09:09:48: -> Client trace started, level=3. 09:09:48: -> Tracelevel set to 5. PID is 588980 09:09:48: -> Session ID is 8fcb44e51903c7035 09:09:48: -> Session time is Sun Aug 21 23:09:48 2011 09:09:48: -> Client was compiled Jun 10 2011 13:10:14 09:09:48: -> Client was compiled with MSVC C/C++ 1310 09:09:48: -> Client build platform is microsoft-windows-x86 09:09:48: -> Build version is CVSNT 2.8.01 (Soolin) Build 4185 09:09:48: -> User name is jsnpr4 09:09:48: -> Client running on "Microsoft Windows Server 2003 "R2" Enterprise Edition Service Pack 2 (Build 3790) [5.2.3790] (Service Pack 2)" 09:09:48: -> /3GB is not enabled, highest user address is 7ffeffff 09:09:48: -> Client has 38 percent of memory in use. 09:09:48: -> Client has 4194303 total Kbytes of physical memory*. 09:09:48: -> Client has 4194303 free Kbytes of physical memory*. 09:09:48: -> Client has 13630548 total Kbytes of physical memory. 09:09:48: -> Client has 8338240 free Kbytes of physical memory. 09:09:48: -> Client has 17211160 total Kbytes of paging file. 09:09:48: -> Client has 12119136 free Kbytes of paging file. 09:09:48: -> Client has 2097024 total Kbytes of virtual memory. 09:09:48: -> Client has 2057928 free Kbytes of virtual memory. 09:09:48: -> Client has 0 free Kbytes of extended memory. 09:09:48: -> Client Hardware information: 09:09:48: -> Number of processors: 4 09:09:48: -> Processor type: 586 09:09:48: -> processor architecture: x32 09:09:48: -> processor 386/486 model: 3840 step: 11 09:09:48: -> Free space in C:\DOCUME~1\jsnpr4\LOCALS~1\Temp 1463242752 09:09:48: -> Total space in C:\DOCUME~1\jsnpr4\LOCALS~1\Temp 4075520 09:09:48: -> Total Free space in C:\DOCUME~1\jsnpr4\LOCALS~1\Temp 1463242752 09:09:48: -> Loading protocol sspi as sspi.dll 09:09:48: -> CLibraryAccess::Load loading C:\PROGRA~1\CVSSUI~1\CVSNT/protocols/sspi.dll 09:09:48: -> main loop with CVSROOT=:sspi:.@localhost:D:/CVSNT/GatewaySystems 09:09:48: -> main - about to start the server yes 09:09:48: -> start_server(verify_only=0) 09:09:48: -> client start - client_protocol->connect 09:09:48: -> Buffer size is 5120 09:09:48: -> sspi_connect 09:09:48: -> tcp_write(26,1792) 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> SSPI:ClientAuthenticate(Negotiate,*NONE*,*NONE*) !Schannel - AcquireCredentialsHandle 09:09:48: -> SSPI:ClientAuthenticate() !Schannel - AcquireCredentialsHandle result = OK 09:09:48: -> SSPI:ClientAuthenticate() InitializeSecurityContext 09:09:48: -> tcp_write(2,1792) 09:09:48: -> tcp_write(55,1792) 09:09:48: -> tcp_read(2) using WSAEventSelect 09:09:48: -> tcp_read(2) immediate timeout previous thread count -1/0 09:09:48: -> tcp_read(208) using WSAEventSelect 09:09:48: -> tcp_read(208) immediate timeout previous thread count -1/0 09:09:48: -> SSPI:ClientAuthenticate() InitializeSecurityContext 09:09:48: -> tcp_write(2,1792) 09:09:48: -> tcp_write(72,1792) 09:09:48: -> tcp_write(24,1792) 09:09:48: -> client start - Loop, getting responses from the server. 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> recv_line - got 1 chars, first is 73(I), index=0 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> recv_line - got 1 chars, first is 32( ), index=1 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> recv_line - got 1 chars, first is 76(L), index=2 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> recv_line - got 1 chars, first is 79(O), index=3 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> recv_line - got 1 chars, first is 86(V), index=4 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> recv_line - got 1 chars, first is 69(E), index=5 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> recv_line - got 1 chars, first is 32( ), index=6 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> recv_line - got 1 chars, first is 89(Y), index=7 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> recv_line - got 1 chars, first is 79(O), index=8 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> recv_line - got 1 chars, first is 85(U), index=9 09:09:48: -> tcp_read(1) using WSAEventSelect 09:09:48: -> tcp_read(1) immediate timeout previous thread count -1/0 09:09:48: -> recv_line - got 1 chars, first is 10( ), index=10 09:09:48: -> client start - got "I LOVE YOU" 09:09:48: -> client start - continue login. 09:09:48: -> client start - server started. 09:09:48: -> client start - send Valid-responses to server. 09:09:48: -> send_to_server_untranslated() calls buf_output() len=15 nbytes=0 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=15 09:09:48: -> send_to_server_untranslated() calls buf_output() len=2 nbytes=16 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=18 09:09:48: -> send_to_server_untranslated() calls buf_output() len=5 nbytes=19 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=24 09:09:48: -> send_to_server_untranslated() calls buf_output() len=14 nbytes=25 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=39 09:09:48: -> send_to_server_untranslated() calls buf_output() len=10 nbytes=40 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=50 09:09:48: -> send_to_server_untranslated() calls buf_output() len=9 nbytes=51 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=60 09:09:48: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=61 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=69 09:09:48: -> send_to_server_untranslated() calls buf_output() len=9 nbytes=70 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=79 09:09:48: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=80 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=87 09:09:48: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=88 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=95 09:09:48: -> send_to_server_untranslated() calls buf_output() len=15 nbytes=96 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=111 09:09:48: -> send_to_server_untranslated() calls buf_output() len=6 nbytes=112 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=118 09:09:48: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=119 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=126 09:09:48: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=127 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=135 09:09:48: -> send_to_server_untranslated() calls buf_output() len=14 nbytes=136 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=150 09:09:48: -> send_to_server_untranslated() calls buf_output() len=4 nbytes=151 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=155 09:09:48: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=156 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=164 09:09:48: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=165 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=172 09:09:48: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=173 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=180 09:09:48: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=181 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=193 09:09:48: -> send_to_server_untranslated() calls buf_output() len=20 nbytes=194 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=214 09:09:48: -> send_to_server_untranslated() calls buf_output() len=22 nbytes=215 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=237 09:09:48: -> send_to_server_untranslated() calls buf_output() len=10 nbytes=238 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=248 09:09:48: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=249 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=261 09:09:48: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=262 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=270 09:09:48: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=271 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=279 09:09:48: -> send_to_server_untranslated() calls buf_output() len=16 nbytes=280 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=296 09:09:48: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=297 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=314 09:09:48: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=315 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=327 09:09:48: -> send_to_server_untranslated() calls buf_output() len=6 nbytes=328 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=334 09:09:48: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=335 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=347 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=348 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=349 09:09:48: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=350 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=357 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=358 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=359 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=360 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=361 09:09:48: -> send_to_server_untranslated() calls buf_output() len=2 nbytes=362 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=364 09:09:48: -> send_to_server_untranslated() calls buf_output() len=16 nbytes=365 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=381 09:09:48: -> send_to_server_untranslated() calls buf_output() len=14 nbytes=382 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=396 09:09:48: -> client start - send valid-requests to server. 09:09:48: -> send_to_server_untranslated() calls buf_output() len=15 nbytes=397 09:09:48: -> tcp_write(412,1792) 09:09:48: -> tcp_read(5120) using WSAEventSelect 09:09:48: -> tcp_read(5120) immediate timeout previous thread count -1/0 09:09:48: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=412 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=424 09:09:48: -> tcp_write(13,1792) 09:09:48: -> client start - rootless_encryption. 09:09:48: -> send_to_server_untranslated() calls buf_output() len=5 nbytes=425 09:09:48: -> send_to_server_untranslated() calls buf_output() len=23 nbytes=430 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=453 09:09:48: -> send_to_server_untranslated() calls buf_output() len=16 nbytes=454 09:09:48: -> tcp_write(45,1792) 09:09:48: -> tcp_read(4210) using WSAEventSelect 09:09:48: -> tcp_read(4210) immediate timeout previous thread count -1/0 09:09:48: -> Server codepage is CP1252 09:09:48: -> Client codepage is CP1252 09:09:48: -> send_to_server_untranslated() calls buf_output() len=15 nbytes=470 09:09:48: -> send_to_server_untranslated() calls buf_output() len=32 nbytes=485 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=517 09:09:48: -> tcp_write(48,1792) 09:09:48: -> tcp_read(4203) using WSAEventSelect 09:09:48: -> tcp_read(4203) immediate timeout previous thread count -1/0 09:09:48: -> Server version is CVSNT 2.8.01 (Soolin) Build 4185 09:09:48: -> Client version is CVSNT 2.8.01 (Soolin) Build 4185 09:09:48: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=518 09:09:48: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=535 09:09:48: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=552 09:09:48: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=569 09:09:48: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=586 09:09:48: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=603 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=620 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=621 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=622 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=623 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=624 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=625 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=626 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=627 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=628 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=629 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=630 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=631 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=632 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=633 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=634 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=635 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=636 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=637 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=638 09:09:48: -> Requesting server cvsignore 09:09:48: -> send_to_server_untranslated() calls buf_output() len=15 nbytes=639 09:09:48: -> tcp_write(136,1792) 09:09:48: -> tcp_read(4170) using WSAEventSelect 09:09:48: -> tcp_read(4170) immediate timeout previous thread count -1/0 09:09:48: -> wrap_add(*.a -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.a" 09:09:48: -> Call CGetOptions::getOpt: "*.a -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.ai -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.ai" 09:09:48: -> Call CGetOptions::getOpt: "*.ai -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.avi -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.avi" 09:09:48: -> Call CGetOptions::getOpt: "*.avi -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.bin -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.bin" 09:09:48: -> Call CGetOptions::getOpt: "*.bin -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.bmp -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.bmp" 09:09:48: -> Call CGetOptions::getOpt: "*.bmp -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.bz2 -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.bz2" 09:09:48: -> Call CGetOptions::getOpt: "*.bz2 -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.chm -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.chm" 09:09:48: -> Call CGetOptions::getOpt: "*.chm -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.class -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.class" 09:09:48: -> Call CGetOptions::getOpt: "*.class -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.cur -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.cur" 09:09:48: -> Call CGetOptions::getOpt: "*.cur -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.dll -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.dll" 09:09:48: -> Call CGetOptions::getOpt: "*.dll -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.doc -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.doc" 09:09:48: -> Call CGetOptions::getOpt: "*.doc -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.docx -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.docx" 09:09:48: -> Call CGetOptions::getOpt: "*.docx -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.docm -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.docm" 09:09:48: -> Call CGetOptions::getOpt: "*.docm -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.pptx -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.pptx" 09:09:48: -> Call CGetOptions::getOpt: "*.pptx -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.pptm -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.pptm" 09:09:48: -> Call CGetOptions::getOpt: "*.pptm -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.xlsx -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.xlsx" 09:09:48: -> Call CGetOptions::getOpt: "*.xlsx -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.xlsm -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.xlsm" 09:09:48: -> Call CGetOptions::getOpt: "*.xlsm -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.odt -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.odt" 09:09:48: -> Call CGetOptions::getOpt: "*.odt -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.ods -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.ods" 09:09:48: -> Call CGetOptions::getOpt: "*.ods -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.odp -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.odp" 09:09:48: -> Call CGetOptions::getOpt: "*.odp -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.odb -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.odb" 09:09:48: -> Call CGetOptions::getOpt: "*.odb -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.odg -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.odg" 09:09:48: -> Call CGetOptions::getOpt: "*.odg -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.odf -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.odf" 09:09:48: -> Call CGetOptions::getOpt: "*.odf -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.mpp -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.mpp" 09:09:48: -> Call CGetOptions::getOpt: "*.mpp -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.dvi -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.dvi" 09:09:48: -> Call CGetOptions::getOpt: "*.dvi -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.exe -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.exe" 09:09:48: -> Call CGetOptions::getOpt: "*.exe -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.gif -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.gif" 09:09:48: -> Call CGetOptions::getOpt: "*.gif -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.gz -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.gz" 09:09:48: -> Call CGetOptions::getOpt: "*.gz -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.hqx -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.hqx" 09:09:48: -> Call CGetOptions::getOpt: "*.hqx -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.ico -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.ico" 09:09:48: -> Call CGetOptions::getOpt: "*.ico -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.ilk -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.ilk" 09:09:48: -> Call CGetOptions::getOpt: "*.ilk -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.indd -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.indd" 09:09:48: -> Call CGetOptions::getOpt: "*.indd -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.iso -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.iso" 09:09:48: -> Call CGetOptions::getOpt: "*.iso -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.lib -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.lib" 09:09:48: -> Call CGetOptions::getOpt: "*.lib -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.jar -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.jar" 09:09:48: -> Call CGetOptions::getOpt: "*.jar -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.jpg -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.jpg" 09:09:48: -> Call CGetOptions::getOpt: "*.jpg -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.jpeg -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.jpeg" 09:09:48: -> Call CGetOptions::getOpt: "*.jpeg -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.lnk -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.lnk" 09:09:48: -> Call CGetOptions::getOpt: "*.lnk -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.mpg -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.mpg" 09:09:48: -> Call CGetOptions::getOpt: "*.mpg -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.mpeg -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.mpeg" 09:09:48: -> Call CGetOptions::getOpt: "*.mpeg -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.mov -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.mov" 09:09:48: -> Call CGetOptions::getOpt: "*.mov -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.mp3 -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.mp3" 09:09:48: -> Call CGetOptions::getOpt: "*.mp3 -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.ncb -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.ncb" 09:09:48: -> Call CGetOptions::getOpt: "*.ncb -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.o -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.o" 09:09:48: -> Call CGetOptions::getOpt: "*.o -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.ogg -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.ogg" 09:09:48: -> Call CGetOptions::getOpt: "*.ogg -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.obj -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.obj" 09:09:48: -> Call CGetOptions::getOpt: "*.obj -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.pdb -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.pdb" 09:09:48: -> Call CGetOptions::getOpt: "*.pdb -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.pdf -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.pdf" 09:09:48: -> Call CGetOptions::getOpt: "*.pdf -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.png -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.png" 09:09:48: -> Call CGetOptions::getOpt: "*.png -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.ppt -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.ppt" 09:09:48: -> Call CGetOptions::getOpt: "*.ppt -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.psd -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.psd" 09:09:48: -> Call CGetOptions::getOpt: "*.psd -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.res -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.res" 09:09:48: -> Call CGetOptions::getOpt: "*.res -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.rpm -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.rpm" 09:09:48: -> Call CGetOptions::getOpt: "*.rpm -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.sit -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.sit" 09:09:48: -> Call CGetOptions::getOpt: "*.sit -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.so -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.so" 09:09:48: -> Call CGetOptions::getOpt: "*.so -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.tar -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.tar" 09:09:48: -> Call CGetOptions::getOpt: "*.tar -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.tga -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.tga" 09:09:48: -> Call CGetOptions::getOpt: "*.tga -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.tgz -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.tgz" 09:09:48: -> Call CGetOptions::getOpt: "*.tgz -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.tif -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.tif" 09:09:48: -> Call CGetOptions::getOpt: "*.tif -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.tiff -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.tiff" 09:09:48: -> Call CGetOptions::getOpt: "*.tiff -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.ttf -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.ttf" 09:09:48: -> Call CGetOptions::getOpt: "*.ttf -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.wav -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.wav" 09:09:48: -> Call CGetOptions::getOpt: "*.wav -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.wmv -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.wmv" 09:09:48: -> Call CGetOptions::getOpt: "*.wmv -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.xls -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.xls" 09:09:48: -> Call CGetOptions::getOpt: "*.xls -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.zip -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.zip" 09:09:48: -> Call CGetOptions::getOpt: "*.zip -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> wrap_add(*.Z -kb, 0, 0, 0, 0) 09:09:48: -> Call CFileAccess::mimetype: "*.Z" 09:09:48: -> Call CGetOptions::getOpt: "*.Z -kb" "+k:x:m:t:" 09:09:48: -> wrap_add() Sort. 09:09:48: -> Requesting server cvswrappers 09:09:48: -> send_to_server_untranslated() calls buf_output() len=17 nbytes=654 09:09:48: -> tcp_write(17,1792) 09:09:48: -> tcp_read(4168) using WSAEventSelect 09:09:48: -> tcp_read(4168) immediate timeout previous thread count -1/0 09:09:48: -> The first item in the sorted list is "b" with wildcard "*.a" 09:09:48: -> Requesting server cvsrc (read-cvsrc2) 09:09:48: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=671 09:09:48: -> tcp_write(12,1792) 09:09:48: -> tcp_read(4164) using WSAEventSelect 09:09:48: -> tcp_read(4164) immediate timeout previous thread count -1/0 09:09:48: -> Parsing global cvsrc started 09:09:48: -> Parsing global cvsrc finished 0 lines. 09:09:48: -> No local H:/.cvsrc to parse 09:09:48: -> Server: call the requested function commit 09:09:48: -> Commit start_recursion parsed root is remote argc=1 09:09:48: -> start_recursion((null),(null)) 09:09:48: -> start_recursion() dirleaveproc is NULL 09:09:48: -> start_recursion() update_dir set to "" 09:09:48: -> start_recursion - argument count (argc) == 1 09:09:48: -> * There were arguments, so we have to handle them by hand. To do 09:09:48: -> * that, we set up the filelist and dirlist with the arguments and 09:09:48: -> * call do_recursion. do_recursion recognizes the fact that the 09:09:48: -> * lists are non-null when it starts and doesn't update them. 09:09:48: -> 09:09:48: -> * explicitly named directories are stored in dirlist. 09:09:48: -> * explicitly named files are stored in filelist. 09:09:48: -> * other possibility is named entities whicha are not currently in 09:09:48: -> * the working directory. 09:09:48: -> * if this argument is a directory, then add it to the list of directories. 09:09:48: -> * otherwise, split argument into directory and component names. 09:09:48: -> * Now break out argv[i] into directory part (DIR) and file part (COMP). 09:09:48: -> DIR and COMP will each point to a newly malloc'd string. 09:09:48: -> ParseTag_Dir(.,,,0,) 09:09:48: -> start_recursion: (1) addfile(files_by_dir,".","AURA.ear") 09:09:48: -> * At this point we have looped over all named arguments and built 09:09:48: -> a coupla lists. Now we unroll the lists, setting up and 09:09:48: -> calling do_recursion. 09:09:48: -> call walklist() with unroll_files_proc and files_by_dir 09:09:48: -> unroll_files_proc() begin 09:09:48: -> * if this dir was also an explicitly named argument, then skip 09:09:48: -> it. We'll catch it later when we do dirs. 09:09:48: -> * otherwise, call dorecusion for this list of files. 09:09:48: -> Name_Repository((null),) 09:09:48: -> Name_Repository dup tmp is len 09:09:48: -> Name_Repository dup tmp is now len 09:09:48: -> Name_Repository open CVS/Repository 09:09:48: -> Name_Repository opened CVS/Repository ok so read a line 09:09:48: -> Name_Repository closed CVS/Repository 09:09:48: -> Name_Repository read 1 AURAEAR 09:09:48: -> Name_Repository (stripped the newline) read 2 AURAEAR 09:09:48: -> Name_Repository isabsolute( AURAEAR )? 09:09:48: -> Name_Repository isabsolute( AURAEAR )! 09:09:48: -> Name_Repository Sanitize_Repository_Name( D:/CVSNT/GatewaySystems/AURAEAR )! 09:09:48: -> Name_Repository return ( D:/CVSNT/GatewaySystems/AURAEAR )! 09:09:48: -> ParseTag() 09:09:48: -> ParseTag_Dir((null),,,0,) 09:09:48: -> open_directory(D:/CVSNT/GatewaySystems/AURAEAR,.,(null),(null),0,(null),1) 09:09:48: -> open_directory() directory_stack_size increased by one to 1 09:09:48: -> Look for rename script file CVS/Rename 09:09:48: -> Rename script file does not exist 09:09:48: -> directory opened 09:09:48: -> do_recursion: begin 09:09:48: -> do_recursion: Check the value in CVSADM_ROOT 09:09:48: -> do_recursion: server does not appear to be active, update_dir= 09:09:48: -> do_recursion: Fill in repository with the current repository 09:09:48: -> do_recursion: update_dir= 09:09:48: -> Name_Repository((null),) 09:09:48: -> Name_Repository dup tmp is len 09:09:48: -> Name_Repository dup tmp is now len 09:09:48: -> Name_Repository open CVS/Repository 09:09:48: -> Name_Repository opened CVS/Repository ok so read a line 09:09:48: -> Name_Repository closed CVS/Repository 09:09:48: -> Name_Repository read 1 AURAEAR 09:09:48: -> Name_Repository (stripped the newline) read 2 AURAEAR 09:09:48: -> Name_Repository isabsolute( AURAEAR )? 09:09:48: -> Name_Repository isabsolute( AURAEAR )! 09:09:48: -> Name_Repository Sanitize_Repository_Name( D:/CVSNT/GatewaySystems/AURAEAR )! 09:09:48: -> Name_Repository return ( D:/CVSNT/GatewaySystems/AURAEAR )! 09:09:48: -> do_recursion: update_dir= repository=D:/CVSNT/GatewaySystems/AURAEAR 09:09:48: -> !(repository && (server_active || !current_parsed_root->isremote)) - so just strdup 09:09:48: -> Repository = D:/CVSNT/GatewaySystems/AURAEAR 09:09:48: -> Mapped repository = D:/CVSNT/GatewaySystems/AURAEAR 09:09:48: -> * The filesdoneproc needs to be called for each directory where files 09:09:48: -> * processed, or each directory that is processed by a call where no 09:09:48: -> * directories were passed in. In fact, the only time we don't want to 09:09:48: -> * call back the filesdoneproc is when we are processing directories that 09:09:48: -> * were passed in on the command line (or in the special case of `.' when 09:09:48: -> * we were called with no args 09:09:48: -> do_recursion: dirlist == NULL && filelist == NULL 09:09:48: -> do_recursion: dodoneproc=1 09:09:48: -> * If filelist or dirlist is already set, we don't look again. Otherwise, 09:09:48: -> * find the files and directories 09:09:48: -> do_recursion: something was passed on the command line 09:09:48: -> do_recursion: we will process files, so pre-parse entries 09:09:48: -> Entries_Open() 09:09:48: -> Entries_Open ParseTag() 09:09:48: -> ParseTag() 09:09:48: -> ParseTag_Dir((null),,,0,) 09:09:48: -> Entries_Open aflag==0 && dirtag==0 && dirdate==0 09:09:48: -> Entries_Open CVS_FOPEN("CVS/Entries","r") 09:09:48: -> Entries_Open CVS_FOPEN CVSADM_ENT returned a file handle, now call the (slow) fgetentent() / AddEntryNode 09:09:48: -> Entnode_Create() 09:09:48: -> Entnode_Create() finished 09:09:48: -> AddEntryNode() 09:09:48: -> AddEntryNode() get a node and fill in the regular stuff 09:09:48: -> AddEntryNode() this one gets a key of the name for hashing 09:09:48: -> AddEntryNode() put the node into the list 09:09:48: -> AddEntryNode() finished 09:09:48: -> Entnode_Create() 09:09:48: -> Entnode_Create() finished 09:09:48: -> AddEntryNode() 09:09:48: -> AddEntryNode() get a node and fill in the regular stuff 09:09:48: -> AddEntryNode() this one gets a key of the name for hashing 09:09:48: -> AddEntryNode() put the node into the list 09:09:48: -> AddEntryNode() finished 09:09:48: -> Entnode_Create() 09:09:48: -> Entnode_Create() finished 09:09:48: -> AddEntryNode() 09:09:48: -> AddEntryNode() get a node and fill in the regular stuff 09:09:48: -> AddEntryNode() this one gets a key of the name for hashing 09:09:48: -> AddEntryNode() put the node into the list 09:09:48: -> AddEntryNode() finished 09:09:48: -> Entries_Open fclose() CVSADM_ENT 09:09:48: -> Entries_Open CVS_FOPEN("CVS/Entries.Extra","r") 09:09:48: -> Entries_Open CVS_FOPEN CVSADM_ENTEXT returned a file handle 09:09:48: -> Entries_Open fclose() CVSADM_ENTEXT 09:09:48: -> Entries_Open CVS_FOPEN("CVS/Entries.Log","r") 09:09:48: -> Entries_Open clean up and return 09:09:48: -> Entries_Open done 09:09:48: -> do_recursion: process the files (if any) 09:09:48: -> do_recursion: read lock it if necessary 09:09:48: -> * For the server, we handle notifications in a completely different 09:09:48: -> place (server_notify). For local, we can't do them here--we don't 09:09:48: -> have writelocks in place, and there is no way to get writelocks here 09:09:48: -> do_recursion: process the files by calling walklist() 09:09:48: -> do_file_proc: process the files "AURA.ear" 09:09:48: -> !(server_active || !current_parsed_root->isremote) - so just strdup 09:09:48: -> do_file_proc: mapped name of file "AURA.ear" 09:09:48: -> do_file_proc: call findnode_fn() 09:09:48: -> do_file_proc: got a result from findnode_fn() 09:09:48: -> do_file_proc: verify_access() returned ok 09:09:48: -> find_fileproc(AURA.ear) 09:09:48: -> Version_TS((null),(null),0) 09:09:48: -> wnt_stat(AURA.ear) 09:09:48: -> _statcore(00000000,AURA.ear) 09:09:48: -> Trying GetFileAttributesEx.... 09:09:48: -> File attributes = 00000020 09:09:48: -> - read/write file 09:09:48: -> GetUnixFileModeNtEA(A,00000650) returns 0400 09:09:48: -> _statcore(AURA.ear) returns S_IWRITE 09:09:48: -> do_file_proc: finished fileproc() 09:09:48: -> do_file_proc: return 09:09:48: -> do_recursion: unlock it 09:09:48: -> do_recursion: clean up by calling dellist(filelist) 09:09:48: -> do_recursion: call-back files done proc (if any) 09:09:48: -> do_recursion: yes: call-back files done proc (if any) 09:09:48: -> find_filesdoneproc 09:09:48: -> do_recursion: at skip_directory 09:09:48: -> do_recursion: process the directories (if necessary) 09:09:48: -> do_recursion: cannot process the directories (dirlist == NULL) 09:09:48: -> Entries_Close - isfile ("CVS/Entries.Log") 09:09:48: -> Entries_Close - dellist (list) 09:09:48: -> do_recursion: free the saved copy of the pointer if necessary 09:09:48: -> more efficient - close directory in unroll_files_proc? 09:09:48: -> close_directory() 09:09:48: -> close_directory() directory_stack_size decreased by one to 0 09:09:48: -> unroll_files_proc() end 09:09:48: -> walklist call with unroll_files_proc done. err=0 09:09:48: -> freenode() free the badbad DIRS 09:09:48: -> dellist after unroll_files_proc done. 09:09:48: -> start_recursion: cannot do_recursion on the dirlist. 09:09:48: -> start_recursion: Free the data which expand_wild allocated. 09:09:48: -> start_recursion: Free the data - update_dir 09:09:48: -> start_recursion: Free the data - update_repos 09:09:48: -> start_recursion: (args_to_send_when_finished == NULL) 09:09:48: -> start_recursion: return 0. 09:09:48: -> Commit after start_recursion() find_args.argc=1 and find_args.renames=0 09:09:48: -> * Now we keep track of which files we actually are going to 09:09:48: -> operate on, and only work with those files in the future. 09:09:48: -> This saves time--we don't want to search the file system 09:09:48: -> of the working directory twice. 09:09:48: -> copy_ulist( ) create the argv[0] list "AURA.ear". 09:09:48: -> Commit created the argv[] list with find_args.argc=1 09:09:48: -> send_to_server_untranslated() calls buf_output() len=9 nbytes=683 09:09:48: -> send_to_server_untranslated() calls buf_output() len=2 nbytes=692 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=694 09:09:48: -> send_to_server_untranslated() calls buf_output() len=9 nbytes=695 09:09:48: -> send_to_server_untranslated() calls buf_output() len=11 nbytes=704 09:09:48: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=715 09:09:48: -> send_to_server_untranslated() calls buf_output() len=9 nbytes=716 09:09:49: -> send_to_server_untranslated() calls buf_output() len=2 nbytes=725 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=727 09:09:49: -> client (1) calls start_recursion() with 1 args 09:09:49: -> start_recursion((null),(null)) 09:09:49: -> start_recursion() dirleaveproc is OK 09:09:49: -> start_recursion() update_dir set to "" 09:09:49: -> start_recursion - argument count (argc) == 1 09:09:49: -> * There were arguments, so we have to handle them by hand. To do 09:09:49: -> * that, we set up the filelist and dirlist with the arguments and 09:09:49: -> * call do_recursion. do_recursion recognizes the fact that the 09:09:49: -> * lists are non-null when it starts and doesn't update them. 09:09:49: -> 09:09:49: -> * explicitly named directories are stored in dirlist. 09:09:49: -> * explicitly named files are stored in filelist. 09:09:49: -> * other possibility is named entities whicha are not currently in 09:09:49: -> * the working directory. 09:09:49: -> * if this argument is a directory, then add it to the list of directories. 09:09:49: -> * otherwise, split argument into directory and component names. 09:09:49: -> * Now break out argv[i] into directory part (DIR) and file part (COMP). 09:09:49: -> DIR and COMP will each point to a newly malloc'd string. 09:09:49: -> ParseTag_Dir(.,,,0,) 09:09:49: -> start_recursion: (1) addfile(files_by_dir,".","AURA.ear") 09:09:49: -> * At this point we have looped over all named arguments and built 09:09:49: -> a coupla lists. Now we unroll the lists, setting up and 09:09:49: -> calling do_recursion. 09:09:49: -> call walklist() with unroll_files_proc and files_by_dir 09:09:49: -> unroll_files_proc() begin 09:09:49: -> * if this dir was also an explicitly named argument, then skip 09:09:49: -> it. We'll catch it later when we do dirs. 09:09:49: -> * otherwise, call dorecusion for this list of files. 09:09:49: -> Name_Repository((null),) 09:09:49: -> Name_Repository dup tmp is len 09:09:49: -> Name_Repository dup tmp is now len 09:09:49: -> Name_Repository open CVS/Repository 09:09:49: -> Name_Repository opened CVS/Repository ok so read a line 09:09:49: -> Name_Repository closed CVS/Repository 09:09:49: -> Name_Repository read 1 AURAEAR 09:09:49: -> Name_Repository (stripped the newline) read 2 AURAEAR 09:09:49: -> Name_Repository isabsolute( AURAEAR )? 09:09:49: -> Name_Repository isabsolute( AURAEAR )! 09:09:49: -> Name_Repository Sanitize_Repository_Name( D:/CVSNT/GatewaySystems/AURAEAR )! 09:09:49: -> Name_Repository return ( D:/CVSNT/GatewaySystems/AURAEAR )! 09:09:49: -> ParseTag() 09:09:49: -> ParseTag_Dir((null),,,0,) 09:09:49: -> open_directory(D:/CVSNT/GatewaySystems/AURAEAR,.,(null),(null),0,(null),1) 09:09:49: -> open_directory() directory_stack_size increased by one to 1 09:09:49: -> Look for rename script file CVS/Rename 09:09:49: -> Rename script file does not exist 09:09:49: -> directory opened 09:09:49: -> do_recursion: begin 09:09:49: -> do_recursion: Check the value in CVSADM_ROOT 09:09:49: -> do_recursion: server does not appear to be active, update_dir= 09:09:49: -> do_recursion: Fill in repository with the current repository 09:09:49: -> do_recursion: update_dir= 09:09:49: -> Name_Repository((null),) 09:09:49: -> Name_Repository dup tmp is len 09:09:49: -> Name_Repository dup tmp is now len 09:09:49: -> Name_Repository open CVS/Repository 09:09:49: -> Name_Repository opened CVS/Repository ok so read a line 09:09:49: -> Name_Repository closed CVS/Repository 09:09:49: -> Name_Repository read 1 AURAEAR 09:09:49: -> Name_Repository (stripped the newline) read 2 AURAEAR 09:09:49: -> Name_Repository isabsolute( AURAEAR )? 09:09:49: -> Name_Repository isabsolute( AURAEAR )! 09:09:49: -> Name_Repository Sanitize_Repository_Name( D:/CVSNT/GatewaySystems/AURAEAR )! 09:09:49: -> Name_Repository return ( D:/CVSNT/GatewaySystems/AURAEAR )! 09:09:49: -> do_recursion: update_dir= repository=D:/CVSNT/GatewaySystems/AURAEAR 09:09:49: -> !(repository && (server_active || !current_parsed_root->isremote)) - so just strdup 09:09:49: -> Repository = D:/CVSNT/GatewaySystems/AURAEAR 09:09:49: -> Mapped repository = D:/CVSNT/GatewaySystems/AURAEAR 09:09:49: -> * The filesdoneproc needs to be called for each directory where files 09:09:49: -> * processed, or each directory that is processed by a call where no 09:09:49: -> * directories were passed in. In fact, the only time we don't want to 09:09:49: -> * call back the filesdoneproc is when we are processing directories that 09:09:49: -> * were passed in on the command line (or in the special case of `.' when 09:09:49: -> * we were called with no args 09:09:49: -> do_recursion: dirlist == NULL && filelist == NULL 09:09:49: -> do_recursion: dodoneproc=1 09:09:49: -> * If filelist or dirlist is already set, we don't look again. Otherwise, 09:09:49: -> * find the files and directories 09:09:49: -> do_recursion: something was passed on the command line 09:09:49: -> do_recursion: we will process files, so pre-parse entries 09:09:49: -> Entries_Open() 09:09:49: -> Entries_Open ParseTag() 09:09:49: -> ParseTag() 09:09:49: -> ParseTag_Dir((null),,,0,) 09:09:49: -> Entries_Open aflag==0 && dirtag==0 && dirdate==0 09:09:49: -> Entries_Open CVS_FOPEN("CVS/Entries","r") 09:09:49: -> Entries_Open CVS_FOPEN CVSADM_ENT returned a file handle, now call the (slow) fgetentent() / AddEntryNode 09:09:49: -> Entnode_Create() 09:09:49: -> Entnode_Create() finished 09:09:49: -> AddEntryNode() 09:09:49: -> AddEntryNode() get a node and fill in the regular stuff 09:09:49: -> AddEntryNode() this one gets a key of the name for hashing 09:09:49: -> AddEntryNode() put the node into the list 09:09:49: -> AddEntryNode() finished 09:09:49: -> Entnode_Create() 09:09:49: -> Entnode_Create() finished 09:09:49: -> AddEntryNode() 09:09:49: -> AddEntryNode() get a node and fill in the regular stuff 09:09:49: -> AddEntryNode() this one gets a key of the name for hashing 09:09:49: -> AddEntryNode() put the node into the list 09:09:49: -> AddEntryNode() finished 09:09:49: -> Entnode_Create() 09:09:49: -> Entnode_Create() finished 09:09:49: -> AddEntryNode() 09:09:49: -> AddEntryNode() get a node and fill in the regular stuff 09:09:49: -> AddEntryNode() this one gets a key of the name for hashing 09:09:49: -> AddEntryNode() put the node into the list 09:09:49: -> AddEntryNode() finished 09:09:49: -> Entries_Open fclose() CVSADM_ENT 09:09:49: -> Entries_Open CVS_FOPEN("CVS/Entries.Extra","r") 09:09:49: -> Entries_Open CVS_FOPEN CVSADM_ENTEXT returned a file handle 09:09:49: -> Entries_Open fclose() CVSADM_ENTEXT 09:09:49: -> Entries_Open CVS_FOPEN("CVS/Entries.Log","r") 09:09:49: -> Entries_Open clean up and return 09:09:49: -> Entries_Open done 09:09:49: -> do_recursion: process the files (if any) 09:09:49: -> do_recursion: read lock it if necessary 09:09:49: -> * For the server, we handle notifications in a completely different 09:09:49: -> place (server_notify). For local, we can't do them here--we don't 09:09:49: -> have writelocks in place, and there is no way to get writelocks here 09:09:49: -> do_recursion: process the files by calling walklist() 09:09:49: -> do_file_proc: process the files "AURA.ear" 09:09:49: -> !(server_active || !current_parsed_root->isremote) - so just strdup 09:09:49: -> do_file_proc: mapped name of file "AURA.ear" 09:09:49: -> do_file_proc: call findnode_fn() 09:09:49: -> do_file_proc: got a result from findnode_fn() 09:09:49: -> do_file_proc: verify_access() returned ok 09:09:49: -> send_fileproc (1) 09:09:49: -> send_a_repository(,D:/CVSNT/GatewaySystems/AURAEAR,) 09:09:49: -> send_repository(,D:/CVSNT/GatewaySystems/AURAEAR,) 09:09:49: -> allocate adm_name * 80 is large enough for any of CVSADM_*. 09:09:49: -> send_to_server_untranslated() calls buf_output() len=10 nbytes=728 09:09:49: -> * Send the directory name. 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=738 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=739 09:09:49: -> send_to_server_untranslated() calls buf_output() len=31 nbytes=740 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=771 09:09:49: -> Version_TS((null),(null),0) 09:09:49: -> wnt_stat(AURA.ear) 09:09:49: -> _statcore(00000000,AURA.ear) 09:09:49: -> Trying GetFileAttributesEx.... 09:09:49: -> File attributes = 00000020 09:09:49: -> - read/write file 09:09:49: -> GetUnixFileModeNtEA(A,00000650) returns 0400 09:09:49: -> _statcore(AURA.ear) returns S_IWRITE 09:09:49: -> send_to_server_untranslated() calls buf_output() len=7 nbytes=772 09:09:49: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=779 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=787 09:09:49: -> send_to_server_untranslated() calls buf_output() len=3 nbytes=788 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=791 09:09:49: -> send_to_server_untranslated() calls buf_output() len=24 nbytes=792 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=816 09:09:49: -> send_to_server_untranslated() calls buf_output() len=2 nbytes=817 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=819 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=820 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=821 09:09:49: -> send_to_server_untranslated() calls buf_output() len=12 nbytes=822 09:09:49: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=834 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=842 09:09:49: -> send_to_server_untranslated() calls buf_output() len=0 nbytes=843 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=843 09:09:49: -> send_to_server_untranslated() calls buf_output() len=0 nbytes=844 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=844 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=845 09:09:49: -> send_to_server_untranslated() calls buf_output() len=0 nbytes=846 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=846 09:09:49: -> send_to_server_untranslated() calls buf_output() len=0 nbytes=847 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=847 09:09:49: -> send_to_server_untranslated() calls buf_output() len=0 nbytes=848 09:09:49: -> send_to_server_untranslated() calls buf_output() len=2 nbytes=848 09:09:49: -> Sending file 'AURA.ear' to server 09:09:49: -> wnt_stat(AURA.ear) 09:09:49: -> _statcore(00000000,AURA.ear) 09:09:49: -> Trying GetFileAttributesEx.... 09:09:49: -> File attributes = 00000020 09:09:49: -> - read/write file 09:09:49: -> GetUnixFileModeNtEA(A,00000650) returns 0400 09:09:49: -> _statcore(AURA.ear) returns S_IWRITE 09:09:49: -> If the file is unicode (and the remote server supports it), translate it to utf8 before transmitting. 09:09:49: -> encode is NOT set. 09:09:49: -> wnt_stat(AURA.ear) 09:09:49: -> _statcore(00000000,AURA.ear) 09:09:49: -> Trying GetFileAttributesEx.... 09:09:49: -> File attributes = 00000020 09:09:49: -> - read/write file 09:09:49: -> GetUnixFileModeNtEA(A,00000650) returns 0400 09:09:49: -> _statcore(AURA.ear) returns S_IWRITE 09:09:49: -> send_to_server_untranslated() calls buf_output() len=13 nbytes=850 09:09:49: -> send_to_server_untranslated() calls buf_output() len=26 nbytes=863 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=889 09:09:49: -> send_to_server_untranslated() calls buf_output() len=9 nbytes=890 09:09:49: -> send_to_server_untranslated() calls buf_output() len=8 nbytes=899 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=907 09:09:49: -> send_to_server_untranslated() calls buf_output() len=10 nbytes=908 09:09:49: -> send_to_server_untranslated() calls buf_output() len=1 nbytes=918 09:09:49: -> send_to_server_untranslated() calls buf_output() len=9 nbytes=919 09:09:49: -> /3GB is not enabled, highest user address is 7ffeffff 09:09:49: -> Client has 39 percent of memory in use. 09:09:49: -> Client has 4194303 total Kbytes of physical memory*. 09:09:49: -> Client has 4194303 free Kbytes of physical memory*. 09:09:49: -> Client has 13630548 total Kbytes of physical memory. 09:09:49: -> Client has 8296832 free Kbytes of physical memory. 09:09:49: -> Client has 17211160 total Kbytes of paging file. 09:09:49: -> Client has 12079692 free Kbytes of paging file. 09:09:49: -> Client has 2097024 total Kbytes of virtual memory. 09:09:49: -> Client has 2016348 free Kbytes of virtual memory. 09:09:49: -> Client has 0 free Kbytes of extended memory. 09:09:49: -> Client seems to have enough memory, send an error message showing available memory. 09:09:49: -> send_modified() yes enough memory to complete: 09:09:49: -> Client has 12079692/17211160 page, 2016348/2097024 virt, 39/13630548 memory. 09:09:49: -> Sending binary file of size '39313704' to server unencoded without md5. 09:09:49: -> send_to_server_untranslated: size > 100k, calling buf_send_immediate 09:09:49: -> tcp_write(245,1792) 09:09:49: -> tcp_write(39313704,1792) 09:09:49: -> tcp_write(38265128) got WSAEWOULDBLOCK so wait using WSAEventSelect(FD_WRITE) 09:09:49: -> tcp_write(38265128) -1000 ms timeout 09:09:49: -> client_buffer_output() Error writing to server WSAECONNRESET cvs [commit aborted]: Error writing to server WSAECONNRESET 09:09:49: -> Unloading - about to clear list 09:09:49: -> Unloading - cleared list