09:40:44: -> Client trace started, level=3. 09:40:44: -> Tracelevel set to 4. PID is 8308 09:40:44: -> Session ID is 20744f96bb6c4d6f 09:40:44: -> Session time is Tue Apr 24 14:40:44 2012 09:40:44: -> Client was compiled Jan 6 2012 23:38:33 09:40:44: -> Client was compiled with MSVC C/C++ 1310 09:40:44: -> Client build platform is microsoft-windows-x86 09:40:44: -> Build version is CVSNT 2.8.01 (Soolin) Build 4395 09:40:44: -> User name is Glen Starrett 09:40:44: -> Client running on "Windows 7 x64 Service Pack 1 (Build 7601) [6.1.7601] (Service Pack 1)" 09:40:44: -> /3GB is enabled, highest user address is fffeffff 09:40:44: -> Client has 33 percent of memory in use. 09:40:44: -> Client has 4194303 total Kbytes of physical memory*. 09:40:44: -> Client has 4194303 free Kbytes of physical memory*. 09:40:44: -> Client has 12541008 total Kbytes of physical memory. 09:40:44: -> Client has 8292612 free Kbytes of physical memory. 09:40:44: -> Client has 25080168 total Kbytes of paging file. 09:40:44: -> Client has 20646904 free Kbytes of paging file. 09:40:44: -> Client has 4194176 total Kbytes of virtual memory. 09:40:44: -> Client has 4113240 free Kbytes of virtual memory. 09:40:44: -> Client has 0 free Kbytes of extended memory. 09:40:44: -> The custom heap has the low-fragmentation heap enabled. 09:40:44: -> The minimum large page size is 2097152. 09:40:44: -> Walking heap 0X02930000... 09:40:44: -> Region 09:40:44: -> 249856 bytes committed 09:40:44: -> 12288 bytes uncommitted 09:40:44: -> First block address: 0X02930598 09:40:44: -> Last block address: 0X02970000 09:40:44: -> Data portion begins at: 0X02930000 09:40:44: -> Size: 1416 bytes 09:40:44: -> Overhead: 0 bytes 09:40:44: -> Region index: 0 09:40:44: -> Block 09:40:44: -> Data portion begins at: 0X0296BDA8 09:40:44: -> Size: 4664 bytes 09:40:44: -> Overhead: 16 bytes 09:40:44: -> Region index: 0 09:40:44: -> Uncommitted range 09:40:44: -> Data portion begins at: 0X0296D000 09:40:44: -> Size: 12288 bytes 09:40:44: -> Overhead: 0 bytes 09:40:44: -> Region index: 0 09:40:44: -> Client Hardware information (Wow64): 09:40:44: -> Number of processors: 8 09:40:44: -> Processor type: 8664 09:40:44: -> processor architecture: x64 09:40:44: -> processor type 8664/Xeon model: unknown 09:40:44: -> Free space in C:\Users\GLENST~1\AppData\Local\Temp 1478012928 09:40:44: -> Total space in C:\Users\GLENST~1\AppData\Local\Temp 2386554880 09:40:44: -> Total Free space in C:\Users\GLENST~1\AppData\Local\Temp 1478012928 09:40:44: -> Loading protocol sspi as sspi.dll 09:40:44: -> CLibraryAccess::Load loading C:\PROGRA~2\CVSSUI~1\CVSNT/protocols/sspi.dll 09:40:44: -> main loop with CVSROOT=:sspi:europa:/myrepo 09:40:44: -> main - about to start the server yes 09:40:44: -> start_server(verify_only=0) 09:40:44: -> client start - client_protocol->connect 09:40:44: -> Buffer size is 5120 09:40:44: -> sspi_connect 09:40:44: -> tcp_write(26,576) 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> SSPI:ClientAuthenticate(Negotiate,*NONE*,*NONE*) !Schannel - AcquireCredentialsHandle 09:40:44: -> SSPI:ClientAuthenticate() !Schannel - AcquireCredentialsHandle result = OK 09:40:44: -> SSPI:ClientAuthenticate() InitializeSecurityContext 09:40:44: -> tcp_write(2,576) 09:40:44: -> tcp_write(123,576) 09:40:44: -> tcp_read(2) using WSAEventSelect 09:40:44: -> tcp_read(2) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(179) using WSAEventSelect 09:40:44: -> tcp_read(179) immediate timeout previous thread count -1/0 09:40:44: -> SSPI:ClientAuthenticate() InitializeSecurityContext 09:40:44: -> tcp_write(2,576) 09:40:44: -> tcp_write(121,576) 09:40:44: -> tcp_read(2) using WSAEventSelect 09:40:44: -> tcp_read(2) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(29) using WSAEventSelect 09:40:44: -> tcp_read(29) immediate timeout previous thread count -1/0 09:40:44: -> SSPI:ClientAuthenticate() InitializeSecurityContext 09:40:44: -> tcp_write(8,576) 09:40:44: -> client start - Loop, getting responses from the server. 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> recv_line - got 1 chars, first is 73(I), index=0 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> recv_line - got 1 chars, first is 32( ), index=1 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> recv_line - got 1 chars, first is 76(L), index=2 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> recv_line - got 1 chars, first is 79(O), index=3 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> recv_line - got 1 chars, first is 86(V), index=4 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> recv_line - got 1 chars, first is 69(E), index=5 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> recv_line - got 1 chars, first is 32( ), index=6 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> recv_line - got 1 chars, first is 89(Y), index=7 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> recv_line - got 1 chars, first is 79(O), index=8 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> recv_line - got 1 chars, first is 85(U), index=9 09:40:44: -> tcp_read(1) using WSAEventSelect 09:40:44: -> tcp_read(1) immediate timeout previous thread count -1/0 09:40:44: -> recv_line - got 1 chars, first is 10( ), index=10 09:40:44: -> client start - got "I LOVE YOU" 09:40:44: -> client start - continue login. 09:40:44: -> client start - server started. 09:40:44: -> client start - send Valid-responses to server. 09:40:44: -> send_to_server_untranslated() calls buf_output() len=15 nbytes=0 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=15 09:40:44: -> send_to_server_untranslated() calls buf_output() len=2 nbytes=16 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=18 09:40:44: -> send_to_server_untranslated() calls buf_output() len=5 nbytes=19 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=24 09:40:44: -> send_to_server_untranslated() calls buf_output() len=14 nbytes=25 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=39 09:40:44: -> send_to_server_untranslated() calls buf_output() len=10 nbytes=40 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=50 09:40:44: -> send_to_server_untranslated() calls buf_output() len=9 nbytes=51 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=60 09:40:44: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=61 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=69 09:40:44: -> send_to_server_untranslated() calls buf_output() len=9 nbytes=70 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=79 09:40:44: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=80 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=87 09:40:44: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=88 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=95 09:40:44: -> send_to_server_untranslated() calls buf_output() len=15 nbytes=96 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=111 09:40:44: -> send_to_server_untranslated() calls buf_output() len=6 nbytes=112 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=118 09:40:44: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=119 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=126 09:40:44: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=127 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=135 09:40:44: -> send_to_server_untranslated() calls buf_output() len=14 nbytes=136 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=150 09:40:44: -> send_to_server_untranslated() calls buf_output() len=4 nbytes=151 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=155 09:40:44: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=156 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=164 09:40:44: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=165 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=172 09:40:44: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=173 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=180 09:40:44: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=181 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=193 09:40:44: -> send_to_server_untranslated() calls buf_output() len=20 nbytes=194 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=214 09:40:44: -> send_to_server_untranslated() calls buf_output() len=22 nbytes=215 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=237 09:40:44: -> send_to_server_untranslated() calls buf_output() len=10 nbytes=238 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=248 09:40:44: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=249 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=261 09:40:44: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=262 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=270 09:40:44: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=271 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=279 09:40:44: -> send_to_server_untranslated() calls buf_output() len=16 nbytes=280 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=296 09:40:44: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=297 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=314 09:40:44: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=315 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=327 09:40:44: -> send_to_server_untranslated() calls buf_output() len=6 nbytes=328 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=334 09:40:44: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=335 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=347 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=348 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=349 09:40:44: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=350 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=357 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=358 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=359 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=360 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=361 09:40:44: -> send_to_server_untranslated() calls buf_output() len=2 nbytes=362 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=364 09:40:44: -> send_to_server_untranslated() calls buf_output() len=16 nbytes=365 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=381 09:40:44: -> send_to_server_untranslated() calls buf_output() len=14 nbytes=382 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=396 09:40:44: -> client start - send valid-requests to server. 09:40:44: -> send_to_server_untranslated() calls buf_output() len=15 nbytes=397 09:40:44: -> tcp_write(412,576) 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=412 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=424 09:40:44: -> tcp_write(13,576) 09:40:44: -> client start - rootless_encryption. 09:40:44: -> send_to_server_untranslated() calls buf_output() len=5 nbytes=425 09:40:44: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=430 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=437 09:40:44: -> send_to_server_untranslated() calls buf_output() len=16 nbytes=438 09:40:44: -> tcp_write(29,576) 09:40:44: -> tcp_read(4198) using WSAEventSelect 09:40:44: -> tcp_read(4198) immediate timeout previous thread count -1/0 09:40:44: -> Server codepage is CP1252 09:40:44: -> Client codepage is CP1252 09:40:44: -> send_to_server_untranslated() calls buf_output() len=15 nbytes=454 09:40:44: -> send_to_server_untranslated() calls buf_output() len=32 nbytes=469 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=501 09:40:44: -> tcp_write(48,576) 09:40:44: -> tcp_read(4191) using WSAEventSelect 09:40:44: -> tcp_read(4191) immediate timeout previous thread count -1/0 09:40:44: -> Server version is CVSNT 2.8.01 (Soolin) Build 4395 09:40:44: -> Client version is CVSNT 2.8.01 (Soolin) Build 4395 09:40:44: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=502 09:40:44: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=519 09:40:44: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=536 09:40:44: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=553 09:40:44: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=570 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=587 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=588 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=589 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=590 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=591 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=592 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=593 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=594 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=595 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=596 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=597 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=598 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=599 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=600 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=601 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=602 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=603 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=604 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=605 09:40:44: -> Requesting server cvsignore 09:40:44: -> send_to_server_untranslated() calls buf_output() len=15 nbytes=606 09:40:44: -> tcp_write(119,576) 09:40:44: -> tcp_read(4158) using WSAEventSelect 09:40:44: -> tcp_read(4158) immediate timeout previous thread count -1/0 09:40:44: -> wrap_add(*.a -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.a" 09:40:44: -> Call CGetOptions::getOpt: "*.a -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.ai -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.ai" 09:40:44: -> Call CGetOptions::getOpt: "*.ai -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.avi -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.avi" 09:40:44: -> Call CGetOptions::getOpt: "*.avi -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.bin -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.bin" 09:40:44: -> Call CGetOptions::getOpt: "*.bin -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.bmp -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.bmp" 09:40:44: -> Call CGetOptions::getOpt: "*.bmp -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.bz2 -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.bz2" 09:40:44: -> Call CGetOptions::getOpt: "*.bz2 -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.cdd -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.cdd" 09:40:44: -> Call CGetOptions::getOpt: "*.cdd -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.cdmz -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.cdmz" 09:40:44: -> Call CGetOptions::getOpt: "*.cdmz -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.chm -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.chm" 09:40:44: -> Call CGetOptions::getOpt: "*.chm -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.class -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.class" 09:40:44: -> Call CGetOptions::getOpt: "*.class -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.cur -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.cur" 09:40:44: -> Call CGetOptions::getOpt: "*.cur -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.dll -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.dll" 09:40:44: -> Call CGetOptions::getOpt: "*.dll -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.doc -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.doc" 09:40:44: -> Call CGetOptions::getOpt: "*.doc -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.docx -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.docx" 09:40:44: -> Call CGetOptions::getOpt: "*.docx -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.docm -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.docm" 09:40:44: -> Call CGetOptions::getOpt: "*.docm -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.fp -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.fp" 09:40:44: -> Call CGetOptions::getOpt: "*.fp -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.pptx -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.pptx" 09:40:44: -> Call CGetOptions::getOpt: "*.pptx -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.pptm -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.pptm" 09:40:44: -> Call CGetOptions::getOpt: "*.pptm -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.xlsx -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.xlsx" 09:40:44: -> Call CGetOptions::getOpt: "*.xlsx -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.xlsm -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.xlsm" 09:40:44: -> Call CGetOptions::getOpt: "*.xlsm -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.odt -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.odt" 09:40:44: -> Call CGetOptions::getOpt: "*.odt -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.ods -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.ods" 09:40:44: -> Call CGetOptions::getOpt: "*.ods -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.odp -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.odp" 09:40:44: -> Call CGetOptions::getOpt: "*.odp -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.odb -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.odb" 09:40:44: -> Call CGetOptions::getOpt: "*.odb -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.odg -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.odg" 09:40:44: -> Call CGetOptions::getOpt: "*.odg -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.odf -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.odf" 09:40:44: -> Call CGetOptions::getOpt: "*.odf -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.mpp -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.mpp" 09:40:44: -> Call CGetOptions::getOpt: "*.mpp -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.dvi -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.dvi" 09:40:44: -> Call CGetOptions::getOpt: "*.dvi -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.exe -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.exe" 09:40:44: -> Call CGetOptions::getOpt: "*.exe -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.gif -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.gif" 09:40:44: -> Call CGetOptions::getOpt: "*.gif -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.gz -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.gz" 09:40:44: -> Call CGetOptions::getOpt: "*.gz -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.hqx -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.hqx" 09:40:44: -> Call CGetOptions::getOpt: "*.hqx -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.ico -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.ico" 09:40:44: -> Call CGetOptions::getOpt: "*.ico -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.ilk -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.ilk" 09:40:44: -> Call CGetOptions::getOpt: "*.ilk -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.indd -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.indd" 09:40:44: -> Call CGetOptions::getOpt: "*.indd -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.iso -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.iso" 09:40:44: -> Call CGetOptions::getOpt: "*.iso -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.lib -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.lib" 09:40:44: -> Call CGetOptions::getOpt: "*.lib -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.jar -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.jar" 09:40:44: -> Call CGetOptions::getOpt: "*.jar -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.jpg -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.jpg" 09:40:44: -> Call CGetOptions::getOpt: "*.jpg -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.jpeg -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.jpeg" 09:40:44: -> Call CGetOptions::getOpt: "*.jpeg -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.lnk -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.lnk" 09:40:44: -> Call CGetOptions::getOpt: "*.lnk -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.mpg -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.mpg" 09:40:44: -> Call CGetOptions::getOpt: "*.mpg -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.mpeg -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.mpeg" 09:40:44: -> Call CGetOptions::getOpt: "*.mpeg -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.mov -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.mov" 09:40:44: -> Call CGetOptions::getOpt: "*.mov -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.mp3 -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.mp3" 09:40:44: -> Call CGetOptions::getOpt: "*.mp3 -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.ncb -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.ncb" 09:40:44: -> Call CGetOptions::getOpt: "*.ncb -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.o -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.o" 09:40:44: -> Call CGetOptions::getOpt: "*.o -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.ogg -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.ogg" 09:40:44: -> Call CGetOptions::getOpt: "*.ogg -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.ocx -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.ocx" 09:40:44: -> Call CGetOptions::getOpt: "*.ocx -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.obj -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.obj" 09:40:44: -> Call CGetOptions::getOpt: "*.obj -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.pdb -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.pdb" 09:40:44: -> Call CGetOptions::getOpt: "*.pdb -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.pdf -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.pdf" 09:40:44: -> Call CGetOptions::getOpt: "*.pdf -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.png -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.png" 09:40:44: -> Call CGetOptions::getOpt: "*.png -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.ppt -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.ppt" 09:40:44: -> Call CGetOptions::getOpt: "*.ppt -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.psd -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.psd" 09:40:44: -> Call CGetOptions::getOpt: "*.psd -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.res -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.res" 09:40:44: -> Call CGetOptions::getOpt: "*.res -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.rpm -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.rpm" 09:40:44: -> Call CGetOptions::getOpt: "*.rpm -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.sit -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.sit" 09:40:44: -> Call CGetOptions::getOpt: "*.sit -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.so -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.so" 09:40:44: -> Call CGetOptions::getOpt: "*.so -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.tar -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.tar" 09:40:44: -> Call CGetOptions::getOpt: "*.tar -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.tga -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.tga" 09:40:44: -> Call CGetOptions::getOpt: "*.tga -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.tgz -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.tgz" 09:40:44: -> Call CGetOptions::getOpt: "*.tgz -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.tif -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.tif" 09:40:44: -> Call CGetOptions::getOpt: "*.tif -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.tiff -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.tiff" 09:40:44: -> Call CGetOptions::getOpt: "*.tiff -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.ttf -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.ttf" 09:40:44: -> Call CGetOptions::getOpt: "*.ttf -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.uir -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.uir" 09:40:44: -> Call CGetOptions::getOpt: "*.uir -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.wav -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.wav" 09:40:44: -> Call CGetOptions::getOpt: "*.wav -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.wmv -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.wmv" 09:40:44: -> Call CGetOptions::getOpt: "*.wmv -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.xls -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.xls" 09:40:44: -> Call CGetOptions::getOpt: "*.xls -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.zip -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.zip" 09:40:44: -> Call CGetOptions::getOpt: "*.zip -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> wrap_add(*.Z -kb, 0, 0, 0, 0) 09:40:44: -> Call CFileAccess::mimetype: "*.Z" 09:40:44: -> Call CGetOptions::getOpt: "*.Z -kb" "+k:x:m:t:" 09:40:44: -> wrap_add() Sort. 09:40:44: -> Requesting server cvswrappers 09:40:44: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=621 09:40:44: -> tcp_write(17,576) 09:40:44: -> tcp_read(4156) using WSAEventSelect 09:40:44: -> tcp_read(4156) immediate timeout previous thread count -1/0 09:40:44: -> Got the server cvswrappers 09:40:44: -> The first item in the sorted list is "b" with wildcard "*.a" 09:40:44: -> Requesting server cvsrc (read-cvsrc2) 09:40:44: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=638 09:40:44: -> tcp_write(12,576) 09:40:44: -> tcp_read(4152) using WSAEventSelect 09:40:44: -> tcp_read(4152) immediate timeout previous thread count -1/0 09:40:44: -> Parsing global cvsrc started 09:40:44: -> Parsing global cvsrc finished 0 lines. 09:40:44: -> No local C:\Users\Glen Starrett/.cvsrc to parse 09:40:44: -> Server: call the requested function rls 09:40:44: -> send_to_server_untranslated() calls buf_output() len=9 nbytes=650 09:40:44: -> send_to_server_untranslated() calls buf_output() len=2 nbytes=659 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=661 09:40:44: -> send_to_server_untranslated() calls buf_output() len=9 nbytes=662 09:40:44: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=671 09:40:44: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=679 09:40:44: -> send_to_server_untranslated() calls buf_output() len=4 nbytes=680 09:40:44: -> tcp_write(34,576) 09:40:44: -> tcp_read(4150) using WSAEventSelect 09:40:44: -> tcp_read(4150) immediate timeout previous thread count -1/0 09:40:44: S -> server_main started 09:40:44: S -> server_main process id is 2164 09:40:44: -> tcp_read(4065) using WSAEventSelect 09:40:44: -> tcp_read(4065) immediate timeout previous thread count -1/0 09:40:44: S -> server_main CVS2_SERVER_SLEEP not set. 09:40:44: S -> run plugintools proc server 09:40:44: -> tcp_read(3964) using WSAEventSelect 09:40:44: -> tcp_read(3964) immediate timeout previous thread count -1/0 09:40:44: S -> run_trigger() 09:40:44: -> tcp_read(3933) using WSAEventSelect 09:40:44: -> tcp_read(3933) immediate timeout previous thread count -1/0 09:40:44: S -> LoadTrigger(audit.dll) 09:40:44: S -> CLibraryAccess::Load loading C:\PROGRA~2\CVSSUI~1\CVSNT/triggers/audit.dll 09:40:44: -> tcp_read(3801) using WSAEventSelect 09:40:44: -> tcp_read(3801) immediate timeout previous thread count -1/0 09:40:44: S -> Not loading disabled trigger audit.dll. 09:40:44: -> tcp_read(3744) using WSAEventSelect 09:40:44: -> tcp_read(3744) immediate timeout previous thread count -1/0 09:40:44: S -> Couldn't load trigger audit.dll 09:40:44: -> tcp_read(3695) using WSAEventSelect 09:40:44: -> tcp_read(3695) immediate timeout previous thread count -1/0 09:40:44: S -> LoadTrigger(bugzilla.dll) 09:40:44: S -> CLibraryAccess::Load loading C:\PROGRA~2\CVSSUI~1\CVSNT/triggers/bugzilla.dll 09:40:44: -> tcp_read(3557) using WSAEventSelect 09:40:44: -> tcp_read(3557) immediate timeout previous thread count -1/0 09:40:44: S -> Defect Tracking trigger not enabled. 09:40:44: S -> Couldn't load trigger bugzilla.dll 09:40:44: -> tcp_read(3448) using WSAEventSelect 09:40:44: -> tcp_read(3448) immediate timeout previous thread count -1/0 09:40:44: S -> Checking admin file C:/PROGRA~3/MARCHH~1/myrepo/CVSROOT/admin for user Europa\Glen Starrett 09:40:44: -> tcp_read(3339) using WSAEventSelect 09:40:44: -> tcp_read(3339) immediate timeout previous thread count -1/0 09:40:44: S -> Checking started in admin file C:/PROGRA~3/MARCHH~1/myrepo/CVSROOT/admin for user Europa\Glen Starrett 09:40:44: -> tcp_read(3219) using WSAEventSelect 09:40:44: -> tcp_read(3219) immediate timeout previous thread count -1/0 09:40:44: S -> Checked admin file (null) for user Europa\Glen Starrett they are an admin. 09:40:44: -> tcp_read(3127) using WSAEventSelect 09:40:44: -> tcp_read(3127) immediate timeout previous thread count -1/0 09:40:44: S -> InitTrigger(checkout.dll) 09:40:44: -> tcp_read(3084) using WSAEventSelect 09:40:44: -> tcp_read(3084) immediate timeout previous thread count -1/0 09:40:44: S -> Checkout trigger not enabled. 09:40:44: S -> Couldn't load trigger checkout.dll 09:40:44: -> tcp_read(2985) using WSAEventSelect 09:40:44: -> tcp_read(2985) immediate timeout previous thread count -1/0 09:40:44: S -> InitTrigger(email.dll) 09:40:44: -> tcp_read(2945) using WSAEventSelect 09:40:44: -> tcp_read(2945) immediate timeout previous thread count -1/0 09:40:44: S -> Email trigger not enabled. 09:40:44: -> tcp_read(2901) using WSAEventSelect 09:40:44: -> tcp_read(2901) immediate timeout previous thread count -1/0 09:40:44: S -> Couldn't load trigger email.dll 09:40:44: S -> InitTrigger(info.dll) 09:40:44: -> tcp_read(2813) using WSAEventSelect 09:40:44: -> tcp_read(2813) immediate timeout previous thread count -1/0 09:40:44: S -> InitTrigger(make.dll) 09:40:44: -> tcp_read(2774) using WSAEventSelect 09:40:44: -> tcp_read(2774) immediate timeout previous thread count -1/0 09:40:44: S -> Make trigger not enabled. 09:40:44: S -> Couldn't load trigger make.dll 09:40:44: -> tcp_read(2680) using WSAEventSelect 09:40:44: -> tcp_read(2680) immediate timeout previous thread count -1/0 09:40:44: S -> InitTrigger(script.dll) 09:40:44: -> tcp_read(2639) using WSAEventSelect 09:40:44: -> tcp_read(2639) immediate timeout previous thread count -1/0 09:40:44: S -> Script trigger not enabled. 09:40:44: S -> Couldn't load trigger script.dll 09:40:44: S -> InitTrigger(sync.dll) 09:40:44: -> tcp_read(2505) using WSAEventSelect 09:40:44: -> tcp_read(2505) immediate timeout previous thread count -1/0 09:40:44: S -> Sync trigger not enabled. 09:40:44: S -> Couldn't load trigger sync.dll 09:40:44: -> tcp_read(2411) using WSAEventSelect 09:40:44: -> tcp_read(2411) immediate timeout previous thread count -1/0 09:40:44: S -> Call pre-loaded 'info.dll' 09:40:44: S -> plugintools_proc() 09:40:44: -> tcp_read(2331) using WSAEventSelect 09:40:44: -> tcp_read(2331) immediate timeout previous thread count -1/0 09:40:44: S -> Call pre-loaded 'info.dll' returned 0, total ret 0 09:40:44: S -> run_trigger returning 0 09:40:44: S -> run precommand proc server 09:40:44: -> tcp_read(2178) using WSAEventSelect 09:40:44: -> tcp_read(2178) immediate timeout previous thread count -1/0 09:40:44: S -> run_trigger() 09:40:44: S -> Call pre-loaded 'info.dll' 09:40:44: -> tcp_read(2103) using WSAEventSelect 09:40:44: -> tcp_read(2103) immediate timeout previous thread count -1/0 09:40:44: S -> precommand_proc() 09:40:44: -> tcp_read(2068) using WSAEventSelect 09:40:44: -> tcp_read(2068) immediate timeout previous thread count -1/0 09:40:44: S -> default_trigger: parse_info(CVSROOT/precommand,%r %c,%) 09:40:44: S -> CFileAccess::open('C:/PROGRA~3/MARCHH~1/myrepo/CVSROOT/precommand','rb') 09:40:44: -> tcp_read(1896) using WSAEventSelect 09:40:44: -> tcp_read(1896) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::open() setvbuf(_IONBF) 09:40:44: -> tcp_read(1843) using WSAEventSelect 09:40:44: -> tcp_read(1843) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::close() 09:40:44: -> tcp_read(1805) using WSAEventSelect 09:40:44: -> tcp_read(1805) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::close() 09:40:44: S -> Call pre-loaded 'info.dll' returned 0, total ret 0 09:40:44: -> tcp_read(1699) using WSAEventSelect 09:40:44: -> tcp_read(1699) immediate timeout previous thread count -1/0 09:40:44: S -> run_trigger returning 0 09:40:44: S -> open_module(C:/PROGRA~3/MARCHH~1/myrepo) 09:40:44: -> tcp_read(1600) using WSAEventSelect 09:40:44: -> tcp_read(1600) immediate timeout previous thread count -1/0 09:40:44: S -> do_module(testfilt, Listing, , ) 09:40:44: -> tcp_read(1550) using WSAEventSelect 09:40:44: -> tcp_read(1550) immediate timeout previous thread count -1/0 09:40:44: S -> do_module calls map_repository() 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/testfilt) 09:40:44: -> tcp_read(1430) using WSAEventSelect 09:40:44: -> tcp_read(1430) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() 09:40:44: S -> lookup_module2(testfilt) after rename? 09:40:44: -> tcp_read(1340) using WSAEventSelect 09:40:44: -> tcp_read(1340) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(1283) using WSAEventSelect 09:40:44: -> tcp_read(1283) immediate timeout previous thread count -1/0 09:40:44: S -> Loading modules2 from C:/PROGRA~3/MARCHH~1/myrepo/CVSROOT/modules2 09:40:44: -> tcp_read(1199) using WSAEventSelect 09:40:44: -> tcp_read(1199) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(1132) using WSAEventSelect 09:40:44: -> tcp_read(1132) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(testfilt,1) 09:40:44: S -> _lookup_module2 !p lookup_repository_module(testfilt) 09:40:44: -> tcp_read(1017) using WSAEventSelect 09:40:44: -> tcp_read(1017) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(testfilt) 09:40:44: S -> modules2_struct_sort(testfilt,testfilt) 09:40:44: -> tcp_read(908) using WSAEventSelect 09:40:44: -> tcp_read(908) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 lookup_repository_directory(,0,0) 09:40:44: S -> _lookup_module2 lookup_repository_directory results "",0,0 09:40:44: S -> lookup_module2() call to lookup_repository_directory() returned something 09:40:44: -> tcp_read(674) using WSAEventSelect 09:40:44: -> tcp_read(674) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 return at end 1 left,right(samp,) 09:40:44: S -> lookup_module2() call _lookup_module2 returned 1 09:40:44: S -> lookup_module2() found "samp" 09:40:44: -> tcp_read(494) using WSAEventSelect 09:40:44: -> tcp_read(494) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(437) using WSAEventSelect 09:40:44: -> tcp_read(437) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(370) using WSAEventSelect 09:40:44: -> tcp_read(370) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp,1) 09:40:44: S -> _lookup_module2 !p lookup_repository_module(samp) 09:40:44: -> tcp_read(263) using WSAEventSelect 09:40:44: -> tcp_read(263) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: -> tcp_read(162) using WSAEventSelect 09:40:44: -> tcp_read(162) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp) 09:40:44: -> tcp_read(10) using WSAEventSelect 09:40:44: -> tcp_read(10) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: S -> lookup_module2() return 1 09:40:44: -> tcp_read(4949) using WSAEventSelect 09:40:44: -> tcp_read(4949) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() ret=1, current_directory==NULL, current_directory->directory_mappings=!!!! 09:40:44: S -> lookup_module2() return ret=1 renamed=0 09:40:44: S -> map_repository - lookup_module2 returned res==1 09:40:44: -> tcp_read(4718) using WSAEventSelect 09:40:44: -> tcp_read(4718) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository - return(ret) "C:/PROGRA~3/MARCHH~1/myrepo/samp" 09:40:44: S -> do_module call to map_repository() has returned something 09:40:44: -> tcp_read(4562) using WSAEventSelect 09:40:44: -> tcp_read(4562) immediate timeout previous thread count -1/0 09:40:44: S -> * check to see if mname is a directory or file 09:40:44: S -> do_module calls isdir(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: -> tcp_read(4424) using WSAEventSelect 09:40:44: -> tcp_read(4424) immediate timeout previous thread count -1/0 09:40:44: S -> do_module yes it is a directory ... 09:40:44: -> tcp_read(4371) using WSAEventSelect 09:40:44: -> tcp_read(4371) immediate timeout previous thread count -1/0 09:40:44: S -> * OK, we have now set up modargv with the actual file/directory we want to work on. 09:40:44: S -> run premodule trigger 09:40:44: -> tcp_read(4231) using WSAEventSelect 09:40:44: -> tcp_read(4231) immediate timeout previous thread count -1/0 09:40:44: S -> run_trigger() 09:40:44: S -> Call pre-loaded 'info.dll' 09:40:44: -> tcp_read(4156) using WSAEventSelect 09:40:44: -> tcp_read(4156) immediate timeout previous thread count -1/0 09:40:44: S -> premodule_proc(testfilt) 09:40:44: S -> default_trigger: parse_info(CVSROOT/premodule,%r/%p %c %o,,testfilt) 09:40:44: -> tcp_read(4028) using WSAEventSelect 09:40:44: -> tcp_read(4028) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::open('C:/PROGRA~3/MARCHH~1/myrepo/CVSROOT/premodule','rb') 09:40:44: -> tcp_read(3939) using WSAEventSelect 09:40:44: -> tcp_read(3939) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::open() setvbuf(_IONBF) 09:40:44: -> tcp_read(3886) using WSAEventSelect 09:40:44: -> tcp_read(3886) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::close() 09:40:44: -> tcp_read(3848) using WSAEventSelect 09:40:44: -> tcp_read(3848) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::close() 09:40:44: S -> Call pre-loaded 'info.dll' returned 0, total ret 0 09:40:44: -> tcp_read(3742) using WSAEventSelect 09:40:44: -> tcp_read(3742) immediate timeout previous thread count -1/0 09:40:44: S -> run_trigger returning 0 09:40:44: S -> do_modue(1): call the callback_proc((null)) 09:40:44: -> tcp_read(3640) using WSAEventSelect 09:40:44: -> tcp_read(3640) immediate timeout previous thread count -1/0 Listing module: testfilt 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/testfilt) 09:40:44: -> tcp_read(3540) using WSAEventSelect 09:40:44: -> tcp_read(3540) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() 09:40:44: S -> lookup_module2(testfilt) after rename? 09:40:44: -> tcp_read(3450) using WSAEventSelect 09:40:44: -> tcp_read(3450) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(3393) using WSAEventSelect 09:40:44: -> tcp_read(3393) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: S -> lookup_module2(testfilt,2) 09:40:44: -> tcp_read(3282) using WSAEventSelect 09:40:44: -> tcp_read(3282) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 !p lookup_repository_module(testfilt) 09:40:44: S -> lookup_repository_module(testfilt) 09:40:44: -> tcp_read(3159) using WSAEventSelect 09:40:44: -> tcp_read(3159) immediate timeout previous thread count -1/0 09:40:44: S -> modules2_struct_sort(testfilt,testfilt) 09:40:44: S -> _lookup_module2 lookup_repository_directory(,0,0) 09:40:44: -> tcp_read(3035) using WSAEventSelect 09:40:44: -> tcp_read(3035) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 lookup_repository_directory results "",0,0 09:40:44: S -> lookup_module2() call to lookup_repository_directory() returned something 09:40:44: -> tcp_read(2868) using WSAEventSelect 09:40:44: -> tcp_read(2868) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 return at end 1 left,right(samp,) 09:40:44: S -> lookup_module2() call _lookup_module2 returned 1 09:40:44: -> tcp_read(2735) using WSAEventSelect 09:40:44: -> tcp_read(2735) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() found "samp" 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(2631) using WSAEventSelect 09:40:44: -> tcp_read(2631) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: S -> lookup_module2(samp,2) 09:40:44: S -> _lookup_module2 !p lookup_repository_module(samp) 09:40:44: -> tcp_read(2457) using WSAEventSelect 09:40:44: -> tcp_read(2457) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: -> tcp_read(2356) using WSAEventSelect 09:40:44: -> tcp_read(2356) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp) 09:40:44: -> tcp_read(2204) using WSAEventSelect 09:40:44: -> tcp_read(2204) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: -> tcp_read(2066) using WSAEventSelect 09:40:44: -> tcp_read(2066) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() return 1 09:40:44: S -> lookup_module2() ret=1, current_directory==NULL, current_directory->directory_mappings=!!!! 09:40:44: S -> lookup_module2() return ret=1 renamed=0 09:40:44: -> tcp_read(1857) using WSAEventSelect 09:40:44: -> tcp_read(1857) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository - lookup_module2 returned res==1 09:40:44: S -> map_repository - return(ret) "C:/PROGRA~3/MARCHH~1/myrepo/samp" 09:40:44: -> tcp_read(1711) using WSAEventSelect 09:40:44: -> tcp_read(1711) immediate timeout previous thread count -1/0 09:40:44: S -> start_recursion(testfilt,(null)) 09:40:44: S -> start_recursion() dirleaveproc is NULL 09:40:44: -> tcp_read(1605) using WSAEventSelect 09:40:44: -> tcp_read(1605) immediate timeout previous thread count -1/0 09:40:44: S -> start_recursion() update_dir set to "testfilt" 09:40:44: S -> start_recursion - argument count (argc) == 0 09:40:44: S -> * There were no arguments, so we'll probably just recurse. The 09:40:44: -> tcp_read(1399) using WSAEventSelect 09:40:44: -> tcp_read(1399) immediate timeout previous thread count -1/0 09:40:44: S -> * exception to the rule is when we are called from a directory 09:40:44: S -> * without any CVS administration files. That has always meant to 09:40:44: -> tcp_read(1236) using WSAEventSelect 09:40:44: -> tcp_read(1236) immediate timeout previous thread count -1/0 09:40:44: S -> * process each of the sub-directories, so we pretend like we were 09:40:44: S -> * called with the list of sub-dirs of the current dir as args 09:40:44: -> tcp_read(1074) using WSAEventSelect 09:40:44: -> tcp_read(1074) immediate timeout previous thread count -1/0 09:40:44: S -> start_recursion: !just_subdirs - call addlist(dirlist==NULL, ".") 09:40:44: S -> start_recursion: addlist() returns and now dirlist!=NULL 09:40:44: -> tcp_read(916) using WSAEventSelect 09:40:44: -> tcp_read(916) immediate timeout previous thread count -1/0 09:40:44: S -> start_recursion/do_the_work: do_recursion() on the frame (dirlist != NULL). 09:40:44: S -> do_recursion: begin 09:40:44: -> tcp_read(786) using WSAEventSelect 09:40:44: -> tcp_read(786) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: Check the value in CVSADM_ROOT 09:40:44: S -> do_recursion: Fill in repository with the current repository 09:40:44: -> tcp_read(645) using WSAEventSelect 09:40:44: -> tcp_read(645) immediate timeout previous thread count -1/0 09:40:44: S -> (repository && (server_active || !current_parsed_root->isremote)) 09:40:44: -> tcp_read(562) using WSAEventSelect 09:40:44: -> tcp_read(562) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/testfilt) 09:40:44: S -> lookup_module2() 09:40:44: -> tcp_read(458) using WSAEventSelect 09:40:44: -> tcp_read(458) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(testfilt) after rename? 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(345) using WSAEventSelect 09:40:44: -> tcp_read(345) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: S -> lookup_module2(testfilt,3) 09:40:44: -> tcp_read(234) using WSAEventSelect 09:40:44: -> tcp_read(234) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 !p lookup_repository_module(testfilt) 09:40:44: S -> lookup_repository_module(testfilt) 09:40:44: S -> modules2_struct_sort(testfilt,testfilt) 09:40:44: -> tcp_read(54) using WSAEventSelect 09:40:44: -> tcp_read(54) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 lookup_repository_directory(,0,0) 09:40:44: S -> _lookup_module2 lookup_repository_directory results "",0,0 09:40:44: S -> lookup_module2() call to lookup_repository_directory() returned something 09:40:44: -> tcp_read(4940) using WSAEventSelect 09:40:44: -> tcp_read(4940) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 return at end 1 left,right(samp,) 09:40:44: S -> lookup_module2() call _lookup_module2 returned 1 09:40:44: S -> lookup_module2() found "samp" 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(4703) using WSAEventSelect 09:40:44: -> tcp_read(4703) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: S -> lookup_module2(samp,3) 09:40:44: S -> _lookup_module2 !p lookup_repository_module(samp) 09:40:44: -> tcp_read(4529) using WSAEventSelect 09:40:44: -> tcp_read(4529) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: -> tcp_read(4428) using WSAEventSelect 09:40:44: -> tcp_read(4428) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp) 09:40:44: -> tcp_read(4276) using WSAEventSelect 09:40:44: -> tcp_read(4276) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: -> tcp_read(4138) using WSAEventSelect 09:40:44: -> tcp_read(4138) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() return 1 09:40:44: S -> lookup_module2() ret=1, current_directory==NULL, current_directory->directory_mappings=!!!! 09:40:44: -> tcp_read(3986) using WSAEventSelect 09:40:44: -> tcp_read(3986) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() return ret=1 renamed=0 09:40:44: S -> map_repository - lookup_module2 returned res==1 09:40:44: -> tcp_read(3864) using WSAEventSelect 09:40:44: -> tcp_read(3864) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository - return(ret) "C:/PROGRA~3/MARCHH~1/myrepo/samp" 09:40:44: S -> Repository = C:/PROGRA~3/MARCHH~1/myrepo/testfilt 09:40:44: -> tcp_read(3716) using WSAEventSelect 09:40:44: -> tcp_read(3716) immediate timeout previous thread count -1/0 09:40:44: S -> Mapped repository = C:/PROGRA~3/MARCHH~1/myrepo/samp 09:40:44: -> tcp_read(3646) using WSAEventSelect 09:40:44: -> tcp_read(3646) immediate timeout previous thread count -1/0 09:40:44: S -> (repository && (server_active || !current_parsed_root->isremote)) 09:40:44: S -> ParseTag() 09:40:44: -> tcp_read(3535) using WSAEventSelect 09:40:44: -> tcp_read(3535) immediate timeout previous thread count -1/0 09:40:44: S -> ParseTag_Dir((null),,,0,) 09:40:44: -> tcp_read(3481) using WSAEventSelect 09:40:44: -> tcp_read(3481) immediate timeout previous thread count -1/0 09:40:44: S -> verify_access C:/PROGRA~3/MARCHH~1/myrepo/samp,testfilt,(null) 09:40:44: S -> verify_perm(C:/PROGRA~3/MARCHH~1/myrepo/samp,(null),read,(null),(null)) 09:40:44: -> tcp_read(3312) using WSAEventSelect 09:40:44: -> tcp_read(3312) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm: verify_owner_dir() 09:40:44: S -> verify_owner(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: -> tcp_read(3199) using WSAEventSelect 09:40:44: -> tcp_read(3199) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: S -> fileattr_read(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: -> tcp_read(3055) using WSAEventSelect 09:40:44: -> tcp_read(3055) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() malloc [strlen(C:/PROGRA~3/MARCHH~1/myrepo/samp)=]32+[sizeof(CVS/fileattr.xml)=]17+20=69 09:40:44: S -> fileattr_read() xmalloc fname OK 09:40:44: -> tcp_read(2882) using WSAEventSelect 09:40:44: -> tcp_read(2882) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() allocated memory for fname - will now sprintf() 09:40:44: -> tcp_read(2800) using WSAEventSelect 09:40:44: -> tcp_read(2800) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() ReadXmlFile("C:/PROGRA~3/MARCHH~1/myrepo/samp/CVS/fileattr.xml") 09:40:44: S -> fileattr_read() ReadXmlFile() 09:40:44: -> tcp_read(2654) using WSAEventSelect 09:40:44: -> tcp_read(2654) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() close 09:40:44: S -> fileattr_read() xfree fname 09:40:44: -> tcp_read(2570) using WSAEventSelect 09:40:44: -> tcp_read(2570) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() OK 09:40:44: S -> cache_directory_permissions() - cache directory(fileattr,) 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: -> tcp_read(2306) using WSAEventSelect 09:40:44: -> tcp_read(2306) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() last_component=samp 09:40:44: S -> fileattr_read(C:/PROGRA~3/MARCHH~1/myrepo) 09:40:44: -> tcp_read(2179) using WSAEventSelect 09:40:44: -> tcp_read(2179) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() malloc [strlen(C:/PROGRA~3/MARCHH~1/myrepo)=]27+[sizeof(CVS/fileattr.xml)=]17+20=64 09:40:44: S -> fileattr_read() xmalloc fname OK 09:40:44: -> tcp_read(2011) using WSAEventSelect 09:40:44: -> tcp_read(2011) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() allocated memory for fname - will now sprintf() 09:40:44: -> tcp_read(1929) using WSAEventSelect 09:40:44: -> tcp_read(1929) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() no file "C:/PROGRA~3/MARCHH~1/myrepo/CVS/fileattr.xml", so allocate ofname of 60 bytes. 09:40:44: -> tcp_read(1807) using WSAEventSelect 09:40:44: -> tcp_read(1807) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() xmalloc ofname OK 09:40:44: -> tcp_read(1756) using WSAEventSelect 09:40:44: -> tcp_read(1756) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() no old "C:/PROGRA~3/MARCHH~1/myrepo/CVS/fileattr". 09:40:44: -> tcp_read(1671) using WSAEventSelect 09:40:44: -> tcp_read(1671) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() no old "C:/PROGRA~3/MARCHH~1/myrepo//.owner". 09:40:44: -> tcp_read(1591) using WSAEventSelect 09:40:44: -> tcp_read(1591) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() no old "C:/PROGRA~3/MARCHH~1/myrepo//.perms". 09:40:44: S -> _fileattr_read() CXmlNode("fileattr") 09:40:44: -> tcp_read(1456) using WSAEventSelect 09:40:44: -> tcp_read(1456) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() xfree ofname and fname OK 09:40:44: S -> cache_directory_permissions() - cache directory(fileattr,) 09:40:44: -> tcp_read(1321) using WSAEventSelect 09:40:44: -> tcp_read(1321) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: -> tcp_read(1174) using WSAEventSelect 09:40:44: -> tcp_read(1174) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() free(C:/PROGRA~3/MARCHH~1/myrepo) 09:40:44: S -> cache_directory_permissions() return 09:40:44: -> tcp_read(1039) using WSAEventSelect 09:40:44: -> tcp_read(1039) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm() Read directory permission cache OK 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp 09:40:44: -> tcp_read(899) using WSAEventSelect 09:40:44: -> tcp_read(899) immediate timeout previous thread count -1/0 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: -> tcp_read(804) using WSAEventSelect 09:40:44: -> tcp_read(804) immediate timeout previous thread count -1/0 09:40:44: S -> no match at this level 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo 09:40:44: -> tcp_read(695) using WSAEventSelect 09:40:44: -> tcp_read(695) immediate timeout previous thread count -1/0 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: -> tcp_read(560) using WSAEventSelect 09:40:44: -> tcp_read(560) immediate timeout previous thread count -1/0 09:40:44: S -> Match found. user_state = 0, group_state = 0 09:40:44: S -> verify_perm() return 09:40:44: S -> fileattr_startdir(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: -> tcp_read(391) using WSAEventSelect 09:40:44: -> tcp_read(391) immediate timeout previous thread count -1/0 09:40:44: S -> * The filesdoneproc needs to be called for each directory where files 09:40:44: S -> * processed, or each directory that is processed by a call where no 09:40:44: -> tcp_read(219) using WSAEventSelect 09:40:44: -> tcp_read(219) immediate timeout previous thread count -1/0 09:40:44: S -> * directories were passed in. In fact, the only time we don't want to 09:40:44: S -> * call back the filesdoneproc is when we are processing directories that 09:40:44: -> tcp_read(41) using WSAEventSelect 09:40:44: -> tcp_read(41) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> * were passed in on the command line (or in the special case of `.' when 09:40:44: S -> * we were called with no args 09:40:44: S -> do_recursion: dirlist != NULL && filelist == NULL 09:40:44: -> tcp_read(4957) using WSAEventSelect 09:40:44: -> tcp_read(4957) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: dodoneproc=0 09:40:44: S -> * If filelist or dirlist is already set, we don't look again. Otherwise, 09:40:44: -> tcp_read(4823) using WSAEventSelect 09:40:44: -> tcp_read(4823) immediate timeout previous thread count -1/0 09:40:44: S -> * find the files and directories 09:40:44: S -> do_recursion: something was passed on the command line 09:40:44: -> tcp_read(4700) using WSAEventSelect 09:40:44: -> tcp_read(4700) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: process the files (if any) 09:40:44: S -> do_recursion: call-back files done proc (if any) 09:40:44: -> tcp_read(4574) using WSAEventSelect 09:40:44: -> tcp_read(4574) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: no: don't call-back files done proc (process_this_directory!dodoneprocframe->filesdoneproc == NULL) 09:40:44: S -> do_recursion: at skip_directory 09:40:44: -> tcp_read(4392) using WSAEventSelect 09:40:44: -> tcp_read(4392) immediate timeout previous thread count -1/0 09:40:44: S -> (repository && (server_active || !current_parsed_root->isremote)) 09:40:44: S -> fileattr_write() 09:40:44: -> tcp_read(4275) using WSAEventSelect 09:40:44: -> tcp_read(4275) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_free() 09:40:44: S -> do_recursion: process the directories (if necessary) 09:40:44: -> tcp_read(4171) using WSAEventSelect 09:40:44: -> tcp_read(4171) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: really process the directories (if necessary) 09:40:44: S -> do_recursion() -- walklist (dirlist !=NULL, do_dir_proc, (void *) &frent) 09:40:44: -> tcp_read(4002) using WSAEventSelect 09:40:44: -> tcp_read(4002) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() 09:40:44: S -> do_dir_proc() update_dir=testfilt 09:40:44: -> tcp_read(3920) using WSAEventSelect 09:40:44: -> tcp_read(3920) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- set up update_dir(testfilt) - no dots ? 09:40:44: S -> do_dir_proc() -- set up update_dir is now dirp "testfilt" - no dots ? 09:40:44: -> tcp_read(3757) using WSAEventSelect 09:40:44: -> tcp_read(3757) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote 09:40:44: S -> ParseTag() 09:40:44: -> tcp_read(3647) using WSAEventSelect 09:40:44: -> tcp_read(3647) immediate timeout previous thread count -1/0 09:40:44: S -> ParseTag_Dir((null),,,0,) 09:40:44: S -> do_dir_proc() -- verify_access 09:40:44: S -> verify_access C:/PROGRA~3/MARCHH~1/myrepo/samp,testfilt,(null) 09:40:44: -> tcp_read(3453) using WSAEventSelect 09:40:44: -> tcp_read(3453) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm(C:/PROGRA~3/MARCHH~1/myrepo/samp,(null),read,(null),(null)) 09:40:44: S -> verify_perm: verify_owner_dir() 09:40:44: S -> verify_owner(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: -> tcp_read(3251) using WSAEventSelect 09:40:44: -> tcp_read(3251) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: -> tcp_read(3172) using WSAEventSelect 09:40:44: -> tcp_read(3172) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: S -> cache_directory_permissions() last_component=samp 09:40:44: -> tcp_read(2953) using WSAEventSelect 09:40:44: -> tcp_read(2953) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: S -> cache_directory_permissions() free(C:/PROGRA~3/MARCHH~1/myrepo) 09:40:44: -> tcp_read(2725) using WSAEventSelect 09:40:44: -> tcp_read(2725) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() return 09:40:44: S -> verify_perm() Read directory permission cache OK 09:40:44: -> tcp_read(2605) using WSAEventSelect 09:40:44: -> tcp_read(2605) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: -> tcp_read(2485) using WSAEventSelect 09:40:44: -> tcp_read(2485) immediate timeout previous thread count -1/0 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: -> tcp_read(2396) using WSAEventSelect 09:40:44: -> tcp_read(2396) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: -> tcp_read(2281) using WSAEventSelect 09:40:44: -> tcp_read(2281) immediate timeout previous thread count -1/0 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: -> tcp_read(2192) using WSAEventSelect 09:40:44: -> tcp_read(2192) immediate timeout previous thread count -1/0 09:40:44: S -> Match found. user_state = 0, group_state = 0 09:40:44: S -> verify_perm() return 09:40:44: -> tcp_read(2092) using WSAEventSelect 09:40:44: -> tcp_read(2092) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL 09:40:44: -> tcp_read(2035) using WSAEventSelect 09:40:44: -> tcp_read(2035) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- process_this_directory 09:40:44: -> tcp_read(1978) using WSAEventSelect 09:40:44: -> tcp_read(1978) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory 09:40:44: S -> do_dir_proc() after predirent call ParseTag_Dir() 09:40:44: -> tcp_read(1800) using WSAEventSelect 09:40:44: -> tcp_read(1800) immediate timeout previous thread count -1/0 09:40:44: S -> ParseTag_Dir(.,,,0,) 09:40:44: -> tcp_read(1729) using WSAEventSelect 09:40:44: -> tcp_read(1729) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory(C:/PROGRA~3/MARCHH~1/myrepo/samp,.,(null),(null),0,(null),0) 09:40:44: S -> open_directory() directory_stack_size increased by one to 1 09:40:44: -> tcp_read(1559) using WSAEventSelect 09:40:44: -> tcp_read(1559) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory, (!remote) try and find a mapping file in this directory . 09:40:44: S -> RCS_parse(.directory_history,C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: -> tcp_read(1388) using WSAEventSelect 09:40:44: -> tcp_read(1388) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/.directory_history,v) 09:40:44: -> tcp_read(1304) using WSAEventSelect 09:40:44: -> tcp_read(1304) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/.directory_history,v) failed to open file 1 times 09:40:44: -> tcp_read(1192) using WSAEventSelect 09:40:44: -> tcp_read(1192) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/.directory_history,v) file does not exist, so return 0 09:40:44: S -> rcsbuf_open failed 09:40:44: -> tcp_read(1039) using WSAEventSelect 09:40:44: -> tcp_read(1039) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/Attic/.directory_history,v) 09:40:44: -> tcp_read(949) using WSAEventSelect 09:40:44: -> tcp_read(949) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/Attic/.directory_history,v) failed to open file 1 times 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/Attic/.directory_history,v) file does not exist, so return 0 09:40:44: -> tcp_read(708) using WSAEventSelect 09:40:44: -> tcp_read(708) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open failed 09:40:44: S -> No mapping file in this directory. 09:40:44: -> tcp_read(620) using WSAEventSelect 09:40:44: -> tcp_read(620) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory copy the tag and date. 09:40:44: S -> open_directory copied the tag and date. 09:40:44: -> tcp_read(508) using WSAEventSelect 09:40:44: -> tcp_read(508) immediate timeout previous thread count -1/0 09:40:44: S -> Look for rename script file CVS/Rename 09:40:44: -> tcp_read(452) using WSAEventSelect 09:40:44: -> tcp_read(452) immediate timeout previous thread count -1/0 09:40:44: S -> Rename script file does not exist 09:40:44: -> tcp_read(401) using WSAEventSelect 09:40:44: -> tcp_read(401) immediate timeout previous thread count -1/0 09:40:44: S -> directory opened 09:40:44: S -> fileattr_startdir(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: S -> do_dir_proc() -- call-back dir entry proc (if any) 09:40:44: -> tcp_read(230) using WSAEventSelect 09:40:44: -> tcp_read(230) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc. 09:40:44: S -> do_dir_proc() -- only process the dir if the return code was 0. 09:40:44: -> tcp_read(60) using WSAEventSelect 09:40:44: -> tcp_read(60) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- !(frame->which&(W_LOCAL|W_FAKE)) 09:40:44: S -> debug: 18 09:40:44: S -> debug: 19 09:40:44: -> tcp_read(5059) using WSAEventSelect 09:40:44: -> tcp_read(5059) immediate timeout previous thread count -1/0 09:40:44: S -> debug: 20 09:40:44: -> tcp_read(5032) using WSAEventSelect 09:40:44: -> tcp_read(5032) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: begin 09:40:44: S -> do_recursion: Check the value in CVSADM_ROOT 09:40:44: -> tcp_read(4932) using WSAEventSelect 09:40:44: -> tcp_read(4932) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: Fill in repository with the current repository 09:40:44: S -> (repository && (server_active || !current_parsed_root->isremote)) 09:40:44: -> tcp_read(4771) using WSAEventSelect 09:40:44: -> tcp_read(4771) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: S -> lookup_module2() 09:40:44: S -> lookup_module2(samp) after rename? 09:40:44: -> tcp_read(4619) using WSAEventSelect 09:40:44: -> tcp_read(4619) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(4495) using WSAEventSelect 09:40:44: -> tcp_read(4495) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp,4) 09:40:44: S -> _lookup_module2 !p lookup_repository_module(samp) 09:40:44: -> tcp_read(4388) using WSAEventSelect 09:40:44: -> tcp_read(4388) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(samp) 09:40:44: -> tcp_read(4340) using WSAEventSelect 09:40:44: -> tcp_read(4340) immediate timeout previous thread count -1/0 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: -> tcp_read(4200) using WSAEventSelect 09:40:44: -> tcp_read(4200) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp) 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: -> tcp_read(4069) using WSAEventSelect 09:40:44: -> tcp_read(4069) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: -> tcp_read(3886) using WSAEventSelect 09:40:44: -> tcp_read(3886) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: S -> map_repository - return(repository) "C:/PROGRA~3/MARCHH~1/myrepo/samp" 09:40:44: -> tcp_read(3741) using WSAEventSelect 09:40:44: -> tcp_read(3741) immediate timeout previous thread count -1/0 09:40:44: S -> Repository = C:/PROGRA~3/MARCHH~1/myrepo/samp 09:40:44: S -> Mapped repository = C:/PROGRA~3/MARCHH~1/myrepo/samp 09:40:44: -> tcp_read(3608) using WSAEventSelect 09:40:44: -> tcp_read(3608) immediate timeout previous thread count -1/0 09:40:44: S -> * The filesdoneproc needs to be called for each directory where files 09:40:44: S -> * processed, or each directory that is processed by a call where no 09:40:44: S -> * directories were passed in. In fact, the only time we don't want to 09:40:44: S -> * call back the filesdoneproc is when we are processing directories that 09:40:44: -> tcp_read(3258) using WSAEventSelect 09:40:44: -> tcp_read(3258) immediate timeout previous thread count -1/0 09:40:44: S -> * were passed in on the command line (or in the special case of `.' when 09:40:44: S -> * we were called with no args 09:40:44: -> tcp_read(3121) using WSAEventSelect 09:40:44: -> tcp_read(3121) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: dirlist == NULL && filelist == NULL 09:40:44: S -> do_recursion: dodoneproc=1 09:40:44: -> tcp_read(3010) using WSAEventSelect 09:40:44: -> tcp_read(3010) immediate timeout previous thread count -1/0 09:40:44: S -> * If filelist or dirlist is already set, we don't look again. Otherwise, 09:40:44: S -> * find the files and directories 09:40:44: -> tcp_read(2870) using WSAEventSelect 09:40:44: -> tcp_read(2870) immediate timeout previous thread count -1/0 09:40:44: S -> * both lists were NULL, so start from scratch 09:40:44: S -> * In the !(which & W_LOCAL) case, we filled in repository 09:40:44: -> tcp_read(2731) using WSAEventSelect 09:40:44: -> tcp_read(2731) immediate timeout previous thread count -1/0 09:40:44: S -> earlier in the function. In the (which & W_LOCAL) case, 09:40:44: S -> the Find_Names function is going to look through the 09:40:44: -> tcp_read(2583) using WSAEventSelect 09:40:44: -> tcp_read(2583) immediate timeout previous thread count -1/0 09:40:44: S -> Entries file. If we do not have a repository, that 09:40:44: S -> does not make sense, so we insist upon having a 09:40:44: -> tcp_read(2445) using WSAEventSelect 09:40:44: -> tcp_read(2445) immediate timeout previous thread count -1/0 09:40:44: S -> repository at this point. Name_Repository will give a 09:40:44: S -> reasonable error message. 09:40:44: S -> do_recursion: repository != NULL 09:40:44: -> tcp_read(2275) using WSAEventSelect 09:40:44: -> tcp_read(2275) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: mapped_repository != NULL 09:40:44: S -> do_recursion: find the files and fill in entries if appropriate 09:40:44: -> tcp_read(2137) using WSAEventSelect 09:40:44: -> tcp_read(2137) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: process_this_directory, call Find_Names() 09:40:44: S -> lookup_module2() 09:40:44: -> tcp_read(2030) using WSAEventSelect 09:40:44: -> tcp_read(2030) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp) after rename? 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(1921) using WSAEventSelect 09:40:44: -> tcp_read(1921) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: S -> lookup_module2(samp,5) 09:40:44: -> tcp_read(1814) using WSAEventSelect 09:40:44: -> tcp_read(1814) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 !p lookup_repository_module(samp) 09:40:44: S -> lookup_repository_module(samp) 09:40:44: -> tcp_read(1699) using WSAEventSelect 09:40:44: -> tcp_read(1699) immediate timeout previous thread count -1/0 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right((null),(null)) 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: -> tcp_read(1420) using WSAEventSelect 09:40:44: -> tcp_read(1420) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: -> tcp_read(1237) using WSAEventSelect 09:40:44: -> tcp_read(1237) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: -> tcp_read(1180) using WSAEventSelect 09:40:44: -> tcp_read(1180) immediate timeout previous thread count -1/0 09:40:44: S -> find_virtual_rcs(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: S -> lookup_module2() 09:40:44: -> tcp_read(1078) using WSAEventSelect 09:40:44: -> tcp_read(1078) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp) after rename? 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(969) using WSAEventSelect 09:40:44: -> tcp_read(969) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(902) using WSAEventSelect 09:40:44: -> tcp_read(902) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp,6) 09:40:44: S -> _lookup_module2 !p lookup_repository_module(samp) 09:40:44: -> tcp_read(795) using WSAEventSelect 09:40:44: -> tcp_read(795) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: -> tcp_read(694) using WSAEventSelect 09:40:44: -> tcp_read(694) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp) 09:40:44: -> tcp_read(542) using WSAEventSelect 09:40:44: -> tcp_read(542) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: -> tcp_read(404) using WSAEventSelect 09:40:44: -> tcp_read(404) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: S -> find_rename_rcs(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: -> tcp_read(169) using WSAEventSelect 09:40:44: -> tcp_read(169) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: Find_Names got a filelist 09:40:44: S -> lookup_module2() 09:40:44: -> tcp_read(78) using WSAEventSelect 09:40:44: -> tcp_read(78) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp) after rename? 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(5022) using WSAEventSelect 09:40:44: -> tcp_read(5022) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp,7) 09:40:44: S -> _lookup_module2 !p lookup_repository_module(samp) 09:40:44: -> tcp_read(4915) using WSAEventSelect 09:40:44: -> tcp_read(4915) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: -> tcp_read(4814) using WSAEventSelect 09:40:44: -> tcp_read(4814) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right((null),(null)) 09:40:44: -> tcp_read(4654) using WSAEventSelect 09:40:44: -> tcp_read(4654) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: -> tcp_read(4516) using WSAEventSelect 09:40:44: -> tcp_read(4516) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: -> tcp_read(4348) using WSAEventSelect 09:40:44: -> tcp_read(4348) immediate timeout previous thread count -1/0 09:40:44: S -> find_virtual_dirs(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: S -> lookup_module2() 09:40:44: -> tcp_read(4245) using WSAEventSelect 09:40:44: -> tcp_read(4245) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp) after rename? 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(4136) using WSAEventSelect 09:40:44: -> tcp_read(4136) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(4069) using WSAEventSelect 09:40:44: -> tcp_read(4069) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp,8) 09:40:44: S -> _lookup_module2 !p lookup_repository_module(samp) 09:40:44: -> tcp_read(3962) using WSAEventSelect 09:40:44: -> tcp_read(3962) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: -> tcp_read(3774) using WSAEventSelect 09:40:44: -> tcp_read(3774) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp) 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: -> tcp_read(3643) using WSAEventSelect 09:40:44: -> tcp_read(3643) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: -> tcp_read(3460) using WSAEventSelect 09:40:44: -> tcp_read(3460) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: S -> find_rename_dirs(C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: S -> do_recursion: process the files (if any) 09:40:44: -> tcp_read(3276) using WSAEventSelect 09:40:44: -> tcp_read(3276) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: read lock it if necessary 09:40:44: S -> * For the server, we handle notifications in a completely different 09:40:44: -> tcp_read(3133) using WSAEventSelect 09:40:44: -> tcp_read(3133) immediate timeout previous thread count -1/0 09:40:44: S -> place (server_notify). For local, we can't do them here--we don't 09:40:44: S -> have writelocks in place, and there is no way to get writelocks here 09:40:44: -> tcp_read(2959) using WSAEventSelect 09:40:44: -> tcp_read(2959) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: process the files by calling walklist() 09:40:44: S -> do_file_proc: process the files "hi.doc" 09:40:44: -> tcp_read(2830) using WSAEventSelect 09:40:44: -> tcp_read(2830) immediate timeout previous thread count -1/0 09:40:44: S -> (server_active || !current_parsed_root->isremote) 09:40:44: S -> map_filename(C:/PROGRA~3/MARCHH~1/myrepo/samp,hi.doc) 09:40:44: -> tcp_read(2692) using WSAEventSelect 09:40:44: -> tcp_read(2692) immediate timeout previous thread count -1/0 09:40:44: S -> map_filename - call map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi.doc) 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi.doc) 09:40:44: -> tcp_read(2526) using WSAEventSelect 09:40:44: -> tcp_read(2526) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() 09:40:44: S -> lookup_module2(samp/hi.doc) after rename? 09:40:44: -> tcp_read(2433) using WSAEventSelect 09:40:44: -> tcp_read(2433) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(2376) using WSAEventSelect 09:40:44: -> tcp_read(2376) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: S -> lookup_module2(samp/hi.doc,9) 09:40:44: -> tcp_read(2262) using WSAEventSelect 09:40:44: -> tcp_read(2262) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 p!=NULL lookup_repository_module(samp) 09:40:44: S -> lookup_repository_module(samp) 09:40:44: -> tcp_read(2142) using WSAEventSelect 09:40:44: -> tcp_read(2142) immediate timeout previous thread count -1/0 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: -> tcp_read(2002) using WSAEventSelect 09:40:44: -> tcp_read(2002) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp/hi.doc) 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: -> tcp_read(1864) using WSAEventSelect 09:40:44: -> tcp_read(1864) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: -> tcp_read(1681) using WSAEventSelect 09:40:44: -> tcp_read(1681) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: S -> map_repository - return(repository) "C:/PROGRA~3/MARCHH~1/myrepo/samp/hi.doc" 09:40:44: -> tcp_read(1529) using WSAEventSelect 09:40:44: -> tcp_read(1529) immediate timeout previous thread count -1/0 09:40:44: S -> map_filename - map_repository() returns C:/PROGRA~3/MARCHH~1/myrepo/samp/hi.doc 09:40:44: S -> do_file_proc: mapped name of file "hi.doc" 09:40:44: -> tcp_read(1372) using WSAEventSelect 09:40:44: -> tcp_read(1372) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: frfile->frame->dosrcs && mapped_file_repository 09:40:44: S -> RCS_parse(hi.doc,C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: -> tcp_read(1225) using WSAEventSelect 09:40:44: -> tcp_read(1225) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi.doc,v) 09:40:44: S -> normalize_path(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi.doc,v) 09:40:44: -> tcp_read(1078) using WSAEventSelect 09:40:44: -> tcp_read(1078) immediate timeout previous thread count -1/0 09:40:44: S -> ...returns C:/PROGRA~3/MARCHH~1/myrepo/samp/hi.doc,v 09:40:44: S -> Lock server command sent: Lock Read Full|C:/PROGRA~3/MARCHH~1/myrepo/samp/hi.doc,v 09:40:44: -> tcp_read(905) using WSAEventSelect 09:40:44: -> tcp_read(905) immediate timeout previous thread count -1/0 09:40:44: S -> Lock server command received: 000 OK Lock granted (9) 09:40:44: S -> do_lock_server: [09:40:44] obtained lock 9 in hi.doc,v 09:40:44: -> tcp_read(759) using WSAEventSelect 09:40:44: -> tcp_read(759) immediate timeout previous thread count -1/0 09:40:44: S -> do_lock_file: lock server returns 9 09:40:44: -> tcp_read(706) using WSAEventSelect 09:40:44: -> tcp_read(706) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(/myrepo/samp/hi.doc,v) -- obtained a new lock 09:40:44: -> tcp_read(631) using WSAEventSelect 09:40:44: -> tcp_read(631) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_fill(windows,BigMemory=0) 09:40:44: S -> rcsbuf_fill(0): expanded to 8192 (was: 0, req: 5120, inc: 5120, RCSBUF_BUFSIZE: 5120). 09:40:44: -> tcp_read(477) using WSAEventSelect 09:40:44: -> tcp_read(477) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: call findnode_fn() 09:40:44: S -> do_file_proc: no node? 09:40:44: -> tcp_read(387) using WSAEventSelect 09:40:44: -> tcp_read(387) immediate timeout previous thread count -1/0 09:40:44: S -> Version_TS((null),(null),1) 09:40:44: S -> Version_TS -- findnode() found nothing. 09:40:44: -> tcp_read(285) using WSAEventSelect 09:40:44: -> tcp_read(285) immediate timeout previous thread count -1/0 09:40:44: S -> Version_TS - call RCS_getversion("C:/PROGRA~3/MARCHH~1/myrepo/samp/hi.doc,v",(null),(null),1,0) 09:40:44: S -> *RCS_head(HEAD) 09:40:44: -> tcp_read(139) using WSAEventSelect 09:40:44: -> tcp_read(139) immediate timeout previous thread count -1/0 hi.doc 09:40:44: S -> do_file_proc: finished fileproc() 09:40:44: -> tcp_read(79) using WSAEventSelect 09:40:44: -> tcp_read(79) immediate timeout previous thread count -1/0 09:40:44: S -> Lock server command sent: Unlock 9 09:40:44: -> tcp_read(24) using WSAEventSelect 09:40:44: -> tcp_read(24) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> Lock server command received: 000 OK Unlocked 09:40:44: S -> do_unlock_file: (lock 9) lock server returns 0 09:40:44: S -> do_file_proc: return 09:40:44: -> tcp_read(4976) using WSAEventSelect 09:40:44: -> tcp_read(4976) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: process the files "hi1.txt" 09:40:44: S -> (server_active || !current_parsed_root->isremote) 09:40:44: S -> map_filename(C:/PROGRA~3/MARCHH~1/myrepo/samp,hi1.txt) 09:40:44: -> tcp_read(4778) using WSAEventSelect 09:40:44: -> tcp_read(4778) immediate timeout previous thread count -1/0 09:40:44: S -> map_filename - call map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi1.txt) 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi1.txt) 09:40:44: -> tcp_read(4610) using WSAEventSelect 09:40:44: -> tcp_read(4610) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() 09:40:44: S -> lookup_module2(samp/hi1.txt) after rename? 09:40:44: -> tcp_read(4516) using WSAEventSelect 09:40:44: -> tcp_read(4516) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(4459) using WSAEventSelect 09:40:44: -> tcp_read(4459) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(4392) using WSAEventSelect 09:40:44: -> tcp_read(4392) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/hi1.txt,10) 09:40:44: S -> _lookup_module2 p!=NULL lookup_repository_module(samp) 09:40:44: -> tcp_read(4271) using WSAEventSelect 09:40:44: -> tcp_read(4271) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: -> tcp_read(4170) using WSAEventSelect 09:40:44: -> tcp_read(4170) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: -> tcp_read(4083) using WSAEventSelect 09:40:44: -> tcp_read(4083) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp/hi1.txt) 09:40:44: -> tcp_read(4010) using WSAEventSelect 09:40:44: -> tcp_read(4010) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: -> tcp_read(3872) using WSAEventSelect 09:40:44: -> tcp_read(3872) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: -> tcp_read(3704) using WSAEventSelect 09:40:44: -> tcp_read(3704) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository - return(repository) "C:/PROGRA~3/MARCHH~1/myrepo/samp/hi1.txt" 09:40:44: S -> map_filename - map_repository() returns C:/PROGRA~3/MARCHH~1/myrepo/samp/hi1.txt 09:40:44: -> tcp_read(3510) using WSAEventSelect 09:40:44: -> tcp_read(3510) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: mapped name of file "hi1.txt" 09:40:44: S -> do_file_proc: frfile->frame->dosrcs && mapped_file_repository 09:40:44: -> tcp_read(3370) using WSAEventSelect 09:40:44: -> tcp_read(3370) immediate timeout previous thread count -1/0 09:40:44: S -> RCS_parse(hi1.txt,C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: -> tcp_read(3301) using WSAEventSelect 09:40:44: -> tcp_read(3301) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi1.txt,v) 09:40:44: -> tcp_read(3228) using WSAEventSelect 09:40:44: -> tcp_read(3228) immediate timeout previous thread count -1/0 09:40:44: S -> normalize_path(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi1.txt,v) 09:40:44: S -> ...returns C:/PROGRA~3/MARCHH~1/myrepo/samp/hi1.txt,v 09:40:44: -> tcp_read(3081) using WSAEventSelect 09:40:44: -> tcp_read(3081) immediate timeout previous thread count -1/0 09:40:44: S -> Lock server command sent: Lock Read Full|C:/PROGRA~3/MARCHH~1/myrepo/samp/hi1.txt,v 09:40:44: -> tcp_read(2977) using WSAEventSelect 09:40:44: -> tcp_read(2977) immediate timeout previous thread count -1/0 09:40:44: S -> Lock server command received: 000 OK Lock granted (10) 09:40:44: S -> do_lock_server: [09:40:44] obtained lock 10 in hi1.txt,v 09:40:44: -> tcp_read(2828) using WSAEventSelect 09:40:44: -> tcp_read(2828) immediate timeout previous thread count -1/0 09:40:44: S -> do_lock_file: lock server returns 10 09:40:44: -> tcp_read(2774) using WSAEventSelect 09:40:44: -> tcp_read(2774) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(/myrepo/samp/hi1.txt,v) -- obtained a new lock 09:40:44: -> tcp_read(2698) using WSAEventSelect 09:40:44: -> tcp_read(2698) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_fill(windows,BigMemory=0) 09:40:44: S -> rcsbuf_fill(0): expanded to 8192 (was: 0, req: 5120, inc: 5120, RCSBUF_BUFSIZE: 5120). 09:40:44: -> tcp_read(2544) using WSAEventSelect 09:40:44: -> tcp_read(2544) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: call findnode_fn() 09:40:44: S -> do_file_proc: no node? 09:40:44: -> tcp_read(2454) using WSAEventSelect 09:40:44: -> tcp_read(2454) immediate timeout previous thread count -1/0 09:40:44: S -> Version_TS((null),(null),1) 09:40:44: S -> Version_TS -- findnode() found nothing. 09:40:44: -> tcp_read(2352) using WSAEventSelect 09:40:44: -> tcp_read(2352) immediate timeout previous thread count -1/0 09:40:44: S -> Version_TS - call RCS_getversion("C:/PROGRA~3/MARCHH~1/myrepo/samp/hi1.txt,v",(null),(null),1,0) 09:40:44: S -> *RCS_head(HEAD) 09:40:44: -> tcp_read(2205) using WSAEventSelect 09:40:44: -> tcp_read(2205) immediate timeout previous thread count -1/0 hi1.txt 09:40:44: S -> do_file_proc: finished fileproc() 09:40:44: S -> Lock server command sent: Unlock 10 09:40:44: -> tcp_read(2088) using WSAEventSelect 09:40:44: -> tcp_read(2088) immediate timeout previous thread count -1/0 09:40:44: S -> Lock server command received: 000 OK Unlocked 09:40:44: S -> do_unlock_file: (lock 10) lock server returns 0 09:40:44: -> tcp_read(1957) using WSAEventSelect 09:40:44: -> tcp_read(1957) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: return 09:40:44: -> tcp_read(1919) using WSAEventSelect 09:40:44: -> tcp_read(1919) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: process the files "hi2.txt" 09:40:44: S -> (server_active || !current_parsed_root->isremote) 09:40:44: -> tcp_read(1793) using WSAEventSelect 09:40:44: -> tcp_read(1793) immediate timeout previous thread count -1/0 09:40:44: S -> map_filename(C:/PROGRA~3/MARCHH~1/myrepo/samp,hi2.txt) 09:40:44: S -> map_filename - call map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi2.txt) 09:40:44: -> tcp_read(1627) using WSAEventSelect 09:40:44: -> tcp_read(1627) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi2.txt) 09:40:44: S -> lookup_module2() 09:40:44: -> tcp_read(1519) using WSAEventSelect 09:40:44: -> tcp_read(1519) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/hi2.txt) after rename? 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(1402) using WSAEventSelect 09:40:44: -> tcp_read(1402) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: S -> lookup_module2(samp/hi2.txt,11) 09:40:44: -> tcp_read(1286) using WSAEventSelect 09:40:44: -> tcp_read(1286) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 p!=NULL lookup_repository_module(samp) 09:40:44: S -> lookup_repository_module(samp) 09:40:44: -> tcp_read(1166) using WSAEventSelect 09:40:44: -> tcp_read(1166) immediate timeout previous thread count -1/0 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp/hi2.txt) 09:40:44: -> tcp_read(953) using WSAEventSelect 09:40:44: -> tcp_read(953) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: -> tcp_read(815) using WSAEventSelect 09:40:44: -> tcp_read(815) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: -> tcp_read(647) using WSAEventSelect 09:40:44: -> tcp_read(647) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository - return(repository) "C:/PROGRA~3/MARCHH~1/myrepo/samp/hi2.txt" 09:40:44: S -> map_filename - map_repository() returns C:/PROGRA~3/MARCHH~1/myrepo/samp/hi2.txt 09:40:44: -> tcp_read(453) using WSAEventSelect 09:40:44: -> tcp_read(453) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: mapped name of file "hi2.txt" 09:40:44: -> tcp_read(392) using WSAEventSelect 09:40:44: -> tcp_read(392) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: frfile->frame->dosrcs && mapped_file_repository 09:40:44: S -> RCS_parse(hi2.txt,C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: -> tcp_read(244) using WSAEventSelect 09:40:44: -> tcp_read(244) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi2.txt,v) 09:40:44: -> tcp_read(171) using WSAEventSelect 09:40:44: -> tcp_read(171) immediate timeout previous thread count -1/0 09:40:44: S -> normalize_path(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi2.txt,v) 09:40:44: S -> ...returns C:/PROGRA~3/MARCHH~1/myrepo/samp/hi2.txt,v 09:40:44: -> tcp_read(24) using WSAEventSelect 09:40:44: -> tcp_read(24) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> Lock server command sent: Lock Read Full|C:/PROGRA~3/MARCHH~1/myrepo/samp/hi2.txt,v 09:40:44: S -> Lock server command received: 000 OK Lock granted (11) 09:40:44: S -> do_lock_server: [09:40:44] obtained lock 11 in hi2.txt,v 09:40:44: -> tcp_read(4891) using WSAEventSelect 09:40:44: -> tcp_read(4891) immediate timeout previous thread count -1/0 09:40:44: S -> do_lock_file: lock server returns 11 09:40:44: -> tcp_read(4837) using WSAEventSelect 09:40:44: -> tcp_read(4837) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(/myrepo/samp/hi2.txt,v) -- obtained a new lock 09:40:44: -> tcp_read(4761) using WSAEventSelect 09:40:44: -> tcp_read(4761) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_fill(windows,BigMemory=0) 09:40:44: S -> rcsbuf_fill(0): expanded to 8192 (was: 0, req: 5120, inc: 5120, RCSBUF_BUFSIZE: 5120). 09:40:44: -> tcp_read(4607) using WSAEventSelect 09:40:44: -> tcp_read(4607) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_fill(windows,BigMemory=0) 09:40:44: -> tcp_read(4557) using WSAEventSelect 09:40:44: -> tcp_read(4557) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_fill(0): expanded to 16384 (was: 8192, req: 13312, inc: 5120, RCSBUF_BUFSIZE: 5120). 09:40:44: -> tcp_read(4448) using WSAEventSelect 09:40:44: -> tcp_read(4448) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: call findnode_fn() 09:40:44: -> tcp_read(4398) using WSAEventSelect 09:40:44: -> tcp_read(4398) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: no node? 09:40:44: S -> Version_TS((null),(null),1) 09:40:44: -> tcp_read(4313) using WSAEventSelect 09:40:44: -> tcp_read(4313) immediate timeout previous thread count -1/0 09:40:44: S -> Version_TS -- findnode() found nothing. 09:40:44: -> tcp_read(4256) using WSAEventSelect 09:40:44: -> tcp_read(4256) immediate timeout previous thread count -1/0 09:40:44: S -> Version_TS - call RCS_getversion("C:/PROGRA~3/MARCHH~1/myrepo/samp/hi2.txt,v",(null),(null),1,0) 09:40:44: S -> *RCS_head(HEAD) 09:40:44: -> tcp_read(4109) using WSAEventSelect 09:40:44: -> tcp_read(4109) immediate timeout previous thread count -1/0 hi2.txt 09:40:44: S -> do_file_proc: finished fileproc() 09:40:44: -> tcp_read(4048) using WSAEventSelect 09:40:44: -> tcp_read(4048) immediate timeout previous thread count -1/0 09:40:44: S -> Lock server command sent: Unlock 11 09:40:44: S -> Lock server command received: 000 OK Unlocked 09:40:44: -> tcp_read(3926) using WSAEventSelect 09:40:44: -> tcp_read(3926) immediate timeout previous thread count -1/0 09:40:44: S -> do_unlock_file: (lock 11) lock server returns 0 09:40:44: -> tcp_read(3861) using WSAEventSelect 09:40:44: -> tcp_read(3861) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: return 09:40:44: -> tcp_read(3823) using WSAEventSelect 09:40:44: -> tcp_read(3823) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: process the files "hi3.txt" 09:40:44: S -> (server_active || !current_parsed_root->isremote) 09:40:44: -> tcp_read(3697) using WSAEventSelect 09:40:44: -> tcp_read(3697) immediate timeout previous thread count -1/0 09:40:44: S -> map_filename(C:/PROGRA~3/MARCHH~1/myrepo/samp,hi3.txt) 09:40:44: S -> map_filename - call map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi3.txt) 09:40:44: -> tcp_read(3531) using WSAEventSelect 09:40:44: -> tcp_read(3531) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi3.txt) 09:40:44: S -> lookup_module2() 09:40:44: -> tcp_read(3423) using WSAEventSelect 09:40:44: -> tcp_read(3423) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/hi3.txt) after rename? 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(3306) using WSAEventSelect 09:40:44: -> tcp_read(3306) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(3239) using WSAEventSelect 09:40:44: -> tcp_read(3239) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/hi3.txt,12) 09:40:44: S -> _lookup_module2 p!=NULL lookup_repository_module(samp) 09:40:44: -> tcp_read(3118) using WSAEventSelect 09:40:44: -> tcp_read(3118) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: -> tcp_read(3017) using WSAEventSelect 09:40:44: -> tcp_read(3017) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp/hi3.txt) 09:40:44: -> tcp_read(2857) using WSAEventSelect 09:40:44: -> tcp_read(2857) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: -> tcp_read(2719) using WSAEventSelect 09:40:44: -> tcp_read(2719) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: -> tcp_read(2551) using WSAEventSelect 09:40:44: -> tcp_read(2551) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository - return(repository) "C:/PROGRA~3/MARCHH~1/myrepo/samp/hi3.txt" 09:40:44: S -> map_filename - map_repository() returns C:/PROGRA~3/MARCHH~1/myrepo/samp/hi3.txt 09:40:44: -> tcp_read(2357) using WSAEventSelect 09:40:44: -> tcp_read(2357) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: mapped name of file "hi3.txt" 09:40:44: S -> do_file_proc: frfile->frame->dosrcs && mapped_file_repository 09:40:44: -> tcp_read(2217) using WSAEventSelect 09:40:44: -> tcp_read(2217) immediate timeout previous thread count -1/0 09:40:44: S -> RCS_parse(hi3.txt,C:/PROGRA~3/MARCHH~1/myrepo/samp) 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi3.txt,v) 09:40:44: -> tcp_read(2075) using WSAEventSelect 09:40:44: -> tcp_read(2075) immediate timeout previous thread count -1/0 09:40:44: S -> normalize_path(C:/PROGRA~3/MARCHH~1/myrepo/samp/hi3.txt,v) 09:40:44: S -> ...returns C:/PROGRA~3/MARCHH~1/myrepo/samp/hi3.txt,v 09:40:44: -> tcp_read(1928) using WSAEventSelect 09:40:44: -> tcp_read(1928) immediate timeout previous thread count -1/0 09:40:44: S -> Lock server command sent: Lock Read Full|C:/PROGRA~3/MARCHH~1/myrepo/samp/hi3.txt,v 09:40:44: S -> Lock server command received: 000 OK Lock granted (12) 09:40:44: -> tcp_read(1749) using WSAEventSelect 09:40:44: -> tcp_read(1749) immediate timeout previous thread count -1/0 09:40:44: S -> do_lock_server: [09:40:44] obtained lock 12 in hi3.txt,v 09:40:44: S -> do_lock_file: lock server returns 12 09:40:44: -> tcp_read(1621) using WSAEventSelect 09:40:44: -> tcp_read(1621) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(/myrepo/samp/hi3.txt,v) -- obtained a new lock 09:40:44: -> tcp_read(1545) using WSAEventSelect 09:40:44: -> tcp_read(1545) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_fill(windows,BigMemory=0) 09:40:44: S -> rcsbuf_fill(0): expanded to 8192 (was: 0, req: 5120, inc: 5120, RCSBUF_BUFSIZE: 5120). 09:40:44: -> tcp_read(1391) using WSAEventSelect 09:40:44: -> tcp_read(1391) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: call findnode_fn() 09:40:44: -> tcp_read(1341) using WSAEventSelect 09:40:44: -> tcp_read(1341) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: no node? 09:40:44: S -> Version_TS((null),(null),1) 09:40:44: -> tcp_read(1256) using WSAEventSelect 09:40:44: -> tcp_read(1256) immediate timeout previous thread count -1/0 09:40:44: S -> Version_TS -- findnode() found nothing. 09:40:44: -> tcp_read(1199) using WSAEventSelect 09:40:44: -> tcp_read(1199) immediate timeout previous thread count -1/0 09:40:44: S -> Version_TS - call RCS_getversion("C:/PROGRA~3/MARCHH~1/myrepo/samp/hi3.txt,v",(null),(null),1,0) 09:40:44: -> tcp_read(1085) using WSAEventSelect 09:40:44: -> tcp_read(1085) immediate timeout previous thread count -1/0 09:40:44: S -> *RCS_head(HEAD) hi3.txt 09:40:44: -> tcp_read(1042) using WSAEventSelect 09:40:44: -> tcp_read(1042) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: finished fileproc() 09:40:44: S -> Lock server command sent: Unlock 12 09:40:44: -> tcp_read(935) using WSAEventSelect 09:40:44: -> tcp_read(935) immediate timeout previous thread count -1/0 09:40:44: S -> Lock server command received: 000 OK Unlocked 09:40:44: S -> do_unlock_file: (lock 12) lock server returns 0 09:40:44: -> tcp_read(804) using WSAEventSelect 09:40:44: -> tcp_read(804) immediate timeout previous thread count -1/0 09:40:44: S -> do_file_proc: return 09:40:44: -> tcp_read(766) using WSAEventSelect 09:40:44: -> tcp_read(766) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: unlock it by calling Lock_Cleanup_Directory() 09:40:44: S -> do_recursion: clean up by calling dellist(filelist) 09:40:44: -> tcp_read(620) using WSAEventSelect 09:40:44: -> tcp_read(620) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: call-back files done proc (if any) 09:40:44: S -> do_recursion: no: don't call-back files done proc (process_this_directorydodoneprocframe->filesdoneproc == NULL) 09:40:44: -> tcp_read(422) using WSAEventSelect 09:40:44: -> tcp_read(422) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: at skip_directory 09:40:44: S -> (repository && (server_active || !current_parsed_root->isremote)) 09:40:44: -> tcp_read(289) using WSAEventSelect 09:40:44: -> tcp_read(289) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_write() 09:40:44: S -> fileattr_free() 09:40:44: -> tcp_read(222) using WSAEventSelect 09:40:44: -> tcp_read(222) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: process the directories (if necessary) 09:40:44: S -> do_recursion: really process the directories (if necessary) 09:40:44: -> tcp_read(73) using WSAEventSelect 09:40:44: -> tcp_read(73) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion() -- walklist (dirlist !=NULL, do_dir_proc, (void *) &frent) 09:40:44: S -> do_dir_proc() 09:40:44: S -> do_dir_proc() update_dir=testfilt 09:40:44: S -> do_dir_proc() -- set up update_dir - skip dots if not at start 09:40:44: -> tcp_read(4939) using WSAEventSelect 09:40:44: -> tcp_read(4939) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() after all that now update_dir=testfilt/arg 09:40:44: S -> (server_active || !current_parsed_root->isremote) 2 09:40:44: -> tcp_read(4796) using WSAEventSelect 09:40:44: -> tcp_read(4796) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg) 09:40:44: S -> lookup_module2() 09:40:44: -> tcp_read(4692) using WSAEventSelect 09:40:44: -> tcp_read(4692) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/arg) after rename? 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(4579) using WSAEventSelect 09:40:44: -> tcp_read(4579) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(4512) using WSAEventSelect 09:40:44: -> tcp_read(4512) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/arg,13) 09:40:44: S -> _lookup_module2 p!=NULL lookup_repository_module(samp) 09:40:44: -> tcp_read(4395) using WSAEventSelect 09:40:44: -> tcp_read(4395) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: -> tcp_read(4294) using WSAEventSelect 09:40:44: -> tcp_read(4294) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp/arg) 09:40:44: -> tcp_read(4138) using WSAEventSelect 09:40:44: -> tcp_read(4138) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: -> tcp_read(3889) using WSAEventSelect 09:40:44: -> tcp_read(3889) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: S -> map_repository - return(repository) "C:/PROGRA~3/MARCHH~1/myrepo/samp/arg" 09:40:44: -> tcp_read(3740) using WSAEventSelect 09:40:44: -> tcp_read(3740) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote 09:40:44: -> tcp_read(3658) using WSAEventSelect 09:40:44: -> tcp_read(3658) immediate timeout previous thread count -1/0 09:40:44: S -> ParseTag() 09:40:44: S -> ParseTag_Dir((null),,,0,) 09:40:44: -> tcp_read(3565) using WSAEventSelect 09:40:44: -> tcp_read(3565) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- verify_access 09:40:44: -> tcp_read(3516) using WSAEventSelect 09:40:44: -> tcp_read(3516) immediate timeout previous thread count -1/0 09:40:44: S -> verify_access C:/PROGRA~3/MARCHH~1/myrepo/samp/arg,testfilt/arg,(null) 09:40:44: S -> verify_perm(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg,(null),read,(null),(null)) 09:40:44: -> tcp_read(3335) using WSAEventSelect 09:40:44: -> tcp_read(3335) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm: verify_owner_dir() 09:40:44: S -> verify_owner(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg) 09:40:44: -> tcp_read(3218) using WSAEventSelect 09:40:44: -> tcp_read(3218) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg) 09:40:44: S -> fileattr_read(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg) 09:40:44: -> tcp_read(3066) using WSAEventSelect 09:40:44: -> tcp_read(3066) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() malloc [strlen(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg)=]36+[sizeof(CVS/fileattr.xml)=]17+20=73 09:40:44: S -> fileattr_read() xmalloc fname OK 09:40:44: -> tcp_read(2889) using WSAEventSelect 09:40:44: -> tcp_read(2889) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() allocated memory for fname - will now sprintf() 09:40:44: -> tcp_read(2807) using WSAEventSelect 09:40:44: -> tcp_read(2807) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() ReadXmlFile("C:/PROGRA~3/MARCHH~1/myrepo/samp/arg/CVS/fileattr.xml") 09:40:44: -> tcp_read(2704) using WSAEventSelect 09:40:44: -> tcp_read(2704) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() ReadXmlFile() 09:40:44: -> tcp_read(2657) using WSAEventSelect 09:40:44: -> tcp_read(2657) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() close 09:40:44: -> tcp_read(2618) using WSAEventSelect 09:40:44: -> tcp_read(2618) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() xfree fname 09:40:44: S -> fileattr_read() OK 09:40:44: -> tcp_read(2537) using WSAEventSelect 09:40:44: -> tcp_read(2537) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() - cache directory(fileattr,) 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp/arg",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: -> tcp_read(2305) using WSAEventSelect 09:40:44: -> tcp_read(2305) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() last_component=arg 09:40:44: -> tcp_read(2239) using WSAEventSelect 09:40:44: -> tcp_read(2239) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: S -> cache_directory_permissions() last_component=samp 09:40:44: -> tcp_read(2020) using WSAEventSelect 09:40:44: -> tcp_read(2020) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: S -> cache_directory_permissions() free(C:/PROGRA~3/MARCHH~1/myrepo) 09:40:44: S -> cache_directory_permissions() return 09:40:44: -> tcp_read(1738) using WSAEventSelect 09:40:44: -> tcp_read(1738) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm() Read directory permission cache OK 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp/arg 09:40:44: -> tcp_read(1594) using WSAEventSelect 09:40:44: -> tcp_read(1594) immediate timeout previous thread count -1/0 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: -> tcp_read(1499) using WSAEventSelect 09:40:44: -> tcp_read(1499) immediate timeout previous thread count -1/0 09:40:44: S -> no match at this level 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp 09:40:44: -> tcp_read(1385) using WSAEventSelect 09:40:44: -> tcp_read(1385) immediate timeout previous thread count -1/0 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: -> tcp_read(1290) using WSAEventSelect 09:40:44: -> tcp_read(1290) immediate timeout previous thread count -1/0 09:40:44: S -> no match at this level 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo 09:40:44: -> tcp_read(1181) using WSAEventSelect 09:40:44: -> tcp_read(1181) immediate timeout previous thread count -1/0 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: -> tcp_read(1086) using WSAEventSelect 09:40:44: -> tcp_read(1086) immediate timeout previous thread count -1/0 09:40:44: S -> no match at this level 09:40:44: S -> Match found. user_state = 0, group_state = 0 09:40:44: -> tcp_read(984) using WSAEventSelect 09:40:44: -> tcp_read(984) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm() return 09:40:44: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL 09:40:44: -> tcp_read(889) using WSAEventSelect 09:40:44: -> tcp_read(889) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- process_this_directory 09:40:44: -> tcp_read(832) using WSAEventSelect 09:40:44: -> tcp_read(832) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory 09:40:44: S -> do_dir_proc() after predirent call ParseTag_Dir() 09:40:44: -> tcp_read(654) using WSAEventSelect 09:40:44: -> tcp_read(654) immediate timeout previous thread count -1/0 09:40:44: S -> ParseTag_Dir(arg,,,0,) 09:40:44: -> tcp_read(581) using WSAEventSelect 09:40:44: -> tcp_read(581) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg,arg,(null),(null),0,(null),0) 09:40:44: S -> current_directory is already set 09:40:44: -> tcp_read(432) using WSAEventSelect 09:40:44: -> tcp_read(432) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory() directory_stack_size increased by one to 2 09:40:44: -> tcp_read(355) using WSAEventSelect 09:40:44: -> tcp_read(355) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory, (!remote) try and find a mapping file in this directory . 09:40:44: -> tcp_read(264) using WSAEventSelect 09:40:44: -> tcp_read(264) immediate timeout previous thread count -1/0 09:40:44: S -> RCS_parse(.directory_history,C:/PROGRA~3/MARCHH~1/myrepo/samp/arg) 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg/.directory_history,v) 09:40:44: -> tcp_read(92) using WSAEventSelect 09:40:44: -> tcp_read(92) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg/.directory_history,v) failed to open file 1 times 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg/.directory_history,v) file does not exist, so return 0 09:40:44: S -> rcsbuf_open failed 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg/Attic/.directory_history,v) 09:40:44: -> tcp_read(4845) using WSAEventSelect 09:40:44: -> tcp_read(4845) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg/Attic/.directory_history,v) failed to open file 1 times 09:40:44: -> tcp_read(4723) using WSAEventSelect 09:40:44: -> tcp_read(4723) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg/Attic/.directory_history,v) file does not exist, so return 0 09:40:44: S -> rcsbuf_open failed 09:40:44: -> tcp_read(4560) using WSAEventSelect 09:40:44: -> tcp_read(4560) immediate timeout previous thread count -1/0 09:40:44: S -> No mapping file in this directory. 09:40:44: S -> open_directory copy the tag and date. 09:40:44: -> tcp_read(4453) using WSAEventSelect 09:40:44: -> tcp_read(4453) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory copied the tag and date. 09:40:44: -> tcp_read(4396) using WSAEventSelect 09:40:44: -> tcp_read(4396) immediate timeout previous thread count -1/0 09:40:44: S -> Look for rename script file CVS/Rename 09:40:44: -> tcp_read(4340) using WSAEventSelect 09:40:44: -> tcp_read(4340) immediate timeout previous thread count -1/0 09:40:44: S -> Rename script file does not exist 09:40:44: -> tcp_read(4289) using WSAEventSelect 09:40:44: -> tcp_read(4289) immediate timeout previous thread count -1/0 09:40:44: S -> directory opened 09:40:44: S -> fileattr_startdir(C:/PROGRA~3/MARCHH~1/myrepo/samp/arg) 09:40:44: -> tcp_read(4182) using WSAEventSelect 09:40:44: -> tcp_read(4182) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- call-back dir entry proc (if any) 09:40:44: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc. arg 09:40:44: -> tcp_read(4019) using WSAEventSelect 09:40:44: -> tcp_read(4019) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- cannot process the dir because the return code was R_SKIP_ALL. 09:40:44: S -> more efficient - close directory in do_dir_proc 09:40:44: S -> close_directory() 09:40:44: S -> close_directory() directory_stack_size decreased by one to 1 09:40:44: -> tcp_read(3743) using WSAEventSelect 09:40:44: -> tcp_read(3743) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_write() 09:40:44: S -> fileattr_free() 09:40:44: -> tcp_read(3676) using WSAEventSelect 09:40:44: -> tcp_read(3676) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() 09:40:44: S -> do_dir_proc() update_dir=testfilt 09:40:44: -> tcp_read(3594) using WSAEventSelect 09:40:44: -> tcp_read(3594) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- set up update_dir - skip dots if not at start 09:40:44: S -> do_dir_proc() after all that now update_dir=testfilt/foo 09:40:44: -> tcp_read(3439) using WSAEventSelect 09:40:44: -> tcp_read(3439) immediate timeout previous thread count -1/0 09:40:44: S -> (server_active || !current_parsed_root->isremote) 2 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo) 09:40:44: -> tcp_read(3300) using WSAEventSelect 09:40:44: -> tcp_read(3300) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() 09:40:44: S -> lookup_module2(samp/foo) after rename? 09:40:44: -> tcp_read(3210) using WSAEventSelect 09:40:44: -> tcp_read(3210) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(3153) using WSAEventSelect 09:40:44: -> tcp_read(3153) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: S -> lookup_module2(samp/foo,14) 09:40:44: -> tcp_read(3041) using WSAEventSelect 09:40:44: -> tcp_read(3041) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 p!=NULL lookup_repository_module(samp) 09:40:44: S -> lookup_repository_module(samp) 09:40:44: -> tcp_read(2921) using WSAEventSelect 09:40:44: -> tcp_read(2921) immediate timeout previous thread count -1/0 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: -> tcp_read(2781) using WSAEventSelect 09:40:44: -> tcp_read(2781) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp/foo) 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: -> tcp_read(2646) using WSAEventSelect 09:40:44: -> tcp_read(2646) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: -> tcp_read(2463) using WSAEventSelect 09:40:44: -> tcp_read(2463) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: -> tcp_read(2406) using WSAEventSelect 09:40:44: -> tcp_read(2406) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository - return(repository) "C:/PROGRA~3/MARCHH~1/myrepo/samp/foo" 09:40:44: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote 09:40:44: -> tcp_read(2232) using WSAEventSelect 09:40:44: -> tcp_read(2232) immediate timeout previous thread count -1/0 09:40:44: S -> ParseTag() 09:40:44: S -> ParseTag_Dir((null),,,0,) 09:40:44: -> tcp_read(2139) using WSAEventSelect 09:40:44: -> tcp_read(2139) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- verify_access 09:40:44: -> tcp_read(2090) using WSAEventSelect 09:40:44: -> tcp_read(2090) immediate timeout previous thread count -1/0 09:40:44: S -> verify_access C:/PROGRA~3/MARCHH~1/myrepo/samp/foo,testfilt/foo,(null) 09:40:44: S -> verify_perm(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo,(null),read,(null),(null)) 09:40:44: -> tcp_read(1909) using WSAEventSelect 09:40:44: -> tcp_read(1909) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm: verify_owner_dir() 09:40:44: S -> verify_owner(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo) 09:40:44: S -> cache_directory_permissions(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo) 09:40:44: S -> fileattr_read(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo) 09:40:44: S -> _fileattr_read() malloc [strlen(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo)=]36+[sizeof(CVS/fileattr.xml)=]17+20=73 09:40:44: S -> fileattr_read() xmalloc fname OK 09:40:44: -> tcp_read(1463) using WSAEventSelect 09:40:44: -> tcp_read(1463) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() allocated memory for fname - will now sprintf() 09:40:44: -> tcp_read(1381) using WSAEventSelect 09:40:44: -> tcp_read(1381) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() ReadXmlFile("C:/PROGRA~3/MARCHH~1/myrepo/samp/foo/CVS/fileattr.xml") 09:40:44: -> tcp_read(1278) using WSAEventSelect 09:40:44: -> tcp_read(1278) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() ReadXmlFile() 09:40:44: -> tcp_read(1231) using WSAEventSelect 09:40:44: -> tcp_read(1231) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() close 09:40:44: -> tcp_read(1192) using WSAEventSelect 09:40:44: -> tcp_read(1192) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() xfree fname 09:40:44: S -> fileattr_read() OK 09:40:44: -> tcp_read(1111) using WSAEventSelect 09:40:44: -> tcp_read(1111) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() - cache directory(fileattr,) 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp/foo",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: -> tcp_read(879) using WSAEventSelect 09:40:44: -> tcp_read(879) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() last_component=foo 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: -> tcp_read(661) using WSAEventSelect 09:40:44: -> tcp_read(661) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() last_component=samp 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: -> tcp_read(447) using WSAEventSelect 09:40:44: -> tcp_read(447) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() free(C:/PROGRA~3/MARCHH~1/myrepo) 09:40:44: S -> cache_directory_permissions() return 09:40:44: -> tcp_read(312) using WSAEventSelect 09:40:44: -> tcp_read(312) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm() Read directory permission cache OK 09:40:44: -> tcp_read(246) using WSAEventSelect 09:40:44: -> tcp_read(246) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp/foo 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: -> tcp_read(4984) using WSAEventSelect 09:40:44: -> tcp_read(4984) immediate timeout previous thread count -1/0 09:40:44: S -> no match at this level 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo 09:40:44: -> tcp_read(4875) using WSAEventSelect 09:40:44: -> tcp_read(4875) immediate timeout previous thread count -1/0 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: -> tcp_read(4780) using WSAEventSelect 09:40:44: -> tcp_read(4780) immediate timeout previous thread count -1/0 09:40:44: S -> no match at this level 09:40:44: S -> Match found. user_state = 0, group_state = 0 09:40:44: S -> verify_perm() return 09:40:44: -> tcp_read(4640) using WSAEventSelect 09:40:44: -> tcp_read(4640) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL 09:40:44: -> tcp_read(4583) using WSAEventSelect 09:40:44: -> tcp_read(4583) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- process_this_directory 09:40:44: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory 09:40:44: -> tcp_read(4416) using WSAEventSelect 09:40:44: -> tcp_read(4416) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() after predirent call ParseTag_Dir() 09:40:44: S -> ParseTag_Dir(foo,,,0,) 09:40:44: -> tcp_read(4275) using WSAEventSelect 09:40:44: -> tcp_read(4275) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo,foo,(null),(null),0,(null),0) 09:40:44: -> tcp_read(4176) using WSAEventSelect 09:40:44: -> tcp_read(4176) immediate timeout previous thread count -1/0 09:40:44: S -> current_directory is already set 09:40:44: S -> open_directory() directory_stack_size increased by one to 2 09:40:44: -> tcp_read(4049) using WSAEventSelect 09:40:44: -> tcp_read(4049) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory, (!remote) try and find a mapping file in this directory . 09:40:44: -> tcp_read(3958) using WSAEventSelect 09:40:44: -> tcp_read(3958) immediate timeout previous thread count -1/0 09:40:44: S -> RCS_parse(.directory_history,C:/PROGRA~3/MARCHH~1/myrepo/samp/foo) 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo/.directory_history,v) 09:40:44: -> tcp_read(3786) using WSAEventSelect 09:40:44: -> tcp_read(3786) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo/.directory_history,v) failed to open file 1 times 09:40:44: -> tcp_read(3670) using WSAEventSelect 09:40:44: -> tcp_read(3670) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo/.directory_history,v) file does not exist, so return 0 09:40:44: S -> rcsbuf_open failed 09:40:44: -> tcp_read(3513) using WSAEventSelect 09:40:44: -> tcp_read(3513) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo/Attic/.directory_history,v) 09:40:44: -> tcp_read(3419) using WSAEventSelect 09:40:44: -> tcp_read(3419) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo/Attic/.directory_history,v) failed to open file 1 times 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo/Attic/.directory_history,v) file does not exist, so return 0 09:40:44: S -> rcsbuf_open failed 09:40:44: S -> No mapping file in this directory. 09:40:44: -> tcp_read(3082) using WSAEventSelect 09:40:44: -> tcp_read(3082) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory copy the tag and date. 09:40:44: S -> open_directory copied the tag and date. 09:40:44: -> tcp_read(2970) using WSAEventSelect 09:40:44: -> tcp_read(2970) immediate timeout previous thread count -1/0 09:40:44: S -> Look for rename script file CVS/Rename 09:40:44: S -> Rename script file does not exist 09:40:44: -> tcp_read(2863) using WSAEventSelect 09:40:44: -> tcp_read(2863) immediate timeout previous thread count -1/0 09:40:44: S -> directory opened 09:40:44: -> tcp_read(2829) using WSAEventSelect 09:40:44: -> tcp_read(2829) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_startdir(C:/PROGRA~3/MARCHH~1/myrepo/samp/foo) 09:40:44: S -> do_dir_proc() -- call-back dir entry proc (if any) 09:40:44: -> tcp_read(2688) using WSAEventSelect 09:40:44: -> tcp_read(2688) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc. foo 09:40:44: S -> do_dir_proc() -- cannot process the dir because the return code was R_SKIP_ALL. 09:40:44: S -> more efficient - close directory in do_dir_proc 09:40:44: -> tcp_read(2431) using WSAEventSelect 09:40:44: -> tcp_read(2431) immediate timeout previous thread count -1/0 09:40:44: S -> close_directory() 09:40:44: S -> close_directory() directory_stack_size decreased by one to 1 09:40:44: S -> fileattr_write() 09:40:44: -> tcp_read(2283) using WSAEventSelect 09:40:44: -> tcp_read(2283) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_free() 09:40:44: S -> do_dir_proc() 09:40:44: -> tcp_read(2219) using WSAEventSelect 09:40:44: -> tcp_read(2219) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() update_dir=testfilt 09:40:44: S -> do_dir_proc() -- set up update_dir - skip dots if not at start 09:40:44: -> tcp_read(2087) using WSAEventSelect 09:40:44: -> tcp_read(2087) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() after all that now update_dir=testfilt/icotest 09:40:44: S -> (server_active || !current_parsed_root->isremote) 2 09:40:44: -> tcp_read(1940) using WSAEventSelect 09:40:44: -> tcp_read(1940) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest) 09:40:44: S -> lookup_module2() 09:40:44: -> tcp_read(1832) using WSAEventSelect 09:40:44: -> tcp_read(1832) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/icotest) after rename? 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(1715) using WSAEventSelect 09:40:44: -> tcp_read(1715) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(1648) using WSAEventSelect 09:40:44: -> tcp_read(1648) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/icotest,15) 09:40:44: S -> _lookup_module2 p!=NULL lookup_repository_module(samp) 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: -> tcp_read(1426) using WSAEventSelect 09:40:44: -> tcp_read(1426) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp/icotest) 09:40:44: -> tcp_read(1266) using WSAEventSelect 09:40:44: -> tcp_read(1266) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: -> tcp_read(1128) using WSAEventSelect 09:40:44: -> tcp_read(1128) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: -> tcp_read(960) using WSAEventSelect 09:40:44: -> tcp_read(960) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository - return(repository) "C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest" 09:40:44: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote 09:40:44: -> tcp_read(782) using WSAEventSelect 09:40:44: -> tcp_read(782) immediate timeout previous thread count -1/0 09:40:44: S -> ParseTag() 09:40:44: S -> ParseTag_Dir((null),,,0,) 09:40:44: -> tcp_read(689) using WSAEventSelect 09:40:44: -> tcp_read(689) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- verify_access 09:40:44: -> tcp_read(640) using WSAEventSelect 09:40:44: -> tcp_read(640) immediate timeout previous thread count -1/0 09:40:44: S -> verify_access C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest,testfilt/icotest,(null) 09:40:44: S -> verify_perm(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest,(null),read,(null),(null)) 09:40:44: -> tcp_read(447) using WSAEventSelect 09:40:44: -> tcp_read(447) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm: verify_owner_dir() 09:40:44: S -> verify_owner(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest) 09:40:44: -> tcp_read(326) using WSAEventSelect 09:40:44: -> tcp_read(326) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest) 09:40:44: S -> fileattr_read(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest) 09:40:44: S -> _fileattr_read() malloc [strlen(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest)=]40+[sizeof(CVS/fileattr.xml)=]17+20=77 09:40:44: -> tcp_read(35) using WSAEventSelect 09:40:44: -> tcp_read(35) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() xmalloc fname OK 09:40:44: S -> _fileattr_read() allocated memory for fname - will now sprintf() 09:40:44: -> tcp_read(5023) using WSAEventSelect 09:40:44: -> tcp_read(5023) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() ReadXmlFile("C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest/CVS/fileattr.xml") 09:40:44: -> tcp_read(4916) using WSAEventSelect 09:40:44: -> tcp_read(4916) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() ReadXmlFile() 09:40:44: -> tcp_read(4869) using WSAEventSelect 09:40:44: -> tcp_read(4869) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() close 09:40:44: -> tcp_read(4830) using WSAEventSelect 09:40:44: -> tcp_read(4830) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() xfree fname 09:40:44: S -> fileattr_read() OK 09:40:44: -> tcp_read(4749) using WSAEventSelect 09:40:44: -> tcp_read(4749) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() - cache directory(fileattr,) 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: S -> cache_directory_permissions() last_component=icotest 09:40:44: -> tcp_read(4443) using WSAEventSelect 09:40:44: -> tcp_read(4443) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: S -> cache_directory_permissions() last_component=samp 09:40:44: -> tcp_read(4224) using WSAEventSelect 09:40:44: -> tcp_read(4224) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: S -> cache_directory_permissions() free(C:/PROGRA~3/MARCHH~1/myrepo) 09:40:44: -> tcp_read(3996) using WSAEventSelect 09:40:44: -> tcp_read(3996) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() return 09:40:44: S -> verify_perm() Read directory permission cache OK 09:40:44: -> tcp_read(3876) using WSAEventSelect 09:40:44: -> tcp_read(3876) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: -> tcp_read(3748) using WSAEventSelect 09:40:44: -> tcp_read(3748) immediate timeout previous thread count -1/0 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: -> tcp_read(3659) using WSAEventSelect 09:40:44: -> tcp_read(3659) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: -> tcp_read(3539) using WSAEventSelect 09:40:44: -> tcp_read(3539) immediate timeout previous thread count -1/0 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: -> tcp_read(3450) using WSAEventSelect 09:40:44: -> tcp_read(3450) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: -> tcp_read(3335) using WSAEventSelect 09:40:44: -> tcp_read(3335) immediate timeout previous thread count -1/0 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: S -> Match found. user_state = 0, group_state = 0 09:40:44: -> tcp_read(3184) using WSAEventSelect 09:40:44: -> tcp_read(3184) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm() return 09:40:44: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL 09:40:44: -> tcp_read(3089) using WSAEventSelect 09:40:44: -> tcp_read(3089) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- process_this_directory 09:40:44: -> tcp_read(3032) using WSAEventSelect 09:40:44: -> tcp_read(3032) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory 09:40:44: S -> do_dir_proc() after predirent call ParseTag_Dir() 09:40:44: -> tcp_read(2854) using WSAEventSelect 09:40:44: -> tcp_read(2854) immediate timeout previous thread count -1/0 09:40:44: S -> ParseTag_Dir(icotest,,,0,) 09:40:44: -> tcp_read(2777) using WSAEventSelect 09:40:44: -> tcp_read(2777) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest,icotest,(null),(null),0,(null),0) 09:40:44: S -> current_directory is already set 09:40:44: -> tcp_read(2620) using WSAEventSelect 09:40:44: -> tcp_read(2620) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory() directory_stack_size increased by one to 2 09:40:44: -> tcp_read(2543) using WSAEventSelect 09:40:44: -> tcp_read(2543) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory, (!remote) try and find a mapping file in this directory . 09:40:44: S -> RCS_parse(.directory_history,C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest) 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest/.directory_history,v) 09:40:44: -> tcp_read(2272) using WSAEventSelect 09:40:44: -> tcp_read(2272) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest/.directory_history,v) failed to open file 1 times 09:40:44: -> tcp_read(2152) using WSAEventSelect 09:40:44: -> tcp_read(2152) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest/.directory_history,v) file does not exist, so return 0 09:40:44: S -> rcsbuf_open failed 09:40:44: -> tcp_read(1991) using WSAEventSelect 09:40:44: -> tcp_read(1991) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest/Attic/.directory_history,v) 09:40:44: -> tcp_read(1893) using WSAEventSelect 09:40:44: -> tcp_read(1893) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest/Attic/.directory_history,v) failed to open file 1 times 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest/Attic/.directory_history,v) file does not exist, so return 0 09:40:44: -> tcp_read(1636) using WSAEventSelect 09:40:44: -> tcp_read(1636) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open failed 09:40:44: S -> No mapping file in this directory. 09:40:44: -> tcp_read(1548) using WSAEventSelect 09:40:44: -> tcp_read(1548) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory copy the tag and date. 09:40:44: S -> open_directory copied the tag and date. 09:40:44: -> tcp_read(1436) using WSAEventSelect 09:40:44: -> tcp_read(1436) immediate timeout previous thread count -1/0 09:40:44: S -> Look for rename script file CVS/Rename 09:40:44: -> tcp_read(1380) using WSAEventSelect 09:40:44: -> tcp_read(1380) immediate timeout previous thread count -1/0 09:40:44: S -> Rename script file does not exist 09:40:44: -> tcp_read(1329) using WSAEventSelect 09:40:44: -> tcp_read(1329) immediate timeout previous thread count -1/0 09:40:44: S -> directory opened 09:40:44: S -> fileattr_startdir(C:/PROGRA~3/MARCHH~1/myrepo/samp/icotest) 09:40:44: S -> do_dir_proc() -- call-back dir entry proc (if any) 09:40:44: -> tcp_read(1150) using WSAEventSelect 09:40:44: -> tcp_read(1150) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc. icotest 09:40:44: S -> do_dir_proc() -- cannot process the dir because the return code was R_SKIP_ALL. 09:40:44: -> tcp_read(954) using WSAEventSelect 09:40:44: -> tcp_read(954) immediate timeout previous thread count -1/0 09:40:44: S -> more efficient - close directory in do_dir_proc 09:40:44: S -> close_directory() 09:40:44: -> tcp_read(854) using WSAEventSelect 09:40:44: -> tcp_read(854) immediate timeout previous thread count -1/0 09:40:44: S -> close_directory() directory_stack_size decreased by one to 1 09:40:44: S -> fileattr_write() 09:40:44: -> tcp_read(741) using WSAEventSelect 09:40:44: -> tcp_read(741) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_free() 09:40:44: S -> do_dir_proc() 09:40:44: -> tcp_read(677) using WSAEventSelect 09:40:44: -> tcp_read(677) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() update_dir=testfilt 09:40:44: S -> do_dir_proc() -- set up update_dir - skip dots if not at start 09:40:44: -> tcp_read(545) using WSAEventSelect 09:40:44: -> tcp_read(545) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() after all that now update_dir=testfilt/promo 09:40:44: S -> (server_active || !current_parsed_root->isremote) 2 09:40:44: -> tcp_read(400) using WSAEventSelect 09:40:44: -> tcp_read(400) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo) 09:40:44: S -> lookup_module2() 09:40:44: -> tcp_read(294) using WSAEventSelect 09:40:44: -> tcp_read(294) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/promo) after rename? 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(179) using WSAEventSelect 09:40:44: -> tcp_read(179) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(112) using WSAEventSelect 09:40:44: -> tcp_read(112) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/promo,16) 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 p!=NULL lookup_repository_module(samp) 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: -> tcp_read(5012) using WSAEventSelect 09:40:44: -> tcp_read(5012) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp/promo) 09:40:44: -> tcp_read(4854) using WSAEventSelect 09:40:44: -> tcp_read(4854) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: -> tcp_read(4716) using WSAEventSelect 09:40:44: -> tcp_read(4716) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: -> tcp_read(4548) using WSAEventSelect 09:40:44: -> tcp_read(4548) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository - return(repository) "C:/PROGRA~3/MARCHH~1/myrepo/samp/promo" 09:40:44: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote 09:40:44: -> tcp_read(4372) using WSAEventSelect 09:40:44: -> tcp_read(4372) immediate timeout previous thread count -1/0 09:40:44: S -> ParseTag() 09:40:44: S -> ParseTag_Dir((null),,,0,) 09:40:44: -> tcp_read(4279) using WSAEventSelect 09:40:44: -> tcp_read(4279) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- verify_access 09:40:44: -> tcp_read(4230) using WSAEventSelect 09:40:44: -> tcp_read(4230) immediate timeout previous thread count -1/0 09:40:44: S -> verify_access C:/PROGRA~3/MARCHH~1/myrepo/samp/promo,testfilt/promo,(null) 09:40:44: S -> verify_perm(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo,(null),read,(null),(null)) 09:40:44: -> tcp_read(4043) using WSAEventSelect 09:40:44: -> tcp_read(4043) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm: verify_owner_dir() 09:40:44: S -> verify_owner(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo) 09:40:44: S -> cache_directory_permissions(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo) 09:40:44: -> tcp_read(3839) using WSAEventSelect 09:40:44: -> tcp_read(3839) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo) 09:40:44: S -> _fileattr_read() malloc [strlen(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo)=]38+[sizeof(CVS/fileattr.xml)=]17+20=75 09:40:44: -> tcp_read(3639) using WSAEventSelect 09:40:44: -> tcp_read(3639) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() xmalloc fname OK 09:40:44: S -> _fileattr_read() allocated memory for fname - will now sprintf() 09:40:44: -> tcp_read(3507) using WSAEventSelect 09:40:44: -> tcp_read(3507) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() ReadXmlFile("C:/PROGRA~3/MARCHH~1/myrepo/samp/promo/CVS/fileattr.xml") 09:40:44: -> tcp_read(3402) using WSAEventSelect 09:40:44: -> tcp_read(3402) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() ReadXmlFile() 09:40:44: -> tcp_read(3355) using WSAEventSelect 09:40:44: -> tcp_read(3355) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() close 09:40:44: -> tcp_read(3316) using WSAEventSelect 09:40:44: -> tcp_read(3316) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() xfree fname 09:40:44: S -> fileattr_read() OK 09:40:44: -> tcp_read(3235) using WSAEventSelect 09:40:44: -> tcp_read(3235) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() - cache directory(fileattr,) 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp/promo",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: -> tcp_read(3001) using WSAEventSelect 09:40:44: -> tcp_read(3001) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() last_component=promo 09:40:44: -> tcp_read(2933) using WSAEventSelect 09:40:44: -> tcp_read(2933) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: S -> cache_directory_permissions() last_component=samp 09:40:44: -> tcp_read(2714) using WSAEventSelect 09:40:44: -> tcp_read(2714) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: S -> cache_directory_permissions() free(C:/PROGRA~3/MARCHH~1/myrepo) 09:40:44: -> tcp_read(2486) using WSAEventSelect 09:40:44: -> tcp_read(2486) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() return 09:40:44: S -> verify_perm() Read directory permission cache OK 09:40:44: -> tcp_read(2366) using WSAEventSelect 09:40:44: -> tcp_read(2366) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp/promo 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: -> tcp_read(2240) using WSAEventSelect 09:40:44: -> tcp_read(2240) immediate timeout previous thread count -1/0 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: -> tcp_read(2151) using WSAEventSelect 09:40:44: -> tcp_read(2151) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: -> tcp_read(2031) using WSAEventSelect 09:40:44: -> tcp_read(2031) immediate timeout previous thread count -1/0 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: -> tcp_read(1942) using WSAEventSelect 09:40:44: -> tcp_read(1942) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: -> tcp_read(1778) using WSAEventSelect 09:40:44: -> tcp_read(1778) immediate timeout previous thread count -1/0 09:40:44: S -> no match at this level 09:40:44: S -> Match found. user_state = 0, group_state = 0 09:40:44: -> tcp_read(1676) using WSAEventSelect 09:40:44: -> tcp_read(1676) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm() return 09:40:44: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL 09:40:44: S -> do_dir_proc() -- process_this_directory 09:40:44: -> tcp_read(1524) using WSAEventSelect 09:40:44: -> tcp_read(1524) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory 09:40:44: S -> do_dir_proc() after predirent call ParseTag_Dir() 09:40:44: -> tcp_read(1346) using WSAEventSelect 09:40:44: -> tcp_read(1346) immediate timeout previous thread count -1/0 09:40:44: S -> ParseTag_Dir(promo,,,0,) 09:40:44: -> tcp_read(1271) using WSAEventSelect 09:40:44: -> tcp_read(1271) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo,promo,(null),(null),0,(null),0) 09:40:44: S -> current_directory is already set 09:40:44: -> tcp_read(1118) using WSAEventSelect 09:40:44: -> tcp_read(1118) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory() directory_stack_size increased by one to 2 09:40:44: -> tcp_read(1041) using WSAEventSelect 09:40:44: -> tcp_read(1041) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory, (!remote) try and find a mapping file in this directory . 09:40:44: -> tcp_read(950) using WSAEventSelect 09:40:44: -> tcp_read(950) immediate timeout previous thread count -1/0 09:40:44: S -> RCS_parse(.directory_history,C:/PROGRA~3/MARCHH~1/myrepo/samp/promo) 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo/.directory_history,v) 09:40:44: -> tcp_read(774) using WSAEventSelect 09:40:44: -> tcp_read(774) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo/.directory_history,v) failed to open file 1 times 09:40:44: -> tcp_read(656) using WSAEventSelect 09:40:44: -> tcp_read(656) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo/.directory_history,v) file does not exist, so return 0 09:40:44: S -> rcsbuf_open failed 09:40:44: -> tcp_read(497) using WSAEventSelect 09:40:44: -> tcp_read(497) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo/Attic/.directory_history,v) 09:40:44: -> tcp_read(401) using WSAEventSelect 09:40:44: -> tcp_read(401) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo/Attic/.directory_history,v) failed to open file 1 times 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo/Attic/.directory_history,v) file does not exist, so return 0 09:40:44: -> tcp_read(148) using WSAEventSelect 09:40:44: -> tcp_read(148) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open failed 09:40:44: -> tcp_read(112) using WSAEventSelect 09:40:44: -> tcp_read(112) immediate timeout previous thread count -1/0 09:40:44: S -> No mapping file in this directory. 09:40:44: -> tcp_read(60) using WSAEventSelect 09:40:44: -> tcp_read(60) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory copy the tag and date. 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory copied the tag and date. 09:40:44: S -> Look for rename script file CVS/Rename 09:40:44: -> tcp_read(5012) using WSAEventSelect 09:40:44: -> tcp_read(5012) immediate timeout previous thread count -1/0 09:40:44: S -> Rename script file does not exist 09:40:44: S -> directory opened 09:40:44: S -> fileattr_startdir(C:/PROGRA~3/MARCHH~1/myrepo/samp/promo) 09:40:44: -> tcp_read(4852) using WSAEventSelect 09:40:44: -> tcp_read(4852) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- call-back dir entry proc (if any) 09:40:44: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc. promo 09:40:44: -> tcp_read(4687) using WSAEventSelect 09:40:44: -> tcp_read(4687) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- cannot process the dir because the return code was R_SKIP_ALL. 09:40:44: S -> more efficient - close directory in do_dir_proc 09:40:44: S -> close_directory() 09:40:44: -> tcp_read(4490) using WSAEventSelect 09:40:44: -> tcp_read(4490) immediate timeout previous thread count -1/0 09:40:44: S -> close_directory() directory_stack_size decreased by one to 1 09:40:44: S -> fileattr_write() 09:40:44: -> tcp_read(4377) using WSAEventSelect 09:40:44: -> tcp_read(4377) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_free() 09:40:44: S -> do_dir_proc() 09:40:44: -> tcp_read(4313) using WSAEventSelect 09:40:44: -> tcp_read(4313) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() update_dir=testfilt 09:40:44: S -> do_dir_proc() -- set up update_dir - skip dots if not at start 09:40:44: -> tcp_read(4181) using WSAEventSelect 09:40:44: -> tcp_read(4181) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() after all that now update_dir=testfilt/samp 09:40:44: S -> (server_active || !current_parsed_root->isremote) 2 09:40:44: -> tcp_read(4037) using WSAEventSelect 09:40:44: -> tcp_read(4037) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp) 09:40:44: S -> lookup_module2() 09:40:44: -> tcp_read(3932) using WSAEventSelect 09:40:44: -> tcp_read(3932) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/samp) after rename? 09:40:44: S -> lookup_module2() call _lookup_module2() 09:40:44: -> tcp_read(3818) using WSAEventSelect 09:40:44: -> tcp_read(3818) immediate timeout previous thread count -1/0 09:40:44: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 09:40:44: -> tcp_read(3751) using WSAEventSelect 09:40:44: -> tcp_read(3751) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2(samp/samp,17) 09:40:44: S -> _lookup_module2 p!=NULL lookup_repository_module(samp) 09:40:44: -> tcp_read(3633) using WSAEventSelect 09:40:44: -> tcp_read(3633) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_repository_module(samp) 09:40:44: S -> modules2_struct_sort(samp,testfilt) 09:40:44: -> tcp_read(3532) using WSAEventSelect 09:40:44: -> tcp_read(3532) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() calls to lookup_repository_module() returned nothing 09:40:44: S -> _lookup_module2 !mod return 0 left,right(,samp/samp) 09:40:44: -> tcp_read(3375) using WSAEventSelect 09:40:44: -> tcp_read(3375) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() call _lookup_module2 returned 0 09:40:44: S -> lookup_module2() no recursion permitted so give up now 09:40:44: -> tcp_read(3237) using WSAEventSelect 09:40:44: -> tcp_read(3237) immediate timeout previous thread count -1/0 09:40:44: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 09:40:44: S -> lookup_module2() return ret=0 renamed=0 09:40:44: -> tcp_read(3069) using WSAEventSelect 09:40:44: -> tcp_read(3069) immediate timeout previous thread count -1/0 09:40:44: S -> map_repository - return(repository) "C:/PROGRA~3/MARCHH~1/myrepo/samp/samp" 09:40:44: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote 09:40:44: -> tcp_read(2894) using WSAEventSelect 09:40:44: -> tcp_read(2894) immediate timeout previous thread count -1/0 09:40:44: S -> ParseTag() 09:40:44: S -> ParseTag_Dir((null),,,0,) 09:40:44: S -> do_dir_proc() -- verify_access 09:40:44: -> tcp_read(2752) using WSAEventSelect 09:40:44: -> tcp_read(2752) immediate timeout previous thread count -1/0 09:40:44: S -> verify_access C:/PROGRA~3/MARCHH~1/myrepo/samp/samp,testfilt/samp,(null) 09:40:44: S -> verify_perm(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp,(null),read,(null),(null)) 09:40:44: -> tcp_read(2568) using WSAEventSelect 09:40:44: -> tcp_read(2568) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm: verify_owner_dir() 09:40:44: S -> verify_owner(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp) 09:40:44: S -> cache_directory_permissions(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp) 09:40:44: -> tcp_read(2366) using WSAEventSelect 09:40:44: -> tcp_read(2366) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp) 09:40:44: S -> _fileattr_read() malloc [strlen(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp)=]37+[sizeof(CVS/fileattr.xml)=]17+20=74 09:40:44: -> tcp_read(2168) using WSAEventSelect 09:40:44: -> tcp_read(2168) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() xmalloc fname OK 09:40:44: S -> _fileattr_read() allocated memory for fname - will now sprintf() 09:40:44: -> tcp_read(2036) using WSAEventSelect 09:40:44: -> tcp_read(2036) immediate timeout previous thread count -1/0 09:40:44: S -> _fileattr_read() ReadXmlFile("C:/PROGRA~3/MARCHH~1/myrepo/samp/samp/CVS/fileattr.xml") 09:40:44: -> tcp_read(1932) using WSAEventSelect 09:40:44: -> tcp_read(1932) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() ReadXmlFile() 09:40:44: -> tcp_read(1885) using WSAEventSelect 09:40:44: -> tcp_read(1885) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() close 09:40:44: -> tcp_read(1846) using WSAEventSelect 09:40:44: -> tcp_read(1846) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_read() xfree fname 09:40:44: S -> fileattr_read() OK 09:40:44: -> tcp_read(1765) using WSAEventSelect 09:40:44: -> tcp_read(1765) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() - cache directory(fileattr,) 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp/samp",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: -> tcp_read(1532) using WSAEventSelect 09:40:44: -> tcp_read(1532) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() last_component=samp 09:40:44: -> tcp_read(1465) using WSAEventSelect 09:40:44: -> tcp_read(1465) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo/samp",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: S -> cache_directory_permissions() last_component=samp 09:40:44: -> tcp_read(1246) using WSAEventSelect 09:40:44: -> tcp_read(1246) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() fncmp(d="C:/PROGRA~3/MARCHH~1/myrepo",current_parsed_root->directory="C:/PROGRA~3/MARCHH~1/myrepo") 09:40:44: S -> cache_directory_permissions() free(C:/PROGRA~3/MARCHH~1/myrepo) 09:40:44: -> tcp_read(1018) using WSAEventSelect 09:40:44: -> tcp_read(1018) immediate timeout previous thread count -1/0 09:40:44: S -> cache_directory_permissions() return 09:40:44: S -> verify_perm() Read directory permission cache OK 09:40:44: -> tcp_read(898) using WSAEventSelect 09:40:44: -> tcp_read(898) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp/samp 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: -> tcp_read(773) using WSAEventSelect 09:40:44: -> tcp_read(773) immediate timeout previous thread count -1/0 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo/samp 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: -> tcp_read(564) using WSAEventSelect 09:40:44: -> tcp_read(564) immediate timeout previous thread count -1/0 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: -> tcp_read(475) using WSAEventSelect 09:40:44: -> tcp_read(475) immediate timeout previous thread count -1/0 09:40:44: S -> ACL lookup on directory C:/PROGRA~3/MARCHH~1/myrepo 09:40:44: S -> verify_acl(read,HEAD,(null)) 09:40:44: -> tcp_read(360) using WSAEventSelect 09:40:44: -> tcp_read(360) immediate timeout previous thread count -1/0 09:40:44: S -> user_state = 0, group_state = 0 09:40:44: S -> no match at this level 09:40:44: S -> Match found. user_state = 0, group_state = 0 09:40:44: -> tcp_read(209) using WSAEventSelect 09:40:44: -> tcp_read(209) immediate timeout previous thread count -1/0 09:40:44: S -> verify_perm() return 09:40:44: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL 09:40:44: -> tcp_read(114) using WSAEventSelect 09:40:44: -> tcp_read(114) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- process_this_directory 09:40:44: -> tcp_read(57) using WSAEventSelect 09:40:44: -> tcp_read(57) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory 09:40:44: S -> do_dir_proc() after predirent call ParseTag_Dir() 09:40:44: S -> ParseTag_Dir(samp,,,0,) 09:40:44: -> tcp_read(4925) using WSAEventSelect 09:40:44: -> tcp_read(4925) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp,samp,(null),(null),0,(null),0) 09:40:44: S -> current_directory is already set 09:40:44: -> tcp_read(4774) using WSAEventSelect 09:40:44: -> tcp_read(4774) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory() directory_stack_size increased by one to 2 09:40:44: -> tcp_read(4697) using WSAEventSelect 09:40:44: -> tcp_read(4697) immediate timeout previous thread count -1/0 09:40:44: S -> open_directory, (!remote) try and find a mapping file in this directory . 09:40:44: -> tcp_read(4606) using WSAEventSelect 09:40:44: -> tcp_read(4606) immediate timeout previous thread count -1/0 09:40:44: S -> RCS_parse(.directory_history,C:/PROGRA~3/MARCHH~1/myrepo/samp/samp) 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp/.directory_history,v) 09:40:44: -> tcp_read(4432) using WSAEventSelect 09:40:44: -> tcp_read(4432) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp/.directory_history,v) failed to open file 1 times 09:40:44: -> tcp_read(4315) using WSAEventSelect 09:40:44: -> tcp_read(4315) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp/.directory_history,v) file does not exist, so return 0 09:40:44: S -> rcsbuf_open failed 09:40:44: -> tcp_read(4157) using WSAEventSelect 09:40:44: -> tcp_read(4157) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp/Attic/.directory_history,v) 09:40:44: -> tcp_read(4062) using WSAEventSelect 09:40:44: -> tcp_read(4062) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp/Attic/.directory_history,v) failed to open file 1 times 09:40:44: S -> rcsbuf_open(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp/Attic/.directory_history,v) file does not exist, so return 0 09:40:44: -> tcp_read(3811) using WSAEventSelect 09:40:44: -> tcp_read(3811) immediate timeout previous thread count -1/0 09:40:44: S -> rcsbuf_open failed 09:40:44: S -> No mapping file in this directory. 09:40:44: S -> open_directory copy the tag and date. 09:40:44: S -> open_directory copied the tag and date. 09:40:44: -> tcp_read(3611) using WSAEventSelect 09:40:44: -> tcp_read(3611) immediate timeout previous thread count -1/0 09:40:44: S -> Look for rename script file CVS/Rename 09:40:44: -> tcp_read(3555) using WSAEventSelect 09:40:44: -> tcp_read(3555) immediate timeout previous thread count -1/0 09:40:44: S -> Rename script file does not exist 09:40:44: -> tcp_read(3504) using WSAEventSelect 09:40:44: -> tcp_read(3504) immediate timeout previous thread count -1/0 09:40:44: S -> directory opened 09:40:44: S -> fileattr_startdir(C:/PROGRA~3/MARCHH~1/myrepo/samp/samp) 09:40:44: -> tcp_read(3396) using WSAEventSelect 09:40:44: -> tcp_read(3396) immediate timeout previous thread count -1/0 09:40:44: S -> do_dir_proc() -- call-back dir entry proc (if any) 09:40:44: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc. samp 09:40:44: S -> do_dir_proc() -- cannot process the dir because the return code was R_SKIP_ALL. 09:40:44: -> tcp_read(3135) using WSAEventSelect 09:40:44: -> tcp_read(3135) immediate timeout previous thread count -1/0 09:40:44: S -> more efficient - close directory in do_dir_proc 09:40:44: S -> close_directory() 09:40:44: S -> close_directory() directory_stack_size decreased by one to 1 09:40:44: -> tcp_read(2956) using WSAEventSelect 09:40:44: -> tcp_read(2956) immediate timeout previous thread count -1/0 09:40:44: S -> fileattr_write() 09:40:44: S -> fileattr_free() 09:40:44: -> tcp_read(2889) using WSAEventSelect 09:40:44: -> tcp_read(2889) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion() -- walklist() returns and now dirlist!=NULL 09:40:44: S -> freenode() free the badbad DIRS 09:40:44: -> tcp_read(2763) using WSAEventSelect 09:40:44: -> tcp_read(2763) immediate timeout previous thread count -1/0 09:40:44: S -> freenode() free the badbad DIRS 09:40:44: S -> freenode() free the badbad DIRS 09:40:44: -> tcp_read(2665) using WSAEventSelect 09:40:44: -> tcp_read(2665) immediate timeout previous thread count -1/0 09:40:44: S -> freenode() free the badbad DIRS 09:40:44: S -> freenode() free the badbad DIRS 09:40:44: -> tcp_read(2567) using WSAEventSelect 09:40:44: -> tcp_read(2567) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion: free the saved copy of the pointer if necessary 09:40:44: S -> debug: 21 09:40:44: -> tcp_read(2460) using WSAEventSelect 09:40:44: -> tcp_read(2460) immediate timeout previous thread count -1/0 09:40:44: S -> debug: 22 09:40:44: S -> do_dir_proc() -- call-back dir leave proc (if any) process_this_directory 09:40:44: -> tcp_read(2341) using WSAEventSelect 09:40:44: -> tcp_read(2341) immediate timeout previous thread count -1/0 09:40:44: S -> debug: 23 09:40:44: S -> close_directory() 09:40:44: -> tcp_read(2279) using WSAEventSelect 09:40:44: -> tcp_read(2279) immediate timeout previous thread count -1/0 09:40:44: S -> close_directory() directory_stack_size decreased by one to 0 09:40:44: -> tcp_read(2200) using WSAEventSelect 09:40:44: -> tcp_read(2200) immediate timeout previous thread count -1/0 09:40:44: S -> do_recursion() -- walklist() returns and now dirlist!=NULL 09:40:44: S -> do_recursion: free the saved copy of the pointer if necessary 09:40:44: -> tcp_read(2043) using WSAEventSelect 09:40:44: -> tcp_read(2043) immediate timeout previous thread count -1/0 09:40:44: S -> start_recursion: Free the data which expand_wild allocated. 09:40:44: S -> start_recursion: Free the data - update_dir 09:40:44: -> tcp_read(1905) using WSAEventSelect 09:40:44: -> tcp_read(1905) immediate timeout previous thread count -1/0 09:40:44: S -> start_recursion: Free the data - update_repos 09:40:44: S -> start_recursion: (args_to_send_when_finished == NULL) 09:40:44: S -> start_recursion: return 0. 09:40:44: -> tcp_read(1727) using WSAEventSelect 09:40:44: -> tcp_read(1727) immediate timeout previous thread count -1/0 09:40:44: S -> run postmodule proc 09:40:44: S -> run_trigger() 09:40:44: -> tcp_read(1659) using WSAEventSelect 09:40:44: -> tcp_read(1659) immediate timeout previous thread count -1/0 09:40:44: S -> Call pre-loaded 'info.dll' 09:40:44: S -> postmodule_proc(testfilt) 09:40:44: -> tcp_read(1572) using WSAEventSelect 09:40:44: -> tcp_read(1572) immediate timeout previous thread count -1/0 09:40:44: S -> default_trigger: parse_info(CVSROOT/postmodule,%r/%p %c %o,,testfilt) 09:40:44: -> tcp_read(1485) using WSAEventSelect 09:40:44: -> tcp_read(1485) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::open('C:/PROGRA~3/MARCHH~1/myrepo/CVSROOT/postmodule','rb') 09:40:44: -> tcp_read(1395) using WSAEventSelect 09:40:44: -> tcp_read(1395) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::open() setvbuf(_IONBF) 09:40:44: -> tcp_read(1342) using WSAEventSelect 09:40:44: -> tcp_read(1342) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::close() 09:40:44: -> tcp_read(1304) using WSAEventSelect 09:40:44: -> tcp_read(1304) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::close() 09:40:44: S -> Call pre-loaded 'info.dll' returned 0, total ret 0 09:40:44: S -> run_trigger returning 0 09:40:44: -> tcp_read(1157) using WSAEventSelect 09:40:44: -> tcp_read(1157) immediate timeout previous thread count -1/0 09:40:44: S -> do_module clean up. 09:40:44: S -> do_module return errors=0. 09:40:44: -> tcp_read(1076) using WSAEventSelect 09:40:44: -> tcp_read(1076) immediate timeout previous thread count -1/0 09:40:44: S -> Process warnings about client versions out of date... 09:40:44: S -> run postcommand proc server 09:40:44: -> tcp_read(960) using WSAEventSelect 09:40:44: -> tcp_read(960) immediate timeout previous thread count -1/0 09:40:44: S -> run_trigger() 09:40:44: S -> Call pre-loaded 'info.dll' 09:40:44: -> tcp_read(885) using WSAEventSelect 09:40:44: -> tcp_read(885) immediate timeout previous thread count -1/0 09:40:44: S -> postcommand_proc() 09:40:44: S -> default_trigger: parse_info(CVSROOT/postcommand,%r/%p %c,,samp) 09:40:44: -> tcp_read(768) using WSAEventSelect 09:40:44: -> tcp_read(768) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::open('C:/PROGRA~3/MARCHH~1/myrepo/CVSROOT/postcommand','rb') 09:40:44: -> tcp_read(677) using WSAEventSelect 09:40:44: -> tcp_read(677) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::open() setvbuf(_IONBF) 09:40:44: -> tcp_read(624) using WSAEventSelect 09:40:44: -> tcp_read(624) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::close() 09:40:44: -> tcp_read(586) using WSAEventSelect 09:40:44: -> tcp_read(586) immediate timeout previous thread count -1/0 09:40:44: S -> CFileAccess::close() 09:40:44: S -> Call pre-loaded 'info.dll' returned 0, total ret 0 09:40:44: -> tcp_read(480) using WSAEventSelect 09:40:44: -> tcp_read(480) immediate timeout previous thread count -1/0 09:40:44: S -> run_trigger returning 0 09:40:44: -> tcp_read(439) using WSAEventSelect 09:40:44: -> tcp_read(439) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading checkout.dll 09:40:44: S -> Unloading - about to destroy 09:40:44: -> tcp_read(353) using WSAEventSelect 09:40:44: -> tcp_read(353) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - destroyed 09:40:44: S -> Unloading - about to get lib 09:40:44: -> tcp_read(268) using WSAEventSelect 09:40:44: -> tcp_read(268) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to unload 09:40:44: -> tcp_read(223) using WSAEventSelect 09:40:44: -> tcp_read(223) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - unloaded 09:40:44: S -> Unloading - about to free 09:40:44: -> tcp_read(142) using WSAEventSelect 09:40:44: -> tcp_read(142) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to delete trigg 09:40:44: -> tcp_read(91) using WSAEventSelect 09:40:44: -> tcp_read(91) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to delete inf 09:40:44: S -> Unloading - complete 09:40:44: -> tcp_read(4) using WSAEventSelect 09:40:44: -> tcp_read(4) immediate timeout previous thread count -1/0 09:40:44: -> tcp_read(5120) using WSAEventSelect 09:40:44: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading email.dll 09:40:44: S -> Unloading - about to destroy 09:40:44: S -> Unloading - destroyed 09:40:44: -> tcp_read(5002) using WSAEventSelect 09:40:44: -> tcp_read(5002) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to get lib 09:40:44: S -> Unloading - about to unload 09:40:44: S -> Unloading - unloaded 09:40:44: -> tcp_read(4873) using WSAEventSelect 09:40:44: -> tcp_read(4873) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to free 09:40:44: -> tcp_read(4830) using WSAEventSelect 09:40:44: -> tcp_read(4830) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to delete trigg 09:40:44: S -> Unloading - about to delete inf 09:40:44: S -> Unloading - complete 09:40:44: -> tcp_read(4692) using WSAEventSelect 09:40:44: -> tcp_read(4692) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading info.dll 09:40:44: S -> Unloading - about to close 09:40:44: -> tcp_read(4612) using WSAEventSelect 09:40:44: -> tcp_read(4612) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - closed 09:40:44: S -> Unloading - about to destroy 09:40:44: -> tcp_read(4530) using WSAEventSelect 09:40:44: -> tcp_read(4530) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - destroyed 09:40:44: S -> Unloading - about to get lib 09:40:44: -> tcp_read(4445) using WSAEventSelect 09:40:44: -> tcp_read(4445) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to unload 09:40:44: -> tcp_read(4400) using WSAEventSelect 09:40:44: -> tcp_read(4400) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - unloaded 09:40:44: S -> Unloading - about to free 09:40:44: -> tcp_read(4319) using WSAEventSelect 09:40:44: -> tcp_read(4319) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to delete trigg 09:40:44: S -> Unloading - about to delete inf 09:40:44: -> tcp_read(4219) using WSAEventSelect 09:40:44: -> tcp_read(4219) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - complete 09:40:44: S -> Unloading make.dll 09:40:44: -> tcp_read(4145) using WSAEventSelect 09:40:44: -> tcp_read(4145) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to destroy 09:40:44: -> tcp_read(4099) using WSAEventSelect 09:40:44: -> tcp_read(4099) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - destroyed 09:40:44: S -> Unloading - about to get lib 09:40:44: -> tcp_read(4014) using WSAEventSelect 09:40:44: -> tcp_read(4014) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to unload 09:40:44: S -> Unloading - unloaded 09:40:44: -> tcp_read(3931) using WSAEventSelect 09:40:44: -> tcp_read(3931) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to free 09:40:44: -> tcp_read(3888) using WSAEventSelect 09:40:44: -> tcp_read(3888) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to delete trigg 09:40:44: S -> Unloading - about to delete inf 09:40:44: -> tcp_read(3788) using WSAEventSelect 09:40:44: -> tcp_read(3788) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - complete 09:40:44: S -> Unloading script.dll 09:40:44: -> tcp_read(3712) using WSAEventSelect 09:40:44: -> tcp_read(3712) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to destroy 09:40:44: S -> Unloading - destroyed 09:40:44: S -> Unloading - about to get lib 09:40:44: -> tcp_read(3581) using WSAEventSelect 09:40:44: -> tcp_read(3581) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to unload 09:40:44: -> tcp_read(3536) using WSAEventSelect 09:40:44: -> tcp_read(3536) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - unloaded 09:40:44: S -> Unloading - about to free 09:40:44: -> tcp_read(3455) using WSAEventSelect 09:40:44: -> tcp_read(3455) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to delete trigg 09:40:44: -> tcp_read(3404) using WSAEventSelect 09:40:44: -> tcp_read(3404) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to delete inf 09:40:44: S -> Unloading - complete 09:40:44: -> tcp_read(3317) using WSAEventSelect 09:40:44: -> tcp_read(3317) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading sync.dll 09:40:44: S -> Unloading - about to destroy 09:40:44: -> tcp_read(3235) using WSAEventSelect 09:40:44: -> tcp_read(3235) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - destroyed 09:40:44: S -> Unloading - about to get lib 09:40:44: S -> Unloading - about to unload 09:40:44: -> tcp_read(3105) using WSAEventSelect 09:40:44: -> tcp_read(3105) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - unloaded 09:40:44: -> tcp_read(3067) using WSAEventSelect 09:40:44: -> tcp_read(3067) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to free 09:40:44: S -> Unloading - about to delete trigg 09:40:44: -> tcp_read(2973) using WSAEventSelect 09:40:44: -> tcp_read(2973) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to delete inf 09:40:44: S -> Unloading - complete 09:40:44: -> tcp_read(2886) using WSAEventSelect 09:40:44: -> tcp_read(2886) immediate timeout previous thread count -1/0 09:40:44: S -> Unloading - about to clear list 09:40:44: S -> Unloading - cleared list 09:40:44: -> Server: return from the requested function 09:40:44: -> Unloading - about to clear list 09:40:44: -> Unloading - cleared list 09:40:44: -> Unloading sspi 09:40:44: -> Process 8308 exiting 09:40:44: -> free_directory() 09:40:44: -> free_modules2() directory_stack_size and rubbish set to zero 09:40:44: -> Free CVS_Username and cvs_locale 09:40:44: -> Perform SYSTEM_CLEANUP () 09:40:44: -> Free global_session_time and global_real_session_time 09:40:44: -> CCvsgui::Close 09:40:44: -> main return OK 09:40:44: -> Set the terminate semaphore 09:40:44: -> Free trace_file