rendered paste bodyJul 29 16:33:41 VERBOSE[9442] logger.c:
<-- SIP read from 217.10.79.23:5060:
INVITE sip:4795852@62.49.18.87:62844 SIP/2.0
Record-Route: <sip:217.10.79.23;ftag=as1fb1b4b1;lr=on>
Record-Route: <sip:217.10.79.8;ftag=as1fb1b4b1;lr=on>
Via: SIP/2.0/UDP 217.10.79.23;branch=z9hG4bK0b2e.ee6da572.0
Via: SIP/2.0/UDP 217.10.79.8;branch=z9hG4bK0b2e.dd3320d7.0
Via: SIP/2.0/UDP 217.10.79.30:5060;branch=z9hG4bK1a74dccd;rport=5060
From: 01619020300 <sip:01619020300@gw02.uk.sipgate.net>;tag=as1fb1b4b1
To: <sip:4795852@217.10.79.8>
Contact: <sip:01619020300@217.10.79.30>
Call-ID: 67646bd13247f58d0d52bbaa4a5b2aaa@gw02.uk.sipgate.net
CSeq: 102 INVITE
User-Agent: sipgate asterisk
Max-Forwards: 15
Date: Sat, 29 Jul 2006 15:25:50 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Type: application/sdp
Content-Length: 470
v=0
o=root 867 867 IN IP4 217.10.79.30
s=session
c=IN IP4 217.10.79.54
t=0 0
m=audio 38910 RTP/AVP 3 8 0 97 18 111 4 5 110 7 10
a=rtpmap:3 GSM/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:97 iLBC/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:111 G726-32/8000
a=rtpmap:4 G723/8000
a=rtpmap:5 DVI4/8000
a=rtpmap:110 speex/8000
a=rtpmap:7 LPC/8000
a=rtpmap:10 L16/8000
a=silenceSupp:off - - - -
a=direction:active
a=nortpproxy:yes
Jul 29 16:33:41 VERBOSE[9442] logger.c: --- (17 headers 21 lines)Jul 29 16:33:41 VERBOSE[9442] logger.c: --- (17 headers 21 lines)---
Jul 29 16:33:41 DEBUG[9442] chan_sip.c: Allocating new SIP dialog for 67646bd13247f58d0d52bbaa4a5b2aaa@gw02.uk.sipgate.net - INVITE (With RTP)
Jul 29 16:33:41 VERBOSE[9442] logger.c: Using INVITE request as basis request - 67646bd13247f58d0d52bbaa4a5b2aaa@gw02.uk.sipgate.net
Jul 29 16:33:41 VERBOSE[9442] logger.c: Sending to 217.10.79.23 : 5060 (non-NAT)
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found peer 'sipgate'
Jul 29 16:33:41 DEBUG[9442] chan_sip.c: Setting NAT on RTP to 524288
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found RTP audio format 3
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found RTP audio format 8
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found RTP audio format 0
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found RTP audio format 97
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found RTP audio format 18
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found RTP audio format 111
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found RTP audio format 4
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found RTP audio format 5
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found RTP audio format 110
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found RTP audio format 7
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found RTP audio format 10
Jul 29 16:33:41 VERBOSE[9442] logger.c: Peer audio RTP is at port 217.10.79.54:38910
Jul 29 16:33:41 DEBUG[9442] chan_sip.c: Peer audio RTP is at port 217.10.79.54:38910
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found description format GSM
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found description format PCMA
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found description format PCMU
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found description format iLBC
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found description format G729
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found description format G726-32
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found description format G723
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found description format DVI4
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found description format speex
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found description format LPC
Jul 29 16:33:41 VERBOSE[9442] logger.c: Found description format L16
Jul 29 16:33:41 VERBOSE[9442] logger.c: Capabilities: us - 0x100 (g729), peer - audio=0x7ff (g723|gsm|ulaw|alaw|g726|adpcm|slin|lpc10|g729|speex|ilbc)/video=0x0 (nothing), combined - 0x100 (g729)
Jul 29 16:33:41 VERBOSE[9442] logger.c: Non-codec capabilities: us - 0x1 (telephone-event), peer - 0x0 (nothing), combined - 0x0 (nothing)
Jul 29 16:33:41 DEBUG[9442] chan_sip.c: Checking SIP call limits for device 4795852
Jul 29 16:33:41 VERBOSE[9442] logger.c: Looking for 4795852 in from-trunk (domain 62.49.18.87)
Jul 29 16:33:41 DEBUG[9442] chan_sip.c: build_route: Record-Route hop: <sip:217.10.79.23;ftag=as1fb1b4b1;lr=on>
Jul 29 16:33:41 DEBUG[9442] chan_sip.c: build_route: Record-Route hop: <sip:217.10.79.8;ftag=as1fb1b4b1;lr=on>
Jul 29 16:33:41 VERBOSE[9442] logger.c: list_route: hop: <sip:217.10.79.23;ftag=as1fb1b4b1;lr=on>
Jul 29 16:33:41 VERBOSE[9442] logger.c: list_route: hop: <sip:217.10.79.8;ftag=as1fb1b4b1;lr=on>
Jul 29 16:33:41 VERBOSE[9442] logger.c: Transmitting (NAT) to 217.10.79.23:5060:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 217.10.79.23;branch=z9hG4bK0b2e.ee6da572.0;received=217.10.79.23
Via: SIP/2.0/UDP 217.10.79.8;branch=z9hG4bK0b2e.dd3320d7.0
Via: SIP/2.0/UDP 217.10.79.30:5060;branch=z9hG4bK1a74dccd;rport=5060
From: 01619020300 <sip:01619020300@gw02.uk.sipgate.net>;tag=as1fb1b4b1
To: <sip:4795852@217.10.79.8>
Call-ID: 67646bd13247f58d0d52bbaa4a5b2aaa@gw02.uk.sipgate.net
CSeq: 102 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:4795852@192.168.253.15>
Content-Length: 0
---
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'NoOp'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Goto'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Goto'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Macro'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Expression result is '0'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Not taking any branch
Jul 29 16:33:41 DEBUG[27485] pbx.c: Expression result is '0'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Not taking any branch
Jul 29 16:33:41 DEBUG[27485] pbx.c: Function result is '01619020300'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'NoOp'
Jul 29 16:33:41 DEBUG[27485] db.c: Unable to find key '01619020300/user' in family 'DEVICE'
Jul 29 16:33:41 DEBUG[27485] func_db.c: DB: DEVICE/01619020300/user not found in database.
Jul 29 16:33:41 DEBUG[27485] pbx.c: Function result is ''
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] db.c: Unable to find key '/cidname' in family 'AMPUSER'
Jul 29 16:33:41 DEBUG[27485] func_db.c: DB: AMPUSER//cidname not found in database.
Jul 29 16:33:41 DEBUG[27485] pbx.c: Function result is ''
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Expression result is '1'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Function result is '"01619020300" <01619020300>'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'NoOp'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Function result is '0'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Function result is '01619020300'
Jul 29 16:33:41 WARNING[27485] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected $end, expecting TOK_MINUS or TOK_COMPL or TOK_LP or TOKEN; Input:
"" != "
^
Jul 29 16:33:41 WARNING[27485] ast_expr2.fl: If you have questions, please refer to doc/README.variables in the asterisk source.
Jul 29 16:33:41 DEBUG[27485] pbx.c: Expression result is '0'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Not taking any branch
Jul 29 16:33:41 DEBUG[27485] pbx.c: Function result is '0'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Function result is '01619020300'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Function result is '01619020300'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Macro'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Function result is '0'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'AGI'
Jul 29 16:33:41 DEBUG[27486] app_queue.c: Device 'SIP/4795852' changed to state '4' (Invalid) but we don't care because they're not a member of any queue.
Jul 29 16:33:41 DEBUG[27485] db.c: Unable to find key '/recording' in family 'AMPUSER'
Jul 29 16:33:41 VERBOSE[27485] logger.c: recordingcheck|20060729-163341|1154187221.68: No DB Entry AMPUSER//recording - Not recording
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'NoOp'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Macro'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'AGI'
Jul 29 16:33:41 VERBOSE[27485] logger.c: dialparties.agi: Starting New Dialparties.agi
Jul 29 16:33:41 VERBOSE[27485] logger.c: dialparties.agi: Caller ID name is '01619020300' number is '01619020300'
Jul 29 16:33:41 VERBOSE[27485] logger.c: dialparties.agi: Methodology of ring is 'hunt'
Jul 29 16:33:41 DEBUG[27485] db.c: Unable to find key '07766087677#' in family 'CF'
Jul 29 16:33:41 DEBUG[27485] db.c: Unable to find key '07766087677#' in family 'CW'
Jul 29 16:33:41 DEBUG[27485] db.c: Unable to find key '07766087677#' in family 'CFB'
Jul 29 16:33:41 DEBUG[27485] db.c: Unable to find key '07766087677#' in family 'CFU'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'NoOp'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Expression result is '1'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Expression result is '1'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Expression result is '1'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Expression result is '1'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Expression result is '1'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Function result is '07766087677#'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Goto'
Jul 29 16:33:41 DEBUG[27485] pbx.c: Launching 'Dial'
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-dial-s-42.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable MACRO_DEPTH.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-dial-s-34.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-dial-s-33.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable CT_EXTEN.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-dial-s-32.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-dial-s-31.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable HuntMember.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-dial-s-30.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-dial-s-22.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable HuntLoop.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-dial-s-21.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-dial-s-20.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable HuntMembers.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable ds.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable HuntMember0.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable CALLTRACE_HUNT.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-dial-s-1.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable ARG3.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable ARG2.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable ARG1.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable MACRO_PRIORITY.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable MACRO_CONTEXT.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable MACRO_EXTEN.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-ext-findmefollow-201-9.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable RingGroupMethod.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-ext-findmefollow-201-8.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-record-enable-s-5.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable RecEnable.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-record-enable-s-4.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-record-enable-s-1.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-ext-findmefollow-201-7.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable RecordMethod.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-ext-findmefollow-201-6.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-ext-findmefollow-201-5.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable RGPREFIX.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-ext-findmefollow-201-4.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-ext-findmefollow-201-3.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-ext-findmefollow-201-2.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-user-callerid-s-9.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-user-callerid-s-7.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable AMPUSERCIDNAME.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-user-callerid-s-6.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable AMPUSER.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-user-callerid-s-5.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-user-callerid-s-4.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable REALCALLERIDNUM.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-user-callerid-s-3.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-user-callerid-s-2.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-macro-user-callerid-s-1.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-ext-findmefollow-201-1.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-ext-did-s-2.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable FROM_DID.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-ext-did-s-1.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-from-trunk-4795852-2.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable STACK-from-trunk-4795852-1.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable SIPCALLID.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable SIPUSERAGENT.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable SIPDOMAIN.
Jul 29 16:33:41 DEBUG[27485] channel.c: Not copying variable SIPURI.
Jul 29 16:33:41 VERBOSE[27485] logger.c: Transmitting (NAT) to 217.10.79.23:5060:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 217.10.79.23;branch=z9hG4bK0b2e.ee6da572.0;received=217.10.79.23
Via: SIP/2.0/UDP 217.10.79.8;branch=z9hG4bK0b2e.dd3320d7.0
Via: SIP/2.0/UDP 217.10.79.30:5060;branch=z9hG4bK1a74dccd;rport=5060
From: 01619020300 <sip:01619020300@gw02.uk.sipgate.net>;tag=as1fb1b4b1
To: <sip:4795852@217.10.79.8>;tag=as3332438f
Call-ID: 67646bd13247f58d0d52bbaa4a5b2aaa@gw02.uk.sipgate.net
CSeq: 102 INVITE
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Contact: <sip:4795852@192.168.253.15>
Content-Length: 0
---
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Macro'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Expression result is '1'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Macro'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Expression result is '1'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Function result is '"01619020300" <01619020300>'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'NoOp'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Function result is '01619020300'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Macro'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Function result is '0'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'AGI'
Jul 29 16:33:41 DEBUG[27490] app_queue.c: Device 'Local/07766087677@from-internal' changed to state '2' (In use) but we don't care because they're not a member of any queue.
Jul 29 16:33:41 DEBUG[9442] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - OPTIONS (No RTP)
Jul 29 16:33:41 VERBOSE[9442] logger.c: 12 headers, 0 lines
Jul 29 16:33:41 VERBOSE[9442] logger.c: Reliably Transmitting (no NAT) to 192.168.253.200:5060:
OPTIONS sip:103@192.168.253.200:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.253.15:5060;branch=z9hG4bK32b5f24d
From: "Unknown" <sip:Unknown@192.168.253.15>;tag=as317e7c8b
To: <sip:103@192.168.253.200:5060>
Contact: <sip:Unknown@192.168.253.15>
Call-ID: 00630c203e1268534cdb4cc51252ed30@192.168.253.15
CSeq: 102 OPTIONS
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Sat, 29 Jul 2006 15:33:41 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Length: 0
---
Jul 29 16:33:41 DEBUG[27489] db.c: Unable to find key '01619020300/recording' in family 'AMPUSER'
Jul 29 16:33:41 VERBOSE[27489] logger.c: recordingcheck|20060729-163341|1154187221.70: No AMPUSER db entry for 01619020300. Not recording
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'NoOp'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Macro'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Expression result is '0'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Not taking any branch
Jul 29 16:33:41 DEBUG[27489] pbx.c: Function result is '01619020300'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'NoOp'
Jul 29 16:33:41 DEBUG[27489] db.c: Unable to find key '01619020300/outboundcid' in family 'AMPUSER'
Jul 29 16:33:41 DEBUG[27489] func_db.c: DB: AMPUSER/01619020300/outboundcid not found in database.
Jul 29 16:33:41 DEBUG[27489] pbx.c: Function result is ''
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27489] db.c: Unable to find key '01619020300/emergency_cid' in family 'DEVICE'
Jul 29 16:33:41 DEBUG[27489] func_db.c: DB: DEVICE/01619020300/emergency_cid not found in database.
Jul 29 16:33:41 DEBUG[27489] pbx.c: Function result is ''
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Expression result is '1'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Expression result is '1'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Expression result is '1'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Function result is '"01619020300" <01619020300>'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'NoOp'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Function result is '1'
Jul 29 16:33:41 WARNING[27489] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected $end, expecting TOK_MINUS or TOK_COMPL or TOK_LP or TOKEN; Input:
1 >
^
Jul 29 16:33:41 WARNING[27489] ast_expr2.fl: If you have questions, please refer to doc/README.variables in the asterisk source.
Jul 29 16:33:41 DEBUG[27489] pbx.c: Expression result is '0'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Not taking any branch
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'AGI'
Jul 29 16:33:41 VERBOSE[27489] logger.c: fixlocalprefix: Could not parse /etc/asterisk/localprefixes.conf
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Function result is 'SIP/103'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Set'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Expression result is '0'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'GotoIf'
Jul 29 16:33:41 DEBUG[27489] pbx.c: Not taking any branch
Jul 29 16:33:41 DEBUG[27489] pbx.c: Launching 'Dial'
Jul 29 16:33:41 DEBUG[27489] chan_sip.c: Allocating new SIP dialog for (No Call-ID) - INVITE (With RTP)
Jul 29 16:33:41 DEBUG[27489] chan_sip.c: Setting NAT on RTP to 0
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-14.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable MACRO_DEPTH.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-13.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable custom.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-12.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable OUTNUM.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-11.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-10.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable DIAL_TRUNK.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-9.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable DIAL_NUMBER.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-8.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-7.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable GROUP.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-6.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable MACRO_PRIORITY.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable MACRO_CONTEXT.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable MACRO_EXTEN.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable ARG1.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-outbound-callerid-s-15.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-outbound-callerid-s-13.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-outbound-callerid-s-11.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-outbound-callerid-s-7.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable TRUNKOUTCID.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-outbound-callerid-s-6.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable EMERGENCYCID.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-outbound-callerid-s-5.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable USEROUTCID.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-outbound-callerid-s-4.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-outbound-callerid-s-3.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable REALCALLERIDNUM.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-outbound-callerid-s-2.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-outbound-callerid-s-1.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-5.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable ARG2.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-record-enable-s-5.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-record-enable-s-4.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-record-enable-s-1.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-4.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-user-callerid-s-9.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-user-callerid-s-1.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-3.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-macro-dialout-trunk-s-1.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable ARG4.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable ARG3.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable STACK-from-internal-07766087677-1.
Jul 29 16:33:41 DEBUG[27489] channel.c: Not copying variable DIALEDPEERNUMBER.
Jul 29 16:33:41 DEBUG[27489] chan_sip.c: Outgoing Call for 07766087677
Jul 29 16:33:41 VERBOSE[27489] logger.c: We're at 192.168.253.15 port 10506
Jul 29 16:33:41 VERBOSE[27489] logger.c: Adding codec 0x100 (g729) to SDP
Jul 29 16:33:41 VERBOSE[27489] logger.c: Adding codec 0x2 (gsm) to SDP
Jul 29 16:33:41 VERBOSE[27489] logger.c: Adding codec 0x4 (ulaw) to SDP
Jul 29 16:33:41 VERBOSE[27489] logger.c: Adding codec 0x8 (alaw) to SDP
Jul 29 16:33:41 VERBOSE[27489] logger.c: Adding non-codec 0x1 (telephone-event) to SDP
Jul 29 16:33:41 VERBOSE[27489] logger.c: 13 headers, 14 lines
Jul 29 16:33:41 VERBOSE[27489] logger.c: Reliably Transmitting (no NAT) to 192.168.253.200:5060:
INVITE sip:07766087677@192.168.253.200 SIP/2.0
Via: SIP/2.0/UDP 192.168.253.15:5060;branch=z9hG4bK0aebb603
From: "01619020300" <sip:01619020300@192.168.253.15>;tag=as0a3e6cb5
To: <sip:07766087677@192.168.253.200>
Contact: <sip:01619020300@192.168.253.15>
Call-ID: 5042d54f5a50a4ab3dbe91ea07a54463@192.168.253.15
CSeq: 102 INVITE
User-Agent: Asterisk PBX
Max-Forwards: 70
Date: Sat, 29 Jul 2006 15:33:41 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Content-Type: application/sdp
Content-Length: 312
v=0
o=root 9426 9426 IN IP4 192.168.253.15
s=session
c=IN IP4 192.168.253.15
t=0 0
m=audio 10506 RTP/AVP 18 3 0 8 101
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:3 GSM/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=silenceSupp:off - - - -
---
Jul 29 16:33:41 VERBOSE[9442] logger.c:
<-- SIP read from 192.168.253.200:5060:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.253.15:5060;branch=z9hG4bK32b5f24d
From: "Unknown" <sip:Unknown@192.168.253.15>;tag=as317e7c8b
To: <sip:103@192.168.253.200:5060>;tag=4a9a3d88
Server: Crystal Media CM5000 Sip-Phone
Contact: <sip:103@192.168.253.200>
Call-ID: 00630c203e1268534cdb4cc51252ed30@192.168.253.15
CSeq: 102 OPTIONS
Allow: INVITE,CANCEL,ACK,BYE,NOTIFY,REFER,OPTIONS
Content-Length: 0
Jul 29 16:33:41 VERBOSE[9442] logger.c: --- (10 headers 0 lines)Jul 29 16:33:41 VERBOSE[9442] logger.c: --- (10 headers 0 lines)---
Jul 29 16:33:41 DEBUG[9442] chan_sip.c: Stopping retransmission on '00630c203e1268534cdb4cc51252ed30@192.168.253.15' of Request 102: Match Found
Jul 29 16:33:41 VERBOSE[9442] logger.c: Destroying call '00630c203e1268534cdb4cc51252ed30@192.168.253.15'
Jul 29 16:33:41 VERBOSE[9442] logger.c:
<-- SIP read from 192.168.253.200:5060:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.253.15:5060;branch=z9hG4bK0aebb603
From: "01619020300" <sip:01619020300@192.168.253.15>;tag=as0a3e6cb5
To: <sip:07766087677@192.168.253.200>
Contact: <sip:1001@192.168.253.200:5060>
Call-ID: 5042d54f5a50a4ab3dbe91ea07a54463@192.168.253.15
CSeq: 102 INVITE
Content-Length: 0
Jul 29 16:33:41 VERBOSE[9442] logger.c: --- (8 headers 0 lines)Jul 29 16:33:41 VERBOSE[9442] logger.c: --- (8 headers 0 lines)---
Jul 29 16:33:41 DEBUG[9442] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '5042d54f5a50a4ab3dbe91ea07a54463@192.168.253.15' Request 102: Found
Jul 29 16:33:41 VERBOSE[9442] logger.c:
<-- SIP read from 192.168.253.200:5060:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.253.15:5060;branch=z9hG4bK0aebb603
From: "01619020300" <sip:01619020300@192.168.253.15>;tag=as0a3e6cb5
To: <sip:07766087677@192.168.253.200>;tag=7f110003
Contact: <sip:1001@192.168.253.200:5060>
Call-ID: 5042d54f5a50a4ab3dbe91ea07a54463@192.168.253.15
CSeq: 102 INVITE
Content-Length: 0
Jul 29 16:33:41 VERBOSE[9442] logger.c: --- (8 headers 0 lines)Jul 29 16:33:41 VERBOSE[9442] logger.c: --- (8 headers 0 lines)---
Jul 29 16:33:41 DEBUG[9442] chan_sip.c: (Provisional) Stopping retransmission (but retaining packet) on '5042d54f5a50a4ab3dbe91ea07a54463@192.168.253.15' Request 102: Found
Jul 29 16:33:41 DEBUG[27493] app_queue.c: Device 'SIP/103' changed to state '6' (Ringing) but we don't care because they're not a member of any queue.