December 2023 - jenkins-notifications

Build failed in Jenkins: master-osmo-msc » --disable-iu,0,a3=default,a4=default,osmocom-master #40958
by jenkins＠lists.osmocom.org 19 Dec '23

19 Dec '23

See <https://jenkins.osmocom.org/jenkins/job/master-osmo-msc/IU=--disable-iu,WIT…> Changes: ------------------------------------------ [...truncated 707.07 KB...] logging level vlr notice logging level iucs notice logging level bssap notice logging level sgs notice logging level ss notice logging level asci notice logging level lglobal notice logging level llapd notice logging level linp notice logging level lmux notice logging level lmi notice logging level lmib notice logging level lsms notice logging level lctrl notice logging level lgtp notice logging level lstats notice logging level lgsup notice logging level loap notice logging level lss7 notice logging level lsccp notice logging level lsua notice logging level lm3ua notice logging level lmgcp notice logging level ljibuf notice logging level lrspro notice logging level lns notice logging level lbssgp notice logging level lnsdata notice logging level lnssignal notice logging level liuup notice logging level lpfcp notice logging level lcsn1 notice logging level lio notice ! stats interval 5 ! line vty no login ! cs7 instance 0 point-code 0.23.1 network network country code 001 mobile network code 01 short name OsmoMSC long name OsmoMSC encryption a5 0 encryption uea 1 2 authentication optional rrlp mode none mm info 1 mgw 0 local-port 2728 remote-ip 127.0.0.1 remote-port 2427 msc mncc guard-timeout 180 ncss guard-timeout 30 assign-tmsi cs7-instance-a 0 auth-tuple-max-reuse-count 3 auth-tuple-reuse-on-error 1 mncc-int default-codec tch-f fr default-codec tch-h hr smpp local-tcp-port 2775 policy closed no smpp-first hlr remote-ip 127.0.0.1 remote-port 4222 sgs local-port 29118 local-ip 0.0.0.0 vlr-name vlr.example.net smsc queue max-pending 20 queue max-failure 1 database delete-delivered 1 database delete-expired 1 validity-period minimum 1 validity-period default 10080 asci disable gcr end [1;33mDMSC[0;m [1;33mNOTICE[0;m Terminating due to signal 15 (msc_main.c:286) full talloc report on 'osmo_msc' (total 19442 bytes in 92 blocks) struct osmo_ss7_instance contains 5121 bytes in 38 blocks (ref 0) 0x55a27ae6ec80 struct osmo_sccp_instance contains 858 bytes in 6 blocks (ref 0) 0x55a27ae670a0 struct osmo_sccp_user contains 90 bytes in 2 blocks (ref 0) 0x55a27ae6ef40 OsmoMSC-A contains 10 bytes in 1 blocks (ref 0) 0x55a27ae7f210 struct osmo_sccp_user contains 96 bytes in 2 blocks (ref 0) 0x55a27ae6bd60 SCCP Management contains 16 bytes in 1 blocks (ref 0) 0x55a27ae88e90 sccp_user.c:241 contains 560 bytes in 1 blocks (ref 0) 0x55a27ae88bf0 struct osmo_ss7_asp contains 2966 bytes in 19 blocks (ref 0) 0x55a27ad23900 struct osmo_fsm_inst contains 367 bytes in 4 blocks (ref 0) 0x55a27ae88ac0 struct xua_asp_fsm_priv contains 104 bytes in 1 blocks (ref 0) 0x55a27ae67d80 XUA_ASP(asp-clnt-OsmoMSC-A)[0x55a27ae88ac0] contains 44 bytes in 1 blocks (ref 0) 0x55a27ae68c90 asp-clnt-OsmoMSC-A contains 19 bytes in 1 blocks (ref 0) 0x55a27ae754d0 struct osmo_stream_cli contains 959 bytes in 4 blocks (ref 0) 0x55a27ae886c0 localhost contains 10 bytes in 1 blocks (ref 0) 0x55a27ae83560 localhost contains 10 bytes in 1 blocks (ref 0) 0x55a27ae736f0 asp-clnt-OsmoMSC-A contains 19 bytes in 1 blocks (ref 0) 0x55a27ae7b790 struct osmo_fsm_inst contains 278 bytes in 4 blocks (ref 0) 0x55a27ae4a7d0 struct lm_fsm_priv contains 8 bytes in 1 blocks (ref 0) 0x55a27ae6aa40 xua_default_lm(asp-clnt-OsmoMSC-A)[0x55a27ae4a7d0] contains 51 bytes in 1 blocks (ref 0) 0x55a27ae501f0 asp-clnt-OsmoMSC-A contains 19 bytes in 1 blocks (ref 0) 0x55a27ae7f480 localhost contains 10 bytes in 1 blocks (ref 0) 0x55a27ae7b520 localhost contains 10 bytes in 1 blocks (ref 0) 0x55a27ae7f2e0 osmo_ss7_asp.c:523 contains 280 bytes in 1 blocks (ref 0) 0x55a27ae6e570 asp-clnt-OsmoMSC-A contains 19 bytes in 1 blocks (ref 0) 0x55a27ae6e4f0 rate_ctr.c:233 contains 299 bytes in 2 blocks (ref 0) 0x55a27acfea80 asp-clnt-OsmoMSC-A contains 19 bytes in 1 blocks (ref 0) 0x55a27ae7b5f0 struct osmo_ss7_as contains 856 bytes in 8 blocks (ref 0) 0x55a27ae6c1f0 struct osmo_fsm_inst contains 372 bytes in 4 blocks (ref 0) 0x55a27ae6e3c0 struct xua_as_fsm_priv contains 112 bytes in 1 blocks (ref 0) 0x55a27ae70120 XUA_AS(as-clnt-OsmoMSC-A)[0x55a27ae6e3c0] contains 42 bytes in 1 blocks (ref 0) 0x55a27ae6e910 as-clnt-OsmoMSC-A contains 18 bytes in 1 blocks (ref 0) 0x55a27ae70630 as-clnt-OsmoMSC-A contains 18 bytes in 1 blocks (ref 0) 0x55a27ae6ee80 rate_ctr.c:233 contains 218 bytes in 2 blocks (ref 0) 0x55a27acfe950 as-clnt-OsmoMSC-A contains 18 bytes in 1 blocks (ref 0) 0x55a27ae69550 struct osmo_ss7_route_table contains 145 bytes in 4 blocks (ref 0) 0x55a27ae72cd0 struct osmo_ss7_route contains 82 bytes in 2 blocks (ref 0) 0x55a27ae6bb00 as-clnt-OsmoMSC-A contains 18 bytes in 1 blocks (ref 0) 0x55a27ae6eb80 system contains 7 bytes in 1 blocks (ref 0) 0x55a27ae73bd0 telnet_connection contains 1 bytes in 1 blocks (ref 0) 0x55a27ae4b730 struct osmo_stream_srv_link contains 1920 bytes in 2 blocks (ref 0) 0x55a27ae49810 0.0.0.0 contains 8 bytes in 1 blocks (ref 0) 0x55a27ae49ff0 struct sgs_state contains 376 bytes in 1 blocks (ref 0) 0x55a27ae49630 struct smsc contains 152 bytes in 1 blocks (ref 0) 0x55a27acfd9b0 sms.db contains 7 bytes in 1 blocks (ref 0) 0x55a27ad65650 struct sms_queue_config contains 32 bytes in 1 blocks (ref 0) 0x55a27ad655c0 struct gsm_network contains 11023 bytes in 29 blocks (ref 0) 0x55a27ad001d0 struct sccp_ran_inst contains 152 bytes in 1 blocks (ref 0) 0x55a27ae693b0 struct gsm_sms_queue contains 776 bytes in 4 blocks (ref 0) 0x55a27ad22770 rate_ctr.c:233 contains 440 bytes in 1 blocks (ref 0) 0x55a27ae4c580 stat_item.c:195 contains 104 bytes in 2 blocks (ref 0) 0x55a27ae4b0a0 struct osmo_stat_item contains 56 bytes in 1 blocks (ref 0) 0x55a27ae4b140 struct gsup_client_mux contains 682 bytes in 6 blocks (ref 0) 0x55a27ae4ae60 struct osmo_gsup_client contains 514 bytes in 4 blocks (ref 0) 0x55a27ad278c0 struct osmo_fd contains 48 bytes in 1 blocks (ref 0) 0x55a27ae4af30 struct ipa_client_conn contains 202 bytes in 2 blocks (ref 0) 0x55a27ad02540 127.0.0.1 contains 10 bytes in 1 blocks (ref 0) 0x55a27ae4afd0 struct ipaccess_unit contains 64 bytes in 1 blocks (ref 0) 0x55a27ae4ba50 struct ctrl_handle contains 88 bytes in 1 blocks (ref 0) 0x55a27ae4ac40 127.0.0.1 contains 10 bytes in 1 blocks (ref 0) 0x55a27ae4bc70 struct vlr_instance contains 2488 bytes in 5 blocks (ref 0) 0x55a27ad48220 rate_ctr.c:233 contains 2040 bytes in 1 blocks (ref 0) 0x55a27ae33b90 stat_item.c:195 contains 168 bytes in 2 blocks (ref 0) 0x55a27ae33a10 struct osmo_stat_item contains 112 bytes in 1 blocks (ref 0) 0x55a27ae33ab0 struct osmo_nri_ranges contains 16 bytes in 1 blocks (ref 0) 0x55a27ae33990 struct mgcp_client_conf contains 1088 bytes in 1 blocks (ref 0) 0x55a27ad65110 struct mgcp_client_pool contains 2681 bytes in 5 blocks (ref 0) 0x55a27ad65080 struct mgcp_client_pool_member contains 2520 bytes in 2 blocks (ref 0) 0x55a27ae4be80 struct mgcp_client contains 1384 bytes in 1 blocks (ref 0) 0x55a27ae6ddf0 struct cmd_node contains 121 bytes in 2 blocks (ref 0) 0x55a27ad009a0 %s(config-mgw)# contains 17 bytes in 1 blocks (ref 0) 0x55a27ad87290 127.0.0.1 contains 10 bytes in 1 blocks (ref 0) 0x55a27ad641b0 stat_item.c:195 contains 168 bytes in 2 blocks (ref 0) 0x55a27ad64f00 struct osmo_stat_item contains 112 bytes in 1 blocks (ref 0) 0x55a27ad00d40 rate_ctr.c:233 contains 2520 bytes in 1 blocks (ref 0) 0x55a27ad644c0 struct sched_vty_opts contains 72 bytes in 1 blocks (ref 0) 0x55a27ad519f0 utils.c:386 contains 203 bytes in 1 blocks (ref 0) 0x55a27ac8ea20 utils.c:386 contains 46 bytes in 1 blocks (ref 0) 0x55a27ac8e980 utils.c:386 contains 165 bytes in 1 blocks (ref 0) 0x55a27ac8e870 utils.c:386 contains 43 bytes in 1 blocks (ref 0) 0x55a27ac8e7d0 transaction contains 0 bytes in 1 blocks (ref 0) 0x55a27ac6aa70 gsm_call contains 0 bytes in 1 blocks (ref 0) 0x55a27ac6aa00 sms contains 0 bytes in 1 blocks (ref 0) 0x55a27ac6a990 osmo_signal contains 280 bytes in 8 blocks (ref 0) 0x55a27ac6a920 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x55a27ae6ce70 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x55a27ae50ab0 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x55a27ae4b6a0 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x55a27ae4b7a0 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x55a27ae4bbe0 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x55a27ae4bd70 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x55a27adfaa90 msgb contains 0 bytes in 1 blocks (ref 0) 0x55a27ac6a8b0 full talloc report on 'null_context' (total 24 bytes in 2 blocks) struct lookup_helper contains 24 bytes in 1 blocks (ref 0) 0x55a27ae4b510 signal 15 received Terminating took 0.897s RESULTS: pass: ../../../tests/test_nodes.vty rm -f ./sms.db* make[8]: Leaving directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub/tests' make[7]: Leaving directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub/tests' make ctrl-test make[7]: Entering directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub/tests' make ctrl-python-test make[8]: Entering directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub/tests' ../../../tests/ctrl_test_runner.py -w /build/osmo-msc-1.11.1.19-82fad/_build/sub -v testRateCounters (__main__.TestCtrlMSC.testRateCounters) ... ERROR ====================================================================== ERROR: testRateCounters (__main__.TestCtrlMSC.testRateCounters) ---------------------------------------------------------------------- Traceback (most recent call last): File "/build/osmo-msc-1.11.1.19-82fad/_build/sub/tests/../../../tests/ctrl_test_runner.py", line 69, in tearDown raise Exception("Process returned %d" % rc) Exception: Process returned -6 ---------------------------------------------------------------------- Ran 1 test in 2.169s FAILED (errors=1) confpath /build/osmo-msc-1.11.1.19-82fad/tests/.., workdir /build/osmo-msc-1.11.1.19-82fad/_build/sub Running tests for specific control commands Opening /dev/null Launching: PWD=/build/osmo-msc-1.11.1.19-82fad/_build/sub './src/osmo-msc/osmo-msc' '-c' '/build/osmo-msc-1.11.1.19-82fad/tests/../doc/examples/osmo-msc/osmo-msc.cfg' Connecting to host 127.0.0.1:4255 Sending "GET 1000 rate_ctr.*" Got message: b'ERROR 1000 GET variable contains invalid characters' Decoded replies: {1000: {'mtype': b'ERROR', 'id': 1000, 'var': b'GET', 'value': b'variable contains invalid characters'}} Process returned code: -6 make[8]: Leaving directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub/tests' make[7]: Leaving directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub/tests' make[8]: *** [Makefile:749: ctrl-python-test] Error 1 make[7]: *** [Makefile:760: ctrl-test] Error 2 make[6]: *** [Makefile:716: python-tests] Error 2 make[6]: Leaving directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub/tests' make[5]: *** [Makefile:769: check-local] Error 2 make[5]: Leaving directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub/tests' make[4]: *** [Makefile:574: check-am] Error 2 make[4]: Leaving directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub/tests' make[3]: *** [Makefile:424: check-recursive] Error 1 make[3]: Leaving directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub/tests' make[2]: Leaving directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub' make[2]: *** [Makefile:473: check-recursive] Error 1 make[1]: Leaving directory '/build/osmo-msc-1.11.1.19-82fad/_build/sub' make[1]: *** [Makefile:772: check] Error 2 make: *** [Makefile:692: distcheck] Error 1 + exit_tar_workspace + '[' 1 = 1 ']' + tar -cJf /tmp/workspace.tar.xz /build tar: Removing leading `/' from member names + mv /tmp/workspace.tar.xz /build + cat-testlogs.sh Build step 'Execute shell' marked build as failure $ ssh-agent -k unset SSH_AUTH_SOCK; unset SSH_AGENT_PID; echo Agent pid 1740126 killed; [ssh-agent] Stopped. Archiving artifacts

1 1

Build failed in Jenkins: master-osmo-pcu » master,0,rpi4-raspbian11,none,False #6327
by jenkins＠lists.osmocom.org 18 Dec '23

18 Dec '23

See <https://jenkins.osmocom.org/jenkins/job/master-osmo-pcu/FIRMWARE_VERSION=ma…> Changes: ------------------------------------------ [...truncated 156.95 KB...] 6: edge ok 7: types ok 8: ms ok 9: llc ok 10: llist ok 11: codel ok 12: fn ok 13: app_info ok 14: ulc ok ## ------------- ## ## Test results. ## ## ------------- ## ERROR: All 14 tests were run, 1 failed unexpectedly. ## -------------------------- ## ## testsuite.log was created. ## ## -------------------------- ## Please send `tests/testsuite.log' and all information you think might help: To: <osmocom-net-gprs(a)lists.osmocom.org> Subject: [osmo-pcu 1.4.0.1-b04e1] testsuite: 4 failed You may investigate any problem if you feel able to do so, in which case the test suite provides a good starting point. Its output may be found below `tests/testsuite.dir'. make[2]: *** [Makefile:1496: installcheck-local] Error 1 make[2]: Leaving directory '/build/osmo-pcu-1.4.0.1-b04e1/_build/sub/tests' make[1]: *** [Makefile:429: installcheck-recursive] Error 1 make[1]: Leaving directory '/build/osmo-pcu-1.4.0.1-b04e1/_build/sub' make: *** [Makefile:648: distcheck] Error 1 + cat-testlogs.sh ======================== ./osmo-pcu-1.4.0.1-b04e1/_build/sub/tests/testsuite.dir/04/testsuite.log # -*- compilation -*- 4. testsuite.at:25: testing tbf ... ../../../tests/testsuite.at:28: $OSMO_QEMU $abs_top_builddir/tests/tbf/TbfTest --- experr 2023-12-18 04:26:55.099514963 +0000 +++ /build/osmo-pcu-1.4.0.1-b04e1/_build/sub/tests/testsuite.dir/at-groups/4/stderr 2023-12-18 04:26:59.239403461 +0000 @@ -11453,145 +11453,51 @@ UL_TBF(UL:TFI-0-0--1:G:TLLI-0xffeeddcc){ASSIGN}: Deallocated UL_ASS_TBF(UL:TFI-0-0--1:G:TLLI-0xffeeddcc){NONE}: Deallocated DL_ASS_TBF(UL:TFI-0-0--1:G:TLLI-0xffeeddcc){NONE}: Deallocated -=== end test_packet_access_rej_prr_no_other_tbfs === -=== start test_ms_merge_dl_tbf_different_trx === -PDCH(bts=0,trx=0,ts=1) PDCH state: disabled => enabled -PDCH(bts=0,trx=0,ts=1) PDCH state: enabled => disabled -PDCH(bts=0,trx=1,ts=4) PDCH state: disabled => enabled -PDCH(bts=0,trx=1,ts=5) PDCH state: disabled => enabled -PDCH(bts=0,trx=1,ts=6) PDCH state: disabled => enabled -Creating MS object -MS(TA-220:MSCLS-0-0): + dl_tbf_handle: now used by 1 (dl_tbf_handle) -Modifying MS object, TLLI = 0xffffffff, IMSI '' -> '001001000000001' -The MS object cannot fully confirm an unexpected TLLI: 0xa3c2f953, partly confirmed -Modifying MS object, TLLI = 0xa3c2f953, MS class 0 -> 11 -MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0) appending 19 bytes to DL LLC queue -[DL] algo B <single> (suggested TRX: -1): Alloc start -Found first unallocated TRX=1 TFI=0 -Slot Allocation (Algorithm B) for class 11 -- Skipping TS 0, because not enabled -- Skipping TS 1, because not enabled -- Skipping TS 2, because not enabled -- Skipping TS 3, because not enabled -- Skipping TS 7, because not enabled -- Possible DL/UL slots: (TS=0)"....CCC."(TS=7) -Rx=4 Tx=3 Sum Rx+Tx=5, Tta=3 Ttb=1, Tra=2 Trb=1, Type=1 -- Skipping TS 6, because num TBFs 0 >= 0 -Selected DL slots: (TS=0)".ddd.D.."(TS=7), single -[DL] algo B <single> (suggested TRX: -1): using single slot at TS 5 -- Available DL/UL slots: (TS=0)"..D..CU."(TS=7) -MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0) ********** DL-TBF starts here ********** -MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0) Allocating DL TBF -UL_ASS_TBF{NONE}: Allocated -DL_ASS_TBF{NONE}: Allocated -DL_TBF{NEW}: Allocated -TBF(DL:TFI-0-1--1:G:IMSI-001001000000001:TLLI-0xa3c2f953){NEW} Assigning TS=5 TFI=0 -PDCH(bts=0,trx=1,ts=5) Attaching TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){NEW}, 1 TBFs, USFs = 00, TFIs = 00000001. -TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){NEW} Setting Control TS PDCH(bts=0,trx=1,ts=5) -TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){NEW} Allocated: trx = 1, ul_slots = 20, dl_slots = 20 -MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0) Attaching DL TBF: TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){NEW} -MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0:DL): + tbf: now used by 2 (dl_tbf_handle,tbf) -TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){NEW} [DOWNLINK] START (PCH) -TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){NEW} Send downlink assignment on PCH, no TBF exist (IMSI=001001000000001) -DL_TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){NEW}: Received Event ASSIGN_ADD_CCCH -TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){NEW} set ass. type CCCH [prev CCCH:0, PACCH:0] -DL_TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){NEW}: state_chg to ASSIGN -TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){ASSIGN} Tx CCCH (PCH) Immediate Assignment [PktDlAss=PDCH(bts=0,trx=1,ts=5)] TA=220 -MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0:DL): - dl_tbf_handle: now used by 1 (tbf) -PDCH(bts=0,trx=0,ts=1) PDCH state: disabled => enabled -PDCH(bts=0,trx=0,ts=2) PDCH state: disabled => enabled -PDCH(bts=0,trx=0,ts=3) PDCH state: disabled => enabled -Creating MS object -Modifying MS object, UL TLLI: 0xffffffff -> 0xecc1f953, not yet confirmed -[UL] algo B <multi> (suggested TRX: 0): Alloc start -Found first unallocated TRX=0 TFI=0 -- Skipping TS 0, because not enabled -- Skipping TS 4, because not enabled -- Skipping TS 5, because not enabled -- Skipping TS 6, because not enabled -- Skipping TS 7, because not enabled -- Possible DL/UL slots: (TS=0)".CCC...."(TS=7) -Rx=4 Tx=4 Sum Rx+Tx=5, Tta=2 Ttb=1, Tra=2 Trb=1, Type=1 -Selected UL slots: (TS=0)"..UUuu.."(TS=7), multi -[UL] algo B <multi> (suggested TRX: 0): using 2 slots -- Available DL/UL slots: (TS=0)"..CCDDD."(TS=7) -MS(TLLI-0xecc1f953:TA-220:MSCLS-0-0) ********** UL-TBF starts here ********** -MS(TLLI-0xecc1f953:TA-220:MSCLS-0-0) Allocating UL TBF -UL_ASS_TBF{NONE}: Allocated -DL_ASS_TBF{NONE}: Allocated -UL_TBF{NEW}: Allocated -UL_ACK_TBF{NONE}: Allocated -TBF(UL:TFI-0-0--1:G:TLLI-0xecc1f953){NEW} Assigning TS=2 TFI=0 USF=0 -PDCH(bts=0,trx=0,ts=2) Attaching TBF(UL:TFI-0-0-0:G:TLLI-0xecc1f953){NEW}, 1 TBFs, USFs = 01, TFIs = 00000001. -TBF(UL:TFI-0-0-0:G:TLLI-0xecc1f953){NEW} Assigning TS=3 TFI=0 USF=0 -PDCH(bts=0,trx=0,ts=3) Attaching TBF(UL:TFI-0-0-0:G:TLLI-0xecc1f953){NEW}, 1 TBFs, USFs = 01, TFIs = 00000001. -TBF(UL:TFI-0-0-0:G:TLLI-0xecc1f953){NEW} Setting Control TS PDCH(bts=0,trx=0,ts=2) -TBF(UL:TFI-0-0-0:G:TLLI-0xecc1f953){NEW} Allocated: trx = 0, ul_slots = 0c, dl_slots = 00 -MS(TLLI-0xecc1f953:TA-220:MSCLS-0-0) Attaching UL TBF: TBF(UL:TFI-0-0-0:G:TLLI-0xecc1f953){NEW} -MS(TLLI-0xecc1f953:TA-220:MSCLS-0-0:UL): + tbf: now used by 1 (tbf) -UL_TBF(UL:TFI-0-0-0:G:TLLI-0xecc1f953){NEW}: Received Event ASSIGN_ADD_PACCH -TBF(UL:TFI-0-0-0:G:TLLI-0xecc1f953){NEW} set ass. type PACCH [prev CCCH:0, PACCH:0] -UL_TBF(UL:TFI-0-0-0:G:TLLI-0xecc1f953){NEW}: state_chg to ASSIGN -TBF(UL:TFI-0-0-0:G:TLLI-0xecc1f953){ASSIGN} Starting timer T3168 [UL TBF Ass (PACCH)] with 16 sec. 0 microsec -There is a new MS object for the same MS: (0xa3c2f953, '001001000000001') -> (0xecc1f953, '') -MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0:DL): + ms_merge_and_clear_ms: now used by 2 (tbf,ms_merge_and_clear_ms) -MS(TLLI-0xecc1f953:TA-220:MSCLS-0-0:UL) Merge MS: MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0:DL) -Modifying MS object, TLLI = 0xecc1f953, MS class 0 -> 11 -MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0:DL) Clearing MS object -TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){ASSIGN} free -PDCH(bts=0,trx=1,ts=5) Detaching TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){ASSIGN}, 1 TBFs, USFs = 00, TFIs = 00000001. -MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0:DL) Detaching TBF: TBF(DL:G:IMSI-001001000000001:TLLI-0xa3c2f953){ASSIGN} -MS(IMSI-001001000000001:TLLI-0xa3c2f953:TA-220:MSCLS-11-0): - tbf: now used by 1 (ms_merge_and_clear_ms) -********** DL-TBF ends here ********** -DL_TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){ASSIGN}: Deallocated -UL_ASS_TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){NONE}: Deallocated -DL_ASS_TBF(DL:TFI-0-1-0:G:IMSI-001001000000001:TLLI-0xa3c2f953){NONE}: Deallocated -MS(TA-220:MSCLS-11-0): - ms_merge_and_clear_ms: now used by 0 (-) -MS(TA-220:MSCLS-11-0) Destroying MS object -Modifying MS object, TLLI: 0xecc1f953 confirmed -MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:UL) appending 19 bytes to DL LLC queue -[DL] algo B <multi> (suggested TRX: 0): Alloc start -Found first unallocated TRX=0 TFI=0 -Selected DL slots: (TS=0)".DDDddd."(TS=7), multi -[DL] algo B <multi> (suggested TRX: 0): using 3 slots -- Available DL/UL slots: (TS=0)"..CCDDD."(TS=7) -MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:UL) ********** DL-TBF starts here ********** -MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:UL) Allocating DL TBF -UL_ASS_TBF{NONE}: Allocated -DL_ASS_TBF{NONE}: Allocated -DL_TBF{NEW}: Allocated -TBF(DL:TFI-0-0--1:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW} Assigning TS=1 TFI=0 -PDCH(bts=0,trx=0,ts=1) Attaching TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW}, 1 TBFs, USFs = 00, TFIs = 00000001. -TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW} Assigning TS=2 TFI=0 -PDCH(bts=0,trx=0,ts=2) Attaching TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW}, 1 TBFs, USFs = 01, TFIs = 00000001. -TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW} Assigning TS=3 TFI=0 -PDCH(bts=0,trx=0,ts=3) Attaching TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW}, 1 TBFs, USFs = 01, TFIs = 00000001. -TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW} Setting Control TS PDCH(bts=0,trx=0,ts=2) -TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW} Allocated: trx = 0, ul_slots = 04, dl_slots = 0e -MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:UL) Attaching DL TBF: TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW} -MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:UL:DL): + tbf: now used by 2 (2*tbf) -TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW} [DOWNLINK] START (PACCH) -TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW} Send downlink assignment on PACCH, because TBF(UL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){ASSIGN} exists -DL_ASS_TBF(UL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NONE}: Received Event SCHED_ASS -DL_ASS_TBF(UL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NONE}: state_chg to SEND_ASS -DL_TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW}: Received Event ASSIGN_ADD_PACCH -TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW} set ass. type PACCH [prev CCCH:0, PACCH:0] -DL_TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){NEW}: state_chg to ASSIGN -TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){ASSIGN} Starting timer X2001 [assignment (PACCH)] with 2 sec. 0 microsec -DL_TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){ASSIGN}: Received Event ASSIGN_PCUIF_CNF -TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){ASSIGN} Ignoring event ASSIGN_PCUIF_CNF from BTS (CCCH was not requested on current assignment) -DL_ASS_TBF(UL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){SEND_ASS}: Received Event CREATE_RLCMAC_MSG -PDCH(bts=0,trx=0,ts=2) POLL scheduled at FN 0 + 13 = 13 -TBF(UL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){ASSIGN} start Packet Downlink Assignment (PACCH) for TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){ASSIGN} -+++++++++++++++++++++++++ TX : Packet Downlink Assignment +++++++++++++++++++++++++ -------------------------- TX : Packet Downlink Assignment ------------------------- -PDCH(bts=0,trx=0,ts=2) Reserving FN 13 for type POLL -TBF(UL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){ASSIGN} Scheduled DL Assignment polling on PACCH (FN=13, TS=2) -DL_ASS_TBF(UL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){SEND_ASS}: state_chg to WAIT_ACK -PDCH(bts=0,trx=0,ts=2) FN=0 Scheduling control message at RTS for TBF(UL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){ASSIGN} -=== end test_ms_merge_dl_tbf_different_trx === -MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:UL:DL) Destroying MS object -MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:UL:DL) Detaching TBF: TBF(UL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){ASSIGN} -MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:DL): - tbf: now used by 1 (tbf) -MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0:DL) Detaching TBF: TBF(DL:TFI-0-0-0:G:IMSI-001001000000001:TLLI-0xecc1f953){ASSIGN} -MS(IMSI-001001000000001:TLLI-0xecc1f953:TA-220:MSCLS-11-0): - tbf: now used by 0 (-) +DL_TBF(DL:TFI-0-0-0:E:IMSI-0011223344:TLLI-0xf1223344){ASSIGN}: Timeout of X2001 +================================================================= +==2053==ERROR: AddressSanitizer: heap-use-after-free on address 0xb306cd24 at pc 0x0063c48d bp 0xbed61148 sp 0xbed6114c +READ of size 4 at 0xb306cd24 thread T0 + #0 0x63c48a in gprs_rlcmac_tbf::name(bool) const (/build/osmo-pcu-1.4.0.1-b04e1/_build/sub/tests/tbf/TbfTest+0x1fa48a) + #1 0x63b504 in tbf_name (/build/osmo-pcu-1.4.0.1-b04e1/_build/sub/tests/tbf/TbfTest+0x1f9504) + #2 0x69d7f2 in tbf_dl_fsm_timer_cb (/build/osmo-pcu-1.4.0.1-b04e1/_build/sub/tests/tbf/TbfTest+0x25b7f2) + +0xb306cd24 is located 2852 bytes inside of 23736-byte region [0xb306c200,0xb3071eb8) +freed by thread T0 here: + #0 0xb6a381e4 in __interceptor_free ../../../../src/libsanitizer/asan/asan_malloc_linux.cpp:52 + +previously allocated by thread T0 here: + #0 0xb6a38cae in __interceptor_malloc ../../../../src/libsanitizer/asan/asan_malloc_linux.cpp:69 + +SUMMARY: AddressSanitizer: heap-use-after-free (/build/osmo-pcu-1.4.0.1-b04e1/_build/sub/tests/tbf/TbfTest+0x1fa48a) in gprs_rlcmac_tbf::name(bool) const +Shadow bytes around the buggy address: + 0x3660d950: fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd + 0x3660d960: fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd + 0x3660d970: fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd + 0x3660d980: fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd + 0x3660d990: fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd +=>0x3660d9a0: fd fd fd fd[fd]fd fd fd fd fd fd fd fd fd fd fd + 0x3660d9b0: fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd + 0x3660d9c0: fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd + 0x3660d9d0: fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd + 0x3660d9e0: fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd + 0x3660d9f0: fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd fd +Shadow byte legend (one shadow byte represents 8 application bytes): + Addressable: 00 + Partially addressable: 01 02 03 04 05 06 07 + Heap left redzone: fa + Freed heap region: fd + Stack left redzone: f1 + Stack mid redzone: f2 + Stack right redzone: f3 + Stack after return: f5 + Stack use after scope: f8 + Global redzone: f9 + Global init order: f6 + Poisoned by user: f7 + Container overflow: fc + Array cookie: ac + Intra object redzone: bb + ASan internal: fe + Left alloca redzone: ca + Right alloca redzone: cb +==2053==ABORTING stdout: ../../../tests/testsuite.at:28: exit code was 1, expected 0 4. testsuite.at:25: 4. tbf (testsuite.at:25): FAILED (testsuite.at:28) Build step 'Execute shell' marked build as failure $ ssh-agent -k unset SSH_AUTH_SOCK; unset SSH_AGENT_PID; echo Agent pid 25087 killed; [ssh-agent] Stopped. Archiving artifacts

1 1

Jenkins build became unstable: ttcn3-mme-test-ogs #161
by jenkins＠lists.osmocom.org 17 Dec '23

17 Dec '23

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-mme-test-ogs/161/display/redi…>

1 1

Jenkins build is back to stable : TTCN3-centos-stp-test #1305
by jenkins＠lists.osmocom.org 14 Dec '23

14 Dec '23

See <https://jenkins.osmocom.org/jenkins/job/TTCN3-centos-stp-test/1305/display/…>

1 0

Jenkins build is back to stable : ttcn3-stp-test #1536
by jenkins＠lists.osmocom.org 14 Dec '23

14 Dec '23

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-stp-test/1536/display/redirect>

1 0

Build failed in Jenkins: osmo-gsm-tester_virtual #7425
by jenkins＠lists.osmocom.org 13 Dec '23

13 Dec '23

See <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_virtual/7425/displa…> Changes: ------------------------------------------ [...truncated 650.13 KB...] 09:56:56.219257 run osmo-ms-virt-phy/00093(pid=129): Terminated: ok {rc=0} 09:56:56.223513 --- ParallelTerminationStrategy: PID 130 died... 09:56:56.225315 run osmo-ms-virt-phy/00094(pid=130): Terminated: ok {rc=0} 09:56:56.229551 --- ParallelTerminationStrategy: PID 131 died... 09:56:56.231341 run osmo-ms-virt-phy/00095(pid=131): Terminated: ok {rc=0} 09:56:56.235637 --- ParallelTerminationStrategy: PID 132 died... 09:56:56.237448 run osmo-ms-virt-phy/00096(pid=132): Terminated: ok {rc=0} 09:56:56.241716 --- ParallelTerminationStrategy: PID 133 died... 09:56:56.243501 run osmo-ms-virt-phy/00097(pid=133): Terminated: ok {rc=0} 09:56:56.247758 --- ParallelTerminationStrategy: PID 134 died... 09:56:56.249574 run osmo-ms-virt-phy/00098(pid=134): Terminated: ok {rc=0} 09:56:56.253822 --- ParallelTerminationStrategy: PID 135 died... 09:56:56.255613 run osmo-ms-virt-phy/00099(pid=135): Terminated: ok {rc=0} 09:56:56.259853 --- ParallelTerminationStrategy: PID 136 died... 09:56:56.261652 run osmo-ms-mob/00000(pid=136): Terminated {rc=26112} 09:56:56.265891 --- ParallelTerminationStrategy: PID 137 died... 09:56:56.267734 run osmo-ms-mob/00001(pid=137): Terminated {rc=26112} 09:56:56.272058 --- ParallelTerminationStrategy: PID 138 died... 09:56:56.273901 run osmo-ms-mob/00002(pid=138): Terminated {rc=26112} 09:56:56.278234 --- ParallelTerminationStrategy: PID 139 died... 09:56:56.280017 run osmo-ms-mob/00003(pid=139): Terminated {rc=26112} 09:56:56.284261 --- ParallelTerminationStrategy: PID 140 died... 09:56:56.286075 run osmo-ms-mob/00004(pid=140): Terminated {rc=26112} 09:56:56.290348 --- ParallelTerminationStrategy: PID 141 died... 09:56:56.292156 run osmo-ms-mob/00005(pid=141): Terminated {rc=26112} 09:56:56.296508 --- ParallelTerminationStrategy: PID 142 died... 09:56:56.298367 run osmo-ms-mob/00006(pid=142): Terminated {rc=26112} 09:56:56.302786 --- ParallelTerminationStrategy: PID 143 died... 09:56:56.304657 run osmo-ms-mob/00007(pid=143): Terminated {rc=26112} 09:56:56.308985 --- ParallelTerminationStrategy: PID 144 died... 09:56:56.310774 run osmo-ms-mob/00008(pid=144): Terminated {rc=26112} 09:56:56.315076 --- ParallelTerminationStrategy: PID 145 died... 09:56:56.316927 run osmo-ms-mob/00009(pid=145): Terminated {rc=26112} 09:56:56.321218 --- ParallelTerminationStrategy: PID 146 died... 09:56:56.323014 run osmo-ms-mob/00010(pid=146): Terminated {rc=26112} 09:56:56.327321 --- ParallelTerminationStrategy: PID 147 died... 09:56:56.329155 run osmo-ms-mob/00011(pid=147): Terminated {rc=26112} 09:56:56.333476 --- ParallelTerminationStrategy: PID 148 died... 09:56:56.335341 run osmo-ms-mob/00012(pid=148): Terminated {rc=26112} 09:56:56.339698 --- ParallelTerminationStrategy: PID 149 died... 09:56:56.341543 run osmo-ms-mob/00013(pid=149): Terminated {rc=26112} 09:56:56.345905 --- ParallelTerminationStrategy: PID 150 died... 09:56:56.347716 run osmo-ms-mob/00014(pid=150): Terminated {rc=26112} 09:56:56.352098 --- ParallelTerminationStrategy: PID 151 died... 09:56:56.353894 run osmo-ms-mob/00015(pid=151): Terminated {rc=26112} 09:56:56.358195 --- ParallelTerminationStrategy: PID 152 died... 09:56:56.359997 run osmo-ms-mob/00016(pid=152): Terminated {rc=26112} 09:56:56.364352 --- ParallelTerminationStrategy: PID 153 died... 09:56:56.366209 run osmo-ms-mob/00017(pid=153): Terminated {rc=26112} 09:56:56.370605 --- ParallelTerminationStrategy: PID 154 died... 09:56:56.372492 run osmo-ms-mob/00018(pid=154): Terminated {rc=26112} 09:56:56.376916 --- ParallelTerminationStrategy: PID 155 died... 09:56:56.378801 run osmo-ms-mob/00019(pid=155): Terminated {rc=26112} 09:56:56.383148 --- ParallelTerminationStrategy: PID 156 died... 09:56:56.385004 run osmo-ms-mob/00020(pid=156): Terminated {rc=26112} 09:56:56.389379 --- ParallelTerminationStrategy: PID 157 died... 09:56:56.391239 run osmo-ms-mob/00021(pid=157): Terminated {rc=26112} 09:56:56.395515 --- ParallelTerminationStrategy: PID 158 died... 09:56:56.397333 run osmo-ms-mob/00022(pid=158): Terminated {rc=26112} 09:56:56.401661 --- ParallelTerminationStrategy: PID 159 died... 09:56:56.403478 run osmo-ms-mob/00023(pid=159): Terminated {rc=26112} 09:56:56.407825 --- ParallelTerminationStrategy: PID 160 died... 09:56:56.409702 run osmo-ms-mob/00024(pid=160): Terminated {rc=26112} 09:56:56.414036 --- ParallelTerminationStrategy: PID 161 died... 09:56:56.415851 run osmo-ms-mob/00025(pid=161): Terminated {rc=26112} 09:56:56.420184 --- ParallelTerminationStrategy: PID 162 died... 09:56:56.422007 run osmo-ms-mob/00026(pid=162): Terminated {rc=26112} 09:56:56.426322 --- ParallelTerminationStrategy: PID 163 died... 09:56:56.429020 run osmo-ms-mob/00027(pid=163): Terminated {rc=26112} 09:56:56.435824 --- ParallelTerminationStrategy: PID 164 died... 09:56:56.438689 run osmo-ms-mob/00028(pid=164): Terminated {rc=26112} 09:56:56.445393 --- ParallelTerminationStrategy: PID 165 died... 09:56:56.448166 run osmo-ms-mob/00029(pid=165): Terminated {rc=26112} 09:56:56.454861 --- ParallelTerminationStrategy: PID 166 died... 09:56:56.457795 run osmo-ms-mob/00030(pid=166): Terminated {rc=26112} 09:56:56.463363 --- ParallelTerminationStrategy: PID 167 died... 09:56:56.465442 run osmo-ms-mob/00031(pid=167): Terminated {rc=26112} 09:56:56.469942 --- ParallelTerminationStrategy: PID 168 died... 09:56:56.471773 run osmo-ms-mob/00032(pid=168): Terminated {rc=26112} 09:56:56.476149 --- ParallelTerminationStrategy: PID 169 died... 09:56:56.478035 run osmo-ms-mob/00033(pid=169): Terminated {rc=26112} 09:56:56.482498 --- ParallelTerminationStrategy: PID 170 died... 09:56:56.484386 run osmo-ms-mob/00034(pid=170): Terminated {rc=26112} 09:56:56.488771 --- ParallelTerminationStrategy: PID 171 died... 09:56:56.492157 run osmo-ms-mob/00035(pid=171): Terminated {rc=26112} 09:56:56.497044 --- ParallelTerminationStrategy: PID 172 died... 09:56:56.498952 run osmo-ms-mob/00036(pid=172): Terminated {rc=26112} 09:56:56.503355 --- ParallelTerminationStrategy: PID 173 died... 09:56:56.505264 run osmo-ms-mob/00037(pid=173): Terminated {rc=26112} 09:56:56.509812 --- ParallelTerminationStrategy: PID 174 died... 09:56:56.511708 run osmo-ms-mob/00038(pid=174): Terminated {rc=26112} 09:56:56.516198 --- ParallelTerminationStrategy: PID 175 died... 09:56:56.518134 run osmo-ms-mob/00039(pid=175): Terminated {rc=26112} 09:56:56.522557 --- ParallelTerminationStrategy: PID 176 died... 09:56:56.524450 run osmo-ms-mob/00040(pid=176): Terminated {rc=26112} 09:56:56.529266 --- ParallelTerminationStrategy: PID 177 died... 09:56:56.531849 run osmo-ms-mob/00041(pid=177): Terminated {rc=26112} 09:56:56.538584 --- ParallelTerminationStrategy: PID 178 died... 09:56:56.541514 run osmo-ms-mob/00042(pid=178): Terminated {rc=26112} 09:56:56.548298 --- ParallelTerminationStrategy: PID 179 died... 09:56:56.550990 run osmo-ms-mob/00043(pid=179): Terminated {rc=26112} 09:56:56.557814 --- ParallelTerminationStrategy: PID 180 died... 09:56:56.560604 run osmo-ms-mob/00044(pid=180): Terminated {rc=26112} 09:56:56.567404 --- ParallelTerminationStrategy: PID 181 died... 09:56:56.569990 run osmo-ms-mob/00045(pid=181): Terminated {rc=26112} 09:56:56.574498 --- ParallelTerminationStrategy: PID 182 died... 09:56:56.576329 run osmo-ms-mob/00046(pid=182): Terminated {rc=26112} 09:56:56.580690 --- ParallelTerminationStrategy: PID 183 died... 09:56:56.582517 run osmo-ms-mob/00047(pid=183): Terminated {rc=26112} 09:56:56.586847 --- ParallelTerminationStrategy: PID 184 died... 09:56:56.588692 run osmo-ms-mob/00048(pid=184): Terminated {rc=26112} 09:56:56.593031 --- ParallelTerminationStrategy: PID 185 died... 09:56:56.594891 run osmo-ms-mob/00049(pid=185): Terminated {rc=26112} 09:56:56.599257 --- ParallelTerminationStrategy: PID 186 died... 09:56:56.601121 run osmo-ms-mob/00050(pid=186): Terminated {rc=26112} 09:56:56.605811 --- ParallelTerminationStrategy: PID 187 died... 09:56:56.607654 run osmo-ms-mob/00051(pid=187): Terminated {rc=26112} 09:56:56.612090 --- ParallelTerminationStrategy: PID 188 died... 09:56:56.613993 run osmo-ms-mob/00052(pid=188): Terminated {rc=26112} 09:56:56.618353 --- ParallelTerminationStrategy: PID 189 died... 09:56:56.620164 run osmo-ms-mob/00053(pid=189): Terminated {rc=26112} 09:56:56.624488 --- ParallelTerminationStrategy: PID 190 died... 09:56:56.626306 run osmo-ms-mob/00054(pid=190): Terminated {rc=26112} 09:56:56.630619 --- ParallelTerminationStrategy: PID 191 died... 09:56:56.632476 run osmo-ms-mob/00055(pid=191): Terminated {rc=26112} 09:56:56.636870 --- ParallelTerminationStrategy: PID 192 died... 09:56:56.638751 run osmo-ms-mob/00056(pid=192): Terminated {rc=26112} 09:56:56.643182 --- ParallelTerminationStrategy: PID 193 died... 09:56:56.645089 run osmo-ms-mob/00057(pid=193): Terminated {rc=26112} 09:56:56.649477 --- ParallelTerminationStrategy: PID 194 died... 09:56:56.651394 run osmo-ms-mob/00058(pid=194): Terminated {rc=26112} 09:56:56.655742 --- ParallelTerminationStrategy: PID 195 died... 09:56:56.657668 run osmo-ms-mob/00059(pid=195): Terminated {rc=26112} 09:56:56.662042 --- ParallelTerminationStrategy: PID 196 died... 09:56:56.663915 run osmo-ms-mob/00060(pid=196): Terminated {rc=26112} 09:56:56.668242 --- ParallelTerminationStrategy: PID 197 died... 09:56:56.670127 run osmo-ms-mob/00061(pid=197): Terminated {rc=26112} 09:56:56.674513 --- ParallelTerminationStrategy: PID 198 died... 09:56:56.676378 run osmo-ms-mob/00062(pid=198): Terminated {rc=26112} 09:56:56.680774 --- ParallelTerminationStrategy: PID 199 died... 09:56:56.682683 run osmo-ms-mob/00063(pid=199): Terminated {rc=26112} 09:56:56.687092 --- ParallelTerminationStrategy: PID 200 died... 09:56:56.689009 run osmo-ms-mob/00064(pid=200): Terminated {rc=26112} 09:56:56.693468 --- ParallelTerminationStrategy: PID 201 died... 09:56:56.695364 run osmo-ms-mob/00065(pid=201): Terminated {rc=26112} 09:56:56.699852 --- ParallelTerminationStrategy: PID 202 died... 09:56:56.701759 run osmo-ms-mob/00066(pid=202): Terminated {rc=26112} 09:56:56.706153 --- ParallelTerminationStrategy: PID 203 died... 09:56:56.708126 run osmo-ms-mob/00067(pid=203): Terminated {rc=26112} 09:56:56.712653 --- ParallelTerminationStrategy: PID 204 died... 09:56:56.714539 run osmo-ms-mob/00068(pid=204): Terminated {rc=26112} 09:56:56.718888 --- ParallelTerminationStrategy: PID 205 died... 09:56:56.720685 run osmo-ms-mob/00069(pid=205): Terminated {rc=26112} 09:56:56.724907 --- ParallelTerminationStrategy: PID 206 died... 09:56:56.726679 run osmo-ms-mob/00070(pid=206): Terminated {rc=26112} 09:56:56.730953 --- ParallelTerminationStrategy: PID 207 died... 09:56:56.732755 run osmo-ms-mob/00071(pid=207): Terminated {rc=26112} 09:56:56.737177 --- ParallelTerminationStrategy: PID 208 died... 09:56:56.738972 run osmo-ms-mob/00072(pid=208): Terminated {rc=26112} 09:56:56.743369 --- ParallelTerminationStrategy: PID 209 died... 09:56:56.745452 run osmo-ms-mob/00073(pid=209): Terminated {rc=26112} 09:56:56.750331 --- ParallelTerminationStrategy: PID 210 died... 09:56:56.752218 run osmo-ms-mob/00074(pid=210): Terminated {rc=26112} 09:56:56.756583 --- ParallelTerminationStrategy: PID 211 died... 09:56:56.758412 run osmo-ms-mob/00075(pid=211): Terminated {rc=26112} 09:56:56.762763 --- ParallelTerminationStrategy: PID 212 died... 09:56:56.764645 run osmo-ms-mob/00076(pid=212): Terminated {rc=26112} 09:56:56.768990 --- ParallelTerminationStrategy: PID 213 died... 09:56:56.770884 run osmo-ms-mob/00077(pid=213): Terminated {rc=26112} 09:56:56.775210 --- ParallelTerminationStrategy: PID 214 died... 09:56:56.777088 run osmo-ms-mob/00078(pid=214): Terminated {rc=26112} 09:56:56.781516 --- ParallelTerminationStrategy: PID 215 died... 09:56:56.783357 run osmo-ms-mob/00079(pid=215): Terminated {rc=26112} 09:56:56.787673 --- ParallelTerminationStrategy: PID 216 died... 09:56:56.789495 run osmo-ms-mob/00080(pid=216): Terminated {rc=26112} 09:56:56.793815 --- ParallelTerminationStrategy: PID 217 died... 09:56:56.795661 run osmo-ms-mob/00081(pid=217): Terminated {rc=26112} 09:56:56.800024 --- ParallelTerminationStrategy: PID 218 died... 09:56:56.801927 run osmo-ms-mob/00082(pid=218): Terminated {rc=26112} 09:56:56.806316 --- ParallelTerminationStrategy: PID 219 died... 09:56:56.808141 run osmo-ms-mob/00083(pid=219): Terminated {rc=26112} 09:56:56.812488 --- ParallelTerminationStrategy: PID 220 died... 09:56:56.814352 run osmo-ms-mob/00084(pid=220): Terminated {rc=26112} 09:56:56.818777 --- ParallelTerminationStrategy: PID 221 died... 09:56:56.820684 run osmo-ms-mob/00085(pid=221): Terminated {rc=26112} 09:56:56.825044 --- ParallelTerminationStrategy: PID 222 died... 09:56:56.826836 run osmo-ms-mob/00086(pid=222): Terminated {rc=26112} 09:56:56.831114 --- ParallelTerminationStrategy: PID 223 died... 09:56:56.832996 run osmo-ms-mob/00087(pid=223): Terminated {rc=26112} 09:56:56.837378 --- ParallelTerminationStrategy: PID 224 died... 09:56:56.839269 run osmo-ms-mob/00088(pid=224): Terminated {rc=26112} 09:56:56.843612 --- ParallelTerminationStrategy: PID 225 died... 09:56:56.845515 run osmo-ms-mob/00089(pid=225): Terminated {rc=26112} 09:56:56.849836 --- ParallelTerminationStrategy: PID 226 died... 09:56:56.851648 run osmo-ms-mob/00090(pid=226): Terminated {rc=26112} 09:56:56.856012 --- ParallelTerminationStrategy: PID 227 died... 09:56:56.857859 run osmo-ms-mob/00091(pid=227): Terminated {rc=26112} 09:56:56.862115 --- ParallelTerminationStrategy: PID 228 died... 09:56:56.863905 run osmo-ms-mob/00092(pid=228): Terminated {rc=26112} 09:56:56.868198 --- ParallelTerminationStrategy: PID 229 died... 09:56:56.870113 run osmo-ms-mob/00093(pid=229): Terminated {rc=26112} 09:56:56.874529 --- ParallelTerminationStrategy: PID 230 died... 09:56:56.876421 run osmo-ms-mob/00094(pid=230): Terminated {rc=26112} 09:56:56.881907 --- ParallelTerminationStrategy: PID 231 died... 09:56:56.883794 run osmo-ms-mob/00095(pid=231): Terminated {rc=26112} 09:56:56.888189 --- ParallelTerminationStrategy: PID 232 died... 09:56:56.890041 run osmo-ms-mob/00096(pid=232): Terminated {rc=26112} 09:56:56.894456 --- ParallelTerminationStrategy: PID 233 died... 09:56:56.896345 run osmo-ms-mob/00097(pid=233): Terminated {rc=26112} 09:56:56.901197 --- ParallelTerminationStrategy: PID 234 died... 09:56:56.903123 run osmo-ms-mob/00098(pid=234): Terminated {rc=26112} 09:56:56.907606 --- ParallelTerminationStrategy: PID 235 died... 09:56:56.909669 run osmo-ms-mob/00099(pid=235): Terminated {rc=26112} 09:57:00.317289 --- ParallelTerminationStrategy: PID 35 died... 09:57:00.320011 run osmo-bts-virtual(pid=35): Terminated: ok {rc=0} --------------------------------------------------------------------- trial-7425 netreg_mass FAIL --------------------------------------------------------------------- 09:57:00.488990 tst trial-7425: Storing JUnit report in /build/trial-7425/run.2023-12-11_09-54-31/trial-7425.xml -------------------------------------------------------------------------------------------- trial-7425 FAIL -------------------------------------------------------------------------------------------- 09:57:00.533190 tst trial-7425: trial-7425: FAIL, 1 suites failed FAIL: netreg_mass (fail: 1) FAIL: register_default_mass.py (141.8 sec) Exception: Completion ratio of 26.000000% lower than threshold. + rm -rf trial-7425/inst + cd trial-7425 + command -v journalctl + [ ! -z /bin/journalctl ] + readlink last_run + journalctl -u ofono -o short-precise --since 2023-12-11 09:54:31 No journal files were found. + readlink last_run + tar czf /build/trial-7425-run.tgz run.2023-12-11_09-54-31 + tar czf /build/trial-7425-bin.tgz checksums.md5 open5gs.build-8.tgz osmo-bsc.build-20577.tgz osmo-bts-oc2g.build-7071.tgz osmo-bts-sysmo.build-9573.tgz osmo-bts.build-9049.tgz osmo-ggsn.build-8057.tgz osmo-hlr.build-10518.tgz osmo-hnbgw.build-6891.tgz osmo-mgw.build-10799.tgz osmo-msc.build-33758.tgz osmo-nitb.build-15470.tgz osmo-pcu-oc2g.build-4847.tgz osmo-pcu-sysmo.build-6128.tgz osmo-pcu.build-6091.tgz osmo-sgsn.build-35115.tgz osmo-stp.build-11091.tgz osmo-trx.build-6046.tgz osmocom-bb.build-5833.tgz srslte.build-19.tgz + exit 1 + fix_permissions_trap + set +x ### Clean up ### + trap - EXIT INT TERM 0 + fix_permissions + docker run --rm -v <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_virtual/ws/>:/workspace debian:bullseye chmod -R a+rwX /workspace/ Build step 'Execute shell' marked build as failure Archiving artifacts Recording test results [Checks API] No suitable checks publisher found.

1 6

Build failed in Jenkins: master-pysim » test,a1=default,a3=default,a4=default,simtester #867
by jenkins＠lists.osmocom.org 13 Dec '23

13 Dec '23

See <https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…> Changes: [pmaier(a)sysmocom.de] runtime: explain how file probing works ------------------------------------------ Started by upstream project "master-pysim" build number 867 originally caused by: Started by an SCM change Running as SYSTEM Building remotely on simtester in workspace <https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…> [ssh-agent] Looking for ssh-agent implementation... [ssh-agent] Exec ssh-agent (binary ssh-agent on a remote machine) $ ssh-agent SSH_AUTH_SOCK=/tmp/ssh-1EKhCz4SrVCO/agent.1715389 SSH_AGENT_PID=1715391 [ssh-agent] Started. Running ssh-add (command line suppressed) Identity added: <https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…> (osmocom-jenkins) [ssh-agent] Using credentials docs (OS#5798) The recommended git tool is: NONE No credentials specified > git rev-parse --resolve-git-dir <https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…> # timeout=10 Fetching changes from the remote Git repository > git config remote.origin.url https://gerrit.osmocom.org/pysim # timeout=10 Fetching upstream changes from https://gerrit.osmocom.org/pysim > git --version # timeout=10 > git --version # 'git version 2.30.2' > git fetch --tags --force --progress -- https://gerrit.osmocom.org/pysim +refs/heads/*:refs/remotes/origin/* # timeout=10 Checking out Revision 174fd32f17b7147724933cc3d8e33ebbb9541831 (origin/master) > git config core.sparsecheckout # timeout=10 > git checkout -f 174fd32f17b7147724933cc3d8e33ebbb9541831 # timeout=10 Commit message: "runtime: explain how file probing works" > git rev-list --no-walk b582c3c7ea1cb46deb074979e48b20d3e7100732 # timeout=10 [simtester] $ /bin/sh -xe /tmp/jenkins13679377054316037902.sh + /usr/bin/timeout 30m ./contrib/jenkins.sh + export PYTHONUNBUFFERED=1 + [ ! -d ./pysim-testdata/ ] + virtualenv -p python3 venv --system-site-packages created virtual environment CPython3.9.2.final.0-64 in 796ms creator CPython3Posix(dest=<https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…,> clear=False, no_vcs_ignore=False, global=True) seeder FromAppData(download=False, pip=bundle, setuptools=bundle, wheel=bundle, via=copy, app_data_dir=/home/jenkins/.local/share/virtualenv) added seed packages: pip==20.3.4, pkg_resources==0.0.0, pyshark==0.6, setuptools==44.1.1, wheel==0.34.2 activators BashActivator,CShellActivator,FishActivator,PowerShellActivator,PythonActivator,XonshActivator + . venv/bin/activate + [ = ./contrib/jenkins.sh ] + deactivate nondestructive + unset -f pydoc + [ -z ] + [ -z ] + [ -n ] + [ -n ] + [ -z ] + unset VIRTUAL_ENV + [ ! nondestructive = nondestructive ] + VIRTUAL_ENV=<https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…> + [ = cygwin ] + [ = msys ] + export VIRTUAL_ENV + _OLD_VIRTUAL_PATH=/usr/local/bin:/usr/bin:/bin:/usr/games:/home/jenkins/bin + PATH=<https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…>:/usr/local/bin:/usr/bin:/bin:/usr/games:/home/jenkins/bin + export PATH + [ -z ] + [ -z ] + _OLD_VIRTUAL_PS1=$ + [ x != x ] + basename <https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…> + PS1=(venv) $ + export PS1 + alias pydoc + true + [ -n ] + [ -n ] + pip install -r requirements.txt Collecting git+https://github.com/hologram-io/smpp.pdu (from -r requirements.txt (line 14)) Cloning https://github.com/hologram-io/smpp.pdu to /tmp/pip-req-build-4wd4y4c1 Running command git clone -q https://github.com/hologram-io/smpp.pdu /tmp/pip-req-build-4wd4y4c1 Requirement already satisfied: pyscard in /usr/lib/python3/dist-packages (from -r requirements.txt (line 1)) (2.0.0) Requirement already satisfied: pyserial in /usr/lib/python3/dist-packages (from -r requirements.txt (line 2)) (3.5b0) Requirement already satisfied: pytlv in /usr/local/lib/python3.9/dist-packages (from -r requirements.txt (line 3)) (0.71) Requirement already satisfied: cmd2>=1.5 in /usr/local/lib/python3.9/dist-packages (from -r requirements.txt (line 4)) (2.4.3) Requirement already satisfied: jsonpath-ng in /usr/local/lib/python3.9/dist-packages (from -r requirements.txt (line 5)) (1.5.3) Requirement already satisfied: construct>=2.9.51 in /usr/local/lib/python3.9/dist-packages (from -r requirements.txt (line 6)) (2.10.68) Requirement already satisfied: bidict in /usr/local/lib/python3.9/dist-packages (from -r requirements.txt (line 7)) (0.22.1) Requirement already satisfied: gsm0338 in /usr/local/lib/python3.9/dist-packages (from -r requirements.txt (line 8)) (1.0.0) Requirement already satisfied: pyyaml>=5.1 in /usr/local/lib/python3.9/dist-packages (from -r requirements.txt (line 9)) (6.0.1) Requirement already satisfied: termcolor in /usr/local/lib/python3.9/dist-packages (from -r requirements.txt (line 10)) (2.3.0) Requirement already satisfied: colorlog in /usr/local/lib/python3.9/dist-packages (from -r requirements.txt (line 11)) (6.7.0) Requirement already satisfied: pycryptodomex in /usr/local/lib/python3.9/dist-packages (from -r requirements.txt (line 12)) (3.18.0) Requirement already satisfied: packaging in /usr/local/lib/python3.9/dist-packages (from -r requirements.txt (line 13)) (23.1) Requirement already satisfied: wcwidth>=0.1.7 in /usr/local/lib/python3.9/dist-packages (from cmd2>=1.5->-r requirements.txt (line 4)) (0.2.6) Requirement already satisfied: pyperclip>=1.6 in /usr/local/lib/python3.9/dist-packages (from cmd2>=1.5->-r requirements.txt (line 4)) (1.8.2) Requirement already satisfied: attrs>=16.3.0 in /usr/local/lib/python3.9/dist-packages (from cmd2>=1.5->-r requirements.txt (line 4)) (23.1.0) Requirement already satisfied: six in /usr/lib/python3/dist-packages (from gsm0338->-r requirements.txt (line 8)) (1.16.0) Requirement already satisfied: ply in /usr/local/lib/python3.9/dist-packages (from jsonpath-ng->-r requirements.txt (line 5)) (3.11) Requirement already satisfied: decorator in /usr/local/lib/python3.9/dist-packages (from jsonpath-ng->-r requirements.txt (line 5)) (5.1.1) + pip install pyshark Requirement already satisfied: pyshark in ./venv/lib/python3.9/site-packages (0.6) Requirement already satisfied: termcolor in /usr/local/lib/python3.9/dist-packages (from pyshark) (2.3.0) Requirement already satisfied: appdirs in /usr/lib/python3/dist-packages (from pyshark) (1.4.4) Requirement already satisfied: lxml in /usr/lib/python3/dist-packages (from pyshark) (4.6.3) Requirement already satisfied: packaging in /usr/local/lib/python3.9/dist-packages (from pyshark) (23.1) + python -m unittest discover -v -s tests/ test_successful (test_apdu.TestApdu) ... ok test_successful_method (test_apdu.TestApdu) Test overloading of the success property with a custom method. ... ok test_2g (test_apdu.TestUsimAuth) ... ok test_3g (test_apdu.TestUsimAuth) ... ok test_3g_sync (test_apdu.TestUsimAuth) ... ok test_vgcs (test_apdu.TestUsimAuth) ... ok test_GreedyInt_decoder (test_construct.TestGreedyInt) ... ok test_GreedyInt_encoder (test_construct.TestGreedyInt) ... ok test_filter_dict (test_construct.TestUtils) ... ok test_filter_dict_nested (test_construct.TestUtils) ... ok test_de_encode_record (test_files.LinFixed_Test) Test the decoder and encoder for a linear-fixed EF. Performs first a decoder ... ok test_decode_record (test_files.LinFixed_Test) Test the decoder for a linear-fixed EF. Requires the given LinFixedEF subclass ... ok test_encode_record (test_files.LinFixed_Test) Test the encoder for a linear-fixed EF. Requires the given LinFixedEF subclass ... ok test_de_encode_record (test_files.TransRecEF_Test) Test the decoder and encoder for a transparent record-oriented EF. Performs first a decoder ... ok test_decode_record (test_files.TransRecEF_Test) Test the decoder for a transparent record-oriented EF. Requires the given TransRecEF subclass ... ok test_encode_record (test_files.TransRecEF_Test) Test the encoder for a transparent record-oriented EF. Requires the given TransRecEF subclass ... ok test_de_encode_file (test_files.TransparentEF_Test) Test the decoder and encoder for a transparent EF. Performs first a decoder ... ok test_decode_file (test_files.TransparentEF_Test) Test the decoder for a transparent EF. Requires the given TransparentEF subclass ... ok test_encode_file (test_files.TransparentEF_Test) Test the encoder for a transparent EF. Requires the given TransparentEF subclass ... ok test_decode_resp (test_ota.SmsOtaTestCase) ... ok test_encode_cmd (test_ota.SmsOtaTestCase) ... ok test_cmd_3des_ciphered (test_ota.Test_SMS_3DES) ... ok test_cmd_3des_none (test_ota.Test_SMS_3DES) ... ok test_cmd_3des_signed (test_ota.Test_SMS_3DES) ... ok test_resp_3des_ciphered (test_ota.Test_SMS_3DES) ... ok test_resp_3des_none (test_ota.Test_SMS_3DES) ... ok test_resp_3des_signed (test_ota.Test_SMS_3DES) ... ok test_resp_3des_signed_err (test_ota.Test_SMS_3DES) Expect an OtaCheckError exception if the computed CC != received CC ... ok test_cmd_aes128_ciphered (test_ota.Test_SMS_AES128) ... ok test_resp_aes128_ciphered (test_ota.Test_SMS_AES128) ... ok test_fromBytes (test_sms.Test_AddressField) ... ok test_fromBytes_odd (test_sms.Test_AddressField) ... ok test_toBytes (test_sms.Test_AddressField) ... ok test_toBytes_odd (test_sms.Test_AddressField) ... ok test_fromBytes (test_sms.Test_DELIVER) ... ok test_single_ie (test_sms.Test_SMS_UDH) ... ok test_single_ie_tail (test_sms.Test_SMS_UDH) ... ok test_single_ie_value (test_sms.Test_SMS_UDH) ... ok test_toBytes (test_sms.Test_SMS_UDH) ... ok test_two_ie_data_tail (test_sms.Test_SMS_UDH) ... ok test_fromBytes (test_sms.Test_SUBMIT) ... ok test_IE_empty (test_tlv.TestIE) ... ok test_IE_from_bytes (test_tlv.TestIE) ... ok test_XC_constr_class (test_tlv.TestTranscodable) Transcodable derived class with _construct class variable ... ok test_XC_constr_instance (test_tlv.TestTranscodable) Transcodable derived class with _construct instance variable ... ok test_XC_method_instance (test_tlv.TestTranscodable) Transcodable derived class with _{from,to}_bytes() methods ... ok test_camel_to_snake (test_tlv.TestUtils) ... ok test_flatten_dict_lists (test_tlv.TestUtils) ... ok test_flatten_dict_lists_nested (test_tlv.TestUtils) ... ok test_flatten_dict_lists_nodict (test_tlv.TestUtils) ... ok testDecAct_allSet (test_utils.DecTestCase) ... ok testDecAct_noneSet (test_utils.DecTestCase) ... ok testDecAct_onlyCdma20001xRTT (test_utils.DecTestCase) ... ok testDecAct_onlyCdma2000HRPD (test_utils.DecTestCase) ... ok testDecAct_onlyEUtran (test_utils.DecTestCase) ... ok testDecAct_onlyGsm (test_utils.DecTestCase) ... ok testDecAct_onlyGsmCompact (test_utils.DecTestCase) ... ok testDecAct_onlyNgRan (test_utils.DecTestCase) ... ok testDecAct_onlyUtran (test_utils.DecTestCase) ... ok testDecMCCfromPLMN (test_utils.DecTestCase) ... ok testDecMCCfromPLMN_str (test_utils.DecTestCase) ... ok testDecMCCfromPLMN_unused (test_utils.DecTestCase) ... ok testDecMCCfromPLMN_unused_str (test_utils.DecTestCase) ... ok testDecMNCfromPLMN_threeDigitMNC (test_utils.DecTestCase) ... ok testDecMNCfromPLMN_threeDigitMNC_str (test_utils.DecTestCase) ... ok testDecMNCfromPLMN_twoDigitMNC (test_utils.DecTestCase) ... ok testDecMNCfromPLMN_twoDigitMNC_str (test_utils.DecTestCase) ... ok testDecMNCfromPLMN_unused (test_utils.DecTestCase) ... ok testDecMNCfromPLMN_unused_str (test_utils.DecTestCase) ... ok testDec_msisdn (test_utils.DecTestCase) ... ok testDecodeSuciCalcInfo (test_utils.DecTestCase) ... ok testDecxPlmn_w_act (test_utils.DecTestCase) ... ok testEnc_msisdn (test_utils.DecTestCase) ... ok testEncodeSuciCalcInfo (test_utils.DecTestCase) ... ok testFormatxPlmn_w_act (test_utils.DecTestCase) ... ok testSplitHexStringToListOf5ByteEntries (test_utils.DecTestCase) ... ok test_enc_plmn (test_utils.DecTestCase) ... ok testSeqOfChoices (test_utils.DoTestCase) A sequence of two choices with each a variety of DO/TLVs ... ok test_BerTlvLenDec (test_utils.TestBerTlv) ... ok test_BerTlvLenEnc (test_utils.TestBerTlv) ... ok test_BerTlvParseOne (test_utils.TestBerTlv) ... ok test_BerTlvTagDec (test_utils.TestBerTlv) ... ok test_ComprTlvTagDec (test_utils.TestComprTlv) ... ok test_ComprTlvTagEnc (test_utils.TestComprTlv) ... ok ---------------------------------------------------------------------- Ran 84 tests in 0.855s OK + cd pysim-testdata + ../tests/pySim-prog_test.sh pySim-prog_test - a test program to test pySim-prog.py ====================================================== Expecting to see the following cards: Fairwaves-SIM fakemagicsim sysmoISIM-SJA2 sysmosim-gr1 sysmoUSIM-SJS1 Wavemobile-SIM Number of card terminals installed: 6 == EXECUTING TEST == Probing card in terminal #0 Card is of type: Using PC/SC reader interface ../tests/pySim-prog_test.sh: line 166: Using PC/SC reader interface.data: No such file or directory Build step 'Execute shell' marked build as failure $ ssh-agent -k unset SSH_AUTH_SOCK; unset SSH_AGENT_PID; echo Agent pid 1715391 killed; [ssh-agent] Stopped. Archiving artifacts

1 1

Build failed in Jenkins: osmo-gsm-tester_virtual-jolly #6
by jenkins＠lists.osmocom.org 12 Dec '23

12 Dec '23

See <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_virtual-jolly/6/dis…> Changes: [Andreas Eversberg] jolly testing ------------------------------------------ [...truncated 36.54 KB...] osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile ---------------------------------------------- trial-6 netreg_mass register_default_mass.py ---------------------------------------------- 14:38:04.248170 tst register_default_mass.py:9: Claiming resources for the test 14:38:04.268117 tst netreg_mass: Using 1 x ip_address (candidates: 6) 14:38:04.268795 tst netreg_mass: Using 1 x ip_address (candidates: 6) 14:38:04.269401 tst netreg_mass: Using 1 x ip_address (candidates: 6) 14:38:04.269990 tst netreg_mass: Using 1 x ip_address (candidates: 6) 14:38:04.270590 tst netreg_mass: Using 1 x ip_address (candidates: 6) 14:38:04.271159 tst netreg_mass: Using 1 x ip_address (candidates: 6) 14:38:04.271711 tst netreg_mass: Using 1 x bts (candidates: 1) 14:38:04.308707 tst register_default_mass.py: using LAC 2 14:38:04.331238 tst register_default_mass.py: using RAC 2 14:38:04.358388 tst register_default_mass.py: using CellId 2 14:38:04.388730 tst register_default_mass.py: using BVCI 3 14:38:04.402877 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.403841 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.404630 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.405319 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.406009 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.406684 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.407346 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.408021 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.408680 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.409342 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.409999 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.410664 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.411332 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.412011 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.412672 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.413350 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.414018 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.414693 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.415351 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.416004 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.416675 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.417334 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.418008 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.418683 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.419342 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.420016 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.420665 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.421314 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.421977 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.422634 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.423281 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.423929 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.424576 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.425240 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.425896 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.426569 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.427225 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.427866 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.428513 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.429172 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.429806 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.430472 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.431124 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.431775 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.432443 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.433089 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.433744 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.434398 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.435071 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.435717 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.436382 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.437034 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.437696 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.438355 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.439001 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.439645 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.440296 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.440934 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.441585 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.442227 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.442884 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.443517 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.444236 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.444901 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.445548 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.446219 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.446932 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.447599 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.448246 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.448905 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.449554 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.450189 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.450856 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.451501 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.452144 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.452794 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.453437 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.454091 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.454745 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.455400 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.456049 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.456679 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.457328 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.457967 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.458636 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.459274 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.459929 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.460567 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.461205 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.461867 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.462522 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.463166 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.463820 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.464456 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.465112 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.465745 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.466397 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.467047 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.467682 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.468331 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.468968 tst netreg_mass: Using 1 x modem (candidates: 100) 14:38:04.469669 tst register_default_mass.py:21: Launching a simple network 14:38:04.478507 run osmo-hlr_127.0.42.2: Starting osmo-hlr 14:38:04.609663 run create_hlr_db(pid=21): Launched 14:38:05.622666 run create_hlr_db(pid=21): Terminated: ok {rc=0} 14:38:05.637548 run pcap-recorder_any(filters='host 127.0.42.2')(pid=23): Launched 14:38:05.651457 run osmo-hlr_127.0.42.2(pid=24): Launched 14:38:05.656704 run osmo-stp_127.0.42.5: Starting osmo-stp 14:38:05.867679 run pcap-recorder_any(filters='host 127.0.42.5 and port not 22')(pid=25): Launched 14:38:05.881761 run osmo-stp_127.0.42.5(pid=26): Launched 14:38:05.887003 run osmo-msc_127.0.42.6: Starting osmo-msc 14:38:06.315679 run pcap-recorder_any(filters='host 127.0.42.6 and port not 22')(pid=27): Launched 14:38:06.329767 run osmo-msc_127.0.42.6(pid=28): Launched 14:38:09.343685 run osmo-mgw_127.0.42.3: Starting osmo-mgw 14:38:09.500987 run pcap-recorder_any(filters='host 127.0.42.3 and port not 22')(pid=29): Launched 14:38:09.515136 run osmo-mgw_127.0.42.3(pid=30): Launched 14:38:09.520563 run osmo-mgw_127.0.42.4: Starting osmo-mgw 14:38:09.542289 run pcap-recorder_any(filters='host 127.0.42.4 and port not 22')(pid=31): Launched 14:38:09.556098 run osmo-mgw_127.0.42.4(pid=32): Launched 14:38:09.561311 run osmo-bsc_127.0.42.7: Starting osmo-bsc 14:38:09.920302 run pcap-recorder_any(filters='host 127.0.42.7 and port not 22')(pid=33): Launched 14:38:09.934556 run osmo-bsc_127.0.42.7(pid=34): Launched 14:38:15.965245 run osmo-bts-virtual: Starting to connect to osmo-bsc_127.0.42.7 14:38:16.173535 run osmo-bts-virtual(pid=35): Launched 14:38:17.213270 run osmo-bts-virtual(pid=35): ERR: Terminated: ERROR {rc=1} [trial-6↪netreg_mass↪register_default_mass.py:31↪register_default_mass.py↪osmo-bts-virtual↪osmo-bts-virtual(pid=35)] 14:38:17.234388 run osmo-bts-virtual(pid=35): stdout: | (launched: 2023-12-12_14:38:16.170302) 14:38:17.240220 run osmo-bts-virtual(pid=35): stderr: | Command line argument '-r' is deprecated, use VTY cpu-sched node setting 'policy rr 1' instead. | Command line argument '-i' is deprecated, use VTY parameter 'gsmtap-remote-host 127.0.42.7' instead. | ((*)) | | | / \ OsmoBTS | There is no such command. | Error occurred during reading the below line: | logging level lapd debug | | Failed to parse the config file: '/build/trial-6/run.2023-12-12_14-38-03/netreg_mass/register_default_mass.py/osmo-bts-virtual/osmo-bts-virtual.cfg' 14:38:17.245555 run osmo-bts-virtual(pid=35): stdout: | (launched: 2023-12-12_14:38:16.170302) 14:38:17.250587 run osmo-bts-virtual(pid=35): stderr: | Command line argument '-r' is deprecated, use VTY cpu-sched node setting 'policy rr 1' instead. | Command line argument '-i' is deprecated, use VTY parameter 'gsmtap-remote-host 127.0.42.7' instead. | ((*)) | | | / \ OsmoBTS | There is no such command. | Error occurred during reading the below line: | logging level lapd debug | | Failed to parse the config file: '/build/trial-6/run.2023-12-12_14-38-03/netreg_mass/register_default_mass.py/osmo-bts-virtual/osmo-bts-virtual.cfg' 14:38:17.256629 tst register_default_mass.py:31: ERR: Error: osmo-bts-virtual(pid=35): Process ended prematurely: osmo-bts-virtual(pid=35) [trial-6↪netreg_mass↪register_default_mass.py:31↪register_default_mass.py↪osmo-bts-virtual↪osmo-bts-virtual(pid=35)] [trial-6↪netreg_mass↪register_default_mass.py:31] 14:38:17.257007 tst register_default_mass.py:31: Test FAILED (13.0 sec) 14:38:17.257334 run pcap-recorder_any(filters='host 127.0.42.2')(pid=23): Terminating (SIGTERM) 14:38:17.259550 run osmo-hlr_127.0.42.2(pid=24): Terminating (SIGTERM) 14:38:17.261700 run pcap-recorder_any(filters='host 127.0.42.5 and port not 22')(pid=25): Terminating (SIGTERM) 14:38:17.263897 run osmo-stp_127.0.42.5(pid=26): Terminating (SIGTERM) 14:38:17.266100 run pcap-recorder_any(filters='host 127.0.42.6 and port not 22')(pid=27): Terminating (SIGTERM) 14:38:17.268369 run osmo-msc_127.0.42.6(pid=28): Terminating (SIGTERM) 14:38:17.270582 run pcap-recorder_any(filters='host 127.0.42.3 and port not 22')(pid=29): Terminating (SIGTERM) 14:38:17.272781 run osmo-mgw_127.0.42.3(pid=30): Terminating (SIGTERM) 14:38:17.275016 run pcap-recorder_any(filters='host 127.0.42.4 and port not 22')(pid=31): Terminating (SIGTERM) 14:38:17.277187 run osmo-mgw_127.0.42.4(pid=32): Terminating (SIGTERM) 14:38:17.279368 run pcap-recorder_any(filters='host 127.0.42.7 and port not 22')(pid=33): Terminating (SIGTERM) 14:38:17.281657 run osmo-bsc_127.0.42.7(pid=34): Terminating (SIGTERM) 14:38:17.283970 --- ParallelTerminationStrategy: PID 24 died... 14:38:17.285032 run osmo-hlr_127.0.42.2(pid=24): Terminated: ok {rc=0} 14:38:17.287552 --- ParallelTerminationStrategy: PID 26 died... 14:38:17.288604 run osmo-stp_127.0.42.5(pid=26): Terminated: ok {rc=0} 14:38:17.291151 --- ParallelTerminationStrategy: PID 30 died... 14:38:17.292205 run osmo-mgw_127.0.42.3(pid=30): Terminated {rc=15} 14:38:17.294749 --- ParallelTerminationStrategy: PID 32 died... 14:38:17.295799 run osmo-mgw_127.0.42.4(pid=32): Terminated {rc=15} 14:38:17.466340 --- ParallelTerminationStrategy: PID 23 died... 14:38:17.472054 run pcap-recorder_any(filters='host 127.0.42.2')(pid=23): Terminated: ok {rc=0} 14:38:17.474443 --- ParallelTerminationStrategy: PID 25 died... 14:38:17.475435 run pcap-recorder_any(filters='host 127.0.42.5 and port not 22')(pid=25): Terminated: ok {rc=0} 14:38:17.477807 --- ParallelTerminationStrategy: PID 27 died... 14:38:17.478799 run pcap-recorder_any(filters='host 127.0.42.6 and port not 22')(pid=27): Terminated: ok {rc=0} 14:38:17.481178 --- ParallelTerminationStrategy: PID 28 died... 14:38:17.482154 run osmo-msc_127.0.42.6(pid=28): Terminated: ok {rc=0} 14:38:17.484544 --- ParallelTerminationStrategy: PID 29 died... 14:38:17.485528 run pcap-recorder_any(filters='host 127.0.42.3 and port not 22')(pid=29): Terminated: ok {rc=0} 14:38:17.487906 --- ParallelTerminationStrategy: PID 31 died... 14:38:17.488908 run pcap-recorder_any(filters='host 127.0.42.4 and port not 22')(pid=31): Terminated: ok {rc=0} 14:38:17.491338 --- ParallelTerminationStrategy: PID 33 died... 14:38:17.492340 run pcap-recorder_any(filters='host 127.0.42.7 and port not 22')(pid=33): Terminated: ok {rc=0} 14:38:18.224226 --- ParallelTerminationStrategy: PID 34 died... 14:38:18.229711 run osmo-bsc_127.0.42.7(pid=34): Terminated: ok {rc=0} --------------------------------------------------------------------- trial-6 netreg_mass FAIL --------------------------------------------------------------------- 14:38:18.336904 tst trial-6: Storing JUnit report in /build/trial-6/run.2023-12-12_14-38-03/trial-6.xml -------------------------------------------------------------------------------------------- trial-6 FAIL -------------------------------------------------------------------------------------------- 14:38:18.344260 tst trial-6: trial-6: FAIL, 1 suites failed FAIL: netreg_mass (fail: 1) FAIL: register_default_mass.py (13.0 sec) Error: osmo-bts-virtual(pid=35): Process ended prematurely: osmo-bts-virtual(pid=35) [trial-6↪netreg_mass↪register_default_mass.py:31↪register_default_mass.py↪osmo-bts-virtual↪osmo-bts-virtual(pid=35)] + rm -rf trial-6/inst + cd trial-6 + command -v journalctl + [ ! -z /bin/journalctl ] + readlink last_run + journalctl -u ofono -o short-precise --since 2023-12-12 14:38:03 No journal files were found. + readlink last_run + tar czf /build/trial-6-run.tgz run.2023-12-12_14-38-03 + tar czf /build/trial-6-bin.tgz checksums.md5 open5gs.build-8.tgz osmo-bsc.build-20590.tgz osmo-bts-oc2g.build-7078.tgz osmo-bts-sysmo.build-9580.tgz osmo-bts.build-3.tgz osmo-ggsn.build-8063.tgz osmo-hlr.build-10527.tgz osmo-hnbgw.build-6909.tgz osmo-mgw.build-10808.tgz osmo-msc.build-33780.tgz osmo-nitb.build-15480.tgz osmo-pcu-oc2g.build-4849.tgz osmo-pcu-sysmo.build-6130.tgz osmo-pcu.build-6093.tgz osmo-sgsn.build-35138.tgz osmo-stp.build-11100.tgz osmo-trx.build-6054.tgz osmocom-bb.build-3.tgz srslte.build-19.tgz + exit 1 + fix_permissions_trap + set +x ### Clean up ### + trap - EXIT INT TERM 0 + fix_permissions + docker run --rm -v <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_virtual-jolly/ws/>:/workspace debian:bullseye chmod -R a+rwX /workspace/ Build step 'Execute shell' marked build as failure Archiving artifacts Recording test results [Checks API] No suitable checks publisher found.

1 1

Build failed in Jenkins: osmo-gsm-tester_virtual-jolly #2
by jenkins＠lists.osmocom.org 12 Dec '23

12 Dec '23

See <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_virtual-jolly/2/dis…> Changes: ------------------------------------------ [...truncated 50.52 KB...] 13:24:42.010698 tst register_default_mass.py: using MSISDN 1014 13:24:42.023807 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001020000000003', msisdn='1014', subscriber_id=14} 13:24:42.055027 tst register_default_mass.py: using MSISDN 1015 13:24:42.069018 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001020000000004', msisdn='1015', subscriber_id=15} 13:24:42.100729 tst register_default_mass.py: using MSISDN 1016 13:24:42.115053 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001020000000005', msisdn='1016', subscriber_id=16} 13:24:42.146717 tst register_default_mass.py: using MSISDN 1017 13:24:42.161307 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001020000000006', msisdn='1017', subscriber_id=17} 13:24:42.193041 tst register_default_mass.py: using MSISDN 1018 13:24:42.207405 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001020000000007', msisdn='1018', subscriber_id=18} 13:24:42.238684 tst register_default_mass.py: using MSISDN 1019 13:24:42.253001 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001020000000008', msisdn='1019', subscriber_id=19} 13:24:42.284123 tst register_default_mass.py: using MSISDN 1020 13:24:42.298354 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001020000000009', msisdn='1020', subscriber_id=20} 13:24:42.329812 tst register_default_mass.py: using MSISDN 1021 13:24:42.344286 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001030000000000', msisdn='1021', subscriber_id=21} 13:24:42.375475 tst register_default_mass.py: using MSISDN 1022 13:24:42.389753 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001030000000001', msisdn='1022', subscriber_id=22} 13:24:42.430085 tst register_default_mass.py: using MSISDN 1023 13:24:42.447247 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001030000000002', msisdn='1023', subscriber_id=23} 13:24:42.478291 tst register_default_mass.py: using MSISDN 1024 13:24:42.492377 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001030000000003', msisdn='1024', subscriber_id=24} 13:24:42.523632 tst register_default_mass.py: using MSISDN 1025 13:24:42.538274 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001030000000004', msisdn='1025', subscriber_id=25} 13:24:42.569394 tst register_default_mass.py: using MSISDN 1026 13:24:42.583604 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001030000000005', msisdn='1026', subscriber_id=26} 13:24:42.623649 tst register_default_mass.py: using MSISDN 1027 13:24:42.640841 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001030000000006', msisdn='1027', subscriber_id=27} 13:24:42.671970 tst register_default_mass.py: using MSISDN 1028 13:24:42.687075 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001030000000007', msisdn='1028', subscriber_id=28} 13:24:42.717904 tst register_default_mass.py: using MSISDN 1029 13:24:42.732200 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001030000000008', msisdn='1029', subscriber_id=29} 13:24:42.762320 tst register_default_mass.py: using MSISDN 1030 13:24:42.776166 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001030000000009', msisdn='1030', subscriber_id=30} 13:24:42.806521 tst register_default_mass.py: using MSISDN 1031 13:24:42.820099 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001040000000000', msisdn='1031', subscriber_id=31} 13:24:42.850198 tst register_default_mass.py: using MSISDN 1032 13:24:42.864003 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001040000000001', msisdn='1032', subscriber_id=32} 13:24:42.902645 tst register_default_mass.py: using MSISDN 1033 13:24:42.919456 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001040000000002', msisdn='1033', subscriber_id=33} 13:24:42.950757 tst register_default_mass.py: using MSISDN 1034 13:24:42.965195 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001040000000003', msisdn='1034', subscriber_id=34} 13:24:42.996430 tst register_default_mass.py: using MSISDN 1035 13:24:43.010794 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001040000000004', msisdn='1035', subscriber_id=35} 13:24:43.042175 tst register_default_mass.py: using MSISDN 1036 13:24:43.056388 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001040000000005', msisdn='1036', subscriber_id=36} 13:24:43.087329 tst register_default_mass.py: using MSISDN 1037 13:24:43.101434 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001040000000006', msisdn='1037', subscriber_id=37} 13:24:43.132808 tst register_default_mass.py: using MSISDN 1038 13:24:43.147060 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001040000000007', msisdn='1038', subscriber_id=38} 13:24:43.178174 tst register_default_mass.py: using MSISDN 1039 13:24:43.192450 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001040000000008', msisdn='1039', subscriber_id=39} 13:24:43.223718 tst register_default_mass.py: using MSISDN 1040 13:24:43.238200 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001040000000009', msisdn='1040', subscriber_id=40} 13:24:43.269611 tst register_default_mass.py: using MSISDN 1041 13:24:43.284211 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001050000000000', msisdn='1041', subscriber_id=41} 13:24:43.322940 tst register_default_mass.py: using MSISDN 1042 13:24:43.338701 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001050000000001', msisdn='1042', subscriber_id=42} 13:24:43.370550 tst register_default_mass.py: using MSISDN 1043 13:24:43.385244 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001050000000002', msisdn='1043', subscriber_id=43} 13:24:43.416826 tst register_default_mass.py: using MSISDN 1044 13:24:43.431319 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001050000000003', msisdn='1044', subscriber_id=44} 13:24:43.462628 tst register_default_mass.py: using MSISDN 1045 13:24:43.477049 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001050000000004', msisdn='1045', subscriber_id=45} 13:24:43.507817 tst register_default_mass.py: using MSISDN 1046 13:24:43.522017 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001050000000005', msisdn='1046', subscriber_id=46} 13:24:43.553143 tst register_default_mass.py: using MSISDN 1047 13:24:43.567315 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001050000000006', msisdn='1047', subscriber_id=47} 13:24:43.598600 tst register_default_mass.py: using MSISDN 1048 13:24:43.612884 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001050000000007', msisdn='1048', subscriber_id=48} 13:24:43.644162 tst register_default_mass.py: using MSISDN 1049 13:24:43.650920 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001050000000008', msisdn='1049', subscriber_id=49} 13:24:43.680177 tst register_default_mass.py: using MSISDN 1050 13:24:43.685134 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001050000000009', msisdn='1050', subscriber_id=50} 13:24:43.722133 tst register_default_mass.py: using MSISDN 1051 13:24:43.736162 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001060000000000', msisdn='1051', subscriber_id=51} 13:24:43.767437 tst register_default_mass.py: using MSISDN 1052 13:24:43.777569 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001060000000001', msisdn='1052', subscriber_id=52} 13:24:43.808790 tst register_default_mass.py: using MSISDN 1053 13:24:43.819468 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001060000000002', msisdn='1053', subscriber_id=53} 13:24:43.850478 tst register_default_mass.py: using MSISDN 1054 13:24:43.859899 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001060000000003', msisdn='1054', subscriber_id=54} 13:24:43.890491 tst register_default_mass.py: using MSISDN 1055 13:24:43.905149 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001060000000004', msisdn='1055', subscriber_id=55} 13:24:43.936139 tst register_default_mass.py: using MSISDN 1056 13:24:43.949742 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001060000000005', msisdn='1056', subscriber_id=56} 13:24:43.984125 tst register_default_mass.py: using MSISDN 1057 13:24:43.993046 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001060000000006', msisdn='1057', subscriber_id=57} 13:24:44.023167 tst register_default_mass.py: using MSISDN 1058 13:24:44.038700 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001060000000007', msisdn='1058', subscriber_id=58} 13:24:44.069044 tst register_default_mass.py: using MSISDN 1059 13:24:44.083474 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001060000000008', msisdn='1059', subscriber_id=59} 13:24:44.114561 tst register_default_mass.py: using MSISDN 1060 13:24:44.128852 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001060000000009', msisdn='1060', subscriber_id=60} 13:24:44.158860 tst register_default_mass.py: using MSISDN 1061 13:24:44.172680 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001070000000000', msisdn='1061', subscriber_id=61} 13:24:44.200844 tst register_default_mass.py: using MSISDN 1062 13:24:44.213879 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001070000000001', msisdn='1062', subscriber_id=62} 13:24:44.242264 tst register_default_mass.py: using MSISDN 1063 13:24:44.255413 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001070000000002', msisdn='1063', subscriber_id=63} 13:24:44.283925 tst register_default_mass.py: using MSISDN 1064 13:24:44.297037 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001070000000003', msisdn='1064', subscriber_id=64} 13:24:44.324588 tst register_default_mass.py: using MSISDN 1065 13:24:44.337031 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001070000000004', msisdn='1065', subscriber_id=65} 13:24:44.364930 tst register_default_mass.py: using MSISDN 1066 13:24:44.377725 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001070000000005', msisdn='1066', subscriber_id=66} 13:24:44.405872 tst register_default_mass.py: using MSISDN 1067 13:24:44.418805 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001070000000006', msisdn='1067', subscriber_id=67} 13:24:44.447016 tst register_default_mass.py: using MSISDN 1068 13:24:44.459965 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001070000000007', msisdn='1068', subscriber_id=68} 13:24:44.488455 tst register_default_mass.py: using MSISDN 1069 13:24:44.501585 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001070000000008', msisdn='1069', subscriber_id=69} 13:24:44.530055 tst register_default_mass.py: using MSISDN 1070 13:24:44.543194 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001070000000009', msisdn='1070', subscriber_id=70} 13:24:44.571250 tst register_default_mass.py: using MSISDN 1071 13:24:44.584393 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001080000000000', msisdn='1071', subscriber_id=71} 13:24:44.613040 tst register_default_mass.py: using MSISDN 1072 13:24:44.626125 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001080000000001', msisdn='1072', subscriber_id=72} 13:24:44.654257 tst register_default_mass.py: using MSISDN 1073 13:24:44.667063 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001080000000002', msisdn='1073', subscriber_id=73} 13:24:44.695143 tst register_default_mass.py: using MSISDN 1074 13:24:44.708070 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001080000000003', msisdn='1074', subscriber_id=74} 13:24:44.735806 tst register_default_mass.py: using MSISDN 1075 13:24:44.748469 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001080000000004', msisdn='1075', subscriber_id=75} 13:24:44.776490 tst register_default_mass.py: using MSISDN 1076 13:24:44.789276 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001080000000005', msisdn='1076', subscriber_id=76} 13:24:44.816426 tst register_default_mass.py: using MSISDN 1077 13:24:44.828861 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001080000000006', msisdn='1077', subscriber_id=77} 13:24:44.864805 tst register_default_mass.py: using MSISDN 1078 13:24:44.880801 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001080000000007', msisdn='1078', subscriber_id=78} 13:24:44.915372 tst register_default_mass.py: using MSISDN 1079 13:24:44.929987 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001080000000008', msisdn='1079', subscriber_id=79} 13:24:44.957377 tst register_default_mass.py: using MSISDN 1080 13:24:44.970069 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001080000000009', msisdn='1080', subscriber_id=80} 13:24:44.997182 tst register_default_mass.py: using MSISDN 1081 13:24:45.009639 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001090000000000', msisdn='1081', subscriber_id=81} 13:24:45.036792 tst register_default_mass.py: using MSISDN 1082 13:24:45.049200 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001090000000001', msisdn='1082', subscriber_id=82} 13:24:45.079408 tst register_default_mass.py: using MSISDN 1083 13:24:45.093519 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001090000000002', msisdn='1083', subscriber_id=83} 13:24:45.120605 tst register_default_mass.py: using MSISDN 1084 13:24:45.131984 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001090000000003', msisdn='1084', subscriber_id=84} 13:24:45.159192 tst register_default_mass.py: using MSISDN 1085 13:24:45.171488 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001090000000004', msisdn='1085', subscriber_id=85} 13:24:45.198485 tst register_default_mass.py: using MSISDN 1086 13:24:45.210976 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001090000000005', msisdn='1086', subscriber_id=86} 13:24:45.238423 tst register_default_mass.py: using MSISDN 1087 13:24:45.250874 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001090000000006', msisdn='1087', subscriber_id=87} 13:24:45.277976 tst register_default_mass.py: using MSISDN 1088 13:24:45.290314 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001090000000007', msisdn='1088', subscriber_id=88} 13:24:45.317817 tst register_default_mass.py: using MSISDN 1089 13:24:45.329342 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001090000000008', msisdn='1089', subscriber_id=89} 13:24:45.363808 tst register_default_mass.py: using MSISDN 1090 13:24:45.378614 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001090000000009', msisdn='1090', subscriber_id=90} 13:24:45.406390 tst register_default_mass.py: using MSISDN 1091 13:24:45.419383 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001100000000000', msisdn='1091', subscriber_id=91} 13:24:45.448283 tst register_default_mass.py: using MSISDN 1092 13:24:45.461614 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001100000000001', msisdn='1092', subscriber_id=92} 13:24:45.490522 tst register_default_mass.py: using MSISDN 1093 13:24:45.503896 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001100000000002', msisdn='1093', subscriber_id=93} 13:24:45.575986 tst register_default_mass.py: using MSISDN 1094 13:24:45.597478 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001100000000003', msisdn='1094', subscriber_id=94} 13:24:45.673627 tst register_default_mass.py: using MSISDN 1095 13:24:45.695145 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001100000000004', msisdn='1095', subscriber_id=95} 13:24:45.748336 tst register_default_mass.py: using MSISDN 1096 13:24:45.768211 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001100000000005', msisdn='1096', subscriber_id=96} 13:24:45.796923 tst register_default_mass.py: using MSISDN 1097 13:24:45.810843 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001100000000006', msisdn='1097', subscriber_id=97} 13:24:45.846811 tst register_default_mass.py: using MSISDN 1098 13:24:45.862141 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001100000000007', msisdn='1098', subscriber_id=98} 13:24:45.897795 tst register_default_mass.py: using MSISDN 1099 13:24:45.918871 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001100000000008', msisdn='1099', subscriber_id=99} 13:24:45.946773 tst register_default_mass.py: using MSISDN 1100 13:24:45.959919 run osmo-hlr_127.0.42.2: Add subscriber {algo=0, algo_str='none', imsi='001100000000009', msisdn='1100', subscriber_id=100} 13:24:45.980246 tst register_default_mass.py:39: ERR: RuntimeError: More than one match for bin name 'osmocom-bb' on run_label '': ['osmocom-bb.build-1.tgz', 'osmocom-bb.build-5836.tgz'] [trial-2↪netreg_mass↪register_default_mass.py:39] 13:24:45.981205 tst register_default_mass.py:39: Test FAILED (17.6 sec) 13:24:45.982015 run pcap-recorder_any(filters='host 127.0.42.2')(pid=23): Terminating (SIGTERM) 13:24:45.986283 run osmo-hlr_127.0.42.2(pid=24): Terminating (SIGTERM) 13:24:45.989086 run pcap-recorder_any(filters='host 127.0.42.5 and port not 22')(pid=25): Terminating (SIGTERM) 13:24:45.991337 run osmo-stp_127.0.42.5(pid=26): Terminating (SIGTERM) 13:24:45.993578 run pcap-recorder_any(filters='host 127.0.42.6 and port not 22')(pid=27): Terminating (SIGTERM) 13:24:45.995892 run osmo-msc_127.0.42.6(pid=28): Terminating (SIGTERM) 13:24:45.998201 run pcap-recorder_any(filters='host 127.0.42.3 and port not 22')(pid=29): Terminating (SIGTERM) 13:24:46.000514 run osmo-mgw_127.0.42.3(pid=30): Terminating (SIGTERM) 13:24:46.002771 run pcap-recorder_any(filters='host 127.0.42.4 and port not 22')(pid=31): Terminating (SIGTERM) 13:24:46.005034 run osmo-mgw_127.0.42.4(pid=32): Terminating (SIGTERM) 13:24:46.007336 run pcap-recorder_any(filters='host 127.0.42.7 and port not 22')(pid=33): Terminating (SIGTERM) 13:24:46.009603 run osmo-bsc_127.0.42.7(pid=34): Terminating (SIGTERM) 13:24:46.011864 run osmo-bts-virtual(pid=35): Terminating (SIGTERM) 13:24:46.014145 --- ParallelTerminationStrategy: PID 26 died... 13:24:46.015227 run osmo-stp_127.0.42.5(pid=26): Terminated: ok {rc=0} 13:24:46.017759 --- ParallelTerminationStrategy: PID 24 died... 13:24:46.018809 run osmo-hlr_127.0.42.2(pid=24): Terminated: ok {rc=0} 13:24:46.021323 --- ParallelTerminationStrategy: PID 30 died... 13:24:46.022384 run osmo-mgw_127.0.42.3(pid=30): Terminated {rc=15} 13:24:46.024864 --- ParallelTerminationStrategy: PID 32 died... 13:24:46.025870 run osmo-mgw_127.0.42.4(pid=32): Terminated {rc=15} 13:24:46.028359 --- ParallelTerminationStrategy: PID 28 died... 13:24:46.029353 run osmo-msc_127.0.42.6(pid=28): Terminated: ok {rc=0} 13:24:46.031847 --- ParallelTerminationStrategy: PID 34 died... 13:24:46.032877 run osmo-bsc_127.0.42.7(pid=34): Terminated: ok {rc=0} 13:24:46.203226 --- ParallelTerminationStrategy: PID 23 died... 13:24:46.208530 run pcap-recorder_any(filters='host 127.0.42.2')(pid=23): Terminated: ok {rc=0} 13:24:46.210848 --- ParallelTerminationStrategy: PID 25 died... 13:24:46.211817 run pcap-recorder_any(filters='host 127.0.42.5 and port not 22')(pid=25): Terminated: ok {rc=0} 13:24:46.214152 --- ParallelTerminationStrategy: PID 27 died... 13:24:46.215127 run pcap-recorder_any(filters='host 127.0.42.6 and port not 22')(pid=27): Terminated: ok {rc=0} 13:24:46.217493 --- ParallelTerminationStrategy: PID 29 died... 13:24:46.218484 run pcap-recorder_any(filters='host 127.0.42.3 and port not 22')(pid=29): Terminated: ok {rc=0} 13:24:46.220853 --- ParallelTerminationStrategy: PID 31 died... 13:24:46.221842 run pcap-recorder_any(filters='host 127.0.42.4 and port not 22')(pid=31): Terminated: ok {rc=0} 13:24:46.224250 --- ParallelTerminationStrategy: PID 33 died... 13:24:46.225259 run pcap-recorder_any(filters='host 127.0.42.7 and port not 22')(pid=33): Terminated: ok {rc=0} 13:24:51.878371 --- ParallelTerminationStrategy: PID 35 died... 13:24:51.883778 run osmo-bts-virtual(pid=35): Terminated: ok {rc=0} --------------------------------------------------------------------- trial-2 netreg_mass FAIL --------------------------------------------------------------------- 13:24:51.982266 tst trial-2: Storing JUnit report in /build/trial-2/run.2023-12-12_13-24-27/trial-2.xml -------------------------------------------------------------------------------------------- trial-2 FAIL -------------------------------------------------------------------------------------------- 13:24:51.996251 tst trial-2: trial-2: FAIL, 1 suites failed FAIL: netreg_mass (fail: 1) FAIL: register_default_mass.py (17.6 sec) RuntimeError: More than one match for bin name 'osmocom-bb' on run_label '': ['osmocom-bb.build-1.tgz', 'osmocom-bb.build-5836.tgz'] + rm -rf trial-2/inst + cd trial-2 + command -v journalctl + [ ! -z /bin/journalctl ] + readlink last_run + journalctl -u ofono -o short-precise --since 2023-12-12 13:24:27 No journal files were found. + readlink last_run + tar czf /build/trial-2-run.tgz run.2023-12-12_13-24-27 + tar czf /build/trial-2-bin.tgz checksums.md5 open5gs.build-8.tgz osmo-bsc.build-20588.tgz osmo-bts-oc2g.build-7076.tgz osmo-bts-sysmo.build-9578.tgz osmo-bts.build-9054.tgz osmo-ggsn.build-8061.tgz osmo-hlr.build-10525.tgz osmo-hnbgw.build-6905.tgz osmo-mgw.build-10806.tgz osmo-msc.build-33776.tgz osmo-nitb.build-15478.tgz osmo-pcu-oc2g.build-4849.tgz osmo-pcu-sysmo.build-6130.tgz osmo-pcu.build-6093.tgz osmo-sgsn.build-35134.tgz osmo-stp.build-11098.tgz osmo-trx.build-6051.tgz osmocom-bb.build-1.tgz osmocom-bb.build-5836.tgz srslte.build-19.tgz + exit 1 + fix_permissions_trap + set +x ### Clean up ### + trap - EXIT INT TERM 0 + fix_permissions + docker run --rm -v <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_virtual-jolly/ws/>:/workspace debian:bullseye chmod -R a+rwX /workspace/ Build step 'Execute shell' marked build as failure Archiving artifacts Recording test results [Checks API] No suitable checks publisher found.

1 3

Build failed in Jenkins: osmo-gsm-tester_build-osmo-bts-jolly #2
by jenkins＠lists.osmocom.org 12 Dec '23

12 Dec '23

See <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> Changes: ------------------------------------------ [...truncated 126.80 KB...] checking netinet/sctp.h presence... yes checking for netinet/sctp.h... yes checking for osmo_sock_init2_multiaddr in -losmocore... yes checking for library containing sctp_send... -lsctp checking pcap.h usability... yes checking pcap.h presence... yes checking for pcap.h... yes checking for doxygen... /usr/bin/doxygen checking that generated files are newer than configure... done configure: creating ./config.status config.status: creating libosmo-netif.pc config.status: creating include/Makefile config.status: creating include/osmocom/Makefile config.status: creating include/osmocom/netif/Makefile config.status: creating src/Makefile config.status: creating examples/Makefile config.status: creating utils/Makefile config.status: creating tests/Makefile config.status: creating Doxyfile config.status: creating Makefile config.status: creating contrib/libosmo-netif.spec config.status: creating config.h config.status: executing tests/atconfig commands config.status: executing depfiles commands config.status: executing libtool commands configure: WARNING: unrecognized options: --with-systemdsystemunitdir + set +x + make -j8 make all-recursive make[1]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making all in include make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making all in osmocom make[3]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making all in netif make[4]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[4]: Nothing to be done for 'all'. make[4]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[4]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[4]: Nothing to be done for 'all-am'. make[4]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Nothing to be done for 'all-am'. make[3]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making all in src make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> CC ipa.lo CC amr.lo CC datagram.lo CC ipa_unit.lo CC osmux_input.lo CC jibuf.lo CC osmux.lo CC osmux_output.lo CC prim.lo CC rs232.lo CC rtp.lo CC stream_cli.lo CC stream_srv.lo CC stream.lo CC sctp.lo CCLD libosmonetif.la ar: `u' modifier ignored since `D' is the default (see `U') make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making all in examples make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> CC ipa-stream-client.o CC ipa-stream-server.o CC stream-client.o CC rs232-read.o CC rs232-write.o CC stream-server.o CC rtp-udp-test-client.o CC rtp-udp-test-server.o CC udp-test-client.o CC udp-test-server.o CC osmux-test-input.o CC osmux-test-output.o CCLD ipa-stream-server CCLD stream-client CCLD stream-server CCLD rs232-read CCLD rs232-write CCLD rtp-udp-test-client CCLD rtp-udp-test-server CCLD udp-test-client CCLD udp-test-server CCLD osmux-test-input CCLD osmux-test-output CCLD ipa-stream-client make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making all in utils make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> CC osmo-amr-inspect.o CCLD osmo-amr-inspect make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making all in tests make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[2]: Nothing to be done for 'all'. make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[1]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> + set +x + make install make install-recursive make[1]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making install in include make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making install in osmocom make[3]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making install in netif make[4]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[5]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[5]: Nothing to be done for 'install-exec-am'. /bin/mkdir -p '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> /usr/bin/install -c -m 644 amr.h datagram.h jibuf.h osmux.h ipa.h ipa_unit.h prim.h rs232.h rtp.h stream.h sctp.h '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[5]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[4]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[4]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[5]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[5]: Nothing to be done for 'install-exec-am'. make[5]: Nothing to be done for 'install-data-am'. make[5]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[4]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[4]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[4]: Nothing to be done for 'install-exec-am'. make[4]: Nothing to be done for 'install-data-am'. make[4]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making install in src make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> /bin/mkdir -p '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> /bin/bash ../libtool --mode=install /usr/bin/install -c libosmonetif.la '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> libtool: install: /usr/bin/install -c .libs/libosmonetif.so.11.1.0 <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> libtool: install: (cd <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> && { ln -s -f libosmonetif.so.11.1.0 libosmonetif.so.11 || { rm -f libosmonetif.so.11 && ln -s libosmonetif.so.11.1.0 libosmonetif.so.11; }; }) libtool: install: (cd <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> && { ln -s -f libosmonetif.so.11.1.0 libosmonetif.so || { rm -f libosmonetif.so && ln -s libosmonetif.so.11.1.0 libosmonetif.so; }; }) libtool: install: /usr/bin/install -c .libs/libosmonetif.lai <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> libtool: install: /usr/bin/install -c .libs/libosmonetif.a <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> libtool: install: chmod 644 <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> libtool: install: ranlib <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> libtool: finish: PATH="/usr/local/bin:/usr/bin:/bin:/usr/games:/home/osmocom-build/bin:/sbin" ldconfig -n <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> ---------------------------------------------------------------------- Libraries have been installed in: <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> If you ever happen to want to link against installed libraries in a given directory, LIBDIR, you must either use libtool, and specify the full pathname of the library, or use the '-LLIBDIR' flag during linking and do at least one of the following: - add LIBDIR to the 'LD_LIBRARY_PATH' environment variable during execution - add LIBDIR to the 'LD_RUN_PATH' environment variable during linking - use the '-Wl,-rpath -Wl,LIBDIR' linker flag - have your system administrator add LIBDIR to '/etc/ld.so.conf' See any operating system documentation about shared libraries for more information, such as the ld(1) and ld.so(8) manual pages. ---------------------------------------------------------------------- make[3]: Nothing to be done for 'install-data-am'. make[3]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making install in examples make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Nothing to be done for 'install-exec-am'. make[3]: Nothing to be done for 'install-data-am'. make[3]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making install in utils make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Nothing to be done for 'install-exec-am'. make[3]: Nothing to be done for 'install-data-am'. make[3]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> Making install in tests make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Nothing to be done for 'install-exec-am'. make[3]: Nothing to be done for 'install-data-am'. make[3]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[2]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Nothing to be done for 'install-exec-am'. /bin/mkdir -p '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> /usr/bin/install -c -m 644 libosmo-netif.pc '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make install-data-hook make[4]: Entering directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[4]: Nothing to be done for 'install-data-hook'. make[4]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[3]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[2]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> make[1]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…'> + build_repo osmo-bts --enable-sanitize --enable-trx --with-openbsc=<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> --enable-octphy --with-octsdr-2g=<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> + dir=osmo-bts + shift + build_repo_dir osmo-bts ./ --enable-sanitize --enable-trx --with-openbsc=<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> --enable-octphy --with-octsdr-2g=<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> + dep=osmo-bts + dir=./ + branch=master + echo --enable-sanitize + grep ^- + [ -z --enable-sanitize ] + shift + shift + configure_opts=--enable-sanitize --enable-trx --with-openbsc=<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> --enable-octphy --with-octsdr-2g=<https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> + set +x ====================== osmo-bts + have_repo osmo-bts master + repo=osmo-bts + branch=master + echo OSMO_GSM_TESTER_BUILD_osmo-bts + sed s/-/_/g + branch_override_var=OSMO_GSM_TESTER_BUILD_osmo_bts + eval echo $OSMO_GSM_TESTER_BUILD_osmo_bts + echo jolly/tester + branch_override=jolly/tester + [ -n jolly/tester ] + branch=jolly/tester + cd <https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_build-osmo-bts-joll…> + [ -d osmo-bts ] + cd osmo-bts + git fetch + git rev-parse origin/jolly/tester fatal: ambiguous argument 'origin/jolly/tester': unknown revision or path not in the working tree. Use '--' to separate paths from revisions, like this: 'git <command> [<revision>...] -- [<file>...]' origin/jolly/tester + git checkout -B build_branch jolly/tester fatal: 'jolly/tester' is not a commit and a branch 'build_branch' cannot be created from it Build step 'Execute shell' marked build as failure Skipped archiving because build is not successful

1 1

2025

2024

2023

2022

2021

2020

2019

jenkins-notifications December 2023