Skip to content

Instantly share code, notes, and snippets.

@andrewvmail

andrewvmail/more-freeswitch.log

Created January 8, 2019 20:49
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save andrewvmail/17da7b823ca6608698581f29a384ea40 to your computer and use it in GitHub Desktop.
Save andrewvmail/17da7b823ca6608698581f29a384ea40 to your computer and use it in GitHub Desktop.
Download ZIP
more-freeswitch.log
Raw
more-freeswitch.log
root@default:/# fs_cli
.=======================================================.
| _____ ____ ____ _ ___ |
| | ___/ ___| / ___| | |_ _| |
| | |_ \___ \ | | | | | | |
| | _| ___) | | |___| |___ | | |
| |_| |____/ \____|_____|___| |
| |
.=======================================================.
| Anthony Minessale II, Ken Rice, |
| Michael Jerris, Travis Cross |
| FreeSWITCH (http://www.freeswitch.org) |
| Paypal Donations Appreciated: paypal@freeswitch.org |
| Brought to you by ClueCon http://www.cluecon.com/ |
.=======================================================.
.=======================================================================================================.
| ____ _ ____ |
| / ___| |_ _ ___ / ___|___ _ __ |
| | | | | | | |/ _ \ | / _ \| '_ \ |
| | |___| | |_| | __/ |__| (_) | | | | |
| \____|_|\__,_|\___|\____\___/|_| |_| |
| |
| _____ _ _ ____ __ |
| |_ _|__| | ___ _ __ | |__ ___ _ __ _ _ / ___|___ _ __ / _| ___ _ __ ___ _ __ ___ ___ |
| | |/ _ \ |/ _ \ '_ \| '_ \ / _ \| '_ \| | | | | | / _ \| '_ \| |_ / _ \ '__/ _ \ '_ \ / __/ _ \ |
| | | __/ | __/ |_) | | | | (_) | | | | |_| | | |__| (_) | | | | _| __/ | | __/ | | | (_| __/ |
| |_|\___|_|\___| .__/|_| |_|\___/|_| |_|\__, | \____\___/|_| |_|_| \___|_| \___|_| |_|\___\___| |
| |_| |___/ |
| _____ _ _ |
| | ____|_ _____ _ __ _ _ / \ _ _ __ _ _ _ ___| |_ |
| | _| \ \ / / _ \ '__| | | | / _ \| | | |/ _` | | | / __| __| |
| | |___ \ V / __/ | | |_| | / ___ \ |_| | (_| | |_| \__ \ |_ |
| |_____| \_/ \___|_| \__, | /_/ \_\__,_|\__, |\__,_|___/\__| |
| |___/ |___/ |
| ____ _ ____ |
| __ ____ ____ __ / ___| |_ _ ___ / ___|___ _ __ ___ ___ _ __ ___ |
| \ \ /\ / /\ \ /\ / /\ \ /\ / / | | | | | | |/ _ \ | / _ \| '_ \ / __/ _ \| '_ ` _ \ |
| \ V V / \ V V / \ V V / _ | |___| | |_| | __/ |__| (_) | | | | _ | (_| (_) | | | | | | |
| \_/\_/ \_/\_/ \_/\_/ (_) \____|_|\__,_|\___|\____\___/|_| |_| (_) \___\___/|_| |_| |_| |
| |
.=======================================================================================================.
Type /help <enter> to see a list of commands
+OK log level [7]
freeswitch@default> fsctl loglevel debug
+OK log level: DEBUG [7]
tport.c:2773 tport_wakeup() tport_wakeup(0x7f15840293d0): events IN
tport.c:2864 tport_recv_event() tport_recv_event(0x7f15840293d0)
tport.c:2157 tport_shutdown0() tport_shutdown0(0x7f15840293d0, 2)
tport.c:2090 tport_close() tport_close(0x7f15840293d0): tcp/192.168.99.1:63218/sip
tport.c:2263 tport_set_secondary_timer() tport(0x7f15840293d0): set timer at 0 ms because zap
tport.c:2749 tport_wakeup_pri() tport_wakeup_pri(0x7f1584004990): events IN
tport.c:862 tport_alloc_secondary() tport_alloc_secondary(0x7f1584004990): new secondary tport 0x7f1584037bf0
tport_type_tcp.c:203 tport_tcp_init_secondary() tport_tcp_init_secondary(0x7f1584037bf0): Setting TCP_KEEPIDLE to 30
tport_type_tcp.c:209 tport_tcp_init_secondary() tport_tcp_init_secondary(0x7f1584037bf0): Setting TCP_KEEPINTVL to 30
tport.c:2640 tport_accept() tport_accept(0x7f1584037bf0): new connection from tcp/192.168.99.1:60678/sip
tport.c:2773 tport_wakeup() tport_wakeup(0x7f1584037bf0): events IN
tport.c:2864 tport_recv_event() tport_recv_event(0x7f1584037bf0)
tport.c:3205 tport_recv_iovec() tport_recv_iovec(0x7f1584037bf0) msg 0x7f158403c5c0 from (tcp/192.168.99.1:60678) has 4047 bytes, veclen = 1
recv 4047 bytes from tcp/[192.168.99.1]:60678 at 20:48:28.274993:
------------------------------------------------------------------------
INVITE sip:drachtio@192.168.99.100:5080 SIP/2.0
Via: SIP/2.0/TCP 192.168.99.1:5040;branch=z9hG4bKBK39rrj17Nj0H
Max-Forwards: 70
From: <sip:192.168.99.1:5040>;tag=cvv2SS420gSaB
To: <sip:drachtio@192.168.99.100:5080>
Call-ID: 9791b2ff-8e29-1237-a5af-7dfd20b821e9
CSeq: 133154190 INVITE
Contact: <sip:192.168.99.1:5040>
User-Agent: drachtio-fsmrf:aac78de1-3408-4b27-8451-bb0ab95f0327
Content-Type: application/sdp
Content-Length: 3565
X-esl-outbound: 175.25.50.117:60490
v=0
o=- 8365008793010879322 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS AtPOtx7b4pT7TwWcYo3ykOHxgmqhN8UfXZ0N
m=audio 61694 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 206.116.9.145
a=rtcp:52456 IN IP4 206.116.9.145
a=candidate:2218435994 1 udp 2122260223 192.168.99.1 62616 typ host generation 0 network-id 4 network-cost 50
a=candidate:1364794483 1 udp 2122194687 169.254.62.57 54545 typ host generation 0 network-id 2
a=candidate:3845939934 1 udp 2122129151 175.25.50.118 61694 typ host generation 0 network-id 3
a=candidate:3177149064 1 udp 2122063615 175.25.50.117 62073 typ host generation 0 network-id 1 network-cost 10
a=candidate:2218435994 2 udp 2122260222 192.168.99.1 57615 typ host generation 0 network-id 4 network-cost 50
a=candidate:1364794483 2 udp 2122194686 169.254.62.57 62001 typ host generation 0 network-id 2
a=candidate:3845939934 2 udp 2122129150 175.25.50.118 52456 typ host generation 0 network-id 3
a=candidate:3177149064 2 udp 2122063614 175.25.50.117 49607 typ host generation 0 network-id 1 network-cost 10
a=candidate:1685349482 1 udp 1685921535 206.116.9.145 61694 typ srflx raddr 175.25.50.118 rport 61694 generation 0 network-id 3
a=candidate:1685349482 2 udp 1685921534 206.116.9.145 52456 typ srflx raddr 175.25.50.118 rport 52456 generation 0 network-id 3
a=candidate:1008170044 1 udp 1685855999 206.116.9.145 62073 typ srflx raddr 175.25.50.117 rport 62073 generation 0 network-id 1 network-cost 10
a=candidate:1008170044 2 udp 1685855998 206.116.9.145 49607 typ srflx raddr 175.25.50.117 rport 49607 generation 0 network-id 1 network-cost 10
a=candidate:3401144682 1 tcp 1518280447 192.168.99.1 9 typ host tcptype active generation 0 network-id 4 network-cost 50
a=candidate:534438019 1 tcp 1518214911 169.254.62.57 9 typ host tcptype active generation 0 network-id 2
a=candidate:2881461806 1 tcp 1518149375 175.25.50.118 9 typ host tcptype active generation 0 network-id 3
a=candidate:4091317880 1 tcp 1518083839 175.25.50.117 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=candidate:3401144682 2 tcp 1518280446 192.168.99.1 9 typ host tcptype active generation 0 network-id 4 network-cost 50
a=candidate:534438019 2 tcp 1518214910 169.254.62.57 9 typ host tcptype active generation 0 network-id 2
a=candidate:2881461806 2 tcp 1518149374 175.25.50.118 9 typ host tcptype active generation 0 network-id 3
a=candidate:4091317880 2 tcp 1518083838 175.25.50.117 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=ice-ufrag:VMvy
a=ice-pwd:3Waamfjn5CQRrRsiIE5s7k0T
a=ice-options:trickle
a=fingerprint:sha-256 47:C6:32:D2:9C:8A:06:85:33:48:98:72:BD:D1:44:1F:B3:AE:E6:CD:65:92:E5:7E:F9:61:1D:0F:D4:DC:40:13
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=sendrecv
a=rtcp-mux
a=rtpmap:111 opus/48000/2
a=rtcp-fb:111 transport-cc
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=ssrc:2696873829 cname:IFcIJxUVVf6BQcPn
a=ssrc:2696873829 msid:AtPOtx7b4pT7TwWcYo3ykOHxgmqhN8UfXZ0N d3cc3ecf-82fe-4c92-a36e-c5e1407af272
a=ssrc:2696873829 mslabel:AtPOtx7b4pT7TwWcYo3ykOHxgmqhN8UfXZ0N
a=ssrc:2696873829 label:d3cc3ecf-82fe-4c92-a36e-c5e1407af272
------------------------------------------------------------------------
tport.c:3023 tport_deliver() tport_deliver(0x7f1584037bf0): msg 0x7f158403c5c0 (4047 bytes) from tcp/192.168.99.1:60678/sip next=(nil)
nta.c:2880 agent_recv_request() nta: received INVITE sip:drachtio@192.168.99.100:5080 SIP/2.0 (CSeq 133154190)
nta.c:3248 agent_aliases() nta: canonizing sip:drachtio@192.168.99.100:5080 with contact
nta.c:3085 agent_recv_request() nta: INVITE (133154190) going to a default leg
nta.c:1350 set_timeout() nta: timer set to 2000 ms
nua_server.c:102 nua_stack_process_request() nua: nua_stack_process_request: entering
nua_stack.c:899 nh_create() nua: nh_create: entering
nua_common.c:108 nh_create_handle() nua: nh_create_handle: entering
nua_params.c:480 nua_stack_set_params() nua: nua_stack_set_params: entering
soa.c:280 soa_clone() soa_clone(static::0x7f1584001930, 0x7f1584001130, 0x7f1584032a10) called
soa.c:403 soa_set_params() soa_set_params(static::0x7f15840332f0, ...) called
nta.c:4417 nta_leg_tcreate() nta_leg_tcreate(0x7f15840339f0)
soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::0x7f15840332f0) called
soa.c:1171 soa_set_remote_sdp() soa_set_remote_sdp(static::0x7f15840332f0, (nil), 0x7f1584029fe2, 3565) called
nua_dialog.c:338 nua_dialog_usage_add() nua(0x7f1584032a10): adding session usage
tport.c:3257 tport_tsend() tport_tsend(0x7f1584037bf0) tpn = TCP/192.168.99.1:60678
tport.c:3594 tport_vsend() tport_vsend(0x7f1584037bf0): 303 bytes of 303 to tcp/192.168.99.1:60678
tport.c:3492 tport_send_msg() tport_vsend returned 303
send 303 bytes to tcp/[192.168.99.1]:60678 at 20:48:28.275534:
------------------------------------------------------------------------
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 192.168.99.1:5040;branch=z9hG4bKBK39rrj17Nj0H;rport=60678
From: <sip:192.168.99.1:5040>;tag=cvv2SS420gSaB
To: <sip:drachtio@192.168.99.100:5080>
Call-ID: 9791b2ff-8e29-1237-a5af-7dfd20b821e9
CSeq: 133154190 INVITE
User-Agent: drachtio MRF
Content-Length: 0
------------------------------------------------------------------------
tport.c:2296 tport_set_secondary_timer() tport(0x7f1584037bf0): reset timer
nta.c:6791 incoming_reply() nta: sent 100 Trying for INVITE (133154190)
nua_stack.c:271 nua_stack_event() nua(0x7f1584032a10): event i_invite 100 Trying
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
nua.c:342 nua_handle_bind() nua: nua_handle_bind: entering
2019-01-08 20:33:05.950567 [NOTICE] switch_channel.c:1104 New Channel sofia/drachtio_mrf/nobody@192.168.99.1:5040 [c0351426-1386-11e9-a3d6-7da98fe72c43]
nua_session.c:4139 signal_call_state_change() nua(0x7f1584032a10): call state changed: init -> received, received offer
soa.c:1098 soa_get_remote_sdp() soa_get_remote_sdp(static::0x7f15840332f0, [0x7f159e928948], [0x7f159e928950], [(nil)]) called
nua_stack.c:271 nua_stack_event() nua(0x7f1584032a10): event i_state 100 Trying
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
tport.c:2296 tport_set_secondary_timer() tport(0x7f1584037bf0): reset timer
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:584 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Running State Change CS_NEW (Cur 1 Tot 2)
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2019-01-08 20:33:05.950567 [DEBUG] sofia.c:9873 sofia/drachtio_mrf/nobody@192.168.99.1:5040 receiving invite from 192.168.99.1:60678 version: 1.6.20 git 43a9feb 2018-05-07 18:56:11Z 64bit
nua.c:610 nua_set_hparams() nua: nua_set_hparams: entering
nua.c:610 nua_set_hparams() nua: nua_r_set_params with invalid handle (nil)
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2019-01-08 20:33:05.950567 [DEBUG] sofia.c:7084 Channel sofia/drachtio_mrf/nobody@192.168.99.1:5040 entering state [received][100]
2019-01-08 20:33:05.950567 [DEBUG] sofia.c:7094 Remote SDP:
v=0
o=- 8365008793010879322 2 IN IP4 127.0.0.1
s=-
t=0 0
a=group:BUNDLE audio
a=msid-semantic: WMS AtPOtx7b4pT7TwWcYo3ykOHxgmqhN8UfXZ0N
m=audio 61694 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
c=IN IP4 206.116.9.145
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10;useinbandfec=1
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:9 G722/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:110 telephone-event/48000
a=rtpmap:112 telephone-event/32000
a=rtpmap:113 telephone-event/16000
a=rtpmap:126 telephone-event/8000
a=rtcp:52456 IN IP4 206.116.9.145
a=candidate:2218435994 1 udp 2122260223 192.168.99.1 62616 typ host generation 0 network-id 4 network-cost 50
a=candidate:1364794483 1 udp 2122194687 169.254.62.57 54545 typ host generation 0 network-id 2
a=candidate:3845939934 1 udp 2122129151 175.25.50.118 61694 typ host generation 0 network-id 3
a=candidate:3177149064 1 udp 2122063615 175.25.50.117 62073 typ host generation 0 network-id 1 network-cost 10
a=candidate:2218435994 2 udp 2122260222 192.168.99.1 57615 typ host generation 0 network-id 4 network-cost 50
a=candidate:1364794483 2 udp 2122194686 169.254.62.57 62001 typ host generation 0 network-id 2
a=candidate:3845939934 2 udp 2122129150 175.25.50.118 52456 typ host generation 0 network-id 3
a=candidate:3177149064 2 udp 2122063614 175.25.50.117 49607 typ host generation 0 network-id 1 network-cost 10
a=candidate:1685349482 1 udp 1685921535 206.116.9.145 61694 typ srflx raddr 175.25.50.118 rport 61694 generation 0 network-id 3
a=candidate:1685349482 2 udp 1685921534 206.116.9.145 52456 typ srflx raddr 175.25.50.118 rport 52456 generation 0 network-id 3
a=candidate:1008170044 1 udp 1685855999 206.116.9.145 62073 typ srflx raddr 175.25.50.117 rport 62073 generation 0 network-id 1 network-cost 10
a=candidate:1008170044 2 udp 1685855998 206.116.9.145 49607 typ srflx raddr 175.25.50.117 rport 49607 generation 0 network-id 1 network-cost 10
a=candidate:3401144682 1 tcp 1518280447 192.168.99.1 9 typ host tcptype active generation 0 network-id 4 network-cost 50
a=candidate:534438019 1 tcp 1518214911 169.254.62.57 9 typ host tcptype active generation 0 network-id 2
a=candidate:2881461806 1 tcp 1518149375 175.25.50.118 9 typ host tcptype active generation 0 network-id 3
a=candidate:4091317880 1 tcp 1518083839 175.25.50.117 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=candidate:3401144682 2 tcp 1518280446 192.168.99.1 9 typ host tcptype active generation 0 network-id 4 network-cost 50
a=candidate:534438019 2 tcp 1518214910 169.254.62.57 9 typ host tcptype active generation 0 network-id 2
a=candidate:2881461806 2 tcp 1518149374 175.25.50.118 9 typ host tcptype active generation 0 network-id 3
a=candidate:4091317880 2 tcp 1518083838 175.25.50.117 9 typ host tcptype active generation 0 network-id 1 network-cost 10
a=ice-ufrag:VMvy
a=ice-pwd:3Waamfjn5CQRrRsiIE5s7k0T
a=ice-options:trickle
a=fingerprint:sha-256 47:C6:32:D2:9C:8A:06:85:33:48:98:72:BD:D1:44:1F:B3:AE:E6:CD:65:92:E5:7E:F9:61:1D:0F:D4:DC:40:13
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=rtcp-mux
a=rtcp-fb:111 transport-cc
a=ssrc:2696873829 cname:IFcIJxUVVf6BQcPn
a=ssrc:2696873829 msid:AtPOtx7b4pT7TwWcYo3ykOHxgmqhN8UfXZ0N d3cc3ecf-82fe-4c92-a36e-c5e1407af272
a=ssrc:2696873829 mslabel:AtPOtx7b4pT7TwWcYo3ykOHxgmqhN8UfXZ0N
a=ssrc:2696873829 label:d3cc3ecf-82fe-4c92-a36e-c5e1407af272
2019-01-08 20:33:05.950567 [DEBUG] sofia.c:7486 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State Change CS_NEW -> CS_INIT
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:603 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State NEW
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:584 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Running State Change CS_INIT (Cur 1 Tot 2)
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:627 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State INIT
2019-01-08 20:33:05.950567 [DEBUG] mod_sofia.c:90 sofia/drachtio_mrf/nobody@192.168.99.1:5040 SOFIA INIT
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:40 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Standard INIT
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:48 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State Change CS_INIT -> CS_ROUTING
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:627 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State INIT going to sleep
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:584 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Running State Change CS_ROUTING (Cur 1 Tot 2)
2019-01-08 20:33:05.950567 [DEBUG] switch_channel.c:2249 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Callstate Change DOWN -> RINGING
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:643 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State ROUTING
2019-01-08 20:33:05.950567 [DEBUG] mod_sofia.c:143 sofia/drachtio_mrf/nobody@192.168.99.1:5040 SOFIA ROUTING
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:236 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Standard ROUTING
2019-01-08 20:33:05.950567 [INFO] mod_dialplan_xml.c:637 Processing unknown <>->drachtio in context mrf
Dialplan: sofia/drachtio_mrf/nobody@192.168.99.1:5040 parsing [mrf->socket] continue=false
Dialplan: sofia/drachtio_mrf/nobody@192.168.99.1:5040 Regex (PASS) [socket] ${sip_user_agent}(drachtio-fsmrf:aac78de1-3408-4b27-8451-bb0ab95f0327) =~ /^drachtio-fsmrf:(.*)$/ break=on-false
Dialplan: sofia/drachtio_mrf/nobody@192.168.99.1:5040 Action socket(${sip_h_X-esl-outbound} async full)
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:286 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State Change CS_ROUTING -> CS_EXECUTE
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:643 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State ROUTING going to sleep
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:584 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Running State Change CS_EXECUTE (Cur 1 Tot 2)
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:650 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State EXECUTE
2019-01-08 20:33:05.950567 [DEBUG] mod_sofia.c:198 sofia/drachtio_mrf/nobody@192.168.99.1:5040 SOFIA EXECUTE
2019-01-08 20:33:05.950567 [DEBUG] switch_core_state_machine.c:328 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Standard EXECUTE
EXECUTE sofia/drachtio_mrf/nobody@192.168.99.1:5040 socket(175.25.50.117:60490 async full)
2019-01-08 20:33:05.950567 [NOTICE] mod_event_socket.c:447 Trying host: 175.25.50.117:60490
2019-01-08 20:33:06.011046 [DEBUG] switch_ivr.c:623 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Command Execute answer()
EXECUTE sofia/drachtio_mrf/nobody@192.168.99.1:5040 answer()
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:111:48000:20:0:1]/[PCMU:0:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:111:48000:20:0:1]/[opus:116:48000:20:0:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:111:48000:20:0:1]/[SPEEX:99:32000:20:44000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [opus:111:48000:20:0:1]/[PCMA:8:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMU:0:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[opus:116:48000:20:0:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[SPEEX:99:32000:20:44000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[PCMA:8:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[PCMU:0:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[opus:116:48000:20:0:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[SPEEX:99:32000:20:44000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[PCMA:8:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[SPEEX:99:32000:20:44000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[SPEEX:99:32000:20:44000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[SPEEX:99:32000:20:44000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [CN:105:16000:20:0:1]/[PCMU:0:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [CN:105:16000:20:0:1]/[opus:116:48000:20:0:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [CN:105:16000:20:0:1]/[SPEEX:99:32000:20:44000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [CN:105:16000:20:0:1]/[PCMA:8:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [CN:13:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [CN:13:8000:20:0:1]/[opus:116:48000:20:0:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [CN:13:8000:20:0:1]/[SPEEX:99:32000:20:44000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [CN:13:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 110@48000
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3061 Set Codec sofia/drachtio_mrf/nobody@192.168.99.1:5040 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
2019-01-08 20:33:06.011046 [DEBUG] switch_core_codec.c:111 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Original read codec set to PCMU:0
2019-01-08 20:33:06.011046 [WARNING] switch_core_media.c:3451 NO candidate ACL defined, Defaulting to wan.auto
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.99.1:62616
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 1 proto: udp type: host addr: 169.254.62.57:54545
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 1 proto: udp type: host addr: 175.25.50.118:61694
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 1 proto: udp type: host addr: 175.25.50.117:62073
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 2 proto: udp type: host addr: 192.168.99.1:57615
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 2 proto: udp type: host addr: 169.254.62.57:62001
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 2 proto: udp type: host addr: 175.25.50.118:52456
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 2 proto: udp type: host addr: 175.25.50.117:49607
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 1 proto: udp type: srflx addr: 206.116.9.145:61694
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 2 proto: udp type: srflx addr: 206.116.9.145:52456
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 1 proto: udp type: srflx addr: 206.116.9.145:62073
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3481 Save audio Candidate cid: 2 proto: udp type: srflx addr: 206.116.9.145:49607
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3523 Searching for rtp candidate.
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3528 Choose rtp candidate, index 2, 175.25.50.118:61694
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3301 sofia/drachtio_mrf/nobody@192.168.99.1:5040 choosing family v4
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3539 Choose same candidate, index 6, for rtcp based on rtcp-mux attribute 175.25.50.118:61694
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3586 setting remote audio ice addr to index 2 175.25.50.118:61694 based on candidate
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:3618 Setting remote rtcp audio addr to 175.25.50.118:61694 based on candidate
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 126@8000
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:4767 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Set 2833 dtmf send payload to 126 recv payload to 126
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/drachtio_mrf/nobody@192.168.99.1:5040] 192.168.99.100 port 19666 -> 175.25.50.118 port 61694 codec: 0 ms: 20
2019-01-08 20:33:06.011046 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
2019-01-08 20:33:06.011046 [INFO] switch_core_media.c:7055 Activating Audio ICE
2019-01-08 20:33:06.011046 [NOTICE] switch_rtp.c:4636 Activating RTP audio ICE: VMvy:tQcVUk1f3Nw6WzPl 175.25.50.118:61694
2019-01-08 20:33:06.011046 [DEBUG] switch_core_media.c:7096 Activating RTCP PORT 61694
2019-01-08 20:33:06.011046 [DEBUG] switch_rtp.c:4533 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 61694
2019-01-08 20:33:06.011046 [INFO] switch_core_media.c:7107 Skipping RTCP ICE (Same as RTP)
2019-01-08 20:33:06.011046 [INFO] switch_rtp.c:3603 Activate RTP/RTCP audio DTLS client
2019-01-08 20:33:06.050473 [INFO] switch_rtp.c:3752 Changing audio DTLS state from OFF to HANDSHAKE
2019-01-08 20:33:06.050473 [DEBUG] switch_core_media.c:7180 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Set 2833 dtmf send payload to 126
2019-01-08 20:33:06.050473 [DEBUG] switch_core_media.c:7187 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Set 2833 dtmf receive payload to 126
2019-01-08 20:33:06.050473 [DEBUG] switch_core_media.c:7210 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Set rtp dtmf delay to 40
2019-01-08 20:33:06.050473 [NOTICE] sofia_media.c:92 Pre-Answer sofia/drachtio_mrf/nobody@192.168.99.1:5040!
2019-01-08 20:33:06.050473 [DEBUG] switch_channel.c:3474 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Callstate Change RINGING -> EARLY
2019-01-08 20:33:06.050473 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/drachtio_mrf/nobody@192.168.99.1:5040.
2019-01-08 20:33:06.050473 [DEBUG] mod_sofia.c:850 Local SDP sofia/drachtio_mrf/nobody@192.168.99.1:5040:
v=0
o=FreeSWITCH 1546959920 1546959921 IN IP4 192.168.99.100
s=FreeSWITCH
c=IN IP4 192.168.99.100
t=0 0
a=msid-semantic: WMS Qqbu0ePGZhsi1zhC6eFMCehfuSWqcidT
m=audio 19666 UDP/TLS/RTP/SAVPF 0 126
a=rtpmap:0 PCMU/8000
a=rtpmap:126 telephone-event/8000
a=ptime:20
a=sendrecv
a=fingerprint:sha-256 12:CB:FE:24:F0:4E:D1:27:E3:94:D7:A6:F8:97:38:68:8C:CD:65:F0:86:DF:5C:AE:0F:D6:72:57:D3:71:78:9D
a=setup:active
a=rtcp-mux
a=rtcp:19666 IN IP4 192.168.99.100
a=ice-ufrag:tQcVUk1f3Nw6WzPl
a=ice-pwd:ETANCmMtqTcT9njs4meOw5Uq
a=candidate:6012340419 1 udp 659136 192.168.99.100 19666 typ host generation 0
a=end-of-candidates
a=ssrc:3695280252 cname:yedpjTV80dhSDpkz
a=ssrc:3695280252 msid:Qqbu0ePGZhsi1zhC6eFMCehfuSWqcidT a0
a=ssrc:3695280252 mslabel:Qqbu0ePGZhsi1zhC6eFMCehfuSWqcidT
a=ssrc:3695280252 label:Qqbu0ePGZhsi1zhC6eFMCehfuSWqcidTa0
nua.c:879 nua_respond() nua: nua_respond: entering
nua_stack.c:573 nua_stack_signal() nua(0x7f1584032a10): recv signal r_respond 200 OK
nua_params.c:480 nua_stack_set_params() nua: nua_stack_set_params: entering
soa.c:403 soa_set_params() soa_set_params(static::0x7f15840332f0, ...) called
soa.c:1052 soa_set_user_sdp() soa_set_user_sdp(static::0x7f15840332f0, (nil), 0xfaa550, -1) called
soa.c:890 soa_set_capability_sdp() soa_set_capability_sdp(static::0x7f15840332f0, (nil), 0xfaa550, -1) called
nua_session.c:2320 nua_invite_server_respond() nua: nua_invite_server_respond: entering
soa.c:1515 soa_generate_answer() soa_generate_answer(static::0x7f15840332f0) called
soa_static.c:1148 offer_answer_step() soa_static_offer_answer_action(0x7f15840332f0, soa_generate_answer): called
soa_static.c:1189 offer_answer_step() soa_static(0x7f15840332f0, soa_generate_answer): generating local description
soa_static.c:1230 offer_answer_step() soa_static(0x7f15840332f0, soa_generate_answer): upgrade with remote description
soa_static.c:1029 soa_sdp_mode_set() soa_sdp_mode_set(0x7f159e926b80, 0x7f158403c970, ""): called
soa_static.c:1446 offer_answer_step() soa_static(0x7f15840332f0, soa_generate_answer): storing local description
soa.c:1730 soa_activate() soa_activate(static::0x7f15840332f0, (nil)) called
soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::0x7f15840332f0, [(nil)], [0x7f159e928cb8], [0x7f159e928cb4]) called
tport.c:3257 tport_tsend() tport_tsend(0x7f1584037bf0) tpn = TCP/192.168.99.1:60678
tport.c:3594 tport_vsend() tport_vsend(0x7f1584037bf0): 1565 bytes of 1565 to tcp/192.168.99.1:60678
tport.c:3492 tport_send_msg() tport_vsend returned 1565
send 1565 bytes to tcp/[192.168.99.1]:60678 at 20:48:28.368402:
------------------------------------------------------------------------
SIP/2.0 200 OK
Via: SIP/2.0/TCP 192.168.99.1:5040;branch=z9hG4bKBK39rrj17Nj0H;rport=60678
From: <sip:192.168.99.1:5040>;tag=cvv2SS420gSaB
To: <sip:drachtio@192.168.99.100:5080>;tag=y6vSFcB5ag8mK
Call-ID: 9791b2ff-8e29-1237-a5af-7dfd20b821e9
CSeq: 133154190 INVITE
Contact: <sip:drachtio@192.168.99.100:5080;transport=udp>
User-Agent: drachtio MRF
Accept: application/sdp
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: path, replaces
Allow-Events: talk, hold, conference, refer
Content-Type: application/sdp
Content-Disposition: session
Content-Length: 844
Remote-Party-ID: "drachtio" <sip:drachtio@192.168.99.100>;party=calling;privacy=off;screen=no
v=0
o=FreeSWITCH 1546959920 1546959921 IN IP4 192.168.99.100
s=FreeSWITCH
c=IN IP4 192.168.99.100
t=0 0
a=msid-semantic: WMS Qqbu0ePGZhsi1zhC6eFMCehfuSWqcidT
m=audio 19666 UDP/TLS/RTP/SAVPF 0 126
a=rtpmap:0 PCMU/8000
a=rtpmap:126 telephone-event/8000
a=ptime:20
a=fingerprint:sha-256 12:CB:FE:24:F0:4E:D1:27:E3:94:D7:A6:F8:97:38:68:8C:CD:65:F0:86:DF:5C:AE:0F:D6:72:57:D3:71:78:9D
a=setup:active
a=rtcp-mux
a=rtcp:19666 IN IP4 192.168.99.100
a=ice-ufrag:tQcVUk1f3Nw6WzPl
a=ice-pwd:ETANCmMtqTcT9njs4meOw5Uq
a=candidate:6012340419 1 udp 659136 192.168.99.100 19666 typ host generation 0
a=end-of-candidates
a=ssrc:3695280252 cname:yedpjTV80dhSDpkz
a=ssrc:3695280252 msid:Qqbu0ePGZhsi1zhC6eFMCehfuSWqcidT a0
a=ssrc:3695280252 mslabel:Qqbu0ePGZhsi1zhC6eFMCehfuSWqcidT
a=ssrc:3695280252 label:Qqbu0ePGZhsi1zhC6eFMCehfuSWqcidTa0
------------------------------------------------------------------------
tport.c:2296 tport_set_secondary_timer() tport(0x7f1584037bf0): reset timer
nta.c:6791 incoming_reply() nta: sent 200 OK for INVITE (133154190)
nta.c:1348 set_timeout() nta: timer shortened to 500 ms
nua_session.c:4139 signal_call_state_change() nua(0x7f1584032a10): call state changed: received -> completed, sent answer
soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::0x7f15840332f0, [0x7f159e928d68], [0x7f159e928d70], [(nil)]) called
soa.c:616 soa_get_params() soa_get_params(static::0x7f15840332f0, ...) called
nua_stack.c:271 nua_stack_event() nua(0x7f1584032a10): event i_state 200 OK
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
nua_stack.c:529 nua_signal() nua(0x7f1584032a10): sent signal r_respond
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2019-01-08 20:33:06.050473 [DEBUG] sofia.c:7084 Channel sofia/drachtio_mrf/nobody@192.168.99.1:5040 entering state [completed][200]
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
tport.c:2773 tport_wakeup() tport_wakeup(0x7f1584037bf0): events IN
tport.c:2864 tport_recv_event() tport_recv_event(0x7f1584037bf0)
tport.c:3205 tport_recv_iovec() tport_recv_iovec(0x7f1584037bf0) msg 0x7f158403ed20 from (tcp/192.168.99.1:60678) has 338 bytes, veclen = 1
recv 338 bytes from tcp/[192.168.99.1]:60678 at 20:48:28.371957:
------------------------------------------------------------------------
ACK sip:drachtio@192.168.99.100:5080;transport=udp SIP/2.0
Via: SIP/2.0/TCP 192.168.99.1:5040;branch=z9hG4bKcvv2tK344y8jD
Max-Forwards: 70
From: <sip:192.168.99.1:5040>;tag=cvv2SS420gSaB
To: <sip:drachtio@192.168.99.100:5080>;tag=y6vSFcB5ag8mK
Call-ID: 9791b2ff-8e29-1237-a5af-7dfd20b821e9
CSeq: 133154190 ACK
Content-Length: 0
------------------------------------------------------------------------
tport.c:3023 tport_deliver() tport_deliver(0x7f1584037bf0): msg 0x7f158403ed20 (338 bytes) from tcp/192.168.99.1:60678/sip next=(nil)
nta.c:2880 agent_recv_request() nta: received ACK sip:drachtio@192.168.99.100:5080;transport=udp SIP/2.0 (CSeq 133154190)
nta.c:3019 agent_recv_request() nta: ACK (133154190) is going to INVITE (133154190)
nua_session.c:2569 process_ack_or_cancel() nua: process_ack_or_cancel: entering
soa.c:1214 soa_clear_remote_sdp() soa_clear_remote_sdp(static::0x7f15840332f0) called
nua_stack.c:271 nua_stack_event() nua(0x7f1584032a10): event i_ack 200 OK
nua_session.c:4139 signal_call_state_change() nua(0x7f1584032a10): call state changed: completed -> ready
nua_stack.c:271 nua_stack_event() nua(0x7f1584032a10): event i_state 200 OK
nua_stack.c:271 nua_stack_event() nua(0x7f1584032a10): event i_active 200 Call active
nta.c:5744 incoming_free() nta: incoming_free(0x7f1584031150)
tport.c:2296 tport_set_secondary_timer() tport(0x7f1584037bf0): reset timer
tport.c:2296 tport_set_secondary_timer() tport(0x7f1584037bf0): reset timer
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
nua_stack.c:359 nua_application_event() nua: nua_application_event: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2019-01-08 20:33:06.070819 [DEBUG] sofia.c:7084 Channel sofia/drachtio_mrf/nobody@192.168.99.1:5040 entering state [ready][200]
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering
2019-01-08 20:33:06.310609 [INFO] switch_rtp.c:3192 Changing audio DTLS state from HANDSHAKE to SETUP
2019-01-08 20:33:06.310609 [INFO] switch_rtp.c:3101 audio Fingerprint Verified.
2019-01-08 20:33:06.310609 [INFO] switch_rtp.c:3941 Activating audio Secure RTP SEND
2019-01-08 20:33:06.310609 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
2019-01-08 20:33:06.310609 [INFO] switch_rtp.c:3919 Activating audio Secure RTP RECV
2019-01-08 20:33:06.310609 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
2019-01-08 20:33:06.310609 [INFO] switch_rtp.c:3141 Changing audio DTLS state from SETUP to READY
2019-01-08 20:33:06.330475 [NOTICE] mod_dptools.c:1312 Channel [sofia/drachtio_mrf/nobody@192.168.99.1:5040] has been answered
2019-01-08 20:33:06.330475 [DEBUG] switch_channel.c:3773 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Callstate Change EARLY -> ACTIVE
2019-01-08 20:33:06.330475 [DEBUG] switch_ivr.c:623 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Command Execute conference(test++flags{endconf})
EXECUTE sofia/drachtio_mrf/nobody@192.168.99.1:5040 conference(test++flags{endconf})
2019-01-08 20:33:06.330475 [DEBUG] mod_conference.c:3084 using channel sound prefix: /usr/local/freeswitch/sounds/en/us/callie
2019-01-08 20:33:06.350500 [DEBUG] conference_member.c:1693 Raw Codec Activation Success L16@8000hz 1 channel 20ms
2019-01-08 20:33:06.350500 [DEBUG] conference_member.c:1740 Raw Codec Activation Success L16@8000hz 1 channel 20ms
2019-01-08 20:33:06.350500 [DEBUG] switch_core_codec.c:223 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Push codec L16:100
2019-01-08 20:33:06.350500 [ERR] switch_core_video.c:2267 This function is not available, libpng not installed
2019-01-08 20:33:06.350500 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '0' to 'mute'
2019-01-08 20:33:06.350500 [DEBUG] mod_conference.c:220 Setup timer success interval: 20 samples: 160
2019-01-08 20:33:06.350500 [INFO] switch_ivr_async.c:214 Digit parser mod_conference: Setting realm to 'conf'
2019-01-08 20:33:06.350500 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 0/conf/0 callback: 0x7f159cd37a40 data: 0x123dea8
2019-01-08 20:33:06.370668 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '*' to 'deaf mute'
2019-01-08 20:33:06.370668 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding */conf/0 callback: 0x7f159cd37a40 data: 0x123ded8
2019-01-08 20:33:06.370668 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '9' to 'energy up'
2019-01-08 20:33:06.370668 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 9/conf/0 callback: 0x7f159cd37a40 data: 0x123df08
2019-01-08 20:33:06.370668 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '8' to 'energy equ'
2019-01-08 20:33:06.370668 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 8/conf/0 callback: 0x7f159cd37a40 data: 0x123df38
2019-01-08 20:33:06.370668 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '7' to 'energy dn'
2019-01-08 20:33:06.370668 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 7/conf/0 callback: 0x7f159cd37a40 data: 0x123df68
2019-01-08 20:33:06.370668 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '3' to 'vol talk up'
2019-01-08 20:33:06.370668 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 3/conf/0 callback: 0x7f159cd37a40 data: 0x123df98
2019-01-08 20:33:06.370668 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '2' to 'vol talk zero'
2019-01-08 20:33:06.370668 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 2/conf/0 callback: 0x7f159cd37a40 data: 0x123dfc8
2019-01-08 20:33:06.370668 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '1' to 'vol talk dn'
2019-01-08 20:33:06.370668 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 1/conf/0 callback: 0x7f159cd37a40 data: 0x123dff8
2019-01-08 20:33:06.370668 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '6' to 'vol listen up'
2019-01-08 20:33:06.370668 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 6/conf/0 callback: 0x7f159cd37a40 data: 0x123e028
2019-01-08 20:33:06.370668 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '5' to 'vol listen zero'
2019-01-08 20:33:06.370668 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 5/conf/0 callback: 0x7f159cd37a40 data: 0x123e058
2019-01-08 20:33:06.370668 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '4' to 'vol listen dn'
2019-01-08 20:33:06.370668 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 4/conf/0 callback: 0x7f159cd37a40 data: 0x123e088
2019-01-08 20:33:06.370668 [DEBUG] conference_member.c:128 sofia/drachtio_mrf/nobody@192.168.99.1:5040 binding '#' to 'hangup'
2019-01-08 20:33:06.370668 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding #/conf/0 callback: 0x7f159cd37a40 data: 0x123e0b8
2019-01-08 20:33:06.370668 [DEBUG] conference_loop.c:1142 Setup timer soft success interval: 20 samples: 160 from codec PCMU
2019-01-08 20:33:06.410555 [DEBUG] switch_rtp.c:1887 rtcp_stats_init: audio ssrc[2696873829] base_seq[5905]
nta.c:1289 agent_timer() nta: timer not set
2019-01-08 20:33:09.110457 [DEBUG] mod_local_stream.c:871 Opening Stream [moh/8000] 8000hz
2019-01-08 20:33:14.850501 [DEBUG] switch_ivr.c:623 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Command Execute hangup()
EXECUTE sofia/drachtio_mrf/nobody@192.168.99.1:5040 hangup()
2019-01-08 20:33:14.850501 [NOTICE] mod_dptools.c:1286 Hangup sofia/drachtio_mrf/nobody@192.168.99.1:5040 [CS_EXECUTE] [NORMAL_CLEARING]
2019-01-08 20:33:14.850501 [DEBUG] switch_core_session.c:2815 sofia/drachtio_mrf/nobody@192.168.99.1:5040 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2019-01-08 20:33:14.870472 [INFO] conference_loop.c:1471 Channel leaving conference, cause: NORMAL_CLEARING
2019-01-08 20:33:14.870472 [DEBUG] mod_conference.c:2247 sofia/drachtio_mrf/nobody@192.168.99.1:5040 skip receive message [UNBRIDGE] (channel is hungup already)
2019-01-08 20:33:14.870472 [DEBUG] switch_core_media.c:9780 sofia/drachtio_mrf/nobody@192.168.99.1:5040 skip receive message [HARD_MUTE] (channel is hungup already)
2019-01-08 20:33:14.870472 [DEBUG] switch_core_codec.c:248 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Restore previous codec PCMU:0.
2019-01-08 20:33:14.870472 [DEBUG] switch_core_session.c:2815 sofia/drachtio_mrf/nobody@192.168.99.1:5040 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2019-01-08 20:33:14.870472 [DEBUG] switch_ivr.c:666 sofia/drachtio_mrf/nobody@192.168.99.1:5040 skip receive message [AUDIO_SYNC] (channel is hungup already)
2019-01-08 20:33:14.870472 [DEBUG] switch_core_session.c:2815 sofia/drachtio_mrf/nobody@192.168.99.1:5040 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:650 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State EXECUTE going to sleep
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:584 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Running State Change CS_HANGUP (Cur 1 Tot 2)
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:850 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Callstate Change ACTIVE -> HANGUP
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:852 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State HANGUP
2019-01-08 20:33:14.870472 [DEBUG] mod_sofia.c:438 Channel sofia/drachtio_mrf/nobody@192.168.99.1:5040 hanging up, cause: NORMAL_CLEARING
2019-01-08 20:33:14.870472 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/drachtio_mrf/nobody@192.168.99.1:5040
nua.c:645 nua_bye() nua: nua_bye: entering
nua_stack.c:569 nua_stack_signal() nua(0x7f1584032a10): recv signal r_bye
nua_params.c:480 nua_stack_set_params() nua: nua_stack_set_params: entering
soa.c:403 soa_set_params() soa_set_params(static::0x7f15840332f0, ...) called
soa.c:1784 soa_terminate() soa_terminate(static::0x7f15840332f0) called
soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::0x7f15840332f0) called
nta.c:2665 nta_tpn_by_url() nta: selecting scheme sip
tport.c:3257 tport_tsend() tport_tsend(0x7f15840044e0) tpn = UDP/192.168.99.1:5040
tport.c:4046 tport_resolve() tport_resolve addrinfo = 192.168.99.1:5040
tport.c:4680 tport_by_addrinfo() tport_by_addrinfo(0x7f15840044e0): not found by name UDP/192.168.99.1:5040
tport.c:3594 tport_vsend() tport_vsend(0x7f15840044e0): 511 bytes of 511 to udp/192.168.99.1:5040
tport.c:3492 tport_send_msg() tport_vsend returned 511
send 511 bytes to udp/[192.168.99.1]:5040 at 20:48:37.204808:
------------------------------------------------------------------------
BYE sip:192.168.99.1:5040 SIP/2.0
Via: SIP/2.0/UDP 192.168.99.100:5080;rport;branch=z9hG4bKX4DrZmDSZDQaj
Max-Forwards: 70
From: <sip:drachtio@192.168.99.100:5080>;tag=y6vSFcB5ag8mK
To: <sip:192.168.99.1:5040>;tag=cvv2SS420gSaB
Call-ID: 9791b2ff-8e29-1237-a5af-7dfd20b821e9
CSeq: 133154194 BYE
User-Agent: drachtio MRF
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: path, replaces
Reason: Q.850;cause=16;text="NORMAL_CLEARING"
Content-Length: 0
------------------------------------------------------------------------
nta.c:8304 outgoing_send() nta: sent BYE (133154194) to UDP/192.168.99.1:5040
tport.c:4160 tport_pend() tport_pend(0x7f15840044e0): pending 0x7f1584035180 for udp/192.168.99.100:5080 (already 0)
nta.c:1350 set_timeout() nta: timer set to 32000 ms
nta.c:1348 set_timeout() nta: timer shortened to 1000 ms
nua_stack.c:529 nua_signal() nua(0x7f1584032a10): sent signal r_bye
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:60 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Standard HANGUP, cause: NORMAL_CLEARING
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:852 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State HANGUP going to sleep
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:619 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State Change CS_HANGUP -> CS_REPORTING
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:584 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Running State Change CS_REPORTING (Cur 1 Tot 2)
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:938 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State REPORTING
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:174 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Standard REPORTING, cause: NORMAL_CLEARING
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:938 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State REPORTING going to sleep
2019-01-08 20:33:14.870472 [DEBUG] switch_core_state_machine.c:610 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State Change CS_REPORTING -> CS_DESTROY
2019-01-08 20:33:14.870472 [DEBUG] switch_core_session.c:1665 Session 2 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Locked, Waiting on external entities
2019-01-08 20:33:14.870472 [NOTICE] switch_core_session.c:1683 Session 2 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Ended
2019-01-08 20:33:14.870472 [NOTICE] switch_core_session.c:1687 Close Channel sofia/drachtio_mrf/nobody@192.168.99.1:5040 [CS_DESTROY]
2019-01-08 20:33:14.891210 [DEBUG] switch_core_state_machine.c:741 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) Running State Change CS_DESTROY (Cur 0 Tot 2)
2019-01-08 20:33:14.891210 [DEBUG] switch_core_state_machine.c:751 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State DESTROY
2019-01-08 20:33:14.891210 [DEBUG] mod_sofia.c:343 sofia/drachtio_mrf/nobody@192.168.99.1:5040 SOFIA DESTROY
2019-01-08 20:33:14.891210 [DEBUG] switch_core_state_machine.c:181 sofia/drachtio_mrf/nobody@192.168.99.1:5040 Standard DESTROY
2019-01-08 20:33:14.891210 [DEBUG] switch_core_state_machine.c:751 (sofia/drachtio_mrf/nobody@192.168.99.1:5040) State DESTROY going to sleep
2019-01-08 20:33:14.891210 [DEBUG] mod_conference.c:788 Write Lock ON
2019-01-08 20:33:14.891210 [DEBUG] mod_conference.c:791 Write Lock OFF
nta.c:8893 _nta_outgoing_timer() nta: timer E fired, retransmit BYE (133154194)
tport.c:4222 tport_release() tport_release(0x7f15840044e0): 0x7f1584035180 by 0x7f1584040260 with (nil)
tport.c:3257 tport_tsend() tport_tsend(0x7f15840044e0) tpn = UDP/192.168.99.1:5040
tport.c:4046 tport_resolve() tport_resolve addrinfo = 192.168.99.1:5040
tport.c:4680 tport_by_addrinfo() tport_by_addrinfo(0x7f15840044e0): not found by name UDP/192.168.99.1:5040
tport.c:3594 tport_vsend() tport_vsend(0x7f15840044e0): 511 bytes of 511 to udp/192.168.99.1:5040
tport.c:3492 tport_send_msg() tport_vsend returned 511
send 511 bytes to udp/[192.168.99.1]:5040 at 20:48:38.206103:
------------------------------------------------------------------------
BYE sip:192.168.99.1:5040 SIP/2.0
Via: SIP/2.0/UDP 192.168.99.100:5080;rport;branch=z9hG4bKX4DrZmDSZDQaj
Max-Forwards: 70
From: <sip:drachtio@192.168.99.100:5080>;tag=y6vSFcB5ag8mK
To: <sip:192.168.99.1:5040>;tag=cvv2SS420gSaB
Call-ID: 9791b2ff-8e29-1237-a5af-7dfd20b821e9
CSeq: 133154194 BYE
User-Agent: drachtio MRF
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: path, replaces
Reason: Q.850;cause=16;text="NORMAL_CLEARING"
Content-Length: 0
------------------------------------------------------------------------
nta.c:8304 outgoing_send() nta: resent BYE (133154194) to UDP/192.168.99.1:5040
tport.c:4160 tport_pend() tport_pend(0x7f15840044e0): pending 0x7f1584035180 for udp/192.168.99.100:5080 (already 0)
nta.c:8929 _nta_outgoing_timer() nta_outgoing_timer: 1/1 resent, 0/1 tout, 0/0 term, 0/1 free
nta.c:1296 agent_timer() nta: timer set next to 2000 ms
nta.c:8893 _nta_outgoing_timer() nta: timer E fired, retransmit BYE (133154194)
tport.c:4222 tport_release() tport_release(0x7f15840044e0): 0x7f1584035180 by 0x7f1584040260 with (nil)
tport.c:3257 tport_tsend() tport_tsend(0x7f15840044e0) tpn = UDP/192.168.99.1:5040
tport.c:4046 tport_resolve() tport_resolve addrinfo = 192.168.99.1:5040
tport.c:4680 tport_by_addrinfo() tport_by_addrinfo(0x7f15840044e0): not found by name UDP/192.168.99.1:5040
tport.c:3594 tport_vsend() tport_vsend(0x7f15840044e0): 511 bytes of 511 to udp/192.168.99.1:5040
tport.c:3492 tport_send_msg() tport_vsend returned 511
send 511 bytes to udp/[192.168.99.1]:5040 at 20:48:40.206331:
------------------------------------------------------------------------
BYE sip:192.168.99.1:5040 SIP/2.0
Via: SIP/2.0/UDP 192.168.99.100:5080;rport;branch=z9hG4bKX4DrZmDSZDQaj
Max-Forwards: 70
From: <sip:drachtio@192.168.99.100:5080>;tag=y6vSFcB5ag8mK
To: <sip:192.168.99.1:5040>;tag=cvv2SS420gSaB
Call-ID: 9791b2ff-8e29-1237-a5af-7dfd20b821e9
CSeq: 133154194 BYE
User-Agent: drachtio MRF
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: path, replaces
Reason: Q.850;cause=16;text="NORMAL_CLEARING"
Content-Length: 0
------------------------------------------------------------------------
nta.c:8304 outgoing_send() nta: resent BYE (133154194) to UDP/192.168.99.1:5040
tport.c:4160 tport_pend() tport_pend(0x7f15840044e0): pending 0x7f1584035180 for udp/192.168.99.100:5080 (already 0)
nta.c:8929 _nta_outgoing_timer() nta_outgoing_timer: 1/1 resent, 0/1 tout, 0/0 term, 0/1 free
nta.c:1296 agent_timer() nta: timer set next to 4000 ms
nta.c:8893 _nta_outgoing_timer() nta: timer E fired, retransmit BYE (133154194)
tport.c:4222 tport_release() tport_release(0x7f15840044e0): 0x7f1584035180 by 0x7f1584040260 with (nil)
tport.c:3257 tport_tsend() tport_tsend(0x7f15840044e0) tpn = UDP/192.168.99.1:5040
tport.c:4046 tport_resolve() tport_resolve addrinfo = 192.168.99.1:5040
tport.c:4680 tport_by_addrinfo() tport_by_addrinfo(0x7f15840044e0): not found by name UDP/192.168.99.1:5040
tport.c:3594 tport_vsend() tport_vsend(0x7f15840044e0): 511 bytes of 511 to udp/192.168.99.1:5040
tport.c:3492 tport_send_msg() tport_vsend returned 511
send 511 bytes to udp/[192.168.99.1]:5040 at 20:48:44.207350:
------------------------------------------------------------------------
BYE sip:192.168.99.1:5040 SIP/2.0
Via: SIP/2.0/UDP 192.168.99.100:5080;rport;branch=z9hG4bKX4DrZmDSZDQaj
Max-Forwards: 70
From: <sip:drachtio@192.168.99.100:5080>;tag=y6vSFcB5ag8mK
To: <sip:192.168.99.1:5040>;tag=cvv2SS420gSaB
Call-ID: 9791b2ff-8e29-1237-a5af-7dfd20b821e9
CSeq: 133154194 BYE
User-Agent: drachtio MRF
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: path, replaces
Reason: Q.850;cause=16;text="NORMAL_CLEARING"
Content-Length: 0
------------------------------------------------------------------------
nta.c:8304 outgoing_send() nta: resent BYE (133154194) to UDP/192.168.99.1:5040
tport.c:4160 tport_pend() tport_pend(0x7f15840044e0): pending 0x7f1584035180 for udp/192.168.99.100:5080 (already 0)
nta.c:8929 _nta_outgoing_timer() nta_outgoing_timer: 1/1 resent, 0/1 tout, 0/0 term, 0/1 free
nta.c:1296 agent_timer() nta: timer set next to 4001 ms
nta.c:8893 _nta_outgoing_timer() nta: timer E fired, retransmit BYE (133154194)
tport.c:4222 tport_release() tport_release(0x7f15840044e0): 0x7f1584035180 by 0x7f1584040260 with (nil)
tport.c:3257 tport_tsend() tport_tsend(0x7f15840044e0) tpn = UDP/192.168.99.1:5040
tport.c:4046 tport_resolve() tport_resolve addrinfo = 192.168.99.1:5040
tport.c:4680 tport_by_addrinfo() tport_by_addrinfo(0x7f15840044e0): not found by name UDP/192.168.99.1:5040
tport.c:3594 tport_vsend() tport_vsend(0x7f15840044e0): 511 bytes of 511 to udp/192.168.99.1:5040
tport.c:3492 tport_send_msg() tport_vsend returned 511
send 511 bytes to udp/[192.168.99.1]:5040 at 20:48:48.209075:
------------------------------------------------------------------------
BYE sip:192.168.99.1:5040 SIP/2.0
Via: SIP/2.0/UDP 192.168.99.100:5080;rport;branch=z9hG4bKX4DrZmDSZDQaj
Max-Forwards: 70
From: <sip:drachtio@192.168.99.100:5080>;tag=y6vSFcB5ag8mK
To: <sip:192.168.99.1:5040>;tag=cvv2SS420gSaB
Call-ID: 9791b2ff-8e29-1237-a5af-7dfd20b821e9
CSeq: 133154194 BYE
User-Agent: drachtio MRF
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
Supported: path, replaces
Reason: Q.850;cause=16;text="NORMAL_CLEARING"
Content-Length: 0
------------------------------------------------------------------------
nta.c:8304 outgoing_send() nta: resent BYE (133154194) to UDP/192.168.99.1:5040
tport.c:4160 tport_pend() tport_pend(0x7f15840044e0): pending 0x7f1584035180 for udp/192.168.99.100:5080 (already 0)
nta.c:8929 _nta_outgoing_timer() nta_outgoing_timer: 1/1 resent, 0/1 tout, 0/0 term, 0/1 free
nta.c:1296 agent_timer() nta: timer set next to 4000 ms
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment