[Dec 19 23:55:34] NOTICE[95040] res_pjsip/pjsip_distributor.c: Request 'INVITE' from '"5555" <sip:5555@206.126.62.165>' failed for '108.170.60.38:5070' (callid: 37cbfb0a351792e6634ed9dbdabe4ae5) - No matching endpoint found
[Dec 19 23:56:03] NOTICE[95040] res_pjsip/pjsip_distributor.c: Request 'INVITE' from '"2020" <sip:2020@206.126.62.165>' failed for '209.239.122.204:5071' (callid: 7ed1471e4ead98e6fc69824df71d1dbd) - No matching endpoint found
[Dec 19 23:56:05] NOTICE[95040] res_pjsip/pjsip_distributor.c: Request 'INVITE' from '"5555" <sip:5555@206.126.62.165>' failed for '108.170.60.38:5073' (callid: 8ae2f37a696773c88f698db1f1b7c63c) - No matching endpoint found
[Dec 19 23:56:20] VERBOSE[95019] asterisk.c: Remote UNIX connection
[Dec 19 23:56:25] DEBUG[95096] manager.c: Examining AMI event:
Event: RequestBadFormat
Privilege: security,all
EventTV: 2016-12-19T23:56:25.865+0000
Severity: Error
Service: AMI
EventVersion: 1
SessionID: 0x7fe70c000b00
LocalAddress: IPV4/TCP/127.0.0.1/5038
RemoteAddress: IPV4/TCP/127.0.0.1/53388
RequestType: Action: SIPpeerstatus
SessionTV: 2016-12-19T23:31:59.501+0000
AccountID: admin


[Dec 19 23:56:27] DEBUG[95040] pjproject: 	      endpoint Request msg OPTIONS/cseq=56791 (tdta0x7fe704008930) created.
[Dec 19 23:56:27] DEBUG[95040] config.c: extract uint from [3] in [0, 4294967295] gives [3](0)
[Dec 19 23:56:27] DEBUG[95040] config.c: extract uint from [0] in [0, 4294967295] gives [0](0)
[Dec 19 23:56:27] DEBUG[95040] config.c: extract uint from [2] in [0, 4294967295] gives [2](0)
[Dec 19 23:56:27] DEBUG[95040] res_pjsip.c: 0x7fe77800d870: Wrapper created
[Dec 19 23:56:27] DEBUG[95040] res_pjsip.c: 0x7fe77800d870: Set timer to 20000 msec
[Dec 19 23:56:27] DEBUG[95040] pjproject: 	tsx0x7fe778039 .Transaction created for Request msg OPTIONS/cseq=56791 (tdta0x7fe704008930)
[Dec 19 23:56:27] DEBUG[95040] pjproject: 	tsx0x7fe778039 Sending Request msg OPTIONS/cseq=56791 (tdta0x7fe704008930) in state Null
[Dec 19 23:56:27] DEBUG[95040] pjproject: 	 sip_resolve.c .Target '72.190.32.250:27249' type=Unspecified resolved to '72.190.32.250:27249' type=UDP (UDP transport)
[Dec 19 23:56:27] DEBUG[95040] res_pjsip/pjsip_message_ip_updater.c: Re-wrote Contact URI host/port to 206.126.62.165:5060
[Dec 19 23:56:27] DEBUG[95040] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:27] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:27] DEBUG[95040] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:27] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:27] DEBUG[95040] pjproject: 	tsx0x7fe778039 .State changed from Null to Calling, event=TX_MSG
[Dec 19 23:56:27] DEBUG[95039] pjproject: 	sip_endpoint.c Processing incoming message: Response msg 200/OPTIONS/cseq=56791 (rdata0x7fe704001948)
[Dec 19 23:56:27] DEBUG[95039] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:27] DEBUG[95039] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:27] DEBUG[95039] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:27] DEBUG[95039] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:27] DEBUG[95039] res_pjsip/pjsip_distributor.c: No dialog serializer for response Response msg 200/OPTIONS/cseq=56791 (rdata0x7fe704001948). Using request transaction as basis
[Dec 19 23:56:27] DEBUG[95039] res_pjsip/pjsip_distributor.c: Found serializer pjsip/default-0000000e on transaction tsx0x7fe7780392d8
[Dec 19 23:56:27] DEBUG[95040] pjproject: 	sip_endpoint.c Distributing rdata to modules: Response msg 200/OPTIONS/cseq=56791 (rdata0x7fe70400a128)
[Dec 19 23:56:27] DEBUG[95040] pjproject: 	tsx0x7fe778039 .Incoming Response msg 200/OPTIONS/cseq=56791 (rdata0x7fe70400a128) in state Calling
[Dec 19 23:56:27] DEBUG[95040] pjproject: 	tsx0x7fe778039 ..State changed from Calling to Completed, event=RX_MSG
[Dec 19 23:56:27] DEBUG[95040] res_pjsip.c: 0x7fe77800d870: PJSIP tsx response received
[Dec 19 23:56:27] DEBUG[95040] res_pjsip.c: 0x7fe77800d870: Cancelling timer
[Dec 19 23:56:27] DEBUG[95040] res_pjsip.c: 0x7fe77800d870: Timer cancelled
[Dec 19 23:56:27] DEBUG[95040] config.c: extract uint from [3] in [0, 4294967295] gives [3](0)
[Dec 19 23:56:27] DEBUG[95040] config.c: extract uint from [0] in [0, 4294967295] gives [0](0)
[Dec 19 23:56:27] DEBUG[95040] config.c: extract uint from [2] in [0, 4294967295] gives [2](0)
[Dec 19 23:56:27] DEBUG[95040] res_pjsip.c: 0x7fe77800d870: Callbacks executed
[Dec 19 23:56:27] DEBUG[95040] res_pjsip.c: 0x7fe77800d870: wrapper destroyed
[Dec 19 23:56:27] DEBUG[95045] res_pjsip/pjsip_configuration.c: Contact 100/sip:100@72.190.32.250:27249 status didn't change: Reachable, RTT: 16.541 msec
[Dec 19 23:56:28] DEBUG[95701] threadpool.c: Worker thread idle timeout reached. Dying.
[Dec 19 23:56:28] DEBUG[95702] threadpool.c: Worker thread idle timeout reached. Dying.
[Dec 19 23:56:28] DEBUG[95700] threadpool.c: Worker thread idle timeout reached. Dying.
[Dec 19 23:56:28] DEBUG[95703] threadpool.c: Worker thread idle timeout reached. Dying.
[Dec 19 23:56:28] DEBUG[95037] threadpool.c: Destroying worker thread 86
[Dec 19 23:56:28] DEBUG[95698] threadpool.c: Worker thread idle timeout reached. Dying.
[Dec 19 23:56:28] DEBUG[95037] threadpool.c: Destroying worker thread 87
[Dec 19 23:56:28] DEBUG[95037] threadpool.c: Destroying worker thread 85
[Dec 19 23:56:28] DEBUG[95037] threadpool.c: Destroying worker thread 88
[Dec 19 23:56:28] DEBUG[95014] threadpool.c: Destroying worker thread 82
[Dec 19 23:56:28] DEBUG[95699] threadpool.c: Worker thread idle timeout reached. Dying.
[Dec 19 23:56:28] DEBUG[95037] threadpool.c: Destroying worker thread 84
[Dec 19 23:56:29] Asterisk 13.13.1 built by root @ testbed3.primevox.net on a x86_64 running Linux on 2016-12-19 23:27:59 UTC
[Dec 19 23:56:29] DEBUG[95829] config.c: Parsing /etc/asterisk/logger.conf
[Dec 19 23:56:29] VERBOSE[95829] config.c: Parsing '/etc/asterisk/logger.conf': Found
[Dec 19 23:56:30] DEBUG[95040] pjproject: 	      endpoint Request msg OPTIONS/cseq=11026 (tdta0x7fe7040059d0) created.
[Dec 19 23:56:30] DEBUG[95040] config.c: extract uint from [3] in [0, 4294967295] gives [3](0)
[Dec 19 23:56:30] DEBUG[95040] config.c: extract uint from [0] in [0, 4294967295] gives [0](0)
[Dec 19 23:56:30] DEBUG[95040] config.c: extract uint from [2] in [0, 4294967295] gives [2](0)
[Dec 19 23:56:30] DEBUG[95040] res_pjsip.c: 0x7fe77804b000: Wrapper created
[Dec 19 23:56:30] DEBUG[95040] res_pjsip.c: 0x7fe77804b000: Set timer to 20000 msec
[Dec 19 23:56:30] DEBUG[95040] pjproject: 	tsx0x7fe778031 .Transaction created for Request msg OPTIONS/cseq=11026 (tdta0x7fe7040059d0)
[Dec 19 23:56:30] DEBUG[95040] pjproject: 	tsx0x7fe778031 Sending Request msg OPTIONS/cseq=11026 (tdta0x7fe7040059d0) in state Null
[Dec 19 23:56:30] DEBUG[95040] pjproject: 	 sip_resolve.c .Target '72.190.32.250:33403' type=Unspecified resolved to '72.190.32.250:33403' type=UDP (UDP transport)
[Dec 19 23:56:30] DEBUG[95040] res_pjsip/pjsip_message_ip_updater.c: Re-wrote Contact URI host/port to 206.126.62.165:5060
[Dec 19 23:56:30] DEBUG[95040] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:30] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:30] DEBUG[95040] netsock2.c: Splitting '72.190.32.250:33403' into...
[Dec 19 23:56:30] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port '33403'.
[Dec 19 23:56:30] DEBUG[95040] pjproject: 	tsx0x7fe778031 .State changed from Null to Calling, event=TX_MSG
[Dec 19 23:56:30] DEBUG[95039] pjproject: 	sip_endpoint.c Processing incoming message: Response msg 200/OPTIONS/cseq=11026 (rdata0x7fe704001948)
[Dec 19 23:56:30] DEBUG[95039] netsock2.c: Splitting '72.190.32.250:33403' into...
[Dec 19 23:56:30] DEBUG[95039] netsock2.c: ...host '72.190.32.250' and port '33403'.
[Dec 19 23:56:30] DEBUG[95039] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:30] DEBUG[95039] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:30] DEBUG[95039] res_pjsip/pjsip_distributor.c: No dialog serializer for response Response msg 200/OPTIONS/cseq=11026 (rdata0x7fe704001948). Using request transaction as basis
[Dec 19 23:56:30] DEBUG[95039] res_pjsip/pjsip_distributor.c: Found serializer pjsip/default-0000000f on transaction tsx0x7fe778031c88
[Dec 19 23:56:30] DEBUG[95040] pjproject: 	sip_endpoint.c Distributing rdata to modules: Response msg 200/OPTIONS/cseq=11026 (rdata0x7fe704009968)
[Dec 19 23:56:30] DEBUG[95040] pjproject: 	tsx0x7fe778031 .Incoming Response msg 200/OPTIONS/cseq=11026 (rdata0x7fe704009968) in state Calling
[Dec 19 23:56:30] DEBUG[95040] pjproject: 	tsx0x7fe778031 ..State changed from Calling to Completed, event=RX_MSG
[Dec 19 23:56:30] DEBUG[95040] res_pjsip.c: 0x7fe77804b000: PJSIP tsx response received
[Dec 19 23:56:30] DEBUG[95040] res_pjsip.c: 0x7fe77804b000: Cancelling timer
[Dec 19 23:56:30] DEBUG[95040] res_pjsip.c: 0x7fe77804b000: Timer cancelled
[Dec 19 23:56:30] DEBUG[95040] config.c: extract uint from [3] in [0, 4294967295] gives [3](0)
[Dec 19 23:56:30] DEBUG[95040] config.c: extract uint from [0] in [0, 4294967295] gives [0](0)
[Dec 19 23:56:30] DEBUG[95040] config.c: extract uint from [2] in [0, 4294967295] gives [2](0)
[Dec 19 23:56:30] DEBUG[95040] res_pjsip.c: 0x7fe77804b000: Callbacks executed
[Dec 19 23:56:30] DEBUG[95040] res_pjsip.c: 0x7fe77804b000: wrapper destroyed
[Dec 19 23:56:30] DEBUG[95045] res_pjsip/pjsip_configuration.c: Contact 101/sip:101@72.190.32.250:33403 status didn't change: Reachable, RTT: 47.191 msec
[Dec 19 23:56:32] DEBUG[95039] pjproject: 	tsx0x7fe778039 Timeout timer event
[Dec 19 23:56:32] DEBUG[95039] pjproject: 	tsx0x7fe778039 .State changed from Completed to Terminated, event=TIMER
[Dec 19 23:56:32] DEBUG[95039] pjproject: 	tsx0x7fe778039 Timeout timer event
[Dec 19 23:56:32] DEBUG[95039] pjproject: 	tsx0x7fe778039 .State changed from Terminated to Destroyed, event=TIMER
[Dec 19 23:56:32] DEBUG[95039] pjproject: 	tdta0x7fe70400 ..Destroying txdata Request msg OPTIONS/cseq=56791 (tdta0x7fe704008930)
[Dec 19 23:56:32] DEBUG[95039] pjproject: 	tsx0x7fe778039 Transaction destroyed!
[Dec 19 23:56:33] DEBUG[95039] pjproject: 	sip_endpoint.c Processing incoming message: Request msg INVITE/cseq=450 (rdata0x7fe704001948)
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:33] DEBUG[95039] res_pjsip/pjsip_distributor.c: Could not find matching transaction for Request msg INVITE/cseq=450 (rdata0x7fe704001948)
[Dec 19 23:56:33] DEBUG[95039] res_pjsip/pjsip_distributor.c: Calculated serializer pjsip/distributor-0000002a to use for Request msg INVITE/cseq=450 (rdata0x7fe704001948)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	sip_endpoint.c Distributing rdata to modules: Request msg INVITE/cseq=450 (rdata0x7fe704009968)
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '72.190.32.250' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port ''.
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: Source address 72.190.32.250:27249 does not match identify 'flowroute'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: '72.190.32.250:27249' did not match any identify section rules
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_user.c: Attempting identify by From username '100' domain 'testbed3.primevox.net'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_user.c: Identified by From username '100' domain 'testbed3.primevox.net'
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	      endpoint .Response msg 401/INVITE/cseq=450 (tdta0x7fe778017b40) created
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '206.126.62.165' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port ''.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '72.190.32.250' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port ''.
[Dec 19 23:56:33] DEBUG[95096] manager.c: Examining AMI event:
Event: ChallengeSent
Privilege: security,all
EventTV: 2016-12-19T23:56:33.933+0000
Severity: Informational
Service: PJSIP
EventVersion: 1
AccountID: 100
SessionID: 53315327-27249-47@BJC.BGI.B.G
LocalAddress: IPV4/UDP/206.126.62.165/5060
RemoteAddress: IPV4/UDP/72.190.32.250/27249
Challenge: 


[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	tdta0x7fe77801 .Destroying txdata Response msg 401/INVITE/cseq=450 (tdta0x7fe778017b40)
[Dec 19 23:56:33] DEBUG[95039] pjproject: 	sip_endpoint.c Processing incoming message: Request msg ACK/cseq=450 (rdata0x7fe704001948)
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:33] DEBUG[95039] res_pjsip/pjsip_distributor.c: Could not find matching transaction for Request msg ACK/cseq=450 (rdata0x7fe704001948)
[Dec 19 23:56:33] DEBUG[95039] res_pjsip/pjsip_distributor.c: Calculated serializer pjsip/distributor-0000002a to use for Request msg ACK/cseq=450 (rdata0x7fe704001948)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	sip_endpoint.c Distributing rdata to modules: Request msg ACK/cseq=450 (rdata0x7fe704009968)
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '72.190.32.250' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port ''.
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: Source address 72.190.32.250:27249 does not match identify 'flowroute'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: '72.190.32.250:27249' did not match any identify section rules
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_user.c: Attempting identify by From username '100' domain 'testbed3.primevox.net'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_user.c: Identified by From username '100' domain 'testbed3.primevox.net'
[Dec 19 23:56:33] DEBUG[95039] pjproject: 	sip_endpoint.c Processing incoming message: Request msg INVITE/cseq=451 (rdata0x7fe704001948)
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:33] DEBUG[95039] res_pjsip/pjsip_distributor.c: Could not find matching transaction for Request msg INVITE/cseq=451 (rdata0x7fe704001948)
[Dec 19 23:56:33] DEBUG[95039] res_pjsip/pjsip_distributor.c: Calculated serializer pjsip/distributor-0000002a to use for Request msg INVITE/cseq=451 (rdata0x7fe704001948)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	sip_endpoint.c Distributing rdata to modules: Request msg INVITE/cseq=451 (rdata0x7fe704009968)
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '72.190.32.250' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port ''.
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: Source address 72.190.32.250:27249 does not match identify 'flowroute'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: '72.190.32.250:27249' did not match any identify section rules
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_user.c: Attempting identify by From username '100' domain 'testbed3.primevox.net'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_endpoint_identifier_user.c: Identified by From username '100' domain 'testbed3.primevox.net'
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	      endpoint .Response msg 401/INVITE/cseq=451 (tdta0x7fe778017b40) created
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_authenticator_digest.c: Calculated nonce 1482191793/6b7249a72bf11bb20cdb07afa0ac5d5c. Actual nonce is 1482191793/6b7249a72bf11bb20cdb07afa0ac5d5c
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '206.126.62.165' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port ''.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '72.190.32.250' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port ''.
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	tdta0x7fe77801 .Destroying txdata Response msg 401/INVITE/cseq=451 (tdta0x7fe778017b40)
[Dec 19 23:56:33] DEBUG[95096] manager.c: Examining AMI event:
Event: SuccessfulAuth
Privilege: security,all
EventTV: 2016-12-19T23:56:33.955+0000
Severity: Informational
Service: PJSIP
EventVersion: 1
AccountID: 100
SessionID: 53315327-27249-47@BJC.BGI.B.G
LocalAddress: IPV4/UDP/206.126.62.165/5060
RemoteAddress: IPV4/UDP/72.190.32.250/27249
UsingPassword: 1


[Dec 19 23:56:33] DEBUG[95040] pjproject: 	tsx0x7fe77804c ..Transaction created for Request msg INVITE/cseq=451 (rdata0x7fe704009968)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	tsx0x7fe77804c .Incoming Request msg INVITE/cseq=451 (rdata0x7fe704009968) in state Null
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	tsx0x7fe77804c ..State changed from Null to Trying, event=RX_MSG
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 ...Transaction tsx0x7fe77804c0b8 state changed to Trying
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 .UAS dialog created
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 .Module mod-invite added as dialog usage, data=0x7fe77801dd58
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 ..Session count inc to 2 by mod-invite
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	inv0x7fe778039 .UAS invite session created for dialog dlg0x7fe7780392d8
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 .Module Session Module added as dialog usage, data=(nil)
[Dec 19 23:56:33] DEBUG[95040] res_pjsip/pjsip_distributor.c: Calculated serializer pjsip/distributor-0000002a to use for Request msg INVITE/cseq=451 (rdata0x7fe704009968)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 ..Session count inc to 2 by Session Module
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Negotiating incoming SDP media stream 'audio' using audio SDP handler
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '192.168.1.6' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '192.168.1.6' and port ''.
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Using engine 'asterisk' for RTP instance '0x7fe77801b5d0'
[Dec 19 23:56:33] DEBUG[95040] res_rtp_asterisk.c: Allocated port 18654 for RTP instance '0x7fe77801b5d0'
[Dec 19 23:56:33] DEBUG[95040] res_rtp_asterisk.c: Creating ICE session [::]:18654 (18654) for RTP instance '0x7fe77801b5d0'
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	icess0x7fe7780 ICE session created, comp_cnt=2, role is Unknown agent
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting 'fe80::250:56ff:feb6:be4d' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host 'fe80::250:56ff:feb6:be4d' and port ''.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting 'fe80::250:56ff:feb6:be4d' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host 'fe80::250:56ff:feb6:be4d' and port ''.
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	icess0x7fe7780 Candidate 0 added: comp_id=1, type=host, foundation=H825991a4, addr=fe80::250:56ff:feb6:be4d:18654, base=fe80::250:56ff:feb6:be4d:18654, prio=0x7effffff (2130706431)
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '206.126.62.165' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port ''.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '206.126.62.165' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port ''.
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	icess0x7fe7780 Candidate 1 added: comp_id=1, type=host, foundation=Hce7e3ea5, addr=206.126.62.165:18654, base=206.126.62.165:18654, prio=0x7effffff (2130706431)
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: RTP instance '0x7fe77801b5d0' is setup and ready to go
[Dec 19 23:56:33] DEBUG[95040] acl.c: Not an IPv4 nor IPv6 address, cannot get port.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting 'testbed3.primevox.net' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host 'testbed3.primevox.net' and port ''.
[Dec 19 23:56:33] DEBUG[95040] res_rtp_asterisk.c: Setup RTCP on RTP instance '0x7fe77801b5d0'
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting 'fe80::250:56ff:feb6:be4d' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host 'fe80::250:56ff:feb6:be4d' and port ''.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting 'fe80::250:56ff:feb6:be4d' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host 'fe80::250:56ff:feb6:be4d' and port ''.
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	icess0x7fe7780 Candidate 2 added: comp_id=2, type=host, foundation=H825991a4, addr=fe80::250:56ff:feb6:be4d:18655, base=fe80::250:56ff:feb6:be4d:18655, prio=0x7efffffe (2130706430)
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '206.126.62.165' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port ''.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '206.126.62.165' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port ''.
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	icess0x7fe7780 Candidate 3 added: comp_id=2, type=host, foundation=Hce7e3ea5, addr=206.126.62.165:18655, base=206.126.62.165:18655, prio=0x7efffffe (2130706430)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	icess0x7fe7780 Destroying ICE session 0x7fe77803fd08
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	stuse0x7fe7780 STUN session 0x7fe778007f58 destroy request, ref_cnt=4
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	stuse0x7fe7780 STUN session 0x7fe778038648 destroy request, ref_cnt=3
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	 ice_session.c ICE session 0x7fe77803fd08 destroyed
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	stun_session.c STUN session 0x7fe778007f58 destroyed
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	stun_session.c STUN session 0x7fe778038648 destroyed
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Don't have a default tx payload type 125 format for m type on 0x7fe78c16d3d0
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Setting tx payload type 0 based on m type on 0x7fe78c16d3d0
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Setting tx payload type 97 based on m type on 0x7fe78c16d3d0
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Setting tx payload type 18 based on m type on 0x7fe78c16d3d0
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Setting tx payload type 9 based on m type on 0x7fe78c16d3d0
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Setting tx payload type 101 based on m type on 0x7fe78c16d3d0
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 0 (0x7fe77800be88) from 0x7fe78c16d3d0 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 9 (0x7fe778038a78) from 0x7fe78c16d3d0 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 18 (0x7fe778038f38) from 0x7fe78c16d3d0 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 97 (0x7fe778038ab8) from 0x7fe78c16d3d0 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 101 (0x7fe7780317c8) from 0x7fe78c16d3d0 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 125 (0x7fe778008388) from 0x7fe78c16d3d0 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Media stream 'audio' handled by audio
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_t38.c: Not creating outgoing SDP stream: T.38 not enabled
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	      endpoint .Response msg 100/INVITE/cseq=451 (tdta0x7fe704008930) created
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 .Initial answer Response msg 100/INVITE/cseq=451 (tdta0x7fe704008930)
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Method is INVITE, Response is 100 Trying
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	inv0x7fe778039 .Sending Response msg 100/INVITE/cseq=451 (tdta0x7fe704008930)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 ..Sending Response msg 100/INVITE/cseq=451 (tdta0x7fe704008930)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	tsx0x7fe77804c ..Sending Response msg 100/INVITE/cseq=451 (tdta0x7fe704008930) in state Trying
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	tsx0x7fe77804c ...State changed from Trying to Proceeding, event=TX_MSG
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 ....Transaction tsx0x7fe77804c0b8 state changed to Proceeding
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Function session_inv_on_state_changed called on event TSX_STATE
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The state change pertains to the endpoint '100()'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The inv session still has an invite_tsx (0x7fe77804c0b8)
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: There is no transaction involved in this state change
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The current inv state is INCOMING
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Source of transaction state change is TX_MSG
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Function session_inv_on_tsx_state_changed called on event TSX_STATE
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The state change pertains to the endpoint '100()'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The inv session still has an invite_tsx (0x7fe77804c0b8)
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The UAS INVITE transaction involved in this state change is 0x7fe77804c0b8
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The current transaction state is Proceeding
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The transaction state change event is TX_MSG
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The current inv state is INCOMING
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Method is INVITE
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 Module NAT added as dialog usage, data=(nil)
[Dec 19 23:56:33] DEBUG[95015] threadpool.c: Increasing threadpool stasis-core's size by 1
[Dec 19 23:56:33] DEBUG[95096] manager.c: Examining AMI event:
Event: Newchannel
Privilege: call,all
Channel: PJSIP/100-0000001d
ChannelState: 4
ChannelStateDesc: Ring
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63


[Dec 19 23:56:33] DEBUG[95040] chan_pjsip.c: Started PBX on new PJSIP channel PJSIP/100-0000001d
[Dec 19 23:56:33] DEBUG[95833][C-00000011] pbx.c: Launching 'Playback'
[Dec 19 23:56:33] VERBOSE[95833][C-00000011] pbx.c: Executing [*43@from-internal:1] Playback("PJSIP/100-0000001d", "demo-echotest") in new stack
[Dec 19 23:56:33] DEBUG[95026] devicestate.c: No provider found, checking channel drivers for PJSIP - 100
[Dec 19 23:56:33] DEBUG[95096] manager.c: Examining AMI event:
Event: Newexten
Privilege: call,all
Channel: PJSIP/100-0000001d
ChannelState: 4
ChannelStateDesc: Ring
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
Extension: *43
Application: Playback
AppData: demo-echotest


[Dec 19 23:56:33] DEBUG[95026] devicestate.c: Changing state for PJSIP/100 - state 2 (In use)
[Dec 19 23:56:33] DEBUG[95096] manager.c: Examining AMI event:
Event: Newstate
Privilege: call,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63


[Dec 19 23:56:33] DEBUG[95040] pjproject: 	inv0x7fe778039 .SDP negotiation done, status=0
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Applying negotiated SDP media stream 'audio' using audio SDP handler
[Dec 19 23:56:33] DEBUG[95091] app_queue.c: Device 'PJSIP/100' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '192.168.1.6' into...
[Dec 19 23:56:33] DEBUG[95028] app_queue.c: Extension '100@from-internal' changed to state '2' (In use) but we don't care because they're not a member of any queue.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '192.168.1.6' and port ''.
[Dec 19 23:56:33] DEBUG[95040] acl.c: Not an IPv4 nor IPv6 address, cannot get port.
[Dec 19 23:56:33] DEBUG[95096] manager.c: Examining AMI event:
Event: ExtensionStatus
Privilege: call,all
Exten: 100
Context: from-internal
Hint: PJSIP/100
Status: 1
StatusText: InUse


[Dec 19 23:56:33] DEBUG[95040] acl.c: For destination '192.168.1.6', our source address is '206.126.62.165'.
[Dec 19 23:56:33] DEBUG[95096] manager.c: Examining AMI event:
Event: DeviceStateChange
Privilege: call,all
Device: PJSIP/100
State: INUSE


[Dec 19 23:56:33] DEBUG[95040] res_rtp_asterisk.c: Setting RTCP address on RTP instance '0x7fe77801b5d0'
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Don't have a default tx payload type 125 format for m type on 0x7fe78c16cd90
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Setting tx payload type 0 based on m type on 0x7fe78c16cd90
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Setting tx payload type 97 based on m type on 0x7fe78c16cd90
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Setting tx payload type 18 based on m type on 0x7fe78c16cd90
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Setting tx payload type 9 based on m type on 0x7fe78c16cd90
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Setting tx payload type 101 based on m type on 0x7fe78c16cd90
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 0 (0x7fe778008a38) from 0x7fe78c16cd90 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 9 (0x7fe7780310f8) from 0x7fe78c16cd90 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 18 (0x7fe77801b528) from 0x7fe78c16cd90 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 97 (0x7fe77801b4e8) from 0x7fe78c16cd90 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 101 (0x7fe778031138) from 0x7fe78c16cd90 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] rtp_engine.c: Copying payload 125 (0x7fe778051128) from 0x7fe78c16cd90 to 0x7fe77801b798
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Applied negotiated SDP media stream 'audio' using audio SDP handler
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Method is INVITE, Response is 200 OK
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	inv0x7fe778039 .Sending Response msg 200/INVITE/cseq=451 (tdta0x7fe704008930)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 ..Sending Response msg 200/INVITE/cseq=451 (tdta0x7fe704008930)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	tsx0x7fe77804c ..Sending Response msg 200/INVITE/cseq=451 (tdta0x7fe704008930) in state Proceeding
[Dec 19 23:56:33] DEBUG[95040] res_pjsip/pjsip_message_ip_updater.c: Re-wrote Contact URI host/port to 206.126.62.165:5060
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:33] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	tsx0x7fe77804c ...State changed from Proceeding to Completed, event=TX_MSG
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 ....Transaction tsx0x7fe77804c0b8 state changed to Completed
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Function session_inv_on_state_changed called on event TSX_STATE
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The state change pertains to the endpoint '100(PJSIP/100-0000001d)'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The inv session still has an invite_tsx (0x7fe77804c0b8)
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: There is no transaction involved in this state change
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The current inv state is CONNECTING
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Source of transaction state change is TX_MSG
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Function session_inv_on_tsx_state_changed called on event TSX_STATE
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The state change pertains to the endpoint '100(PJSIP/100-0000001d)'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The inv session still has an invite_tsx (0x7fe77804c0b8)
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The UAS INVITE transaction involved in this state change is 0x7fe77804c0b8
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The current transaction state is Completed
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The transaction state change event is TX_MSG
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The current inv state is CONNECTING
[Dec 19 23:56:33] DEBUG[95039] pjproject: 	sip_endpoint.c Processing incoming message: Request msg ACK/cseq=451 (rdata0x7fe704001948)
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:33] DEBUG[95039] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:33] DEBUG[95039] res_pjsip/pjsip_distributor.c: Searching for serializer on dialog dlg0x7fe7780392d8 for Request msg ACK/cseq=451 (rdata0x7fe704001948)
[Dec 19 23:56:33] DEBUG[95039] res_pjsip/pjsip_distributor.c: Found serializer pjsip/distributor-0000002a on dialog dlg0x7fe7780392d8
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	sip_endpoint.c Distributing rdata to modules: Request msg ACK/cseq=451 (rdata0x7fe704009968)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 .Received Request msg ACK/cseq=451 (rdata0x7fe704009968)
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	tsx0x7fe77804c ..Request to terminate transaction
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	tsx0x7fe77804c ...State changed from Completed to Terminated, event=USER
[Dec 19 23:56:33] DEBUG[95040] pjproject: 	dlg0x7fe778039 ....Transaction tsx0x7fe77804c0b8 state changed to Terminated
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Function session_inv_on_tsx_state_changed called on event TSX_STATE
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The state change pertains to the endpoint '100(PJSIP/100-0000001d)'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The inv session does NOT have an invite_tsx
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The UAS INVITE transaction involved in this state change is 0x7fe77804c0b8
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The current transaction state is Terminated
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The transaction state change event is USER
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The current inv state is CONNECTING
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Function session_inv_on_state_changed called on event RX_MSG
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The state change pertains to the endpoint '100(PJSIP/100-0000001d)'
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The inv session does NOT have an invite_tsx
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: There is no transaction involved in this state change
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: The current inv state is CONFIRMED
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Received request
[Dec 19 23:56:33] DEBUG[95040] res_pjsip_session.c: Method is ACK
[Dec 19 23:56:34] DEBUG[95039] pjproject: 	tsx0x7fe77804c Timeout timer event
[Dec 19 23:56:34] DEBUG[95039] pjproject: 	tsx0x7fe77804c .State changed from Terminated to Destroyed, event=TIMER
[Dec 19 23:56:34] DEBUG[95039] pjproject: 	tdta0x7fe70400 ..Destroying txdata Response msg 200/INVITE/cseq=451 (tdta0x7fe704008930)
[Dec 19 23:56:34] DEBUG[95039] pjproject: 	tsx0x7fe77804c Transaction destroyed!
[Dec 19 23:56:34] DEBUG[95833][C-00000011] res_rtp_asterisk.c: 0x7fe778021d70 -- Probation learning mode pass with source address 72.190.32.250:5006
[Dec 19 23:56:34] DEBUG[95833][C-00000011] acl.c: Not an IPv4 nor IPv6 address, cannot get port.
[Dec 19 23:56:34] DEBUG[95833][C-00000011] acl.c: For destination '72.190.32.250', our source address is '206.126.62.165'.
[Dec 19 23:56:34] DEBUG[95833][C-00000011] res_rtp_asterisk.c: Setting RTCP address on RTP instance '0x7fe77801b5d0'
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] res_rtp_asterisk.c: Ooh, format changed from none to ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Scheduling timer at (50 requested / 50 actual) timer ticks per second
[Dec 19 23:56:34] VERBOSE[95833][C-00000011] file.c: <PJSIP/100-0000001d> Playing 'demo-echotest.gsm' (language 'en')
[Dec 19 23:56:34] DEBUG[95833][C-00000011] res_rtp_asterisk.c: 0x7fe778021d70 -- Probation learning mode pass with source address 72.190.32.250:5006
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:34] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:34] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] res_rtp_asterisk.c: Got RTCP report of 64 bytes
[Dec 19 23:56:35] DEBUG[95096] manager.c: Examining AMI event:
Event: RTCPReceived
Privilege: reporting,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
To: 206.126.62.165:18655
From: 72.190.32.250:5007
RTT: 0.0000
SSRC: 0x191f95bc
PT: 200(SR)
ReportCount: 1
SentNTP: 1482191794.17527714422784
SentRTP: 9078720
SentPackets: 42
SentOctets: 2108
Report0SourceSSRC: 0x3348cbeb
Report0FractionLost: 0
Report0CumulativeLost: 0
Report0HighestSequence: 3966
Report0SequenceNumberCycles: 0
Report0IAJitter: 0
Report0LSR: 0
Report0DLSR: 0.0000


[Dec 19 23:56:35] DEBUG[95083] netsock2.c: Splitting '72.190.32.250:5007' into...
[Dec 19 23:56:35] DEBUG[95083] netsock2.c: ...host '72.190.32.250' and port '5007'.
[Dec 19 23:56:35] DEBUG[95083] netsock2.c: Splitting '206.126.62.165:18655' into...
[Dec 19 23:56:35] DEBUG[95083] netsock2.c: ...host '206.126.62.165' and port '18655'.
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95039] pjproject: 	sip_endpoint.c Processing incoming message: Request msg INVITE/cseq=1 (rdata0x7fe704001948)
[Dec 19 23:56:35] DEBUG[95039] netsock2.c: Splitting '108.170.60.38:5078' into...
[Dec 19 23:56:35] DEBUG[95039] netsock2.c: ...host '108.170.60.38' and port '5078'.
[Dec 19 23:56:35] DEBUG[95039] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:35] DEBUG[95039] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:35] DEBUG[95039] res_pjsip/pjsip_distributor.c: Could not find matching transaction for Request msg INVITE/cseq=1 (rdata0x7fe704001948)
[Dec 19 23:56:35] DEBUG[95039] res_pjsip/pjsip_distributor.c: Calculated serializer pjsip/distributor-0000003b to use for Request msg INVITE/cseq=1 (rdata0x7fe704001948)
[Dec 19 23:56:35] DEBUG[95040] pjproject: 	sip_endpoint.c Distributing rdata to modules: Request msg INVITE/cseq=1 (rdata0x7fe704009968)
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: Splitting '108.170.60.38' into...
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: ...host '108.170.60.38' and port ''.
[Dec 19 23:56:35] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: Source address 108.170.60.38:5078 does not match identify 'flowroute'
[Dec 19 23:56:35] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: '108.170.60.38:5078' did not match any identify section rules
[Dec 19 23:56:35] DEBUG[95040] res_pjsip_endpoint_identifier_user.c: Attempting identify by From username '5555' domain '206.126.62.165'
[Dec 19 23:56:35] DEBUG[95040] res_pjsip_endpoint_identifier_user.c: Endpoint not found for From username '5555' domain '206.126.62.165'
[Dec 19 23:56:35] NOTICE[95040] res_pjsip/pjsip_distributor.c: Request 'INVITE' from '"5555" <sip:5555@206.126.62.165>' failed for '108.170.60.38:5078' (callid: c3bc32f359cc6bdae312f2541c61095c) - No matching endpoint found
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: Splitting '206.126.62.165' into...
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port ''.
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: Splitting '108.170.60.38' into...
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: ...host '108.170.60.38' and port ''.
[Dec 19 23:56:35] DEBUG[95040] pjproject: 	      endpoint .Response msg 401/INVITE/cseq=1 (tdta0x7fe778017b40) created
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: Splitting '206.126.62.165' into...
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port ''.
[Dec 19 23:56:35] DEBUG[95096] manager.c: Examining AMI event:
Event: InvalidAccountID
Privilege: security,all
EventTV: 2016-12-19T23:56:35.371+0000
Severity: Error
Service: PJSIP
EventVersion: 1
AccountID: 5555
SessionID: c3bc32f359cc6bdae312f2541c61095c
LocalAddress: IPV4/UDP/206.126.62.165/5060
RemoteAddress: IPV4/UDP/108.170.60.38/5078


[Dec 19 23:56:35] DEBUG[95040] netsock2.c: Splitting '108.170.60.38' into...
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: ...host '108.170.60.38' and port ''.
[Dec 19 23:56:35] DEBUG[95096] manager.c: Examining AMI event:
Event: ChallengeSent
Privilege: security,all
EventTV: 2016-12-19T23:56:35.371+0000
Severity: Informational
Service: PJSIP
EventVersion: 1
AccountID: <unknown>
SessionID: c3bc32f359cc6bdae312f2541c61095c
LocalAddress: IPV4/UDP/206.126.62.165/5060
RemoteAddress: IPV4/UDP/108.170.60.38/5078
Challenge: 


[Dec 19 23:56:35] DEBUG[95040] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: Splitting '108.170.60.38:5078' into...
[Dec 19 23:56:35] DEBUG[95040] netsock2.c: ...host '108.170.60.38' and port '5078'.
[Dec 19 23:56:35] DEBUG[95040] pjproject: 	tdta0x7fe77801 .Destroying txdata Response msg 401/INVITE/cseq=1 (tdta0x7fe778017b40)
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95039] pjproject: 	tsx0x7fe778031 Timeout timer event
[Dec 19 23:56:35] DEBUG[95039] pjproject: 	tsx0x7fe778031 .State changed from Completed to Terminated, event=TIMER
[Dec 19 23:56:35] DEBUG[95039] pjproject: 	tsx0x7fe778031 Timeout timer event
[Dec 19 23:56:35] DEBUG[95039] pjproject: 	tsx0x7fe778031 .State changed from Terminated to Destroyed, event=TIMER
[Dec 19 23:56:35] DEBUG[95039] pjproject: 	tdta0x7fe70400 ..Destroying txdata Request msg OPTIONS/cseq=11026 (tdta0x7fe7040059d0)
[Dec 19 23:56:35] DEBUG[95039] pjproject: 	tsx0x7fe778031 Transaction destroyed!
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] res_rtp_asterisk.c: Got RTCP report of 64 bytes
[Dec 19 23:56:35] DEBUG[95096] manager.c: Examining AMI event:
Event: RTCPReceived
Privilege: reporting,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
To: 206.126.62.165:18655
From: 72.190.32.250:5007
RTT: 0.0000
SSRC: 0x191f95bc
PT: 200(SR)
ReportCount: 1
SentNTP: 1482191795.17543058903040
SentRTP: 9119040
SentPackets: 84
SentOctets: 4056
Report0SourceSSRC: 0x3348cbeb
Report0FractionLost: 0
Report0CumulativeLost: 0
Report0HighestSequence: 4008
Report0SequenceNumberCycles: 0
Report0IAJitter: 3
Report0LSR: 0
Report0DLSR: 0.0000


[Dec 19 23:56:35] DEBUG[95083] netsock2.c: Splitting '72.190.32.250:5007' into...
[Dec 19 23:56:35] DEBUG[95083] netsock2.c: ...host '72.190.32.250' and port '5007'.
[Dec 19 23:56:35] DEBUG[95083] netsock2.c: Splitting '206.126.62.165:18655' into...
[Dec 19 23:56:35] DEBUG[95083] netsock2.c: ...host '206.126.62.165' and port '18655'.
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:35] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:35] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] res_rtp_asterisk.c: Got RTCP report of 64 bytes
[Dec 19 23:56:36] DEBUG[95083] netsock2.c: Splitting '72.190.32.250:5007' into...
[Dec 19 23:56:36] DEBUG[95096] manager.c: Examining AMI event:
Event: RTCPReceived
Privilege: reporting,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
To: 206.126.62.165:18655
From: 72.190.32.250:5007
RTT: 0.0000
SSRC: 0x191f95bc
PT: 200(SR)
ReportCount: 1
SentNTP: 1482191796.17553116553216
SentRTP: 9159360
SentPackets: 126
SentOctets: 6162
Report0SourceSSRC: 0x3348cbeb
Report0FractionLost: 0
Report0CumulativeLost: 0
Report0HighestSequence: 4049
Report0SequenceNumberCycles: 0
Report0IAJitter: 1
Report0LSR: 0
Report0DLSR: 0.0000


[Dec 19 23:56:36] DEBUG[95083] netsock2.c: ...host '72.190.32.250' and port '5007'.
[Dec 19 23:56:36] DEBUG[95083] netsock2.c: Splitting '206.126.62.165:18655' into...
[Dec 19 23:56:36] DEBUG[95083] netsock2.c: ...host '206.126.62.165' and port '18655'.
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:36] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:36] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95039] pjproject: 	sip_endpoint.c Processing incoming message: Request msg OPTIONS/cseq=1 (rdata0x7fe704001948)
[Dec 19 23:56:37] DEBUG[95039] netsock2.c: Splitting '216.115.69.144:5060' into...
[Dec 19 23:56:37] DEBUG[95039] netsock2.c: ...host '216.115.69.144' and port '5060'.
[Dec 19 23:56:37] DEBUG[95039] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:37] DEBUG[95039] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:37] DEBUG[95039] res_pjsip/pjsip_distributor.c: Could not find matching transaction for Request msg OPTIONS/cseq=1 (rdata0x7fe704001948)
[Dec 19 23:56:37] DEBUG[95039] res_pjsip/pjsip_distributor.c: Calculated serializer pjsip/distributor-00000036 to use for Request msg OPTIONS/cseq=1 (rdata0x7fe704001948)
[Dec 19 23:56:37] DEBUG[95040] pjproject: 	sip_endpoint.c Distributing rdata to modules: Request msg OPTIONS/cseq=1 (rdata0x7fe704009968)
[Dec 19 23:56:37] DEBUG[95040] netsock2.c: Splitting '216.115.69.144' into...
[Dec 19 23:56:37] DEBUG[95040] netsock2.c: ...host '216.115.69.144' and port ''.
[Dec 19 23:56:37] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: Source address 216.115.69.144:5060 matches identify 'flowroute'
[Dec 19 23:56:37] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: Retrieved endpoint flowroute
[Dec 19 23:56:37] DEBUG[95040] pjproject: 	      endpoint .Response msg 200/OPTIONS/cseq=1 (tdta0x7fe704008930) created
[Dec 19 23:56:37] DEBUG[95040] pjproject: 	tsx0x7fe778031 ..Transaction created for Request msg OPTIONS/cseq=1 (rdata0x7fe704009968)
[Dec 19 23:56:37] DEBUG[95040] pjproject: 	tsx0x7fe778031 .Incoming Request msg OPTIONS/cseq=1 (rdata0x7fe704009968) in state Null
[Dec 19 23:56:37] DEBUG[95040] pjproject: 	tsx0x7fe778031 ..State changed from Null to Trying, event=RX_MSG
[Dec 19 23:56:37] DEBUG[95040] pjproject: 	tsx0x7fe778031 .Sending Response msg 200/OPTIONS/cseq=1 (tdta0x7fe704008930) in state Trying
[Dec 19 23:56:37] DEBUG[95040] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:37] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:37] DEBUG[95040] netsock2.c: Splitting '216.115.69.144:5060' into...
[Dec 19 23:56:37] DEBUG[95040] netsock2.c: ...host '216.115.69.144' and port '5060'.
[Dec 19 23:56:37] DEBUG[95040] pjproject: 	tsx0x7fe778031 ..State changed from Trying to Completed, event=TX_MSG
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] res_rtp_asterisk.c: Got RTCP report of 64 bytes
[Dec 19 23:56:37] DEBUG[95096] manager.c: Examining AMI event:
Event: RTCPReceived
Privilege: reporting,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
To: 206.126.62.165:18655
From: 72.190.32.250:5007
RTT: 0.0000
SSRC: 0x191f95bc
PT: 200(SR)
ReportCount: 1
SentNTP: 1482191797.17564111896576
SentRTP: 9199680
SentPackets: 168
SentOctets: 8286
Report0SourceSSRC: 0x3348cbeb
Report0FractionLost: 0
Report0CumulativeLost: 0
Report0HighestSequence: 4092
Report0SequenceNumberCycles: 0
Report0IAJitter: 0
Report0LSR: 0
Report0DLSR: 0.0000


[Dec 19 23:56:37] DEBUG[95083] netsock2.c: Splitting '72.190.32.250:5007' into...
[Dec 19 23:56:37] DEBUG[95083] netsock2.c: ...host '72.190.32.250' and port '5007'.
[Dec 19 23:56:37] DEBUG[95083] netsock2.c: Splitting '206.126.62.165:18655' into...
[Dec 19 23:56:37] DEBUG[95083] netsock2.c: ...host '206.126.62.165' and port '18655'.
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:37] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:37] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] res_rtp_asterisk.c: Got RTCP report of 64 bytes
[Dec 19 23:56:38] DEBUG[95096] manager.c: Examining AMI event:
Event: RTCPReceived
Privilege: reporting,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
To: 206.126.62.165:18655
From: 72.190.32.250:5007
RTT: 0.0000
SSRC: 0x191f95bc
PT: 200(SR)
ReportCount: 1
SentNTP: 1482191798.17574636601344
SentRTP: 9240000
SentPackets: 210
SentOctets: 10412
Report0SourceSSRC: 0x3348cbeb
Report0FractionLost: 0
Report0CumulativeLost: 0
Report0HighestSequence: 4134
Report0SequenceNumberCycles: 0
Report0IAJitter: 2
Report0LSR: 0
Report0DLSR: 0.0000


[Dec 19 23:56:38] DEBUG[95083] netsock2.c: Splitting '72.190.32.250:5007' into...
[Dec 19 23:56:38] DEBUG[95083] netsock2.c: ...host '72.190.32.250' and port '5007'.
[Dec 19 23:56:38] DEBUG[95083] netsock2.c: Splitting '206.126.62.165:18655' into...
[Dec 19 23:56:38] DEBUG[95083] netsock2.c: ...host '206.126.62.165' and port '18655'.
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95096] manager.c: Examining AMI event:
Event: RequestBadFormat
Privilege: security,all
EventTV: 2016-12-19T23:56:38.563+0000
Severity: Error
Service: AMI
EventVersion: 1
SessionID: 0x7fe70c000b00
LocalAddress: IPV4/TCP/127.0.0.1/5038
RemoteAddress: IPV4/TCP/127.0.0.1/53388
RequestType: Action: SIPpeerstatus
SessionTV: 2016-12-19T23:31:59.501+0000
AccountID: admin


[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:38] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:38] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95096] manager.c: Examining AMI event:
Event: RTCPSent
Privilege: reporting,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
To: 72.190.32.250:5007
From: 206.126.62.165:18655
SSRC: 0x3348cbeb
PT: 200(SR)
ReportCount: 1
SentNTP: 1482191799.496312320
SentRTP: 40000
SentPackets: 250
SentOctets: 40000
Report0SourceSSRC: 0x191f95bc
Report0FractionLost: 0
Report0CumulativeLost: 0
Report0HighestSequence: 36011
Report0SequenceNumberCycles: 0
Report0IAJitter: 119
Report0LSR: 4063641796
Report0DLSR: 0.7590


[Dec 19 23:56:39] DEBUG[95083] netsock2.c: Splitting '206.126.62.165:18655' into...
[Dec 19 23:56:39] DEBUG[95083] netsock2.c: ...host '206.126.62.165' and port '18655'.
[Dec 19 23:56:39] DEBUG[95083] netsock2.c: Splitting '72.190.32.250:5007' into...
[Dec 19 23:56:39] DEBUG[95083] netsock2.c: ...host '72.190.32.250' and port '5007'.
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] res_rtp_asterisk.c: Got RTCP report of 64 bytes
[Dec 19 23:56:39] DEBUG[95096] manager.c: Examining AMI event:
Event: RTCPReceived
Privilege: reporting,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
To: 206.126.62.165:18655
From: 72.190.32.250:5007
RTT: 0.2328
SSRC: 0x191f95bc
PT: 200(SR)
ReportCount: 1
SentNTP: 1482191799.17589510434816
SentRTP: 9280320
SentPackets: 252
SentOctets: 12476
Report0SourceSSRC: 0x3348cbeb
Report0FractionLost: 0
Report0CumulativeLost: 0
Report0HighestSequence: 4175
Report0SequenceNumberCycles: 0
Report0IAJitter: 3
Report0LSR: 4063698692
Report0DLSR: 0.0580


[Dec 19 23:56:39] DEBUG[95083] netsock2.c: Splitting '72.190.32.250:5007' into...
[Dec 19 23:56:39] DEBUG[95083] netsock2.c: ...host '72.190.32.250' and port '5007'.
[Dec 19 23:56:39] DEBUG[95083] netsock2.c: Splitting '206.126.62.165:18655' into...
[Dec 19 23:56:39] DEBUG[95083] netsock2.c: ...host '206.126.62.165' and port '18655'.
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: Oooh, got a frame with format of opus on channel 'PJSIP/100-0000001d' when we're sending 'ulaw', switching to match
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: gsm -> ulaw
[Dec 19 23:56:39] DEBUG[95039] pjproject: 	sip_endpoint.c Processing incoming message: Request msg BYE/cseq=452 (rdata0x7fe704001948)
[Dec 19 23:56:39] DEBUG[95039] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:39] DEBUG[95039] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:39] DEBUG[95039] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:39] DEBUG[95039] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:39] DEBUG[95039] res_pjsip/pjsip_distributor.c: Searching for serializer on dialog dlg0x7fe7780392d8 for Request msg BYE/cseq=452 (rdata0x7fe704001948)
[Dec 19 23:56:39] DEBUG[95039] res_pjsip/pjsip_distributor.c: Found serializer pjsip/distributor-0000002a on dialog dlg0x7fe7780392d8
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	sip_endpoint.c Distributing rdata to modules: Request msg BYE/cseq=452 (rdata0x7fe704009968)
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	dlg0x7fe778039 .Received Request msg BYE/cseq=452 (rdata0x7fe704009968)
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	tsx0x7fe77804c ...Transaction created for Request msg BYE/cseq=452 (rdata0x7fe704009968)
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	tsx0x7fe77804c ..Incoming Request msg BYE/cseq=452 (rdata0x7fe704009968) in state Null
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	tsx0x7fe77804c ...State changed from Null to Trying, event=RX_MSG
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	dlg0x7fe778039 ....Transaction tsx0x7fe77804c0b8 state changed to Trying
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	      endpoint .....Response msg 200/BYE/cseq=452 (tdta0x7fe778017b40) created
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	dlg0x7fe778039 ......Sending Response msg 200/BYE/cseq=452 (tdta0x7fe778017b40)
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	tsx0x7fe77804c ......Sending Response msg 200/BYE/cseq=452 (tdta0x7fe778017b40) in state Trying
[Dec 19 23:56:39] DEBUG[95040] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:39] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:39] DEBUG[95040] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:39] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	tsx0x7fe77804c .......State changed from Trying to Completed, event=TX_MSG
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	dlg0x7fe778039 ........Transaction tsx0x7fe77804c0b8 state changed to Completed
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: Function session_inv_on_tsx_state_changed called on event TSX_STATE
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The state change pertains to the endpoint '100(PJSIP/100-0000001d)'
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The inv session does NOT have an invite_tsx
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The UAS BYE transaction involved in this state change is 0x7fe77804c0b8
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The current transaction state is Completed
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The transaction state change event is TX_MSG
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The current inv state is CONFIRMED
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: Function session_inv_on_state_changed called on event TSX_STATE
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The state change pertains to the endpoint '100(PJSIP/100-0000001d)'
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The inv session does NOT have an invite_tsx
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: There is no transaction involved in this state change
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The current inv state is DISCONNCTD
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: Source of transaction state change is RX_MSG
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: Received request
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: Method is BYE
[Dec 19 23:56:39] DEBUG[95040] pjproject: 	dlg0x7fe778039 ......Session count dec to 4 by mod-invite
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: Function session_inv_on_tsx_state_changed called on event TSX_STATE
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The state change pertains to the endpoint '100(PJSIP/100-0000001d)'
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The inv session does NOT have an invite_tsx
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The UAS BYE transaction involved in this state change is 0x7fe77804c0b8
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The current transaction state is Completed
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The transaction state change event is RX_MSG
[Dec 19 23:56:39] DEBUG[95040] res_pjsip_session.c: The current inv state is DISCONNCTD
[Dec 19 23:56:39] DEBUG[95096] manager.c: Examining AMI event:
Event: HangupRequest
Privilege: call,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
Cause: 16


[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Channel PJSIP/100-0000001d setting write format path: opus -> opus
[Dec 19 23:56:39] DEBUG[95833][C-00000011] pbx.c: Extension *43, priority 1 returned normally even though call was hung up
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Soft-Hanging (0x10) up channel 'PJSIP/100-0000001d'
[Dec 19 23:56:39] DEBUG[95833][C-00000011] channel.c: Hanging up channel 'PJSIP/100-0000001d'
[Dec 19 23:56:39] DEBUG[95833][C-00000011] chan_pjsip.c: AST hangup cause 16 (no match found in PJSIP)
[Dec 19 23:56:39] DEBUG[95096] manager.c: Examining AMI event:
Event: VarSet
Privilege: dialplan,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
Variable: PLAYBACKSTATUS
Value: FAILED


[Dec 19 23:56:39] DEBUG[95096] manager.c: Examining AMI event:
Event: SoftHangupRequest
Privilege: call,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
Cause: 16


[Dec 19 23:56:39] DEBUG[95027] cdr.c: Finalized CDR for PJSIP/100-0000001d - start 1482191793.959107 answer 1482191793.959268 end 1482191799.749276 dispo ANSWERED
[Dec 19 23:56:39] DEBUG[95026] devicestate.c: No provider found, checking channel drivers for PJSIP - 100
[Dec 19 23:56:39] DEBUG[95026] devicestate.c: Changing state for PJSIP/100 - state 1 (Not in use)
[Dec 19 23:56:39] DEBUG[95091] app_queue.c: Device 'PJSIP/100' changed to state '1' (Not in use) but we don't care because they're not a member of any queue.
[Dec 19 23:56:39] DEBUG[95028] app_queue.c: Extension '100@from-internal' changed to state '1' (Not in use) but we don't care because they're not a member of any queue.
[Dec 19 23:56:39] DEBUG[95027] cdr_radius.c: Unable to create RADIUS record. CDR not recorded!
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(uniqueid) result is '1482191793.63'
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(start) result is '2016-12-19 23:56:33'
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(end) result is '2016-12-19 23:56:39'
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(disposition) result is 'ANSWERED'
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_direction) result is ''
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_application) result is ''
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_inbound_did) result is ''
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_inbound_from_phonenumber) result is ''
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_inbound_from_callerid) result is ''
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_inbound_to_extension) result is ''
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_outbound_did) result is ''
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_outbound_dialed_phonenumber) result is ''
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_outbound_from_extension) result is ''
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_internal_from_extension) result is ''
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_internal_to_extension) result is ''
[Dec 19 23:56:39] DEBUG[95027] pbx_variables.c: Function CDR(cdr_recording_path) result is ''
[Dec 19 23:56:39] DEBUG[95027] res_config_sqlite.c: SQL query: INSERT INTO ast_cdr (clid,src,dst,dcontext,channel,lastapp,lastdata,start,answer,end,duration,billsec,disposition,amaflags,uniqueid) VALUES ('"Luke Apartment" <100>','100','*43','from-internal','PJSIP/100-0000001d','Playback','demo-echotest','2016-12-19 23:56:33','2016-12-19 23:56:33','2016-12-19 23:56:39','5','5','ANSWERED','DOCUMENTATION','1482191793.63')
[Dec 19 23:56:39] DEBUG[95096] manager.c: Examining AMI event:
Event: Hangup
Privilege: call,all
Channel: PJSIP/100-0000001d
ChannelState: 6
ChannelStateDesc: Up
CallerIDNum: 100
CallerIDName: Luke Apartment
ConnectedLineNum: <unknown>
ConnectedLineName: <unknown>
Language: en
AccountCode: 
Context: from-internal
Exten: *43
Priority: 1
Uniqueid: 1482191793.63
Linkedid: 1482191793.63
Cause: 16
Cause-txt: Normal Clearing


[Dec 19 23:56:39] DEBUG[95096] manager.c: Examining AMI event:
Event: ExtensionStatus
Privilege: call,all
Exten: 100
Context: from-internal
Hint: PJSIP/100
Status: 0
StatusText: Idle


[Dec 19 23:56:39] DEBUG[95096] manager.c: Examining AMI event:
Event: DeviceStateChange
Privilege: call,all
Device: PJSIP/100
State: NOT_INUSE


[Dec 19 23:56:39] DEBUG[95096] manager.c: Examining AMI event:
Event: Cdr
Privilege: cdr,all
AccountCode: 
Source: 100
Destination: *43
DestinationContext: from-internal
CallerID: "Luke Apartment" <100>
Channel: PJSIP/100-0000001d
DestinationChannel: 
LastApplication: Playback
LastData: demo-echotest
StartTime: 2016-12-19 23:56:33
AnswerTime: 2016-12-19 23:56:33
EndTime: 2016-12-19 23:56:39
Duration: 5
BillableSeconds: 5
Disposition: ANSWERED
AMAFlags: DOCUMENTATION
UniqueID: 1482191793.63
UserField: 
unique_id: 1482191793.63
tstamp_start: 2016-12-19 23:56:33
tstamp_end: 2016-12-19 23:56:39
answer_status: ANSWERED
direction: 
application: 
inbound_did: 
inbound_from_phonenumber: 
inbound_from_callerid: 
inbound_to_extension: 
outbound_did: 
outbound_dialed_phonenumber: 
outbound_from_extension: 
internal_from_extension: 
internal_to_extension: 
recording_path: 


[Dec 19 23:56:40] DEBUG[95039] pjproject: 	sip_endpoint.c Processing incoming message: Request msg OPTIONS/cseq=1 (rdata0x7fe704001948)
[Dec 19 23:56:40] DEBUG[95039] netsock2.c: Splitting '216.115.69.144:5060' into...
[Dec 19 23:56:40] DEBUG[95039] netsock2.c: ...host '216.115.69.144' and port '5060'.
[Dec 19 23:56:40] DEBUG[95039] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:40] DEBUG[95039] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:40] DEBUG[95039] res_pjsip/pjsip_distributor.c: Could not find matching transaction for Request msg OPTIONS/cseq=1 (rdata0x7fe704001948)
[Dec 19 23:56:40] DEBUG[95039] res_pjsip/pjsip_distributor.c: Calculated serializer pjsip/distributor-0000002b to use for Request msg OPTIONS/cseq=1 (rdata0x7fe704001948)
[Dec 19 23:56:40] DEBUG[95040] pjproject: 	sip_endpoint.c Distributing rdata to modules: Request msg OPTIONS/cseq=1 (rdata0x7fe704009968)
[Dec 19 23:56:40] DEBUG[95040] netsock2.c: Splitting '216.115.69.144' into...
[Dec 19 23:56:40] DEBUG[95040] netsock2.c: ...host '216.115.69.144' and port ''.
[Dec 19 23:56:40] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: Source address 216.115.69.144:5060 matches identify 'flowroute'
[Dec 19 23:56:40] DEBUG[95040] res_pjsip_endpoint_identifier_ip.c: Retrieved endpoint flowroute
[Dec 19 23:56:40] DEBUG[95040] pjproject: 	      endpoint .Response msg 200/OPTIONS/cseq=1 (tdta0x7fe778009fa0) created
[Dec 19 23:56:40] DEBUG[95040] pjproject: 	tsx0x7fe764001 ..Transaction created for Request msg OPTIONS/cseq=1 (rdata0x7fe704009968)
[Dec 19 23:56:40] DEBUG[95040] pjproject: 	tsx0x7fe764001 .Incoming Request msg OPTIONS/cseq=1 (rdata0x7fe704009968) in state Null
[Dec 19 23:56:40] DEBUG[95040] pjproject: 	tsx0x7fe764001 ..State changed from Null to Trying, event=RX_MSG
[Dec 19 23:56:40] DEBUG[95040] pjproject: 	tsx0x7fe764001 .Sending Response msg 200/OPTIONS/cseq=1 (tdta0x7fe778009fa0) in state Trying
[Dec 19 23:56:40] DEBUG[95040] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:40] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:40] DEBUG[95040] netsock2.c: Splitting '216.115.69.144:5060' into...
[Dec 19 23:56:40] DEBUG[95040] netsock2.c: ...host '216.115.69.144' and port '5060'.
[Dec 19 23:56:40] DEBUG[95040] pjproject: 	tsx0x7fe764001 ..State changed from Trying to Completed, event=TX_MSG
[Dec 19 23:56:42] DEBUG[95040] pjproject: 	      endpoint Request msg OPTIONS/cseq=56101 (tdta0x7fe7040059d0) created.
[Dec 19 23:56:42] DEBUG[95040] config.c: extract uint from [3] in [0, 4294967295] gives [3](0)
[Dec 19 23:56:42] DEBUG[95040] config.c: extract uint from [0] in [0, 4294967295] gives [0](0)
[Dec 19 23:56:42] DEBUG[95040] config.c: extract uint from [2] in [0, 4294967295] gives [2](0)
[Dec 19 23:56:42] DEBUG[95040] res_pjsip.c: 0x7fe7780304a0: Wrapper created
[Dec 19 23:56:42] DEBUG[95040] res_pjsip.c: 0x7fe7780304a0: Set timer to 20000 msec
[Dec 19 23:56:42] DEBUG[95040] pjproject: 	tsx0x7fe778064 .Transaction created for Request msg OPTIONS/cseq=56101 (tdta0x7fe7040059d0)
[Dec 19 23:56:42] DEBUG[95040] pjproject: 	tsx0x7fe778064 Sending Request msg OPTIONS/cseq=56101 (tdta0x7fe7040059d0) in state Null
[Dec 19 23:56:42] DEBUG[95040] pjproject: 	 sip_resolve.c .Target '72.190.32.250:27249' type=Unspecified resolved to '72.190.32.250:27249' type=UDP (UDP transport)
[Dec 19 23:56:42] DEBUG[95040] res_pjsip/pjsip_message_ip_updater.c: Re-wrote Contact URI host/port to 206.126.62.165:5060
[Dec 19 23:56:42] DEBUG[95040] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:42] DEBUG[95040] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:42] DEBUG[95040] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:42] DEBUG[95040] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:42] DEBUG[95040] pjproject: 	tsx0x7fe778064 .State changed from Null to Calling, event=TX_MSG
[Dec 19 23:56:42] DEBUG[95039] pjproject: 	sip_endpoint.c Processing incoming message: Response msg 200/OPTIONS/cseq=56101 (rdata0x7fe704001948)
[Dec 19 23:56:42] DEBUG[95039] netsock2.c: Splitting '72.190.32.250:27249' into...
[Dec 19 23:56:42] DEBUG[95039] netsock2.c: ...host '72.190.32.250' and port '27249'.
[Dec 19 23:56:42] DEBUG[95039] netsock2.c: Splitting '206.126.62.165:5060' into...
[Dec 19 23:56:42] DEBUG[95039] netsock2.c: ...host '206.126.62.165' and port '5060'.
[Dec 19 23:56:42] DEBUG[95039] res_pjsip/pjsip_distributor.c: No dialog serializer for response Response msg 200/OPTIONS/cseq=56101 (rdata0x7fe704001948). Using request transaction as basis
[Dec 19 23:56:42] DEBUG[95039] res_pjsip/pjsip_distributor.c: Found serializer pjsip/default-00000010 on transaction tsx0x7fe778064bf8
[Dec 19 23:56:42] DEBUG[95040] pjproject: 	sip_endpoint.c Distributing rdata to modules: Response msg 200/OPTIONS/cseq=56101 (rdata0x7fe704009968)
[Dec 19 23:56:42] DEBUG[95040] pjproject: 	tsx0x7fe778064 .Incoming Response msg 200/OPTIONS/cseq=56101 (rdata0x7fe704009968) in state Calling
[Dec 19 23:56:42] DEBUG[95040] pjproject: 	tsx0x7fe778064 ..State changed from Calling to Completed, event=RX_MSG
[Dec 19 23:56:42] DEBUG[95040] res_pjsip.c: 0x7fe7780304a0: PJSIP tsx response received
[Dec 19 23:56:42] DEBUG[95040] res_pjsip.c: 0x7fe7780304a0: Cancelling timer
[Dec 19 23:56:42] DEBUG[95040] res_pjsip.c: 0x7fe7780304a0: Timer cancelled
[Dec 19 23:56:42] DEBUG[95040] config.c: extract uint from [3] in [0, 4294967295] gives [3](0)
[Dec 19 23:56:42] DEBUG[95040] config.c: extract uint from [0] in [0, 4294967295] gives [0](0)
[Dec 19 23:56:42] DEBUG[95040] config.c: extract uint from [2] in [0, 4294967295] gives [2](0)
[Dec 19 23:56:42] DEBUG[95040] res_pjsip.c: 0x7fe7780304a0: Callbacks executed
[Dec 19 23:56:42] DEBUG[95040] res_pjsip.c: 0x7fe7780304a0: wrapper destroyed
[Dec 19 23:56:42] DEBUG[95045] res_pjsip/pjsip_configuration.c: Contact 100/sip:100@72.190.32.250:27249 status didn't change: Reachable, RTT: 15.285 msec
[Dec 19 23:56:44] DEBUG[95083] netsock2.c: Splitting '206.126.62.165:18655' into...
[Dec 19 23:56:44] DEBUG[95083] netsock2.c: ...host '206.126.62.165' and port '18655'.
[Dec 19 23:56:44] DEBUG[95096] manager.c: Examining AMI event:
Event: RTCPSent
Privilege: reporting,all
To: 72.190.32.250:5007
From: 206.126.62.165:18655
SSRC: 0x3348cbeb
PT: 200(SR)
ReportCount: 1
SentNTP: 1482191804.496844800
SentRTP: 45120
SentPackets: 282
SentOctets: 45120
Report0SourceSSRC: 0x191f95bc
Report0FractionLost: 0
Report0CumulativeLost: 0
Report0HighestSequence: 36043
Report0SequenceNumberCycles: 0
Report0IAJitter: 107
Report0LSR: 4063696715
Report0DLSR: 4.9170


[Dec 19 23:56:44] DEBUG[95083] netsock2.c: Splitting '72.190.32.250:5007' into...
[Dec 19 23:56:44] DEBUG[95083] netsock2.c: ...host '72.190.32.250' and port '5007'.
[Dec 19 23:56:47] Asterisk 13.13.1 built by root @ testbed3.primevox.net on a x86_64 running Linux on 2016-12-19 23:27:59 UTC
[Dec 19 23:56:47] VERBOSE[95829] config.c: Parsing '/etc/asterisk/logger.conf': Found
[Dec 19 23:56:49] VERBOSE[95829] asterisk.c: Remote UNIX connection disconnected
[Dec 19 23:57:08] NOTICE[95040] res_pjsip/pjsip_distributor.c: Request 'INVITE' from '"5555" <sip:5555@206.126.62.165>' failed for '108.170.60.38:5071' (callid: 01945a1f1e1bc3d951cfc0b5f6ae87f2) - No matching endpoint found