[Freeswitch-users] Outbound calls being dropped after update to Version 1.6.17 -34-0fc0946 64bit
Charles Bujold
cjbujold at accra.ca
Wed May 3 18:54:26 MSD 2017
<mailto:freeswitch-users at lists.freeswitch.org> Still no solutions, Here is
a log of a call. Any suggestion would be appreciated
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:57.156987 [DEBUG]
sofia.c:7048 Channel sofia/internal/15068559226 entering state [calling][0]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:57.156987 [DEBUG]
switch_core_state_machine.c:643 (sofia/internal/15068559226) State ROUTING
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:57.156987 [DEBUG]
mod_sofia.c:143 sofia/internal/15068559226 SOFIA ROUTING
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:57.156987 [DEBUG]
switch_ivr_originate.c:67 (sofia/internal/15068559226) State Change
CS_ROUTING -> CS_CONSUME_MEDIA
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:57.156987 [DEBUG]
switch_core_state_machine.c:643 (sofia/internal/15068559226) State ROUTING
going to sleep
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:57.156987 [DEBUG]
switch_core_state_machine.c:584 (sofia/internal/15068559226) Running State
Change CS_CONSUME_MEDIA (Cur 2 Tot 136)
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:57.156987 [DEBUG]
switch_core_state_machine.c:662 (sofia/internal/15068559226) State
CONSUME_MEDIA
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:57.156987 [DEBUG]
switch_core_state_machine.c:662 (sofia/internal/15068559226) State
CONSUME_MEDIA going to sleep
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:57.236974 [DEBUG]
sofia.c:7048 Channel sofia/internal/15068559226 entering state [calling][0]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
sofia.c:7048 Channel sofia/internal/15068559226 entering state
[proceeding][183]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
sofia.c:7058 Remote SDP:
3960b42a-6c36-49c9-96a0-a844b3f0f259 v=0
3960b42a-6c36-49c9-96a0-a844b3f0f259 o=FreeSWITCH 1493799827 1493799828 IN
IP4 72.55.158.152
3960b42a-6c36-49c9-96a0-a844b3f0f259 s=FreeSWITCH
3960b42a-6c36-49c9-96a0-a844b3f0f259 c=IN IP4 72.55.158.152
3960b42a-6c36-49c9-96a0-a844b3f0f259 t=0 0
3960b42a-6c36-49c9-96a0-a844b3f0f259 m=audio 22274 RTP/AVP 0 101 13
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=rtpmap:0 PCMU/8000
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=rtpmap:101 telephone-event/8000
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=fmtp:101 0-16
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=rtpmap:13 CN/8000
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=ptime:20
3960b42a-6c36-49c9-96a0-a844b3f0f259
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:4436 Audio Codec Compare
[PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:4491 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++
is saved as a match
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:4436 Audio Codec Compare
[PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:4352 Set telephone-event payload to 101 at 8000
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:3056 Set Codec sofia/internal/15068559226 PCMU/8000 20
ms 160 samples 64000 bits 1 channels
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_codec.c:111 sofia/internal/15068559226 Original read codec set
to PCMU:0
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:4695 Set telephone-event payload to 101 at 8000
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:4754 sofia/internal/15068559226 Set 2833 dtmf send
payload to 101 recv payload to 101
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:6865 AUDIO RTP [sofia/internal/15068559226]
192.168.20.161 port 29764 -> 72.55.158.152 port 22274 codec: 0 ms: 20
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_rtp.c:4096 Starting timer [soft] 160 bytes per 20ms
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:7166 sofia/internal/15068559226 Set 2833 dtmf send
payload to 101
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:7173 sofia/internal/15068559226 Set 2833 dtmf receive
payload to 101
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:7196 sofia/internal/15068559226 Set rtp dtmf delay to 40
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_core_media.c:7202 Set comfort noise payload to 13
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [NOTICE]
sofia_media.c:92 Pre-Answer sofia/internal/15068559226!
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.737079 [DEBUG]
switch_channel.c:3473 (sofia/internal/15068559226) Callstate Change DOWN ->
EARLY
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [DEBUG]
switch_ivr_originate.c:410 Setting codec string on
sofia/internal/200 at 192.168.20.161 to PCMU at 8000h@20i
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [INFO]
switch_ivr_originate.c:3639 Sending early media
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [DEBUG]
switch_core_media.c:6865 AUDIO RTP [sofia/internal/200 at 192.168.20.161]
192.168.20.161 port 16564 -> 192.168.20.150 port 19542 codec: 0 ms: 20
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [DEBUG]
switch_rtp.c:4096 Starting timer [soft] 160 bytes per 20ms
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [DEBUG]
switch_core_media.c:7166 sofia/internal/200 at 192.168.20.161 Set 2833 dtmf
send payload to 101
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [DEBUG]
switch_core_media.c:7173 sofia/internal/200 at 192.168.20.161 Set 2833 dtmf
receive payload to 101
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [DEBUG]
switch_core_media.c:7196 sofia/internal/200 at 192.168.20.161 Set rtp dtmf
delay to 40
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [DEBUG]
mod_sofia.c:2363 Ring SDP:
cc1d0c18-e576-47a6-bf4f-35ab835f920c v=0
cc1d0c18-e576-47a6-bf4f-35ab835f920c o=FreeSWITCH 1493805534 1493805535 IN
IP4 192.168.20.161
cc1d0c18-e576-47a6-bf4f-35ab835f920c s=FreeSWITCH
cc1d0c18-e576-47a6-bf4f-35ab835f920c c=IN IP4 192.168.20.161
cc1d0c18-e576-47a6-bf4f-35ab835f920c t=0 0
cc1d0c18-e576-47a6-bf4f-35ab835f920c m=audio 16564 RTP/AVP 0 101
cc1d0c18-e576-47a6-bf4f-35ab835f920c a=rtpmap:0 PCMU/8000
cc1d0c18-e576-47a6-bf4f-35ab835f920c a=rtpmap:101 telephone-event/8000
cc1d0c18-e576-47a6-bf4f-35ab835f920c a=fmtp:101 0-16
cc1d0c18-e576-47a6-bf4f-35ab835f920c a=ptime:20
cc1d0c18-e576-47a6-bf4f-35ab835f920c a=sendrecv
cc1d0c18-e576-47a6-bf4f-35ab835f920c
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [NOTICE]
mod_sofia.c:2366 Pre-Answer sofia/internal/200 at 192.168.20.161!
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [DEBUG]
switch_channel.c:3473 (sofia/internal/200 at 192.168.20.161) Callstate Change
RINGING -> EARLY
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [DEBUG]
switch_ivr_originate.c:3690 Originate Resulted in Success:
[sofia/internal/15068559226]
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.757038 [DEBUG]
sofia.c:7048 Channel sofia/internal/200 at 192.168.20.161 entering state
[early][183]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.757038 [DEBUG]
switch_ivr_bridge.c:1601 (sofia/internal/15068559226) State Change
CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.757038 [DEBUG]
switch_core_state_machine.c:584 (sofia/internal/15068559226) Running State
Change CS_EXCHANGE_MEDIA (Cur 2 Tot 136)
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.757038 [DEBUG]
switch_core_state_machine.c:653 (sofia/internal/15068559226) State
EXCHANGE_MEDIA
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.757038 [DEBUG]
mod_sofia.c:631 SOFIA EXCHANGE_MEDIA
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:34:58.796985 [DEBUG]
switch_rtp.c:7229 Correct audio ip/port confirmed.
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:34:58.877072 [DEBUG]
switch_rtp.c:7229 Correct audio ip/port confirmed.
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:35:00.317073 [DEBUG]
sofia.c:7048 Channel sofia/internal/15068559226 entering state
[completing][200]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:35:00.317073 [DEBUG]
sofia.c:7055 Duplicate SDP
3960b42a-6c36-49c9-96a0-a844b3f0f259 v=0
3960b42a-6c36-49c9-96a0-a844b3f0f259 o=FreeSWITCH 1493799827 1493799828 IN
IP4 72.55.158.152
3960b42a-6c36-49c9-96a0-a844b3f0f259 s=FreeSWITCH
3960b42a-6c36-49c9-96a0-a844b3f0f259 c=IN IP4 72.55.158.152
3960b42a-6c36-49c9-96a0-a844b3f0f259 t=0 0
3960b42a-6c36-49c9-96a0-a844b3f0f259 m=audio 22274 RTP/AVP 0 101 13
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=rtpmap:0 PCMU/8000
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=rtpmap:101 telephone-event/8000
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=fmtp:101 0-16
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=rtpmap:13 CN/8000
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=ptime:20
3960b42a-6c36-49c9-96a0-a844b3f0f259
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:35:00.337073 [DEBUG]
sofia.c:7048 Channel sofia/internal/15068559226 entering state [ready][200]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:35:00.337073 [NOTICE]
sofia.c:8123 Channel [sofia/internal/15068559226] has been answered
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:35:00.337073 [DEBUG]
switch_channel.c:3772 (sofia/internal/15068559226) Callstate Change EARLY ->
ACTIVE
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:35:00.357041 [DEBUG]
switch_core_media.c:6848 Audio params are unchanged for
sofia/internal/200 at 192.168.20.161.
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:35:00.357041 [DEBUG]
mod_sofia.c:850 Local SDP sofia/internal/200 at 192.168.20.161:
cc1d0c18-e576-47a6-bf4f-35ab835f920c v=0
cc1d0c18-e576-47a6-bf4f-35ab835f920c o=FreeSWITCH 1493805534 1493805536 IN
IP4 192.168.20.161
cc1d0c18-e576-47a6-bf4f-35ab835f920c s=FreeSWITCH
cc1d0c18-e576-47a6-bf4f-35ab835f920c c=IN IP4 192.168.20.161
cc1d0c18-e576-47a6-bf4f-35ab835f920c t=0 0
cc1d0c18-e576-47a6-bf4f-35ab835f920c m=audio 16564 RTP/AVP 0 101
cc1d0c18-e576-47a6-bf4f-35ab835f920c a=rtpmap:0 PCMU/8000
cc1d0c18-e576-47a6-bf4f-35ab835f920c a=rtpmap:101 telephone-event/8000
cc1d0c18-e576-47a6-bf4f-35ab835f920c a=fmtp:101 0-16
cc1d0c18-e576-47a6-bf4f-35ab835f920c a=ptime:20
cc1d0c18-e576-47a6-bf4f-35ab835f920c a=sendrecv
cc1d0c18-e576-47a6-bf4f-35ab835f920c
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:35:00.357041 [NOTICE]
switch_ivr_bridge.c:623 Channel [sofia/internal/200 at 192.168.20.161] has been
answered
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:35:00.357041 [DEBUG]
switch_channel.c:3772 (sofia/internal/200 at 192.168.20.161) Callstate Change
EARLY -> ACTIVE
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:35:00.357041 [DEBUG]
sofia.c:7048 Channel sofia/internal/200 at 192.168.20.161 entering state
[completed][200]
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:35:00.377070 [DEBUG]
sofia.c:7048 Channel sofia/internal/200 at 192.168.20.161 entering state
[ready][200]
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:35:00.396999 [DEBUG]
switch_rtp.c:7229 Correct audio ip/port confirmed.
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:35:00.396999 [DEBUG]
switch_rtp.c:7229 Correct audio ip/port confirmed.
2017-05-03 11:35:00.396999 [INFO] sofia.c:1279 sofia/internal/15068559226
Update Callee ID to "Outbound Call" <+15068559226>
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:36:02.717070 [DEBUG]
sofia.c:7048 Channel sofia/internal/15068559226 entering state [calling][0]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:36:03.757073 [DEBUG]
sofia.c:7048 Channel sofia/internal/15068559226 entering state
[completing][200]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:36:03.757073 [DEBUG]
sofia.c:7055 Duplicate SDP
3960b42a-6c36-49c9-96a0-a844b3f0f259 v=0
3960b42a-6c36-49c9-96a0-a844b3f0f259 o=FreeSWITCH 1493799827 1493799828 IN
IP4 72.55.158.152
3960b42a-6c36-49c9-96a0-a844b3f0f259 s=FreeSWITCH
3960b42a-6c36-49c9-96a0-a844b3f0f259 c=IN IP4 72.55.158.152
3960b42a-6c36-49c9-96a0-a844b3f0f259 t=0 0
3960b42a-6c36-49c9-96a0-a844b3f0f259 m=audio 22274 RTP/AVP 0 101 13
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=rtpmap:0 PCMU/8000
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=rtpmap:101 telephone-event/8000
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=fmtp:101 0-16
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=rtpmap:13 CN/8000
3960b42a-6c36-49c9-96a0-a844b3f0f259 a=ptime:20
3960b42a-6c36-49c9-96a0-a844b3f0f259
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:36:03.777033 [DEBUG]
sofia.c:7048 Channel sofia/internal/15068559226 entering state [ready][200]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:03.737072 [DEBUG]
sofia.c:7048 Channel sofia/internal/15068559226 entering state [calling][0]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
sofia.c:7048 Channel sofia/internal/15068559226 entering state
[terminating][408]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [NOTICE]
sofia.c:8237 Hangup sofia/internal/15068559226 [CS_EXCHANGE_MEDIA]
[RECOVERY_ON_TIMER_EXPIRE]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_ivr_bridge.c:712 sofia/internal/15068559226 ending bridge by request
from read function
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/internal/15068559226]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:653 (sofia/internal/15068559226) State
EXCHANGE_MEDIA going to sleep
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:584 (sofia/internal/15068559226) Running State
Change CS_HANGUP (Cur 2 Tot 136)
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:850 (sofia/internal/15068559226) Callstate
Change ACTIVE -> HANGUP
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:852 (sofia/internal/15068559226) State HANGUP
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
mod_sofia.c:438 Channel sofia/internal/15068559226 hanging up, cause:
RECOVERY_ON_TIMER_EXPIRE
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:60 sofia/internal/15068559226 Standard HANGUP,
cause: RECOVERY_ON_TIMER_EXPIRE
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:852 (sofia/internal/15068559226) State HANGUP
going to sleep
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:619 (sofia/internal/15068559226) State Change
CS_HANGUP -> CS_REPORTING
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:584 (sofia/internal/15068559226) Running State
Change CS_REPORTING (Cur 2 Tot 136)
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:938 (sofia/internal/15068559226) State REPORTING
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:174 sofia/internal/15068559226 Standard
REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:938 (sofia/internal/15068559226) State REPORTING
going to sleep
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_state_machine.c:610 (sofia/internal/15068559226) State Change
CS_REPORTING -> CS_DESTROY
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.737038 [DEBUG]
switch_core_session.c:1664 Session 136 (sofia/internal/15068559226) Locked,
Waiting on external entities
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_ivr_bridge.c:706 sofia/internal/15068559226 ending bridge by request
from write function
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_ivr_bridge.c:787 BRIDGE THREAD DONE
[sofia/internal/200 at 192.168.20.161]
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [NOTICE]
switch_ivr_bridge.c:1751 Hangup sofia/internal/200 at 192.168.20.161
[CS_EXECUTE] [RECOVERY_ON_TIMER_EXPIRE]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.757070 [NOTICE]
switch_core_session.c:1682 Session 136 (sofia/internal/15068559226) Ended
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.757070 [NOTICE]
switch_core_session.c:1686 Close Channel sofia/internal/15068559226
[CS_DESTROY]
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:741 (sofia/internal/15068559226) Running State
Change CS_DESTROY (Cur 1 Tot 136)
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_session.c:2814 sofia/internal/200 at 192.168.20.161 skip receive
message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:650 (sofia/internal/200 at 192.168.20.161) State
EXECUTE going to sleep
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:584 (sofia/internal/200 at 192.168.20.161) Running
State Change CS_HANGUP (Cur 1 Tot 136)
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:751 (sofia/internal/15068559226) State DESTROY
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.757070 [DEBUG]
mod_sofia.c:343 sofia/internal/15068559226 SOFIA DESTROY
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:850 (sofia/internal/200 at 192.168.20.161)
Callstate Change ACTIVE -> HANGUP
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:852 (sofia/internal/200 at 192.168.20.161) State
HANGUP
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
mod_sofia.c:432 sofia/internal/200 at 192.168.20.161 Overriding SIP cause 504
with 408 from the other leg
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
mod_sofia.c:438 Channel sofia/internal/200 at 192.168.20.161 hanging up, cause:
RECOVERY_ON_TIMER_EXPIRE
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
mod_sofia.c:491 Sending BYE to sofia/internal/200 at 192.168.20.161
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:60 sofia/internal/200 at 192.168.20.161 Standard
HANGUP, cause: RECOVERY_ON_TIMER_EXPIRE
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:852 (sofia/internal/200 at 192.168.20.161) State
HANGUP going to sleep
2017-05-03 11:37:35.757070 [DEBUG] switch_nat.c:542 unmapped public port
29764 protocol UDP to localport 29764
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:619 (sofia/internal/200 at 192.168.20.161) State
Change CS_HANGUP -> CS_REPORTING
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:584 (sofia/internal/200 at 192.168.20.161) Running
State Change CS_REPORTING (Cur 1 Tot 136)
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:938 (sofia/internal/200 at 192.168.20.161) State
REPORTING
2017-05-03 11:37:35.757070 [DEBUG] switch_nat.c:542 unmapped public port
29765 protocol UDP to localport 29765
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:181 sofia/internal/15068559226 Standard DESTROY
3960b42a-6c36-49c9-96a0-a844b3f0f259 2017-05-03 11:37:35.757070 [DEBUG]
switch_core_state_machine.c:751 (sofia/internal/15068559226) State DESTROY
going to sleep
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.776979 [DEBUG]
switch_core_state_machine.c:174 sofia/internal/200 at 192.168.20.161 Standard
REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.776979 [DEBUG]
switch_core_state_machine.c:938 (sofia/internal/200 at 192.168.20.161) State
REPORTING going to sleep
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.776979 [DEBUG]
switch_core_state_machine.c:610 (sofia/internal/200 at 192.168.20.161) State
Change CS_REPORTING -> CS_DESTROY
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.776979 [DEBUG]
switch_core_session.c:1664 Session 135 (sofia/internal/200 at 192.168.20.161)
Locked, Waiting on external entities
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.776979 [NOTICE]
switch_core_session.c:1682 Session 135 (sofia/internal/200 at 192.168.20.161)
Ended
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.776979 [NOTICE]
switch_core_session.c:1686 Close Channel sofia/internal/200 at 192.168.20.161
[CS_DESTROY]
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.776979 [DEBUG]
switch_core_state_machine.c:741 (sofia/internal/200 at 192.168.20.161) Running
State Change CS_DESTROY (Cur 0 Tot 136)
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.796986 [DEBUG]
switch_core_state_machine.c:751 (sofia/internal/200 at 192.168.20.161) State
DESTROY
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.796986 [DEBUG]
mod_sofia.c:343 sofia/internal/200 at 192.168.20.161 SOFIA DESTROY
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.796986 [DEBUG]
switch_core_state_machine.c:181 sofia/internal/200 at 192.168.20.161 Standard
DESTROY
cc1d0c18-e576-47a6-bf4f-35ab835f920c 2017-05-03 11:37:35.796986 [DEBUG]
switch_core_state_machine.c:751 (sofia/internal/200 at 192.168.20.161) State
DESTROY going to sleep
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20170503/768803ae/attachment-0001.html
Join us at ClueCon 2016 Aug 8-12, 2016
More information about the FreeSWITCH-users
mailing list