October 2024 - jenkins-notifications

Build failed in Jenkins: master-pyosmocom » pysim,a1=default,a3=default,a4=default,simtester #73
by jenkins＠lists.osmocom.org 25 Oct '24

25 Oct '24

See <https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…> Changes: ------------------------------------------ [...truncated 327.74 KiB...] update_record 1 update_record 2 update_record 3 select MF/ADF.USIM/DF.ProSe/EF.PROSE_PLMN update_record 1 update_record 2 update_record 3 select MF/ADF.USIM/DF.ProSe/EF.PROSE_GC update_binary select MF/ADF.USIM/DF.ProSe/EF.PST update_binary select MF/ADF.USIM/DF.ProSe/EF.UIRC update_binary select MF/ADF.USIM/DF.ProSe/EF.PROSE_GM_DISCOVERY update_record 1 update_record 2 update_record 3 select MF/ADF.USIM/DF.ProSe/EF.PROSE_RELAY update_record 1 update_record 2 update_record 3 select MF/ADF.USIM/DF.ProSe/EF.PROSE_RELAY_DISCOVERY update_binary select MF/ADF.USIM/DF.5GS select MF/ADF.USIM/DF.5GS/EF.5GS3GPPLOCI update_binary select MF/ADF.USIM/DF.5GS/EF.5GSN3GPPLOCI update_binary select MF/ADF.USIM/DF.5GS/EF.5GS3GPPNSC update_record 1 select MF/ADF.USIM/DF.5GS/EF.5GSN3GPPNSC update_record 1 select MF/ADF.USIM/DF.5GS/EF.5GAUTHKEYS update_binary select MF/ADF.USIM/DF.5GS/EF.UAC_AIC update_binary select MF/ADF.USIM/DF.5GS/EF.SUCI_Calc_Info update_binary select MF/ADF.USIM/DF.5GS/EF.OPL5G update_record 1 update_record 2 update_record 3 update_record 4 update_record 5 update_record 6 update_record 7 update_record 8 update_record 9 update_record 10 select MF/ADF.USIM/DF.5GS/EF.SUPI_NAI update_binary select MF/ADF.USIM/DF.5GS/EF.Routing_Indicator update_binary select MF/ADF.USIM/DF.5GS/EF.URSP update_binary select MF/ADF.USIM/DF.5GS/EF.TN3GPPSNN update_binary select MF/ADF.USIM/DF.5GS/EF.CAG select MF/ADF.USIM/DF.5GS/EF.SOR-CMCI select MF/ADF.USIM/DF.5GS/EF.DRI select MF/ADF.USIM/DF.5GS/EF.5GSEDRX select MF/ADF.USIM/DF.5GS/EF.5GNSWO_CONF select MF/ADF.USIM/DF.5GS/EF.MCHPPLMN select MF/ADF.USIM/DF.5GS/EF.KAUSF_DERIVATION select MF/ADF.USIM/DF.SNPN select MF/ADF.USIM/DF.SNPN/EF.PWS_SNPN select MF/ADF.USIM/DF.SNPN/EF.NID select MF/ADF.USIM/DF.5G_ProSe select MF/ADF.USIM/DF.5G_ProSe/EF.5G_PROSE_ST select MF/ADF.USIM/DF.5G_ProSe/EF.5G_PROSE_DD select MF/ADF.USIM/DF.5G_ProSe/EF.5G_PROSE_DC select MF/ADF.USIM/DF.5G_ProSe/EF.5G_PROSE_U2NRU select MF/ADF.USIM/DF.5G_ProSe/EF.5G_PROSE_RU select MF/ADF.USIM/DF.5G_ProSe/EF.5G_PROSE_UIR select MF/ADF.USIM/DF.SAIP select MF/ADF.USIM/DF.SAIP/EF.SUCI_Calc_Info select MF/ADF.USIM/EF.IMSI update_binary select MF/ADF.USIM/EF.USIM_AUTH_KEY select MF/ADF.USIM/EF.USIM_AUTH_KEY_2G select MF/ADF.USIM/EF.GBA_SK select MF/ADF.USIM/EF.GBA_REC_LIST select MF/ADF.USIM/EF.GBA_INT_KEY select MF/ADF.USIM/EF.USIM_SQN select MF/ADF.ISIM select MF/ADF.ISIM/EF.IMPI update_binary select MF/ADF.ISIM/EF.DOMAIN update_binary select MF/ADF.ISIM/EF.IMPU update_record 1 update_record 2 update_record 3 update_record 4 update_record 5 update_record 6 update_record 7 update_record 8 select MF/ADF.ISIM/EF.AD update_binary select MF/ADF.ISIM/EF.ARR update_record 1 update_record 2 update_record 3 update_record 4 select MF/ADF.ISIM/EF.IST update_binary select MF/ADF.ISIM/EF.P-CSCF update_record 1 update_record 2 update_record 3 update_record 4 update_record 5 update_record 6 update_record 7 update_record 8 select MF/ADF.ISIM/EF.GBABP update_binary select MF/ADF.ISIM/EF.GBANL update_record 1 update_record 2 update_record 3 update_record 4 update_record 5 update_record 6 update_record 7 update_record 8 select MF/ADF.ISIM/EF.NAFKCA update_record 1 update_record 2 update_record 3 update_record 4 update_record 5 update_record 6 update_record 7 update_record 8 select MF/ADF.ISIM/EF.UICCIARI update_record 1 update_record 2 update_record 3 update_record 4 update_record 5 update_record 6 update_record 7 update_record 8 select MF/ADF.ISIM/EF.FromPreferred update_binary select MF/ADF.ISIM/EF.IMSConfigData select MF/ADF.ISIM/EF.XCAPConfigData select MF/ADF.ISIM/EF.WebRTCURI update_record 1 update_record 2 update_record 3 update_record 4 update_record 5 update_record 6 update_record 7 update_record 8 update_record 9 update_record 10 select MF/ADF.ISIM/EF.MuDMiDConfigData select MF/ADF.ISIM/EF.ISIM_AUTH_KEY select MF/ADF.ISIM/EF.ISIM_AUTH_KEY_2G select MF/ADF.ISIM/EF.ISIM_SQN - select MF/ADF.ISD select MF/ADF.ARA-M aram_delete_all : File comparison: content export.script.tmp does not match content of export.script.ok -- test failed ====================================================================== FAIL: test (fsdump.test.test_case.test) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 41, in test self.assertEqualFiles("fsdump.json.tmp", File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 393, in assertEqualFiles self.assertEqual(ok_file_content, out_file_content, AssertionError: '{\n"[237292 chars]n}\n},\n"MF/ADF.ISD": {\n"path": [\n"MF",\n"AD[141 chars]}\n}' != '{\n"[237292 chars]n}\n}\n}\n}' : File comparison: content fsdump.json.tmp does not match content of fsdump.json.ok -- test failed ====================================================================== FAIL: test_est_scp02_csv (gp.test.test_case.test_est_scp02_csv) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 41, in test_est_scp02_csv self.runPySimShell(cardname, "test_est_scp02_csv.script", no_exceptions = True, add_csv = True) File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 282, in runPySimShell self.assertTrue(False, "Unexpected exceptions occurred!") AssertionError: False is not true : Unexpected exceptions occurred! ====================================================================== FAIL: test_est_scp02_direct (gp.test.test_case.test_est_scp02_direct) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 35, in test_est_scp02_direct self.runPySimShell(cardname, "test_est_scp02_direct.script", no_exceptions = True) File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 282, in runPySimShell self.assertTrue(False, "Unexpected exceptions occurred!") AssertionError: False is not true : Unexpected exceptions occurred! ====================================================================== FAIL: test_est_scp03_csv (gp.test.test_case.test_est_scp03_csv) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 56, in test_est_scp03_csv self.runPySimShell(cardname, "test_est_scp03_csv.script", no_exceptions = True, add_csv = True) File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 282, in runPySimShell self.assertTrue(False, "Unexpected exceptions occurred!") AssertionError: False is not true : Unexpected exceptions occurred! ====================================================================== FAIL: test_est_scp03_direct (gp.test.test_case.test_est_scp03_direct) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 51, in test_est_scp03_direct self.runPySimShell(cardname, "test_est_scp03_direct.script", no_exceptions = True) File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 282, in runPySimShell self.assertTrue(False, "Unexpected exceptions occurred!") AssertionError: False is not true : Unexpected exceptions occurred! ====================================================================== FAIL: test_get_status (gp.test.test_case.test_get_status) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 72, in test_get_status self.runPySimShell(cardname, "test_get_status.script", no_exceptions = True, add_csv = True) File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 282, in runPySimShell self.assertTrue(False, "Unexpected exceptions occurred!") AssertionError: False is not true : Unexpected exceptions occurred! ====================================================================== FAIL: test_put_delete_key (gp.test.test_case.test_put_delete_key) ---------------------------------------------------------------------- Traceback (most recent call last): File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 64, in test_put_delete_key self.runPySimShell(cardname, "test_put_delete_key.script", no_exceptions = True, add_csv = True) File "<https://jenkins.osmocom.org/jenkins/job/master-pyosmocom/JOB_TYPE=pysim,a1=…",> line 282, in runPySimShell self.assertTrue(False, "Unexpected exceptions occurred!") AssertionError: False is not true : Unexpected exceptions occurred! ---------------------------------------------------------------------- Ran 35 tests in 397.646s FAILED (failures=12, errors=1) Build step 'Execute shell' marked build as failure $ ssh-agent -k unset SSH_AUTH_SOCK; unset SSH_AGENT_PID; echo Agent pid 1465119 killed; [ssh-agent] Stopped. Archiving artifacts

1 0

Jenkins build became unstable: ttcn3-bsc-test-asan #139
by jenkins＠lists.osmocom.org 24 Oct '24

24 Oct '24

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

1 0

Build failed in Jenkins: ttcn3-pcu-test-asan #137
by jenkins＠lists.osmocom.org 24 Oct '24

24 Oct '24

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/137/display/red…> Changes: ------------------------------------------ [...truncated 45.14 MiB...] [1;32m20241024140021714 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=7,ts=7) FN=91 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021715 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=0,ts=7) FN=95 RX RTS.req: sapi=5 arfcn=871 cur_fn=91 block=10 (pcu_l1_if.cpp:576)[0;m [0;36m20241024140021715 [1;34mDRLCMACSCHED[0;m[0;36m [1;34mDEBUG[0;m[0;36m PDCH(bts=0,trx=0,ts=7) Received RTS for PDCH: FN=95 block_nr=10 scheduling USF=0 for TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW}, expect answer on UL FN=99 (gprs_rlcmac_sched.cpp:454)[0;m [0;33m20241024140021715 [1;34mDRLCMAC[0;m[0;33m [1;34mDEBUG[0;m[0;33m PDCH(bts=0,trx=0,ts=7) Reserving FN 99 for type USF (pdch_ul_controller.c:184)[0;m [1;37m20241024140021715 [1;32mDNACC[0;m[1;37m [1;32mINFO[0;m[1;37m NACC(TLLI-0x00000001){TX_NEIGHBOUR_DATA}: Received Event CREATE_RLCMAC_MSG (gprs_ms.c:1078)[0;m [1;37m20241024140021715 [1;34mDNACC[0;m[1;37m [1;34mDEBUG[0;m[1;37m +++++++++++++++++++++++++ TX : Packet Neighbour Cell Data +++++++++++++++++++++++++ (nacc_fsm.c:139)[0;m [1;31m20241024140021715 [1;32mDCSN1[0;m[1;31m [1;32mINFO[0;m[1;31m csnStreamEncoder (type: Pkt Neightbour Cell Data (12)): [0;m[1;31mMESSAGE_TYPE = 12 | [0;m[1;31mPAGE_MODE = 0 | [0;m[1;31m0x00 = 0 | [0;m[1;31m : Global_TFI | [0;m[1;31mu.UPLINK_TFI = 0 | [0;m[1;31mu.UPLINK_TFI = 0 | [0;m[1;31m : End Global_TFI | [0;m[1;31mCONTAINER_ID = 0 | [0;m[1;31mspare = 0 | [0;m[1;31mCONTAINER_INDEX = 3 | [0;m[1;31m : Container | [0;m[1;31mu.PNCD_Container_Without_ID = 0 | [0;m[1;31m : u.PNCD_Container_Without_ID | [0;m[1;31mCONTAINER = 11 | [0;m[1;31mCONTAINER = 171 | [0;m[1;31mCONTAINER = 43 | [0;m[1;31mCONTAINER = 43 | [0;m[1;31mCONTAINER = 43 | [0;m[1;31mCONTAINER = 43 | [0;m[1;31mCONTAINER = 43 | [0;m[1;31mCONTAINER = 43 | [0;m[1;31mCONTAINER = 43 | [0;m[1;31mCONTAINER = 43 | [0;m[1;31mCONTAINER = 43 | [0;m[1;31mCONTAINER = 43 | [0;m[1;31mCONTAINER = 0 | [0;m[1;31mCONTAINER = 0 | [0;m[1;31mCONTAINER = 0 | [0;m[1;31mCONTAINER = 0 | [0;m[1;31mCONTAINER = 0 | [0;m[1;31mCONTAINER = 0 | [0;m[1;31mCONTAINER = 0 | [0;m[1;31m : End u.PNCD_Container_Without_ID | [0;m[1;31m : End Container | [0;m[1;31mPadding = [0;m[1;31m (gsm_rlcmac.c:6009)[0;m [1;37m20241024140021716 [1;34mDNACC[0;m[1;37m [1;34mDEBUG[0;m[1;37m ------------------------- TX : Packet Neighbour Cell Data ------------------------- (nacc_fsm.c:145)[0;m [1;37m20241024140021716 [1;32mDNACC[0;m[1;37m [1;32mINFO[0;m[1;37m NACC(TLLI-0x00000001){TX_NEIGHBOUR_DATA}: state_chg to TX_CELL_CHG_CONTINUE (nacc_fsm.c:620)[0;m [0;36m20241024140021716 [1;34mDRLCMACSCHED[0;m[0;36m [1;34mDEBUG[0;m[0;36m PDCH(bts=0,trx=0,ts=7) FN=95 Scheduling control message at RTS for TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW} (gprs_rlcmac_sched.cpp:202)[0;m [1;32m20241024140021716 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=0,ts=7) FN=95 Sending data request: sapi=5 arfcn=871 cur_fn=91 block=10 data=40 30 00 06 0b ab 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 00 00 00 00 00 00 00 (pcu_l1_if.cpp:182)[0;m [1;32m20241024140021716 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Time indication received: 43 (pcu_l1_if.cpp:1048)[0;m [1;32m20241024140021727 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=0,ts=7) FN=95 Rx DATA.ind: sapi=5 arfcn=871 cur_fn=91 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021727 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=0,ts=7) FN=95 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [0;33m20241024140021727 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=0,ts=7) Timeout for registered USF (FN=95): TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW} (pdch_ul_controller.c:309)[0;m [1;34m20241024140021727 [1;34mDTBF[0;m[1;34m [1;34mDEBUG[0;m[1;34m TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW} N3101 2 => 3 (< MAX 10) (tbf.cpp:362)[0;m [1;32m20241024140021729 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=1,ts=7) FN=95 Rx DATA.ind: sapi=5 arfcn=872 cur_fn=95 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021729 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=1,ts=7) FN=95 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021730 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=2,ts=7) FN=95 Rx DATA.ind: sapi=5 arfcn=873 cur_fn=95 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021730 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=2,ts=7) FN=95 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021731 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=3,ts=7) FN=95 Rx DATA.ind: sapi=5 arfcn=874 cur_fn=95 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021731 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=3,ts=7) FN=95 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021732 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=4,ts=7) FN=95 Rx DATA.ind: sapi=5 arfcn=875 cur_fn=95 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021732 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=4,ts=7) FN=95 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021733 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=5,ts=7) FN=95 Rx DATA.ind: sapi=5 arfcn=876 cur_fn=95 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021733 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=5,ts=7) FN=95 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021733 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=6,ts=7) FN=95 Rx DATA.ind: sapi=5 arfcn=877 cur_fn=95 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021733 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=6,ts=7) FN=95 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021734 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=7,ts=7) FN=95 Rx DATA.ind: sapi=5 arfcn=878 cur_fn=95 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021734 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=7,ts=7) FN=95 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021735 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=0,ts=7) FN=99 RX RTS.req: sapi=5 arfcn=871 cur_fn=95 block=11 (pcu_l1_if.cpp:576)[0;m [0;36m20241024140021735 [1;34mDRLCMACSCHED[0;m[0;36m [1;34mDEBUG[0;m[0;36m PDCH(bts=0,trx=0,ts=7) Received RTS for PDCH: FN=99 block_nr=11 scheduling USF=0 for TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW}, expect answer on UL FN=104 (gprs_rlcmac_sched.cpp:454)[0;m [0;33m20241024140021735 [1;34mDRLCMAC[0;m[0;33m [1;34mDEBUG[0;m[0;33m PDCH(bts=0,trx=0,ts=7) Reserving FN 104 for type USF (pdch_ul_controller.c:184)[0;m [1;37m20241024140021735 [1;32mDNACC[0;m[1;37m [1;32mINFO[0;m[1;37m NACC(TLLI-0x00000001){TX_CELL_CHG_CONTINUE}: Received Event CREATE_RLCMAC_MSG (gprs_ms.c:1078)[0;m [0;33m20241024140021735 [1;34mDRLCMAC[0;m[0;33m [1;34mDEBUG[0;m[0;33m PDCH(bts=0,trx=0,ts=7) POLL scheduled at FN 99 + 13 = 112 (pdch_ul_controller.c:131)[0;m [1;37m20241024140021735 [1;34mDNACC[0;m[1;37m [1;34mDEBUG[0;m[1;37m +++++++++++++++++++++++++ TX : Packet Cell Change Continue +++++++++++++++++++++++++ (nacc_fsm.c:196)[0;m [1;31m20241024140021735 [1;32mDCSN1[0;m[1;31m [1;32mINFO[0;m[1;31m csnStreamEncoder (type: Pkt Cell Change Continue (11)): [0;m[1;31mMESSAGE_TYPE = 11 | [0;m[1;31mPAGE_MODE = 0 | [0;m[1;31m0x00 = 0 | [0;m[1;31m : Global_TFI | [0;m[1;31mu.UPLINK_TFI = 0 | [0;m[1;31mu.UPLINK_TFI = 0 | [0;m[1;31m : End Global_TFI | [0;m[1;31mExist_ID = 1 | [0;m[1;31mARFCN = 862 | [0;m[1;31mBSIC = 43 | [0;m[1;31mCONTAINER_ID = 0 | [0;m[1;31mPadding = [0;m[1;31m11|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m (gsm_rlcmac.c:6009)[0;m [1;37m20241024140021736 [1;34mDNACC[0;m[1;37m [1;34mDEBUG[0;m[1;37m ------------------------- TX : Packet Cell Change Continue ------------------------- (nacc_fsm.c:202)[0;m [0;33m20241024140021736 [1;34mDRLCMAC[0;m[0;33m [1;34mDEBUG[0;m[0;33m PDCH(bts=0,trx=0,ts=7) Reserving FN 112 for type POLL (pdch_ul_controller.c:184)[0;m [1;34m20241024140021736 [1;34mDTBF[0;m[1;34m [1;34mDEBUG[0;m[1;34m TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW} Scheduled 'Packet Cell Change Continue' polling on PACCH (FN=112, TS=7) (nacc_fsm.c:206)[0;m [1;37m20241024140021736 [1;32mDNACC[0;m[1;37m [1;32mINFO[0;m[1;37m NACC(TLLI-0x00000001){TX_CELL_CHG_CONTINUE}: state_chg to WAIT_CELL_CHG_CONTINUE_ACK (nacc_fsm.c:649)[0;m [0;36m20241024140021736 [1;34mDRLCMACSCHED[0;m[0;36m [1;34mDEBUG[0;m[0;36m PDCH(bts=0,trx=0,ts=7) FN=99 Scheduling control message at RTS for TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW} (gprs_rlcmac_sched.cpp:202)[0;m [1;32m20241024140021736 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=0,ts=7) FN=99 Sending data request: sapi=5 arfcn=871 cur_fn=95 block=11 data=48 2c 01 d7 ab 0b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b (pcu_l1_if.cpp:182)[0;m [1;32m20241024140021736 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Time indication received: 47 (pcu_l1_if.cpp:1048)[0;m BTS(1073)@9541a9c1d226: Warning: dec_RlcmacDlCtrlBlock(): Data remained at the end of the stream after successful decoding: '0B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B2B'O ("\v+++++++++++++++++") [1;32m20241024140021747 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=0,ts=7) FN=99 Rx DATA.ind: sapi=5 arfcn=871 cur_fn=95 block=11 data=40 30 06 bd 58 00 00 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021747 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=0,ts=7) FN=99 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 0 (pcu_l1_if.cpp:478)[0;m [1;36m20241024140021747 [1;34mDRLCMACUL[0;m[1;36m [1;34mDEBUG[0;m[1;36m PDCH(bts=0,trx=0,ts=7) Got RLC block, coding scheme: CS-1, length: 23 (23)) (pdch.cpp:983)[0;m [0;33m20241024140021747 [1;34mDRLCMAC[0;m[0;33m [1;34mDEBUG[0;m[0;33m PDCH(bts=0,trx=0,ts=7) FN=99 +++++++++++++++++++++++++ RX : Uplink Control Block +++++++++++++++++++++++++ (pdch.cpp:914)[0;m [1;31m20241024140021747 [1;32mDCSN1[0;m[1;31m [1;32mINFO[0;m[1;31m csnStreamDecoder (type: Pkt Cell Change Notification (12)): [0;m[1;31mPayloadType = 1 | [0;m[1;31mspare = 0 | [0;m[1;31mR = 0 | [0;m[1;31mMESSAGE_TYPE = 12 | [0;m[1;31m : Global_TFI | [0;m[1;31mu.UPLINK_TFI = 0 | [0;m[1;31mu.UPLINK_TFI = 0 | [0;m[1;31m: End Global_TFI | [0;m[1;31m : Target_Cell | [0;m[1;31mu.Target_Cell_GSM_Notif = 0 | [0;m[1;31m : u.Target_Cell_GSM_Notif | [0;m[1;31mARFCN = 862 | [0;m[1;31mBSIC = 43 | [0;m[1;31m : End u.Target_Cell_GSM_Notif | [0;m[1;31m: End Target_Cell | [0;m[1;31mu.BA_IND = 0 | [0;m[1;31mu.BA_IND = 0 | [0;m[1;31mPMO_USED = 0 | [0;m[1;31mPCCN_SENDING = 0 | [0;m[1;31m : CCN_Measurement_Report | [0;m[1;31mRXLEV_SERVING_CELL = 0 | [0;m[1;31m0 = 0 | [0;m[1;31mNUMBER_OF_NC_MEASUREMENTS = 0 | [0;m[1;31m: End CCN_Measurement_Report | [0;m[1;31mExist_AdditionsR6 = 0 | [0;m[1;31mPadding = [0;m[1;31m0|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m (gsm_rlcmac.c:5476)[0;m [0;33m20241024140021748 [1;34mDRLCMAC[0;m[0;33m [1;34mDEBUG[0;m[0;33m PDCH(bts=0,trx=0,ts=7) FN=99 ------------------------- RX : Uplink Control Block ------------------------- (pdch.cpp:927)[0;m [1;37m20241024140021748 [1;32mDNACC[0;m[1;37m [1;32mINFO[0;m[1;37m NACC(TLLI-0x00000001){WAIT_CELL_CHG_CONTINUE_ACK}: Received Event RX_CELL_CHG_NOTIFICATION (gprs_ms.c:1052)[0;m [1;37m20241024140021748 [1;33mDNACC[0;m[1;37m [1;33mNOTICE[0;m[1;37m NACC(TLLI-0x00000001){WAIT_CELL_CHG_CONTINUE_ACK}: TargetCell: RAT=GSM, ARFCN=862, BSIC=43 (nacc_fsm.c:291)[0;m [1;32m20241024140021750 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=1,ts=7) FN=99 Rx DATA.ind: sapi=5 arfcn=872 cur_fn=99 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021750 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=1,ts=7) FN=99 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021752 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=2,ts=7) FN=99 Rx DATA.ind: sapi=5 arfcn=873 cur_fn=99 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021752 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=2,ts=7) FN=99 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021753 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=3,ts=7) FN=99 Rx DATA.ind: sapi=5 arfcn=874 cur_fn=99 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021753 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=3,ts=7) FN=99 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021754 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=4,ts=7) FN=99 Rx DATA.ind: sapi=5 arfcn=875 cur_fn=99 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021754 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=4,ts=7) FN=99 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021754 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=5,ts=7) FN=99 Rx DATA.ind: sapi=5 arfcn=876 cur_fn=99 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021754 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=5,ts=7) FN=99 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021754 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=6,ts=7) FN=99 Rx DATA.ind: sapi=5 arfcn=877 cur_fn=99 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021755 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=6,ts=7) FN=99 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021755 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=7,ts=7) FN=99 Rx DATA.ind: sapi=5 arfcn=878 cur_fn=99 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021755 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=7,ts=7) FN=99 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021756 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Time indication received: 0 (pcu_l1_if.cpp:1048)[0;m [1;32m20241024140021771 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=0,ts=7) FN=104 Rx DATA.ind: sapi=5 arfcn=871 cur_fn=99 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021771 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=0,ts=7) FN=104 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [0;33m20241024140021772 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=0,ts=7) Timeout for registered USF (FN=104): TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW} (pdch_ul_controller.c:309)[0;m [1;34m20241024140021772 [1;34mDTBF[0;m[1;34m [1;34mDEBUG[0;m[1;34m TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW} N3101 3 => 4 (< MAX 10) (tbf.cpp:362)[0;m [1;32m20241024140021773 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=1,ts=7) FN=104 Rx DATA.ind: sapi=5 arfcn=872 cur_fn=104 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021773 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=1,ts=7) FN=104 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021774 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=2,ts=7) FN=104 Rx DATA.ind: sapi=5 arfcn=873 cur_fn=104 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021774 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=2,ts=7) FN=104 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021775 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=3,ts=7) FN=104 Rx DATA.ind: sapi=5 arfcn=874 cur_fn=104 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021775 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=3,ts=7) FN=104 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021775 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=4,ts=7) FN=104 Rx DATA.ind: sapi=5 arfcn=875 cur_fn=104 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021775 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=4,ts=7) FN=104 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021776 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=5,ts=7) FN=104 Rx DATA.ind: sapi=5 arfcn=876 cur_fn=104 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021776 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=5,ts=7) FN=104 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021777 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=6,ts=7) FN=104 Rx DATA.ind: sapi=5 arfcn=877 cur_fn=104 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021777 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=6,ts=7) FN=104 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021778 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=7,ts=7) FN=104 Rx DATA.ind: sapi=5 arfcn=878 cur_fn=104 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021778 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=7,ts=7) FN=104 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021779 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Time indication received: 4 (pcu_l1_if.cpp:1048)[0;m [1;32m20241024140021790 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=0,ts=7) FN=108 Rx DATA.ind: sapi=5 arfcn=871 cur_fn=104 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021790 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=0,ts=7) FN=108 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021791 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=1,ts=7) FN=108 Rx DATA.ind: sapi=5 arfcn=872 cur_fn=108 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021791 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=1,ts=7) FN=108 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021792 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=2,ts=7) FN=108 Rx DATA.ind: sapi=5 arfcn=873 cur_fn=108 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021792 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=2,ts=7) FN=108 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021792 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=3,ts=7) FN=108 Rx DATA.ind: sapi=5 arfcn=874 cur_fn=108 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021792 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=3,ts=7) FN=108 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021793 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=4,ts=7) FN=108 Rx DATA.ind: sapi=5 arfcn=875 cur_fn=108 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021793 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=4,ts=7) FN=108 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021794 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=5,ts=7) FN=108 Rx DATA.ind: sapi=5 arfcn=876 cur_fn=108 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021794 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=5,ts=7) FN=108 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021795 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=6,ts=7) FN=108 Rx DATA.ind: sapi=5 arfcn=877 cur_fn=108 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021795 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=6,ts=7) FN=108 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021795 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=7,ts=7) FN=108 Rx DATA.ind: sapi=5 arfcn=878 cur_fn=108 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021795 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=7,ts=7) FN=108 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021796 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m Time indication received: 8 (pcu_l1_if.cpp:1048)[0;m [1;32m20241024140021809 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=0,ts=7) FN=112 Rx DATA.ind: sapi=5 arfcn=871 cur_fn=108 block=2 data=40 04 00 00 00 07 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b 2b (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021809 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=0,ts=7) FN=112 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 0 (pcu_l1_if.cpp:478)[0;m [1;36m20241024140021809 [1;34mDRLCMACUL[0;m[1;36m [1;34mDEBUG[0;m[1;36m PDCH(bts=0,trx=0,ts=7) Got RLC block, coding scheme: CS-1, length: 23 (23)) (pdch.cpp:983)[0;m [0;33m20241024140021809 [1;34mDRLCMAC[0;m[0;33m [1;34mDEBUG[0;m[0;33m PDCH(bts=0,trx=0,ts=7) FN=112 +++++++++++++++++++++++++ RX : Uplink Control Block +++++++++++++++++++++++++ (pdch.cpp:914)[0;m [1;31m20241024140021809 [1;32mDCSN1[0;m[1;31m [1;32mINFO[0;m[1;31m csnStreamDecoder (type: Pkt Control Ack (1)): [0;m[1;31mPayloadType = 1 | [0;m[1;31mspare = 0 | [0;m[1;31mR = 0 | [0;m[1;31mMESSAGE_TYPE = 1 | [0;m[1;31mTLLI = 0x00000001 | [0;mBTS(1073)@9541a9c1d226: Shutting down virtual BTS #0... [1;31mCTRL_ACK = 3 | [0;m[1;31mExist_AdditionsR5 = 0 | [0;m[1;31mPadding = [0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m43|[0;m[1;31m (gsm_rlcmac.c:5476)[0;m [0;33m20241024140021809 [1;34mDRLCMAC[0;m[0;33m [1;34mDEBUG[0;m[0;33m PDCH(bts=0,trx=0,ts=7) FN=112 ------------------------- RX : Uplink Control Block ------------------------- (pdch.cpp:927)[0;m [1;34m20241024140021810 [1;34mDTBF[0;m[1;34m [1;34mDEBUG[0;m[1;34m TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW} FN=112 Rx Packet Control Ack (reason=CELL_CHG_CONTINUE) (pdch.cpp:363)[0;m [1;37m20241024140021810 [1;32mDNACC[0;m[1;37m [1;32mINFO[0;m[1;37m NACC(TLLI-0x00000001){WAIT_CELL_CHG_CONTINUE_ACK}: Received Event RX_CELL_CHG_CONTINUE_ACK (pdch.cpp:449)[0;m [1;37m20241024140021810 [1;32mDNACC[0;m[1;37m [1;32mINFO[0;m[1;37m NACC(TLLI-0x00000001){WAIT_CELL_CHG_CONTINUE_ACK}: state_chg to DONE (nacc_fsm.c:671)[0;m [1;37m20241024140021810 [1;32mDNACC[0;m[1;37m [1;32mINFO[0;m[1;37m NACC(TLLI-0x00000001){DONE}: Terminating (cause = OSMO_FSM_TERM_REGULAR) (nacc_fsm.c:681)[0;m [1;37m20241024140021810 [1;32mDNACC[0;m[1;37m [1;32mINFO[0;m[1;37m NACC(TLLI-0x00000001){DONE}: Freeing instance (nacc_fsm.c:681)[0;m [1;37m20241024140021810 [1;32mDNACC[0;m[1;37m [1;32mINFO[0;m[1;37m NACC(TLLI-0x00000001){DONE}: Deallocated (fsm.c:568)[0;m [1;32m20241024140021811 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=1,ts=7) FN=112 Rx DATA.ind: sapi=5 arfcn=872 cur_fn=112 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021811 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=1,ts=7) FN=112 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021812 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=2,ts=7) FN=112 Rx DATA.ind: sapi=5 arfcn=873 cur_fn=112 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021812 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=2,ts=7) FN=112 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021814 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=3,ts=7) FN=112 Rx DATA.ind: sapi=5 arfcn=874 cur_fn=112 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021814 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=3,ts=7) FN=112 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m 20241024140021814 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:44156<->l=127.0.0.1:4240 (telnet_interface.c:138) [1;32m20241024140021815 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=4,ts=7) FN=112 Rx DATA.ind: sapi=5 arfcn=875 cur_fn=112 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021815 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=4,ts=7) FN=112 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021816 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=5,ts=7) FN=112 Rx DATA.ind: sapi=5 arfcn=876 cur_fn=112 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021816 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=5,ts=7) FN=112 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021817 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=6,ts=7) FN=112 Rx DATA.ind: sapi=5 arfcn=877 cur_fn=112 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021817 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=6,ts=7) FN=112 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m [1;32m20241024140021819 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m (bts=0,trx=7,ts=7) FN=112 Rx DATA.ind: sapi=5 arfcn=878 cur_fn=112 block=0 data= (pcu_l1_if.cpp:463)[0;m [1;32m20241024140021819 [1;34mDL1IF[0;m[1;32m [1;34mDEBUG[0;m[1;32m PDCH(bts=0,trx=7,ts=7) FN=112 Rx DATA.ind PDTCH: BER10k = 0, BTO = 0, Q = 10 (pcu_l1_if.cpp:478)[0;m 20241024140021823 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:44152<->l=127.0.0.1:4240 (telnet_interface.c:138) [1;32m20241024140021825 [1;31mDL1IF[0;m[1;32m [1;31mERROR[0;m[1;32m pcu_sock_read: recv() failed with rc=0 errno=9 (pcuif_sock.c:123)[0;m [1;32m20241024140021825 [1;33mDL1IF[0;m[1;32m [1;33mNOTICE[0;m[1;32m PCU socket has LOST connection (pcuif_sock.c:78)[0;m [0;33m20241024140021825 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=0,ts=7) PDCH state: enabled => disabled (pdch.cpp:184)[0;m [1;34m20241024140021825 [1;32mDTBF[0;m[1;34m [1;32mINFO[0;m[1;34m TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW} free (tbf.cpp:271)[0;m [0;33m20241024140021825 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=0,ts=7) Detaching TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW}, 1 TBFs, USFs = 01, TFIs = 00000001. (pdch.cpp:1202)[0;m [1;34m20241024140021825 [1;32mDMS[0;m[1;34m [1;32mINFO[0;m[1;34m MS(TLLI-0x00000001:TA-0:MSCLS-3-0:UL) Detaching TBF: TBF(UL:G:TLLI-0x00000001){FLOW} (gprs_ms.c:381)[0;m [1;34m20241024140021825 [1;32mDMS[0;m[1;34m [1;32mINFO[0;m[1;34m MS(TLLI-0x00000001:TA-0:MSCLS-3-0): - tbf: now used by 0 (-) (gprs_ms.c:394)[0;m [1;34m20241024140021826 [1;32mDMS[0;m[1;34m [1;32mINFO[0;m[1;34m MS(TLLI-0x00000001:TA-0:MSCLS-3-0) Schedule MS release in 60 secs (gprs_ms.c:246)[0;m [1;34m20241024140021826 [1;34mDTBF[0;m[1;34m [1;34mDEBUG[0;m[1;34m ********** UL-TBF ends here ********** (tbf.cpp:279)[0;m [1;34m20241024140021826 [1;32mDTBFUL[0;m[1;34m [1;32mINFO[0;m[1;34m UL_ACK_TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){NONE}: Deallocated (fsm.c:568)[0;m [1;34m20241024140021826 [1;32mDTBFUL[0;m[1;34m [1;32mINFO[0;m[1;34m UL_TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){FLOW}: Deallocated (fsm.c:568)[0;m [1;34m20241024140021826 [1;32mDTBF[0;m[1;34m [1;32mINFO[0;m[1;34m UL_ASS_TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){NONE}: Deallocated (fsm.c:568)[0;m [1;34m20241024140021826 [1;32mDTBF[0;m[1;34m [1;32mINFO[0;m[1;34m DL_ASS_TBF(UL:TFI-0-0-0:G:TLLI-0x00000001){NONE}: Deallocated (fsm.c:568)[0;m [0;33m20241024140021826 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=1,ts=7) PDCH state: enabled => disabled (pdch.cpp:184)[0;m [0;33m20241024140021826 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=2,ts=7) PDCH state: enabled => disabled (pdch.cpp:184)[0;m [0;33m20241024140021826 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=3,ts=7) PDCH state: enabled => disabled (pdch.cpp:184)[0;m [0;33m20241024140021826 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=4,ts=7) PDCH state: enabled => disabled (pdch.cpp:184)[0;m [0;33m20241024140021826 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=5,ts=7) PDCH state: enabled => disabled (pdch.cpp:184)[0;m [0;33m20241024140021827 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=6,ts=7) PDCH state: enabled => disabled (pdch.cpp:184)[0;m [0;33m20241024140021827 [1;32mDRLCMAC[0;m[0;33m [1;32mINFO[0;m[0;33m PDCH(bts=0,trx=7,ts=7) PDCH state: enabled => disabled (pdch.cpp:184)[0;m [38;5;57m20241024140021827 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(01234) NS-STATUS.ind(bvci=00000): cause=NSE failure, transfer=0, first=0, mtu=65523 (gprs_ns2.c:575)[0;m [1;35m20241024140021827 [1;33mDPCU[0;m[1;35m [1;33mNOTICE[0;m[1;35m NS-NSE 1234 became unavailable (gprs_bssgp_pcu.c:690)[0;m [38;5;57m20241024140021827 [1;33mDLNS[0;m[38;5;57m [1;33mNOTICE[0;m[38;5;57m NSE(01234)-NSVC(01234) NS-STATUS.ind(bvci=00000): cause=NSVC failure, transfer=0, first=0, mtu=65523 (gprs_ns2.c:571)[0;m [1;35m20241024140021827 [1;34mDPCU[0;m[1;35m [1;34mDEBUG[0;m[1;35m NS: indication Unknown affecting cause NSVC failure / 0 from NS (gprs_bssgp_pcu.c:702)[0;m [38;5;57m20241024140021827 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Terminating (cause = OSMO_FSM_TERM_REQUEST) (gprs_ns2.c:656)[0;m [38;5;57m20241024140021827 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Freeing instance (gprs_ns2.c:656)[0;m [38;5;57m20241024140021827 [1;34mDLNS[0;m[38;5;57m [1;34mDEBUG[0;m[38;5;57m GPRS-NS2-VC(NSE01234-NSVC-UDP-0_0_0_0:22000-127_0_0_1:23000){UNBLOCKED}: Deallocated (fsm.c:568)[0;m MTC@9541a9c1d226: Test case TC_nacc_outbound_pkt_cell_chg_notif_dup5 finished. Verdict: pass MTC@9541a9c1d226: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache/podma…> PCU_Tests.TC_nacc_outbound_pkt_cell_chg_notif_dup5 pass'. Thu Oct 24 14:00:21 UTC 2024 [1;32m====== PCU_Tests.TC_nacc_outbound_pkt_cell_chg_notif_dup5 pass ======[0m Saving talloc report from 127.0.0.1:4240 to PCU_Tests.TC_nacc_outbound_pkt_cell_chg_notif_dup5.talloc respawn: 95: stopped pid 13908 with status 0 respawn: 96: starting: osmo-pcu 20241024140021907 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m Setting up GSMTAP Um forwarding to '127.0.0.1:4729' (pcu_main.cpp:298) 20241024140021907 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m Available via telnet 127.0.0.1 4240 (telnet_interface.c:88) [1;32m20241024140021907 [1;32mDL1IF[0;m[1;32m [1;32mINFO[0;m[1;32m Opening OsmoPCU L1 interface v12 to OsmoBTS/OsmoBSC (pcuif_sock.c:202)[0;m [1;32m20241024140021907 [1;31mDL1IF[0;m[1;32m [1;31mERROR[0;m[1;32m Failed to connect to the BTS (/tmp/pcu_bts). Retrying... (pcuif_sock.c:210)[0;m 20241024140021908 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Accept()ed new telnet connection r=127.0.0.1:60948<->l=127.0.0.1:4240 (telnet_interface.c:192) 20241024140022009 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Closing telnet connection r=127.0.0.1:60948<->l=127.0.0.1:4240 (telnet_interface.c:138) Waiting for packet dumper to finish... 0 (prev_count=-1, count=302736) Waiting for packet dumper to finish... 1 (prev_count=302736, count=312328) MTC@9541a9c1d226: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache/podma…> PCU_Tests.TC_nacc_outbound_pkt_cell_chg_notif_dup5 pass' was executed successfully (exit status: 0). MTC@9541a9c1d226: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache/podma…> PCU_Tests.TC_nacc_outbound_pkt_cell_chg_notif_twice'. ------ PCU_Tests.TC_nacc_outbound_pkt_cell_chg_notif_twice ------ Thu Oct 24 14:00:24 UTC 2024 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/137/artifact/lo…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/137/artifact/lo…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@9541a9c1d226: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache/podma…> PCU_Tests.TC_nacc_outbound_pkt_cell_chg_notif_twice' was executed successfully (exit status: 0). MTC@9541a9c1d226: Test case TC_nacc_outbound_pkt_cell_chg_notif_twice started. 1080@9541a9c1d226: Creating NSIP provider for "127.0.0.1":23000 1080@9541a9c1d226: Starting NSVC component for { provider := { ip := { address_family := AF_INET (2), local_udp_port := 23000, local_ip := "127.0.0.1", remote_udp_port := 22000, remote_ip := "127.0.0.1", data_weight := 1, signalling_weight := 1 } }, nsvci := 1234 } -NSVCI1234(1084)@9541a9c1d226: NSVC 1234 State Transition: NSVC_S_DEAD_BLOCKED (1) -> NSVC_S_DEAD_BLOCKED (1) TC_nacc_outbound_pkt_cell_chg_notif_twice-BVCI1234(1083)@9541a9c1d226: Adding Client=mtc, IMSI='262420000000001'H, TLLI='FFFFFFFF'O, index=0 1080@9541a9c1d226: Creating NSIP provider for "127.0.0.1":23001 -NSVCI1234(1084)@9541a9c1d226: Provider Link came up: waiting for NS-RESET MTC@9541a9c1d226: Start timer g_T_guard: 60 s 1080@9541a9c1d226: Starting NSVC component for { provider := { ip := { address_family := AF_INET (2), local_udp_port := 23001, local_ip := "127.0.0.1", remote_udp_port := 22000, remote_ip := "127.0.0.1", data_weight := 1, signalling_weight := 1 } }, nsvci := 1234 } -NSVCI1234(1087)@9541a9c1d226: NSVC 1234 State Transition: NSVC_S_DEAD_BLOCKED (1) -> NSVC_S_DEAD_BLOCKED (1) 1080@9541a9c1d226: Creating NSIP provider for "127.0.0.1":23002 -NSVCI1234(1087)@9541a9c1d226: Provider Link came up: waiting for NS-RESET 20241024140025930 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Accept()ed new telnet connection r=127.0.0.1:60962<->l=127.0.0.1:4240 (telnet_interface.c:192) MTC@9541a9c1d226: Start timer T: 2 s MTC@9541a9c1d226: Start timer T: 2 s MTC@9541a9c1d226: Start timer T: 2 s MTC@9541a9c1d226: Start timer T: 2 s MTC@9541a9c1d226: Start timer T: 2 s MTC@9541a9c1d226: Start timer T: 2 s MTC@9541a9c1d226: Start timer T: 2 s MTC@9541a9c1d226: Start timer T: 2 s MTC@9541a9c1d226: Start timer T: 2 s 1080@9541a9c1d226: Starting NSVC component for { provider := { ip := { address_family := AF_INET (2), local_udp_port := 23002, local_ip := "127.0.0.1", remote_udp_port := 22000, remote_ip := "127.0.0.1", data_weight := 1, signalling_weight := 1 } }, nsvci := 1234 } -NSVCI1234(1090)@9541a9c1d226: NSVC 1234 State Transition: NSVC_S_DEAD_BLOCKED (1) -> NSVC_S_DEAD_BLOCKED (1) -NSVCI1234(1090)@9541a9c1d226: Provider Link came up: waiting for NS-RESET PCUIF(1086)@9541a9c1d226: "Init PCU interface on '/tmp/pcu_bts', waiting for connection..." PCUIF(1086)@9541a9c1d226: Start timer T: 5 s 20241024140025937 [1;32mDLGLOBAL[0;m [1;32mINFO[0;m Accept()ed new telnet connection r=127.0.0.1:60964<->l=127.0.0.1:4240 (telnet_interface.c:192) PCUIF(1086)@9541a9c1d226: Start timer T_Conn: 10 s TC_nacc_outbound_pkt_cell_chg_notif_twice-STATS(1091)@9541a9c1d226: Start timer T: 2 s TC_nacc_outbound_pkt_cell_chg_notif_twice-STATS(1091)@9541a9c1d226: Start timer T: 2 s Error: OCI runtime error: crun: the container `9541a9c1d22616963ded87dae5e9d742098d2372ae18d2ab19bff3bad2a3b196` is not running [1;91m[testenv] podman container crashed![0m [0;94m[testenv][generic] Testsuite is done[0m [1;34m[testenv][generic] Stopping testsuite (1828055)[0m [1;34m[testenv][generic] Merging log files[0m [0;94m[testenv][generic] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache',> '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TERM=dumb', '-e', 'TESTENV_GIT_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache/git',> '-e', 'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_testenv/dat…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_testenv/dat…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache/podma…>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-t', '-w', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/137/artifact/lo…',> 'testenv-pcu-generic-osmocom-nightly-asan-20241024-1348-d17cee9a-0', 'sh', '-c', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache/podma…> PCU_Tests --rm >/dev/null'][0m Error: no container with name or ID "testenv-pcu-generic-osmocom-nightly-asan-20241024-1348-d17cee9a-0" found: no such container [1;91m[testenv][generic] Command failed unexpectedly[0m [0;94m[testenv][generic] Command: ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache',> '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TERM=dumb', '-e', 'TESTENV_GIT_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache/git',> '-e', 'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_testenv/dat…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_testenv/dat…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache/podma…>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-t', '-w', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/137/artifact/lo…',> 'testenv-pcu-generic-osmocom-nightly-asan-20241024-1348-d17cee9a-0', 'sh', '-c', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_cache/podma…> PCU_Tests --rm >/dev/null'][0m [0;94m[testenv][generic] Returncode: 125[0m Traceback (most recent call last): File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/./testenv.py",> line 115, in <module> main() File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/./testenv.py",> line 104, in main run() File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/./testenv.py",> line 63, in run testenv.testsuite.run(cfg) File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_testenv/tes…",> line 204, in run merge_log_files(cfg) File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_testenv/tes…",> line 130, in merge_log_files testenv.cmd.run(cmd, cwd=cwd) File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_testenv/tes…",> line 101, in run return testenv.podman.exec_cmd(cmd, check=check, env=env, *args, **kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_testenv/tes…",> line 149, in exec_cmd testenv.cmd.run( File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_testenv/tes…",> line 118, in run exit_error_cmd(p, "Command failed unexpectedly") File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/ws/_testenv/tes…",> line 66, 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 [1;34m[testenv][generic] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-pcu-test-asan/137/artifact/lo… [0m 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-hnbgw-test-io_uring #226
by jenkins＠lists.osmocom.org 24 Oct '24

24 Oct '24

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-io_uring/226/displ…>

1 1

Build failed in Jenkins: ttcn3-ggsn-test-kernel-latest-net-next #1346
by jenkins＠lists.osmocom.org 24 Oct '24

24 Oct '24

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> Changes: [Pau Espin Pedrol] ggsn: Request osmo-ggsn to apply the MTU on the tundev ------------------------------------------ [...truncated 1.79 MiB...] ------ GGSN_Tests.TC_pdp6_act_deact_mtu ------ Thu Oct 24 10:10:43 UTC 2024 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@8e66734a2b8c: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_mtu' was executed successfully (exit status: 0). MTC@8e66734a2b8c: Test case TC_pdp6_act_deact_mtu started. MTC@8e66734a2b8c: GTP1C ConnectionID: 1 MTC@8e66734a2b8c: "TC_pdp6_act_deact_mtu() start" 20241024101044273 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): TC_pdp6_act_deact_mtu() start (logging_vty.c:1172) MTC@8e66734a2b8c: setverdict(fail): none -> fail reason: ""VTY: Unknown Command: mtu 1400 apply"", new component reason: ""VTY: Unknown Command: mtu 1400 apply"" MTC@8e66734a2b8c: Setting final verdict of the test case. MTC@8e66734a2b8c: Local verdict of MTC: fail reason: ""VTY: Unknown Command: mtu 1400 apply"" MTC@8e66734a2b8c: No PTCs were created. MTC@8e66734a2b8c: Test case TC_pdp6_act_deact_mtu finished. Verdict: fail reason: "VTY: Unknown Command: mtu 1400 apply" MTC@8e66734a2b8c: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_mtu fail'. Thu Oct 24 10:10:45 UTC 2024 [1;31m------ GGSN_Tests.TC_pdp6_act_deact_mtu fail ------[0m Saving talloc report from 172.18.3.2:4260 to GGSN_Tests.TC_pdp6_act_deact_mtu.talloc Waiting for packet dumper to finish... 0 (prev_count=-1, count=252) Waiting for packet dumper to finish... 1 (prev_count=252, count=23220) MTC@8e66734a2b8c: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_mtu fail' was executed successfully (exit status: 0). MTC@8e66734a2b8c: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access'. ------ GGSN_Tests.TC_pdp6_act_deact_gtpu_access ------ Thu Oct 24 10:10:49 UTC 2024 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@8e66734a2b8c: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access' was executed successfully (exit status: 0). MTC@8e66734a2b8c: Test case TC_pdp6_act_deact_gtpu_access started. MTC@8e66734a2b8c: GTP1C ConnectionID: 1 MTC@8e66734a2b8c: "TC_pdp6_act_deact_gtpu_access() start" 20241024101051074 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): TC_pdp6_act_deact_gtpu_access() start (logging_vty.c:1172) MTC@8e66734a2b8c: sending CreatePDP [ 105.170680] tun46: GTPv1-U: new PDP ctx id=1/f116bf84 ssgn=172.18.3.1 ms=32.1.7.128 (pdp=(____ptrval____)) 20241024101051077 [1;32mDGGSN[0;m [1;32mINFO[0;m SGSN(172.18.3.1): Discovered (sgsn.c:83) 20241024101051077 [1;32mDGGSN[0;m [1;32mINFO[0;m PDP(262427517377946:10): Successful PDP Context Creation: APN=inet6(inet46), TEIC=1, IPv4=none, IPv6=2001:780:44:2104:: (ggsn.c:567) MTC@8e66734a2b8c: setverdict(pass): none -> pass [ 105.172935] tun46: encap_recv sk=(____ptrval____) [ 105.173018] tun46: received GTP1U packet [ 105.173051] tun46: No PDP ctx for this MS [ 105.173080] tun46: pass up to the process MTC@8e66734a2b8c: RA with /64 prefix '20010780004421040000000000000000'O [ 105.173761] tun46: encap_recv sk=(____ptrval____) [ 105.173811] tun46: received GTP1U packet [ 105.173842] tun46: No PDP ctx for this MS [ 105.173869] tun46: pass up to the process [ 105.174026] tun46: encap_recv sk=(____ptrval____) [ 105.174068] tun46: received GTP1U packet [ 105.174140] tun46: forwarding packet from GGSN to uplink [ 105.177530] tun46: found PDP context (____ptrval____) [ 105.177720] tun46: gtp -> IP src: 2001:0780:0044:2100:0000:0000:0000:0000 dst: 2001:0780:0044:2104:1234:1234:1234:1234 20241024101051085 [1;31mDTUN[0;m [1;31mERROR[0;m errno=9/Bad file descriptor TUN(tun46): write() failed (tun.c:324) MTC@8e66734a2b8c: setverdict(pass): pass -> pass, component reason not changed 20241024101051086 [1;32mDGGSN[0;m [1;32mINFO[0;m PDP(262427517377946:10): Deleting PDP context (ggsn.c:351) 20241024101051086 [1;32mDGGSN[0;m [1;32mINFO[0;m SGSN(172.18.3.1): Deleting SGSN (sgsn.c:21) [ 105.181184] tun46: GTPv1-U: deleting tunnel id = 1/f116bf84 (pdp (____ptrval____)) MTC@8e66734a2b8c: setverdict(pass): pass -> pass, component reason not changed MTC@8e66734a2b8c: Setting final verdict of the test case. MTC@8e66734a2b8c: Local verdict of MTC: pass MTC@8e66734a2b8c: No PTCs were created. MTC@8e66734a2b8c: Test case TC_pdp6_act_deact_gtpu_access finished. Verdict: pass MTC@8e66734a2b8c: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access pass'. Thu Oct 24 10:10:54 UTC 2024 [1;32m====== GGSN_Tests.TC_pdp6_act_deact_gtpu_access pass ======[0m Saving talloc report from 172.18.3.2:4260 to GGSN_Tests.TC_pdp6_act_deact_gtpu_access.talloc Waiting for packet dumper to finish... 0 (prev_count=-1, count=24348) Waiting for packet dumper to finish... 1 (prev_count=24348, count=33244) MTC@8e66734a2b8c: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access pass' was executed successfully (exit status: 0). MTC@8e66734a2b8c: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access_ll_saddr'. ------ GGSN_Tests.TC_pdp6_act_deact_gtpu_access_ll_saddr ------ Thu Oct 24 10:10:56 UTC 2024 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@8e66734a2b8c: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access_ll_saddr' was executed successfully (exit status: 0). MTC@8e66734a2b8c: Test case TC_pdp6_act_deact_gtpu_access_ll_saddr started. MTC@8e66734a2b8c: GTP1C ConnectionID: 1 MTC@8e66734a2b8c: "TC_pdp6_act_deact_gtpu_access_ll_saddr() start" 20241024101056211 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): TC_pdp6_act_deact_gtpu_access_ll_saddr() start (logging_vty.c:1172) MTC@8e66734a2b8c: sending CreatePDP [ 110.307640] tun46: GTPv1-U: new PDP ctx id=1/129ffff4 ssgn=172.18.3.1 ms=32.1.7.128 (pdp=(____ptrval____)) 20241024101056214 [1;32mDGGSN[0;m [1;32mINFO[0;m SGSN(172.18.3.1): Discovered (sgsn.c:83) 20241024101056214 [1;32mDGGSN[0;m [1;32mINFO[0;m PDP(262422006630974:8): Successful PDP Context Creation: APN=inet6(inet46), TEIC=1, IPv4=none, IPv6=2001:780:44:2105:: (ggsn.c:567) MTC@8e66734a2b8c: setverdict(pass): none -> pass [ 110.309075] tun46: encap_recv sk=(____ptrval____) [ 110.309145] tun46: received GTP1U packet [ 110.309182] tun46: No PDP ctx for this MS [ 110.309212] tun46: pass up to the process MTC@8e66734a2b8c: RA with /64 prefix '20010780004421050000000000000000'O [ 110.309860] tun46: encap_recv sk=(____ptrval____) [ 110.309914] tun46: received GTP1U packet [ 110.309944] tun46: No PDP ctx for this MS [ 110.309983] tun46: pass up to the process [ 110.310042] tun46: encap_recv sk=(____ptrval____) [ 110.310076] tun46: received GTP1U packet [ 110.310105] tun46: No PDP ctx for this MS [ 110.310131] tun46: pass up to the process 20241024101056216 [1;31mDTUN[0;m [1;31mERROR[0;m errno=9/Bad file descriptor TUN(tun46): write() failed (tun.c:324) 20241024101056216 [1;31mDTUN[0;m [1;31mERROR[0;m errno=9/Bad file descriptor TUN(tun46): write() failed (tun.c:324) MTC@8e66734a2b8c: This GGSN does NOT support forwarding link-local source address. MTC@8e66734a2b8c: setverdict(pass): pass -> pass, component reason not changed 20241024101059219 [1;32mDGGSN[0;m [1;32mINFO[0;m PDP(262422006630974:8): Deleting PDP context (ggsn.c:351) 20241024101059220 [1;32mDGGSN[0;m [1;32mINFO[0;m SGSN(172.18.3.1): Deleting SGSN (sgsn.c:21) [ 113.314862] tun46: GTPv1-U: deleting tunnel id = 1/129ffff4 (pdp (____ptrval____)) MTC@8e66734a2b8c: setverdict(pass): pass -> pass, component reason not changed MTC@8e66734a2b8c: Setting final verdict of the test case. MTC@8e66734a2b8c: Local verdict of MTC: pass MTC@8e66734a2b8c: No PTCs were created. MTC@8e66734a2b8c: Test case TC_pdp6_act_deact_gtpu_access_ll_saddr finished. Verdict: pass MTC@8e66734a2b8c: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access_ll_saddr pass'. Thu Oct 24 10:11:02 UTC 2024 [1;32m====== GGSN_Tests.TC_pdp6_act_deact_gtpu_access_ll_saddr pass ======[0m Saving talloc report from 172.18.3.2:4260 to GGSN_Tests.TC_pdp6_act_deact_gtpu_access_ll_saddr.talloc Waiting for packet dumper to finish... 0 (prev_count=-1, count=25204) [ 115.774524] tun46: no PDP ctx found for ff02:0000:0000:0000:0000:0000:0000:0002, skip Waiting for packet dumper to finish... 1 (prev_count=25204, count=34100) MTC@8e66734a2b8c: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access_ll_saddr pass' was executed successfully (exit status: 0). MTC@8e66734a2b8c: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_ll_saddr'. ------ GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_ll_saddr ------ Thu Oct 24 10:11:06 UTC 2024 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@8e66734a2b8c: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_ll_saddr' was executed successfully (exit status: 0). MTC@8e66734a2b8c: Test case TC_pdp6_act_deact_gtpu_access_wrong_ll_saddr started. MTC@8e66734a2b8c: GTP1C ConnectionID: 1 MTC@8e66734a2b8c: "TC_pdp6_act_deact_gtpu_access_wrong_ll_saddr() start" 20241024101106132 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): TC_pdp6_act_deact_gtpu_access_wrong_ll_saddr() start (logging_vty.c:1172) MTC@8e66734a2b8c: sending CreatePDP [ 120.227999] tun46: GTPv1-U: new PDP ctx id=1/9108fb8c ssgn=172.18.3.1 ms=32.1.7.128 (pdp=(____ptrval____)) 20241024101106134 [1;32mDGGSN[0;m [1;32mINFO[0;m SGSN(172.18.3.1): Discovered (sgsn.c:83) 20241024101106134 [1;32mDGGSN[0;m [1;32mINFO[0;m PDP(262428896447223:12): Successful PDP Context Creation: APN=inet6(inet46), TEIC=1, IPv4=none, IPv6=2001:780:44:2106:: (ggsn.c:567) MTC@8e66734a2b8c: setverdict(pass): none -> pass [ 120.229404] tun46: encap_recv sk=(____ptrval____) [ 120.229502] tun46: received GTP1U packet [ 120.229534] tun46: No PDP ctx for this MS [ 120.229560] tun46: pass up to the process MTC@8e66734a2b8c: RA with /64 prefix '20010780004421060000000000000000'O [ 120.230256] tun46: encap_recv sk=(____ptrval____) [ 120.230307] tun46: received GTP1U packet [ 120.230338] tun46: No PDP ctx for this MS [ 120.230365] tun46: pass up to the process [ 120.230469] tun46: encap_recv sk=(____ptrval____) [ 120.230508] tun46: received GTP1U packet [ 120.230537] tun46: No PDP ctx for this MS [ 120.230564] tun46: pass up to the process 20241024101106136 [1;31mDTUN[0;m [1;31mERROR[0;m errno=9/Bad file descriptor TUN(tun46): write() failed (tun.c:324) 20241024101106137 [1;31mDGGSN[0;m [1;31mERROR[0;m PDP(262428896447223:12): Packet from MS using unassigned src IPv6: fe80::3110:1691:1155:3017 (ggsn.c:695) MTC@8e66734a2b8c: Warning: Stopping inactive timer T_default. MTC@8e66734a2b8c: setverdict(pass): pass -> pass, component reason not changed 20241024101109141 [1;32mDGGSN[0;m [1;32mINFO[0;m PDP(262428896447223:12): Deleting PDP context (ggsn.c:351) 20241024101109142 [1;32mDGGSN[0;m [1;32mINFO[0;m SGSN(172.18.3.1): Deleting SGSN (sgsn.c:21) [ 123.236367] tun46: GTPv1-U: deleting tunnel id = 1/9108fb8c (pdp (____ptrval____)) MTC@8e66734a2b8c: setverdict(pass): pass -> pass, component reason not changed MTC@8e66734a2b8c: Setting final verdict of the test case. MTC@8e66734a2b8c: Local verdict of MTC: pass MTC@8e66734a2b8c: No PTCs were created. MTC@8e66734a2b8c: Test case TC_pdp6_act_deact_gtpu_access_wrong_ll_saddr finished. Verdict: pass MTC@8e66734a2b8c: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_ll_saddr pass'. Thu Oct 24 10:11:12 UTC 2024 [1;32m====== GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_ll_saddr pass ======[0m Saving talloc report from 172.18.3.2:4260 to GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_ll_saddr.talloc Waiting for packet dumper to finish... 0 (prev_count=-1, count=25356) Waiting for packet dumper to finish... 1 (prev_count=25356, count=34252) MTC@8e66734a2b8c: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_ll_saddr pass' was executed successfully (exit status: 0). MTC@8e66734a2b8c: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_global_saddr'. ------ GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_global_saddr ------ Thu Oct 24 10:11:14 UTC 2024 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@8e66734a2b8c: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_global_saddr' was executed successfully (exit status: 0). MTC@8e66734a2b8c: Test case TC_pdp6_act_deact_gtpu_access_wrong_global_saddr started. MTC@8e66734a2b8c: GTP1C ConnectionID: 1 MTC@8e66734a2b8c: "TC_pdp6_act_deact_gtpu_access_wrong_global_saddr() start" 20241024101114227 [1;33mDLGLOBAL[0;m [1;33mNOTICE[0;m TTCN3 f_logp(): TC_pdp6_act_deact_gtpu_access_wrong_global_saddr() start (logging_vty.c:1172) MTC@8e66734a2b8c: sending CreatePDP [ 128.327638] tun46: GTPv1-U: new PDP ctx id=1/152d9136 ssgn=172.18.3.1 ms=32.1.7.128 (pdp=(____ptrval____)) 20241024101114234 [1;32mDGGSN[0;m [1;32mINFO[0;m SGSN(172.18.3.1): Discovered (sgsn.c:83) 20241024101114235 [1;32mDGGSN[0;m [1;32mINFO[0;m PDP(262429334522933:7): Successful PDP Context Creation: APN=inet6(inet46), TEIC=1, IPv4=none, IPv6=2001:780:44:2107:: (ggsn.c:567) MTC@8e66734a2b8c: setverdict(pass): none -> pass [ 128.332435] tun46: encap_recv sk=(____ptrval____) [ 128.332631] tun46: received GTP1U packet [ 128.332751] tun46: No PDP ctx for this MS [ 128.332863] tun46: pass up to the process MTC@8e66734a2b8c: RA with /64 prefix '20010780004421070000000000000000'O [ 128.335219] tun46: encap_recv sk=(____ptrval____) [ 128.335417] tun46: received GTP1U packet [ 128.335544] tun46: No PDP ctx for this MS [ 128.335725] tun46: pass up to the process [ 128.335922] tun46: encap_recv sk=(____ptrval____) [ 128.336039] tun46: received GTP1U packet [ 128.336146] tun46: No PDP ctx for this MS [ 128.336248] tun46: pass up to the process 20241024101114243 [1;31mDTUN[0;m [1;31mERROR[0;m errno=9/Bad file descriptor TUN(tun46): write() failed (tun.c:324) 20241024101114244 [1;31mDGGSN[0;m [1;31mERROR[0;m PDP(262429334522933:7): Packet from MS using unassigned src IPv6: 3110:1691:1155:3016:325:325:325:325 (ggsn.c:695) MTC@8e66734a2b8c: Warning: Stopping inactive timer T_default. 20241024101117249 [1;32mDGGSN[0;m [1;32mINFO[0;m PDP(262429334522933:7): Deleting PDP context (ggsn.c:351)MTC@8e66734a2b8c: setverdict(pass): pass -> pass, component reason not changed 20241024101117251 [1;32mDGGSN[0;m [1;32mINFO[0;m SGSN(172.18.3.1): Deleting SGSN (sgsn.c:21) [ 131.346612] tun46: GTPv1-U: deleting tunnel id = 1/152d9136 (pdp (____ptrval____)) MTC@8e66734a2b8c: setverdict(pass): pass -> pass, component reason not changed MTC@8e66734a2b8c: Setting final verdict of the test case. MTC@8e66734a2b8c: Local verdict of MTC: pass MTC@8e66734a2b8c: No PTCs were created. MTC@8e66734a2b8c: Test case TC_pdp6_act_deact_gtpu_access_wrong_global_saddr finished. Verdict: pass MTC@8e66734a2b8c: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_global_saddr pass'. Thu Oct 24 10:11:20 UTC 2024 [1;32m====== GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_global_saddr pass ======[0m Saving talloc report from 172.18.3.2:4260 to GGSN_Tests.TC_pdp6_act_deact_gtpu_access_wrong_global_saddr.talloc Waiting for packet dumper to finish... 0 (prev_count=-1, count=25884) Waiting for packet dumper to finish... 1 (prev_count=25884, count=34780) [0;94m[testenv][osmo_ggsn_v4v6_only] Testsuite is done[0m [1;34m[testenv][osmo_ggsn_v4v6_only] Stopping testsuite (2996889)[0m [1;34m[testenv][osmo_ggsn_v4v6_only] Merging log files[0m [0;94m[testenv][osmo_ggsn_v4v6_only] + ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…',> '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TERM=dumb', '-e', 'TESTENV_GIT_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…',> '-e', 'TESTENV_QEMU_KERNEL=<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…',> '-e', 'TESTENV_QEMU_SCRIPTS=<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…',> '-e', 'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-t', '-w', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…',> 'testenv-ggsn_tests-osmo_ggsn_v_only-osmocom-latest-20241024-1006-4b528e53-1', 'sh', '-c', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests --rm >/dev/null'][0m Error: no container with name or ID "testenv-ggsn_tests-osmo_ggsn_v_only-osmocom-latest-20241024-1006-4b528e53-1" found: no such container [1;91m[testenv][osmo_ggsn_v4v6_only] Command failed unexpectedly[0m [0;94m[testenv][osmo_ggsn_v4v6_only] Command: ['podman', 'exec', '-e', 'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e', 'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…',> '-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace', '-e', 'TERM=dumb', '-e', 'TESTENV_GIT_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…',> '-e', 'TESTENV_QEMU_KERNEL=<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…',> '-e', 'TESTENV_QEMU_SCRIPTS=<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…',> '-e', 'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin', '-e', 'HOME=/home/osmocom-build', '-t', '-w', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…',> 'testenv-ggsn_tests-osmo_ggsn_v_only-osmocom-latest-20241024-1006-4b528e53-1', 'sh', '-c', '<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…> GGSN_Tests --rm >/dev/null'][0m [0;94m[testenv][osmo_ggsn_v4v6_only] Returncode: 125[0m Traceback (most recent call last): File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…",> line 115, in <module> main() File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…",> line 104, in main run() File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…",> line 63, in run testenv.testsuite.run(cfg) File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…",> line 204, in run merge_log_files(cfg) File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…",> line 130, in merge_log_files testenv.cmd.run(cmd, cwd=cwd) File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…",> line 101, in run return testenv.podman.exec_cmd(cmd, check=check, env=env, *args, **kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…",> line 149, in exec_cmd testenv.cmd.run( File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…",> line 118, in run exit_error_cmd(p, "Command failed unexpectedly") File "<https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n…",> line 66, 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][osmo_ggsn_v4v6_only] Skipping clean up scripts, podman container has already stopped[0m Error: no container with name or ID "testenv-ggsn_tests-osmo_ggsn_v_only-osmocom-latest-20241024-1006-4b528e53-1" found: no such container [1;91m[testenv] podman container crashed![0m [1;34m[testenv][osmo_ggsn_v4v6_only] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-kernel-latest-net-n… [0m 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-stp-test-latest #1802
by jenkins＠lists.osmocom.org 24 Oct '24

24 Oct '24

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-stp-test-latest/1802/display/…>

1 0

Build failed in Jenkins: master-osmo-sgsn » --enable-iu,1,a3=default,a4=default,osmocom-master #50901
by jenkins＠lists.osmocom.org 24 Oct '24

24 Oct '24

See <https://jenkins.osmocom.org/jenkins/job/master-osmo-sgsn/IU=--enable-iu,WIT…> Changes: ------------------------------------------ [...truncated 442.58 KiB...] > ss -tn State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ss -tln State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ps xua | grep osmo build 109908 3.5 0.0 27972 23588 ? S 04:23 0:00 /usr/bin/python3 /usr/local/bin/osmotestconfig.py -p /build -w /build -v build 109931 0.0 0.0 21474894360 20412 ? D 04:23 0:00 src/sgsn/osmo-sgsn -c /build/writtenconfig/osmo-sgsn.cfgnukoi9cj build 109938 0.0 0.0 2576 940 ? S 04:23 0:00 /bin/sh -c ps xua | grep osmo build 109940 0.0 0.0 3700 1820 ? S 04:23 0:00 grep osmo Connecting socket failed, retrying... Connecting socket failed, retrying... Socket: in 3 tries, connected to 127.0.0.1:4245 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 60994), raddr=('127.0.0.1', 4245)> (1 sockets open) Terminating took 0.897s Process returned code: 0 Socket: closing 127.0.0.1:4245 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 60994), raddr=('127.0.0.1', 4245)> (0 sockets open) Verifying src/gtphub/osmo-gtphub -c /build/doc/examples/osmo-gtphub/osmo-gtphub-1iface.cfg, test verify_doc Launching: PWD=/build 'src/gtphub/osmo-gtphub' '-c' '/build/doc/examples/osmo-gtphub/osmo-gtphub-1iface.cfg' > ls -l /proc/109908/fd total 0 lr-x------ 1 build build 64 Oct 24 04:23 0 -> pipe:[1672270819] l-wx------ 1 build build 64 Oct 24 04:23 1 -> pipe:[1672270820] l-wx------ 1 build build 64 Oct 24 04:23 2 -> pipe:[1672270821] l-wx------ 1 build build 64 Oct 24 04:23 3 -> /dev/null > ss -tn State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ss -tln State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess LISTEN 0 10 127.0.0.1:4253 0.0.0.0:* > ps xua | grep osmo build 109908 1.1 0.0 27972 23588 ? S 04:23 0:00 /usr/bin/python3 /usr/local/bin/osmotestconfig.py -p /build -w /build -v build 109942 0.0 0.0 21474888936 14032 ? S 04:23 0:00 src/gtphub/osmo-gtphub -c /build/doc/examples/osmo-gtphub/osmo-gtphub-1iface.cfg build 109949 0.0 0.0 2576 908 ? S 04:23 0:00 /bin/sh -c ps xua | grep osmo build 109951 0.0 0.0 3700 1896 ? S 04:23 0:00 grep osmo Socket: in 1 tries, connected to 127.0.0.1:4253 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 44266), raddr=('127.0.0.1', 4253)> (1 sockets open) Terminating took 0.897s Process returned code: 0 Socket: closing 127.0.0.1:4253 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 44266), raddr=('127.0.0.1', 4253)> (0 sockets open) Verifying src/gtphub/osmo-gtphub -c /build/writtenconfig/osmo-gtphub-1iface.cfgcu7ov9i3, test write_config Launching: PWD=/build 'src/gtphub/osmo-gtphub' '-c' '/build/writtenconfig/osmo-gtphub-1iface.cfgcu7ov9i3' > ls -l /proc/109908/fd total 0 lr-x------ 1 build build 64 Oct 24 04:23 0 -> pipe:[1672270819] l-wx------ 1 build build 64 Oct 24 04:23 1 -> pipe:[1672270820] l-wx------ 1 build build 64 Oct 24 04:23 2 -> pipe:[1672270821] l-wx------ 1 build build 64 Oct 24 04:23 3 -> /dev/null > ss -tn State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ss -tln State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess LISTEN 0 10 127.0.0.1:4253 0.0.0.0:* > ps xua | grep osmo build 109908 1.2 0.0 28128 23588 ? S 04:23 0:00 /usr/bin/python3 /usr/local/bin/osmotestconfig.py -p /build -w /build -v build 109953 25.0 0.0 21474888936 14120 ? S 04:23 0:00 src/gtphub/osmo-gtphub -c /build/writtenconfig/osmo-gtphub-1iface.cfgcu7ov9i3 build 109960 0.0 0.0 2576 900 ? S 04:23 0:00 /bin/sh -c ps xua | grep osmo build 109962 0.0 0.0 3700 1820 ? S 04:23 0:00 grep osmo Socket: in 1 tries, connected to 127.0.0.1:4253 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 44276), raddr=('127.0.0.1', 4253)> (1 sockets open) Terminating took 0.897s Process returned code: 0 Socket: closing 127.0.0.1:4253 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 44276), raddr=('127.0.0.1', 4253)> (0 sockets open) Verifying src/gtphub/osmo-gtphub -c /build/writtenconfig/osmo-gtphub-1iface.cfgcu7ov9i3, test token_vty_command Launching: PWD=/build 'src/gtphub/osmo-gtphub' '-c' '/build/writtenconfig/osmo-gtphub-1iface.cfgcu7ov9i3' > ls -l /proc/109908/fd total 0 lr-x------ 1 build build 64 Oct 24 04:23 0 -> pipe:[1672270819] l-wx------ 1 build build 64 Oct 24 04:23 1 -> pipe:[1672270820] l-wx------ 1 build build 64 Oct 24 04:23 2 -> pipe:[1672270821] l-wx------ 1 build build 64 Oct 24 04:23 3 -> /dev/null > ss -tn State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ss -tln State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ps xua | grep osmo build 109908 1.0 0.0 28128 23588 ? S 04:23 0:00 /usr/bin/python3 /usr/local/bin/osmotestconfig.py -p /build -w /build -v build 109964 0.0 0.0 21474888260 13644 ? D 04:23 0:00 src/gtphub/osmo-gtphub -c /build/writtenconfig/osmo-gtphub-1iface.cfgcu7ov9i3 build 109971 0.0 0.0 2576 904 ? S 04:23 0:00 /bin/sh -c ps xua | grep osmo build 109973 0.0 0.0 3700 1896 ? S 04:23 0:00 grep osmo Failed to verify src/gtphub/osmo-gtphub -c /build/writtenconfig/osmo-gtphub-1iface.cfgcu7ov9i3 Current directory: /build Error was [Errno 111] Connection refused Config was ! ! OsmoGTPhub (1.12.0.16-62132) configuration saved from vty !! ! log stderr logging filter all 1 logging color 1 logging print category-hex 0 logging print category 1 logging print thread-id 0 logging timestamp 0 logging print level 1 logging print file basename last logging level gtphub info logging level lglobal notice logging level llapd notice logging level linp notice logging level lmux notice logging level lmi notice logging level lmib notice logging level lsms notice logging level lctrl notice logging level lgtp notice logging level lstats notice logging level lgsup notice logging level loap notice logging level lss7 notice logging level lsccp notice logging level lsua notice logging level lm3ua notice logging level lmgcp notice logging level ljibuf notice logging level lrspro notice logging level lns notice logging level lbssgp notice logging level lnsdata notice logging level lnssignal notice logging level liuup notice logging level lpfcp notice logging level lcsn1 notice logging level lio notice ! line vty no login ! gtphub bind-to-sgsns ctrl 127.0.0.1 12123 user 127.0.0.1 12153 grx-dns-add 192.168.0.1 bind-to-ggsns 127.0.0.1 sgsn-proxy 127.0.0.4 ggsn-proxy ctrl 127.0.0.3 2123 user 127.0.0.5 2152 grx-dns-add 192.168.0.1 Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Connecting socket failed, retrying... Terminating took 0.897s Process returned code: 0 Socket: closing 127.0.0.1:4253 <socket.socket fd=5, family=2, type=1, proto=0, laddr=('0.0.0.0', 44564)> (0 sockets open) Traceback (most recent call last): File "/usr/local/bin/osmotestconfig.py", line 4, in <module> __import__('pkg_resources').run_script('osmopython==0.2.1', 'osmotestconfig.py') File "/usr/lib/python3/dist-packages/pkg_resources/__init__.py", line 708, in run_script self.require(requires)[0].run_script(script_name, ns) File "/usr/lib/python3/dist-packages/pkg_resources/__init__.py", line 1517, in run_script exec(code, namespace, namespace) File "/usr/local/lib/python3.11/dist-packages/osmopython-0.2.1-py3.11.egg/EGG-INFO/scripts/osmotestconfig.py", line 192, in <module> sys.exit(test_all_apps(apps, configs, ignore_configs=ignores, ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.11/dist-packages/osmopython-0.2.1-py3.11.egg/EGG-INFO/scripts/osmotestconfig.py", line 153, in test_all_apps test_config(app, config, tmpdir, verbose) File "/usr/local/lib/python3.11/dist-packages/osmopython-0.2.1-py3.11.egg/EGG-INFO/scripts/osmotestconfig.py", line 36, in test_config if test_config_atest(app_desc, newconfig, token_vty_command, verbose) > 0: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.11/dist-packages/osmopython-0.2.1-py3.11.egg/EGG-INFO/scripts/osmotestconfig.py", line 60, in test_config_atest raise se File "/usr/local/lib/python3.11/dist-packages/osmopython-0.2.1-py3.11.egg/EGG-INFO/scripts/osmotestconfig.py", line 53, in test_config_atest ret = run_test(vty) ^^^^^^^^^^^^^ File "/usr/local/lib/python3.11/dist-packages/osmopython-0.2.1-py3.11.egg/EGG-INFO/scripts/osmotestconfig.py", line 95, in token_vty_command vty.command("help") File "/usr/local/lib/python3.11/dist-packages/osmopython-0.2.1-py3.11.egg/osmopy/obscvty.py", line 222, in command return self._common_command(request, close) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.11/dist-packages/osmopython-0.2.1-py3.11.egg/osmopy/obscvty.py", line 175, in _common_command self._connect_socket() File "/usr/local/lib/python3.11/dist-packages/osmopython-0.2.1-py3.11.egg/osmopy/obscvty.py", line 82, in _connect_socket self.socket.connect((self.host, self.port)) ConnectionRefusedError: [Errno 111] Connection refused make[7]: *** [Makefile:712: vty-python-test] Error 1 make[7]: Leaving directory '/build/tests' make[6]: *** [Makefile:728: vty-test] Error 2 make[6]: Leaving directory '/build/tests' make[5]: Leaving directory '/build/tests' make[5]: *** [Makefile:705: python-tests] Error 2 make[4]: Leaving directory '/build/tests' make[4]: *** [Makefile:737: check-local] Error 2 make[3]: *** [Makefile:565: check-am] Error 2 make[3]: Leaving directory '/build/tests' make[2]: Leaving directory '/build/tests' make[2]: *** [Makefile:415: check-recursive] Error 1 make[1]: *** [Makefile:459: check-recursive] Error 1 make[1]: Leaving directory '/build' make: *** [Makefile:758: check] Error 2 + cat-testlogs.sh Build step 'Execute shell' marked build as failure $ ssh-agent -k unset SSH_AUTH_SOCK; unset SSH_AGENT_PID; echo Agent pid 3806621 killed; [ssh-agent] Stopped. Archiving artifacts

1 1

Build failed in Jenkins: master-osmo-msc » --enable-iu,1,a3=default,a4=default,osmocom-master #46152
by jenkins＠lists.osmocom.org 24 Oct '24

24 Oct '24

See <https://jenkins.osmocom.org/jenkins/job/master-osmo-msc/IU=--enable-iu,WITH…> Changes: ------------------------------------------ [...truncated 573.58 KiB...] logging level lmux notice logging level lmi notice logging level lmib notice logging level lsms notice logging level lctrl notice logging level lgtp notice logging level lstats notice logging level lgsup notice logging level loap notice logging level lss7 notice logging level lsccp notice logging level lsua notice logging level lm3ua notice logging level lmgcp notice logging level ljibuf notice logging level lrspro notice logging level lns notice logging level lbssgp notice logging level lnsdata notice logging level lnssignal notice logging level liuup notice logging level lpfcp notice logging level lcsn1 notice logging level lio notice ! stats interval 5 ! line vty no login ! cs7 instance 0 point-code 0.23.1 network network country code 001 mobile network code 01 short name OsmoMSC long name OsmoMSC encryption a5 0 encryption uea 1 2 authentication optional rrlp mode none mm info 1 mgw 0 local-port 2728 remote-ip 127.0.0.1 remote-port 2427 msc mncc internal mncc guard-timeout 180 ncss guard-timeout 30 assign-tmsi cs7-instance-a 0 cs7-instance-iu 0 auth-tuple-max-reuse-count 3 auth-tuple-reuse-on-error 1 mncc-int default-codec tch-f fr default-codec tch-h hr smpp local-tcp-port 2775 policy closed no smpp-first hlr remote-ip 127.0.0.1 remote-port 4222 ipa-name unnamed-MSC sgs local-port 29118 local-ip 0.0.0.0 vlr-name vlr.example.net smsc queue max-pending 20 queue max-failure 1 database delete-delivered 1 database delete-expired 1 validity-period minimum 1 validity-period default 10080 asci disable gcr end [1;33mDMSC[0;m [1;33mNOTICE[0;m Terminating due to signal 15 (msc_main.c:286) full talloc report on 'osmo_msc' (total 19927 bytes in 98 blocks) asn1 contains 0 bytes in 1 blocks (ref 0) 0x608000006800 struct osmo_ss7_instance contains 5250 bytes in 40 blocks (ref 0) 0x6140000034a0 struct osmo_sccp_instance contains 951 bytes in 8 blocks (ref 0) 0x611000011ee0 struct osmo_sccp_user contains 93 bytes in 2 blocks (ref 0) 0x60f000004330 OsmoMSC-IuCS contains 13 bytes in 1 blocks (ref 0) 0x60b000246910 struct osmo_sccp_user contains 90 bytes in 2 blocks (ref 0) 0x60f000004240 OsmoMSC-A contains 10 bytes in 1 blocks (ref 0) 0x60b000246860 struct osmo_sccp_user contains 96 bytes in 2 blocks (ref 0) 0x60f000004150 SCCP Management contains 16 bytes in 1 blocks (ref 0) 0x60b0002467b0 sccp_user.c:241 contains 560 bytes in 1 blocks (ref 0) 0x617000003560 struct osmo_ss7_asp contains 2979 bytes in 19 blocks (ref 0) 0x618000005ce0 struct osmo_fsm_inst contains 373 bytes in 4 blocks (ref 0) 0x6120000093a0 struct xua_asp_fsm_priv contains 104 bytes in 1 blocks (ref 0) 0x611000011da0 XUA_ASP(asp-clnt-OsmoMSC-A-Iu)[0x6120000093a0] contains 47 bytes in 1 blocks (ref 0) 0x60d0000344b0 asp-clnt-OsmoMSC-A-Iu contains 22 bytes in 1 blocks (ref 0) 0x60c000069be0 struct osmo_stream_cli contains 954 bytes in 4 blocks (ref 0) 0x6190000172e0 localhost contains 10 bytes in 1 blocks (ref 0) 0x60b000246650 localhost contains 10 bytes in 1 blocks (ref 0) 0x60b0002465a0 asp-clnt-OsmoMSC-A-Iu contains 22 bytes in 1 blocks (ref 0) 0x60c0000698e0 struct osmo_fsm_inst contains 284 bytes in 4 blocks (ref 0) 0x612000009220 struct lm_fsm_priv contains 8 bytes in 1 blocks (ref 0) 0x60b0002464f0 xua_default_lm(asp-clnt-OsmoMSC-A-Iu)[0x612000009220] contains 54 bytes in 1 blocks (ref 0) 0x60e00002f580 asp-clnt-OsmoMSC-A-Iu contains 22 bytes in 1 blocks (ref 0) 0x60c000069820 localhost contains 10 bytes in 1 blocks (ref 0) 0x60b000246440 localhost contains 10 bytes in 1 blocks (ref 0) 0x60b000246390 osmo_ss7_asp.c:561 contains 280 bytes in 1 blocks (ref 0) 0x61300000a360 asp-clnt-OsmoMSC-A-Iu contains 22 bytes in 1 blocks (ref 0) 0x60c000069760 rate_ctr.c:233 contains 302 bytes in 2 blocks (ref 0) 0x61300000a1a0 asp-clnt-OsmoMSC-A-Iu contains 22 bytes in 1 blocks (ref 0) 0x60c0000696a0 struct osmo_ss7_as contains 868 bytes in 8 blocks (ref 0) 0x613000009fe0 struct osmo_fsm_inst contains 378 bytes in 4 blocks (ref 0) 0x6120000090a0 struct xua_as_fsm_priv contains 112 bytes in 1 blocks (ref 0) 0x611000011b20 XUA_AS(as-clnt-OsmoMSC-A-Iu)[0x6120000090a0] contains 45 bytes in 1 blocks (ref 0) 0x60d0000343e0 as-clnt-OsmoMSC-A-Iu contains 21 bytes in 1 blocks (ref 0) 0x60c000069460 as-clnt-OsmoMSC-A-Iu contains 21 bytes in 1 blocks (ref 0) 0x60c0000693a0 rate_ctr.c:233 contains 221 bytes in 2 blocks (ref 0) 0x612000008f20 as-clnt-OsmoMSC-A-Iu contains 21 bytes in 1 blocks (ref 0) 0x60c0000692e0 struct osmo_ss7_route_table contains 148 bytes in 4 blocks (ref 0) 0x60e00002f3c0 struct osmo_ss7_route contains 85 bytes in 2 blocks (ref 0) 0x60e00002f4a0 as-clnt-OsmoMSC-A-Iu contains 21 bytes in 1 blocks (ref 0) 0x60c000069520 system contains 7 bytes in 1 blocks (ref 0) 0x60b0002462e0 telnet_connection contains 1 bytes in 1 blocks (ref 0) 0x60b00023e9e0 struct osmo_stream_srv_link contains 1920 bytes in 2 blocks (ref 0) 0x61d000000ae0 0.0.0.0 contains 8 bytes in 1 blocks (ref 0) 0x60b000235cf0 struct sgs_state contains 376 bytes in 1 blocks (ref 0) 0x615000002b60 struct smsc contains 152 bytes in 1 blocks (ref 0) 0x6110000096a0 sms.db contains 7 bytes in 1 blocks (ref 0) 0x60b00011a420 struct sms_queue_config contains 32 bytes in 1 blocks (ref 0) 0x60c000036520 struct gsm_network contains 11379 bytes in 32 blocks (ref 0) 0x6150000028e0 struct sccp_ran_inst contains 152 bytes in 1 blocks (ref 0) 0x611000012160 struct sccp_ran_inst contains 152 bytes in 1 blocks (ref 0) 0x611000012020 struct gsm_sms_queue contains 776 bytes in 4 blocks (ref 0) 0x613000008ca0 rate_ctr.c:233 contains 440 bytes in 1 blocks (ref 0) 0x616000006fe0 stat_item.c:195 contains 104 bytes in 2 blocks (ref 0) 0x60d0000303b0 struct osmo_stat_item contains 56 bytes in 1 blocks (ref 0) 0x60e00002ecc0 struct gsup_client_mux contains 682 bytes in 6 blocks (ref 0) 0x611000009e20 struct osmo_gsup_client contains 514 bytes in 4 blocks (ref 0) 0x613000008ae0 struct osmo_fd contains 48 bytes in 1 blocks (ref 0) 0x60d0000302e0 struct ipa_client_conn contains 202 bytes in 2 blocks (ref 0) 0x612000004ba0 127.0.0.1 contains 10 bytes in 1 blocks (ref 0) 0x60b00023fbc0 struct ipaccess_unit contains 64 bytes in 1 blocks (ref 0) 0x60e00002ebe0 struct ctrl_handle contains 88 bytes in 1 blocks (ref 0) 0x6100000024a0 127.0.0.1 contains 10 bytes in 1 blocks (ref 0) 0x60b00023cfc0 struct vlr_instance contains 2496 bytes in 5 blocks (ref 0) 0x6130000067e0 rate_ctr.c:233 contains 2040 bytes in 1 blocks (ref 0) 0x61d0000000e0 stat_item.c:195 contains 168 bytes in 2 blocks (ref 0) 0x60e00003ec40 struct osmo_stat_item contains 112 bytes in 1 blocks (ref 0) 0x611000009560 struct osmo_nri_ranges contains 16 bytes in 1 blocks (ref 0) 0x60b0002183f0 struct mgcp_client_conf contains 1088 bytes in 1 blocks (ref 0) 0x61a00000aee0 struct mgcp_client_pool contains 2877 bytes in 7 blocks (ref 0) 0x60d000021260 struct mgcp_client_pool_member contains 2716 bytes in 4 blocks (ref 0) 0x61a00000b4e0 struct mgcp_client contains 1580 bytes in 3 blocks (ref 0) 0x61a00000c0e0 struct osmo_io_fd contains 284 bytes in 2 blocks (ref 0) 0x613000009e20 r=127.0.0.1:2427<->l=127.0.0.1:2728 contains 36 bytes in 1 blocks (ref 0) 0x60d000034310 struct cmd_node contains 121 bytes in 2 blocks (ref 0) 0x611000006c20 %s(config-mgw)# contains 17 bytes in 1 blocks (ref 0) 0x60c000041560 127.0.0.1 contains 10 bytes in 1 blocks (ref 0) 0x60b00011a370 stat_item.c:195 contains 168 bytes in 2 blocks (ref 0) 0x60e000033100 struct osmo_stat_item contains 112 bytes in 1 blocks (ref 0) 0x611000006720 rate_ctr.c:233 contains 2520 bytes in 1 blocks (ref 0) 0x61e0000000e0 struct sched_vty_opts contains 72 bytes in 1 blocks (ref 0) 0x60f000001bd0 utils.c:386 contains 203 bytes in 1 blocks (ref 0) 0x612000000220 utils.c:386 contains 46 bytes in 1 blocks (ref 0) 0x60d0000034a0 utils.c:386 contains 165 bytes in 1 blocks (ref 0) 0x6120000000a0 utils.c:386 contains 43 bytes in 1 blocks (ref 0) 0x60d0000033d0 transaction contains 0 bytes in 1 blocks (ref 0) 0x608000000380 gsm_call contains 0 bytes in 1 blocks (ref 0) 0x608000000300 sms contains 0 bytes in 1 blocks (ref 0) 0x608000000280 osmo_signal contains 280 bytes in 8 blocks (ref 0) 0x608000000200 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d000034650 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d000034580 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d000030550 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d000030480 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d000030070 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00000d7f0 struct signal_handler contains 40 bytes in 1 blocks (ref 0) 0x60d00002e670 msgb contains 0 bytes in 1 blocks (ref 0) 0x608000000180 full talloc report on 'null_context' (total 24 bytes in 2 blocks) struct lookup_helper contains 24 bytes in 1 blocks (ref 0) 0x60c000067ba0 signal 15 received Terminating took 0.897s RESULTS: pass: ./test_neighbor_ident.vty pass: ./test_nodes.vty rm -f ./sms.db* make[7]: Leaving directory '/build/tests' make[6]: Leaving directory '/build/tests' make ctrl-test make[6]: Entering directory '/build/tests' make ctrl-python-test make[7]: Entering directory '/build/tests' ./ctrl_test_runner.py -w /build -v testRateCounters (__main__.TestCtrlMSC.testRateCounters) ... ERROR ====================================================================== ERROR: testRateCounters (__main__.TestCtrlMSC.testRateCounters) ---------------------------------------------------------------------- Traceback (most recent call last): File "/build/tests/./ctrl_test_runner.py", line 69, in tearDown raise Exception("Process returned %d" % rc) Exception: Process returned -9 ---------------------------------------------------------------------- Ran 1 test in 9.060s FAILED (errors=1) confpath /build/tests/.., workdir /build Running tests for specific control commands Opening /dev/null Launching: PWD=/build './src/osmo-msc/osmo-msc' '-c' '/build/tests/../doc/examples/osmo-msc/osmo-msc.cfg' Connecting to host 127.0.0.1:4255 Sending "GET 1000 rate_ctr.*" Got message: b'ERROR 1000 GET variable contains invalid characters' Decoded replies: {1000: {'mtype': b'ERROR', 'id': 1000, 'var': b'GET', 'value': b'variable contains invalid characters'}} Killed child process Process returned code: -9 make[7]: *** [Makefile:747: ctrl-python-test] Error 1 make[7]: Leaving directory '/build/tests' make[6]: Leaving directory '/build/tests' make[6]: *** [Makefile:758: ctrl-test] Error 2 make[5]: *** [Makefile:714: python-tests] Error 2 make[5]: Leaving directory '/build/tests' make[4]: Leaving directory '/build/tests' make[4]: *** [Makefile:767: check-local] Error 2 make[3]: Leaving directory '/build/tests' make[3]: *** [Makefile:572: check-am] Error 2 make[2]: *** [Makefile:422: check-recursive] Error 1 make[2]: Leaving directory '/build/tests' make[1]: Leaving directory '/build' make[1]: *** [Makefile:471: check-recursive] Error 1 make: *** [Makefile:770: check] Error 2 + exit_tar_workspace + '[' 1 = 1 ']' + tar -cJf /tmp/workspace.tar.xz /build tar: Removing leading `/' from member names + mv /tmp/workspace.tar.xz /build + cat-testlogs.sh Build step 'Execute shell' marked build as failure $ ssh-agent -k unset SSH_AUTH_SOCK; unset SSH_AGENT_PID; echo Agent pid 1290677 killed; [ssh-agent] Stopped. Archiving artifacts

1 0

Build failed in Jenkins: master-osmo-msc » --enable-iu,1,a3=default,a4=default,osmocom-master #46148
by jenkins＠lists.osmocom.org 24 Oct '24

24 Oct '24

See <https://jenkins.osmocom.org/jenkins/job/master-osmo-msc/IU=--enable-iu,WITH…> Changes: ------------------------------------------ [...truncated 765.01 KiB...] l-wx------ 1 build build 64 Oct 23 23:58 1 -> pipe:[1665102776] l-wx------ 1 build build 64 Oct 23 23:58 2 -> pipe:[1665102777] l-wx------ 1 build build 64 Oct 23 23:58 3 -> /dev/null > ss -tn State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ss -tln State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess LISTEN 0 10 127.0.0.1:4254 0.0.0.0:* LISTEN 0 10 127.0.0.1:4255 0.0.0.0:* LISTEN 0 10 0.0.0.0:2775 0.0.0.0:* > ps xua | grep osmo build 121073 0.0 0.0 3924 3060 ? S 23:58 0:00 /bin/bash -c test -d osmo-msc-1.12.1.16-2fb32/_build || exit 0; \ dc_install_base=`CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_inst && pwd | sed -e 's,^[^:\\/]:[\\/],/,'` \ && dc_destdir="${TMPDIR-/tmp}/am-dc-$$/" \ && am__cwd=`pwd` \ && CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_build/sub \ && ../../configure \ --with-systemdsystemunitdir=$dc_install_base//lib/systemd/system \ --enable-werror --enable-smpp --enable-iu --enable-external-tests --enable-manuals \ --srcdir=../.. --prefix="$dc_install_base" \ && make \ && make dvi \ && make check \ && make install \ && make installcheck \ && make uninstall \ && make distuninstallcheck_dir="$dc_install_base" \ distuninstallcheck \ && chmod -R a-w "$dc_install_base" \ && ({ \ (cd ../.. && umask 077 && mkdir "$dc_destdir") \ && make DESTDIR="$dc_destdir" install \ && make DESTDIR="$dc_destdir" uninstall \ && make DESTDIR="$dc_destdir" \ distuninstallcheck_dir="$dc_destdir" distuninstallcheck; \ } || { rm -rf "$dc_destdir"; exit 1; }) \ && rm -rf "$dc_destdir" \ && make dist \ && rm -rf osmo-msc-1.12.1.16-2fb32.tar.gz osmo-msc-1.12.1.16-2fb32.tar.bz2 \ && make distcleancheck \ && cd "$am__cwd" \ || exit 1 build 125566 0.0 0.0 3924 3032 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '2'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='include src doc contrib tests ' ;; \ *) list='include src doc contrib tests ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 125773 0.0 0.0 3924 3068 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '3'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp' ;; \ *) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 132539 36.3 0.0 19652 14704 ? S 23:58 0:00 python3 ../../../tests/vty_test_runner.py -w /build/osmo-msc-1.12.1.16-2fb32/_build/sub -v build 132540 0.0 0.0 20724 13008 ? S 23:58 0:00 ./src/osmo-msc/osmo-msc -c /build/osmo-msc-1.12.1.16-2fb32/tests/../doc/examples/osmo-msc/osmo-msc.cfg build 132547 0.0 0.0 2576 904 ? S 23:58 0:00 /bin/sh -c ps xua | grep osmo build 132549 0.0 0.0 3700 1852 ? S 23:58 0:00 grep osmo Socket: in 1 tries, connected to 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 57038), raddr=('127.0.0.1', 4254)> (1 sockets open) Socket: closing 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 57038), raddr=('127.0.0.1', 4254)> (0 sockets open) Terminating took 0.897s Process returned code: 0 ok testEnableDisablePeriodicLU (__main__.TestVTYMSC.testEnableDisablePeriodicLU) ... Launching: PWD=/build/osmo-msc-1.12.1.16-2fb32/_build/sub './src/osmo-msc/osmo-msc' '-c' '/build/osmo-msc-1.12.1.16-2fb32/tests/../doc/examples/osmo-msc/osmo-msc.cfg' > ls -l /proc/132539/fd total 0 lr-x------ 1 build build 64 Oct 23 23:58 0 -> pipe:[1665102775] l-wx------ 1 build build 64 Oct 23 23:58 1 -> pipe:[1665102776] l-wx------ 1 build build 64 Oct 23 23:58 2 -> pipe:[1665102777] l-wx------ 1 build build 64 Oct 23 23:58 3 -> /dev/null > ss -tn State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ss -tln State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess LISTEN 0 10 127.0.0.1:4254 0.0.0.0:* LISTEN 0 10 127.0.0.1:4255 0.0.0.0:* LISTEN 0 10 0.0.0.0:2775 0.0.0.0:* > ps xua | grep osmo build 121073 0.0 0.0 3924 3060 ? S 23:58 0:00 /bin/bash -c test -d osmo-msc-1.12.1.16-2fb32/_build || exit 0; \ dc_install_base=`CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_inst && pwd | sed -e 's,^[^:\\/]:[\\/],/,'` \ && dc_destdir="${TMPDIR-/tmp}/am-dc-$$/" \ && am__cwd=`pwd` \ && CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_build/sub \ && ../../configure \ --with-systemdsystemunitdir=$dc_install_base//lib/systemd/system \ --enable-werror --enable-smpp --enable-iu --enable-external-tests --enable-manuals \ --srcdir=../.. --prefix="$dc_install_base" \ && make \ && make dvi \ && make check \ && make install \ && make installcheck \ && make uninstall \ && make distuninstallcheck_dir="$dc_install_base" \ distuninstallcheck \ && chmod -R a-w "$dc_install_base" \ && ({ \ (cd ../.. && umask 077 && mkdir "$dc_destdir") \ && make DESTDIR="$dc_destdir" install \ && make DESTDIR="$dc_destdir" uninstall \ && make DESTDIR="$dc_destdir" \ distuninstallcheck_dir="$dc_destdir" distuninstallcheck; \ } || { rm -rf "$dc_destdir"; exit 1; }) \ && rm -rf "$dc_destdir" \ && make dist \ && rm -rf osmo-msc-1.12.1.16-2fb32.tar.gz osmo-msc-1.12.1.16-2fb32.tar.bz2 \ && make distcleancheck \ && cd "$am__cwd" \ || exit 1 build 125566 0.0 0.0 3924 3032 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '2'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='include src doc contrib tests ' ;; \ *) list='include src doc contrib tests ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 125773 0.0 0.0 3924 3068 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '3'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp' ;; \ *) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 132539 2.5 0.0 19652 14704 ? S 23:58 0:00 python3 ../../../tests/vty_test_runner.py -w /build/osmo-msc-1.12.1.16-2fb32/_build/sub -v build 132550 0.0 0.0 20724 12852 ? S 23:58 0:00 ./src/osmo-msc/osmo-msc -c /build/osmo-msc-1.12.1.16-2fb32/tests/../doc/examples/osmo-msc/osmo-msc.cfg build 132557 0.0 0.0 2576 908 ? S 23:58 0:00 /bin/sh -c ps xua | grep osmo build 132559 0.0 0.0 3700 1972 ? S 23:58 0:00 grep osmo Socket: in 1 tries, connected to 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 43842), raddr=('127.0.0.1', 4254)> (1 sockets open) Rec: ["% 'periodic location update' is now deprecated. Use 'msc' / 'timer vlr T3212' to change subscriber expiration timeout.", '% Setting T3212 to 121 minutes (emulating the old behaviour).'] Exp: ["% 'periodic location update' is now deprecated: use 'timer T3212' to change subscriber expiration timeout.", '% Setting T3212 to 121 minutes (emulating the old behaviour).'] Socket: closing 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 43842), raddr=('127.0.0.1', 4254)> (0 sockets open) Terminating took 0.897s Process returned code: 0 ok testShowNetwork (__main__.TestVTYMSC.testShowNetwork) ... Launching: PWD=/build/osmo-msc-1.12.1.16-2fb32/_build/sub './src/osmo-msc/osmo-msc' '-c' '/build/osmo-msc-1.12.1.16-2fb32/tests/../doc/examples/osmo-msc/osmo-msc.cfg' > ls -l /proc/132539/fd total 0 lr-x------ 1 build build 64 Oct 23 23:58 0 -> pipe:[1665102775] l-wx------ 1 build build 64 Oct 23 23:58 1 -> pipe:[1665102776] l-wx------ 1 build build 64 Oct 23 23:58 2 -> pipe:[1665102777] l-wx------ 1 build build 64 Oct 23 23:58 3 -> /dev/null > ss -tn State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ss -tln State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess LISTEN 0 10 127.0.0.1:4254 0.0.0.0:* LISTEN 0 10 127.0.0.1:4255 0.0.0.0:* LISTEN 0 10 0.0.0.0:2775 0.0.0.0:* > ps xua | grep osmo build 121073 0.0 0.0 3924 3060 ? S 23:58 0:00 /bin/bash -c test -d osmo-msc-1.12.1.16-2fb32/_build || exit 0; \ dc_install_base=`CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_inst && pwd | sed -e 's,^[^:\\/]:[\\/],/,'` \ && dc_destdir="${TMPDIR-/tmp}/am-dc-$$/" \ && am__cwd=`pwd` \ && CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_build/sub \ && ../../configure \ --with-systemdsystemunitdir=$dc_install_base//lib/systemd/system \ --enable-werror --enable-smpp --enable-iu --enable-external-tests --enable-manuals \ --srcdir=../.. --prefix="$dc_install_base" \ && make \ && make dvi \ && make check \ && make install \ && make installcheck \ && make uninstall \ && make distuninstallcheck_dir="$dc_install_base" \ distuninstallcheck \ && chmod -R a-w "$dc_install_base" \ && ({ \ (cd ../.. && umask 077 && mkdir "$dc_destdir") \ && make DESTDIR="$dc_destdir" install \ && make DESTDIR="$dc_destdir" uninstall \ && make DESTDIR="$dc_destdir" \ distuninstallcheck_dir="$dc_destdir" distuninstallcheck; \ } || { rm -rf "$dc_destdir"; exit 1; }) \ && rm -rf "$dc_destdir" \ && make dist \ && rm -rf osmo-msc-1.12.1.16-2fb32.tar.gz osmo-msc-1.12.1.16-2fb32.tar.bz2 \ && make distcleancheck \ && cd "$am__cwd" \ || exit 1 build 125566 0.0 0.0 3924 3032 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '2'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='include src doc contrib tests ' ;; \ *) list='include src doc contrib tests ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 125773 0.0 0.0 3924 3068 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '3'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp' ;; \ *) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 132539 1.2 0.0 19652 14704 ? S 23:58 0:00 python3 ../../../tests/vty_test_runner.py -w /build/osmo-msc-1.12.1.16-2fb32/_build/sub -v build 132560 0.0 0.0 20724 12956 ? S 23:58 0:00 ./src/osmo-msc/osmo-msc -c /build/osmo-msc-1.12.1.16-2fb32/tests/../doc/examples/osmo-msc/osmo-msc.cfg build 132567 0.0 0.0 2576 936 ? S 23:58 0:00 /bin/sh -c ps xua | grep osmo build 132569 0.0 0.0 3700 1792 ? S 23:58 0:00 grep osmo Socket: in 1 tries, connected to 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 43850), raddr=('127.0.0.1', 4254)> (1 sockets open) Socket: closing 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 43850), raddr=('127.0.0.1', 4254)> (0 sockets open) Terminating took 0.897s Process returned code: 0 ok testSi2Q (__main__.TestVTYMSC.testSi2Q) ... Launching: PWD=/build/osmo-msc-1.12.1.16-2fb32/_build/sub './src/osmo-msc/osmo-msc' '-c' '/build/osmo-msc-1.12.1.16-2fb32/tests/../doc/examples/osmo-msc/osmo-msc.cfg' > ls -l /proc/132539/fd total 0 lr-x------ 1 build build 64 Oct 23 23:58 0 -> pipe:[1665102775] l-wx------ 1 build build 64 Oct 23 23:58 1 -> pipe:[1665102776] l-wx------ 1 build build 64 Oct 23 23:58 2 -> pipe:[1665102777] l-wx------ 1 build build 64 Oct 23 23:58 3 -> /dev/null > ss -tn State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ss -tln State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess LISTEN 0 10 127.0.0.1:4254 0.0.0.0:* LISTEN 0 10 127.0.0.1:4255 0.0.0.0:* LISTEN 0 10 0.0.0.0:2775 0.0.0.0:* > ps xua | grep osmo build 121073 0.0 0.0 3924 3060 ? S 23:58 0:00 /bin/bash -c test -d osmo-msc-1.12.1.16-2fb32/_build || exit 0; \ dc_install_base=`CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_inst && pwd | sed -e 's,^[^:\\/]:[\\/],/,'` \ && dc_destdir="${TMPDIR-/tmp}/am-dc-$$/" \ && am__cwd=`pwd` \ && CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_build/sub \ && ../../configure \ --with-systemdsystemunitdir=$dc_install_base//lib/systemd/system \ --enable-werror --enable-smpp --enable-iu --enable-external-tests --enable-manuals \ --srcdir=../.. --prefix="$dc_install_base" \ && make \ && make dvi \ && make check \ && make install \ && make installcheck \ && make uninstall \ && make distuninstallcheck_dir="$dc_install_base" \ distuninstallcheck \ && chmod -R a-w "$dc_install_base" \ && ({ \ (cd ../.. && umask 077 && mkdir "$dc_destdir") \ && make DESTDIR="$dc_destdir" install \ && make DESTDIR="$dc_destdir" uninstall \ && make DESTDIR="$dc_destdir" \ distuninstallcheck_dir="$dc_destdir" distuninstallcheck; \ } || { rm -rf "$dc_destdir"; exit 1; }) \ && rm -rf "$dc_destdir" \ && make dist \ && rm -rf osmo-msc-1.12.1.16-2fb32.tar.gz osmo-msc-1.12.1.16-2fb32.tar.bz2 \ && make distcleancheck \ && cd "$am__cwd" \ || exit 1 build 125566 0.0 0.0 3924 3032 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '2'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='include src doc contrib tests ' ;; \ *) list='include src doc contrib tests ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 125773 0.0 0.0 3924 3068 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '3'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp' ;; \ *) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 132539 0.8 0.0 19652 14704 ? S 23:58 0:00 python3 ../../../tests/vty_test_runner.py -w /build/osmo-msc-1.12.1.16-2fb32/_build/sub -v build 132570 0.0 0.0 20724 12840 ? S 23:58 0:00 ./src/osmo-msc/osmo-msc -c /build/osmo-msc-1.12.1.16-2fb32/tests/../doc/examples/osmo-msc/osmo-msc.cfg build 132577 0.0 0.0 2576 944 ? S 23:58 0:00 /bin/sh -c ps xua | grep osmo build 132579 0.0 0.0 3700 1816 ? S 23:58 0:00 grep osmo Socket: in 1 tries, connected to 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 43856), raddr=('127.0.0.1', 4254)> (1 sockets open) Socket: closing 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 43856), raddr=('127.0.0.1', 4254)> (0 sockets open) Process returned code: 0 ok testSmppFirst (__main__.TestVTYMSC.testSmppFirst) ... Launching: PWD=/build/osmo-msc-1.12.1.16-2fb32/_build/sub './src/osmo-msc/osmo-msc' '-c' '/build/osmo-msc-1.12.1.16-2fb32/tests/../doc/examples/osmo-msc/osmo-msc.cfg' > ls -l /proc/132539/fd total 0 lr-x------ 1 build build 64 Oct 23 23:58 0 -> pipe:[1665102775] l-wx------ 1 build build 64 Oct 23 23:58 1 -> pipe:[1665102776] l-wx------ 1 build build 64 Oct 23 23:58 2 -> pipe:[1665102777] l-wx------ 1 build build 64 Oct 23 23:58 3 -> /dev/null > ss -tn State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ss -tln State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess LISTEN 0 10 127.0.0.1:4254 0.0.0.0:* LISTEN 0 10 127.0.0.1:4255 0.0.0.0:* LISTEN 0 10 0.0.0.0:2775 0.0.0.0:* > ps xua | grep osmo build 121073 0.0 0.0 3924 3060 ? S 23:58 0:00 /bin/bash -c test -d osmo-msc-1.12.1.16-2fb32/_build || exit 0; \ dc_install_base=`CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_inst && pwd | sed -e 's,^[^:\\/]:[\\/],/,'` \ && dc_destdir="${TMPDIR-/tmp}/am-dc-$$/" \ && am__cwd=`pwd` \ && CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_build/sub \ && ../../configure \ --with-systemdsystemunitdir=$dc_install_base//lib/systemd/system \ --enable-werror --enable-smpp --enable-iu --enable-external-tests --enable-manuals \ --srcdir=../.. --prefix="$dc_install_base" \ && make \ && make dvi \ && make check \ && make install \ && make installcheck \ && make uninstall \ && make distuninstallcheck_dir="$dc_install_base" \ distuninstallcheck \ && chmod -R a-w "$dc_install_base" \ && ({ \ (cd ../.. && umask 077 && mkdir "$dc_destdir") \ && make DESTDIR="$dc_destdir" install \ && make DESTDIR="$dc_destdir" uninstall \ && make DESTDIR="$dc_destdir" \ distuninstallcheck_dir="$dc_destdir" distuninstallcheck; \ } || { rm -rf "$dc_destdir"; exit 1; }) \ && rm -rf "$dc_destdir" \ && make dist \ && rm -rf osmo-msc-1.12.1.16-2fb32.tar.gz osmo-msc-1.12.1.16-2fb32.tar.bz2 \ && make distcleancheck \ && cd "$am__cwd" \ || exit 1 build 125566 0.0 0.0 3924 3032 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '2'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='include src doc contrib tests ' ;; \ *) list='include src doc contrib tests ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 125773 0.0 0.0 3924 3068 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '3'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp' ;; \ *) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 132539 0.8 0.0 19652 14704 ? S 23:58 0:00 python3 ../../../tests/vty_test_runner.py -w /build/osmo-msc-1.12.1.16-2fb32/_build/sub -v build 132580 16.6 0.0 20724 12940 ? S 23:58 0:00 ./src/osmo-msc/osmo-msc -c /build/osmo-msc-1.12.1.16-2fb32/tests/../doc/examples/osmo-msc/osmo-msc.cfg build 132587 0.0 0.0 2576 900 ? S 23:58 0:00 /bin/sh -c ps xua | grep osmo build 132589 0.0 0.0 3700 1800 ? S 23:58 0:00 grep osmo Socket: in 1 tries, connected to 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 43868), raddr=('127.0.0.1', 4254)> (1 sockets open) Socket: closing 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 43868), raddr=('127.0.0.1', 4254)> (0 sockets open) Terminating took 0.897s Process returned code: 0 ok testVtyTree (__main__.TestVTYMSC.testVtyTree) ... Launching: PWD=/build/osmo-msc-1.12.1.16-2fb32/_build/sub './src/osmo-msc/osmo-msc' '-c' '/build/osmo-msc-1.12.1.16-2fb32/tests/../doc/examples/osmo-msc/osmo-msc.cfg' > ls -l /proc/132539/fd total 0 lr-x------ 1 build build 64 Oct 23 23:58 0 -> pipe:[1665102775] l-wx------ 1 build build 64 Oct 23 23:58 1 -> pipe:[1665102776] l-wx------ 1 build build 64 Oct 23 23:58 2 -> pipe:[1665102777] l-wx------ 1 build build 64 Oct 23 23:58 3 -> /dev/null > ss -tn State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess > ss -tln State Recv-Q Send-Q Local Address:Port Peer Address:PortProcess LISTEN 0 10 127.0.0.1:4254 0.0.0.0:* LISTEN 0 10 127.0.0.1:4255 0.0.0.0:* LISTEN 0 10 0.0.0.0:2775 0.0.0.0:* > ps xua | grep osmo build 121073 0.0 0.0 3924 3060 ? S 23:58 0:00 /bin/bash -c test -d osmo-msc-1.12.1.16-2fb32/_build || exit 0; \ dc_install_base=`CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_inst && pwd | sed -e 's,^[^:\\/]:[\\/],/,'` \ && dc_destdir="${TMPDIR-/tmp}/am-dc-$$/" \ && am__cwd=`pwd` \ && CDPATH="${ZSH_VERSION+.}:" && cd osmo-msc-1.12.1.16-2fb32/_build/sub \ && ../../configure \ --with-systemdsystemunitdir=$dc_install_base//lib/systemd/system \ --enable-werror --enable-smpp --enable-iu --enable-external-tests --enable-manuals \ --srcdir=../.. --prefix="$dc_install_base" \ && make \ && make dvi \ && make check \ && make install \ && make installcheck \ && make uninstall \ && make distuninstallcheck_dir="$dc_install_base" \ distuninstallcheck \ && chmod -R a-w "$dc_install_base" \ && ({ \ (cd ../.. && umask 077 && mkdir "$dc_destdir") \ && make DESTDIR="$dc_destdir" install \ && make DESTDIR="$dc_destdir" uninstall \ && make DESTDIR="$dc_destdir" \ distuninstallcheck_dir="$dc_destdir" distuninstallcheck; \ } || { rm -rf "$dc_destdir"; exit 1; }) \ && rm -rf "$dc_destdir" \ && make dist \ && rm -rf osmo-msc-1.12.1.16-2fb32.tar.gz osmo-msc-1.12.1.16-2fb32.tar.bz2 \ && make distcleancheck \ && cd "$am__cwd" \ || exit 1 build 125566 0.0 0.0 3924 3032 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '2'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='include src doc contrib tests ' ;; \ *) list='include src doc contrib tests ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 125773 0.0 0.0 3924 3068 ? S 23:58 0:00 /bin/bash -c fail=; \ if (target_option=k; case ${target_option-} in ?) ;; *) echo "am__make_running_with_option: internal error: invalid" "target option '${target_option-}' specified" >&2; exit 1;; esac; has_opt=no; sane_makeflags=$MAKEFLAGS; if { if test -z '3'; then false; elif test -n 'x86_64-pc-linux-gnu'; then true; elif test -n '4.3' && test -n '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests'; then true; else false; fi; }; then sane_makeflags=$MFLAGS; else case $MAKEFLAGS in *\\[\ \?]*) bs=\\; sane_makeflags=`printf '%s\n' "$MAKEFLAGS" | sed "s/$bs$bs[$bs $bs?]*//g"`;; esac; fi; skip_next=no; strip_trailopt () { flg=`printf '%s\n' "$flg" | sed "s/$1.*$//"`; }; for flg in $sane_makeflags; do test $skip_next = yes && { skip_next=no; continue; }; case $flg in *=*|--*) continue;; -*I) strip_trailopt 'I'; skip_next=yes;; -*I?*) strip_trailopt 'I';; -*O) strip_trailopt 'O'; skip_next=yes;; -*O?*) strip_trailopt 'O';; -*l) strip_trailopt 'l'; skip_next=yes;; -*l?*) strip_trailopt 'l';; -[dEDm]) skip_next=yes;; -[JT]) skip_next=yes;; esac; case $flg in *$target_option*) has_opt=yes; break;; esac; done; test $has_opt = yes); then \ failcom='fail=yes'; \ else \ failcom='exit 1'; \ fi; \ dot_seen=no; \ target=`echo check-recursive | sed s/-recursive//`; \ case "check-recursive" in \ distclean-* | maintainer-clean-*) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp' ;; \ *) list='sms_queue msc_vlr db_sms sdp_msg mncc csd smpp ' ;; \ esac; \ for subdir in $list; do \ echo "Making $target in $subdir"; \ if test "$subdir" = "."; then \ dot_seen=yes; \ local_target="$target-am"; \ else \ local_target="$target"; \ fi; \ (CDPATH="${ZSH_VERSION+.}:" && cd $subdir && make $local_target) \ || eval $failcom; \ done; \ if test "$dot_seen" = "no"; then \ make "$target-am" || exit 1; \ fi; test -z "$fail" build 132539 0.6 0.0 19652 14704 ? S 23:58 0:00 python3 ../../../tests/vty_test_runner.py -w /build/osmo-msc-1.12.1.16-2fb32/_build/sub -v build 132590 0.0 0.0 20724 12968 ? S 23:58 0:00 ./src/osmo-msc/osmo-msc -c /build/osmo-msc-1.12.1.16-2fb32/tests/../doc/examples/osmo-msc/osmo-msc.cfg build 132597 0.0 0.0 2576 900 ? S 23:58 0:00 /bin/sh -c ps xua | grep osmo build 132599 0.0 0.0 3700 1820 ? S 23:58 0:00 grep osmo Socket: in 1 tries, connected to 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 43870), raddr=('127.0.0.1', 4254)> (1 sockets open) Socket: closing 127.0.0.1:4254 <socket.socket fd=4, family=2, type=1, proto=0, laddr=('127.0.0.1', 43870), raddr=('127.0.0.1', 4254)> (0 sockets open) Killed child process Process returned code: -9 ERROR ====================================================================== ERROR: testVtyTree (__main__.TestVTYMSC.testVtyTree) ---------------------------------------------------------------------- Traceback (most recent call last): File "/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests/../../../tests/vty_test_runner.py", line 70, in tearDown raise Exception("Process returned %d" % rc) Exception: Process returned -9 ---------------------------------------------------------------------- Ran 6 tests in 13.095s FAILED (errors=1) make[8]: Leaving directory '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests' make[8]: *** [Makefile:723: vty-python-test] Error 1 make[7]: Leaving directory '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests' make[7]: *** [Makefile:743: vty-test] Error 2 make[6]: *** [Makefile:713: python-tests] Error 2 make[6]: Leaving directory '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests' make[5]: *** [Makefile:767: check-local] Error 2 make[5]: Leaving directory '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests' make[4]: *** [Makefile:572: check-am] Error 2 make[4]: Leaving directory '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests' make[3]: *** [Makefile:422: check-recursive] Error 1 make[3]: Leaving directory '/build/osmo-msc-1.12.1.16-2fb32/_build/sub/tests' make[2]: *** [Makefile:471: check-recursive] Error 1 make[2]: Leaving directory '/build/osmo-msc-1.12.1.16-2fb32/_build/sub' make[1]: *** [Makefile:770: check] Error 2 make[1]: Leaving directory '/build/osmo-msc-1.12.1.16-2fb32/_build/sub' make: *** [Makefile:690: distcheck] Error 1 + exit_tar_workspace + '[' 1 = 1 ']' + tar -cJf /tmp/workspace.tar.xz /build tar: Removing leading `/' from member names + mv /tmp/workspace.tar.xz /build + cat-testlogs.sh Build step 'Execute shell' marked build as failure $ ssh-agent -k unset SSH_AUTH_SOCK; unset SSH_AGENT_PID; echo Agent pid 3335393 killed; [ssh-agent] Stopped. Archiving artifacts

1 1

Jenkins build is back to stable : ttcn3-ggsn-test-asan #139
by jenkins＠lists.osmocom.org 23 Oct '24

23 Oct '24

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-ggsn-test-asan/139/display/re…>

1 0

2025

2024

2023

2022

2021

2020

2019

jenkins-notifications October 2024