-
-
Save ranlauf/2170e68cece999b037a0 to your computer and use it in GitHub Desktop.
Menu test with adhearsion3 beta 1
This file contains bidirectional Unicode text that may be interpreted or compiled differently than what appears below. To review, open the file in an editor that reveals hidden Unicode characters.
Learn more about bidirectional Unicode characters
| [Nov 25 18:31:06] Asterisk 13.6.0 built by root @ callcenter-centos7-dit on a x86_64 running Linux on 2015-11-13 15:49:30 UTC | |
| [Nov 25 18:31:08] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:13] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:17] DEBUG[13767] manager.c: Mansession: 0x7f981c004eb8 refcount now 0 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Allocating new SIP dialog for 2926465a0beca13d386f8da655a53dbf@10.47.20.42:5060 - OPTIONS (No RTP) | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: OBPROXY: Not applying OBproxy to this call | |
| [Nov 25 18:31:20] DEBUG[1224] acl.c: For destination '10.47.22.253', our source address is '10.47.20.42'. | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Setting AST_TRANSPORT_UDP with address 10.47.20.42:5060 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: SIP call-id changed from '2926465a0beca13d386f8da655a53dbf@10.47.20.42:5060' to '57ab38c76210110c784fb5e023399804@10.47.20.42:5060' | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Initializing initreq for method OPTIONS - callid 57ab38c76210110c784fb5e023399804@10.47.20.42:5060 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 0 [ 55]: OPTIONS sip:110@10.47.22.253:5060;line=xiio2hm8 SIP/2.0 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 1 [ 56]: Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK16e24707 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 2 [ 16]: Max-Forwards: 70 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 3 [ 58]: From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as5305a865 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 4 [ 45]: To: <sip:110@10.47.22.253:5060;line=xiio2hm8> | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 5 [ 40]: Contact: <sip:asterisk@10.47.20.42:5060> | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 6 [ 58]: Call-ID: 57ab38c76210110c784fb5e023399804@10.47.20.42:5060 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 7 [ 17]: CSeq: 102 OPTIONS | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 8 [ 31]: User-Agent: Asterisk PBX 13.6.0 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 9 [ 35]: Date: Wed, 25 Nov 2015 17:31:20 GMT | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 10 [ 90]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 11 [ 26]: Supported: replaces, timer | |
| [Nov 25 18:31:20] VERBOSE[1224] chan_sip.c: Reliably Transmitting (no NAT) to 10.47.22.253:5060: | |
| OPTIONS sip:110@10.47.22.253:5060;line=xiio2hm8 SIP/2.0 | |
| Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK16e24707 | |
| Max-Forwards: 70 | |
| From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as5305a865 | |
| To: <sip:110@10.47.22.253:5060;line=xiio2hm8> | |
| Contact: <sip:asterisk@10.47.20.42:5060> | |
| Call-ID: 57ab38c76210110c784fb5e023399804@10.47.20.42:5060 | |
| CSeq: 102 OPTIONS | |
| User-Agent: Asterisk PBX 13.6.0 | |
| Date: Wed, 25 Nov 2015 17:31:20 GMT | |
| Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| Supported: replaces, timer | |
| Content-Length: 0 | |
| --- | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: *** SIP TIMER: Initializing retransmit timer on packet: Id #6 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Trying to put 'OPTIONS sip' onto UDP socket destined for 10.47.22.253:5060 | |
| [Nov 25 18:31:20] VERBOSE[1224] chan_sip.c: | |
| <--- SIP read from UDP:10.47.22.253:5060 ---> | |
| SIP/2.0 200 OK | |
| Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK16e24707 | |
| From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as5305a865 | |
| To: <sip:110@10.47.22.253:5060;line=xiio2hm8> | |
| Call-ID: 57ab38c76210110c784fb5e023399804@10.47.20.42:5060 | |
| CSeq: 102 OPTIONS | |
| Contact: <sip:107@10.47.22.253:5060;line=vav9afgv>;reg-id=1 | |
| User-Agent: snom320/7.3.30 | |
| Accept-Language: en | |
| Accept: application/sdp | |
| Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO | |
| Allow-Events: talk, hold, refer, call-info | |
| Supported: timer, 100rel, replaces, from-change | |
| Content-Length: 0 | |
| <-------------> | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 0 [ 14]: SIP/2.0 200 OK | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 1 [ 56]: Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK16e24707 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 2 [ 58]: From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as5305a865 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 3 [ 45]: To: <sip:110@10.47.22.253:5060;line=xiio2hm8> | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 4 [ 58]: Call-ID: 57ab38c76210110c784fb5e023399804@10.47.20.42:5060 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 5 [ 17]: CSeq: 102 OPTIONS | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 6 [ 59]: Contact: <sip:107@10.47.22.253:5060;line=vav9afgv>;reg-id=1 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 7 [ 26]: User-Agent: snom320/7.3.30 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 8 [ 19]: Accept-Language: en | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 9 [ 23]: Accept: application/sdp | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 10 [ 88]: Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 11 [ 42]: Allow-Events: talk, hold, refer, call-info | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 12 [ 47]: Supported: timer, 100rel, replaces, from-change | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Header 13 [ 17]: Content-Length: 0 | |
| [Nov 25 18:31:20] VERBOSE[1224] chan_sip.c: --- (14 headers 0 lines) --- | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: = Looking for Call ID: 57ab38c76210110c784fb5e023399804@10.47.20.42:5060 (Checking To) --From tag as5305a865 --To-tag | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #6 | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Stopping retransmission on '57ab38c76210110c784fb5e023399804@10.47.20.42:5060' of Request 102: Match Found | |
| [Nov 25 18:31:20] DEBUG[1224] chan_sip.c: Destroying SIP dialog 57ab38c76210110c784fb5e023399804@10.47.20.42:5060 | |
| [Nov 25 18:31:20] VERBOSE[1224] chan_sip.c: Really destroying SIP dialog '57ab38c76210110c784fb5e023399804@10.47.20.42:5060' Method: OPTIONS | |
| [Nov 25 18:31:20] DEBUG[13944] manager.c: Running action 'Login' | |
| [Nov 25 18:31:20] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:20] DEBUG[13944] manager.c: Examining AMI event: | |
| Event: SuccessfulAuth | |
| Privilege: security,all | |
| SequenceNumber: 4769 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| EventTV: 2015-11-25T18:31:20.723+0100 | |
| Severity: Informational | |
| Service: AMI | |
| EventVersion: 1 | |
| AccountID: ahn_ami | |
| SessionID: 0x7f981c004eb8 | |
| LocalAddress: IPV4/TCP/0.0.0.0/5038 | |
| RemoteAddress: IPV4/TCP/10.47.20.174/54897 | |
| UsingPassword: 0 | |
| SessionTV: 2015-11-25T18:31:20.723+0100 | |
| [Nov 25 18:31:20] DEBUG[13944] manager.c: Running action 'Command' | |
| [Nov 25 18:31:20] WARNING[13944] pbx.c: Unable to register extension '1' priority 1 in 'adhearsion-redirect', already in use | |
| [Nov 25 18:31:20] DEBUG[13944] manager.c: Running action 'Command' | |
| [Nov 25 18:31:25] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:30] DEBUG[13944] manager.c: Mansession: 0x7f981c004eb8 refcount now 0 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Allocating new SIP dialog for 2281fc4941264f2918ab4f0520c60c3d@10.47.20.42:5060 - OPTIONS (No RTP) | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: OBPROXY: Not applying OBproxy to this call | |
| [Nov 25 18:31:33] DEBUG[1224] acl.c: For destination '10.47.22.252', our source address is '10.47.20.42'. | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Setting AST_TRANSPORT_UDP with address 10.47.20.42:5060 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: SIP call-id changed from '2281fc4941264f2918ab4f0520c60c3d@10.47.20.42:5060' to '0021331e411eb50406ec039f5590c2ab@10.47.20.42:5060' | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Initializing initreq for method OPTIONS - callid 0021331e411eb50406ec039f5590c2ab@10.47.20.42:5060 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 0 [ 55]: OPTIONS sip:112@10.47.22.252:5060;line=u79redls SIP/2.0 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 1 [ 56]: Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK2a0a806c | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 2 [ 16]: Max-Forwards: 70 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 3 [ 58]: From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as5ef7df97 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 4 [ 45]: To: <sip:112@10.47.22.252:5060;line=u79redls> | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 5 [ 40]: Contact: <sip:asterisk@10.47.20.42:5060> | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 6 [ 58]: Call-ID: 0021331e411eb50406ec039f5590c2ab@10.47.20.42:5060 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 7 [ 17]: CSeq: 102 OPTIONS | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 8 [ 31]: User-Agent: Asterisk PBX 13.6.0 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 9 [ 35]: Date: Wed, 25 Nov 2015 17:31:33 GMT | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 10 [ 90]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 11 [ 26]: Supported: replaces, timer | |
| [Nov 25 18:31:33] VERBOSE[1224] chan_sip.c: Reliably Transmitting (no NAT) to 10.47.22.252:5060: | |
| OPTIONS sip:112@10.47.22.252:5060;line=u79redls SIP/2.0 | |
| Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK2a0a806c | |
| Max-Forwards: 70 | |
| From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as5ef7df97 | |
| To: <sip:112@10.47.22.252:5060;line=u79redls> | |
| Contact: <sip:asterisk@10.47.20.42:5060> | |
| Call-ID: 0021331e411eb50406ec039f5590c2ab@10.47.20.42:5060 | |
| CSeq: 102 OPTIONS | |
| User-Agent: Asterisk PBX 13.6.0 | |
| Date: Wed, 25 Nov 2015 17:31:33 GMT | |
| Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| Supported: replaces, timer | |
| Content-Length: 0 | |
| --- | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: *** SIP TIMER: Initializing retransmit timer on packet: Id #7 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Trying to put 'OPTIONS sip' onto UDP socket destined for 10.47.22.252:5060 | |
| [Nov 25 18:31:33] VERBOSE[1224] chan_sip.c: | |
| <--- SIP read from UDP:10.47.22.252:5060 ---> | |
| SIP/2.0 200 OK | |
| Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK2a0a806c | |
| From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as5ef7df97 | |
| To: <sip:112@10.47.22.252:5060;line=u79redls> | |
| Call-ID: 0021331e411eb50406ec039f5590c2ab@10.47.20.42:5060 | |
| CSeq: 102 OPTIONS | |
| Contact: <sip:112@10.47.22.252:5060;line=u79redls>;reg-id=1 | |
| User-Agent: snom320/7.3.30 | |
| Accept-Language: en | |
| Accept: application/sdp | |
| Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO | |
| Allow-Events: talk, hold, refer, call-info | |
| Supported: timer, 100rel, replaces, from-change | |
| Content-Length: 0 | |
| <-------------> | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 0 [ 14]: SIP/2.0 200 OK | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 1 [ 56]: Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK2a0a806c | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 2 [ 58]: From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as5ef7df97 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 3 [ 45]: To: <sip:112@10.47.22.252:5060;line=u79redls> | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 4 [ 58]: Call-ID: 0021331e411eb50406ec039f5590c2ab@10.47.20.42:5060 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 5 [ 17]: CSeq: 102 OPTIONS | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 6 [ 59]: Contact: <sip:112@10.47.22.252:5060;line=u79redls>;reg-id=1 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 7 [ 26]: User-Agent: snom320/7.3.30 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 8 [ 19]: Accept-Language: en | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 9 [ 23]: Accept: application/sdp | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 10 [ 88]: Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 11 [ 42]: Allow-Events: talk, hold, refer, call-info | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 12 [ 47]: Supported: timer, 100rel, replaces, from-change | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Header 13 [ 17]: Content-Length: 0 | |
| [Nov 25 18:31:33] VERBOSE[1224] chan_sip.c: --- (14 headers 0 lines) --- | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: = Looking for Call ID: 0021331e411eb50406ec039f5590c2ab@10.47.20.42:5060 (Checking To) --From tag as5ef7df97 --To-tag | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #7 | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Stopping retransmission on '0021331e411eb50406ec039f5590c2ab@10.47.20.42:5060' of Request 102: Match Found | |
| [Nov 25 18:31:33] DEBUG[1224] chan_sip.c: Destroying SIP dialog 0021331e411eb50406ec039f5590c2ab@10.47.20.42:5060 | |
| [Nov 25 18:31:33] VERBOSE[1224] chan_sip.c: Really destroying SIP dialog '0021331e411eb50406ec039f5590c2ab@10.47.20.42:5060' Method: OPTIONS | |
| [Nov 25 18:31:35] DEBUG[13945] manager.c: Running action 'Login' | |
| [Nov 25 18:31:35] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:35] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: SuccessfulAuth | |
| Privilege: security,all | |
| SequenceNumber: 4770 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| EventTV: 2015-11-25T18:31:35.818+0100 | |
| Severity: Informational | |
| Service: AMI | |
| EventVersion: 1 | |
| AccountID: ahn_ami | |
| SessionID: 0x7f981c004eb8 | |
| LocalAddress: IPV4/TCP/0.0.0.0/5038 | |
| RemoteAddress: IPV4/TCP/10.47.20.174/54898 | |
| UsingPassword: 0 | |
| SessionTV: 2015-11-25T18:31:35.818+0100 | |
| [Nov 25 18:31:35] DEBUG[13945] manager.c: Running action 'Command' | |
| [Nov 25 18:31:35] WARNING[13945] pbx.c: Unable to register extension '1' priority 1 in 'adhearsion-redirect', already in use | |
| [Nov 25 18:31:35] DEBUG[13945] manager.c: Running action 'Command' | |
| [Nov 25 18:31:36] VERBOSE[1229] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: POKE | |
| [Nov 25 18:31:36] VERBOSE[1229] chan_iax2.c: Timestamp: 00013ms SCall: 10753 DCall: 00000 10.47.20.65:4569 | |
| [Nov 25 18:31:36] VERBOSE[1229] chan_iax2.c: | |
| [Nov 25 18:31:36] VERBOSE[1229] chan_iax2.c: Tx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: PONG | |
| [Nov 25 18:31:36] VERBOSE[1229] chan_iax2.c: Timestamp: 00013ms SCall: 00001 DCall: 10753 10.47.20.65:4569 | |
| [Nov 25 18:31:36] VERBOSE[1236] chan_iax2.c: Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: ACK | |
| [Nov 25 18:31:36] VERBOSE[1236] chan_iax2.c: Timestamp: 00013ms SCall: 10753 DCall: 00001 10.47.20.65:4569 | |
| [Nov 25 18:31:40] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:45] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:50] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: | |
| <--- SIP read from UDP:10.47.22.251:5060 ---> | |
| INVITE sip:777@10.47.20.42 SIP/2.0 | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-1mml8pt1f2tk;rport | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42> | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 1 INVITE | |
| Max-Forwards: 70 | |
| User-Agent: snom320/8.7.5.17 | |
| Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| X-Serialnumber: 000413381C8C | |
| P-Key-Flags: keys="3" | |
| Accept: application/sdp | |
| Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO, UPDATE | |
| Allow-Events: talk, hold, refer, call-info | |
| Supported: timer, 100rel, replaces, from-change | |
| Session-Expires: 3600 | |
| Min-SE: 90 | |
| Content-Type: application/sdp | |
| Content-Length: 403 | |
| v=0 | |
| o=root 1239629211 1239629211 IN IP4 10.47.22.251 | |
| s=call | |
| c=IN IP4 10.47.22.251 | |
| t=0 0 | |
| m=audio 54830 RTP/AVP 9 0 8 3 99 112 18 101 | |
| a=rtpmap:9 G722/8000 | |
| a=rtpmap:0 PCMU/8000 | |
| a=rtpmap:8 PCMA/8000 | |
| a=rtpmap:3 GSM/8000 | |
| a=rtpmap:99 G726-32/8000 | |
| a=rtpmap:112 AAL2-G726-32/8000 | |
| a=rtpmap:18 G729/8000 | |
| a=fmtp:18 annexb=no | |
| a=rtpmap:101 telephone-event/8000 | |
| a=fmtp:101 0-15 | |
| a=ptime:20 | |
| a=sendrecv | |
| <-------------> | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 0 [ 34]: INVITE sip:777@10.47.20.42 SIP/2.0 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 1 [ 68]: Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-1mml8pt1f2tk;rport | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 2 [ 55]: From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 3 [ 25]: To: <sip:777@10.47.20.42> | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 4 [ 52]: Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 5 [ 14]: CSeq: 1 INVITE | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 6 [ 16]: Max-Forwards: 70 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 7 [ 28]: User-Agent: snom320/8.7.5.17 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 8 [ 59]: Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 9 [ 28]: X-Serialnumber: 000413381C8C | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 10 [ 21]: P-Key-Flags: keys="3" | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 11 [ 23]: Accept: application/sdp | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 12 [ 96]: Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO, UPDATE | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 13 [ 42]: Allow-Events: talk, hold, refer, call-info | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 14 [ 47]: Supported: timer, 100rel, replaces, from-change | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 15 [ 21]: Session-Expires: 3600 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 16 [ 10]: Min-SE: 90 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 17 [ 29]: Content-Type: application/sdp | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 18 [ 19]: Content-Length: 403 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 19 [ 0]: | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 0 [ 3]: v=0 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 1 [ 48]: o=root 1239629211 1239629211 IN IP4 10.47.22.251 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 2 [ 6]: s=call | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 3 [ 21]: c=IN IP4 10.47.22.251 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 4 [ 5]: t=0 0 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 5 [ 43]: m=audio 54830 RTP/AVP 9 0 8 3 99 112 18 101 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 6 [ 20]: a=rtpmap:9 G722/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 7 [ 20]: a=rtpmap:0 PCMU/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 8 [ 20]: a=rtpmap:8 PCMA/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 9 [ 19]: a=rtpmap:3 GSM/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 10 [ 24]: a=rtpmap:99 G726-32/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 11 [ 30]: a=rtpmap:112 AAL2-G726-32/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 12 [ 21]: a=rtpmap:18 G729/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 13 [ 19]: a=fmtp:18 annexb=no | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 14 [ 33]: a=rtpmap:101 telephone-event/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 15 [ 15]: a=fmtp:101 0-15 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 16 [ 10]: a=ptime:20 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 17 [ 10]: a=sendrecv | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: --- (19 headers 18 lines) --- | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: = Looking for Call ID: 313434383437323731323534323736-psjp6zc12znr (Checking From) --From tag pleulbxibr --To-tag | |
| [Nov 25 18:31:54] DEBUG[1224] acl.c: For destination '10.47.22.251', our source address is '10.47.20.42'. | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Setting AST_TRANSPORT_UDP with address 10.47.20.42:5060 | |
| [Nov 25 18:31:54] DEBUG[1224] netsock2.c: Splitting '10.47.22.251:5060' into... | |
| [Nov 25 18:31:54] DEBUG[1224] netsock2.c: ...host '10.47.22.251' and port '5060'. | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: Sending to 10.47.22.251:5060 (no NAT) | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Allocating new SIP dialog for 313434383437323731323534323736-psjp6zc12znr - INVITE (No RTP) | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] sip/reqresp_parser.c: Begin: parsing SIP "Supported: timer, 100rel, replaces, from-change" | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] sip/reqresp_parser.c: Found SIP option: -timer- | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] sip/reqresp_parser.c: Matched SIP option: timer | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] sip/reqresp_parser.c: Found SIP option: -100rel- | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] sip/reqresp_parser.c: Matched SIP option: 100rel | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] sip/reqresp_parser.c: Found SIP option: -replaces- | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] sip/reqresp_parser.c: Matched SIP option: replaces | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] sip/reqresp_parser.c: Found SIP option: -from-change- | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] sip/reqresp_parser.c: Matched SIP option: from-change | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: Splitting '10.47.22.251:5060' into... | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: ...host '10.47.22.251' and port '5060'. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Sending to 10.47.22.251:5060 (no NAT) | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Initializing initreq for method INVITE - callid 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Using INVITE request as basis request - 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: Splitting '10.47.20.42' into... | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: ...host '10.47.20.42' and port ''. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found peer '111' for '111' from 10.47.22.251:5060 | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: | |
| <--- Reliably Transmitting (no NAT) to 10.47.22.251:5060 ---> | |
| SIP/2.0 401 Unauthorized | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-1mml8pt1f2tk;received=10.47.22.251;rport=5060 | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42>;tag=as3f752e4b | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 1 INVITE | |
| Server: Asterisk PBX 13.6.0 | |
| Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| Supported: replaces, timer | |
| WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="4f735554" | |
| Content-Length: 0 | |
| <------------> | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: *** SIP TIMER: Initializing retransmit timer on packet: Id #10 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Trying to put 'SIP/2.0 401' onto UDP socket destined for 10.47.22.251:5060 | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Scheduling destruction of SIP dialog '313434383437323731323534323736-psjp6zc12znr' in 6400 ms (Method: INVITE) | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: ChallengeSent | |
| Privilege: security,all | |
| SequenceNumber: 4771 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| EventTV: 2015-11-25T18:31:54.386+0100 | |
| Severity: Informational | |
| Service: SIP | |
| EventVersion: 1 | |
| AccountID: sip:111@10.47.20.42 | |
| SessionID: 0x7f981001d258 | |
| LocalAddress: IPV4/UDP/10.47.20.42/5060 | |
| RemoteAddress: IPV4/UDP/10.47.22.251/5060 | |
| Challenge: 4f735554 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: SIP TIMER: Rescheduling retransmission #10 (1) SIP/2.0 - 1 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: ** SIP timers: Rescheduling retransmission 2 to 200 ms (t1 100 ms (Retrans id #10)) | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: Retransmitting #1 (no NAT) to 10.47.22.251:5060: | |
| SIP/2.0 401 Unauthorized | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-1mml8pt1f2tk;received=10.47.22.251;rport=5060 | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42>;tag=as3f752e4b | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 1 INVITE | |
| Server: Asterisk PBX 13.6.0 | |
| Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| Supported: replaces, timer | |
| WWW-Authenticate: Digest algorithm=MD5, realm="asterisk", nonce="4f735554" | |
| Content-Length: 0 | |
| --- | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Trying to put 'SIP/2.0 401' onto UDP socket destined for 10.47.22.251:5060 | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: | |
| <--- SIP read from UDP:10.47.22.251:5060 ---> | |
| ACK sip:777@10.47.20.42 SIP/2.0 | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-1mml8pt1f2tk;rport | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42>;tag=as3f752e4b | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 1 ACK | |
| Max-Forwards: 70 | |
| User-Agent: snom320/8.7.5.17 | |
| Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| Content-Length: 0 | |
| <-------------> | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 0 [ 31]: ACK sip:777@10.47.20.42 SIP/2.0 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 1 [ 68]: Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-1mml8pt1f2tk;rport | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 2 [ 55]: From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 3 [ 40]: To: <sip:777@10.47.20.42>;tag=as3f752e4b | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 4 [ 52]: Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 5 [ 11]: CSeq: 1 ACK | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 6 [ 16]: Max-Forwards: 70 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 7 [ 28]: User-Agent: snom320/8.7.5.17 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 8 [ 59]: Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 9 [ 17]: Content-Length: 0 | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: --- (10 headers 0 lines) --- | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: = Looking for Call ID: 313434383437323731323534323736-psjp6zc12znr (Checking From) --From tag pleulbxibr --To-tag as3f752e4b | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: **** Received ACK (6) - Command in SIP ACK | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #10 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Stopping retransmission on '313434383437323731323534323736-psjp6zc12znr' of Response 1: Match Found | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: | |
| <--- SIP read from UDP:10.47.22.251:5060 ---> | |
| INVITE sip:777@10.47.20.42 SIP/2.0 | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-rbcyed51idab;rport | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42> | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 2 INVITE | |
| Max-Forwards: 70 | |
| User-Agent: snom320/8.7.5.17 | |
| Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| X-Serialnumber: 000413381C8C | |
| P-Key-Flags: keys="3" | |
| Accept: application/sdp | |
| Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO, UPDATE | |
| Allow-Events: talk, hold, refer, call-info | |
| Supported: timer, 100rel, replaces, from-change | |
| Session-Expires: 3600 | |
| Min-SE: 90 | |
| Authorization: Digest username="111",realm="asterisk",nonce="4f735554",uri="sip:777@10.47.20.42",response="9c35d242d4bcc62f7eeeea61f127d2bd",algorithm=MD5 | |
| Content-Type: application/sdp | |
| Content-Length: 403 | |
| v=0 | |
| o=root 1239629211 1239629211 IN IP4 10.47.22.251 | |
| s=call | |
| c=IN IP4 10.47.22.251 | |
| t=0 0 | |
| m=audio 54830 RTP/AVP 9 0 8 3 99 112 18 101 | |
| a=rtpmap:9 G722/8000 | |
| a=rtpmap:0 PCMU/8000 | |
| a=rtpmap:8 PCMA/8000 | |
| a=rtpmap:3 GSM/8000 | |
| a=rtpmap:99 G726-32/8000 | |
| a=rtpmap:112 AAL2-G726-32/8000 | |
| a=rtpmap:18 G729/8000 | |
| a=fmtp:18 annexb=no | |
| a=rtpmap:101 telephone-event/8000 | |
| a=fmtp:101 0-15 | |
| a=ptime:20 | |
| a=sendrecv | |
| <-------------> | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 0 [ 34]: INVITE sip:777@10.47.20.42 SIP/2.0 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 1 [ 68]: Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-rbcyed51idab;rport | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 2 [ 55]: From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 3 [ 25]: To: <sip:777@10.47.20.42> | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 4 [ 52]: Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 5 [ 14]: CSeq: 2 INVITE | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 6 [ 16]: Max-Forwards: 70 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 7 [ 28]: User-Agent: snom320/8.7.5.17 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 8 [ 59]: Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 9 [ 28]: X-Serialnumber: 000413381C8C | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 10 [ 21]: P-Key-Flags: keys="3" | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 11 [ 23]: Accept: application/sdp | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 12 [ 96]: Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO, UPDATE | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 13 [ 42]: Allow-Events: talk, hold, refer, call-info | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 14 [ 47]: Supported: timer, 100rel, replaces, from-change | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 15 [ 21]: Session-Expires: 3600 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 16 [ 10]: Min-SE: 90 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 17 [154]: Authorization: Digest username="111",realm="asterisk",nonce="4f735554",uri="sip:777@10.47.20.42",response="9c35d242d4bcc62f7eeeea61f127d2bd",algorithm=MD5 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 18 [ 29]: Content-Type: application/sdp | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 19 [ 19]: Content-Length: 403 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 20 [ 0]: | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 0 [ 3]: v=0 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 1 [ 48]: o=root 1239629211 1239629211 IN IP4 10.47.22.251 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 2 [ 6]: s=call | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 3 [ 21]: c=IN IP4 10.47.22.251 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 4 [ 5]: t=0 0 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 5 [ 43]: m=audio 54830 RTP/AVP 9 0 8 3 99 112 18 101 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 6 [ 20]: a=rtpmap:9 G722/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 7 [ 20]: a=rtpmap:0 PCMU/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 8 [ 20]: a=rtpmap:8 PCMA/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 9 [ 19]: a=rtpmap:3 GSM/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 10 [ 24]: a=rtpmap:99 G726-32/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 11 [ 30]: a=rtpmap:112 AAL2-G726-32/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 12 [ 21]: a=rtpmap:18 G729/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 13 [ 19]: a=fmtp:18 annexb=no | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 14 [ 33]: a=rtpmap:101 telephone-event/8000 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 15 [ 15]: a=fmtp:101 0-15 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 16 [ 10]: a=ptime:20 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Body 17 [ 10]: a=sendrecv | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: --- (20 headers 18 lines) --- | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: = Looking for Call ID: 313434383437323731323534323736-psjp6zc12znr (Checking From) --From tag pleulbxibr --To-tag | |
| [Nov 25 18:31:54] DEBUG[1224] netsock2.c: Splitting '10.47.20.42' into... | |
| [Nov 25 18:31:54] DEBUG[1224] netsock2.c: ...host '10.47.20.42' and port ''. | |
| [Nov 25 18:31:54] DEBUG[1224] netsock2.c: Splitting '10.47.20.42' into... | |
| [Nov 25 18:31:54] DEBUG[1224] netsock2.c: ...host '10.47.20.42' and port ''. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: **** Received INVITE (5) - Command in SIP INVITE | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: Splitting '10.47.22.251:5060' into... | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: ...host '10.47.22.251' and port '5060'. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Sending to 10.47.22.251:5060 (no NAT) | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Initializing initreq for method INVITE - callid 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Using INVITE request as basis request - 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: Splitting '10.47.20.42' into... | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: ...host '10.47.20.42' and port ''. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found peer '111' for '111' from 10.47.22.251:5060 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Using engine 'asterisk' for RTP instance '0x7f981001ae58' | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] res_rtp_asterisk.c: Allocated port 17544 for RTP instance '0x7f981001ae58' | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: RTP instance '0x7f981001ae58' is setup and ready to go | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] res_rtp_asterisk.c: Setup RTCP on RTP instance '0x7f981001ae58' | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Setting NAT on RTP to Off | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing session-level SDP v=0... UNSUPPORTED OR FAILED. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing session-level SDP o=root 1239629211 1239629211 IN IP4 10.47.22.251... OK. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing session-level SDP s=call... UNSUPPORTED OR FAILED. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: Splitting '10.47.22.251' into... | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: ...host '10.47.22.251' and port ''. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing session-level SDP c=IN IP4 10.47.22.251... OK. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing session-level SDP t=0 0... UNSUPPORTED OR FAILED. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found RTP audio format 9 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Setting tx payload type 9 based on m type on 0x7f97f50602d0 | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found RTP audio format 0 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Setting tx payload type 0 based on m type on 0x7f97f50602d0 | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found RTP audio format 8 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Setting tx payload type 8 based on m type on 0x7f97f50602d0 | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found RTP audio format 3 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Setting tx payload type 3 based on m type on 0x7f97f50602d0 | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found RTP audio format 99 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Setting tx payload type 99 based on m type on 0x7f97f50602d0 | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found RTP audio format 112 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Setting tx payload type 112 based on m type on 0x7f97f50602d0 | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found RTP audio format 18 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Setting tx payload type 18 based on m type on 0x7f97f50602d0 | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found RTP audio format 101 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Setting tx payload type 101 based on m type on 0x7f97f50602d0 | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found audio description format G722 for ID 9 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=rtpmap:9 G722/8000... OK. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found audio description format PCMU for ID 0 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=rtpmap:0 PCMU/8000... OK. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found audio description format PCMA for ID 8 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=rtpmap:8 PCMA/8000... OK. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found audio description format GSM for ID 3 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=rtpmap:3 GSM/8000... OK. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found audio description format G726-32 for ID 99 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=rtpmap:99 G726-32/8000... OK. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found audio description format AAL2-G726-32 for ID 112 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=rtpmap:112 AAL2-G726-32/8000... OK. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found audio description format G729 for ID 18 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=rtpmap:18 G729/8000... OK. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=fmtp:18 annexb=no... OK. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Found audio description format telephone-event for ID 101 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=rtpmap:101 telephone-event/8000... OK. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=fmtp:101 0-15... UNSUPPORTED OR FAILED. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=ptime:20... OK. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Processing media-level (audio) SDP a=sendrecv... OK. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Capabilities: us - (ulaw|alaw|gsm), peer - audio=(ulaw|gsm|alaw|g722|g729|g726|g726aal2)/video=(nothing)/text=(nothing), combined - (ulaw|alaw|gsm) | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Non-codec capabilities (dtmf): us - 0x1 (telephone-event|), peer - 0x1 (telephone-event|), combined - 0x1 (telephone-event|) | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] res_rtp_asterisk.c: Setting RTCP address on RTP instance '0x7f981001ae58' | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Peer audio RTP is at port 10.47.22.251:54830 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Copying payload 0 (0x7f981000f670) from 0x7f97f50602d0 to 0x7f981001b020 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Copying payload 3 (0x7f9810024ee0) from 0x7f97f50602d0 to 0x7f981001b020 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Copying payload 8 (0x7f9810024ea0) from 0x7f97f50602d0 to 0x7f981001b020 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Copying payload 9 (0x7f981000f630) from 0x7f97f50602d0 to 0x7f981001b020 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Copying payload 18 (0x7f981000ddd0) from 0x7f97f50602d0 to 0x7f981001b020 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Copying payload 99 (0x7f98100147e0) from 0x7f97f50602d0 to 0x7f981001b020 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Copying payload 101 (0x7f981000dd90) from 0x7f97f50602d0 to 0x7f981001b020 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] rtp_engine.c: Copying payload 112 (0x7f9810014820) from 0x7f97f50602d0 to 0x7f981001b020 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] res_rtp_asterisk.c: Ignoring duplicate RTCP property on RTP instance '0x7f981001ae58' | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: We're settling with these formats: (ulaw|alaw|gsm) | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Checking SIP call limits for device 111 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Updating call counter for incoming call | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Call from peer '111' is 1 out of 2 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: Splitting '10.47.20.42' into... | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: ...host '10.47.20.42' and port ''. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: Splitting '10.47.20.42' into... | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] netsock2.c: ...host '10.47.20.42' and port ''. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: Looking for 777 in from_sip (domain 10.47.20.42) | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Incoming INVITE with 'timer' option supported | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: INVITE also has "Session-Expires" header. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Session-Expires: 3600 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: INVITE also has "Min-SE" header. | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Received Min-SE: 90 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: *** Our native formats are (ulaw) | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: *** Joint capabilities are (ulaw|alaw|gsm) | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: *** Our capabilities are (ulaw|alaw|gsm) | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: *** AST_CODEC_CHOOSE formats are ulaw | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: This channel will not be able to handle video. | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] sip/route.c: sip_route_dump: route/path hop: <sip:111@10.47.22.251:5060;line=n8nouw93> | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: SIP/111-00000037: New call is still down.... Trying... | |
| [Nov 25 18:31:54] VERBOSE[1224][C-00000056] chan_sip.c: | |
| <--- Transmitting (no NAT) to 10.47.22.251:5060 ---> | |
| SIP/2.0 100 Trying | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-rbcyed51idab;received=10.47.22.251;rport=5060 | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42> | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 2 INVITE | |
| Server: Asterisk PBX 13.6.0 | |
| Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| Supported: replaces, timer | |
| Session-Expires: 1800;refresher=uas | |
| Contact: <sip:777@10.47.20.42:5060> | |
| Content-Length: 0 | |
| <------------> | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Trying to put 'SIP/2.0 100' onto UDP socket destined for 10.47.22.251:5060 | |
| [Nov 25 18:31:54] DEBUG[1202] devicestate.c: No provider found, checking channel drivers for SIP - 111 | |
| [Nov 25 18:31:54] DEBUG[1202] chan_sip.c: Checking device state for peer 111 | |
| [Nov 25 18:31:54] DEBUG[1202] devicestate.c: Changing state for SIP/111 - state 2 (In use) | |
| [Nov 25 18:31:54] DEBUG[1202] devicestate.c: No provider found, checking channel drivers for SIP - 111 | |
| [Nov 25 18:31:54] DEBUG[1202] chan_sip.c: Checking device state for peer 111 | |
| [Nov 25 18:31:54] DEBUG[1202] devicestate.c: Changing state for SIP/111 - state 2 (In use) | |
| [Nov 25 18:31:54] DEBUG[1190] threadpool.c: Increasing threadpool stasis-core's size by 1 | |
| [Nov 25 18:31:54] DEBUG[1206] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1255] app_queue.c: Device 'SIP/111' changed to state '2' (In use) but we don't care because they're not a member of any queue. | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: CEL | |
| Privilege: call,all | |
| SequenceNumber: 4772 | |
| File: cel_manager.c | |
| Line: 299 | |
| Func: manager_log | |
| EventName: CHAN_START | |
| AccountCode: | |
| CallerIDnum: 111 | |
| CallerIDname: biw CC 111 | |
| CallerIDani: | |
| CallerIDrdnis: | |
| CallerIDdnid: | |
| Exten: 777 | |
| Context: from_sip | |
| Channel: SIP/111-00000037 | |
| Application: | |
| AppData: | |
| EventTime: 2015-11-25 18:31:54 | |
| AMAFlags: DOCUMENTATION | |
| UniqueID: 1448472714.504 | |
| LinkedID: 1448472714.504 | |
| Userfield: | |
| Peer: | |
| PeerAccount: | |
| Extra: | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: Newchannel | |
| Privilege: call,all | |
| SequenceNumber: 4773 | |
| File: manager_channels.c | |
| Line: 677 | |
| Func: channel_snapshot_update | |
| Channel: SIP/111-00000037 | |
| ChannelState: 0 | |
| ChannelStateDesc: Down | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: en | |
| AccountCode: | |
| Context: from_sip | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4774 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 0 | |
| ChannelStateDesc: Down | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: en | |
| AccountCode: | |
| Context: from_sip | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: SIPURI | |
| Value: sip:111@10.47.22.251:5060 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4775 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 0 | |
| ChannelStateDesc: Down | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: en | |
| AccountCode: | |
| Context: from_sip | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: SIPDOMAIN | |
| Value: 10.47.20.42 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4776 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 0 | |
| ChannelStateDesc: Down | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: en | |
| AccountCode: | |
| Context: from_sip | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: SIPCALLID | |
| Value: 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4777 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 0 | |
| ChannelStateDesc: Down | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: en | |
| AccountCode: | |
| Context: from_sip | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: basterisk | |
| Value: 1 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: Newstate | |
| Privilege: call,all | |
| SequenceNumber: 4778 | |
| File: manager_channels.c | |
| Line: 677 | |
| Func: channel_snapshot_update | |
| Channel: SIP/111-00000037 | |
| ChannelState: 4 | |
| ChannelStateDesc: Ring | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: from_sip | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: SuccessfulAuth | |
| Privilege: security,all | |
| SequenceNumber: 4779 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| EventTV: 2015-11-25T18:31:54.538+0100 | |
| Severity: Informational | |
| Service: SIP | |
| EventVersion: 1 | |
| AccountID: 777 | |
| SessionID: 0x7f981001d258 | |
| LocalAddress: IPV4/UDP/10.47.20.42/5060 | |
| RemoteAddress: IPV4/UDP/10.47.22.251/5060 | |
| UsingPassword: 1 | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] pbx.c: Result of 'EXTEN' is '777' | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] pbx.c: Launching 'NoOp' | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] pbx.c: Launching 'Set' | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] pbx.c: Result of 'EXTEN' is '777' | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] pbx.c: Launching 'Goto' | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] pbx.c: Launching 'AGI' | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: DeviceStateChange | |
| Privilege: call,all | |
| SequenceNumber: 4780 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Device: SIP/111 | |
| State: INUSE | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: Newexten | |
| Privilege: call,all | |
| SequenceNumber: 4781 | |
| File: manager_channels.c | |
| Line: 677 | |
| Func: channel_snapshot_update | |
| Channel: SIP/111-00000037 | |
| ChannelState: 4 | |
| ChannelStateDesc: Ring | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: from_sip | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Extension: 777 | |
| Application: NoOp | |
| AppData: Extension: 777 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: Newexten | |
| Privilege: call,all | |
| SequenceNumber: 4782 | |
| File: manager_channels.c | |
| Line: 677 | |
| Func: channel_snapshot_update | |
| Channel: SIP/111-00000037 | |
| ChannelState: 4 | |
| ChannelStateDesc: Ring | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: from_sip | |
| Exten: 777 | |
| Priority: 2 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Extension: 777 | |
| Application: Set | |
| AppData: AGI_HOST=127.0.0.1 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4783 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 4 | |
| ChannelStateDesc: Ring | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: from_sip | |
| Exten: 777 | |
| Priority: 2 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: AGI_HOST | |
| Value: 127.0.0.1 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: Newexten | |
| Privilege: call,all | |
| SequenceNumber: 4784 | |
| File: manager_channels.c | |
| Line: 677 | |
| Func: channel_snapshot_update | |
| Channel: SIP/111-00000037 | |
| ChannelState: 4 | |
| ChannelStateDesc: Ring | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: from_sip | |
| Exten: 777 | |
| Priority: 3 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Extension: 777 | |
| Application: Goto | |
| AppData: menu_test,777,1 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: Newexten | |
| Privilege: call,all | |
| SequenceNumber: 4785 | |
| File: manager_channels.c | |
| Line: 677 | |
| Func: channel_snapshot_update | |
| Channel: SIP/111-00000037 | |
| ChannelState: 4 | |
| ChannelStateDesc: Ring | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Extension: 777 | |
| Application: AGI | |
| AppData: agi:async | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AsyncAGIStart | |
| Privilege: agi,all | |
| SequenceNumber: 4786 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 4 | |
| ChannelStateDesc: Ring | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Env: agi_request%3A%20async%0Aagi_channel%3A%20SIP%2F111-00000037%0Aagi_language%3A%20de%0Aagi_type%3A%20SIP%0Aagi_uniqueid%3A%201448472714.504%0Aagi_version%3A%2013.6.0%0Aagi_callerid%3A%20111%0Aagi_calleridname%3A%20biw%20CC%20111%0Aagi_callingpres%3A%200%0Aagi_callingani2%3A%200%0Aagi_callington%3A%200%0Aagi_callingtns%3A%200%0Aagi_dnid%3A%20777%0Aagi_rdnis%3A%20unknown%0Aagi_context%3A%20menu_test%0Aagi_extension%3A%20777%0Aagi_priority%3A%201%0Aagi_enhanced%3A%200.0%0Aagi_accountcode%3A%20%0Aagi_threadid%3A%20140292152915712%0A%0A | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Running action 'AGI' | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: | |
| <--- SIP read from UDP:10.47.22.251:5060 ---> | |
| ACK sip:777@10.47.20.42 SIP/2.0 | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-1mml8pt1f2tk;rport | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42>;tag=as3f752e4b | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 1 ACK | |
| Max-Forwards: 70 | |
| User-Agent: snom320/8.7.5.17 | |
| Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| Content-Length: 0 | |
| <-------------> | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 0 [ 31]: ACK sip:777@10.47.20.42 SIP/2.0 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 1 [ 68]: Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-1mml8pt1f2tk;rport | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 2 [ 55]: From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 3 [ 40]: To: <sip:777@10.47.20.42>;tag=as3f752e4b | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 4 [ 52]: Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 5 [ 11]: CSeq: 1 ACK | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 6 [ 16]: Max-Forwards: 70 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 7 [ 28]: User-Agent: snom320/8.7.5.17 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 8 [ 59]: Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 9 [ 17]: Content-Length: 0 | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: --- (10 headers 0 lines) --- | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: = Looking for Call ID: 313434383437323731323534323736-psjp6zc12znr (Checking From) --From tag pleulbxibr --To-tag as3f752e4b | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Invalid SIP message - rejected , no callid, len 387 | |
| [Nov 25 18:31:54] VERBOSE[13946][C-00000056] chan_sip.c: | |
| <--- Transmitting (no NAT) to 10.47.22.251:5060 ---> | |
| SIP/2.0 180 Ringing | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-rbcyed51idab;received=10.47.22.251;rport=5060 | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42>;tag=as4a35a0d4 | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 2 INVITE | |
| Server: Asterisk PBX 13.6.0 | |
| Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| Supported: replaces, timer | |
| Session-Expires: 1800;refresher=uas | |
| Contact: <sip:777@10.47.20.42:5060> | |
| Content-Length: 0 | |
| <------------> | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] chan_sip.c: Trying to put 'SIP/2.0 180' onto UDP socket destined for 10.47.22.251:5060 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AGIExecStart | |
| Privilege: agi,all | |
| SequenceNumber: 4787 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 4 | |
| ChannelStateDesc: Ring | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| CommandId: 1427323525 | |
| Command: EXEC RINGING | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AGIExecEnd | |
| Privilege: agi,all | |
| SequenceNumber: 4788 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 4 | |
| ChannelStateDesc: Ring | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| CommandId: 1427323525 | |
| Command: EXEC RINGING | |
| ResultCode: 200 | |
| Result: Success | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AsyncAGIExec | |
| Privilege: agi,all | |
| SequenceNumber: 4789 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 4 | |
| ChannelStateDesc: Ring | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Result: 200%20result%3D0%0A | |
| CommandId: 191ee6d3-16c7-41a9-bd0c-aaf6d581aa61 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Running action 'AGI' | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] chan_sip.c: SIP answering channel: SIP/111-00000037 | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] res_rtp_asterisk.c: Setting the marker bit due to a source update | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] chan_sip.c: Setting framing from config on incoming call | |
| [Nov 25 18:31:54] DEBUG[1202] devicestate.c: No provider found, checking channel drivers for SIP - 111 | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] chan_sip.c: ** Our capability: (ulaw|alaw|gsm) Video flag: True Text flag: True | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] chan_sip.c: ** Our prefcodec: (nothing) | |
| [Nov 25 18:31:54] DEBUG[1202] chan_sip.c: Checking device state for peer 111 | |
| [Nov 25 18:31:54] DEBUG[1202] devicestate.c: Changing state for SIP/111 - state 2 (In use) | |
| [Nov 25 18:31:54] VERBOSE[13946][C-00000056] chan_sip.c: Audio is at 17544 | |
| [Nov 25 18:31:54] VERBOSE[13946][C-00000056] chan_sip.c: Adding codec ulaw to SDP | |
| [Nov 25 18:31:54] VERBOSE[13946][C-00000056] chan_sip.c: Adding codec alaw to SDP | |
| [Nov 25 18:31:54] VERBOSE[13946][C-00000056] chan_sip.c: Adding codec gsm to SDP | |
| [Nov 25 18:31:54] VERBOSE[13946][C-00000056] chan_sip.c: Adding non-codec 0x1 (telephone-event) to SDP | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] chan_sip.c: -- Done with adding codecs to SDP | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] chan_sip.c: Done building SDP. Settling with this capability: (ulaw|alaw|gsm) | |
| [Nov 25 18:31:54] VERBOSE[13946][C-00000056] chan_sip.c: | |
| <--- Reliably Transmitting (no NAT) to 10.47.22.251:5060 ---> | |
| SIP/2.0 200 OK | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-rbcyed51idab;received=10.47.22.251;rport=5060 | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42>;tag=as4a35a0d4 | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 2 INVITE | |
| Server: Asterisk PBX 13.6.0 | |
| Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| Supported: replaces, timer | |
| Session-Expires: 1800;refresher=uas | |
| Contact: <sip:777@10.47.20.42:5060> | |
| Content-Type: application/sdp | |
| Require: timer | |
| Content-Length: 284 | |
| v=0 | |
| o=root 1261643556 1261643556 IN IP4 10.47.20.42 | |
| s=Asterisk PBX 13.6.0 | |
| c=IN IP4 10.47.20.42 | |
| t=0 0 | |
| m=audio 17544 RTP/AVP 0 8 3 101 | |
| a=rtpmap:0 PCMU/8000 | |
| a=rtpmap:8 PCMA/8000 | |
| a=rtpmap:3 GSM/8000 | |
| a=rtpmap:101 telephone-event/8000 | |
| a=fmtp:101 0-16 | |
| a=maxptime:150 | |
| a=sendrecv | |
| <------------> | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] chan_sip.c: *** SIP TIMER: Initializing retransmit timer on packet: Id #11 | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] chan_sip.c: Trying to put 'SIP/2.0 200' onto UDP socket destined for 10.47.22.251:5060 | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] chan_sip.c: Session timer started: 6 - 313434383437323731323534323736-psjp6zc12znr 900000ms | |
| [Nov 25 18:31:54] DEBUG[1206] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: CEL | |
| Privilege: call,all | |
| SequenceNumber: 4790 | |
| File: cel_manager.c | |
| Line: 299 | |
| Func: manager_log | |
| EventName: ANSWER | |
| AccountCode: | |
| CallerIDnum: 111 | |
| CallerIDname: biw CC 111 | |
| CallerIDani: 111 | |
| CallerIDrdnis: | |
| CallerIDdnid: 777 | |
| Exten: 777 | |
| Context: menu_test | |
| Channel: SIP/111-00000037 | |
| Application: AGI | |
| AppData: agi:async | |
| EventTime: 2015-11-25 18:31:54 | |
| AMAFlags: DOCUMENTATION | |
| UniqueID: 1448472714.504 | |
| LinkedID: 1448472714.504 | |
| Userfield: | |
| Peer: | |
| PeerAccount: | |
| Extra: | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AGIExecStart | |
| Privilege: agi,all | |
| SequenceNumber: 4791 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 4 | |
| ChannelStateDesc: Ring | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| CommandId: 1388495162 | |
| Command: ANSWER | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: Newstate | |
| Privilege: call,all | |
| SequenceNumber: 4792 | |
| File: manager_channels.c | |
| Line: 677 | |
| Func: channel_snapshot_update | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: | |
| <--- SIP read from UDP:10.47.22.251:5060 ---> | |
| ACK sip:777@10.47.20.42:5060 SIP/2.0 | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-0sx01qslan4s;rport | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42>;tag=as4a35a0d4 | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 2 ACK | |
| Max-Forwards: 70 | |
| User-Agent: snom320/8.7.5.17 | |
| Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| Content-Length: 0 | |
| <-------------> | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 0 [ 36]: ACK sip:777@10.47.20.42:5060 SIP/2.0 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 1 [ 68]: Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-0sx01qslan4s;rport | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 2 [ 55]: From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 3 [ 40]: To: <sip:777@10.47.20.42>;tag=as4a35a0d4 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 4 [ 52]: Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 5 [ 11]: CSeq: 2 ACK | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 6 [ 16]: Max-Forwards: 70 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 7 [ 28]: User-Agent: snom320/8.7.5.17 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 8 [ 59]: Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: Header 9 [ 17]: Content-Length: 0 | |
| [Nov 25 18:31:54] VERBOSE[1224] chan_sip.c: --- (10 headers 0 lines) --- | |
| [Nov 25 18:31:54] DEBUG[1224] chan_sip.c: = Looking for Call ID: 313434383437323731323534323736-psjp6zc12znr (Checking From) --From tag pleulbxibr --To-tag as4a35a0d4 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: **** Received ACK (6) - Command in SIP ACK | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #11 | |
| [Nov 25 18:31:54] DEBUG[1224][C-00000056] chan_sip.c: Stopping retransmission on '313434383437323731323534323736-psjp6zc12znr' of Response 2: Match Found | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] res_rtp_asterisk.c: Got RTCP report of 48 bytes | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] acl.c: Not an IPv4 nor IPv6 address, cannot get port. | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] netsock2.c: Splitting 'callcenter-centos7-dit' into... | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] netsock2.c: ...host 'callcenter-centos7-dit' and port ''. | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] acl.c: Not an IPv4 nor IPv6 address, cannot get port. | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] acl.c: Attached to given IP address | |
| [Nov 25 18:31:54] DEBUG[1254] netsock2.c: Splitting '10.47.22.251:54831' into... | |
| [Nov 25 18:31:54] DEBUG[1254] netsock2.c: ...host '10.47.22.251' and port '54831'. | |
| [Nov 25 18:31:54] DEBUG[1254] netsock2.c: Splitting '10.47.20.42:0' into... | |
| [Nov 25 18:31:54] DEBUG[1254] netsock2.c: ...host '10.47.20.42' and port '0'. | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: RTCPReceived | |
| Privilege: reporting,all | |
| SequenceNumber: 4793 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| To: 10.47.20.42:0 | |
| From: 10.47.22.251:54831 | |
| RTT: 0.0000 | |
| SSRC: 0x4e836d04 | |
| PT: 201(RR) | |
| ReportCount: 1 | |
| Report0SourceSSRC: 0x6874cb52 | |
| Report0FractionLost: 0 | |
| Report0CumulativeLost: 0 | |
| Report0HighestSequence: 0 | |
| Report0SequenceNumberCycles: 0 | |
| Report0IAJitter: 0 | |
| Report0LSR: 0 | |
| Report0DLSR: 0.0000 | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] res_rtp_asterisk.c: 0x7f9810026a70 -- Probation learning mode pass with source address 10.47.22.251:54830 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AGIExecEnd | |
| Privilege: agi,all | |
| SequenceNumber: 4794 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| CommandId: 1388495162 | |
| Command: ANSWER | |
| ResultCode: 200 | |
| Result: Success | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AsyncAGIExec | |
| Privilege: agi,all | |
| SequenceNumber: 4795 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Result: 200%20result%3D0%0A | |
| CommandId: 420e4b74-6203-436f-ab78-859207f77c08 | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Running action 'AGI' | |
| [Nov 25 18:31:54] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] channel.c: Channel SIP/111-00000037 setting write format path: gsm -> ulaw | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] res_rtp_asterisk.c: Ooh, format changed from none to ulaw | |
| [Nov 25 18:31:54] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (50 requested / 50 actual) timer ticks per second | |
| [Nov 25 18:31:54] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AGIExecStart | |
| Privilege: agi,all | |
| SequenceNumber: 4796 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| CommandId: 1948518814 | |
| Command: EXEC Playback "vm-press&vm-first&vm-for&vm-password" | |
| [Nov 25 18:31:55] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:55] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:55] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:55] DEBUG[13946][C-00000056] channel.c: Channel SIP/111-00000037 setting write format path: ulaw -> ulaw | |
| [Nov 25 18:31:55] DEBUG[13946][C-00000056] channel.c: Channel SIP/111-00000037 setting write format path: gsm -> ulaw | |
| [Nov 25 18:31:55] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (50 requested / 50 actual) timer ticks per second | |
| [Nov 25 18:31:55] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Channel SIP/111-00000037 setting write format path: ulaw -> ulaw | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Channel SIP/111-00000037 setting write format path: gsm -> ulaw | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (50 requested / 50 actual) timer ticks per second | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] res_rtp_asterisk.c: Creating BEGIN DTMF Frame: 49 (1), at 10.47.22.251:54830 | |
| [Nov 25 18:31:56] DTMF[13946][C-00000056] channel.c: DTMF begin '1' received on SIP/111-00000037 | |
| [Nov 25 18:31:56] DTMF[13946][C-00000056] channel.c: DTMF begin ignored '1' on SIP/111-00000037 | |
| [Nov 25 18:31:56] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: DTMFBegin | |
| Privilege: dtmf,all | |
| SequenceNumber: 4797 | |
| File: manager_channels.c | |
| Line: 831 | |
| Func: channel_dtmf_begin_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Digit: 1 | |
| Direction: Received | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] res_rtp_asterisk.c: Creating END DTMF Frame: 49 (1), at 10.47.22.251:54830 | |
| [Nov 25 18:31:56] DTMF[13946][C-00000056] channel.c: DTMF end '1' received on SIP/111-00000037, duration 120 ms | |
| [Nov 25 18:31:56] DTMF[13946][C-00000056] channel.c: DTMF end passthrough '1' on SIP/111-00000037 | |
| [Nov 25 18:31:56] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: DTMFEnd | |
| Privilege: dtmf,all | |
| SequenceNumber: 4798 | |
| File: manager_channels.c | |
| Line: 878 | |
| Func: channel_dtmf_end_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Digit: 1 | |
| DurationMs: 120 | |
| Direction: Received | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Running action 'Redirect' | |
| [Nov 25 18:31:56] DEBUG[13945] channel.c: Soft-Hanging (0x02) up channel 'SIP/111-00000037' | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Channel SIP/111-00000037 setting write format path: ulaw -> ulaw | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Channel SIP/111-00000037 setting write format path: gsm -> ulaw | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] file.c: Failed to write frame | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:56] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:56] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:56] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4799 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: PLAYBACKSTATUS | |
| Value: FAILED | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AGIExecEnd | |
| Privilege: agi,all | |
| SequenceNumber: 4800 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| CommandId: 1948518814 | |
| Command: EXEC Playback "vm-press&vm-first&vm-for&vm-password" | |
| ResultCode: 200 | |
| Result: Success | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AsyncAGIExec | |
| Privilege: agi,all | |
| SequenceNumber: 4801 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Result: 200%20result%3D0%0A | |
| CommandId: 81099210-44b0-4c0d-980f-97211b85977d | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] res_agi.c: No frame read on channel SIP/111-00000037, going out ... | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] pbx.c: Spawn extension (adhearsion-redirect,1,1) exited non-zero on 'SIP/111-00000037' | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] pbx.c: Launching 'AGI' | |
| [Nov 25 18:31:56] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:56] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:56] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:56] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AsyncAGIEnd | |
| Privilege: agi,all | |
| SequenceNumber: 4802 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| (null): | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4803 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: menu_test | |
| Exten: 777 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: AGISTATUS | |
| Value: HANGUP | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: Newexten | |
| Privilege: call,all | |
| SequenceNumber: 4804 | |
| File: manager_channels.c | |
| Line: 677 | |
| Func: channel_snapshot_update | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Extension: 1 | |
| Application: AGI | |
| AppData: agi:async | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AsyncAGIStart | |
| Privilege: agi,all | |
| SequenceNumber: 4805 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Env: agi_request%3A%20async%0Aagi_channel%3A%20SIP%2F111-00000037%0Aagi_language%3A%20de%0Aagi_type%3A%20SIP%0Aagi_uniqueid%3A%201448472714.504%0Aagi_version%3A%2013.6.0%0Aagi_callerid%3A%20111%0Aagi_calleridname%3A%20biw%20CC%20111%0Aagi_callingpres%3A%200%0Aagi_callingani2%3A%200%0Aagi_callington%3A%200%0Aagi_callingtns%3A%200%0Aagi_dnid%3A%20777%0Aagi_rdnis%3A%20unknown%0Aagi_context%3A%20adhearsion-redirect%0Aagi_extension%3A%201%0Aagi_priority%3A%201%0Aagi_enhanced%3A%200.0%0Aagi_accountcode%3A%20%0Aagi_threadid%3A%20140292152915712%0A%0A | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Running action 'AGI' | |
| [Nov 25 18:31:56] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Channel SIP/111-00000037 setting write format path: ulaw -> ulaw | |
| [Nov 25 18:31:56] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AGIExecStart | |
| Privilege: agi,all | |
| SequenceNumber: 4806 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| CommandId: 2103661936 | |
| Command: EXEC Playback "vm-pls-try-again" | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Channel SIP/111-00000037 setting write format path: gsm -> ulaw | |
| [Nov 25 18:31:56] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (50 requested / 50 actual) timer ticks per second | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Allocating new SIP dialog for 02f1f9922afd5f41386837172ec4b778@10.47.20.42:5060 - OPTIONS (No RTP) | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: OBPROXY: Not applying OBproxy to this call | |
| [Nov 25 18:31:57] DEBUG[1224] acl.c: For destination '10.47.22.251', our source address is '10.47.20.42'. | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Setting AST_TRANSPORT_UDP with address 10.47.20.42:5060 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: SIP call-id changed from '02f1f9922afd5f41386837172ec4b778@10.47.20.42:5060' to '3eaf9d905d4f342537919e7f70e3b93d@10.47.20.42:5060' | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Initializing initreq for method OPTIONS - callid 3eaf9d905d4f342537919e7f70e3b93d@10.47.20.42:5060 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 0 [ 55]: OPTIONS sip:111@10.47.22.251:5060;line=n8nouw93 SIP/2.0 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 1 [ 56]: Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK3b8f5d29 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 2 [ 16]: Max-Forwards: 70 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 3 [ 58]: From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as687f8ac4 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 4 [ 45]: To: <sip:111@10.47.22.251:5060;line=n8nouw93> | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 5 [ 40]: Contact: <sip:asterisk@10.47.20.42:5060> | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 6 [ 58]: Call-ID: 3eaf9d905d4f342537919e7f70e3b93d@10.47.20.42:5060 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 7 [ 17]: CSeq: 102 OPTIONS | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 8 [ 31]: User-Agent: Asterisk PBX 13.6.0 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 9 [ 35]: Date: Wed, 25 Nov 2015 17:31:57 GMT | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 10 [ 90]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 11 [ 26]: Supported: replaces, timer | |
| [Nov 25 18:31:57] VERBOSE[1224] chan_sip.c: Reliably Transmitting (no NAT) to 10.47.22.251:5060: | |
| OPTIONS sip:111@10.47.22.251:5060;line=n8nouw93 SIP/2.0 | |
| Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK3b8f5d29 | |
| Max-Forwards: 70 | |
| From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as687f8ac4 | |
| To: <sip:111@10.47.22.251:5060;line=n8nouw93> | |
| Contact: <sip:asterisk@10.47.20.42:5060> | |
| Call-ID: 3eaf9d905d4f342537919e7f70e3b93d@10.47.20.42:5060 | |
| CSeq: 102 OPTIONS | |
| User-Agent: Asterisk PBX 13.6.0 | |
| Date: Wed, 25 Nov 2015 17:31:57 GMT | |
| Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| Supported: replaces, timer | |
| Content-Length: 0 | |
| --- | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: *** SIP TIMER: Initializing retransmit timer on packet: Id #12 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Trying to put 'OPTIONS sip' onto UDP socket destined for 10.47.22.251:5060 | |
| [Nov 25 18:31:57] VERBOSE[1224] chan_sip.c: | |
| <--- SIP read from UDP:10.47.22.251:5060 ---> | |
| SIP/2.0 200 OK | |
| Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK3b8f5d29 | |
| From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as687f8ac4 | |
| To: <sip:111@10.47.22.251:5060;line=n8nouw93>;tag=yr83d3b0pr | |
| Call-ID: 3eaf9d905d4f342537919e7f70e3b93d@10.47.20.42:5060 | |
| CSeq: 102 OPTIONS | |
| User-Agent: snom320/8.7.5.17 | |
| Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| Accept-Language: en | |
| Accept: application/sdp | |
| Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO, UPDATE | |
| Allow-Events: talk, hold, refer, call-info | |
| Supported: timer, 100rel, replaces, from-change | |
| Content-Length: 0 | |
| <-------------> | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 0 [ 14]: SIP/2.0 200 OK | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 1 [ 56]: Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK3b8f5d29 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 2 [ 58]: From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as687f8ac4 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 3 [ 60]: To: <sip:111@10.47.22.251:5060;line=n8nouw93>;tag=yr83d3b0pr | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 4 [ 58]: Call-ID: 3eaf9d905d4f342537919e7f70e3b93d@10.47.20.42:5060 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 5 [ 17]: CSeq: 102 OPTIONS | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 6 [ 28]: User-Agent: snom320/8.7.5.17 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 7 [ 59]: Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 8 [ 19]: Accept-Language: en | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 9 [ 23]: Accept: application/sdp | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 10 [ 96]: Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO, UPDATE | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 11 [ 42]: Allow-Events: talk, hold, refer, call-info | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 12 [ 47]: Supported: timer, 100rel, replaces, from-change | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Header 13 [ 17]: Content-Length: 0 | |
| [Nov 25 18:31:57] VERBOSE[1224] chan_sip.c: --- (14 headers 0 lines) --- | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: = Looking for Call ID: 3eaf9d905d4f342537919e7f70e3b93d@10.47.20.42:5060 (Checking To) --From tag as687f8ac4 --To-tag yr83d3b0pr | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #12 | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Stopping retransmission on '3eaf9d905d4f342537919e7f70e3b93d@10.47.20.42:5060' of Request 102: Match Found | |
| [Nov 25 18:31:57] DEBUG[1224] chan_sip.c: Destroying SIP dialog 3eaf9d905d4f342537919e7f70e3b93d@10.47.20.42:5060 | |
| [Nov 25 18:31:57] VERBOSE[1224] chan_sip.c: Really destroying SIP dialog '3eaf9d905d4f342537919e7f70e3b93d@10.47.20.42:5060' Method: OPTIONS | |
| [Nov 25 18:31:57] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:57] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:57] DEBUG[13946][C-00000056] channel.c: Scheduling timer at (0 requested / 0 actual) timer ticks per second | |
| [Nov 25 18:31:57] DEBUG[13946][C-00000056] channel.c: Channel SIP/111-00000037 setting write format path: ulaw -> ulaw | |
| [Nov 25 18:31:57] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:57] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:57] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:57] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4807 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: PLAYBACKSTATUS | |
| Value: SUCCESS | |
| [Nov 25 18:31:57] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AGIExecEnd | |
| Privilege: agi,all | |
| SequenceNumber: 4808 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| CommandId: 2103661936 | |
| Command: EXEC Playback "vm-pls-try-again" | |
| ResultCode: 200 | |
| Result: Success | |
| [Nov 25 18:31:57] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AsyncAGIExec | |
| Privilege: agi,all | |
| SequenceNumber: 4809 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Result: 200%20result%3D0%0A | |
| CommandId: f8d6d8d0-3e4c-48cb-95b1-ebac21d4b7a1 | |
| [Nov 25 18:31:59] DEBUG[13946][C-00000056] res_rtp_asterisk.c: Got RTCP report of 68 bytes | |
| [Nov 25 18:31:59] DEBUG[13946][C-00000056] acl.c: Not an IPv4 nor IPv6 address, cannot get port. | |
| [Nov 25 18:31:59] DEBUG[13946][C-00000056] netsock2.c: Splitting 'callcenter-centos7-dit' into... | |
| [Nov 25 18:31:59] DEBUG[13946][C-00000056] netsock2.c: ...host 'callcenter-centos7-dit' and port ''. | |
| [Nov 25 18:31:59] DEBUG[13946][C-00000056] acl.c: Not an IPv4 nor IPv6 address, cannot get port. | |
| [Nov 25 18:31:59] DEBUG[13946][C-00000056] acl.c: Attached to given IP address | |
| [Nov 25 18:31:59] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:59] DEBUG[1254] netsock2.c: Splitting '10.47.22.251:54831' into... | |
| [Nov 25 18:31:59] DEBUG[1254] netsock2.c: ...host '10.47.22.251' and port '54831'. | |
| [Nov 25 18:31:59] DEBUG[1254] netsock2.c: Splitting '10.47.20.42:0' into... | |
| [Nov 25 18:31:59] DEBUG[1254] netsock2.c: ...host '10.47.20.42' and port '0'. | |
| [Nov 25 18:31:59] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: RTCPReceived | |
| Privilege: reporting,all | |
| SequenceNumber: 4810 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| To: 10.47.20.42:0 | |
| From: 10.47.22.251:54831 | |
| RTT: 0.0000 | |
| SSRC: 0x4e836d04 | |
| PT: 200(SR) | |
| ReportCount: 1 | |
| SentNTP: 2085997555.17588806266880 | |
| SentRTP: 51423512 | |
| SentPackets: 238 | |
| SentOctets: 36832 | |
| Report0SourceSSRC: 0x4a5b6e47 | |
| Report0FractionLost: 0 | |
| Report0CumulativeLost: 0 | |
| Report0HighestSequence: 29560 | |
| Report0SequenceNumberCycles: 0 | |
| Report0IAJitter: 4 | |
| Report0LSR: 0 | |
| Report0DLSR: 0.0000 | |
| [Nov 25 18:31:59] DEBUG[1224] acl.c: Not an IPv4 nor IPv6 address, cannot get port. | |
| [Nov 25 18:31:59] DEBUG[1224] netsock2.c: Splitting 'callcenter-centos7-dit' into... | |
| [Nov 25 18:31:59] DEBUG[1224] netsock2.c: ...host 'callcenter-centos7-dit' and port ''. | |
| [Nov 25 18:31:59] DEBUG[1224] acl.c: Not an IPv4 nor IPv6 address, cannot get port. | |
| [Nov 25 18:31:59] DEBUG[1224] acl.c: Attached to given IP address | |
| [Nov 25 18:31:59] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:31:59] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: RTCPSent | |
| Privilege: reporting,all | |
| SequenceNumber: 4811 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| To: 10.47.22.251:54831 | |
| From: 10.47.20.42:0 | |
| SSRC: 0x4a5b6e47 | |
| PT: 200(SR) | |
| ReportCount: 1 | |
| SentNTP: 1448472719.3938312192 | |
| SentRTP: 22880 | |
| SentPackets: 143 | |
| SentOctets: 22880 | |
| Report0SourceSSRC: 0x4e836d04 | |
| Report0FractionLost: 0 | |
| Report0CumulativeLost: 0 | |
| Report0HighestSequence: 26347 | |
| Report0SequenceNumberCycles: 0 | |
| Report0IAJitter: 0 | |
| Report0LSR: 1249056391 | |
| Report0DLSR: 0.1120 | |
| [Nov 25 18:31:59] DEBUG[1254] netsock2.c: Splitting '10.47.20.42:0' into... | |
| [Nov 25 18:31:59] DEBUG[1254] netsock2.c: ...host '10.47.20.42' and port '0'. | |
| [Nov 25 18:31:59] DEBUG[1254] netsock2.c: Splitting '10.47.22.251:54831' into... | |
| [Nov 25 18:31:59] DEBUG[1254] netsock2.c: ...host '10.47.22.251' and port '54831'. | |
| [Nov 25 18:32:00] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:04] DEBUG[13946][C-00000056] res_rtp_asterisk.c: Got RTCP report of 68 bytes | |
| [Nov 25 18:32:04] DEBUG[13946][C-00000056] acl.c: Not an IPv4 nor IPv6 address, cannot get port. | |
| [Nov 25 18:32:04] DEBUG[13946][C-00000056] netsock2.c: Splitting 'callcenter-centos7-dit' into... | |
| [Nov 25 18:32:04] DEBUG[13946][C-00000056] netsock2.c: ...host 'callcenter-centos7-dit' and port ''. | |
| [Nov 25 18:32:04] DEBUG[13946][C-00000056] acl.c: Not an IPv4 nor IPv6 address, cannot get port. | |
| [Nov 25 18:32:04] DEBUG[13946][C-00000056] acl.c: Attached to given IP address | |
| [Nov 25 18:32:04] DEBUG[1254] netsock2.c: Splitting '10.47.22.251:54831' into... | |
| [Nov 25 18:32:04] DEBUG[1254] netsock2.c: ...host '10.47.22.251' and port '54831'. | |
| [Nov 25 18:32:04] DEBUG[1254] netsock2.c: Splitting '10.47.20.42:0' into... | |
| [Nov 25 18:32:04] DEBUG[1254] netsock2.c: ...host '10.47.20.42' and port '0'. | |
| [Nov 25 18:32:04] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:04] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: RTCPReceived | |
| Privilege: reporting,all | |
| SequenceNumber: 4812 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| To: 10.47.20.42:0 | |
| From: 10.47.22.251:54831 | |
| RTT: 69787.7496 | |
| SSRC: 0x4e836d04 | |
| PT: 200(SR) | |
| ReportCount: 1 | |
| SentNTP: 2085997565.17588806266880 | |
| SentRTP: 51423512 | |
| SentPackets: 488 | |
| SentOctets: 76832 | |
| Report0SourceSSRC: 0x4a5b6e47 | |
| Report0FractionLost: 0 | |
| Report0CumulativeLost: 0 | |
| Report0HighestSequence: 29560 | |
| Report0SequenceNumberCycles: 0 | |
| Report0IAJitter: 4 | |
| Report0LSR: 1863317029 | |
| Report0DLSR: 33.0710 | |
| [Nov 25 18:32:04] DEBUG[1224] acl.c: Not an IPv4 nor IPv6 address, cannot get port. | |
| [Nov 25 18:32:04] DEBUG[1224] netsock2.c: Splitting 'callcenter-centos7-dit' into... | |
| [Nov 25 18:32:04] DEBUG[1224] netsock2.c: ...host 'callcenter-centos7-dit' and port ''. | |
| [Nov 25 18:32:04] DEBUG[1224] acl.c: Not an IPv4 nor IPv6 address, cannot get port. | |
| [Nov 25 18:32:04] DEBUG[1224] acl.c: Attached to given IP address | |
| [Nov 25 18:32:04] DEBUG[1254] netsock2.c: Splitting '10.47.20.42:0' into... | |
| [Nov 25 18:32:04] DEBUG[1254] netsock2.c: ...host '10.47.20.42' and port '0'. | |
| [Nov 25 18:32:04] DEBUG[1254] netsock2.c: Splitting '10.47.22.251:54831' into... | |
| [Nov 25 18:32:04] DEBUG[1254] netsock2.c: ...host '10.47.22.251' and port '54831'. | |
| [Nov 25 18:32:04] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:04] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: RTCPSent | |
| Privilege: reporting,all | |
| SequenceNumber: 4813 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| To: 10.47.22.251:54831 | |
| From: 10.47.20.42:0 | |
| SSRC: 0x4a5b6e47 | |
| PT: 201(RR) | |
| ReportCount: 1 | |
| Report0SourceSSRC: 0x4e836d04 | |
| Report0FractionLost: 0 | |
| Report0CumulativeLost: 0 | |
| Report0HighestSequence: 26597 | |
| Report0SequenceNumberCycles: 0 | |
| Report0IAJitter: 1 | |
| Report0LSR: 1249711751 | |
| Report0DLSR: 0.1120 | |
| [Nov 25 18:32:05] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] VERBOSE[1224] chan_sip.c: | |
| <--- SIP read from UDP:10.47.22.251:5060 ---> | |
| BYE sip:777@10.47.20.42:5060 SIP/2.0 | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-9g6js73uq367;rport | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42>;tag=as4a35a0d4 | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 3 BYE | |
| Max-Forwards: 70 | |
| User-Agent: snom320/8.7.5.17 | |
| Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| RTP-RxStat: Total_Rx_Pkts=143,Rx_Pkts=143,Rx_Pkts_Lost=0,Remote_Rx_Pkts_Lost=0 | |
| RTP-TxStat: Total_Tx_Pkts=713,Tx_Pkts=713,Remote_Tx_Pkts=143 | |
| Content-Length: 0 | |
| <-------------> | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 0 [ 36]: BYE sip:777@10.47.20.42:5060 SIP/2.0 | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 1 [ 68]: Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-9g6js73uq367;rport | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 2 [ 55]: From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 3 [ 40]: To: <sip:777@10.47.20.42>;tag=as4a35a0d4 | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 4 [ 52]: Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 5 [ 11]: CSeq: 3 BYE | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 6 [ 16]: Max-Forwards: 70 | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 7 [ 28]: User-Agent: snom320/8.7.5.17 | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 8 [ 59]: Contact: <sip:111@10.47.22.251:5060;line=n8nouw93>;reg-id=1 | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 9 [ 78]: RTP-RxStat: Total_Rx_Pkts=143,Rx_Pkts=143,Rx_Pkts_Lost=0,Remote_Rx_Pkts_Lost=0 | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 10 [ 60]: RTP-TxStat: Total_Tx_Pkts=713,Tx_Pkts=713,Remote_Tx_Pkts=143 | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: Header 11 [ 17]: Content-Length: 0 | |
| [Nov 25 18:32:09] VERBOSE[1224] chan_sip.c: --- (12 headers 0 lines) --- | |
| [Nov 25 18:32:09] DEBUG[1224] chan_sip.c: = Looking for Call ID: 313434383437323731323534323736-psjp6zc12znr (Checking From) --From tag pleulbxibr --To-tag as4a35a0d4 | |
| [Nov 25 18:32:09] DEBUG[1224][C-00000056] chan_sip.c: **** Received BYE (8) - Command in SIP BYE | |
| [Nov 25 18:32:09] DEBUG[1224][C-00000056] chan_sip.c: Initializing initreq for method BYE - callid 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:32:09] DEBUG[1224][C-00000056] netsock2.c: Splitting '10.47.22.251:5060' into... | |
| [Nov 25 18:32:09] DEBUG[1224][C-00000056] netsock2.c: ...host '10.47.22.251' and port '5060'. | |
| [Nov 25 18:32:09] VERBOSE[1224][C-00000056] chan_sip.c: Sending to 10.47.22.251:5060 (no NAT) | |
| [Nov 25 18:32:09] DEBUG[1224][C-00000056] chan_sip.c: Setting SIP_ALREADYGONE on dialog 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:32:09] DEBUG[1224][C-00000056] res_rtp_asterisk.c: Setting RTCP address on RTP instance '0x7f981001ae58' | |
| [Nov 25 18:32:09] DEBUG[1224][C-00000056] chan_sip.c: Session timer stopped: 6 - 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:32:09] VERBOSE[1224][C-00000056] chan_sip.c: Scheduling destruction of SIP dialog '313434383437323731323534323736-psjp6zc12znr' in 6400 ms (Method: BYE) | |
| [Nov 25 18:32:09] DEBUG[1224][C-00000056] chan_sip.c: Received bye, issuing owner hangup | |
| [Nov 25 18:32:09] VERBOSE[1224][C-00000056] chan_sip.c: | |
| <--- Transmitting (no NAT) to 10.47.22.251:5060 ---> | |
| SIP/2.0 200 OK | |
| Via: SIP/2.0/UDP 10.47.22.251:5060;branch=z9hG4bK-9g6js73uq367;received=10.47.22.251;rport=5060 | |
| From: "biw CC 111" <sip:111@10.47.20.42>;tag=pleulbxibr | |
| To: <sip:777@10.47.20.42>;tag=as4a35a0d4 | |
| Call-ID: 313434383437323731323534323736-psjp6zc12znr | |
| CSeq: 3 BYE | |
| Server: Asterisk PBX 13.6.0 | |
| Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| Supported: replaces, timer | |
| Content-Length: 0 | |
| <------------> | |
| [Nov 25 18:32:09] DEBUG[1224][C-00000056] chan_sip.c: Trying to put 'SIP/2.0 200' onto UDP socket destined for 10.47.22.251:5060 | |
| [Nov 25 18:32:09] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4814 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: RTPAUDIOQOS | |
| Value: ssrc=1247505991;themssrc=1317235972;lp=0;rxjitter=0.000000;rxcount=714;txjitter=0.000116;txcount=143;rlp=0;rtt=69787.749608 | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4815 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: RTPAUDIOQOSJITTER | |
| Value: minrxjitter=0.000000;maxrxjitter=0.000000;avgrxjitter=0.000000;stdevrxjitter=0.000000;reported_minjitter=0.000000;reported_maxjitter=0.000000;reported_avgjitter=0.000000;reported_stdevjitter=0.000000; | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4816 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: RTPAUDIOQOSLOSS | |
| Value: minrxlost=0.000000;maxrxlost=0.000000;avgrxlost=0.000000;stdevrxlost=0.000000;reported_minlost=0.000000;reported_maxlost=0.000000;reported_avglost=0.000000;reported_stdevlost=0.000000; | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4817 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: RTPAUDIOQOSRTT | |
| Value: minrtt=0.000000;maxrtt=0.000000;avgrtt=0.000000;stdevrtt=0.000000; | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: HangupRequest | |
| Privilege: call,all | |
| SequenceNumber: 4818 | |
| File: manager_channels.c | |
| Line: 732 | |
| Func: channel_hangup_request_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| [Nov 25 18:32:09] DEBUG[13946][C-00000056] res_agi.c: No frame read on channel SIP/111-00000037, going out ... | |
| [Nov 25 18:32:09] DEBUG[13946][C-00000056] pbx.c: Spawn extension (adhearsion-redirect,1,1) exited non-zero on 'SIP/111-00000037' | |
| [Nov 25 18:32:09] DEBUG[13946][C-00000056] channel.c: Soft-Hanging (0x10) up channel 'SIP/111-00000037' | |
| [Nov 25 18:32:09] DEBUG[13946][C-00000056] channel.c: Hanging up channel 'SIP/111-00000037' | |
| [Nov 25 18:32:09] DEBUG[13946][C-00000056] chan_sip.c: Hangup call SIP/111-00000037, SIP callid 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:32:09] DEBUG[13946][C-00000056] chan_sip.c: update_call_counter(111) - decrement call limit counter on hangup | |
| [Nov 25 18:32:09] DEBUG[13946][C-00000056] chan_sip.c: Updating call counter for incoming call | |
| [Nov 25 18:32:09] DEBUG[13946][C-00000056] chan_sip.c: Call from peer '111' removed from call limit 2 | |
| [Nov 25 18:32:09] DEBUG[13946][C-00000056] res_rtp_asterisk.c: Setting RTCP address on RTP instance '0x7f981001ae58' | |
| [Nov 25 18:32:09] DEBUG[1203] cdr.c: Finalized CDR for SIP/111-00000037 - start 1448472714.538356 answer 1448472714.744406 end 1448472729.504518 dispo ANSWERED | |
| [Nov 25 18:32:09] DEBUG[1206] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[1206] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: CEL | |
| Privilege: call,all | |
| SequenceNumber: 4819 | |
| File: cel_manager.c | |
| Line: 299 | |
| Func: manager_log | |
| EventName: HANGUP | |
| AccountCode: | |
| CallerIDnum: 111 | |
| CallerIDname: biw CC 111 | |
| CallerIDani: 111 | |
| CallerIDrdnis: | |
| CallerIDdnid: 777 | |
| Exten: 1 | |
| Context: adhearsion-redirect | |
| Channel: SIP/111-00000037 | |
| Application: | |
| AppData: | |
| EventTime: 2015-11-25 18:32:09 | |
| AMAFlags: DOCUMENTATION | |
| UniqueID: 1448472714.504 | |
| LinkedID: 1448472714.504 | |
| Userfield: | |
| Peer: | |
| PeerAccount: | |
| Extra: {"hangupcause":0,"hangupsource":"SIP/111-00000037","dialstatus":""} | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: CEL | |
| Privilege: call,all | |
| SequenceNumber: 4820 | |
| File: cel_manager.c | |
| Line: 299 | |
| Func: manager_log | |
| EventName: CHAN_END | |
| AccountCode: | |
| CallerIDnum: 111 | |
| CallerIDname: biw CC 111 | |
| CallerIDani: 111 | |
| CallerIDrdnis: | |
| CallerIDdnid: 777 | |
| Exten: 1 | |
| Context: adhearsion-redirect | |
| Channel: SIP/111-00000037 | |
| Application: | |
| AppData: | |
| EventTime: 2015-11-25 18:32:09 | |
| AMAFlags: DOCUMENTATION | |
| UniqueID: 1448472714.504 | |
| LinkedID: 1448472714.504 | |
| Userfield: | |
| Peer: | |
| PeerAccount: | |
| Extra: | |
| [Nov 25 18:32:09] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: AsyncAGIEnd | |
| Privilege: agi,all | |
| SequenceNumber: 4821 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| (null): | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: VarSet | |
| Privilege: dialplan,all | |
| SequenceNumber: 4822 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Variable: AGISTATUS | |
| Value: HANGUP | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: SoftHangupRequest | |
| Privilege: call,all | |
| SequenceNumber: 4823 | |
| File: manager_channels.c | |
| Line: 732 | |
| Func: channel_hangup_request_cb | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Cause: 16 | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: Hangup | |
| Privilege: call,all | |
| SequenceNumber: 4824 | |
| File: manager_channels.c | |
| Line: 677 | |
| Func: channel_snapshot_update | |
| Channel: SIP/111-00000037 | |
| ChannelState: 6 | |
| ChannelStateDesc: Up | |
| CallerIDNum: 111 | |
| CallerIDName: biw CC 111 | |
| ConnectedLineNum: <unknown> | |
| ConnectedLineName: <unknown> | |
| Language: de | |
| AccountCode: | |
| Context: adhearsion-redirect | |
| Exten: 1 | |
| Priority: 1 | |
| Uniqueid: 1448472714.504 | |
| Linkedid: 1448472714.504 | |
| Cause: 0 | |
| Cause-txt: Unknown | |
| [Nov 25 18:32:09] DEBUG[1202] devicestate.c: No provider found, checking channel drivers for SIP - 111 | |
| [Nov 25 18:32:09] DEBUG[1202] chan_sip.c: Checking device state for peer 111 | |
| [Nov 25 18:32:09] DEBUG[1202] devicestate.c: Changing state for SIP/111 - state 1 (Not in use) | |
| [Nov 25 18:32:09] DEBUG[1202] devicestate.c: No provider found, checking channel drivers for SIP - 111 | |
| [Nov 25 18:32:09] DEBUG[1202] chan_sip.c: Checking device state for peer 111 | |
| [Nov 25 18:32:09] DEBUG[1202] devicestate.c: Changing state for SIP/111 - state 1 (Not in use) | |
| [Nov 25 18:32:09] DEBUG[1207] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:09] DEBUG[13945] manager.c: Examining AMI event: | |
| Event: DeviceStateChange | |
| Privilege: call,all | |
| SequenceNumber: 4825 | |
| File: manager.c | |
| Line: 1693 | |
| Func: manager_default_msg_cb | |
| Device: SIP/111 | |
| State: NOT_INUSE | |
| [Nov 25 18:32:09] DEBUG[1255] app_queue.c: Device 'SIP/111' changed to state '1' (Not in use) but we don't care because they're not a member of any queue. | |
| [Nov 25 18:32:10] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:15] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:15] DEBUG[1224] chan_sip.c: Auto destroying SIP dialog '313434383437323731323534323736-psjp6zc12znr' | |
| [Nov 25 18:32:15] DEBUG[1224] chan_sip.c: Destroying SIP dialog 313434383437323731323534323736-psjp6zc12znr | |
| [Nov 25 18:32:15] VERBOSE[1224] chan_sip.c: Really destroying SIP dialog '313434383437323731323534323736-psjp6zc12znr' Method: BYE | |
| [Nov 25 18:32:15] DEBUG[1224] rtp_engine.c: Destroyed RTP instance '0x7f981001ae58' | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Allocating new SIP dialog for 3f3ac0f82f6f6d551c3cbcce5dd58582@10.47.20.42:5060 - OPTIONS (No RTP) | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: OBPROXY: Not applying OBproxy to this call | |
| [Nov 25 18:32:20] DEBUG[1224] acl.c: For destination '10.47.22.253', our source address is '10.47.20.42'. | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Setting AST_TRANSPORT_UDP with address 10.47.20.42:5060 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: SIP call-id changed from '3f3ac0f82f6f6d551c3cbcce5dd58582@10.47.20.42:5060' to '0f5e1cbc1c6e7f2869221b8376535f5f@10.47.20.42:5060' | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Initializing initreq for method OPTIONS - callid 0f5e1cbc1c6e7f2869221b8376535f5f@10.47.20.42:5060 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 0 [ 55]: OPTIONS sip:110@10.47.22.253:5060;line=xiio2hm8 SIP/2.0 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 1 [ 56]: Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK6d5ac373 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 2 [ 16]: Max-Forwards: 70 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 3 [ 58]: From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as1b7b9d11 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 4 [ 45]: To: <sip:110@10.47.22.253:5060;line=xiio2hm8> | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 5 [ 40]: Contact: <sip:asterisk@10.47.20.42:5060> | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 6 [ 58]: Call-ID: 0f5e1cbc1c6e7f2869221b8376535f5f@10.47.20.42:5060 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 7 [ 17]: CSeq: 102 OPTIONS | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 8 [ 31]: User-Agent: Asterisk PBX 13.6.0 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 9 [ 35]: Date: Wed, 25 Nov 2015 17:32:20 GMT | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 10 [ 90]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 11 [ 26]: Supported: replaces, timer | |
| [Nov 25 18:32:20] VERBOSE[1224] chan_sip.c: Reliably Transmitting (no NAT) to 10.47.22.253:5060: | |
| OPTIONS sip:110@10.47.22.253:5060;line=xiio2hm8 SIP/2.0 | |
| Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK6d5ac373 | |
| Max-Forwards: 70 | |
| From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as1b7b9d11 | |
| To: <sip:110@10.47.22.253:5060;line=xiio2hm8> | |
| Contact: <sip:asterisk@10.47.20.42:5060> | |
| Call-ID: 0f5e1cbc1c6e7f2869221b8376535f5f@10.47.20.42:5060 | |
| CSeq: 102 OPTIONS | |
| User-Agent: Asterisk PBX 13.6.0 | |
| Date: Wed, 25 Nov 2015 17:32:20 GMT | |
| Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE | |
| Supported: replaces, timer | |
| Content-Length: 0 | |
| --- | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: *** SIP TIMER: Initializing retransmit timer on packet: Id #2 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Trying to put 'OPTIONS sip' onto UDP socket destined for 10.47.22.253:5060 | |
| [Nov 25 18:32:20] VERBOSE[1224] chan_sip.c: | |
| <--- SIP read from UDP:10.47.22.253:5060 ---> | |
| SIP/2.0 200 OK | |
| Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK6d5ac373 | |
| From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as1b7b9d11 | |
| To: <sip:110@10.47.22.253:5060;line=xiio2hm8> | |
| Call-ID: 0f5e1cbc1c6e7f2869221b8376535f5f@10.47.20.42:5060 | |
| CSeq: 102 OPTIONS | |
| Contact: <sip:107@10.47.22.253:5060;line=vav9afgv>;reg-id=1 | |
| User-Agent: snom320/7.3.30 | |
| Accept-Language: en | |
| Accept: application/sdp | |
| Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO | |
| Allow-Events: talk, hold, refer, call-info | |
| Supported: timer, 100rel, replaces, from-change | |
| Content-Length: 0 | |
| <-------------> | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 0 [ 14]: SIP/2.0 200 OK | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 1 [ 56]: Via: SIP/2.0/UDP 10.47.20.42:5060;branch=z9hG4bK6d5ac373 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 2 [ 58]: From: "asterisk" <sip:asterisk@10.47.20.42>;tag=as1b7b9d11 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 3 [ 45]: To: <sip:110@10.47.22.253:5060;line=xiio2hm8> | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 4 [ 58]: Call-ID: 0f5e1cbc1c6e7f2869221b8376535f5f@10.47.20.42:5060 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 5 [ 17]: CSeq: 102 OPTIONS | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 6 [ 59]: Contact: <sip:107@10.47.22.253:5060;line=vav9afgv>;reg-id=1 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 7 [ 26]: User-Agent: snom320/7.3.30 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 8 [ 19]: Accept-Language: en | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 9 [ 23]: Accept: application/sdp | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 10 [ 88]: Allow: INVITE, ACK, CANCEL, BYE, REFER, OPTIONS, NOTIFY, SUBSCRIBE, PRACK, MESSAGE, INFO | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 11 [ 42]: Allow-Events: talk, hold, refer, call-info | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 12 [ 47]: Supported: timer, 100rel, replaces, from-change | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Header 13 [ 17]: Content-Length: 0 | |
| [Nov 25 18:32:20] VERBOSE[1224] chan_sip.c: --- (14 headers 0 lines) --- | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: = Looking for Call ID: 0f5e1cbc1c6e7f2869221b8376535f5f@10.47.20.42:5060 (Checking To) --From tag as1b7b9d11 --To-tag | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: ** SIP TIMER: Cancelling retransmit of packet (reply received) Retransid #2 | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Stopping retransmission on '0f5e1cbc1c6e7f2869221b8376535f5f@10.47.20.42:5060' of Request 102: Match Found | |
| [Nov 25 18:32:20] DEBUG[1224] chan_sip.c: Destroying SIP dialog 0f5e1cbc1c6e7f2869221b8376535f5f@10.47.20.42:5060 | |
| [Nov 25 18:32:20] VERBOSE[1224] chan_sip.c: Really destroying SIP dialog '0f5e1cbc1c6e7f2869221b8376535f5f@10.47.20.42:5060' Method: OPTIONS | |
| [Nov 25 18:32:20] DEBUG[1209] manager.c: Mansession: 0x7f981c004eb8 refcount now 2 | |
| [Nov 25 18:32:23] DEBUG[13935] config_options.c: acl.conf was unchanged | |
| [Nov 25 18:32:23] DEBUG[13935] config.c: extract int from [100] in [0, 1000] gives [100](0) | |
| [Nov 25 18:32:23] DEBUG[13935] config.c: extract int from [300] in [0, 86400] gives [300](0) | |
| [Nov 25 18:32:23] DEBUG[13935] config_options.c: cdr.conf was unchanged | |
| [Nov 25 18:32:23] DEBUG[13935] config_options.c: cel.conf was unchanged | |
| [Nov 25 18:32:23] DEBUG[13935] config.c: Parsing /etc/asterisk/extconfig.conf | |
| [Nov 25 18:32:23] DEBUG[13935] config.c: extract int from [1000] in [-2147483648, 2147483647] gives [1000](0) | |
| [Nov 25 18:32:23] DEBUG[13935] config.c: extract int from [10] in [-2147483648, 2147483647] gives [10](0) | |
| [Nov 25 18:32:23] DEBUG[13935] config.c: extract int from [15] in [-2147483648, 2147483647] gives [15](0) | |
| [Nov 25 18:32:23] DEBUG[13935] config.c: extract int from [1] in [-2147483648, 2147483647] gives [1](0) | |
| [Nov 25 18:32:23] DEBUG[13935] config.c: extract int from [2] in [-2147483648, 2147483647] gives [2](0) | |
| [Nov 25 18:32:23] DEBUG[13935] config.c: extract int from [3] in [-2147483648, 2147483647] gives [3](0) | |
| [Nov 25 18:32:23] DEBUG[13935] config_options.c: features.conf was unchanged |
Sign up for free
to join this conversation on GitHub.
Already have an account?
Sign in to comment