Sip read: INVITE sip:500014800000001@192.168.30.151 SIP/2.0 Via: SIP/2.0/UDP 192.168.30.5;branch=z9hG4bK4adc9e0aac238200 From: "4001" ;tag=44a1cf5a2b1354ae To: Contact: Supported: replaces Call-ID: b8597006fe968ad3@192.168.30.5 CSeq: 30744 INVITE User-Agent: Grandstream BT100 1.0.6.7 Max-Forwards: 70 Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE Content-Type: application/sdp Content-Length: 211 v=0 o=4001 8000 8000 IN IP4 192.168.30.5 s=SIP Call c=IN IP4 192.168.30.5 t=0 0 m=audio 5004 RTP/AVP 4 101 a=sendrecv a=rtpmap:4 G723/8000 a=ptime:60 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-11 13 headers, 11 lines Jul 4 07:23:23 DEBUG[2743]: chan_sip.c:5434 check_user_full: Setting NAT on RTP to 4 Jul 4 07:23:23 DEBUG[2743]: chan_sip.c:7327 handle_request: Check for res for 4001 Jul 4 07:23:23 DEBUG[2743]: chan_sip.c:1624 update_user_counter: Call from user '4001' is 1 out of 0 == Checking CHANNEL LICENSE[SIP]. Jul 4 07:23:23 DEBUG[2743]: chan_sip.c:4643 build_route: build_route: Contact hop: == Checking APP LICENSE. -- Executing Dial("SIP/4001-e9a4", "SIP/116302926/0014808820711|60|tT") in new stack == Checking MPTS LICENSE. Jul 4 07:23:23 DEBUG[2760]: app_dial.c:494 dial_exec: SIMPLE DIAL (NO URL) == Checking CHANNEL LICENSE[SIP]. Jul 4 07:23:23 DEBUG[2760]: chan_sip.c:1313 create_addr: Setting NAT on RTP to 4 == Checking CHANNEL LICENSE[SIP]. Jul 4 07:23:23 DEBUG[2760]: chan_sip.c:1491 sip_call: Outgoing Call for 0014808820711 Jul 4 07:23:23 DEBUG[2760]: chan_sip.c:1596 update_user_counter: 0014808820711 is not a local user -- Called 116302926/0014808820711 Sip read: SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.30.151:5060;branch=z9hG4bK18f80388;received=192.168.30.151;rport=5060 From: "4001" ;tag=as1f2056b5 To: ;tag=as4b67f1ac Call-ID: 218257ec46f87e203d9d2e052ea7ecf5@192.168.30.151 CSeq: 102 INVITE User-Agent: SipProxy Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Proxy-Authenticate: Digest realm="asterisk", nonce="35d23cb3" Content-Length: 0 11 headers, 0 lines Jul 4 07:23:23 DEBUG[2743]: chan_sip.c:826 __sip_ack: Acked pending invite 102 Jul 4 07:23:23 DEBUG[2743]: chan_sip.c:844 __sip_ack: Stopping retransmission on '218257ec46f87e203d9d2e052ea7ecf5@192.168.30.151' of Request 102: Found Sip read: SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.30.151:5060;branch=z9hG4bK5236d5a2;received=192.168.30.151;rport=5060 From: "4001" ;tag=as1f2056b5 To: Call-ID: 218257ec46f87e203d9d2e052ea7ecf5@192.168.30.151 CSeq: 103 INVITE User-Agent: SipProxy Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Content-Length: 0 10 headers, 0 lines Jul 4 07:23:23 DEBUG[2743]: chan_sip.c:876 __sip_semi_ack: (Provisional) Stopping retransmission (but retaining packet) on '218257ec46f87e203d9d2e052ea7ecf5@192.168.30.151' Request 103: Found Sip read: 0 headers, 0 lines Sip read: REGISTER sip:192.168.30.151 SIP/2.0 Via: SIP/2.0/UDP 192.168.30.5;branch=z9hG4bK2a32c0be9d4939b5 From: "4001" ;tag=30723898f46aa066 To: Contact: Call-ID: 0dafd588f2f44846@192.168.30.5 CSeq: 166 REGISTER Expires: 60 User-Agent: Grandstream BT100 1.0.6.7 Max-Forwards: 70 Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE Content-Length: 0 12 headers, 0 lines Sip read: SIP/2.0 183 Session Progress Via: SIP/2.0/UDP 192.168.30.151:5060;branch=z9hG4bK5236d5a2;received=192.168.30.151;rport=5060 From: "4001" ;tag=as1f2056b5 To: ;tag=as669e66bd Call-ID: 218257ec46f87e203d9d2e052ea7ecf5@192.168.30.151 CSeq: 103 INVITE User-Agent: SipProxy Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Content-Type: application/sdp Content-Length: 365 v=0 o=root 7986 7986 IN IP4 213.61.187.150 s=session c=IN IP4 213.61.187.150 t=0 0 m=audio 35308 RTP/AVP 8 0 18 3 4 2 7 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=rtpmap:3 GSM/8000 a=rtpmap:4 G723/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:7 LPC/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - 11 headers, 16 lines Jul 4 07:23:29 DEBUG[2743]: chan_sip.c:7230 handle_request: That's odd... Got a response on a call we dont know about. Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.30.151:5060;branch=z9hG4bK5236d5a2;received=192.168.30.151;rport=5060 From: "4001" ;tag=as1f2056b5 To: ;tag=as669e66bd Call-ID: 218257ec46f87e203d9d2e052ea7ecf5@192.168.30.151 CSeq: 103 INVITE User-Agent: SipProxy Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Content-Type: application/sdp Content-Length: 365 v=0 o=root 7986 7987 IN IP4 213.61.187.150 s=session c=IN IP4 213.61.187.150 t=0 0 m=audio 35308 RTP/AVP 8 0 18 3 4 2 7 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=rtpmap:3 GSM/8000 a=rtpmap:4 G723/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:7 LPC/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - 11 headers, 16 lines Jul 4 07:23:35 DEBUG[2743]: chan_sip.c:7230 handle_request: That's odd... Got a response on a call we dont know about. Sip read: SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.30.151:5060;branch=z9hG4bK5236d5a2;received=192.168.30.151;rport=5060 From: "4001" ;tag=as1f2056b5 To: ;tag=as669e66bd Call-ID: 218257ec46f87e203d9d2e052ea7ecf5@192.168.30.151 CSeq: 103 INVITE User-Agent: SipProxy Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Content-Type: application/sdp Content-Length: 365 v=0 o=root 7986 7987 IN IP4 213.61.187.150 s=session c=IN IP4 213.61.187.150 t=0 0 m=audio 35308 RTP/AVP 8 0 18 3 4 2 7 101 a=rtpmap:8 PCMA/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:18 G729/8000 a=rtpmap:3 GSM/8000 a=rtpmap:4 G723/8000 a=rtpmap:2 G726-32/8000 a=rtpmap:7 LPC/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=silenceSupp:off - - - - 11 headers, 16 lines Jul 4 07:23:37 DEBUG[2743]: chan_sip.c:7230 handle_request: That's odd... Got a response on a call we dont know about. stop nowJul 4 07:23:38 DEBUG[2760]: rtp.c:373 ast_rtcp_read: RTP NAT: Using address 0.0.0.0:0 Beginning ess shutdown.... Jul 4 07:23:38 DEBUG[2760]: chan_sip.c:1720 sip_hangup: update_user_counter(0014808820711) - decrement outUse counter Jul 4 07:23:38 DEBUG[2760]: chan_sip.c:1596 update_user_counter: 0014808820711 is not a local user == No one is available to answer at this time Jul 4 07:23:38 DEBUG[2760]: app_dial.c:1036 dial_exec: Exiting with DIALSTATUS=NOANSWER. Jul 4 07:23:38 DEBUG[2760]: pbx.c:1888 ast_pbx_run: Extension 500014800000001, priority 1 returned normally even though call was hung up -- Radius billing event occured from Ess... Jul 4 07:23:38 DEBUG[2760]: cdr_radius.c:137 send_stop: cdr_radius: sending a CDR record. Jul 4 07:23:38 DEBUG[2760]: cdr_pgsql.c:100 pgsql_log: cdr_pgsql: inserting a CDR record. Jul 4 07:23:38 DEBUG[2760]: cdr_pgsql.c:103 pgsql_log: cdr_pgsql: SQL command executed: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,uniqueid,userfield) VALUES ('2006-07-04 07:23:23','4001','4001','500014800000001','ESSHolland', 'SIP/4001-e9a4','SIP/116302926-e907','Dial','SIP/116302926/0014808820711|60|tT',15,0,'NO ANSWER',3,'','1152023003.0','') Jul 4 07:23:38 DEBUG[2760]: chan_sip.c:1723 sip_hangup: update_user_counter(4001) - decrement inUse counter Sip read: SIP/2.0 487 Request Terminated Via: SIP/2.0/UDP 192.168.30.151:5060;branch=z9hG4bK5236d5a2;received=192.168.30.151;rport=5060 From: "4001" ;tag=as1f2056b5 To: ;tag=as669e66bd Call-ID: 218257ec46f87e203d9d2e052ea7ecf5@192.168.30.151 CSeq: 103 INVITE User-Agent: SipProxy Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY Contact: Content-Length: 0 10 headers, 0 lines