See
<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/202/display/redirect>
Changes:
------------------------------------------
[...truncated 16.83 MiB...]
MTC@d63b308baed3: Local verdict of PTC VirtCallAgent-STATS(392): none (pass -> pass)
MTC@d63b308baed3: Local verdict of PTC IPA-CTRL-CLI-IPA(393): none (pass -> pass)
MTC@d63b308baed3: Test case TC_two_crcx_mdcx_and_rtp_osmux_ipv4_ipv6 finished. Verdict:
pass
MTC@d63b308baed3: Starting external command
`<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh>
MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv4_ipv6 pass'.
Wed Oct 2 11:55:16 UTC 2024
[1;32m====== MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv4_ipv6 pass ======[0m
Saving talloc report from 127.0.0.1:4243 to
MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv4_ipv6.talloc
Waiting for packet dumper to finish... 0 (prev_count=-1, count=438504)
Waiting for packet dumper to finish... 1 (prev_count=438504, count=468156)
MTC@d63b308baed3: External command
`<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh>
MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv4_ipv6 pass' was executed successfully
(exit status: 0).
MTC@d63b308baed3: Starting external command
`<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-start.sh>
MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv6_ipv4'.
------ MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv6_ipv4 ------
Wed Oct 2 11:55:18 UTC 2024
/usr/bin/dumpcap -q -s 1520 -n -i any -w
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/202/artifact/logs/testsuite/MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv6_ipv4.pcap">
><https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/202/artifact/logs/testsuite/MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv6_ipv4.pcap.stdout>
2>/tmp/cmderr &
Waiting for packet dumper to start... 0
MTC@d63b308baed3: External command
`<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-start.sh>
MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv6_ipv4' was executed successfully (exit
status: 0).
MTC@d63b308baed3: Test case TC_two_crcx_mdcx_and_rtp_osmux_ipv6_ipv4 started.
[38;5;51m20241002115519625 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #00: DLCX 36094 rtpbridge/2@mgw MGCP 1.0
(mgcp_msg.c:67)[0;m
[38;5;51m20241002115519625 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw (trunk:0) found endpoint: rtpbridge/2@mgw
(mgcp_endp.c:279)[0;m
[38;5;51m20241002115519625 [1;32mDLMGCP[0;m[38;5;51m [1;32mINFO[0;m[38;5;51m
<0013> DLCX: executing request handler "DeleteConnection" for endpoint
resource "rtpbridge/2@mgw" (mgcp_protocol.c:441)[0;m
[38;5;51m20241002115519625 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw DLCX: deleting connection(s) ...
(mgcp_protocol.c:1382)[0;m
[38;5;51m20241002115519625 [1;31mDLMGCP[0;m[38;5;51m [1;31mERROR[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw DLCX: endpoint is not holding a connection.
(mgcp_protocol.c:1399)[0;m
[38;5;51m20241002115519625 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Generated response: code=515
(mgcp_protocol.c:230)[0;m
[38;5;51m20241002115519625 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #00: 515 36094 FAIL (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #00: CRCX 36095 rtpbridge/2@mgw MGCP 1.0
(mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #01: M: recvonly (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #02: C: 1227 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #03: L: p:20, a:AMR (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #04: v=0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #05: o=- 23 42 IN IP6 ::1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #06: s=- (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #07: c=IN IP6 ::1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #08: t=0 0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #09: m=audio 10000 RTP/AVP 112 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #10: a=rtpmap:112 AMR/8000 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #11: a=ptime:20 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw (trunk:0) found endpoint: rtpbridge/2@mgw
(mgcp_endp.c:279)[0;m
[38;5;51m20241002115519629 [1;32mDLMGCP[0;m[38;5;51m [1;32mINFO[0;m[38;5;51m
<0013> CRCX: executing request handler "CreateConnection" for endpoint
resource "rtpbridge/2@mgw" (mgcp_protocol.c:441)[0;m
[38;5;51m20241002115519629 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CRCX: creating new connection ...
(mgcp_protocol.c:881)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw conn:(1227/rtp C:16342088 r=NULL:0<->l=:0)
(mgcp_msg.c:118)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:16342088 connection mode 'recvonly' 1
(mgcp_msg.c:120)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:16342088 output_enabled 0 (mgcp_msg.c:125)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> local CX options: lco->pkt_period_max: 20, lco->codec: AMR
(mgcp_protocol.c:701)[0;m
[38;5;51m20241002115519629 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:16342088 Got media info via SDP: port:10000,
addr:::1, duration:20, payload-types:[0;m[38;5;51m112=AMR[0;m[38;5;51m [0;m[38;5;51m
(mgcp_sdp.c:444)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw conn:(1227/rtp C:16342088 r=::1:10000<->l=:0)
codecs[0]:(pt:112=DYNAMIC, audio:AMR/8000 subt=AMR, rate=8000, ch=1,
t=20/1000)[0;m[38;5;51m [selected][0;m[38;5;51m (mgcp_codec.c:79)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Configuring RTP endpoint: local port 10000
(mgcp_protocol.c:726)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:16342088 CRCX: Creating connection: port: 5944
(mgcp_protocol.c:1112)[0;m
[38;5;51m20241002115519629 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:16342088 CRCX: connection successfully created
(mgcp_protocol.c:1121)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Generated response: code=200
(mgcp_protocol.c:230)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #00: 200 36095 OK (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #01: I: 16342088 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #02: v=0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #03: o=- 16342088 23 IN IP6 ::1
(mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #04: s=- (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #05: c=IN IP6 ::1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #06: t=0 0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #07: m=audio 5944 RTP/AVP 112 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #08: a=rtpmap:112 AMR/8000 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519629 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #09: a=ptime:20 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #00: CRCX 36096 rtpbridge/2@mgw MGCP 1.0
(mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #01: M: recvonly (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #02: C: 1227 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #03: L: p:20, a:AMR (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #04: X-OSMUX: 2 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #05: v=0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #06: o=- 23 42 IN IP4 127.0.0.1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #07: s=- (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #08: c=IN IP4 127.0.0.1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #09: t=0 0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #10: m=audio 1985 RTP/AVP 110 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #11: a=rtpmap:110 AMR/8000 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #12: a=ptime:20 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw (trunk:0) found endpoint: rtpbridge/2@mgw
(mgcp_endp.c:279)[0;m
[38;5;51m20241002115519631 [1;32mDLMGCP[0;m[38;5;51m [1;32mINFO[0;m[38;5;51m
<0013> CRCX: executing request handler "CreateConnection" for endpoint
resource "rtpbridge/2@mgw" (mgcp_protocol.c:441)[0;m
[38;5;51m20241002115519631 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CRCX: creating new connection ...
(mgcp_protocol.c:881)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> MGCP client offered Osmux CID 2 (mgcp_msg.c:207)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw conn:(1227/rtp C:E23B81FD r=NULL:0<->l=:0)
(mgcp_msg.c:118)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:E23B81FD connection mode 'recvonly' 1
(mgcp_msg.c:120)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:E23B81FD output_enabled 0 (mgcp_msg.c:125)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> local CX options: lco->pkt_period_max: 20, lco->codec: AMR
(mgcp_protocol.c:701)[0;m
[38;5;51m20241002115519631 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:E23B81FD Got media info via SDP: port:1985,
addr:127.0.0.1, duration:20, payload-types:[0;m[38;5;51m110=AMR[0;m[38;5;51m
[0;m[38;5;51m (mgcp_sdp.c:444)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw conn:(1227/rtp C:E23B81FD
r=127.0.0.1:1985<->l=:0 CID=16) codecs[0]:(pt:110=DYNAMIC, audio:AMR/8000 subt=AMR,
rate=8000, ch=1, t=20/1000)[0;m[38;5;51m [selected][0;m[38;5;51m
(mgcp_codec.c:79)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Configuring RTP endpoint: local port 1985
(mgcp_protocol.c:726)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:E23B81FD CRCX: Creating connection: port: 5946
(mgcp_protocol.c:1112)[0;m
[38;5;51m20241002115519631 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:E23B81FD CRCX: connection successfully created
(mgcp_protocol.c:1121)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Generated response: code=200
(mgcp_protocol.c:230)[0;m
[38;5;51m20241002115519631 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #00: 200 36096 OK (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519632 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #01: I: E23B81FD (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519632 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #02: X-Osmux: 16 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519632 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #03: v=0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519632 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #04: o=- E23B81FD 23 IN IP4 127.0.0.1
(mgcp_msg.c:67)[0;m
[38;5;51m20241002115519632 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #05: s=- (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519632 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #06: c=IN IP4 127.0.0.1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519632 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #07: t=0 0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519632 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #08: m=audio 1984 RTP/AVP 110 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519632 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #09: a=rtpmap:110 AMR/8000 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115519632 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #10: a=ptime:20 (mgcp_msg.c:67)[0;m
RTPEM0(394)@d63b308baed3: Warning: Re-starting timer T_transmit, which is already active
(running or expired).
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #00: MDCX 36097 rtpbridge/2@mgw MGCP 1.0
(mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #01: M: sendrecv (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #02: C: 1227 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #03: I: 16342088 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #04: L: p:20, a:AMR (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #05: v=0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #06: o=- 23 42 IN IP6 ::1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #07: s=- (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #08: c=IN IP6 ::1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #09: t=0 0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #10: m=audio 10000 RTP/AVP 112 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #11: a=rtpmap:112 AMR/8000 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #12: a=ptime:20 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw (trunk:0) found endpoint: rtpbridge/2@mgw
(mgcp_endp.c:279)[0;m
[38;5;51m20241002115521138 [1;32mDLMGCP[0;m[38;5;51m [1;32mINFO[0;m[38;5;51m
<0013> MDCX: executing request handler "ModifiyConnection" for endpoint
resource "rtpbridge/2@mgw" (mgcp_protocol.c:441)[0;m
[38;5;51m20241002115521138 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw MDCX: modifying existing connection ...
(mgcp_protocol.c:1155)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw conn:(1227/rtp C:16342088
r=::1:10000<->l=::1:5944) (mgcp_msg.c:118)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:16342088 connection mode 'sendrecv' 3
(mgcp_msg.c:120)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:16342088 output_enabled 1 (mgcp_msg.c:125)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> local CX options: lco->pkt_period_max: 20, lco->codec: AMR
(mgcp_protocol.c:701)[0;m
[38;5;51m20241002115521138 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:16342088 Got media info via SDP: port:10000,
addr:::1, duration:20, payload-types:[0;m[38;5;51m112=AMR[0;m[38;5;51m [0;m[38;5;51m
(mgcp_sdp.c:444)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw conn:(1227/rtp C:16342088
r=::1:10000<->l=::1:5944) codecs[0]:(pt:112=DYNAMIC, audio:AMR/8000 subt=AMR,
rate=8000, ch=1, t=20/1000)[0;m[38;5;51m [selected][0;m[38;5;51m
(mgcp_codec.c:79)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Configuring RTP endpoint: local port 10000
(mgcp_protocol.c:726)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:16342088 MDCX: modified conn:(1227/rtp C:16342088
r=::1:10000<->l=::1:5944) (mgcp_protocol.c:1338)[0;m
[38;5;51m20241002115521138 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:16342088 MDCX: connection successfully modified
(mgcp_protocol.c:1351)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Generated response: code=200
(mgcp_protocol.c:230)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #00: 200 36097 OK (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #01: v=0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #02: o=- 16342088 23 IN IP6 ::1
(mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #03: s=- (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #04: c=IN IP6 ::1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #05: t=0 0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #06: m=audio 5944 RTP/AVP 112 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #07: a=rtpmap:112 AMR/8000 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521138 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #08: a=ptime:20 (mgcp_msg.c:67)[0;m
OsmuxEM(397)@d63b308baed3: Warning: Re-starting timer T_transmit, which is already active
(running or expired).
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #00: MDCX 36098 rtpbridge/2@mgw MGCP 1.0
(mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #01: M: sendrecv (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #02: C: 1227 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #03: I: E23B81FD (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #04: L: p:20, a:AMR (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #05: X-OSMUX: 2 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #06: v=0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #07: o=- 23 42 IN IP4 127.0.0.1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #08: s=- (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #09: c=IN IP4 127.0.0.1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #10: t=0 0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #11: m=audio 1985 RTP/AVP 110 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #12: a=rtpmap:110 AMR/8000 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #13: a=ptime:20 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw (trunk:0) found endpoint: rtpbridge/2@mgw
(mgcp_endp.c:279)[0;m
[38;5;51m20241002115521642 [1;32mDLMGCP[0;m[38;5;51m [1;32mINFO[0;m[38;5;51m
<0013> MDCX: executing request handler "ModifiyConnection" for endpoint
resource "rtpbridge/2@mgw" (mgcp_protocol.c:441)[0;m
[38;5;51m20241002115521642 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw MDCX: modifying existing connection ...
(mgcp_protocol.c:1155)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> MGCP client offered Osmux CID 2 (mgcp_msg.c:207)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw conn:(1227/rtp C:E23B81FD
r=127.0.0.1:1985<->l=127.0.0.1:5946 CID=16) (mgcp_msg.c:118)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:E23B81FD connection mode 'sendrecv' 3
(mgcp_msg.c:120)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:E23B81FD output_enabled 1 (mgcp_msg.c:125)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> local CX options: lco->pkt_period_max: 20, lco->codec: AMR
(mgcp_protocol.c:701)[0;m
[38;5;51m20241002115521642 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:E23B81FD Got media info via SDP: port:1985,
addr:127.0.0.1, duration:20, payload-types:[0;m[38;5;51m110=AMR[0;m[38;5;51m
[0;m[38;5;51m (mgcp_sdp.c:444)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw conn:(1227/rtp C:E23B81FD
r=127.0.0.1:1985<->l=127.0.0.1:5946 CID=16) codecs[0]:(pt:110=DYNAMIC,
audio:AMR/8000 subt=AMR, rate=8000, ch=1, t=20/1000)[0;m[38;5;51m
[selected][0;m[38;5;51m (mgcp_codec.c:79)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Configuring RTP endpoint: local port 1985
(mgcp_protocol.c:726)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:E23B81FD MDCX: modified conn:(1227/rtp C:E23B81FD
r=127.0.0.1:1985<->l=127.0.0.1:5946 CID=16) (mgcp_protocol.c:1338)[0;m
[38;5;51m20241002115521642 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw CI:E23B81FD MDCX: connection successfully modified
(mgcp_protocol.c:1351)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Generated response: code=200
(mgcp_protocol.c:230)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #00: 200 36098 OK (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #01: X-Osmux: 16 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #02: v=0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #03: o=- E23B81FD 23 IN IP4 127.0.0.1
(mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #04: s=- (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #05: c=IN IP4 127.0.0.1 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #06: t=0 0 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #07: m=audio 1984 RTP/AVP 110 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #08: a=rtpmap:110 AMR/8000 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115521642 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #09: a=ptime:20 (mgcp_msg.c:67)[0;m
MTC@d63b308baed3: stats: { num_pkts_tx := 196, bytes_payload_tx := 3332, num_pkts_rx :=
115, bytes_payload_rx := 1955, num_pkts_rx_err_seq := 0, num_pkts_rx_err_ts := 0,
num_pkts_rx_err_pt := 0, num_pkts_rx_err_disabled := 0, num_pkts_rx_err_payload := 0 }
MTC@d63b308baed3: stats: { num_pkts_tx := 41, bytes_payload_tx := 2460, num_pkts_rx := 24,
bytes_payload_rx := 1440, num_pkts_rx_err_seq := 0, num_pkts_rx_err_disabled := 0,
num_pkts_rx_err_payload := 0 }
[38;5;51m20241002115523752 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #00: DLCX 36099 rtpbridge/2@mgw MGCP 1.0
(mgcp_msg.c:67)[0;m
[38;5;51m20241002115523752 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Received message: line #01: C: 1227 (mgcp_msg.c:67)[0;m
[38;5;51m20241002115523752 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw (trunk:0) found endpoint: rtpbridge/2@mgw
(mgcp_endp.c:279)[0;m
[38;5;51m20241002115523752 [1;32mDLMGCP[0;m[38;5;51m [1;32mINFO[0;m[38;5;51m
<0013> DLCX: executing request handler "DeleteConnection" for endpoint
resource "rtpbridge/2@mgw" (mgcp_protocol.c:441)[0;m
[38;5;51m20241002115523752 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw DLCX: deleting connection(s) ...
(mgcp_protocol.c:1382)[0;m
[38;5;51m20241002115523752 [1;33mDLMGCP[0;m[38;5;51m [1;33mNOTICE[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw DLCX: missing ci (connectionIdentifier), will remove
all connections (2 total) at once (mgcp_protocol.c:1477)[0;m
[38;5;51m20241002115523752 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Releasing endpoint (mgcp_endp.c:662)[0;m
[38;5;51m20241002115523752 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Releasing endpoint (mgcp_endp.c:662)[0;m
[38;5;51m20241002115523752 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> endpoint:rtpbridge/2@mgw Generated response: code=200
(mgcp_protocol.c:230)[0;m
[38;5;51m20241002115523752 [1;34mDLMGCP[0;m[38;5;51m [1;34mDEBUG[0;m[38;5;51m
<0013> Generated response: line #00: 200 36099 OK (mgcp_msg.c:67)[0;m
MTC@d63b308baed3: setverdict(pass): none -> pass
OsmuxEM(397)@d63b308baed3: Final verdict of PTC: none
RTPEM2(396)@d63b308baed3: Final verdict of PTC: none
RTPEM0(394)@d63b308baed3: Final verdict of PTC: none
IPA-CTRL-CLI-IPA(399)@d63b308baed3: Final verdict of PTC: none
RTPEM1(395)@d63b308baed3: Final verdict of PTC: none
VirtCallAgent-STATS(398)@d63b308baed3: Final verdict of PTC: none
MTC@d63b308baed3: Setting final verdict of the test case.
MTC@d63b308baed3: Local verdict of MTC: pass
MTC@d63b308baed3: Local verdict of PTC RTPEM0(394): none (pass -> pass)
MTC@d63b308baed3: Local verdict of PTC RTPEM1(395): none (pass -> pass)
MTC@d63b308baed3: Local verdict of PTC RTPEM2(396): none (pass -> pass)
MTC@d63b308baed3: Local verdict of PTC OsmuxEM(397): none (pass -> pass)
MTC@d63b308baed3: Local verdict of PTC VirtCallAgent-STATS(398): none (pass -> pass)
MTC@d63b308baed3: Local verdict of PTC IPA-CTRL-CLI-IPA(399): none (pass -> pass)
MTC@d63b308baed3: Test case TC_two_crcx_mdcx_and_rtp_osmux_ipv6_ipv4 finished. Verdict:
pass
MTC@d63b308baed3: Starting external command
`<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh>
MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv6_ipv4 pass'.
Wed Oct 2 11:55:23 UTC 2024
[1;32m====== MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv6_ipv4 pass ======[0m
Saving talloc report from 127.0.0.1:4243 to
MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv6_ipv4.talloc
Waiting for packet dumper to finish... 0 (prev_count=-1, count=434976)
Waiting for packet dumper to finish... 1 (prev_count=434976, count=472560)
MTC@d63b308baed3: External command
`<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-stop.sh>
MGCP_Test.TC_two_crcx_mdcx_and_rtp_osmux_ipv6_ipv4 pass' was executed successfully
(exit status: 0).
MTC@d63b308baed3: Starting external command
`<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/podman/osmo-ttcn3-hacks/ttcn3-tcpdump-start.sh>
MGCP_Test.TC_two_crcx_mdcx_and_iuup'.
------ MGCP_Test.TC_two_crcx_mdcx_and_iuup ------
Wed Oct 2 11:55:25 UTC 2024
/usr/bin/dumpcap -q -s 1520 -n -i any -w
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/202/artifact/logs/testsuite/MGCP_Test.TC_two_crcx_mdcx_and_iuup.pcap">
><https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/202/artifact/logs/testsuite/MGCP_Test.TC_two_crcx_mdcx_and_iuup.pcap.stdout>
2>/tmp/cmderr &
Waiting for packet dumper to start... 0
Error: can only start exec sessions when their container is running: container state
improper
[1;91m[testenv] podman container crashed![0m
[0;94m[testenv] Testsuite is done[0m
[1;34m[testenv] Stopping testsuite (651799)[0m
[1;34m[testenv] Merging log files[0m
[0;94m[testenv] + ['podman', 'exec', '-e',
'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e',
'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache',>
'-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace',
'-e', 'TERM=dumb', '-e',
'TESTENV_GIT_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/git',>
'-e',
'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_testenv/data/scripts>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/podman/osmo-ttcn3-hacks/mgw>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin',
'-e', 'HOME=/home/osmocom-build', '-t', '-w',
'<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/202/artifact/logs/testsuite',>
'testenv-mgw-osmocom-nightly-20241002-1148-3fb3d642', 'sh', '-c',
'<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/podman/osmo-ttcn3-hacks/log_merge.sh>
MGCP_Test --rm >/dev/null'][0m
Error: no container with name or ID
"testenv-mgw-osmocom-nightly-20241002-1148-3fb3d642" found: no such container
[1;91m[testenv] Command failed unexpectedly[0m
[0;94m[testenv] Command: ['podman', 'exec', '-e',
'CCACHE_DIR=/home/osmocom-build/ccache/testenv', '-e',
'TESTENV_CACHE_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache',>
'-e', 'TESTENV_SRC_DIR=/home/osmocom-build/jenkins/workspace',
'-e', 'TERM=dumb', '-e',
'TESTENV_GIT_DIR=<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/git',>
'-e',
'PATH=<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_testenv/data/scripts>:<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/podman/osmo-ttcn3-hacks/mgw>:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin',
'-e', 'HOME=/home/osmocom-build', '-t', '-w',
'<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/202/artifact/logs/testsuite',>
'testenv-mgw-osmocom-nightly-20241002-1148-3fb3d642', 'sh', '-c',
'<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_cache/podman/osmo-ttcn3-hacks/log_merge.sh>
MGCP_Test --rm >/dev/null'][0m
[0;94m[testenv] Returncode: 125[0m
Traceback (most recent call last):
File
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/./testenv.py",>
line 115, in <module>
main()
File
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/./testenv.py",>
line 104, in main
run()
File
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/./testenv.py",>
line 63, in run
testenv.testsuite.run(cfg)
File
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_testenv/testenv/testsuite.py",>
line 204, in run
merge_log_files(cfg)
File
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_testenv/testenv/testsuite.py",>
line 130, in merge_log_files
testenv.cmd.run(cmd, cwd=cwd)
File
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_testenv/testenv/cmd.py",>
line 93, in run
return testenv.podman.exec_cmd(cmd, check=check, env=env, *args, **kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_testenv/testenv/podman.py",>
line 148, in exec_cmd
testenv.cmd.run(
File
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_testenv/testenv/cmd.py",>
line 110, in run
exit_error_cmd(p, "Command failed unexpectedly")
File
"<https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/ws/_testenv/testenv/cmd.py",>
line 59, in exit_error_cmd
raise RuntimeError("shell command related error, find details right above this
python trace")
RuntimeError: shell command related error, find details right above this python trace
[1;34m[testenv] Logs saved to:
https://jenkins.osmocom.org/jenkins/job/ttcn3-mgw-test-io_uring/202/artifac… [0m
Build step 'Execute shell' marked build as failure
Recording test results
[Checks API] No suitable checks publisher found.