Re: [Siproxd-users] Configuration help needed for Cisco 7905

[Jeremy M. <Je...@Ma...>]

On 08/09/2013, at 8:21 PM, Thomas Ries <tr...@gm...> wrote:

> Hmm, the dumps look funny.
> 
> Your internal address 192.168.15.200 (which supposedly ist the internal IP of
> the siproxd host) does unexpectedly show up in VIA header of incoming SIP
> messages (whereas the matching outgoing message clearly did *NOT* contain the
> internal IP but the public IP address).
> 
> This makes me believe *strongly* that some other toys in your network are
> messing around with the SIP protocol. Do you have a SIP aware NAT
> Router/Firewall in place (between siporxd and the Internet)? If so, do disable
> *all* SIP processing on those devices.

Thanks, I do indeed have a D-Link DIR-605L, and just noticed a (default-on) setting for "RTSP application-level gateway".  I disabled it and rebooted - the D-Link now just has a DMZ host setting pointing to the machine running siproxd.  But still no success.

Here is the new log.

08:31:42 INFO:siproxd.c:233 siproxd-0.8.1-53 i486-pc-linux-gnu starting up
08:31:42 readconf.c:76 setting default config values
08:31:42 readconf.c:79 trying to read config file
08:31:42 readconf.c:97 ... trying /root/.siproxdrc
08:31:42 readconf.c:97 ... trying /etc/siproxd.conf
08:31:42 readconf.c:227 cfg line:"if_inbound  = eth0"
08:31:42 readconf.c:234 got keyword:"if_inbound"
08:31:42 readconf.c:244 got argument:"eth0"
08:31:42 readconf.c:283 STRING="eth0"
08:31:42 readconf.c:227 cfg line:"if_outbound = eth0"
08:31:42 readconf.c:234 got keyword:"if_outbound"
08:31:42 readconf.c:244 got argument:"eth0"
08:31:42 readconf.c:283 STRING="eth0"
08:31:42 readconf.c:227 cfg line:"host_outbound = name-that-resolves-to-my-external-ip.net"
08:31:42 readconf.c:234 got keyword:"host_outbound"
08:31:42 readconf.c:244 got argument:"name-that-resolves-to-my-external-ip.net"
08:31:42 readconf.c:283 STRING="name-that-resolves-to-my-external-ip.net"
08:31:42 readconf.c:227 cfg line:"hosts_allow_reg = 192.168.15.0/24"
08:31:42 readconf.c:234 got keyword:"hosts_allow_reg"
08:31:42 readconf.c:244 got argument:"192.168.15.0/24"
08:31:42 readconf.c:283 STRING="192.168.15.0/24"
08:31:42 readconf.c:227 cfg line:"sip_listen_port = 5060"
08:31:42 readconf.c:234 got keyword:"sip_listen_port"
08:31:42 readconf.c:244 got argument:"5060"
08:31:42 readconf.c:259 INT4=5060
08:31:42 readconf.c:227 cfg line:"daemonize = 0"
08:31:42 readconf.c:234 got keyword:"daemonize"
08:31:42 readconf.c:244 got argument:"0"
08:31:42 readconf.c:259 INT4=0
08:31:42 readconf.c:227 cfg line:"silence_log = 0"
08:31:42 readconf.c:234 got keyword:"silence_log"
08:31:42 readconf.c:244 got argument:"0"
08:31:42 readconf.c:259 INT4=0
08:31:42 readconf.c:227 cfg line:"user = siproxd "
08:31:42 readconf.c:234 got keyword:"user"
08:31:42 readconf.c:244 got argument:"siproxd "
08:31:42 readconf.c:283 STRING="siproxd"
08:31:42 readconf.c:227 cfg line:"registration_file = /var/lib/siproxd/siproxd_registrations"
08:31:42 readconf.c:234 got keyword:"registration_file"
08:31:42 readconf.c:244 got argument:"/var/lib/siproxd/siproxd_registrations"
08:31:42 readconf.c:283 STRING="/var/lib/siproxd/siproxd_registrations"
08:31:42 readconf.c:227 cfg line:"autosave_registrations = 300"
08:31:42 readconf.c:234 got keyword:"autosave_registrations"
08:31:42 readconf.c:244 got argument:"300"
08:31:42 readconf.c:259 INT4=300
08:31:42 readconf.c:227 cfg line:"rtp_proxy_enable = 1"
08:31:42 readconf.c:234 got keyword:"rtp_proxy_enable"
08:31:42 readconf.c:244 got argument:"1"
08:31:42 readconf.c:259 INT4=1
08:31:42 readconf.c:227 cfg line:"rtp_port_low  = 7070"
08:31:42 readconf.c:234 got keyword:"rtp_port_low"
08:31:42 readconf.c:244 got argument:"7070"
08:31:42 readconf.c:259 INT4=7070
08:31:42 readconf.c:227 cfg line:"rtp_port_high = 7089"
08:31:42 readconf.c:234 got keyword:"rtp_port_high"
08:31:42 readconf.c:244 got argument:"7089"
08:31:42 readconf.c:259 INT4=7089
08:31:42 readconf.c:227 cfg line:"rtp_timeout = 300"
08:31:42 readconf.c:234 got keyword:"rtp_timeout"
08:31:42 readconf.c:244 got argument:"300"
08:31:42 readconf.c:259 INT4=300
08:31:42 readconf.c:227 cfg line:"rtp_dscp = 46"
08:31:42 readconf.c:234 got keyword:"rtp_dscp"
08:31:42 readconf.c:244 got argument:"46"
08:31:42 readconf.c:259 INT4=46
08:31:42 readconf.c:227 cfg line:"sip_dscp = 0"
08:31:42 readconf.c:234 got keyword:"sip_dscp"
08:31:42 readconf.c:244 got argument:"0"
08:31:42 readconf.c:259 INT4=0
08:31:42 readconf.c:227 cfg line:"rtp_input_dejitter  = 0"
08:31:42 readconf.c:234 got keyword:"rtp_input_dejitter"
08:31:42 readconf.c:244 got argument:"0"
08:31:42 readconf.c:259 INT4=0
08:31:42 readconf.c:227 cfg line:"rtp_output_dejitter = 0"
08:31:42 readconf.c:234 got keyword:"rtp_output_dejitter"
08:31:42 readconf.c:244 got argument:"0"
08:31:42 readconf.c:259 INT4=0
08:31:42 readconf.c:227 cfg line:"tcp_timeout = 600"
08:31:42 readconf.c:234 got keyword:"tcp_timeout"
08:31:42 readconf.c:244 got argument:"600"
08:31:42 readconf.c:259 INT4=600
08:31:42 readconf.c:227 cfg line:"tcp_connect_timeout = 500"
08:31:42 readconf.c:234 got keyword:"tcp_connect_timeout"
08:31:42 readconf.c:244 got argument:"500"
08:31:42 readconf.c:259 INT4=500
08:31:42 readconf.c:227 cfg line:"tcp_keepalive = 20"
08:31:42 readconf.c:234 got keyword:"tcp_keepalive"
08:31:42 readconf.c:244 got argument:"20"
08:31:42 readconf.c:259 INT4=20
08:31:42 readconf.c:227 cfg line:"debug_level =      -1"
08:31:42 readconf.c:234 got keyword:"debug_level"
08:31:42 readconf.c:244 got argument:"-1"
08:31:42 readconf.c:259 INT4=-1
08:31:42 readconf.c:227 cfg line:"debug_port = 0"
08:31:42 readconf.c:234 got keyword:"debug_port"
08:31:42 readconf.c:244 got argument:"0"
08:31:42 readconf.c:259 INT4=0
08:31:42 readconf.c:227 cfg line:"plugindir=/usr/lib/siproxd/"
08:31:42 readconf.c:234 got keyword:"plugindir"
08:31:42 readconf.c:244 got argument:"/usr/lib/siproxd/"
08:31:42 readconf.c:283 STRING="/usr/lib/siproxd/"
08:31:42 readconf.c:227 cfg line:"load_plugin=plugin_logcall.so"
08:31:42 readconf.c:234 got keyword:"load_plugin"
08:31:42 readconf.c:244 got argument:"plugin_logcall.so"
08:31:42 readconf.c:309 STRINGA[0]="plugin_logcall.so"
08:31:42 readconf.c:214 skipped: "plugin_demo_string = This_is_a_string_passed_to_the_demo_plugin"
08:31:42 readconf.c:214 skipped: "plugin_shortdial_akey = *00"
08:31:42 readconf.c:214 skipped: "plugin_shortdial_entry = 17474743246"
08:31:42 readconf.c:214 skipped: "plugin_shortdial_entry = 17474745000"
08:31:42 readconf.c:214 skipped: "plugin_defaulttarget_log = 1"
08:31:42 readconf.c:214 skipped: "plugin_defaulttarget_target = sip:cisco@192.168.15.122:5060"
08:31:42 readconf.c:214 skipped: "plugin_fix_bogus_via_networks = 10.0.0.0/8,172.16.0.0/12,192.168.0.0/16"
08:31:42 readconf.c:214 skipped: "plugin_stun_server = stun.xten.com"
08:31:42 readconf.c:214 skipped: "plugin_stun_port = 3478"
08:31:42 readconf.c:214 skipped: "plugin_stun_period = 300"
08:31:42 readconf.c:214 skipped: "plugin_prefix_akey = 0"
08:31:42 readconf.c:214 skipped: "plugin_regex_desc    = Test Regex 1"
08:31:42 readconf.c:214 skipped: "plugin_regex_pattern = ^sip:00"
08:31:42 readconf.c:214 skipped: "plugin_regex_replace = +"
08:31:42 readconf.c:214 skipped: "plugin_regex_desc    = Test Regex 2"
08:31:42 readconf.c:214 skipped: "plugin_regex_pattern = ^sip:01"
08:31:42 readconf.c:214 skipped: "plugin_regex_replace = +a"
08:31:42 readconf.c:214 skipped: "plugin_regex_desc    = Test Regex 3"
08:31:42 readconf.c:214 skipped: "plugin_regex_pattern = ^(sips?):01"
08:31:42 readconf.c:214 skipped: "plugin_regex_replace = \1:001"
08:31:42 readconf.c:133 rounded rtp_port_high down to 7088
08:31:42 plugins.c:83 load_plugins: opening plugin [/usr/lib/siproxd/plugin_logcall.so]
08:31:42 plugins.c:98 load_plugins: init=0xb77b4580, process=0xb77b45c0, end=0xb77b4840
08:31:42 INFO:plugins.c:112 Plugin 'plugin_logcall' [Logs calls to syslog] loaded with success, exemask=0x40
08:31:42 utils.c:286 running w/uid=0, euid=0, gid=0, egid=0
08:31:42 utils.c:322 changing uid/gid to siproxd
08:31:42 utils.c:325 changed gid to 117 - Ok
08:31:42 utils.c:329 changed egid to 117 - Ok
08:31:42 utils.c:333 changed euid to 115 - Ok
08:31:42 INFO:rtpproxy_relay.c:121 Current thread stacksize is 8192 kB
08:31:42 rtpproxy_relay.c:138 create thread
08:31:42 rtpproxy_relay.c:140 created, sts=0
08:31:42 rtpproxy_relay.c:151 uid=0, euid=115
08:31:42 rtpproxy_relay.c:164 pmin=1, pmax=99, using p=33
08:31:42 INFO:sock.c:131 bound to port 5060
08:31:42 sock.c:133 bound UDP socket=4, TCP socket=5
08:31:42 INFO:siproxd.c:344 siproxd-0.8.1-53 i486-pc-linux-gnu started
08:31:42 sock.c:157 entered sipsock_waitfordata
08:31:42 sock.c:169 winding up select() timeout
08:31:47 register.c:509 sip_agemap, t=1378686707
08:31:47 sock.c:157 entered sipsock_waitfordata
08:31:47 sock.c:169 winding up select() timeout
08:31:52 sock.c:220 FD 4 = active
08:31:52 sock.c:281 received UDP packet from [192.168.15.122:5060] count=427
---BUFFER DUMP follows---
  52 45 47 49 53 54 45 52 20 73 69 70 3a 6d 61 6c REGISTER sip:my.sip
  63 6f 6c 6d 2e 69 64 2e 61 75 20 53 49 50 2f 32 .server.net SIP/2
  2e 30 0d 0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 .0..Via: SIP/2.0
  2f 55 44 50 20 31 39 32 2e 31 36 38 2e 31 35 2e /UDP 192.168.15.
  31 32 32 3a 35 30 36 30 0d 0a 46 72 6f 6d 3a 20 122:5060..From: 
  73 69 70 3a 63 69 73 63 6f 40 6d 61 6c 63 6f 6c sip:ci...@my...r
  6d 2e 69 64 2e 61 75 3b 74 61 67 3d 31 32 31 34 ver.net;tag=1214
  32 31 31 34 35 37 0d 0a 54 6f 3a 20 73 69 70 3a 211457..To: sip:
  63 69 73 63 6f 40 6d 61 6c 63 6f 6c 6d 2e 69 64 ci...@my...r
  2e 61 75 0d 0a 43 61 6c 6c 2d 49 44 3a 20 33 32 ver.net..Call-ID: 32
  34 33 36 38 38 30 31 36 40 31 39 32 2e 31 36 38 43688016@192.168
  2e 31 35 2e 31 32 32 0d 0a 43 53 65 71 3a 20 31 .15.122..CSeq: 1
  20 52 45 47 49 53 54 45 52 0d 0a 43 6f 6e 74 61  REGISTER..Conta
  63 74 3a 20 4a 65 72 65 6d 79 20 61 6e 64 20 44 ct: Jeremy and D
  6f 6d 69 6e 69 63 61 20 4d 61 6c 63 6f 6c 6d 20 ominica Malcolm 
  3c 73 69 70 3a 63 69 73 63 6f 40 31 39 32 2e 31 <sip:cisco@192.1
  36 38 2e 31 35 2e 31 32 32 3a 35 30 36 30 3b 74 68.15.122:5060;t
  72 61 6e 73 70 6f 72 74 3d 75 64 70 3e 3b 65 78 ransport=udp>;ex
  70 69 72 65 73 3d 33 36 30 30 0d 0a 55 73 65 72 pires=3600..User
  2d 41 67 65 6e 74 3a 20 43 69 73 63 6f 2d 43 50 -Agent: Cisco-CP
  37 39 30 35 2f 31 2e 30 31 2d 30 33 30 38 30 37 7905/1.01-030807
  41 0d 0a 41 6c 6c 6f 77 3a 20 41 43 4b 2c 20 42 A..Allow: ACK, B
  59 45 2c 20 43 41 4e 43 45 4c 2c 20 49 4e 56 49 YE, CANCEL, INVI
  54 45 2c 20 4e 4f 54 49 46 59 2c 20 4f 50 54 49 TE, NOTIFY, OPTI
  4f 4e 53 2c 20 52 45 46 45 52 2c 20 52 45 47 49 ONS, REFER, REGI
  53 54 45 52 0d 0a 43 6f 6e 74 65 6e 74 2d 4c 65 STER..Content-Le
  6e 67 74 68 3a 20 30 0d 0a 0d 0a                ngth: 0....     

---end of BUFFER DUMP---
08:31:52 siproxd.c:387 received 427 bytes of data
08:31:52 accessctl.c:50 deny  list (SIP):*NULL*
08:31:52 accessctl.c:52 allow list (SIP):*NULL*
08:31:52 accessctl.c:54 allow list (REG):192.168.15.0/24
08:31:52 accessctl.c:149 [0] extracted address=192.168.15.0
08:31:52 accessctl.c:150 [0] extracted mask   =24
08:31:52 utils.c:99 initializing DNS cache (256 entries)
08:31:52 utils.c:215 DNS lookup - resolved: 192.168.15.0 -> 192.168.15.0
08:31:52 utils.c:255 DNS lookup - store into cache, entry 0)
08:31:52 accessctl.c:168 check match: entry=0, filter=c0a80f00, from=c0a80f00
08:31:52 accessctl.c:92 granted REG/SIP access
08:31:52 accessctl.c:99 access check =3
08:31:52 security.c:48 security_check_raw: size=427
08:31:52 siproxd.c:481 checking Max-Forwards (=70)
08:31:52 siproxd.c:526 received SIP type REQ:REGISTER
08:31:52 utils.c:215 DNS lookup - resolved: my.sip.server.net -> 85.234.150.85
08:31:52 utils.c:255 DNS lookup - store into cache, entry 1)
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:437 initializing ifaddr cache (32 entries)
08:31:52 utils.c:481 getifaddrs - eth0 / lo, ifa_addr=0xa21b77c, addrfamily=17
08:31:52 utils.c:481 getifaddrs - eth0 / eth0, ifa_addr=0xa21b818, addrfamily=17
08:31:52 utils.c:481 getifaddrs - eth0 / wlan0, ifa_addr=0xa21b8b4, addrfamily=17
08:31:52 utils.c:481 getifaddrs - eth0 / sit0, ifa_addr=0xa21b950, addrfamily=17
08:31:52 utils.c:481 getifaddrs - eth0 / he-ipv6, ifa_addr=0xa21b9ec, addrfamily=17
08:31:52 utils.c:481 getifaddrs - eth0 / lo, ifa_addr=0xa21ba88, addrfamily=2
08:31:52 utils.c:481 getifaddrs - eth0 / eth0, ifa_addr=0xa21bb24, addrfamily=2
08:31:52 utils.c:491 getifaddrs - MATCH, sin_addr=192.168.15.200
08:31:52 utils.c:543 get_ip_by_ifname: if eth0 has IP:192.168.15.200 (flags=11043) UP
08:31:52 utils.c:563 ifname lookup - store into cache, entry 0)
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:215 DNS lookup - resolved: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 utils.c:255 DNS lookup - store into cache, entry 2)
08:31:52 siproxd.c:580 proxying REGISTER request to:my.sip.server.net
08:31:52 register.c:239 sip_register:
08:31:52 register.c:325 register: cisco@192.168.15.122 expires=3600 seconds
08:31:52 sip_utils.c:279 comparing urls: sip:ci...@my... -> sip:ci...@my...
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 register.c:350 found entry for cisco@192.168.15.122 <-> ci...@my... at slot=0, exp=1605
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 register.c:450 masquerading UA cisco@192.168.15.122 local cisco@128.107.224.47
08:31:52 proxy.c:89 proxy_request
08:31:52 route_processing.c:63 route_preprocess: no Route header present
08:31:52 utils.c:215 DNS lookup - resolved: 192.168.15.122 -> 192.168.15.122
08:31:52 utils.c:255 DNS lookup - store into cache, entry 3)
08:31:52 sip_utils.c:1018 sip_find_direction: reghost:192.168.15.122 ip:192.168.15.122
08:31:52 proxy.c:180 outgoing request from ci...@my... from inbound
08:31:52 sip_utils.c:279 comparing urls: sip:cisco@192.168.15.122 -> sip:cisco@192.168.15.122
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 sip_utils.c:681 rewriting Contact header cisco@192.168.15.122 -> cisco@128.107.224.47
08:31:52 proxy.c:295 setting Max-Forwards=70
08:31:52 proxy.c:316 Purging Record-Routes (outgoing packet)
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 proxy.c:400 proxy_request: have SIP URI to my.sip.server.net:5060
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 sip_utils.c:866 non-existing branch -> branch hash [931d80f9fa8e3432466736de8a03edad]
08:31:52 sip_utils.c:593 adding VIA:SIP/2.0/UDP 128.107.224.47:5060;branch=z9hG4bK931d80f9fa8e3432466736de8a03edad
08:31:52 sock.c:434 send UDP packet to 85.234.150.85: 5060
---BUFFER DUMP follows---
  52 45 47 49 53 54 45 52 20 73 69 70 3a 6d 61 6c REGISTER sip:my.sip
  63 6f 6c 6d 2e 69 64 2e 61 75 20 53 49 50 2f 32 .server.net SIP/2
  2e 30 0d 0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 .0..Via: SIP/2.0
  2f 55 44 50 20 31 31 38 2e 31 30 37 2e 32 32 34 /UDP 128.107.224
  2e 34 37 3a 35 30 36 30 3b 62 72 61 6e 63 68 3d .47:5060;branch=
  7a 39 68 47 34 62 4b 39 33 31 64 38 30 66 39 66 z9hG4bK931d80f9f
  61 38 65 33 34 33 32 34 36 36 37 33 36 64 65 38 a8e3432466736de8
  61 30 33 65 64 61 64 0d 0a 56 69 61 3a 20 53 49 a03edad..Via: SI
  50 2f 32 2e 30 2f 55 44 50 20 31 39 32 2e 31 36 P/2.0/UDP 192.16
  38 2e 31 35 2e 31 32 32 3a 35 30 36 30 0d 0a 46 8.15.122:5060..F
  72 6f 6d 3a 20 3c 73 69 70 3a 63 69 73 63 6f 40 rom: <sip:cisco@
  6d 61 6c 63 6f 6c 6d 2e 69 64 2e 61 75 3e 3b 74 my.sip.server.net>;t
  61 67 3d 31 32 31 34 32 31 31 34 35 37 0d 0a 54 ag=1214211457..T
  6f 3a 20 3c 73 69 70 3a 63 69 73 63 6f 40 6d 61 o: <sip:cisco@my.
  6c 63 6f 6c 6d 2e 69 64 2e 61 75 3e 0d 0a 43 61 sip.server.net>..Ca
  6c 6c 2d 49 44 3a 20 33 32 34 33 36 38 38 30 31 ll-ID: 324368801
  36 40 31 39 32 2e 31 36 38 2e 31 35 2e 31 32 32 6@192.168.15.122
  0d 0a 43 53 65 71 3a 20 31 20 52 45 47 49 53 54 ..CSeq: 1 REGIST
  45 52 0d 0a 43 6f 6e 74 61 63 74 3a 20 4a 65 72 ER..Contact: Jer
  65 6d 79 20 61 6e 64 20 44 6f 6d 69 6e 69 63 61 emy and Dominica
  20 4d 61 6c 63 6f 6c 6d 20 3c 73 69 70 3a 63 69  Malcolm <sip:ci
  73 63 6f 40 31 31 38 2e 31 30 37 2e 32 32 34 2e sco@128.107.224.
  34 37 3e 3b 65 78 70 69 72 65 73 3d 33 36 30 30 47>;expires=3600
  0d 0a 41 6c 6c 6f 77 3a 20 41 43 4b 0d 0a 41 6c ..Allow: ACK..Al
  6c 6f 77 3a 20 42 59 45 0d 0a 41 6c 6c 6f 77 3a low: BYE..Allow:
  20 43 41 4e 43 45 4c 0d 0a 41 6c 6c 6f 77 3a 20  CANCEL..Allow: 
  49 4e 56 49 54 45 0d 0a 41 6c 6c 6f 77 3a 20 4e INVITE..Allow: N
  4f 54 49 46 59 0d 0a 41 6c 6c 6f 77 3a 20 4f 50 OTIFY..Allow: OP
  54 49 4f 4e 53 0d 0a 41 6c 6c 6f 77 3a 20 52 45 TIONS..Allow: RE
  46 45 52 0d 0a 41 6c 6c 6f 77 3a 20 52 45 47 49 FER..Allow: REGI
  53 54 45 52 0d 0a 55 73 65 72 2d 61 67 65 6e 74 STER..User-agent
  3a 20 43 69 73 63 6f 2d 43 50 37 39 30 35 2f 31 : Cisco-CP7905/1
  2e 30 31 2d 30 33 30 38 30 37 41 0d 0a 4d 61 78 .01-030807A..Max
  2d 46 6f 72 77 61 72 64 73 3a 20 37 30 0d 0a 43 -Forwards: 70..C
  6f 6e 74 65 6e 74 2d 4c 65 6e 67 74 68 3a 20 30 ontent-Length: 0
  0d 0a 0d 0a                                     ....            

---end of BUFFER DUMP---
08:31:52 sock.c:157 entered sipsock_waitfordata
08:31:52 register.c:509 sip_agemap, t=1378686712
08:31:52 sock.c:157 entered sipsock_waitfordata
08:31:52 sock.c:169 winding up select() timeout
08:31:52 sock.c:220 FD 4 = active
08:31:52 sock.c:281 received UDP packet from [85.234.150.85:5060] count=341
---BUFFER DUMP follows---
  53 49 50 2f 32 2e 30 20 31 30 30 20 54 72 79 69 SIP/2.0 100 Tryi
  6e 67 0d 0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 ng..Via: SIP/2.0
  2f 55 44 50 20 31 39 32 2e 31 36 38 2e 31 35 2e /UDP 192.168.15.
  32 30 30 3a 35 30 36 30 3b 62 72 61 6e 63 68 3d 200:5060;branch=
  7a 39 68 47 34 62 4b 39 33 31 64 38 30 66 39 66 z9hG4bK931d80f9f
  61 38 65 33 34 33 32 34 36 36 37 33 36 64 65 38 a8e3432466736de8
  61 30 33 65 64 61 64 3b 72 65 63 65 69 76 65 64 a03edad;received
  3d 31 31 38 2e 31 30 37 2e 32 32 34 2e 34 37 0d =128.107.224.47.
  0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 2f 55 44 .Via: SIP/2.0/UD
  50 20 31 39 32 2e 31 36 38 2e 31 35 2e 31 32 32 P 192.168.15.122
  3a 35 30 36 30 0d 0a 46 72 6f 6d 3a 20 3c 73 69 :5060..From: <si
  70 3a 63 69 73 63 6f 40 6d 61 6c 63 6f 6c 6d 2e p:ci...@my...r
  69 64 2e 61 75 3e 3b 74 61 67 3d 31 32 31 34 32 ver.net>;tag=12142
  31 31 34 35 37 0d 0a 54 6f 3a 20 3c 73 69 70 3a 11457..To: <sip:
  63 69 73 63 6f 40 6d 61 6c 63 6f 6c 6d 2e 69 64 ci...@my...r
  2e 61 75 3e 0d 0a 43 61 6c 6c 2d 49 44 3a 20 33 ver.net>..Call-ID: 3
  32 34 33 36 38 38 30 31 36 40 31 39 32 2e 31 36 243688016@192.16
  38 2e 31 35 2e 31 32 32 0d 0a 43 53 65 71 3a 20 8.15.122..CSeq: 
  31 20 52 45 47 49 53 54 45 52 0d 0a 53 65 72 76 1 REGISTER..Serv
  65 72 3a 20 59 41 54 45 2f 34 2e 31 2e 30 0d 0a er: YATE/4.1.0..
  43 6f 6e 74 65 6e 74 2d 4c 65 6e 67 74 68 3a 20 Content-Length: 
  30 0d 0a 0d 0a                                  0....           

---end of BUFFER DUMP---
08:31:52 siproxd.c:387 received 341 bytes of data
08:31:52 accessctl.c:50 deny  list (SIP):*NULL*
08:31:52 accessctl.c:52 allow list (SIP):*NULL*
08:31:52 accessctl.c:54 allow list (REG):192.168.15.0/24
08:31:52 accessctl.c:149 [0] extracted address=192.168.15.0
08:31:52 accessctl.c:150 [0] extracted mask   =24
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.0 -> 192.168.15.0
08:31:52 accessctl.c:168 check match: entry=0, filter=c0a80f00, from=55ea9600
08:31:52 accessctl.c:99 access check =1
08:31:52 security.c:48 security_check_raw: size=341
08:31:52 siproxd.c:481 checking Max-Forwards (=70)
08:31:52 sip_utils.c:198 via name 192.168.15.122
08:31:52 sip_utils.c:221 resolving IP of interface outbound
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 sip_utils.c:221 resolving IP of interface inbound
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 sip_utils.c:229 resolving IP of interface 'host_outbound'
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 siproxd.c:526 received SIP type RES:Trying
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 proxy.c:483 proxy_response
08:31:52 sip_utils.c:618 deleting topmost VIA
08:31:52 sip_utils.c:198 via name 192.168.15.200
08:31:52 sip_utils.c:221 resolving IP of interface outbound
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 sip_utils.c:221 resolving IP of interface inbound
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 sip_utils.c:238 got address match [192.168.15.200]
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 sip_utils.c:1018 sip_find_direction: reghost:192.168.15.122 ip:85.234.150.85
08:31:52 sip_utils.c:279 comparing urls: sip:ci...@my... -> sip:ci...@my...
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 proxy.c:523 incoming response for ci...@my... from outbound
08:31:52 register.c:649 REGISTER response, looking for 'Expire' information
08:31:52 proxy.c:655 Adding my Record-Route
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 sock.c:434 send UDP packet to 192.168.15.122: 5060
---BUFFER DUMP follows---
  53 49 50 2f 32 2e 30 20 31 30 30 20 54 72 79 69 SIP/2.0 100 Tryi
  6e 67 0d 0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 ng..Via: SIP/2.0
  2f 55 44 50 20 31 39 32 2e 31 36 38 2e 31 35 2e /UDP 192.168.15.
  31 32 32 3a 35 30 36 30 0d 0a 52 65 63 6f 72 64 122:5060..Record
  2d 52 6f 75 74 65 3a 20 3c 73 69 70 3a 73 69 70 -Route: <sip:sip
  72 6f 78 64 40 31 39 32 2e 31 36 38 2e 31 35 2e roxd@192.168.15.
  32 30 30 3a 35 30 36 30 3b 6c 72 3e 0d 0a 46 72 200:5060;lr>..Fr
  6f 6d 3a 20 3c 73 69 70 3a 63 69 73 63 6f 40 6d om: <sip:cisco@my.
  61 6c 63 6f 6c 6d 2e 69 64 2e 61 75 3e 3b 74 61 sip.server.net>;ta
  67 3d 31 32 31 34 32 31 31 34 35 37 0d 0a 54 6f g=1214211457..To
  3a 20 3c 73 69 70 3a 63 69 73 63 6f 40 6d 61 6c : <sip:ci...@my...p
  63 6f 6c 6d 2e 69 64 2e 61 75 3e 0d 0a 43 61 6c .server.net>..Cal
  6c 2d 49 44 3a 20 33 32 34 33 36 38 38 30 31 36 l-ID: 3243688016
  40 31 39 32 2e 31 36 38 2e 31 35 2e 31 32 32 0d @192.168.15.122.
  0a 43 53 65 71 3a 20 31 20 52 45 47 49 53 54 45 .CSeq: 1 REGISTE
  52 0d 0a 53 65 72 76 65 72 3a 20 59 41 54 45 2f R..Server: YATE/
  34 2e 31 2e 30 0d 0a 43 6f 6e 74 65 6e 74 2d 4c 4.1.0..Content-L
  65 6e 67 74 68 3a 20 30 0d 0a 0d 0a             ength: 0....    

---end of BUFFER DUMP---
08:31:52 sock.c:157 entered sipsock_waitfordata
08:31:52 sock.c:220 FD 4 = active
08:31:52 sock.c:281 received UDP packet from [85.234.150.85:5060] count=532
---BUFFER DUMP follows---
  53 49 50 2f 32 2e 30 20 34 30 31 20 55 6e 61 75 SIP/2.0 401 Unau
  74 68 6f 72 69 7a 65 64 0d 0a 56 69 61 3a 20 53 thorized..Via: S
  49 50 2f 32 2e 30 2f 55 44 50 20 31 39 32 2e 31 IP/2.0/UDP 192.1
  36 38 2e 31 35 2e 32 30 30 3a 35 30 36 30 3b 62 68.15.200:5060;b
  72 61 6e 63 68 3d 7a 39 68 47 34 62 4b 39 33 31 ranch=z9hG4bK931
  64 38 30 66 39 66 61 38 65 33 34 33 32 34 36 36 d80f9fa8e3432466
  37 33 36 64 65 38 61 30 33 65 64 61 64 3b 72 65 736de8a03edad;re
  63 65 69 76 65 64 3d 31 31 38 2e 31 30 37 2e 32 ceived=128.107.2
  32 34 2e 34 37 0d 0a 56 69 61 3a 20 53 49 50 2f 24.47..Via: SIP/
  32 2e 30 2f 55 44 50 20 31 39 32 2e 31 36 38 2e 2.0/UDP 192.168.
  31 35 2e 31 32 32 3a 35 30 36 30 0d 0a 46 72 6f 15.122:5060..Fro
  6d 3a 20 3c 73 69 70 3a 63 69 73 63 6f 40 6d 61 m: <sip:cisco@my.
  6c 63 6f 6c 6d 2e 69 64 2e 61 75 3e 3b 74 61 67 sip.server.net>;tag
  3d 31 32 31 34 32 31 31 34 35 37 0d 0a 54 6f 3a =1214211457..To:
  20 3c 73 69 70 3a 63 69 73 63 6f 40 6d 61 6c 63  <sip:ci...@my...p
  6f 6c 6d 2e 69 64 2e 61 75 3e 0d 0a 43 61 6c 6c .server.net>..Call
  2d 49 44 3a 20 33 32 34 33 36 38 38 30 31 36 40 -ID: 3243688016@
  31 39 32 2e 31 36 38 2e 31 35 2e 31 32 32 0d 0a 192.168.15.122..
  43 53 65 71 3a 20 31 20 52 45 47 49 53 54 45 52 CSeq: 1 REGISTER
  0d 0a 57 57 57 2d 41 75 74 68 65 6e 74 69 63 61 ..WWW-Authentica
  74 65 3a 20 44 69 67 65 73 74 20 72 65 61 6c 6d te: Digest realm
  3d 22 59 61 74 65 22 2c 20 6e 6f 6e 63 65 3d 22 ="Yate", nonce="
  36 37 32 34 66 33 66 66 63 66 39 35 31 38 37 61 6724f3ffcf95187a
  65 36 35 31 65 36 64 62 35 37 32 64 33 39 31 30 e651e6db572d3910
  2e 31 33 37 38 36 38 37 31 33 35 22 2c 20 73 74 .1378687135", st
  61 6c 65 3d 46 41 4c 53 45 2c 20 61 6c 67 6f 72 ale=FALSE, algor
  69 74 68 6d 3d 4d 44 35 0d 0a 53 65 72 76 65 72 ithm=MD5..Server
  3a 20 59 41 54 45 2f 34 2e 31 2e 30 0d 0a 41 6c : YATE/4.1.0..Al
  6c 6f 77 3a 20 41 43 4b 2c 20 49 4e 56 49 54 45 low: ACK, INVITE
  2c 20 42 59 45 2c 20 43 41 4e 43 45 4c 2c 20 52 , BYE, CANCEL, R
  45 47 49 53 54 45 52 2c 20 52 45 46 45 52 2c 20 EGISTER, REFER, 
  4f 50 54 49 4f 4e 53 2c 20 49 4e 46 4f 0d 0a 43 OPTIONS, INFO..C
  6f 6e 74 65 6e 74 2d 4c 65 6e 67 74 68 3a 20 30 ontent-Length: 0
  0d 0a 0d 0a                                     ....            

---end of BUFFER DUMP---
08:31:52 siproxd.c:387 received 532 bytes of data
08:31:52 accessctl.c:50 deny  list (SIP):*NULL*
08:31:52 accessctl.c:52 allow list (SIP):*NULL*
08:31:52 accessctl.c:54 allow list (REG):192.168.15.0/24
08:31:52 accessctl.c:149 [0] extracted address=192.168.15.0
08:31:52 accessctl.c:150 [0] extracted mask   =24
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.0 -> 192.168.15.0
08:31:52 accessctl.c:168 check match: entry=0, filter=c0a80f00, from=55ea9600
08:31:52 accessctl.c:99 access check =1
08:31:52 security.c:48 security_check_raw: size=532
08:31:52 siproxd.c:481 checking Max-Forwards (=70)
08:31:52 sip_utils.c:198 via name 192.168.15.122
08:31:52 sip_utils.c:221 resolving IP of interface outbound
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 sip_utils.c:221 resolving IP of interface inbound
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 sip_utils.c:229 resolving IP of interface 'host_outbound'
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 siproxd.c:526 received SIP type RES:Unauthorized
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 proxy.c:483 proxy_response
08:31:52 sip_utils.c:618 deleting topmost VIA
08:31:52 sip_utils.c:198 via name 192.168.15.200
08:31:52 sip_utils.c:221 resolving IP of interface outbound
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 sip_utils.c:221 resolving IP of interface inbound
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 sip_utils.c:238 got address match [192.168.15.200]
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 sip_utils.c:1018 sip_find_direction: reghost:192.168.15.122 ip:85.234.150.85
08:31:52 sip_utils.c:279 comparing urls: sip:ci...@my... -> sip:ci...@my...
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 proxy.c:523 incoming response for ci...@my... from outbound
08:31:52 register.c:649 REGISTER response, looking for 'Expire' information
08:31:52 proxy.c:655 Adding my Record-Route
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 sock.c:434 send UDP packet to 192.168.15.122: 5060
---BUFFER DUMP follows---
  53 49 50 2f 32 2e 30 20 34 30 31 20 55 6e 61 75 SIP/2.0 401 Unau
  74 68 6f 72 69 7a 65 64 0d 0a 56 69 61 3a 20 53 thorized..Via: S
  49 50 2f 32 2e 30 2f 55 44 50 20 31 39 32 2e 31 IP/2.0/UDP 192.1
  36 38 2e 31 35 2e 31 32 32 3a 35 30 36 30 0d 0a 68.15.122:5060..
  52 65 63 6f 72 64 2d 52 6f 75 74 65 3a 20 3c 73 Record-Route: <s
  69 70 3a 73 69 70 72 6f 78 64 40 31 39 32 2e 31 ip:siproxd@192.1
  36 38 2e 31 35 2e 32 30 30 3a 35 30 36 30 3b 6c 68.15.200:5060;l
  72 3e 0d 0a 46 72 6f 6d 3a 20 3c 73 69 70 3a 63 r>..From: <sip:c
  69 73 63 6f 40 6d 61 6c 63 6f 6c 6d 2e 69 64 2e is...@my...rver
  61 75 3e 3b 74 61 67 3d 31 32 31 34 32 31 31 34 .net>;tag=12142114
  35 37 0d 0a 54 6f 3a 20 3c 73 69 70 3a 63 69 73 57..To: <sip:cis
  63 6f 40 6d 61 6c 63 6f 6c 6d 2e 69 64 2e 61 75 co...@my...
  3e 0d 0a 43 61 6c 6c 2d 49 44 3a 20 33 32 34 33 >..Call-ID: 3243
  36 38 38 30 31 36 40 31 39 32 2e 31 36 38 2e 31 688016@192.168.1
  35 2e 31 32 32 0d 0a 43 53 65 71 3a 20 31 20 52 5.122..CSeq: 1 R
  45 47 49 53 54 45 52 0d 0a 57 57 57 2d 41 75 74 EGISTER..WWW-Aut
  68 65 6e 74 69 63 61 74 65 3a 20 44 69 67 65 73 henticate: Diges
  74 20 72 65 61 6c 6d 3d 22 59 61 74 65 22 2c 20 t realm="Yate", 
  6e 6f 6e 63 65 3d 22 36 37 32 34 66 33 66 66 63 nonce="6724f3ffc
  66 39 35 31 38 37 61 65 36 35 31 65 36 64 62 35 f95187ae651e6db5
  37 32 64 33 39 31 30 2e 31 33 37 38 36 38 37 31 72d3910.13786871
  33 35 22 2c 20 73 74 61 6c 65 3d 46 41 4c 53 45 35", stale=FALSE
  2c 20 61 6c 67 6f 72 69 74 68 6d 3d 4d 44 35 0d , algorithm=MD5.
  0a 41 6c 6c 6f 77 3a 20 41 43 4b 0d 0a 41 6c 6c .Allow: ACK..All
  6f 77 3a 20 49 4e 56 49 54 45 0d 0a 41 6c 6c 6f ow: INVITE..Allo
  77 3a 20 42 59 45 0d 0a 41 6c 6c 6f 77 3a 20 43 w: BYE..Allow: C
  41 4e 43 45 4c 0d 0a 41 6c 6c 6f 77 3a 20 52 45 ANCEL..Allow: RE
  47 49 53 54 45 52 0d 0a 41 6c 6c 6f 77 3a 20 52 GISTER..Allow: R
  45 46 45 52 0d 0a 41 6c 6c 6f 77 3a 20 4f 50 54 EFER..Allow: OPT
  49 4f 4e 53 0d 0a 41 6c 6c 6f 77 3a 20 49 4e 46 IONS..Allow: INF
  4f 0d 0a 53 65 72 76 65 72 3a 20 59 41 54 45 2f O..Server: YATE/
  34 2e 31 2e 30 0d 0a 43 6f 6e 74 65 6e 74 2d 4c 4.1.0..Content-L
  65 6e 67 74 68 3a 20 30 0d 0a 0d 0a             ength: 0....    

---end of BUFFER DUMP---
08:31:52 sock.c:157 entered sipsock_waitfordata
08:31:52 sock.c:220 FD 4 = active
08:31:52 sock.c:281 received UDP packet from [192.168.15.122:5060] count=600
---BUFFER DUMP follows---
  52 45 47 49 53 54 45 52 20 73 69 70 3a 6d 61 6c REGISTER sip:my.sip
  63 6f 6c 6d 2e 69 64 2e 61 75 20 53 49 50 2f 32 .server.net SIP/2
  2e 30 0d 0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 .0..Via: SIP/2.0
  2f 55 44 50 20 31 39 32 2e 31 36 38 2e 31 35 2e /UDP 192.168.15.
  31 32 32 3a 35 30 36 30 0d 0a 46 72 6f 6d 3a 20 122:5060..From: 
  73 69 70 3a 63 69 73 63 6f 40 6d 61 6c 63 6f 6c sip:ci...@my...r
  6d 2e 69 64 2e 61 75 3b 74 61 67 3d 31 32 31 34 ver.net;tag=1214
  32 31 31 34 35 37 0d 0a 54 6f 3a 20 73 69 70 3a 211457..To: sip:
  63 69 73 63 6f 40 6d 61 6c 63 6f 6c 6d 2e 69 64 ci...@my...r
  2e 61 75 0d 0a 43 61 6c 6c 2d 49 44 3a 20 33 32 ver.net..Call-ID: 32
  34 33 36 38 38 30 31 36 40 31 39 32 2e 31 36 38 43688016@192.168
  2e 31 35 2e 31 32 32 0d 0a 43 53 65 71 3a 20 32 .15.122..CSeq: 2
  20 52 45 47 49 53 54 45 52 0d 0a 43 6f 6e 74 61  REGISTER..Conta
  63 74 3a 20 4a 65 72 65 6d 79 20 61 6e 64 20 44 ct: Jeremy and D
  6f 6d 69 6e 69 63 61 20 4d 61 6c 63 6f 6c 6d 20 ominica Malcolm 
  3c 73 69 70 3a 63 69 73 63 6f 40 31 39 32 2e 31 <sip:cisco@192.1
  36 38 2e 31 35 2e 31 32 32 3a 35 30 36 30 3b 74 68.15.122:5060;t
  72 61 6e 73 70 6f 72 74 3d 75 64 70 3e 3b 65 78 ransport=udp>;ex
  70 69 72 65 73 3d 33 36 30 30 0d 0a 55 73 65 72 pires=3600..User
  2d 41 67 65 6e 74 3a 20 43 69 73 63 6f 2d 43 50 -Agent: Cisco-CP
  37 39 30 35 2f 31 2e 30 31 2d 30 33 30 38 30 37 7905/1.01-030807
  41 0d 0a 41 6c 6c 6f 77 3a 20 41 43 4b 2c 20 42 A..Allow: ACK, B
  59 45 2c 20 43 41 4e 43 45 4c 2c 20 49 4e 56 49 YE, CANCEL, INVI
  54 45 2c 20 4e 4f 54 49 46 59 2c 20 4f 50 54 49 TE, NOTIFY, OPTI
  4f 4e 53 2c 20 52 45 46 45 52 2c 20 52 45 47 49 ONS, REFER, REGI
  53 54 45 52 0d 0a 41 75 74 68 6f 72 69 7a 61 74 STER..Authorizat
  69 6f 6e 3a 20 44 69 67 65 73 74 20 75 73 65 72 ion: Digest user
  6e 61 6d 65 3d 22 63 69 73 63 6f 22 2c 72 65 61 name="cisco",rea
  6c 6d 3d 22 59 61 74 65 22 2c 6e 6f 6e 63 65 3d lm="Yate",nonce=
  22 36 37 32 34 66 33 66 66 63 66 39 35 31 38 37 "6724f3ffcf95187
  61 65 36 35 31 65 36 64 62 35 37 32 64 33 39 31 ae651e6db572d391
  30 2e 31 33 37 38 36 38 37 31 33 35 22 2c 75 72 0.1378687135",ur
  69 3d 22 73 69 70 3a 6d 61 6c 63 6f 6c 6d 2e 69 i="sip:my.sip.ser
  64 2e 61 75 22 2c 72 65 73 70 6f 6e 73 65 3d 22 ver.net",response="
  36 64 39 62 33 62 30 61 39 38 38 37 36 63 66 33 6d9b3b0a98876cf3
  62 33 32 66 62 33 34 62 65 34 61 37 34 36 62 31 b32fb34be4a746b1
  22 0d 0a 43 6f 6e 74 65 6e 74 2d 4c 65 6e 67 74 "..Content-Lengt
  68 3a 20 30 0d 0a 0d 0a                         h: 0....        

---end of BUFFER DUMP---
08:31:52 siproxd.c:387 received 600 bytes of data
08:31:52 accessctl.c:50 deny  list (SIP):*NULL*
08:31:52 accessctl.c:52 allow list (SIP):*NULL*
08:31:52 accessctl.c:54 allow list (REG):192.168.15.0/24
08:31:52 accessctl.c:149 [0] extracted address=192.168.15.0
08:31:52 accessctl.c:150 [0] extracted mask   =24
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.0 -> 192.168.15.0
08:31:52 accessctl.c:168 check match: entry=0, filter=c0a80f00, from=c0a80f00
08:31:52 accessctl.c:92 granted REG/SIP access
08:31:52 accessctl.c:99 access check =3
08:31:52 security.c:48 security_check_raw: size=600
08:31:52 siproxd.c:481 checking Max-Forwards (=70)
08:31:52 siproxd.c:526 received SIP type REQ:REGISTER
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 siproxd.c:580 proxying REGISTER request to:my.sip.server.net
08:31:52 register.c:239 sip_register:
08:31:52 register.c:325 register: cisco@192.168.15.122 expires=3600 seconds
08:31:52 sip_utils.c:279 comparing urls: sip:ci...@my... -> sip:ci...@my...
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 register.c:350 found entry for cisco@192.168.15.122 <-> ci...@my... at slot=0, exp=3630
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 register.c:450 masquerading UA cisco@192.168.15.122 local cisco@128.107.224.47
08:31:52 proxy.c:89 proxy_request
08:31:52 route_processing.c:63 route_preprocess: no Route header present
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 sip_utils.c:1018 sip_find_direction: reghost:192.168.15.122 ip:192.168.15.122
08:31:52 proxy.c:180 outgoing request from ci...@my... from inbound
08:31:52 sip_utils.c:279 comparing urls: sip:cisco@192.168.15.122 -> sip:cisco@192.168.15.122
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 sip_utils.c:681 rewriting Contact header cisco@192.168.15.122 -> cisco@128.107.224.47
08:31:52 proxy.c:295 setting Max-Forwards=70
08:31:52 proxy.c:316 Purging Record-Routes (outgoing packet)
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 proxy.c:400 proxy_request: have SIP URI to my.sip.server.net:5060
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 sip_utils.c:866 non-existing branch -> branch hash [d3d210a2724e25d0172ca661a88d016c]
08:31:52 sip_utils.c:593 adding VIA:SIP/2.0/UDP 128.107.224.47:5060;branch=z9hG4bKd3d210a2724e25d0172ca661a88d016c
08:31:52 sock.c:434 send UDP packet to 85.234.150.85: 5060
---BUFFER DUMP follows---
  52 45 47 49 53 54 45 52 20 73 69 70 3a 6d 61 6c REGISTER sip:my.sip
  63 6f 6c 6d 2e 69 64 2e 61 75 20 53 49 50 2f 32 .server.net SIP/2
  2e 30 0d 0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 .0..Via: SIP/2.0
  2f 55 44 50 20 31 31 38 2e 31 30 37 2e 32 32 34 /UDP 128.107.224
  2e 34 37 3a 35 30 36 30 3b 62 72 61 6e 63 68 3d .47:5060;branch=
  7a 39 68 47 34 62 4b 64 33 64 32 31 30 61 32 37 z9hG4bKd3d210a27
  32 34 65 32 35 64 30 31 37 32 63 61 36 36 31 61 24e25d0172ca661a
  38 38 64 30 31 36 63 0d 0a 56 69 61 3a 20 53 49 88d016c..Via: SI
  50 2f 32 2e 30 2f 55 44 50 20 31 39 32 2e 31 36 P/2.0/UDP 192.16
  38 2e 31 35 2e 31 32 32 3a 35 30 36 30 0d 0a 46 8.15.122:5060..F
  72 6f 6d 3a 20 3c 73 69 70 3a 63 69 73 63 6f 40 rom: <sip:cisco@
  6d 61 6c 63 6f 6c 6d 2e 69 64 2e 61 75 3e 3b 74 my.sip.server.net>;t
  61 67 3d 31 32 31 34 32 31 31 34 35 37 0d 0a 54 ag=1214211457..T
  6f 3a 20 3c 73 69 70 3a 63 69 73 63 6f 40 6d 61 o: <sip:cisco@my.
  6c 63 6f 6c 6d 2e 69 64 2e 61 75 3e 0d 0a 43 61 sip.server.net>..Ca
  6c 6c 2d 49 44 3a 20 33 32 34 33 36 38 38 30 31 ll-ID: 324368801
  36 40 31 39 32 2e 31 36 38 2e 31 35 2e 31 32 32 6@192.168.15.122
  0d 0a 43 53 65 71 3a 20 32 20 52 45 47 49 53 54 ..CSeq: 2 REGIST
  45 52 0d 0a 43 6f 6e 74 61 63 74 3a 20 4a 65 72 ER..Contact: Jer
  65 6d 79 20 61 6e 64 20 44 6f 6d 69 6e 69 63 61 emy and Dominica
  20 4d 61 6c 63 6f 6c 6d 20 3c 73 69 70 3a 63 69  Malcolm <sip:ci
  73 63 6f 40 31 31 38 2e 31 30 37 2e 32 32 34 2e sco@128.107.224.
  34 37 3e 3b 65 78 70 69 72 65 73 3d 33 36 30 30 47>;expires=3600
  0d 0a 41 75 74 68 6f 72 69 7a 61 74 69 6f 6e 3a ..Authorization:
  20 44 69 67 65 73 74 20 75 73 65 72 6e 61 6d 65  Digest username
  3d 22 63 69 73 63 6f 22 2c 20 72 65 61 6c 6d 3d ="cisco", realm=
  22 59 61 74 65 22 2c 20 6e 6f 6e 63 65 3d 22 36 "Yate", nonce="6
  37 32 34 66 33 66 66 63 66 39 35 31 38 37 61 65 724f3ffcf95187ae
  36 35 31 65 36 64 62 35 37 32 64 33 39 31 30 2e 651e6db572d3910.
  31 33 37 38 36 38 37 31 33 35 22 2c 20 75 72 69 1378687135", uri
  3d 22 73 69 70 3a 6d 61 6c 63 6f 6c 6d 2e 69 64 ="sip:my.sip.ser
  2e 61 75 22 2c 20 72 65 73 70 6f 6e 73 65 3d 22 ver.net", response="
  36 64 39 62 33 62 30 61 39 38 38 37 36 63 66 33 6d9b3b0a98876cf3
  62 33 32 66 62 33 34 62 65 34 61 37 34 36 62 31 b32fb34be4a746b1
  22 0d 0a 41 6c 6c 6f 77 3a 20 41 43 4b 0d 0a 41 "..Allow: ACK..A
  6c 6c 6f 77 3a 20 42 59 45 0d 0a 41 6c 6c 6f 77 llow: BYE..Allow
  3a 20 43 41 4e 43 45 4c 0d 0a 41 6c 6c 6f 77 3a : CANCEL..Allow:
  20 49 4e 56 49 54 45 0d 0a 41 6c 6c 6f 77 3a 20  INVITE..Allow: 
  4e 4f 54 49 46 59 0d 0a 41 6c 6c 6f 77 3a 20 4f NOTIFY..Allow: O
  50 54 49 4f 4e 53 0d 0a 41 6c 6c 6f 77 3a 20 52 PTIONS..Allow: R
  45 46 45 52 0d 0a 41 6c 6c 6f 77 3a 20 52 45 47 EFER..Allow: REG
  49 53 54 45 52 0d 0a 55 73 65 72 2d 61 67 65 6e ISTER..User-agen
  74 3a 20 43 69 73 63 6f 2d 43 50 37 39 30 35 2f t: Cisco-CP7905/
  31 2e 30 31 2d 30 33 30 38 30 37 41 0d 0a 4d 61 1.01-030807A..Ma
  78 2d 46 6f 72 77 61 72 64 73 3a 20 37 30 0d 0a x-Forwards: 70..
  43 6f 6e 74 65 6e 74 2d 4c 65 6e 67 74 68 3a 20 Content-Length: 
  30 0d 0a 0d 0a                                  0....           

---end of BUFFER DUMP---
08:31:52 sock.c:157 entered sipsock_waitfordata
08:31:52 sock.c:220 FD 4 = active
08:31:52 sock.c:281 received UDP packet from [85.234.150.85:5060] count=341
---BUFFER DUMP follows---
  53 49 50 2f 32 2e 30 20 31 30 30 20 54 72 79 69 SIP/2.0 100 Tryi
  6e 67 0d 0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 ng..Via: SIP/2.0
  2f 55 44 50 20 31 39 32 2e 31 36 38 2e 31 35 2e /UDP 192.168.15.
  32 30 30 3a 35 30 36 30 3b 62 72 61 6e 63 68 3d 200:5060;branch=
  7a 39 68 47 34 62 4b 64 33 64 32 31 30 61 32 37 z9hG4bKd3d210a27
  32 34 65 32 35 64 30 31 37 32 63 61 36 36 31 61 24e25d0172ca661a
  38 38 64 30 31 36 63 3b 72 65 63 65 69 76 65 64 88d016c;received
  3d 31 31 38 2e 31 30 37 2e 32 32 34 2e 34 37 0d =128.107.224.47.
  0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 2f 55 44 .Via: SIP/2.0/UD
  50 20 31 39 32 2e 31 36 38 2e 31 35 2e 31 32 32 P 192.168.15.122
  3a 35 30 36 30 0d 0a 46 72 6f 6d 3a 20 3c 73 69 :5060..From: <si
  70 3a 63 69 73 63 6f 40 6d 61 6c 63 6f 6c 6d 2e p:ci...@my...r
  69 64 2e 61 75 3e 3b 74 61 67 3d 31 32 31 34 32 ver.net>;tag=12142
  31 31 34 35 37 0d 0a 54 6f 3a 20 3c 73 69 70 3a 11457..To: <sip:
  63 69 73 63 6f 40 6d 61 6c 63 6f 6c 6d 2e 69 64 ci...@my...r
  2e 61 75 3e 0d 0a 43 61 6c 6c 2d 49 44 3a 20 33 ver.net>..Call-ID: 3
  32 34 33 36 38 38 30 31 36 40 31 39 32 2e 31 36 243688016@192.16
  38 2e 31 35 2e 31 32 32 0d 0a 43 53 65 71 3a 20 8.15.122..CSeq: 
  32 20 52 45 47 49 53 54 45 52 0d 0a 53 65 72 76 2 REGISTER..Serv
  65 72 3a 20 59 41 54 45 2f 34 2e 31 2e 30 0d 0a er: YATE/4.1.0..
  43 6f 6e 74 65 6e 74 2d 4c 65 6e 67 74 68 3a 20 Content-Length: 
  30 0d 0a 0d 0a                                  0....           

---end of BUFFER DUMP---
08:31:52 siproxd.c:387 received 341 bytes of data
08:31:52 accessctl.c:50 deny  list (SIP):*NULL*
08:31:52 accessctl.c:52 allow list (SIP):*NULL*
08:31:52 accessctl.c:54 allow list (REG):192.168.15.0/24
08:31:52 accessctl.c:149 [0] extracted address=192.168.15.0
08:31:52 accessctl.c:150 [0] extracted mask   =24
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.0 -> 192.168.15.0
08:31:52 accessctl.c:168 check match: entry=0, filter=c0a80f00, from=55ea9600
08:31:52 accessctl.c:99 access check =1
08:31:52 security.c:48 security_check_raw: size=341
08:31:52 siproxd.c:481 checking Max-Forwards (=70)
08:31:52 sip_utils.c:198 via name 192.168.15.122
08:31:52 sip_utils.c:221 resolving IP of interface outbound
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 sip_utils.c:221 resolving IP of interface inbound
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 sip_utils.c:229 resolving IP of interface 'host_outbound'
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 siproxd.c:526 received SIP type RES:Trying
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 proxy.c:483 proxy_response
08:31:52 sip_utils.c:618 deleting topmost VIA
08:31:52 sip_utils.c:198 via name 192.168.15.200
08:31:52 sip_utils.c:221 resolving IP of interface outbound
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 sip_utils.c:221 resolving IP of interface inbound
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 sip_utils.c:238 got address match [192.168.15.200]
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 sip_utils.c:1018 sip_find_direction: reghost:192.168.15.122 ip:85.234.150.85
08:31:52 sip_utils.c:279 comparing urls: sip:ci...@my... -> sip:ci...@my...
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 proxy.c:523 incoming response for ci...@my... from outbound
08:31:52 register.c:649 REGISTER response, looking for 'Expire' information
08:31:52 proxy.c:655 Adding my Record-Route
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 sock.c:434 send UDP packet to 192.168.15.122: 5060
---BUFFER DUMP follows---
  53 49 50 2f 32 2e 30 20 31 30 30 20 54 72 79 69 SIP/2.0 100 Tryi
  6e 67 0d 0a 56 69 61 3a 20 53 49 50 2f 32 2e 30 ng..Via: SIP/2.0
  2f 55 44 50 20 31 39 32 2e 31 36 38 2e 31 35 2e /UDP 192.168.15.
  31 32 32 3a 35 30 36 30 0d 0a 52 65 63 6f 72 64 122:5060..Record
  2d 52 6f 75 74 65 3a 20 3c 73 69 70 3a 73 69 70 -Route: <sip:sip
  72 6f 78 64 40 31 39 32 2e 31 36 38 2e 31 35 2e roxd@192.168.15.
  32 30 30 3a 35 30 36 30 3b 6c 72 3e 0d 0a 46 72 200:5060;lr>..Fr
  6f 6d 3a 20 3c 73 69 70 3a 63 69 73 63 6f 40 6d om: <sip:cisco@my.
  61 6c 63 6f 6c 6d 2e 69 64 2e 61 75 3e 3b 74 61 sip.server.net>;ta
  67 3d 31 32 31 34 32 31 31 34 35 37 0d 0a 54 6f g=1214211457..To
  3a 20 3c 73 69 70 3a 63 69 73 63 6f 40 6d 61 6c : <sip:ci...@my...p
  63 6f 6c 6d 2e 69 64 2e 61 75 3e 0d 0a 43 61 6c .server.net>..Cal
  6c 2d 49 44 3a 20 33 32 34 33 36 38 38 30 31 36 l-ID: 3243688016
  40 31 39 32 2e 31 36 38 2e 31 35 2e 31 32 32 0d @192.168.15.122.
  0a 43 53 65 71 3a 20 32 20 52 45 47 49 53 54 45 .CSeq: 2 REGISTE
  52 0d 0a 53 65 72 76 65 72 3a 20 59 41 54 45 2f R..Server: YATE/
  34 2e 31 2e 30 0d 0a 43 6f 6e 74 65 6e 74 2d 4c 4.1.0..Content-L
  65 6e 67 74 68 3a 20 30 0d 0a 0d 0a             ength: 0....    

---end of BUFFER DUMP---
08:31:52 sock.c:157 entered sipsock_waitfordata
08:31:52 sock.c:220 FD 4 = active
08:31:52 sock.c:281 received UDP packet from [85.234.150.85:5060] count=487
---BUFFER DUMP follows---
  53 49 50 2f 32 2e 30 20 32 30 30 20 4f 4b 0d 0a SIP/2.0 200 OK..
  56 69 61 3a 20 53 49 50 2f 32 2e 30 2f 55 44 50 Via: SIP/2.0/UDP
  20 31 39 32 2e 31 36 38 2e 31 35 2e 32 30 30 3a  192.168.15.200:
  35 30 36 30 3b 62 72 61 6e 63 68 3d 7a 39 68 47 5060;branch=z9hG
  34 62 4b 64 33 64 32 31 30 61 32 37 32 34 65 32 4bKd3d210a2724e2
  35 64 30 31 37 32 63 61 36 36 31 61 38 38 64 30 5d0172ca661a88d0
  31 36 63 3b 72 65 63 65 69 76 65 64 3d 31 31 38 16c;received=118
  2e 31 30 37 2e 32 32 34 2e 34 37 0d 0a 56 69 61 .107.224.47..Via
  3a 20 53 49 50 2f 32 2e 30 2f 55 44 50 20 31 39 : SIP/2.0/UDP 19
  32 2e 31 36 38 2e 31 35 2e 31 32 32 3a 35 30 36 2.168.15.122:506
  30 0d 0a 46 72 6f 6d 3a 20 3c 73 69 70 3a 63 69 0..From: <sip:ci
  73 63 6f 40 6d 61 6c 63 6f 6c 6d 2e 69 64 2e 61 sc...@my...rver.
  75 3e 3b 74 61 67 3d 31 32 31 34 32 31 31 34 35 net>;tag=121421145
  37 0d 0a 54 6f 3a 20 3c 73 69 70 3a 63 69 73 63 7..To: <sip:cisc
  6f 40 6d 61 6c 63 6f 6c 6d 2e 69 64 2e 61 75 3e o...@my...>
  3b 74 61 67 3d 31 39 36 30 32 35 32 30 38 32 0d ;tag=1960252082.
  0a 43 61 6c 6c 2d 49 44 3a 20 33 32 34 33 36 38 .Call-ID: 324368
  38 30 31 36 40 31 39 32 2e 31 36 38 2e 31 35 2e 8016@192.168.15.
  31 32 32 0d 0a 43 53 65 71 3a 20 32 20 52 45 47 122..CSeq: 2 REG
  49 53 54 45 52 0d 0a 45 78 70 69 72 65 73 3a 20 ISTER..Expires: 
  33 36 30 30 0d 0a 43 6f 6e 74 61 63 74 3a 20 3c 3600..Contact: <
  73 69 70 3a 63 69 73 63 6f 40 31 39 32 2e 31 36 sip:cisco@192.16
  38 2e 31 35 2e 32 30 30 3a 35 30 36 30 3e 3b 65 8.15.200:5060>;e
  78 70 69 72 65 73 3d 33 36 30 30 0d 0a 53 65 72 xpires=3600..Ser
  76 65 72 3a 20 59 41 54 45 2f 34 2e 31 2e 30 0d ver: YATE/4.1.0.
  0a 41 6c 6c 6f 77 3a 20 41 43 4b 2c 20 49 4e 56 .Allow: ACK, INV
  49 54 45 2c 20 42 59 45 2c 20 43 41 4e 43 45 4c ITE, BYE, CANCEL
  2c 20 52 45 47 49 53 54 45 52 2c 20 52 45 46 45 , REGISTER, REFE
  52 2c 20 4f 50 54 49 4f 4e 53 2c 20 49 4e 46 4f R, OPTIONS, INFO
  0d 0a 43 6f 6e 74 65 6e 74 2d 4c 65 6e 67 74 68 ..Content-Length
  3a 20 30 0d 0a 0d 0a                            : 0....         

---end of BUFFER DUMP---
08:31:52 siproxd.c:387 received 487 bytes of data
08:31:52 accessctl.c:50 deny  list (SIP):*NULL*
08:31:52 accessctl.c:52 allow list (SIP):*NULL*
08:31:52 accessctl.c:54 allow list (REG):192.168.15.0/24
08:31:52 accessctl.c:149 [0] extracted address=192.168.15.0
08:31:52 accessctl.c:150 [0] extracted mask   =24
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.0 -> 192.168.15.0
08:31:52 accessctl.c:168 check match: entry=0, filter=c0a80f00, from=55ea9600
08:31:52 accessctl.c:99 access check =1
08:31:52 security.c:48 security_check_raw: size=487
08:31:52 siproxd.c:481 checking Max-Forwards (=70)
08:31:52 sip_utils.c:198 via name 192.168.15.122
08:31:52 sip_utils.c:221 resolving IP of interface outbound
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 sip_utils.c:221 resolving IP of interface inbound
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 sip_utils.c:229 resolving IP of interface 'host_outbound'
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 siproxd.c:526 received SIP type RES:OK
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 proxy.c:483 proxy_response
08:31:52 sip_utils.c:618 deleting topmost VIA
08:31:52 sip_utils.c:198 via name 192.168.15.200
08:31:52 sip_utils.c:221 resolving IP of interface outbound
08:31:52 utils.c:353 fetching outbound IP by HOSTNAME
08:31:52 utils.c:134 DNS lookup - from cache: name-that-resolves-to-my-external-ip.net -> 128.107.224.47
08:31:52 sip_utils.c:221 resolving IP of interface inbound
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 sip_utils.c:238 got address match [192.168.15.200]
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 sip_utils.c:1018 sip_find_direction: reghost:192.168.15.122 ip:85.234.150.85
08:31:52 sip_utils.c:279 comparing urls: sip:ci...@my... -> sip:ci...@my...
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:31:52 proxy.c:523 incoming response for ci...@my... from outbound
08:31:52 register.c:649 REGISTER response, looking for 'Expire' information
08:31:52 register.c:679 Expires=3600, expires_param=0xa218d78, expires_hdr=0xa218cf0
08:31:52 sip_utils.c:279 comparing urls: sip:cisco@192.168.15.200 -> sip:cisco@128.107.224.47
08:31:52 utils.c:215 DNS lookup - resolved: 192.168.15.200 -> 192.168.15.200
08:31:52 utils.c:255 DNS lookup - store into cache, entry 4)
08:31:52 utils.c:215 DNS lookup - resolved: 128.107.224.47 -> 128.107.224.47
08:31:52 utils.c:255 DNS lookup - store into cache, entry 5)
08:31:52 sip_utils.c:324 compare_url: IP mismatch
08:31:52 register.c:695 no urlmap entry found
08:31:52 sip_utils.c:279 comparing urls: sip:cisco@192.168.15.200 -> sip:cisco@128.107.224.47
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.200 -> 192.168.15.200
08:31:52 utils.c:134 DNS lookup - from cache: 128.107.224.47 -> 128.107.224.47
08:31:52 sip_utils.c:324 compare_url: IP mismatch
08:31:52 sip_utils.c:719 no Contact header rewritten!
08:31:52 proxy.c:655 Adding my Record-Route
08:31:52 utils.c:386 fetching interface IP by INTERFACE [1]
08:31:52 utils.c:464 ifaddr lookup - from cache: eth0 -> 192.168.15.200 UP
08:31:52 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:31:52 sock.c:434 send UDP packet to 192.168.15.122: 5060
---BUFFER DUMP follows---
  53 49 50 2f 32 2e 30 20 32 30 30 20 4f 4b 0d 0a SIP/2.0 200 OK..
  56 69 61 3a 20 53 49 50 2f 32 2e 30 2f 55 44 50 Via: SIP/2.0/UDP
  20 31 39 32 2e 31 36 38 2e 31 35 2e 31 32 32 3a  192.168.15.122:
  35 30 36 30 0d 0a 52 65 63 6f 72 64 2d 52 6f 75 5060..Record-Rou
  74 65 3a 20 3c 73 69 70 3a 73 69 70 72 6f 78 64 te: <sip:siproxd
  40 31 39 32 2e 31 36 38 2e 31 35 2e 32 30 30 3a @192.168.15.200:
  35 30 36 30 3b 6c 72 3e 0d 0a 46 72 6f 6d 3a 20 5060;lr>..From: 
  3c 73 69 70 3a 63 69 73 63 6f 40 6d 61 6c 63 6f <sip:ci...@my...p.
  6c 6d 2e 69 64 2e 61 75 3e 3b 74 61 67 3d 31 32 server.net>;tag=12
  31 34 32 31 31 34 35 37 0d 0a 54 6f 3a 20 3c 73 14211457..To: <s
  69 70 3a 63 69 73 63 6f 40 6d 61 6c 63 6f 6c 6d ip:ci...@my...r
  2e 69 64 2e 61 75 3e 3b 74 61 67 3d 31 39 36 30 ver.net>;tag=1960
  32 35 32 30 38 32 0d 0a 43 61 6c 6c 2d 49 44 3a 252082..Call-ID:
  20 33 32 34 33 36 38 38 30 31 36 40 31 39 32 2e  3243688016@192.
  31 36 38 2e 31 35 2e 31 32 32 0d 0a 43 53 65 71 168.15.122..CSeq
  3a 20 32 20 52 45 47 49 53 54 45 52 0d 0a 43 6f : 2 REGISTER..Co
  6e 74 61 63 74 3a 20 3c 73 69 70 3a 63 69 73 63 ntact: <sip:cisc
  6f 40 31 39 32 2e 31 36 38 2e 31 35 2e 32 30 30 o@192.168.15.200
  3a 35 30 36 30 3e 3b 65 78 70 69 72 65 73 3d 33 :5060>;expires=3
  36 30 30 0d 0a 41 6c 6c 6f 77 3a 20 41 43 4b 0d 600..Allow: ACK.
  0a 41 6c 6c 6f 77 3a 20 49 4e 56 49 54 45 0d 0a .Allow: INVITE..
  41 6c 6c 6f 77 3a 20 42 59 45 0d 0a 41 6c 6c 6f Allow: BYE..Allo
  77 3a 20 43 41 4e 43 45 4c 0d 0a 41 6c 6c 6f 77 w: CANCEL..Allow
  3a 20 52 45 47 49 53 54 45 52 0d 0a 41 6c 6c 6f : REGISTER..Allo
  77 3a 20 52 45 46 45 52 0d 0a 41 6c 6c 6f 77 3a w: REFER..Allow:
  20 4f 50 54 49 4f 4e 53 0d 0a 41 6c 6c 6f 77 3a  OPTIONS..Allow:
  20 49 4e 46 4f 0d 0a 45 78 70 69 72 65 73 3a 20  INFO..Expires: 
  33 36 30 30 0d 0a 53 65 72 76 65 72 3a 20 59 41 3600..Server: YA
  54 45 2f 34 2e 31 2e 30 0d 0a 43 6f 6e 74 65 6e TE/4.1.0..Conten
  74 2d 4c 65 6e 67 74 68 3a 20 30 0d 0a 0d 0a    t-Length: 0.... 

---end of BUFFER DUMP---
08:31:52 sock.c:157 entered sipsock_waitfordata
08:31:57 register.c:509 sip_agemap, t=1378686717
08:31:57 sock.c:157 entered sipsock_waitfordata
08:31:57 sock.c:169 winding up select() timeout
08:32:02 register.c:509 sip_agemap, t=1378686722
08:32:02 sock.c:157 entered sipsock_waitfordata
08:32:02 sock.c:169 winding up select() timeout
08:32:06 sock.c:220 FD 4 = active
08:32:06 sock.c:281 received UDP packet from [85.234.150.85:5060] count=690
---BUFFER DUMP follows---
  49 4e 56 49 54 45 20 73 69 70 3a 63 69 73 63 6f INVITE sip:cisco
  40 31 39 32 2e 31 36 38 2e 31 35 2e 32 30 30 3a @192.168.15.200:
  35 30 36 30 20 53 49 50 2f 32 2e 30 0d 0a 4d 61 5060 SIP/2.0..Ma
  78 2d 46 6f 72 77 61 72 64 73 3a 20 31 34 0d 0a x-Forwards: 14..
  56 69 61 3a 20 53 49 50 2f 32 2e 30 2f 55 44 50 Via: SIP/2.0/UDP
  20 38 35 2e 32 33 34 2e 31 35 30 2e 38 35 3a 35  85.234.150.85:5
  30 36 30 3b 72 70 6f 72 74 3b 62 72 61 6e 63 68 060;rport;branch
  3d 7a 39 68 47 34 62 4b 31 31 31 34 33 39 31 30 =z9hG4bK11143910
  37 33 0d 0a 46 72 6f 6d 3a 20 22 71 69 72 74 61 73..From: "qirta
  69 62 61 22 20 3c 73 69 70 3a 30 30 30 30 31 32 iba" <sip:000012
  33 34 35 36 40 38 35 2e 32 33 34 2e 31 35 30 2e 3456@85.234.150.
  38 35 3a 35 30 36 30 3e 3b 74 61 67 3d 31 30 36 85:5060>;tag=106
  31 36 30 36 30 35 38 0d 0a 54 6f 3a 20 3c 73 69 1606058..To: <si
  70 3a 63 69 73 63 6f 40 31 39 32 2e 31 36 38 2e p:cisco@192.168.
  31 35 2e 32 30 30 3a 35 30 36 30 3e 0d 0a 43 61 15.200:5060>..Ca
  6c 6c 2d 49 44 3a 20 37 37 37 36 36 38 39 35 32 ll-ID: 777668952
  40 38 35 2e 32 33 34 2e 31 35 30 2e 38 35 0d 0a @85.234.150.85..
  43 53 65 71 3a 20 31 31 32 36 34 20 49 4e 56 49 CSeq: 11264 INVI
  54 45 0d 0a 55 73 65 72 2d 41 67 65 6e 74 3a 20 TE..User-Agent: 
  59 41 54 45 2f 34 2e 31 2e 30 0d 0a 43 6f 6e 74 YATE/4.1.0..Cont
  61 63 74 3a 20 3c 73 69 70 3a 30 30 30 30 31 32 act: <sip:000012
  33 34 35 36 40 38 35 2e 32 33 34 2e 31 35 30 2e 3456@85.234.150.
  38 35 3a 35 30 36 30 3e 0d 0a 41 6c 6c 6f 77 3a 85:5060>..Allow:
  20 41 43 4b 2c 20 49 4e 56 49 54 45 2c 20 42 59  ACK, INVITE, BY
  45 2c 20 43 41 4e 43 45 4c 2c 20 52 45 47 49 53 E, CANCEL, REGIS
  54 45 52 2c 20 52 45 46 45 52 2c 20 4f 50 54 49 TER, REFER, OPTI
  4f 4e 53 2c 20 49 4e 46 4f 0d 0a 43 6f 6e 74 65 ONS, INFO..Conte
  6e 74 2d 54 79 70 65 3a 20 61 70 70 6c 69 63 61 nt-Type: applica
  74 69 6f 6e 2f 73 64 70 0d 0a 43 6f 6e 74 65 6e tion/sdp..Conten
  74 2d 4c 65 6e 67 74 68 3a 20 32 30 39 0d 0a 0d t-Length: 209...
  0a 76 3d 30 0d 0a 6f 3d 79 61 74 65 20 31 33 37 .v=0..o=yate 137
  38 36 38 37 31 34 39 20 31 33 37 38 36 38 37 31 8687149 13786871
  34 39 20 49 4e 20 49 50 34 20 38 35 2e 32 33 34 49 IN IP4 85.234
  2e 31 35 30 2e 38 35 0d 0a 73 3d 53 49 50 20 43 .150.85..s=SIP C
  61 6c 6c 0d 0a 63 3d 49 4e 20 49 50 34 20 38 35 all..c=IN IP4 85
  2e 32 33 34 2e 31 35 30 2e 38 35 0d 0a 74 3d 30 .234.150.85..t=0
  20 30 0d 0a 6d 3d 61 75 64 69 6f 20 32 38 30 36  0..m=audio 2806
  32 20 52 54 50 2f 41 56 50 20 30 20 38 20 31 30 2 RTP/AVP 0 8 10
  31 0d 0a 61 3d 72 74 70 6d 61 70 3a 30 20 50 43 1..a=rtpmap:0 PC
  4d 55 2f 38 30 30 30 0d 0a 61 3d 72 74 70 6d 61 MU/8000..a=rtpma
  70 3a 38 20 50 43 4d 41 2f 38 30 30 30 0d 0a 61 p:8 PCMA/8000..a
  3d 72 74 70 6d 61 70 3a 31 30 31 20 74 65 6c 65 =rtpmap:101 tele
  70 68 6f 6e 65 2d 65 76 65 6e 74 2f 38 30 30 30 phone-event/8000
  0d 0a                                           ..              

---end of BUFFER DUMP---
08:32:06 siproxd.c:387 received 690 bytes of data
08:32:06 accessctl.c:50 deny  list (SIP):*NULL*
08:32:06 accessctl.c:52 allow list (SIP):*NULL*
08:32:06 accessctl.c:54 allow list (REG):192.168.15.0/24
08:32:06 accessctl.c:149 [0] extracted address=192.168.15.0
08:32:06 accessctl.c:150 [0] extracted mask   =24
08:32:06 utils.c:134 DNS lookup - from cache: 192.168.15.0 -> 192.168.15.0
08:32:06 accessctl.c:168 check match: entry=0, filter=c0a80f00, from=55ea9600
08:32:06 accessctl.c:99 access check =1
08:32:06 security.c:48 security_check_raw: size=690
08:32:06 siproxd.c:481 checking Max-Forwards (=14)
08:32:06 siproxd.c:526 received SIP type REQ:INVITE
08:32:06 utils.c:353 fetching outbound IP by HOSTNAME
08:32:06 proxy.c:89 proxy_request
08:32:06 route_processing.c:63 route_preprocess: no Route header present
08:32:06 utils.c:134 DNS lookup - from cache: 192.168.15.122 -> 192.168.15.122
08:32:06 sip_utils.c:1018 sip_find_direction: reghost:192.168.15.122 ip:85.234.150.85
08:32:06 sip_utils.c:279 comparing urls: sip:cisco@192.168.15.200 -> sip:cisco@128.107.224.47
08:32:06 utils.c:134 DNS lookup - from cache: 192.168.15.200 -> 192.168.15.200
08:32:06 utils.c:134 DNS lookup - from cache: 128.107.224.47 -> 128.107.224.47
08:32:06 sip_utils.c:324 compare_url: IP mismatch
08:32:06 sip_utils.c:279 comparing urls: sip:cisco@192.168.15.200 -> sip:ci...@my...
08:32:06 utils.c:134 DNS lookup - from cache: 192.168.15.200 -> 192.168.15.200
08:32:06 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:32:06 sip_utils.c:324 compare_url: IP mismatch
08:32:06 sip_utils.c:279 comparing urls: sip:cisco@192.168.15.200 -> sip:cisco@128.107.224.47
08:32:06 utils.c:134 DNS lookup - from cache: 192.168.15.200 -> 192.168.15.200
08:32:06 utils.c:134 DNS lookup - from cache: 128.107.224.47 -> 128.107.224.47
08:32:06 sip_utils.c:324 compare_url: IP mismatch
08:32:06 sip_utils.c:279 comparing urls: sip:cisco@192.168.15.200 -> sip:ci...@my...
08:32:06 utils.c:134 DNS lookup - from cache: 192.168.15.200 -> 192.168.15.200
08:32:06 utils.c:134 DNS lookup - from cache: my.sip.server.net -> 85.234.150.85
08:32:06 sip_utils.c:324 compare_url: IP mismatch
08:32:06 utils.c:386 fetching interface IP by INTERFACE [1]
08:32:06 utils.c:449 cleaning ifaddr cache (entry 0)
08:32:06 utils.c:481 getifaddrs - eth0 / lo, ifa_addr=0xa21bc04, addrfamily=17
08:32:06 utils.c:481 getifaddrs - eth0 / eth0, ifa_addr=0xa21bca0, addrfamily=17
08:32:06 utils.c:481 getifaddrs - eth0 / wlan0, ifa_addr=0xa21bd3c, addrfamily=17
08:32:06 utils.c:481 getifaddrs - eth0 / sit0, ifa_addr=0xa21bdd8, addrfamily=17
08:32:06 utils.c:481 getifaddrs - eth0 / he-ipv6, ifa_addr=0xa21be74, addrfamily=17
08:32:06 utils.c:481 getifaddrs - eth0 / lo, ifa_addr=0xa21bf10, addrfamily=2
08:32:06 utils.c:481 getifaddrs - eth0 / eth0, ifa_addr=0xa21bfac, addrfamily=2
08:32...
 
[truncated message content]