Enable Multiple Codec in Outbound Call
murad
Though I have configured multiple codecs in both trunk and sip device outbound-codec-prefs G729,GSM,PCMU,PCMA for my outbound trunk but it only selects GSM at SDP for outbound call as a result my call is failing as my trunk expect more codecs i.e PCMA, PCMU
Any help will be appreciated
Free Switch CLI output give below
freeswitch@internal>
2017-06-04 06:05:19.657957 [NOTICE] switch_channel.c:1089 New Channel sofia/default/20364...@myswitch.com [c9b52d04-48eb-11e7-bc8a-f3566a129896]
2017-06-04 06:05:19.657957 [DEBUG] switch_core_state_machine.c:473 (sofia/default/20364...@myswitch.com) Running State Change CS_NEW
2017-06-04 06:05:19.657957 [DEBUG] sofia.c:9091 sofia/default/20364...@myswitch.com receiving invite from 24.252.175.34:45646 version: 1.7.0 git 2751039 2015-07-15 21:57:05Z 64bit
2017-06-04 06:05:19.657957 [DEBUG] sofia.c:9258 IP 24.252.175.34 Rejected by acl "default". Falling back to Digest auth.
2017-06-04 06:05:19.657957 [WARNING] sofia_reg.c:1744 SIP auth challenge (INVITE) on sofia profile 'default' for [14808...@myswitch.com] from ip 24.252.175.34
2017-06-04 06:05:19.657957 [DEBUG] switch_core_state_machine.c:492 (sofia/default/20364...@myswitch.com) State NEW
2017-06-04 06:05:19.657957 [DEBUG] sofia.c:2147 detaching session c9b52d04-48eb-11e7-bc8a-f3566a129896
2017-06-04 06:05:20.057952 [DEBUG] sofia.c:2255 Re-attaching to session c9b52d04-48eb-11e7-bc8a-f3566a129896
2017-06-04 06:05:20.057952 [DEBUG] sofia.c:9091 sofia/default/20364...@myswitch.com receiving invite from 24.252.175.34:45646 version: 1.7.0 git 2751039 2015-07-15 21:57:05Z 64bit
2017-06-04 06:05:20.057952 [DEBUG] sofia.c:9258 IP 24.252.175.34 Rejected by acl "default". Falling back to Digest auth.
2017-06-04 06:05:20.217957 [DEBUG] sofia.c:6715 Channel sofia/default/20364...@myswitch.com entering state [received][100]
2017-06-04 06:05:20.217957 [DEBUG] sofia.c:6725 Remote SDP:
v=0
o=2036499237 0 0 IN IP4 192.168.1.100
s=session
c=IN IP4 192.168.1.100
t=0 0
m=audio 5062 RTP/AVP 4 3 0 8 18 101
a=rtpmap:4 G723/8000
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:18 G729/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [G723:4:8000:30:6300:1]/[G729:18:8000:20:8000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [G723:4:8000:30:6300:1]/[GSM:3:8000:20:13200:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [G723:4:8000:30:6300:1]/[PCMA:8:8000:20:64000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [G723:4:8000:30:6300:1]/[PCMU:0:8000:20:64000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G729:18:8000:20:8000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [GSM:3:8000:20:13200:1]/[GSM:3:8000:20:13200:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4120 Audio Codec Compare [GSM:3:8000:20:13200:1] ++++ is saved as a match
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G729:18:8000:20:8000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4120 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G729:18:8000:20:8000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4120 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4120 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [G729:18:8000:20:8000:1]/[GSM:3:8000:20:13200:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4065 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:3981 Set telephone-event payload to 101
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:2851 Set Codec sofia/default/20364...@myswitch.com GSM/8000 20 ms 160 samples 13200 bits 1 channels
2017-06-04 06:05:20.217957 [DEBUG] switch_core_codec.c:111 sofia/default/20364...@myswitch.com Original read codec set to GSM:3
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4332 Set 2833 dtmf send/recv payload to 101
2017-06-04 06:05:20.217957 [DEBUG] sofia.c:7011 (sofia/default/20364...@myswitch.com) State Change CS_NEW -> CS_INIT
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:473 (sofia/default/20364...@myswitch.com) Running State Change CS_INIT
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:516 (sofia/default/20364...@myswitch.com) State INIT
2017-06-04 06:05:20.217957 [DEBUG] mod_sofia.c:88 sofia/default/20364...@myswitch.com SOFIA INIT
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:40 sofia/default/20364...@myswitch.com Standard INIT
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:48 (sofia/default/20364...@myswitch.com) State Change CS_INIT -> CS_ROUTING
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:516 (sofia/default/20364...@myswitch.com) State INIT going to sleep
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:473 (sofia/default/20364...@myswitch.com) Running State Change CS_ROUTING
2017-06-04 06:05:20.217957 [DEBUG] switch_channel.c:2239 (sofia/default/20364...@myswitch.com) Callstate Change DOWN -> RINGING
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:532 (sofia/default/20364...@myswitch.com) State ROUTING
2017-06-04 06:05:20.217957 [DEBUG] mod_sofia.c:141 sofia/default/20364...@myswitch.com SOFIA ROUTING
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:166 sofia/default/20364...@myswitch.com Standard ROUTING
2017-06-04 06:05:20.217957 [INFO] mod_dialplan_xml.c:637 Processing 2036499237 <2036499237>->14808452938 in context default
Dialplan: sofia/default/20364...@myswitch.com parsing [default->] continue=false
Dialplan: sofia/default/20364...@myswitch.com Regex (PASS) [] destination_number(14808452938) =~ // break=on-false
Dialplan: sofia/default/20364...@myswitch.com Action set(callstart=2017-06-04 06:05:20)
Dialplan: sofia/default/20364...@myswitch.com Action set(call_processed=internal)
Dialplan: sofia/default/20364...@myswitch.com Action set(originated_destination_number=14808452938)
Dialplan: sofia/default/20364...@myswitch.com Action set(hangup_after_bridge=true)
Dialplan: sofia/default/20364...@myswitch.com Action set(continue_on_fail=false)
Dialplan: sofia/default/20364...@myswitch.com Action set(accountid=4)
Dialplan: sofia/default/20364...@myswitch.com Action set(account_type=0)
Dialplan: sofia/default/20364...@myswitch.com Action set(resellerid=0)
Dialplan: sofia/default/20364...@myswitch.com Action set(accountcode=2036499237)
Dialplan: sofia/default/20364...@myswitch.com Action set(call_direction=outbound)
Dialplan: sofia/default/20364...@myswitch.com Action set(calltype=STANDARD)
Dialplan: sofia/default/20364...@myswitch.com Action sched_hangup(+1440 allotted_timeout)
Dialplan: sofia/default/20364...@myswitch.com Action log(INFO [Customer info] : [Account code: 2036499237, Rategroup Id: 4, Called number: 14808452938])
Dialplan: sofia/default/20364...@myswitch.com Action set(origination_rates=ID:120736|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.01620|INC:60|RATEGROUP:4|MARKUP:0|ACCID:4)
Dialplan: sofia/default/20364...@myswitch.com Action set(effective_destination_number=14808452938)
Dialplan: sofia/default/20364...@myswitch.com Action set(termination_rates=ID:120739|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00810|INC:60|TRUNK:4|PROVIDER:2)
Dialplan: sofia/default/20364...@myswitch.com Action limit(db myoutboundtrunk gw_myoutboundtrunk 100)
Dialplan: sofia/default/20364...@myswitch.com Action set(absolute_codec_string=G729,GSM,PCMU,PCMA)
Dialplan: sofia/default/20364...@myswitch.com Action bridge(sofia/gateway/myoutboundtrunk/001110214808452938)
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:216 (sofia/default/20364...@myswitch.com) State Change CS_ROUTING -> CS_EXECUTE
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:532 (sofia/default/20364...@myswitch.com) State ROUTING going to sleep
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:473 (sofia/default/20364...@myswitch.com) Running State Change CS_EXECUTE
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:539 (sofia/default/20364...@myswitch.com) State EXECUTE
2017-06-04 06:05:20.397957 [DEBUG] mod_sofia.c:196 sofia/default/20364...@myswitch.com SOFIA EXECUTE
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:258 sofia/default/20364...@myswitch.com Standard EXECUTE
EXECUTE sofia/default/20364...@myswitch.com set(callstart=2017-06-04 06:05:20)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [callstart]=[2017-06-04 06:05:20]
EXECUTE sofia/default/20364...@myswitch.com set(call_processed=internal)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [call_processed]=[internal]
EXECUTE sofia/default/20364...@myswitch.com set(originated_destination_number=14808452938)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [originated_destination_number]=[14808452938]
EXECUTE sofia/default/20364...@myswitch.com set(hangup_after_bridge=true)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [hangup_after_bridge]=[true]
EXECUTE sofia/default/20364...@myswitch.com set(continue_on_fail=false)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [continue_on_fail]=[false]
EXECUTE sofia/default/20364...@myswitch.com set(accountid=4)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [accountid]=[4]
EXECUTE sofia/default/20364...@myswitch.com set(account_type=0)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [account_type]=[0]
EXECUTE sofia/default/20364...@myswitch.com set(resellerid=0)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [resellerid]=[0]
EXECUTE sofia/default/20364...@myswitch.com set(accountcode=2036499237)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [accountcode]=[2036499237]
EXECUTE sofia/default/20364...@myswitch.com set(call_direction=outbound)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [call_direction]=[outbound]
EXECUTE sofia/default/20364...@myswitch.com set(calltype=STANDARD)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [calltype]=[STANDARD]
EXECUTE sofia/default/20364...@myswitch.com sched_hangup(+1440 allotted_timeout)
2017-06-04 06:05:20.397957 [DEBUG] switch_scheduler.c:249 Added task 1914 switch_ivr_schedule_hangup (c9b52d04-48eb-11e7-bc8a-f3566a129896) to run at 1496557760
EXECUTE sofia/default/20364...@myswitch.com log(INFO [Customer info] : [Account code: 2036499237, Rategroup Id: 4, Called number: 14808452938])
2017-06-04 06:05:20.397957 [INFO] mod_dptools.c:1683 [Customer info] : [Account code: 2036499237, Rategroup Id: 4, Called number: 14808452938]
EXECUTE sofia/default/20364...@myswitch.com set(origination_rates=ID:120736|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.01620|INC:60|RATEGROUP:4|MARKUP:0|ACCID:4)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [origination_rates]=[ID:120736|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.01620|INC:60|RATEGROUP:4|MARKUP:0|ACCID:4]
EXECUTE sofia/default/20364...@myswitch.com set(effective_destination_number=14808452938)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [effective_destination_number]=[14808452938]
EXECUTE sofia/default/20364...@myswitch.com set(termination_rates=ID:120739|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00810|INC:60|TRUNK:4|PROVIDER:2)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [termination_rates]=[ID:120739|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00810|INC:60|TRUNK:4|PROVIDER:2]
EXECUTE sofia/default/20364...@myswitch.com limit(db myoutboundtrunk gw_myoutboundtrunk 100)
2017-06-04 06:05:20.397957 [DEBUG] switch_limit.c:126 incr called: myoutboundtrunk_gw_myoutboundtrunk max:100, interval:0
2017-06-04 06:05:20.397957 [DEBUG] mod_db.c:194 Usage for myoutboundtrunk_gw_myoutboundtrunk is now 1/100
EXECUTE sofia/default/20364...@myswitch.com set(absolute_codec_string=G729,GSM,PCMU,PCMA)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/20364...@myswitch.com [absolute_codec_string]=[G729,GSM,PCMU,PCMA]
EXECUTE sofia/default/20364...@myswitch.com bridge(sofia/gateway/myoutboundtrunk/001110214808452938)
2017-06-04 06:05:20.397957 [DEBUG] switch_ivr_originate.c:2104 Parsing global variables
2017-06-04 06:05:20.397957 [NOTICE] switch_channel.c:1089 New Channel sofia/default/001110214808452938 [ca27330e-48eb-11e7-bca5-f3566a129896]
2017-06-04 06:05:20.397957 [DEBUG] mod_sofia.c:4735 (sofia/default/001110214808452938) State Change CS_NEW -> CS_INIT
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:473 (sofia/default/001110214808452938) Running State Change CS_INIT
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:516 (sofia/default/001110214808452938) State INIT
2017-06-04 06:05:20.397957 [DEBUG] mod_sofia.c:88 sofia/default/001110214808452938 SOFIA INIT
2017-06-04 06:05:20.417936 [DEBUG] sofia_glue.c:1227 sip:sbc.myoutboundtrunk.com Setting proxy route to sofia/default/001110214808452938
2017-06-04 06:05:20.417936 [DEBUG] sofia_glue.c:1256 sofia/default/001110214808452938 sending invite version: 1.7.0 git 2751039 2015-07-15 21:57:05Z 64bit
Local SDP:
v=0
o=FreeSWITCH 1496524210 1496524211 IN IP4 24.252.175.26
s=FreeSWITCH
c=IN IP4 24.252.175.26
t=0 0
m=audio 32110 RTP/AVP 3 101
a=rtpmap:3 GSM/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=sendrecv
2017-06-04 06:05:20.417936 [DEBUG] switch_core_state_machine.c:40 sofia/default/001110214808452938 Standard INIT
2017-06-04 06:05:20.417936 [DEBUG] switch_core_state_machine.c:48 (sofia/default/001110214808452938) State Change CS_INIT -> CS_ROUTING
2017-06-04 06:05:20.417936 [DEBUG] switch_core_state_machine.c:516 (sofia/default/001110214808452938) State INIT going to sleep
2017-06-04 06:05:20.417936 [DEBUG] switch_core_state_machine.c:473 (sofia/default/001110214808452938) Running State Change CS_ROUTING
2017-06-04 06:05:20.417936 [DEBUG] sofia.c:6715 Channel sofia/default/001110214808452938 entering state [calling][0]
2017-06-04 06:05:20.417936 [DEBUG] switch_core_state_machine.c:532 (sofia/default/001110214808452938) State ROUTING
2017-06-04 06:05:20.417936 [DEBUG] mod_sofia.c:141 sofia/default/001110214808452938 SOFIA ROUTING
2017-06-04 06:05:20.417936 [DEBUG] switch_ivr_originate.c:67 (sofia/default/001110214808452938) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2017-06-04 06:05:20.417936 [DEBUG] switch_core_state_machine.c:532 (sofia/default/001110214808452938) State ROUTING going to sleep
2017-06-04 06:05:20.417936 [DEBUG] switch_core_state_machine.c:473 (sofia/default/001110214808452938) Running State Change CS_CONSUME_MEDIA
2017-06-04 06:05:20.417936 [DEBUG] switch_core_state_machine.c:551 (sofia/default/001110214808452938) State CONSUME_MEDIA
2017-06-04 06:05:20.417936 [DEBUG] switch_core_state_machine.c:551 (sofia/default/001110214808452938) State CONSUME_MEDIA going to sleep
2017-06-04 06:05:52.418038 [DEBUG] sofia.c:6715 Channel sofia/default/001110214808452938 entering state [terminated][408]
2017-06-04 06:05:52.418038 [NOTICE] sofia.c:7631 Hangup sofia/default/001110214808452938 [CS_CONSUME_MEDIA] [RECOVERY_ON_TIMER_EXPIRE]
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:473 (sofia/default/001110214808452938) Running State Change CS_HANGUP
2017-06-04 06:05:52.418038 [DEBUG] switch_ivr_originate.c:3727 Originate Resulted in Error Cause: 102 [RECOVERY_ON_TIMER_EXPIRE]
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:739 (sofia/default/001110214808452938) Callstate Change DOWN -> HANGUP
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:741 (sofia/default/001110214808452938) State HANGUP
2017-06-04 06:05:52.418038 [DEBUG] mod_sofia.c:431 Channel sofia/default/001110214808452938 hanging up, cause: RECOVERY_ON_TIMER_EXPIRE
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:60 sofia/default/001110214808452938 Standard HANGUP, cause: RECOVERY_ON_TIMER_EXPIRE
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:741 (sofia/default/001110214808452938) State HANGUP going to sleep
2017-06-04 06:05:52.418038 [INFO] mod_dptools.c:3324 Originate Failed. Cause: RECOVERY_ON_TIMER_EXPIRE
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:508 (sofia/default/001110214808452938) State Change CS_HANGUP -> CS_REPORTING
2017-06-04 06:05:52.418038 [NOTICE] switch_channel.c:4800 Hangup sofia/default/20364...@myswitch.com [CS_EXECUTE] [RECOVERY_ON_TIMER_EXPIRE]
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:473 (sofia/default/001110214808452938) Running State Change CS_REPORTING
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:827 (sofia/default/001110214808452938) State REPORTING
2017-06-04 06:05:52.418038 [DEBUG] switch_core_session.c:2926 sofia/default/20364...@myswitch.com skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:539 (sofia/default/20364...@myswitch.com) State EXECUTE going to sleep
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:473 (sofia/default/20364...@myswitch.com) Running State Change CS_HANGUP
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:739 (sofia/default/20364...@myswitch.com) Callstate Change RINGING -> HANGUP
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:741 (sofia/default/20364...@myswitch.com) State HANGUP
2017-06-04 06:05:52.418038 [DEBUG] mod_sofia.c:425 sofia/default/20364...@myswitch.com Overriding SIP cause 504 with 408 from the other leg
2017-06-04 06:05:52.418038 [DEBUG] mod_sofia.c:431 Channel sofia/default/20364...@myswitch.com hanging up, cause: RECOVERY_ON_TIMER_EXPIRE
2017-06-04 06:05:52.418038 [DEBUG] mod_sofia.c:568 Responding to INVITE with: 408
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:60 sofia/default/20364...@myswitch.com Standard HANGUP, cause: RECOVERY_ON_TIMER_EXPIRE
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:741 (sofia/default/20364...@myswitch.com) State HANGUP going to sleep
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:508 (sofia/default/20364...@myswitch.com) State Change CS_HANGUP -> CS_REPORTING
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:473 (sofia/default/20364...@myswitch.com) Running State Change CS_REPORTING
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:827 (sofia/default/20364...@myswitch.com) State REPORTING
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:104 sofia/default/001110214808452938 Standard REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:827 (sofia/default/001110214808452938) State REPORTING going to sleep
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:499 (sofia/default/001110214808452938) State Change CS_REPORTING -> CS_DESTROY
2017-06-04 06:05:52.717935 [DEBUG] switch_core_session.c:1639 Session 3831 (sofia/default/001110214808452938) Locked, Waiting on external entities
2017-06-04 06:05:52.717935 [NOTICE] switch_core_session.c:1657 Session 3831 (sofia/default/001110214808452938) Ended
2017-06-04 06:05:52.717935 [NOTICE] switch_core_session.c:1661 Close Channel sofia/default/001110214808452938 [CS_DESTROY]
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:630 (sofia/default/001110214808452938) Running State Change CS_DESTROY
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:640 (sofia/default/001110214808452938) State DESTROY
2017-06-04 06:05:52.717935 [DEBUG] mod_sofia.c:341 sofia/default/001110214808452938 SOFIA DESTROY
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:111 sofia/default/001110214808452938 Standard DESTROY
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:640 (sofia/default/001110214808452938) State DESTROY going to sleep
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:104 sofia/default/20364...@myswitch.com Standard REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:827 (sofia/default/20364...@myswitch.com) State REPORTING going to sleep
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:499 (sofia/default/20364...@myswitch.com) State Change CS_REPORTING -> CS_DESTROY
2017-06-04 06:05:52.737937 [DEBUG] switch_core_session.c:1639 Session 3830 (sofia/default/20364...@myswitch.com) Locked, Waiting on external entities
2017-06-04 06:05:52.737937 [NOTICE] switch_core_session.c:1657 Session 3830 (sofia/default/20364...@myswitch.com) Ended
2017-06-04 06:05:52.737937 [NOTICE] switch_core_session.c:1661 Close Channel sofia/default/20364...@myswitch.com [CS_DESTROY]
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:630 (sofia/default/20364...@myswitch.com) Running State Change CS_DESTROY
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:640 (sofia/default/20364...@myswitch.com) State DESTROY
2017-06-04 06:05:52.737937 [DEBUG] mod_sofia.c:341 sofia/default/20364...@myswitch.com SOFIA DESTROY
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:111 sofia/default/20364...@myswitch.com Standard DESTROY
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:640 (sofia/default/20364...@myswitch.com) State DESTROY going to sleep
2017-06-04 06:05:52.897955 [DEBUG] switch_scheduler.c:144 Deleting task 1914 switch_ivr_schedule_hangup (c9b52d04-48eb-11e7-bc8a-f3566a129896)
freeswitch@internal>
Thanks
Samir Doshi
Hi
Though I have configured multiple codecs in both trunk and sip device outbound-codec-prefs G729,GSM,PCMU,PCMA for my outbound trunk but it only selects GSM at SDP for outbound call as a result my call is failing as my trunk expect more codecs i.e PCMA, PCMU
Any help will be appreciated
Free Switch CLI output give below
freeswitch@internal>
2017-06-04 06:05:19.657957 [NOTICE] switch_channel.c:1089 New Channel sofia/default/2036499237@myswitch.com [c9b52d04-48eb-11e7-bc8a-f3566a129896]
2017-06-04 06:05:19.657957 [DEBUG] switch_core_state_machine.c:473 (sofia/default/2036499237@myswitch.com) Running State Change CS_NEW
2017-06-04 06:05:19.657957 [DEBUG] sofia.c:9091 sofia/default/2036499237@myswitch.com receiving invite from 24.252.175.34:45646 version: 1.7.0 git 2751039 2015-07-15 21:57:05Z 64bit
2017-06-04 06:05:19.657957 [DEBUG] sofia.c:9258 IP 24.252.175.34 Rejected by acl "default". Falling back to Digest auth.
2017-06-04 06:05:19.657957 [WARNING] sofia_reg.c:1744 SIP auth challenge (INVITE) on sofia profile 'default' for [14808...@myswitch.com] from ip 24.252.175.34
2017-06-04 06:05:19.657957 [DEBUG] switch_core_state_machine.c:492 (sofia/default/2036499237@myswitch.com) State NEW
2017-06-04 06:05:19.657957 [DEBUG] sofia.c:2147 detaching session c9b52d04-48eb-11e7-bc8a-f3566a129896
2017-06-04 06:05:20.057952 [DEBUG] sofia.c:2255 Re-attaching to session c9b52d04-48eb-11e7-bc8a-f3566a129896
2017-06-04 06:05:20.057952 [DEBUG] sofia.c:9091 sofia/default/2036499237@myswitch.com receiving invite from 24.252.175.34:45646 version: 1.7.0 git 2751039 2015-07-15 21:57:05Z 64bit
2017-06-04 06:05:20.057952 [DEBUG] sofia.c:9258 IP 24.252.175.34 Rejected by acl "default". Falling back to Digest auth.
2017-06-04 06:05:20.217957 [DEBUG] sofia.c:6715 Channel sofia/default/2036499237@myswitch.com entering state [received][100]
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:2851 Set Codec sofia/default/2036499237@myswitch.com GSM/8000 20 ms 160 samples 13200 bits 1 channels
2017-06-04 06:05:20.217957 [DEBUG] switch_core_codec.c:111 sofia/default/2036499237@myswitch.com Original read codec set to GSM:3
2017-06-04 06:05:20.217957 [DEBUG] switch_core_media.c:4332 Set 2833 dtmf send/recv payload to 101
2017-06-04 06:05:20.217957 [DEBUG] sofia.c:7011 (sofia/default/2036499237@myswitch.com) State Change CS_NEW -> CS_INIT
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:473 (sofia/default/2036499237@myswitch.com) Running State Change CS_INIT
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:516 (sofia/default/2036499237@myswitch.com) State INIT
2017-06-04 06:05:20.217957 [DEBUG] mod_sofia.c:88 sofia/default/2036499237@myswitch.com SOFIA INIT
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:40 sofia/default/2036499237@myswitch.com Standard INIT
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:48 (sofia/default/2036499237@myswitch.com) State Change CS_INIT -> CS_ROUTING
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:516 (sofia/default/2036499237@myswitch.com) State INIT going to sleep
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:473 (sofia/default/2036499237@myswitch.com) Running State Change CS_ROUTING
2017-06-04 06:05:20.217957 [DEBUG] switch_channel.c:2239 (sofia/default/2036499237@myswitch.com) Callstate Change DOWN -> RINGING
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:532 (sofia/default/2036499237@myswitch.com) State ROUTING
2017-06-04 06:05:20.217957 [DEBUG] mod_sofia.c:141 sofia/default/2036499237@myswitch.com SOFIA ROUTING
2017-06-04 06:05:20.217957 [DEBUG] switch_core_state_machine.c:166 sofia/default/2036499237@myswitch.com Standard ROUTING
2017-06-04 06:05:20.217957 [INFO] mod_dialplan_xml.c:637 Processing 2036499237 <2036499237>->14808452938 in context default
Dialplan: sofia/default/2036499237@myswitch.com parsing [default->] continue=false
Dialplan: sofia/default/2036499237@myswitch.com Regex (PASS) [] destination_number(14808452938) =~ // break=on-false
Dialplan: sofia/default/2036499237@myswitch.com Action set(callstart=2017-06-04 06:05:20)
Dialplan: sofia/default/2036499237@myswitch.com Action set(call_processed=internal)
Dialplan: sofia/default/2036499237@myswitch.com Action set(originated_destination_number=14808452938)
Dialplan: sofia/default/2036499237@myswitch.com Action set(hangup_after_bridge=true)
Dialplan: sofia/default/2036499237@myswitch.com Action set(continue_on_fail=false)
Dialplan: sofia/default/2036499237@myswitch.com Action set(accountid=4)
Dialplan: sofia/default/2036499237@myswitch.com Action set(account_type=0)
Dialplan: sofia/default/2036499237@myswitch.com Action set(resellerid=0)
Dialplan: sofia/default/2036499237@myswitch.com Action set(accountcode=2036499237)
Dialplan: sofia/default/2036499237@myswitch.com Action set(call_direction=outbound)
Dialplan: sofia/default/2036499237@myswitch.com Action set(calltype=STANDARD)
Dialplan: sofia/default/2036499237@myswitch.com Action sched_hangup(+1440 allotted_timeout)
Dialplan: sofia/default/2036499237@myswitch.com Action log(INFO [Customer info] : [Account code: 2036499237, Rategroup Id: 4, Called number: 14808452938])
Dialplan: sofia/default/2036499237@myswitch.com Action set(origination_rates=ID:120736|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.01620|INC:60|RATEGROUP:4|MARKUP:0|ACCID:4)
Dialplan: sofia/default/2036499237@myswitch.com Action set(effective_destination_number=14808452938)
Dialplan: sofia/default/2036499237@myswitch.com Action set(termination_rates=ID:120739|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00810|INC:60|TRUNK:4|PROVIDER:2)
Dialplan: sofia/default/2036499237@myswitch.com Action limit(db myoutboundtrunk gw_myoutboundtrunk 100)
Dialplan: sofia/default/2036499237@myswitch.com Action set(absolute_codec_string=G729,GSM,PCMU,PCMA)
Dialplan: sofia/default/2036499237@myswitch.com Action bridge(sofia/gateway/myoutboundtrunk/001110214808452938)
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:216 (sofia/default/2036499237@myswitch.com) State Change CS_ROUTING -> CS_EXECUTE
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:532 (sofia/default/2036499237@myswitch.com) State ROUTING going to sleep
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:473 (sofia/default/2036499237@myswitch.com) Running State Change CS_EXECUTE
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:539 (sofia/default/2036499237@myswitch.com) State EXECUTE
2017-06-04 06:05:20.397957 [DEBUG] mod_sofia.c:196 sofia/default/2036499237@myswitch.com SOFIA EXECUTE
2017-06-04 06:05:20.397957 [DEBUG] switch_core_state_machine.c:258 sofia/default/2036499237@myswitch.com Standard EXECUTE
EXECUTE sofia/default/2036499237@myswitch.com set(callstart=2017-06-04 06:05:20)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [callstart]=[2017-06-04 06:05:20]
EXECUTE sofia/default/2036499237@myswitch.com set(call_processed=internal)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [call_processed]=[internal]
EXECUTE sofia/default/2036499237@myswitch.com set(originated_destination_number=14808452938)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [originated_destination_number]=[14808452938]
EXECUTE sofia/default/2036499237@myswitch.com set(hangup_after_bridge=true)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [hangup_after_bridge]=[true]
EXECUTE sofia/default/2036499237@myswitch.com set(continue_on_fail=false)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [continue_on_fail]=[false]
EXECUTE sofia/default/2036499237@myswitch.com set(accountid=4)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [accountid]=[4]
EXECUTE sofia/default/2036499237@myswitch.com set(account_type=0)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [account_type]=[0]
EXECUTE sofia/default/2036499237@myswitch.com set(resellerid=0)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [resellerid]=[0]
EXECUTE sofia/default/2036499237@myswitch.com set(accountcode=2036499237)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [accountcode]=[2036499237]
EXECUTE sofia/default/2036499237@myswitch.com set(call_direction=outbound)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [call_direction]=[outbound]
EXECUTE sofia/default/2036499237@myswitch.com set(calltype=STANDARD)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [calltype]=[STANDARD]
EXECUTE sofia/default/2036499237@myswitch.com sched_hangup(+1440 allotted_timeout)
2017-06-04 06:05:20.397957 [DEBUG] switch_scheduler.c:249 Added task 1914 switch_ivr_schedule_hangup (c9b52d04-48eb-11e7-bc8a-f3566a129896) to run at 1496557760
EXECUTE sofia/default/2036499237@myswitch.com log(INFO [Customer info] : [Account code: 2036499237, Rategroup Id: 4, Called number: 14808452938])
2017-06-04 06:05:20.397957 [INFO] mod_dptools.c:1683 [Customer info] : [Account code: 2036499237, Rategroup Id: 4, Called number: 14808452938]
EXECUTE sofia/default/2036499237@myswitch.com set(origination_rates=ID:120736|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.01620|INC:60|RATEGROUP:4|MARKUP:0|ACCID:4)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [origination_rates]=[ID:120736|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.01620|INC:60|RATEGROUP:4|MARKUP:0|ACCID:4]
EXECUTE sofia/default/2036499237@myswitch.com set(effective_destination_number=14808452938)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [effective_destination_number]=[14808452938]
EXECUTE sofia/default/2036499237@myswitch.com set(termination_rates=ID:120739|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00810|INC:60|TRUNK:4|PROVIDER:2)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [termination_rates]=[ID:120739|CODE:^1480.*|DESTINATION:United States - OnNet - AZ - 480|CONNECTIONCOST:0.00000|INCLUDEDSECONDS:0|COST:0.00810|INC:60|TRUNK:4|PROVIDER:2]
EXECUTE sofia/default/2036499237@myswitch.com limit(db myoutboundtrunk gw_myoutboundtrunk 100)
2017-06-04 06:05:20.397957 [DEBUG] switch_limit.c:126 incr called: myoutboundtrunk_gw_myoutboundtrunk max:100, interval:0
2017-06-04 06:05:20.397957 [DEBUG] mod_db.c:194 Usage for myoutboundtrunk_gw_myoutboundtrunk is now 1/100
EXECUTE sofia/default/2036499237@myswitch.com set(absolute_codec_string=G729,GSM,PCMU,PCMA)
2017-06-04 06:05:20.397957 [DEBUG] mod_dptools.c:1489 SET sofia/default/2036499237@myswitch.com [absolute_codec_string]=[G729,GSM,PCMU,PCMA]
EXECUTE sofia/default/2036499237@myswitch.com bridge(sofia/gateway/myoutboundtrunk/001110214808452938)
2017-06-04 06:05:52.418038 [NOTICE] switch_channel.c:4800 Hangup sofia/default/2036499237@myswitch.com [CS_EXECUTE] [RECOVERY_ON_TIMER_EXPIRE]
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:473 (sofia/default/001110214808452938) Running State Change CS_REPORTING
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:827 (sofia/default/001110214808452938) State REPORTING
2017-06-04 06:05:52.418038 [DEBUG] switch_core_session.c:2926 sofia/default/2036499237@myswitch.com skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:539 (sofia/default/2036499237@myswitch.com) State EXECUTE going to sleep
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:473 (sofia/default/2036499237@myswitch.com) Running State Change CS_HANGUP
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:739 (sofia/default/2036499237@myswitch.com) Callstate Change RINGING -> HANGUP
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:741 (sofia/default/2036499237@myswitch.com) State HANGUP
2017-06-04 06:05:52.418038 [DEBUG] mod_sofia.c:425 sofia/default/2036499237@myswitch.com Overriding SIP cause 504 with 408 from the other leg
2017-06-04 06:05:52.418038 [DEBUG] mod_sofia.c:431 Channel sofia/default/2036499237@myswitch.com hanging up, cause: RECOVERY_ON_TIMER_EXPIRE
2017-06-04 06:05:52.418038 [DEBUG] mod_sofia.c:568 Responding to INVITE with: 408
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:60 sofia/default/2036499237@myswitch.com Standard HANGUP, cause: RECOVERY_ON_TIMER_EXPIRE
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:741 (sofia/default/2036499237@myswitch.com) State HANGUP going to sleep
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:508 (sofia/default/2036499237@myswitch.com) State Change CS_HANGUP -> CS_REPORTING
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:473 (sofia/default/2036499237@myswitch.com) Running State Change CS_REPORTING
2017-06-04 06:05:52.418038 [DEBUG] switch_core_state_machine.c:827 (sofia/default/2036499237@myswitch.com) State REPORTING
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:104 sofia/default/001110214808452938 Standard REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:827 (sofia/default/001110214808452938) State REPORTING going to sleep
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:499 (sofia/default/001110214808452938) State Change CS_REPORTING -> CS_DESTROY
2017-06-04 06:05:52.717935 [DEBUG] switch_core_session.c:1639 Session 3831 (sofia/default/001110214808452938) Locked, Waiting on external entities
2017-06-04 06:05:52.717935 [NOTICE] switch_core_session.c:1657 Session 3831 (sofia/default/001110214808452938) Ended
2017-06-04 06:05:52.717935 [NOTICE] switch_core_session.c:1661 Close Channel sofia/default/001110214808452938 [CS_DESTROY]
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:630 (sofia/default/001110214808452938) Running State Change CS_DESTROY
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:640 (sofia/default/001110214808452938) State DESTROY
2017-06-04 06:05:52.717935 [DEBUG] mod_sofia.c:341 sofia/default/001110214808452938 SOFIA DESTROY
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:111 sofia/default/001110214808452938 Standard DESTROY
2017-06-04 06:05:52.717935 [DEBUG] switch_core_state_machine.c:640 (sofia/default/001110214808452938) State DESTROY going to sleep
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:104 sofia/default/2036499237@myswitch.com Standard REPORTING, cause: RECOVERY_ON_TIMER_EXPIRE
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:827 (sofia/default/2036499237@myswitch.com) State REPORTING going to sleep
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:499 (sofia/default/2036499237@myswitch.com) State Change CS_REPORTING -> CS_DESTROY
2017-06-04 06:05:52.737937 [DEBUG] switch_core_session.c:1639 Session 3830 (sofia/default/2036499237@myswitch.com) Locked, Waiting on external entities
2017-06-04 06:05:52.737937 [NOTICE] switch_core_session.c:1657 Session 3830 (sofia/default/2036499237@myswitch.com) Ended
2017-06-04 06:05:52.737937 [NOTICE] switch_core_session.c:1661 Close Channel sofia/default/2036499237@myswitch.com [CS_DESTROY]
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:630 (sofia/default/2036499237@myswitch.com) Running State Change CS_DESTROY
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:640 (sofia/default/2036499237@myswitch.com) State DESTROY
2017-06-04 06:05:52.737937 [DEBUG] mod_sofia.c:341 sofia/default/2036499237@myswitch.com SOFIA DESTROY
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:111 sofia/default/2036499237@myswitch.com Standard DESTROY
2017-06-04 06:05:52.737937 [DEBUG] switch_core_state_machine.c:640 (sofia/default/2036499237@myswitch.com) State DESTROY going to sleep
2017-06-04 06:05:52.897955 [DEBUG] switch_scheduler.c:144 Deleting task 1914 switch_ivr_schedule_hangup (c9b52d04-48eb-11e7-bc8a-f3566a129896)
freeswitch@internal>
Thanks
--
=====================================================================
Documentation : https://astppdoc.atlassian.net/
Please contact at sa...@inextrix.com for commercial support.
---
You received this message because you are subscribed to the Google Groups "ASTPP" group.
To unsubscribe from this group and stop receiving emails from it, send an email to astpp+unsubscribe@googlegroups.com.
To post to this group, send email to as...@googlegroups.com.
Visit this group at https://groups.google.com/group/astpp.
To view this discussion on the web visit https://groups.google.com/d/msgid/astpp/f3e0cb1e-2325-4941-a27c-052f827f10d6%40googlegroups.com.
For more options, visit https://groups.google.com/d/optout.
Intel Networks
To view this discussion on the web visit https://groups.google.com/d/msgid/astpp/CAFABgc1nVNCtr2VgerMBwaoqeYhC4EaFyXsmTgVmgrxajMAR5w%40mail.gmail.com.