From Sweet Marmoset, 4 Years ago, written in Plain Text.
- view diff
Embed
  1. freeswitch@LAPTOPANDY> fsctl recover
  2. 2020-11-16 22:14:23.907628 82.73[NOTICE] switch_channel.c:1118 New Channel verto.rtc/029929 [0f01cf63-766a-2e01-50e7-990bb74d7105]
  3. 2020-11-16 22:14:23.917627 82.73[DEBUG] mod_opus.c:613 Opus encoder: set bitrate to local settings [120000bps]
  4. 2020-11-16 22:14:23.917627 82.73[DEBUG] mod_opus.c:613 Opus encoder: set bitrate to local settings [120000bps]
  5. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_core_media.c:3853 Set Codec verto.rtc/029929 opus/48000 20 ms 960 samples 0 bits 2 channels
  6. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_core_codec.c:111 verto.rtc/029929 Original read codec set to opus:116
  7. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_vpx.c:703 VPX VER:v1.8.1 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:8
  8.  
  9. +OK 1 session(s) recovered in total
  10.  
  11. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_vpx.c:703 VPX VER:v1.8.1 VPX_IMAGE_ABI_VERSION:4 VPX_CODEC_ABI_VERSION:8
  12. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_core_media.c:3663 Set VIDEO Codec verto.rtc/029929 VP8/90000 0 ms
  13. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_core_media.c:3630 Already using VP8
  14. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_core_media.c:8734 AUDIO RTP [verto.rtc/029929] 192.168.88.114 port 30446 -> 192.168.88.114 port 57286 codec: 111 ms: 20
  15. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_rtp.c:4505 Starting timer [soft] 960 bytes per 20ms
  16. 2020-11-16 22:14:23.917627 82.73[INFO] switch_rtp.c:3833 Activate RTP audio DTLS server
  17. 2020-11-16 22:14:23.917627 82.73[INFO] switch_rtp.c:4000 Changing audio DTLS state from OFF to HANDSHAKE
  18. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_core_media.c:9048 verto.rtc/029929 Set 2833 dtmf send payload to 110
  19. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_core_media.c:9055 verto.rtc/029929 Set 2833 dtmf receive payload to 110
  20. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_rtp.c:4520 Starting video timer.
  21. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_core_media.c:9566 VIDEO RTP [verto.rtc/029929] 192.168.88.114:19632->192.168.88.114:57289 codec: 96 ms: 0 [SUCCESS]
  22. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_core_media.c:7701 verto.rtc/029929 Starting Video thread
  23. 2020-11-16 22:14:23.917627 82.73[INFO] switch_rtp.c:3833 Activate RTP video DTLS server
  24. 2020-11-16 22:14:23.917627 82.73[INFO] switch_rtp.c:4000 Changing video DTLS state from OFF to HANDSHAKE
  25. 2020-11-16 22:14:23.917627 82.73[NOTICE] switch_channel.c:1116 Rename Channel verto.rtc/029929->verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d [0f01cf63-766a-2e01-50e7-990bb74d7105]
  26. 2020-11-16 22:14:23.917627 82.73[DEBUG] switch_core_sqldb.c:3308 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) State Change CS_NEW -> CS_INIT
  27. 2020-11-16 22:14:23.917627 82.73[NOTICE] switch_core_sqldb.c:3309 Resurrecting fallen channel verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d
  28. 2020-11-16 22:14:23.929631 82.73[DEBUG] switch_core_state_machine.c:585 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) Running State Change CS_INIT (Cur 1 Tot 1)
  29. 2020-11-16 22:14:23.929631 82.73[DEBUG] switch_channel.c:2334 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) Callstate Change DOWN -> ACTIVE
  30. 2020-11-16 22:14:23.929631 82.73[DEBUG] switch_core_state_machine.c:628 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) State INIT
  31. 2020-11-16 22:14:23.929631 82.73[DEBUG] mod_verto.c:2291 Local verto.attach SDP verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d:
  32. v=0
  33. o=FreeSWITCH 1605520017 1605520019 IN IP4 192.168.88.114
  34. s=FreeSWITCH
  35. c=IN IP4 192.168.88.114
  36. t=0 0
  37. a=msid-semantic: WMS BgvZAkaOVdfxQYjidvb8Od4NAbpyOWbZ
  38. m=audio 30446 UDP/TLS/RTP/SAVPF 111 110
  39. a=rtpmap:111 opus/48000/2
  40. a=fmtp:111 useinbandfec=1; minptime=10; stereo=1; sprop-stereo=1
  41. a=rtpmap:110 telephone-event/0
  42. a=silenceSupp:off - - - -
  43. a=ptime:20
  44. a=sendrecv
  45. a=fingerprint:sha-256 FE:31:02:0B:E7:01:B2:25:E9:60:CB:C0:5A:0E:FF:F9:4C:BA:E1:5D:92:D1:A2:71:DE:D9:EA:3F:03:F4:67:53
  46. a=setup:actpass
  47. a=rtcp-mux
  48. a=rtcp:30446 IN IP4 192.168.88.114
  49. a=ice-ufrag:S9WNM6QrJsHSpHE7
  50. a=ice-pwd:PVMBXU9mN4K4FEB36lpmT6Mc
  51. a=candidate:0518543887 1 udp 659136 192.168.88.114 30446 typ host generation 0
  52. a=candidate:0518543887 2 udp 659135 192.168.88.114 30446 typ host generation 0
  53. a=end-of-candidates
  54. a=ssrc:1899581426 cname:iNI8CnsWvDLg9UjC
  55. a=ssrc:1899581426 msid:BgvZAkaOVdfxQYjidvb8Od4NAbpyOWbZ a0
  56. a=ssrc:1899581426 mslabel:BgvZAkaOVdfxQYjidvb8Od4NAbpyOWbZ
  57. a=ssrc:1899581426 label:BgvZAkaOVdfxQYjidvb8Od4NAbpyOWbZa0
  58. m=video 19632 UDP/TLS/RTP/SAVPF 96
  59. b=AS:3072
  60. a=rtpmap:96 VP8/90000
  61. a=fingerprint:sha-256 FE:31:02:0B:E7:01:B2:25:E9:60:CB:C0:5A:0E:FF:F9:4C:BA:E1:5D:92:D1:A2:71:DE:D9:EA:3F:03:F4:67:53
  62. a=setup:actpass
  63. a=rtcp-mux
  64. a=rtcp:19632 IN IP4 192.168.88.114
  65. a=rtcp-fb:96 ccm fir
  66. a=rtcp-fb:96 ccm tmmbr
  67. a=rtcp-fb:96 nack
  68. a=rtcp-fb:96 nack pli
  69. a=ssrc:1096827597 cname:iNI8CnsWvDLg9UjC
  70. a=ssrc:1096827597 msid:BgvZAkaOVdfxQYjidvb8Od4NAbpyOWbZ v0
  71. a=ssrc:1096827597 mslabel:BgvZAkaOVdfxQYjidvb8Od4NAbpyOWbZ
  72. a=ssrc:1096827597 label:BgvZAkaOVdfxQYjidvb8Od4NAbpyOWbZv0
  73. a=ice-ufrag:4YCg1Vcz6eknhKhM
  74. a=ice-pwd:JQT4PsYx9VmkylKm7lxshmcV
  75. a=candidate:1643067853 1 udp 659136 192.168.88.114 19632 typ host generation 0
  76. a=candidate:1643067853 2 udp 659135 192.168.88.114 19632 typ host generation 0
  77. a=end-of-candidates
  78.  
  79.  
  80. freeswitch@LAPTOPANDY> 2020-11-16 22:14:24.017764 82.73[DEBUG] switch_core_media.c:7567 verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Video thread started. Echo is off
  81. 2020-11-16 22:14:24.127756 82.73[INFO] switch_vpx.c:564 config: vp8
  82. 2020-11-16 22:14:24.127756 82.73[NOTICE] switch_vpx.c:599 VPX encoder reset (WxH/BW) from 0x0/0 to 352x288/3072
  83. 2020-11-16 22:14:25.818275 81.20[DEBUG] mod_verto.c:3372 Remote SDP verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d:
  84. v=0
  85. o=- 5920300289985436535 2 IN IP4 127.0.0.1
  86. s=-
  87. t=0 0
  88. a=msid-semantic: WMS OCCxU5TlUD3LGNaD6uw3oTGrarNhV759pN79
  89. m=audio 56115 UDP/TLS/RTP/SAVPF 111
  90. c=IN IP4 78.107.191.70
  91. a=rtcp:9 IN IP4 0.0.0.0
  92. a=candidate:3116056525 1 udp 2122260223 192.168.170.10 56113 typ host generation 0 network-id 1
  93. a=candidate:3406557703 1 udp 2122194687 172.18.61.17 56114 typ host generation 0 network-id 2
  94. a=candidate:2252037040 1 udp 2122129151 192.168.88.114 56115 typ host generation 0 network-id 3 network-cost 10
  95. a=candidate:1253467171 1 udp 1685921535 78.107.191.70 56115 typ srflx raddr 192.168.88.114 rport 56115 generation 0 network-id 3 network-cost 10
  96. a=candidate:4147692349 1 tcp 1518280447 192.168.170.10 9 typ host tcptype active generation 0 network-id 1
  97. a=candidate:2240286455 1 tcp 1518214911 172.18.61.17 9 typ host tcptype active generation 0 network-id 2
  98. a=candidate:3367544640 1 tcp 1518149375 192.168.88.114 9 typ host tcptype active generation 0 network-id 3 network-cost 10
  99. a=ice-ufrag:azZ4
  100. a=ice-pwd:zIXeGoBcNpkFehh8O398J6eY
  101. a=ice-options:trickle
  102. a=fingerprint:sha-256 85:DD:01:25:19:E1:2B:14:6E:AC:19:A1:7B:B2:99:06:85:EC:1F:CF:56:03:13:FF:89:42:86:6C:8B:D2:D3:C1
  103. a=setup:active
  104. a=mid:audio
  105. a=sendrecv
  106. a=rtcp-mux
  107. a=rtpmap:111 opus/48000/2
  108. a=fmtp:111 minptime=10;useinbandfec=1; stereo=1; sprop-stereo=1
  109. a=ssrc:910115429 cname:d/pphYD8uAI57MS3
  110. a=ssrc:910115429 msid:OCCxU5TlUD3LGNaD6uw3oTGrarNhV759pN79 50a40b69-2561-4d67-b763-1d4b998caba1
  111. a=ssrc:910115429 mslabel:OCCxU5TlUD3LGNaD6uw3oTGrarNhV759pN79
  112. a=ssrc:910115429 label:50a40b69-2561-4d67-b763-1d4b998caba1
  113. m=video 56118 UDP/TLS/RTP/SAVPF 96
  114. c=IN IP4 78.107.191.70
  115. a=rtcp:9 IN IP4 0.0.0.0
  116. a=candidate:3116056525 1 udp 2122260223 192.168.170.10 56116 typ host generation 0 network-id 1
  117. a=candidate:3406557703 1 udp 2122194687 172.18.61.17 56117 typ host generation 0 network-id 2
  118. a=candidate:2252037040 1 udp 2122129151 192.168.88.114 56118 typ host generation 0 network-id 3 network-cost 10
  119. a=candidate:1253467171 1 udp 1685921535 78.107.191.70 56118 typ srflx raddr 192.168.88.114 rport 56118 generation 0 network-id 3 network-cost 10
  120. a=candidate:4147692349 1 tcp 1518280447 192.168.170.10 9 typ host tcptype active generation 0 network-id 1
  121. a=candidate:2240286455 1 tcp 1518214911 172.18.61.17 9 typ host tcptype active generation 0 network-id 2
  122. a=candidate:3367544640 1 tcp 1518149375 192.168.88.114 9 typ host tcptype active generation 0 network-id 3 network-cost 10
  123. a=ice-ufrag:aBBg
  124. a=ice-pwd:GTEbwwywRWLo1VOH3z5rYN6n
  125. a=ice-options:trickle
  126. a=fingerprint:sha-256 85:DD:01:25:19:E1:2B:14:6E:AC:19:A1:7B:B2:99:06:85:EC:1F:CF:56:03:13:FF:89:42:86:6C:8B:D2:D3:C1
  127. a=setup:active
  128. a=mid:video
  129. a=sendrecv
  130. a=rtcp-mux
  131. a=rtpmap:96 VP8/90000
  132. a=rtcp-fb:96 ccm fir
  133. a=rtcp-fb:96 nack
  134. a=rtcp-fb:96 nack pli
  135. a=ssrc:1241511452 cname:d/pphYD8uAI57MS3
  136. a=ssrc:1241511452 msid:OCCxU5TlUD3LGNaD6uw3oTGrarNhV759pN79 5519eeb8-038e-4148-8fcb-9eac5e2287df
  137. a=ssrc:1241511452 mslabel:OCCxU5TlUD3LGNaD6uw3oTGrarNhV759pN79
  138. a=ssrc:1241511452 label:5519eeb8-038e-4148-8fcb-9eac5e2287df
  139.  
  140. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_rtp.c:1994 rtcp_stats_init: audio rtcp disabled
  141. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_rtp.c:1994 rtcp_stats_init: video rtcp disabled
  142. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:5635 Audio Codec Compare [opus:111:48000:20:0:2]/[opus:116:48000:20:0:1]
  143. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:5690 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
  144. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4325 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.170.10:56113
  145. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4325 Save audio Candidate cid: 1 proto: udp type: host addr: 172.18.61.17:56114
  146. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4325 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.88.114:56115
  147. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4325 Save audio Candidate cid: 1 proto: udp type: srflx addr: 78.107.191.70:56115
  148. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4370 Searching for rtp candidate.
  149. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4379 Choose rtp candidate, index 2, 192.168.88.114:56115
  150. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4119 verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d choosing family v4
  151. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4390 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 192.168.88.114:56115
  152. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4442 setting remote audio ice addr to index 2 192.168.88.114:56115 based on candidate
  153. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4477 Setting remote rtcp audio addr to 192.168.88.114:56115 based on candidate
  154. 2020-11-16 22:14:25.818275 81.20[INFO] switch_core_media.c:4510 RE-Activating audio ICE
  155. 2020-11-16 22:14:25.818275 81.20[NOTICE] switch_rtp.c:5011 Activating RTP audio ICE: azZ4:S9WNM6QrJsHSpHE7 192.168.88.114:56115
  156. 2020-11-16 22:14:25.818275 81.20[INFO] switch_core_media.c:4553 Activating audio RTCP PORT 56115
  157. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_rtp.c:4907 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 56115
  158. 2020-11-16 22:14:25.818275 81.20[INFO] switch_core_media.c:4562 Skipping audio RTCP ICE (Same as RTP)
  159. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:5923 No 2833 in SDP. Liberal DTMF mode adding 110 as telephone-event.
  160. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:5952 verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Set 2833 dtmf send payload to 110 recv payload to 110
  161. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:6237 Video Codec Compare [VP8:96]/[VP8:99]
  162. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:6291 Video Codec Compare [VP8:96] +++ is saved as a match
  163. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4325 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.170.10:56116
  164. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4325 Save video Candidate cid: 1 proto: udp type: host addr: 172.18.61.17:56117
  165. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4325 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.88.114:56118
  166. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4325 Save video Candidate cid: 1 proto: udp type: srflx addr: 78.107.191.70:56118
  167. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4370 Searching for rtp candidate.
  168. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4379 Choose rtp candidate, index 2, 192.168.88.114:56118
  169. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4119 verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d choosing family v4
  170. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4390 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 192.168.88.114:56118
  171. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4442 setting remote video ice addr to index 2 192.168.88.114:56118 based on candidate
  172. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:4477 Setting remote rtcp video addr to 192.168.88.114:56118 based on candidate
  173. 2020-11-16 22:14:25.818275 81.20[INFO] switch_core_media.c:4510 RE-Activating video ICE
  174. 2020-11-16 22:14:25.818275 81.20[NOTICE] switch_rtp.c:5011 Activating RTP video ICE: aBBg:4YCg1Vcz6eknhKhM 192.168.88.114:56118
  175. 2020-11-16 22:14:25.818275 81.20[INFO] switch_core_media.c:4553 Activating video RTCP PORT 56118
  176. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_rtp.c:4907 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 56118
  177. 2020-11-16 22:14:25.818275 81.20[INFO] switch_core_media.c:4562 Skipping video RTCP ICE (Same as RTP)
  178. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:8722 Audio params changed for verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d from 192.168.88.114:57286 to 192.168.88.114:56115
  179. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:8734 AUDIO RTP [verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d] 192.168.88.114 port 30446 -> 192.168.88.114 port 56115 codec: 111 ms: 20
  180. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:8763 AUDIO RTP CHANGING DEST TO: [192.168.88.114:56115]
  181. 2020-11-16 22:14:25.818275 81.20[INFO] switch_core_media.c:8563 RE-SETTING audio DTLS
  182. 2020-11-16 22:14:25.818275 81.20[INFO] switch_rtp.c:3833 Activate RTP/RTCP audio DTLS server
  183. 2020-11-16 22:14:25.818275 81.20[INFO] switch_rtp.c:4000 Changing audio DTLS state from OFF to HANDSHAKE
  184. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:9435 Video params changed for verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d from 192.168.88.114:57289 to 192.168.88.114:56118
  185. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:9443 VIDEO RTP [verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d] 192.168.88.114 port 19632 -> 192.168.88.114 port 56118 codec: 96
  186. 2020-11-16 22:14:25.818275 81.20[DEBUG] switch_core_media.c:9474 VIDEO RTP CHANGING DEST TO: [192.168.88.114:56118]
  187. 2020-11-16 22:14:25.818275 81.20[INFO] switch_core_media.c:8563 RE-SETTING video DTLS
  188. 2020-11-16 22:14:25.818275 81.20[INFO] switch_rtp.c:3833 Activate RTP/RTCP video DTLS server
  189. 2020-11-16 22:14:25.818275 81.20[INFO] switch_rtp.c:4000 Changing video DTLS state from OFF to HANDSHAKE
  190. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_core_state_machine.c:40 verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Standard INIT
  191. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_core_state_machine.c:48 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) State Change CS_INIT -> CS_ROUTING
  192. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_core_state_machine.c:628 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) State INIT going to sleep
  193. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_core_state_machine.c:585 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) Running State Change CS_ROUTING (Cur 1 Tot 1)
  194. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_channel.c:2332 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) Callstate Change ACTIVE -> RINGING
  195. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_core_state_machine.c:644 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) State ROUTING
  196. 2020-11-16 22:14:25.828276 81.20[DEBUG] mod_rtc.c:89 verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d RTC ROUTING
  197. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_core_state_machine.c:236 verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Standard ROUTING
  198. 2020-11-16 22:14:25.828276 81.20[INFO] mod_dialplan_xml.c:637 Processing Andrey <andywolk@gmail.com>->029929 in context default
  199. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d parsing [default->unloop] continue=false
  200. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  201. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  202. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d parsing [default->tod_example] continue=true
  203. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Date/TimeMatch (FAIL) [tod_example] break=on-false
  204. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d parsing [default->holiday_example] continue=true
  205. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Date/TimeMatch (FAIL) [holiday_example] break=on-false
  206. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d parsing [default->global-intercept] continue=false
  207. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Regex (FAIL) [global-intercept] destination_number(029929) =~ /^886$/ break=on-false
  208. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d parsing [default->group-intercept] continue=false
  209. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Regex (FAIL) [group-intercept] destination_number(029929) =~ /^\*8$/ break=on-false
  210. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d parsing [default->intercept-ext] continue=false
  211. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Regex (FAIL) [intercept-ext] destination_number(029929) =~ /^\*\*(\d+)$/ break=on-false
  212. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d parsing [default->redial] continue=false
  213. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Regex (FAIL) [redial] destination_number(029929) =~ /^(redial|870)$/ break=on-false
  214. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d parsing [default->global] continue=true
  215. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
  216. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Regex (FAIL) [global] ${default_password}(123456) =~ /^1234$/ break=never
  217. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d 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
  218. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Regex (FAIL) [global] ${endpoint_disposition}(ANSWER) =~ /^(DELAYED NEGOTIATION)/ break=on-false
  219. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d parsing [default->snom-demo-2] continue=false
  220. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Regex (FAIL) [snom-demo-2] destination_number(029929) =~ /^9001$/ break=on-false
  221. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d parsing [default->tone_stream2] continue=false
  222. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Regex (PASS) [tone_stream2] destination_number(029929) =~ /^029929$/ break=on-false
  223. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Action answer()
  224. Dialplan: verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Action playback({loops=-1}tone_stream://path=${conf_dir}/fur_elise.ttml)
  225. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_core_state_machine.c:287 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) State Change CS_ROUTING -> CS_EXECUTE
  226. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_core_state_machine.c:644 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) State ROUTING going to sleep
  227. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_core_state_machine.c:585 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) Running State Change CS_EXECUTE (Cur 1 Tot 1)
  228. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_channel.c:2334 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) Callstate Change RINGING -> ACTIVE
  229. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_core_state_machine.c:651 (verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d) State EXECUTE
  230. 2020-11-16 22:14:25.828276 81.20[DEBUG] mod_rtc.c:120 verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d RTC EXECUTE
  231. 2020-11-16 22:14:25.828276 81.20[DEBUG] switch_core_state_machine.c:329 verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d Standard EXECUTE
  232. EXECUTE [depth=0] verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d answer()
  233. EXECUTE [depth=0] verto.rtc/c2c2aafa-db42-391a-9d3c-9a67e53f477d playback({loops=-1}tone_stream://path=D:/fsa/airwave/check/stack/x64/Debug/conf/fur_elise.ttml)
  234. 2020-11-16 22:14:25.887799 81.20[WARNING] switch_core_file.c:424 File has 1 channels, muxing to 2 channels will occur.
  235. 2020-11-16 22:14:25.887799 81.20[DEBUG] switch_ivr_play_say.c:1488 Codec Activated L16@48000hz 2 channels 20ms
  236. 2020-11-16 22:14:26.227797 81.20[INFO] switch_rtp.c:3370 Changing video DTLS state from HANDSHAKE to SETUP
  237. 2020-11-16 22:14:26.247800 81.20[INFO] switch_rtp.c:3277 video Fingerprint Verified.
  238. 2020-11-16 22:14:26.247800 81.20[INFO] switch_rtp.c:4309 Activating video Secure RTP SEND
  239. 2020-11-16 22:14:26.247800 81.20[INFO] switch_rtp.c:4287 Activating video Secure RTP RECV
  240. 2020-11-16 22:14:26.247800 81.20[INFO] switch_rtp.c:3319 Changing video DTLS state from SETUP to READY
  241. 2020-11-16 22:14:26.247800 81.20[DEBUG] switch_core_sqldb.c:2842 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
  242. 2020-11-16 22:14:26.247800 81.20[DEBUG] switch_core_sqldb.c:2842 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
  243. 2020-11-16 22:14:26.257801 81.20[INFO] switch_rtp.c:3370 Changing audio DTLS state from HANDSHAKE to SETUP
  244. 2020-11-16 22:14:26.257801 81.20[DEBUG] switch_rtp.c:2000 rtcp_stats_init: video ssrc[1241511452] base_seq[9443]
  245. 2020-11-16 22:14:26.277802 81.20[INFO] switch_rtp.c:3277 audio Fingerprint Verified.
  246. 2020-11-16 22:14:26.277802 81.20[INFO] switch_rtp.c:4309 Activating audio Secure RTP SEND
  247. 2020-11-16 22:14:26.277802 81.20[DEBUG] switch_core_sqldb.c:2842 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
  248. 2020-11-16 22:14:26.277802 81.20[INFO] switch_rtp.c:4287 Activating audio Secure RTP RECV
  249. 2020-11-16 22:14:26.277802 81.20[INFO] switch_rtp.c:3319 Changing audio DTLS state from SETUP to READY
  250. 2020-11-16 22:14:26.277802 81.20[DEBUG] switch_core_sqldb.c:2842 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
  251. 2020-11-16 22:14:26.347845 81.20[DEBUG] switch_rtp.c:2000 rtcp_stats_init: audio ssrc[910115429] base_seq[14350]