Feb 17 23:31:15 centaury Test[19038]: (zorp/nosession): GLib-WARNING **: poll(2) failed due to: Interrupted system call. Feb 17 23:31:15 centaury Test[18900]: zorp version 1.4.8 going down. Feb 17 23:31:15 centaury Test[19038]: stderr log thread: thread exiting; Feb 17 23:31:17 centaury Test[27050]: Verbosity level: 8 Feb 17 23:31:17 centaury Test[841]: stderr log thread: thread starting; Feb 17 23:31:17 centaury Test[27050]: zorp version 1.4.8 starting up Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): outbound service=dmz_FTP_inter Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): outbound service=dmz_SSH_inter Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): outbound service=dmz_SMTP_inter Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): outbound service=dmz_HTTP_inter Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): inbound service=test Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): inbound service=inter_FTP_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): inbound service=inter_SMTP_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): inbound service=inter_HTTP_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): inbound service=inter_POP3_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): inbound service=inter_HTTPS_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): inbound service=inter_POP3S_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): inbound service=inter_Auditpont_HTTP_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(dmz): inbound service=inter_HFS_FTP_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): outbound service=test Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): outbound service=inter_FTP_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): outbound service=inter_SMTP_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): outbound service=inter_HTTP_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): outbound service=inter_POP3_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): outbound service=inter_HTTPS_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): outbound service=inter_POP3S_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): outbound service=inter_Auditpont_HTTP_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): outbound service=inter_HFS_FTP_dmz Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): inbound service=dmz_FTP_inter Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): inbound service=dmz_SSH_inter Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): inbound service=dmz_SMTP_inter Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Zone(internet): inbound service=dmz_HTTP_inter Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Listening on address; local='AF_INET(195.70.36.4:20022)' Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service+ep cap_net_admin+p' Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service,cap_net_admin+ep' Feb 17 23:31:17 centaury Test[27050]: (zorp/nosession): Resetting process capabilities; caps='= cap_net_bind_service,cap_net_admin+p' Feb 17 23:38:02 centaury Test[27050]: (zorp/nosession): Incoming connection; remote='AF_INET(148.6.26.163:1572)', fd='9' Feb 17 23:38:02 centaury Test[27050]: (Zorp@Centaury/test): Connection accepted; client_address='AF_INET(148.6.26.163:1572)' Feb 17 23:38:02 centaury Test[27050]: (Zorp@Centaury/test:0): Starting proxy instance; client_fd='9', client_address='AF_INET(148.6.26.163:1572)', client_zone='Zone(internet, 0.0.0.0/0)', client_local='AF_INET(195.70.36.4:20022)' Feb 17 23:38:02 centaury Test[27050]: (Zorp@Centaury/test:0/ftp): Proxy starting; class='Inter_FTP_DMZ', module='ftp' Feb 17 23:38:02 centaury Test[27050]: (zorp/nosession): Module successfully loaded; module='ftp', file='/usr/lib/zorp/libftp.so' Feb 17 23:38:02 centaury Test[27050]: (zorp/nosession): accept count; accepts='1' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): thread starting; Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): calling __config__() event; Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): calling config() event; Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Attribute fetched; attribute='request', value='' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Attribute fetched; attribute='response', value='' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Attribute fetched; attribute='response', value='' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Attribute changed; attribute='permit_unknown_command', newvalue='1' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Attribute changed; attribute='timeout', newvalue='300000' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='max_hostname_length', value='128' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='target_port_range', value=''21'' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='request', value='' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='timeout', value='300000' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='permit_unknown_command', value='1' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='transparent_mode', value='1' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='permit_empty_command', value='1' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='max_line_length', value='255' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='max_username_length', value='32' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='max_password_length', value='64' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='response_strip_msg', value='0' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='response', value='' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config dump, attribute value; name='data_mode', value='0' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Config event done Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): calling __startup__() event; Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): calling startUp() event; Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Startup event done Feb 17 23:38:02 centaury Test[2384]: (zorp/nosession): Connecting to remote host; local='NULL', remote='AF_INET(192.168.1.101:21)' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Server connection established; server_fd='10', server_addr='AF_INET(192.168.1.101:21)', server_zone='Zone(dmz, 192.168.1.101/32)', server_local='AF_INET(192.168.1.100:39216)' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in server side; Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0): server: Reading channel; fd='10', count='45' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Answer fetched; answer='220 ProFTPD 1.2.5rc1 Server (Orion) [orion]' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0): client: Writing channel; fd='9', count='45' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in client side; Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0): client: Reading channel; fd='9', count='12' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Fetched; command='USER proba' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Command fetched. Command=`USER' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0): server: Writing channel; fd='10', count='12' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in server side; Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0): server: Reading channel; fd='10', count='34' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Answer fetched; answer='331 Password required for proba.' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0): client: Writing channel; fd='9', count='34' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in client side; Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0): client: Reading channel; fd='9', count='12' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Fetched; command='PASS proba' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Command fetched. Command=`PASS' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0): server: Writing channel; fd='10', count='12' Feb 17 23:38:02 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in server side; Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0): server: Reading channel; fd='10', count='27' Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Answer fetched; answer='230 User proba logged in.' Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0): client: Writing channel; fd='9', count='27' Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in client side; Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0): client: Reading channel; fd='9', count='5' Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Fetched; command='pwd' Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Command fetched. Command=`pwd' Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0): server: Writing channel; fd='10', count='5' Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in server side; Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0): server: Reading channel; fd='10', count='31' Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Answer fetched; answer='257 "/" is current directory.' Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0): client: Writing channel; fd='9', count='31' Feb 17 23:38:03 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in client side; Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): client: Reading channel; fd='9', count='49' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Fetched; command='SIZE /el-hazard_the_alternative_world-ep_03.mpg' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Command fetched. Command=`SIZE' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): server: Writing channel; fd='10', count='49' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in server side; Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): server: Reading channel; fd='10', count='75' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Answer fetched; answer='550 /el-hazard_the_alternative_world-ep_03.mpg: No such file or directory' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): client: Writing channel; fd='9', count='75' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in client side; Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): client: Reading channel; fd='9', count='8' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Fetched; command='TYPE I' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Command fetched. Command=`TYPE' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): server: Writing channel; fd='10', count='8' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in server side; Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): server: Reading channel; fd='10', count='20' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Answer fetched; answer='200 Type set to I.' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): client: Writing channel; fd='9', count='20' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in client side; Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): client: Reading channel; fd='9', count='6' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Fetched; command='PASV' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Command fetched. Command=`PASV' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): ftp_listen_both_side_start called; Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): server: Writing channel; fd='10', count='6' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in server side; Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): server: Reading channel; fd='10', count='52' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Answer fetched; answer='227 Entering Passive Mode (192,168,1,101,161,231).' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Attribute fetched; attribute='fw_server_data', value='' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Attribute fetched; attribute='server_data', value='' Feb 17 23:38:14 centaury Test[2384]: (zorp/nosession): Connecting to remote host; local='AF_INET(192.168.1.100:0)', remote='AF_INET(192.168.1.101:41447)' Feb 17 23:38:14 centaury Test[2384]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service+ep cap_net_admin+p' Feb 17 23:38:14 centaury Test[2384]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service,cap_net_admin+ep' Feb 17 23:38:14 centaury Test[2384]: (zorp/nosession): SockAddrInetRange, successfully bound; min_port='40000', max_port='41000', port='40919' Feb 17 23:38:14 centaury Test[2384]: (zorp/nosession): Resetting process capabilities; caps='= cap_net_bind_service,cap_net_admin+p' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Attribute changed; attribute='fw_server_data', newvalue='' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Attribute fetched; attribute='fw_client_data', value='' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Attribute fetched; attribute='client_data', value='' Feb 17 23:38:14 centaury Test[2384]: (zorp/nosession): Listening on address; local='AF_INET(195.70.36.4:0)' Feb 17 23:38:14 centaury Test[2384]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service+ep cap_net_admin+p' Feb 17 23:38:14 centaury Test[2384]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service,cap_net_admin+ep' Feb 17 23:38:14 centaury Test[2384]: (zorp/nosession): SockAddrInetRange, successfully bound; min_port='40000', max_port='41000', port='40650' Feb 17 23:38:14 centaury Test[2384]: (zorp/nosession): Resetting process capabilities; caps='= cap_net_bind_service,cap_net_admin+p' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Attribute changed; attribute='fw_client_data', newvalue='' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): client: Writing channel; fd='9', count='49' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in client side; Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): client: Reading channel; fd='9', count='49' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Fetched; command='STOR /el-hazard_the_alternative_world-ep_03.mpg' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Command fetched. Command=`STOR' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): data listener, state 0 Feb 17 23:38:14 centaury Test[27050]: (Zorp@Centaury/test:0/ftp): data listener, connectedCallback Feb 17 23:38:14 centaury Test[27050]: (Zorp@Centaury/test:0/ftp): Attribute fetched; attribute='ftpDataWakeup', value='' Feb 17 23:38:14 centaury Test[27050]: (Zorp@Centaury/test:0/ftp): Server side connected, poll woked up Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): server: Writing channel; fd='10', count='49' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in server side; Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): server: Reading channel; fd='10', count='88' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Answer fetched; answer='150 Opening BINARY mode data connection for /el-hazard_the_alternative_world-ep_03.mpg' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): data listener, state 1 Feb 17 23:38:14 centaury Test[27050]: (zorp/nosession): Incoming connection; remote='AF_INET(148.6.26.163:1573)', fd='15' Feb 17 23:38:14 centaury Test[27050]: (Zorp@Centaury/test:0/ftp): data listener, acceptedCallback Feb 17 23:38:14 centaury Test[27050]: (Zorp@Centaury/test:0/ftp): Attribute fetched; attribute='ftpDataWakeup', value='' Feb 17 23:38:14 centaury Test[27050]: (Zorp@Centaury/test:0/ftp): Client side connected, poll woked up Feb 17 23:38:14 centaury Test[27050]: (zorp/nosession): accept count; accepts='1' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0): client: Writing channel; fd='9', count='88' Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): data listener, state 2 Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): stacking data proxy Feb 17 23:38:14 centaury Test[2384]: (Zorp@Centaury/test:0/plug): Proxy starting; class='FtpDataProxy', module='plug' Feb 17 23:38:14 centaury Test[2384]: (zorp/nosession): Module successfully loaded; module='plug', file='/usr/lib/zorp/libplug.so' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/plug): thread starting; Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/plug): calling __config__() event; Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/plug): calling config() event; Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/plug): Attribute changed; attribute='copy_to_client', newvalue='0' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/plug): Config dump, attribute value; name='packet_stats_interval', value='0' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/plug): Config dump, attribute value; name='copy_to_client', value='0' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/plug): Config dump, attribute value; name='timeout', value='-1' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/plug): Config dump, attribute value; name='copy_to_server', value='1' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/plug): calling __startup__() event; Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/plug): calling startUp() event; Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1460' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1460' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1460' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1460' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1460' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1460' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='812' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='812' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1460' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1460' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 17 23:38:14 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='732' Feb 18 00:27:30 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='336' Feb 18 00:27:30 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:27:30 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:27:30 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:27:30 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:27:30 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:27:30 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:27:30 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:27:30 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:30:39 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in client side; Feb 18 00:30:39 centaury Test[2384]: (Zorp@Centaury/test:0): client: Reading channel; fd='9', count='0' Feb 18 00:30:39 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): ftp_listen_both_side_stop called; Feb 18 00:30:39 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): ftp.poll stopped; wake_who='0' Feb 18 00:30:39 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in server side; Feb 18 00:30:40 centaury Test[27050]: (zorp/nosession): Incoming connection; remote='AF_INET(148.6.26.163:1579)', fd='11' Feb 18 00:30:40 centaury Test[27050]: (Zorp@Centaury/test): Connection accepted; client_address='AF_INET(148.6.26.163:1579)' Feb 18 00:30:40 centaury Test[27050]: (Zorp@Centaury/test:1): Starting proxy instance; client_fd='11', client_address='AF_INET(148.6.26.163:1579)', client_zone='Zone(internet, 0.0.0.0/0)', client_local='AF_INET(195.70.36.4:20022)' Feb 18 00:30:40 centaury Test[27050]: (Zorp@Centaury/test:1/ftp): Proxy starting; class='Inter_FTP_DMZ', module='ftp' Feb 18 00:30:40 centaury Test[27050]: (zorp/nosession): accept count; accepts='1' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): thread starting; Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): calling __config__() event; Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): calling config() event; Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Attribute fetched; attribute='request', value='' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Attribute fetched; attribute='response', value='' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Attribute fetched; attribute='response', value='' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Attribute changed; attribute='permit_unknown_command', newvalue='1' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Attribute changed; attribute='timeout', newvalue='300000' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='max_hostname_length', value='128' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='target_port_range', value=''21'' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='request', value='' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='timeout', value='300000' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='permit_unknown_command', value='1' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='transparent_mode', value='1' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='permit_empty_command', value='1' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='max_line_length', value='255' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='max_username_length', value='32' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='max_password_length', value='64' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='response_strip_msg', value='0' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='response', value='' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config dump, attribute value; name='data_mode', value='0' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Config event done Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): calling __startup__() event; Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): calling startUp() event; Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Startup event done Feb 18 00:30:40 centaury Test[4648]: (zorp/nosession): Connecting to remote host; local='NULL', remote='AF_INET(192.168.1.101:21)' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Server connection established; server_fd='12', server_addr='AF_INET(192.168.1.101:21)', server_zone='Zone(dmz, 192.168.1.101/32)', server_local='AF_INET(192.168.1.100:41872)' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in server side; Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1): server: Reading channel; fd='12', count='45' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Answer fetched; answer='220 ProFTPD 1.2.5rc1 Server (Orion) [orion]' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1): client: Writing channel; fd='11', count='45' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in client side; Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1): client: Reading channel; fd='11', count='12' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Fetched; command='USER proba' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Command fetched. Command=`USER' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1): server: Writing channel; fd='12', count='12' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in server side; Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1): server: Reading channel; fd='12', count='34' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Answer fetched; answer='331 Password required for proba.' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1): client: Writing channel; fd='11', count='34' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in client side; Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1): client: Reading channel; fd='11', count='12' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Fetched; command='PASS proba' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Command fetched. Command=`PASS' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1): server: Writing channel; fd='12', count='12' Feb 18 00:30:40 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in server side; Feb 18 00:30:42 centaury Test[4648]: (Zorp@Centaury/test:1): server: Reading channel; fd='12', count='27' Feb 18 00:30:42 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Answer fetched; answer='230 User proba logged in.' Feb 18 00:30:42 centaury Test[4648]: (Zorp@Centaury/test:1): client: Writing channel; fd='11', count='27' Feb 18 00:30:42 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in client side; Feb 18 00:30:43 centaury Test[4648]: (Zorp@Centaury/test:1): client: Reading channel; fd='11', count='49' Feb 18 00:30:43 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Fetched; command='SIZE /el-hazard_the_alternative_world-ep_03.mpg' Feb 18 00:30:43 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Command fetched. Command=`SIZE' Feb 18 00:30:43 centaury Test[4648]: (Zorp@Centaury/test:1): server: Writing channel; fd='12', count='49' Feb 18 00:30:43 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in server side; Feb 18 00:30:43 centaury Test[4648]: (Zorp@Centaury/test:1): server: Reading channel; fd='12', count='14' Feb 18 00:30:43 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Answer fetched; answer='213 17922636' Feb 18 00:30:43 centaury Test[4648]: (Zorp@Centaury/test:1): client: Writing channel; fd='11', count='14' Feb 18 00:30:43 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in client side; Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): client: Reading channel; fd='11', count='8' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Fetched; command='TYPE I' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Command fetched. Command=`TYPE' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): server: Writing channel; fd='12', count='8' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in server side; Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): server: Reading channel; fd='12', count='20' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Answer fetched; answer='200 Type set to I.' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): client: Writing channel; fd='11', count='20' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in client side; Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): client: Reading channel; fd='11', count='6' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Fetched; command='PASV' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Command fetched. Command=`PASV' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): ftp_listen_both_side_start called; Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): server: Writing channel; fd='12', count='6' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in server side; Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): server: Reading channel; fd='12', count='52' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Answer fetched; answer='227 Entering Passive Mode (192,168,1,101,162,195).' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Attribute fetched; attribute='fw_server_data', value='' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Attribute fetched; attribute='server_data', value='' Feb 18 00:30:59 centaury Test[4648]: (zorp/nosession): Connecting to remote host; local='AF_INET(192.168.1.100:0)', remote='AF_INET(192.168.1.101:41667)' Feb 18 00:30:59 centaury Test[4648]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service+ep cap_net_admin+p' Feb 18 00:30:59 centaury Test[4648]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service,cap_net_admin+ep' Feb 18 00:30:59 centaury Test[4648]: (zorp/nosession): SockAddrInetRange, successfully bound; min_port='40000', max_port='41000', port='40596' Feb 18 00:30:59 centaury Test[4648]: (zorp/nosession): Resetting process capabilities; caps='= cap_net_bind_service,cap_net_admin+p' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Attribute changed; attribute='fw_server_data', newvalue='' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Attribute fetched; attribute='fw_client_data', value='' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Attribute fetched; attribute='client_data', value='' Feb 18 00:30:59 centaury Test[4648]: (zorp/nosession): Listening on address; local='AF_INET(195.70.36.4:0)' Feb 18 00:30:59 centaury Test[4648]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service+ep cap_net_admin+p' Feb 18 00:30:59 centaury Test[4648]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service,cap_net_admin+ep' Feb 18 00:30:59 centaury Test[4648]: (zorp/nosession): SockAddrInetRange, successfully bound; min_port='40000', max_port='41000', port='40785' Feb 18 00:30:59 centaury Test[4648]: (zorp/nosession): Resetting process capabilities; caps='= cap_net_bind_service,cap_net_admin+p' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Attribute changed; attribute='fw_client_data', newvalue='' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): client: Writing channel; fd='11', count='48' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in client side; Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): client: Reading channel; fd='11', count='49' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Fetched; command='APPE /el-hazard_the_alternative_world-ep_03.mpg' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Command fetched. Command=`APPE' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): data listener, state 0 Feb 18 00:30:59 centaury Test[27050]: (Zorp@Centaury/test:1/ftp): data listener, connectedCallback Feb 18 00:30:59 centaury Test[27050]: (Zorp@Centaury/test:1/ftp): Attribute fetched; attribute='ftpDataWakeup', value='' Feb 18 00:30:59 centaury Test[27050]: (Zorp@Centaury/test:1/ftp): Server side connected, poll woked up Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): server: Writing channel; fd='12', count='49' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in server side; Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): server: Reading channel; fd='12', count='90' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Answer fetched; answer='451 /el-hazard_the_alternative_world-ep_03.mpg: Append/Restart not permitted, try again.' Feb 18 00:30:59 centaury Test[4648]: (Zorp@Centaury/test:1): client: Writing channel; fd='11', count='90' Feb 18 00:33:34 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='544' Feb 18 00:33:34 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:34 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:34 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:34 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:34 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:34 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:34 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:34 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:35 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='752' Feb 18 00:33:35 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:35 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:35 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:35 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:35 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:35 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:35 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:35 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='960' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1168' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:36 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='468' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='728' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:37 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='988' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1248' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:38 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='8' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='268' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:39 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='528' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='788' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='1500' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='636' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Writing channel; fd='13', count='636' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Reading channel; fd='15', count='0' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/plug): calling __shutdown__() event; Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/plug): calling shutDown() event; Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/plug): calling __destroy__() event; Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): Attribute fetched; attribute='ftpDataWakeup', value='' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Shutdown channel; fd='15', mode='2' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: Closing channel; fd='15' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Shutdown channel; fd='13', mode='2' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: Closing channel; fd='13' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/plug): Proxy ending; class='FtpDataProxy', module='plug' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data server: accounting info; duration='3326', sent='18022400', received='0' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/ftp): data client: accounting info; duration='3326', sent='0', received='18022400' Feb 18 00:33:40 centaury Test[9749]: (Zorp@Centaury/test:0/plug): thread exiting; Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0): server: Reading channel; fd='10', count='24' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Answer fetched; answer='226 Transfer complete.' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0): client: Writing channel; fd='9', count='24' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Receiving in client side; Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0): client: Reading channel; fd='9', count='0' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): calling __shutdown__() event; Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): calling shutDown() event; Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): calling __destroy__() event; Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Proxy destroy; class='Inter_FTP_DMZ', module='ftp' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0): client: Shutdown channel; fd='9', mode='2' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0): client: Closing channel; fd='9' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0): server: Shutdown channel; fd='10', mode='2' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0): server: Closing channel; fd='10' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Proxy ending; class='Inter_FTP_DMZ', module='ftp' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0): client: accounting info; duration='3339', sent='393', received='141' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0): server: accounting info; duration='3339', sent='141', received='396' Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): Ftp Proxy bye; Feb 18 00:33:41 centaury Test[2384]: (Zorp@Centaury/test:0/ftp): thread exiting; Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in client side; Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1): client: Reading channel; fd='11', count='0' Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): ftp_listen_both_side_stop called; Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): ftp.poll stopped; wake_who='0' Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Receiving in client side; Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1): client: Reading channel; fd='11', count='0' Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): calling __shutdown__() event; Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): calling shutDown() event; Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): calling __destroy__() event; Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Proxy destroy; class='Inter_FTP_DMZ', module='ftp' Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1): client: Shutdown channel; fd='11', mode='2' Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1): client: Closing channel; fd='11' Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1): server: Shutdown channel; fd='12', mode='2' Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1): server: Closing channel; fd='12' Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Proxy ending; class='Inter_FTP_DMZ', module='ftp' Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1): client: accounting info; duration='207', sent='278', received='136' Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1): server: accounting info; duration='207', sent='136', received='282' Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): Ftp Proxy bye; Feb 18 00:34:07 centaury Test[4648]: (Zorp@Centaury/test:1/ftp): thread exiting; Feb 18 00:34:08 centaury Test[27050]: (zorp/nosession): Incoming connection; remote='AF_INET(148.6.26.163:1581)', fd='9' Feb 18 00:34:08 centaury Test[27050]: (Zorp@Centaury/test): Connection accepted; client_address='AF_INET(148.6.26.163:1581)' Feb 18 00:34:08 centaury Test[27050]: (Zorp@Centaury/test:2): Starting proxy instance; client_fd='9', client_address='AF_INET(148.6.26.163:1581)', client_zone='Zone(internet, 0.0.0.0/0)', client_local='AF_INET(195.70.36.4:20022)' Feb 18 00:34:08 centaury Test[27050]: (Zorp@Centaury/test:2/ftp): Proxy starting; class='Inter_FTP_DMZ', module='ftp' Feb 18 00:34:08 centaury Test[27050]: (zorp/nosession): accept count; accepts='1' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): thread starting; Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): calling __config__() event; Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): calling config() event; Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Attribute fetched; attribute='request', value='' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Attribute fetched; attribute='response', value='' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Attribute fetched; attribute='response', value='' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Attribute changed; attribute='permit_unknown_command', newvalue='1' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Attribute changed; attribute='timeout', newvalue='300000' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='max_hostname_length', value='128' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='target_port_range', value=''21'' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='request', value='' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='timeout', value='300000' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='permit_unknown_command', value='1' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='transparent_mode', value='1' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='permit_empty_command', value='1' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='max_line_length', value='255' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='max_username_length', value='32' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='max_password_length', value='64' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='response_strip_msg', value='0' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='response', value='' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config dump, attribute value; name='data_mode', value='0' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Config event done Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): calling __startup__() event; Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): calling startUp() event; Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Startup event done Feb 18 00:34:08 centaury Test[23293]: (zorp/nosession): Connecting to remote host; local='NULL', remote='AF_INET(192.168.1.101:21)' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Server connection established; server_fd='10', server_addr='AF_INET(192.168.1.101:21)', server_zone='Zone(dmz, 192.168.1.101/32)', server_local='AF_INET(192.168.1.100:56282)' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in server side; Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2): server: Reading channel; fd='10', count='45' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Answer fetched; answer='220 ProFTPD 1.2.5rc1 Server (Orion) [orion]' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2): client: Writing channel; fd='9', count='45' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in client side; Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2): client: Reading channel; fd='9', count='12' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Fetched; command='USER proba' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Command fetched. Command=`USER' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2): server: Writing channel; fd='10', count='12' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in server side; Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2): server: Reading channel; fd='10', count='34' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Answer fetched; answer='331 Password required for proba.' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2): client: Writing channel; fd='9', count='34' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in client side; Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2): client: Reading channel; fd='9', count='12' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Fetched; command='PASS proba' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Command fetched. Command=`PASS' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2): server: Writing channel; fd='10', count='12' Feb 18 00:34:08 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in server side; Feb 18 00:34:10 centaury Test[23293]: (Zorp@Centaury/test:2): server: Reading channel; fd='10', count='27' Feb 18 00:34:10 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Answer fetched; answer='230 User proba logged in.' Feb 18 00:34:10 centaury Test[23293]: (Zorp@Centaury/test:2): client: Writing channel; fd='9', count='27' Feb 18 00:34:10 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in client side; Feb 18 00:34:11 centaury Test[23293]: (Zorp@Centaury/test:2): client: Reading channel; fd='9', count='49' Feb 18 00:34:11 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Fetched; command='SIZE /el-hazard_the_alternative_world-ep_03.mpg' Feb 18 00:34:11 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Command fetched. Command=`SIZE' Feb 18 00:34:11 centaury Test[23293]: (Zorp@Centaury/test:2): server: Writing channel; fd='10', count='49' Feb 18 00:34:11 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in server side; Feb 18 00:34:11 centaury Test[23293]: (Zorp@Centaury/test:2): server: Reading channel; fd='10', count='14' Feb 18 00:34:11 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Answer fetched; answer='213 18022400' Feb 18 00:34:11 centaury Test[23293]: (Zorp@Centaury/test:2): client: Writing channel; fd='9', count='14' Feb 18 00:34:11 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in client side; Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): client: Reading channel; fd='9', count='8' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Fetched; command='TYPE I' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Command fetched. Command=`TYPE' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): server: Writing channel; fd='10', count='8' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in server side; Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): server: Reading channel; fd='10', count='20' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Answer fetched; answer='200 Type set to I.' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): client: Writing channel; fd='9', count='20' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in client side; Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): client: Reading channel; fd='9', count='6' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Fetched; command='PASV' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Command fetched. Command=`PASV' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): ftp_listen_both_side_start called; Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): server: Writing channel; fd='10', count='6' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in server side; Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): server: Reading channel; fd='10', count='51' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Answer fetched; answer='227 Entering Passive Mode (192,168,1,101,163,25).' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Attribute fetched; attribute='fw_server_data', value='' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Attribute fetched; attribute='server_data', value='' Feb 18 00:34:26 centaury Test[23293]: (zorp/nosession): Connecting to remote host; local='AF_INET(192.168.1.100:0)', remote='AF_INET(192.168.1.101:41753)' Feb 18 00:34:26 centaury Test[23293]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service+ep cap_net_admin+p' Feb 18 00:34:26 centaury Test[23293]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service,cap_net_admin+ep' Feb 18 00:34:26 centaury Test[23293]: (zorp/nosession): SockAddrInetRange, successfully bound; min_port='40000', max_port='41000', port='40634' Feb 18 00:34:26 centaury Test[23293]: (zorp/nosession): Resetting process capabilities; caps='= cap_net_bind_service,cap_net_admin+p' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Attribute changed; attribute='fw_server_data', newvalue='' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Attribute fetched; attribute='fw_client_data', value='' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Attribute fetched; attribute='client_data', value='' Feb 18 00:34:26 centaury Test[23293]: (zorp/nosession): Listening on address; local='AF_INET(195.70.36.4:0)' Feb 18 00:34:26 centaury Test[23293]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service+ep cap_net_admin+p' Feb 18 00:34:26 centaury Test[23293]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service,cap_net_admin+ep' Feb 18 00:34:26 centaury Test[23293]: (zorp/nosession): SockAddrInetRange, successfully bound; min_port='40000', max_port='41000', port='40028' Feb 18 00:34:26 centaury Test[23293]: (zorp/nosession): Resetting process capabilities; caps='= cap_net_bind_service,cap_net_admin+p' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Attribute changed; attribute='fw_client_data', newvalue='' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): client: Writing channel; fd='9', count='48' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in client side; Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): client: Reading channel; fd='9', count='49' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Fetched; command='APPE /el-hazard_the_alternative_world-ep_03.mpg' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Command fetched. Command=`APPE' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): data listener, state 0 Feb 18 00:34:26 centaury Test[27050]: (Zorp@Centaury/test:2/ftp): data listener, connectedCallback Feb 18 00:34:26 centaury Test[27050]: (Zorp@Centaury/test:2/ftp): Attribute fetched; attribute='ftpDataWakeup', value='' Feb 18 00:34:26 centaury Test[27050]: (Zorp@Centaury/test:2/ftp): Server side connected, poll woked up Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): server: Writing channel; fd='10', count='49' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in server side; Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): server: Reading channel; fd='10', count='90' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Answer fetched; answer='451 /el-hazard_the_alternative_world-ep_03.mpg: Append/Restart not permitted, try again.' Feb 18 00:34:26 centaury Test[23293]: (Zorp@Centaury/test:2): client: Writing channel; fd='9', count='90' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in client side; Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2): client: Reading channel; fd='9', count='0' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): ftp_listen_both_side_stop called; Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): ftp.poll stopped; wake_who='0' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Receiving in client side; Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2): client: Reading channel; fd='9', count='0' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): calling __shutdown__() event; Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): calling shutDown() event; Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): calling __destroy__() event; Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Proxy destroy; class='Inter_FTP_DMZ', module='ftp' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2): client: Shutdown channel; fd='9', mode='2' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2): client: Closing channel; fd='9' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2): server: Shutdown channel; fd='10', mode='2' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2): server: Closing channel; fd='10' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Proxy ending; class='Inter_FTP_DMZ', module='ftp' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2): client: accounting info; duration='207', sent='278', received='136' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2): server: accounting info; duration='207', sent='136', received='281' Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): Ftp Proxy bye; Feb 18 00:37:35 centaury Test[23293]: (Zorp@Centaury/test:2/ftp): thread exiting; Feb 18 00:37:36 centaury Test[27050]: (zorp/nosession): Incoming connection; remote='AF_INET(148.6.26.163:1583)', fd='9' Feb 18 00:37:36 centaury Test[27050]: (Zorp@Centaury/test): Connection accepted; client_address='AF_INET(148.6.26.163:1583)' Feb 18 00:37:36 centaury Test[27050]: (Zorp@Centaury/test:3): Starting proxy instance; client_fd='9', client_address='AF_INET(148.6.26.163:1583)', client_zone='Zone(internet, 0.0.0.0/0)', client_local='AF_INET(195.70.36.4:20022)' Feb 18 00:37:36 centaury Test[27050]: (Zorp@Centaury/test:3/ftp): Proxy starting; class='Inter_FTP_DMZ', module='ftp' Feb 18 00:37:36 centaury Test[27050]: (zorp/nosession): accept count; accepts='1' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): thread starting; Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): calling __config__() event; Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): calling config() event; Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Attribute fetched; attribute='request', value='' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Attribute fetched; attribute='response', value='' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Attribute fetched; attribute='response', value='' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Attribute changed; attribute='permit_unknown_command', newvalue='1' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Attribute changed; attribute='timeout', newvalue='300000' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='max_hostname_length', value='128' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='target_port_range', value=''21'' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='request', value='' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='timeout', value='300000' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='permit_unknown_command', value='1' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='transparent_mode', value='1' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='permit_empty_command', value='1' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='max_line_length', value='255' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='max_username_length', value='32' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='max_password_length', value='64' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='response_strip_msg', value='0' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='response', value='' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config dump, attribute value; name='data_mode', value='0' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Config event done Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): calling __startup__() event; Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): calling startUp() event; Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Startup event done Feb 18 00:37:36 centaury Test[8073]: (zorp/nosession): Connecting to remote host; local='NULL', remote='AF_INET(192.168.1.101:21)' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Server connection established; server_fd='10', server_addr='AF_INET(192.168.1.101:21)', server_zone='Zone(dmz, 192.168.1.101/32)', server_local='AF_INET(192.168.1.100:35708)' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in server side; Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3): server: Reading channel; fd='10', count='45' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Answer fetched; answer='220 ProFTPD 1.2.5rc1 Server (Orion) [orion]' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3): client: Writing channel; fd='9', count='45' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in client side; Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3): client: Reading channel; fd='9', count='12' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Fetched; command='USER proba' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Command fetched. Command=`USER' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3): server: Writing channel; fd='10', count='12' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in server side; Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3): server: Reading channel; fd='10', count='34' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Answer fetched; answer='331 Password required for proba.' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3): client: Writing channel; fd='9', count='34' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in client side; Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3): client: Reading channel; fd='9', count='12' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Fetched; command='PASS proba' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Command fetched. Command=`PASS' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3): server: Writing channel; fd='10', count='12' Feb 18 00:37:36 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in server side; Feb 18 00:37:38 centaury Test[8073]: (Zorp@Centaury/test:3): server: Reading channel; fd='10', count='27' Feb 18 00:37:38 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Answer fetched; answer='230 User proba logged in.' Feb 18 00:37:38 centaury Test[8073]: (Zorp@Centaury/test:3): client: Writing channel; fd='9', count='27' Feb 18 00:37:38 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in client side; Feb 18 00:37:39 centaury Test[8073]: (Zorp@Centaury/test:3): client: Reading channel; fd='9', count='49' Feb 18 00:37:39 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Fetched; command='SIZE /el-hazard_the_alternative_world-ep_03.mpg' Feb 18 00:37:39 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Command fetched. Command=`SIZE' Feb 18 00:37:39 centaury Test[8073]: (Zorp@Centaury/test:3): server: Writing channel; fd='10', count='49' Feb 18 00:37:39 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in server side; Feb 18 00:37:39 centaury Test[8073]: (Zorp@Centaury/test:3): server: Reading channel; fd='10', count='14' Feb 18 00:37:39 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Answer fetched; answer='213 18022400' Feb 18 00:37:39 centaury Test[8073]: (Zorp@Centaury/test:3): client: Writing channel; fd='9', count='14' Feb 18 00:37:39 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in client side; Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): client: Reading channel; fd='9', count='8' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Fetched; command='TYPE I' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Command fetched. Command=`TYPE' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): server: Writing channel; fd='10', count='8' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in server side; Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): server: Reading channel; fd='10', count='20' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Answer fetched; answer='200 Type set to I.' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): client: Writing channel; fd='9', count='20' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in client side; Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): client: Reading channel; fd='9', count='6' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Fetched; command='PASV' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Command fetched. Command=`PASV' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): ftp_listen_both_side_start called; Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): server: Writing channel; fd='10', count='6' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in server side; Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): server: Reading channel; fd='10', count='51' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Answer fetched; answer='227 Entering Passive Mode (192,168,1,101,163,31).' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Attribute fetched; attribute='fw_server_data', value='' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Attribute fetched; attribute='server_data', value='' Feb 18 00:37:55 centaury Test[8073]: (zorp/nosession): Connecting to remote host; local='AF_INET(192.168.1.100:0)', remote='AF_INET(192.168.1.101:41759)' Feb 18 00:37:55 centaury Test[8073]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service+ep cap_net_admin+p' Feb 18 00:37:55 centaury Test[8073]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service,cap_net_admin+ep' Feb 18 00:37:55 centaury Test[8073]: (zorp/nosession): SockAddrInetRange, successfully bound; min_port='40000', max_port='41000', port='40732' Feb 18 00:37:55 centaury Test[8073]: (zorp/nosession): Resetting process capabilities; caps='= cap_net_bind_service,cap_net_admin+p' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Attribute changed; attribute='fw_server_data', newvalue='' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Attribute fetched; attribute='fw_client_data', value='' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Attribute fetched; attribute='client_data', value='' Feb 18 00:37:55 centaury Test[8073]: (zorp/nosession): Listening on address; local='AF_INET(195.70.36.4:0)' Feb 18 00:37:55 centaury Test[8073]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service+ep cap_net_admin+p' Feb 18 00:37:55 centaury Test[8073]: (zorp/nosession): Changing process capabilities; caps='= cap_net_bind_service,cap_net_admin+ep' Feb 18 00:37:55 centaury Test[8073]: (zorp/nosession): SockAddrInetRange, successfully bound; min_port='40000', max_port='41000', port='40308' Feb 18 00:37:55 centaury Test[8073]: (zorp/nosession): Resetting process capabilities; caps='= cap_net_bind_service,cap_net_admin+p' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Attribute changed; attribute='fw_client_data', newvalue='' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): client: Writing channel; fd='9', count='49' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in client side; Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): client: Reading channel; fd='9', count='49' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Fetched; command='APPE /el-hazard_the_alternative_world-ep_03.mpg' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Command fetched. Command=`APPE' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): data listener, state 0 Feb 18 00:37:55 centaury Test[27050]: (Zorp@Centaury/test:3/ftp): data listener, connectedCallback Feb 18 00:37:55 centaury Test[27050]: (Zorp@Centaury/test:3/ftp): Attribute fetched; attribute='ftpDataWakeup', value='' Feb 18 00:37:55 centaury Test[27050]: (Zorp@Centaury/test:3/ftp): Server side connected, poll woked up Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): server: Writing channel; fd='10', count='49' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in server side; Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): server: Reading channel; fd='10', count='90' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Answer fetched; answer='451 /el-hazard_the_alternative_world-ep_03.mpg: Append/Restart not permitted, try again.' Feb 18 00:37:55 centaury Test[8073]: (Zorp@Centaury/test:3): client: Writing channel; fd='9', count='90' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in client side; Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3): client: Reading channel; fd='9', count='0' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): ftp_listen_both_side_stop called; Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): ftp.poll stopped; wake_who='0' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Receiving in client side; Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3): client: Reading channel; fd='9', count='0' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): calling __shutdown__() event; Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): calling shutDown() event; Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): calling __destroy__() event; Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Proxy destroy; class='Inter_FTP_DMZ', module='ftp' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3): client: Shutdown channel; fd='9', mode='2' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3): client: Closing channel; fd='9' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3): server: Shutdown channel; fd='10', mode='2' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3): server: Closing channel; fd='10' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Proxy ending; class='Inter_FTP_DMZ', module='ftp' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3): client: accounting info; duration='172', sent='279', received='136' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3): server: accounting info; duration='172', sent='136', received='281' Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): Ftp Proxy bye; Feb 18 00:40:28 centaury Test[8073]: (Zorp@Centaury/test:3/ftp): thread exiting;