From Bistre Cassowary, 4 Years ago, written in FreeSWITCH.
This paste is a reply to Untitled from Chunky Kangaroo
- view diff
Embed
  1. span style="color: cornflowerblue; font-weight: bold;"> 2017-09-05 22:37:45.528111 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/keniab@new-bbcorp.voiphoenix.com [5d4c1b18-92ac-11e7-b45a-318961d573b8]
  2. 2017-09-05 22:37:45.528111 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Running State Change CS_NEW (Cur 1 Tot 81)
  3. 2017-09-05 22:37:45.528111 [DEBUG] sofia.c:9873 sofia/internal/keniab@new-bbcorp.voiphoenix.com receiving invite from 107.128.125.120:35382 version: 1.6.19  64bit
  4. 2017-09-05 22:37:45.528111 [DEBUG] sofia.c:10044 IP 107.128.125.120 Rejected by acl "domains". Falling back to Digest auth.
  5. 2017-09-05 22:37:45.528111 [WARNING] sofia_reg.c:1792 SIP auth challenge (INVITE) on sofia profile 'internal' for [17862812455@new-bbcorp.voiphoenix.com] from ip 107.128.125.120
  6. 2017-09-05 22:37:45.528111 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State NEW
  7. 2017-09-05 22:37:45.528111 [DEBUG] sofia.c:2334 detaching session 5d4c1b18-92ac-11e7-b45a-318961d573b8
  8. 2017-09-05 22:37:46.128188 [DEBUG] sofia.c:2442 Re-attaching to session 5d4c1b18-92ac-11e7-b45a-318961d573b8
  9. 2017-09-05 22:37:46.128188 [DEBUG] sofia.c:9873 sofia/internal/keniab@new-bbcorp.voiphoenix.com receiving invite from 107.128.125.120:35382 version: 1.6.19  64bit
  10. 2017-09-05 22:37:46.128188 [DEBUG] sofia.c:10044 IP 107.128.125.120 Rejected by acl "domains". Falling back to Digest auth.
  11. 2017-09-05 22:37:46.168057 [DEBUG] sofia.c:11168 Setting NAT mode based on via received
  12. 2017-09-05 22:37:46.168057 [DEBUG] sofia.c:7084 Channel sofia/internal/keniab@new-bbcorp.voiphoenix.com entering state [received][100]
  13. 2017-09-05 22:37:46.168057 [DEBUG] sofia.c:7094 Remote SDP:
  14. v=0
  15. o=Z 0 0 IN IP4 107.128.125.120
  16. s=Z
  17. c=IN IP4 107.128.125.120
  18. t=0 0
  19. m=audio 8000 RTP/AVP 0 101
  20. a=rtpmap:101 telephone-event/8000
  21. a=fmtp:101 0-15
  22.  
  23. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G7221:115:32000:20:48000:1]
  24. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G7221:107:16000:20:32000:1]
  25. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
  26. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  27. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  28. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  29. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
  30. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
  31. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/keniab@new-bbcorp.voiphoenix.com PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  32. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_codec.c:111 sofia/internal/keniab@new-bbcorp.voiphoenix.com Original read codec set to PCMU:0
  33. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
  34. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_media.c:4767 sofia/internal/keniab@new-bbcorp.voiphoenix.com Set 2833 dtmf send payload to 101 recv payload to 101
  35. 2017-09-05 22:37:46.168057 [DEBUG] sofia.c:7507 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State Change CS_NEW -> CS_INIT
  36. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Running State Change CS_INIT (Cur 1 Tot 81)
  37. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State INIT
  38. 2017-09-05 22:37:46.168057 [DEBUG] mod_sofia.c:90 sofia/internal/keniab@new-bbcorp.voiphoenix.com SOFIA INIT
  39. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_state_machine.c:40 sofia/internal/keniab@new-bbcorp.voiphoenix.com Standard INIT
  40. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State Change CS_INIT -> CS_ROUTING
  41. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State INIT going to sleep
  42. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Running State Change CS_ROUTING (Cur 1 Tot 81)
  43. 2017-09-05 22:37:46.168057 [DEBUG] switch_channel.c:2249 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Callstate Change DOWN -> RINGING
  44. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State ROUTING
  45. 2017-09-05 22:37:46.168057 [DEBUG] mod_sofia.c:143 sofia/internal/keniab@new-bbcorp.voiphoenix.com SOFIA ROUTING
  46. 2017-09-05 22:37:46.168057 [DEBUG] switch_core_state_machine.c:236 sofia/internal/keniab@new-bbcorp.voiphoenix.com Standard ROUTING
  47. 2017-09-05 22:37:46.168057 [INFO] mod_dialplan_xml.c:637 Processing keniab <keniab>->17862812455 in context new-bbcorp.voiphoenix.com
  48. 2017-09-05 22:37:46.168057 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f548c0075f0 Connected.
  49. 2017-09-05 22:37:46.188011 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f548c0075f0 released.
  50. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com parsing [new-bbcorp.voiphoenix.com->user_exists] continue=true
  51. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (PASS) [user_exists] () =~ // break=on-false
  52. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
  53. 2017-09-05 22:37:46.188011 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f548c0075f0 Connected.
  54. 2017-09-05 22:37:46.188011 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f548c0075f0 released.
  55. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(user_exists=false)
  56. 2017-09-05 22:37:46.188011 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [user_exists]=[false]
  57. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
  58. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com parsing [new-bbcorp.voiphoenix.com->call-direction] continue=true
  59. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never
  60. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com ANTI-Action set(call_direction=local)
  61. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com parsing [new-bbcorp.voiphoenix.com->variables] continue=true
  62. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (PASS) [variables] () =~ // break=on-false
  63. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action export(origination_callee_id_name=${destination_number})
  64. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  65. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com parsing [new-bbcorp.voiphoenix.com->user_record] continue=true
  66. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (PASS) [user_record] () =~ // break=on-false
  67. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
  68. 2017-09-05 22:37:46.188011 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f548c0075f0 Connected.
  69. 2017-09-05 22:37:46.188011 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f548c0075f0 released.
  70. 2017-09-05 22:37:46.208014 [DEBUG] freeswitch_lua.cpp:365 DBH handle 0x7f548c0075f0 Connected.
  71. 2017-09-05 22:37:46.208014 [DEBUG] freeswitch_lua.cpp:382 DBH handle 0x7f548c0075f0 released.
  72. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(user_record=)
  73. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [user_record]=[UNDEF]
  74. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
  75. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(from_user_exists=true)
  76. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [from_user_exists]=[true]
  77. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  78. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
  79. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  80. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
  81. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
  82. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  83. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
  84. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
  85. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  86. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
  87. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
  88. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  89. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(from_user_record=${user_data ${sip_from_user}@${sip_from_host} var user_record}) INLINE
  90. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(from_user_record=)
  91. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [from_user_record]=[UNDEF]
  92. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  93. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
  94. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  95. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${call_direction}() =~ /^inbound$/ break=never
  96. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
  97. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  98. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${call_direction}() =~ /^outbound$/ break=never
  99. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
  100. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  101. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${call_direction}() =~ /^local$/ break=never
  102. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
  103. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
  104. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com parsing [new-bbcorp.voiphoenix.com->redial] continue=true
  105. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [redial] destination_number(17862812455) =~ /^(redial|\*870)$/ break=on-true
  106. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (PASS) [redial] () =~ // break=never
  107. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
  108. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com parsing [new-bbcorp.voiphoenix.com->speed_dial] continue=false
  109. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (FAIL) [speed_dial] destination_number(17862812455) =~ /^\*0(.*)$/ break=on-false
  110. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com parsing [new-bbcorp.voiphoenix.com->VOIPHOENIX-OUT.11d] continue=false
  111. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Regex (PASS) [VOIPHOENIX-OUT.11d] destination_number(17862812455) =~ /^\+?(\d{11})$/ break=on-false
  112. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(sip_h_X-accountcode=${accountcode})
  113. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(call_direction=outbound)
  114. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action unset(call_timeout)
  115. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(hangup_after_bridge=true)
  116. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(effective_caller_id_name=${outbound_caller_id_name})
  117. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(effective_caller_id_number=${outbound_caller_id_number})
  118. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(inherit_codec=true)
  119. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(ignore_display_updates=true)
  120. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(callee_id_number=17862812455)
  121. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action set(continue_on_fail=true)
  122. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action limit(hash ${domain_name} outbound 1 !USER_BUSY)
  123. Dialplan: sofia/internal/keniab@new-bbcorp.voiphoenix.com Action bridge(sofia/gateway/8e667b81-e64a-4172-adb8-bf8254ae34bc/33221117862812455)
  124. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State Change CS_ROUTING -> CS_EXECUTE
  125. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State ROUTING going to sleep
  126. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Running State Change CS_EXECUTE (Cur 1 Tot 81)
  127. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State EXECUTE
  128. 2017-09-05 22:37:46.208014 [DEBUG] mod_sofia.c:198 sofia/internal/keniab@new-bbcorp.voiphoenix.com SOFIA EXECUTE
  129. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:328 sofia/internal/keniab@new-bbcorp.voiphoenix.com Standard EXECUTE
  130. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(call_direction=local)
  131. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [call_direction]=[local]
  132. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com export(origination_callee_id_name=17862812455)
  133. 2017-09-05 22:37:46.208014 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [origination_callee_id_name]=[17862812455]
  134. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(RFC2822_DATE=Tue, 05 Sep 2017 22:37:46 -0400)
  135. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [RFC2822_DATE]=[Tue, 05 Sep 2017 22:37:46 -0400]
  136. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com hash(insert/new-bbcorp.voiphoenix.com-last_dial/100/17862812455)
  137. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(sip_h_X-accountcode=new-bbcorp.voiphoenix.com)
  138. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [sip_h_X-accountcode]=[new-bbcorp.voiphoenix.com]
  139. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(call_direction=outbound)
  140. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [call_direction]=[outbound]
  141. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com unset(call_timeout)
  142. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1693 UNSET [call_timeout]
  143. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(hangup_after_bridge=true)
  144. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [hangup_after_bridge]=[true]
  145. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(effective_caller_id_name=Kenia Bello)
  146. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [effective_caller_id_name]=[Kenia Bello]
  147. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(effective_caller_id_number=3052519606)
  148. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [effective_caller_id_number]=[3052519606]
  149. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(inherit_codec=true)
  150. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [inherit_codec]=[true]
  151. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(ignore_display_updates=true)
  152. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [ignore_display_updates]=[true]
  153. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(callee_id_number=17862812455)
  154. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [callee_id_number]=[17862812455]
  155. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com set(continue_on_fail=true)
  156. 2017-09-05 22:37:46.208014 [DEBUG] mod_dptools.c:1548 SET sofia/internal/keniab@new-bbcorp.voiphoenix.com [continue_on_fail]=[true]
  157. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com limit(hash new-bbcorp.voiphoenix.com outbound 1 !USER_BUSY)
  158. 2017-09-05 22:37:46.208014 [DEBUG] switch_limit.c:126 incr called: new-bbcorp.voiphoenix.com_outbound max:1, interval:0
  159. 2017-09-05 22:37:46.208014 [DEBUG] mod_hash.c:196 Usage for new-bbcorp.voiphoenix.com_outbound is now 1/1
  160. EXECUTE sofia/internal/keniab@new-bbcorp.voiphoenix.com bridge(sofia/gateway/8e667b81-e64a-4172-adb8-bf8254ae34bc/33221117862812455)
  161. 2017-09-05 22:37:46.208014 [DEBUG] switch_channel.c:1250 sofia/internal/keniab@new-bbcorp.voiphoenix.com EXPORTING[export_vars] [domain_name]=[new-bbcorp.voiphoenix.com] to event
  162. 2017-09-05 22:37:46.208014 [DEBUG] switch_channel.c:1250 sofia/internal/keniab@new-bbcorp.voiphoenix.com EXPORTING[export_vars] [origination_callee_id_name]=[17862812455] to event
  163. 2017-09-05 22:37:46.208014 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  164. 2017-09-05 22:37:46.208014 [NOTICE] switch_channel.c:1104 New Channel sofia/external/33221117862812455 [5db4d798-92ac-11e7-b474-318961d573b8]
  165. 2017-09-05 22:37:46.208014 [DEBUG] mod_sofia.c:4819 (sofia/external/33221117862812455) State Change CS_NEW -> CS_INIT
  166. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:584 (sofia/external/33221117862812455) Running State Change CS_INIT (Cur 2 Tot 82)
  167. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:627 (sofia/external/33221117862812455) State INIT
  168. 2017-09-05 22:37:46.208014 [DEBUG] mod_sofia.c:90 sofia/external/33221117862812455 SOFIA INIT
  169. 2017-09-05 22:37:46.208014 [DEBUG] sofia_glue.c:1295 sofia/external/33221117862812455 sending invite version: 1.6.19  64bit
  170. Local SDP:
  171. v=0
  172. o=Z 0 0 IN IP4 107.128.125.120
  173. s=Z
  174. c=IN IP4 107.128.125.120
  175. t=0 0
  176. m=audio 8000 RTP/AVP 0 101
  177. a=rtpmap:101 telephone-event/8000
  178. a=fmtp:101 0-15
  179.  
  180. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:40 sofia/external/33221117862812455 Standard INIT
  181. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:48 (sofia/external/33221117862812455) State Change CS_INIT -> CS_ROUTING
  182. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:627 (sofia/external/33221117862812455) State INIT going to sleep
  183. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:584 (sofia/external/33221117862812455) Running State Change CS_ROUTING (Cur 2 Tot 82)
  184. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:643 (sofia/external/33221117862812455) State ROUTING
  185. 2017-09-05 22:37:46.208014 [DEBUG] mod_sofia.c:143 sofia/external/33221117862812455 SOFIA ROUTING
  186. 2017-09-05 22:37:46.208014 [DEBUG] switch_ivr_originate.c:67 (sofia/external/33221117862812455) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  187. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:643 (sofia/external/33221117862812455) State ROUTING going to sleep
  188. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:584 (sofia/external/33221117862812455) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 82)
  189. 2017-09-05 22:37:46.208014 [DEBUG] sofia.c:7084 Channel sofia/external/33221117862812455 entering state [calling][0]
  190. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:662 (sofia/external/33221117862812455) State CONSUME_MEDIA
  191. 2017-09-05 22:37:46.208014 [DEBUG] switch_core_state_machine.c:662 (sofia/external/33221117862812455) State CONSUME_MEDIA going to sleep
  192. 2017-09-05 22:37:46.788063 [DEBUG] sofia.c:7084 Channel sofia/external/33221117862812455 entering state [proceeding][183]
  193. 2017-09-05 22:37:46.788063 [DEBUG] sofia.c:7094 Remote SDP:
  194. v=0
  195. o=root 2115724431 2115724431 IN IP4 199.59.98.42
  196. s=Asterisk PBX 10.7.0
  197. c=IN IP4 199.59.98.42
  198. t=0 0
  199. m=audio 16772 RTP/AVP 0 101
  200. a=rtpmap:0 PCMU/8000
  201. a=rtpmap:101 telephone-event/8000
  202. a=fmtp:101 0-16
  203. a=silenceSupp:off - - - -
  204. a=ptime:20
  205.  
  206. 2017-09-05 22:37:46.788063 [NOTICE] sofia.c:7240 Pre-Answer sofia/external/33221117862812455!
  207. 2017-09-05 22:37:46.788063 [DEBUG] switch_channel.c:3474 (sofia/external/33221117862812455) Callstate Change DOWN -> EARLY
  208. 2017-09-05 22:37:46.808057 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/external/33221117862812455]
  209. 2017-09-05 22:37:46.808057 [INFO] switch_ivr.c:784 Sending early media
  210. 2017-09-05 22:37:46.808057 [NOTICE] mod_sofia.c:2367 Pre-Answer sofia/internal/keniab@new-bbcorp.voiphoenix.com!
  211. 2017-09-05 22:37:46.808057 [DEBUG] switch_channel.c:3474 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Callstate Change RINGING -> EARLY
  212. 2017-09-05 22:37:46.808057 [DEBUG] switch_ivr_bridge.c:1416 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State Change CS_EXECUTE -> CS_HIBERNATE
  213. 2017-09-05 22:37:46.808057 [DEBUG] switch_ivr_bridge.c:1417 (sofia/external/33221117862812455) State Change CS_CONSUME_MEDIA -> CS_HIBERNATE
  214. 2017-09-05 22:37:46.808057 [DEBUG] switch_core_state_machine.c:584 (sofia/external/33221117862812455) Running State Change CS_HIBERNATE (Cur 2 Tot 82)
  215. 2017-09-05 22:37:46.808057 [DEBUG] sofia.c:7084 Channel sofia/internal/keniab@new-bbcorp.voiphoenix.com entering state [early][183]
  216. 2017-09-05 22:37:46.808057 [DEBUG] switch_core_state_machine.c:665 (sofia/external/33221117862812455) State HIBERNATE
  217. 2017-09-05 22:37:46.808057 [DEBUG] mod_sofia.c:180 sofia/external/33221117862812455 SOFIA HIBERNATE
  218. 2017-09-05 22:37:46.808057 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State EXECUTE going to sleep
  219. 2017-09-05 22:37:46.808057 [DEBUG] switch_core_state_machine.c:420 sofia/external/33221117862812455 Standard HIBERNATE
  220. 2017-09-05 22:37:46.808057 [DEBUG] switch_core_state_machine.c:665 (sofia/external/33221117862812455) State HIBERNATE going to sleep
  221. 2017-09-05 22:37:46.808057 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Running State Change CS_HIBERNATE (Cur 2 Tot 82)
  222. 2017-09-05 22:37:46.808057 [DEBUG] switch_core_state_machine.c:665 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State HIBERNATE
  223. 2017-09-05 22:37:46.808057 [DEBUG] mod_sofia.c:180 sofia/internal/keniab@new-bbcorp.voiphoenix.com SOFIA HIBERNATE
  224. 2017-09-05 22:37:46.808057 [DEBUG] switch_core_state_machine.c:420 sofia/internal/keniab@new-bbcorp.voiphoenix.com Standard HIBERNATE
  225. 2017-09-05 22:37:46.808057 [DEBUG] switch_core_state_machine.c:665 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State HIBERNATE going to sleep
  226. 2017-09-05 22:37:59.128182 [DEBUG] sofia.c:7084 Channel sofia/external/33221117862812455 entering state [proceeding][180]
  227. 2017-09-05 22:37:59.128182 [NOTICE] sofia.c:7192 Ring-Ready sofia/external/33221117862812455!
  228. 2017-09-05 22:37:59.128182 [DEBUG] switch_channel.c:3346 (sofia/external/33221117862812455) Callstate Change EARLY -> RINGING
  229. 2017-09-05 22:38:06.808045 [DEBUG] sofia.c:7084 Channel sofia/external/33221117862812455 entering state [completing][200]
  230. 2017-09-05 22:38:06.808045 [DEBUG] sofia.c:7094 Remote SDP:
  231. v=0
  232. o=root 2115724431 2115724432 IN IP4 199.59.98.42
  233. s=Asterisk PBX 10.7.0
  234. c=IN IP4 199.59.98.42
  235. t=0 0
  236. m=audio 16772 RTP/AVP 0 101
  237. a=rtpmap:0 PCMU/8000
  238. a=rtpmap:101 telephone-event/8000
  239. a=fmtp:101 0-16
  240. a=silenceSupp:off - - - -
  241. a=ptime:20
  242.  
  243. 2017-09-05 22:38:06.808045 [DEBUG] sofia.c:7084 Channel sofia/external/33221117862812455 entering state [ready][200]
  244. 2017-09-05 22:38:06.808045 [NOTICE] sofia.c:8159 Channel [sofia/external/33221117862812455] has been answered
  245. 2017-09-05 22:38:06.808045 [DEBUG] switch_channel.c:3773 (sofia/external/33221117862812455) Callstate Change RINGING -> ACTIVE
  246. 2017-09-05 22:38:06.808045 [NOTICE] switch_ivr.c:779 Channel [sofia/internal/keniab@new-bbcorp.voiphoenix.com] has been answered
  247. 2017-09-05 22:38:06.808045 [DEBUG] switch_channel.c:3773 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Callstate Change EARLY -> ACTIVE
  248. 2017-09-05 22:38:06.808045 [DEBUG] sofia.c:7084 Channel sofia/internal/keniab@new-bbcorp.voiphoenix.com entering state [completed][200]
  249. 2017-09-05 22:38:06.948032 [DEBUG] sofia.c:7084 Channel sofia/internal/keniab@new-bbcorp.voiphoenix.com entering state [ready][200]
  250. 2017-09-05 22:38:14.648094 [NOTICE] sofia.c:1012 Hangup sofia/external/33221117862812455 [CS_HIBERNATE] [NORMAL_CLEARING]
  251. 2017-09-05 22:38:14.648094 [DEBUG] switch_ivr_bridge.c:1163 sofia/external/33221117862812455 skip receive message [UNBRIDGE] (channel is hungup already)
  252. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:584 (sofia/external/33221117862812455) Running State Change CS_HANGUP (Cur 2 Tot 82)
  253. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:850 (sofia/external/33221117862812455) Callstate Change ACTIVE -> HANGUP
  254. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:852 (sofia/external/33221117862812455) State HANGUP
  255. 2017-09-05 22:38:14.648094 [DEBUG] mod_sofia.c:438 Channel sofia/external/33221117862812455 hanging up, cause: NORMAL_CLEARING
  256. 2017-09-05 22:38:14.648094 [NOTICE] switch_ivr_bridge.c:1294 Hangup sofia/internal/keniab@new-bbcorp.voiphoenix.com [CS_HIBERNATE] [NORMAL_CLEARING]
  257. 2017-09-05 22:38:14.648094 [DEBUG] mod_hash.c:297 Usage for new-bbcorp.voiphoenix.com_outbound is now 0
  258. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Running State Change CS_HANGUP (Cur 2 Tot 82)
  259. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:60 sofia/external/33221117862812455 Standard HANGUP, cause: NORMAL_CLEARING
  260. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:852 (sofia/external/33221117862812455) State HANGUP going to sleep
  261. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:619 (sofia/external/33221117862812455) State Change CS_HANGUP -> CS_REPORTING
  262. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:584 (sofia/external/33221117862812455) Running State Change CS_REPORTING (Cur 2 Tot 82)
  263. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:938 (sofia/external/33221117862812455) State REPORTING
  264. 2017-09-05 22:38:14.648094 [DEBUG] switch_ivr_bridge.c:1163 sofia/internal/keniab@new-bbcorp.voiphoenix.com skip receive message [UNBRIDGE] (channel is hungup already)
  265. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:174 sofia/external/33221117862812455 Standard REPORTING, cause: NORMAL_CLEARING
  266. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:938 (sofia/external/33221117862812455) State REPORTING going to sleep
  267. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Callstate Change ACTIVE -> HANGUP
  268. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State HANGUP
  269. 2017-09-05 22:38:14.648094 [DEBUG] mod_sofia.c:432 sofia/internal/keniab@new-bbcorp.voiphoenix.com Overriding SIP cause 480 with 200 from the other leg
  270. 2017-09-05 22:38:14.648094 [DEBUG] mod_sofia.c:438 Channel sofia/internal/keniab@new-bbcorp.voiphoenix.com hanging up, cause: NORMAL_CLEARING
  271. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:610 (sofia/external/33221117862812455) State Change CS_REPORTING -> CS_DESTROY
  272. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_session.c:1665 Session 82 (sofia/external/33221117862812455) Locked, Waiting on external entities
  273. 2017-09-05 22:38:14.648094 [NOTICE] switch_core_session.c:1683 Session 82 (sofia/external/33221117862812455) Ended
  274. 2017-09-05 22:38:14.648094 [NOTICE] switch_core_session.c:1687 Close Channel sofia/external/33221117862812455 [CS_DESTROY]
  275. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:741 (sofia/external/33221117862812455) Running State Change CS_DESTROY (Cur 1 Tot 82)
  276. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:751 (sofia/external/33221117862812455) State DESTROY
  277. 2017-09-05 22:38:14.648094 [DEBUG] mod_sofia.c:343 sofia/external/33221117862812455 SOFIA DESTROY
  278. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:181 sofia/external/33221117862812455 Standard DESTROY
  279. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:751 (sofia/external/33221117862812455) State DESTROY going to sleep
  280. 2017-09-05 22:38:14.648094 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/internal/keniab@new-bbcorp.voiphoenix.com
  281. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:60 sofia/internal/keniab@new-bbcorp.voiphoenix.com Standard HANGUP, cause: NORMAL_CLEARING
  282. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State HANGUP going to sleep
  283. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State Change CS_HANGUP -> CS_REPORTING
  284. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Running State Change CS_REPORTING (Cur 1 Tot 82)
  285. 2017-09-05 22:38:14.648094 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State REPORTING
  286. 2017-09-05 22:38:14.668165 [DEBUG] switch_core_state_machine.c:174 sofia/internal/keniab@new-bbcorp.voiphoenix.com Standard REPORTING, cause: NORMAL_CLEARING
  287. 2017-09-05 22:38:14.668165 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State REPORTING going to sleep
  288. 2017-09-05 22:38:14.668165 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State Change CS_REPORTING -> CS_DESTROY
  289. 2017-09-05 22:38:14.668165 [DEBUG] switch_core_session.c:1665 Session 81 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Locked, Waiting on external entities
  290. 2017-09-05 22:38:14.668165 [NOTICE] switch_core_session.c:1683 Session 81 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Ended
  291. 2017-09-05 22:38:14.668165 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/keniab@new-bbcorp.voiphoenix.com [CS_DESTROY]
  292. 2017-09-05 22:38:14.668165 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) Running State Change CS_DESTROY (Cur 0 Tot 82)
  293. 2017-09-05 22:38:14.668165 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State DESTROY
  294. 2017-09-05 22:38:14.668165 [DEBUG] mod_sofia.c:343 sofia/internal/keniab@new-bbcorp.voiphoenix.com SOFIA DESTROY
  295. 2017-09-05 22:38:14.668165 [DEBUG] switch_core_state_machine.c:181 sofia/internal/keniab@new-bbcorp.voiphoenix.com Standard DESTROY
  296. 2017-09-05 22:38:14.668165 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/keniab@new-bbcorp.voiphoenix.com) State DESTROY going to sleep
  297. freeswitch@pbx.voiphoenix.com>
  298.