From Cream Crane, 6 Years ago, written in Plain Text.
- view diff
Embed
  1. 2017-10-05 10:59:55.444212 [NOTICE] mod_cdr_csv.c:127 Rotated CDR logfile /usr/local/freeswitch/log/cdr-csv/1003.csv
  2. 2017-10-05 10:59:55.444212 [NOTICE] mod_logfile.c:192 New log started.
  3. 2017-10-05 11:00:01.964211 [ALERT] mod_verto.c:1405 READ 192.168.1.1:55563 [{
  4.         "jsonrpc":      "2.0",
  5.         "method":       "verto.invite",
  6.         "params":       {
  7.                 "sdp":  "v=0\r\no=- 2752367973978024640 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE audio video\r\na=msid-semantic: WMS rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK\r\nm=audio 51686 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126\r\nc=IN IP4 65.15.69.32\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=candidate:3676716184 1 udp 2122255103 2001::9d38:6ab8:2857:2624:bef0:badf 51685 typ host generation 0 network-id 1 network-cost 50\r\na=candidate:3687888086 1 udp 2122194687 192.168.1.123 51686 typ host generation 0 network-id 2\r\na=candidate:1519956578 1 udp 1685987071 65.15.69.32 51686 typ srflx raddr 192.168.1.123 rport 51686 generation 0 network-id 2\r\na=candidate:2510667880 1 tcp 1518275327 2001::9d38:6ab8:2857:2624:bef0:badf 9 typ host tcptype active generation 0 network-id 1 network-cost 50\r\na=candidate:2505263142 1 tcp 1518214911 192.168.1.123 9 typ host tcptype active generation 0 network-id 2\r\na=ice-ufrag:iTlu\r\na=ice-pwd:2z9+7ZinoPf0BfuMNQlkVeq6\r\na=ice-options:trickle\r\na=fingerprint:sha-256 DE:E3:A2:8A:E4:1F:94:68:CE:16:A6:74:7B:B1:25:A1:FC:F7:90:10:06:C0:F3:EB:F9:27:77:9F:1E:39:3D:92\r\na=setup:actpass\r\na=mid:audio\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=sendrecv\r\na=rtcp-mux\r\na=rtpmap:111 opus/48000/2\r\na=rtcp-fb:111 transport-cc\r\na=fmtp:111 minptime=10;useinbandfec=1; stereo=1; sprop-stereo=1\r\na=rtpmap:103 ISAC/16000\r\na=rtpmap:104 ISAC/32000\r\na=rtpmap:9 G722/8000\r\na=rtpmap:0 PCMU/8000\r\na=rtpmap:8 PCMA/8000\r\na=rtpmap:106 CN/32000\r\na=rtpmap:105 CN/16000\r\na=rtpmap:13 CN/8000\r\na=rtpmap:110 telephone-event/48000\r\na=rtpmap:112 telephone-event/32000\r\na=rtpmap:113 telephone-event/16000\r\na=rtpmap:126 telephone-event/8000\r\na=ssrc:395565095 cname:aJLaOP3UK2dzvkhh\r\na=ssrc:395565095 msid:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK 7a7af0af-b247-4dc4-9916-3c10cbc478a5\r\na=ssrc:395565095 mslabel:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK\r\na=ssrc:395565095 label:7a7af0af-b247-4dc4-9916-3c10cbc478a5\r\nm=video 51688 UDP/TLS/RTP/SAVPF 96 98 100 102 127 97 99 101 125\r\nc=IN IP4 65.15.69.32\r\na=rtcp:9 IN IP4 0.0.0.0\r\na=candidate:3676716184 1 udp 2122255103 2001::9d38:6ab8:2857:2624:bef0:badf 51687 typ host generation 0 network-id 1 network-cost 50\r\na=candidate:3687888086 1 udp 2122194687 192.168.1.123 51688 typ host generation 0 network-id 2\r\na=candidate:1519956578 1 udp 1685987071 65.15.69.32 51688 typ srflx raddr 192.168.1.123 rport 51688 generation 0 network-id 2\r\na=candidate:2510667880 1 tcp 1518275327 2001::9d38:6ab8:2857:2624:bef0:badf 9 typ host tcptype active generation 0 network-id 1 network-cost 50\r\na=candidate:2505263142 1 tcp 1518214911 192.168.1.123 9 typ host tcptype active generation 0 network-id 2\r\na=ice-ufrag:iTlu\r\na=ice-pwd:2z9+7ZinoPf0BfuMNQlkVeq6\r\na=ice-options:trickle\r\na=fingerprint:sha-256 DE:E3:A2:8A:E4:1F:94:68:CE:16:A6:74:7B:B1:25:A1:FC:F7:90:10:06:C0:F3:EB:F9:27:77:9F:1E:39:3D:92\r\na=setup:actpass\r\na=mid:video\r\na=extmap:2 urn:ietf:params:rtp-hdrext:toffset\r\na=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\r\na=extmap:4 urn:3gpp:video-orientation\r\na=extmap:5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01\r\na=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay\r\na=sendrecv\r\na=rtcp-mux\r\na=rtcp-rsize\r\na=rtpmap:96 VP8/90000\r\na=rtcp-fb:96 ccm fir\r\na=rtcp-fb:96 nack\r\na=rtcp-fb:96 nack pli\r\na=rtcp-fb:96 goog-remb\r\na=rtcp-fb:96 transport-cc\r\na=rtpmap:98 VP9/90000\r\na=rtcp-fb:98 ccm fir\r\na=rtcp-fb:98 nack\r\na=rtcp-fb:98 nack pli\r\na=rtcp-fb:98 goog-remb\r\na=rtcp-fb:98 transport-cc\r\na=rtpmap:100 H264/90000\r\na=rtcp-fb:100 ccm fir\r\na=rtcp-fb:100 nack\r\na=rtcp-fb:100 nack pli\r\na=rtcp-fb:100 goog-remb\r\na=rtcp-fb:100 transport-cc\r\na=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=rtpmap:102 red/90000\r\na=rtpmap:127 ulpfec/90000\r\na=rtpmap:97 rtx/90000\r\na=fmtp:97 apt=96\r\na=rtpmap:99 rtx/90000\r\na=fmtp:99 apt=98\r\na=rtpmap:101 rtx/90000\r\na=fmtp:101 apt=100\r\na=rtpmap:125 rtx/90000\r\na=fmtp:125 apt=102\r\na=ssrc-group:FID 2784642864 1476148818\r\na=ssrc:2784642864 cname:aJLaOP3UK2dzvkhh\r\na=ssrc:2784642864 msid:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK 7d0e195f-df11-4940-993d-aee0e4ed4857\r\na=ssrc:2784642864 mslabel:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK\r\na=ssrc:2784642864 label:7d0e195f-df11-4940-993d-aee0e4ed4857\r\na=ssrc:1476148818 cname:aJLaOP3UK2dzvkhh\r\na=ssrc:1476148818 msid:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK 7d0e195f-df11-4940-993d-aee0e4ed4857\r\na=ssrc:1476148818 mslabel:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK\r\na=ssrc:1476148818 label:7d0e195f-df11-4940-993d-aee0e4ed4857\r\n",
  8.                 "dialogParams": {
  9.                         "useVideo":     true,
  10.                         "useStereo":    true,
  11.                         "screenShare":  false,
  12.                         "useCamera":    "045df2abc86d39fe84a007c577623bbed07263394e09491bf7508947970b2d5f",
  13.                         "useMic":       "default",
  14.                         "useSpeak":     "default",
  15.                         "tag":  "webcam",
  16.                         "localTag":     null,
  17.                         "login":        "1001@baremetal.joshebosh.com",
  18.                         "videoParams":  {
  19.                                 "minWidth":     160,
  20.                                 "minHeight":    120,
  21.                                 "maxWidth":     160,
  22.                                 "maxHeight":    120,
  23.                                 "minFrameRate": 15
  24.                         },
  25.                         "destination_number":   "1002",
  26.                         "caller_id_name":       "1001",
  27.                         "caller_id_number":     "joshua@freeswitch.org",
  28.                         "outgoingBandwidth":    "250",
  29.                         "incomingBandwidth":    "250",
  30.                         "dedEnc":       true,
  31.                         "mirrorInput":  false,
  32.                         "userVariables":        {
  33.                                 "email":        "joshua@freeswitch.org",
  34.                                 "avatar":       "http://gravatar.com/avatar/4d744e87a0efca67c7418f2d8e098a98.png?s=600"
  35.                         },
  36.                         "callID":       "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  37.                         "remote_caller_id_name":        "Outbound Call",
  38.                         "remote_caller_id_number":      "1002"
  39.                 },
  40.                 "sessid":       "8f00da09-b94a-6eac-7246-f8f6f4d3ad78"
  41.         },
  42.         "id":   22
  43. }]
  44. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.964211 [DEBUG] mod_rtc.c:392 () State Change CS_NEW -> CS_INIT
  45. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.964211 [DEBUG] switch_core_session.c:641 N/A set UUID=a64a2d13-097c-fad5-4a2e-4b9912283ade
  46. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.964211 [NOTICE] switch_channel.c:1104 New Channel verto.rtc/1002 [a64a2d13-097c-fad5-4a2e-4b9912283ade]
  47. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.964211 [DEBUG] mod_verto.c:3761 Remote SDP verto.rtc/1002:
  48. a64a2d13-097c-fad5-4a2e-4b9912283ade v=0
  49. a64a2d13-097c-fad5-4a2e-4b9912283ade o=- 2752367973978024640 2 IN IP4 127.0.0.1
  50. a64a2d13-097c-fad5-4a2e-4b9912283ade s=-
  51. a64a2d13-097c-fad5-4a2e-4b9912283ade t=0 0
  52. a64a2d13-097c-fad5-4a2e-4b9912283ade a=group:BUNDLE audio video
  53. a64a2d13-097c-fad5-4a2e-4b9912283ade a=msid-semantic: WMS rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK
  54. a64a2d13-097c-fad5-4a2e-4b9912283ade m=audio 51686 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 110 112 113 126
  55. a64a2d13-097c-fad5-4a2e-4b9912283ade c=IN IP4 65.15.69.32
  56. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp:9 IN IP4 0.0.0.0
  57. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:3676716184 1 udp 2122255103 2001::9d38:6ab8:2857:2624:bef0:badf 51685 typ host generation 0 network-id 1 network-cost 50
  58. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:3687888086 1 udp 2122194687 192.168.1.123 51686 typ host generation 0 network-id 2
  59. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:1519956578 1 udp 1685987071 65.15.69.32 51686 typ srflx raddr 192.168.1.123 rport 51686 generation 0 network-id 2
  60. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:2510667880 1 tcp 1518275327 2001::9d38:6ab8:2857:2624:bef0:badf 9 typ host tcptype active generation 0 network-id 1 network-cost 50
  61. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:2505263142 1 tcp 1518214911 192.168.1.123 9 typ host tcptype active generation 0 network-id 2
  62. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ice-ufrag:iTlu
  63. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ice-pwd:2z9+7ZinoPf0BfuMNQlkVeq6
  64. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ice-options:trickle
  65. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fingerprint:sha-256 DE:E3:A2:8A:E4:1F:94:68:CE:16:A6:74:7B:B1:25:A1:FC:F7:90:10:06:C0:F3:EB:F9:27:77:9F:1E:39:3D:92
  66. a64a2d13-097c-fad5-4a2e-4b9912283ade a=setup:actpass
  67. a64a2d13-097c-fad5-4a2e-4b9912283ade a=mid:audio
  68. a64a2d13-097c-fad5-4a2e-4b9912283ade a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
  69. a64a2d13-097c-fad5-4a2e-4b9912283ade a=sendrecv
  70. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-mux
  71. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:111 opus/48000/2
  72. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:111 transport-cc
  73. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fmtp:111 minptime=10;useinbandfec=1; stereo=1; sprop-stereo=1
  74. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:103 ISAC/16000
  75. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:104 ISAC/32000
  76. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:9 G722/8000
  77. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:0 PCMU/8000
  78. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:8 PCMA/8000
  79. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:106 CN/32000
  80. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:105 CN/16000
  81. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:13 CN/8000
  82. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:110 telephone-event/48000
  83. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:112 telephone-event/32000
  84. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:113 telephone-event/16000
  85. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:126 telephone-event/8000
  86. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:395565095 cname:aJLaOP3UK2dzvkhh
  87. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:395565095 msid:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK 7a7af0af-b247-4dc4-9916-3c10cbc478a5
  88. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:395565095 mslabel:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK
  89. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:395565095 label:7a7af0af-b247-4dc4-9916-3c10cbc478a5
  90. a64a2d13-097c-fad5-4a2e-4b9912283ade m=video 51688 UDP/TLS/RTP/SAVPF 96 98 100 102 127 97 99 101 125
  91. a64a2d13-097c-fad5-4a2e-4b9912283ade c=IN IP4 65.15.69.32
  92. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp:9 IN IP4 0.0.0.0
  93. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:3676716184 1 udp 2122255103 2001::9d38:6ab8:2857:2624:bef0:badf 51687 typ host generation 0 network-id 1 network-cost 50
  94. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:3687888086 1 udp 2122194687 192.168.1.123 51688 typ host generation 0 network-id 2
  95. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:1519956578 1 udp 1685987071 65.15.69.32 51688 typ srflx raddr 192.168.1.123 rport 51688 generation 0 network-id 2
  96. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:2510667880 1 tcp 1518275327 2001::9d38:6ab8:2857:2624:bef0:badf 9 typ host tcptype active generation 0 network-id 1 network-cost 50
  97. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:2505263142 1 tcp 1518214911 192.168.1.123 9 typ host tcptype active generation 0 network-id 2
  98. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ice-ufrag:iTlu
  99. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ice-pwd:2z9+7ZinoPf0BfuMNQlkVeq6
  100. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ice-options:trickle
  101. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fingerprint:sha-256 DE:E3:A2:8A:E4:1F:94:68:CE:16:A6:74:7B:B1:25:A1:FC:F7:90:10:06:C0:F3:EB:F9:27:77:9F:1E:39:3D:92
  102. a64a2d13-097c-fad5-4a2e-4b9912283ade a=setup:actpass
  103. a64a2d13-097c-fad5-4a2e-4b9912283ade a=mid:video
  104. a64a2d13-097c-fad5-4a2e-4b9912283ade a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
  105. a64a2d13-097c-fad5-4a2e-4b9912283ade a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
  106. a64a2d13-097c-fad5-4a2e-4b9912283ade a=extmap:4 urn:3gpp:video-orientation
  107. a64a2d13-097c-fad5-4a2e-4b9912283ade a=extmap:5 http://www.ietf.org/id/draft-holmer-rmcat-transport-wide-cc-extensions-01
  108. a64a2d13-097c-fad5-4a2e-4b9912283ade a=extmap:6 http://www.webrtc.org/experiments/rtp-hdrext/playout-delay
  109. a64a2d13-097c-fad5-4a2e-4b9912283ade a=sendrecv
  110. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-mux
  111. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-rsize
  112. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:96 VP8/90000
  113. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:96 ccm fir
  114. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:96 nack
  115. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:96 nack pli
  116. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:96 goog-remb
  117. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:96 transport-cc
  118. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:98 VP9/90000
  119. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:98 ccm fir
  120. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:98 nack
  121. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:98 nack pli
  122. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:98 goog-remb
  123. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:98 transport-cc
  124. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:100 H264/90000
  125. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:100 ccm fir
  126. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:100 nack
  127. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:100 nack pli
  128. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:100 goog-remb
  129. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:100 transport-cc
  130. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
  131. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:102 red/90000
  132. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:127 ulpfec/90000
  133. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:97 rtx/90000
  134. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fmtp:97 apt=96
  135. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:99 rtx/90000
  136. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fmtp:99 apt=98
  137. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:101 rtx/90000
  138. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fmtp:101 apt=100
  139. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:125 rtx/90000
  140. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fmtp:125 apt=102
  141. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc-group:FID 2784642864 1476148818
  142. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:2784642864 cname:aJLaOP3UK2dzvkhh
  143. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:2784642864 msid:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK 7d0e195f-df11-4940-993d-aee0e4ed4857
  144. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:2784642864 mslabel:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK
  145. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:2784642864 label:7d0e195f-df11-4940-993d-aee0e4ed4857
  146. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:1476148818 cname:aJLaOP3UK2dzvkhh
  147. a=ssrc:1476148818 msid:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK 7d0e195f-df11-4940-993d-aee0e4ed4857
  148. a=ssrc:1476148818 mslabel:rMHRy69szr2SCaZAwfD563M8TUKF6elR9hfK
  149. a=ssrc:1476148818 label:7d0e195f-df11-4940-993d-aee0e4ed4857
  150.  
  151.  
  152. 2017-10-05 11:00:01.964211 [ALERT] mod_verto.c:601 WRITE 192.168.1.1:55563 [{
  153.         "jsonrpc":      "2.0",
  154.         "id":   22,
  155.         "result":       {
  156.                 "message":      "CALL CREATED",
  157.                 "callID":       "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  158.                 "sessid":       "8f00da09-b94a-6eac-7246-f8f6f4d3ad78"
  159.         }
  160. }]
  161. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.964211 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/1002) Running State Change CS_INIT (Cur 1 Tot 803)
  162. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.964211 [DEBUG] switch_core_state_machine.c:627 (verto.rtc/1002) State INIT
  163. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.964211 [DEBUG] switch_core_state_machine.c:40 verto.rtc/1002 Standard INIT
  164. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.964211 [DEBUG] switch_core_state_machine.c:48 (verto.rtc/1002) State Change CS_INIT -> CS_ROUTING
  165. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.964211 [DEBUG] switch_core_state_machine.c:627 (verto.rtc/1002) State INIT going to sleep
  166. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.964211 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/1002) Running State Change CS_ROUTING (Cur 1 Tot 803)
  167. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] switch_channel.c:2249 (verto.rtc/1002) Callstate Change DOWN -> RINGING
  168. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] switch_core_state_machine.c:643 (verto.rtc/1002) State ROUTING
  169. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] mod_rtc.c:89 verto.rtc/1002 RTC ROUTING
  170. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] switch_core_state_machine.c:236 verto.rtc/1002 Standard ROUTING
  171. 2017-10-05 11:00:01.974180 [ALERT] mod_verto.c:5543 EVENT BROADCAST presence.1001@192.168.1.113 {
  172.         "data": {
  173.                 "channelCallState":     "RINGING",
  174.                 "originalChannelCallState":     "DOWN",
  175.                 "channelState": "CS_ROUTING",
  176.                 "callerUserName":       "1001@192.168.1.113",
  177.                 "callerIDName": "1001",
  178.                 "callerIDNumber":       "joshua@freeswitch.org",
  179.                 "calleeIDName": "Outbound Call",
  180.                 "calleeIDNumber":       "1002",
  181.                 "channelUUID":  "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  182.                 "presenceCallDirection":        "inbound",
  183.                 "channelPresenceID":    "1001@192.168.1.113"
  184.         },
  185.         "eventChannel": "presence.1001@192.168.1.113"
  186. }
  187. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [INFO] mod_dialplan_xml.c:637 Processing 1001 <joshua@freeswitch.org>->1002 in context default
  188. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->api-on-answer-test] continue=false
  189. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [api-on-answer-test] destination_number(1002) =~ /^(779)$/ break=on-false
  190. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->fifo_test_agent] continue=false
  191. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [fifo_test_agent] destination_number(1002) =~ /^(777)$/ break=on-false
  192. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->fifo_test_caller] continue=false
  193. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [fifo_test_caller] destination_number(1002) =~ /^(778)$/ break=on-false
  194. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->amd_test] continue=false
  195. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [amd_test] destination_number(1002) =~ /^(amd_test)$/ break=on-false
  196. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->flowroute.com] continue=false
  197. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [flowroute.com] destination_number(1002) =~ /^(\+?1?\d{11})$/ break=on-false
  198. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->perl_test] continue=false
  199. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [perl_test] destination_number(1002) =~ /^(595)$/ break=on-false
  200. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->test flac play] continue=false
  201. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [test flac play] destination_number(1002) =~ /^(596)$/ break=on-false
  202. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->test flac record] continue=false
  203. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [test flac record] destination_number(1002) =~ /^(597)$/ break=on-false
  204. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->test lua] continue=false
  205. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [test lua] destination_number(1002) =~ /^(598)$/ break=on-false
  206. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->123_screen] continue=false
  207. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [123_screen] destination_number(1002) =~ /^(3600)$/ break=on-false
  208. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->conf_bridger] continue=false
  209. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [conf_bridger] destination_number(1002) =~ /^599$/ break=on-false
  210. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->cdquality_stereo_conferences] continue=false
  211. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [cdquality_stereo_conferences] destination_number(1002) =~ /^599-screen$/ break=on-false
  212. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->unloop] continue=false
  213. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false
  214. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false
  215. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->tod_example] continue=true
  216. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Date/Time Match (PASS) [tod_example] break=on-false
  217. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action set(open=true)
  218. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->holiday_example] continue=true
  219. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Date/TimeMatch (FAIL) [holiday_example] break=on-false
  220. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->global-intercept] continue=false
  221. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [global-intercept] destination_number(1002) =~ /^886$/ break=on-false
  222. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->group-intercept] continue=false
  223. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [group-intercept] destination_number(1002) =~ /^\*8$/ break=on-false
  224. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->intercept-ext] continue=false
  225. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [intercept-ext] destination_number(1002) =~ /^\*\*(\d+)$/ break=on-false
  226. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->redial] continue=false
  227. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [redial] destination_number(1002) =~ /^(redial|870)$/ break=on-false
  228. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->global] continue=true
  229. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never
  230. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [global] ${default_password}(j0sh3b0sh) =~ /^1234$/ break=never
  231. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 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
  232. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [global] ${endpoint_disposition}() =~ /^(DELAYED NEGOTIATION)/ break=on-false
  233. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->snom-demo-2] continue=false
  234. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [snom-demo-2] destination_number(1002) =~ /^9001$/ break=on-false
  235. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->snom-demo-1] continue=false
  236. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [snom-demo-1] destination_number(1002) =~ /^9000$/ break=on-false
  237. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->eavesdrop] continue=false
  238. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [eavesdrop] destination_number(1002) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false
  239. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->eavesdrop] continue=false
  240. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [eavesdrop] destination_number(1002) =~ /^779$/ break=on-false
  241. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->call_return] continue=false
  242. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [call_return] destination_number(1002) =~ /^\*69$|^869$|^lcr$/ break=on-false
  243. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->del-group] continue=false
  244. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [del-group] destination_number(1002) =~ /^80(\d{2})$/ break=on-false
  245. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->add-group] continue=false
  246. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [add-group] destination_number(1002) =~ /^81(\d{2})$/ break=on-false
  247. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->call-group-simo] continue=false
  248. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [call-group-simo] destination_number(1002) =~ /^82(\d{2})$/ break=on-false
  249. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->call-group-order] continue=false
  250. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [call-group-order] destination_number(1002) =~ /^83(\d{2})$/ break=on-false
  251. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->extension-intercom] continue=false
  252. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (FAIL) [extension-intercom] destination_number(1002) =~ /^8(10[01][0-9])$/ break=on-false
  253. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 parsing [default->Local_Extension] continue=false
  254. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Regex (PASS) [Local_Extension] destination_number(1002) =~ /^(10[01][0-9])$/ break=on-false
  255. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action export(dialed_extension=1002)
  256. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action bind_meta_app(1 b s execute_extension::dx XML features)
  257. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/${caller_id_number}.${strftime(%Y-%m-%d-%H-%M-%S)}.wav)
  258. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action bind_meta_app(3 b s execute_extension::cf XML features)
  259. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action bind_meta_app(4 b s execute_extension::att_xfer XML features)
  260. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action set(ringback=${us-ring})
  261. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action set(transfer_ringback=/usr/local/freeswitch/sounds/joshebosh/Tomtoms.wav)
  262. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action set(call_timeout=30)
  263. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action set(hangup_after_bridge=true)
  264. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action set(continue_on_fail=true)
  265. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action hash(insert/${domain_name}-call_return/${dialed_extension}/${caller_id_number})
  266. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action hash(insert/${domain_name}-last_dial_ext/${dialed_extension}/${uuid})
  267. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action set(called_party_callgroup=${user_data(${dialed_extension}@${domain_name} var callgroup)})
  268. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action hash(insert/${domain_name}-last_dial_ext/${called_party_callgroup}/${uuid})
  269. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action hash(insert/${domain_name}-last_dial_ext/global/${uuid})
  270. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action hash(insert/${domain_name}-last_dial/${called_party_callgroup}/${uuid})
  271. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action set(media_bug_answer_req=true)
  272. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action set(record_concat_video=true)
  273. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action set(record_file_name=/var/www/html/fs/${strftime(%Y-%m-%d-%H-%M-%S)}_${uuid}.mp4) INLINE
  274. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 set(record_file_name=/var/www/html/fs/2017-10-05-11-00-01_a64a2d13-097c-fad5-4a2e-4b9912283ade.mp4)
  275. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [record_file_name]=[/var/www/html/fs/2017-10-05-11-00-01_a64a2d13-097c-fad5-4a2e-4b9912283ade.mp4]
  276. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action answer()
  277. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action bridge(user/${dialed_extension}@${domain_name})
  278. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action sleep(1000)
  279. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action bridge(user/1003@192.168.150.3)
  280. a64a2d13-097c-fad5-4a2e-4b9912283ade Dialplan: verto.rtc/1002 Action bridge(loopback/app=voicemail:default ${domain_name} ${dialed_extension})
  281. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] switch_core_state_machine.c:286 (verto.rtc/1002) State Change CS_ROUTING -> CS_EXECUTE
  282. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] switch_core_state_machine.c:643 (verto.rtc/1002) State ROUTING going to sleep
  283. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/1002) Running State Change CS_EXECUTE (Cur 1 Tot 803)
  284. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] switch_core_state_machine.c:650 (verto.rtc/1002) State EXECUTE
  285. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] mod_rtc.c:120 verto.rtc/1002 RTC EXECUTE
  286. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] switch_core_state_machine.c:328 verto.rtc/1002 Standard EXECUTE
  287. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 set(open=true)
  288. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [open]=[true]
  289. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 export(dialed_extension=1002)
  290. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] switch_channel.c:1296 EXPORT (export_vars) [dialed_extension]=[1002]
  291. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 bind_meta_app(1 b s execute_extension::dx XML features)
  292. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *1 execute_extension::dx XML features
  293. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 bind_meta_app(2 b s record_session::/usr/local/freeswitch/recordings/joshua@freeswitch.org.2017-10-05-11-00-01.wav)
  294. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *2 record_session::/usr/local/freeswitch/recordings/joshua@freeswitch.org.2017-10-05-11-00-01.wav
  295. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 bind_meta_app(3 b s execute_extension::cf XML features)
  296. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *3 execute_extension::cf XML features
  297. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 bind_meta_app(4 b s execute_extension::att_xfer XML features)
  298. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [INFO] switch_ivr_async.c:4273 Bound B-Leg: *4 execute_extension::att_xfer XML features
  299. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 set(ringback=%(2000,4000,440,480))
  300. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [ringback]=[%(2000,4000,440,480)]
  301. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 set(transfer_ringback=/usr/local/freeswitch/sounds/joshebosh/Tomtoms.wav)
  302. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [transfer_ringback]=[/usr/local/freeswitch/sounds/joshebosh/Tomtoms.wav]
  303. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 set(call_timeout=30)
  304. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [call_timeout]=[30]
  305. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 set(hangup_after_bridge=true)
  306. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [hangup_after_bridge]=[true]
  307. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 set(continue_on_fail=true)
  308. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [continue_on_fail]=[true]
  309. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 hash(insert/192.168.1.113-call_return/1002/joshua@freeswitch.org)
  310. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 hash(insert/192.168.1.113-last_dial_ext/1002/a64a2d13-097c-fad5-4a2e-4b9912283ade)
  311. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 set(called_party_callgroup=management)
  312. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.974180 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [called_party_callgroup]=[management]
  313. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 hash(insert/192.168.1.113-last_dial_ext/management/a64a2d13-097c-fad5-4a2e-4b9912283ade)
  314. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 hash(insert/192.168.1.113-last_dial_ext/global/a64a2d13-097c-fad5-4a2e-4b9912283ade)
  315. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 hash(insert/192.168.1.113-last_dial/management/a64a2d13-097c-fad5-4a2e-4b9912283ade)
  316. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 set(media_bug_answer_req=true)
  317. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [media_bug_answer_req]=[true]
  318. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 set(record_concat_video=true)
  319. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] mod_dptools.c:1588 SET verto.rtc/1002 [record_concat_video]=[true]
  320. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 answer()
  321. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [opus:111:48000:20:0:2]/[opus:116:48000:20:0:1]
  322. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5183 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
  323. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [ISAC:103:16000:30:32000:1]/[opus:116:48000:20:0:1]
  324. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [ISAC:104:32000:30:32000:1]/[opus:116:48000:20:0:1]
  325. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1]
  326. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
  327. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1]
  328. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [CN:106:32000:20:0:1]/[opus:116:48000:20:0:1]
  329. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [CN:105:16000:20:0:1]/[opus:116:48000:20:0:1]
  330. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [CN:13:8000:20:0:1]/[opus:116:48000:20:0:1]
  331. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5044 Set telephone-event payload to 110@48000
  332. 2017-10-05 11:00:01.984181 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps]
  333. 2017-10-05 11:00:01.984181 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps]
  334. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3443 Set Codec verto.rtc/1002 opus/48000 20 ms 960 samples 0 bits 2 channels
  335. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_codec.c:111 verto.rtc/1002 Original read codec set to opus:116
  336. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3867 Drop audio Candidate cid: 1 proto: udp type: host addr: 2001::9d38:6ab8:2857:2624:bef0:badf:51685 (no network path)
  337. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3873 Save audio Candidate cid: 1 proto: udp type: host addr: 192.168.1.123:51686
  338. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3873 Save audio Candidate cid: 1 proto: udp type: srflx addr: 65.15.69.32:51686
  339. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3915 Searching for rtp candidate.
  340. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3920 Choose rtp candidate, index 0, 192.168.1.123:51686
  341. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3693 verto.rtc/1002 choosing family v4
  342. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3931 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 192.168.1.123:51686
  343. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3978 setting remote audio ice addr to index 0 192.168.1.123:51686 based on candidate
  344. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:4013 Setting remote rtcp audio addr to 192.168.1.123:51686 based on candidate
  345. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5387 Set telephone-event payload to 110@48000
  346. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5445 verto.rtc/1002 Set 2833 dtmf send payload to 110 recv payload to 110
  347. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5728 Video Codec Compare [VP8:96]/[H264:99]
  348. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5728 Video Codec Compare [VP9:98]/[H264:99]
  349. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5728 Video Codec Compare [H264:100]/[H264:99]
  350. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5760 Video Codec Compare [H264:100] +++ is saved as a match
  351. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5728 Video Codec Compare [red:102]/[H264:99]
  352. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5728 Video Codec Compare [ulpfec:127]/[H264:99]
  353. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5728 Video Codec Compare [rtx:97]/[H264:99]
  354. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5728 Video Codec Compare [rtx:99]/[H264:99]
  355. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5728 Video Codec Compare [rtx:101]/[H264:99]
  356. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:5728 Video Codec Compare [rtx:125]/[H264:99]
  357. 2017-10-05 11:00:01.984181 [NOTICE] avcodec.c:1024 codec: id=28 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
  358. 2017-10-05 11:00:01.984181 [NOTICE] avcodec.c:1024 codec: id=28 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10
  359. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3253 Set VIDEO Codec verto.rtc/1002 H264/90000 0 ms
  360. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3867 Drop video Candidate cid: 1 proto: udp type: host addr: 2001::9d38:6ab8:2857:2624:bef0:badf:51687 (no network path)
  361. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3873 Save video Candidate cid: 1 proto: udp type: host addr: 192.168.1.123:51688
  362. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3873 Save video Candidate cid: 1 proto: udp type: srflx addr: 65.15.69.32:51688
  363. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3915 Searching for rtp candidate.
  364. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3920 Choose rtp candidate, index 0, 192.168.1.123:51688
  365. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3693 verto.rtc/1002 choosing family v4
  366. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3931 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 192.168.1.123:51688
  367. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:3978 setting remote video ice addr to index 0 192.168.1.123:51688 based on candidate
  368. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:4013 Setting remote rtcp video addr to 192.168.1.123:51688 based on candidate
  369. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:8162 AUDIO RTP [verto.rtc/1002] 192.168.1.113 port 16454 -> 192.168.1.123 port 51686 codec: 111 ms: 20
  370. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_rtp.c:4191 Starting timer [soft] 960 bytes per 20ms
  371. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [INFO] switch_core_media.c:8341 Activating Audio ICE
  372. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [NOTICE] switch_rtp.c:4690 Activating RTP audio ICE: iTlu:V9rA81ElyWoho6f2 192.168.1.123:51686
  373. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:8382 Activating RTCP PORT 51686
  374. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_rtp.c:4587 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 51686
  375. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [INFO] switch_core_media.c:8393 Skipping RTCP ICE (Same as RTP)
  376. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [INFO] switch_rtp.c:3643 Activate RTP/RTCP audio DTLS client
  377. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [INFO] switch_rtp.c:3806 Changing audio DTLS state from OFF to HANDSHAKE
  378. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:2204 Setting Jitterbuffer to 20ms (1 frames) (50 max frames)
  379. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:8466 verto.rtc/1002 Set 2833 dtmf send payload to 110
  380. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:8473 verto.rtc/1002 Set 2833 dtmf receive payload to 110
  381. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_rtp.c:4206 Starting video timer.
  382. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:8991 VIDEO RTP [verto.rtc/1002] 192.168.1.113:16472->192.168.1.123:51688 codec: 100 ms: 0 [SUCCESS]
  383. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:7154 verto.rtc/1002 Starting Video thread
  384. 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:7020 verto.rtc/1002 Video thread started. Echo is off
  385. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [INFO] switch_core_media.c:9033 Activating Video ICE
  386. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [NOTICE] switch_rtp.c:4690 Activating RTP video ICE: iTlu:14Ku0NjrxWwD6t3Z 192.168.1.123:51688
  387. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [INFO] switch_core_media.c:9071 Activating VIDEO RTCP PORT 51688 interval 1000 mux 1
  388. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_rtp.c:4587 RTCP send rate is: 1000 and packet rate is: 90000 Remote Port: 51688
  389. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [INFO] switch_core_media.c:9082 Skipping VIDEO RTCP ICE (Same as VIDEO RTP)
  390. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [INFO] switch_rtp.c:3643 Activate RTP/RTCP video DTLS client
  391. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [INFO] switch_rtp.c:3806 Changing video DTLS state from OFF to HANDSHAKE
  392. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:8145 Audio params are unchanged for verto.rtc/1002.
  393. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] switch_core_media.c:8849 Video params are unchanged for verto.rtc/1002.
  394. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [DEBUG] mod_verto.c:2490 Local SDP verto.rtc/1002:
  395. a64a2d13-097c-fad5-4a2e-4b9912283ade v=0
  396. a64a2d13-097c-fad5-4a2e-4b9912283ade o=FreeSWITCH 1507199147 1507199148 IN IP4 192.168.1.113
  397. a64a2d13-097c-fad5-4a2e-4b9912283ade s=FreeSWITCH
  398. a64a2d13-097c-fad5-4a2e-4b9912283ade c=IN IP4 192.168.1.113
  399. a64a2d13-097c-fad5-4a2e-4b9912283ade t=0 0
  400. a64a2d13-097c-fad5-4a2e-4b9912283ade a=msid-semantic: WMS pmYKmne611HHwCog5ybHO8JdnGscTBS8
  401. a64a2d13-097c-fad5-4a2e-4b9912283ade m=audio 16454 UDP/TLS/RTP/SAVPF 111 110
  402. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:111 opus/48000/2
  403. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fmtp:111 useinbandfec=1; minptime=10; stereo=1; sprop-stereo=1
  404. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:110 telephone-event/48000
  405. a64a2d13-097c-fad5-4a2e-4b9912283ade a=silenceSupp:off - - - -
  406. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ptime:20
  407. a64a2d13-097c-fad5-4a2e-4b9912283ade a=sendrecv
  408. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fingerprint:sha-256 A5:44:80:7A:3C:F0:D1:FD:3C:BD:DE:6E:41:C0:88:27:6C:7E:AA:B9:25:4F:36:20:71:3C:2F:68:BC:B8:D2:64
  409. a64a2d13-097c-fad5-4a2e-4b9912283ade a=setup:active
  410. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-mux
  411. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp:16454 IN IP4 192.168.1.113
  412. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ice-ufrag:V9rA81ElyWoho6f2
  413. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ice-pwd:DPTosGZY28QQvPAhPRHNJcZ7
  414. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:0510665810 1 udp 659136 192.168.1.113 16454 typ host generation 0
  415. a64a2d13-097c-fad5-4a2e-4b9912283ade a=end-of-candidates
  416. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:1039850537 cname:OGJ0UNXLFvi2Xx8T
  417. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:1039850537 msid:pmYKmne611HHwCog5ybHO8JdnGscTBS8 a0
  418. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:1039850537 mslabel:pmYKmne611HHwCog5ybHO8JdnGscTBS8
  419. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:1039850537 label:pmYKmne611HHwCog5ybHO8JdnGscTBS8a0
  420. a64a2d13-097c-fad5-4a2e-4b9912283ade m=video 16472 UDP/TLS/RTP/SAVPF 100
  421. a64a2d13-097c-fad5-4a2e-4b9912283ade b=AS:250
  422. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtpmap:100 H264/90000
  423. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f
  424. a64a2d13-097c-fad5-4a2e-4b9912283ade a=sendrecv
  425. a64a2d13-097c-fad5-4a2e-4b9912283ade a=fingerprint:sha-256 A5:44:80:7A:3C:F0:D1:FD:3C:BD:DE:6E:41:C0:88:27:6C:7E:AA:B9:25:4F:36:20:71:3C:2F:68:BC:B8:D2:64
  426. a64a2d13-097c-fad5-4a2e-4b9912283ade a=setup:active
  427. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-mux
  428. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp:16472 IN IP4 192.168.1.113
  429. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:100 ccm fir
  430. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:100 nack
  431. a64a2d13-097c-fad5-4a2e-4b9912283ade a=rtcp-fb:100 nack pli
  432. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:286263712 cname:OGJ0UNXLFvi2Xx8T
  433. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:286263712 msid:pmYKmne611HHwCog5ybHO8JdnGscTBS8 v0
  434. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:286263712 mslabel:pmYKmne611HHwCog5ybHO8JdnGscTBS8
  435. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ssrc:286263712 label:pmYKmne611HHwCog5ybHO8JdnGscTBS8v0
  436. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ice-ufrag:14Ku0NjrxWwD6t3Z
  437. a64a2d13-097c-fad5-4a2e-4b9912283ade a=ice-pwd:YZ2da2bjFGmGCDQuxrOn5XFs
  438. a64a2d13-097c-fad5-4a2e-4b9912283ade a=candidate:6587643235 1 udp 659136 192.168.1.113 16472 typ host generation 0
  439. a64a2d13-097c-fad5-4a2e-4b9912283ade a=end-of-candidates
  440. a64a2d13-097c-fad5-4a2e-4b9912283ade
  441. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.984181 [NOTICE] mod_dptools.c:1352 Channel [verto.rtc/1002] has been answered
  442. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.994180 [DEBUG] switch_channel.c:3781 (verto.rtc/1002) Callstate Change RINGING -> ACTIVE
  443. 2017-10-05 11:00:01.994180 [ALERT] mod_verto.c:5543 EVENT BROADCAST presence.1001@192.168.1.113 {
  444.         "data": {
  445.                 "channelCallState":     "ACTIVE",
  446.                 "originalChannelCallState":     "RINGING",
  447.                 "channelState": "CS_EXECUTE",
  448.                 "callerUserName":       "1001@192.168.1.113",
  449.                 "callerIDName": "1001",
  450.                 "callerIDNumber":       "joshua@freeswitch.org",
  451.                 "calleeIDName": "Outbound Call",
  452.                 "calleeIDNumber":       "1002",
  453.                 "channelUUID":  "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  454.                 "presenceCallDirection":        "inbound",
  455.                 "channelPresenceID":    "1001@192.168.1.113"
  456.         },
  457.         "eventChannel": "presence.1001@192.168.1.113"
  458. }
  459. a64a2d13-097c-fad5-4a2e-4b9912283ade EXECUTE verto.rtc/1002 bridge(user/1002@192.168.1.113)
  460. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.994180 [DEBUG] switch_channel.c:1823 (verto.rtc/1002) Callstate Change ACTIVE -> RING_WAIT
  461. 2017-10-05 11:00:01.994180 [ALERT] mod_verto.c:5543 EVENT BROADCAST presence.1001@192.168.1.113 {
  462.         "data": {
  463.                 "channelCallState":     "RING_WAIT",
  464.                 "originalChannelCallState":     "ACTIVE",
  465.                 "channelState": "CS_EXECUTE",
  466.                 "callerUserName":       "1001@192.168.1.113",
  467.                 "callerIDName": "1001",
  468.                 "callerIDNumber":       "joshua@freeswitch.org",
  469.                 "calleeIDName": "Outbound Call",
  470.                 "calleeIDNumber":       "1002",
  471.                 "channelUUID":  "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  472.                 "presenceCallDirection":        "inbound",
  473.                 "channelPresenceID":    "1001@192.168.1.113"
  474.         },
  475.         "eventChannel": "presence.1001@192.168.1.113"
  476. }
  477. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.994180 [DEBUG] switch_channel.c:1250 verto.rtc/1002 EXPORTING[export_vars] [dialed_extension]=[1002] to event
  478. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.994180 [DEBUG] switch_ivr_originate.c:2159 Parsing global variables
  479. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.994180 [DEBUG] switch_channel.c:1250 verto.rtc/1002 EXPORTING[export_vars] [dialed_extension]=[1002] to event
  480. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.994180 [DEBUG] switch_ivr_originate.c:2159 Parsing global variables
  481. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:01.994180 [NOTICE] switch_ivr_originate.c:2868 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED]
  482. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] mod_rtc.c:392 () State Change CS_NEW -> CS_INIT
  483. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [NOTICE] switch_channel.c:1104 New Channel verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 [b3dddbfc-a3ba-405b-8272-2541d73ad160]
  484. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Running State Change CS_INIT (Cur 2 Tot 804)
  485. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_core_state_machine.c:627 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State INIT
  486. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] mod_verto.c:2255 Local verto.invite SDP verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5:
  487. b3dddbfc-a3ba-405b-8272-2541d73ad160 v=0
  488. b3dddbfc-a3ba-405b-8272-2541d73ad160 o=FreeSWITCH 1507199137 1507199138 IN IP4 65.15.69.32
  489. b3dddbfc-a3ba-405b-8272-2541d73ad160 s=FreeSWITCH
  490. b3dddbfc-a3ba-405b-8272-2541d73ad160 c=IN IP4 65.15.69.32
  491. b3dddbfc-a3ba-405b-8272-2541d73ad160 t=0 0
  492. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=msid-semantic: WMS i2gahfk0u1Il79NE0mUASnLVjrugbcJj
  493. b3dddbfc-a3ba-405b-8272-2541d73ad160 m=audio 16464 RTP/SAVPF 102
  494. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtpmap:102 opus/48000/2
  495. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40
  496. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=fingerprint:sha-256 A5:44:80:7A:3C:F0:D1:FD:3C:BD:DE:6E:41:C0:88:27:6C:7E:AA:B9:25:4F:36:20:71:3C:2F:68:BC:B8:D2:64
  497. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=setup:actpass
  498. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtcp-mux
  499. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtcp:16464 IN IP4 65.15.69.32
  500. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ssrc:3588277673 cname:4PkcVu2gmArjA4Nq
  501. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ssrc:3588277673 msid:i2gahfk0u1Il79NE0mUASnLVjrugbcJj a0
  502. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ssrc:3588277673 mslabel:i2gahfk0u1Il79NE0mUASnLVjrugbcJj
  503. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ssrc:3588277673 label:i2gahfk0u1Il79NE0mUASnLVjrugbcJja0
  504. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ice-ufrag:hyQ0LsMVK61L9AV4
  505. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ice-pwd:g561qZ7CppLQkp7rNNip6UaG
  506. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=candidate:2032564126 1 udp 659136 65.15.69.32 16464 typ host generation 0
  507. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=candidate:2032564126 2 udp 659136 65.15.69.32 16464 typ host generation 0
  508. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=silenceSupp:off - - - -
  509. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ptime:20
  510. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=sendrecv
  511. b3dddbfc-a3ba-405b-8272-2541d73ad160 m=video 16482 RTP/SAVPF 103
  512. b3dddbfc-a3ba-405b-8272-2541d73ad160 b=AS:1024
  513. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtpmap:103 H264/90000
  514. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=sendrecv
  515. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=fingerprint:sha-256 A5:44:80:7A:3C:F0:D1:FD:3C:BD:DE:6E:41:C0:88:27:6C:7E:AA:B9:25:4F:36:20:71:3C:2F:68:BC:B8:D2:64
  516. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=setup:actpass
  517. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtcp-mux
  518. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtcp:16482 IN IP4 65.15.69.32
  519. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtcp-fb:103 ccm fir
  520. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtcp-fb:103 ccm tmmbr
  521. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtcp-fb:103 nack
  522. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtcp-fb:103 nack pli
  523. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ssrc:2834690848 cname:4PkcVu2gmArjA4Nq
  524. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ssrc:2834690848 msid:i2gahfk0u1Il79NE0mUASnLVjrugbcJj v0
  525. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ssrc:2834690848 mslabel:i2gahfk0u1Il79NE0mUASnLVjrugbcJj
  526. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ssrc:2834690848 label:i2gahfk0u1Il79NE0mUASnLVjrugbcJjv0
  527. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ice-ufrag:ujsQyZs19KFyZAAT
  528. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ice-pwd:ESJtb5ZmzbQXZJajTsZhih9h
  529. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=candidate:7675915594 1 udp 659136 65.15.69.32 16482 typ host generation 0
  530. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=candidate:7675915594 2 udp 659135 65.15.69.32 16482 typ host generation 0
  531. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=end-of-candidates
  532. b3dddbfc-a3ba-405b-8272-2541d73ad160
  533. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [NOTICE] mod_verto.c:2355 Ring-Ready verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5!
  534. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_channel.c:3354 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Callstate Change DOWN -> RINGING
  535. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_core_state_machine.c:40 verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 Standard INIT
  536. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_core_state_machine.c:48 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State Change CS_INIT -> CS_ROUTING
  537. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_core_state_machine.c:627 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State INIT going to sleep
  538. 2017-10-05 11:00:01.994180 [ALERT] mod_verto.c:5543 EVENT BROADCAST presence.1002@192.168.1.113 {
  539.         "data": {
  540.                 "channelCallState":     "RINGING",
  541.                 "originalChannelCallState":     "DOWN",
  542.                 "channelState": "CS_INIT",
  543.                 "callerUserName":       "1001@192.168.1.113",
  544.                 "callerIDName": "Extension 1001",
  545.                 "callerIDNumber":       "1001",
  546.                 "calleeIDName": "1002",
  547.                 "calleeIDNumber":       "1002",
  548.                 "channelUUID":  "b3dddbfc-a3ba-405b-8272-2541d73ad160",
  549.                 "presenceCallDirection":        "outbound",
  550.                 "channelPresenceID":    "1002@192.168.1.113"
  551.         },
  552.         "eventChannel": "presence.1002@192.168.1.113"
  553. }
  554. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Running State Change CS_ROUTING (Cur 2 Tot 804)
  555. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_core_state_machine.c:643 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State ROUTING
  556. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] mod_rtc.c:89 verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 RTC ROUTING
  557. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_ivr_originate.c:67 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  558. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_core_state_machine.c:643 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State ROUTING going to sleep
  559. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Running State Change CS_CONSUME_MEDIA (Cur 2 Tot 804)
  560. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_core_state_machine.c:662 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State CONSUME_MEDIA
  561. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:01.994180 [DEBUG] switch_core_state_machine.c:662 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State CONSUME_MEDIA going to sleep
  562. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:02.004186 [DEBUG] switch_ivr_originate.c:1278 Raw Codec Activation Success L16@48000hz 2 channel 20ms
  563. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:02.004186 [DEBUG] switch_core_codec.c:223 verto.rtc/1002 Push codec L16:100
  564. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:02.004186 [DEBUG] switch_ivr_originate.c:1310 Play Ringback File [/usr/local/freeswitch/sounds/joshebosh/Tomtoms.wav]
  565. 2017-10-05 11:00:02.004186 [DEBUG] switch_core_file.c:358 File /usr/local/freeswitch/sounds/joshebosh/Tomtoms.wav sample rate 44100 doesn't match requested rate 48000
  566. 2017-10-05 11:00:02.004186 [WARNING] switch_core_file.c:376 File has 1 channels, muxing to 2 channels will occur.
  567. 2017-10-05 11:00:02.014178 [ALERT] mod_verto.c:601 WRITE 192.168.1.1:55563 [{
  568.         "jsonrpc":      "2.0",
  569.         "id":   177,
  570.         "method":       "verto.answer",
  571.         "params":       {
  572.                 "callID":       "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  573.                 "sdp":  "v=0\r\no=FreeSWITCH 1507199147 1507199148 IN IP4 192.168.1.113\r\ns=FreeSWITCH\r\nc=IN IP4 192.168.1.113\r\nt=0 0\r\na=msid-semantic: WMS pmYKmne611HHwCog5ybHO8JdnGscTBS8\r\nm=audio 16454 UDP/TLS/RTP/SAVPF 111 110\r\na=rtpmap:111 opus/48000/2\r\na=fmtp:111 useinbandfec=1; minptime=10; stereo=1; sprop-stereo=1\r\na=rtpmap:110 telephone-event/48000\r\na=silenceSupp:off - - - -\r\na=ptime:20\r\na=sendrecv\r\na=fingerprint:sha-256 A5:44:80:7A:3C:F0:D1:FD:3C:BD:DE:6E:41:C0:88:27:6C:7E:AA:B9:25:4F:36:20:71:3C:2F:68:BC:B8:D2:64\r\na=setup:active\r\na=rtcp-mux\r\na=rtcp:16454 IN IP4 192.168.1.113\r\na=ice-ufrag:V9rA81ElyWoho6f2\r\na=ice-pwd:DPTosGZY28QQvPAhPRHNJcZ7\r\na=candidate:0510665810 1 udp 659136 192.168.1.113 16454 typ host generation 0\r\na=end-of-candidates\r\na=ssrc:1039850537 cname:OGJ0UNXLFvi2Xx8T\r\na=ssrc:1039850537 msid:pmYKmne611HHwCog5ybHO8JdnGscTBS8 a0\r\na=ssrc:1039850537 mslabel:pmYKmne611HHwCog5ybHO8JdnGscTBS8\r\na=ssrc:1039850537 label:pmYKmne611HHwCog5ybHO8JdnGscTBS8a0\r\nm=video 16472 UDP/TLS/RTP/SAVPF 100\r\nb=AS:250\r\na=rtpmap:100 H264/90000\r\na=fmtp:100 level-asymmetry-allowed=1;packetization-mode=1;profile-level-id=42e01f\r\na=sendrecv\r\na=fingerprint:sha-256 A5:44:80:7A:3C:F0:D1:FD:3C:BD:DE:6E:41:C0:88:27:6C:7E:AA:B9:25:4F:36:20:71:3C:2F:68:BC:B8:D2:64\r\na=setup:active\r\na=rtcp-mux\r\na=rtcp:16472 IN IP4 192.168.1.113\r\na=rtcp-fb:100 ccm fir\r\na=rtcp-fb:100 nack\r\na=rtcp-fb:100 nack pli\r\na=ssrc:286263712 cname:OGJ0UNXLFvi2Xx8T\r\na=ssrc:286263712 msid:pmYKmne611HHwCog5ybHO8JdnGscTBS8 v0\r\na=ssrc:286263712 mslabel:pmYKmne611HHwCog5ybHO8JdnGscTBS8\r\na=ssrc:286263712 label:pmYKmne611HHwCog5ybHO8JdnGscTBS8v0\r\na=ice-ufrag:14Ku0NjrxWwD6t3Z\r\na=ice-pwd:YZ2da2bjFGmGCDQuxrOn5XFs\r\na=candidate:6587643235 1 udp 659136 192.168.1.113 16472 typ host generation 0\r\na=end-of-candidates\r\n"
  574.         }
  575. }]
  576. 2017-10-05 11:00:02.024179 [ALERT] mod_verto.c:1405 READ 192.168.1.1:55563 [{
  577.         "jsonrpc":      "2.0",
  578.         "id":   177,
  579.         "result":       {
  580.                 "method":       "verto.answer"
  581.         }
  582. }]
  583. 2017-10-05 11:00:02.024179 [ALERT] mod_verto.c:601 WRITE 166.170.56.190:53568 [{
  584.         "jsonrpc":      "2.0",
  585.         "id":   178,
  586.         "method":       "verto.invite",
  587.         "params":       {
  588.                 "callID":       "b3dddbfc-a3ba-405b-8272-2541d73ad160",
  589.                 "sdp":  "v=0\r\no=FreeSWITCH 1507199137 1507199138 IN IP4 65.15.69.32\r\ns=FreeSWITCH\r\nc=IN IP4 65.15.69.32\r\nt=0 0\r\na=msid-semantic: WMS i2gahfk0u1Il79NE0mUASnLVjrugbcJj\r\nm=audio 16464 RTP/SAVPF 102\r\na=rtpmap:102 opus/48000/2\r\na=fmtp:102 useinbandfec=1; maxaveragebitrate=30000; maxplaybackrate=48000; ptime=20; minptime=10; maxptime=40\r\na=fingerprint:sha-256 A5:44:80:7A:3C:F0:D1:FD:3C:BD:DE:6E:41:C0:88:27:6C:7E:AA:B9:25:4F:36:20:71:3C:2F:68:BC:B8:D2:64\r\na=setup:actpass\r\na=rtcp-mux\r\na=rtcp:16464 IN IP4 65.15.69.32\r\na=ssrc:3588277673 cname:4PkcVu2gmArjA4Nq\r\na=ssrc:3588277673 msid:i2gahfk0u1Il79NE0mUASnLVjrugbcJj a0\r\na=ssrc:3588277673 mslabel:i2gahfk0u1Il79NE0mUASnLVjrugbcJj\r\na=ssrc:3588277673 label:i2gahfk0u1Il79NE0mUASnLVjrugbcJja0\r\na=ice-ufrag:hyQ0LsMVK61L9AV4\r\na=ice-pwd:g561qZ7CppLQkp7rNNip6UaG\r\na=candidate:2032564126 1 udp 659136 65.15.69.32 16464 typ host generation 0\r\na=candidate:2032564126 2 udp 659136 65.15.69.32 16464 typ host generation 0\r\na=silenceSupp:off - - - -\r\na=ptime:20\r\na=sendrecv\r\nm=video 16482 RTP/SAVPF 103\r\nb=AS:1024\r\na=rtpmap:103 H264/90000\r\na=sendrecv\r\na=fingerprint:sha-256 A5:44:80:7A:3C:F0:D1:FD:3C:BD:DE:6E:41:C0:88:27:6C:7E:AA:B9:25:4F:36:20:71:3C:2F:68:BC:B8:D2:64\r\na=setup:actpass\r\na=rtcp-mux\r\na=rtcp:16482 IN IP4 65.15.69.32\r\na=rtcp-fb:103 ccm fir\r\na=rtcp-fb:103 ccm tmmbr\r\na=rtcp-fb:103 nack\r\na=rtcp-fb:103 nack pli\r\na=ssrc:2834690848 cname:4PkcVu2gmArjA4Nq\r\na=ssrc:2834690848 msid:i2gahfk0u1Il79NE0mUASnLVjrugbcJj v0\r\na=ssrc:2834690848 mslabel:i2gahfk0u1Il79NE0mUASnLVjrugbcJj\r\na=ssrc:2834690848 label:i2gahfk0u1Il79NE0mUASnLVjrugbcJjv0\r\na=ice-ufrag:ujsQyZs19KFyZAAT\r\na=ice-pwd:ESJtb5ZmzbQXZJajTsZhih9h\r\na=candidate:7675915594 1 udp 659136 65.15.69.32 16482 typ host generation 0\r\na=candidate:7675915594 2 udp 659135 65.15.69.32 16482 typ host generation 0\r\na=end-of-candidates\r\n",
  590.                 "caller_id_name":       "Extension 1001",
  591.                 "caller_id_number":     "1001",
  592.                 "callee_id_name":       "1002",
  593.                 "callee_id_number":     "1002",
  594.                 "display_direction":    "outbound"
  595.         }
  596. }]
  597. 2017-10-05 11:00:02.034184 [INFO] avcodec.c:1085 initializing encoder 352x288
  598. 2017-10-05 11:00:02.034184 [DEBUG] avcodec.c:833 NVENC HW CODEC NOT PRESENT
  599. using cpu capabilities: MMX2 SSE2Fast SSSE3 SSE4.2 AVX
  600. profile Constrained Baseline, level 3.1
  601. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:02.074182 [INFO] switch_rtp.c:3191 Changing video DTLS state from HANDSHAKE to SETUP
  602. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:02.074182 [INFO] switch_rtp.c:3100 video Fingerprint Verified.
  603. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:02.074182 [INFO] switch_rtp.c:3995 Activating video Secure RTP SEND
  604. 2017-10-05 11:00:02.074182 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
  605. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:02.074182 [INFO] switch_rtp.c:3973 Activating video Secure RTP RECV
  606. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:02.074182 [INFO] switch_rtp.c:3140 Changing video DTLS state from SETUP to READY
  607. 2017-10-05 11:00:02.074182 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
  608. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:02.104213 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: video ssrc[2784642864] base_seq[27825]
  609. 2017-10-05 11:00:02.124211 [ALERT] mod_verto.c:1405 READ 166.170.56.190:53568 [{
  610.         "jsonrpc":      "2.0",
  611.         "id":   178,
  612.         "result":       {
  613.                 "method":       "verto.invite"
  614.         }
  615. }]
  616. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:03.054179 [INFO] switch_rtp.c:3191 Changing audio DTLS state from HANDSHAKE to SETUP
  617. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:03.074212 [INFO] switch_rtp.c:3100 audio Fingerprint Verified.
  618. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:03.074212 [INFO] switch_rtp.c:3995 Activating audio Secure RTP SEND
  619. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:03.074212 [INFO] switch_rtp.c:3973 Activating audio Secure RTP RECV
  620. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:03.074212 [INFO] switch_rtp.c:3140 Changing audio DTLS state from SETUP to READY
  621. 2017-10-05 11:00:03.074212 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
  622. 2017-10-05 11:00:03.074212 [DEBUG] switch_core_sqldb.c:2617 Secure Type: srtp:dtls:AES_CM_128_HMAC_SHA1_80
  623. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:03.104211 [DEBUG] switch_rtp.c:1886 rtcp_stats_init: audio ssrc[395565095] base_seq[7115]
  624. 2017-10-05 11:00:09.064211 [ALERT] mod_verto.c:1405 READ 166.170.56.190:53568 [{
  625.         "jsonrpc":      "2.0",
  626.         "method":       "verto.answer",
  627.         "params":       {
  628.                 "sdp":  "v=0\r\no=mozilla...THIS_IS_SDPARTA-58.0a1 3065108213601928732 0 IN IP4 0.0.0.0\r\ns=-\r\nt=0 0\r\na=sendrecv\r\na=fingerprint:sha-256 9D:ED:6E:33:E4:04:52:47:B6:56:E4:82:CE:40:66:FB:29:93:E5:BE:EA:45:AD:DE:E8:44:B8:67:C6:1D:75:16\r\na=ice-options:trickle\r\na=msid-semantic:WMS *\r\nm=audio 1580 RTP/SAVPF 102\r\nc=IN IP4 166.170.56.190\r\na=candidate:0 1 UDP 2122252543 192.168.150.50 50222 typ host\r\na=candidate:2 1 UDP 2122187007 2001:0:9d38:6ab8:18c6:15de:3f57:69cd 50223 typ host\r\na=candidate:4 1 TCP 2105524479 192.168.150.50 9 typ host tcptype active\r\na=candidate:5 1 TCP 2105458943 2001:0:9d38:6ab8:18c6:15de:3f57:69cd 9 typ host tcptype active\r\na=candidate:1 1 UDP 1686052863 166.170.56.190 1580 typ srflx raddr 192.168.150.50 rport 50222\r\na=sendrecv\r\na=end-of-candidates\r\na=fmtp:102 maxplaybackrate=48000;stereo=1;useinbandfec=1\r\na=ice-pwd:e8a768678b97d9435e1a09767de3c6ed\r\na=ice-ufrag:4c6e3a96\r\na=msid:{212a93ca-642b-4e49-a9bf-7244bd56b1b8} {32c8665f-d178-4ae2-8984-a8e76e4b02b7}\r\na=rtcp-mux\r\na=rtpmap:102 opus/48000/2\r\na=setup:active\r\na=ssrc:2752822895 cname:{7774a22c-43d7-4652-b912-1e7323d9de19}\r\nm=video 0 RTP/SAVPF 120\r\nc=IN IP4 0.0.0.0\r\na=inactive\r\na=rtpmap:120 VP8/90000\r\n",
  629.                 "dialogParams": {
  630.                         "useVideo":     true,
  631.                         "screenShare":  false,
  632.                         "useCamera":    "xI8gFA67oJwA0CBLRZ62Mkc8ZuyKoQgCoZaOmFs2oXI=",
  633.                         "useMic":       "4Jd/M8fL+Viyc6uEeDNnMHsXYvNT4F1dDAQpSQUPy4E=",
  634.                         "useSpeak":     null,
  635.                         "tag":  "webcam",
  636.                         "localTag":     null,
  637.                         "login":        "1002@baremetal.joshebosh.com",
  638.                         "videoParams":  {
  639.                                 "minWidth":     320,
  640.                                 "minHeight":    240,
  641.                                 "maxWidth":     320,
  642.                                 "maxHeight":    240,
  643.                                 "minFrameRate": 15
  644.                         },
  645.                         "callID":       "b3dddbfc-a3ba-405b-8272-2541d73ad160",
  646.                         "caller_id_name":       "Extension 1001",
  647.                         "caller_id_number":     "1001",
  648.                         "callee_id_name":       "1002",
  649.                         "callee_id_number":     "1002",
  650.                         "display_direction":    "outbound",
  651.                         "wantVideo":    true,
  652.                         "remote_caller_id_name":        "Extension 1001",
  653.                         "remote_caller_id_number":      "1001"
  654.                 },
  655.                 "sessid":       "b661ee3f-a8fe-86d4-d8fe-74652bb047a5"
  656.         },
  657.         "id":   12
  658. }]
  659. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.064211 [DEBUG] mod_verto.c:2721 Remote SDP verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5:
  660. b3dddbfc-a3ba-405b-8272-2541d73ad160 v=0
  661. b3dddbfc-a3ba-405b-8272-2541d73ad160 o=mozilla...THIS_IS_SDPARTA-58.0a1 3065108213601928732 0 IN IP4 0.0.0.0
  662. b3dddbfc-a3ba-405b-8272-2541d73ad160 s=-
  663. b3dddbfc-a3ba-405b-8272-2541d73ad160 t=0 0
  664. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=sendrecv
  665. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=fingerprint:sha-256 9D:ED:6E:33:E4:04:52:47:B6:56:E4:82:CE:40:66:FB:29:93:E5:BE:EA:45:AD:DE:E8:44:B8:67:C6:1D:75:16
  666. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ice-options:trickle
  667. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=msid-semantic:WMS *
  668. b3dddbfc-a3ba-405b-8272-2541d73ad160 m=audio 1580 RTP/SAVPF 102
  669. b3dddbfc-a3ba-405b-8272-2541d73ad160 c=IN IP4 166.170.56.190
  670. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=candidate:0 1 UDP 2122252543 192.168.150.50 50222 typ host
  671. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=candidate:2 1 UDP 2122187007 2001:0:9d38:6ab8:18c6:15de:3f57:69cd 50223 typ host
  672. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=candidate:4 1 TCP 2105524479 192.168.150.50 9 typ host tcptype active
  673. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=candidate:5 1 TCP 2105458943 2001:0:9d38:6ab8:18c6:15de:3f57:69cd 9 typ host tcptype active
  674. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=candidate:1 1 UDP 1686052863 166.170.56.190 1580 typ srflx raddr 192.168.150.50 rport 50222
  675. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=sendrecv
  676. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=end-of-candidates
  677. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=fmtp:102 maxplaybackrate=48000;stereo=1;useinbandfec=1
  678. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ice-pwd:e8a768678b97d9435e1a09767de3c6ed
  679. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ice-ufrag:4c6e3a96
  680. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=msid:{212a93ca-642b-4e49-a9bf-7244bd56b1b8} {32c8665f-d178-4ae2-8984-a8e76e4b02b7}
  681. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtcp-mux
  682. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtpmap:102 opus/48000/2
  683. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=setup:active
  684. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=ssrc:2752822895 cname:{7774a22c-43d7-4652-b912-1e7323d9de19}
  685. b3dddbfc-a3ba-405b-8272-2541d73ad160 m=video 0 RTP/SAVPF 120
  686. b3dddbfc-a3ba-405b-8272-2541d73ad160 c=IN IP4 0.0.0.0
  687. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=inactive
  688. b3dddbfc-a3ba-405b-8272-2541d73ad160 a=rtpmap:120 VP8/90000
  689. b3dddbfc-a3ba-405b-8272-2541d73ad160
  690. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.064211 [DEBUG] switch_core_media.c:5128 Audio Codec Compare [opus:102:48000:20:0:2]/[opus:116:48000:20:0:1]
  691. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.064211 [DEBUG] switch_core_media.c:5183 Audio Codec Compare [opus:116:48000:20:0:1] ++++ is saved as a match
  692. 2017-10-05 11:00:09.064211 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps]
  693. 2017-10-05 11:00:09.064211 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps]
  694. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.064211 [DEBUG] switch_core_media.c:3443 Set Codec verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 opus/48000 20 ms 960 samples 0 bits 2 channels
  695. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.064211 [DEBUG] switch_core_codec.c:111 verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 Original read codec set to opus:116
  696. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:3873 Save audio Candidate cid: 1 proto: UDP type: host addr: 192.168.150.50:50222
  697. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:3867 Drop audio Candidate cid: 1 proto: UDP type: host addr: 2001:0:9d38:6ab8:18c6:15de:3f57:69cd:50223 (no network path)
  698. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:3873 Save audio Candidate cid: 1 proto: UDP type: srflx addr: 166.170.56.190:1580
  699. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:3915 Searching for rtp candidate.
  700. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:3920 Choose rtp candidate, index 1, 166.170.56.190:1580
  701. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:3693 verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 choosing family v4
  702. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:3931 Choose same candidate, index 0, for rtcp based on rtcp-mux attribute 166.170.56.190:1580
  703. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:3978 setting remote audio ice addr to index 1 166.170.56.190:1580 based on candidate
  704. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:4013 Setting remote rtcp audio addr to 166.170.56.190:1580 based on candidate
  705. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:5416 No 2833 in SDP. Liberal DTMF mode adding 0 as telephone-event.
  706. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:5452 No 2833 in SDP.  Disable 2833 dtmf and switch to INFO
  707. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:8162 AUDIO RTP [verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5] 192.168.1.113 port 16464 -> 166.170.56.190 port 1580 codec: 102 ms: 20
  708. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_rtp.c:4191 Starting timer [soft] 960 bytes per 20ms
  709. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [INFO] switch_core_media.c:8341 Activating Audio ICE
  710. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [NOTICE] switch_rtp.c:4690 Activating RTP audio ICE: 4c6e3a96:hyQ0LsMVK61L9AV4 166.170.56.190:1580
  711. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:8382 Activating RTCP PORT 1580
  712. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_rtp.c:4587 RTCP send rate is: 1000 and packet rate is: 20000 Remote Port: 1580
  713. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [INFO] switch_core_media.c:8393 Skipping RTCP ICE (Same as RTP)
  714. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [INFO] switch_rtp.c:3643 Activate RTP/RTCP audio DTLS server
  715. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [INFO] switch_rtp.c:3806 Changing audio DTLS state from OFF to HANDSHAKE
  716. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:2204 Setting Jitterbuffer to 20ms (1 frames) (50 max frames)
  717. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_core_media.c:8145 Audio params are unchanged for verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5.
  718. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [NOTICE] mod_verto.c:2755 Channel [verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5] has been answered
  719. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.074181 [DEBUG] switch_channel.c:3781 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Callstate Change RINGING -> ACTIVE
  720. 2017-10-05 11:00:09.074181 [ALERT] mod_verto.c:601 WRITE 166.170.56.190:53568 [{
  721.         "jsonrpc":      "2.0",
  722.         "id":   12,
  723.         "result":       {
  724.                 "sessid":       "b661ee3f-a8fe-86d4-d8fe-74652bb047a5"
  725.         }
  726. }]
  727. 2017-10-05 11:00:09.074181 [ALERT] mod_verto.c:5543 EVENT BROADCAST presence.1002@192.168.1.113 {
  728.         "data": {
  729.                 "channelCallState":     "ACTIVE",
  730.                 "originalChannelCallState":     "RINGING",
  731.                 "channelState": "CS_CONSUME_MEDIA",
  732.                 "callerUserName":       "1001@192.168.1.113",
  733.                 "callerIDName": "Extension 1001",
  734.                 "callerIDNumber":       "1001",
  735.                 "calleeIDName": "1002",
  736.                 "calleeIDNumber":       "1002",
  737.                 "channelUUID":  "b3dddbfc-a3ba-405b-8272-2541d73ad160",
  738.                 "presenceCallDirection":        "outbound",
  739.                 "channelPresenceID":    "1002@192.168.1.113"
  740.         },
  741.         "eventChannel": "presence.1002@192.168.1.113"
  742. }
  743. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:09.084186 [DEBUG] switch_core_codec.c:248 verto.rtc/1002 Restore previous codec opus:116.
  744. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:09.084186 [DEBUG] switch_ivr_originate.c:3722 Originate Resulted in Success: [verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5]
  745. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:09.084186 [DEBUG] switch_channel.c:2047 (verto.rtc/1002) Callstate Change RING_WAIT -> ACTIVE
  746. 2017-10-05 11:00:09.084186 [ALERT] mod_verto.c:5543 EVENT BROADCAST presence.1001@192.168.1.113 {
  747.         "data": {
  748.                 "channelCallState":     "ACTIVE",
  749.                 "originalChannelCallState":     "RING_WAIT",
  750.                 "channelState": "CS_EXECUTE",
  751.                 "callerUserName":       "1001@192.168.1.113",
  752.                 "callerIDName": "1001",
  753.                 "callerIDNumber":       "joshua@freeswitch.org",
  754.                 "calleeIDName": "1002",
  755.                 "calleeIDNumber":       "1002",
  756.                 "channelUUID":  "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  757.                 "presenceCallDirection":        "inbound",
  758.                 "channelPresenceID":    "1001@192.168.1.113"
  759.         },
  760.         "eventChannel": "presence.1001@192.168.1.113"
  761. }
  762. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:09.084186 [DEBUG] switch_ivr_originate.c:3722 Originate Resulted in Success: [verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5]
  763. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.084186 [DEBUG] switch_core_media.c:12204 verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 PAUSE Jitterbuffer
  764. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.094179 [DEBUG] switch_ivr_bridge.c:1744 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA
  765. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.094179 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Running State Change CS_EXCHANGE_MEDIA (Cur 2 Tot 804)
  766. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.094179 [DEBUG] switch_core_state_machine.c:653 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State EXCHANGE_MEDIA
  767. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.094179 [DEBUG] mod_rtc.c:146 RTC EXCHANGE_MEDIA
  768. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.104211 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  769. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:09.104211 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  770. 2017-10-05 11:00:09.104211 [DEBUG] mod_opus.c:617 Opus encoder: set bitrate to local settings [120000bps]
  771. 2017-10-05 11:00:09.124211 [ALERT] mod_verto.c:601 WRITE 166.170.56.190:53568 [{
  772.         "jsonrpc":      "2.0",
  773.         "id":   180,
  774.         "method":       "verto.display",
  775.         "params":       {
  776.                 "callID":       "b3dddbfc-a3ba-405b-8272-2541d73ad160",
  777.                 "display_name": "Extension 1001",
  778.                 "display_number":       "1001",
  779.                 "caller_id_name":       "Extension 1001",
  780.                 "caller_id_number":     "1001",
  781.                 "callee_id_name":       "1002",
  782.                 "callee_id_number":     "1002",
  783.                 "display_direction":    "outbound"
  784.         }
  785. }]
  786. 2017-10-05 11:00:09.124211 [ALERT] mod_verto.c:601 WRITE 192.168.1.1:55563 [{
  787.         "jsonrpc":      "2.0",
  788.         "id":   179,
  789.         "method":       "verto.display",
  790.         "params":       {
  791.                 "callID":       "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  792.                 "display_name": "1002",
  793.                 "display_number":       "1002",
  794.                 "caller_id_name":       "1001",
  795.                 "caller_id_number":     "joshua@freeswitch.org",
  796.                 "callee_id_name":       "1002",
  797.                 "callee_id_number":     "1002",
  798.                 "display_direction":    "inbound"
  799.         }
  800. }]
  801. 2017-10-05 11:00:09.124211 [ALERT] mod_verto.c:1405 READ 192.168.1.1:55563 [{
  802.         "jsonrpc":      "2.0",
  803.         "id":   179,
  804.         "result":       {
  805.                 "method":       "verto.display"
  806.         }
  807. }]
  808. 2017-10-05 11:00:09.304212 [ALERT] mod_verto.c:1405 READ 166.170.56.190:53568 [{
  809.         "jsonrpc":      "2.0",
  810.         "id":   180,
  811.         "result":       {
  812.                 "method":       "verto.display"
  813.         }
  814. }]
  815. 2017-10-05 11:00:18.464212 [ALERT] mod_verto.c:1405 READ 166.170.56.190:53568 [{
  816.         "jsonrpc":      "2.0",
  817.         "method":       "verto.bye",
  818.         "params":       {
  819.                 "dialogParams": {
  820.                         "useVideo":     true,
  821.                         "screenShare":  false,
  822.                         "useCamera":    "xI8gFA67oJwA0CBLRZ62Mkc8ZuyKoQgCoZaOmFs2oXI=",
  823.                         "useMic":       "4Jd/M8fL+Viyc6uEeDNnMHsXYvNT4F1dDAQpSQUPy4E=",
  824.                         "useSpeak":     null,
  825.                         "tag":  "webcam",
  826.                         "localTag":     null,
  827.                         "login":        "1002@baremetal.joshebosh.com",
  828.                         "videoParams":  {
  829.                                 "minWidth":     320,
  830.                                 "minHeight":    240,
  831.                                 "maxWidth":     320,
  832.                                 "maxHeight":    240,
  833.                                 "minFrameRate": 15
  834.                         },
  835.                         "callID":       "b3dddbfc-a3ba-405b-8272-2541d73ad160",
  836.                         "caller_id_name":       "Extension 1001",
  837.                         "caller_id_number":     "1001",
  838.                         "callee_id_name":       "1002",
  839.                         "callee_id_number":     "1002",
  840.                         "display_direction":    "outbound",
  841.                         "wantVideo":    true,
  842.                         "remote_caller_id_name":        "Extension 1001",
  843.                         "remote_caller_id_number":      "1001"
  844.                 },
  845.                 "sessid":       "b661ee3f-a8fe-86d4-d8fe-74652bb047a5"
  846.         },
  847.         "id":   13
  848. }]
  849. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.464212 [NOTICE] mod_verto.c:2835 Hangup verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
  850. 2017-10-05 11:00:18.464212 [ALERT] mod_verto.c:601 WRITE 166.170.56.190:53568 [{
  851.         "jsonrpc":      "2.0",
  852.         "id":   13,
  853.         "result":       {
  854.                 "callID":       "b3dddbfc-a3ba-405b-8272-2541d73ad160",
  855.                 "message":      "CALL ENDED",
  856.                 "causeCode":    16,
  857.                 "cause":        "NORMAL_CLEARING",
  858.                 "sessid":       "b661ee3f-a8fe-86d4-d8fe-74652bb047a5"
  859.         }
  860. }]
  861. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_ivr_bridge.c:831 verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 ending bridge by request from read function
  862. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5]
  863. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:653 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State EXCHANGE_MEDIA going to sleep
  864. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Running State Change CS_HANGUP (Cur 2 Tot 804)
  865. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Callstate Change ACTIVE -> HANGUP
  866. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:852 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State HANGUP
  867. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:60 verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 Standard HANGUP, cause: NORMAL_CLEARING
  868. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:852 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State HANGUP going to sleep
  869. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:619 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State Change CS_HANGUP -> CS_REPORTING
  870. 2017-10-05 11:00:18.474179 [ALERT] mod_verto.c:5543 EVENT BROADCAST presence.1002@192.168.1.113 {
  871.         "data": {
  872.                 "channelCallState":     "HANGUP",
  873.                 "originalChannelCallState":     "ACTIVE",
  874.                 "channelState": "CS_HANGUP",
  875.                 "callerUserName":       "1001@192.168.1.113",
  876.                 "callerIDName": "Extension 1001",
  877.                 "callerIDNumber":       "1001",
  878.                 "calleeIDName": "1002",
  879.                 "calleeIDNumber":       "1002",
  880.                 "channelUUID":  "b3dddbfc-a3ba-405b-8272-2541d73ad160",
  881.                 "presenceCallDirection":        "outbound",
  882.                 "channelPresenceID":    "1002@192.168.1.113"
  883.         },
  884.         "eventChannel": "presence.1002@192.168.1.113"
  885. }
  886. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Running State Change CS_REPORTING (Cur 2 Tot 804)
  887. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:938 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State REPORTING
  888. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [INFO] mod_json_cdr.c:271 Process [b3dddbfc-a3ba-405b-8272-2541d73ad160.cdr.json]
  889. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [INFO] mod_json_cdr.c:275 Log to disk [/usr/local/freeswitch/log/json_cdr/b3dddbfc-a3ba-405b-8272-2541d73ad160.cdr.json]
  890. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:174 verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 Standard REPORTING, cause: NORMAL_CLEARING
  891. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:938 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State REPORTING going to sleep
  892. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_state_machine.c:610 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State Change CS_REPORTING -> CS_DESTROY
  893. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.474179 [DEBUG] switch_core_session.c:1713 Session 804 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Locked, Waiting on external entities
  894. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_ivr_bridge.c:825 verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 ending bridge by request from write function
  895. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_ivr_bridge.c:917 BRIDGE THREAD DONE [verto.rtc/1002]
  896. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [NOTICE] switch_ivr_bridge.c:1895 Hangup verto.rtc/1002 [CS_EXECUTE] [NORMAL_CLEARING]
  897. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.484217 [NOTICE] switch_core_session.c:1731 Session 804 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Ended
  898. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.484217 [NOTICE] switch_core_session.c:1735 Close Channel verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 [CS_DESTROY]
  899. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_core_session.c:2885 verto.rtc/1002 skip receive message [PHONE_EVENT] (channel is hungup already)
  900. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:650 (verto.rtc/1002) State EXECUTE going to sleep
  901. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/1002) Running State Change CS_HANGUP (Cur 1 Tot 804)
  902. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:741 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) Running State Change CS_DESTROY (Cur 1 Tot 804)
  903. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:751 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State DESTROY
  904. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.484217 [DEBUG] mod_rtc.c:132 verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 RTC DESTROY
  905. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.484217 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  906. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.484217 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  907. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.484217 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  908. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.484217 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  909. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:181 verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5 Standard DESTROY
  910. b3dddbfc-a3ba-405b-8272-2541d73ad160 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:751 (verto.rtc/b661ee3f-a8fe-86d4-d8fe-74652bb047a5) State DESTROY going to sleep
  911. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:850 (verto.rtc/1002) Callstate Change ACTIVE -> HANGUP
  912. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:852 (verto.rtc/1002) State HANGUP
  913. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:60 verto.rtc/1002 Standard HANGUP, cause: NORMAL_CLEARING
  914. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:852 (verto.rtc/1002) State HANGUP going to sleep
  915. 2017-10-05 11:00:18.484217 [ALERT] mod_verto.c:5543 EVENT BROADCAST presence.1001@192.168.1.113 {
  916.         "data": {
  917.                 "channelCallState":     "HANGUP",
  918.                 "originalChannelCallState":     "ACTIVE",
  919.                 "channelState": "CS_HANGUP",
  920.                 "callerUserName":       "1001@192.168.1.113",
  921.                 "callerIDName": "1001",
  922.                 "callerIDNumber":       "joshua@freeswitch.org",
  923.                 "calleeIDName": "1002",
  924.                 "calleeIDNumber":       "1002",
  925.                 "channelUUID":  "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  926.                 "presenceCallDirection":        "inbound",
  927.                 "channelPresenceID":    "1001@192.168.1.113"
  928.         },
  929.         "eventChannel": "presence.1001@192.168.1.113"
  930. }
  931. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:619 (verto.rtc/1002) State Change CS_HANGUP -> CS_REPORTING
  932. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:584 (verto.rtc/1002) Running State Change CS_REPORTING (Cur 1 Tot 804)
  933. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.484217 [DEBUG] switch_core_state_machine.c:938 (verto.rtc/1002) State REPORTING
  934. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [INFO] mod_json_cdr.c:271 Process [a_a64a2d13-097c-fad5-4a2e-4b9912283ade.cdr.json]
  935. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [INFO] mod_json_cdr.c:275 Log to disk [/usr/local/freeswitch/log/json_cdr/a_a64a2d13-097c-fad5-4a2e-4b9912283ade.cdr.json]
  936. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] switch_core_state_machine.c:174 verto.rtc/1002 Standard REPORTING, cause: NORMAL_CLEARING
  937. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] switch_core_state_machine.c:938 (verto.rtc/1002) State REPORTING going to sleep
  938. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] switch_core_state_machine.c:610 (verto.rtc/1002) State Change CS_REPORTING -> CS_DESTROY
  939. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] switch_core_session.c:1713 Session 803 (verto.rtc/1002) Locked, Waiting on external entities
  940. 2017-10-05 11:00:18.494183 [DEBUG] switch_core_media.c:7121 verto.rtc/1002 Video thread ended
  941. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [NOTICE] switch_core_session.c:1731 Session 803 (verto.rtc/1002) Ended
  942. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [NOTICE] switch_core_session.c:1735 Close Channel verto.rtc/1002 [CS_DESTROY]
  943. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] switch_core_state_machine.c:741 (verto.rtc/1002) Running State Change CS_DESTROY (Cur 0 Tot 804)
  944. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] switch_core_state_machine.c:751 (verto.rtc/1002) State DESTROY
  945. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] mod_rtc.c:132 verto.rtc/1002 RTC DESTROY
  946. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[301] PLC[0] FEC[0]
  947. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[0] Bytes encoded[0] Encoded length ms[0] Average encoded bitrate bps[0]
  948. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] mod_opus.c:725 Opus decoder stats: Frames[0] PLC[0] FEC[0]
  949. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] mod_opus.c:740 Opus encoder stats: Frames[354] Bytes encoded[82196] Encoded length ms[7080] Average encoded bitrate bps[93938]
  950. frame I:4     Avg QP:10.25  size:   605
  951. frame P:146   Avg QP: 0.25  size:    49
  952. mb I  I16..4: 99.0%  0.0%  1.0%
  953. mb P  I16..4:  0.0%  0.0%  0.0%  P16..4:  0.0%  0.0%  0.0%  0.0%  0.0%    skip:100.0%
  954. coded y,uvDC,uvAC intra: 0.3% 0.0% 0.0% inter: 0.0% 0.0% 0.0%
  955. i16 v,h,dc,p: 79%  0% 21%  0%
  956. i4 v,h,dc,ddl,ddr,vr,hd,vl,hu:  0%  0% 100%  0%  0%  0%  0%  0%  0%
  957. i8c dc,h,v,p: 100%  0%  0%  0%
  958. kb/s:45.95
  959. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] switch_core_state_machine.c:181 verto.rtc/1002 Standard DESTROY
  960. a64a2d13-097c-fad5-4a2e-4b9912283ade 2017-10-05 11:00:18.494183 [DEBUG] switch_core_state_machine.c:751 (verto.rtc/1002) State DESTROY going to sleep
  961. 2017-10-05 11:00:18.534189 [ALERT] mod_verto.c:601 WRITE 192.168.1.1:55563 [{
  962.         "jsonrpc":      "2.0",
  963.         "id":   181,
  964.         "method":       "verto.bye",
  965.         "params":       {
  966.                 "callID":       "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  967.                 "causeCode":    16,
  968.                 "cause":        "NORMAL_CLEARING"
  969.         }
  970. }]
  971. 2017-10-05 11:00:18.534189 [ALERT] mod_verto.c:1405 READ 192.168.1.1:55563 [{
  972.         "jsonrpc":      "2.0",
  973.         "method":       "verto.bye",
  974.         "params":       {
  975.                 "dialogParams": {
  976.                         "useVideo":     true,
  977.                         "useStereo":    true,
  978.                         "screenShare":  false,
  979.                         "useCamera":    "045df2abc86d39fe84a007c577623bbed07263394e09491bf7508947970b2d5f",
  980.                         "useMic":       "default",
  981.                         "useSpeak":     "default",
  982.                         "tag":  "webcam",
  983.                         "localTag":     null,
  984.                         "login":        "1001@baremetal.joshebosh.com",
  985.                         "videoParams":  {
  986.                                 "minWidth":     160,
  987.                                 "minHeight":    120,
  988.                                 "maxWidth":     160,
  989.                                 "maxHeight":    120,
  990.                                 "minFrameRate": 15
  991.                         },
  992.                         "destination_number":   "1002",
  993.                         "caller_id_name":       "1001",
  994.                         "caller_id_number":     "joshua@freeswitch.org",
  995.                         "outgoingBandwidth":    "250",
  996.                         "incomingBandwidth":    "250",
  997.                         "dedEnc":       true,
  998.                         "mirrorInput":  false,
  999.                         "userVariables":        {
  1000.                                 "email":        "joshua@freeswitch.org",
  1001.                                 "avatar":       "http://gravatar.com/avatar/4d744e87a0efca67c7418f2d8e098a98.png?s=600"
  1002.                         },
  1003.                         "callID":       "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  1004.                         "remote_caller_id_name":        "1002",
  1005.                         "remote_caller_id_number":      "1002"
  1006.                 },
  1007.                 "sessid":       "8f00da09-b94a-6eac-7246-f8f6f4d3ad78"
  1008.         },
  1009.         "id":   23
  1010. }]
  1011. 2017-10-05 11:00:18.534189 [ALERT] mod_verto.c:601 WRITE 192.168.1.1:55563 [{
  1012.         "jsonrpc":      "2.0",
  1013.         "id":   23,
  1014.         "error":        {
  1015.                 "callID":       "a64a2d13-097c-fad5-4a2e-4b9912283ade",
  1016.                 "message":      "CALL DOES NOT EXIST",
  1017.                 "code": -32002
  1018.         }
  1019. }]
  1020. 2017-10-05 11:00:18.584212 [ALERT] mod_verto.c:1405 READ 192.168.1.1:55563 [{
  1021.         "jsonrpc":      "2.0",
  1022.         "id":   181,
  1023.         "result":       {
  1024.                 "method":       "verto.bye"
  1025.         }
  1026. }]
  1027. 2017-10-05 11:00:21.014189 [NOTICE] mod_cdr_csv.c:127 Rotated CDR logfile /usr/local/freeswitch/log/cdr-csv/1001.csv
  1028. 2017-10-05 11:00:21.014189 [NOTICE] mod_cdr_csv.c:127 Rotated CDR logfile /usr/local/freeswitch/log/cdr-csv/1002.csv
  1029. 2017-10-05 11:00:21.014189 [NOTICE] mod_cdr_csv.c:127 Rotated CDR logfile /usr/local/freeswitch/log/cdr-csv/Master.csv
  1030.