$ cvs -ttt -d :pserver:localhost:/as400 rls
17:29:26:   -> Tracelevel set to 3.  PID is 6877
17:29:26:   -> Session ID is 1add4a35f8567329
17:29:26:   -> Session time is Mon Jun 15 07:29:26 2009
17:29:26:   -> Client locale is C C C C C C
17:29:26:   -> Client was compiled Jun 15 2009 02:19:33
17:29:26:   -> Client was compiled with HP aCC C/C++ 36700
17:29:26:   -> Client build platform is hp-hpux11.11-hppa2.0w
17:29:26:   -> Loading protocol pserver as pserver.la
17:29:26:   -> main loop with CVSROOT=:pserver:localhost:/as400
17:29:26:   -> main - about to start the server
17:29:26:   -> start_server(0)
17:29:26:   -> client start - client_protocol->connect
17:29:26:   -> Buffer size is 10240
17:29:26:   -> Config file name /home/abarrett/.cvs/cvspass
17:29:26:   -> client start - Loop, getting responses from the server.
17:29:26:   -> client start - got "I LOVE YOU"
17:29:26:   -> client start - continue login.
17:29:26:   -> client start - server started.
17:29:26:   -> client start - send Valid-responses to server.
17:29:26:   -> client start - send valid-requests to server.
17:29:26:   -> client start - rootless_encryption.
17:29:27:   -> Server codepage is ROMAN8
17:29:27:   -> Client codepage is roman8
17:29:27:   -> Server->Client codepage translation is active
17:29:27:   -> TranscodeBuffer(ROMAN8,roman8) failed
17:29:27:   -> Translation not posible - disabling
17:29:27:   -> Server version is CVSNT 2.5.03 (Scorpio) Build 3428
17:29:27:   -> Client version is CVSNT 2.5.03 (Scorpio) Build 3428
17:29:27:   -> Requesting server cvsignore
17:29:27:   -> wrap_add(*.a -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.a"
17:29:27:   -> wrap_add(*.avi -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.avi"
17:29:27:   -> wrap_add(*.bin -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.bin"
17:29:27:   -> wrap_add(*.bmp -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.bmp"
17:29:27:   -> wrap_add(*.bz2 -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.bz2"
17:29:27:   -> wrap_add(*.chm -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.chm"
17:29:27:   -> wrap_add(*.class -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.class"
17:29:27:   -> wrap_add(*.cur -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.cur"
17:29:27:   -> wrap_add(*.dll -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.dll"
17:29:27:   -> wrap_add(*.doc -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.doc"
17:29:27:   -> wrap_add(*.mpp -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.mpp"
17:29:27:   -> wrap_add(*.dvi -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.dvi"
17:29:27:   -> wrap_add(*.exe -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.exe"
17:29:27:   -> wrap_add(*.gif -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.gif"
17:29:27:   -> wrap_add(*.gz -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.gz"
17:29:27:   -> wrap_add(*.hqx -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.hqx"
17:29:27:   -> wrap_add(*.ico -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.ico"
17:29:27:   -> wrap_add(*.ilk -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.ilk"
17:29:27:   -> wrap_add(*.iso -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.iso"
17:29:27:   -> wrap_add(*.lib -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.lib"
17:29:27:   -> wrap_add(*.jar -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.jar"
17:29:27:   -> wrap_add(*.jpg -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.jpg"
17:29:27:   -> wrap_add(*.jpeg -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.jpeg"
17:29:27:   -> wrap_add(*.lnk -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.lnk"
17:29:27:   -> wrap_add(*.mpg -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.mpg"
17:29:27:   -> wrap_add(*.mpeg -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.mpeg"
17:29:27:   -> wrap_add(*.mov -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.mov"
17:29:27:   -> wrap_add(*.mp3 -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.mp3"
17:29:27:   -> wrap_add(*.ncb -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.ncb"
17:29:27:   -> wrap_add(*.o -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.o"
17:29:27:   -> wrap_add(*.ogg -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.ogg"
17:29:27:   -> wrap_add(*.obj -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.obj"
17:29:27:   -> wrap_add(*.pdb -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.pdb"
17:29:27:   -> wrap_add(*.pdf -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.pdf"
17:29:27:   -> wrap_add(*.png -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.png"
17:29:27:   -> wrap_add(*.ppt -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.ppt"
17:29:27:   -> wrap_add(*.res -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.res"
17:29:27:   -> wrap_add(*.rpm -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.rpm"
17:29:27:   -> wrap_add(*.sit -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.sit"
17:29:27:   -> wrap_add(*.so -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.so"
17:29:27:   -> wrap_add(*.tar -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.tar"
17:29:27:   -> wrap_add(*.tga -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.tga"
17:29:27:   -> wrap_add(*.tgz -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.tgz"
17:29:27:   -> wrap_add(*.tif -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.tif"
17:29:27:   -> wrap_add(*.tiff -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.tiff"
17:29:27:   -> wrap_add(*.ttf -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.ttf"
17:29:27:   -> wrap_add(*.wav -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.wav"
17:29:27:   -> wrap_add(*.wmv -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.wmv"
17:29:27:   -> wrap_add(*.xls -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.xls"
17:29:27:   -> wrap_add(*.zip -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.zip"
17:29:27:   -> wrap_add(*.Z -kb, 0, 0, 0, 0)
17:29:27:   -> Call CFileAccess::mimetype: "*.Z"
17:29:27:   -> Requesting server cvswrappers
17:29:27:   -> The first item in the sorted list is "b" with wildcard "*.mov"
17:29:27:   -> Requesting server cvsrc (read-cvsrc2)
17:29:27:   -> Parsing global cvsrc started
17:29:27:   -> Parsing global cvsrc finished 0 lines.
17:29:27:   -> No local /home/abarrett/.cvsrc to parse
17:29:27: S -> server_main started
17:29:27: S -> run plugintools proc server
17:29:27: S -> run_trigger()
17:29:27: S -> Checking admin file /var/tstrepos/as400/CVSROOT/admin for user abarrett
17:29:27: S -> Checking started in admin file /var/tstrepos/as400/CVSROOT/admin for user abarrett
17:29:27: S -> Checked admin file  for user abarrett they are not an admin.
17:29:27: S -> LoadTrigger(info.la)
17:29:27: S -> LoadTrigger(audit.la)
17:29:27: S -> Not loading disabled trigger audit.la.
17:29:27: S -> Couldn't load trigger audit.la
17:29:27: S -> LoadTrigger(bug.la)
17:29:27: S -> looking for new revision in bug trigger
17:29:27: S -> Connecting to MySql
17:29:27: S -> Defect Tracking trigger is enabled.

17:29:27: S -> LoadTrigger(checkout.la)
17:29:27: S -> Checkout trigger not enabled.
17:29:27: S -> Couldn't load trigger checkout.la
17:29:27: S -> LoadTrigger(email.la)
17:29:27: S -> Email trigger not enabled.
17:29:27: S -> Couldn't load trigger email.la
17:29:27: S -> LoadTrigger(make.la)
17:29:27: S -> looking for new revision in bug trigger
17:29:27: S -> Connecting to MySql
17:29:27: S -> Defect Tracking trigger is enabled.

17:29:27: S -> Call pre-loaded 'bug.la'
17:29:27: S -> plugintools_proc()
17:29:27: S -> Call pre-loaded 'bug.la' returned 0, total ret 0
17:29:27: S -> Call pre-loaded 'info.la'
17:29:27: S -> plugintools_proc()
17:29:27: S -> Call pre-loaded 'info.la' returned 0, total ret 0
17:29:27: S -> Call pre-loaded 'make.la'
17:29:27: S -> plugintools_proc()
17:29:27: S -> Call pre-loaded 'make.la' returned 0, total ret 0
17:29:27: S -> run_trigger returning 0
17:29:27: S -> run precommand proc server
17:29:27: S -> run_trigger()
17:29:27: S -> Call pre-loaded 'bug.la'
17:29:27: S -> precommand_proc()
17:29:27: S -> Call pre-loaded 'bug.la' returned 0, total ret 0
17:29:27: S -> Call pre-loaded 'info.la'
17:29:27: S -> precommand_proc()
17:29:27: S -> default_trigger: parse_info(CVSROOT/precommand,%r %c,%<a,<null>)
17:29:27: S -> Call pre-loaded 'info.la' returned 0, total ret 0
17:29:27: S -> Call pre-loaded 'make.la'
17:29:27: S -> precommand_proc()
17:29:27: S -> Call pre-loaded 'make.la' returned 0, total ret 0
17:29:27: S -> run_trigger returning 0
17:29:27: S -> open_module(/var/tstrepos/as400)
17:29:27: S -> do_module(., Listing, , )
17:29:27: S -> do_module calls map_repository()
17:29:27: S -> map_repository(/var/tstrepos/as400)
17:29:27: S -> do_module call to map_repository() has returned something
17:29:27: S -> * check to see if mname is a directory or file 
17:29:27: S -> do_module calls isdir(/var/tstrepos/as400)
17:29:27: S -> do_module yes it is a directory ...
17:29:27: S -> * OK, we have now set up modargv with the actual file/directory we want to work on.
17:29:27: S -> run premodule trigger
17:29:27: S -> run_trigger()
17:29:27: S -> Call pre-loaded 'bug.la'
17:29:27: S -> premodule_proc(.)
17:29:27: S -> Call pre-loaded 'bug.la' returned 0, total ret 0
17:29:27: S -> Call pre-loaded 'info.la'
17:29:27: S -> premodule_proc(.)
17:29:27: S -> default_trigger: parse_info(CVSROOT/premodule,%r/%p %c %o,,.)
17:29:27: S -> Call pre-loaded 'info.la' returned 0, total ret 0
17:29:27: S -> Call pre-loaded 'make.la'
17:29:27: S -> premodule_proc(.)
17:29:27: S -> Call pre-loaded 'make.la' returned 0, total ret 0
17:29:27: S -> run_trigger returning 0
17:29:27: S -> do_modue(1): call the callback_proc()
Listing modules on server

17:29:27: S -> map_repository(/var/tstrepos/as400)
17:29:27: S -> start_recursion(.,)
17:29:27: S -> start_recursion() dirleaveproc is NULL
17:29:27: S -> start_recursion() update_dir set to "."
17:29:27: S -> start_recursion - argument count (argc) == 0
17:29:27: S -> * There were no arguments, so we'll probably just recurse. The
17:29:27: S -> * exception to the rule is when we are called from a directory
17:29:27: S -> * without any CVS administration files.  That has always meant to
17:29:27: S -> * process each of the sub-directories, so we pretend like we were
17:29:27: S -> * called with the list of sub-dirs of the current dir as args
17:29:27: S -> start_recursion: !just_subdirs - call addlist(dirlist==NULL, ".")
17:29:27: S -> start_recursion: addlist() returns and now dirlist!=NULL 
17:29:27: S -> start_recursion/do_the_work: do_recursion() on the frame (dirlist != NULL).
17:29:27: S -> do_recursion: begin
17:29:27: S -> do_recursion: Check the value in CVSADM_ROOT 
17:29:27: S -> do_recursion: Fill in repository with the current repository
17:29:27: S -> (repository && (server_active || !current_parsed_root->isremote))
17:29:27: S -> map_repository(/var/tstrepos/as400)
17:29:27: S -> Repository = /var/tstrepos/as400/.
17:29:27: S -> Mapped repository = /var/tstrepos/as400
17:29:27: S -> (repository && (server_active || !current_parsed_root->isremote))
17:29:27: S -> ParseTag()
17:29:27: S -> ParseTag_Dir(,<something>,,0,)
17:29:27: S -> verify_access /var/tstrepos/as400,.,
17:29:27: S -> verify_perm(/var/tstrepos/as400,,read,,)
17:29:27: S -> verify_owner(/var/tstrepos/as400)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> Open the admin group file CVSROOT/group
17:29:27: S -> Finished reading the admin group file CVSROOT/group
17:29:27: S -> add_valid_group(users)
17:29:27: S -> add_valid_group(cvsusers)
17:29:27: S -> add_valid_group(tstusers)
17:29:27: S -> add_valid_group(cvsaudit)
17:29:27: S -> add_valid_group(apache)
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400)
17:29:27: S -> fileattr_read(/var/tstrepos/as400)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400)
17:29:27: S -> ACL lookup on directory /var/tstrepos/as400
17:29:27: S -> verify_acl(read,HEAD,)
17:29:27: S -> user_state = 0, group_state = 0
17:29:27: S -> no match at this level
17:29:27: S -> Match found.
17:29:27: S -> fileattr_startdir(/var/tstrepos/as400)
17:29:27: S -> * The filesdoneproc needs to be called for each directory where files
17:29:27: S -> * processed, or each directory that is processed by a call where no
17:29:27: S -> * directories were passed in.  In fact, the only time we don't want to
17:29:27: S -> * call back the filesdoneproc is when we are processing directories that
17:29:27: S -> * were passed in on the command line (or in the special case of `.' when
17:29:27: S -> * we were called with no args
17:29:27: S -> do_recursion: dirlist != NULL && filelist == NULL
17:29:27: S -> do_recursion: dodoneproc=0
17:29:27: S -> * If filelist or dirlist is already set, we don't look again. Otherwise,
17:29:27: S -> * find the files and directories
17:29:27: S -> do_recursion: something was passed on the command line 
17:29:27: S -> do_recursion: process the files (if any) 
17:29:27: S -> do_recursion: call-back files done proc (if any) 
17:29:27: S -> do_recursion: no: don't call-back files done proc (process_this_directory!dodoneprocframe->filesdoneproc == NULL) 
17:29:27: S -> do_recursion: at skip_directory 
17:29:27: S -> (repository && (server_active || !current_parsed_root->isremote))
17:29:27: S -> fileattr_write()
17:29:27: S -> fileattr_free()
17:29:27: S -> do_recursion: process the directories (if necessary) 
17:29:27: S -> do_recursion: really process the directories (if necessary) 
17:29:27: S -> do_recursion() -- walklist (dirlist !=NULL, do_dir_proc, (void *) &frent)
17:29:27: S -> do_dir_proc()
17:29:27: S -> do_dir_proc() update_dir=.
17:29:27: S -> do_dir_proc() -- set up update_dir(.) - no dots ? 
17:29:27: S -> do_dir_proc() -- set up update_dir is now dirp "." - no dots ? 
17:29:27: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote
17:29:27: S -> ParseTag_Dir(/var/tstrepos/as400,<something>,<something>,0,)
17:29:27: S -> do_dir_proc() -- verify_access 
17:29:27: S -> verify_access /var/tstrepos/as400,.,
17:29:27: S -> verify_perm(/var/tstrepos/as400,,read,,)
17:29:27: S -> verify_owner(/var/tstrepos/as400)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400)
17:29:27: S -> ACL lookup on directory /var/tstrepos/as400
17:29:27: S -> verify_acl(read,HEAD,)
17:29:27: S -> user_state = 0, group_state = 0
17:29:27: S -> no match at this level
17:29:27: S -> Match found.
17:29:27: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL
17:29:27: S -> do_dir_proc() -- process_this_directory
17:29:27: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory
17:29:27: S -> do_dir_proc() after predirent call ParseTag_Dir() 
17:29:27: S -> ParseTag_Dir(.,<something>,<something>,0,<something>)
17:29:27: S -> open_directory(/var/tstrepos/as400,.,,,0,,0)
17:29:27: S -> open_directory() directory_stack_size increased by one to 1
17:29:27: S -> open_directory, (!remote) try and find a mapping file in this directory .
17:29:27: S -> RCS_parse(.directory_history,/var/tstrepos/as400)
17:29:27: S -> rcsbuf_open(/var/tstrepos/as400/.directory_history,v)
17:29:27: S -> rcsbuf_open failed
17:29:27: S -> rcsbuf_open(/var/tstrepos/as400/Attic/.directory_history,v)
17:29:27: S -> rcsbuf_open failed
17:29:27: S -> No mapping file in this directory.
17:29:27: S -> open_directory copy the tag and date.
17:29:27: S -> open_directory copied the tag and date.
17:29:27: S -> Look for rename script file CVS/Rename
17:29:27: S -> Rename script file does not exist
17:29:27: S -> directory opened
17:29:27: S -> fileattr_startdir(/var/tstrepos/as400)
17:29:27: S -> do_dir_proc() -- call-back dir entry proc (if any)
17:29:27: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc.
17:29:27: S -> do_dir_proc() -- only process the dir if the return code was 0.
17:29:27: S -> do_dir_proc() -- !(frame->which&(W_LOCAL|W_FAKE))
17:29:27: S -> debug: 18
17:29:27: S -> debug: 19
17:29:27: S -> debug: 20
17:29:27: S -> do_recursion: begin
17:29:27: S -> do_recursion: Check the value in CVSADM_ROOT 
17:29:27: S -> do_recursion: Fill in repository with the current repository
17:29:27: S -> (repository && (server_active || !current_parsed_root->isremote))
17:29:27: S -> map_repository(/var/tstrepos/as400)
17:29:27: S -> lookup_module2()
17:29:27: S -> lookup_module2() after rename?
17:29:27: S -> lookup_module2() call _lookup_module2()
17:29:27: S -> Loading modules2 from /var/tstrepos/as400/CVSROOT/modules2
17:29:27: S -> _lookup_module2 - continue_if_no_mod2=1 (default)
17:29:27: S -> lookup_module2(,1)
17:29:27: S -> lookup_module2() call _lookup_module2 returned 0
17:29:27: S -> lookup_module2() no recursion permitted so give up now
17:29:27: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL
17:29:27: S -> lookup_module2() return ret=0 renamed=0
17:29:27: S -> map_repository - return(repository) "/var/tstrepos/as400"
17:29:27: S -> Repository = /var/tstrepos/as400
17:29:27: S -> Mapped repository = /var/tstrepos/as400
17:29:27: S -> * The filesdoneproc needs to be called for each directory where files
17:29:27: S -> * processed, or each directory that is processed by a call where no
17:29:27: S -> * directories were passed in.  In fact, the only time we don't want to
17:29:27: S -> * call back the filesdoneproc is when we are processing directories that
17:29:27: S -> * were passed in on the command line (or in the special case of `.' when
17:29:27: S -> * we were called with no args
17:29:27: S -> do_recursion: dirlist == NULL && filelist == NULL
17:29:27: S -> do_recursion: dodoneproc=1
17:29:27: S -> * If filelist or dirlist is already set, we don't look again. Otherwise,
17:29:27: S -> * find the files and directories
17:29:27: S -> * both lists were NULL, so start from scratch 
17:29:27: S -> * In the !(which & W_LOCAL) case, we filled in repository
17:29:27: S ->   earlier in the function.  In the (which & W_LOCAL) case,
17:29:27: S ->   the Find_Names function is going to look through the
17:29:27: S ->   Entries file.  If we do not have a repository, that
17:29:27: S ->   does not make sense, so we insist upon having a
17:29:27: S ->   repository at this point.  Name_Repository will give a
17:29:27: S ->   reasonable error message. 
17:29:27: S -> do_recursion: repository != NULL
17:29:27: S -> do_recursion: mapped_repository != NULL
17:29:27: S -> do_recursion: find the files and fill in entries if appropriate
17:29:27: S -> do_recursion: process_this_directory, call Find_Names()
17:29:27: S -> lookup_module2()
17:29:27: S -> lookup_module2() after rename?
17:29:27: S -> lookup_module2() call _lookup_module2()
17:29:27: S -> _lookup_module2 - continue_if_no_mod2=1 (default)
17:29:27: S -> lookup_module2(,2)
17:29:27: S -> lookup_module2() call _lookup_module2 returned 0
17:29:27: S -> lookup_module2() no recursion permitted so give up now
17:29:27: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL
17:29:27: S -> lookup_module2() return ret=0 renamed=0
17:29:27: S -> find_virtual_rcs(/var/tstrepos/as400)
17:29:27: S -> lookup_module2()
17:29:27: S -> lookup_module2() after rename?
17:29:27: S -> lookup_module2() call _lookup_module2()
17:29:27: S -> _lookup_module2 - continue_if_no_mod2=1 (default)
17:29:27: S -> lookup_module2(,3)
17:29:27: S -> lookup_module2() call _lookup_module2 returned 0
17:29:27: S -> lookup_module2() no recursion permitted so give up now
17:29:27: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL
17:29:27: S -> lookup_module2() return ret=0 renamed=0
17:29:27: S -> find_rename_rcs(/var/tstrepos/as400)
17:29:27: S -> do_recursion: Find_Names got a filelist
17:29:27: S -> lookup_module2()
17:29:27: S -> lookup_module2() after rename?
17:29:27: S -> lookup_module2() call _lookup_module2()
17:29:27: S -> _lookup_module2 - continue_if_no_mod2=1 (default)
17:29:27: S -> lookup_module2(,4)
17:29:27: S -> lookup_module2() call _lookup_module2 returned 0
17:29:27: S -> lookup_module2() no recursion permitted so give up now
17:29:27: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL
17:29:27: S -> lookup_module2() return ret=0 renamed=0
17:29:27: S -> find_virtual_dirs(/var/tstrepos/as400)
17:29:27: S -> find_rename_dirs(/var/tstrepos/as400)
17:29:27: S -> do_recursion: process the files (if any) 
17:29:27: S -> do_recursion: read lock it if necessary 
17:29:27: S -> * For the server, we handle notifications in a completely different
17:29:27: S ->   place (server_notify).  For local, we can't do them here--we don't
17:29:27: S ->   have writelocks in place, and there is no way to get writelocks here
17:29:27: S -> do_recursion: process the files by calling walklist()
17:29:27: S -> do_recursion: unlock it by calling Lock_Cleanup_Directory()
17:29:27: S -> do_recursion: clean up by calling dellist(filelist)
17:29:27: S -> do_recursion: call-back files done proc (if any) 
17:29:27: S -> do_recursion: no: don't call-back files done proc (process_this_directorydodoneprocframe->filesdoneproc == NULL) 
17:29:27: S -> do_recursion: at skip_directory 
17:29:27: S -> (repository && (server_active || !current_parsed_root->isremote))
17:29:27: S -> fileattr_write()
17:29:27: S -> fileattr_free()
17:29:27: S -> do_recursion: process the directories (if necessary) 
17:29:27: S -> do_recursion: really process the directories (if necessary) 
17:29:27: S -> do_recursion() -- walklist (dirlist !=NULL, do_dir_proc, (void *) &frent)
17:29:27: S -> do_dir_proc()
17:29:27: S -> do_dir_proc() update_dir=
17:29:27: S -> do_dir_proc() -- set up update_dir - skip dots if not at start 
17:29:27: S -> do_dir_proc() -- update_dir is dot? - set to dirp instead
17:29:27: S -> do_dir_proc() after all that now update_dir=CVSROOT
17:29:27: S -> (server_active || !current_parsed_root->isremote) 2
17:29:27: S -> map_repository(/var/tstrepos/as400/CVSROOT)
17:29:27: S -> lookup_module2()
17:29:27: S -> lookup_module2(CVSROOT) after rename?
17:29:27: S -> lookup_module2() call _lookup_module2()
17:29:27: S -> _lookup_module2 - continue_if_no_mod2=1 (default)
17:29:27: S -> lookup_module2(CVSROOT,5)
17:29:27: S -> _lookup_module2 !p lookup_repository_module(CVSROOT)
17:29:27: S -> lookup_repository_module(CVSROOT)
17:29:27: S -> lookup_module2() calls to lookup_repository_module() returned nothing
17:29:27: S -> _lookup_module2 !mod return 0 left,right(,CVSROOT)
17:29:27: S -> lookup_module2() call _lookup_module2 returned 0
17:29:27: S -> lookup_module2() no recursion permitted so give up now
17:29:27: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL
17:29:27: S -> lookup_module2() return ret=0 renamed=0
17:29:27: S -> map_repository - return(repository) "/var/tstrepos/as400/CVSROOT"
17:29:27: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote
17:29:27: S -> ParseTag_Dir(/var/tstrepos/as400/CVSROOT,<something>,<something>,0,)
17:29:27: S -> do_dir_proc() -- verify_access 
17:29:27: S -> verify_access /var/tstrepos/as400/CVSROOT,CVSROOT,
17:29:27: S -> verify_perm(/var/tstrepos/as400/CVSROOT,,read,,)
17:29:27: S -> verify_owner(/var/tstrepos/as400/CVSROOT)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400/CVSROOT)
17:29:27: S -> fileattr_read(/var/tstrepos/as400/CVSROOT)
17:29:27: S -> verify_valid_name(root)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400/CVSROOT)
17:29:27: S -> ACL lookup on directory /var/tstrepos/as400/CVSROOT
17:29:27: S -> verify_acl(read,HEAD,)
17:29:27: S -> verify_valid_name(admin)
17:29:27: S -> verify_valid_name(root)
17:29:27: S -> matched ACL user=, branch=_default_, merge=(no acl_merge)
17:29:27: S -> calculated ACL priority is 0
17:29:27: S -> new max priority is 0
17:29:27: S -> matched ACL user=, branch=_default_, merge=(no acl_merge)
17:29:27: S -> calculated ACL priority is 0
17:29:27: S -> user_state = 0, group_state = -1
17:29:27: S -> Match found.
17:29:27: S -> do_dir_proc() -- process_this_directory
17:29:27: S -> do_dir_proc() -- dir_return == R_SKIP_ALL || dir_return == R_ERROR
17:29:27: S -> do_dir_proc() -- call-back dir entry proc (if any)
17:29:27: S -> do_dir_proc() -- dir_return == R_SKIP_ALL || dir_return == R_ERROR
17:29:27: S -> do_dir_proc() -- cannot process the dir because the return code was R_SKIP_ALL.
17:29:27: S -> fileattr_write()
17:29:27: S -> fileattr_free()
17:29:27: S -> do_dir_proc()
17:29:27: S -> do_dir_proc() update_dir=
17:29:27: S -> do_dir_proc() -- set up update_dir - skip dots if not at start 
17:29:27: S -> do_dir_proc() -- update_dir is dot? - set to dirp instead
17:29:27: S -> do_dir_proc() after all that now update_dir=CVSTestApp4
17:29:27: S -> (server_active || !current_parsed_root->isremote) 2
17:29:27: S -> map_repository(/var/tstrepos/as400/CVSTestApp4)
17:29:27: S -> lookup_module2()
17:29:27: S -> lookup_module2(CVSTestApp4) after rename?
17:29:27: S -> lookup_module2() call _lookup_module2()
17:29:27: S -> _lookup_module2 - continue_if_no_mod2=1 (default)
17:29:27: S -> lookup_module2(CVSTestApp4,6)
17:29:27: S -> _lookup_module2 !p lookup_repository_module(CVSTestApp4)
17:29:27: S -> lookup_repository_module(CVSTestApp4)
17:29:27: S -> lookup_module2() calls to lookup_repository_module() returned nothing
17:29:27: S -> _lookup_module2 !mod return 0 left,right(,CVSTestApp4)
17:29:27: S -> lookup_module2() call _lookup_module2 returned 0
17:29:27: S -> lookup_module2() no recursion permitted so give up now
17:29:27: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL
17:29:27: S -> lookup_module2() return ret=0 renamed=0
17:29:27: S -> map_repository - return(repository) "/var/tstrepos/as400/CVSTestApp4"
17:29:27: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote
17:29:27: S -> ParseTag_Dir(/var/tstrepos/as400/CVSTestApp4,<something>,<something>,0,)
17:29:27: S -> do_dir_proc() -- verify_access 
17:29:27: S -> verify_access /var/tstrepos/as400/CVSTestApp4,CVSTestApp4,
17:29:27: S -> verify_perm(/var/tstrepos/as400/CVSTestApp4,,read,,)
17:29:27: S -> verify_owner(/var/tstrepos/as400/CVSTestApp4)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400/CVSTestApp4)
17:29:27: S -> fileattr_read(/var/tstrepos/as400/CVSTestApp4)
17:29:27: S -> verify_valid_name(tst101)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400/CVSTestApp4)
17:29:27: S -> ACL lookup on directory /var/tstrepos/as400/CVSTestApp4
17:29:27: S -> verify_acl(read,HEAD,)
17:29:27: S -> user_state = 0, group_state = 0
17:29:27: S -> no match at this level
17:29:27: S -> ACL lookup on directory /var/tstrepos/as400
17:29:27: S -> verify_acl(read,HEAD,)
17:29:27: S -> user_state = 0, group_state = 0
17:29:27: S -> no match at this level
17:29:27: S -> Match found.
17:29:27: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL
17:29:27: S -> do_dir_proc() -- process_this_directory
17:29:27: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory
17:29:27: S -> do_dir_proc() after predirent call ParseTag_Dir() 
17:29:27: S -> ParseTag_Dir(CVSTestApp4,<something>,<something>,0,<something>)
17:29:27: S -> open_directory(/var/tstrepos/as400/CVSTestApp4,CVSTestApp4,,,0,,0)
17:29:27: S -> current_directory is already set
17:29:27: S -> open_directory() directory_stack_size increased by one to 2
17:29:27: S -> open_directory, (!remote) try and find a mapping file in this directory .
17:29:27: S -> RCS_parse(.directory_history,/var/tstrepos/as400/CVSTestApp4)
17:29:27: S -> rcsbuf_open(/var/tstrepos/as400/CVSTestApp4/.directory_history,v)
17:29:27: S -> rcsbuf_open failed
17:29:27: S -> rcsbuf_open(/var/tstrepos/as400/CVSTestApp4/Attic/.directory_history,v)
17:29:27: S -> rcsbuf_open failed
17:29:27: S -> No mapping file in this directory.
17:29:27: S -> open_directory copy the tag and date.
17:29:27: S -> open_directory copied the tag and date.
17:29:27: S -> Look for rename script file CVS/Rename
17:29:27: S -> Rename script file does not exist
17:29:27: S -> directory opened
17:29:27: S -> fileattr_startdir(/var/tstrepos/as400/CVSTestApp4)
17:29:27: S -> do_dir_proc() -- call-back dir entry proc (if any)
17:29:27: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc.
CVSTestApp4
17:29:27: S -> do_dir_proc() -- cannot process the dir because the return code was R_SKIP_ALL.
17:29:27: S -> more efficient - close directory in do_dir_proc
17:29:27: S -> close_directory()
17:29:27: S -> close_directory() directory_stack_size decreased by one to 1 
17:29:27: S -> fileattr_write()
17:29:27: S -> fileattr_free()
17:29:27: S -> do_dir_proc()
17:29:27: S -> do_dir_proc() update_dir=
17:29:27: S -> do_dir_proc() -- set up update_dir - skip dots if not at start 
17:29:27: S -> do_dir_proc() -- update_dir is dot? - set to dirp instead
17:29:27: S -> do_dir_proc() after all that now update_dir=WindowsApplication1
17:29:27: S -> (server_active || !current_parsed_root->isremote) 2
17:29:27: S -> map_repository(/var/tstrepos/as400/WindowsApplication1)
17:29:27: S -> lookup_module2()
17:29:27: S -> lookup_module2(WindowsApplication1) after rename?
17:29:27: S -> lookup_module2() call _lookup_module2()
17:29:27: S -> _lookup_module2 - continue_if_no_mod2=1 (default)
17:29:27: S -> lookup_module2(WindowsApplication1,7)
17:29:27: S -> _lookup_module2 !p lookup_repository_module(WindowsApplication1)
17:29:27: S -> lookup_repository_module(WindowsApplication1)
17:29:27: S -> lookup_module2() calls to lookup_repository_module() returned nothing
17:29:27: S -> _lookup_module2 !mod return 0 left,right(,WindowsApplication1)
17:29:27: S -> lookup_module2() call _lookup_module2 returned 0
17:29:27: S -> lookup_module2() no recursion permitted so give up now
17:29:27: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL
17:29:27: S -> lookup_module2() return ret=0 renamed=0
17:29:27: S -> map_repository - return(repository) "/var/tstrepos/as400/WindowsApplication1"
17:29:27: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote
17:29:27: S -> ParseTag_Dir(/var/tstrepos/as400/WindowsApplication1,<something>,<something>,0,)
17:29:27: S -> do_dir_proc() -- verify_access 
17:29:27: S -> verify_access /var/tstrepos/as400/WindowsApplication1,WindowsApplication1,
17:29:27: S -> verify_perm(/var/tstrepos/as400/WindowsApplication1,,read,,)
17:29:27: S -> verify_owner(/var/tstrepos/as400/WindowsApplication1)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400/WindowsApplication1)
17:29:27: S -> fileattr_read(/var/tstrepos/as400/WindowsApplication1)
17:29:27: S -> verify_valid_name(abarrett)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400/WindowsApplication1)
17:29:27: S -> ACL lookup on directory /var/tstrepos/as400/WindowsApplication1
17:29:27: S -> verify_acl(read,HEAD,)
17:29:27: S -> user_state = 0, group_state = 0
17:29:27: S -> no match at this level
17:29:27: S -> ACL lookup on directory /var/tstrepos/as400
17:29:27: S -> verify_acl(read,HEAD,)
17:29:27: S -> user_state = 0, group_state = 0
17:29:27: S -> no match at this level
17:29:27: S -> Match found.
17:29:27: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL
17:29:27: S -> do_dir_proc() -- process_this_directory
17:29:27: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory
17:29:27: S -> do_dir_proc() after predirent call ParseTag_Dir() 
17:29:27: S -> ParseTag_Dir(WindowsApplication1,<something>,<something>,0,<something>)
17:29:27: S -> open_directory(/var/tstrepos/as400/WindowsApplication1,WindowsApplication1,,,0,,0)
17:29:27: S -> current_directory is already set
17:29:27: S -> open_directory() directory_stack_size increased by one to 2
17:29:27: S -> open_directory, (!remote) try and find a mapping file in this directory .
17:29:27: S -> RCS_parse(.directory_history,/var/tstrepos/as400/WindowsApplication1)
17:29:27: S -> rcsbuf_open(/var/tstrepos/as400/WindowsApplication1/.directory_history,v)
17:29:27: S -> rcsbuf_open failed
17:29:27: S -> rcsbuf_open(/var/tstrepos/as400/WindowsApplication1/Attic/.directory_history,v)
17:29:27: S -> rcsbuf_open failed
17:29:27: S -> No mapping file in this directory.
17:29:27: S -> open_directory copy the tag and date.
17:29:27: S -> open_directory copied the tag and date.
17:29:27: S -> Look for rename script file CVS/Rename
17:29:27: S -> Rename script file does not exist
17:29:27: S -> directory opened
17:29:27: S -> fileattr_startdir(/var/tstrepos/as400/WindowsApplication1)
17:29:27: S -> do_dir_proc() -- call-back dir entry proc (if any)
17:29:27: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc.
WindowsApplication1
17:29:27: S -> do_dir_proc() -- cannot process the dir because the return code was R_SKIP_ALL.
17:29:27: S -> more efficient - close directory in do_dir_proc
17:29:27: S -> close_directory()
17:29:27: S -> close_directory() directory_stack_size decreased by one to 1 
17:29:27: S -> fileattr_write()
17:29:27: S -> fileattr_free()
17:29:27: S -> do_dir_proc()
17:29:27: S -> do_dir_proc() update_dir=
17:29:27: S -> do_dir_proc() -- set up update_dir - skip dots if not at start 
17:29:27: S -> do_dir_proc() -- update_dir is dot? - set to dirp instead
17:29:27: S -> do_dir_proc() after all that now update_dir=WindowsApplicationEVS2a
17:29:27: S -> (server_active || !current_parsed_root->isremote) 2
17:29:27: S -> map_repository(/var/tstrepos/as400/WindowsApplicationEVS2a)
17:29:27: S -> lookup_module2()
17:29:27: S -> lookup_module2(WindowsApplicationEVS2a) after rename?
17:29:27: S -> lookup_module2() call _lookup_module2()
17:29:27: S -> _lookup_module2 - continue_if_no_mod2=1 (default)
17:29:27: S -> lookup_module2(WindowsApplicationEVS2a,8)
17:29:27: S -> _lookup_module2 !p lookup_repository_module(WindowsApplicationEVS2a)
17:29:27: S -> lookup_repository_module(WindowsApplicationEVS2a)
17:29:27: S -> lookup_module2() calls to lookup_repository_module() returned nothing
17:29:27: S -> _lookup_module2 !mod return 0 left,right(,WindowsApplicationEVS2a)
17:29:27: S -> lookup_module2() call _lookup_module2 returned 0
17:29:27: S -> lookup_module2() no recursion permitted so give up now
17:29:27: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL
17:29:27: S -> lookup_module2() return ret=0 renamed=0
17:29:27: S -> map_repository - return(repository) "/var/tstrepos/as400/WindowsApplicationEVS2a"
17:29:27: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote
17:29:27: S -> ParseTag_Dir(/var/tstrepos/as400/WindowsApplicationEVS2a,<something>,<something>,0,)
17:29:27: S -> do_dir_proc() -- verify_access 
17:29:27: S -> verify_access /var/tstrepos/as400/WindowsApplicationEVS2a,WindowsApplicationEVS2a,
17:29:27: S -> verify_perm(/var/tstrepos/as400/WindowsApplicationEVS2a,,read,,)
17:29:27: S -> verify_owner(/var/tstrepos/as400/WindowsApplicationEVS2a)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400/WindowsApplicationEVS2a)
17:29:27: S -> fileattr_read(/var/tstrepos/as400/WindowsApplicationEVS2a)
17:29:27: S -> verify_valid_name(abarrett)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400/WindowsApplicationEVS2a)
17:29:27: S -> ACL lookup on directory /var/tstrepos/as400/WindowsApplicationEVS2a
17:29:27: S -> verify_acl(read,HEAD,)
17:29:27: S -> user_state = 0, group_state = 0
17:29:27: S -> no match at this level
17:29:27: S -> ACL lookup on directory /var/tstrepos/as400
17:29:27: S -> verify_acl(read,HEAD,)
17:29:27: S -> user_state = 0, group_state = 0
17:29:27: S -> no match at this level
17:29:27: S -> Match found.
17:29:27: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL
17:29:27: S -> do_dir_proc() -- process_this_directory
17:29:27: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory
17:29:27: S -> do_dir_proc() after predirent call ParseTag_Dir() 
17:29:27: S -> ParseTag_Dir(WindowsApplicationEVS2a,<something>,<something>,0,<something>)
17:29:27: S -> open_directory(/var/tstrepos/as400/WindowsApplicationEVS2a,WindowsApplicationEVS2a,,,0,,0)
17:29:27: S -> current_directory is already set
17:29:27: S -> open_directory() directory_stack_size increased by one to 2
17:29:27: S -> open_directory, (!remote) try and find a mapping file in this directory .
17:29:27: S -> RCS_parse(.directory_history,/var/tstrepos/as400/WindowsApplicationEVS2a)
17:29:27: S -> rcsbuf_open(/var/tstrepos/as400/WindowsApplicationEVS2a/.directory_history,v)
17:29:27: S -> rcsbuf_open failed
17:29:27: S -> rcsbuf_open(/var/tstrepos/as400/WindowsApplicationEVS2a/Attic/.directory_history,v)
17:29:27: S -> rcsbuf_open failed
17:29:27: S -> No mapping file in this directory.
17:29:27: S -> open_directory copy the tag and date.
17:29:27: S -> open_directory copied the tag and date.
17:29:27: S -> Look for rename script file CVS/Rename
17:29:27: S -> Rename script file does not exist
17:29:27: S -> directory opened
17:29:27: S -> fileattr_startdir(/var/tstrepos/as400/WindowsApplicationEVS2a)
17:29:27: S -> do_dir_proc() -- call-back dir entry proc (if any)
17:29:27: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc.
WindowsApplicationEVS2a
17:29:27: S -> do_dir_proc() -- cannot process the dir because the return code was R_SKIP_ALL.
17:29:27: S -> more efficient - close directory in do_dir_proc
17:29:27: S -> close_directory()
17:29:27: S -> close_directory() directory_stack_size decreased by one to 1 
17:29:27: S -> fileattr_write()
17:29:27: S -> fileattr_free()
17:29:27: S -> do_dir_proc()
17:29:27: S -> do_dir_proc() update_dir=
17:29:27: S -> do_dir_proc() -- set up update_dir - skip dots if not at start 
17:29:27: S -> do_dir_proc() -- update_dir is dot? - set to dirp instead
17:29:27: S -> do_dir_proc() after all that now update_dir=rpgtest
17:29:27: S -> (server_active || !current_parsed_root->isremote) 2
17:29:27: S -> map_repository(/var/tstrepos/as400/rpgtest)
17:29:27: S -> lookup_module2()
17:29:27: S -> lookup_module2(rpgtest) after rename?
17:29:27: S -> lookup_module2() call _lookup_module2()
17:29:27: S -> _lookup_module2 - continue_if_no_mod2=1 (default)
17:29:27: S -> lookup_module2(rpgtest,9)
17:29:27: S -> _lookup_module2 !p lookup_repository_module(rpgtest)
17:29:27: S -> lookup_repository_module(rpgtest)
17:29:27: S -> lookup_module2() calls to lookup_repository_module() returned nothing
17:29:27: S -> _lookup_module2 !mod return 0 left,right(,rpgtest)
17:29:27: S -> lookup_module2() call _lookup_module2 returned 0
17:29:27: S -> lookup_module2() no recursion permitted so give up now
17:29:27: S -> lookup_module2() ret=0, current_directory!=NULL, current_directory->directory_mappings===NULL
17:29:27: S -> lookup_module2() return ret=0 renamed=0
17:29:27: S -> map_repository - return(repository) "/var/tstrepos/as400/rpgtest"
17:29:27: S -> do_dir_proc() -- server_active || !current_parsed_root->isremote
17:29:27: S -> ParseTag_Dir(/var/tstrepos/as400/rpgtest,<something>,<something>,0,)
17:29:27: S -> do_dir_proc() -- verify_access 
17:29:27: S -> verify_access /var/tstrepos/as400/rpgtest,rpgtest,
17:29:27: S -> verify_perm(/var/tstrepos/as400/rpgtest,,read,,)
17:29:27: S -> verify_owner(/var/tstrepos/as400/rpgtest)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400/rpgtest)
17:29:27: S -> fileattr_read(/var/tstrepos/as400/rpgtest)
17:29:27: S -> verify_valid_name(abarrett)
17:29:27: S -> Find all the groups the user is in and add them to the list of valid names.
17:29:27: S -> cache_directory_permissions(/var/tstrepos/as400/rpgtest)
17:29:27: S -> ACL lookup on directory /var/tstrepos/as400/rpgtest
17:29:27: S -> verify_acl(read,HEAD,)
17:29:27: S -> user_state = 0, group_state = 0
17:29:27: S -> no match at this level
17:29:27: S -> ACL lookup on directory /var/tstrepos/as400
17:29:27: S -> verify_acl(read,HEAD,)
17:29:27: S -> user_state = 0, group_state = 0
17:29:27: S -> no match at this level
17:29:27: S -> Match found.
17:29:27: S -> do_dir_proc() -- dir_return!=R_SKIP_ALL
17:29:27: S -> do_dir_proc() -- process_this_directory
17:29:27: S -> do_dir_proc() -- dir_return != R_SKIP_ALL && dir_return != R_ERROR && process_this_directory
17:29:27: S -> do_dir_proc() after predirent call ParseTag_Dir() 
17:29:27: S -> ParseTag_Dir(rpgtest,<something>,<something>,0,<something>)
17:29:27: S -> open_directory(/var/tstrepos/as400/rpgtest,rpgtest,,,0,,0)
17:29:27: S -> current_directory is already set
17:29:27: S -> open_directory() directory_stack_size increased by one to 2
17:29:27: S -> open_directory, (!remote) try and find a mapping file in this directory .
17:29:27: S -> RCS_parse(.directory_history,/var/tstrepos/as400/rpgtest)
17:29:27: S -> rcsbuf_open(/var/tstrepos/as400/rpgtest/.directory_history,v)
17:29:27: S -> rcsbuf_open failed
17:29:27: S -> rcsbuf_open(/var/tstrepos/as400/rpgtest/Attic/.directory_history,v)
17:29:27: S -> rcsbuf_open failed
17:29:27: S -> No mapping file in this directory.
17:29:27: S -> open_directory copy the tag and date.
17:29:27: S -> open_directory copied the tag and date.
17:29:27: S -> Look for rename script file CVS/Rename
17:29:27: S -> Rename script file does not exist
17:29:27: S -> directory opened
17:29:27: S -> fileattr_startdir(/var/tstrepos/as400/rpgtest)
17:29:27: S -> do_dir_proc() -- call-back dir entry proc (if any)
17:29:27: S -> do_dir_proc() -- If we're doing the actual processing, call direntproc.
rpgtest
17:29:27: S -> do_dir_proc() -- cannot process the dir because the return code was R_SKIP_ALL.
17:29:27: S -> more efficient - close directory in do_dir_proc
17:29:27: S -> close_directory()
17:29:27: S -> close_directory() directory_stack_size decreased by one to 1 
17:29:27: S -> fileattr_write()
17:29:27: S -> fileattr_free()
17:29:27: S -> do_recursion() -- walklist() returns and now dirlist!=NULL 
17:29:27: S -> do_recursion: free the saved copy of the pointer if necessary 
17:29:27: S -> debug: 21
17:29:27: S -> debug: 22
17:29:27: S -> do_dir_proc() -- call-back dir leave proc (if any) process_this_directory 
17:29:27: S -> debug: 23
17:29:27: S -> close_directory()
17:29:27: S -> close_directory() directory_stack_size decreased by one to 0 
17:29:27: S -> do_recursion() -- walklist() returns and now dirlist!=NULL 
17:29:27: S -> do_recursion: free the saved copy of the pointer if necessary 
17:29:27: S -> start_recursion: Free the data which expand_wild allocated.
17:29:27: S -> start_recursion: Free the data - update_dir
17:29:27: S -> start_recursion: Free the data - update_repos
17:29:27: S -> start_recursion: (args_to_send_when_finished == NULL)
17:29:27: S -> start_recursion: return 0.
17:29:27: S -> open_module(/var/tstrepos/as400)
17:29:27: S -> run postmodule proc
17:29:27: S -> run_trigger()
17:29:27: S -> Call pre-loaded 'bug.la'
17:29:27: S -> postmodule_proc(.)
17:29:27: S -> Call pre-loaded 'bug.la' returned 0, total ret 0
17:29:27: S -> Call pre-loaded 'info.la'
17:29:27: S -> postmodule_proc(.)
17:29:27: S -> default_trigger: parse_info(CVSROOT/postmodule,%r/%p %c %o,,.)
17:29:27: S -> Call pre-loaded 'info.la' returned 0, total ret 0
17:29:27: S -> Call pre-loaded 'make.la'
17:29:27: S -> postmodule_proc(.)
17:29:27: S -> Call pre-loaded 'make.la' returned 0, total ret 0
17:29:27: S -> run_trigger returning 0
17:29:27: S -> do_module clean up.
17:29:27: S -> do_module return errors=0.
17:29:27: S -> run postcommand proc server
17:29:27: S -> run_trigger()
17:29:27: S -> Call pre-loaded 'bug.la'
17:29:27: S -> postcommand_proc()
17:29:27: S -> No bugs to process
17:29:27: S -> Call pre-loaded 'bug.la' returned 0, total ret 0
17:29:27: S -> Call pre-loaded 'info.la'
17:29:27: S -> postcommand_proc()
17:29:27: S -> default_trigger: parse_info(CVSROOT/postcommand,%r/%p %c,,)
17:29:27: S -> Call pre-loaded 'info.la' returned 0, total ret 0
17:29:27: S -> Call pre-loaded 'make.la'
17:29:27: S -> postcommand_proc()
17:29:27: S -> No bugs to process
17:29:27: S -> Call pre-loaded 'make.la' returned 0, total ret 0
17:29:27: S -> run_trigger returning 0
17:29:27: S -> Unloading bug.la
17:29:27: S -> Unloading - about to close
17:29:27: S -> Unloading - closed
17:29:27: S -> Unloading - about to destroy
17:29:27: S -> Unloading - destroyed
17:29:27: S -> Unloading - about to get lib
17:29:27: S -> Unloading - about to unload
cvs [rls aborted]: end of file from server (consult above messages if any)
17:29:27:   -> Unloading - about to clear list
17:29:27:   -> Unloading - cleared list