Build failed in Jenkins: ttcn3-hnbgw-test #668

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test/668/display/redirect> Changes: ------------------------------------------ [...truncated 642.06 KB...] MTC@19d69b19d9ff: Local verdict of PTC TC_hnb_reregister_reuse_sctp_assoc-Iuh0-RUA(732): none (error -> error) MTC@19d69b19d9ff: Test case TC_hnb_reregister_reuse_sctp_assoc finished. Verdict: error MTC@19d69b19d9ff: Starting external command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc error'. Thu Nov 9 07:53:04 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@19d69b19d9ff: External command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc error' was executed successfully (exit status: 0). MTC@19d69b19d9ff: Starting external command `../ttcn3-tcpdump-start.sh HNBGW_Tests.TC_apply_sccp'. ------ HNBGW_Tests.TC_apply_sccp ------ Thu Nov 9 07:53:06 UTC 2023 NOTE: unable to use dumpcap due to missing capabilities or suid bit Waiting for packet dumper to start... 0 MTC@19d69b19d9ff: External command `../ttcn3-tcpdump-start.sh HNBGW_Tests.TC_apply_sccp' was executed successfully (exit status: 0). MTC@19d69b19d9ff: Test case TC_apply_sccp started. TC_apply_sccp-Iuh0(733)@19d69b19d9ff: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 TC_apply_sccp-Iuh1(735)@19d69b19d9ff: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 MTC@19d69b19d9ff: setverdict(fail): none -> fail reason: ""VTY Timeout for prompt: enable"", new component reason: ""VTY Timeout for prompt: enable"" TC_apply_sccp-Iuh0-RUA(734)@19d69b19d9ff: Final verdict of PTC: none TC_apply_sccp-Iuh1-RUA(736)@19d69b19d9ff: Final verdict of PTC: none MC@19d69b19d9ff: PTC 733 on host 172.18.249.203 is not responding. Trying to kill it using its HC. MC@19d69b19d9ff: PTC 735 on host 172.18.249.203 is not responding. Trying to kill it using its HC. MTC@19d69b19d9ff: Setting final verdict of the test case. MTC@19d69b19d9ff: Local verdict of MTC: fail reason: ""VTY Timeout for prompt: enable"" MTC@19d69b19d9ff: Local verdict of PTC TC_apply_sccp-Iuh0(733): error (fail -> error) MTC@19d69b19d9ff: Local verdict of PTC TC_apply_sccp-Iuh0-RUA(734): none (error -> error) MTC@19d69b19d9ff: Local verdict of PTC TC_apply_sccp-Iuh1(735): error (error -> error) MTC@19d69b19d9ff: Local verdict of PTC TC_apply_sccp-Iuh1-RUA(736): none (error -> error) MTC@19d69b19d9ff: Test case TC_apply_sccp finished. Verdict: error MTC@19d69b19d9ff: Starting external command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_apply_sccp error'. Thu Nov 9 07:53:23 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=3272) MTC@19d69b19d9ff: External command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_apply_sccp error' was executed successfully (exit status: 0). MC@19d69b19d9ff: Test execution finished. Execution of [EXECUTE] section finished. emtc MC@19d69b19d9ff: Terminating MTC. MC@19d69b19d9ff: MTC terminated. MC2> exit MC@19d69b19d9ff: Shutting down session. MC@19d69b19d9ff: Shutdown complete. Comparing expected results '/osmo-ttcn3-hacks/hnbgw/expected-results.xml' against results in 'junit-xml-22.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->FAIL HNBGW_Tests.TC_ranap_cs_mo_disconnect pass->FAIL 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: 3 NEW: FAIL: 2 pass: 13 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-668-hnbgw + docker kill jenkins-ttcn3-hnbgw-test-668-hnbgw Error response from daemon: Cannot kill container: jenkins-ttcn3-hnbgw-test-668-hnbgw: No such container: jenkins-ttcn3-hnbgw-test-668-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/668/artifact/logs/with-pfcp/hnbgw-tester/junit-xml-with-pfcp-*.log> sed: can't read <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test/668/artifact/logs/with-pfcp/hnbgw-tester/junit-xml-with-pfcp-*.log>: No such file or directory + network_clean + docker network inspect ttcn3-hnbgw-test-249 + grep Name + cut -d : -f2 + awk -F" NR>1{print $2} + local containers=jenkins-ttcn3-hnbgw-test-668-stp + [ -n jenkins-ttcn3-hnbgw-test-668-stp ] + docker_kill_wait jenkins-ttcn3-hnbgw-test-668-stp + docker kill jenkins-ttcn3-hnbgw-test-668-stp jenkins-ttcn3-hnbgw-test-668-stp + docker wait jenkins-ttcn3-hnbgw-test-668-stp Error response from daemon: No such container: jenkins-ttcn3-hnbgw-test-668-stp + true + network_remove + set +x Removing network ttcn3-hnbgw-test-249 + docker network remove ttcn3-hnbgw-test-249 ttcn3-hnbgw-test-249 + rm -rf <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test/668/artifact/logs/unix> + fix_perms + set +x Fixing permissions + docker run --rm -v <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test/ws/logs>:/data -v <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test/ws/_cache>:/cache --name jenkins-ttcn3-hnbgw-test-668-cleaner debian:bookworm chmod -R a+rX /data/ /cache/ + collect_logs + cat <https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test/668/artifact/logs/hnbgw-tester/junit-xml-22.log> <?xml version="1.0"?> <testsuite name='Titan' tests='41' failures='3' errors='2' skipped='0' inconc='0' time='365.00'> <testcase classname='HNBGW_Tests' name='TC_hnb_register' time='1.085385'/> <testcase classname='HNBGW_Tests' name='TC_hnb_register_duplicate' time='1.092560'/> <testcase classname='HNBGW_Tests' name='TC_hnb_register_duplicate_reuse_sctp_assoc' time='1.075861'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_initial_ue' time='2.115327'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_initial_ue' time='2.109777'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_initial_ue_empty_cr' time='2.111042'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_initial_ue_empty_cr' time='2.113727'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_bidir' time='2.331553'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_bidir' time='2.324869'/> <testcase classname='HNBGW_Tests' name='TC_rab_assignment' time='2.377262'/> <testcase classname='HNBGW_Tests' name='TC_rab_release' time='2.370956'/> <testcase classname='HNBGW_Tests' name='TC_rab_assign_fail' time='2.339311'/> <testcase classname='HNBGW_Tests' name='TC_rab_assign_mgcp_to' time='6.341858'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_mo_disconnect' time='8.532829'> <failure type='fail-verdict'>Timeout waiting for Iu disconnect HNBGW_Tests.ttcn:2680 HNBGW_Tests control part HNBGW_Tests.ttcn:1538 TC_ranap_cs_mo_disconnect testcase </failure> </testcase> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_mo_disconnect' time='8.527349'> <failure type='fail-verdict'>Timeout waiting for Iu disconnect HNBGW_Tests.ttcn:2681 HNBGW_Tests control part HNBGW_Tests.ttcn:1548 TC_ranap_ps_mo_disconnect testcase </failure> </testcase> <testcase classname='HNBGW_Tests' name='TC_ps_rab_assignment_without_pfcp' time='7.366533'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Compl_on_1_cnlink' time='5.366349'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_imsi_round_robin' time='5.353126'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_null_nri_0_round_robin' time='5.335444'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_null_nri_1_round_robin' time='5.355550'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_unassigned_nri_round_robin' time='5.355994'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_msc_not_connected_round_robin' time='5.344634'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_1' time='5.357590'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_2' time='5.383510'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_from_other_PLMN' time='4.325147'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_paging_imsi' time='5.217852'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_paging_tmsi' time='5.229905'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_no_allow_attach_round_robin' time='5.358581'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_no_allow_attach_valid_nri' time='5.366336'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_sccp_n_pcstate_detaches_cnlink' time='5.357472'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_sccp_n_pcstate_attaches_cnlink' time='6.349471'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Compl_on_1_cnlink' time='5.356122'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_no_nri_round_robin' time='5.355712'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_valid_nri_1' time='5.355549'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_valid_nri_2' time='5.410495'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_nri_from_other_PLMN' time='4.325474'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_sccp_n_pcstate_detaches_cnlink' time='5.370286'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_sccp_n_pcstate_attaches_cnlink' time='6.348053'/> <testcase classname='HNBGW_Tests' name='TC_second_rab_assignment' time='7.369698'> <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.709968'> <error type='DTE'></error> </testcase> <testcase classname='HNBGW_Tests' name='TC_apply_sccp' time='15.105686'> <error type='DTE'></error> </testcase> </testsuite> Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.