From Bipin, 3 Years ago, written in FreeSWITCH.
- view diff
Embed
  1. .=======================================================.
  2. |            _____ ____     ____ _     ___              |
  3. |           |  ___/ ___|   / ___| |   |_ _|             |
  4. |           | |_  \___ \  | |   | |    | |              |
  5. |           |  _|  ___) | | |___| |___ | |              |
  6. |           |_|   |____/   \____|_____|___|             |
  7. |                                                       |
  8. .=======================================================.
  9. | Anthony Minessale II, Ken Rice,                       |
  10. | Michael Jerris, Travis Cross                          |
  11. | FreeSWITCH (http://www.freeswitch.org)                |
  12. | Paypal Donations Appreciated: paypal@freeswitch.org   |
  13. | Brought to you by ClueCon http://www.cluecon.com/     |
  14. .=======================================================.
  15.  
  16. .=======================================================================================================.
  17. |    ____ _             ____                                                                            |
  18. |   / ___| |_   _  ___ / ___|___  _ __                                                                  |
  19. |  | |   | | | | |/ _ \ |   / _ \| '_ \                                                                 |
  20. |  | |___| | |_| |  __/ |__| (_) | | | |                                                                |
  21. |   \____|_|\__,_|\___|\____\___/|_| |_|                                                                |
  22. |                                                                                                       |
  23. |   _____    _            _                          ____             __                                |
  24. |  |_   _|__| | ___ _ __ | |__   ___  _ __  _   _   / ___|___  _ __  / _| ___ _ __ ___ _ __   ___ ___   |
  25. |    | |/ _ \ |/ _ \ '_ \| '_ \ / _ \| '_ \| | | | | |   / _ \| '_ \| |_ / _ \ '__/ _ \ '_ \ / __/ _ \  |
  26. |    | |  __/ |  __/ |_) | | | | (_) | | | | |_| | | |__| (_) | | | |  _|  __/ | |  __/ | | | (_|  __/  |
  27. |    |_|\___|_|\___| .__/|_| |_|\___/|_| |_|\__, |  \____\___/|_| |_|_|  \___|_|  \___|_| |_|\___\___|  |
  28. |                  |_|                      |___/                                                       |
  29. |   _____                           _                         _                                         |
  30. |  | ____|_   _____ _ __ _   _     / \  _   _  __ _ _   _ ___| |_                                       |
  31. |  |  _| \ \ / / _ \ '__| | | |   / _ \| | | |/ _` | | | / __| __|                                      |
  32. |  | |___ \ V /  __/ |  | |_| |  / ___ \ |_| | (_| | |_| \__ \ |_                                       |
  33. |  |_____| \_/ \___|_|   \__, | /_/   \_\__,_|\__, |\__,_|___/\__|                                      |
  34. |                        |___/                |___/                                                     |
  35. |                                       ____ _             ____                                         |
  36. |  __      ____      ____      __      / ___| |_   _  ___ / ___|___  _ __         ___ ___  _ __ ___     |
  37. |  \ \ /\ / /\ \ /\ / /\ \ /\ / /     | |   | | | | |/ _ \ |   / _ \| '_ \       / __/ _ \| '_ ` _ \    |
  38. |   \ V  V /  \ V  V /  \ V  V /   _  | |___| | |_| |  __/ |__| (_) | | | |  _  | (_| (_) | | | | | |   |
  39. |    \_/\_/    \_/\_/    \_/\_/   (_)  \____|_|\__,_|\___|\____\___/|_| |_| (_)  \___\___/|_| |_| |_|   |
  40. |                                                                                                       |
  41. .=======================================================================================================.
  42.  
  43. Type /help <enter> to see a list of commands
  44.  
  45.  
  46.  
  47. +OK log level  [7]
  48. freeswitch@DESKTOP-5PS5MGH> 2016-08-03 19:22:00.979309 [INFO] mod_verto.c:4025 192.168.0.11:52770 Client Connect.
  49. 2016-08-03 19:22:00.979309 [INFO] mod_verto.c:1978 192.168.0.11:52770 Starting client thread.
  50. 2016-08-03 19:22:01.039354 [ALERT] mod_verto.c:1370 READ 192.168.0.11:52770 [{
  51.         "jsonrpc":      "2.0",
  52.         "method":       "login",
  53.         "params":       {
  54.                 "sessid":       "f3116205-59f7-1a56-6b06-e23e4645f500"
  55.         },
  56.         "id":   2
  57. }]
  58. 2016-08-03 19:22:01.039354 [INFO] mod_verto.c:1267 192.168.0.11:52770 re-connecting session f3116205-59f7-1a56-6b06-e23e4645f500
  59. 2016-08-03 19:22:01.039354 [ALERT] mod_verto.c:604 WRITE 192.168.0.11:52770 [{
  60.         "jsonrpc":      "2.0",
  61.         "id":   2,
  62.        "error":        {
  63.                 "code": -32000,
  64.                 "message":      "Authentication Required"
  65.         }
  66. }]
  67. 2016-08-03 19:22:01.039354 [ALERT] mod_verto.c:1370 READ 192.168.0.11:52770 [{
  68.         "jsonrpc":      "2.0",
  69.         "method":       "login",
  70.         "params":       {
  71.                 "sessid":       "f3116205-59f7-1a56-6b06-e23e4645f500"
  72.         },
  73.         "id":   1
  74. }]
  75. 2016-08-03 19:22:01.039354 [ALERT] mod_verto.c:604 WRITE 192.168.0.11:52770 [{
  76.         "jsonrpc":      "2.0",
  77.         "id":   1,
  78.        "error":        {
  79.                 "code": -32000,
  80.                 "message":      "Authentication Required"
  81.         }
  82. }]
  83. 2016-08-03 19:22:01.039354 [ALERT] mod_verto.c:1370 READ 192.168.0.11:52770 [{
  84.         "jsonrpc":      "2.0",
  85.         "method":       "login",
  86.         "params":       {
  87.                 "login":        "trillionss@xbipin.com",
  88.                 "passwd":       "pass",
  89.                 "loginParams":  {
  90.                 },
  91.                 "userVariables":        {
  92.                 },
  93.                 "sessid":       "f3116205-59f7-1a56-6b06-e23e4645f500"
  94.         },
  95.         "id":   3
  96. }]
  97. 2016-08-03 19:22:01.039354 [ALERT] mod_verto.c:604 WRITE 192.168.0.11:52770 [{
  98.         "jsonrpc":      "2.0",
  99.         "id":   3,
  100.         "result":       {
  101.                 "message":      "logged in",
  102.                 "sessid":       "f3116205-59f7-1a56-6b06-e23e4645f500"
  103.         }
  104. }]
  105. 2016-08-03 19:22:08.859223 [ALERT] mod_verto.c:1370 READ 192.168.0.11:52770 [{
  106.         "jsonrpc":      "2.0",
  107.         "method":       "verto.invite",
  108.         "params":       {
  109.                 "sdp":  "v=0\r\no=- 3018471058368447081 2 IN IP4 127.0.0.1\r\ns=-\r\nt=0 0\r\na=group:BUNDLE audio\r\na=msid-semantic: WMS I6aZuIEDFEgPlqVwboc9SC4C9ebgurNwpuaW\r\nm=audio 52625 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 126\r\nc=IN IP4 86.99.124.187\r\na=rtcp:52628 IN IP4 86.99.124.187\r\na=candidate:922509271 1 udp 2122255103 2001::5ef5:79fb:38d8:392f:a99c:8344 52623 typ host generation 0 network-id 2\r\na=candidate:2237255773 1 udp 2122194687 169.254.101.10 52624 typ host generation 0 network-id 3\r\na=candidate:3988902457 1 udp 2122129151 192.168.0.11 52625 typ host generation 0 network-id 1\r\na=candidate:922509271 2 udp 2122255102 2001::5ef5:79fb:38d8:392f:a99c:8344 52626 typ host generation 0 network-id 2\r\na=candidate:2237255773 2 udp 2122194686 169.254.101.10 52627 typ host generation 0 network-id 3\r\na=candidate:3988902457 2 udp 2122129150 192.168.0.11 52628 typ host generation 0 network-id 1\r\na=candidate:2021630759 1 tcp 1518275327 2001::5ef5:79fb:38d8:392f:a99c:8344 9 typ host tcptype active generation 0 network-id 2\r\na=candidate:3420073133 1 tcp 1518214911 169.254.101.10 9 typ host tcptype active generation 0 network-id 3\r\na=candidate:2739023561 1 tcp 1518149375 192.168.0.11 9 typ host tcptype active generation 0 network-id 1\r\na=candidate:2021630759 2 tcp 1518275326 2001::5ef5:79fb:38d8:392f:a99c:8344 9 typ host tcptype active generation 0 network-id 2\r\na=candidate:3420073133 2 tcp 1518214910 169.254.101.10 9 typ host tcptype active generation 0 network-id 3\r\na=candidate:2739023561 2 tcp 1518149374 192.168.0.11 9 typ host tcptype active generation 0 network-id 1\r\na=candidate:466725869 1 udp 1685921535 86.99.124.187 52625 typ srflx raddr 192.168.0.11 rport 52625 generation 0 network-id 1\r\na=candidate:466725869 2 udp 1685921534 86.99.124.187 52628 typ srflx raddr 192.168.0.11 rport 52628 generation 0 network-id 1\r\na=ice-ufrag:s++TdQnUXpWu0DOr\r\na=ice-pwd:TQCtkr2gdDWnAHi12lTZnYYv\r\na=fingerprint:sha-256 B6:24:49:5E:BB:CE:18:F9:BF:2A:14:65:95:B1:6A:6D:54:B1:7B:AF:4D:CD:3B:D1:AC:DF:38:E9:D6:60:25:D9\r\na=setup:actpass\r\na=mid:audio\r\na=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level\r\na=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time\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\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:126 telephone-event/8000\r\na=maxptime:60\r\na=ssrc:164895446 cname:7y6XBJM1HSeAZDum\r\na=ssrc:164895446 msid:I6aZuIEDFEgPlqVwboc9SC4C9ebgurNwpuaW 6ca3b444-ad8a-478b-9968-8e203b627b10\r\na=ssrc:164895446 mslabel:I6aZuIEDFEgPlqVwboc9SC4C9ebgurNwpuaW\r\na=ssrc:164895446 label:6ca3b444-ad8a-478b-9968-8e203b627b10\r\n",
  110.                 "dialogParams": {
  111.                         "useVideo":     false,
  112.                         "useStereo":    false,
  113.                         "screenShare":  false,
  114.                         "useCamera":    "none",
  115.                         "useMic":       "f0ceca0920127577edd263ef38b6e316412a27fbec70948ba4acbbfa53eb9dfe",
  116.                         "useSpeak":     "default",
  117.                         "tag":  "webcam",
  118.                         "localTag":     null,
  119.                         "login":        "trillionss@xbipin.com",
  120.                         "videoParams":  {
  121.                                 "minWidth":     320,
  122.                                 "minHeight":    180,
  123.                                 "maxWidth":     320,
  124.                                 "maxHeight":    180,
  125.                                 "minFrameRate": 15
  126.                         },
  127.                         "destination_number":   "2002",
  128.                         "caller_id_name":       "1234",
  129.                         "caller_id_number":     "",
  130.                         "outgoingBandwidth":    19443,
  131.                         "incomingBandwidth":    90354,
  132.                         "dedEnc":       false,
  133.                         "mirrorInput":  false,
  134.                         "userVariables":        {
  135.                                 "email":        "",
  136.                                 "avatar":       "http://gravatar.com/avatar/d41d8cd98f00b204e9800998ecf8427e.png?s=600"
  137.                         },
  138.                         "callID":       "f00246a4-2136-48ef-5f03-5b58fe15b677",
  139.                         "remote_caller_id_name":        "Outbound Call",
  140.                         "remote_caller_id_number":      "2002"
  141.                 },
  142.                 "sessid":       "f3116205-59f7-1a56-6b06-e23e4645f500"
  143.         },
  144.         "id":   4
  145. }]
  146. 2016-08-03 19:22:08.859223 [DEBUG] mod_rtc.c:389 () State Change CS_NEW -> CS_INIT
  147. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_session.c:613 N/A set UUID=f00246a4-2136-48ef-5f03-5b58fe15b677
  148. 2016-08-03 19:22:08.859223 [NOTICE] switch_channel.c:1104 New Channel verto.rtc/2002 [f00246a4-2136-48ef-5f03-5b58fe15b677]
  149. 2016-08-03 19:22:08.859223 [DEBUG] mod_verto.c:3579 Remote SDP verto.rtc/2002:
  150. v=0
  151. o=- 3018471058368447081 2 IN IP4 127.0.0.1
  152. s=-
  153. t=0 0
  154. a=group:BUNDLE audio
  155. a=msid-semantic: WMS I6aZuIEDFEgPlqVwboc9SC4C9ebgurNwpuaW
  156. m=audio 52625 UDP/TLS/RTP/SAVPF 111 103 104 9 0 8 106 105 13 126
  157. c=IN IP4 86.99.124.187
  158. a=rtcp:52628 IN IP4 86.99.124.187
  159. a=candidate:922509271 1 udp 2122255103 2001::5ef5:79fb:38d8:392f:a99c:8344 52623 typ host generation 0 network-id 2
  160. a=candidate:2237255773 1 udp 2122194687 169.254.101.10 52624 typ host generation 0 network-id 3
  161. a=candidate:3988902457 1 udp 2122129151 192.168.0.11 52625 typ host generation 0 network-id 1
  162. a=candidate:922509271 2 udp 2122255102 2001::5ef5:79fb:38d8:392f:a99c:8344 52626 typ host generation 0 network-id 2
  163. a=candidate:2237255773 2 udp 2122194686 169.254.101.10 52627 typ host generation 0 network-id 3
  164. a=candidate:3988902457 2 udp 2122129150 192.168.0.11 52628 typ host generation 0 network-id 1
  165. a=candidate:2021630759 1 tcp 1518275327 2001::5ef5:79fb:38d8:392f:a99c:8344 9 typ host tcptype active generation 0 network-id 2
  166. a=candidate:3420073133 1 tcp 1518214911 169.254.101.10 9 typ host tcptype active generation 0 network-id 3
  167. a=candidate:2739023561 1 tcp 1518149375 192.168.0.11 9 typ host tcptype active generation 0 network-id 1
  168. a=candidate:2021630759 2 tcp 1518275326 2001::5ef5:79fb:38d8:392f:a99c:8344 9 typ host tcptype active generation 0 network-id 2
  169. a=candidate:3420073133 2 tcp 1518214910 169.254.101.10 9 typ host tcptype active generation 0 network-id 3
  170. a=candidate:2739023561 2 tcp 1518149374 192.168.0.11 9 typ host tcptype active generation 0 network-id 1
  171. a=candidate:466725869 1 udp 1685921535 86.99.124.187 52625 typ srflx raddr 192.168.0.11 rport 52625 generation 0 network-id 1
  172. a=candidate:466725869 2 udp 1685921534 86.99.124.187 52628 typ srflx raddr 192.168.0.11 rport 52628 generation 0 network-id 1
  173. a=ice-ufrag:s++TdQnUXpWu0DOr
  174. a=ice-pwd:TQCtkr2gdDWnAHi12lTZnYYv
  175. a=fingerprint:sha-256 B6:24:49:5E:BB:CE:18:F9:BF:2A:14:65:95:B1:6A:6D:54:B1:7B:AF:4D:CD:3B:D1:AC:DF:38:E9:D6:60:25:D9
  176. a=setup:actpass
  177. a=mid:audio
  178. a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
  179. a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
  180. a=sendrecv
  181. a=rtcp-mux
  182. a=rtpmap:111 opus/48000/2
  183. a=rtcp-fb:111 transport-cc
  184. a=fmtp:111 minptime=10;useinbandfec=1
  185. a=rtpmap:103 ISAC/16000
  186. a=rtpmap:104 ISAC/32000
  187. a=rtpmap:9 G722/8000
  188. a=rtpmap:0 PCMU/8000
  189. a=rtpmap:8 PCMA/8000
  190. a=rtpmap:106 CN/32000
  191. a=rtpmap:105 CN/16000
  192. a=rtpmap:13 CN/8000
  193. a=rtpmap:126 telephone-event/8000
  194. a=maxptime:60
  195. a=ssrc:164895446 cname:7y6XBJM1HSeAZDum
  196. a=ssrc:164895446 msid:I6aZuIEDFEgPlqVwboc9SC4C9ebgurNwpuaW 6ca3b444-ad8a-478b-9968-8e203b627b10
  197. a=ssrc:164895446 mslabel:I6aZuIEDFEgPlqVwboc9SC4C9ebgurNwpuaW
  198. a=ssrc:164895446 label:6ca3b444-ad8a-478b-9968-8e203b627b10
  199.  
  200. 2016-08-03 19:22:08.859223 [ALERT] mod_verto.c:604 WRITE 192.168.0.11:52770 [{
  201.         "jsonrpc":      "2.0",
  202.         "id":   4,
  203.         "result":       {
  204.                 "message":      "CALL CREATED",
  205.                 "callID":       "f00246a4-2136-48ef-5f03-5b58fe15b677",
  206.                 "sessid":       "f3116205-59f7-1a56-6b06-e23e4645f500"
  207.         }
  208. }]
  209. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:543 (verto.rtc/2002) Running State Change CS_INIT
  210. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:586 (verto.rtc/2002) State INIT
  211. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:40 verto.rtc/2002 Standard INIT
  212. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:48 (verto.rtc/2002) State Change CS_INIT -> CS_ROUTING
  213. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:586 (verto.rtc/2002) State INIT going to sleep
  214. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:543 (verto.rtc/2002) Running State Change CS_ROUTING
  215. 2016-08-03 19:22:08.859223 [DEBUG] switch_channel.c:2249 (verto.rtc/2002) Callstate Change DOWN -> RINGING
  216. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:602 (verto.rtc/2002) State ROUTING
  217. 2016-08-03 19:22:08.859223 [DEBUG] mod_rtc.c:89 verto.rtc/2002 RTC ROUTING
  218. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:236 verto.rtc/2002 Standard ROUTING
  219. 2016-08-03 19:22:08.859223 [INFO] mod_dialplan_xml.c:637 Processing 1234 <0000000000>->2002 in context lanusersdialout
  220. Dialplan: verto.rtc/2002 parsing [lanusersdialout->call_xlite] continue=false
  221. Dialplan: verto.rtc/2002 Regex (PASS) [call_xlite] destination_number(2002) =~ /^2002$/ break=on-false
  222. Dialplan: verto.rtc/2002 Action bridge(user/trillions@${domain_name})
  223. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:286 (verto.rtc/2002) State Change CS_ROUTING -> CS_EXECUTE
  224. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:602 (verto.rtc/2002) State ROUTING going to sleep
  225. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:543 (verto.rtc/2002) Running State Change CS_EXECUTE
  226. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:609 (verto.rtc/2002) State EXECUTE
  227. 2016-08-03 19:22:08.859223 [DEBUG] mod_rtc.c:120 verto.rtc/2002 RTC EXECUTE
  228. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:328 verto.rtc/2002 Standard EXECUTE
  229. EXECUTE verto.rtc/2002 bridge(user/trillions@192.168.0.11)
  230. 2016-08-03 19:22:08.859223 [DEBUG] switch_ivr_originate.c:2127 Parsing global variables
  231. 2016-08-03 19:22:08.859223 [DEBUG] switch_ivr_originate.c:2127 Parsing global variables
  232. 2016-08-03 19:22:08.859223 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/trillions@192.168.0.11:9040 [06e0486b-7cb7-4635-aa14-b1b7b08652bb]
  233. 2016-08-03 19:22:08.859223 [DEBUG] mod_sofia.c:4754 (sofia/internal/trillions@192.168.0.11:9040) State Change CS_NEW -> CS_INIT
  234. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/trillions@192.168.0.11:9040) Running State Change CS_INIT
  235. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:586 (sofia/internal/trillions@192.168.0.11:9040) State INIT
  236. 2016-08-03 19:22:08.859223 [DEBUG] mod_sofia.c:90 sofia/internal/trillions@192.168.0.11:9040 SOFIA INIT
  237. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_port_allocator.c:183 UDP port robustness check for port 1024 pass
  238. 2016-08-03 19:22:08.859223 [DEBUG] sofia_glue.c:1249 sofia/internal/trillions@192.168.0.11:9040 sending invite version: 1.7.0 git 18f1d56 2016-07-24 04:35:30Z 32bit
  239. Local SDP:
  240. v=0
  241. o=Talkycom 1470236704 1470236705 IN IP4 192.168.0.11
  242. s=Talkycom
  243. c=IN IP4 192.168.0.11
  244. t=0 0
  245. m=audio 1024 RTP/AVP 102 9 0 8 103 101
  246. a=rtpmap:102 opus/48000/2
  247. a=fmtp:102 useinbandfec=1; maxaveragebitrate=20000; maxplaybackrate=16000; sprop-maxcapturerate=16000; ptime=20; minptime=10; maxptime=40; stereo=1
  248. a=rtpmap:9 G722/8000
  249. a=rtpmap:0 PCMU/8000
  250. a=rtpmap:8 PCMA/8000
  251. a=rtpmap:103 telephone-event/48000
  252. a=fmtp:103 0-16
  253. a=rtpmap:101 telephone-event/8000
  254. a=fmtp:101 0-16
  255. a=silenceSupp:off - - - -
  256. a=ptime:20
  257. a=sendrecv
  258.  
  259. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:40 sofia/internal/trillions@192.168.0.11:9040 Standard INIT
  260. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/trillions@192.168.0.11:9040) State Change CS_INIT -> CS_ROUTING
  261. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:586 (sofia/internal/trillions@192.168.0.11:9040) State INIT going to sleep
  262. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/trillions@192.168.0.11:9040) Running State Change CS_ROUTING
  263. 2016-08-03 19:22:08.859223 [DEBUG] sofia.c:6937 Channel sofia/internal/trillions@192.168.0.11:9040 entering state [calling][0]
  264. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/trillions@192.168.0.11:9040) State ROUTING
  265. 2016-08-03 19:22:08.859223 [DEBUG] mod_sofia.c:143 sofia/internal/trillions@192.168.0.11:9040 SOFIA ROUTING
  266. 2016-08-03 19:22:08.859223 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/trillions@192.168.0.11:9040) State Change CS_ROUTING -> CS_CONSUME_MEDIA
  267. 2016-08-03 19:22:08.859223 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/trillions@192.168.0.11:9040) State ROUTING going to sleep
  268. 2016-08-03 19:22:08.879751 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/trillions@192.168.0.11:9040) Running State Change CS_CONSUME_MEDIA
  269. 2016-08-03 19:22:08.879751 [DEBUG] switch_core_state_machine.c:621 (sofia/internal/trillions@192.168.0.11:9040) State CONSUME_MEDIA
  270. 2016-08-03 19:22:08.879751 [DEBUG] switch_core_state_machine.c:621 (sofia/internal/trillions@192.168.0.11:9040) State CONSUME_MEDIA going to sleep
  271. 2016-08-03 19:22:09.158715 [DEBUG] sofia.c:6937 Channel sofia/internal/trillions@192.168.0.11:9040 entering state [proceeding][180]
  272. 2016-08-03 19:22:16.819211 [ALERT] mod_verto.c:1370 READ 192.168.0.11:52770 [{
  273.         "jsonrpc":      "2.0",
  274.         "method":       "verto.bye",
  275.         "params":       {
  276.                 "dialogParams": {
  277.                         "useVideo":     false,
  278.                         "useStereo":    false,
  279.                         "screenShare":  false,
  280.                         "useCamera":    "none",
  281.                         "useMic":       "f0ceca0920127577edd263ef38b6e316412a27fbec70948ba4acbbfa53eb9dfe",
  282.                         "useSpeak":     "default",
  283.                         "tag":  "webcam",
  284.                         "localTag":     null,
  285.                         "login":        "trillionss@xbipin.com",
  286.                         "videoParams":  {
  287.                                 "minWidth":     320,
  288.                                 "minHeight":    180,
  289.                                 "maxWidth":     320,
  290.                                 "maxHeight":    180,
  291.                                 "minFrameRate": 15
  292.                         },
  293.                         "destination_number":   "2002",
  294.                         "caller_id_name":       "1234",
  295.                         "caller_id_number":     "",
  296.                         "outgoingBandwidth":    19443,
  297.                         "incomingBandwidth":    90354,
  298.                         "dedEnc":       false,
  299.                         "mirrorInput":  false,
  300.                         "userVariables":        {
  301.                                 "email":        "",
  302.                                 "avatar":       "http://gravatar.com/avatar/d41d8cd98f00b204e9800998ecf8427e.png?s=600"
  303.                         },
  304.                         "callID":       "f00246a4-2136-48ef-5f03-5b58fe15b677",
  305.                         "remote_caller_id_name":        "Outbound Call",
  306.                         "remote_caller_id_number":      "2002"
  307.                 },
  308.                 "sessid":       "f3116205-59f7-1a56-6b06-e23e4645f500"
  309.         },
  310.         "id":   5
  311. }]
  312. 2016-08-03 19:22:16.819211 [NOTICE] mod_verto.c:2748 Hangup verto.rtc/2002 [CS_EXECUTE] [NORMAL_CLEARING]
  313. 2016-08-03 19:22:16.819211 [ALERT] mod_verto.c:604 WRITE 192.168.0.11:52770 [{
  314.         "jsonrpc":      "2.0",
  315.         "id":   5,
  316.         "result":       {
  317.                 "callID":       "f00246a4-2136-48ef-5f03-5b58fe15b677",
  318.                 "message":      "CALL ENDED",
  319.                 "causeCode":    16,
  320.                 "cause":        "NORMAL_CLEARING",
  321.                 "sessid":       "f3116205-59f7-1a56-6b06-e23e4645f500"
  322.         }
  323. }]
  324. 2016-08-03 19:22:16.819211 [NOTICE] switch_ivr_originate.c:3522 Hangup sofia/internal/trillions@192.168.0.11:9040 [CS_CONSUME_MEDIA] [ORIGINATOR_CANCEL]
  325. 2016-08-03 19:22:16.819211 [DEBUG] switch_ivr_originate.c:3739 Originate Cancelled by originator termination Cause: 487 [ORIGINATOR_CANCEL]
  326. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/trillions@192.168.0.11:9040) Running State Change CS_HANGUP
  327. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:809 (sofia/internal/trillions@192.168.0.11:9040) Callstate Change DOWN -> HANGUP
  328. 2016-08-03 19:22:16.819211 [NOTICE] switch_ivr_originate.c:2762 Cannot create outgoing channel of type [user] cause: [ORIGINATOR_CANCEL]
  329. 2016-08-03 19:22:16.819211 [DEBUG] switch_ivr_originate.c:3750 Originate Resulted in Error Cause: 487 [ORIGINATOR_CANCEL]
  330. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:811 (sofia/internal/trillions@192.168.0.11:9040) State HANGUP
  331. 2016-08-03 19:22:16.819211 [DEBUG] mod_sofia.c:438 Channel sofia/internal/trillions@192.168.0.11:9040 hanging up, cause: ORIGINATOR_CANCEL
  332. 2016-08-03 19:22:16.819211 [INFO] mod_dptools.c:3401 Originate Failed.  Cause: ORIGINATOR_CANCEL
  333. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_session.c:2797 verto.rtc/2002 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
  334. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:609 (verto.rtc/2002) State EXECUTE going to sleep
  335. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:543 (verto.rtc/2002) Running State Change CS_HANGUP
  336. 2016-08-03 19:22:16.819211 [DEBUG] mod_sofia.c:502 Sending CANCEL to sofia/internal/trillions@192.168.0.11:9040
  337. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:60 sofia/internal/trillions@192.168.0.11:9040 Standard HANGUP, cause: ORIGINATOR_CANCEL
  338. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:809 (verto.rtc/2002) Callstate Change RINGING -> HANGUP
  339. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:811 (sofia/internal/trillions@192.168.0.11:9040) State HANGUP going to sleep
  340. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/trillions@192.168.0.11:9040) State Change CS_HANGUP -> CS_REPORTING
  341. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:811 (verto.rtc/2002) State HANGUP
  342. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:60 verto.rtc/2002 Standard HANGUP, cause: NORMAL_CLEARING
  343. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:811 (verto.rtc/2002) State HANGUP going to sleep
  344. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:578 (verto.rtc/2002) State Change CS_HANGUP -> CS_REPORTING
  345. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/trillions@192.168.0.11:9040) Running State Change CS_REPORTING
  346. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:543 (verto.rtc/2002) Running State Change CS_REPORTING
  347. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:897 (sofia/internal/trillions@192.168.0.11:9040) State REPORTING
  348. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:174 sofia/internal/trillions@192.168.0.11:9040 Standard REPORTING, cause: ORIGINATOR_CANCEL
  349. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:897 (sofia/internal/trillions@192.168.0.11:9040) State REPORTING going to sleep
  350. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:897 (verto.rtc/2002) State REPORTING
  351. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:174 verto.rtc/2002 Standard REPORTING, cause: NORMAL_CLEARING
  352. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:897 (verto.rtc/2002) State REPORTING going to sleep
  353. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/trillions@192.168.0.11:9040) State Change CS_REPORTING -> CS_DESTROY
  354. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:569 (verto.rtc/2002) State Change CS_REPORTING -> CS_DESTROY
  355. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_session.c:1647 Session 9 (sofia/internal/trillions@192.168.0.11:9040) Locked, Waiting on external entities
  356. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_session.c:1647 Session 8 (verto.rtc/2002) Locked, Waiting on external entities
  357. 2016-08-03 19:22:16.819211 [NOTICE] switch_core_session.c:1665 Session 8 (verto.rtc/2002) Ended
  358. 2016-08-03 19:22:16.819211 [NOTICE] switch_core_session.c:1665 Session 9 (sofia/internal/trillions@192.168.0.11:9040) Ended
  359. 2016-08-03 19:22:16.819211 [NOTICE] switch_core_session.c:1669 Close Channel verto.rtc/2002 [CS_DESTROY]
  360. 2016-08-03 19:22:16.819211 [NOTICE] switch_core_session.c:1669 Close Channel sofia/internal/trillions@192.168.0.11:9040 [CS_DESTROY]
  361. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:700 (verto.rtc/2002) Running State Change CS_DESTROY
  362. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:700 (sofia/internal/trillions@192.168.0.11:9040) Running State Change CS_DESTROY
  363. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:710 (verto.rtc/2002) State DESTROY
  364. 2016-08-03 19:22:16.819211 [DEBUG] mod_rtc.c:132 verto.rtc/2002 RTC DESTROY
  365. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:181 verto.rtc/2002 Standard DESTROY
  366. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:710 (verto.rtc/2002) State DESTROY going to sleep
  367. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:710 (sofia/internal/trillions@192.168.0.11:9040) State DESTROY
  368. 2016-08-03 19:22:16.819211 [DEBUG] mod_sofia.c:343 sofia/internal/trillions@192.168.0.11:9040 SOFIA DESTROY
  369. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:181 sofia/internal/trillions@192.168.0.11:9040 Standard DESTROY
  370. 2016-08-03 19:22:16.819211 [DEBUG] switch_core_state_machine.c:710 (sofia/internal/trillions@192.168.0.11:9040) State DESTROY going to sleep
  371. 2016-08-03 19:22:35.439125 [DEBUG] sofia_reg.c:2429 Changing expire time to 120 by request of proxy sip:10.10.0.1
  372. 2016-08-03 19:22:37.799015 [DEBUG] mod_verto.c:1862 BAD READ -1000
  373. 2016-08-03 19:22:37.799015 [INFO] mod_verto.c:2005 192.168.0.11:52770 Ending client thread.
  374. 2016-08-03 19:22:37.799015 [INFO] mod_verto.c:2013 192.168.0.11:52770 Thread ended
  375.