2018-11-20 20:47:28.510471 [DEBUG] sofia.c:2413 detaching session 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:34.453489 [INFO] conference_loop.c:1674 Channel leaving conference, cause: NONE 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:34.453489 [INFO] conference_loop.c:1674 Channel leaving conference, cause: NONE e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:34.453489 [INFO] conference_loop.c:1674 Channel leaving conference, cause: NONE freeswitch@FreeSWITCH-CUDA> 2018-11-20 20:47:34.465484 [DEBUG] avcodec.c:1412 picture size changed from 1920x1080 to 352x288, reinitializing encoder 2018-11-20 20:47:34.467483 [DEBUG] avcodec.c:1412 picture size changed from 1920x1080 to 352x288, reinitializing encoder 2018-11-20 20:47:34.467483 [WARNING] switch_core_file.c:405 File has 1 channels, muxing to 2 channels will occur. 2018-11-20 20:47:34.484486 [DEBUG] avcodec.c:1412 picture size changed from 1920x1080 to 352x288, reinitializing encoder Nvenc unloaded Loaded Nvenc version 8.0 Nvenc initialized successfully 1 CUDA capable devices found [ GPU #0 - < Tesla K80 > has Compute SM 3.7 ] Nvenc unloaded supports NVENC Nvenc unloaded 2018-11-20 20:47:34.828546 [INFO] avcodec.c:1289 codec opened: Video: h264 (nvenc_h264) (Baseline), yuv420p, 352x288, 3145 kb/s Loaded Nvenc version 8.0 Nvenc initialized successfully 1 CUDA capable devices found [ GPU #0 - < Tesla K80 > has Compute SM 3.7 ] supports NVENC 2018-11-20 20:47:34.920486 [INFO] avcodec.c:1289 codec opened: Video: h264 (nvenc_h264) (Baseline), yuv420p, 352x288, 3145 kb/s Loaded Nvenc version 8.0 Nvenc initialized successfully 1 CUDA capable devices found [ GPU #0 - < Tesla K80 > has Compute SM 3.7 ] supports NVENC 2018-11-20 20:47:35.009484 [INFO] avcodec.c:1289 codec opened: Video: h264 (nvenc_h264) (Baseline), yuv420p, 352x288, 3145 kb/s 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:35.014485 [DEBUG] switch_core_codec.c:248 verto.rtc/3500 Restore previous codec opus:116. 2018-11-20 20:47:35.014485 [DEBUG] switch_core_file.c:386 File C:/Program Files/FreeSWITCH/sounds/en/us/callie/conference/conf-kicked.wav sample rate 32000 doesn't match requested rate 48000 2018-11-20 20:47:35.014485 [WARNING] switch_core_file.c:405 File has 1 channels, muxing to 2 channels will occur. 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:35.014485 [DEBUG] switch_ivr_play_say.c:1493 Codec Activated L16@48000hz 2 channels 20ms 2018-11-20 20:47:35.016484 [WARNING] switch_core_file.c:405 File has 1 channels, muxing to 2 channels will occur. 2018-11-20 20:47:35.016484 [DEBUG] switch_core_file.c:386 File C:/Program Files/FreeSWITCH/sounds/en/us/callie/conference/conf-alone.wav sample rate 32000 doesn't match requested rate 48000 2018-11-20 20:47:35.016484 [WARNING] switch_core_file.c:405 File has 1 channels, muxing to 2 channels will occur. e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:35.016484 [DEBUG] switch_core_codec.c:248 verto.rtc/3500 Restore previous codec opus:116. 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:35.018485 [DEBUG] switch_core_codec.c:248 verto.rtc/3500 Restore previous codec opus:116. 2018-11-20 20:47:35.018485 [DEBUG] switch_core_file.c:386 File C:/Program Files/FreeSWITCH/sounds/en/us/callie/conference/conf-kicked.wav sample rate 32000 doesn't match requested rate 48000 2018-11-20 20:47:35.018485 [WARNING] switch_core_file.c:405 File has 1 channels, muxing to 2 channels will occur. 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:35.018485 [DEBUG] switch_ivr_play_say.c:1493 Codec Activated L16@48000hz 2 channels 20ms 2018-11-20 20:47:35.018485 [DEBUG] switch_core_file.c:386 File C:/Program Files/FreeSWITCH/sounds/en/us/callie/conference/conf-kicked.wav sample rate 32000 doesn't match requested rate 48000 2018-11-20 20:47:35.018485 [WARNING] switch_core_file.c:405 File has 1 channels, muxing to 2 channels will occur. e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:35.018485 [DEBUG] switch_ivr_play_say.c:1493 Codec Activated L16@48000hz 2 channels 20ms 2018-11-20 20:47:35.038485 [DEBUG] mod_conference.c:836 Write Lock ON 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [DEBUG] switch_ivr_play_say.c:1937 done playing file C:/Program Files/FreeSWITCH/sounds/en/us/callie/conference/conf-kicked.wav 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [NOTICE] switch_core_state_machine.c:386 verto.rtc/3500 has executed the last dialplan instruction, hanging up. 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [NOTICE] switch_core_state_machine.c:388 Hangup verto.rtc/3500 [CS_EXECUTE] [NORMAL_CLEARING] 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [DEBUG] switch_core_state_machine.c:651 (verto.rtc/3500) State EXECUTE going to sleep 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_HANGUP (Cur 4 Tot 101) 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [DEBUG] switch_core_state_machine.c:848 (verto.rtc/3500) Callstate Change ACTIVE -> HANGUP 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/3500) State HANGUP 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [DEBUG] switch_core_state_machine.c:60 verto.rtc/3500 Standard HANGUP, cause: NORMAL_CLEARING 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/3500) State HANGUP going to sleep 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [DEBUG] switch_core_state_machine.c:620 (verto.rtc/3500) State Change CS_HANGUP -> CS_REPORTING 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_REPORTING (Cur 4 Tot 101) 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.193148 [DEBUG] switch_core_state_machine.c:936 (verto.rtc/3500) State REPORTING 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.195147 [DEBUG] switch_core_state_machine.c:174 verto.rtc/3500 Standard REPORTING, cause: NORMAL_CLEARING 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.195147 [DEBUG] switch_core_state_machine.c:936 (verto.rtc/3500) State REPORTING going to sleep 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.195147 [DEBUG] switch_core_state_machine.c:611 (verto.rtc/3500) State Change CS_REPORTING -> CS_DESTROY 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.195147 [DEBUG] switch_core_session.c:1714 Session 3 (verto.rtc/3500) Locked, Waiting on external entities 2018-11-20 20:47:36.201148 [DEBUG] switch_core_media.c:7470 verto.rtc/3500 Video thread ended 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.203148 [NOTICE] switch_core_session.c:1732 Session 3 (verto.rtc/3500) Ended 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.203148 [NOTICE] switch_core_session.c:1736 Close Channel verto.rtc/3500 [CS_DESTROY] 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.203148 [DEBUG] switch_core_state_machine.c:739 (verto.rtc/3500) Running State Change CS_DESTROY (Cur 3 Tot 101) 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.203148 [DEBUG] switch_core_state_machine.c:749 (verto.rtc/3500) State DESTROY 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.203148 [DEBUG] mod_rtc.c:132 verto.rtc/3500 RTC DESTROY 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.203148 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[95811] PLC[28] FEC[0] 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.203148 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0] 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.203148 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0] 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.203148 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[97051] Bytes encoded[13658827] Encoded length ms[1941020] Average encoded bitrate bps[56296] Nvenc unloaded 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.294146 [DEBUG] switch_core_state_machine.c:181 verto.rtc/3500 Standard DESTROY 1a1be434-d0ba-c76f-9b7b-57fef47147df 2018-11-20 20:47:36.294146 [DEBUG] switch_core_state_machine.c:749 (verto.rtc/3500) State DESTROY going to sleep e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.693146 [DEBUG] switch_ivr_play_say.c:1937 done playing file C:/Program Files/FreeSWITCH/sounds/en/us/callie/conference/conf-kicked.wav e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.693146 [NOTICE] switch_core_state_machine.c:386 verto.rtc/3500 has executed the last dialplan instruction, hanging up. e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.693146 [NOTICE] switch_core_state_machine.c:388 Hangup verto.rtc/3500 [CS_EXECUTE] [NORMAL_CLEARING] e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.693146 [DEBUG] switch_core_state_machine.c:651 (verto.rtc/3500) State EXECUTE going to sleep e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.693146 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_HANGUP (Cur 3 Tot 101) e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.693146 [DEBUG] switch_core_state_machine.c:848 (verto.rtc/3500) Callstate Change ACTIVE -> HANGUP e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.693146 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/3500) State HANGUP e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.693146 [DEBUG] switch_core_state_machine.c:60 verto.rtc/3500 Standard HANGUP, cause: NORMAL_CLEARING e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.693146 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/3500) State HANGUP going to sleep e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.695148 [DEBUG] switch_core_state_machine.c:620 (verto.rtc/3500) State Change CS_HANGUP -> CS_REPORTING e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.695148 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_REPORTING (Cur 3 Tot 101) e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.695148 [DEBUG] switch_core_state_machine.c:936 (verto.rtc/3500) State REPORTING e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.695148 [DEBUG] switch_core_state_machine.c:174 verto.rtc/3500 Standard REPORTING, cause: NORMAL_CLEARING e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.695148 [DEBUG] switch_core_state_machine.c:936 (verto.rtc/3500) State REPORTING going to sleep e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.695148 [DEBUG] switch_core_state_machine.c:611 (verto.rtc/3500) State Change CS_REPORTING -> CS_DESTROY e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.695148 [DEBUG] switch_core_session.c:1714 Session 16 (verto.rtc/3500) Locked, Waiting on external entities 2018-11-20 20:47:36.701149 [DEBUG] switch_core_media.c:7470 verto.rtc/3500 Video thread ended e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.701149 [NOTICE] switch_core_session.c:1732 Session 16 (verto.rtc/3500) Ended e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.701149 [NOTICE] switch_core_session.c:1736 Close Channel verto.rtc/3500 [CS_DESTROY] e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.701149 [DEBUG] switch_core_state_machine.c:739 (verto.rtc/3500) Running State Change CS_DESTROY (Cur 2 Tot 101) e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.701149 [DEBUG] switch_core_state_machine.c:749 (verto.rtc/3500) State DESTROY e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.701149 [DEBUG] mod_rtc.c:132 verto.rtc/3500 RTC DESTROY e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.701149 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[84075] PLC[0] FEC[0] e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.701149 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0] e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.701149 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0] e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.701149 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[84219] Bytes encoded[13065190] Encoded length ms[1684380] Average encoded bitrate bps[62067] Nvenc unloaded e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.789192 [DEBUG] switch_core_state_machine.c:181 verto.rtc/3500 Standard DESTROY e8506d34-b60f-ee35-50ba-f411ce12052d 2018-11-20 20:47:36.789192 [DEBUG] switch_core_state_machine.c:749 (verto.rtc/3500) State DESTROY going to sleep 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.793147 [DEBUG] switch_ivr_play_say.c:1937 done playing file C:/Program Files/FreeSWITCH/sounds/en/us/callie/conference/conf-kicked.wav 2018-11-20 20:47:36.793147 [DEBUG] mod_conference.c:839 Write Lock OFF 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.793147 [NOTICE] switch_core_state_machine.c:386 verto.rtc/3500 has executed the last dialplan instruction, hanging up. 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.793147 [NOTICE] switch_core_state_machine.c:388 Hangup verto.rtc/3500 [CS_EXECUTE] [NORMAL_CLEARING] 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.795146 [DEBUG] switch_core_state_machine.c:651 (verto.rtc/3500) State EXECUTE going to sleep 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.795146 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_HANGUP (Cur 2 Tot 101) 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.795146 [DEBUG] switch_core_state_machine.c:848 (verto.rtc/3500) Callstate Change ACTIVE -> HANGUP 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.795146 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/3500) State HANGUP 2018-11-20 20:47:36.797147 [DEBUG] switch_core_media.c:7470 verto.rtc/3500 Video thread ended 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] switch_core_state_machine.c:60 verto.rtc/3500 Standard HANGUP, cause: NORMAL_CLEARING 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/3500) State HANGUP going to sleep 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] switch_core_state_machine.c:620 (verto.rtc/3500) State Change CS_HANGUP -> CS_REPORTING 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_REPORTING (Cur 2 Tot 101) 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] switch_core_state_machine.c:936 (verto.rtc/3500) State REPORTING 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] switch_core_state_machine.c:174 verto.rtc/3500 Standard REPORTING, cause: NORMAL_CLEARING 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] switch_core_state_machine.c:936 (verto.rtc/3500) State REPORTING going to sleep 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] switch_core_state_machine.c:611 (verto.rtc/3500) State Change CS_REPORTING -> CS_DESTROY 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] switch_core_session.c:1714 Session 22 (verto.rtc/3500) Locked, Waiting on external entities 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [NOTICE] switch_core_session.c:1732 Session 22 (verto.rtc/3500) Ended 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [NOTICE] switch_core_session.c:1736 Close Channel verto.rtc/3500 [CS_DESTROY] 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] switch_core_state_machine.c:739 (verto.rtc/3500) Running State Change CS_DESTROY (Cur 1 Tot 101) 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] switch_core_state_machine.c:749 (verto.rtc/3500) State DESTROY 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] mod_rtc.c:132 verto.rtc/3500 RTC DESTROY 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[79982] PLC[0] FEC[0] 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0] 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0] 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.797147 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[80087] Bytes encoded[10205403] Encoded length ms[1601740] Average encoded bitrate bps[50995] Nvenc unloaded 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.887148 [DEBUG] switch_core_state_machine.c:181 verto.rtc/3500 Standard DESTROY 0a5269e9-e54a-13b2-533e-4aafd73e57b5 2018-11-20 20:47:36.887148 [DEBUG] switch_core_state_machine.c:749 (verto.rtc/3500) State DESTROY going to sleep 2018-11-20 20:47:37.881235 [WARNING] mod_verto.c:1885 98.142.70.152:61665 Client sent close request 2018-11-20 20:47:37.903232 [DEBUG] mod_verto.c:2030 98.142.70.152:61665 Ending client thread. 2018-11-20 20:47:37.903232 [DEBUG] mod_verto.c:2038 98.142.70.152:61665 Thread ended 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [WARNING] switch_core_state_machine.c:688 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 sofia/internal/1000@137.135.122.137 Abandoned 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [NOTICE] switch_core_state_machine.c:691 Hangup sofia/internal/1000@137.135.122.137 [CS_NEW] [WRONG_CALL_STATE] 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/1000@137.135.122.137) Running State Change CS_HANGUP (Cur 1 Tot 101) 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:848 (sofia/internal/1000@137.135.122.137) Callstate Change DOWN -> HANGUP 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1000@137.135.122.137) State HANGUP 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] mod_sofia.c:449 Channel sofia/internal/1000@137.135.122.137 hanging up, cause: WRONG_CALL_STATE 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1000@137.135.122.137 Standard HANGUP, cause: WRONG_CALL_STATE 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:850 (sofia/internal/1000@137.135.122.137) State HANGUP going to sleep 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:620 (sofia/internal/1000@137.135.122.137) State Change CS_HANGUP -> CS_REPORTING 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:585 (sofia/internal/1000@137.135.122.137) Running State Change CS_REPORTING (Cur 1 Tot 101) 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/1000@137.135.122.137) State REPORTING 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:174 sofia/internal/1000@137.135.122.137 Standard REPORTING, cause: WRONG_CALL_STATE 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:936 (sofia/internal/1000@137.135.122.137) State REPORTING going to sleep 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:611 (sofia/internal/1000@137.135.122.137) State Change CS_REPORTING -> CS_DESTROY 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_session.c:1714 Session 101 (sofia/internal/1000@137.135.122.137) Locked, Waiting on external entities 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [NOTICE] switch_core_session.c:1732 Session 101 (sofia/internal/1000@137.135.122.137) Ended 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [NOTICE] switch_core_session.c:1736 Close Channel sofia/internal/1000@137.135.122.137 [CS_DESTROY] 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:739 (sofia/internal/1000@137.135.122.137) Running State Change CS_DESTROY (Cur 0 Tot 101) 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/1000@137.135.122.137) State DESTROY 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] mod_sofia.c:354 sofia/internal/1000@137.135.122.137 SOFIA DESTROY 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:181 sofia/internal/1000@137.135.122.137 Standard DESTROY 04fd9d8c-1c30-462b-b91c-e137d83fe3e4 2018-11-20 20:47:38.987801 [DEBUG] switch_core_state_machine.c:749 (sofia/internal/1000@137.135.122.137) State DESTROY going to sleep 2018-11-20 20:47:40.253801 [DEBUG] mod_verto.c:4250 98.142.70.152:63442 Client Connect from 98.142.70.152:63442 accepted 2018-11-20 20:47:40.255230 [DEBUG] mod_verto.c:2003 98.142.70.152:63442 Starting client thread. 2018-11-20 20:47:40.431241 [DEBUG] mod_verto.c:1306 98.142.70.152:63442 re-connecting session ca458acc-4540-537e-00c6-5739e5ae885e 2018-11-20 20:47:40.482306 [DEBUG] mod_verto.c:1055 auth using username & password 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.032034 [DEBUG] mod_rtc.c:392 () State Change CS_NEW -> CS_INIT 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.032034 [DEBUG] switch_core_session.c:641 N/A set UUID=38fe7832-f853-8ef1-d577-c72ffb25d0b9 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.032034 [NOTICE] switch_channel.c:1104 New Channel verto.rtc/3500 [38fe7832-f853-8ef1-d577-c72ffb25d0b9] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.032034 [DEBUG] mod_verto.c:3779 Remote SDP verto.rtc/3500: 38fe7832-f853-8ef1-d577-c72ffb25d0b9 v=0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 o=- 3661229245671475910 2 IN IP4 127.0.0.1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 s=- 38fe7832-f853-8ef1-d577-c72ffb25d0b9 t=0 0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=group:BUNDLE audio video 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=msid-semantic: WMS p8JDrtHiFxtZF9J0KTbGX5i6hb4GLFsujv92 38fe7832-f853-8ef1-d577-c72ffb25d0b9 m=audio 7126 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126 38fe7832-f853-8ef1-d577-c72ffb25d0b9 c=IN IP4 98.144.128.103 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp:9 IN IP4 0.0.0.0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:940563199 1 udp 2122262783 2605:a000:1401:e4:88cf:1152:7f96:7320 49466 typ host generation 0 network-id 2 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:3956764112 1 udp 2122194687 10.0.1.244 51062 typ host generation 0 network-id 1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:150399804 1 udp 1685987071 98.144.128.103 7126 typ srflx raddr 10.0.1.244 rport 51062 generation 0 network-id 1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:1988896271 1 tcp 1518283007 2605:a000:1401:e4:88cf:1152:7f96:7320 9 typ host tcptype active generation 0 network-id 2 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:2773782816 1 tcp 1518214911 10.0.1.244 9 typ host tcptype active generation 0 network-id 1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ice-ufrag:Rx0B 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ice-pwd:+d7R+M3ODoAbwuy31JNVWALH 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ice-options:trickle 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fingerprint:sha-256 B5:2F:CF:7F:13:FC:C6:7A:68:21:9C:81:F3:CF:B8:82:D6:5E:EB:98:78:3D:99:54:10:E9:D3:5B:02:7A:D0:92 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=setup:actpass 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=mid:audio 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=sendrecv 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-mux 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:111 opus/48000/2 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:111 transport-cc 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fmtp:111 minptime=10;useinbandfec=1; stereo=1; sprop-stereo=1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:103 ISAC/16000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:104 ISAC/32000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:9 G722/8000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:0 PCMU/8000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:8 PCMA/8000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:106 CN/32000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:105 CN/16000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:13 CN/8000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:110 telephone-event/48000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:112 telephone-event/32000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:113 telephone-event/16000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:126 telephone-event/8000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:3105446125 cname:iTRaSHco1U6838vZ 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:3105446125 msid:p8JDrtHiFxtZF9J0KTbGX5i6hb4GLFsujv92 722759af-f686-43af-b589-ae3119b17607 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:3105446125 mslabel:p8JDrtHiFxtZF9J0KTbGX5i6hb4GLFsujv92 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:3105446125 label:722759af-f686-43af-b589-ae3119b17607 38fe7832-f853-8ef1-d577-c72ffb25d0b9 m=video 58608 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 123 127 122 125 107 108 109 124 38fe7832-f853-8ef1-d577-c72ffb25d0b9 c=IN IP4 98.144.128.103 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp:9 IN IP4 0.0.0.0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:940563199 1 udp 2122262783 2605:a000:1401:e4:88cf:1152:7f96:7320 51063 typ host generation 0 network-id 2 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:3956764112 1 udp 2122194687 10.0.1.244 59703 typ host generation 0 network-id 1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:150399804 1 udp 1685987071 98.144.128.103 58608 typ srflx raddr 10.0.1.244 rport 59703 generation 0 network-id 1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:1988896271 1 tcp 1518283007 2605:a000:1401:e4:88cf:1152:7f96:7320 9 typ host tcptype active generation 0 network-id 2 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:2773782816 1 tcp 1518214911 10.0.1.244 9 typ host tcptype active generation 0 network-id 1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ice-ufrag:Rx0B 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ice-pwd:+d7R+M3ODoAbwuy31JNVWALH 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ice-options:trickle 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fingerprint:sha-256 B5:2F:CF:7F:13:FC:C6:7A:68:21:9C:81:F3:CF:B8:82:D6:5E:EB:98:78:3D:99:54:10:E9:D3:5B:02:7A:D0:92 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=setup:actpass 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=mid:video 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=extmap:2 urn:ietf:params:rtp-hdrext:toffset 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=extmap:4 urn:3gpp:video-orientation 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=extmap:5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/video-timing 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=sendrecv 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-mux 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-rsize 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:96 VP8/90000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:96 goog-remb 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:96 transport-cc 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:96 ccm fir 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:96 nack 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:96 nack pli 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:97 rtx/90000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fmtp:97 apt=96 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:98 VP9/90000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:98 goog-remb 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:98 transport-cc 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:98 ccm fir 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:98 nack 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:98 nack pli 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fmtp:98 x-google-profile-id=0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:99 rtx/90000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fmtp:99 apt=98 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:100 H264/90000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:100 goog-remb 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:100 transport-cc 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:100 ccm fir 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:100 nack 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:100 nack pli 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:101 rtx/90000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fmtp:101 apt=100 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:102 H264/90000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:102 goog-remb 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:102 transport-cc 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:102 ccm fir 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:102 nack 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:102 nack pli 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fmtp:102 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f a=rtpmap:123 rtx/90000 a=fmtp:123 apt=102 a=rtpmap:127 H264/90000 a=rtcp-fb:127 goog-remb a=rtcp-fb:127 transport-cc a=rtcp-fb:127 ccm fir a=rtcp-fb:127 nack a=rtcp-fb:127 nack pli a=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f a=rtpmap:122 rtx/90000 a=fmtp:122 apt=127 a=rtpmap:125 H264/90000 a=rtcp-fb:125 goog-remb a=rtcp-fb:125 transport-cc a=rtcp-fb:125 ccm fir a=rtcp-fb:125 nack a=rtcp-fb:125 nack pli a=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f a=rtpmap:107 rtx/90000 a=fmtp:107 apt=125 a=rtpmap:108 red/90000 a=rtpmap:109 rtx/90000 a=fmtp:109 apt=108 a=rtpmap:124 ulpfec/90000 a=ssrc-group:FID 3390098715 2244733256 a=ssrc:3390098715 cname:iTRaSHco1U6838vZ a=ssrc:3390098715 msid:p8JDrtHiFxtZF9J0KTbGX5i6hb4GLFsujv92 f0913725-8892-48f6-8daf-aed710ef4472 a=ssrc:3390098715 mslabel:p8JDrtHiFxtZF9J0KTbGX5i6hb4GLFsujv92 a=ssrc:3390098715 label:f0913725-8892-48f6-8daf-aed710ef4472 a=ssrc:2244733256 cname:iTRaSHco1U6838vZ a=ssrc:2244733256 msid:p8JDrtHiFxtZF9J0KTbGX5i6hb4GLFsujv92 f0913725-8892-48f6-8daf-aed710ef4472 a=ssrc:2244733256 mslabel:p8JDrtHiFxtZF9J0KTbGX5i6hb4GLFsujv92 a=ssrc:2244733256 label:f0913725-8892-48f6-8daf-aed710ef4472 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.032034 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_INIT (Cur 1 Tot 102) 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.032034 [DEBUG] switch_core_state_machine.c:628 (verto.rtc/3500) State INIT 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.032034 [DEBUG] switch_core_state_machine.c:40 verto.rtc/3500 Standard INIT 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.032034 [DEBUG] switch_core_state_machine.c:48 (verto.rtc/3500) State Change CS_INIT -> CS_ROUTING 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.032034 [DEBUG] switch_core_state_machine.c:628 (verto.rtc/3500) State INIT going to sleep 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.032034 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_ROUTING (Cur 1 Tot 102) 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.032034 [DEBUG] switch_channel.c:2249 (verto.rtc/3500) Callstate Change DOWN -> RINGING 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_state_machine.c:644 (verto.rtc/3500) State ROUTING 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] mod_rtc.c:89 verto.rtc/3500 RTC ROUTING 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_state_machine.c:236 verto.rtc/3500 Standard ROUTING 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [INFO] mod_dialplan_xml.c:637 Processing Anthony Minessale ->3500 in context default 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->unloop] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->tod_example] continue=true 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Date/TimeMatch (FAIL) [tod_example] break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->holiday_example] continue=true 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Date/TimeMatch (FAIL) [holiday_example] break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->global-intercept] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [global-intercept] destination_number(3500) =~ /^886$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->group-intercept] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [group-intercept] destination_number(3500) =~ /^\*8$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->intercept-ext] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [intercept-ext] destination_number(3500) =~ /^\*\*(\d+)$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->redial] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [redial] destination_number(3500) =~ /^(redial|870)$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->global] continue=true 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${default_password}(123456) =~ /^1234$/ break=never 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${endpoint_disposition}() =~ /^(DELAYED NEGOTIATION)/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->snom-demo-2] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [snom-demo-2] destination_number(3500) =~ /^9001$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->snom-demo-1] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [snom-demo-1] destination_number(3500) =~ /^9000$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->eavesdrop] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [eavesdrop] destination_number(3500) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->eavesdrop] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [eavesdrop] destination_number(3500) =~ /^779$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->call_return] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [call_return] destination_number(3500) =~ /^\*69$|^869$|^lcr$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->del-group] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [del-group] destination_number(3500) =~ /^80(\d{2})$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->add-group] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [add-group] destination_number(3500) =~ /^81(\d{2})$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->call-group-simo] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [call-group-simo] destination_number(3500) =~ /^82(\d{2})$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->call-group-order] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [call-group-order] destination_number(3500) =~ /^83(\d{2})$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->extension-intercom] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [extension-intercom] destination_number(3500) =~ /^8(10[01][0-9])$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->Local_Extension] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [Local_Extension] destination_number(3500) =~ /^(10[01][0-9])$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->Local_Extension_Skinny] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [Local_Extension_Skinny] destination_number(3500) =~ /^(11[01][0-9])$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->group_dial_sales] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [group_dial_sales] destination_number(3500) =~ /^2000$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->group_dial_support] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [group_dial_support] destination_number(3500) =~ /^2001$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->group_dial_billing] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [group_dial_billing] destination_number(3500) =~ /^2002$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->operator] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [operator] destination_number(3500) =~ /^(operator|0)$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->vmain] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [vmain] destination_number(3500) =~ /^vmain$|^4000$|^\*98$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->sip_uri] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [sip_uri] destination_number(3500) =~ /^sip:(.*)$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->nb_conferences] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [nb_conferences] destination_number(3500) =~ /^(30\d{2})$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->wb_conferences] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [wb_conferences] destination_number(3500) =~ /^(31\d{2})$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->uwb_conferences] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [uwb_conferences] destination_number(3500) =~ /^(32\d{2})$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->cdquality_conferences] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [cdquality_conferences] destination_number(3500) =~ /^(33\d{2})$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->cdquality_stereo_conferences] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [cdquality_stereo_conferences] destination_number(3500) =~ /^(35\d{2}).*?-screen$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->conference-canvases] continue=true 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [conference-canvases] destination_number(3500) =~ /(35\d{2})-canvas-(\d+)/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->conf mod] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (FAIL) [conf mod] destination_number(3500) =~ /^6070-moderator$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 parsing [default->cdquality_conferences] continue=false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Regex (PASS) [cdquality_conferences] destination_number(3500) =~ /^(35\d{2})$/ break=on-false 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Action answer() 38fe7832-f853-8ef1-d577-c72ffb25d0b9 Dialplan: verto.rtc/3500 Action conference(3500-${domain_name}@video-mcu-stereo) 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_state_machine.c:287 (verto.rtc/3500) State Change CS_ROUTING -> CS_EXECUTE 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_state_machine.c:644 (verto.rtc/3500) State ROUTING going to sleep 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_EXECUTE (Cur 1 Tot 102) 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_state_machine.c:651 (verto.rtc/3500) State EXECUTE 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] mod_rtc.c:120 verto.rtc/3500 RTC EXECUTE 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_state_machine.c:329 verto.rtc/3500 Standard EXECUTE 38fe7832-f853-8ef1-d577-c72ffb25d0b9 EXECUTE verto.rtc/3500 answer() 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [opus:111:48000:20:0:2]/[opus:116:48000:20:0:1] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:5552 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[opus:116:48000:20:0:1] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[opus:116:48000:20:0:1] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [CN:106:32000:20:0:1]/[opus:116:48000:20:0:1] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [CN:105:16000:20:0:1]/[opus:116:48000:20:0:1] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [CN:13:8000:20:0:1]/[opus:116:48000:20:0:1] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:5413 Set telephone-event payload to 110@48000 2018-11-20 20:47:43.034038 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps] 2018-11-20 20:47:43.034038 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:3781 Set Codec verto.rtc/3500 opus/48000 20 ms 960 samples 0 bits 2 channels 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_codec.c:111 verto.rtc/3500 Original read codec set to opus:116 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:4205 Drop audio Candidate cid: 1 proto: udp type: host addr: 2605:a000:1401:e4:88cf:1152:7f96:7320:49466 (no network path) 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: udp type: host addr: 10.0.1.244:51062 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.034038 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: udp type: srflx addr: 98.144.128.103:7126 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4256 Searching for rtp candidate. 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4265 Choose rtp candidate, index 1, 98.144.128.103:7126 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4031 verto.rtc/3500 choosing family v4 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4276 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 98.144.128.103:7126 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4328 setting remote audio ice addr to index 1 98.144.128.103:7126 based on candidate 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4363 Setting remote rtcp audio addr to 98.144.128.103:7126 based on candidate 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:5756 Set telephone-event payload to 110@48000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:5814 verto.rtc/3500 Set 2833 dtmf send payload to 110 recv payload to 110 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [VP8:96]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:97]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [VP9:98]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:99]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:100]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:100] +++ is saved as a match 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:101]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:102]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:102] +++ is saved as a match 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:123]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:127]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:127] +++ is saved as a match 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:122]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:125]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:125] +++ is saved as a match 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:107]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [red:108]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:109]/[H264:99] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:6098 Video Codec Compare [ulpfec:124]/[H264:99] 2018-11-20 20:47:43.036036 [NOTICE] avcodec.c:1345 codec: id=28 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 2018-11-20 20:47:43.036036 [NOTICE] avcodec.c:1345 codec: id=28 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:3591 Set VIDEO Codec verto.rtc/3500 H264/90000 0 ms 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4205 Drop video Candidate cid: 1 proto: udp type: host addr: 2605:a000:1401:e4:88cf:1152:7f96:7320:51063 (no network path) 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4211 Save video Candidate cid: 1 proto: udp type: host addr: 10.0.1.244:59703 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4211 Save video Candidate cid: 1 proto: udp type: srflx addr: 98.144.128.103:58608 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4256 Searching for rtp candidate. 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4265 Choose rtp candidate, index 1, 98.144.128.103:58608 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4031 verto.rtc/3500 choosing family v4 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4276 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 98.144.128.103:58608 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4328 setting remote video ice addr to index 1 98.144.128.103:58608 based on candidate 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:4363 Setting remote rtcp video addr to 98.144.128.103:58608 based on candidate 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:8511 AUDIO RTP [verto.rtc/3500] 10.0.0.5 port 16522 -> 98.144.128.103 port 7126 codec: 111 ms: 20 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_rtp.c:4296 Starting timer [soft] 960 bytes per 20ms 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [INFO] switch_core_media.c:8690 Activating Audio ICE 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [NOTICE] switch_rtp.c:4795 Activating RTP audio ICE: Rx0B:LcQUNYeWb97txrpb 98.144.128.103:7126 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_core_media.c:8731 Activating RTCP PORT 7126 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [DEBUG] switch_rtp.c:4692 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 7126 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [INFO] switch_core_media.c:8742 Skipping RTCP ICE (Same as RTP) 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.036036 [INFO] switch_rtp.c:3665 Activate RTP/RTCP audio DTLS client 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.038034 [INFO] switch_rtp.c:3828 Changing audio DTLS state from OFF to HANDSHAKE 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.038034 [DEBUG] switch_core_media.c:2543 Setting Jitterbuffer to 20ms (1 frames) (50 max frames) 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.038034 [DEBUG] switch_core_media.c:8815 verto.rtc/3500 Set 2833 dtmf send payload to 110 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.038034 [DEBUG] switch_core_media.c:8822 verto.rtc/3500 Set 2833 dtmf receive payload to 110 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.038034 [DEBUG] switch_rtp.c:4311 Starting video timer. 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.038034 [DEBUG] switch_core_media.c:9342 VIDEO RTP [verto.rtc/3500] 10.0.0.5:16966->98.144.128.103:58608 codec: 100 ms: 0 [SUCCESS] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.038034 [DEBUG] switch_core_media.c:7503 verto.rtc/3500 Starting Video thread 2018-11-20 20:47:43.038034 [DEBUG] switch_core_media.c:7369 verto.rtc/3500 Video thread started. Echo is off 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.040033 [INFO] switch_core_media.c:9384 Activating Video ICE 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.040033 [NOTICE] switch_rtp.c:4795 Activating RTP video ICE: Rx0B:cMgFOgAMDDRemTer 98.144.128.103:58608 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.040033 [INFO] switch_core_media.c:9422 Activating VIDEO RTCP PORT 58608 interval 1000 mux 1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.040033 [DEBUG] switch_rtp.c:4692 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 58608 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.040033 [INFO] switch_core_media.c:9435 Skipping VIDEO RTCP ICE (Same as VIDEO RTP) 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.040033 [INFO] switch_rtp.c:3665 Activate RTP/RTCP video DTLS client 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.040033 [INFO] switch_rtp.c:3828 Changing video DTLS state from OFF to HANDSHAKE 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.040033 [DEBUG] switch_core_media.c:8494 Audio params are unchanged for verto.rtc/3500. 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.040033 [DEBUG] switch_core_media.c:9200 Video params are unchanged for verto.rtc/3500. 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.040033 [DEBUG] mod_verto.c:2502 Local SDP verto.rtc/3500: 38fe7832-f853-8ef1-d577-c72ffb25d0b9 v=0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 o=FreeSWITCH 1542730341 1542730342 IN IP4 137.135.122.137 38fe7832-f853-8ef1-d577-c72ffb25d0b9 s=FreeSWITCH 38fe7832-f853-8ef1-d577-c72ffb25d0b9 c=IN IP4 137.135.122.137 38fe7832-f853-8ef1-d577-c72ffb25d0b9 t=0 0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=msid-semantic: WMS J2h5yBqBMv1oWQvTVJxZIGA8eXFuLvCL 38fe7832-f853-8ef1-d577-c72ffb25d0b9 m=audio 16522 UDP/TLS/RTP/SAVPF 111 110 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:111 opus/48000/2 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fmtp:111 useinbandfec=1; minptime=10; stereo=1; sprop-stereo=1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:110 telephone-event/48000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=silenceSupp:off - - - - 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ptime:20 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=sendrecv 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fingerprint:sha-256 24:75:FE:94:82:E8:4F:24:32:AB:5E:71:35:C4:91:76:32:3A:9D:B9:68:22:77:06:E4:DA:80:DA:0E:9E:39:5E 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=setup:active 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-mux 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp:16522 IN IP4 137.135.122.137 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ice-ufrag:LcQUNYeWb97txrpb 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ice-pwd:iFQRrcCj2a8Ano8nn3OaQo62 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:7152065483 1 udp 659136 137.135.122.137 16522 typ host generation 0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=end-of-candidates 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:2862699143 cname:SdzziMCZmLoh4uSm 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:2862699143 msid:J2h5yBqBMv1oWQvTVJxZIGA8eXFuLvCL a0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:2862699143 mslabel:J2h5yBqBMv1oWQvTVJxZIGA8eXFuLvCL 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:2862699143 label:J2h5yBqBMv1oWQvTVJxZIGA8eXFuLvCLa0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 m=video 16966 UDP/TLS/RTP/SAVPF 100 38fe7832-f853-8ef1-d577-c72ffb25d0b9 b=AS:1024 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtpmap:100 H264/90000 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=sendrecv 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=fingerprint:sha-256 24:75:FE:94:82:E8:4F:24:32:AB:5E:71:35:C4:91:76:32:3A:9D:B9:68:22:77:06:E4:DA:80:DA:0E:9E:39:5E 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=setup:active 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-mux 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp:16966 IN IP4 137.135.122.137 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:100 ccm fir 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:100 nack 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=rtcp-fb:100 nack pli 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:2091346999 cname:SdzziMCZmLoh4uSm 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:2091346999 msid:J2h5yBqBMv1oWQvTVJxZIGA8eXFuLvCL v0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:2091346999 mslabel:J2h5yBqBMv1oWQvTVJxZIGA8eXFuLvCL 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ssrc:2091346999 label:J2h5yBqBMv1oWQvTVJxZIGA8eXFuLvCLv0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ice-ufrag:cMgFOgAMDDRemTer 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=ice-pwd:jtFoClB2Yo6EEXcsRhP5mAzt 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=candidate:3465035080 1 udp 659136 137.135.122.137 16966 typ host generation 0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 a=end-of-candidates 38fe7832-f853-8ef1-d577-c72ffb25d0b9 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.040033 [NOTICE] mod_dptools.c:1377 Channel [verto.rtc/3500] has been answered 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.042036 [DEBUG] switch_channel.c:3781 (verto.rtc/3500) Callstate Change RINGING -> ACTIVE 38fe7832-f853-8ef1-d577-c72ffb25d0b9 EXECUTE verto.rtc/3500 conference(3500-137.135.122.137@video-mcu-stereo) 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:304 Adding layout group grid 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 1x1 to layout group grid 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 2x1 to layout group grid 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 1x1+2x1 to layout group grid 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 2x2 to layout group grid 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 3x3 to layout group grid 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 4x4 to layout group grid 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 5x5 to layout group grid 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 6x6 to layout group grid 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 8x8 to layout group grid 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:304 Adding layout group grid-zoom 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 1x1 to layout group grid-zoom 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 2x1-zoom to layout group grid-zoom 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 3x1-zoom to layout group grid-zoom 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 2x2 to layout group grid-zoom 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 5-grid-zoom to layout group grid-zoom 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 3x2-zoom to layout group grid-zoom 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 7-grid-zoom to layout group grid-zoom 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 4x2-zoom to layout group grid-zoom 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 3x3 to layout group grid-zoom 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:304 Adding layout group 1up_top_left_plus 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 1up_top_left+5 to layout group 1up_top_left_plus 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 1up_top_left+7 to layout group 1up_top_left_plus 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 1up_top_left+9 to layout group 1up_top_left_plus 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:304 Adding layout group 3up_plus 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 3up+4 to layout group 3up_plus 2018-11-20 20:47:43.042036 [DEBUG] conference_video.c:313 Adding node 3up+9 to layout group 3up_plus 2018-11-20 20:47:43.042036 [DEBUG] mod_conference.c:3387 using channel sound prefix: C:/Program Files/FreeSWITCH/sounds/en/us/callie 2018-11-20 20:47:43.046040 [DEBUG] conference_video.c:1689 Canvas position 1 applied layout 1x1 2018-11-20 20:47:43.046040 [DEBUG] conference_video.c:1810 Layout set to 1x1 2018-11-20 20:47:43.046040 [DEBUG] conference_video.c:1770 Canvas attached to position 0 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.046040 [DEBUG] conference_member.c:1758 Raw Codec Activation Success L16@48000hz 2 channel 20ms 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.046040 [DEBUG] conference_member.c:1805 Raw Codec Activation Success L16@48000hz 2 channel 20ms 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.046040 [DEBUG] switch_core_codec.c:223 verto.rtc/3500 Push codec L16:100 2018-11-20 20:47:43.046040 [WARNING] switch_time.c:738 Increasing global timer resolution to 1ms to handle interval 33 2018-11-20 20:47:43.046040 [INFO] switch_time.c:615 Clock synchronized to system time. 2018-11-20 20:47:43.046040 [DEBUG] mod_conference.c:233 Setup timer success interval: 20 samples: 960 2018-11-20 20:47:43.058036 [DEBUG] switch_core_file.c:386 File C:/Program Files/FreeSWITCH/sounds/en/us/callie/conference/conf-alone.wav sample rate 32000 doesn't match requested rate 48000 2018-11-20 20:47:43.060039 [WARNING] switch_core_file.c:405 File has 1 channels, muxing to 2 channels will occur. 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '0' to 'mute' 2018-11-20 20:47:43.060039 [INFO] switch_ivr_async.c:219 Digit parser mod_conference: Setting realm to 'conf' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 0/conf/0 callback: 0000023A3F511F10 data: 0000023A492C9708 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '*' to 'deaf mute' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding */conf/0 callback: 0000023A3F511F10 data: 0000023A492C9738 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '9' to 'energy up' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 9/conf/0 callback: 0000023A3F511F10 data: 0000023A492C9768 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '8' to 'energy equ' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 8/conf/0 callback: 0000023A3F511F10 data: 0000023A492C9798 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '7' to 'energy dn' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 7/conf/0 callback: 0000023A3F511F10 data: 0000023A492C97C8 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '3' to 'vol talk up' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 3/conf/0 callback: 0000023A3F511F10 data: 0000023A492C97F8 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '2' to 'vol talk zero' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 2/conf/0 callback: 0000023A3F511F10 data: 0000023A492C9828 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '1' to 'vol talk dn' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 1/conf/0 callback: 0000023A3F511F10 data: 0000023A492C9858 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '6' to 'vol listen up' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 6/conf/0 callback: 0000023A3F511F10 data: 0000023A492C9888 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '5' to 'vol listen zero' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 5/conf/0 callback: 0000023A3F511F10 data: 0000023A492C98B8 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '4' to 'vol listen dn' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 4/conf/0 callback: 0000023A3F511F10 data: 0000023A492C5928 2018-11-20 20:47:43.060039 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '#' to 'hangup' 2018-11-20 20:47:43.060039 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding #/conf/0 callback: 0000023A3F511F10 data: 0000023A492C5958 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:43.060039 [DEBUG] conference_loop.c:1338 Setup timer soft success interval: 20 samples: 960 from codec opus 2018-11-20 20:47:43.064035 [INFO] avcodec.c:1404 initializing encoder 1920x1080 2018-11-20 20:47:43.064035 [NOTICE] avcodec.c:1139 NVENC HW CODEC ENABLED Loaded Nvenc version 8.0 Nvenc initialized successfully 1 CUDA capable devices found [ GPU #0 - < Tesla K80 > has Compute SM 3.7 ] 2018-11-20 20:47:43.155035 [ERR] mod_verto.c:4040 MCAST Data Sent supports NVENC 2018-11-20 20:47:43.218034 [INFO] avcodec.c:1289 codec opened: Video: h264 (nvenc_h264) (Baseline), yuv420p, 1920x1080, 3145 kb/s Nvenc unloaded Loaded Nvenc version 8.0 Nvenc initialized successfully 1 CUDA capable devices found [ GPU #0 - < Tesla K80 > has Compute SM 3.7 ] supports NVENC 2018-11-20 20:47:43.434034 [INFO] avcodec.c:1289 codec opened: Video: h264 (nvenc_h264) (Baseline), yuv420p, 1920x1080, 3145 kb/s 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.236755 [NOTICE] switch_rtp.c:1280 Auto Changing video stun/rtp/dtls port from 98.144.128.103:58608 to 98.144.128.103:58082 idx:1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.254755 [NOTICE] switch_rtp.c:1280 Auto Changing audio stun/rtp/dtls port from 98.144.128.103:7126 to 98.144.128.103:57396 idx:1 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.358755 [INFO] switch_rtp.c:3202 Changing video DTLS state from HANDSHAKE to SETUP 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.394756 [INFO] switch_rtp.c:3202 Changing audio DTLS state from HANDSHAKE to SETUP 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.394756 [INFO] switch_rtp.c:3109 video Fingerprint Verified. 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.394756 [INFO] switch_rtp.c:4100 Activating video Secure RTP SEND 2018-11-20 20:47:44.394756 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.394756 [INFO] switch_rtp.c:4078 Activating video Secure RTP RECV 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.394756 [INFO] switch_rtp.c:3151 Changing video DTLS state from SETUP to READY 2018-11-20 20:47:44.394756 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.394756 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: video ssrc[3390098715] base_seq[27205] 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.414755 [INFO] switch_rtp.c:3109 audio Fingerprint Verified. 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.414755 [INFO] switch_rtp.c:4100 Activating audio Secure RTP SEND 2018-11-20 20:47:44.414755 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.414755 [INFO] switch_rtp.c:4078 Activating audio Secure RTP RECV 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.414755 [INFO] switch_rtp.c:3151 Changing audio DTLS state from SETUP to READY 2018-11-20 20:47:44.414755 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 38fe7832-f853-8ef1-d577-c72ffb25d0b9 2018-11-20 20:47:44.453754 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: audio ssrc[3105446125] base_seq[25628] Reinit context to 720x416, pix_fmt: yuv420p 2018-11-20 20:47:45.794264 [DEBUG] mod_local_stream.c:907 Opening Stream [moh/48000] 48000hz 2018-11-20 20:47:45.794264 [WARNING] switch_core_file.c:405 File has 1 channels, muxing to 2 channels will occur. Reinit context to 960x544, pix_fmt: yuv420p 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.849130 [DEBUG] mod_rtc.c:392 () State Change CS_NEW -> CS_INIT 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.849130 [DEBUG] switch_core_session.c:641 N/A set UUID=06125006-7929-5350-76d8-1364b3c8ad72 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.849130 [NOTICE] switch_channel.c:1104 New Channel verto.rtc/3500 [06125006-7929-5350-76d8-1364b3c8ad72] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.851132 [DEBUG] mod_verto.c:3779 Remote SDP verto.rtc/3500: 06125006-7929-5350-76d8-1364b3c8ad72 v=0 06125006-7929-5350-76d8-1364b3c8ad72 o=- 8312289971842574796 2 IN IP4 127.0.0.1 06125006-7929-5350-76d8-1364b3c8ad72 s=- 06125006-7929-5350-76d8-1364b3c8ad72 t=0 0 06125006-7929-5350-76d8-1364b3c8ad72 a=group:BUNDLE audio video 06125006-7929-5350-76d8-1364b3c8ad72 a=msid-semantic: WMS 51Cb844cYLKzqXt3Qj9D5BgKk2waR6XBimWQ 06125006-7929-5350-76d8-1364b3c8ad72 m=audio 52228 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126 06125006-7929-5350-76d8-1364b3c8ad72 c=IN IP4 98.142.70.152 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp:9 IN IP4 0.0.0.0 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:3471666979 1 udp 2122262783 2001:470:1f0f:4ff:2cd4:1172:458f:3bc5 58561 typ host generation 0 network-id 2 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:2998815840 1 udp 2122194687 192.168.2.41 52228 typ host generation 0 network-id 1 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:4073414875 1 udp 2122131711 2001:470:1f0f:4ff:e991:d5e6:6a5e:47b5 52229 typ host generation 0 network-id 4 network-cost 10 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:3364391820 1 udp 2122063615 192.168.2.124 62901 typ host generation 0 network-id 3 network-cost 10 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:1152267700 1 udp 1685987071 98.142.70.152 52228 typ srflx raddr 192.168.2.41 rport 52228 generation 0 network-id 1 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:1237355832 1 udp 1685855999 98.142.70.152 62901 typ srflx raddr 192.168.2.124 rport 62901 generation 0 network-id 3 network-cost 10 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:2154730451 1 tcp 1518283007 2001:470:1f0f:4ff:2cd4:1172:458f:3bc5 9 typ host tcptype active generation 0 network-id 2 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:4231901328 1 tcp 1518214911 192.168.2.41 9 typ host tcptype active generation 0 network-id 1 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:3158875179 1 tcp 1518151935 2001:470:1f0f:4ff:e991:d5e6:6a5e:47b5 9 typ host tcptype active generation 0 network-id 4 network-cost 10 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:2248898428 1 tcp 1518083839 192.168.2.124 9 typ host tcptype active generation 0 network-id 3 network-cost 10 06125006-7929-5350-76d8-1364b3c8ad72 a=ice-ufrag:NkqS 06125006-7929-5350-76d8-1364b3c8ad72 a=ice-pwd:T995lC4BZYFeP3jKYqWj/laB 06125006-7929-5350-76d8-1364b3c8ad72 a=ice-options:trickle 06125006-7929-5350-76d8-1364b3c8ad72 a=fingerprint:sha-256 D6:72:BA:E9:DD:36:68:A0:67:52:3F:22:92:64:33:5B:03:F1:09:94:4A:B3:9F:B5:41:E2:E3:07:24:B0:A1:B9 06125006-7929-5350-76d8-1364b3c8ad72 a=setup:actpass 06125006-7929-5350-76d8-1364b3c8ad72 a=mid:audio 06125006-7929-5350-76d8-1364b3c8ad72 a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level 06125006-7929-5350-76d8-1364b3c8ad72 a=sendrecv 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-mux 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:111 opus/48000/2 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:111 transport-cc 06125006-7929-5350-76d8-1364b3c8ad72 a=fmtp:111 minptime=10;useinbandfec=1; stereo=1; sprop-stereo=1 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:103 ISAC/16000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:104 ISAC/32000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:9 G722/8000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:0 PCMU/8000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:8 PCMA/8000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:106 CN/32000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:105 CN/16000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:13 CN/8000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:110 telephone-event/48000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:112 telephone-event/32000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:113 telephone-event/16000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:126 telephone-event/8000 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:3317970407 cname:Y8/PanLZ4ddgVAVY 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:3317970407 msid:51Cb844cYLKzqXt3Qj9D5BgKk2waR6XBimWQ cbd20c90-b4c7-4ed5-a76a-c2a63e2ca706 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:3317970407 mslabel:51Cb844cYLKzqXt3Qj9D5BgKk2waR6XBimWQ 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:3317970407 label:cbd20c90-b4c7-4ed5-a76a-c2a63e2ca706 06125006-7929-5350-76d8-1364b3c8ad72 m=video 50199 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 123 127 122 125 107 108 109 124 06125006-7929-5350-76d8-1364b3c8ad72 c=IN IP4 98.142.70.152 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp:9 IN IP4 0.0.0.0 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:3471666979 1 udp 2122262783 2001:470:1f0f:4ff:2cd4:1172:458f:3bc5 62902 typ host generation 0 network-id 2 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:2998815840 1 udp 2122194687 192.168.2.41 50199 typ host generation 0 network-id 1 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:4073414875 1 udp 2122131711 2001:470:1f0f:4ff:e991:d5e6:6a5e:47b5 50200 typ host generation 0 network-id 4 network-cost 10 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:3364391820 1 udp 2122063615 192.168.2.124 54475 typ host generation 0 network-id 3 network-cost 10 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:1152267700 1 udp 1685987071 98.142.70.152 50199 typ srflx raddr 192.168.2.41 rport 50199 generation 0 network-id 1 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:1237355832 1 udp 1685855999 98.142.70.152 54475 typ srflx raddr 192.168.2.124 rport 54475 generation 0 network-id 3 network-cost 10 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:2154730451 1 tcp 1518283007 2001:470:1f0f:4ff:2cd4:1172:458f:3bc5 9 typ host tcptype active generation 0 network-id 2 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:4231901328 1 tcp 1518214911 192.168.2.41 9 typ host tcptype active generation 0 network-id 1 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:3158875179 1 tcp 1518151935 2001:470:1f0f:4ff:e991:d5e6:6a5e:47b5 9 typ host tcptype active generation 0 network-id 4 network-cost 10 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:2248898428 1 tcp 1518083839 192.168.2.124 9 typ host tcptype active generation 0 network-id 3 network-cost 10 06125006-7929-5350-76d8-1364b3c8ad72 a=ice-ufrag:NkqS 06125006-7929-5350-76d8-1364b3c8ad72 a=ice-pwd:T995lC4BZYFeP3jKYqWj/laB 06125006-7929-5350-76d8-1364b3c8ad72 a=ice-options:trickle 06125006-7929-5350-76d8-1364b3c8ad72 a=fingerprint:sha-256 D6:72:BA:E9:DD:36:68:A0:67:52:3F:22:92:64:33:5B:03:F1:09:94:4A:B3:9F:B5:41:E2:E3:07:24:B0:A1:B9 06125006-7929-5350-76d8-1364b3c8ad72 a=setup:actpass 06125006-7929-5350-76d8-1364b3c8ad72 a=mid:video 06125006-7929-5350-76d8-1364b3c8ad72 a=extmap:2 urn:ietf:params:rtp-hdrext:toffset 06125006-7929-5350-76d8-1364b3c8ad72 a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time 06125006-7929-5350-76d8-1364b3c8ad72 a=extmap:4 urn:3gpp:video-orientation 06125006-7929-5350-76d8-1364b3c8ad72 a=extmap:5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01 06125006-7929-5350-76d8-1364b3c8ad72 a=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay 06125006-7929-5350-76d8-1364b3c8ad72 a=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type 06125006-7929-5350-76d8-1364b3c8ad72 a=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/video-timing 06125006-7929-5350-76d8-1364b3c8ad72 a=extmap:10 http://tools.ietf.org/html/draft-ietf-avtext-framemarking-07 06125006-7929-5350-76d8-1364b3c8ad72 a=sendrecv 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-mux 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-rsize 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:96 VP8/90000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:96 goog-remb 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:96 transport-cc 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:96 ccm fir 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:96 nack 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:96 nack pli 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:97 rtx/90000 06125006-7929-5350-76d8-1364b3c8ad72 a=fmtp:97 apt=96 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:98 VP9/90000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:98 goog-remb 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:98 transport-cc 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:98 ccm fir 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:98 nack 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:98 nack pli 06125006-7929-5350-76d8-1364b3c8ad72 a=fmtp:98 profile-id=0 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:99 rtx/90000 06125006-7929-5350-76d8-1364b3c8ad72 a=fmtp:99 apt=98 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:100 H264/90000 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:100 goog-remb 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:100 transport-cc 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:100 ccm fir 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:100 nack a=rtcp-fb:100 nack pli a=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f a=rtpmap:101 rtx/90000 a=fmtp:101 apt=100 a=rtpmap:102 H264/90000 a=rtcp-fb:102 goog-remb a=rtcp-fb:102 transport-cc a=rtcp-fb:102 ccm fir a=rtcp-fb:102 nack a=rtcp-fb:102 nack pli a=fmtp:102 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f a=rtpmap:123 rtx/90000 a=fmtp:123 apt=102 a=rtpmap:127 H264/90000 a=rtcp-fb:127 goog-remb a=rtcp-fb:127 transport-cc a=rtcp-fb:127 ccm fir a=rtcp-fb:127 nack a=rtcp-fb:127 nack pli a=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f a=rtpmap:122 rtx/90000 a=fmtp:122 apt=127 a=rtpmap:125 H264/90000 a=rtcp-fb:125 goog-remb a=rtcp-fb:125 transport-cc a=rtcp-fb:125 ccm fir a=rtcp-fb:125 nack a=rtcp-fb:125 nack pli a=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f a=rtpmap:107 rtx/90000 a=fmtp:107 apt=125 a=rtpmap:108 red/90000 a=rtpmap:109 rtx/90000 a=fmtp:109 apt=108 a=rtpmap:124 ulpfec/90000 a=ssrc-group:FID 3265324966 2357682930 a=ssrc:3265324966 cname:Y8/PanLZ4ddgVAVY a=ssrc:3265324966 msid:51Cb844cYLKzqXt3Qj9D5BgKk2waR6XBimWQ 4dd50fea-e724-487c-aec4-16127f205648 a=ssrc:3265324966 mslabel:51Cb844cYLKzqXt3Qj9D5BgKk2waR6XBimWQ a=ssrc:3265324966 label:4dd50fea-e724-487c-aec4-16127f205648 a=ssrc:2357682930 cname:Y8/PanLZ4ddgVAVY a=ssrc:2357682930 msid:51Cb844cYLKzqXt3Qj9D5BgKk2waR6XBimWQ 4dd50fea-e724-487c-aec4-16127f205648 a=ssrc:2357682930 mslabel:51Cb844cYLKzqXt3Qj9D5BgKk2waR6XBimWQ a=ssrc:2357682930 label:4dd50fea-e724-487c-aec4-16127f205648 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.853131 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_INIT (Cur 2 Tot 103) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.853131 [DEBUG] switch_core_state_machine.c:628 (verto.rtc/3500) State INIT 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.853131 [DEBUG] switch_core_state_machine.c:40 verto.rtc/3500 Standard INIT 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.853131 [DEBUG] switch_core_state_machine.c:48 (verto.rtc/3500) State Change CS_INIT -> CS_ROUTING 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.853131 [DEBUG] switch_core_state_machine.c:628 (verto.rtc/3500) State INIT going to sleep 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.853131 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_ROUTING (Cur 2 Tot 103) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.853131 [DEBUG] switch_channel.c:2249 (verto.rtc/3500) Callstate Change DOWN -> RINGING 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.853131 [DEBUG] switch_core_state_machine.c:644 (verto.rtc/3500) State ROUTING 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.853131 [DEBUG] mod_rtc.c:89 verto.rtc/3500 RTC ROUTING 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.853131 [DEBUG] switch_core_state_machine.c:236 verto.rtc/3500 Standard ROUTING 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.853131 [INFO] mod_dialplan_xml.c:637 Processing Brian West - McAlester, OK ->3500 in context default 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->unloop] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->tod_example] continue=true 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Date/TimeMatch (FAIL) [tod_example] break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->holiday_example] continue=true 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Date/TimeMatch (FAIL) [holiday_example] break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->global-intercept] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [global-intercept] destination_number(3500) =~ /^886$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->group-intercept] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [group-intercept] destination_number(3500) =~ /^\*8$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->intercept-ext] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [intercept-ext] destination_number(3500) =~ /^\*\*(\d+)$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->redial] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [redial] destination_number(3500) =~ /^(redial|870)$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->global] continue=true 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${default_password}(123456) =~ /^1234$/ break=never 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${endpoint_disposition}() =~ /^(DELAYED NEGOTIATION)/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->snom-demo-2] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [snom-demo-2] destination_number(3500) =~ /^9001$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->snom-demo-1] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [snom-demo-1] destination_number(3500) =~ /^9000$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->eavesdrop] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [eavesdrop] destination_number(3500) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->eavesdrop] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [eavesdrop] destination_number(3500) =~ /^779$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->call_return] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [call_return] destination_number(3500) =~ /^\*69$|^869$|^lcr$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->del-group] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [del-group] destination_number(3500) =~ /^80(\d{2})$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->add-group] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [add-group] destination_number(3500) =~ /^81(\d{2})$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->call-group-simo] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [call-group-simo] destination_number(3500) =~ /^82(\d{2})$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->call-group-order] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [call-group-order] destination_number(3500) =~ /^83(\d{2})$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->extension-intercom] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [extension-intercom] destination_number(3500) =~ /^8(10[01][0-9])$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->Local_Extension] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [Local_Extension] destination_number(3500) =~ /^(10[01][0-9])$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->Local_Extension_Skinny] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [Local_Extension_Skinny] destination_number(3500) =~ /^(11[01][0-9])$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->group_dial_sales] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [group_dial_sales] destination_number(3500) =~ /^2000$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->group_dial_support] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [group_dial_support] destination_number(3500) =~ /^2001$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->group_dial_billing] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [group_dial_billing] destination_number(3500) =~ /^2002$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->operator] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [operator] destination_number(3500) =~ /^(operator|0)$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->vmain] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [vmain] destination_number(3500) =~ /^vmain$|^4000$|^\*98$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->sip_uri] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [sip_uri] destination_number(3500) =~ /^sip:(.*)$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->nb_conferences] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [nb_conferences] destination_number(3500) =~ /^(30\d{2})$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->wb_conferences] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [wb_conferences] destination_number(3500) =~ /^(31\d{2})$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->uwb_conferences] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [uwb_conferences] destination_number(3500) =~ /^(32\d{2})$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->cdquality_conferences] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [cdquality_conferences] destination_number(3500) =~ /^(33\d{2})$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->cdquality_stereo_conferences] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [cdquality_stereo_conferences] destination_number(3500) =~ /^(35\d{2}).*?-screen$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->conference-canvases] continue=true 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [conference-canvases] destination_number(3500) =~ /(35\d{2})-canvas-(\d+)/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->conf mod] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (FAIL) [conf mod] destination_number(3500) =~ /^6070-moderator$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 parsing [default->cdquality_conferences] continue=false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Regex (PASS) [cdquality_conferences] destination_number(3500) =~ /^(35\d{2})$/ break=on-false 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Action answer() 06125006-7929-5350-76d8-1364b3c8ad72 Dialplan: verto.rtc/3500 Action conference(3500-${domain_name}@video-mcu-stereo) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_state_machine.c:287 (verto.rtc/3500) State Change CS_ROUTING -> CS_EXECUTE 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_state_machine.c:644 (verto.rtc/3500) State ROUTING going to sleep 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_EXECUTE (Cur 2 Tot 103) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_state_machine.c:651 (verto.rtc/3500) State EXECUTE 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] mod_rtc.c:120 verto.rtc/3500 RTC EXECUTE 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_state_machine.c:329 verto.rtc/3500 Standard EXECUTE 06125006-7929-5350-76d8-1364b3c8ad72 EXECUTE verto.rtc/3500 answer() 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [opus:111:48000:20:0:2]/[opus:116:48000:20:0:1] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5552 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[opus:116:48000:20:0:1] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[opus:116:48000:20:0:1] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [CN:106:32000:20:0:1]/[opus:116:48000:20:0:1] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [CN:105:16000:20:0:1]/[opus:116:48000:20:0:1] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [CN:13:8000:20:0:1]/[opus:116:48000:20:0:1] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5413 Set telephone-event payload to 110@48000 2018-11-20 20:47:48.855132 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps] 2018-11-20 20:47:48.855132 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:3781 Set Codec verto.rtc/3500 opus/48000 20 ms 960 samples 0 bits 2 channels 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_codec.c:111 verto.rtc/3500 Original read codec set to opus:116 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4205 Drop audio Candidate cid: 1 proto: udp type: host addr: 2001:470:1f0f:4ff:2cd4:1172:458f:3bc5:58561 (no network path) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.2.41:52228 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4205 Drop audio Candidate cid: 1 proto: udp type: host addr: 2001:470:1f0f:4ff:e991:d5e6:6a5e:47b5:52229 (no network path) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.2.124:62901 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: udp type: srflx addr: 98.142.70.152:52228 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: udp type: srflx addr: 98.142.70.152:62901 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4256 Searching for rtp candidate. 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4265 Choose rtp candidate, index 2, 98.142.70.152:52228 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4031 verto.rtc/3500 choosing family v4 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4276 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 98.142.70.152:52228 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4328 setting remote audio ice addr to index 2 98.142.70.152:52228 based on candidate 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:4363 Setting remote rtcp audio addr to 98.142.70.152:52228 based on candidate 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5756 Set telephone-event payload to 110@48000 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:5814 verto.rtc/3500 Set 2833 dtmf send payload to 110 recv payload to 110 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:6098 Video Codec Compare [VP8:96]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:97]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.855132 [DEBUG] switch_core_media.c:6098 Video Codec Compare [VP9:98]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:99]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:100]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:100] +++ is saved as a match 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:101]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:102]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:102] +++ is saved as a match 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:123]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:127]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:127] +++ is saved as a match 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:122]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:125]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:125] +++ is saved as a match 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:107]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [red:108]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:109]/[H264:99] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:6098 Video Codec Compare [ulpfec:124]/[H264:99] 2018-11-20 20:47:48.857131 [NOTICE] avcodec.c:1345 codec: id=28 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 2018-11-20 20:47:48.857131 [NOTICE] avcodec.c:1345 codec: id=28 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:3591 Set VIDEO Codec verto.rtc/3500 H264/90000 0 ms 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4205 Drop video Candidate cid: 1 proto: udp type: host addr: 2001:470:1f0f:4ff:2cd4:1172:458f:3bc5:62902 (no network path) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4211 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.2.41:50199 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4205 Drop video Candidate cid: 1 proto: udp type: host addr: 2001:470:1f0f:4ff:e991:d5e6:6a5e:47b5:50200 (no network path) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4211 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.2.124:54475 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4211 Save video Candidate cid: 1 proto: udp type: srflx addr: 98.142.70.152:50199 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4211 Save video Candidate cid: 1 proto: udp type: srflx addr: 98.142.70.152:54475 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4256 Searching for rtp candidate. 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4265 Choose rtp candidate, index 2, 98.142.70.152:50199 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4031 verto.rtc/3500 choosing family v4 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4276 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 98.142.70.152:50199 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4328 setting remote video ice addr to index 2 98.142.70.152:50199 based on candidate 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:4363 Setting remote rtcp video addr to 98.142.70.152:50199 based on candidate 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:8511 AUDIO RTP [verto.rtc/3500] 10.0.0.5 port 16482 -> 98.142.70.152 port 52228 codec: 111 ms: 20 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_rtp.c:4296 Starting timer [soft] 960 bytes per 20ms 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [INFO] switch_core_media.c:8690 Activating Audio ICE 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [NOTICE] switch_rtp.c:4795 Activating RTP audio ICE: NkqS:OypHrewYb1feTM70 98.142.70.152:52228 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_core_media.c:8731 Activating RTCP PORT 52228 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [DEBUG] switch_rtp.c:4692 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 52228 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [INFO] switch_core_media.c:8742 Skipping RTCP ICE (Same as RTP) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.857131 [INFO] switch_rtp.c:3665 Activate RTP/RTCP audio DTLS client 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.859130 [INFO] switch_rtp.c:3828 Changing audio DTLS state from OFF to HANDSHAKE 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.859130 [DEBUG] switch_core_media.c:2543 Setting Jitterbuffer to 20ms (1 frames) (50 max frames) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.859130 [DEBUG] switch_core_media.c:8815 verto.rtc/3500 Set 2833 dtmf send payload to 110 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.859130 [DEBUG] switch_core_media.c:8822 verto.rtc/3500 Set 2833 dtmf receive payload to 110 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.859130 [DEBUG] switch_rtp.c:4311 Starting video timer. 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.859130 [DEBUG] switch_core_media.c:9342 VIDEO RTP [verto.rtc/3500] 10.0.0.5:16934->98.142.70.152:50199 codec: 100 ms: 0 [SUCCESS] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.859130 [DEBUG] switch_core_media.c:7503 verto.rtc/3500 Starting Video thread 2018-11-20 20:47:48.871132 [DEBUG] switch_core_media.c:7369 verto.rtc/3500 Video thread started. Echo is off 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.873133 [INFO] switch_core_media.c:9384 Activating Video ICE 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.873133 [NOTICE] switch_rtp.c:4795 Activating RTP video ICE: NkqS:t796GBGTj0lZNjTw 98.142.70.152:50199 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.873133 [INFO] switch_core_media.c:9422 Activating VIDEO RTCP PORT 50199 interval 1000 mux 1 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.873133 [DEBUG] switch_rtp.c:4692 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 50199 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.873133 [INFO] switch_core_media.c:9435 Skipping VIDEO RTCP ICE (Same as VIDEO RTP) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.873133 [INFO] switch_rtp.c:3665 Activate RTP/RTCP video DTLS client 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.873133 [INFO] switch_rtp.c:3828 Changing video DTLS state from OFF to HANDSHAKE 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.873133 [DEBUG] switch_core_media.c:8494 Audio params are unchanged for verto.rtc/3500. 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.873133 [DEBUG] switch_core_media.c:9200 Video params are unchanged for verto.rtc/3500. 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.873133 [DEBUG] mod_verto.c:2502 Local SDP verto.rtc/3500: 06125006-7929-5350-76d8-1364b3c8ad72 v=0 06125006-7929-5350-76d8-1364b3c8ad72 o=FreeSWITCH 1542730386 1542730387 IN IP4 137.135.122.137 06125006-7929-5350-76d8-1364b3c8ad72 s=FreeSWITCH 06125006-7929-5350-76d8-1364b3c8ad72 c=IN IP4 137.135.122.137 06125006-7929-5350-76d8-1364b3c8ad72 t=0 0 06125006-7929-5350-76d8-1364b3c8ad72 a=msid-semantic: WMS sDRoj01UsSPEIIkquq7cTZLedegs0CmX 06125006-7929-5350-76d8-1364b3c8ad72 m=audio 16482 UDP/TLS/RTP/SAVPF 111 110 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:111 opus/48000/2 06125006-7929-5350-76d8-1364b3c8ad72 a=fmtp:111 useinbandfec=1; minptime=10; stereo=1; sprop-stereo=1 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:110 telephone-event/48000 06125006-7929-5350-76d8-1364b3c8ad72 a=silenceSupp:off - - - - 06125006-7929-5350-76d8-1364b3c8ad72 a=ptime:20 06125006-7929-5350-76d8-1364b3c8ad72 a=sendrecv 06125006-7929-5350-76d8-1364b3c8ad72 a=fingerprint:sha-256 24:75:FE:94:82:E8:4F:24:32:AB:5E:71:35:C4:91:76:32:3A:9D:B9:68:22:77:06:E4:DA:80:DA:0E:9E:39:5E 06125006-7929-5350-76d8-1364b3c8ad72 a=setup:active 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-mux 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp:16482 IN IP4 137.135.122.137 06125006-7929-5350-76d8-1364b3c8ad72 a=ice-ufrag:OypHrewYb1feTM70 06125006-7929-5350-76d8-1364b3c8ad72 a=ice-pwd:cFUupyeSc5I3dQeXD9fzzvR7 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:9505173877 1 udp 659136 137.135.122.137 16482 typ host generation 0 06125006-7929-5350-76d8-1364b3c8ad72 a=end-of-candidates 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:2785849212 cname:FIx1BKgvZwzccevI 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:2785849212 msid:sDRoj01UsSPEIIkquq7cTZLedegs0CmX a0 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:2785849212 mslabel:sDRoj01UsSPEIIkquq7cTZLedegs0CmX 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:2785849212 label:sDRoj01UsSPEIIkquq7cTZLedegs0CmXa0 06125006-7929-5350-76d8-1364b3c8ad72 m=video 16934 UDP/TLS/RTP/SAVPF 100 06125006-7929-5350-76d8-1364b3c8ad72 b=AS:1024 06125006-7929-5350-76d8-1364b3c8ad72 a=rtpmap:100 H264/90000 06125006-7929-5350-76d8-1364b3c8ad72 a=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f 06125006-7929-5350-76d8-1364b3c8ad72 a=sendrecv 06125006-7929-5350-76d8-1364b3c8ad72 a=fingerprint:sha-256 24:75:FE:94:82:E8:4F:24:32:AB:5E:71:35:C4:91:76:32:3A:9D:B9:68:22:77:06:E4:DA:80:DA:0E:9E:39:5E 06125006-7929-5350-76d8-1364b3c8ad72 a=setup:active 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-mux 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp:16934 IN IP4 137.135.122.137 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:100 ccm fir 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:100 nack 06125006-7929-5350-76d8-1364b3c8ad72 a=rtcp-fb:100 nack pli 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:2014497066 cname:FIx1BKgvZwzccevI 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:2014497066 msid:sDRoj01UsSPEIIkquq7cTZLedegs0CmX v0 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:2014497066 mslabel:sDRoj01UsSPEIIkquq7cTZLedegs0CmX 06125006-7929-5350-76d8-1364b3c8ad72 a=ssrc:2014497066 label:sDRoj01UsSPEIIkquq7cTZLedegs0CmXv0 06125006-7929-5350-76d8-1364b3c8ad72 a=ice-ufrag:t796GBGTj0lZNjTw 06125006-7929-5350-76d8-1364b3c8ad72 a=ice-pwd:VSB5fRdtCa0fYImqbJQWOPcv 06125006-7929-5350-76d8-1364b3c8ad72 a=candidate:9461876591 1 udp 659136 137.135.122.137 16934 typ host generation 0 06125006-7929-5350-76d8-1364b3c8ad72 a=end-of-candidates 06125006-7929-5350-76d8-1364b3c8ad72 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.873133 [NOTICE] mod_dptools.c:1377 Channel [verto.rtc/3500] has been answered 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.875132 [DEBUG] switch_channel.c:3781 (verto.rtc/3500) Callstate Change RINGING -> ACTIVE 06125006-7929-5350-76d8-1364b3c8ad72 EXECUTE verto.rtc/3500 conference(3500-137.135.122.137@video-mcu-stereo) 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.875132 [DEBUG] conference_member.c:1758 Raw Codec Activation Success L16@48000hz 2 channel 20ms 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.875132 [DEBUG] conference_member.c:1805 Raw Codec Activation Success L16@48000hz 2 channel 20ms 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.875132 [DEBUG] switch_core_codec.c:223 verto.rtc/3500 Push codec L16:100 2018-11-20 20:47:48.889133 [WARNING] switch_core_file.c:405 File has 1 channels, muxing to 2 channels will occur. 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '0' to 'mute' 2018-11-20 20:47:48.889133 [INFO] switch_ivr_async.c:219 Digit parser mod_conference: Setting realm to 'conf' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 0/conf/0 callback: 0000023A3F511F10 data: 0000023A45A8B338 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '*' to 'deaf mute' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding */conf/0 callback: 0000023A3F511F10 data: 0000023A45A8B368 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '9' to 'energy up' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 9/conf/0 callback: 0000023A3F511F10 data: 0000023A45A8B398 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '8' to 'energy equ' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 8/conf/0 callback: 0000023A3F511F10 data: 0000023A45A8B3C8 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '7' to 'energy dn' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 7/conf/0 callback: 0000023A3F511F10 data: 0000023A45A8B3F8 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '3' to 'vol talk up' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 3/conf/0 callback: 0000023A3F511F10 data: 0000023A45A8B428 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '2' to 'vol talk zero' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 2/conf/0 callback: 0000023A3F511F10 data: 0000023A45A8B458 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '1' to 'vol talk dn' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 1/conf/0 callback: 0000023A3F511F10 data: 0000023A45A8B488 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '6' to 'vol listen up' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 6/conf/0 callback: 0000023A3F511F10 data: 0000023A45A8B4B8 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '5' to 'vol listen zero' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 5/conf/0 callback: 0000023A3F511F10 data: 0000023A45A8B4E8 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '4' to 'vol listen dn' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 4/conf/0 callback: 0000023A3F511F10 data: 0000023A45A90588 2018-11-20 20:47:48.889133 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '#' to 'hangup' 2018-11-20 20:47:48.889133 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding #/conf/0 callback: 0000023A3F511F10 data: 0000023A45A905B8 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:48.891132 [DEBUG] conference_loop.c:1338 Setup timer soft success interval: 20 samples: 960 from codec opus 2018-11-20 20:47:48.910132 [INFO] avcodec.c:1404 initializing encoder 1920x1080 2018-11-20 20:47:48.910132 [NOTICE] avcodec.c:1139 NVENC HW CODEC ENABLED Loaded Nvenc version 8.0 Nvenc initialized successfully 1 CUDA capable devices found [ GPU #0 - < Tesla K80 > has Compute SM 3.7 ] 2018-11-20 20:47:48.948132 [ERR] mod_verto.c:4040 MCAST Data Sent supports NVENC 2018-11-20 20:47:49.016131 [INFO] avcodec.c:1289 codec opened: Video: h264 (nvenc_h264) (Baseline), yuv420p, 1920x1080, 3145 kb/s Nvenc unloaded Loaded Nvenc version 8.0 Nvenc initialized successfully 1 CUDA capable devices found [ GPU #0 - < Tesla K80 > has Compute SM 3.7 ] 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.133131 [INFO] switch_rtp.c:3202 Changing audio DTLS state from HANDSHAKE to SETUP 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.133131 [INFO] switch_rtp.c:3109 audio Fingerprint Verified. 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.133131 [INFO] switch_rtp.c:4100 Activating audio Secure RTP SEND 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.133131 [INFO] switch_rtp.c:4078 Activating audio Secure RTP RECV 2018-11-20 20:47:49.133131 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.133131 [INFO] switch_rtp.c:3151 Changing audio DTLS state from SETUP to READY 2018-11-20 20:47:49.133131 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 supports NVENC 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.173134 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: audio ssrc[3317970407] base_seq[9941] 2018-11-20 20:47:49.205132 [INFO] avcodec.c:1289 codec opened: Video: h264 (nvenc_h264) (Baseline), yuv420p, 1920x1080, 3145 kb/s 2018-11-20 20:47:49.245134 [DEBUG] conference_video.c:1689 Canvas position 1 applied layout 2x1 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.363132 [INFO] switch_rtp.c:3202 Changing video DTLS state from HANDSHAKE to SETUP 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.375132 [INFO] switch_rtp.c:3109 video Fingerprint Verified. 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.375132 [INFO] switch_rtp.c:4100 Activating video Secure RTP SEND 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.375132 [INFO] switch_rtp.c:4078 Activating video Secure RTP RECV 2018-11-20 20:47:49.375132 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.375132 [INFO] switch_rtp.c:3151 Changing video DTLS state from SETUP to READY 2018-11-20 20:47:49.375132 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 06125006-7929-5350-76d8-1364b3c8ad72 2018-11-20 20:47:49.375132 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: video ssrc[3265324966] base_seq[17315] Reinit context to 640x368, pix_fmt: yuv420p ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.642495 [DEBUG] mod_rtc.c:392 () State Change CS_NEW -> CS_INIT ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.642495 [DEBUG] switch_core_session.c:641 N/A set UUID=ef39ae06-1e9c-e64c-a9c9-0aace5cf414d ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.642495 [NOTICE] switch_channel.c:1104 New Channel verto.rtc/3500 [ef39ae06-1e9c-e64c-a9c9-0aace5cf414d] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.642495 [DEBUG] mod_verto.c:3779 Remote SDP verto.rtc/3500: ef39ae06-1e9c-e64c-a9c9-0aace5cf414d v=0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d o=- 2913611992540251268 2 IN IP4 127.0.0.1 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d s=- ef39ae06-1e9c-e64c-a9c9-0aace5cf414d t=0 0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=group:BUNDLE audio video ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=msid-semantic: WMS ppxJErVuFNUXon84SRGMc1fuReAJJHjuT449 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d m=audio 52476 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d c=IN IP4 95.182.77.38 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp:9 IN IP4 0.0.0.0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:4214507315 1 udp 2122260223 192.168.149.1 52475 typ host generation 0 network-id 1 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:2054126206 1 udp 2122194687 192.168.88.234 52476 typ host generation 0 network-id 2 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:1970018127 1 udp 2122129151 192.168.96.1 52477 typ host generation 0 network-id 3 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:2285800280 1 udp 2122063615 169.254.185.128 52478 typ host generation 0 network-id 4 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:3068282349 1 udp 1685987071 95.182.77.38 52476 typ srflx raddr 192.168.88.234 rport 52476 generation 0 network-id 2 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:3048717251 1 tcp 1518280447 192.168.149.1 9 typ host tcptype active generation 0 network-id 1 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:887916174 1 tcp 1518214911 192.168.88.234 9 typ host tcptype active generation 0 network-id 2 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:1005579199 1 tcp 1518149375 192.168.96.1 9 typ host tcptype active generation 0 network-id 3 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:3334305704 1 tcp 1518083839 169.254.185.128 9 typ host tcptype active generation 0 network-id 4 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ice-ufrag:ap3y ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ice-pwd:C6zzUl4bXgdHWzCmGx+npBma ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ice-options:trickle ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=fingerprint:sha-256 B9:9B:5C:BD:7C:2C:D9:CA:FC:CB:A4:19:EA:A5:DF:0F:1E:14:D5:72:8C:A4:FC:2C:08:E1:EA:EC:82:39:A0:B2 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=setup:actpass ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=mid:audio ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=sendrecv ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-mux ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:111 opus/48000/2 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:111 transport-cc ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=fmtp:111 minptime=10;useinbandfec=1; stereo=1; sprop-stereo=1 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:103 ISAC/16000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:104 ISAC/32000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:9 G722/8000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:0 PCMU/8000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:8 PCMA/8000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:106 CN/32000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:105 CN/16000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:13 CN/8000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:110 telephone-event/48000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:112 telephone-event/32000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:113 telephone-event/16000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:126 telephone-event/8000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:971570147 cname:ornc0cB1EFEtKfae ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:971570147 msid:ppxJErVuFNUXon84SRGMc1fuReAJJHjuT449 0e265e28-f281-47fb-81a7-76c6abbd5912 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:971570147 mslabel:ppxJErVuFNUXon84SRGMc1fuReAJJHjuT449 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:971570147 label:0e265e28-f281-47fb-81a7-76c6abbd5912 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d m=video 52480 UDP/TLS/RTP/SAVPF 96 97 98 99 100 101 102 123 127 122 125 107 108 109 124 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d c=IN IP4 95.182.77.38 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp:9 IN IP4 0.0.0.0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:4214507315 1 udp 2122260223 192.168.149.1 52479 typ host generation 0 network-id 1 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:2054126206 1 udp 2122194687 192.168.88.234 52480 typ host generation 0 network-id 2 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:1970018127 1 udp 2122129151 192.168.96.1 52481 typ host generation 0 network-id 3 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:2285800280 1 udp 2122063615 169.254.185.128 52482 typ host generation 0 network-id 4 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:3068282349 1 udp 1685987071 95.182.77.38 52480 typ srflx raddr 192.168.88.234 rport 52480 generation 0 network-id 2 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:3048717251 1 tcp 1518280447 192.168.149.1 9 typ host tcptype active generation 0 network-id 1 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:887916174 1 tcp 1518214911 192.168.88.234 9 typ host tcptype active generation 0 network-id 2 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:1005579199 1 tcp 1518149375 192.168.96.1 9 typ host tcptype active generation 0 network-id 3 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:3334305704 1 tcp 1518083839 169.254.185.128 9 typ host tcptype active generation 0 network-id 4 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ice-ufrag:ap3y ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ice-pwd:C6zzUl4bXgdHWzCmGx+npBma ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ice-options:trickle ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=fingerprint:sha-256 B9:9B:5C:BD:7C:2C:D9:CA:FC:CB:A4:19:EA:A5:DF:0F:1E:14:D5:72:8C:A4:FC:2C:08:E1:EA:EC:82:39:A0:B2 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=setup:actpass ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=mid:video ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=extmap:2 urn:ietf:params:rtp-hdrext:toffset ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=extmap:4 urn:3gpp:video-orientation ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=extmap:5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=extmap:7 http://www.webrtc.org/experiments/rtp-hdrext/video-content-type ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=extmap:8 http://www.webrtc.org/experiments/rtp-hdrext/video-timing ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=sendrecv ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-mux ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-rsize ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:96 VP8/90000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:96 goog-remb ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:96 transport-cc ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:96 ccm fir ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:96 nack ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:96 nack pli ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:97 rtx/90000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=fmtp:97 apt=96 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:98 VP9/90000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:98 goog-remb ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:98 transport-cc ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:98 ccm fir ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:98 nack ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:98 nack pli ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=fmtp:98 x-google-profile-id=0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:99 rtx/90000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=fmtp:99 apt=98 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:100 H264/90000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:100 goog-remb ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:100 transport-cc ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:100 ccm fir ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:100 nack ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:100 nack pli ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:101 rtx/90000 a=fmtp:101 apt=100 a=rtpmap:102 H264/90000 a=rtcp-fb:102 goog-remb a=rtcp-fb:102 transport-cc a=rtcp-fb:102 ccm fir a=rtcp-fb:102 nack a=rtcp-fb:102 nack pli a=fmtp:102 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42001f a=rtpmap:123 rtx/90000 a=fmtp:123 apt=102 a=rtpmap:127 H264/90000 a=rtcp-fb:127 goog-remb a=rtcp-fb:127 transport-cc a=rtcp-fb:127 ccm fir a=rtcp-fb:127 nack a=rtcp-fb:127 nack pli a=fmtp:127 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f a=rtpmap:122 rtx/90000 a=fmtp:122 apt=127 a=rtpmap:125 H264/90000 a=rtcp-fb:125 goog-remb a=rtcp-fb:125 transport-cc a=rtcp-fb:125 ccm fir a=rtcp-fb:125 nack a=rtcp-fb:125 nack pli a=fmtp:125 level-asymmetry-allowed=1;packetization-mode=0;profile-level-id=42e01f a=rtpmap:107 rtx/90000 a=fmtp:107 apt=125 a=rtpmap:108 red/90000 a=rtpmap:109 rtx/90000 a=fmtp:109 apt=108 a=rtpmap:124 ulpfec/90000 a=ssrc-group:FID 3580427659 4063806105 a=ssrc:3580427659 cname:ornc0cB1EFEtKfae a=ssrc:3580427659 msid:ppxJErVuFNUXon84SRGMc1fuReAJJHjuT449 2191e8e0-d2ff-415c-aea6-6ed327145765 a=ssrc:3580427659 mslabel:ppxJErVuFNUXon84SRGMc1fuReAJJHjuT449 a=ssrc:3580427659 label:2191e8e0-d2ff-415c-aea6-6ed327145765 a=ssrc:4063806105 cname:ornc0cB1EFEtKfae a=ssrc:4063806105 msid:ppxJErVuFNUXon84SRGMc1fuReAJJHjuT449 2191e8e0-d2ff-415c-aea6-6ed327145765 a=ssrc:4063806105 mslabel:ppxJErVuFNUXon84SRGMc1fuReAJJHjuT449 a=ssrc:4063806105 label:2191e8e0-d2ff-415c-aea6-6ed327145765 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.644494 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_INIT (Cur 3 Tot 104) ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.644494 [DEBUG] switch_core_state_machine.c:628 (verto.rtc/3500) State INIT ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.644494 [DEBUG] switch_core_state_machine.c:40 verto.rtc/3500 Standard INIT ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.644494 [DEBUG] switch_core_state_machine.c:48 (verto.rtc/3500) State Change CS_INIT -> CS_ROUTING ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.644494 [DEBUG] switch_core_state_machine.c:628 (verto.rtc/3500) State INIT going to sleep ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_ROUTING (Cur 3 Tot 104) ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_channel.c:2249 (verto.rtc/3500) Callstate Change DOWN -> RINGING ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_state_machine.c:644 (verto.rtc/3500) State ROUTING ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] mod_rtc.c:89 verto.rtc/3500 RTC ROUTING ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_state_machine.c:236 verto.rtc/3500 Standard ROUTING ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [INFO] mod_dialplan_xml.c:637 Processing Andrey Volk ->3500 in context default ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->unloop] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->tod_example] continue=true ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Date/TimeMatch (FAIL) [tod_example] break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->holiday_example] continue=true ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Date/TimeMatch (FAIL) [holiday_example] break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->global-intercept] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [global-intercept] destination_number(3500) =~ /^886$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->group-intercept] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [group-intercept] destination_number(3500) =~ /^\*8$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->intercept-ext] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [intercept-ext] destination_number(3500) =~ /^\*\*(\d+)$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->redial] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [redial] destination_number(3500) =~ /^(redial|870)$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->global] continue=true ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${default_password}(123456) =~ /^1234$/ break=never ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [global] ${endpoint_disposition}() =~ /^(DELAYED NEGOTIATION)/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->snom-demo-2] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [snom-demo-2] destination_number(3500) =~ /^9001$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->snom-demo-1] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [snom-demo-1] destination_number(3500) =~ /^9000$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->eavesdrop] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [eavesdrop] destination_number(3500) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->eavesdrop] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [eavesdrop] destination_number(3500) =~ /^779$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->call_return] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [call_return] destination_number(3500) =~ /^\*69$|^869$|^lcr$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->del-group] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [del-group] destination_number(3500) =~ /^80(\d{2})$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->add-group] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [add-group] destination_number(3500) =~ /^81(\d{2})$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->call-group-simo] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [call-group-simo] destination_number(3500) =~ /^82(\d{2})$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->call-group-order] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [call-group-order] destination_number(3500) =~ /^83(\d{2})$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->extension-intercom] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [extension-intercom] destination_number(3500) =~ /^8(10[01][0-9])$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->Local_Extension] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [Local_Extension] destination_number(3500) =~ /^(10[01][0-9])$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->Local_Extension_Skinny] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [Local_Extension_Skinny] destination_number(3500) =~ /^(11[01][0-9])$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->group_dial_sales] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [group_dial_sales] destination_number(3500) =~ /^2000$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->group_dial_support] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [group_dial_support] destination_number(3500) =~ /^2001$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->group_dial_billing] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [group_dial_billing] destination_number(3500) =~ /^2002$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->operator] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [operator] destination_number(3500) =~ /^(operator|0)$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->vmain] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [vmain] destination_number(3500) =~ /^vmain$|^4000$|^\*98$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->sip_uri] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [sip_uri] destination_number(3500) =~ /^sip:(.*)$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->nb_conferences] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [nb_conferences] destination_number(3500) =~ /^(30\d{2})$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->wb_conferences] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [wb_conferences] destination_number(3500) =~ /^(31\d{2})$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->uwb_conferences] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [uwb_conferences] destination_number(3500) =~ /^(32\d{2})$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->cdquality_conferences] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [cdquality_conferences] destination_number(3500) =~ /^(33\d{2})$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->cdquality_stereo_conferences] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [cdquality_stereo_conferences] destination_number(3500) =~ /^(35\d{2}).*?-screen$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->conference-canvases] continue=true ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [conference-canvases] destination_number(3500) =~ /(35\d{2})-canvas-(\d+)/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->conf mod] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (FAIL) [conf mod] destination_number(3500) =~ /^6070-moderator$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 parsing [default->cdquality_conferences] continue=false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Regex (PASS) [cdquality_conferences] destination_number(3500) =~ /^(35\d{2})$/ break=on-false ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Action answer() ef39ae06-1e9c-e64c-a9c9-0aace5cf414d Dialplan: verto.rtc/3500 Action conference(3500-${domain_name}@video-mcu-stereo) ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_state_machine.c:287 (verto.rtc/3500) State Change CS_ROUTING -> CS_EXECUTE ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_state_machine.c:644 (verto.rtc/3500) State ROUTING going to sleep ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_state_machine.c:585 (verto.rtc/3500) Running State Change CS_EXECUTE (Cur 3 Tot 104) ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_state_machine.c:651 (verto.rtc/3500) State EXECUTE ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] mod_rtc.c:120 verto.rtc/3500 RTC EXECUTE ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_state_machine.c:329 verto.rtc/3500 Standard EXECUTE ef39ae06-1e9c-e64c-a9c9-0aace5cf414d EXECUTE verto.rtc/3500 answer() ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [opus:111:48000:20:0:2]/[opus:116:48000:20:0:1] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:5552 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[opus:116:48000:20:0:1] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[opus:116:48000:20:0:1] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [CN:106:32000:20:0:1]/[opus:116:48000:20:0:1] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [CN:105:16000:20:0:1]/[opus:116:48000:20:0:1] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:5497 Audio Codec Compare [CN:13:8000:20:0:1]/[opus:116:48000:20:0:1] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:5413 Set telephone-event payload to 110@48000 2018-11-20 20:47:50.646495 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps] 2018-11-20 20:47:50.646495 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:3781 Set Codec verto.rtc/3500 opus/48000 20 ms 960 samples 0 bits 2 channels ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_codec.c:111 verto.rtc/3500 Original read codec set to opus:116 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.149.1:52475 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.88.234:52476 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.96.1:52477 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: udp type: host addr: 169.254.185.128:52478 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.646495 [DEBUG] switch_core_media.c:4211 Save audio Candidate cid: 1 proto: udp type: srflx addr: 95.182.77.38:52476 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4256 Searching for rtp candidate. ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4265 Choose rtp candidate, index 4, 95.182.77.38:52476 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4031 verto.rtc/3500 choosing family v4 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4276 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 95.182.77.38:52476 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4328 setting remote audio ice addr to index 4 95.182.77.38:52476 based on candidate ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4363 Setting remote rtcp audio addr to 95.182.77.38:52476 based on candidate ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:5756 Set telephone-event payload to 110@48000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:5814 verto.rtc/3500 Set 2833 dtmf send payload to 110 recv payload to 110 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [VP8:96]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:97]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [VP9:98]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:99]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:100]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:100] +++ is saved as a match ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:101]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:102]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:102] +++ is saved as a match ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:123]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:127]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:127] +++ is saved as a match ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:122]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [H264:125]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6130 Video Codec Compare [H264:125] +++ is saved as a match ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:107]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [red:108]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [rtx:109]/[H264:99] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:6098 Video Codec Compare [ulpfec:124]/[H264:99] 2018-11-20 20:47:50.648493 [NOTICE] avcodec.c:1345 codec: id=28 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 2018-11-20 20:47:50.648493 [NOTICE] avcodec.c:1345 codec: id=28 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:3591 Set VIDEO Codec verto.rtc/3500 H264/90000 0 ms ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4211 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.149.1:52479 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4211 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.88.234:52480 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4211 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.96.1:52481 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4211 Save video Candidate cid: 1 proto: udp type: host addr: 169.254.185.128:52482 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4211 Save video Candidate cid: 1 proto: udp type: srflx addr: 95.182.77.38:52480 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4256 Searching for rtp candidate. ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4265 Choose rtp candidate, index 4, 95.182.77.38:52480 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4031 verto.rtc/3500 choosing family v4 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4276 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 95.182.77.38:52480 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4328 setting remote video ice addr to index 4 95.182.77.38:52480 based on candidate ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:4363 Setting remote rtcp video addr to 95.182.77.38:52480 based on candidate ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:8511 AUDIO RTP [verto.rtc/3500] 10.0.0.5 port 16650 -> 95.182.77.38 port 52476 codec: 111 ms: 20 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_rtp.c:4296 Starting timer [soft] 960 bytes per 20ms ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [INFO] switch_core_media.c:8690 Activating Audio ICE ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [NOTICE] switch_rtp.c:4795 Activating RTP audio ICE: ap3y:qJzl3JcKl662DtON 95.182.77.38:52476 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_core_media.c:8731 Activating RTCP PORT 52476 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [DEBUG] switch_rtp.c:4692 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 52476 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [INFO] switch_core_media.c:8742 Skipping RTCP ICE (Same as RTP) ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.648493 [INFO] switch_rtp.c:3665 Activate RTP/RTCP audio DTLS client ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.650493 [INFO] switch_rtp.c:3828 Changing audio DTLS state from OFF to HANDSHAKE ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.650493 [DEBUG] switch_core_media.c:2543 Setting Jitterbuffer to 20ms (1 frames) (50 max frames) ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.650493 [DEBUG] switch_core_media.c:8815 verto.rtc/3500 Set 2833 dtmf send payload to 110 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.650493 [DEBUG] switch_core_media.c:8822 verto.rtc/3500 Set 2833 dtmf receive payload to 110 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.650493 [DEBUG] switch_rtp.c:4311 Starting video timer. ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.650493 [DEBUG] switch_core_media.c:9342 VIDEO RTP [verto.rtc/3500] 10.0.0.5:16488->95.182.77.38:52480 codec: 100 ms: 0 [SUCCESS] ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.650493 [DEBUG] switch_core_media.c:7503 verto.rtc/3500 Starting Video thread 2018-11-20 20:47:50.650493 [DEBUG] switch_core_media.c:7369 verto.rtc/3500 Video thread started. Echo is off ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.652497 [INFO] switch_core_media.c:9384 Activating Video ICE ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.652497 [NOTICE] switch_rtp.c:4795 Activating RTP video ICE: ap3y:5at6wLIZVzmgYauU 95.182.77.38:52480 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.652497 [INFO] switch_core_media.c:9422 Activating VIDEO RTCP PORT 52480 interval 1000 mux 1 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.652497 [DEBUG] switch_rtp.c:4692 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 52480 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.652497 [INFO] switch_core_media.c:9435 Skipping VIDEO RTCP ICE (Same as VIDEO RTP) ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.652497 [INFO] switch_rtp.c:3665 Activate RTP/RTCP video DTLS client ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.652497 [INFO] switch_rtp.c:3828 Changing video DTLS state from OFF to HANDSHAKE ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.652497 [DEBUG] switch_core_media.c:8494 Audio params are unchanged for verto.rtc/3500. ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.652497 [DEBUG] switch_core_media.c:9200 Video params are unchanged for verto.rtc/3500. ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.652497 [DEBUG] mod_verto.c:2502 Local SDP verto.rtc/3500: ef39ae06-1e9c-e64c-a9c9-0aace5cf414d v=0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d o=FreeSWITCH 1542730220 1542730221 IN IP4 137.135.122.137 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d s=FreeSWITCH ef39ae06-1e9c-e64c-a9c9-0aace5cf414d c=IN IP4 137.135.122.137 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d t=0 0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=msid-semantic: WMS xWRh4gxc5raqc36ehcBCxavoXkaCtLfd ef39ae06-1e9c-e64c-a9c9-0aace5cf414d m=audio 16650 UDP/TLS/RTP/SAVPF 111 110 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:111 opus/48000/2 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=fmtp:111 useinbandfec=1; minptime=10; stereo=1; sprop-stereo=1 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:110 telephone-event/48000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=silenceSupp:off - - - - ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ptime:20 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=sendrecv ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=fingerprint:sha-256 24:75:FE:94:82:E8:4F:24:32:AB:5E:71:35:C4:91:76:32:3A:9D:B9:68:22:77:06:E4:DA:80:DA:0E:9E:39:5E ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=setup:active ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-mux ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp:16650 IN IP4 137.135.122.137 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ice-ufrag:qJzl3JcKl662DtON ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ice-pwd:Vgp2Wr7uWhqbDIIXkbm0Dink ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:7750762322 1 udp 659136 137.135.122.137 16650 typ host generation 0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=end-of-candidates ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:2718517854 cname:YmUKB2SWrK0x9SQv ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:2718517854 msid:xWRh4gxc5raqc36ehcBCxavoXkaCtLfd a0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:2718517854 mslabel:xWRh4gxc5raqc36ehcBCxavoXkaCtLfd ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:2718517854 label:xWRh4gxc5raqc36ehcBCxavoXkaCtLfda0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d m=video 16488 UDP/TLS/RTP/SAVPF 100 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d b=AS:813 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtpmap:100 H264/90000 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42001f ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=sendrecv ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=fingerprint:sha-256 24:75:FE:94:82:E8:4F:24:32:AB:5E:71:35:C4:91:76:32:3A:9D:B9:68:22:77:06:E4:DA:80:DA:0E:9E:39:5E ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=setup:active ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-mux ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp:16488 IN IP4 137.135.122.137 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:100 ccm fir ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:100 nack ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=rtcp-fb:100 nack pli ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:1947165707 cname:YmUKB2SWrK0x9SQv ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:1947165707 msid:xWRh4gxc5raqc36ehcBCxavoXkaCtLfd v0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:1947165707 mslabel:xWRh4gxc5raqc36ehcBCxavoXkaCtLfd ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ssrc:1947165707 label:xWRh4gxc5raqc36ehcBCxavoXkaCtLfdv0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ice-ufrag:5at6wLIZVzmgYauU ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=ice-pwd:MnqYmfpY0Ld1xvGt2lh5XoMt ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=candidate:0428094240 1 udp 659136 137.135.122.137 16488 typ host generation 0 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d a=end-of-candidates ef39ae06-1e9c-e64c-a9c9-0aace5cf414d ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.652497 [NOTICE] mod_dptools.c:1377 Channel [verto.rtc/3500] has been answered ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.654496 [DEBUG] switch_channel.c:3781 (verto.rtc/3500) Callstate Change RINGING -> ACTIVE ef39ae06-1e9c-e64c-a9c9-0aace5cf414d EXECUTE verto.rtc/3500 conference(3500-137.135.122.137@video-mcu-stereo) ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.654496 [DEBUG] conference_member.c:1758 Raw Codec Activation Success L16@48000hz 2 channel 20ms ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.654496 [DEBUG] conference_member.c:1805 Raw Codec Activation Success L16@48000hz 2 channel 20ms ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.654496 [DEBUG] switch_core_codec.c:223 verto.rtc/3500 Push codec L16:100 2018-11-20 20:47:50.668495 [WARNING] switch_core_file.c:405 File has 1 channels, muxing to 2 channels will occur. 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '0' to 'mute' 2018-11-20 20:47:50.668495 [INFO] switch_ivr_async.c:219 Digit parser mod_conference: Setting realm to 'conf' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 0/conf/0 callback: 0000023A3F511F10 data: 0000023A45AA63C8 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '*' to 'deaf mute' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding */conf/0 callback: 0000023A3F511F10 data: 0000023A45AA63F8 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '9' to 'energy up' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 9/conf/0 callback: 0000023A3F511F10 data: 0000023A45AA6428 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '8' to 'energy equ' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 8/conf/0 callback: 0000023A3F511F10 data: 0000023A45AA6458 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '7' to 'energy dn' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 7/conf/0 callback: 0000023A3F511F10 data: 0000023A45AA6488 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '3' to 'vol talk up' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 3/conf/0 callback: 0000023A3F511F10 data: 0000023A45AA64B8 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '2' to 'vol talk zero' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 2/conf/0 callback: 0000023A3F511F10 data: 0000023A45AA64E8 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '1' to 'vol talk dn' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 1/conf/0 callback: 0000023A3F511F10 data: 0000023A45AA6518 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '6' to 'vol listen up' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 6/conf/0 callback: 0000023A3F511F10 data: 0000023A45AA6548 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '5' to 'vol listen zero' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 5/conf/0 callback: 0000023A3F511F10 data: 0000023A45AA6578 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '4' to 'vol listen dn' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding 4/conf/0 callback: 0000023A3F511F10 data: 0000023A45A8D578 2018-11-20 20:47:50.668495 [DEBUG] conference_member.c:105 verto.rtc/3500 binding '#' to 'hangup' 2018-11-20 20:47:50.668495 [DEBUG] switch_ivr_async.c:344 Digit parser mod_conference: binding #/conf/0 callback: 0000023A3F511F10 data: 0000023A45A8D5A8 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:50.670496 [DEBUG] conference_loop.c:1338 Setup timer soft success interval: 20 samples: 960 from codec opus 2018-11-20 20:47:50.692495 [INFO] avcodec.c:1404 initializing encoder 1920x1080 2018-11-20 20:47:50.692495 [NOTICE] avcodec.c:1139 NVENC HW CODEC ENABLED Loaded Nvenc version 8.0 Nvenc initialized successfully 1 CUDA capable devices found [ GPU #0 - < Tesla K80 > has Compute SM 3.7 ] supports NVENC 2018-11-20 20:47:50.810495 [INFO] avcodec.c:1289 codec opened: Video: h264 (nvenc_h264) (Baseline), yuv420p, 1920x1080, 3145 kb/s 2018-11-20 20:47:50.886494 [ERR] mod_verto.c:4040 MCAST Data Sent Nvenc unloaded Loaded Nvenc version 8.0 Nvenc initialized successfully 1 CUDA capable devices found [ GPU #0 - < Tesla K80 > has Compute SM 3.7 ] supports NVENC 2018-11-20 20:47:51.018495 [INFO] avcodec.c:1289 codec opened: Video: h264 (nvenc_h264) (Baseline), yuv420p, 1920x1080, 3145 kb/s 2018-11-20 20:47:51.060497 [DEBUG] conference_video.c:1689 Canvas position 1 applied layout 1x1+2x1 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:51.368495 [INFO] switch_rtp.c:3202 Changing video DTLS state from HANDSHAKE to SETUP ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:51.414494 [INFO] switch_rtp.c:3109 video Fingerprint Verified. ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:51.414494 [INFO] switch_rtp.c:4100 Activating video Secure RTP SEND ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:51.414494 [INFO] switch_rtp.c:4078 Activating video Secure RTP RECV 2018-11-20 20:47:51.414494 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:51.414494 [INFO] switch_rtp.c:3151 Changing video DTLS state from SETUP to READY 2018-11-20 20:47:51.414494 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:51.414494 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: video ssrc[3580427659] base_seq[14226] Reinit context to 640x368, pix_fmt: yuv420p ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:52.194494 [INFO] switch_rtp.c:3202 Changing audio DTLS state from HANDSHAKE to SETUP ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:52.204494 [INFO] switch_rtp.c:3109 audio Fingerprint Verified. ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:52.204494 [INFO] switch_rtp.c:4100 Activating audio Secure RTP SEND ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:52.204494 [INFO] switch_rtp.c:4078 Activating audio Secure RTP RECV 2018-11-20 20:47:52.204494 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:52.204494 [INFO] switch_rtp.c:3151 Changing audio DTLS state from SETUP to READY 2018-11-20 20:47:52.204494 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80 ef39ae06-1e9c-e64c-a9c9-0aace5cf414d 2018-11-20 20:47:52.234497 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: audio ssrc[971570147] base_seq[16263]