FreeSWITCH Pastebin

Untitled

From Lousy Agouti, 5 Years ago, written in Plain Text.
- view diff
URL https://pastebin.freeswitch.org/view/edfc1f3e
Embed
Download Paste or View Raw
  1. recv 818 bytes from udp/[10.3.3.26]:5060 at 16:06:24.562561:
  2.    ------------------------------------------------------------------------
  3.    INVITE sip:17806860331@voice.polarisnetworks.ca SIP/2.0
  4.    Via: SIP/2.0/UDP 10.3.3.26:5060;branch=z9hG4bK-c18fe00b
  5.    From: 5878272002 <sip:5878272002@voice.polarisnetworks.ca>;tag=7c71b9d8f3653583o0
  6.    To: <sip:17806860331@voice.polarisnetworks.ca>
  7.    Call-ID: d7fdac3c-7a01466f@10.3.3.26
  8.    CSeq: 101 INVITE
  9.    Max-Forwards: 70
  10.    Contact: 5878272002 <sip:5878272002@10.3.3.26:5060>
  11.    Expires: 240
  12.    User-Agent: Linksys/PAP2T-5.1.6(LS)
  13.    Content-Length: 247
  14.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  15.    Supported: x-sipura, replaces
  16.    Content-Type: application/sdp
  17.  
  18.    v=0
  19.    o=- 406268 406268 IN IP4 10.3.3.26
  20.    s=-
  21.    c=IN IP4 10.3.3.26
  22.    t=0 0
  23.    m=audio 16440 RTP/AVP 8 100 101
  24.    a=rtpmap:8 PCMA/8000
  25.    a=rtpmap:100 NSE/8000
  26.    a=fmtp:100 192-193
  27.    a=rtpmap:101 telephone-event/8000
  28.    a=fmtp:101 0-15
  29.    a=ptime:30
  30.    a=sendrecv
  31.    ------------------------------------------------------------------------
  32. send 309 bytes to udp/[10.3.3.26]:5060 at 16:06:24.563166:
  33.    ------------------------------------------------------------------------
  34.    SIP/2.0 100 Trying
  35.    Via: SIP/2.0/UDP 10.3.3.26:5060;branch=z9hG4bK-c18fe00b
  36.    From: 5878272002 <sip:5878272002@voice.polarisnetworks.ca>;tag=7c71b9d8f3653583o0
  37.    To: <sip:17806860331@voice.polarisnetworks.ca>
  38.    Call-ID: d7fdac3c-7a01466f@10.3.3.26
  39.    CSeq: 101 INVITE
  40.    User-Agent: FreeSWITCH
  41.    Content-Length: 0
  42.  
  43.    ------------------------------------------------------------------------
  44. 2018-10-03 16:06:24.559488 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/5878272002@voice.polarisnetworks.ca [916c2d98-c758-11e8-9d0e-c3d2c916e7a3]
  45. 2018-10-03 16:06:24.559488 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5878272002@voice.polarisnetworks.ca) Running State Change CS_NEW (Cur 1 Tot 36)
  46. 2018-10-03 16:06:24.559488 [DEBUG] sofia.c:9834 sofia/internal/5878272002@voice.polarisnetworks.ca receiving invite from 10.3.3.26:5060 version: 1.6.17  64bit
  47. 2018-10-03 16:06:24.559488 [DEBUG] sofia.c:10005 IP 10.3.3.26 Rejected by acl "domains". Falling back to Digest auth.
  48. send 824 bytes to udp/[10.3.3.26]:5060 at 16:06:24.566858:
  49.    ------------------------------------------------------------------------
  50.    SIP/2.0 407 Proxy Authentication Required
  51.    Via: SIP/2.0/UDP 10.3.3.26:5060;branch=z9hG4bK-c18fe00b
  52.    From: 5878272002 <sip:5878272002@voice.polarisnetworks.ca>;tag=7c71b9d8f3653583o0
  53.    To: <sip:17806860331@voice.polarisnetworks.ca>;tag=7H3gXyQea9Sye
  54.    Call-ID: d7fdac3c-7a01466f@10.3.3.26
  55.    CSeq: 101 INVITE
  56.    User-Agent: FreeSWITCH
  57.    Accept: application/sdp
  58.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  59.    Supported: timer, path, replaces
  60.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  61.    Proxy-Authenticate: Digest realm="voice.polarisnetworks.ca", nonce="916c8cfc-c758-11e8-9d0f-c3d2c916e7a3", algorithm=MD5, qop="auth"
  62.    Content-Length: 0
  63.  
  64.    ------------------------------------------------------------------------
  65. 2018-10-03 16:06:24.559488 [DEBUG] sofia.c:2334 detaching session 916c2d98-c758-11e8-9d0e-c3d2c916e7a3
  66. 2018-10-03 16:06:24.559488 [WARNING] sofia_reg.c:1792 SIP auth challenge (INVITE) on sofia profile 'internal' for [17806860331@voice.polarisnetworks.ca] from ip 10.3.3.26
  67. 2018-10-03 16:06:24.559488 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/5878272002@voice.polarisnetworks.ca) State NEW
  68. recv 442 bytes from udp/[10.3.3.26]:5060 at 16:06:24.582048:
  69.    ------------------------------------------------------------------------
  70.    ACK sip:17806860331@voice.polarisnetworks.ca SIP/2.0
  71.    Via: SIP/2.0/UDP 10.3.3.26:5060;branch=z9hG4bK-c18fe00b
  72.    From: 5878272002 <sip:5878272002@voice.polarisnetworks.ca>;tag=7c71b9d8f3653583o0
  73.    To: <sip:17806860331@voice.polarisnetworks.ca>;tag=7H3gXyQea9Sye
  74.    Call-ID: d7fdac3c-7a01466f@10.3.3.26
  75.    CSeq: 101 ACK
  76.    Max-Forwards: 70
  77.    Contact: 5878272002 <sip:5878272002@10.3.3.26:5060>
  78.    User-Agent: Linksys/PAP2T-5.1.6(LS)
  79.    Content-Length: 0
  80.  
  81.    ------------------------------------------------------------------------
  82. recv 1090 bytes from udp/[10.3.3.26]:5060 at 16:06:24.591014:
  83.    ------------------------------------------------------------------------
  84.    INVITE sip:17806860331@voice.polarisnetworks.ca SIP/2.0
  85.    Via: SIP/2.0/UDP 10.3.3.26:5060;branch=z9hG4bK-beb255b
  86.    From: 5878272002 <sip:5878272002@voice.polarisnetworks.ca>;tag=7c71b9d8f3653583o0
  87.    To: <sip:17806860331@voice.polarisnetworks.ca>
  88.    Call-ID: d7fdac3c-7a01466f@10.3.3.26
  89.    CSeq: 102 INVITE
  90.    Max-Forwards: 70
  91.    Proxy-Authorization: Digest username="5878272002",realm="voice.polarisnetworks.ca",nonce="916c8cfc-c758-11e8-9d0f-c3d2c916e7a3",uri="sip:17806860331@voice.polarisnetworks.ca",algorithm=MD5,response="3147e80a86a64ee560364738ddb17fea",qop=auth,nc=00000001,cnonce="f49c8cef"
  92.    Contact: 5878272002 <sip:5878272002@10.3.3.26:5060>
  93.    Expires: 240
  94.    User-Agent: Linksys/PAP2T-5.1.6(LS)
  95.    Content-Length: 247
  96.    Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
  97.    Supported: x-sipura, replaces
  98.    Content-Type: application/sdp
  99.  
  100.    v=0
  101.    o=- 406268 406268 IN IP4 10.3.3.26
  102.    s=-
  103.    c=IN IP4 10.3.3.26
  104.    t=0 0
  105.    m=audio 16440 RTP/AVP 8 100 101
  106.    a=rtpmap:8 PCMA/8000
  107.    a=rtpmap:100 NSE/8000
  108.    a=fmtp:100 192-193
  109.    a=rtpmap:101 telephone-event/8000
  110.    a=fmtp:101 0-15
  111.    a=ptime:30
  112.    a=sendrecv
  113.    ------------------------------------------------------------------------
  114. send 308 bytes to udp/[10.3.3.26]:5060 at 16:06:24.591502:
  115.    ------------------------------------------------------------------------
  116.    SIP/2.0 100 Trying
  117.    Via: SIP/2.0/UDP 10.3.3.26:5060;branch=z9hG4bK-beb255b
  118.    From: 5878272002 <sip:5878272002@voice.polarisnetworks.ca>;tag=7c71b9d8f3653583o0
  119.    To: <sip:17806860331@voice.polarisnetworks.ca>
  120.    Call-ID: d7fdac3c-7a01466f@10.3.3.26
  121.    CSeq: 102 INVITE
  122.    User-Agent: FreeSWITCH
  123.    Content-Length: 0
  124.  
  125.    ------------------------------------------------------------------------
  126. 2018-10-03 16:06:24.579415 [DEBUG] sofia.c:2442 Re-attaching to session 916c2d98-c758-11e8-9d0e-c3d2c916e7a3
  127. 2018-10-03 16:06:24.599416 [DEBUG] sofia.c:9834 sofia/internal/5878272002@voice.polarisnetworks.ca receiving invite from 10.3.3.26:5060 version: 1.6.17  64bit
  128. 2018-10-03 16:06:24.599416 [DEBUG] sofia.c:10005 IP 10.3.3.26 Rejected by acl "domains". Falling back to Digest auth.
  129. 2018-10-03 16:06:24.619416 [DEBUG] sofia.c:7048 Channel sofia/internal/5878272002@voice.polarisnetworks.ca entering state [received][100]
  130. 2018-10-03 16:06:24.619416 [DEBUG] sofia.c:7058 Remote SDP:
  131. v=0
  132. o=- 406268 406268 IN IP4 10.3.3.26
  133. s=-
  134. c=IN IP4 10.3.3.26
  135. t=0 0
  136. m=audio 16440 RTP/AVP 8 100 101
  137. a=rtpmap:8 PCMA/8000
  138. a=rtpmap:100 NSE/8000
  139. a=fmtp:100 192-193
  140. a=rtpmap:101 telephone-event/8000
  141. a=fmtp:101 0-15
  142. a=ptime:30
  143.  
  144. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:30:64000:1]/[PCMU:0:8000:20:64000:1]
  145. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:30:64000:1]/[PCMA:8:8000:20:64000:1]
  146. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4472 Audio Codec Compare [PCMA:8:8000:20:64000:1] is saved as a near-match
  147. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:30:64000:1]/[G7221:115:32000:20:48000:1]
  148. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:30:64000:1]/[G7221:107:16000:20:32000:1]
  149. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:30:64000:1]/[G722:9:8000:20:64000:1]
  150. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [PCMA:8:8000:30:64000:1]/[GSM:3:8000:20:13200:1]
  151. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [NSE:100:8000:30:0:1]/[PCMU:0:8000:20:64000:1]
  152. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [NSE:100:8000:30:0:1]/[PCMA:8:8000:20:64000:1]
  153. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [NSE:100:8000:30:0:1]/[G7221:115:32000:20:48000:1]
  154. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [NSE:100:8000:30:0:1]/[G7221:107:16000:20:32000:1]
  155. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [NSE:100:8000:30:0:1]/[G722:9:8000:20:64000:1]
  156. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4436 Audio Codec Compare [NSE:100:8000:30:0:1]/[GSM:3:8000:20:13200:1]
  157. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4352 Set telephone-event payload to 101@8000
  158. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4543 Substituting codec PCMA@30i@8000h@1c
  159. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:3056 Set Codec sofia/internal/5878272002@voice.polarisnetworks.ca PCMA/8000 30 ms 240 samples 64000 bits 1 channels
  160. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_codec.c:111 sofia/internal/5878272002@voice.polarisnetworks.ca Original read codec set to PCMA:8
  161. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4695 Set telephone-event payload to 101@8000
  162. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_media.c:4754 sofia/internal/5878272002@voice.polarisnetworks.ca Set 2833 dtmf send payload to 101 recv payload to 101
  163. 2018-10-03 16:06:24.619416 [DEBUG] sofia.c:7471 (sofia/internal/5878272002@voice.polarisnetworks.ca) State Change CS_NEW -> CS_INIT
  164. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5878272002@voice.polarisnetworks.ca) Running State Change CS_INIT (Cur 1 Tot 36)
  165. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/5878272002@voice.polarisnetworks.ca) State INIT
  166. 2018-10-03 16:06:24.619416 [DEBUG] mod_sofia.c:90 sofia/internal/5878272002@voice.polarisnetworks.ca SOFIA INIT
  167. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_state_machine.c:40 sofia/internal/5878272002@voice.polarisnetworks.ca Standard INIT
  168. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/5878272002@voice.polarisnetworks.ca) State Change CS_INIT -> CS_ROUTING
  169. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/5878272002@voice.polarisnetworks.ca) State INIT going to sleep
  170. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5878272002@voice.polarisnetworks.ca) Running State Change CS_ROUTING (Cur 1 Tot 36)
  171. 2018-10-03 16:06:24.619416 [DEBUG] switch_channel.c:2249 (sofia/internal/5878272002@voice.polarisnetworks.ca) Callstate Change DOWN -> RINGING
  172. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5878272002@voice.polarisnetworks.ca) State ROUTING
  173. 2018-10-03 16:06:24.619416 [DEBUG] mod_sofia.c:143 sofia/internal/5878272002@voice.polarisnetworks.ca SOFIA ROUTING
  174. 2018-10-03 16:06:24.619416 [DEBUG] switch_core_state_machine.c:236 sofia/internal/5878272002@voice.polarisnetworks.ca Standard ROUTING
  175. 2018-10-03 16:06:24.619416 [INFO] mod_dialplan_xml.c:637 Processing 5878272002 <5878272002>->17806860331 in context voice.polarisnetworks.ca
  176. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->user_exists] continue=true
  177. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (PASS) [user_exists] () =~ // break=on-false
  178. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
  179. 2018-10-03 16:06:24.799427 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7eff0c0db020 Connected.
  180. 2018-10-03 16:06:24.839428 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7eff0c0db020 released.
  181. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(user_exists=false)
  182. 2018-10-03 16:06:24.839428 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [user_exists]=[false]
  183. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
  184. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->call-direction] continue=true
  185. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never
  186. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca ANTI-Action set(call_direction=local)
  187. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->variables] continue=true
  188. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (PASS) [variables] () =~ // break=on-false
  189. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action export(origination_callee_id_name=${destination_number})
  190. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  191. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->user_record] continue=true
  192. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (PASS) [user_record] () =~ // break=on-false
  193. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
  194. 2018-10-03 16:06:24.859428 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7eff0c0db020 Connected.
  195. 2018-10-03 16:06:24.879441 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7eff0c0db020 released.
  196. 2018-10-03 16:06:24.899422 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7eff0c0db020 Connected.
  197. 2018-10-03 16:06:24.899422 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7eff0c0db020 released.
  198. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(user_record=)
  199. 2018-10-03 16:06:24.899422 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [user_record]=[UNDEF]
  200. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
  201. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(from_user_exists=true)
  202. 2018-10-03 16:06:24.919426 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [from_user_exists]=[true]
  203. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  204. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
  205. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  206. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
  207. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
  208. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  209. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
  210. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
  211. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  212. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
  213. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
  214. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  215. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(from_user_record=${user_data ${sip_from_user}@${sip_from_host} var user_record}) INLINE
  216. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(from_user_record=)
  217. 2018-10-03 16:06:24.939417 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [from_user_record]=[UNDEF]
  218. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  219. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
  220. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  221. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
  222. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
  223. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  224. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
  225. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
  226. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  227. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
  228. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
  229. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
  230. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->redial] continue=true
  231. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [redial] destination_number(17806860331) =~ /^(redial|\*870)$/ break=on-true
  232. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (PASS) [redial] () =~ // break=never
  233. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
  234. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->speed_dial] continue=false
  235. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [speed_dial] destination_number(17806860331) =~ /^\*0(.*)$/ break=on-false
  236. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->agent_status] continue=false
  237. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [agent_status] destination_number(17806860331) =~ /^\*22$/ break=on-false
  238. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->agent_status_id] continue=false
  239. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [agent_status_id] destination_number(17806860331) =~ /^\*23$/ break=on-false
  240. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->group-intercept] continue=false
  241. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [group-intercept] destination_number(17806860331) =~ /^\*8$/ break=on-false
  242. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->page-extension] continue=false
  243. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [page-extension] destination_number(17806860331) =~ /^\*8(\d{2,7})$/ break=on-false
  244. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->eavesdrop] continue=false
  245. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [eavesdrop] destination_number(17806860331) =~ /^\*33(\d{2,7})$/ break=on-false
  246. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->call_privacy] continue=false
  247. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [call_privacy] destination_number(17806860331) =~ /^\*67(\d+)$/ break=on-false
  248. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->call_return] continue=false
  249. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [call_return] destination_number(17806860331) =~ /^\*69$/ break=on-false
  250. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->extension_queue] continue=false
  251. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [extension_queue] destination_number(17806860331) =~ /^\*800(.*)$/ break=on-false
  252. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->intercept-ext] continue=false
  253. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [intercept-ext] destination_number(17806860331) =~ /^\*\*(\d+)$/ break=on-false
  254. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->intercept-ext-polycom] continue=false
  255. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [intercept-ext-polycom] destination_number(17806860331) =~ /^\*97(\d+)$/ break=on-false
  256. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->dx] continue=false
  257. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [dx] destination_number(17806860331) =~ /^dx$/ break=on-false
  258. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->att_xfer] continue=false
  259. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [att_xfer] destination_number(17806860331) =~ /^att_xfer$/ break=on-false
  260. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->extension-to-voicemail] continue=false
  261. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [extension-to-voicemail] ${user_exists}(false) =~ /^true$/ break=on-false
  262. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->send_to_voicemail] continue=false
  263. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [send_to_voicemail] destination_number(17806860331) =~ /^\*99(\d{2,10})$/ break=on-false
  264. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->vmain] continue=false
  265. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [vmain] destination_number(17806860331) =~ /^vmain$|^\*4000$|^\*98$/ break=on-false
  266. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->xfer_vm] continue=false
  267. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [xfer_vm] destination_number(17806860331) =~ /^xfer_vm$/ break=on-false
  268. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->is_transfer] continue=false
  269. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [is_transfer] destination_number(17806860331) =~ /^is_transfer$/ break=on-false
  270. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->vmain_user] continue=false
  271. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [vmain_user] destination_number(17806860331) =~ /^\*97$/ break=on-false
  272. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->SSConference] continue=
  273. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [SSConference] destination_number(17806860331) =~ /^299$/ break=on-false
  274. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->SSCORPIVR] continue=true
  275. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [SSCORPIVR] destination_number(17806860331) =~ /^200$/ break=on-false
  276. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->test] continue=
  277. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [test] destination_number(17806860331) =~ /^300$/ break=on-false
  278. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->cf] continue=false
  279. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [cf] destination_number(17806860331) =~ /^cf$/ break=on-false
  280. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->delay_echo] continue=false
  281. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [delay_echo] destination_number(17806860331) =~ /^\*9195$/ break=on-false
  282. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->echo] continue=false
  283. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [echo] destination_number(17806860331) =~ /^\*9196$/ break=on-false
  284. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->is_zrtp_secure] continue=true
  285. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [is_zrtp_secure] ${zrtp_secure_media_confirmed}() =~ /^true$/ break=on-false
  286. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca ANTI-Action eval(not_secure)
  287. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->milliwatt] continue=false
  288. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [milliwatt] destination_number(17806860331) =~ /^\*9197$/ break=on-false
  289. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->is_secure] continue=true
  290. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [is_secure] ${sip_via_protocol}(udp) =~ /tls/ break=on-false
  291. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->tone_stream] continue=false
  292. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [tone_stream] destination_number(17806860331) =~ /^\*9198$/ break=on-false
  293. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->hold_music] continue=false
  294. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [hold_music] destination_number(17806860331) =~ /^\*9664$/ break=on-false
  295. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->recordings] continue=false
  296. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [recordings] destination_number(17806860331) =~ /^\*(732)$/ break=on-false
  297. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->directory] continue=false
  298. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [directory] destination_number(17806860331) =~ /^\*411$/ break=on-false
  299. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->wake-up] continue=false
  300. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [wake-up] destination_number(17806860331) =~ /^\*(925)$/ break=on-false
  301. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->valet_park] continue=false
  302. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [valet_park] destination_number(17806860331) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=never
  303. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [valet_park] ${sip_h_Referred-By}() =~ /sip:(.*)@.*/ break=never
  304. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [valet_park] destination_number(17806860331) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=never
  305. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [valet_park] destination_number(17806860331) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=on-false
  306. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->operator] continue=false
  307. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [operator] destination_number(17806860331) =~ /^0$|^operator$/ break=on-false
  308. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->operator-forward] continue=false
  309. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [operator-forward] destination_number(17806860331) =~ /^\*000$/ break=on-false
  310. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->do-not-disturb] continue=false
  311. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [do-not-disturb] destination_number(17806860331) =~ /^\*77$/ break=on-true
  312. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [do-not-disturb] destination_number(17806860331) =~ /^\*78$|\*363$/ break=on-true
  313. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [do-not-disturb] destination_number(17806860331) =~ /^\*79$/ break=on-false
  314. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->call-forward] continue=false
  315. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [call-forward] destination_number(17806860331) =~ /^\*72$/ break=on-true
  316. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [call-forward] destination_number(17806860331) =~ /^\*73$/ break=on-true
  317. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [call-forward] destination_number(17806860331) =~ /^\*74$/ break=on-true
  318. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->follow-me] continue=false
  319. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [follow-me] destination_number(17806860331) =~ /^\*21$/ break=on-false
  320. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->clear_sip_auto_answer] continue=true
  321. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [clear_sip_auto_answer] ${click_to_call}() =~ /true/ break=on-false
  322. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->talking clock date and time] continue=true
  323. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [talking clock date and time] destination_number(17806860331) =~ /^\*9172$/ break=on-false
  324. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->talking clock time] continue=true
  325. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [talking clock time] destination_number(17806860331) =~ /^\*9170$/ break=on-false
  326. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->talking clock date] continue=true
  327. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [talking clock date] destination_number(17806860331) =~ /^\*9171$/ break=on-false
  328. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->call_screen] continue=true
  329. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [call_screen] ${call_screen_enabled}(false) =~ /^true$/ break=on-false
  330. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->local_extension] continue=true
  331. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [local_extension] ${user_exists}(false) =~ /true/ break=on-false
  332. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->voicemail] continue=false
  333. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [voicemail] ${user_exists}(false) =~ /true/ break=on-false
  334. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->iTel_Incoming_Primary.10d] continue=false
  335. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (FAIL) [iTel_Incoming_Primary.10d] destination_number(17806860331) =~ /^(\d{10})$/ break=on-false
  336. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca parsing [voice.polarisnetworks.ca->iTel_Incoming_Primary.11d] continue=false
  337. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Regex (PASS) [iTel_Incoming_Primary.11d] destination_number(17806860331) =~ /^\+?(\d{11})$/ break=on-false
  338. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(sip_h_X-accountcode=${accountcode})
  339. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(call_direction=outbound)
  340. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(hangup_after_bridge=true)
  341. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(effective_caller_id_name=${outbound_caller_id_name})
  342. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(effective_caller_id_number=${outbound_caller_id_number})
  343. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(inherit_codec=true)
  344. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(ignore_display_updates=true)
  345. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(callee_id_number=17806860331)
  346. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action set(continue_on_fail=true)
  347. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action bridge(sofia/gateway/e40ff470-da46-45a8-af74-3a2c32c909be/17806860331)
  348. Dialplan: sofia/internal/5878272002@voice.polarisnetworks.ca Action bridge(sofia/gateway/05b0a307-7d63-4c3e-990f-9e3c0280a661/17806860331)
  349. 2018-10-03 16:06:24.939417 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/5878272002@voice.polarisnetworks.ca) State Change CS_ROUTING -> CS_EXECUTE
  350. 2018-10-03 16:06:24.939417 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5878272002@voice.polarisnetworks.ca) State ROUTING going to sleep
  351. 2018-10-03 16:06:24.939417 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5878272002@voice.polarisnetworks.ca) Running State Change CS_EXECUTE (Cur 1 Tot 36)
  352. 2018-10-03 16:06:24.939417 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5878272002@voice.polarisnetworks.ca) State EXECUTE
  353. 2018-10-03 16:06:24.939417 [DEBUG] mod_sofia.c:198 sofia/internal/5878272002@voice.polarisnetworks.ca SOFIA EXECUTE
  354. 2018-10-03 16:06:24.939417 [DEBUG] switch_core_state_machine.c:328 sofia/internal/5878272002@voice.polarisnetworks.ca Standard EXECUTE
  355. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(call_direction=local)
  356. 2018-10-03 16:06:24.939417 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [call_direction]=[local]
  357. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca export(origination_callee_id_name=17806860331)
  358. 2018-10-03 16:06:24.939417 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[17806860331]
  359. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(RFC2822_DATE=Wed, 03 Oct 2018 16:06:24 -0600)
  360. 2018-10-03 16:06:24.939417 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [RFC2822_DATE]=[Wed, 03 Oct 2018 16:06:24 -0600]
  361. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca hash(insert/voice.polarisnetworks.ca-last_dial/5878272002/17806860331)
  362. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca eval(not_secure)
  363. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(sip_h_X-accountcode=voice.polarisnetworks.ca)
  364. 2018-10-03 16:06:24.939417 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [sip_h_X-accountcode]=[voice.polarisnetworks.ca]
  365. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(call_direction=outbound)
  366. 2018-10-03 16:06:24.939417 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [call_direction]=[outbound]
  367. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(hangup_after_bridge=true)
  368. 2018-10-03 16:06:24.939417 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [hangup_after_bridge]=[true]
  369. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(effective_caller_id_name=Stellar Solutions)
  370. 2018-10-03 16:06:24.939417 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [effective_caller_id_name]=[Stellar Solutions]
  371. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(effective_caller_id_number=7804266220)
  372. 2018-10-03 16:06:24.939417 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [effective_caller_id_number]=[7804266220]
  373. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(inherit_codec=true)
  374. 2018-10-03 16:06:24.939417 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [inherit_codec]=[true]
  375. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(ignore_display_updates=true)
  376. 2018-10-03 16:06:24.959409 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [ignore_display_updates]=[true]
  377. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(callee_id_number=17806860331)
  378. 2018-10-03 16:06:24.959409 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [callee_id_number]=[17806860331]
  379. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca set(continue_on_fail=true)
  380. 2018-10-03 16:06:24.959409 [DEBUG] mod_dptools.c:1530 SET sofia/internal/5878272002@voice.polarisnetworks.ca [continue_on_fail]=[true]
  381. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca bridge(sofia/gateway/e40ff470-da46-45a8-af74-3a2c32c909be/17806860331)
  382. 2018-10-03 16:06:24.959409 [DEBUG] switch_channel.c:1250 sofia/internal/5878272002@voice.polarisnetworks.ca EXPORTING[export_vars] [domain_name]=[voice.polarisnetworks.ca] to event
  383. 2018-10-03 16:06:24.959409 [DEBUG] switch_channel.c:1250 sofia/internal/5878272002@voice.polarisnetworks.ca EXPORTING[export_vars] [origination_callee_id_name]=[17806860331] to event
  384. 2018-10-03 16:06:24.959409 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  385. 2018-10-03 16:06:24.959409 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/17806860331 [91a963a2-c758-11e8-9d27-c3d2c916e7a3]
  386. 2018-10-03 16:06:24.959409 [DEBUG] mod_sofia.c:4818 (sofia/internal/17806860331) State Change CS_NEW -> CS_INIT
  387. 2018-10-03 16:06:24.979409 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/17806860331) Running State Change CS_INIT (Cur 2 Tot 37)
  388. 2018-10-03 16:06:24.979409 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/17806860331) State INIT
  389. 2018-10-03 16:06:24.979409 [DEBUG] mod_sofia.c:90 sofia/internal/17806860331 SOFIA INIT
  390. 2018-10-03 16:06:24.979409 [DEBUG] sofia_glue.c:1295 sofia/internal/17806860331 sending invite version: 1.6.17  64bit
  391. Local SDP:
  392. v=0
  393. o=FreeSWITCH 1538585382 1538585383 IN IP4 10.3.3.53
  394. s=FreeSWITCH
  395. c=IN IP4 10.3.3.53
  396. t=0 0
  397. m=audio 19002 RTP/AVP 8 101 13 104 105 106 107
  398. a=rtpmap:8 PCMA/8000
  399. a=rtpmap:101 telephone-event/8000
  400. a=fmtp:101 0-16
  401. a=rtpmap:104 telephone-event/32000
  402. a=fmtp:104 0-16
  403. a=rtpmap:106 telephone-event/16000
  404. a=fmtp:106 0-16
  405. a=rtpmap:13 CN/8000
  406. a=rtpmap:105 CN/32000
  407. a=rtpmap:107 CN/16000
  408. a=ptime:30
  409. a=sendrecv
  410. m=audio 19002 RTP/AVP 0 8 102 103 9 3 101 13 104 105 106 107
  411. a=rtpmap:0 PCMU/8000
  412. a=rtpmap:8 PCMA/8000
  413. a=rtpmap:102 G7221/32000
  414. a=fmtp:102 bitrate=48000
  415. a=rtpmap:103 G7221/16000
  416. a=fmtp:103 bitrate=32000
  417. a=rtpmap:9 G722/8000
  418. a=rtpmap:3 GSM/8000
  419. a=rtpmap:101 telephone-event/8000
  420. a=fmtp:101 0-16
  421. a=rtpmap:104 telephone-event/32000
  422. a=fmtp:104 0-16
  423. a=rtpmap:106 telephone-event/16000
  424. a=fmtp:106 0-16
  425. a=rtpmap:13 CN/8000
  426. a=rtpmap:105 CN/32000
  427. a=rtpmap:107 CN/16000
  428. a=ptime:20
  429. a=sendrecv
  430.  
  431. send 1935 bytes to udp/[65.39.243.100]:5060 at 16:06:24.988465:
  432.    ------------------------------------------------------------------------
  433.    INVITE sip:17806860331@sbc.itel.com SIP/2.0
  434.    Via: SIP/2.0/UDP 10.3.3.53;rport;branch=z9hG4bKF2X3BF9F54KQj
  435.    Max-Forwards: 69
  436.    From: "Stellar Solutions" <sip:USERNAME@sbc.itel.com>;tag=93N20mSN4t63N
  437.    To: <sip:17806860331@sbc.itel.com>
  438.    Call-ID: 690b3991-41fb-1237-a3b5-96b7153df19c
  439.    CSeq: 128966128 INVITE
  440.    Contact: <sip:gw+e40ff470-da46-45a8-af74-3a2c32c909be@10.3.3.53:5060;transport=udp;gw=e40ff470-da46-45a8-af74-3a2c32c909be>
  441.    User-Agent: FreeSWITCH
  442.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  443.    Supported: timer, path, replaces
  444.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  445.    Content-Type: application/sdp
  446.    Content-Disposition: session
  447.    Content-Length: 896
  448.    X-accountcode: voice.polarisnetworks.ca
  449.    X-FS-Support: update_display,send_info
  450.    Remote-Party-ID: "Stellar Solutions" <sip:7804266220@sbc.itel.com>;party=calling;screen=yes;privacy=off
  451.  
  452.    v=0
  453.    o=FreeSWITCH 1538585382 1538585383 IN IP4 10.3.3.53
  454.    s=FreeSWITCH
  455.    c=IN IP4 10.3.3.53
  456.    t=0 0
  457.    m=audio 19002 RTP/AVP 8 101 13 104 105 106 107
  458.    a=rtpmap:8 PCMA/8000
  459.    a=rtpmap:101 telephone-event/8000
  460.    a=fmtp:101 0-16
  461.    a=rtpmap:13 CN/8000
  462.    a=rtpmap:104 telephone-event/32000
  463.    a=fmtp:104 0-16
  464.    a=rtpmap:105 CN/32000
  465.    a=rtpmap:106 telephone-event/16000
  466.    a=fmtp:106 0-16
  467.    a=rtpmap:107 CN/16000
  468.    a=ptime:30
  469.    m=audio 19002 RTP/AVP 0 8 102 103 9 3 101 13 104 105 106 107
  470.    a=rtpmap:0 PCMU/8000
  471.    a=rtpmap:8 PCMA/8000
  472.    a=rtpmap:102 G7221/32000
  473.    a=fmtp:102 bitrate=48000
  474.    a=rtpmap:103 G7221/16000
  475.    a=fmtp:103 bitrate=32000
  476.    a=rtpmap:9 G722/8000
  477.    a=rtpmap:3 GSM/8000
  478.    a=rtpmap:101 telephone-event/8000
  479.    a=fmtp:101 0-16
  480.    a=rtpmap:13 CN/8000
  481.    a=rtpmap:104 telephone-event/32000
  482.    a=fmtp:104 0-16
  483.    a=rtpmap:105 CN/32000
  484.    a=rtpmap:106 telephone-event/16000
  485.    a=fmtp:106 0-16
  486.    a=rtpmap:107 CN/16000
  487.    a=ptime:20
  488.    ------------------------------------------------------------------------
  489. 2018-10-03 16:06:24.979409 [DEBUG] switch_core_state_machine.c:40 sofia/internal/17806860331 Standard INIT
  490. 2018-10-03 16:06:24.979409 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/17806860331) State Change CS_INIT -> CS_ROUTING
  491. 2018-10-03 16:06:24.979409 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/17806860331) State INIT going to sleep
  492. 2018-10-03 16:06:24.979409 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/17806860331) Running State Change CS_ROUTING (Cur 2 Tot 37)
  493. 2018-10-03 16:06:24.979409 [DEBUG] sofia.c:7048 Channel sofia/internal/17806860331 entering state [calling][0]
  494. 2018-10-03 16:06:24.979409 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/17806860331) State ROUTING
  495. 2018-10-03 16:06:24.979409 [DEBUG] mod_sofia.c:143 sofia/internal/17806860331 SOFIA ROUTING
  496. 2018-10-03 16:06:24.979409 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/17806860331) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  497. 2018-10-03 16:06:24.979409 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/17806860331) State ROUTING going to sleep
  498. 2018-10-03 16:06:24.979409 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/17806860331) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 37)
  499. 2018-10-03 16:06:24.979409 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/17806860331) State CONSUME_MEDIA
  500. 2018-10-03 16:06:24.979409 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/17806860331) State CONSUME_MEDIA going to sleep
  501. recv 475 bytes from udp/[65.39.243.100]:5060 at 16:06:25.029654:
  502.    ------------------------------------------------------------------------
  503.    SIP/2.0 488 Not acceptable here
  504.    Via: SIP/2.0/UDP 10.3.3.53:5060;branch=z9hG4bKF2X3BF9F54KQj;received=10.3.3.53;rport=5060
  505.    From: "Stellar Solutions" <sip:USERNAME@sbc.itel.com>;tag=93N20mSN4t63N
  506.    To: <sip:17806860331@sbc.itel.com>;tag=as0893c208
  507.    Call-ID: 690b3991-41fb-1237-a3b5-96b7153df19c
  508.    CSeq: 128966128 INVITE
  509.    Server: Itelnetworks
  510.    Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  511.    Supported: replaces
  512.    Content-Length: 0
  513.  
  514.    ------------------------------------------------------------------------
  515. send 335 bytes to udp/[65.39.243.100]:5060 at 16:06:25.029983:
  516.    ------------------------------------------------------------------------
  517.    ACK sip:17806860331@sbc.itel.com SIP/2.0
  518.    Via: SIP/2.0/UDP 10.3.3.53;rport;branch=z9hG4bKF2X3BF9F54KQj
  519.    Max-Forwards: 69
  520.    From: "Stellar Solutions" <sip:USERNAME@sbc.itel.com>;tag=93N20mSN4t63N
  521.    To: <sip:17806860331@sbc.itel.com>;tag=as0893c208
  522.    Call-ID: 690b3991-41fb-1237-a3b5-96b7153df19c
  523.    CSeq: 128966128 ACK
  524.    Content-Length: 0
  525.  
  526.    ------------------------------------------------------------------------
  527. 2018-10-03 16:06:25.019419 [DEBUG] sofia.c:7048 Channel sofia/internal/17806860331 entering state [terminated][488]
  528. 2018-10-03 16:06:25.019419 [NOTICE] sofia.c:8237 Hangup sofia/internal/17806860331 [CS_CONSUME_MEDIA] [INCOMPATIBLE_DESTINATION]
  529. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/17806860331) Running State Change CS_HANGUP (Cur 2 Tot 37)
  530. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/17806860331) Callstate Change DOWN -> HANGUP
  531. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/17806860331) State HANGUP
  532. 2018-10-03 16:06:25.019419 [DEBUG] mod_sofia.c:438 Channel sofia/internal/17806860331 hanging up, cause: INCOMPATIBLE_DESTINATION
  533. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_state_machine.c:60 sofia/internal/17806860331 Standard HANGUP, cause: INCOMPATIBLE_DESTINATION
  534. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/17806860331) State HANGUP going to sleep
  535. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/17806860331) State Change CS_HANGUP -> CS_REPORTING
  536. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/17806860331) Running State Change CS_REPORTING (Cur 2 Tot 37)
  537. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/17806860331) State REPORTING
  538. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_state_machine.c:174 sofia/internal/17806860331 Standard REPORTING, cause: INCOMPATIBLE_DESTINATION
  539. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/17806860331) State REPORTING going to sleep
  540. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/17806860331) State Change CS_REPORTING -> CS_DESTROY
  541. 2018-10-03 16:06:25.019419 [DEBUG] switch_core_session.c:1664 Session 37 (sofia/internal/17806860331) Locked, Waiting on external entities
  542. 2018-10-03 16:06:25.019419 [DEBUG] switch_ivr_originate.c:3833 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]
  543. 2018-10-03 16:06:25.019419 [INFO] mod_dptools.c:3418 Originate Failed.  Cause: INCOMPATIBLE_DESTINATION
  544. EXECUTE sofia/internal/5878272002@voice.polarisnetworks.ca bridge(sofia/gateway/05b0a307-7d63-4c3e-990f-9e3c0280a661/17806860331)
  545. 2018-10-03 16:06:25.019419 [DEBUG] switch_channel.c:1250 sofia/internal/5878272002@voice.polarisnetworks.ca EXPORTING[export_vars] [domain_name]=[voice.polarisnetworks.ca] to event
  546. 2018-10-03 16:06:25.019419 [DEBUG] switch_channel.c:1250 sofia/internal/5878272002@voice.polarisnetworks.ca EXPORTING[export_vars] [origination_callee_id_name]=[17806860331] to event
  547. 2018-10-03 16:06:25.019419 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  548. 2018-10-03 16:06:25.019419 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/17806860331 [91b49e66-c758-11e8-9d2f-c3d2c916e7a3]
  549. 2018-10-03 16:06:25.019419 [DEBUG] mod_sofia.c:4818 (sofia/internal/17806860331) State Change CS_NEW -> CS_INIT
  550. 2018-10-03 16:06:25.039421 [NOTICE] switch_core_session.c:1682 Session 37 (sofia/internal/17806860331) Ended
  551. 2018-10-03 16:06:25.039421 [NOTICE] switch_core_session.c:1686 Close Channel sofia/internal/17806860331 [CS_DESTROY]
  552. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/17806860331) Running State Change CS_DESTROY (Cur 2 Tot 38)
  553. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/17806860331) State DESTROY
  554. 2018-10-03 16:06:25.039421 [DEBUG] mod_sofia.c:343 sofia/internal/17806860331 SOFIA DESTROY
  555. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:181 sofia/internal/17806860331 Standard DESTROY
  556. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/17806860331) State DESTROY going to sleep
  557. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/17806860331) Running State Change CS_INIT (Cur 2 Tot 38)
  558. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/17806860331) State INIT
  559. 2018-10-03 16:06:25.039421 [DEBUG] mod_sofia.c:90 sofia/internal/17806860331 SOFIA INIT
  560. 2018-10-03 16:06:25.039421 [DEBUG] sofia_glue.c:1295 sofia/internal/17806860331 sending invite version: 1.6.17  64bit
  561. Local SDP:
  562. v=0
  563. o=FreeSWITCH 1538584465 1538584466 IN IP4 10.3.3.53
  564. s=FreeSWITCH
  565. c=IN IP4 10.3.3.53
  566. t=0 0
  567. m=audio 19920 RTP/AVP 8 101 13 104 105 106 107
  568. a=rtpmap:8 PCMA/8000
  569. a=rtpmap:101 telephone-event/8000
  570. a=fmtp:101 0-16
  571. a=rtpmap:104 telephone-event/32000
  572. a=fmtp:104 0-16
  573. a=rtpmap:106 telephone-event/16000
  574. a=fmtp:106 0-16
  575. a=rtpmap:13 CN/8000
  576. a=rtpmap:105 CN/32000
  577. a=rtpmap:107 CN/16000
  578. a=ptime:30
  579. a=sendrecv
  580. m=audio 19920 RTP/AVP 0 8 102 103 9 3 101 13 104 105 106 107
  581. a=rtpmap:0 PCMU/8000
  582. a=rtpmap:8 PCMA/8000
  583. a=rtpmap:102 G7221/32000
  584. a=fmtp:102 bitrate=48000
  585. a=rtpmap:103 G7221/16000
  586. a=fmtp:103 bitrate=32000
  587. a=rtpmap:9 G722/8000
  588. a=rtpmap:3 GSM/8000
  589. a=rtpmap:101 telephone-event/8000
  590. a=fmtp:101 0-16
  591. a=rtpmap:104 telephone-event/32000
  592. a=fmtp:104 0-16
  593. a=rtpmap:106 telephone-event/16000
  594. a=fmtp:106 0-16
  595. a=rtpmap:13 CN/8000
  596. a=rtpmap:105 CN/32000
  597. a=rtpmap:107 CN/16000
  598. a=ptime:20
  599. a=sendrecv
  600.  
  601. send 1939 bytes to udp/[199.192.104.104]:5060 at 16:06:25.043020:
  602.    ------------------------------------------------------------------------
  603.    INVITE sip:17806860331@sbc2.itel.com SIP/2.0
  604.    Via: SIP/2.0/UDP 10.3.3.53;rport;branch=z9hG4bKgBQvDatK2Daae
  605.    Max-Forwards: 69
  606.    From: "Stellar Solutions" <sip:USERNAME@sbc2.itel.com>;tag=aDFU2FaS13vpH
  607.    To: <sip:17806860331@sbc2.itel.com>
  608.    Call-ID: 69138d81-41fb-1237-a3b5-96b7153df19c
  609.    CSeq: 128966128 INVITE
  610.    Contact: <sip:gw+05b0a307-7d63-4c3e-990f-9e3c0280a661@10.3.3.53:5060;transport=udp;gw=05b0a307-7d63-4c3e-990f-9e3c0280a661>
  611.    User-Agent: FreeSWITCH
  612.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  613.    Supported: timer, path, replaces
  614.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  615.    Content-Type: application/sdp
  616.    Content-Disposition: session
  617.    Content-Length: 896
  618.    X-accountcode: voice.polarisnetworks.ca
  619.    X-FS-Support: update_display,send_info
  620.    Remote-Party-ID: "Stellar Solutions" <sip:7804266220@sbc2.itel.com>;party=calling;screen=yes;privacy=off
  621.  
  622.    v=0
  623.    o=FreeSWITCH 1538584465 1538584466 IN IP4 10.3.3.53
  624.    s=FreeSWITCH
  625.    c=IN IP4 10.3.3.53
  626.    t=0 0
  627.    m=audio 19920 RTP/AVP 8 101 13 104 105 106 107
  628.    a=rtpmap:8 PCMA/8000
  629.    a=rtpmap:101 telephone-event/8000
  630.    a=fmtp:101 0-16
  631.    a=rtpmap:13 CN/8000
  632.    a=rtpmap:104 telephone-event/32000
  633.    a=fmtp:104 0-16
  634.    a=rtpmap:105 CN/32000
  635.    a=rtpmap:106 telephone-event/16000
  636.    a=fmtp:106 0-16
  637.    a=rtpmap:107 CN/16000
  638.    a=ptime:30
  639.    m=audio 19920 RTP/AVP 0 8 102 103 9 3 101 13 104 105 106 107
  640.    a=rtpmap:0 PCMU/8000
  641.    a=rtpmap:8 PCMA/8000
  642.    a=rtpmap:102 G7221/32000
  643.    a=fmtp:102 bitrate=48000
  644.    a=rtpmap:103 G7221/16000
  645.    a=fmtp:103 bitrate=32000
  646.    a=rtpmap:9 G722/8000
  647.    a=rtpmap:3 GSM/8000
  648.    a=rtpmap:101 telephone-event/8000
  649.    a=fmtp:101 0-16
  650.    a=rtpmap:13 CN/8000
  651.    a=rtpmap:104 telephone-event/32000
  652.    a=fmtp:104 0-16
  653.    a=rtpmap:105 CN/32000
  654.    a=rtpmap:106 telephone-event/16000
  655.    a=fmtp:106 0-16
  656.    a=rtpmap:107 CN/16000
  657.    a=ptime:20
  658.    ------------------------------------------------------------------------
  659. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:40 sofia/internal/17806860331 Standard INIT
  660. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/17806860331) State Change CS_INIT -> CS_ROUTING
  661. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/17806860331) State INIT going to sleep
  662. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/17806860331) Running State Change CS_ROUTING (Cur 2 Tot 38)
  663. 2018-10-03 16:06:25.039421 [DEBUG] sofia.c:7048 Channel sofia/internal/17806860331 entering state [calling][0]
  664. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/17806860331) State ROUTING
  665. 2018-10-03 16:06:25.039421 [DEBUG] mod_sofia.c:143 sofia/internal/17806860331 SOFIA ROUTING
  666. 2018-10-03 16:06:25.039421 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/17806860331) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  667. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/17806860331) State ROUTING going to sleep
  668. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/17806860331) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 38)
  669. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/17806860331) State CONSUME_MEDIA
  670. 2018-10-03 16:06:25.039421 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/17806860331) State CONSUME_MEDIA going to sleep
  671. recv 484 bytes from udp/[199.192.104.104]:5060 at 16:06:25.091357:
  672.    ------------------------------------------------------------------------
  673.    SIP/2.0 488 Not acceptable here
  674.    Via: SIP/2.0/UDP 10.3.3.53:5060;branch=z9hG4bKgBQvDatK2Daae;received=10.3.3.53;rport=5060
  675.    From: "Stellar Solutions" <sip:USERNAME@sbc2.itel.com>;tag=aDFU2FaS13vpH
  676.    To: <sip:17806860331@sbc2.itel.com>;tag=as743e02cc
  677.    Call-ID: 69138d81-41fb-1237-a3b5-96b7153df19c
  678.    CSeq: 128966128 INVITE
  679.    Server: Itelnetworks
  680.    Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
  681.    Supported: replaces, timer
  682.    Content-Length: 0
  683.  
  684.    ------------------------------------------------------------------------
  685. send 338 bytes to udp/[199.192.104.104]:5060 at 16:06:25.091707:
  686.    ------------------------------------------------------------------------
  687.    ACK sip:17806860331@sbc2.itel.com SIP/2.0
  688.    Via: SIP/2.0/UDP 10.3.3.53;rport;branch=z9hG4bKgBQvDatK2Daae
  689.    Max-Forwards: 69
  690.    From: "Stellar Solutions" <sip:USERNAME@sbc2.itel.com>;tag=aDFU2FaS13vpH
  691.    To: <sip:17806860331@sbc2.itel.com>;tag=as743e02cc
  692.    Call-ID: 69138d81-41fb-1237-a3b5-96b7153df19c
  693.    CSeq: 128966128 ACK
  694.    Content-Length: 0
  695.  
  696.    ------------------------------------------------------------------------
  697. 2018-10-03 16:06:25.079435 [DEBUG] sofia.c:7048 Channel sofia/internal/17806860331 entering state [terminated][488]
  698. 2018-10-03 16:06:25.079435 [NOTICE] sofia.c:8237 Hangup sofia/internal/17806860331 [CS_CONSUME_MEDIA] [INCOMPATIBLE_DESTINATION]
  699. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/17806860331) Running State Change CS_HANGUP (Cur 2 Tot 38)
  700. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/17806860331) Callstate Change DOWN -> HANGUP
  701. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/17806860331) State HANGUP
  702. 2018-10-03 16:06:25.079435 [DEBUG] mod_sofia.c:438 Channel sofia/internal/17806860331 hanging up, cause: INCOMPATIBLE_DESTINATION
  703. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:60 sofia/internal/17806860331 Standard HANGUP, cause: INCOMPATIBLE_DESTINATION
  704. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/17806860331) State HANGUP going to sleep
  705. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/17806860331) State Change CS_HANGUP -> CS_REPORTING
  706. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/17806860331) Running State Change CS_REPORTING (Cur 2 Tot 38)
  707. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/17806860331) State REPORTING
  708. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:174 sofia/internal/17806860331 Standard REPORTING, cause: INCOMPATIBLE_DESTINATION
  709. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/17806860331) State REPORTING going to sleep
  710. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/17806860331) State Change CS_REPORTING -> CS_DESTROY
  711. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_session.c:1664 Session 38 (sofia/internal/17806860331) Locked, Waiting on external entities
  712. 2018-10-03 16:06:25.079435 [DEBUG] switch_ivr_originate.c:3833 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]
  713. 2018-10-03 16:06:25.079435 [INFO] mod_dptools.c:3418 Originate Failed.  Cause: INCOMPATIBLE_DESTINATION
  714. 2018-10-03 16:06:25.079435 [NOTICE] switch_core_state_machine.c:385 sofia/internal/5878272002@voice.polarisnetworks.ca has executed the last dialplan instruction, hanging up.
  715. 2018-10-03 16:06:25.079435 [NOTICE] switch_core_state_machine.c:387 Hangup sofia/internal/5878272002@voice.polarisnetworks.ca [CS_EXECUTE] [NORMAL_CLEARING]
  716. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5878272002@voice.polarisnetworks.ca) State EXECUTE going to sleep
  717. 2018-10-03 16:06:25.079435 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5878272002@voice.polarisnetworks.ca) Running State Change CS_HANGUP (Cur 2 Tot 38)
  718. 2018-10-03 16:06:25.099411 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/5878272002@voice.polarisnetworks.ca) Callstate Change RINGING -> HANGUP
  719. 2018-10-03 16:06:25.099411 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/5878272002@voice.polarisnetworks.ca) State HANGUP
  720. 2018-10-03 16:06:25.099411 [DEBUG] mod_sofia.c:432 sofia/internal/5878272002@voice.polarisnetworks.ca Overriding SIP cause 480 with 488 from the other leg
  721. 2018-10-03 16:06:25.099411 [DEBUG] mod_sofia.c:438 Channel sofia/internal/5878272002@voice.polarisnetworks.ca hanging up, cause: NORMAL_CLEARING
  722. 2018-10-03 16:06:25.099411 [DEBUG] mod_sofia.c:577 Responding to INVITE with: 488
  723. send 855 bytes to udp/[10.3.3.26]:5060 at 16:06:25.101482:
  724.    ------------------------------------------------------------------------
  725.    SIP/2.0 488 Not Acceptable Here
  726.    Via: SIP/2.0/UDP 10.3.3.26:5060;branch=z9hG4bK-beb255b
  727.    Max-Forwards: 70
  728.    From: 5878272002 <sip:5878272002@voice.polarisnetworks.ca>;tag=7c71b9d8f3653583o0
  729.    To: <sip:17806860331@voice.polarisnetworks.ca>;tag=8tv9yS8H7HgHa
  730.    Call-ID: d7fdac3c-7a01466f@10.3.3.26
  731.    CSeq: 102 INVITE
  732.    User-Agent: FreeSWITCH
  733.    Accept: application/sdp
  734.    Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
  735.    Supported: timer, path, replaces
  736.    Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
  737.    Reason: Q.850;cause=16;text="NORMAL_CLEARING"
  738.    Content-Length: 0
  739.    Remote-Party-ID: "17806860331" <sip:17806860331@voice.polarisnetworks.ca>;party=calling;privacy=off;screen=no
  740.  
  741.    ------------------------------------------------------------------------
  742. 2018-10-03 16:06:25.099411 [DEBUG] switch_core_state_machine.c:60 sofia/internal/5878272002@voice.polarisnetworks.ca Standard HANGUP, cause: NORMAL_CLEARING
  743. 2018-10-03 16:06:25.099411 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/5878272002@voice.polarisnetworks.ca) State HANGUP going to sleep
  744. 2018-10-03 16:06:25.099411 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/5878272002@voice.polarisnetworks.ca) State Change CS_HANGUP -> CS_REPORTING
  745. 2018-10-03 16:06:25.099411 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5878272002@voice.polarisnetworks.ca) Running State Change CS_REPORTING (Cur 2 Tot 38)
  746. 2018-10-03 16:06:25.099411 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/5878272002@voice.polarisnetworks.ca) State REPORTING
  747. 2018-10-03 16:06:25.099411 [NOTICE] switch_core_session.c:1682 Session 38 (sofia/internal/17806860331) Ended
  748. 2018-10-03 16:06:25.099411 [NOTICE] switch_core_session.c:1686 Close Channel sofia/internal/17806860331 [CS_DESTROY]
  749. 2018-10-03 16:06:25.099411 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/17806860331) Running State Change CS_DESTROY (Cur 1 Tot 38)
  750. 2018-10-03 16:06:25.099411 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/17806860331) State DESTROY
  751. 2018-10-03 16:06:25.099411 [DEBUG] mod_sofia.c:343 sofia/internal/17806860331 SOFIA DESTROY
  752. 2018-10-03 16:06:25.099411 [DEBUG] switch_core_state_machine.c:181 sofia/internal/17806860331 Standard DESTROY
  753. 2018-10-03 16:06:25.099411 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/17806860331) State DESTROY going to sleep
  754. recv 714 bytes from udp/[10.3.3.26]:5060 at 16:06:25.119712:
  755.    ------------------------------------------------------------------------
  756.    ACK sip:17806860331@voice.polarisnetworks.ca SIP/2.0
  757.    Via: SIP/2.0/UDP 10.3.3.26:5060;branch=z9hG4bK-beb255b
  758.    From: 5878272002 <sip:5878272002@voice.polarisnetworks.ca>;tag=7c71b9d8f3653583o0
  759.    To: <sip:17806860331@voice.polarisnetworks.ca>;tag=8tv9yS8H7HgHa
  760.    Call-ID: d7fdac3c-7a01466f@10.3.3.26
  761.    CSeq: 102 ACK
  762.    Max-Forwards: 70
  763.    Proxy-Authorization: Digest username="5878272002",realm="voice.polarisnetworks.ca",nonce="916c8cfc-c758-11e8-9d0f-c3d2c916e7a3",uri="sip:17806860331@voice.polarisnetworks.ca",algorithm=MD5,response="3147e80a86a64ee560364738ddb17fea",qop=auth,nc=00000001,cnonce="f49c8cef"
  764.    Contact: 5878272002 <sip:5878272002@10.3.3.26:5060>
  765.    User-Agent: Linksys/PAP2T-5.1.6(LS)
  766.    Content-Length: 0
  767.  
  768.    ------------------------------------------------------------------------
  769. 2018-10-03 16:06:25.819437 [DEBUG] switch_core_state_machine.c:174 sofia/internal/5878272002@voice.polarisnetworks.ca Standard REPORTING, cause: NORMAL_CLEARING
  770. 2018-10-03 16:06:25.819437 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/5878272002@voice.polarisnetworks.ca) State REPORTING going to sleep
  771. 2018-10-03 16:06:25.819437 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/5878272002@voice.polarisnetworks.ca) State Change CS_REPORTING -> CS_DESTROY
  772. 2018-10-03 16:06:25.819437 [DEBUG] switch_core_session.c:1664 Session 36 (sofia/internal/5878272002@voice.polarisnetworks.ca) Locked, Waiting on external entities
  773. 2018-10-03 16:06:25.819437 [NOTICE] switch_core_session.c:1682 Session 36 (sofia/internal/5878272002@voice.polarisnetworks.ca) Ended
  774. 2018-10-03 16:06:25.819437 [NOTICE] switch_core_session.c:1686 Close Channel sofia/internal/5878272002@voice.polarisnetworks.ca [CS_DESTROY]
  775. 2018-10-03 16:06:25.819437 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/5878272002@voice.polarisnetworks.ca) Running State Change CS_DESTROY (Cur 0 Tot 38)
  776. 2018-10-03 16:06:25.819437 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/5878272002@voice.polarisnetworks.ca) State DESTROY
  777. 2018-10-03 16:06:25.819437 [DEBUG] mod_sofia.c:343 sofia/internal/5878272002@voice.polarisnetworks.ca SOFIA DESTROY
  778. 2018-10-03 16:06:25.819437 [DEBUG] switch_core_state_machine.c:181 sofia/internal/5878272002@voice.polarisnetworks.ca Standard DESTROY
  779. 2018-10-03 16:06:25.819437 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/5878272002@voice.polarisnetworks.ca) State DESTROY going to sleep
  780.  

Reply to "Untitled"