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

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

Changes:

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

Waiting for packet dumper to finish... 0 (prev_count=-1, count=2730) Waiting for packet dumper to finish... 1 (prev_count=2730, count=2910) MTC@23060a37f817: External command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_hnb_reregister_reuse_sctp_assoc error' was executed successfully (exit status: 0). MTC@23060a37f817: Starting external command `../ttcn3-tcpdump-start.sh HNBGW_Tests.TC_apply_sccp'. ------ HNBGW_Tests.TC_apply_sccp ------ Sat Nov 11 10:29:40 UTC 2023 NOTE: unable to use dumpcap due to missing capabilities or suid bit Waiting for packet dumper to start... 0 MTC@23060a37f817: External command `../ttcn3-tcpdump-start.sh HNBGW_Tests.TC_apply_sccp' was executed successfully (exit status: 0). MTC@23060a37f817: Test case TC_apply_sccp started. TC_apply_sccp-Iuh0(733)@23060a37f817: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 TC_apply_sccp-Iuh1(735)@23060a37f817: Warning: sizes of 'struct sctp_event_subscribe': compile-time 14, kernel: 14 MTC@23060a37f817: setverdict(fail): none -> fail reason: ""VTY Timeout for prompt: enable"", new component reason: ""VTY Timeout for prompt: enable"" TC_apply_sccp-Iuh0-RUA(734)@23060a37f817: Final verdict of PTC: none TC_apply_sccp-Iuh1-RUA(736)@23060a37f817: Final verdict of PTC: none MC@23060a37f817: PTC 733 on host 172.18.237.203 is not responding. Trying to kill it using its HC. MC@23060a37f817: PTC 735 on host 172.18.237.203 is not responding. Trying to kill it using its HC. MTC@23060a37f817: Setting final verdict of the test case. MTC@23060a37f817: Local verdict of MTC: fail reason: ""VTY Timeout for prompt: enable"" MTC@23060a37f817: Local verdict of PTC TC_apply_sccp-Iuh0(733): error (fail -> error) MTC@23060a37f817: Local verdict of PTC TC_apply_sccp-Iuh0-RUA(734): none (error -> error) MTC@23060a37f817: Local verdict of PTC TC_apply_sccp-Iuh1(735): error (error -> error) MTC@23060a37f817: Local verdict of PTC TC_apply_sccp-Iuh1-RUA(736): none (error -> error) MTC@23060a37f817: Test case TC_apply_sccp finished. Verdict: error MTC@23060a37f817: Starting external command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_apply_sccp error'. Sat Nov 11 10:29:56 UTC 2023 ------ HNBGW_Tests.TC_apply_sccp error ------

Waiting for packet dumper to finish... 0 (prev_count=-1, count=2796) Waiting for packet dumper to finish... 1 (prev_count=2796, count=3156) MTC@23060a37f817: External command `../ttcn3-tcpdump-stop.sh HNBGW_Tests.TC_apply_sccp error' was executed successfully (exit status: 0). MC@23060a37f817: Test execution finished. Execution of [EXECUTE] section finished. emtc MC@23060a37f817: Terminating MTC. MC@23060a37f817: MTC terminated. MC2> exit MC@23060a37f817: Shutting down session. MC@23060a37f817: 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-511-hnbgw + docker kill jenkins-ttcn3-hnbgw-test-latest-511-hnbgw Error response from daemon: Cannot kill container: jenkins-ttcn3-hnbgw-test-latest-511-hnbgw: No such container: jenkins-ttcn3-hnbgw-test-latest-511-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/511/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/511/artifact/logs/with-pfcp/hnbgw-tester/junit-xml-with-pfcp-*.log: No such file or directory + network_clean + docker network inspect ttcn3-hnbgw-test-237 + grep Name + cut -d : -f2 + awk -F" NR>1{print $2} + local containers=jenkins-ttcn3-hnbgw-test-latest-511-stp + [ -n jenkins-ttcn3-hnbgw-test-latest-511-stp ] + docker_kill_wait jenkins-ttcn3-hnbgw-test-latest-511-stp + docker kill jenkins-ttcn3-hnbgw-test-latest-511-stp jenkins-ttcn3-hnbgw-test-latest-511-stp + docker wait jenkins-ttcn3-hnbgw-test-latest-511-stp 137 + network_remove + set +x Removing network ttcn3-hnbgw-test-237 + docker network remove ttcn3-hnbgw-test-237 ttcn3-hnbgw-test-237 + rm -rf https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/511/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-511-cleaner debian:bookworm chmod -R a+rX /data/ /cache/ + collect_logs + cat https://jenkins.osmocom.org/jenkins/job/ttcn3-hnbgw-test-latest/511/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.150004'/> <testcase classname='HNBGW_Tests' name='TC_hnb_register_duplicate' time='1.123816'/> <testcase classname='HNBGW_Tests' name='TC_hnb_register_duplicate_reuse_sctp_assoc' time='1.082150'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_initial_ue' time='2.215811'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_initial_ue' time='2.192224'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_initial_ue_empty_cr' time='2.194345'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_initial_ue_empty_cr' time='2.211682'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_bidir' time='2.436217'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_bidir' time='2.411759'/> <testcase classname='HNBGW_Tests' name='TC_rab_assignment' time='2.460943'/> <testcase classname='HNBGW_Tests' name='TC_rab_release' time='2.423292'/> <testcase classname='HNBGW_Tests' name='TC_rab_assign_fail' time='2.434330'/> <testcase classname='HNBGW_Tests' name='TC_rab_assign_mgcp_to' time='6.375737'/> <testcase classname='HNBGW_Tests' name='TC_ranap_cs_mo_disconnect' time='7.581058'/> <testcase classname='HNBGW_Tests' name='TC_ranap_ps_mo_disconnect' time='7.624895'/> <testcase classname='HNBGW_Tests' name='TC_ps_rab_assignment_without_pfcp' time='7.411276'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Compl_on_1_cnlink' time='5.348025'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_imsi_round_robin' time='5.340017'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_null_nri_0_round_robin' time='5.330484'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_null_nri_1_round_robin' time='5.401499'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_unassigned_nri_round_robin' time='5.361296'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_msc_not_connected_round_robin' time='5.404865'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_1' time='5.388915'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_L3Complete_by_tmsi_valid_nri_2' time='5.494816'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_LU_by_tmsi_from_other_PLMN' time='4.367416'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_paging_imsi' time='5.355492'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_paging_tmsi' time='5.293825'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_no_allow_attach_round_robin' time='5.341317'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_no_allow_attach_valid_nri' time='5.446329'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_sccp_n_pcstate_detaches_cnlink' time='5.345112'/> <testcase classname='HNBGW_Tests' name='TC_mscpool_sccp_n_pcstate_attaches_cnlink' time='6.321011'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Compl_on_1_cnlink' time='5.447948'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_no_nri_round_robin' time='5.368655'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_valid_nri_1' time='5.331958'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_L3Complete_valid_nri_2' time='5.451406'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_nri_from_other_PLMN' time='4.322334'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_sccp_n_pcstate_detaches_cnlink' time='5.380240'/> <testcase classname='HNBGW_Tests' name='TC_sgsnpool_sccp_n_pcstate_attaches_cnlink' time='6.365407'/> <testcase classname='HNBGW_Tests' name='TC_second_rab_assignment' time='7.424981'> <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='78.472560'> <error type='DTE'></error> </testcase> <testcase classname='HNBGW_Tests' name='TC_apply_sccp' time='15.132348'> <error type='DTE'></error> </testcase> </testsuite> Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.