Build failed in Jenkins: osmo-gsm-tester_virtual #7240

See https://jenkins.osmocom.org/jenkins/job/osmo-gsm-tester_virtual/7240/display/redirect

Changes:

------------------------------------------ [...truncated 132.01 KB...] osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile osmo-mobile

---------------------------------------------- trial-7240 netreg_mass register_default_mass.py ---------------------------------------------- 22:49:53.228819 tst register_default_mass.py:9: Claiming resources for the test 22:49:53.261952 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:53.263120 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:53.264214 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:53.265348 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:53.266425 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:53.267512 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:53.268646 tst netreg_mass: Using 1 x bts (candidates: 1) 22:49:53.329173 tst register_default_mass.py: using LAC 2 22:49:53.373912 tst register_default_mass.py: using RAC 2 22:49:53.412059 tst register_default_mass.py: using CellId 2 22:49:53.443505 tst register_default_mass.py: using BVCI 3 22:49:53.457902 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.459256 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.460547 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.461809 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.463072 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.464339 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.465636 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.466906 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.468173 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.469435 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.470699 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.471945 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.473205 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.474459 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.475707 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.476969 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.478222 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.479467 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.480725 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.481967 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.483199 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.484442 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.485681 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.486917 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.488143 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.489384 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.490623 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.491856 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.493098 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.494319 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.495526 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.496743 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.497962 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.499180 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.500414 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.501631 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.502846 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.504061 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.505285 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.506496 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.507808 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.509052 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.510266 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.511470 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.512698 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.513906 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.515143 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.516408 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.517634 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.518859 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.520088 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.521309 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.522521 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.523734 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.524940 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.526148 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.527353 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.528577 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.529781 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.530977 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.532172 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.533376 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.534671 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.535882 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.537096 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.538307 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.539515 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.540737 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.541939 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.543140 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.544344 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.545567 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.546763 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.547960 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.549163 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.550358 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.551550 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.552808 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.554019 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.555208 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.556411 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.557597 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.558780 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.559984 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.561191 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.562390 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.563592 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.564805 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.566043 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.567248 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.568494 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.569699 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.570902 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.572103 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.573306 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.574487 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.575672 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.576922 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.578704 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.580495 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.581839 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:53.583170 tst register_default_mass.py:21: Launching a simple network 22:49:53.602977 run osmo-hlr_127.0.42.2: Starting osmo-hlr 22:49:53.809184 run create_hlr_db(pid=21): Launched 22:49:54.830367 run create_hlr_db(pid=21): Terminated: ok {rc=0} 22:49:54.862850 run pcap-recorder_any(filters='host 127.0.42.2')(pid=23): Launched 22:49:54.891604 run osmo-hlr_127.0.42.2(pid=24): Launched 22:49:54.902958 run osmo-stp_127.0.42.5: Starting osmo-stp 22:49:55.237988 run pcap-recorder_any(filters='host 127.0.42.5 and port not 22')(pid=25): Launched 22:49:55.267536 run osmo-stp_127.0.42.5(pid=26): Launched 22:49:55.278489 run osmo-msc_127.0.42.6: Starting osmo-msc 22:49:55.954811 run pcap-recorder_any(filters='host 127.0.42.6 and port not 22')(pid=27): Launched 22:49:55.983989 run osmo-msc_127.0.42.6(pid=28): Launched 22:49:57.001252 run osmo-msc_127.0.42.6(pid=28): ERR: Terminated: ERROR {rc=8} [trial-7240↪netreg_mass↪register_default_mass.py:24↪register_default_mass.py↪osmo-msc_127.0.42.6↪osmo-msc_127.0.42.6(pid=28)] 22:49:57.013512 run osmo-msc_127.0.42.6(pid=28): stdout: | (launched: 2023-06-17_22:49:55.977982) 22:49:57.025664 run osmo-msc_127.0.42.6(pid=28): stderr: | sms contains 0 bytes in 1 blocks (ref 0) 0x608000000280 | osmo_signal contains 200 bytes in 6 blocks (ref 0) 0x608000000200 | struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00002f9f0 | struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00002f920 | struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00002f440 | struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00002f370 | struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00002a4a0 | msgb contains 0 bytes in 1 blocks (ref 0) 0x608000000180 | full talloc report on 'null_context' (total 24 bytes in 2 blocks) | struct lookup_helper contains 24 bytes in 1 blocks (ref 0) 0x60c00005ed20 22:49:57.037770 run osmo-msc_127.0.42.6(pid=28): stdout: | (launched: 2023-06-17_22:49:55.977982) 22:49:57.049310 run osmo-msc_127.0.42.6(pid=28): stderr: | sms contains 0 bytes in 1 blocks (ref 0) 0x608000000280 | osmo_signal contains 200 bytes in 6 blocks (ref 0) 0x608000000200 | struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00002f9f0 | struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00002f920 | struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00002f440 | struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00002f370 | struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00002a4a0 | msgb contains 0 bytes in 1 blocks (ref 0) 0x608000000180 | full talloc report on 'null_context' (total 24 bytes in 2 blocks) | struct lookup_helper contains 24 bytes in 1 blocks (ref 0) 0x60c00005ed20 22:49:57.063474 tst register_default_mass.py:24: ERR: Error: osmo-msc_127.0.42.6(pid=28): Process ended prematurely: osmo-msc_127.0.42.6(pid=28) [trial-7240↪netreg_mass↪register_default_mass.py:24↪register_default_mass.py↪osmo-msc_127.0.42.6↪osmo-msc_127.0.42.6(pid=28)] [trial-7240↪netreg_mass↪register_default_mass.py:24] 22:49:57.064359 tst register_default_mass.py:24: Test FAILED (3.8 sec) 22:49:57.065132 run pcap-recorder_any(filters='host 127.0.42.2')(pid=23): Terminating (SIGTERM) 22:49:57.069351 run osmo-hlr_127.0.42.2(pid=24): Terminating (SIGTERM) 22:49:57.073707 run pcap-recorder_any(filters='host 127.0.42.5 and port not 22')(pid=25): Terminating (SIGTERM) 22:49:57.077947 run osmo-stp_127.0.42.5(pid=26): Terminating (SIGTERM) 22:49:57.082597 run pcap-recorder_any(filters='host 127.0.42.6 and port not 22')(pid=27): Terminating (SIGTERM) 22:49:57.087358 --- ParallelTerminationStrategy: PID 24 died... 22:49:57.089314 run osmo-hlr_127.0.42.2(pid=24): Terminated: ok {rc=0} 22:49:57.261675 --- ParallelTerminationStrategy: PID 23 died... 22:49:57.265391 run pcap-recorder_any(filters='host 127.0.42.2')(pid=23): Terminated: ok {rc=0} 22:49:57.271848 --- ParallelTerminationStrategy: PID 25 died... 22:49:57.273683 run pcap-recorder_any(filters='host 127.0.42.5 and port not 22')(pid=25): Terminated: ok {rc=0} 22:49:57.278055 --- ParallelTerminationStrategy: PID 26 died... 22:49:57.279881 run osmo-stp_127.0.42.5(pid=26): Terminated: ok {rc=0} 22:49:57.284193 --- ParallelTerminationStrategy: PID 27 died... 22:49:57.285966 run pcap-recorder_any(filters='host 127.0.42.6 and port not 22')(pid=27): Terminated: ok {rc=0} --------------------------------------------------------------------- trial-7240 netreg_mass FAIL --------------------------------------------------------------------- 22:49:57.414267 tst trial-7240: Storing JUnit report in /build/trial-7240/run.2023-06-17_22-49-52/trial-7240.xml

-------------------------------------------------------------------------------------------- trial-7240 FAIL -------------------------------------------------------------------------------------------- 22:49:57.423428 tst trial-7240: trial-7240: FAIL, 1 suites failed FAIL: netreg_mass (fail: 1) FAIL: register_default_mass.py (3.8 sec) Error: osmo-msc_127.0.42.6(pid=28): Process ended prematurely: osmo-msc_127.0.42.6(pid=28) [trial-7240↪netreg_mass↪register_default_mass.py:24↪register_default_mass.py↪osmo-msc_127.0.42.6↪osmo-msc_127.0.42.6(pid=28)] + rm -rf trial-7240/inst + cd trial-7240 + command -v journalctl + [ ! -z /bin/journalctl ] + readlink last_run + journalctl -u ofono -o short-precise --since 2023-06-17 22:49:52 No journal files were found. + readlink last_run + tar czf /build/trial-7240-run.tgz run.2023-06-17_22-49-52 + tar czf /build/trial-7240-bin.tgz checksums.md5 open5gs.build-8.tgz osmo-bsc.build-19177.tgz osmo-bts-oc2g.build-6364.tgz osmo-bts-sysmo.build-8866.tgz osmo-bts.build-8341.tgz osmo-ggsn.build-7399.tgz osmo-hlr.build-9668.tgz osmo-hnbgw.build-5030.tgz osmo-mgw.build-9935.tgz osmo-msc.build-31593.tgz osmo-nitb.build-14272.tgz osmo-pcu-oc2g.build-4420.tgz osmo-pcu-sysmo.build-5702.tgz osmo-pcu.build-5664.tgz osmo-sgsn.build-32716.tgz osmo-stp.build-10219.tgz osmo-trx.build-5396.tgz osmocom-bb.build-5309.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.