2010-12-17 09:49:59.937000 [blink.exe 7440] (5) sip_endpoint.c: Processing incoming message: Request msg INVITE/cseq=1 (rdata01b4101c) 2010-12-17 09:49:59.953000 [blink.exe 7440] (4) sip_endpoint.c: Message Request msg INVITE/cseq=1 (rdata01b4101c) from 66.227.100.25:5060 was dropped/unhandled by any modules 2010-12-17 09:50:00.046000 [blink.exe 7440] (5) pasound.c: Stopping stream.. 2010-12-17 09:50:00.140000 [blink.exe 7440] (5) pasound.c: Done, status=0 2010-12-17 09:50:00.156000 [blink.exe 7440] (5) pasound.c: Closing Chat 160: 0 underflow, 0 overflow 2010-12-17 09:50:01.234000 [blink.exe 7440] (5) pasound.c: Stopping stream.. 2010-12-17 09:50:01.234000 [blink.exe 7440] (5) pasound.c: Done, status=0 2010-12-17 09:50:02.312000 [blink.exe 7440] (5) pasound.c: Closing Realtek HD Audio output: 0 underflow, 0 overflow 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) tcplis:4593: SIP TCP listener destroyed 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) tls01b37bcc: SIP TLS listener destroyed 2010-12-17 09:50:02.312000 [blink.exe 7440] (5) sip_endpoint.c: Destroying endpoing instance.. 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_transactio: Stopping transaction layer module 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Module "mod-core" unregistered 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Module "mod-stateful-util" unregistered 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Module "mod-core-events" unregistered 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Module "mod-invite" unregistered 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Module "mod-100rel" unregistered 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Module "mod-evsub" unregistered 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Module "mod-ua" unregistered 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_transactio: Transaction layer module destroyed 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Module "mod-tsx-layer" unregistered 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Module "mod-core-ua-tag" unregistered 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Module "mod-msg-print" unregistered 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Module "mod-core-sip-trace" unregistered 2010-12-17 09:50:02.312000 [blink.exe 7440] (5) sip_transport.: Destroying transport manager 2010-12-17 09:50:02.312000 [blink.exe 7440] (3) sip_transport.: Warning: 1 transmit buffer(s) not freed! 2010-12-17 09:50:02.312000 [blink.exe 7440] (4) sip_endpoint.c: Endpoint 01b23694 destroyed 2010-12-17 09:50:02.453000 [blink.exe 7440] (4) pasound.c: PortAudio sound library shutting down.. 2010-12-17 09:50:02.453000 [blink.exe 7440] (4) AudioMixer_311: Pool is not released by application, releasing now 2010-12-17 09:50:02.453000 [blink.exe 7440] (4) AudioMixer_311: Pool is not released by application, releasing now 2010-12-17 09:50:02.453000 [blink.exe 7440] (4) tdta00d915b8: Pool is not released by application, releasing now 2010-12-17 09:50:33.671000 [blink.exe 5536] (4) os_core_win32.: pjlib 1.0.3-trunk for win32 initialized 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) pasound.c: PortAudio sound library initialized, status=0 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) pasound.c: PortAudio host api count=2 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) pasound.c: Sound device count=6 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) pjlib: select() I/O Queue created (01b1991c) 2010-12-17 09:50:33.703000 [blink.exe 5536] (5) sip_endpoint.c: Creating endpoint instance... 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) pjlib: select() I/O Queue created (01b2c970) 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-msg-print" registered 2010-12-17 09:50:33.703000 [blink.exe 5536] (5) sip_transport.: Transport manager created. 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-tsx-layer" registered 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-stateful-util" registered 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-ua" registered 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-evsub" registered 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-100rel" registered 2010-12-17 09:50:33.703000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-invite" registered 2010-12-17 09:50:33.718000 [blink.exe 5536] (4) udp01b36810: SIP UDP transport started, published address is 192.168.10.9:4800 2010-12-17 09:50:33.718000 [blink.exe 5536] (4) tcplis:4803: SIP TCP listener ready for incoming connections at 192.168.10.9:4803 2010-12-17 09:50:33.718000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-core" registered 2010-12-17 09:50:33.718000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-core-sip-trace" registered 2010-12-17 09:50:33.718000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-core-ua-tag" registered 2010-12-17 09:50:33.718000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-core-events" registered 2010-12-17 09:50:33.718000 [blink.exe 5536] (5) evsub.c: Event pkg "presence.winfo" registered by mod-core-events 2010-12-17 09:50:33.718000 [blink.exe 5536] (5) evsub.c: Event pkg "message-summary" registered by mod-core-events 2010-12-17 09:50:33.718000 [blink.exe 5536] (5) evsub.c: Event pkg "xcap-diff" registered by mod-core-events 2010-12-17 09:50:33.718000 [blink.exe 5536] (5) evsub.c: Event pkg "presence" registered by mod-core-events 2010-12-17 09:50:34.828000 [blink.exe 5536] (5) tls01b3e554: TLS verification mode set to 0 2010-12-17 09:50:34.828000 [blink.exe 5536] (4) tls01b3e554: SIP TLS listener ready for incoming connections at 192.168.10.9:4808 2010-12-17 09:50:34.828000 [blink.exe 5536] (5) conference.c: Creating conference bridge with 255 ports 2010-12-17 09:50:34.828000 [blink.exe 5536] (5) conference.c: Sound device successfully created for port 0 2010-12-17 09:50:34.843000 [blink.exe 5536] (5) pasound.c: Opened device Chat 160(MME)/Chat 160(MME) for recording and playback, sample rate=16000, ch=1, bits=16, 320 samples per frame, input latency=100 ms, output latency=100 ms 2010-12-17 09:50:34.843000 [blink.exe 5536] (5) pasound.c: Starting Chat 160 stream.. 2010-12-17 09:50:34.843000 [blink.exe 5536] (5) pasound.c: Done, status=0 2010-12-17 09:50:34.843000 [blink.exe 5536] (5) ec01b0add0: Creating AEC 2010-12-17 09:50:34.843000 [blink.exe 5536] (4) ec01b0add0: AEC created, clock_rate=16000, channel=1, samples per frame=320, tail length=200 ms, latency=100 ms 2010-12-17 09:50:34.843000 [blink.exe 5536] (5) conference.c: Creating conference bridge with 255 ports 2010-12-17 09:50:34.843000 [blink.exe 5536] (5) conference.c: Sound device successfully created for port 0 2010-12-17 09:50:34.859000 [blink.exe 5536] (5) pasound.c: Opened device 5: Realtek HD Audio output(MME) for playing, sample rate=16000, ch=1, bits=16, 320 samples per frame, latency=100 ms 2010-12-17 09:50:34.859000 [blink.exe 5536] (5) pasound.c: Starting Realtek HD Audio output stream.. 2010-12-17 09:50:34.859000 [blink.exe 5536] (5) pasound.c: Done, status=0 2010-12-17 09:50:34.875000 [blink.exe 5536] (5) pasound.c: Player thread started 2010-12-17 09:50:34.875000 [blink.exe 5536] (5) pasound.c: Player thread started 2010-12-17 09:50:34.890000 [blink.exe 5536] (5) pasound.c: Recorder thread started 2010-12-17 09:50:34.890000 [blink.exe 5536] (5) ec01b0add0: Prefetching.. 2010-12-17 09:50:34.906000 [blink.exe 5536] (5) ec01b0add0: Prefetching.. 2010-12-17 09:50:34.921000 [blink.exe 5536] (5) ec01b0add0: Prefetching.. 2010-12-17 09:50:34.937000 [blink.exe 5536] (5) ec01b0add0: Prefetching.. 2010-12-17 09:50:34.968000 [blink.exe 5536] (5) ec01b0add0: Prefetching.. 2010-12-17 09:50:34.968000 [blink.exe 5536] (5) ec01b0add0: Latency bufferring complete 2010-12-17 09:50:35 [blink.exe 5536] (5) dlg00d7f404: UAC dialog created 2010-12-17 09:50:35 [blink.exe 5536] (5) dlg00d7f404: Module mod-evsub added as dialog usage, data=01df6ce4 2010-12-17 09:50:35 [blink.exe 5536] (5) evsub01e2ed04: UAC subscription created, using dialog dlg00d7f404 2010-12-17 09:50:35 [blink.exe 5536] (5) dlg00d7f404: Session count inc to 2 by mod-evsub 2010-12-17 09:50:35 [blink.exe 5536] (5) endpoint: Request msg SUBSCRIBE/cseq=14672 (tdta00d7fba8) created. 2010-12-17 09:50:35 [blink.exe 5536] (5) dlg00d7f404: Sending Request msg SUBSCRIBE/cseq=14672 (tdta00d7fba8) 2010-12-17 09:50:35 [blink.exe 5536] (5) tsx00d80c14: Transaction created for Request msg SUBSCRIBE/cseq=14671 (tdta00d7fba8) 2010-12-17 09:50:35 [blink.exe 5536] (5) tsx00d80c14: Sending Request msg SUBSCRIBE/cseq=14671 (tdta00d7fba8) in state Null 2010-12-17 09:50:35 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:50:35 [blink.exe 5536] (5) tsx00d80c14: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:50:35 [blink.exe 5536] (5) dlg00d7f404: Transaction tsx00d80c14 state changed to Calling 2010-12-17 09:50:35 [blink.exe 5536] (4) evsub01e2ed04: Subscription state changed NULL --> SENT 2010-12-17 09:50:35 [blink.exe 5536] (5) endpoint: Request msg REGISTER/cseq=1 (tdta00d933f0) created. 2010-12-17 09:50:35 [blink.exe 5536] (5) tsx01ec17d4: Transaction created for Request msg REGISTER/cseq=1 (tdta00d933f0) 2010-12-17 09:50:35 [blink.exe 5536] (5) tsx01ec17d4: Sending Request msg REGISTER/cseq=1 (tdta00d933f0) in state Null 2010-12-17 09:50:35 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:50:35 [blink.exe 5536] (5) tsx01ec17d4: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 489/SUBSCRIBE/cseq=14671 (rdata01b4101c) 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) tsx00d80c14: Incoming Response msg 489/SUBSCRIBE/cseq=14671 (rdata01b4101c) in state Calling 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) tsx00d80c14: State changed from Calling to Completed, event=RX_MSG 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) dlg00d7f404: Received Response msg 489/SUBSCRIBE/cseq=14671 (rdata01b4101c) 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) dlg00d7f404: Transaction tsx00d80c14 state changed to Completed 2010-12-17 09:50:35.062000 [blink.exe 5536] (4) evsub01e2ed04: Subscription state changed SENT --> TERMINATED 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 401/REGISTER/cseq=1 (rdata01b4101c) 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) tsx01ec17d4: Incoming Response msg 401/REGISTER/cseq=1 (rdata01b4101c) in state Calling 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) tsx01ec17d4: State changed from Calling to Completed, event=RX_MSG 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) tsx01e35644: Transaction created for Request msg REGISTER/cseq=2 (tdta00d933f0) 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) tsx01e35644: Sending Request msg REGISTER/cseq=2 (tdta00d933f0) in state Null 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:50:35.062000 [blink.exe 5536] (5) tsx01e35644: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:50:35.125000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 200/REGISTER/cseq=2 (rdata01b4101c) 2010-12-17 09:50:35.125000 [blink.exe 5536] (5) tsx01e35644: Incoming Response msg 200/REGISTER/cseq=2 (rdata01b4101c) in state Calling 2010-12-17 09:50:35.125000 [blink.exe 5536] (5) tsx01e35644: State changed from Calling to Completed, event=RX_MSG 2010-12-17 09:50:39.875000 [blink.exe 5536] (4) sound_port.c: EC suspended because of inactivity 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) tsx01ec17d4: Timeout timer event 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) tsx01ec17d4: State changed from Completed to Terminated, event=TIMER 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) tsx00d80c14: Timeout timer event 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) tsx00d80c14: State changed from Completed to Terminated, event=TIMER 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) dlg00d7f404: Transaction tsx00d80c14 state changed to Terminated 2010-12-17 09:50:40.062000 [blink.exe 5536] (4) evsub01e2ed04: Subscription destroyed 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) dlg00d7f404: Session count dec to 1 by mod-evsub 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) dlg00d7f404: Dialog destroyed 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) tsx01ec17d4: Timeout timer event 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) tsx01ec17d4: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) tsx01ec17d4: Transaction destroyed! 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) tsx00d80c14: Timeout timer event 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) tsx00d80c14: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) tdta00d7fba8: Destroying txdata Request msg SUBSCRIBE/cseq=14671 (tdta00d7fba8) 2010-12-17 09:50:40.062000 [blink.exe 5536] (5) tsx00d80c14: Transaction destroyed! 2010-12-17 09:50:40.125000 [blink.exe 5536] (5) tsx01e35644: Timeout timer event 2010-12-17 09:50:40.125000 [blink.exe 5536] (5) tsx01e35644: State changed from Completed to Terminated, event=TIMER 2010-12-17 09:50:40.125000 [blink.exe 5536] (5) tsx01e35644: Timeout timer event 2010-12-17 09:50:40.125000 [blink.exe 5536] (5) tsx01e35644: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:50:40.125000 [blink.exe 5536] (5) tsx01e35644: Transaction destroyed! 2010-12-17 09:50:44.296000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 0 (Master/sound) 2010-12-17 09:50:44.296000 [blink.exe 5536] (4) conference.c: Port 0 (Master/sound) transmitting to port 1 (mixer-port) 2010-12-17 09:50:44.296000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) stop transmitting to port 0 (Master/sound) 2010-12-17 09:50:44.359000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:50:44.437000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 0 (Master/sound) 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) dlg00dac25c: UAC dialog created 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) dlg00dac25c: Module mod-invite added as dialog usage, data=00dac92c 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) dlg00dac25c: Session count inc to 3 by mod-invite 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) dlg00dac25c: Module mod-100rel added as dialog usage, data=00dad1c8 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) dlg00dac25c: 100rel module attached 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) inv00dac25c: UAC invite session created for dialog dlg00dac25c 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) endpoint: Request msg INVITE/cseq=6028 (tdta00dad210) created. 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) inv00dac25c: Sending Request msg INVITE/cseq=6028 (tdta00dad210) 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) dlg00dac25c: Sending Request msg INVITE/cseq=6028 (tdta00dad210) 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) tsx00dae27c: Transaction created for Request msg INVITE/cseq=6027 (tdta00dad210) 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) tsx00dae27c: Sending Request msg INVITE/cseq=6027 (tdta00dad210) in state Null 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) tsx00dae27c: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:50:44.625000 [blink.exe 5536] (5) dlg00dac25c: Transaction tsx00dae27c state changed to Calling 2010-12-17 09:50:44.687000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 404/INVITE/cseq=6027 (rdata01b4101c) 2010-12-17 09:50:44.687000 [blink.exe 5536] (5) tsx00dae27c: Incoming Response msg 404/INVITE/cseq=6027 (rdata01b4101c) in state Calling 2010-12-17 09:50:44.687000 [blink.exe 5536] (5) endpoint: Request msg ACK/cseq=6027 (tdta00dc0b50) created. 2010-12-17 09:50:44.687000 [blink.exe 5536] (5) tsx00dae27c: State changed from Calling to Completed, event=RX_MSG 2010-12-17 09:50:44.687000 [blink.exe 5536] (5) dlg00dac25c: Received Response msg 404/INVITE/cseq=6027 (rdata01b4101c) 2010-12-17 09:50:44.687000 [blink.exe 5536] (5) dlg00dac25c: Transaction tsx00dae27c state changed to Completed 2010-12-17 09:50:44.687000 [blink.exe 5536] (5) dlg00dac25c: Session count dec to 1 by mod-invite 2010-12-17 09:50:44.687000 [blink.exe 5536] (5) tdta00dad210: Destroying txdata Request msg INVITE/cseq=6027 (tdta00dad210) 2010-12-17 09:50:44.734000 [blink.exe 5536] (4) wav_player.c: File player 'C:\Program Files\Blink\resources\sounds/hangup_tone.wav' created: samp.rate=32000, ch=1, bufsize=4KB, filesize=32KB 2010-12-17 09:50:44.734000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=32000/16000 2010-12-17 09:50:44.734000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=16000/32000 2010-12-17 09:50:44.734000 [blink.exe 5536] (4) conference.c: Port 1 (C:\Program Files\Blink\resources\sounds/hangup_tone.wav) transmitting to port 0 (Master/sound) 2010-12-17 09:50:44.734000 [blink.exe 5536] (4) sound_port.c: EC activated 2010-12-17 09:50:45.234000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:50:45.250000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:50:45.281000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:50:45.296000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:50:46.234000 [blink.exe 5536] (5) ec01b0add0: 479 samples reduced, buf_cnt=801 2010-12-17 09:50:46.234000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1280 to 801 (eff_cnt=947) 2010-12-17 09:50:50.156000 [blink.exe 5536] (4) sound_port.c: EC suspended because of inactivity 2010-12-17 09:51:13.171000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 0 (Master/sound) 2010-12-17 09:51:13.171000 [blink.exe 5536] (4) conference.c: Port 0 (Master/sound) transmitting to port 1 (mixer-port) 2010-12-17 09:51:13.171000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) stop transmitting to port 0 (Master/sound) 2010-12-17 09:51:13.203000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 0 (Master/sound) 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) dlg00db2754: UAC dialog created 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) dlg00db2754: Module mod-invite added as dialog usage, data=00db2e24 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) dlg00db2754: Session count inc to 3 by mod-invite 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) dlg00db2754: Module mod-100rel added as dialog usage, data=00db36c0 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) dlg00db2754: 100rel module attached 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) inv00db2754: UAC invite session created for dialog dlg00db2754 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) endpoint: Request msg INVITE/cseq=468 (tdta00db3910) created. 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) inv00db2754: Sending Request msg INVITE/cseq=468 (tdta00db3910) 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) dlg00db2754: Sending Request msg INVITE/cseq=468 (tdta00db3910) 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) tsx00db497c: Transaction created for Request msg INVITE/cseq=467 (tdta00db3910) 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) tsx00db497c: Sending Request msg INVITE/cseq=467 (tdta00db3910) in state Null 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) tsx00db497c: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:51:13.250000 [blink.exe 5536] (5) dlg00db2754: Transaction tsx00db497c state changed to Calling 2010-12-17 09:51:13.312000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 100/INVITE/cseq=467 (rdata01b4101c) 2010-12-17 09:51:13.312000 [blink.exe 5536] (5) tsx00db497c: Incoming Response msg 100/INVITE/cseq=467 (rdata01b4101c) in state Calling 2010-12-17 09:51:13.312000 [blink.exe 5536] (5) tsx00db497c: State changed from Calling to Proceeding, event=RX_MSG 2010-12-17 09:51:13.312000 [blink.exe 5536] (5) dlg00db2754: Received Response msg 100/INVITE/cseq=467 (rdata01b4101c) 2010-12-17 09:51:13.312000 [blink.exe 5536] (5) dlg00db2754: Route-set updated 2010-12-17 09:51:13.312000 [blink.exe 5536] (5) dlg00db2754: Transaction tsx00db497c state changed to Proceeding 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 180/INVITE/cseq=467 (rdata01b4101c) 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) tsx00db497c: Incoming Response msg 180/INVITE/cseq=467 (rdata01b4101c) in state Proceeding 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) tsx00db497c: State changed from Proceeding to Proceeding, event=RX_MSG 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) dlg00db2754: Received Response msg 180/INVITE/cseq=467 (rdata01b4101c) 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) dlg00db2754: Route-set updated 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) dlg00db2754: Transaction tsx00db497c state changed to Proceeding 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) endpoint: Request msg PRACK/cseq=469 (tdta00db7310) created. 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) dlg00db2754: Sending Request msg PRACK/cseq=469 (tdta00db7310) 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) tsx00db837c: Transaction created for Request msg PRACK/cseq=468 (tdta00db7310) 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) tsx00db837c: Sending Request msg PRACK/cseq=468 (tdta00db7310) in state Null 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) tsx00db837c: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:51:13.562000 [blink.exe 5536] (5) dlg00db2754: Transaction tsx00db837c state changed to Calling 2010-12-17 09:51:13.609000 [blink.exe 5536] (4) wav_player.c: File player 'C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav' created: samp.rate=32000, ch=1, bufsize=4KB, filesize=78KB 2010-12-17 09:51:13.609000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=32000/16000 2010-12-17 09:51:13.609000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=16000/32000 2010-12-17 09:51:13.609000 [blink.exe 5536] (4) conference.c: Port 3 (C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav) transmitting to port 1 (mixer-port) 2010-12-17 09:51:13.609000 [blink.exe 5536] (4) conference.c: Port 3 (C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav) transmitting to port 0 (Master/sound) 2010-12-17 09:51:13.609000 [blink.exe 5536] (4) sound_port.c: EC activated 2010-12-17 09:51:13.687000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 200/PRACK/cseq=468 (rdata01b4101c) 2010-12-17 09:51:13.687000 [blink.exe 5536] (5) tsx00db837c: Incoming Response msg 200/PRACK/cseq=468 (rdata01b4101c) in state Calling 2010-12-17 09:51:13.687000 [blink.exe 5536] (5) tsx00db837c: State changed from Calling to Completed, event=RX_MSG 2010-12-17 09:51:13.687000 [blink.exe 5536] (5) dlg00db2754: Received Response msg 200/PRACK/cseq=468 (rdata01b4101c) 2010-12-17 09:51:13.687000 [blink.exe 5536] (5) dlg00db2754: Transaction tsx00db837c state changed to Completed 2010-12-17 09:51:14.859000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:51:14.875000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:51:14.890000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:51:15.171000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:51:15.312000 [blink.exe 5536] (5) ec01b0add0: 479 samples reduced, buf_cnt=642 2010-12-17 09:51:15.312000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1121 to 642 (eff_cnt=769) 2010-12-17 09:51:16.687000 [blink.exe 5536] (5) tsx00dae27c: Timeout timer event 2010-12-17 09:51:16.687000 [blink.exe 5536] (5) tsx00dae27c: State changed from Completed to Terminated, event=TIMER 2010-12-17 09:51:16.687000 [blink.exe 5536] (5) dlg00dac25c: Transaction tsx00dae27c state changed to Terminated 2010-12-17 09:51:16.687000 [blink.exe 5536] (5) dlg00dac25c: Dialog destroyed 2010-12-17 09:51:16.687000 [blink.exe 5536] (5) tsx00dae27c: Timeout timer event 2010-12-17 09:51:16.687000 [blink.exe 5536] (5) tsx00dae27c: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:51:16.687000 [blink.exe 5536] (5) tdta00dc0b50: Destroying txdata Request msg ACK/cseq=6027 (tdta00dc0b50) 2010-12-17 09:51:16.687000 [blink.exe 5536] (5) tsx00dae27c: Transaction destroyed! 2010-12-17 09:51:18.296000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:51:18.703000 [blink.exe 5536] (5) tsx00db837c: Timeout timer event 2010-12-17 09:51:18.703000 [blink.exe 5536] (5) tsx00db837c: State changed from Completed to Terminated, event=TIMER 2010-12-17 09:51:18.703000 [blink.exe 5536] (5) dlg00db2754: Transaction tsx00db837c state changed to Terminated 2010-12-17 09:51:18.703000 [blink.exe 5536] (5) tsx00db837c: Timeout timer event 2010-12-17 09:51:18.703000 [blink.exe 5536] (5) tsx00db837c: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:51:18.703000 [blink.exe 5536] (5) tdta00db7310: Destroying txdata Request msg PRACK/cseq=468 (tdta00db7310) 2010-12-17 09:51:18.703000 [blink.exe 5536] (5) tsx00db837c: Transaction destroyed! 2010-12-17 09:51:19.093000 [blink.exe 5536] (5) ec01b0add0: 479 samples reduced, buf_cnt=803 2010-12-17 09:51:19.093000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1282 to 803 (eff_cnt=736) 2010-12-17 09:51:19.859000 [blink.exe 5536] (4) sound_port.c: EC suspended because of inactivity 2010-12-17 09:51:19.906000 [blink.exe 5536] (4) wav_player.c: File player 'C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav' created: samp.rate=32000, ch=1, bufsize=4KB, filesize=78KB 2010-12-17 09:51:19.906000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=32000/16000 2010-12-17 09:51:19.906000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=16000/32000 2010-12-17 09:51:19.906000 [blink.exe 5536] (4) conference.c: Port 3 (C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav) transmitting to port 1 (mixer-port) 2010-12-17 09:51:19.906000 [blink.exe 5536] (4) conference.c: Port 3 (C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav) transmitting to port 0 (Master/sound) 2010-12-17 09:51:19.921000 [blink.exe 5536] (4) sound_port.c: EC activated 2010-12-17 09:51:19.937000 [blink.exe 5536] (5) ec01b0add0: 479 samples reduced, buf_cnt=644 2010-12-17 09:51:19.937000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1123 to 644 (eff_cnt=712) 2010-12-17 09:51:21.156000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:51:21.171000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:51:21.187000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:51:21.218000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:51:21.312000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 200/INVITE/cseq=467 (rdata01b4101c) 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) tsx00db497c: Incoming Response msg 200/INVITE/cseq=467 (rdata01b4101c) in state Proceeding 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) tsx00db497c: State changed from Proceeding to Terminated, event=RX_MSG 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) dlg00db2754: Received Response msg 200/INVITE/cseq=467 (rdata01b4101c) 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) dlg00db2754: Route-set updated 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) dlg00db2754: Route-set frozen 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) dlg00db2754: Transaction tsx00db497c state changed to Terminated 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) inv00db2754: Got SDP answer in Response msg 200/INVITE/cseq=467 (rdata01b4101c) 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) inv00db2754: SDP negotiation done, status=0 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) inv00db2754: Received Response msg 200/INVITE/cseq=467 (rdata01b4101c), sending ACK 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) endpoint: Request msg ACK/cseq=467 (tdta00dac1f8) created. 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) dlg00db2754: Sending Request msg ACK/cseq=467 (tdta00dac1f8) 2010-12-17 09:51:23.500000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:51:23.515000 [blink.exe 5536] (5) tsx00db497c: Timeout timer event 2010-12-17 09:51:23.515000 [blink.exe 5536] (5) tsx00db497c: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:51:23.515000 [blink.exe 5536] (5) tdta00db3910: Destroying txdata Request msg INVITE/cseq=467 (tdta00db3910) 2010-12-17 09:51:23.515000 [blink.exe 5536] (5) tsx00db497c: Transaction destroyed! 2010-12-17 09:51:23.531000 [blink.exe 5536] (5) rtp.c: pjmedia_rtp_session_init: ses=00dc0da8, default_pt=9, ssrc=0x68465899 2010-12-17 09:51:23.531000 [blink.exe 5536] (5) rtp.c: pjmedia_rtp_session_init: ses=00dc13cc, default_pt=9, ssrc=0x68465899 2010-12-17 09:51:23.531000 [blink.exe 5536] (5) stream.c: Stream strm00db1e00 created 2010-12-17 09:51:23.531000 [blink.exe 5536] (4) strm00db1e00: Encoder stream started 2010-12-17 09:51:23.531000 [blink.exe 5536] (4) strm00db1e00: Decoder stream started 2010-12-17 09:51:23.531000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 3 (strm00db1e00) 2010-12-17 09:51:23.531000 [blink.exe 5536] (4) conference.c: Port 3 (strm00db1e00) transmitting to port 1 (mixer-port) 2010-12-17 09:51:23.531000 [blink.exe 5536] (4) conference.c: Port 0 (Master/sound) transmitting to port 3 (strm00db1e00) 2010-12-17 09:51:23.531000 [blink.exe 5536] (4) conference.c: Port 3 (strm00db1e00) transmitting to port 0 (Master/sound) 2010-12-17 09:51:23.562000 [blink.exe 5536] (5) strm00db1e00: Jitter buffer empty (prefetch=0) 2010-12-17 09:51:23.562000 [blink.exe 5536] (5) strm00db1e00: Start talksprut.. 2010-12-17 09:51:23.640000 [blink.exe 5536] (5) strm00db1e00: RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0 2010-12-17 09:51:23.734000 [blink.exe 5536] (5) strm00db1e00: jb updated(2), prefetch=1, size=0 2010-12-17 09:51:23.750000 [blink.exe 5536] (4) stream.c: G722 codec used, remote samples per frame detected = 160 2010-12-17 09:51:24.515000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:51:24.531000 [blink.exe 5536] (5) ec01b0add0: 462 samples reduced, buf_cnt=822 2010-12-17 09:51:24.531000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1284 to 822 (eff_cnt=680) 2010-12-17 09:51:27.671000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:51:27.812000 [blink.exe 5536] (5) ec01b0add0: 372 samples reduced, buf_cnt=770 2010-12-17 09:51:27.812000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1142 to 770 (eff_cnt=662) 2010-12-17 09:51:28.218000 [blink.exe 5536] (5) strm00db1e00: Jitter buffer empty (prefetch=1) 2010-12-17 09:51:28.296000 [blink.exe 5536] (5) strm00db1e00: Jitter buffer empty (prefetch=1) 2010-12-17 09:51:28.421000 [blink.exe 5536] (5) strm00db1e00: Internal RTCP NTP clock skew detected: lsr=b11b4a50, now=b11fe3e5, dlsr=00049999 (4:599ms), diff=4 2010-12-17 09:51:30.921000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:51:31.515000 [blink.exe 5536] (5) ec01b0add0: 437 samples reduced, buf_cnt=653 2010-12-17 09:51:31.515000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1090 to 653 (eff_cnt=652) 2010-12-17 09:51:32.578000 [blink.exe 5536] (4) strm00db1e00: RTP recv() error: Connection reset by peer (WSAECONNRESET) [err:130054] 2010-12-17 09:51:32.593000 [blink.exe 5536] (5) strm00db1e00: Jitter buffer empty (prefetch=1) 2010-12-17 09:51:32.593000 [blink.exe 5536] (4) strm00db1e00: RTP recv() error: Connection reset by peer (WSAECONNRESET) [err:130054] 2010-12-17 09:51:32.609000 [blink.exe 5536] (4) strm00db1e00: RTP recv() error: Connection reset by peer (WSAECONNRESET) [err:130054] 2010-12-17 09:51:32.640000 [blink.exe 5536] (4) strm00db1e00: RTP recv() error: Connection reset by peer (WSAECONNRESET) [err:130054] 2010-12-17 09:51:32.656000 [blink.exe 5536] (4) strm00db1e00: RTP recv() error: Connection reset by peer (WSAECONNRESET) [err:130054] 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Request msg BYE/cseq=1 (rdata01b4101c) 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) dlg00db2754: Received Request msg BYE/cseq=1 (rdata01b4101c) 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) tsx01ed33dc: Transaction created for Request msg BYE/cseq=1 (rdata01b4101c) 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) tsx01ed33dc: Incoming Request msg BYE/cseq=1 (rdata01b4101c) in state Null 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) tsx01ed33dc: State changed from Null to Trying, event=RX_MSG 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) dlg00db2754: Transaction tsx01ed33dc state changed to Trying 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) endpoint: Response msg 200/BYE/cseq=1 (tdta00db8c00) created 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) dlg00db2754: Sending Response msg 200/BYE/cseq=1 (tdta00db8c00) 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) tsx01ed33dc: Sending Response msg 200/BYE/cseq=1 (tdta00db8c00) in state Trying 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:5060' type=UDP resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) tsx01ed33dc: State changed from Trying to Completed, event=TX_MSG 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) dlg00db2754: Transaction tsx01ed33dc state changed to Completed 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) tdta00dac1f8: Destroying txdata Request msg ACK/cseq=467 (tdta00dac1f8) 2010-12-17 09:51:32.656000 [blink.exe 5536] (5) dlg00db2754: Session count dec to 3 by mod-invite 2010-12-17 09:51:32.687000 [blink.exe 5536] (4) wav_player.c: File player 'C:\Program Files\Blink\resources\sounds/hangup_tone.wav' created: samp.rate=32000, ch=1, bufsize=4KB, filesize=32KB 2010-12-17 09:51:32.687000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=32000/16000 2010-12-17 09:51:32.687000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=16000/32000 2010-12-17 09:51:32.687000 [blink.exe 5536] (4) conference.c: Port 1 (C:\Program Files\Blink\resources\sounds/hangup_tone.wav) transmitting to port 0 (Master/sound) 2010-12-17 09:51:33.187000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:51:33.218000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:51:33.234000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:51:33.250000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:51:35.390000 [blink.exe 5536] (5) ec01b0add0: 479 samples reduced, buf_cnt=494 2010-12-17 09:51:35.390000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 973 to 494 (eff_cnt=649) 2010-12-17 09:51:38.109000 [blink.exe 5536] (4) sound_port.c: EC suspended because of inactivity 2010-12-17 09:52:04.656000 [blink.exe 5536] (5) tsx01ed33dc: Timeout timer event 2010-12-17 09:52:04.656000 [blink.exe 5536] (5) tsx01ed33dc: State changed from Completed to Terminated, event=TIMER 2010-12-17 09:52:04.656000 [blink.exe 5536] (5) dlg00db2754: Transaction tsx01ed33dc state changed to Terminated 2010-12-17 09:52:04.656000 [blink.exe 5536] (5) dlg00db2754: Dialog destroyed 2010-12-17 09:52:04.656000 [blink.exe 5536] (5) tsx01ed33dc: Timeout timer event 2010-12-17 09:52:04.656000 [blink.exe 5536] (5) tsx01ed33dc: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:52:04.656000 [blink.exe 5536] (5) tdta00db8c00: Destroying txdata Response msg 200/BYE/cseq=1 (tdta00db8c00) 2010-12-17 09:52:04.656000 [blink.exe 5536] (5) tsx01ed33dc: Transaction destroyed! 2010-12-17 09:53:57.750000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 0 (Master/sound) 2010-12-17 09:53:57.750000 [blink.exe 5536] (4) conference.c: Port 0 (Master/sound) transmitting to port 1 (mixer-port) 2010-12-17 09:53:57.750000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) stop transmitting to port 0 (Master/sound) 2010-12-17 09:53:57.796000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 0 (Master/sound) 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) dlg00db059c: UAC dialog created 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) dlg00db059c: Module mod-invite added as dialog usage, data=00db0c5c 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) dlg00db059c: Session count inc to 3 by mod-invite 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) dlg00db059c: Module mod-100rel added as dialog usage, data=00dbb878 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) dlg00db059c: 100rel module attached 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) inv00db059c: UAC invite session created for dialog dlg00db059c 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) endpoint: Request msg INVITE/cseq=32256 (tdta00db36f8) created. 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) inv00db059c: Sending Request msg INVITE/cseq=32256 (tdta00db36f8) 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) dlg00db059c: Sending Request msg INVITE/cseq=32256 (tdta00db36f8) 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) tsx00db4764: Transaction created for Request msg INVITE/cseq=32255 (tdta00db36f8) 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) tsx00db4764: Sending Request msg INVITE/cseq=32255 (tdta00db36f8) in state Null 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) tsx00db4764: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:53:57.921000 [blink.exe 5536] (5) dlg00db059c: Transaction tsx00db4764 state changed to Calling 2010-12-17 09:53:57.984000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 100/INVITE/cseq=32255 (rdata035d301c) 2010-12-17 09:53:57.984000 [blink.exe 5536] (5) tsx00db4764: Incoming Response msg 100/INVITE/cseq=32255 (rdata035d301c) in state Calling 2010-12-17 09:53:57.984000 [blink.exe 5536] (5) tsx00db4764: State changed from Calling to Proceeding, event=RX_MSG 2010-12-17 09:53:57.984000 [blink.exe 5536] (5) dlg00db059c: Received Response msg 100/INVITE/cseq=32255 (rdata035d301c) 2010-12-17 09:53:57.984000 [blink.exe 5536] (5) dlg00db059c: Route-set updated 2010-12-17 09:53:57.984000 [blink.exe 5536] (5) dlg00db059c: Transaction tsx00db4764 state changed to Proceeding 2010-12-17 09:53:58.187000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 180/INVITE/cseq=32255 (rdata035d301c) 2010-12-17 09:53:58.187000 [blink.exe 5536] (5) tsx00db4764: Incoming Response msg 180/INVITE/cseq=32255 (rdata035d301c) in state Proceeding 2010-12-17 09:53:58.187000 [blink.exe 5536] (5) tsx00db4764: State changed from Proceeding to Proceeding, event=RX_MSG 2010-12-17 09:53:58.187000 [blink.exe 5536] (5) dlg00db059c: Received Response msg 180/INVITE/cseq=32255 (rdata035d301c) 2010-12-17 09:53:58.187000 [blink.exe 5536] (5) dlg00db059c: Route-set updated 2010-12-17 09:53:58.187000 [blink.exe 5536] (5) dlg00db059c: Transaction tsx00db4764 state changed to Proceeding 2010-12-17 09:53:58.187000 [blink.exe 5536] (4) wav_player.c: File player 'C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav' created: samp.rate=32000, ch=1, bufsize=4KB, filesize=78KB 2010-12-17 09:53:58.187000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=32000/16000 2010-12-17 09:53:58.187000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=16000/32000 2010-12-17 09:53:58.187000 [blink.exe 5536] (4) conference.c: Port 3 (C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav) transmitting to port 1 (mixer-port) 2010-12-17 09:53:58.187000 [blink.exe 5536] (4) conference.c: Port 3 (C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav) transmitting to port 0 (Master/sound) 2010-12-17 09:53:58.203000 [blink.exe 5536] (4) sound_port.c: EC activated 2010-12-17 09:53:58.312000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:53:58.343000 [blink.exe 5536] (5) ec01b0add0: 330 samples reduced, buf_cnt=804 2010-12-17 09:53:58.343000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1134 to 804 (eff_cnt=644) 2010-12-17 09:53:59.437000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:53:59.453000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:53:59.468000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 200/INVITE/cseq=32255 (rdata035d301c) 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) tsx00db4764: Incoming Response msg 200/INVITE/cseq=32255 (rdata035d301c) in state Proceeding 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) tsx00db4764: State changed from Proceeding to Terminated, event=RX_MSG 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) dlg00db059c: Received Response msg 200/INVITE/cseq=32255 (rdata035d301c) 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) dlg00db059c: Route-set updated 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) dlg00db059c: Route-set frozen 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) dlg00db059c: Transaction tsx00db4764 state changed to Terminated 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) inv00db059c: Got SDP answer in Response msg 200/INVITE/cseq=32255 (rdata035d301c) 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) inv00db059c: SDP negotiation done, status=0 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) inv00db059c: Received Response msg 200/INVITE/cseq=32255 (rdata035d301c), sending ACK 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) endpoint: Request msg ACK/cseq=32255 (tdta00dc2008) created. 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) dlg00db059c: Sending Request msg ACK/cseq=32255 (tdta00dc2008) 2010-12-17 09:54:00.281000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:54:00.296000 [blink.exe 5536] (5) tsx00db4764: Timeout timer event 2010-12-17 09:54:00.296000 [blink.exe 5536] (5) tsx00db4764: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:54:00.296000 [blink.exe 5536] (5) tdta00db36f8: Destroying txdata Request msg INVITE/cseq=32255 (tdta00db36f8) 2010-12-17 09:54:00.296000 [blink.exe 5536] (5) tsx00db4764: Transaction destroyed! 2010-12-17 09:54:00.296000 [blink.exe 5536] (5) rtp.c: pjmedia_rtp_session_init: ses=00db3978, default_pt=9, ssrc=0x64317585 2010-12-17 09:54:00.296000 [blink.exe 5536] (5) rtp.c: pjmedia_rtp_session_init: ses=00db3f9c, default_pt=9, ssrc=0x64317585 2010-12-17 09:54:00.296000 [blink.exe 5536] (5) stream.c: Stream strm00db31a0 created 2010-12-17 09:54:00.312000 [blink.exe 5536] (4) strm00db31a0: Encoder stream started 2010-12-17 09:54:00.312000 [blink.exe 5536] (4) strm00db31a0: Decoder stream started 2010-12-17 09:54:00.312000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 3 (strm00db31a0) 2010-12-17 09:54:00.312000 [blink.exe 5536] (4) conference.c: Port 3 (strm00db31a0) transmitting to port 1 (mixer-port) 2010-12-17 09:54:00.312000 [blink.exe 5536] (4) conference.c: Port 0 (Master/sound) transmitting to port 3 (strm00db31a0) 2010-12-17 09:54:00.312000 [blink.exe 5536] (4) conference.c: Port 3 (strm00db31a0) transmitting to port 0 (Master/sound) 2010-12-17 09:54:00.312000 [blink.exe 5536] (5) strm00db31a0: Jitter buffer empty (prefetch=0) 2010-12-17 09:54:00.312000 [blink.exe 5536] (5) strm00db31a0: Start talksprut.. 2010-12-17 09:54:00.359000 [blink.exe 5536] (4) strm00db31a0: RTCP recv() error: Connection reset by peer (WSAECONNRESET) [err:130054] 2010-12-17 09:54:00.390000 [blink.exe 5536] (5) strm00db31a0: RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0 2010-12-17 09:54:00.468000 [blink.exe 5536] (5) strm00db31a0: jb updated(2), prefetch=1, size=0 2010-12-17 09:54:00.484000 [blink.exe 5536] (4) stream.c: G722 codec used, remote samples per frame detected = 160 2010-12-17 09:54:00.625000 [blink.exe 5536] (4) strm00db31a0: RTCP recv() error: Connection reset by peer (WSAECONNRESET) [err:130054] 2010-12-17 09:54:01.312000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:54:01.796000 [blink.exe 5536] (5) ec01b0add0: 206 samples reduced, buf_cnt=918 2010-12-17 09:54:01.796000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1124 to 918 (eff_cnt=642) 2010-12-17 09:54:04.437000 [blink.exe 5536] (4) sound_port.c: EC suspended because of inactivity 2010-12-17 09:54:04.515000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:54:07.859000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:54:08.218000 [blink.exe 5536] (5) strm00db31a0: Jitter buffer empty (prefetch=1) 2010-12-17 09:54:08.234000 [blink.exe 5536] (5) strm00db31a0: jb updated(2), prefetch=2, size=1 2010-12-17 09:54:09.531000 [blink.exe 5536] (4) strm00db31a0: RTCP recv() error: Connection reset by peer (WSAECONNRESET) [err:130054] 2010-12-17 09:54:10.875000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:54:12.171000 [blink.exe 5536] (5) strm00db31a0: jb updated(1), prefetch=1, size=1 2010-12-17 09:54:13.546000 [blink.exe 5536] (5) endpoint: Request msg BYE/cseq=32257 (tdta00dbe0f0) created. 2010-12-17 09:54:13.546000 [blink.exe 5536] (5) inv00db059c: Sending Request msg BYE/cseq=32257 (tdta00dbe0f0) 2010-12-17 09:54:13.546000 [blink.exe 5536] (5) dlg00db059c: Sending Request msg BYE/cseq=32257 (tdta00dbe0f0) 2010-12-17 09:54:13.546000 [blink.exe 5536] (5) tsx0360585c: Transaction created for Request msg BYE/cseq=32256 (tdta00dbe0f0) 2010-12-17 09:54:13.546000 [blink.exe 5536] (5) tsx0360585c: Sending Request msg BYE/cseq=32256 (tdta00dbe0f0) in state Null 2010-12-17 09:54:13.546000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:54:13.546000 [blink.exe 5536] (5) tsx0360585c: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:54:13.546000 [blink.exe 5536] (5) dlg00db059c: Transaction tsx0360585c state changed to Calling 2010-12-17 09:54:13.687000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 200/BYE/cseq=32256 (rdata035d2e8c) 2010-12-17 09:54:13.687000 [blink.exe 5536] (5) tsx0360585c: Incoming Response msg 200/BYE/cseq=32256 (rdata035d2e8c) in state Calling 2010-12-17 09:54:13.687000 [blink.exe 5536] (5) tsx0360585c: State changed from Calling to Completed, event=RX_MSG 2010-12-17 09:54:13.687000 [blink.exe 5536] (5) dlg00db059c: Received Response msg 200/BYE/cseq=32256 (rdata035d2e8c) 2010-12-17 09:54:13.687000 [blink.exe 5536] (5) dlg00db059c: Transaction tsx0360585c state changed to Completed 2010-12-17 09:54:13.687000 [blink.exe 5536] (5) tdta00dc2008: Destroying txdata Request msg ACK/cseq=32255 (tdta00dc2008) 2010-12-17 09:54:13.687000 [blink.exe 5536] (5) dlg00db059c: Session count dec to 1 by mod-invite 2010-12-17 09:54:13.703000 [blink.exe 5536] (4) wav_player.c: File player 'C:\Program Files\Blink\resources\sounds/hangup_tone.wav' created: samp.rate=32000, ch=1, bufsize=4KB, filesize=32KB 2010-12-17 09:54:13.703000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=32000/16000 2010-12-17 09:54:13.703000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=16000/32000 2010-12-17 09:54:13.703000 [blink.exe 5536] (4) conference.c: Port 1 (C:\Program Files\Blink\resources\sounds/hangup_tone.wav) transmitting to port 0 (Master/sound) 2010-12-17 09:54:13.718000 [blink.exe 5536] (4) sound_port.c: EC activated 2010-12-17 09:54:13.734000 [blink.exe 5536] (5) ec01b0add0: 466 samples reduced, buf_cnt=772 2010-12-17 09:54:13.734000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1238 to 772 (eff_cnt=641) 2010-12-17 09:54:14.093000 [blink.exe 5536] (5) ec01b0add0: 360 samples reduced, buf_cnt=732 2010-12-17 09:54:14.093000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1092 to 732 (eff_cnt=641) 2010-12-17 09:54:14.218000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:14.234000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:14.250000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:14.281000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:16.750000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 0 (Master/sound) 2010-12-17 09:54:16.750000 [blink.exe 5536] (4) conference.c: Port 0 (Master/sound) transmitting to port 1 (mixer-port) 2010-12-17 09:54:16.750000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) stop transmitting to port 0 (Master/sound) 2010-12-17 09:54:16.781000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 0 (Master/sound) 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) dlg00d8f094: UAC dialog created 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) dlg00d8f094: Module mod-invite added as dialog usage, data=00d8f740 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) dlg00d8f094: Session count inc to 3 by mod-invite 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) dlg00d8f094: Module mod-100rel added as dialog usage, data=00db2ab0 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) dlg00d8f094: 100rel module attached 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) inv00d8f094: UAC invite session created for dialog dlg00d8f094 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) endpoint: Request msg INVITE/cseq=29490 (tdta00db2af8) created. 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) inv00d8f094: Sending Request msg INVITE/cseq=29490 (tdta00db2af8) 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) dlg00d8f094: Sending Request msg INVITE/cseq=29490 (tdta00db2af8) 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) tsx00db3b64: Transaction created for Request msg INVITE/cseq=29489 (tdta00db2af8) 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) tsx00db3b64: Sending Request msg INVITE/cseq=29489 (tdta00db2af8) in state Null 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) tsx00db3b64: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:54:16.921000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx00db3b64 state changed to Calling 2010-12-17 09:54:16.984000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 100/INVITE/cseq=29489 (rdata035f4e64) 2010-12-17 09:54:16.984000 [blink.exe 5536] (5) tsx00db3b64: Incoming Response msg 100/INVITE/cseq=29489 (rdata035f4e64) in state Calling 2010-12-17 09:54:16.984000 [blink.exe 5536] (5) tsx00db3b64: State changed from Calling to Proceeding, event=RX_MSG 2010-12-17 09:54:16.984000 [blink.exe 5536] (5) dlg00d8f094: Received Response msg 100/INVITE/cseq=29489 (rdata035f4e64) 2010-12-17 09:54:16.984000 [blink.exe 5536] (5) dlg00d8f094: Route-set updated 2010-12-17 09:54:16.984000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx00db3b64 state changed to Proceeding 2010-12-17 09:54:17.093000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 180/INVITE/cseq=29489 (rdata035f4e64) 2010-12-17 09:54:17.093000 [blink.exe 5536] (5) tsx00db3b64: Incoming Response msg 180/INVITE/cseq=29489 (rdata035f4e64) in state Proceeding 2010-12-17 09:54:17.093000 [blink.exe 5536] (5) tsx00db3b64: State changed from Proceeding to Proceeding, event=RX_MSG 2010-12-17 09:54:17.093000 [blink.exe 5536] (5) dlg00d8f094: Received Response msg 180/INVITE/cseq=29489 (rdata035f4e64) 2010-12-17 09:54:17.093000 [blink.exe 5536] (5) dlg00d8f094: Route-set updated 2010-12-17 09:54:17.093000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx00db3b64 state changed to Proceeding 2010-12-17 09:54:17.109000 [blink.exe 5536] (4) wav_player.c: File player 'C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav' created: samp.rate=32000, ch=1, bufsize=4KB, filesize=78KB 2010-12-17 09:54:17.109000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=32000/16000 2010-12-17 09:54:17.109000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=16000/32000 2010-12-17 09:54:17.109000 [blink.exe 5536] (4) conference.c: Port 3 (C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav) transmitting to port 1 (mixer-port) 2010-12-17 09:54:17.109000 [blink.exe 5536] (4) conference.c: Port 3 (C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav) transmitting to port 0 (Master/sound) 2010-12-17 09:54:17.531000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:54:17.562000 [blink.exe 5536] (5) ec01b0add0: 261 samples reduced, buf_cnt=791 2010-12-17 09:54:17.562000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1052 to 791 (eff_cnt=640) 2010-12-17 09:54:18.359000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:54:18.375000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:54:18.390000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav EOF 2010-12-17 09:54:18.687000 [blink.exe 5536] (5) tsx0360585c: Timeout timer event 2010-12-17 09:54:18.687000 [blink.exe 5536] (5) tsx0360585c: State changed from Completed to Terminated, event=TIMER 2010-12-17 09:54:18.687000 [blink.exe 5536] (5) dlg00db059c: Transaction tsx0360585c state changed to Terminated 2010-12-17 09:54:18.687000 [blink.exe 5536] (5) dlg00db059c: Dialog destroyed 2010-12-17 09:54:18.687000 [blink.exe 5536] (5) tsx0360585c: Timeout timer event 2010-12-17 09:54:18.687000 [blink.exe 5536] (5) tsx0360585c: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:54:18.687000 [blink.exe 5536] (5) tdta00dbe0f0: Destroying txdata Request msg BYE/cseq=32256 (tdta00dbe0f0) 2010-12-17 09:54:18.687000 [blink.exe 5536] (5) tsx0360585c: Transaction destroyed! 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 200/INVITE/cseq=29489 (rdata035f4e64) 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) tsx00db3b64: Incoming Response msg 200/INVITE/cseq=29489 (rdata035f4e64) in state Proceeding 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) tsx00db3b64: State changed from Proceeding to Terminated, event=RX_MSG 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) dlg00d8f094: Received Response msg 200/INVITE/cseq=29489 (rdata035f4e64) 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) dlg00d8f094: Route-set updated 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) dlg00d8f094: Route-set frozen 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx00db3b64 state changed to Terminated 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) inv00d8f094: Got SDP answer in Response msg 200/INVITE/cseq=29489 (rdata035f4e64) 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) inv00d8f094: SDP negotiation done, status=0 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) inv00d8f094: Received Response msg 200/INVITE/cseq=29489 (rdata035f4e64), sending ACK 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) endpoint: Request msg ACK/cseq=29489 (tdta00dbe0f0) created. 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) dlg00d8f094: Sending Request msg ACK/cseq=29489 (tdta00dbe0f0) 2010-12-17 09:54:19.109000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:54:19.125000 [blink.exe 5536] (5) tsx00db3b64: Timeout timer event 2010-12-17 09:54:19.125000 [blink.exe 5536] (5) tsx00db3b64: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:54:19.125000 [blink.exe 5536] (5) tdta00db2af8: Destroying txdata Request msg INVITE/cseq=29489 (tdta00db2af8) 2010-12-17 09:54:19.125000 [blink.exe 5536] (5) tsx00db3b64: Transaction destroyed! 2010-12-17 09:54:19.125000 [blink.exe 5536] (5) rtp.c: pjmedia_rtp_session_init: ses=00db2d50, default_pt=9, ssrc=0x2c4e081d 2010-12-17 09:54:19.125000 [blink.exe 5536] (5) rtp.c: pjmedia_rtp_session_init: ses=00db3374, default_pt=9, ssrc=0x2c4e081d 2010-12-17 09:54:19.125000 [blink.exe 5536] (5) stream.c: Stream strm00dafea0 created 2010-12-17 09:54:19.125000 [blink.exe 5536] (4) strm00dafea0: Encoder stream started 2010-12-17 09:54:19.125000 [blink.exe 5536] (4) strm00dafea0: Decoder stream started 2010-12-17 09:54:19.125000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 3 (strm00dafea0) 2010-12-17 09:54:19.125000 [blink.exe 5536] (4) conference.c: Port 3 (strm00dafea0) transmitting to port 1 (mixer-port) 2010-12-17 09:54:19.125000 [blink.exe 5536] (4) conference.c: Port 0 (Master/sound) transmitting to port 3 (strm00dafea0) 2010-12-17 09:54:19.125000 [blink.exe 5536] (4) conference.c: Port 3 (strm00dafea0) transmitting to port 0 (Master/sound) 2010-12-17 09:54:19.140000 [blink.exe 5536] (5) strm00dafea0: Jitter buffer empty (prefetch=0) 2010-12-17 09:54:19.140000 [blink.exe 5536] (5) strm00dafea0: Start talksprut.. 2010-12-17 09:54:20.468000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:54:20.593000 [blink.exe 5536] (5) strm00dafea0: RTP status: badpt=-1, badssrc=0, dup=0, outorder=0, probation=0, restart=0 2010-12-17 09:54:20.593000 [blink.exe 5536] (4) strm00dafea0: Bad RTP pt 8 (expecting 9) 2010-12-17 09:54:20.609000 [blink.exe 5536] (5) strm00dafea0: RTP status: badpt=-1, badssrc=0, dup=0, outorder=0, probation=0, restart=0 2010-12-17 09:54:20.609000 [blink.exe 5536] (4) strm00dafea0: Bad RTP pt 8 (expecting 9) 2010-12-17 09:54:20.640000 [blink.exe 5536] (5) strm00dafea0: RTP status: badpt=-1, badssrc=0, dup=0, outorder=0, probation=0, restart=0 2010-12-17 09:54:20.640000 [blink.exe 5536] (4) strm00dafea0: Bad RTP pt 8 (expecting 9) 2010-12-17 09:54:20.656000 [blink.exe 5536] (5) strm00dafea0: RTP status: badpt=-1, badssrc=0, dup=0, outorder=0, probation=0, restart=0 2010-12-17 09:54:20.656000 [blink.exe 5536] (4) strm00dafea0: Bad RTP pt 8 (expecting 9) 2010-12-17 09:54:20.671000 [blink.exe 5536] (5) strm00dafea0: RTP status: badpt=-1, badssrc=0, dup=0, outorder=0, probation=0, restart=0 2010-12-17 09:54:20.671000 [blink.exe 5536] (4) strm00dafea0: Bad RTP pt 8 (expecting 9) 2010-12-17 09:54:20.687000 [blink.exe 5536] (5) strm00dafea0: RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0 2010-12-17 09:54:20.781000 [blink.exe 5536] (5) strm00dafea0: jb updated(2), prefetch=1, size=0 2010-12-17 09:54:20.796000 [blink.exe 5536] (4) stream.c: G722 codec used, remote samples per frame detected = 160 2010-12-17 09:54:21.109000 [blink.exe 5536] (5) strm00dafea0: Jitter buffer empty (prefetch=1) 2010-12-17 09:54:21.156000 [blink.exe 5536] (5) strm00dafea0: jb updated(2), prefetch=2, size=1 2010-12-17 09:54:21.343000 [blink.exe 5536] (5) ec01b0add0: 285 samples reduced, buf_cnt=826 2010-12-17 09:54:21.343000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1111 to 826 (eff_cnt=640) 2010-12-17 09:54:23.843000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:54:23.859000 [blink.exe 5536] (5) ec01b0add0: 230 samples reduced, buf_cnt=916 2010-12-17 09:54:23.859000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1146 to 916 (eff_cnt=640) 2010-12-17 09:54:23.953000 [blink.exe 5536] (5) endpoint: Request msg BYE/cseq=29491 (tdta01b11238) created. 2010-12-17 09:54:23.953000 [blink.exe 5536] (5) inv00d8f094: Sending Request msg BYE/cseq=29491 (tdta01b11238) 2010-12-17 09:54:23.953000 [blink.exe 5536] (5) dlg00d8f094: Sending Request msg BYE/cseq=29491 (tdta01b11238) 2010-12-17 09:54:23.953000 [blink.exe 5536] (5) tsx01b122a4: Transaction created for Request msg BYE/cseq=29490 (tdta01b11238) 2010-12-17 09:54:23.953000 [blink.exe 5536] (5) tsx01b122a4: Sending Request msg BYE/cseq=29490 (tdta01b11238) in state Null 2010-12-17 09:54:23.953000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:54:23.953000 [blink.exe 5536] (5) tsx01b122a4: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:54:23.953000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx01b122a4 state changed to Calling 2010-12-17 09:54:24.093000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 200/BYE/cseq=29490 (rdata035f4c44) 2010-12-17 09:54:24.093000 [blink.exe 5536] (5) tsx01b122a4: Incoming Response msg 200/BYE/cseq=29490 (rdata035f4c44) in state Calling 2010-12-17 09:54:24.093000 [blink.exe 5536] (5) tsx01b122a4: State changed from Calling to Completed, event=RX_MSG 2010-12-17 09:54:24.093000 [blink.exe 5536] (5) dlg00d8f094: Received Response msg 200/BYE/cseq=29490 (rdata035f4c44) 2010-12-17 09:54:24.093000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx01b122a4 state changed to Completed 2010-12-17 09:54:24.093000 [blink.exe 5536] (5) tdta00dbe0f0: Destroying txdata Request msg ACK/cseq=29489 (tdta00dbe0f0) 2010-12-17 09:54:24.093000 [blink.exe 5536] (5) dlg00d8f094: Session count dec to 1 by mod-invite 2010-12-17 09:54:24.125000 [blink.exe 5536] (4) wav_player.c: File player 'C:\Program Files\Blink\resources\sounds/hangup_tone.wav' created: samp.rate=32000, ch=1, bufsize=4KB, filesize=32KB 2010-12-17 09:54:24.125000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=32000/16000 2010-12-17 09:54:24.125000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=16000/32000 2010-12-17 09:54:24.125000 [blink.exe 5536] (4) conference.c: Port 1 (C:\Program Files\Blink\resources\sounds/hangup_tone.wav) transmitting to port 0 (Master/sound) 2010-12-17 09:54:24.640000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:24.656000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:24.671000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:24.703000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:26.921000 [blink.exe 5536] (5) ec01b0add0: 479 samples reduced, buf_cnt=757 2010-12-17 09:54:26.921000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1236 to 757 (eff_cnt=640) 2010-12-17 09:54:29.093000 [blink.exe 5536] (5) tsx01b122a4: Timeout timer event 2010-12-17 09:54:29.093000 [blink.exe 5536] (5) tsx01b122a4: State changed from Completed to Terminated, event=TIMER 2010-12-17 09:54:29.093000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx01b122a4 state changed to Terminated 2010-12-17 09:54:29.093000 [blink.exe 5536] (5) dlg00d8f094: Dialog destroyed 2010-12-17 09:54:29.093000 [blink.exe 5536] (5) tsx01b122a4: Timeout timer event 2010-12-17 09:54:29.093000 [blink.exe 5536] (5) tsx01b122a4: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:54:29.093000 [blink.exe 5536] (5) tdta01b11238: Destroying txdata Request msg BYE/cseq=29490 (tdta01b11238) 2010-12-17 09:54:29.093000 [blink.exe 5536] (5) tsx01b122a4: Transaction destroyed! 2010-12-17 09:54:29.562000 [blink.exe 5536] (4) sound_port.c: EC suspended because of inactivity 2010-12-17 09:54:31.312000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 0 (Master/sound) 2010-12-17 09:54:31.312000 [blink.exe 5536] (4) conference.c: Port 0 (Master/sound) transmitting to port 1 (mixer-port) 2010-12-17 09:54:31.312000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) stop transmitting to port 0 (Master/sound) 2010-12-17 09:54:31.343000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 0 (Master/sound) 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) dlg00d8f094: UAC dialog created 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) dlg00d8f094: Module mod-invite added as dialog usage, data=00d8f754 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) dlg00d8f094: Session count inc to 3 by mod-invite 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) dlg00d8f094: Module mod-100rel added as dialog usage, data=00dbe4b0 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) dlg00d8f094: 100rel module attached 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) inv00d8f094: UAC invite session created for dialog dlg00d8f094 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) endpoint: Request msg INVITE/cseq=30256 (tdta01b10230) created. 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) inv00d8f094: Sending Request msg INVITE/cseq=30256 (tdta01b10230) 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) dlg00d8f094: Sending Request msg INVITE/cseq=30256 (tdta01b10230) 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) tsx00dbe55c: Transaction created for Request msg INVITE/cseq=30255 (tdta01b10230) 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) tsx00dbe55c: Sending Request msg INVITE/cseq=30255 (tdta01b10230) in state Null 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) tsx00dbe55c: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:54:31.421000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx00dbe55c state changed to Calling 2010-12-17 09:54:31.484000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 100/INVITE/cseq=30255 (rdata035f4c44) 2010-12-17 09:54:31.484000 [blink.exe 5536] (5) tsx00dbe55c: Incoming Response msg 100/INVITE/cseq=30255 (rdata035f4c44) in state Calling 2010-12-17 09:54:31.484000 [blink.exe 5536] (5) tsx00dbe55c: State changed from Calling to Proceeding, event=RX_MSG 2010-12-17 09:54:31.484000 [blink.exe 5536] (5) dlg00d8f094: Received Response msg 100/INVITE/cseq=30255 (rdata035f4c44) 2010-12-17 09:54:31.484000 [blink.exe 5536] (5) dlg00d8f094: Route-set updated 2010-12-17 09:54:31.484000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx00dbe55c state changed to Proceeding 2010-12-17 09:54:31.593000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 180/INVITE/cseq=30255 (rdata035f4c44) 2010-12-17 09:54:31.593000 [blink.exe 5536] (5) tsx00dbe55c: Incoming Response msg 180/INVITE/cseq=30255 (rdata035f4c44) in state Proceeding 2010-12-17 09:54:31.593000 [blink.exe 5536] (5) tsx00dbe55c: State changed from Proceeding to Proceeding, event=RX_MSG 2010-12-17 09:54:31.593000 [blink.exe 5536] (5) dlg00d8f094: Received Response msg 180/INVITE/cseq=30255 (rdata035f4c44) 2010-12-17 09:54:31.593000 [blink.exe 5536] (5) dlg00d8f094: Route-set updated 2010-12-17 09:54:31.593000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx00dbe55c state changed to Proceeding 2010-12-17 09:54:31.609000 [blink.exe 5536] (4) wav_player.c: File player 'C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav' created: samp.rate=32000, ch=1, bufsize=4KB, filesize=78KB 2010-12-17 09:54:31.609000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=32000/16000 2010-12-17 09:54:31.609000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=16000/32000 2010-12-17 09:54:31.609000 [blink.exe 5536] (4) conference.c: Port 3 (C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav) transmitting to port 1 (mixer-port) 2010-12-17 09:54:31.609000 [blink.exe 5536] (4) conference.c: Port 3 (C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav) transmitting to port 0 (Master/sound) 2010-12-17 09:54:31.625000 [blink.exe 5536] (4) sound_port.c: EC activated 2010-12-17 09:54:31.640000 [blink.exe 5536] (5) ec01b0add0: 479 samples reduced, buf_cnt=598 2010-12-17 09:54:31.640000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1077 to 598 (eff_cnt=640) 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 200/INVITE/cseq=30255 (rdata035f4c44) 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) tsx00dbe55c: Incoming Response msg 200/INVITE/cseq=30255 (rdata035f4c44) in state Proceeding 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) tsx00dbe55c: State changed from Proceeding to Terminated, event=RX_MSG 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) dlg00d8f094: Received Response msg 200/INVITE/cseq=30255 (rdata035f4c44) 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) dlg00d8f094: Route-set updated 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) dlg00d8f094: Route-set frozen 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx00dbe55c state changed to Terminated 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) inv00d8f094: Got SDP answer in Response msg 200/INVITE/cseq=30255 (rdata035f4c44) 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) inv00d8f094: SDP negotiation done, status=0 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) inv00d8f094: Received Response msg 200/INVITE/cseq=30255 (rdata035f4c44), sending ACK 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) endpoint: Request msg ACK/cseq=30255 (tdta00dc8070) created. 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) dlg00d8f094: Sending Request msg ACK/cseq=30255 (tdta00dc8070) 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) tsx00dbe55c: Timeout timer event 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) tsx00dbe55c: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) tdta01b10230: Destroying txdata Request msg INVITE/cseq=30255 (tdta01b10230) 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) tsx00dbe55c: Transaction destroyed! 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) rtp.c: pjmedia_rtp_session_init: ses=01b10488, default_pt=9, ssrc=0x22450b68 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) rtp.c: pjmedia_rtp_session_init: ses=01b10aac, default_pt=9, ssrc=0x22450b68 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) stream.c: Stream strm00dbdb98 created 2010-12-17 09:54:32.609000 [blink.exe 5536] (4) strm00dbdb98: Encoder stream started 2010-12-17 09:54:32.609000 [blink.exe 5536] (4) strm00dbdb98: Decoder stream started 2010-12-17 09:54:32.609000 [blink.exe 5536] (5) strm00dbdb98: Start talksprut.. 2010-12-17 09:54:32.609000 [blink.exe 5536] (4) conference.c: Port 2 (mixer-port) transmitting to port 4 (strm00dbdb98) 2010-12-17 09:54:32.609000 [blink.exe 5536] (4) conference.c: Port 4 (strm00dbdb98) transmitting to port 1 (mixer-port) 2010-12-17 09:54:32.609000 [blink.exe 5536] (4) conference.c: Port 0 (Master/sound) transmitting to port 4 (strm00dbdb98) 2010-12-17 09:54:32.609000 [blink.exe 5536] (4) conference.c: Port 4 (strm00dbdb98) transmitting to port 0 (Master/sound) 2010-12-17 09:54:32.609000 [blink.exe 5536] (4) conference.c: Port 3 (C:\Program Files\Blink\resources\sounds\outbound_ringtone.wav) transmitting to port 4 (strm00dbdb98) 2010-12-17 09:54:32.640000 [blink.exe 5536] (5) strm00dbdb98: Jitter buffer empty (prefetch=0) 2010-12-17 09:54:32.734000 [blink.exe 5536] (5) strm00dbdb98: RTP status: badpt=0, badssrc=0, dup=0, outorder=0, probation=-1, restart=0 2010-12-17 09:54:32.796000 [blink.exe 5536] (5) strm00dbdb98: Jitter buffer empty (prefetch=0) 2010-12-17 09:54:32.859000 [blink.exe 5536] (5) strm00dbdb98: jb updated(2), prefetch=1, size=0 2010-12-17 09:54:32.859000 [blink.exe 5536] (4) stream.c: G722 codec used, remote samples per frame detected = 160 2010-12-17 09:54:33 [blink.exe 5536] (5) strm00dbdb98: jb updated(2), prefetch=2, size=1 2010-12-17 09:54:33.500000 [blink.exe 5536] (4) Master/sound: Underflow, buf_cnt=0, will generate 1 frame 2010-12-17 09:54:33.703000 [blink.exe 5536] (5) ec01b0add0: 160 samples reduced, buf_cnt=1078 2010-12-17 09:54:33.703000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1238 to 1078 (eff_cnt=640) 2010-12-17 09:54:33.718000 [blink.exe 5536] (5) ec01b0add0: 166 samples reduced, buf_cnt=912 2010-12-17 09:54:33.718000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1078 to 912 (eff_cnt=640) 2010-12-17 09:54:36.343000 [blink.exe 5536] (5) endpoint: Request msg BYE/cseq=30257 (tdta00dc7068) created. 2010-12-17 09:54:36.343000 [blink.exe 5536] (5) inv00d8f094: Sending Request msg BYE/cseq=30257 (tdta00dc7068) 2010-12-17 09:54:36.343000 [blink.exe 5536] (5) dlg00d8f094: Sending Request msg BYE/cseq=30257 (tdta00dc7068) 2010-12-17 09:54:36.343000 [blink.exe 5536] (5) tsx035e306c: Transaction created for Request msg BYE/cseq=30256 (tdta00dc7068) 2010-12-17 09:54:36.343000 [blink.exe 5536] (5) tsx035e306c: Sending Request msg BYE/cseq=30256 (tdta00dc7068) in state Null 2010-12-17 09:54:36.343000 [blink.exe 5536] (5) sip_resolve.c: Target '66.227.100.25:0' type=Unspecified resolved to '66.227.100.25:5060' type=UDP (UDP transport) 2010-12-17 09:54:36.343000 [blink.exe 5536] (5) tsx035e306c: State changed from Null to Calling, event=TX_MSG 2010-12-17 09:54:36.343000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx035e306c state changed to Calling 2010-12-17 09:54:36.484000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Response msg 200/BYE/cseq=30256 (rdata035f4c44) 2010-12-17 09:54:36.484000 [blink.exe 5536] (5) tsx035e306c: Incoming Response msg 200/BYE/cseq=30256 (rdata035f4c44) in state Calling 2010-12-17 09:54:36.484000 [blink.exe 5536] (5) tsx035e306c: State changed from Calling to Completed, event=RX_MSG 2010-12-17 09:54:36.484000 [blink.exe 5536] (5) dlg00d8f094: Received Response msg 200/BYE/cseq=30256 (rdata035f4c44) 2010-12-17 09:54:36.484000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx035e306c state changed to Completed 2010-12-17 09:54:36.484000 [blink.exe 5536] (5) tdta00dc8070: Destroying txdata Request msg ACK/cseq=30255 (tdta00dc8070) 2010-12-17 09:54:36.484000 [blink.exe 5536] (5) dlg00d8f094: Session count dec to 1 by mod-invite 2010-12-17 09:54:36.500000 [blink.exe 5536] (4) wav_player.c: File player 'C:\Program Files\Blink\resources\sounds/hangup_tone.wav' created: samp.rate=32000, ch=1, bufsize=4KB, filesize=32KB 2010-12-17 09:54:36.500000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=32000/16000 2010-12-17 09:54:36.500000 [blink.exe 5536] (5) resample.c: resample created: high qualiy, large filter, in/out rate=16000/32000 2010-12-17 09:54:36.500000 [blink.exe 5536] (4) conference.c: Port 1 (C:\Program Files\Blink\resources\sounds/hangup_tone.wav) transmitting to port 0 (Master/sound) 2010-12-17 09:54:36.515000 [blink.exe 5536] (5) ec01b0add0: 207 samples reduced, buf_cnt=1025 2010-12-17 09:54:36.515000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1232 to 1025 (eff_cnt=640) 2010-12-17 09:54:36.843000 [blink.exe 5536] (5) ec01b0add0: 320 samples reduced, buf_cnt=705 2010-12-17 09:54:36.843000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1025 to 705 (eff_cnt=640) 2010-12-17 09:54:37.015000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:37.031000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:37.062000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:37.078000 [blink.exe 5536] (5) wav_player.c: File port C:\Program Files\Blink\resources\sounds/hangup_tone.wav EOF 2010-12-17 09:54:41.296000 [blink.exe 5536] (5) ec01b0add0: 479 samples reduced, buf_cnt=546 2010-12-17 09:54:41.296000 [blink.exe 5536] (4) ec01b0add0: Buffer size adjusted from 1025 to 546 (eff_cnt=640) 2010-12-17 09:54:41.484000 [blink.exe 5536] (5) tsx035e306c: Timeout timer event 2010-12-17 09:54:41.484000 [blink.exe 5536] (5) tsx035e306c: State changed from Completed to Terminated, event=TIMER 2010-12-17 09:54:41.484000 [blink.exe 5536] (5) dlg00d8f094: Transaction tsx035e306c state changed to Terminated 2010-12-17 09:54:41.484000 [blink.exe 5536] (5) dlg00d8f094: Dialog destroyed 2010-12-17 09:54:41.484000 [blink.exe 5536] (5) tsx035e306c: Timeout timer event 2010-12-17 09:54:41.484000 [blink.exe 5536] (5) tsx035e306c: State changed from Terminated to Destroyed, event=TIMER 2010-12-17 09:54:41.484000 [blink.exe 5536] (5) tdta00dc7068: Destroying txdata Request msg BYE/cseq=30256 (tdta00dc7068) 2010-12-17 09:54:41.484000 [blink.exe 5536] (5) tsx035e306c: Transaction destroyed! 2010-12-17 09:54:41.937000 [blink.exe 5536] (4) sound_port.c: EC suspended because of inactivity 2010-12-17 09:54:42.796000 [blink.exe 5536] (5) sip_endpoint.c: Processing incoming message: Request msg INVITE/cseq=1 (rdata035f4c44) 2010-12-17 09:54:42.796000 [blink.exe 5536] (4) sip_endpoint.c: Message Request msg INVITE/cseq=1 (rdata035f4c44) from 66.227.100.25:5060 was dropped/unhandled by any modules 2010-12-17 09:54:42.812000 [blink.exe 5536] (5) pasound.c: Stopping stream.. 2010-12-17 09:54:42.921000 [blink.exe 5536] (5) pasound.c: Done, status=0 2010-12-17 09:54:42.921000 [blink.exe 5536] (5) pasound.c: Closing Chat 160: 0 underflow, 0 overflow 2010-12-17 09:54:44.015000 [blink.exe 5536] (5) pasound.c: Stopping stream.. 2010-12-17 09:54:44.015000 [blink.exe 5536] (5) pasound.c: Done, status=0 2010-12-17 09:54:45.093000 [blink.exe 5536] (5) pasound.c: Closing Realtek HD Audio output: 0 underflow, 0 overflow 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) tcplis:4803: SIP TCP listener destroyed 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) tls01b3e554: SIP TLS listener destroyed 2010-12-17 09:54:45.093000 [blink.exe 5536] (5) sip_endpoint.c: Destroying endpoing instance.. 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_transactio: Stopping transaction layer module 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-core" unregistered 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-stateful-util" unregistered 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-core-events" unregistered 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-invite" unregistered 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-100rel" unregistered 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-evsub" unregistered 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-ua" unregistered 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_transactio: Transaction layer module destroyed 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-tsx-layer" unregistered 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-core-ua-tag" unregistered 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-msg-print" unregistered 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Module "mod-core-sip-trace" unregistered 2010-12-17 09:54:45.093000 [blink.exe 5536] (5) sip_transport.: Destroying transport manager 2010-12-17 09:54:45.093000 [blink.exe 5536] (3) sip_transport.: Warning: 1 transmit buffer(s) not freed! 2010-12-17 09:54:45.093000 [blink.exe 5536] (4) sip_endpoint.c: Endpoint 01b24ae4 destroyed 2010-12-17 09:54:45.484000 [blink.exe 5536] (4) pasound.c: PortAudio sound library shutting down.. 2010-12-17 09:54:45.484000 [blink.exe 5536] (4) AudioMixer_311: Pool is not released by application, releasing now 2010-12-17 09:54:45.484000 [blink.exe 5536] (4) AudioMixer_311: Pool is not released by application, releasing now 2010-12-17 09:54:45.484000 [blink.exe 5536] (4) tdta00d933f0: Pool is not released by application, releasing now