On Wed, Oct 10, 2001 at 02:28:48PM -0400, Jan Harkes wrote: > On Wed, Oct 10, 2001 at 01:45:59PM +0200, Matthias Teege wrote: > > So I do an venus -init & wich works and then try again my cvsup command. > > > > The point, venus stopped working is always different and I can't find any > > hint in the venus.log. > > > > How do I debug such thing? > > Check the venus.log file, especially near the end. (probably in > /usr/coda/etc/venus.log. If it doesn't show anything interesting, start > venus with 'venus -init -d 10', then there should be a _lot_ more stuff > in the venus.log to the point that it actually becomes hard to notice > the interesting messages.
I'll append the last 100 lines from venus.log. There you can see that all directorys under /coda has gone. I have also run venus under gdb with but I get no interesting message. It looks like that venus dont die but only the mounted files are gone. Sometimes I can shutdown venus successfully but a clean restart is impossible. Can It be an cache problem? I have two servers and in this case venus run on server 1 (scm) and the volume to write is on server 2. All files must write over network to server 2. So I setup a big cache (300000) on server 1 and start the cvsup. It runs for a while and then /coda went away. After I restart venus with init and all cached files are gone, I try it again and I get sometimes conflicts on one directory wich I cant repair because of "Cant allocate new repvol ...". So I have to wait untill the cvsup stops, clean the cache and try again. > However, if it really is a crash (null-ptr or something) the easiest > way that I've found is to run venus under gdb, which catches the > segfault and then grabs a stacktrace. No segfault at all but only on restart without init. There I get an 09:13:16 49884 CML entries allocated 09:13:16 0 CML entries on free-list 09:13:16 starting FSDB scan (12500, 300000) (25, 75, 4) 09:13:17 fatal error -- recovery failed on local, non-file object (gcc27, (0xffffffff.0xffffffff.0x2)) 09:13:42 Fatal Signal (11); pid 2609 becoming a zombie... 09:13:42 You may use gdb to attach to 2609 %vutil shutdown %09:15:46 RecovTerminate: clean shutdown Many thanks Matthias -- Matthias Teege -- [EMAIL PROTECTED] -- http://emugs.de make world not war PGP-Key auf Anfrage
[ W(21) : 0000 : 07:53:09 ] fsobj::Lookup: (cpp2latex/#cvs.cvsup-2311.9883), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (cpp2latex, 8, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Lookup: (cpp2latex/pkg-descr), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (cpp2latex, 8, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Rename : (cpp2latex/#cvs.cvsup-2311.9883, cpp2latex/pkg-descr), uid = 0 [ W(21) : 0000 : 07:53:09 ] repvol::LogRename: 1002779589, 0, (7f00000b.ffffffff.82db0), #cvs.cvsup-2311.9883, (7f00000b.ffffffff.82db0), pkg-descr, (7f00000b.fffffffe.82db4) -1 [ W(21) : 0000 : 07:53:09 ] cmlent::operator new() [ W(21) : 0000 : 07:53:09 ] cmlent::cmlent(...) [ W(21) : 0000 : 07:53:09 ] cmlent::cmlent: tid = (3b8a8bda.52089), uid = 0, op = Rename [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Rename): code = 0 [ W(21) : 0000 : 07:53:09 ] Rename : returns SUCCESS, elapsed = 19.4 msec [ W(21) : 0000 : 07:53:09 ] vproc::lookup: fid = (0x7f00000b.0xffffffff.0x82db0), name = pkg-descr, nc = 0 [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Lookup): vid = 7f00000b, u.u_vol = 0, mode = -1 [ W(21) : 0000 : 07:53:09 ] fsobj::Lookup: (cpp2latex/pkg-descr), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (cpp2latex, 8, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Lookup): code = 0 [ W(21) : 0000 : 07:53:09 ] Lookup : returns SUCCESS, elapsed = 9.1 msec [ W(21) : 0000 : 07:53:09 ] vproc::getattr: fid = (0x7f00000b.0xfffffffe.0x82db4) [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Getattr): vid = 7f00000b, u.u_vol = 0, mode = -1 [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Getattr): code = 0 [ W(21) : 0000 : 07:53:09 ] Getattr : returns SUCCESS, elapsed = 7.4 msec [ W(21) : 0000 : 07:53:09 ] vproc::getattr: fid = (0x7f00000b.0xffffffff.0x82db0) [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Getattr): vid = 7f00000b, u.u_vol = 0, mode = -1 [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Getattr): code = 0 [ W(21) : 0000 : 07:53:09 ] Getattr : returns SUCCESS, elapsed = 1.8 msec [ W(21) : 0000 : 07:53:09 ] vproc::lookup: fid = (0x7f00000b.0xffffffff.0x82db0), name = #cvs.cvsup-2311.9884, nc = 0 [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Lookup): vid = 7f00000b, u.u_vol = 0, mode = -1 [ W(21) : 0000 : 07:53:09 ] fsobj::Lookup: (cpp2latex/#cvs.cvsup-2311.9884), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (cpp2latex, 8, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Lookup): code = 2 [ W(21) : 0000 : 07:53:09 ] Lookup : returns No such file or directory, elapsed = 1.9 msec [ W(21) : 0000 : 07:53:09 ] vproc::create: fid = (0x7f00000b.0xffffffff.0x82db0), name = #cvs.cvsup-2311.9884, excl = 256, mode = 384 [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Create): vid = 7f00000b, u.u_vol = 0, mode = -1 [ W(21) : 0000 : 07:53:09 ] fsobj::Lookup: (cpp2latex/#cvs.cvsup-2311.9884), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (cpp2latex, 8, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (cpp2latex, 4, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Create: (cpp2latex, #cvs.cvsup-2311.9884, 62500), uid = 0 [ W(21) : 0000 : 07:53:09 ] repvol::AllocFid: (7f00000b, 1), uid = 0 [ W(21) : 0000 : 07:53:09 ] repvol::AllocFid: target_fid = (7f00000b.fffffffe.82db5) [ W(21) : 0000 : 07:53:09 ] fsobj::fsobj: fid = ((0x7f00000b.0xfffffffe.0x82db5)), comp = #cvs.cvsup-2311.9884 [ W(21) : 0000 : 07:53:09 ] repvol::LogCreate: 1002779589, 0, (7f00000b.ffffffff.82db0), #cvs.cvsup-2311.9884, (7f00000b.fffffffe.82db5), 600 -1 [ W(21) : 0000 : 07:53:09 ] cmlent::operator new() [ W(21) : 0000 : 07:53:09 ] cmlent::cmlent(...) [ W(21) : 0000 : 07:53:09 ] fsobj::MakeDirty: ((0x7f00000b.0xfffffffe.0x82db5)) [ W(21) : 0000 : 07:53:09 ] cmlent::cmlent: tid = (3b8a8bda.52090), uid = 0, op = Create [ W(21) : 0000 : 07:53:09 ] fsobj::Matriculate: ((0x7f00000b.0xfffffffe.0x82db5)) [ W(21) : 0000 : 07:53:09 ] CacheFile::Create: 00/00/2E/CC, 0 [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Create): code = 0 [ W(21) : 0000 : 07:53:09 ] Create : returns SUCCESS, elapsed = 31.5 msec [ W(21) : 0000 : 07:53:09 ] vproc::open: fid = (0x7f00000b.0xfffffffe.0x82db5) , flags = 203 [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Open): vid = 7f00000b, u.u_vol = 0, mode = 1 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (#cvs.cvsup-2311.9884, 1, 4), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (cpp2latex, 1, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (#cvs.cvsup-2311.9884, 6, 8), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (cpp2latex, 6, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Open: (#cvs.cvsup-2311.9884, 1, 0, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsdb::ChangeDiskUsage: 0 blocks [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Open): code = 0 [ W(21) : 0000 : 07:53:09 ] Open : returns SUCCESS, elapsed = 15.0 msec [ W(21) : 0000 : 07:53:09 ] vproc::getattr: fid = (0x7f00000b.0xfffffffe.0x82db5) [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Getattr): vid = 7f00000b, u.u_vol = 0, mode = -1 [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Getattr): code = 0 [ W(21) : 0000 : 07:53:09 ] Getattr : returns SUCCESS, elapsed = 8.1 msec [ W(21) : 0000 : 07:53:09 ] vproc::getattr: fid = (0x7f00000b.0xfffffffe.0x82db5) [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Getattr): vid = 7f00000b, u.u_vol = 0, mode = -1 [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Getattr): code = 0 [ W(21) : 0000 : 07:53:09 ] Getattr : returns SUCCESS, elapsed = 9.7 msec [ W(21) : 0000 : 07:53:09 ] vproc::close: fid = (0x7f00000b.0xfffffffe.0x82db5), flags = 3 [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Close): vid = 7f00000b, u.u_vol = 0, mode = 1 [ W(21) : 0000 : 07:53:09 ] fsobj::Close: (#cvs.cvsup-2311.9884, 1, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsdb::ChangeDiskUsage: 1 blocks [ W(21) : 0000 : 07:53:09 ] Cachefile::SetLength 207 [ W(21) : 0000 : 07:53:09 ] fsobj::Store: (#cvs.cvsup-2311.9884), uid = 0 [ W(21) : 0000 : 07:53:09 ] repvol::LogStore: 1002779589, 0, (7f00000b.fffffffe.82db5), 207 -1 [ W(21) : 0000 : 07:53:09 ] cmlent::operator new() [ W(21) : 0000 : 07:53:09 ] cmlent::cmlent(...) [ W(21) : 0000 : 07:53:09 ] cmlent::cmlent: tid = (3b8a8bda.52091), uid = 0, op = Store [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Close): code = 0 [ W(21) : 0000 : 07:53:09 ] Close : returns SUCCESS, elapsed = 27.3 msec [ W(21) : 0000 : 07:53:09 ] vproc::lookup: fid = (0x7f00000b.0xffffffff.0x82db0), name = pkg-plist, nc = 0 [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Lookup): vid = 7f00000b, u.u_vol = 0, mode = -1 [ W(21) : 0000 : 07:53:09 ] fsobj::Lookup: (cpp2latex/pkg-plist), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (cpp2latex, 8, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Lookup): code = 2 [ W(21) : 0000 : 07:53:09 ] Lookup : returns No such file or directory, elapsed = 2.6 msec [ W(21) : 0000 : 07:53:09 ] vproc::lookup: fid = (0x7f00000b.0xffffffff.0x82db0), name = #cvs.cvsup-2311.9884, nc = 0 [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Lookup): vid = 7f00000b, u.u_vol = 0, mode = -1 [ W(21) : 0000 : 07:53:09 ] fsobj::Lookup: (cpp2latex/#cvs.cvsup-2311.9884), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (cpp2latex, 8, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] vproc::End_VFS(Lookup): code = 0 [ W(21) : 0000 : 07:53:09 ] Lookup : returns SUCCESS, elapsed = 10.9 msec [ W(21) : 0000 : 07:53:09 ] vproc::setattr: fid = (0x7f00000b.0xfffffffe.0x82db5) [ W(21) : 0000 : 07:53:09 ] vproc::Begin_VFS(Setattr): vid = 7f00000b, u.u_vol = 0, mode = -1 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (#cvs.cvsup-2311.9884, 2, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::Access : (cpp2latex, 2, 0), uid = 0 [ W(21) : 0000 : 07:53:09 ] fsobj::SetAttr: (#cvs.cvsup-2311.9884), uid = 0 [ W(21) : 0000 : 07:53:09 ] repvol::LogUtimes: 1002779589, 0, (7f00000b.fffffffe.82db5), 995621817 -1 [ W(21) : 0000 : 07:53:09 ] cmlent::operator new() [ W(21) : 0000 : 07:53:09 ] k_Purge: Flush [ W(21) : 0000 : 07:53:09 ] k_Purge: Flush, returns 0
