From Mark, 3 Years ago, written in Plain Text.
- view diff
Embed
  1. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1]
  2. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_media.c:5647 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match
  3. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_media.c:5592 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  4. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_media.c:5508 Set telephone-event payload to 101@8000
  5. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_media.c:3837 Set Codec sofia/internal/587@vpbx-stpeters.bitco.co.za G729/8000 20 ms 160 samples 8000 bits 1 channels
  6. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_codec.c:111 sofia/internal/587@vpbx-stpeters.bitco.co.za Original read codec set to G729:18
  7. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_media.c:5851 Set telephone-event payload to 101@8000
  8. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_media.c:5909 sofia/internal/587@vpbx-stpeters.bitco.co.za Set 2833 dtmf send payload to 101 recv payload to 101
  9. 2020-12-15 11:19:04.267495 [DEBUG] sofia.c:7759 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State Change CS_NEW -> CS_INIT
  10. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/587@vpbx-stpeters.bitco.co.za) Running State Change CS_INIT (Cur 1 Tot 173)
  11. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_state_machine.c:628 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State INIT
  12. 2020-12-15 11:19:04.267495 [DEBUG] mod_sofia.c:93 sofia/internal/587@vpbx-stpeters.bitco.co.za SOFIA INIT
  13. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_state_machine.c:40 sofia/internal/587@vpbx-stpeters.bitco.co.za Standard INIT
  14. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State Change CS_INIT -> CS_ROUTING
  15. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_state_machine.c:628 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State INIT going to sleep
  16. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/587@vpbx-stpeters.bitco.co.za) Running State Change CS_ROUTING (Cur 1 Tot 173)
  17. 2020-12-15 11:19:04.267495 [DEBUG] switch_channel.c:2332 (sofia/internal/587@vpbx-stpeters.bitco.co.za) Callstate Change DOWN -> RINGING
  18. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_state_machine.c:644 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State ROUTING
  19. 2020-12-15 11:19:04.267495 [DEBUG] mod_sofia.c:154 sofia/internal/587@vpbx-stpeters.bitco.co.za SOFIA ROUTING
  20. 2020-12-15 11:19:04.267495 [DEBUG] switch_core_state_machine.c:236 sofia/internal/587@vpbx-stpeters.bitco.co.za Standard ROUTING
  21. 2020-12-15 11:19:04.267495 [INFO] mod_dialplan_xml.c:637 Processing 587 <587>->*08 in context vpbx-stpeters.bitco.co.za
  22. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za parsing [vpbx-stpeters.bitco.co.za->user_exists] continue=true
  23. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_exists] ${loopback_leg}() =~ /^B$/ break=never
  24. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [user_exists] () =~ // break=on-false
  25. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
  26. EXECUTE [depth=0] sofia/internal/587@vpbx-stpeters.bitco.co.za set(user_exists=false)
  27. 2020-12-15 11:19:04.287593 [DEBUG] mod_dptools.c:1672 SET sofia/internal/587@vpbx-stpeters.bitco.co.za [user_exists]=[false]
  28. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
  29. EXECUTE [depth=0] sofia/internal/587@vpbx-stpeters.bitco.co.za set(from_user_exists=true)
  30. 2020-12-15 11:19:04.287593 [DEBUG] mod_dptools.c:1672 SET sofia/internal/587@vpbx-stpeters.bitco.co.za [from_user_exists]=[true]
  31. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_exists] ${user_exists}(false) =~ /^true$/ break=on-false
  32. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za parsing [vpbx-stpeters.bitco.co.za->caller-details] continue=true
  33. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [caller-details] ${caller_destination}() =~ /^$/ break=never
  34. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Action set(caller_destination=${destination_number}) INLINE
  35. EXECUTE [depth=0] sofia/internal/587@vpbx-stpeters.bitco.co.za set(caller_destination=*08)
  36. 2020-12-15 11:19:04.287593 [DEBUG] mod_dptools.c:1672 SET sofia/internal/587@vpbx-stpeters.bitco.co.za [caller_destination]=[*08]
  37. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Action set(caller_id_name=${caller_id_name}) INLINE
  38. EXECUTE [depth=0] sofia/internal/587@vpbx-stpeters.bitco.co.za set(caller_id_name=587)
  39. 2020-12-15 11:19:04.287593 [DEBUG] mod_dptools.c:1672 SET sofia/internal/587@vpbx-stpeters.bitco.co.za [caller_id_name]=[587]
  40. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Action set(caller_id_number=${caller_id_number})
  41. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za parsing [vpbx-stpeters.bitco.co.za->call-direction] continue=true
  42. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never
  43. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za ANTI-Action export(call_direction=local) INLINE
  44. EXECUTE [depth=0] sofia/internal/587@vpbx-stpeters.bitco.co.za export(call_direction=local)
  45. 2020-12-15 11:19:04.287593 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[local]
  46. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za parsing [vpbx-stpeters.bitco.co.za->global-variables] continue=true
  47. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [global-variables] () =~ // break=on-false
  48. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  49. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za parsing [vpbx-stpeters.bitco.co.za->domain-variables] continue=true
  50. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [domain-variables] () =~ // break=on-false
  51. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Action export(origination_callee_id_name=${destination_number})
  52. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za parsing [vpbx-stpeters.bitco.co.za->is_loopback] continue=true
  53. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [is_loopback] ${is_follow_me_loopback}() =~ /true/ break=on-false
  54. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za parsing [vpbx-stpeters.bitco.co.za->user_record] continue=true
  55. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  56. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
  57. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  58. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
  59. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
  60. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  61. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
  62. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
  63. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${user_exists}(false) =~ /^true$/ break=never
  64. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
  65. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
  66. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  67. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Action set(from_user_record=${user_data ${sip_from_user}@${sip_from_host} var user_record}) INLINE
  68. EXECUTE [depth=0] sofia/internal/587@vpbx-stpeters.bitco.co.za set(from_user_record=)
  69. 2020-12-15 11:19:04.287593 [DEBUG] mod_dptools.c:1672 SET sofia/internal/587@vpbx-stpeters.bitco.co.za [from_user_record]=[UNDEF]
  70. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  71. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
  72. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  73. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
  74. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
  75. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  76. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
  77. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
  78. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [user_record] ${from_user_exists}(true) =~ /^true$/ break=never
  79. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
  80. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
  81. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
  82. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za parsing [vpbx-stpeters.bitco.co.za->redial] continue=true
  83. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (FAIL) [redial] destination_number(*08) =~ /^(redial|\*870)$/ break=on-true
  84. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [redial] () =~ // break=never
  85. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
  86. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za parsing [vpbx-stpeters.bitco.co.za->speed_dial] continue=false
  87. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Regex (PASS) [speed_dial] destination_number(*08) =~ /^\*0(.*)$/ break=on-false
  88. Dialplan: sofia/internal/587@vpbx-stpeters.bitco.co.za Action lua(app.lua speed_dial 8)
  89. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:287 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State Change CS_ROUTING -> CS_EXECUTE
  90. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:644 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State ROUTING going to sleep
  91. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/587@vpbx-stpeters.bitco.co.za) Running State Change CS_EXECUTE (Cur 1 Tot 173)
  92. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State EXECUTE
  93. 2020-12-15 11:19:04.287593 [DEBUG] mod_sofia.c:209 sofia/internal/587@vpbx-stpeters.bitco.co.za SOFIA EXECUTE
  94. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:329 sofia/internal/587@vpbx-stpeters.bitco.co.za Standard EXECUTE
  95. EXECUTE [depth=0] sofia/internal/587@vpbx-stpeters.bitco.co.za set(caller_id_number=587)
  96. 2020-12-15 11:19:04.287593 [DEBUG] mod_dptools.c:1672 SET sofia/internal/587@vpbx-stpeters.bitco.co.za [caller_id_number]=[587]
  97. EXECUTE [depth=0] sofia/internal/587@vpbx-stpeters.bitco.co.za set(RFC2822_DATE=Tue, 15 Dec 2020 11:19:04 +0200)
  98. 2020-12-15 11:19:04.287593 [DEBUG] mod_dptools.c:1672 SET sofia/internal/587@vpbx-stpeters.bitco.co.za [RFC2822_DATE]=[Tue, 15 Dec 2020 11:19:04 +0200]
  99. EXECUTE [depth=0] sofia/internal/587@vpbx-stpeters.bitco.co.za export(origination_callee_id_name=*08)
  100. 2020-12-15 11:19:04.287593 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [origination_callee_id_name]=[*08]
  101. EXECUTE [depth=0] sofia/internal/587@vpbx-stpeters.bitco.co.za hash(insert/vpbx-stpeters.bitco.co.za-last_dial/587/*08)
  102. EXECUTE [depth=0] sofia/internal/587@vpbx-stpeters.bitco.co.za lua(app.lua speed_dial 8)
  103. 2020-12-15 11:19:04.287593 [WARNING] switch_cpp.cpp:1447 [app:dialplan:outbound:speed_dial] can not find number: 8 in domain: vpbx-stpeters.bitco.co.za
  104. 2020-12-15 11:19:04.287593 [DEBUG] switch_cpp.cpp:1191 sofia/internal/587@vpbx-stpeters.bitco.co.za destroy/unlink session from object
  105. 2020-12-15 11:19:04.287593 [NOTICE] switch_core_state_machine.c:386 sofia/internal/587@vpbx-stpeters.bitco.co.za has executed the last dialplan instruction, hanging up.
  106. 2020-12-15 11:19:04.287593 [NOTICE] switch_core_state_machine.c:388 Hangup sofia/internal/587@vpbx-stpeters.bitco.co.za [CS_EXECUTE] [NORMAL_CLEARING]
  107. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:651 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State EXECUTE going to sleep
  108. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/587@vpbx-stpeters.bitco.co.za) Running State Change CS_HANGUP (Cur 1 Tot 173)
  109. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:848 (sofia/internal/587@vpbx-stpeters.bitco.co.za) Callstate Change RINGING -> HANGUP
  110. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State HANGUP
  111. 2020-12-15 11:19:04.287593 [DEBUG] mod_sofia.c:453 Channel sofia/internal/587@vpbx-stpeters.bitco.co.za hanging up, cause: NORMAL_CLEARING
  112. 2020-12-15 11:19:04.287593 [DEBUG] mod_sofia.c:598 Responding to INVITE with: 480
  113. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:60 sofia/internal/587@vpbx-stpeters.bitco.co.za Standard HANGUP, cause: NORMAL_CLEARING
  114. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State HANGUP going to sleep
  115. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:620 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State Change CS_HANGUP -> CS_REPORTING
  116. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/587@vpbx-stpeters.bitco.co.za) Running State Change CS_REPORTING (Cur 1 Tot 173)
  117. 2020-12-15 11:19:04.287593 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State REPORTING
  118. 2020-12-15 11:19:04.327480 [DEBUG] switch_core_state_machine.c:174 sofia/internal/587@vpbx-stpeters.bitco.co.za Standard REPORTING, cause: NORMAL_CLEARING
  119. 2020-12-15 11:19:04.327480 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State REPORTING going to sleep
  120. 2020-12-15 11:19:04.327480 [DEBUG] switch_core_state_machine.c:611 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State Change CS_REPORTING -> CS_DESTROY
  121. 2020-12-15 11:19:04.327480 [DEBUG] switch_core_session.c:1726 Session 173 (sofia/internal/587@vpbx-stpeters.bitco.co.za) Locked, Waiting on external entities
  122. 2020-12-15 11:19:04.327480 [NOTICE] switch_core_session.c:1744 Session 173 (sofia/internal/587@vpbx-stpeters.bitco.co.za) Ended
  123. 2020-12-15 11:19:04.327480 [NOTICE] switch_core_session.c:1748 Close Channel sofia/internal/587@vpbx-stpeters.bitco.co.za [CS_DESTROY]
  124. 2020-12-15 11:19:04.327480 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/587@vpbx-stpeters.bitco.co.za) Running State Change CS_DESTROY (Cur 0 Tot 173)
  125. 2020-12-15 11:19:04.327480 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State DESTROY
  126. 2020-12-15 11:19:04.327480 [DEBUG] mod_sofia.c:364 sofia/internal/587@vpbx-stpeters.bitco.co.za SOFIA DESTROY
  127. 2020-12-15 11:19:04.327480 [DEBUG] switch_core_state_machine.c:181 sofia/internal/587@vpbx-stpeters.bitco.co.za Standard DESTROY
  128. 2020-12-15 11:19:04.327480 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/587@vpbx-stpeters.bitco.co.za) State DESTROY going to sleep
  129. 2020-12-15 11:19:06.567492 [WARNING] sofia_reg.c:1794 SIP auth challenge (INVITE) on sofia profile 'internal' for [287@vpbx-stpeters.bitco.co.za] from ip 10.4.4.230
  130. 2020-12-15 11:19:06.567492 [WARNING] sofia_reg.c:1794 SIP auth challenge (INVITE) on sofia profile 'internal' for [283@vpbx-stpeters.bitco.co.za] from ip 10.4.4.230
  131. 2020-12-15 11:19:06.567492 [WARNING] sofia_reg.c:1794 SIP auth challenge (INVITE) on sofia profile 'internal' for [282@vpbx-stpeters.bitco.co.za] from ip 10.4.4.230
  132.