From owner-freebsd-current  Sat Dec 28 21:59:33 2002
Delivered-To: freebsd-current@freebsd.org
Received: from mx1.FreeBSD.org (mx1.freebsd.org [216.136.204.125])
	by hub.freebsd.org (Postfix) with ESMTP id E796037B401
	for <freebsd-current@freebsd.org>; Sat, 28 Dec 2002 21:59:25 -0800 (PST)
Received: from mx01.goddamnbastard.org (12-249-234-146.client.attbi.com [12.249.234.146])
	by mx1.FreeBSD.org (Postfix) with ESMTP id 1E64143EC2
	for <freebsd-current@freebsd.org>; Sat, 28 Dec 2002 21:59:20 -0800 (PST)
	(envelope-from ryanb@goddamnbastard.org)
Received: by mx01.goddamnbastard.org (Postfix, from userid 1000)
	id 414F115524; Sat, 28 Dec 2002 23:59:19 -0600 (CST)
Date: Sat, 28 Dec 2002 23:59:19 -0600
From: ryan beasley <ryanb@goddamnbastard.org>
To: freebsd-current@freebsd.org
Subject: panic: lockmgr: draining against myself
Message-ID: <20021229055919.GA62145@goddamnbastard.org>
Mime-Version: 1.0
Content-Type: multipart/signed; micalg=pgp-sha1;
	protocol="application/pgp-signature"; boundary="SLDf9lqlvOQaIe6s"
Content-Disposition: inline
User-Agent: Mutt/1.4i
Sender: owner-freebsd-current@FreeBSD.ORG
Precedence: bulk
List-ID: <freebsd-current.FreeBSD.ORG>
List-Archive: <http://docs.freebsd.org/mail/> (Web Archive)
List-Help: <mailto:majordomo@FreeBSD.ORG?subject=help> (List Instructions)
List-Subscribe: <mailto:majordomo@FreeBSD.ORG?subject=subscribe%20freebsd-current>
List-Unsubscribe: <mailto:majordomo@FreeBSD.ORG?subject=unsubscribe%20freebsd-current>
X-Loop: FreeBSD.ORG


--SLDf9lqlvOQaIe6s
Content-Type: text/plain; charset=us-ascii
Content-Disposition: inline
Content-Transfer-Encoding: quoted-printable

RELENG_5_0 sources checked out 2002.12.28 04:00 CST.  Please let me know if
I can provide any other useful information.

root@fredrik ~> gdb -k /usr/obj/usr/src/sys/FREDRIK_DP/kernel.debug /var/cr=
ash/vmcore.4
Copyright (c) 1992-2002 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
	The Regents of the University of California. All rights reserved.
FreeBSD 5.0-RC #5: Sat Dec 28 04:37:37 CST 2002
    ryanb@fredrik.internal.goddamnbastard.org:/usr/obj/usr/src/sys/FREDRIK_=
DP
Preloaded elf kernel "/boot/kernel/kernel" at 0xc042b000.
Preloaded elf module "/boot/kernel/vesa.ko" at 0xc042b0a8.
Preloaded elf module "/boot/kernel/acpi.ko" at 0xc042b154.
Timecounter "i8254"  frequency 1193182 Hz
Timecounter "TSC"  frequency 2392295728 Hz
CPU: Pentium 4 (2392.30-MHz 686-class CPU)
  Origin =3D "GenuineIntel"  Id =3D 0xf24  Stepping =3D 4
  Features=3D0x3febfbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PG=
E,MCA,CMOV,PAT,PSE36,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM>
real memory  =3D 67108864 (64 MB)
avail memory =3D 60674048 (57 MB)
Initializing GEOMetry subsystem
Pentium Pro MTRR support enabled
VESA: v3.0, 65536k memory, flags:0x1, mode table:0xc03deca2 (1000022)
VESA: NVidia
npx0: <math processor> on motherboard
npx0: INT 16 interface
acpi0: <A M I  OEMRSDT > on motherboard
    ACPI-0625: *** Info: GPE Block0 defined as GPE0 to GPE31
Using $PIR table, 8 entries at 0xc00f44e0
acpi0: power button is handled as a fixed feature programming model.
Timecounter "ACPI-fast"  frequency 3579545 Hz
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x408-0x40b on acpi0
acpi_cpu0: <CPU> on acpi0
pcib0: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib0
agp0: <Intel 82845 host to AGP bridge> mem 0xf8000000-0xfbffffff at device =
0.0 on pci0
pcib1: <PCIBIOS PCI-PCI bridge> at device 1.0 on pci0
pci1: <PCI bus> on pcib1
pci1: <display, VGA> at device 0.0 (no driver attached)
pci0: <serial bus, USB> at device 29.0 (no driver attached)
pci0: <serial bus, USB> at device 29.1 (no driver attached)
pci0: <serial bus, USB> at device 29.2 (no driver attached)
pci0: <serial bus, USB> at device 29.7 (no driver attached)
pcib2: <ACPI PCI-PCI bridge> at device 30.0 on pci0
pci2: <ACPI PCI bus> on pcib2
pci2: <multimedia, audio> at device 1.0 (no driver attached)
pci2: <input device> at device 1.1 (no driver attached)
pci2: <network, ethernet> at device 2.0 (no driver attached)
isab0: <PCI-ISA bridge> at device 31.0 on pci0
isa0: <ISA bus> on isab0
atapci0: <Intel ICH4 ATA100 controller> port 0xffa0-0xffaf,0-0x3,0-0x7,0-0x=
3,0-0x7 at device 31.1 on pci0
ata0: at 0x1f0 irq 14 on atapci0
ata1: at 0x170 irq 15 on atapci0
pci0: <serial bus, SMBus> at device 31.3 (no driver attached)
acpi_button0: <Sleep Button> on acpi0
sio0: configured irq 4 not in bitmap of probed irqs 0
sio0: port may not be enabled
sio0 port 0x3f8-0x3ff irq 4 on acpi0
sio0: type 16550A
fdc0: <Enhanced floppy controller (i82077, NE72065 or clone)> port 0x3f7,0x=
3f4-0x3f5,0x3f2-0x3f3,0x3f0-0x3f1 irq 6 drq 2 on acpi0
fdc0: FIFO enabled, 8 bytes threshold
fd0: <1440-KB 3.5" drive> on fdc0 drive 0
atkbdc0: <Keyboard controller (i8042)> port 0x64,0x60 irq 1 on acpi0
atkbd0: <AT Keyboard> flags 0x1 irq 1 on atkbdc0
psm0: <PS/2 Mouse> irq 12 on atkbdc0
psm0: model MouseMan+, device ID 0
pmtimer0 on isa0
orm0: <Option ROM> at iomem 0xc0000-0xcefff on isa0
sc0: <System console> on isa0
sc0: VGA <16 virtual consoles, flags=3D0x200>
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
sio1: configured irq 3 not in bitmap of probed irqs 0
sio1: port may not be enabled
Timecounters tick every 10.000 msec
acpi_cpu: CPU throttling enabled, 8 steps from 100% to 12.5%
ad0: 38172MB <MAXTOR 6L040J2> [77557/16/63] at ata0-master UDMA100
ad1: 38166MB <WDC WD400BB-00AUA1> [77545/16/63] at ata0-slave UDMA33
acd0: CD-RW <_NEC CD-RW NR-9100A> at ata1-master PIO4
Mounting root from ufs:/dev/ad1s2a
WARNING: / was not properly dismounted
lock order reversal
 1st 0xc128c068 process lock (process lock) @ /usr/src/sys/kern/kern_descri=
p.c:2111
 2nd 0xc12c2534 filedesc structure (filedesc structure) @ /usr/src/sys/kern=
/kern_descrip.c:2118
WARNING: /usr was not properly dismounted
/usr: superblock summary recomputed
WARNING: /var was not properly dismounted
/var: mount pending error: blocks 0 files 3
dc0: <Davicom DM9102A 10/100BaseTX> port 0xd400-0xd4ff mem 0xfeaffc00-0xfea=
ffcff irq 9 at device 2.0 on pci2
dc0: Ethernet address: 00:08:a1:2a:2d:29
/usr/src/sys/vm/uma_core.c:1330: could sleep with "dc0" locked from /usr/sr=
c/sys/pci/if_dc.c:691
/usr/src/sys/vm/uma_core.c:1330: could sleep with "dc0" locked from /usr/sr=
c/sys/pci/if_dc.c:691
/usr/src/sys/vm/uma_core.c:1330: could sleep with "dc0" locked from /usr/sr=
c/sys/pci/if_dc.c:691
miibus0: <MII bus> on dc0
ukphy0: <Generic IEEE 802.3u media interface> on miibus0
ukphy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
dc0: failed to force tx and rx to idle state
dc0: failed to force tx and rx to idle state
panic: lockmgr: draining against myself
panic: from debugger
Uptime: 1m30s
Dumping 64 MB
ata0: resetting devices ..
ad0: DMA limited to UDMA33, non-ATA66 cable or device
done
 16 32 48
---
#0  doadump () at /usr/src/sys/kern/kern_shutdown.c:232
232		dumping++;
(kgdb) where
#0  doadump () at /usr/src/sys/kern/kern_shutdown.c:232
#1  0xc01998ae in boot (howto=3D260) at /usr/src/sys/kern/kern_shutdown.c:3=
64
#2  0xc0199af3 in panic () at /usr/src/sys/kern/kern_shutdown.c:517
#3  0xc0123672 in db_panic () at /usr/src/sys/ddb/db_command.c:450
#4  0xc01235f2 in db_command (last_cmdp=3D0xc02f4c00, cmd_table=3D0x0, aux_=
cmd_tablep=3D0xc02ef544, aux_cmd_tablep_end=3D0xc02ef548)
    at /usr/src/sys/ddb/db_command.c:346
#5  0xc0123706 in db_command_loop () at /usr/src/sys/ddb/db_command.c:472
#6  0xc01263fa in db_trap (type=3D3, code=3D0) at /usr/src/sys/ddb/db_trap.=
c:72
#7  0xc02a2b12 in kdb_trap (type=3D3, code=3D0, regs=3D0xc635d680) at /usr/=
src/sys/i386/i386/db_interface.c:166
#8  0xc02b38cf in trap (frame=3D
      {tf_fs =3D -1072168936, tf_es =3D -1070465008, tf_ds =3D 16, tf_edi =
=3D -1055176288, tf_esi =3D 256, tf_ebp =3D -969550132, tf_isp =3D -9695501=
64, tf_ebx =3D 0, tf_edx =3D 0, tf_ecx =3D 32, tf_eax =3D 18, tf_trapno =3D=
 3, tf_err =3D 0, tf_eip =3D -1070977612, tf_cs =3D 8, tf_eflags =3D 662, t=
f_esp =3D -1070682391, tf_ss =3D -1070753879}) at /usr/src/sys/i386/i386/tr=
ap.c:603
#9  0xc02a42f8 in calltrap () at {standard input}:98
#10 0xc0199adb in panic (fmt=3D0x0) at /usr/src/sys/kern/kern_shutdown.c:503
#11 0xc018d0b2 in lockmgr (lkp=3D0xc1375b50, flags=3D65543, interlkp=3D0x10=
00040, td=3D0xc11b49a0) at /usr/src/sys/kern/kern_lock.c:441
#12 0xc01e42dc in vop_stdlock (ap=3D0x0) at /usr/src/sys/kern/vfs_default.c=
:279
#13 0xc026b8b8 in ufs_vnoperate (ap=3D0x0) at /usr/src/sys/ufs/ufs/ufs_vnop=
s.c:2796
#14 0xc01edec5 in vclean (vp=3D0xc1375a8c, flags=3D8, td=3D0xc11b49a0) at v=
node_if.h:990
#15 0xc01ee44c in vgonel (vp=3D0xc1375a8c, td=3D0x0) at /usr/src/sys/kern/v=
fs_subr.c:2690
#16 0xc01ee35b in vrecycle (vp=3D0xc1375a8c, inter_lkp=3D0x0, td=3D0x0) at =
/usr/src/sys/kern/vfs_subr.c:2645
#17 0xc02643ec in ufs_inactive (ap=3D0x0) at /usr/src/sys/ufs/ufs/ufs_inode=
.c:133
#18 0xc026b8b8 in ufs_vnoperate (ap=3D0x0) at /usr/src/sys/ufs/ufs/ufs_vnop=
s.c:2796
#19 0xc01ed720 in vput (vp=3D0xc1375a8c) at vnode_if.h:930
#20 0xc0255bd7 in handle_workitem_freeblocks (freeblks=3D0xc12c2b00, flags=
=3D0) at /usr/src/sys/ufs/ffs/ffs_softdep.c:2501
#21 0xc025507a in softdep_setup_freeblocks (ip=3D0xc12b6200, length=3D0, fl=
ags=3D2048) at /usr/src/sys/ufs/ffs/ffs_softdep.c:2084
#22 0xc024b0f4 in ffs_truncate (vp=3D0xc1375a8c, length=3D0, flags=3D3072, =
cred=3D0x0, td=3D0xc11b49a0)
    at /usr/src/sys/ufs/ffs/ffs_inode.c:271
#23 0xc02642bc in ufs_inactive (ap=3D0x0) at /usr/src/sys/ufs/ufs/ufs_inode=
.c:100
#24 0xc026b8b8 in ufs_vnoperate (ap=3D0x0) at /usr/src/sys/ufs/ufs/ufs_vnop=
s.c:2796
#25 0xc01ed720 in vput (vp=3D0xc1375a8c) at vnode_if.h:930
#26 0xc01f27b5 in kern_unlink (td=3D0xc11b49a0, path=3D---Can't read usersp=
ace from dump, or kernel process---

) at /usr/src/sys/kern/vfs_syscalls.c:1283
#27 0xc01f2612 in unlink (td=3D0x0, uap=3D0x0) at /usr/src/sys/kern/vfs_sys=
calls.c:1225
#28 0xc02b41ae in syscall (frame=3D
      {tf_fs =3D 47, tf_es =3D 47, tf_ds =3D 47, tf_edi =3D -1077936728, tf=
_esi =3D 0, tf_ebp =3D -1077936824, tf_isp =3D -969548428, tf_ebx =3D -1077=
936575, tf_edx =3D -1077936562, tf_ecx =3D 47, tf_eax =3D 10, tf_trapno =3D=
 12, tf_err =3D 2, tf_eip =3D 134526247, tf_cs =3D 31, tf_eflags =3D 582, t=
f_esp =3D -1077936964, tf_ss =3D 47}) at /usr/src/sys/i386/i386/trap.c:1033
#29 0xc02a434d in Xint0x80_syscall () at {standard input}:140
---Can't read userspace from dump, or kernel process---

(kgdb) up 11
#11 0xc018d0b2 in lockmgr (lkp=3D0xc1375b50, flags=3D65543, interlkp=3D0x10=
00040, td=3D0xc11b49a0) at /usr/src/sys/kern/kern_lock.c:441
441				panic("lockmgr: draining against myself");
(kgdb) list
436			 * never drain if we do. Unfortunately, we have no way to
437			 * check for holding a shared lock, but at least we can
438			 * check for an exclusive one.
439			 */
440			if (lkp->lk_lockholder =3D=3D pid)
441				panic("lockmgr: draining against myself");
442=09
443			error =3D acquiredrain(lkp, extflags);
444			if (error)
445				break;
(kgdb) p *lkp
$1 =3D {lk_interlock =3D 0xc032b3c8, lk_flags =3D 16778304, lk_sharecount =
=3D 0, lk_waitcount =3D 0, lk_exclusivecount =3D 1, lk_prio =3D 80,=20
  lk_wmesg =3D 0xc02e24b4 "ufs", lk_timo =3D 6, lk_lockholder =3D 210, lk_n=
ewlock =3D 0x0}
(kgdb) up 1
#12 0xc01e42dc in vop_stdlock (ap=3D0x0) at /usr/src/sys/kern/vfs_default.c=
:279
279		return (lockmgr(vp->v_vnlock, ap->a_flags, VI_MTX(vp), ap->a_td));

root@fredrik ~> ps -M /var/crash/vmcore.4 -N /usr/obj/usr/src/sys/FREDRIK_D=
P/kernel.debug -axl=20
  UID   PID  PPID CPU PRI NI   VSZ  RSS MWCHAN STAT  TT       TIME COMMAND
    0    37     1 327698   8  0   968    0 wait   Ds+  #C:    0:00.04  (sh)
    0   203    37 327698   8  0   984    0 wait   D+   #C:    0:00.01  (sh)
    0   207   203 327698   8  0   868    0 wait   D+   #C:    0:00.00  (sh)
    0   209   207 327698   8  0   872    0 wait   D+   #C:    0:00.00  (sh)
    0   210   209 327698  -8  0   552    0 -      R+   #C:    0:00.23  (rm)
    0     0     0 327698 -16  0     0    0 sched  DLs   ??    0:00.00  (swa=
pper)
    0     1     0 327698   8  0   664    0 wait   DLs   ??    0:00.01  (ini=
t)
    0     2     0 327698  -8  0     0    0 g_even DL    ??    0:00.03  (g_e=
vent)
    0     3     0 327698  -8  0     0    0 g_up   DL    ??    0:00.01  (g_u=
p)
    0     4     0 327698  -8  0     0    0 g_down DL    ??    0:00.03  (g_d=
own)
    0     5     0 327698 -84  0     0    0 actask DL    ??    0:00.00  (acp=
i_task0)
    0     6     0 327698 -84  0     0    0 actask DL    ??    0:00.00  (acp=
i_task1)
    0     7     0 327698 -84  0     0    0 actask DL    ??    0:00.00  (acp=
i_task2)
    0     8     0 327698 -16  0     0    0 psleep DL    ??    0:00.00  (pag=
edaemon)
    0     9     0 327698  20  0     0    0 psleep DL    ??    0:00.00  (vmd=
aemon)
    0    10     0 327698 -16  0     0    0 ktrace DL    ??    0:00.00  (ktr=
ace)
    0    11     0 327698 -16  0     0    0 -      RL    ??    1:26.81  (idl=
e)
    0    12     0 327698 -48  0     0    0 -      WL    ??    0:00.08  (swi=
6: tty:sio clock)
    0    13     0 327698 -32  0     0    0 -      RL    ??    0:00.00  (swi=
4: vm)
    0    14     0 327698 -44  0     0    0 -      WL    ??    0:00.00  (swi=
1: net)
    0    15     0 327698  76  0     0    0 sleep  DL    ??    0:00.00  (ran=
dom)
    0    16     0 327698 -28  0     0    0 -      WL    ??    0:00.00  (swi=
5: acpitaskq)
    0    17     0 327698 -28  0     0    0 -      RL    ??    0:00.00  (swi=
5: task queue)
    0    18     0 327698 -21  0     0    0 -      RL    ??    0:00.00  (irq=
13:)
    0    19     0 327698 -68  0     0    0 -      WL    ??    0:00.00  (irq=
9: dc0 acpi0)
    0    20     0 327698 -64  0     0    0 -      WL    ??    0:00.02  (irq=
14: ata0)
    0    21     0 327698 -64  0     0    0 -      WL    ??    0:00.00  (irq=
15: ata1)
    0    22     0 327698 -48  0     0    0 -      RL    ??    0:00.00  (swi=
0: tty:sio)
    0    23     0 327698 -60  0     0    0 -      RL    ??    0:00.00  (irq=
4: sio0)
    0    24     0 327698 -64  0     0    0 -      WL    ??    0:00.00  (irq=
6: fdc0)
    0    25     0 327698 -60  0     0    0 -      WL    ??    0:00.02  (irq=
1: atkbd0)
    0    26     0 327698 -60  0     0    0 -      RL    ??    0:00.00  (irq=
12: psm0)
    0    27     0 327698 -84  0     0    0 -      RL    ??    0:00.00  (irq=
0: clk)
    0    28     0 327698 -84  0     0    0 -      RL    ??    0:00.00  (irq=
8: rtc)
    0    29     0 327698 171  0     0    0 pgzero DL    ??    0:00.08  (pag=
ezero)
    0    30     0 327698 -16  0     0    0 psleep DL    ??    0:00.00  (buf=
daemon)
    0    31     0 327698  -4  0     0    0 vlruwt DL    ??    0:00.00  (vnl=
ru)
    0    32     0 327698  20  0     0    0 syncer DL    ??    0:00.00  (syn=
cer)
    0    33     0 327698   8  0     0    0 nfsidl DL    ??    0:00.00  (nfs=
iod 0)
    0    34     0 327698   8  0     0    0 nfsidl DL    ??    0:00.00  (nfs=
iod 1)
    0    35     0 327698   8  0     0    0 nfsidl DL    ??    0:00.00  (nfs=
iod 2)
    0    36     0 327698   8  0     0    0 nfsidl DL    ??    0:00.00  (nfs=
iod 3)
    0   119     1 327698  20  0   220    0 pause  Ds    ??    0:00.00  (adj=
kerntz)
    0   184     1 327698  96  0  1160    0 select Ds    ??    0:00.00  (dhc=
lient)

--=20
ryan beasley				<ryanb@goddamnbastard.org>
GPG ID: 0x16EFBD48			http://www.goddamnbastard.org	=09

--SLDf9lqlvOQaIe6s
Content-Type: application/pgp-signature
Content-Disposition: inline

-----BEGIN PGP SIGNATURE-----
Version: GnuPG v1.0.7 (FreeBSD)

iD8DBQE+Do83skfdOxbvvUgRAiu5AJ42FbjDaF1PRG52U7L/tYd5WXFU/wCeIj1e
JOcXe42j2gXW/2goSO3LjSA=
=biKY
-----END PGP SIGNATURE-----

--SLDf9lqlvOQaIe6s--

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