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.
See https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/392/display/redirect?page=changes
Changes:
[Andreas Eversberg] CCID: Check if reader accepts highest P3 value 0xff
[Andreas Eversberg] CCID: Check if reader handles special P3 value 0x00 correctly
[Andreas Eversberg] CCID: Check if reader restarts WWT upon NULL procedure byte
[Andreas Eversberg] SIMTRACE: Increase USB receive buffer size
[Andreas Eversberg] CCID: Check if reader sends request TPDU with maximum size
[Andreas Eversberg] CCID: Check response of reader with empty SIM carrier
[Andreas Eversberg] CCID: Add testenv.cfg to run tests using testenv
[Andreas Eversberg] CCID: Check if reader times out while expecting status words
------------------------------------------ [...truncated 266.59 MiB...] [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;32mpass[0;m C5G_Tests.TC_ng_register_ping6_256 [1;32mpass[0;m C5G_Tests.TC_ng_register_ping46 [1;31mpass->FAIL[0;m C5G_Tests.TC_ng_register_ping46_256 [1;32mpass[0;m C5G_Tests.TC_ue_service_request_cm_idle_ul_data [1;32mpass[0;m C5G_Tests.TC_ue_service_request_cm_idle_inact_sess [1;32mpass[0;m C5G_Tests.TC_ue_service_request_cm_idle_unknown_sess_active [1;32mpass[0;m C5G_Tests.TC_ue_service_request_cm_connected [1;32mpass[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: 5 [1;33mxfail[0;m: 7 [1;32mpass[0;m: 19
[32m06/19 09:35:13.882[0m: [[33msmf[0m] [1;37mDEBUG[0m: smf_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/smf/smf-sm.c:94) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/7991d7c0-6bc1-41f1-8db3-59c... (../lib/sbi/client.c:797) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":2}] (../lib/sbi/client.c:548) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [13445] (../lib/sbi/nghttp2-server.c:1737) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/7991d7c0-6bc1-41f1-8db3-59cbb5d901a7 (../lib/sbi/nghttp2-server.c:1308) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":2}] (../lib/sbi/nghttp2-server.c:1314) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/7991d7c0-6bc1-41f1-8db3-59cb... (../lib/sbi/client.c:797) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":2}] (../lib/sbi/client.c:548) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [813] (../lib/sbi/nghttp2-server.c:1737) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/7991d7c0-6bc1-41f1-8db3-59cbb5d901a7 (../lib/sbi/nghttp2-server.c:1308) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":2}] (../lib/sbi/nghttp2-server.c:1314) [32m06/19 09:35:13.882[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/19 09:35:13.882[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [813] (../lib/sbi/nghttp2-server.c:1419) 0000: 00000301 05000003 2d89cfbe ........-... [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/7991d7c0-6bc1-41f1-8db3-59cb... (../lib/sbi/client.c:744) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [13445] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001a01 05000034 8589de61 96c361be .......4...a..a. 0010: 940bea65 b6a50401 38a01fb8 cb7702ca ...e....8....w.. 0020: 98b46f ..o [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/7991d7c0-6bc1-41f1-8db3-59c... (../lib/sbi/client.c:744) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/19 09:35:13.882[0m: [[33msmf[0m] [1;37mDEBUG[0m: smf_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/smf/smf-sm.c:94) [32m06/19 09:35:13.882[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) [1;34m[testenv] Running gdb to get a backtrace[0m [0;94m[testenv] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_cache', '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/5gc:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-5gc-osmocom-nightly-20260619-0929-56f6e4f8-1', 'sh', '-c', 'echo; gdb --batch /usr/bin/open5gs-amfd https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/392/artifact/logs/amf/core -ex bt | tee https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/392/artifact/logs/amf/core.backtrace; echo'][0m
[32m06/19 09:35:14.418[0m: [[33mausf[0m] [1;37mDEBUG[0m: ausf_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/ausf/ausf-sm.c:56) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/79ded82c-6bc1-41f1-b51f-c96... (../lib/sbi/client.c:797) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":16}] (../lib/sbi/client.c:548) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [4975] (../lib/sbi/nghttp2-server.c:1737) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/79ded82c-6bc1-41f1-b51f-c966e9f82a70 (../lib/sbi/nghttp2-server.c:1308) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1312) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":16}] (../lib/sbi/nghttp2-server.c:1314) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/79ded82c-6bc1-41f1-b51f-c966... (../lib/sbi/client.c:797) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":16}] (../lib/sbi/client.c:548) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [815] (../lib/sbi/nghttp2-server.c:1737) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/79ded82c-6bc1-41f1-b51f-c966e9f82a70 (../lib/sbi/nghttp2-server.c:1308) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1312) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":16}] (../lib/sbi/nghttp2-server.c:1314) [32m06/19 09:35:14.418[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/19 09:35:14.418[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [815] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001a01 05000003 2f89cf61 96c361be ......../..a..a. 0010: 940bea65 b6a50401 38a01fb8 cb7702d2 ...e....8....w.. 0020: 98b46f ..o [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/79ded82c-6bc1-41f1-b51f-c966... (../lib/sbi/client.c:744) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [4975] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001a01 05000013 6f89ef61 96c361be ........o..a..a. 0010: 940bea65 b6a50401 38a01fb8 cb7702d2 ...e....8....w.. 0020: 98b46f ..o [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/79ded82c-6bc1-41f1-b51f-c96... (../lib/sbi/client.c:744) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/19 09:35:14.418[0m: [[33mausf[0m] [1;37mDEBUG[0m: ausf_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/ausf/ausf-sm.c:56) [32m06/19 09:35:14.418[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) [New LWP 6639] [New LWP 6637] [32m06/19 09:35:14.562[0m: [[33mudm[0m] [1;37mDEBUG[0m: udm_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/udm/udm-sm.c:61) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/79f70e2e-6bc1-41f1-b687-edb... (../lib/sbi/client.c:797) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/client.c:548) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [15413] (../lib/sbi/nghttp2-server.c:1737) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/79f70e2e-6bc1-41f1-b687-edbd6c3485e6 (../lib/sbi/nghttp2-server.c:1308) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1312) [32m06/19 09:35:14.562[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/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/79f70e2e-6bc1-41f1-b687-edbd... (../lib/sbi/client.c:797) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/client.c:548) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [817] (../lib/sbi/nghttp2-server.c:1737) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/79f70e2e-6bc1-41f1-b687-edbd6c3485e6 (../lib/sbi/nghttp2-server.c:1308) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1312) [32m06/19 09:35:14.562[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/19 09:35:14.562[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/19 09:35:14.562[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [817] (../lib/sbi/nghttp2-server.c:1419) 0000: 00000301 05000003 3189d0be ........1... [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/79f70e2e-6bc1-41f1-b687-edbd... (../lib/sbi/client.c:744) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [15413] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001a01 0500003c 3589f261 96c361be .......<5..a..a. 0010: 940bea65 b6a50401 38a01fb8 cb7702d2 ...e....8....w.. 0020: 98b46f ..o [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/79f70e2e-6bc1-41f1-b687-edb... (../lib/sbi/client.c:744) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/19 09:35:14.562[0m: [[33mudm[0m] [1;37mDEBUG[0m: udm_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/udm/udm-sm.c:61) [32m06/19 09:35:14.562[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) [32m06/19 09:35:14.678[0m: [[33mudr[0m] [1;37mDEBUG[0m: udr_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/udr/udr-sm.c:53) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/7a0757a2-6bc1-41f1-bdb6-41e... (../lib/sbi/client.c:797) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [83] (../lib/sbi/nghttp2-server.c:1737) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/7a0757a2-6bc1-41f1-bdb6-41e062a817fe (../lib/sbi/nghttp2-server.c:1308) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/19 09:35:14.678[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/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/7a0757a2-6bc1-41f1-bdb6-41e0... (../lib/sbi/client.c:797) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [819] (../lib/sbi/nghttp2-server.c:1737) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/7a0757a2-6bc1-41f1-bdb6-41e062a817fe (../lib/sbi/nghttp2-server.c:1308) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/19 09:35:14.678[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/19 09:35:14.678[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/19 09:35:14.678[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/19 09:35:14.678[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [819] (../lib/sbi/nghttp2-server.c:1419) 0000: 00000301 05000003 3389d0be ........3... [32m06/19 09:35:14.679[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/7a0757a2-6bc1-41f1-bdb6-41e0... (../lib/sbi/client.c:744) [32m06/19 09:35:14.679[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/19 09:35:14.679[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/19 09:35:14.679[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [83] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001a01 05000000 5389de61 96c361be ........S..a..a. 0010: 940bea65 b6a50401 38a01fb8 cb7702d2 ...e....8....w.. 0020: 98b46f ..o [32m06/19 09:35:14.679[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/7a0757a2-6bc1-41f1-bdb6-41e... (../lib/sbi/client.c:744) [32m06/19 09:35:14.679[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/19 09:35:14.679[0m: [[33mudr[0m] [1;37mDEBUG[0m: udr_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/udr/udr-sm.c:53) [32m06/19 09:35:14.679[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) [32m06/19 09:35:14.842[0m: [[33mpcf[0m] [1;37mDEBUG[0m: pcf_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/pcf/pcf-sm.c:64) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/7a20ac3e-6bc1-41f1-97c3-2fd... (../lib/sbi/client.c:797) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":10}] (../lib/sbi/client.c:548) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [6141] (../lib/sbi/nghttp2-server.c:1737) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/7a20ac3e-6bc1-41f1-97c3-2fd4ec53ee3d (../lib/sbi/nghttp2-server.c:1308) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1312) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":10}] (../lib/sbi/nghttp2-server.c:1314) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/7a20ac3e-6bc1-41f1-97c3-2fd4... (../lib/sbi/client.c:797) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":10}] (../lib/sbi/client.c:548) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [821] (../lib/sbi/nghttp2-server.c:1737) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/7a20ac3e-6bc1-41f1-97c3-2fd4ec53ee3d (../lib/sbi/nghttp2-server.c:1308) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1312) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":10}] (../lib/sbi/nghttp2-server.c:1314) [32m06/19 09:35:14.842[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/19 09:35:14.842[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [821] (../lib/sbi/nghttp2-server.c:1419) 0000: 00000301 05000003 3589d0be ........5... [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/7a20ac3e-6bc1-41f1-97c3-2fd4... (../lib/sbi/client.c:744) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [6141] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001a01 05000017 fd89e161 96c361be ...........a..a. 0010: 940bea65 b6a50401 38a01fb8 cb7702d2 ...e....8....w.. 0020: 98b46f ..o [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/7a20ac3e-6bc1-41f1-97c3-2fd... (../lib/sbi/client.c:744) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/19 09:35:14.842[0m: [[33mpcf[0m] [1;37mDEBUG[0m: pcf_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/pcf/pcf-sm.c:64) [32m06/19 09:35:14.842[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) [Thread debugging using libthread_db enabled] Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1". Core was generated by `/usr/bin/open5gs-amfd -c open5gs-amf.yaml'. Program terminated with signal SIGSEGV, Segmentation fault. #0 0x00007f0b83c016bd in NativeInteger_encode_aper (td=0x7f0b8398dba0 <asn_DEF_NGAP_ProtocolIE_ID>, constraints=0x7f0b839d5c20 <asn_PER_memb_NGAP_id_constr_454>, sptr=0x77, warning: 57 ../lib/asn1c/common/NativeInteger_aper.c: No such file or directory po=0x7f0b1e371d00) at ../lib/asn1c/common/NativeInteger_aper.c:57 [Current thread is 1 (Thread 0x7f0b1e3736c0 (LWP 6639))] #0 0x00007f0b83c016bd in NativeInteger_encode_aper (td=0x7f0b8398dba0 <asn_DEF_NGAP_ProtocolIE_ID>, constraints=0x7f0b839d5c20 <asn_PER_memb_NGAP_id_constr_454>, sptr=0x77, po=0x7f0b1e371d00) at ../lib/asn1c/common/NativeInteger_aper.c:57 #1 0x00007f0b83c03f20 in SEQUENCE_encode_aper (td=0x7f0b839b5460 <asn_DEF_NGAP_PathSwitchRequestAcknowledgeIEs>, constraints=<optimized out>, sptr=0x77, po=0x7f0b1e371d00) at ../lib/asn1c/common/constr_SEQUENCE_aper.c:452 #2 0x00007f0b83c03148 in SEQUENCE_OF_encode_aper (td=0x7f0b83994000 <asn_DEF_NGAP_ProtocolIE_Container_14662P36>, constraints=<optimized out>, sptr=0x7f0b180663a0, po=0x7f0b1e371d00) at ../lib/asn1c/common/constr_SEQUENCE_OF_aper.c:92 #3 0x00007f0b83c03f20 in SEQUENCE_encode_aper (td=0x7f0b83924d60 <asn_DEF_NGAP_PathSwitchRequestAcknowledge>, constraints=<optimized out>, sptr=0x7f0b18046c40, po=0x7f0b1e371d00) at ../lib/asn1c/common/constr_SEQUENCE_aper.c:452 #4 0x00007f0b83bfed7f in aper_encode (td=0x7f0b83924d60 <asn_DEF_NGAP_PathSwitchRequestAcknowledge>, constraints=<optimized out>, sptr=0x7f0b18046c40, cb=<optimized out>, app_key=app_key@entry=0x7f0b1e371db0) at ../lib/asn1c/common/aper_encoder.c:115 #5 0x00007f0b83bfef19 in aper_encode_to_new_buffer (td=<optimized out>, constraints=<optimized out>, sptr=<optimized out>, buffer_r=buffer_r@entry=0x7f0b1e371df0) at ../lib/asn1c/common/aper_encoder.c:48 #6 0x00007f0b83bff8bd in aper_open_type_put (td=<optimized out>, constraints=<optimized out>, sptr=<optimized out>, po=po@entry=0x7f0b1e372010) at ../lib/asn1c/common/aper_opentype.c:99 #7 0x00007f0b83c026e1 in OPEN_TYPE_encode_aper (td=0x7f0b83921260 <asn_DEF_NGAP_value_4>, constraints=<optimized out>, sptr=0x7f0b183d17f0, po=0x7f0b1e372010) at ../lib/asn1c/common/OPEN_TYPE_aper.c:270 #8 0x00007f0b83c027ab in OPEN_TYPE_aper_put (td=td@entry=0x7f0b839210c0 <asn_DEF_NGAP_SuccessfulOutcome>, sptr=sptr@entry=0x7f0b183d17e0, elm=0x7f0b83921200 <asn_MBR_NGAP_SuccessfulOutcome_1+160>, po=po@entry=0x7f0b1e372010) at ../lib/asn1c/common/OPEN_TYPE_aper.c:336 #9 0x00007f0b83c03fe3 in SEQUENCE_encode_aper (td=0x7f0b839210c0 <asn_DEF_NGAP_SuccessfulOutcome>, constraints=<optimized out>, sptr=0x7f0b183d17e0, po=0x7f0b1e372010) at ../lib/asn1c/common/constr_SEQUENCE_aper.c:450 #10 0x00007f0b83c02f35 in CHOICE_encode_aper (td=0x7f0b8391f020 <asn_DEF_NGAP_NGAP_PDU>, constraints=<optimized out>, sptr=0x7f0b1e372150, po=0x7f0b1e372010) at ../lib/asn1c/common/constr_CHOICE_aper.c:195 #11 0x00007f0b83bfed7f in aper_encode (td=td@entry=0x7f0b8391f020 <asn_DEF_NGAP_NGAP_PDU>, constraints=constraints@entry=0x0, sptr=sptr@entry=0x7f0b1e372150, cb=cb@entry=0x7f0b83bfecb0 <encode_to_buffer_cb>, app_key=app_key@entry=0x7f0b1e3720a0) at ../lib/asn1c/common/aper_encoder.c:115 #12 0x00007f0b83bfeeb2 in aper_encode_to_buffer (td=td@entry=0x7f0b8391f020 <asn_DEF_NGAP_NGAP_PDU>, constraints=constraints@entry=0x0, sptr=sptr@entry=0x7f0b1e372150, buffer=<optimized out>, buffer_size=buffer_size@entry=32768) at ../lib/asn1c/common/aper_encoder.c:36 #13 0x00007f0b83bee807 in ogs_asn_encode (td=td@entry=0x7f0b8391f020 <asn_DEF_NGAP_NGAP_PDU>, sptr=sptr@entry=0x7f0b1e372150) at ../lib/asn1c/util/message.c:95 #14 0x00007f0b83c14ba7 in ogs_ngap_encode (message=message@entry=0x7f0b1e372150) at ../lib/ngap/message.c:33 #15 0x0000557f79892769 in ngap_build_path_switch_ack (amf_ue=amf_ue@entry=0x7f0b1eef1100) at ../src/amf/ngap-build.c:2514 #16 0x0000557f7985cf81 in ngap_send_path_switch_ack (sess=sess@entry=0x7f0b1e534780) at ../src/amf/ngap-path.c:611 #17 0x0000557f7987c48c in amf_nsmf_pdusession_handle_update_sm_context (amf_ue=amf_ue@entry=0x7f0b1eef1100, ran_ue=ran_ue@entry=0x557fa07b3550, sess=sess@entry=0x7f0b1e534780, state=state@entry=20, recvmsg=recvmsg@entry=0x7f0b1e372270) at ../src/amf/nsmf-handler.c:485 #18 0x0000557f798728aa in amf_state_operational (s=<optimized out>, e=<optimized out>) at ../src/amf/amf-sm.c:608 #19 0x00007f0b83c3ee24 in ogs_fsm_dispatch (fsm=0x7f0b1e372c20, event=0x7f0b183a2b10) at ../lib/core/ogs-fsm.c:127 #20 0x0000557f79848e49 in amf_main (data=<optimized out>) at ../src/amf/init.c:163 #21 0x00007f0b83c34005 in thread_worker (arg=0x557fa07dc8f0) at ../lib/core/ogs-thread.c:67 #22 0x00007f0b82a9eb7b in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:448 #23 0x00007f0b82b1c7f8 in __GI___clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78
[1;34m[testenv] Stopping podman container[0m [0;94m[testenv] + ['podman', 'kill', 'testenv-5gc-osmocom-nightly-20260619-0929-56f6e4f8-1'][0m testenv-5gc-osmocom-nightly-20260619-0929-56f6e4f8-1 https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/392/artifact/logs/amf/core: ELF 64-bit LSB core file, x86-64, version 1 (SYSV), SVR4-style, from 'open5gs-amfd -c open5gs-amf.yaml', real uid: 0, effective uid: 0, real gid: 0, effective gid: 0, execfn: '/usr/bin/open5gs-amfd', platform: 'x86_64' [0;94m[testenv] Skipping clean up scripts, podman container has already stopped[0m [1;34m[testenv] Stopping testsuite (3081889)[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/392/artifact/logs... [0m + RC=1 + [ 1 = 0 ] + uptime + grep --color=always -o load.* [01;31m[Kload average: 8.96, 13.88, 11.00[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.
See https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/393/display/redirect
Changes:
------------------------------------------ [...truncated 271.02 MiB...] [32m06/20 09:34:48.258[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/20 09:34:48.259[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/9aa723f6-6c8a-41f1-8f4d-1136... (../lib/sbi/client.c:797) [32m06/20 09:34:48.259[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m06/20 09:34:48.259[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/client.c:548) [32m06/20 09:34:48.259[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [799] (../lib/sbi/nghttp2-server.c:1737) [32m06/20 09:34:48.259[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/9aa723f6-6c8a-41f1-8f4d-1136b52de78b (../lib/sbi/nghttp2-server.c:1308) [32m06/20 09:34:48.259[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1312) [32m06/20 09:34:48.259[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/20 09:34:48.259[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/20 09:34:48.259[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/20 09:34:48.259[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/20 09:34:48.259[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [799] (../lib/sbi/nghttp2-server.c:1419) 0000: 00000301 05000003 1f89dbbe ............ [32m06/20 09:34:48.260[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/9aa723f6-6c8a-41f1-8f4d-1136... (../lib/sbi/client.c:744) [32m06/20 09:34:48.260[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/20 09:34:48.260[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/20 09:34:48.260[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [15721] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001a01 0500003d 6989e761 96dc34fd .......=i..a..4. 0010: 28202996 da941004 e2807ee3 2d5c69e5 ( ).......~.-\i. 0020: 3168df 1h. [32m06/20 09:34:48.260[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/9aa723f6-6c8a-41f1-8f4d-113... (../lib/sbi/client.c:744) [32m06/20 09:34:48.260[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/20 09:34:48.260[0m: [[33mudm[0m] [1;37mDEBUG[0m: udm_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/udm/udm-sm.c:61) [32m06/20 09:34:48.261[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) MTC@737675d98ef9: External command `https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/ttcn3-tcpdump-start.sh C5G_Tests.TC_ran_initiated_qos_flow_mobility' was executed successfully (exit status: 0). MTC@737675d98ef9: Test case TC_ran_initiated_qos_flow_mobility started. GTP1U_EM(878)@737675d98ef9: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 [38;5;23m20260620093448291 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m SRV(,127.0.0.20:4268) accept()ed new link from 127.0.0.1:9999 (stream_srv.c:145)[0;m 20260620093448291 [1;32mDUECUPS[0;m [1;32mINFO[0;m r=127.0.0.1:9999<->l=127.0.0.20:4268: Accepted new UECUPS connection (cups_client.c:822) TC_ran_initiated_qos_flow_mobility-NGAP0(879)@737675d98ef9: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 TC_ran_initiated_qos_flow_mobility-NGAP0(879)@737675d98ef9: setverdict(fail): none -> fail reason: "Could not connect NGAP socket, check your configuration", new component reason: "Could not connect NGAP socket, check your configuration" MC@737675d98ef9: Test Component 879 has requested to stop MTC. Terminating current testcase execution. TC_ran_initiated_qos_flow_mobility-NGAP0(879)@737675d98ef9: Final verdict of PTC: fail reason: "Could not connect NGAP socket, check your configuration" [38;5;23m20260620093448307 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m r=127.0.0.1:9999<->l=127.0.0.20:4268 NOTIFICATION SHUTDOWN_EVENT flags=0x0 (stream.c:360)[0;m 20260620093448307 [1;33mDUECUPS[0;m [1;33mNOTICE[0;m r=127.0.0.1:9999<->l=127.0.0.20:4268: UECUPS connection lost (cups_client.c:748) GTP1U_EM(878)@737675d98ef9: Final verdict of PTC: none MTC@737675d98ef9: Setting final verdict of the test case. MTC@737675d98ef9: Local verdict of MTC: none MTC@737675d98ef9: Local verdict of PTC GTP1U_EM(878): none (none -> none) MTC@737675d98ef9: Local verdict of PTC TC_ran_initiated_qos_flow_mobility-NGAP0(879): fail (none -> fail) reason: "Could not connect NGAP socket, check your configuration" MTC@737675d98ef9: Test case TC_ran_initiated_qos_flow_mobility finished. Verdict: fail reason: Could not connect NGAP socket, check your configuration MTC@737675d98ef9: Starting external command `https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/ttcn3-tcpdump-stop.sh C5G_Tests.TC_ran_initiated_qos_flow_mobility fail'. (09:34:48) load average: 1.85, 2.34, 1.65 [1;31m------ C5G_Tests.TC_ran_initiated_qos_flow_mobility fail ------[0m
Waiting for packet dumper to finish... 0 (prev_count=-1, count=3420) [32m06/20 09:34:48.502[0m: [[33mudr[0m] [1;37mDEBUG[0m: udr_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/udr/udr-sm.c:53) [32m06/20 09:34:48.502[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/20 09:34:48.502[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/9acc8600-6c8a-41f1-b9dc-31f... (../lib/sbi/client.c:797) [32m06/20 09:34:48.503[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/20 09:34:48.503[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/20 09:34:48.503[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [81] (../lib/sbi/nghttp2-server.c:1737) [32m06/20 09:34:48.503[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/9acc8600-6c8a-41f1-b9dc-31f4e918b0ed (../lib/sbi/nghttp2-server.c:1308) [32m06/20 09:34:48.503[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/20 09:34:48.503[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/20 09:34:48.503[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/9acc8600-6c8a-41f1-b9dc-31f4... (../lib/sbi/client.c:797) [32m06/20 09:34:48.503[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/20 09:34:48.503[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/20 09:34:48.504[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [801] (../lib/sbi/nghttp2-server.c:1737) [32m06/20 09:34:48.504[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/9acc8600-6c8a-41f1-b9dc-31f4e918b0ed (../lib/sbi/nghttp2-server.c:1308) [32m06/20 09:34:48.504[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/20 09:34:48.504[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/20 09:34:48.504[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/20 09:34:48.504[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/20 09:34:48.504[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/20 09:34:48.504[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [801] (../lib/sbi/nghttp2-server.c:1419) 0000: 00000301 05000003 2189dbbe ........!... [32m06/20 09:34:48.504[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/9acc8600-6c8a-41f1-b9dc-31f4... (../lib/sbi/client.c:744) [32m06/20 09:34:48.504[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/20 09:34:48.504[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/20 09:34:48.504[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [81] (../lib/sbi/nghttp2-server.c:1419) 0000: 00001a01 05000000 5189dd61 96dc34fd ........Q..a..4. 0010: 28202996 da941004 e2807ee3 2d5c69e5 ( ).......~.-\i. 0020: 3168df 1h. [32m06/20 09:34:48.505[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/9acc8600-6c8a-41f1-b9dc-31f... (../lib/sbi/client.c:744) [32m06/20 09:34:48.505[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/20 09:34:48.505[0m: [[33mudr[0m] [1;37mDEBUG[0m: udr_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/udr/udr-sm.c:53) [32m06/20 09:34:48.505[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:358) [32m06/20 09:34:48.704[0m: [[33mpcf[0m] [1;37mDEBUG[0m: pcf_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/pcf/pcf-sm.c:64) [32m06/20 09:34:48.704[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:358) [32m06/20 09:34:48.704[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/9aec1e48-6c8a-41f1-8f82-6d8... (../lib/sbi/client.c:797) [32m06/20 09:34:48.704[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/20 09:34:48.704[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/20 09:34:48.705[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [6355] (../lib/sbi/nghttp2-server.c:1737) [32m06/20 09:34:48.705[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/9aec1e48-6c8a-41f1-8f82-6d8735689303 (../lib/sbi/nghttp2-server.c:1308) [32m06/20 09:34:48.705[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/20 09:34:48.705[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/20 09:34:48.705[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/9aec1e48-6c8a-41f1-8f82-6d87... (../lib/sbi/client.c:797) [32m06/20 09:34:48.705[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m06/20 09:34:48.705[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m06/20 09:34:48.706[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [803] (../lib/sbi/nghttp2-server.c:1737) [32m06/20 09:34:48.706[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/9aec1e48-6c8a-41f1-8f82-6d8735689303 (../lib/sbi/nghttp2-server.c:1308) [32m06/20 09:34:48.706[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m06/20 09:34:48.706[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/20 09:34:48.706[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m06/20 09:34:48.706[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/9aec1e48-6c8a-41f1-8f82-6d87... (../lib/sbi/client.c:744) [32m06/20 09:34:48.706[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/20 09:34:48.706[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/20 09:34:48.706[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [6355] (../lib/sbi/nghttp2-server.c:1419) [32m06/20 09:34:48.706[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m06/20 09:34:48.706[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m06/20 09:34:48.706[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [803] (../lib/sbi/nghttp2-server.c:1419) 0000: 00000301 05000003 2389dbbe ........#... 0000: 00001a01 05000018 d389d961 96dc34fd ...........a..4. 0010: 28202996 da941004 e2807ee3 2d5c69e5 ( ).......~.-\i. 0020: 3168df 1h. [32m06/20 09:34:48.706[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/9aec1e48-6c8a-41f1-8f82-6d8... (../lib/sbi/client.c:744) [32m06/20 09:34:48.706[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m06/20 09:34:48.707[0m: [[33mpcf[0m] [1;37mDEBUG[0m: pcf_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/pcf/pcf-sm.c:64) [32m06/20 09:34:48.707[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=3420, count=13852) MTC@737675d98ef9: External command `https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/ttcn3-tcpdump-stop.sh C5G_Tests.TC_ran_initiated_qos_flow_mobility fail' was executed successfully (exit status: 0). MTC@737675d98ef9: Starting 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'. ------ C5G_Tests.TC_secondary_rat_data_usage_report ------ (09:34:50) load average: 1.85, 2.34, 1.65 /usr/bin/dumpcap -q -s 1520 -n -i any -w "https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/393/artifact/logs/testsuite/C5G_Tests.TC_secondary_rat_data_usage_report.pcap" >https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/393/artifact/logs/testsuite/C5G_Tests.TC_secondary_rat_data_usage_report.pcap.stdout 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@737675d98ef9: 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@737675d98ef9: Test case TC_secondary_rat_data_usage_report started. GTP1U_EM(880)@737675d98ef9: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 [38;5;23m20260620093451418 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m SRV(,127.0.0.20:4268) accept()ed new link from 127.0.0.1:9999 (stream_srv.c:145)[0;m 20260620093451418 [1;32mDUECUPS[0;m [1;32mINFO[0;m r=127.0.0.1:9999<->l=127.0.0.20:4268: Accepted new UECUPS connection (cups_client.c:822) TC_secondary_rat_data_usage_report-NGAP0(881)@737675d98ef9: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 TC_secondary_rat_data_usage_report-NGAP0(881)@737675d98ef9: setverdict(fail): none -> fail reason: "Could not connect NGAP socket, check your configuration", new component reason: "Could not connect NGAP socket, check your configuration" MC@737675d98ef9: Test Component 881 has requested to stop MTC. Terminating current testcase execution. TC_secondary_rat_data_usage_report-NGAP0(881)@737675d98ef9: Final verdict of PTC: fail reason: "Could not connect NGAP socket, check your configuration" [38;5;23m20260620093451422 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m r=127.0.0.1:9999<->l=127.0.0.20:4268 NOTIFICATION SHUTDOWN_EVENT flags=0x0 (stream.c:360)[0;m 20260620093451422 [1;33mDUECUPS[0;m [1;33mNOTICE[0;m r=127.0.0.1:9999<->l=127.0.0.20:4268: UECUPS connection lost (cups_client.c:748) GTP1U_EM(880)@737675d98ef9: Final verdict of PTC: none MTC@737675d98ef9: Setting final verdict of the test case. MTC@737675d98ef9: Local verdict of MTC: none MTC@737675d98ef9: Local verdict of PTC GTP1U_EM(880): none (none -> none) MTC@737675d98ef9: Local verdict of PTC TC_secondary_rat_data_usage_report-NGAP0(881): fail (none -> fail) reason: "Could not connect NGAP socket, check your configuration" MTC@737675d98ef9: Test case TC_secondary_rat_data_usage_report finished. Verdict: fail reason: Could not connect NGAP socket, check your configuration MTC@737675d98ef9: 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 fail'. (09:34:51) load average: 1.85, 2.34, 1.65 [1;31m------ C5G_Tests.TC_secondary_rat_data_usage_report fail ------[0m
Waiting for packet dumper to finish... 0 (prev_count=-1, count=208) Waiting for packet dumper to finish... 1 (prev_count=208, count=6372) MTC@737675d98ef9: 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 fail' was executed successfully (exit status: 0). MC@737675d98ef9: Test execution finished. Execution of [EXECUTE] section finished. emtc MC@737675d98ef9: Terminating MTC. MC@737675d98ef9: MTC terminated. MC2> exit MC@737675d98ef9: Shutting down session. MC@737675d98ef9: 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-6633.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;32mpass[0;m C5G_Tests.TC_ng_register_ping6_256 [1;32mpass[0;m C5G_Tests.TC_ng_register_ping46 [1;31mpass->FAIL[0;m C5G_Tests.TC_ng_register_ping46_256 [1;32mpass[0;m C5G_Tests.TC_ue_service_request_cm_idle_ul_data [1;32mpass[0;m C5G_Tests.TC_ue_service_request_cm_idle_inact_sess [1;32mpass[0;m C5G_Tests.TC_ue_service_request_cm_idle_unknown_sess_active [1;32mpass[0;m C5G_Tests.TC_ue_service_request_cm_connected [1;32mpass[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: 5 [1;33mxfail[0;m: 7 [1;32mpass[0;m: 19
[1;34m[testenv] Running gdb to get a backtrace[0m [0;94m[testenv] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_cache', '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/5gc:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-5gc-osmocom-nightly-20260620-0929-acada516-1', 'sh', '-c', 'echo; gdb --batch /usr/bin/open5gs-amfd https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/393/artifact/logs/amf/core -ex bt | tee https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/393/artifact/logs/amf/core.backtrace; echo'][0m
[New LWP 6609] [New LWP 6607] [Thread debugging using libthread_db enabled] Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1". Core was generated by `/usr/bin/open5gs-amfd -c open5gs-amf.yaml'. Program terminated with signal SIGSEGV, Segmentation fault. #0 0x00007fdbec6f46bd in NativeInteger_encode_aper (td=0x7fdbec58dba0 <asn_DEF_NGAP_ProtocolIE_ID>, constraints=0x7fdbec5d5c20 <asn_PER_memb_NGAP_id_constr_454>, sptr=0x77, po=0x7fdb86e62d00) at ../lib/asn1c/common/NativeInteger_aper.c:57 warning: 57 ../lib/asn1c/common/NativeInteger_aper.c: No such file or directory [Current thread is 1 (Thread 0x7fdb86e646c0 (LWP 6609))] #0 0x00007fdbec6f46bd in NativeInteger_encode_aper (td=0x7fdbec58dba0 <asn_DEF_NGAP_ProtocolIE_ID>, constraints=0x7fdbec5d5c20 <asn_PER_memb_NGAP_id_constr_454>, sptr=0x77, po=0x7fdb86e62d00) at ../lib/asn1c/common/NativeInteger_aper.c:57 #1 0x00007fdbec6f6f20 in SEQUENCE_encode_aper (td=0x7fdbec5b5460 <asn_DEF_NGAP_PathSwitchRequestAcknowledgeIEs>, constraints=<optimized out>, sptr=0x77, po=0x7fdb86e62d00) at ../lib/asn1c/common/constr_SEQUENCE_aper.c:452 #2 0x00007fdbec6f6148 in SEQUENCE_OF_encode_aper (td=0x7fdbec594000 <asn_DEF_NGAP_ProtocolIE_Container_14662P36>, constraints=<optimized out>, sptr=0x7fdb80378560, po=0x7fdb86e62d00) at ../lib/asn1c/common/constr_SEQUENCE_OF_aper.c:92 #3 0x00007fdbec6f6f20 in SEQUENCE_encode_aper (td=0x7fdbec524d60 <asn_DEF_NGAP_PathSwitchRequestAcknowledge>, constraints=<optimized out>, sptr=0x7fdb803b68b0, po=0x7fdb86e62d00) at ../lib/asn1c/common/constr_SEQUENCE_aper.c:452 #4 0x00007fdbec6f1d7f in aper_encode (td=0x7fdbec524d60 <asn_DEF_NGAP_PathSwitchRequestAcknowledge>, constraints=<optimized out>, sptr=0x7fdb803b68b0, cb=<optimized out>, app_key=app_key@entry=0x7fdb86e62db0) at ../lib/asn1c/common/aper_encoder.c:115 #5 0x00007fdbec6f1f19 in aper_encode_to_new_buffer (td=<optimized out>, constraints=<optimized out>, sptr=<optimized out>, buffer_r=buffer_r@entry=0x7fdb86e62df0) at ../lib/asn1c/common/aper_encoder.c:48 #6 0x00007fdbec6f28bd in aper_open_type_put (td=<optimized out>, constraints=<optimized out>, sptr=<optimized out>, po=po@entry=0x7fdb86e63010) at ../lib/asn1c/common/aper_opentype.c:99 #7 0x00007fdbec6f56e1 in OPEN_TYPE_encode_aper (td=0x7fdbec521260 <asn_DEF_NGAP_value_4>, constraints=<optimized out>, sptr=0x7fdb801af450, po=0x7fdb86e63010) at ../lib/asn1c/common/OPEN_TYPE_aper.c:270 #8 0x00007fdbec6f57ab in OPEN_TYPE_aper_put (td=td@entry=0x7fdbec5210c0 <asn_DEF_NGAP_SuccessfulOutcome>, sptr=sptr@entry=0x7fdb801af440, elm=0x7fdbec521200 <asn_MBR_NGAP_SuccessfulOutcome_1+160>, po=po@entry=0x7fdb86e63010) at ../lib/asn1c/common/OPEN_TYPE_aper.c:336 #9 0x00007fdbec6f6fe3 in SEQUENCE_encode_aper (td=0x7fdbec5210c0 <asn_DEF_NGAP_SuccessfulOutcome>, constraints=<optimized out>, sptr=0x7fdb801af440, po=0x7fdb86e63010) at ../lib/asn1c/common/constr_SEQUENCE_aper.c:450 #10 0x00007fdbec6f5f35 in CHOICE_encode_aper (td=0x7fdbec51f020 <asn_DEF_NGAP_NGAP_PDU>, constraints=<optimized out>, sptr=0x7fdb86e63150, po=0x7fdb86e63010) at ../lib/asn1c/common/constr_CHOICE_aper.c:195 #11 0x00007fdbec6f1d7f in aper_encode (td=td@entry=0x7fdbec51f020 <asn_DEF_NGAP_NGAP_PDU>, constraints=constraints@entry=0x0, sptr=sptr@entry=0x7fdb86e63150, cb=cb@entry=0x7fdbec6f1cb0 <encode_to_buffer_cb>, app_key=app_key@entry=0x7fdb86e630a0) at ../lib/asn1c/common/aper_encoder.c:115 #12 0x00007fdbec6f1eb2 in aper_encode_to_buffer (td=td@entry=0x7fdbec51f020 <asn_DEF_NGAP_NGAP_PDU>, constraints=constraints@entry=0x0, sptr=sptr@entry=0x7fdb86e63150, buffer=<optimized out>, buffer_size=buffer_size@entry=32768) at ../lib/asn1c/common/aper_encoder.c:36 #13 0x00007fdbec6e1807 in ogs_asn_encode (td=td@entry=0x7fdbec51f020 <asn_DEF_NGAP_NGAP_PDU>, sptr=sptr@entry=0x7fdb86e63150) at ../lib/asn1c/util/message.c:95 #14 0x00007fdbec707ba7 in ogs_ngap_encode (message=message@entry=0x7fdb86e63150) at ../lib/ngap/message.c:33 #15 0x000055e17e30c769 in ngap_build_path_switch_ack (amf_ue=amf_ue@entry=0x7fdb879e2100) at ../src/amf/ngap-build.c:2514 #16 0x000055e17e2d6f81 in ngap_send_path_switch_ack (sess=sess@entry=0x7fdb87025780) at ../src/amf/ngap-path.c:611 #17 0x000055e17e2f648c in amf_nsmf_pdusession_handle_update_sm_context (amf_ue=amf_ue@entry=0x7fdb879e2100, ran_ue=ran_ue@entry=0x55e1a1784550, sess=sess@entry=0x7fdb87025780, state=state@entry=20, recvmsg=recvmsg@entry=0x7fdb86e63270) at ../src/amf/nsmf-handler.c:485 #18 0x000055e17e2ec8aa in amf_state_operational (s=<optimized out>, e=<optimized out>) at ../src/amf/amf-sm.c:608 #19 0x00007fdbec731e24 in ogs_fsm_dispatch (fsm=0x7fdb86e63c20, event=0x7fdb800583e0) at ../lib/core/ogs-fsm.c:127 #20 0x000055e17e2c2e49 in amf_main (data=<optimized out>) at ../src/amf/init.c:163 #21 0x00007fdbec727005 in thread_worker (arg=0x55e1a17ad8f0) at ../lib/core/ogs-thread.c:67 #22 0x00007fdbeb69eb7b in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:448 #23 0x00007fdbeb71c7f8 in __GI___clone3 () at ../sysdeps/unix/sysv/linux/x86_64/clone3.S:78
[1;34m[testenv] Stopping podman container[0m [0;94m[testenv] + ['podman', 'kill', 'testenv-5gc-osmocom-nightly-20260620-0929-acada516-1'][0m testenv-5gc-osmocom-nightly-20260620-0929-acada516-1 https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/393/artifact/logs/amf/core: ELF 64-bit LSB core file, x86-64, version 1 (SYSV), SVR4-style, from 'open5gs-amfd -c open5gs-amf.yaml', real uid: 0, effective uid: 0, real gid: 0, effective gid: 0, execfn: '/usr/bin/open5gs-amfd', platform: 'x86_64' [0;94m[testenv] Skipping clean up scripts, podman container has already stopped[0m [1;34m[testenv] Stopping testsuite (266476)[0m Error: container has already been removed Error: container has already been removed Error: container has already been removed Error: container has already been removed [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/393/artifact/logs... [0m + RC=1 + [ 1 = 0 ] + uptime + grep --color=always -o load.* [01;31m[Kload average: 1.78, 2.32, 1.64[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.
jenkins-notifications@lists.osmocom.org
-
jenkins＠lists.osmocom.org