(proc 2884): (debug)vortex-support: file found at: C:\Program Files (x86)\VortexLibraryW32\bin\channel.dtd (proc 2884): (debug)vortex: init winsocket for windows (proc 2884): (debug)vortex-win32: winsock initialization ok (proc 2884): (debug)vortex-support: file found at: C:\Program Files (x86)\VortexLibraryW32\bin\channel.dtd (proc 2884): (debug)vortex-dtds: dtd file definition found at: C:\Program Files (x86)\VortexLibraryW32\bin\channel.dtd (proc 2884): (debug)vortex-support: file found at: C:\Program Files (x86)\VortexLibraryW32\bin\sasl.dtd (proc 2884): (debug)vortex-dtds: dtd file definition found at: C:\Program Files (x86)\VortexLibraryW32\bin\sasl.dtd (proc 2884): (debug)vortex-support: file found at: C:\Program Files (x86)\VortexLibraryW32\bin\xml-rpc-boot.dtd (proc 2884): (debug)vortex-dtds: dtd file definition found at: C:\Program Files (x86)\VortexLibraryW32\bin\xml-rpc-boot.dtd (proc 2884): (debug)vortex: select mechanism selected, reconfiguring current socket limit: soft_limit=1024 > 1024.. (proc 2884): (warning)vortex: found select(2) I/O configured, which can handled up to 1023 fds, reconfigured process with that value (proc 2884): (debug)vortex: starting vortex reader.. (proc 2884): (debug)vortex: starting vortex sequencer.. (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex: starting vortex thread pool: (5 threads the pool have).. (proc 2884): (debug)vortex-thread-pool: creating thread pool threads=5 (proc 2884): (debug)vortex-thread-pool: thread from pool started (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: thread from pool started (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: thread from pool started (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: thread from pool started (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-listener: (proc 2884): invoking listener_new non-threaded mode(debug) vortex-thread-pool: thread from pool started (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-reader: new listener connection to be watched (676 --> 0.0.0.0:44001) (proc 2884): (debug)vortex-connection: invoking connection_new non-threaded mode (proc 2884): (debug)vortex-connection: executing connection new in blocking mode to 192.168.0.109:44001 id=2 (proc 2884): (debug)vortex-channel: sending reply for message 0 (size: 14) (proc 2884): (debug)vortex-channel: mime headers size calculated for channel 0 was: 38 (proc 2884): (debug)vortex-channel: new reply message to sent size (52) = msg size (14) + mime size (38) (proc 2884): (debug)vortex-channel: updating channel sending status to: msgno=0, rpyno=1, seqno=52, ansno=0.. (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-sequencer: a new message to be sequenced.. (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 2 by (vortex sequencer) (proc 2884): (debug)vortex-sequencer: sequence operation: next seq no=0 message size=52 max seq no=4095 step=0 (proc 2884): (debug)vortex-sequencer: the channel is not stalled, continue with sequencing ... (proc 2884): (debug)vortex-sequencer: sequencing next message: type=2, channel num=0, msgno=0, more=0, next seq=0 size=52 ansno=0 (proc 2884): (debug)vortex-sequencer: frame built, send the frame directly (proc 2884): (debug)vortex-sequencer: Sending message, size (73) over connection id=2 (proc 2884): (debug)vortex-frame-factory: bytes written: 73 (proc 2884): (debug)vortex-frame-factory: write on socket request=73 written=73 (proc 2884): (debug)vortex-channel: updating channel sending status to: msgno=0, rpyno=1, seqno=52, ansno=0.. (proc 2884): (debug)vortex-channel: channel=0 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-sequencer: it seems the message was sent completely (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 1 decreased by (vortex sequencer) (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-connection: greetings sent, waiting for reply (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'RPY 0 0 . 0 131' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=1 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 0, content type=application/beep+xml, transfer encoding=, payload size=93, mime content size=38 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=0, rpyno=1, seqno=131, ansno=0.. (proc 2884): (debug)vortex-greetings: greetings frame header specification is ok (proc 2884): (debug)vortex-connection: greetings received, process reply frame (proc 2884): (debug)vortex-connection: About to parse the following message: (size: 93) ' ' (proc 2884): (debug)vortex-connection: document not found in cache, parsing as usual (proc 2884): (debug)vortex-connection: storing xml document for future cache hit (proc 2884): (debug)vortex-connection: greetings parsed.. (proc 2884): (debug)vortex-frame-factory: deallocating frame id=1 (proc 2884): (debug)vortex-connection: new connection created to 192.168.0.109:44001 (proc 2884): (debug)vortex-connection: setting connection as non-blocking (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 2 by vortex reader (process) (proc 2884): (debug)vortex-connection: locking pool channel.. (proc 2884): (debug)vortex-connection: returning as next channel to create: 3 (proc 2884): (debug)vortex-channel: channel num returned=3 (proc 2884): (debug)vortex-channel: mime headers size calculated for channel 0 was: 38 (proc 2884): (debug)vortex-channel: new message to sent, type=1 channel=0 msgno=1 size (136) = msg size (98) + mime size (38) (proc 2884): (debug)vortex-channel: updating channel sending status to: msgno=1, rpyno=1, seqno=188, ansno=0.. (proc 2884): (debug)vortex-channel: getting reply at wait reply from the queue (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (proc 2884): (debug)vortex-sequencer: (debug)vortex-thread: a new message to be sequenced..called vortex_cond_timedwait from vortex_thread.c:856 (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 3 by (vortex sequencer) (proc 2884): (debug)vortex-sequencer: sequence operation: next seq no=52 message size=136 max seq no=4095 step=0 (proc 2884): (debug)vortex-sequencer: the channel is not stalled, continue with sequencing ... (proc 2884): (debug)vortex-sequencer: sequencing next message: type=1, channel num=0, msgno=1, more=0, next seq=52 size=136 ansno=0 (proc 2884): (debug)vortex-sequencer: frame built, send the frame directly (proc 2884): (debug)vortex-sequencer: Sending message, size (159) over connection id=2 (proc 2884): (debug)vortex-frame-factory: bytes written: 159 (proc 2884): (debug)vortex-frame-factory: write on socket request=159 written=159 (proc 2884): (debug)vortex-channel: channel=0 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-sequencer: it seems the message was sent completely (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 2 decreased by (vortex sequencer) (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-reader: new connection to be watched (1136) (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'RPY 0 1 . 131 103' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=2 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 0, content type=application/beep+xml, transfer encoding=, payload size=65, mime content size=38 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=0 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=0, rpyno=2, seqno=234, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: not updated, already not consumed half of window advertised: 234 < (4096 / 2) (proc 2884): (debug)vortex-reader: passed frame checking stage (proc 2884): (debug)vortex-channel: found a frame that were waited by a thread: reply no='1' over channel=0 (proc 2884): (debug)vortex-reader: frame delivered on second (channel) level handler channel (proc 2884): (debug)vortex-thread: finished vortex_cond_timedwait (result: 1) from vortex_thread.c:856 (proc 2884): (debug)vortex-channel: received reply, freeing wait reply object (proc 2884): (debug)vortex-channel: received reply to start message (proc 2884): (debug)vortex-channel: doing validate for start reply msg: '' (proc 2884): (debug)vortex-channel: channel start reply validation stage finished (proc 2884): (debug)vortex-channel-pool: channels added 1 to the pool id=1 (proc 2884): (debug)vortex-connection: unlocking pool channel.. (proc 2884): (debug)vortex-channel-pool: channel pool created id=1 over connection id=2 (proc 2884): (debug)vortex-channel-pool: getting new channel before locking.. (proc 2884): (debug)vortex-connection: locking pool channel.. (proc 2884): (debug)vortex-channel-pool: getting next channel to use (proc 2884): (debug)vortex-channel-pool: channel id=3 is ready to be used, flagged as busy (proc 2884): (debug)vortex-channel-pool: returning channel id=3 for pool id=1 connection id=2 [get_next_ready] (connection=2 actual pool=1 size: 1 channels [3(B)] (proc 2884): (debug)vortex-connection: unlocking pool channel.. (proc 2884): (debug)vortex-channel: mime headers size calculated for channel 3 was: 0 (proc 2884): (debug)vortex-channel: new message to sent, type=1 channel=3 msgno=0 size (120) = msg size (120) + mime size (0) (proc 2884): (debug)vortex-channel: updating channel sending status to: msgno=0, rpyno=0, seqno=120, ansno=0.. (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-sequencer: a new message to be sequenced.. (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 3 by (vortex sequencer) (proc 2884): (debug)vortex-sequencer: sequence operation: next seq no=0 message size=120 max seq no=4095 step=0 (proc 2884): (debug)vortex-sequencer: the channel is not stalled, continue with sequencing ... (proc 2884): (debug)vortex-sequencer: sequencing next message: type=1, channel num=3, msgno=0, more=0, next seq=0 size=120 ansno=0 (proc 2884): (debug)vortex-sequencer: frame built, send the frame directly (proc 2884): (debug)vortex-sequencer: Sending message, size (142) over connection id=2 (proc 2884): (debug)vortex-frame-factory: bytes written: 142 (proc 2884): (debug)vortex-frame-factory: write on socket request=142 written=142 (proc 2884): (debug)vortex-channel: channel=3 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-sequencer: it seems the message was sent completely (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 2 decreased by (vortex sequencer) (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 0 * 0 4096 0' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=3 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=4096, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=0, seqno=4096, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: updating allowed max seq no to be received from 4095 to 8191 (delta: 4096) (proc 2884): (debug)vortex-reader: notifying remote side that current buffer status is SEQ 3 4096 4096 (proc 2884): (debug)vortex-sequencer: Sending message, size (17) over connection id=2 (proc 2884): (debug)vortex-frame-factory: bytes written: 17 (proc 2884): (debug)vortex-frame-factory: write on socket request=17 written=17 (proc 2884): (debug)vortex-channel: channel=0 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: more flag or completed flag detected, skipping to the next frame (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 0 . 4096 204 0' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=4 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=204, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=0, seqno=4300, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: not updated, already not consumed half of window advertised: 204 < (4096 / 2) (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: joining frames (previous frame was found).. (proc 2884): (debug)vortex-frame-factory: from='frame-join' allocating a new frame id=5 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=3 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=4 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: passed frame checking stage (proc 2884): (debug)vortex-channel: no waiting queue for this message: 0 (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 3 by second level invocation (frame received) (proc 2884): (debug)vortex-channel: about to invoke the frame received under a newly created handler (proc 2884): (debug)vortex-reader: frame delivered on second (channel) level handler channel (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 0 * 4300 3892 1' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=6 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=3892, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=0, seqno=8192, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: updating allowed max seq no to be received from 8191 to 12287 (delta: 4096) (proc 2884): (debug)vortex-reader: notifying remote side that current buffer status is SEQ 3 8192 4096 (proc 2884): (debug)vortex-sequencer: Sending message, size (17) over connection id=2 (proc 2884): (debug)vortex-frame-factory: bytes written: 17 (proc 2884): (debug)vortex-frame-factory: write on socket request=17 written=17 (proc 2884): (debug)vortex-channel: channel=0 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: more flag or completed flag detected, skipping to the next frame (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool processing new job (proc 2884): (debug)vortex-channel: inside the frame received handler (new task) (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 0 . 8192 408 1' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=7 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=408, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=0, seqno=8600, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: not updated, already not consumed half of window advertised: 408 < (4096 / 2) (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: joining frames (previous frame was found).. (proc 2884): (debug)vortex-frame-factory: from='frame-join' allocating a new frame id=8 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=6 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=7 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: passed frame checking stage (proc 2884): (debug)vortex-channel: no waiting queue for this message: 0 (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 4 by second level invocation (frame received) (proc 2884): (debug)vortex-channel: about to invoke the frame received under a newly created handler (proc 2884): (debug)vortex-reader: frame delivered on second (channel) level handler channel (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 0 * 8600 3688 2' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=9 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=3688, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=0, seqno=12288, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: updating allowed max seq no to be received from 12287 to 16383 (delta: 4096) (proc 2884): (debug)vortex-reader: notifying remote side that current buffer status is SEQ 3 12288 4096 (proc 2884): (debug)vortex-sequencer: Sending message, size (18) over connection id=2 (proc 2884): (debug)vortex-frame-factory: bytes written: 18 (proc 2884): (debug)vortex-frame-factory: write on socket request=18 written=18 (proc 2884): (debug)vortex-channel: channel=0 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: more flag or completed flag detected, skipping to the next frame (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool processing new job (proc 2884): (debug)vortex-channel: inside the frame received handler (new task) (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 0 . 12288 612 2' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=10 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=612, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=0, seqno=12900, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: not updated, already not consumed half of window advertised: 612 < (4096 / 2) (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: joining frames (previous frame was found).. (proc 2884): (debug)vortex-frame-factory: from='frame-join' allocating a new frame id=11 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=9 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=10 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: passed frame checking stage (proc 2884): (debug)vortex-channel: no waiting queue for this message: 0 (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 5 by second level invocation (frame received) (proc 2884): (debug)vortex-channel: about to invoke the frame received under a newly created handler (proc 2884): (debug)vortex-reader: frame delivered on second (channel) level handler channel (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 0 * 12900 3484 3' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=12 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=3484, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=0, seqno=16384, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: updating allowed max seq no to be received from 16383 to 20479 (delta: 4096) (proc 2884): (debug)vortex-reader: notifying remote side that current buffer status is SEQ 3 16384 4096 (proc 2884): (debug)vortex-sequencer: Sending message, size (18) over connection id=2 (proc 2884): (debug)vortex-frame-factory: bytes written: 18 (proc 2884): (debug)vortex-frame-factory: write on socket request=18 written=18 (proc 2884): (debug)vortex-channel: channel=0 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: more flag or completed flag detected, skipping to the next frame (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool processing new job (proc 2884): (debug)vortex-channel: inside the frame received handler (new task) (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 0 . 16384 816 3' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=13 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=816, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=0, seqno=17200, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: not updated, already not consumed half of window advertised: 816 < (4096 / 2) (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: joining frames (previous frame was found).. (proc 2884): (debug)vortex-frame-factory: from='frame-join' allocating a new frame id=14 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=12 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=13 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: passed frame checking stage (proc 2884): (debug)vortex-channel: no waiting queue for this message: 0 (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 6 by second level invocation (frame received) (proc 2884): (debug)vortex-channel: about to invoke the frame received under a newly created handler (proc 2884): (debug)vortex-reader: frame delivered on second (channel) level handler channel (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool processing new job (proc 2884): (debug)vortex-channel: inside the frame received handler (new task) (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 0 * 17200 3280 4' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=15 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=3280, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=0, seqno=20480, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: updating allowed max seq no to be received from 20479 to 24575 (delta: 4096) (proc 2884): (debug)vortex-reader: notifying remote side that current buffer status is SEQ 3 20480 4096 (proc 2884): (debug)vortex-sequencer: Sending message, size (18) over connection id=2 (proc 2884): (debug)vortex-frame-factory: bytes written: 18 (proc 2884): (debug)vortex-frame-factory: write on socket request=18 written=18 (proc 2884): (debug)vortex-channel: channel=0 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: more flag or completed flag detected, skipping to the next frame (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 0 . 20480 1020 4' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=16 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=1020, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=0, seqno=21500, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: not updated, already not consumed half of window advertised: 1020 < (4096 / 2) (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: joining frames (previous frame was found).. (proc 2884): (debug)vortex-frame-factory: from='frame-join' allocating a new frame id=17 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=15 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=16 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: passed frame checking stage (proc 2884): (debug)vortex-channel: no waiting queue for this message: 0 (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 7 by second level invocation (frame received) (proc 2884): (debug)vortex-channel: about to invoke the frame received under a newly created handler (proc 2884): (debug)vortex-reader: frame delivered on second (channel) level handler channel (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool processing new job (proc 2884): (debug)vortex-channel: inside the frame received handler (new task) (proc 2884): (debug)vortex-channel: frame received invocation for second level finished (proc 2884): (debug)vortex-channel: invocation frame received handler for channel 3 finished (second level: channel), ref count: channel=6 connection=7 (proc 2884): (debug)vortex-channel: channel=3 unref called, ref count status after calling=5 (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 6 decreased by second level handler (frame received) (proc 2884): (debug)vortex-frame-factory: deallocating frame id=5 (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-channel: frame received invocation for second level finished (proc 2884): (debug)vortex-channel: invocation frame received handler for channel 3 finished (second level: channel), ref count: channel=5 connection=6 (proc 2884): (debug)vortex-channel: channel=3 unref called, ref count status after calling=4 (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 5 decreased by second level handler (frame received) (proc 2884): (debug)vortex-frame-factory: deallocating frame id=11 (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-channel: frame received invocation for second level finished (proc 2884): (debug)vortex-channel: invocation frame received handler for channel 3 finished (second level: channel), ref count: channel=4 connection=5 (proc 2884): (debug)vortex-channel: channel=3 unref called, ref count status after calling=3 (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 4 decreased by second level handler (frame received) (proc 2884): (debug)vortex-frame-factory: deallocating frame id=8 (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-channel: frame received invocation for second level finished (proc 2884): (debug)vortex-channel: invocation frame received handler for channel 3 finished (second level: channel), ref count: channel=3 connection=4 (proc 2884): (debug)vortex-channel: channel=3 unref called, ref count status after calling=2 (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 3 decreased by second level handler (frame received) (proc 2884): (debug)vortex-frame-factory: deallocating frame id=14 (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-channel: frame received invocation for second level finished (proc 2884): (debug)vortex-channel: invocation frame received handler for channel 3 finished (second level: channel), ref count: channel=2 connection=3 (proc 2884): (debug)vortex-channel: channel=3 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 2 decreased by second level handler (frame received) (proc 2884): (debug)vortex-frame-factory: deallocating frame id=17 (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 0 . 21500 1390 5' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=18 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=1390, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=0, seqno=22890, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: updating allowed max seq no to be received from 24575 to 26985 (delta: 2410) (proc 2884): (debug)vortex-reader: notifying remote side that current buffer status is SEQ 3 22890 4096 (proc 2884): (debug)vortex-sequencer: Sending message, size (18) over connection id=2 (proc 2884): (debug)vortex-frame-factory: bytes written: 18 (proc 2884): (debug)vortex-frame-factory: write on socket request=18 written=18 (proc 2884): (debug)vortex-channel: channel=0 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-reader: passed frame checking stage (proc 2884): (debug)vortex-channel: no waiting queue for this message: 0 (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 3 by second level invocation (frame received) (proc 2884): (debug)vortex-channel: about to invoke the frame received under a newly created handler (proc 2884): (debug)vortex-reader: frame delivered on second (channel) level handler channel (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (proc 2884): (debug)vortex-thread-pool: --> thread from pool processing new job (debug)vortex-reader: something to read (proc 2884): (debug)vortex-channel: inside the frame received handler (new task) (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'NUL 3 0 . 22890 0' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=19 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=0, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=1, seqno=22890, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-reader: passed frame checking stage (proc 2884): (debug)vortex-channel: no waiting queue for this message: 0 (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 4 by second level invocation (frame received) (proc 2884): (debug)vortex-channel: about to invoke the frame received under a newly created handler (proc 2884): (debug)vortex-reader: frame delivered on second (channel) level handler channel (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool processing new job (proc 2884): (debug)vortex-channel: inside the frame received handler (new task) (proc 2884): (debug)vortex-channel: frame received invocation for second level finished (proc 2884): (debug)vortex-channel: invocation frame received handler for channel 3 finished (second level: channel), ref count: channel=3 connection=4 (proc 2884): (debug)vortex-channel: channel=3 unref called, ref count status after calling=2 (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 3 decreased by second level handler (frame received) (proc 2884): (debug)vortex-frame-factory: deallocating frame id=19 (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-channel-pool: attempting to release the channel id=3 for pool id=1 connection id=2 (proc 2884): (debug)vortex-connection: locking pool channel.. (proc 2884): (debug)vortex-channel-pool: channel id=3 for pool id=1 connection id=2 was released [releasing] (connection=2 actual pool=1 size: 1 channels [3(R)] (proc 2884): (debug)vortex-connection: unlocking pool channel.. (proc 2884): (debug)vortex-channel: frame received invocation for second level finished (proc 2884): (debug)vortex-channel: invocation frame received handler for channel 3 finished (second level: channel), ref count: channel=2 connection=3 (proc 2884): (debug)vortex-channel: channel=3 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 2 decreased by second level handler (frame received) (proc 2884): (debug)vortex-frame-factory: deallocating frame id=18 (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-channel-pool: getting new channel before locking.. (proc 2884): (debug)vortex-connection: locking pool channel.. (proc 2884): (debug)vortex-channel-pool: getting next channel to use (proc 2884): (debug)vortex-channel-pool: channel id=3 is ready to be used, flagged as busy (proc 2884): (debug)vortex-channel-pool: returning channel id=3 for pool id=1 connection id=2 [get_next_ready] (connection=2 actual pool=1 size: 1 channels [3(B)] (proc 2884): (debug)vortex-connection: unlocking pool channel.. (proc 2884): (debug)vortex-channel: mime headers size calculated for channel 3 was: 0 (proc 2884): (debug)vortex-channel: new message to sent, type=1 channel=3 msgno=1 size (118) = msg size (118) + mime size (0) (proc 2884): (debug)vortex-channel: updating channel sending status to: msgno=1, rpyno=0, seqno=238, ansno=0.. (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-sequencer: a new message to be sequenced.. (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 3 by (vortex sequencer) (proc 2884): (debug)vortex-sequencer: sequence operation: next seq no=120 message size=118 max seq no=4095 step=0 (proc 2884): (debug)vortex-sequencer: the channel is not stalled, continue with sequencing ... (proc 2884): (debug)vortex-sequencer: sequencing next message: type=1, channel num=3, msgno=1, more=0, next seq=120 size=118 ansno=0 (proc 2884): (debug)vortex-sequencer: frame built, send the frame directly (proc 2884): (debug)vortex-sequencer: Sending message, size (142) over connection id=2 (proc 2884): (debug)vortex-frame-factory: bytes written: 142 (proc 2884): (debug)vortex-frame-factory: write on socket request=142 written=142 (proc 2884): (debug)vortex-channel: channel=3 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-sequencer: it seems the message was sent completely (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 2 decreased by (vortex sequencer) (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 1 * 22890 4096 0' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=20 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=4096, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=1, seqno=26986, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: updating allowed max seq no to be received from 26985 to 31081 (delta: 4096) (proc 2884): (debug)vortex-reader: notifying remote side that current buffer status is SEQ 3 26986 4096 (proc 2884): (debug)vortex-sequencer: Sending message, size (18) over connection id=2 (proc 2884): (debug)vortex-frame-factory: bytes written: 18 (proc 2884): (debug)vortex-frame-factory: write on socket request=18 written=18 (proc 2884): (debug)vortex-channel: channel=0 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: more flag or completed flag detected, skipping to the next frame (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 1 . 26986 202 0' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=21 (proc 2884): (debug)vortex-frame-factory: Frame received on channel 3, content type=, transfer encoding=, payload size=202, mime content size=0 (proc 2884): (debug)vortex-reader: passed initial accept stage (proc 2884): (debug)vortex-reader: passed connection existence stage (proc 2884): (debug)vortex-reader: passed message number checking stage (proc 2884): (debug)vortex-channel: setting pending reply processed=0 for channel=3 (proc 2884): (debug)vortex-channel: updating channel receiving status to: msgno=-1, rpyno=1, seqno=27188, ansno=0.. (proc 2884): (debug)vortex-reader: passed channel update status due to frame received stage (proc 2884): (debug)vortex-channel: not updated, already not consumed half of window advertised: 202 < (4096 / 2) (proc 2884): (debug)vortex-reader: getting previous frame for the channel: 3 (proc 2884): (debug)vortex-reader: joining frames (previous frame was found).. (proc 2884): (debug)vortex-frame-factory: from='frame-join' allocating a new frame id=22 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=20 (proc 2884): (debug)vortex-frame-factory: deallocating frame id=21 (proc 2884): (debug)vortex-reader: frame fragmented received, joined with previous frame (proc 2884): (debug)vortex-reader: passed frame checking stage (proc 2884): (debug)vortex-channel: no waiting queue for this message: 1 (proc 2884): (debug)vortex-connection: increased connection id=2 reference to 3 by second level invocation (frame received) (proc 2884): (debug)vortex-channel: about to invoke the frame received under a newly created handler (proc 2884): (debug)vortex-reader: frame delivered on second (channel) level handler channel (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool processing new job (proc 2884): (debug)vortex-channel: inside the frame received handler (new task) (proc 2884): (debug)vortex-channel: frame received invocation for second level finished (proc 2884): (debug)vortex-channel: invocation frame received handler for channel 3 finished (second level: channel), ref count: channel=2 connection=3 (proc 2884): (debug)vortex-channel: channel=3 unref called, ref count status after calling=1 (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 2 decreased by second level handler (frame received) (proc 2884): (debug)vortex-frame-factory: deallocating frame id=22 (proc 2884): (debug)vortex-thread-pool: --> thread from pool waiting for jobs (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'ANS 3 1 * 27188 3894 1' (proc 2884): (debug)vortex-frame-factory: from='get-next' allocating a new frame id=23 (proc 2884): (debug)vortex-frame-factory: (ok message) received a frame fragment (expected: 3899 read: 2888 remaining: 1011), storing into this connection id=2 (proc 2884): (debug)vortex-reader: something to read (proc 2884): (debug)vortex-frame-factory: line read from underlying transport: 'rror: ParsePath(): Empty path!19:10:34.0531 error: ParsePath(): Empty path!19:10:34.0531 error: Pa' (proc 2884): (critical) vortex-frame-factory: no line definition found for frame, over connection id=2, bytes read: 99, line: 'rror: ParsePath(): Empty path!19:10:34.0531 error: ParsePath(): Empty path!19:10:34.0531 error: Pa' , closing session (proc 2884): (debug)vortex-connection: flagging the connection as non-connected (proc 2884): (debug)vortex-connection: closing connection id=2 to 192.168.0.109:44001 (proc 2884): (debug)vortex-connection: closing session id=2 and set to be not connected (proc 2884): (debug)vortex-connection: decreased connection id=2 reference count to 1 decreased by vortex reader (process) (proc 2884): (debug)vortex: shutting down vortex library (proc 2884): (debug)vortex-sequencer: stopping vortex sequencer (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-sequencer: vortex sequencer stopped.. (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-sequencer: vortex sequencer completely stoped (proc 2884): (debug)vortex-reader: stopping vortex reader .. (proc 2884): (debug)vortex-reader: pushing data stop signal.. (proc 2884): (debug)vortex-reader: signal sent reader .. (proc 2884): (debug)vortex-thread: called vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-connection: decreased connection id=1 reference count to 0 decreased by vortex reader (proc 2884): (debug)vortex-connection: freeing connection id=1 (proc 2884): (debug)vortex-connection: freeing connection custom data holder id=1 (proc 2884): (debug)vortex-connection: freeing connection message id=1 (proc 2884): (debug)vortex-connection: freeing connection host id=1 (proc 2884): (debug)vortex-connection: freeing connection port id=1 (proc 2884): (debug)vortex-connection: freeing connection profiles id=1 (proc 2884): (debug)vortex-connection: freeing connection channels id=1 (proc 2884): (debug)vortex-connection: freeing connection channel pools id=1 (proc 2884): (debug)vortex-connection: freeing connection channel mutex id=1 (proc 2884): (debug)vortex-connection: freeing connection reference counting mutex id=1 (proc 2884): (debug)vortex-connection: freeing connection operational mutex id=1 (proc 2884): (debug)vortex-connection: freeing connection channel pools mutex id=1 (proc 2884): (debug)vortex-connection: freeing/terminating connection id=1 (proc 2884): (debug)vortex-connection: session socket closed (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-reader: vortex reader process stopped (proc 2884): (debug)vortex-profiles: stopping vortex profiles module (proc 2884): (debug)vortex: shutting down WinSock2(tm) API (proc 2884): (debug)vortex: shutting down vortex xml subsystem (proc 2884): (debug)vortex: shutting down xml library (proc 2884): (debug)vortex: unlocking vortex listeners (proc 2884): (debug)vortex-listener: (un)Locking listener.. (proc 2884): (debug)vortex: vortex library stopped (proc 2884): (debug)vortex-thread-pool: stopping thread pool.. (proc 2884): (debug)vortex-thread-pool: pushing beacon to stop thread from the pool.. (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool stoping, found finish beacon (proc 2884): (debug)vortex-thread-pool: pushing beacon to stop thread from the pool.. (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool stoping, found finish beacon (proc 2884): (debug)vortex-thread-pool: pushing beacon to stop thread from the pool.. (proc 2884): (debug)vortex-thread-pool: pushing beacon to stop thread from the pool.. (proc 2884): (debug)vortex-thread-pool: pushing beacon to stop thread from the pool.. (proc 2884): (debug)vortex-thread-pool: thread pool is stopped.. (proc 2884): (debug)vortex-frame-factory: deallocating frame id=2 (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool stoping, found finish beacon (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool stoping, found finish beacon (proc 2884): (debug)vortex-thread: finished vortex_cond_wait from vortex_thread.c:802 (proc 2884): (debug)vortex-thread-pool: --> thread from pool stoping, found finish beacon