Any call transfers disconnects

Status
Not open for further replies.
R

Ruckol1

New Member
May 28, 2020
4
0
1
32
Hi all,

I am having a bizarre issue that arose after precisely 0 changes to this box. Whenever a call is attempted to be transferred, whether it's automatically from an IVR, or manually by an end user, the call is dropped, or never established. I've also been able to recreate this behavior by having end users attempt to dial eachother by extension. The handsets ring, but a call is never established.

Outbound calls work fine, follow-me (forwarding to cell phones) work fine. All IVRs play fine, and receive the correct DTMF inputs fine. Gateways are fine. Confirmed end-users firewalls have whitelisted all traffic from PBX WAN IP, and can even see all traffic being allowed in logs. The server has been rebooted.
 
R

Ruckol1

New Member
May 28, 2020
4
0
1
32
Version 4.5.13

Added some logging below:

Code: 
25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 parsing [intech.pbx.domainxxx.com->talking clock date] continue=
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Regex (FAIL) [talking clock date] destination_number(148) =~ /^\*9171$/ break=on-false
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 parsing [subdomain.pbx.domainxxx.com->local_extension] continue=true
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Regex (PASS) [local_extension] ${user_exists}(true) =~ /true/ break=on-false
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action export(dialed_extension=${destination_number}) INLINE
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 export(dialed_extension=148)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [dialed_extension]=[148]
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action limit(hash ${domain_name} ${destination_number} ${limit_max} ${limit_destination})
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Regex (PASS) [local_extension] () =~ // break=on-false
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action set(hangup_after_bridge=true)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action set(continue_on_fail=true)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action set(called_party_call_group=${user_data(${dialed_extension}@${domain_name} var call_group)})
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action hash(insert/${domain_name}-last_dial/${called_party_call_group}/${uuid})
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action set(api_hangup_hook=lua app.lua hangup)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action export(domain_name=${domain_name})
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action bridge(user/${destination_number}@${domain_name})
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action lua(app.lua failure_handler)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 parsing [subdomain.pbx.domainxxx.com->voicemail] continue=false
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Regex (PASS) [voicemail] ${user_exists}(true) =~ /true/ break=on-false
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action set(record_append=false)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action set(voicemail_action=save)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action set(voicemail_id=${destination_number})
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action set(voicemail_profile=default)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de Dialplan: sofia/external/905XXXXXXX@208.100.60.53 Action lua(app.lua voicemail)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] switch_core_state_machine.c:287 (sofia/external/905XXXXXXX@208.100.60.53) State Change CS_ROUTING -> CS_EXECUTE
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] switch_core_state_machine.c:644 (sofia/external/905XXXXXXX@208.100.60.53) State ROUTING going to sleep
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] switch_core_state_machine.c:585 (sofia/external/905XXXXXXX@208.100.60.53) Running State Change CS_EXECUTE (Cur 1 Tot 54)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] switch_channel.c:2334 (sofia/external/905XXXXXXX@208.100.60.53) Callstate Change RINGING -> ACTIVE
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] switch_core_state_machine.c:651 (sofia/external/905XXXXXXX@208.100.60.53) State EXECUTE
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] mod_sofia.c:209 sofia/external/905XXXXXXX@208.100.60.53 SOFIA EXECUTE
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] switch_core_state_machine.c:329 sofia/external/905XXXXXXX@208.100.60.53 Standard EXECUTE
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 set(RFC2822_DATE=Tue, 04 Jul 2023 13:23:23 -0400)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] mod_dptools.c:1672 SET sofia/external/905XXXXXXX@208.100.60.53 [RFC2822_DATE]=[Tue, 04 Jul 2023 13:23:23 -0400]
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 export(origination_callee_id_name=148)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [origination_callee_id_name]=[148]
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 hash(insert/subdomain.pbx.domainxxx.com-last_dial/905XXXXXXX/148)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 eval(not_secure)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 limit(hash subdomain.pbx.domainxxx.com 148 )
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] switch_limit.c:124 incr called: subdomain.pbx.domainxxx.com_148 max:-1, interval:0
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] mod_hash.c:194 Usage for subdomain.pbx.domainxxx.com_148 is now 1
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 set(hangup_after_bridge=true)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] mod_dptools.c:1672 SET sofia/external/905XXXXXXX@208.100.60.53 [hangup_after_bridge]=[true]
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 set(continue_on_fail=true)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.697199 [DEBUG] mod_dptools.c:1672 SET sofia/external/905XXXXXXX@208.100.60.53 [continue_on_fail]=[true]
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 hash(insert/subdomain.pbx.domainxxx.com-call_return/148/905XXXXXXX)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 hash(insert/subdomain.pbx.domainxxx.com-last_dial_ext/148/96a3ff09-f261-4f0a-ab09-7ff4eefa25de)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 set(called_party_call_group=)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] mod_dptools.c:1672 SET sofia/external/905XXXXXXX@208.100.60.53 [called_party_call_group]=[UNDEF]
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 hash(insert/subdomain.pbx.domainxxx.com-last_dial//96a3ff09-f261-4f0a-ab09-7ff4eefa25de)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 set(api_hangup_hook=lua app.lua hangup)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] mod_dptools.c:1672 SET sofia/external/905XXXXXXX@208.100.60.53 [api_hangup_hook]=[lua app.lua hangup]
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 export(domain_name=subdomain.pbx.domainxxx.com)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [domain_name]=[subdomain.pbx.domainxxx.com]
96a3ff09-f261-4f0a-ab09-7ff4eefa25de EXECUTE [depth=0] sofia/external/905XXXXXXX@208.100.60.53 bridge(user/148@subdomain.pbx.domainxxx.com)
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1906 (sofia/external/905XXXXXXX@208.100.60.53) Callstate Change ACTIVE -> RING_WAIT
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [call_direction]=[inbound] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [call_direction]=[inbound] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [call_direction]=[inbound] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [origination_callee_id_name]=[148] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [dialed_extension]=[148] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [origination_callee_id_name]=[148] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [domain_name]=[subdomain.pbx.domainxxx.com] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_ivr_originate.c:2212 Parsing global variables
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [call_direction]=[inbound] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [call_direction]=[inbound] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [call_direction]=[inbound] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [origination_callee_id_name]=[148] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [dialed_extension]=[148] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [origination_callee_id_name]=[148] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_channel.c:1264 sofia/external/905XXXXXXX@208.100.60.53 EXPORTING[export_vars] [domain_name]=[subdomain.pbx.domainxxx.com] to event
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.717195 [DEBUG] switch_ivr_originate.c:2212 Parsing global variables
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [NOTICE] switch_channel.c:1118 New Channel sofia/external/148@192.168.10.110:5060 [2ab3cc2d-141c-434c-bf84-81cedbab032f]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] mod_sofia.c:5089 (sofia/external/148@192.168.10.110:5060) State Change CS_NEW -> CS_INIT
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_core_state_machine.c:585 (sofia/external/148@192.168.10.110:5060) Running State Change CS_INIT (Cur 2 Tot 55)
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_core_state_machine.c:628 (sofia/external/148@192.168.10.110:5060) State INIT
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] mod_sofia.c:93 sofia/external/148@192.168.10.110:5060 SOFIA INIT
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] sofia_glue.c:1587 sip:148@184.68.255.150:4921 Setting proxy route to sofia/external/148@192.168.10.110:5060
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] sofia_glue.c:1618 sofia/external/148@192.168.10.110:5060 sending invite version: 1.10.2 -release-14-f7bdd3845a 64bit
2ab3cc2d-141c-434c-bf84-81cedbab032f Local SDP:
2ab3cc2d-141c-434c-bf84-81cedbab032f v=0
2ab3cc2d-141c-434c-bf84-81cedbab032f o=FreeSWITCH 1688472679 1688472680 IN IP4 wan.ip.here
2ab3cc2d-141c-434c-bf84-81cedbab032f s=FreeSWITCH
2ab3cc2d-141c-434c-bf84-81cedbab032f c=IN IP4 wan.ip.here
2ab3cc2d-141c-434c-bf84-81cedbab032f t=0 0
2ab3cc2d-141c-434c-bf84-81cedbab032f m=audio 18724 RTP/AVP 0 8 101
2ab3cc2d-141c-434c-bf84-81cedbab032f a=rtpmap:0 PCMU/8000
2ab3cc2d-141c-434c-bf84-81cedbab032f a=rtpmap:8 PCMA/8000
2ab3cc2d-141c-434c-bf84-81cedbab032f a=rtpmap:101 telephone-event/8000
2ab3cc2d-141c-434c-bf84-81cedbab032f a=fmtp:101 0-16
2ab3cc2d-141c-434c-bf84-81cedbab032f a=silenceSuppff - - - -
2ab3cc2d-141c-434c-bf84-81cedbab032f a=ptime:20
2ab3cc2d-141c-434c-bf84-81cedbab032f a=sendrecv
2ab3cc2d-141c-434c-bf84-81cedbab032f
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_core_state_machine.c:40 sofia/external/148@192.168.10.110:5060 Standard INIT
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_core_state_machine.c:48 (sofia/external/148@192.168.10.110:5060) State Change CS_INIT -> CS_ROUTING
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_core_state_machine.c:628 (sofia/external/148@192.168.10.110:5060) State INIT going to sleep
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_core_state_machine.c:585 (sofia/external/148@192.168.10.110:5060) Running State Change CS_ROUTING (Cur 2 Tot 55)
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] sofia.c:7301 Channel sofia/external/148@192.168.10.110:5060 entering state [calling][0]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_core_state_machine.c:644 (sofia/external/148@192.168.10.110:5060) State ROUTING
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] mod_sofia.c:154 sofia/external/148@192.168.10.110:5060 SOFIA ROUTING
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_ivr_originate.c:67 (sofia/external/148@192.168.10.110:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_core_state_machine.c:644 (sofia/external/148@192.168.10.110:5060) State ROUTING going to sleep
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_core_state_machine.c:585 (sofia/external/148@192.168.10.110:5060) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 55)
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_core_state_machine.c:663 (sofia/external/148@192.168.10.110:5060) State CONSUME_MEDIA
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.717195 [DEBUG] switch_core_state_machine.c:663 (sofia/external/148@192.168.10.110:5060) State CONSUME_MEDIA going to sleep
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.837200 [DEBUG] sofia.c:7301 Channel sofia/external/148@192.168.10.110:5060 entering state [proceeding][180]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.837200 [NOTICE] sofia.c:7412 Ring-Ready sofia/external/148@192.168.10.110:5060!
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:23.837200 [DEBUG] switch_channel.c:3437 (sofia/external/148@192.168.10.110:5060) Callstate Change DOWN -> RINGING
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.857206 [DEBUG] switch_ivr_originate.c:1304 Raw Codec Activation Success L16@8000hz 1 channel 20ms
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.857206 [DEBUG] switch_core_codec.c:223 sofia/external/905XXXXXXX@208.100.60.53 Push codec L16:100
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:23.857206 [DEBUG] switch_ivr_originate.c:1378 Play Ringback Tone [%(2000,4000,440,480)]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] sofia.c:7301 Channel sofia/external/148@192.168.10.110:5060 entering state [completing][200]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] sofia.c:7311 Remote SDP:
2ab3cc2d-141c-434c-bf84-81cedbab032f v=0
2ab3cc2d-141c-434c-bf84-81cedbab032f o=- 20003 20003 IN IP4 192.168.10.110
2ab3cc2d-141c-434c-bf84-81cedbab032f s=SDP data
2ab3cc2d-141c-434c-bf84-81cedbab032f c=IN IP4 192.168.10.110
2ab3cc2d-141c-434c-bf84-81cedbab032f t=0 0
2ab3cc2d-141c-434c-bf84-81cedbab032f m=audio 11940 RTP/AVP 0 101
2ab3cc2d-141c-434c-bf84-81cedbab032f a=rtpmap:0 PCMU/8000
2ab3cc2d-141c-434c-bf84-81cedbab032f a=rtpmap:101 telephone-event/8000
2ab3cc2d-141c-434c-bf84-81cedbab032f a=fmtp:101 0-15
2ab3cc2d-141c-434c-bf84-81cedbab032f a=ptime:20
2ab3cc2d-141c-434c-bf84-81cedbab032f
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] sofia.c:7301 Channel sofia/external/148@192.168.10.110:5060 entering state [ready][200]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] switch_core_media.c:5647 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] switch_core_media.c:5508 Set telephone-event payload to 101@8000
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] switch_core_media.c:3837 Set Codec sofia/external/148@192.168.10.110:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] switch_core_codec.c:111 sofia/external/148@192.168.10.110:5060 Original read codec set to PCMU:0
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] switch_core_media.c:5851 Set telephone-event payload to 101@8000
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] switch_core_media.c:5909 sofia/external/148@192.168.10.110:5060 Set 2833 dtmf send payload to 101 recv payload to 101
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] switch_core_media.c:8659 AUDIO RTP [sofia/external/148@192.168.10.110:5060] wan.ip.here port 18724 -> 192.168.10.110 port 11940 codec: 0 ms: 20
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.657424 [DEBUG] switch_rtp.c:4408 Starting timer [soft] 160 bytes per 20ms
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.677201 [DEBUG] switch_core_media.c:8973 sofia/external/148@192.168.10.110:5060 Set 2833 dtmf send payload to 101
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.677201 [DEBUG] switch_core_media.c:8980 sofia/external/148@192.168.10.110:5060 Set 2833 dtmf receive payload to 101
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.677201 [DEBUG] switch_core_media.c:9003 sofia/external/148@192.168.10.110:5060 Set rtp dtmf delay to 40
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.677201 [NOTICE] sofia.c:8479 Channel [sofia/external/148@192.168.10.110:5060] has been answered
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.677201 [DEBUG] switch_channel.c:3865 (sofia/external/148@192.168.10.110:5060) Callstate Change RINGING -> ACTIVE
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:33.677201 [DEBUG] switch_core_codec.c:248 sofia/external/905XXXXXXX@208.100.60.53 Restore previous codec PCMU:0.
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:33.677201 [DEBUG] switch_ivr_originate.c:3809 Originate Resulted in Success: [sofia/external/148@192.168.10.110:5060]
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:33.677201 [DEBUG] switch_channel.c:2130 (sofia/external/905XXXXXXX@208.100.60.53) Callstate Change RING_WAIT -> ACTIVE
96a3ff09-f261-4f0a-ab09-7ff4eefa25de 2023-07-04 13:23:33.677201 [DEBUG] switch_ivr_originate.c:3809 Originate Resulted in Success: [sofia/external/148@192.168.10.110:5060]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.677201 [DEBUG] switch_ivr_bridge.c:1796 (sofia/external/148@192.168.10.110:5060) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.677201 [DEBUG] switch_core_state_machine.c:585 (sofia/external/148@192.168.10.110:5060) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 55)
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.677201 [DEBUG] switch_core_state_machine.c:654 (sofia/external/148@192.168.10.110:5060) State EXCHANGE_MEDIA
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.677201 [DEBUG] mod_sofia.c:656 SOFIA EXCHANGE_MEDIA
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.677201 [DEBUG] sofia.c:7301 Channel sofia/external/148@192.168.10.110:5060 entering state [calling][0]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.777232 [DEBUG] sofia.c:7301 Channel sofia/external/148@192.168.10.110:5060 entering state [ready][200]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.777232 [DEBUG] sofia.c:7311 Remote SDP:
2ab3cc2d-141c-434c-bf84-81cedbab032f v=0
2ab3cc2d-141c-434c-bf84-81cedbab032f o=- 20003 20004 IN IP4 192.168.10.110
2ab3cc2d-141c-434c-bf84-81cedbab032f s=SDP data
2ab3cc2d-141c-434c-bf84-81cedbab032f c=IN IP4 192.168.10.110
2ab3cc2d-141c-434c-bf84-81cedbab032f t=0 0
2ab3cc2d-141c-434c-bf84-81cedbab032f m=audio 11940 RTP/AVP 0 101
2ab3cc2d-141c-434c-bf84-81cedbab032f a=rtpmap:0 PCMU/8000
2ab3cc2d-141c-434c-bf84-81cedbab032f a=rtpmap:101 telephone-event/8000
2ab3cc2d-141c-434c-bf84-81cedbab032f a=fmtp:101 0-15
2ab3cc2d-141c-434c-bf84-81cedbab032f a=ptime:20
2ab3cc2d-141c-434c-bf84-81cedbab032f
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.777232 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.777232 [DEBUG] switch_core_media.c:5647 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.777232 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.777232 [DEBUG] switch_core_media.c:5508 Set telephone-event payload to 101@8000
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.777232 [DEBUG] switch_core_media.c:5851 Set telephone-event payload to 101@8000
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.777232 [DEBUG] switch_core_media.c:5909 sofia/external/148@192.168.10.110:5060 Set 2833 dtmf send payload to 101 recv payload to 101
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.777232 [DEBUG] sofia.c:8320 Processing updated SDP
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:33.777232 [DEBUG] switch_core_media.c:8641 Audio params are unchanged for sofia/external/148@192.168.10.110:5060.
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.677235 [NOTICE] sofia.c:1089 Hangup sofia/external/148@192.168.10.110:5060 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.697208 [DEBUG] switch_ivr_bridge.c:915 BRIDGE THREAD DONE [sofia/external/148@192.168.10.110:5060]
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.697208 [DEBUG] switch_core_state_machine.c:654 (sofia/external/148@192.168.10.110:5060) State EXCHANGE_MEDIA going to sleep
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.697208 [DEBUG] switch_core_state_machine.c:585 (sofia/external/148@192.168.10.110:5060) Running State Change CS_HANGUP (Cur 2 Tot 55)
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.697208 [DEBUG] switch_core_state_machine.c:848 (sofia/external/148@192.168.10.110:5060) Callstate Change ACTIVE -> HANGUP
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.697208 [DEBUG] switch_core_state_machine.c:850 (sofia/external/148@192.168.10.110:5060) State HANGUP
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.697208 [DEBUG] mod_sofia.c:453 Channel sofia/external/148@192.168.10.110:5060 hanging up, cause: NORMAL_CLEARING
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.697208 [DEBUG] switch_core_state_machine.c:60 sofia/external/148@192.168.10.110:5060 Standard HANGUP, cause: NORMAL_CLEARING
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.697208 [DEBUG] switch_core_state_machine.c:850 (sofia/external/148@192.168.10.110:5060) State HANGUP going to sleep
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.697208 [DEBUG] switch_core_state_machine.c:620 (sofia/external/148@192.168.10.110:5060) State Change CS_HANGUP -> CS_REPORTING
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.697208 [DEBUG] switch_core_state_machine.c:585 (sofia/external/148@192.168.10.110:5060) Running State Change CS_REPORTING (Cur 2 Tot 55)
2ab3cc2d-141c-434c-bf84-81cedbab032f 2023-07-04 13:23:38.697208 [DEBUG] switch_core_state_machine.c:936 (sofia/external/148@192.168.10.110:5060) State REPORTING
 
Status
Not open for further replies.
Top Bottom