- jenkins-notifications - lists.osmocom.org

Build failed in Jenkins: ttcn3-gbproxy-test-fr #1985
by jenkins＠lists.osmocom.org 29 Apr '26

29 Apr '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-gbproxy-test-fr/1985/display/…> Changes: ------------------------------------------ [...truncated 1.92 MiB...] TC_paging_ps_sig_rac(2391)@1379cdb918a5: setverdict(pass): pass -> pass, component reason not changed GbProxy_Test-BSSGP(SGSN[0])-BVCI20011(2334)@1379cdb918a5: Removing Client IMSI='262420000000000'H, index=0 GbProxy_Test-BSSGP(SGSN[1])-BVCI20011(2346)@1379cdb918a5: Removing Client IMSI='262420000000000'H, index=0 GbProxy_Test-BSSGP(PCU[0])-BVCI20011(2358)@1379cdb918a5: Removing Client IMSI='262420000000000'H, index=0 GbProxy_Test-BSSGP(PCU[1])-BVCI20021(2373)@1379cdb918a5: Removing Client IMSI='262420000000000'H, index=0 GbProxy_Test-BSSGP(PCU[2])-BVCI20032(2386)@1379cdb918a5: Removing Client IMSI='262420000000000'H, index=0 MTC@1379cdb918a5: f_gen_tmsi(suffix:=1000, nri_v:=4, nri_bitlen:=5, base_tmsi:='42000023'O) -> prefix:='01000010'B, suffix:='0000000010000001011'B, total_bits:='01000010001000000000010000001011'B == '4220040B'O MTC@1379cdb918a5: Starting "TC_paging_ps_sig_rac" for SGSN[1], NRI=4, P-TMSI='4220040B'O, TLLI='C220040B'O, IMSI='262420000001000'H on component=TC_paging_ps_sig_rac(2392) GbProxy_Test-BSSGP(PCU[0])-BVCI20011(2358)@1379cdb918a5: Adding Client=TC_paging_ps_sig_rac(2392), IMSI='262420000001000'H, TLLI='C220040B'O, index=1 GbProxy_Test-BSSGP(PCU[1])-BVCI20021(2373)@1379cdb918a5: Adding Client=TC_paging_ps_sig_rac(2392), IMSI='262420000001000'H, TLLI='C220040B'O, index=1 GbProxy_Test-BSSGP(PCU[2])-BVCI20031(2382)@1379cdb918a5: Adding Client=TC_paging_ps_sig_rac(2392), IMSI='262420000001000'H, TLLI='C220040B'O, index=1 GbProxy_Test-BSSGP(SGSN[0])-BVCI20011(2334)@1379cdb918a5: Adding Client=TC_paging_ps_sig_rac(2392), IMSI='262420000001000'H, TLLI='C220040B'O, index=1 GbProxy_Test-BSSGP(SGSN[1])-BVCI20011(2346)@1379cdb918a5: Adding Client=TC_paging_ps_sig_rac(2392), IMSI='262420000001000'H, TLLI='C220040B'O, index=1 GbProxy_Test-BSSGP(PCU[0])(2356)@1379cdb918a5: Rx on SIG BVCI without PTP BVCI: broadcasting GbProxy_Test-BSSGP(PCU[0])-BVCI20011(2358)@1379cdb918a5: No TLLI: Broadcasting { bssgp := { pDU_BSSGP_PAGING_PS := { bssgpPduType := '06'O, iMSI := { iEI := '0D'O ("\r"), ext := '1'B, lengthIndicator := { length1 := 8 }, type_of_Identity := '001'B, oddevenIndicator := '1'B, digits := '262420000001000'H }, dRX_Parameters := omit, paging_Field4 := { routeing_Area := { iEI := '1B'O, ext := '1'B, lengthIndicator := { length1 := 6 }, mccDigit1 := '2'H, mccDigit2 := '6'H, mccDigit3 := '2'H, mncDigit3 := 'F'H, mncDigit1 := '4'H, mncDigit2 := '2'H, lac := '334F'O ("3O"), rac := '00'O } }, pFI := omit, aBQP := omit, qoS_Profile := { iEI := '18'O, ext := '1'B, lengthIndicator := { length1 := 3 }, peak_Bit_Rate := '0050'O, precedence := '000'B, a_bit := '0'B, t_bit := '0'B, c_r_bit := '0'B, peakBitRateGranularity := '00'B }, pTMSI := { iEI := '20'O (" "), ext := '1'B, lengthIndicator := { length1 := 4 }, tMSI_Value := '4220040B'O }, eDRX_Paremeters := omit } }, llc := omit, l3_mo := omit, l3_mt := omit, sndcp := omit } TC_paging_ps_sig_rac(2392)@1379cdb918a5: Paging received on PCU { 0 } TC_paging_ps_sig_rac(2392)@1379cdb918a5: setverdict(pass): none -> pass GbProxy_Test-BSSGP(PCU[1])(2368)@1379cdb918a5: Rx on SIG BVCI without PTP BVCI: broadcasting GbProxy_Test-BSSGP(PCU[2])(2381)@1379cdb918a5: Rx on SIG BVCI without PTP BVCI: broadcasting GbProxy_Test-BSSGP(PCU[2])-BVCI20032(2386)@1379cdb918a5: No TLLI: Broadcasting { bssgp := { pDU_BSSGP_PAGING_PS := { bssgpPduType := '06'O, iMSI := { iEI := '0D'O ("\r"), ext := '1'B, lengthIndicator := { length1 := 8 }, type_of_Identity := '001'B, oddevenIndicator := '1'B, digits := '262420000001000'H }, dRX_Parameters := omit, paging_Field4 := { routeing_Area := { iEI := '1B'O, ext := '1'B, lengthIndicator := { length1 := 6 }, mccDigit1 := '2'H, mccDigit2 := '6'H, mccDigit3 := '2'H, mncDigit3 := 'F'H, mncDigit1 := '4'H, mncDigit2 := '2'H, lac := '334F'O ("3O"), rac := '01'O } }, pFI := omit, aBQP := omit, qoS_Profile := { iEI := '18'O, ext := '1'B, lengthIndicator := { length1 := 3 }, peak_Bit_Rate := '0050'O, precedence := '000'B, a_bit := '0'B, t_bit := '0'B, c_r_bit := '0'B, peakBitRateGranularity := '00'B }, pTMSI := { iEI := '20'O (" "), ext := '1'B, lengthIndicator := { length1 := 4 }, tMSI_Value := '4220040B'O }, eDRX_Paremeters := omit } }, llc := omit, l3_mo := omit, l3_mt := omit, sndcp := omit } GbProxy_Test-BSSGP(PCU[1])-BVCI20022(2376)@1379cdb918a5: No TLLI: Broadcasting { bssgp := { pDU_BSSGP_PAGING_PS := { bssgpPduType := '06'O, iMSI := { iEI := '0D'O ("\r"), ext := '1'B, lengthIndicator := { length1 := 8 }, type_of_Identity := '001'B, oddevenIndicator := '1'B, digits := '262420000001000'H }, dRX_Parameters := omit, paging_Field4 := { routeing_Area := { iEI := '1B'O, ext := '1'B, lengthIndicator := { length1 := 6 }, mccDigit1 := '2'H, mccDigit2 := '6'H, mccDigit3 := '2'H, mncDigit3 := 'F'H, mncDigit1 := '4'H, mncDigit2 := '2'H, lac := '334F'O ("3O"), rac := '01'O } }, pFI := omit, aBQP := omit, qoS_Profile := { iEI := '18'O, ext := '1'B, lengthIndicator := { length1 := 3 }, peak_Bit_Rate := '0050'O, precedence := '000'B, a_bit := '0'B, t_bit := '0'B, c_r_bit := '0'B, peakBitRateGranularity := '00'B }, pTMSI := { iEI := '20'O (" "), ext := '1'B, lengthIndicator := { length1 := 4 }, tMSI_Value := '4220040B'O }, eDRX_Paremeters := omit } }, llc := omit, l3_mo := omit, l3_mt := omit, sndcp := omit } GbProxy_Test-BSSGP(PCU[2])-BVCI20031(2382)@1379cdb918a5: No TLLI: Broadcasting { bssgp := { pDU_BSSGP_PAGING_PS := { bssgpPduType := '06'O, iMSI := { iEI := '0D'O ("\r"), ext := '1'B, lengthIndicator := { length1 := 8 }, type_of_Identity := '001'B, oddevenIndicator := '1'B, digits := '262420000001000'H }, dRX_Parameters := omit, paging_Field4 := { routeing_Area := { iEI := '1B'O, ext := '1'B, lengthIndicator := { length1 := 6 }, mccDigit1 := '2'H, mccDigit2 := '6'H, mccDigit3 := '2'H, mncDigit3 := 'F'H, mncDigit1 := '4'H, mncDigit2 := '2'H, lac := '334F'O ("3O"), rac := '01'O } }, pFI := omit, aBQP := omit, qoS_Profile := { iEI := '18'O, ext := '1'B, lengthIndicator := { length1 := 3 }, peak_Bit_Rate := '0050'O, precedence := '000'B, a_bit := '0'B, t_bit := '0'B, c_r_bit := '0'B, peakBitRateGranularity := '00'B }, pTMSI := { iEI := '20'O (" "), ext := '1'B, lengthIndicator := { length1 := 4 }, tMSI_Value := '4220040B'O }, eDRX_Paremeters := omit } }, llc := omit, l3_mo := omit, l3_mt := omit, sndcp := omit } GbProxy_Test-BSSGP(PCU[2])-BVCI20033(2389)@1379cdb918a5: No TLLI: Broadcasting { bssgp := { pDU_BSSGP_PAGING_PS := { bssgpPduType := '06'O, iMSI := { iEI := '0D'O ("\r"), ext := '1'B, lengthIndicator := { length1 := 8 }, type_of_Identity := '001'B, oddevenIndicator := '1'B, digits := '262420000001000'H }, dRX_Parameters := omit, paging_Field4 := { routeing_Area := { iEI := '1B'O, ext := '1'B, lengthIndicator := { length1 := 6 }, mccDigit1 := '2'H, mccDigit2 := '6'H, mccDigit3 := '2'H, mncDigit3 := 'F'H, mncDigit1 := '4'H, mncDigit2 := '2'H, lac := '334F'O ("3O"), rac := '01'O } }, pFI := omit, aBQP := omit, qoS_Profile := { iEI := '18'O, ext := '1'B, lengthIndicator := { length1 := 3 }, peak_Bit_Rate := '0050'O, precedence := '000'B, a_bit := '0'B, t_bit := '0'B, c_r_bit := '0'B, peakBitRateGranularity := '00'B }, pTMSI := { iEI := '20'O (" "), ext := '1'B, lengthIndicator := { length1 := 4 }, tMSI_Value := '4220040B'O }, eDRX_Paremeters := omit } }, llc := omit, l3_mo := omit, l3_mt := omit, sndcp := omit } GbProxy_Test-BSSGP(PCU[1])-BVCI20021(2373)@1379cdb918a5: No TLLI: Broadcasting { bssgp := { pDU_BSSGP_PAGING_PS := { bssgpPduType := '06'O, iMSI := { iEI := '0D'O ("\r"), ext := '1'B, lengthIndicator := { length1 := 8 }, type_of_Identity := '001'B, oddevenIndicator := '1'B, digits := '262420000001000'H }, dRX_Parameters := omit, paging_Field4 := { routeing_Area := { iEI := '1B'O, ext := '1'B, lengthIndicator := { length1 := 6 }, mccDigit1 := '2'H, mccDigit2 := '6'H, mccDigit3 := '2'H, mncDigit3 := 'F'H, mncDigit1 := '4'H, mncDigit2 := '2'H, lac := '334F'O ("3O"), rac := '01'O } }, pFI := omit, aBQP := omit, qoS_Profile := { iEI := '18'O, ext := '1'B, lengthIndicator := { length1 := 3 }, peak_Bit_Rate := '0050'O, precedence := '000'B, a_bit := '0'B, t_bit := '0'B, c_r_bit := '0'B, peakBitRateGranularity := '00'B }, pTMSI := { iEI := '20'O (" "), ext := '1'B, lengthIndicator := { length1 := 4 }, tMSI_Value := '4220040B'O }, eDRX_Paremeters := omit } }, llc := omit, l3_mo := omit, l3_mt := omit, sndcp := omit } TC_paging_ps_sig_rac(2392)@1379cdb918a5: Paging received on PCU { 2, 1 } TC_paging_ps_sig_rac(2392)@1379cdb918a5: setverdict(pass): pass -> pass, component reason not changed GbProxy_Test-BSSGP(PCU[2])-BVCI20031(2382)@1379cdb918a5: Removing Client IMSI='262420000001000'H, index=1 GbProxy_Test-BSSGP(PCU[2])-BVCI20032(2386)@1379cdb918a5: Adding Client=TC_paging_ps_sig_rac(2392), IMSI='262420000001000'H, TLLI='C220040B'O, index=1 GbProxy_Test-BSSGP(PCU[2])(2381)@1379cdb918a5: Rx on SIG BVCI without PTP BVCI: broadcasting GbProxy_Test-BSSGP(PCU[2])-BVCI20032(2386)@1379cdb918a5: No TLLI: Broadcasting { bssgp := { pDU_BSSGP_PAGING_PS := { bssgpPduType := '06'O, iMSI := { iEI := '0D'O ("\r"), ext := '1'B, lengthIndicator := { length1 := 8 }, type_of_Identity := '001'B, oddevenIndicator := '1'B, digits := '262420000001000'H }, dRX_Parameters := omit, paging_Field4 := { routeing_Area := { iEI := '1B'O, ext := '1'B, lengthIndicator := { length1 := 6 }, mccDigit1 := '2'H, mccDigit2 := '6'H, mccDigit3 := '2'H, mncDigit3 := 'F'H, mncDigit1 := '4'H, mncDigit2 := '2'H, lac := '33F4'O, rac := '00'O } }, pFI := omit, aBQP := omit, qoS_Profile := { iEI := '18'O, ext := '1'B, lengthIndicator := { length1 := 3 }, peak_Bit_Rate := '0050'O, precedence := '000'B, a_bit := '0'B, t_bit := '0'B, c_r_bit := '0'B, peakBitRateGranularity := '00'B }, pTMSI := { iEI := '20'O (" "), ext := '1'B, lengthIndicator := { length1 := 4 }, tMSI_Value := '4220040B'O }, eDRX_Paremeters := omit } }, llc := omit, l3_mo := omit, l3_mt := omit, sndcp := omit } GbProxy_Test-BSSGP(PCU[2])-BVCI20031(2382)@1379cdb918a5: No TLLI: Broadcasting { bssgp := { pDU_BSSGP_PAGING_PS := { bssgpPduType := '06'O, iMSI := { iEI := '0D'O ("\r"), ext := '1'B, lengthIndicator := { length1 := 8 }, type_of_Identity := '001'B, oddevenIndicator := '1'B, digits := '262420000001000'H }, dRX_Parameters := omit, paging_Field4 := { routeing_Area := { iEI := '1B'O, ext := '1'B, lengthIndicator := { length1 := 6 }, mccDigit1 := '2'H, mccDigit2 := '6'H, mccDigit3 := '2'H, mncDigit3 := 'F'H, mncDigit1 := '4'H, mncDigit2 := '2'H, lac := '33F4'O, rac := '00'O } }, pFI := omit, aBQP := omit, qoS_Profile := { iEI := '18'O, ext := '1'B, lengthIndicator := { length1 := 3 }, peak_Bit_Rate := '0050'O, precedence := '000'B, a_bit := '0'B, t_bit := '0'B, c_r_bit := '0'B, peakBitRateGranularity := '00'B }, pTMSI := { iEI := '20'O (" "), ext := '1'B, lengthIndicator := { length1 := 4 }, tMSI_Value := '4220040B'O }, eDRX_Paremeters := omit } }, llc := omit, l3_mo := omit, l3_mt := omit, sndcp := omit } GbProxy_Test-BSSGP(PCU[2])-BVCI20033(2389)@1379cdb918a5: No TLLI: Broadcasting { bssgp := { pDU_BSSGP_PAGING_PS := { bssgpPduType := '06'O, iMSI := { iEI := '0D'O ("\r"), ext := '1'B, lengthIndicator := { length1 := 8 }, type_of_Identity := '001'B, oddevenIndicator := '1'B, digits := '262420000001000'H }, dRX_Parameters := omit, paging_Field4 := { routeing_Area := { iEI := '1B'O, ext := '1'B, lengthIndicator := { length1 := 6 }, mccDigit1 := '2'H, mccDigit2 := '6'H, mccDigit3 := '2'H, mncDigit3 := 'F'H, mncDigit1 := '4'H, mncDigit2 := '2'H, lac := '33F4'O, rac := '00'O } }, pFI := omit, aBQP := omit, qoS_Profile := { iEI := '18'O, ext := '1'B, lengthIndicator := { length1 := 3 }, peak_Bit_Rate := '0050'O, precedence := '000'B, a_bit := '0'B, t_bit := '0'B, c_r_bit := '0'B, peakBitRateGranularity := '00'B }, pTMSI := { iEI := '20'O (" "), ext := '1'B, lengthIndicator := { length1 := 4 }, tMSI_Value := '4220040B'O }, eDRX_Paremeters := omit } }, llc := omit, l3_mo := omit, l3_mt := omit, sndcp := omit } TC_paging_ps_sig_rac(2392)@1379cdb918a5: Paging received on PCU { 2 } TC_paging_ps_sig_rac(2392)@1379cdb918a5: setverdict(pass): pass -> pass, component reason not changed GbProxy_Test-BSSGP(SGSN[0])-BVCI20011(2334)@1379cdb918a5: Removing Client IMSI='262420000001000'H, index=1 GbProxy_Test-BSSGP(SGSN[1])-BVCI20011(2346)@1379cdb918a5: Removing Client IMSI='262420000001000'H, index=1 GbProxy_Test-BSSGP(PCU[0])-BVCI20011(2358)@1379cdb918a5: Removing Client IMSI='262420000001000'H, index=1 GbProxy_Test-BSSGP(PCU[1])-BVCI20021(2373)@1379cdb918a5: Removing Client IMSI='262420000001000'H, index=1 GbProxy_Test-BSSGP(PCU[2])-BVCI20032(2386)@1379cdb918a5: Removing Client IMSI='262420000001000'H, index=1 MTC@1379cdb918a5: setverdict(pass): none -> pass reason: ""GBProxy_Tests.ttcn:674 : "", new component reason: ""GBProxy_Tests.ttcn:674 : "" MTC@1379cdb918a5: Stopping testcase execution from "GBProxy_Tests.ttcn":674 IPA-CTRL-CLI-IPA(2330)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(SGSN[0])(2331)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[0])(2332)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(SGSN[0])-NSVCI201(2341)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(SGSN[0])-NSVCI101-provIP(2333)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[0])-BVCI20011(2334)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[0])-BVCI20021(2335)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[0])-BVCI20031(2338)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[0])-BVCI20032(2340)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[0])-BVCI20022(2337)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[0])-BVCI20033(2342)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[1])(2344)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(SGSN[1])(2343)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[1])-BVCI20021(2347)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[1])-BVCI20011(2346)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(SGSN[1])-NSVCI102-provIP(2345)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[1])-BVCI20033(2354)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(SGSN[1])-NSVCI102(2348)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[1])-BVCI20031(2350)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(SGSN[1])-NSVCI202-provIP(2351)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[1])-BVCI20032(2352)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(SGSN[1])-BVCI20022(2349)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(SGSN[0])-NSVCI201-provIP(2339)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])(2355)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[1])(2364)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(PCU[0])-BVCI20011(2358)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[1])-NSVCI5(2371)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[1])-NSVCI6(2374)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])-NSVCI1-NSVCemu1-provFR(2360)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])-NSVCI4-NSVCemu4-provFR(2369)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])-NSVCI3(2361)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])-NSVCI3-NSVCemu3-provFR(2366)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[1])-NSVCI5-NSVCemu5-provFR(2375)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])-NSVCI2(2359)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(PCU[1])(2368)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])-NSVCI1(2357)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[2])(2380)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(PCU[0])(2356)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(PCU[2])(2381)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[2])-NSVCI7(2383)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[2])-NSVCI8(2385)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])-NSVCI4(2365)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])-NSVCI2-NSVCemu2-provFR(2362)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[2])-NSVCI8-NSVCemu8-provFR(2388)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[2])-NSVCI7-NSVCemu7-provFR(2384)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[1])-NSVCI6-NSVCemu6-provFR(2377)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(SGSN[0])-NSVCI101(2336)@1379cdb918a5: Final verdict of PTC: none TC_paging_ps_sig_rac(2391)@1379cdb918a5: Final verdict of PTC: pass GbProxy_Test-NS(PCU[0])-NSVCI2-NSVCemu2-FRemu(2367)@1379cdb918a5: AF_PACKET Test port (FR): user_stop GbProxy_Test-NS(PCU[0])-NSVCI2-NSVCemu2-FRemu(2367)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(SGSN[1])-NSVCI202(2353)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(PCU[2])-BVCI20032(2386)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[2])-NSVCI8-NSVCemu8-FRemu(2390)@1379cdb918a5: AF_PACKET Test port (FR): user_stop GbProxy_Test-NS(PCU[2])-NSVCI8-NSVCemu8-FRemu(2390)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])-NSVCI3-NSVCemu3-FRemu(2370)@1379cdb918a5: AF_PACKET Test port (FR): user_stop GbProxy_Test-NS(PCU[0])-NSVCI3-NSVCemu3-FRemu(2370)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[1])-NSVCI5-NSVCemu5-FRemu(2378)@1379cdb918a5: AF_PACKET Test port (FR): user_stop GbProxy_Test-NS(PCU[1])-NSVCI5-NSVCemu5-FRemu(2378)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])-NSVCI4-NSVCemu4-FRemu(2372)@1379cdb918a5: AF_PACKET Test port (FR): user_stop GbProxy_Test-NS(PCU[0])-NSVCI4-NSVCemu4-FRemu(2372)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[0])-NSVCI1-NSVCemu1-FRemu(2363)@1379cdb918a5: AF_PACKET Test port (FR): user_stop GbProxy_Test-NS(PCU[0])-NSVCI1-NSVCemu1-FRemu(2363)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[1])-NSVCI6-NSVCemu6-FRemu(2379)@1379cdb918a5: AF_PACKET Test port (FR): user_stop GbProxy_Test-NS(PCU[1])-NSVCI6-NSVCemu6-FRemu(2379)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(PCU[1])-BVCI20022(2376)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(PCU[2])-BVCI20033(2389)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-NS(PCU[2])-NSVCI7-NSVCemu7-FRemu(2387)@1379cdb918a5: AF_PACKET Test port (FR): user_stop GbProxy_Test-NS(PCU[2])-NSVCI7-NSVCemu7-FRemu(2387)@1379cdb918a5: Final verdict of PTC: none GbProxy_Test-BSSGP(PCU[1])-BVCI20021(2373)@1379cdb918a5: Final verdict of PTC: none TC_paging_ps_sig_rac(2392)@1379cdb918a5: Final verdict of PTC: pass GbProxy_Test-BSSGP(PCU[2])-BVCI20031(2382)@1379cdb918a5: Final verdict of PTC: none MTC@1379cdb918a5: Setting final verdict of the test case. MTC@1379cdb918a5: Local verdict of MTC: pass reason: ""GBProxy_Tests.ttcn:674 : "" MTC@1379cdb918a5: Local verdict of PTC IPA-CTRL-CLI-IPA(2330): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(SGSN[0])(2331): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[0])(2332): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(SGSN[0])-NSVCI101-provIP(2333): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[0])-BVCI20011(2334): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[0])-BVCI20021(2335): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(SGSN[0])-NSVCI101(2336): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[0])-BVCI20022(2337): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[0])-BVCI20031(2338): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(SGSN[0])-NSVCI201-provIP(2339): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[0])-BVCI20032(2340): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(SGSN[0])-NSVCI201(2341): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[0])-BVCI20033(2342): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(SGSN[1])(2343): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[1])(2344): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(SGSN[1])-NSVCI102-provIP(2345): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[1])-BVCI20011(2346): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[1])-BVCI20021(2347): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(SGSN[1])-NSVCI102(2348): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[1])-BVCI20022(2349): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[1])-BVCI20031(2350): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(SGSN[1])-NSVCI202-provIP(2351): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[1])-BVCI20032(2352): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(SGSN[1])-NSVCI202(2353): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(SGSN[1])-BVCI20033(2354): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])(2355): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(PCU[0])(2356): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI1(2357): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(PCU[0])-BVCI20011(2358): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI2(2359): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI1-NSVCemu1-provFR(2360): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI3(2361): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI2-NSVCemu2-provFR(2362): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI1-NSVCemu1-FRemu(2363): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[1])(2364): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI4(2365): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI3-NSVCemu3-provFR(2366): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI2-NSVCemu2-FRemu(2367): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(PCU[1])(2368): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI4-NSVCemu4-provFR(2369): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI3-NSVCemu3-FRemu(2370): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[1])-NSVCI5(2371): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[0])-NSVCI4-NSVCemu4-FRemu(2372): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(PCU[1])-BVCI20021(2373): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[1])-NSVCI6(2374): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[1])-NSVCI5-NSVCemu5-provFR(2375): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(PCU[1])-BVCI20022(2376): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[1])-NSVCI6-NSVCemu6-provFR(2377): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[1])-NSVCI5-NSVCemu5-FRemu(2378): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[1])-NSVCI6-NSVCemu6-FRemu(2379): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[2])(2380): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(PCU[2])(2381): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(PCU[2])-BVCI20031(2382): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[2])-NSVCI7(2383): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[2])-NSVCI7-NSVCemu7-provFR(2384): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[2])-NSVCI8(2385): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(PCU[2])-BVCI20032(2386): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[2])-NSVCI7-NSVCemu7-FRemu(2387): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[2])-NSVCI8-NSVCemu8-provFR(2388): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-BSSGP(PCU[2])-BVCI20033(2389): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC GbProxy_Test-NS(PCU[2])-NSVCI8-NSVCemu8-FRemu(2390): none (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC TC_paging_ps_sig_rac(2391): pass (pass -> pass) MTC@1379cdb918a5: Local verdict of PTC TC_paging_ps_sig_rac(2392): pass (pass -> pass) MTC@1379cdb918a5: Test case TC_paging_ps_sig_rac finished. Verdict: pass reason: "GBProxy_Tests.ttcn:674 : " MTC@1379cdb918a5: Starting external command `../ttcn3-dumpcap-stop.sh GBProxy_Tests.TC_paging_ps_sig_rac pass'. (06:56:35) load average: 1.11, 2.35, 1.72 [1;32m====== GBProxy_Tests.TC_paging_ps_sig_rac pass ======[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=339460) Waiting for packet dumper to finish... 1 (prev_count=339460, count=342108) MTC@1379cdb918a5: External command `../ttcn3-dumpcap-stop.sh GBProxy_Tests.TC_paging_ps_sig_rac pass' was executed successfully (exit status: 0). MTC@1379cdb918a5: Starting external command `../ttcn3-dumpcap-start.sh GBProxy_Tests.TC_paging_ps_sig_rac_unknown'. ------ GBProxy_Tests.TC_paging_ps_sig_rac_unknown ------ FATAL: command execution failed java.io.EOFException at java.base/java.io.ObjectInputStream$PeekInputStream.readFully(Unknown Source) at java.base/java.io.ObjectInputStream$BlockDataInputStream.readShort(Unknown Source) at java.base/java.io.ObjectInputStream.readStreamHeader(Unknown Source) at java.base/java.io.ObjectInputStream.<init>(Unknown Source) at hudson.remoting.ObjectInputStreamEx.<init>(ObjectInputStreamEx.java:50) at hudson.remoting.Command.readFrom(Command.java:141) at hudson.remoting.Command.readFrom(Command.java:127) at hudson.remoting.AbstractSynchronousByteArrayCommandTransport.read(AbstractSynchronousByteArrayCommandTransport.java:35) at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:62) Caused: java.io.IOException: Unexpected termination of the channel at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:80) Caused: java.io.IOException: Backing channel 'gtp0-deb10fr' is disconnected. at hudson.remoting.RemoteInvocationHandler.channelOrFail(RemoteInvocationHandler.java:227) at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandler.java:306) at jdk.proxy2/jdk.proxy2.$Proxy150.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/jenkins12783938517740331190.sh java.io.EOFException at java.base/java.io.ObjectInputStream$PeekInputStream.readFully(Unknown Source) at java.base/java.io.ObjectInputStream$BlockDataInputStream.readShort(Unknown Source) at java.base/java.io.ObjectInputStream.readStreamHeader(Unknown Source) at java.base/java.io.ObjectInputStream.<init>(Unknown Source) at hudson.remoting.ObjectInputStreamEx.<init>(ObjectInputStreamEx.java:50) at hudson.remoting.Command.readFrom(Command.java:141) at hudson.remoting.Command.readFrom(Command.java:127) at hudson.remoting.AbstractSynchronousByteArrayCommandTransport.read(AbstractSynchronousByteArrayCommandTransport.java:35) at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:62) Caused: java.io.IOException: Unexpected termination of the channel at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(SynchronousCommandTransport.java:80) Caused: hudson.remoting.ChannelClosedException: Channel "hudson.remoting.Channel@5835a5df:gtp0-deb10fr": Remote call on gtp0-deb10fr failed. The channel is closing down or has closed down at hudson.remoting.Channel.call(Channel.java:1101) at hudson.FilePath.act(FilePath.java:1217) at hudson.FilePath.act(FilePath.java:1206) at hudson.FilePath.delete(FilePath.java:1753) 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-gbproxy-test-fr #1985

1 1

Build failed in Jenkins: ttcn3-remsim-test-asan #691
by jenkins＠lists.osmocom.org 28 Apr '26

28 Apr '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/691/display/…> Changes: [Andreas Eversberg] Fix bankd connection at RemsimClient_Tests.TC_bank_disconnect_reconnect [Andreas Eversberg] Fix access pcscd in various RemsimBankd_Tests [Andreas Eversberg] testenv: Allow adding extra parameters to podman ------------------------------------------ [...truncated 103.62 KiB...] RSPRO_SRV0(3)@4a2bd02e722f: IPA: Closed MTC@4a2bd02e722f: setverdict(pass): pass -> pass, component reason not changed [38;5;23m4814 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m stream_cli.c:565 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:35089){CONNECTED} lost connection with srv (-104)[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:181 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:35089){CONNECTED} close()[0;m 4814 [1;33mDRSPRO[0;m [1;33mNOTICE[0;m ../rspro_client_fsm.c:154 RSPRO_CLIENT(server){ESTABLISHED}: RSPRO link to 127.0.0.10:9998 DOWN [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa_keepalive.c:351 IPA-KA(server){WAIT_RESP}: Stopping IPA keep-alive FSM[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:352 IPA-KA(server){WAIT_RESP}: Received Event OSMO_IPA_KA_E_STOP[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:159 IPA-KA(server){WAIT_RESP}: state_chg to INIT[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m fsm.c:569 IPA-KA(server){INIT}: Deallocated[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:162 RSPRO_CLIENT(server){ESTABLISHED}: Received Event SRVC_E_TCP_DOWN 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:310 RSPRO_CLIENT(server){ESTABLISHED}: ->REESTABLISH_DELAY delay 995ms; 5ms since last attempt [step 3/123@1s] 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:318 RSPRO_CLIENT(server){ESTABLISHED}: state_chg to REESTABLISH_DELAY 4814 [1;32mDRSPRO[0;m [1;32mINFO[0;m ../rspro_client_fsm.c:428 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Destroying existing connection to server [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:1068 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:35089){CLOSED} destroy()[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:181 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:35089){CLOSED} close()[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:1075 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:35089){CLOSED} delay free() in_cb_mask=0x02[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:150 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:35089){CLOSED} free(delayed)[0;m RSPRO_SRV0(3)@4a2bd02e722f: Final verdict of PTC: none MTC@4a2bd02e722f: Setting final verdict of the test case. MTC@4a2bd02e722f: Local verdict of MTC: pass MTC@4a2bd02e722f: Local verdict of PTC RSPRO_SRV0(3): none (pass -> pass) MTC@4a2bd02e722f: Test case TC_connectBankReq_timeout finished. Verdict: pass MTC@4a2bd02e722f: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/ttcn3-tcp…> RemsimBankd_Tests.TC_connectBankReq_timeout pass'. (17:12:45) load average: 0.44, 0.52, 0.60 [1;32m====== RemsimBankd_Tests.TC_connectBankReq_timeout pass ======[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=2248) 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m fsm.c:318 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Timeout of T3 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:555 RSPRO_CLIENT(server){REESTABLISH_DELAY}: state_chg to REESTABLISH 4814 [1;32mDRSPRO[0;m [1;32mINFO[0;m ../rspro_client_fsm.c:454 RSPRO_CLIENT(server){REESTABLISH}: Creating TCP connection to server at 127.0.0.10:9998 [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m fsm.c:457 IPA-KA(server){INIT}: Allocated[0;m [38;5;23m4814 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m stream_cli.c:446 CLICONN(server,){CONNECTING} connect failed (-111)[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:181 CLICONN(server,){CONNECTING} close()[0;m 4814 [1;33mDRSPRO[0;m [1;33mNOTICE[0;m ../rspro_client_fsm.c:154 RSPRO_CLIENT(server){REESTABLISH}: RSPRO link to 127.0.0.10:9998 DOWN [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa_keepalive.c:351 IPA-KA(server){INIT}: Stopping IPA keep-alive FSM[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:352 IPA-KA(server){INIT}: Received Event OSMO_IPA_KA_E_STOP[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:159 IPA-KA(server){INIT}: state_chg to INIT[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m fsm.c:569 IPA-KA(server){INIT}: Deallocated[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:162 RSPRO_CLIENT(server){REESTABLISH}: Received Event SRVC_E_TCP_DOWN [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m stream_cli.c:241 CLICONN(server,){CLOSED} not reconnecting, disabled[0;m Waiting for packet dumper to finish... 1 (prev_count=2248, count=3456) MTC@4a2bd02e722f: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/ttcn3-tcp…> RemsimBankd_Tests.TC_connectBankReq_timeout pass' was executed successfully (exit status: 0). MTC@4a2bd02e722f: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/ttcn3-tcp…> RemsimBankd_Tests.TC_connectBankReq'. ------ RemsimBankd_Tests.TC_connectBankReq ------ (17:12:47) load average: 0.44, 0.52, 0.60 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/691/artifact…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/691/artifact…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@4a2bd02e722f: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/ttcn3-tcp…> RemsimBankd_Tests.TC_connectBankReq' was executed successfully (exit status: 0). MTC@4a2bd02e722f: Test case TC_connectBankReq started. 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m fsm.c:318 RSPRO_CLIENT(server){REESTABLISH}: Timeout of T2 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:318 RSPRO_CLIENT(server){REESTABLISH}: state_chg to REESTABLISH_DELAY 4814 [1;32mDRSPRO[0;m [1;32mINFO[0;m ../rspro_client_fsm.c:428 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Destroying existing connection to server [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:1068 CLICONN(server,){CLOSED} destroy()[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:181 CLICONN(server,){CLOSED} close()[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:1083 CLICONN(server,){CLOSED} free(destroy)[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m fsm.c:318 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Timeout of T3 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:555 RSPRO_CLIENT(server){REESTABLISH_DELAY}: state_chg to REESTABLISH 4814 [1;32mDRSPRO[0;m [1;32mINFO[0;m ../rspro_client_fsm.c:454 RSPRO_CLIENT(server){REESTABLISH}: Creating TCP connection to server at 127.0.0.10:9998 [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m fsm.c:457 IPA-KA(server){INIT}: Allocated[0;m [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m stream_cli.c:462 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:45821){CONNECTING} connection established[0;m 4814 [1;33mDRSPRO[0;m [1;33mNOTICE[0;m ../rspro_client_fsm.c:145 RSPRO_CLIENT(server){REESTABLISH}: RSPRO link to 127.0.0.10:9998 UP 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:146 RSPRO_CLIENT(server){REESTABLISH}: Received Event SRVC_E_TCP_UP 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:513 RSPRO_CLIENT(server){REESTABLISH}: state_chg to ESTABLISHED [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa_keepalive.c:332 IPA-KA(server){INIT}: Starting IPA keep-alive FSM (interval=30s wait=10s)[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:334 IPA-KA(server){INIT}: Received Event OSMO_IPA_KA_E_START[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:94 IPA-KA(server){INIT}: state_chg to WAIT_RESP[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:100 RSPRO_CLIENT(server){ESTABLISHED}: Tx RSPRO connectBankReq RSPRO_SRV0(4)@4a2bd02e722f: Established a new IPA connection (conn_id=2) RSPRO_SRV0(4)@4a2bd02e722f: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:573 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:45821){CONNECTED} received 8 bytes from srv[0;m 4814 [1;33mDRSPRO[0;m [1;33mNOTICE[0;m ../rspro_client_fsm.c:199 RSPRO_CLIENT(server){ESTABLISHED}: received ID_GET for unit ID 0/0/0 [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa.c:396 tag 1: 00-00-00-00-00-00[0;m [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa.c:396 tag 8: 0/0/0[0;m RSPRO_SRV0(4)@4a2bd02e722f: CCM Rx:{ msg_type := IPAC_MSGT_PING (0), u := omit } RSPRO_SRV0(4)@4a2bd02e722f: CCM Tx:{ msg_type := IPAC_MSGT_PONG (1), u := omit } [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:573 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:45821){CONNECTED} received 4 bytes from srv[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:342 IPA-KA(server){WAIT_RESP}: Received Event OSMO_IPA_KA_E_PONG[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:124 IPA-KA(server){WAIT_RESP}: state_chg to IDLE[0;m RSPRO_SRV0(4)@4a2bd02e722f: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } } } RSPRO_SRV0(4)@4a2bd02e722f: IPA ID RESP: { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } MTC@4a2bd02e722f: setverdict(pass): none -> pass reason: ""RemsimBankd_Tests.ttcn:93 : "", new component reason: ""RemsimBankd_Tests.ttcn:93 : "" MTC@4a2bd02e722f: Stopping testcase execution from "RemsimBankd_Tests.ttcn":93 RSPRO_SRV0(4)@4a2bd02e722f: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } RSPRO_SRV0(4)@4a2bd02e722f: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:573 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:45821){CONNECTED} received 4 bytes from srv[0;m [38;5;23m4814 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m stream_cli.c:569 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:45821){CONNECTED} connection closed with srv[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:181 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:45821){CONNECTED} close()[0;m 4814 [1;33mDRSPRO[0;m [1;33mNOTICE[0;m ../rspro_client_fsm.c:154 RSPRO_CLIENT(server){ESTABLISHED}: RSPRO link to 127.0.0.10:9998 DOWN [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa_keepalive.c:351 IPA-KA(server){IDLE}: Stopping IPA keep-alive FSM[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:352 IPA-KA(server){IDLE}: Received Event OSMO_IPA_KA_E_STOP[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:159 IPA-KA(server){IDLE}: state_chg to INIT[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m fsm.c:569 IPA-KA(server){INIT}: Deallocated[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:162 RSPRO_CLIENT(server){ESTABLISHED}: Received Event SRVC_E_TCP_DOWN 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:310 RSPRO_CLIENT(server){ESTABLISHED}: ->REESTABLISH_DELAY delay 986ms; 14ms since last attempt [step 5/123@1s] 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:318 RSPRO_CLIENT(server){ESTABLISHED}: state_chg to REESTABLISH_DELAY 4814 [1;32mDRSPRO[0;m [1;32mINFO[0;m ../rspro_client_fsm.c:428 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Destroying existing connection to server [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:1068 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:45821){CLOSED} destroy()[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:181 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:45821){CLOSED} close()[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:1075 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:45821){CLOSED} delay free() in_cb_mask=0x02[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:150 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:45821){CLOSED} free(delayed)[0;m RSPRO_SRV0(4)@4a2bd02e722f: Final verdict of PTC: none MTC@4a2bd02e722f: Setting final verdict of the test case. MTC@4a2bd02e722f: Local verdict of MTC: pass reason: ""RemsimBankd_Tests.ttcn:93 : "" MTC@4a2bd02e722f: Local verdict of PTC RSPRO_SRV0(4): none (pass -> pass) MTC@4a2bd02e722f: Test case TC_connectBankReq finished. Verdict: pass reason: "RemsimBankd_Tests.ttcn:93 : " MTC@4a2bd02e722f: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/ttcn3-tcp…> RemsimBankd_Tests.TC_connectBankReq pass'. (17:12:56) load average: 0.37, 0.51, 0.60 [1;32m====== RemsimBankd_Tests.TC_connectBankReq pass ======[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=576) 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m fsm.c:318 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Timeout of T3 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:555 RSPRO_CLIENT(server){REESTABLISH_DELAY}: state_chg to REESTABLISH 4814 [1;32mDRSPRO[0;m [1;32mINFO[0;m ../rspro_client_fsm.c:454 RSPRO_CLIENT(server){REESTABLISH}: Creating TCP connection to server at 127.0.0.10:9998 [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m fsm.c:457 IPA-KA(server){INIT}: Allocated[0;m [38;5;23m4814 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m stream_cli.c:446 CLICONN(server,){CONNECTING} connect failed (-111)[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:181 CLICONN(server,){CONNECTING} close()[0;m 4814 [1;33mDRSPRO[0;m [1;33mNOTICE[0;m ../rspro_client_fsm.c:154 RSPRO_CLIENT(server){REESTABLISH}: RSPRO link to 127.0.0.10:9998 DOWN [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa_keepalive.c:351 IPA-KA(server){INIT}: Stopping IPA keep-alive FSM[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:352 IPA-KA(server){INIT}: Received Event OSMO_IPA_KA_E_STOP[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:159 IPA-KA(server){INIT}: state_chg to INIT[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m fsm.c:569 IPA-KA(server){INIT}: Deallocated[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:162 RSPRO_CLIENT(server){REESTABLISH}: Received Event SRVC_E_TCP_DOWN [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m stream_cli.c:241 CLICONN(server,){CLOSED} not reconnecting, disabled[0;m Waiting for packet dumper to finish... 1 (prev_count=576, count=2340) MTC@4a2bd02e722f: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/ttcn3-tcp…> RemsimBankd_Tests.TC_connectBankReq pass' was executed successfully (exit status: 0). MTC@4a2bd02e722f: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/ttcn3-tcp…> RemsimBankd_Tests.TC_createMapping'. ------ RemsimBankd_Tests.TC_createMapping ------ (17:12:58) load average: 0.50, 0.53, 0.60 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/691/artifact…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/691/artifact…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@4a2bd02e722f: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/ttcn3-tcp…> RemsimBankd_Tests.TC_createMapping' was executed successfully (exit status: 0). MTC@4a2bd02e722f: Test case TC_createMapping started. 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m fsm.c:318 RSPRO_CLIENT(server){REESTABLISH}: Timeout of T2 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:318 RSPRO_CLIENT(server){REESTABLISH}: state_chg to REESTABLISH_DELAY 4814 [1;32mDRSPRO[0;m [1;32mINFO[0;m ../rspro_client_fsm.c:428 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Destroying existing connection to server [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:1068 CLICONN(server,){CLOSED} destroy()[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:181 CLICONN(server,){CLOSED} close()[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:1083 CLICONN(server,){CLOSED} free(destroy)[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m fsm.c:318 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Timeout of T3 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:555 RSPRO_CLIENT(server){REESTABLISH_DELAY}: state_chg to REESTABLISH 4814 [1;32mDRSPRO[0;m [1;32mINFO[0;m ../rspro_client_fsm.c:454 RSPRO_CLIENT(server){REESTABLISH}: Creating TCP connection to server at 127.0.0.10:9998 [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m fsm.c:457 IPA-KA(server){INIT}: Allocated[0;m [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m stream_cli.c:462 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CONNECTING} connection established[0;m 4814 [1;33mDRSPRO[0;m [1;33mNOTICE[0;m ../rspro_client_fsm.c:145 RSPRO_CLIENT(server){REESTABLISH}: RSPRO link to 127.0.0.10:9998 UP 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:146 RSPRO_CLIENT(server){REESTABLISH}: Received Event SRVC_E_TCP_UP 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:513 RSPRO_CLIENT(server){REESTABLISH}: state_chg to ESTABLISHED [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa_keepalive.c:332 IPA-KA(server){INIT}: Starting IPA keep-alive FSM (interval=30s wait=10s)[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:334 IPA-KA(server){INIT}: Received Event OSMO_IPA_KA_E_START[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:94 IPA-KA(server){INIT}: state_chg to WAIT_RESP[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:100 RSPRO_CLIENT(server){ESTABLISHED}: Tx RSPRO connectBankReq RSPRO_SRV0(5)@4a2bd02e722f: Established a new IPA connection (conn_id=2) RSPRO_SRV0(5)@4a2bd02e722f: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:573 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CONNECTED} received 8 bytes from srv[0;m 4814 [1;33mDRSPRO[0;m [1;33mNOTICE[0;m ../rspro_client_fsm.c:199 RSPRO_CLIENT(server){ESTABLISHED}: received ID_GET for unit ID 0/0/0 [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa.c:396 tag 1: 00-00-00-00-00-00[0;m [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa.c:396 tag 8: 0/0/0[0;m RSPRO_SRV0(5)@4a2bd02e722f: CCM Rx:{ msg_type := IPAC_MSGT_PING (0), u := omit } RSPRO_SRV0(5)@4a2bd02e722f: CCM Tx:{ msg_type := IPAC_MSGT_PONG (1), u := omit } [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:573 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CONNECTED} received 4 bytes from srv[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:342 IPA-KA(server){WAIT_RESP}: Received Event OSMO_IPA_KA_E_PONG[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:124 IPA-KA(server){WAIT_RESP}: state_chg to IDLE[0;m RSPRO_SRV0(5)@4a2bd02e722f: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } } } RSPRO_SRV0(5)@4a2bd02e722f: IPA ID RESP: { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } RSPRO_SRV0(5)@4a2bd02e722f: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } RSPRO_SRV0(5)@4a2bd02e722f: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:573 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CONNECTED} received 79 bytes from srv[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:573 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CONNECTED} received 79 bytes from srv[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:255 RSPRO_CLIENT(server){ESTABLISHED}: Received RSPRO (L1=data-4) [L2]> 30 35 80 01 02 81 01 00 a2 2d a1 2b 30 26 0a 01 01 16 0b 74 74 63 6e 2d 73 65 72 76 65 72 80 05 54 54 43 4e 33 81 03 30 2e 31 82 08 73 79 73 6d 6f 63 6f 6d 0a 01 00 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m rspro_util.c:86 decoding (L1=data-4) [L2]> 30 35 80 01 02 81 01 00 a2 2d a1 2b 30 26 0a 01 01 16 0b 74 74 63 6e 2d 73 65 72 76 65 72 80 05 54 54 43 4e 33 81 03 30 2e 31 82 08 73 79 73 6d 6f 63 6f 6d 0a 01 00 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m bankd_main.c:182 RSPRO_CLIENT(server){ESTABLISHED}: Rx RSPRO connectBankRes 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m bankd_main.c:195 RSPRO_CLIENT(server){ESTABLISHED}: Received Event SRVC_E_CLIENT_CONN_RES 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:365 RSPRO_CLIENT(server){ESTABLISHED}: state_chg to CONNECTED [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:573 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CONNECTED} received 79 bytes from srv[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:255 RSPRO_CLIENT(server){CONNECTED}: Received RSPRO (L1=data-4) [L2]> 30 0a 80 01 02 81 01 00 a2 02 b3 00 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m rspro_util.c:86 decoding (L1=data-4) [L2]> 30 0a 80 01 02 81 01 00 a2 02 b3 00 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m bankd_main.c:182 RSPRO_CLIENT(server){CONNECTED}: Rx RSPRO resetStateReq 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:111 RSPRO_CLIENT(server){CONNECTED}: Received Event SRVC_E_RSPRO_TX 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:100 RSPRO_CLIENT(server){CONNECTED}: Tx RSPRO resetStateRes MTC@4a2bd02e722f: setverdict(pass): none -> pass [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:573 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CONNECTED} received 32 bytes from srv[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:255 RSPRO_CLIENT(server){CONNECTED}: Received RSPRO (L1=data-4) [L2]> 30 1a 80 01 02 81 01 00 a2 12 a4 10 30 06 02 01 17 02 01 2a 30 06 02 01 01 02 01 00 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m rspro_util.c:86 decoding (L1=data-4) [L2]> 30 1a 80 01 02 81 01 00 a2 12 a4 10 30 06 02 01 17 02 01 2a 30 06 02 01 01 02 01 00 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m bankd_main.c:182 RSPRO_CLIENT(server){CONNECTED}: Rx RSPRO createMappingReq 4814 [1;32mDSLOTMAP[0;m [1;32mINFO[0;m ../slotmap.c:131 Slot Map B(1:0) <-> C(23:42) added 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:111 RSPRO_CLIENT(server){CONNECTED}: Received Event SRVC_E_RSPRO_TX 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:100 RSPRO_CLIENT(server){CONNECTED}: Tx RSPRO createMappingRes MTC@4a2bd02e722f: setverdict(pass): pass -> pass, component reason not changed MTC@4a2bd02e722f: setverdict(pass): pass -> pass reason: ""RemsimBankd_Tests.ttcn:104 : "", component reason not changed MTC@4a2bd02e722f: Stopping testcase execution from "RemsimBankd_Tests.ttcn":104 [38;5;23m4814 [1;33mDLINP[0;m[38;5;23m [1;33mNOTICE[0;m[38;5;23m stream_cli.c:569 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CONNECTED} connection closed with srv[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:181 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CONNECTED} close()[0;m 4814 [1;33mDRSPRO[0;m [1;33mNOTICE[0;m ../rspro_client_fsm.c:154 RSPRO_CLIENT(server){CONNECTED}: RSPRO link to 127.0.0.10:9998 DOWN [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa_keepalive.c:351 IPA-KA(server){IDLE}: Stopping IPA keep-alive FSM[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:352 IPA-KA(server){IDLE}: Received Event OSMO_IPA_KA_E_STOP[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:159 IPA-KA(server){IDLE}: state_chg to INIT[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m fsm.c:569 IPA-KA(server){INIT}: Deallocated[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:162 RSPRO_CLIENT(server){CONNECTED}: Received Event SRVC_E_TCP_DOWN 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:310 RSPRO_CLIENT(server){CONNECTED}: ->REESTABLISH_DELAY delay 938ms; 62ms since last attempt [step 7/123@1s] 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:318 RSPRO_CLIENT(server){CONNECTED}: state_chg to REESTABLISH_DELAY 4814 [1;32mDRSPRO[0;m [1;32mINFO[0;m ../rspro_client_fsm.c:428 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Destroying existing connection to server [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:1068 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CLOSED} destroy()[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:181 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CLOSED} close()[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:1075 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CLOSED} delay free() in_cb_mask=0x02[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:150 CLICONN(server,r=127.0.0.10:9998<->l=127.0.0.1:41811){CLOSED} free(delayed)[0;m RSPRO_SRV0(5)@4a2bd02e722f: Final verdict of PTC: none MTC@4a2bd02e722f: Setting final verdict of the test case. MTC@4a2bd02e722f: Local verdict of MTC: pass MTC@4a2bd02e722f: Local verdict of PTC RSPRO_SRV0(5): none (pass -> pass) MTC@4a2bd02e722f: Test case TC_createMapping finished. Verdict: pass MTC@4a2bd02e722f: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/ttcn3-tcp…> RemsimBankd_Tests.TC_createMapping pass'. (17:13:07) load average: 1.10, 0.66, 0.64 [1;32m====== RemsimBankd_Tests.TC_createMapping pass ======[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=576) 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m fsm.c:318 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Timeout of T3 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:555 RSPRO_CLIENT(server){REESTABLISH_DELAY}: state_chg to REESTABLISH 4814 [1;32mDRSPRO[0;m [1;32mINFO[0;m ../rspro_client_fsm.c:454 RSPRO_CLIENT(server){REESTABLISH}: Creating TCP connection to server at 127.0.0.10:9998 [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m fsm.c:457 IPA-KA(server){INIT}: Allocated[0;m [38;5;23m4814 [1;31mDLINP[0;m[38;5;23m [1;31mERROR[0;m[38;5;23m stream_cli.c:446 CLICONN(server,){CONNECTING} connect failed (-111)[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m stream_cli.c:181 CLICONN(server,){CONNECTING} close()[0;m 4814 [1;33mDRSPRO[0;m [1;33mNOTICE[0;m ../rspro_client_fsm.c:154 RSPRO_CLIENT(server){REESTABLISH}: RSPRO link to 127.0.0.10:9998 DOWN [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m ipa_keepalive.c:351 IPA-KA(server){INIT}: Stopping IPA keep-alive FSM[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:352 IPA-KA(server){INIT}: Received Event OSMO_IPA_KA_E_STOP[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m ipa_keepalive.c:159 IPA-KA(server){INIT}: state_chg to INIT[0;m [38;5;23m4814 [1;34mDLINP[0;m[38;5;23m [1;34mDEBUG[0;m[38;5;23m fsm.c:569 IPA-KA(server){INIT}: Deallocated[0;m 4814 [1;34mDRSPRO[0;m [1;34mDEBUG[0;m ../rspro_client_fsm.c:162 RSPRO_CLIENT(server){REESTABLISH}: Received Event SRVC_E_TCP_DOWN [38;5;23m4814 [1;32mDLINP[0;m[38;5;23m [1;32mINFO[0;m[38;5;23m stream_cli.c:241 CLICONN(server,){CLOSED} not reconnecting, disabled[0;m Waiting for packet dumper to finish... 1 (prev_count=576, count=2988) MTC@4a2bd02e722f: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/ttcn3-tcp…> RemsimBankd_Tests.TC_createMapping pass' was executed successfully (exit status: 0). MTC@4a2bd02e722f: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/ttcn3-tcp…> RemsimBankd_Tests.TC_createMapping_busySlot'. ------ RemsimBankd_Tests.TC_createMapping_busySlot ------ (17:13:09) load average: 1.02, 0.64, 0.64 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/691/artifact…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/691/artifact…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 [1;34m[testenv][bankd] Stopping podman container[0m [0;94m[testenv][bankd] + ['podman', 'kill', 'testenv-remsim-all-osmocom-nightly-asan-20260427-1712-b0485ce5-0'][0m testenv-remsim-all-osmocom-nightly-asan-20260427-1712-b0485ce5-0 [1;34m[testenv][bankd] Stopping testsuite (3303231)[0m [0;94m[testenv] feed_watchdog_loop: podman container has stopped[0m [1;34m[testenv][bankd] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/691/artifact… [0m + RC=1 + [ 1 = 0 ] + uptime + grep --color=always -o load.* [01;31m[Kload average: 1.02, 0.64, 0.64[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.

1 1

Build failed in Jenkins: ttcn3-5gc-test-ogs #340
by jenkins＠lists.osmocom.org 28 Apr '26

28 Apr '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/340/display/redi…> Changes: ------------------------------------------ [...truncated 250.43 MiB...] [32m04/28 09:32:22.808[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/c998b3fc-42e4-41f1-9bd4-c7f… (../lib/sbi/client.c:744) [32m04/28 09:32:22.808[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m04/28 09:32:22.808[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:687) [32m04/28 09:32:22.808[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [4715] (../lib/sbi/nghttp2-server.c:1326) 0000: 00001a01 05000012 6b89bf61 96df697e ........k..a..i~ 0010: 9413ca43 5d8a0802 71403f71 915c1094 ...C]...q(a)?q.\.. 0020: c5a37f ... [32m04/28 09:32:22.809[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/c998b3fc-42e4-41f1-9bd4-c7… (../lib/sbi/client.c:744) [32m04/28 09:32:22.809[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m04/28 09:32:22.809[0m: [[33mausf[0m] [1;37mDEBUG[0m: ausf_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/ausf/ausf-sm.c:55) [32m04/28 09:32:22.809[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:331) [32m04/28 09:32:23.001[0m: [[33mudm[0m] [1;37mDEBUG[0m: udm_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/udm/udm-sm.c:59) [32m04/28 09:32:23.001[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:331) [32m04/28 09:32:23.001[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/c9b60a4c-42e4-41f1-b98f-09… (../lib/sbi/client.c:797) [32m04/28 09:32:23.001[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m04/28 09:32:23.001[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/client.c:548) [32m04/28 09:32:23.002[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [14563] (../lib/sbi/nghttp2-server.c:1630) [32m04/28 09:32:23.002[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/c9b60a4c-42e4-41f1-b98f-09e78cc535fb (../lib/sbi/nghttp2-server.c:1215) [32m04/28 09:32:23.002[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1219) [32m04/28 09:32:23.002[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/nghttp2-server.c:1221) [32m04/28 09:32:23.002[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/c9b60a4c-42e4-41f1-b98f-09e… (../lib/sbi/client.c:797) [32m04/28 09:32:23.002[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m04/28 09:32:23.002[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/client.c:548) [32m04/28 09:32:23.003[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [543] (../lib/sbi/nghttp2-server.c:1630) [32m04/28 09:32:23.003[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/c9b60a4c-42e4-41f1-b98f-09e78cc535fb (../lib/sbi/nghttp2-server.c:1215) [32m04/28 09:32:23.003[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1219) [32m04/28 09:32:23.003[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/nghttp2-server.c:1221) [32m04/28 09:32:23.003[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:53) [32m04/28 09:32:23.003[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:197) [32m04/28 09:32:23.003[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:687) [32m04/28 09:32:23.003[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [543] (../lib/sbi/nghttp2-server.c:1326) 0000: 00001a01 05000002 1f89f261 96df697e ...........a..i~ 0010: 9413ca43 5d8a0802 71403f71 915c132a ...C]...q(a)?q.\.* 0020: 62d1bf b.. [32m04/28 09:32:23.003[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/c9b60a4c-42e4-41f1-b98f-09e… (../lib/sbi/client.c:744) [32m04/28 09:32:23.003[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m04/28 09:32:23.003[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:687) [32m04/28 09:32:23.003[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [14563] (../lib/sbi/nghttp2-server.c:1326) 0000: 00001a01 05000038 e389c261 96df697e .......8...a..i~ 0010: 9413ca43 5d8a0802 71403f71 915c132a ...C]...q(a)?q.\.* 0020: 62d1bf b.. [32m04/28 09:32:23.004[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/c9b60a4c-42e4-41f1-b98f-09… (../lib/sbi/client.c:744) [32m04/28 09:32:23.004[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m04/28 09:32:23.004[0m: [[33mudm[0m] [1;37mDEBUG[0m: udm_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/udm/udm-sm.c:59) [32m04/28 09:32:23.004[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:331) Aborted [32m04/28 09:32:23.155[0m: [[33mudr[0m] [1;37mDEBUG[0m: udr_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/udr/udr-sm.c:52) [32m04/28 09:32:23.155[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:331) [32m04/28 09:32:23.156[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/c9cd1ef8-42e4-41f1-bf28-ef… (../lib/sbi/client.c:797) [32m04/28 09:32:23.156[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m04/28 09:32:23.156[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m04/28 09:32:23.156[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [55] (../lib/sbi/nghttp2-server.c:1630) [32m04/28 09:32:23.156[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/c9cd1ef8-42e4-41f1-bf28-ef5be2db2697 (../lib/sbi/nghttp2-server.c:1215) [32m04/28 09:32:23.156[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1219) [32m04/28 09:32:23.156[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1221) [32m04/28 09:32:23.156[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/c9cd1ef8-42e4-41f1-bf28-ef5… (../lib/sbi/client.c:797) [32m04/28 09:32:23.156[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m04/28 09:32:23.156[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m04/28 09:32:23.157[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [545] (../lib/sbi/nghttp2-server.c:1630) [32m04/28 09:32:23.157[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/c9cd1ef8-42e4-41f1-bf28-ef5be2db2697 (../lib/sbi/nghttp2-server.c:1215) [32m04/28 09:32:23.157[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1219) [32m04/28 09:32:23.157[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1221) [32m04/28 09:32:23.157[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:53) [32m04/28 09:32:23.157[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:197) [32m04/28 09:32:23.157[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:687) [32m04/28 09:32:23.157[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [545] (../lib/sbi/nghttp2-server.c:1326) 0000: 00000301 05000002 2189f3be ........!... [32m04/28 09:32:23.157[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/c9cd1ef8-42e4-41f1-bf28-ef5… (../lib/sbi/client.c:744) [32m04/28 09:32:23.157[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m04/28 09:32:23.157[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:687) [32m04/28 09:32:23.157[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [55] (../lib/sbi/nghttp2-server.c:1326) 0000: 00001a01 05000000 3789d061 96df697e ........7..a..i~ 0010: 9413ca43 5d8a0802 71403f71 915c132a ...C]...q(a)?q.\.* 0020: 62d1bf b.. [32m04/28 09:32:23.158[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/c9cd1ef8-42e4-41f1-bf28-ef… (../lib/sbi/client.c:744) [32m04/28 09:32:23.158[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m04/28 09:32:23.158[0m: [[33mudr[0m] [1;37mDEBUG[0m: udr_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/udr/udr-sm.c:52) [32m04/28 09:32:23.158[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:331) [32m04/28 09:32:23.355[0m: [[33mpcf[0m] [1;37mDEBUG[0m: pcf_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/pcf/pcf-sm.c:63) [32m04/28 09:32:23.355[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:331) [32m04/28 09:32:23.355[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/c9ebf45e-42e4-41f1-9cd7-53… (../lib/sbi/client.c:797) [32m04/28 09:32:23.355[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m04/28 09:32:23.355[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/client.c:548) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [5755] (../lib/sbi/nghttp2-server.c:1630) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/c9ebf45e-42e4-41f1-9cd7-53bb64197796 (../lib/sbi/nghttp2-server.c:1215) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1219) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/nghttp2-server.c:1221) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/c9ebf45e-42e4-41f1-9cd7-53b… (../lib/sbi/client.c:797) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[101] (../lib/sbi/client.c:546) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/client.c:548) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [547] (../lib/sbi/nghttp2-server.c:1630) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/c9ebf45e-42e4-41f1-9cd7-53bb64197796 (../lib/sbi/nghttp2-server.c:1215) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 101 (../lib/sbi/nghttp2-server.c:1219) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":25}] (../lib/sbi/nghttp2-server.c:1221) [32m04/28 09:32:23.356[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:53) [32m04/28 09:32:23.356[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:197) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:687) [32m04/28 09:32:23.356[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [547] (../lib/sbi/nghttp2-server.c:1326) 0000: 00000301 05000002 2389f3be ........#... [32m04/28 09:32:23.357[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/c9ebf45e-42e4-41f1-9cd7-53b… (../lib/sbi/client.c:744) [32m04/28 09:32:23.357[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m04/28 09:32:23.357[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:687) [32m04/28 09:32:23.357[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [5755] (../lib/sbi/nghttp2-server.c:1326) 0000: 00001a01 05000016 7b89f661 96df697e ........{..a..i~ 0010: 9413ca43 5d8a0802 71403f71 915c132a ...C]...q(a)?q.\.* 0020: 62d1bf b.. [32m04/28 09:32:23.357[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/c9ebf45e-42e4-41f1-9cd7-53… (../lib/sbi/client.c:744) [32m04/28 09:32:23.357[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m04/28 09:32:23.357[0m: [[33mpcf[0m] [1;37mDEBUG[0m: pcf_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/pcf/pcf-sm.c:63) [32m04/28 09:32:23.357[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:331) MTC@196d6fd55eda: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/ttcn3-tcpdump…> C5G_Tests.TC_ue_service_request_cm_idle_ul_data' was executed successfully (exit status: 0). MTC@196d6fd55eda: Test case TC_ue_service_request_cm_idle_ul_data started. GTP1U_EM(829)@196d6fd55eda: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 GTP1U_EM(829)@196d6fd55eda: setverdict(fail): none -> fail reason: "Could not connect UECUPS socket, check your configuration", new component reason: "Could not connect UECUPS socket, check your configuration" GTP1U_EM(829)@196d6fd55eda: Dynamic test case error: testcase.stop GTP1U_EM(829)@196d6fd55eda: setverdict(error): fail -> error GTP1U_EM(829)@196d6fd55eda: Final verdict of PTC: error TC_ue_service_request_cm_idle_ul_data-NGAP0(830)@196d6fd55eda: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 [32m04/28 09:32:23.425[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2 accepted[127.0.0.202]:50000 in ng-path module (../src/amf/ngap-sctp.c:113) [32m04/28 09:32:23.425[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_ACCEPT (../src/amf/amf-sm.c:86) [32m04/28 09:32:23.425[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2 accepted[127.0.0.202] in master_sm module (../src/amf/amf-sm.c:953) [32m04/28 09:32:23.427[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_initial(): ENTRY (../src/amf/ngap-sm.c:28) [32m04/28 09:32:23.427[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): ENTRY (../src/amf/ngap-sm.c:55) [32m04/28 09:32:23.427[0m: [[33mamf[0m] [1;32mINFO[0m: [Added] Number of gNBs is now 1 (../src/amf/context.c:1277) [32m04/28 09:32:23.428[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_ASSOC_CHANGE:[T:32769, F:0x0, S:0, I/O:64/30] (../src/amf/ngap-sctp.c:152) [32m04/28 09:32:23.428[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_COMM_UP (../src/amf/ngap-sctp.c:161) [32m04/28 09:32:23.428[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_SCTP_COMM_UP (../src/amf/amf-sm.c:86) [32m04/28 09:32:23.428[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] max_num_of_ostreams : 30 (../src/amf/amf-sm.c:1000) TC_ue_service_request_cm_idle_ul_data-NGAP1(831)@196d6fd55eda: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 [32m04/28 09:32:23.431[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2 accepted[127.0.0.202]:50001 in ng-path module (../src/amf/ngap-sctp.c:113) [32m04/28 09:32:23.431[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_ACCEPT (../src/amf/amf-sm.c:86) [32m04/28 09:32:23.431[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2 accepted[127.0.0.202] in master_sm module (../src/amf/amf-sm.c:953) [32m04/28 09:32:23.433[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_initial(): ENTRY (../src/amf/ngap-sm.c:28) [32m04/28 09:32:23.433[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): ENTRY (../src/amf/ngap-sm.c:55) [32m04/28 09:32:23.433[0m: [[33mamf[0m] [1;32mINFO[0m: [Added] Number of gNBs is now 2 (../src/amf/context.c:1277) [32m04/28 09:32:23.433[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_ASSOC_CHANGE:[T:32769, F:0x0, S:0, I/O:64/30] (../src/amf/ngap-sctp.c:152) [32m04/28 09:32:23.433[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_COMM_UP (../src/amf/ngap-sctp.c:161) [32m04/28 09:32:23.433[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_SCTP_COMM_UP (../src/amf/amf-sm.c:86) [32m04/28 09:32:23.433[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] max_num_of_ostreams : 30 (../src/amf/amf-sm.c:1000) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_MESSAGE (../src/amf/amf-sm.c:86) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): AMF_EVENT_NGAP_MESSAGE (../src/amf/ngap-sm.c:55) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: NGSetupRequest (../src/amf/ngap-handler.c:146) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: IP[127.0.0.202] GNB_ID[0x0] (../src/amf/ngap-handler.c:209) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:213) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: PagingDRX[0] (../src/amf/ngap-handler.c:217) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: TAC[1] (../src/amf/ngap-handler.c:251) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:303) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: S_NSSAI[SST:1 SD:0xffffff] (../src/amf/ngap-handler.c:356) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: TAC[1] (../src/amf/ngap-handler.c:72) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:73) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: SERVED_TAI_INDEX[0] (../src/amf/ngap-handler.c:78) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: PLMN_ID[MCC:999 MNC:70] (../src/amf/ngap-handler.c:100) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: S_NSSAI[SST:1 SD:0xffffff] (../src/amf/ngap-handler.c:105) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: NG-Setup response (../src/amf/ngap-path.c:305) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: NGSetupResponse (../src/amf/ngap-build.c:87) [32m04/28 09:32:23.437[0m: [[33mamf[0m] [1;37mDEBUG[0m: IP[127.0.0.202] RAN_ID[0] (../src/amf/ngap-path.c:64) MTC@196d6fd55eda: setverdict(pass): none -> pass MTC@196d6fd55eda: Dynamic test case error: Error message was received from MC: The connect operation refers to test component with component reference 829, which has already terminated. MTC@196d6fd55eda: setverdict(error): pass -> error [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_SHUTDOWN_EVENT:[T:32773, F:0x0, L:12] (../src/amf/ngap-sctp.c:193) [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_CONNREFUSED (../src/amf/amf-sm.c:86) [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] connection refused!!! (../src/amf/amf-sm.c:1013) [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): EXIT (../src/amf/ngap-sm.c:55) [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_final(): EXIT (../src/amf/ngap-sm.c:37) [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;32mINFO[0m: [Removed] Number of gNBs is now 1 (../src/amf/context.c:1305) TC_ue_service_request_cm_idle_ul_data0(832)@196d6fd55eda: Final verdict of PTC: none [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;37mDEBUG[0m: SCTP_SHUTDOWN_EVENT:[T:32773, F:0x0, L:12] (../src/amf/ngap-sctp.c:193) [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): AMF_EVENT_NGAP_LO_CONNREFUSED (../src/amf/amf-sm.c:86) [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;32mINFO[0m: gNB-N2[127.0.0.202] connection refused!!! (../src/amf/amf-sm.c:1013) [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_operational(): EXIT (../src/amf/ngap-sm.c:55) [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;37mDEBUG[0m: ngap_state_final(): EXIT (../src/amf/ngap-sm.c:37) [32m04/28 09:32:23.443[0m: [[33mamf[0m] [1;32mINFO[0m: [Removed] Number of gNBs is now 0 (../src/amf/context.c:1305) TC_ue_service_request_cm_idle_ul_data-NGAP1(831)@196d6fd55eda: Final verdict of PTC: none TC_ue_service_request_cm_idle_ul_data-NGAP0(830)@196d6fd55eda: Final verdict of PTC: none MTC@196d6fd55eda: Setting final verdict of the test case. MTC@196d6fd55eda: Local verdict of MTC: error MTC@196d6fd55eda: Local verdict of PTC GTP1U_EM(829): error (error -> error) MTC@196d6fd55eda: Local verdict of PTC TC_ue_service_request_cm_idle_ul_data-NGAP0(830): none (error -> error) MTC@196d6fd55eda: Local verdict of PTC TC_ue_service_request_cm_idle_ul_data-NGAP1(831): none (error -> error) MTC@196d6fd55eda: Local verdict of PTC TC_ue_service_request_cm_idle_ul_data0(832): none (error -> error) MTC@196d6fd55eda: Test case TC_ue_service_request_cm_idle_ul_data finished. Verdict: error MTC@196d6fd55eda: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/ttcn3-tcpdump…> C5G_Tests.TC_ue_service_request_cm_idle_ul_data error'. (09:32:23) load average: 2.93, 2.07, 1.33 [1;31m------ C5G_Tests.TC_ue_service_request_cm_idle_ul_data error ------[0m Waiting for packet dumper to finish... 0 (prev_count=-1, count=3464) [32m04/28 09:32:23.544[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): OGS_EVENT_NAME_SBI_TIMER (../src/amf/amf-sm.c:86) [32m04/28 09:32:23.544[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_TIMER (../lib/sbi/nf-sm.c:331) [32m04/28 09:32:23.544[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/ca0afdfe-42e4-41f1-af59-43… (../lib/sbi/client.c:797) [32m04/28 09:32:23.544[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m04/28 09:32:23.544[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m04/28 09:32:23.544[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [23905] (../lib/sbi/nghttp2-server.c:1630) [32m04/28 09:32:23.544[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/ca0afdfe-42e4-41f1-af59-43094209187a (../lib/sbi/nghttp2-server.c:1215) [32m04/28 09:32:23.544[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1219) [32m04/28 09:32:23.544[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1221) [32m04/28 09:32:23.544[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/ca0afdfe-42e4-41f1-af59-430… (../lib/sbi/client.c:797) [32m04/28 09:32:23.544[0m: [[33msbi[0m] [1;37mDEBUG[0m: SENDING...[100] (../lib/sbi/client.c:546) [32m04/28 09:32:23.544[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/client.c:548) [32m04/28 09:32:23.545[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM added [549] (../lib/sbi/nghttp2-server.c:1630) [32m04/28 09:32:23.545[0m: [[33msbi[0m] [1;37mDEBUG[0m: [PATCH] /nnrf-nfm/v1/nf-instances/ca0afdfe-42e4-41f1-af59-43094209187a (../lib/sbi/nghttp2-server.c:1215) [32m04/28 09:32:23.545[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED: 100 (../lib/sbi/nghttp2-server.c:1219) [32m04/28 09:32:23.545[0m: [[33msbi[0m] [1;37mDEBUG[0m: [{"op":"replace","path":"/nfStatus","value":"REGISTERED"},{"op":"replace","path":"/load","value":0}] (../lib/sbi/nghttp2-server.c:1221) [32m04/28 09:32:23.545[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_state_operational(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nrf-sm.c:53) [32m04/28 09:32:23.545[0m: [[33mnrf[0m] [1;37mDEBUG[0m: nrf_nf_state_registered(): OGS_EVENT_NAME_SBI_SERVER (../src/nrf/nf-sm.c:197) [32m04/28 09:32:23.545[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:687) [32m04/28 09:32:23.545[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [549] (../lib/sbi/nghttp2-server.c:1326) 0000: 00000301 05000002 2589f3be ........%... [32m04/28 09:32:23.545[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.10:7777/nnrf-nfm/v1/nf-instances/ca0afdfe-42e4-41f1-af59-430… (../lib/sbi/client.c:744) [32m04/28 09:32:23.545[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m04/28 09:32:23.545[0m: [[33msbi[0m] [1;37mDEBUG[0m: STATUS [204] (../lib/sbi/nghttp2-server.c:687) [32m04/28 09:32:23.545[0m: [[33msbi[0m] [1;37mDEBUG[0m: STREAM closed [23905] (../lib/sbi/nghttp2-server.c:1326) 0000: 00001a01 0500005d 6189c161 96df697e .......]a..a..i~ 0010: 9413ca43 5d8a0802 71403f71 915c132a ...C]...q(a)?q.\.* 0020: 62d1bf b.. [32m04/28 09:32:23.546[0m: [[33msbi[0m] [1;37mDEBUG[0m: [204:PATCH] http://127.0.0.200:7777/nnrf-nfm/v1/nf-instances/ca0afdfe-42e4-41f1-af59-43… (../lib/sbi/client.c:744) [32m04/28 09:32:23.546[0m: [[33msbi[0m] [1;37mDEBUG[0m: RECEIVED[0] (../lib/sbi/client.c:755) [32m04/28 09:32:23.546[0m: [[33mamf[0m] [1;37mDEBUG[0m: amf_state_operational(): OGS_EVENT_NAME_SBI_CLIENT (../src/amf/amf-sm.c:86) [32m04/28 09:32:23.546[0m: [[33msbi[0m] [1;37mDEBUG[0m: ogs_sbi_nf_state_registered(): OGS_EVENT_NAME_SBI_CLIENT (../lib/sbi/nf-sm.c:331) [1;34m[testenv] Looking for a coredump file[0m [1;91m[testenv] uecups-daemon unexpected exit during C5G_Tests.TC_ue_service_request_cm_idle_ul_data! rc=0[0m [0;94m[testenv] Waiting until test has stopped...[0m Waiting for packet dumper to finish... 1 (prev_count=3464, count=10132) MTC@196d6fd55eda: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/ttcn3-tcpdump…> C5G_Tests.TC_ue_service_request_cm_idle_ul_data error' was executed successfully (exit status: 0). MTC@196d6fd55eda: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/ws/ttcn3-tcpdump…> C5G_Tests.TC_ue_service_request_cm_idle_inact_sess'. ------ C5G_Tests.TC_ue_service_request_cm_idle_inact_sess ------ (09:32:25) load average: 2.69, 2.04, 1.33 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/340/artifact/log…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/340/artifact/log…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 [1;34m[testenv] Stopping podman container[0m [0;94m[testenv] + ['podman', 'kill', 'testenv-5gc-osmocom-nightly-20260428-0929-59ddd0be-0'][0m testenv-5gc-osmocom-nightly-20260428-0929-59ddd0be-0 [0;94m[testenv] Skipping clean up scripts, podman container has already stopped[0m [1;34m[testenv] Stopping testsuite (933045)[0m Error: container has already been removed Error: container has already been removed Error: container has already been removed Error: container has already been removed Error: container has already been removed [0;94m[testenv] feed_watchdog_loop: podman container has stopped[0m [1;34m[testenv] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-5gc-test-ogs/340/artifact/log… [0m + RC=1 + [ 1 = 0 ] + grep --color=always -o load.* + uptime [01;31m[Kload average: 2.69, 2.04, 1.33[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.

1 0

Build failed in Jenkins: ttcn3-bsc-test-sccplite #2932
by jenkins＠lists.osmocom.org 28 Apr '26

28 Apr '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/2932/displa…> Changes: ------------------------------------------ [...truncated 108.74 KiB...] CCLD RTP_CodecPort_CtrlFunct_part_5.so CCLD RTP_CodecPort_CtrlFunct_part_6.so CCLD RTP_CodecPort_CtrlFunct_part_7.so CCLD RTP_Emulation_part_1.so CCLD RTP_Emulation_part_2.so CCLD RTP_Emulation_part_3.so CCLD RTP_Emulation_part_4.so CCLD RTP_Emulation_part_5.so CCLD RTP_Emulation_part_6.so CCLD RTP_Emulation_part_7.so CCLD RTP_Types_part_1.so CCLD RTP_Types_part_2.so CCLD RTP_Types_part_3.so CCLD RTP_Types_part_4.so CCLD RTP_Types_part_5.so CCLD RTP_Types_part_6.so CCLD RTP_Types_part_7.so CCLD SCCP_Emulation_part_1.so CCLD SCCP_Emulation_part_2.so CCLD SCCP_Emulation_part_3.so CCLD SCCP_Emulation_part_4.so CCLD SCCP_Emulation_part_5.so CCLD SCCP_Emulation_part_6.so CCLD SCCP_Emulation_part_7.so CCLD SCCP_Templates_part_1.so CCLD SCCP_Templates_part_2.so CCLD SCCP_Templates_part_3.so CCLD SCCP_Templates_part_4.so CCLD SCCP_Templates_part_5.so CCLD SCCP_Templates_part_6.so CCLD SCCP_Templates_part_7.so CCLD SCCP_Types_part_1.so CCLD SCCP_Types_part_2.so CCLD SCCP_Types_part_3.so CCLD SCCP_Types_part_4.so CCLD SCCP_Types_part_5.so CCLD SCCP_Types_part_6.so CCLD SCCP_Types_part_7.so CCLD SCCPasp_Types_part_1.so CCLD SCCPasp_Types_part_2.so CCLD SCCPasp_Types_part_3.so CCLD SCCPasp_Types_part_4.so CCLD SCCPasp_Types_part_5.so CCLD SCCPasp_Types_part_6.so CCLD SCCPasp_Types_part_7.so CCLD SCTPasp_PortType_part_1.so CCLD SCTPasp_PortType_part_2.so CCLD SCTPasp_PortType_part_3.so CCLD SCTPasp_PortType_part_4.so CCLD SCTPasp_PortType_part_5.so CCLD SCTPasp_PortType_part_6.so CCLD SCTPasp_PortType_part_7.so CCLD SCTPasp_Types_part_1.so CCLD SCTPasp_Types_part_2.so CCLD SCTPasp_Types_part_3.so CCLD SCTPasp_Types_part_4.so CCLD SCTPasp_Types_part_5.so CCLD SCTPasp_Types_part_6.so CCLD SCTPasp_Types_part_7.so CCLD SDP_Templates_part_1.so CCLD SDP_Templates_part_2.so CCLD SDP_Templates_part_3.so CCLD SDP_Templates_part_4.so CCLD SDP_Templates_part_5.so CCLD SDP_Templates_part_6.so CCLD SDP_Templates_part_7.so CCLD SDP_Types_part_1.so CCLD SDP_Types_part_2.so CCLD SDP_Types_part_3.so CCLD SDP_Types_part_4.so CCLD SDP_Types_part_5.so CCLD SDP_Types_part_6.so CCLD SDP_Types_part_7.so CCLD Socket_API_Definitions_part_1.so CCLD Socket_API_Definitions_part_2.so CCLD Socket_API_Definitions_part_3.so CCLD Socket_API_Definitions_part_4.so CCLD Socket_API_Definitions_part_5.so CCLD Socket_API_Definitions_part_6.so CCLD Socket_API_Definitions_part_7.so CCLD StatsD_CodecPort_part_1.so CCLD StatsD_CodecPort_part_2.so CCLD StatsD_CodecPort_part_3.so CCLD StatsD_CodecPort_part_4.so CCLD StatsD_CodecPort_part_5.so CCLD StatsD_CodecPort_part_6.so CCLD StatsD_CodecPort_part_7.so CCLD StatsD_CodecPort_CtrlFunct_part_1.so CCLD StatsD_CodecPort_CtrlFunct_part_2.so CCLD StatsD_CodecPort_CtrlFunct_part_3.so CCLD StatsD_CodecPort_CtrlFunct_part_4.so CCLD StatsD_CodecPort_CtrlFunct_part_5.so CCLD StatsD_CodecPort_CtrlFunct_part_6.so CCLD StatsD_CodecPort_CtrlFunct_part_7.so CCLD StatsD_Types_part_1.so CCLD StatsD_Types_part_2.so CCLD StatsD_Types_part_3.so CCLD StatsD_Types_part_4.so CCLD StatsD_Types_part_5.so CCLD StatsD_Types_part_6.so CCLD StatsD_Types_part_7.so CCLD TCCConversion_Functions_part_1.so CCLD TCCConversion_Functions_part_2.so CCLD TCCConversion_Functions_part_3.so CCLD TCCConversion_Functions_part_4.so CCLD TCCConversion_Functions_part_5.so CCLD TCCConversion_Functions_part_6.so CCLD TCCConversion_Functions_part_7.so CCLD TCCInterface_Functions_part_1.so CCLD TCCInterface_Functions_part_2.so CCLD TCCInterface_Functions_part_3.so CCLD TCCInterface_Functions_part_4.so CCLD TCCInterface_Functions_part_5.so CCLD TCCInterface_Functions_part_6.so CCLD TCCInterface_Functions_part_7.so CCLD TELNETasp_PortType_part_1.so CCLD TELNETasp_PortType_part_2.so CCLD TELNETasp_PortType_part_3.so CCLD TELNETasp_PortType_part_4.so CCLD TELNETasp_PortType_part_5.so CCLD TELNETasp_PortType_part_6.so CCLD TELNETasp_PortType_part_7.so CCLD IPA_Emulation.so CCLD RAN_Adapter.so CCLD RAN_Emulation.so CCLD SCCP_Adapter.so CCLD SCCP_Mapping.so CCLD StatsD_Checker.so CCLD IPA_Emulation_part_1.so CCLD IPA_Emulation_part_2.so CCLD IPA_Emulation_part_3.so CCLD IPA_Emulation_part_4.so CCLD IPA_Emulation_part_5.so CCLD IPA_Emulation_part_6.so CCLD IPA_Emulation_part_7.so CCLD RAN_Adapter_part_1.so CCLD RAN_Adapter_part_2.so CCLD RAN_Adapter_part_3.so CCLD RAN_Adapter_part_4.so CCLD RAN_Adapter_part_5.so CCLD RAN_Adapter_part_6.so CCLD RAN_Adapter_part_7.so CCLD RAN_Emulation_part_1.so CCLD RAN_Emulation_part_2.so CCLD RAN_Emulation_part_3.so CCLD RAN_Emulation_part_4.so CCLD RAN_Emulation_part_5.so CCLD RAN_Emulation_part_6.so CCLD RAN_Emulation_part_7.so CCLD SCCP_Adapter_part_1.so CCLD SCCP_Adapter_part_2.so CCLD SCCP_Adapter_part_3.so CCLD SCCP_Adapter_part_4.so CCLD SCCP_Adapter_part_5.so CCLD SCCP_Adapter_part_6.so CCLD SCCP_Adapter_part_7.so CCLD SCCP_Mapping_part_1.so CCLD SCCP_Mapping_part_2.so CCLD SCCP_Mapping_part_3.so CCLD SCCP_Mapping_part_4.so CCLD SCCP_Mapping_part_5.so CCLD SCCP_Mapping_part_6.so CCLD SCCP_Mapping_part_7.so CCLD StatsD_Checker_part_1.so CCLD StatsD_Checker_part_2.so CCLD StatsD_Checker_part_3.so CCLD StatsD_Checker_part_4.so CCLD StatsD_Checker_part_5.so CCLD StatsD_Checker_part_6.so CCLD StatsD_Checker_part_7.so CCLD SDP_parse_.tab.so CCLD lex.SDP_parse_.so CCLD CBSP_CodecPort_CtrlFunctdef.so CCLD IPA_CodecPort_CtrlFunctDef.so CCLD IPL4asp_PT.so CCLD IPL4asp_discovery.so CCLD IuUP_EncDec.so CCLD MGCP_CodecPort_CtrlFunctDef.so CCLD Native_FunctionDefs.so CCLD RTP_CodecPort_CtrlFunctDef.so CCLD RTP_EncDec.so CCLD SCTPasp_PT.so CCLD SDP_EncDec.so CCLD StatsD_CodecPort_CtrlFunctdef.so CCLD TCCConversion.so CCLD TCCInterface.so CCLD TELNETasp_PT.so CCLD BSC_Tests make[1]: Leaving directory '<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_cache/p…'> [0;94m[testenv][sccplite] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_cache',> '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/bsc>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-bsc-sccplite-osmocom-nightly-20260426-0848-abd967b2-0', 'sh', '-c', "echo 'deb [signed-by=/obs.key] https://downloads.osmocom.org/packages/osmocom:/nightly/Debian_13/ ./' > /etc/apt/sources.list.d/osmocom.list"][0m [0;94m[testenv][sccplite] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_cache',> '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/bsc>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-bsc-sccplite-osmocom-nightly-20260426-0848-abd967b2-0', 'sh', '-c', 'echo \'Package: *\nPin: origin "downloads.osmocom.org"\nPin-Priority: 1100\n\' > /etc/apt/preferences.d/osmocom-apt-pin'][0m [0;94m[testenv][sccplite] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_cache',> '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/bsc>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-bsc-sccplite-osmocom-nightly-20260426-0848-abd967b2-0', 'apt-get', '-q', 'update'][0m Hit:1 http://deb.debian.org/debian trixie InRelease Hit:2 http://deb.debian.org/debian trixie-updates InRelease Hit:3 http://deb.debian.org/debian-security trixie-security InRelease Get:4 https://downloads.osmocom.org/packages/osmocom:/nightly/Debian_13 ./ InRelease [1623 B] Get:5 https://downloads.osmocom.org/packages/osmocom:/nightly/Debian_13 ./ Packages [210 kB] Err:5 https://downloads.osmocom.org/packages/osmocom:/nightly/Debian_13 ./ Packages File has unexpected size (210767 != 210491). Mirror sync in progress? [IP: 148.251.236.141 443] Hashes of expected file: - Filesize:210491 [weak] - SHA256:a0cdea838b724880f455d68eb433f6331a7d4113c2eb677ca2f7f6dbdf9a72e1 - SHA1:71780896257ca550e51b95e77fee4c63fcc9980c [weak] - MD5Sum:531a2d49d4e9f3ff121ca6aa5be602fc [weak] Release file created at: Sun, 26 Apr 2026 08:48:04 +0000 Fetched 1623 B in 0s (7135 B/s) Reading package lists... E: Failed to fetch https://downloads.osmocom.org/packages/osmocom:/nightly/Debian_13/./Package… File has unexpected size (210767 != 210491). Mirror sync in progress? [IP: 148.251.236.141 443] Hashes of expected file: - Filesize:210491 [weak] - SHA256:a0cdea838b724880f455d68eb433f6331a7d4113c2eb677ca2f7f6dbdf9a72e1 - SHA1:71780896257ca550e51b95e77fee4c63fcc9980c [weak] - MD5Sum:531a2d49d4e9f3ff121ca6aa5be602fc [weak] Release file created at: Sun, 26 Apr 2026 08:48:04 +0000 E: Some index files failed to download. They have been ignored, or old ones used instead. [1;91m[testenv][sccplite] Command failed unexpectedly[0m [0;94m[testenv][sccplite] Command: ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_cache',> '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TESTENV_INSTALL_DIR=/', '-e', 'TERM=dumb', '-e', 'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/bsc>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-e', 'PYTHONUNBUFFERED=1', '-t', 'testenv-bsc-sccplite-osmocom-nightly-20260426-0848-abd967b2-0', 'apt-get', '-q', 'update'][0m [0;94m[testenv][sccplite] Returncode: 100[0m [1;34m[testenv][sccplite] Stopping podman container[0m [0;94m[testenv][sccplite] + ['podman', 'kill', 'testenv-bsc-sccplite-osmocom-nightly-20260426-0848-abd967b2-0'][0m testenv-bsc-sccplite-osmocom-nightly-20260426-0848-abd967b2-0 Traceback (most recent call last): File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/./testen…",> line 139, in <module> main() File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/./testen…",> line 128, in main run() File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/./testen…",> line 75, in run testenv.podman.enable_binary_repo() File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…",> line 326, in enable_binary_repo exec_cmd(["apt-get", "-q", "update"]) File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…",> line 151, in exec_cmd return testenv.cmd.run( ^^^^^^^^^^^^^^^^ File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…",> line 142, in run exit_error_cmd(p, "Command failed unexpectedly") File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/ws/_testenv…",> line 88, in exit_error_cmd raise RuntimeError("shell command related error, find details right above this python trace") RuntimeError: shell command related error, find details right above this python trace [0;94m[testenv] feed_watchdog_loop: podman container has stopped[0m [1;34m[testenv][sccplite] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-sccplite/2932/artifa… [0m + RC=1 + [ 1 = 0 ] + + uptime grep --color=always -o load.* [01;31m[Kload average: 11.34, 4.81, 2.23[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results ERROR: Step ‘Publish JUnit test result report’ failed: No test report files were found. Configuration error?

1 2

Build failed in Jenkins: ttcn3-bts-test-io_uring #711
by jenkins＠lists.osmocom.org 27 Apr '26

27 Apr '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-io_uring/711/display…> Changes: ------------------------------------------ [...truncated 12.58 MiB...] <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_req_DCCH' time='1.999286'/> <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_req_ACCH' time='5.210515'/> <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_ind_DCCH' time='2.790807'/> <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_ind_ACCH' time='10.307504'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a51' time='2.460760'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a52' time='6.855896'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a53' time='2.652820'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a54' time='2.679361'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a51' time='9.560213'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a52' time='7.301921'> <failure type='fail-verdict'>"BTS_Tests.ttcn:7401 : Timeout waiting for LAPDm { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := true, ea := true }, ctrl := { i := { n_r := ?, p := ?, n_s := ?, spare := '0'B } }, len := ?, m := false, el := 1, payload := '063503'O, padding := ? } }" BTS_Tests.ttcn:9562 BTS_Tests control part BTS_Tests.ttcn:7909 TC_encr_cmd_a52 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a53' time='5.170322'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a54' time='5.166409'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_mdisc' time='1.150996'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_msg_type' time='1.240032'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_sequence' time='1.221804'/> <testcase classname='BTS_Tests:hopping' name='TC_lapdm_selftest' time='0.002190'/> <testcase classname='BTS_Tests:hopping' name='TC_tch_sign_l2_fill_frame' time='18.112124'/> <testcase classname='BTS_Tests:hopping' name='TC_tch_sign_l2_fill_frame_dtxd' time='2.065481'> <failure type='fail-verdict'>Received DTX TCH fill frame with bad frame number: 175 (mod 104: 71) (mod 26: 19) BTS_Tests.ttcn:9573 BTS_Tests control part BTS_Tests.ttcn:8104 TC_tch_sign_l2_fill_frame_dtxd testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_chopped_ipa_ping' time='24.905228'/> <testcase classname='BTS_Tests:hopping' name='TC_chopped_ipa_payload' time='42.601872'/> <testcase classname='BTS_Tests:hopping' name='TC_ms_pwr_ctrl_constant' time='16.199066'/> <testcase classname='BTS_Tests:hopping' name='TC_ms_pwr_ctrl_pf_ewma' time='30.895186'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_no_rtp_tchf' time='7.309501'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_no_rtp_tchh' time='5.408134'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_rtp_tchf' time='7.509984'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_rtp_tchh' time='5.404229'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_osmux_tchf' time='3.427763'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_osmux_tchh' time='3.448857'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf144' time='1.994705'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf96' time='1.851592'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf48' time='2.055852'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchh48' time='5.238365'> <failure type='fail-verdict'>Timeout waiting for matching Downlink data frame BTS_Tests.ttcn:9591 BTS_Tests control part BTS_Tests.ttcn:8874 TC_data_rtp_tchh48 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf24' time='1.648245'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchh24' time='5.246498'> <failure type='fail-verdict'>Timeout waiting for matching Downlink data frame BTS_Tests.ttcn:9593 BTS_Tests control part BTS_Tests.ttcn:8943 TC_data_rtp_tchh24 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf144' time='1.928788'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf96' time='1.943497'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf48' time='1.959891'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchh48' time='2.077535'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf24' time='1.969662'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchh24' time='1.992114'/> <testcase classname='BTS_Tests:hopping' name='TC_early_immediate_assignment' time='3.506992'/> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_rxqual_thresh' time='9.257983'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9604 BTS_Tests control part BTS_Tests.ttcn:9238 TC_acch_overpower_rxqual_thresh testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_rxqual_thresh_dtx' time='8.997679'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9605 BTS_Tests control part BTS_Tests.ttcn:9279 TC_acch_overpower_rxqual_thresh_dtx testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_always_on_facch' time='9.031980'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9606 BTS_Tests control part BTS_Tests.ttcn:9311 TC_acch_overpower_always_on_facch testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_always_on_sacch' time='9.001118'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9607 BTS_Tests control part BTS_Tests.ttcn:9343 TC_acch_overpower_always_on_sacch testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_limit' time='9.006429'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9608 BTS_Tests control part BTS_Tests.ttcn:9374 TC_acch_overpower_limit testcase </failure> </testcase> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbch_load_idle_no_cbch' time='11.154020'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_1block' time='14.209697'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_2block' time='14.191827'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_3block' time='14.166450'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_4block' time='14.098721'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_multi' time='20.188785'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_schedule' time='14.124146'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_only' time='16.190988'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_and_normal' time='17.183473'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_then_null' time='26.111757'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch4_load_idle' time='16.040205'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch4_load_overload' time='18.177610'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_1block' time='14.196425'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_2block' time='14.185239'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_3block' time='14.218223'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_4block' time='14.184899'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_multi' time='20.214189'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_schedule' time='14.130635'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_default_only' time='16.187107'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_default_and_normal' time='17.171094'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch8_load_idle' time='16.138703'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch8_load_overload' time='18.183056'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_p1ro' time='12.153880'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_p1ro_end' time='16.137517'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_pcu' time='1.108806'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi0' time='2.854903'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi0_nopayload' time='21.449770'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi3' time='21.264997'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi4' time='21.256873'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_contention' time='21.309519'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_retransmit' time='3.124210'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_retransmit_bts' time='81.500350'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_invalid_resp' time='23.089972'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_dm' time='13.907625'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_establish_ign_first_sabm' time='7.844853'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_iframe_seq_and_ack' time='29.522212'> <failure type='fail-verdict'>Received RSL ERROR IND { msg_disc := { msg_group := RSL_MDISC_RLL (1), transparent := false }, msg_type := RSL_MT_ERROR_IND (3), ies := { { iei := RSL_IE_CHAN_NR (1), body := { chan_nr := { u := { sdcch8 := { tag := '01'B, sub_chan := 4 } }, tn := 6 } } }, { iei := RSL_IE_LINK_IDENT (2), body := { link_id := { c := FACCH_SDCCH (0), na := false, prio := SAPI0_PRIO_NORMAL (0), sapi := 0 } } }, { iei := RSL_IE_RLM_CAUSE (22), body := { rlm_cause := { len := 1, payload := '01'O } } } } } 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='24.556165'> <failure type='fail-verdict'>Received RSL ERROR IND { msg_disc := { msg_group := RSL_MDISC_RLL (1), transparent := false }, msg_type := RSL_MT_ERROR_IND (3), ies := { { iei := RSL_IE_CHAN_NR (1), body := { chan_nr := { u := { sdcch8 := { tag := '01'B, sub_chan := 4 } }, tn := 6 } } }, { iei := RSL_IE_LINK_IDENT (2), body := { link_id := { c := FACCH_SDCCH (0), na := false, prio := SAPI0_PRIO_NORMAL (0), sapi := 0 } } }, { iei := RSL_IE_RLM_CAUSE (22), body := { rlm_cause := { len := 1, payload := '01'O } } } } } 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='29.513009'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" 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='2.821780'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_rec_invalid_frame' time='119.027238'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:904 : Missing LAPDm_RR RSP" 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='13.417895'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { s := { n_r := 1, p_f := false, s := '10'B, spare := '01'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++++\") } } }" 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='48.033967'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := true, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { u := { u := '011'B, p_f := true, u2 := '00'B, spare := '11'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++\") } } }" 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='47.710391'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" 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='6.566417'> <failure type='fail-verdict'>Timeout waiting for RR or REJ 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.588016'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_incorrect_c' time='23.288463'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" 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.904809'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { u := { u := '011'B, p_f := true, u2 := '00'B, spare := '11'B } }, len := 5, m := false, el := 1, payload := '1BA64AC322'O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"+++++++++++++++\") } } }" 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='12.245487'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { s := { n_r := 1, p_f := false, s := '10'B, spare := '01'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++++\") } } }" 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='2.418180'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_vhh' time='2.554680'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_hvhh' time='2.551323'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_ipa_vff' time='2.524005'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vff' time='2.529327'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vhh' time='2.527923'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_hvhh' time='2.505610'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vff' time='1.301637'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vhh' time='1.340343'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_hvhh' time='1.357754'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_ipa_vff' time='1.302847'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vff' time='1.255674'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vhh' time='1.293539'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_hvhh' time='1.319654'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vbs_notification' time='4.647209'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_uplink_free_and_busy' time='1.738628'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_fail' time='16.368936'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_est_rel' time='1.388530'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_listener_det' time='3.309798'/> </testsuite> <?xml version="1.0"?> <testsuite name='Titan' tests='17' failures='0' errors='0' skipped='0' inconc='0' time='96.00'> <testcase classname='BTS_Tests_OML' name='TC_wrong_mdisc' time='10.775773'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_msgtype' time='0.698215'/> <testcase classname='BTS_Tests_OML' name='TC_short_length' time='0.712596'/> <testcase classname='BTS_Tests_OML' name='TC_long_length' time='0.688467'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_placement' time='0.699705'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_seq' time='0.719588'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_obj_class' time='0.674624'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_bts_nr' time='0.705865'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_trx_nr' time='0.684141'/> <testcase classname='BTS_Tests_OML' name='TC_radio_carrier_opstart_noattr' time='0.684370'/> <testcase classname='BTS_Tests_OML' name='TC_bts_opstart' time='0.698704'/> <testcase classname='BTS_Tests_OML' name='TC_bts_opstart_noattr' time='0.716697'/> <testcase classname='BTS_Tests_OML' name='TC_ts_opstart' time='0.707390'/> <testcase classname='BTS_Tests_OML' name='TC_ts_opstart_noattr' time='0.708133'/> <testcase classname='BTS_Tests_OML' name='TC_initial_state_reports' time='0.695629'/> <testcase classname='BTS_Tests_OML' name='TC_ipa_osmo_pcu_anr_fwd' time='0.728478'/> <testcase classname='BTS_Tests_OML' name='TC_ipa_rsl_connect_nack' time='0.703868'/> </testsuite> + check_respawn_count + set +x [0;31m ================================================================ WARNING: osmo-bts was respawned 4 times (expected: 3)! (OS#6794) ================================================================ [0m+ RC=1 + uptime + grep --color=always -o load.* [01;31m[Kload average: 1.20, 1.20, 2.05[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.

1 4

Build failed in Jenkins: ttcn3-bts-test #3121
by jenkins＠lists.osmocom.org 26 Apr '26

26 Apr '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test/3121/display/redirect> Changes: ------------------------------------------ [...truncated 12.47 MiB...] <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a53' time='5.145884'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a54' time='5.169128'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_mdisc' time='1.213694'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_msg_type' time='1.311683'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_sequence' time='1.230756'/> <testcase classname='BTS_Tests:hopping' name='TC_lapdm_selftest' time='0.005837'/> <testcase classname='BTS_Tests:hopping' name='TC_tch_sign_l2_fill_frame' time='18.283671'/> <testcase classname='BTS_Tests:hopping' name='TC_tch_sign_l2_fill_frame_dtxd' time='1.956897'> <failure type='fail-verdict'>Received DTX TCH fill frame with bad frame number: 175 (mod 104: 71) (mod 26: 19) BTS_Tests.ttcn:9573 BTS_Tests control part BTS_Tests.ttcn:8104 TC_tch_sign_l2_fill_frame_dtxd testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_chopped_ipa_ping' time='24.669977'/> <testcase classname='BTS_Tests:hopping' name='TC_chopped_ipa_payload' time='42.470573'/> <testcase classname='BTS_Tests:hopping' name='TC_ms_pwr_ctrl_constant' time='16.303626'/> <testcase classname='BTS_Tests:hopping' name='TC_ms_pwr_ctrl_pf_ewma' time='31.234408'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_no_rtp_tchf' time='7.355384'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_no_rtp_tchh' time='5.399899'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_rtp_tchf' time='7.685151'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_rtp_tchh' time='6.650281'> <failure type='fail-verdict'>Connection refused (unexpected) BTS_Tests.ttcn:9584 BTS_Tests control part BTS_Tests.ttcn:8525 TC_speech_rtp_tchh testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_speech_osmux_tchf' time='7.213442'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_osmux_tchh' time='4.585842'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf144' time='1.976990'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf96' time='2.033733'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf48' time='2.164568'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchh48' time='5.219094'> <failure type='fail-verdict'>Timeout waiting for matching Downlink data frame BTS_Tests.ttcn:9591 BTS_Tests control part BTS_Tests.ttcn:8874 TC_data_rtp_tchh48 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf24' time='1.704182'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchh24' time='7.066227'> <failure type='fail-verdict'>Timeout waiting for matching Downlink data frame BTS_Tests.ttcn:9593 BTS_Tests control part BTS_Tests.ttcn:8943 TC_data_rtp_tchh24 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf144' time='1.973679'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf96' time='1.961953'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf48' time='2.012560'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchh48' time='5.621426'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf24' time='1.901383'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchh24' time='2.170292'/> <testcase classname='BTS_Tests:hopping' name='TC_early_immediate_assignment' time='3.472370'/> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_rxqual_thresh' time='8.997387'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9604 BTS_Tests control part BTS_Tests.ttcn:9238 TC_acch_overpower_rxqual_thresh testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_rxqual_thresh_dtx' time='8.946161'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9605 BTS_Tests control part BTS_Tests.ttcn:9279 TC_acch_overpower_rxqual_thresh_dtx testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_always_on_facch' time='9.094997'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9606 BTS_Tests control part BTS_Tests.ttcn:9311 TC_acch_overpower_always_on_facch testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_always_on_sacch' time='9.169620'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9607 BTS_Tests control part BTS_Tests.ttcn:9343 TC_acch_overpower_always_on_sacch testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_limit' time='8.903091'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9608 BTS_Tests control part BTS_Tests.ttcn:9374 TC_acch_overpower_limit testcase </failure> </testcase> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbch_load_idle_no_cbch' time='11.145009'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_1block' time='14.207285'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_2block' time='14.149293'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_3block' time='11.505414'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_4block' time='14.156068'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_multi' time='20.176249'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_schedule' time='14.137404'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_only' time='16.049133'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_and_normal' time='16.794429'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_then_null' time='27.566746'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch4_load_idle' time='15.580204'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch4_load_overload' time='17.972643'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_1block' time='13.976664'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_2block' time='13.963554'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_3block' time='14.547615'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_4block' time='14.019537'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_multi' time='20.018977'> <failure type='fail-verdict'>Timeout waiting for "Basic" CBCH block 1 of msg 1 BTS_Tests_SMSCB.ttcn:1108 BTS_Tests_SMSCB control part BTS_Tests_SMSCB.ttcn:617 TC_sms_cb_cmd_sdcch8_multi testcase </failure> </testcase> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_schedule' time='16.932846'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_default_only' time='16.065484'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_default_and_normal' time='17.050955'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch8_load_idle' time='16.024973'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch8_load_overload' time='18.147563'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_p1ro' time='12.459908'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_p1ro_end' time='16.093100'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_pcu' time='0.833702'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi0' time='7.743249'> <failure type='fail-verdict'> BTS_Tests_LAPDm.ttcn:1474 BTS_Tests_LAPDm control part BTS_Tests_LAPDm.ttcn:152 TC_sabm_ua_dcch_sapi0 testcase </failure> </testcase> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi0_nopayload' time='21.918016'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi3' time='21.283510'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi4' time='21.213268'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_contention' time='21.198654'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_retransmit' time='3.067100'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_retransmit_bts' time='81.427871'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_invalid_resp' time='23.048423'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_dm' time='14.753400'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_establish_ign_first_sabm' time='7.874426'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_iframe_seq_and_ack' time='29.511815'> <failure type='fail-verdict'>Received RSL ERROR IND { msg_disc := { msg_group := RSL_MDISC_RLL (1), transparent := false }, msg_type := RSL_MT_ERROR_IND (3), ies := { { iei := RSL_IE_CHAN_NR (1), body := { chan_nr := { u := { sdcch8 := { tag := '01'B, sub_chan := 4 } }, tn := 6 } } }, { iei := RSL_IE_LINK_IDENT (2), body := { link_id := { c := FACCH_SDCCH (0), na := false, prio := SAPI0_PRIO_NORMAL (0), sapi := 0 } } }, { iei := RSL_IE_RLM_CAUSE (22), body := { rlm_cause := { len := 1, payload := '01'O } } } } } 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='24.621870'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" 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='29.817593'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" 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='2.841799'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_rec_invalid_frame' time='79.152142'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:899 : Missing LAPDm_RR RSP" 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='30.988742'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" 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='48.723256'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := true, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { u := { u := '011'B, p_f := true, u2 := '00'B, spare := '11'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++\") } } }" 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='44.032473'> <failure type='fail-verdict'>Missing RSL RLL ERROR INDICATION 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='6.561820'> <failure type='fail-verdict'>Timeout waiting for RR or REJ 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.543682'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_incorrect_c' time='22.952133'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" 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='18.699435'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { u := { u := '011'B, p_f := true, u2 := '00'B, spare := '11'B } }, len := 5, m := false, el := 1, payload := '872BF17A64'O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"+++++++++++++++\") } } }" 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='12.213828'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { s := { n_r := 1, p_f := false, s := '10'B, spare := '01'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++++\") } } }" 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='2.269321'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_vhh' time='6.329081'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_hvhh' time='2.454125'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_ipa_vff' time='2.417106'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vff' time='2.453367'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vhh' time='2.482109'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_hvhh' time='2.328260'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vff' time='1.209398'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vhh' time='1.690944'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_hvhh' time='1.290599'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_ipa_vff' time='1.245192'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vff' time='1.285805'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vhh' time='1.441740'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_hvhh' time='1.453377'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vbs_notification' time='4.667467'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_uplink_free_and_busy' time='1.799953'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_fail' time='16.879154'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_est_rel' time='1.265237'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_listener_det' time='3.272649'/> </testsuite> <?xml version="1.0"?> <testsuite name='Titan' tests='17' failures='0' errors='0' skipped='0' inconc='0' time='95.00'> <testcase classname='BTS_Tests_OML' name='TC_wrong_mdisc' time='10.611642'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_msgtype' time='0.683000'/> <testcase classname='BTS_Tests_OML' name='TC_short_length' time='0.704630'/> <testcase classname='BTS_Tests_OML' name='TC_long_length' time='0.696264'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_placement' time='0.710131'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_seq' time='0.684658'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_obj_class' time='0.686886'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_bts_nr' time='0.698176'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_trx_nr' time='0.698951'/> <testcase classname='BTS_Tests_OML' name='TC_radio_carrier_opstart_noattr' time='0.706529'/> <testcase classname='BTS_Tests_OML' name='TC_bts_opstart' time='0.748483'/> <testcase classname='BTS_Tests_OML' name='TC_bts_opstart_noattr' time='0.696941'/> <testcase classname='BTS_Tests_OML' name='TC_ts_opstart' time='0.723960'/> <testcase classname='BTS_Tests_OML' name='TC_ts_opstart_noattr' time='0.707318'/> <testcase classname='BTS_Tests_OML' name='TC_initial_state_reports' time='0.700995'/> <testcase classname='BTS_Tests_OML' name='TC_ipa_osmo_pcu_anr_fwd' time='0.758001'/> <testcase classname='BTS_Tests_OML' name='TC_ipa_rsl_connect_nack' time='0.700248'/> </testsuite> + check_respawn_count + set +x [0;31m ================================================================ WARNING: osmo-bts was respawned 7 times (expected: 3)! (OS#6794) ================================================================ [0m+ RC=1 + uptime + grep --color=always -o load.* [01;31m[Kload average: 10.97, 11.69, 10.53[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.

1 0

Jenkins build became unstable: ttcn3-bsc-test-asan #689
by jenkins＠lists.osmocom.org 25 Apr '26

25 Apr '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-bsc-test-asan/689/display/red…>

1 1

Jenkins build became unstable: ttcn3-upf-test #1329
by jenkins＠lists.osmocom.org 25 Apr '26

25 Apr '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-upf-test/1329/display/redirect>

1 1

Build failed in Jenkins: ttcn3-bts-test-latest #2769
by jenkins＠lists.osmocom.org 25 Apr '26

25 Apr '26

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-bts-test-latest/2769/display/…> Changes: [Vadim Yanitskiy] debian-trixie-build: add tshark ------------------------------------------ [...truncated 12.36 MiB...] <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" BTS_Tests.ttcn:9551 BTS_Tests control part BTS_Tests.ttcn:7519 TC_rll_rel_req testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_req_DCCH' time='2.344906'/> <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_req_ACCH' time='5.289079'/> <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_ind_DCCH' time='2.931186'/> <testcase classname='BTS_Tests:hopping' name='TC_rll_unit_data_ind_ACCH' time='10.582431'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a51' time='2.644764'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a52' time='2.703853'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a53' time='2.698119'/> <testcase classname='BTS_Tests:hopping' name='TC_chan_act_a54' time='2.703078'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a51' time='5.249608'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a52' time='5.215171'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a53' time='5.229516'/> <testcase classname='BTS_Tests:hopping' name='TC_encr_cmd_a54' time='5.222522'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_mdisc' time='1.183629'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_msg_type' time='1.255913'/> <testcase classname='BTS_Tests:hopping' name='TC_err_rep_wrong_sequence' time='1.213505'/> <testcase classname='BTS_Tests:hopping' name='TC_lapdm_selftest' time='0.004968'/> <testcase classname='BTS_Tests:hopping' name='TC_tch_sign_l2_fill_frame' time='18.426382'/> <testcase classname='BTS_Tests:hopping' name='TC_tch_sign_l2_fill_frame_dtxd' time='2.141266'> <failure type='fail-verdict'>Received DTX TCH fill frame with bad frame number: 175 (mod 104: 71) (mod 26: 19) BTS_Tests.ttcn:9573 BTS_Tests control part BTS_Tests.ttcn:8104 TC_tch_sign_l2_fill_frame_dtxd testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_chopped_ipa_ping' time='24.689894'/> <testcase classname='BTS_Tests:hopping' name='TC_chopped_ipa_payload' time='42.611048'/> <testcase classname='BTS_Tests:hopping' name='TC_ms_pwr_ctrl_constant' time='16.478965'/> <testcase classname='BTS_Tests:hopping' name='TC_ms_pwr_ctrl_pf_ewma' time='31.650898'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_no_rtp_tchf' time='7.402883'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_no_rtp_tchh' time='5.426612'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_rtp_tchf' time='7.619686'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_rtp_tchh' time='5.458401'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_osmux_tchf' time='3.344568'/> <testcase classname='BTS_Tests:hopping' name='TC_speech_osmux_tchh' time='3.431872'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf144' time='2.085103'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf96' time='2.072718'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf48' time='2.125875'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchh48' time='5.290476'> <failure type='fail-verdict'>Timeout waiting for matching Downlink data frame BTS_Tests.ttcn:9591 BTS_Tests control part BTS_Tests.ttcn:8874 TC_data_rtp_tchh48 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchf24' time='1.751844'/> <testcase classname='BTS_Tests:hopping' name='TC_data_rtp_tchh24' time='5.263104'> <failure type='fail-verdict'>Timeout waiting for matching Downlink data frame BTS_Tests.ttcn:9593 BTS_Tests control part BTS_Tests.ttcn:8943 TC_data_rtp_tchh24 testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf144' time='1.933629'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf96' time='2.025079'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf48' time='1.960834'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchh48' time='2.049769'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchf24' time='2.000337'/> <testcase classname='BTS_Tests:hopping' name='TC_data_facch_tchh24' time='2.037702'/> <testcase classname='BTS_Tests:hopping' name='TC_early_immediate_assignment' time='3.579064'/> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_rxqual_thresh' time='9.103751'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9604 BTS_Tests control part BTS_Tests.ttcn:9238 TC_acch_overpower_rxqual_thresh testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_rxqual_thresh_dtx' time='9.046926'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9605 BTS_Tests control part BTS_Tests.ttcn:9279 TC_acch_overpower_rxqual_thresh_dtx testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_always_on_facch' time='9.056334'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9606 BTS_Tests control part BTS_Tests.ttcn:9311 TC_acch_overpower_always_on_facch testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_always_on_sacch' time='9.047774'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9607 BTS_Tests control part BTS_Tests.ttcn:9343 TC_acch_overpower_always_on_sacch testcase </failure> </testcase> <testcase classname='BTS_Tests:hopping' name='TC_acch_overpower_limit' time='9.034895'> <failure type='fail-verdict'>Timeout waiting for L1CTL DATA.ind BTS_Tests.ttcn:9608 BTS_Tests control part BTS_Tests.ttcn:9374 TC_acch_overpower_limit testcase </failure> </testcase> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbch_load_idle_no_cbch' time='11.150342'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_1block' time='14.241887'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_2block' time='14.197782'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_3block' time='14.199708'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_4block' time='14.208058'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_multi' time='20.209215'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_schedule' time='14.149343'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_only' time='16.188655'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_and_normal' time='17.190179'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch4_default_then_null' time='26.183465'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch4_load_idle' time='16.032694'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch4_load_overload' time='18.157671'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_1block' time='14.186354'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_2block' time='14.260569'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_3block' time='14.221077'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_4block' time='14.181927'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_multi' time='20.228144'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_schedule' time='14.186370'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_default_only' time='16.196491'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_sms_cb_cmd_sdcch8_default_and_normal' time='17.192331'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch8_load_idle' time='16.128078'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_cbc_sdcch8_load_overload' time='18.196846'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_p1ro' time='12.171294'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_p1ro_end' time='16.148835'/> <testcase classname='BTS_Tests_SMSCB:hopping' name='TC_etws_pcu' time='1.094612'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi0' time='2.898325'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi0_nopayload' time='21.466406'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi3' time='21.202278'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_ua_dcch_sapi4' time='21.266728'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_contention' time='21.223796'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_retransmit' time='3.155021'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_retransmit_bts' time='81.418492'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_invalid_resp' time='23.437837'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_dm' time='14.071657'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_establish_ign_first_sabm' time='7.962791'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_iframe_seq_and_ack' time='29.589161'> <failure type='fail-verdict'>Received RSL ERROR IND { msg_disc := { msg_group := RSL_MDISC_RLL (1), transparent := false }, msg_type := RSL_MT_ERROR_IND (3), ies := { { iei := RSL_IE_CHAN_NR (1), body := { chan_nr := { u := { sdcch8 := { tag := '01'B, sub_chan := 4 } }, tn := 6 } } }, { iei := RSL_IE_LINK_IDENT (2), body := { link_id := { c := FACCH_SDCCH (0), na := false, prio := SAPI0_PRIO_NORMAL (0), sapi := 0 } } }, { iei := RSL_IE_RLM_CAUSE (22), body := { rlm_cause := { len := 1, payload := '01'O } } } } } 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='24.617794'> <failure type='fail-verdict'>Received RSL ERROR IND { msg_disc := { msg_group := RSL_MDISC_RLL (1), transparent := false }, msg_type := RSL_MT_ERROR_IND (3), ies := { { iei := RSL_IE_CHAN_NR (1), body := { chan_nr := { u := { sdcch8 := { tag := '01'B, sub_chan := 4 } }, tn := 6 } } }, { iei := RSL_IE_LINK_IDENT (2), body := { link_id := { c := FACCH_SDCCH (0), na := false, prio := SAPI0_PRIO_NORMAL (0), sapi := 0 } } }, { iei := RSL_IE_RLM_CAUSE (22), body := { rlm_cause := { len := 1, payload := '01'O } } } } } 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='29.633241'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" 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='2.877684'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_rec_invalid_frame' time='107.523970'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:883 : Missing LAPDm_RR RSP" 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='13.642758'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { s := { n_r := 1, p_f := false, s := '10'B, spare := '01'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++++\") } } }" 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='48.716491'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := true, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { u := { u := '011'B, p_f := true, u2 := '00'B, spare := '11'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++\") } } }" 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='39.913823'> <failure type='fail-verdict'>Missing RSL RLL ERROR INDICATION 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='6.704723'> <failure type='fail-verdict'>Timeout waiting for RR or REJ 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.837829'/> <testcase classname='BTS_Tests_LAPDm:hopping' name='TC_sabm_incorrect_c' time='23.049729'> <failure type='fail-verdict'>"BTS_Tests.ttcn:732 : Tguard timeout" 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='16.171423'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { u := { u := '011'B, p_f := true, u2 := '00'B, spare := '11'B } }, len := 5, m := false, el := 1, payload := '8F40CFF662'O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"+++++++++++++++\") } } }" 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='12.398225'> <failure type='fail-verdict'>"BTS_Tests_LAPDm.ttcn:1023 : received unexpected LAPDm { sacch := false, sapi := 0, lapdm := { ab := { addr := { spare := '0'B, lpd := 0, sapi := 0, c_r := false, ea := true }, ctrl := { s := { n_r := 1, p_f := false, s := '10'B, spare := '01'B } }, len := 0, m := false, el := 1, payload := ''O, padding := '2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O (\"++++++++++++++++++++\") } } }" 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='2.442050'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_vhh' time='2.512188'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_hvhh' time='2.532445'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_ipa_vff' time='2.553690'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vff' time='2.482039'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_vhh' time='2.539977'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_act_dyn_osmo_hvhh' time='2.500077'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vff' time='1.264758'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_vhh' time='1.314689'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_hvhh' time='1.296566'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_ipa_vff' time='1.285516'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vff' time='1.269106'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_vhh' time='1.323513'/> <testcase classname='BTS_Tests_VAMOS:hopping' name='TC_vamos_chan_mode_modify_dyn_osmo_hvhh' time='1.311825'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vbs_notification' time='4.672129'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_uplink_free_and_busy' time='1.726354'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_fail' time='16.609822'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_talker_est_rel' time='1.381901'/> <testcase classname='BTS_Tests_ASCI:hopping' name='TC_vgcs_listener_det' time='3.326112'/> </testsuite> <?xml version="1.0"?> <testsuite name='Titan' tests='17' failures='0' errors='0' skipped='0' inconc='0' time='97.00'> <testcase classname='BTS_Tests_OML' name='TC_wrong_mdisc' time='10.749189'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_msgtype' time='0.689803'/> <testcase classname='BTS_Tests_OML' name='TC_short_length' time='0.715889'/> <testcase classname='BTS_Tests_OML' name='TC_long_length' time='0.698771'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_placement' time='0.716694'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_seq' time='0.709468'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_obj_class' time='0.707136'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_bts_nr' time='0.713036'/> <testcase classname='BTS_Tests_OML' name='TC_wrong_trx_nr' time='0.722824'/> <testcase classname='BTS_Tests_OML' name='TC_radio_carrier_opstart_noattr' time='0.715609'/> <testcase classname='BTS_Tests_OML' name='TC_bts_opstart' time='0.715579'/> <testcase classname='BTS_Tests_OML' name='TC_bts_opstart_noattr' time='0.690658'/> <testcase classname='BTS_Tests_OML' name='TC_ts_opstart' time='0.721345'/> <testcase classname='BTS_Tests_OML' name='TC_ts_opstart_noattr' time='0.686418'/> <testcase classname='BTS_Tests_OML' name='TC_initial_state_reports' time='0.705792'/> <testcase classname='BTS_Tests_OML' name='TC_ipa_osmo_pcu_anr_fwd' time='0.764783'/> <testcase classname='BTS_Tests_OML' name='TC_ipa_rsl_connect_nack' time='0.701639'/> </testsuite> + check_respawn_count + set +x [0;31m ================================================================ WARNING: osmo-bts was respawned 4 times (expected: 3)! (OS#6794) ================================================================ [0m+ RC=1 + uptime + grep --color=always -o load.* [01;31m[Kload average: 0.77, 0.66, 0.57[m[K + exit 1 Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.

1 0

Build failed in Jenkins: master-pysim » test,a1=default,a3=default,a4=default,simtester #2112
by jenkins＠lists.osmocom.org 24 Apr '26

24 Apr '26

See <https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…> Changes: ------------------------------------------ Started by upstream project "master-pysim" build number 2112 originally caused by: Started by timer Running as SYSTEM Building remotely on simtester in workspace <https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…> [ssh-agent] Looking for ssh-agent implementation... $ ssh-agent SSH_AUTH_SOCK=/tmp/ssh-7Dd71HhI2fPq/agent.2321850 SSH_AGENT_PID=2321852 [ssh-agent] Started. Running ssh-add (command line suppressed) Identity added: <https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…> (osmocom-jenkins) [ssh-agent] Using credentials docs (OS#5798) The recommended git tool is: NONE No credentials specified Cloning the remote Git repository Cloning repository https://gerrit.osmocom.org/pysim > git init <https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…> # timeout=10 Fetching upstream changes from https://gerrit.osmocom.org/pysim > git --version # timeout=10 > git --version # 'git version 2.39.5' > git fetch --tags --force --progress -- https://gerrit.osmocom.org/pysim +refs/heads/*:refs/remotes/origin/* # timeout=10 > git config remote.origin.url https://gerrit.osmocom.org/pysim # timeout=10 > git config --add remote.origin.fetch +refs/heads/*:refs/remotes/origin/* # timeout=10 Avoid second fetch Checking out Revision 03b58985a51ab39ff4f6edc82b3e7fdd923a782b (origin/master) > git config core.sparsecheckout # timeout=10 > git checkout -f 03b58985a51ab39ff4f6edc82b3e7fdd923a782b # timeout=10 Commit message: "tests: pySim-smpp2sim_test.sh: fix copy-pasted comment" > git rev-list --no-walk 03b58985a51ab39ff4f6edc82b3e7fdd923a782b # timeout=10 [simtester] $ /bin/sh -xe /tmp/jenkins1677034194777137910.sh + readlink -f /tmp/ssh-7Dd71HhI2fPq/agent.2321850 + docker run --rm=true --cap-add SYS_PTRACE --security-opt seccomp=/home/jenkins/osmo-ci/_docker_playground/seccomp_profile.json --ulimit fsize=1000000000 -e ASCIIDOC_WARNINGS_CHECK=1 -e CFLAGS=-g -e HOME=/build -e IS_MASTER_BUILD=1 -e JOB_NAME=master-pysim/JOB_TYPE=test,a1=default,a3=default,a4=default,label=simtester -e MAKE=make -e OSMOPY_DEBUG_TCP_SOCKETS=1 -e OSMO_GSM_MANUALS_DIR=/opt/osmo-gsm-manuals -e PARALLEL_MAKE=-j 1 -e PUBLISH=1 -e SSH_AUTH_SOCK=/ssh-agent -e WITH_MANUALS=1 -w /build -i -u build -v /tmp/ssh-7Dd71HhI2fPq/agent.2321850:/ssh-agent -v /home/jenkins/osmo-ci:/osmo-ci:ro -v <https://jenkins.osmocom.org/jenkins/job/master-pysim/JOB_TYPE=test,a1=defau…>:/build -v /home/jenkins/.ssh:/home/build/.ssh:ro -e JOB_TYPE=test jenkins/debian-trixie-build /usr/bin/timeout 30m /build/contrib/jenkins.sh /tmp/jenkins1677034194777137910.sh: 7: docker: not found Build step 'Execute shell' marked build as failure $ ssh-agent -k unset SSH_AUTH_SOCK; unset SSH_AGENT_PID; echo Agent pid 2321852 killed; [ssh-agent] Stopped. Archiving artifacts

1 0

2026

2025

2024

2023

2022

2021

2020

2019

jenkins-notifications