From John MacPherson, 7 Years ago, written in Plain Text.
- go back
Embed
Viewing differences between and Forwarding Issue
  1. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [NOTICE] switch_channel.c:1104 New Channel sofia/external/15554321212@96.88.69.88 [0c9c70b8-0345-46e1-a193-67751042f058]
  2. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_NEW (Cur 1 Tot 488)
  3. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] sofia.c:9815 sofia/external/15554321212@96.88.69.88 receiving invite from 96.88.69.88:9020 version: 1.6.14 -23-e460bf8 64bit
  4. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] sofia.c:7041 Channel sofia/external/15554321212@96.88.69.88 entering state [received][100]
  5. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] sofia.c:7051 Remote SDP:
  6. 0c9c70b8-0345-46e1-a193-67751042f058 v=0
  7. 0c9c70b8-0345-46e1-a193-67751042f058 o=Sansay-VSXi 188 1 IN IP4 96.88.69.88
  8. 0c9c70b8-0345-46e1-a193-67751042f058 s=Session Controller
  9. 0c9c70b8-0345-46e1-a193-67751042f058 c=IN IP4 207.112.37.25
  10. 0c9c70b8-0345-46e1-a193-67751042f058 t=0 0
  11. 0c9c70b8-0345-46e1-a193-67751042f058 m=audio 33720 RTP/AVP 0 18 101
  12. 0c9c70b8-0345-46e1-a193-67751042f058 a=rtpmap:0 PCMU/8000
  13. 0c9c70b8-0345-46e1-a193-67751042f058 a=rtpmap:18 G729/8000
  14. 0c9c70b8-0345-46e1-a193-67751042f058 a=fmtp:18 annexb=no
  15. 0c9c70b8-0345-46e1-a193-67751042f058 a=rtpmap:101 telephone-event/8000
  16. 0c9c70b8-0345-46e1-a193-67751042f058 a=fmtp:101 0-15
  17. 0c9c70b8-0345-46e1-a193-67751042f058 a=ptime:20
  18. 0c9c70b8-0345-46e1-a193-67751042f058
  19. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  20. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  21. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4433 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  22. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  23. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  24. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  25. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
  26. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  27. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  28. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [G729:18:8000:20:8000:1]/[GSM:3:8000:20:13200:1]
  29. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1]
  30. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4294 Set telephone-event payload to 101@8000
  31. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:3043 Set Codec sofia/external/15554321212@96.88.69.88 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  32. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_codec.c:111 sofia/external/15554321212@96.88.69.88 Original read codec set to PCMU:0
  33. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4637 Set telephone-event payload to 101@8000
  34. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_media.c:4696 sofia/external/15554321212@96.88.69.88 Set 2833 dtmf send payload to 101 recv payload to 101
  35. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] sofia.c:7464 (sofia/external/15554321212@96.88.69.88) State Change CS_NEW -> CS_INIT
  36. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_state_machine.c:603 (sofia/external/15554321212@96.88.69.88) State NEW
  37. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_INIT (Cur 1 Tot 488)
  38. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_state_machine.c:627 (sofia/external/15554321212@96.88.69.88) State INIT
  39. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] mod_sofia.c:90 sofia/external/15554321212@96.88.69.88 SOFIA INIT
  40. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_state_machine.c:40 sofia/external/15554321212@96.88.69.88 Standard INIT
  41. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_state_machine.c:48 (sofia/external/15554321212@96.88.69.88) State Change CS_INIT -> CS_ROUTING
  42. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_state_machine.c:627 (sofia/external/15554321212@96.88.69.88) State INIT going to sleep
  43. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_ROUTING (Cur 1 Tot 488)
  44. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_channel.c:2249 (sofia/external/15554321212@96.88.69.88) Callstate Change DOWN -> RINGING
  45. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_state_machine.c:643 (sofia/external/15554321212@96.88.69.88) State ROUTING
  46. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] mod_sofia.c:143 sofia/external/15554321212@96.88.69.88 SOFIA ROUTING
  47. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] switch_core_state_machine.c:236 sofia/external/15554321212@96.88.69.88 Standard ROUTING
  48. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [INFO] mod_dialplan_xml.c:637 Processing HOROM <5554321212>->15559998585 in context public
  49. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->13152840001] continue=false
  50. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [13152840001] destination_number(15559998585) =~ /^(13152840001)$/ break=on-false
  51. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->19022063688] continue=false
  52. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [19022063688] destination_number(15559998585) =~ /^(19022063688)$/ break=on-false
  53. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->19028750503] continue=false
  54. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [19028750503] destination_number(15559998585) =~ /^(19028750503)$/ break=on-false
  55. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->19028750505] continue=false
  56. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [19028750505] destination_number(15559998585) =~ /^(19028750505)$/ break=on-false
  57. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->19028750804] continue=false
  58. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [19028750804] destination_number(15559998585) =~ /^(19028750804)$/ break=on-false
  59. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->19028751434] continue=false
  60. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [19028751434] destination_number(15559998585) =~ /^(19028751434)$/ break=on-false
  61. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->15559998585] continue=false
  62. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [15559998585] destination_number(15559998585) =~ /^(15559998585)$/ break=on-false
  63. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(call_direction=inbound) INLINE
  64. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(call_direction=inbound)
  65. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [call_direction]=[inbound]
  66. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(domain_uuid=53dfbf50-263f-4208-9540-c2abd247b89b) INLINE
  67. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(domain_uuid=53dfbf50-263f-4208-9540-c2abd247b89b)
  68. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [domain_uuid]=[53dfbf50-263f-4208-9540-c2abd247b89b]
  69. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(domain_name=my.somevoip.com.ne) INLINE
  70. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(domain_name=my.somevoip.com.ne)
  71. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.522253 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [domain_name]=[my.somevoip.com.ne]
  72. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action transfer(5559998585 XML my.somevoip.com.ne)
  73. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] switch_core_state_machine.c:286 (sofia/external/15554321212@96.88.69.88) State Change CS_ROUTING -> CS_EXECUTE
  74. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] switch_core_state_machine.c:643 (sofia/external/15554321212@96.88.69.88) State ROUTING going to sleep
  75. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_EXECUTE (Cur 1 Tot 488)
  76. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] switch_core_state_machine.c:650 (sofia/external/15554321212@96.88.69.88) State EXECUTE
  77. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] mod_sofia.c:198 sofia/external/15554321212@96.88.69.88 SOFIA EXECUTE
  78. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] switch_core_state_machine.c:328 sofia/external/15554321212@96.88.69.88 Standard EXECUTE
  79. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 transfer(5559998585 XML my.somevoip.com.ne)
  80. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] switch_ivr.c:2160 (sofia/external/15554321212@96.88.69.88) State Change CS_EXECUTE -> CS_ROUTING
  81. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [NOTICE] switch_ivr.c:2167 Transfer sofia/external/15554321212@96.88.69.88 to XML[5559998585@my.somevoip.com.ne]
  82. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] switch_core_state_machine.c:650 (sofia/external/15554321212@96.88.69.88) State EXECUTE going to sleep
  83. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_ROUTING (Cur 1 Tot 488)
  84. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] switch_core_state_machine.c:643 (sofia/external/15554321212@96.88.69.88) State ROUTING
  85. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] mod_sofia.c:143 sofia/external/15554321212@96.88.69.88 SOFIA ROUTING
  86. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [DEBUG] switch_core_state_machine.c:236 sofia/external/15554321212@96.88.69.88 Standard ROUTING
  87. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.532247 [INFO] mod_dialplan_xml.c:637 Processing HOROM <5554321212>->5559998585 in context my.somevoip.com.ne
  88. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->user_exists] continue=true
  89. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_exists] () =~ // break=on-false
  90. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
  91. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(user_exists=true)
  92. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.542244 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [user_exists]=[true]
  93. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_exists] ${user_exists}(true) =~ /^true$/ break=on-false
  94. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(extension_uuid=${user_data ${destination_number}@${domain_name} var extension_uuid})
  95. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(hold_music=${user_data ${destination_number}@${domain_name} var hold_music})
  96. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_all_enabled=${user_data ${destination_number}@${domain_name} var forward_all_enabled})
  97. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_all_destination=${user_data ${destination_number}@${domain_name} var forward_all_destination})
  98. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_busy_enabled=${user_data ${destination_number}@${domain_name} var forward_busy_enabled})
  99. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_busy_destination=${user_data ${destination_number}@${domain_name} var forward_busy_destination})
  100. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_no_answer_enabled=${user_data ${destination_number}@${domain_name} var forward_no_answer_enabled})
  101. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_no_answer_destination=${user_data ${destination_number}@${domain_name} var forward_no_answer_destination})
  102. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_user_not_registered_enabled=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_enabled})
  103. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_user_not_registered_destination=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_destination})
  104. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(do_not_disturb=${user_data ${destination_number}@${domain_name} var do_not_disturb})
  105. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(call_timeout=${user_data ${destination_number}@${domain_name} var call_timeout})
  106. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(missed_call_app=${user_data ${destination_number}@${domain_name} var missed_call_app})
  107. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(missed_call_data=${user_data ${destination_number}@${domain_name} var missed_call_data})
  108. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(call_screen_enabled=${user_data ${destination_number}@${domain_name} var call_screen_enabled}) INLINE
  109. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(call_screen_enabled=false)
  110. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.542244 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [call_screen_enabled]=[false]
  111. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->call-direction] continue=true
  112. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [call-direction] ${call_direction}(inbound) =~ /^(inbound|outbound|local)$/ break=never
  113. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->variables] continue=true
  114. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [variables] () =~ // break=on-false
  115. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action export(origination_callee_id_name=${destination_number})
  116. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  117. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(timezone=America/Halifax) INLINE
  118. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(timezone=America/Halifax)
  119. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.542244 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [timezone]=[America/Halifax]
  120. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->user_record] continue=true
  121. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] () =~ // break=on-false
  122. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
  123. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(user_record=)
  124. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.542244 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [user_record]=[UNDEF]
  125. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
  126. 2017-06-02 20:40:02.552254 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x205f830 Connected.
  127. 2017-06-02 20:40:02.552254 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x205f830 released.
  128. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(from_user_exists=false)
  129. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.552254 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [from_user_exists]=[false]
  130. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
  131. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
  132. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
  133. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
  134. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
  135. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
  136. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
  137. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
  138. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
  139. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
  140. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
  141. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
  142. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
  143. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
  144. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
  145. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
  146. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
  147. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
  148. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
  149. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
  150. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
  151. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
  152. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
  153. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
  154. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->redial] continue=true
  155. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [redial] destination_number(5559998585) =~ /^(redial|\*870)$/ break=on-true
  156. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [redial] () =~ // break=never
  157. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
  158. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->speed_dial] continue=false
  159. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [speed_dial] destination_number(5559998585) =~ /^\*0(.*)$/ break=on-false
  160. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->sip_has_crypto] continue=false
  161. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [sip_has_crypto] ${sip_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never
  162. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->transfer.10d] continue=false
  163. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [transfer.10d] ${user_exists}(true) =~ /false/ break=on-false
  164. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->VoIP_Innovations_Conversational_Primary_IP.011.9-17d] continue=false
  165. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [VoIP_Innovations_Conversational_Primary_IP.011.9-17d] ${user_exists}(true) =~ /false/ break=on-false
  166. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->VoIP_Innovations_Conversational_Primary_IP.10d] continue=false
  167. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [VoIP_Innovations_Conversational_Primary_IP.10d] ${user_exists}(true) =~ /false/ break=on-false
  168. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->VoIP_Innovations_Conversational_Primary_IP.11d] continue=false
  169. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [VoIP_Innovations_Conversational_Primary_IP.11d] ${user_exists}(true) =~ /false/ break=on-false
  170. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->VoIP_Innovations_Conversational_Primary_IP.1d10] continue=false
  171. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [VoIP_Innovations_Conversational_Primary_IP.1d10] ${user_exists}(true) =~ /false/ break=on-false
  172. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->agent_status] continue=false
  173. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [agent_status] destination_number(5559998585) =~ /^\*22$/ break=on-false
  174. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->agent_status_id] continue=false
  175. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [agent_status_id] destination_number(5559998585) =~ /^\*23$/ break=on-false
  176. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->group-intercept] continue=false
  177. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [group-intercept] destination_number(5559998585) =~ /^\*8$/ break=on-false
  178. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->page-extension] continue=false
  179. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [page-extension] destination_number(5559998585) =~ /^\*8(\d{2,7})$/ break=on-false
  180. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->eavesdrop] continue=false
  181. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [eavesdrop] destination_number(5559998585) =~ /^\*33(\d{2,7})$/ break=on-false
  182. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->call_privacy] continue=false
  183. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call_privacy] destination_number(5559998585) =~ /^\*67(\d+)$/ break=on-false
  184. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->call_return] continue=false
  185. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call_return] destination_number(5559998585) =~ /^\*69$/ break=on-false
  186. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->extension_queue] continue=false
  187. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [extension_queue] destination_number(5559998585) =~ /^\*800(.*)$/ break=on-false
  188. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->intercept-ext] continue=false
  189. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [intercept-ext] destination_number(5559998585) =~ /^\*\*(\d+)$/ break=on-false
  190. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->intercept-ext-polycom] continue=false
  191. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [intercept-ext-polycom] destination_number(5559998585) =~ /^\*97(\d+)$/ break=on-false
  192. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->dx] continue=false
  193. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [dx] destination_number(5559998585) =~ /^dx$/ break=on-false
  194. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->att_xfer] continue=false
  195. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [att_xfer] destination_number(5559998585) =~ /^att_xfer$/ break=on-false
  196. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->extension-to-voicemail] continue=false
  197. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [extension-to-voicemail] username(5554321212) =~ /^5554321212$/ break=on-false
  198. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [extension-to-voicemail] destination_number(5559998585) =~ /^5554321212$/ break=on-false
  199. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->send_to_voicemail] continue=false
  200. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [send_to_voicemail] destination_number(5559998585) =~ /^\*99(\d{2,10})$/ break=on-false
  201. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->vmain] continue=false
  202. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [vmain] destination_number(5559998585) =~ /^vmain$|^\*4000$|^\*98$/ break=on-false
  203. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->xfer_vm] continue=false
  204. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [xfer_vm] destination_number(5559998585) =~ /^xfer_vm$/ break=on-false
  205. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->is_transfer] continue=false
  206. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [is_transfer] destination_number(5559998585) =~ /^is_transfer$/ break=on-false
  207. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->vmain_user] continue=false
  208. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [vmain_user] destination_number(5559998585) =~ /^\*97$/ break=on-false
  209. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->cf] continue=false
  210. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [cf] destination_number(5559998585) =~ /^cf$/ break=on-false
  211. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->delay_echo] continue=false
  212. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [delay_echo] destination_number(5559998585) =~ /^\*9195$/ break=on-false
  213. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->echo] continue=false
  214. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [echo] destination_number(5559998585) =~ /^\*9196$/ break=on-false
  215. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->is_zrtp_secure] continue=true
  216. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [is_zrtp_secure] ${zrtp_secure_media_confirmed}() =~ /^true$/ break=on-false
  217. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 ANTI-Action eval(not_secure)
  218. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->milliwatt] continue=false
  219. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [milliwatt] destination_number(5559998585) =~ /^\*9197$/ break=on-false
  220. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->is_secure] continue=true
  221. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [is_secure] ${sip_via_protocol}(udp) =~ /tls/ break=on-false
  222. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->tone_stream] continue=false
  223. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [tone_stream] destination_number(5559998585) =~ /^\*9198$/ break=on-false
  224. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->hold_music] continue=false
  225. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [hold_music] destination_number(5559998585) =~ /^\*9664$/ break=on-false
  226. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->recordings] continue=false
  227. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [recordings] destination_number(5559998585) =~ /^\*(732)$/ break=on-false
  228. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->directory] continue=false
  229. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [directory] destination_number(5559998585) =~ /^\*411$/ break=on-false
  230. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->wake-up] continue=false
  231. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [wake-up] destination_number(5559998585) =~ /^\*(925)$/ break=on-false
  232. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->valet_park] continue=false
  233. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [valet_park] destination_number(5559998585) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=never
  234. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [valet_park] ${sip_h_Referred-By}() =~ /sip:(.*)@.*/ break=never
  235. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [valet_park] destination_number(5559998585) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=never
  236. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [valet_park] destination_number(5559998585) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=on-false
  237. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->operator] continue=false
  238. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [operator] destination_number(5559998585) =~ /^0$|^operator$/ break=on-false
  239. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->operator-forward] continue=false
  240. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [operator-forward] destination_number(5559998585) =~ /^\*000$/ break=on-false
  241. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->do-not-disturb] continue=false
  242. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [do-not-disturb] destination_number(5559998585) =~ /^\*77$/ break=on-true
  243. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [do-not-disturb] destination_number(5559998585) =~ /^\*78$|\*363$/ break=on-true
  244. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [do-not-disturb] destination_number(5559998585) =~ /^\*79$/ break=on-false
  245. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->call-forward] continue=false
  246. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call-forward] destination_number(5559998585) =~ /^\*72$/ break=on-true
  247. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call-forward] destination_number(5559998585) =~ /^\*73$/ break=on-true
  248. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call-forward] destination_number(5559998585) =~ /^\*74$/ break=on-true
  249. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->follow-me] continue=false
  250. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [follow-me] destination_number(5559998585) =~ /^\*21$/ break=on-false
  251. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->clear_sip_auto_answer] continue=true
  252. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [clear_sip_auto_answer] ${click_to_call}() =~ /true/ break=on-false
  253. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->talking clock date and time] continue=true
  254. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [talking clock date and time] destination_number(5559998585) =~ /^\*9172$/ break=on-false
  255. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->talking clock time] continue=true
  256. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [talking clock time] destination_number(5559998585) =~ /^\*9170$/ break=on-false
  257. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->talking clock date] continue=true
  258. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [talking clock date] destination_number(5559998585) =~ /^\*9171$/ break=on-false
  259. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->call_screen] continue=true
  260. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call_screen] ${call_screen_enabled}(false) =~ /^true$/ break=on-false
  261. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->local_extension] continue=true
  262. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [local_extension] ${user_exists}(true) =~ /true/ break=on-false
  263. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action export(dialed_extension=${destination_number}) INLINE
  264. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 export(dialed_extension=5559998585)
  265. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.552254 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [dialed_extension]=[5559998585]
  266. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action limit(hash ${domain_name} ${destination_number} ${limit_max} ${limit_destination})
  267. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action export(rtp_secure_media=true)
  268. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [local_extension] ${sip_authorized}() =~ /true/ break=never
  269. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 ANTI-Action set(bind_target=peer) INLINE
  270. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(bind_target=peer)
  271. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.552254 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [bind_target]=[peer]
  272. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [local_extension] () =~ // break=on-false
  273. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action bind_digit_action(local,*1,exec:execute_extension,dx XML ${context},${bind_target})
  274. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action bind_digit_action(local,*2,exec:record_session,${recordings_dir}/${domain_name}/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${uuid}.${record_ext},${bind_target})
  275. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action bind_digit_action(local,*3,exec:execute_extension,cf XML ${context},${bind_target})
  276. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action bind_digit_action(local,*4,exec:execute_extension,att_xfer XML ${context},${bind_target})
  277. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action digit_action_set_realm(local)
  278. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [local_extension] () =~ // break=on-false
  279. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(hangup_after_bridge=true)
  280. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(continue_on_fail=true)
  281. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
  282. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
  283. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(called_party_call_group=${user_data(${dialed_extension}@${domain_name} var call_group)})
  284. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action hash(insert/${domain_name}-last_dial/${called_party_call_group}/${uuid})
  285. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(api_hangup_hook=lua app.lua hangup)
  286. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action export(domain_name=${context})
  287. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action bridge(user/${destination_number}@${domain_name})
  288. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action lua(app.lua failure_handler)
  289. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->voicemail] continue=false
  290. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [voicemail] ${user_exists}(true) =~ /true/ break=on-false
  291. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action answer()
  292. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action sleep(1000)
  293. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(voicemail_action=save)
  294. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(voicemail_id=${destination_number})
  295. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(voicemail_profile=default)
  296. 0c9c70b8-0345-46e1-a193-67751042f058 Dialplan: sofia/external/15554321212@96.88.69.88 Action lua(app.lua voicemail)
  297. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.552254 [DEBUG] switch_core_state_machine.c:286 (sofia/external/15554321212@96.88.69.88) State Change CS_ROUTING -> CS_EXECUTE
  298. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.552254 [DEBUG] switch_core_state_machine.c:643 (sofia/external/15554321212@96.88.69.88) State ROUTING going to sleep
  299. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.552254 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_EXECUTE (Cur 1 Tot 488)
  300. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.552254 [DEBUG] switch_core_state_machine.c:650 (sofia/external/15554321212@96.88.69.88) State EXECUTE
  301. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.552254 [DEBUG] mod_sofia.c:198 sofia/external/15554321212@96.88.69.88 SOFIA EXECUTE
  302. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.552254 [DEBUG] switch_core_state_machine.c:328 sofia/external/15554321212@96.88.69.88 Standard EXECUTE
  303. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(extension_uuid=c53678f6-62e8-48df-8fba-e7ddd39de7b3)
  304. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.562243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [extension_uuid]=[c53678f6-62e8-48df-8fba-e7ddd39de7b3]
  305. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(hold_music=local_stream://default)
  306. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.562243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [hold_music]=[local_stream://default]
  307. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_all_enabled=true)
  308. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.562243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_all_enabled]=[true]
  309. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_all_destination=+15059687272)
  310. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.572243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_all_destination]=[+15059687272]
  311. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_busy_enabled=false)
  312. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.572243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_busy_enabled]=[false]
  313. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_busy_destination=)
  314. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.572243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_busy_destination]=[UNDEF]
  315. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_no_answer_enabled=false)
  316. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.582244 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_no_answer_enabled]=[false]
  317. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_no_answer_destination=)
  318. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.582244 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_no_answer_destination]=[UNDEF]
  319. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_user_not_registered_enabled=false)
  320. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.582244 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_user_not_registered_enabled]=[false]
  321. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_user_not_registered_destination=)
  322. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.592242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_user_not_registered_destination]=[UNDEF]
  323. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(do_not_disturb=false)
  324. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.592242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [do_not_disturb]=[false]
  325. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(call_timeout=30)
  326. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.592242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [call_timeout]=[30]
  327. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(missed_call_app=)
  328. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.592242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [missed_call_app]=[UNDEF]
  329. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(missed_call_data=)
  330. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.602242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [missed_call_data]=[UNDEF]
  331. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 export(origination_callee_id_name=5559998585)
  332. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.602242 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[5559998585]
  333. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(RFC2822_DATE=Fri, 02 Jun 2017 20:40:02 +0000)
  334. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.602242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [RFC2822_DATE]=[Fri, 02 Jun 2017 20:40:02 +0000]
  335. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 hash(insert/my.somevoip.com.ne-last_dial/5554321212/5559998585)
  336. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 eval(not_secure)
  337. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 limit(hash my.somevoip.com.ne 5559998585 )
  338. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.602242 [DEBUG] switch_limit.c:126 incr called: my.somevoip.com.ne_5559998585 max:-1, interval:0
  339. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.602242 [DEBUG] mod_hash.c:194 Usage for my.somevoip.com.ne_5559998585 is now 1
  340. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 export(rtp_secure_media=true)
  341. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.602242 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [rtp_secure_media]=[true]
  342. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 bind_digit_action(local,*1,exec:execute_extension,dx XML my.somevoip.com.ne,peer)
  343. 2017-06-02 20:40:02.602242 [INFO] switch_ivr_async.c:214 Digit parser DPTOOLS: Setting realm to 'local'
  344. 2017-06-02 20:40:02.602242 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *1/local/0 callback: 0x6d49d7be6c20 data: 0x1f7b4f8
  345. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 bind_digit_action(local,*2,exec:record_session,/var/lib/freeswitch/recordings/my.somevoip.com.ne/archive/2017/Jun/02/0c9c70b8-0345-46e1-a193-67751042f058.wav,peer)
  346. 2017-06-02 20:40:02.602242 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *2/local/0 callback: 0x6d49d7be6c20 data: 0x1f7b728
  347. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 bind_digit_action(local,*3,exec:execute_extension,cf XML my.somevoip.com.ne,peer)
  348. 2017-06-02 20:40:02.602242 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *3/local/0 callback: 0x6d49d7be6c20 data: 0x1f7b8c0
  349. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 bind_digit_action(local,*4,exec:execute_extension,att_xfer XML my.somevoip.com.ne,peer)
  350. 2017-06-02 20:40:02.602242 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *4/local/0 callback: 0x6d49d7be6c20 data: 0x217f1c0
  351. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 digit_action_set_realm(local)
  352. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(hangup_after_bridge=true)
  353. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.602242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [hangup_after_bridge]=[true]
  354. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(continue_on_fail=true)
  355. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.602242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [continue_on_fail]=[true]
  356. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 hash(insert/my.somevoip.com.ne-call_return/5559998585/5554321212)
  357. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 hash(insert/my.somevoip.com.ne-last_dial_ext/5559998585/0c9c70b8-0345-46e1-a193-67751042f058)
  358. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(called_party_call_group=)
  359. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.602242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [called_party_call_group]=[UNDEF]
  360. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 hash(insert/my.somevoip.com.ne-last_dial//0c9c70b8-0345-46e1-a193-67751042f058)
  361. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 set(api_hangup_hook=lua app.lua hangup)
  362. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.602242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [api_hangup_hook]=[lua app.lua hangup]
  363. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 export(domain_name=my.somevoip.com.ne)
  364. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.602242 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [domain_name]=[my.somevoip.com.ne]
  365. 0c9c70b8-0345-46e1-a193-67751042f058 EXECUTE sofia/external/15554321212@96.88.69.88 bridge(user/5559998585@my.somevoip.com.ne)
  366. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.612241 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [dialed_extension]=[5559998585] to event
  367. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.612241 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [origination_callee_id_name]=[5559998585] to event
  368. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.612241 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [rtp_secure_media]=[true] to event
  369. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.612241 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [domain_name]=[my.somevoip.com.ne] to event
  370. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.612241 [DEBUG] switch_ivr_originate.c:2138 Parsing global variables
  371. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.612241 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [dialed_extension]=[5559998585] to event
  372. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.612241 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [origination_callee_id_name]=[5559998585] to event
  373. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.612241 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [rtp_secure_media]=[true] to event
  374. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.612241 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [domain_name]=[my.somevoip.com.ne] to event
  375. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:02.612241 [DEBUG] switch_ivr_originate.c:2138 Parsing global variables
  376. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [NOTICE] switch_channel.c:1104 New Channel sofia/external/5059687272 [873afbb6-acd8-432e-b6ea-1b739a7e7e9e]
  377. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] mod_sofia.c:4808 (sofia/external/5059687272) State Change CS_NEW -> CS_INIT
  378. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_state_machine.c:584 (sofia/external/5059687272) Running State Change CS_INIT (Cur 2 Tot 489)
  379. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_state_machine.c:627 (sofia/external/5059687272) State INIT
  380. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] mod_sofia.c:90 sofia/external/5059687272 SOFIA INIT
  381. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [1 AEAD_AES_256_GCM_8 inline:mDQ3pGJiDxb7Vas4ROTVd5RiZQtsvmkWgKK9ZQmNiofXxku5e/DLSieVExU]
  382. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [1 AEAD_AES_256_GCM_8 inline:OXBHtbaSSWGOSo8R3Ov+DN7Wt1d4NUFaAgFqjNN0EB1dgnWZkQ+OIx9TX9c]
  383. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [2 AEAD_AES_128_GCM_8 inline:Aq9nmphdN6YiFULHVaVYlDzwhqJurhqBA0rOrw]
  384. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [2 AEAD_AES_128_GCM_8 inline:5ZFrW/CKX8pUeA03U/CbTndiUEblbswZrz0UwQ]
  385. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [3 AES_CM_256_HMAC_SHA1_80 inline:mA+63efDsOqJ/H4dXG/0Cklg63QBL5f7BP+NIB+mIQoxF6Imau+3JBKSzf+fcQ]
  386. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [3 AES_CM_256_HMAC_SHA1_80 inline:LqoPuEZGwDGidR91S6iPuLEkfLjY3XZVHGgAf0tqsVqTixZEXG+044/lMkY4hw]
  387. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [4 AES_CM_192_HMAC_SHA1_80 inline:RSb4bBURiROdrqjM7y6Wrldsl3G8D5Li0XKcCjxVXrJLEntZzlo]
  388. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [4 AES_CM_192_HMAC_SHA1_80 inline:pxVsna3eS7KGffK60waLX3tVpzSZmyymxdoUMH9mgf8FS4LhyJE]
  389. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [5 AES_CM_128_HMAC_SHA1_80 inline:exwPwLlaTMO4+AcQZCz4rKc3x7Yf5kZr6xmRzGSK]
  390. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [5 AES_CM_128_HMAC_SHA1_80 inline:hdoPU1O++QW5ackkG9dLZTPcOCaRDZ848r4SPhTz]
  391. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [6 AES_CM_256_HMAC_SHA1_32 inline:TJuHHUQAVisZmpTOMlpKOePg375HGhuuBFtbxADn6W9j3JM67DBLtkpLKK+esQ]
  392. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [6 AES_CM_256_HMAC_SHA1_32 inline:Wp3S1dgwVJ9uNWPuKmcL2kLrkaH/CdqmpIwlyzVUZK9SjpIAzwk8eHYsnNIVsg]
  393. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [7 AES_CM_192_HMAC_SHA1_32 inline:q2HaT2/rqHGV/3P4xHMDQQnjjpcseKJweFcEnaeawdXH27diALY]
  394. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [7 AES_CM_192_HMAC_SHA1_32 inline:rWNvLQ5VVpxfn4nMtDE81rxAgpMTzlFzPARWkIZy65coEDASazk]
  395. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [8 AES_CM_128_HMAC_SHA1_32 inline:D23aEEz3NPU/MJbn3Ay1MSplaM1OuaqT4JKGNpOV]
  396. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [8 AES_CM_128_HMAC_SHA1_32 inline:Fp5011U7lla5jlowG4j/HdI8XO07EFUGMfwzsY6U]
  397. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [9 AES_CM_128_NULL_AUTH inline:CnVIkpEUdaYbh44qy+ZL+nE7ELHJzjzkG/PQYgMF]
  398. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [9 AES_CM_128_NULL_AUTH inline:vVt8OiMnoJOLC9vMLHhxZg4cUfShJy9RdKaS0wPu]
  399. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] sofia_glue.c:1283 sofia/external/5059687272 sending invite version: 1.6.14 -23-e460bf8 64bit
  400. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e Local SDP:
  401. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e v=0
  402. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e o=FreeSWITCH 1496410354 1496410355 IN IP4 111.111.111.111
  403. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e s=FreeSWITCH
  404. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e c=IN IP4 111.111.111.111
  405. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e t=0 0
  406. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e m=audio 25648 RTP/SAVP 0 8 3 101 13
  407. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=rtpmap:0 PCMU/8000
  408. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=rtpmap:8 PCMA/8000
  409. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=rtpmap:3 GSM/8000
  410. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=rtpmap:101 telephone-event/8000
  411. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=fmtp:101 0-16
  412. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=crypto:1 AEAD_AES_256_GCM_8 inline:mDQ3pGJiDxb7Vas4ROTVd5RiZQtsvmkWgKK9ZQmNiofXxku5e/DLSieVExU
  413. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=crypto:2 AEAD_AES_128_GCM_8 inline:Aq9nmphdN6YiFULHVaVYlDzwhqJurhqBA0rOrw
  414. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=crypto:3 AES_CM_256_HMAC_SHA1_80 inline:mA+63efDsOqJ/H4dXG/0Cklg63QBL5f7BP+NIB+mIQoxF6Imau+3JBKSzf+fcQ
  415. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=crypto:4 AES_CM_192_HMAC_SHA1_80 inline:RSb4bBURiROdrqjM7y6Wrldsl3G8D5Li0XKcCjxVXrJLEntZzlo
  416. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:exwPwLlaTMO4+AcQZCz4rKc3x7Yf5kZr6xmRzGSK
  417. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=crypto:6 AES_CM_256_HMAC_SHA1_32 inline:TJuHHUQAVisZmpTOMlpKOePg375HGhuuBFtbxADn6W9j3JM67DBLtkpLKK+esQ
  418. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=crypto:7 AES_CM_192_HMAC_SHA1_32 inline:q2HaT2/rqHGV/3P4xHMDQQnjjpcseKJweFcEnaeawdXH27diALY
  419. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:D23aEEz3NPU/MJbn3Ay1MSplaM1OuaqT4JKGNpOV
  420. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=crypto:9 AES_CM_128_NULL_AUTH inline:CnVIkpEUdaYbh44qy+ZL+nE7ELHJzjzkG/PQYgMF
  421. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=rtpmap:13 CN/8000
  422. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=ptime:20
  423. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e a=sendrecv
  424. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e
  425. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_state_machine.c:40 sofia/external/5059687272 Standard INIT
  426. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_state_machine.c:48 (sofia/external/5059687272) State Change CS_INIT -> CS_ROUTING
  427. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_state_machine.c:627 (sofia/external/5059687272) State INIT going to sleep
  428. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_state_machine.c:584 (sofia/external/5059687272) Running State Change CS_ROUTING (Cur 2 Tot 489)
  429. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] sofia.c:7041 Channel sofia/external/5059687272 entering state [calling][0]
  430. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_state_machine.c:643 (sofia/external/5059687272) State ROUTING
  431. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] mod_sofia.c:143 sofia/external/5059687272 SOFIA ROUTING
  432. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_ivr_originate.c:67 (sofia/external/5059687272) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  433. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_state_machine.c:643 (sofia/external/5059687272) State ROUTING going to sleep
  434. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_state_machine.c:584 (sofia/external/5059687272) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 489)
  435. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_state_machine.c:662 (sofia/external/5059687272) State CONSUME_MEDIA
  436. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:02.612241 [DEBUG] switch_core_state_machine.c:662 (sofia/external/5059687272) State CONSUME_MEDIA going to sleep
  437. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.132252 [DEBUG] sofia.c:7041 Channel sofia/external/15554321212@96.88.69.88 entering state [terminated][487]
  438. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.132252 [NOTICE] sofia.c:8212 Hangup sofia/external/15554321212@96.88.69.88 [CS_EXECUTE] [ORIGINATOR_CANCEL]
  439. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.132252 [DEBUG] mod_hash.c:297 Usage for my.somevoip.com.ne_5559998585 is now 0
  440. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [NOTICE] switch_ivr_originate.c:3601 Hangup sofia/external/5059687272 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
  441. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.152248 [DEBUG] switch_ivr_originate.c:3818 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
  442. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:584 (sofia/external/5059687272) Running State Change CS_HANGUP (Cur 2 Tot 489)
  443. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:850 (sofia/external/5059687272) Callstate Change DOWN -> HANGUP
  444. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:852 (sofia/external/5059687272) State HANGUP
  445. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] mod_sofia.c:432 sofia/external/5059687272 Overriding SIP cause 487 with 487 from the other leg
  446. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] mod_sofia.c:438 Channel sofia/external/5059687272 hanging up, cause: ORIGINATOR_CANCEL
  447. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] mod_sofia.c:502 Sending CANCEL to sofia/external/5059687272
  448. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:60 sofia/external/5059687272 Standard HANGUP, cause: ORIGINATOR_CANCEL
  449. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:852 (sofia/external/5059687272) State HANGUP going to sleep
  450. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:619 (sofia/external/5059687272) State Change CS_HANGUP -> CS_REPORTING
  451. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:584 (sofia/external/5059687272) Running State Change CS_REPORTING (Cur 2 Tot 489)
  452. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:938 (sofia/external/5059687272) State REPORTING
  453. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:174 sofia/external/5059687272 Standard REPORTING, cause: ORIGINATOR_CANCEL
  454. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:938 (sofia/external/5059687272) State REPORTING going to sleep
  455. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.152248 [NOTICE] switch_ivr_originate.c:2841 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
  456. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.152248 [DEBUG] switch_ivr_originate.c:3829 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
  457. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:610 (sofia/external/5059687272) State Change CS_REPORTING -> CS_DESTROY
  458. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_session.c:1647 Session 489 (sofia/external/5059687272) Locked, Waiting on external entities
  459. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [NOTICE] switch_core_session.c:1665 Session 489 (sofia/external/5059687272) Ended
  460. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [NOTICE] switch_core_session.c:1669 Close Channel sofia/external/5059687272 [CS_DESTROY]
  461. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:741 (sofia/external/5059687272) Running State Change CS_DESTROY (Cur 1 Tot 489)
  462. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:751 (sofia/external/5059687272) State DESTROY
  463. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] mod_sofia.c:343 sofia/external/5059687272 SOFIA DESTROY
  464. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:181 sofia/external/5059687272 Standard DESTROY
  465. 873afbb6-acd8-432e-b6ea-1b739a7e7e9e 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:751 (sofia/external/5059687272) State DESTROY going to sleep
  466. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.152248 [INFO] mod_dptools.c:3409 Originate Failed. Cause: ORIGINATOR_CANCEL
  467. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.152248 [DEBUG] switch_core_session.c:2797 sofia/external/15554321212@96.88.69.88 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  468. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:650 (sofia/external/15554321212@96.88.69.88) State EXECUTE going to sleep
  469. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.152248 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_HANGUP (Cur 1 Tot 489)
  470. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.162245 [DEBUG] switch_core_state_machine.c:850 (sofia/external/15554321212@96.88.69.88) Callstate Change RINGING -> HANGUP
  471. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.162245 [DEBUG] switch_core_state_machine.c:852 (sofia/external/15554321212@96.88.69.88) State HANGUP
  472. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.162245 [DEBUG] mod_sofia.c:438 Channel sofia/external/15554321212@96.88.69.88 hanging up, cause: ORIGINATOR_CANCEL
  473. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.162245 [DEBUG] switch_core_state_machine.c:60 sofia/external/15554321212@96.88.69.88 Standard HANGUP, cause: ORIGINATOR_CANCEL
  474. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.162245 [DEBUG] switch_core_state_machine.c:852 (sofia/external/15554321212@96.88.69.88) State HANGUP going to sleep
  475. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.162245 [DEBUG] switch_core_state_machine.c:783 Hangup Command with no Session lua(app.lua hangup):
  476. 0c9c70b8-0345-46e1-a193-67751042f058
  477. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.162245 [DEBUG] switch_core_state_machine.c:619 (sofia/external/15554321212@96.88.69.88) State Change CS_HANGUP -> CS_REPORTING
  478. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.162245 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_REPORTING (Cur 1 Tot 489)
  479. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.162245 [DEBUG] switch_core_state_machine.c:938 (sofia/external/15554321212@96.88.69.88) State REPORTING
  480. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.282246 [DEBUG] switch_core_state_machine.c:174 sofia/external/15554321212@96.88.69.88 Standard REPORTING, cause: ORIGINATOR_CANCEL
  481. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.282246 [DEBUG] switch_core_state_machine.c:938 (sofia/external/15554321212@96.88.69.88) State REPORTING going to sleep
  482. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.282246 [DEBUG] switch_core_state_machine.c:610 (sofia/external/15554321212@96.88.69.88) State Change CS_REPORTING -> CS_DESTROY
  483. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.282246 [DEBUG] switch_core_session.c:1647 Session 488 (sofia/external/15554321212@96.88.69.88) Locked, Waiting on external entities
  484. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.282246 [NOTICE] switch_core_session.c:1665 Session 488 (sofia/external/15554321212@96.88.69.88) Ended
  485. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.282246 [NOTICE] switch_core_session.c:1669 Close Channel sofia/external/15554321212@96.88.69.88 [CS_DESTROY]
  486. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.282246 [DEBUG] switch_core_state_machine.c:741 (sofia/external/15554321212@96.88.69.88) Running State Change CS_DESTROY (Cur 0 Tot 489)
  487. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.282246 [DEBUG] switch_core_state_machine.c:751 (sofia/external/15554321212@96.88.69.88) State DESTROY
  488. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.282246 [DEBUG] mod_sofia.c:343 sofia/external/15554321212@96.88.69.88 SOFIA DESTROY
  489. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.282246 [DEBUG] switch_core_state_machine.c:181 sofia/external/15554321212@96.88.69.88 Standard DESTROY
  490. 0c9c70b8-0345-46e1-a193-67751042f058 2017-06-02 20:40:04.282246 [DEBUG] switch_core_state_machine.c:751 (sofia/external/15554321212@96.88.69.88) State DESTROY going to sleep
  491. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [NOTICE] switch_channel.c:1104 New Channel sofia/external/15554321212@96.88.69.88 [5f780b7d-593b-4524-a6c5-1767d3f6a047]
  492. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_NEW (Cur 1 Tot 490)
  493. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] sofia.c:9815 sofia/external/15554321212@96.88.69.88 receiving invite from 96.88.69.88:9020 version: 1.6.14 -23-e460bf8 64bit
  494. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] sofia.c:7041 Channel sofia/external/15554321212@96.88.69.88 entering state [received][100]
  495. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] sofia.c:7051 Remote SDP:
  496. 5f780b7d-593b-4524-a6c5-1767d3f6a047 v=0
  497. 5f780b7d-593b-4524-a6c5-1767d3f6a047 o=Sansay-VSXi 188 1 IN IP4 96.88.69.88
  498. 5f780b7d-593b-4524-a6c5-1767d3f6a047 s=Session Controller
  499. 5f780b7d-593b-4524-a6c5-1767d3f6a047 c=IN IP4 207.112.37.25
  500. 5f780b7d-593b-4524-a6c5-1767d3f6a047 t=0 0
  501. 5f780b7d-593b-4524-a6c5-1767d3f6a047 m=audio 36436 RTP/AVP 0 18 101
  502. 5f780b7d-593b-4524-a6c5-1767d3f6a047 a=rtpmap:0 PCMU/8000
  503. 5f780b7d-593b-4524-a6c5-1767d3f6a047 a=rtpmap:18 G729/8000
  504. 5f780b7d-593b-4524-a6c5-1767d3f6a047 a=fmtp:18 annexb=no
  505. 5f780b7d-593b-4524-a6c5-1767d3f6a047 a=rtpmap:101 telephone-event/8000
  506. 5f780b7d-593b-4524-a6c5-1767d3f6a047 a=fmtp:101 0-15
  507. 5f780b7d-593b-4524-a6c5-1767d3f6a047 a=ptime:20
  508. 5f780b7d-593b-4524-a6c5-1767d3f6a047
  509. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  510. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  511. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4433 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  512. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  513. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  514. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  515. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1]
  516. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  517. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  518. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [G729:18:8000:20:8000:1]/[GSM:3:8000:20:13200:1]
  519. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1]
  520. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4294 Set telephone-event payload to 101@8000
  521. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:3043 Set Codec sofia/external/15554321212@96.88.69.88 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  522. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_codec.c:111 sofia/external/15554321212@96.88.69.88 Original read codec set to PCMU:0
  523. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4637 Set telephone-event payload to 101@8000
  524. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_media.c:4696 sofia/external/15554321212@96.88.69.88 Set 2833 dtmf send payload to 101 recv payload to 101
  525. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] sofia.c:7464 (sofia/external/15554321212@96.88.69.88) State Change CS_NEW -> CS_INIT
  526. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_state_machine.c:603 (sofia/external/15554321212@96.88.69.88) State NEW
  527. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_INIT (Cur 1 Tot 490)
  528. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_state_machine.c:627 (sofia/external/15554321212@96.88.69.88) State INIT
  529. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] mod_sofia.c:90 sofia/external/15554321212@96.88.69.88 SOFIA INIT
  530. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_state_machine.c:40 sofia/external/15554321212@96.88.69.88 Standard INIT
  531. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_state_machine.c:48 (sofia/external/15554321212@96.88.69.88) State Change CS_INIT -> CS_ROUTING
  532. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_state_machine.c:627 (sofia/external/15554321212@96.88.69.88) State INIT going to sleep
  533. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_ROUTING (Cur 1 Tot 490)
  534. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_channel.c:2249 (sofia/external/15554321212@96.88.69.88) Callstate Change DOWN -> RINGING
  535. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_state_machine.c:643 (sofia/external/15554321212@96.88.69.88) State ROUTING
  536. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] mod_sofia.c:143 sofia/external/15554321212@96.88.69.88 SOFIA ROUTING
  537. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [DEBUG] switch_core_state_machine.c:236 sofia/external/15554321212@96.88.69.88 Standard ROUTING
  538. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.372253 [INFO] mod_dialplan_xml.c:637 Processing HOROM <5554321212>->15559998585 in context public
  539. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->13152840001] continue=false
  540. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [13152840001] destination_number(15559998585) =~ /^(13152840001)$/ break=on-false
  541. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->19022063688] continue=false
  542. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [19022063688] destination_number(15559998585) =~ /^(19022063688)$/ break=on-false
  543. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->19028750503] continue=false
  544. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [19028750503] destination_number(15559998585) =~ /^(19028750503)$/ break=on-false
  545. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->19028750505] continue=false
  546. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [19028750505] destination_number(15559998585) =~ /^(19028750505)$/ break=on-false
  547. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->19028750804] continue=false
  548. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [19028750804] destination_number(15559998585) =~ /^(19028750804)$/ break=on-false
  549. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->19028751434] continue=false
  550. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [19028751434] destination_number(15559998585) =~ /^(19028751434)$/ break=on-false
  551. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [public->15559998585] continue=false
  552. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [15559998585] destination_number(15559998585) =~ /^(15559998585)$/ break=on-false
  553. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(call_direction=inbound) INLINE
  554. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(call_direction=inbound)
  555. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [call_direction]=[inbound]
  556. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(domain_uuid=53dfbf50-263f-4208-9540-c2abd247b89b) INLINE
  557. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(domain_uuid=53dfbf50-263f-4208-9540-c2abd247b89b)
  558. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [domain_uuid]=[53dfbf50-263f-4208-9540-c2abd247b89b]
  559. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(domain_name=my.somevoip.com.ne) INLINE
  560. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(domain_name=my.somevoip.com.ne)
  561. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [domain_name]=[my.somevoip.com.ne]
  562. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action transfer(5559998585 XML my.somevoip.com.ne)
  563. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] switch_core_state_machine.c:286 (sofia/external/15554321212@96.88.69.88) State Change CS_ROUTING -> CS_EXECUTE
  564. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] switch_core_state_machine.c:643 (sofia/external/15554321212@96.88.69.88) State ROUTING going to sleep
  565. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_EXECUTE (Cur 1 Tot 490)
  566. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] switch_core_state_machine.c:650 (sofia/external/15554321212@96.88.69.88) State EXECUTE
  567. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] mod_sofia.c:198 sofia/external/15554321212@96.88.69.88 SOFIA EXECUTE
  568. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] switch_core_state_machine.c:328 sofia/external/15554321212@96.88.69.88 Standard EXECUTE
  569. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 transfer(5559998585 XML my.somevoip.com.ne)
  570. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] switch_ivr.c:2160 (sofia/external/15554321212@96.88.69.88) State Change CS_EXECUTE -> CS_ROUTING
  571. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [NOTICE] switch_ivr.c:2167 Transfer sofia/external/15554321212@96.88.69.88 to XML[5559998585@my.somevoip.com.ne]
  572. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] switch_core_state_machine.c:650 (sofia/external/15554321212@96.88.69.88) State EXECUTE going to sleep
  573. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_ROUTING (Cur 1 Tot 490)
  574. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] switch_core_state_machine.c:643 (sofia/external/15554321212@96.88.69.88) State ROUTING
  575. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] mod_sofia.c:143 sofia/external/15554321212@96.88.69.88 SOFIA ROUTING
  576. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [DEBUG] switch_core_state_machine.c:236 sofia/external/15554321212@96.88.69.88 Standard ROUTING
  577. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.382245 [INFO] mod_dialplan_xml.c:637 Processing HOROM <5554321212>->5559998585 in context my.somevoip.com.ne
  578. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->user_exists] continue=true
  579. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_exists] () =~ // break=on-false
  580. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
  581. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(user_exists=true)
  582. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.392244 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [user_exists]=[true]
  583. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_exists] ${user_exists}(true) =~ /^true$/ break=on-false
  584. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(extension_uuid=${user_data ${destination_number}@${domain_name} var extension_uuid})
  585. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(hold_music=${user_data ${destination_number}@${domain_name} var hold_music})
  586. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_all_enabled=${user_data ${destination_number}@${domain_name} var forward_all_enabled})
  587. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_all_destination=${user_data ${destination_number}@${domain_name} var forward_all_destination})
  588. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_busy_enabled=${user_data ${destination_number}@${domain_name} var forward_busy_enabled})
  589. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_busy_destination=${user_data ${destination_number}@${domain_name} var forward_busy_destination})
  590. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_no_answer_enabled=${user_data ${destination_number}@${domain_name} var forward_no_answer_enabled})
  591. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_no_answer_destination=${user_data ${destination_number}@${domain_name} var forward_no_answer_destination})
  592. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_user_not_registered_enabled=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_enabled})
  593. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(forward_user_not_registered_destination=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_destination})
  594. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(do_not_disturb=${user_data ${destination_number}@${domain_name} var do_not_disturb})
  595. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(call_timeout=${user_data ${destination_number}@${domain_name} var call_timeout})
  596. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(missed_call_app=${user_data ${destination_number}@${domain_name} var missed_call_app})
  597. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(missed_call_data=${user_data ${destination_number}@${domain_name} var missed_call_data})
  598. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(call_screen_enabled=${user_data ${destination_number}@${domain_name} var call_screen_enabled}) INLINE
  599. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(call_screen_enabled=false)
  600. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.392244 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [call_screen_enabled]=[false]
  601. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->call-direction] continue=true
  602. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [call-direction] ${call_direction}(inbound) =~ /^(inbound|outbound|local)$/ break=never
  603. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->variables] continue=true
  604. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [variables] () =~ // break=on-false
  605. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action export(origination_callee_id_name=${destination_number})
  606. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  607. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(timezone=America/Halifax) INLINE
  608. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(timezone=America/Halifax)
  609. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.392244 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [timezone]=[America/Halifax]
  610. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->user_record] continue=true
  611. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] () =~ // break=on-false
  612. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
  613. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(user_record=)
  614. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.402243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [user_record]=[UNDEF]
  615. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
  616. 2017-06-02 20:40:24.402243 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x205f830 Connected.
  617. 2017-06-02 20:40:24.402243 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x205f830 released.
  618. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(from_user_exists=false)
  619. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.402243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [from_user_exists]=[false]
  620. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
  621. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
  622. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
  623. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
  624. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
  625. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
  626. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
  627. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
  628. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
  629. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
  630. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
  631. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
  632. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
  633. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
  634. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
  635. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [user_record] ${call_direction}(inbound) =~ /^inbound$/ break=never
  636. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
  637. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
  638. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^outbound$/ break=never
  639. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
  640. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
  641. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${call_direction}(inbound) =~ /^local$/ break=never
  642. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
  643. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
  644. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->redial] continue=true
  645. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [redial] destination_number(5559998585) =~ /^(redial|\*870)$/ break=on-true
  646. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [redial] () =~ // break=never
  647. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
  648. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->speed_dial] continue=false
  649. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [speed_dial] destination_number(5559998585) =~ /^\*0(.*)$/ break=on-false
  650. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->sip_has_crypto] continue=false
  651. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [sip_has_crypto] ${sip_has_crypto}() =~ /^(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)$/ break=never
  652. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->transfer.10d] continue=false
  653. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [transfer.10d] ${user_exists}(true) =~ /false/ break=on-false
  654. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->VoIP_Innovations_Conversational_Primary_IP.011.9-17d] continue=false
  655. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [VoIP_Innovations_Conversational_Primary_IP.011.9-17d] ${user_exists}(true) =~ /false/ break=on-false
  656. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->VoIP_Innovations_Conversational_Primary_IP.10d] continue=false
  657. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [VoIP_Innovations_Conversational_Primary_IP.10d] ${user_exists}(true) =~ /false/ break=on-false
  658. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->VoIP_Innovations_Conversational_Primary_IP.11d] continue=false
  659. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [VoIP_Innovations_Conversational_Primary_IP.11d] ${user_exists}(true) =~ /false/ break=on-false
  660. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->VoIP_Innovations_Conversational_Primary_IP.1d10] continue=false
  661. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [VoIP_Innovations_Conversational_Primary_IP.1d10] ${user_exists}(true) =~ /false/ break=on-false
  662. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->agent_status] continue=false
  663. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [agent_status] destination_number(5559998585) =~ /^\*22$/ break=on-false
  664. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->agent_status_id] continue=false
  665. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [agent_status_id] destination_number(5559998585) =~ /^\*23$/ break=on-false
  666. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->group-intercept] continue=false
  667. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [group-intercept] destination_number(5559998585) =~ /^\*8$/ break=on-false
  668. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->page-extension] continue=false
  669. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [page-extension] destination_number(5559998585) =~ /^\*8(\d{2,7})$/ break=on-false
  670. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->eavesdrop] continue=false
  671. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [eavesdrop] destination_number(5559998585) =~ /^\*33(\d{2,7})$/ break=on-false
  672. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->call_privacy] continue=false
  673. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call_privacy] destination_number(5559998585) =~ /^\*67(\d+)$/ break=on-false
  674. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->call_return] continue=false
  675. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call_return] destination_number(5559998585) =~ /^\*69$/ break=on-false
  676. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->extension_queue] continue=false
  677. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [extension_queue] destination_number(5559998585) =~ /^\*800(.*)$/ break=on-false
  678. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->intercept-ext] continue=false
  679. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [intercept-ext] destination_number(5559998585) =~ /^\*\*(\d+)$/ break=on-false
  680. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->intercept-ext-polycom] continue=false
  681. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [intercept-ext-polycom] destination_number(5559998585) =~ /^\*97(\d+)$/ break=on-false
  682. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->dx] continue=false
  683. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [dx] destination_number(5559998585) =~ /^dx$/ break=on-false
  684. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->att_xfer] continue=false
  685. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [att_xfer] destination_number(5559998585) =~ /^att_xfer$/ break=on-false
  686. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->extension-to-voicemail] continue=false
  687. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [extension-to-voicemail] username(5554321212) =~ /^5554321212$/ break=on-false
  688. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [extension-to-voicemail] destination_number(5559998585) =~ /^5554321212$/ break=on-false
  689. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->send_to_voicemail] continue=false
  690. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [send_to_voicemail] destination_number(5559998585) =~ /^\*99(\d{2,10})$/ break=on-false
  691. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->vmain] continue=false
  692. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [vmain] destination_number(5559998585) =~ /^vmain$|^\*4000$|^\*98$/ break=on-false
  693. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->xfer_vm] continue=false
  694. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [xfer_vm] destination_number(5559998585) =~ /^xfer_vm$/ break=on-false
  695. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->is_transfer] continue=false
  696. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [is_transfer] destination_number(5559998585) =~ /^is_transfer$/ break=on-false
  697. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->vmain_user] continue=false
  698. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [vmain_user] destination_number(5559998585) =~ /^\*97$/ break=on-false
  699. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->cf] continue=false
  700. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [cf] destination_number(5559998585) =~ /^cf$/ break=on-false
  701. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->delay_echo] continue=false
  702. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [delay_echo] destination_number(5559998585) =~ /^\*9195$/ break=on-false
  703. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->echo] continue=false
  704. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [echo] destination_number(5559998585) =~ /^\*9196$/ break=on-false
  705. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->is_zrtp_secure] continue=true
  706. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [is_zrtp_secure] ${zrtp_secure_media_confirmed}() =~ /^true$/ break=on-false
  707. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 ANTI-Action eval(not_secure)
  708. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->milliwatt] continue=false
  709. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [milliwatt] destination_number(5559998585) =~ /^\*9197$/ break=on-false
  710. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->is_secure] continue=true
  711. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [is_secure] ${sip_via_protocol}(udp) =~ /tls/ break=on-false
  712. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->tone_stream] continue=false
  713. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [tone_stream] destination_number(5559998585) =~ /^\*9198$/ break=on-false
  714. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->hold_music] continue=false
  715. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [hold_music] destination_number(5559998585) =~ /^\*9664$/ break=on-false
  716. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->recordings] continue=false
  717. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [recordings] destination_number(5559998585) =~ /^\*(732)$/ break=on-false
  718. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->directory] continue=false
  719. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [directory] destination_number(5559998585) =~ /^\*411$/ break=on-false
  720. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->wake-up] continue=false
  721. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [wake-up] destination_number(5559998585) =~ /^\*(925)$/ break=on-false
  722. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->valet_park] continue=false
  723. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [valet_park] destination_number(5559998585) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=never
  724. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [valet_park] ${sip_h_Referred-By}() =~ /sip:(.*)@.*/ break=never
  725. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [valet_park] destination_number(5559998585) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=never
  726. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [valet_park] destination_number(5559998585) =~ /^(park\+)?(\*59[0-9][0-9])$/ break=on-false
  727. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->operator] continue=false
  728. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [operator] destination_number(5559998585) =~ /^0$|^operator$/ break=on-false
  729. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->operator-forward] continue=false
  730. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [operator-forward] destination_number(5559998585) =~ /^\*000$/ break=on-false
  731. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->do-not-disturb] continue=false
  732. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [do-not-disturb] destination_number(5559998585) =~ /^\*77$/ break=on-true
  733. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [do-not-disturb] destination_number(5559998585) =~ /^\*78$|\*363$/ break=on-true
  734. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [do-not-disturb] destination_number(5559998585) =~ /^\*79$/ break=on-false
  735. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->call-forward] continue=false
  736. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call-forward] destination_number(5559998585) =~ /^\*72$/ break=on-true
  737. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call-forward] destination_number(5559998585) =~ /^\*73$/ break=on-true
  738. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call-forward] destination_number(5559998585) =~ /^\*74$/ break=on-true
  739. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->follow-me] continue=false
  740. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [follow-me] destination_number(5559998585) =~ /^\*21$/ break=on-false
  741. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->clear_sip_auto_answer] continue=true
  742. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [clear_sip_auto_answer] ${click_to_call}() =~ /true/ break=on-false
  743. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->talking clock date and time] continue=true
  744. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [talking clock date and time] destination_number(5559998585) =~ /^\*9172$/ break=on-false
  745. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->talking clock time] continue=true
  746. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [talking clock time] destination_number(5559998585) =~ /^\*9170$/ break=on-false
  747. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->talking clock date] continue=true
  748. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [talking clock date] destination_number(5559998585) =~ /^\*9171$/ break=on-false
  749. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->call_screen] continue=true
  750. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [call_screen] ${call_screen_enabled}(false) =~ /^true$/ break=on-false
  751. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->local_extension] continue=true
  752. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [local_extension] ${user_exists}(true) =~ /true/ break=on-false
  753. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action export(dialed_extension=${destination_number}) INLINE
  754. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 export(dialed_extension=5559998585)
  755. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.402243 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [dialed_extension]=[5559998585]
  756. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action limit(hash ${domain_name} ${destination_number} ${limit_max} ${limit_destination})
  757. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action export(rtp_secure_media=true)
  758. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (FAIL) [local_extension] ${sip_authorized}() =~ /true/ break=never
  759. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 ANTI-Action set(bind_target=peer) INLINE
  760. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(bind_target=peer)
  761. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.402243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [bind_target]=[peer]
  762. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [local_extension] () =~ // break=on-false
  763. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action bind_digit_action(local,*1,exec:execute_extension,dx XML ${context},${bind_target})
  764. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action bind_digit_action(local,*2,exec:record_session,${recordings_dir}/${domain_name}/archive/${strftime(%Y)}/${strftime(%b)}/${strftime(%d)}/${uuid}.${record_ext},${bind_target})
  765. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action bind_digit_action(local,*3,exec:execute_extension,cf XML ${context},${bind_target})
  766. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action bind_digit_action(local,*4,exec:execute_extension,att_xfer XML ${context},${bind_target})
  767. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action digit_action_set_realm(local)
  768. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [local_extension] () =~ // break=on-false
  769. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(hangup_after_bridge=true)
  770. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(continue_on_fail=true)
  771. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
  772. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
  773. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(called_party_call_group=${user_data(${dialed_extension}@${domain_name} var call_group)})
  774. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action hash(insert/${domain_name}-last_dial/${called_party_call_group}/${uuid})
  775. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(api_hangup_hook=lua app.lua hangup)
  776. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action export(domain_name=${context})
  777. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action bridge(user/${destination_number}@${domain_name})
  778. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action lua(app.lua failure_handler)
  779. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 parsing [my.somevoip.com.ne->voicemail] continue=false
  780. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Regex (PASS) [voicemail] ${user_exists}(true) =~ /true/ break=on-false
  781. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action answer()
  782. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action sleep(1000)
  783. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(voicemail_action=save)
  784. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(voicemail_id=${destination_number})
  785. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action set(voicemail_profile=default)
  786. 5f780b7d-593b-4524-a6c5-1767d3f6a047 Dialplan: sofia/external/15554321212@96.88.69.88 Action lua(app.lua voicemail)
  787. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.402243 [DEBUG] switch_core_state_machine.c:286 (sofia/external/15554321212@96.88.69.88) State Change CS_ROUTING -> CS_EXECUTE
  788. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.402243 [DEBUG] switch_core_state_machine.c:643 (sofia/external/15554321212@96.88.69.88) State ROUTING going to sleep
  789. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.402243 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_EXECUTE (Cur 1 Tot 490)
  790. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.402243 [DEBUG] switch_core_state_machine.c:650 (sofia/external/15554321212@96.88.69.88) State EXECUTE
  791. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.402243 [DEBUG] mod_sofia.c:198 sofia/external/15554321212@96.88.69.88 SOFIA EXECUTE
  792. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.402243 [DEBUG] switch_core_state_machine.c:328 sofia/external/15554321212@96.88.69.88 Standard EXECUTE
  793. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(extension_uuid=c53678f6-62e8-48df-8fba-e7ddd39de7b3)
  794. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.412243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [extension_uuid]=[c53678f6-62e8-48df-8fba-e7ddd39de7b3]
  795. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(hold_music=local_stream://default)
  796. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.412243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [hold_music]=[local_stream://default]
  797. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_all_enabled=true)
  798. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.422247 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_all_enabled]=[true]
  799. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_all_destination=+15059687272)
  800. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.422247 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_all_destination]=[+15059687272]
  801. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_busy_enabled=false)
  802. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.422247 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_busy_enabled]=[false]
  803. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_busy_destination=)
  804. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.432243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_busy_destination]=[UNDEF]
  805. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_no_answer_enabled=false)
  806. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.432243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_no_answer_enabled]=[false]
  807. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_no_answer_destination=)
  808. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.432243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_no_answer_destination]=[UNDEF]
  809. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_user_not_registered_enabled=false)
  810. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.432243 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_user_not_registered_enabled]=[false]
  811. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(forward_user_not_registered_destination=)
  812. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.442242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [forward_user_not_registered_destination]=[UNDEF]
  813. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(do_not_disturb=false)
  814. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.442242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [do_not_disturb]=[false]
  815. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(call_timeout=30)
  816. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.442242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [call_timeout]=[30]
  817. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(missed_call_app=)
  818. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.452242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [missed_call_app]=[UNDEF]
  819. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(missed_call_data=)
  820. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.452242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [missed_call_data]=[UNDEF]
  821. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 export(origination_callee_id_name=5559998585)
  822. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.452242 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[5559998585]
  823. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(RFC2822_DATE=Fri, 02 Jun 2017 20:40:24 +0000)
  824. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.452242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [RFC2822_DATE]=[Fri, 02 Jun 2017 20:40:24 +0000]
  825. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 hash(insert/my.somevoip.com.ne-last_dial/5554321212/5559998585)
  826. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 eval(not_secure)
  827. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 limit(hash my.somevoip.com.ne 5559998585 )
  828. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.452242 [DEBUG] switch_limit.c:126 incr called: my.somevoip.com.ne_5559998585 max:-1, interval:0
  829. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.452242 [DEBUG] mod_hash.c:194 Usage for my.somevoip.com.ne_5559998585 is now 1
  830. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 export(rtp_secure_media=true)
  831. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.452242 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [rtp_secure_media]=[true]
  832. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 bind_digit_action(local,*1,exec:execute_extension,dx XML my.somevoip.com.ne,peer)
  833. 2017-06-02 20:40:24.452242 [INFO] switch_ivr_async.c:214 Digit parser DPTOOLS: Setting realm to 'local'
  834. 2017-06-02 20:40:24.452242 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *1/local/0 callback: 0x6d49d7be6c20 data: 0x1f7b4f8
  835. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 bind_digit_action(local,*2,exec:record_session,/var/lib/freeswitch/recordings/my.somevoip.com.ne/archive/2017/Jun/02/5f780b7d-593b-4524-a6c5-1767d3f6a047.wav,peer)
  836. 2017-06-02 20:40:24.452242 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *2/local/0 callback: 0x6d49d7be6c20 data: 0x1f7b728
  837. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 bind_digit_action(local,*3,exec:execute_extension,cf XML my.somevoip.com.ne,peer)
  838. 2017-06-02 20:40:24.452242 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *3/local/0 callback: 0x6d49d7be6c20 data: 0x1f7b8c0
  839. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 bind_digit_action(local,*4,exec:execute_extension,att_xfer XML my.somevoip.com.ne,peer)
  840. 2017-06-02 20:40:24.452242 [DEBUG] switch_ivr_async.c:323 Digit parser DPTOOLS: binding *4/local/0 callback: 0x6d49d7be6c20 data: 0x217f1c0
  841. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 digit_action_set_realm(local)
  842. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(hangup_after_bridge=true)
  843. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.452242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [hangup_after_bridge]=[true]
  844. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(continue_on_fail=true)
  845. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.452242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [continue_on_fail]=[true]
  846. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 hash(insert/my.somevoip.com.ne-call_return/5559998585/5554321212)
  847. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 hash(insert/my.somevoip.com.ne-last_dial_ext/5559998585/5f780b7d-593b-4524-a6c5-1767d3f6a047)
  848. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(called_party_call_group=)
  849. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [called_party_call_group]=[UNDEF]
  850. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 hash(insert/my.somevoip.com.ne-last_dial//5f780b7d-593b-4524-a6c5-1767d3f6a047)
  851. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(api_hangup_hook=lua app.lua hangup)
  852. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [api_hangup_hook]=[lua app.lua hangup]
  853. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 export(domain_name=my.somevoip.com.ne)
  854. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [domain_name]=[my.somevoip.com.ne]
  855. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 bridge(user/5559998585@my.somevoip.com.ne)
  856. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [dialed_extension]=[5559998585] to event
  857. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [origination_callee_id_name]=[5559998585] to event
  858. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [rtp_secure_media]=[true] to event
  859. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [domain_name]=[my.somevoip.com.ne] to event
  860. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] switch_ivr_originate.c:2138 Parsing global variables
  861. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [dialed_extension]=[5559998585] to event
  862. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [origination_callee_id_name]=[5559998585] to event
  863. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [rtp_secure_media]=[true] to event
  864. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] switch_channel.c:1250 sofia/external/15554321212@96.88.69.88 EXPORTING[export_vars] [domain_name]=[my.somevoip.com.ne] to event
  865. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:24.462242 [DEBUG] switch_ivr_originate.c:2138 Parsing global variables
  866. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [NOTICE] switch_channel.c:1104 New Channel sofia/external/5059687272 [8d261e38-5336-4cb2-86ae-cc3adda922bc]
  867. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] mod_sofia.c:4808 (sofia/external/5059687272) State Change CS_NEW -> CS_INIT
  868. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_state_machine.c:584 (sofia/external/5059687272) Running State Change CS_INIT (Cur 2 Tot 491)
  869. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_state_machine.c:627 (sofia/external/5059687272) State INIT
  870. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] mod_sofia.c:90 sofia/external/5059687272 SOFIA INIT
  871. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [1 AEAD_AES_256_GCM_8 inline:cnrJju17yxlZYgnZugO8UAGCaa0cXx5baerfKD49DjHwPpAP2tugcgUYbeE]
  872. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [1 AEAD_AES_256_GCM_8 inline:AGUZbaHu0LK8Kpyh0nXps+NnQAd5kvOd9NfdCV2uDSJmZTzWCpt6poijZE8]
  873. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [2 AEAD_AES_128_GCM_8 inline:K/YZfxVPgqaxZw/JJJ1fbRLnv5TeQcrZEUWbLQ]
  874. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [2 AEAD_AES_128_GCM_8 inline:PT8Kl1K6yycktX1WPCiTKcvgn572SXxOPAvqkw]
  875. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [3 AES_CM_256_HMAC_SHA1_80 inline:uURCYfja5h7cJo7Bw6R7/gYstjbrwvJ4un2EPlfYV+ehdso5HUB98KnwkCtxIw]
  876. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [3 AES_CM_256_HMAC_SHA1_80 inline:y5SNcyJoeD2prWR7qbCADdi3IMu5G7GfEz6Ykab2WM4Gf3cv4odMeh2mu7Q7Wg]
  877. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [4 AES_CM_192_HMAC_SHA1_80 inline:phIAW/y9o/c0SNkfk74heIeKiGprL3jdcKHT72ueqie/ZGZTzqQ]
  878. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [4 AES_CM_192_HMAC_SHA1_80 inline:mm4T16quTAHPBujHiBmWFXWHAG0G8Q96P3H8u3hAJ0rQYPdzeZg]
  879. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [5 AES_CM_128_HMAC_SHA1_80 inline:6ouYLUv2xi0oSSREjk6CB0evuc7Xngr44AS52Pia]
  880. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [5 AES_CM_128_HMAC_SHA1_80 inline:yGLmDE4PYHAAE9zTm08uyQyDCL0kygSR7+mhOnK/]
  881. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [6 AES_CM_256_HMAC_SHA1_32 inline:EdDAaFCuIRRT1Fv6ePy6wpzjsNnmtOr0CgnnkUwVne0kBnhnURNgpWn4HuV9AA]
  882. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [6 AES_CM_256_HMAC_SHA1_32 inline:dV1huVnyNb4y0vdqrwvnseusnOQ6lUjgQCIMhjxC865u5JeE8IMlIVrfLt0HWw]
  883. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [7 AES_CM_192_HMAC_SHA1_32 inline:Dg/fmqQadogq4IcyZq2qQhyceE4cSZ2oSBhHWgTf3MF6JWw5+E8]
  884. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [7 AES_CM_192_HMAC_SHA1_32 inline:S8xXAKkPjoQB0B6XdnBWnpv+DtIMrHnaRS0dq8ES+EKglQB8jng]
  885. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [8 AES_CM_128_HMAC_SHA1_32 inline:U4OfN4hFzMcuENkGI0mnprstFBoFc7qyxwFwW4rN]
  886. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [8 AES_CM_128_HMAC_SHA1_32 inline:DNfUuQi/875h4WmfUE9IwOTIJe3HiUSZIRW8ZgFw]
  887. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local audio crypto Key [9 AES_CM_128_NULL_AUTH inline:JZ3OHTMG6nPCZh1iGFSuagXZQjwFKRwneA0xBgKZ]
  888. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_media.c:1117 Set Local video crypto Key [9 AES_CM_128_NULL_AUTH inline:56Ij9UYK+nPghSFjgTpyhVec6ZBFtJS+HMezgkrH]
  889. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] sofia_glue.c:1283 sofia/external/5059687272 sending invite version: 1.6.14 -23-e460bf8 64bit
  890. 8d261e38-5336-4cb2-86ae-cc3adda922bc Local SDP:
  891. 8d261e38-5336-4cb2-86ae-cc3adda922bc v=0
  892. 8d261e38-5336-4cb2-86ae-cc3adda922bc o=FreeSWITCH 1496415216 1496415217 IN IP4 111.111.111.111
  893. 8d261e38-5336-4cb2-86ae-cc3adda922bc s=FreeSWITCH
  894. 8d261e38-5336-4cb2-86ae-cc3adda922bc c=IN IP4 111.111.111.111
  895. 8d261e38-5336-4cb2-86ae-cc3adda922bc t=0 0
  896. 8d261e38-5336-4cb2-86ae-cc3adda922bc m=audio 20808 RTP/SAVP 0 8 3 101 13
  897. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=rtpmap:0 PCMU/8000
  898. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=rtpmap:8 PCMA/8000
  899. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=rtpmap:3 GSM/8000
  900. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=rtpmap:101 telephone-event/8000
  901. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=fmtp:101 0-16
  902. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=crypto:1 AEAD_AES_256_GCM_8 inline:cnrJju17yxlZYgnZugO8UAGCaa0cXx5baerfKD49DjHwPpAP2tugcgUYbeE
  903. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=crypto:2 AEAD_AES_128_GCM_8 inline:K/YZfxVPgqaxZw/JJJ1fbRLnv5TeQcrZEUWbLQ
  904. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=crypto:3 AES_CM_256_HMAC_SHA1_80 inline:uURCYfja5h7cJo7Bw6R7/gYstjbrwvJ4un2EPlfYV+ehdso5HUB98KnwkCtxIw
  905. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=crypto:4 AES_CM_192_HMAC_SHA1_80 inline:phIAW/y9o/c0SNkfk74heIeKiGprL3jdcKHT72ueqie/ZGZTzqQ
  906. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:6ouYLUv2xi0oSSREjk6CB0evuc7Xngr44AS52Pia
  907. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=crypto:6 AES_CM_256_HMAC_SHA1_32 inline:EdDAaFCuIRRT1Fv6ePy6wpzjsNnmtOr0CgnnkUwVne0kBnhnURNgpWn4HuV9AA
  908. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=crypto:7 AES_CM_192_HMAC_SHA1_32 inline:Dg/fmqQadogq4IcyZq2qQhyceE4cSZ2oSBhHWgTf3MF6JWw5+E8
  909. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:U4OfN4hFzMcuENkGI0mnprstFBoFc7qyxwFwW4rN
  910. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=crypto:9 AES_CM_128_NULL_AUTH inline:JZ3OHTMG6nPCZh1iGFSuagXZQjwFKRwneA0xBgKZ
  911. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=rtpmap:13 CN/8000
  912. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=ptime:20
  913. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=sendrecv
  914. 8d261e38-5336-4cb2-86ae-cc3adda922bc
  915. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_state_machine.c:40 sofia/external/5059687272 Standard INIT
  916. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_state_machine.c:48 (sofia/external/5059687272) State Change CS_INIT -> CS_ROUTING
  917. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_state_machine.c:627 (sofia/external/5059687272) State INIT going to sleep
  918. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_state_machine.c:584 (sofia/external/5059687272) Running State Change CS_ROUTING (Cur 2 Tot 491)
  919. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] sofia.c:7041 Channel sofia/external/5059687272 entering state [calling][0]
  920. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_state_machine.c:643 (sofia/external/5059687272) State ROUTING
  921. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] mod_sofia.c:143 sofia/external/5059687272 SOFIA ROUTING
  922. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_ivr_originate.c:67 (sofia/external/5059687272) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  923. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_state_machine.c:643 (sofia/external/5059687272) State ROUTING going to sleep
  924. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_state_machine.c:584 (sofia/external/5059687272) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 491)
  925. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_state_machine.c:662 (sofia/external/5059687272) State CONSUME_MEDIA
  926. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:24.462242 [DEBUG] switch_core_state_machine.c:662 (sofia/external/5059687272) State CONSUME_MEDIA going to sleep
  927. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] sofia.c:7041 Channel sofia/external/5059687272 entering state [proceeding][183]
  928. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] sofia.c:7051 Remote SDP:
  929. 8d261e38-5336-4cb2-86ae-cc3adda922bc v=0
  930. 8d261e38-5336-4cb2-86ae-cc3adda922bc o=Sansay-VSXi 188 1 IN IP4 64.136.174.30
  931. 8d261e38-5336-4cb2-86ae-cc3adda922bc s=Session Controller
  932. 8d261e38-5336-4cb2-86ae-cc3adda922bc c=IN IP4 216.221.154.151
  933. 8d261e38-5336-4cb2-86ae-cc3adda922bc t=0 0
  934. 8d261e38-5336-4cb2-86ae-cc3adda922bc m=audio 46070 RTP/AVP 0 101
  935. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=rtpmap:0 PCMU/8000
  936. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=rtpmap:101 telephone-event/8000
  937. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=fmtp:101 0-15
  938. 8d261e38-5336-4cb2-86ae-cc3adda922bc a=ptime:20
  939. 8d261e38-5336-4cb2-86ae-cc3adda922bc
  940. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  941. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_media.c:4433 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  942. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  943. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_media.c:4378 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  944. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_media.c:4294 Set telephone-event payload to 101@8000
  945. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [WARNING] switch_core_media.c:4451 Crypto not negotiated but required.
  946. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_media.c:4696 sofia/external/5059687272 Set 2833 dtmf send payload to 101 recv payload to 101
  947. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [NOTICE] sofia.c:7230 Hangup sofia/external/5059687272 [CS_CONSUME_MEDIA] [INCOMPATIBLE_DESTINATION]
  948. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_state_machine.c:584 (sofia/external/5059687272) Running State Change CS_HANGUP (Cur 2 Tot 491)
  949. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_state_machine.c:850 (sofia/external/5059687272) Callstate Change DOWN -> HANGUP
  950. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_state_machine.c:852 (sofia/external/5059687272) State HANGUP
  951. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] mod_sofia.c:438 Channel sofia/external/5059687272 hanging up, cause: INCOMPATIBLE_DESTINATION
  952. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] mod_sofia.c:502 Sending CANCEL to sofia/external/5059687272
  953. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_state_machine.c:60 sofia/external/5059687272 Standard HANGUP, cause: INCOMPATIBLE_DESTINATION
  954. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_state_machine.c:852 (sofia/external/5059687272) State HANGUP going to sleep
  955. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_state_machine.c:619 (sofia/external/5059687272) State Change CS_HANGUP -> CS_REPORTING
  956. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_state_machine.c:584 (sofia/external/5059687272) Running State Change CS_REPORTING (Cur 2 Tot 491)
  957. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_state_machine.c:938 (sofia/external/5059687272) State REPORTING
  958. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_state_machine.c:174 sofia/external/5059687272 Standard REPORTING, cause: INCOMPATIBLE_DESTINATION
  959. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_state_machine.c:938 (sofia/external/5059687272) State REPORTING going to sleep
  960. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_state_machine.c:610 (sofia/external/5059687272) State Change CS_REPORTING -> CS_DESTROY
  961. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.652252 [DEBUG] switch_core_session.c:1647 Session 491 (sofia/external/5059687272) Locked, Waiting on external entities
  962. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [DEBUG] switch_ivr_originate.c:3829 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]
  963. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.672244 [NOTICE] switch_core_session.c:1665 Session 491 (sofia/external/5059687272) Ended
  964. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.672244 [NOTICE] switch_core_session.c:1669 Close Channel sofia/external/5059687272 [CS_DESTROY]
  965. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.672244 [DEBUG] switch_core_state_machine.c:741 (sofia/external/5059687272) Running State Change CS_DESTROY (Cur 1 Tot 491)
  966. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.672244 [DEBUG] switch_core_state_machine.c:751 (sofia/external/5059687272) State DESTROY
  967. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.672244 [DEBUG] mod_sofia.c:343 sofia/external/5059687272 SOFIA DESTROY
  968. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.672244 [DEBUG] switch_core_state_machine.c:181 sofia/external/5059687272 Standard DESTROY
  969. 8d261e38-5336-4cb2-86ae-cc3adda922bc 2017-06-02 20:40:26.672244 [DEBUG] switch_core_state_machine.c:751 (sofia/external/5059687272) State DESTROY going to sleep
  970. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [NOTICE] switch_ivr_originate.c:2841 Cannot create outgoing channel of type [user] cause: [INCOMPATIBLE_DESTINATION]
  971. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [DEBUG] switch_ivr_originate.c:3829 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION]
  972. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [INFO] mod_dptools.c:3409 Originate Failed. Cause: INCOMPATIBLE_DESTINATION
  973. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 lua(app.lua failure_handler)
  974. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [DEBUG] switch_cpp.cpp:1113 sofia/external/15554321212@96.88.69.88 destroy/unlink session from object
  975. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 answer()
  976. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [DEBUG] switch_core_media.c:6703 AUDIO RTP [sofia/external/15554321212@96.88.69.88] 111.111.111.111 port 18402 -> 207.112.37.25 port 36436 codec: 0 ms: 20
  977. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [DEBUG] switch_rtp.c:3878 Starting timer [soft] 160 bytes per 20ms
  978. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [DEBUG] switch_core_media.c:7009 sofia/external/15554321212@96.88.69.88 Set 2833 dtmf send payload to 101
  979. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [DEBUG] switch_core_media.c:7016 sofia/external/15554321212@96.88.69.88 Set 2833 dtmf receive payload to 101
  980. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [DEBUG] switch_core_media.c:7039 sofia/external/15554321212@96.88.69.88 Set rtp dtmf delay to 40
  981. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [DEBUG] mod_sofia.c:849 Local SDP sofia/external/15554321212@96.88.69.88:
  982. 5f780b7d-593b-4524-a6c5-1767d3f6a047 v=0
  983. 5f780b7d-593b-4524-a6c5-1767d3f6a047 o=FreeSWITCH 1496417624 1496417625 IN IP4 111.111.111.111
  984. 5f780b7d-593b-4524-a6c5-1767d3f6a047 s=FreeSWITCH
  985. 5f780b7d-593b-4524-a6c5-1767d3f6a047 c=IN IP4 111.111.111.111
  986. 5f780b7d-593b-4524-a6c5-1767d3f6a047 t=0 0
  987. 5f780b7d-593b-4524-a6c5-1767d3f6a047 m=audio 18402 RTP/AVP 0 101
  988. 5f780b7d-593b-4524-a6c5-1767d3f6a047 a=rtpmap:0 PCMU/8000
  989. 5f780b7d-593b-4524-a6c5-1767d3f6a047 a=rtpmap:101 telephone-event/8000
  990. 5f780b7d-593b-4524-a6c5-1767d3f6a047 a=fmtp:101 0-16
  991. 5f780b7d-593b-4524-a6c5-1767d3f6a047 a=ptime:20
  992. 5f780b7d-593b-4524-a6c5-1767d3f6a047 a=sendrecv
  993. 5f780b7d-593b-4524-a6c5-1767d3f6a047
  994. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [NOTICE] mod_dptools.c:1309 Channel [sofia/external/15554321212@96.88.69.88] has been answered
  995. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [DEBUG] switch_channel.c:3772 (sofia/external/15554321212@96.88.69.88) Callstate Change RINGING -> ACTIVE
  996. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.672244 [DEBUG] sofia.c:7041 Channel sofia/external/15554321212@96.88.69.88 entering state [completed][200]
  997. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 sleep(1000)
  998. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.712243 [DEBUG] sofia.c:7041 Channel sofia/external/15554321212@96.88.69.88 entering state [ready][200]
  999. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:26.832255 [DEBUG] switch_rtp.c:6994 Correct audio ip/port confirmed.
  1000. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(voicemail_action=save)
  1001. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:27.672261 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [voicemail_action]=[save]
  1002. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(voicemail_id=5559998585)
  1003. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:27.672261 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [voicemail_id]=[5559998585]
  1004. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 set(voicemail_profile=default)
  1005. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:27.672261 [DEBUG] mod_dptools.c:1527 SET sofia/external/15554321212@96.88.69.88 [voicemail_profile]=[default]
  1006. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 lua(app.lua voicemail)
  1007. 2017-06-02 20:40:27.672261 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x205f830 Connected.
  1008. 2017-06-02 20:40:27.682244 [NOTICE] switch_cpp.cpp:1366 [voicemail] voicemail_dir: /var/lib/freeswitch/storage/voicemail/default/my.somevoip.com.ne
  1009. 2017-06-02 20:40:27.682244 [NOTICE] switch_cpp.cpp:1366 [settings] SQL: SELECT * FROM v_default_settings WHERE default_setting_enabled = 'true' AND default_setting_category is not null AND default_setting_subcategory is not null AND default_setting_name is not null AND default_setting_value is not null ORDER BY default_setting_category, default_setting_subcategory ASC
  1010. 2017-06-02 20:40:27.682244 [NOTICE] switch_cpp.cpp:1366 [settings] SQL: SELECT * FROM v_domain_settings WHERE domain_uuid = :domain_uuid AND domain_setting_enabled = 'true' AND domain_setting_category is not null AND domain_setting_subcategory is not null AND domain_setting_name is not null AND domain_setting_value is not null ORDER BY domain_setting_category, domain_setting_subcategory ASC ; params: {"domain_uuid":"53dfbf50-263f-4208-9540-c2abd247b89b"}
  1011. 2017-06-02 20:40:27.682244 [NOTICE] switch_cpp.cpp:1366 [voicemail] SQL: SELECT * FROM v_voicemails
  1012. WHERE domain_uuid = :domain_uuid
  1013. AND voicemail_id = :voicemail_id
  1014. AND voicemail_enabled = 'true' ; params:{"domain_uuid":"53dfbf50-263f-4208-9540-c2abd247b89b","voicemail_id":"5559998585"}
  1015. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 unbind_meta_app()
  1016. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:27.682244 [INFO] switch_ivr_async.c:4065 UnBound A-Leg: ALL
  1017. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:27.682244 [DEBUG] switch_cpp.cpp:746 CoreSession::setVariable(playback_terminators, #)
  1018. 5f780b7d-593b-4524-a6c5-1767d3f6a047 EXECUTE sofia/external/15554321212@96.88.69.88 playback(silence_stream://200)
  1019. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:27.692244 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
  1020. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:27.872252 [DEBUG] switch_ivr_play_say.c:1942 done playing file silence_stream://200
  1021. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:27.872252 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
  1022. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:29.232261 [DEBUG] switch_ivr_play_say.c:1942 done playing file /usr/share/freeswitch/sounds/en/us/callie/voicemail/vm-person.wav
  1023. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:29.232261 [DEBUG] switch_ivr.c:3565 No language specified - Using [en]
  1024. 2017-06-02 20:40:29.232261 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x217b6d0 Connected.
  1025. 2017-06-02 20:40:29.232261 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x217b6d0 released.
  1026. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:29.242244 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
  1027. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:29.972261 [NOTICE] sofia.c:1012 Hangup sofia/external/15554321212@96.88.69.88 [CS_EXECUTE] [NORMAL_CLEARING]
  1028. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:29.972261 [DEBUG] mod_hash.c:297 Usage for my.somevoip.com.ne_5559998585 is now 0
  1029. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:29.972261 [DEBUG] switch_ivr_play_say.c:1942 done playing file file_string://digits/5.wav!digits/0.wav!digits/6.wav!digits/3.wav!digits/0.wav!digits/0.wav!digits/7.wav!digits/1.wav!digits/7.wav!digits/0.wav
  1030. 2017-06-02 20:40:29.972261 [NOTICE] switch_cpp.cpp:1366 [voicemail] transcribe_enabled: true
  1031. 2017-06-02 20:40:29.982840 [NOTICE] switch_cpp.cpp:1366 [voicemail] transcribe_provider: microsoft
  1032. 2017-06-02 20:40:29.982840 [NOTICE] switch_cpp.cpp:1366 [voicemail] transcribe_language: en-US
  1033. 2017-06-02 20:40:30.362252 [NOTICE] switch_cpp.cpp:1366 [voicemail] CMD: curl -X POST "https://api.cognitive.microsoft.com/sts/v1.0/issueToken" -H "Content-type: application/x-www-form-urlencoded" -H "Content-Length: 0" -H "Ocp-Apim-Subscription-Key: 4fdabe8e06f748fbab42c5f471241061"
  1034. 2017-06-02 20:40:30.362252 [NOTICE] switch_cpp.cpp:1366 [voicemail] RESULT: eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzY29wZSI6Imh0dHBzOi8vc3BlZWNoLnBsYXRmb3JtLmJpbmcuY29tIiwic3Vic2NyaXB0aW9uLWlkIjoiOWQ5NTM1OGM4Nzg4NDBjZGJlZjQzNDhiNTIyMzNmNjYiLCJwcm9kdWN0LWlkIjoiQmluZy5TcGVlY2guUHJldmlldyIsImNvZ25pdGl2ZS1zZXJ2aWNlcy1lbmRwb2ludCI6Imh0dHBzOi8vYXBpLmNvZ25pdGl2ZS5taWNyb3NvZnQuY29tL2ludGVybmFsL3YxLjAvIiwiYXp1cmUtcmVzb3VyY2UtaWQiOiIiLCJpc3MiOiJ1cm46bXMuY29nbml0aXZlc2VydmljZXMiLCJhdWQiOiJ1cm46bXMuc3BlZWNoIiwiZXhwIjoxNDk2NDM2MzkwfQ.hhfWeHuXyvd2i5w0ycILPDqjTAvuLQ9xLellI9N7b-0
  1035. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [ERR] mod_lua.cpp:203 ...eswitch/scripts/resources/functions/lunajson/decoder.lua:28: parse error at 2: invalid value
  1036. 5f780b7d-593b-4524-a6c5-1767d3f6a047 stack traceback:
  1037. 5f780b7d-593b-4524-a6c5-1767d3f6a047 [C]: in function error
  1038. 5f780b7d-593b-4524-a6c5-1767d3f6a047 ...eswitch/scripts/resources/functions/lunajson/decoder.lua:28: in function decodeerror
  1039. 5f780b7d-593b-4524-a6c5-1767d3f6a047 ...eswitch/scripts/resources/functions/lunajson/decoder.lua:35: in function f
  1040. 5f780b7d-593b-4524-a6c5-1767d3f6a047 ...eswitch/scripts/resources/functions/lunajson/decoder.lua:348: in function decode
  1041. 5f780b7d-593b-4524-a6c5-1767d3f6a047 ...pts/app/voicemail/resources/functions/record_message.lua:68: in function transcribe
  1042. 5f780b7d-593b-4524-a6c5-1767d3f6a047 ...pts/app/voicemail/resources/functions/record_message.lua:252: in function record_message
  1043. 5f780b7d-593b-4524-a6c5-1767d3f6a047 /usr/share/freeswitch/scripts/app/voicemail/index.lua:354: in main chunk
  1044. 5f780b7d-593b-4524-a6c5-1767d3f6a047 /usr/share/freeswitch/scripts/app.lua:48: in main chunk
  1045. 2017-06-02 20:40:30.432251 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x205f830 released.
  1046. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_cpp.cpp:1113 sofia/external/15554321212@96.88.69.88 destroy/unlink session from object
  1047. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_core_session.c:2797 sofia/external/15554321212@96.88.69.88 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1048. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_core_state_machine.c:650 (sofia/external/15554321212@96.88.69.88) State EXECUTE going to sleep
  1049. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_HANGUP (Cur 1 Tot 491)
  1050. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_core_state_machine.c:850 (sofia/external/15554321212@96.88.69.88) Callstate Change ACTIVE -> HANGUP
  1051. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_core_state_machine.c:852 (sofia/external/15554321212@96.88.69.88) State HANGUP
  1052. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] mod_sofia.c:438 Channel sofia/external/15554321212@96.88.69.88 hanging up, cause: NORMAL_CLEARING
  1053. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_core_state_machine.c:60 sofia/external/15554321212@96.88.69.88 Standard HANGUP, cause: NORMAL_CLEARING
  1054. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_core_state_machine.c:852 (sofia/external/15554321212@96.88.69.88) State HANGUP going to sleep
  1055. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_core_state_machine.c:783 Hangup Command with no Session lua(app.lua hangup):
  1056. 5f780b7d-593b-4524-a6c5-1767d3f6a047
  1057. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_core_state_machine.c:619 (sofia/external/15554321212@96.88.69.88) State Change CS_HANGUP -> CS_REPORTING
  1058. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_core_state_machine.c:584 (sofia/external/15554321212@96.88.69.88) Running State Change CS_REPORTING (Cur 1 Tot 491)
  1059. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.432251 [DEBUG] switch_core_state_machine.c:938 (sofia/external/15554321212@96.88.69.88) State REPORTING
  1060. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.532252 [DEBUG] switch_core_state_machine.c:174 sofia/external/15554321212@96.88.69.88 Standard REPORTING, cause: NORMAL_CLEARING
  1061. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.532252 [DEBUG] switch_core_state_machine.c:938 (sofia/external/15554321212@96.88.69.88) State REPORTING going to sleep
  1062. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.532252 [DEBUG] switch_core_state_machine.c:610 (sofia/external/15554321212@96.88.69.88) State Change CS_REPORTING -> CS_DESTROY
  1063. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.532252 [DEBUG] switch_core_session.c:1647 Session 490 (sofia/external/15554321212@96.88.69.88) Locked, Waiting on external entities
  1064. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.532252 [NOTICE] switch_core_session.c:1665 Session 490 (sofia/external/15554321212@96.88.69.88) Ended
  1065. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.532252 [NOTICE] switch_core_session.c:1669 Close Channel sofia/external/15554321212@96.88.69.88 [CS_DESTROY]
  1066. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.532252 [DEBUG] switch_core_state_machine.c:741 (sofia/external/15554321212@96.88.69.88) Running State Change CS_DESTROY (Cur 0 Tot 491)
  1067. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.532252 [DEBUG] switch_core_state_machine.c:751 (sofia/external/15554321212@96.88.69.88) State DESTROY
  1068. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.532252 [DEBUG] mod_sofia.c:343 sofia/external/15554321212@96.88.69.88 SOFIA DESTROY
  1069. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.532252 [DEBUG] switch_core_state_machine.c:181 sofia/external/15554321212@96.88.69.88 Standard DESTROY
  1070. 5f780b7d-593b-4524-a6c5-1767d3f6a047 2017-06-02 20:40:30.532252 [DEBUG] switch_core_state_machine.c:751 (sofia/external/15554321212@96.88.69.88) State DESTROY going to sleep