From Abdhesh, 6 Years ago, written in Plain Text.
- view diff
Embed
  1. freeswitch@abdhesh-System-Product-Name>
  2. 2017-07-24 15:02:21.227925 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1000@10.0.0.29 [d29b26c1-cea3-4d0b-b6d1-889f56fe24de]
  3. 2017-07-24 15:02:21.227925 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@10.0.0.29) Running State Change CS_NEW (Cur 1 Tot 46)
  4. 2017-07-24 15:02:21.227925 [DEBUG] sofia.c:10031 sofia/internal/1000@10.0.0.29 receiving invite from 10.0.0.29:56382 version: 1.9.0 -446-7d195dd 64bit
  5. 2017-07-24 15:02:21.227925 [DEBUG] sofia.c:10202 IP 10.0.0.29 Rejected by acl "domains". Falling back to Digest auth.
  6. 2017-07-24 15:02:21.227925 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/1000@10.0.0.29) State NEW
  7. 2017-07-24 15:02:21.227925 [DEBUG] sofia.c:2405 detaching session d29b26c1-cea3-4d0b-b6d1-889f56fe24de
  8. 2017-07-24 15:02:21.227925 [DEBUG] sofia.c:2514 Re-attaching to session d29b26c1-cea3-4d0b-b6d1-889f56fe24de
  9. 2017-07-24 15:02:21.247975 [DEBUG] sofia.c:10031 sofia/internal/1000@10.0.0.29 receiving invite from 10.0.0.29:56382 version: 1.9.0 -446-7d195dd 64bit
  10. 2017-07-24 15:02:21.247975 [DEBUG] sofia.c:10202 IP 10.0.0.29 Rejected by acl "domains". Falling back to Digest auth.
  11. 2017-07-24 15:02:21.247975 [DEBUG] sofia.c:7247 Channel sofia/internal/1000@10.0.0.29 entering state [received][100]
  12. 2017-07-24 15:02:21.247975 [DEBUG] sofia.c:7257 Remote SDP:
  13. v=0
  14. o=Z 0 0 IN IP4 10.0.0.29
  15. s=Z
  16. c=IN IP4 10.0.0.29
  17. t=0 0
  18. m=audio 8000 RTP/AVP 3 110 8 0 98 101
  19. a=rtpmap:110 speex/8000
  20. a=rtpmap:98 iLBC/8000
  21. a=fmtp:98 mode=20
  22. a=rtpmap:101 telephone-event/8000
  23. a=fmtp:101 0-15
  24.  
  25. 2017-07-24 15:02:21.247975 [DEBUG] sofia.c:7649 (sofia/internal/1000@10.0.0.29) State Change CS_NEW -> CS_INIT
  26. 2017-07-24 15:02:21.247975 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@10.0.0.29) Running State Change CS_INIT (Cur 1 Tot 46)
  27. 2017-07-24 15:02:21.247975 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1000@10.0.0.29) State INIT
  28. 2017-07-24 15:02:21.247975 [DEBUG] mod_sofia.c:93 sofia/internal/1000@10.0.0.29 SOFIA INIT
  29. 2017-07-24 15:02:21.247975 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1000@10.0.0.29 Standard INIT
  30. 2017-07-24 15:02:21.247975 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1000@10.0.0.29) State Change CS_INIT -> CS_ROUTING
  31. 2017-07-24 15:02:21.247975 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1000@10.0.0.29) State INIT going to sleep
  32. 2017-07-24 15:02:21.247975 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@10.0.0.29) Running State Change CS_ROUTING (Cur 1 Tot 46)
  33. 2017-07-24 15:02:21.247975 [DEBUG] switch_channel.c:2249 (sofia/internal/1000@10.0.0.29) Callstate Change DOWN -> RINGING
  34. 2017-07-24 15:02:21.247975 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1000@10.0.0.29) State ROUTING
  35. 2017-07-24 15:02:21.247975 [DEBUG] mod_sofia.c:154 sofia/internal/1000@10.0.0.29 SOFIA ROUTING
  36. 2017-07-24 15:02:21.247975 [DEBUG] switch_core_state_machine.c:236 sofia/internal/1000@10.0.0.29 Standard ROUTING
  37. 2017-07-24 15:02:21.247975 [INFO] mod_dialplan_xml.c:637 Processing 1000 <1000>->9999 in context default
  38. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->unloop] continue=false
  39. Dialplan: sofia/internal/1000@10.0.0.29 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  40. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  41. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->tod_example] continue=true
  42. Dialplan: sofia/internal/1000@10.0.0.29 Date/Time Match (PASS) [tod_example] break=on-false
  43. Dialplan: sofia/internal/1000@10.0.0.29 Action set(open=true)
  44. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->holiday_example] continue=true
  45. Dialplan: sofia/internal/1000@10.0.0.29 Date/TimeMatch (FAIL) [holiday_example] break=on-false
  46. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->global-intercept] continue=false
  47. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [global-intercept] destination_number(9999) =~ /^886$/ break=on-false
  48. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->group-intercept] continue=false
  49. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [group-intercept] destination_number(9999) =~ /^\*8$/ break=on-false
  50. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->intercept-ext] continue=false
  51. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [intercept-ext] destination_number(9999) =~ /^\*\*(\d+)$/ break=on-false
  52. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->redial] continue=false
  53. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [redial] destination_number(9999) =~ /^(redial|870)$/ break=on-false
  54. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->global] continue=true
  55. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
  56. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [global] ${default_password}(4321) =~ /^1234$/ break=never
  57. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never
  58. Dialplan: sofia/internal/1000@10.0.0.29 Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false
  59. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [global] ${switch_r_sdp}(v=0
  60. o=Z 0 0 IN IP4 10.0.0.29
  61. s=Z
  62. c=IN IP4 10.0.0.29
  63. t=0 0
  64. m=audio 8000 RTP/AVP 3 110 8 0 98 101
  65. a=rtpmap:110 speex/8000
  66. a=rtpmap:98 iLBC/8000
  67. a=fmtp:98 mode=20
  68. a=rtpmap:101 telephone-event/8000
  69. a=fmtp:101 0-15
  70. ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never
  71. Dialplan: sofia/internal/1000@10.0.0.29 Absolute Condition [global]
  72. Dialplan: sofia/internal/1000@10.0.0.29 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
  73. Dialplan: sofia/internal/1000@10.0.0.29 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
  74. Dialplan: sofia/internal/1000@10.0.0.29 Action hash(insert/${domain_name}-last_dial/global/${uuid})
  75. Dialplan: sofia/internal/1000@10.0.0.29 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  76. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->snom-demo-2] continue=false
  77. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [snom-demo-2] destination_number(9999) =~ /^9001$/ break=on-false
  78. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->snom-demo-1] continue=false
  79. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [snom-demo-1] destination_number(9999) =~ /^9000$/ break=on-false
  80. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->eavesdrop] continue=false
  81. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [eavesdrop] destination_number(9999) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
  82. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->eavesdrop] continue=false
  83. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [eavesdrop] destination_number(9999) =~ /^779$/ break=on-false
  84. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->call_return] continue=false
  85. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [call_return] destination_number(9999) =~ /^\*69$|^869$|^lcr$/ break=on-false
  86. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->del-group] continue=false
  87. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [del-group] destination_number(9999) =~ /^80(\d{2})$/ break=on-false
  88. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->add-group] continue=false
  89. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [add-group] destination_number(9999) =~ /^81(\d{2})$/ break=on-false
  90. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->call-group-simo] continue=false
  91. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [call-group-simo] destination_number(9999) =~ /^82(\d{2})$/ break=on-false
  92. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->call-group-order] continue=false
  93. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [call-group-order] destination_number(9999) =~ /^83(\d{2})$/ break=on-false
  94. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->extension-intercom] continue=false
  95. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [extension-intercom] destination_number(9999) =~ /^8(10[01][0-9])$/ break=on-false
  96. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->Local_Extension] continue=false
  97. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [Local_Extension] destination_number(9999) =~ /^(10[01][0-9])$/ break=on-false
  98. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->Local_Extension_Skinny] continue=false
  99. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [Local_Extension_Skinny] destination_number(9999) =~ /^(11[01][0-9])$/ break=on-false
  100. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->group_dial_sales] continue=false
  101. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [group_dial_sales] destination_number(9999) =~ /^2000$/ break=on-false
  102. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->group_dial_support] continue=false
  103. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [group_dial_support] destination_number(9999) =~ /^2001$/ break=on-false
  104. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->group_dial_billing] continue=false
  105. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [group_dial_billing] destination_number(9999) =~ /^2002$/ break=on-false
  106. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->operator] continue=false
  107. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [operator] destination_number(9999) =~ /^(operator|0)$/ break=on-false
  108. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->vmain] continue=false
  109. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [vmain] destination_number(9999) =~ /^vmain$|^4000$|^\*98$/ break=on-false
  110. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->sip_uri] continue=false
  111. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [sip_uri] destination_number(9999) =~ /^sip:(.*)$/ break=on-false
  112. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->nb_conferences] continue=false
  113. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [nb_conferences] destination_number(9999) =~ /^(30\d{2})$/ break=on-false
  114. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->wb_conferences] continue=false
  115. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [wb_conferences] destination_number(9999) =~ /^(31\d{2})$/ break=on-false
  116. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->uwb_conferences] continue=false
  117. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [uwb_conferences] destination_number(9999) =~ /^(32\d{2})$/ break=on-false
  118. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->cdquality_conferences] continue=false
  119. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [cdquality_conferences] destination_number(9999) =~ /^(33\d{2})$/ break=on-false
  120. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->cdquality_stereo_conferences] continue=false
  121. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [cdquality_stereo_conferences] destination_number(9999) =~ /^(35\d{2}).*?-screen$/ break=on-false
  122. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->conference-canvases] continue=true
  123. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [conference-canvases] destination_number(9999) =~ /(35\d{2})-canvas-(\d+)/ break=on-false
  124. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->conf mod] continue=false
  125. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [conf mod] destination_number(9999) =~ /^6070-moderator$/ break=on-false
  126. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->cdquality_conferences] continue=false
  127. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [cdquality_conferences] destination_number(9999) =~ /^(35\d{2})$/ break=on-false
  128. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->freeswitch_public_conf_via_sip] continue=false
  129. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [freeswitch_public_conf_via_sip] destination_number(9999) =~ /^9(888|8888|1616|3232)$/ break=on-false
  130. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->mad_boss_intercom] continue=false
  131. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [mad_boss_intercom] destination_number(9999) =~ /^0911$/ break=on-false
  132. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->mad_boss_intercom] continue=false
  133. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [mad_boss_intercom] destination_number(9999) =~ /^0912$/ break=on-false
  134. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->mad_boss] continue=false
  135. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [mad_boss] destination_number(9999) =~ /^0913$/ break=on-false
  136. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->ivr_demo] continue=false
  137. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [ivr_demo] destination_number(9999) =~ /^5000$/ break=on-false
  138. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->dynamic_conference] continue=false
  139. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [dynamic_conference] destination_number(9999) =~ /^5001$/ break=on-false
  140. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->rtp_multicast_page] continue=false
  141. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [rtp_multicast_page] destination_number(9999) =~ /^pagegroup$|^7243$/ break=on-false
  142. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->park] continue=false
  143. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [park] destination_number(9999) =~ /^5900$/ break=on-false
  144. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->unpark] continue=false
  145. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [unpark] destination_number(9999) =~ /^5901$/ break=on-false
  146. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->valet_park] continue=false
  147. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [valet_park] destination_number(9999) =~ /^(6000)$/ break=on-false
  148. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->valet_park] continue=false
  149. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [valet_park] destination_number(9999) =~ /^((?!6000)60\d{2})$/ break=on-false
  150. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->park] continue=false
  151. Dialplan: sofia/internal/1000@10.0.0.29 Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false
  152. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [park] destination_number(9999) =~ /park\+(\d+)/ break=on-false
  153. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->unpark] continue=false
  154. Dialplan: sofia/internal/1000@10.0.0.29 Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false
  155. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [unpark] destination_number(9999) =~ /^parking$/ break=on-false
  156. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->park] continue=false
  157. Dialplan: sofia/internal/1000@10.0.0.29 Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false
  158. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [park] destination_number(9999) =~ /callpark/ break=on-false
  159. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->unpark] continue=false
  160. Dialplan: sofia/internal/1000@10.0.0.29 Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false
  161. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [unpark] destination_number(9999) =~ /pickup/ break=on-false
  162. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->wait] continue=false
  163. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [wait] destination_number(9999) =~ /^wait$/ break=on-false
  164. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->fax_receive] continue=false
  165. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [fax_receive] destination_number(9999) =~ /^9178$/ break=on-false
  166. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->fax_transmit] continue=false
  167. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [fax_transmit] destination_number(9999) =~ /^9179$/ break=on-false
  168. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->ringback_180] continue=false
  169. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [ringback_180] destination_number(9999) =~ /^9180$/ break=on-false
  170. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->ringback_183_uk_ring] continue=false
  171. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [ringback_183_uk_ring] destination_number(9999) =~ /^9181$/ break=on-false
  172. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->ringback_183_music_ring] continue=false
  173. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [ringback_183_music_ring] destination_number(9999) =~ /^9182$/ break=on-false
  174. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->ringback_post_answer_uk_ring] continue=false
  175. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [ringback_post_answer_uk_ring] destination_number(9999) =~ /^9183$/ break=on-false
  176. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->ringback_post_answer_music] continue=false
  177. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [ringback_post_answer_music] destination_number(9999) =~ /^9184$/ break=on-false
  178. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->ClueCon] continue=false
  179. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [ClueCon] destination_number(9999) =~ /^9191$/ break=on-false
  180. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->show_info] continue=false
  181. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [show_info] destination_number(9999) =~ /^9192$/ break=on-false
  182. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->video_record] continue=false
  183. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [video_record] destination_number(9999) =~ /^9193$/ break=on-false
  184. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->video_playback] continue=false
  185. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [video_playback] destination_number(9999) =~ /^9194$/ break=on-false
  186. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->delay_echo] continue=false
  187. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [delay_echo] destination_number(9999) =~ /^9195$/ break=on-false
  188. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->echo] continue=false
  189. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [echo] destination_number(9999) =~ /^9196$/ break=on-false
  190. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->milliwatt] continue=false
  191. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [milliwatt] destination_number(9999) =~ /^9197$/ break=on-false
  192. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->tone_stream] continue=false
  193. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [tone_stream] destination_number(9999) =~ /^9198$/ break=on-false
  194. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->zrtp_enrollement] continue=false
  195. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [zrtp_enrollement] destination_number(9999) =~ /^9787$/ break=on-false
  196. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->hold_music] continue=false
  197. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [hold_music] destination_number(9999) =~ /^9664$/ break=on-false
  198. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->laugh break] continue=false
  199. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [laugh break] destination_number(9999) =~ /^9386$/ break=on-false
  200. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->101] continue=false
  201. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [101] destination_number(9999) =~ /^101$/ break=on-false
  202. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->pizza_demo] continue=false
  203. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [pizza_demo] destination_number(9999) =~ /^(pizza|74992)$/ break=on-false
  204. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->Talking Clock Time] continue=false
  205. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [Talking Clock Time] destination_number(9999) =~ /^9170$/ break=on-false
  206. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->Talking Clock Date] continue=false
  207. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [Talking Clock Date] destination_number(9999) =~ /^9171$/ break=on-false
  208. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->Talking Clock Date and Time] continue=false
  209. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [Talking Clock Date and Time] destination_number(9999) =~ /^9172$/ break=on-false
  210. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->local.example.com] continue=false
  211. Dialplan: sofia/internal/1000@10.0.0.29 Regex (PASS) [local.example.com] ${toll_allow}(domestic,international,local) =~ /local/ break=on-false
  212. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [local.example.com] destination_number(9999) =~ /^(\d{7})$/ break=on-false
  213. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->domestic.example.com] continue=false
  214. Dialplan: sofia/internal/1000@10.0.0.29 Regex (PASS) [domestic.example.com] ${toll_allow}(domestic,international,local) =~ /domestic/ break=on-false
  215. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [domestic.example.com] destination_number(9999) =~ /^(\d{11})$/ break=on-false
  216. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->international.example.com] continue=false
  217. Dialplan: sofia/internal/1000@10.0.0.29 Regex (PASS) [international.example.com] ${toll_allow}(domestic,international,local) =~ /international/ break=on-false
  218. Dialplan: sofia/internal/1000@10.0.0.29 Regex (FAIL) [international.example.com] destination_number(9999) =~ /^(011\d+)$/ break=on-false
  219. Dialplan: sofia/internal/1000@10.0.0.29 parsing [default->Socket_Test] continue=false
  220. Dialplan: sofia/internal/1000@10.0.0.29 Regex (PASS) [Socket_Test] destination_number(9999) =~ /^9999$/ break=on-false
  221. Dialplan: sofia/internal/1000@10.0.0.29 Action socket(127.0.0.1:8084 async full)
  222. Dialplan: sofia/internal/1000@10.0.0.29 Action park()
  223. 2017-07-24 15:02:21.267973 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/1000@10.0.0.29) State Change CS_ROUTING -> CS_EXECUTE
  224. 2017-07-24 15:02:21.267973 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1000@10.0.0.29) State ROUTING going to sleep
  225. 2017-07-24 15:02:21.267973 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@10.0.0.29) Running State Change CS_EXECUTE (Cur 1 Tot 46)
  226. 2017-07-24 15:02:21.267973 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1000@10.0.0.29) State EXECUTE
  227. 2017-07-24 15:02:21.267973 [DEBUG] mod_sofia.c:209 sofia/internal/1000@10.0.0.29 SOFIA EXECUTE
  228. 2017-07-24 15:02:21.267973 [DEBUG] switch_core_state_machine.c:328 sofia/internal/1000@10.0.0.29 Standard EXECUTE
  229. EXECUTE sofia/internal/1000@10.0.0.29 set(open=true)
  230. 2017-07-24 15:02:21.267973 [DEBUG] mod_dptools.c:1570 SET sofia/internal/1000@10.0.0.29 [open]=[true]
  231. EXECUTE sofia/internal/1000@10.0.0.29 hash(insert/10.0.0.29-spymap/1000/d29b26c1-cea3-4d0b-b6d1-889f56fe24de)
  232. EXECUTE sofia/internal/1000@10.0.0.29 hash(insert/10.0.0.29-last_dial/1000/9999)
  233. EXECUTE sofia/internal/1000@10.0.0.29 hash(insert/10.0.0.29-last_dial/global/d29b26c1-cea3-4d0b-b6d1-889f56fe24de)
  234. EXECUTE sofia/internal/1000@10.0.0.29 export(RFC2822_DATE=Mon, 24 Jul 2017 15:02:21 +0100)
  235. 2017-07-24 15:02:21.267973 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Mon, 24 Jul 2017 15:02:21 +0100]
  236. EXECUTE sofia/internal/1000@10.0.0.29 socket(127.0.0.1:8084 async full)
  237. 2017-07-24 15:02:21.267973 [NOTICE] mod_event_socket.c:447 Trying host: 127.0.0.1:8084
  238. 2017-07-24 15:02:21.467919 [DEBUG] switch_ivr.c:624 sofia/internal/1000@10.0.0.29 Command Execute playback(/usr/share/freeswitch/sounds/en/us/callie/voicemail/8000/vm-tutorial_change_pin.wav)
  239. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_session.c:2708 Application playback Requires media! pre_answering channel sofia/internal/1000@10.0.0.29
  240. 2017-07-24 15:02:21.467919 [INFO] switch_core_session.c:2710 Sending early media
  241. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [GSM:3:8000:20:13200:1]/[G722:9:8000:20:64000:1]
  242. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMU:0:8000:20:64000:1]
  243. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [GSM:3:8000:20:13200:1]/[PCMA:8:8000:20:64000:1]
  244. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [speex:110:8000:20:0:1]/[G722:9:8000:20:64000:1]
  245. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMU:0:8000:20:64000:1]
  246. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [speex:110:8000:20:0:1]/[PCMA:8:8000:20:64000:1]
  247. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  248. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  249. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  250. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5168 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  251. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  252. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  253. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5168 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  254. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  255. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [iLBC:98:8000:30:0:1]/[G722:9:8000:20:64000:1]
  256. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMU:0:8000:20:64000:1]
  257. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5113 Audio Codec Compare [iLBC:98:8000:30:0:1]/[PCMA:8:8000:20:64000:1]
  258. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5029 Set telephone-event payload to 101@8000
  259. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:3428 Set Codec sofia/internal/1000@10.0.0.29 PCMA/8000 20 ms 160 samples 64000 bits 1 channels
  260. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_codec.c:111 sofia/internal/1000@10.0.0.29 Original read codec set to PCMA:8
  261. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5372 Set telephone-event payload to 101@8000
  262. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:5430 sofia/internal/1000@10.0.0.29 Set 2833 dtmf send payload to 101 recv payload to 101
  263. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:8147 AUDIO RTP [sofia/internal/1000@10.0.0.29] 10.0.0.29 port 27038 -> 10.0.0.29 port 8000 codec: 8 ms: 20
  264. 2017-07-24 15:02:21.467919 [DEBUG] switch_rtp.c:4164 Starting timer [soft] 160 bytes per 20ms
  265. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:8450 sofia/internal/1000@10.0.0.29 Set 2833 dtmf send payload to 101
  266. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:8457 sofia/internal/1000@10.0.0.29 Set 2833 dtmf receive payload to 101
  267. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:8480 sofia/internal/1000@10.0.0.29 Set rtp dtmf delay to 40
  268. 2017-07-24 15:02:21.467919 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1000@10.0.0.29!
  269. 2017-07-24 15:02:21.467919 [DEBUG] switch_channel.c:3482 (sofia/internal/1000@10.0.0.29) Callstate Change RINGING -> EARLY
  270. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_media.c:8130 Audio params are unchanged for sofia/internal/1000@10.0.0.29.
  271. 2017-07-24 15:02:21.467919 [DEBUG] mod_sofia.c:2512 Ring SDP:
  272. v=0
  273. o=FreeSWITCH 1500877903 1500877904 IN IP4 10.0.0.29
  274. s=FreeSWITCH
  275. c=IN IP4 10.0.0.29
  276. t=0 0
  277. m=audio 27038 RTP/AVP 8 101
  278. a=rtpmap:8 PCMA/8000
  279. a=rtpmap:101 telephone-event/8000
  280. a=fmtp:101 0-16
  281. a=ptime:20
  282. a=sendrecv
  283.  
  284. EXECUTE sofia/internal/1000@10.0.0.29 playback(/usr/share/freeswitch/sounds/en/us/callie/voicemail/8000/vm-tutorial_change_pin.wav)
  285. 2017-07-24 15:02:21.467919 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
  286. 2017-07-24 15:02:21.467919 [DEBUG] sofia.c:7247 Channel sofia/internal/1000@10.0.0.29 entering state [early][183]
  287. 2017-07-24 15:02:21.467919 [DEBUG] switch_ivr.c:624 sofia/internal/1000@10.0.0.29 Command Execute filter(Event-Name HEARTBEAT)
  288. 2017-07-24 15:02:21.467919 [ERR] switch_core_session.c:2683 Invalid Application filter
  289. 2017-07-24 15:02:21.467919 [NOTICE] switch_core_session.c:2684 Hangup sofia/internal/1000@10.0.0.29 [CS_EXECUTE] [DESTINATION_OUT_OF_ORDER]
  290. 2017-07-24 15:02:21.467919 [DEBUG] switch_ivr.c:624 sofia/internal/1000@10.0.0.29 Command Execute playback(/usr/share/freeswitch/sounds/en/us/callie/voicemail/8000/vm-tutorial_change_pin.wav)
  291. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_session.c:2671 sofia/internal/1000@10.0.0.29 Channel is hungup and application 'playback' does not have the zombie_exec flag.
  292. 2017-07-24 15:02:21.467919 [DEBUG] switch_ivr_play_say.c:1942 done playing file /usr/share/freeswitch/sounds/en/us/callie/voicemail/8000/vm-tutorial_change_pin.wav
  293. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_session.c:2885 sofia/internal/1000@10.0.0.29 skip receive message [PHONE_EVENT] (channel is hungup already)
  294. 2017-07-24 15:02:21.467919 [DEBUG] switch_ivr.c:667 sofia/internal/1000@10.0.0.29 skip receive message [VIDEO_SYNC] (channel is hungup already)
  295. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_session.c:2885 sofia/internal/1000@10.0.0.29 skip receive message [PHONE_EVENT] (channel is hungup already)
  296. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1000@10.0.0.29) State EXECUTE going to sleep
  297. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@10.0.0.29) Running State Change CS_HANGUP (Cur 1 Tot 46)
  298. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1000@10.0.0.29) Callstate Change EARLY -> HANGUP
  299. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1000@10.0.0.29) State HANGUP
  300. 2017-07-24 15:02:21.467919 [DEBUG] mod_sofia.c:449 Channel sofia/internal/1000@10.0.0.29 hanging up, cause: DESTINATION_OUT_OF_ORDER
  301. 2017-07-24 15:02:21.467919 [DEBUG] mod_sofia.c:588 Responding to INVITE with: 502
  302. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1000@10.0.0.29 Standard HANGUP, cause: DESTINATION_OUT_OF_ORDER
  303. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1000@10.0.0.29) State HANGUP going to sleep
  304. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1000@10.0.0.29) State Change CS_HANGUP -> CS_REPORTING
  305. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1000@10.0.0.29) Running State Change CS_REPORTING (Cur 1 Tot 46)
  306. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1000@10.0.0.29) State REPORTING
  307. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1000@10.0.0.29 Standard REPORTING, cause: DESTINATION_OUT_OF_ORDER
  308. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1000@10.0.0.29) State REPORTING going to sleep
  309. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1000@10.0.0.29) State Change CS_REPORTING -> CS_DESTROY
  310. 2017-07-24 15:02:21.467919 [DEBUG] switch_core_session.c:1713 Session 46 (sofia/internal/1000@10.0.0.29) Locked, Waiting on external entities
  311. 2017-07-24 15:02:21.487916 [NOTICE] switch_core_session.c:1731 Session 46 (sofia/internal/1000@10.0.0.29) Ended
  312. 2017-07-24 15:02:21.487916 [NOTICE] switch_core_session.c:1735 Close Channel sofia/internal/1000@10.0.0.29 [CS_DESTROY]
  313. 2017-07-24 15:02:21.487916 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1000@10.0.0.29) Running State Change CS_DESTROY (Cur 0 Tot 46)
  314. 2017-07-24 15:02:21.487916 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1000@10.0.0.29) State DESTROY
  315. 2017-07-24 15:02:21.487916 [DEBUG] mod_sofia.c:354 sofia/internal/1000@10.0.0.29 SOFIA DESTROY
  316. 2017-07-24 15:02:21.487916 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1000@10.0.0.29 Standard DESTROY
  317. 2017-07-24 15:02:21.487916 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1000@10.0.0.29) State DESTROY going to sleep
  318. freeswitch@abdhesh-System-Product-Name>
  319.