Build failed in Jenkins: ttcn3-remsim-test-asan #302

See <https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/302/display/redirect?page=changes> Changes: [Oliver Smith] testenv: fix building osmo-remsim with osmo-dev [Oliver Smith] Cosmetic: testenv/testdir: fix formatting ------------------------------------------ [...truncated 547.70 KiB...] DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(bankd){REESTABLISH}: RSPRO link to 127.0.0.1:9999 DOWN MTC@74943110aef6: Local verdict of MTC: pass MTC@74943110aef6: Local verdict of PTC RSPRO_SRV0(7): none (pass -> pass) MTC@74943110aef6: Local verdict of PTC RSPRO_SRV1(8): none (pass -> pass) MTC@74943110aef6: Test case TC_srv_connectClient_configClientBank finished. Verdict: pass MTC@74943110aef6: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh> RemsimClient_Tests.TC_srv_connectClient_configClientBank pass'. Fri Apr 4 17:16:26 UTC 2025 ====== RemsimClient_Tests.TC_srv_connectClient_configClientBank pass ====== Waiting for packet dumper to finish... 0 (prev_count=-1, count=4644) Waiting for packet dumper to finish... 1 (prev_count=4644, count=5636) MTC@74943110aef6: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh> RemsimClient_Tests.TC_srv_connectClient_configClientBank pass' was executed successfully (exit status: 0). MTC@74943110aef6: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-start.sh> RemsimClient_Tests.TC_srv_reconnect'. ------ RemsimClient_Tests.TC_srv_reconnect ------ Fri Apr 4 17:16:28 UTC 2025 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/302/artifact/logs/client/testsuite/RemsimClient_Tests.TC_srv_reconnect.pcap"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/302/artifact/logs/client/testsuite/RemsimClient_Tests.TC_srv_reconnect.pcap.stdout> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@74943110aef6: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-start.sh> RemsimClient_Tests.TC_srv_reconnect' was executed successfully (exit status: 0). MTC@74943110aef6: Test case TC_srv_reconnect started. DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(bankd){REESTABLISH_DELAY}: Destroying existing connection to server DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Destroying existing connection to server DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(server){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9998 DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(bankd){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9999 DRSPRO NOTICE ../rspro_client_fsm.c:145 RSPRO_CLIENT(server){REESTABLISH}: RSPRO link to 127.0.0.1:9998 UP DLINP ERROR stream_cli.c:423 CLICONN(bankd,){CONNECTING} connect failed (-111) DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(bankd){REESTABLISH}: RSPRO link to 127.0.0.1:9999 DOWN RSPRO_SRV0(9)@74943110aef6: Established a new IPA connection (conn_id=2) RSPRO_SRV0(9)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } DRSPRO NOTICE ../rspro_client_fsm.c:199 RSPRO_CLIENT(server){ESTABLISHED}: received ID_GET for unit ID 0/0/0 RSPRO_SRV0(9)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_PING (0), u := omit } RSPRO_SRV0(9)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_PONG (1), u := omit } MTC@74943110aef6: Warning: Re-starting timer g_rspro_srv_Tguard, which is already active (running or expired). RSPRO_SRV0(9)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } } } RSPRO_SRV0(9)@74943110aef6: IPA ID RESP: { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } RSPRO_SRV0(9)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } RSPRO_SRV0(9)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } DMAIN ERROR ../rspro_client_fsm.c:378 CLIENT_MAIN(main){WAIT_BANKD}: Event MF_E_SRVC_CONNECTED not permitted DLINP NOTICE stream_cli.c:547 CLICONN(server,r=127.0.0.1:9998<->l=127.0.0.1:40671){CONNECTED} connection closed with srv DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(server){CONNECTED}: RSPRO link to 127.0.0.1:9998 DOWN DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Destroying existing connection to server RSPRO_SRV0(9)@74943110aef6: Final verdict of PTC: none MTC@74943110aef6: Warning: Re-starting timer g_rspro_srv_Tguard, which is already active (running or expired). DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(server){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9998 DRSPRO NOTICE ../rspro_client_fsm.c:145 RSPRO_CLIENT(server){REESTABLISH}: RSPRO link to 127.0.0.1:9998 UP RSPRO_SRV0(11)@74943110aef6: Established a new IPA connection (conn_id=2) RSPRO_SRV0(11)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } DRSPRO NOTICE ../rspro_client_fsm.c:199 RSPRO_CLIENT(server){ESTABLISHED}: received ID_GET for unit ID 0/0/0 RSPRO_SRV0(11)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_PING (0), u := omit } RSPRO_SRV0(11)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_PONG (1), u := omit } MTC@74943110aef6: setverdict(pass): none -> pass RSPRO_SRV0(11)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } } } RSPRO_SRV0(11)@74943110aef6: IPA ID RESP: { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } RSPRO_SRV0(11)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } RSPRO_SRV0(11)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } DMAIN ERROR ../rspro_client_fsm.c:378 CLIENT_MAIN(main){WAIT_BANKD}: Event MF_E_SRVC_CONNECTED not permitted DLINP NOTICE stream_cli.c:547 CLICONN(server,r=127.0.0.1:9998<->l=127.0.0.1:40089){CONNECTED} connection closed with srv DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(server){CONNECTED}: RSPRO link to 127.0.0.1:9998 DOWN DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Destroying existing connection to server RSPRO_SRV1(10)@74943110aef6: Final verdict of PTC: none RSPRO_SRV0(11)@74943110aef6: Final verdict of PTC: none MTC@74943110aef6: Setting final verdict of the test case. MTC@74943110aef6: Local verdict of MTC: pass MTC@74943110aef6: Local verdict of PTC RSPRO_SRV0(9): none (pass -> pass) MTC@74943110aef6: Local verdict of PTC RSPRO_SRV1(10): none (pass -> pass) MTC@74943110aef6: Local verdict of PTC RSPRO_SRV0(11): none (pass -> pass) DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(server){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9998 MTC@74943110aef6: Test case TC_srv_reconnect finished. Verdict: pass MTC@74943110aef6: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh> RemsimClient_Tests.TC_srv_reconnect pass'. DLINP ERROR stream_cli.c:423 CLICONN(server,){CONNECTING} connect failed (-111) DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(server){REESTABLISH}: RSPRO link to 127.0.0.1:9998 DOWN Fri Apr 4 17:16:38 UTC 2025 ====== RemsimClient_Tests.TC_srv_reconnect pass ====== Waiting for packet dumper to finish... 0 (prev_count=-1, count=4972) Waiting for packet dumper to finish... 1 (prev_count=4972, count=5468) MTC@74943110aef6: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh> RemsimClient_Tests.TC_srv_reconnect pass' was executed successfully (exit status: 0). MTC@74943110aef6: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-start.sh> RemsimClient_Tests.TC_bank_reconnect'. ------ RemsimClient_Tests.TC_bank_reconnect ------ Fri Apr 4 17:16:40 UTC 2025 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/302/artifact/logs/client/testsuite/RemsimClient_Tests.TC_bank_reconnect.pcap"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/302/artifact/logs/client/testsuite/RemsimClient_Tests.TC_bank_reconnect.pcap.stdout> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@74943110aef6: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-start.sh> RemsimClient_Tests.TC_bank_reconnect' was executed successfully (exit status: 0). MTC@74943110aef6: Test case TC_bank_reconnect started. DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(bankd){REESTABLISH_DELAY}: Destroying existing connection to server DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(bankd){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9999 DLINP ERROR stream_cli.c:423 CLICONN(bankd,){CONNECTING} connect failed (-111) DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(bankd){REESTABLISH}: RSPRO link to 127.0.0.1:9999 DOWN DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Destroying existing connection to server DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(server){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9998 DRSPRO NOTICE ../rspro_client_fsm.c:145 RSPRO_CLIENT(server){REESTABLISH}: RSPRO link to 127.0.0.1:9998 UP RSPRO_SRV0(12)@74943110aef6: Established a new IPA connection (conn_id=2) RSPRO_SRV0(12)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } DRSPRO NOTICE ../rspro_client_fsm.c:199 RSPRO_CLIENT(server){ESTABLISHED}: received ID_GET for unit ID 0/0/0 RSPRO_SRV0(12)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_PING (0), u := omit } RSPRO_SRV0(12)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_PONG (1), u := omit } MTC@74943110aef6: Warning: Re-starting timer g_rspro_srv_Tguard, which is already active (running or expired). RSPRO_SRV0(12)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } } } RSPRO_SRV0(12)@74943110aef6: IPA ID RESP: { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } RSPRO_SRV0(12)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } RSPRO_SRV0(12)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } DMAIN ERROR ../rspro_client_fsm.c:378 CLIENT_MAIN(main){WAIT_BANKD}: Event MF_E_SRVC_CONNECTED not permitted DMAIN INFO main_fsm.c:249 CLIENT_MAIN(main){WAIT_BANKD}: Rx configClientBankReq(127.0.0.1:9999 / B1:0) DMAIN ERROR main_fsm.c:255 CLIENT_MAIN(main){WAIT_BANKD}: transition to state WAIT_BANKD not permitted! DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(bankd){REESTABLISH_DELAY}: Destroying existing connection to server DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(bankd){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9999 DRSPRO NOTICE ../rspro_client_fsm.c:145 RSPRO_CLIENT(bankd){REESTABLISH}: RSPRO link to 127.0.0.1:9999 UP RSPRO_SRV1(13)@74943110aef6: Established a new IPA connection (conn_id=2) MTC@74943110aef6: setverdict(pass): none -> pass RSPRO_SRV1(13)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } DRSPRO NOTICE ../rspro_client_fsm.c:199 RSPRO_CLIENT(bankd){ESTABLISHED}: received ID_GET for unit ID 0/0/0 RSPRO_SRV1(13)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_PING (0), u := omit } RSPRO_SRV1(13)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_PONG (1), u := omit } RSPRO_SRV1(13)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } } } RSPRO_SRV1(13)@74943110aef6: IPA ID RESP: { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } RSPRO_SRV1(13)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } RSPRO_SRV1(13)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } DLINP NOTICE stream_cli.c:547 CLICONN(bankd,r=127.0.0.1:9999<->l=127.0.0.1:43005){CONNECTED} connection closed with srv DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(bankd){ESTABLISHED}: RSPRO link to 127.0.0.1:9999 DOWN DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(bankd){REESTABLISH_DELAY}: Destroying existing connection to server RSPRO_SRV1(13)@74943110aef6: Final verdict of PTC: none DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(bankd){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9999 DLINP ERROR stream_cli.c:423 CLICONN(bankd,){CONNECTING} connect failed (-111) DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(bankd){REESTABLISH}: RSPRO link to 127.0.0.1:9999 DOWN MTC@74943110aef6: Warning: Re-starting timer g_rspro_srv_Tguard, which is already active (running or expired). DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(bankd){REESTABLISH_DELAY}: Destroying existing connection to server DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(bankd){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9999 DRSPRO NOTICE ../rspro_client_fsm.c:145 RSPRO_CLIENT(bankd){REESTABLISH}: RSPRO link to 127.0.0.1:9999 UP RSPRO_SRV1(14)@74943110aef6: Established a new IPA connection (conn_id=2) RSPRO_SRV1(14)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } DRSPRO NOTICE ../rspro_client_fsm.c:199 RSPRO_CLIENT(bankd){ESTABLISHED}: received ID_GET for unit ID 0/0/0 RSPRO_SRV1(14)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_PING (0), u := omit } RSPRO_SRV1(14)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_PONG (1), u := omit } MTC@74943110aef6: setverdict(pass): pass -> pass, component reason not changed RSPRO_SRV1(14)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } } } RSPRO_SRV1(14)@74943110aef6: IPA ID RESP: { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } RSPRO_SRV1(14)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } RSPRO_SRV1(14)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } SET_ATR: 3b 00 DLINP NOTICE stream_cli.c:547 CLICONN(bankd,r=127.0.0.1:9999<->l=127.0.0.1:43075){CONNECTED} connection closed with srv DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(bankd){CONNECTED}: RSPRO link to 127.0.0.1:9999 DOWN DMAIN ERROR main_fsm.c:237 CLIENT_MAIN(main){OPERATIONAL}: Connection to bankd lost DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(bankd){REESTABLISH_DELAY}: Destroying existing connection to server DLINP NOTICE stream_cli.c:547 CLICONN(server,r=127.0.0.1:9998<->l=127.0.0.1:36267){CONNECTED} connection closed with srv DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(server){CONNECTED}: RSPRO link to 127.0.0.1:9998 DOWN DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Destroying existing connection to server RSPRO_SRV1(14)@74943110aef6: Final verdict of PTC: none RSPRO_SRV0(12)@74943110aef6: Final verdict of PTC: none MTC@74943110aef6: Setting final verdict of the test case. DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(server){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9998 MTC@74943110aef6: Local verdict of MTC: pass DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(bankd){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9999 MTC@74943110aef6: Local verdict of PTC RSPRO_SRV0(12): none (pass -> pass) DLINP ERROR stream_cli.c:423 CLICONN(server,){CONNECTING} connect failed (-111) DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(server){REESTABLISH}: RSPRO link to 127.0.0.1:9998 DOWN DLINP ERROR stream_cli.c:423 CLICONN(bankd,){CONNECTING} connect failed (-111) DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(bankd){REESTABLISH}: RSPRO link to 127.0.0.1:9999 DOWN MTC@74943110aef6: Local verdict of PTC RSPRO_SRV1(13): none (pass -> pass) MTC@74943110aef6: Local verdict of PTC RSPRO_SRV1(14): none (pass -> pass) MTC@74943110aef6: Test case TC_bank_reconnect finished. Verdict: pass MTC@74943110aef6: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh> RemsimClient_Tests.TC_bank_reconnect pass'. Fri Apr 4 17:16:59 UTC 2025 ====== RemsimClient_Tests.TC_bank_reconnect pass ====== Waiting for packet dumper to finish... 0 (prev_count=-1, count=7084) Waiting for packet dumper to finish... 1 (prev_count=7084, count=8076) MTC@74943110aef6: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh> RemsimClient_Tests.TC_bank_reconnect pass' was executed successfully (exit status: 0). MTC@74943110aef6: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-start.sh> RemsimClient_Tests.TC_bank_disconnect'. ------ RemsimClient_Tests.TC_bank_disconnect ------ Fri Apr 4 17:17:01 UTC 2025 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/302/artifact/logs/client/testsuite/RemsimClient_Tests.TC_bank_disconnect.pcap"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/302/artifact/logs/client/testsuite/RemsimClient_Tests.TC_bank_disconnect.pcap.stdout> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 MTC@74943110aef6: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-start.sh> RemsimClient_Tests.TC_bank_disconnect' was executed successfully (exit status: 0). MTC@74943110aef6: Test case TC_bank_disconnect started. DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(bankd){REESTABLISH_DELAY}: Destroying existing connection to server DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(server){REESTABLISH_DELAY}: Destroying existing connection to server DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(server){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9998 DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(bankd){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9999 DRSPRO NOTICE ../rspro_client_fsm.c:145 RSPRO_CLIENT(server){REESTABLISH}: RSPRO link to 127.0.0.1:9998 UP DLINP ERROR stream_cli.c:423 CLICONN(bankd,){CONNECTING} connect failed (-111) DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(bankd){REESTABLISH}: RSPRO link to 127.0.0.1:9999 DOWN RSPRO_SRV0(15)@74943110aef6: Established a new IPA connection (conn_id=2) RSPRO_SRV0(15)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } DRSPRO NOTICE ../rspro_client_fsm.c:199 RSPRO_CLIENT(server){ESTABLISHED}: received ID_GET for unit ID 0/0/0 RSPRO_SRV0(15)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_PING (0), u := omit } RSPRO_SRV0(15)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_PONG (1), u := omit } RSPRO_SRV0(15)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } } } RSPRO_SRV0(15)@74943110aef6: IPA ID RESP: { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } MTC@74943110aef6: Warning: Re-starting timer g_rspro_srv_Tguard, which is already active (running or expired). RSPRO_SRV0(15)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } RSPRO_SRV0(15)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } DMAIN ERROR ../rspro_client_fsm.c:378 CLIENT_MAIN(main){WAIT_BANKD}: Event MF_E_SRVC_CONNECTED not permitted DMAIN INFO main_fsm.c:249 CLIENT_MAIN(main){WAIT_BANKD}: Rx configClientBankReq(127.0.0.1:9999 / B1:0) DMAIN ERROR main_fsm.c:255 CLIENT_MAIN(main){WAIT_BANKD}: transition to state WAIT_BANKD not permitted! DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(bankd){REESTABLISH_DELAY}: Destroying existing connection to server DRSPRO INFO ../rspro_client_fsm.c:454 RSPRO_CLIENT(bankd){REESTABLISH}: Creating TCP connection to server at 127.0.0.1:9999 DRSPRO NOTICE ../rspro_client_fsm.c:145 RSPRO_CLIENT(bankd){REESTABLISH}: RSPRO link to 127.0.0.1:9999 UP RSPRO_SRV1(16)@74943110aef6: Established a new IPA connection (conn_id=2) MTC@74943110aef6: setverdict(pass): none -> pass RSPRO_SRV1(16)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_GET (4), u := { get := { { len := 1, tag := IPAC_IDTAG_UNITNAME (1) }, { len := 1, tag := IPAC_IDTAG_UNITID (8) } } } } DRSPRO NOTICE ../rspro_client_fsm.c:199 RSPRO_CLIENT(bankd){ESTABLISHED}: received ID_GET for unit ID 0/0/0 RSPRO_SRV1(16)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_PING (0), u := omit } RSPRO_SRV1(16)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_PONG (1), u := omit } RSPRO_SRV1(16)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_RESP (5), u := { resp := { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } } } RSPRO_SRV1(16)@74943110aef6: IPA ID RESP: { { len := 19, tag := IPAC_IDTAG_UNITNAME (1), data := '30302D30302D30302D30302D30302D303000'O }, { len := 7, tag := IPAC_IDTAG_UNITID (8), data := '302F302F3000'O } } RSPRO_SRV1(16)@74943110aef6: CCM Tx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } RSPRO_SRV1(16)@74943110aef6: CCM Rx:{ msg_type := IPAC_MSGT_ID_ACK (6), u := omit } SET_ATR: 3b 00 DMAIN INFO main_fsm.c:249 CLIENT_MAIN(main){OPERATIONAL}: Rx configClientBankReq(0.0.0.0:0 / B1:0) DRSPRO INFO ../rspro_client_fsm.c:536 RSPRO_CLIENT(bankd){CONNECTED}: Destroying existing connection to server DRSPRO NOTICE ../rspro_client_fsm.c:154 RSPRO_CLIENT(bankd){CONNECTED}: RSPRO link to 0.0.0.0:0 DOWN DMAIN ERROR ../rspro_client_fsm.c:405 CLIENT_MAIN(main){UNCONFIGURED}: Event MF_E_BANKD_LOST not permitted DRSPRO INFO ../rspro_client_fsm.c:428 RSPRO_CLIENT(bankd){REESTABLISH_DELAY}: Destroying existing connection to server Assert failed stream_cli_close(cli) == false stream_cli.c:1023 RSPRO_SRV1(16)@74943110aef6: IPA: Closed RSPRO_SRV1(16)@74943110aef6: Final verdict of PTC: none Aborted RSPRO_SRV0(15)@74943110aef6: IPA: Closed MTC@74943110aef6: setverdict(fail): pass -> fail reason: "Received unexpected != RPSRO", new component reason: "Received unexpected != RPSRO" RSPRO_SRV0(15)@74943110aef6: Final verdict of PTC: none MTC@74943110aef6: Setting final verdict of the test case. MTC@74943110aef6: Local verdict of MTC: fail reason: "Received unexpected != RPSRO" MTC@74943110aef6: Local verdict of PTC RSPRO_SRV0(15): none (fail -> fail) MTC@74943110aef6: Local verdict of PTC RSPRO_SRV1(16): none (fail -> fail) MTC@74943110aef6: Test case TC_bank_disconnect finished. Verdict: fail reason: Received unexpected != RPSRO MTC@74943110aef6: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh> RemsimClient_Tests.TC_bank_disconnect fail'. Fri Apr 4 17:17:10 UTC 2025 ------ RemsimClient_Tests.TC_bank_disconnect fail ------ Waiting for packet dumper to finish... 0 (prev_count=-1, count=4800) [testenv][client] Looking for a coredump [testenv][client] coredumpctl is not available, won't try to get coredump [testenv][client] client unexpected exit during RemsimClient_Tests.TC_bank_disconnect! rc=0 [testenv][client] Waiting until test has stopped... Waiting for packet dumper to finish... 1 (prev_count=4800, count=5536) MTC@74943110aef6: External command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh> RemsimClient_Tests.TC_bank_disconnect fail' was executed successfully (exit status: 0). MTC@74943110aef6: Starting external command `<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-start.sh> RemsimClient_Tests.TC_bank_disconnect_reconnect'. ------ RemsimClient_Tests.TC_bank_disconnect_reconnect ------ Fri Apr 4 17:17:12 UTC 2025 /usr/bin/dumpcap -q -s 1520 -n -i any -w "<https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/302/artifact/logs/client/testsuite/RemsimClient_Tests.TC_bank_disconnect_reconnect.pcap"> ><https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/302/artifact/logs/client/testsuite/RemsimClient_Tests.TC_bank_disconnect_reconnect.pcap.stdout> 2>/tmp/cmderr & Waiting for packet dumper to start... 0 [testenv][client] Stopping podman container [testenv][client] + ['podman', 'kill', 'testenv-remsim-all-osmocom-nightly-asan-20250404-1712-fcbe140d-1'] testenv-remsim-all-osmocom-nightly-asan-20250404-1712-fcbe140d-1 [testenv][client] Stopping testsuite (2689805) [testenv] feed_watchdog_loop: podman container has stopped [testenv][client] Logs saved to: https://jenkins.osmocom.org/jenkins/job/ttcn3-remsim-test-asan/302/artifact…  Build step 'Execute shell' marked build as failure Recording test results [Checks API] No suitable checks publisher found.