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

See https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/513/display/redirect

Changes:

------------------------------------------ [...truncated 593.49 KB...] NOTE: unable to use dumpcap due to missing capabilities or suid bit Waiting for packet dumper to start... 0 MTC@50123f6a5fe1: External command `../ttcn3-tcpdump-start.sh HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc' was executed successfully (exit status: 0). MTC@50123f6a5fe1: Test case TC_hnb_reregister_reuse_sctp_assoc started. TC_hnb_reregister_reuse_sctp_assoc-Iuh0(731)@50123f6a5fe1: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 MTC@50123f6a5fe1: 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)@50123f6a5fe1: Final verdict of PTC: none MC@50123f6a5fe1: PTC 731 on host 172.18.169.203 is not responding. Trying to kill it using its HC. MTC@50123f6a5fe1: Setting final verdict of the test case. MTC@50123f6a5fe1: Local verdict of MTC: fail reason: "Timeout of T_guard" MTC@50123f6a5fe1: Local verdict of PTC TC_hnb_reregister_reuse_sctp_assoc-Iuh0(731): error (fail -> error) MTC@50123f6a5fe1: Local verdict of PTC TC_hnb_reregister_reuse_sctp_assoc-Iuh0-RUA(732): none (error -> error) MTC@50123f6a5fe1: Test case TC_hnb_reregister_reuse_sctp_assoc finished. Verdict: error MTC@50123f6a5fe1: Starting external command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc error'. Mon Nov 13 10:28:22 UTC 2023 ------ HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc error ------

Waiting for packet dumper to finish... 0 (prev_count=-1, count=3234) Waiting for packet dumper to finish... 1 (prev_count=3234, count=3478) MTC@50123f6a5fe1: External command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc error' was executed successfully (exit status: 0). MTC@50123f6a5fe1: Starting external command `../ttcn3-tcpdump-start.sh HNBGW_Tests.TC_apply_sccp'. ------ HNBGW_Tests.TC_apply_sccp ------ Mon Nov 13 10:28:24 UTC 2023 NOTE: unable to use dumpcap due to missing capabilities or suid bit Waiting for packet dumper to start... 0 MTC@50123f6a5fe1: External command `../ttcn3-tcpdump-start.sh HNBGW_Tests.TC_apply_sccp' was executed successfully (exit status: 0). MTC@50123f6a5fe1: Test case TC_apply_sccp started. TC_apply_sccp-Iuh0(733)@50123f6a5fe1: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 TC_apply_sccp-Iuh1(735)@50123f6a5fe1: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 MTC@50123f6a5fe1: setverdict(fail): none -> fail reason: ""VTY Timeout for prompt: enable"", new component reason: ""VTY Timeout for prompt: enable"" TC_apply_sccp-Iuh1-RUA(736)@50123f6a5fe1: Final verdict of PTC: none TC_apply_sccp-Iuh0-RUA(734)@50123f6a5fe1: Final verdict of PTC: none MC@50123f6a5fe1: PTC 733 on host 172.18.169.203 is not responding. Trying to kill it using its HC. MC@50123f6a5fe1: PTC 735 on host 172.18.169.203 is not responding. Trying to kill it using its HC. MTC@50123f6a5fe1: Setting final verdict of the test case. MTC@50123f6a5fe1: Local verdict of MTC: fail reason: ""VTY Timeout for prompt: enable"" MTC@50123f6a5fe1: Local verdict of PTC TC_apply_sccp-Iuh0(733): error (fail -> error) MTC@50123f6a5fe1: Local verdict of PTC TC_apply_sccp-Iuh0-RUA(734): none (error -> error) MTC@50123f6a5fe1: Local verdict of PTC TC_apply_sccp-Iuh1(735): error (error -> error) MTC@50123f6a5fe1: Local verdict of PTC TC_apply_sccp-Iuh1-RUA(736): none (error -> error) MTC@50123f6a5fe1: Test case TC_apply_sccp finished. Verdict: error MTC@50123f6a5fe1: Starting external command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_apply_sccp error'. Mon Nov 13 10:28:41 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@50123f6a5fe1: External command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_apply_sccp error' was executed successfully (exit status: 0). MC@50123f6a5fe1: Test execution finished. Execution of [EXECUTE] section finished. emtc MC@50123f6a5fe1: Terminating MTC. MC@50123f6a5fe1: MTC terminated. MC2> exit MC@50123f6a5fe1: Shutting down session. MC@50123f6a5fe1: 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-513-hnbgw + docker kill jenkins-ttcn3-hnbgw-test-latest-513-hnbgw Error response from daemon: Cannot kill container: jenkins-ttcn3-hnbgw-test-latest-513-hnbgw: No such container: jenkins-ttcn3-hnbgw-test-latest-513-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/513/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/513/artifact/logs/with-pfcp/hnbgw-tester/junit-xml-with-pfcp-*.log: No such file or directory + network_clean + docker network inspect ttcn3-hnbgw-test-169 + grep Name + cut -d : -f2 + awk -F" NR>1{print $2} + local containers=jenkins-ttcn3-hnbgw-test-latest-513-stp + [ -n jenkins-ttcn3-hnbgw-test-latest-513-stp ] + docker_kill_wait jenkins-ttcn3-hnbgw-test-latest-513-stp + docker kill jenkins-ttcn3-hnbgw-test-latest-513-stp jenkins-ttcn3-hnbgw-test-latest-513-stp + docker wait jenkins-ttcn3-hnbgw-test-latest-513-stp 137 + network_remove + set +x Removing network ttcn3-hnbgw-test-169 + docker network remove ttcn3-hnbgw-test-169 ttcn3-hnbgw-test-169 + rm -rf https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/513/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-513-cleaner debian:bookworm chmod -R a+rX /data/ /cache/ + collect_logs + cat https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/513/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='398.00'> <testcase classname='HNBGW_Tests' name='TC_hnb_register' time='1.143818'/> <testcase classname='HNBGW_Tests' name='TC_hnb_register_duplicate' time='1.176701'/> <testcase classname='HNBGW_Tests' name='TC_hnb_register_duplicate_reuse_sctp_assoc' time='1.128351'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_initial_ue' time='2.231434'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_initial_ue' time='2.206486'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_initial_ue_empty_cr' time='2.162114'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_initial_ue_empty_cr' time='2.223463'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_bidir' time='2.425147'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_bidir' time='2.416688'/> <testcase classname='HNBGW_Tests' name='TC_rab_assignment' time='2.484542'/> <testcase classname='HNBGW_Tests' name='TC_rab_release' time='2.432115'/> <testcase classname='HNBGW_Tests' name='TC_rab_assign_fail' time='2.424655'/> <testcase classname='HNBGW_Tests' name='TC_rab_assign_mgcp_to' time='6.355578'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_mo_disconnect' time='7.557026'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_mo_disconnect' time='7.621458'/> <testcase classname='HNBGW_Tests' name='TC_ps_rab_assignment_without_pfcp' time='7.414441'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Compl_on_1_cnlink' time='5.314404'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_imsi_round_robin' time='5.314671'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_null_nri_0_round_robin' time='5.401461'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_null_nri_1_round_robin' time='5.361308'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_unassigned_nri_round_robin' time='5.360652'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_msc_not_connected_round_robin' time='5.374900'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_1' time='5.338248'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_2' time='5.468227'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_from_other_PLMN' time='4.302836'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_paging_imsi' time='5.229114'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_paging_tmsi' time='5.251889'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_no_allow_attach_round_robin' time='5.365510'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_no_allow_attach_valid_nri' time='5.381836'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_sccp_n_pcstate_detaches_cnlink' time='5.416473'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_sccp_n_pcstate_attaches_cnlink' time='6.345803'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Compl_on_1_cnlink' time='5.393822'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_no_nri_round_robin' time='5.326966'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_valid_nri_1' time='5.402966'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_valid_nri_2' time='5.375823'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_nri_from_other_PLMN' time='4.364758'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_sccp_n_pcstate_detaches_cnlink' time='5.418830'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_sccp_n_pcstate_attaches_cnlink' time='6.360467'/> <testcase classname='HNBGW_Tests' name='TC_second_rab_assignment' time='7.466885'> <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='77.596785'> <error type='DTE'></error> </testcase> <testcase classname='HNBGW_Tests' name='TC_apply_sccp' time='15.099223'> <error type='DTE'></error> </testcase> </testsuite> Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.