2016-09-07 13:43:22.296063 [DEBUG] switch_ivr_originate.c:2136 Parsing global variables 2016-09-07 13:43:22.296063 [DEBUG] switch_ivr_originate.c:2589 Parsing session specific variables 2016-09-07 13:43:22.296063 [DEBUG] switch_ivr_originate.c:2136 Parsing global variables 2016-09-07 13:43:22.296063 [NOTICE] switch_channel.c:1104 New Channel sofia/internal/2@192.168.0.63:44595 [74321c58-e9ae-4e77-a3aa-2a9b4dbb8640] 2016-09-07 13:43:22.296063 [DEBUG] mod_sofia.c:4753 (sofia/internal/2@192.168.0.63:44595) State Change CS_NEW -> CS_INIT 2016-09-07 13:43:22.296063 [DEBUG] switch_core_session.c:613 sofia/internal/2@192.168.0.63:44595 set UUID=74321c58-e9ae-4e77-a3aa-2a9b4dbb8640 2016-09-07 13:43:22.296063 [DEBUG] switch_ivr_originate.c:2589 Parsing session specific variables 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/2@192.168.0.63:44595) Running State Change CS_INIT 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:586 (sofia/internal/2@192.168.0.63:44595) State INIT 2016-09-07 13:43:22.296063 [NOTICE] switch_channel.c:1104 New Channel loopback/2/alarm-a [68d65bc1-2f30-4834-908e-d4e98a5d1785] 2016-09-07 13:43:22.296063 [DEBUG] mod_sofia.c:90 sofia/internal/2@192.168.0.63:44595 SOFIA INIT 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:158 loopback/2/alarm-a setup codec L16/8000/20 2016-09-07 13:43:22.296063 [NOTICE] switch_channel.c:1102 Rename Channel loopback/2/alarm-a->loopback/2-a [68d65bc1-2f30-4834-908e-d4e98a5d1785] 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:1174 (loopback/2-a) State Change CS_NEW -> CS_INIT 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] sofia_glue.c:1276 sofia/internal/2@192.168.0.63:44595 sending invite version: 1.6.10 git 726448d 2016-08-24 21:54:04Z 64bit Local SDP: v=0 o=FreeSWITCH 1473227382 1473227383 IN IP4 192.168.0.63 s=FreeSWITCH c=IN IP4 192.168.0.63 t=0 0 m=audio 17620 RTP/AVP 0 8 18 9 3 101 13 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:18 G729/8000 a=rtpmap:9 G722/8000 a=rtpmap:3 GSM/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=rtcp-mux a=rtcp:17620 IN IP4 192.168.0.63 a=rtpmap:13 CN/8000 a=ptime:20 a=sendrecv 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:40 sofia/internal/2@192.168.0.63:44595 Standard INIT 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/2@192.168.0.63:44595) State Change CS_INIT -> CS_ROUTING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:586 (sofia/internal/2@192.168.0.63:44595) State INIT going to sleep 2016-09-07 13:43:22.296063 [DEBUG] switch_ivr_originate.c:2901 loopback/2-a Setting leg delay start to 10 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/2@192.168.0.63:44595) Running State Change CS_ROUTING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/2@192.168.0.63:44595) State ROUTING 2016-09-07 13:43:22.296063 [DEBUG] mod_sofia.c:143 sofia/internal/2@192.168.0.63:44595 SOFIA ROUTING 2016-09-07 13:43:22.296063 [DEBUG] switch_ivr_originate.c:67 (sofia/internal/2@192.168.0.63:44595) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/2@192.168.0.63:44595) State ROUTING going to sleep 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/2@192.168.0.63:44595) Running State Change CS_CONSUME_MEDIA 2016-09-07 13:43:22.296063 [DEBUG] sofia.c:6962 Channel sofia/internal/2@192.168.0.63:44595 entering state [calling][0] 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:621 (sofia/internal/2@192.168.0.63:44595) State CONSUME_MEDIA 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:621 (sofia/internal/2@192.168.0.63:44595) State CONSUME_MEDIA going to sleep 2016-09-07 13:43:22.296063 [DEBUG] sofia.c:6962 Channel sofia/internal/2@192.168.0.63:44595 entering state [terminated][488] 2016-09-07 13:43:22.296063 [NOTICE] sofia.c:8054 Hangup sofia/internal/2@192.168.0.63:44595 [CS_CONSUME_MEDIA] [INCOMPATIBLE_DESTINATION] 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/2@192.168.0.63:44595) Running State Change CS_HANGUP 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:809 (sofia/internal/2@192.168.0.63:44595) Callstate Change DOWN -> HANGUP 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:811 (sofia/internal/2@192.168.0.63:44595) State HANGUP 2016-09-07 13:43:22.296063 [DEBUG] mod_sofia.c:438 Channel sofia/internal/2@192.168.0.63:44595 hanging up, cause: INCOMPATIBLE_DESTINATION 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:60 sofia/internal/2@192.168.0.63:44595 Standard HANGUP, cause: INCOMPATIBLE_DESTINATION 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:811 (sofia/internal/2@192.168.0.63:44595) State HANGUP going to sleep 2016-09-07 13:43:22.296063 [DEBUG] switch_ivr_originate.c:2136 Parsing global variables 2016-09-07 13:43:22.296063 [NOTICE] switch_channel.c:1104 New Channel loopback/2/answered-a [7989266d-14c8-4dc9-9322-7cad90edb0cb] 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:158 loopback/2/answered-a setup codec L16/8000/20 2016-09-07 13:43:22.296063 [NOTICE] switch_channel.c:1102 Rename Channel loopback/2/answered-a->loopback/2-a [7989266d-14c8-4dc9-9322-7cad90edb0cb] 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:1174 (loopback/2-a) State Change CS_NEW -> CS_INIT 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (loopback/2-a) Running State Change CS_INIT 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:586 (loopback/2-a) State INIT 2016-09-07 13:43:22.296063 [NOTICE] switch_channel.c:1104 New Channel loopback/2-b [00a1271f-ce95-4607-bf33-98d47dfbe7d2] 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:158 loopback/2-b setup codec L16/8000/20 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:276 (loopback/2-b) State Change CS_NEW -> CS_INIT 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:362 (loopback/2-a) State Change CS_INIT -> CS_ROUTING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (loopback/2-b) Running State Change CS_INIT 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:586 (loopback/2-a) State INIT going to sleep 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:586 (loopback/2-b) State INIT 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:362 (loopback/2-b) State Change CS_INIT -> CS_ROUTING 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:586 (loopback/2-b) State INIT going to sleep 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (loopback/2-b) Running State Change CS_ROUTING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (loopback/2-a) Running State Change CS_ROUTING 2016-09-07 13:43:22.296063 [DEBUG] switch_channel.c:2249 (loopback/2-b) Callstate Change DOWN -> RINGING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:602 (loopback/2-a) State ROUTING 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:394 loopback/2-a CHANNEL ROUTING 2016-09-07 13:43:22.296063 [DEBUG] switch_ivr_originate.c:67 (loopback/2-a) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:602 (loopback/2-b) State ROUTING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:602 (loopback/2-a) State ROUTING going to sleep 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:394 loopback/2-b CHANNEL ROUTING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:236 loopback/2-b Standard ROUTING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (loopback/2-a) Running State Change CS_CONSUME_MEDIA 2016-09-07 13:43:22.296063 [INFO] mod_dialplan_xml.c:637 Processing <0000000000>->2 in context answered Dialplan: loopback/2-b parsing [answered->Stop-alarm] continue=false 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:621 (loopback/2-a) State CONSUME_MEDIA 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:661 CHANNEL CONSUME_MEDIA 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:621 (loopback/2-a) State CONSUME_MEDIA going to sleep Dialplan: loopback/2-b Regex (FAIL) [Stop-alarm] ${hash(select/alarms/${destination_number})}() =~ /1/ break=on-false 2016-09-07 13:43:22.296063 [INFO] switch_core_state_machine.c:311 No Route, Aborting 2016-09-07 13:43:22.296063 [NOTICE] switch_core_state_machine.c:312 Hangup loopback/2-b [CS_ROUTING] [NO_ROUTE_DESTINATION] 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:602 (loopback/2-b) State ROUTING going to sleep 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (loopback/2-b) Running State Change CS_HANGUP 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:809 (loopback/2-b) Callstate Change RINGING -> HANGUP 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:811 (loopback/2-b) State HANGUP 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:548 loopback/2-b CHANNEL HANGUP 2016-09-07 13:43:22.296063 [NOTICE] mod_loopback.c:564 Hangup loopback/2-a [CS_CONSUME_MEDIA] [NO_ROUTE_DESTINATION] 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:60 loopback/2-b Standard HANGUP, cause: NO_ROUTE_DESTINATION 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (loopback/2-a) Running State Change CS_HANGUP 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:811 (loopback/2-b) State HANGUP going to sleep 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:578 (loopback/2-b) State Change CS_HANGUP -> CS_REPORTING 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (loopback/2-b) Running State Change CS_REPORTING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:897 (loopback/2-b) State REPORTING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:174 loopback/2-b Standard REPORTING, cause: NO_ROUTE_DESTINATION 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:897 (loopback/2-b) State REPORTING going to sleep 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:809 (loopback/2-a) Callstate Change DOWN -> HANGUP 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:569 (loopback/2-b) State Change CS_REPORTING -> CS_DESTROY 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] switch_core_session.c:1647 Session 519 (loopback/2-b) Locked, Waiting on external entities 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:811 (loopback/2-a) State HANGUP 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:548 loopback/2-a CHANNEL HANGUP 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:60 loopback/2-a Standard HANGUP, cause: NO_ROUTE_DESTINATION 2016-09-07 13:43:22.296063 [NOTICE] switch_core_session.c:1665 Session 519 (loopback/2-b) Ended 2016-09-07 13:43:22.296063 [NOTICE] switch_core_session.c:1669 Close Channel loopback/2-b [CS_DESTROY] 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:811 (loopback/2-a) State HANGUP going to sleep 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:578 (loopback/2-a) State Change CS_HANGUP -> CS_REPORTING 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:543 (loopback/2-a) Running State Change CS_REPORTING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:700 (loopback/2-b) Running State Change CS_DESTROY 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:710 (loopback/2-b) State DESTROY 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:181 loopback/2-b Standard DESTROY 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:710 (loopback/2-b) State DESTROY going to sleep 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:897 (loopback/2-a) State REPORTING 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:174 loopback/2-a Standard REPORTING, cause: NO_ROUTE_DESTINATION 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:897 (loopback/2-a) State REPORTING going to sleep 2016-09-07 13:43:22.296063 [DEBUG] switch_core_state_machine.c:569 (loopback/2-a) State Change CS_REPORTING -> CS_DESTROY 2016-09-07 13:43:22.296063 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.296063 [DEBUG] switch_core_session.c:1647 Session 518 (loopback/2-a) Locked, Waiting on external entities 2016-09-07 13:43:22.316063 [DEBUG] switch_ivr_originate.c:3759 Originate Resulted in Error Cause: 3 [NO_ROUTE_DESTINATION] 2016-09-07 13:43:22.316063 [DEBUG] switch_core_state_machine.c:742 Hangup Command with no Session originate(loopback/2/answered 0): -ERR NO_ROUTE_DESTINATION 2016-09-07 13:43:22.316063 [NOTICE] switch_core_session.c:1665 Session 518 (loopback/2-a) Ended 2016-09-07 13:43:22.316063 [DEBUG] switch_core_state_machine.c:578 (sofia/internal/2@192.168.0.63:44595) State Change CS_HANGUP -> CS_REPORTING 2016-09-07 13:43:22.316063 [NOTICE] switch_core_session.c:1669 Close Channel loopback/2-a [CS_DESTROY] 2016-09-07 13:43:22.316063 [DEBUG] switch_core_state_machine.c:543 (sofia/internal/2@192.168.0.63:44595) Running State Change CS_REPORTING 2016-09-07 13:43:22.316063 [DEBUG] switch_core_state_machine.c:897 (sofia/internal/2@192.168.0.63:44595) State REPORTING 2016-09-07 13:43:22.316063 [DEBUG] switch_core_state_machine.c:700 (loopback/2-a) Running State Change CS_DESTROY 2016-09-07 13:43:22.316063 [DEBUG] switch_core_state_machine.c:174 sofia/internal/2@192.168.0.63:44595 Standard REPORTING, cause: INCOMPATIBLE_DESTINATION 2016-09-07 13:43:22.316063 [DEBUG] switch_core_state_machine.c:897 (sofia/internal/2@192.168.0.63:44595) State REPORTING going to sleep 2016-09-07 13:43:22.316063 [DEBUG] switch_core_state_machine.c:710 (loopback/2-a) State DESTROY 2016-09-07 13:43:22.316063 [DEBUG] switch_core_state_machine.c:181 loopback/2-a Standard DESTROY 2016-09-07 13:43:22.316063 [DEBUG] switch_core_state_machine.c:710 (loopback/2-a) State DESTROY going to sleep 2016-09-07 13:43:22.316063 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/2@192.168.0.63:44595) State Change CS_REPORTING -> CS_DESTROY 2016-09-07 13:43:22.316063 [DEBUG] switch_core_session.c:1647 Session 516 (sofia/internal/2@192.168.0.63:44595) Locked, Waiting on external entities 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:543 (loopback/2-a) Running State Change CS_INIT 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:586 (loopback/2-a) State INIT 2016-09-07 13:43:22.336031 [NOTICE] switch_channel.c:1104 New Channel loopback/2-b [9f951727-74b5-4da6-b047-59c2219ee21b] 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:158 loopback/2-b setup codec L16/8000/20 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:276 (loopback/2-b) State Change CS_NEW -> CS_INIT 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:362 (loopback/2-a) State Change CS_INIT -> CS_ROUTING 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:543 (loopback/2-b) Running State Change CS_INIT 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:586 (loopback/2-a) State INIT going to sleep 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:586 (loopback/2-b) State INIT 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:362 (loopback/2-b) State Change CS_INIT -> CS_ROUTING 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:586 (loopback/2-b) State INIT going to sleep 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:543 (loopback/2-a) Running State Change CS_ROUTING 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:543 (loopback/2-b) Running State Change CS_ROUTING 2016-09-07 13:43:22.336031 [DEBUG] switch_channel.c:2249 (loopback/2-b) Callstate Change DOWN -> RINGING 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:602 (loopback/2-a) State ROUTING 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:394 loopback/2-a CHANNEL ROUTING 2016-09-07 13:43:22.336031 [DEBUG] switch_ivr_originate.c:67 (loopback/2-a) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:602 (loopback/2-a) State ROUTING going to sleep 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:543 (loopback/2-a) Running State Change CS_CONSUME_MEDIA 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:602 (loopback/2-b) State ROUTING 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:394 loopback/2-b CHANNEL ROUTING 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:236 loopback/2-b Standard ROUTING 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:621 (loopback/2-a) State CONSUME_MEDIA 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:661 CHANNEL CONSUME_MEDIA 2016-09-07 13:43:22.336031 [INFO] mod_dialplan_xml.c:637 Processing Диспетчерская <2>->2 in context alarm 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:621 (loopback/2-a) State CONSUME_MEDIA going to sleep Dialplan: loopback/2-b parsing [alarm->Alarm] continue=false Dialplan: loopback/2-b Regex (FAIL) [Alarm] ${db(exists/alarms/${destination_number})}(false) =~ /^true$/ break=on-false 2016-09-07 13:43:22.336031 [INFO] switch_core_state_machine.c:311 No Route, Aborting 2016-09-07 13:43:22.336031 [NOTICE] switch_core_state_machine.c:312 Hangup loopback/2-b [CS_ROUTING] [NO_ROUTE_DESTINATION] 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:602 (loopback/2-b) State ROUTING going to sleep 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:543 (loopback/2-b) Running State Change CS_HANGUP 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:809 (loopback/2-b) Callstate Change RINGING -> HANGUP 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:811 (loopback/2-b) State HANGUP 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:548 loopback/2-b CHANNEL HANGUP 2016-09-07 13:43:22.336031 [NOTICE] mod_loopback.c:564 Hangup loopback/2-a [CS_CONSUME_MEDIA] [NO_ROUTE_DESTINATION] 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:60 loopback/2-b Standard HANGUP, cause: NO_ROUTE_DESTINATION 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:543 (loopback/2-a) Running State Change CS_HANGUP 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:811 (loopback/2-b) State HANGUP going to sleep 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:578 (loopback/2-b) State Change CS_HANGUP -> CS_REPORTING 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:543 (loopback/2-b) Running State Change CS_REPORTING 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:809 (loopback/2-a) Callstate Change DOWN -> HANGUP 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:897 (loopback/2-b) State REPORTING 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:811 (loopback/2-a) State HANGUP 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:548 loopback/2-a CHANNEL HANGUP 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:60 loopback/2-a Standard HANGUP, cause: NO_ROUTE_DESTINATION 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:811 (loopback/2-a) State HANGUP going to sleep 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:174 loopback/2-b Standard REPORTING, cause: NO_ROUTE_DESTINATION 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:578 (loopback/2-a) State Change CS_HANGUP -> CS_REPORTING 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:897 (loopback/2-b) State REPORTING going to sleep 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:543 (loopback/2-a) Running State Change CS_REPORTING 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:897 (loopback/2-a) State REPORTING 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:569 (loopback/2-b) State Change CS_REPORTING -> CS_DESTROY 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-b CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] switch_core_session.c:1647 Session 520 (loopback/2-b) Locked, Waiting on external entities 2016-09-07 13:43:22.336031 [NOTICE] switch_core_session.c:1665 Session 520 (loopback/2-b) Ended 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:174 loopback/2-a Standard REPORTING, cause: NO_ROUTE_DESTINATION 2016-09-07 13:43:22.336031 [NOTICE] switch_core_session.c:1669 Close Channel loopback/2-b [CS_DESTROY] 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:897 (loopback/2-a) State REPORTING going to sleep 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:700 (loopback/2-b) Running State Change CS_DESTROY 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:569 (loopback/2-a) State Change CS_REPORTING -> CS_DESTROY 2016-09-07 13:43:22.336031 [DEBUG] mod_loopback.c:601 loopback/2-a CHANNEL KILL 2016-09-07 13:43:22.336031 [DEBUG] switch_core_session.c:1647 Session 517 (loopback/2-a) Locked, Waiting on external entities 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:710 (loopback/2-b) State DESTROY 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:181 loopback/2-b Standard DESTROY 2016-09-07 13:43:22.336031 [DEBUG] switch_core_state_machine.c:710 (loopback/2-b) State DESTROY going to sleep 2016-09-07 13:43:22.356055 [DEBUG] switch_ivr_originate.c:3759 Originate Resulted in Error Cause: 88 [INCOMPATIBLE_DESTINATION] 2016-09-07 13:43:22.356055 [NOTICE] switch_core_session.c:1665 Session 517 (loopback/2-a) Ended 2016-09-07 13:43:22.356055 [NOTICE] switch_core_session.c:1669 Close Channel loopback/2-a [CS_DESTROY] 2016-09-07 13:43:22.356055 [NOTICE] switch_core_session.c:1665 Session 516 (sofia/internal/2@192.168.0.63:44595) Ended 2016-09-07 13:43:22.356055 [NOTICE] switch_core_session.c:1669 Close Channel sofia/internal/2@192.168.0.63:44595 [CS_DESTROY] 2016-09-07 13:43:22.356055 [DEBUG] switch_core_state_machine.c:700 (loopback/2-a) Running State Change CS_DESTROY 2016-09-07 13:43:22.356055 [DEBUG] switch_core_state_machine.c:710 (loopback/2-a) State DESTROY 2016-09-07 13:43:22.356055 [DEBUG] switch_core_state_machine.c:700 (sofia/internal/2@192.168.0.63:44595) Running State Change CS_DESTROY 2016-09-07 13:43:22.356055 [DEBUG] switch_core_state_machine.c:181 loopback/2-a Standard DESTROY 2016-09-07 13:43:22.356055 [DEBUG] switch_core_state_machine.c:710 (loopback/2-a) State DESTROY going to sleep 2016-09-07 13:43:22.356055 [DEBUG] switch_core_state_machine.c:710 (sofia/internal/2@192.168.0.63:44595) State DESTROY 2016-09-07 13:43:22.356055 [DEBUG] mod_sofia.c:343 sofia/internal/2@192.168.0.63:44595 SOFIA DESTROY 2016-09-07 13:43:22.356055 [DEBUG] switch_core_state_machine.c:181 sofia/internal/2@192.168.0.63:44595 Standard DESTROY 2016-09-07 13:43:22.356055 [DEBUG] switch_core_state_machine.c:710 (sofia/internal/2@192.168.0.63:44595) State DESTROY going to sleep