Skip site navigation (1)Skip section navigation (2)
Date:      Fri, 5 May 2000 15:35:30 +0200 (CEST)
From:      Thomas Faehnle <tf@wurbl.wn.bawue.de>
To:        grog@lemis.com
Cc:        freebsd-questions@freebsd.org
Subject:   Re: 4.0-RELEASE: vinum, fs, ATA trouble
Message-ID:  <E12niI6-0002m3-00@wurbl.bk.int>
In-Reply-To: <20000505091209.D32650@freebie.lemis.com>

next in thread | previous in thread | raw e-mail | index | archive | help
On  5 May, grog@lemis.com wrote:
> [...]
>> But then, copying /usr/src to a filesystem with non-default block and
>> fragment size (32k/4k) yields the cp process hanging in "D+" state
>> after some 10s of megabytes. No vinum, no soft updates involved.
> 
> More interesting than the D+ state is the WCHAN value returned by 
> ps l.

Ok, I have a debugging kernel now. Doing

  newfs -f 4096 -b 32768 /dev/ad2s2e
  mount /dev/ad2s2e /t
  cp -rv /usr/src/* /t

leaves the machine as shown below. I've included stack traces of all
processes on the "nbufkv" WCHAN.

marvin:/sys/compile/TFDBG# ps l
  UID   PID  PPID CPU PRI NI   VSZ  RSS WCHAN  STAT  TT       TIME COMMAND
[...]
    0     4     0   0  -2  0     0    0 nbufkv DL    ??    0:00.13  (bufdaemon)
    0     5     0   0  -2  0     0    0 nbufkv DL    ??    0:00.35  (syncer)
[...]
    0   241   212   0  -2  0   372  200 nbufkv D+    v0    0:02.76 cp -rv /usr/
[...]

marvin:/sys/compile/TFDBG# gdb -k
GNU gdb 4.18
[...]
(kgdb) symbol-file kernel.debug 
Reading symbols from kernel.debug...done.
(kgdb) exec-file kernel
(kgdb) core-file /dev/mem
IdlePTD 3203072
initial pcb at 2990000
panic messages:
---
---
#0  mi_switch () at ../../kern/kern_synch.c:859
859             if (switchtime.tv_sec == 0)
(kgdb) proc 241
(kgdb) bt
#0  mi_switch () at ../../kern/kern_synch.c:859
#1  0xc014fe81 in tsleep (ident=0xc02990bc, priority=20, 
    wmesg=0xc0256b68 "nbufkv", timo=0) at ../../kern/kern_synch.c:468
#2  0xc016fbd7 in getnewbuf (slpflag=0, slptimeo=0, size=4096, maxsize=32768)
    at ../../kern/vfs_bio.c:1709
#3  0xc0170511 in getblk (vp=0xc63529a0, blkno=0, size=4096, slpflag=0, 
    slptimeo=0) at ../../kern/vfs_bio.c:2248
#4  0xc016e48a in bread (vp=0xc63529a0, blkno=0, size=4096, cred=0x0, 
    bpp=0xc62ebcf4) at ../../kern/vfs_bio.c:498
#5  0xc01f192b in ffs_blkatoff (vp=0xc63529a0, offset=0, res=0x0, 
    bpp=0xc62ebd74) at ../../ufs/ffs/ffs_subr.c:83
#6  0xc01f63b5 in ufs_lookup (ap=0xc62ebdc4) at ../../ufs/ufs/ufs_lookup.c:219
#7  0xc01fb155 in ufs_vnoperate (ap=0xc62ebdc4)
    at ../../ufs/ufs/ufs_vnops.c:2283
#8  0xc0172079 in vfs_cache_lookup (ap=0xc62ebe18) at vnode_if.h:77
#9  0xc01fb155 in ufs_vnoperate (ap=0xc62ebe18)
    at ../../ufs/ufs/ufs_vnops.c:2283
#10 0xc0174c58 in lookup (ndp=0xc62ebe94) at vnode_if.h:52
#11 0xc0174754 in namei (ndp=0xc62ebe94) at ../../kern/vfs_lookup.c:153
#12 0xc017a0d1 in stat (p=0xc5db7080, uap=0xc62ebf80)
    at ../../kern/vfs_syscalls.c:1698
#13 0xc023939e in syscall (frame={tf_fs = 47, tf_es = 47, tf_ds = 47, 
      tf_edi = 134563645, tf_esi = 20, tf_ebp = -1077937864, 
      tf_isp = -970014764, tf_ebx = 134573354, tf_edx = 134573374, tf_ecx = 0, 
      tf_eax = 188, tf_trapno = 7, tf_err = 2, tf_eip = 134522652, tf_cs = 31, 
      tf_eflags = 643, tf_esp = -1077938020, tf_ss = 47})
    at ../../i386/i386/trap.c:1073
#14 0xc022d8c6 in Xint0x80_syscall ()
#15 0x80484da in ?? ()
#16 0x80480f9 in ?? ()
(kgdb) 
(kgdb) proc 4
(kgdb) bt
#0  mi_switch () at ../../kern/kern_synch.c:859
#1  0xc014fe81 in tsleep (ident=0xc02990bc, priority=20, 
    wmesg=0xc0256b68 "nbufkv", timo=0) at ../../kern/kern_synch.c:468
#2  0xc016fbd7 in getnewbuf (slpflag=0, slptimeo=0, size=4096, maxsize=65536)
    at ../../kern/vfs_bio.c:1709
#3  0xc0170617 in geteblk (size=4096) at ../../kern/vfs_bio.c:2320
#4  0xc016e7a8 in bwrite (bp=0xc1c87bb0) at ../../kern/vfs_bio.c:641
#5  0xc0173c82 in vop_stdbwrite (ap=0xc5dc5f68) at ../../kern/vfs_default.c:319
#6  0xc0173add in vop_defaultop (ap=0xc5dc5f68) at ../../kern/vfs_default.c:138
#7  0xc01823e9 in spec_vnoperate (ap=0xc5dc5f68)
    at ../../miscfs/specfs/spec_vnops.c:117
#8  0xc01fb185 in ufs_vnoperatespec (ap=0xc5dc5f68)
    at ../../ufs/ufs/ufs_vnops.c:2301
#9  0xc016f802 in vfs_bio_awrite (bp=0xc1c87bb0) at vnode_if.h:1172
#10 0xc016ff9a in flushbufqueues () at ../../kern/vfs_bio.c:1913
#11 0xc016fd7b in buf_daemon () at ../../kern/vfs_bio.c:1833
#12 0xc022d8e0 in fork_trampoline ()
error reading /proc/4/mem
(kgdb) 
(kgdb) proc 5
(kgdb) bt
#0  mi_switch () at ../../kern/kern_synch.c:859
#1  0xc014fe81 in tsleep (ident=0xc02990bc, priority=20, 
    wmesg=0xc0256b68 "nbufkv", timo=0) at ../../kern/kern_synch.c:468
#2  0xc016fbd7 in getnewbuf (slpflag=0, slptimeo=0, size=4096, maxsize=65536)
    at ../../kern/vfs_bio.c:1709
#3  0xc0170617 in geteblk (size=4096) at ../../kern/vfs_bio.c:2320
#4  0xc016e7a8 in bwrite (bp=0xc1cb8048) at ../../kern/vfs_bio.c:641
#5  0xc0173c82 in vop_stdbwrite (ap=0xc5dc7f10) at ../../kern/vfs_default.c:319
#6  0xc0173add in vop_defaultop (ap=0xc5dc7f10) at ../../kern/vfs_default.c:138
#7  0xc01823e9 in spec_vnoperate (ap=0xc5dc7f10)
    at ../../miscfs/specfs/spec_vnops.c:117
#8  0xc01fb185 in ufs_vnoperatespec (ap=0xc5dc7f10)
    at ../../ufs/ufs/ufs_vnops.c:2301
#9  0xc016eba2 in bawrite (bp=0xc1cb8048) at vnode_if.h:1172
#10 0xc01f48e2 in ffs_fsync (ap=0xc5dc7f7c) at ../../ufs/ffs/ffs_vnops.c:198
#11 0xc0176203 in sched_sync () at vnode_if.h:537
#12 0xc022d8e0 in fork_trampoline ()
error reading /proc/5/mem
(kgdb)


Thomas

-- 
Thomas Faehnle, Am Sommerrain 12, D-71522 Backnang  | MIME mail welcome
mail: tf@wurbl.wn.bawue.de * phone: +49 7191 954671 | PGP key available




To Unsubscribe: send mail to majordomo@FreeBSD.org
with "unsubscribe freebsd-questions" in the body of the message




Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?E12niI6-0002m3-00>