Skip to content

Instantly share code, notes, and snippets.

@skalogirou
Created July 31, 2014 16:45
Show Gist options
  • Save skalogirou/b384ffdac71bcf93cb37 to your computer and use it in GitHub Desktop.
Save skalogirou/b384ffdac71bcf93cb37 to your computer and use it in GitHub Desktop.
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1052 Send signal sofia/external/test@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:969 Send signal sofia/external/test@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] sofia.c:7539 Process REFER to [200@sip.example.com]
2014-07-31 15:48:02.324898 [DEBUG] sofia.c:7565 Replaces: [806adaca-82ff692f@192.168.87.100]
2014-07-31 15:48:02.324898 [NOTICE] sofia.c:7732 Attended Transfer [DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000][05969673-6585-4a83-ad27-a3ceab777233]
2014-07-31 15:48:02.324898 [DEBUG] switch_ivr_bridge.c:1871 (sofia/external/0000000000@000.000.000.000) State Change CS_SOFT_EXECUTE -> CS_HIBERNATE
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/0000000000@000.000.000.000 [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] switch_ivr_bridge.c:1873 (sofia/external/test1@sip.example.com) State Change CS_SOFT_EXECUTE -> CS_HIBERNATE
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/test1@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] sofia.c:7783 (sofia/external/test@sip.example.com) State Change CS_SOFT_EXECUTE -> CS_PARK
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/test@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:472 (sofia/external/test1@sip.example.com) Running State Change CS_HIBERNATE
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:550 (sofia/external/test1@sip.example.com) State HIBERNATE
2014-07-31 15:48:02.324898 [DEBUG] mod_sofia.c:160 sofia/external/test1@sip.example.com SOFIA HIBERNATE
2014-07-31 15:48:02.324898 [DEBUG] switch_ivr_bridge.c:835 (sofia/external/test1@sip.example.com) State Change CS_HIBERNATE -> CS_RESET
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/test1@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:550 (sofia/external/test1@sip.example.com) State HIBERNATE going to sleep
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:472 (sofia/external/test1@sip.example.com) Running State Change CS_RESET
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:531 (sofia/external/test1@sip.example.com) State RESET
2014-07-31 15:48:02.324898 [DEBUG] mod_sofia.c:141 sofia/external/test1@sip.example.com SOFIA RESET
2014-07-31 15:48:02.324898 [DEBUG] switch_ivr_bridge.c:820 sofia/external/test1@sip.example.com CUSTOM RESET
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:118 sofia/external/test1@sip.example.com Standard RESET
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:531 (sofia/external/test1@sip.example.com) State RESET going to sleep
2014-07-31 15:48:02.324898 [DEBUG] switch_ivr_play_say.c:1714 done playing file local_stream://moh
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3603 got event CHANNEL_EXECUTE_COMPLETE
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3608 adhearsion@127.0.0.1/ rayo event CHANNEL_EXECUTE_COMPLETE
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3610 Locate (jid) adhearsion@127.0.0.1: ref count = 2
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3545 Locate (id) DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1: ref count = 2
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3548 Application playback execute complete: PLAYBACK ERROR
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3551 Release DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1: ref count = 1
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3618 Release adhearsion@127.0.0.1: ref count = 1
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:907 Send signal sofia/external/0000000000@000.000.000.000 [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] switch_ivr_bridge.c:395 Send signal sofia/external/test@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] switch_core_codec.c:246 sofia/external/test@sip.example.com Restore previous codec PCMU:0.
2014-07-31 15:48:02.324898 [NOTICE] switch_ivr_originate.c:1126 Hangup sofia/external/test1@sip.example.com [CS_RESET] [DESTINATION_OUT_OF_ORDER]
2014-07-31 15:48:02.324898 [DEBUG] switch_channel.c:3221 Send signal sofia/external/test1@sip.example.com [KILL]
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/test1@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [NOTICE] switch_ivr_bridge.c:904 Hangup sofia/external/test@sip.example.com [CS_PARK] [ORIGINATOR_CANCEL]
2014-07-31 15:48:02.324898 [DEBUG] switch_channel.c:3221 Send signal sofia/external/test@sip.example.com [KILL]
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/test@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:541 (sofia/external/test@sip.example.com) State SOFT_EXECUTE going to sleep
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:472 (sofia/external/test@sip.example.com) Running State Change CS_HANGUP
2014-07-31 15:48:02.324898 [DEBUG] rayo_components.c:117 Release 806adaca-82ff692f---192.168.87.100@127.0.0.1/output-1: ref count = 0
2014-07-31 15:48:02.324898 [DEBUG] rayo_components.c:118 Destroy 806adaca-82ff692f---192.168.87.100@127.0.0.1/output-1 requested: ref_count = 0
2014-07-31 15:48:02.324898 [DEBUG] rayo_components.c:118 Destroying 806adaca-82ff692f---192.168.87.100@127.0.0.1/output-1
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:956 Release 806adaca-82ff692f---192.168.87.100@127.0.0.1: ref count = 1
2014-07-31 15:48:02.324898 [DEBUG] switch_core_media_bug.c:780 Removing BUG from sofia/external/test@sip.example.com
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:735 (sofia/external/test@sip.example.com) Callstate Change EARLY -> HANGUP
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:737 (sofia/external/test@sip.example.com) State HANGUP
2014-07-31 15:48:02.324898 [DEBUG] mod_sofia.c:413 Channel sofia/external/test@sip.example.com hanging up, cause: ORIGINATOR_CANCEL
2014-07-31 15:48:02.324898 [DEBUG] mod_sofia.c:547 Responding to INVITE with: 487
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:60 sofia/external/test@sip.example.com Standard HANGUP, cause: ORIGINATOR_CANCEL
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:737 (sofia/external/test@sip.example.com) State HANGUP going to sleep
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:504 (sofia/external/test@sip.example.com) State Change CS_HANGUP -> CS_REPORTING
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/test@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:472 (sofia/external/test@sip.example.com) Running State Change CS_REPORTING
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:823 (sofia/external/test@sip.example.com) State REPORTING
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:104 sofia/external/test@sip.example.com Standard REPORTING, cause: ORIGINATOR_CANCEL
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:823 (sofia/external/wGMpNobozrm4dOJm@sip.example.com) State REPORTING going to sleep
2014-07-31 15:48:02.324898 [DEBUG] rayo_cpa_component.c:130 Subscriber execute hangup
2014-07-31 15:48:02.324898 [DEBUG] rayo_cpa_component.c:143 No subscribers for hangup
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:498 (sofia/external/wGMpNobozrm4dOJm@sip.example.com) State Change CS_REPORTING -> CS_DESTROY
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/wGMpNobozrm4dOJm@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1614 Session 257 (sofia/external/wGMpNobozrm4dOJm@sip.example.com) Locked, Waiting on external entities
2014-07-31 15:48:02.324898 [NOTICE] switch_core_session.c:1632 Session 257 (sofia/external/wGMpNobozrm4dOJm@sip.example.com) Ended
2014-07-31 15:48:02.324898 [NOTICE] switch_core_session.c:1636 Close Channel sofia/external/wGMpNobozrm4dOJm@sip.example.com [CS_DESTROY]
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3355 Locate (id) 806adaca-82ff692f---192.168.87.100@127.0.0.1: ref count = 2
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3365 Got channel destroy event
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3370 Destroy 806adaca-82ff692f---192.168.87.100@127.0.0.1 requested: ref_count = 2
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3371 Release 806adaca-82ff692f---192.168.87.100@127.0.0.1: ref count = 1
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3374 Release 806adaca-82ff692f---192.168.87.100@127.0.0.1: ref count = 0
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3374 Destroying 806adaca-82ff692f---192.168.87.100@127.0.0.1
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:1107 Sending <end> to offered client adhearsion@127.0.0.1
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:626 (sofia/external/test@sip.example.com) Running State Change CS_DESTROY
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:636 (sofia/external/test@sip.example.com) State DESTROY
2014-07-31 15:48:02.324898 [DEBUG] mod_sofia.c:323 sofia/external/test@sip.example.com SOFIA DESTROY
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:111 sofia/external/test@sip.example.com Standard DESTROY
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:636 (sofia/external/test@sip.example.com) State DESTROY going to sleep
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:472 (sofia/external/test1@sip.example.com) Running State Change CS_HANGUP
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:735 (sofia/external/test1@sip.example.com) Callstate Change RINGING -> HANGUP
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:737 (sofia/external/test1@sip.example.com) State HANGUP
2014-07-31 15:48:02.324898 [DEBUG] mod_sofia.c:413 Channel sofia/external/test1@sip.example.com hanging up, cause: DESTINATION_OUT_OF_ORDER
2014-07-31 15:48:02.324898 [DEBUG] mod_sofia.c:475 Sending CANCEL to sofia/external/test1@sip.example.com
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:60 sofia/external/test1@sip.example.com Standard HANGUP, cause: DESTINATION_OUT_OF_ORDER
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:737 (sofia/external/test1@sip.example.com) State HANGUP going to sleep
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:504 (sofia/external/test1@sip.example.com) State Change CS_HANGUP -> CS_REPORTING
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/test1@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:472 (sofia/external/test1@sip.example.com) Running State Change CS_REPORTING
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:823 (sofia/external/test1@sip.example.com) State REPORTING
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:104 sofia/external/test1@sip.example.com Standard REPORTING, cause: DESTINATION_OUT_OF_ORDER
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:823 (sofia/external/test1@sip.example.com) State REPORTING going to sleep
2014-07-31 15:48:02.324898 [DEBUG] rayo_cpa_component.c:130 Subscriber execute hangup
2014-07-31 15:48:02.324898 [DEBUG] rayo_cpa_component.c:143 No subscribers for hangup
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:498 (sofia/external/test1@sip.example.com) State Change CS_REPORTING -> CS_DESTROY
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/test1@sip.example.com [BREAK]
2014-07-31 15:48:02.324898 [DEBUG] switch_core_session.c:1614 Session 258 (sofia/external/test1@sip.example.com) Locked, Waiting on external entities
2014-07-31 15:48:02.324898 [NOTICE] switch_core_session.c:1632 Session 258 (sofia/external/test1@sip.example.com) Ended
2014-07-31 15:48:02.324898 [NOTICE] switch_core_session.c:1636 Close Channel sofia/external/test1@sip.example.com [CS_DESTROY]
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3355 Locate (id) 05969673-6585-4a83-ad27-a3ceab777233@127.0.0.1: ref count = 2
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3365 Got channel destroy event
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3370 Destroy 05969673-6585-4a83-ad27-a3ceab777233@127.0.0.1 requested: ref_count = 2
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3371 Release 05969673-6585-4a83-ad27-a3ceab777233@127.0.0.1: ref count = 1
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3374 Release 05969673-6585-4a83-ad27-a3ceab777233@127.0.0.1: ref count = 0
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:3374 Destroying 05969673-6585-4a83-ad27-a3ceab777233@127.0.0.1
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:1114 Sending <end> to DCP adhearsion@127.0.0.1
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:626 (sofia/external/test1@sip.example.com) Running State Change CS_DESTROY
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:636 (sofia/external/test1@sip.example.com) State DESTROY
2014-07-31 15:48:02.324898 [DEBUG] mod_sofia.c:323 sofia/external/test1@sip.example.com SOFIA DESTROY
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:111 sofia/external/test1@sip.example.com Standard DESTROY
2014-07-31 15:48:02.324898 [DEBUG] switch_core_state_machine.c:636 (sofia/external/test1@sip.example.com) State DESTROY going to sleep
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:772 Locate (jid) adhearsion@127.0.0.1 : ref count = 2
2014-07-31 15:48:02.324898 [DEBUG] rayo_components.c:116 Deliver 806adaca-82ff692f---192.168.87.100@127.0.0.1/output-1 => adhearsion@127.0.0.1 <presence from='806adaca-82ff692f---192.168.87.100@127.0.0.1/output-1' to='adhearsion@127.0.0.1' type='unavailable'><complete xmlns='urn:xmpp:rayo:ext:1'><hangup xmlns='urn:xmpp:rayo:ext:complete:1'/></complete><delay xmlns='urn:xmpp:delay' stamp='2014-07-31T15:48:02Z'/></presence>
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:779 Release adhearsion@127.0.0.1: ref count = 1
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:772 Locate (jid) adhearsion@127.0.0.1: ref count = 2
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:1108 Deliver 806adaca-82ff692f---192.168.87.100@127.0.0.1 => adhearsion@127.0.0.1 <presence from='806adaca-82ff692f---192.168.87.100@127.0.0.1' to='adhearsion@127.0.0.1' type='unavailable'><end xmlns='urn:xmpp:rayo:1'><hungup platform-code='16'/><header name='X-AUTH-IP' value='62.38.38.20'/><header name='X-DIAL' value='{sip_contact_user=ansr}sofia/external/'/></end><delay xmlns='urn:xmpp:delay' stamp='2014-07-31T15:48:02Z'/></presence>
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:779 Release adhearsion@127.0.0.1: ref count = 1
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:772 Locate (jid) adhearsion@127.0.0.1: ref count = 2
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:1160 Deliver 806adaca-82ff692f---192.168.87.100@127.0.0.1 => adhearsion@127.0.0.1<iq type='error' to='adhearsion@127.0.0.1' id='1fff5808-38f7-4a51-b803-3ecfd946e19d' from='806adaca-82ff692f---192.168.87.100@127.0.0.1'><join xmlns='urn:xmpp:rayo:1' call-uri='xmpp:05969673-6585-4a83-ad27-a3ceab777233@127.0.0.1' direction='duplex' media='bridge' mixer-name=''/><error type='cancel'><item-not-found xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/><text xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>call ended</text></error></iq>
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:779 Release adhearsion@127.0.0.1: ref count = 1
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:772 Locate (jid) adhearsion@127.0.0.1: ref count = 2
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:1116 Deliver 05969673-6585-4a83-ad27-a3ceab777233@127.0.0.1 => adhearsion@127.0.0.1 <presence from='05969673-6585-4a83-ad27-a3ceab777233@127.0.0.1' to='adhearsion@127.0.0.1' type='unavailable'><end xmlns='urn:xmpp:rayo:1'><error platform-code='27'/></end><delay xmlns='urn:xmpp:delay' stamp='2014-07-31T15:48:02Z'/></presence>
2014-07-31 15:48:02.324898 [DEBUG] mod_rayo.c:779 Release adhearsion@127.0.0.1: ref count = 1
2014-07-31 15:48:02.344914 [DEBUG] switch_ivr_bridge.c:660 BRIDGE THREAD DONE [sofia/external/test@sip.example.com]
2014-07-31 15:48:02.344914 [DEBUG] switch_channel.c:1960 (sofia/external/test@sipdev.theansr.com) Callstate Change HELD -> UNHELD
2014-07-31 15:48:02.344914 [DEBUG] switch_ivr_bridge.c:690 Send signal sofia/external/6957839215@217.195.128.193 [BREAK]
2014-07-31 15:48:02.344914 [NOTICE] switch_ivr_bridge.c:754 Hangup sofia/external/test@sipdev.theansr.com [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING]
2014-07-31 15:48:02.344914 [DEBUG] switch_channel.c:3221 Send signal sofia/external/test@sip.example.com [KILL]
2014-07-31 15:48:02.344914 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/test@sip.example.com [BREAK]
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:538 (sofia/external/test@sip.example.com) State EXCHANGE_MEDIA going to sleep
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:472 (sofia/external/test@sip.example.com) Running State Change CS_HANGUP
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:735 (sofia/external/test@sip.example.com) Callstate Change UNHELD -> HANGUP
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:737 (sofia/external/test@sip.example.com) State HANGUP
2014-07-31 15:48:02.344914 [DEBUG] mod_sofia.c:413 Channel sofia/external/test@sip.example.com hanging up, cause: NORMAL_CLEARING
2014-07-31 15:48:02.344914 [DEBUG] mod_sofia.c:465 Sending BYE to sofia/external/test@sip.example.com
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:60 sofia/external/test@sip.example.com Standard HANGUP, cause: NORMAL_CLEARING
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:737 (sofia/external/test@sip.example.com) State HANGUP going to sleep
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:504 (sofia/external/test@sip.example.com) State Change CS_HANGUP -> CS_REPORTING
2014-07-31 15:48:02.344914 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/test@sip.example.com [BREAK]
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:472 (sofia/external/test@sip.example.com) Running State Change CS_REPORTING
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:823 (sofia/external/test@sip.example.com) State REPORTING
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:104 sofia/external/test@sip.example.com Standard REPORTING, cause: NORMAL_CLEARING
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:823 (sofia/external/test@sip.example.com) State REPORTING going to sleep
2014-07-31 15:48:02.344914 [DEBUG] rayo_cpa_component.c:130 Subscriber execute hangup
2014-07-31 15:48:02.344914 [DEBUG] rayo_cpa_component.c:143 No subscribers for hangup
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:498 (sofia/external/test@sip.example.com) State Change CS_REPORTING -> CS_DESTROY
2014-07-31 15:48:02.344914 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/test@sip.example.com [BREAK]
2014-07-31 15:48:02.344914 [DEBUG] switch_core_session.c:1614 Session 256 (sofia/external/test@sip.example.com) Locked, Waiting on external entities
2014-07-31 15:48:02.344914 [DEBUG] xmpp_streams.c:190 adhearsion@127.0.0.1, 127.0.0.1:47945, c2s_in SEND <presence from='806adaca-82ff692f---192.168.87.100@127.0.0.1/output-1' to='adhearsion@127.0.0.1' type='unavailable'><complete xmlns='urn:xmpp:rayo:ext:1'><hangup xmlns='urn:xmpp:rayo:ext:complete:1'/></complete><delay xmlns='urn:xmpp:delay' stamp='2014-07-31T15:48:02Z'/></presence>
2014-07-31 15:48:02.344914 [DEBUG] xmpp_streams.c:190 adhearsion@127.0.0.1, 127.0.0.1:47945, c2s_in SEND <presence from='806adaca-82ff692f---192.168.87.100@127.0.0.1' to='adhearsion@127.0.0.1' type='unavailable'><end xmlns='urn:xmpp:rayo:1'><hungup platform-code='16'/><header name='X-AUTH-IP' value='62.38.38.20'/><header name='X-DIAL' value='{sip_contact_user=ansr}sofia/external/'/></end><delay xmlns='urn:xmpp:delay' stamp='2014-07-31T15:48:02Z'/></presence>
2014-07-31 15:48:02.344914 [DEBUG] xmpp_streams.c:190 adhearsion@127.0.0.1, 127.0.0.1:47945, c2s_in SEND <iq type='error' to='adhearsion@127.0.0.1' id='1fff5808-38f7-4a51-b803-3ecfd946e19d' from='806adaca-82ff692f---192.168.87.100@127.0.0.1'><join xmlns='urn:xmpp:rayo:1' call-uri='xmpp:05969673-6585-4a83-ad27-a3ceab777233@127.0.0.1' direction='duplex' media='bridge' mixer-name=''/><error type='cancel'><item-not-found xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'/><text xml:lang='en' xmlns='urn:ietf:params:xml:ns:xmpp-stanzas'>call ended</text></error></iq>
2014-07-31 15:48:02.344914 [DEBUG] xmpp_streams.c:190 adhearsion@127.0.0.1, 127.0.0.1:47945, c2s_in SEND <presence from='05969673-6585-4a83-ad27-a3ceab777233@127.0.0.1' to='adhearsion@127.0.0.1' type='unavailable'><end xmlns='urn:xmpp:rayo:1'><error platform-code='27'/></end><delay xmlns='urn:xmpp:delay' stamp='2014-07-31T15:48:02Z'/></presence>
2014-07-31 15:48:02.344914 [DEBUG] switch_ivr_bridge.c:660 BRIDGE THREAD DONE [sofia/external/0000000000@000.000.000.000]
2014-07-31 15:48:02.344914 [DEBUG] switch_ivr_bridge.c:690 Send signal sofia/external/test@sip.example.com [BREAK]
2014-07-31 15:48:02.344914 [DEBUG] switch_core_session.c:907 Send signal sofia/external/0000000000@000.000.000.000 [BREAK]
2014-07-31 15:48:02.344914 [DEBUG] switch_ivr_bridge.c:1621 (sofia/external/0000000000@000.000.000.000) State Change CS_HIBERNATE -> CS_RESET
2014-07-31 15:48:02.344914 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/0000000000@000.000.000.000 [BREAK]
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:541 (sofia/external/0000000000@000.000.000.000) State SOFT_EXECUTE going to sleep
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:472 (sofia/external/0000000000@000.000.000.000) Running State Change CS_RESET
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:531 (sofia/external/0000000000@000.000.000.000) State RESET
2014-07-31 15:48:02.344914 [DEBUG] mod_sofia.c:141 sofia/external/0000000000@000.000.000.000 SOFIA RESET
2014-07-31 15:48:02.344914 [DEBUG] switch_ivr_bridge.c:820 sofia/external/0000000000@000.000.000.000 CUSTOM RESET
2014-07-31 15:48:02.344914 [DEBUG] switch_ivr_bridge.c:827 (sofia/external/0000000000@000.000.000.000) State Change CS_RESET -> CS_SOFT_EXECUTE
2014-07-31 15:48:02.344914 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/0000000000@000.000.000.000 [BREAK]
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:531 (sofia/external/0000000000@000.000.000.000) State RESET going to sleep
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:472 (sofia/external/0000000000@000.000.000.000) Running State Change CS_SOFT_EXECUTE
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:541 (sofia/external/0000000000@000.000.000.000) State SOFT_EXECUTE
2014-07-31 15:48:02.344914 [DEBUG] mod_sofia.c:598 SOFIA SOFT_EXECUTE
2014-07-31 15:48:02.344914 [DEBUG] switch_ivr_bridge.c:845 sofia/external/0000000000@000.000.000.000 CUSTOM SOFT_EXECUTE
2014-07-31 15:48:02.344914 [NOTICE] switch_ivr_bridge.c:951 Hangup sofia/external/0000000000@000.000.000.000 [CS_SOFT_EXECUTE] [DESTINATION_OUT_OF_ORDER]
2014-07-31 15:48:02.344914 [DEBUG] switch_channel.c:3221 Send signal sofia/external/0000000000@000.000.000.000 [KILL]
2014-07-31 15:48:02.344914 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/0000000000@000.000.000.000 [BREAK]
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:541 (sofia/external/0000000000@000.000.000.000) State SOFT_EXECUTE going to sleep
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:472 (sofia/external/0000000000@000.000.000.000) Running State Change CS_HANGUP
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:735 (sofia/external/0000000000@000.000.000.000) Callstate Change ACTIVE -> HANGUP
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:737 (sofia/external/0000000000@000.000.000.000) State HANGUP
2014-07-31 15:48:02.344914 [DEBUG] mod_sofia.c:413 Channel sofia/external/0000000000@000.000.000.000 hanging up, cause: DESTINATION_OUT_OF_ORDER
2014-07-31 15:48:02.344914 [DEBUG] mod_sofia.c:465 Sending BYE to sofia/external/0000000000@000.000.000.000
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:60 sofia/external/0000000000@000.000.000.000 Standard HANGUP, cause: DESTINATION_OUT_OF_ORDER
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:737 (sofia/external/0000000000@000.000.000.000) State HANGUP going to sleep
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:504 (sofia/external/0000000000@000.000.000.000) State Change CS_HANGUP -> CS_REPORTING
2014-07-31 15:48:02.344914 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/0000000000@000.000.000.000 [BREAK]
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:472 (sofia/external/0000000000@000.000.000.000) Running State Change CS_REPORTING
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:823 (sofia/external/0000000000@000.000.000.000) State REPORTING
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:104 sofia/external/0000000000@000.000.000.000 Standard REPORTING, cause: DESTINATION_OUT_OF_ORDER
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:823 (sofia/external/0000000000@000.000.000.000) State REPORTING going to sleep
2014-07-31 15:48:02.344914 [DEBUG] rayo_cpa_component.c:130 Subscriber execute hangup
2014-07-31 15:48:02.344914 [DEBUG] rayo_cpa_component.c:143 No subscribers for hangup
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:498 (sofia/external/0000000000@000.000.000.000) State Change CS_REPORTING -> CS_DESTROY
2014-07-31 15:48:02.344914 [DEBUG] switch_core_session.c:1387 Send signal sofia/external/0000000000@000.000.000.000 [BREAK]
2014-07-31 15:48:02.344914 [DEBUG] switch_core_session.c:1614 Session 255 (sofia/external/0000000000@000.000.000.000) Locked, Waiting on external entities
2014-07-31 15:48:02.344914 [NOTICE] switch_core_session.c:1632 Session 255 (sofia/external/0000000000@000.000.000.000) Ended
2014-07-31 15:48:02.344914 [NOTICE] switch_core_session.c:1636 Close Channel sofia/external/0000000000@000.000.000.000 [CS_DESTROY]
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3355 Locate (id) DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1: ref count = 2
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3365 Got channel destroy event
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3370 Destroy DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1 requested: ref_count = 2
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3371 Release DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1: ref count = 1
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3374 Release DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1: ref count = 0
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3374 Destroying DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:1107 Sending <end> to offered client adhearsion@127.0.0.1
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:626 (sofia/external/0000000000@000.000.000.000) Running State Change CS_DESTROY
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:636 (sofia/external/0000000000@000.000.000.000) State DESTROY
2014-07-31 15:48:02.344914 [DEBUG] mod_sofia.c:323 sofia/external/0000000000@000.000.000.000 SOFIA DESTROY
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:111 sofia/external/0000000000@000.000.000.000 Standard DESTROY
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:636 (sofia/external/0000000000@000.000.000.000) State DESTROY going to sleep
2014-07-31 15:48:02.344914 [NOTICE] switch_core_session.c:1632 Session 256 (sofia/external/test@sip.example.com) Ended
2014-07-31 15:48:02.344914 [NOTICE] switch_core_session.c:1636 Close Channel sofia/external/test@sip.example.com [CS_DESTROY]
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3355 Locate (id) 7fa89668-8ca9-4848-b58b-35322dee714b@127.0.0.1: ref count = 2
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3365 Got channel destroy event
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3370 Destroy 7fa89668-8ca9-4848-b58b-35322dee714b@127.0.0.1 requested: ref_count = 2
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3371 Release 7fa89668-8ca9-4848-b58b-35322dee714b@127.0.0.1: ref count = 1
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3374 Release 7fa89668-8ca9-4848-b58b-35322dee714b@127.0.0.1: ref count = 0
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:3374 Destroying 7fa89668-8ca9-4848-b58b-35322dee714b@127.0.0.1
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:1114 Sending <end> to DCP adhearsion@127.0.0.1/ip-172-31-2-101.eu-west-1.compute.internal-4535
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:626 (sofia/external/test@sip.example.com) Running State Change CS_DESTROY
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:636 (sofia/external/test@sip.example.com) State DESTROY
2014-07-31 15:48:02.344914 [DEBUG] mod_sofia.c:323 sofia/external/test@sip.example.com SOFIA DESTROY
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:111 sofia/external/test@sip.example.com Standard DESTROY
2014-07-31 15:48:02.344914 [DEBUG] switch_core_state_machine.c:636 (sofia/external/test@sip.example.com) State DESTROY going to sleep
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:772 Locate (jid) adhearsion@127.0.0.1: ref count = 2
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:1143 Deliver DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1 => adhearsion@127.0.0.1 <presence from='DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1' to='adhearsion@127.0.0.1'><unjoined xmlns='urn:xmpp:rayo:1' call-uri='xmpp:7fa89668-8ca9-4848-b58b-35322dee714b@127.0.0.1'/><delay xmlns='urn:xmpp:delay' stamp='2014-07-31T15:48:02Z'/></presence>
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:779 Release adhearsion@127.0.0.1: ref count = 1
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:772 Locate (jid) adhearsion@127.0.0.1: ref count = 2
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:1108 Deliver DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1 => adhearsion@127.0.0.1 <presence from='DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1' to='adhearsion@127.0.0.1' type='unavailable'><end xmlns='urn:xmpp:rayo:1'><error platform-code='27'/><header name='X-AUTH-IP' value='217.195.128.193'/><header name='X-CARRIER-IN' value='Voice-Net'/><header name='X-DIAL' value='{sip_contact_user=ansr}sofia/external/'/></end><delay xmlns='urn:xmpp:delay' stamp='2014-07-31T15:48:02Z'/></presence>
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:779 Release adhearsion@127.0.0.1: ref count = 1
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:772 Locate (jid) adhearsion@127.0.0.1: ref count = 2
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:1143 Deliver 7fa89668-8ca9-4848-b58b-35322dee714b@127.0.0.1 => adhearsion@127.0.0.1 <presence from='7fa89668-8ca9-4848-b58b-35322dee714b@127.0.0.1' to='adhearsion@127.0.0.1'><unjoined xmlns='urn:xmpp:rayo:1' call-uri='xmpp:DD948089-180011E4-A9899BDB-BA8EA274---000.000.000.000@127.0.0.1'/><delay xmlns='urn:xmpp:delay' stamp='2014-07-31T15:48:02Z'/></presence>
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:779 Release adhearsion@127.0.0.1: ref count = 1
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:772 Locate (jid) adhearsion@127.0.0.1: ref count = 2
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:1116 Deliver 7fa89668-8ca9-4848-b58b-35322dee714b@127.0.0.1 => adhearsion@127.0.0.1 <presence from='7fa89668-8ca9-4848-b58b-35322dee714b@127.0.0.1' to='adhearsion@127.0.0.1' type='unavailable'><end xmlns='urn:xmpp:rayo:1'><hungup platform-code='16'/></end><delay xmlns='urn:xmpp:delay' stamp='2014-07-31T15:48:02Z'/></presence>
2014-07-31 15:48:02.344914 [DEBUG] mod_rayo.c:779 Release adhearsion@127.0.0.1: ref count = 1
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment