Dear Yutaka, I use DeleGate 9.2.3-pre1 under Windows like a proxy to filter web pages. I made test on localhost, with a small sample (1 CSS and 3 pictures). When I add the option FTOCL=filter.cfi, the page takes time to appear in the browser, specialy when there's many links (pictures, ...). In the filter.cfi I only do text/html replacement. My first analyse let me show that when there's filtering option : - there's many more delegated processes running - the processes between "REQUEST = [http://domain] GET /img.gif HTTP/1.1" and "#HT11 ..." takes long time (300-400ms) - there's errors "### ERROR: select() applied to non-SOCKET handle" on child processes Is it possible to have "shorter time display" : - by a delegate patch ? - by delegate options ? Note that I test CMAP conditional filtering, which can alow to specify filtered / not filtered domains. But the aim is to display as quicker as possible web filtered pages ... Thanks, Xavier PS : The corresponding log ... 06/21 17:30:19.57 [2176] 0+0: ... testing resolver[SYS] with 'WWW.DeleGate.ORG' 06/21 17:30:19.57 [2176] 0+0: ... gethostname(C54158) 06/21 17:30:19.57 [2176] 0+0: configuring default RESOLV ... 06/21 17:30:19.57 [2176] 0+0: ... gethostname()='C54158' 06/21 17:30:19.57 [2176] 0+0: ... SYS: C54158 -> 89.0.20.230 06/21 17:30:19.59 [2176] 0+0: ... DNS: 89.0.20.230 -> c54008 06/21 17:30:19.59 [2176] 0+0: ... DNS available 06/21 17:30:19.59 [2176] 0+0: ... NIS not available (no default domain) 06/21 17:30:19.59 [2176] 0+0: ... export RES_ORDER=CFD 06/21 17:30:19.59 [2176] 0+0: export RESOLV=cache,file,dns (set by default) 06/21 17:30:19.59 [2176] 0+0: --INITIALIZATION START: 9.2.3-pre1 on WindowsNT-- 06/21 17:30:19.59 [2176] 0+0: BINSHELL=/bin/sh (WIN) 30:19.593 [2176] #### send_file (2176,1)[1920,7] -> 2176[1868,0] (0,Err=87) (WIN) 30:19.593 [2176] #### file to be sent fd=1 -> 0 8800000 142606336 06/21 17:30:19.60 [2176] 0+0: DGAuth: ERROR getCkey(), ekeyFd=-1 06/21 17:30:19.60 [2176] 0+0: #### start a service... 06/21 17:30:21.46 [1876] 0+0: ## RES_ORDER=CFD 06/21 17:30:21.48 [1876] 0+0: ... testing resolver[CFD] with 'WWW.DeleGate.ORG' 06/21 17:30:21.50 [1876] 0+0: ... gethostname(C54158) 06/21 17:30:21.51 [1876] 0+0: --INITIALIZATION START: 9.2.3-pre1 on WindowsNT-- 06/21 17:30:21.51 [1876] 0+0: BINSHELL=/bin/sh 06/21 17:30:21.51 [1876] 0+0: server_open(delegate,:8080,listen=20) 06/21 17:30:21.51 [1876] 0+0: server_open(delegate,:8080) BOUND 06/21 17:30:21.51 [1876] 0+0: DGROOT=C:\delegate^M 06/21 17:30:21.51 [1876] 0+0: <DeleGate/9.2.3-pre1> [1876] -P8080 READY^M 06/21 17:30:21.51 [1876] 0+0: PORT= 8080/11 (31,144) 06/21 17:30:21.51 [1876] 0+0: OWNER=nobody => OWNER=?/?(?/?) 06/21 17:30:21.53 [1876] 0+0: default netmask 89.0.20.230/. = FFFFFF00 06/21 17:30:21.53 [1876] 0+0: REMITTABLE = http,https/ {80,443},gopher,ftp,wais 06/21 17:30:21.53 [1876] 0+0: LIBPATH: test.cfi -> C:\delegate/etc\test.cfi 06/21 17:30:21.53 [1876] 0+0: --- [z] 0 z 06/21 17:30:21.53 [1876] 0+0: ## cannot load z 06/21 17:30:21.54 [1876] 0+0: #### gzip nor gunzip not found in LIBPATH 06/21 17:30:21.54 [1876] 0+0: ADMIN=delegate-admin@xxx..fr protocol=http (specialist) 06/21 17:30:21.54 [1876] 0+0: WORKDIR=C:\delegate/work/8080 06/21 17:30:21.54 [1876] 0+0: MOUNT[0]X[3] /-/builtin/mssgs/302-moved.dhtml http://localhost/cms_fe/index.php?service=proxyerror&errnb=302 06/21 17:30:21.54 [1876] 0+0: MOUNT[1]X[4] /-/builtin/mssgs/305- userproxy.dhtml http://localhost/cms_fe/index.php? service=proxyerror&errnb=305 06/21 17:30:21.54 [1876] 0+0: MOUNT[2]X[5] /-/builtin/mssgs/401-unauth.dhtml http://localhost/cms_fe/index.php?service=proxyerror&errnb=401 06/21 17:30:21.54 [1876] 0+0: MOUNT[3]X[6] /-/builtin/mssgs/403- forbidden.dhtml http://localhost/cms_fe/index.php? service=proxyerror&errnb=403 06/21 17:30:21.54 [1876] 0+0: MOUNT[4]X[7] /-/builtin/mssgs/404- notfound.dhtml http://localhost/cms_fe/index.php? service=proxyerror&errnb=404 06/21 17:30:21.54 [1876] 0+0: MOUNT[5]X[8] /-/builtin/mssgs/407- unauthproxy.dhtml http://localhost/cms_fe/index.php? service=proxyerror&errnb=407 06/21 17:30:21.54 [1876] 0+0: MOUNT[6]X[9] /-/builtin/mssgs/426- upgrade.dhtml http://localhost/cms_fe/index.php?service=proxyerror&errnb=426 06/21 17:30:21.54 [1876] 0+0: MOUNT[7]X[10] /-/builtin/mssgs/502- cantconnect.dhtml http://localhost/cms_fe/index.php? service=proxyerror&errnb=502 06/21 17:30:21.54 [1876] 0+0: MOUNT[8]X[11] /-/builtin/mssgs/502- offline.dhtml http://localhost/cms_fe/index.php?service=proxyerror&errnb=502 06/21 17:30:21.54 [1876] 0+0: MOUNT[9]X[12] /-/builtin/icons/* = default 06/21 17:30:21.54 [1876] 0+0: MOUNT[10]X[13] /-/* = forbidden,from=!.RELIABLE,default 06/21 17:30:21.54 [1876] 0+0: MOUNT[11]X[0] /-* = default 06/21 17:30:21.54 [1876] 0+0: MOUNT[12]X[1] /=* = default 06/21 17:30:21.54 [1876] 0+0: MOUNT[13]X[2] http://https.* https://* FSV=sslway 06/21 17:30:21.54 [1876] 0+0: MOUNT[14]=[14] /favicon.ico builtin:icons/ysato/default.ico default,direction=fo,onerror=404,expires=15m 06/21 17:30:21.54 [1876] 0+0: ## MOUNT vURL* [http://https.*] rem=1 nc=2 06/21 17:30:21.54 [1876] 0+0: ## MOUNT FULL-URL-SRC [http]://[https.:80]/[] 06/21 17:30:21.54 [1876] 0+0: #### stack size limit = FFFFFFFF (-1) 06/21 17:30:21.54 [1876] 0+0: Stay open PIDFILE for accept() lock[fd=15] 06/21 17:30:21.54 [1876] 0+0: env[25] LIBPATH=.;C:\WINDOWS\system32;C:\delegate/lib;C:\delegate;C:\delegate/etc 06/21 17:30:21.54 [1876] 0+0: ext[0] SERVER=http 06/21 17:30:21.54 [1876] 0+0: ext[1] ADMIN=delegate-admin@xxx..fr 06/21 17:30:21.54 [1876] 0+0: ext[2] PROXY=89.0.15.2:8080:!*localhost* 06/21 17:30:21.54 [1876] 0+0: ext[3] FTOCL=test.cfi 06/21 17:30:21.54 [1876] 0+0: ext[4] MOUNT=http://https.* https://* FSV=sslway 06/21 17:30:21.54 [1876] 0+0: ext[5] DELAY=reject:0 06/21 17:30:21.54 [1876] 0+0: ext[6] CACHE=no 06/21 17:30:21.54 [1876] 0+0: ext[7] PERMIT=*:*localhost*:* 06/21 17:30:21.54 [1876] 0+0: ext[8] PERMIT=*:*eprocedures*:* 06/21 17:30:21.54 [1876] 0+0: ext[9] PERMIT=*:*google*:* 06/21 17:30:21.54 [1876] 0+0: ext[10] PERMIT=*:*valdoise*:* 06/21 17:30:21.54 [1876] 0+0: ext[11] MOUNT=/-/builtin/mssgs/302-moved.dhtml http://localhost/cms_fe/index.php?service=proxyerror&errnb=302 06/21 17:30:21.54 [1876] 0+0: ext[12] MOUNT=/-/builtin/mssgs/305- userproxy.dhtml http://localhost/cms_fe/index.php? service=proxyerror&errnb=305 06/21 17:30:21.54 [1876] 0+0: ext[13] MOUNT=/-/builtin/mssgs/401- unauth.dhtml http://localhost/cms_fe/index.php?service=proxyerror&errnb=401 06/21 17:30:21.54 [1876] 0+0: ext[14] MOUNT=/-/builtin/mssgs/403- forbidden.dhtml http://localhost/cms_fe/index.php? service=proxyerror&errnb=403 06/21 17:30:21.54 [1876] 0+0: ext[15] MOUNT=/-/builtin/mssgs/404- notfound.dhtml http://localhost/cms_fe/index.php?service=proxyerror&errnb=404 06/21 17:30:21.54 [1876] 0+0: ext[16] MOUNT=/-/builtin/mssgs/407- unauthproxy.dhtml http://localhost/cms_fe/index.php? service=proxyerror&errnb=407 06/21 17:30:21.54 [1876] 0+0: ext[17] MOUNT=/-/builtin/mssgs/426- upgrade.dhtml http://localhost/cms_fe/index.php?service=proxyerror&errnb=426 06/21 17:30:21.54 [1876] 0+0: ext[18] MOUNT=/-/builtin/mssgs/502- cantconnect.dhtml http://localhost/cms_fe/index.php? service=proxyerror&errnb=502 06/21 17:30:21.54 [1876] 0+0: ext[19] MOUNT=/-/builtin/mssgs/502- offline.dhtml http://localhost/cms_fe/index.php?service=proxyerror&errnb=502 06/21 17:30:21.54 [1876] 0+0: arg[1] LIBPATH=.;C:\delegate;C:\delegate/lib;.;C:\delegate/etc 06/21 17:30:21.54 [1876] 0+0: arg[2] RESOLV=cache,file,dns 06/21 17:30:21.54 [1876] 0+0: arg[3] DGROOT=C:\delegate 06/21 17:30:21.54 [1876] 0+0: arg[10] ADMIN=delegate-admin@xxx..fr 06/21 17:30:21.56 [1876] 0+0: DELEGATE_Modified[0]: 44994a1d 1150896669 06/21 17:30:21.56 [1876] 0+0: --INITIALIZATION DONE: 9.2.3-pre1 on WindowsNT- - (WIN) 30:21.562 [1876] setNonblockingSocket(20,1)=0 (WIN) 30:29.359 [1876] spawn() = 376 [2456], children(alive=1,total=1) 0.063s 06/21 17:30:29.37 [2456] 1+0: Stay open PIDFILE for accept() lock[fd=25] 06/21 17:30:29.39 [2456] 1+1: default netmask 89.0.20.230/. = FFFFFF00 06/21 17:30:29.40 [2456] 1+1: (0) accepted [5] -@[127.0.0.1]localhost:3828 (0.047s)(1) 06/21 17:30:29.40 [2456] 1+1: IGNORE request: Keep-Alive: 300^M 06/21 17:30:29.40 [2456] 1+1: Proxy: host=localhost; User-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; fr-FR; rv:1.7.10) Gecko/20050717 Firefox/1.0.6; DIRECT 06/21 17:30:29.40 [2456] 1+1: HCKA:[0] keep-alive; host=localhost; (User- Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; fr-FR; rv:1.7.10) Gecko/20050717 Firefox/1.0.6) 06/21 17:30:29.40 [2456] 1+1: REQUEST - GET http://localhost/test.html HTTP/1.1^M 06/21 17:30:29.40 [2456] 1+1: PATH> http://localhost:80!localhost:8080! localhost:3828!anonymous@localhost;1150903829 06/21 17:30:29.40 [2456] 1+1: REQUEST = [http://localhost:80/] GET /test.html HTTP/1.1^M (WIN) 30:29.453 [2456] spawn() = 1828 [3776], children(alive=1,total=1) 0.047s 06/21 17:30:29.45 [2456] 1+1: ## wait the filter finish reading enviroment 06/21 17:30:29.45 [3776] 0+0: #### clearConnPTR: clearing D_REQUEST 06/21 17:30:29.45 [3776] 0+0: simple_relayf [29 -> 31] = 0 06/21 17:30:29.56 [2456] 1+1: #### pre-filter inserted: 1828 (WIN) 30:29.593 [2456] spawn() = 1844 [3688], children(alive=2,total=2) 0.031s 06/21 17:30:29.60 [2456] 1+1: ## wait the filter finish reading enviroment 06/21 17:30:29.60 [3688] 0+0: #### clearConnPTR: clearing D_REQUEST 06/21 17:30:29.60 [3688] 0+0: #### execFilter[FTOCL] CFI 06/21 17:30:29.60 [3688] 0+0: ## CFI/http ## 06/21 17:30:29.71 [2456] 1+1: connectTO: assume in non-blocking mode (WIN) 30:29.718 [2456] setNonblockingSocket(29,1)=0 (WIN) 30:29.718 [2456] setNonblockingSocket(29,0)=0 06/21 17:30:29.71 [2456] 1+1: ConnectToServer connected [29] {127.0.0.1:80 <- 127.0.0.1:3835} [0.000s] 06/21 17:30:29.71 [2456] 1+1: willSTLS_SV: ServerFlags=10 06/21 17:30:29.71 [2456] 1+1: HTTP => (localhost:80) GET /test.html HTTP/1.1^M 06/21 17:30:29.71 [2456] 1+1: #HT11 SERVER ver[HTTP/1.1] conn[] 06/21 17:30:29.71 [2456] 1+1: #HT11 server KEEP-ALIVE 06/21 17:30:29.71 [2456] 1+1: HTTP/1.1 200 Content-{Type:text/html Encoding: [/] Leng:341} Server:Apache/1.3.33 (Win32) PHP/5.0.3 06/21 17:30:29.71 [2456] 1+1: Content-Length: 341 -> 341 (618 - 277) 06/21 17:30:29.71 [2456] 1+1: HTTP transmitted: 235head+341/341body=>0txt+0bin->341/341, 9i/2o/0f/0.0 06/21 17:30:29.71 [2456] 1+1: #HT11 putServ(30/32) localhost:80 06/21 17:30:29.71 [2456] 1+1: HCKA:[0] closed -- x:external filter 06/21 17:30:29.71 [3688] 0+0: systemFilter[29,0]: C:\delegate\ssed\ssed -e s/fai.fr/titi/g 06/21 17:30:29.71 [2456] 1+1: disconnected [5] -@[127.0.0.1]localhost:3828 (0.359s)(0) 06/21 17:30:29.81 [3688] 0+0: systemFilter[0,4]: C:\delegate\ssed\ssed -e s/teleprocedures/toto/g 06/21 17:30:29.89 [3688] 0+0: Content-Length: 341 -> 341 (671 - 330) (WIN) 30:29.890 [3776] select() = -1 [errno=(22 / 10038)] (WIN) 30:29.890 [3776] #### ERROR: select() applied to non-SOCKET handle (WIN) 30:29.937 [2456] wait3(N) = 1844 [3688] 0, children(alive=1,total=2) 0.00s 06/21 17:30:29.93 [2456] 1+1: CFI process [1844] done (1/2 AFT-2) (WIN) 30:29.968 [1876] spawn() = 440 [3556], children(alive=2,total=2) 0.031s 06/21 17:30:30.00 [3556] 2+0: Stay open PIDFILE for accept() lock[fd=24] 06/21 17:30:30.03 [3556] 2+1: default netmask 89.0.20.230/. = FFFFFF00 (WIN) 30:30.062 [1876] spawn() = 424 [4056], children(alive=3,total=3) 0.078s 06/21 17:30:30.07 [3556] 2+1: (1) accepted [5] -@[127.0.0.1]localhost:3836 (0.094s)(1) 06/21 17:30:30.09 [3776] 0+0: simple_relay [29 -> 31] = (671 -> 671) / 1 06/21 17:30:30.09 [3556] 2+1: IGNORE request: Keep-Alive: 300^M 06/21 17:30:30.09 [3556] 2+1: Proxy: host=localhost; User-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; fr-FR; rv:1.7.10) Gecko/20050717 Firefox/1.0.6; DIRECT 06/21 17:30:30.09 [3556] 2+1: HCKA:[0] keep-alive; host=localhost; (User- Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; fr-FR; rv:1.7.10) Gecko/20050717 Firefox/1.0.6) 06/21 17:30:30.09 [3556] 2+1: REQUEST - GET http://localhost/veuillezpatienter.gif HTTP/1.1^M 06/21 17:30:30.09 [3556] 2+1: PATH> http://localhost:80!localhost:8080! localhost:3836!anonymous@localhost;1150903830 06/21 17:30:30.09 [3556] 2+1: REQUEST = [http://localhost:80/] GET /veuillezpatienter.gif HTTP/1.1^M 06/21 17:30:30.10 [4056] 3+0: Stay open PIDFILE for accept() lock[fd=25] (WIN) 30:30.140 [2456] wait3(N) = 1828 [3776] 0, children(alive=0,total=2) 0.00s 06/21 17:30:30.14 [2456] 1+1: CFI process [1828] done (2/2 AFT-4) 06/21 17:30:30.14 [4056] 3+1: default netmask 89.0.20.230/. = FFFFFF00 (WIN) 30:30.203 [1876] spawn() = 508 [3676], children(alive=4,total=4) 0.141s (WIN) 30:30.203 [1876] spawn() = 508 [4]0.125[8]0.016 (WIN) 30:30.250 [3556] spawn() = 1828 [3244], children(alive=1,total=1) 0.141s (WIN) 30:30.250 [3556] spawn() = 1828 [4]0.125[8]0.016 06/21 17:30:30.25 [3676] 4+0: Stay open PIDFILE for accept() lock[fd=24] 06/21 17:30:30.28 [3676] 4+1: default netmask 89.0.20.230/. = FFFFFF00 06/21 17:30:30.28 [3244] 0+0: #### clearConnPTR: clearing D_REQUEST 06/21 17:30:30.28 [3244] 0+0: simple_relayf [28 -> 30] = 0 06/21 17:30:30.28 [3556] 2+1: #### pre-filter inserted: 1828 06/21 17:30:30.29 [4056] 3+1: (2) accepted [5] -@[127.0.0.1]localhost:3837 (0.218s)(2) 06/21 17:30:30.31 [4056] 3+1: IGNORE request: Keep-Alive: 300^M 06/21 17:30:30.31 [4056] 3+1: Proxy: host=localhost; User-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; fr-FR; rv:1.7.10) Gecko/20050717 Firefox/1.0.6; DIRECT 06/21 17:30:30.31 [4056] 3+1: HCKA:[0] keep-alive; host=localhost; (User- Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; fr-FR; rv:1.7.10) Gecko/20050717 Firefox/1.0.6) 06/21 17:30:30.31 [4056] 3+1: REQUEST - GET http://localhost/Sablier_anime.gif HTTP/1.1^M 06/21 17:30:30.31 [4056] 3+1: PATH> http://localhost:80!localhost:8080! localhost:3837!anonymous@localhost;1150903830 06/21 17:30:30.31 [4056] 3+1: REQUEST = [http://localhost:80/] GET /Sablier_anime.gif HTTP/1.1^M (WIN) 30:30.390 [3556] spawn() = 1844 [3324], children(alive=2,total=2) 0.109s (WIN) 30:30.390 [3556] spawn() = 1844 [2]0.015[4]0.094 06/21 17:30:30.39 [3676] 4+1: (3) accepted [5] -@[127.0.0.1]localhost:3838 (0.156s)(3) (WIN) 30:30.406 [4056] spawn() = 1828 [3148], children(alive=1,total=1) 0.094s 06/21 17:30:30.40 [3676] 4+1: IGNORE request: Keep-Alive: 300^M 06/21 17:30:30.40 [3676] 4+1: Proxy: host=localhost; User-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; fr-FR; rv:1.7.10) Gecko/20050717 Firefox/1.0.6; DIRECT 06/21 17:30:30.40 [3676] 4+1: HCKA:[0] keep-alive; host=localhost; (User- Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; fr-FR; rv:1.7.10) Gecko/20050717 Firefox/1.0.6) 06/21 17:30:30.40 [3676] 4+1: REQUEST - GET http://localhost/fond.jpg HTTP/1.1^M 06/21 17:30:30.40 [3676] 4+1: PATH> http://localhost:80!localhost:8080! localhost:3838!anonymous@localhost;1150903830 06/21 17:30:30.40 [3676] 4+1: REQUEST = [http://localhost:80/] GET /fond.jpg HTTP/1.1^M 06/21 17:30:30.42 [3556] 2+1: ## wait the filter finish reading enviroment 06/21 17:30:30.42 [3324] 0+0: #### clearConnPTR: clearing D_REQUEST 06/21 17:30:30.42 [3324] 0+0: #### execFilter[FTOCL] CFI 06/21 17:30:30.42 [3324] 0+0: ## CFI/http ## 06/21 17:30:30.43 [4056] 3+1: ## wait the filter finish reading enviroment 06/21 17:30:30.43 [3148] 0+0: #### clearConnPTR: clearing D_REQUEST 06/21 17:30:30.43 [3148] 0+0: simple_relayf [29 -> 31] = 0 (WIN) 30:30.468 [3676] spawn() = 1828 [2916], children(alive=1,total=1) 0.062s 06/21 17:30:30.46 [3676] 4+1: ## wait the filter finish reading enviroment 06/21 17:30:30.46 [2916] 0+0: #### clearConnPTR: clearing D_REQUEST 06/21 17:30:30.46 [2916] 0+0: simple_relayf [28 -> 30] = 0 06/21 17:30:30.53 [3556] 2+1: connectTO: assume in non-blocking mode (WIN) 30:30.531 [3556] setNonblockingSocket(28,1)=0 (WIN) 30:30.531 [3556] setNonblockingSocket(28,0)=0 06/21 17:30:30.53 [3556] 2+1: ConnectToServer connected [28] {127.0.0.1:80 <- 127.0.0.1:3853} [0.000s] 06/21 17:30:30.53 [3556] 2+1: willSTLS_SV: ServerFlags=10 06/21 17:30:30.53 [3556] 2+1: HTTP => (localhost:80) GET /veuillezpatienter.gif HTTP/1.1^M 06/21 17:30:30.53 [3556] 2+1: #HT11 SERVER ver[HTTP/1.1] conn[] 06/21 17:30:30.53 [3556] 2+1: #HT11 server KEEP-ALIVE 06/21 17:30:30.53 [3556] 2+1: HTTP/1.1 200 Content-{Type:image/gif Encoding: [/] Leng:1774} Server:Apache/1.3.33 (Win32) PHP/5.0.3 06/21 17:30:30.53 [3556] 2+1: detach respBuff: non-text data, non keep-alive 06/21 17:30:30.53 [3556] 2+1: HTTP transmitted: 236head+1774/1774body=>0txt+0bin->1774/1774, 9i/2o/0f/0.0 06/21 17:30:30.53 [3324] 0+0: simple_relayf [28 -> 29] = 0 (WIN) 30:30.531 [3324] select() = -1 [errno=(9 / 10038)] (WIN) 30:30.531 [3324] #### ERROR: select() applied to non-SOCKET handle 06/21 17:30:30.54 [3556] 2+1: #HT11 putServ(29/31) localhost:80 06/21 17:30:30.54 [3556] 2+1: HCKA:[0] closed -- x:external filter 06/21 17:30:30.54 [4056] 3+1: #### pre-filter inserted: 1828 06/21 17:30:30.54 [3556] 2+1: disconnected [5] -@[127.0.0.1]localhost:3836 (0.562s)(2) 06/21 17:30:30.57 [3676] 4+1: #### pre-filter inserted: 1828 (WIN) 30:30.593 [4056] spawn() = 1844 [3708], children(alive=2,total=2) 0.047s 06/21 17:30:30.64 [3708] 0+0: #### clearConnPTR: clearing D_REQUEST 06/21 17:30:30.64 [3708] 0+0: #### execFilter[FTOCL] CFI 06/21 17:30:30.64 [3708] 0+0: ## CFI/http ## 06/21 17:30:30.64 [4056] 3+1: connectTO: assume in non-blocking mode (WIN) 30:30.640 [4056] setNonblockingSocket(29,1)=0 (WIN) 30:30.640 [4056] setNonblockingSocket(29,0)=0 06/21 17:30:30.64 [4056] 3+1: ConnectToServer connected [29] {127.0.0.1:80 <- 127.0.0.1:3857} [0.000s] 06/21 17:30:30.64 [4056] 3+1: willSTLS_SV: ServerFlags=10 06/21 17:30:30.64 [4056] 3+1: HTTP => (localhost:80) GET /Sablier_anime.gif HTTP/1.1^M 06/21 17:30:30.64 [4056] 3+1: #HT11 SERVER ver[HTTP/1.1] conn[] 06/21 17:30:30.64 [4056] 3+1: #HT11 server KEEP-ALIVE 06/21 17:30:30.64 [4056] 3+1: HTTP/1.1 200 Content-{Type:image/gif Encoding: [/] Leng:9924} Server:Apache/1.3.33 (Win32) PHP/5.0.3 06/21 17:30:30.64 [4056] 3+1: detach respBuff: non-text data, non keep-alive 06/21 17:30:30.65 [3708] 0+0: simple_relayf [29 -> 30] = 0 06/21 17:30:30.65 [4056] 3+1: HTTP transmitted: 237head+9924/9924body=>0txt+0bin->9924/9924, 10i/3o/0f/0.0 (WIN) 30:30.656 [3676] spawn() = 1844 [2928], children(alive=2,total=2) 0.078s (WIN) 30:30.656 [3708] select() = -1 [errno=(9 / 10038)] (WIN) 30:30.656 [3708] #### ERROR: select() applied to non-SOCKET handle 06/21 17:30:30.65 [4056] 3+1: #HT11 putServ(30/32) localhost:80 06/21 17:30:30.65 [4056] 3+1: HCKA:[0] closed -- x:external filter 06/21 17:30:30.65 [4056] 3+1: disconnected [5] -@[127.0.0.1]localhost:3837 (0.578s)(1) 06/21 17:30:30.67 [2928] 0+0: #### clearConnPTR: clearing D_REQUEST 06/21 17:30:30.67 [2928] 0+0: #### execFilter[FTOCL] CFI 06/21 17:30:30.67 [2928] 0+0: ## CFI/http ## 06/21 17:30:30.67 [3676] 4+1: connectTO: assume in non-blocking mode (WIN) 30:30.671 [3676] setNonblockingSocket(28,1)=0 (WIN) 30:30.671 [3676] setNonblockingSocket(28,0)=0 06/21 17:30:30.67 [3676] 4+1: ConnectToServer connected [28] {127.0.0.1:80 <- 127.0.0.1:3859} [0.000s] 06/21 17:30:30.67 [3676] 4+1: willSTLS_SV: ServerFlags=10 06/21 17:30:30.67 [3676] 4+1: HTTP => (localhost:80) GET /fond.jpg HTTP/1.1^M 06/21 17:30:30.68 [3676] 4+1: #HT11 SERVER ver[HTTP/1.1] conn[] 06/21 17:30:30.68 [3676] 4+1: #HT11 server KEEP-ALIVE 06/21 17:30:30.68 [3676] 4+1: HTTP/1.1 200 Content-{Type:image/jpeg Encoding: [/] Leng:55825} Server:Apache/1.3.33 (Win32) PHP/5.0.3 06/21 17:30:30.68 [3676] 4+1: detach respBuff: non-text data, non keep-alive 06/21 17:30:30.68 [2928] 0+0: simple_relayf [28 -> 29] = 0 06/21 17:30:30.71 [3676] 4+1: HTTP transmitted: 239head+00000/0000fbody=>0txt+0bin->55825/55825, 13i/6o/0f/0.0 06/21 17:30:30.73 [3676] 4+1: #HT11 putServ(29/31) localhost:80 06/21 17:30:30.73 [3676] 4+1: HCKA:[0] closed -- x:external filter (WIN) 30:30.750 [2928] select() = -1 [errno=(9 / 10038)] (WIN) 30:30.750 [2928] #### ERROR: select() applied to non-SOCKET handle 06/21 17:30:30.78 [1876] 4+0: AcceptByMain: locked out*1/0 by Sticky*4 0/0 06/21 17:30:30.79 [3676] 4+1: disconnected [5] -@[127.0.0.1]localhost:3838 (0.562s)(0) 06/21 17:30:30.79 [3324] 0+0: simple_relay [28 -> 29] = (1774 -> 1774) / 1 (WIN) 30:30.796 [3556] wait3(N) = 1844 [3324] 0, children(alive=1,total=2) 0.00s 06/21 17:30:30.79 [3556] 2+1: CFI process [1844] done (1/2 AFT-2) (WIN) 30:30.796 [3244] select() = -1 [errno=(22 / 10038)] (WIN) 30:30.796 [3244] #### ERROR: select() applied to non-SOCKET handle 06/21 17:30:30.79 [2456] 1+2: (0) accepted [41] -@[127.0.0.1]localhost:3860 (0.000s)(1) 06/21 17:30:30.81 [2456] 1+2: IGNORE request: Keep-Alive: 300^M 06/21 17:30:30.81 [2456] 1+2: Proxy: host=localhost; User-Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; fr-FR; rv:1.7.10) Gecko/20050717 Firefox/1.0.6; DIRECT 06/21 17:30:30.81 [2456] 1+2: HCKA:[0] keep-alive; host=localhost; (User- Agent: Mozilla/5.0 (Windows; U; Windows NT 5.1; fr-FR; rv:1.7.10) Gecko/20050717 Firefox/1.0.6) 06/21 17:30:30.81 [2456] 1+2: REQUEST - GET http://localhost/favicon.ico HTTP/1.1^M 06/21 17:30:30.81 [2456] 1+2: PATH> http://localhost:80!localhost:8080! localhost:3860!anonymous@localhost;1150903830 06/21 17:30:30.81 [2456] 1+2: REQUEST = [http://localhost:80/] GET /favicon.ico HTTP/1.1^M (WIN) 30:30.843 [2456] spawn() = 336 [2528], children(alive=1,total=3) 0.031s 06/21 17:30:30.85 [3708] 0+0: simple_relay [29 -> 30] = (9924 -> 9924) / 2 (WIN) 30:30.859 [3148] select() = -1 [errno=(22 / 10038)] (WIN) 30:30.859 [3148] #### ERROR: select() applied to non-SOCKET handle 06/21 17:30:30.85 [2528] 0+0: #### clearConnPTR: clearing D_REQUEST 06/21 17:30:30.85 [2528] 0+0: simple_relayf [25 -> 31] = 0 06/21 17:30:30.85 [2456] 1+2: #### pre-filter inserted: 336 (WIN) 30:30.890 [4056] wait3(N) = 1844 [3708] 0, children(alive=1,total=2) 0.00s 06/21 17:30:30.89 [4056] 3+1: CFI process [1844] done (1/2 AFT-2) (WIN) 30:30.906 [2456] spawn() = 1976 [1980], children(alive=2,total=4) 0.047s 06/21 17:30:30.90 [1980] 0+0: #### clearConnPTR: clearing D_REQUEST 06/21 17:30:30.90 [1980] 0+0: #### execFilter[FTOCL] CFI 06/21 17:30:30.90 [1980] 0+0: ## CFI/http ## 06/21 17:30:30.90 [2456] 1+2/0/1: #HT11 getServ 1.19s*1 SERVER REUSE (30/32) [localhost:80] localhost 06/21 17:30:30.92 [2456] 1+2/0/1: #HT11 SERVER ver[HTTP/1.1] conn[] 06/21 17:30:30.92 [2456] 1+2/0/1: #HT11 server KEEP-ALIVE 06/21 17:30:30.92 [2456] 1+2/0/1: HTTP/1.1 200 Content-{Type:image/x-icon Encoding:[/] Leng:797} Server:Apache/1.3.33 (Win32) PHP/5.0.3 06/21 17:30:30.92 [2456] 1+2/0/1: detach respBuff: non-text data, non keep- alive 06/21 17:30:30.92 [2456] 1+2/0/1: HTTP transmitted: 238head+797/797body=>0txt+0bin->797/797, 9i/2o/0f/0.0 06/21 17:30:30.92 [1980] 0+0: simple_relayf [25 -> 29] = 0 (WIN) 30:30.921 [1980] select() = -1 [errno=(9 / 10038)] (WIN) 30:30.921 [1980] #### ERROR: select() applied to non-SOCKET handle 06/21 17:30:30.92 [2456] 1+2/0/1: #HT11 putServ(25/29) localhost:80 06/21 17:30:30.92 [2456] 1+2/0/1: HCKA:[0] closed -- x:external filter 06/21 17:30:30.92 [2456] 1+2/0/1: disconnected [41] -@[127.0.0.1] localhost:3860 (0.125s)(0) 06/21 17:30:30.93 [2928] 0+0: simple_relay [28 -> 29] = (55825 -> 55825) / 5 (WIN) 30:30.953 [2916] select() = -1 [errno=(22 / 10038)] (WIN) 30:30.953 [2916] #### ERROR: select() applied to non-SOCKET handle 06/21 17:30:31.00 [3244] 0+0: simple_relay [28 -> 30] = (2105 -> 2105) / 1 (WIN) 30:31.000 [3676] wait3(N) = 1844 [2928] 0, children(alive=1,total=2) 0.00s 06/21 17:30:31.00 [3676] 4+1: CFI process [1844] done (1/2 AFT-2) (WIN) 30:31.000 [3556] wait3(N) = 1828 [3244] 0, children(alive=0,total=2) 0.00s 06/21 17:30:31.00 [3556] 2+1: CFI process [1828] done (2/2 AFT-4) 06/21 17:30:31.04 [3148] 0+0: simple_relay [29 -> 31] = (10256 -> 10256) / 2 (WIN) 30:31.109 [4056] wait3(N) = 1828 [3148] 0, children(alive=0,total=2) 0.00s 06/21 17:30:31.10 [4056] 3+1: CFI process [1828] done (2/2 AFT-4) 06/21 17:30:31.12 [1980] 0+0: simple_relay [25 -> 29] = (797 -> 797) / 1 (WIN) 30:31.125 [2528] select() = -1 [errno=(22 / 10038)] (WIN) 30:31.125 [2528] #### ERROR: select() applied to non-SOCKET handle (WIN) 30:31.125 [2456] wait3(N) = 1976 [1980] 0, children(alive=1,total=4) 0.00s 06/21 17:30:31.12 [2456] 1+2/0/1: CFI process [1976] done (1/2 AFT-2) 06/21 17:30:31.15 [2916] 0+0: simple_relay [28 -> 30] = (56159 -> 56159) / 6 (WIN) 30:31.203 [3676] wait3(N) = 1828 [2916] 0, children(alive=0,total=2) 0.00s 06/21 17:30:31.20 [3676] 4+1: CFI process [1828] done (2/2 AFT-4) 06/21 17:30:31.32 [2528] 0+0: simple_relay [25 -> 31] = (1130 -> 1130) / 1 (WIN) 30:31.343 [2456] wait3(N) = 336 [2528] 0, children(alive=0,total=4) 0.00s 06/21 17:30:31.34 [2456] 1+2/0/1: CFI process [336] done (2/2 AFT-4) 06/21 17:30:36.59 [1876] 4+0: TERMINATE... 06/21 17:30:36.59 [1876] 4+0: DGAuth: ERROR getCkey(), ekeyFd=-1 06/21 17:30:36.59 [1876] 4+0: Kill(376,15) 06/21 17:30:36.59 [1876] 4+0: Kill(440,15) 06/21 17:30:36.59 [1876] 4+0: Kill(424,15) 06/21 17:30:36.59 [1876] 4+0: Kill(508,15) 06/21 17:30:36.59 [1876] 4+0: StickyKill(15): 4/4 killed 06/21 17:30:36.60 [1876] 4+0: unlinked C:\delegate/work/8080/1876 06/21 17:30:36.60 [1876] 4+0: remove failed, errno=13, C:\delegate/work/8080 (WIN) 30:36.609 [1876] killchildren#1 Terminate 376 [2456] = 1 (WIN) 30:36.609 [1876] killchildren#2 Terminate 424 [4056] = 1 (WIN) 30:36.609 [1876] killchildren#3 Terminate 440 [3556] = 1 (WIN) 30:36.609 [1876] killchildren#4 Terminate 508 [3676] = 1 06/21 17:30:36.60 [1876] 4+0: TERMINATED. 06/21 17:30:36.60 [1876] 4+0: SetStatus: STOP -- Open WebMail Project (http://openwebmail.org)