12:19:04: -> Client trace started, level=3. 12:19:04: -> Tracelevel set to 3. PID is 3696 12:19:04: -> Session ID is e704f958f08787c 12:19:04: -> Session time is Mon Apr 23 17:19:04 2012 12:19:04: -> Client was compiled Jan 6 2012 23:38:33 12:19:04: -> Client was compiled with MSVC C/C++ 1310 12:19:04: -> Client build platform is microsoft-windows-x86 12:19:04: -> Build version is CVSNT 2.8.01 (Soolin) Build 4395 12:19:04: -> User name is Glen Starrett 12:19:04: -> Client running on "Windows 7 x64 Service Pack 1 (Build 7601) [6.1.7601] (Service Pack 1)" 12:19:04: -> /3GB is enabled, highest user address is fffeffff 12:19:04: -> Client has 39 percent of memory in use. 12:19:04: -> Client has 4194303 total Kbytes of physical memory*. 12:19:04: -> Client has 4194303 free Kbytes of physical memory*. 12:19:04: -> Client has 12541008 total Kbytes of physical memory. 12:19:04: -> Client has 7562436 free Kbytes of physical memory. 12:19:04: -> Client has 25080168 total Kbytes of paging file. 12:19:04: -> Client has 20083924 free Kbytes of paging file. 12:19:04: -> Client has 4194176 total Kbytes of virtual memory. 12:19:04: -> Client has 4113240 free Kbytes of virtual memory. 12:19:04: -> Client has 0 free Kbytes of extended memory. 12:19:04: -> The custom heap has the low-fragmentation heap enabled. 12:19:04: -> The minimum large page size is 2097152. 12:19:04: -> Walking heap 0X028B0000... 12:19:04: -> Region 12:19:04: -> 249856 bytes committed 12:19:04: -> 12288 bytes uncommitted 12:19:04: -> First block address: 0X028B0598 12:19:04: -> Last block address: 0X028F0000 12:19:04: -> Data portion begins at: 0X028B0000 12:19:04: -> Size: 1416 bytes 12:19:04: -> Overhead: 0 bytes 12:19:04: -> Region index: 0 12:19:04: -> Block 12:19:04: -> Data portion begins at: 0X028EBDA8 12:19:04: -> Size: 4664 bytes 12:19:04: -> Overhead: 16 bytes 12:19:04: -> Region index: 0 12:19:04: -> Uncommitted range 12:19:04: -> Data portion begins at: 0X028ED000 12:19:04: -> Size: 12288 bytes 12:19:04: -> Overhead: 0 bytes 12:19:04: -> Region index: 0 12:19:04: -> Client Hardware information (Wow64): 12:19:04: -> Number of processors: 8 12:19:04: -> Processor type: 8664 12:19:04: -> processor architecture: x64 12:19:04: -> processor type 8664/Xeon model: unknown 12:19:04: -> Free space in C:\Users\GLENST~1\AppData\Local\Temp 2491072512 12:19:04: -> Total space in C:\Users\GLENST~1\AppData\Local\Temp 2386554880 12:19:04: -> Total Free space in C:\Users\GLENST~1\AppData\Local\Temp 2491072512 12:19:04: -> Loading protocol pserver as pserver.dll 12:19:04: -> CLibraryAccess::Load loading C:\PROGRA~2\CVSSUI~1\CVSNT/protocols/pserver.dll 12:19:04: -> main loop with CVSROOT=:pserver:gstarret@stanley:/test2 12:19:04: -> main - about to start the server yes 12:19:04: -> start_server(verify_only=0) 12:19:04: -> client start - client_protocol->connect 12:19:04: -> Buffer size is 5120 12:19:04: -> client start - Loop, getting responses from the server. 12:19:04: -> client start - got "I LOVE YOU" 12:19:04: -> client start - continue login. 12:19:04: -> client start - server started. 12:19:04: -> client start - send Valid-responses to server. 12:19:04: -> client start - send valid-requests to server. 12:19:04: -> client start - rootless_encryption. 12:19:04: -> Server codepage is UTF-8 12:19:04: -> Client codepage is CP1252 12:19:04: -> Server->Client codepage translation is active 12:19:04: -> Server version is CVSNT 2.8.01 (Soolin) Build 4377 12:19:04: -> Client version is CVSNT 2.8.01 (Soolin) Build 4395 12:19:04: -> Requesting server cvsignore 12:19:04: -> wrap_add(*.a -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.a" 12:19:04: -> wrap_add(*.ai -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ai" 12:19:04: -> wrap_add(*.avi -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.avi" 12:19:04: -> wrap_add(*.bin -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.bin" 12:19:04: -> wrap_add(*.bmp -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.bmp" 12:19:04: -> wrap_add(*.bz2 -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.bz2" 12:19:04: -> wrap_add(*.cdd -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.cdd" 12:19:04: -> wrap_add(*.cdmz -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.cdmz" 12:19:04: -> wrap_add(*.chm -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.chm" 12:19:04: -> wrap_add(*.class -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.class" 12:19:04: -> wrap_add(*.cur -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.cur" 12:19:04: -> wrap_add(*.dll -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.dll" 12:19:04: -> wrap_add(*.doc -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.doc" 12:19:04: -> wrap_add(*.docx -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.docx" 12:19:04: -> wrap_add(*.docm -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.docm" 12:19:04: -> wrap_add(*.fp -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.fp" 12:19:04: -> wrap_add(*.pptx -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.pptx" 12:19:04: -> wrap_add(*.pptm -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.pptm" 12:19:04: -> wrap_add(*.xlsx -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.xlsx" 12:19:04: -> wrap_add(*.xlsm -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.xlsm" 12:19:04: -> wrap_add(*.odt -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.odt" 12:19:04: -> wrap_add(*.ods -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ods" 12:19:04: -> wrap_add(*.odp -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.odp" 12:19:04: -> wrap_add(*.odb -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.odb" 12:19:04: -> wrap_add(*.odg -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.odg" 12:19:04: -> wrap_add(*.odf -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.odf" 12:19:04: -> wrap_add(*.mpp -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.mpp" 12:19:04: -> wrap_add(*.dvi -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.dvi" 12:19:04: -> wrap_add(*.exe -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.exe" 12:19:04: -> wrap_add(*.gif -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.gif" 12:19:04: -> wrap_add(*.gz -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.gz" 12:19:04: -> wrap_add(*.hqx -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.hqx" 12:19:04: -> wrap_add(*.ico -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ico" 12:19:04: -> wrap_add(*.ilk -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ilk" 12:19:04: -> wrap_add(*.indd -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.indd" 12:19:04: -> wrap_add(*.iso -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.iso" 12:19:04: -> wrap_add(*.lib -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.lib" 12:19:04: -> wrap_add(*.jar -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.jar" 12:19:04: -> wrap_add(*.jpg -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.jpg" 12:19:04: -> wrap_add(*.jpeg -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.jpeg" 12:19:04: -> wrap_add(*.lnk -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.lnk" 12:19:04: -> wrap_add(*.mpg -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.mpg" 12:19:04: -> wrap_add(*.mpeg -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.mpeg" 12:19:04: -> wrap_add(*.mov -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.mov" 12:19:04: -> wrap_add(*.mp3 -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.mp3" 12:19:04: -> wrap_add(*.ncb -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ncb" 12:19:04: -> wrap_add(*.o -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.o" 12:19:04: -> wrap_add(*.ogg -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ogg" 12:19:04: -> wrap_add(*.ocx -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ocx" 12:19:04: -> wrap_add(*.obj -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.obj" 12:19:04: -> wrap_add(*.pdb -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.pdb" 12:19:04: -> wrap_add(*.pdf -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.pdf" 12:19:04: -> wrap_add(*.png -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.png" 12:19:04: -> wrap_add(*.ppt -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ppt" 12:19:04: -> wrap_add(*.psd -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.psd" 12:19:04: -> wrap_add(*.res -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.res" 12:19:04: -> wrap_add(*.rpm -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.rpm" 12:19:04: -> wrap_add(*.sit -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.sit" 12:19:04: -> wrap_add(*.so -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.so" 12:19:04: -> wrap_add(*.tar -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.tar" 12:19:04: -> wrap_add(*.tga -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.tga" 12:19:04: -> wrap_add(*.tgz -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.tgz" 12:19:04: -> wrap_add(*.tif -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.tif" 12:19:04: -> wrap_add(*.tiff -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.tiff" 12:19:04: -> wrap_add(*.ttf -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ttf" 12:19:04: -> wrap_add(*.uir -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.uir" 12:19:04: -> wrap_add(*.wav -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.wav" 12:19:04: -> wrap_add(*.wmv -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.wmv" 12:19:04: -> wrap_add(*.xls -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.xls" 12:19:04: -> wrap_add(*.zip -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.zip" 12:19:04: -> wrap_add(*.Z -kb, 0, 0, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.Z" 12:19:04: -> Requesting server cvswrappers 12:19:04: -> wrap_add(*.cab -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.cab" 12:19:04: -> wrap_add(*.class -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.class" 12:19:04: -> wrap_add(*.dll -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.dll" 12:19:04: -> wrap_add(*.doc -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.doc" 12:19:04: -> wrap_add(*.docx -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.docx" 12:19:04: -> wrap_add(*.dot -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.dot" 12:19:04: -> wrap_add(*.exe -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.exe" 12:19:04: -> wrap_add(*.exp -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.exp" 12:19:04: -> wrap_add(*.gif -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.gif" 12:19:04: -> wrap_add(*.gz -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.gz" 12:19:04: -> wrap_add(*.jar -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.jar" 12:19:04: -> wrap_add(*.jpg -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.jpg" 12:19:04: -> wrap_add(*.jpeg -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.jpeg" 12:19:04: -> wrap_add(*.lib -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.lib" 12:19:04: -> wrap_add(*.mpp -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.mpp" 12:19:04: -> wrap_add(*.mppx -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.mppx" 12:19:04: -> wrap_add(*.msg -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.msg" 12:19:04: -> wrap_add(*.msi -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.msi" 12:19:04: -> wrap_add(*.mso -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.mso" 12:19:04: -> wrap_add(*.pfw -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.pfw" 12:19:04: -> wrap_add(*.png -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.png" 12:19:04: -> wrap_add(*.ppt -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ppt" 12:19:04: -> wrap_add(*.pptx -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.pptx" 12:19:04: -> wrap_add(*.sit -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.sit" 12:19:04: -> wrap_add(*.slddrw -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.slddrw" 12:19:04: -> wrap_add(*.sldasm -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.sldasm" 12:19:04: -> wrap_add(*.sldprt -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.sldprt" 12:19:04: -> wrap_add(*.tar -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.tar" 12:19:04: -> wrap_add(*.tlb -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.tlb" 12:19:04: -> wrap_add(*.txt -k 'ckv', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.txt" 12:19:04: -> wrap_add(*.vi -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.vi" 12:19:04: -> wrap_add(*.vsd -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.vsd" 12:19:04: -> wrap_add(*.xls -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.xls" 12:19:04: -> wrap_add(*.xlsx -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.xlsx" 12:19:04: -> wrap_add(*.xlt -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.xlt" 12:19:04: -> wrap_add(*.wmz -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.wmz" 12:19:04: -> wrap_add(*.zip -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.zip" 12:19:04: -> wrap_add(*.pcbdoc -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.pcbdoc" 12:19:04: -> wrap_add(*.schdoc -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.schdoc" 12:19:04: -> wrap_add(*.cam -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.cam" 12:19:04: -> wrap_add(*.pdf -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.pdf" 12:19:04: -> wrap_add(*.fpd -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.fpd" 12:19:04: -> wrap_add(*.pcblib -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.pcblib" 12:19:04: -> wrap_add(*.bin -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.bin" 12:19:04: -> wrap_add(*.aps -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.aps" 12:19:04: -> wrap_add(*.ncb -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ncb" 12:19:04: -> wrap_add(*.opt -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.opt" 12:19:04: -> wrap_add(*.suo -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.suo" 12:19:04: -> wrap_add(*.ico -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.ico" 12:19:04: -> wrap_add(*.jpg -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.jpg" 12:19:04: -> wrap_add(*.jpeg -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.jpeg" 12:19:04: -> wrap_add(*.bmp -k 'b', 0, 1, 0, 0) 12:19:04: -> Call CFileAccess::mimetype: "*.bmp" 12:19:04: -> Got the server cvswrappers 12:19:04: -> The first item in the sorted list is "b" with wildcard "*.a" 12:19:04: -> Requesting server cvsrc (read-cvsrc2) 12:19:04: -> Parsing global cvsrc started 12:19:04: -> Parsing global cvsrc finished 0 lines. 12:19:04: -> No local C:\Users\Glen Starrett/.cvsrc to parse 12:19:04: -> Server: call the requested function ls 12:19:07: S -> server_main started 12:19:07: S -> server_main process id is 879 12:19:07: S -> run plugintools proc server 12:19:07: S -> run_trigger() 12:19:07: S -> LoadTrigger(audit.la) 12:19:07: S -> Audit trigger not enabled. 12:19:07: S -> Couldn't load trigger audit.la 12:19:07: S -> Checking admin file /var/cvs/test2/CVSROOT/admin for user gstarret 12:19:07: S -> Checking started in admin file /var/cvs/test2/CVSROOT/admin for user gstarret 12:19:07: S -> Checked admin file (null) for user gstarret they are an admin. 12:19:07: S -> InitTrigger(checkout.la) 12:19:07: S -> Checkout trigger is enabled. 12:19:07: S -> InitTrigger(email.la) 12:19:07: S -> Email trigger not enabled. 12:19:07: S -> Couldn't load trigger email.la 12:19:07: S -> LoadTrigger(bug_trigger.la) 12:19:07: S -> LibraryAccess::Load failed for '/usr/lib/cvsnt/triggers/bug_trigger.la', error = No such file or directory 12:19:07: S -> Unable to load bug_trigger.la: error 2 12:19:07: S -> Couldn't load trigger bug_trigger.la 12:19:07: S -> InitTrigger(info.la) 12:19:07: S -> LoadTrigger(bug.la) 12:19:07: S -> Defect Tracking trigger not enabled. 12:19:07: S -> Couldn't load trigger bug.la 12:19:07: S -> InitTrigger(make.la) 12:19:07: S -> Make trigger not enabled. 12:19:07: S -> Couldn't load trigger make.la 12:19:07: S -> Call pre-loaded 'checkout.la' 12:19:07: S -> plugintools_proc() 12:19:07: S -> Call pre-loaded 'checkout.la' returned 0, total ret 0 12:19:07: S -> Call pre-loaded 'info.la' 12:19:07: S -> plugintools_proc() 12:19:07: S -> Call pre-loaded 'info.la' returned 0, total ret 0 12:19:07: S -> run_trigger returning 0 12:19:07: S -> run precommand proc server 12:19:07: S -> run_trigger() 12:19:07: S -> Call pre-loaded 'checkout.la' 12:19:07: S -> precommand_proc() 12:19:07: S -> Call pre-loaded 'checkout.la' returned 0, total ret 0 12:19:07: S -> Call pre-loaded 'info.la' 12:19:07: S -> precommand_proc() 12:19:07: S -> default_trigger: parse_info(CVSROOT/precommand,%r %c,%) 12:19:07: S -> Call pre-loaded 'info.la' returned 0, total ret 0 12:19:07: S -> run_trigger returning 0 12:19:07: S -> open_module(/var/cvs/test2) 12:19:07: S -> do_module(test-filtered, Listing, , ) 12:19:07: S -> do_module calls map_repository() 12:19:07: S -> map_repository(/var/cvs/test2/test-filtered) 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(test-filtered) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> Loading modules2 from /var/cvs/test2/CVSROOT/modules2 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(test-filtered,1) 12:19:07: S -> _lookup_module2 !p lookup_repository_module(test-filtered) 12:19:07: S -> lookup_repository_module(test-filtered) 12:19:07: S -> _lookup_module2 lookup_repository_directory(,0,0) 12:19:07: S -> _lookup_module2 lookup_repository_directory results "",0,0 12:19:07: S -> lookup_module2() call to lookup_repository_directory() returned something 12:19:07: S -> _lookup_module2 return at end 1 left,right(testcvs/unfiltered,) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 1 12:19:07: S -> lookup_module2() found "testcvs/unfiltered" 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered,1) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right(,testcvs/unfiltered) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() return 1 12:19:07: S -> lookup_module2() ret=1, current_directory==NULL, current_directory->directory_mappings=!!!! 12:19:07: S -> lookup_module2() return ret=1 renamed=0 12:19:07: S -> map_repository - lookup_module2 returned res==1 12:19:07: S -> map_repository - return(ret) "/var/cvs/test2/testcvs/unfiltered" 12:19:07: S -> do_module call to map_repository() has returned something 12:19:07: S -> * check to see if mname is a directory or file 12:19:07: S -> do_module calls isdir(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> do_module yes it is a directory ... 12:19:07: S -> * OK, we have now set up modargv with the actual file/directory we want to work on. 12:19:07: S -> run premodule trigger 12:19:07: S -> run_trigger() 12:19:07: S -> Call pre-loaded 'checkout.la' 12:19:07: S -> premodule_proc(test-filtered) 12:19:07: S -> Call pre-loaded 'checkout.la' returned 0, total ret 0 12:19:07: S -> Call pre-loaded 'info.la' 12:19:07: S -> premodule_proc(test-filtered) 12:19:07: S -> default_trigger: parse_info(CVSROOT/premodule,%r/%p %c %o,,test-filtered) 12:19:07: S -> Call pre-loaded 'info.la' returned 0, total ret 0 12:19:07: S -> run_trigger returning 0 12:19:07: S -> do_modue(1): call the callback_proc((null)) Listing module: test-filtered 12:19:07: S -> map_repository(/var/cvs/test2/test-filtered) 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(test-filtered) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(test-filtered,2) 12:19:07: S -> _lookup_module2 !p lookup_repository_module(test-filtered) 12:19:07: S -> lookup_repository_module(test-filtered) 12:19:07: S -> _lookup_module2 lookup_repository_directory(,0,0) 12:19:07: S -> _lookup_module2 lookup_repository_directory results "",0,0 12:19:07: S -> lookup_module2() call to lookup_repository_directory() returned something 12:19:07: S -> _lookup_module2 return at end 1 left,right(testcvs/unfiltered,) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 1 12:19:07: S -> lookup_module2() found "testcvs/unfiltered" 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered,2) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right(,testcvs/unfiltered) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() return 1 12:19:07: S -> lookup_module2() ret=1, current_directory==NULL, current_directory->directory_mappings=!!!! 12:19:07: S -> lookup_module2() return ret=1 renamed=0 12:19:07: S -> map_repository - lookup_module2 returned res==1 12:19:07: S -> map_repository - return(ret) "/var/cvs/test2/testcvs/unfiltered" 12:19:07: S -> start_recursion(test-filtered,(null)) 12:19:07: S -> start_recursion() dirleaveproc is NULL 12:19:07: S -> start_recursion() update_dir set to "test-filtered" 12:19:07: S -> start_recursion - argument count (argc) == 0 12:19:07: S -> * There were no arguments, so we'll probably just recurse. The 12:19:07: S -> * exception to the rule is when we are called from a directory 12:19:07: S -> * without any CVS administration files. That has always meant to 12:19:07: S -> * process each of the sub-directories, so we pretend like we were 12:19:07: S -> * called with the list of sub-dirs of the current dir as args 12:19:07: S -> start_recursion: !just_subdirs - call addlist(dirlist==NULL, ".") 12:19:07: S -> start_recursion: addlist() returns and now dirlist!=NULL 12:19:07: S -> start_recursion/do_the_work: do_recursion() on the frame (dirlist != NULL). 12:19:07: S -> do_recursion: begin 12:19:07: S -> do_recursion: Check the value in CVSADM_ROOT 12:19:07: S -> do_recursion: Fill in repository with the current repository 12:19:07: S -> (repository && (server_active || !current_parsed_root->isremote)) 12:19:07: S -> map_repository(/var/cvs/test2/test-filtered) 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(test-filtered) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(test-filtered,3) 12:19:07: S -> _lookup_module2 !p lookup_repository_module(test-filtered) 12:19:07: S -> lookup_repository_module(test-filtered) 12:19:07: S -> _lookup_module2 lookup_repository_directory(,0,0) 12:19:07: S -> _lookup_module2 lookup_repository_directory results "",0,0 12:19:07: S -> lookup_module2() call to lookup_repository_directory() returned something 12:19:07: S -> _lookup_module2 return at end 1 left,right(testcvs/unfiltered,) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 1 12:19:07: S -> lookup_module2() found "testcvs/unfiltered" 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered,3) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right(,testcvs/unfiltered) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() return 1 12:19:07: S -> lookup_module2() ret=1, current_directory==NULL, current_directory->directory_mappings=!!!! 12:19:07: S -> lookup_module2() return ret=1 renamed=0 12:19:07: S -> map_repository - lookup_module2 returned res==1 12:19:07: S -> map_repository - return(ret) "/var/cvs/test2/testcvs/unfiltered" 12:19:07: S -> Repository = /var/cvs/test2/test-filtered 12:19:07: S -> Mapped repository = /var/cvs/test2/testcvs/unfiltered 12:19:07: S -> (repository && (server_active || !current_parsed_root->isremote)) 12:19:07: S -> ParseTag() 12:19:07: S -> ParseTag_Dir((null),,,0,) 12:19:07: S -> verify_access /var/cvs/test2/testcvs/unfiltered,test-filtered,(null) 12:19:07: S -> verify_perm(/var/cvs/test2/testcvs/unfiltered,(null),read,(null),(null)) 12:19:07: S -> verify_perm: verify_owner_dir() 12:19:07: S -> verify_owner(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> cache_directory_permissions(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> fileattr_read(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> _fileattr_read() malloc [strlen(/var/cvs/test2/testcvs/unfiltered)=]33+[sizeof(CVS/fileattr.xml)=]17+20=70 12:19:07: S -> _fileattr_read() allocated memory for fname - will now sprintf() 12:19:07: S -> _fileattr_read() ReadXmlFile("/var/cvs/test2/testcvs/unfiltered/CVS/fileattr.xml") 12:19:07: S -> cache_directory_permissions() - cache directory(fileattr,) 12:19:07: S -> cache_directory_permissions() fncmp(d="/var/cvs/test2/testcvs/unfiltered",current_parsed_root->directory="/var/cvs/test2") 12:19:07: S -> cache_directory_permissions() last_component=unfiltered 12:19:07: S -> fileattr_read(/var/cvs/test2/testcvs) 12:19:07: S -> _fileattr_read() malloc [strlen(/var/cvs/test2/testcvs)=]22+[sizeof(CVS/fileattr.xml)=]17+20=59 12:19:07: S -> _fileattr_read() allocated memory for fname - will now sprintf() 12:19:07: S -> _fileattr_read() ReadXmlFile("/var/cvs/test2/testcvs/CVS/fileattr.xml") 12:19:07: S -> cache_directory_permissions() - cache directory(fileattr,) 12:19:07: S -> cache_directory_permissions() fncmp(d="/var/cvs/test2/testcvs",current_parsed_root->directory="/var/cvs/test2") 12:19:07: S -> cache_directory_permissions() last_component=testcvs 12:19:07: S -> fileattr_read(/var/cvs/test2) 12:19:07: S -> _fileattr_read() malloc [strlen(/var/cvs/test2)=]14+[sizeof(CVS/fileattr.xml)=]17+20=51 12:19:07: S -> _fileattr_read() allocated memory for fname - will now sprintf() 12:19:07: S -> _fileattr_read() ReadXmlFile("/var/cvs/test2/CVS/fileattr.xml") 12:19:07: S -> cache_directory_permissions() - cache directory(fileattr,) 12:19:07: S -> cache_directory_permissions() fncmp(d="/var/cvs/test2",current_parsed_root->directory="/var/cvs/test2") 12:19:07: S -> cache_directory_permissions() free(/var/cvs/test2) 12:19:07: S -> cache_directory_permissions() return 12:19:07: S -> verify_perm() Read directory permission cache OK 12:19:07: S -> ACL lookup on directory /var/cvs/test2/testcvs/unfiltered 12:19:07: S -> verify_acl(read,HEAD,(null)) 12:19:07: S -> user_state = 0, group_state = 0 12:19:07: S -> no match at this level 12:19:07: S -> ACL lookup on directory /var/cvs/test2/testcvs 12:19:07: S -> verify_acl(read,HEAD,(null)) 12:19:07: S -> user_state = 0, group_state = 0 12:19:07: S -> no match at this level 12:19:07: S -> ACL lookup on directory /var/cvs/test2 12:19:07: S -> verify_acl(read,HEAD,(null)) 12:19:07: S -> verify_valid_name(gstarret) 12:19:07: S -> matched ACL user=gstarret, branch=_default_, merge=(no acl_merge) 12:19:07: S -> calculated ACL priority is 10 12:19:07: S -> new max priority is 10 12:19:07: S -> matched ACL user=_default_, branch=_default_, merge=(no acl_merge) 12:19:07: S -> calculated ACL priority is 0 12:19:07: S -> matched ACL user=_default_, branch=_default_, merge=(no acl_merge) 12:19:07: S -> calculated ACL priority is 0 12:19:07: S -> user_state = 1, group_state = 0 12:19:07: S -> Match found. user_state = 1, group_state = 0 12:19:07: S -> fileattr_startdir(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> * The filesdoneproc needs to be called for each directory where files 12:19:07: S -> * processed, or each directory that is processed by a call where no 12:19:07: S -> * directories were passed in. In fact, the only time we don't want to 12:19:07: S -> * call back the filesdoneproc is when we are processing directories that 12:19:07: S -> * were passed in on the command line (or in the special case of `.' when 12:19:07: S -> * we were called with no args 12:19:07: S -> do_recursion: dirlist != NULL && filelist == NULL 12:19:07: S -> do_recursion: dodoneproc=0 12:19:07: S -> * If filelist or dirlist is already set, we don't look again. Otherwise, 12:19:07: S -> * find the files and directories 12:19:07: S -> do_recursion: something was passed on the command line 12:19:07: S -> do_recursion: process the files (if any) 12:19:07: S -> do_recursion: call-back files done proc (if any) 12:19:07: S -> do_recursion: no: don't call-back files done proc (process_this_directory!dodoneprocframe->filesdoneproc == NULL) 12:19:07: S -> do_recursion: at skip_directory 12:19:07: S -> (repository && (server_active || !current_parsed_root->isremote)) 12:19:07: S -> fileattr_write() 12:19:07: S -> fileattr_free() 12:19:07: S -> do_recursion: process the directories (if necessary) 12:19:07: S -> do_recursion: really process the directories (if necessary) 12:19:07: S -> do_recursion() -- walklist (dirlist !=NULL, do_dir_proc, (void *) &frent) 12:19:07: S -> do_dir_proc() 12:19:07: S -> do_dir_proc() update_dir=test-filtered 12:19:07: S -> do_dir_proc() -- set up update_dir(test-filtered) - no dots ? 12:19:07: S -> do_dir_proc() -- set up update_dir is now dirp "test-filtered" - no dots ? 12:19:07: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote 12:19:07: S -> ParseTag() 12:19:07: S -> ParseTag_Dir((null),,,0,) 12:19:07: S -> do_dir_proc() -- verify_access 12:19:07: S -> verify_access /var/cvs/test2/testcvs/unfiltered,test-filtered,(null) 12:19:07: S -> verify_perm(/var/cvs/test2/testcvs/unfiltered,(null),read,(null),(null)) 12:19:07: S -> verify_perm: verify_owner_dir() 12:19:07: S -> verify_owner(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> cache_directory_permissions(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> cache_directory_permissions() fncmp(d="/var/cvs/test2/testcvs/unfiltered",current_parsed_root->directory="/var/cvs/test2") 12:19:07: S -> cache_directory_permissions() last_component=unfiltered 12:19:07: S -> cache_directory_permissions() fncmp(d="/var/cvs/test2/testcvs",current_parsed_root->directory="/var/cvs/test2") 12:19:07: S -> cache_directory_permissions() last_component=testcvs 12:19:07: S -> cache_directory_permissions() fncmp(d="/var/cvs/test2",current_parsed_root->directory="/var/cvs/test2") 12:19:07: S -> cache_directory_permissions() free(/var/cvs/test2) 12:19:07: S -> cache_directory_permissions() return 12:19:07: S -> verify_perm() Read directory permission cache OK 12:19:07: S -> ACL lookup on directory /var/cvs/test2/testcvs/unfiltered 12:19:07: S -> verify_acl(read,HEAD,(null)) 12:19:07: S -> user_state = 0, group_state = 0 12:19:07: S -> no match at this level 12:19:07: S -> ACL lookup on directory /var/cvs/test2/testcvs 12:19:07: S -> verify_acl(read,HEAD,(null)) 12:19:07: S -> user_state = 0, group_state = 0 12:19:07: S -> no match at this level 12:19:07: S -> ACL lookup on directory /var/cvs/test2 12:19:07: S -> verify_acl(read,HEAD,(null)) 12:19:07: S -> verify_valid_name(gstarret) 12:19:07: S -> matched ACL user=gstarret, branch=_default_, merge=(no acl_merge) 12:19:07: S -> calculated ACL priority is 10 12:19:07: S -> new max priority is 10 12:19:07: S -> matched ACL user=_default_, branch=_default_, merge=(no acl_merge) 12:19:07: S -> calculated ACL priority is 0 12:19:07: S -> matched ACL user=_default_, branch=_default_, merge=(no acl_merge) 12:19:07: S -> calculated ACL priority is 0 12:19:07: S -> user_state = 1, group_state = 0 12:19:07: S -> Match found. user_state = 1, group_state = 0 12:19:07: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL 12:19:07: S -> do_dir_proc() -- process_this_directory 12:19:07: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory 12:19:07: S -> do_dir_proc() after predirent call ParseTag_Dir() 12:19:07: S -> ParseTag_Dir(.,,,0,) 12:19:07: S -> open_directory(/var/cvs/test2/testcvs/unfiltered,.,(null),(null),0,(null),0) 12:19:07: S -> open_directory() directory_stack_size increased by one to 1 12:19:07: S -> open_directory, (!remote) try and find a mapping file in this directory . 12:19:07: S -> RCS_parse(.directory_history,/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> rcsbuf_open(/var/cvs/test2/testcvs/unfiltered/.directory_history,v) 12:19:07: S -> rcsbuf_open(/var/cvs/test2/testcvs/unfiltered/.directory_history,v) failed to open file 1 times 12:19:07: S -> rcsbuf_open(/var/cvs/test2/testcvs/unfiltered/.directory_history,v) file does not exist, so return 0 12:19:07: S -> rcsbuf_open failed 12:19:07: S -> rcsbuf_open(/var/cvs/test2/testcvs/unfiltered/Attic/.directory_history,v) 12:19:07: S -> rcsbuf_open(/var/cvs/test2/testcvs/unfiltered/Attic/.directory_history,v) failed to open file 1 times 12:19:07: S -> rcsbuf_open(/var/cvs/test2/testcvs/unfiltered/Attic/.directory_history,v) file does not exist, so return 0 12:19:07: S -> rcsbuf_open failed 12:19:07: S -> No mapping file in this directory. 12:19:07: S -> open_directory copy the tag and date. 12:19:07: S -> open_directory copied the tag and date. 12:19:07: S -> Look for rename script file CVS/Rename 12:19:07: S -> Rename script file does not exist 12:19:07: S -> directory opened 12:19:07: S -> fileattr_startdir(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> do_dir_proc() -- call-back dir entry proc (if any) 12:19:07: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc. 12:19:07: S -> do_dir_proc() -- only process the dir if the return code was 0. 12:19:07: S -> do_dir_proc() -- !(frame->which&(W_LOCAL|W_FAKE)) 12:19:07: S -> debug: 18 12:19:07: S -> debug: 19 12:19:07: S -> debug: 20 12:19:07: S -> do_recursion: begin 12:19:07: S -> do_recursion: Check the value in CVSADM_ROOT 12:19:07: S -> do_recursion: Fill in repository with the current repository 12:19:07: S -> (repository && (server_active || !current_parsed_root->isremote)) 12:19:07: S -> map_repository(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(testcvs/unfiltered) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered,4) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right(,testcvs/unfiltered) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 12:19:07: S -> lookup_module2() return ret=0 renamed=0 12:19:07: S -> map_repository - return(repository) "/var/cvs/test2/testcvs/unfiltered" 12:19:07: S -> Repository = /var/cvs/test2/testcvs/unfiltered 12:19:07: S -> Mapped repository = /var/cvs/test2/testcvs/unfiltered 12:19:07: S -> * The filesdoneproc needs to be called for each directory where files 12:19:07: S -> * processed, or each directory that is processed by a call where no 12:19:07: S -> * directories were passed in. In fact, the only time we don't want to 12:19:07: S -> * call back the filesdoneproc is when we are processing directories that 12:19:07: S -> * were passed in on the command line (or in the special case of `.' when 12:19:07: S -> * we were called with no args 12:19:07: S -> do_recursion: dirlist == NULL && filelist == NULL 12:19:07: S -> do_recursion: dodoneproc=1 12:19:07: S -> * If filelist or dirlist is already set, we don't look again. Otherwise, 12:19:07: S -> * find the files and directories 12:19:07: S -> * both lists were NULL, so start from scratch 12:19:07: S -> * In the !(which & W_LOCAL) case, we filled in repository 12:19:07: S -> earlier in the function. In the (which & W_LOCAL) case, 12:19:07: S -> the Find_Names function is going to look through the 12:19:07: S -> Entries file. If we do not have a repository, that 12:19:07: S -> does not make sense, so we insist upon having a 12:19:07: S -> repository at this point. Name_Repository will give a 12:19:07: S -> reasonable error message. 12:19:07: S -> do_recursion: repository != NULL 12:19:07: S -> do_recursion: mapped_repository != NULL 12:19:07: S -> do_recursion: find the files and fill in entries if appropriate 12:19:07: S -> do_recursion: process_this_directory, call Find_Names() 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(testcvs/unfiltered) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered,5) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right((null),(null)) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 12:19:07: S -> lookup_module2() return ret=0 renamed=0 12:19:07: S -> find_virtual_rcs(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(testcvs/unfiltered) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered,6) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right(,testcvs/unfiltered) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 12:19:07: S -> lookup_module2() return ret=0 renamed=0 12:19:07: S -> find_rename_rcs(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> do_recursion: Find_Names got a filelist 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(testcvs/unfiltered) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered,7) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right((null),(null)) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 12:19:07: S -> lookup_module2() return ret=0 renamed=0 12:19:07: S -> find_virtual_dirs(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(testcvs/unfiltered) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered,8) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right(,testcvs/unfiltered) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 12:19:07: S -> lookup_module2() return ret=0 renamed=0 12:19:07: S -> find_rename_dirs(/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> do_recursion: process the files (if any) 12:19:07: S -> do_recursion: read lock it if necessary 12:19:07: S -> * For the server, we handle notifications in a completely different 12:19:07: S -> place (server_notify). For local, we can't do them here--we don't 12:19:07: S -> have writelocks in place, and there is no way to get writelocks here 12:19:07: S -> do_recursion: process the files by calling walklist() 12:19:07: S -> do_file_proc: process the files "a.doc" 12:19:07: S -> (server_active || !current_parsed_root->isremote) 12:19:07: S -> map_filename(/var/cvs/test2/testcvs/unfiltered,a.doc) 12:19:07: S -> map_filename - call map_repository(/var/cvs/test2/testcvs/unfiltered/a.doc) 12:19:07: S -> map_repository(/var/cvs/test2/testcvs/unfiltered/a.doc) 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(testcvs/unfiltered/a.doc) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered/a.doc,9) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right(,testcvs/unfiltered/a.doc) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 12:19:07: S -> lookup_module2() return ret=0 renamed=0 12:19:07: S -> map_repository - return(repository) "/var/cvs/test2/testcvs/unfiltered/a.doc" 12:19:07: S -> map_filename - map_repository() returns /var/cvs/test2/testcvs/unfiltered/a.doc 12:19:07: S -> do_file_proc: mapped name of file "a.doc" 12:19:07: S -> do_file_proc: frfile->frame->dosrcs && mapped_file_repository 12:19:07: S -> RCS_parse(a.doc,/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> rcsbuf_open(/var/cvs/test2/testcvs/unfiltered/a.doc,v) 12:19:07: S -> Lock server command sent: Lock Read Full|/var/cvs/test2/testcvs/unfiltered/a.doc,v 12:19:07: S -> Lock server command received: 000 OK Lock granted (1520) 12:19:07: S -> do_lock_server: [12:19:07] obtained lock 1520 in /test2/testcvs/unfiltered/a.doc,v 12:19:07: S -> do_lock_file: lock server returns 1520 12:19:07: S -> rcsbuf_open(/test2/testcvs/unfiltered/a.doc,v) -- obtained a new lock 12:19:07: S -> rcsbuf_fill(0): expanded to 131072 (was: 0, req: 81920, inc: 81920, RCSBUF_BUFSIZE: 81920). 12:19:07: S -> do_file_proc: call findnode_fn() 12:19:07: S -> do_file_proc: no node? 12:19:07: S -> Version_TS((null),(null),1) 12:19:07: S -> Version_TS - call RCS_getversion("/var/cvs/test2/testcvs/unfiltered/a.doc,v",(null),(null),1,0) 12:19:07: S -> *RCS_head(HEAD) a.doc 12:19:07: S -> do_file_proc: finished fileproc() 12:19:07: S -> Lock server command sent: Unlock 1520 12:19:07: S -> Lock server command received: 000 OK Unlocked 12:19:07: S -> do_unlock_file: (lock 1520) lock server returns 0 12:19:07: S -> do_file_proc: return 12:19:07: S -> do_file_proc: process the files "a.jpg" 12:19:07: S -> (server_active || !current_parsed_root->isremote) 12:19:07: S -> map_filename(/var/cvs/test2/testcvs/unfiltered,a.jpg) 12:19:07: S -> map_filename - call map_repository(/var/cvs/test2/testcvs/unfiltered/a.jpg) 12:19:07: S -> map_repository(/var/cvs/test2/testcvs/unfiltered/a.jpg) 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(testcvs/unfiltered/a.jpg) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered/a.jpg,10) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right(,testcvs/unfiltered/a.jpg) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 12:19:07: S -> lookup_module2() return ret=0 renamed=0 12:19:07: S -> map_repository - return(repository) "/var/cvs/test2/testcvs/unfiltered/a.jpg" 12:19:07: S -> map_filename - map_repository() returns /var/cvs/test2/testcvs/unfiltered/a.jpg 12:19:07: S -> do_file_proc: mapped name of file "a.jpg" 12:19:07: S -> do_file_proc: frfile->frame->dosrcs && mapped_file_repository 12:19:07: S -> RCS_parse(a.jpg,/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> rcsbuf_open(/var/cvs/test2/testcvs/unfiltered/a.jpg,v) 12:19:07: S -> Lock server command sent: Lock Read Full|/var/cvs/test2/testcvs/unfiltered/a.jpg,v 12:19:07: S -> Lock server command received: 000 OK Lock granted (1521) 12:19:07: S -> do_lock_server: [12:19:07] obtained lock 1521 in /test2/testcvs/unfiltered/a.jpg,v 12:19:07: S -> do_lock_file: lock server returns 1521 12:19:07: S -> rcsbuf_open(/test2/testcvs/unfiltered/a.jpg,v) -- obtained a new lock 12:19:07: S -> rcsbuf_fill(0): expanded to 131072 (was: 0, req: 81920, inc: 81920, RCSBUF_BUFSIZE: 81920). 12:19:07: S -> do_file_proc: call findnode_fn() 12:19:07: S -> do_file_proc: no node? 12:19:07: S -> Version_TS((null),(null),1) 12:19:07: S -> Version_TS - call RCS_getversion("/var/cvs/test2/testcvs/unfiltered/a.jpg,v",(null),(null),1,0) 12:19:07: S -> *RCS_head(HEAD) a.jpg 12:19:07: S -> do_file_proc: finished fileproc() 12:19:07: S -> Lock server command sent: Unlock 1521 12:19:07: S -> Lock server command received: 000 OK Unlocked 12:19:07: S -> do_unlock_file: (lock 1521) lock server returns 0 12:19:07: S -> do_file_proc: return 12:19:07: S -> do_file_proc: process the files "a.txt" 12:19:07: S -> (server_active || !current_parsed_root->isremote) 12:19:07: S -> map_filename(/var/cvs/test2/testcvs/unfiltered,a.txt) 12:19:07: S -> map_filename - call map_repository(/var/cvs/test2/testcvs/unfiltered/a.txt) 12:19:07: S -> map_repository(/var/cvs/test2/testcvs/unfiltered/a.txt) 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(testcvs/unfiltered/a.txt) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered/a.txt,11) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right(,testcvs/unfiltered/a.txt) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 12:19:07: S -> lookup_module2() return ret=0 renamed=0 12:19:07: S -> map_repository - return(repository) "/var/cvs/test2/testcvs/unfiltered/a.txt" 12:19:07: S -> map_filename - map_repository() returns /var/cvs/test2/testcvs/unfiltered/a.txt 12:19:07: S -> do_file_proc: mapped name of file "a.txt" 12:19:07: S -> do_file_proc: frfile->frame->dosrcs && mapped_file_repository 12:19:07: S -> RCS_parse(a.txt,/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> rcsbuf_open(/var/cvs/test2/testcvs/unfiltered/a.txt,v) 12:19:07: S -> Lock server command sent: Lock Read Full|/var/cvs/test2/testcvs/unfiltered/a.txt,v 12:19:07: S -> Lock server command received: 000 OK Lock granted (1522) 12:19:07: S -> do_lock_server: [12:19:07] obtained lock 1522 in /test2/testcvs/unfiltered/a.txt,v 12:19:07: S -> do_lock_file: lock server returns 1522 12:19:07: S -> rcsbuf_open(/test2/testcvs/unfiltered/a.txt,v) -- obtained a new lock 12:19:07: S -> rcsbuf_fill(0): expanded to 131072 (was: 0, req: 81920, inc: 81920, RCSBUF_BUFSIZE: 81920). 12:19:07: S -> do_file_proc: call findnode_fn() 12:19:07: S -> do_file_proc: no node? 12:19:07: S -> Version_TS((null),(null),1) 12:19:07: S -> Version_TS - call RCS_getversion("/var/cvs/test2/testcvs/unfiltered/a.txt,v",(null),(null),1,0) 12:19:07: S -> *RCS_head(HEAD) a.txt 12:19:07: S -> do_file_proc: finished fileproc() 12:19:07: S -> Lock server command sent: Unlock 1522 12:19:07: S -> Lock server command received: 000 OK Unlocked 12:19:07: S -> do_unlock_file: (lock 1522) lock server returns 0 12:19:07: S -> do_file_proc: return 12:19:07: S -> do_file_proc: process the files "a.xls" 12:19:07: S -> (server_active || !current_parsed_root->isremote) 12:19:07: S -> map_filename(/var/cvs/test2/testcvs/unfiltered,a.xls) 12:19:07: S -> map_filename - call map_repository(/var/cvs/test2/testcvs/unfiltered/a.xls) 12:19:07: S -> map_repository(/var/cvs/test2/testcvs/unfiltered/a.xls) 12:19:07: S -> lookup_module2() 12:19:07: S -> lookup_module2(testcvs/unfiltered/a.xls) after rename? 12:19:07: S -> lookup_module2() call _lookup_module2() 12:19:07: S -> _lookup_module2 - continue_if_no_mod2=1 (default) 12:19:07: S -> lookup_module2(testcvs/unfiltered/a.xls,12) 12:19:07: S -> _lookup_module2 p!=NULL lookup_repository_module(testcvs) 12:19:07: S -> lookup_repository_module(testcvs) 12:19:07: S -> lookup_module2() calls to lookup_repository_module() returned nothing 12:19:07: S -> _lookup_module2 !mod return 0 left,right(,testcvs/unfiltered/a.xls) 12:19:07: S -> lookup_module2() call _lookup_module2 returned 0 12:19:07: S -> lookup_module2() no recursion permitted so give up now 12:19:07: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL 12:19:07: S -> lookup_module2() return ret=0 renamed=0 12:19:07: S -> map_repository - return(repository) "/var/cvs/test2/testcvs/unfiltered/a.xls" 12:19:07: S -> map_filename - map_repository() returns /var/cvs/test2/testcvs/unfiltered/a.xls 12:19:07: S -> do_file_proc: mapped name of file "a.xls" 12:19:07: S -> do_file_proc: frfile->frame->dosrcs && mapped_file_repository 12:19:07: S -> RCS_parse(a.xls,/var/cvs/test2/testcvs/unfiltered) 12:19:07: S -> rcsbuf_open(/var/cvs/test2/testcvs/unfiltered/a.xls,v) 12:19:07: S -> Lock server command sent: Lock Read Full|/var/cvs/test2/testcvs/unfiltered/a.xls,v 12:19:07: S -> Lock server command received: 000 OK Lock granted (1523) 12:19:07: S -> do_lock_server: [12:19:07] obtained lock 1523 in /test2/testcvs/unfiltered/a.xls,v 12:19:07: S -> do_lock_file: lock server returns 1523 12:19:07: S -> rcsbuf_open(/test2/testcvs/unfiltered/a.xls,v) -- obtained a new lock 12:19:07: S -> rcsbuf_fill(0): expanded to 131072 (was: 0, req: 81920, inc: 81920, RCSBUF_BUFSIZE: 81920). 12:19:07: S -> do_file_proc: call findnode_fn() 12:19:07: S -> do_file_proc: no node? 12:19:07: S -> Version_TS((null),(null),1) 12:19:07: S -> Version_TS - call RCS_getversion("/var/cvs/test2/testcvs/unfiltered/a.xls,v",(null),(null),1,0) 12:19:07: S -> *RCS_head(HEAD) a.xls 12:19:07: S -> do_file_proc: finished fileproc() 12:19:07: S -> Lock server command sent: Unlock 1523 12:19:07: S -> Lock server command received: 000 OK Unlocked 12:19:07: S -> do_unlock_file: (lock 1523) lock server returns 0 12:19:07: S -> do_file_proc: return 12:19:07: S -> do_recursion: unlock it by calling Lock_Cleanup_Directory() 12:19:07: S -> do_recursion: clean up by calling dellist(filelist) 12:19:07: S -> do_recursion: call-back files done proc (if any) 12:19:07: S -> do_recursion: no: don't call-back files done proc (process_this_directorydodoneprocframe->filesdoneproc == NULL) 12:19:07: S -> do_recursion: at skip_directory 12:19:07: S -> (repository && (server_active || !current_parsed_root->isremote)) 12:19:07: S -> fileattr_write() 12:19:07: S -> fileattr_free() 12:19:07: S -> do_recursion: process the directories (if necessary) 12:19:07: S -> do_recursion: really process the directories (if necessary) 12:19:07: S -> do_recursion() -- walklist (dirlist !=NULL, do_dir_proc, (void *) &frent) 12:19:07: S -> do_recursion() -- walklist() returns and now dirlist!=NULL 12:19:07: S -> do_recursion: free the saved copy of the pointer if necessary 12:19:07: S -> debug: 21 12:19:07: S -> debug: 22 12:19:07: S -> do_dir_proc() -- call-back dir leave proc (if any) process_this_directory 12:19:07: S -> debug: 23 12:19:07: S -> close_directory() 12:19:07: S -> close_directory() directory_stack_size decreased by one to 0 12:19:07: S -> do_recursion() -- walklist() returns and now dirlist!=NULL 12:19:07: S -> do_recursion: free the saved copy of the pointer if necessary 12:19:07: S -> start_recursion: Free the data which expand_wild allocated. 12:19:07: S -> start_recursion: Free the data - update_dir 12:19:07: S -> start_recursion: Free the data - update_repos 12:19:07: S -> start_recursion: (args_to_send_when_finished == NULL) 12:19:07: S -> start_recursion: return 0. 12:19:07: S -> run postmodule proc 12:19:07: S -> run_trigger() 12:19:07: S -> Call pre-loaded 'checkout.la' 12:19:07: S -> postmodule_proc(test-filtered) 12:19:07: S -> Call pre-loaded 'checkout.la' returned 0, total ret 0 12:19:07: S -> Call pre-loaded 'info.la' 12:19:07: S -> postmodule_proc(test-filtered) 12:19:07: S -> default_trigger: parse_info(CVSROOT/postmodule,%r/%p %c %o,,test-filtered) 12:19:08: S -> Call pre-loaded 'info.la' returned 0, total ret 0 12:19:08: S -> run_trigger returning 0 12:19:08: S -> do_module clean up. 12:19:08: S -> do_module return errors=0. 12:19:08: S -> Process warnings about client versions out of date... 12:19:08: S -> run postcommand proc server 12:19:08: S -> run_trigger() 12:19:08: S -> Call pre-loaded 'checkout.la' 12:19:08: S -> postcommand_proc() 12:19:08: S -> Call pre-loaded 'checkout.la' returned 0, total ret 0 12:19:08: S -> Call pre-loaded 'info.la' 12:19:08: S -> postcommand_proc() 12:19:08: S -> default_trigger: parse_info(CVSROOT/postcommand,%r/%p %c,,testcvs/unfiltered) 12:19:08: S -> Call pre-loaded 'info.la' returned 0, total ret 0 12:19:08: S -> run_trigger returning 0 12:19:08: S -> Unloading checkout.la 12:19:08: S -> Unloading - about to close 12:19:08: S -> Unloading - closed 12:19:08: S -> Unloading - about to destroy 12:19:08: S -> Unloading - destroyed 12:19:08: S -> Unloading - about to get lib 12:19:08: S -> Unloading - about to unload 12:19:08: S -> Unloading - unloaded 12:19:08: S -> Unloading - about to free 12:19:08: S -> Unloading - about to delete trigg 12:19:08: S -> Unloading - about to delete inf 12:19:08: S -> Unloading - complete 12:19:08: S -> Unloading email.la 12:19:08: S -> Unloading - about to destroy 12:19:08: S -> Unloading - destroyed 12:19:08: S -> Unloading - about to get lib 12:19:08: S -> Unloading - about to unload 12:19:08: S -> Unloading - unloaded 12:19:08: S -> Unloading - about to free 12:19:08: S -> Unloading - about to delete trigg 12:19:08: S -> Unloading - about to delete inf 12:19:08: S -> Unloading - complete 12:19:08: S -> Unloading info.la 12:19:08: S -> Unloading - about to close 12:19:08: S -> Unloading - closed 12:19:08: S -> Unloading - about to destroy 12:19:08: S -> Unloading - destroyed 12:19:08: S -> Unloading - about to get lib 12:19:08: S -> Unloading - about to unload 12:19:08: S -> Unloading - unloaded 12:19:08: S -> Unloading - about to free 12:19:08: S -> Unloading - about to delete trigg 12:19:08: S -> Unloading - about to delete inf 12:19:08: S -> Unloading - complete 12:19:08: S -> Unloading make.la 12:19:08: S -> Unloading - about to destroy 12:19:08: S -> Unloading - destroyed 12:19:08: S -> Unloading - about to get lib 12:19:08: S -> Unloading - about to unload 12:19:08: S -> Unloading - unloaded 12:19:08: S -> Unloading - about to free 12:19:08: S -> Unloading - about to delete trigg 12:19:08: S -> Unloading - about to delete inf 12:19:08: S -> Unloading - complete 12:19:08: S -> Unloading - about to clear list 12:19:08: S -> Unloading - cleared list 12:19:04: -> Server: return from the requested function 12:19:04: -> Unloading - about to clear list 12:19:04: -> Unloading - cleared list 12:19:04: -> Unloading pserver 12:19:04: -> Process 3696 exiting 12:19:04: -> free_directory() 12:19:04: -> free_modules2() directory_stack_size and rubbish set to zero 12:19:04: -> Free CVS_Username and cvs_locale 12:19:04: -> Perform SYSTEM_CLEANUP () 12:19:04: -> Free global_session_time and global_real_session_time 12:19:04: -> CCvsgui::Close 12:19:04: -> main return OK 12:19:04: -> Set the terminate semaphore 12:19:04: -> Free trace_file