Add the following xlog at the beginning of the script: xlog("L_INFO", "$mb\n");
Then and add a local_route: local_route { xlog("L_INFO", "$mb\n"); } Then check the logs. There you should have the received and sent message. Regards, Ovidiu Sas On Wed, Feb 9, 2011 at 4:02 PM, Chris Stone <axi...@gmail.com> wrote: > Henk, > > On Tue, Feb 8, 2011 at 6:23 PM, Henk Hesselink <opensips-us...@voipro.nl> > wrote: >> What does an ngrep trace on the interface (interfaces?) of the machine >> show? Are the packets changed when they leave the machine? In that >> case it must be happening on that machine, i.e. no external firewall > > It shows that the packets are changed on the machine - no external > firewall involvement: > > [root@mars ~]# ngrep -pt -d eth0 port 5060 and not host 38.116.136.247 > interface: eth0 (67.212.153.176/255.255.255.240) > filter: (ip) and ( port 5060 and not host 38.116.136.247 ) > # > U 2011/02/09 12:57:47.457399 208.94.157.10:5060 -> 67.212.153.178:5060 > INVITE sip:17204497101@67.212.153.178:5060;transport=udp > SIP/2.0..From: "STONE C AND C" > <sip:+13038382386@208.94.157.10:5060>;tag=a9d5ed0-13c4-4d52f1ba-24e62632-44ba7768..To: > <sip:17204497101@67.21 > 2.153.178:5060>..Call-ID: > cxc-173-6b187330-a9d5ed0-13c4-4d52f1ba-24e62632-15a05...@208.94.157.10..cseq: > 1 INVITE..Via: SIP/2.0/UDP > 208.94.157.10:5060;branch=z9hG4bK-9be4f-4d52f1ba-24e62632-5636b781 > ..Max-Forwards: 69..P-Asserted-Identity: "STONE C AND C " > <sip:+13038382...@cxc.dashcs.com:5060>..Supported: > timer,100rel..Content-Disposition: session;handling=required..Contact: > <sip:+1303838238 > 6@208.94.157.10:5060;maddr=208.94.157.10;transport=udp>..Session-Expires: > 1800..Content-Type: application/sdp..Content-Length: > 238....v=0..o=Acme_UAS 0 1 IN IP4 208.94.157.10..s=SIP Media Capabilit > ies..c=IN IP4 208.94.157.10..t=0 0..m=audio 21428 RTP/AVP 0 18 > 101..a=rtpmap:0 PCMU/8000..a=rtpmap:18 G729/8000..a=rtpmap:101 > telephone-event/8000..a=maxptime:20..a=sendrecv.. > # > U 2011/02/09 12:57:47.459479 67.212.153.178:5060 -> 67.212.153.179:5060 > INVITE sip:17204497101@67.212.153.178:5060;transport=udp > SIP/2.0..From: "STONE C AND C" > <sip:+13038382386@208.94.157.10:5060>;tag=a9d5ed0-13c4-4d52f1ba-24e62632-44ba7768..To: > <sip:17204497101@67.21 > 2.153.178:5060>..Call-ID: > cxc-173-6b187330-a9d5ed0-13c4-4d52f1ba-24e62632-15a05...@208.94.157.10..cseq: > 1 INVITE..Via: SIP/2.0/UDP > 67.212.153.178:5060;branch=z9hG4bK-9be4f-4d52f1ba-24e62632-5636b78 > 1..Via: SIP/2.0/UDP > 208.94.157.10:5060;branch=z9hG4bK-9be4f-4d52f1ba-24e62632-5636b781..Max-Forwards: > 69..P-Asserted-Identity: "STONE C AND C " > <sip:+13038382...@cxc.dashcs.com:5060>..Supported: t > imer,100rel..Content-Disposition: > session;handling=required..Contact: > <sip:+13038382386@67.212.153.178:5060;maddr=208.94.157.10;transport=udp>..Session-Expires: > 1800..Content-Type: application/sdp. > .Content-Length: 240....v=0..o=Acme_UAS 0 1 IN IP4 > 67.212.153.178..s=SIP Media Capabilities..c=IN IP4 67.212.153.178..t=0 > 0..m=audio 21428 RTP/AVP 0 18 101..a=rtpmap:0 PCMU/8000..a=rtpmap:18 > G729/8 > 000..a=rtpmap:101 telephone-event/8000..a=maxptime:20..a=sendrecv.. > >> munging. If that is the case then run OpenSIPS with debug level 9 or >> so, save the output and then grep on the 2 different IP adresses that >> are in the incoming/outgoing contact header to see why that header is >> being changed. That might give a clue as to the SDP routing. > > I can see that the addresses are being changed for what's send v.s. > what's received from the upstream. Can't say that I can tell the why > of it though. Here's the output of the call test. Do you maybe see why > Opensips is making such a change and hence, causing the SDP to be > routed back to it? > > ======================================================== > Feb 9 13:27:28 [12757] DBG:core:socket2str: <udp:67.212.153.178:5060> > Feb 9 13:27:28 [12757] WARNING:core:main: no fork mode > Feb 9 13:27:28 [12757] DBG:core:fm_malloc_init: F_OPTIMIZE=16384, > /ROUNDTO=2048 > Feb 9 13:27:28 [12757] DBG:core:fm_malloc_init: F_HASH_SIZE=2099, > fm_block size=33632 > Feb 9 13:27:28 [12757] DBG:core:fm_malloc_init: params > (0x2b1aeab1d000, 33554432), start=0x2b1aeab1d000 > Feb 9 13:27:28 [12757] DBG:core:shm_mem_init_mallocs: success > Feb 9 13:27:28 [12757] INFO:core:init_tcp: using epoll_lt as the TCP > io watch method (auto detected) > Feb 9 13:27:28 [12757] DBG:core:set_core_dump: core dump limits set > to 18446744073709551615 > Feb 9 13:27:28 [12757] NOTICE:core:main: version: opensips > 1.4.0-notls (x86_64/linux) > Feb 9 13:27:28 [12757] INFO:core:main: using 32 Mb shared memory > Feb 9 13:27:28 [12757] INFO:core:main: using 1 Mb private memory per process > Feb 9 13:27:28 [12757] DBG:core:add_avp_galias: registering > <serial_branch> for avp id <16725044> > Feb 9 13:27:28 [12757] DBG:core:init_stats_collector: statistics > manager successfully initialized > Feb 9 13:27:28 [12757] DBG:core:count_module_procs: modules require 0 > extra processes > Feb 9 13:27:28 [12757] DBG:core:mk_proxy: doing DNS lookup... > Feb 9 13:27:28 [12757] DBG:core:probe_max_receive_buffer: getsockopt > SO_RCVBUF is initially 129024 > Feb 9 13:27:28 [12757] DBG:core:probe_max_receive_buffer: trying > SO_RCVBUF: 258048 > Feb 9 13:27:28 [12757] DBG:core:probe_max_receive_buffer: setting > SO_RCVBUF; set=258048,verify=262142 > Feb 9 13:27:28 [12757] DBG:core:probe_max_receive_buffer: trying > SO_RCVBUF: 260096 > Feb 9 13:27:28 [12757] DBG:core:probe_max_receive_buffer: setting > SO_RCVBUF; set=260096,verify=262142 > Feb 9 13:27:28 [12757] DBG:core:probe_max_receive_buffer: trying > SO_RCVBUF: 262144 > Feb 9 13:27:28 [12757] DBG:core:probe_max_receive_buffer: setting > SO_RCVBUF; set=262144,verify=262142 > Feb 9 13:27:28 [12757] DBG:core:probe_max_receive_buffer: setting > SO_RCVBUF has no effect > Feb 9 13:27:28 [12757] INFO:core:probe_max_receive_buffer: using a > UDP receive buffer of 255 kb > Feb 9 13:27:28 [12757] DBG:core:internal_fork: forking new process "timer" > Feb 9 13:27:28 [12759] DBG:core:run_timer_process: tv = 1, 0 , m=1 > Feb 9 13:27:38 [12757] DBG:core:parse_msg: SIP Request: > Feb 9 13:27:38 [12757] DBG:core:parse_msg: method: <INVITE> > Feb 9 13:27:38 [12757] DBG:core:parse_msg: uri: > <sip:17204497101@67.212.153.178:5060;transport=udp> > Feb 9 13:27:38 [12757] DBG:core:parse_msg: version: <SIP/2.0> > Feb 9 13:27:38 [12757] DBG:core:parse_headers: flags=2 > Feb 9 13:27:38 [12757] DBG:core:parse_to: end of header reached, state=10 > Feb 9 13:27:38 [12757] DBG:core:parse_to: display={}, > ruri={sip:17204497101@67.212.153.178:5060} > Feb 9 13:27:38 [12757] DBG:core:get_hdr_field: <To> [39]; > uri=[sip:17204497101@67.212.153.178:5060] > Feb 9 13:27:38 [12757] DBG:core:get_hdr_field: to body > [<sip:17204497101@67.212.153.178:5060> > ] > Feb 9 13:27:38 [12757] DBG:core:get_hdr_field: cseq <CSeq>: <1> <INVITE> > Feb 9 13:27:38 [12757] DBG:core:parse_via_param: found param type > 232, <branch> = <z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0>; state=16 > Feb 9 13:27:38 [12757] DBG:core:parse_via: end of header reached, state=5 > Feb 9 13:27:38 [12757] DBG:core:parse_headers: via found, flags=2 > Feb 9 13:27:38 [12757] DBG:core:parse_headers: this is the first via > Feb 9 13:27:38 [12757] DBG:core:receive_msg: After parse_msg... > Feb 9 13:27:38 [12757] DBG:core:receive_msg: preparing to run routing > scripts... > Feb 9 13:27:38 [12757] DBG:core:check_via_address: params > 208.94.157.10, 208.94.157.10, 0 > Feb 9 13:27:38 [12757] DBG:core:forward_request: sending: > INVITE sip:17204497101@67.212.153.178:5060;transport=udp SIP/2.0 > From: "STONE C AND C" > <sip:+13038382386@208.94.157.10:5060>;tag=a9d5ed0-13c4-4d52f8b9-25017a0d-7828b493 > To: <sip:17204497101@67.212.153.178:5060> > Call-ID: > CXC-439-6b15b570-a9d5ed0-13c4-4d52f8b9-25017a0d-19d038cd@208.94.157.10 > CSeq: 1 INVITE > Via: SIP/2.0/UDP 67.212.153.178;branch=z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0 > Via: SIP/2.0/UDP > 208.94.157.10:5060;branch=z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0 > Max-Forwards: 69 > P-Asserted-Identity: "STONE C AND C " <sip:+13038382...@cxc.dashcs.com:5060> > Supported: timer,100rel > Content-Disposition: session;handling=required > Contact: > <sip:+13038382386@208.94.157.10:5060;maddr=208.94.157.10;transport=udp> > Session-Expires: 1800 > Content-Type: application/sdp > Content-Length: 238 > > v=0 > o=Acme_UAS 0 1 IN IP4 208.94.157.10 > s=SIP Media Capabilities > c=IN IP4 208.94.157.10 > t=0 0 > m=audio 23366 RTP/AVP 0 18 101 > a=rtpmap:0 PCMU/8000 > a=rtpmap:18 G729/8000 > a=rtpmap:101 telephone-event/8000 > a=maxptime:20 > a=sendrecv > . > Feb 9 13:27:38 [12757] DBG:core:forward_request: orig. len=962, > new_len=1042, proto=1 > Feb 9 13:27:38 [12757] DBG:core:destroy_avp_list: destroying list (nil) > Feb 9 13:27:38 [12757] DBG:core:receive_msg: cleaning up > Feb 9 13:27:38 [12757] DBG:core:parse_msg: SIP Reply (status): > Feb 9 13:27:38 [12757] DBG:core:parse_msg: version: <SIP/2.0> > Feb 9 13:27:38 [12757] DBG:core:parse_msg: status: <100> > Feb 9 13:27:38 [12757] DBG:core:parse_msg: reason: <Trying> > Feb 9 13:27:38 [12757] DBG:core:parse_headers: flags=2 > Feb 9 13:27:38 [12757] DBG:core:parse_via_param: found param type > 232, <branch> = <z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0>; state=6 > Feb 9 13:27:38 [12757] DBG:core:parse_via_param: found param type > 234, <received> = <67.212.153.178>; state=16 > Feb 9 13:27:38 [12757] DBG:core:parse_via: end of header reached, state=5 > Feb 9 13:27:38 [12757] DBG:core:parse_headers: via found, flags=2 > Feb 9 13:27:38 [12757] DBG:core:parse_headers: this is the first via > Feb 9 13:27:38 [12757] DBG:core:receive_msg: After parse_msg... > Feb 9 13:27:38 [12757] DBG:core:parse_headers: flags=4 > Feb 9 13:27:38 [12757] DBG:core:parse_via_param: found param type > 232, <branch> = <z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0>; state=16 > Feb 9 13:27:38 [12757] DBG:core:parse_via: end of header reached, state=5 > Feb 9 13:27:38 [12757] DBG:core:parse_headers: via found, flags=4 > Feb 9 13:27:38 [12757] DBG:core:parse_headers: parse_headers: this is > the second via > Feb 9 13:27:38 [12757] DBG:core:build_res_buf_from_sip_res: old > size: 661, new size: 552 > Feb 9 13:27:38 [12757] DBG:core:build_res_buf_from_sip_res: copied > size: orig:129, new: 20, rest: 532 msg= > SIP/2.0 100 Trying > Via: SIP/2.0/UDP > 208.94.157.10:5060;branch=z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0 > From: "STONE C AND C" > <sip:+13038382386@208.94.157.10:5060>;tag=a9d5ed0-13c4-4d52f8b9-25017a0d-7828b493 > To: <sip:17204497101@67.212.153.178:5060> > Call-ID: > CXC-439-6b15b570-a9d5ed0-13c4-4d52f8b9-25017a0d-19d038cd@208.94.157.10 > CSeq: 1 INVITE > Server: Asterisk PBX 1.8.2.3 > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, > INFO, PUBLISH > Supported: replaces > Contact: <sip:17204497101@67.212.153.179:5060> > Content-Length: 0 > > > Feb 9 13:27:38 [12757] DBG:core:update_sock_struct_from_via: using via host > Feb 9 13:27:38 [12757] DBG:core:update_sock_struct_from_via: trying SRV > lookup > Feb 9 13:27:38 [12757] DBG:core:forward_reply: reply forwarded to > 208.94.157.10:5060 > Feb 9 13:27:38 [12757] DBG:core:destroy_avp_list: destroying list (nil) > Feb 9 13:27:38 [12757] DBG:core:receive_msg: cleaning up > Feb 9 13:27:39 [12757] DBG:core:parse_msg: SIP Reply (status): > Feb 9 13:27:39 [12757] DBG:core:parse_msg: version: <SIP/2.0> > Feb 9 13:27:39 [12757] DBG:core:parse_msg: status: <180> > Feb 9 13:27:39 [12757] DBG:core:parse_msg: reason: <Ringing> > Feb 9 13:27:39 [12757] DBG:core:parse_headers: flags=2 > Feb 9 13:27:39 [12757] DBG:core:parse_via_param: found param type > 232, <branch> = <z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0>; state=6 > Feb 9 13:27:39 [12757] DBG:core:parse_via_param: found param type > 234, <received> = <67.212.153.178>; state=16 > Feb 9 13:27:39 [12757] DBG:core:parse_via: end of header reached, state=5 > Feb 9 13:27:39 [12757] DBG:core:parse_headers: via found, flags=2 > Feb 9 13:27:39 [12757] DBG:core:parse_headers: this is the first via > Feb 9 13:27:39 [12757] DBG:core:receive_msg: After parse_msg... > Feb 9 13:27:39 [12757] DBG:core:parse_headers: flags=4 > Feb 9 13:27:39 [12757] DBG:core:parse_via_param: found param type > 232, <branch> = <z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0>; state=16 > Feb 9 13:27:39 [12757] DBG:core:parse_via: end of header reached, state=5 > Feb 9 13:27:39 [12757] DBG:core:parse_headers: via found, flags=4 > Feb 9 13:27:39 [12757] DBG:core:parse_headers: parse_headers: this is > the second via > Feb 9 13:27:39 [12757] DBG:core:build_res_buf_from_sip_res: old > size: 677, new size: 568 > Feb 9 13:27:39 [12757] DBG:core:build_res_buf_from_sip_res: copied > size: orig:130, new: 21, rest: 547 msg= > SIP/2.0 180 Ringing > Via: SIP/2.0/UDP > 208.94.157.10:5060;branch=z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0 > From: "STONE C AND C" > <sip:+13038382386@208.94.157.10:5060>;tag=a9d5ed0-13c4-4d52f8b9-25017a0d-7828b493 > To: <sip:17204497101@67.212.153.178:5060>;tag=as4903531b > Call-ID: > CXC-439-6b15b570-a9d5ed0-13c4-4d52f8b9-25017a0d-19d038cd@208.94.157.10 > CSeq: 1 INVITE > Server: Asterisk PBX 1.8.2.3 > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, > INFO, PUBLISH > Supported: replaces > Contact: <sip:17204497101@67.212.153.179:5060> > Content-Length: 0 > > > Feb 9 13:27:39 [12757] DBG:core:update_sock_struct_from_via: using via host > Feb 9 13:27:39 [12757] DBG:core:update_sock_struct_from_via: trying SRV > lookup > Feb 9 13:27:39 [12757] DBG:core:forward_reply: reply forwarded to > 208.94.157.10:5060 > Feb 9 13:27:39 [12757] DBG:core:destroy_avp_list: destroying list (nil) > Feb 9 13:27:39 [12757] DBG:core:receive_msg: cleaning up > Feb 9 13:27:41 [12757] DBG:core:parse_msg: SIP Reply (status): > Feb 9 13:27:41 [12757] DBG:core:parse_msg: version: <SIP/2.0> > Feb 9 13:27:41 [12757] DBG:core:parse_msg: status: <200> > Feb 9 13:27:41 [12757] DBG:core:parse_msg: reason: <OK> > Feb 9 13:27:41 [12757] DBG:core:parse_headers: flags=2 > Feb 9 13:27:41 [12757] DBG:core:parse_via_param: found param type > 232, <branch> = <z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0>; state=6 > Feb 9 13:27:41 [12757] DBG:core:parse_via_param: found param type > 234, <received> = <67.212.153.178>; state=16 > Feb 9 13:27:41 [12757] DBG:core:parse_via: end of header reached, state=5 > Feb 9 13:27:41 [12757] DBG:core:parse_headers: via found, flags=2 > Feb 9 13:27:41 [12757] DBG:core:parse_headers: this is the first via > Feb 9 13:27:41 [12757] DBG:core:receive_msg: After parse_msg... > Feb 9 13:27:41 [12757] DBG:core:parse_headers: flags=4 > Feb 9 13:27:41 [12757] DBG:core:parse_via_param: found param type > 232, <branch> = <z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0>; state=16 > Feb 9 13:27:41 [12757] DBG:core:parse_via: end of header reached, state=5 > Feb 9 13:27:41 [12757] DBG:core:parse_headers: via found, flags=4 > Feb 9 13:27:41 [12757] DBG:core:parse_headers: parse_headers: this is > the second via > Feb 9 13:27:41 [12757] DBG:core:build_res_buf_from_sip_res: old > size: 990, new size: 881 > Feb 9 13:27:41 [12757] DBG:core:build_res_buf_from_sip_res: copied > size: orig:125, new: 16, rest: 865 msg= > SIP/2.0 200 OK > Via: SIP/2.0/UDP > 208.94.157.10:5060;branch=z9hG4bK-a89b6-4d52f8b9-25017a0d-d0bdcd0 > From: "STONE C AND C" > <sip:+13038382386@208.94.157.10:5060>;tag=a9d5ed0-13c4-4d52f8b9-25017a0d-7828b493 > To: <sip:17204497101@67.212.153.178:5060>;tag=as4903531b > Call-ID: > CXC-439-6b15b570-a9d5ed0-13c4-4d52f8b9-25017a0d-19d038cd@208.94.157.10 > CSeq: 1 INVITE > Server: Asterisk PBX 1.8.2.3 > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, > INFO, PUBLISH > Supported: replaces > Contact: <sip:17204497101@67.212.153.179:5060> > Content-Type: application/sdp > Content-Length: 285 > > v=0 > o=root 330278739 330278739 IN IP4 67.212.153.179 > s=Asterisk PBX 1.8.2.3 > c=IN IP4 67.212.153.179 > t=0 0 > m=audio 13376 RTP/AVP 0 18 101 > a=rtpmap:0 PCMU/8000 > a=rtpmap:18 G729/8000 > a=fmtp:18 annexb=no > a=rtpmap:101 telephone-event/8000 > a=fmtp:101 0-16 > a=ptime:20 > a=sendrecv > > Feb 9 13:27:41 [12757] DBG:core:update_sock_struct_from_via: using via host > Feb 9 13:27:41 [12757] DBG:core:update_sock_struct_from_via: trying SRV > lookup > Feb 9 13:27:41 [12757] DBG:core:forward_reply: reply forwarded to > 208.94.157.10:5060 > Feb 9 13:27:41 [12757] DBG:core:destroy_avp_list: destroying list (nil) > Feb 9 13:27:41 [12757] DBG:core:receive_msg: cleaning up > Feb 9 13:27:41 [12757] DBG:core:parse_msg: SIP Request: > Feb 9 13:27:41 [12757] DBG:core:parse_msg: method: <ACK> > Feb 9 13:27:41 [12757] DBG:core:parse_msg: uri: > <sip:17204497101@67.212.153.179:5060> > Feb 9 13:27:41 [12757] DBG:core:parse_msg: version: <SIP/2.0> > Feb 9 13:27:41 [12757] DBG:core:parse_headers: flags=2 > Feb 9 13:27:41 [12757] DBG:core:parse_to_param: tag=as4903531b > Feb 9 13:27:41 [12757] DBG:core:parse_to: end of header reached, state=29 > Feb 9 13:27:41 [12757] DBG:core:parse_to: display={}, > ruri={sip:17204497101@67.212.153.178:5060} > Feb 9 13:27:41 [12757] DBG:core:get_hdr_field: <To> [54]; > uri=[sip:17204497101@67.212.153.178:5060] > Feb 9 13:27:41 [12757] DBG:core:get_hdr_field: to body > [<sip:17204497101@67.212.153.178:5060>] > Feb 9 13:27:41 [12757] DBG:core:get_hdr_field: cseq <CSeq>: <1> <ACK> > Feb 9 13:27:41 [12757] DBG:core:parse_via_param: found param type > 232, <branch> = <z9hG4bK-a89fb-4d52f8bc-250185e3-53cb0b94>; state=16 > Feb 9 13:27:41 [12757] DBG:core:parse_via: end of header reached, state=5 > Feb 9 13:27:41 [12757] DBG:core:parse_headers: via found, flags=2 > Feb 9 13:27:41 [12757] DBG:core:parse_headers: this is the first via > Feb 9 13:27:41 [12757] DBG:core:receive_msg: After parse_msg... > Feb 9 13:27:41 [12757] DBG:core:receive_msg: preparing to run routing > scripts... > Feb 9 13:27:41 [12757] DBG:core:check_via_address: params > 208.94.157.10, 208.94.157.10, 0 > Feb 9 13:27:41 [12757] DBG:core:forward_request: sending: > ACK sip:17204497101@67.212.153.179:5060 SIP/2.0 > From: "STONE C AND C" > <sip:+13038382386@208.94.157.10:5060>;tag=a9d5ed0-13c4-4d52f8b9-25017a0d-7828b493 > To: <sip:17204497101@67.212.153.178:5060>;tag=as4903531b > Call-ID: > CXC-439-6b15b570-a9d5ed0-13c4-4d52f8b9-25017a0d-19d038cd@208.94.157.10 > CSeq: 1 ACK > Via: SIP/2.0/UDP > 67.212.153.178;branch=z9hG4bK-a89fb-4d52f8bc-250185e3-53cb0b94 > Via: SIP/2.0/UDP > 208.94.157.10:5060;branch=z9hG4bK-a89fb-4d52f8bc-250185e3-53cb0b94 > Max-Forwards: 69 > Contact: > <sip:+13038382386@208.94.157.10:5060;maddr=208.94.157.10;transport=udp> > Content-Length: 0 > > . > Feb 9 13:27:41 [12757] DBG:core:forward_request: orig. len=512, > new_len=593, proto=1 > Feb 9 13:27:41 [12757] DBG:core:destroy_avp_list: destroying list (nil) > Feb 9 13:27:41 [12757] DBG:core:receive_msg: cleaning up > Feb 9 13:27:52 [12757] DBG:core:parse_msg: SIP Request: > Feb 9 13:27:52 [12757] DBG:core:parse_msg: method: <BYE> > Feb 9 13:27:52 [12757] DBG:core:parse_msg: uri: > <sip:17204497101@67.212.153.179:5060> > Feb 9 13:27:52 [12757] DBG:core:parse_msg: version: <SIP/2.0> > Feb 9 13:27:52 [12757] DBG:core:parse_headers: flags=2 > Feb 9 13:27:52 [12757] DBG:core:parse_to_param: tag=as4903531b > Feb 9 13:27:52 [12757] DBG:core:parse_to: end of header reached, state=29 > Feb 9 13:27:52 [12757] DBG:core:parse_to: display={}, > ruri={sip:17204497101@67.212.153.178:5060} > Feb 9 13:27:52 [12757] DBG:core:get_hdr_field: <To> [54]; > uri=[sip:17204497101@67.212.153.178:5060] > Feb 9 13:27:52 [12757] DBG:core:get_hdr_field: to body > [<sip:17204497101@67.212.153.178:5060>] > Feb 9 13:27:52 [12757] DBG:core:get_hdr_field: cseq <CSeq>: <2> <BYE> > Feb 9 13:27:52 [12757] DBG:core:parse_via_param: found param type > 232, <branch> = <z9hG4bK-a8b34-4d52f8c7-2501b153-4f303295>; state=16 > Feb 9 13:27:52 [12757] DBG:core:parse_via: end of header reached, state=5 > Feb 9 13:27:52 [12757] DBG:core:parse_headers: via found, flags=2 > Feb 9 13:27:52 [12757] DBG:core:parse_headers: this is the first via > Feb 9 13:27:52 [12757] DBG:core:receive_msg: After parse_msg... > Feb 9 13:27:52 [12757] DBG:core:receive_msg: preparing to run routing > scripts... > Feb 9 13:27:52 [12757] DBG:core:check_via_address: params > 208.94.157.10, 208.94.157.10, 0 > Feb 9 13:27:52 [12757] DBG:core:forward_request: sending: > BYE sip:17204497101@67.212.153.179:5060 SIP/2.0 > From: "STONE C AND C" > <sip:+13038382386@208.94.157.10:5060>;tag=a9d5ed0-13c4-4d52f8b9-25017a0d-7828b493 > To: <sip:17204497101@67.212.153.178:5060>;tag=as4903531b > Call-ID: > CXC-439-6b15b570-a9d5ed0-13c4-4d52f8b9-25017a0d-19d038cd@208.94.157.10 > CSeq: 2 BYE > Via: SIP/2.0/UDP > 67.212.153.178;branch=z9hG4bK-a8b34-4d52f8c7-2501b153-4f303295 > Via: SIP/2.0/UDP > 208.94.157.10:5060;branch=z9hG4bK-a8b34-4d52f8c7-2501b153-4f303295 > Max-Forwards: 69 > Content-Length: 0 > > . > Feb 9 13:27:52 [12757] DBG:core:forward_request: orig. len=430, > new_len=511, proto=1 > Feb 9 13:27:52 [12757] DBG:core:destroy_avp_list: destroying list (nil) > Feb 9 13:27:52 [12757] DBG:core:receive_msg: cleaning up > Feb 9 13:27:52 [12757] DBG:core:parse_msg: SIP Reply (status): > Feb 9 13:27:52 [12757] DBG:core:parse_msg: version: <SIP/2.0> > Feb 9 13:27:52 [12757] DBG:core:parse_msg: status: <200> > Feb 9 13:27:52 [12757] DBG:core:parse_msg: reason: <OK> > Feb 9 13:27:52 [12757] DBG:core:parse_headers: flags=2 > Feb 9 13:27:52 [12757] DBG:core:parse_via_param: found param type > 232, <branch> = <z9hG4bK-a8b34-4d52f8c7-2501b153-4f303295>; state=6 > Feb 9 13:27:52 [12757] DBG:core:parse_via_param: found param type > 234, <received> = <67.212.153.178>; state=16 > Feb 9 13:27:52 [12757] DBG:core:parse_via: end of header reached, state=5 > Feb 9 13:27:52 [12757] DBG:core:parse_headers: via found, flags=2 > Feb 9 13:27:52 [12757] DBG:core:parse_headers: this is the first via > Feb 9 13:27:52 [12757] DBG:core:receive_msg: After parse_msg... > Feb 9 13:27:52 [12757] DBG:core:parse_headers: flags=4 > Feb 9 13:27:52 [12757] DBG:core:parse_via_param: found param type > 232, <branch> = <z9hG4bK-a8b34-4d52f8c7-2501b153-4f303295>; state=16 > Feb 9 13:27:52 [12757] DBG:core:parse_via: end of header reached, state=5 > Feb 9 13:27:52 [12757] DBG:core:parse_headers: via found, flags=4 > Feb 9 13:27:52 [12757] DBG:core:parse_headers: parse_headers: this is > the second via > Feb 9 13:27:52 [12757] DBG:core:build_res_buf_from_sip_res: old > size: 623, new size: 513 > Feb 9 13:27:52 [12757] DBG:core:build_res_buf_from_sip_res: copied > size: orig:126, new: 16, rest: 497 msg= > SIP/2.0 200 OK > Via: SIP/2.0/UDP > 208.94.157.10:5060;branch=z9hG4bK-a8b34-4d52f8c7-2501b153-4f303295 > From: "STONE C AND C" > <sip:+13038382386@208.94.157.10:5060>;tag=a9d5ed0-13c4-4d52f8b9-25017a0d-7828b493 > To: <sip:17204497101@67.212.153.178:5060>;tag=as4903531b > Call-ID: > CXC-439-6b15b570-a9d5ed0-13c4-4d52f8b9-25017a0d-19d038cd@208.94.157.10 > CSeq: 2 BYE > Server: Asterisk PBX 1.8.2.3 > Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, > INFO, PUBLISH > Supported: replaces > Content-Length: 0 > > > Feb 9 13:27:52 [12757] DBG:core:update_sock_struct_from_via: using via host > Feb 9 13:27:52 [12757] DBG:core:update_sock_struct_from_via: trying SRV > lookup > Feb 9 13:27:52 [12757] DBG:core:forward_reply: reply forwarded to > 208.94.157.10:5060 > Feb 9 13:27:52 [12757] DBG:core:destroy_avp_list: destroying list (nil) > Feb 9 13:27:52 [12757] DBG:core:receive_msg: cleaning up > ======================================================== > > > > Thanks > > > Chris > > _______________________________________________ > Users mailing list > Users@lists.opensips.org > http://lists.opensips.org/cgi-bin/mailman/listinfo/users > _______________________________________________ Users mailing list Users@lists.opensips.org http://lists.opensips.org/cgi-bin/mailman/listinfo/users