1. v2v call - no media in prod
2.  
3. FS_CLI:
4.  
5. +OK log level  [7]
6. 2020-02-10 20:26:32.438738 [DEBUG] mod_verto.c:1415 READ 75.69.229.242:55707 [{
7.         "jsonrpc":      "2.0",
8.         "method":       "verto.invite",
9.         "params":       {
10.                 "sdp":  "v=0\r\no=- 5294435820167355833 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE audio\r\na=msid-semantic: WMS 73CZbHY19upuW80v0kyhdfNyDpN0ECx9MQY5\r\nm=audio 54872 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126\r\nc=IN IP4 75.69.229.242\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=candidate:2456471252 1 udp 2122260223 10.0.0.13 54872 typ host generation 0 network-id 1 network-cost 10\r\na=candidate:3504814172 1 udp 1686052607 75.69.229.242 54872 typ srflx raddr 10.0.0.13 rport 54872 generation 0 network-id 1 network-cost 10\r\na=candidate:3706272292 1 tcp 1518280447 10.0.0.13 9 typ host tcptype active generation 0 network-id 1 network-cost 10\r\na=ice-ufrag:7EfF\r\na=ice-pwd:Z8WH62o+Yhj+iqbOdIAapNpG\r\na=ice-options:trickle\r\na=fingerprint:sha-256 24:84:49:A3:18:F7:CC:BC:72:5D:72:3D:14:B4:79:B8:F4:70:76:51:86:9E:11:CD:A8:FE:CD:50:33:D5:BA:90\r\na=setup:actpass\r\na=mid:audio\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=sendrecv\r\na=rtcp-mux\r\na=rtpmap:111 opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111 minptime=10;useinbandfec=1; stereo=1; sprop-stereo=1\r\na=rtpmap:103 ISAC/16000\r\na=rtpmap:104 ISAC/32000\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:106 CN/32000\r\na=rtpmap:105 CN/16000\r\na=rtpmap:13 CN/8000\r\na=rtpmap:110 telephone-event/48000\r\na=rtpmap:112 telephone-event/32000\r\na=rtpmap:113 telephone-event/16000\r\na=rtpmap:126 telephone-event/8000\r\na=ssrc:3135906121 cname:4sygjsSsqgZzYttl\r\na=ssrc:3135906121 msid:73CZbHY19upuW80v0kyhdfNyDpN0ECx9MQY5 262eeec0-fe95-472a-b579-03389273d351\r\na=ssrc:3135906121 mslabel:73CZbHY19upuW80v0kyhdfNyDpN0ECx9MQY5\r\na=ssrc:3135906121 label:262eeec0-fe95-472a-b579-03389273d351\r\n",
11.                 "dialogParams": {
12.                         "useVideo":     false,
13.                         "useStereo":    true,
14.                         "screenShare":  false,
15.                         "useCamera":    "f76590a55f1c1fd642aae28210b44ba4e366d3e0ec613d8860358fe0bb9ff58c",
16.                         "useMic":       "default",
17.                         "useSpeak":     "default",
18.                         "tag":  "webcam",
19.                         "localTag":     null,
20.                         "login":        "2201@pbx.performityinctest.com",
21.                         "videoParams":  {
22.                                 "minWidth":     1280,
23.                                 "minHeight":    720,
24.                                 "maxWidth":     1280,
25.                                 "maxHeight":    720,
26.                                 "minFrameRate": 15
27.                         },
28.                         "useStream":    null,
29.                         "destination_number":   "2001",
30.                         "caller_id_name":       "Bennett Malbon",
31.                         "caller_id_number":     "bennett.malbon@gmail.com",
32.                         "outgoingBandwidth":    4377,
33.                         "incomingBandwidth":    null,
34.                         "dedEnc":       false,
35.                         "mirrorInput":  false,
36.                         "userVariables":        {
37.                                 "email":        "bennett.malbon@gmail.com",
38.                                 "avatar":       "http://gravatar.com/avatar/9264cd2d9ebc0d7d78c2c73b39a5c176.png?s=600"
39.                         },
40.                         "callID":       "3d4878b9-8f16-5a58-feee-a300d1e8e84c",
41.                         "remote_caller_id_name":        "Outbound Call",
42.                         "remote_caller_id_number":      "2001"
43.                 },
44.                 "sessid":       "cc7e3c7a-d037-28b6-6743-6775eeb505a8"
45.         },
46.         "id":   16
47. }]
48. 2020-02-10 20:26:32.438738 [DEBUG] mod_rtc.c:390 () State Change CS_NEW -> CS_INIT
49. 2020-02-10 20:26:32.438738 [DEBUG] switch_core_session.c:641 N/A set UUID=3d4878b9-8f16-5a58-feee-a300d1e8e84c
50. 2020-02-10 20:26:32.438738 [NOTICE] switch_channel.c:1118 New Channel verto.rtc/2001 [3d4878b9-8f16-5a58-feee-a300d1e8e84c]
51. 2020-02-10 20:26:32.438738 [DEBUG] mod_verto.c:3797 Remote SDP verto.rtc/2001:
52. v=0
53. o=- 5294435820167355833 2 IN IP4 127.0.0.1
54. s=-
55. t=0 0
56. a=group:BUNDLE audio
57. a=msid-semantic: WMS 73CZbHY19upuW80v0kyhdfNyDpN0ECx9MQY5
58. m=audio 54872 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
59. c=IN IP4 75.69.229.242
60. a=rtcp:9 IN IP4 0.0.0.0
61. a=candidate:2456471252 1 udp 2122260223 10.0.0.13 54872 typ host generation 0 network-id 1 network-cost 10
62. a=candidate:3504814172 1 udp 1686052607 75.69.229.242 54872 typ srflx raddr 10.0.0.13 rport 54872 generation 0 network-id 1 network-cost 10
63. a=candidate:3706272292 1 tcp 1518280447 10.0.0.13 9 typ host tcptype active generation 0 network-id 1 network-cost 10
64. a=ice-ufrag:7EfF
65. a=ice-pwd:Z8WH62o+Yhj+iqbOdIAapNpG
66. a=ice-options:trickle
67. a=fingerprint:sha-256 24:84:49:A3:18:F7:CC:BC:72:5D:72:3D:14:B4:79:B8:F4:70:76:51:86:9E:11:CD:A8:FE:CD:50:33:D5:BA:90
68. a=setup:actpass
69. a=mid:audio
70. a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
71. a=extmap:2 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
72. a=extmap:3 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
73. a=sendrecv
74. a=rtcp-mux
75. a=rtpmap:111 opus/48000/2
76. a=rtcp-fb:111 transport-cc
77. a=fmtp:111 minptime=10;useinbandfec=1; stereo=1; sprop-stereo=1
78. a=rtpmap:103 ISAC/16000
79. a=rtpmap:104 ISAC/32000
80. a=rtpmap:9 G722/8000
81. a=rtpmap:0 PCMU/8000
82. a=rtpmap:8 PCMA/8000
83. a=rtpmap:106 CN/32000
84. a=rtpmap:105 CN/16000
85. a=rtpmap:13 CN/8000
86. a=rtpmap:110 telephone-event/48000
87. a=rtpmap:112 telephone-event/32000
88. a=rtpmap:113 telephone-event/16000
89. a=rtpmap:126 telephone-event/8000
90. a=ssrc:3135906121 cname:4sygjsSsqgZzYttl
91. a=ssrc:3135906121 msid:73CZbHY19upuW80v0kyhdfNyDpN0ECx9MQY5 262eeec0-fe95-472a-b579-03389273d351
92. a=ssrc:3135906121 mslabel:73CZbHY19upuW80v0kyhdfNyDpN0ECx9MQY5
93. a=ssrc:3135906121 label:262eeec0-fe95-472a-b579-03389273d351
94.  
95. 2020-02-10 20:26:32.438738 [DEBUG] mod_verto.c:607 WRITE 75.69.229.242:55707 [{
96.         "jsonrpc":      "2.0",
97.         "id":   16,
98.         "result":       {
99.                 "message":      "CALL CREATED",
100.                 "callID":       "3d4878b9-8f16-5a58-feee-a300d1e8e84c",
101.                 "sessid":       "cc7e3c7a-d037-28b6-6743-6775eeb505a8"
102.         }
103. }]
104. 2020-02-10 20:26:32.438738 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/2001) Running State Change CS_INIT (Cur 1 Tot 25)
105. 2020-02-10 20:26:32.438738 [DEBUG] switch_core_state_machine.c:628 (verto.rtc/2001) State INIT
106. 2020-02-10 20:26:32.438738 [DEBUG] switch_core_state_machine.c:40 verto.rtc/2001 Standard INIT
107. 2020-02-10 20:26:32.438738 [DEBUG] switch_core_state_machine.c:48 (verto.rtc/2001) State Change CS_INIT -> CS_ROUTING
108. 2020-02-10 20:26:32.438738 [DEBUG] switch_core_state_machine.c:628 (verto.rtc/2001) State INIT going to sleep
109. 2020-02-10 20:26:32.438738 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/2001) Running State Change CS_ROUTING (Cur 1 Tot 25)
110. 2020-02-10 20:26:32.438738 [DEBUG] switch_channel.c:2332 (verto.rtc/2001) Callstate Change DOWN -> RINGING
111. 2020-02-10 20:26:32.438738 [DEBUG] switch_core_state_machine.c:644 (verto.rtc/2001) State ROUTING
112. 2020-02-10 20:26:32.438738 [DEBUG] mod_rtc.c:89 verto.rtc/2001 RTC ROUTING
113. 2020-02-10 20:26:32.438738 [DEBUG] switch_core_state_machine.c:236 verto.rtc/2001 Standard ROUTING
114. 2020-02-10 20:26:32.438738 [INFO] mod_dialplan_xml.c:637 Processing Bennett Malbon <bennett.malbon@gmail.com>->2001 in context pbx.performityinctest.com
115. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->user_exists] continue=true
116. Dialplan: verto.rtc/2001 Regex (PASS) [user_exists] () =~ // break=on-false
117. Dialplan: verto.rtc/2001 Action set(user_exists=${user_exists id ${destination_number} ${domain_name}}) INLINE
118. EXECUTE [depth=0] verto.rtc/2001 set(user_exists=true)
119. 2020-02-10 20:26:32.438738 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [user_exists]=[true]
120. Dialplan: verto.rtc/2001 Action set(from_user_exists=${user_exists id ${sip_from_user} ${sip_from_host}}) INLINE
121. EXECUTE [depth=0] verto.rtc/2001 set(from_user_exists=false)
122. 2020-02-10 20:26:32.438738 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [from_user_exists]=[false]
123. Dialplan: verto.rtc/2001 Regex (PASS) [user_exists] ${user_exists}(true) =~ /^true$/ break=on-false
124. Dialplan: verto.rtc/2001 Action set(extension_uuid=${user_data ${destination_number}@${domain_name} var extension_uuid}) INLINE
125. EXECUTE [depth=0] verto.rtc/2001 set(extension_uuid=cb74a4f9-f557-4e2f-82e9-b822ea00185c)
126. 2020-02-10 20:26:32.438738 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [extension_uuid]=[cb74a4f9-f557-4e2f-82e9-b822ea00185c]
127. Dialplan: verto.rtc/2001 Action set(hold_music=${user_data ${destination_number}@${domain_name} var hold_music}) INLINE
128. EXECUTE [depth=0] verto.rtc/2001 set(hold_music=)
129. 2020-02-10 20:26:32.458742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [hold_music]=[UNDEF]
130. Dialplan: verto.rtc/2001 Action set(forward_all_enabled=${user_data ${destination_number}@${domain_name} var forward_all_enabled}) INLINE
131. EXECUTE [depth=0] verto.rtc/2001 set(forward_all_enabled=)
132. 2020-02-10 20:26:32.458742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [forward_all_enabled]=[UNDEF]
133. Dialplan: verto.rtc/2001 Action set(forward_all_destination=${user_data ${destination_number}@${domain_name} var forward_all_destination}) INLINE
134. EXECUTE [depth=0] verto.rtc/2001 set(forward_all_destination=)
135. 2020-02-10 20:26:32.458742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [forward_all_destination]=[UNDEF]
136. Dialplan: verto.rtc/2001 Action set(forward_busy_enabled=${user_data ${destination_number}@${domain_name} var forward_busy_enabled}) INLINE
137. EXECUTE [depth=0] verto.rtc/2001 set(forward_busy_enabled=)
138. 2020-02-10 20:26:32.458742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [forward_busy_enabled]=[UNDEF]
139. Dialplan: verto.rtc/2001 Action set(forward_busy_destination=${user_data ${destination_number}@${domain_name} var forward_busy_destination}) INLINE
140. EXECUTE [depth=0] verto.rtc/2001 set(forward_busy_destination=)
141. 2020-02-10 20:26:32.458742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [forward_busy_destination]=[UNDEF]
142. Dialplan: verto.rtc/2001 Action set(forward_no_answer_enabled=${user_data ${destination_number}@${domain_name} var forward_no_answer_enabled}) INLINE
143. EXECUTE [depth=0] verto.rtc/2001 set(forward_no_answer_enabled=)
144. 2020-02-10 20:26:32.458742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [forward_no_answer_enabled]=[UNDEF]
145. Dialplan: verto.rtc/2001 Action set(forward_no_answer_destination=${user_data ${destination_number}@${domain_name} var forward_no_answer_destination}) INLINE
146. EXECUTE [depth=0] verto.rtc/2001 set(forward_no_answer_destination=)
147. 2020-02-10 20:26:32.458742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [forward_no_answer_destination]=[UNDEF]
148. Dialplan: verto.rtc/2001 Action set(forward_user_not_registered_enabled=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_enabled}) INLINE
149. EXECUTE [depth=0] verto.rtc/2001 set(forward_user_not_registered_enabled=)
150. 2020-02-10 20:26:32.478742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [forward_user_not_registered_enabled]=[UNDEF]
151. Dialplan: verto.rtc/2001 Action set(forward_user_not_registered_destination=${user_data ${destination_number}@${domain_name} var forward_user_not_registered_destination}) INLINE
152. EXECUTE [depth=0] verto.rtc/2001 set(forward_user_not_registered_destination=)
153. 2020-02-10 20:26:32.478742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [forward_user_not_registered_destination]=[UNDEF]
154. Dialplan: verto.rtc/2001 Action set(forward_all_enabled=${user_data ${destination_number}@${domain_name} var forward_all_enabled}) INLINE
155. EXECUTE [depth=0] verto.rtc/2001 set(forward_all_enabled=)
156. 2020-02-10 20:26:32.478742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [forward_all_enabled]=[UNDEF]
157. Dialplan: verto.rtc/2001 Action set(follow_me_enabled=${user_data ${destination_number}@${domain_name} var follow_me_enabled}) INLINE
158. EXECUTE [depth=0] verto.rtc/2001 set(follow_me_enabled=)
159. 2020-02-10 20:26:32.478742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [follow_me_enabled]=[UNDEF]
160. Dialplan: verto.rtc/2001 Action set(do_not_disturb=${user_data ${destination_number}@${domain_name} var do_not_disturb}) INLINE
161. EXECUTE [depth=0] verto.rtc/2001 set(do_not_disturb=)
162. 2020-02-10 20:26:32.478742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [do_not_disturb]=[UNDEF]
163. Dialplan: verto.rtc/2001 Action set(call_timeout=${user_data ${destination_number}@${domain_name} var call_timeout}) INLINE
164. EXECUTE [depth=0] verto.rtc/2001 set(call_timeout=30)
165. 2020-02-10 20:26:32.478742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [call_timeout]=[30]
166. Dialplan: verto.rtc/2001 Action set(missed_call_app=${user_data ${destination_number}@${domain_name} var missed_call_app}) INLINE
167. EXECUTE [depth=0] verto.rtc/2001 set(missed_call_app=)
168. 2020-02-10 20:26:32.478742 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [missed_call_app]=[UNDEF]
169. Dialplan: verto.rtc/2001 Action set(missed_call_data=${user_data ${destination_number}@${domain_name} var missed_call_data}) INLINE
170. EXECUTE [depth=0] verto.rtc/2001 set(missed_call_data=)
171. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [missed_call_data]=[UNDEF]
172. Dialplan: verto.rtc/2001 Action set(toll_allow=${user_data ${destination_number}@${domain_name} var toll_allow}) INLINE
173. EXECUTE [depth=0] verto.rtc/2001 set(toll_allow=)
174. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [toll_allow]=[UNDEF]
175. Dialplan: verto.rtc/2001 Action set(call_screen_enabled=${user_data ${destination_number}@${domain_name} var call_screen_enabled}) INLINE
176. EXECUTE [depth=0] verto.rtc/2001 set(call_screen_enabled=false)
177. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [call_screen_enabled]=[false]
178. Dialplan: verto.rtc/2001 Action set(user_record=${user_data ${destination_number}@${domain_name} var user_record}) INLINE
179. EXECUTE [depth=0] verto.rtc/2001 set(user_record=)
180. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [user_record]=[UNDEF]
181. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->caller-details] continue=true
182. Dialplan: verto.rtc/2001 Regex (PASS) [caller-details] ${caller_destination}() =~ /^$/ break=never
183. Dialplan: verto.rtc/2001 Action set(caller_destination=${destination_number}) INLINE
184. EXECUTE [depth=0] verto.rtc/2001 set(caller_destination=2001)
185. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [caller_destination]=[2001]
186. Dialplan: verto.rtc/2001 Action set(caller_id_name=${caller_id_name}) INLINE
187. EXECUTE [depth=0] verto.rtc/2001 set(caller_id_name=2201)
188. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [caller_id_name]=[2201]
189. Dialplan: verto.rtc/2001 Action set(caller_id_number=${caller_id_number})
190. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->call-direction] continue=true
191. Dialplan: verto.rtc/2001 Regex (FAIL) [call-direction] ${call_direction}() =~ /^(inbound|outbound|local)$/ break=never
192. Dialplan: verto.rtc/2001 ANTI-Action export(call_direction=local) INLINE
193. EXECUTE [depth=0] verto.rtc/2001 export(call_direction=local)
194. 2020-02-10 20:26:32.498741 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [call_direction]=[local]
195. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->variables] continue=true
196. Dialplan: verto.rtc/2001 Regex (PASS) [variables] () =~ // break=on-false
197. Dialplan: verto.rtc/2001 Action export(origination_callee_id_name=${destination_number})
198. Dialplan: verto.rtc/2001 Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)})
199. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->is_loopback] continue=true
200. Dialplan: verto.rtc/2001 Regex (FAIL) [is_loopback] ${is_follow_me_loopback}() =~ /true/ break=on-false
201. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->user_record] continue=true
202. Dialplan: verto.rtc/2001 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
203. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${user_record}() =~ /^all$/ break=never
204. Dialplan: verto.rtc/2001 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
205. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
206. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${user_record}() =~ /^inbound$/ break=never
207. Dialplan: verto.rtc/2001 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
208. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
209. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${user_record}() =~ /^outbound$/ break=never
210. Dialplan: verto.rtc/2001 Regex (PASS) [user_record] ${user_exists}(true) =~ /^true$/ break=never
211. Dialplan: verto.rtc/2001 Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
212. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${user_record}() =~ /^local$/ break=never
213. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
214. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
215. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${from_user_record}() =~ /^all$/ break=never
216. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
217. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${call_direction}(local) =~ /^inbound$/ break=never
218. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${from_user_record}() =~ /^inbound$/ break=never
219. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
220. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${call_direction}(local) =~ /^outbound$/ break=never
221. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${from_user_record}() =~ /^outbound$/ break=never
222. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${from_user_exists}(false) =~ /^true$/ break=never
223. Dialplan: verto.rtc/2001 Regex (PASS) [user_record] ${call_direction}(local) =~ /^local$/ break=never
224. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${from_user_record}() =~ /^local$/ break=never
225. Dialplan: verto.rtc/2001 Regex (FAIL) [user_record] ${record_session}() =~ /^true$/ break=on-false
226. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->redial] continue=true
227. Dialplan: verto.rtc/2001 Regex (FAIL) [redial] destination_number(2001) =~ /^(redial|\*870)$/ break=on-true
228. Dialplan: verto.rtc/2001 Regex (PASS) [redial] () =~ // break=never
229. Dialplan: verto.rtc/2001 Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number})
230. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->speed_dial] continue=false
231. Dialplan: verto.rtc/2001 Regex (FAIL) [speed_dial] destination_number(2001) =~ /^\*0(.*)$/ break=on-false
232. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->default_caller_id] continue=true
233. Dialplan: verto.rtc/2001 Regex (PASS) [default_caller_id] ${emergency_caller_id_number}() =~ /^$/ break=never
234. Dialplan: verto.rtc/2001 Action set(emergency_caller_id_name=${default_emergency_caller_id_name}) INLINE
235. EXECUTE [depth=0] verto.rtc/2001 set(emergency_caller_id_name=)
236. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [emergency_caller_id_name]=[UNDEF]
237. Dialplan: verto.rtc/2001 Action set(emergency_caller_id_number=${default_emergency_caller_id_number}) INLINE
238. EXECUTE [depth=0] verto.rtc/2001 set(emergency_caller_id_number=)
239. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [emergency_caller_id_number]=[UNDEF]
240. Dialplan: verto.rtc/2001 Regex (PASS) [default_caller_id] ${outbound_caller_id_number}() =~ /^$/ break=never
241. Dialplan: verto.rtc/2001 Action set(outbound_caller_id_name=${default_outbound_caller_id_name}) INLINE
242. EXECUTE [depth=0] verto.rtc/2001 set(outbound_caller_id_name=)
243. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [outbound_caller_id_name]=[UNDEF]
244. Dialplan: verto.rtc/2001 Action set(outbound_caller_id_number=${default_outbound_caller_id_number}) INLINE
245. EXECUTE [depth=0] verto.rtc/2001 set(outbound_caller_id_number=)
246. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [outbound_caller_id_number]=[UNDEF]
247. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->Cisco.PRI] continue=false
248. Dialplan: verto.rtc/2001 Regex (FAIL) [Cisco.PRI] ${user_exists}(true) =~ /false/ break=on-false
249. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->Cisco.d4] continue=false
250. Dialplan: verto.rtc/2001 Regex (FAIL) [Cisco.d4] ${user_exists}(true) =~ /false/ break=on-false
251. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->verto_screen_share] continue=false
252. Dialplan: verto.rtc/2001 Regex (FAIL) [verto_screen_share] destination_number(2001) =~ /^(\d+)-screen$/ break=on-false
253. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->agent_status] continue=false
254. Dialplan: verto.rtc/2001 Regex (FAIL) [agent_status] destination_number(2001) =~ /^\*22$/ break=never
255. Dialplan: verto.rtc/2001 Regex (FAIL) [agent_status] destination_number(2001) =~ /^(agent\+)(.*)$/ break=on-false
256. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->agent_status_id] continue=false
257. Dialplan: verto.rtc/2001 Regex (FAIL) [agent_status_id] destination_number(2001) =~ /^\*23$/ break=on-false
258. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->TestQue] continue=
259. Dialplan: verto.rtc/2001 Regex (FAIL) [TestQue] destination_number(2001) =~ /^([^#]+#)(.*)$/ break=never
260. Dialplan: verto.rtc/2001 Regex (FAIL) [TestQue] destination_number(2001) =~ /^3003$/ break=on-false
261. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->group-intercept] continue=false
262. Dialplan: verto.rtc/2001 Regex (FAIL) [group-intercept] destination_number(2001) =~ /^\*8$/ break=on-false
263. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->page-extension] continue=false
264. Dialplan: verto.rtc/2001 Regex (FAIL) [page-extension] destination_number(2001) =~ /^\*8(\d{2,7})$/ break=on-false
265. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->eavesdrop] continue=false
266. Dialplan: verto.rtc/2001 Regex (FAIL) [eavesdrop] destination_number(2001) =~ /^\*33(\d{2,7})$/ break=on-false
267. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->call_privacy] continue=false
268. Dialplan: verto.rtc/2001 Regex (FAIL) [call_privacy] destination_number(2001) =~ /^\*67(\d+)$/ break=on-false
269. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->call_return] continue=false
270. Dialplan: verto.rtc/2001 Regex (FAIL) [call_return] destination_number(2001) =~ /^\*69$/ break=on-false
271. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->intercept-ext-polycom] continue=false
272. Dialplan: verto.rtc/2001 Regex (FAIL) [intercept-ext-polycom] destination_number(2001) =~ /^\*97(\d+)$/ break=on-false
273. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->extension_queue] continue=false
274. Dialplan: verto.rtc/2001 Regex (FAIL) [extension_queue] destination_number(2001) =~ /^\*800(.*)$/ break=on-false
275. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->intercept-ext] continue=false
276. Dialplan: verto.rtc/2001 Regex (FAIL) [intercept-ext] destination_number(2001) =~ /^\*\*(\d+)$/ break=on-true
277. Dialplan: verto.rtc/2001 Regex (FAIL) [intercept-ext] destination_number(2001) =~ /^\*\*$/ break=on-false
278. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->dx] continue=false
279. Dialplan: verto.rtc/2001 Regex (FAIL) [dx] destination_number(2001) =~ /^dx$/ break=on-false
280. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->send_to_voicemail] continue=false
281. Dialplan: verto.rtc/2001 Regex (FAIL) [send_to_voicemail] destination_number(2001) =~ /^\*99(\d{2,10})$/ break=on-false
282. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->extension-to-voicemail] continue=false
283. Dialplan: verto.rtc/2001 Regex (PASS) [extension-to-voicemail] ${user_exists}(true) =~ /^true$/ break=on-false
284. Dialplan: verto.rtc/2001 Regex (FAIL) [extension-to-voicemail] username(2201@pbx.performityinctest.com) =~ /^2201$/ break=on-false
285. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->att_xfer] continue=false
286. Dialplan: verto.rtc/2001 Regex (FAIL) [att_xfer] destination_number(2001) =~ /^att_xfer$/ break=on-false
287. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->xfer_vm] continue=false
288. Dialplan: verto.rtc/2001 Regex (FAIL) [xfer_vm] destination_number(2001) =~ /^xfer_vm$/ break=on-false
289. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->vmain] continue=false
290. Dialplan: verto.rtc/2001 Regex (FAIL) [vmain] destination_number(2001) =~ /^vmain$|^\*4000$|^\*98$/ break=never
291. Dialplan: verto.rtc/2001 Regex (FAIL) [vmain] destination_number(2001) =~ /^(vmain$|^\*4000$|^\*98)(\d{2,12})$/ break=on-false
292. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->vmain_user] continue=false
293. Dialplan: verto.rtc/2001 Regex (FAIL) [vmain_user] destination_number(2001) =~ /^\*97$/ break=on-false
294. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->is_transfer] continue=false
295. Dialplan: verto.rtc/2001 Regex (FAIL) [is_transfer] destination_number(2001) =~ /^is_transfer$/ break=on-false
296. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->delay_echo] continue=false
297. Dialplan: verto.rtc/2001 Regex (FAIL) [delay_echo] destination_number(2001) =~ /^\*9195$/ break=on-false
298. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->cf] continue=false
299. Dialplan: verto.rtc/2001 Regex (FAIL) [cf] destination_number(2001) =~ /^cf$/ break=on-false
300. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->echo] continue=false
301. Dialplan: verto.rtc/2001 Regex (FAIL) [echo] destination_number(2001) =~ /^\*9196$/ break=on-false
302. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->is_zrtp_secure] continue=true
303. Dialplan: verto.rtc/2001 Regex (FAIL) [is_zrtp_secure] ${zrtp_secure_media_confirmed}() =~ /^true$/ break=on-false
304. Dialplan: verto.rtc/2001 ANTI-Action eval(not_secure)
305. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->milliwatt] continue=false
306. Dialplan: verto.rtc/2001 Regex (FAIL) [milliwatt] destination_number(2001) =~ /^\*9197$/ break=on-false
307. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->tone_stream] continue=false
308. Dialplan: verto.rtc/2001 Regex (FAIL) [tone_stream] destination_number(2001) =~ /^\*9198$/ break=on-false
309. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->is_secure] continue=true
310. Dialplan: verto.rtc/2001 Regex (FAIL) [is_secure] ${sip_via_protocol}() =~ /tls/ break=on-false
311. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->hold_music] continue=false
312. Dialplan: verto.rtc/2001 Regex (FAIL) [hold_music] destination_number(2001) =~ /^\*9664$/ break=on-false
313. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->recordings] continue=false
314. Dialplan: verto.rtc/2001 Regex (FAIL) [recordings] destination_number(2001) =~ /^\*(732)$/ break=on-false
315. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->directory] continue=false
316. Dialplan: verto.rtc/2001 Regex (FAIL) [directory] destination_number(2001) =~ /^\*411$/ break=on-false
317. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->wake-up] continue=false
318. Dialplan: verto.rtc/2001 Regex (FAIL) [wake-up] destination_number(2001) =~ /^\*(925)$/ break=on-false
319. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->valet_park] continue=false
320. Dialplan: verto.rtc/2001 Regex (FAIL) [valet_park] destination_number(2001) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
321. Dialplan: verto.rtc/2001 Regex (FAIL) [valet_park] ${sip_h_Referred-By}() =~ /sip:(.*)@.*/ break=never
322. Dialplan: verto.rtc/2001 Regex (FAIL) [valet_park] destination_number(2001) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=never
323. Dialplan: verto.rtc/2001 Regex (FAIL) [valet_park] destination_number(2001) =~ /^(park\+)?\*(59[0-9][0-9])$/ break=on-false
324. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->operator] continue=false
325. Dialplan: verto.rtc/2001 Regex (FAIL) [operator] destination_number(2001) =~ /^0$|^operator$/ break=on-false
326. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->operator-forward] continue=false
327. Dialplan: verto.rtc/2001 Regex (FAIL) [operator-forward] destination_number(2001) =~ /^\*000$/ break=on-false
328. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->do-not-disturb] continue=false
329. Dialplan: verto.rtc/2001 Regex (FAIL) [do-not-disturb] destination_number(2001) =~ /^\*77$/ break=on-true
330. Dialplan: verto.rtc/2001 Regex (FAIL) [do-not-disturb] destination_number(2001) =~ /^\*78$|\*363$/ break=on-true
331. Dialplan: verto.rtc/2001 Regex (FAIL) [do-not-disturb] destination_number(2001) =~ /^\*79$/ break=on-true
332. Dialplan: verto.rtc/2001 Regex (FAIL) [do-not-disturb] destination_number(2001) =~ /^dnd\+2201$/ break=on-true
333. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->call_screen] continue=true
334. Dialplan: verto.rtc/2001 Regex (FAIL) [call_screen] ${call_screen_enabled}(false) =~ /^true$/ break=on-false
335. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->follow-me-destinations] continue=false
336. Dialplan: verto.rtc/2001 Regex (PASS) [follow-me-destinations] ${user_exists}(true) =~ /^true$/ break=on-false
337. Dialplan: verto.rtc/2001 Regex (FAIL) [follow-me-destinations] ${follow_me_enabled}() =~ /^true$/ break=on-false
338. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->call-forward] continue=false
339. Dialplan: verto.rtc/2001 Regex (FAIL) [call-forward] destination_number(2001) =~ /^\*72(\d*)$/ break=on-true
340. Dialplan: verto.rtc/2001 Regex (FAIL) [call-forward] destination_number(2001) =~ /^\*73$/ break=on-true
341. Dialplan: verto.rtc/2001 Regex (FAIL) [call-forward] destination_number(2001) =~ /^\*74$/ break=on-true
342. Dialplan: verto.rtc/2001 Regex (FAIL) [call-forward] destination_number(2001) =~ /^forward\+(\Q2201\E)(?:\/(\d+))?$/ break=on-true
343. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->call forward all] continue=false
344. Dialplan: verto.rtc/2001 Regex (PASS) [call forward all] ${user_exists}(true) =~ /true/ break=on-false
345. Dialplan: verto.rtc/2001 Regex (FAIL) [call forward all] ${forward_all_enabled}() =~ /true/ break=on-false
346. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->call forward not registered] continue=false
347. Dialplan: verto.rtc/2001 Regex (PASS) [call forward not registered] ${user_exists}(true) =~ /true/ break=on-false
348. Dialplan: verto.rtc/2001 Regex (FAIL) [call forward not registered] ${forward_user_not_registered_enabled}() =~ /true/ break=on-false
349. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->follow-me] continue=false
350. Dialplan: verto.rtc/2001 Regex (FAIL) [follow-me] destination_number(2001) =~ /^\*21$/ break=on-false
351. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->talking clock date and time] continue=true
352. Dialplan: verto.rtc/2001 Regex (FAIL) [talking clock date and time] destination_number(2001) =~ /^\*9172$/ break=on-false
353. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->clear_sip_auto_answer] continue=true
354. Dialplan: verto.rtc/2001 Regex (FAIL) [clear_sip_auto_answer] ${click_to_call}() =~ /true/ break=on-false
355. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->talking clock time] continue=true
356. Dialplan: verto.rtc/2001 Regex (FAIL) [talking clock time] destination_number(2001) =~ /^\*9170$/ break=on-false
357. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->talking clock date] continue=true
358. Dialplan: verto.rtc/2001 Regex (FAIL) [talking clock date] destination_number(2001) =~ /^\*9171$/ break=on-false
359. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->local_extension] continue=true
360. Dialplan: verto.rtc/2001 Regex (PASS) [local_extension] ${user_exists}(true) =~ /true/ break=on-false
361. Dialplan: verto.rtc/2001 Action export(dialed_extension=${destination_number}) INLINE
362. EXECUTE [depth=0] verto.rtc/2001 export(dialed_extension=2001)
363. 2020-02-10 20:26:32.498741 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [dialed_extension]=[2001]
364. Dialplan: verto.rtc/2001 Action limit(hash ${domain_name} ${destination_number} ${limit_max} ${limit_destination})
365. Dialplan: verto.rtc/2001 Regex (PASS) [local_extension] () =~ // break=on-false
366. Dialplan: verto.rtc/2001 Action set(hangup_after_bridge=true)
367. Dialplan: verto.rtc/2001 Action set(continue_on_fail=true)
368. Dialplan: verto.rtc/2001 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
369. Dialplan: verto.rtc/2001 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
370. Dialplan: verto.rtc/2001 Action set(called_party_call_group=${user_data(${dialed_extension}@${domain_name} var call_group)})
371. Dialplan: verto.rtc/2001 Action hash(insert/${domain_name}-last_dial/${called_party_call_group}/${uuid})
372. Dialplan: verto.rtc/2001 Action set(api_hangup_hook=lua app.lua hangup)
373. Dialplan: verto.rtc/2001 Action export(domain_name=${domain_name})
374. Dialplan: verto.rtc/2001 Action bridge(user/${destination_number}@${domain_name})
375. Dialplan: verto.rtc/2001 Action lua(app.lua failure_handler)
376. Dialplan: verto.rtc/2001 parsing [pbx.performityinctest.com->voicemail] continue=false
377. Dialplan: verto.rtc/2001 Regex (PASS) [voicemail] ${user_exists}(true) =~ /true/ break=on-false
378. Dialplan: verto.rtc/2001 Action set(record_append=false)
379. Dialplan: verto.rtc/2001 Action set(voicemail_action=save)
380. Dialplan: verto.rtc/2001 Action set(voicemail_id=${destination_number})
381. Dialplan: verto.rtc/2001 Action set(voicemail_profile=default)
382. Dialplan: verto.rtc/2001 Action lua(app.lua voicemail)
383. 2020-02-10 20:26:32.498741 [DEBUG] switch_core_state_machine.c:287 (verto.rtc/2001) State Change CS_ROUTING -> CS_EXECUTE
384. 2020-02-10 20:26:32.498741 [DEBUG] switch_core_state_machine.c:644 (verto.rtc/2001) State ROUTING going to sleep
385. 2020-02-10 20:26:32.498741 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/2001) Running State Change CS_EXECUTE (Cur 1 Tot 25)
386. 2020-02-10 20:26:32.498741 [DEBUG] switch_core_state_machine.c:651 (verto.rtc/2001) State EXECUTE
387. 2020-02-10 20:26:32.498741 [DEBUG] mod_rtc.c:120 verto.rtc/2001 RTC EXECUTE
388. 2020-02-10 20:26:32.498741 [DEBUG] switch_core_state_machine.c:329 verto.rtc/2001 Standard EXECUTE
389. EXECUTE [depth=0] verto.rtc/2001 set(caller_id_number=2201)
390. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [caller_id_number]=[2201]
391. EXECUTE [depth=0] verto.rtc/2001 export(origination_callee_id_name=2001)
392. 2020-02-10 20:26:32.498741 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [origination_callee_id_name]=[2001]
393. EXECUTE [depth=0] verto.rtc/2001 set(RFC2822_DATE=Mon, 10 Feb 2020 20:26:32 +0000)
394. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [RFC2822_DATE]=[Mon, 10 Feb 2020 20:26:32 +0000]
395. EXECUTE [depth=0] verto.rtc/2001 hash(insert/pbx.performityinctest.com-last_dial/2201/2001)
396. EXECUTE [depth=0] verto.rtc/2001 eval(not_secure)
397.  
398. EXECUTE [depth=0] verto.rtc/2001 limit(hash pbx.performityinctest.com 2001 5 error/user_busy)
399.  
400. 2020-02-10 20:26:32.498741 [DEBUG] switch_limit.c:124 incr called: pbx.performityinctest.com_2001 max:5, interval:0
401. 2020-02-10 20:26:32.498741 [DEBUG] mod_hash.c:196 Usage for pbx.performityinctest.com_2001 is now 1/5
402. EXECUTE [depth=0] verto.rtc/2001 set(hangup_after_bridge=true)
403. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [hangup_after_bridge]=[true]
404. EXECUTE [depth=0] verto.rtc/2001 set(continue_on_fail=true)
405. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [continue_on_fail]=[true]
406. EXECUTE [depth=0] verto.rtc/2001 hash(insert/pbx.performityinctest.com-call_return/2001/2201)
407. EXECUTE [depth=0] verto.rtc/2001 hash(insert/pbx.performityinctest.com-last_dial_ext/2001/3d4878b9-8f16-5a58-feee-a300d1e8e84c)
408. EXECUTE [depth=0] verto.rtc/2001 set(called_party_call_group=)
409. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [called_party_call_group]=[UNDEF]
410. EXECUTE [depth=0] verto.rtc/2001 hash(insert/pbx.performityinctest.com-last_dial//3d4878b9-8f16-5a58-feee-a300d1e8e84c)
411. EXECUTE [depth=0] verto.rtc/2001 set(api_hangup_hook=lua app.lua hangup)
412. 2020-02-10 20:26:32.498741 [DEBUG] mod_dptools.c:1672 SET verto.rtc/2001 [api_hangup_hook]=[lua app.lua hangup]
413. EXECUTE [depth=0] verto.rtc/2001 export(domain_name=pbx.performityinctest.com)
414. 2020-02-10 20:26:32.498741 [DEBUG] switch_channel.c:1310 EXPORT (export_vars) [domain_name]=[pbx.performityinctest.com]
415. EXECUTE [depth=0] verto.rtc/2001 bridge(user/2001@pbx.performityinctest.com)
416. 2020-02-10 20:26:32.498741 [DEBUG] switch_channel.c:1264 verto.rtc/2001 EXPORTING[export_vars] [domain_name]=[pbx.performityinctest.com] to event
417. 2020-02-10 20:26:32.498741 [DEBUG] switch_channel.c:1264 verto.rtc/2001 EXPORTING[export_vars] [call_direction]=[local] to event
418. 2020-02-10 20:26:32.498741 [DEBUG] switch_channel.c:1264 verto.rtc/2001 EXPORTING[export_vars] [dialed_extension]=[2001] to event
419. 2020-02-10 20:26:32.498741 [DEBUG] switch_channel.c:1264 verto.rtc/2001 EXPORTING[export_vars] [origination_callee_id_name]=[2001] to event
420. 2020-02-10 20:26:32.498741 [DEBUG] switch_channel.c:1264 verto.rtc/2001 EXPORTING[export_vars] [domain_name]=[pbx.performityinctest.com] to event
421. 2020-02-10 20:26:32.498741 [DEBUG] switch_ivr_originate.c:2212 Parsing global variables
422. 2020-02-10 20:26:32.518742 [DEBUG] switch_channel.c:1264 verto.rtc/2001 EXPORTING[export_vars] [domain_name]=[pbx.performityinctest.com] to event
423. 2020-02-10 20:26:32.518742 [DEBUG] switch_channel.c:1264 verto.rtc/2001 EXPORTING[export_vars] [call_direction]=[local] to event
424. 2020-02-10 20:26:32.518742 [DEBUG] switch_channel.c:1264 verto.rtc/2001 EXPORTING[export_vars] [dialed_extension]=[2001] to event
425. 2020-02-10 20:26:32.518742 [DEBUG] switch_channel.c:1264 verto.rtc/2001 EXPORTING[export_vars] [origination_callee_id_name]=[2001] to event
426. 2020-02-10 20:26:32.518742 [DEBUG] switch_channel.c:1264 verto.rtc/2001 EXPORTING[export_vars] [domain_name]=[pbx.performityinctest.com] to event
427. 2020-02-10 20:26:32.518742 [DEBUG] switch_ivr_originate.c:2212 Parsing global variables
428.  
429. 2020-02-10 20:26:32.518742 [NOTICE] switch_ivr_originate.c:2952 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
430.  
431.  *** NOTE: no 'originate failed', and both clients show call connected, just without media ***
432.  
433. 2020-02-10 20:26:32.518742 [DEBUG] mod_rtc.c:390 () State Change CS_NEW -> CS_INIT
434. 2020-02-10 20:26:32.518742 [NOTICE] switch_channel.c:1118 New Channel verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 [5d064648-18e8-4004-b4e6-bdda6cefa96f]
435.  
436. 2020-02-10 20:26:32.518742 [DEBUG] switch_ivr_originate.c:3064 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 Setting leg timeout to 30
437.  
438. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) Running State Change CS_INIT (Cur 2 Tot 26)
439. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_state_machine.c:628 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State INIT
440.  
441.  
442.  
443. ***
444. 2020-02-10 20:26:32.518742 [CRIT] switch_channel.c:1484 Invalid data (${advertised_media_ip} contains a variable)
445. 2020-02-10 20:26:32.518742 [CRIT] switch_channel.c:1484 Invalid data (${local_video_ip} contains a variable)
446. 2020-02-10 20:26:32.518742 [CRIT] switch_channel.c:1484 Invalid data (${rtp_local_sdp_str} contains a variable)
447. ***
448.  
449.  
450.  
451. 2020-02-10 20:26:32.518742 [DEBUG] mod_verto.c:2272 Local verto.invite SDP verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2:
452. v=0
453. o=FreeSWITCH 1581346272 1581346273 IN IP4 ${external_rtp_ip}
454. s=FreeSWITCH
455. c=IN IP4 ${external_rtp_ip}
456. t=0 0
457. a=msid-semantic: WMS GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q
458. m=audio 20120 RTP/SAVPF 102 9 0 8 103
459. a=rtpmap:102 opus/48000/2
460. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40; stereo=1
461. a=rtpmap:9 G722/8000
462. a=rtpmap:0 PCMU/8000
463. a=rtpmap:8 PCMA/8000
464. a=rtpmap:103 opus/48000/2
465. a=fmtp:103 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
466. a=fingerprint:sha-256 96:E9:38:23:96:4C:07:4E:61:4F:80:B7:05:E6:BE:BA:04:CA:F3:69:B6:90:E0:43:59:AD:F1:A9:4B:D1:57:C3
467. a=setup:actpass
468. a=rtcp-mux
469. a=rtcp:20120 IN IP4 ${external_rtp_ip}
470. a=ssrc:1380421024 cname:qTfDHrzty7XiZScD
471. a=ssrc:1380421024 msid:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q a0
472. a=ssrc:1380421024 mslabel:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q
473. a=ssrc:1380421024 label:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Qa0
474. a=ice-ufrag:lO7nNTWvTVZ3KUK1
475. a=ice-pwd:EQub7UvwRjFH2Ibdm8r0SdmC
476. a=candidate:3536908466 1 udp 659136 ${external_rtp_ip} 20120 typ host generation 0
477. a=candidate:3536908466 2 udp 659136 ${external_rtp_ip} 20120 typ host generation 0
478. a=silenceSupp:off - - - -
479. a=ptime:20
480. a=sendrecv
481. m=video 20122 RTP/SAVPF 104 105
482. b=AS:1024
483. a=rtpmap:104 VP8/90000
484. a=rtpmap:105 VP9/90000
485. a=sendrecv
486. a=fingerprint:sha-256 96:E9:38:23:96:4C:07:4E:61:4F:80:B7:05:E6:BE:BA:04:CA:F3:69:B6:90:E0:43:59:AD:F1:A9:4B:D1:57:C3
487. a=setup:actpass
488. a=rtcp-mux
489. a=rtcp:20122 IN IP4 ${external_rtp_ip}
490. a=rtcp-fb:104 ccm fir
491. a=rtcp-fb:104 ccm tmmbr
492. a=rtcp-fb:104 nack
493. a=rtcp-fb:104 nack pli
494. a=rtcp-fb:105 ccm fir
495. a=rtcp-fb:105 ccm tmmbr
496. a=rtcp-fb:105 nack
497. a=rtcp-fb:105 nack pli
498. a=ssrc:589759212 cname:qTfDHrzty7XiZScD
499. a=ssrc:589759212 msid:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q v0
500. a=ssrc:589759212 mslabel:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q
501. a=ssrc:589759212 label:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Qv0
502. a=ice-ufrag:nOqJsoNhRoYS1I6C
503. a=ice-pwd:KbWQrJLKQ7PUJaBXPSw76afN
504. a=candidate:7693262838 1 udp 659136 ${external_rtp_ip} 20122 typ host generation 0
505. a=candidate:7693262838 2 udp 659135 ${external_rtp_ip} 20122 typ host generation 0
506. a=end-of-candidates
507.  
508. 2020-02-10 20:26:32.518742 [NOTICE] mod_verto.c:2372 Ring-Ready verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2!
509. 2020-02-10 20:26:32.518742 [DEBUG] switch_channel.c:3437 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) Callstate Change DOWN -> RINGING
510. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_state_machine.c:40 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 Standard INIT
511. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_state_machine.c:48 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State Change CS_INIT -> CS_ROUTING
512. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_state_machine.c:628 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State INIT going to sleep
513. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) Running State Change CS_ROUTING (Cur 2 Tot 26)
514. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_state_machine.c:644 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State ROUTING
515. 2020-02-10 20:26:32.518742 [DEBUG] mod_rtc.c:89 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 RTC ROUTING
516. 2020-02-10 20:26:32.518742 [DEBUG] switch_ivr_originate.c:67 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State Change CS_ROUTING -> CS_CONSUME_MEDIA
517. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_state_machine.c:644 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State ROUTING going to sleep
518. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 26)
519. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [opus:111:48000:20:0:2]/[opus:116:48000:20:0:1]
520. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5645 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
521. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[opus:116:48000:20:0:1]
522. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[opus:116:48000:20:0:1]
523. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1]
524. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
525. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
526. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [CN:106:32000:20:0:1]/[opus:116:48000:20:0:1]
527. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [CN:105:16000:20:0:1]/[opus:116:48000:20:0:1]
528. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [CN:13:8000:20:0:1]/[opus:116:48000:20:0:1]
529. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5506 Set telephone-event payload to 110@48000
530. 2020-02-10 20:26:32.518742 [DEBUG] mod_opus.c:613 Opus encoder: set bitrate to local settings [120000bps]
531. 2020-02-10 20:26:32.518742 [DEBUG] mod_opus.c:613 Opus encoder: set bitrate to local settings [120000bps]
532. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:3834 Set Codec verto.rtc/2001 opus/48000 20 ms 960 samples 0 bits 2 channels
533. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_codec.c:111 verto.rtc/2001 Original read codec set to opus:116
534. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:4279 Save audio Candidate cid: 1 proto: udp type: host addr: 10.0.0.13:54872
535. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:4279 Save audio Candidate cid: 1 proto: udp type: srflx addr: 75.69.229.242:54872
536. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_state_machine.c:663 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State CONSUME_MEDIA
537. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_state_machine.c:663 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State CONSUME_MEDIA going to sleep
538. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:4324 Searching for rtp candidate.
539. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:4333 Choose rtp candidate, index 1, 75.69.229.242:54872
540. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:4099 verto.rtc/2001 choosing family v4
541. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:4344 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 75.69.229.242:54872
542. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:4396 setting remote audio ice addr to index 1 75.69.229.242:54872 based on candidate
543. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:4431 Setting remote rtcp audio addr to 75.69.229.242:54872 based on candidate
544. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5849 Set telephone-event payload to 110@48000
545. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:5907 verto.rtc/2001 Set 2833 dtmf send payload to 110 recv payload to 110
546. 2020-02-10 20:26:32.518742 [CRIT] switch_channel.c:1484 Invalid data (${advertised_media_ip} contains a variable)
547. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:8658 AUDIO RTP [verto.rtc/2001] 172.20.253.46 port 31314 -> 75.69.229.242 port 54872 codec: 111 ms: 20
548. 2020-02-10 20:26:32.518742 [CRIT] switch_channel.c:1484 Invalid data (${advertised_media_ip} contains a variable)
549. 2020-02-10 20:26:32.518742 [DEBUG] switch_rtp.c:4408 Starting timer [soft] 960 bytes per 20ms
550. 2020-02-10 20:26:32.518742 [INFO] switch_core_media.c:8840 Activating Audio ICE
551. 2020-02-10 20:26:32.518742 [NOTICE] switch_rtp.c:4910 Activating RTP audio ICE: 7EfF:euKNmM0JJcZQhDh2 75.69.229.242:54872
552. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:8880 Activating RTCP PORT 54872
553. 2020-02-10 20:26:32.518742 [DEBUG] switch_rtp.c:4806 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 54872
554. 2020-02-10 20:26:32.518742 [INFO] switch_core_media.c:8891 Skipping RTCP ICE (Same as RTP)
555. 2020-02-10 20:26:32.518742 [INFO] switch_rtp.c:3736 Activate RTP/RTCP audio DTLS client
556. 2020-02-10 20:26:32.518742 [INFO] switch_rtp.c:3903 Changing audio DTLS state from OFF to HANDSHAKE
557. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:2549 Setting Jitterbuffer to 20ms (1 frames) (50 max frames)
558. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:8972 verto.rtc/2001 Set 2833 dtmf send payload to 110
559. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:8979 verto.rtc/2001 Set 2833 dtmf receive payload to 110
560. 2020-02-10 20:26:32.518742 [CRIT] switch_channel.c:1484 Invalid data (${rtp_local_sdp_str} contains a variable)
561. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_media.c:8640 Audio params are unchanged for verto.rtc/2001.
562. 2020-02-10 20:26:32.518742 [DEBUG] mod_verto.c:2519 Local SDP verto.rtc/2001:
563. v=0
564. o=FreeSWITCH 1581335078 1581335079 IN IP4 ${external_rtp_ip}
565. s=FreeSWITCH
566. c=IN IP4 ${external_rtp_ip}
567. t=0 0
568. a=msid-semantic: WMS tRdhIVXwVqToQK858NgKI2bmx7mpheOA
569. m=audio 31314 UDP/TLS/RTP/SAVPF 111 110
570. a=rtpmap:111 opus/48000/2
571. a=fmtp:111 useinbandfec=1; minptime=10; stereo=1; sprop-stereo=1
572. a=rtpmap:110 telephone-event/48000
573. a=silenceSupp:off - - - -
574. a=ptime:20
575. a=sendrecv
576. a=fingerprint:sha-256 96:E9:38:23:96:4C:07:4E:61:4F:80:B7:05:E6:BE:BA:04:CA:F3:69:B6:90:E0:43:59:AD:F1:A9:4B:D1:57:C3
577. a=setup:active
578. a=rtcp-mux
579. a=rtcp:31314 IN IP4 ${external_rtp_ip}
580. a=ice-ufrag:euKNmM0JJcZQhDh2
581. a=ice-pwd:mPmPb34Nuw6vYkv3E5HRHxqh
582. a=candidate:4653287215 1 udp 659136 ${external_rtp_ip} 31314 typ host generation 0
583. a=end-of-candidates
584. a=ssrc:1112046320 cname:VSIuDvRoMACsbBna
585. a=ssrc:1112046320 msid:tRdhIVXwVqToQK858NgKI2bmx7mpheOA a0
586. a=ssrc:1112046320 mslabel:tRdhIVXwVqToQK858NgKI2bmx7mpheOA
587. a=ssrc:1112046320 label:tRdhIVXwVqToQK858NgKI2bmx7mpheOAa0
588.  
589. 2020-02-10 20:26:32.518742 [NOTICE] switch_ivr_originate.c:1246 Pre-Answer verto.rtc/2001!
590. 2020-02-10 20:26:32.518742 [DEBUG] switch_channel.c:3565 (verto.rtc/2001) Callstate Change RINGING -> EARLY
591. 2020-02-10 20:26:32.518742 [DEBUG] switch_ivr_originate.c:1304 Raw Codec Activation Success L16@48000hz 2 channel 20ms
592. 2020-02-10 20:26:32.518742 [DEBUG] switch_core_codec.c:223 verto.rtc/2001 Push codec L16:100
593. 2020-02-10 20:26:32.518742 [DEBUG] switch_ivr_originate.c:1378 Play Ringback Tone [%(2000,4000,440,480)]
594. 2020-02-10 20:26:32.538739 [DEBUG] mod_verto.c:607 WRITE 75.69.229.242:55707 [{
595.         "jsonrpc":      "2.0",
596.         "id":   39,
597.         "method":       "verto.media",
598.         "params":       {
599.                 "callID":       "3d4878b9-8f16-5a58-feee-a300d1e8e84c",
600.                 "sdp":  "v=0\r\no=FreeSWITCH 1581335078 1581335079 IN IP4 ${external_rtp_ip}\r\ns=FreeSWITCH\r\nc=IN IP4 ${external_rtp_ip}\r\nt=0 0\r\na=msid-semantic: WMS tRdhIVXwVqToQK858NgKI2bmx7mpheOA\r\nm=audio 31314 UDP/TLS/RTP/SAVPF 111 110\r\na=rtpmap:111 opus/48000/2\r\na=fmtp:111 useinbandfec=1; minptime=10; stereo=1; sprop-stereo=1\r\na=rtpmap:110 telephone-event/48000\r\na=silenceSupp:off - - - -\r\na=ptime:20\r\na=sendrecv\r\na=fingerprint:sha-256 96:E9:38:23:96:4C:07:4E:61:4F:80:B7:05:E6:BE:BA:04:CA:F3:69:B6:90:E0:43:59:AD:F1:A9:4B:D1:57:C3\r\na=setup:active\r\na=rtcp-mux\r\na=rtcp:31314 IN IP4 ${external_rtp_ip}\r\na=ice-ufrag:euKNmM0JJcZQhDh2\r\na=ice-pwd:mPmPb34Nuw6vYkv3E5HRHxqh\r\na=candidate:4653287215 1 udp 659136 ${external_rtp_ip} 31314 typ host generation 0\r\na=end-of-candidates\r\na=ssrc:1112046320 cname:VSIuDvRoMACsbBna\r\na=ssrc:1112046320 msid:tRdhIVXwVqToQK858NgKI2bmx7mpheOA a0\r\na=ssrc:1112046320 mslabel:tRdhIVXwVqToQK858NgKI2bmx7mpheOA\r\na=ssrc:1112046320 label:tRdhIVXwVqToQK858NgKI2bmx7mpheOAa0\r\n"
601.         }
602. }]
603. 2020-02-10 20:26:32.538739 [DEBUG] mod_verto.c:607 WRITE 47.208.143.73:53106 [{
604.         "jsonrpc":      "2.0",
605.         "id":   38,
606.         "method":       "verto.invite",
607.         "params":       {
608.                 "callID":       "5d064648-18e8-4004-b4e6-bdda6cefa96f",
609.                 "sdp":  "v=0\r\no=FreeSWITCH 1581346272 1581346273 IN IP4 ${external_rtp_ip}\r\ns=FreeSWITCH\r\nc=IN IP4 ${external_rtp_ip}\r\nt=0 0\r\na=msid-semantic: WMS GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q\r\nm=audio 20120 RTP/SAVPF 102 9 0 8 103\r\na=rtpmap:102 opus/48000/2\r\na=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40; stereo=1\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:103 opus/48000/2\r\na=fmtp:103 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40\r\na=fingerprint:sha-256 96:E9:38:23:96:4C:07:4E:61:4F:80:B7:05:E6:BE:BA:04:CA:F3:69:B6:90:E0:43:59:AD:F1:A9:4B:D1:57:C3\r\na=setup:actpass\r\na=rtcp-mux\r\na=rtcp:20120 IN IP4 ${external_rtp_ip}\r\na=ssrc:1380421024 cname:qTfDHrzty7XiZScD\r\na=ssrc:1380421024 msid:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q a0\r\na=ssrc:1380421024 mslabel:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q\r\na=ssrc:1380421024 label:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Qa0\r\na=ice-ufrag:lO7nNTWvTVZ3KUK1\r\na=ice-pwd:EQub7UvwRjFH2Ibdm8r0SdmC\r\na=candidate:3536908466 1 udp 659136 ${external_rtp_ip} 20120 typ host generation 0\r\na=candidate:3536908466 2 udp 659136 ${external_rtp_ip} 20120 typ host generation 0\r\na=silenceSupp:off - - - -\r\na=ptime:20\r\na=sendrecv\r\nm=video 20122 RTP/SAVPF 104 105\r\nb=AS:1024\r\na=rtpmap:104 VP8/90000\r\na=rtpmap:105 VP9/90000\r\na=sendrecv\r\na=fingerprint:sha-256 96:E9:38:23:96:4C:07:4E:61:4F:80:B7:05:E6:BE:BA:04:CA:F3:69:B6:90:E0:43:59:AD:F1:A9:4B:D1:57:C3\r\na=setup:actpass\r\na=rtcp-mux\r\na=rtcp:20122 IN IP4 ${external_rtp_ip}\r\na=rtcp-fb:104 ccm fir\r\na=rtcp-fb:104 ccm tmmbr\r\na=rtcp-fb:104 nack\r\na=rtcp-fb:104 nack pli\r\na=rtcp-fb:105 ccm fir\r\na=rtcp-fb:105 ccm tmmbr\r\na=rtcp-fb:105 nack\r\na=rtcp-fb:105 nack pli\r\na=ssrc:589759212 cname:qTfDHrzty7XiZScD\r\na=ssrc:589759212 msid:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q v0\r\na=ssrc:589759212 mslabel:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q\r\na=ssrc:589759212 label:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Qv0\r\na=ice-ufrag:nOqJsoNhRoYS1I6C\r\na=ice-pwd:KbWQrJLKQ7PUJaBXPSw76afN\r\na=candidate:7693262838 1 udp 659136 ${external_rtp_ip} 20122 typ host generation 0\r\na=candidate:7693262838 2 udp 659135 ${external_rtp_ip} 20122 typ host generation 0\r\na=end-of-candidates\r\n",
610.                 "caller_id_name":       "Bennett Malbon",
611.                 "caller_id_number":     "bennett.malbon@gmail.com",
612.                 "callee_id_name":       "River Hume",
613.                 "callee_id_number":     "2001",
614.                 "display_direction":    "outbound"
615.         }
616. }]
617. 2020-02-10 20:26:32.638740 [DEBUG] mod_verto.c:1415 READ 47.208.143.73:53106 [{
618.         "jsonrpc":      "2.0",
619.         "id":   38,
620.         "result":       {
621.                 "method":       "verto.invite"
622.         }
623. }]
624. 2020-02-10 20:26:32.638740 [DEBUG] mod_verto.c:1415 READ 75.69.229.242:55707 [{
625.         "jsonrpc":      "2.0",
626.         "id":   39,
627.         "result":       {
628.                 "method":       "verto.media"
629.         }
630. }]
631. 2020-02-10 20:26:35.298739 [DEBUG] mod_verto.c:1415 READ 47.208.143.73:53106 [{
632.         "jsonrpc":      "2.0",
633.         "method":       "verto.answer",
634.         "params":       {
635.                 "sdp":  "v=0\r\no=- 2086842449089840571 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=msid-semantic: WMS L0aEOuZ3LaFUV6AIRKXnRO3LiVXme4Lo9e2v\r\nm=audio 61518 RTP/SAVPF 102 9 0 8\r\nc=IN IP4 47.208.143.73\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=candidate:544163749 1 udp 2122260223 192.168.203.1 61517 typ host generation 0 network-id 1\r\na=candidate:1817745826 1 udp 2122194687 192.168.11.4 61518 typ host generation 0 network-id 2 network-cost 10\r\na=candidate:1861008213 1 tcp 1518280447 192.168.203.1 9 typ host tcptype active generation 0 network-id 1\r\na=candidate:584803666 1 tcp 1518214911 192.168.11.4 9 typ host tcptype active generation 0 network-id 2 network-cost 10\r\na=candidate:2588467318 1 udp 1685987071 47.208.143.73 61518 typ srflx raddr 192.168.11.4 rport 61518 generation 0 network-id 2 network-cost 10\r\na=ice-ufrag:H55r\r\na=ice-pwd:rzNXN8nz6FBo5Nf3QZz32aNL\r\na=ice-options:trickle\r\na=fingerprint:sha-256 5A:28:05:08:10:7A:E4:87:34:EF:3B:42:64:2E:D4:FC:F4:AB:95:2C:76:3B:8B:F1:E7:02:45:44:15:C7:33:2D\r\na=setup:active\r\na=mid:audio\r\na=sendrecv\r\na=rtcp-mux\r\na=rtpmap:102 opus/48000/2\r\na=fmtp:102 minptime=10;useinbandfec=1; stereo=1; sprop-stereo=1\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=ssrc:2328629703 cname:TpichWJD8vJa7eUl\r\na=ssrc:2328629703 msid:L0aEOuZ3LaFUV6AIRKXnRO3LiVXme4Lo9e2v b89f0657-9a2d-4e86-b094-a52701603622\r\na=ssrc:2328629703 mslabel:L0aEOuZ3LaFUV6AIRKXnRO3LiVXme4Lo9e2v\r\na=ssrc:2328629703 label:b89f0657-9a2d-4e86-b094-a52701603622\r\nm=video 61520 RTP/SAVPF 104 105\r\nc=IN IP4 47.208.143.73\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=candidate:544163749 1 udp 2122260223 192.168.203.1 61519 typ host generation 0 network-id 1\r\na=candidate:1817745826 1 udp 2122194687 192.168.11.4 61520 typ host generation 0 network-id 2 network-cost 10\r\na=candidate:1861008213 1 tcp 1518280447 192.168.203.1 9 typ host tcptype active generation 0 network-id 1\r\na=candidate:584803666 1 tcp 1518214911 192.168.11.4 9 typ host tcptype active generation 0 network-id 2 network-cost 10\r\na=candidate:2588467318 1 udp 1685987071 47.208.143.73 61520 typ srflx raddr 192.168.11.4 rport 61520 generation 0 network-id 2 network-cost 10\r\na=ice-ufrag:/xeC\r\na=ice-pwd:w2ArNzyEcxKMPQ5YpFb7IGBO\r\na=ice-options:trickle\r\na=fingerprint:sha-256 5A:28:05:08:10:7A:E4:87:34:EF:3B:42:64:2E:D4:FC:F4:AB:95:2C:76:3B:8B:F1:E7:02:45:44:15:C7:33:2D\r\na=setup:active\r\na=mid:video\r\na=recvonly\r\na=rtcp-mux\r\na=rtpmap:104 VP8/90000\r\na=rtcp-fb:104 ccm fir\r\na=rtcp-fb:104 nack\r\na=rtcp-fb:104 nack pli\r\na=rtpmap:105 VP9/90000\r\na=rtcp-fb:105 ccm fir\r\na=rtcp-fb:105 nack\r\na=rtcp-fb:105 nack pli\r\na=fmtp:105 profile-id=0\r\n",
636.                 "dialogParams": {
637.                         "useStereo":    true,
638.                         "screenShare":  false,
639.                         "useCamera":    "b17ca3d0e160db0e8ba5bcdc4d2888451133c8e3ab8cb486618b7a0fb11fed25",
640.                         "useMic":       "default",
641.                         "useSpeak":     "default",
642.                         "tag":  "webcam",
643.                         "localTag":     null,
644.                         "login":        "2001@pbx.performityinctest.com",
645.                         "videoParams":  {
646.                                 "minWidth":     1280,
647.                                 "minHeight":    720,
648.                                 "maxWidth":     1280,
649.                                 "maxHeight":    720,
650.                                 "minFrameRate": 15
651.                         },
652.                         "useStream":    null,
653.                         "callID":       "5d064648-18e8-4004-b4e6-bdda6cefa96f",
654.                         "caller_id_name":       "Bennett Malbon",
655.                         "caller_id_number":     "bennett.malbon@gmail.com",
656.                         "callee_id_name":       "River Hume",
657.                         "callee_id_number":     "2001",
658.                         "display_direction":    "outbound",
659.                         "wantVideo":    true,
660.                         "remote_caller_id_name":        "Bennett Malbon",
661.                         "remote_caller_id_number":      "bennett.malbon@gmail.com"
662.                 },
663.                 "sessid":       "7374663b-9d73-f499-a2a6-05d579db6fa2"
664.         },
665.         "id":   36
666. }]
667. 2020-02-10 20:26:35.298739 [DEBUG] mod_verto.c:2753 Remote SDP verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2:
668. v=0
669. o=- 2086842449089840571 2 IN IP4 127.0.0.1
670. s=-
671. t=0 0
672. a=msid-semantic: WMS L0aEOuZ3LaFUV6AIRKXnRO3LiVXme4Lo9e2v
673. m=audio 61518 RTP/SAVPF 102 9 0 8
674. c=IN IP4 47.208.143.73
675. a=rtcp:9 IN IP4 0.0.0.0
676. a=candidate:544163749 1 udp 2122260223 192.168.203.1 61517 typ host generation 0 network-id 1
677. a=candidate:1817745826 1 udp 2122194687 192.168.11.4 61518 typ host generation 0 network-id 2 network-cost 10
678. a=candidate:1861008213 1 tcp 1518280447 192.168.203.1 9 typ host tcptype active generation 0 network-id 1
679. a=candidate:584803666 1 tcp 1518214911 192.168.11.4 9 typ host tcptype active generation 0 network-id 2 network-cost 10
680. a=candidate:2588467318 1 udp 1685987071 47.208.143.73 61518 typ srflx raddr 192.168.11.4 rport 61518 generation 0 network-id 2 network-cost 10
681. a=ice-ufrag:H55r
682. a=ice-pwd:rzNXN8nz6FBo5Nf3QZz32aNL
683. a=ice-options:trickle
684. a=fingerprint:sha-256 5A:28:05:08:10:7A:E4:87:34:EF:3B:42:64:2E:D4:FC:F4:AB:95:2C:76:3B:8B:F1:E7:02:45:44:15:C7:33:2D
685. a=setup:active
686. a=mid:audio
687. a=sendrecv
688. a=rtcp-mux
689. a=rtpmap:102 opus/48000/2
690. a=fmtp:102 minptime=10;useinbandfec=1; stereo=1; sprop-stereo=1
691. a=rtpmap:9 G722/8000
692. a=rtpmap:0 PCMU/8000
693. a=rtpmap:8 PCMA/8000
694. a=ssrc:2328629703 cname:TpichWJD8vJa7eUl
695. a=ssrc:2328629703 msid:L0aEOuZ3LaFUV6AIRKXnRO3LiVXme4Lo9e2v b89f0657-9a2d-4e86-b094-a52701603622
696. a=ssrc:2328629703 mslabel:L0aEOuZ3LaFUV6AIRKXnRO3LiVXme4Lo9e2v
697. a=ssrc:2328629703 label:b89f0657-9a2d-4e86-b094-a52701603622
698. m=video 61520 RTP/SAVPF 104 105
699. c=IN IP4 47.208.143.73
700. a=rtcp:9 IN IP4 0.0.0.0
701. a=candidate:544163749 1 udp 2122260223 192.168.203.1 61519 typ host generation 0 network-id 1
702. a=candidate:1817745826 1 udp 2122194687 192.168.11.4 61520 typ host generation 0 network-id 2 network-cost 10
703. a=candidate:1861008213 1 tcp 1518280447 192.168.203.1 9 typ host tcptype active generation 0 network-id 1
704. a=candidate:584803666 1 tcp 1518214911 192.168.11.4 9 typ host tcptype active generation 0 network-id 2 network-cost 10
705. a=candidate:2588467318 1 udp 1685987071 47.208.143.73 61520 typ srflx raddr 192.168.11.4 rport 61520 generation 0 network-id 2 network-cost 10
706. a=ice-ufrag:/xeC
707. a=ice-pwd:w2ArNzyEcxKMPQ5YpFb7IGBO
708. a=ice-options:trickle
709. a=fingerprint:sha-256 5A:28:05:08:10:7A:E4:87:34:EF:3B:42:64:2E:D4:FC:F4:AB:95:2C:76:3B:8B:F1:E7:02:45:44:15:C7:33:2D
710. a=setup:active
711. a=mid:video
712. a=recvonly
713. a=rtcp-mux
714. a=rtpmap:104 VP8/90000
715. a=rtcp-fb:104 ccm fir
716. a=rtcp-fb:104 nack
717. a=rtcp-fb:104 nack pli
718. a=rtpmap:105 VP9/90000
719. a=rtcp-fb:105 ccm fir
720. a=rtcp-fb:105 nack
721. a=rtcp-fb:105 nack pli
722. a=fmtp:105 profile-id=0
723.  
724. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [opus:102:48000:20:0:2]/[opus:116:48000:20:0:2]
725. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5645 Audio Codec Compare [opus:116:48000:20:0:2] ++++ is saved as a match
726. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [opus:102:48000:20:0:2]/[G722:9:8000:20:64000:1]
727. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [opus:102:48000:20:0:2]/[PCMU:0:8000:20:64000:1]
728. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [opus:102:48000:20:0:2]/[PCMA:8:8000:20:64000:1]
729. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [opus:102:48000:20:0:2]/[opus:116:48000:20:0:1]
730. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5645 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
731. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:2]
732. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1]
733. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5645 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match
734. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
735. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
736. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1]
737. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:2]
738. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
739. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
740. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5645 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
741. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
742. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
743. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:2]
744. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1]
745. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
746. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
747. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5645 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match
748. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5590 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
749. 2020-02-10 20:26:35.298739 [DEBUG] mod_opus.c:613 Opus encoder: set bitrate to local settings [120000bps]
750. 2020-02-10 20:26:35.298739 [DEBUG] mod_opus.c:613 Opus encoder: set bitrate to local settings [120000bps]
751. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:3834 Set Codec verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 opus/48000 20 ms 960 samples 0 bits 2 channels
752. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_codec.c:111 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 Original read codec set to opus:116
753. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4279 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.203.1:61517
754. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4279 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.11.4:61518
755. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4279 Save audio Candidate cid: 1 proto: udp type: srflx addr: 47.208.143.73:61518
756. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4324 Searching for rtp candidate.
757. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4333 Choose rtp candidate, index 2, 47.208.143.73:61518
758. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4099 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 choosing family v4
759. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4344 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 47.208.143.73:61518
760. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4396 setting remote audio ice addr to index 2 47.208.143.73:61518 based on candidate
761. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4431 Setting remote rtcp audio addr to 47.208.143.73:61518 based on candidate
762. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:5914 No 2833 in SDP.  Disable 2833 dtmf and switch to INFO
763. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:6191 Video Codec Compare [VP8:104]/[VP8:99]
764. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:6223 Video Codec Compare [VP8:104] +++ is saved as a match
765. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:6191 Video Codec Compare [VP8:104]/[VP9:99]
766. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:6191 Video Codec Compare [VP9:105]/[VP8:99]
767. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:6191 Video Codec Compare [VP9:105]/[VP9:99]
768. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:6223 Video Codec Compare [VP9:105] +++ is saved as a match
769. 2020-02-10 20:26:35.298739 [DEBUG] switch_vpx.c:703 VPX VER:v1.7.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:8
770. 2020-02-10 20:26:35.298739 [DEBUG] switch_vpx.c:703 VPX VER:v1.7.0 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:8
771. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:3644 Set VIDEO Codec verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 VP8/90000 0 ms
772. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4279 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.203.1:61519
773. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4279 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.11.4:61520
774. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4279 Save video Candidate cid: 1 proto: udp type: srflx addr: 47.208.143.73:61520
775. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4324 Searching for rtp candidate.
776. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4333 Choose rtp candidate, index 2, 47.208.143.73:61520
777. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4099 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 choosing family v4
778. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4344 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 47.208.143.73:61520
779. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4396 setting remote video ice addr to index 2 47.208.143.73:61520 based on candidate
780. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:4431 Setting remote rtcp video addr to 47.208.143.73:61520 based on candidate
781. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:8658 AUDIO RTP [verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2] 172.20.253.46 port 20120 -> 47.208.143.73 port 61518 codec: 102 ms: 20
782. 2020-02-10 20:26:35.298739 [CRIT] switch_channel.c:1484 Invalid data (${advertised_media_ip} contains a variable)
783. 2020-02-10 20:26:35.298739 [DEBUG] switch_rtp.c:4408 Starting timer [soft] 960 bytes per 20ms
784. 2020-02-10 20:26:35.298739 [INFO] switch_core_media.c:8840 Activating Audio ICE
785. 2020-02-10 20:26:35.298739 [NOTICE] switch_rtp.c:4910 Activating RTP audio ICE: H55r:lO7nNTWvTVZ3KUK1 47.208.143.73:61518
786. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:8880 Activating RTCP PORT 61518
787. 2020-02-10 20:26:35.298739 [DEBUG] switch_rtp.c:4806 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 61518
788. 2020-02-10 20:26:35.298739 [INFO] switch_core_media.c:8891 Skipping RTCP ICE (Same as RTP)
789. 2020-02-10 20:26:35.298739 [INFO] switch_rtp.c:3736 Activate RTP/RTCP audio DTLS server
790. 2020-02-10 20:26:35.298739 [INFO] switch_rtp.c:3903 Changing audio DTLS state from OFF to HANDSHAKE
791. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:2549 Setting Jitterbuffer to 20ms (1 frames) (50 max frames)
792.  
793.  
794. 2020-02-10 20:26:35.298739 [CRIT] switch_channel.c:1484 Invalid data (${local_video_ip} contains a variable)
795.  
796.  
797. 2020-02-10 20:26:35.298739 [DEBUG] switch_rtp.c:4423 Starting video timer.
798. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:9504 VIDEO RTP [verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2] 172.20.253.46:20122->47.208.143.73:61520 codec: 104 ms: 0 [SUCCESS]
799. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:7625 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 Starting Video thread
800. 2020-02-10 20:26:35.298739 [DEBUG] switch_core_media.c:7491 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 Video thread started. Echo is off
801. 2020-02-10 20:26:35.298739 [INFO] switch_core_media.c:9548 Activating Video ICE
802. 2020-02-10 20:26:35.298739 [NOTICE] switch_rtp.c:4910 Activating RTP video ICE: /xeC:nOqJsoNhRoYS1I6C 47.208.143.73:61520
803. 2020-02-10 20:26:35.298739 [INFO] switch_core_media.c:9585 Activating VIDEO RTCP PORT 61520 interval 1000 mux 1
804. 2020-02-10 20:26:35.298739 [DEBUG] switch_rtp.c:4806 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 61520
805. 2020-02-10 20:26:35.298739 [INFO] switch_core_media.c:9598 Skipping VIDEO RTCP ICE (Same as VIDEO RTP)
806. 2020-02-10 20:26:35.298739 [INFO] switch_rtp.c:3736 Activate RTP/RTCP video DTLS server
807. 2020-02-10 20:26:35.318744 [INFO] switch_rtp.c:3903 Changing video DTLS state from OFF to HANDSHAKE
808. 2020-02-10 20:26:35.318744 [DEBUG] switch_core_media.c:8640 Audio params are unchanged for verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2.
809. 2020-02-10 20:26:35.318744 [DEBUG] switch_core_media.c:9361 Video params are unchanged for verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2.
810. 2020-02-10 20:26:35.318744 [NOTICE] mod_verto.c:2787 Channel [verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2] has been answered
811. 2020-02-10 20:26:35.318744 [DEBUG] switch_channel.c:3865 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) Callstate Change RINGING -> ACTIVE
812. 2020-02-10 20:26:35.318744 [DEBUG] mod_verto.c:607 WRITE 47.208.143.73:53106 [{
813.         "jsonrpc":      "2.0",
814.         "id":   36,
815.         "result":       {
816.                 "sessid":       "7374663b-9d73-f499-a2a6-05d579db6fa2"
817.         }
818. }]
819. 2020-02-10 20:26:35.318744 [DEBUG] switch_core_codec.c:248 verto.rtc/2001 Restore previous codec opus:116.
820. 2020-02-10 20:26:35.338741 [DEBUG] mod_verto.c:607 WRITE 75.69.229.242:55707 [{
821.         "jsonrpc":      "2.0",
822.         "id":   40,
823.         "method":       "verto.answer",
824.         "params":       {
825.                 "callID":       "3d4878b9-8f16-5a58-feee-a300d1e8e84c"
826.         }
827. }]
828. 2020-02-10 20:26:35.418737 [INFO] switch_vpx.c:564 config: vp8
829. 2020-02-10 20:26:35.418737 [NOTICE] switch_vpx.c:599 VPX encoder reset (WxH/BW) from 0x0/0 to 352x288/1024
830. 2020-02-10 20:26:35.478737 [DEBUG] mod_verto.c:1415 READ 75.69.229.242:55707 [{
831.         "jsonrpc":      "2.0",
832.         "id":   40,
833.         "result":       {
834.                 "method":       "verto.answer"
835.         }
836. }]
837. 2020-02-10 20:26:42.998738 [DEBUG] mod_verto.c:1415 READ 47.208.143.73:53106 [{
838.         "jsonrpc":      "2.0",
839.         "method":       "verto.bye",
840.         "params":       {
841.                 "dialogParams": {
842.                         "useStereo":    true,
843.                         "screenShare":  false,
844.                         "useCamera":    "b17ca3d0e160db0e8ba5bcdc4d2888451133c8e3ab8cb486618b7a0fb11fed25",
845.                         "useMic":       "default",
846.                         "useSpeak":     "default",
847.                         "tag":  "webcam",
848.                         "localTag":     null,
849.                         "login":        "2001@pbx.performityinctest.com",
850.                         "videoParams":  {
851.                                 "minWidth":     1280,
852.                                 "minHeight":    720,
853.                                 "maxWidth":     1280,
854.                                 "maxHeight":    720,
855.                                 "minFrameRate": 15
856.                         },
857.                         "useStream":    null,
858.                         "callID":       "5d064648-18e8-4004-b4e6-bdda6cefa96f",
859.                         "caller_id_name":       "Bennett Malbon",
860.                         "caller_id_number":     "bennett.malbon@gmail.com",
861.                         "callee_id_name":       "River Hume",
862.                         "callee_id_number":     "2001",
863.                         "display_direction":    "outbound",
864.                         "wantVideo":    true,
865.                         "remote_caller_id_name":        "Bennett Malbon",
866.                         "remote_caller_id_number":      "bennett.malbon@gmail.com"
867.                 },
868.                 "sessid":       "7374663b-9d73-f499-a2a6-05d579db6fa2"
869.         },
870.         "id":   37
871. }]
872. 2020-02-10 20:26:42.998738 [NOTICE] mod_verto.c:2867 Hangup verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 [CS_CONSUME_MEDIA] [NORMAL_CLEARING]
873. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) Running State Change CS_HANGUP (Cur 2 Tot 26)
874. 2020-02-10 20:26:42.998738 [DEBUG] mod_verto.c:607 WRITE 47.208.143.73:53106 [{
875.         "jsonrpc":      "2.0",
876.         "id":   37,
877.         "result":       {
878.                 "callID":       "5d064648-18e8-4004-b4e6-bdda6cefa96f",
879.                 "message":      "CALL ENDED",
880.                 "causeCode":    16,
881.                 "cause":        "NORMAL_CLEARING",
882.                 "sessid":       "7374663b-9d73-f499-a2a6-05d579db6fa2"
883.         }
884. }]
885. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:848 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) Callstate Change ACTIVE -> HANGUP
886. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State HANGUP
887. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:850 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 skip receive message [VIDEO_REFRESH_REQ] (channel is hungup already)
888. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:60 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 Standard HANGUP, cause: NORMAL_CLEARING
889. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State HANGUP going to sleep
890. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:620 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State Change CS_HANGUP -> CS_REPORTING
891. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) Running State Change CS_REPORTING (Cur 2 Tot 26)
892. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:936 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State REPORTING
893. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:174 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 Standard REPORTING, cause: NORMAL_CLEARING
894. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:936 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State REPORTING going to sleep
895. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_state_machine.c:611 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) State Change CS_REPORTING -> CS_DESTROY
896. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_session.c:1726 Session 26 (verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2) Locked, Waiting on external entities
897. 2020-02-10 20:26:42.998738 [DEBUG] switch_core_media.c:7592 verto.rtc/7374663b-9d73-f499-a2a6-05d579db6fa2 Video thread ended
898.  
899.  
900.  
901.  
902.  
903.  
904.  
905.  
906.  
907.  
908.  
909. -------------------------
910.  
911. WEB CONSOLE OUTPUT:
912.  
913. Dialog 5d064648-18e8-4004-b4e6-bdda6cefa96f: state change from new to ringing
914. scripts.js:13339 onDialogState: a.verto.dialog {params: {…}, verto: a.verto, direction: {…}, lastState: {…}, state: {…}, …}params: {useVideo: undefined, useStereo: true, screenShare: false, useCamera: "b17ca3d0e160db0e8ba5bcdc4d2888451133c8e3ab8cb486618b7a0fb11fed25", useMic: "default", …}verto: a.verto {options: {…}, sessid: "7374663b-9d73-f499-a2a6-05d579db6fa2", dialogs: {…}, callbacks: {…}, eventSUBS: {…}, …}direction: {name: "inbound", val: 0}lastState: {name: "hangup", val: 9}state: {name: "destroy", val: 10}callbacks: {onWSLogin: ƒ, onMessage: ƒ, onDialogState: ƒ, onWSClose: ƒ, onEvent: ƒ}answered: trueattach: falsescreenShare: falseuseCamera: "b17ca3d0e160db0e8ba5bcdc4d2888451133c8e3ab8cb486618b7a0fb11fed25"useCameraLabel: undefineduseMic: "default"useMicLabel: undefineduseSpeak: "default"callID: "5d064648-18e8-4004-b4e6-bdda6cefa96f"audioStream: video#webcam.hidertc: a.FSRTC {options: {…}, audioEnabled: true, videoEnabled: true, mediaData: {…}, constraints: {…}, …}cause: "NORMAL_CLEARING"__proto__: Object
915. scripts.js:11875 Incoming call from: bennett.malbon@gmail.com
916. scripts.js:11889 Mon Feb 10 2020 12:25:13 GMT-0800 (Pacific Standard Time)
917. scripts.js:1122 inbound sdp:  v=0
918. o=FreeSWITCH 1581346272 1581346273 IN IP4 ${external_rtp_ip}
919. s=FreeSWITCH
920. c=IN IP4 ${external_rtp_ip}
921. t=0 0
922. a=msid-semantic: WMS GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q
923. m=audio 20120 RTP/SAVPF 102 9 0 8 103
924. a=rtpmap:102 opus/48000/2
925. a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40; stereo=1
926. a=rtpmap:9 G722/8000
927. a=rtpmap:0 PCMU/8000
928. a=rtpmap:8 PCMA/8000
929. a=rtpmap:103 opus/48000/2
930. a=fmtp:103 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
931. a=fingerprint:sha-256 96:E9:38:23:96:4C:07:4E:61:4F:80:B7:05:E6:BE:BA:04:CA:F3:69:B6:90:E0:43:59:AD:F1:A9:4B:D1:57:C3
932. a=setup:actpass
933. a=rtcp-mux
934. a=rtcp:20120 IN IP4 ${external_rtp_ip}
935. a=ssrc:1380421024 cname:qTfDHrzty7XiZScD
936. a=ssrc:1380421024 msid:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q a0
937. a=ssrc:1380421024 mslabel:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q
938. a=ssrc:1380421024 label:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Qa0
939. a=ice-ufrag:lO7nNTWvTVZ3KUK1
940. a=ice-pwd:EQub7UvwRjFH2Ibdm8r0SdmC
941. a=candidate:3536908466 1 udp 659136 ${external_rtp_ip} 20120 typ host generation 0
942. a=candidate:3536908466 2 udp 659136 ${external_rtp_ip} 20120 typ host generation 0
943. a=silenceSupp:off - - - -
944. a=ptime:20
945. a=sendrecv
946. m=video 20122 RTP/SAVPF 104 105
947. b=AS:1024
948. a=rtpmap:104 VP8/90000
949. a=rtpmap:105 VP9/90000
950. a=sendrecv
951. a=fingerprint:sha-256 96:E9:38:23:96:4C:07:4E:61:4F:80:B7:05:E6:BE:BA:04:CA:F3:69:B6:90:E0:43:59:AD:F1:A9:4B:D1:57:C3
952. a=setup:actpass
953. a=rtcp-mux
954. a=rtcp:20122 IN IP4 ${external_rtp_ip}
955. a=rtcp-fb:104 ccm fir
956. a=rtcp-fb:104 ccm tmmbr
957. a=rtcp-fb:104 nack
958. a=rtcp-fb:104 nack pli
959. a=rtcp-fb:105 ccm fir
960. a=rtcp-fb:105 ccm tmmbr
961. a=rtcp-fb:105 nack
962. a=rtcp-fb:105 nack pli
963. a=ssrc:589759212 cname:qTfDHrzty7XiZScD
964. a=ssrc:589759212 msid:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q v0
965. a=ssrc:589759212 mslabel:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q
966. a=ssrc:589759212 label:GBYymXl6WhHDT244NCLEc9WJS98DkZ4Qv0
967. a=ice-ufrag:nOqJsoNhRoYS1I6C
968. a=ice-pwd:KbWQrJLKQ7PUJaBXPSw76afN
969. a=candidate:7693262838 1 udp 659136 ${external_rtp_ip} 20122 typ host generation 0
970. a=candidate:7693262838 2 udp 659135 ${external_rtp_ip} 20122 typ host generation 0
971. a=end-of-candidates
972.  
973. scripts.js:1304 Camera Disabled
974. scripts.js:1163 Audio constraints {googEchoCancellation: true, googNoiseSuppression: true, googHighpassFilter: true, googAutoGainControl: true, googAutoGainControl2: true, …}googEchoCancellation: truegoogNoiseSuppression: truegoogHighpassFilter: truegoogAutoGainControl: truegoogAutoGainControl2: truedeviceId: {deviceId: {…}}__proto__: Object
975.  
976. scripts.js:1164 Video constraints false
977.  
978. scripts.js:1707 Tried to use constraint fallbacks but did not found vendor function `assureMediaInputId` on window scope. Did you forget to import `vendor/media-device-id.js` before Verto?
979.  
980.  
981. v @ scripts.js:1707
982. z @ scripts.js:1765
983. a.FSRTC.createAnswer @ scripts.js:1190
984. a.verto.dialog.answer @ scripts.js:4460
985. a.answerCall @ scripts.js:11943
986. (anonymous) @ scripts.js:11891
987. i @ vendor.js:22848
988. (anonymous) @ vendor.js:22864
989. $eval @ vendor.js:24100
990. $digest @ vendor.js:23916
991. $apply @ vendor.js:24205
992. (anonymous) @ vendor.js:31235
993. dispatch @ vendor.js:4435
994. q.handle @ vendor.js:4121
995.  
996.  
997. scripts.js:1707 Tried to use constraint fallbacks but did not found vendor function `assureMediaInputId` on window scope. Did you forget to import `vendor/media-device-id.js` before Verto?
998.  
999. v @ scripts.js:1707
1000. z @ scripts.js:1766
1001. a.FSRTC.createAnswer @ scripts.js:1190
1002. a.verto.dialog.answer @ scripts.js:4460
1003. a.answerCall @ scripts.js:11943
1004. (anonymous) @ scripts.js:11891
1005. i @ vendor.js:22848
1006. (anonymous) @ vendor.js:22864
1007. $eval @ vendor.js:24100
1008. $digest @ vendor.js:23916
1009. $apply @ vendor.js:24205
1010. (anonymous) @ vendor.js:31235
1011. dispatch @ vendor.js:4435
1012. q.handle @ vendor.js:4121
1013. scripts.js:14061 0
1014. scripts.js:11251 Executing InCallController.
1015. scripts.js:921 Stream Success
1016. scripts.js:3958 stream started
1017. scripts.js:1504 Peer Track RTCTrackEvent {isTrusted: true, transceiver: {…}, receiver: RTCRtpReceiver, track: MediaStreamTrack, streams: Array(1), …}
1018. scripts.js:991 REMOTE STREAM MediaStream {id: "GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q", active: true, onaddtrack: null, onremovetrack: null, onactive: null, …} <video class=​"hide" id=​"webcam" autoplay=​"autoplay" style=​"object-fit:​ inherit;​" src=​"sounds/​bell_ring2.wav">​</video>​
1019. scripts.js:926 Remote Stream Success
1020. scripts.js:3965 remote stream started
1021. scripts.js:1504 Peer Track RTCTrackEvent {isTrusted: true, transceiver: {…}, receiver: RTCRtpReceiver, track: MediaStreamTrack, streams: Array(1), …}
1022. scripts.js:991 REMOTE STREAM MediaStream {id: "GBYymXl6WhHDT244NCLEc9WJS98DkZ4Q", active: true, onaddtrack: null, onremovetrack: null, onactive: null, …} <video class=​"hide" id=​"webcam" autoplay=​"autoplay" style=​"object-fit:​ inherit;​" src=​"sounds/​bell_ring2.wav">​</video>​
1023. scripts.js:926 Remote Stream Success
1024. scripts.js:3965 remote stream started
1025. scripts.js:11385 broadcast time-start incall
1026. scripts.js:944 ICE Complete
1027. scripts.js:955 ICE SDP
1028. scripts.js:3912 RECV answer SDP v=0
1029. o=- 2086842449089840571 2 IN IP4 127.0.0.1
1030. s=-
1031. t=0 0
1032. a=msid-semantic: WMS L0aEOuZ3LaFUV6AIRKXnRO3LiVXme4Lo9e2v
1033. m=audio 61518 RTP/SAVPF 102 9 0 8
1034. c=IN IP4 47.208.143.73
1035. a=rtcp:9 IN IP4 0.0.0.0
1036. a=candidate:544163749 1 udp 2122260223 192.168.203.1 61517 typ host generation 0 network-id 1
1037. a=candidate:1817745826 1 udp 2122194687 192.168.11.4 61518 typ host generation 0 network-id 2 network-cost 10
1038. a=candidate:1861008213 1 tcp 1518280447 192.168.203.1 9 typ host tcptype active generation 0 network-id 1
1039. a=candidate:584803666 1 tcp 1518214911 192.168.11.4 9 typ host tcptype active generation 0 network-id 2 network-cost 10
1040. a=candidate:2588467318 1 udp 1685987071 47.208.143.73 61518 typ srflx raddr 192.168.11.4 rport 61518 generation 0 network-id 2 network-cost 10
1041. a=ice-ufrag:H55r
1042. a=ice-pwd:rzNXN8nz6FBo5Nf3QZz32aNL
1043. a=ice-options:trickle
1044. a=fingerprint:sha-256 5A:28:05:08:10:7A:E4:87:34:EF:3B:42:64:2E:D4:FC:F4:AB:95:2C:76:3B:8B:F1:E7:02:45:44:15:C7:33:2D
1045. a=setup:active
1046. a=mid:audio
1047. a=sendrecv
1048. a=rtcp-mux
1049. a=rtpmap:102 opus/48000/2
1050. a=fmtp:102 minptime=10;useinbandfec=1; stereo=1; sprop-stereo=1
1051. a=rtpmap:9 G722/8000
1052. a=rtpmap:0 PCMU/8000
1053. a=rtpmap:8 PCMA/8000
1054. a=ssrc:2328629703 cname:TpichWJD8vJa7eUl
1055. a=ssrc:2328629703 msid:L0aEOuZ3LaFUV6AIRKXnRO3LiVXme4Lo9e2v b89f0657-9a2d-4e86-b094-a52701603622
1056. a=ssrc:2328629703 mslabel:L0aEOuZ3LaFUV6AIRKXnRO3LiVXme4Lo9e2v
1057. a=ssrc:2328629703 label:b89f0657-9a2d-4e86-b094-a52701603622
1058. m=video 61520 RTP/SAVPF 104 105
1059. c=IN IP4 47.208.143.73
1060. a=rtcp:9 IN IP4 0.0.0.0
1061. a=candidate:544163749 1 udp 2122260223 192.168.203.1 61519 typ host generation 0 network-id 1
1062. a=candidate:1817745826 1 udp 2122194687 192.168.11.4 61520 typ host generation 0 network-id 2 network-cost 10
1063. a=candidate:1861008213 1 tcp 1518280447 192.168.203.1 9 typ host tcptype active generation 0 network-id 1
1064. a=candidate:584803666 1 tcp 1518214911 192.168.11.4 9 typ host tcptype active generation 0 network-id 2 network-cost 10
1065. a=candidate:2588467318 1 udp 1685987071 47.208.143.73 61520 typ srflx raddr 192.168.11.4 rport 61520 generation 0 network-id 2 network-cost 10
1066. a=ice-ufrag:/xeC
1067. a=ice-pwd:w2ArNzyEcxKMPQ5YpFb7IGBO
1068. a=ice-options:trickle
1069. a=fingerprint:sha-256 5A:28:05:08:10:7A:E4:87:34:EF:3B:42:64:2E:D4:FC:F4:AB:95:2C:76:3B:8B:F1:E7:02:45:44:15:C7:33:2D
1070. a=setup:active
1071. a=mid:video
1072. a=recvonly
1073. a=rtcp-mux
1074. a=rtpmap:104 VP8/90000
1075. a=rtcp-fb:104 ccm fir
1076. a=rtcp-fb:104 nack
1077. a=rtcp-fb:104 nack pli
1078. a=rtpmap:105 VP9/90000
1079. a=rtcp-fb:105 ccm fir
1080. a=rtcp-fb:105 nack
1081. a=rtcp-fb:105 nack pli
1082. a=fmtp:105 profile-id=0
1083.  
1084. scripts.js:4116 Dialog 5d064648-18e8-4004-b4e6-bdda6cefa96f: state change from ringing to answering
1085. scripts.js:13339 onDialogState: a.verto.dialog {params: {…}, verto: a.verto, direction: {…}, lastState: {…}, state: {…}, …}
1086.  
1087.  
1088. *** not implemented state: destroy ??? ***
1089. scripts.js:13375 Got a not implemented state: a.verto.dialog {params: {…}, verto: a.verto, direction: {…}, lastState: {…}, state: {…}, …}params: {useVideo: undefined, useStereo: true, screenShare: false, useCamera: "b17ca3d0e160db0e8ba5bcdc4d2888451133c8e3ab8cb486618b7a0fb11fed25", useMic: "default", …}verto: a.verto {options: {…}, sessid: "7374663b-9d73-f499-a2a6-05d579db6fa2", dialogs: {…}, callbacks: {…}, eventSUBS: {…}, …}direction: {name: "inbound", val: 0}lastState: {name: "hangup", val: 9}
1090.  
1091. state: name: "destroy"val: 10__proto__: Objectcallbacks: {onWSLogin: ƒ, onMessage: ƒ, onDialogState: ƒ, onWSClose: ƒ, onEvent: ƒ}answered: trueattach: falsescreenShare: falseuseCamera: "b17ca3d0e160db0e8ba5bcdc4d2888451133c8e3ab8cb486618b7a0fb11fed25"useCameraLabel: undefineduseMic: "default"useMicLabel: undefineduseSpeak: "default"callID: "5d064648-18e8-4004-b4e6-bdda6cefa96f"audioStream: video#webcam.hidertc: a.FSRTC {options: {…}, audioEnabled: true, videoEnabled: true, mediaData: {…}, constraints: {…}, …}cause: "NORMAL_CLEARING"__proto__: Object
1092.  
1093.  
1094.  
1095.  
1096. onDialogState @ scripts.js:13375
1097. a.verto.dialog.setState @ scripts.js:4122
1098. f.onICESDP @ scripts.js:3933
1099. l @ scripts.js:939
1100. o @ scripts.js:956
1101. onICESDP @ scripts.js:1140
1102. b @ scripts.js:1452
1103. setTimeout (async)
1104. o.onicecandidate @ scripts.js:1464
1105. scripts.js:4116 Dialog 5d064648-18e8-4004-b4e6-bdda6cefa96f: state change from answering to active
1106. scripts.js:13339 onDialogState: a.verto.dialog {params: {…}, verto: a.verto, direction: {…}, lastState: {…}, state: {…}, …}
1107. scripts.js:13354 Talking to: Bennett Malbon <bennett.malbon@gmail.com>
1108. scripts.js:4131 Using Speaker:  default
1109. scripts.js:12812 Setting video size to NaN/null
1110. scripts.js:4075 Dialog: 5d064648-18e8-4004-b4e6-bdda6cefa96f Setting speaker: <video class=​"hide" id=​"webcam" autoplay=​"autoplay" style=​"object-fit:​ inherit;​" src=​"sounds/​bell_ring2.wav">​</video>​ Default - Speakers (Dell USB Audio) (17e9:436e)
1111. scripts.js:4079 Dialog: 5d064648-18e8-4004-b4e6-bdda6cefa96f Success, audio output device attached: default
1112. scripts.js:13659 Attempting to hangup the current call.
1113. scripts.js:4116 Dialog 5d064648-18e8-4004-b4e6-bdda6cefa96f: state change from active to hangup
1114. scripts.js:13339 onDialogState: a.verto.dialog {params: {…}, verto: a.verto, direction: {…}, lastState: {…}, state: {…}, …}
1115. scripts.js:13360 Call ended with cause: NORMAL_CLEARING
1116. scripts.js:4116 Dialog 5d064648-18e8-4004-b4e6-bdda6cefa96f: state change from hangup to destroy
1117. scripts.js:13339 onDialogState: a.verto.dialog {params: {…}, verto: a.verto, direction: {…}, lastState: {…}, state: {…}, …}
1118. scripts.js:13364 Destroying: NORMAL_CLEARING
1119. scripts.js:13251 stopConference()
1120. scripts.js:13258 Doesn't found data.liveArray.
1121. scripts.js:11772 Redirecting to dialpad page.
1122. scripts.js:11778 not digest
1123. scripts.js:1033 Stopping localStream tracks: [MediaStreamTrack]
1124. scripts.js:1049 stopping peer
1125. scripts.js:13673 The call was hangup.
1126. scripts.js:11102 Executing DialPadController.