- jenkins-notifications - lists.osmocom.org

Build failed in Jenkins: ttcn3-5gc-test-ogs #479
by jenkins＠lists.osmocom.org 14 Sep '26

14 Sep '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/479/display/redi…> Changes: ------------------------------------------ [...truncated 246.13 MiB...] [32m09/14 09:33:17.503[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_initial(): ENTRY (../src/amf/ngap-sm.c:28) [32m09/14 09:33:17.503[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): ENTRY (../src/amf/ngap-sm.c:55) [32m09/14 09:33:17.503[0m: [[33mamf[0m] [1;32mINFO[0m: [Added] Number of gNBs is now 1 (../src/amf/context.c:1349) [32m09/14 09:33:17.503[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) [32m09/14 09:33:17.503[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_COMM_UP (../src/amf/ngap-sctp.c:161) [32m09/14 09:33:17.503[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_SCTP_COMM_UP (../src/amf/amf-sm.c:84) [32m09/14 09:33:17.503[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] max_num_of_ostreams : 30 (../src/amf/amf-sm.c:870) TC_secondary_rat_data_usage_report-NGAP1(887)@a379fdf1b308: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 [32m09/14 09:33:17.508[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2 accepted[127.0.0.202]:50001 in ng-path module (../src/amf/ngap-sctp.c:113) [32m09/14 09:33:17.508[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_ACCEPT (../src/amf/amf-sm.c:84) [32m09/14 09:33:17.508[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2 accepted[127.0.0.202] in master_sm module (../src/amf/amf-sm.c:823) [32m09/14 09:33:17.511[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_initial(): ENTRY (../src/amf/ngap-sm.c:28) [32m09/14 09:33:17.511[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): ENTRY (../src/amf/ngap-sm.c:55) [32m09/14 09:33:17.511[0m: [[33mamf[0m] [1;32mINFO[0m: [Added] Number of gNBs is now 2 (../src/amf/context.c:1349) [32m09/14 09:33:17.511[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) [32m09/14 09:33:17.511[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_COMM_UP (../src/amf/ngap-sctp.c:161) [32m09/14 09:33:17.511[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_SCTP_COMM_UP (../src/amf/amf-sm.c:84) [32m09/14 09:33:17.511[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] max_num_of_ostreams : 30 (../src/amf/amf-sm.c:870) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_MESSAGE (../src/amf/amf-sm.c:84) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): AMF_EVENT_NGAP_MESSAGE (../src/amf/ngap-sm.c:55) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: NGSetupRequest (../src/amf/ngap-handler.c:288) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: IP[127.0.0.202] GNB_ID[0x0] GNB_ID_LENGTH[22] (../src/amf/ngap-handler.c:386) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:391) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: PagingDRX[0] (../src/amf/ngap-handler.c:395) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: TAC[1] (../src/amf/ngap-handler.c:439) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:501) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: S_NSSAI[SST:1 SD:0xffffff] (../src/amf/ngap-handler.c:562) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: TAC[1] (../src/amf/ngap-handler.c:72) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:73) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: SERVED_TAI_INDEX[0] (../src/amf/ngap-handler.c:78) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:100) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: S_NSSAI[SST:1 SD:0xffffff] (../src/amf/ngap-handler.c:105) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: NG-Setup response (../src/amf/ngap-path.c:356) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: NGSetupResponse (../src/amf/ngap-build.c:91) [32m09/14 09:33:17.514[0m: [[33mamf[0m] [1;37mDEBUG[0m: IP[127.0.0.202] RAN_ID[0] (../src/amf/ngap-path.c:64) MTC@a379fdf1b308: setverdict(pass): none -> pass MTC@a379fdf1b308: Dynamic test case error: Error message was received from MC: The connect operation refers to test component with component reference 885, which has already terminated. MTC@a379fdf1b308: setverdict(error): pass -> error TC_secondary_rat_data_usage_report0(888)@a379fdf1b308: Final verdict of PTC: none [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_SHUTDOWN_EVENT:[T:32773, F:0x0, L:12] (../src/amf/ngap-sctp.c:193) [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_SHUTDOWN_EVENT:[T:32773, F:0x0, L:12] (../src/amf/ngap-sctp.c:193) [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_CONNREFUSED (../src/amf/amf-sm.c:84) [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] connection refused!!! (../src/amf/amf-sm.c:883) [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): EXIT (../src/amf/ngap-sm.c:55) [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_final(): EXIT (../src/amf/ngap-sm.c:37) [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;32mINFO[0m: [Removed] Number of gNBs is now 1 (../src/amf/context.c:1377) [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_CONNREFUSED (../src/amf/amf-sm.c:84) [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] connection refused!!! (../src/amf/amf-sm.c:883) [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): EXIT (../src/amf/ngap-sm.c:55) [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_final(): EXIT (../src/amf/ngap-sm.c:37) [32m09/14 09:33:17.523[0m: [[33mamf[0m] [1;32mINFO[0m: [Removed] Number of gNBs is now 0 (../src/amf/context.c:1377) TC_secondary_rat_data_usage_report-NGAP1(887)@a379fdf1b308: Final verdict of PTC: none TC_secondary_rat_data_usage_report-NGAP0(886)@a379fdf1b308: Final verdict of PTC: none MTC@a379fdf1b308: Setting final verdict of the test case. MTC@a379fdf1b308: Local verdict of MTC: error MTC@a379fdf1b308: Local verdict of PTC GTP1U_EM(885): error (error -> error) MTC@a379fdf1b308: Local verdict of PTC TC_secondary_rat_data_usage_report-NGAP0(886): none (error -> error) MTC@a379fdf1b308: Local verdict of PTC TC_secondary_rat_data_usage_report-NGAP1(887): none (error -> error) MTC@a379fdf1b308: Local verdict of PTC TC_secondary_rat_data_usage_report0(888): none (error -> error) MTC@a379fdf1b308: Test case TC_secondary_rat_data_usage_report finished. Verdict: error MTC@a379fdf1b308: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/src/osmo-ttcn…> C5G_Tests.TC_secondary_rat_data_usage_report error'. (09:33:17) load average: 1.16, 1.80, 3.40 [1;31m------ C5G_Tests.TC_secondary_rat_data_usage_report error ------[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=224) Waiting for packet dumper to finish... 1 (prev_count=224, count=4732) [32m09/14 09:33:19.184[0m: [[33mscp[0m] [1;37mDEBUG[0m: scp_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/scp/scp-sm.c:54) [32m09/14 09:33:19.184[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:312) [32m09/14 09:33:19.185[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/d4c7db16-b01e-41f1-981e-9d8… (../lib/sbi/client.c:797) [32m09/14 09:33:19.185[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m09/14 09:33:19.185[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m09/14 09:33:19.185[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [631] (../lib/sbi/nghttp2-server.c:1749) [32m09/14 09:33:19.185[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/d4c7db16-b01e-41f1-981e-9d8f137f857f (../lib/sbi/nghttp2-server.c:1308) [32m09/14 09:33:19.185[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m09/14 09:33:19.185[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m09/14 09:33:19.185[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m09/14 09:33:19.185[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m09/14 09:33:19.185[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m09/14 09:33:19.185[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [631] (../lib/sbi/nghttp2-server.c:1431) 0000: 00001a01 05000002 7789c061 96d07abe ........w..a..z. 0010: 940b4a6e 2d6a0802 71403f71 966e05f5 ..Jn-j..q(a)?q.n.. 0020: 3168df 1h. [32m09/14 09:33:19.186[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/d4c7db16-b01e-41f1-981e-9d8… (../lib/sbi/client.c:744) [32m09/14 09:33:19.186[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m09/14 09:33:19.186[0m: [[33mscp[0m] [1;37mDEBUG[0m: scp_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/scp/scp-sm.c:54) [32m09/14 09:33:19.186[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:312) [32m09/14 09:33:19.469[0m: [[33msepp[0m] [1;37mDEBUG[0m: sepp_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/sepp/sepp-sm.c:55) [32m09/14 09:33:19.469[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:312) [32m09/14 09:33:19.469[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/d4e60e42-b01e-41f1-91e9-67… (../lib/sbi/client.c:797) [32m09/14 09:33:19.469[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m09/14 09:33:19.469[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m09/14 09:33:19.469[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [51] (../lib/sbi/nghttp2-server.c:1749) [32m09/14 09:33:19.469[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/d4e60e42-b01e-41f1-91e9-67fbdaf3737b (../lib/sbi/nghttp2-server.c:1308) [32m09/14 09:33:19.469[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m09/14 09:33:19.469[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m09/14 09:33:19.469[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/d4e60e42-b01e-41f1-91e9-67f… (../lib/sbi/client.c:797) [32m09/14 09:33:19.469[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m09/14 09:33:19.469[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m09/14 09:33:19.470[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [633] (../lib/sbi/nghttp2-server.c:1749) [32m09/14 09:33:19.470[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/d4e60e42-b01e-41f1-91e9-67fbdaf3737b (../lib/sbi/nghttp2-server.c:1308) [32m09/14 09:33:19.470[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m09/14 09:33:19.470[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m09/14 09:33:19.470[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m09/14 09:33:19.470[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m09/14 09:33:19.470[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m09/14 09:33:19.470[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [633] (../lib/sbi/nghttp2-server.c:1431) 0000: 00000301 05000002 7989c1be ........y... [32m09/14 09:33:19.470[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/d4e60e42-b01e-41f1-91e9-67f… (../lib/sbi/client.c:744) [32m09/14 09:33:19.470[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m09/14 09:33:19.470[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m09/14 09:33:19.470[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [51] (../lib/sbi/nghttp2-server.c:1431) 0000: 00001a01 05000000 3389d561 96d07abe ........3..a..z. 0010: 940b4a6e 2d6a0802 71403f71 966e05f5 ..Jn-j..q(a)?q.n.. 0020: 3168df 1h. [32m09/14 09:33:19.471[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/d4e60e42-b01e-41f1-91e9-67… (../lib/sbi/client.c:744) [32m09/14 09:33:19.471[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m09/14 09:33:19.471[0m: [[33msepp[0m] [1;37mDEBUG[0m: sepp_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/sepp/sepp-sm.c:55) [32m09/14 09:33:19.471[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:312) MTC@a379fdf1b308: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/src/osmo-ttcn…> C5G_Tests.TC_secondary_rat_data_usage_report error' was executed successfully (exit status: 0). MC@a379fdf1b308: Test execution finished. Execution of [EXECUTE] section finished. emtc MC@a379fdf1b308: Terminating MTC. MC@a379fdf1b308: MTC terminated. MC2> exit MC@a379fdf1b308: Shutting down session. MC@a379fdf1b308: Shutdown complete. [32m09/14 09:33:19.664[0m: [[33msepp[0m] [1;37mDEBUG[0m: sepp_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/sepp/sepp-sm.c:55) [32m09/14 09:33:19.664[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:312) [32m09/14 09:33:19.664[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/d4ffd156-b01e-41f1-a982-39… (../lib/sbi/client.c:797) [32m09/14 09:33:19.664[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m09/14 09:33:19.664[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [53] (../lib/sbi/nghttp2-server.c:1749) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/d4ffd156-b01e-41f1-a982-394619cecdd4 (../lib/sbi/nghttp2-server.c:1308) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/d4ffd156-b01e-41f1-a982-394… (../lib/sbi/client.c:797) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [635] (../lib/sbi/nghttp2-server.c:1749) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/d4ffd156-b01e-41f1-a982-394619cecdd4 (../lib/sbi/nghttp2-server.c:1308) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1314) [32m09/14 09:33:19.665[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m09/14 09:33:19.665[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [635] (../lib/sbi/nghttp2-server.c:1431) 0000: 00000301 05000002 7b89c1be ........{... [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/d4ffd156-b01e-41f1-a982-394… (../lib/sbi/client.c:744) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [53] (../lib/sbi/nghttp2-server.c:1431) 0000: 00001a01 05000000 3589d561 96d07abe ........5..a..z. 0010: 940b4a6e 2d6a0802 71403f71 966e05f5 ..Jn-j..q(a)?q.n.. 0020: 3168df 1h. [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/d4ffd156-b01e-41f1-a982-39… (../lib/sbi/client.c:744) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m09/14 09:33:19.665[0m: [[33msepp[0m] [1;37mDEBUG[0m: sepp_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/sepp/sepp-sm.c:55) [32m09/14 09:33:19.665[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:312) Comparing expected results '<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/src/osmo-ttcn…'> against results in 'junit-xml-6861.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;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: 10 [1;33mxfail[0;m: 7 [1;32mpass[0;m: 14 [32m09/14 09:33:19.780[0m: [[33mbsf[0m] [1;37mDEBUG[0m: bsf_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/bsf/bsf-sm.c:59) [32m09/14 09:33:19.781[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:312) [32m09/14 09:33:19.781[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/d51e5338-b01e-41f1-ad06-13… (../lib/sbi/client.c:797) [32m09/14 09:33:19.781[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m09/14 09:33:19.781[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":6}] (../lib/sbi/client.c:548) [32m09/14 09:33:19.781[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [57] (../lib/sbi/nghttp2-server.c:1749) [32m09/14 09:33:19.781[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/d51e5338-b01e-41f1-ad06-1374fe33161f (../lib/sbi/nghttp2-server.c:1308) [32m09/14 09:33:19.781[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m09/14 09:33:19.781[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":6}] (../lib/sbi/nghttp2-server.c:1314) [32m09/14 09:33:19.781[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/d51e5338-b01e-41f1-ad06-137… (../lib/sbi/client.c:797) [32m09/14 09:33:19.781[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m09/14 09:33:19.781[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":6}] (../lib/sbi/client.c:548) [32m09/14 09:33:19.782[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [637] (../lib/sbi/nghttp2-server.c:1749) [32m09/14 09:33:19.782[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/d51e5338-b01e-41f1-ad06-1374fe33161f (../lib/sbi/nghttp2-server.c:1308) [32m09/14 09:33:19.782[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1312) [32m09/14 09:33:19.782[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":6}] (../lib/sbi/nghttp2-server.c:1314) [32m09/14 09:33:19.782[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:54) [32m09/14 09:33:19.782[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:201) [32m09/14 09:33:19.782[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m09/14 09:33:19.782[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [637] (../lib/sbi/nghttp2-server.c:1431) 0000: 00000301 05000002 7d89c1be ........}... [32m09/14 09:33:19.782[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/d51e5338-b01e-41f1-ad06-137… (../lib/sbi/client.c:744) [32m09/14 09:33:19.782[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m09/14 09:33:19.782[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:702) [32m09/14 09:33:19.782[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [57] (../lib/sbi/nghttp2-server.c:1431) 0000: 00001a01 05000000 3989d561 96d07abe ........9..a..z. 0010: 940b4a6e 2d6a0802 71403f71 966e05f5 ..Jn-j..q(a)?q.n.. 0020: 3168df 1h. [32m09/14 09:33:19.783[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/d51e5338-b01e-41f1-ad06-13… (../lib/sbi/client.c:744) [32m09/14 09:33:19.783[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m09/14 09:33:19.783[0m: [[33mbsf[0m] [1;37mDEBUG[0m: bsf_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/bsf/bsf-sm.c:59) [32m09/14 09:33:19.783[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:312) [1;34m[testenv] Stopping podman container[0m [0;94m[testenv] + ['podman', 'kill', 'testenv-5gc-osmocom-nightly-20260914-0929-f348db2d-1'][0m testenv-5gc-osmocom-nightly-20260914-0929-f348db2d-1 [0;94m[testenv] Skipping clean up scripts, podman container has already stopped[0m [1;34m[testenv] Stopping testsuite (3872542)[0m 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/479/artifact/log… [0m + RC=1 + [ 1 = 0 ] + uptime + grep --color=always -o load.* [01;31m[Kload average: 1.07, 1.77, 3.39[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.

1 0

Build failed in Jenkins: ttcn3-bts-test #3263
by jenkins＠lists.osmocom.org 14 Sep '26

14 Sep '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test/3263/display/redirect> Changes: ------------------------------------------ [...truncated 12.62 MiB...] <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a52' time='2.723557'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a53' time='2.700870'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a54' time='2.729426'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a51' time='5.243514'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a52' time='5.220784'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a53' time='5.219503'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a54' time='5.214209'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_mdisc' time='1.225686'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_msg_type' time='1.239884'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_sequence' time='1.250528'/> <testcase classname='BTS_Tests:hopping' name='TC_lapdm_selftest' time='0.004425'/> <testcase classname='BTS_Tests:hopping' name='TC_tch_sign_l2_fill_frame' time='18.428792'/> <testcase classname='BTS_Tests:hopping' name='TC_tch_sign_l2_fill_frame_dtxd' time='2.136831'> <failure type='fail-verdict'>Received DTX TCH fill frame with bad frame number: 175 (mod 104: 71) (mod 26: 19) BTS_Tests.ttcn:9579 BTS_Tests control part BTS_Tests.ttcn:8110 TC_tch_sign_l2_fill_frame_dtxd testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_chopped_ipa_ping' time='24.675705'/> <testcase classname='BTS_Tests:hopping' name='TC_chopped_ipa_payload' time='42.606982'/> <testcase classname='BTS_Tests:hopping' name='TC_ms_pwr_ctrl_constant' time='16.900445'/> <testcase classname='BTS_Tests:hopping' name='TC_ms_pwr_ctrl_pf_ewma' time='32.007421'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_no_rtp_tchf' time='7.394324'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_no_rtp_tchh' time='5.462394'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_rtp_tchf' time='7.576089'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_rtp_tchh' time='5.503080'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_osmux_tchf' time='3.508232'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_osmux_tchh' time='3.481087'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf144' time='5.779337'> <failure type='fail-verdict'>Timeout waiting for matching Downlink data frame BTS_Tests.ttcn:9594 BTS_Tests control part BTS_Tests.ttcn:8781 TC_data_rtp_tchf144 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf96' time='2.152025'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf48' time='2.134629'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchh48' time='5.316943'> <failure type='fail-verdict'>Timeout waiting for matching Downlink data frame BTS_Tests.ttcn:9597 BTS_Tests control part BTS_Tests.ttcn:8880 TC_data_rtp_tchh48 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf24' time='1.805095'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchh24' time='5.363697'> <failure type='fail-verdict'>Timeout waiting for matching Downlink data frame BTS_Tests.ttcn:9599 BTS_Tests control part BTS_Tests.ttcn:8949 TC_data_rtp_tchh24 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf144' time='2.017878'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf96' time='2.026323'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf48' time='2.049606'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchh48' time='2.148481'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf24' time='2.108748'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchh24' time='2.180226'/> <testcase classname='BTS_Tests:hopping' name='TC_early_immediate_assignment' time='3.565445'/> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_rxqual_thresh' time='9.079111'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9610 BTS_Tests control part BTS_Tests.ttcn:9244 TC_acch_overpower_rxqual_thresh testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_rxqual_thresh_dtx' time='9.039922'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9611 BTS_Tests control part BTS_Tests.ttcn:9285 TC_acch_overpower_rxqual_thresh_dtx testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_always_on_facch' time='9.026437'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9612 BTS_Tests control part BTS_Tests.ttcn:9317 TC_acch_overpower_always_on_facch testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_always_on_sacch' time='9.015236'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9613 BTS_Tests control part BTS_Tests.ttcn:9349 TC_acch_overpower_always_on_sacch testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_limit' time='9.024395'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9614 BTS_Tests control part BTS_Tests.ttcn:9380 TC_acch_overpower_limit testcase </failure> </testcase> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbch_load_idle_no_cbch' time='11.190192'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_1block' time='14.259658'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_2block' time='14.187769'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_3block' time='14.198502'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_4block' time='14.172921'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_multi' time='20.202346'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_schedule' time='14.112418'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_only' time='16.179351'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_and_normal' time='17.181709'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_then_null' time='26.189720'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch4_load_idle' time='16.070744'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch4_load_overload' time='18.197366'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_1block' time='14.195525'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_2block' time='14.224404'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_3block' time='14.192284'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_4block' time='14.226541'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_multi' time='20.211261'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_schedule' time='14.128247'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_default_only' time='16.243630'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_default_and_normal' time='17.175690'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch8_load_idle' time='16.172973'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch8_load_overload' time='18.174852'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_p1ro' time='12.184870'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_p1ro_end' time='16.153449'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_pcu' time='1.161566'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi0' time='2.907012'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi0_nopayload' time='21.568065'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi3' time='21.362301'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi4' time='21.364738'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_contention' time='21.303822'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_retransmit' time='3.165568'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_retransmit_bts' time='81.443678'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_invalid_resp' time='23.388963'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_dm' time='14.017617'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_establish_ign_first_sabm' time='7.947219'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_iframe_seq_and_ack' time='29.576281'> <failure type='fail-verdict'>Received RSL ERROR IND { msg_disc := { msg_group := RSL_MDISC_RLL (1), transparent := false }, msg_type := RSL_MT_ERROR_IND (3), ies := { { iei := RSL_IE_CHAN_NR (1), body := { chan_nr := { u := { sdcch8 := { tag := '01'B, sub_chan := 4 } }, tn := 6 } } }, { iei := RSL_IE_LINK_IDENT (2), body := { link_id := { c := FACCH_SDCCH (0), na := false, prio := SAPI0_PRIO_NORMAL (0), sapi := 0 } } }, { iei := RSL_IE_RLM_CAUSE (22), body := { rlm_cause := { len := 1, payload := '01'O } } } } } BTS_Tests_LAPDm.ttcn:1484 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:579 TC_iframe_seq_and_ack testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_iframe_timer_recovery' time='24.586806'> <failure type='fail-verdict'>Received RSL ERROR IND { msg_disc := { msg_group := RSL_MDISC_RLL (1), transparent := false }, msg_type := RSL_MT_ERROR_IND (3), ies := { { iei := RSL_IE_CHAN_NR (1), body := { chan_nr := { u := { sdcch8 := { tag := '01'B, sub_chan := 4 } }, tn := 6 } } }, { iei := RSL_IE_LINK_IDENT (2), body := { link_id := { c := FACCH_SDCCH (0), na := false, prio := SAPI0_PRIO_NORMAL (0), sapi := 0 } } }, { iei := RSL_IE_RLM_CAUSE (22), body := { rlm_cause := { len := 1, payload := '01'O } } } } } BTS_Tests_LAPDm.ttcn:1485 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:685 TC_iframe_timer_recovery testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_ns_seq_error' time='29.621045'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" BTS_Tests_LAPDm.ttcn:1486 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:768 TC_ns_seq_error testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_nr_seq_error' time='2.906095'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_rec_invalid_frame' time='119.169867'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:909 : Missing LAPDm_RR RSP" BTS_Tests_LAPDm.ttcn:1488 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:961 TC_rec_invalid_frame testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_segm_concat_dcch' time='13.539977'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { s := { n_r := 1, p_f := false, s := '10'B, spare := '01'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++++\") } } }" BTS_Tests_LAPDm.ttcn:1489 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1088 TC_segm_concat_dcch testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_segm_concat_sacch' time='48.541748'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := true, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { u := { u := '011'B, p_f := true, u2 := '00'B, spare := '11'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++\") } } }" BTS_Tests_LAPDm.ttcn:1490 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1093 TC_segm_concat_sacch testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_t200_n200' time='39.804502'> <failure type='fail-verdict'>Missing RSL RLL ERROR INDICATION BTS_Tests_LAPDm.ttcn:1491 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1182 TC_t200_n200 testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_rr_response_frame_loss' time='6.665469'> <failure type='fail-verdict'>Timeout waiting for RR or REJ BTS_Tests_LAPDm.ttcn:1492 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1239 TC_rr_response_frame_loss testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_incorrect_cr' time='24.482814'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" BTS_Tests_LAPDm.ttcn:1493 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1293 TC_incorrect_cr testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_incorrect_c' time='23.221346'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" BTS_Tests_LAPDm.ttcn:1494 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1341 TC_sabm_incorrect_c testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_normal_reestablishment' time='16.110573'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { u := { u := '011'B, p_f := true, u2 := '00'B, spare := '11'B } }, len := 5, m := false, el := 1, payload := '828FD4C2D3'O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"+++++++++++++++\") } } }" BTS_Tests_LAPDm.ttcn:1495 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1403 TC_normal_reestablishment testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_normal_reestablishment_state_unacked' time='12.385532'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { s := { n_r := 1, p_f := false, s := '10'B, spare := '01'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++++\") } } }" BTS_Tests_LAPDm.ttcn:1496 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1470 TC_normal_reestablishment_state_unacked testcase </failure> </testcase> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_vff' time='2.433425'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_vhh' time='2.578732'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_hvhh' time='2.590143'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_ipa_vff' time='2.524930'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vff' time='2.569483'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vhh' time='2.590514'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_hvhh' time='2.588064'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vff' time='1.303354'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vhh' time='1.370379'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_hvhh' time='1.356280'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_ipa_vff' time='1.341490'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vff' time='1.339755'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vhh' time='1.402120'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_hvhh' time='1.365678'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vbs_notification' time='4.663694'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_uplink_free_and_busy' time='1.826568'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_fail' time='17.009040'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_est_rel' time='1.448237'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_listener_det' time='3.388861'/> </testsuite> <?xml version="1.0"?> <testsuite name='Titan' tests='17' failures='0' errors='0' skipped='0' inconc='0' time='96.00'> <testcase classname='BTS_Tests_OML' name='TC_wrong_mdisc' time='10.616577'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_msgtype' time='0.703864'/> <testcase classname='BTS_Tests_OML' name='TC_short_length' time='0.718241'/> <testcase classname='BTS_Tests_OML' name='TC_long_length' time='0.691461'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_placement' time='0.702266'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_seq' time='0.683919'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_obj_class' time='0.677186'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_bts_nr' time='0.667177'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_trx_nr' time='0.669756'/> <testcase classname='BTS_Tests_OML' name='TC_radio_carrier_opstart_noattr' time='0.677981'/> <testcase classname='BTS_Tests_OML' name='TC_bts_opstart' time='0.695797'/> <testcase classname='BTS_Tests_OML' name='TC_bts_opstart_noattr' time='0.666016'/> <testcase classname='BTS_Tests_OML' name='TC_ts_opstart' time='0.659369'/> <testcase classname='BTS_Tests_OML' name='TC_ts_opstart_noattr' time='0.682439'/> <testcase classname='BTS_Tests_OML' name='TC_initial_state_reports' time='0.671297'/> <testcase classname='BTS_Tests_OML' name='TC_ipa_osmo_pcu_anr_fwd' time='0.696470'/> <testcase classname='BTS_Tests_OML' name='TC_ipa_rsl_connect_nack' time='0.681792'/> </testsuite> + check_respawn_count + set +x [0;31m ================================================================ WARNING: osmo-bts was respawned 4 times (expected: 3)! (OS#6794) ================================================================ [0m+ RC=1 + uptime + grep --color=always -o load.* [01;31m[Kload average: 0.81, 0.98, 0.88[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.

1 0

Jenkins build became unstable: ttcn3-epdg-test #1076
by jenkins＠lists.osmocom.org 13 Sep '26

13 Sep '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-epdg-test/1076/display/redire…>

1 1

Jenkins build became unstable: ttcn3-epdg-test-latest-net-next #480
by jenkins＠lists.osmocom.org 11 Sep '26

11 Sep '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-epdg-test-latest-net-next/480…>

1 1

Build failed in Jenkins: master-osmo-pcu » master,0,raspbian,none,False #8384
by jenkins＠lists.osmocom.org 11 Sep '26

11 Sep '26

See <https://jenkins.osmocom.org/jenkins/job/master-osmo-pcu/FIRMWARE_VERSION=ma…> Changes: ------------------------------------------ [...truncated 139.92 KiB...] make[3]: Nothing to be done for 'dvi-am'. make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' make[2]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' Making dvi in tests make[2]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' make[2]: Nothing to be done for 'dvi'. make[2]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' Making dvi in contrib make[2]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' Making dvi in systemd make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib/systemd' make[3]: Nothing to be done for 'dvi'. make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib/systemd' make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' make[3]: Nothing to be done for 'dvi-am'. make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' make[2]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' make[2]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[2]: Nothing to be done for 'dvi-am'. make[2]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[1]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[1]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make check-recursive make[2]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' Making check in include make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/include' make[3]: Nothing to be done for 'check'. make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/include' Making check in src make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/src' make[3]: Nothing to be done for 'check'. make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/src' Making check in doc make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' Making check in examples make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/examples' make[4]: Nothing to be done for 'check'. make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/examples' Making check in manuals make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/manuals' make[4]: Nothing to be done for 'check'. make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/manuals' make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' make[4]: Nothing to be done for 'check-am'. make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' Making check in tests make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' make rlcmac/RLCMACTest alloc/AllocTest alloc/MslotTest tbf/TbfTest types/TypesTest ms/MsTest llist/LListTest llc/LlcTest codel/codel_test edge/EdgeTest bitcomp/BitcompTest fn/FnTest app_info/AppInfoTest ulc/PdchUlcTest make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' CXX RLCMACTest.o CXX AllocTest.o CXX MslotTest.o CXX TbfTest.o CXX TypesTest.o CXX MsTest.o CXX LListTest.o CXX LlcTest.o CC codel_test.o CXX EdgeTest.o CXX BitcompTest.o CXX egprs_rlc_compression.o CXX FnTest.o CXX AppInfoTest.o CXX PdchUlcTest.o CXXLD rlcmac/RLCMACTest CXXLD alloc/AllocTest CXXLD alloc/MslotTest CXXLD tbf/TbfTest CXXLD types/TypesTest CXXLD ms/MsTest CXXLD llist/LListTest CXXLD llc/LlcTest CCLD codel/codel_test CXXLD edge/EdgeTest CXXLD bitcomp/BitcompTest CXXLD fn/FnTest CXXLD app_info/AppInfoTest CXXLD ulc/PdchUlcTest make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' make check-local make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' /bin/bash '../../../tests/testsuite' ## ---------------------------------- ## ## osmo-pcu 1.5.3.1-379d7 test suite. ## ## ---------------------------------- ## Regression tests 1: rlcmac ok 2: multi_slot ok 3: ts_alloc ok 4: tbf ok 5: bitcomp ok 6: edge ok 7: types ok 8: ms ok 9: llc ok 10: llist ok 11: codel ok 12: fn ok 13: app_info ok 14: ulc ok ## ------------- ## ## Test results. ## ## ------------- ## All 14 tests were successful. make python-tests make[5]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' Not running python-based tests (determined at configure-time) make[5]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' Making check in contrib make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' Making check in systemd make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib/systemd' make[4]: Nothing to be done for 'check'. make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib/systemd' make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' make[4]: Nothing to be done for 'check-am'. make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[3]: Nothing to be done for 'check-am'. make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[2]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[1]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[1]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make install-recursive make[2]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' Making install in include make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/include' make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/include' make[4]: Nothing to be done for 'install-exec-am'. make[4]: Nothing to be done for 'install-data-am'. make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/include' make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/include' Making install in src make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/src' make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/src' make[4]: Nothing to be done for 'install-data-am'. /usr/bin/mkdir -p '/build/osmo-pcu-1.5.3.1-379d7/_inst/bin' /bin/bash ../libtool --mode=install /usr/bin/install -c osmo-pcu '/build/osmo-pcu-1.5.3.1-379d7/_inst/bin' libtool: install: /usr/bin/install -c osmo-pcu /build/osmo-pcu-1.5.3.1-379d7/_inst/bin/osmo-pcu make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/src' make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/src' Making install in doc make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' Making install in examples make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/examples' make[5]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/examples' make[5]: Nothing to be done for 'install-exec-am'. /usr/bin/mkdir -p '/build/osmo-pcu-1.5.3.1-379d7/_inst/share/doc/osmo-pcu/examples/osmo-pcu' /usr/bin/mkdir -p '/build/osmo-pcu-1.5.3.1-379d7/_inst/etc/osmocom' /usr/bin/install -c -m 644 ../../../../doc/examples/osmo-pcu.cfg '/build/osmo-pcu-1.5.3.1-379d7/_inst/share/doc/osmo-pcu/examples/osmo-pcu' /usr/bin/install -c -m 644 ../../../../doc/examples/osmo-pcu.cfg '/build/osmo-pcu-1.5.3.1-379d7/_inst/etc/osmocom' make[5]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/examples' make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/examples' Making install in manuals make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/manuals' make[5]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/manuals' make[5]: Nothing to be done for 'install-exec-am'. make[5]: Nothing to be done for 'install-data-am'. make[5]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/manuals' make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/manuals' make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' make[5]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' make[5]: Nothing to be done for 'install-exec-am'. make[5]: Nothing to be done for 'install-data-am'. make[5]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' Making install in tests make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' make[4]: Nothing to be done for 'install-exec-am'. make[4]: Nothing to be done for 'install-data-am'. make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' Making install in contrib make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' Making install in systemd make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib/systemd' make[5]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib/systemd' make[5]: Nothing to be done for 'install-exec-am'. /usr/bin/mkdir -p '/build/osmo-pcu-1.5.3.1-379d7/_inst/' /usr/bin/install -c -m 644 ../../../../contrib/systemd/osmo-pcu.service '/build/osmo-pcu-1.5.3.1-379d7/_inst/' make[5]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib/systemd' make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib/systemd' make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' make[5]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' make[5]: Nothing to be done for 'install-exec-am'. make[5]: Nothing to be done for 'install-data-am'. make[5]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/contrib' make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[4]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[4]: Nothing to be done for 'install-exec-am'. make[4]: Nothing to be done for 'install-data-am'. make[4]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[2]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[1]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' make[1]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub' Making installcheck in include make[2]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/include' make[2]: Nothing to be done for 'installcheck'. make[2]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/include' Making installcheck in src make[2]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/src' make[2]: Nothing to be done for 'installcheck'. make[2]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/src' Making installcheck in doc make[2]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' Making installcheck in examples make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/examples' make[3]: Nothing to be done for 'installcheck'. make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/examples' Making installcheck in manuals make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/manuals' make[3]: Nothing to be done for 'installcheck'. make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc/manuals' make[3]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' make[3]: Nothing to be done for 'installcheck-am'. make[3]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' make[2]: Leaving directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/doc' Making installcheck in tests make[2]: Entering directory '/build/osmo-pcu-1.5.3.1-379d7/_build/sub/tests' /bin/bash '../../../tests/testsuite' AUTOTEST_PATH='/build/osmo-pcu-1.5.3.1-379d7/_inst/bin' \ ## ---------------------------------- ## ## osmo-pcu 1.5.3.1-379d7 test suite. ## ## ---------------------------------- ## Regression tests 1: rlcmac ok 2: multi_slot ok 3: ts_alloc Build step 'Execute shell' marked build as failure $ ssh-agent -k unset SSH_AUTH_SOCK; unset SSH_AGENT_PID; echo Agent pid 1826270 killed; [ssh-agent] Stopped. Archiving artifacts

1 1

Build failed in Jenkins: ttcn3-smf-test-ogs-latest #1
by jenkins＠lists.osmocom.org 08 Sep '26

08 Sep '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/display…> Changes: ------------------------------------------ [...truncated 109.52 KiB...] cmtc MC@29c9d80cf285: Downloading configuration file to all HCs. construct junitlogger Initializing `JUnitLogger' (v2.0): JUnitLogger writes JUnit-compatible XML MC@29c9d80cf285: Configuration file was processed on all HCs. MC@29c9d80cf285: Creating MTC on host 10.0.2.100. MC@29c9d80cf285: MTC is created. MC2> smtc Executing all items of [EXECUTE] section. MC2> MTC@29c9d80cf285: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_tx_echo'. ------ SMF_Tests.TC_tx_echo ------ (13:08:30) load average: 2.37, 0.88, 0.83 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@29c9d80cf285: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_tx_echo' was executed successfully (exit status: 0). MTC@29c9d80cf285: Test case TC_tx_echo started. TC_tx_echo-PFCP(6)@29c9d80cf285: f_PFCPEM_conns_bcast_add(): vc_conn mtc subscribed for broadcast TC_tx_echo-PFCP(6)@29c9d80cf285: PFCP_Emulation main() CLIENT.receive from mtc: { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 0, lengthIndicator := 0, seid := omit, sequence_number := 0, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { heartbeat_request := { recovery_time_stamp := { elementIdentifier := 96, lengthIndicator := 0, time_value := 3997170511 } } } } TC_tx_echo-PFCP(6)@29c9d80cf285: PFCP_Emulation main() PFCP.receive: { peer := { conn_id := 1, remote_name := "127.0.0.4", remote_port := 8805 }, pdu := { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 2, lengthIndicator := 12, seid := omit, sequence_number := 460001, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { heartbeat_response := { recovery_time_stamp := { elementIdentifier := 96, lengthIndicator := 4, time_value := 3997170509 } } } } } TC_tx_echo-PFCP(6)@29c9d80cf285: found destination mtc TC_tx_echo-PFCP(6)@29c9d80cf285: PFCP_Emulation main() PFCP.receive: { peer := { conn_id := 1, remote_name := "127.0.0.4", remote_port := 8805 }, pdu := { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 5, lengthIndicator := 26, seid := omit, sequence_number := 1, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { pfcp_association_setup_request := { node_id := { elementIdentifier := 60, lengthIndicator := 5, node_id_type := 0, spare := '0000'B, node_id_value := '7F000004'O }, time_stamp := { elementIdentifier := 96, lengthIndicator := 4, time_value := 3997170509 }, up_function_features := omit, cp_function_features := { elementIdentifier := 89, lengthIndicator := 1, load := '0'B, ovrl := '0'B, epfar := '0'B, sset := '0'B, bundl := '0'B, mpas := '0'B, ardr := '0'B, uiaur := '0'B, psucc := omit, rpgur := omit, papfd := omit, spare6_4 := omit, spare6_5 := omit, spare6_6 := omit, spare6_7 := omit, spare6_8 := omit }, UP_IP_resource_list := omit } } } } TC_tx_echo-PFCP(6)@29c9d80cf285: broadcasting to mtc MTC@29c9d80cf285: setverdict(pass): none -> pass TC_tx_echo-PFCP(6)@29c9d80cf285: PFCP_Emulation main() CLIENT.receive from mtc: { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 0, lengthIndicator := 0, seid := omit, sequence_number := 1, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { pfcp_association_setup_response := { node_id := { elementIdentifier := 60, lengthIndicator := 0, node_id_type := 0, spare := '0000'B, node_id_value := '7F000007'O }, cause := { elementIdentifier := 19, lengthIndicator := 0, causeValue := '01'O }, time_stamp := { elementIdentifier := 96, lengthIndicator := 0, time_value := 3997170511 }, up_function_features := { elementIdentifier := 43, lengthIndicator := 0, bucp := '0'B, ddnd := '0'B, dlbd := '0'B, trst := '0'B, ftup := '1'B, pfdm := '0'B, heeu := '0'B, treu := '0'B, empu := '0'B, pdiu := '0'B, udbc := '0'B, quoac := '0'B, trace := '0'B, frrt := '0'B, pfde := '0'B, epfar := '0'B, dpdra := '0'B, adpdp := '0'B, ueip := '0'B, sset := '0'B, mnop := '0'B, mte := '0'B, bundl := '0'B, gcom := '0'B, mpas := '0'B, rttl := '0'B, vtime := '0'B, norp := '0'B, iptv := '0'B, ip6pl := '0'B, tsn := '0'B, mptcp := '0'B, atsss_ll := '0'B, qfqm := '0'B, gpqm := '0'B, mt_edt := '0'B, ciot := '0'B, ethar := '0'B, ddds := '0'B, rds := '0'B, rttwp := '0'B, quasf := '0'B, nspoc := '0'B, l2tp := '0'B, upber := '0'B, resps := '0'B, iprep := '0'B, dnsts := '0'B, drqos := '0'B, mbsn4 := '0'B, psuprm := '0'B, epppi := '0'B, ratp := '0'B, upidp := '0'B, afsfc := '0'B, mquic_udp := '0'B, redsm := '0'B, dbdm := '0'B, tscts := '0'B, drtsc := '0'B, n6jedb := '0'B, qmcon := '0'B, detnet := '0'B, eml4s := '0'B, pdusm := '0'B, cn_tl := '0'B, qmdrm := '0'B, edbnc := '0'B, mt_sdt := '0'B, upsbies := '0'B, umn6ip := '0'B, un6tu := '0'B, mbsch := '0'B, un6dm := '0'B, natpub := '0'B, ushph := '0'B, mpquic_ip := '0'B, mpquic_e := '0'B, dyntr := '0'B, muxmf := '0'B, conudp := '0'B, moq := '0'B, ulm := '0'B, psitlm := '0'B, udpopt := '0'B, qmabr := '0'B, papfd := '0'B, spare := '0'B }, cp_function_features := omit, UP_IP_resource_list := omit } } } [32m08/31 13:08:32.251[0m: [[33msmf[0m] [1;32mINFO[0m: PFCP associated [127.0.0.7]:8805 (../src/smf/pfcp-sm.c:189) TC_tx_echo-PFCP(6)@29c9d80cf285: f_PFCPEM_conns_bcast_del(): vc_conn mtc unsubscribed from broadcast TC_tx_echo-PFCP(6)@29c9d80cf285: Rx Heartbeat Req: { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 1, lengthIndicator := 12, seid := omit, sequence_number := 2, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { heartbeat_request := { recovery_time_stamp := { elementIdentifier := 96, lengthIndicator := 4, time_value := 3997170509 } } } } TC_tx_echo(7)@29c9d80cf285: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 TC_tx_echo(8)@29c9d80cf285: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 TC_tx_echo(9)@29c9d80cf285: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 [32m08/31 13:08:32.432[0m: [[33mdiam[0m] [1;32mINFO[0m: CONNECTED TO 'aaa.localdomain' (SCTP,soc#17): (../lib/diameter/common/logger.c:81) [32m08/31 13:08:33.466[0m: [[33mdiam[0m] [1;32mINFO[0m: CONNECTED TO 'ocs.localdomain' (SCTP,soc#18): (../lib/diameter/common/logger.c:81) [32m08/31 13:08:33.710[0m: [[33mdiam[0m] [1;32mINFO[0m: CONNECTED TO 'pcrf.localdomain' (SCTP,soc#19): (../lib/diameter/common/logger.c:81) MTC@29c9d80cf285: setverdict(pass): pass -> pass, component reason not changed GTP1U_EM(4)@29c9d80cf285: Final verdict of PTC: none GTP2C_EM(3)@29c9d80cf285: Final verdict of PTC: none MutexDispCT-TC_tx_echo(5)@29c9d80cf285: Final verdict of PTC: none [32m08/31 13:08:34.736[0m: [[33mdiam[0m] [1;33mERROR[0m: pid:PSM/aaa.localdomain in fd_psm_change_state@p_psm.c:284: 'STATE_OPEN' -> 'STATE_CLOSED' 'aaa.localdomain' ((null):0) [32m08/31 13:08:34.736[0m: [[33mdiam[0m] [1;33mERROR[0m: pid:PSM/pcrf.localdomain in fd_psm_change_state@p_psm.c:284: 'STATE_OPEN' -> 'STATE_CLOSED' 'pcrf.localdomain' ((null):0) TC_tx_echo-PFCP(6)@29c9d80cf285: Final verdict of PTC: none [32m08/31 13:08:34.736[0m: [[33mdiam[0m] [1;33mERROR[0m: pid:PSM/ocs.localdomain in fd_psm_change_state@p_psm.c:284: 'STATE_OPEN' -> 'STATE_CLOSED' 'ocs.localdomain' ((null):0) TC_tx_echo(8)@29c9d80cf285: Final verdict of PTC: none TC_tx_echo(7)@29c9d80cf285: Final verdict of PTC: none TC_tx_echo(9)@29c9d80cf285: Final verdict of PTC: none MTC@29c9d80cf285: Setting final verdict of the test case. MTC@29c9d80cf285: Local verdict of MTC: pass MTC@29c9d80cf285: Local verdict of PTC GTP2C_EM(3): none (pass -> pass) MTC@29c9d80cf285: Local verdict of PTC GTP1U_EM(4): none (pass -> pass) MTC@29c9d80cf285: Local verdict of PTC MutexDispCT-TC_tx_echo(5): none (pass -> pass) MTC@29c9d80cf285: Local verdict of PTC TC_tx_echo-PFCP(6): none (pass -> pass) MTC@29c9d80cf285: Local verdict of PTC TC_tx_echo(7): none (pass -> pass) MTC@29c9d80cf285: Local verdict of PTC TC_tx_echo(8): none (pass -> pass) MTC@29c9d80cf285: Local verdict of PTC TC_tx_echo(9): none (pass -> pass) MTC@29c9d80cf285: Test case TC_tx_echo finished. Verdict: pass MTC@29c9d80cf285: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_tx_echo pass'. (13:08:34) load average: 2.26, 0.89, 0.83 [1;32m====== SMF_Tests.TC_tx_echo pass ======[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=8896) Waiting for packet dumper to finish... 1 (prev_count=8896, count=9852) MTC@29c9d80cf285: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_tx_echo pass' was executed successfully (exit status: 0). MTC@29c9d80cf285: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_createSession_deleteSession'. ------ SMF_Tests.TC_createSession_deleteSession ------ (13:08:36) load average: 2.08, 0.87, 0.82 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@29c9d80cf285: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_createSession_deleteSession' was executed successfully (exit status: 0). MTC@29c9d80cf285: Test case TC_createSession_deleteSession started. TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: f_PFCPEM_conns_bcast_add(): vc_conn mtc subscribed for broadcast TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: PFCP_Emulation main() CLIENT.receive from mtc: { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 0, lengthIndicator := 0, seid := omit, sequence_number := 0, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { heartbeat_request := { recovery_time_stamp := { elementIdentifier := 96, lengthIndicator := 0, time_value := 3997170517 } } } } [32m08/31 13:08:37.889[0m: [[33mpfcp[0m] [1;33mERROR[0m: Remote PFCP restarted [3997170511<3997170517] in Heartbeat REQ (../lib/pfcp/handler.c:39) [32m08/31 13:08:37.889[0m: [[33msmf[0m] [1;32mINFO[0m: PFCP de-associated [127.0.0.7]:8805 (../src/smf/pfcp-sm.c:205) TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: PFCP_Emulation main() PFCP.receive: { peer := { conn_id := 1, remote_name := "127.0.0.4", remote_port := 8805 }, pdu := { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 2, lengthIndicator := 12, seid := omit, sequence_number := 6510001, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { heartbeat_response := { recovery_time_stamp := { elementIdentifier := 96, lengthIndicator := 4, time_value := 3997170509 } } } } } TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: found destination mtc TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: PFCP_Emulation main() PFCP.receive: { peer := { conn_id := 1, remote_name := "127.0.0.4", remote_port := 8805 }, pdu := { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 5, lengthIndicator := 26, seid := omit, sequence_number := 3, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { pfcp_association_setup_request := { node_id := { elementIdentifier := 60, lengthIndicator := 5, node_id_type := 0, spare := '0000'B, node_id_value := '7F000004'O }, time_stamp := { elementIdentifier := 96, lengthIndicator := 4, time_value := 3997170509 }, up_function_features := omit, cp_function_features := { elementIdentifier := 89, lengthIndicator := 1, load := '0'B, ovrl := '0'B, epfar := '0'B, sset := '0'B, bundl := '0'B, mpas := '0'B, ardr := '0'B, uiaur := '0'B, psucc := omit, rpgur := omit, papfd := omit, spare6_4 := omit, spare6_5 := omit, spare6_6 := omit, spare6_7 := omit, spare6_8 := omit }, UP_IP_resource_list := omit } } } } TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: broadcasting to mtc MTC@29c9d80cf285: setverdict(pass): none -> pass TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: PFCP_Emulation main() CLIENT.receive from mtc: { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 0, lengthIndicator := 0, seid := omit, sequence_number := 3, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { pfcp_association_setup_response := { node_id := { elementIdentifier := 60, lengthIndicator := 0, node_id_type := 0, spare := '0000'B, node_id_value := '7F000007'O }, cause := { elementIdentifier := 19, lengthIndicator := 0, causeValue := '01'O }, time_stamp := { elementIdentifier := 96, lengthIndicator := 0, time_value := 3997170517 }, up_function_features := { elementIdentifier := 43, lengthIndicator := 0, bucp := '0'B, ddnd := '0'B, dlbd := '0'B, trst := '0'B, ftup := '1'B, pfdm := '0'B, heeu := '0'B, treu := '0'B, empu := '0'B, pdiu := '0'B, udbc := '0'B, quoac := '0'B, trace := '0'B, frrt := '0'B, pfde := '0'B, epfar := '0'B, dpdra := '0'B, adpdp := '0'B, ueip := '0'B, sset := '0'B, mnop := '0'B, mte := '0'B, bundl := '0'B, gcom := '0'B, mpas := '0'B, rttl := '0'B, vtime := '0'B, norp := '0'B, iptv := '0'B, ip6pl := '0'B, tsn := '0'B, mptcp := '0'B, atsss_ll := '0'B, qfqm := '0'B, gpqm := '0'B, mt_edt := '0'B, ciot := '0'B, ethar := '0'B, ddds := '0'B, rds := '0'B, rttwp := '0'B, quasf := '0'B, nspoc := '0'B, l2tp := '0'B, upber := '0'B, resps := '0'B, iprep := '0'B, dnsts := '0'B, drqos := '0'B, mbsn4 := '0'B, psuprm := '0'B, epppi := '0'B, ratp := '0'B, upidp := '0'B, afsfc := '0'B, mquic_udp := '0'B, redsm := '0'B, dbdm := '0'B, tscts := '0'B, drtsc := '0'B, n6jedb := '0'B, qmcon := '0'B, detnet := '0'B, eml4s := '0'B, pdusm := '0'B, cn_tl := '0'B, qmdrm := '0'B, edbnc := '0'B, mt_sdt := '0'B, upsbies := '0'B, umn6ip := '0'B, un6tu := '0'B, mbsch := '0'B, un6dm := '0'B, natpub := '0'B, ushph := '0'B, mpquic_ip := '0'B, mpquic_e := '0'B, dyntr := '0'B, muxmf := '0'B, conudp := '0'B, moq := '0'B, ulm := '0'B, psitlm := '0'B, udpopt := '0'B, qmabr := '0'B, papfd := '0'B, spare := '0'B }, cp_function_features := omit, UP_IP_resource_list := omit } } } [32m08/31 13:08:37.891[0m: [[33msmf[0m] [1;32mINFO[0m: PFCP associated [127.0.0.7]:8805 (../src/smf/pfcp-sm.c:189) [32m08/31 13:08:37.891[0m: [[33msmf[0m] [1;33mERROR[0m: PFCP restoration (../src/smf/pfcp-sm.c:199) TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: f_PFCPEM_conns_bcast_del(): vc_conn mtc unsubscribed from broadcast TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: Rx Heartbeat Req: { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 1, lengthIndicator := 12, seid := omit, sequence_number := 4, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { heartbeat_request := { recovery_time_stamp := { elementIdentifier := 96, lengthIndicator := 4, time_value := 3997170509 } } } } TC_createSession_deleteSession(14)@29c9d80cf285: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 TC_createSession_deleteSession(15)@29c9d80cf285: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 TC_createSession_deleteSession(16)@29c9d80cf285: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 [32m08/31 13:08:38.457[0m: [[33mdiam[0m] [1;32mINFO[0m: CONNECTED TO 'aaa.localdomain' (SCTP,soc#17): (../lib/diameter/common/logger.c:81) [32m08/31 13:08:39.672[0m: [[33mdiam[0m] [1;32mINFO[0m: CONNECTED TO 'ocs.localdomain' (SCTP,soc#18): (../lib/diameter/common/logger.c:81) [32m08/31 13:08:40.739[0m: [[33msbi[0m] [1;36mWARNING[0m: [0f859ec4-a53d-41f1-a76c-dda2e2791897] Retry registration with NRF (../lib/sbi/nf-sm.c:282) [32m08/31 13:08:40.739[0m: [[33msbi[0m] [1;36mWARNING[0m: Could not connect to server (7): Failed to connect to 127.0.1.10 port 7777 after 0 ms: Could not connect to server (../lib/sbi/client.c:767) [32m08/31 13:08:40.739[0m: [[33msbi[0m] [1;36mWARNING[0m: ogs_sbi_client_handler() failed [-1] (../lib/sbi/path.c:62) [32m08/31 13:08:40.944[0m: [[33mdiam[0m] [1;32mINFO[0m: CONNECTED TO 'pcrf.localdomain' (SCTP,soc#19): (../lib/diameter/common/logger.c:81) TC_createSession_deleteSession(14)@29c9d80cf285: Created Expect[0] for '001010123456789'H to be handled at TC_createSession_deleteSession(17) TC_createSession_deleteSession(15)@29c9d80cf285: Created Expect[0] for '001010123456789'H to be handled at TC_createSession_deleteSession(17) TC_createSession_deleteSession(16)@29c9d80cf285: Created Expect[0] for '001010123456789'H to be handled at TC_createSession_deleteSession(17) TC_createSession_deleteSession(17)@29c9d80cf285: f_Mutex_lock(): mutex acquired @ "SMF_Session_CT.ttcn":402 [32m08/31 13:08:42.037[0m: [[33msmf[0m] [1;32mINFO[0m: [Added] Number of SMF-UEs is now 1 (../src/smf/context.c:1069) [32m08/31 13:08:42.037[0m: [[33msmf[0m] [1;32mINFO[0m: [Added] Number of SMF-Sessions is now 1 (../src/smf/context.c:3612) [32m08/31 13:08:42.037[0m: [[33msmf[0m] [1;32mINFO[0m: UE IMSI[001010123456789] APN[internet] IPv4[10.45.0.2] IPv6[] (../src/smf/s5c-handler.c:312) TC_createSession_deleteSession(15)@29c9d80cf285: Found Expect[0] for { version := 1, message_length := 712, RPETxxxx := '11000000'B, command_code := Credit_Control (272), application_id := '00000004'O, hop_by_hop_id := '10760088'O, end_to_end_id := 'CCDEDA22'O, avps := { { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Session_Id (263) }, VMPxxxxx := '01000000'B, avp_length := 43, vendor_id := omit }, avp_data := { avp_BASE_NONE_Session_Id := '736D662E6C6F63616C646F6D61696E3B313738383138313730393B323B6170705F6779'O ("smf.localdomain;1788181709;2;app_gy") } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Origin_Host (264) }, VMPxxxxx := '01000000'B, avp_length := 23, vendor_id := omit }, avp_data := { avp_BASE_NONE_Origin_Host := "smf.localdomain" } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Origin_Realm (296) }, VMPxxxxx := '01000000'B, avp_length := 19, vendor_id := omit }, avp_data := { avp_BASE_NONE_Origin_Realm := "localdomain" } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Destination_Realm (283) }, VMPxxxxx := '01000000'B, avp_length := 19, vendor_id := omit }, avp_data := { avp_BASE_NONE_Destination_Realm := "localdomain" } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Auth_Application_Id (258) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_BASE_NONE_Auth_Application_Id := '00000004'O } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Service_Context_Id (461) }, VMPxxxxx := '01000000'B, avp_length := 22, vendor_id := omit }, avp_data := { avp_DCC_NONE_Service_Context_Id := '333232353140336770702E6F7267'O ("32251(a)3gpp.org") } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_CC_Request_Type (416) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_CC_Request_Type := INITIAL_REQUEST (1) } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_CC_Request_Number (415) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_CC_Request_Number := '00000000'O } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Event_Timestamp (55) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_BASE_NONE_Event_Timestamp := 'EE3FFB5A'O } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id (443) }, VMPxxxxx := '01000000'B, avp_length := 44, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id := { { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id_Type (450) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id_Type := END_USER_IMSI (1) } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id_Data (444) }, VMPxxxxx := '01000000'B, avp_length := 23, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id_Data := '303031303130313233343536373839'O ("001010123456789") } } } } } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id (443) }, VMPxxxxx := '01000000'B, avp_length := 32, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id := { { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id_Type (450) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id_Type := END_USER_E164 (0) } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id_Data (444) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id_Data := '31323334'O ("1234") } } } } } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Requested_Action (436) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_Requested_Action := DIRECT_DEBITING (0) } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_DCA_3GPP_AoC_Request_Type (2055) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_DCA_3GPP_AoC_Request_Type := AoC_FULL (1) } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Multiple_Services_Indicator (455) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_Multiple_Services_Indicator := MULTIPLE_SERVICES_NOT_SUPPORTED (0) } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Multiple_Services_Credit_Control (456) }, VMPxxxxx := '01000000'B, avp_length := 152, vendor_id := omit }, avp_data := { avp_DCC_NONE_Multiple_Services_Credit_Control := { { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Requested_Service_Unit (437) }, VMPxxxxx := '01000000'B, avp_length := 24, vendor_id := omit }, avp_data := { avp_DCC_NONE_Requested_Service_Unit := { { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_CC_Total_Octets (421) }, VMPxxxxx := '01000000'B, avp_length := 16, vendor_id := omit }, avp_data := { avp_DCC_NONE_CC_Total_Octets := '00000000000F4240'O } } } } } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_QoS_Information (1016) }, VMPxxxxx := '11000000'B, avp_length := 120, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_QoS_Information := { { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_QoS_Class_Identifier (1028) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_QoS_Class_Identifier := '00000009'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Allocation_Retention_Priority (1034) }, VMPxxxxx := '10000000'B, avp_length := 60, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Allocation_Retention_Priority := { { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Priority_Level (1046) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Priority_Level := '00000009'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Pre_emption_Capability (1047) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Pre_emption_Capability := PRE_EMPTION_CAPABILITY_ENABLED (0) } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Pre_emption_Vulnerability (1048) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Pre_emption_Vulnerability := PRE_EMPTION_VULNERABILITY_ENABLED (0) } } } } } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_APN_Aggregate_Max_Bitrate_UL (1041) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_APN_Aggregate_Max_Bitrate_UL := '061A8000'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_APN_Aggregate_Max_Bitrate_DL (1040) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_APN_Aggregate_Max_Bitrate_DL := '061A8000'O } } } } } } } } } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_DCA_3GPP_Service_Information (873) }, VMPxxxxx := '11000000'B, avp_length := 244, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_DCA_3GPP_Service_Information := { { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_DCA_3GPP_PS_Information (874) }, VMPxxxxx := '11000000'B, avp_length := 232, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_DCA_3GPP_PS_Information := { { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_GI_3GPP_3GPP_Charging_Id (2) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_GI_3GPP_3GPP_Charging_Id := '00000001'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_GI_3GPP_3GPP_PDP_Type (3) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_GI_3GPP_3GPP_PDP_Type := IPv4 (0) } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_DCA_3GPP_PDP_Address (1227) }, VMPxxxxx := '11000000'B, avp_length := 18, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_DCA_3GPP_PDP_Address := { address_type := IP (1), address_data := '0A2D0002'O } } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_DCA_3GPP_SGSN_Address (1228) }, VMPxxxxx := '11000000'B, avp_length := 18, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_DCA_3GPP_SGSN_Address := { address_type := IP (1), address_data := '7F0000CA'O } } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_DCA_3GPP_GGSN_Address (847) }, VMPxxxxx := '11000000'B, avp_length := 18, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_DCA_3GPP_GGSN_Address := { address_type := IP (1), address_data := '7F000004'O } } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DNAS_NONE_Called_Station_Id (30) }, VMPxxxxx := '01000000'B, avp_length := 16, vendor_id := omit }, avp_data := { avp_DNAS_NONE_Called_Station_Id := '696E7465726E6574'O ("internet") } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_GI_3GPP_3GPP_Selection_Mode (12) }, VMPxxxxx := '11000000'B, avp_length := 13, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_GI_3GPP_3GPP_Selection_Mode := '30'O ("0") } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_GI_3GPP_3GPP_Charging_Characteristics (13) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_GI_3GPP_3GPP_Charging_Characteristics := '30303030'O ("0000") } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_GI_3GPP_3GPP_SGSN_MCC_MNC (18) }, VMPxxxxx := '11000000'B, avp_length := 17, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_GI_3GPP_3GPP_SGSN_MCC_MNC := '3030313031'O ("00101") } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_GI_3GPP_3GPP_NSAPI (10) }, VMPxxxxx := '11000000'B, avp_length := 13, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_GI_3GPP_3GPP_NSAPI := '05'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_GI_3GPP_3GPP_User_Location_Info (22) }, VMPxxxxx := '11000000'B, avp_length := 25, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_GI_3GPP_3GPP_User_Location_Info := '8200F110000100F11000000017'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_GI_3GPP_3GPP_RAT_Type (21) }, VMPxxxxx := '11000000'B, avp_length := 13, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_GI_3GPP_3GPP_RAT_Type := '06'O } } } } } } } } } } } } } handled at TC_createSession_deleteSession(17) TC_createSession_deleteSession(14)@29c9d80cf285: Found Expect[0] for { version := 1, message_length := 668, RPETxxxx := '11000000'B, command_code := Credit_Control (272), application_id := '01000016'O, hop_by_hop_id := '1F84E2D0'O, end_to_end_id := 'CCDEDA21'O, avps := { { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Session_Id (263) }, VMPxxxxx := '01000000'B, avp_length := 43, vendor_id := omit }, avp_data := { avp_BASE_NONE_Session_Id := '736D662E6C6F63616C646F6D61696E3B313738383138313730393B313B6170705F6778'O ("smf.localdomain;1788181709;1;app_gx") } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Origin_Host (264) }, VMPxxxxx := '01000000'B, avp_length := 23, vendor_id := omit }, avp_data := { avp_BASE_NONE_Origin_Host := "smf.localdomain" } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Origin_Realm (296) }, VMPxxxxx := '01000000'B, avp_length := 19, vendor_id := omit }, avp_data := { avp_BASE_NONE_Origin_Realm := "localdomain" } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Destination_Realm (283) }, VMPxxxxx := '01000000'B, avp_length := 19, vendor_id := omit }, avp_data := { avp_BASE_NONE_Destination_Realm := "localdomain" } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Auth_Application_Id (258) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_BASE_NONE_Auth_Application_Id := '01000016'O } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_CC_Request_Type (416) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_CC_Request_Type := INITIAL_REQUEST (1) } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_CC_Request_Number (415) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_CC_Request_Number := '00000000'O } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id (443) }, VMPxxxxx := '01000000'B, avp_length := 44, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id := { { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id_Type (450) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id_Type := END_USER_IMSI (1) } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id_Data (444) }, VMPxxxxx := '01000000'B, avp_length := 23, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id_Data := '303031303130313233343536373839'O ("001010123456789") } } } } } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id (443) }, VMPxxxxx := '01000000'B, avp_length := 32, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id := { { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id_Type (450) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id_Type := END_USER_E164 (0) } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DCC_NONE_Subscription_Id_Data (444) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DCC_NONE_Subscription_Id_Data := '31323334'O ("1234") } } } } } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_CxDx_3GPP_Supported_Features (628) }, VMPxxxxx := '10000000'B, avp_length := 56, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_CxDx_3GPP_Supported_Features := { { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_BASE_NONE_Vendor_Id (266) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_BASE_NONE_Vendor_Id := '000028AF'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_CxDx_3GPP_Feature_List_ID (629) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_CxDx_3GPP_Feature_List_ID := '00000001'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_CxDx_3GPP_Feature_List (630) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_CxDx_3GPP_Feature_List := '0000000B'O } } } } } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Network_Request_Support (1024) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Network_Request_Support := NETWORK_REQUEST_SUPPORTED (1) } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DNAS_NONE_Framed_IP_Address (8) }, VMPxxxxx := '01000000'B, avp_length := 12, vendor_id := omit }, avp_data := { avp_DNAS_NONE_Framed_IP_Address := '0A2D0002'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_IP_CAN_Type (1027) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_IP_CAN_Type := threeGPP_EPS (5) } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_RAT_Type (1032) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_RAT_Type := EUTRAN (1004) } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_QoS_Information (1016) }, VMPxxxxx := '11000000'B, avp_length := 44, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_QoS_Information := { { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_APN_Aggregate_Max_Bitrate_UL (1041) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_APN_Aggregate_Max_Bitrate_UL := '061A8000'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_APN_Aggregate_Max_Bitrate_DL (1040) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_APN_Aggregate_Max_Bitrate_DL := '061A8000'O } } } } } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Default_EPS_Bearer_QoS (1049) }, VMPxxxxx := '10000000'B, avp_length := 88, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Default_EPS_Bearer_QoS := { { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_QoS_Class_Identifier (1028) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_QoS_Class_Identifier := '00000009'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Allocation_Retention_Priority (1034) }, VMPxxxxx := '10000000'B, avp_length := 60, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Allocation_Retention_Priority := { { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Priority_Level (1046) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Priority_Level := '00000009'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Pre_emption_Capability (1047) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Pre_emption_Capability := PRE_EMPTION_CAPABILITY_ENABLED (0) } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Pre_emption_Vulnerability (1048) }, VMPxxxxx := '10000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Pre_emption_Vulnerability := PRE_EMPTION_VULNERABILITY_ENABLED (0) } } } } } } } } } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_GI_3GPP_3GPP_User_Location_Info (22) }, VMPxxxxx := '11000000'B, avp_length := 25, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_GI_3GPP_3GPP_User_Location_Info := '8200F110000100F11000000017'O } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_GI_3GPP_3GPP_SGSN_MCC_MNC (18) }, VMPxxxxx := '11000000'B, avp_length := 17, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_GI_3GPP_3GPP_SGSN_MCC_MNC := '3030313031'O ("00101") } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_AN_GW_Address (1050) }, VMPxxxxx := '10000000'B, avp_length := 18, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_AN_GW_Address := { address_type := IP (1), address_data := '7F0000CA'O } } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_GI_3GPP_3GPP_Charging_Characteristics (13) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_GI_3GPP_3GPP_Charging_Characteristics := '30303030'O ("0000") } } }, { avp := { avp_header := { avp_code := { vendor_id_NONE := avp_code_DNAS_NONE_Called_Station_Id (30) }, VMPxxxxx := '01000000'B, avp_length := 16, vendor_id := omit }, avp_data := { avp_DNAS_NONE_Called_Station_Id := '696E7465726E6574'O ("internet") } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Online (1009) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Online := DISABLE_ONLINE (0) } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Offline (1008) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Offline := ENABLE_OFFLINE (1) } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_RX_3GPP_Access_Network_Charging_Address (501) }, VMPxxxxx := '11000000'B, avp_length := 18, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_RX_3GPP_Access_Network_Charging_Address := { address_type := IP (1), address_data := '7F000004'O } } } }, { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_PCC_3GPP_Access_Network_Charging_Identifier_Gx (1022) }, VMPxxxxx := '11000000'B, avp_length := 28, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_PCC_3GPP_Access_Network_Charging_Identifier_Gx := { { avp := { avp_header := { avp_code := { vendor_id_3GPP := avp_code_RX_3GPP_Access_Network_Charging_Identifier_Value (503) }, VMPxxxxx := '11000000'B, avp_length := 16, vendor_id := vendor_id_3GPP (10415) }, avp_data := { avp_RX_3GPP_Access_Network_Charging_Identifier_Value := '00000001'O } } } } } } } } } handled at TC_createSession_deleteSession(17) TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: PFCP_Emulation main() PFCP.receive: { peer := { conn_id := 1, remote_name := "127.0.0.4", remote_port := 8805 }, pdu := { s_flag := '1'B, mp := '0'B, spare := '000'B, version := 1, message_type := 50, lengthIndicator := 608, seid := '0000000000000000'O, sequence_number := 5, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { pfcp_session_establishment_request := { node_id := { elementIdentifier := 60, lengthIndicator := 5, node_id_type := 0, spare := '0000'B, node_id_value := '7F000004'O }, CP_F_SEID := { elementIdentifier := 57, lengthIndicator := 13, v6 := '0'B, v4 := '1'B, spare := '000000'B, seid := '0000000000000FF8'O, ipv4_address := '7F000004'O, ipv6_address := omit }, create_PDR_list := { { elementIdentifier := 1, lengthIndicator := 74, grouped_ie := { pdr_id := { elementIdentifier := 56, lengthIndicator := 2, rule_id := '0001'O }, precedence := { elementIdentifier := 29, lengthIndicator := 4, precedence_value := 65535 }, pdi := { elementIdentifier := 2, lengthIndicator := 32, grouped_ie := { source_interface := { elementIdentifier := 20, lengthIndicator := 1, interfacevalue := 1, spare := '0000'B }, local_F_TEID := omit, pdn_instance := { elementIdentifier := 22, lengthIndicator := 9, pdn_instance := '08696E7465726E6574'O ("\binternet") }, ue_ip_address := { elementIdentifier := 93, lengthIndicator := 5, v6 := '0'B, v4 := '1'B, sd := '1'B, spare := '00000'B, ipv4_address := '0A2D0002'O, ipv6_address := omit }, traffic_endpoint_id := omit, sdf_filter_list := omit, application_id := omit, ethernet_packet_filter_list := omit, qfi_list := omit, source_interface_type := { elementIdentifier := 160, lengthIndicator := 1, interfacetypevalue := 17, spare := '00'B } } }, outer_header_removal := omit, fAR_ID_list := { { elementIdentifier := 108, lengthIndicator := 4, id_value := 1 } }, uRR_ID_list := { { elementIdentifier := 81, lengthIndicator := 4, id_value := 1 } }, qER_ID_list := { { elementIdentifier := 109, lengthIndicator := 4, id_value := 1 } }, activate_predefined_rules := omit } }, { elementIdentifier := 1, lengthIndicator := 85, grouped_ie := { pdr_id := { elementIdentifier := 56, lengthIndicator := 2, rule_id := '0002'O }, precedence := { elementIdentifier := 29, lengthIndicator := 4, precedence_value := 65535 }, pdi := { elementIdentifier := 2, lengthIndicator := 38, grouped_ie := { source_interface := { elementIdentifier := 20, lengthIndicator := 1, interfacevalue := 0, spare := '0000'B }, local_F_TEID := { elementIdentifier := 21, lengthIndicator := 2, v4 := '1'B, v6 := '1'B, ch := '1'B, chid := '1'B, spare := '0000'B, teid := omit, ipv4_address := omit, ipv6_address := omit, choose_id := '05'O }, pdn_instance := { elementIdentifier := 22, lengthIndicator := 9, pdn_instance := '08696E7465726E6574'O ("\binternet") }, ue_ip_address := { elementIdentifier := 93, lengthIndicator := 5, v6 := '0'B, v4 := '1'B, sd := '0'B, spare := '00000'B, ipv4_address := '0A2D0002'O, ipv6_address := omit }, traffic_endpoint_id := omit, sdf_filter_list := omit, application_id := omit, ethernet_packet_filter_list := omit, qfi_list := omit, source_interface_type := { elementIdentifier := 160, lengthIndicator := 1, interfacetypevalue := 11, spare := '00'B } } }, outer_header_removal := { elementIdentifier := 95, lengthIndicator := 1, ohc_description := 6 }, fAR_ID_list := { { elementIdentifier := 108, lengthIndicator := 4, id_value := 2 } }, uRR_ID_list := { { elementIdentifier := 81, lengthIndicator := 4, id_value := 1 } }, qER_ID_list := { { elementIdentifier := 109, lengthIndicator := 4, id_value := 1 } }, activate_predefined_rules := omit } }, { elementIdentifier := 1, lengthIndicator := 41, grouped_ie := { pdr_id := { elementIdentifier := 56, lengthIndicator := 2, rule_id := '0003'O }, precedence := { elementIdentifier := 29, lengthIndicator := 4, precedence_value := 255 }, pdi := { elementIdentifier := 2, lengthIndicator := 10, grouped_ie := { source_interface := { elementIdentifier := 20, lengthIndicator := 1, interfacevalue := 3, spare := '0000'B }, local_F_TEID := { elementIdentifier := 21, lengthIndicator := 1, v4 := '1'B, v6 := '1'B, ch := '1'B, chid := '0'B, spare := '0000'B, teid := omit, ipv4_address := omit, ipv6_address := omit, choose_id := omit }, pdn_instance := omit, ue_ip_address := omit, traffic_endpoint_id := omit, sdf_filter_list := omit, application_id := omit, ethernet_packet_filter_list := omit, qfi_list := omit, source_interface_type := omit } }, outer_header_removal := { elementIdentifier := 95, lengthIndicator := 1, ohc_description := 6 }, fAR_ID_list := { { elementIdentifier := 108, lengthIndicator := 4, id_value := 1 } }, uRR_ID_list := omit, qER_ID_list := omit, activate_predefined_rules := omit } }, { elementIdentifier := 1, lengthIndicator := 110, grouped_ie := { pdr_id := { elementIdentifier := 56, lengthIndicator := 2, rule_id := '0004'O }, precedence := { elementIdentifier := 29, lengthIndicator := 4, precedence_value := 255 }, pdi := { elementIdentifier := 2, lengthIndicator := 79, grouped_ie := { source_interface := { elementIdentifier := 20, lengthIndicator := 1, interfacevalue := 0, spare := '0000'B }, local_F_TEID := { elementIdentifier := 21, lengthIndicator := 2, v4 := '1'B, v6 := '1'B, ch := '1'B, chid := '1'B, spare := '0000'B, teid := omit, ipv4_address := omit, ipv6_address := omit, choose_id := '05'O }, pdn_instance := { elementIdentifier := 22, lengthIndicator := 9, pdn_instance := '08696E7465726E6574'O ("\binternet") }, ue_ip_address := omit, traffic_endpoint_id := omit, sdf_filter_list := { { elementIdentifier := 23, lengthIndicator := 46, fd := '1'B, ttc := '0'B, spi := '0'B, fl := '0'B, bid := '0'B, spare := '00000000000'B, lengthFlowDesc := 42, flow_description := '7065726D6974206F75742035382066726F6D20666630323A3A322F31323820746F2061737369676E6564'O ("permit out 58 from ff02::2/128 to assigned"), ToS_Traffic_Class := omit, security_parameter_index := omit, flow_label := omit, SDF_filter_id := omit } }, application_id := omit, ethernet_packet_filter_list := omit, qfi_list := omit, source_interface_type := { elementIdentifier := 160, lengthIndicator := 1, interfacetypevalue := 11, spare := '00'B } } }, outer_header_removal := { elementIdentifier := 95, lengthIndicator := 1, ohc_description := 6 }, fAR_ID_list := { { elementIdentifier := 108, lengthIndicator := 4, id_value := 3 } }, uRR_ID_list := omit, qER_ID_list := omit, activate_predefined_rules := omit } } }, create_FAR_list := { { elementIdentifier := 3, lengthIndicator := 55, grouped_ie := { far_id := { elementIdentifier := 108, lengthIndicator := 4, id_value := 1 }, apply_action := { elementIdentifier := 44, lengthIndicator := 2, drop := '0'B, forw := '1'B, buff := '0'B, nocp := '0'B, dupl := '0'B, ipma := '0'B, ipmd := '0'B, dfrt := '0'B, edrt := '0'B, bdpn := '0'B, ddpn := '0'B, fssm := '0'B, mbsu := '0'B, spare := '000'B }, forwarding_parameters := { elementIdentifier := 4, lengthIndicator := 37, grouped_ie := { destination_interface := { elementIdentifier := 42, lengthIndicator := 1, interface_value := 0, spare := '0000'B }, pdn_Instance := { elementIdentifier := 22, lengthIndicator := 9, pdn_instance := '08696E7465726E6574'O ("\binternet") }, redirect_information := omit, outer_header_creation := { elementIdentifier := 84, lengthIndicator := 10, ohc_description_oct5 := '00000001'B, ohc_description_oct6 := '00000000'B, teid := '2D95F3A5'O, ipv4 := '7F000014'O, ipv6 := omit, udp_port := omit }, transport_level_marking := omit, forwarding_policy := omit, header_enrichment := omit, traffic_endpoint_ID := omit, destination_interface_type := { elementIdentifier := 160, lengthIndicator := 1, interfacetypevalue := 11, spare := '00'B } } }, duplicating_parameters := omit, bar_id := omit } }, { elementIdentifier := 3, lengthIndicator := 41, grouped_ie := { far_id := { elementIdentifier := 108, lengthIndicator := 4, id_value := 2 }, apply_action := { elementIdentifier := 44, lengthIndicator := 2, drop := '0'B, forw := '1'B, buff := '0'B, nocp := '0'B, dupl := '0'B, ipma := '0'B, ipmd := '0'B, dfrt := '0'B, edrt := '0'B, bdpn := '0'B, ddpn := '0'B, fssm := '0'B, mbsu := '0'B, spare := '000'B }, forwarding_parameters := { elementIdentifier := 4, lengthIndicator := 23, grouped_ie := { destination_interface := { elementIdentifier := 42, lengthIndicator := 1, interface_value := 1, spare := '0000'B }, pdn_Instance := { elementIdentifier := 22, lengthIndicator := 9, pdn_instance := '08696E7465726E6574'O ("\binternet") }, redirect_information := omit, outer_header_creation := omit, transport_level_marking := omit, forwarding_policy := omit, header_enrichment := omit, traffic_endpoint_ID := omit, destination_interface_type := { elementIdentifier := 160, lengthIndicator := 1, interfacetypevalue := 17, spare := '00'B } } }, duplicating_parameters := omit, bar_id := omit } }, { elementIdentifier := 3, lengthIndicator := 37, grouped_ie := { far_id := { elementIdentifier := 108, lengthIndicator := 4, id_value := 3 }, apply_action := { elementIdentifier := 44, lengthIndicator := 2, drop := '0'B, forw := '1'B, buff := '0'B, nocp := '0'B, dupl := '0'B, ipma := '0'B, ipmd := '0'B, dfrt := '0'B, edrt := '0'B, bdpn := '0'B, ddpn := '0'B, fssm := '0'B, mbsu := '0'B, spare := '000'B }, forwarding_parameters := { elementIdentifier := 4, lengthIndicator := 19, grouped_ie := { destination_interface := { elementIdentifier := 42, lengthIndicator := 1, interface_value := 3, spare := '0000'B }, pdn_Instance := omit, redirect_information := omit, outer_header_creation := { elementIdentifier := 84, lengthIndicator := 10, ohc_description_oct5 := '00000001'B, ohc_description_oct6 := '00000000'B, teid := '00000001'O, ipv4 := '7F000004'O, ipv6 := omit, udp_port := omit }, transport_level_marking := omit, forwarding_policy := omit, header_enrichment := omit, traffic_endpoint_ID := omit, destination_interface_type := omit } }, duplicating_parameters := omit, bar_id := omit } } }, create_URR_list := { { elementIdentifier := 6, lengthIndicator := 20, grouped_ie := { urr_id := { elementIdentifier := 81, lengthIndicator := 4, id_value := 1 }, measurement_method := { elementIdentifier := 62, lengthIndicator := 1, durat := '0'B, volum := '0'B, event := '0'B, spare := '00000'B }, reporting_triggers := { elementIdentifier := 37, lengthIndicator := 3, perio := '0'B, volth := '0'B, timth := '0'B, quhti := '0'B, start_ := '0'B, stop_ := '0'B, droth := '0'B, liusa := '0'B, volqu := '0'B, timqu := '0'B, envcl := '0'B, macar := '0'B, eveth := '0'B, evequ := '0'B, ipmjl := '0'B, quvti := '0'B, upint := '0'B, reemr := '0'B, spare := '000000'B }, measurement_period := omit, volume_threshold := omit, volume_quota := omit, time_threshold := omit, time_quota := omit, quota_holding_time := omit, dropped_dl_traffic_threshold := omit, quota_validity_time := omit, monitoring_time := omit, subsequent_volume_threshold := omit, subsequent_time_threshold := omit, subsequent_volume_quota := omit, subsequent_time_quota := omit, inactivity_detection_time := omit, linked_urr_id := omit, measurement_information := omit, time_qouta_mechanism := omit, aggregated_urrs := omit } } }, create_QER_list := { { elementIdentifier := 7, lengthIndicator := 27, grouped_ie := { qer_id := { elementIdentifier := 109, lengthIndicator := 4, id_value := 1 }, qer_correlation_id := omit, gate_status := { elementIdentifier := 25, lengthIndicator := 1, dl_gate := 0, ul_gate := 0, spare := '0000'B }, mbr := { elementIdentifier := 26, lengthIndicator := 10, ul_mbr := '0000008313'O, dl_mbr := '000000CCCD'O }, gbr := omit, packet_rate := omit, dl_transport_level_marking := omit, qfi := omit, rqi := omit } } }, create_BAR := { elementIdentifier := 85, lengthIndicator := 5, grouped_ie := { bar_id := { elementIdentifier := 88, lengthIndicator := 1, id_value := '01'O }, downlink_data_notification_delay := omit } }, create_traffic_endpoint_list := omit, pdn_type := { elementIdentifier := 113, lengthIndicator := 1, pdn_type := 1, spare := '00000'B }, node_list := omit, up_inactivity_timer := omit, user_id := { elementIdentifier := 141, lengthIndicator := 13, imsif := '1'B, imeif := '0'B, msisdnf := '1'B, naif := '0'B, supif := '0'B, gpsif := '0'B, peif := '0'B, spare := '0'B, imsi_length := 8, imsi := '00010121436587F9'O, imei_length := omit, imei := omit, msisdn_length := 2, msisdn := '2143'O ("!C"), nai_length := omit, nai := omit, supi_length := omit, supi := omit, gpsi_length := omit, gpsi := omit, pei_length := omit, pei := omit }, apn_dnn := { elementIdentifier := 159, lengthIndicator := 9, apn_dnn := '08696E7465726E6574'O ("\binternet") } } } } } TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: found destination TC_createSession_deleteSession(17) TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: PFCP_Emulation main() CLIENT.receive from TC_createSession_deleteSession(17): { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 0, lengthIndicator := 0, seid := '0000000000000FF8'O, sequence_number := 5, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { pfcp_session_establishment_response := { node_id := { elementIdentifier := 60, lengthIndicator := 0, node_id_type := 0, spare := '0000'B, node_id_value := '7F000007'O }, cause := { elementIdentifier := 19, lengthIndicator := 0, causeValue := '01'O }, offending_ie := omit, UP_F_SEID := { elementIdentifier := 57, lengthIndicator := 0, v6 := '0'B, v4 := '1'B, spare := '000000'B, seid := '0000000000000001'O, ipv4_address := '7F000007'O, ipv6_address := omit }, created_PDR_list := { { elementIdentifier := 8, lengthIndicator := 0, grouped_ie := { pdr_id := { elementIdentifier := 56, lengthIndicator := 2, rule_id := '0001'O }, local_F_TEID := { elementIdentifier := 21, lengthIndicator := 0, v4 := '1'B, v6 := '0'B, ch := '0'B, chid := '0'B, spare := '0000'B, teid := '00002001'O, ipv4_address := '7F000007'O, ipv6_address := omit, choose_id := omit } } }, { elementIdentifier := 8, lengthIndicator := 0, grouped_ie := { pdr_id := { elementIdentifier := 56, lengthIndicator := 2, rule_id := '0002'O }, local_F_TEID := { elementIdentifier := 21, lengthIndicator := 0, v4 := '1'B, v6 := '0'B, ch := '0'B, chid := '0'B, spare := '0000'B, teid := '00000001'O, ipv4_address := '7F000007'O, ipv6_address := omit, choose_id := omit } } }, { elementIdentifier := 8, lengthIndicator := 0, grouped_ie := { pdr_id := { elementIdentifier := 56, lengthIndicator := 2, rule_id := '0003'O }, local_F_TEID := { elementIdentifier := 21, lengthIndicator := 0, v4 := '1'B, v6 := '0'B, ch := '0'B, chid := '0'B, spare := '0000'B, teid := '00002001'O, ipv4_address := '7F000007'O, ipv6_address := omit, choose_id := omit } } }, { elementIdentifier := 8, lengthIndicator := 0, grouped_ie := { pdr_id := { elementIdentifier := 56, lengthIndicator := 2, rule_id := '0004'O }, local_F_TEID := { elementIdentifier := 21, lengthIndicator := 0, v4 := '1'B, v6 := '0'B, ch := '0'B, chid := '0'B, spare := '0000'B, teid := '00000001'O, ipv4_address := '7F000007'O, ipv6_address := omit, choose_id := omit } } } }, load_control_information := omit, overload_control_information := omit, node_list := omit, failed_rule_id := omit, created_traffic_endpoint_list := omit } } } [32m08/31 13:08:42.081[0m: [[33mgtp[0m] [1;32mINFO[0m: gtp_connect() [127.0.0.7]:2152 (../lib/gtp/path.c:60) TC_createSession_deleteSession(17)@29c9d80cf285: f_Mutex_unlock(): mutex released @ "SMF_Session_CT.ttcn":427 TC_createSession_deleteSession(17)@29c9d80cf285: SMF assigned UE IPv4 address: "10.45.0.2" TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: PFCP_Emulation main() PFCP.receive: { peer := { conn_id := 1, remote_name := "127.0.0.4", remote_port := 8805 }, pdu := { s_flag := '1'B, mp := '0'B, spare := '000'B, version := 1, message_type := 54, lengthIndicator := 12, seid := '0000000000000001'O, sequence_number := 6, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { pfcp_session_deletion_request := { } } } } TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: found destination TC_createSession_deleteSession(17) TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: PFCP_Emulation main() CLIENT.receive from TC_createSession_deleteSession(17): { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 0, lengthIndicator := 0, seid := '0000000000000FF8'O, sequence_number := 6, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { pfcp_session_deletion_response := { cause := { elementIdentifier := 19, lengthIndicator := 0, causeValue := '01'O }, offending_IE := omit, load_control_information := omit, overload_control_information := omit, usage_report := { { elementIdentifier := 79, lengthIndicator := 0, grouped_ie := { urr_id := { elementIdentifier := 81, lengthIndicator := 4, id_value := 1 }, ur_seqn := { elementIdentifier := 104, lengthIndicator := 0, ur_seqn := 0 }, usage_report_trigger := { elementIdentifier := 63, lengthIndicator := 0, perio := '0'B, volth := '0'B, timth := '0'B, quhti := '0'B, start_ := '0'B, stop_ := '0'B, droth := '0'B, immer := '0'B, volqu := '0'B, timqu := '0'B, liusa := '0'B, termr := '1'B, monit := '0'B, envcl := '0'B, macar := '0'B, eveth := '0'B, evequ := '0'B, tebur := '0'B, ipmjl := '0'B, quvti := '0'B, emrre := '0'B, upint := '0'B, spare7_7 := '0'B, spare7_8 := '0'B }, start_time := { elementIdentifier := 75, lengthIndicator := 0, start_time := 'EE3FFB5A'O }, end_time := { elementIdentifier := 76, lengthIndicator := 0, end_time := 'EE3FFB5A'O }, volume_measurement := omit, duration_measurement := omit, time_of_first_packet := omit, time_of_last_packet := omit, usage_information := omit } } } } } } Segmentation fault (core dumped) [1;34m[testenv] Looking for a coredump file[0m [0;94m[testenv] + ['file', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…'][0m> [0;94m[testenv] Coredump file and execfn found[0m [1;91m[testenv] smf unexpected exit during SMF_Tests.TC_createSession_deleteSession! rc=0[0m [0;94m[testenv] Waiting until test has stopped...[0m MTC@29c9d80cf285: setverdict(fail): pass -> fail reason: "Timeout of T_guard", new component reason: "Timeout of T_guard" MutexDispCT-TC_createSession_deleteSession(12)@29c9d80cf285: Final verdict of PTC: none TC_createSession_deleteSession(17)@29c9d80cf285: Final verdict of PTC: none GTP1U_EM(11)@29c9d80cf285: Final verdict of PTC: none TC_createSession_deleteSession(15)@29c9d80cf285: Final verdict of PTC: none TC_createSession_deleteSession(14)@29c9d80cf285: Final verdict of PTC: none TC_createSession_deleteSession(16)@29c9d80cf285: Final verdict of PTC: none TC_createSession_deleteSession-PFCP(13)@29c9d80cf285: Final verdict of PTC: none GTP2C_EM(10)@29c9d80cf285: Final verdict of PTC: none MTC@29c9d80cf285: Setting final verdict of the test case. MTC@29c9d80cf285: Local verdict of MTC: fail reason: "Timeout of T_guard" MTC@29c9d80cf285: Local verdict of PTC GTP2C_EM(10): none (fail -> fail) MTC@29c9d80cf285: Local verdict of PTC GTP1U_EM(11): none (fail -> fail) MTC@29c9d80cf285: Local verdict of PTC MutexDispCT-TC_createSession_deleteSession(12): none (fail -> fail) MTC@29c9d80cf285: Local verdict of PTC TC_createSession_deleteSession-PFCP(13): none (fail -> fail) MTC@29c9d80cf285: Local verdict of PTC TC_createSession_deleteSession(14): none (fail -> fail) MTC@29c9d80cf285: Local verdict of PTC TC_createSession_deleteSession(15): none (fail -> fail) MTC@29c9d80cf285: Local verdict of PTC TC_createSession_deleteSession(16): none (fail -> fail) MTC@29c9d80cf285: Local verdict of PTC TC_createSession_deleteSession(17): none (fail -> fail) MTC@29c9d80cf285: Test case TC_createSession_deleteSession finished. Verdict: fail reason: Timeout of T_guard MTC@29c9d80cf285: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_createSession_deleteSession fail'. (13:09:37) load average: 1.52, 0.91, 0.84 [1;31m------ SMF_Tests.TC_createSession_deleteSession fail ------[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=21240) MTC@29c9d80cf285: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_createSession_deleteSession fail' was executed successfully (exit status: 0). MTC@29c9d80cf285: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_deleteSession_unknown'. ------ SMF_Tests.TC_deleteSession_unknown ------ (13:09:38) load average: 1.52, 0.91, 0.84 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@29c9d80cf285: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_deleteSession_unknown' was executed successfully (exit status: 0). MTC@29c9d80cf285: Test case TC_deleteSession_unknown started. TC_deleteSession_unknown-PFCP(21)@29c9d80cf285: f_PFCPEM_conns_bcast_add(): vc_conn mtc subscribed for broadcast TC_deleteSession_unknown-PFCP(21)@29c9d80cf285: PFCP_Emulation main() CLIENT.receive from mtc: { s_flag := '0'B, mp := '0'B, spare := '000'B, version := 1, message_type := 0, lengthIndicator := 0, seid := omit, sequence_number := 0, spare2 := '0000'B, mp_or_spare := '0000'B, message_body := { heartbeat_request := { recovery_time_stamp := { elementIdentifier := 96, lengthIndicator := 0, time_value := 3997170580 } } } } MTC@29c9d80cf285: setverdict(fail): none -> fail reason: ""PFCP_Emulation.ttcn:504 : Timeout waiting for PFCP { s_flag := ?, mp := ?, spare := ?, version := 1, message_type := ?, lengthIndicator := ?, seid := *, sequence_number := ?, spare2 := ?, mp_or_spare := ?, message_body := { pfcp_association_setup_request := { node_id := ?, time_stamp := ?, up_function_features := *, cp_function_features := *, UP_IP_resource_list := * } } }"", new component reason: ""PFCP_Emulation.ttcn:504 : Timeout waiting for PFCP { s_flag := ?, mp := ?, spare := ?, version := 1, message_type := ?, lengthIndicator := ?, seid := *, sequence_number := ?, spare2 := ?, mp_or_spare := ?, message_body := { pfcp_association_setup_request := { node_id := ?, time_stamp := ?, up_function_features := *, cp_function_features := *, UP_IP_resource_list := * } } }"" MTC@29c9d80cf285: Stopping testcase execution from "PFCP_Emulation.ttcn":504 GTP1U_EM(19)@29c9d80cf285: Final verdict of PTC: none GTP2C_EM(18)@29c9d80cf285: Final verdict of PTC: none MutexDispCT-TC_deleteSession_unknown(20)@29c9d80cf285: Final verdict of PTC: none TC_deleteSession_unknown-PFCP(21)@29c9d80cf285: Final verdict of PTC: none MTC@29c9d80cf285: Setting final verdict of the test case. MTC@29c9d80cf285: Local verdict of MTC: fail reason: ""PFCP_Emulation.ttcn:504 : Timeout waiting for PFCP { s_flag := ?, mp := ?, spare := ?, version := 1, message_type := ?, lengthIndicator := ?, seid := *, sequence_number := ?, spare2 := ?, mp_or_spare := ?, message_body := { pfcp_association_setup_request := { node_id := ?, time_stamp := ?, up_function_features := *, cp_function_features := *, UP_IP_resource_list := * } } }"" MTC@29c9d80cf285: Local verdict of PTC GTP2C_EM(18): none (fail -> fail) MTC@29c9d80cf285: Local verdict of PTC GTP1U_EM(19): none (fail -> fail) MTC@29c9d80cf285: Local verdict of PTC MutexDispCT-TC_deleteSession_unknown(20): none (fail -> fail) MTC@29c9d80cf285: Local verdict of PTC TC_deleteSession_unknown-PFCP(21): none (fail -> fail) MTC@29c9d80cf285: Test case TC_deleteSession_unknown finished. Verdict: fail reason: "PFCP_Emulation.ttcn:504 : Timeout waiting for PFCP { s_flag := ?, mp := ?, spare := ?, version := 1, message_type := ?, lengthIndicator := ?, seid := *, sequence_number := ?, spare2 := ?, mp_or_spare := ?, message_body := { pfcp_association_setup_request := { node_id := ?, time_stamp := ?, up_function_features := *, cp_function_features := *, UP_IP_resource_list := * } } }" MTC@29c9d80cf285: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_deleteSession_unknown fail'. (13:09:56) load average: 1.33, 0.90, 0.84 [1;31m------ SMF_Tests.TC_deleteSession_unknown fail ------[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=1736) MTC@29c9d80cf285: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_deleteSession_unknown fail' was executed successfully (exit status: 0). MTC@29c9d80cf285: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/ttcn3-…> SMF_Tests.TC_gy_ccr_update_rejected'. ------ SMF_Tests.TC_gy_ccr_update_rejected ------ (13:09:57) load average: 1.23, 0.89, 0.83 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 [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-smf-test-ogs-latest/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-smf-test-ogs-latest/ws/_teste…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/_teste…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/ws/smf>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-smf-osmocom-latest-20260831-1308-5a804244-1', 'sh', '-c', 'echo; gdb --batch /usr/bin/open5gs-smfd <https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…> -ex bt | tee <https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…;> echo'][0m [New LWP 209] [New LWP 185] [New LWP 188] [New LWP 186] [New LWP 193] [New LWP 194] [New LWP 195] [New LWP 197] [New LWP 198] [New LWP 200] [New LWP 199] [New LWP 184] [New LWP 189] [New LWP 187] [New LWP 191] [New LWP 201] [New LWP 190] [New LWP 192] [New LWP 196] [New LWP 182] [New LWP 348] [New LWP 205] [New LWP 202] [New LWP 208] [New LWP 203] [New LWP 358] [New LWP 353] [New LWP 204] [New LWP 357] [New LWP 207] [New LWP 206] [New LWP 352] [New LWP 349] [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-smfd -c open5gs-smf.yaml'. Program terminated with signal SIGSEGV, Segmentation fault. #0 0x00007fede2c86f69 in ogs_pfcp_parse_volume_measurement (volume=volume@entry=0x7fed80ff69b0, warning: 591 ../lib/pfcp/types.c: No such file or directory octet=octet@entry=0x7fed5400c7d0) at ../lib/pfcp/types.c:591 [Current thread is 1 (Thread 0x7fed80ff96c0 (LWP 209))] #0 0x00007fede2c86f69 in ogs_pfcp_parse_volume_measurement (volume=volume@entry=0x7fed80ff69b0, octet=octet@entry=0x7fed5400c7d0) at ../lib/pfcp/types.c:591 #1 0x000055be55802886 in smf_epc_n4_handle_session_deletion_response (sess=sess@entry=0x7fedcb7a3010, xact=xact@entry=0x7fedcaf3e748, rsp=rsp@entry=0x7fed5400c6b8) at ../src/smf/n4-handler.c:1548 #2 0x000055be557d4738 in smf_gsm_state_wait_pfcp_deletion (s=s@entry=0x7fedcb7a3850, e=e@entry=0x7fed9c000e30) at ../src/smf/gsm-sm.c:2313 #3 0x00007fede3863e24 in ogs_fsm_dispatch (fsm=0x7fedcb7a3850, event=0x7fed9c000e30) at ../lib/core/ogs-fsm.c:127 #4 0x00007fede3863e24 in ogs_fsm_dispatch (fsm=0x55be5d830258, event=0x7fed9c000e30) at ../lib/core/ogs-fsm.c:127 #5 0x000055be557c9dc6 in smf_state_operational (s=s@entry=0x7fed80ff8c20, e=e@entry=0x7fed9c000e30) at ../src/smf/smf-sm.c:441 #6 0x00007fede3863e24 in ogs_fsm_dispatch (fsm=0x7fed80ff8c20, event=0x7fed9c000e30) at ../lib/core/ogs-fsm.c:127 #7 0x000055be557bb859 in smf_main (data=<optimized out>) at ../src/smf/init.c:194 #8 0x00007fede3859005 in thread_worker (arg=0x55be5da6b190) at ../lib/core/ogs-thread.c:67 #9 0x00007fede25beb7b in start_thread (arg=<optimized out>) at ./nptl/pthread_create.c:448 #10 0x00007fede263c7f8 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-smf-osmocom-latest-20260831-1308-5a804244-1'][0m testenv-smf-osmocom-latest-20260831-1308-5a804244-1 <https://jenkins.osmocom.org/jenkins/job/ttcn3-smf-test-ogs-latest/1/artifac…>: ELF 64-bit LSB core file, x86-64, version 1 (SYSV), SVR4-style, from 'open5gs-smfd -c open5gs-smf.yaml', real uid: 0, effective uid: 0, real gid: 0, effective gid: 0, execfn: '/usr/bin/open5gs-smfd', platform: 'x86_64' [1;34m[testenv] Stopping testsuite (1851773)[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-smf-test-ogs-latest/1/artifac… [0m + RC=1 + [ 1 = 0 ] + + grep --color=always -o load.* uptime [01;31m[Kload average: 1.23, 0.89, 0.83[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.

1 8

Build failed in Jenkins: ttcn3-bts-test-io_uring #849
by jenkins＠lists.osmocom.org 08 Sep '26

08 Sep '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-io_uring/849/display…> Changes: ------------------------------------------ [...truncated 12.58 MiB...] <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" BTS_Tests.ttcn:9557 BTS_Tests control part BTS_Tests.ttcn:7525 TC_rll_rel_req testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_req_DCCH' time='2.342918'/> <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_req_ACCH' time='5.292034'/> <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_ind_DCCH' time='2.918450'/> <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_ind_ACCH' time='11.511367'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a51' time='2.650276'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a52' time='2.699148'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a53' time='2.710186'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a54' time='2.717119'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a51' time='5.242888'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a52' time='5.208244'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a53' time='5.206919'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a54' time='5.215719'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_mdisc' time='1.208878'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_msg_type' time='1.305426'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_sequence' time='1.268411'/> <testcase classname='BTS_Tests:hopping' name='TC_lapdm_selftest' time='0.005557'/> <testcase classname='BTS_Tests:hopping' name='TC_tch_sign_l2_fill_frame' time='18.463654'/> <testcase classname='BTS_Tests:hopping' name='TC_tch_sign_l2_fill_frame_dtxd' time='2.106338'> <failure type='fail-verdict'>Received DTX TCH fill frame with bad frame number: 175 (mod 104: 71) (mod 26: 19) BTS_Tests.ttcn:9579 BTS_Tests control part BTS_Tests.ttcn:8110 TC_tch_sign_l2_fill_frame_dtxd testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_chopped_ipa_ping' time='24.694319'/> <testcase classname='BTS_Tests:hopping' name='TC_chopped_ipa_payload' time='42.615309'/> <testcase classname='BTS_Tests:hopping' name='TC_ms_pwr_ctrl_constant' time='16.897724'/> <testcase classname='BTS_Tests:hopping' name='TC_ms_pwr_ctrl_pf_ewma' time='31.998358'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_no_rtp_tchf' time='7.438991'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_no_rtp_tchh' time='5.462630'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_rtp_tchf' time='7.706848'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_rtp_tchh' time='5.481234'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_osmux_tchf' time='3.453746'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_osmux_tchh' time='3.502667'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf144' time='2.094024'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf96' time='2.142364'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf48' time='2.200510'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchh48' time='5.307154'> <failure type='fail-verdict'>Timeout waiting for matching Downlink data frame BTS_Tests.ttcn:9597 BTS_Tests control part BTS_Tests.ttcn:8880 TC_data_rtp_tchh48 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf24' time='1.783627'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchh24' time='5.307066'> <failure type='fail-verdict'>Timeout waiting for matching Downlink data frame BTS_Tests.ttcn:9599 BTS_Tests control part BTS_Tests.ttcn:8949 TC_data_rtp_tchh24 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf144' time='2.083183'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf96' time='2.027918'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf48' time='1.985915'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchh48' time='2.128729'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf24' time='2.025097'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchh24' time='2.166861'/> <testcase classname='BTS_Tests:hopping' name='TC_early_immediate_assignment' time='3.545980'/> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_rxqual_thresh' time='9.086858'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9610 BTS_Tests control part BTS_Tests.ttcn:9244 TC_acch_overpower_rxqual_thresh testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_rxqual_thresh_dtx' time='9.043845'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9611 BTS_Tests control part BTS_Tests.ttcn:9285 TC_acch_overpower_rxqual_thresh_dtx testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_always_on_facch' time='9.020579'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9612 BTS_Tests control part BTS_Tests.ttcn:9317 TC_acch_overpower_always_on_facch testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_always_on_sacch' time='9.030794'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9613 BTS_Tests control part BTS_Tests.ttcn:9349 TC_acch_overpower_always_on_sacch testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_limit' time='9.025674'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9614 BTS_Tests control part BTS_Tests.ttcn:9380 TC_acch_overpower_limit testcase </failure> </testcase> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbch_load_idle_no_cbch' time='11.163746'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_1block' time='14.242062'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_2block' time='14.189691'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_3block' time='14.203221'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_4block' time='14.198932'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_multi' time='20.199785'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_schedule' time='14.138432'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_only' time='16.197110'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_and_normal' time='17.193498'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_then_null' time='26.213650'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch4_load_idle' time='16.062186'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch4_load_overload' time='18.174633'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_1block' time='14.207873'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_2block' time='14.223714'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_3block' time='14.207990'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_4block' time='14.205683'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_multi' time='20.227691'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_schedule' time='14.166550'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_default_only' time='16.237712'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_default_and_normal' time='17.205582'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch8_load_idle' time='16.147247'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch8_load_overload' time='18.250367'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_p1ro' time='12.195901'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_p1ro_end' time='16.143973'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_pcu' time='1.085141'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi0' time='2.909533'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi0_nopayload' time='21.563093'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi3' time='21.273371'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi4' time='21.339864'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_contention' time='21.289912'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_retransmit' time='3.163055'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_retransmit_bts' time='81.460943'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_invalid_resp' time='23.348972'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_dm' time='14.000164'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_establish_ign_first_sabm' time='7.947384'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_iframe_seq_and_ack' time='29.568167'> <failure type='fail-verdict'>Received RSL ERROR IND { msg_disc := { msg_group := RSL_MDISC_RLL (1), transparent := false }, msg_type := RSL_MT_ERROR_IND (3), ies := { { iei := RSL_IE_CHAN_NR (1), body := { chan_nr := { u := { sdcch8 := { tag := '01'B, sub_chan := 4 } }, tn := 6 } } }, { iei := RSL_IE_LINK_IDENT (2), body := { link_id := { c := FACCH_SDCCH (0), na := false, prio := SAPI0_PRIO_NORMAL (0), sapi := 0 } } }, { iei := RSL_IE_RLM_CAUSE (22), body := { rlm_cause := { len := 1, payload := '01'O } } } } } BTS_Tests_LAPDm.ttcn:1484 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:579 TC_iframe_seq_and_ack testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_iframe_timer_recovery' time='24.616309'> <failure type='fail-verdict'>Received RSL ERROR IND { msg_disc := { msg_group := RSL_MDISC_RLL (1), transparent := false }, msg_type := RSL_MT_ERROR_IND (3), ies := { { iei := RSL_IE_CHAN_NR (1), body := { chan_nr := { u := { sdcch8 := { tag := '01'B, sub_chan := 4 } }, tn := 6 } } }, { iei := RSL_IE_LINK_IDENT (2), body := { link_id := { c := FACCH_SDCCH (0), na := false, prio := SAPI0_PRIO_NORMAL (0), sapi := 0 } } }, { iei := RSL_IE_RLM_CAUSE (22), body := { rlm_cause := { len := 1, payload := '01'O } } } } } BTS_Tests_LAPDm.ttcn:1485 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:685 TC_iframe_timer_recovery testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_ns_seq_error' time='29.603420'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" BTS_Tests_LAPDm.ttcn:1486 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:768 TC_ns_seq_error testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_nr_seq_error' time='2.901309'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_rec_invalid_frame' time='119.108605'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:909 : Missing LAPDm_RR RSP" BTS_Tests_LAPDm.ttcn:1488 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:961 TC_rec_invalid_frame testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_segm_concat_dcch' time='13.548481'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { s := { n_r := 1, p_f := false, s := '10'B, spare := '01'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++++\") } } }" BTS_Tests_LAPDm.ttcn:1489 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1088 TC_segm_concat_dcch testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_segm_concat_sacch' time='48.518003'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := true, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { u := { u := '011'B, p_f := true, u2 := '00'B, spare := '11'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++\") } } }" BTS_Tests_LAPDm.ttcn:1490 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1093 TC_segm_concat_sacch testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_t200_n200' time='39.841267'> <failure type='fail-verdict'>Missing RSL RLL ERROR INDICATION BTS_Tests_LAPDm.ttcn:1491 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1182 TC_t200_n200 testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_rr_response_frame_loss' time='6.683598'> <failure type='fail-verdict'>Timeout waiting for RR or REJ BTS_Tests_LAPDm.ttcn:1492 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1239 TC_rr_response_frame_loss testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_incorrect_cr' time='15.825487'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_incorrect_c' time='23.302386'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" BTS_Tests_LAPDm.ttcn:1494 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1341 TC_sabm_incorrect_c testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_normal_reestablishment' time='16.132537'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { u := { u := '011'B, p_f := true, u2 := '00'B, spare := '11'B } }, len := 5, m := false, el := 1, payload := '384B4BA0DD'O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"+++++++++++++++\") } } }" BTS_Tests_LAPDm.ttcn:1495 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1403 TC_normal_reestablishment testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_normal_reestablishment_state_unacked' time='12.408751'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { s := { n_r := 1, p_f := false, s := '10'B, spare := '01'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++++\") } } }" BTS_Tests_LAPDm.ttcn:1496 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:1470 TC_normal_reestablishment_state_unacked testcase </failure> </testcase> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_vff' time='2.473522'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_vhh' time='2.587559'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_hvhh' time='2.549683'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_ipa_vff' time='2.542742'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vff' time='2.528251'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vhh' time='2.577991'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_hvhh' time='2.566651'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vff' time='1.303282'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vhh' time='1.375615'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_hvhh' time='1.325253'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_ipa_vff' time='1.340647'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vff' time='1.341694'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vhh' time='1.334550'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_hvhh' time='1.385772'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vbs_notification' time='4.663183'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_uplink_free_and_busy' time='1.835520'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_fail' time='16.554889'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_est_rel' time='1.439544'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_listener_det' time='3.308056'/> </testsuite> <?xml version="1.0"?> <testsuite name='Titan' tests='17' failures='0' errors='0' skipped='0' inconc='0' time='96.00'> <testcase classname='BTS_Tests_OML' name='TC_wrong_mdisc' time='10.855609'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_msgtype' time='0.712234'/> <testcase classname='BTS_Tests_OML' name='TC_short_length' time='0.711826'/> <testcase classname='BTS_Tests_OML' name='TC_long_length' time='0.706585'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_placement' time='0.712584'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_seq' time='0.669659'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_obj_class' time='0.679135'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_bts_nr' time='0.717946'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_trx_nr' time='0.695812'/> <testcase classname='BTS_Tests_OML' name='TC_radio_carrier_opstart_noattr' time='0.677893'/> <testcase classname='BTS_Tests_OML' name='TC_bts_opstart' time='0.695455'/> <testcase classname='BTS_Tests_OML' name='TC_bts_opstart_noattr' time='0.679089'/> <testcase classname='BTS_Tests_OML' name='TC_ts_opstart' time='0.680640'/> <testcase classname='BTS_Tests_OML' name='TC_ts_opstart_noattr' time='0.676068'/> <testcase classname='BTS_Tests_OML' name='TC_initial_state_reports' time='0.671526'/> <testcase classname='BTS_Tests_OML' name='TC_ipa_osmo_pcu_anr_fwd' time='0.695731'/> <testcase classname='BTS_Tests_OML' name='TC_ipa_rsl_connect_nack' time='0.674729'/> </testsuite> + check_respawn_count + set +x [0;31m ================================================================ WARNING: osmo-bts was respawned 4 times (expected: 3)! (OS#6794) ================================================================ [0m+ RC=1 + uptime + grep --color=always -o load.* [01;31m[Kload average: 1.10, 1.05, 0.79[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.

1 0

Build failed in Jenkins: Osmocom-repo-install-debian11 » nightly,qemu #1557
by jenkins＠lists.osmocom.org 07 Sep '26

07 Sep '26

See <https://jenkins.osmocom.org/jenkins/job/Osmocom-repo-install-debian11/feed=…> Changes: ------------------------------------------ [...truncated 3.50 KiB...] + LOG_FILE=_repo_install_test_data/qemu.log + check_usage + local i + [ debian11 = centos8 ] + [ debian11 = debian10 ] + [ debian11 = debian11 ] + return + FEED=nightly + PROJ=osmocom:nightly + [ -z ] + TESTS= test_conflict install_repo_packages test_binaries services_check + [ -z ] + PROJ_CONFLICT=osmocom:latest + clean_up + [ -n ] + [ -e _repo_install_test_data/qemu.pid ] + rm -f _repo_install_test_data/temp.qcow2 + trap clean_up_trap EXIT INT TERM 0 + qemu_start + [ -n ] + prepare_img + dirname _repo_install_test_data/temp.qcow2 + mkdir -p _repo_install_test_data + get_backing_img_path + local ret= + ret=/opt/qemu/debian-11.qcow2 + [ -e /opt/qemu/debian-11.qcow2 ] + echo /opt/qemu/debian-11.qcow2 + qemu-img create -f qcow2 -b /opt/qemu/debian-11.qcow2 -F qcow2 _repo_install_test_data/temp.qcow2 Formatting '_repo_install_test_data/temp.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=6442450944 backing_file=/opt/qemu/debian-11.qcow2 backing_fmt=qcow2 lazy_refcounts=off refcount_bits=16 + find_free_ssh_port + echo (1077489 % 1000) + 22022 + bc + SSH_PORT=22511 + nc -z 127.0.0.1 22511 + echo 22511 + qemu_ssh_wait + set +x Waiting for VM to boot up... + sleep 1 + timeout 1h qemu-system-x86_64 -cpu host -device virtio-net-pci,netdev=net -display none -drive file=_repo_install_test_data/temp.qcow2,format=qcow2 -enable-kvm -m 1024 -netdev user,id=net,hostfwd=tcp:127.0.0.1:22511-:22 -nodefaults -pidfile _repo_install_test_data/qemu.pid -serial stdio -smp 16 + cat _repo_install_test_data/qemu.pid + local pid=1077508 + seq 1 6 + [ -z 1077508 ] + kill -0 1077508 + TIMEOUT=10s qemu_ssh true + timeout 10s sshpass -p root ssh -p 22511 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null root(a)127.0.0.1 -- true + sleep 1 + [ -z 1077508 ] + kill -0 1077508 + TIMEOUT=10s qemu_ssh true + timeout 10s sshpass -p root ssh -p 22511 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null root(a)127.0.0.1 -- true Warning: Permanently added '[127.0.0.1]:22511' (ED25519) to the list of known hosts. + return + set +x VM is running! + qemu_prepare_vm + qemu_run_test_script + cat + qemu_ssh rm -rf /repo-install-test/ + timeout 1m sshpass -p root ssh -p 22511 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null root(a)127.0.0.1 -- rm -rf /repo-install-test/ Warning: Permanently added '[127.0.0.1]:22511' (ED25519) to the list of known hosts. + qemu_ssh mkdir /repo-install-test + timeout 1m sshpass -p root ssh -p 22511 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null root(a)127.0.0.1 -- mkdir /repo-install-test Warning: Permanently added '[127.0.0.1]:22511' (ED25519) to the list of known hosts. + qemu_scp -r scripts/repo-install-test/run-inside-env.sh scripts/repo-install-test/run-inside.sh root@127.0.0.1:/repo-install-test + timeout 1m sshpass -p root scp -P 22511 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -r scripts/repo-install-test/run-inside-env.sh scripts/repo-install-test/run-inside.sh root@127.0.0.1:/repo-install-test Warning: Permanently added '[127.0.0.1]:22511' (ED25519) to the list of known hosts. + TIMEOUT=1h qemu_ssh sh -ex /repo-install-test/run-inside-env.sh + timeout 1h sshpass -p root ssh -p 22511 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null root(a)127.0.0.1 -- sh -ex /repo-install-test/run-inside-env.sh Warning: Permanently added '[127.0.0.1]:22511' (ED25519) to the list of known hosts. + export DISTRO=debian11 + export DOMAIN=downloads.osmocom.org + export FEED=nightly + export PROJ=osmocom:nightly + export PROJ_CONFLICT=osmocom:latest + export SKIP_PREPARE_VM= + export TESTS= test_conflict install_repo_packages test_binaries services_check + /repo-install-test/run-inside.sh + SERVICES= osmo-bsc osmo-bts-virtual osmo-cbc osmo-e1d osmo-gbproxy osmo-ggsn osmo-gtphub osmo-hlr osmo-hnbgw osmo-hnodeb osmo-mgw osmo-msc osmo-pcap-client osmo-pcap-server osmo-pcu osmo-remsim-bankd osmo-remsim-server osmo-sgsn osmo-sip-connector osmo-smlc osmo-stp + SERVICES_NIGHTLY= osmo-bsc-nat + distro_obsdir + echo Debian_11 + DISTRO_OBSDIR=Debian_11 Checking feed: nightly Checking project: osmocom:nightly Checking conflicting project: osmocom:latest Linux distribution: debian11 Enabled tests: test_conflict install_repo_packages test_binaries services_check + check_env + [ -n nightly ] + echo Checking feed: nightly + [ -n osmocom:nightly ] + echo Checking project: osmocom:nightly + [ -n osmocom:latest ] + echo Checking conflicting project: osmocom:latest + [ -n debian11 ] + echo Linux distribution: debian11 + [ -n test_conflict install_repo_packages test_binaries services_check ] + echo Enabled tests: test_conflict install_repo_packages test_binaries services_check + prepare_vm + [ -n ] + prepare_vm_debian + ln -sf /bin/true /usr/bin/fmtutil + echo path-exclude=/usr/bin/fmtutil + apt-get update --allow-releaseinfo-change Get:1 http://security.debian.org/debian-security bullseye-security InRelease [27.2 kB] Get:2 http://deb.debian.org/debian bullseye InRelease [75.1 kB] Get:3 http://deb.debian.org/debian bullseye-updates InRelease [44.0 kB] Get:4 http://security.debian.org/debian-security bullseye-security/main Sources [311 kB] Get:5 http://security.debian.org/debian-security bullseye-security/main amd64 Packages [475 kB] Get:6 http://security.debian.org/debian-security bullseye-security/main Translation-en [318 kB] Get:7 http://deb.debian.org/debian bullseye/main Sources [8,500 kB] Get:8 http://deb.debian.org/debian bullseye-updates/main Sources.diff/Index [26.3 kB] Get:9 http://deb.debian.org/debian bullseye-updates/main amd64 Packages.diff/Index [26.3 kB] Ign:9 http://deb.debian.org/debian bullseye-updates/main amd64 Packages.diff/Index Get:10 http://deb.debian.org/debian bullseye-updates/main Translation-en.diff/Index [12.8 kB] Get:11 http://deb.debian.org/debian bullseye-updates/main Sources T-2023-12-29-1403.39-F-2022-01-24-2024.03.pdiff [7,722 B] Get:11 http://deb.debian.org/debian bullseye-updates/main Sources T-2023-12-29-1403.39-F-2022-01-24-2024.03.pdiff [7,722 B] Get:12 http://deb.debian.org/debian bullseye-updates/main Translation-en T-2025-07-21-2004.39-F-2022-09-22-1635.40.pdiff [8,550 B] Get:12 http://deb.debian.org/debian bullseye-updates/main Translation-en T-2025-07-21-2004.39-F-2022-09-22-1635.40.pdiff [8,550 B] Get:13 http://deb.debian.org/debian bullseye/main amd64 Packages [8,066 kB] Get:14 http://deb.debian.org/debian bullseye/main Translation-en [6,235 kB] Get:15 http://deb.debian.org/debian bullseye-updates/main amd64 Packages [18.8 kB] Get:16 http://deb.debian.org/debian bullseye-updates/main Sources [7,908 B] Get:17 http://deb.debian.org/debian bullseye-updates/main Translation-en [10.5 kB] Fetched 24.2 MB in 2s (11.0 MB/s) Reading package lists... + apt-get install -y --no-install-recommends aptitude ca-certificates gnupg2 wget Reading package lists... Building dependency tree... Reading state information... The following additional packages will be installed: aptitude-common dirmngr gnupg gnupg-l10n gnupg-utils gpg gpg-agent gpg-wks-client gpg-wks-server gpgconf gpgsm gpgv libassuan0 libboost-iostreams1.74.0 libcwidget4 libksba8 libnpth0 libsigc++-2.0-0v5 libxapian30 pinentry-curses Suggested packages: apt-xapian-index aptitude-doc-en | aptitude-doc debtags dbus-user-session pinentry-gnome3 tor parcimonie xloadimage scdaemon libcwidget-dev xapian-tools pinentry-doc Recommended packages: libdpkg-perl The following NEW packages will be installed: aptitude aptitude-common dirmngr gnupg gnupg-l10n gnupg-utils gnupg2 gpg gpg-agent gpg-wks-client gpg-wks-server gpgconf gpgsm libassuan0 libboost-iostreams1.74.0 libcwidget4 libksba8 libnpth0 libsigc++-2.0-0v5 libxapian30 pinentry-curses The following packages will be upgraded: ca-certificates gpgv wget 3 upgraded, 21 newly installed, 0 to remove and 148 not upgraded. Need to get 14.7 MB of archives. After this operation, 37.0 MB of additional disk space will be used. Get:1 http://security.debian.org/debian-security bullseye-security/main amd64 gpgv amd64 2.2.27-2+deb11u3 [626 kB] Get:2 http://deb.debian.org/debian bullseye/main amd64 aptitude-common all 0.8.13-3 [1,776 kB] Err:3 http://security.debian.org/debian-security bullseye-security/main amd64 ca-certificates all 20250419~deb12u1~deb11u1 404 Not Found [IP: 146.75.122.132 80] Get:4 http://security.debian.org/debian-security bullseye-security/main amd64 wget amd64 1.21-1+deb11u2 [964 kB] Get:5 http://security.debian.org/debian-security bullseye-security/main amd64 gpgconf amd64 2.2.27-2+deb11u3 [548 kB] Get:6 http://deb.debian.org/debian bullseye/main amd64 libboost-iostreams1.74.0 amd64 1.74.0-9 [264 kB] Get:7 http://deb.debian.org/debian bullseye/main amd64 libsigc++-2.0-0v5 amd64 2.10.4-2 [31.3 kB] Get:8 http://deb.debian.org/debian bullseye/main amd64 libcwidget4 amd64 0.5.18-5 [315 kB] Get:9 http://security.debian.org/debian-security bullseye-security/main amd64 dirmngr amd64 2.2.27-2+deb11u3 [763 kB] Get:10 http://deb.debian.org/debian bullseye/main amd64 libxapian30 amd64 1.4.18-3+deb11u1 [1,089 kB] Get:11 http://security.debian.org/debian-security bullseye-security/main amd64 gnupg-l10n all 2.2.27-2+deb11u3 [1,084 kB] Get:12 http://security.debian.org/debian-security bullseye-security/main amd64 gnupg-utils amd64 2.2.27-2+deb11u3 [905 kB] Get:13 http://security.debian.org/debian-security bullseye-security/main amd64 gpg amd64 2.2.27-2+deb11u3 [928 kB] Get:14 http://security.debian.org/debian-security bullseye-security/main amd64 gpg-agent amd64 2.2.27-2+deb11u3 [670 kB] Get:15 http://deb.debian.org/debian bullseye/main amd64 aptitude amd64 0.8.13-3 [1,349 kB] Get:16 http://deb.debian.org/debian bullseye/main amd64 libassuan0 amd64 2.5.3-7.1 [50.5 kB] Get:17 http://deb.debian.org/debian bullseye/main amd64 libksba8 amd64 1.5.0-3+deb11u2 [123 kB] Get:18 http://deb.debian.org/debian bullseye/main amd64 libnpth0 amd64 1.6-3 [19.0 kB] Get:19 http://deb.debian.org/debian bullseye/main amd64 pinentry-curses amd64 1.1.0-4 [64.9 kB] Get:20 http://security.debian.org/debian-security bullseye-security/main amd64 gpg-wks-client amd64 2.2.27-2+deb11u3 [524 kB] Get:21 http://security.debian.org/debian-security bullseye-security/main amd64 gpg-wks-server amd64 2.2.27-2+deb11u3 [516 kB] Get:22 http://security.debian.org/debian-security bullseye-security/main amd64 gpgsm amd64 2.2.27-2+deb11u3 [645 kB] Get:23 http://security.debian.org/debian-security bullseye-security/main amd64 gnupg all 2.2.27-2+deb11u3 [825 kB] Get:24 http://security.debian.org/debian-security bullseye-security/main amd64 gnupg2 all 2.2.27-2+deb11u3 [435 kB] Fetched 14.5 MB in 0s (79.8 MB/s) E: Failed to fetch http://security.debian.org/debian-security/pool/updates/main/c/ca-certifica… 404 Not Found [IP: 146.75.122.132 80] E: Unable to fetch some archives, maybe run apt-get update or try with --fix-missing? + clean_up_trap + [ -n ] + set +x ### Clean up ### + trap - EXIT INT TERM 0 + clean_up + [ -n ] + [ -e _repo_install_test_data/qemu.pid ] + cat _repo_install_test_data/qemu.pid + kill 1077508 + rm -f _repo_install_test_data/temp.qcow2 Build step 'Execute shell' marked build as failure

1 3

Build failed in Jenkins: Osmocom-repo-install-debian11 » latest,qemu #1557
by jenkins＠lists.osmocom.org 07 Sep '26

07 Sep '26

See <https://jenkins.osmocom.org/jenkins/job/Osmocom-repo-install-debian11/feed=…> Changes: ------------------------------------------ [...truncated 3.49 KiB...] + LOG_FILE=_repo_install_test_data/qemu.log + check_usage + local i + [ debian11 = centos8 ] + [ debian11 = debian10 ] + [ debian11 = debian11 ] + return + FEED=latest + PROJ=osmocom:latest + [ -z ] + TESTS= test_conflict install_repo_packages test_binaries services_check + [ -z ] + PROJ_CONFLICT=osmocom:nightly + clean_up + [ -n ] + [ -e _repo_install_test_data/qemu.pid ] + rm -f _repo_install_test_data/temp.qcow2 + trap clean_up_trap EXIT INT TERM 0 + qemu_start + [ -n ] + prepare_img + dirname _repo_install_test_data/temp.qcow2 + mkdir -p _repo_install_test_data + get_backing_img_path + local ret= + ret=/opt/qemu/debian-11.qcow2 + [ -e /opt/qemu/debian-11.qcow2 ] + echo /opt/qemu/debian-11.qcow2 + qemu-img create -f qcow2 -b /opt/qemu/debian-11.qcow2 -F qcow2 _repo_install_test_data/temp.qcow2 Formatting '_repo_install_test_data/temp.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=6442450944 backing_file=/opt/qemu/debian-11.qcow2 backing_fmt=qcow2 lazy_refcounts=off refcount_bits=16 + find_free_ssh_port + echo (2024954 % 1000) + 22022 + bc + SSH_PORT=22976 + nc -z 127.0.0.1 22976 + echo 22976 + qemu_ssh_wait + set +x Waiting for VM to boot up... + sleep 1 + timeout 1h qemu-system-x86_64 -cpu host -device virtio-net-pci,netdev=net -display none -drive file=_repo_install_test_data/temp.qcow2,format=qcow2 -enable-kvm -m 1024 -netdev user,id=net,hostfwd=tcp:127.0.0.1:22976-:22 -nodefaults -pidfile _repo_install_test_data/qemu.pid -serial stdio -smp 16 + cat _repo_install_test_data/qemu.pid + local pid=2024978 + seq 1 6 + [ -z 2024978 ] + kill -0 2024978 + TIMEOUT=10s qemu_ssh true + timeout 10s sshpass -p root ssh -p 22976 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null root(a)127.0.0.1 -- true + sleep 1 + [ -z 2024978 ] + kill -0 2024978 + TIMEOUT=10s qemu_ssh true + timeout 10s sshpass -p root ssh -p 22976 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null root(a)127.0.0.1 -- true Warning: Permanently added '[127.0.0.1]:22976' (ED25519) to the list of known hosts. + return + set +x VM is running! + qemu_prepare_vm + qemu_run_test_script + cat + qemu_ssh rm -rf /repo-install-test/ + timeout 1m sshpass -p root ssh -p 22976 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null root(a)127.0.0.1 -- rm -rf /repo-install-test/ Warning: Permanently added '[127.0.0.1]:22976' (ED25519) to the list of known hosts. + qemu_ssh mkdir /repo-install-test + timeout 1m sshpass -p root ssh -p 22976 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null root(a)127.0.0.1 -- mkdir /repo-install-test Warning: Permanently added '[127.0.0.1]:22976' (ED25519) to the list of known hosts. + qemu_scp -r scripts/repo-install-test/run-inside-env.sh scripts/repo-install-test/run-inside.sh root@127.0.0.1:/repo-install-test + timeout 1m sshpass -p root scp -P 22976 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -r scripts/repo-install-test/run-inside-env.sh scripts/repo-install-test/run-inside.sh root@127.0.0.1:/repo-install-test Warning: Permanently added '[127.0.0.1]:22976' (ED25519) to the list of known hosts. + TIMEOUT=1h qemu_ssh sh -ex /repo-install-test/run-inside-env.sh + timeout 1h sshpass -p root ssh -p 22976 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null root(a)127.0.0.1 -- sh -ex /repo-install-test/run-inside-env.sh Warning: Permanently added '[127.0.0.1]:22976' (ED25519) to the list of known hosts. + export DISTRO=debian11 + export DOMAIN=downloads.osmocom.org + export FEED=latest + export PROJ=osmocom:latest + export PROJ_CONFLICT=osmocom:nightly + export SKIP_PREPARE_VM= + export TESTS= test_conflict install_repo_packages test_binaries services_check + /repo-install-test/run-inside.sh + SERVICES= osmo-bsc osmo-bts-virtual osmo-cbc osmo-e1d osmo-gbproxy osmo-ggsn osmo-gtphub osmo-hlr osmo-hnbgw osmo-hnodeb osmo-mgw osmo-msc osmo-pcap-client osmo-pcap-server osmo-pcu osmo-remsim-bankd osmo-remsim-server osmo-sgsn osmo-sip-connector osmo-smlc osmo-stp + SERVICES_NIGHTLY= osmo-bsc-nat + distro_obsdir + echo Debian_11 + DISTRO_OBSDIR=Debian_11 + check_env + [ -n latest ] + echo Checking feed: latest + Checking feed: latest Checking project: osmocom:latest Checking conflicting project: osmocom:nightly [ -n osmocom:latest ] + echo Checking project: osmocom:latest + [ -n osmocom:nightly ] + echo Checking conflicting project: osmocom:nightly + [ -n debian11Linux distribution: debian11 Enabled tests: test_conflict install_repo_packages test_binaries services_check ] + echo Linux distribution: debian11 + [ -n test_conflict install_repo_packages test_binaries services_check ] + echo Enabled tests: test_conflict install_repo_packages test_binaries services_check + prepare_vm + [ -n ] + prepare_vm_debian + ln -sf /bin/true /usr/bin/fmtutil + echo path-exclude=/usr/bin/fmtutil + apt-get update --allow-releaseinfo-change Get:1 http://security.debian.org/debian-security bullseye-security InRelease [27.2 kB] Get:2 http://deb.debian.org/debian bullseye InRelease [75.1 kB] Get:3 http://deb.debian.org/debian bullseye-updates InRelease [44.0 kB] Get:4 http://security.debian.org/debian-security bullseye-security/main Sources [311 kB] Get:5 http://security.debian.org/debian-security bullseye-security/main amd64 Packages [475 kB] Get:6 http://security.debian.org/debian-security bullseye-security/main Translation-en [318 kB] Get:7 http://deb.debian.org/debian bullseye/main Sources [8,500 kB] Get:8 http://deb.debian.org/debian bullseye-updates/main Sources.diff/Index [26.3 kB] Get:9 http://deb.debian.org/debian bullseye-updates/main amd64 Packages.diff/Index [26.3 kB] Ign:9 http://deb.debian.org/debian bullseye-updates/main amd64 Packages.diff/Index Get:10 http://deb.debian.org/debian bullseye-updates/main Translation-en.diff/Index [12.8 kB] Get:11 http://deb.debian.org/debian bullseye-updates/main Sources T-2023-12-29-1403.39-F-2022-01-24-2024.03.pdiff [7,722 B] Get:11 http://deb.debian.org/debian bullseye-updates/main Sources T-2023-12-29-1403.39-F-2022-01-24-2024.03.pdiff [7,722 B] Get:12 http://deb.debian.org/debian bullseye-updates/main Translation-en T-2025-07-21-2004.39-F-2022-09-22-1635.40.pdiff [8,550 B] Get:12 http://deb.debian.org/debian bullseye-updates/main Translation-en T-2025-07-21-2004.39-F-2022-09-22-1635.40.pdiff [8,550 B] Get:13 http://deb.debian.org/debian bullseye/main amd64 Packages [8,066 kB] Get:14 http://deb.debian.org/debian bullseye/main Translation-en [6,235 kB] Get:15 http://deb.debian.org/debian bullseye-updates/main amd64 Packages [18.8 kB] Get:16 http://deb.debian.org/debian bullseye-updates/main Sources [7,908 B] Get:17 http://deb.debian.org/debian bullseye-updates/main Translation-en [10.5 kB] Fetched 24.2 MB in 2s (10.4 MB/s) Reading package lists... + apt-get install -y --no-install-recommends aptitude ca-certificates gnupg2 wget Reading package lists... Building dependency tree... Reading state information... The following additional packages will be installed: aptitude-common dirmngr gnupg gnupg-l10n gnupg-utils gpg gpg-agent gpg-wks-client gpg-wks-server gpgconf gpgsm gpgv libassuan0 libboost-iostreams1.74.0 libcwidget4 libksba8 libnpth0 libsigc++-2.0-0v5 libxapian30 pinentry-curses Suggested packages: apt-xapian-index aptitude-doc-en | aptitude-doc debtags dbus-user-session pinentry-gnome3 tor parcimonie xloadimage scdaemon libcwidget-dev xapian-tools pinentry-doc Recommended packages: libdpkg-perl The following NEW packages will be installed: aptitude aptitude-common dirmngr gnupg gnupg-l10n gnupg-utils gnupg2 gpg gpg-agent gpg-wks-client gpg-wks-server gpgconf gpgsm libassuan0 libboost-iostreams1.74.0 libcwidget4 libksba8 libnpth0 libsigc++-2.0-0v5 libxapian30 pinentry-curses The following packages will be upgraded: ca-certificates gpgv wget 3 upgraded, 21 newly installed, 0 to remove and 148 not upgraded. Need to get 14.7 MB of archives. After this operation, 37.0 MB of additional disk space will be used. Get:1 http://deb.debian.org/debian bullseye/main amd64 aptitude-common all 0.8.13-3 [1,776 kB] Get:2 http://security.debian.org/debian-security bullseye-security/main amd64 gpgv amd64 2.2.27-2+deb11u3 [626 kB] Err:3 http://security.debian.org/debian-security bullseye-security/main amd64 ca-certificates all 20250419~deb12u1~deb11u1 404 Not Found [IP: 146.75.122.132 80] Get:4 http://deb.debian.org/debian bullseye/main amd64 libboost-iostreams1.74.0 amd64 1.74.0-9 [264 kB] Get:5 http://security.debian.org/debian-security bullseye-security/main amd64 wget amd64 1.21-1+deb11u2 [964 kB] Get:6 http://deb.debian.org/debian bullseye/main amd64 libsigc++-2.0-0v5 amd64 2.10.4-2 [31.3 kB] Get:7 http://deb.debian.org/debian bullseye/main amd64 libcwidget4 amd64 0.5.18-5 [315 kB] Get:8 http://deb.debian.org/debian bullseye/main amd64 libxapian30 amd64 1.4.18-3+deb11u1 [1,089 kB] Get:9 http://security.debian.org/debian-security bullseye-security/main amd64 gpgconf amd64 2.2.27-2+deb11u3 [548 kB] Get:10 http://deb.debian.org/debian bullseye/main amd64 aptitude amd64 0.8.13-3 [1,349 kB] Get:11 http://security.debian.org/debian-security bullseye-security/main amd64 dirmngr amd64 2.2.27-2+deb11u3 [763 kB] Get:12 http://deb.debian.org/debian bullseye/main amd64 libassuan0 amd64 2.5.3-7.1 [50.5 kB] Get:13 http://deb.debian.org/debian bullseye/main amd64 libksba8 amd64 1.5.0-3+deb11u2 [123 kB] Get:14 http://deb.debian.org/debian bullseye/main amd64 libnpth0 amd64 1.6-3 [19.0 kB] Get:15 http://deb.debian.org/debian bullseye/main amd64 pinentry-curses amd64 1.1.0-4 [64.9 kB] Get:16 http://security.debian.org/debian-security bullseye-security/main amd64 gnupg-l10n all 2.2.27-2+deb11u3 [1,084 kB] Get:17 http://security.debian.org/debian-security bullseye-security/main amd64 gnupg-utils amd64 2.2.27-2+deb11u3 [905 kB] Get:18 http://security.debian.org/debian-security bullseye-security/main amd64 gpg amd64 2.2.27-2+deb11u3 [928 kB] Get:19 http://security.debian.org/debian-security bullseye-security/main amd64 gpg-agent amd64 2.2.27-2+deb11u3 [670 kB] Get:20 http://security.debian.org/debian-security bullseye-security/main amd64 gpg-wks-client amd64 2.2.27-2+deb11u3 [524 kB] Get:21 http://security.debian.org/debian-security bullseye-security/main amd64 gpg-wks-server amd64 2.2.27-2+deb11u3 [516 kB] Get:22 http://security.debian.org/debian-security bullseye-security/main amd64 gpgsm amd64 2.2.27-2+deb11u3 [645 kB] Get:23 http://security.debian.org/debian-security bullseye-security/main amd64 gnupg all 2.2.27-2+deb11u3 [825 kB] Get:24 http://security.debian.org/debian-security bullseye-security/main amd64 gnupg2 all 2.2.27-2+deb11u3 [435 kB] Fetched 14.5 MB in 0s (71.6 MB/s) E: Failed to fetch http://security.debian.org/debian-security/pool/updates/main/c/ca-certifica… 404 Not Found [IP: 146.75.122.132 80] E: Unable to fetch some archives, maybe run apt-get update or try with --fix-missing? + clean_up_trap + [ -n ] + set +x ### Clean up ### + trap - EXIT INT TERM 0 + clean_up + [ -n ] + [ -e _repo_install_test_data/qemu.pid ] + cat _repo_install_test_data/qemu.pid + kill 2024978 + rm -f _repo_install_test_data/temp.qcow2 Build step 'Execute shell' marked build as failure

1 3

Build failed in Jenkins: Osmocom_OBS_master #156436
by jenkins＠lists.osmocom.org 06 Sep '26

06 Sep '26

See <https://jenkins.osmocom.org/jenkins/job/Osmocom_OBS_master/156436/display/r…> Changes: ------------------------------------------ Started by upstream project "master-osmo-sgsn" build number 58459 originally caused by: Started by timer Running as SYSTEM Building remotely on build4-deb12build-ansible (ttcn3 obs osmo-gsm-tester-build qemu io_uring linux-shallow-clone osmocom-gerrit coverity osmocom-master) in workspace <https://jenkins.osmocom.org/jenkins/job/Osmocom_OBS_master/ws/> The recommended git tool is: NONE No credentials specified Wiping out workspace first. Cloning the remote Git repository Cloning repository https://gerrit.osmocom.org/osmo-ci > git init <https://jenkins.osmocom.org/jenkins/job/Osmocom_OBS_master/ws/> # timeout=10 Fetching upstream changes from https://gerrit.osmocom.org/osmo-ci > git --version # timeout=10 > git --version # 'git version 2.39.5' > git fetch --tags --force --progress -- https://gerrit.osmocom.org/osmo-ci +refs/heads/*:refs/remotes/origin/* # timeout=10 > git config remote.origin.url https://gerrit.osmocom.org/osmo-ci # timeout=10 > git config --add remote.origin.fetch +refs/heads/*:refs/remotes/origin/* # timeout=10 Avoid second fetch > git rev-parse origin/master^{commit} # timeout=10 Checking out Revision 3a5e9d0f214488f71de5266f346287d8c1b708e4 (origin/master) > git config core.sparsecheckout # timeout=10 > git checkout -f 3a5e9d0f214488f71de5266f346287d8c1b708e4 # timeout=10 Commit message: "jobs/ttcn3-testsuites-testenv: add eim" > git rev-list --no-walk 3a5e9d0f214488f71de5266f346287d8c1b708e4 # timeout=10 [Osmocom_OBS_master] $ /bin/sh -xe /tmp/jenkins17475890452550387361.sh + export PYTHONUNBUFFERED=1 + ./scripts/obs/update_obs_project.py --apiurl https://obs.osmocom.org --conflict-version --docker --feed master --meta osmocom:master docker: building image debian-13-osmocom-obs-build-srcpkg + run_in_docker_and_exit(): ['docker', 'build', '--build-arg', 'DISTRO=debian:13', '--build-arg', 'DISTRO_FROM=debian:trixie', '--build-arg', 'UID=1000', '-t', 'debian-13-osmocom-obs-build-srcpkg', '-f', '<https://jenkins.osmocom.org/jenkins/job/Osmocom_OBS_master/ws/scripts/obs/d…',> '<https://jenkins.osmocom.org/jenkins/job/Osmocom_OBS_master/ws/scripts/obs/d…']> #0 building with "default" instance using docker driver #1 [internal] load build definition from build_srcpkg.Dockerfile #1 transferring dockerfile: 1.48kB done #1 WARN: InvalidDefaultArgInFrom: Default value for ARG ${DISTRO_FROM} results in empty or invalid base image name (line 3) #1 DONE 0.0s #2 [internal] load metadata for docker.io/library/debian:trixie #2 DONE 0.0s #3 [internal] load .dockerignore #3 transferring context: 2B done #3 DONE 0.0s #4 [1/4] FROM docker.io/library/debian:trixie #4 DONE 0.0s #5 [2/4] RUN APT-GET update && apt-get upgrade -y && apt-get install -y --no-install-recommends ca-certificates colordiff debhelper default-libmysqlclient-dev dh-cmake dh-python dh-runit dh-virtualenv dpkg-dev erlang-nox fakeroot git git-review gnupg2 libxml2-utils lsb-release meson osc pkgconf python3-packaging python3-pip python3-setuptools quilt sed sphinx-common wget && apt-get clean #5 CACHED #6 [3/4] RUN WGET https://github.com/erlang/rebar3/releases/download/3.24.0/rebar3 -O /usr/bin/rebar3 && echo "d2d31cfb98904b8e4917300a75f870de12cb5167cd6214d1043e973a56668a54 /usr/bin/rebar3" | sha256sum -c && chmod +x /usr/bin/rebar3 && rebar3 --version #6 CACHED #7 [4/4] RUN USERADD --uid=1000 -m user #7 CACHED #8 exporting to image #8 exporting layers done #8 writing image sha256:9939d922165980127b8c2b86684488eecbea95eea4e9c7652446dda0d74ca96c 0.0s done #8 naming to docker.io/library/debian-13-osmocom-obs-build-srcpkg #8 naming to docker.io/library/debian-13-osmocom-obs-build-srcpkg 0.0s done #8 DONE 0.0s [33m1 warning found (use docker --debug to expand): [0m - InvalidDefaultArgInFrom: Default value for ARG ${DISTRO_FROM} results in empty or invalid base image name (line 3) docker: running: update_obs_project.py inside docker /obs/lib/debian.py:183: SyntaxWarning: invalid escape sequence '\/' lib.run_cmd(["sed", "-i", "s/$(MAKE) -C doc\/manuals//g", f"{debian}/rules"]) OBS: getting packages in osmocom:master ERROR: command failed unexpectedly *** command *** ['osc', '-A', 'https://obs.osmocom.org', 'list', 'osmocom:master'] *** returncode *** 1 *** output *** fatal: not a git repository (or any of the parent directories): .git Server returned an error: HTTP Error 408: Request Timeout *** python trace *** Traceback (most recent call last): File "/obs/update_obs_project.py", line 265, in <module> main() ~~~~^^ File "/obs/update_obs_project.py", line 257, in main pkgs_remote = lib.osc.get_remote_pkgs() File "/obs/lib/osc.py", line 63, in get_remote_pkgs ret = run_osc(["list", proj]) File "/obs/lib/osc.py", line 58, in run_osc return lib.run_cmd(cmd, *args, **kwargs) ~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^ File "/obs/lib/__init__.py", line 202, in run_cmd exit_error_cmd(p, "command failed unexpectedly") ~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/obs/lib/__init__.py", line 163, in exit_error_cmd raise RuntimeError("shell command related error, find details right above" " this python trace") RuntimeError: shell command related error, find details right above this python trace Build step 'Execute shell' marked build as failure

1 1

2026

2025

2024

2023

2022

2021

2020

2019

jenkins-notifications