From mattswainstopn, 2 Years ago, written in FreeSWITCH.
- view diff
Embed
  1.    ------------------------------------------------------------------------
  2. 2016-08-05 18:22:25.354070 [NOTICE] switch_channel.c:1104 New Channel sofia/external/01482423490@88.215.55.97 [175c94a7-1cba-4478-89a4-dc3b51f4d7dd]
  3. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_NEW
  4. 2016-08-05 18:22:25.354070 [DEBUG] sofia.c:9456 sofia/external/01482423490@88.215.55.97 receiving invite from 88.215.55.97:5060 version: 1.6.9 -16-d574870 64bit
  5. 2016-08-05 18:22:25.354070 [DEBUG] sofia.c:6933 Channel sofia/external/01482423490@88.215.55.97 entering state [received][100]
  6. 2016-08-05 18:22:25.354070 [DEBUG] sofia.c:6943 Remote SDP:
  7. v=0
  8. o=MSX57 9092270216140018773 1 IN IP4 88.215.55.97
  9. s=sip call
  10. c=IN IP4 88.215.55.98
  11. t=0 0
  12. m=audio 36308 RTP/AVP 8 101
  13. a=rtpmap:8 PCMA/8000
  14. a=rtpmap:101 telephone-event/8000
  15. a=fmtp:101 0-15
  16.  
  17. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  18. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  19. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  20. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_media.c:4420 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  21. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  22. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_media.c:4281 Set telephone-event payload to 101@8000
  23. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_media.c:3091 Set Codec sofia/external/01482423490@88.215.55.97 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  24. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_codec.c:111 sofia/external/01482423490@88.215.55.97 Original read codec set to PCMA:8
  25. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_media.c:4634 Set telephone-event payload to 101@8000
  26. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_media.c:4693 sofia/external/01482423490@88.215.55.97 Set 2833 dtmf send payload to 101 recv payload to 101
  27. 2016-08-05 18:22:25.354070 [DEBUG] sofia.c:7332 (sofia/external/01482423490@88.215.55.97) State Change CS_NEW -> CS_INIT
  28. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_state_machine.c:562 (sofia/external/01482423490@88.215.55.97) State NEW
  29. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_INIT
  30. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_state_machine.c:586 (sofia/external/01482423490@88.215.55.97) State INIT
  31. 2016-08-05 18:22:25.354070 [DEBUG] mod_sofia.c:89 sofia/external/01482423490@88.215.55.97 SOFIA INIT
  32. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_state_machine.c:40 sofia/external/01482423490@88.215.55.97 Standard INIT
  33. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_state_machine.c:48 (sofia/external/01482423490@88.215.55.97) State Change CS_INIT -> CS_ROUTING
  34. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_state_machine.c:586 (sofia/external/01482423490@88.215.55.97) State INIT going to sleep
  35. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_ROUTING
  36. 2016-08-05 18:22:25.354070 [DEBUG] switch_channel.c:2249 (sofia/external/01482423490@88.215.55.97) Callstate Change DOWN -> RINGING
  37. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_state_machine.c:602 (sofia/external/01482423490@88.215.55.97) State ROUTING
  38. 2016-08-05 18:22:25.354070 [DEBUG] mod_sofia.c:142 sofia/external/01482423490@88.215.55.97 SOFIA ROUTING
  39. 2016-08-05 18:22:25.354070 [DEBUG] switch_core_state_machine.c:236 sofia/external/01482423490@88.215.55.97 Standard ROUTING
  40. 2016-08-05 18:22:25.354070 [INFO] mod_dialplan_xml.c:637 Processing 01482423490 <01482423490>->01482426509 in context public
  41. 2016-08-05 18:22:25.379354 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f2edc05fd40 Connected.
  42. 2016-08-05 18:22:25.379354 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f2edc05fd40 released.
  43. Dialplan: sofia/external/01482423490@88.215.55.97 parsing [public->public] continue=true
  44. Dialplan: sofia/external/01482423490@88.215.55.97 Regex (FAIL) [public] destination_number(01482426509) =~ /^(GroupO[2-9]e)$/ break=on-false
  45. 2016-08-05 18:22:25.394056 [INFO] switch_core_state_machine.c:311 No Route, Aborting
  46. 2016-08-05 18:22:25.394056 [NOTICE] switch_core_state_machine.c:312 Hangup sofia/external/01482423490@88.215.55.97 [CS_ROUTING] [NO_ROUTE_DESTINATION]
  47. 2016-08-05 18:22:25.394056 [DEBUG] switch_core_state_machine.c:602 (sofia/external/01482423490@88.215.55.97) State ROUTING going to sleep
  48. 2016-08-05 18:22:25.394056 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_HANGUP
  49. 2016-08-05 18:22:25.394056 [DEBUG] switch_core_state_machine.c:809 (sofia/external/01482423490@88.215.55.97) Callstate Change RINGING -> HANGUP
  50. 2016-08-05 18:22:25.394056 [DEBUG] switch_core_state_machine.c:811 (sofia/external/01482423490@88.215.55.97) State HANGUP
  51. 2016-08-05 18:22:25.394056 [DEBUG] mod_sofia.c:437 Channel sofia/external/01482423490@88.215.55.97 hanging up, cause: NO_ROUTE_DESTINATION
  52. 2016-08-05 18:22:25.394056 [DEBUG] mod_sofia.c:576 Responding to INVITE with: 404
  53. 2016-08-05 18:22:25.394056 [DEBUG] switch_core_state_machine.c:60 sofia/external/01482423490@88.215.55.97 Standard HANGUP, cause: NO_ROUTE_DESTINATION
  54. 2016-08-05 18:22:25.394056 [DEBUG] switch_core_state_machine.c:811 (sofia/external/01482423490@88.215.55.97) State HANGUP going to sleep
  55. 2016-08-05 18:22:25.394056 [DEBUG] switch_core_state_machine.c:578 (sofia/external/01482423490@88.215.55.97) State Change CS_HANGUP -> CS_REPORTING
  56. 2016-08-05 18:22:25.394056 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_REPORTING
  57. 2016-08-05 18:22:25.394056 [DEBUG] switch_core_state_machine.c:897 (sofia/external/01482423490@88.215.55.97) State REPORTING
  58. send 687 bytes to udp/[88.215.55.97]:5060 at 18:22:25.395251:
  59.    ------------------------------------------------------------------------
  60.    SIP/2.0 404 Not Found
  61.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bKf8d990ef82f83d7fd796aa2c988ea3e8
  62.    Max-Forwards: 69
  63.    From: <sip:01482423490@88.215.55.97>;tag=3679406554-839434
  64.    To: <sip:01482426509@88.215.55.97:5060;user=phone>;tag=60v8mpc638m3r
  65.    Call-ID: 10680944-3679406554-839427@MSX57.gammatelecom.com
  66.    CSeq: 1 INVITE
  67.    User-Agent: FreeSWITCH
  68.    Accept: application/sdp
  69.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  70.    Supported: timer, path, replaces
  71.    Allow-Events: talk, hold, conference, refer
  72.    Reason: Q.850;cause=3;text="NO_ROUTE_DESTINATION"
  73.    Content-Length: 0
  74.    P-Asserted-Identity: "01482426509" <sip:01482426509@88.215.55.97>
  75.  
  76.    ------------------------------------------------------------------------
  77. recv 479 bytes from udp/[88.215.55.97]:5060 at 18:22:25.415121:
  78.    ------------------------------------------------------------------------
  79.    ACK sip:01482426509@77.86.26.187 SIP/2.0
  80.    Max-Forwards: 70
  81.    To: <sip:01482426509@88.215.55.97:5060;user=phone>;tag=60v8mpc638m3r
  82.    From: <sip:01482423490@88.215.55.97>;tag=3679406554-839434
  83.    Call-ID: 10680944-3679406554-839427@MSX57.gammatelecom.com
  84.    CSeq: 1 ACK
  85.   Allow: UPDATE,INFO,NOTIFY,REGISTER,OPTIONS,BYE,INVITE,ACK,CANCEL
  86.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bKf8d990ef82f83d7fd796aa2c988ea3e8
  87.    Contact: <sip:01482423490@88.215.55.97:5060>
  88.    Content-Length: 0
  89.  
  90.    ------------------------------------------------------------------------
  91. 2016-08-05 18:22:25.434045 [DEBUG] switch_core_state_machine.c:174 sofia/external/01482423490@88.215.55.97 Standard REPORTING, cause: NO_ROUTE_DESTINATION
  92. 2016-08-05 18:22:25.434045 [DEBUG] switch_core_state_machine.c:897 (sofia/external/01482423490@88.215.55.97) State REPORTING going to sleep
  93. 2016-08-05 18:22:25.434045 [DEBUG] switch_core_state_machine.c:569 (sofia/external/01482423490@88.215.55.97) State Change CS_REPORTING -> CS_DESTROY
  94. 2016-08-05 18:22:25.434045 [DEBUG] switch_core_session.c:1647 Session 6 (sofia/external/01482423490@88.215.55.97) Locked, Waiting on external entities
  95. 2016-08-05 18:22:25.434045 [NOTICE] switch_core_session.c:1665 Session 6 (sofia/external/01482423490@88.215.55.97) Ended
  96. 2016-08-05 18:22:25.434045 [NOTICE] switch_core_session.c:1669 Close Channel sofia/external/01482423490@88.215.55.97 [CS_DESTROY]
  97. 2016-08-05 18:22:25.434045 [DEBUG] switch_core_state_machine.c:700 (sofia/external/01482423490@88.215.55.97) Running State Change CS_DESTROY
  98. 2016-08-05 18:22:25.434045 [DEBUG] switch_core_state_machine.c:710 (sofia/external/01482423490@88.215.55.97) State DESTROY
  99. 2016-08-05 18:22:25.434045 [DEBUG] mod_sofia.c:342 sofia/external/01482423490@88.215.55.97 SOFIA DESTROY
  100. 2016-08-05 18:22:25.434045 [DEBUG] switch_core_state_machine.c:181 sofia/external/01482423490@88.215.55.97 Standard DESTROY
  101. 2016-08-05 18:22:25.434045 [DEBUG] switch_core_state_machine.c:710 (sofia/external/01482423490@88.215.55.97) State DESTROY going to sleep
  102. recv 894 bytes from udp/[88.215.55.97]:5060 at 18:22:32.377252:
  103.    ------------------------------------------------------------------------
  104.    INVITE sip:01482426509@77.86.26.187;user=phone SIP/2.0
  105.    Max-Forwards: 69
  106.    Session-Expires: 3600;refresher=uac
  107.    Min-SE: 600
  108.    Supported: timer, 100rel
  109.    To: <sip:01482426509@88.215.55.97:5060;user=phone>
  110.    From: <sip:01482423490@88.215.55.97>;tag=3679406561-857874
  111.    P-Asserted-Identity: <sip:01482423490@88.215.55.97;user=phone>
  112.    Call-ID: 10681121-3679406561-857865@MSX57.gammatelecom.com
  113.    CSeq: 1 INVITE
  114.   Allow: UPDATE,PRACK,INFO,NOTIFY,REGISTER,OPTIONS,BYE,INVITE,ACK,CANCEL
  115.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bKa5b9cf79975a95da0d9e2062968e2504
  116.    Contact: <sip:01482423490@88.215.55.97:5060>
  117.    Content-Type: application/sdp
  118.    Accept: application/sdp
  119.    Content-Length: 212
  120.  
  121.    v=0
  122.    o=MSX57 909045068753014979 1 IN IP4 88.215.55.97
  123.    s=sip call
  124.    c=IN IP4 88.215.55.98
  125.    t=0 0
  126.    m=audio 36324 RTP/AVP 8 101
  127.    a=rtpmap:8 PCMA/8000
  128.    a=rtpmap:101 telephone-event/8000
  129.    a=fmtp:101 0-15
  130.    a=sendrecv
  131.    ------------------------------------------------------------------------
  132. send 336 bytes to udp/[88.215.55.97]:5060 at 18:22:32.377602:
  133.    ------------------------------------------------------------------------
  134.    SIP/2.0 100 Trying
  135.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bKa5b9cf79975a95da0d9e2062968e2504
  136.    From: <sip:01482423490@88.215.55.97>;tag=3679406561-857874
  137.    To: <sip:01482426509@88.215.55.97:5060;user=phone>
  138.    Call-ID: 10681121-3679406561-857865@MSX57.gammatelecom.com
  139.    CSeq: 1 INVITE
  140.    User-Agent: FreeSWITCH
  141.    Content-Length: 0
  142.  
  143.    ------------------------------------------------------------------------
  144. 2016-08-05 18:22:32.374068 [NOTICE] switch_channel.c:1104 New Channel sofia/external/01482423490@88.215.55.97 [8d84cfee-078c-42be-a262-82f0f501a39f]
  145. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_NEW
  146. 2016-08-05 18:22:32.374068 [DEBUG] sofia.c:9456 sofia/external/01482423490@88.215.55.97 receiving invite from 88.215.55.97:5060 version: 1.6.9 -16-d574870 64bit
  147. 2016-08-05 18:22:32.374068 [DEBUG] sofia.c:6933 Channel sofia/external/01482423490@88.215.55.97 entering state [received][100]
  148. 2016-08-05 18:22:32.374068 [DEBUG] sofia.c:6943 Remote SDP:
  149. v=0
  150. o=MSX57 909045068753014979 1 IN IP4 88.215.55.97
  151. s=sip call
  152. c=IN IP4 88.215.55.98
  153. t=0 0
  154. m=audio 36324 RTP/AVP 8 101
  155. a=rtpmap:8 PCMA/8000
  156. a=rtpmap:101 telephone-event/8000
  157. a=fmtp:101 0-15
  158.  
  159. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  160. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  161. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  162. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_media.c:4420 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  163. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  164. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_media.c:4281 Set telephone-event payload to 101@8000
  165. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_media.c:3091 Set Codec sofia/external/01482423490@88.215.55.97 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  166. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_codec.c:111 sofia/external/01482423490@88.215.55.97 Original read codec set to PCMA:8
  167. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_media.c:4634 Set telephone-event payload to 101@8000
  168. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_media.c:4693 sofia/external/01482423490@88.215.55.97 Set 2833 dtmf send payload to 101 recv payload to 101
  169. 2016-08-05 18:22:32.374068 [DEBUG] sofia.c:7332 (sofia/external/01482423490@88.215.55.97) State Change CS_NEW -> CS_INIT
  170. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:562 (sofia/external/01482423490@88.215.55.97) State NEW
  171. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_INIT
  172. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:586 (sofia/external/01482423490@88.215.55.97) State INIT
  173. 2016-08-05 18:22:32.374068 [DEBUG] mod_sofia.c:89 sofia/external/01482423490@88.215.55.97 SOFIA INIT
  174. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:40 sofia/external/01482423490@88.215.55.97 Standard INIT
  175. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:48 (sofia/external/01482423490@88.215.55.97) State Change CS_INIT -> CS_ROUTING
  176. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:586 (sofia/external/01482423490@88.215.55.97) State INIT going to sleep
  177. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_ROUTING
  178. 2016-08-05 18:22:32.374068 [DEBUG] switch_channel.c:2249 (sofia/external/01482423490@88.215.55.97) Callstate Change DOWN -> RINGING
  179. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:602 (sofia/external/01482423490@88.215.55.97) State ROUTING
  180. 2016-08-05 18:22:32.374068 [DEBUG] mod_sofia.c:142 sofia/external/01482423490@88.215.55.97 SOFIA ROUTING
  181. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:236 sofia/external/01482423490@88.215.55.97 Standard ROUTING
  182. 2016-08-05 18:22:32.374068 [INFO] mod_dialplan_xml.c:637 Processing 01482423490 <01482423490>->01482426509 in context public
  183. Dialplan: sofia/external/01482423490@88.215.55.97 parsing [public->public] continue=true
  184. Dialplan: sofia/external/01482423490@88.215.55.97 Regex (FAIL) [public] destination_number(01482426509) =~ /^(GroupO[2-9]e)$/ break=on-false
  185. 2016-08-05 18:22:32.374068 [INFO] switch_core_state_machine.c:311 No Route, Aborting
  186. 2016-08-05 18:22:32.374068 [NOTICE] switch_core_state_machine.c:312 Hangup sofia/external/01482423490@88.215.55.97 [CS_ROUTING] [NO_ROUTE_DESTINATION]
  187. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:602 (sofia/external/01482423490@88.215.55.97) State ROUTING going to sleep
  188. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_HANGUP
  189. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:809 (sofia/external/01482423490@88.215.55.97) Callstate Change RINGING -> HANGUP
  190. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:811 (sofia/external/01482423490@88.215.55.97) State HANGUP
  191. 2016-08-05 18:22:32.374068 [DEBUG] mod_sofia.c:437 Channel sofia/external/01482423490@88.215.55.97 hanging up, cause: NO_ROUTE_DESTINATION
  192. 2016-08-05 18:22:32.374068 [DEBUG] mod_sofia.c:576 Responding to INVITE with: 404
  193. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:60 sofia/external/01482423490@88.215.55.97 Standard HANGUP, cause: NO_ROUTE_DESTINATION
  194. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:811 (sofia/external/01482423490@88.215.55.97) State HANGUP going to sleep
  195. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:578 (sofia/external/01482423490@88.215.55.97) State Change CS_HANGUP -> CS_REPORTING
  196. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_REPORTING
  197. 2016-08-05 18:22:32.374068 [DEBUG] switch_core_state_machine.c:897 (sofia/external/01482423490@88.215.55.97) State REPORTING
  198. send 687 bytes to udp/[88.215.55.97]:5060 at 18:22:32.383615:
  199.    ------------------------------------------------------------------------
  200.    SIP/2.0 404 Not Found
  201.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bKa5b9cf79975a95da0d9e2062968e2504
  202.    Max-Forwards: 69
  203.    From: <sip:01482423490@88.215.55.97>;tag=3679406561-857874
  204.    To: <sip:01482426509@88.215.55.97:5060;user=phone>;tag=79N1pHX90HBpm
  205.    Call-ID: 10681121-3679406561-857865@MSX57.gammatelecom.com
  206.    CSeq: 1 INVITE
  207.    User-Agent: FreeSWITCH
  208.    Accept: application/sdp
  209.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  210.    Supported: timer, path, replaces
  211.    Allow-Events: talk, hold, conference, refer
  212.    Reason: Q.850;cause=3;text="NO_ROUTE_DESTINATION"
  213.    Content-Length: 0
  214.    P-Asserted-Identity: "01482426509" <sip:01482426509@88.215.55.97>
  215.  
  216.    ------------------------------------------------------------------------
  217. recv 479 bytes from udp/[88.215.55.97]:5060 at 18:22:32.403393:
  218.    ------------------------------------------------------------------------
  219.    ACK sip:01482426509@77.86.26.187 SIP/2.0
  220.    Max-Forwards: 70
  221.    To: <sip:01482426509@88.215.55.97:5060;user=phone>;tag=79N1pHX90HBpm
  222.    From: <sip:01482423490@88.215.55.97>;tag=3679406561-857874
  223.    Call-ID: 10681121-3679406561-857865@MSX57.gammatelecom.com
  224.    CSeq: 1 ACK
  225.   Allow: UPDATE,INFO,NOTIFY,REGISTER,OPTIONS,BYE,INVITE,ACK,CANCEL
  226.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bKa5b9cf79975a95da0d9e2062968e2504
  227.    Contact: <sip:01482423490@88.215.55.97:5060>
  228.    Content-Length: 0
  229.  
  230.    ------------------------------------------------------------------------
  231. 2016-08-05 18:22:32.434050 [DEBUG] switch_core_state_machine.c:174 sofia/external/01482423490@88.215.55.97 Standard REPORTING, cause: NO_ROUTE_DESTINATION
  232. 2016-08-05 18:22:32.434050 [DEBUG] switch_core_state_machine.c:897 (sofia/external/01482423490@88.215.55.97) State REPORTING going to sleep
  233. 2016-08-05 18:22:32.434050 [DEBUG] switch_core_state_machine.c:569 (sofia/external/01482423490@88.215.55.97) State Change CS_REPORTING -> CS_DESTROY
  234. 2016-08-05 18:22:32.434050 [DEBUG] switch_core_session.c:1647 Session 7 (sofia/external/01482423490@88.215.55.97) Locked, Waiting on external entities
  235. 2016-08-05 18:22:32.434050 [NOTICE] switch_core_session.c:1665 Session 7 (sofia/external/01482423490@88.215.55.97) Ended
  236. 2016-08-05 18:22:32.434050 [NOTICE] switch_core_session.c:1669 Close Channel sofia/external/01482423490@88.215.55.97 [CS_DESTROY]
  237. 2016-08-05 18:22:32.434050 [DEBUG] switch_core_state_machine.c:700 (sofia/external/01482423490@88.215.55.97) Running State Change CS_DESTROY
  238. 2016-08-05 18:22:32.434050 [DEBUG] switch_core_state_machine.c:710 (sofia/external/01482423490@88.215.55.97) State DESTROY
  239. 2016-08-05 18:22:32.434050 [DEBUG] mod_sofia.c:342 sofia/external/01482423490@88.215.55.97 SOFIA DESTROY
  240. 2016-08-05 18:22:32.434050 [DEBUG] switch_core_state_machine.c:181 sofia/external/01482423490@88.215.55.97 Standard DESTROY
  241. 2016-08-05 18:22:32.434050 [DEBUG] switch_core_state_machine.c:710 (sofia/external/01482423490@88.215.55.97) State DESTROY going to sleep
  242. recv 895 bytes from udp/[88.215.55.97]:5060 at 18:23:58.651017:
  243.    ------------------------------------------------------------------------
  244.    INVITE sip:01482426509@77.86.26.187;user=phone SIP/2.0
  245.    Max-Forwards: 69
  246.    Session-Expires: 3600;refresher=uac
  247.    Min-SE: 600
  248.    Supported: timer, 100rel
  249.    To: <sip:01482426509@88.215.55.97:5060;user=phone>
  250.    From: <sip:01482423490@88.215.55.97>;tag=3679406648-133864
  251.    P-Asserted-Identity: <sip:01482423490@88.215.55.97;user=phone>
  252.    Call-ID: 10682812-3679406648-133856@MSX57.gammatelecom.com
  253.    CSeq: 1 INVITE
  254.   Allow: UPDATE,PRACK,INFO,NOTIFY,REGISTER,OPTIONS,BYE,INVITE,ACK,CANCEL
  255.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bKeb286a8385c249dc11e3680226e3f82e
  256.    Contact: <sip:01482423490@88.215.55.97:5060>
  257.    Content-Type: application/sdp
  258.    Accept: application/sdp
  259.    Content-Length: 213
  260.  
  261.    v=0
  262.    o=MSX57 9090426073067011568 1 IN IP4 88.215.55.97
  263.    s=sip call
  264.    c=IN IP4 88.215.55.98
  265.    t=0 0
  266.    m=audio 36670 RTP/AVP 8 101
  267.    a=rtpmap:8 PCMA/8000
  268.    a=rtpmap:101 telephone-event/8000
  269.    a=fmtp:101 0-15
  270.    a=sendrecv
  271.    ------------------------------------------------------------------------
  272. send 336 bytes to udp/[88.215.55.97]:5060 at 18:23:58.651479:
  273.    ------------------------------------------------------------------------
  274.    SIP/2.0 100 Trying
  275.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bKeb286a8385c249dc11e3680226e3f82e
  276.    From: <sip:01482423490@88.215.55.97>;tag=3679406648-133864
  277.    To: <sip:01482426509@88.215.55.97:5060;user=phone>
  278.    Call-ID: 10682812-3679406648-133856@MSX57.gammatelecom.com
  279.    CSeq: 1 INVITE
  280.    User-Agent: FreeSWITCH
  281.    Content-Length: 0
  282.  
  283.    ------------------------------------------------------------------------
  284. 2016-08-05 18:23:58.634107 [NOTICE] switch_channel.c:1104 New Channel sofia/external/01482423490@88.215.55.97 [e369428a-e4ee-4e65-a0b0-b8438db34352]
  285. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_NEW
  286. 2016-08-05 18:23:58.634107 [DEBUG] sofia.c:9456 sofia/external/01482423490@88.215.55.97 receiving invite from 88.215.55.97:5060 version: 1.6.9 -16-d574870 64bit
  287. 2016-08-05 18:23:58.634107 [DEBUG] sofia.c:6933 Channel sofia/external/01482423490@88.215.55.97 entering state [received][100]
  288. 2016-08-05 18:23:58.634107 [DEBUG] sofia.c:6943 Remote SDP:
  289. v=0
  290. o=MSX57 9090426073067011568 1 IN IP4 88.215.55.97
  291. s=sip call
  292. c=IN IP4 88.215.55.98
  293. t=0 0
  294. m=audio 36670 RTP/AVP 8 101
  295. a=rtpmap:8 PCMA/8000
  296. a=rtpmap:101 telephone-event/8000
  297. a=fmtp:101 0-15
  298.  
  299. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  300. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  301. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  302. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_media.c:4420 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  303. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  304. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_media.c:4281 Set telephone-event payload to 101@8000
  305. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_media.c:3091 Set Codec sofia/external/01482423490@88.215.55.97 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  306. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_codec.c:111 sofia/external/01482423490@88.215.55.97 Original read codec set to PCMA:8
  307. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_media.c:4634 Set telephone-event payload to 101@8000
  308. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_media.c:4693 sofia/external/01482423490@88.215.55.97 Set 2833 dtmf send payload to 101 recv payload to 101
  309. 2016-08-05 18:23:58.634107 [DEBUG] sofia.c:7332 (sofia/external/01482423490@88.215.55.97) State Change CS_NEW -> CS_INIT
  310. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_state_machine.c:562 (sofia/external/01482423490@88.215.55.97) State NEW
  311. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_INIT
  312. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_state_machine.c:586 (sofia/external/01482423490@88.215.55.97) State INIT
  313. 2016-08-05 18:23:58.634107 [DEBUG] mod_sofia.c:89 sofia/external/01482423490@88.215.55.97 SOFIA INIT
  314. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_state_machine.c:40 sofia/external/01482423490@88.215.55.97 Standard INIT
  315. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_state_machine.c:48 (sofia/external/01482423490@88.215.55.97) State Change CS_INIT -> CS_ROUTING
  316. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_state_machine.c:586 (sofia/external/01482423490@88.215.55.97) State INIT going to sleep
  317. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_ROUTING
  318. 2016-08-05 18:23:58.634107 [DEBUG] switch_channel.c:2249 (sofia/external/01482423490@88.215.55.97) Callstate Change DOWN -> RINGING
  319. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_state_machine.c:602 (sofia/external/01482423490@88.215.55.97) State ROUTING
  320. 2016-08-05 18:23:58.634107 [DEBUG] mod_sofia.c:142 sofia/external/01482423490@88.215.55.97 SOFIA ROUTING
  321. 2016-08-05 18:23:58.634107 [DEBUG] switch_core_state_machine.c:236 sofia/external/01482423490@88.215.55.97 Standard ROUTING
  322. 2016-08-05 18:23:58.634107 [INFO] mod_dialplan_xml.c:637 Processing 01482423490 <01482423490>->01482426509 in context public
  323. 2016-08-05 18:23:58.674067 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f2edc05ffa0 Connected.
  324. 2016-08-05 18:23:58.674067 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f2edc05ffa0 released.
  325. 2016-08-05 18:23:58.674067 [ERR] switch_xml.c:1695 Error[[error near line 12]: unexpected closing tag </condition>]
  326. 2016-08-05 18:23:58.674067 [WARNING] mod_dialplan_xml.c:667 Context public not found
  327. 2016-08-05 18:23:58.674067 [INFO] switch_core_state_machine.c:311 No Route, Aborting
  328. 2016-08-05 18:23:58.674067 [NOTICE] switch_core_state_machine.c:312 Hangup sofia/external/01482423490@88.215.55.97 [CS_ROUTING] [NO_ROUTE_DESTINATION]
  329. 2016-08-05 18:23:58.674067 [DEBUG] switch_core_state_machine.c:602 (sofia/external/01482423490@88.215.55.97) State ROUTING going to sleep
  330. 2016-08-05 18:23:58.674067 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_HANGUP
  331. 2016-08-05 18:23:58.674067 [DEBUG] switch_core_state_machine.c:809 (sofia/external/01482423490@88.215.55.97) Callstate Change RINGING -> HANGUP
  332. 2016-08-05 18:23:58.674067 [DEBUG] switch_core_state_machine.c:811 (sofia/external/01482423490@88.215.55.97) State HANGUP
  333. 2016-08-05 18:23:58.674067 [DEBUG] mod_sofia.c:437 Channel sofia/external/01482423490@88.215.55.97 hanging up, cause: NO_ROUTE_DESTINATION
  334. 2016-08-05 18:23:58.674067 [DEBUG] mod_sofia.c:576 Responding to INVITE with: 404
  335. 2016-08-05 18:23:58.674067 [DEBUG] switch_core_state_machine.c:60 sofia/external/01482423490@88.215.55.97 Standard HANGUP, cause: NO_ROUTE_DESTINATION
  336. 2016-08-05 18:23:58.674067 [DEBUG] switch_core_state_machine.c:811 (sofia/external/01482423490@88.215.55.97) State HANGUP going to sleep
  337. 2016-08-05 18:23:58.674067 [DEBUG] switch_core_state_machine.c:578 (sofia/external/01482423490@88.215.55.97) State Change CS_HANGUP -> CS_REPORTING
  338. 2016-08-05 18:23:58.674067 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_REPORTING
  339. 2016-08-05 18:23:58.674067 [DEBUG] switch_core_state_machine.c:897 (sofia/external/01482423490@88.215.55.97) State REPORTING
  340. send 687 bytes to udp/[88.215.55.97]:5060 at 18:23:58.684013:
  341.    ------------------------------------------------------------------------
  342.    SIP/2.0 404 Not Found
  343.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bKeb286a8385c249dc11e3680226e3f82e
  344.    Max-Forwards: 69
  345.    From: <sip:01482423490@88.215.55.97>;tag=3679406648-133864
  346.    To: <sip:01482426509@88.215.55.97:5060;user=phone>;tag=8jFtrceDyt18F
  347.    Call-ID: 10682812-3679406648-133856@MSX57.gammatelecom.com
  348.    CSeq: 1 INVITE
  349.    User-Agent: FreeSWITCH
  350.    Accept: application/sdp
  351.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  352.    Supported: timer, path, replaces
  353.    Allow-Events: talk, hold, conference, refer
  354.    Reason: Q.850;cause=3;text="NO_ROUTE_DESTINATION"
  355.    Content-Length: 0
  356.    P-Asserted-Identity: "01482426509" <sip:01482426509@88.215.55.97>
  357.  
  358.    ------------------------------------------------------------------------
  359. recv 479 bytes from udp/[88.215.55.97]:5060 at 18:23:58.706618:
  360.    ------------------------------------------------------------------------
  361.    ACK sip:01482426509@77.86.26.187 SIP/2.0
  362.    Max-Forwards: 70
  363.    To: <sip:01482426509@88.215.55.97:5060;user=phone>;tag=8jFtrceDyt18F
  364.    From: <sip:01482423490@88.215.55.97>;tag=3679406648-133864
  365.    Call-ID: 10682812-3679406648-133856@MSX57.gammatelecom.com
  366.    CSeq: 1 ACK
  367.   Allow: UPDATE,INFO,NOTIFY,REGISTER,OPTIONS,BYE,INVITE,ACK,CANCEL
  368.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bKeb286a8385c249dc11e3680226e3f82e
  369.    Contact: <sip:01482423490@88.215.55.97:5060>
  370.    Content-Length: 0
  371.  
  372.    ------------------------------------------------------------------------
  373. 2016-08-05 18:23:58.814086 [DEBUG] switch_core_state_machine.c:174 sofia/external/01482423490@88.215.55.97 Standard REPORTING, cause: NO_ROUTE_DESTINATION
  374. 2016-08-05 18:23:58.814086 [DEBUG] switch_core_state_machine.c:897 (sofia/external/01482423490@88.215.55.97) State REPORTING going to sleep
  375. 2016-08-05 18:23:58.814086 [DEBUG] switch_core_state_machine.c:569 (sofia/external/01482423490@88.215.55.97) State Change CS_REPORTING -> CS_DESTROY
  376. 2016-08-05 18:23:58.814086 [DEBUG] switch_core_session.c:1647 Session 8 (sofia/external/01482423490@88.215.55.97) Locked, Waiting on external entities
  377. 2016-08-05 18:23:58.814086 [NOTICE] switch_core_session.c:1665 Session 8 (sofia/external/01482423490@88.215.55.97) Ended
  378. 2016-08-05 18:23:58.814086 [NOTICE] switch_core_session.c:1669 Close Channel sofia/external/01482423490@88.215.55.97 [CS_DESTROY]
  379. 2016-08-05 18:23:58.814086 [DEBUG] switch_core_state_machine.c:700 (sofia/external/01482423490@88.215.55.97) Running State Change CS_DESTROY
  380. 2016-08-05 18:23:58.814086 [DEBUG] switch_core_state_machine.c:710 (sofia/external/01482423490@88.215.55.97) State DESTROY
  381. 2016-08-05 18:23:58.814086 [DEBUG] mod_sofia.c:342 sofia/external/01482423490@88.215.55.97 SOFIA DESTROY
  382. 2016-08-05 18:23:58.814086 [DEBUG] switch_core_state_machine.c:181 sofia/external/01482423490@88.215.55.97 Standard DESTROY
  383. 2016-08-05 18:23:58.814086 [DEBUG] switch_core_state_machine.c:710 (sofia/external/01482423490@88.215.55.97) State DESTROY going to sleep
  384. 2016-08-05 18:29:39.194098 [ERR] switch_xml.c:1310 Error including /etc/freeswitch/lang/de/phrases/*.xml
  385. 2016-08-05 18:29:39.218399 [ERR] switch_xml.c:1310 Error including /etc/freeswitch/lang/en/phrases/*.xml
  386. 2016-08-05 18:29:39.236425 [ERR] switch_xml.c:1310 Error including /etc/freeswitch/lang/fr/phrases/*.xml
  387. 2016-08-05 18:29:39.236425 [ERR] switch_xml.c:1310 Error including /etc/freeswitch/lang/ru/phrases/*.xml
  388. 2016-08-05 18:29:39.236425 [ERR] switch_xml.c:1310 Error including /etc/freeswitch/lang/he/phrases/*.xml
  389. 2016-08-05 18:29:39.314054 [INFO] mod_enum.c:880 ENUM Reloaded
  390. 2016-08-05 18:29:39.314054 [INFO] switch_time.c:1415 Timezone reloaded 530 definitions
  391. recv 895 bytes from udp/[88.215.55.97]:5060 at 18:30:41.696723:
  392.    ------------------------------------------------------------------------
  393.    INVITE sip:01482426509@77.86.26.187;user=phone SIP/2.0
  394.    Max-Forwards: 69
  395.    Session-Expires: 3600;refresher=uac
  396.    Min-SE: 600
  397.    Supported: timer, 100rel
  398.    To: <sip:01482426509@88.215.55.97:5060;user=phone>
  399.    From: <sip:01482423490@88.215.55.97>;tag=3679407051-190620
  400.    P-Asserted-Identity: <sip:01482423490@88.215.55.97;user=phone>
  401.    Call-ID: 10690800-3679407051-190611@MSX57.gammatelecom.com
  402.    CSeq: 1 INVITE
  403.   Allow: UPDATE,PRACK,INFO,NOTIFY,REGISTER,OPTIONS,BYE,INVITE,ACK,CANCEL
  404.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bK073ed6ffc47a00a88f4128ec11e755e7
  405.    Contact: <sip:01482423490@88.215.55.97:5060>
  406.    Content-Type: application/sdp
  407.    Accept: application/sdp
  408.    Content-Length: 213
  409.  
  410.    v=0
  411.    o=MSX57 9090209093220021619 1 IN IP4 88.215.55.97
  412.    s=sip call
  413.    c=IN IP4 88.215.55.98
  414.    t=0 0
  415.    m=audio 37858 RTP/AVP 8 101
  416.    a=rtpmap:8 PCMA/8000
  417.    a=rtpmap:101 telephone-event/8000
  418.    a=fmtp:101 0-15
  419.    a=sendrecv
  420.    ------------------------------------------------------------------------
  421. send 336 bytes to udp/[88.215.55.97]:5060 at 18:30:41.697241:
  422.    ------------------------------------------------------------------------
  423.    SIP/2.0 100 Trying
  424.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bK073ed6ffc47a00a88f4128ec11e755e7
  425.    From: <sip:01482423490@88.215.55.97>;tag=3679407051-190620
  426.    To: <sip:01482426509@88.215.55.97:5060;user=phone>
  427.    Call-ID: 10690800-3679407051-190611@MSX57.gammatelecom.com
  428.    CSeq: 1 INVITE
  429.    User-Agent: FreeSWITCH
  430.    Content-Length: 0
  431.  
  432.    ------------------------------------------------------------------------
  433. 2016-08-05 18:30:41.694076 [NOTICE] switch_channel.c:1104 New Channel sofia/external/01482423490@88.215.55.97 [2a911940-c453-423c-b06d-5f85bea0b05c]
  434. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_NEW
  435. 2016-08-05 18:30:41.694076 [DEBUG] sofia.c:9456 sofia/external/01482423490@88.215.55.97 receiving invite from 88.215.55.97:5060 version: 1.6.9 -16-d574870 64bit
  436. 2016-08-05 18:30:41.694076 [DEBUG] sofia.c:6933 Channel sofia/external/01482423490@88.215.55.97 entering state [received][100]
  437. 2016-08-05 18:30:41.694076 [DEBUG] sofia.c:6943 Remote SDP:
  438. v=0
  439. o=MSX57 9090209093220021619 1 IN IP4 88.215.55.97
  440. s=sip call
  441. c=IN IP4 88.215.55.98
  442. t=0 0
  443. m=audio 37858 RTP/AVP 8 101
  444. a=rtpmap:8 PCMA/8000
  445. a=rtpmap:101 telephone-event/8000
  446. a=fmtp:101 0-15
  447.  
  448. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  449. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  450. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  451. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_media.c:4420 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  452. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_media.c:4365 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  453. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_media.c:4281 Set telephone-event payload to 101@8000
  454. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_media.c:3091 Set Codec sofia/external/01482423490@88.215.55.97 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  455. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_codec.c:111 sofia/external/01482423490@88.215.55.97 Original read codec set to PCMA:8
  456. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_media.c:4634 Set telephone-event payload to 101@8000
  457. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_media.c:4693 sofia/external/01482423490@88.215.55.97 Set 2833 dtmf send payload to 101 recv payload to 101
  458. 2016-08-05 18:30:41.694076 [DEBUG] sofia.c:7332 (sofia/external/01482423490@88.215.55.97) State Change CS_NEW -> CS_INIT
  459. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:562 (sofia/external/01482423490@88.215.55.97) State NEW
  460. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_INIT
  461. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:586 (sofia/external/01482423490@88.215.55.97) State INIT
  462. 2016-08-05 18:30:41.694076 [DEBUG] mod_sofia.c:89 sofia/external/01482423490@88.215.55.97 SOFIA INIT
  463. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:40 sofia/external/01482423490@88.215.55.97 Standard INIT
  464. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:48 (sofia/external/01482423490@88.215.55.97) State Change CS_INIT -> CS_ROUTING
  465. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:586 (sofia/external/01482423490@88.215.55.97) State INIT going to sleep
  466. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_ROUTING
  467. 2016-08-05 18:30:41.694076 [DEBUG] switch_channel.c:2249 (sofia/external/01482423490@88.215.55.97) Callstate Change DOWN -> RINGING
  468. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:602 (sofia/external/01482423490@88.215.55.97) State ROUTING
  469. 2016-08-05 18:30:41.694076 [DEBUG] mod_sofia.c:142 sofia/external/01482423490@88.215.55.97 SOFIA ROUTING
  470. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:236 sofia/external/01482423490@88.215.55.97 Standard ROUTING
  471. 2016-08-05 18:30:41.694076 [INFO] mod_dialplan_xml.c:637 Processing 01482423490 <01482423490>->01482426509 in context public
  472. 2016-08-05 18:30:41.694076 [ERR] switch_xml.c:1695 Error[[error near line 12]: unexpected closing tag </condition>]
  473. 2016-08-05 18:30:41.694076 [WARNING] mod_dialplan_xml.c:667 Context public not found
  474. 2016-08-05 18:30:41.694076 [INFO] switch_core_state_machine.c:311 No Route, Aborting
  475. 2016-08-05 18:30:41.694076 [NOTICE] switch_core_state_machine.c:312 Hangup sofia/external/01482423490@88.215.55.97 [CS_ROUTING] [NO_ROUTE_DESTINATION]
  476. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:602 (sofia/external/01482423490@88.215.55.97) State ROUTING going to sleep
  477. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_HANGUP
  478. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:809 (sofia/external/01482423490@88.215.55.97) Callstate Change RINGING -> HANGUP
  479. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:811 (sofia/external/01482423490@88.215.55.97) State HANGUP
  480. 2016-08-05 18:30:41.694076 [DEBUG] mod_sofia.c:437 Channel sofia/external/01482423490@88.215.55.97 hanging up, cause: NO_ROUTE_DESTINATION
  481. 2016-08-05 18:30:41.694076 [DEBUG] mod_sofia.c:576 Responding to INVITE with: 404
  482. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:60 sofia/external/01482423490@88.215.55.97 Standard HANGUP, cause: NO_ROUTE_DESTINATION
  483. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:811 (sofia/external/01482423490@88.215.55.97) State HANGUP going to sleep
  484. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:578 (sofia/external/01482423490@88.215.55.97) State Change CS_HANGUP -> CS_REPORTING
  485. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:543 (sofia/external/01482423490@88.215.55.97) Running State Change CS_REPORTING
  486. 2016-08-05 18:30:41.694076 [DEBUG] switch_core_state_machine.c:897 (sofia/external/01482423490@88.215.55.97) State REPORTING
  487. send 687 bytes to udp/[88.215.55.97]:5060 at 18:30:41.706091:
  488.    ------------------------------------------------------------------------
  489.    SIP/2.0 404 Not Found
  490.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bK073ed6ffc47a00a88f4128ec11e755e7
  491.    Max-Forwards: 69
  492.    From: <sip:01482423490@88.215.55.97>;tag=3679407051-190620
  493.    To: <sip:01482426509@88.215.55.97:5060;user=phone>;tag=9U8jt7ygU3QUB
  494.    Call-ID: 10690800-3679407051-190611@MSX57.gammatelecom.com
  495.    CSeq: 1 INVITE
  496.    User-Agent: FreeSWITCH
  497.    Accept: application/sdp
  498.   Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY
  499.    Supported: timer, path, replaces
  500.    Allow-Events: talk, hold, conference, refer
  501.    Reason: Q.850;cause=3;text="NO_ROUTE_DESTINATION"
  502.    Content-Length: 0
  503.    P-Asserted-Identity: "01482426509" <sip:01482426509@88.215.55.97>
  504.  
  505.    ------------------------------------------------------------------------
  506. recv 479 bytes from udp/[88.215.55.97]:5060 at 18:30:41.726127:
  507.    ------------------------------------------------------------------------
  508.    ACK sip:01482426509@77.86.26.187 SIP/2.0
  509.    Max-Forwards: 70
  510.    To: <sip:01482426509@88.215.55.97:5060;user=phone>;tag=9U8jt7ygU3QUB
  511.    From: <sip:01482423490@88.215.55.97>;tag=3679407051-190620
  512.    Call-ID: 10690800-3679407051-190611@MSX57.gammatelecom.com
  513.    CSeq: 1 ACK
  514.   Allow: UPDATE,INFO,NOTIFY,REGISTER,OPTIONS,BYE,INVITE,ACK,CANCEL
  515.    Via: SIP/2.0/UDP 88.215.55.97:5060;branch=z9hG4bK073ed6ffc47a00a88f4128ec11e755e7
  516.    Contact: <sip:01482423490@88.215.55.97:5060>
  517.    Content-Length: 0
  518.  
  519.    ------------------------------------------------------------------------
  520. 2016-08-05 18:30:41.774084 [DEBUG] switch_core_state_machine.c:174 sofia/external/01482423490@88.215.55.97 Standard REPORTING, cause: NO_ROUTE_DESTINATION
  521. 2016-08-05 18:30:41.774084 [DEBUG] switch_core_state_machine.c:897 (sofia/external/01482423490@88.215.55.97) State REPORTING going to sleep
  522. 2016-08-05 18:30:41.774084 [DEBUG] switch_core_state_machine.c:569 (sofia/external/01482423490@88.215.55.97) State Change CS_REPORTING -> CS_DESTROY
  523. 2016-08-05 18:30:41.774084 [DEBUG] switch_core_session.c:1647 Session 9 (sofia/external/01482423490@88.215.55.97) Locked, Waiting on external entities
  524. 2016-08-05 18:30:41.774084 [NOTICE] switch_core_session.c:1665 Session 9 (sofia/external/01482423490@88.215.55.97) Ended
  525. 2016-08-05 18:30:41.774084 [NOTICE] switch_core_session.c:1669 Close Channel sofia/external/01482423490@88.215.55.97 [CS_DESTROY]
  526. 2016-08-05 18:30:41.774084 [DEBUG] switch_core_state_machine.c:700 (sofia/external/01482423490@88.215.55.97) Running State Change CS_DESTROY
  527. 2016-08-05 18:30:41.774084 [DEBUG] switch_core_state_machine.c:710 (sofia/external/01482423490@88.215.55.97) State DESTROY
  528. 2016-08-05 18:30:41.774084 [DEBUG] mod_sofia.c:342 sofia/external/01482423490@88.215.55.97 SOFIA DESTROY
  529. 2016-08-05 18:30:41.774084 [DEBUG] switch_core_state_machine.c:181 sofia/external/01482423490@88.215.55.97 Standard DESTROY
  530. 2016-08-05 18:30:41.774084 [DEBUG] switch_core_state_machine.c:710 (sofia/external/01482423490@88.215.55.97) State DESTROY going to sleep
  531. 2016-08-05 18:35:59.154113 [DEBUG] switch_rtp.c:1439  [  zrtp cache]:   Storing ZRTP cache to </var/lib/freeswitch/db/zrtp.dat>...
  532. 2016-08-05 18:35:59.154113 [DEBUG] switch_rtp.c:1300 Saving ZRTP cache: OK
  533.