2012-10-05 22:06:57.386448 [NOTICE] sofia.c:6318 Channel [sofia/internal/1001] has been answered
2012-10-05 22:06:57.406452 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1001) Running State Change CS_SOFT_EXECUTE
2012-10-05 22:06:57.406452 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/1001) State SOFT_EXECUTE
2012-10-05 22:06:57.406452 [DEBUG] mod_sofia.c:588 SOFIA SOFT_EXECUTE
2012-10-05 22:06:57.406452 [DEBUG] switch_core_state_machine.c:241 sofia/internal/1001 Standard SOFT_EXECUTE
2012-10-05 22:06:57.406452 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/1001) State SOFT_EXECUTE going to sleep
2012-10-05 22:06:57.406452 [INFO] switch_channel.c:2711 sofia/internal/1001 Flipping CID from "" <1111> to "Outbound Call" <1001%192.168.0.19>
2012-10-05 22:06:57.406452 [INFO] switch_channel.c:2711 sofia/internal/1000 Flipping CID from "" <1111> to "Outbound Call" <1000%192.168.0.19>
2012-10-05 22:06:57.406452 [DEBUG] switch_ivr_bridge.c:1619 (sofia/internal/1000) State Change CS_SOFT_EXECUTE -> CS_HIBERNATE
2012-10-05 22:06:57.406452 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1000) Running State Change CS_HIBERNATE
2012-10-05 22:06:57.426425 [DEBUG] switch_core_session.c:1205 Send signal sofia/internal/1000 [BREAK]
2012-10-05 22:06:57.426425 [DEBUG] switch_core_state_machine.c:432 (sofia/internal/1000) State HIBERNATE
2012-10-05 22:06:57.426425 [DEBUG] mod_sofia.c:222 sofia/internal/1000 SOFIA HIBERNATE
2012-10-05 22:06:57.426425 [DEBUG] switch_ivr_bridge.c:749 (sofia/internal/1000) State Change CS_HIBERNATE -> CS_RESET
2012-10-05 22:06:57.426425 [DEBUG] switch_core_session.c:1205 Send signal sofia/internal/1000 [BREAK]
2012-10-05 22:06:57.426425 [DEBUG] switch_core_state_machine.c:432 (sofia/internal/1000) State HIBERNATE going to sleep
2012-10-05 22:06:57.426425 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1000) Running State Change CS_RESET
2012-10-05 22:06:57.426425 [DEBUG] switch_core_state_machine.c:413 (sofia/internal/1000) State RESET
2012-10-05 22:06:57.426425 [DEBUG] mod_sofia.c:166 sofia/internal/1000 SOFIA RESET
2012-10-05 22:06:57.426425 [DEBUG] switch_ivr_bridge.c:734 sofia/internal/1000 CUSTOM RESET
2012-10-05 22:06:57.426425 [DEBUG] switch_ivr_bridge.c:741 (sofia/internal/1000) State Change CS_RESET -> CS_SOFT_EXECUTE
2012-10-05 22:06:57.426425 [DEBUG] switch_core_session.c:1205 Send signal sofia/internal/1000 [BREAK]
2012-10-05 22:06:57.426425 [DEBUG] switch_core_state_machine.c:413 (sofia/internal/1000) State RESET going to sleep
2012-10-05 22:06:57.426425 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1000) Running State Change CS_SOFT_EXECUTE
2012-10-05 22:06:57.426425 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/1000) State SOFT_EXECUTE
2012-10-05 22:06:57.426425 [DEBUG] mod_sofia.c:588 SOFIA SOFT_EXECUTE
2012-10-05 22:06:57.426425 [DEBUG] switch_ivr_bridge.c:759 sofia/internal/1000 CUSTOM SOFT_EXECUTE
2012-10-05 22:06:57.426425 [DEBUG] switch_channel.c:2849 (sofia/internal/1001) Callstate Change ACTIVE -> HANGUP
2012-10-05 22:06:57.426425 [NOTICE] switch_ivr_originate.c:1056 Hangup sofia/internal/1001 [CS_SOFT_EXECUTE] [DESTINATION_OUT_OF_ORDER]
2012-10-05 22:06:57.426425 [DEBUG] switch_channel.c:2872 Send signal sofia/internal/1001 [KILL]
2012-10-05 22:06:57.426425 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1001) Running State Change CS_HANGUP
2012-10-05 22:06:57.426425 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/1001) State HANGUP
2012-10-05 22:06:57.426425 [DEBUG] mod_sofia.c:469 Channel sofia/internal/1001 hanging up, cause: DESTINATION_OUT_OF_ORDER
2012-10-05 22:06:57.426425 [DEBUG] switch_core_session.c:1205 Send signal sofia/internal/1001 [BREAK]
2012-10-05 22:06:57.426425 [DEBUG] switch_channel.c:2849 (sofia/internal/1000) Callstate Change ACTIVE -> HANGUP
2012-10-05 22:06:57.426425 [NOTICE] switch_ivr_bridge.c:817 Hangup sofia/internal/1000 [CS_SOFT_EXECUTE] [ORIGINATOR_CANCEL]
2012-10-05 22:06:57.426425 [DEBUG] switch_channel.c:2872 Send signal sofia/internal/1000 [KILL]
2012-10-05 22:06:57.426425 [DEBUG] switch_core_session.c:1205 Send signal sofia/internal/1000 [BREAK]
2012-10-05 22:06:57.426425 [DEBUG] switch_core_state_machine.c:423 (sofia/internal/1000) State SOFT_EXECUTE going to sleep
2012-10-05 22:06:57.426425 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1000) Running State Change CS_HANGUP
2012-10-05 22:06:57.426425 [DEBUG] switch_core_session.c:816 Send signal sofia/internal/1001 [BREAK]
2012-10-05 22:06:57.426425 [DEBUG] switch_core_session.c:816 Send signal sofia/internal/1000 [BREAK]
2012-10-05 22:06:57.426425 [DEBUG] mod_sofia.c:517 Sending BYE to sofia/internal/1001
2012-10-05 22:06:57.446365 [DEBUG] switch_cpp.cpp:1007 sofia/internal/1001 destroy/unlink session from object
2012-10-05 22:06:57.446365 [DEBUG] switch_cpp.cpp:1007 sofia/internal/1000 destroy/unlink session from object
2012-10-05 22:06:57.446365 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/1000) State HANGUP
2012-10-05 22:06:57.446365 [DEBUG] switch_core_state_machine.c:47 sofia/internal/1001 Standard HANGUP, cause: DESTINATION_OUT_OF_ORDER
2012-10-05 22:06:57.446365 [DEBUG] switch_core_state_machine.c:602 (sofia/internal/1001) State HANGUP going to sleep
2012-10-05 22:06:57.446365 [DEBUG] switch_core_state_machine.c:393 (sofia/internal/1001) State Change CS_HANGUP -> CS_REPORTING
2012-10-05 22:06:57.446365 [DEBUG] switch_core_session.c:1205 Send signal sofia/internal/1001 [BREAK]
2012-10-05 22:06:57.446365 [DEBUG] switch_core_state_machine.c:362 (sofia/internal/1001) Running State Change CS_REPORTING