Internal call hangup after 30 second

Status
Not open for further replies.

Carlo Piga

New Member
Sep 2, 2017
2
0
1
48
I have this trouble with fusionpbx. When I make or receive external call from/to gateway all works well. When I make internal call between extension the phone ring, I start talking correctly and all works well for 30 seconds. After this 30 seconds the caller doesn't listen any sound, and the called listen a busy tone as the call has been closed.
Do you have any suggestion? I have fusionpbx installed in a xen hosted vps with debian 8.
Thanks
Carlo

This is the log:
Code:
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 set(missed_call_data=)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.568208 [DEBUG] mod_dptools.c:1548 SET sofia/internal/31@192.168.20.4 [missed_call_data]=[UNDEF]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 set(call_direction=local)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.568208 [DEBUG] mod_dptools.c:1548 SET sofia/internal/31@192.168.20.4 [call_direction]=[local]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 export(origination_callee_id_name=21)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.568208 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[21]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 set(RFC2822_DATE=Sat, 02 Sep 2017 13:37:08 +0200)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.568208 [DEBUG] mod_dptools.c:1548 SET sofia/internal/31@192.168.20.4 [RFC2822_DATE]=[Sat, 02 Sep 2017 13:37:08 +0200]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 hash(insert/192.168.20.4-last_dial/31/21)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 eval(not_secure)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 limit(hash 192.168.20.4 21 5 error/user_busy)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.568208 [DEBUG] switch_limit.c:126 incr called: 192.168.20.4_21 max:5, interval:0
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.568208 [DEBUG] mod_hash.c:196 Usage for 192.168.20.4_21 is now 1/5
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 set(hangup_after_bridge=true)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.568208 [DEBUG] mod_dptools.c:1548 SET sofia/internal/31@192.168.20.4 [hangup_after_bridge]=[true]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 set(continue_on_fail=true)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.568208 [DEBUG] mod_dptools.c:1548 SET sofia/internal/31@192.168.20.4 [continue_on_fail]=[true]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 hash(insert/192.168.20.4-call_return/21/31)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 hash(insert/192.168.20.4-last_dial_ext/21/4e3cc292-897d-4d2a-9b6c-dd1cf0875240)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 set(called_party_call_group=)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] mod_dptools.c:1548 SET sofia/internal/31@192.168.20.4 [called_party_call_group]=[UNDEF]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 hash(insert/192.168.20.4-last_dial//4e3cc292-897d-4d2a-9b6c-dd1cf0875240)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 set(api_hangup_hook=lua app.lua hangup)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] mod_dptools.c:1548 SET sofia/internal/31@192.168.20.4 [api_hangup_hook]=[lua app.lua hangup]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 export(domain_name=192.168.20.4)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [domain_name]=[192.168.20.4]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 EXECUTE sofia/internal/31@192.168.20.4 bridge(user/21@192.168.20.4)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] switch_channel.c:1250 sofia/internal/31@192.168.20.4 EXPORTING[export_vars] [domain_name]=[192.168.20.4] to event
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] switch_channel.c:1250 sofia/internal/31@192.168.20.4 EXPORTING[export_vars] [dialed_extension]=[21] to event
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] switch_channel.c:1250 sofia/internal/31@192.168.20.4 EXPORTING[export_vars] [origination_callee_id_name]=[21] to event
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] switch_channel.c:1250 sofia/internal/31@192.168.20.4 EXPORTING[export_vars] [domain_name]=[192.168.20.4] to event
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] switch_channel.c:1250 sofia/internal/31@192.168.20.4 EXPORTING[export_vars] [domain_name]=[192.168.20.4] to event
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] switch_channel.c:1250 sofia/internal/31@192.168.20.4 EXPORTING[export_vars] [dialed_extension]=[21] to event
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] switch_channel.c:1250 sofia/internal/31@192.168.20.4 EXPORTING[export_vars] [origination_callee_id_name]=[21] to event
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] switch_channel.c:1250 sofia/internal/31@192.168.20.4 EXPORTING[export_vars] [domain_name]=[192.168.20.4] to event
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.588206 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/21@192.168.10.81:5060 [ffe97b27-b971-4e3b-a6ec-0e8a91c6836c]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] mod_sofia.c:4819 (sofia/internal/21@192.168.10.81:5060) State Change CS_NEW -> CS_INIT
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/21@192.168.10.81:5060) Running State Change CS_INIT (Cur 2 Tot 459)
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/21@192.168.10.81:5060) State INIT
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] mod_sofia.c:90 sofia/internal/21@192.168.10.81:5060 SOFIA INIT
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] sofia_glue.c:1264 sip:21@192.168.10.81:5060;transport=udp Setting proxy route to sofia/internal/21@192.168.10.81:5060
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] sofia_glue.c:1295 sofia/internal/21@192.168.10.81:5060 sending invite version: 1.6.19 -36-7a77e0b 64bit
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c Local SDP:
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c v=0
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c o=FreeSWITCH 1504320210 1504320211 IN IP4 192.168.20.4
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c s=FreeSWITCH
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c c=IN IP4 192.168.20.4
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c t=0 0
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c m=audio 32018 RTP/AVP 9 0 8 3 101 13
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=rtpmap:9 G722/8000
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=rtpmap:0 PCMU/8000
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=rtpmap:8 PCMA/8000
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=rtpmap:3 GSM/8000
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=rtpmap:101 telephone-event/8000
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=fmtp:101 0-16
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=rtpmap:13 CN/8000
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=ptime:20
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=sendrecv
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] switch_core_state_machine.c:40 sofia/internal/21@192.168.10.81:5060 Standard INIT
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/21@192.168.10.81:5060) State Change CS_INIT -> CS_ROUTING
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/21@192.168.10.81:5060) State INIT going to sleep
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/21@192.168.10.81:5060) Running State Change CS_ROUTING (Cur 2 Tot 459)
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] sofia.c:7084 Channel sofia/internal/21@192.168.10.81:5060 entering state [calling][0]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/21@192.168.10.81:5060) State ROUTING
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] mod_sofia.c:143 sofia/internal/21@192.168.10.81:5060 SOFIA ROUTING
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/21@192.168.10.81:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.588206 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/21@192.168.10.81:5060) State ROUTING going to sleep
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.608211 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/21@192.168.10.81:5060) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 459)
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.608211 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/21@192.168.10.81:5060) State CONSUME_MEDIA
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.608211 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/21@192.168.10.81:5060) State CONSUME_MEDIA going to sleep
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.648210 [DEBUG] sofia.c:7084 Channel sofia/internal/21@192.168.10.81:5060 entering state [proceeding][180]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.648210 [NOTICE] sofia.c:7192 Ring-Ready sofia/internal/21@192.168.10.81:5060!
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:08.648210 [DEBUG] switch_channel.c:3346 (sofia/internal/21@192.168.10.81:5060) Callstate Change DOWN -> RINGING
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [INFO] switch_ivr_originate.c:1215 Sending early media
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/internal/31@192.168.20.4] 192.168.20.4 port 28780 -> 192.168.10.86 port 5004 codec: 9 ms: 20
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [DEBUG] switch_rtp.c:4111 Starting timer [soft] 160 bytes per 20ms
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [DEBUG] switch_core_media.c:7179 sofia/internal/31@192.168.20.4 Set 2833 dtmf send payload to 101
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [DEBUG] switch_core_media.c:7186 sofia/internal/31@192.168.20.4 Set 2833 dtmf receive payload to 101
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [DEBUG] switch_core_media.c:7209 sofia/internal/31@192.168.20.4 Set rtp dtmf delay to 40
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [DEBUG] mod_sofia.c:2364 Ring SDP:
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 v=0
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 o=FreeSWITCH 1504323448 1504323449 IN IP4 192.168.20.4
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 s=FreeSWITCH
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 c=IN IP4 192.168.20.4
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 t=0 0
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 m=audio 28780 RTP/AVP 9 101
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=rtpmap:9 G722/8000
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=rtpmap:101 telephone-event/8000
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=fmtp:101 0-16
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=ptime:20
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=sendrecv
4e3cc292-897d-4d2a-9b6c-dd1cf0875240
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [NOTICE] mod_sofia.c:2367 Pre-Answer sofia/internal/31@192.168.20.4!
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [DEBUG] switch_channel.c:3474 (sofia/internal/31@192.168.20.4) Callstate Change RINGING -> EARLY
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [DEBUG] sofia.c:7084 Channel sofia/internal/31@192.168.20.4 entering state [early][183]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [DEBUG] switch_ivr_originate.c:1273 Raw Codec Activation Success L16@16000hz 1 channel 20ms
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [DEBUG] switch_core_codec.c:223 sofia/internal/31@192.168.20.4 Push codec L16:100
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.648210 [DEBUG] switch_ivr_originate.c:1342 Play Ringback Tone [%(2000,4000,440,480)]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:08.888209 [DEBUG] switch_rtp.c:7271 Correct audio ip/port confirmed.
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] sofia.c:7084 Channel sofia/internal/21@192.168.10.81:5060 entering state [completing][200]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] sofia.c:7094 Remote SDP:
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c v=0
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c o=21 8000 8000 IN IP4 192.168.10.81
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c s=SIP Call
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c c=IN IP4 192.168.10.81
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c t=0 0
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c m=audio 5020 RTP/AVP 9 13
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=rtpmap:9 G722/8000
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=ptime:20
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] sofia.c:7084 Channel sofia/internal/21@192.168.10.81:5060 entering state [ready][200]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/21@192.168.10.81:5060 G722/8000 20 ms 160 samples 64000 bits 1 channels
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_codec.c:111 sofia/internal/21@192.168.10.81:5060 Original read codec set to G722:9
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_media.c:4774 No 2833 in SDP. Disable 2833 dtmf and switch to INFO
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/internal/21@192.168.10.81:5060] 192.168.20.4 port 32018 -> 192.168.10.81 port 5020 codec: 9 ms: 20
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_rtp.c:4111 Starting timer [soft] 160 bytes per 20ms
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_media.c:7209 sofia/internal/21@192.168.10.81:5060 Set rtp dtmf delay to 40
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_media.c:7215 Set comfort noise payload to 13
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [NOTICE] sofia.c:8218 Channel [sofia/internal/21@192.168.10.81:5060] has been answered
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_channel.c:3773 (sofia/internal/21@192.168.10.81:5060) Callstate Change RINGING -> ACTIVE
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:14.468410 [DEBUG] switch_core_codec.c:248 sofia/internal/31@192.168.20.4 Restore previous codec G722:9.
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:14.468410 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/internal/31@192.168.20.4.
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:14.468410 [DEBUG] mod_sofia.c:850 Local SDP sofia/internal/31@192.168.20.4:
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 v=0
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 o=FreeSWITCH 1504323448 1504323450 IN IP4 192.168.20.4
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 s=FreeSWITCH
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 c=IN IP4 192.168.20.4
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 t=0 0
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 m=audio 28780 RTP/AVP 9 101
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=rtpmap:9 G722/8000
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=rtpmap:101 telephone-event/8000
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=fmtp:101 0-16
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=ptime:20
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=sendrecv
4e3cc292-897d-4d2a-9b6c-dd1cf0875240
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:14.468410 [DEBUG] sofia.c:7084 Channel sofia/internal/31@192.168.20.4 entering state [completed][200]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:14.468410 [NOTICE] switch_ivr_originate.c:3647 Channel [sofia/internal/31@192.168.20.4] has been answered
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:14.468410 [DEBUG] switch_channel.c:3773 (sofia/internal/31@192.168.20.4) Callstate Change EARLY -> ACTIVE
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:14.468410 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/internal/21@192.168.10.81:5060]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:14.468410 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/internal/21@192.168.10.81:5060]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_ivr_bridge.c:1614 (sofia/internal/21@192.168.10.81:5060) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/21@192.168.10.81:5060) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 459)
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] switch_core_state_machine.c:653 (sofia/internal/21@192.168.10.81:5060) State EXCHANGE_MEDIA
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.468410 [DEBUG] mod_sofia.c:631 SOFIA EXCHANGE_MEDIA
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:14.548209 [DEBUG] switch_rtp.c:7271 Correct audio ip/port confirmed.
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.608219 [DEBUG] switch_rtp.c:7271 Correct audio ip/port confirmed.
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:14.768218 [DEBUG] sofia.c:7084 Channel sofia/internal/31@192.168.20.4 entering state [ready][200]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:14.788209 [DEBUG] sofia.c:7084 Channel sofia/internal/21@192.168.10.81:5060 entering state [calling][0]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:14.788209 [DEBUG] sofia.c:7084 Channel sofia/internal/31@192.168.20.4 entering state [calling][0]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] sofia.c:7084 Channel sofia/internal/21@192.168.10.81:5060 entering state [ready][200]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] sofia.c:7094 Remote SDP:
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c v=0
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c o=21 8000 8001 IN IP4 192.168.10.81
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c s=SIP Call
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c c=IN IP4 192.168.10.81
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c t=0 0
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c m=audio 5020 RTP/AVP 9 13
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=rtpmap:9 G722/8000
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c a=ptime:20
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] switch_core_media.c:4373 Set comfort noise payload to 13
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] switch_core_media.c:4720 Set comfort noise payload to 13@8000
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] switch_core_media.c:4774 No 2833 in SDP. Disable 2833 dtmf and switch to INFO
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] sofia.c:8061 Processing updated SDP
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:15.008207 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/internal/21@192.168.10.81:5060.
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] sofia.c:7084 Channel sofia/internal/31@192.168.20.4 entering state [ready][200]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] sofia.c:7094 Remote SDP:
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 v=0
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 o=31 8000 8001 IN IP4 192.168.10.86
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 s=SIP Call
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 c=IN IP4 192.168.10.86
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 t=0 0
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 m=audio 5004 RTP/AVP 9 101
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=rtpmap:9 G722/8000
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=rtpmap:101 telephone-event/8000
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=fmtp:101 0-15
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 a=ptime:20
4e3cc292-897d-4d2a-9b6c-dd1cf0875240
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] switch_core_media.c:4767 sofia/internal/31@192.168.20.4 Set 2833 dtmf send payload to 101 recv payload to 101
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] sofia.c:8061 Processing updated SDP
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:15.408400 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/internal/31@192.168.20.4.
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.888207 [NOTICE] sofia.c:1012 Hangup sofia/internal/31@192.168.20.4 [CS_EXECUTE] [NORMAL_CLEARING]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.888207 [DEBUG] mod_hash.c:297 Usage for 192.168.20.4_21 is now 0
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.888207 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/internal/31@192.168.20.4]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_ivr_bridge.c:706 sofia/internal/31@192.168.20.4 ending bridge by request from write function
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_ivr_bridge.c:787 BRIDGE THREAD DONE [sofia/internal/21@192.168.10.81:5060]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [NOTICE] switch_ivr_bridge.c:904 Hangup sofia/internal/21@192.168.10.81:5060 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:653 (sofia/internal/21@192.168.10.81:5060) State EXCHANGE_MEDIA going to sleep
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/21@192.168.10.81:5060) Running State Change CS_HANGUP (Cur 2 Tot 459)
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/21@192.168.10.81:5060) Callstate Change ACTIVE -> HANGUP
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/21@192.168.10.81:5060) State HANGUP
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] mod_sofia.c:432 sofia/internal/21@192.168.10.81:5060 Overriding SIP cause 480 with 200 from the other leg
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] mod_sofia.c:438 Channel sofia/internal/21@192.168.10.81:5060 hanging up, cause: NORMAL_CLEARING
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/internal/21@192.168.10.81:5060
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:60 sofia/internal/21@192.168.10.81:5060 Standard HANGUP, cause: NORMAL_CLEARING
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/21@192.168.10.81:5060) State HANGUP going to sleep
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/21@192.168.10.81:5060) State Change CS_HANGUP -> CS_REPORTING
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/21@192.168.10.81:5060) Running State Change CS_REPORTING (Cur 2 Tot 459)
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/21@192.168.10.81:5060) State REPORTING
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:174 sofia/internal/21@192.168.10.81:5060 Standard REPORTING, cause: NORMAL_CLEARING
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/21@192.168.10.81:5060) State REPORTING going to sleep
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/21@192.168.10.81:5060) State Change CS_REPORTING -> CS_DESTROY
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_session.c:1665 Session 459 (sofia/internal/21@192.168.10.81:5060) Locked, Waiting on external entities
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_ivr_bridge.c:1715 sofia/internal/31@192.168.20.4 skip receive message [UNBRIDGE] (channel is hungup already)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_core_session.c:2815 sofia/internal/31@192.168.20.4 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/31@192.168.20.4) State EXECUTE going to sleep
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/31@192.168.20.4) Running State Change CS_HANGUP (Cur 2 Tot 459)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/31@192.168.20.4) Callstate Change ACTIVE -> HANGUP
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/31@192.168.20.4) State HANGUP
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] mod_sofia.c:438 Channel sofia/internal/31@192.168.20.4 hanging up, cause: NORMAL_CLEARING
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:60 sofia/internal/31@192.168.20.4 Standard HANGUP, cause: NORMAL_CLEARING
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/31@192.168.20.4) State HANGUP going to sleep
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:783 Hangup Command with no Session lua(app.lua hangup):
4e3cc292-897d-4d2a-9b6c-dd1cf0875240
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/31@192.168.20.4) State Change CS_HANGUP -> CS_REPORTING
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/31@192.168.20.4) Running State Change CS_REPORTING (Cur 2 Tot 459)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/31@192.168.20.4) State REPORTING
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [NOTICE] switch_core_session.c:1683 Session 459 (sofia/internal/21@192.168.10.81:5060) Ended
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/21@192.168.10.81:5060 [CS_DESTROY]
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/21@192.168.10.81:5060) Running State Change CS_DESTROY (Cur 1 Tot 459)
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/21@192.168.10.81:5060) State DESTROY
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] mod_sofia.c:343 sofia/internal/21@192.168.10.81:5060 SOFIA DESTROY
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:181 sofia/internal/21@192.168.10.81:5060 Standard DESTROY
ffe97b27-b971-4e3b-a6ec-0e8a91c6836c 2017-09-02 13:37:49.908313 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/21@192.168.10.81:5060) State DESTROY going to sleep
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:50.128211 [DEBUG] switch_core_state_machine.c:174 sofia/internal/31@192.168.20.4 Standard REPORTING, cause: NORMAL_CLEARING
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:50.128211 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/31@192.168.20.4) State REPORTING going to sleep
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:50.128211 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/31@192.168.20.4) State Change CS_REPORTING -> CS_DESTROY
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:50.128211 [DEBUG] switch_core_session.c:1665 Session 458 (sofia/internal/31@192.168.20.4) Locked, Waiting on external entities
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:50.128211 [NOTICE] switch_core_session.c:1683 Session 458 (sofia/internal/31@192.168.20.4) Ended
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:50.128211 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/31@192.168.20.4 [CS_DESTROY]
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:50.128211 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/31@192.168.20.4) Running State Change CS_DESTROY (Cur 0 Tot 459)
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:50.128211 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/31@192.168.20.4) State DESTROY
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:50.128211 [DEBUG] mod_sofia.c:343 sofia/internal/31@192.168.20.4 SOFIA DESTROY
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:50.128211 [DEBUG] switch_core_state_machine.c:181 sofia/internal/31@192.168.20.4 Standard DESTROY
4e3cc292-897d-4d2a-9b6c-dd1cf0875240 2017-09-02 13:37:50.128211 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/31@192.168.20.4) State DESTROY going to sleep
 

EasyBB

Active Member
Oct 23, 2016
240
33
28
Australia
You seem to have two internal subnets 192.168.10.x and 192.168.20.x. Are you still using /24 subnet mask?

What make and model are the phones? Did you test with TCP instead of UDP? Did you try filling in 'Outbound Proxy' field on the phone with FusionPBX IP address?
 

Carlo Piga

New Member
Sep 2, 2017
2
0
1
48
Yes. I have two subnet: 192.168.10.0/24 and 192.168.20.0/24 (dmz) connected by the router/firewall. The phones are grandstream gxp2110. The outbound proxy is already the ip of the fusionpbx server. How do I force fusionpbx to use tcp instead of udp?
 
Status
Not open for further replies.