August 2024 - jenkins-notifications

Build failed in Jenkins: ttcn3-sgsn-test-io_uring #165

by jenkins＠lists.osmocom.org

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/165/displa…> Changes: [lynxis] SGSN_Tests: add paging a whole routing area with multiple cells [lynxis] SGSN_Tests: remove unused variable d [lynxis] SGSN_Tests_NS: NS related tests: use the shutdown helper [lynxis] SGSN_Tests_NS: TC_NS_connect_alive: set missing verdict ------------------------------------------ [...truncated 1.25 MB...] MTC@a6473498aab6: Local verdict of PTC -NSVCI98-provIP(391): none (none -> none) MTC@a6473498aab6: Local verdict of PTC TC_hlr_location_cancel_request_withdraw-BVCI210(392): none (none -> none) MTC@a6473498aab6: Local verdict of PTC -NSVCI98(393): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-Gb2-NS2(394): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-Gb2-BSSGP2(395): none (none -> none) MTC@a6473498aab6: Local verdict of PTC -NSVCI99-provIP(396): none (none -> none) MTC@a6473498aab6: Local verdict of PTC TC_hlr_location_cancel_request_withdraw-BVCI220(397): none (none -> none) MTC@a6473498aab6: Local verdict of PTC -NSVCI99(398): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-GSUP-IPA(399): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-GSUP(400): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-GGSN_GTP(401): none (none -> none) MTC@a6473498aab6: Local verdict of PTC TC_hlr_location_cancel_request_withdraw(402): pass (none -> pass) MTC@a6473498aab6: Test case TC_hlr_location_cancel_request_withdraw finished. Verdict: pass MTC@a6473498aab6: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache/…> SGSN_Tests.TC_hlr_location_cancel_request_withdraw pass'. Fri Aug 16 12:03:19 UTC 2024 [1;32m====== SGSN_Tests.TC_hlr_location_cancel_request_withdraw pass ======[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=44100) [38;5;39m20240816120320350 [1;33mDLGSUP[0;m[38;5;39m [1;33mNOTICE[0;m[38;5;39m GSUP connecting to 127.0.0.103:4222 (gsup_client.c:74)[0;m [38;5;39m20240816120320350 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m GSUP link to 127.0.0.103:4222 DOWN (gsup_client.c:151)[0;m Waiting for packet dumper to finish... 1 (prev_count=44100, count=93200) [38;5;39m20240816120321351 [1;33mDLGSUP[0;m[38;5;39m [1;33mNOTICE[0;m[38;5;39m GSUP connecting to 127.0.0.103:4222 (gsup_client.c:74)[0;m [38;5;39m20240816120321352 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m GSUP link to 127.0.0.103:4222 DOWN (gsup_client.c:151)[0;m MTC@a6473498aab6: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache/…> SGSN_Tests.TC_hlr_location_cancel_request_withdraw pass' was executed successfully (exit status: 0). MTC@a6473498aab6: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache/…> SGSN_Tests.TC_hlr_location_cancel_request_unknown_subscriber_withdraw'. ------ SGSN_Tests.TC_hlr_location_cancel_request_unknown_subscriber_withdraw ------ Fri Aug 16 12:03:21 UTC 2024 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/165/artifa…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/165/artifa…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 [38;5;39m20240816120322353 [1;33mDLGSUP[0;m[38;5;39m [1;33mNOTICE[0;m[38;5;39m GSUP connecting to 127.0.0.103:4222 (gsup_client.c:74)[0;m [38;5;39m20240816120322353 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m GSUP link to 127.0.0.103:4222 DOWN (gsup_client.c:151)[0;m MTC@a6473498aab6: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache/…> SGSN_Tests.TC_hlr_location_cancel_request_unknown_subscriber_withdraw' was executed successfully (exit status: 0). MTC@a6473498aab6: Test case TC_hlr_location_cancel_request_unknown_subscriber_withdraw started. 20240816120322474 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Accept()ed new telnet connection r=127.0.0.1:58490<->l=127.0.0.10:4245 (telnet_interface.c:192) [38;5;35m20240816120322476 [1;32mDLGTP[0;m[38;5;35m [1;32mINFO[0;m[38;5;35m Clearing req & resp retransmit queues (gsn.c:365)[0;m SGSN_Test-Gb0-NS0(403)@a6473498aab6: Creating NSIP provider for "127.0.0.103":21010 SGSN_Test-Gb0-BSSGP0(404)@a6473498aab6: BVCI(0) State Transition: BVC_S_WAIT_RESET (0) -> BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) SGSN_Test-Gb0-NS0(403)@a6473498aab6: Starting NSVC component for { provider := { ip := { address_family := AF_INET (2), local_udp_port := 21010, local_ip := "127.0.0.103", remote_udp_port := 23000, remote_ip := "127.0.0.10", data_weight := 1, signalling_weight := 1 } }, nsvci := 97 } -NSVCI97(407)@a6473498aab6: NSVC 97 State Transition: NSVC_S_DEAD_BLOCKED (1) -> NSVC_S_DEAD_BLOCKED (1) -NSVCI97(407)@a6473498aab6: Provider Link came up: sending NS-RESET [38;5;63m20240816120322515 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Rx NS-RESET (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322515 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x555bfb2dbe10]{UNBLOCKED}: Received Event RX-RESET (gprs_ns2_vc_fsm.c:934)[0;m [38;5;57m20240816120322515 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x555bfb2dbe10]{UNBLOCKED}: state_chg to RESET (gprs_ns2_vc_fsm.c:657)[0;m [38;5;57m20240816120322515 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00096) NS-STATUS.ind(bvci=00000): cause=NSE failure, transfer=0, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816120322515 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 96 became unavailable (gprs_ns.c:54) [38;5;63m20240816120322515 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Tx NS-RESET-ACK (gprs_ns2_message.c:331)[0;m [38;5;57m20240816120322515 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x555bfb2dbe10]{RESET}: state_chg to BLOCKED (gprs_ns2_vc_fsm.c:329)[0;m [38;5;63m20240816120322515 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m [38;5;57m20240816120322515 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x555bfb2dbe10]{BLOCKED}: Starting Tns-alive of 3 seconds (gprs_ns2_vc_fsm.c:177)[0;m -NSVCI97(407)@a6473498aab6: NSVC 97 State Transition: NSVC_S_WAIT_RESET (2) -> NSVC_S_ALIVE_BLOCKED (3) [38;5;63m20240816120322516 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Rx NS-ALIVE (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322516 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x555bfb2dbe10]{BLOCKED}: Received Event RX-ALIVE (gprs_ns2_vc_fsm.c:957)[0;m [38;5;63m20240816120322516 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Tx NS-ALIVE-ACK (gprs_ns2_message.c:193)[0;m [38;5;63m20240816120322516 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Rx NS-UNBLOCK (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322516 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x555bfb2dbe10]{BLOCKED}: Received Event RX-UNBLOCK (gprs_ns2_vc_fsm.c:951)[0;m [38;5;63m20240816120322516 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Tx NS-UNBLOCK-ACK (gprs_ns2_message.c:193)[0;m [38;5;57m20240816120322516 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x555bfb2dbe10]{BLOCKED}: state_chg to UNBLOCKED (gprs_ns2_vc_fsm.c:414)[0;m [38;5;57m20240816120322516 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00096) NS-STATUS.ind(bvci=00000): cause=NSE recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816120322516 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 96 became available (gprs_ns.c:43) [38;5;57m20240816120322516 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00096)-NSVC(00097) NS-STATUS.ind(bvci=00000): cause=NSVC recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:571)[0;m 20240816120322516 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS: indication Unknown prim 2 from NS (gprs_ns.c:57) [38;5;63m20240816120322516 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322516 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x555bfb2dbe10]{UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m -NSVCI97(407)@a6473498aab6: Rx NS-ALIVE-ACK: stopping Tns-alive; starting Tns-test -NSVCI97(407)@a6473498aab6: NSVC 97 State Transition: NSVC_S_ALIVE_BLOCKED (3) -> NSVC_S_ALIVE_UNBLOCKED (4) [38;5;57m20240816120322517 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x555bfb2dbe10]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m SGSN_Test-Gb1-NS1(408)@a6473498aab6: Creating NSIP provider for "127.0.0.103":21011 SGSN_Test-Gb0-BSSGP0(404)@a6473498aab6: BVCI(0) Rx BVC-RESET-ACK SGSN_Test-Gb0-BSSGP0(404)@a6473498aab6: BVCI(0) State Transition: BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) -> BVC_S_UNBLOCKED (3) [38;5;57m20240816120322521 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x555bfb2dbe10]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m [38;5;59m20240816120322521 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m Cell 262-42-13135-0 CI 20960 on BVCI 196 (gprs_bssgp.c:400)[0;m TC_hlr_location_cancel_request_unknown_subscriber_withdraw-BVCI196(406)@a6473498aab6: BVCI(196) State Transition: BVC_S_BLOCKED (2) -> BVC_S_UNBLOCKED (3) SGSN_Test-Gb1-BSSGP1(409)@a6473498aab6: BVCI(0) State Transition: BVC_S_WAIT_RESET (0) -> BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) SGSN_Test-Gb1-NS1(408)@a6473498aab6: Starting NSVC component for { provider := { ip := { address_family := AF_INET (2), local_udp_port := 21011, local_ip := "127.0.0.103", remote_udp_port := 23000, remote_ip := "127.0.0.10", data_weight := 1, signalling_weight := 1 } }, nsvci := 98 } -NSVCI98(412)@a6473498aab6: NSVC 98 State Transition: NSVC_S_DEAD_BLOCKED (1) -> NSVC_S_DEAD_BLOCKED (1) -NSVCI98(412)@a6473498aab6: Provider Link came up: sending NS-RESET [38;5;63m20240816120322529 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Rx NS-RESET (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322529 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x555bfb2de2a0]{UNBLOCKED}: Received Event RX-RESET (gprs_ns2_vc_fsm.c:934)[0;m [38;5;57m20240816120322529 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x555bfb2de2a0]{UNBLOCKED}: state_chg to RESET (gprs_ns2_vc_fsm.c:657)[0;m [38;5;57m20240816120322529 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00097) NS-STATUS.ind(bvci=00000): cause=NSE failure, transfer=0, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816120322529 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 97 became unavailable (gprs_ns.c:54) [38;5;63m20240816120322529 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Tx NS-RESET-ACK (gprs_ns2_message.c:331)[0;m [38;5;57m20240816120322529 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x555bfb2de2a0]{RESET}: state_chg to BLOCKED (gprs_ns2_vc_fsm.c:329)[0;m [38;5;63m20240816120322529 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m [38;5;57m20240816120322529 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x555bfb2de2a0]{BLOCKED}: Starting Tns-alive of 3 seconds (gprs_ns2_vc_fsm.c:177)[0;m [38;5;63m20240816120322530 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Rx NS-ALIVE (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322530 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x555bfb2de2a0]{BLOCKED}: Received Event RX-ALIVE (gprs_ns2_vc_fsm.c:957)[0;m -NSVCI98(412)@a6473498aab6: NSVC 98 State Transition: NSVC_S_WAIT_RESET (2) -> NSVC_S_ALIVE_BLOCKED (3) [38;5;63m20240816120322530 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Tx NS-ALIVE-ACK (gprs_ns2_message.c:193)[0;m [38;5;63m20240816120322530 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Rx NS-UNBLOCK (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322530 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x555bfb2de2a0]{BLOCKED}: Received Event RX-UNBLOCK (gprs_ns2_vc_fsm.c:951)[0;m [38;5;63m20240816120322530 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Tx NS-UNBLOCK-ACK (gprs_ns2_message.c:193)[0;m [38;5;57m20240816120322530 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x555bfb2de2a0]{BLOCKED}: state_chg to UNBLOCKED (gprs_ns2_vc_fsm.c:414)[0;m [38;5;57m20240816120322530 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00097) NS-STATUS.ind(bvci=00000): cause=NSE recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816120322530 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 97 became available (gprs_ns.c:43) [38;5;57m20240816120322530 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00097)-NSVC(00098) NS-STATUS.ind(bvci=00000): cause=NSVC recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:571)[0;m 20240816120322530 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS: indication Unknown prim 2 from NS (gprs_ns.c:57) [38;5;63m20240816120322530 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322530 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x555bfb2de2a0]{UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m -NSVCI98(412)@a6473498aab6: Rx NS-ALIVE-ACK: stopping Tns-alive; starting Tns-test -NSVCI98(412)@a6473498aab6: NSVC 98 State Transition: NSVC_S_ALIVE_BLOCKED (3) -> NSVC_S_ALIVE_UNBLOCKED (4) [38;5;57m20240816120322532 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x555bfb2de2a0]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m SGSN_Test-Gb2-NS2(413)@a6473498aab6: Creating NSIP provider for "127.0.0.103":21012 SGSN_Test-Gb1-BSSGP1(409)@a6473498aab6: BVCI(0) Rx BVC-RESET-ACK SGSN_Test-Gb1-BSSGP1(409)@a6473498aab6: BVCI(0) State Transition: BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) -> BVC_S_UNBLOCKED (3) [38;5;57m20240816120322535 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x555bfb2de2a0]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m [38;5;59m20240816120322536 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m Cell 262-42-13200-0 CI 20961 on BVCI 210 (gprs_bssgp.c:400)[0;m TC_hlr_location_cancel_request_unknown_subscriber_withdraw-BVCI210(411)@a6473498aab6: BVCI(210) State Transition: BVC_S_BLOCKED (2) -> BVC_S_UNBLOCKED (3) SGSN_Test-Gb2-BSSGP2(414)@a6473498aab6: BVCI(0) State Transition: BVC_S_WAIT_RESET (0) -> BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) SGSN_Test-Gb2-NS2(413)@a6473498aab6: Starting NSVC component for { provider := { ip := { address_family := AF_INET (2), local_udp_port := 21012, local_ip := "127.0.0.103", remote_udp_port := 23000, remote_ip := "127.0.0.10", data_weight := 1, signalling_weight := 1 } }, nsvci := 99 } -NSVCI99(417)@a6473498aab6: NSVC 99 State Transition: NSVC_S_DEAD_BLOCKED (1) -> NSVC_S_DEAD_BLOCKED (1) -NSVCI99(417)@a6473498aab6: Provider Link came up: sending NS-RESET [38;5;63m20240816120322543 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Rx NS-RESET (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322543 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x555bfb2dfd00]{UNBLOCKED}: Received Event RX-RESET (gprs_ns2_vc_fsm.c:934)[0;m [38;5;57m20240816120322543 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x555bfb2dfd00]{UNBLOCKED}: state_chg to RESET (gprs_ns2_vc_fsm.c:657)[0;m [38;5;57m20240816120322544 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00098) NS-STATUS.ind(bvci=00000): cause=NSE failure, transfer=0, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816120322544 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 98 became unavailable (gprs_ns.c:54) [38;5;63m20240816120322544 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Tx NS-RESET-ACK (gprs_ns2_message.c:331)[0;m [38;5;57m20240816120322544 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x555bfb2dfd00]{RESET}: state_chg to BLOCKED (gprs_ns2_vc_fsm.c:329)[0;m [38;5;63m20240816120322544 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m [38;5;57m20240816120322544 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x555bfb2dfd00]{BLOCKED}: Starting Tns-alive of 3 seconds (gprs_ns2_vc_fsm.c:177)[0;m -NSVCI99(417)@a6473498aab6: NSVC 99 State Transition: NSVC_S_WAIT_RESET (2) -> NSVC_S_ALIVE_BLOCKED (3) [38;5;63m20240816120322544 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Rx NS-ALIVE (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322544 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x555bfb2dfd00]{BLOCKED}: Received Event RX-ALIVE (gprs_ns2_vc_fsm.c:957)[0;m [38;5;63m20240816120322544 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Tx NS-ALIVE-ACK (gprs_ns2_message.c:193)[0;m [38;5;63m20240816120322544 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Rx NS-UNBLOCK (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322544 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x555bfb2dfd00]{BLOCKED}: Received Event RX-UNBLOCK (gprs_ns2_vc_fsm.c:951)[0;m [38;5;63m20240816120322544 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Tx NS-UNBLOCK-ACK (gprs_ns2_message.c:193)[0;m [38;5;57m20240816120322544 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x555bfb2dfd00]{BLOCKED}: state_chg to UNBLOCKED (gprs_ns2_vc_fsm.c:414)[0;m [38;5;57m20240816120322544 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00098) NS-STATUS.ind(bvci=00000): cause=NSE recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816120322544 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 98 became available (gprs_ns.c:43) [38;5;57m20240816120322544 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00098)-NSVC(00099) NS-STATUS.ind(bvci=00000): cause=NSVC recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:571)[0;m 20240816120322544 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS: indication Unknown prim 2 from NS (gprs_ns.c:57) [38;5;63m20240816120322544 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m [38;5;57m20240816120322544 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x555bfb2dfd00]{UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m -NSVCI99(417)@a6473498aab6: Rx NS-ALIVE-ACK: stopping Tns-alive; starting Tns-test -NSVCI99(417)@a6473498aab6: NSVC 99 State Transition: NSVC_S_ALIVE_BLOCKED (3) -> NSVC_S_ALIVE_UNBLOCKED (4) [38;5;57m20240816120322546 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x555bfb2dfd00]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m SGSN_Test-Gb2-BSSGP2(414)@a6473498aab6: BVCI(0) Rx BVC-RESET-ACK SGSN_Test-Gb2-BSSGP2(414)@a6473498aab6: BVCI(0) State Transition: BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) -> BVC_S_UNBLOCKED (3) [38;5;57m20240816120322549 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x555bfb2dfd00]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m [38;5;59m20240816120322549 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m Cell 262-42-13200-0 CI 20962 on BVCI 220 (gprs_bssgp.c:400)[0;m TC_hlr_location_cancel_request_unknown_subscriber_withdraw-BVCI220(416)@a6473498aab6: BVCI(220) State Transition: BVC_S_BLOCKED (2) -> BVC_S_UNBLOCKED (3) [38;5;39m20240816120323354 [1;33mDLGSUP[0;m[38;5;39m [1;33mNOTICE[0;m[38;5;39m GSUP connecting to 127.0.0.103:4222 (gsup_client.c:74)[0;m [38;5;23m20240816120323354 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m 127.0.0.103:4222 connection done (ipa.c:143)[0;m [38;5;39m20240816120323354 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m GSUP link to 127.0.0.103:4222 UP (gsup_client.c:151)[0;m [38;5;39m20240816120323354 [1;34mDLGSUP[0;m[38;5;39m [1;34mDEBUG[0;m[38;5;39m GSUP sending PING (gsup_client.c:288)[0;m SGSN_Test-GSUP-IPA(418)@a6473498aab6: Established a new IPA connection (conn_id=2) SGSN_Test-GSUP-IPA(418)@a6473498aab6: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } [38;5;23m20240816120323358 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m received ID_GET for unit ID 0/0/0 (ipaccess.c:897)[0;m SGSN_Test-GSUP-IPA(418)@a6473498aab6: CCM Rx:{ msg_type := IPAC_MSGT_PING (0), u := omit } SGSN_Test-GSUP-IPA(418)@a6473498aab6: CCM Tx:{ msg_type := IPAC_MSGT_PONG (1), u := omit } SGSN_Test-GSUP-IPA(418)@a6473498aab6: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 24, tag := IPAC_IDTAG_UNITNAME (1), data := '5347534E2D30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } } } SGSN_Test-GSUP-IPA(418)@a6473498aab6: IPA ID RESP: { { len := 24, tag := IPAC_IDTAG_UNITNAME (1), data := '5347534E2D30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } [38;5;39m20240816120323359 [1;34mDLGSUP[0;m[38;5;39m [1;34mDEBUG[0;m[38;5;39m GSUP receiving PONG (gsup_client.c:225)[0;m SGSN_Test-GSUP-IPA(418)@a6473498aab6: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } SGSN_Test-GSUP-IPA(418)@a6473498aab6: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } TC_hlr_location_cancel_request_unknown_subscriber_withdraw-BVCI196(406)@a6473498aab6: Adding Client=TC_hlr_location_cancel_request_unknown_subscriber_withdraw(421), IMSI='262420000000030'H, TLLI='F55B3882'O, index=0 SGSN_Test-GSUP(419)@a6473498aab6: Created GsupExpect[0] for "262420000000030" to be handled at TC_hlr_location_cancel_request_unknown_subscriber_withdraw(421) 20240816120324393 [1;32mDGPRS[0;m [1;32mINFO[0;m SUBSCR(---) Sending GSUP, will send: 1d 01 08 62 42 02 00 00 00 30 f0 02 01 02 28 01 01 (gprs_subscriber.c:210) 20240816120324393 [1;33mDGPRS[0;m [1;33mNOTICE[0;m Unknown IMSI 262420000000030, discarding GSUP request of type 0x1c (gprs_subscriber.c:661) SGSN_Test-GSUP(419)@a6473498aab6: Found GsupExpect[0] for "262420000000030" handled at TC_hlr_location_cancel_request_unknown_subscriber_withdraw(421) SGSN_Test-GSUP(419)@a6473498aab6: Added IMSI table entry 0TC_hlr_location_cancel_request_unknown_subscriber_withdraw(421)"262420000000030" TC_hlr_location_cancel_request_unknown_subscriber_withdraw(421)@a6473498aab6: setverdict(pass): none -> pass TC_hlr_location_cancel_request_unknown_subscriber_withdraw-BVCI196(406)@a6473498aab6: Removing Client IMSI='262420000000030'H, index=0 TC_hlr_location_cancel_request_unknown_subscriber_withdraw(421)@a6473498aab6: Final verdict of PTC: pass 20240816120324396 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:58490<->l=127.0.0.10:4245 (telnet_interface.c:138) SGSN_Test-Gb1-BSSGP1(409)@a6473498aab6: Final verdict of PTC: none TC_hlr_location_cancel_request_unknown_subscriber_withdraw-BVCI210(411)@a6473498aab6: Final verdict of PTC: none TC_hlr_location_cancel_request_unknown_subscriber_withdraw-BVCI196(406)@a6473498aab6: Final verdict of PTC: none SGSN_Test-GSUP-IPA(418)@a6473498aab6: Final verdict of PTC: none [38;5;23m20240816120324398 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m 127.0.0.103:4222 connection closed with server (ipa.c:68)[0;m [38;5;39m20240816120324398 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m GSUP link to 127.0.0.103:4222 DOWN (gsup_client.c:151)[0;m SGSN_Test-Gb1-NS1(408)@a6473498aab6: Final verdict of PTC: none -NSVCI97-provIP(405)@a6473498aab6: Final verdict of PTC: none SGSN_Test-Gb2-BSSGP2(414)@a6473498aab6: Final verdict of PTC: none -NSVCI98(412)@a6473498aab6: Final verdict of PTC: none -NSVCI99(417)@a6473498aab6: Final verdict of PTC: none TC_hlr_location_cancel_request_unknown_subscriber_withdraw-BVCI220(416)@a6473498aab6: Final verdict of PTC: none -NSVCI98-provIP(410)@a6473498aab6: Final verdict of PTC: none -NSVCI97(407)@a6473498aab6: Final verdict of PTC: none SGSN_Test-Gb0-NS0(403)@a6473498aab6: Final verdict of PTC: none -NSVCI99-provIP(415)@a6473498aab6: Final verdict of PTC: none SGSN_Test-Gb2-NS2(413)@a6473498aab6: Final verdict of PTC: none SGSN_Test-GSUP(419)@a6473498aab6: Final verdict of PTC: none SGSN_Test-GGSN_GTP(420)@a6473498aab6: Final verdict of PTC: none SGSN_Test-Gb0-BSSGP0(404)@a6473498aab6: Final verdict of PTC: none MTC@a6473498aab6: Setting final verdict of the test case. MTC@a6473498aab6: Local verdict of MTC: none MTC@a6473498aab6: Local verdict of PTC SGSN_Test-Gb0-NS0(403): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-Gb0-BSSGP0(404): none (none -> none) MTC@a6473498aab6: Local verdict of PTC -NSVCI97-provIP(405): none (none -> none) MTC@a6473498aab6: Local verdict of PTC TC_hlr_location_cancel_request_unknown_subscriber_withdraw-BVCI196(406): none (none -> none) MTC@a6473498aab6: Local verdict of PTC -NSVCI97(407): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-Gb1-NS1(408): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-Gb1-BSSGP1(409): none (none -> none) MTC@a6473498aab6: Local verdict of PTC -NSVCI98-provIP(410): none (none -> none) MTC@a6473498aab6: Local verdict of PTC TC_hlr_location_cancel_request_unknown_subscriber_withdraw-BVCI210(411): none (none -> none) MTC@a6473498aab6: Local verdict of PTC -NSVCI98(412): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-Gb2-NS2(413): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-Gb2-BSSGP2(414): none (none -> none) MTC@a6473498aab6: Local verdict of PTC -NSVCI99-provIP(415): none (none -> none) MTC@a6473498aab6: Local verdict of PTC TC_hlr_location_cancel_request_unknown_subscriber_withdraw-BVCI220(416): none (none -> none) MTC@a6473498aab6: Local verdict of PTC -NSVCI99(417): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-GSUP-IPA(418): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-GSUP(419): none (none -> none) MTC@a6473498aab6: Local verdict of PTC SGSN_Test-GGSN_GTP(420): none (none -> none) MTC@a6473498aab6: Local verdict of PTC TC_hlr_location_cancel_request_unknown_subscriber_withdraw(421): pass (none -> pass) MTC@a6473498aab6: Test case TC_hlr_location_cancel_request_unknown_subscriber_withdraw finished. Verdict: pass MTC@a6473498aab6: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache/…> SGSN_Tests.TC_hlr_location_cancel_request_unknown_subscriber_withdraw pass'. Fri Aug 16 12:03:24 UTC 2024 [1;32m====== SGSN_Tests.TC_hlr_location_cancel_request_unknown_subscriber_withdraw pass ======[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=44516) Error: OCI runtime error: crun: the container `a6473498aab6080cd310c2e7facb778be7ff0a6ff937d362d2a2b2e7e29100c7` is not running [1;91m[testenv] podman container crashed![0m [0;94m[testenv][generic] Testsuite is done[0m [1;34m[testenv][generic] Stopping testsuite (2699682)[0m [1;34m[testenv][generic] Merging log files[0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache',> '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TERM=dumb', '-e', 'TESTENV_GIT_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache/…',> '-e', 'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_testen…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache/…>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-t', '-w', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/165/artifa…',> 'testenv-sgsn-generic-osmocom-nightly-20240816-1158-a86509fe', 'sh', '-c', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache/…> SGSN_Tests --rm >/dev/null'][0m Error: no container with name or ID "testenv-sgsn-generic-osmocom-nightly-20240816-1158-a86509fe" found: no such container [1;91m[testenv][generic] Command failed unexpectedly[0m [0;94m[testenv][generic] Command: ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache',> '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TERM=dumb', '-e', 'TESTENV_GIT_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache/…',> '-e', 'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_testen…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache/…>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-t', '-w', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/165/artifa…',> 'testenv-sgsn-generic-osmocom-nightly-20240816-1158-a86509fe', 'sh', '-c', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_cache/…> SGSN_Tests --rm >/dev/null'][0m [0;94m[testenv][generic] Returncode: 125[0m Traceback (most recent call last): File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/./teste…",> line 115, in <module> main() File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/./teste…",> line 104, in main run() File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/./teste…",> line 63, in run testenv.testsuite.run(cfg) File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_testen…",> line 199, in run merge_log_files(cfg) File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_testen…",> line 131, in merge_log_files testenv.cmd.run(cmd, cwd=cwd) File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_testen…",> line 86, in run return testenv.podman.exec_cmd(cmd, check=check, env=env, *args, **kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_testen…",> line 133, in exec_cmd testenv.cmd.run( File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_testen…",> line 103, in run exit_error_cmd(p, "Command failed unexpectedly") File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/ws/_testen…",> line 59, 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 [1;34m[testenv][generic] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-io_uring/165/artifa… [0m Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.

10 months, 3 weeks

1
0
0 0

Build failed in Jenkins: ttcn3-sgsn-test #2441

by jenkins＠lists.osmocom.org

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test/2441/display/redire…> Changes: ------------------------------------------ [...truncated 735.52 KB...] MTC@fabb34539fda: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test/ws/_cache/podman/os…> SGSN_Tests.TC_attach_auth_sai_timeout pass'. Fri Aug 16 05:50:15 UTC 2024 [1;32m====== SGSN_Tests.TC_attach_auth_sai_timeout pass ======[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=57296) [38;5;39m20240816055016429 [1;33mDLGSUP[0;m[38;5;39m [1;33mNOTICE[0;m[38;5;39m GSUP connecting to 127.0.0.103:4222 (gsup_client.c:74)[0;m [38;5;39m20240816055016429 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m GSUP link to 127.0.0.103:4222 DOWN (gsup_client.c:151)[0;m Waiting for packet dumper to finish... 1 (prev_count=57296, count=62684) [38;5;39m20240816055017430 [1;33mDLGSUP[0;m[38;5;39m [1;33mNOTICE[0;m[38;5;39m GSUP connecting to 127.0.0.103:4222 (gsup_client.c:74)[0;m [38;5;39m20240816055017430 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m GSUP link to 127.0.0.103:4222 DOWN (gsup_client.c:151)[0;m MTC@fabb34539fda: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test/ws/_cache/podman/os…> SGSN_Tests.TC_attach_auth_sai_timeout pass' was executed successfully (exit status: 0). MTC@fabb34539fda: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test/ws/_cache/podman/os…> SGSN_Tests.TC_attach_auth_sai_reject'. ------ SGSN_Tests.TC_attach_auth_sai_reject ------ Fri Aug 16 05:50:17 UTC 2024 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test/2441/artifact/logs/…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test/2441/artifact/logs/…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 [38;5;39m20240816055018431 [1;33mDLGSUP[0;m[38;5;39m [1;33mNOTICE[0;m[38;5;39m GSUP connecting to 127.0.0.103:4222 (gsup_client.c:74)[0;m [38;5;39m20240816055018431 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m GSUP link to 127.0.0.103:4222 DOWN (gsup_client.c:151)[0;m MTC@fabb34539fda: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test/ws/_cache/podman/os…> SGSN_Tests.TC_attach_auth_sai_reject' was executed successfully (exit status: 0). MTC@fabb34539fda: Test case TC_attach_auth_sai_reject started. 20240816055018526 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Accept()ed new telnet connection r=127.0.0.1:38218<->l=127.0.0.10:4245 (telnet_interface.c:192) [38;5;35m20240816055018528 [1;32mDLGTP[0;m[38;5;35m [1;32mINFO[0;m[38;5;35m Clearing req & resp retransmit queues (gsn.c:365)[0;m SGSN_Test-Gb0-NS0(136)@fabb34539fda: Creating NSIP provider for "127.0.0.103":21010 SGSN_Test-Gb0-BSSGP0(137)@fabb34539fda: BVCI(0) State Transition: BVC_S_WAIT_RESET (0) -> BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) SGSN_Test-Gb0-NS0(136)@fabb34539fda: Starting NSVC component for { provider := { ip := { address_family := AF_INET (2), local_udp_port := 21010, local_ip := "127.0.0.103", remote_udp_port := 23000, remote_ip := "127.0.0.10", data_weight := 1, signalling_weight := 1 } }, nsvci := 97 } -NSVCI97(140)@fabb34539fda: NSVC 97 State Transition: NSVC_S_DEAD_BLOCKED (1) -> NSVC_S_DEAD_BLOCKED (1) -NSVCI97(140)@fabb34539fda: Provider Link came up: sending NS-RESET [38;5;63m20240816055018559 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Rx NS-RESET (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018559 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{UNBLOCKED}: Received Event RX-RESET (gprs_ns2_vc_fsm.c:934)[0;m [38;5;57m20240816055018559 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{UNBLOCKED}: state_chg to RESET (gprs_ns2_vc_fsm.c:657)[0;m [38;5;57m20240816055018559 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00096) NS-STATUS.ind(bvci=00000): cause=NSE failure, transfer=0, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816055018559 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 96 became unavailable (gprs_ns.c:54) [38;5;63m20240816055018559 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Tx NS-RESET-ACK (gprs_ns2_message.c:331)[0;m [38;5;57m20240816055018559 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{RESET}: state_chg to BLOCKED (gprs_ns2_vc_fsm.c:329)[0;m [38;5;63m20240816055018559 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m [38;5;57m20240816055018559 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{BLOCKED}: Starting Tns-alive of 3 seconds (gprs_ns2_vc_fsm.c:177)[0;m [38;5;63m20240816055018559 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Rx NS-ALIVE (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018559 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{BLOCKED}: Received Event RX-ALIVE (gprs_ns2_vc_fsm.c:957)[0;m [38;5;63m20240816055018559 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Tx NS-ALIVE-ACK (gprs_ns2_message.c:193)[0;m [38;5;63m20240816055018559 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Rx NS-UNBLOCK (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018559 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{BLOCKED}: Received Event RX-UNBLOCK (gprs_ns2_vc_fsm.c:951)[0;m [38;5;63m20240816055018559 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Tx NS-UNBLOCK-ACK (gprs_ns2_message.c:193)[0;m [38;5;57m20240816055018559 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{BLOCKED}: state_chg to UNBLOCKED (gprs_ns2_vc_fsm.c:414)[0;m [38;5;57m20240816055018559 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00096) NS-STATUS.ind(bvci=00000): cause=NSE recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816055018559 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 96 became available (gprs_ns.c:43) [38;5;57m20240816055018559 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00096)-NSVC(00097) NS-STATUS.ind(bvci=00000): cause=NSVC recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:571)[0;m 20240816055018559 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS: indication Unknown prim 2 from NS (gprs_ns.c:57) -NSVCI97(140)@fabb34539fda: NSVC 97 State Transition: NSVC_S_WAIT_RESET (2) -> NSVC_S_ALIVE_BLOCKED (3) [38;5;63m20240816055018560 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00096)-NSVC(00097) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018560 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m -NSVCI97(140)@fabb34539fda: Rx NS-ALIVE-ACK: stopping Tns-alive; starting Tns-test -NSVCI97(140)@fabb34539fda: NSVC 97 State Transition: NSVC_S_ALIVE_BLOCKED (3) -> NSVC_S_ALIVE_UNBLOCKED (4) [38;5;57m20240816055018561 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m SGSN_Test-Gb1-NS1(141)@fabb34539fda: Creating NSIP provider for "127.0.0.103":21011 SGSN_Test-Gb0-BSSGP0(137)@fabb34539fda: BVCI(0) Rx BVC-RESET-ACK SGSN_Test-Gb0-BSSGP0(137)@fabb34539fda: BVCI(0) State Transition: BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) -> BVC_S_UNBLOCKED (3) [38;5;57m20240816055018565 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m [38;5;59m20240816055018565 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m Cell 262-42-13135-0 CI 20960 on BVCI 196 (gprs_bssgp.c:400)[0;m TC_attach_auth_sai_reject-BVCI196(139)@fabb34539fda: BVCI(196) State Transition: BVC_S_BLOCKED (2) -> BVC_S_UNBLOCKED (3) SGSN_Test-Gb1-BSSGP1(142)@fabb34539fda: BVCI(0) State Transition: BVC_S_WAIT_RESET (0) -> BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) SGSN_Test-Gb1-NS1(141)@fabb34539fda: Starting NSVC component for { provider := { ip := { address_family := AF_INET (2), local_udp_port := 21011, local_ip := "127.0.0.103", remote_udp_port := 23000, remote_ip := "127.0.0.10", data_weight := 1, signalling_weight := 1 } }, nsvci := 98 } -NSVCI98(145)@fabb34539fda: NSVC 98 State Transition: NSVC_S_DEAD_BLOCKED (1) -> NSVC_S_DEAD_BLOCKED (1) -NSVCI98(145)@fabb34539fda: Provider Link came up: sending NS-RESET [38;5;63m20240816055018573 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Rx NS-RESET (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018573 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x55cd1cba1980]{UNBLOCKED}: Received Event RX-RESET (gprs_ns2_vc_fsm.c:934)[0;m [38;5;57m20240816055018573 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x55cd1cba1980]{UNBLOCKED}: state_chg to RESET (gprs_ns2_vc_fsm.c:657)[0;m [38;5;57m20240816055018573 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00097) NS-STATUS.ind(bvci=00000): cause=NSE failure, transfer=0, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816055018573 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 97 became unavailable (gprs_ns.c:54) [38;5;63m20240816055018573 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Tx NS-RESET-ACK (gprs_ns2_message.c:331)[0;m [38;5;57m20240816055018573 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x55cd1cba1980]{RESET}: state_chg to BLOCKED (gprs_ns2_vc_fsm.c:329)[0;m [38;5;63m20240816055018573 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m [38;5;57m20240816055018573 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x55cd1cba1980]{BLOCKED}: Starting Tns-alive of 3 seconds (gprs_ns2_vc_fsm.c:177)[0;m -NSVCI98(145)@fabb34539fda: NSVC 98 State Transition: NSVC_S_WAIT_RESET (2) -> NSVC_S_ALIVE_BLOCKED (3) [38;5;63m20240816055018573 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Rx NS-ALIVE (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018573 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x55cd1cba1980]{BLOCKED}: Received Event RX-ALIVE (gprs_ns2_vc_fsm.c:957)[0;m [38;5;63m20240816055018573 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Tx NS-ALIVE-ACK (gprs_ns2_message.c:193)[0;m [38;5;63m20240816055018573 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Rx NS-UNBLOCK (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018573 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x55cd1cba1980]{BLOCKED}: Received Event RX-UNBLOCK (gprs_ns2_vc_fsm.c:951)[0;m [38;5;63m20240816055018573 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Tx NS-UNBLOCK-ACK (gprs_ns2_message.c:193)[0;m [38;5;57m20240816055018573 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x55cd1cba1980]{BLOCKED}: state_chg to UNBLOCKED (gprs_ns2_vc_fsm.c:414)[0;m [38;5;57m20240816055018573 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00097) NS-STATUS.ind(bvci=00000): cause=NSE recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816055018573 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 97 became available (gprs_ns.c:43) [38;5;57m20240816055018573 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00097)-NSVC(00098) NS-STATUS.ind(bvci=00000): cause=NSVC recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:571)[0;m 20240816055018573 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS: indication Unknown prim 2 from NS (gprs_ns.c:57) [38;5;63m20240816055018573 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00097)-NSVC(00098) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018573 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x55cd1cba1980]{UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m -NSVCI98(145)@fabb34539fda: Rx NS-ALIVE-ACK: stopping Tns-alive; starting Tns-test -NSVCI98(145)@fabb34539fda: NSVC 98 State Transition: NSVC_S_ALIVE_BLOCKED (3) -> NSVC_S_ALIVE_UNBLOCKED (4) [38;5;57m20240816055018575 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x55cd1cba1980]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m SGSN_Test-Gb2-NS2(146)@fabb34539fda: Creating NSIP provider for "127.0.0.103":21012 SGSN_Test-Gb1-BSSGP1(142)@fabb34539fda: BVCI(0) Rx BVC-RESET-ACK SGSN_Test-Gb1-BSSGP1(142)@fabb34539fda: BVCI(0) State Transition: BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) -> BVC_S_UNBLOCKED (3) [38;5;57m20240816055018579 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00097-NSVC00098-127_0_0_10:23000-127_0_0_103:21011)[0x55cd1cba1980]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m [38;5;59m20240816055018579 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m Cell 262-42-13200-0 CI 20961 on BVCI 210 (gprs_bssgp.c:400)[0;m TC_attach_auth_sai_reject-BVCI210(144)@fabb34539fda: BVCI(210) State Transition: BVC_S_BLOCKED (2) -> BVC_S_UNBLOCKED (3) SGSN_Test-Gb2-BSSGP2(147)@fabb34539fda: BVCI(0) State Transition: BVC_S_WAIT_RESET (0) -> BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) SGSN_Test-Gb2-NS2(146)@fabb34539fda: Starting NSVC component for { provider := { ip := { address_family := AF_INET (2), local_udp_port := 21012, local_ip := "127.0.0.103", remote_udp_port := 23000, remote_ip := "127.0.0.10", data_weight := 1, signalling_weight := 1 } }, nsvci := 99 } -NSVCI99(150)@fabb34539fda: NSVC 99 State Transition: NSVC_S_DEAD_BLOCKED (1) -> NSVC_S_DEAD_BLOCKED (1) -NSVCI99(150)@fabb34539fda: Provider Link came up: sending NS-RESET [38;5;63m20240816055018587 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Rx NS-RESET (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018587 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x55cd1cba3240]{UNBLOCKED}: Received Event RX-RESET (gprs_ns2_vc_fsm.c:934)[0;m [38;5;57m20240816055018587 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x55cd1cba3240]{UNBLOCKED}: state_chg to RESET (gprs_ns2_vc_fsm.c:657)[0;m [38;5;57m20240816055018587 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00098) NS-STATUS.ind(bvci=00000): cause=NSE failure, transfer=0, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816055018587 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 98 became unavailable (gprs_ns.c:54) [38;5;63m20240816055018587 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Tx NS-RESET-ACK (gprs_ns2_message.c:331)[0;m [38;5;57m20240816055018587 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x55cd1cba3240]{RESET}: state_chg to BLOCKED (gprs_ns2_vc_fsm.c:329)[0;m [38;5;63m20240816055018587 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m [38;5;57m20240816055018587 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x55cd1cba3240]{BLOCKED}: Starting Tns-alive of 3 seconds (gprs_ns2_vc_fsm.c:177)[0;m -NSVCI99(150)@fabb34539fda: NSVC 99 State Transition: NSVC_S_WAIT_RESET (2) -> NSVC_S_ALIVE_BLOCKED (3) [38;5;63m20240816055018587 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Rx NS-ALIVE (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018587 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x55cd1cba3240]{BLOCKED}: Received Event RX-ALIVE (gprs_ns2_vc_fsm.c:957)[0;m [38;5;63m20240816055018587 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Tx NS-ALIVE-ACK (gprs_ns2_message.c:193)[0;m [38;5;63m20240816055018587 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Rx NS-UNBLOCK (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018587 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x55cd1cba3240]{BLOCKED}: Received Event RX-UNBLOCK (gprs_ns2_vc_fsm.c:951)[0;m [38;5;63m20240816055018587 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Tx NS-UNBLOCK-ACK (gprs_ns2_message.c:193)[0;m [38;5;57m20240816055018587 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x55cd1cba3240]{BLOCKED}: state_chg to UNBLOCKED (gprs_ns2_vc_fsm.c:414)[0;m [38;5;57m20240816055018587 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00098) NS-STATUS.ind(bvci=00000): cause=NSE recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:575)[0;m 20240816055018587 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS-E 98 became available (gprs_ns.c:43) [38;5;57m20240816055018587 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(00098)-NSVC(00099) NS-STATUS.ind(bvci=00000): cause=NSVC recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:571)[0;m 20240816055018587 [1;33mDGPRS[0;m [1;33mNOTICE[0;m NS: indication Unknown prim 2 from NS (gprs_ns.c:57) [38;5;63m20240816055018587 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(00098)-NSVC(00099) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m [38;5;57m20240816055018587 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x55cd1cba3240]{UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m -NSVCI99(150)@fabb34539fda: Rx NS-ALIVE-ACK: stopping Tns-alive; starting Tns-test -NSVCI99(150)@fabb34539fda: NSVC 99 State Transition: NSVC_S_ALIVE_BLOCKED (3) -> NSVC_S_ALIVE_UNBLOCKED (4) [38;5;57m20240816055018589 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x55cd1cba3240]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m SGSN_Test-Gb2-BSSGP2(147)@fabb34539fda: BVCI(0) Rx BVC-RESET-ACK SGSN_Test-Gb2-BSSGP2(147)@fabb34539fda: BVCI(0) State Transition: BVC_S_WAIT_NS_ALIVE_UNBLOCKED (1) -> BVC_S_UNBLOCKED (3) [38;5;57m20240816055018593 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00098-NSVC00099-127_0_0_10:23000-127_0_0_103:21012)[0x55cd1cba3240]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m [38;5;59m20240816055018593 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m Cell 262-42-13200-0 CI 20962 on BVCI 220 (gprs_bssgp.c:400)[0;m TC_attach_auth_sai_reject-BVCI220(149)@fabb34539fda: BVCI(220) State Transition: BVC_S_BLOCKED (2) -> BVC_S_UNBLOCKED (3) [38;5;39m20240816055019432 [1;33mDLGSUP[0;m[38;5;39m [1;33mNOTICE[0;m[38;5;39m GSUP connecting to 127.0.0.103:4222 (gsup_client.c:74)[0;m [38;5;23m20240816055019432 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m 127.0.0.103:4222 connection done (ipa.c:143)[0;m [38;5;39m20240816055019432 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m GSUP link to 127.0.0.103:4222 UP (gsup_client.c:151)[0;m [38;5;39m20240816055019432 [1;34mDLGSUP[0;m[38;5;39m [1;34mDEBUG[0;m[38;5;39m GSUP sending PING (gsup_client.c:288)[0;m SGSN_Test-GSUP-IPA(151)@fabb34539fda: Established a new IPA connection (conn_id=2) SGSN_Test-GSUP-IPA(151)@fabb34539fda: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } [38;5;23m20240816055019436 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m received ID_GET for unit ID 0/0/0 (ipaccess.c:897)[0;m [38;5;39m20240816055019437 [1;34mDLGSUP[0;m[38;5;39m [1;34mDEBUG[0;m[38;5;39m GSUP receiving PONG (gsup_client.c:225)[0;m SGSN_Test-GSUP-IPA(151)@fabb34539fda: CCM Rx:{ msg_type := IPAC_MSGT_PING (0), u := omit } SGSN_Test-GSUP-IPA(151)@fabb34539fda: CCM Tx:{ msg_type := IPAC_MSGT_PONG (1), u := omit } SGSN_Test-GSUP-IPA(151)@fabb34539fda: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 24, tag := IPAC_IDTAG_UNITNAME (1), data := '5347534E2D30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } } } SGSN_Test-GSUP-IPA(151)@fabb34539fda: IPA ID RESP: { { len := 24, tag := IPAC_IDTAG_UNITNAME (1), data := '5347534E2D30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } SGSN_Test-GSUP-IPA(151)@fabb34539fda: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } SGSN_Test-GSUP-IPA(151)@fabb34539fda: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } TC_attach_auth_sai_reject-BVCI196(139)@fabb34539fda: Adding Client=TC_attach_auth_sai_reject(154), IMSI='262420000000004'H, TLLI='F5A900AA'O, index=0 SGSN_Test-GSUP(152)@fabb34539fda: Created GsupExpect[0] for "262420000000004" to be handled at TC_attach_auth_sai_reject(154) [38;5;57m20240816055019472 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m 20240816055019472 [1;33mDLLC[0;m [1;33mNOTICE[0;m LLME(ffffffff/f5a900aa){UNASSIGNED} LLC RX: unknown TLLI 0xf5a900aa, creating LLME on the fly (gprs_llc.c:552) 20240816055019472 [1;34mDLLC[0;m [1;34mDEBUG[0;m LLC SAPI=1 C U GEA0 IOV-UI=0x000000 FCS=0x24bf94 CMD=UI DATA (gprs_llc_parse.c:89) [1;33m20240816055019472 [1;32mDMM[0;m[1;33m [1;32mINFO[0;m[1;33m MM(---/ffffffff) -> GMM ATTACH REQUEST [0;m[1;33mMI(IMSI-262420000000004) type="GPRS attach" [0;m[1;33m (gprs_gmm.c:1266)[0;m [1;33m20240816055019472 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM(gmm_fsm)[0x55cd1cb9ed90]{Deregistered}: Allocated (fsm.c:456)[0;m [1;33m20240816055019472 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55cd1cba63a0]{Init}: Allocated (fsm.c:456)[0;m [1;33m20240816055019472 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m MM_STATE_Gb[0x55cd1cb9eff0]{Idle}: Allocated (fsm.c:456)[0;m [1;33m20240816055019472 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m MM_STATE_Iu[0x55cd1cb9eec0]{Detached}: Allocated (fsm.c:456)[0;m [1;33m20240816055019472 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM(gmm_fsm)[0x55cd1cb9ed90]{Deregistered}: Received Event E_GMM_COMMON_PROC_INIT_REQ (gprs_gmm.c:1144)[0;m [1;33m20240816055019472 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM(gmm_fsm)[0x55cd1cb9ed90]{Deregistered}: state_chg to CommonProcedureInitiated (gprs_gmm_fsm.c:49)[0;m 20240816055019472 [1;33mDLLC[0;m [1;33mNOTICE[0;m LLME(ffffffff/f5a900aa){UNASSIGNED} LLGM Assign pre (f5a900aa => cbfadb3d) (gprs_llc.c:1079) 20240816055019472 [1;33mDLLC[0;m [1;33mNOTICE[0;m LLME(f5a900aa/cbfadb3d){ASSIGNED} LLGM Assign post (f5a900aa => cbfadb3d) (gprs_llc.c:1125) [1;33m20240816055019472 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55cd1cba63a0]{Init}: Received Event E_ATTACH_REQ_RECV (gprs_gmm.c:1370)[0;m [1;33m20240816055019472 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55cd1cba63a0]{Init}: state_chg to CheckIdentity (gprs_gmm_attach.c:52)[0;m [1;33m20240816055019472 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m MM(262420000000004/cbfadb3d) <- GMM IDENTITY REQUEST: mi_type=IMEI (gprs_gmm.c:431)[0;m [38;5;57m20240816055019490 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(UDP-NSE00096-NSVC00097-127_0_0_10:23000-127_0_0_103:21010)[0x55cd1cb9dc10]{UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m 20240816055019490 [1;34mDLLC[0;m [1;34mDEBUG[0;m LLC SAPI=1 C U GEA0 IOV-UI=0x000000 FCS=0x612fca CMD=UI DATA (gprs_llc_parse.c:89) [1;33m20240816055019490 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m MM_STATE_Gb(0)[0x55cd1cb9eff0]{Idle}: Received Event E_MM_PDU_RECEPTION (gprs_gmm.c:2333)[0;m [1;33m20240816055019490 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m MM(262420000000004/cbfadb3d) -> GMM IDENTITY RESPONSE: MI=IMEI-499990000000040 (gprs_gmm.c:1084)[0;m [1;33m20240816055019490 [1;33mDMM[0;m[1;33m [1;33mNOTICE[0;m[1;33m MM(262420000000004/cbfadb3d) Stopping *inactive* MM timer 3370 (gprs_gmm.c:115)[0;m [1;33m20240816055019490 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55cd1cba63a0]{CheckIdentity}: Received Event E_IDEN_RESP_RECV (gprs_gmm.c:1128)[0;m [1;33m20240816055019490 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55cd1cba63a0]{CheckIdentity}: state_chg to Authenticate (gprs_gmm_attach.c:115)[0;m [1;33m20240816055019490 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55cd1cba63a0]{Authenticate}: state_chg to AskVLR (gprs_gmm_attach.c:143)[0;m [1;33m20240816055019490 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m MM(262420000000004/cbfadb3d) Requesting authorization (sgsn_auth.c:160)[0;m [1;33m20240816055019490 [1;32mDMM[0;m[1;33m [1;32mINFO[0;m[1;33m MM(262420000000004/cbfadb3d) Requesting authentication tuples (sgsn_auth.c:184)[0;m [1;33m20240816055019490 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m MM(262420000000004/cbfadb3d) Requesting subscriber authentication info (gprs_subscriber.c:921)[0;m 20240816055019490 [1;32mDGPRS[0;m [1;32mINFO[0;m SUBSCR(262420000000004) requesting auth info (gprs_subscriber.c:805) 20240816055019490 [1;32mDGPRS[0;m [1;32mINFO[0;m SUBSCR(262420000000004) Sending GSUP, will send: 08 01 08 62 42 02 00 00 00 00 f4 28 01 01 (gprs_subscriber.c:210) SGSN_Test-GSUP(152)@fabb34539fda: Found GsupExpect[0] for "262420000000004" handled at TC_attach_auth_sai_reject(154) SGSN_Test-GSUP(152)@fabb34539fda: Added IMSI table entry 0TC_attach_auth_sai_reject(154)"262420000000004" 20240816055019497 [1;32mDGPRS[0;m [1;32mINFO[0;m SUBSCR(262420000000004) Received GSUP message OSMO_GSUP_MSGT_SEND_AUTH_INFO_ERROR (gprs_subscriber.c:723) 20240816055019497 [1;34mDGPRS[0;m [1;34mDEBUG[0;m SUBSCR(262420000000004) Send authentication info has failed with cause 23, handled as: Invalid argument (gprs_subscriber.c:477) 20240816055019497 [1;31mDGPRS[0;m [1;31mERROR[0;m SUBSCR(262420000000004) GSUP protocol remote error, GMM cause = 'GSM authentication unacceptable' (23) (gprs_subscriber.c:511) [1;33m20240816055025491 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55cd1cba63a0]{AskVLR}: Timeout of T3350 (fsm.c:317)[0;m [1;33m20240816055025491 [1;31mDMM[0;m[1;33m [1;31mERROR[0;m[1;33m MM(262420000000004/cbfadb3d) HLR did not answer in time. Rejecting. (gprs_gmm_attach.c:415)[0;m [1;33m20240816055025491 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55cd1cba63a0]{AskVLR}: Received Event E_REJECT (gprs_gmm_attach.c:416)[0;m [1;33m20240816055025491 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55cd1cba63a0]{AskVLR}: state_chg to Reject (gprs_gmm_attach.c:397)[0;m [1;33m20240816055025491 [1;33mDMM[0;m[1;33m [1;33mNOTICE[0;m[1;33m MM(262420000000004/cbfadb3d) <- GMM ATTACH REJECT: Network failure (gprs_gmm.c:364)[0;m [1;33m20240816055025491 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM_ATTACH_REQ_FSM(gb_gmm_req)[0x55cd1cba63a0]{Reject}: Deallocated (fsm.c:568)[0;m [1;33m20240816055025491 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m MM_STATE_Gb(0)[0x55cd1cb9eff0]{Idle}: Deallocated (fsm.c:568)[0;m [1;33m20240816055025491 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m MM_STATE_Iu[0x55cd1cb9eec0]{Detached}: Deallocated (fsm.c:568)[0;m [1;33m20240816055025491 [1;34mDMM[0;m[1;33m [1;34mDEBUG[0;m[1;33m GMM(gmm_fsm)[0x55cd1cb9ed90]{CommonProcedureInitiated}: Deallocated (fsm.c:568)[0;m 20240816055025491 [1;33mDLLC[0;m [1;33mNOTICE[0;m LLME(f5a900aa/cbfadb3d){ASSIGNED} LLGM Assign pre (cbfadb3d => ffffffff) (gprs_llc.c:1079) 20240816055025491 [1;33mDLLC[0;m [1;33mNOTICE[0;m LLME(00000000/00000000){UNASSIGNED} LLGM Assign post (cbfadb3d => ffffffff) (gprs_llc.c:1125) TC_attach_auth_sai_reject(154)@fabb34539fda: setverdict(pass): none -> pass TC_attach_auth_sai_reject-BVCI196(139)@fabb34539fda: Removing Client IMSI='262420000000004'H, index=0 TC_attach_auth_sai_reject(154)@fabb34539fda: Final verdict of PTC: pass 20240816055025503 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:38218<->l=127.0.0.10:4245 (telnet_interface.c:138) SGSN_Test-Gb1-NS1(141)@fabb34539fda: Final verdict of PTC: none TC_attach_auth_sai_reject-BVCI196(139)@fabb34539fda: Final verdict of PTC: none -NSVCI98(145)@fabb34539fda: Final verdict of PTC: none SGSN_Test-Gb0-BSSGP0(137)@fabb34539fda: Final verdict of PTC: none -NSVCI97(140)@fabb34539fda: Final verdict of PTC: none -NSVCI99(150)@fabb34539fda: Final verdict of PTC: none SGSN_Test-GSUP(152)@fabb34539fda: Final verdict of PTC: none TC_attach_auth_sai_reject-BVCI220(149)@fabb34539fda: Final verdict of PTC: none SGSN_Test-Gb1-BSSGP1(142)@fabb34539fda: Final verdict of PTC: none SGSN_Test-Gb2-BSSGP2(147)@fabb34539fda: Final verdict of PTC: none [38;5;23m20240816055025507 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m 127.0.0.103:4222 connection closed with server (ipa.c:68)[0;m [38;5;39m20240816055025507 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m GSUP link to 127.0.0.103:4222 DOWN (gsup_client.c:151)[0;m -NSVCI97-provIP(138)@fabb34539fda: Final verdict of PTC: none -NSVCI98-provIP(143)@fabb34539fda: Final verdict of PTC: none SGSN_Test-GGSN_GTP(153)@fabb34539fda: Final verdict of PTC: none SGSN_Test-Gb0-NS0(136)@fabb34539fda: Final verdict of PTC: none SGSN_Test-GSUP-IPA(151)@fabb34539fda: Final verdict of PTC: none -NSVCI99-provIP(148)@fabb34539fda: Final verdict of PTC: none TC_attach_auth_sai_reject-BVCI210(144)@fabb34539fda: Final verdict of PTC: none SGSN_Test-Gb2-NS2(146)@fabb34539fda: Final verdict of PTC: none MTC@fabb34539fda: Setting final verdict of the test case. MTC@fabb34539fda: Local verdict of MTC: none MTC@fabb34539fda: Local verdict of PTC SGSN_Test-Gb0-NS0(136): none (none -> none) MTC@fabb34539fda: Local verdict of PTC SGSN_Test-Gb0-BSSGP0(137): none (none -> none) MTC@fabb34539fda: Local verdict of PTC -NSVCI97-provIP(138): none (none -> none) MTC@fabb34539fda: Local verdict of PTC TC_attach_auth_sai_reject-BVCI196(139): none (none -> none) MTC@fabb34539fda: Local verdict of PTC -NSVCI97(140): none (none -> none) MTC@fabb34539fda: Local verdict of PTC SGSN_Test-Gb1-NS1(141): none (none -> none) MTC@fabb34539fda: Local verdict of PTC SGSN_Test-Gb1-BSSGP1(142): none (none -> none) MTC@fabb34539fda: Local verdict of PTC -NSVCI98-provIP(143): none (none -> none) MTC@fabb34539fda: Local verdict of PTC TC_attach_auth_sai_reject-BVCI210(144): none (none -> none) MTC@fabb34539fda: Local verdict of PTC -NSVCI98(145): none (none -> none) MTC@fabb34539fda: Local verdict of PTC SGSN_Test-Gb2-NS2(146): none (none -> none) MTC@fabb34539fda: Local verdict of PTC SGSN_Test-Gb2-BSSGP2(147): none (none -> none) MTC@fabb34539fda: Local verdict of PTC -NSVCI99-provIP(148): none (none -> none) MTC@fabb34539fda: Local verdict of PTC TC_attach_auth_sai_reject-BVCI220(149): none (none -> none) MTC@fabb34539fda: Local verdict of PTC -NSVCI99(150): none (none -> none) MTC@fabb34539fda: Local verdict of PTC SGSN_Test-GSUP-IPA(151): none (none -> none) MTC@fabb34539fda: Local verdict of PTC SGSN_Test-GSUP(152): none (none -> none) MTC@fabb34539fda: Local verdict of PTC SGSN_Test-GGSN_GTP(153): none (none -> none) MTC@fabb34539fda: Local verdict of PTC TC_attach_auth_sai_reject(154): pass (none -> pass) MTC@fabb34539fda: Test case TC_attach_auth_sai_reject finished. Verdict: pass MTC@fabb34539fda: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test/ws/_cache/podman/os…> SGSN_Tests.TC_attach_auth_sai_reject pass'. Fri Aug 16 05:50:25 UTC 2024 [1;32m====== SGSN_Tests.TC_attach_auth_sai_reject pass ======[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=59132) [1;91m[testenv][generic] sgsn crashed![0m [1;34m[testenv][generic] Stopping testsuite (184058)[0m Error: container fabb34539fdac3c5d361078532cb9a0a344bcbe86c818e2ca941e2f4272fd8bd does not exist in database: no such container [1;91m[testenv] podman container crashed![0m [1;34m[testenv][generic] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test/2441/artifact/logs/ [0m Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.

10 months, 3 weeks

1
0
0 0

Jenkins build is back to stable : ttcn3-sgsn-test-sns #118

by jenkins＠lists.osmocom.org

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-sns/118/display/red…>

10 months, 3 weeks

1
0
0 0

Jenkins build became unstable: ttcn3-sgsn-test-sns-latest #114

by jenkins＠lists.osmocom.org

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-sgsn-test-sns-latest/114/disp…>

10 months, 3 weeks

1
1
0 0

Jenkins build became unstable: ttcn3-sccp-test #1685

by jenkins＠lists.osmocom.org

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

10 months, 3 weeks

1
1
0 0

Build failed in Jenkins: Osmocom_OBS_master #65116

by jenkins＠lists.osmocom.org

See <https://jenkins.osmocom.org/jenkins/job/Osmocom_OBS_master/65116/display/re…> Changes: ------------------------------------------ Started by upstream project "master-osmo-msc" build number 45009 originally caused by: Started by timer Running as SYSTEM Building remotely on build2-deb10build-ansible (obs osmo-gsm-tester-build osmocom-master-debian10 ttcn3-ggsn-test-kernel-git osmocom-gerrit-debian10 osmocom-gerrit repo-install-test 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.20.1' > 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 c6ab7a2f7ac0e1ddf5e080495080324c63d3df9c (origin/master) > git config core.sparsecheckout # timeout=10 > git checkout -f c6ab7a2f7ac0e1ddf5e080495080324c63d3df9c # timeout=10 Commit message: "Update Release.key for Osmocom OBS" > git rev-list --no-walk c6ab7a2f7ac0e1ddf5e080495080324c63d3df9c # timeout=10 [Osmocom_OBS_master] $ /bin/sh -xe /tmp/jenkins8179057610972618770.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-12-osmocom-obs-build-srcpkg + run_in_docker_and_exit(): ['docker', 'build', '--build-arg', 'DISTRO=debian:12', '--build-arg', 'DISTRO_FROM=debian:12', '--build-arg', 'UID=1000', '-t', 'debian-12-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: 561B done #1 DONE 0.0s #2 [internal] load metadata for docker.io/library/debian:12 #2 DONE 0.8s #3 [internal] load .dockerignore #3 transferring context: 2B done #3 DONE 0.0s #4 [1/3] FROM docker.io/library/debian:12@sha256:aadf411dc9ed5199bc7dab48b3e6ce18f8bbee4f170127f5ff1b75cd8035eb36 #4 resolve docker.io/library/debian:12@sha256:aadf411dc9ed5199bc7dab48b3e6ce18f8bbee4f170127f5ff1b75cd8035eb36 0.0s done #4 DONE 0.1s #5 [2/3] RUN APT-GET update && apt-get upgrade -y && apt-get install -y --no-install-recommends ca-certificates colordiff debhelper dh-python dpkg-dev fakeroot git git-review gnupg2 libxml2-utils lsb-release meson osc python3-packaging python3-setuptools quilt rebar3 sed && apt-get clean #5 CACHED #6 [3/3] RUN USERADD --uid=1000 -m user #6 CACHED #7 exporting to image #7 exporting layers done #7 writing image sha256:f79c0dfb57184a52c2eb56b3ab5631a05ad791654e31739fe25e3ce160b74701 0.0s done #7 naming to docker.io/library/debian-12-osmocom-obs-build-srcpkg 0.0s done #7 DONE 0.0s docker: running: update_obs_project.py inside docker OBS: getting packages in osmocom:master ### Building source packages ### osmocom-master: getting OBS version osmocom-master: skipping (1.0.0 is up-to-date) erlang/osmo_dia2gsup: getting head from git remote for master erlang/osmo_dia2gsup: getting OBS version erlang/osmo_dia2gsup: skipping (f3653a5f9dc8b503313caa53b32aa1f2f232ac0d is up-to-date) erlang/osmo-epdg: getting head from git remote for master erlang/osmo-epdg: getting OBS version erlang/osmo-epdg: skipping (1b7038b8ff204008160a998525a7dff2e38de51d is up-to-date) erlang/osmo-s1gw: getting head from git remote for master erlang/osmo-s1gw: getting OBS version erlang/osmo-s1gw: skipping (c6c7b6f6b7ea453f868f6282630b80c743bfdfb8 is up-to-date) gapk: getting head from git remote for master gapk: getting OBS version gapk: skipping (70dd4311fbfbbc3cc908c1c3b5ac63d56a35c0f1 is up-to-date) libasn1c: getting head from git remote for master libasn1c: getting OBS version libasn1c: skipping (de520a417a95f47ec13b895b7c129d2969b791d7 is up-to-date) libgtpnl: getting head from git remote for master libgtpnl: getting OBS version libgtpnl: skipping (33afef9794cd44541d7e337a89830cd83f6611e4 is up-to-date) libosmo-abis: getting head from git remote for master libosmo-abis: getting OBS version libosmo-abis: skipping (4bd83dfd71afaf81e826febf79e63dd06abe73a3 is up-to-date) libosmo-dsp: getting head from git remote for master libosmo-dsp: getting OBS version libosmo-dsp: skipping (912827c9da7def5069d88a3327aca018d339be62 is up-to-date) libosmo-gprs: getting head from git remote for master libosmo-gprs: getting OBS version libosmo-gprs: skipping (b226fd2702de34f4d43bb18f2d58272814f7cc8a is up-to-date) libosmo-netif: getting head from git remote for master libosmo-netif: getting OBS version libosmo-netif: skipping (01a7d4089f3c980bc3ae365f5b6b1aab4c2799d1 is up-to-date) libosmo-pfcp: getting head from git remote for master libosmo-pfcp: getting OBS version libosmo-pfcp: skipping (c7ff5ab7a8e4a8089385b130fd4575f3cf4e50b9 is up-to-date) libosmo-sccp: getting head from git remote for master libosmo-sccp: getting OBS version libosmo-sccp: skipping (428ea8407844f3313ce611365bffaaa7656c540a is up-to-date) libosmocore: getting head from git remote for master libosmocore: getting OBS version libosmocore: skipping (2e788a7b411a4d5e9c8bbf47479ddab2438a5ea6 is up-to-date) libsmpp34: getting head from git remote for master libsmpp34: getting OBS version libsmpp34: skipping (f1ec51db83de0d20b5ad0f88756016f289d5d268 is up-to-date) libusrp: getting head from git remote for master libusrp: getting OBS version libusrp: skipping (b125637fdff2b8f4552aaddf767fae5a2d26666a is up-to-date) osmo-bsc: getting head from git remote for master osmo-bsc: getting OBS version osmo-bsc: skipping (d6b09695366749992aff92331a49034f2c728616 is up-to-date) osmo-bsc-nat: getting head from git remote for master osmo-bsc-nat: getting OBS version osmo-bsc-nat: skipping (77c875491c9c38dea8400bc2ecc3a9b30dac0d6e is up-to-date) osmo-bts: getting head from git remote for master osmo-bts: getting OBS version osmo-bts: skipping (9512355ebc7f4a4c710b03bc2482a86248a0163c is up-to-date) osmo-cbc: getting head from git remote for master osmo-cbc: getting OBS version osmo-cbc: skipping (637874eaf9a05490fe50217b972a016158055a5f is up-to-date) osmo-e1d: getting head from git remote for master osmo-e1d: getting OBS version osmo-e1d: skipping (e11e77868a96f3bcec436ed5ccc34824b60dc6f1 is up-to-date) osmo-fl2k: getting head from git remote for master osmo-fl2k: getting OBS version osmo-fl2k: skipping (6c81d75b49c57e0661ce8e6c16ae49e420e62e2e is up-to-date) osmo-gbproxy: getting head from git remote for master osmo-gbproxy: getting OBS version osmo-gbproxy: skipping (c8113ce75a4278254ff64142da46df32eb95e437 is up-to-date) osmo-ggsn: getting head from git remote for master osmo-ggsn: getting OBS version osmo-ggsn: skipping (5f8960b206b908c99493435a5695b43a58d6c21e is up-to-date) osmo-gsm-manuals: getting head from git remote for master osmo-gsm-manuals: getting OBS version osmo-gsm-manuals: skipping (4527acf936dc732b450bd73d95cd72a950ab5c67 is up-to-date) osmo-hlr: getting head from git remote for master osmo-hlr: getting OBS version osmo-hlr: skipping (c819234a42af5f0c6a9114b605ff8365e89d770d is up-to-date) osmo-hnbgw: getting head from git remote for master osmo-hnbgw: getting OBS version osmo-hnbgw: skipping (61e278a452bf4fd240e45f1fe8c094a4b3795317 is up-to-date) osmo-hnodeb: getting head from git remote for master osmo-hnodeb: getting OBS version osmo-hnodeb: skipping (b6759ba06c2c8bd615c21822ee5b9863df41ad08 is up-to-date) osmo-iuh: getting head from git remote for master osmo-iuh: getting OBS version osmo-iuh: skipping (bb71c57a9ca42f74ef8d6a4fe56bef962352671c is up-to-date) osmo-mgw: getting head from git remote for master osmo-mgw: getting OBS version osmo-mgw: skipping (24cae67f3ec98a7390069ba52b13532a0dcef00c is up-to-date) osmo-msc: getting head from git remote for master osmo-msc: getting OBS version osmo-msc: skipping (24044221839cf8c7839d48ce99be2cc1a716cc12 is up-to-date) osmo-pcap: getting head from git remote for master osmo-pcap: getting OBS version osmo-pcap: skipping (bcb3b1b073d192674adc7285c7e928ede3f4e86c is up-to-date) osmo-pcu: getting head from git remote for master osmo-pcu: getting OBS version osmo-pcu: skipping (8734f1765ddcae61ebb0aa8fc0f8abdba875c669 is up-to-date) osmo-remsim: getting head from git remote for master osmo-remsim: getting OBS version osmo-remsim: skipping (5b8a2e93b47bee1251704a584f786c0d45c60d4b is up-to-date) osmo-sgsn: getting head from git remote for master osmo-sgsn: getting OBS version osmo-sgsn: skipping (140017e0edcfa817f2a185346fdc644a43459d45 is up-to-date) osmo-sip-connector: getting head from git remote for master osmo-sip-connector: getting OBS version osmo-sip-connector: skipping (7a3532e0eb07fe26b21af3a15e0c03da7b5e3f8f is up-to-date) osmo-smlc: getting head from git remote for master osmo-smlc: getting OBS version osmo-smlc: skipping (ccfd8e40ea49974da0105f8a7ada78a6ab357aec is up-to-date) osmo-sysmon: getting head from git remote for master osmo-sysmon: getting OBS version osmo-sysmon: skipping (4e7cd683b355f6b31123226f70c6b0c00df13655 is up-to-date) osmo-trx: getting head from git remote for master osmo-trx: getting OBS version osmo-trx: skipping (4f6e9eb4cf86d2678a39394d0ea66f44ecaa7883 is up-to-date) osmo-uecups: getting head from git remote for master osmo-uecups: getting OBS version osmo-uecups: skipping (0315f9d13f0a69412bb9a2f661911446a9b35c1d is up-to-date) osmo-upf: getting head from git remote for master osmo-upf: getting OBS version osmo-upf: skipping (3efa0196568c34f2898d13220ec9e7c66b832874 is up-to-date) osmocom-bb: getting head from git remote for master osmocom-bb: getting OBS version osmocom-bb: skipping (04ea6f9cab3d9d5120c77f88b500bad526564c0a is up-to-date) python/osmo-python-tests: getting head from git remote for master python/osmo-python-tests: getting OBS version python/osmo-python-tests: skipping (c3c8401b5a46e376f46560cc0c0ccc265de2c7fe is up-to-date) rtl-sdr: getting head from git remote for master rtl-sdr: getting OBS version rtl-sdr: skipping (619ac3186ea0ffc092615e1f59f7397e5e6f668c is up-to-date) simtrace2: getting head from git remote for master simtrace2: getting OBS version simtrace2: skipping (f9885fe019f42e247b74df6877167d786cb5f0ee is up-to-date) strongswan-epdg: getting head from git remote for master strongswan-epdg: getting OBS version strongswan-epdg: skipping (961bace455bb7fc3615a8ed4ddf6434e2d54820d is up-to-date) limesuite: getting head from git remote for master ERROR: command failed unexpectedly *** command *** ['git', 'ls-remote', 'https://github.com/myriadrf/LimeSuite', 'heads/master'] *** returncode *** 128 *** output *** fatal: unable to access 'https://github.com/myriadrf/LimeSuite/': The requested URL returned error: 502 *** 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 259, in main build_srcpkgs(pkgs_remote, packages) File "/obs/update_obs_project.py", line 151, in build_srcpkgs build_srcpkg_if_needed(pkgs_remote, package, False) File "/obs/update_obs_project.py", line 97, in build_srcpkg_if_needed latest_version = lib.git.get_head_remote(package, branch, ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/obs/lib/git.py", line 99, in get_head_remote ls_remote = lib.run_cmd(["git", "ls-remote", repo_url, f"heads/{branch}"]) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/obs/lib/__init__.py", line 200, in run_cmd exit_error_cmd(p, "command failed unexpectedly") File "/obs/lib/__init__.py", line 161, in exit_error_cmd raise RuntimeError("shell command related error, find details right above" RuntimeError: shell command related error, find details right above this python trace Build step 'Execute shell' marked build as failure

10 months, 3 weeks

1
2
0 0

Build failed in Jenkins: ttcn3-sccp-test-asan #66

by jenkins＠lists.osmocom.org

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-asan/66/display/red…> Changes: [Oliver Smith] ttcn3-epdg-test: fix osmo-epdg path for latest ------------------------------------------ [...truncated 90.48 KB...] + [ -n ] + set +x ### Installed Osmocom packages in: osmo-stp-master ### ii libosmo-netif-dev:amd64 1.5.1.202408122026 amd64 Development headers for Osmocom network interface ii libosmocodec4:amd64 1.10.0.2.2e788.202408122026 amd64 Osmo codec library ii libosmocoding0:amd64 1.10.0.2.2e788.202408122026 amd64 Osmo coding library ii libosmocore 1.10.0.2.2e788.202408122026 amd64 Open Source MObile COMmunications CORE library (metapackage) ii libosmocore-dev:amd64 1.10.0.2.2e788.202408122026 amd64 Development headers for Open Source MObile COMmunications CORE library ii libosmocore22:amd64 1.10.0.2.2e788.202408122026 amd64 Osmo Core library ii libosmoctrl0:amd64 1.10.0.2.2e788.202408122026 amd64 Osmo control library ii libosmogb14:amd64 1.10.0.2.2e788.202408122026 amd64 Osmo GPRS GB library ii libosmogsm20:amd64 1.10.0.2.2e788.202408122026 amd64 Osmo GSM utility library ii libosmoisdn0:amd64 1.10.0.2.2e788.202408122026 amd64 Osmo ISDN utility library ii libosmonetif11:amd64 1.5.1.202408122026 amd64 Common/shared code regarding network interface for OpenBSC ii libosmosim2:amd64 1.10.0.2.2e788.202408122026 amd64 Osmo SIM library ii libosmousb0:amd64 1.10.0.2.2e788.202408122026 amd64 Osmo USB library ii libosmovty13:amd64 1.10.0.2.2e788.202408122026 amd64 Osmo VTY library ii osmocom-nightly 202408122026 amd64 Dummy package, conflicts with ['osmocom-2022q1', 'osmocom-2022q2', 'osmocom-2023q1', 'osmocom-latest', 'osmocom-master', 'osmocom-nightly'] + [ registry.osmocom.org = registry.osmocom.org ] + docker_depends ttcn3-sccp-test + local feed + echo debian-bookworm-titan + depends=debian-bookworm-titan + [ -n debian-bookworm-titan ] + docker_images_require debian-bookworm-titan + local i + local from_line + local pull_arg + local upstream_distro_arg + local distro_arg + local depends + local dir + [ registry.osmocom.org = registry.osmocom.org ] + docker pull registry.osmocom.org/osmocom-build/debian-bookworm-titan Using default tag: latest latest: Pulling from osmocom-build/debian-bookworm-titan Digest: sha256:851b8221d34cd55aff2ddc69a155373cd728bef7895f02cd86596f0415ea5063 Status: Image is up to date for registry.osmocom.org/osmocom-build/debian-bookworm-titan:latest registry.osmocom.org/osmocom-build/debian-bookworm-titan:latest + continue + docker_distro_from_image_name ttcn3-sccp-test + echo debian-bookworm + distro_arg=debian-bookworm + [ -z ] + docker_upstream_distro_from_image_name ttcn3-sccp-test + echo debian:bookworm + upstream_distro_arg=debian:bookworm + docker_dir_from_image_name ttcn3-sccp-test + echo ttcn3-sccp-test + dir=ttcn3-sccp-test + pull_arg=--pull + grep ^FROM ../ttcn3-sccp-test/Dockerfile + from_line=FROM $REGISTRY/$USER/debian-bookworm-titan + echo FROM $REGISTRY/$USER/debian-bookworm-titan + grep -q $USER + pull_arg= + set +x Building image: ttcn3-sccp-test (export NO_DOCKER_IMAGE_BUILD=1 to prevent this) + docker_osmo_ttcn3_branch + [ -n ] + echo master + make -C ../ttcn3-sccp-test BUILD_ARGS= UPSTREAM_DISTRO=debian:bookworm DISTRO=debian-bookworm IMAGE=osmocom-build/ttcn3-sccp-test OSMO_TTCN3_BRANCH=master make: Entering directory '<https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-asan/ws/ttcn3-sccp-…'> awk: fatal: cannot open file `.release' for reading: No such file or directory awk: fatal: cannot open file `.release' for reading: No such file or directory awk: fatal: cannot open file `.release' for reading: No such file or directory rm -rf .common cp -r <https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-asan/ws/common> .common INFO: .release created release=0.0.0 docker build \ --build-arg USER=osmocom-build \ --build-arg UID=1000 \ --build-arg REGISTRY=registry.osmocom.org \ --build-arg OSMO_TTCN3_BRANCH=master \ --build-arg UPSTREAM_DISTRO=debian:bookworm \ --build-arg DISTRO=debian-bookworm \ --build-arg OSMOCOM_REPO_MIRROR=https://downloads.osmocom.org \ --build-arg OSMOCOM_REPO_PATH=packages/osmocom: \ --build-arg OSMOCOM_REPO_VERSION=asan \ --build-arg OSMOCOM_REPO_TESTSUITE_MIRROR=https://downloads.osmocom.org \ --build-arg ASTERISK_BRANCH=jolly/work \ --build-arg LIBOSMOCORE_BRANCH=master \ --build-arg OSMO_BB_BRANCH=master \ --build-arg OSMO_BSC_BRANCH=master \ --build-arg OSMO_BTS_BRANCH=master \ --build-arg OSMO_CBC_BRANCH=master \ --build-arg OSMO_DIA2GSUP_BRANCH=master \ --build-arg OSMO_EPDG_BRANCH=master \ --build-arg OSMO_GBPROXY_BRANCH=master \ --build-arg OSMO_GGSN_BRANCH=master \ --build-arg OSMO_GSM_TESTER_BRANCH=master \ --build-arg OSMO_HLR_BRANCH=master \ --build-arg OSMO_HNBGW_BRANCH=master \ --build-arg OSMO_HNODEB_BRANCH=master \ --build-arg OSMO_IUH_BRANCH=master \ --build-arg OSMO_MGW_BRANCH=master \ --build-arg OSMO_MSC_BRANCH=master \ --build-arg OSMO_NITB_BRANCH=master \ --build-arg OSMO_PCU_BRANCH=master \ --build-arg OSMO_SGSN_BRANCH=master \ --build-arg OSMO_SIP_BRANCH=master \ --build-arg OSMO_STP_BRANCH=master \ --build-arg OSMO_UECUPS_BRANCH=master \ --build-arg OPEN5GS_BRANCH=main \ --build-arg PJPROJECT_BRANCH=jolly/work \ -t osmocom-build/ttcn3-sccp-test:latest . #0 building with "default" instance using docker driver #1 [internal] load build definition from Dockerfile #1 transferring dockerfile: 390B done #1 DONE 0.0s #2 [internal] load metadata for registry.osmocom.org/osmocom-build/debian-bookworm-titan:latest #2 DONE 0.0s #3 [internal] load .dockerignore #3 transferring context: 2B done #3 DONE 0.0s #4 [1/4] FROM registry.osmocom.org/osmocom-build/debian-bookworm-titan:latest #4 DONE 0.0s #5 [internal] load build context #5 transferring context: 934B done #5 DONE 0.1s #6 https://gerrit.osmocom.org/plugins/gitiles/osmo-ttcn3-hacks/+/master?format… #6 DONE 0.2s #7 [2/4] ADD HTTPS://GERRIT.OSMOCOM.ORG/PLUGINS/GITILES/OSMO-TTCN3-HACKS/+/MASTER?FORMAT… /tmp/commit #7 CACHED #8 [3/4] RUN TTCN3-DOCKER-PREPARE "master" sccp #8 0.405 + OSMO_TTCN3_BRANCH=master #8 0.405 + shift #8 0.405 + cd /osmo-ttcn3-hacks #8 0.405 + git fetch #8 0.501 From https://gerrit.osmocom.org/osmo-ttcn3-hacks #8 0.501 * [new branch] neels/testenv -> origin/neels/testenv #8 0.505 + git checkout master #8 0.557 Already on 'master' #8 0.558 Your branch is up to date with 'origin/master'. #8 0.558 + git symbolic-ref -q HEAD #8 0.560 refs/heads/master #8 0.561 + git reset --hard origin/master #8 0.571 HEAD is now at 4d0ec2f8 testenv/testdir: fix typo #8 0.571 + git rev-parse --abbrev-ref HEAD #8 0.572 master #8 0.572 + git rev-parse HEAD #8 0.573 4d0ec2f852aca5a64b5b296de42ade18d09ecd4d #8 0.574 + diff -q /tmp/deps-Makefile deps/Makefile #8 0.574 Files /tmp/deps-Makefile and deps/Makefile differ #8 0.574 + make -j8 deps #8 0.628 (make -j16 -C deps || make -j1 -C deps) #8 0.629 make[1]: warning: -j16 forced in submake: resetting jobserver mode. #8 0.630 make[1]: Entering directory '/osmo-ttcn3-hacks/deps' #8 1.184 cd titan.ProtocolEmulations.M3UA && git fetch && if git rev-parse "origin/b58f92046e48a7b1ed531e243a2319ebca53bf4c" 2>/dev/null; then set -x && git checkout -q -f "origin/b58f92046e48a7b1ed531e243a2319ebca53bf4c"; else set -x && git checkout -q -f "b58f92046e48a7b1ed531e243a2319ebca53bf4c"; fi #8 1.185 cd titan.ProtocolModules.DIAMETER_ProtocolModule_Generator && git fetch && if git rev-parse "origin/ffd939595a08da1b8c8176aaa1f8578bfe02a912" 2>/dev/null; then set -x && git checkout -q -f "origin/ffd939595a08da1b8c8176aaa1f8578bfe02a912"; else set -x && git checkout -q -f "ffd939595a08da1b8c8176aaa1f8578bfe02a912"; fi #8 1.185 cd titan.ProtocolModules.GTP_v13.5.0 && git fetch && if git rev-parse "origin/6b769f985eb91bf5a4332f29faa4a043b23ce62e" 2>/dev/null; then set -x && git checkout -q -f "origin/6b769f985eb91bf5a4332f29faa4a043b23ce62e"; else set -x && git checkout -q -f "6b769f985eb91bf5a4332f29faa4a043b23ce62e"; fi #8 1.185 cd titan.ProtocolModules.ICMP && git fetch && if git rev-parse "origin/e49d9fb9f7de637b4bf4803dc6b6e911a8661640" 2>/dev/null; then set -x && git checkout -q -f "origin/e49d9fb9f7de637b4bf4803dc6b6e911a8661640"; else set -x && git checkout -q -f "e49d9fb9f7de637b4bf4803dc6b6e911a8661640"; fi #8 1.186 cd titan.ProtocolModules.ICMPv6 && git fetch && if git rev-parse "origin/46f4d9b6e1e3c794294a92588401a81e4881dd27" 2>/dev/null; then set -x && git checkout -q -f "origin/46f4d9b6e1e3c794294a92588401a81e4881dd27"; else set -x && git checkout -q -f "46f4d9b6e1e3c794294a92588401a81e4881dd27"; fi #8 1.186 cd titan.ProtocolModules.IP && git fetch && if git rev-parse "origin/1be86705f39ae38f3c04b2109806ee20d25e91d0" 2>/dev/null; then set -x && git checkout -q -f "origin/1be86705f39ae38f3c04b2109806ee20d25e91d0"; else set -x && git checkout -q -f "1be86705f39ae38f3c04b2109806ee20d25e91d0"; fi #8 1.186 cd titan.ProtocolModules.L2TP && git fetch && if git rev-parse "origin/17e76d3662bd0bb815158e8a9de1ec413f21b530" 2>/dev/null; then set -x && git checkout -q -f "origin/17e76d3662bd0bb815158e8a9de1ec413f21b530"; else set -x && git checkout -q -f "17e76d3662bd0bb815158e8a9de1ec413f21b530"; fi #8 1.187 cd titan.ProtocolModules.LLC_v7.1.0 && git fetch && if git rev-parse "origin/09817f113255d7fb56f1d45d3dd629a093d9248d" 2>/dev/null; then set -x && git checkout -q -f "origin/09817f113255d7fb56f1d45d3dd629a093d9248d"; else set -x && git checkout -q -f "09817f113255d7fb56f1d45d3dd629a093d9248d"; fi #8 1.187 cd titan.ProtocolModules.M3UA && git fetch && if git rev-parse "origin/c496d298876fed55c2b730278b7ee77982555563" 2>/dev/null; then set -x && git checkout -q -f "origin/c496d298876fed55c2b730278b7ee77982555563"; else set -x && git checkout -q -f "c496d298876fed55c2b730278b7ee77982555563"; fi #8 1.187 cd titan.ProtocolModules.MobileL3_v13.4.0 && git fetch && if git rev-parse "origin/b6602eb357673f097ea1a1d22edd568ecd239da1" 2>/dev/null; then set -x && git checkout -q -f "origin/b6602eb357673f097ea1a1d22edd568ecd239da1"; else set -x && git checkout -q -f "b6602eb357673f097ea1a1d22edd568ecd239da1"; fi #8 1.188 cd titan.ProtocolModules.PFCP_v15.1.0 && git fetch && if git rev-parse "origin/d550ad9ddb6f9c823c9a555254cd76cf0e738d18" 2>/dev/null; then set -x && git checkout -q -f "origin/d550ad9ddb6f9c823c9a555254cd76cf0e738d18"; else set -x && git checkout -q -f "d550ad9ddb6f9c823c9a555254cd76cf0e738d18"; fi #8 1.188 cd titan.TestPorts.TELNETasp && git fetch && if git rev-parse "origin/873fe539642542cd9a901c208f1ec11c6d2f5387" 2>/dev/null; then set -x && git checkout -q -f "origin/873fe539642542cd9a901c208f1ec11c6d2f5387"; else set -x && git checkout -q -f "873fe539642542cd9a901c208f1ec11c6d2f5387"; fi #8 1.189 cd titan.TestPorts.UDPasp && git fetch && if git rev-parse "origin/54176e95850654e5e8b0ffa2f1b5f35c412b949c" 2>/dev/null; then set -x && git checkout -q -f "origin/54176e95850654e5e8b0ffa2f1b5f35c412b949c"; else set -x && git checkout -q -f "54176e95850654e5e8b0ffa2f1b5f35c412b949c"; fi #8 1.189 cd titan.ProtocolModules.BSSGP_v13.0.0 && git fetch && if git rev-parse "origin/e97d92a8b66bec399babea52f593771b76cb175a" 2>/dev/null; then set -x && git checkout -q -f "origin/e97d92a8b66bec399babea52f593771b76cb175a"; else set -x && git checkout -q -f "e97d92a8b66bec399babea52f593771b76cb175a"; fi #8 1.190 cd osmo-uecups && git fetch && if git rev-parse "origin/8362efef7c6fa341eb947a75786878e0685767b7" 2>/dev/null; then set -x && git checkout -q -f "origin/8362efef7c6fa341eb947a75786878e0685767b7"; else set -x && git checkout -q -f "8362efef7c6fa341eb947a75786878e0685767b7"; fi #8 1.190 cd titan.ProtocolModules.BSSMAP && git fetch && if git rev-parse "origin/4acb6ab5f058477f0b90c2da182d52054e3614b0" 2>/dev/null; then set -x && git checkout -q -f "origin/4acb6ab5f058477f0b90c2da182d52054e3614b0"; else set -x && git checkout -q -f "4acb6ab5f058477f0b90c2da182d52054e3614b0"; fi #8 1.253 origin/8362efef7c6fa341eb947a75786878e0685767b7 #8 1.253 + git checkout -q -f 8362efef7c6fa341eb947a75786878e0685767b7 #8 1.257 cd titan.TestPorts.SIPmsg && git fetch && if git rev-parse "origin/b37ea251eff2d6cd4e8d317aff71d463863b59f9" 2>/dev/null; then set -x && git checkout -q -f "origin/b37ea251eff2d6cd4e8d317aff71d463863b59f9"; else set -x && git checkout -q -f "b37ea251eff2d6cd4e8d317aff71d463863b59f9"; fi #8 1.257 origin/4acb6ab5f058477f0b90c2da182d52054e3614b0 #8 1.258 + git checkout -q -f 4acb6ab5f058477f0b90c2da182d52054e3614b0 #8 1.326 origin/b37ea251eff2d6cd4e8d317aff71d463863b59f9 #8 1.326 + git checkout -q -f b37ea251eff2d6cd4e8d317aff71d463863b59f9 #8 1.499 origin/e97d92a8b66bec399babea52f593771b76cb175a #8 1.499 + git checkout -q -f e97d92a8b66bec399babea52f593771b76cb175a #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolModules.PFCP_v15.1.0/': Failed to connect to gitlab.eclipse.org port 443 after 130725 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolModules.DIAMETER_Pro…': Failed to connect to gitlab.eclipse.org port 443 after 130725 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolModules.MobileL3_v13…': Failed to connect to gitlab.eclipse.org port 443 after 130725 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolModules.M3UA/': Failed to connect to gitlab.eclipse.org port 443 after 130727 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolModules.IP/': Failed to connect to gitlab.eclipse.org port 443 after 130727 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolModules.ICMPv6/': Failed to connect to gitlab.eclipse.org port 443 after 130727 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolEmulations.M3UA/': Failed to connect to gitlab.eclipse.org port 443 after 130726 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolModules.ICMP/': Failed to connect to gitlab.eclipse.org port 443 after 130727 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.TestPorts.UDPasp/': Failed to connect to gitlab.eclipse.org port 443 after 130721 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.TestPorts.TELNETasp/': Failed to connect to gitlab.eclipse.org port 443 after 130724 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolModules.LLC_v7.1.0/': Failed to connect to gitlab.eclipse.org port 443 after 130726 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolModules.L2TP/': Failed to connect to gitlab.eclipse.org port 443 after 130726 ms: Couldn't connect to server #8 131.9 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolModules.GTP_v13.5.0/': Failed to connect to gitlab.eclipse.org port 443 after 130726 ms: Couldn't connect to server #8 131.9 make[1]: *** [Makefile:190: titan.TestPorts.UDPasp/update] Error 128 #8 131.9 make[1]: *** Waiting for unfinished jobs.... #8 131.9 make[1]: *** [Makefile:190: titan.ProtocolModules.ICMP/update] Error 128 #8 131.9 make[1]: *** [Makefile:190: titan.ProtocolModules.ICMPv6/update] Error 128 #8 131.9 make[1]: *** [Makefile:190: titan.ProtocolModules.IP/update] Error 128 #8 131.9 make[1]: *** [Makefile:190: titan.ProtocolModules.PFCP_v15.1.0/update] Error 128 #8 131.9 make[1]: *** [Makefile:190: titan.TestPorts.TELNETasp/update] Error 128 #8 131.9 make[1]: *** [Makefile:190: titan.ProtocolModules.GTP_v13.5.0/update] Error 128 #8 131.9 make[1]: *** [Makefile:190: titan.ProtocolModules.LLC_v7.1.0/update] Error 128 #8 131.9 make[1]: *** [Makefile:190: titan.ProtocolModules.DIAMETER_ProtocolModule_Generator/update] Error 128 #8 131.9 make[1]: *** [Makefile:190: titan.ProtocolModules.M3UA/update] Error 128 #8 131.9 make[1]: *** [Makefile:190: titan.ProtocolModules.MobileL3_v13.4.0/update] Error 128 #8 131.9 make[1]: *** [Makefile:190: titan.ProtocolModules.L2TP/update] Error 128 #8 131.9 make[1]: *** [Makefile:190: titan.ProtocolEmulations.M3UA/update] Error 128 #8 131.9 make[1]: Leaving directory '/osmo-ttcn3-hacks/deps' #8 131.9 make[1]: warning: -j1 forced in submake: resetting jobserver mode. #8 131.9 make[1]: Entering directory '/osmo-ttcn3-hacks/deps' #8 132.4 cd titan.ProtocolEmulations.M3UA && git fetch && if git rev-parse "origin/b58f92046e48a7b1ed531e243a2319ebca53bf4c" 2>/dev/null; then set -x && git checkout -q -f "origin/b58f92046e48a7b1ed531e243a2319ebca53bf4c"; else set -x && git checkout -q -f "b58f92046e48a7b1ed531e243a2319ebca53bf4c"; fi #8 263.0 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolEmulations.M3UA/': Failed to connect to gitlab.eclipse.org port 443 after 130538 ms: Couldn't connect to server #8 263.0 make[1]: Leaving directory '/osmo-ttcn3-hacks/deps' #8 263.0 make[1]: *** [Makefile:190: titan.ProtocolEmulations.M3UA/update] Error 128 #8 263.0 make: *** [Makefile:79: deps] Error 2 #8 ERROR: process "/bin/sh -c ttcn3-docker-prepare \"$OSMO_TTCN3_BRANCH\" sccp" did not complete successfully: exit code: 2 ------ > [3/4] RUN TTCN3-DOCKER-PREPARE "master" sccp: 131.9 make[1]: *** [Makefile:190: titan.ProtocolModules.L2TP/update] Error 128 131.9 make[1]: *** [Makefile:190: titan.ProtocolEmulations.M3UA/update] Error 128 131.9 make[1]: Leaving directory '/osmo-ttcn3-hacks/deps' 131.9 make[1]: warning: -j1 forced in submake: resetting jobserver mode. 131.9 make[1]: Entering directory '/osmo-ttcn3-hacks/deps' 132.4 cd titan.ProtocolEmulations.M3UA && git fetch && if git rev-parse "origin/b58f92046e48a7b1ed531e243a2319ebca53bf4c" 2>/dev/null; then set -x && git checkout -q -f "origin/b58f92046e48a7b1ed531e243a2319ebca53bf4c"; else set -x && git checkout -q -f "b58f92046e48a7b1ed531e243a2319ebca53bf4c"; fi 263.0 fatal: unable to access 'https://gitlab.eclipse.org/eclipse/titan/titan.ProtocolEmulations.M3UA/': Failed to connect to gitlab.eclipse.org port 443 after 130538 ms: Couldn't connect to server 263.0 make[1]: Leaving directory '/osmo-ttcn3-hacks/deps' 263.0 make[1]: *** [Makefile:190: titan.ProtocolEmulations.M3UA/update] Error 128 263.0 make: *** [Makefile:79: deps] Error 2 ------ Dockerfile:7 -------------------- 5 | 6 | ADD https://gerrit.osmocom.org/plugins/gitiles/osmo-ttcn3-hacks/+/$OSMO_TTCN3_B… /tmp/commit 7 | >>> RUN ttcn3-docker-prepare "$OSMO_TTCN3_BRANCH" sccp 8 | 9 | VOLUME /data -------------------- ERROR: failed to solve: process "/bin/sh -c ttcn3-docker-prepare \"$OSMO_TTCN3_BRANCH\" sccp" did not complete successfully: exit code: 2 make: *** [../make/Makefile:94: docker-build] Error 1 make: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-asan/ws/ttcn3-sccp-…'> + exit 1 Build step 'Execute shell' marked build as failure Recording test results ERROR: Step ‘Publish JUnit test result report’ failed: No test report files were found. Configuration error?

10 months, 3 weeks