See https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-latest/1036/display/redirect?page=changes

Changes:

[Oliver Smith] buildsystem: move related scripts to subdir

[Oliver Smith] buildsystem/regen_makefile: change to inc script

[Oliver Smith] buildsystem: remove ttcn3_compiler workaround

[Oliver Smith] buildsystem/regen_makefile: modernize

[Oliver Smith] buildsystem/gen_links: move set -e to users

[Oliver Smith] buildsystem/gen_links: rename ignore_pp_results

[Oliver Smith] buildsystem: build out-of-tree

[Oliver Smith] buildsystem: make output more readable

[Oliver Smith] testenv: remove copy_ttcn3_hacks_dir

[Oliver Smith] testenv: refactor run --until-nok code

[Oliver Smith] testenv: run: add --bisect argument

------------------------------------------ [...truncated 377.38 KiB...] 20250422131042851 DLSS7 INFO asp-srv-client: connection closed (osmo_ss7_asp.c:1082) 20250422131042851 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_ACTIVE}: Received Event SCTP-COMM_DOWN.ind (osmo_ss7_asp.c:1088) 20250422131042851 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_ACTIVE}: state_chg to ASP_DOWN (xua_asp_fsm.c:687) 20250422131042851 DLSS7 DEBUG XUA_AS(as-srv-client){AS_ACTIVE}: Received Event ASPAS-ASP_DOWN.ind (xua_asp_fsm.c:368) 20250422131042851 DLSS7 DEBUG XUA_AS(as-srv-client){AS_ACTIVE}: state_chg to AS_PENDING (xua_as_fsm.c:437) 20250422131042851 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'SCCP Management' (sccp_user.c:181) 20250422131042851 DLSCCP DEBUG Ignoring SCCP user primitive N-PCSTATE.indication (sccp_scmg.c:298) 20250422131042851 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'refuser' (sccp_user.c:181) 20250422131042851 DMAIN NOTICE Unknown primitive N-PCSTATE.indication (sccp_test_server.c:33) 20250422131042851 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'echo' (sccp_user.c:181) 20250422131042851 DMAIN NOTICE Unknown primitive N-PCSTATE.indication (sccp_test_server.c:76) 20250422131042851 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'callback' (sccp_user.c:181) 20250422131042851 DMAIN NOTICE Unknown primitive N-PCSTATE.indication (sccp_test_server.c:108) 20250422131042851 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'test_client_vty' (sccp_user.c:181) 20250422131042851 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_DOWN}: No Layer Manager, dropping M-ASP_DOWN.indication (xua_asp_fsm.c:119) 20250422131042851 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_DOWN}: No Layer Manager, dropping M-SCTP_RELEASE.indication (xua_asp_fsm.c:119) 14@ddf5f4bd17bd: Final verdict of PTC: none MTC@ddf5f4bd17bd: Setting final verdict of the test case. MTC@ddf5f4bd17bd: Local verdict of MTC: pass MTC@ddf5f4bd17bd: Local verdict of PTC with component reference 14: none (pass -> pass) MTC@ddf5f4bd17bd: Test case TC_callingparty_ssn_only finished. Verdict: pass MTC@ddf5f4bd17bd: Starting external command `https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-latest/ws/ttcn3-tcpdump-stop.sh SCCP_Tests_RAW.TC_callingparty_ssn_only pass'. 20250422131044853 DLSS7 DEBUG XUA_AS(as-srv-client){AS_PENDING}: Received Event AS-T_REC_EXPD.ind (xua_as_fsm.c:323) 20250422131044853 DLSS7 DEBUG XUA_AS(as-srv-client){AS_PENDING}: T(r) expired; dropping queued messages (xua_as_fsm.c:479) 20250422131044853 DLSS7 DEBUG XUA_AS(as-srv-client){AS_PENDING}: state_chg to AS_DOWN (xua_as_fsm.c:485) MTC@ddf5f4bd17bd: External command `https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-latest/ws/ttcn3-tcpdump-stop.sh SCCP_Tests_RAW.TC_callingparty_ssn_only pass' was executed successfully (exit status: 0). MTC@ddf5f4bd17bd: Starting external command `https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-latest/ws/ttcn3-tcpdump-start.sh SCCP_Tests_RAW.TC_cr_timeout_cc_too_late'. MTC@ddf5f4bd17bd: External command `https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-latest/ws/ttcn3-tcpdump-start.sh SCCP_Tests_RAW.TC_cr_timeout_cc_too_late' was executed successfully (exit status: 0). MTC@ddf5f4bd17bd: Test case TC_cr_timeout_cc_too_late started. 20250422131045955 DLGLOBAL INFO Accept()ed new telnet connection r=127.0.0.1:59458<->l=127.0.0.2:2324 (telnet_interface.c:192) 15@ddf5f4bd17bd: ************************************************* 15@ddf5f4bd17bd: M3UA emulation initiated, the test can be started 15@ddf5f4bd17bd: ************************************************* 20250422131046175 DLINP INFO SRV(m3ua,127.0.0.2:2905) accept()ed new link from 127.0.0.1:2905 (stream_srv.c:142) 20250422131046175 DLSS7 INFO (r=127.0.0.1:2905<->l=127.0.0.2:2905): New m3ua connection accepted (osmo_ss7_xua_srv.c:75) 20250422131046175 DLSS7 INFO (r=127.0.0.1:2905<->l=127.0.0.2:2905): matched connection to ASP asp-srv-client (osmo_ss7_xua_srv.c:112) 20250422131046175 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_DOWN}: Received Event SCTP-EST.ind (osmo_ss7_xua_srv.c:186) 20250422131046175 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_DOWN}: No Layer Manager, dropping M-SCTP_ESTABLISH.indication (xua_asp_fsm.c:119) 15@ddf5f4bd17bd: SCTP_ConnectResult -> connection established from: "127.0.0.1":2905 to server: "127.0.0.2":2905 association #8 15@ddf5f4bd17bd: Association #8 state changed to aSP_Down_sCTP_Associate_done (2) 15@ddf5f4bd17bd: Association #8 state changed to: aSP_Down_commUP_Received (3) 20250422131046182 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) message received (res=8) (stream_srv.c:759) 20250422131046182 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) received 8 bytes from client (stream_srv.c:773) 20250422131046182 DLSS7 DEBUG 0: asp-asp-srv-client: ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (osmo_ss7_asp.c:834) 20250422131046182 DLM3UA DEBUG 0: asp-asp-srv-client: Received M3UA Message (ASPSM:UP) (m3ua.c:751) 20250422131046182 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_DOWN}: Received Event ASPSM-ASP_UP (m3ua.c:714) 20250422131046182 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_DOWN}: state_chg to ASP_INACTIVE (xua_asp_fsm.c:462) 20250422131046182 DLSS7 DEBUG XUA_AS(as-srv-client){AS_DOWN}: Received Event ASPAS-ASP_INACTIVE.ind (xua_asp_fsm.c:368) 20250422131046182 DLSS7 DEBUG XUA_AS(as-srv-client){AS_DOWN}: state_chg to AS_INACTIVE (xua_as_fsm.c:331) 20250422131046182 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_INACTIVE}: No Layer Manager, dropping M-ASP_UP.indication (xua_asp_fsm.c:119) 20250422131046182 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) connected write (stream_srv.c:740) 20250422131046182 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) connected write (stream_srv.c:740) 15@ddf5f4bd17bd: M3UA_ASPUP sent 15@ddf5f4bd17bd: Association #8 state changed to: aSP_Down_ASPUP_Sent (4) 15@ddf5f4bd17bd: Message received on association #8 15@ddf5f4bd17bd: M3UA_ASPUP_Ack received -> send M3UA_ASPAC 15@ddf5f4bd17bd: Association #8 state changed to: aSP_Inactive (5) 20250422131046185 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) message received (res=8) (stream_srv.c:759) 20250422131046185 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) received 8 bytes from client (stream_srv.c:773) 20250422131046185 DLSS7 DEBUG 0: asp-asp-srv-client: ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (osmo_ss7_asp.c:834) 20250422131046185 DLM3UA DEBUG 0: asp-asp-srv-client: Received M3UA Message (ASPTM:ACTIVE) (m3ua.c:751) 20250422131046185 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_INACTIVE}: Received Event ASPTM-ASP_AC (m3ua.c:714) 20250422131046185 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_INACTIVE}: state_chg to ASP_ACTIVE (xua_asp_fsm.c:566) 20250422131046185 DLSS7 DEBUG XUA_AS(as-srv-client){AS_INACTIVE}: Received Event ASPAS-ASP_ACTIVE.ind (xua_asp_fsm.c:368) 20250422131046185 DLSS7 DEBUG XUA_AS(as-srv-client){AS_INACTIVE}: state_chg to AS_ACTIVE (xua_as_fsm.c:415) 20250422131046185 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'SCCP Management' (sccp_user.c:181) 20250422131046185 DLSCCP DEBUG Ignoring SCCP user primitive N-PCSTATE.indication (sccp_scmg.c:298) 20250422131046185 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'refuser' (sccp_user.c:181) 20250422131046185 DMAIN NOTICE Unknown primitive N-PCSTATE.indication (sccp_test_server.c:33) 20250422131046185 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'echo' (sccp_user.c:181) 20250422131046185 DMAIN NOTICE Unknown primitive N-PCSTATE.indication (sccp_test_server.c:76) 20250422131046185 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'callback' (sccp_user.c:181) 20250422131046185 DMAIN NOTICE Unknown primitive N-PCSTATE.indication (sccp_test_server.c:108) 20250422131046185 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'test_client_vty' (sccp_user.c:181) 20250422131046185 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_ACTIVE}: No Layer Manager, dropping M-ASP_ACTIVE.indication (xua_asp_fsm.c:119) 20250422131046185 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) connected write (stream_srv.c:740) 20250422131046185 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) connected write (stream_srv.c:740) 15@ddf5f4bd17bd: Association #8 state changed to: aSP_Inact_ASPAC_Sent (6) 15@ddf5f4bd17bd: Message received on association #8 15@ddf5f4bd17bd: Received M3UA_NOTIFY -> discard 15@ddf5f4bd17bd: Message received on association #8 15@ddf5f4bd17bd: ASPAC_Ack received for association #8 15@ddf5f4bd17bd: Association #8 state changed to: aSP_Active (7) 15@ddf5f4bd17bd: Message received on association #8 15@ddf5f4bd17bd: Received M3UA_NOTIFY -> discard 20250422131046975 DLSCCP DEBUG Received SCCP User Primitive (N-CONNECT.request) (sccp_scoc.c:1891) 20250422131046975 DLSCCP DEBUG SCCP-SCOC(1234){IDLE}: Allocated (fsm.c:456) 20250422131046975 DLSCCP DEBUG SCCP-SCOC(1234){IDLE}: Received Event N-CONNECT.req (sccp_scoc.c:1932) 20250422131046975 DLSS7 DEBUG sccp_scrc_rx_scoc_conn_msg: HDR=(CO:CORE,V=0,LEN=0), PART(T=Routing Context,L=4,D=00000000), PART(T=Protocol Class,L=4,D=00000002), PART(T=Source Reference,L=4,D=000004d2), PART(T=Destination Address,L=20,D=0002000380020008000000178003000800000001), PART(T=Sequence Control,L=4,D=00000000), PART(T=Source Address,L=20,D=00020003800200080000000180030008000000fe) (sccp_scrc.c:406) 20250422131046975 DLSUA DEBUG sua_addr_parse_part(IEI=0x0103) (20) 00 02 00 03 80 02 00 08 00 00 00 17 80 03 00 08 00 00 00 01 (sua.c:391) 20250422131046975 DLSUA DEBUG SUA IEI 0x0103 pos 4/20: subpart tag 0x8002, len 8 (sua.c:450) 20250422131046975 DLSUA DEBUG SUA IEI 0x0103 pos 12/20: subpart tag 0x8003, len 8 (sua.c:450) 20250422131046975 DLSUA DEBUG sua_addr_parse_part(IEI=0x0103) (20) 00 02 00 03 80 02 00 08 00 00 00 17 80 03 00 08 00 00 00 01 (sua.c:391) 20250422131046975 DLSUA DEBUG SUA IEI 0x0103 pos 4/20: subpart tag 0x8002, len 8 (sua.c:450) 20250422131046975 DLSUA DEBUG SUA IEI 0x0103 pos 12/20: subpart tag 0x8003, len 8 (sua.c:450) 20250422131046975 DLSUA DEBUG sua_addr_parse_part(IEI=0x0102) (20) 00 02 00 03 80 02 00 08 00 00 00 01 80 03 00 08 00 00 00 fe (sua.c:391) 20250422131046975 DLSUA DEBUG SUA IEI 0x0102 pos 4/20: subpart tag 0x8002, len 8 (sua.c:450) 20250422131046975 DLSUA DEBUG SUA IEI 0x0102 pos 12/20: subpart tag 0x8003, len 8 (sua.c:450) 20250422131046975 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): dpc=23=0.2.7 not local, message is for routing (osmo_ss7_hmrt.c:289) 20250422131046975 DLSS7 DEBUG Found route for dpc=23=0.2.7: pc=23=0.2.7 mask=0x3fff=7.255.7 via AS as-srv-client proto=m3ua (osmo_ss7_hmrt.c:233) 20250422131046975 DLSS7 DEBUG rt->dest.as proto is M3UA for dpc=23=0.2.7 (osmo_ss7_hmrt.c:247) 20250422131046975 DLSS7 DEBUG XUA_AS(as-srv-client){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:532) 20250422131046975 DLSCCP DEBUG SCCP-SCOC(1234){IDLE}: state_chg to CONN_PEND_OUT (sccp_scoc.c:975) 20250422131046975 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) connected write (stream_srv.c:740) 15@ddf5f4bd17bd: Message received on association #8 15@ddf5f4bd17bd: MTP3_SP_PORT: Data received -> TRANSFERind sent 20250422131046977 DLSCCP DEBUG Received SCCP User Primitive (N-DISCONNECT.request) (sccp_scoc.c:1891) 20250422131046977 DLSCCP DEBUG SCCP-SCOC(1234){CONN_PEND_OUT}: Received Event N-DISCONNECT.req (sccp_scoc.c:1932) 20250422131046977 DLSCCP DEBUG SCCP-SCOC(1234){CONN_PEND_OUT}: state_chg to WAIT_CONN_CONF (sccp_scoc.c:1070) MTC@ddf5f4bd17bd: Waiting for RLSD 20250422131046978 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) message received (res=36) (stream_srv.c:759) 20250422131046978 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) received 36 bytes from client (stream_srv.c:773) 20250422131046978 DLSS7 DEBUG 0: asp-asp-srv-client: ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (osmo_ss7_asp.c:834) 20250422131046978 DLM3UA DEBUG 0: asp-asp-srv-client: Received M3UA Message (XFER:DATA) (m3ua.c:751) 20250422131046978 DLM3UA DEBUG 0: asp-asp-srv-client: m3ua_rx_xfer (m3ua.c:568) 20250422131046978 DLM3UA DEBUG 0: asp-asp-srv-client: m3ua_rx_xfer(): M3UA data header: opc=23=0.2.7 dpc=1=0.0.1 (m3ua.c:603) 20250422131046978 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): found dpc=1=0.0.1 as local (osmo_ss7_hmrt.c:285) 20250422131046978 DLSS7 DEBUG scrc_rx_mtp_xfer_ind_xua: HDR=(CO:COAK,V=0,LEN=0), PART(T=Protocol Class,L=4,D=00000002), PART(T=Destination Reference,L=4,D=000004d2), PART(T=Source Reference,L=4,D=00000001) (sccp_scrc.c:477) 20250422131046978 DLSCCP DEBUG Received CO:COAK for local reference 1234 (sccp_scoc.c:1824) 20250422131046978 DLSCCP DEBUG SCCP-SCOC(1234){WAIT_CONN_CONF}: Received Event RCOC-CONNECT_CONFIRM.ind (sccp_scoc.c:1858) 20250422131046978 DLSS7 DEBUG sccp_scrc_rx_scoc_conn_msg: HDR=(CO:RELRE,V=0,LEN=0), PART(T=Routing Context,L=4,D=00000000), PART(T=Destination Reference,L=4,D=00000001), PART(T=Source Reference,L=4,D=000004d2), PART(T=SCCP Cause,L=4,D=0000032a) (sccp_scrc.c:406) 20250422131046978 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): dpc=23=0.2.7 not local, message is for routing (osmo_ss7_hmrt.c:289) 20250422131046978 DLSS7 DEBUG Found route for dpc=23=0.2.7: pc=23=0.2.7 mask=0x3fff=7.255.7 via AS as-srv-client proto=m3ua (osmo_ss7_hmrt.c:233) 20250422131046978 DLSS7 DEBUG rt->dest.as proto is M3UA for dpc=23=0.2.7 (osmo_ss7_hmrt.c:247) 20250422131046978 DLSS7 DEBUG XUA_AS(as-srv-client){AS_ACTIVE}: Received Event AS-TRANSFER.req (m3ua.c:532) 15@ddf5f4bd17bd: MTP3_SP_PORT: ASP_MTP3_TRANSFERreq received -> message sent via SCTP 20250422131046978 DLSCCP DEBUG SCCP-SCOC(1234){WAIT_CONN_CONF}: state_chg to DISCONN_PEND (sccp_scoc.c:1175) 20250422131046978 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) connected write (stream_srv.c:740) 15@ddf5f4bd17bd: Message received on association #8 15@ddf5f4bd17bd: MTP3_SP_PORT: Data received -> TRANSFERind sent 20250422131046979 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) message received (res=32) (stream_srv.c:759) 20250422131046979 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) received 32 bytes from client (stream_srv.c:773) 20250422131046979 DLSS7 DEBUG 0: asp-asp-srv-client: ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (osmo_ss7_asp.c:834) 20250422131046979 DLM3UA DEBUG 0: asp-asp-srv-client: Received M3UA Message (XFER:DATA) (m3ua.c:751) 20250422131046979 DLM3UA DEBUG 0: asp-asp-srv-client: m3ua_rx_xfer (m3ua.c:568) 20250422131046979 DLM3UA DEBUG 0: asp-asp-srv-client: m3ua_rx_xfer(): M3UA data header: opc=23=0.2.7 dpc=1=0.0.1 (m3ua.c:603) 15@ddf5f4bd17bd: MTP3_SP_PORT: ASP_MTP3_TRANSFERreq received -> message sent via SCTP 20250422131046979 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): found dpc=1=0.0.1 as local (osmo_ss7_hmrt.c:285) 20250422131046979 DLSS7 DEBUG scrc_rx_mtp_xfer_ind_xua: HDR=(CO:RELCO,V=0,LEN=0), PART(T=Destination Reference,L=4,D=000004d2), PART(T=Source Reference,L=4,D=00000001) (sccp_scrc.c:477) 20250422131046979 DLSCCP DEBUG Received CO:RELCO for local reference 1234 (sccp_scoc.c:1824) 20250422131046979 DLSCCP DEBUG SCCP-SCOC(1234){DISCONN_PEND}: Received Event RCOC-RELEASE_COMPLETE.ind (sccp_scoc.c:1858) 20250422131046979 DLSCCP DEBUG SCCP-SCOC(1234){DISCONN_PEND}: state_chg to IDLE (sccp_scoc.c:1332) 20250422131046979 DLSCCP DEBUG SCCP-SCOC(1234){IDLE}: Terminating (cause = OSMO_FSM_TERM_REQUEST) (sccp_scoc.c:552) 20250422131046979 DLSCCP DEBUG SCCP-SCOC(1234){IDLE}: Freeing instance (sccp_scoc.c:552) 20250422131046979 DLSCCP DEBUG SCCP-SCOC(1234){IDLE}: Deallocated (fsm.c:568) MTC@ddf5f4bd17bd: setverdict(pass): none -> pass 20250422131047981 DLGLOBAL INFO Closing telnet connection r=127.0.0.1:59458<->l=127.0.0.2:2324 (telnet_interface.c:138) 20250422131047985 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) message received (res=12) (stream_srv.c:759) 20250422131047985 DLINP NOTICE asp-srv-client NOTIFICATION SHUTDOWN_EVENT flags=0x0 (stream.c:265) 20250422131047985 DLSS7 DEBUG 0: asp-asp-srv-client: ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x80) (osmo_ss7_asp.c:834) 20250422131047985 DLSS7 INFO 0: asp-asp-srv-client: xUA SRV SCTP NOTIFICATION 32773 flags=0x0 (osmo_ss7_asp.c:772) 20250422131047985 DLSS7 NOTICE 0: asp-asp-srv-client: xUA SRV SHUTDOWN_EVENT (osmo_ss7_asp.c:795) 20250422131047985 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) message received (res=20) (stream_srv.c:759) 20250422131047985 DLINP NOTICE asp-srv-client NOTIFICATION ASSOC_CHANGE flags=0x0 SHUTDOWN_COMP (stream.c:265) 20250422131047985 DLSS7 DEBUG 0: asp-asp-srv-client: ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x80) (osmo_ss7_asp.c:834) 20250422131047985 DLSS7 INFO 0: asp-asp-srv-client: xUA SRV SCTP NOTIFICATION 32769 flags=0x0 (osmo_ss7_asp.c:772) 20250422131047985 DLSS7 NOTICE 0: asp-asp-srv-client: xUA SRV SCTP_ASSOC_CHANGE: SHUTDOWN_COMP (osmo_ss7_asp.c:780) 20250422131047985 DLINP DEBUG SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) message received (res=0) (stream_srv.c:759) 20250422131047985 DLINP NOTICE SRVCONN(asp-srv-client,r=127.0.0.1:2905<->l=127.0.0.2:2905) connection closed with client (stream_srv.c:769) 20250422131047986 DLSS7 DEBUG 0: asp-asp-srv-client: ss7_asp_xua_srv_conn_rx_cb(): sctp_recvmsg() returned 0 (flags=0x0) (osmo_ss7_asp.c:834) 15@ddf5f4bd17bd: Final verdict of PTC: none 20250422131047986 DLSS7 INFO asp-srv-client: connection closed (osmo_ss7_asp.c:1082) 20250422131047986 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_ACTIVE}: Received Event SCTP-COMM_DOWN.ind (osmo_ss7_asp.c:1088) 20250422131047986 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_ACTIVE}: state_chg to ASP_DOWN (xua_asp_fsm.c:687) 20250422131047986 DLSS7 DEBUG XUA_AS(as-srv-client){AS_ACTIVE}: Received Event ASPAS-ASP_DOWN.ind (xua_asp_fsm.c:368) 20250422131047986 DLSS7 DEBUG XUA_AS(as-srv-client){AS_ACTIVE}: state_chg to AS_PENDING (xua_as_fsm.c:437) 20250422131047986 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'SCCP Management' (sccp_user.c:181) 20250422131047986 DLSCCP DEBUG Ignoring SCCP user primitive N-PCSTATE.indication (sccp_scmg.c:298) MTC@ddf5f4bd17bd: Setting final verdict of the test case. 20250422131047986 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'refuser' (sccp_user.c:181) 20250422131047986 DMAIN NOTICE Unknown primitive N-PCSTATE.indication (sccp_test_server.c:33) 20250422131047986 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'echo' (sccp_user.c:181) 20250422131047986 DMAIN NOTICE Unknown primitive N-PCSTATE.indication (sccp_test_server.c:76) MTC@ddf5f4bd17bd: Local verdict of MTC: pass 20250422131047986 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'callback' (sccp_user.c:181) 20250422131047986 DMAIN NOTICE Unknown primitive N-PCSTATE.indication (sccp_test_server.c:108) 20250422131047986 DLSCCP DEBUG Delivering N-PCSTATE.indication to SCCP User 'test_client_vty' (sccp_user.c:181) 20250422131047986 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_DOWN}: No Layer Manager, dropping M-ASP_DOWN.indication (xua_asp_fsm.c:119) 20250422131047986 DLSS7 DEBUG XUA_ASP(asp-srv-client){ASP_DOWN}: No Layer Manager, dropping M-SCTP_RELEASE.indication (xua_asp_fsm.c:119) MTC@ddf5f4bd17bd: Local verdict of PTC with component reference 15: none (pass -> pass) MTC@ddf5f4bd17bd: Test case TC_cr_timeout_cc_too_late finished. Verdict: pass MTC@ddf5f4bd17bd: Starting external command `https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-latest/ws/ttcn3-tcpdump-stop.sh SCCP_Tests_RAW.TC_cr_timeout_cc_too_late pass'. 20250422131049987 DLSS7 DEBUG XUA_AS(as-srv-client){AS_PENDING}: Received Event AS-T_REC_EXPD.ind (xua_as_fsm.c:323) 20250422131049987 DLSS7 DEBUG XUA_AS(as-srv-client){AS_PENDING}: T(r) expired; dropping queued messages (xua_as_fsm.c:479) 20250422131049987 DLSS7 DEBUG XUA_AS(as-srv-client){AS_PENDING}: state_chg to AS_DOWN (xua_as_fsm.c:485) MTC@ddf5f4bd17bd: External command `https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-latest/ws/ttcn3-tcpdump-stop.sh SCCP_Tests_RAW.TC_cr_timeout_cc_too_late pass' was executed successfully (exit status: 0). MC@ddf5f4bd17bd: Test execution finished. Execution of [EXECUTE] section finished. 20250422131640932 DLSCCP DEBUG SCCP-SCOC(1){ACTIVE}: Received Event T(ias)_expired (sccp_scoc.c:293) 20250422131640932 DLSS7 DEBUG sccp_scrc_rx_scoc_conn_msg: HDR=(CO:COIT,V=0,LEN=0), PART(T=Routing Context,L=4,D=00000000), PART(T=Protocol Class,L=4,D=00000002), PART(T=Source Reference,L=4,D=00000001), PART(T=Destination Reference,L=4,D=00000001) (sccp_scrc.c:406) 20250422131640932 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): dpc=23=0.2.7 not local, message is for routing (osmo_ss7_hmrt.c:289) 20250422131640932 DLSS7 DEBUG Found route for dpc=23=0.2.7: pc=23=0.2.7 mask=0x3fff=7.255.7 via AS as-srv-client proto=m3ua (osmo_ss7_hmrt.c:233) 20250422131640932 DLSS7 ERROR Unable to route HMRT message: the AS as-srv-client is down (osmo_ss7_hmrt.c:238) 20250422132340932 DLSCCP DEBUG SCCP-SCOC(1){ACTIVE}: Received Event T(ias)_expired (sccp_scoc.c:293) 20250422132340933 DLSS7 DEBUG sccp_scrc_rx_scoc_conn_msg: HDR=(CO:COIT,V=0,LEN=0), PART(T=Routing Context,L=4,D=00000000), PART(T=Protocol Class,L=4,D=00000002), PART(T=Source Reference,L=4,D=00000001), PART(T=Destination Reference,L=4,D=00000001) (sccp_scrc.c:406) 20250422132340933 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): dpc=23=0.2.7 not local, message is for routing (osmo_ss7_hmrt.c:289) 20250422132340933 DLSS7 DEBUG Found route for dpc=23=0.2.7: pc=23=0.2.7 mask=0x3fff=7.255.7 via AS as-srv-client proto=m3ua (osmo_ss7_hmrt.c:233) 20250422132340933 DLSS7 ERROR Unable to route HMRT message: the AS as-srv-client is down (osmo_ss7_hmrt.c:238) 20250422132440931 DLSCCP DEBUG SCCP-SCOC(1){ACTIVE}: Received Event T(iar)_expired (sccp_scoc.c:300) 20250422132440932 DLSCCP DEBUG Delivering N-DISCONNECT.indication to SCCP User 'echo' (sccp_user.c:181) 20250422132440932 DMAIN INFO Got N-DISCONNECT.ind (local_ref=1, cause=781, importance=0) (sccp_test_server.c:71) 20250422132440932 DLSS7 DEBUG sccp_scrc_rx_scoc_conn_msg: HDR=(CO:RELRE,V=0,LEN=0), PART(T=Routing Context,L=4,D=00000000), PART(T=Destination Reference,L=4,D=00000001), PART(T=Source Reference,L=4,D=00000001), PART(T=SCCP Cause,L=4,D=0000030d) (sccp_scrc.c:406) 20250422132440932 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): dpc=23=0.2.7 not local, message is for routing (osmo_ss7_hmrt.c:289) 20250422132440932 DLSS7 DEBUG Found route for dpc=23=0.2.7: pc=23=0.2.7 mask=0x3fff=7.255.7 via AS as-srv-client proto=m3ua (osmo_ss7_hmrt.c:233) 20250422132440932 DLSS7 ERROR Unable to route HMRT message: the AS as-srv-client is down (osmo_ss7_hmrt.c:238) 20250422132440932 DLSCCP DEBUG SCCP-SCOC(1){ACTIVE}: state_chg to DISCONN_PEND (sccp_scoc.c:1258) 20250422132450932 DLSCCP DEBUG SCCP-SCOC(1){DISCONN_PEND}: Received Event T(rel)_expired (sccp_scoc.c:307) 20250422132450933 DLSS7 DEBUG sccp_scrc_rx_scoc_conn_msg: HDR=(CO:RELRE,V=0,LEN=0), PART(T=Routing Context,L=4,D=00000000), PART(T=Destination Reference,L=4,D=00000001), PART(T=Source Reference,L=4,D=00000001), PART(T=SCCP Cause,L=4,D=0000030f) (sccp_scrc.c:406) 20250422132450933 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): dpc=23=0.2.7 not local, message is for routing (osmo_ss7_hmrt.c:289) 20250422132450933 DLSS7 DEBUG Found route for dpc=23=0.2.7: pc=23=0.2.7 mask=0x3fff=7.255.7 via AS as-srv-client proto=m3ua (osmo_ss7_hmrt.c:233) 20250422132450933 DLSS7 ERROR Unable to route HMRT message: the AS as-srv-client is down (osmo_ss7_hmrt.c:238) 20250422132500934 DLSCCP DEBUG SCCP-SCOC(1){DISCONN_PEND}: Received Event T(rep_rel)_expired (sccp_scoc.c:321) 20250422132500934 DLSS7 DEBUG sccp_scrc_rx_scoc_conn_msg: HDR=(CO:RELRE,V=0,LEN=0), PART(T=Routing Context,L=4,D=00000000), PART(T=Destination Reference,L=4,D=00000001), PART(T=Source Reference,L=4,D=00000001), PART(T=SCCP Cause,L=4,D=0000030f) (sccp_scrc.c:406) 20250422132500934 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): dpc=23=0.2.7 not local, message is for routing (osmo_ss7_hmrt.c:289) 20250422132500934 DLSS7 DEBUG Found route for dpc=23=0.2.7: pc=23=0.2.7 mask=0x3fff=7.255.7 via AS as-srv-client proto=m3ua (osmo_ss7_hmrt.c:233) 20250422132500934 DLSS7 ERROR Unable to route HMRT message: the AS as-srv-client is down (osmo_ss7_hmrt.c:238) 20250422132510934 DLSCCP DEBUG SCCP-SCOC(1){DISCONN_PEND}: Received Event T(rep_rel)_expired (sccp_scoc.c:321) 20250422132510934 DLSS7 DEBUG sccp_scrc_rx_scoc_conn_msg: HDR=(CO:RELRE,V=0,LEN=0), PART(T=Routing Context,L=4,D=00000000), PART(T=Destination Reference,L=4,D=00000001), PART(T=Source Reference,L=4,D=00000001), PART(T=SCCP Cause,L=4,D=0000030f) (sccp_scrc.c:406) 20250422132510934 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): dpc=23=0.2.7 not local, message is for routing (osmo_ss7_hmrt.c:289) 20250422132510934 DLSS7 DEBUG Found route for dpc=23=0.2.7: pc=23=0.2.7 mask=0x3fff=7.255.7 via AS as-srv-client proto=m3ua (osmo_ss7_hmrt.c:233) 20250422132510934 DLSS7 ERROR Unable to route HMRT message: the AS as-srv-client is down (osmo_ss7_hmrt.c:238) 20250422132520936 DLSCCP DEBUG SCCP-SCOC(1){DISCONN_PEND}: Received Event T(rep_rel)_expired (sccp_scoc.c:321) 20250422132520936 DLSS7 DEBUG sccp_scrc_rx_scoc_conn_msg: HDR=(CO:RELRE,V=0,LEN=0), PART(T=Routing Context,L=4,D=00000000), PART(T=Destination Reference,L=4,D=00000001), PART(T=Source Reference,L=4,D=00000001), PART(T=SCCP Cause,L=4,D=0000030f) (sccp_scrc.c:406) 20250422132520936 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): dpc=23=0.2.7 not local, message is for routing (osmo_ss7_hmrt.c:289) 20250422132520936 DLSS7 DEBUG Found route for dpc=23=0.2.7: pc=23=0.2.7 mask=0x3fff=7.255.7 via AS as-srv-client proto=m3ua (osmo_ss7_hmrt.c:233) 20250422132520936 DLSS7 ERROR Unable to route HMRT message: the AS as-srv-client is down (osmo_ss7_hmrt.c:238) 20250422132530937 DLSCCP DEBUG SCCP-SCOC(1){DISCONN_PEND}: Received Event T(rep_rel)_expired (sccp_scoc.c:321) 20250422132530937 DLSS7 DEBUG sccp_scrc_rx_scoc_conn_msg: HDR=(CO:RELRE,V=0,LEN=0), PART(T=Routing Context,L=4,D=00000000), PART(T=Destination Reference,L=4,D=00000001), PART(T=Source Reference,L=4,D=00000001), PART(T=SCCP Cause,L=4,D=0000030f) (sccp_scrc.c:406) 20250422132530937 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): dpc=23=0.2.7 not local, message is for routing (osmo_ss7_hmrt.c:289) 20250422132530937 DLSS7 DEBUG Found route for dpc=23=0.2.7: pc=23=0.2.7 mask=0x3fff=7.255.7 via AS as-srv-client proto=m3ua (osmo_ss7_hmrt.c:233) 20250422132530937 DLSS7 ERROR Unable to route HMRT message: the AS as-srv-client is down (osmo_ss7_hmrt.c:238) 20250422132540938 DLSCCP DEBUG SCCP-SCOC(1){DISCONN_PEND}: Received Event T(rep_rel)_expired (sccp_scoc.c:321) 20250422132540938 DLSS7 DEBUG sccp_scrc_rx_scoc_conn_msg: HDR=(CO:RELRE,V=0,LEN=0), PART(T=Routing Context,L=4,D=00000000), PART(T=Destination Reference,L=4,D=00000001), PART(T=Source Reference,L=4,D=00000001), PART(T=SCCP Cause,L=4,D=0000030f) (sccp_scrc.c:406) 20250422132540938 DLSS7 DEBUG m3ua_hmdc_rx_from_l2(): dpc=23=0.2.7 not local, message is for routing (osmo_ss7_hmrt.c:289) 20250422132540938 DLSS7 DEBUG Found route for dpc=23=0.2.7: pc=23=0.2.7 mask=0x3fff=7.255.7 via AS as-srv-client proto=m3ua (osmo_ss7_hmrt.c:233) 20250422132540938 DLSS7 ERROR Unable to route HMRT message: the AS as-srv-client is down (osmo_ss7_hmrt.c:238) 20250422132550934 DLSCCP DEBUG SCCP-SCOC(1){DISCONN_PEND}: Received Event T(int)_expired (sccp_scoc.c:314) 20250422132550934 DLSCCP DEBUG SCCP-SCOC(1){DISCONN_PEND}: state_chg to IDLE (sccp_scoc.c:1350) 20250422132550934 DLSCCP DEBUG SCCP-SCOC(1){IDLE}: Terminating (cause = OSMO_FSM_TERM_REQUEST) (sccp_scoc.c:552) 20250422132550934 DLSCCP DEBUG SCCP-SCOC(1){IDLE}: Freeing instance (sccp_scoc.c:552) 20250422132550934 DLSCCP DEBUG SCCP-SCOC(1){IDLE}: Deallocated (fsm.c:568) ERROR: timeout reached! [testenv] podman container crashed! [testenv] Stopping testsuite (1698654) [testenv] feed_watchdog_loop: podman container has stopped [testenv] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-sccp-test-latest/1036/artifact...  Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.