See https://jenkins.osmocom.org/jenkins/job/ttcn3-hlr-test-latest/2878/display/redirect?page=changes
Changes:
[Pau Espin Pedrol] sgsn: Fail in obvious way when unexpected ServiceAccept is received
[Oliver Smith] testenv: subprocess.run with explicit check=False
[Oliver Smith] smdpp/generate_all_test_certificates: use f-string
[Oliver Smith] testenv: remove *args from various functions
[Oliver Smith] testenv: various small syntax tweaks
------------------------------------------ [...truncated 467.24 KiB...] [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [0]: calculating 2G separately (auc.c:158)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [0]: kc = 0645b3fa90e46ebb (auc.c:179)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [0]: sres = b40f623d (auc.c:180)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [0]: auth_types = 0x3 (auc.c:181)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [1]: rand = 00a0db98cf7bb1e485b56b31a431aa54 (auc.c:113)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [1]: sqn = 385 (auc.c:139)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [1]: autn = a12a91d199d20000b8ed9b65c6340d50 (auc.c:142)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [1]: ck = c176e7a7e93313e8600abc759a9c8522 (auc.c:143)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [1]: ik = b07e6afdd8769bd7eef4d7be059dcef1 (auc.c:144)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [1]: res = e2a5cb08f0f6388a0000000000000000 (auc.c:145)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [1]: res_len = 8 (auc.c:146)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [1]: calculating 2G separately (auc.c:158)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [1]: kc = e03f498fcc2eff2d (auc.c:179)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [1]: sres = ed254d41 (auc.c:180)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [1]: auth_types = 0x3 (auc.c:181)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [2]: rand = a9caf7940ba344a3c29e3475e535327b (auc.c:113)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [2]: sqn = 417 (auc.c:139)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [2]: autn = d938942986fa00002884de4be0c61895 (auc.c:142)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [2]: ck = fe8d98507b502220531bc6bb7e2ba98d (auc.c:143)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [2]: ik = a4adbfb6da54be277748c45516917eb7 (auc.c:144)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [2]: res = 879ffa72d7e5b6dc0000000000000000 (auc.c:145)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [2]: res_len = 8 (auc.c:146)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [2]: calculating 2G separately (auc.c:158)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [2]: kc = ef84cc67164269a8 (auc.c:179)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [2]: sres = 8d04ebf8 (auc.c:180)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [2]: auth_types = 0x3 (auc.c:181)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [3]: rand = c49e9a09ef4728e751f59034beb858ba (auc.c:113)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [3]: sqn = 449 (auc.c:139)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [3]: autn = 308ec496ab040000dab751b990b9c476 (auc.c:142)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [3]: ck = 9d9eceec5a38f0a8c983d2d61346d986 (auc.c:143)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [3]: ik = 63dff8f264db5876dc36b869d0088d80 (auc.c:144)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [3]: res = 7893569cf083e4b00000000000000000 (auc.c:145)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [3]: res_len = 8 (auc.c:146)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [3]: calculating 2G separately (auc.c:158)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [3]: kc = b136b9d234970e03 (auc.c:179)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [3]: sres = af201568 (auc.c:180)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [3]: auth_types = 0x3 (auc.c:181)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [4]: rand = 1ff84652ff368ef6ca15369b07065338 (auc.c:113)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [4]: sqn = 481 (auc.c:139)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [4]: autn = e50df7c03e5400002a5c2051931d5ded (auc.c:142)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [4]: ck = 11ec3111cb038461ea7e9addb94c19d3 (auc.c:143)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [4]: ik = 8bec3e806bee207eed76f71ee5c179bd (auc.c:144)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [4]: res = d06647c3acf678d40000000000000000 (auc.c:145)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [4]: res_len = 8 (auc.c:146)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [4]: calculating 2G separately (auc.c:158)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [4]: kc = 1a1712dd008c9fc7 (auc.c:179)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [4]: sres = 6eff177d (auc.c:180)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m vector [4]: auth_types = 0x3 (auc.c:181)[0;m [1;33m20260820122528419 [1;32mDAUC[0;m[1;33m [1;32mINFO[0;m[1;33m IMSI='262428492324451': Generated 5 vectors (db_auc.c:245)[0;m [1;33m20260820122528419 [1;34mDAUC[0;m[1;33m [1;34mDEBUG[0;m[1;33m IMSI='262428492324451': Updating SQN=481 in DB (db_auc.c:249)[0;m [38;5;39m20260820122528420 [1;34mDLGSUP[0;m[38;5;39m [1;34mDEBUG[0;m[38;5;39m GSUP 41: MSC-00-00-00-00-00-00: IMSI-262428492324451 OSMO_GSUP_MSGT_SEND_AUTH_INFO_REQUEST: Tx response: {OSMO_GSUP_MSGT_SEND_AUTH_INFO_RESULT: imsi="262428492324451"} (hlr.c:345)[0;m [38;5;39m20260820122528420 [1;34mDLGSUP[0;m[38;5;39m [1;34mDEBUG[0;m[38;5;39m GSUP 41: MSC-00-00-00-00-00-00: IMSI-262428492324451 OSMO_GSUP_MSGT_SEND_AUTH_INFO_REQUEST: free (gsup_req.c:173)[0;m [38;5;23m20260820122528420 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m connected read/write (ipa.c:452)[0;m [38;5;23m20260820122528420 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m 127.0.0.1:9999 sending data (ipa.c:432)[0;m [38;5;23m20260820122528420 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m connected read/write (ipa.c:452)[0;m [38;5;23m20260820122528420 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m 127.0.0.1:9999 sending data (ipa.c:432)[0;m TC_gsup_sai_num_auth_vectors(31)@59895a16b894: setverdict(pass): pass -> pass, component reason not changed TC_gsup_sai_num_auth_vectors(31)@59895a16b894: setverdict(pass): pass -> pass, component reason not changed 20260820122528421 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:60494<->l=127.0.0.1:4258 (telnet_interface.c:138) TC_gsup_sai_num_auth_vectors(31)@59895a16b894: Final verdict of PTC: pass MTC@59895a16b894: setverdict(pass): none -> pass 20260820122528422 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:60432<->l=127.0.0.1:4258 (telnet_interface.c:138) [38;5;23m20260820122528422 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m connected read/write (ipa.c:452)[0;m [38;5;23m20260820122528422 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m 127.0.0.1:9999 message received (ipa.c:406)[0;m [38;5;23m20260820122528422 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m 127.0.0.1:9999 connection closed with server (ipa.c:415)[0;m HLR_Test-GSUP(21)@59895a16b894: Final verdict of PTC: none [38;5;39m20260820122528422 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m Lost GSUP client 127.0.0.1:9999 (gsup_server.c:313)[0;m 20260820122528423 [1;32mDMAIN[0;m [1;32mINFO[0;m Removing GSUP route for "MSC-00-00-00-00-00-00\0" (GSUP disconnect) (gsup_router.c:112) 22@59895a16b894: Final verdict of PTC: none HLR_Test-GSUP-IPA(20)@59895a16b894: Final verdict of PTC: none [38;5;33m20260820122528424 [1;32mDLCTRL[0;m[38;5;33m [1;32mINFO[0;m[38;5;33m close()d CTRL connection (r=127.0.0.1:46127<->l=127.0.0.1:4259) (control_if.c:193)[0;m IPA-CTRL-CLI-IPA(23)@59895a16b894: Final verdict of PTC: none MTC@59895a16b894: Setting final verdict of the test case. MTC@59895a16b894: Local verdict of MTC: pass MTC@59895a16b894: Local verdict of PTC HLR_Test-GSUP-IPA(20): none (pass -> pass) MTC@59895a16b894: Local verdict of PTC HLR_Test-GSUP(21): none (pass -> pass) MTC@59895a16b894: Local verdict of PTC with component reference 22: none (pass -> pass) MTC@59895a16b894: Local verdict of PTC IPA-CTRL-CLI-IPA(23): none (pass -> pass) MTC@59895a16b894: Local verdict of PTC TC_gsup_sai_num_auth_vectors(24): pass (pass -> pass) MTC@59895a16b894: Local verdict of PTC TC_gsup_sai_num_auth_vectors(25): pass (pass -> pass) MTC@59895a16b894: Local verdict of PTC TC_gsup_sai_num_auth_vectors(26): pass (pass -> pass) MTC@59895a16b894: Local verdict of PTC TC_gsup_sai_num_auth_vectors(27): pass (pass -> pass) MTC@59895a16b894: Local verdict of PTC TC_gsup_sai_num_auth_vectors(28): pass (pass -> pass) MTC@59895a16b894: Local verdict of PTC TC_gsup_sai_num_auth_vectors(29): pass (pass -> pass) MTC@59895a16b894: Local verdict of PTC TC_gsup_sai_num_auth_vectors(30): pass (pass -> pass) MTC@59895a16b894: Local verdict of PTC TC_gsup_sai_num_auth_vectors(31): pass (pass -> pass) MTC@59895a16b894: Test case TC_gsup_sai_num_auth_vectors finished. Verdict: pass MTC@59895a16b894: Starting external command `/home/osmocom-build/jenkins/workspace/ttcn3-hlr-test-latest/ttcn3-tcpdump-stop.sh HLR_Tests.TC_gsup_sai_num_auth_vectors pass'. (12:25:28) load average: 1.13, 1.95, 2.30 [1;32m====== HLR_Tests.TC_gsup_sai_num_auth_vectors pass ======[0m
Saving talloc report from 127.0.0.1:4258 to HLR_Tests.TC_gsup_sai_num_auth_vectors.talloc 20260820122528462 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Accept()ed new telnet connection r=127.0.0.1:60504<->l=127.0.0.1:4258 (telnet_interface.c:192) 20260820122528563 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:60504<->l=127.0.0.1:4258 (telnet_interface.c:138) Waiting for packet dumper to finish... 0 (prev_count=-1, count=275036) Waiting for packet dumper to finish... 1 (prev_count=275036, count=409112) MTC@59895a16b894: External command `/home/osmocom-build/jenkins/workspace/ttcn3-hlr-test-latest/ttcn3-tcpdump-stop.sh HLR_Tests.TC_gsup_sai_num_auth_vectors pass' was executed successfully (exit status: 0). MTC@59895a16b894: Starting external command `/home/osmocom-build/jenkins/workspace/ttcn3-hlr-test-latest/ttcn3-tcpdump-start.sh HLR_Tests.TC_gsup_ul_unknown_imsi'. ------ HLR_Tests.TC_gsup_ul_unknown_imsi ------ (12:25:30) load average: 1.13, 1.95, 2.30 /usr/bin/dumpcap -q -s 1520 -n -i any -w "/home/osmocom-build/jenkins/workspace/ttcn3-hlr-test-latest/logs/testsuite/HLR_Tests.TC_gsup_ul_unknown_imsi.pcap" >/home/osmocom-build/jenkins/workspace/ttcn3-hlr-test-latest/logs/testsuite/HLR_Tests.TC_gsup_ul_unknown_imsi.pcap.stdout 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@59895a16b894: External command `/home/osmocom-build/jenkins/workspace/ttcn3-hlr-test-latest/ttcn3-tcpdump-start.sh HLR_Tests.TC_gsup_ul_unknown_imsi' was executed successfully (exit status: 0). MTC@59895a16b894: Test case TC_gsup_ul_unknown_imsi started. MTC@59895a16b894: legacy= false MTC@59895a16b894: in not legacy case 1 MTC@59895a16b894: in not legacy case 2 [38;5;23m20260820122531738 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m 127.0.0.1:4222 accept()ed new link from 127.0.0.1:9999 (ipa.c:321)[0;m [38;5;39m20260820122531738 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m New GSUP client 127.0.0.1:9999 (gsup_server.c:354)[0;m HLR_Test-GSUP-IPA(32)@59895a16b894: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } [38;5;23m20260820122531742 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m connected read/write (ipa.c:452)[0;m [38;5;23m20260820122531742 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m 127.0.0.1:9999 message received (ipa.c:406)[0;m 20260820122531743 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Accept()ed new telnet connection r=127.0.0.1:60524<->l=127.0.0.1:4258 (telnet_interface.c:192) HLR_Test-GSUP-IPA(32)@59895a16b894: CCM Rx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITID (8) }, { len := 1, tag := IPAC_IDTAG_MACADDR (7) }, { len := 1, tag := IPAC_IDTAG_LOCATION1 (2) }, { len := 1, tag := IPAC_IDTAG_LOCATION2 (3) }, { len := 1, tag := IPAC_IDTAG_EQUIPVERS (4) }, { len := 1, tag := IPAC_IDTAG_SWVERSION (5) }, { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_SERNR (0) } } } } HLR_Test-GSUP-IPA(32)@59895a16b894: CCM Tx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 0, tag := IPAC_IDTAG_UNITID (8), data := '302F312F3200'O }, { len := 0, tag := IPAC_IDTAG_MACADDR (7), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION1 (2), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION2 (3), data := '00'O }, { len := 0, tag := IPAC_IDTAG_EQUIPVERS (4), data := '00'O }, { len := 0, tag := IPAC_IDTAG_SWVERSION (5), data := '00'O }, { len := 0, tag := IPAC_IDTAG_UNITNAME (1), data := '4F736D6F636F6D205454434E2D3320475355502053696D756C61746F7220284D53432900'O }, { len := 0, tag := IPAC_IDTAG_SERNR (0), data := '4D53432D30302D30302D30302D30302D30302D303000'O } } } } [38;5;23m20260820122531745 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m connected read/write (ipa.c:452)[0;m [38;5;23m20260820122531745 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m 127.0.0.1:9999 message received (ipa.c:406)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m CCM Callback (gsup_server.c:281)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 0: MSC-00-00-00-00-00-00 (gsup_server.c:236)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 0: 4d 53 43 2d 30 30 2d 30 30 2d 30 30 2d 30 30 2d 30 30 2d 30 30 00 (gsup_server.c:238)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 1: Osmocom TTCN-3 GSUP Simulator (MSC) (gsup_server.c:236)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 1: 4f 73 6d 6f 63 6f 6d 20 54 54 43 4e 2d 33 20 47 53 55 50 20 53 69 6d 75 6c 61 74 6f 72 20 28 4d 53 43 29 00 (gsup_server.c:238)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 2: (gsup_server.c:236)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 2: 00 (gsup_server.c:238)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 3: (gsup_server.c:236)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 3: 00 (gsup_server.c:238)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 4: (gsup_server.c:236)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 4: 00 (gsup_server.c:238)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 5: (gsup_server.c:236)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 5: 00 (gsup_server.c:238)[0;m HLR_Test-GSUP-IPA(32)@59895a16b894: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 7: (gsup_server.c:236)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 7: 00 (gsup_server.c:238)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 8: 0/1/2 (gsup_server.c:236)[0;m [38;5;39m20260820122531745 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m 8: 30 2f 31 2f 32 00 (gsup_server.c:238)[0;m 20260820122531745 [1;32mDMAIN[0;m [1;32mINFO[0;m Adding GSUP route for MSC-00-00-00-00-00-00 via 127.0.0.1:9999 (gsup_router.c:90) 34@59895a16b894: Warning: The maximum number of open file descriptors (1048576) is greater than FD_SETSIZE (1024). Ensure that Test Ports using Install_Handler do not try to wait for events of file descriptors with values greater than FD_SETSIZE (1024). (Current caller of Install_Handler is "mDNS_UDP") [38;5;33m20260820122531768 [1;32mDLCTRL[0;m[38;5;33m [1;32mINFO[0;m[38;5;33m accept()ed new CTRL connection from (r=127.0.0.1:34409<->l=127.0.0.1:4259) (control_if.c:572)[0;m HLR_Test-GSUP(33)@59895a16b894: Created GsupExpect[0] for "262426753457224" to be handled at TC_gsup_ul_unknown_imsi(36) 20260820122531799 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Accept()ed new telnet connection r=127.0.0.1:60528<->l=127.0.0.1:4258 (telnet_interface.c:192) [38;5;23m20260820122531804 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m connected read/write (ipa.c:452)[0;m [38;5;23m20260820122531804 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m 127.0.0.1:9999 message received (ipa.c:406)[0;m [38;5;39m20260820122531804 [1;34mDLGSUP[0;m[38;5;39m [1;34mDEBUG[0;m[38;5;39m GSUP 42: MSC-00-00-00-00-00-00: IMSI-262426753457224 OSMO_GSUP_MSGT_UPDATE_LOCATION_REQUEST: new request: {OSMO_GSUP_MSGT_UPDATE_LOCATION_REQUEST: imsi="262426753457224" cn_domain=PS} (gsup_req.c:140)[0;m [1;33m20260820122531804 [1;34mDLU[0;m[1;33m [1;34mDEBUG[0;m[1;33m lu(262426753457224)[0x562911d39d70]{UNVALIDATED}: Allocated (fsm.c:457)[0;m [38;5;39m20260820122531804 [1;31mDLGSUP[0;m[38;5;39m [1;31mERROR[0;m[38;5;39m GSUP 42: MSC-00-00-00-00-00-00: IMSI-262426753457224 OSMO_GSUP_MSGT_UPDATE_LOCATION_REQUEST: IMSI unknown in HLR: Subscriber does not exist (lu_fsm.c:139)[0;m [38;5;39m20260820122531804 [1;34mDLGSUP[0;m[38;5;39m [1;34mDEBUG[0;m[38;5;39m GSUP 42: MSC-00-00-00-00-00-00: IMSI-262426753457224 OSMO_GSUP_MSGT_UPDATE_LOCATION_REQUEST: Tx response: {OSMO_GSUP_MSGT_UPDATE_LOCATION_ERROR: imsi="262426753457224" cause=IMSI unknown in HLR} (gsup_req.c:276)[0;m [38;5;39m20260820122531804 [1;34mDLGSUP[0;m[38;5;39m [1;34mDEBUG[0;m[38;5;39m GSUP 42: MSC-00-00-00-00-00-00: IMSI-262426753457224 OSMO_GSUP_MSGT_UPDATE_LOCATION_REQUEST: free (gsup_req.c:173)[0;m [1;33m20260820122531804 [1;34mDLU[0;m[1;33m [1;34mDEBUG[0;m[1;33m lu(PS:IMSI-262426753457224)[0x562911d39d70]{UNVALIDATED}: Terminating (cause = OSMO_FSM_TERM_REGULAR) (lu_fsm.c:139)[0;m [1;33m20260820122531804 [1;34mDLU[0;m[1;33m [1;34mDEBUG[0;m[1;33m lu(PS:IMSI-262426753457224)[0x562911d39d70]{UNVALIDATED}: Freeing instance (lu_fsm.c:139)[0;m [1;33m20260820122531804 [1;34mDLU[0;m[1;33m [1;34mDEBUG[0;m[1;33m lu(PS:IMSI-262426753457224)[0x562911d39d70]{UNVALIDATED}: Deallocated (fsm.c:569)[0;m [38;5;23m20260820122531804 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m connected read/write (ipa.c:452)[0;m [38;5;23m20260820122531804 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m 127.0.0.1:9999 sending data (ipa.c:432)[0;m [38;5;23m20260820122531804 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m connected read/write (ipa.c:452)[0;m [38;5;23m20260820122531804 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m 127.0.0.1:9999 sending data (ipa.c:432)[0;m HLR_Test-GSUP(33)@59895a16b894: Found GsupExpect[0] for "262426753457224" handled at TC_gsup_ul_unknown_imsi(36) HLR_Test-GSUP(33)@59895a16b894: Added IMSI table entry 0TC_gsup_ul_unknown_imsi(36)"262426753457224" TC_gsup_ul_unknown_imsi(36)@59895a16b894: setverdict(pass): none -> pass TC_gsup_ul_unknown_imsi(36)@59895a16b894: setverdict(pass): pass -> pass, component reason not changed 20260820122531807 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:60528<->l=127.0.0.1:4258 (telnet_interface.c:138) TC_gsup_ul_unknown_imsi(36)@59895a16b894: Final verdict of PTC: pass 20260820122531808 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:60524<->l=127.0.0.1:4258 (telnet_interface.c:138) [38;5;23m20260820122531810 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m connected read/write (ipa.c:452)[0;m [38;5;23m20260820122531810 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m 127.0.0.1:9999 message received (ipa.c:406)[0;m [38;5;23m20260820122531810 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m 127.0.0.1:9999 connection closed with server (ipa.c:415)[0;m [38;5;39m20260820122531810 [1;32mDLGSUP[0;m[38;5;39m [1;32mINFO[0;m[38;5;39m Lost GSUP client 127.0.0.1:9999 (gsup_server.c:313)[0;m 20260820122531810 [1;32mDMAIN[0;m [1;32mINFO[0;m Removing GSUP route for "MSC-00-00-00-00-00-00\0" (GSUP disconnect) (gsup_router.c:112) [38;5;33m20260820122531810 [1;32mDLCTRL[0;m[38;5;33m [1;32mINFO[0;m[38;5;33m close()d CTRL connection (r=127.0.0.1:34409<->l=127.0.0.1:4259) (control_if.c:193)[0;m HLR_Test-GSUP(33)@59895a16b894: Final verdict of PTC: none HLR_Test-GSUP-IPA(32)@59895a16b894: Final verdict of PTC: none 34@59895a16b894: Final verdict of PTC: none IPA-CTRL-CLI-IPA(35)@59895a16b894: Final verdict of PTC: none MTC@59895a16b894: Setting final verdict of the test case. MTC@59895a16b894: Local verdict of MTC: none MTC@59895a16b894: Local verdict of PTC HLR_Test-GSUP-IPA(32): none (none -> none) MTC@59895a16b894: Local verdict of PTC HLR_Test-GSUP(33): none (none -> none) MTC@59895a16b894: Local verdict of PTC with component reference 34: none (none -> none) MTC@59895a16b894: Local verdict of PTC IPA-CTRL-CLI-IPA(35): none (none -> none) MTC@59895a16b894: Local verdict of PTC TC_gsup_ul_unknown_imsi(36): pass (none -> pass) MTC@59895a16b894: Test case TC_gsup_ul_unknown_imsi finished. Verdict: pass MTC@59895a16b894: Starting external command `/home/osmocom-build/jenkins/workspace/ttcn3-hlr-test-latest/ttcn3-tcpdump-stop.sh HLR_Tests.TC_gsup_ul_unknown_imsi pass'. (12:25:31) load average: 1.13, 1.95, 2.30 [1;32m====== HLR_Tests.TC_gsup_ul_unknown_imsi pass ======[0m
Saving talloc report from 127.0.0.1:4258 to HLR_Tests.TC_gsup_ul_unknown_imsi.talloc 20260820122531848 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Accept()ed new telnet connection r=127.0.0.1:60540<->l=127.0.0.1:4258 (telnet_interface.c:192) 20260820122531949 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:60540<->l=127.0.0.1:4258 (telnet_interface.c:138) Waiting for packet dumper to finish... 0 (prev_count=-1, count=440) FATAL: command execution failed Command Close created at at hudson.remoting.Command.<init>(Command.java:69) at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1424) at hudson.remoting.Channel.close(Channel.java:1603) at hudson.remoting.Channel.close(Channel.java:1567) at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1430) at hudson.remoting.Channel$1.handle(Channel.java:664) at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86) Caused: hudson.remoting.Channel$OrderlyShutdown at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1431) at hudson.remoting.Channel$1.handle(Channel.java:664) at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86) Caused: java.io.IOException: Backing channel 'build4-deb12build-ansible' is disconnected. at hudson.remoting.RemoteInvocationHandler.channelOrFail(RemoteInvocationHandler.java:227) at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:306) at jdk.proxy2/jdk.proxy2.$Proxy111.isAlive(Unknown Source) at hudson.Launcher$RemoteLauncher$ProcImpl.isAlive(Launcher.java:1227) at hudson.Launcher$RemoteLauncher$ProcImpl.join(Launcher.java:1219) at hudson.tasks.CommandInterpreter.join(CommandInterpreter.java:195) at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:145) at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:92) at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:817) at hudson.model.Build$BuildExecution.build(Build.java:199) at hudson.model.Build$BuildExecution.doRun(Build.java:164) at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:526) at hudson.model.Run.execute(Run.java:1843) at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44) at hudson.model.ResourceController.execute(ResourceController.java:97) at hudson.model.Executor.run(Executor.java:456) FATAL: Unable to delete script file /tmp/jenkins5808405966271109480.sh Command Close created at at hudson.remoting.Command.<init>(Command.java:69) at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1424) at hudson.remoting.Channel.close(Channel.java:1603) at hudson.remoting.Channel.close(Channel.java:1567) at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1430) at hudson.remoting.Channel$1.handle(Channel.java:664) at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86) Caused: hudson.remoting.Channel$OrderlyShutdown at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1431) at hudson.remoting.Channel$1.handle(Channel.java:664) at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86) Caused: hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@afac38f:build4-deb12build-ansible": Remote call on build4-deb12build-ansible failed. The channel is closing down or has closed down at hudson.remoting.Channel.call(Channel.java:1101) at hudson.FilePath.act(FilePath.java:1220) at hudson.FilePath.act(FilePath.java:1209) at hudson.FilePath.delete(FilePath.java:1756) at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:163) at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:92) at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:817) at hudson.model.Build$BuildExecution.build(Build.java:199) at hudson.model.Build$BuildExecution.doRun(Build.java:164) at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:526) at hudson.model.Run.execute(Run.java:1843) at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44) at hudson.model.ResourceController.execute(ResourceController.java:97) at hudson.model.Executor.run(Executor.java:456) Build step 'Execute shell' marked build as failure ERROR: Step ‘Publish JUnit test result report’ failed: no workspace for ttcn3-hlr-test-latest #2878
jenkins-notifications@lists.osmocom.org
-
jenkins＠lists.osmocom.org