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

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

Changes:

------------------------------------------ [...truncated 132.00 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-7239 netreg_mass register_default_mass.py ---------------------------------------------- 22:49:59.458002 tst register_default_mass.py:9: Claiming resources for the test 22:49:59.488545 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:59.489810 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:59.490928 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:59.492033 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:59.493135 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:59.494231 tst netreg_mass: Using 1 x ip_address (candidates: 6) 22:49:59.495331 tst netreg_mass: Using 1 x bts (candidates: 1) 22:49:59.556751 tst register_default_mass.py: using LAC 2 22:49:59.580049 tst register_default_mass.py: using RAC 2 22:49:59.606311 tst register_default_mass.py: using CellId 2 22:49:59.639651 tst register_default_mass.py: using BVCI 3 22:49:59.655078 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.656533 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.657851 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.659145 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.660458 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.661751 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.663039 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.664330 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.665656 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.666965 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.668261 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.669564 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.670868 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.672177 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.673497 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.674793 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.676081 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.677421 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.678707 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.679982 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.681273 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.682556 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.683840 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.685150 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.686426 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.687707 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.689004 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.690288 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.691619 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.692900 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.694168 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.695433 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.696722 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.697995 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.699269 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.700538 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.701813 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.703078 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.704355 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.705639 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.706902 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.708325 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.709990 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.711584 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.713056 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.714338 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.715610 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.716908 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.718178 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.719459 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.720775 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.722053 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.723345 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.724653 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.725938 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.727223 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.728650 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.729946 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.731278 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.732584 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.733855 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.735122 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.736509 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.737778 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.739111 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.740385 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.741669 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.742946 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.744215 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.745503 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.746775 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.748122 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.749406 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.750679 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.751943 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.753225 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.754508 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.755791 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.757110 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.758398 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.759680 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.760975 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.762244 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.763514 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.764840 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.766181 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.767461 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.768771 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.770038 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.771309 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.772660 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.774205 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.776051 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.777791 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.779027 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.780273 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.781534 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.782791 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.784049 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.785330 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.786636 tst netreg_mass: Using 1 x modem (candidates: 100) 22:49:59.788131 tst register_default_mass.py:21: Launching a simple network 22:49:59.807788 run osmo-hlr_127.0.42.2: Starting osmo-hlr 22:50:00.014968 run create_hlr_db(pid=21): Launched 22:50:01.036959 run create_hlr_db(pid=21): Terminated: ok {rc=0} 22:50:01.078011 run pcap-recorder_any(filters='host 127.0.42.2')(pid=23): Launched 22:50:01.108428 run osmo-hlr_127.0.42.2(pid=24): Launched 22:50:01.119034 run osmo-stp_127.0.42.5: Starting osmo-stp 22:50:01.441324 run pcap-recorder_any(filters='host 127.0.42.5 and port not 22')(pid=25): Launched 22:50:01.474583 run osmo-stp_127.0.42.5(pid=26): Launched 22:50:01.485379 run osmo-msc_127.0.42.6: Starting osmo-msc 22:50:02.219485 run pcap-recorder_any(filters='host 127.0.42.6 and port not 22')(pid=27): Launched 22:50:02.253890 run osmo-msc_127.0.42.6(pid=28): Launched 22:50:03.272259 run osmo-msc_127.0.42.6(pid=28): ERR: Terminated: ERROR {rc=8} [trial-7239↪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:50:03.286943 run osmo-msc_127.0.42.6(pid=28): stdout: | (launched: 2023-06-16_22:50:02.246501) 22:50:03.299387 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:50:03.312091 run osmo-msc_127.0.42.6(pid=28): stdout: | (launched: 2023-06-16_22:50:02.246501) 22:50:03.323850 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:50:03.339833 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-7239↪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-7239↪netreg_mass↪register_default_mass.py:24] 22:50:03.340830 tst register_default_mass.py:24: Test FAILED (3.9 sec) 22:50:03.341657 run pcap-recorder_any(filters='host 127.0.42.2')(pid=23): Terminating (SIGTERM) 22:50:03.345860 run osmo-hlr_127.0.42.2(pid=24): Terminating (SIGTERM) 22:50:03.351167 run pcap-recorder_any(filters='host 127.0.42.5 and port not 22')(pid=25): Terminating (SIGTERM) 22:50:03.355656 run osmo-stp_127.0.42.5(pid=26): Terminating (SIGTERM) 22:50:03.361267 run pcap-recorder_any(filters='host 127.0.42.6 and port not 22')(pid=27): Terminating (SIGTERM) 22:50:03.367355 --- ParallelTerminationStrategy: PID 24 died... 22:50:03.369693 run osmo-hlr_127.0.42.2(pid=24): Terminated: ok {rc=0} 22:50:03.541827 --- ParallelTerminationStrategy: PID 23 died... 22:50:03.545638 run pcap-recorder_any(filters='host 127.0.42.2')(pid=23): Terminated: ok {rc=0} 22:50:03.550096 --- ParallelTerminationStrategy: PID 25 died... 22:50:03.552060 run pcap-recorder_any(filters='host 127.0.42.5 and port not 22')(pid=25): Terminated: ok {rc=0} 22:50:03.556588 --- ParallelTerminationStrategy: PID 26 died... 22:50:03.558486 run osmo-stp_127.0.42.5(pid=26): Terminated: ok {rc=0} 22:50:03.562863 --- ParallelTerminationStrategy: PID 27 died... 22:50:03.564733 run pcap-recorder_any(filters='host 127.0.42.6 and port not 22')(pid=27): Terminated: ok {rc=0} --------------------------------------------------------------------- trial-7239 netreg_mass FAIL --------------------------------------------------------------------- 22:50:03.707450 tst trial-7239: Storing JUnit report in /build/trial-7239/run.2023-06-16_22-49-58/trial-7239.xml

-------------------------------------------------------------------------------------------- trial-7239 FAIL -------------------------------------------------------------------------------------------- 22:50:03.720502 tst trial-7239: trial-7239: FAIL, 1 suites failed FAIL: netreg_mass (fail: 1) FAIL: register_default_mass.py (3.9 sec) Error: osmo-msc_127.0.42.6(pid=28): Process ended prematurely: osmo-msc_127.0.42.6(pid=28) [trial-7239↪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-7239/inst + cd trial-7239 + command -v journalctl + [ ! -z /bin/journalctl ] + readlink last_run + journalctl -u ofono -o short-precise --since 2023-06-16 22:49:58 No journal files were found. + readlink last_run + tar czf /build/trial-7239-run.tgz run.2023-06-16_22-49-58 + tar czf /build/trial-7239-bin.tgz checksums.md5 open5gs.build-8.tgz osmo-bsc.build-19170.tgz osmo-bts-oc2g.build-6361.tgz osmo-bts-sysmo.build-8863.tgz osmo-bts.build-8338.tgz osmo-ggsn.build-7396.tgz osmo-hlr.build-9662.tgz osmo-hnbgw.build-5021.tgz osmo-mgw.build-9930.tgz osmo-msc.build-31583.tgz osmo-nitb.build-14265.tgz osmo-pcu-oc2g.build-4417.tgz osmo-pcu-sysmo.build-5699.tgz osmo-pcu.build-5661.tgz osmo-sgsn.build-32704.tgz osmo-stp.build-10214.tgz osmo-trx.build-5393.tgz osmocom-bb.build-5307.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.