See https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/391/display/redirect
Changes:
------------------------------------------ [...truncated 163.87 MiB...] [32m06/18 09:32:35.785[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/4463e2a6-6af8-41f1-9d3b-43a... (../lib/sbi/client.c:744) [32m06/18 09:32:35.785[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/18 09:32:35.785[0m: [[33mudm[0m] [1;37mDEBUG[0m: udm_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/udm/udm-sm.c:61) [32m06/18 09:32:35.785[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) 0000: 00001b01 05000024 cf89f561 97df3dbf .......$...a..=. 0010: 4a05e532 db528200 9c500fdc 6457196d J..2.R...P..dW.m 0020: 4c5a37ff LZ7. MTC@c583244f2497: External command `https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/ttcn3-tcpdump-start.sh C5G_Tests.TC_secondary_rat_data_usage_report' was executed successfully (exit status: 0). MTC@c583244f2497: Test case TC_secondary_rat_data_usage_report started. GTP1U_EM(630)@c583244f2497: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 GTP1U_EM(630)@c583244f2497: setverdict(fail): none -> fail reason: "Could not connect UECUPS socket, check your configuration", new component reason: "Could not connect UECUPS socket, check your configuration" GTP1U_EM(630)@c583244f2497: Dynamic test case error: testcase.stop GTP1U_EM(630)@c583244f2497: setverdict(error): fail -> error GTP1U_EM(630)@c583244f2497: Final verdict of PTC: error TC_secondary_rat_data_usage_report-NGAP0(631)@c583244f2497: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 [32m06/18 09:32:35.839[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2 accepted[127.0.0.202]:50000 in ng-path module (../src/amf/ngap-sctp.c:113) [32m06/18 09:32:35.839[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_ACCEPT (../src/amf/amf-sm.c:83) [32m06/18 09:32:35.839[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2 accepted[127.0.0.202] in master_sm module (../src/amf/amf-sm.c:818) [32m06/18 09:32:35.841[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_initial(): ENTRY (../src/amf/ngap-sm.c:28) [32m06/18 09:32:35.841[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): ENTRY (../src/amf/ngap-sm.c:55) [32m06/18 09:32:35.841[0m: [[33mamf[0m] [1;32mINFO[0m: [Added] Number of gNBs is now 1 (../src/amf/context.c:1277) [32m06/18 09:32:35.841[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_ASSOC_CHANGE:[T:32769, F:0x0, S:0, I/O:64/30] (../src/amf/ngap-sctp.c:152) [32m06/18 09:32:35.841[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_COMM_UP (../src/amf/ngap-sctp.c:161) [32m06/18 09:32:35.841[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_SCTP_COMM_UP (../src/amf/amf-sm.c:83) [32m06/18 09:32:35.841[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] max_num_of_ostreams : 30 (../src/amf/amf-sm.c:865) TC_secondary_rat_data_usage_report-NGAP1(632)@c583244f2497: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 [32m06/18 09:32:35.846[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2 accepted[127.0.0.202]:50001 in ng-path module (../src/amf/ngap-sctp.c:113) [32m06/18 09:32:35.846[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_ACCEPT (../src/amf/amf-sm.c:83) [32m06/18 09:32:35.846[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2 accepted[127.0.0.202] in master_sm module (../src/amf/amf-sm.c:818) [32m06/18 09:32:35.847[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_initial(): ENTRY (../src/amf/ngap-sm.c:28) [32m06/18 09:32:35.847[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): ENTRY (../src/amf/ngap-sm.c:55) [32m06/18 09:32:35.847[0m: [[33mamf[0m] [1;32mINFO[0m: [Added] Number of gNBs is now 2 (../src/amf/context.c:1277) [32m06/18 09:32:35.847[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_ASSOC_CHANGE:[T:32769, F:0x0, S:0, I/O:64/30] (../src/amf/ngap-sctp.c:152) [32m06/18 09:32:35.847[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_COMM_UP (../src/amf/ngap-sctp.c:161) [32m06/18 09:32:35.847[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_SCTP_COMM_UP (../src/amf/amf-sm.c:83) [32m06/18 09:32:35.847[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] max_num_of_ostreams : 30 (../src/amf/amf-sm.c:865) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_MESSAGE (../src/amf/amf-sm.c:83) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): AMF_EVENT_NGAP_MESSAGE (../src/amf/ngap-sm.c:55) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: NGSetupRequest (../src/amf/ngap-handler.c:288) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: IP[127.0.0.202] GNB_ID[0x0] GNB_ID_LENGTH[22] (../src/amf/ngap-handler.c:386) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:391) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: PagingDRX[0] (../src/amf/ngap-handler.c:395) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: TAC[1] (../src/amf/ngap-handler.c:439) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:501) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: S_NSSAI[SST:1 SD:0xffffff] (../src/amf/ngap-handler.c:562) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: TAC[1] (../src/amf/ngap-handler.c:72) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:73) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: SERVED_TAI_INDEX[0] (../src/amf/ngap-handler.c:78) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:100) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: S_NSSAI[SST:1 SD:0xffffff] (../src/amf/ngap-handler.c:105) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: NG-Setup response (../src/amf/ngap-path.c:356) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: NGSetupResponse (../src/amf/ngap-build.c:91) [32m06/18 09:32:35.850[0m: [[33mamf[0m] [1;37mDEBUG[0m: IP[127.0.0.202] RAN_ID[0] (../src/amf/ngap-path.c:64) MTC@c583244f2497: setverdict(pass): none -> pass MTC@c583244f2497: Dynamic test case error: Error message was received from MC: The connect operation refers to test component with component reference 630, which has already terminated. MTC@c583244f2497: setverdict(error): pass -> error TC_secondary_rat_data_usage_report0(633)@c583244f2497: Final verdict of PTC: none [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_SHUTDOWN_EVENT:[T:32773, F:0x0, L:12] (../src/amf/ngap-sctp.c:193) [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_SHUTDOWN_EVENT:[T:32773, F:0x0, L:12] (../src/amf/ngap-sctp.c:193) [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_CONNREFUSED (../src/amf/amf-sm.c:83) [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] connection refused!!! (../src/amf/amf-sm.c:878) [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): EXIT (../src/amf/ngap-sm.c:55) [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_final(): EXIT (../src/amf/ngap-sm.c:37) [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;32mINFO[0m: [Removed] Number of gNBs is now 1 (../src/amf/context.c:1305) [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_CONNREFUSED (../src/amf/amf-sm.c:83) [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] connection refused!!! (../src/amf/amf-sm.c:878) [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): EXIT (../src/amf/ngap-sm.c:55) [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_final(): EXIT (../src/amf/ngap-sm.c:37) [32m06/18 09:32:35.857[0m: [[33mamf[0m] [1;32mINFO[0m: [Removed] Number of gNBs is now 0 (../src/amf/context.c:1305) TC_secondary_rat_data_usage_report-NGAP1(632)@c583244f2497: Final verdict of PTC: none TC_secondary_rat_data_usage_report-NGAP0(631)@c583244f2497: Final verdict of PTC: none MTC@c583244f2497: Setting final verdict of the test case. MTC@c583244f2497: Local verdict of MTC: error MTC@c583244f2497: Local verdict of PTC GTP1U_EM(630): error (error -> error) MTC@c583244f2497: Local verdict of PTC TC_secondary_rat_data_usage_report-NGAP0(631): none (error -> error) MTC@c583244f2497: Local verdict of PTC TC_secondary_rat_data_usage_report-NGAP1(632): none (error -> error) MTC@c583244f2497: Local verdict of PTC TC_secondary_rat_data_usage_report0(633): none (error -> error) MTC@c583244f2497: Test case TC_secondary_rat_data_usage_report finished. Verdict: error MTC@c583244f2497: Starting external command `https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/ttcn3-tcpdump-stop.sh C5G_Tests.TC_secondary_rat_data_usage_report error'. (09:32:35) load average: 11.25, 12.05, 9.09 [1;31m------ C5G_Tests.TC_secondary_rat_data_usage_report error ------[0m
Waiting for packet dumper to finish... 0 (prev_count=-1, count=2356) [32m06/18 09:32:36.062[0m: [[33mudr[0m] [1;37mDEBUG[0m: udr_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/udr/udr-sm.c:53) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/448e27d2-6af8-41f1-96e6-5b1... (../lib/sbi/client.c:797) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [55] (../lib/sbi/nghttp2-server.c:1737) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/448e27d2-6af8-41f1-96e6-5b1239dd77cf (../lib/sbi/nghttp2-server.c:1308) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/448e27d2-6af8-41f1-96e6-5b12... (../lib/sbi/client.c:797) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [545] (../lib/sbi/nghttp2-server.c:1737) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/448e27d2-6af8-41f1-96e6-5b1239dd77cf (../lib/sbi/nghttp2-server.c:1308) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m06/18 09:32:36.062[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/18 09:32:36.062[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [545] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001b01 05000002 2189f261 97df3dbf ........!..a..=. 0010: 4a05e532 db528200 9c500fdc 64571971 J..2.R...P..dW.q 0020: 4c5a37ff LZ7. [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/448e27d2-6af8-41f1-96e6-5b12... (../lib/sbi/client.c:744) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [55] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001b01 05000000 3789d061 97df3dbf ........7..a..=. 0010: 4a05e532 db528200 9c500fdc 64571971 J..2.R...P..dW.q 0020: 4c5a37ff LZ7. [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/448e27d2-6af8-41f1-96e6-5b1... (../lib/sbi/client.c:744) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/18 09:32:36.062[0m: [[33mudr[0m] [1;37mDEBUG[0m: udr_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/udr/udr-sm.c:53) [32m06/18 09:32:36.062[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) [32m06/18 09:32:36.310[0m: [[33mpcf[0m] [1;37mDEBUG[0m: pcf_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/pcf/pcf-sm.c:64) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/44b426a8-6af8-41f1-97a6-e9e... (../lib/sbi/client.c:797) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/client.c:548) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [3699] (../lib/sbi/nghttp2-server.c:1737) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/44b426a8-6af8-41f1-97a6-e9e183cbfd89 (../lib/sbi/nghttp2-server.c:1308) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1312) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/nghttp2-server.c:1314) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/44b426a8-6af8-41f1-97a6-e9e1... (../lib/sbi/client.c:797) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/client.c:548) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [547] (../lib/sbi/nghttp2-server.c:1737) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/44b426a8-6af8-41f1-97a6-e9e183cbfd89 (../lib/sbi/nghttp2-server.c:1308) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1312) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/nghttp2-server.c:1314) [32m06/18 09:32:36.310[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/18 09:32:36.310[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [547] (../lib/sbi/nghttp2-server.c:1419) 0000: 00000301 05000002 2389f3be ........#... [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/44b426a8-6af8-41f1-97a6-e9e1... (../lib/sbi/client.c:744) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [3699] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001b01 0500000e 7389ed61 97df3dbf ........s..a..=. 0010: 4a05e532 db528200 9c500fdc 64571971 J..2.R...P..dW.q 0020: 4c5a37ff LZ7. [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/44b426a8-6af8-41f1-97a6-e9e... (../lib/sbi/client.c:744) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/18 09:32:36.310[0m: [[33mpcf[0m] [1;37mDEBUG[0m: pcf_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/pcf/pcf-sm.c:64) [32m06/18 09:32:36.310[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) [32m06/18 09:32:36.515[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/amf/amf-sm.c:83) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/44dafce2-6af8-41f1-8ec2-f33... (../lib/sbi/client.c:797) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [15167] (../lib/sbi/nghttp2-server.c:1737) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/44dafce2-6af8-41f1-8ec2-f33279fef221 (../lib/sbi/nghttp2-server.c:1308) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/44dafce2-6af8-41f1-8ec2-f332... (../lib/sbi/client.c:797) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [549] (../lib/sbi/nghttp2-server.c:1737) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/44dafce2-6af8-41f1-8ec2-f33279fef221 (../lib/sbi/nghttp2-server.c:1308) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m06/18 09:32:36.515[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/18 09:32:36.515[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [549] (../lib/sbi/nghttp2-server.c:1419) 0000: 00000301 05000002 2589f3be ........%... [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/44dafce2-6af8-41f1-8ec2-f332... (../lib/sbi/client.c:744) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/18 09:32:36.515[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [15167] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001b01 0500003b 3f89da61 97df3dbf .......;?..a..=. 0010: 4a05e532 db528200 9c500fdc 64571971 J..2.R...P..dW.q 0020: 4c5a37ff LZ7. [32m06/18 09:32:36.516[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/44dafce2-6af8-41f1-8ec2-f33... (../lib/sbi/client.c:744) [32m06/18 09:32:36.516[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/18 09:32:36.516[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/amf/amf-sm.c:83) [32m06/18 09:32:36.516[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) Waiting for packet dumper to finish... 1 (prev_count=2356, count=11176) MTC@c583244f2497: External command `https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/ttcn3-tcpdump-stop.sh C5G_Tests.TC_secondary_rat_data_usage_report error' was executed successfully (exit status: 0). MC@c583244f2497: Test execution finished. Execution of [EXECUTE] section finished. emtc MC@c583244f2497: Terminating MTC. MC@c583244f2497: MTC terminated. MC2> exit MC@c583244f2497: Shutting down session. MC@c583244f2497: Shutdown complete.
Comparing expected results 'https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/5gc/expected-results.xml' against results in 'junit-xml-6650.log' -------------------- [1;32mpass[0;m C5G_Tests.TC_ng_setup_unknown_global_gnb_id_plmn [1;32mpass[0;m C5G_Tests.TC_ng_setup_wrong_tac [1;32mpass[0;m C5G_Tests.TC_ng_setup [1;32mpass[0;m C5G_Tests.TC_ng_register [1;32mpass[0;m C5G_Tests.TC_periodic_registration_updating [1;32mpass[0;m C5G_Tests.TC_ue_context_release_no_pdu_session [1;32mpass[0;m C5G_Tests.TC_ue_context_release_with_pdu_session [1;32mpass[0;m C5G_Tests.TC_pdu_sess_modification [1;33mxfail[0;m C5G_Tests.TC_pdu_sess_est_always_on [1;32mpass[0;m C5G_Tests.TC_pdu_sess_est_pco_pcscf [1;32mpass[0;m C5G_Tests.TC_ng_register_ping4 [1;32mpass[0;m C5G_Tests.TC_ng_register_ping4_256 [1;32mpass[0;m C5G_Tests.TC_ng_register_ping6 [1;31mpass->FAIL[0;m C5G_Tests.TC_ng_register_ping6_256 [1;31mpass->FAIL[0;m C5G_Tests.TC_ng_register_ping46 [1;31mpass->FAIL[0;m C5G_Tests.TC_ng_register_ping46_256 [1;31mpass->FAIL[0;m C5G_Tests.TC_ue_service_request_cm_idle_ul_data [1;31mpass->FAIL[0;m C5G_Tests.TC_ue_service_request_cm_idle_inact_sess [1;31mpass->FAIL[0;m C5G_Tests.TC_ue_service_request_cm_idle_unknown_sess_active [1;31mpass->FAIL[0;m C5G_Tests.TC_ue_service_request_cm_connected [1;31mpass->FAIL[0;m C5G_Tests.TC_net_triggered_service_req [1;33mxfail[0;m C5G_Tests.TC_connection_inactive [1;33mxfail[0;m C5G_Tests.TC_connection_suspend [1;33mxfail[0;m C5G_Tests.TC_normal_reg_emergency_services [1;33mxfail[0;m C5G_Tests.TC_normal_reg_emergency_services_fallback [1;33mxfail[0;m C5G_Tests.TC_emergency_registration [1;31mpass->FAIL[0;m C5G_Tests.TC_handover_inter_ngran_xn [1;31mpass->FAIL[0;m C5G_Tests.TC_handover_inter_ngran_n2 [1;31mpass->FAIL[0;m C5G_Tests.TC_handover_inter_ngran_n2_cancel [1;33mxfail[0;m C5G_Tests.TC_ran_initiated_qos_flow_mobility [1;31mpass->FAIL[0;m C5G_Tests.TC_secondary_rat_data_usage_report
Summary: [1;31mpass->FAIL[0;m: 12 [1;33mxfail[0;m: 7 [1;32mpass[0;m: 12
{"t":{"$date":"2026-06-18T09:32:38.127+00:00"},"s":"I", "c":"STORAGE", "id":22430, "ctx":"Checkpointer","msg":"WiredTiger message","attr":{"message":"[1781775158:127361][857:0x7f75976256c0], WT_SESSION.checkpoint: [WT_VERB_CHECKPOINT_PROGRESS] saving checkpoint snapshot min: 2368, snapshot max: 2368 snapshot count: 0, oldest timestamp: (0, 0) , meta checkpoint timestamp: (0, 0) base write gen: 1"}} [1;34m[testenv] Stopping podman container[0m [0;94m[testenv] + ['podman', 'kill', 'testenv-5gc-osmocom-nightly-20260618-0929-1cbf248c-1'][0m testenv-5gc-osmocom-nightly-20260618-0929-1cbf248c-1 [0;94m[testenv] Skipping clean up scripts, podman container has already stopped[0m [1;34m[testenv] Stopping testsuite (4008996)[0m [0;94m[testenv] feed_watchdog_loop: podman container has stopped[0m [1;34m[testenv] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/391/artifact/logs... [0m + RC=1 + [ 1 = 0 ] + uptime + grep --color=always -o load.* [01;31m[Kload average: 11.23, 12.04, 9.10[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.