From shashi kumar, 6 Years ago, written in FreeSWITCH.
- view diff
Embed
  1. span style="color: cornflowerblue; font-weight: bold;"> ff4e24f6 2018-07-20 12:55:03.212221 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/9000@10.10.0.190:5060 [ff4e24f6-3887-45b8-8fea-df129c4d554a]
  2. ff4e24f6 2018-07-20 12:55:03.212221 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/9000@10.10.0.190:5060) Running State Change CS_NEW (Cur 1 Tot 1)
  3. ff4e24f6 2018-07-20 12:55:03.212221 [DEBUG] sofia.c:9873 sofia/internal/9000@10.10.0.190:5060 receiving invite from 10.10.0.30:5060 version: 1.6.20 -37-987c9b9 64bit
  4. 2018-07-20 12:55:03.212221 [DEBUG] sofia.c:10044 IP 10.10.0.30 Rejected by acl "domains". Falling back to Digest auth.
  5. ff4e24f6 2018-07-20 12:55:03.212221 [DEBUG] switch_core_state_machine.c:603 (sofia/internal/9000@10.10.0.190:5060) State NEW
  6. 2018-07-20 12:55:03.212221 [DEBUG] sofia.c:2334 detaching session ff4e24f6-3887-45b8-8fea-df129c4d554a
  7. 2018-07-20 12:55:03.212221 [DEBUG] sofia.c:2442 Re-attaching to session ff4e24f6-3887-45b8-8fea-df129c4d554a
  8. ff4e24f6 2018-07-20 12:55:03.232217 [DEBUG] sofia.c:9873 sofia/internal/9000@10.10.0.190:5060 receiving invite from 10.10.0.30:5060 version: 1.6.20 -37-987c9b9 64bit
  9. 2018-07-20 12:55:03.232217 [DEBUG] sofia.c:10044 IP 10.10.0.30 Rejected by acl "domains". Falling back to Digest auth.
  10. 2018-07-20 12:55:03.532224 [DEBUG] switch_xml.c:2068 caching lookup for user 9000@10.10.0.190 for 30000 milliseconds
  11. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] sofia.c:7084 Channel sofia/internal/9000@10.10.0.190:5060 entering state [received][100]
  12. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] sofia.c:7094 Remote SDP:
  13. v=0
  14. o=- 20088 20088 IN IP4 10.10.0.30
  15. s=SDP data
  16. c=IN IP4 10.10.0.30
  17. t=0 0
  18. m=audio 12442 RTP/AVP 9 0 8 18 101
  19. a=rtpmap:9 G722/8000
  20. a=rtpmap:0 PCMU/8000
  21. a=rtpmap:8 PCMA/8000
  22. a=rtpmap:18 G729/8000
  23. a=fmtp:18 annexb=no
  24. a=rtpmap:101 telephone-event/8000
  25. a=fmtp:101 0-15
  26. a=ptime:20
  27.  
  28. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] sofia.c:7486 (sofia/internal/9000@10.10.0.190:5060) State Change CS_NEW -> CS_INIT
  29. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/9000@10.10.0.190:5060) Running State Change CS_INIT (Cur 1 Tot 1)
  30. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/9000@10.10.0.190:5060) State INIT
  31. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] mod_sofia.c:90 sofia/internal/9000@10.10.0.190:5060 SOFIA INIT
  32. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] switch_core_state_machine.c:40 sofia/internal/9000@10.10.0.190:5060 Standard INIT
  33. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/9000@10.10.0.190:5060) State Change CS_INIT -> CS_ROUTING
  34. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/9000@10.10.0.190:5060) State INIT going to sleep
  35. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/9000@10.10.0.190:5060) Running State Change CS_ROUTING (Cur 1 Tot 1)
  36. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] switch_channel.c:2249 (sofia/internal/9000@10.10.0.190:5060) Callstate Change DOWN -> RINGING
  37. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/9000@10.10.0.190:5060) State ROUTING
  38. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] mod_sofia.c:143 sofia/internal/9000@10.10.0.190:5060 SOFIA ROUTING
  39. ff4e24f6 2018-07-20 12:55:03.532224 [DEBUG] switch_core_state_machine.c:236 sofia/internal/9000@10.10.0.190:5060 Standard ROUTING
  40. ff4e24f6 2018-07-20 12:55:03.532224 [INFO] mod_dialplan_xml.c:637 Processing 9000 <9000>->6060 in context default
  41. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->notification-Bell_Ring] continue=false
  42. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [notification-Bell_Ring] destination_number(6060) =~ /^9010$/ break=on-false
  43. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->notification-Earthquake] continue=false
  44. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [notification-Earthquake] destination_number(6060) =~ /^9011$/ break=on-false
  45. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->notification-Fire] continue=false
  46. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [notification-Fire] destination_number(6060) =~ /^9012$/ break=on-false
  47. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->notification-Lightning] continue=false
  48. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [notification-Lightning] destination_number(6060) =~ /^9014$/ break=on-false
  49. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->notification-National_Anthem] continue=false
  50. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [notification-National_Anthem] destination_number(6060) =~ /^9015$/ break=on-false
  51. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->notification-Tornado] continue=false
  52. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [notification-Tornado] destination_number(6060) =~ /^9016$/ break=on-false
  53. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->notification-Lockout] continue=false
  54. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [notification-Lockout] destination_number(6060) =~ /^9017$/ break=on-false
  55. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->notification-Lockdown] continue=false
  56. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [notification-Lockdown] destination_number(6060) =~ /^9018$/ break=on-false
  57. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->notification-Custom_Announcement] continue=false
  58. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [notification-Custom_Announcement] destination_number(6060) =~ /^9999$/ break=on-false
  59. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->unloop] continue=false
  60. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  61. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  62. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->global-intercept] continue=false
  63. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [global-intercept] destination_number(6060) =~ /^886$/ break=on-false
  64. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->school_sipcall_intercom] continue=false
  65. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [school_sipcall_intercom] destination_number(6060) =~ /^(9000)$/ break=on-false
  66. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->school_sipcall_emergency] continue=false
  67. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [school_sipcall_emergency] destination_number(6060) =~ /^(9050)$/ break=on-false
  68. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->group-intercept] continue=false
  69. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group-intercept] destination_number(6060) =~ /^\*8$/ break=on-false
  70. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->intercept-ext] continue=false
  71. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [intercept-ext] destination_number(6060) =~ /^\*\*(\d+)$/ break=on-false
  72. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->redial] continue=false
  73. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [redial] destination_number(6060) =~ /^(redial|870)$/ break=on-false
  74. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->global] continue=true
  75. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
  76. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Absolute Condition [global]
  77. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid})
  78. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
  79. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action hash(insert/${domain_name}-last_dial/global/${uuid})
  80. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
  81. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->eavesdrop] continue=false
  82. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [eavesdrop] destination_number(6060) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
  83. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->eavesdrop] continue=false
  84. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [eavesdrop] destination_number(6060) =~ /^779$/ break=on-false
  85. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->call_return] continue=false
  86. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [call_return] destination_number(6060) =~ /^\*69$|^869$|^lcr$/ break=on-false
  87. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->extension-intercom] continue=false
  88. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [extension-intercom] destination_number(6060) =~ /^8([1-3]\d{3})$/ break=on-false
  89. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->main_ivr] continue=false
  90. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [main_ivr] destination_number(6060) =~ /^6000$/ break=on-false
  91. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 parsing [default->group_dial_paging_zones] continue=false
  92. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (PASS) [group_dial_paging_zones] destination_number(6060) =~ /^6060$/ break=never
  93. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action set(group_id_name=All Call) INLINE
  94. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 set(group_id_name=All Call)
  95. ff4e24f6 2018-07-20 12:55:04.572234 [DEBUG] mod_dptools.c:1548 SET sofia/internal/9000@10.10.0.190:5060 [group_id_name]=[All Call]
  96. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group_dial_paging_zones] destination_number(6060) =~ /^6061$/ break=never
  97. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group_dial_paging_zones] destination_number(6060) =~ /^6062$/ break=never
  98. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group_dial_paging_zones] destination_number(6060) =~ /^6001$/ break=never
  99. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group_dial_paging_zones] destination_number(6060) =~ /^6002$/ break=never
  100. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group_dial_paging_zones] destination_number(6060) =~ /^6003$/ break=never
  101. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group_dial_paging_zones] destination_number(6060) =~ /^6004$/ break=never
  102. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group_dial_paging_zones] destination_number(6060) =~ /^6000$/ break=never
  103. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group_dial_paging_zones] destination_number(6060) =~ /^6005$/ break=never
  104. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group_dial_paging_zones] destination_number(6060) =~ /^6006$/ break=never
  105. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group_dial_paging_zones] destination_number(6060) =~ /^6200$/ break=never
  106. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (FAIL) [group_dial_paging_zones] destination_number(6060) =~ /^6012$/ break=never
  107. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Regex (PASS) [group_dial_paging_zones] destination_number(6060) =~ /^6(\d{3})$/ break=on-false
  108. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action set(conference_auto_outcall_caller_id_name=${group_id_name})
  109. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action set(conference_auto_outcall_caller_id_number=6060)
  110. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action set(conference_auto_outcall_timeout=60)
  111. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action set(conference_auto_outcall_flags=mute)
  112. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action set(conference_auto_outcall_announce=tone_stream://%(250,0,800))
  113. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action set(conference_auto_outcall_prefix={sip_auto_answer=true})
  114. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action set(sip_exclude_contact=${network_addr})
  115. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action conference_set_auto_outcall(${group_call(060)})
  116. ff4e24f6 Dialplan: sofia/internal/9000@10.10.0.190:5060 Action conference(madboss_intercom1@default+flags{endconf|deaf})
  117. ff4e24f6 2018-07-20 12:55:04.572234 [DEBUG] switch_core_state_machine.c:286 (sofia/internal/9000@10.10.0.190:5060) State Change CS_ROUTING -> CS_EXECUTE
  118. ff4e24f6 2018-07-20 12:55:04.572234 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/9000@10.10.0.190:5060) State ROUTING going to sleep
  119. ff4e24f6 2018-07-20 12:55:04.572234 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/9000@10.10.0.190:5060) Running State Change CS_EXECUTE (Cur 1 Tot 1)
  120. ff4e24f6 2018-07-20 12:55:04.572234 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/9000@10.10.0.190:5060) State EXECUTE
  121. ff4e24f6 2018-07-20 12:55:04.572234 [DEBUG] mod_sofia.c:198 sofia/internal/9000@10.10.0.190:5060 SOFIA EXECUTE
  122. ff4e24f6 2018-07-20 12:55:04.572234 [DEBUG] switch_core_state_machine.c:328 sofia/internal/9000@10.10.0.190:5060 Standard EXECUTE
  123. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 hash(insert/10.10.0.190-spymap/9000/ff4e24f6-3887-45b8-8fea-df129c4d554a)
  124. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 hash(insert/10.10.0.190-last_dial/9000/6060)
  125. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 hash(insert/10.10.0.190-last_dial/global/ff4e24f6-3887-45b8-8fea-df129c4d554a)
  126. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 export(RFC2822_DATE=Fri, 20 Jul 2018 12:55:04 -0700)
  127. ff4e24f6 2018-07-20 12:55:04.572234 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [RFC2822_DATE]=[Fri, 20 Jul 2018 12:55:04 -0700]
  128. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 set(conference_auto_outcall_caller_id_name=All Call)
  129. ff4e24f6 2018-07-20 12:55:04.572234 [DEBUG] mod_dptools.c:1548 SET sofia/internal/9000@10.10.0.190:5060 [conference_auto_outcall_caller_id_name]=[All Call]
  130. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 set(conference_auto_outcall_caller_id_number=6060)
  131. ff4e24f6 2018-07-20 12:55:04.572234 [DEBUG] mod_dptools.c:1548 SET sofia/internal/9000@10.10.0.190:5060 [conference_auto_outcall_caller_id_number]=[6060]
  132. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 set(conference_auto_outcall_timeout=60)
  133. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] mod_dptools.c:1548 SET sofia/internal/9000@10.10.0.190:5060 [conference_auto_outcall_timeout]=[60]
  134. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 set(conference_auto_outcall_flags=mute)
  135. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] mod_dptools.c:1548 SET sofia/internal/9000@10.10.0.190:5060 [conference_auto_outcall_flags]=[mute]
  136. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 set(conference_auto_outcall_announce=tone_stream://%(250,0,800))
  137. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] mod_dptools.c:1548 SET sofia/internal/9000@10.10.0.190:5060 [conference_auto_outcall_announce]=[tone_stream://%(250,0,800)]
  138. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 set(conference_auto_outcall_prefix={sip_auto_answer=true})
  139. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] mod_dptools.c:1548 SET sofia/internal/9000@10.10.0.190:5060 [conference_auto_outcall_prefix]=[{sip_auto_answer=true}]
  140. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 set(sip_exclude_contact=10.10.0.30)
  141. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] mod_dptools.c:1548 SET sofia/internal/9000@10.10.0.190:5060 [sip_exclude_contact]=[10.10.0.30]
  142. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_session.c:2647 Application conference_set_auto_outcall Requires media! pre_answering channel sofia/internal/9000@10.10.0.190:5060
  143. ff4e24f6 2018-07-20 12:55:04.592218 [INFO] switch_core_session.c:2649 Sending early media
  144. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1]
  145. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  146. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  147. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  148. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  149. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  150. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  151. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
  152. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  153. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  154. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
  155. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1]
  156. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1]
  157. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1]
  158. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
  159. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/9000@10.10.0.190:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  160. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_codec.c:111 sofia/internal/9000@10.10.0.190:5060 Original read codec set to PCMU:0
  161. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
  162. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:4767 sofia/internal/9000@10.10.0.190:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  163. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/internal/9000@10.10.0.190:5060] 10.10.0.190 port 30644 -> 10.10.0.30 port 12442 codec: 0 ms: 20
  164. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
  165. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:7180 sofia/internal/9000@10.10.0.190:5060 Set 2833 dtmf send payload to 101
  166. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:7187 sofia/internal/9000@10.10.0.190:5060 Set 2833 dtmf receive payload to 101
  167. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:7210 sofia/internal/9000@10.10.0.190:5060 Set rtp dtmf delay to 40
  168. ff4e24f6 2018-07-20 12:55:04.592218 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/9000@10.10.0.190:5060!
  169. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_channel.c:3474 (sofia/internal/9000@10.10.0.190:5060) Callstate Change RINGING -> EARLY
  170. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/internal/9000@10.10.0.190:5060.
  171. ff4e24f6 2018-07-20 12:55:04.592218 [DEBUG] mod_sofia.c:2364 Ring SDP:
  172. v=0
  173. o=FreeSWITCH 1532085860 1532085861 IN IP4 10.10.0.190
  174. s=FreeSWITCH
  175. c=IN IP4 10.10.0.190
  176. t=0 0
  177. m=audio 30644 RTP/AVP 0 101
  178. a=rtpmap:0 PCMU/8000
  179. a=rtpmap:101 telephone-event/8000
  180. a=fmtp:101 0-16
  181. a=ptime:20
  182. a=sendrecv
  183.  
  184. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 conference_set_auto_outcall([^^:sip_invite_domain=10.10.0.190:presence_id=1000@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1101@10.10.0.190]sofia/internal/sip:1101@10.10.0.33:5060,[^^:sip_invite_domain=10.10.0.190:presence_id=1102@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1103@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1104@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1105@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1106@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1107@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1108@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1109@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1110@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1111@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1112@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1113@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1114@10.10.0.190]sofia/internal/sip:1114@10.10.0.36:5060,[^^:sip_invite_domain=10.10.0.190:presence_id=1115@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1116@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1117@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1118@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1119@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1120@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1121@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1122@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1123@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1124@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1125@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1126@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1127@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1128@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1129@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1130@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=1131@10.10.0.190]sofia/internal/sip:1131@10.10.0.35:5060,[^^:sip_invite_domain=10.10.0.190:presence_id=2201@10.10.0.190]sofia/internal/sip:2201@10.10.0.34:5060,[^^:sip_invite_domain=10.10.0.190:presence_id=2202@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=2203@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=2204@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=2205@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=2206@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=2207@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=2208@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=2209@10.10.0.190]error/user_not_registered,[^^:sip_invite_domain=10.10.0.190:presence_id=3001@10.10.0.190]sofia/internal/sip:3001@10.10.0.201,[^^:sip_invite_domain=10.10.0.190:presence_id=5001@10.10.0.190]sofia/internal/sip:5001@10.10.0.37:5060)
  185. ff4e24f6 2018-07-20 12:55:17.232227 [DEBUG] sofia.c:7084 Channel sofia/internal/9000@10.10.0.190:5060 entering state [early][183]
  186. ff4e24f6 EXECUTE sofia/internal/9000@10.10.0.190:5060 conference(madboss_intercom1@default+flags{endconf|deaf})
  187. ff4e24f6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_media.c:6861 Audio params are unchanged for sofia/internal/9000@10.10.0.190:5060.
  188. ff4e24f6 2018-07-20 12:55:17.232227 [DEBUG] mod_sofia.c:850 Local SDP sofia/internal/9000@10.10.0.190:5060:
  189. v=0
  190. o=FreeSWITCH 1532085860 1532085862 IN IP4 10.10.0.190
  191. s=FreeSWITCH
  192. c=IN IP4 10.10.0.190
  193. t=0 0
  194. m=audio 30644 RTP/AVP 0 101
  195. a=rtpmap:0 PCMU/8000
  196. a=rtpmap:101 telephone-event/8000
  197. a=fmtp:101 0-16
  198. a=ptime:20
  199. a=sendrecv
  200.  
  201. ff4e24f6 2018-07-20 12:55:17.232227 [NOTICE] mod_conference.c:1673 Channel [sofia/internal/9000@10.10.0.190:5060] has been answered
  202. ff4e24f6 2018-07-20 12:55:17.232227 [DEBUG] switch_channel.c:3773 (sofia/internal/9000@10.10.0.190:5060) Callstate Change EARLY -> ACTIVE
  203. ff4e24f6 2018-07-20 12:55:17.232227 [DEBUG] sofia.c:7084 Channel sofia/internal/9000@10.10.0.190:5060 entering state [completed][200]
  204. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:3084 using channel sound prefix: /usr/share/freeswitch/sounds/en/us/callie
  205. ff4e24f6 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:1693 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  206. ff4e24f6 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:1740 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  207. ff4e24f6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_codec.c:223 sofia/internal/9000@10.10.0.190:5060 Push codec L16:100
  208. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:220 Setup timer success interval: 20  samples: 160
  209. 2018-07-20 12:55:17.232227 [ERR] switch_core_video.c:1789 Error open png: /var/lib/freeswitch/images/default-mute.png
  210. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '0' to 'mute'
  211. 2018-07-20 12:55:17.232227 [INFO] switch_ivr_async.c:214 Digit parser mod_conference: Setting realm to 'conf'
  212. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 0/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046a20
  213. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '*' to 'deaf mute'
  214. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding */conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046a50
  215. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '9' to 'energy up'
  216. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 9/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046a80
  217. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '8' to 'energy equ'
  218. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 8/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046ab0
  219. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '7' to 'energy dn'
  220. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 7/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046ae0
  221. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '3' to 'vol talk up'
  222. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 3/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046b10
  223. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '2' to 'vol talk zero'
  224. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 2/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046b40
  225. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '1' to 'vol talk dn'
  226. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 1/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046b70
  227. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '6' to 'vol listen up'
  228. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 6/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046ba0
  229. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '5' to 'vol listen zero'
  230. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 5/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046bd0
  231. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '4' to 'vol listen dn'
  232. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 4/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046c00
  233. 2018-07-20 12:55:17.232227 [DEBUG] conference_member.c:128 sofia/internal/9000@10.10.0.190:5060 binding '#' to 'hangup'
  234. span style="color: goldenrod; font-weight: bold;"> 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding #/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbea0046c30
  235. span style="color: goldenrod; font-weight: bold;"> ff4e24f6 2018-07-20 12:55:17.232227 [DEBUG] conference_loop.c:1142 Setup timer soft success interval: 20  samples: 160 from codec PCMU
  236. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  237. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  238. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  239. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  240. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  241. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  242. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  243. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  244. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  245. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  246. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  247. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  248. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  249. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  250. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  251. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  252. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  253. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  254. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  255. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  256. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  257. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  258. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  259. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  260. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  261. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  262. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  263. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  264. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  265. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  266. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  267. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  268. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  269. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  270. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  271. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  272. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  273. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  274. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  275. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  276. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  277. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  278. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  279. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  280. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  281. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  282. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  283. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  284. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  285. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  286. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  287. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  288. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  289. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  290. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  291. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  292. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  293. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  294. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  295. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  296. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  297. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  298. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  299. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  300. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  301. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  302. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  303. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  304. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  305. 24ecc9c6 2018-07-20 12:55:17.232227 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1101@10.10.0.33:5060 [24ecc9c6-1dc9-4477-9e77-2b540b43b82b]
  306. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  307. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  308. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  309. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  310. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  311. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] mod_sofia.c:4819 (sofia/internal/1101@10.10.0.33:5060) State Change CS_NEW -> CS_INIT
  312. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  313. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  314. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  315. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  316. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  317. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  318. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  319. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  320. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  321. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  322. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  323. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  324. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  325. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  326. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  327. e5e6183d 2018-07-20 12:55:17.232227 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1114@10.10.0.36:5060 [e5e6183d-d7a9-43f7-8df0-a1ef55e97fe5]
  328. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  329. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  330. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  331. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  332. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  333. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  334. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] mod_sofia.c:4819 (sofia/internal/1114@10.10.0.36:5060) State Change CS_NEW -> CS_INIT
  335. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  336. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  337. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  338. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  339. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  340. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  341. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  342. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  343. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  344. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1101@10.10.0.33:5060) Running State Change CS_INIT (Cur 3 Tot 3)
  345. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  346. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  347. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  348. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  349. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  350. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  351. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  352. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  353. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  354. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  355. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  356. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  357. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  358. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  359. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  360. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  361. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1101@10.10.0.33:5060) State INIT
  362. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] mod_sofia.c:90 sofia/internal/1101@10.10.0.33:5060 SOFIA INIT
  363. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  364. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  365. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  366. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  367. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  368. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  369. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  370. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  371. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  372. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1114@10.10.0.36:5060) Running State Change CS_INIT (Cur 3 Tot 3)
  373. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  374. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  375. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  376. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  377. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  378. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  379. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  380. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  381. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  382. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  383. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  384. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  385. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  386. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  387. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  388. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  389. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] sofia_glue.c:1295 sofia/internal/1101@10.10.0.33:5060 sending invite version: 1.6.20 -37-987c9b9 64bit
  390. Local SDP:
  391. v=0
  392. o=FreeSWITCH 1532095023 1532095024 IN IP4 10.10.0.190
  393. s=FreeSWITCH
  394. c=IN IP4 10.10.0.190
  395. t=0 0
  396. m=audio 21494 RTP/AVP 102 0 8 103 101
  397. a=rtpmap:102 opus/48000/2
  398. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
  399. a=rtpmap:0 PCMU/8000
  400. a=rtpmap:8 PCMA/8000
  401. a=rtpmap:103 telephone-event/48000
  402. a=fmtp:103 0-16
  403. a=rtpmap:101 telephone-event/8000
  404. a=fmtp:101 0-16
  405. a=ptime:20
  406. a=sendrecv
  407.  
  408. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1114@10.10.0.36:5060) State INIT
  409. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] mod_sofia.c:90 sofia/internal/1114@10.10.0.36:5060 SOFIA INIT
  410. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1101@10.10.0.33:5060 Standard INIT
  411. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1101@10.10.0.33:5060) State Change CS_INIT -> CS_ROUTING
  412. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  413. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1101@10.10.0.33:5060) State INIT going to sleep
  414. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  415. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  416. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  417. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  418. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  419. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1101@10.10.0.33:5060) Running State Change CS_ROUTING (Cur 3 Tot 3)
  420. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1101@10.10.0.33:5060) State ROUTING
  421. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] mod_sofia.c:143 sofia/internal/1101@10.10.0.33:5060 SOFIA ROUTING
  422. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/1101@10.10.0.33:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  423. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1101@10.10.0.33:5060) State ROUTING going to sleep
  424. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  425. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  426. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  427. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  428. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  429. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  430. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1101@10.10.0.33:5060) Running State Change CS_CONSUME_MEDIA (Cur 3 Tot 3)
  431. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  432. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  433. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  434. 0cf8ec7a 2018-07-20 12:55:17.232227 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/1131@10.10.0.35:5060 [0cf8ec7a-fece-4ebe-976e-8184b9768df9]
  435. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  436. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  437. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  438. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  439. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  440. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] sofia_glue.c:1295 sofia/internal/1114@10.10.0.36:5060 sending invite version: 1.6.20 -37-987c9b9 64bit
  441. Local SDP:
  442. v=0
  443. o=FreeSWITCH 1532089039 1532089040 IN IP4 10.10.0.190
  444. s=FreeSWITCH
  445. c=IN IP4 10.10.0.190
  446. t=0 0
  447. m=audio 27478 RTP/AVP 102 0 8 103 101
  448. a=rtpmap:102 opus/48000/2
  449. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
  450. a=rtpmap:0 PCMU/8000
  451. a=rtpmap:8 PCMA/8000
  452. a=rtpmap:103 telephone-event/48000
  453. a=fmtp:103 0-16
  454. a=rtpmap:101 telephone-event/8000
  455. a=fmtp:101 0-16
  456. a=ptime:20
  457. a=sendrecv
  458.  
  459. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  460. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  461. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1114@10.10.0.36:5060 Standard INIT
  462. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1114@10.10.0.36:5060) State Change CS_INIT -> CS_ROUTING
  463. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1114@10.10.0.36:5060) State INIT going to sleep
  464. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  465. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  466. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  467. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1114@10.10.0.36:5060) Running State Change CS_ROUTING (Cur 4 Tot 4)
  468. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  469. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  470. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  471. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  472. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  473. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  474. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  475. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  476. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  477. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  478. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  479. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  480. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  481. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  482. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  483. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  484. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  485. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  486. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  487. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  488. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  489. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  490. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  491. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  492. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] sofia.c:7084 Channel sofia/internal/1101@10.10.0.33:5060 entering state [calling][0]
  493. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1101@10.10.0.33:5060) State CONSUME_MEDIA
  494. 0cf8ec7a 2018-07-20 12:55:17.232227 [DEBUG] mod_sofia.c:4819 (sofia/internal/1131@10.10.0.35:5060) State Change CS_NEW -> CS_INIT
  495. 24ecc9c6 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1101@10.10.0.33:5060) State CONSUME_MEDIA going to sleep
  496. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] sofia.c:7084 Channel sofia/internal/1114@10.10.0.36:5060 entering state [calling][0]
  497. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1114@10.10.0.36:5060) State ROUTING
  498. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] mod_sofia.c:143 sofia/internal/1114@10.10.0.36:5060 SOFIA ROUTING
  499. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/1114@10.10.0.36:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  500. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  501. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1114@10.10.0.36:5060) State ROUTING going to sleep
  502. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  503. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  504. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  505. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1114@10.10.0.36:5060) Running State Change CS_CONSUME_MEDIA (Cur 4 Tot 4)
  506. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  507. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1114@10.10.0.36:5060) State CONSUME_MEDIA
  508. e5e6183d 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1114@10.10.0.36:5060) State CONSUME_MEDIA going to sleep
  509. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  510. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  511. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  512. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  513. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  514. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  515. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  516. 0cf8ec7a 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1131@10.10.0.35:5060) Running State Change CS_INIT (Cur 4 Tot 4)
  517. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  518. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  519. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  520. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  521. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  522. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  523. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  524. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  525. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  526. 0cf8ec7a 2018-07-20 12:55:17.232227 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1131@10.10.0.35:5060) State INIT
  527. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  528. 0cf8ec7a 2018-07-20 12:55:17.232227 [DEBUG] mod_sofia.c:90 sofia/internal/1131@10.10.0.35:5060 SOFIA INIT
  529. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  530. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  531. 2018-07-20 12:55:17.232227 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  532. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  533. f5d2f201 2018-07-20 12:55:17.232227 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/3001@10.10.0.201 [f5d2f201-bc99-4f77-97f7-47ab7be0a282]
  534. f5d2f201 2018-07-20 12:55:17.232227 [DEBUG] mod_sofia.c:4819 (sofia/internal/3001@10.10.0.201) State Change CS_NEW -> CS_INIT
  535. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  536. 2018-07-20 12:55:17.232227 [DEBUG] mod_conference.c:1603 Launching BG Thread for outcall
  537. 0cf8ec7a 2018-07-20 12:55:17.232227 [DEBUG] sofia_glue.c:1295 sofia/internal/1131@10.10.0.35:5060 sending invite version: 1.6.20 -37-987c9b9 64bit
  538. Local SDP:
  539. v=0
  540. o=FreeSWITCH 1532091247 1532091248 IN IP4 10.10.0.190
  541. s=FreeSWITCH
  542. c=IN IP4 10.10.0.190
  543. t=0 0
  544. m=audio 25270 RTP/AVP 102 0 8 103 101
  545. a=rtpmap:102 opus/48000/2
  546. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
  547. a=rtpmap:0 PCMU/8000
  548. a=rtpmap:8 PCMA/8000
  549. a=rtpmap:103 telephone-event/48000
  550. a=fmtp:103 0-16
  551. a=rtpmap:101 telephone-event/8000
  552. a=fmtp:101 0-16
  553. a=ptime:20
  554. a=sendrecv
  555.  
  556. 2018-07-20 12:55:17.252223 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  557. 2018-07-20 12:55:17.252223 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  558. 2018-07-20 12:55:17.252223 [DEBUG] switch_ivr_originate.c:2142 Parsing global variables
  559. 2018-07-20 12:55:17.252223 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  560. 2018-07-20 12:55:17.252223 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  561. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  562. 2018-07-20 12:55:17.252223 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  563. 2018-07-20 12:55:17.232227 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  564. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1131@10.10.0.35:5060 Standard INIT
  565. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  566. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1131@10.10.0.35:5060) State Change CS_INIT -> CS_ROUTING
  567. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/1131@10.10.0.35:5060) State INIT going to sleep
  568. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/3001@10.10.0.201) Running State Change CS_INIT (Cur 6 Tot 6)
  569. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/3001@10.10.0.201) State INIT
  570. 5f3e9751 2018-07-20 12:55:17.252223 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/5001@10.10.0.37:5060 [5f3e9751-fb7d-48c1-812c-ffae5fee1559]
  571. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] mod_sofia.c:90 sofia/internal/3001@10.10.0.201 SOFIA INIT
  572. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] mod_sofia.c:4819 (sofia/internal/5001@10.10.0.37:5060) State Change CS_NEW -> CS_INIT
  573. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1131@10.10.0.35:5060) Running State Change CS_ROUTING (Cur 6 Tot 6)
  574. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] sofia.c:7084 Channel sofia/internal/1131@10.10.0.35:5060 entering state [calling][0]
  575. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1131@10.10.0.35:5060) State ROUTING
  576. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] mod_sofia.c:143 sofia/internal/1131@10.10.0.35:5060 SOFIA ROUTING
  577. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/1131@10.10.0.35:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  578. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/1131@10.10.0.35:5060) State ROUTING going to sleep
  579. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1131@10.10.0.35:5060) Running State Change CS_CONSUME_MEDIA (Cur 6 Tot 6)
  580. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1131@10.10.0.35:5060) State CONSUME_MEDIA
  581. 0cf8ec7a 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/1131@10.10.0.35:5060) State CONSUME_MEDIA going to sleep
  582. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:2669 Parsing session specific variables
  583. 2018-07-20 12:55:17.252223 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  584. 2018-07-20 12:55:17.252223 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  585. 2018-07-20 12:55:17.252223 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  586. e10e6bbc 2018-07-20 12:55:17.252223 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/2201@10.10.0.34:5060 [e10e6bbc-b423-4b6f-af69-bb188b7277f1]
  587. 2018-07-20 12:55:17.232227 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  588. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] mod_sofia.c:4819 (sofia/internal/2201@10.10.0.34:5060) State Change CS_NEW -> CS_INIT
  589. 2018-07-20 12:55:17.252223 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  590. 2018-07-20 12:55:17.252223 [NOTICE] switch_ivr_originate.c:2851 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  591. 2018-07-20 12:55:17.252223 [DEBUG] switch_ivr_originate.c:3848 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED]
  592. 2018-07-20 12:55:17.252223 [ERR] mod_conference.c:1418 Cannot create outgoing channel, cause: USER_NOT_REGISTERED
  593. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5001@10.10.0.37:5060) Running State Change CS_INIT (Cur 7 Tot 7)
  594. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/5001@10.10.0.37:5060) State INIT
  595. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/2201@10.10.0.34:5060) Running State Change CS_INIT (Cur 7 Tot 7)
  596. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] mod_sofia.c:90 sofia/internal/5001@10.10.0.37:5060 SOFIA INIT
  597. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/2201@10.10.0.34:5060) State INIT
  598. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] mod_sofia.c:90 sofia/internal/2201@10.10.0.34:5060 SOFIA INIT
  599. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] sofia_glue.c:1295 sofia/internal/5001@10.10.0.37:5060 sending invite version: 1.6.20 -37-987c9b9 64bit
  600. Local SDP:
  601. v=0
  602. o=FreeSWITCH 1532089095 1532089096 IN IP4 10.10.0.190
  603. s=FreeSWITCH
  604. c=IN IP4 10.10.0.190
  605. t=0 0
  606. m=audio 27422 RTP/AVP 102 0 8 103 101
  607. a=rtpmap:102 opus/48000/2
  608. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
  609. a=rtpmap:0 PCMU/8000
  610. a=rtpmap:8 PCMA/8000
  611. a=rtpmap:103 telephone-event/48000
  612. a=fmtp:103 0-16
  613. a=rtpmap:101 telephone-event/8000
  614. a=fmtp:101 0-16
  615. a=ptime:20
  616. a=sendrecv
  617.  
  618. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] sofia_glue.c:1295 sofia/internal/2201@10.10.0.34:5060 sending invite version: 1.6.20 -37-987c9b9 64bit
  619. Local SDP:
  620. v=0
  621. o=FreeSWITCH 1532093607 1532093608 IN IP4 10.10.0.190
  622. s=FreeSWITCH
  623. c=IN IP4 10.10.0.190
  624. t=0 0
  625. m=audio 22910 RTP/AVP 102 0 8 103 101
  626. a=rtpmap:102 opus/48000/2
  627. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
  628. a=rtpmap:0 PCMU/8000
  629. a=rtpmap:8 PCMA/8000
  630. a=rtpmap:103 telephone-event/48000
  631. a=fmtp:103 0-16
  632. a=rtpmap:101 telephone-event/8000
  633. a=fmtp:101 0-16
  634. a=ptime:20
  635. a=sendrecv
  636.  
  637. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:40 sofia/internal/2201@10.10.0.34:5060 Standard INIT
  638. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/2201@10.10.0.34:5060) State Change CS_INIT -> CS_ROUTING
  639. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] sofia_glue.c:1295 sofia/internal/3001@10.10.0.201 sending invite version: 1.6.20 -37-987c9b9 64bit
  640. Local SDP:
  641. v=0
  642. o=FreeSWITCH 1532090945 1532090946 IN IP4 10.10.0.190
  643. s=FreeSWITCH
  644. c=IN IP4 10.10.0.190
  645. t=0 0
  646. m=audio 25572 RTP/AVP 102 0 8 103 101
  647. a=rtpmap:102 opus/48000/2
  648. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
  649. a=rtpmap:0 PCMU/8000
  650. a=rtpmap:8 PCMA/8000
  651. a=rtpmap:103 telephone-event/48000
  652. a=fmtp:103 0-16
  653. a=rtpmap:101 telephone-event/8000
  654. a=fmtp:101 0-16
  655. a=ptime:20
  656. a=sendrecv
  657.  
  658. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:40 sofia/internal/3001@10.10.0.201 Standard INIT
  659. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:40 sofia/internal/5001@10.10.0.37:5060 Standard INIT
  660. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/3001@10.10.0.201) State Change CS_INIT -> CS_ROUTING
  661. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/5001@10.10.0.37:5060) State Change CS_INIT -> CS_ROUTING
  662. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/3001@10.10.0.201) State INIT going to sleep
  663. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/5001@10.10.0.37:5060) State INIT going to sleep
  664. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/3001@10.10.0.201) Running State Change CS_ROUTING (Cur 7 Tot 7)
  665. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/3001@10.10.0.201) State ROUTING
  666. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] mod_sofia.c:143 sofia/internal/3001@10.10.0.201 SOFIA ROUTING
  667. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/3001@10.10.0.201) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  668. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/3001@10.10.0.201) State ROUTING going to sleep
  669. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/3001@10.10.0.201) Running State Change CS_CONSUME_MEDIA (Cur 7 Tot 7)
  670. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5001@10.10.0.37:5060) Running State Change CS_ROUTING (Cur 7 Tot 7)
  671. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] sofia.c:7084 Channel sofia/internal/5001@10.10.0.37:5060 entering state [calling][0]
  672. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5001@10.10.0.37:5060) State ROUTING
  673. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] mod_sofia.c:143 sofia/internal/5001@10.10.0.37:5060 SOFIA ROUTING
  674. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/5001@10.10.0.37:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  675. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/5001@10.10.0.37:5060) State ROUTING going to sleep
  676. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5001@10.10.0.37:5060) Running State Change CS_CONSUME_MEDIA (Cur 7 Tot 7)
  677. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:627 (sofia/internal/2201@10.10.0.34:5060) State INIT going to sleep
  678. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/5001@10.10.0.37:5060) State CONSUME_MEDIA
  679. 5f3e9751 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/5001@10.10.0.37:5060) State CONSUME_MEDIA going to sleep
  680. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] sofia.c:7084 Channel sofia/internal/3001@10.10.0.201 entering state [calling][0]
  681. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/3001@10.10.0.201) State CONSUME_MEDIA
  682. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/3001@10.10.0.201) State CONSUME_MEDIA going to sleep
  683. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/2201@10.10.0.34:5060) Running State Change CS_ROUTING (Cur 7 Tot 7)
  684. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] sofia.c:7084 Channel sofia/internal/2201@10.10.0.34:5060 entering state [calling][0]
  685. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/2201@10.10.0.34:5060) State ROUTING
  686. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] mod_sofia.c:143 sofia/internal/2201@10.10.0.34:5060 SOFIA ROUTING
  687. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/2201@10.10.0.34:5060) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  688. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:643 (sofia/internal/2201@10.10.0.34:5060) State ROUTING going to sleep
  689. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/2201@10.10.0.34:5060) Running State Change CS_CONSUME_MEDIA (Cur 7 Tot 7)
  690. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/2201@10.10.0.34:5060) State CONSUME_MEDIA
  691. e10e6bbc 2018-07-20 12:55:17.252223 [DEBUG] switch_core_state_machine.c:662 (sofia/internal/2201@10.10.0.34:5060) State CONSUME_MEDIA going to sleep
  692. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] sofia.c:7084 Channel sofia/internal/3001@10.10.0.201 entering state [proceeding][180]
  693. f5d2f201 2018-07-20 12:55:17.252223 [NOTICE] sofia.c:7192 Ring-Ready sofia/internal/3001@10.10.0.201!
  694. f5d2f201 2018-07-20 12:55:17.252223 [DEBUG] switch_channel.c:3346 (sofia/internal/3001@10.10.0.201) Callstate Change DOWN -> RINGING
  695. 2018-07-20 12:55:17.252223 [DEBUG] mod_local_stream.c:871 Opening Stream [moh/8000] 8000hz
  696. ff4e24f6 2018-07-20 12:55:17.272219 [DEBUG] sofia.c:7084 Channel sofia/internal/9000@10.10.0.190:5060 entering state [ready][200]
  697. ff4e24f6 2018-07-20 12:55:17.272219 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
  698. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] sofia.c:7084 Channel sofia/internal/3001@10.10.0.201 entering state [completing][200]
  699. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] sofia.c:7094 Remote SDP:
  700. v=0
  701. o=3001 1052092996 591622851 IN IP4 10.10.0.201
  702. s=-
  703. c=IN IP4 10.10.0.201
  704. t=0 0
  705. m=audio 8000 RTP/AVP 0
  706. a=rtpmap:0 PCMU/8000
  707. a=ptime:20
  708.  
  709. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] sofia.c:7084 Channel sofia/internal/3001@10.10.0.201 entering state [ready][200]
  710. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  711. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  712. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  713. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  714. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/3001@10.10.0.201 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  715. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_codec.c:111 sofia/internal/3001@10.10.0.201 Original read codec set to PCMU:0
  716. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_media.c:4738 No 2833 in SDP. Liberal DTMF mode adding 101 as telephone-event.
  717. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_media.c:4767 sofia/internal/3001@10.10.0.201 Set 2833 dtmf send payload to 101 recv payload to 101
  718. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/internal/3001@10.10.0.201] 10.10.0.190 port 25572 -> 10.10.0.201 port 8000 codec: 0 ms: 20
  719. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
  720. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_media.c:7180 sofia/internal/3001@10.10.0.201 Set 2833 dtmf send payload to 101
  721. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_media.c:7187 sofia/internal/3001@10.10.0.201 Set 2833 dtmf receive payload to 101
  722. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_core_media.c:7210 sofia/internal/3001@10.10.0.201 Set rtp dtmf delay to 40
  723. f5d2f201 2018-07-20 12:55:17.272219 [NOTICE] sofia.c:8218 Channel [sofia/internal/3001@10.10.0.201] has been answered
  724. f5d2f201 2018-07-20 12:55:17.272219 [DEBUG] switch_channel.c:3773 (sofia/internal/3001@10.10.0.201) Callstate Change RINGING -> ACTIVE
  725. 2018-07-20 12:55:17.292233 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/internal/3001@10.10.0.201]
  726. f5d2f201 2018-07-20 12:55:17.292233 [INFO] switch_channel.c:3129 sofia/internal/3001@10.10.0.201 Flipping CID from "All Call" <6060> to "Outbound Call" <3001>
  727. f5d2f201 2018-07-20 12:55:17.292233 [DEBUG] mod_conference.c:1482 (sofia/internal/3001@10.10.0.201) State Change CS_CONSUME_MEDIA -> CS_EXECUTE
  728. f5d2f201 2018-07-20 12:55:17.292233 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/3001@10.10.0.201) Running State Change CS_EXECUTE (Cur 7 Tot 7)
  729. f5d2f201 2018-07-20 12:55:17.292233 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/3001@10.10.0.201) State EXECUTE
  730. f5d2f201 2018-07-20 12:55:17.292233 [DEBUG] mod_sofia.c:198 sofia/internal/3001@10.10.0.201 SOFIA EXECUTE
  731. f5d2f201 2018-07-20 12:55:17.292233 [DEBUG] switch_core_state_machine.c:328 sofia/internal/3001@10.10.0.201 Standard EXECUTE
  732. f5d2f201 EXECUTE sofia/internal/3001@10.10.0.201 conference(madboss_intercom1+flags{})
  733. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7084 Channel sofia/internal/1101@10.10.0.33:5060 entering state [completing][200]
  734. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7094 Remote SDP:
  735. v=0
  736. o=- 1 1 IN IP4 10.10.0.33
  737. s=Barix SIP
  738. c=IN IP4 10.10.0.33
  739. t=0 0
  740. m=audio 5004 RTP/AVP 0 101
  741. a=rtpmap:0 PCMU/8000
  742. a=rtpmap:101 telephone-event/8000
  743. a=fmtp:101 0-16
  744. a=sendrcv
  745.  
  746. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7084 Channel sofia/internal/1101@10.10.0.33:5060 entering state [ready][200]
  747. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  748. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  749. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  750. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  751. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
  752. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/1101@10.10.0.33:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  753. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_codec.c:111 sofia/internal/1101@10.10.0.33:5060 Original read codec set to PCMU:0
  754. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
  755. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4767 sofia/internal/1101@10.10.0.33:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  756. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/internal/1101@10.10.0.33:5060] 10.10.0.190 port 21494 -> 10.10.0.33 port 5004 codec: 0 ms: 20
  757. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
  758. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7084 Channel sofia/internal/1114@10.10.0.36:5060 entering state [completing][200]
  759. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7094 Remote SDP:
  760. v=0
  761. o=- 1 1 IN IP4 10.10.0.36
  762. s=Barix SIP
  763. c=IN IP4 10.10.0.36
  764. t=0 0
  765. m=audio 5004 RTP/AVP 0 101
  766. a=rtpmap:0 PCMU/8000
  767. a=rtpmap:101 telephone-event/8000
  768. a=fmtp:101 0-16
  769. a=sendrcv
  770.  
  771. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7180 sofia/internal/1101@10.10.0.33:5060 Set 2833 dtmf send payload to 101
  772. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7187 sofia/internal/1101@10.10.0.33:5060 Set 2833 dtmf receive payload to 101
  773. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7210 sofia/internal/1101@10.10.0.33:5060 Set rtp dtmf delay to 40
  774. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7084 Channel sofia/internal/1114@10.10.0.36:5060 entering state [ready][200]
  775. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7084 Channel sofia/internal/1131@10.10.0.35:5060 entering state [completing][200]
  776. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7094 Remote SDP:
  777. v=0
  778. o=- 1 1 IN IP4 10.10.0.35
  779. s=Barix SIP
  780. c=IN IP4 10.10.0.35
  781. t=0 0
  782. m=audio 5004 RTP/AVP 0 101
  783. a=rtpmap:0 PCMU/8000
  784. a=rtpmap:101 telephone-event/8000
  785. a=fmtp:101 0-16
  786. a=sendrcv
  787.  
  788. 24ecc9c6 2018-07-20 12:55:17.312222 [NOTICE] sofia.c:8218 Channel [sofia/internal/1101@10.10.0.33:5060] has been answered
  789. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7084 Channel sofia/internal/1131@10.10.0.35:5060 entering state [ready][200]
  790. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  791. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  792. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  793. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  794. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
  795. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/1114@10.10.0.36:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  796. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_codec.c:111 sofia/internal/1114@10.10.0.36:5060 Original read codec set to PCMU:0
  797. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  798. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  799. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  800. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  801. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
  802. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/1131@10.10.0.35:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  803. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_codec.c:111 sofia/internal/1131@10.10.0.35:5060 Original read codec set to PCMU:0
  804. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
  805. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4767 sofia/internal/1114@10.10.0.36:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  806. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/internal/1114@10.10.0.36:5060] 10.10.0.190 port 27478 -> 10.10.0.36 port 5004 codec: 0 ms: 20
  807. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
  808. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4767 sofia/internal/1131@10.10.0.35:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  809. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/internal/1131@10.10.0.35:5060] 10.10.0.190 port 25270 -> 10.10.0.35 port 5004 codec: 0 ms: 20
  810. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
  811. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_channel.c:3773 (sofia/internal/1101@10.10.0.33:5060) Callstate Change DOWN -> ACTIVE
  812. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
  813. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7180 sofia/internal/1114@10.10.0.36:5060 Set 2833 dtmf send payload to 101
  814. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7187 sofia/internal/1114@10.10.0.36:5060 Set 2833 dtmf receive payload to 101
  815. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7210 sofia/internal/1114@10.10.0.36:5060 Set rtp dtmf delay to 40
  816. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7180 sofia/internal/1131@10.10.0.35:5060 Set 2833 dtmf send payload to 101
  817. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7187 sofia/internal/1131@10.10.0.35:5060 Set 2833 dtmf receive payload to 101
  818. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7210 sofia/internal/1131@10.10.0.35:5060 Set rtp dtmf delay to 40
  819. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7084 Channel sofia/internal/5001@10.10.0.37:5060 entering state [completing][200]
  820. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7094 Remote SDP:
  821. v=0
  822. o=- 1 1 IN IP4 10.10.0.37
  823. s=Barix SIP
  824. c=IN IP4 10.10.0.37
  825. t=0 0
  826. m=audio 5004 RTP/AVP 0 101
  827. a=rtpmap:0 PCMU/8000
  828. a=rtpmap:101 telephone-event/8000
  829. a=fmtp:101 0-16
  830. a=sendrcv
  831.  
  832. e5e6183d 2018-07-20 12:55:17.312222 [NOTICE] sofia.c:8218 Channel [sofia/internal/1114@10.10.0.36:5060] has been answered
  833. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7084 Channel sofia/internal/5001@10.10.0.37:5060 entering state [ready][200]
  834. 0cf8ec7a 2018-07-20 12:55:17.312222 [NOTICE] sofia.c:8218 Channel [sofia/internal/1131@10.10.0.35:5060] has been answered
  835. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  836. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  837. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  838. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  839. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
  840. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/5001@10.10.0.37:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  841. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_codec.c:111 sofia/internal/5001@10.10.0.37:5060 Original read codec set to PCMU:0
  842. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
  843. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4767 sofia/internal/5001@10.10.0.37:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  844. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_channel.c:3773 (sofia/internal/1114@10.10.0.36:5060) Callstate Change DOWN -> ACTIVE
  845. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/internal/5001@10.10.0.37:5060] 10.10.0.190 port 27422 -> 10.10.0.37 port 5004 codec: 0 ms: 20
  846. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
  847. 0cf8ec7a 2018-07-20 12:55:17.312222 [DEBUG] switch_channel.c:3773 (sofia/internal/1131@10.10.0.35:5060) Callstate Change DOWN -> ACTIVE
  848. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7084 Channel sofia/internal/2201@10.10.0.34:5060 entering state [completing][200]
  849. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7094 Remote SDP:
  850. v=0
  851. o=- 1 1 IN IP4 10.10.0.34
  852. s=Barix SIP
  853. c=IN IP4 10.10.0.34
  854. t=0 0
  855. m=audio 5004 RTP/AVP 0 101
  856. a=rtpmap:0 PCMU/8000
  857. a=rtpmap:101 telephone-event/8000
  858. a=fmtp:101 0-16
  859. a=sendrcv
  860.  
  861. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] sofia.c:7084 Channel sofia/internal/2201@10.10.0.34:5060 entering state [ready][200]
  862. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7180 sofia/internal/5001@10.10.0.37:5060 Set 2833 dtmf send payload to 101
  863. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7187 sofia/internal/5001@10.10.0.37:5060 Set 2833 dtmf receive payload to 101
  864. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  865. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
  866. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7210 sofia/internal/5001@10.10.0.37:5060 Set rtp dtmf delay to 40
  867. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4504 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
  868. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4449 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
  869. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4365 Set telephone-event payload to 101@8000
  870. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:3061 Set Codec sofia/internal/2201@10.10.0.34:5060 PCMU/8000 20 ms 160 samples 64000 bits 1 channels
  871. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_codec.c:111 sofia/internal/2201@10.10.0.34:5060 Original read codec set to PCMU:0
  872. 5f3e9751 2018-07-20 12:55:17.312222 [NOTICE] sofia.c:8218 Channel [sofia/internal/5001@10.10.0.37:5060] has been answered
  873. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4708 Set telephone-event payload to 101@8000
  874. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:4767 sofia/internal/2201@10.10.0.34:5060 Set 2833 dtmf send payload to 101 recv payload to 101
  875. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:6878 AUDIO RTP [sofia/internal/2201@10.10.0.34:5060] 10.10.0.190 port 22910 -> 10.10.0.34 port 5004 codec: 0 ms: 20
  876. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_rtp.c:4137 Starting timer [soft] 160 bytes per 20ms
  877. 5f3e9751 2018-07-20 12:55:17.312222 [DEBUG] switch_channel.c:3773 (sofia/internal/5001@10.10.0.37:5060) Callstate Change DOWN -> ACTIVE
  878. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7180 sofia/internal/2201@10.10.0.34:5060 Set 2833 dtmf send payload to 101
  879. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7187 sofia/internal/2201@10.10.0.34:5060 Set 2833 dtmf receive payload to 101
  880. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_core_media.c:7210 sofia/internal/2201@10.10.0.34:5060 Set rtp dtmf delay to 40
  881. e10e6bbc 2018-07-20 12:55:17.312222 [NOTICE] sofia.c:8218 Channel [sofia/internal/2201@10.10.0.34:5060] has been answered
  882. e10e6bbc 2018-07-20 12:55:17.312222 [DEBUG] switch_channel.c:3773 (sofia/internal/2201@10.10.0.34:5060) Callstate Change DOWN -> ACTIVE
  883. 2018-07-20 12:55:17.312222 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/internal/1101@10.10.0.33:5060]
  884. 2018-07-20 12:55:17.312222 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/internal/1114@10.10.0.36:5060]
  885. 24ecc9c6 2018-07-20 12:55:17.312222 [INFO] switch_channel.c:3129 sofia/internal/1101@10.10.0.33:5060 Flipping CID from "All Call" <6060> to "Outbound Call" <1101>
  886. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] mod_conference.c:1482 (sofia/internal/1101@10.10.0.33:5060) State Change CS_CONSUME_MEDIA -> CS_EXECUTE
  887. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1101@10.10.0.33:5060) Running State Change CS_EXECUTE (Cur 7 Tot 7)
  888. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1101@10.10.0.33:5060) State EXECUTE
  889. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] mod_sofia.c:198 sofia/internal/1101@10.10.0.33:5060 SOFIA EXECUTE
  890. 24ecc9c6 2018-07-20 12:55:17.312222 [DEBUG] switch_core_state_machine.c:328 sofia/internal/1101@10.10.0.33:5060 Standard EXECUTE
  891. 24ecc9c6 EXECUTE sofia/internal/1101@10.10.0.33:5060 conference(madboss_intercom1+flags{})
  892. e5e6183d 2018-07-20 12:55:17.312222 [INFO] switch_channel.c:3129 sofia/internal/1114@10.10.0.36:5060 Flipping CID from "All Call" <6060> to "Outbound Call" <1114>
  893. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] mod_conference.c:1482 (sofia/internal/1114@10.10.0.36:5060) State Change CS_CONSUME_MEDIA -> CS_EXECUTE
  894. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1114@10.10.0.36:5060) Running State Change CS_EXECUTE (Cur 7 Tot 7)
  895. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1114@10.10.0.36:5060) State EXECUTE
  896. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] mod_sofia.c:198 sofia/internal/1114@10.10.0.36:5060 SOFIA EXECUTE
  897. e5e6183d 2018-07-20 12:55:17.312222 [DEBUG] switch_core_state_machine.c:328 sofia/internal/1114@10.10.0.36:5060 Standard EXECUTE
  898. e5e6183d EXECUTE sofia/internal/1114@10.10.0.36:5060 conference(madboss_intercom1+flags{})
  899. 2018-07-20 12:55:17.332226 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/internal/1131@10.10.0.35:5060]
  900. 0cf8ec7a 2018-07-20 12:55:17.332226 [INFO] switch_channel.c:3129 sofia/internal/1131@10.10.0.35:5060 Flipping CID from "All Call" <6060> to "Outbound Call" <1131>
  901. 0cf8ec7a 2018-07-20 12:55:17.332226 [DEBUG] mod_conference.c:1482 (sofia/internal/1131@10.10.0.35:5060) State Change CS_CONSUME_MEDIA -> CS_EXECUTE
  902. 0cf8ec7a 2018-07-20 12:55:17.332226 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1131@10.10.0.35:5060) Running State Change CS_EXECUTE (Cur 7 Tot 7)
  903. 0cf8ec7a 2018-07-20 12:55:17.332226 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1131@10.10.0.35:5060) State EXECUTE
  904. 0cf8ec7a 2018-07-20 12:55:17.332226 [DEBUG] mod_sofia.c:198 sofia/internal/1131@10.10.0.35:5060 SOFIA EXECUTE
  905. 0cf8ec7a 2018-07-20 12:55:17.332226 [DEBUG] switch_core_state_machine.c:328 sofia/internal/1131@10.10.0.35:5060 Standard EXECUTE
  906. 0cf8ec7a EXECUTE sofia/internal/1131@10.10.0.35:5060 conference(madboss_intercom1+flags{})
  907. 2018-07-20 12:55:17.332226 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/internal/5001@10.10.0.37:5060]
  908. 2018-07-20 12:55:17.332226 [DEBUG] switch_ivr_originate.c:3705 Originate Resulted in Success: [sofia/internal/2201@10.10.0.34:5060]
  909. 5f3e9751 2018-07-20 12:55:17.332226 [INFO] switch_channel.c:3129 sofia/internal/5001@10.10.0.37:5060 Flipping CID from "All Call" <6060> to "Outbound Call" <5001>
  910. 5f3e9751 2018-07-20 12:55:17.332226 [DEBUG] mod_conference.c:1482 (sofia/internal/5001@10.10.0.37:5060) State Change CS_CONSUME_MEDIA -> CS_EXECUTE
  911. 5f3e9751 2018-07-20 12:55:17.332226 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5001@10.10.0.37:5060) Running State Change CS_EXECUTE (Cur 7 Tot 7)
  912. e10e6bbc 2018-07-20 12:55:17.332226 [INFO] switch_channel.c:3129 sofia/internal/2201@10.10.0.34:5060 Flipping CID from "All Call" <6060> to "Outbound Call" <2201>
  913. e10e6bbc 2018-07-20 12:55:17.332226 [DEBUG] mod_conference.c:1482 (sofia/internal/2201@10.10.0.34:5060) State Change CS_CONSUME_MEDIA -> CS_EXECUTE
  914. 5f3e9751 2018-07-20 12:55:17.332226 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5001@10.10.0.37:5060) State EXECUTE
  915. 5f3e9751 2018-07-20 12:55:17.332226 [DEBUG] mod_sofia.c:198 sofia/internal/5001@10.10.0.37:5060 SOFIA EXECUTE
  916. 5f3e9751 2018-07-20 12:55:17.332226 [DEBUG] switch_core_state_machine.c:328 sofia/internal/5001@10.10.0.37:5060 Standard EXECUTE
  917. e10e6bbc 2018-07-20 12:55:17.332226 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/2201@10.10.0.34:5060) Running State Change CS_EXECUTE (Cur 7 Tot 7)
  918. 5f3e9751 EXECUTE sofia/internal/5001@10.10.0.37:5060 conference(madboss_intercom1+flags{})
  919. e10e6bbc 2018-07-20 12:55:17.332226 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/2201@10.10.0.34:5060) State EXECUTE
  920. e10e6bbc 2018-07-20 12:55:17.332226 [DEBUG] mod_sofia.c:198 sofia/internal/2201@10.10.0.34:5060 SOFIA EXECUTE
  921. e10e6bbc 2018-07-20 12:55:17.332226 [DEBUG] switch_core_state_machine.c:328 sofia/internal/2201@10.10.0.34:5060 Standard EXECUTE
  922. e10e6bbc EXECUTE sofia/internal/2201@10.10.0.34:5060 conference(madboss_intercom1+flags{})
  923. f5d2f201 2018-07-20 12:55:17.332226 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
  924. ff4e24f6 2018-07-20 12:55:17.352226 [DEBUG] conference_member.c:1425 Queueing file 'tone_stream://%(500,0,640)' for play
  925. 24ecc9c6 2018-07-20 12:55:17.612221 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
  926. e5e6183d 2018-07-20 12:55:17.612221 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
  927. 0cf8ec7a 2018-07-20 12:55:17.612221 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
  928. 5f3e9751 2018-07-20 12:55:17.612221 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
  929. e10e6bbc 2018-07-20 12:55:17.612221 [DEBUG] switch_rtp.c:7308 Correct audio ip/port confirmed.
  930. f5d2f201 2018-07-20 12:55:17.672223 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
  931. 24ecc9c6 2018-07-20 12:55:17.712225 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
  932. 0cf8ec7a 2018-07-20 12:55:17.712225 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
  933. e5e6183d 2018-07-20 12:55:17.712225 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
  934. 5f3e9751 2018-07-20 12:55:17.712225 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
  935. e10e6bbc 2018-07-20 12:55:17.712225 [DEBUG] switch_ivr_play_say.c:1498 Codec Activated L16@8000hz 1 channels 20ms
  936. f5d2f201 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_play_say.c:1942 done playing file tone_stream://%(250,0,800)
  937. f5d2f201 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:1693 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  938. f5d2f201 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:1740 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  939. f5d2f201 2018-07-20 12:55:17.932216 [DEBUG] switch_core_codec.c:223 sofia/internal/3001@10.10.0.201 Push codec L16:100
  940. 2018-07-20 12:55:17.932216 [ERR] switch_core_video.c:1789 Error open png: /var/lib/freeswitch/images/default-mute.png
  941. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '0' to 'mute'
  942. 2018-07-20 12:55:17.932216 [INFO] switch_ivr_async.c:214 Digit parser mod_conference: Setting realm to 'conf'
  943. 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 0/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c083200
  944. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '*' to 'deaf mute'
  945. 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding */conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c083230
  946. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '9' to 'energy up'
  947. 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 9/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c083260
  948. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '8' to 'energy equ'
  949. 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 8/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c083290
  950. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '7' to 'energy dn'
  951. 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 7/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c0832c0
  952. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '3' to 'vol talk up'
  953. 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 3/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c0832f0
  954. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '2' to 'vol talk zero'
  955. 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 2/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c083320
  956. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '1' to 'vol talk dn'
  957. 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 1/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c083350
  958. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '6' to 'vol listen up'
  959. 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 6/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c083380
  960. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '5' to 'vol listen zero'
  961. 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 5/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c0833b0
  962. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '4' to 'vol listen dn'
  963. 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 4/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c0833e0
  964. 2018-07-20 12:55:17.932216 [DEBUG] conference_member.c:128 sofia/internal/3001@10.10.0.201 binding '#' to 'hangup'
  965. span style="color: goldenrod; font-weight: bold;"> 2018-07-20 12:55:17.932216 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding #/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4c083410
  966. span style="color: goldenrod; font-weight: bold;"> f5d2f201 2018-07-20 12:55:17.932216 [DEBUG] conference_loop.c:1142 Setup timer soft success interval: 20  samples: 160 from codec PCMU
  967. 24ecc9c6 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_play_say.c:1942 done playing file tone_stream://%(250,0,800)
  968. 24ecc9c6 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:1693 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  969. 24ecc9c6 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:1740 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  970. 24ecc9c6 2018-07-20 12:55:17.972226 [DEBUG] switch_core_codec.c:223 sofia/internal/1101@10.10.0.33:5060 Push codec L16:100
  971. 2018-07-20 12:55:17.972226 [ERR] switch_core_video.c:1789 Error open png: /var/lib/freeswitch/images/default-mute.png
  972. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '0' to 'mute'
  973. 2018-07-20 12:55:17.972226 [INFO] switch_ivr_async.c:214 Digit parser mod_conference: Setting realm to 'conf'
  974. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 0/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe30030570
  975. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '*' to 'deaf mute'
  976. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding */conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe300305a0
  977. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '9' to 'energy up'
  978. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 9/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe300305d0
  979. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '8' to 'energy equ'
  980. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 8/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe30030600
  981. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '7' to 'energy dn'
  982. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 7/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe30030630
  983. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '3' to 'vol talk up'
  984. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 3/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe30030660
  985. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '2' to 'vol talk zero'
  986. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 2/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe30030690
  987. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '1' to 'vol talk dn'
  988. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 1/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe300306c0
  989. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '6' to 'vol listen up'
  990. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 6/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe300306f0
  991. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '5' to 'vol listen zero'
  992. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 5/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe30030720
  993. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '4' to 'vol listen dn'
  994. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 4/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe30030750
  995. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1101@10.10.0.33:5060 binding '#' to 'hangup'
  996. span style="color: goldenrod; font-weight: bold;"> 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding #/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe30030780
  997. span style="color: goldenrod; font-weight: bold;"> 24ecc9c6 2018-07-20 12:55:17.972226 [DEBUG] conference_loop.c:1142 Setup timer soft success interval: 20  samples: 160 from codec PCMU
  998. e5e6183d 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_play_say.c:1942 done playing file tone_stream://%(250,0,800)
  999. 0cf8ec7a 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_play_say.c:1942 done playing file tone_stream://%(250,0,800)
  1000. e5e6183d 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:1693 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  1001. e5e6183d 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:1740 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  1002. 0cf8ec7a 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:1693 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  1003. e5e6183d 2018-07-20 12:55:17.972226 [DEBUG] switch_core_codec.c:223 sofia/internal/1114@10.10.0.36:5060 Push codec L16:100
  1004. 0cf8ec7a 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:1740 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  1005. 2018-07-20 12:55:17.972226 [ERR] switch_core_video.c:1789 Error open png: /var/lib/freeswitch/images/default-mute.png
  1006. 0cf8ec7a 2018-07-20 12:55:17.972226 [DEBUG] switch_core_codec.c:223 sofia/internal/1131@10.10.0.35:5060 Push codec L16:100
  1007. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '0' to 'mute'
  1008. 2018-07-20 12:55:17.972226 [INFO] switch_ivr_async.c:214 Digit parser mod_conference: Setting realm to 'conf'
  1009. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 0/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe340371f0
  1010. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '*' to 'deaf mute'
  1011. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding */conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe34037220
  1012. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '9' to 'energy up'
  1013. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 9/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe34037250
  1014. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '8' to 'energy equ'
  1015. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 8/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe34037280
  1016. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '7' to 'energy dn'
  1017. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 7/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe340372b0
  1018. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '3' to 'vol talk up'
  1019. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 3/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe340372e0
  1020. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '2' to 'vol talk zero'
  1021. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 2/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe34037310
  1022. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '1' to 'vol talk dn'
  1023. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 1/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe34037340
  1024. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '6' to 'vol listen up'
  1025. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 6/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe34037370
  1026. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '5' to 'vol listen zero'
  1027. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 5/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe340373a0
  1028. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '4' to 'vol listen dn'
  1029. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 4/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe340373d0
  1030. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1114@10.10.0.36:5060 binding '#' to 'hangup'
  1031. span style="color: goldenrod; font-weight: bold;"> 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding #/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe34037400
  1032. span style="color: firebrick; font-weight: bold;"> 2018-07-20 12:55:17.972226 [ERR] switch_core_video.c:1789 Error open png: /var/lib/freeswitch/images/default-mute.png
  1033. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '0' to 'mute'
  1034. 2018-07-20 12:55:17.972226 [INFO] switch_ivr_async.c:214 Digit parser mod_conference: Setting realm to 'conf'
  1035. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 0/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe540817c0
  1036. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '*' to 'deaf mute'
  1037. e5e6183d 2018-07-20 12:55:17.972226 [DEBUG] conference_loop.c:1142 Setup timer soft success interval: 20  samples: 160 from codec PCMU
  1038. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding */conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe540817f0
  1039. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '9' to 'energy up'
  1040. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 9/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe54081820
  1041. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '8' to 'energy equ'
  1042. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 8/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe54081850
  1043. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '7' to 'energy dn'
  1044. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 7/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe54081880
  1045. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '3' to 'vol talk up'
  1046. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 3/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe540818b0
  1047. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '2' to 'vol talk zero'
  1048. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 2/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe540818e0
  1049. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '1' to 'vol talk dn'
  1050. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 1/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe54081910
  1051. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '6' to 'vol listen up'
  1052. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 6/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe54081940
  1053. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '5' to 'vol listen zero'
  1054. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 5/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe54081970
  1055. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '4' to 'vol listen dn'
  1056. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 4/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe540819a0
  1057. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/1131@10.10.0.35:5060 binding '#' to 'hangup'
  1058. span style="color: goldenrod; font-weight: bold;"> 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding #/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe540819d0
  1059. span style="color: goldenrod; font-weight: bold;"> 0cf8ec7a 2018-07-20 12:55:17.972226 [DEBUG] conference_loop.c:1142 Setup timer soft success interval: 20  samples: 160 from codec PCMU
  1060. 5f3e9751 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_play_say.c:1942 done playing file tone_stream://%(250,0,800)
  1061. 5f3e9751 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:1693 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  1062. 5f3e9751 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:1740 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  1063. 5f3e9751 2018-07-20 12:55:17.972226 [DEBUG] switch_core_codec.c:223 sofia/internal/5001@10.10.0.37:5060 Push codec L16:100
  1064. 2018-07-20 12:55:17.972226 [ERR] switch_core_video.c:1789 Error open png: /var/lib/freeswitch/images/default-mute.png
  1065. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '0' to 'mute'
  1066. 2018-07-20 12:55:17.972226 [INFO] switch_ivr_async.c:214 Digit parser mod_conference: Setting realm to 'conf'
  1067. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 0/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403ac00
  1068. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '*' to 'deaf mute'
  1069. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding */conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403ac30
  1070. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '9' to 'energy up'
  1071. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 9/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403ac60
  1072. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '8' to 'energy equ'
  1073. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 8/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403ac90
  1074. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '7' to 'energy dn'
  1075. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 7/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403acc0
  1076. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '3' to 'vol talk up'
  1077. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 3/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403acf0
  1078. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '2' to 'vol talk zero'
  1079. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 2/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403ad20
  1080. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '1' to 'vol talk dn'
  1081. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 1/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403ad50
  1082. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '6' to 'vol listen up'
  1083. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 6/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403ad80
  1084. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '5' to 'vol listen zero'
  1085. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 5/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403adb0
  1086. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '4' to 'vol listen dn'
  1087. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 4/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403ade0
  1088. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/5001@10.10.0.37:5060 binding '#' to 'hangup'
  1089. span style="color: goldenrod; font-weight: bold;"> 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding #/conf/0 callback: 0x7fbe737a5dd0 data: 0x7fbe4403ae10
  1090. span style="color: goldenrod; font-weight: bold;"> 5f3e9751 2018-07-20 12:55:17.972226 [DEBUG] conference_loop.c:1142 Setup timer soft success interval: 20  samples: 160 from codec PCMU
  1091. e10e6bbc 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_play_say.c:1942 done playing file tone_stream://%(250,0,800)
  1092. e10e6bbc 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:1693 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  1093. e10e6bbc 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:1740 Raw Codec Activation Success L16@8000hz 1 channel 20ms
  1094. e10e6bbc 2018-07-20 12:55:17.972226 [DEBUG] switch_core_codec.c:223 sofia/internal/2201@10.10.0.34:5060 Push codec L16:100
  1095. 2018-07-20 12:55:17.972226 [ERR] switch_core_video.c:1789 Error open png: /var/lib/freeswitch/images/default-mute.png
  1096. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '0' to 'mute'
  1097. 2018-07-20 12:55:17.972226 [INFO] switch_ivr_async.c:214 Digit parser mod_conference: Setting realm to 'conf'
  1098. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 0/conf/0 callback: 0x7fbe737a5dd0 data: 0xa32b70
  1099. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '*' to 'deaf mute'
  1100. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding */conf/0 callback: 0x7fbe737a5dd0 data: 0xa32ba0
  1101. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '9' to 'energy up'
  1102. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 9/conf/0 callback: 0x7fbe737a5dd0 data: 0xa32bd0
  1103. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '8' to 'energy equ'
  1104. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 8/conf/0 callback: 0x7fbe737a5dd0 data: 0xa32c00
  1105. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '7' to 'energy dn'
  1106. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 7/conf/0 callback: 0x7fbe737a5dd0 data: 0xa32c30
  1107. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '3' to 'vol talk up'
  1108. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 3/conf/0 callback: 0x7fbe737a5dd0 data: 0xa32c60
  1109. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '2' to 'vol talk zero'
  1110. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 2/conf/0 callback: 0x7fbe737a5dd0 data: 0xa32c90
  1111. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '1' to 'vol talk dn'
  1112. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 1/conf/0 callback: 0x7fbe737a5dd0 data: 0xa32cc0
  1113. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '6' to 'vol listen up'
  1114. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 6/conf/0 callback: 0x7fbe737a5dd0 data: 0xa32cf0
  1115. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '5' to 'vol listen zero'
  1116. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 5/conf/0 callback: 0x7fbe737a5dd0 data: 0xa32d20
  1117. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '4' to 'vol listen dn'
  1118. 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding 4/conf/0 callback: 0x7fbe737a5dd0 data: 0xa32d50
  1119. 2018-07-20 12:55:17.972226 [DEBUG] conference_member.c:128 sofia/internal/2201@10.10.0.34:5060 binding '#' to 'hangup'
  1120. span style="color: goldenrod; font-weight: bold;"> 2018-07-20 12:55:17.972226 [DEBUG] switch_ivr_async.c:323 Digit parser mod_conference: binding #/conf/0 callback: 0x7fbe737a5dd0 data: 0xa32d80
  1121. span style="color: goldenrod; font-weight: bold;"> e10e6bbc 2018-07-20 12:55:17.972226 [DEBUG] conference_loop.c:1142 Setup timer soft success interval: 20  samples: 160 from codec PCMU
  1122. ff4e24f6 2018-07-20 12:55:19.472217 [NOTICE] sofia.c:1012 Hangup sofia/internal/9000@10.10.0.190:5060 [CS_EXECUTE] [NORMAL_CLEARING]
  1123. ff4e24f6 2018-07-20 12:55:19.492234 [INFO] conference_loop.c:1471 Channel leaving conference, cause: NORMAL_CLEARING
  1124. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] mod_conference.c:2247 sofia/internal/9000@10.10.0.190:5060 skip receive message [UNBRIDGE] (channel is hungup already)
  1125. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_media.c:9780 sofia/internal/9000@10.10.0.190:5060 skip receive message [HARD_MUTE] (channel is hungup already)
  1126. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_codec.c:248 sofia/internal/9000@10.10.0.190:5060 Restore previous codec PCMU:0.
  1127. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_session.c:2815 sofia/internal/9000@10.10.0.190:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1128. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/9000@10.10.0.190:5060) State EXECUTE going to sleep
  1129. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/9000@10.10.0.190:5060) Running State Change CS_HANGUP (Cur 7 Tot 7)
  1130. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/9000@10.10.0.190:5060) Callstate Change ACTIVE -> HANGUP
  1131. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/9000@10.10.0.190:5060) State HANGUP
  1132. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] mod_sofia.c:438 Channel sofia/internal/9000@10.10.0.190:5060 hanging up, cause: NORMAL_CLEARING
  1133. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:60 sofia/internal/9000@10.10.0.190:5060 Standard HANGUP, cause: NORMAL_CLEARING
  1134. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/9000@10.10.0.190:5060) State HANGUP going to sleep
  1135. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/9000@10.10.0.190:5060) State Change CS_HANGUP -> CS_REPORTING
  1136. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/9000@10.10.0.190:5060) Running State Change CS_REPORTING (Cur 7 Tot 7)
  1137. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/9000@10.10.0.190:5060) State REPORTING
  1138. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:174 sofia/internal/9000@10.10.0.190:5060 Standard REPORTING, cause: NORMAL_CLEARING
  1139. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/9000@10.10.0.190:5060) State REPORTING going to sleep
  1140. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/9000@10.10.0.190:5060) State Change CS_REPORTING -> CS_DESTROY
  1141. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_session.c:1665 Session 1 (sofia/internal/9000@10.10.0.190:5060) Locked, Waiting on external entities
  1142. ff4e24f6 2018-07-20 12:55:19.492234 [NOTICE] switch_core_session.c:1683 Session 1 (sofia/internal/9000@10.10.0.190:5060) Ended
  1143. ff4e24f6 2018-07-20 12:55:19.492234 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/9000@10.10.0.190:5060 [CS_DESTROY]
  1144. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/9000@10.10.0.190:5060) Running State Change CS_DESTROY (Cur 6 Tot 7)
  1145. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/9000@10.10.0.190:5060) State DESTROY
  1146. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] mod_sofia.c:343 sofia/internal/9000@10.10.0.190:5060 SOFIA DESTROY
  1147. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:181 sofia/internal/9000@10.10.0.190:5060 Standard DESTROY
  1148. ff4e24f6 2018-07-20 12:55:19.492234 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/9000@10.10.0.190:5060) State DESTROY going to sleep
  1149. 2018-07-20 12:55:20.012221 [DEBUG] mod_conference.c:706 Conference madboss_intercom1: endconf grace time exceeded (0)
  1150. 2018-07-20 12:55:20.012221 [NOTICE] mod_conference.c:719 Ending pending outcall channels for Conference: 'madboss_intercom1'
  1151. e10e6bbc 2018-07-20 12:55:20.012221 [NOTICE] mod_conference.c:742 Hangup sofia/internal/2201@10.10.0.34:5060 [CS_EXECUTE] [NORMAL_CLEARING]
  1152. 5f3e9751 2018-07-20 12:55:20.012221 [NOTICE] mod_conference.c:742 Hangup sofia/internal/5001@10.10.0.37:5060 [CS_EXECUTE] [NORMAL_CLEARING]
  1153. 0cf8ec7a 2018-07-20 12:55:20.012221 [NOTICE] mod_conference.c:742 Hangup sofia/internal/1131@10.10.0.35:5060 [CS_EXECUTE] [NORMAL_CLEARING]
  1154. e5e6183d 2018-07-20 12:55:20.012221 [NOTICE] mod_conference.c:742 Hangup sofia/internal/1114@10.10.0.36:5060 [CS_EXECUTE] [NORMAL_CLEARING]
  1155. 24ecc9c6 2018-07-20 12:55:20.012221 [NOTICE] mod_conference.c:742 Hangup sofia/internal/1101@10.10.0.33:5060 [CS_EXECUTE] [NORMAL_CLEARING]
  1156. f5d2f201 2018-07-20 12:55:20.012221 [NOTICE] mod_conference.c:742 Hangup sofia/internal/3001@10.10.0.201 [CS_EXECUTE] [NORMAL_CLEARING]
  1157. 2018-07-20 12:55:20.012221 [DEBUG] mod_conference.c:788 Write Lock ON
  1158. 24ecc9c6 2018-07-20 12:55:20.032219 [INFO] conference_loop.c:1471 Channel leaving conference, cause: NORMAL_CLEARING
  1159. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] mod_conference.c:2247 sofia/internal/1101@10.10.0.33:5060 skip receive message [UNBRIDGE] (channel is hungup already)
  1160. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_media.c:9780 sofia/internal/1101@10.10.0.33:5060 skip receive message [HARD_MUTE] (channel is hungup already)
  1161. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_codec.c:248 sofia/internal/1101@10.10.0.33:5060 Restore previous codec PCMU:0.
  1162. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:2815 sofia/internal/1101@10.10.0.33:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1163. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1101@10.10.0.33:5060) State EXECUTE going to sleep
  1164. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1101@10.10.0.33:5060) Running State Change CS_HANGUP (Cur 6 Tot 7)
  1165. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1101@10.10.0.33:5060) Callstate Change ACTIVE -> HANGUP
  1166. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1101@10.10.0.33:5060) State HANGUP
  1167. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:438 Channel sofia/internal/1101@10.10.0.33:5060 hanging up, cause: NORMAL_CLEARING
  1168. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/internal/1101@10.10.0.33:5060
  1169. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1101@10.10.0.33:5060 Standard HANGUP, cause: NORMAL_CLEARING
  1170. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1101@10.10.0.33:5060) State HANGUP going to sleep
  1171. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1101@10.10.0.33:5060) State Change CS_HANGUP -> CS_REPORTING
  1172. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1101@10.10.0.33:5060) Running State Change CS_REPORTING (Cur 6 Tot 7)
  1173. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1101@10.10.0.33:5060) State REPORTING
  1174. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1101@10.10.0.33:5060 Standard REPORTING, cause: NORMAL_CLEARING
  1175. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1101@10.10.0.33:5060) State REPORTING going to sleep
  1176. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1101@10.10.0.33:5060) State Change CS_REPORTING -> CS_DESTROY
  1177. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:1665 Session 2 (sofia/internal/1101@10.10.0.33:5060) Locked, Waiting on external entities
  1178. 24ecc9c6 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1683 Session 2 (sofia/internal/1101@10.10.0.33:5060) Ended
  1179. 24ecc9c6 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/1101@10.10.0.33:5060 [CS_DESTROY]
  1180. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1101@10.10.0.33:5060) Running State Change CS_DESTROY (Cur 5 Tot 7)
  1181. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1101@10.10.0.33:5060) State DESTROY
  1182. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:343 sofia/internal/1101@10.10.0.33:5060 SOFIA DESTROY
  1183. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1101@10.10.0.33:5060 Standard DESTROY
  1184. 24ecc9c6 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1101@10.10.0.33:5060) State DESTROY going to sleep
  1185. e5e6183d 2018-07-20 12:55:20.032219 [INFO] conference_loop.c:1471 Channel leaving conference, cause: NORMAL_CLEARING
  1186. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] mod_conference.c:2247 sofia/internal/1114@10.10.0.36:5060 skip receive message [UNBRIDGE] (channel is hungup already)
  1187. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_media.c:9780 sofia/internal/1114@10.10.0.36:5060 skip receive message [HARD_MUTE] (channel is hungup already)
  1188. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_codec.c:248 sofia/internal/1114@10.10.0.36:5060 Restore previous codec PCMU:0.
  1189. 0cf8ec7a 2018-07-20 12:55:20.032219 [INFO] conference_loop.c:1471 Channel leaving conference, cause: NORMAL_CLEARING
  1190. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] mod_conference.c:2247 sofia/internal/1131@10.10.0.35:5060 skip receive message [UNBRIDGE] (channel is hungup already)
  1191. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_media.c:9780 sofia/internal/1131@10.10.0.35:5060 skip receive message [HARD_MUTE] (channel is hungup already)
  1192. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:2815 sofia/internal/1114@10.10.0.36:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1193. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_codec.c:248 sofia/internal/1131@10.10.0.35:5060 Restore previous codec PCMU:0.
  1194. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1114@10.10.0.36:5060) State EXECUTE going to sleep
  1195. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1114@10.10.0.36:5060) Running State Change CS_HANGUP (Cur 5 Tot 7)
  1196. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1114@10.10.0.36:5060) Callstate Change ACTIVE -> HANGUP
  1197. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:2815 sofia/internal/1131@10.10.0.35:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1198. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/1131@10.10.0.35:5060) State EXECUTE going to sleep
  1199. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1131@10.10.0.35:5060) Running State Change CS_HANGUP (Cur 5 Tot 7)
  1200. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1114@10.10.0.36:5060) State HANGUP
  1201. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:438 Channel sofia/internal/1114@10.10.0.36:5060 hanging up, cause: NORMAL_CLEARING
  1202. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1131@10.10.0.35:5060) Callstate Change ACTIVE -> HANGUP
  1203. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1131@10.10.0.35:5060) State HANGUP
  1204. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:438 Channel sofia/internal/1131@10.10.0.35:5060 hanging up, cause: NORMAL_CLEARING
  1205. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/internal/1114@10.10.0.36:5060
  1206. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1114@10.10.0.36:5060 Standard HANGUP, cause: NORMAL_CLEARING
  1207. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1114@10.10.0.36:5060) State HANGUP going to sleep
  1208. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1114@10.10.0.36:5060) State Change CS_HANGUP -> CS_REPORTING
  1209. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1114@10.10.0.36:5060) Running State Change CS_REPORTING (Cur 5 Tot 7)
  1210. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1114@10.10.0.36:5060) State REPORTING
  1211. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1114@10.10.0.36:5060 Standard REPORTING, cause: NORMAL_CLEARING
  1212. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1114@10.10.0.36:5060) State REPORTING going to sleep
  1213. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/internal/1131@10.10.0.35:5060
  1214. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1131@10.10.0.35:5060 Standard HANGUP, cause: NORMAL_CLEARING
  1215. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/1131@10.10.0.35:5060) State HANGUP going to sleep
  1216. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/1131@10.10.0.35:5060) State Change CS_HANGUP -> CS_REPORTING
  1217. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1114@10.10.0.36:5060) State Change CS_REPORTING -> CS_DESTROY
  1218. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:1665 Session 3 (sofia/internal/1114@10.10.0.36:5060) Locked, Waiting on external entities
  1219. e5e6183d 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1683 Session 3 (sofia/internal/1114@10.10.0.36:5060) Ended
  1220. e5e6183d 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/1114@10.10.0.36:5060 [CS_DESTROY]
  1221. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/1131@10.10.0.35:5060) Running State Change CS_REPORTING (Cur 5 Tot 7)
  1222. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1131@10.10.0.35:5060) State REPORTING
  1223. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1131@10.10.0.35:5060 Standard REPORTING, cause: NORMAL_CLEARING
  1224. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/1131@10.10.0.35:5060) State REPORTING going to sleep
  1225. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1114@10.10.0.36:5060) Running State Change CS_DESTROY (Cur 4 Tot 7)
  1226. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/1131@10.10.0.35:5060) State Change CS_REPORTING -> CS_DESTROY
  1227. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:1665 Session 4 (sofia/internal/1131@10.10.0.35:5060) Locked, Waiting on external entities
  1228. 0cf8ec7a 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1683 Session 4 (sofia/internal/1131@10.10.0.35:5060) Ended
  1229. 0cf8ec7a 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/1131@10.10.0.35:5060 [CS_DESTROY]
  1230. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1114@10.10.0.36:5060) State DESTROY
  1231. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:343 sofia/internal/1114@10.10.0.36:5060 SOFIA DESTROY
  1232. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1114@10.10.0.36:5060 Standard DESTROY
  1233. e5e6183d 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1114@10.10.0.36:5060) State DESTROY going to sleep
  1234. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/1131@10.10.0.35:5060) Running State Change CS_DESTROY (Cur 3 Tot 7)
  1235. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1131@10.10.0.35:5060) State DESTROY
  1236. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:343 sofia/internal/1131@10.10.0.35:5060 SOFIA DESTROY
  1237. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1131@10.10.0.35:5060 Standard DESTROY
  1238. 0cf8ec7a 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/1131@10.10.0.35:5060) State DESTROY going to sleep
  1239. 5f3e9751 2018-07-20 12:55:20.032219 [INFO] conference_loop.c:1471 Channel leaving conference, cause: NORMAL_CLEARING
  1240. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] mod_conference.c:2247 sofia/internal/5001@10.10.0.37:5060 skip receive message [UNBRIDGE] (channel is hungup already)
  1241. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_media.c:9780 sofia/internal/5001@10.10.0.37:5060 skip receive message [HARD_MUTE] (channel is hungup already)
  1242. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_codec.c:248 sofia/internal/5001@10.10.0.37:5060 Restore previous codec PCMU:0.
  1243. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:2815 sofia/internal/5001@10.10.0.37:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1244. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/5001@10.10.0.37:5060) State EXECUTE going to sleep
  1245. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5001@10.10.0.37:5060) Running State Change CS_HANGUP (Cur 3 Tot 7)
  1246. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/5001@10.10.0.37:5060) Callstate Change ACTIVE -> HANGUP
  1247. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/5001@10.10.0.37:5060) State HANGUP
  1248. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:438 Channel sofia/internal/5001@10.10.0.37:5060 hanging up, cause: NORMAL_CLEARING
  1249. f5d2f201 2018-07-20 12:55:20.032219 [INFO] conference_loop.c:1471 Channel leaving conference, cause: NORMAL_CLEARING
  1250. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] mod_conference.c:2247 sofia/internal/3001@10.10.0.201 skip receive message [UNBRIDGE] (channel is hungup already)
  1251. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_media.c:9780 sofia/internal/3001@10.10.0.201 skip receive message [HARD_MUTE] (channel is hungup already)
  1252. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_codec.c:248 sofia/internal/3001@10.10.0.201 Restore previous codec PCMU:0.
  1253. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:2815 sofia/internal/3001@10.10.0.201 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1254. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/3001@10.10.0.201) State EXECUTE going to sleep
  1255. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/3001@10.10.0.201) Running State Change CS_HANGUP (Cur 3 Tot 7)
  1256. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/internal/5001@10.10.0.37:5060
  1257. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:60 sofia/internal/5001@10.10.0.37:5060 Standard HANGUP, cause: NORMAL_CLEARING
  1258. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/5001@10.10.0.37:5060) State HANGUP going to sleep
  1259. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/5001@10.10.0.37:5060) State Change CS_HANGUP -> CS_REPORTING
  1260. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/5001@10.10.0.37:5060) Running State Change CS_REPORTING (Cur 3 Tot 7)
  1261. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/5001@10.10.0.37:5060) State REPORTING
  1262. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/3001@10.10.0.201) Callstate Change ACTIVE -> HANGUP
  1263. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:174 sofia/internal/5001@10.10.0.37:5060 Standard REPORTING, cause: NORMAL_CLEARING
  1264. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/5001@10.10.0.37:5060) State REPORTING going to sleep
  1265. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/3001@10.10.0.201) State HANGUP
  1266. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:438 Channel sofia/internal/3001@10.10.0.201 hanging up, cause: NORMAL_CLEARING
  1267. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/5001@10.10.0.37:5060) State Change CS_REPORTING -> CS_DESTROY
  1268. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:1665 Session 6 (sofia/internal/5001@10.10.0.37:5060) Locked, Waiting on external entities
  1269. 5f3e9751 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1683 Session 6 (sofia/internal/5001@10.10.0.37:5060) Ended
  1270. 5f3e9751 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/5001@10.10.0.37:5060 [CS_DESTROY]
  1271. e10e6bbc 2018-07-20 12:55:20.032219 [INFO] conference_loop.c:1471 Channel leaving conference, cause: NORMAL_CLEARING
  1272. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/5001@10.10.0.37:5060) Running State Change CS_DESTROY (Cur 2 Tot 7)
  1273. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] mod_conference.c:2247 sofia/internal/2201@10.10.0.34:5060 skip receive message [UNBRIDGE] (channel is hungup already)
  1274. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/5001@10.10.0.37:5060) State DESTROY
  1275. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:343 sofia/internal/5001@10.10.0.37:5060 SOFIA DESTROY
  1276. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:181 sofia/internal/5001@10.10.0.37:5060 Standard DESTROY
  1277. 5f3e9751 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/5001@10.10.0.37:5060) State DESTROY going to sleep
  1278. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_media.c:9780 sofia/internal/2201@10.10.0.34:5060 skip receive message [HARD_MUTE] (channel is hungup already)
  1279. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_codec.c:248 sofia/internal/2201@10.10.0.34:5060 Restore previous codec PCMU:0.
  1280. 2018-07-20 12:55:20.032219 [DEBUG] mod_conference.c:791 Write Lock OFF
  1281. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:2815 sofia/internal/2201@10.10.0.34:5060 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  1282. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:650 (sofia/internal/2201@10.10.0.34:5060) State EXECUTE going to sleep
  1283. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/2201@10.10.0.34:5060) Running State Change CS_HANGUP (Cur 2 Tot 7)
  1284. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/2201@10.10.0.34:5060) Callstate Change ACTIVE -> HANGUP
  1285. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/internal/3001@10.10.0.201
  1286. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/2201@10.10.0.34:5060) State HANGUP
  1287. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:60 sofia/internal/3001@10.10.0.201 Standard HANGUP, cause: NORMAL_CLEARING
  1288. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/3001@10.10.0.201) State HANGUP going to sleep
  1289. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:438 Channel sofia/internal/2201@10.10.0.34:5060 hanging up, cause: NORMAL_CLEARING
  1290. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/3001@10.10.0.201) State Change CS_HANGUP -> CS_REPORTING
  1291. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/3001@10.10.0.201) Running State Change CS_REPORTING (Cur 2 Tot 7)
  1292. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/3001@10.10.0.201) State REPORTING
  1293. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:174 sofia/internal/3001@10.10.0.201 Standard REPORTING, cause: NORMAL_CLEARING
  1294. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/3001@10.10.0.201) State REPORTING going to sleep
  1295. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/3001@10.10.0.201) State Change CS_REPORTING -> CS_DESTROY
  1296. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:1665 Session 5 (sofia/internal/3001@10.10.0.201) Locked, Waiting on external entities
  1297. f5d2f201 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1683 Session 5 (sofia/internal/3001@10.10.0.201) Ended
  1298. f5d2f201 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/3001@10.10.0.201 [CS_DESTROY]
  1299. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/3001@10.10.0.201) Running State Change CS_DESTROY (Cur 1 Tot 7)
  1300. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:491 Sending BYE to sofia/internal/2201@10.10.0.34:5060
  1301. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/3001@10.10.0.201) State DESTROY
  1302. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:343 sofia/internal/3001@10.10.0.201 SOFIA DESTROY
  1303. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:60 sofia/internal/2201@10.10.0.34:5060 Standard HANGUP, cause: NORMAL_CLEARING
  1304. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:852 (sofia/internal/2201@10.10.0.34:5060) State HANGUP going to sleep
  1305. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:181 sofia/internal/3001@10.10.0.201 Standard DESTROY
  1306. f5d2f201 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/3001@10.10.0.201) State DESTROY going to sleep
  1307. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:619 (sofia/internal/2201@10.10.0.34:5060) State Change CS_HANGUP -> CS_REPORTING
  1308. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:584 (sofia/internal/2201@10.10.0.34:5060) Running State Change CS_REPORTING (Cur 1 Tot 7)
  1309. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/2201@10.10.0.34:5060) State REPORTING
  1310. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:174 sofia/internal/2201@10.10.0.34:5060 Standard REPORTING, cause: NORMAL_CLEARING
  1311. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:938 (sofia/internal/2201@10.10.0.34:5060) State REPORTING going to sleep
  1312. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:610 (sofia/internal/2201@10.10.0.34:5060) State Change CS_REPORTING -> CS_DESTROY
  1313. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_session.c:1665 Session 7 (sofia/internal/2201@10.10.0.34:5060) Locked, Waiting on external entities
  1314. e10e6bbc 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1683 Session 7 (sofia/internal/2201@10.10.0.34:5060) Ended
  1315. e10e6bbc 2018-07-20 12:55:20.032219 [NOTICE] switch_core_session.c:1687 Close Channel sofia/internal/2201@10.10.0.34:5060 [CS_DESTROY]
  1316. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:741 (sofia/internal/2201@10.10.0.34:5060) Running State Change CS_DESTROY (Cur 0 Tot 7)
  1317. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/2201@10.10.0.34:5060) State DESTROY
  1318. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] mod_sofia.c:343 sofia/internal/2201@10.10.0.34:5060 SOFIA DESTROY
  1319. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:181 sofia/internal/2201@10.10.0.34:5060 Standard DESTROY
  1320. e10e6bbc 2018-07-20 12:55:20.032219 [DEBUG] switch_core_state_machine.c:751 (sofia/internal/2201@10.10.0.34:5060) State DESTROY going to sleep