Build failed in Jenkins: ttcn3-bsc-test #3275

6 Jul 2026


      See https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test/3275/display/redirect
Changes:
------------------------------------------
[...truncated 27.26 MiB...]
[38;5;43m20260706094406470 [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:573)[0;m
[38;5;43m20260706094406470 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc0-0) Tx 100 bytes: [L2]> 01 00 01 01 00 00 00 64 02 10 00 51 00 00 00 bb 00 00 00 b9 03 00 00 00 01 00 00 cc 02 02 06 04 43 b9 00 fe 04 04 43 bb 00 fe 0f 2c 00 2a 57 05 08 00 00 f1 10 00 01 00 00 17 12 05 08 02 00 f1 10 17 2a 52 08 09 10 10 00 00 00 00 10 7d 09 80 82 83 04 57 81 84 04 07 00 00 00 00 00 06 00 08 00 00 00 01  (ss7_asp.c:1431)[0;m
VirtMSC-SCCP(2604)@8ee29efc7f92: First idle individual index:0
VirtMSC-SCCP(2604)@8ee29efc7f92: Warning: Stopping inactive timer T_ias[0].
VirtMSC-RAN(2606)@8ee29efc7f92: ExpectedCreateCallback completeLayer3Information
VirtMSC-RAN(2606)@8ee29efc7f92: Found Expect[0] for '05080200F110172A52080910100000000010'O handled at TC_mscpool_no_allow_attach_round_robin(2630)
VirtMSC-RAN(2606)@8ee29efc7f92: Added conn table entry 0TC_mscpool_no_allow_attach_round_robin(2630)4454629
VirtMSC-SCCP(2604)@8ee29efc7f92: Session index based on connection ID:0
VirtMSC-SCCP(2604)@8ee29efc7f92: Warning: Re-starting timer T_ias[0], which is already active (running or expired).
[38;5;43m20260706094406482 [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 44 (flags=0x0) (ss7_asp.c:1138)[0;m
[38;5;49m20260706094406482 [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:823)[0;m
[38;5;49m20260706094406482 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc0-0) m3ua_rx_xfer (m3ua.c:611)[0;m
[38;5;49m20260706094406482 [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:642)[0;m
[38;5;43m20260706094406482 [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;43m20260706094406482 [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:261)[0;m
[38;5;43m20260706094406482 [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 via AS bsc0 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20260706094406482 [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;43m20260706094406482 [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:573)[0;m
[38;5;43m20260706094406482 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 36 bytes: [L2]> 01 00 01 01 00 00 00 24 02 10 00 19 00 00 00 b9 00 00 00 bb 03 00 00 00 02 00 00 cc b3 e9 2d 02 00 00 00 00  (ss7_asp.c:1431)[0;m
TC_mscpool_no_allow_attach_round_robin(2630)@8ee29efc7f92: "received expected Complete Layer 3 Info at MSC"
20260706094406485 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): received expected Complete Layer 3 Info at MSC (logging_vty.c:1266)
TC_mscpool_no_allow_attach_round_robin(2630)@8ee29efc7f92: rx exp_l3_compl = { discriminator := '0'B, spare := '0000000'B, dlci := omit, lengthIndicator := 42, pdu := { bssmap := { completeLayer3Information := { messageType := '57'O ("W"), cellIdentifier := { elementIdentifier := '05'O, lengthIndicator := 8, cellIdentifierDiscriminator := '0000'B, spare1_4 := '0000'B, cellIdentification := { cI_CGI := { mcc_mnc := '00F110'O, lac := '0001'O, ci := '0000'O } } }, layer3Information := { elementIdentifier := '17'O, lengthIndicator := 18, layer3info := '05080200F110172A52080910100000000010'O }, chosenChannel := omit, lSAIdentifier := omit, aPDU := omit, codecList := { elementIdentifier := '7D'O ("}"), lengthIndicator := 9, codecElements := { { codecType := GSM_FR (0), tF := '0'B, pT := '0'B, pI := '0'B, fI := '1'B, extendedCodecType := omit, s0_7 := omit, s8_15 := omit }, { codecType := GSM_EFR (2), tF := '0'B, pT := '0'B, pI := '0'B, fI := '1'B, extendedCodecType := omit, s0_7 := omit, s8_15 := omit }, { codecType := FR_AMR (3), tF := '0'B, pT := '0'B, pI := '0'B, fI := '1'B, extendedCodecType := omit, s0_7 := '00000100'B, s8_15 := '01010111'B }, { codecType := GSM_HR (1), tF := '0'B, pT := '0'B, pI := '0'B, fI := '1'B, extendedCodecType := omit, s0_7 := omit, s8_15 := omit }, { codecType := HR_AMR (4), tF := '0'B, pT := '0'B, pI := '0'B, fI := '1'B, extendedCodecType := omit, s0_7 := '00000100'B, s8_15 := '00000111'B } } }, redirectAttemptFlag := omit, sendSequenceNumber := omit, iMSI := omit } } } }
TC_mscpool_no_allow_attach_round_robin(2630)@8ee29efc7f92: "MSC instructs BSC to clear channel"
20260706094406486 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): MSC instructs BSC to clear channel (logging_vty.c:1266)
VirtMSC-SCCP(2604)@8ee29efc7f92: Session index based on connection ID:0
VirtMSC-SCCP(2604)@8ee29efc7f92: vl_len:6
VirtMSC-SCCP(2604)@8ee29efc7f92: vl_from0
VirtMSC-SCCP(2604)@8ee29efc7f92: data sent by MTP3_SCCP_PORT: '000420040100'O
[38;5;43m20260706094406685 [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 48 (flags=0x0) (ss7_asp.c:1138)[0;m
[38;5;49m20260706094406685 [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:823)[0;m
[38;5;49m20260706094406685 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc0-0) m3ua_rx_xfer (m3ua.c:611)[0;m
[38;5;49m20260706094406685 [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:642)[0;m
[38;5;43m20260706094406685 [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;43m20260706094406685 [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:261)[0;m
[38;5;43m20260706094406685 [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 via AS bsc0 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20260706094406685 [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;43m20260706094406685 [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:573)[0;m
[38;5;43m20260706094406685 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 40 bytes: [L2]> 01 00 01 01 00 00 00 28 02 10 00 1d 00 00 00 b9 00 00 00 bb 03 00 00 00 06 00 00 cc 00 01 06 00 04 20 04 01 00 00 00 00  (ss7_asp.c:1431)[0;m
[38;5;43m20260706094406686 [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 36 (flags=0x0) (ss7_asp.c:1138)[0;m
[38;5;49m20260706094406686 [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:823)[0;m
[38;5;49m20260706094406686 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer (m3ua.c:611)[0;m
[38;5;49m20260706094406686 [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=0 (m3ua.c:642)[0;m
[38;5;43m20260706094406686 [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;43m20260706094406686 [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=0 -> eSLS=32: use Normal Route via 'virt-msc0' (ss7_combined_linkset.c:261)[0;m
[38;5;43m20260706094406686 [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;43m20260706094406686 [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;43m20260706094406686 [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:573)[0;m
[38;5;43m20260706094406686 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc0-0) Tx 44 bytes: [L2]> 01 00 01 01 00 00 00 2c 02 10 00 1a 00 00 00 bb 00 00 00 b9 03 00 00 00 06 b3 e9 2d 00 01 03 00 01 21 00 00 00 06 00 08 00 00 00 01  (ss7_asp.c:1431)[0;m
VirtMSC-SCCP(2604)@8ee29efc7f92: Session index based on local reference:0
VirtMSC-SCCP(2604)@8ee29efc7f92: DT1 will be put to the reassembly buffer
VirtMSC-SCCP(2604)@8ee29efc7f92: DT1 data has been put to the reassembly buffer
VirtMSC-SCCP(2604)@8ee29efc7f92: DT1/segmentingReassembl/more==0 received=> send ASP_SCCP_N_DATA comes
TC_mscpool_no_allow_attach_round_robin(2630)@8ee29efc7f92: "Got BSSMAP Clear Complete"
20260706094406691 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): Got BSSMAP Clear Complete (logging_vty.c:1266)
VirtMSC-RAN(2606)@8ee29efc7f92: Deleted conn table entry 0TC_mscpool_no_allow_attach_round_robin(2630)4454629
VirtMSC-SCCP(2604)@8ee29efc7f92: Session index based on connection ID:0
[38;5;43m20260706094406698 [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 44 (flags=0x0) (ss7_asp.c:1138)[0;m
[38;5;49m20260706094406698 [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:823)[0;m
[38;5;49m20260706094406698 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc0-0) m3ua_rx_xfer (m3ua.c:611)[0;m
[38;5;49m20260706094406698 [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:642)[0;m
[38;5;43m20260706094406698 [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;43m20260706094406698 [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:261)[0;m
[38;5;43m20260706094406698 [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 via AS bsc0 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20260706094406698 [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;43m20260706094406698 [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:573)[0;m
[38;5;43m20260706094406698 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 36 bytes: [L2]> 01 00 01 01 00 00 00 24 02 10 00 19 00 00 00 b9 00 00 00 bb 03 00 00 00 04 00 00 cc b3 e9 2d 00 00 00 00 00  (ss7_asp.c:1431)[0;m
TC_mscpool_no_allow_attach_round_robin(2630)@8ee29efc7f92: "Got RSL RR Release"
[38;5;43m20260706094406699 [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 32 (flags=0x0) (ss7_asp.c:1138)[0;m
[38;5;49m20260706094406699 [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:823)[0;m
[38;5;49m20260706094406699 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer (m3ua.c:611)[0;m
[38;5;49m20260706094406699 [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=0 (m3ua.c:642)[0;m
[38;5;43m20260706094406699 [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;43m20260706094406699 [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=0 -> eSLS=32: use Normal Route via 'virt-msc0' (ss7_combined_linkset.c:261)[0;m
[38;5;43m20260706094406699 [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;43m20260706094406699 [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;43m20260706094406699 [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:573)[0;m
[38;5;43m20260706094406699 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc0-0) Tx 40 bytes: [L2]> 01 00 01 01 00 00 00 28 02 10 00 17 00 00 00 bb 00 00 00 b9 03 00 00 00 05 b3 e9 2d 00 00 cc 00 00 06 00 08 00 00 00 01  (ss7_asp.c:1431)[0;m
20260706094406699 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): Got RSL RR Release (logging_vty.c:1266)
VirtMSC-SCCP(2604)@8ee29efc7f92: Session index based on local reference:0
VirtMSC-SCCP(2604)@8ee29efc7f92: RLC received in state:disconnect_pending 
TC_mscpool_no_allow_attach_round_robin(2630)@8ee29efc7f92: "Got RSL Deact SACCH"
20260706094406700 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): Got RSL Deact SACCH (logging_vty.c:1266)
TC_mscpool_no_allow_attach_round_robin(2630)@8ee29efc7f92: "Got RSL RF Chan Rel, sending Rel Ack"
20260706094408691 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): Got RSL RF Chan Rel, sending Rel Ack (logging_vty.c:1266)
TC_mscpool_no_allow_attach_round_robin(2630)@8ee29efc7f92: setverdict(pass): none -> pass
TC_mscpool_no_allow_attach_round_robin(2630)@8ee29efc7f92: Final verdict of PTC: pass
MTC@8ee29efc7f92: verifying msc rate counters: { { { name := "mscpool:subscr:new", val := 1 }, { name := "mscpool:subscr:known", val := 0 }, { name := "mscpool:subscr:reattach", val := 0 }, { name := "mscpool:subscr:attach_lost", val := 0 }, { name := "mscpool:subscr:paged", val := 0 } }, { { name := "mscpool:subscr:new", val := 0 }, { name := "mscpool:subscr:known", val := 0 }, { name := "mscpool:subscr:reattach", val := 0 }, { name := "mscpool:subscr:attach_lost", val := 0 }, { name := "mscpool:subscr:paged", val := 0 } }, { { name := "mscpool:subscr:new", val := 0 }, { name := "mscpool:subscr:known", val := 0 }, { name := "mscpool:subscr:reattach", val := 0 }, { name := "mscpool:subscr:attach_lost", val := 0 }, { name := "mscpool:subscr:paged", val := 0 } } }
MTC@8ee29efc7f92: setverdict(pass): none -> pass
MTC@8ee29efc7f92: setverdict(pass): pass -> pass, component reason not changed
MTC@8ee29efc7f92: setverdict(pass): pass -> pass, component reason not changed
MTC@8ee29efc7f92: "TC_mscpool_no_allow_attach_round_robin": using IMSI '001012821592862'H
TC_mscpool_no_allow_attach_round_robin(2631)@8ee29efc7f92: "establish channel, send Complete Layer 3 Info"
20260706094409744 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): establish channel, send Complete Layer 3 Info (logging_vty.c:1266)
VirtMSC-RAN(2612)@8ee29efc7f92: f_create_expect(l3 := '05240103505902080910100000000020'O, n_connectPointCode := omit
VirtMSC-RAN(2612)@8ee29efc7f92: Created Expect[0] for '05240103505902080910100000000020'O to be handled at TC_mscpool_no_allow_attach_round_robin(2631)
TC_mscpool_no_allow_attach_round_robin(2631)@8ee29efc7f92: "expect BSSAP Complete Layer 3 Info at MSC"
20260706094409753 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): expect BSSAP Complete Layer 3 Info at MSC (logging_vty.c:1266)
[38;5;43m20260706094409754 [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 88 (flags=0x0) (ss7_asp.c:1138)[0;m
[38;5;49m20260706094409754 [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:823)[0;m
[38;5;49m20260706094409754 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer (m3ua.c:611)[0;m
[38;5;49m20260706094409754 [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=1 (m3ua.c:642)[0;m
[38;5;43m20260706094409754 [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;43m20260706094409754 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[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=1 -> eSLS=113: use Normal Route via 'virt-msc2' (ss7_combined_linkset.c:261)[0;m
[38;5;43m20260706094409754 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: Found route for dpc=3=0.0.3: pc=3=0.0.3 mask=0x3fff=7.255.7 prio=5 via AS virt-msc2 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20260706094409754 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: rt->dest.as proto is M3UA for dpc=3=0.0.3 (mtp3_hmrt.c:90)[0;m
[38;5;43m20260706094409754 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(virt-msc2){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:573)[0;m
[38;5;43m20260706094409754 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc2-0) Tx 96 bytes: [L2]> 01 00 01 01 00 00 00 60 02 10 00 4f 00 00 00 bb 00 00 00 03 03 00 00 01 01 00 00 cd 02 02 06 04 43 03 00 fe 04 04 43 bb 00 fe 0f 2a 00 28 57 05 08 00 00 f1 10 00 01 00 01 17 10 05 24 01 03 50 59 02 08 09 10 10 00 00 00 00 20 7d 09 80 81 82 83 a5 57 84 2d 07 00 00 00 06 00 08 00 00 00 03  (ss7_asp.c:1431)[0;m
VirtMSC-SCCP(2610)@8ee29efc7f92: First idle individual index:0
VirtMSC-SCCP(2610)@8ee29efc7f92: Warning: Stopping inactive timer T_ias[0].
VirtMSC-RAN(2612)@8ee29efc7f92: ExpectedCreateCallback completeLayer3Information
VirtMSC-RAN(2612)@8ee29efc7f92: Found Expect[0] for '05240103505902080910100000000020'O handled at TC_mscpool_no_allow_attach_round_robin(2631)
VirtMSC-RAN(2612)@8ee29efc7f92: Added conn table entry 0TC_mscpool_no_allow_attach_round_robin(2631)9899321
VirtMSC-SCCP(2610)@8ee29efc7f92: Session index based on connection ID:0
VirtMSC-SCCP(2610)@8ee29efc7f92: Warning: Re-starting timer T_ias[0], which is already active (running or expired).
[38;5;43m20260706094409757 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc2-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 44 (flags=0x0) (ss7_asp.c:1138)[0;m
[38;5;49m20260706094409757 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc2-0) Received M3UA Message (XFER:DATA) (m3ua.c:823)[0;m
[38;5;49m20260706094409757 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc2-0) m3ua_rx_xfer (m3ua.c:611)[0;m
[38;5;49m20260706094409757 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc2-0) m3ua_rx_xfer(): M3UA data header: opc=3=0.0.3 dpc=187=0.23.3 sls=0 (m3ua.c:642)[0;m
[38;5;43m20260706094409757 [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;43m20260706094409757 [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=0 -> eSLS=112: use Normal Route via 'bsc0' (ss7_combined_linkset.c:261)[0;m
[38;5;43m20260706094409757 [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 via AS bsc0 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20260706094409757 [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;43m20260706094409757 [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:573)[0;m
[38;5;43m20260706094409757 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 36 bytes: [L2]> 01 00 01 01 00 00 00 24 02 10 00 19 00 00 00 03 00 00 00 bb 03 00 00 00 02 00 00 cd 7c 9d fb 02 00 00 00 00  (ss7_asp.c:1431)[0;m
TC_mscpool_no_allow_attach_round_robin(2631)@8ee29efc7f92: "received expected Complete Layer 3 Info at MSC"
20260706094409758 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): received expected Complete Layer 3 Info at MSC (logging_vty.c:1266)
TC_mscpool_no_allow_attach_round_robin(2631)@8ee29efc7f92: rx exp_l3_compl = { discriminator := '0'B, spare := '0000000'B, dlci := omit, lengthIndicator := 40, pdu := { bssmap := { completeLayer3Information := { messageType := '57'O ("W"), cellIdentifier := { elementIdentifier := '05'O, lengthIndicator := 8, cellIdentifierDiscriminator := '0000'B, spare1_4 := '0000'B, cellIdentification := { cI_CGI := { mcc_mnc := '00F110'O, lac := '0001'O, ci := '0001'O } } }, layer3Information := { elementIdentifier := '17'O, lengthIndicator := 16, layer3info := '05240103505902080910100000000020'O }, chosenChannel := omit, lSAIdentifier := omit, aPDU := omit, codecList := { elementIdentifier := '7D'O ("}"), lengthIndicator := 9, codecElements := { { codecType := GSM_FR (0), tF := '0'B, pT := '0'B, pI := '0'B, fI := '1'B, extendedCodecType := omit, s0_7 := omit, s8_15 := omit }, { codecType := GSM_HR (1), tF := '0'B, pT := '0'B, pI := '0'B, fI := '1'B, extendedCodecType := omit, s0_7 := omit, s8_15 := omit }, { codecType := GSM_EFR (2), tF := '0'B, pT := '0'B, pI := '0'B, fI := '1'B, extendedCodecType := omit, s0_7 := omit, s8_15 := omit }, { codecType := FR_AMR (3), tF := '0'B, pT := '0'B, pI := '0'B, fI := '1'B, extendedCodecType := omit, s0_7 := '10100101'B, s8_15 := '01010111'B }, { codecType := HR_AMR (4), tF := '0'B, pT := '0'B, pI := '0'B, fI := '1'B, extendedCodecType := omit, s0_7 := '00101101'B, s8_15 := '00000111'B } } }, redirectAttemptFlag := omit, sendSequenceNumber := omit, iMSI := omit } } } }
TC_mscpool_no_allow_attach_round_robin(2631)@8ee29efc7f92: "MSC instructs BSC to clear channel"
20260706094409758 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): MSC instructs BSC to clear channel (logging_vty.c:1266)
VirtMSC-SCCP(2610)@8ee29efc7f92: Session index based on connection ID:0
VirtMSC-SCCP(2610)@8ee29efc7f92: vl_len:6
VirtMSC-SCCP(2610)@8ee29efc7f92: vl_from0
VirtMSC-SCCP(2610)@8ee29efc7f92: data sent by MTP3_SCCP_PORT: '000420040100'O
[38;5;43m20260706094409961 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc2-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 48 (flags=0x0) (ss7_asp.c:1138)[0;m
[38;5;49m20260706094409961 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc2-0) Received M3UA Message (XFER:DATA) (m3ua.c:823)[0;m
[38;5;49m20260706094409961 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc2-0) m3ua_rx_xfer (m3ua.c:611)[0;m
[38;5;49m20260706094409961 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc2-0) m3ua_rx_xfer(): M3UA data header: opc=3=0.0.3 dpc=187=0.23.3 sls=0 (m3ua.c:642)[0;m
[38;5;43m20260706094409961 [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;43m20260706094409961 [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=0 -> eSLS=112: use Normal Route via 'bsc0' (ss7_combined_linkset.c:261)[0;m
[38;5;43m20260706094409961 [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 via AS bsc0 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20260706094409961 [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;43m20260706094409961 [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:573)[0;m
[38;5;43m20260706094409961 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 40 bytes: [L2]> 01 00 01 01 00 00 00 28 02 10 00 1d 00 00 00 03 00 00 00 bb 03 00 00 00 06 00 00 cd 00 01 06 00 04 20 04 01 00 00 00 00  (ss7_asp.c:1431)[0;m
[38;5;43m20260706094409962 [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 36 (flags=0x0) (ss7_asp.c:1138)[0;m
[38;5;49m20260706094409962 [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:823)[0;m
[38;5;49m20260706094409962 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer (m3ua.c:611)[0;m
[38;5;49m20260706094409962 [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=1 (m3ua.c:642)[0;m
[38;5;43m20260706094409962 [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;43m20260706094409962 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[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=1 -> eSLS=113: use Normal Route via 'virt-msc2' (ss7_combined_linkset.c:261)[0;m
[38;5;43m20260706094409962 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: Found route for dpc=3=0.0.3: pc=3=0.0.3 mask=0x3fff=7.255.7 prio=5 via AS virt-msc2 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20260706094409962 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: rt->dest.as proto is M3UA for dpc=3=0.0.3 (mtp3_hmrt.c:90)[0;m
[38;5;43m20260706094409962 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(virt-msc2){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:573)[0;m
[38;5;43m20260706094409962 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc2-0) Tx 44 bytes: [L2]> 01 00 01 01 00 00 00 2c 02 10 00 1a 00 00 00 bb 00 00 00 03 03 00 00 01 06 7c 9d fb 00 01 03 00 01 21 00 00 00 06 00 08 00 00 00 03  (ss7_asp.c:1431)[0;m
VirtMSC-SCCP(2610)@8ee29efc7f92: Session index based on local reference:0
VirtMSC-SCCP(2610)@8ee29efc7f92: DT1 will be put to the reassembly buffer
VirtMSC-SCCP(2610)@8ee29efc7f92: DT1 data has been put to the reassembly buffer
VirtMSC-SCCP(2610)@8ee29efc7f92: DT1/segmentingReassembl/more==0 received=> send ASP_SCCP_N_DATA comes
TC_mscpool_no_allow_attach_round_robin(2631)@8ee29efc7f92: "Got BSSMAP Clear Complete"
20260706094409967 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): Got BSSMAP Clear Complete (logging_vty.c:1266)
VirtMSC-RAN(2612)@8ee29efc7f92: Deleted conn table entry 0TC_mscpool_no_allow_attach_round_robin(2631)9899321
VirtMSC-SCCP(2610)@8ee29efc7f92: Session index based on connection ID:0
[38;5;43m20260706094409973 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc2-0) ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 44 (flags=0x0) (ss7_asp.c:1138)[0;m
[38;5;49m20260706094409973 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc2-0) Received M3UA Message (XFER:DATA) (m3ua.c:823)[0;m
[38;5;49m20260706094409973 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc2-0) m3ua_rx_xfer (m3ua.c:611)[0;m
[38;5;49m20260706094409973 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(virt-msc2-0) m3ua_rx_xfer(): M3UA data header: opc=3=0.0.3 dpc=187=0.23.3 sls=0 (m3ua.c:642)[0;m
[38;5;43m20260706094409973 [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;43m20260706094409973 [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=0 -> eSLS=112: use Normal Route via 'bsc0' (ss7_combined_linkset.c:261)[0;m
[38;5;43m20260706094409973 [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 via AS bsc0 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20260706094409973 [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;43m20260706094409973 [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:573)[0;m
[38;5;43m20260706094409973 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(bsc0-0) Tx 36 bytes: [L2]> 01 00 01 01 00 00 00 24 02 10 00 19 00 00 00 03 00 00 00 bb 03 00 00 00 04 00 00 cd 7c 9d fb 00 00 00 00 00  (ss7_asp.c:1431)[0;m
[38;5;43m20260706094409974 [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 32 (flags=0x0) (ss7_asp.c:1138)[0;m
[38;5;49m20260706094409974 [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:823)[0;m
[38;5;49m20260706094409974 [1;34mDLM3UA[0;m[38;5;49m [1;34mDEBUG[0;m[38;5;49m 0: ASP(bsc0-0) m3ua_rx_xfer (m3ua.c:611)[0;m
[38;5;49m20260706094409974 [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=1 (m3ua.c:642)[0;m
[38;5;43m20260706094409974 [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;43m20260706094409974 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[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=1 -> eSLS=113: use Normal Route via 'virt-msc2' (ss7_combined_linkset.c:261)[0;m
[38;5;43m20260706094409974 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: Found route for dpc=3=0.0.3: pc=3=0.0.3 mask=0x3fff=7.255.7 prio=5 via AS virt-msc2 proto=m3ua (mtp3_hmrt.c:80)[0;m
[38;5;43m20260706094409974 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: rt->dest.as proto is M3UA for dpc=3=0.0.3 (mtp3_hmrt.c:90)[0;m
[38;5;43m20260706094409974 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m XUA_AS(virt-msc2){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:573)[0;m
[38;5;43m20260706094409974 [1;34mDLSS7[0;m[38;5;43m [1;34mDEBUG[0;m[38;5;43m 0: ASP(virt-msc2-0) Tx 40 bytes: [L2]> 01 00 01 01 00 00 00 28 02 10 00 17 00 00 00 bb 00 00 00 03 03 00 00 01 05 7c 9d fb 00 00 cd 00 00 06 00 08 00 00 00 03  (ss7_asp.c:1431)[0;m
20260706094409975 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): Got RSL RR Release (logging_vty.c:1266)
VirtMSC-SCCP(2610)@8ee29efc7f92: Session index based on local reference:0
VirtMSC-SCCP(2610)@8ee29efc7f92: RLC received in state:disconnect_pending 
TC_mscpool_no_allow_attach_round_robin(2631)@8ee29efc7f92: "Got RSL RR Release"
20260706094409976 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): Got RSL Deact SACCH (logging_vty.c:1266)
TC_mscpool_no_allow_attach_round_robin(2631)@8ee29efc7f92: "Got RSL Deact SACCH"
FATAL: command execution failed
Command Close created at
    at hudson.remoting.Command.<init>(Command.java:69)
    at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1424)
    at hudson.remoting.Channel.close(Channel.java:1603)
    at hudson.remoting.Channel.close(Channel.java:1567)
    at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1430)
    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:1431)
    at hudson.remoting.Channel$1.handle(Channel.java:664)
    at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:86)
Caused: java.io.IOException: Backing channel 'build4-deb12build-ansible' is disconnected.
    at hudson.remoting.RemoteInvocationHandler.channelOrFail(RemoteInvocationHandler.java:227)
    at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:306)
    at jdk.proxy2/jdk.proxy2.$Proxy137.isAlive(Unknown Source)
    at hudson.Launcher$RemoteLauncher$ProcImpl.isAlive(Launcher.java:1227)
    at hudson.Launcher$RemoteLauncher$ProcImpl.join(Launcher.java:1219)
    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:817)
    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:526)
    at hudson.model.Run.execute(Run.java:1842)
    at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
    at hudson.model.ResourceController.execute(ResourceController.java:97)
    at hudson.model.Executor.run(Executor.java:456)
FATAL: Unable to delete script file /tmp/jenkins13121464716733630775.sh
Command Close created at
    at hudson.remoting.Command.<init>(Command.java:69)
    at hudson.remoting.Channel$CloseCommand.<init>(Channel.java:1424)
    at hudson.remoting.Channel.close(Channel.java:1603)
    at hudson.remoting.Channel.close(Channel.java:1567)
    at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1430)
    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:1431)
    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@6d51c2c0: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:1101)
    at hudson.FilePath.act(FilePath.java:1220)
    at hudson.FilePath.act(FilePath.java:1209)
    at hudson.FilePath.delete(FilePath.java:1756)
    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:817)
    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:526)
    at hudson.model.Run.execute(Run.java:1842)
    at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:44)
    at hudson.model.ResourceController.execute(ResourceController.java:97)
    at hudson.model.Executor.run(Executor.java:456)
Build step 'Execute shell' marked build as failure
ERROR: Step ‘Publish JUnit test result report’ failed: no workspace for ttcn3-bsc-test #3275

2026

2025

2024

2023

2022

2021

2020

2019

Build failed in Jenkins: ttcn3-bsc-test #3275