Build failed in Jenkins: master-dahdi-linux-torvalds-master #943
by jenkins＠lists.osmocom.org 11 Dec '25
by jenkins＠lists.osmocom.org 11 Dec '25
11 Dec '25
See <https://jenkins.osmocom.org/jenkins/job/master-dahdi-linux-torvalds-master/…>
Changes:
------------------------------------------
[...truncated 2.86 KiB...]
HOSTCC scripts/kconfig/expr.o
LEX scripts/kconfig/lexer.lex.c
YACC scripts/kconfig/parser.tab.[ch]
HOSTCC scripts/kconfig/lexer.lex.o
HOSTCC scripts/kconfig/menu.o
HOSTCC scripts/kconfig/parser.tab.o
HOSTCC scripts/kconfig/preprocess.o
HOSTCC scripts/kconfig/symbol.o
HOSTCC scripts/kconfig/util.o
HOSTLD scripts/kconfig/conf
#
# configuration written to .config
#
+ [ arch/x86/configs/x86_64_defconfig -nt .config ]
+ git log -1 --pretty=%t - %s
8d16d8571c9 - Merge tag 'livepatching-for-6.19' of git://git.kernel.org/pub/scm/linux/kernel/git/livepatching/livepatching
+ make -j 9 modules_prepare
GEN arch/x86/include/generated/asm/orc_hash.h
HOSTCC scripts/basic/fixdep
WRAP arch/x86/include/generated/uapi/asm/bpf_perf_event.h
WRAP arch/x86/include/generated/uapi/asm/errno.h
WRAP arch/x86/include/generated/uapi/asm/fcntl.h
WRAP arch/x86/include/generated/uapi/asm/ioctl.h
WRAP arch/x86/include/generated/uapi/asm/ioctls.h
SYSHDR arch/x86/include/generated/uapi/asm/unistd_32.h
UPD include/generated/uapi/linux/version.h
WRAP arch/x86/include/generated/uapi/asm/ipcbuf.h
SYSHDR arch/x86/include/generated/uapi/asm/unistd_64.h
WRAP arch/x86/include/generated/uapi/asm/param.h
WRAP arch/x86/include/generated/uapi/asm/poll.h
SYSHDR arch/x86/include/generated/uapi/asm/unistd_x32.h
WRAP arch/x86/include/generated/uapi/asm/resource.h
SYSTBL arch/x86/include/generated/asm/syscalls_32.h
WRAP arch/x86/include/generated/uapi/asm/socket.h
WRAP arch/x86/include/generated/uapi/asm/sockios.h
WRAP arch/x86/include/generated/uapi/asm/termbits.h
WRAP arch/x86/include/generated/uapi/asm/termios.h
UPD include/generated/compile.h
UPD arch/x86/include/generated/asm/cpufeaturemasks.h
WRAP arch/x86/include/generated/uapi/asm/types.h
SYSHDR arch/x86/include/generated/asm/unistd_32_ia32.h
WRAP arch/x86/include/generated/asm/early_ioremap.h
WRAP arch/x86/include/generated/asm/fprobe.h
WRAP arch/x86/include/generated/asm/mcs_spinlock.h
WRAP arch/x86/include/generated/asm/mmzone.h
WRAP arch/x86/include/generated/asm/irq_regs.h
WRAP arch/x86/include/generated/asm/kmap_size.h
WRAP arch/x86/include/generated/asm/local64.h
WRAP arch/x86/include/generated/asm/mmiowb.h
WRAP arch/x86/include/generated/asm/module.lds.h
WRAP arch/x86/include/generated/asm/rwonce.h
SYSHDR arch/x86/include/generated/asm/unistd_64_x32.h
SYSTBL arch/x86/include/generated/asm/syscalls_64.h
DESCEND objtool
UPD include/config/kernel.release
UPD include/generated/utsrelease.h
HOSTCC arch/x86/tools/relocs_32.o
HOSTCC arch/x86/tools/relocs_64.o
HOSTCC arch/x86/tools/relocs_common.o
HOSTCC scripts/kallsyms
HOSTCC scripts/sorttable
HOSTCC scripts/asn1_compiler
HOSTCC scripts/selinux/mdp/mdp
HOSTLD arch/x86/tools/relocs
CC scripts/mod/empty.o
HOSTCC scripts/mod/mk_elfconfig
CC scripts/mod/devicetable-offsets.s
INSTALL /linux/tools/objtool/libsubcmd/include/subcmd/exec-cmd.h
INSTALL /linux/tools/objtool/libsubcmd/include/subcmd/help.h
INSTALL /linux/tools/objtool/libsubcmd/include/subcmd/pager.h
INSTALL /linux/tools/objtool/libsubcmd/include/subcmd/parse-options.h
INSTALL /linux/tools/objtool/libsubcmd/include/subcmd/run-command.h
INSTALL libsubcmd_headers
UPD scripts/mod/devicetable-offsets.h
MKELF scripts/mod/elfconfig.h
HOSTCC scripts/mod/modpost.o
HOSTCC scripts/mod/file2alias.o
HOSTCC scripts/mod/sumversion.o
HOSTCC scripts/mod/symsearch.o
CC /linux/tools/objtool/libsubcmd/exec-cmd.o
CC /linux/tools/objtool/libsubcmd/help.o
CC /linux/tools/objtool/libsubcmd/pager.o
CC /linux/tools/objtool/libsubcmd/parse-options.o
CC /linux/tools/objtool/libsubcmd/run-command.o
CC /linux/tools/objtool/libsubcmd/sigchain.o
CC /linux/tools/objtool/libsubcmd/subcmd-config.o
LD /linux/tools/objtool/libsubcmd/libsubcmd-in.o
AR /linux/tools/objtool/libsubcmd/libsubcmd.a
HOSTLD scripts/mod/modpost
CC /linux/tools/objtool/weak.o
CC /linux/tools/objtool/check.o
CC /linux/tools/objtool/special.o
MKDIR /linux/tools/objtool/arch/x86/lib/
CC /linux/tools/objtool/builtin-check.o
CC /linux/tools/objtool/elf.o
MKDIR /linux/tools/objtool/arch/x86/lib/
CC /linux/tools/objtool/objtool.o
GEN /linux/tools/objtool/arch/x86/lib/inat-tables.c
GEN /linux/tools/objtool/arch/x86/lib/cpu-feature-names.c
CC /linux/tools/objtool/arch/x86/orc.o
UPD include/generated/timeconst.h
CC kernel/bounds.s
CHKSHA1 include/linux/atomic/atomic-arch-fallback.h
CC /linux/tools/objtool/arch/x86/decode.o
CC /linux/tools/objtool/arch/x86/special.o
CHKSHA1 include/linux/atomic/atomic-instrumented.h
CHKSHA1 include/linux/atomic/atomic-long.h
CC /linux/tools/objtool/orc_gen.o
UPD include/generated/bounds.h
CC arch/x86/kernel/asm-offsets.s
CC /linux/tools/objtool/orc_dump.o
CC /linux/tools/objtool/libstring.o
CC /linux/tools/objtool/libctype.o
CC /linux/tools/objtool/str_error_r.o
CC /linux/tools/objtool/librbtree.o
LD /linux/tools/objtool/arch/x86/objtool-in.o
UPD include/generated/asm-offsets.h
CC kernel/sched/rq-offsets.s
UPD include/generated/rq-offsets.h
CALL scripts/checksyscalls.sh
LD /linux/tools/objtool/objtool-in.o
LINK /linux/tools/objtool/objtool
LDS scripts/module.lds
+ make -j 9 -C /build KSRC=/linux KBUILD_MODPOST_WARN=1
make: Entering directory '/build'
make -C drivers/dahdi/firmware firmware-loaders
make[1]: Entering directory '/build/drivers/dahdi/firmware'
Attempting to download dahdi-fwload-vpmadt032-1.25.0.tar.gz
--2025-12-10 23:20:19-- https://downloads.digium.com/pub/telephony/firmware/releases/dahdi-fwload-v…
Resolving downloads.digium.com (downloads.digium.com)... 165.22.184.19, 2604:a880:400:d0::14:9001
Connecting to downloads.digium.com (downloads.digium.com)|165.22.184.19|:443... connected.
HTTP request sent, awaiting response... 200 OK
Length: 149360 (146K) [application/octet-stream]
Saving to: 'dahdi-fwload-vpmadt032-1.25.0.tar.gz'
0K .......... .......... .......... .......... .......... 34% 566K 0s
50K .......... .......... .......... .......... .......... 68% 567K 0s
100K .......... .......... .......... .......... ..... 100% 77.4M=0.2s
2025-12-10 23:20:20 (824 KB/s) - 'dahdi-fwload-vpmadt032-1.25.0.tar.gz' saved [149360/149360]
make[1]: Leaving directory '/build/drivers/dahdi/firmware'
make -C /linux KBUILD_EXTMOD=/build/drivers/dahdi DAHDI_INCLUDE=/build/include DAHDI_MODULES_EXTRA=" " HOTPLUG_FIRMWARE=yes modules DAHDI_BUILD_ALL=m
make[1]: Entering directory '/linux'
make[2]: Entering directory '/build/drivers/dahdi'
CC [M] icE1usb/icE1usb.o
CC [M] trunkdev/trunkdev.o
CC [M] wctc4xxp/base.o
CC [M] wct4xxp/base.o
CC [M] oct612x/octdeviceapi/oct6100api/oct6100_api/oct6100_adpcm_chan.o
CC [M] wcte12xp/base.o
CC [M] voicebus/voicebus.o
CC [M] wctdm24xxp/base.o
CC [M] wcb4xxp/base.o
oct612x/octdeviceapi/oct6100api/oct6100_api/oct6100_adpcm_chan.c:34:10: fatal error: octdef.h: No such file or directory
34 | #include "octdef.h"
| ^~~~~~~~~~
compilation terminated.
make[5]: *** [/linux/scripts/Makefile.build:287: oct612x/octdeviceapi/oct6100api/oct6100_api/oct6100_adpcm_chan.o] Error 1
make[4]: *** [/linux/scripts/Makefile.build:556: oct612x] Error 2
make[4]: *** Waiting for unfinished jobs....
CC [M] wctdm24xxp/xhfc.o
voicebus/voicebus.c:46:5: error: "VOICEBUS_DEFERRED" is not defined, evaluates to 0 [-Werror=undef]
46 | #if VOICEBUS_DEFERRED == TIMER
| ^~~~~~~~~~~~~~~~~
voicebus/voicebus.c:46:26: error: "TIMER" is not defined, evaluates to 0 [-Werror=undef]
46 | #if VOICEBUS_DEFERRED == TIMER
| ^~~~~
wcte12xp/base.c: In function 't1xxp_set_linemode':
wcte12xp/base.c:2119:9: error: implicit declaration of function 'del_timer_sync'; did you mean 'dev_mc_sync'? [-Werror=implicit-function-declaration]
2119 | del_timer_sync(&wc->timer);
| ^~~~~~~~~~~~~~
| dev_mc_sync
wcte12xp/base.c: In function 'te12xp_timer':
wcte12xp/base.c:2772:25: error: implicit declaration of function 'from_timer'; did you mean 'mod_timer'? [-Werror=implicit-function-declaration]
2772 | struct t1 *wc = from_timer(wc, timer, timer);
| ^~~~~~~~~~
| mod_timer
wcte12xp/base.c:2772:25: error: initialization of 'struct t1 *' from 'int' makes pointer from integer without a cast [-Werror=int-conversion]
wcte12xp/base.c:2772:25: error: 'wc' is used uninitialized [-Werror=uninitialized]
2772 | struct t1 *wc = from_timer(wc, timer, timer);
| ^~~~~~~~~~~~~~~~~~~~~~~~~~~~
wcte12xp/base.c:2772:20: note: 'wc' was declared here
2772 | struct t1 *wc = from_timer(wc, timer, timer);
| ^~
wctc4xxp/base.c: In function 'wctc4xxp_watchdog':
wctc4xxp/base.c:3656:28: error: implicit declaration of function 'from_timer'; did you mean 'mod_timer'? [-Werror=implicit-function-declaration]
3656 | struct wcdte *wc = from_timer(wc, timer, watchdog);
| ^~~~~~~~~~
| mod_timer
wctc4xxp/base.c:3656:50: error: 'watchdog' undeclared (first use in this function); did you mean 'watch'?
3656 | struct wcdte *wc = from_timer(wc, timer, watchdog);
| ^~~~~~~~
| watch
wctc4xxp/base.c:3656:50: note: each undeclared identifier is reported only once for each function it appears in
wctc4xxp/base.c: In function 'wctc4xxp_reset_driver_state':
wctc4xxp/base.c:3812:43: error: taking address of expression of type 'void' [-Werror]
3812 | embedded_firmware.size = (size_t) &_binary_dahdi_fw_tc400m_bin_size;
| ^
wctc4xxp/base.c: In function 'wctc4xxp_init_one':
wctc4xxp/base.c:3993:43: error: taking address of expression of type 'void' [-Werror]
3993 | embedded_firmware.size = (size_t) &_binary_dahdi_fw_tc400m_bin_size;
| ^
wctc4xxp/base.c: In function 'wctc4xxp_remove_one':
wctc4xxp/base.c:4167:13: error: implicit declaration of function 'del_timer_sync'; did you mean 'dev_mc_sync'? [-Werror=implicit-function-declaration]
4167 | if (del_timer_sync(&wc->watchdog))
| ^~~~~~~~~~~~~~
| dev_mc_sync
wct4xxp/base.c: In function 't4_vpm_init':
wct4xxp/base.c:4239:51: error: taking address of expression of type 'void' [-Werror]
4239 | embedded_firmware.size = (size_t) &_binary_dahdi_fw_oct6114_064_bin_size;
| ^
wct4xxp/base.c:4258:51: error: taking address of expression of type 'void' [-Werror]
4258 | embedded_firmware.size = (size_t) &_binary_dahdi_fw_oct6114_128_bin_size;
| ^
wct4xxp/base.c:4277:51: error: taking address of expression of type 'void' [-Werror]
4277 | embedded_firmware.size = (size_t) &_binary_dahdi_fw_oct6114_256_bin_size;
| ^
cc1: all warnings being treated as errors
make[5]: *** [/linux/scripts/Makefile.build:287: wctc4xxp/base.o] Error 1
make[4]: *** [/linux/scripts/Makefile.build:556: wctc4xxp] Error 2
CC [M] wct4xxp/vpm450m.o
CC [M] trunkdev/frame_fifo.o
LD [M] trunkdev/dahdi-trunkdev.o
cc1: all warnings being treated as errors
make[5]: *** [/linux/scripts/Makefile.build:287: voicebus/voicebus.o] Error 1
make[4]: *** [/linux/scripts/Makefile.build:556: voicebus] Error 2
wct4xxp/vpm450m.c:33:10: fatal error: oct612x.h: No such file or directory
33 | #include <oct612x.h>
| ^~~~~~~~~~~
compilation terminated.
make[5]: *** [/linux/scripts/Makefile.build:287: wct4xxp/vpm450m.o] Error 1
make[5]: *** Waiting for unfinished jobs....
cc1: all warnings being treated as errors
make[5]: *** [/linux/scripts/Makefile.build:287: wcte12xp/base.o] Error 1
make[4]: *** [/linux/scripts/Makefile.build:556: wcte12xp] Error 2
LD [M] wctdm24xxp/wctdm24xxp.o
LD [M] wcb4xxp/wcb4xxp.o
cc1: all warnings being treated as errors
make[5]: *** [/linux/scripts/Makefile.build:287: wct4xxp/base.o] Error 1
make[4]: *** [/linux/scripts/Makefile.build:556: wct4xxp] Error 2
make[3]: *** [/linux/Makefile:2014: .] Error 2
make[2]: Leaving directory '/build/drivers/dahdi'
make[2]: *** [/linux/Makefile:248: __sub-make] Error 2
make[1]: Leaving directory '/linux'
make[1]: *** [Makefile:248: __sub-make] Error 2
make: *** [Makefile:74: modules] Error 2
make: Leaving directory '/build'
Build step 'Execute shell' marked build as failure
1
1
11 Dec '25
See <https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-io_uring/578/display…>
Changes:
[Pau Espin Pedrol] ttcn3-bts-test: Run fake_trx with sched-prio-rr
------------------------------------------
[...truncated 9.11 MiB...]
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1480 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:315 TC_sabm_retransmit_bts testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_invalid_resp' time='15.045708'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1481 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:379 TC_sabm_invalid_resp testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_dm' time='15.050108'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1482 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:425 TC_sabm_dm testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_establish_ign_first_sabm' time='15.033272'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1483 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:488 TC_establish_ign_first_sabm testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_iframe_seq_and_ack' time='15.044550'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1484 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:579 TC_iframe_seq_and_ack testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_iframe_timer_recovery' time='15.046878'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1485 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:685 TC_iframe_timer_recovery testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_ns_seq_error' time='15.044867'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1486 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:768 TC_ns_seq_error testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_nr_seq_error' time='15.043988'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1487 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:831 TC_nr_seq_error testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_rec_invalid_frame' time='15.047661'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1488 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:961 TC_rec_invalid_frame testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_segm_concat_dcch' time='15.044512'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1489 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1088 TC_segm_concat_dcch testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_segm_concat_sacch' time='15.036025'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1490 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1093 TC_segm_concat_sacch testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_t200_n200' time='15.044754'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1491 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1182 TC_t200_n200 testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_rr_response_frame_loss' time='15.049737'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1492 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1239 TC_rr_response_frame_loss testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_incorrect_cr' time='15.080193'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1493 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1293 TC_incorrect_cr testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_incorrect_c' time='15.049344'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1494 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1341 TC_sabm_incorrect_c testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_normal_reestablishment' time='15.033638'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1495 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1403 TC_normal_reestablishment testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm:hopping' name='TC_normal_reestablishment_state_unacked' time='15.043685'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1496 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1470 TC_normal_reestablishment_state_unacked testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_vff' time='15.035899'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:316 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:210 TC_vamos_chan_act_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_vhh' time='15.040075'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:317 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:224 TC_vamos_chan_act_vhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_hvhh' time='15.034542'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:318 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:234 TC_vamos_chan_act_hvhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_ipa_vff' time='15.042537'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:319 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:214 TC_vamos_chan_act_dyn_ipa_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vff' time='15.055892'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:320 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:218 TC_vamos_chan_act_dyn_osmo_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vhh' time='15.045533'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:321 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:228 TC_vamos_chan_act_dyn_osmo_vhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_hvhh' time='15.043579'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:322 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:238 TC_vamos_chan_act_dyn_osmo_hvhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vff' time='15.043579'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:325 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:283 TC_vamos_chan_mode_modify_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vhh' time='15.050055'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:326 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:297 TC_vamos_chan_mode_modify_vhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_hvhh' time='15.043718'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:327 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:307 TC_vamos_chan_mode_modify_hvhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_ipa_vff' time='15.035615'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:328 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:287 TC_vamos_chan_mode_modify_dyn_ipa_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vff' time='15.046459'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:329 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:291 TC_vamos_chan_mode_modify_dyn_osmo_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vhh' time='15.047735'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:330 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:301 TC_vamos_chan_mode_modify_dyn_osmo_vhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_hvhh' time='15.044678'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:331 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:311 TC_vamos_chan_mode_modify_dyn_osmo_hvhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_ASCI:hopping' name='TC_vbs_notification' time='15.043289'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_ASCI.ttcn:422 BTS_Tests_ASCI control part
BTS_Tests_ASCI.ttcn:83 TC_vbs_notification testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_uplink_free_and_busy' time='15.049183'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_ASCI.ttcn:423 BTS_Tests_ASCI control part
BTS_Tests_ASCI.ttcn:190 TC_vgcs_uplink_free_and_busy testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_fail' time='15.039569'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_ASCI.ttcn:424 BTS_Tests_ASCI control part
BTS_Tests_ASCI.ttcn:289 TC_vgcs_talker_fail testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_est_rel' time='15.038670'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_ASCI.ttcn:425 BTS_Tests_ASCI control part
BTS_Tests_ASCI.ttcn:333 TC_vgcs_talker_est_rel testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_listener_det' time='15.041942'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_ASCI.ttcn:426 BTS_Tests_ASCI control part
BTS_Tests_ASCI.ttcn:411 TC_vgcs_listener_det testcase
</failure>
</testcase>
</testsuite>
<?xml version="1.0"?>
<testsuite name='Titan' tests='17' failures='1' errors='0' skipped='0' inconc='0' time='98.00'>
<testcase classname='BTS_Tests_OML' name='TC_wrong_mdisc' time='10.684898'/>
<testcase classname='BTS_Tests_OML' name='TC_wrong_msgtype' time='0.676253'/>
<testcase classname='BTS_Tests_OML' name='TC_short_length' time='0.683600'/>
<testcase classname='BTS_Tests_OML' name='TC_long_length' time='0.685004'/>
<testcase classname='BTS_Tests_OML' name='TC_wrong_placement' time='0.690329'/>
<testcase classname='BTS_Tests_OML' name='TC_wrong_seq' time='0.687221'/>
<testcase classname='BTS_Tests_OML' name='TC_wrong_obj_class' time='0.671738'/>
<testcase classname='BTS_Tests_OML' name='TC_wrong_bts_nr' time='0.677184'/>
<testcase classname='BTS_Tests_OML' name='TC_wrong_trx_nr' time='0.688233'/>
<testcase classname='BTS_Tests_OML' name='TC_radio_carrier_opstart_noattr' time='0.692938'/>
<testcase classname='BTS_Tests_OML' name='TC_bts_opstart' time='0.688530'/>
<testcase classname='BTS_Tests_OML' name='TC_bts_opstart_noattr' time='0.684497'/>
<testcase classname='BTS_Tests_OML' name='TC_ts_opstart' time='0.713807'/>
<testcase classname='BTS_Tests_OML' name='TC_ts_opstart_noattr' time='0.687709'/>
<testcase classname='BTS_Tests_OML' name='TC_initial_state_reports' time='0.667520'/>
<testcase classname='BTS_Tests_OML' name='TC_ipa_osmo_pcu_anr_fwd' time='2.691904'>
<failure type='fail-verdict'>Timeout waiting for ANR request on PCU inteface
BTS_Tests_OML.ttcn:818 BTS_Tests_OML control part
BTS_Tests_OML.ttcn:797 TC_ipa_osmo_pcu_anr_fwd testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_OML' name='TC_ipa_rsl_connect_nack' time='0.684494'/>
</testsuite>
+ RC=1
+ uptime
+ grep --color=always -o load.*
[01;31m[Kload average: 0.54, 0.49, 0.81[m[K
+ exit 1
Build step 'Execute shell' marked build as failure
Recording test results
[Checks API] No suitable checks publisher found.
1
0
10 Dec '25
Jenkins build is back to stable : ttcn3-s1gw-test-latest #427
by jenkins＠lists.osmocom.org 09 Dec '25
by jenkins＠lists.osmocom.org 09 Dec '25
09 Dec '25
08 Dec '25
Build failed in Jenkins: master-osmo-msc » --enable-iu,1,a3=default,a4=default,osmocom-master #50030
by jenkins＠lists.osmocom.org 07 Dec '25
by jenkins＠lists.osmocom.org 07 Dec '25
07 Dec '25
See <https://jenkins.osmocom.org/jenkins/job/master-osmo-msc/IU=--enable-iu,WITH…>
Changes:
------------------------------------------
[...truncated 705.14 KiB...]
> ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port
LISTEN 0 10 127.0.0.1:4254 0.0.0.0:*
LISTEN 0 10 127.0.0.1:4255 0.0.0.0:*
LISTEN 0 10 0.0.0.0:2775 0.0.0.0:*
> ps xua | grep osmo
build 1 0.0 0.0 2592 1152 ? Ss 13:24 0:00 /usr/bin/timeout 30m /osmo-ci/scripts/wrapper_core_bt_on_error.sh /build/contrib/jenkins.sh
build 7 0.0 0.0 2680 1072 ? S 13:24 0:00 /bin/sh /osmo-ci/scripts/wrapper_core_bt_on_error.sh /build/contrib/jenkins.sh
build 119659 0.0 0.0 4068 3252 ? S 13:27 0:00 /bin/bash -c test -d osmo-msc-1.15.0/_build || exit 0; \ dc_install_base=`CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.15.0/_inst && pwd | sed -e 's,^[^:\\/]:[\\/],/,'` \ && dc_destdir="${TMPDIR-/tmp}/am-dc-$$/" \ && am__cwd=`pwd` \ && CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.15.0/_build/sub \ && ../../configure \ --with-systemdsystemunitdir=$dc_install_base/ \ --enable-werror --enable-smpp --enable-iu --enable-external-tests --enable-manuals \ --srcdir=../.. --prefix="$dc_install_base" \ && make \ && make dvi \ && make check \ && make install \ && make installcheck \ && make uninstall \ && make distuninstallcheck_dir="$dc_install_base" \ distuninstallcheck \ && chmod -R a-w "$dc_install_base" \ && ({ \ (cd ../.. && umask 077 && mkdir "$dc_destdir") \ && make DESTDIR="$dc_destdir" install \ && make DESTDIR="$dc_destdir" uninstall \ && make DESTDIR="$dc_destdir" \ distuninstallcheck_dir="$dc_destdir" distuninstallcheck; \ } || { rm -rf "$dc_destdir"; exit 1; }) \ && rm -rf "$dc_destdir" \ && make dist \ && rm -rf osmo-msc-1.15.0.tar.gz osmo-msc-1.15.0.tar.bz2 \ && make distcleancheck \ && cd "$am__cwd" \ || exit 1
build 123622 0.0 0.0 4068 3212 ? S 13:27 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '2'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.4.1' && test -n '/build/osmo-msc-1.15.0/_build/sub'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='include src doc contrib tests ' ;; \ *) list='include src doc contrib tests ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail"
build 123815 0.0 0.0 4068 3108 ? S 13:27 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '3'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.4.1' && test -n '/build/osmo-msc-1.15.0/_build/sub/tests'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp' ;; \ *) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail"
build 130613 1.2 0.0 21584 16360 ? S 13:28 0:00 python3 ../../../tests/vty_test_runner.py -w /build/osmo-msc-1.15.0/_build/sub -v
build 130625 0.0 0.0 21474931716 39956 ? D 13:28 0:00 ./src/osmo-msc/osmo-msc -c /build/osmo-msc-1.15.0/tests/../doc/examples/osmo-msc/osmo-msc.cfg
build 130632 0.0 0.0 2680 1116 ? S 13:28 0:00 /bin/sh -c ps xua | grep osmo
build 130634 0.0 0.0 3896 1900 ? S 13:28 0:00 grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4254 <socket.socket fd=5, family=2, type=1, proto=0, laddr=('127.0.0.1', 41432), raddr=('127.0.0.1', 4254)> (1 sockets open)
Rec: ["% 'periodic location update' is now deprecated. Use 'msc' / 'timer vlr T3212' to change subscriber expiration timeout.", '% Setting T3212 to 121 minutes (emulating the old behaviour).']
Exp: ["% 'periodic location update' is now deprecated: use 'timer T3212' to change subscriber expiration timeout.", '% Setting T3212 to 121 minutes (emulating the old behaviour).']
Socket: closing 127.0.0.1:4254 <socket.socket fd=5, family=2, type=1, proto=0, laddr=('127.0.0.1', 41432), raddr=('127.0.0.1', 4254)> (0 sockets open)
Terminating took 0.475s
Process returned code: 0
ok
testShowNetwork (__main__.TestVTYMSC.testShowNetwork) ... Launching: PWD=/build/osmo-msc-1.15.0/_build/sub './src/osmo-msc/osmo-msc' '-c' '/build/osmo-msc-1.15.0/tests/../doc/examples/osmo-msc/osmo-msc.cfg'
> ls -l /proc/130613/fd
total 0
lr-x------ 1 build build 64 Dec 7 13:28 0 -> pipe:[1198531509]
l-wx------ 1 build build 64 Dec 7 13:28 1 -> pipe:[1198531510]
l-wx------ 1 build build 64 Dec 7 13:28 2 -> pipe:[1198531511]
lrwx------ 1 build build 64 Dec 7 13:28 3 -> /tmp/tmp6mv0jh47 (deleted)
lrwx------ 1 build build 64 Dec 7 13:28 4 -> /tmp/tmp6eatghcb (deleted)
> ss -tn
State Recv-Q Send-Q Local Address:Port Peer Address:Port
> ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port
LISTEN 0 10 127.0.0.1:4254 0.0.0.0:*
LISTEN 0 10 127.0.0.1:4255 0.0.0.0:*
LISTEN 0 10 0.0.0.0:2775 0.0.0.0:*
> ps xua | grep osmo
build 1 0.0 0.0 2592 1152 ? Ss 13:24 0:00 /usr/bin/timeout 30m /osmo-ci/scripts/wrapper_core_bt_on_error.sh /build/contrib/jenkins.sh
build 7 0.0 0.0 2680 1072 ? S 13:24 0:00 /bin/sh /osmo-ci/scripts/wrapper_core_bt_on_error.sh /build/contrib/jenkins.sh
build 119659 0.0 0.0 4068 3252 ? S 13:27 0:00 /bin/bash -c test -d osmo-msc-1.15.0/_build || exit 0; \ dc_install_base=`CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.15.0/_inst && pwd | sed -e 's,^[^:\\/]:[\\/],/,'` \ && dc_destdir="${TMPDIR-/tmp}/am-dc-$$/" \ && am__cwd=`pwd` \ && CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.15.0/_build/sub \ && ../../configure \ --with-systemdsystemunitdir=$dc_install_base/ \ --enable-werror --enable-smpp --enable-iu --enable-external-tests --enable-manuals \ --srcdir=../.. --prefix="$dc_install_base" \ && make \ && make dvi \ && make check \ && make install \ && make installcheck \ && make uninstall \ && make distuninstallcheck_dir="$dc_install_base" \ distuninstallcheck \ && chmod -R a-w "$dc_install_base" \ && ({ \ (cd ../.. && umask 077 && mkdir "$dc_destdir") \ && make DESTDIR="$dc_destdir" install \ && make DESTDIR="$dc_destdir" uninstall \ && make DESTDIR="$dc_destdir" \ distuninstallcheck_dir="$dc_destdir" distuninstallcheck; \ } || { rm -rf "$dc_destdir"; exit 1; }) \ && rm -rf "$dc_destdir" \ && make dist \ && rm -rf osmo-msc-1.15.0.tar.gz osmo-msc-1.15.0.tar.bz2 \ && make distcleancheck \ && cd "$am__cwd" \ || exit 1
build 123622 0.0 0.0 4068 3212 ? S 13:27 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '2'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.4.1' && test -n '/build/osmo-msc-1.15.0/_build/sub'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='include src doc contrib tests ' ;; \ *) list='include src doc contrib tests ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail"
build 123815 0.0 0.0 4068 3108 ? S 13:27 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '3'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.4.1' && test -n '/build/osmo-msc-1.15.0/_build/sub/tests'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp' ;; \ *) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail"
build 130613 1.0 0.0 21584 16364 ? S 13:28 0:00 python3 ../../../tests/vty_test_runner.py -w /build/osmo-msc-1.15.0/_build/sub -v
build 130636 25.0 0.0 21474931716 39956 ? D 13:28 0:00 ./src/osmo-msc/osmo-msc -c /build/osmo-msc-1.15.0/tests/../doc/examples/osmo-msc/osmo-msc.cfg
build 130643 0.0 0.0 2680 1084 ? S 13:28 0:00 /bin/sh -c ps xua | grep osmo
build 130645 0.0 0.0 3896 1984 ? S 13:28 0:00 grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4254 <socket.socket fd=5, family=2, type=1, proto=0, laddr=('127.0.0.1', 41448), raddr=('127.0.0.1', 4254)> (1 sockets open)
Socket: closing 127.0.0.1:4254 <socket.socket fd=5, family=2, type=1, proto=0, laddr=('127.0.0.1', 41448), raddr=('127.0.0.1', 4254)> (0 sockets open)
Terminating took 0.897s
Process returned code: 0
ok
testSi2Q (__main__.TestVTYMSC.testSi2Q) ... Launching: PWD=/build/osmo-msc-1.15.0/_build/sub './src/osmo-msc/osmo-msc' '-c' '/build/osmo-msc-1.15.0/tests/../doc/examples/osmo-msc/osmo-msc.cfg'
> ls -l /proc/130613/fd
total 0
lr-x------ 1 build build 64 Dec 7 13:28 0 -> pipe:[1198531509]
l-wx------ 1 build build 64 Dec 7 13:28 1 -> pipe:[1198531510]
l-wx------ 1 build build 64 Dec 7 13:28 2 -> pipe:[1198531511]
lrwx------ 1 build build 64 Dec 7 13:28 3 -> /tmp/tmpqk9uy8on (deleted)
lrwx------ 1 build build 64 Dec 7 13:28 4 -> /tmp/tmp2m_ow_3n (deleted)
> ss -tn
State Recv-Q Send-Q Local Address:Port Peer Address:Port
> ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port
LISTEN 0 10 127.0.0.1:4254 0.0.0.0:*
LISTEN 0 10 127.0.0.1:4255 0.0.0.0:*
LISTEN 0 10 0.0.0.0:2775 0.0.0.0:*
> ps xua | grep osmo
build 1 0.0 0.0 2592 1152 ? Ss 13:24 0:00 /usr/bin/timeout 30m /osmo-ci/scripts/wrapper_core_bt_on_error.sh /build/contrib/jenkins.sh
build 7 0.0 0.0 2680 1072 ? S 13:24 0:00 /bin/sh /osmo-ci/scripts/wrapper_core_bt_on_error.sh /build/contrib/jenkins.sh
build 119659 0.0 0.0 4068 3252 ? S 13:27 0:00 /bin/bash -c test -d osmo-msc-1.15.0/_build || exit 0; \ dc_install_base=`CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.15.0/_inst && pwd | sed -e 's,^[^:\\/]:[\\/],/,'` \ && dc_destdir="${TMPDIR-/tmp}/am-dc-$$/" \ && am__cwd=`pwd` \ && CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.15.0/_build/sub \ && ../../configure \ --with-systemdsystemunitdir=$dc_install_base/ \ --enable-werror --enable-smpp --enable-iu --enable-external-tests --enable-manuals \ --srcdir=../.. --prefix="$dc_install_base" \ && make \ && make dvi \ && make check \ && make install \ && make installcheck \ && make uninstall \ && make distuninstallcheck_dir="$dc_install_base" \ distuninstallcheck \ && chmod -R a-w "$dc_install_base" \ && ({ \ (cd ../.. && umask 077 && mkdir "$dc_destdir") \ && make DESTDIR="$dc_destdir" install \ && make DESTDIR="$dc_destdir" uninstall \ && make DESTDIR="$dc_destdir" \ distuninstallcheck_dir="$dc_destdir" distuninstallcheck; \ } || { rm -rf "$dc_destdir"; exit 1; }) \ && rm -rf "$dc_destdir" \ && make dist \ && rm -rf osmo-msc-1.15.0.tar.gz osmo-msc-1.15.0.tar.bz2 \ && make distcleancheck \ && cd "$am__cwd" \ || exit 1
build 123622 0.0 0.0 4068 3212 ? S 13:27 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '2'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.4.1' && test -n '/build/osmo-msc-1.15.0/_build/sub'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='include src doc contrib tests ' ;; \ *) list='include src doc contrib tests ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail"
build 123815 0.0 0.0 4068 3108 ? S 13:27 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '3'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.4.1' && test -n '/build/osmo-msc-1.15.0/_build/sub/tests'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp' ;; \ *) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail"
build 130613 0.6 0.0 21584 16364 ? S 13:28 0:00 python3 ../../../tests/vty_test_runner.py -w /build/osmo-msc-1.15.0/_build/sub -v
build 130647 0.0 0.0 21474931716 37848 ? D 13:28 0:00 ./src/osmo-msc/osmo-msc -c /build/osmo-msc-1.15.0/tests/../doc/examples/osmo-msc/osmo-msc.cfg
build 130654 0.0 0.0 2680 1076 ? S 13:28 0:00 /bin/sh -c ps xua | grep osmo
build 130656 0.0 0.0 3896 1884 ? S 13:28 0:00 grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4254 <socket.socket fd=5, family=2, type=1, proto=0, laddr=('127.0.0.1', 42878), raddr=('127.0.0.1', 4254)> (1 sockets open)
Socket: closing 127.0.0.1:4254 <socket.socket fd=5, family=2, type=1, proto=0, laddr=('127.0.0.1', 42878), raddr=('127.0.0.1', 4254)> (0 sockets open)
Terminating took 0.897s
Process returned code: 0
ok
testSmppFirst (__main__.TestVTYMSC.testSmppFirst) ... Launching: PWD=/build/osmo-msc-1.15.0/_build/sub './src/osmo-msc/osmo-msc' '-c' '/build/osmo-msc-1.15.0/tests/../doc/examples/osmo-msc/osmo-msc.cfg'
> ls -l /proc/130613/fd
total 0
lr-x------ 1 build build 64 Dec 7 13:28 0 -> pipe:[1198531509]
l-wx------ 1 build build 64 Dec 7 13:28 1 -> pipe:[1198531510]
l-wx------ 1 build build 64 Dec 7 13:28 2 -> pipe:[1198531511]
lrwx------ 1 build build 64 Dec 7 13:28 3 -> /tmp/tmpknneoqt6 (deleted)
lrwx------ 1 build build 64 Dec 7 13:28 4 -> /tmp/tmp0_rt3g1f (deleted)
> ss -tn
State Recv-Q Send-Q Local Address:Port Peer Address:Port
> ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port
LISTEN 0 10 127.0.0.1:4254 0.0.0.0:*
LISTEN 0 10 127.0.0.1:4255 0.0.0.0:*
LISTEN 0 10 0.0.0.0:2775 0.0.0.0:*
> ps xua | grep osmo
build 1 0.0 0.0 2592 1152 ? Ss 13:24 0:00 /usr/bin/timeout 30m /osmo-ci/scripts/wrapper_core_bt_on_error.sh /build/contrib/jenkins.sh
build 7 0.0 0.0 2680 1072 ? S 13:24 0:00 /bin/sh /osmo-ci/scripts/wrapper_core_bt_on_error.sh /build/contrib/jenkins.sh
build 119659 0.0 0.0 4068 3252 ? S 13:27 0:00 /bin/bash -c test -d osmo-msc-1.15.0/_build || exit 0; \ dc_install_base=`CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.15.0/_inst && pwd | sed -e 's,^[^:\\/]:[\\/],/,'` \ && dc_destdir="${TMPDIR-/tmp}/am-dc-$$/" \ && am__cwd=`pwd` \ && CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.15.0/_build/sub \ && ../../configure \ --with-systemdsystemunitdir=$dc_install_base/ \ --enable-werror --enable-smpp --enable-iu --enable-external-tests --enable-manuals \ --srcdir=../.. --prefix="$dc_install_base" \ && make \ && make dvi \ && make check \ && make install \ && make installcheck \ && make uninstall \ && make distuninstallcheck_dir="$dc_install_base" \ distuninstallcheck \ && chmod -R a-w "$dc_install_base" \ && ({ \ (cd ../.. && umask 077 && mkdir "$dc_destdir") \ && make DESTDIR="$dc_destdir" install \ && make DESTDIR="$dc_destdir" uninstall \ && make DESTDIR="$dc_destdir" \ distuninstallcheck_dir="$dc_destdir" distuninstallcheck; \ } || { rm -rf "$dc_destdir"; exit 1; }) \ && rm -rf "$dc_destdir" \ && make dist \ && rm -rf osmo-msc-1.15.0.tar.gz osmo-msc-1.15.0.tar.bz2 \ && make distcleancheck \ && cd "$am__cwd" \ || exit 1
build 123622 0.0 0.0 4068 3212 ? S 13:27 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '2'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.4.1' && test -n '/build/osmo-msc-1.15.0/_build/sub'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='include src doc contrib tests ' ;; \ *) list='include src doc contrib tests ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail"
build 123815 0.0 0.0 4068 3108 ? S 13:27 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '3'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.4.1' && test -n '/build/osmo-msc-1.15.0/_build/sub/tests'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp' ;; \ *) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail"
build 130613 0.5 0.0 21584 16372 ? S 13:28 0:00 python3 ../../../tests/vty_test_runner.py -w /build/osmo-msc-1.15.0/_build/sub -v
build 130658 40.0 0.0 21474931716 43844 ? R 13:28 0:00 ./src/osmo-msc/osmo-msc -c /build/osmo-msc-1.15.0/tests/../doc/examples/osmo-msc/osmo-msc.cfg
build 130665 0.0 0.0 2680 1120 ? S 13:28 0:00 /bin/sh -c ps xua | grep osmo
build 130667 0.0 0.0 3896 1932 ? S 13:28 0:00 grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4254 <socket.socket fd=5, family=2, type=1, proto=0, laddr=('127.0.0.1', 42892), raddr=('127.0.0.1', 4254)> (1 sockets open)
Socket: closing 127.0.0.1:4254 <socket.socket fd=5, family=2, type=1, proto=0, laddr=('127.0.0.1', 42892), raddr=('127.0.0.1', 4254)> (0 sockets open)
Terminating took 0.897s
Process returned code: 0
ok
testVtyTree (__main__.TestVTYMSC.testVtyTree) ... Launching: PWD=/build/osmo-msc-1.15.0/_build/sub './src/osmo-msc/osmo-msc' '-c' '/build/osmo-msc-1.15.0/tests/../doc/examples/osmo-msc/osmo-msc.cfg'
> ls -l /proc/130613/fd
total 0
lr-x------ 1 build build 64 Dec 7 13:28 0 -> pipe:[1198531509]
l-wx------ 1 build build 64 Dec 7 13:28 1 -> pipe:[1198531510]
l-wx------ 1 build build 64 Dec 7 13:28 2 -> pipe:[1198531511]
lrwx------ 1 build build 64 Dec 7 13:28 3 -> /tmp/tmp_2bwsofk (deleted)
lrwx------ 1 build build 64 Dec 7 13:28 4 -> /tmp/tmpjmd433vh (deleted)
> ss -tn
State Recv-Q Send-Q Local Address:Port Peer Address:Port
> ss -tln
State Recv-Q Send-Q Local Address:Port Peer Address:Port
LISTEN 0 10 127.0.0.1:4254 0.0.0.0:*
LISTEN 0 10 127.0.0.1:4255 0.0.0.0:*
LISTEN 0 10 0.0.0.0:2775 0.0.0.0:*
> ps xua | grep osmo
build 1 0.0 0.0 2592 1152 ? Ss 13:24 0:00 /usr/bin/timeout 30m /osmo-ci/scripts/wrapper_core_bt_on_error.sh /build/contrib/jenkins.sh
build 7 0.0 0.0 2680 1072 ? S 13:24 0:00 /bin/sh /osmo-ci/scripts/wrapper_core_bt_on_error.sh /build/contrib/jenkins.sh
build 119659 0.0 0.0 4068 3252 ? S 13:27 0:00 /bin/bash -c test -d osmo-msc-1.15.0/_build || exit 0; \ dc_install_base=`CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.15.0/_inst && pwd | sed -e 's,^[^:\\/]:[\\/],/,'` \ && dc_destdir="${TMPDIR-/tmp}/am-dc-$$/" \ && am__cwd=`pwd` \ && CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.15.0/_build/sub \ && ../../configure \ --with-systemdsystemunitdir=$dc_install_base/ \ --enable-werror --enable-smpp --enable-iu --enable-external-tests --enable-manuals \ --srcdir=../.. --prefix="$dc_install_base" \ && make \ && make dvi \ && make check \ && make install \ && make installcheck \ && make uninstall \ && make distuninstallcheck_dir="$dc_install_base" \ distuninstallcheck \ && chmod -R a-w "$dc_install_base" \ && ({ \ (cd ../.. && umask 077 && mkdir "$dc_destdir") \ && make DESTDIR="$dc_destdir" install \ && make DESTDIR="$dc_destdir" uninstall \ && make DESTDIR="$dc_destdir" \ distuninstallcheck_dir="$dc_destdir" distuninstallcheck; \ } || { rm -rf "$dc_destdir"; exit 1; }) \ && rm -rf "$dc_destdir" \ && make dist \ && rm -rf osmo-msc-1.15.0.tar.gz osmo-msc-1.15.0.tar.bz2 \ && make distcleancheck \ && cd "$am__cwd" \ || exit 1
build 123622 0.0 0.0 4068 3212 ? S 13:27 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '2'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.4.1' && test -n '/build/osmo-msc-1.15.0/_build/sub'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='include src doc contrib tests ' ;; \ *) list='include src doc contrib tests ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail"
build 123815 0.0 0.0 4068 3108 ? S 13:27 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '3'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.4.1' && test -n '/build/osmo-msc-1.15.0/_build/sub/tests'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp' ;; \ *) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail"
build 130613 0.4 0.0 21584 16376 ? S 13:28 0:00 python3 ../../../tests/vty_test_runner.py -w /build/osmo-msc-1.15.0/_build/sub -v
build 130669 25.0 0.0 21474931716 40532 ? S 13:28 0:00 ./src/osmo-msc/osmo-msc -c /build/osmo-msc-1.15.0/tests/../doc/examples/osmo-msc/osmo-msc.cfg
build 130676 0.0 0.0 2680 1112 ? S 13:28 0:00 /bin/sh -c ps xua | grep osmo
build 130678 0.0 0.0 3896 1900 ? S 13:28 0:00 grep osmo
Socket: in 1 tries, connected to 127.0.0.1:4254 <socket.socket fd=5, family=2, type=1, proto=0, laddr=('127.0.0.1', 42904), raddr=('127.0.0.1', 4254)> (1 sockets open)
Socket: closing 127.0.0.1:4254 <socket.socket fd=5, family=2, type=1, proto=0, laddr=('127.0.0.1', 42904), raddr=('127.0.0.1', 4254)> (0 sockets open)
Killed child process
Process returned code: -9
================================================================================
stdout
================================================================================
================================================================================
stderr
================================================================================
[1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m Available via telnet 127.0.0.1 4254 (telnet_interface.c:88)
[1;33mDSMPP[0;m [1;33mNOTICE[0;m SMPP at 0.0.0.0 2775 (smpp_smsc.c:990)
[38;5;33m[1;33mDLCTRL[0;m[38;5;33m [1;33mNOTICE[0;m[38;5;33m CTRL at 127.0.0.1 4255 (control_if.c:1026)[0;m
[38;5;39m[1;33mDLGSUP[0;m[38;5;39m [1;33mNOTICE[0;m[38;5;39m GSUP connecting to 127.0.0.1:4222 (gsup_client.c:77)[0;m
[1;33mDDB[0;m [1;33mNOTICE[0;m Init database connection to 'sms.db' using SQLite3 lib version 3.46.1 (db.c:518)
[38;5;51m[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
[1;33mDMSC[0;m [1;33mNOTICE[0;m MGW pool with 1 pool members configured, (ignoring MGW configuration in VTY node 'msc'). (msc_main.c:576)
[38;5;45m[1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m OsmoMSC-A-Iu: Creating SS7 instance (sccp_instance.c:628)[0;m
[38;5;45m[1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m OsmoMSC-A-Iu: Using SS7 instance 0, pc:0.23.1 (sccp_instance.c:655)[0;m
[38;5;45m[1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m OsmoMSC-A-Iu: Creating AS instance (sccp_instance.c:662)[0;m
[38;5;45m[1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m OsmoMSC-A-Iu: Using AS instance as-clnt-OsmoMSC-A-Iu (sccp_instance.c:673)[0;m
[38;5;45m[1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m OsmoMSC-A-Iu: Creating default route (sccp_instance.c:679)[0;m
[38;5;45m[1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m OsmoMSC-A-Iu: No unassociated ASP for m3ua, creating new ASP asp-clnt-OsmoMSC-A-Iu (sccp_instance.c:717)[0;m
[38;5;45m[1;33mDLSCCP[0;m[38;5;45m [1;33mNOTICE[0;m[38;5;45m OsmoMSC-A-Iu: Using ASP instance asp-clnt-OsmoMSC-A-Iu (sccp_instance.c:784)[0;m
[38;5;43m[1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: Creating SCCP instance (ss7_instance.c:214)[0;m
[1;33mDSGS[0;m [1;33mNOTICE[0;m SGs socket bound to r=NULL<->l=0.0.0.0:29118 (sgs_server.c:186)
[1;33mDMSC[0;m [1;33mNOTICE[0;m A-interface: SCCP user OsmoMSC-A:RI=SSN_PC,PC=(no PC),SSN=BSSAP, cs7-instance 0 ((null)) (msc_main.c:790)
[1;33mDMSC[0;m [1;33mNOTICE[0;m Iu-interface: SCCP user OsmoMSC-IuCS:RI=SSN_PC,PC=(no PC),SSN=RANAP, cs7-instance 0 ((null)) (msc_main.c:811)
[38;5;23m[1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m CLICONN(asp-clnt-OsmoMSC-A-Iu,){CONNECTING} connect failed (-111) (stream_cli.c:424)[0;m
[1;33mDMSC[0;m [1;33mNOTICE[0;m Terminating due to signal 15 (msc_main.c:285)
ERROR
======================================================================
ERROR: testVtyTree (__main__.TestVTYMSC.testVtyTree)
----------------------------------------------------------------------
Traceback (most recent call last):
File "/build/osmo-msc-1.15.0/_build/sub/tests/../../../tests/vty_test_runner.py", line 85, in tearDown
raise Exception("Process returned %d" % rc)
Exception: Process returned -9
----------------------------------------------------------------------
Ran 6 tests in 13.572s
FAILED (errors=1)
make[8]: Leaving directory '/build/osmo-msc-1.15.0/_build/sub/tests'
make[8]: *** [Makefile:727: vty-python-test] Error 1
make[7]: Leaving directory '/build/osmo-msc-1.15.0/_build/sub/tests'
make[7]: *** [Makefile:747: vty-test] Error 2
make[6]: *** [Makefile:717: python-tests] Error 2
make[6]: Leaving directory '/build/osmo-msc-1.15.0/_build/sub/tests'
make[5]: *** [Makefile:771: check-local] Error 2
make[5]: Leaving directory '/build/osmo-msc-1.15.0/_build/sub/tests'
make[4]: Leaving directory '/build/osmo-msc-1.15.0/_build/sub/tests'
make[4]: *** [Makefile:576: check-am] Error 2
make[3]: *** [Makefile:426: check-recursive] Error 1
make[3]: Leaving directory '/build/osmo-msc-1.15.0/_build/sub/tests'
make[2]: *** [Makefile:477: check-recursive] Error 1
make[2]: Leaving directory '/build/osmo-msc-1.15.0/_build/sub'
make[1]: *** [Makefile:776: check] Error 2
make[1]: Leaving directory '/build/osmo-msc-1.15.0/_build/sub'
make: *** [Makefile:696: distcheck] Error 1
+ exit_tar_workspace
+ '[' 1 = 1 ']'
+ tar -cJf /tmp/workspace.tar.xz /build
tar: Removing leading `/' from member names
+ mv /tmp/workspace.tar.xz /build
+ cat-testlogs.sh
Build step 'Execute shell' marked build as failure
$ ssh-agent -k
unset SSH_AUTH_SOCK;
unset SSH_AGENT_PID;
echo Agent pid 3500082 killed;
[ssh-agent] Stopped.
Archiving artifacts
1
1
07 Dec '25
See <https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-latest/2631/display/…>
Changes:
------------------------------------------
[...truncated 11.67 MiB...]
[38;5;49m20251206125014910 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer (m3ua.c:601)[0;m
[38;5;49m20251206125014910 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer(): M3UA data header: opc=187=0.23.3 dpc=185=0.23.1 sls=8 (m3ua.c:632)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: mtp3_hmdc_rx_from_l2(): dpc=185=0.23.1 not local, message is for routing (mtp3_hmdc.c:49)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: CombinedLinkset(dpc=185=0.23.1,mask=0x3fff=7.255.7,prio=5) RT lookup: OPC=187=0.23.3,DPC=185=0.23.1,SLS=8 -> eSLS=40: use Normal Route via 'virt-msc0' (ss7_combined_linkset.c:275)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: Found route for dpc=185=0.23.1: pc=185=0.23.1 mask=0x3fff=7.255.7 prio=5 dyn via AS virt-msc0 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: rt->dest.as proto is M3UA for dpc=185=0.23.1 (mtp3_hmrt.c:90)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(virt-msc0){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:563)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc0-0) Tx 56 bytes: [L2]> 01 00 01 01 00 00 00 38 02 10 00 26 00 00 00 bb 00 00 00 b9 03 00 00 08 09 00 03 07 0b 04 43 b9 00 fe 04 43 bb 00 fe 06 00 04 30 04 01 20 00 00 00 06 00 08 00 00 00 01 (ss7_asp.c:1400)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (ss7_asp.c:1107)[0;m
[38;5;49m20251206125014910 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) Received M3UA Message (XFER:DATA) (m3ua.c:811)[0;m
[38;5;49m20251206125014910 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer (m3ua.c:601)[0;m
[38;5;49m20251206125014910 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer(): M3UA data header: opc=187=0.23.3 dpc=185=0.23.1 sls=13 (m3ua.c:632)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: mtp3_hmdc_rx_from_l2(): dpc=185=0.23.1 not local, message is for routing (mtp3_hmdc.c:49)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: CombinedLinkset(dpc=185=0.23.1,mask=0x3fff=7.255.7,prio=5) RT lookup: OPC=187=0.23.3,DPC=185=0.23.1,SLS=13 -> eSLS=45: use Normal Route via 'virt-msc0' (ss7_combined_linkset.c:275)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: Found route for dpc=185=0.23.1: pc=185=0.23.1 mask=0x3fff=7.255.7 prio=5 via AS virt-msc0 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: rt->dest.as proto is M3UA for dpc=185=0.23.1 (mtp3_hmrt.c:90)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(virt-msc0){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:563)[0;m
[38;5;43m20251206125014910 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc0-0) Tx 52 bytes: [L2]> 01 00 01 01 00 00 00 34 02 10 00 23 00 00 00 bb 00 00 00 b9 03 00 00 0d 09 00 03 07 0b 04 43 b9 00 fe 04 43 bb 00 fe 03 00 01 31 00 00 06 00 08 00 00 00 01 (ss7_asp.c:1400)[0;m
MTC@538ec151fcde: BSSMAP: Respoding to inbound RESET with RESET-ACK
[38;5;43m20251206125014916 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc0-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (ss7_asp.c:1107)[0;m
[38;5;49m20251206125014916 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc0-0) Received M3UA Message (XFER:DATA) (m3ua.c:811)[0;m
[38;5;49m20251206125014916 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc0-0) m3ua_rx_xfer (m3ua.c:601)[0;m
[38;5;49m20251206125014916 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc0-0) m3ua_rx_xfer(): M3UA data header: opc=185=0.23.1 dpc=187=0.23.3 sls=0 (m3ua.c:632)[0;m
[38;5;43m20251206125014916 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: mtp3_hmdc_rx_from_l2(): dpc=187=0.23.3 not local, message is for routing (mtp3_hmdc.c:49)[0;m
[38;5;43m20251206125014916 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: CombinedLinkset(dpc=187=0.23.3,mask=0x3fff=7.255.7,prio=5) RT lookup: OPC=185=0.23.1,DPC=187=0.23.3,SLS=0 -> eSLS=32: use Normal Route via 'bsc0' (ss7_combined_linkset.c:275)[0;m
[38;5;43m20251206125014916 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: Found route for dpc=187=0.23.3: pc=187=0.23.3 mask=0x3fff=7.255.7 prio=5 dyn via AS bsc0 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20251206125014916 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: rt->dest.as proto is M3UA for dpc=187=0.23.3 (mtp3_hmrt.c:90)[0;m
[38;5;43m20251206125014916 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(bsc0){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:563)[0;m
[38;5;43m20251206125014916 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 44 bytes: [L2]> 01 00 01 01 00 00 00 2c 02 10 00 23 00 00 00 b9 00 00 00 bb 03 00 00 00 09 00 03 07 0b 04 43 bb 00 fe 04 43 b9 00 fe 03 00 01 31 00 (ss7_asp.c:1400)[0;m
MTC@538ec151fcde: BSSMAP: Received RESET-ACK in response to RESET, we're ready to go!
20251206125014917 [1;33mDMSC[0;m [1;33mNOTICE[0;m (msc=0) RESET ACK from MSC: RI=SSN_PC,PC=0.23.1,SSN=BSSAP (osmo_bsc_bssap.c:84)
VirtSMLC-M3UA(1272)@538ec151fcde: *************************************************
VirtSMLC-M3UA(1272)@538ec151fcde: M3UA emulation initiated, the test can be started
VirtSMLC-M3UA(1272)@538ec151fcde: *************************************************
VirtSMLC-SCCP(1271)@538ec151fcde: v_sccp_pdu_maxlen:268
[38;5;43m20251206125015135 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m (r=127.0.0.1:23908<->l=127.0.0.1:2905): New m3ua connection accepted (ss7_xua_srv.c:75)[0;m
[38;5;43m20251206125015135 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m (r=127.0.0.1:23908<->l=127.0.0.1:2905): matched connection to ASP virt-smlc-0 (ss7_xua_srv.c:79)[0;m
[38;5;43m20251206125015135 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(virt-smlc-0){ASP_DOWN}: Received Event SCTP-EST.ind (ss7_xua_srv.c:215)[0;m
[38;5;43m20251206125015135 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(virt-smlc-0){ASP_DOWN}: No Layer Manager, dropping M-SCTP_ESTABLISH.indication (xua_asp_fsm.c:129)[0;m
VirtSMLC-M3UA(1272)@538ec151fcde: SCTP_ConnectResult -> connection established from: "127.0.0.1":23908 to server: "127.0.0.1":2905 association #8
[38;5;43m20251206125015139 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-smlc-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (ss7_asp.c:1107)[0;m
[38;5;49m20251206125015139 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-smlc-0) Received M3UA Message (ASPSM:UP) (m3ua.c:811)[0;m
[38;5;43m20251206125015139 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(virt-smlc-0){ASP_DOWN}: Received Event ASPSM-ASP_UP (m3ua.c:772)[0;m
[38;5;43m20251206125015139 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-smlc-0) Tx 8 bytes: [L2]> 01 00 03 04 00 00 00 08 (ss7_asp.c:1400)[0;m
[38;5;43m20251206125015139 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(virt-smlc-0){ASP_DOWN}: state_chg to ASP_INACTIVE (xua_asp_fsm.c:596)[0;m
[38;5;43m20251206125015139 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(virt-smlc-0){ASP_INACTIVE}: Tx HEARTBEAT (0 unacked) (xua_asp_fsm.c:447)[0;m
[38;5;43m20251206125015139 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-smlc-0) Tx 8 bytes: [L2]> 01 00 03 03 00 00 00 08 (ss7_asp.c:1400)[0;m
[38;5;43m20251206125015139 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(virt-smlc){AS_DOWN}: Received Event ASPAS-ASP_INACTIVE.ind (xua_asp_fsm.c:405)[0;m
[38;5;43m20251206125015139 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(virt-smlc){AS_DOWN}: state_chg to AS_INACTIVE (xua_as_fsm.c:357)[0;m
[38;5;43m20251206125015139 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(virt-smlc){AS_INACTIVE}: Broadcasting NOTIFY Type State Change:AS Inactive () to all non-DOWN ASPs (xua_as_fsm.c:116)[0;m
[38;5;43m20251206125015139 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: ASP(virt-smlc-0) Tx NOTIFY Type State Change:AS Inactive () (xua_as_fsm.c:142)[0;m
[38;5;43m20251206125015139 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-smlc-0) Tx 24 bytes: [L2]> 01 00 00 01 00 00 00 18 00 0d 00 08 00 01 00 02 00 06 00 08 00 00 00 06 (ss7_asp.c:1400)[0;m
[38;5;43m20251206125015139 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(virt-smlc-0){ASP_INACTIVE}: No Layer Manager, dropping M-ASP_UP.indication (xua_asp_fsm.c:129)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-smlc-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (ss7_asp.c:1107)[0;m
[38;5;49m20251206125015141 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-smlc-0) Received M3UA Message (ASPTM:ACTIVE) (m3ua.c:811)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(virt-smlc-0){ASP_INACTIVE}: Received Event ASPTM-ASP_AC (m3ua.c:772)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-smlc-0) Tx 16 bytes: [L2]> 01 00 04 03 00 00 00 10 00 06 00 08 00 00 00 06 (ss7_asp.c:1400)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(virt-smlc-0){ASP_INACTIVE}: state_chg to ASP_ACTIVE (xua_asp_fsm.c:723)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(virt-smlc){AS_INACTIVE}: Received Event ASPAS-ASP_ACTIVE.ind (xua_asp_fsm.c:405)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(virt-smlc){AS_INACTIVE}: state_chg to AS_ACTIVE (xua_as_fsm.c:565)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(virt-smlc){AS_ACTIVE}: Broadcasting NOTIFY Type State Change:AS Active () to all non-DOWN ASPs (xua_as_fsm.c:116)[0;m
[38;5;43m20251206125015141 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: ASP(virt-smlc-0) Tx NOTIFY Type State Change:AS Active () (xua_as_fsm.c:142)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-smlc-0) Tx 24 bytes: [L2]> 01 00 00 01 00 00 00 18 00 0d 00 08 00 01 00 03 00 06 00 08 00 00 00 06 (ss7_asp.c:1400)[0;m
[38;5;43m20251206125015141 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: RT(dpc=190=0.23.6,mask=0x3fff=7.255.7,prio=5,via=virt-smlc,st=unavailable) changed to status 'available' (ss7_route.c:409)[0;m
[38;5;43m20251206125015141 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: RT(dpc=190=0.23.6,mask=0x3fff=7.255.7,prio=5,via=virt-smlc,st=unavailable) changed to status 'available' (ss7_route.c:409)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 16 bytes: [L2]> 01 00 02 02 00 00 00 10 00 12 00 08 00 00 00 be (ss7_asp.c:1400)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc0-0) Tx 24 bytes: [L2]> 01 00 02 02 00 00 00 18 00 06 00 08 00 00 00 01 00 12 00 08 00 00 00 be (ss7_asp.c:1400)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-smlc-0) Tx 48 bytes: [L2]> 01 00 02 01 00 00 00 30 00 06 00 08 00 00 00 06 00 12 00 0c 00 00 00 02 00 00 00 03 00 04 00 12 52 46 43 34 36 36 36 20 34 2e 35 2e 31 00 00 00 (ss7_asp.c:1400)[0;m
[38;5;43m20251206125015141 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(virt-smlc-0){ASP_ACTIVE}: No Layer Manager, dropping M-ASP_ACTIVE.indication (xua_asp_fsm.c:129)[0;m
[38;5;49m20251206125015142 [1;33mDLM3UA[0;m[38;5;49m [1;33mNOTICE[0;m[38;5;49m 0: ASP(asp-clnt-msc-0) Rx DAVA() for 0.23.6/0 (xua_snm.c:536)[0;m
[38;5;43m20251206125015142 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: RT(dpc=190=0.23.6,mask=0x3fff=7.255.7,prio=5,via=as-clnt-A-0-m3ua,st=unavailable) changed to status 'available' (ss7_route.c:409)[0;m
20251206125015142 [1;31mDLCS[0;m [1;31mERROR[0;m Unhandled SIGTRAN primitive N-PCSTATE.indication (lb.c:212)
[38;5;43m20251206125015693 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: T8: SP 2=0.0.2: Timeout (ss7_instance.c:858)[0;m
[38;5;43m20251206125015694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: T8: SP 3=0.0.3: Timeout (ss7_instance.c:858)[0;m
IPA-BTS0-TRX0-RSL-IPA(1275)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
IPA-BTS0-TRX0-RSL-IPA(1275)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITID (8) }, { len := 1, tag := IPAC_IDTAG_MACADDR (7) }, { len := 1, tag := IPAC_IDTAG_LOCATION1 (2) }, { len := 1, tag := IPAC_IDTAG_LOCATION2 (3) }, { len := 1, tag := IPAC_IDTAG_EQUIPVERS (4) }, { len := 1, tag := IPAC_IDTAG_SWVERSION (5) }, { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_SERNR (0) } } } }
IPA-BTS0-TRX0-RSL-IPA(1275)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 0, tag := IPAC_IDTAG_UNITID (8), data := '313233342F302F3000'O }, { len := 0, tag := IPAC_IDTAG_MACADDR (7), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION1 (2), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION2 (3), data := '00'O }, { len := 0, tag := IPAC_IDTAG_EQUIPVERS (4), data := '00'O }, { len := 0, tag := IPAC_IDTAG_SWVERSION (5), data := '00'O }, { len := 0, tag := IPAC_IDTAG_UNITNAME (1), data := '4F736D6F636F6D205454434E2D33204254532053696D756C61746F7200'O }, { len := 0, tag := IPAC_IDTAG_SERNR (0), data := '00'O } } } }
[1;35m20251206125016002 [1;33mDRSL[0;m[1;35m [1;33mNOTICE[0;m[1;35m (bts=0,trx=0) bootstrapping RSL on ARFCN 871 using MCC-MNC 001-01 LAC=1 CID=0 BSIC=10 (osmo_bsc_main.c:320)[0;m
IPA-BTS0-TRX0-RSL-IPA(1275)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
IPA-BTS1-TRX0-RSL-IPA(1276)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
IPA-BTS1-TRX0-RSL-IPA(1276)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITID (8) }, { len := 1, tag := IPAC_IDTAG_MACADDR (7) }, { len := 1, tag := IPAC_IDTAG_LOCATION1 (2) }, { len := 1, tag := IPAC_IDTAG_LOCATION2 (3) }, { len := 1, tag := IPAC_IDTAG_EQUIPVERS (4) }, { len := 1, tag := IPAC_IDTAG_SWVERSION (5) }, { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_SERNR (0) } } } }
IPA-BTS1-TRX0-RSL-IPA(1276)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 0, tag := IPAC_IDTAG_UNITID (8), data := '313233352F302F3000'O }, { len := 0, tag := IPAC_IDTAG_MACADDR (7), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION1 (2), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION2 (3), data := '00'O }, { len := 0, tag := IPAC_IDTAG_EQUIPVERS (4), data := '00'O }, { len := 0, tag := IPAC_IDTAG_SWVERSION (5), data := '00'O }, { len := 0, tag := IPAC_IDTAG_UNITNAME (1), data := '4F736D6F636F6D205454434E2D33204254532053696D756C61746F7200'O }, { len := 0, tag := IPAC_IDTAG_SERNR (0), data := '00'O } } } }
[1;35m20251206125018051 [1;33mDRSL[0;m[1;35m [1;33mNOTICE[0;m[1;35m (bts=1,trx=0) bootstrapping RSL on ARFCN 871 using MCC-MNC 001-01 LAC=1 CID=1 BSIC=11 (osmo_bsc_main.c:320)[0;m
IPA-BTS1-TRX0-RSL-IPA(1276)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
[38;5;43m20251206125019693 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (ss7_asp.c:1107)[0;m
[38;5;49m20251206125019693 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) Received M3UA Message (XFER:DATA) (m3ua.c:811)[0;m
[38;5;49m20251206125019693 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer (m3ua.c:601)[0;m
[38;5;49m20251206125019693 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer(): M3UA data header: opc=187=0.23.3 dpc=2=0.0.2 sls=11 (m3ua.c:632)[0;m
[38;5;43m20251206125019693 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: mtp3_hmdc_rx_from_l2(): dpc=2=0.0.2 not local, message is for routing (mtp3_hmdc.c:49)[0;m
[38;5;43m20251206125019693 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: CombinedLinkset(dpc=2=0.0.2,mask=0x3fff=7.255.7,prio=5) RT Lookup: OPC=187=0.23.3,DPC=2=0.0.2,SLS=11 -> eSLS=107: Normal Route via 'virt-msc1' unavailable, all Alternative Routes unavailable (ss7_combined_linkset.c:322)[0;m
[38;5;43m20251206125019693 [1;31mDLSS7[0;m[38;5;43m [1;31mERROR[0;m[38;5;43m 0: MTP-TRANSFER.req for dpc=2=0.0.2: no route! (mtp3_hmrt.c:113)[0;m
[38;5;43m20251206125019693 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: T8: SP 2=0.0.2: Start (ss7_instance.c:879)[0;m
[38;5;43m20251206125019693 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: CombinedLinkset(dpc=187=0.23.3,mask=0x3fff=7.255.7,prio=5) RT lookup: OPC=2=0.0.2,DPC=187=0.23.3,SLS=11 -> eSLS=107: use Normal Route via 'bsc0' (ss7_combined_linkset.c:275)[0;m
[38;5;43m20251206125019693 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: Message received for inaccessible SP 2=0.0.2. Tx TFP (DUNA) to concerned SP 187=0.23.3 (mtp3_rtpc.c:120)[0;m
[38;5;43m20251206125019693 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(bsc0){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:563)[0;m
[38;5;43m20251206125019693 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 60 bytes: [L2]> 01 00 02 01 00 00 00 3c 00 12 00 08 00 00 00 02 00 04 00 2a 74 72 61 6e 73 66 65 72 20 70 72 6f 68 69 62 69 74 65 64 20 28 69 6e 61 63 63 65 73 73 69 62 6c 65 20 53 50 29 00 00 00 (ss7_asp.c:1400)[0;m
[38;5;49m20251206125019694 [1;33mDLM3UA[0;m[38;5;49m [1;33mNOTICE[0;m[38;5;49m 0: ASP(asp-clnt-msc-0) Rx DUNA(transfer prohibited (inaccessible SP)) for 0.0.2/0 (xua_snm.c:501)[0;m
[38;5;43m20251206125019694 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: RT(dpc=2=0.0.2,mask=0x3fff=7.255.7,prio=5,via=as-clnt-A-0-m3ua,st=unavailable) changed to status 'unavailable' (ss7_route.c:409)[0;m
20251206125019694 [1;31mDLCS[0;m [1;31mERROR[0;m Unhandled SIGTRAN primitive N-PCSTATE.indication (lb.c:212)
[38;5;43m20251206125019694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (ss7_asp.c:1107)[0;m
[38;5;49m20251206125019694 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) Received M3UA Message (XFER:DATA) (m3ua.c:811)[0;m
[38;5;49m20251206125019694 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer (m3ua.c:601)[0;m
[38;5;49m20251206125019694 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer(): M3UA data header: opc=187=0.23.3 dpc=3=0.0.3 sls=7 (m3ua.c:632)[0;m
[38;5;43m20251206125019694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: mtp3_hmdc_rx_from_l2(): dpc=3=0.0.3 not local, message is for routing (mtp3_hmdc.c:49)[0;m
[38;5;43m20251206125019694 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: CombinedLinkset(dpc=3=0.0.3,mask=0x3fff=7.255.7,prio=5) RT Lookup: OPC=187=0.23.3,DPC=3=0.0.3,SLS=7 -> eSLS=119: Normal Route via 'virt-msc2' unavailable, all Alternative Routes unavailable (ss7_combined_linkset.c:322)[0;m
[38;5;43m20251206125019694 [1;31mDLSS7[0;m[38;5;43m [1;31mERROR[0;m[38;5;43m 0: MTP-TRANSFER.req for dpc=3=0.0.3: no route! (mtp3_hmrt.c:113)[0;m
[38;5;43m20251206125019694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: T8: SP 3=0.0.3: Start (ss7_instance.c:879)[0;m
[38;5;43m20251206125019694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: CombinedLinkset(dpc=187=0.23.3,mask=0x3fff=7.255.7,prio=5) RT lookup: OPC=3=0.0.3,DPC=187=0.23.3,SLS=7 -> eSLS=119: use Normal Route via 'bsc0' (ss7_combined_linkset.c:275)[0;m
[38;5;43m20251206125019694 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: Message received for inaccessible SP 3=0.0.3. Tx TFP (DUNA) to concerned SP 187=0.23.3 (mtp3_rtpc.c:120)[0;m
[38;5;43m20251206125019694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(bsc0){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:563)[0;m
[38;5;43m20251206125019694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 60 bytes: [L2]> 01 00 02 01 00 00 00 3c 00 12 00 08 00 00 00 03 00 04 00 2a 74 72 61 6e 73 66 65 72 20 70 72 6f 68 69 62 69 74 65 64 20 28 69 6e 61 63 63 65 73 73 69 62 6c 65 20 53 50 29 00 00 00 (ss7_asp.c:1400)[0;m
[38;5;49m20251206125019694 [1;33mDLM3UA[0;m[38;5;49m [1;33mNOTICE[0;m[38;5;49m 0: ASP(asp-clnt-msc-0) Rx DUNA(transfer prohibited (inaccessible SP)) for 0.0.3/0 (xua_snm.c:501)[0;m
[38;5;43m20251206125019694 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: RT(dpc=3=0.0.3,mask=0x3fff=7.255.7,prio=5,via=as-clnt-A-0-m3ua,st=unavailable) changed to status 'unavailable' (ss7_route.c:409)[0;m
20251206125019694 [1;31mDLCS[0;m [1;31mERROR[0;m Unhandled SIGTRAN primitive N-PCSTATE.indication (lb.c:212)
IPA-BTS2-TRX0-RSL-IPA(1277)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
IPA-BTS2-TRX0-RSL-IPA(1277)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITID (8) }, { len := 1, tag := IPAC_IDTAG_MACADDR (7) }, { len := 1, tag := IPAC_IDTAG_LOCATION1 (2) }, { len := 1, tag := IPAC_IDTAG_LOCATION2 (3) }, { len := 1, tag := IPAC_IDTAG_EQUIPVERS (4) }, { len := 1, tag := IPAC_IDTAG_SWVERSION (5) }, { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_SERNR (0) } } } }
IPA-BTS2-TRX0-RSL-IPA(1277)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 0, tag := IPAC_IDTAG_UNITID (8), data := '313233362F302F3000'O }, { len := 0, tag := IPAC_IDTAG_MACADDR (7), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION1 (2), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION2 (3), data := '00'O }, { len := 0, tag := IPAC_IDTAG_EQUIPVERS (4), data := '00'O }, { len := 0, tag := IPAC_IDTAG_SWVERSION (5), data := '00'O }, { len := 0, tag := IPAC_IDTAG_UNITNAME (1), data := '4F736D6F636F6D205454434E2D33204254532053696D756C61746F7200'O }, { len := 0, tag := IPAC_IDTAG_SERNR (0), data := '00'O } } } }
IPA-BTS2-TRX0-RSL-IPA(1277)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
[1;35m20251206125020097 [1;33mDRSL[0;m[1;35m [1;33mNOTICE[0;m[1;35m (bts=2,trx=0) bootstrapping RSL on ARFCN 871 using MCC-MNC 001-01 LAC=2 CID=1 BSIC=12 (osmo_bsc_main.c:320)[0;m
IPA-BTS2-TRX1-RSL-IPA(1278)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
IPA-BTS2-TRX1-RSL-IPA(1278)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITID (8) }, { len := 1, tag := IPAC_IDTAG_MACADDR (7) }, { len := 1, tag := IPAC_IDTAG_LOCATION1 (2) }, { len := 1, tag := IPAC_IDTAG_LOCATION2 (3) }, { len := 1, tag := IPAC_IDTAG_EQUIPVERS (4) }, { len := 1, tag := IPAC_IDTAG_SWVERSION (5) }, { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_SERNR (0) } } } }
IPA-BTS2-TRX1-RSL-IPA(1278)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 0, tag := IPAC_IDTAG_UNITID (8), data := '313233362F302F3100'O }, { len := 0, tag := IPAC_IDTAG_MACADDR (7), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION1 (2), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION2 (3), data := '00'O }, { len := 0, tag := IPAC_IDTAG_EQUIPVERS (4), data := '00'O }, { len := 0, tag := IPAC_IDTAG_SWVERSION (5), data := '00'O }, { len := 0, tag := IPAC_IDTAG_UNITNAME (1), data := '4F736D6F636F6D205454434E2D33204254532053696D756C61746F7200'O }, { len := 0, tag := IPAC_IDTAG_SERNR (0), data := '00'O } } } }
[1;35m20251206125020111 [1;33mDRSL[0;m[1;35m [1;33mNOTICE[0;m[1;35m (bts=2,trx=1) bootstrapping RSL on ARFCN 873 using MCC-MNC 001-01 LAC=2 CID=1 BSIC=12 (osmo_bsc_main.c:320)[0;m
IPA-BTS2-TRX1-RSL-IPA(1278)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
IPA-BTS2-TRX2-RSL-IPA(1279)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
IPA-BTS2-TRX2-RSL-IPA(1279)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITID (8) }, { len := 1, tag := IPAC_IDTAG_MACADDR (7) }, { len := 1, tag := IPAC_IDTAG_LOCATION1 (2) }, { len := 1, tag := IPAC_IDTAG_LOCATION2 (3) }, { len := 1, tag := IPAC_IDTAG_EQUIPVERS (4) }, { len := 1, tag := IPAC_IDTAG_SWVERSION (5) }, { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_SERNR (0) } } } }
IPA-BTS2-TRX2-RSL-IPA(1279)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 0, tag := IPAC_IDTAG_UNITID (8), data := '313233362F302F3200'O }, { len := 0, tag := IPAC_IDTAG_MACADDR (7), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION1 (2), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION2 (3), data := '00'O }, { len := 0, tag := IPAC_IDTAG_EQUIPVERS (4), data := '00'O }, { len := 0, tag := IPAC_IDTAG_SWVERSION (5), data := '00'O }, { len := 0, tag := IPAC_IDTAG_UNITNAME (1), data := '4F736D6F636F6D205454434E2D33204254532053696D756C61746F7200'O }, { len := 0, tag := IPAC_IDTAG_SERNR (0), data := '00'O } } } }
[1;35m20251206125020139 [1;33mDRSL[0;m[1;35m [1;33mNOTICE[0;m[1;35m (bts=2,trx=2) bootstrapping RSL on ARFCN 875 using MCC-MNC 001-01 LAC=2 CID=1 BSIC=12 (osmo_bsc_main.c:320)[0;m
IPA-BTS2-TRX2-RSL-IPA(1279)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
IPA-BTS2-TRX3-RSL-IPA(1280)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
IPA-BTS2-TRX3-RSL-IPA(1280)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITID (8) }, { len := 1, tag := IPAC_IDTAG_MACADDR (7) }, { len := 1, tag := IPAC_IDTAG_LOCATION1 (2) }, { len := 1, tag := IPAC_IDTAG_LOCATION2 (3) }, { len := 1, tag := IPAC_IDTAG_EQUIPVERS (4) }, { len := 1, tag := IPAC_IDTAG_SWVERSION (5) }, { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_SERNR (0) } } } }
IPA-BTS2-TRX3-RSL-IPA(1280)@538ec151fcde: CCM Tx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 0, tag := IPAC_IDTAG_UNITID (8), data := '313233362F302F3300'O }, { len := 0, tag := IPAC_IDTAG_MACADDR (7), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION1 (2), data := '00'O }, { len := 0, tag := IPAC_IDTAG_LOCATION2 (3), data := '00'O }, { len := 0, tag := IPAC_IDTAG_EQUIPVERS (4), data := '00'O }, { len := 0, tag := IPAC_IDTAG_SWVERSION (5), data := '00'O }, { len := 0, tag := IPAC_IDTAG_UNITNAME (1), data := '4F736D6F636F6D205454434E2D33204254532053696D756C61746F7200'O }, { len := 0, tag := IPAC_IDTAG_SERNR (0), data := '00'O } } } }
[1;35m20251206125020164 [1;33mDRSL[0;m[1;35m [1;33mNOTICE[0;m[1;35m (bts=2,trx=3) bootstrapping RSL on ARFCN 877 using MCC-MNC 001-01 LAC=2 CID=1 BSIC=12 (osmo_bsc_main.c:320)[0;m
IPA-BTS2-TRX3-RSL-IPA(1280)@538ec151fcde: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit }
[38;5;43m20251206125020695 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: T8: SP 2=0.0.2: Timeout (ss7_instance.c:858)[0;m
[38;5;43m20251206125020695 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: T8: SP 3=0.0.3: Timeout (ss7_instance.c:858)[0;m
MTC@538ec151fcde: "TC_paging_tmsi_nochan() start"
20251206125021174 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): TC_paging_tmsi_nochan() start (logging_vty.c:1172)
[38;5;43m20251206125021179 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc0-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (ss7_asp.c:1107)[0;m
[38;5;49m20251206125021179 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc0-0) Received M3UA Message (XFER:DATA) (m3ua.c:811)[0;m
[38;5;49m20251206125021179 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc0-0) m3ua_rx_xfer (m3ua.c:601)[0;m
[38;5;49m20251206125021179 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc0-0) m3ua_rx_xfer(): M3UA data header: opc=185=0.23.1 dpc=187=0.23.3 sls=0 (m3ua.c:632)[0;m
[38;5;43m20251206125021179 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: mtp3_hmdc_rx_from_l2(): dpc=187=0.23.3 not local, message is for routing (mtp3_hmdc.c:49)[0;m
[38;5;43m20251206125021179 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: CombinedLinkset(dpc=187=0.23.3,mask=0x3fff=7.255.7,prio=5) RT lookup: OPC=185=0.23.1,DPC=187=0.23.3,SLS=0 -> eSLS=32: use Normal Route via 'bsc0' (ss7_combined_linkset.c:275)[0;m
[38;5;43m20251206125021179 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: Found route for dpc=187=0.23.3: pc=187=0.23.3 mask=0x3fff=7.255.7 prio=5 dyn via AS bsc0 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20251206125021179 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: rt->dest.as proto is M3UA for dpc=187=0.23.3 (mtp3_hmrt.c:90)[0;m
[38;5;43m20251206125021179 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(bsc0){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:563)[0;m
[38;5;43m20251206125021179 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 64 bytes: [L2]> 01 00 01 01 00 00 00 40 02 10 00 36 00 00 00 b9 00 00 00 bb 03 00 00 00 09 00 03 07 0b 04 43 bb 00 fe 04 43 b9 00 fe 16 00 14 52 08 08 09 10 10 10 00 00 00 10 09 04 a1 b2 c3 01 1a 01 03 00 00 (ss7_asp.c:1400)[0;m
MTC@538ec151fcde: setverdict(pass): none -> pass
MTC@538ec151fcde: talloc reports "struct bsc_subscr" x 1, expecting 0
MTC@538ec151fcde: talloc reports "struct gsm_subscriber_connection" x 0, expecting 0
MTC@538ec151fcde: count mismatch, retrying in 3.000000
[38;5;43m20251206125024694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (ss7_asp.c:1107)[0;m
[38;5;49m20251206125024694 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) Received M3UA Message (XFER:DATA) (m3ua.c:811)[0;m
[38;5;49m20251206125024694 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer (m3ua.c:601)[0;m
[38;5;49m20251206125024694 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer(): M3UA data header: opc=187=0.23.3 dpc=2=0.0.2 sls=4 (m3ua.c:632)[0;m
[38;5;43m20251206125024694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: mtp3_hmdc_rx_from_l2(): dpc=2=0.0.2 not local, message is for routing (mtp3_hmdc.c:49)[0;m
[38;5;43m20251206125024694 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: CombinedLinkset(dpc=2=0.0.2,mask=0x3fff=7.255.7,prio=5) RT Lookup: OPC=187=0.23.3,DPC=2=0.0.2,SLS=4 -> eSLS=100: Normal Route via 'virt-msc1' unavailable, all Alternative Routes unavailable (ss7_combined_linkset.c:322)[0;m
[38;5;43m20251206125024694 [1;31mDLSS7[0;m[38;5;43m [1;31mERROR[0;m[38;5;43m 0: MTP-TRANSFER.req for dpc=2=0.0.2: no route! (mtp3_hmrt.c:113)[0;m
[38;5;43m20251206125024694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: T8: SP 2=0.0.2: Start (ss7_instance.c:879)[0;m
[38;5;43m20251206125024694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: CombinedLinkset(dpc=187=0.23.3,mask=0x3fff=7.255.7,prio=5) RT lookup: OPC=2=0.0.2,DPC=187=0.23.3,SLS=4 -> eSLS=100: use Normal Route via 'bsc0' (ss7_combined_linkset.c:275)[0;m
[38;5;43m20251206125024694 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: Message received for inaccessible SP 2=0.0.2. Tx TFP (DUNA) to concerned SP 187=0.23.3 (mtp3_rtpc.c:120)[0;m
[38;5;43m20251206125024694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(bsc0){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:563)[0;m
[38;5;43m20251206125024694 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 60 bytes: [L2]> 01 00 02 01 00 00 00 3c 00 12 00 08 00 00 00 02 00 04 00 2a 74 72 61 6e 73 66 65 72 20 70 72 6f 68 69 62 69 74 65 64 20 28 69 6e 61 63 63 65 73 73 69 62 6c 65 20 53 50 29 00 00 00 (ss7_asp.c:1400)[0;m
[38;5;49m20251206125024695 [1;33mDLM3UA[0;m[38;5;49m [1;33mNOTICE[0;m[38;5;49m 0: ASP(asp-clnt-msc-0) Rx DUNA(transfer prohibited (inaccessible SP)) for 0.0.2/0 (xua_snm.c:501)[0;m
[38;5;43m20251206125024695 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: RT(dpc=2=0.0.2,mask=0x3fff=7.255.7,prio=5,via=as-clnt-A-0-m3ua,st=unavailable) changed to status 'unavailable' (ss7_route.c:409)[0;m
20251206125024695 [1;31mDLCS[0;m [1;31mERROR[0;m Unhandled SIGTRAN primitive N-PCSTATE.indication (lb.c:212)
[38;5;43m20251206125024695 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (ss7_asp.c:1107)[0;m
[38;5;49m20251206125024695 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) Received M3UA Message (XFER:DATA) (m3ua.c:811)[0;m
[38;5;49m20251206125024695 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer (m3ua.c:601)[0;m
[38;5;49m20251206125024695 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer(): M3UA data header: opc=187=0.23.3 dpc=3=0.0.3 sls=3 (m3ua.c:632)[0;m
[38;5;43m20251206125024695 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: mtp3_hmdc_rx_from_l2(): dpc=3=0.0.3 not local, message is for routing (mtp3_hmdc.c:49)[0;m
[38;5;43m20251206125024695 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: CombinedLinkset(dpc=3=0.0.3,mask=0x3fff=7.255.7,prio=5) RT Lookup: OPC=187=0.23.3,DPC=3=0.0.3,SLS=3 -> eSLS=115: Normal Route via 'virt-msc2' unavailable, all Alternative Routes unavailable (ss7_combined_linkset.c:322)[0;m
[38;5;43m20251206125024695 [1;31mDLSS7[0;m[38;5;43m [1;31mERROR[0;m[38;5;43m 0: MTP-TRANSFER.req for dpc=3=0.0.3: no route! (mtp3_hmrt.c:113)[0;m
[38;5;43m20251206125024695 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: T8: SP 3=0.0.3: Start (ss7_instance.c:879)[0;m
[38;5;43m20251206125024695 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: CombinedLinkset(dpc=187=0.23.3,mask=0x3fff=7.255.7,prio=5) RT lookup: OPC=3=0.0.3,DPC=187=0.23.3,SLS=3 -> eSLS=115: use Normal Route via 'bsc0' (ss7_combined_linkset.c:275)[0;m
[38;5;43m20251206125024695 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: Message received for inaccessible SP 3=0.0.3. Tx TFP (DUNA) to concerned SP 187=0.23.3 (mtp3_rtpc.c:120)[0;m
[38;5;43m20251206125024695 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(bsc0){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:563)[0;m
[38;5;43m20251206125024695 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 60 bytes: [L2]> 01 00 02 01 00 00 00 3c 00 12 00 08 00 00 00 03 00 04 00 2a 74 72 61 6e 73 66 65 72 20 70 72 6f 68 69 62 69 74 65 64 20 28 69 6e 61 63 63 65 73 73 69 62 6c 65 20 53 50 29 00 00 00 (ss7_asp.c:1400)[0;m
[38;5;49m20251206125024695 [1;33mDLM3UA[0;m[38;5;49m [1;33mNOTICE[0;m[38;5;49m 0: ASP(asp-clnt-msc-0) Rx DUNA(transfer prohibited (inaccessible SP)) for 0.0.3/0 (xua_snm.c:501)[0;m
[38;5;43m20251206125024695 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: RT(dpc=3=0.0.3,mask=0x3fff=7.255.7,prio=5,via=as-clnt-A-0-m3ua,st=unavailable) changed to status 'unavailable' (ss7_route.c:409)[0;m
20251206125024695 [1;31mDLCS[0;m [1;31mERROR[0;m Unhandled SIGTRAN primitive N-PCSTATE.indication (lb.c:212)
[38;5;43m20251206125025695 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: T8: SP 2=0.0.2: Timeout (ss7_instance.c:858)[0;m
[38;5;43m20251206125025695 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: T8: SP 3=0.0.3: Timeout (ss7_instance.c:858)[0;m
MTC@538ec151fcde: talloc reports "struct bsc_subscr" x 1, expecting 0
MTC@538ec151fcde: talloc reports "struct gsm_subscriber_connection" x 0, expecting 0
MTC@538ec151fcde: count mismatch, retrying in 3.000000
FATAL: command execution failed
Command Close created at
at hudson.remoting.Command.<init>(Command.java:69)
at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1431)
at hudson.remoting.Channel.close(Channel.java:1610)
at hudson.remoting.Channel.close(Channel.java:1574)
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1437)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.Channel$OrderlyShutdown
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1438)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@1a00e8d8:build4-deb12build-ansible": Remote call on build4-deb12build-ansible failed. The channel is closing down or has closed down
at hudson.remoting.Channel.call(Channel.java:1105)
at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:306)
at jdk.proxy2/jdk.proxy2.$Proxy68.isAlive(Unknown Source)
at hudson.Launcher$RemoteLauncher$ProcImpl.isAlive(Launcher.java:1212)
at hudson.Launcher$RemoteLauncher$ProcImpl.join(Launcher.java:1204)
at hudson.tasks.CommandInterpreter.join(CommandInterpreter.java:195)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:145)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:92)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:818)
at hudson.model.Build$BuildExecution.build(Build.java:199)
at hudson.model.Build$BuildExecution.doRun(Build.java:164)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:527)
at hudson.model.Run.execute(Run.java:1833)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
at hudson.model.ResourceController.execute(ResourceController.java:101)
at hudson.model.Executor.run(Executor.java:446)
FATAL: Unable to delete script file /tmp/jenkins16343118924726714715.sh
Command Close created at
at hudson.remoting.Command.<init>(Command.java:69)
at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1431)
at hudson.remoting.Channel.close(Channel.java:1610)
at hudson.remoting.Channel.close(Channel.java:1574)
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1437)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.Channel$OrderlyShutdown
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1438)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@1a00e8d8:build4-deb12build-ansible": Remote call on build4-deb12build-ansible failed. The channel is closing down or has closed down
at hudson.remoting.Channel.call(Channel.java:1105)
at hudson.FilePath.act(FilePath.java:1207)
at hudson.FilePath.act(FilePath.java:1196)
at hudson.FilePath.delete(FilePath.java:1743)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:163)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:92)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:818)
at hudson.model.Build$BuildExecution.build(Build.java:199)
at hudson.model.Build$BuildExecution.doRun(Build.java:164)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:527)
at hudson.model.Run.execute(Run.java:1833)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
at hudson.model.ResourceController.execute(ResourceController.java:101)
at hudson.model.Executor.run(Executor.java:446)
Build step 'Execute shell' marked build as failure
ERROR: Step ‘Publish JUnit test result report’ failed: no workspace for ttcn3-bsc-test-latest #2631
1
1
07 Dec '25
See <https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-sns-latest/2475/disp…>
Changes:
------------------------------------------
[...truncated 504.78 KiB...]
[1;32m20251206124938344 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Use MCS2 (pcu_l1_if.cpp:858)[0;m
[1;32m20251206124938345 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Use MCS3 (pcu_l1_if.cpp:858)[0;m
[1;32m20251206124938345 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Use MCS4 (pcu_l1_if.cpp:858)[0;m
[1;32m20251206124938345 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Use MCS5 (pcu_l1_if.cpp:858)[0;m
[1;32m20251206124938345 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Use MCS6 (pcu_l1_if.cpp:858)[0;m
[1;32m20251206124938345 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Use MCS7 (pcu_l1_if.cpp:858)[0;m
[1;32m20251206124938345 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Use MCS8 (pcu_l1_if.cpp:858)[0;m
[1;32m20251206124938345 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Use MCS9 (pcu_l1_if.cpp:858)[0;m
[0;33m20251206124938345 [1;34mDRLCMAC[0;m[0;33m [1;34mDEBUG[0;m[0;33m New max MCS: DL=9 UL=9 (bts.cpp:1449)[0;m
[1;32m20251206124938345 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m initial_cs=2 (VTY forced, ignoring) (pcu_l1_if.cpp:863)[0;m
[1;32m20251206124938345 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m initial_mcs=1 (pcu_l1_if.cpp:868)[0;m
20251206124938345 [1;34mDLGLOBAL[0;m [1;34mDEBUG[0;m validating counter group 0x7f5ceef325a0(bssgp:bss_ctx) with 7 counters (rate_ctr.c:86)
20251206124938345 [1;34mDLGLOBAL[0;m [1;34mDEBUG[0;m validating counter group 0x55eacc3dc700(pcu:sgsn) with 2 counters (rate_ctr.c:86)
[1;32m20251206124938345 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m NS0 nsvci=1234 (pcu_l1_if.cpp:715)[0;m
MTC@bd095fb043ca: f_ns_exp() expecting { pDU_SNS_Size := { nsPduType := '12'O, nSEI_NS := { iEI := '04'O, ext := '1'B, lengthIndicator := { length1 := 2 }, nSEI := '04D2'O }, resetFlag := { iEI := '0A'O ("\n"), resetBIT := '1'B, spare := '0000000'B }, maxNumberOfNSVCs := { iEI := '07'O ("\a"), maxNumberOfNSVCs := ? }, numberOfIP4_Endpoints := ?, numberOfIP6_Endpoints := omit } }
[1;32m20251206124938345 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m NS0 address: r=127.0.0.1:23000<->l=NULL:22000 (pcu_l1_if.cpp:719)[0;m
[38;5;57m20251206124938345 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){UNCONFIGURED}: Allocated (fsm.c:456)[0;m
20251206124938345 [1;34mDLGLOBAL[0;m [1;34mDEBUG[0;m validating counter group 0x7f5ceef33140(ns:nse) with 15 counters (rate_ctr.c:86)
[38;5;57m20251206124938345 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){UNCONFIGURED}: Received Event REQ_ADD_BIND (gprs_ns2_sns.c:2680)[0;m
[38;5;57m20251206124938345 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){UNCONFIGURED}: Received Event REQ_SELECT_ENDPOINT (gprs_ns2_sns.c:2028)[0;m
[38;5;57m20251206124938345 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(01234) NS-STATUS.ind(bvci=00000): cause=NSE SNS no endpoints, transfer=0, first=1, mtu=0 (gprs_ns2.c:575)[0;m
[1;35m20251206124938345 [1;34mDPCU[0;m[1;35m [1;34mDEBUG[0;m[1;35m NS: indication Unknown affecting cause NSE SNS no endpoints / 6 from NS (gprs_bssgp_pcu.c:702)[0;m
[38;5;57m20251206124938345 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){UNCONFIGURED}: state_chg to UNCONFIGURED (gprs_ns2_sns.c:2240)[0;m
[38;5;57m20251206124938345 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){UNCONFIGURED}: Received Event REQ_SELECT_ENDPOINT (gprs_ns2_sns.c:2513)[0;m
[38;5;57m20251206124938345 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){UNCONFIGURED}: state_chg to BSS_SIZE (gprs_ns2_sns.c:2255)[0;m
20251206124938345 [1;34mDLGLOBAL[0;m [1;34mDEBUG[0;m validating counter group 0x7f5ceef33120(ns:nsvc) with 15 counters (rate_ctr.c:86)
[38;5;57m20251206124938345 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNCONFIGURED}: Allocated (fsm.c:456)[0;m
[38;5;63m20251206124938345 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx SNS-SIZE (reset=1, max_nr_nsvc=8192, num_ip4=1, num_ip6=-1) (gprs_ns2_message.c:807)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH(bts=0,trx=0,ts=7) Sending activate request (pcu_l1_if.cpp:165)[0;m
[0;33m20251206124938345 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=0,ts=7) PDCH state: disabled => enabled (pdch.cpp:171)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH (trx=0, ts=7): tsc=7, hopping=no (pcu_l1_if.cpp:959)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH(bts=0,trx=1,ts=7) Sending activate request (pcu_l1_if.cpp:165)[0;m
[0;33m20251206124938345 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=1,ts=7) PDCH state: disabled => enabled (pdch.cpp:171)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH (trx=1, ts=7): tsc=7, hopping=no (pcu_l1_if.cpp:959)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH(bts=0,trx=2,ts=7) Sending activate request (pcu_l1_if.cpp:165)[0;m
[0;33m20251206124938345 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=2,ts=7) PDCH state: disabled => enabled (pdch.cpp:171)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH (trx=2, ts=7): tsc=7, hopping=no (pcu_l1_if.cpp:959)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH(bts=0,trx=3,ts=7) Sending activate request (pcu_l1_if.cpp:165)[0;m
[0;33m20251206124938345 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=3,ts=7) PDCH state: disabled => enabled (pdch.cpp:171)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH (trx=3, ts=7): tsc=7, hopping=no (pcu_l1_if.cpp:959)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH(bts=0,trx=4,ts=7) Sending activate request (pcu_l1_if.cpp:165)[0;m
[0;33m20251206124938345 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=4,ts=7) PDCH state: disabled => enabled (pdch.cpp:171)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH (trx=4, ts=7): tsc=7, hopping=no (pcu_l1_if.cpp:959)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH(bts=0,trx=5,ts=7) Sending activate request (pcu_l1_if.cpp:165)[0;m
[0;33m20251206124938345 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=5,ts=7) PDCH state: disabled => enabled (pdch.cpp:171)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH (trx=5, ts=7): tsc=7, hopping=no (pcu_l1_if.cpp:959)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH(bts=0,trx=6,ts=7) Sending activate request (pcu_l1_if.cpp:165)[0;m
[0;33m20251206124938345 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=6,ts=7) PDCH state: disabled => enabled (pdch.cpp:171)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH (trx=6, ts=7): tsc=7, hopping=no (pcu_l1_if.cpp:959)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH(bts=0,trx=7,ts=7) Sending activate request (pcu_l1_if.cpp:165)[0;m
[0;33m20251206124938345 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=7,ts=7) PDCH state: disabled => enabled (pdch.cpp:171)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m PDCH (trx=7, ts=7): tsc=7, hopping=no (pcu_l1_if.cpp:959)[0;m
[1;32m20251206124938345 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m BTS model: osmo-bts-trx (pcu_l1_if.cpp:974)[0;m
MTC@bd095fb043ca: f_incoming_sns_config(idx=0)
MTC@bd095fb043ca: f_ns_exp() expecting { pDU_SNS_Config := { nsPduType := '0F'O, endFlag := { eBIT := '1'B, spare := '0000000'B }, nSEI_NS := { iEI := '04'O, ext := '1'B, lengthIndicator := { length1 := 2 }, nSEI := '04D2'O }, listofIP4Elements := { iEI := '05'O, ext := '1'B, lengthIndicator := { length1 := ? }, iP4_Elements := { { ipAddress := '7F000001'O, uDP_Port := '55F0'O, signallingWeight := ?, dataWeight := ? } } }, listofIP6Elements := omit } }
[38;5;63m20251206124938353 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx SNS-SIZE-ACK (gprs_ns2.c:1309)[0;m
[38;5;57m20251206124938353 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){BSS_SIZE}: NSEI=1234 Rx SNS PDU type SNS-SIZE-ACK (gprs_ns2_sns.c:2341)[0;m
[38;5;57m20251206124938353 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){BSS_SIZE}: Received Event RX_SIZE_ACK (gprs_ns2_sns.c:2349)[0;m
[38;5;57m20251206124938353 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){BSS_SIZE}: state_chg to BSS_CONFIG_BSS (gprs_ns2_sns.c:827)[0;m
[38;5;63m20251206124938353 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx SNS-CONFIG (end_flag=1, num_ip4=1, num_ip6=0) (gprs_ns2_message.c:713)[0;m
MTC@bd095fb043ca: f_outgoing_sns_config_1c1u(idx=0)
MTC@bd095fb043ca: f_ns_exp() expecting { pDU_SNS_Config_Ack := { nsPduType := '10'O, nSEI_NS := { iEI := '04'O, ext := '1'B, lengthIndicator := { length1 := 2 }, nSEI := '04D2'O }, causeNS := omit } }
[38;5;63m20251206124938356 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx SNS-CONFIG-ACK (gprs_ns2.c:1309)[0;m
[38;5;57m20251206124938356 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){BSS_CONFIG_BSS}: NSEI=1234 Rx SNS PDU type SNS-CONFIG-ACK (gprs_ns2_sns.c:2341)[0;m
[38;5;57m20251206124938356 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){BSS_CONFIG_BSS}: Received Event RX_CONFIG_ACK (gprs_ns2_sns.c:2358)[0;m
[38;5;57m20251206124938356 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){BSS_CONFIG_BSS}: state_chg to BSS_CONFIG_SGSN (gprs_ns2_sns.c:1059)[0;m
[38;5;63m20251206124938356 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx SNS-CONFIG (gprs_ns2.c:1309)[0;m
[38;5;57m20251206124938357 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){BSS_CONFIG_SGSN}: NSEI=1234 Rx SNS PDU type SNS-CONFIG (gprs_ns2_sns.c:2341)[0;m
[38;5;57m20251206124938357 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){BSS_CONFIG_SGSN}: Received Event RX_CONFIG_END (gprs_ns2_sns.c:2353)[0;m
[38;5;57m20251206124938357 [1;32mDLNS[0;m[38;5;57m [1;32mINFO[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){BSS_CONFIG_SGSN}: Rx SNS-CONFIG: Remote IPv4 list now 2 entries (gprs_ns2_sns.c:1126)[0;m
20251206124938357 [1;34mDLGLOBAL[0;m [1;34mDEBUG[0;m validating counter group 0x7f5ceef33120(ns:nsvc) with 15 counters (rate_ctr.c:86)
[38;5;57m20251206124938357 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNCONFIGURED}: Allocated (fsm.c:456)[0;m
[38;5;57m20251206124938357 [1;32mDLNS[0;m[38;5;57m [1;32mINFO[0;m[38;5;57m NSE(01234)-NSVC(none) Tx SNS-CONFIG-ACK (cause=NULL) (gprs_ns2_message.c:755)[0;m
[38;5;63m20251206124938357 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx SNS-CONFIG-ACK (gprs_ns2_message.c:757)[0;m
[38;5;57m20251206124938357 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNCONFIGURED}: Received Event REQ-START (gprs_ns2_vc_fsm.c:817)[0;m
[38;5;57m20251206124938357 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNCONFIGURED}: state_chg to UNBLOCKED (gprs_ns2_vc_fsm.c:278)[0;m
[38;5;57m20251206124938357 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(01234)-NSVC(none) NS-STATUS.ind(bvci=00000): cause=NSVC recovery, transfer=0, first=1, mtu=65523 (gprs_ns2.c:571)[0;m
[1;35m20251206124938357 [1;34mDPCU[0;m[1;35m [1;34mDEBUG[0;m[1;35m NS: indication Unknown affecting cause NSVC recovery / 1 from NS (gprs_bssgp_pcu.c:702)[0;m
[38;5;63m20251206124938357 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
[38;5;57m20251206124938357 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Starting Tns-alive of 3 seconds (gprs_ns2_vc_fsm.c:177)[0;m
[38;5;57m20251206124938357 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNCONFIGURED}: Received Event REQ-START (gprs_ns2_vc_fsm.c:817)[0;m
[38;5;57m20251206124938357 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNCONFIGURED}: state_chg to UNBLOCKED (gprs_ns2_vc_fsm.c:278)[0;m
[38;5;57m20251206124938357 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(01234) NS-STATUS.ind(bvci=00000): cause=NSE recovery, transfer=100, first=1, mtu=65523 (gprs_ns2.c:575)[0;m
[1;35m20251206124938357 [1;33mDPCU[0;m[1;35m [1;33mNOTICE[0;m[1;35m NS-NSE 1234 became available (gprs_bssgp_pcu.c:681)[0;m
[38;5;59m20251206124938357 [1;32mDLBSSGP[0;m[38;5;59m [1;32mINFO[0;m[38;5;59m Sending reset on BVCI 0 (gprs_bssgp_pcu.c:1045)[0;m
[38;5;59m20251206124938357 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m BSSGP (BVCI=0) Tx BVC-RESET CAUSE=O&M intervention (gprs_bssgp.c:124)[0;m
[38;5;61m20251206124938357 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Tx NS-UNITDATA (gprs_ns2_message.c:412)[0;m
[38;5;57m20251206124938357 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(01234)-NSVC(none) NS-STATUS.ind(bvci=00000): cause=NSVC recovery, transfer=100, first=0, mtu=65523 (gprs_ns2.c:571)[0;m
[1;35m20251206124938357 [1;34mDPCU[0;m[1;35m [1;34mDEBUG[0;m[1;35m NS: indication Unknown affecting cause NSVC recovery / 1 from NS (gprs_bssgp_pcu.c:702)[0;m
[38;5;63m20251206124938357 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
[38;5;57m20251206124938357 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNBLOCKED}: Starting Tns-alive of 3 seconds (gprs_ns2_vc_fsm.c:177)[0;m
[38;5;57m20251206124938357 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){BSS_CONFIG_SGSN}: state_chg to CONFIGURED (gprs_ns2_sns.c:1195)[0;m
[38;5;57m20251206124938357 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(01234) NS-STATUS.ind(bvci=00000): cause=NSE SNS configured, transfer=100, first=0, mtu=65523 (gprs_ns2.c:575)[0;m
[1;35m20251206124938357 [1;33mDPCU[0;m[1;35m [1;33mNOTICE[0;m[1;35m NS-NSE 1234 SNS configured. (gprs_bssgp_pcu.c:678)[0;m
[38;5;63m20251206124938359 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m
[38;5;57m20251206124938360 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m
[38;5;63m20251206124938361 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx NS-ALIVE (gprs_ns2.c:1309)[0;m
[38;5;57m20251206124938361 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Received Event RX-ALIVE (gprs_ns2_vc_fsm.c:957)[0;m
[38;5;63m20251206124938361 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE-ACK (gprs_ns2_message.c:193)[0;m
[38;5;63m20251206124938362 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m
[38;5;57m20251206124938362 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m
[38;5;63m20251206124938362 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx NS-ALIVE (gprs_ns2.c:1309)[0;m
[38;5;57m20251206124938362 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNBLOCKED}: Received Event RX-ALIVE (gprs_ns2_vc_fsm.c:957)[0;m
[38;5;63m20251206124938363 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE-ACK (gprs_ns2_message.c:193)[0;m
[38;5;63m20251206124948360 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
[38;5;63m20251206124948363 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
[38;5;63m20251206124948363 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m
[38;5;57m20251206124948363 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m
[38;5;63m20251206124948367 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m
[38;5;57m20251206124948367 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m
[38;5;63m20251206124958364 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
[38;5;63m20251206124958367 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
[38;5;63m20251206124958369 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m
[38;5;57m20251206124958369 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m
[38;5;63m20251206124958370 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m
[38;5;57m20251206124958370 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m
[38;5;59m20251206125008358 [1;32mDLBSSGP[0;m[38;5;59m [1;32mINFO[0;m[38;5;59m Sending reset on BVCI 0 (gprs_bssgp_pcu.c:1045)[0;m
[38;5;59m20251206125008358 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m BSSGP (BVCI=0) Tx BVC-RESET CAUSE=O&M intervention (gprs_bssgp.c:124)[0;m
[38;5;61m20251206125008358 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Tx NS-UNITDATA (gprs_ns2_message.c:412)[0;m
[38;5;61m20251206125008362 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Rx NS-UNITDATA (gprs_ns2.c:1311)[0;m
[38;5;57m20251206125008362 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m
[38;5;61m20251206125008362 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Rx NS-UNITDATA (gprs_ns2_vc_fsm.c:686)[0;m
[38;5;59m20251206125008362 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m rx BVCI_SIGNALLING gprs_bssgp_rx_sign (gprs_bssgp_pcu.c:562)[0;m
[38;5;59m20251206125008362 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m Rx BSSGP BVCI=0 (SIGN) BVC_RESET_ACK (gprs_bssgp_pcu.c:421)[0;m
[38;5;59m20251206125008362 [1;32mDLBSSGP[0;m[38;5;59m [1;32mINFO[0;m[38;5;59m Sending reset on BVCI 1234 (gprs_bssgp_pcu.c:1053)[0;m
[38;5;59m20251206125008362 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m BSSGP (BVCI=1234) Tx BVC-RESET CAUSE=O&M intervention (gprs_bssgp.c:124)[0;m
[38;5;61m20251206125008362 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Tx NS-UNITDATA (gprs_ns2_message.c:412)[0;m
[38;5;61m20251206125008363 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Rx NS-UNITDATA (gprs_ns2.c:1311)[0;m
[38;5;57m20251206125008363 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m
[38;5;61m20251206125008363 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Rx NS-UNITDATA (gprs_ns2_vc_fsm.c:686)[0;m
[38;5;59m20251206125008363 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m rx BVCI_SIGNALLING gprs_bssgp_rx_sign (gprs_bssgp_pcu.c:562)[0;m
[38;5;59m20251206125008363 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m Rx BSSGP BVCI=0 (SIGN) BVC_RESET_ACK (gprs_bssgp_pcu.c:421)[0;m
[38;5;59m20251206125008363 [1;32mDLBSSGP[0;m[38;5;59m [1;32mINFO[0;m[38;5;59m Sending unblock on BVCI 1234 (gprs_bssgp_pcu.c:1062)[0;m
[38;5;59m20251206125008363 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m BSSGP (BVCI=1234) Tx BVC-UNBLOCK (gprs_bssgp_bss.c:281)[0;m
[38;5;61m20251206125008363 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Tx NS-UNITDATA (gprs_ns2_message.c:412)[0;m
[38;5;61m20251206125008364 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Rx NS-UNITDATA (gprs_ns2.c:1311)[0;m
[38;5;57m20251206125008364 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m
[38;5;61m20251206125008364 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Rx NS-UNITDATA (gprs_ns2_vc_fsm.c:686)[0;m
[38;5;59m20251206125008364 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m rx BVCI_SIGNALLING gprs_bssgp_rx_sign (gprs_bssgp_pcu.c:562)[0;m
[38;5;59m20251206125008364 [1;33mDLBSSGP[0;m[38;5;59m [1;33mNOTICE[0;m[38;5;59m Rx BSSGP BVCI=0 (SIGN) BVC_UNBLOCK_ACK (gprs_bssgp_pcu.c:435)[0;m
[38;5;59m20251206125008364 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m Sending flow control info on BVCI 1234 (gprs_bssgp_pcu.c:1070)[0;m
[38;5;59m20251206125008364 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m Computed BVC leak rate = 59200, num_pdch = 8, cs = MCS-9 (gprs_bssgp_pcu.c:978)[0;m
[38;5;59m20251206125008364 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m Computed MS default leak rate = 29600, ms_num_pdch = 4, cs = MCS-9 (gprs_bssgp_pcu.c:1001)[0;m
[38;5;59m20251206125008364 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m Sending FLOW CONTROL BVC, Bmax = 592000, R = 59200, Bmax_MS = 296000, R_MS = 29600, avg_dly = 0 (gprs_bssgp_pcu.c:1029)[0;m
[38;5;61m20251206125008364 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Tx NS-UNITDATA (gprs_ns2_message.c:412)[0;m
MTC@bd095fb043ca: f_outgoing_sns_chg_weight(idx_chg=0)
[38;5;61m20251206125008365 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Rx NS-UNITDATA (gprs_ns2.c:1311)[0;m
[38;5;57m20251206125008365 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNBLOCKED}: Received Event RX-UNITDATA (gprs_ns2_vc_fsm.c:964)[0;m
[38;5;61m20251206125008365 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Rx NS-UNITDATA (gprs_ns2_vc_fsm.c:686)[0;m
[38;5;59m20251206125008365 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m rx BVCI_PTP=1234 gprs_bssgp_rx_ptp (gprs_bssgp_pcu.c:572)[0;m
[38;5;59m20251206125008365 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m Rx BSSGP BVCI=1234 (PTP) FLOW-CONTROL-BVC-ACK (gprs_bssgp_pcu.c:358)[0;m
MTC@bd095fb043ca: f_ns_exp() expecting { pDU_SNS_Ack := { nsPduType := '0C'O ("\f"), nSEI_NS := { iEI := '04'O, ext := '1'B, lengthIndicator := { length1 := 2 }, nSEI := '04D2'O }, transactionID := 25, causeNS := omit, iP_Address_NS := omit, listofIP4Elements := omit, listofIP6Elements := * } }
[38;5;63m20251206125008365 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx SNS-CHANGEWEIGHT (gprs_ns2.c:1309)[0;m
[38;5;57m20251206125008365 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){CONFIGURED}: NSEI=1234 Rx SNS PDU type SNS-CHANGEWEIGHT (gprs_ns2_sns.c:2341)[0;m
[38;5;57m20251206125008365 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){CONFIGURED}: Received Event RX_CHANGE_WEIGHT (gprs_ns2_sns.c:2367)[0;m
[38;5;57m20251206125008365 [1;32mDLNS[0;m[38;5;57m [1;32mINFO[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){CONFIGURED}: CHANGE-WEIGHT NS-VC udp)[0.0.0.0]:22000<>[127.0.0.1]:23000 data_weight 0->1, sig_weight 1->1 (gprs_ns2_sns.c:682)[0;m
[38;5;63m20251206125008365 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx SNS-ACK (trans_id=25, cause=NULL, num_ip4=0, num_ip6=0) (gprs_ns2_message.c:655)[0;m
MTC@bd095fb043ca: Start timer T: 1 s
[38;5;63m20251206125008369 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
[38;5;63m20251206125008370 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m
[38;5;57m20251206125008370 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m
[38;5;63m20251206125008371 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
[38;5;63m20251206125008371 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx NS-ALIVE-ACK (gprs_ns2.c:1309)[0;m
[38;5;57m20251206125008371 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNBLOCKED}: Received Event RX-ALIVE_ACK (gprs_ns2_vc_fsm.c:960)[0;m
MTC@bd095fb043ca: f_outgoing_sns_del(idx_del=1)
MTC@bd095fb043ca: f_ns_exp() expecting { pDU_SNS_Ack := { nsPduType := '0C'O ("\f"), nSEI_NS := { iEI := '04'O, ext := '1'B, lengthIndicator := { length1 := 2 }, nSEI := '04D2'O }, transactionID := 24, causeNS := omit, iP_Address_NS := omit, listofIP4Elements := { iEI := '05'O, ext := '1'B, lengthIndicator := { length1 := ? }, iP4_Elements := { { ipAddress := '7F000001'O, uDP_Port := '59D9'O, signallingWeight := '00'O, dataWeight := '01'O } } }, listofIP6Elements := * } }
[38;5;63m20251206125009371 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Rx SNS-DELETE (gprs_ns2.c:1309)[0;m
[38;5;57m20251206125009371 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){CONFIGURED}: NSEI=1234 Rx SNS PDU type SNS-DELETE (gprs_ns2_sns.c:2341)[0;m
[38;5;57m20251206125009371 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){CONFIGURED}: Received Event RX_DELETE (gprs_ns2_sns.c:2364)[0;m
[38;5;57m20251206125009371 [1;32mDLNS[0;m[38;5;57m [1;32mINFO[0;m[38;5;57m GPRS-NS2-SNS-BSS(NSE00000-SNS){CONFIGURED}: DELETE NS-VC udp)[0.0.0.0]:22000<>[127.0.0.1]:23001 (gprs_ns2_sns.c:729)[0;m
[38;5;57m20251206125009371 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(01234)-NSVC(none) NS-STATUS.ind(bvci=00000): cause=NSVC failure, transfer=100, first=0, mtu=65523 (gprs_ns2.c:571)[0;m
[1;35m20251206125009371 [1;34mDPCU[0;m[1;35m [1;34mDEBUG[0;m[1;35m NS: indication Unknown affecting cause NSVC failure / 0 from NS (gprs_bssgp_pcu.c:702)[0;m
[38;5;57m20251206125009371 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNBLOCKED}: Terminating (cause = OSMO_FSM_TERM_REQUEST) (gprs_ns2.c:656)[0;m
[38;5;57m20251206125009371 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNBLOCKED}: Freeing instance (gprs_ns2.c:656)[0;m
[38;5;57m20251206125009371 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23001){UNBLOCKED}: Deallocated (fsm.c:568)[0;m
[38;5;63m20251206125009371 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx SNS-ACK (trans_id=24, cause=NULL, num_ip4=1, num_ip6=0) (gprs_ns2_message.c:655)[0;m
MTC@bd095fb043ca: Start timer Tgrace: 1 s
MTC@bd095fb043ca: Start timer T: 20 s
[38;5;59m20251206125018365 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m Sending flow control info on BVCI 1234 (gprs_bssgp_pcu.c:1070)[0;m
[38;5;59m20251206125018365 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m Computed BVC leak rate = 59200, num_pdch = 8, cs = MCS-9 (gprs_bssgp_pcu.c:978)[0;m
[38;5;59m20251206125018365 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m Computed MS default leak rate = 29600, ms_num_pdch = 4, cs = MCS-9 (gprs_bssgp_pcu.c:1001)[0;m
[38;5;59m20251206125018365 [1;34mDLBSSGP[0;m[38;5;59m [1;34mDEBUG[0;m[38;5;59m Sending FLOW CONTROL BVC, Bmax = 592000, R = 59200, Bmax_MS = 296000, R_MS = 29600, avg_dly = 0 (gprs_bssgp_pcu.c:1029)[0;m
[38;5;61m20251206125018365 [1;32mDLNSDATA[0;m[38;5;61m [1;32mINFO[0;m[38;5;61m NSE(01234)-NSVC(none) Tx NS-UNITDATA (gprs_ns2_message.c:412)[0;m
[38;5;63m20251206125018370 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
[38;5;63m20251206125021371 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
[38;5;63m20251206125024372 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
FATAL: command execution failed
Command Close created at
at hudson.remoting.Command.<init>(Command.java:69)
at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1431)
at hudson.remoting.Channel.close(Channel.java:1610)
at hudson.remoting.Channel.close(Channel.java:1574)
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1437)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.Channel$OrderlyShutdown
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1438)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@1a00e8d8:build4-deb12build-ansible": Remote call on build4-deb12build-ansible failed. The channel is closing down or has closed down
at hudson.remoting.Channel.call(Channel.java:1105)
at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:306)
at jdk.proxy2/jdk.proxy2.$Proxy68.isAlive(Unknown Source)
at hudson.Launcher$RemoteLauncher$ProcImpl.isAlive(Launcher.java:1212)
at hudson.Launcher$RemoteLauncher$ProcImpl.join(Launcher.java:1204)
at hudson.tasks.CommandInterpreter.join(CommandInterpreter.java:195)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:145)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:92)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:818)
at hudson.model.Build$BuildExecution.build(Build.java:199)
at hudson.model.Build$BuildExecution.doRun(Build.java:164)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:527)
at hudson.model.Run.execute(Run.java:1833)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
at hudson.model.ResourceController.execute(ResourceController.java:101)
at hudson.model.Executor.run(Executor.java:446)
FATAL: Unable to delete script file /tmp/jenkins14878904733103157637.sh
Command Close created at
at hudson.remoting.Command.<init>(Command.java:69)
at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1431)
at hudson.remoting.Channel.close(Channel.java:1610)
at hudson.remoting.Channel.close(Channel.java:1574)
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1437)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.Channel$OrderlyShutdown
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1438)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@1a00e8d8:build4-deb12build-ansible": Remote call on build4-deb12build-ansible failed. The channel is closing down or has closed down
at hudson.remoting.Channel.call(Channel.java:1105)
at hudson.FilePath.act(FilePath.java:1207)
at hudson.FilePath.act(FilePath.java:1196)
at hudson.FilePath.delete(FilePath.java:1743)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:163)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:92)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:818)
at hudson.model.Build$BuildExecution.build(Build.java:199)
at hudson.model.Build$BuildExecution.doRun(Build.java:164)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:527)
at hudson.model.Run.execute(Run.java:1833)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
at hudson.model.ResourceController.execute(ResourceController.java:101)
at hudson.model.Executor.run(Executor.java:446)
Build step 'Execute shell' marked build as failure
ERROR: Step ‘Publish JUnit test result report’ failed: no workspace for ttcn3-pcu-test-sns-latest #2475
[38;5;63m20251206125027373 [1;32mDLNSSIGNAL[0;m[38;5;63m [1;32mINFO[0;m[38;5;63m NSE(01234)-NSVC(none) Tx NS-ALIVE (gprs_ns2_message.c:193)[0;m
1
1
07 Dec '25
See <https://jenkins.osmocom.org/jenkins/job/ttcn3-stp-test-latest/2211/display/…>
Changes:
------------------------------------------
[...truncated 3.45 MiB...]
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_DOWN}: Received Event ASPAS-ASP_INACTIVE.ind (xua_asp_fsm.c:405)[0;m
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_DOWN}: state_chg to AS_INACTIVE (xua_as_fsm.c:357)[0;m
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_INACTIVE}: Broadcasting NOTIFY Type State Change:AS Inactive () to all non-DOWN ASPs (xua_as_fsm.c:116)[0;m
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){WAIT_ASP_UP}: Received primitive M-ASP_UP.confirm (xua_default_lm_fsm.c:403)[0;m
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){WAIT_ASP_UP}: Received Event ASP-UP.conf (xua_default_lm_fsm.c:410)[0;m
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){WAIT_ASP_UP}: state_chg to WAIT_NOTIFY (xua_default_lm_fsm.c:182)[0;m
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(asp-client0) xua_cli_read_cb(): sctp_recvmsg() returned 24 (flags=0x0) (ss7_asp.c:1308)[0;m
[38;5;49m20251206124827773 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(asp-client0) Received M3UA Message (MGMT:NOTIFY) (m3ua.c:811)[0;m
[38;5;49m20251206124827773 [1;33mDLM3UA[0;m[38;5;49m [1;33mNOTICE[0;m[38;5;49m 0: ASP(asp-client0) Received NOTIFY Type State Change:AS Inactive () (m3ua.c:707)[0;m
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){WAIT_NOTIFY}: Received primitive M-NOTIFY.indication (xua_default_lm_fsm.c:403)[0;m
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){WAIT_NOTIFY}: Received Event NOTIFY.ind (xua_default_lm_fsm.c:410)[0;m
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){WAIT_NOTIFY}: state_chg to ACTIVE (xua_default_lm_fsm.c:258)[0;m
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_INACTIVE}: Received Event M-ASP_ACTIVE.req (xua_default_lm_fsm.c:259)[0;m
[38;5;43m20251206124827773 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(asp-client0) Tx 24 bytes: [L2]> 01 00 04 01 00 00 00 18 00 0b 00 08 00 00 00 02 00 06 00 08 00 00 04 1f (ss7_asp.c:1400)[0;m
MTC@030e1a54e5a2: [0] Answering M3UA BEAT { connId := 2, remName := "::ffff:127.0.0.1", remPort := 2906, locName := "::ffff:127.0.0.1", locPort := 10002, msg := { m3UA_BEAT := { version := '01'O, reserved := '00'O, messageClassAndType := '0303'O, messageLength := 8, messageParameters := { heartbeat_Data := omit } } } }
[38;5;43m20251206124827774 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(asp-client0) xua_cli_read_cb(): sctp_recvmsg() returned 8 (flags=0x0) (ss7_asp.c:1308)[0;m
[38;5;49m20251206124827774 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(asp-client0) Received M3UA Message (ASPSM:BEAT-ACK) (m3ua.c:811)[0;m
[38;5;43m20251206124827774 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_INACTIVE}: Received Event ASPSM_BEAT_ACK (m3ua.c:772)[0;m
[38;5;43m20251206124827774 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_INACTIVE}: Rx HEARTBEAT ACK (xua_asp_fsm.c:868)[0;m
MTC@030e1a54e5a2: setverdict(pass): pass -> pass, component reason not changed
MTC@030e1a54e5a2: Clearing M3UA...
[38;5;43m20251206124827978 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(asp-client0) xua_cli_read_cb(): sctp_recvmsg() returned 24 (flags=0x0) (ss7_asp.c:1308)[0;m
[38;5;49m20251206124827978 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(asp-client0) Received M3UA Message (ASPTM:ACTIVE-ACK) (m3ua.c:811)[0;m
[38;5;43m20251206124827978 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_INACTIVE}: Received Event ASPTM-ASP_AC_ACK (m3ua.c:772)[0;m
[38;5;43m20251206124827978 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_INACTIVE}: T(ack) stopped (xua_asp_fsm.c:420)[0;m
[38;5;43m20251206124827978 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_INACTIVE}: state_chg to ASP_ACTIVE (xua_asp_fsm.c:662)[0;m
[38;5;43m20251206124827978 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_INACTIVE}: Received Event ASPAS-ASP_ACTIVE.ind (xua_asp_fsm.c:405)[0;m
[38;5;43m20251206124827978 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_INACTIVE}: state_chg to AS_ACTIVE (xua_as_fsm.c:565)[0;m
[38;5;43m20251206124827978 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_ACTIVE}: Broadcasting NOTIFY Type State Change:AS Active () to all non-DOWN ASPs (xua_as_fsm.c:116)[0;m
[38;5;43m20251206124827978 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){ACTIVE}: Received primitive M-ASP_ACTIVE.confirm (xua_default_lm_fsm.c:403)[0;m
[38;5;43m20251206124827978 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m xua_default_lm(asp-client0){ACTIVE}: Ignoring primitive M-ASP_ACTIVE.confirm (xua_default_lm_fsm.c:406)[0;m
[38;5;43m20251206124827978 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(asp-client0) xua_cli_read_cb(): sctp_recvmsg() returned 24 (flags=0x0) (ss7_asp.c:1308)[0;m
[38;5;49m20251206124827978 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(asp-client0) Received M3UA Message (MGMT:NOTIFY) (m3ua.c:811)[0;m
[38;5;49m20251206124827978 [1;33mDLM3UA[0;m[38;5;49m [1;33mNOTICE[0;m[38;5;49m 0: ASP(asp-client0) Received NOTIFY Type State Change:AS Active () (m3ua.c:707)[0;m
[38;5;43m20251206124827979 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){ACTIVE}: Received primitive M-NOTIFY.indication (xua_default_lm_fsm.c:403)[0;m
[38;5;43m20251206124827979 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){ACTIVE}: Received Event NOTIFY.ind (xua_default_lm_fsm.c:410)[0;m
MTC@030e1a54e5a2: setverdict(pass): pass -> pass reason: "M3UA cleared", component reason not changed
20251206124830276 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:47714<->l=127.0.0.1:4239 (telnet_interface.c:138)
[38;5;23m20251206124830276 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m asp-client0 NOTIFICATION SHUTDOWN_EVENT flags=0x0 (stream.c:348)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(asp-client0) xua_cli_read_cb(): sctp_recvmsg() returned 160 (flags=0x80) (ss7_asp.c:1308)[0;m
[38;5;43m20251206124830276 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: ASP(asp-client0) xUA CLNT SCTP NOTIFICATION 32773 flags=0x0 (ss7_asp.c:998)[0;m
[38;5;43m20251206124830276 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: ASP(asp-client0) xUA CLNT SHUTDOWN_EVENT (ss7_asp.c:1021)[0;m
[38;5;23m20251206124830276 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m asp-client0 NOTIFICATION ASSOC_CHANGE flags=0x0 SHUTDOWN_COMP (stream.c:348)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(asp-client0) xua_cli_read_cb(): sctp_recvmsg() returned 168 (flags=0x80) (ss7_asp.c:1308)[0;m
[38;5;43m20251206124830276 [1;32mDLSS7[0;m[38;5;43m [1;32mINFO[0;m[38;5;43m 0: ASP(asp-client0) xUA CLNT SCTP NOTIFICATION 32769 flags=0x0 (ss7_asp.c:998)[0;m
[38;5;43m20251206124830276 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: ASP(asp-client0) xUA CLNT SCTP_ASSOC_CHANGE: SHUTDOWN_COMP (ss7_asp.c:1006)[0;m
[38;5;23m20251206124830276 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m CLICONN(asp-client0,r=::1:10002<->l=::ffff:127.0.0.1:2906){CONNECTED} connection closed with srv (stream_cli.c:631)[0;m
[38;5;23m20251206124830276 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m CLICONN(asp-client0,r=::1:10002<->l=::ffff:127.0.0.1:2906){CONNECTED} close() (stream_cli.c:179)[0;m
[38;5;43m20251206124830276 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: ASP(asp-client0) disconnect_cb() from lower layers, reconnecting (ss7_asp.c:1248)[0;m
[38;5;43m20251206124830276 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: ASP(asp-client0) Closing and reconnecting ASP (ss7_asp.c:1238)[0;m
[38;5;23m20251206124830276 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m CLICONN(asp-client0,r=::1:10002<->l=::ffff:127.0.0.1:2906){CLOSED} close() (stream_cli.c:179)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_ACTIVE}: Received Event SCTP-COMM_DOWN.ind (ss7_asp.c:1230)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_ACTIVE}: state_chg to ASP_DOWN (xua_asp_fsm.c:859)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_DOWN}: T(beat) stopped (xua_asp_fsm.c:429)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_ACTIVE}: Received Event ASPAS-ASP_DOWN.ind (xua_asp_fsm.c:405)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_ACTIVE}: state_chg to AS_PENDING (xua_as_fsm.c:592)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_PENDING}: Broadcasting NOTIFY Type State Change:AS Pending () to all non-DOWN ASPs (xua_as_fsm.c:116)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){ACTIVE}: Received primitive M-ASP_DOWN.indication (xua_default_lm_fsm.c:403)[0;m
[38;5;43m20251206124830276 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m xua_default_lm(asp-client0){ACTIVE}: Ignoring primitive M-ASP_DOWN.indication (xua_default_lm_fsm.c:406)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){ACTIVE}: Received primitive M-SCTP_RELEASE.indication (xua_default_lm_fsm.c:403)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){ACTIVE}: Received Event SCTP-RELEASE.ind (xua_default_lm_fsm.c:410)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){ACTIVE}: state_chg to IDLE (xua_default_lm_fsm.c:324)[0;m
[38;5;23m20251206124830276 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m CLICONN(asp-client0,r=::1:10002<->l=::ffff:127.0.0.1:2906){CLOSED} close() (stream_cli.c:179)[0;m
[38;5;23m20251206124830276 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m CLICONN(asp-client0,r=::1:10002<->l=::ffff:127.0.0.1:2906){WAIT_RECONNECT} retrying reconnect in 5 seconds... (stream_cli.c:244)[0;m
[38;5;23m20251206124830276 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m CLICONN(asp-client0,r=::1:10002<->l=::ffff:127.0.0.1:2906){WAIT_RECONNECT} retrying reconnect in 5 seconds... (stream_cli.c:244)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(asp-client0) xua_cli_read_cb(): sctp_recvmsg() returned 0 (flags=0x0) (ss7_asp.c:1308)[0;m
[38;5;43m20251206124830276 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m 0: ASP(asp-client0) Closing and reconnecting ASP (ss7_asp.c:1238)[0;m
[38;5;23m20251206124830276 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m CLICONN(asp-client0,r=::1:10002<->l=::ffff:127.0.0.1:2906){WAIT_RECONNECT} close() (stream_cli.c:179)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_DOWN}: Received Event SCTP-COMM_DOWN.ind (ss7_asp.c:1230)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_DOWN}: state_chg to ASP_DOWN (xua_asp_fsm.c:859)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_ASP(asp-client0){ASP_DOWN}: T(beat) stopped (xua_asp_fsm.c:429)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_PENDING}: Received Event ASPAS-ASP_DOWN.ind (xua_asp_fsm.c:405)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){IDLE}: Received primitive M-ASP_DOWN.indication (xua_default_lm_fsm.c:403)[0;m
[38;5;43m20251206124830276 [1;33mDLSS7[0;m[38;5;43m [1;33mNOTICE[0;m[38;5;43m xua_default_lm(asp-client0){IDLE}: Ignoring primitive M-ASP_DOWN.indication (xua_default_lm_fsm.c:406)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){IDLE}: Received primitive M-SCTP_RELEASE.indication (xua_default_lm_fsm.c:403)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){IDLE}: Received Event SCTP-RELEASE.ind (xua_default_lm_fsm.c:410)[0;m
[38;5;43m20251206124830276 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m xua_default_lm(asp-client0){IDLE}: state_chg to IDLE (xua_default_lm_fsm.c:324)[0;m
[38;5;23m20251206124830276 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m CLICONN(asp-client0,r=::1:10002<->l=::ffff:127.0.0.1:2906){CLOSED} close() (stream_cli.c:179)[0;m
MTC@030e1a54e5a2: Setting final verdict of the test case.
MTC@030e1a54e5a2: Local verdict of MTC: pass
MTC@030e1a54e5a2: No PTCs were created.
MTC@030e1a54e5a2: Test case TC_clnt_asp_act_tmt_loadshare finished. Verdict: pass
MTC@030e1a54e5a2: Starting external command `/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/ttcn3-tcpdump-stop.sh STP_Tests_M3UA.TC_clnt_asp_act_tmt_loadshare pass'.
[38;5;23m20251206124830276 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m CLICONN(asp-client0,r=::1:10002<->l=::ffff:127.0.0.1:2906){WAIT_RECONNECT} retrying reconnect in 5 seconds... (stream_cli.c:244)[0;m
Sat Dec 6 12:48:30 UTC 2025
[1;32m====== STP_Tests_M3UA.TC_clnt_asp_act_tmt_loadshare pass ======[0m
Saving talloc report from 127.0.0.1:4239 to STP_Tests_M3UA.TC_clnt_asp_act_tmt_loadshare.talloc
20251206124830301 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Accept()ed new telnet connection r=127.0.0.1:47722<->l=127.0.0.1:4239 (telnet_interface.c:192)
20251206124830904 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:47722<->l=127.0.0.1:4239 (telnet_interface.c:138)
Waiting for packet dumper to finish... 0 (prev_count=-1, count=35024)
[38;5;23m20251206124831297 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m CLICONN(asp-client61-norctx0,r=::1:11061<->l=::ffff:127.0.0.1:2907){WAIT_RECONNECT} reconnecting (stream_cli.c:1352)[0;m
[38;5;23m20251206124831297 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m CLICONN(asp-client60-norctx0,r=::1:11060<->l=::ffff:127.0.0.1:2907){WAIT_RECONNECT} reconnecting (stream_cli.c:1352)[0;m
[38;5;23m20251206124831297 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m CLICONN(asp-client61-norctx0,r=::1:11061<->l=::ffff:127.0.0.1:2907){CONNECTING} connect failed (-111) (stream_cli.c:424)[0;m
[38;5;23m20251206124831297 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m CLICONN(asp-client61-norctx0,r=::1:11061<->l=::ffff:127.0.0.1:2907){CONNECTING} close() (stream_cli.c:179)[0;m
[38;5;23m20251206124831297 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m CLICONN(asp-client61-norctx0,r=::1:11061<->l=::ffff:127.0.0.1:2907){WAIT_RECONNECT} retrying reconnect in 5 seconds... (stream_cli.c:244)[0;m
[38;5;23m20251206124831297 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m CLICONN(asp-client60-norctx0,r=::1:11060<->l=::ffff:127.0.0.1:2907){CONNECTING} connect failed (-111) (stream_cli.c:424)[0;m
[38;5;23m20251206124831297 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m CLICONN(asp-client60-norctx0,r=::1:11060<->l=::ffff:127.0.0.1:2907){CONNECTING} close() (stream_cli.c:179)[0;m
[38;5;23m20251206124831297 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m CLICONN(asp-client60-norctx0,r=::1:11060<->l=::ffff:127.0.0.1:2907){WAIT_RECONNECT} retrying reconnect in 5 seconds... (stream_cli.c:244)[0;m
Waiting for packet dumper to finish... 1 (prev_count=35024, count=38372)
[38;5;43m20251206124832277 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_PENDING}: Received Event AS-T_REC_EXPD.ind (xua_as_fsm.c:349)[0;m
[38;5;43m20251206124832278 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_PENDING}: T(r) expired; dropping queued messages (xua_as_fsm.c:665)[0;m
[38;5;43m20251206124832278 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(as-client){AS_PENDING}: state_chg to AS_DOWN (xua_as_fsm.c:675)[0;m
MTC@030e1a54e5a2: External command `/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/ttcn3-tcpdump-stop.sh STP_Tests_M3UA.TC_clnt_asp_act_tmt_loadshare pass' was executed successfully (exit status: 0).
MC@030e1a54e5a2: Test execution finished.
Execution of [EXECUTE] section finished.
emtc
MC@030e1a54e5a2: Terminating MTC.
MC@030e1a54e5a2: MTC terminated.
MC2> exit
MC@030e1a54e5a2: Shutting down session.
MC@030e1a54e5a2: Shutdown complete.
Comparing expected results '/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/stp/expected-results.xml' against results in 'junit-xml-650.log'
--------------------
[1;32mpass[0;m STP_Tests_M3UA.TC_connect_asp_up
[1;32mpass[0;m STP_Tests_M3UA.TC_beat
[1;32mpass[0;m STP_Tests_M3UA.TC_beat_payload
[1;32mpass[0;m STP_Tests_M3UA.TC_beat_timeout
[1;32mpass[0;m STP_Tests_M3UA.TC_asp_act
[1;32mpass[0;m STP_Tests_M3UA.TC_asp_act_override
[1;32mpass[0;m STP_Tests_M3UA.TC_asp_act_loadshare
[1;32mpass[0;m STP_Tests_M3UA.TC_asp_act_broadcast
[1;32mpass[0;m STP_Tests_M3UA.TC_tmt_override
[1;32mpass[0;m STP_Tests_M3UA.TC_tmt_loadshare_roundrobin
[1;32mpass[0;m STP_Tests_M3UA.TC_tmt_loadshare_sls
[1;32mpass[0;m STP_Tests_M3UA.TC_tmt_broadcast
[1;32mpass[0;m STP_Tests_M3UA.TC_act_rctx_data_no_rctx
[1;32mpass[0;m STP_Tests_M3UA.TC_m3ua_sctp_srv_adm_shutdown
[1;32mpass[0;m STP_Tests_M3UA.TC_combinedlset_loadshare
[1;32mpass[0;m STP_Tests_M3UA.TC_inaccessible_sp_duna
[1;32mpass[0;m STP_Tests_M3UA.TC_inaccessible_sp_duna2
[1;32mpass[0;m STP_Tests_M3UA.TC_rkm_reg_static_notpermitted
[1;32mpass[0;m STP_Tests_M3UA.TC_rkm_reg_static_permitted
[1;32mpass[0;m STP_Tests_M3UA.TC_rkm_reg_dynamic_permitted
[1;32mpass[0;m STP_Tests_M3UA.TC_rkm_unreg_never_registered
[1;32mpass[0;m STP_Tests_M3UA.TC_rkm_unreg_invalid
[1;32mpass[0;m STP_Tests_M3UA.TC_rkm_unreg_registered
[1;32mpass[0;m STP_Tests_M3UA.TC_rkm_unreg_active
[1;32mpass[0;m STP_Tests_M3UA.TC_dyn_asp_as_rkm_permitted
[1;32mpass[0;m STP_Tests_M3UA.TC_dyn_2asp_as_rkm_permitted
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_connect_asp_up
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_beat_timeout
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_asp_act
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_sg_to_asp
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_asp_to_sg
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_sg_to_asp_norctx
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_asp_to_sg_norctx
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_quirk_no_notify_asp_act
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_no_daud_in_asp
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_quirk_daud_in_asp
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_no_snm_inactive
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_quirk_snm_inactive
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_sctp_adm_shutdown
[1;32mpass[0;m STP_Tests_M3UA.TC_ssnm_aspac_dava_aspia_duna
[1;32mpass[0;m STP_Tests_M3UA.TC_ssnm_distribution_dava_duna
[1;32mpass[0;m STP_Tests_M3UA.TC_ssnm_distribution_dava_duna_multipc
[1;32mpass[0;m STP_Tests_M3UA.TC_ssnm_distribution_dupu
[1;32mpass[0;m STP_Tests_M3UA.TC_ssnm_distribution_scon
[1;32mpass[0;m STP_Tests_M3UA.TC_clnt_asp_act_tmt_loadshare
Summary:
[1;32mpass[0;m: 45
[1;34mskip[0;m: 39
[0;94m[testenv][m3ua] Testsuite is done[0m
[1;34m[testenv][m3ua] Stopping testsuite (3093911)[0m
[1;34m[testenv][m3ua] Merging log files[0m
[0;94m[testenv][m3ua] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache', '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=/opt/eclipse-titan-11.1.0/bin:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts/qemu:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/stp:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-e', 'BUILDDIR=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache/podman/titan-11.1.0-debian-trixie', '-e', 'TTCN3_DIR=/opt/eclipse-titan-11.1.0', '-t', '-w', '/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/logs/m3ua/testsuite', 'testenv-stp-all-osmocom-latest-20251206-1238-45e3b039-3', 'sh', '-c', '/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/log_merge.sh STP_Tests --rm >/dev/null'][0m
[1;34m[testenv][m3ua] Formatting log files[0m
[0;94m[testenv][m3ua] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache', '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=/opt/eclipse-titan-11.1.0/bin:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts/qemu:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/stp:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-e', 'BUILDDIR=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache/podman/titan-11.1.0-debian-trixie', '-e', 'TTCN3_DIR=/opt/eclipse-titan-11.1.0', '-t', '-w', '/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/logs/m3ua/testsuite', 'testenv-stp-all-osmocom-latest-20251206-1238-45e3b039-3', 'sh', '-c', '/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts/log_format.sh'][0m
[1;34m[testenv][m3ua] Stopping stp (3093831)[0m
[1;34m[testenv] Stopping podman container (restart)[0m
[0;94m[testenv] + ['podman', 'kill', 'testenv-stp-all-osmocom-latest-20251206-1238-45e3b039-3'][0m
testenv-stp-all-osmocom-latest-20251206-1238-45e3b039-3
[0;94m[testenv] + ['podman', 'run', '--rm', '--name', 'testenv-stp-all-osmocom-latest-20251206-1238-45e3b039-4', '--log-driver', 'json-file', '--log-opt', 'path=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/logs/podman/testenv-stp-all-osmocom-latest-20251206-1238-45e3b039-4.log', '--security-opt=seccomp=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/podman/seccomp.json', '--cap-add=NET_ADMIN', '--cap-add=NET_RAW', '--cap-add=SYS_ADMIN', '--device=/dev/net/tun', '--volume', '/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache/podman/var-cache-apt-debian-trixie:/var/cache/apt', '--volume', '/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache/podman/var-lib-apt-debian-trixie:/var/lib/apt', '--sysctl', 'net.ipv4.conf.all.send_redirects=0', '--sysctl', 'net.ipv4.conf.default.send_redirects=0', '-e', 'PODMAN=1', '-e', 'TESTENV_BINARY_REPO=1', '--volume', '/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/logs:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/logs', '--volume', '/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache', '--volume', '/home/osmocom-build/ccache/testenv:/home/osmocom-build/ccache/testenv', '--volume', '/home/osmocom-build/jenkins/workspace:/home/osmocom-build/jenkins/workspace', 'debian-trixie-osmo-ttcn3-testenv', '/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts/testenv-podman-main.sh'][0m
[0;94m[testenv] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache', '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts/qemu:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/stp:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-stp-all-osmocom-latest-20251206-1238-45e3b039-4', 'rm', '/etc/apt/apt.conf.d/docker-clean'][0m
Running testenv-podman-main.sh
[0;94m[testenv][tcap] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache', '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts/qemu:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/stp:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-stp-all-osmocom-latest-20251206-1238-45e3b039-4', 'sh', '-c', "echo 'deb [signed-by=/obs.key] https://downloads.osmocom.org/packages/osmocom:/latest/Debian_13/ ./' > /etc/apt/sources.list.d/osmocom.list"][0m
[0;94m[testenv][tcap] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache', '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts/qemu:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/stp:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-stp-all-osmocom-latest-20251206-1238-45e3b039-4', 'sh', '-c', 'echo \'Package: *\nPin: origin "downloads.osmocom.org"\nPin-Priority: 1100\n\' > /etc/apt/preferences.d/osmocom-apt-pin'][0m
[0;94m[testenv] feed_watchdog_loop: podman container has stopped[0m
[0;94m[testenv][tcap] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_cache', '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/_testenv/data/scripts/qemu:/home/osmocom-build/jenkins/workspace/ttcn3-stp-test-latest/stp:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-stp-all-osmocom-latest-20251206-1238-45e3b039-4', 'apt-get', '-q', 'update'][0m
Ign:1 http://deb.debian.org/debian trixie InRelease
Ign:2 https://downloads.osmocom.org/packages/osmocom:/latest/Debian_13 ./ InRelease
Ign:3 http://deb.debian.org/debian trixie-updates InRelease
Ign:2 https://downloads.osmocom.org/packages/osmocom:/latest/Debian_13 ./ InRelease
FATAL: command execution failed
Command Close created at
at hudson.remoting.Command.<init>(Command.java:69)
at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1431)
at hudson.remoting.Channel.close(Channel.java:1610)
at hudson.remoting.Channel.close(Channel.java:1574)
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1437)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.Channel$OrderlyShutdown
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1438)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@1a00e8d8:build4-deb12build-ansible": Remote call on build4-deb12build-ansible failed. The channel is closing down or has closed down
at hudson.remoting.Channel.call(Channel.java:1105)
at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:306)
at jdk.proxy2/jdk.proxy2.$Proxy68.isAlive(Unknown Source)
at hudson.Launcher$RemoteLauncher$ProcImpl.isAlive(Launcher.java:1212)
at hudson.Launcher$RemoteLauncher$ProcImpl.join(Launcher.java:1204)
at hudson.tasks.CommandInterpreter.join(CommandInterpreter.java:195)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:145)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:92)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:818)
at hudson.model.Build$BuildExecution.build(Build.java:199)
at hudson.model.Build$BuildExecution.doRun(Build.java:164)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:527)
at hudson.model.Run.execute(Run.java:1833)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
at hudson.model.ResourceController.execute(ResourceController.java:101)
at hudson.model.Executor.run(Executor.java:446)
FATAL: Unable to delete script file /tmp/jenkins5406105115446944055.sh
Command Close created at
at hudson.remoting.Command.<init>(Command.java:69)
at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1431)
at hudson.remoting.Channel.close(Channel.java:1610)
at hudson.remoting.Channel.close(Channel.java:1574)
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1437)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.Channel$OrderlyShutdown
at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1438)
at hudson.remoting.Channel$1.handle(Channel.java:664)
at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@1a00e8d8:build4-deb12build-ansible": Remote call on build4-deb12build-ansible failed. The channel is closing down or has closed down
at hudson.remoting.Channel.call(Channel.java:1105)
at hudson.FilePath.act(FilePath.java:1207)
at hudson.FilePath.act(FilePath.java:1196)
at hudson.FilePath.delete(FilePath.java:1743)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:163)
at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:92)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:818)
at hudson.model.Build$BuildExecution.build(Build.java:199)
at hudson.model.Build$BuildExecution.doRun(Build.java:164)
at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.java:527)
at hudson.model.Run.execute(Run.java:1833)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
at hudson.model.ResourceController.execute(ResourceController.java:101)
at hudson.model.Executor.run(Executor.java:446)
Build step 'Execute shell' marked build as failure
ERROR: Step ‘Publish JUnit test result report’ failed: no workspace for ttcn3-stp-test-latest #2211
1
1
07 Dec '25
See <https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-asan/545/display/red…>
Changes:
------------------------------------------
[...truncated 3.81 MiB...]
<testcase classname='BTS_Tests_LAPDm' name='TC_sabm_ua_dcch_sapi3' time='15.044041'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1476 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:162 TC_sabm_ua_dcch_sapi3 testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_sabm_ua_dcch_sapi4' time='15.041911'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1477 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:167 TC_sabm_ua_dcch_sapi4 testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_sabm_contention' time='15.044046'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1478 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:201 TC_sabm_contention testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_sabm_retransmit' time='15.045209'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1479 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:225 TC_sabm_retransmit testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_sabm_retransmit_bts' time='15.041034'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1480 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:315 TC_sabm_retransmit_bts testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_sabm_invalid_resp' time='15.042782'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1481 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:379 TC_sabm_invalid_resp testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_sabm_dm' time='15.032082'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1482 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:425 TC_sabm_dm testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_establish_ign_first_sabm' time='15.047105'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1483 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:488 TC_establish_ign_first_sabm testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_iframe_seq_and_ack' time='15.041580'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1484 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:579 TC_iframe_seq_and_ack testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_iframe_timer_recovery' time='15.042800'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1485 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:685 TC_iframe_timer_recovery testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_ns_seq_error' time='15.042353'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1486 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:768 TC_ns_seq_error testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_nr_seq_error' time='15.047139'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1487 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:831 TC_nr_seq_error testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_rec_invalid_frame' time='15.038759'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1488 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:961 TC_rec_invalid_frame testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_segm_concat_dcch' time='15.041615'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1489 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1088 TC_segm_concat_dcch testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_segm_concat_sacch' time='15.043223'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1490 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1093 TC_segm_concat_sacch testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_t200_n200' time='15.042608'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1491 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1182 TC_t200_n200 testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_rr_response_frame_loss' time='15.045552'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1492 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1239 TC_rr_response_frame_loss testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_incorrect_cr' time='15.032206'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1493 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1293 TC_incorrect_cr testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_sabm_incorrect_c' time='15.044653'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1494 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1341 TC_sabm_incorrect_c testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_normal_reestablishment' time='15.039553'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1495 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1403 TC_normal_reestablishment testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_LAPDm' name='TC_normal_reestablishment_state_unacked' time='15.041025'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_LAPDm.ttcn:1496 BTS_Tests_LAPDm control part
BTS_Tests_LAPDm.ttcn:1470 TC_normal_reestablishment_state_unacked testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_act_vff' time='15.043931'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:316 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:210 TC_vamos_chan_act_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_act_vhh' time='15.041600'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:317 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:224 TC_vamos_chan_act_vhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_act_hvhh' time='15.041395'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:318 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:234 TC_vamos_chan_act_hvhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_act_dyn_ipa_vff' time='15.033826'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:319 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:214 TC_vamos_chan_act_dyn_ipa_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_act_dyn_osmo_vff' time='15.044674'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:320 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:218 TC_vamos_chan_act_dyn_osmo_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_act_dyn_osmo_vhh' time='15.041463'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:321 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:228 TC_vamos_chan_act_dyn_osmo_vhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_act_dyn_osmo_hvhh' time='15.045549'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:322 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:238 TC_vamos_chan_act_dyn_osmo_hvhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_mode_modify_vff' time='15.043275'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:325 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:283 TC_vamos_chan_mode_modify_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_mode_modify_vhh' time='15.037884'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:326 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:297 TC_vamos_chan_mode_modify_vhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_mode_modify_hvhh' time='15.044323'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:327 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:307 TC_vamos_chan_mode_modify_hvhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_mode_modify_dyn_ipa_vff' time='15.042868'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:328 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:287 TC_vamos_chan_mode_modify_dyn_ipa_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_mode_modify_dyn_osmo_vff' time='15.043660'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:329 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:291 TC_vamos_chan_mode_modify_dyn_osmo_vff testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_mode_modify_dyn_osmo_vhh' time='15.045165'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:330 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:301 TC_vamos_chan_mode_modify_dyn_osmo_vhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_VAMOS' name='TC_vamos_chan_mode_modify_dyn_osmo_hvhh' time='15.041450'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_VAMOS.ttcn:331 BTS_Tests_VAMOS control part
BTS_Tests_VAMOS.ttcn:311 TC_vamos_chan_mode_modify_dyn_osmo_hvhh testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_ASCI' name='TC_vbs_notification' time='15.045165'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_ASCI.ttcn:422 BTS_Tests_ASCI control part
BTS_Tests_ASCI.ttcn:83 TC_vbs_notification testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_ASCI' name='TC_vgcs_uplink_free_and_busy' time='15.042902'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_ASCI.ttcn:423 BTS_Tests_ASCI control part
BTS_Tests_ASCI.ttcn:190 TC_vgcs_uplink_free_and_busy testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_ASCI' name='TC_vgcs_talker_fail' time='15.044363'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_ASCI.ttcn:424 BTS_Tests_ASCI control part
BTS_Tests_ASCI.ttcn:289 TC_vgcs_talker_fail testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_ASCI' name='TC_vgcs_talker_est_rel' time='15.045903'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_ASCI.ttcn:425 BTS_Tests_ASCI control part
BTS_Tests_ASCI.ttcn:333 TC_vgcs_talker_est_rel testcase
</failure>
</testcase>
<testcase classname='BTS_Tests_ASCI' name='TC_vgcs_listener_det' time='15.044006'>
<failure type='fail-verdict'>"BTS_Tests.ttcn:291 : Timeout waiting for RSL bring up"
BTS_Tests_ASCI.ttcn:426 BTS_Tests_ASCI control part
BTS_Tests_ASCI.ttcn:411 TC_vgcs_listener_det testcase
</failure>
</testcase>
</testsuite>
+ RC=1
+ uptime
+ grep --color=always -o load.*
[01;31m[Kload average: 0.17, 0.17, 1.04[m[K
+ exit 1
Build step 'Execute shell' marked build as failure
Recording test results
[Checks API] No suitable checks publisher found.
1
0