See https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/display/redirect
Changes:
------------------------------------------ [...truncated 110.85 KiB...] Preparing to unpack .../libc6-dev_2.41-12+deb13u4_amd64.deb ... Unpacking libc6-dev:amd64 (2.41-12+deb13u4) over (2.41-12+deb13u3) ... Preparing to unpack .../libc-dev-bin_2.41-12+deb13u4_amd64.deb ... Unpacking libc-dev-bin (2.41-12+deb13u4) over (2.41-12+deb13u3) ... Preparing to unpack .../libc6_2.41-12+deb13u4_amd64.deb ... Unpacking libc6:amd64 (2.41-12+deb13u4) over (2.41-12+deb13u3) ... Setting up libc6:amd64 (2.41-12+deb13u4) ... (Reading database ... (Reading database ... 5%(Reading database ... 10%(Reading database ... 15%(Reading database ... 20%(Reading database ... 25%(Reading database ... 30%(Reading database ... 35%(Reading database ... 40%(Reading database ... 45%(Reading database ... 50%(Reading database ... 55%(Reading database ... 60%(Reading database ... 65%(Reading database ... 70%(Reading database ... 75%(Reading database ... 80%(Reading database ... 85%(Reading database ... 90%(Reading database ... 95%(Reading database ... 100%(Reading database ... 44388 files and directories currently installed.) Preparing to unpack .../libc-bin_2.41-12+deb13u4_amd64.deb ... Unpacking libc-bin (2.41-12+deb13u4) over (2.41-12+deb13u3) ... Setting up libc-bin (2.41-12+deb13u4) ... Selecting previously unselected package libc6-dbg:amd64. (Reading database ... (Reading database ... 5%(Reading database ... 10%(Reading database ... 15%(Reading database ... 20%(Reading database ... 25%(Reading database ... 30%(Reading database ... 35%(Reading database ... 40%(Reading database ... 45%(Reading database ... 50%(Reading database ... 55%(Reading database ... 60%(Reading database ... 65%(Reading database ... 70%(Reading database ... 75%(Reading database ... 80%(Reading database ... 85%(Reading database ... 90%(Reading database ... 95%(Reading database ... 100%(Reading database ... 44388 files and directories currently installed.) Preparing to unpack .../00-libc6-dbg_2.41-12+deb13u4_amd64.deb ... Unpacking libc6-dbg:amd64 (2.41-12+deb13u4) ... Selecting previously unselected package osmocom-keyring. Preparing to unpack .../01-osmocom-keyring_1.1.1.8.7873.202609212029~asan_amd64.deb ... Unpacking osmocom-keyring (1.1.1.8.7873.202609212029~asan) ... Selecting previously unselected package osmocom-nightly-asan. Preparing to unpack .../02-osmocom-nightly-asan_202609212029_amd64.deb ... Unpacking osmocom-nightly-asan (202609212029) ... Selecting previously unselected package libosmo-asn1-tcap1:amd64. Preparing to unpack .../03-libosmo-asn1-tcap1_0.3.0.0.202609212029~asan_amd64.deb ... Unpacking libosmo-asn1-tcap1:amd64 (0.3.0.0.202609212029~asan) ... Selecting previously unselected package libosmocore22:amd64. Preparing to unpack .../04-libosmocore22_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmocore22:amd64 (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package libosmovty13:amd64. Preparing to unpack .../05-libosmovty13_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmovty13:amd64 (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package libosmo-mgcp-client16:amd64. Preparing to unpack .../06-libosmo-mgcp-client16_1.16.1.1.ed64d.202609212029~asan_amd64.deb ... Unpacking libosmo-mgcp-client16:amd64 (1.16.1.1.ed64d.202609212029~asan) ... Selecting previously unselected package libosmo-mgcp-client16-dbgsym:amd64. Preparing to unpack .../07-libosmo-mgcp-client16-dbgsym_1.16.1.1.ed64d.202609212029~asan_amd64.deb ... Unpacking libosmo-mgcp-client16-dbgsym:amd64 (1.16.1.1.ed64d.202609212029~asan) ... Selecting previously unselected package libosmoisdn0:amd64. Preparing to unpack .../08-libosmoisdn0_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmoisdn0:amd64 (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package libosmogsm20:amd64. Preparing to unpack .../09-libosmogsm20_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmogsm20:amd64 (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package libosmonetif11:amd64. Preparing to unpack .../10-libosmonetif11_1.8.0.0.202609212029~asan_amd64.deb ... Unpacking libosmonetif11:amd64 (1.8.0.0.202609212029~asan) ... Selecting previously unselected package libosmo-sigtran12:amd64. Preparing to unpack .../11-libosmo-sigtran12_2.3.0.36.5f43.202609212029~asan_amd64.deb ... Unpacking libosmo-sigtran12:amd64 (2.3.0.36.5f43.202609212029~asan) ... Selecting previously unselected package libosmo-sigtran-dbg:amd64. Preparing to unpack .../12-libosmo-sigtran-dbg_2.3.0.36.5f43.202609212029~asan_amd64.deb ... Unpacking libosmo-sigtran-dbg:amd64 (2.3.0.36.5f43.202609212029~asan) ... Selecting previously unselected package libosmo-trx0:amd64. Preparing to unpack .../13-libosmo-trx0_1.8.0.45.dbd9.202609212029~asan_amd64.deb ... Unpacking libosmo-trx0:amd64 (1.8.0.45.dbd9.202609212029~asan) ... Selecting previously unselected package libosmoabis17:amd64. Preparing to unpack .../14-libosmoabis17_2.2.0.0.202609212029~asan_amd64.deb ... Unpacking libosmoabis17:amd64 (2.2.0.0.202609212029~asan) ... Selecting previously unselected package libosmocodec4:amd64. Preparing to unpack .../15-libosmocodec4_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmocodec4:amd64 (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package libosmocoding0:amd64. Preparing to unpack .../16-libosmocoding0_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmocoding0:amd64 (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package libosmogb14:amd64. Preparing to unpack .../17-libosmogb14_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmogb14:amd64 (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package libosmoctrl0:amd64. Preparing to unpack .../18-libosmoctrl0_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmoctrl0:amd64 (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package libosmosim2:amd64. Preparing to unpack .../19-libosmosim2_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmosim2:amd64 (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package libosmousb0:amd64. Preparing to unpack .../20-libosmousb0_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmousb0:amd64 (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package libosmocore. Preparing to unpack .../21-libosmocore_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmocore (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package libosmotrau11:amd64. Preparing to unpack .../22-libosmotrau11_2.2.0.0.202609212029~asan_amd64.deb ... Unpacking libosmotrau11:amd64 (2.2.0.0.202609212029~asan) ... Selecting previously unselected package osmo-bts-trx. Preparing to unpack .../23-osmo-bts-trx_1.12.0.1.31c0.202609212029~asan_amd64.deb ... Unpacking osmo-bts-trx (1.12.0.1.31c0.202609212029~asan) ... Selecting previously unselected package osmo-bts-virtual. Preparing to unpack .../24-osmo-bts-virtual_1.12.0.1.31c0.202609212029~asan_amd64.deb ... Unpacking osmo-bts-virtual (1.12.0.1.31c0.202609212029~asan) ... Selecting previously unselected package osmo-bts. Preparing to unpack .../25-osmo-bts_1.12.0.1.31c0.202609212029~asan_amd64.deb ... Unpacking osmo-bts (1.12.0.1.31c0.202609212029~asan) ... Selecting previously unselected package osmo-trx-proxy. Preparing to unpack .../26-osmo-trx-proxy_1.8.0.45.dbd9.202609212029~asan_amd64.deb ... Unpacking osmo-trx-proxy (1.8.0.45.dbd9.202609212029~asan) ... Selecting previously unselected package osmocom-bb-trxcon. Preparing to unpack .../27-osmocom-bb-trxcon_0.2.0.3692.6fef.202609212029~asan_amd64.deb ... Unpacking osmocom-bb-trxcon (0.2.0.3692.6fef.202609212029~asan) ... Selecting previously unselected package osmocom-bb-trxcon-dbgsym. Preparing to unpack .../28-osmocom-bb-trxcon-dbgsym_0.2.0.3692.6fef.202609212029~asan_amd64.deb ... Unpacking osmocom-bb-trxcon-dbgsym (0.2.0.3692.6fef.202609212029~asan) ... Selecting previously unselected package libosmo-asn1-tcap-dbg:amd64. Preparing to unpack .../29-libosmo-asn1-tcap-dbg_0.3.0.0.202609212029~asan_amd64.deb ... Unpacking libosmo-asn1-tcap-dbg:amd64 (0.3.0.0.202609212029~asan) ... Selecting previously unselected package libosmo-trx-dbg:amd64. Preparing to unpack .../30-libosmo-trx-dbg_1.8.0.45.dbd9.202609212029~asan_amd64.deb ... Unpacking libosmo-trx-dbg:amd64 (1.8.0.45.dbd9.202609212029~asan) ... Selecting previously unselected package libosmocore-dbg:amd64. Preparing to unpack .../31-libosmocore-dbg_1.14.2.8.0632.202609212029~asan_amd64.deb ... Unpacking libosmocore-dbg:amd64 (1.14.2.8.0632.202609212029~asan) ... Selecting previously unselected package osmo-bsc. Preparing to unpack .../32-osmo-bsc_1.15.0.1.3b4a2.202609212029~asan_amd64.deb ... Unpacking osmo-bsc (1.15.0.1.3b4a2.202609212029~asan) ... Selecting previously unselected package osmo-bsc-dbg:amd64. Preparing to unpack .../33-osmo-bsc-dbg_1.15.0.1.3b4a2.202609212029~asan_amd64.deb ... Unpacking osmo-bsc-dbg:amd64 (1.15.0.1.3b4a2.202609212029~asan) ... Selecting previously unselected package osmo-bts-trx-dbg. Preparing to unpack .../34-osmo-bts-trx-dbg_1.12.0.1.31c0.202609212029~asan_amd64.deb ... Unpacking osmo-bts-trx-dbg (1.12.0.1.31c0.202609212029~asan) ... Selecting previously unselected package osmo-bts-virtual-dbg. Preparing to unpack .../35-osmo-bts-virtual-dbg_1.12.0.1.31c0.202609212029~asan_amd64.deb ... Unpacking osmo-bts-virtual-dbg (1.12.0.1.31c0.202609212029~asan) ... Setting up libc6-dbg:amd64 (2.41-12+deb13u4) ... Setting up osmocom-keyring (1.1.1.8.7873.202609212029~asan) ... Setting up osmocom-nightly-asan (202609212029) ... Setting up libc-dev-bin (2.41-12+deb13u4) ... Setting up libosmocore22:amd64 (1.14.2.8.0632.202609212029~asan) ... Setting up libosmocodec4:amd64 (1.14.2.8.0632.202609212029~asan) ... Setting up libosmo-asn1-tcap1:amd64 (0.3.0.0.202609212029~asan) ... Setting up libc6-dev:amd64 (2.41-12+deb13u4) ... Setting up libosmovty13:amd64 (1.14.2.8.0632.202609212029~asan) ... Setting up libosmoisdn0:amd64 (1.14.2.8.0632.202609212029~asan) ... Setting up libosmo-asn1-tcap-dbg:amd64 (0.3.0.0.202609212029~asan) ... Setting up libosmousb0:amd64 (1.14.2.8.0632.202609212029~asan) ... Setting up libosmogsm20:amd64 (1.14.2.8.0632.202609212029~asan) ... Setting up libosmo-mgcp-client16:amd64 (1.16.1.1.ed64d.202609212029~asan) ... Setting up libosmoctrl0:amd64 (1.14.2.8.0632.202609212029~asan) ... Setting up libosmogb14:amd64 (1.14.2.8.0632.202609212029~asan) ... Setting up libosmotrau11:amd64 (2.2.0.0.202609212029~asan) ... Setting up libosmo-mgcp-client16-dbgsym:amd64 (1.16.1.1.ed64d.202609212029~asan) ... Setting up libosmonetif11:amd64 (1.8.0.0.202609212029~asan) ... Setting up libosmocoding0:amd64 (1.14.2.8.0632.202609212029~asan) ... Setting up libosmo-trx0:amd64 (1.8.0.45.dbd9.202609212029~asan) ... Setting up libosmosim2:amd64 (1.14.2.8.0632.202609212029~asan) ... Setting up libosmocore (1.14.2.8.0632.202609212029~asan) ... Setting up libosmo-trx-dbg:amd64 (1.8.0.45.dbd9.202609212029~asan) ... Setting up libosmo-sigtran12:amd64 (2.3.0.36.5f43.202609212029~asan) ... Setting up osmocom-bb-trxcon (0.2.0.3692.6fef.202609212029~asan) ... Setting up libosmoabis17:amd64 (2.2.0.0.202609212029~asan) ... Setting up osmo-bsc (1.15.0.1.3b4a2.202609212029~asan) ... changed ownership of '/etc/osmocom/osmo-bsc.cfg' from root:root to osmocom:osmocom mode of '/etc/osmocom/osmo-bsc.cfg' changed from 0644 (rw-r--r--) to 0660 (rw-rw----) changed ownership of '/etc/osmocom' from root:root to root:osmocom mode of '/etc/osmocom' changed from 0755 (rwxr-xr-x) to 2775 (rwxrwsr-x) changed ownership of '/var/lib/osmocom' from root:root to osmocom:osmocom Created symlink '/etc/systemd/system/multi-user.target.wants/osmo-bsc.service' → '/usr/lib/systemd/system/osmo-bsc.service'. Setting up libosmocore-dbg:amd64 (1.14.2.8.0632.202609212029~asan) ... Setting up osmo-trx-proxy (1.8.0.45.dbd9.202609212029~asan) ... Created symlink '/etc/systemd/system/multi-user.target.wants/osmo-trx-proxy.service' → '/usr/lib/systemd/system/osmo-trx-proxy.service'. Setting up osmocom-bb-trxcon-dbgsym (0.2.0.3692.6fef.202609212029~asan) ... Setting up libosmo-sigtran-dbg:amd64 (2.3.0.36.5f43.202609212029~asan) ... Setting up osmo-bsc-dbg:amd64 (1.15.0.1.3b4a2.202609212029~asan) ... Setting up osmo-bts-virtual (1.12.0.1.31c0.202609212029~asan) ... changed ownership of '/etc/osmocom/osmo-bts-virtual.cfg' from root:root to osmocom:osmocom mode of '/etc/osmocom/osmo-bts-virtual.cfg' changed from 0644 (rw-r--r--) to 0660 (rw-rw----) ownership of '/etc/osmocom' retained as root:osmocom mode of '/etc/osmocom' retained as 2775 (rwxrwsr-x) ownership of '/var/lib/osmocom' retained as osmocom:osmocom Created symlink '/etc/systemd/system/multi-user.target.wants/osmo-bts-virtual.service' → '/usr/lib/systemd/system/osmo-bts-virtual.service'. Setting up osmo-bts-virtual-dbg (1.12.0.1.31c0.202609212029~asan) ... Setting up osmo-bts-trx (1.12.0.1.31c0.202609212029~asan) ... changed ownership of '/etc/osmocom/osmo-bts-trx.cfg' from root:root to osmocom:osmocom mode of '/etc/osmocom/osmo-bts-trx.cfg' changed from 0644 (rw-r--r--) to 0660 (rw-rw----) ownership of '/etc/osmocom' retained as root:osmocom mode of '/etc/osmocom' retained as 2775 (rwxrwsr-x) ownership of '/var/lib/osmocom' retained as osmocom:osmocom Created symlink '/etc/systemd/system/multi-user.target.wants/osmo-bts-trx.service' → '/usr/lib/systemd/system/osmo-bts-trx.service'. Setting up osmo-bts-trx-dbg (1.12.0.1.31c0.202609212029~asan) ... Setting up osmo-bts (1.12.0.1.31c0.202609212029~asan) ... Processing triggers for systemd (257.13-1~deb13u1) ... Processing triggers for libc-bin (2.41-12+deb13u4) ... [1;34m[testenv][generic] Preparing testdir: https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic[0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'install', '-Dm644', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts/BTS_Tests.cfg', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/testsuite/BTS_Tests.cfg'][0m [0;94m[testenv][generic] + ['cp', '-a', 'osmo-bsc.cfg', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/bsc'][0m [0;94m[testenv][generic] + ['cp', '-a', 'osmo-trx-proxy.cfg', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/trx-proxy'][0m [0;94m[testenv][generic] + ['cp', '-a', 'osmo-bts.cfg', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/bts'][0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'install', '-Dm644', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts/BTS_Tests.default', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/testsuite/BTS_Tests.default'][0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'install', '-Dm644', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/Common.cfg', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/testsuite/Common.cfg'][0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'sed', '-i', 's#TTCN3_HACKS_PATH := .*#TTCN3_HACKS_PATH := "https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks"#', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/testsuite/Common.cfg'][0m [0;94m[testenv][generic] Adjusting testsuite config: https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/testsuite/Common.cfg[0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'sed', '-i', '-e', 's/\[MODULE_PARAMETERS\]/\[MODULE_PARAMETERS\]\nMisc_Helpers.mp_osmo_repo := "nightly"/g', '-e', 's#../Common.cfg#Common.cfg#', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/testsuite/Common.cfg'][0m [0;94m[testenv][generic] Adjusting testsuite config: https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/testsuite/BTS_Tests.cfg[0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'sed', '-i', '-e', 's/\[MODULE_PARAMETERS\]/\[MODULE_PARAMETERS\]\nMisc_Helpers.mp_osmo_repo := "nightly"/g', '-e', 's#../Common.cfg#Common.cfg#', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/testsuite/BTS_Tests.cfg'][0m [0;94m[testenv][generic] Adjusting testsuite config: https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/testsuite/BTS_Tests.default[0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'sed', '-i', '-e', 's/\[MODULE_PARAMETERS\]/\[MODULE_PARAMETERS\]\nMisc_Helpers.mp_osmo_repo := "nightly"/g', '-e', 's#../Common.cfg#Common.cfg#', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/testsuite/BTS_Tests.default'][0m [1;34m[testenv][generic] Running trx-proxy prepare script[0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', '-w', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/trx-proxy', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'sh', '-c', 'require_ulimit_r.sh 32'][0m [1;34m[testenv][generic] Running bts prepare script[0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', '-w', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/bts', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'sh', '-c', 'require_ulimit_r.sh 30'][0m [1;34m[testenv][generic] Running bsc[0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-w', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/bsc', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'sh', '-c', 'ulimit -c unlimited; osmo-bsc 2>&1 | tee https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/bsc/bsc.log'][0m [1;34m[testenv][generic] Running trx-proxy[0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-w', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/trx-proxy', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'sh', '-c', 'ulimit -c unlimited; osmo-trx-proxy 2>&1 | tee https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/trx-proxy/trx-proxy.log'][0m [1;35m20260922033029925 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m (bts=0) ACC: New ACC allowed subset 0x3ff (active_len=10, ramp_len=10, adm_len=10, perm_len=10, rotation=off) (acc.c:101)[0;m % VTY node 'asp' without a '[no] shutdown' command at the end is deprecated, please make sure you update your cfg file for future compatibility. 20260922033029928 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m Available via telnet 127.0.0.1 4242 (telnet_interface.c:88) [38;5;23m20260922033029928 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m E1L(0) enabling ipaccess BSC mode on 127.0.0.11 with OML 3002 and RSL 3003 TCP ports (ipaccess.c:1025)[0;m [38;5;33m20260922033029928 [1;33mDLCTRL[0;m[38;5;33m [1;33mNOTICE[0;m[38;5;33m CTRL at 127.0.0.1 4249 (control_if.c:1026)[0;m [1;36m20260922033029929 [1;33mDNM[0;m[1;36m [1;33mNOTICE[0;m[1;36m No MGW pool configured, using MGW configuration in VTY node 'msc' (osmo_bsc_main.c:877)[0;m [38;5;51m20260922033029929 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m MGW(mgw) MGCP client: using endpoint domain '@mgw' (mgcp_client.c:945)[0;m 20260922033029929 [1;33mDMSC[0;m [1;33mNOTICE[0;m (msc=0) To auto-configure msc, adding address 'addr-dyn-msc-default' to cs7 instance 0 address-book implicitly (osmo_bsc_sigtran.c:729) 20260922033029929 [1;33mDMSC[0;m [1;33mNOTICE[0;m Initializing SCCP connection for A/m3ua on cs7 instance 0 (osmo_bsc_sigtran.c:817) [38;5;45m20260922033029929 [1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m A-0-m3ua: Using SS7 instance 0, pc:0.23.3 (sccp_instance.c:643)[0;m [38;5;45m20260922033029929 [1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m A-0-m3ua: Using AS instance as-clnt-msc-0 (sccp_instance.c:661)[0;m [38;5;45m20260922033029929 [1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m A-0-m3ua: Creating default route (sccp_instance.c:667)[0;m [38;5;45m20260922033029929 [1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m A-0-m3ua: Using ASP instance asp-clnt-msc-0 (sccp_instance.c:772)[0;m [38;5;43m20260922033029929 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: Creating SCCP instance (ss7_instance.c:218)[0;m [38;5;45m20260922033029929 [1;32mDLSCCP[0;m[38;5;45m [1;32mINFO[0;m[38;5;45m 0: SCCP(rctx=0) Binding user 'SCCP Management' to SSN=1 PC=(no PC) (sccp_instance.c:168)[0;m 20260922033029929 [1;33mDMSC[0;m [1;33mNOTICE[0;m (msc=0) A-0-m3ua: local (BSC) SCCP address: RI=SSN_PC,PC=0.23.3,SSN=BSSAP (osmo_bsc_sigtran.c:870) 20260922033029929 [1;33mDMSC[0;m [1;33mNOTICE[0;m (msc=0) A-0-m3ua: remote (MSC) SCCP address: RI=SSN_PC,PC=0.23.1,SSN=BSSAP (osmo_bsc_sigtran.c:872) 20260922033029929 [1;33mDMSC[0;m [1;33mNOTICE[0;m (msc=0) A-0-m3ua: binding SCCP user (osmo_bsc_sigtran.c:877) [38;5;45m20260922033029929 [1;32mDLSCCP[0;m[38;5;45m [1;32mINFO[0;m[38;5;45m 0: SCCP(rctx=0) Binding user 'msc-0' to SSN=254 PC=(no PC) (sccp_instance.c:168)[0;m [38;5;23m20260922033029929 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m CLICONN(asp-clnt-msc-0,){CONNECTING} connect failed (-111) (stream_cli.c:446)[0;m [38;5;45m20260922033029930 [1;31mDLSCCP[0;m[38;5;45m [1;31mERROR[0;m[38;5;45m 0: SCCP(rctx=0) MTP-TRANSFER.req from SCCP for OPC=187=0.23.3,DPC=185=0.23.1,SLS=2: no route! (sccp_scrc.c:177)[0;m [38;5;45m20260922033029930 [1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m 0: SCCP(rctx=0) SCRC Routing Failure (MTP failure) for CL message CL:CLDT (sccp_sclc.c:359)[0;m 20260922033029930 [1;34mDMSC[0;m [1;34mDEBUG[0;m N-NOTICE.ind(00 04 30 04 01 20 ) (osmo_bsc_sigtran.c:348) 20260922033029930 [1;33mDMSC[0;m [1;33mNOTICE[0;m (msc=0) (calling_addr=RI=2,PC=185,SSN=254) N-NOTICE.ind cause=5='MTP failure' importance=0 (osmo_bsc_sigtran.c:168) 20260922033030100 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m Setting SCHED_RR priority 32 (cpu_sched_vty.c:475) 20260922033030100 [1;32mDPROXY[0;m [1;32mINFO[0;m (ep=bts) Opening TRXC/TRXD connections l=127.0.0.1:5700<->r=127.0.0.1:5800 (trx_ep.c:540) 20260922033030100 [1;32mDPROXY[0;m [1;32mINFO[0;m (ep=ms) Opening TRXC/TRXD connections l=127.0.0.1:6700<->r=127.0.0.1:6800 (trx_ep.c:540) 20260922033030100 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m Available via telnet 127.0.0.1 4237 (telnet_interface.c:88) 20260922033030100 [1;33mDPROXY[0;m [1;33mNOTICE[0;m osmo-trx-proxy started (main.c:148) [1;34m[testenv][generic] Running trxcon[0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/cache', '-e', 'TESTENV_SRC_DIR=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/_testenv/data/scripts/qemu:https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/ws/src/osmo-ttcn3-hacks/bts:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-w', 'https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/trxcon', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1', 'sh', '-c', 'ulimit -c unlimited; trxcon 2>&1 | tee https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/logs/generic/trxcon/trxcon.log'][0m ==642==ASan runtime does not come first in initial library list; you should either link runtime to your application or manually preload it with LD_PRELOAD. [1;34m[testenv][generic] Looking for a coredump file[0m [1;91m[testenv][generic] program failed to start: trxcon[0m [1;34m[testenv][generic] Stopping podman container[0m [0;94m[testenv][generic] + ['podman', 'kill', 'testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1'][0m testenv-bts-all-osmocom-nightly-asan-20260922-0330-16455799-1 [0;94m[testenv][generic] feed_watchdog_loop: podman container has stopped[0m [1;34m[testenv][generic] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/833/artifact/log... [0m + RC=1 + [ 1 = 0 ] + uptime + grep --color=always -o load.* [01;31m[Kload average: 2.52, 2.71, 2.52[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results ERROR: Step ‘Publish JUnit test result report’ failed: No test report files were found. Configuration error?
See https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/834/display/redirect
Changes:
------------------------------------------ [...truncated 2.39 MiB...] [1;33m20260923033223413 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Response message: 'RSP SETSLOT 0 0 13' (trx_if.c:674)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETPOWER 0 50' (trx_if.c:674)[0;m 20260923033223414 [1;32mDL1C[0;m [1;32mINFO[0;m TRX_PROV(phy0-0)[0x512000005aa0]{OPEN_POWEROFF}: Received Event TRX_PROV_EV_SETPOWER_CNF (trx_provision_fsm.c:109) 20260923033223414 [1;32mDL1C[0;m [1;32mINFO[0;m TRX_PROV(phy0-0)[0x512000005aa0]{OPEN_POWEROFF}: state_chg to OPEN_WAIT_POWERON_CNF (trx_provision_fsm.c:545) [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD POWERON' (trx_if.c:249)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Response message: 'RSP SETSLOT 0 1 13' (trx_if.c:674)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Response message: 'RSP SETSLOT 0 2 13' (trx_if.c:674)[0;m [1;33m20260923033223414 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts) Power on (trx.c:129)[0;m [1;33m20260923033223414 [1;33mDTRXC[0;m[1;33m [1;33mNOTICE[0;m[1;33m TDMA clock generator started (fn=1068765, period=102) (clck_gen.c:146)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Response message: 'RSP SETSLOT 0 1 3' (trx_if.c:674)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP POWERON 0' (trx_if.c:674)[0;m 20260923033223414 [1;32mDL1C[0;m [1;32mINFO[0;m TRX_PROV(phy0-0)[0x512000005aa0]{OPEN_WAIT_POWERON_CNF}: Received Event TRX_PROV_EV_POWERON_CNF (trx_provision_fsm.c:57) 20260923033223414 [1;33mDL1C[0;m [1;33mNOTICE[0;m GSM clock started, waiting for clock indications (scheduler_trx.c:490) 20260923033223414 [1;32mDL1C[0;m [1;32mINFO[0;m phy0: PHY link state change connecting -> connected (phy_link.c:58) 20260923033223414 [1;32mDL1C[0;m [1;32mINFO[0;m TRX_PROV(phy0-0)[0x512000005aa0]{OPEN_WAIT_POWERON_CNF}: state_chg to OPEN_POWERON (trx_provision_fsm.c:586) [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETRXGAIN 10' (trx_if.c:249)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETSLOT 0 5' (trx_if.c:249)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETSLOT 1 1' (trx_if.c:249)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETSLOT 2 1' (trx_if.c:249)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETSLOT 3 1' (trx_if.c:249)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETSLOT 4 8' (trx_if.c:249)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETSLOT 5 3' (trx_if.c:249)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETSLOT 6 7' (trx_if.c:249)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETSLOT 7 13' (trx_if.c:249)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Response message: 'RSP SETSLOT 0 3 8' (trx_if.c:674)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Response message: 'RSP SETSLOT 0 2 7' (trx_if.c:674)[0;m [1;33m20260923033223414 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=0) Unhandled command 'SETRXGAIN' (ctrl_cmd.c:471)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETRXGAIN 0 10' (trx_if.c:674)[0;m [1;33m20260923033223414 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Response message: 'RSP SETSLOT 0 2 3' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Response message: 'RSP SETSLOT 0 4 1' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETSLOT 0 0 5' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Response message: 'RSP SETSLOT 0 3 13' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Response message: 'RSP SETSLOT 0 5 7' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Response message: 'RSP SETSLOT 0 3 7' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETSLOT 0 1 1' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Response message: 'RSP SETSLOT 0 4 7' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Response message: 'RSP SETSLOT 0 6 13' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Response message: 'RSP SETSLOT 0 4 13' (trx_if.c:674)[0;m TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: Established a new IPA connection (conn_id=2) [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETSLOT 0 2 1' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Response message: 'RSP SETSLOT 0 5 1' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Response message: 'RSP SETSLOT 0 7 13' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Response message: 'RSP SETSLOT 0 5 1' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETSLOT 0 3 1' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Response message: 'RSP SETSLOT 0 6 13' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Response message: 'RSP SETSLOT 0 6 13' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETSLOT 0 4 8' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Response message: 'RSP SETSLOT 0 7 13' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Response message: 'RSP SETSLOT 0 7 7' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETSLOT 0 5 3' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETSLOT 0 6 7' (trx_if.c:674)[0;m [1;33m20260923033223415 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETSLOT 0 7 13' (trx_if.c:674)[0;m TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } [38;5;23m20260923033223416 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m received ID_GET for unit ID 1234/0/0 (ipaccess.c:901)[0;m [1;35m20260923033223416 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m (bts=0,trx=0) RSL link up (bts_trx.c:234)[0;m 20260923033223416 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=0) power_ramp_start(cur=-10000, tgt=30000) (tx_power.c:249) TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: A new IPA/RSL connection has been established (conn_id=2), waiting for IDENTITY RESPONSE... TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: Established a new IPA connection (conn_id=3) [1;35m20260923033223416 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m Tx RSL RF RESource INDication (rsl.c:519)[0;m TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } [1;35m20260923033223416 [1;34mDRSL[0;m[1;35m [1;34mDEBUG[0;m[1;35m (bts=0,trx=0) ACC RAMP: nm_obj=RADIO-CARRIER running=1 (acc.c:443)[0;m [1;35m20260923033223416 [1;34mDRSL[0;m[1;35m [1;34mDEBUG[0;m[1;35m (bts=0,trx=0) ACC RAMP: ignoring state change because TRX is not usable (acc.c:453)[0;m [1;35m20260923033223416 [1;34mDRSL[0;m[1;35m [1;34mDEBUG[0;m[1;35m (bts=0,trx=0) ACC RAMP: nm_obj=BASEBAND-TRANSCEIVER running=1 (acc.c:443)[0;m TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: A new IPA/RSL connection has been established (conn_id=3), waiting for IDENTITY RESPONSE... [38;5;23m20260923033223417 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m received ID_GET for unit ID 1234/0/1 (ipaccess.c:901)[0;m [1;35m20260923033223417 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m (bts=0,trx=1) RSL link up (bts_trx.c:234)[0;m 20260923033223417 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=1) power_ramp_start(cur=-10000, tgt=30000) (tx_power.c:249) [1;35m20260923033223417 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m Tx RSL RF RESource INDication (rsl.c:519)[0;m TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: Established a new IPA connection (conn_id=4) TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: A new IPA/RSL connection has been established (conn_id=4), waiting for IDENTITY RESPONSE... [38;5;23m20260923033223418 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m received ID_GET for unit ID 1234/0/2 (ipaccess.c:901)[0;m [1;35m20260923033223418 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m (bts=0,trx=2) RSL link up (bts_trx.c:234)[0;m 20260923033223418 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=2) power_ramp_start(cur=-10000, tgt=30000) (tx_power.c:249) [1;35m20260923033223418 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m Tx RSL RF RESource INDication (rsl.c:519)[0;m TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3000'O } } } } TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: IPA ID RESP: { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3000'O } } TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Got IDENTITY RESPONSE (conn_id=2): { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3000'O } } TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Warning: dec_IpaUnitId(): Data remained at the end of the stream after successful decoding: '00'O TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Mapped TRX#0 to TCP/IP conn_id=2 MTC@03d96655f345: 1/4 transceiver(s) connected TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: Established a new IPA connection (conn_id=5) TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } [38;5;23m20260923033223424 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m received ID_GET for unit ID 1234/0/3 (ipaccess.c:901)[0;m [1;35m20260923033223424 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m (bts=0,trx=3) RSL link up (bts_trx.c:234)[0;m 20260923033223424 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=3) power_ramp_start(cur=-10000, tgt=30000) (tx_power.c:249) [1;35m20260923033223425 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m Tx RSL RF RESource INDication (rsl.c:519)[0;m TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3100'O } } } } TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: IPA ID RESP: { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3100'O } } TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: A new IPA/RSL connection has been established (conn_id=5), waiting for IDENTITY RESPONSE... MTC@03d96655f345: 1/4 RF Resource Indication(s) received TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Got IDENTITY RESPONSE (conn_id=3): { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3100'O } } TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3200'O } } } } TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Warning: dec_IpaUnitId(): Data remained at the end of the stream after successful decoding: '00'O TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: IPA ID RESP: { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3200'O } } TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Mapped TRX#1 to TCP/IP conn_id=3 TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } MTC@03d96655f345: 2/4 transceiver(s) connected TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Got IDENTITY RESPONSE (conn_id=4): { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3200'O } } MTC@03d96655f345: 2/4 RF Resource Indication(s) received TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3300'O } } } } TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: IPA ID RESP: { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3300'O } } TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Warning: dec_IpaUnitId(): Data remained at the end of the stream after successful decoding: '00'O TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Mapped TRX#2 to TCP/IP conn_id=4 TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } MTC@03d96655f345: 3/4 transceiver(s) connected TC_rach_load_idle_thresh0-RSL-IPA(248)@03d96655f345: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Got IDENTITY RESPONSE (conn_id=5): { { len := 10, tag := IPAC_IDTAG_UNITNAME (1), data := '6F736D6F2D62747300'O }, { len := 10, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3300'O } } MTC@03d96655f345: 3/4 RF Resource Indication(s) received TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Warning: dec_IpaUnitId(): Data remained at the end of the stream after successful decoding: '00'O TC_rach_load_idle_thresh0-RSL(249)@03d96655f345: Mapped TRX#3 to TCP/IP conn_id=5 MTC@03d96655f345: 4/4 transceiver(s) connected MTC@03d96655f345: 4/4 RF Resource Indication(s) received [1;33m20260923033223848 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Clock indication: fn=1068858 (trx_if.c:103)[0;m 20260923033223848 [1;33mDL1C[0;m [1;33mNOTICE[0;m GSM clock started: first CLCK.ind fn=1068858 (scheduler_trx.c:554) 20260923033223854 [1;33mDL1P[0;m [1;33mNOTICE[0;m PH-RTS-IND: Unable to determine actual BS_AG_BLKS_RES value as SI3 is not available yet, fallback to 1 (sysinfo.c:162) 20260923033223854 [1;33mDL1P[0;m [1;33mNOTICE[0;m PH-DATA-REQ: Unable to determine actual BS_AG_BLKS_RES value as SI3 is not available yet, fallback to 1 (sysinfo.c:162) 20260923033223854 [1;33mDL1P[0;m [1;33mNOTICE[0;m GSMTAP: Unable to determine actual BS_AG_BLKS_RES value as SI3 is not available yet, fallback to 1 (sysinfo.c:162) 20260923033223881 [1;33mDL1P[0;m [1;33mNOTICE[0;m PH-RTS-IND: Unable to determine actual BS_AG_BLKS_RES value as SI3 is not available yet, fallback to 1 (sysinfo.c:162) 20260923033223881 [1;33mDL1P[0;m [1;33mNOTICE[0;m PH-DATA-REQ: Unable to determine actual BS_AG_BLKS_RES value as SI3 is not available yet, fallback to 1 (sysinfo.c:162) 20260923033223881 [1;33mDL1P[0;m [1;33mNOTICE[0;m GSMTAP: Unable to determine actual BS_AG_BLKS_RES value as SI3 is not available yet, fallback to 1 (sysinfo.c:162) 20260923033223900 [1;33mDL1P[0;m [1;33mNOTICE[0;m PH-RTS-IND: Unable to determine actual BS_AG_BLKS_RES value as SI3 is not available yet, fallback to 1 (sysinfo.c:162) 20260923033223900 [1;33mDL1P[0;m [1;33mNOTICE[0;m PH-DATA-REQ: Unable to determine actual BS_AG_BLKS_RES value as SI3 is not available yet, fallback to 1 (sysinfo.c:162) 20260923033223900 [1;33mDL1P[0;m [1;33mNOTICE[0;m GSMTAP: Unable to determine actual BS_AG_BLKS_RES value as SI3 is not available yet, fallback to 1 (sysinfo.c:162) MTC@03d96655f345: Setting RSL_SYSTEM_INFO_3 (3): { header := { l2_plen := { l2_plen := 18, zero_one := '01'B }, skip_indicator := 0, rr_protocol_discriminator := 6, message_type := SYSTEM_INFORMATION_TYPE_3 (27) }, payload := { si3 := { cell_id := 23, lai := { mcc_mnc := '262F42'H, lac := 42 }, ctrl_chan_desc := { msc_r99 := true, att := true, bs_ag_blks_res := 1, ccch_conf := CCHAN_DESC_1CCCH_COMBINED (1), si22ind := false, cbq3 := CBQ3_IU_MODE_NOT_SUPPORTED (0), spare := '00'B, bs_pa_mfrms := 0, t3212 := 1 }, cell_options := { dn_ind := false, pwrc := false, dtx := MS_MAY_USE_UL_DTX (0), radio_link_tout_div4 := 7 }, cell_sel_par := { cell_resel_hyst_2dB := 2, ms_txpwr_max_cch := 7, acs := '0'B, neci := true, rxlev_access_min := 0 }, rach_control := { max_retrans := RACH_MAX_RETRANS_7 (3), tx_integer := '1001'B, cell_barr_access := false, re_not_allowed := true, acc := '0000010000000000'B }, rest_octets := { sel_params := { presence := '0'B, params := omit }, pwr_offset := { presence := '0'B, offset := omit }, si_2ter_ind := '0'B, early_cm_ind := '0'B, sched_where := { presence := '0'B, where := omit }, gprs_ind := { presence := '1'B, ind := { ra_colour := 0, si13_pos := '0'B } }, umts_early_cm_ind := '0'B, si2_quater_ind := { presence := '0'B, ind := omit }, iu_mode_ind := omit, si21_ind := { presence := '0'B, pos := omit } } } } } MTC@03d96655f345: Setting RSL_SYSTEM_INFO_3 (3): '49061B001762F224002AC90001074740E504002C2B2B2B'O MTC@03d96655f345: Setting RSL_SYSTEM_INFO_2 (2): { header := { l2_plen := { l2_plen := 22, zero_one := '01'B }, skip_indicator := 0, rr_protocol_discriminator := 6, message_type := SYSTEM_INFORMATION_TYPE_2 (26) }, payload := { si2 := { bcch_freq_list := '00000000000000000000000000000000'O, ncc_permitted := '11111111'B, rach_control := { max_retrans := RACH_MAX_RETRANS_7 (3), tx_integer := '1001'B, cell_barr_access := false, re_not_allowed := true, acc := '0000010000000000'B } } } } MTC@03d96655f345: Setting RSL_SYSTEM_INFO_2 (2): '59061A00000000000000000000000000000000FFE50400'O MTC@03d96655f345: Setting RSL_SYSTEM_INFO_4 (4): { header := { l2_plen := { l2_plen := 12, zero_one := '01'B }, skip_indicator := 0, rr_protocol_discriminator := 6, message_type := SYSTEM_INFORMATION_TYPE_4 (28) }, payload := { si4 := { lai := { mcc_mnc := '262F42'H, lac := 42 }, cell_sel_par := { cell_resel_hyst_2dB := 2, ms_txpwr_max_cch := 7, acs := '0'B, neci := true, rxlev_access_min := 0 }, rach_control := { max_retrans := RACH_MAX_RETRANS_7 (3), tx_integer := '1001'B, cell_barr_access := false, re_not_allowed := true, acc := '0000010000000000'B }, cbch_chan_desc := omit, cbch_mobile_alloc := omit, rest_octets := { sel_params := { presence := '0'B, params := omit }, pwr_offset := { presence := '0'B, offset := omit }, gprs_ind := { presence := '1'B, ind := { ra_colour := 0, si13_pos := '0'B } }, s_presence := '0'B, s := omit } } } } MTC@03d96655f345: Setting RSL_SYSTEM_INFO_4 (4): '31061C62F224002A4740E50400012B2B2B2B2B2B2B2B2B'O [1;35m20260923033223966 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m (bts=0,trx=0,ts=0,ss=0) Rx RSL BCCH_INFO (rsl.c:3938)[0;m [1;35m20260923033223966 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m Rx RSL BCCH INFO (SI3, 23 bytes) (rsl.c:616)[0;m 20260923033223966 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=0,ts=0,ss=4) state ACTIVE -> NONE (lchan.c:297) 20260923033223967 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=0,ts=0,ss=4) Deactivating BCCH (scheduler.c:1070) [1;33m20260923033223967 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD NOHANDOVER 0 4' (trx_if.c:249)[0;m 20260923033223967 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=0,ts=0,ss=4) Activating BCCH (scheduler.c:1070) 20260923033223967 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=0,ts=0,ss=4) state NONE -> ACTIVE (lchan.c:297) 20260923033223967 [1;33mDPCU[0;m [1;33mNOTICE[0;m PCU socket not connected, dropping message (pcu_sock.c:1038) 20260923033223967 [1;33mDPCU[0;m [1;33mNOTICE[0;m Failed to send SI3 to PCU: rc=-5 (pcu_sock.c:833) [1;38m20260923033223967 [1;32mDPAG[0;m[1;38m [1;32mINFO[0;m[1;38m Paging SI update (paging.c:837)[0;m [1;33m20260923033223967 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP NOHANDOVER 0 0 4' (trx_if.c:674)[0;m [1;33m20260923033223967 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=0) Unhandled command 'NOHANDOVER' (ctrl_cmd.c:471)[0;m [1;35m20260923033223968 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m (bts=0,trx=0,ts=0,ss=0) Rx RSL BCCH_INFO (rsl.c:3938)[0;m [1;35m20260923033223968 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m Rx RSL BCCH INFO (SI2, 23 bytes) (rsl.c:616)[0;m 20260923033223968 [1;33mDPCU[0;m [1;33mNOTICE[0;m PCU socket not connected, dropping message (pcu_sock.c:1038) 20260923033223968 [1;33mDPCU[0;m [1;33mNOTICE[0;m Failed to send SI2 to PCU: rc=-5 (pcu_sock.c:833) [1;38m20260923033223968 [1;32mDPAG[0;m[1;38m [1;32mINFO[0;m[1;38m Paging SI update (paging.c:837)[0;m [1;35m20260923033223969 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m (bts=0,trx=0,ts=0,ss=0) Rx RSL BCCH_INFO (rsl.c:3938)[0;m [1;35m20260923033223969 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m Rx RSL BCCH INFO (SI4, 23 bytes) (rsl.c:616)[0;m [1;38m20260923033223969 [1;32mDPAG[0;m[1;38m [1;32mINFO[0;m[1;38m Paging SI update (paging.c:837)[0;m [1;35m20260923033224093 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m Tx RSL RF RESource INDication (rsl.c:519)[0;m [1;35m20260923033224093 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m Tx RSL RF RESource INDication (rsl.c:519)[0;m [1;35m20260923033224094 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m Tx RSL RF RESource INDication (rsl.c:519)[0;m [1;35m20260923033224094 [1;32mDRSL[0;m[1;35m [1;32mINFO[0;m[1;35m Tx RSL RF RESource INDication (rsl.c:519)[0;m [1;33m20260923033224319 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Clock indication: fn=1068960 (trx_if.c:103)[0;m 20260923033224319 [1;32mDL1C[0;m [1;32mINFO[0;m TRX Clock Ind: elapsed_us= 470454, elapsed_fn=102, error_us= -276 (scheduler_trx.c:578) 20260923033224319 [1;32mDL1C[0;m [1;32mINFO[0;m GSM clock jitter: 526us (elapsed_fn=1) (scheduler_trx.c:613) 20260923033224319 [1;33mDL1C[0;m [1;33mNOTICE[0;m We were 1 FN slower than TRX, compensated (scheduler_trx.c:643) 20260923033224417 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=0) ramping TRX board output power to 0 mdBm. (tx_power.c:179) [1;33m20260923033224417 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETPOWER 50' (trx_if.c:249)[0;m 20260923033224417 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=1) ramping TRX board output power to 0 mdBm. (tx_power.c:179) [1;33m20260923033224417 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Enqueuing TRX control command 'CMD SETPOWER 50' (trx_if.c:249)[0;m [1;33m20260923033224417 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=0) Tx power attenuation set to 50 dB (ctrl_cmd.c:148)[0;m [1;33m20260923033224417 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=1) Tx power attenuation set to 50 dB (ctrl_cmd.c:148)[0;m [1;33m20260923033224417 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETPOWER 0 50' (trx_if.c:674)[0;m [1;33m20260923033224417 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Response message: 'RSP SETPOWER 0 50' (trx_if.c:674)[0;m 20260923033224419 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=2) ramping TRX board output power to 0 mdBm. (tx_power.c:179) [1;33m20260923033224419 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Enqueuing TRX control command 'CMD SETPOWER 50' (trx_if.c:249)[0;m [1;33m20260923033224419 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=2) Tx power attenuation set to 50 dB (ctrl_cmd.c:148)[0;m [1;33m20260923033224419 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Response message: 'RSP SETPOWER 0 50' (trx_if.c:674)[0;m 20260923033224425 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=3) ramping TRX board output power to 0 mdBm. (tx_power.c:179) [1;33m20260923033224425 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Enqueuing TRX control command 'CMD SETPOWER 50' (trx_if.c:249)[0;m [1;33m20260923033224426 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=3) Tx power attenuation set to 50 dB (ctrl_cmd.c:148)[0;m [1;33m20260923033224426 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Response message: 'RSP SETPOWER 0 50' (trx_if.c:674)[0;m [1;33m20260923033224790 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Clock indication: fn=1069062 (trx_if.c:103)[0;m 20260923033224790 [1;32mDL1C[0;m [1;32mINFO[0;m TRX Clock Ind: elapsed_us= 470804, elapsed_fn=102, error_us= +74 (scheduler_trx.c:578) 20260923033224790 [1;32mDL1C[0;m [1;32mINFO[0;m GSM clock jitter: -4127us (elapsed_fn=0) (scheduler_trx.c:613) [38;5;23m20260923033224824 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m CLICONN(asp-clnt-msc-0,){CONNECTING} connect failed (-111) (stream_cli.c:446)[0;m [38;5;45m20260923033224833 [1;31mDLSCCP[0;m[38;5;45m [1;31mERROR[0;m[38;5;45m 0: SCCP(rctx=0) MTP-TRANSFER.req from SCCP for OPC=187=0.23.3,DPC=185=0.23.1,SLS=12: no route! (sccp_scrc.c:177)[0;m [38;5;45m20260923033224833 [1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m 0: SCCP(rctx=0) SCRC Routing Failure (MTP failure) for CL message CL:CLDT (sccp_sclc.c:359)[0;m 20260923033224833 [1;34mDMSC[0;m [1;34mDEBUG[0;m N-NOTICE.ind(00 04 30 04 01 20 ) (osmo_bsc_sigtran.c:348) 20260923033224833 [1;33mDMSC[0;m [1;33mNOTICE[0;m (msc=0) (calling_addr=RI=2,PC=185,SSN=254) N-NOTICE.ind cause=5='MTP failure' importance=0 (osmo_bsc_sigtran.c:168) [1;33m20260923033225260 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Clock indication: fn=1069164 (trx_if.c:103)[0;m 20260923033225261 [1;32mDL1C[0;m [1;32mINFO[0;m TRX Clock Ind: elapsed_us= 470805, elapsed_fn=102, error_us= +75 (scheduler_trx.c:578) 20260923033225261 [1;32mDL1C[0;m [1;32mINFO[0;m GSM clock jitter: -4034us (elapsed_fn=0) (scheduler_trx.c:613) 20260923033225418 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=1) ramping TRX board output power to 8000 mdBm. (tx_power.c:179) [1;33m20260923033225418 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Enqueuing TRX control command 'CMD SETPOWER 42' (trx_if.c:249)[0;m 20260923033225418 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=0) ramping TRX board output power to 8000 mdBm. (tx_power.c:179) [1;33m20260923033225418 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETPOWER 42' (trx_if.c:249)[0;m [1;33m20260923033225419 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=0) Tx power attenuation set to 42 dB (ctrl_cmd.c:148)[0;m [1;33m20260923033225419 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=1) Tx power attenuation set to 42 dB (ctrl_cmd.c:148)[0;m [1;33m20260923033225419 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETPOWER 0 42' (trx_if.c:674)[0;m [1;33m20260923033225419 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Response message: 'RSP SETPOWER 0 42' (trx_if.c:674)[0;m 20260923033225420 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=2) ramping TRX board output power to 8000 mdBm. (tx_power.c:179) [1;33m20260923033225420 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Enqueuing TRX control command 'CMD SETPOWER 42' (trx_if.c:249)[0;m [1;33m20260923033225420 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=2) Tx power attenuation set to 42 dB (ctrl_cmd.c:148)[0;m [1;33m20260923033225421 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Response message: 'RSP SETPOWER 0 42' (trx_if.c:674)[0;m MTC@03d96655f345: setverdict(pass): none -> pass 20260923033225427 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=3) ramping TRX board output power to 8000 mdBm. (tx_power.c:179) [1;33m20260923033225427 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Enqueuing TRX control command 'CMD SETPOWER 42' (trx_if.c:249)[0;m [1;33m20260923033225428 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=3) Tx power attenuation set to 42 dB (ctrl_cmd.c:148)[0;m [1;33m20260923033225428 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Response message: 'RSP SETPOWER 0 42' (trx_if.c:674)[0;m [1;33m20260923033225731 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Clock indication: fn=1069266 (trx_if.c:103)[0;m 20260923033225731 [1;32mDL1C[0;m [1;32mINFO[0;m TRX Clock Ind: elapsed_us= 470730, elapsed_fn=102, error_us= +0 (scheduler_trx.c:578) 20260923033225731 [1;32mDL1C[0;m [1;32mINFO[0;m GSM clock jitter: -4147us (elapsed_fn=0) (scheduler_trx.c:613) [1;33m20260923033226202 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Clock indication: fn=1069368 (trx_if.c:103)[0;m 20260923033226202 [1;32mDL1C[0;m [1;32mINFO[0;m TRX Clock Ind: elapsed_us= 470760, elapsed_fn=102, error_us= +30 (scheduler_trx.c:578) 20260923033226202 [1;32mDL1C[0;m [1;32mINFO[0;m GSM clock jitter: -4106us (elapsed_fn=0) (scheduler_trx.c:613) 20260923033226419 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=1) ramping TRX board output power to 16000 mdBm. (tx_power.c:179) [1;33m20260923033226419 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Enqueuing TRX control command 'CMD SETPOWER 34' (trx_if.c:249)[0;m 20260923033226419 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=0) ramping TRX board output power to 16000 mdBm. (tx_power.c:179) [1;33m20260923033226419 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Enqueuing TRX control command 'CMD SETPOWER 34' (trx_if.c:249)[0;m [1;33m20260923033226420 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Response message: 'RSP SETPOWER 0 34' (trx_if.c:674)[0;m [1;33m20260923033226420 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.1: Response message: 'RSP SETPOWER 0 34' (trx_if.c:674)[0;m [1;33m20260923033226420 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=0) Tx power attenuation set to 34 dB (ctrl_cmd.c:148)[0;m [1;33m20260923033226420 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=1) Tx power attenuation set to 34 dB (ctrl_cmd.c:148)[0;m 20260923033226421 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=2) ramping TRX board output power to 16000 mdBm. (tx_power.c:179) [1;33m20260923033226421 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Enqueuing TRX control command 'CMD SETPOWER 34' (trx_if.c:249)[0;m [1;33m20260923033226421 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.2: Response message: 'RSP SETPOWER 0 34' (trx_if.c:674)[0;m [1;33m20260923033226421 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=2) Tx power attenuation set to 34 dB (ctrl_cmd.c:148)[0;m MTC@03d96655f345: setverdict(pass): pass -> pass, component reason not changed 20260923033226428 [1;32mDL1C[0;m [1;32mINFO[0;m (bts=0,trx=3) ramping TRX board output power to 16000 mdBm. (tx_power.c:179) [1;33m20260923033226428 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Enqueuing TRX control command 'CMD SETPOWER 34' (trx_if.c:249)[0;m [1;33m20260923033226429 [1;32mDTRXC[0;m[1;33m [1;32mINFO[0;m[1;33m (trx=bts, chan=3) Tx power attenuation set to 34 dB (ctrl_cmd.c:148)[0;m [1;33m20260923033226429 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.3: Response message: 'RSP SETPOWER 0 34' (trx_if.c:674)[0;m [1;33m20260923033226673 [1;32mDTRX[0;m[1;33m [1;32mINFO[0;m[1;33m phy0.0: Clock indication: fn=1069470 (trx_if.c:103)[0;m 20260923033226673 [1;32mDL1C[0;m [1;32mINFO[0;m TRX Clock Ind: elapsed_us= 470634, elapsed_fn=102, error_us= -96 (scheduler_trx.c:578) 20260923033226673 [1;32mDL1C[0;m [1;32mINFO[0;m GSM clock jitter: -4141us (elapsed_fn=0) (scheduler_trx.c:613) [1;91m[testenv][generic] Timeout in wait_until_test_stopped()[0m [1;34m[testenv][generic] Stopping podman container[0m [0;94m[testenv][generic] + ['podman', 'kill', 'testenv-bts-all-osmocom-nightly-asan-20260923-0330-b34200d7-1'][0m testenv-bts-all-osmocom-nightly-asan-20260923-0330-b34200d7-1 [1;34m[testenv][generic] Stopping testsuite (3741460)[0m [0;94m[testenv][generic] feed_watchdog_loop: podman container has stopped[0m [1;34m[testenv][generic] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/834/artifact/log... [0m + RC=1 + [ 1 = 0 ] + uptime + grep --color=always -o load.* [01;31m[Kload average: 1.41, 1.96, 1.40[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.
jenkins-notifications@lists.osmocom.org
-
jenkins＠lists.osmocom.org