2009/12/08 22:18:38.520 0:39.530 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:39.125 0:40.135 SIP Changing MESSAGE handler from Unavailable to Subscribed, target=sip:+32472450423@sip1.voipbuster.com, id=0c29e14d-b5e2-de11-978e-001f161740ff@cass-x200s 2009/12/08 22:18:39.125 0:40.136 SIP Changing MESSAGE handler from Subscribed to Subscribing, target=sip:+32472450423@sip1.voipbuster.com, id=0c29e14d-b5e2-de11-978e-001f161740ff@cass-x200s 2009/12/08 22:18:39.126 0:40.136 OpalUDP Binding to interface: 0.0.0.0:5060 2009/12/08 22:18:39.126 0:40.136 SIP Created transport udp$77.72.169.129:5060 2009/12/08 22:18:39.127 0:40.137 OpalUDP Started connect to 77.72.169.129:5060 2009/12/08 22:18:39.127 0:40.137 OpalUDP Writing to interface 0 - "169.254.6.140%eth0:avahi" 2009/12/08 22:18:39.127 0:40.137 SIP Expiry time for MESSAGE set to 3600 seconds. 2009/12/08 22:18:39.127 0:40.137 SIP Transaction created. 2009/12/08 22:18:39.127 0:40.137 Housekeeper:0xced26910 PTLib MONITOR:timers=2 2009/12/08 22:18:39.259 0:40.269 DNS SRV Lookup sip1.voipbuster.com service _sip._udp 2009/12/08 22:18:39.325 0:40.335 SIP No SRV record found. 2009/12/08 22:18:39.325 0:40.335 SIP Transaction remote address is udp$sip1.voipbuster.com:5060 2009/12/08 22:18:39.325 0:40.335 SIP Sending PDU (453 bytes) to: rem=udp$77.72.169.129:5060,local=udp$169.254.6.140:5060,if=169.254.6.140%eth0:avahi MESSAGE sip:+32472450423@sip1.voipbuster.com SIP/2.0 CSeq: 5 MESSAGE Via: SIP/2.0/UDP 86.26.11.66:5060;branch=z9hG4bK0e95f54d-b5e2-de11-978e-001f161740ff;rport From: "Guillaume Desmottes" ;tag=9a8be14d-b5e2-de11-978e-001f161740ff Call-ID: 0c29e14d-b5e2-de11-978e-001f161740ff@cass-x200s To: Content-Type: text/plain;charset=UTF-8 Content-Length: 4 Max-Forwards: 70 test 2009/12/08 22:18:39.325 0:40.336 OpalUDP Setting interface to 169.254.6.140%eth0:avahi 2009/12/08 22:18:39.326 0:40.336 SIP Transaction timers set: retry=0.500, completion=6.000 2009/12/08 22:18:39.326 0:40.336 Housekeeper:0xced26910 PTLib MONITOR:timers=3 2009/12/08 22:18:39.326 0:40.336 Housekeeper:0xced26910 SIP NAT Binding refresh started. 2009/12/08 22:18:39.326 0:40.336 OpalUDP Writing to interface 1 - "192.168.0.132%wlan0" 2009/12/08 22:18:39.326 0:40.336 SIP Expiry time for MESSAGE set to 3600 seconds. 2009/12/08 22:18:39.326 0:40.336 SIP Transaction created. 2009/12/08 22:18:39.327 0:40.337 DNS SRV Lookup sip1.voipbuster.com service _sip._udp 2009/12/08 22:18:39.385 0:40.395 SIP No SRV record found. 2009/12/08 22:18:39.385 0:40.395 SIP Transaction remote address is udp$sip1.voipbuster.com:5060 2009/12/08 22:18:39.385 0:40.395 SIP Sending PDU (453 bytes) to: rem=udp$77.72.169.129:5060,local=udp$86.26.11.66:5060,if=192.168.0.132%wlan0 MESSAGE sip:+32472450423@sip1.voipbuster.com SIP/2.0 CSeq: 6 MESSAGE Via: SIP/2.0/UDP 86.26.11.66:5060;branch=z9hG4bK9800004e-b5e2-de11-978e-001f161740ff;rport From: "Guillaume Desmottes" ;tag=ecd9ff4d-b5e2-de11-978e-001f161740ff Call-ID: 0c29e14d-b5e2-de11-978e-001f161740ff@cass-x200s To: Content-Type: text/plain;charset=UTF-8 Content-Length: 4 Max-Forwards: 70 test 2009/12/08 22:18:39.386 0:40.396 OpalUDP Setting interface to 192.168.0.132%wlan0 2009/12/08 22:18:39.386 0:40.396 SIP Transaction timers set: retry=0.500, completion=6.000 2009/12/08 22:18:39.386 0:40.397 Housekeeper:0xced26910 SIP NAT Binding refresh finished. 2009/12/08 22:18:39.386 0:40.397 Housekeeper:0xced26910 PTLib MONITOR:timers=5 2009/12/08 22:18:39.520 0:40.530 Opal Garbage:0xceda8910 SIP MONITOR:transactions=2,connections=0 2009/12/08 22:18:39.826 0:40.836 Housekeeper:0xced26910 PTLib MONITOR:timers=7 2009/12/08 22:18:39.826 0:40.836 Housekeeper:0xced26910 SIP MESSAGE transaction id=z9hG4bK0e95f54d-b5e2-de11-978e-001f161740ff timeout, making retry 1, timeout 1.000 2009/12/08 22:18:39.826 0:40.837 Housekeeper:0xced26910 OpalUDP Setting interface to 169.254.6.140%eth0:avahi 2009/12/08 22:18:39.826 0:40.837 Housekeeper:0xced26910 SIP Set new interface 169.254.6.140%eth0:avahi for transport udp$77.72.169.129:5060 2009/12/08 22:18:39.827 0:40.838 Housekeeper:0xced26910 SIP Sending PDU (453 bytes) to: rem=udp$77.72.169.129:5060,local=udp$169.254.6.140:5060,if=169.254.6.140%eth0:avahi MESSAGE sip:+32472450423@sip1.voipbuster.com SIP/2.0 CSeq: 5 MESSAGE Via: SIP/2.0/UDP 86.26.11.66:5060;branch=z9hG4bK0e95f54d-b5e2-de11-978e-001f161740ff;rport From: "Guillaume Desmottes" ;tag=9a8be14d-b5e2-de11-978e-001f161740ff Call-ID: 0c29e14d-b5e2-de11-978e-001f161740ff@cass-x200s To: Content-Type: text/plain;charset=UTF-8 Content-Length: 4 Max-Forwards: 70 test 2009/12/08 22:18:39.828 0:40.838 Housekeeper:0xced26910 OpalUDP Setting interface to 192.168.0.132%wlan0 2009/12/08 22:18:39.889 0:40.900 Housekeeper:0xced26910 PTLib MONITOR:timers=7 2009/12/08 22:18:39.890 0:40.900 Housekeeper:0xced26910 SIP MESSAGE transaction id=z9hG4bK9800004e-b5e2-de11-978e-001f161740ff timeout, making retry 1, timeout 1.000 2009/12/08 22:18:39.890 0:40.900 Housekeeper:0xced26910 SIP Sending PDU (453 bytes) to: rem=udp$77.72.169.129:5060,local=udp$86.26.11.66:5060,if=192.168.0.132%wlan0 MESSAGE sip:+32472450423@sip1.voipbuster.com SIP/2.0 CSeq: 6 MESSAGE Via: SIP/2.0/UDP 86.26.11.66:5060;branch=z9hG4bK9800004e-b5e2-de11-978e-001f161740ff;rport From: "Guillaume Desmottes" ;tag=ecd9ff4d-b5e2-de11-978e-001f161740ff Call-ID: 0c29e14d-b5e2-de11-978e-001f161740ff@cass-x200s To: Content-Type: text/plain;charset=UTF-8 Content-Length: 4 Max-Forwards: 70 test 2009/12/08 22:18:39.891 0:40.901 Housekeeper:0xced26910 OpalUDP Setting interface to 192.168.0.132%wlan0 2009/12/08 22:18:40.261 0:41.271 Opal Liste...0xcece5910 OpalUDP Binding to interface: 86.26.11.66:5060 2009/12/08 22:18:40.261 0:41.272 Opal Liste...0xcece5910 SIP Waiting for PDU on udp$77.72.169.129:5060 2009/12/08 22:18:40.262 0:41.272 Opal Liste...0xcece5910 SIP PDU received: rem=udp$77.72.169.129:5060,local=udp$86.26.11.66:5060,if=192.168.0.132%wlan0 SIP/2.0 200 Ok CSeq: 6 MESSAGE Via: SIP/2.0/UDP 86.26.11.66:5060;branch=z9hG4bK9800004e-b5e2-de11-978e-001f161740ff;rport Server: (Very nice Sip Registrar/Proxy Server) From: "Guillaume Desmottes" ;tag=ecd9ff4d-b5e2-de11-978e-001f161740ff Call-ID: 0c29e14d-b5e2-de11-978e-001f161740ff@cass-x200s To: Contact: sip:+32472450423@77.72.169.129:5060 Allow: ACK,BYE,CANCEL,INVITE,REGISTER,OPTIONS,INFO,MESSAGE Content-Length: 0 2009/12/08 22:18:40.262 0:41.272 Opal Liste...0xcece5910 SIP Queueing PDU "6 MESSAGE <200>", transaction=z9hG4bK9800004e-b5e2-de11-978e-001f161740ff, token=0c29e14d-b5e2-de11-978e-001f161740ff@cass-x200s 2009/12/08 22:18:40.262 0:41.272 Opal Liste...0xcece5910 Opal Transport clean up on termination 2009/12/08 22:18:40.262 0:41.272 Opal Liste...0xcece5910 Opal Transport Close 2009/12/08 22:18:40.262 0:41.272 Pool:0xcec63910 SIP Handling PDU "6 MESSAGE <200>" for transaction=z9hG4bK9800004e-b5e2-de11-978e-001f161740ff 2009/12/08 22:18:40.262 0:41.272 Housekeeper:0xced26910 PTLib MONITOR:timers=7 2009/12/08 22:18:40.262 0:41.273 Pool:0xcec63910 SIP MESSAGE transaction id=z9hG4bK9800004e-b5e2-de11-978e-001f161740ff completed. 2009/12/08 22:18:40.262 0:41.273 Pool:0xcec63910 SIP Product Info: name="(Very nice Sip Registrar/Proxy Server)" 2009/12/08 22:18:40.262 0:41.273 Pool:0xcec63910 SIP Changing MESSAGE handler from Subscribing to Subscribed, target=sip:+32472450423@sip1.voipbuster.com, id=0c29e14d-b5e2-de11-978e-001f161740ff@cass-x200s 2009/12/08 22:18:40.262 0:41.273 Pool:0xcec63910 SIP MESSAGE transaction id=z9hG4bK0e95f54d-b5e2-de11-978e-001f161740ff aborted. 2009/12/08 22:18:40.262 0:41.273 Pool:0xcec63910 SIP Set state Terminated_Aborted for MESSAGE transaction id=z9hG4bK0e95f54d-b5e2-de11-978e-001f161740ff 2009/12/08 22:18:40.262 0:41.273 Pool:0xcec63910 OpalUDP Setting interface to 192.168.0.132%wlan0 2009/12/08 22:18:40.262 0:41.272 Opal Liste...0xcece5910 Opal Deleted transport udp$77.72.169.129:5060 2009/12/08 22:18:40.262 0:41.273 Pool:0xcec63910 SIP Handled PDU "6 MESSAGE <200>" 2009/12/08 22:18:40.263 0:41.273 Housekeeper:0xced26910 PTLib MONITOR:timers=6 2009/12/08 22:18:40.521 0:41.531 Opal Garbage:0xceda8910 SIP MONITOR:transactions=2,connections=0 2009/12/08 22:18:40.521 0:41.531 Opal Garbage:0xceda8910 SIP Transaction id=z9hG4bK0e95f54d-b5e2-de11-978e-001f161740ff destroyed. 2009/12/08 22:18:40.521 0:41.531 Housekeeper:0xced26910 PTLib MONITOR:timers=4 2009/12/08 22:18:40.521 0:41.531 Housekeeper:0xced26910 PTLib MONITOR:timers=4 2009/12/08 22:18:41.263 0:42.274 Housekeeper:0xced26910 PTLib MONITOR:timers=4 2009/12/08 22:18:41.264 0:42.274 Housekeeper:0xced26910 SIP Set state Terminated_Success for MESSAGE transaction id=z9hG4bK9800004e-b5e2-de11-978e-001f161740ff 2009/12/08 22:18:41.521 0:42.532 Opal Garbage:0xceda8910 SIP MONITOR:transactions=1,connections=0 2009/12/08 22:18:41.521 0:42.532 Opal Garbage:0xceda8910 SIP Transaction id=z9hG4bK9800004e-b5e2-de11-978e-001f161740ff destroyed. 2009/12/08 22:18:41.524 0:42.534 Housekeeper:0xced26910 PTLib MONITOR:timers=4 2009/12/08 22:18:41.535 0:42.545 Housekeeper:0xced26910 PTLib MONITOR:timers=3 2009/12/08 22:18:42.535 0:43.546 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:43.536 0:44.546 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:44.538 0:45.549 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:45.539 0:46.549 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:46.539 0:47.549 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:47.539 0:48.549 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:48.540 0:49.550 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:49.326 0:50.337 Housekeeper:0xced26910 PTLib MONITOR:timers=3 2009/12/08 22:18:49.327 0:50.337 Housekeeper:0xced26910 SIP NAT Binding refresh started. 2009/12/08 22:18:49.328 0:50.338 Housekeeper:0xced26910 SIP NAT Binding refresh finished. 2009/12/08 22:18:49.540 0:50.550 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:50.540 0:51.551 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:51.541 0:52.551 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:52.541 0:53.551 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:53.541 0:54.552 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:54.542 0:55.552 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:55.542 0:56.552 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:56.544 0:57.554 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:57.544 0:58.554 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:58.544 0:59.554 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:18:59.328 1:00.339 Housekeeper:0xced26910 PTLib MONITOR:timers=3 2009/12/08 22:18:59.328 1:00.339 Housekeeper:0xced26910 SIP NAT Binding refresh started. 2009/12/08 22:18:59.329 1:00.339 Housekeeper:0xced26910 SIP NAT Binding refresh finished. 2009/12/08 22:18:59.544 1:00.555 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0 2009/12/08 22:19:00.545 1:01.555 Opal Garbage:0xceda8910 SIP MONITOR:transactions=0,connections=0