Build failed in Jenkins: ttcn3-hnbgw-test-latest #510

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/510/display/redirect?page=changes> Changes: [Oliver Smith] ttcn3-hnbgw-test: reduce X31 to 5s [Oliver Smith] ttcn3-hnbgw: Use new module param mp_hnbgw_timer_x31 ------------------------------------------ [...truncated 880.85 KB...] NOTE: unable to use dumpcap due to missing capabilities or suid bit Waiting for packet dumper to start... 0 MTC@caac211ea57e: External command `../ttcn3-tcpdump-start.sh HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc' was executed successfully (exit status: 0). MTC@caac211ea57e: Test case TC_hnb_reregister_reuse_sctp_assoc started. TC_hnb_reregister_reuse_sctp_assoc-Iuh0(731)@caac211ea57e: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 MTC@caac211ea57e: setverdict(fail): none -> fail reason: "Timeout of T_guard", new component reason: "Timeout of T_guard" TC_hnb_reregister_reuse_sctp_assoc-Iuh0-RUA(732)@caac211ea57e: Final verdict of PTC: none MC@caac211ea57e: PTC 731 on host 172.18.168.203 is not responding. Trying to kill it using its HC. MTC@caac211ea57e: Setting final verdict of the test case. MTC@caac211ea57e: Local verdict of MTC: fail reason: "Timeout of T_guard" MTC@caac211ea57e: Local verdict of PTC TC_hnb_reregister_reuse_sctp_assoc-Iuh0(731): error (fail -> error) MTC@caac211ea57e: Local verdict of PTC TC_hnb_reregister_reuse_sctp_assoc-Iuh0-RUA(732): none (error -> error) MTC@caac211ea57e: Test case TC_hnb_reregister_reuse_sctp_assoc finished. Verdict: error MTC@caac211ea57e: Starting external command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc error'. Fri Nov 10 10:29:02 UTC 2023 ------ HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc error ------ Waiting for packet dumper to finish... 0 (prev_count=-1, count=2970) Waiting for packet dumper to finish... 1 (prev_count=2970, count=3150) MTC@caac211ea57e: External command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc error' was executed successfully (exit status: 0). MTC@caac211ea57e: Starting external command `../ttcn3-tcpdump-start.sh HNBGW_Tests.TC_apply_sccp'. ------ HNBGW_Tests.TC_apply_sccp ------ Fri Nov 10 10:29:04 UTC 2023 NOTE: unable to use dumpcap due to missing capabilities or suid bit Waiting for packet dumper to start... 0 MTC@caac211ea57e: External command `../ttcn3-tcpdump-start.sh HNBGW_Tests.TC_apply_sccp' was executed successfully (exit status: 0). MTC@caac211ea57e: Test case TC_apply_sccp started. TC_apply_sccp-Iuh0(733)@caac211ea57e: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 TC_apply_sccp-Iuh1(735)@caac211ea57e: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 MTC@caac211ea57e: setverdict(fail): none -> fail reason: ""VTY Timeout for prompt: enable"", new component reason: ""VTY Timeout for prompt: enable"" TC_apply_sccp-Iuh1-RUA(736)@caac211ea57e: Final verdict of PTC: none TC_apply_sccp-Iuh0-RUA(734)@caac211ea57e: Final verdict of PTC: none MC@caac211ea57e: PTC 733 on host 172.18.168.203 is not responding. Trying to kill it using its HC. MC@caac211ea57e: PTC 735 on host 172.18.168.203 is not responding. Trying to kill it using its HC. MTC@caac211ea57e: Setting final verdict of the test case. MTC@caac211ea57e: Local verdict of MTC: fail reason: ""VTY Timeout for prompt: enable"" MTC@caac211ea57e: Local verdict of PTC TC_apply_sccp-Iuh0(733): error (fail -> error) MTC@caac211ea57e: Local verdict of PTC TC_apply_sccp-Iuh0-RUA(734): none (error -> error) MTC@caac211ea57e: Local verdict of PTC TC_apply_sccp-Iuh1(735): error (error -> error) MTC@caac211ea57e: Local verdict of PTC TC_apply_sccp-Iuh1-RUA(736): none (error -> error) MTC@caac211ea57e: Test case TC_apply_sccp finished. Verdict: error MTC@caac211ea57e: Starting external command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_apply_sccp error'. Fri Nov 10 10:29:20 UTC 2023 ------ HNBGW_Tests.TC_apply_sccp error ------ Waiting for packet dumper to finish... 0 (prev_count=-1, count=2912) Waiting for packet dumper to finish... 1 (prev_count=2912, count=3336) MTC@caac211ea57e: External command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_apply_sccp error' was executed successfully (exit status: 0). MC@caac211ea57e: Test execution finished. Execution of [EXECUTE] section finished. emtc MC@caac211ea57e: Terminating MTC. MC@caac211ea57e: MTC terminated. MC2> exit MC@caac211ea57e: Shutting down session. MC@caac211ea57e: Shutdown complete. Comparing expected results '/osmo-ttcn3-hacks/hnbgw/expected-results.xml' against results in 'junit-xml-21.log' -------------------- pass HNBGW_Tests.TC_hnb_register pass HNBGW_Tests.TC_hnb_register_duplicate pass HNBGW_Tests.TC_ranap_cs_initial_ue pass HNBGW_Tests.TC_ranap_ps_initial_ue pass HNBGW_Tests.TC_ranap_cs_initial_ue_empty_cr pass HNBGW_Tests.TC_ranap_ps_initial_ue_empty_cr pass HNBGW_Tests.TC_ranap_cs_bidir pass HNBGW_Tests.TC_ranap_ps_bidir pass HNBGW_Tests.TC_rab_assignment pass HNBGW_Tests.TC_rab_release pass HNBGW_Tests.TC_rab_assign_fail pass HNBGW_Tests.TC_rab_assign_mgcp_to pass HNBGW_Tests.TC_ranap_cs_mo_disconnect pass HNBGW_Tests.TC_ranap_ps_mo_disconnect pass HNBGW_Tests.TC_ps_rab_assignment_without_pfcp pass->FAIL HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc NEW: PASS HNBGW_Tests.TC_hnb_register_duplicate_reuse_sctp_assoc NEW: PASS HNBGW_Tests.TC_mscpool_L3Compl_on_1_cnlink NEW: PASS HNBGW_Tests.TC_mscpool_L3Complete_by_imsi_round_robin NEW: PASS HNBGW_Tests.TC_mscpool_LU_by_tmsi_null_nri_0_round_robin NEW: PASS HNBGW_Tests.TC_mscpool_LU_by_tmsi_null_nri_1_round_robin NEW: PASS HNBGW_Tests.TC_mscpool_L3Complete_by_tmsi_unassigned_nri_round_robin NEW: PASS HNBGW_Tests.TC_mscpool_L3Complete_by_tmsi_valid_nri_msc_not_connected_round_robin NEW: PASS HNBGW_Tests.TC_mscpool_L3Complete_by_tmsi_valid_nri_1 NEW: PASS HNBGW_Tests.TC_mscpool_L3Complete_by_tmsi_valid_nri_2 NEW: PASS HNBGW_Tests.TC_mscpool_LU_by_tmsi_from_other_PLMN NEW: PASS HNBGW_Tests.TC_mscpool_paging_imsi NEW: PASS HNBGW_Tests.TC_mscpool_paging_tmsi NEW: PASS HNBGW_Tests.TC_mscpool_no_allow_attach_round_robin NEW: PASS HNBGW_Tests.TC_mscpool_no_allow_attach_valid_nri NEW: PASS HNBGW_Tests.TC_mscpool_sccp_n_pcstate_detaches_cnlink NEW: PASS HNBGW_Tests.TC_mscpool_sccp_n_pcstate_attaches_cnlink NEW: PASS HNBGW_Tests.TC_sgsnpool_L3Compl_on_1_cnlink NEW: PASS HNBGW_Tests.TC_sgsnpool_L3Complete_no_nri_round_robin NEW: PASS HNBGW_Tests.TC_sgsnpool_L3Complete_valid_nri_1 NEW: PASS HNBGW_Tests.TC_sgsnpool_L3Complete_valid_nri_2 NEW: PASS HNBGW_Tests.TC_sgsnpool_nri_from_other_PLMN NEW: PASS HNBGW_Tests.TC_sgsnpool_sccp_n_pcstate_detaches_cnlink NEW: PASS HNBGW_Tests.TC_sgsnpool_sccp_n_pcstate_attaches_cnlink NEW: FAIL HNBGW_Tests.TC_second_rab_assignment NEW: FAIL HNBGW_Tests.TC_apply_sccp Summary: pass->FAIL: 1 NEW: FAIL: 2 pass: 15 NEW: PASS: 23 + exit_code=0 + /osmo-ttcn3-hacks/log_merge.sh HNBGW_Tests --rm Generated HNBGW_Tests.TC_apply_sccp.merged Generated HNBGW_Tests.TC_hnb_register.merged Generated HNBGW_Tests.TC_hnb_register_duplicate.merged Generated HNBGW_Tests.TC_hnb_register_duplicate_reuse_sctp_assoc.merged Generated HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc.merged Generated HNBGW_Tests.TC_mscpool_L3Compl_on_1_cnlink.merged Generated HNBGW_Tests.TC_mscpool_L3Complete_by_imsi_round_robin.merged Generated HNBGW_Tests.TC_mscpool_L3Complete_by_tmsi_unassigned_nri_round_robin.merged Generated HNBGW_Tests.TC_mscpool_L3Complete_by_tmsi_valid_nri_1.merged Generated HNBGW_Tests.TC_mscpool_L3Complete_by_tmsi_valid_nri_2.merged Generated HNBGW_Tests.TC_mscpool_L3Complete_by_tmsi_valid_nri_msc_not_connected_round_robin.merged Generated HNBGW_Tests.TC_mscpool_LU_by_tmsi_from_other_PLMN.merged Generated HNBGW_Tests.TC_mscpool_LU_by_tmsi_null_nri_0_round_robin.merged Generated HNBGW_Tests.TC_mscpool_LU_by_tmsi_null_nri_1_round_robin.merged Generated HNBGW_Tests.TC_mscpool_no_allow_attach_round_robin.merged Generated HNBGW_Tests.TC_mscpool_no_allow_attach_valid_nri.merged Generated HNBGW_Tests.TC_mscpool_paging_imsi.merged Generated HNBGW_Tests.TC_mscpool_paging_tmsi.merged Generated HNBGW_Tests.TC_mscpool_sccp_n_pcstate_attaches_cnlink.merged Generated HNBGW_Tests.TC_mscpool_sccp_n_pcstate_detaches_cnlink.merged Generated HNBGW_Tests.TC_ps_rab_assignment_without_pfcp.merged Generated HNBGW_Tests.TC_rab_assign_fail.merged Generated HNBGW_Tests.TC_rab_assign_mgcp_to.merged Generated HNBGW_Tests.TC_rab_assignment.merged Generated HNBGW_Tests.TC_rab_release.merged Generated HNBGW_Tests.TC_ranap_cs_bidir.merged Generated HNBGW_Tests.TC_ranap_cs_initial_ue.merged Generated HNBGW_Tests.TC_ranap_cs_initial_ue_empty_cr.merged Generated HNBGW_Tests.TC_ranap_cs_mo_disconnect.merged Generated HNBGW_Tests.TC_ranap_ps_bidir.merged Generated HNBGW_Tests.TC_ranap_ps_initial_ue.merged Generated HNBGW_Tests.TC_ranap_ps_initial_ue_empty_cr.merged Generated HNBGW_Tests.TC_ranap_ps_mo_disconnect.merged Generated HNBGW_Tests.TC_second_rab_assignment.merged Generated HNBGW_Tests.TC_sgsnpool_L3Compl_on_1_cnlink.merged Generated HNBGW_Tests.TC_sgsnpool_L3Complete_no_nri_round_robin.merged Generated HNBGW_Tests.TC_sgsnpool_L3Complete_valid_nri_1.merged Generated HNBGW_Tests.TC_sgsnpool_L3Complete_valid_nri_2.merged Generated HNBGW_Tests.TC_sgsnpool_nri_from_other_PLMN.merged Generated HNBGW_Tests.TC_sgsnpool_sccp_n_pcstate_attaches_cnlink.merged Generated HNBGW_Tests.TC_sgsnpool_sccp_n_pcstate_detaches_cnlink.merged Removing Input log files !!! + exit 0 + echo Stopping containers Stopping containers + docker_kill_wait jenkins-ttcn3-hnbgw-test-latest-510-hnbgw + docker kill jenkins-ttcn3-hnbgw-test-latest-510-hnbgw Error response from daemon: Cannot kill container: jenkins-ttcn3-hnbgw-test-latest-510-hnbgw: No such container: jenkins-ttcn3-hnbgw-test-latest-510-hnbgw + clean_up_common + set +e + set +x ### Clean up ### + trap - EXIT INT TERM 0 + type clean_up + clean_up + sed -i s/classname='\([^']\+\)'/classname='\1:with-pfcp'/g <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/510/artifact/logs/with-pfcp/hnbgw-tester/junit-xml-with-pfcp-*.log> sed: can't read <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/510/artifact/logs/with-pfcp/hnbgw-tester/junit-xml-with-pfcp-*.log>: No such file or directory + network_clean + docker network inspect ttcn3-hnbgw-test-168 + grep Name + cut -d : -f2 + awk -F" NR>1{print $2} + local containers=jenkins-ttcn3-hnbgw-test-latest-510-stp + [ -n jenkins-ttcn3-hnbgw-test-latest-510-stp ] + docker_kill_wait jenkins-ttcn3-hnbgw-test-latest-510-stp + docker kill jenkins-ttcn3-hnbgw-test-latest-510-stp jenkins-ttcn3-hnbgw-test-latest-510-stp + docker wait jenkins-ttcn3-hnbgw-test-latest-510-stp 137 + network_remove + set +x Removing network ttcn3-hnbgw-test-168 + docker network remove ttcn3-hnbgw-test-168 ttcn3-hnbgw-test-168 + rm -rf <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/510/artifact/logs/unix> + fix_perms + set +x Fixing permissions + docker run --rm -v <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/ws/logs>:/data -v <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/ws/_cache>:/cache --name jenkins-ttcn3-hnbgw-test-latest-510-cleaner debian:bookworm chmod -R a+rX /data/ /cache/ + collect_logs + cat <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/510/artifact/logs/hnbgw-tester/junit-xml-21.log> <?xml version="1.0"?> <testsuite name='Titan' tests='41' failures='1' errors='2' skipped='0' inconc='0' time='365.00'> <testcase classname='HNBGW_Tests' name='TC_hnb_register' time='1.101912'/> <testcase classname='HNBGW_Tests' name='TC_hnb_register_duplicate' time='1.133138'/> <testcase classname='HNBGW_Tests' name='TC_hnb_register_duplicate_reuse_sctp_assoc' time='1.115329'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_initial_ue' time='2.173145'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_initial_ue' time='2.159100'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_initial_ue_empty_cr' time='2.223198'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_initial_ue_empty_cr' time='2.196289'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_bidir' time='2.410789'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_bidir' time='2.400038'/> <testcase classname='HNBGW_Tests' name='TC_rab_assignment' time='2.502466'/> <testcase classname='HNBGW_Tests' name='TC_rab_release' time='2.466164'/> <testcase classname='HNBGW_Tests' name='TC_rab_assign_fail' time='2.415873'/> <testcase classname='HNBGW_Tests' name='TC_rab_assign_mgcp_to' time='6.388109'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_mo_disconnect' time='7.573935'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_mo_disconnect' time='7.597424'/> <testcase classname='HNBGW_Tests' name='TC_ps_rab_assignment_without_pfcp' time='7.414943'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Compl_on_1_cnlink' time='5.327701'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_imsi_round_robin' time='5.366677'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_null_nri_0_round_robin' time='5.420886'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_null_nri_1_round_robin' time='5.313731'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_unassigned_nri_round_robin' time='5.411410'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_msc_not_connected_round_robin' time='5.346574'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_1' time='5.408465'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_2' time='5.407032'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_from_other_PLMN' time='4.450079'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_paging_imsi' time='5.273180'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_paging_tmsi' time='5.272369'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_no_allow_attach_round_robin' time='5.480972'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_no_allow_attach_valid_nri' time='5.379661'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_sccp_n_pcstate_detaches_cnlink' time='5.320697'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_sccp_n_pcstate_attaches_cnlink' time='6.414689'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Compl_on_1_cnlink' time='5.382227'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_no_nri_round_robin' time='5.378796'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_valid_nri_1' time='5.302429'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_valid_nri_2' time='5.402784'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_nri_from_other_PLMN' time='4.348421'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_sccp_n_pcstate_detaches_cnlink' time='5.376335'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_sccp_n_pcstate_attaches_cnlink' time='6.391944'/> <testcase classname='HNBGW_Tests' name='TC_second_rab_assignment' time='7.455466'> <failure type='fail-verdict'>Timeout waiting for Iuh { initiatingMessage := { procedureCode := 0, criticality := reject (0), value_ := { rAB_AssignmentRequest := { protocolIEs := { { id := 54, criticality := ignore (1), value_ := { rAB_SetupOrModifyList := { { { id := 53, firstCriticality := reject (0), firstValue := { rAB_SetupOrModifyItemFirst := { rAB_ID := '00010111'B, nAS_SynchronisationIndicator := omit, rAB_Parameters := { trafficClass := conversational (0), rAB_AsymmetryIndicator := symmetric_bidirectional (0), maxBitrate := { 12200 }, guaranteedBitRate := { 12200 }, deliveryOrder := delivery_order_requested (0), maxSDU_Size := 244, sDU_Parameters := { { sDU_ErrorRatio := { mantissa := 1, exponent := 5, iE_Extensions := omit }, residualBitErrorRatio := { mantissa := 1, exponent := 6, iE_Extensions := omit }, deliveryOfErroneousSDU := yes (0), sDU_FormatInformationParameters := { { subflowSDU_Size := 81, rAB_SubflowCombinationBitRate := omit, iE_Extensions := omit }, { subflowSDU_Size := 39, rAB_SubflowCombinationBitRate := omit, iE_Extensions := omit } }, iE_Extensions := omit }, { sDU_ErrorRatio := omit, residualBitErrorRatio := { mantissa := 1, exponent := 3, iE_Extensions := omit }, deliveryOfErroneousSDU := no_error_detection_consideration (2), sDU_FormatInformationParameters := { { subflowSDU_Size := 103, rAB_SubflowCombinationBitRate := omit, iE_Extensions := omit }, { subflowSDU_Size := 0, rAB_SubflowCombinationBitRate := omit, iE_Extensions := omit } }, iE_Extensions := omit }, { sDU_ErrorRatio := omit, residualBitErrorRatio := { mantissa := 5, exponent := 3, iE_Extensions := omit }, deliveryOfErroneousSDU := no_error_detection_consideration (2), sDU_FormatInformationParameters := { { subflowSDU_Size := 60, rAB_SubflowCombinationBitRate := omit, iE_Extensions := omit }, { subflowSDU_Size := 0, rAB_SubflowCombinationBitRate := omit, iE_Extensions := omit } }, iE_Extensions := omit } }, transferDelay := 80, trafficHandlingPriority := omit, allocationOrRetentionPriority := { priorityLevel := 15, pre_emptionCapability := shall_not_trigger_pre_emption (0), pre_emptionVulnerability := pre_emptable (1), queuingAllowed := queueing_not_allowed (0), iE_Extensions := omit }, sourceStatisticsDescriptor := omit, relocationRequirement := omit, iE_Extensions := omit }, userPlaneInformation := omit, transportLayerInformation := omit, service_Handover := omit, iE_Extensions := omit } }, secondCriticality := ignore (1), secondValue := { rAB_SetupOrModifyItemSecond := { pDP_TypeInformation := omit, dataVolumeReportingIndication := omit, dl_GTP_PDU_SequenceNumber := omit, ul_GTP_PDU_SequenceNumber := omit, dl_N_PDU_SequenceNumber := omit, ul_N_PDU_SequenceNumber := omit, iE_Extensions := omit } } } } } } } }, protocolExtensions := omit } } } } HNBGW_Tests.ttcn:2713 HNBGW_Tests control part HNBGW_Tests.ttcn:2661 TC_second_rab_assignment testcase </failure> </testcase> <testcase classname='HNBGW_Tests' name='TC_hnb_reregister_reuse_sctp_assoc' time='44.741347'> <error type='DTE'></error> </testcase> <testcase classname='HNBGW_Tests' name='TC_apply_sccp' time='15.124624'> <error type='DTE'></error> </testcase> </testsuite> Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.