From owner-freebsd-current@FreeBSD.ORG Tue May 16 08:18:47 2006 Return-Path: X-Original-To: freebsd-current@freebsd.org 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 B868316A400 for ; Tue, 16 May 2006 08:18:47 +0000 (UTC) (envelope-from ganbold@micom.mng.net) Received: from publicd.ub.mng.net (publicd.ub.mng.net [202.179.0.88]) by mx1.FreeBSD.org (Postfix) with ESMTP id D3EE843D45 for ; Tue, 16 May 2006 08:18:44 +0000 (GMT) (envelope-from ganbold@micom.mng.net) Received: from [202.179.0.164] (helo=[192.168.0.18]) by publicd.ub.mng.net with esmtpa (Exim 4.61 (FreeBSD)) (envelope-from ) id 1FfulH-000Dvg-9O for freebsd-current@freebsd.org; Tue, 16 May 2006 17:18:35 +0900 Message-ID: <44698AD9.1080505@micom.mng.net> Date: Tue, 16 May 2006 17:18:33 +0900 From: Ganbold User-Agent: Thunderbird 1.5.0.2 (X11/20060425) MIME-Version: 1.0 To: freebsd-current@freebsd.org Content-Type: text/plain; charset=ISO-8859-1; format=flowed Content-Transfer-Encoding: 7bit Subject: LOR problem (KDB: enter: witness_checkorder) in CURRENT X-BeenThere: freebsd-current@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Discussions about the use of FreeBSD-current List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Tue, 16 May 2006 08:18:47 -0000 Hi, On today's CURRENT I got LOR when I try to access the machine (I couldn't) first time through ssh. gw# uname -an FreeBSD gw.micom.mng.net 7.0-CURRENT FreeBSD 7.0-CURRENT #2: Tue May 16 06:51:40 ULAST 2006 tsgan@gw.micom.mng.net:/usr/obj/usr/src/sys/GW i386 lock order reversal: 1st 0xc1d8d090 inp (divinp) @ /usr/src/sys/netinet/ip_divert.c:336 2nd 0xc082ee58 PFil hook read/write mutex (PFil hook read/write mutex) @ /usr/src/sys/net/pfil.c:73 KDB: stack backtrace: kdb_backtrace(0,ffffffff,c07eeb28,c07eeec0,c07b40e4) at kdb_backtrace+0x29 witness_checkorder(c082ee58,1,c0734957,49) at witness_checkorder+0x586 _rw_rlock(c082ee58,c0734957,49) at _rw_rlock+0x52 pfil_run_hooks(c082ee40,cc21db28,c1b81800,2,0) at pfil_run_hooks+0x2c ip_output(c1b86a00,0,cc21daf4,22,0) at ip_output+0x63f div_output(c1d1667c,c1b86a00,c1b41080,0,cc21dbb0) at div_output+0x185 div_send(c1d1667c,0,c1b86a00,c1b41080,0) at div_send+0x3f sosend(c1d1667c,c1b41080,cc21dbe4,c1b86a00,0) at sosend+0x3e5 kern_sendit(c1b511b0,3,cc21dc64,0,0) at kern_sendit+0x108 sendit(c1b511b0,3,cc21dc64,0,bfbdebf0) at sendit+0x15f sendto(c1b511b0,cc21dd04,c1b53d38,c,c1b511b0) at sendto+0x4d syscall(3b,3b,3b,2,40) at syscall+0x27e Xint0x80_syscall() at Xint0x80_syscall+0x1f --- syscall (133, FreeBSD ELF32, sendto), eip = 0x2813aaab, esp = 0xbfbdeb1c, ebp = 0xbfbeebc8 --- KDB: enter: witness_checkorder [thread pid 572 tid 100041 ] Stopped at kdb_enter+0x2b: nop db> bt Tracing pid 572 tid 100041 td 0xc1b511b0 kdb_enter(c06fb488) at kdb_enter+0x2b witness_checkorder(c082ee58,1,c0734957,49) at witness_checkorder+0x599 _rw_rlock(c082ee58,c0734957,49) at _rw_rlock+0x52 pfil_run_hooks(c082ee40,cc21db28,c1b81800,2,0) at pfil_run_hooks+0x2c ip_output(c1b86a00,0,cc21daf4,22,0) at ip_output+0x63f div_output(c1d1667c,c1b86a00,c1b41080,0,cc21dbb0) at div_output+0x185 div_send(c1d1667c,0,c1b86a00,c1b41080,0) at div_send+0x3f sosend(c1d1667c,c1b41080,cc21dbe4,c1b86a00,0) at sosend+0x3e5 kern_sendit(c1b511b0,3,cc21dc64,0,0) at kern_sendit+0x108 sendit(c1b511b0,3,cc21dc64,0,bfbdebf0) at sendit+0x15f sendto(c1b511b0,cc21dd04,c1b53d38,c,c1b511b0) at sendto+0x4d syscall(3b,3b,3b,2,40) at syscall+0x27e Xint0x80_syscall() at Xint0x80_syscall+0x1f --- syscall (133, FreeBSD ELF32, sendto), eip = 0x2813aaab, esp = 0xbfbdeb1c, ebp = 0xbfbeebc8 --- db> c calcru: runtime went backwards from 13577 usec to 2447 usec for pid 724 (syslogd) calcru: runtime went backwards from 288 usec to 116 usec for pid 665 (devd) calcru: runtime went backwards from 10690 usec to 4935 usec for pid 665 (devd) calcru: runtime went backwards from 630 usec to 84 usec for pid 166 (adjkerntz) calcru: runtime went backwards from 127606 usec to 17140 usec for pid 40 (pagezero) calcru: runtime went backwards from 3 usec to 0 usec for pid 38 (vmdaemon) calcru: runtime went backwards from 63 usec to 26 usec for pid 37 (pagedaemon) calcru: runtime went backwards from 338 usec to 71 usec for pid 35 (swi0: sio) calcru: runtime went backwards from 7918 usec to 1848 usec for pid 32 (irq14: ata0) calcru: runtime went backwards from 14 usec to 1 usec for pid 30 (irq21: skc0) calcru: runtime went backwards from 21 usec to 3 usec for pid 29 (usb4) calcru: runtime went backwards from 7 usec to 1 usec for pid 27 (usb3) calcru: runtime went backwards from 7 usec to 1 usec for pid 26 (usb2) calcru: runtime went backwards from 8 usec to 1 usec for pid 24 (usb1) calcru: runtime went backwards from 17 usec to 3 usec for pid 21 (usb0) calcru: runtime went backwards from 80009 usec to 10750 usec for pid 16 (swi6: task queue) calcru: runtime went backwards from 1820 usec to 793 usec for pid 14 (yarrow) calcru: runtime went backwards from 20253 usec to 4897 usec for pid 4 (g_down) calcru: runtime went backwards from 13521 usec to 4142 usec for pid 3 (g_up) calcru: runtime went backwards from 6040 usec to 1765 usec for pid 2 (g_event) calcru: runtime went backwards from 52793 usec to 8063 usec for pid 1 (init) calcru: runtime went backwards from 2364780 usec to 376903 usec for pid 1 (init) calcru: runtime went backwards from 853 usec to 114 usec for pid 0 (swapper) LOR doesn't appear on subsequent ssh access (I could log in) after 'c' command in kdb. thanks, Ganbold