From owner-freebsd-current@FreeBSD.ORG Sun Jun 21 00:19:17 2009 Return-Path: Delivered-To: freebsd-current@freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id C42D01065670 for ; Sun, 21 Jun 2009 00:19:17 +0000 (UTC) (envelope-from dataefx@charter.net) Received: from mta21.charter.net (mta21.charter.net [216.33.127.81]) by mx1.freebsd.org (Postfix) with ESMTP id 877908FC13 for ; Sun, 21 Jun 2009 00:19:17 +0000 (UTC) (envelope-from dataefx@charter.net) Received: from imp09 ([10.20.200.9]) by mta21.charter.net (InterMail vM.7.09.01.00 201-2219-108-20080618) with ESMTP id <20090621001916.EDNQ3344.mta21.charter.net@imp09> for ; Sat, 20 Jun 2009 20:19:16 -0400 Received: from [192.168.0.196] ([75.142.55.73]) by imp09 with smtp.charter.net id 6QKE1c0041amw1F05QKE8Q; Sat, 20 Jun 2009 20:19:16 -0400 From: john scroggins To: current Content-Type: text/plain Date: Sat, 20 Jun 2009 17:18:58 -0700 Message-Id: <1245543553.2063.24.camel@microtetonics.charterpipeline.net> Mime-Version: 1.0 X-Mailer: Evolution 2.26.2 FreeBSD GNOME Team Port Content-Transfer-Encoding: 7bit Subject: LORs on boot up eeePC 1000HE 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: Sun, 21 Jun 2009 00:19:18 -0000 during boot up I am getting lock order reversals. I get the during shutdown also. the following are boot LORS, ill send the shutdown LORS asap.. bootup -- lock order reversal: 1st 0xd97b32c0 bufwait (bufwait) @ /usr/src/sys/kern/vfs_bio.c:2558 2nd 0xc5e73200 dirhash (dirhash) @ /usr/src/sys/ufs/ufs/ufs_dirhash.c:285 KDB: stack backtrace: db_trace_self_wrapper(c0c44382,e8636854,c08a7a6f,c0899476,c0c471c5,...) at db_trace_self_wrapper+0x26 kdb_backtrace(c0899476,c0c471c5,c552be28,c55304d8,e86368b0,...) at kdb_backtrace+0x29 _witness_debugger(c0c471c5,c5e73200,c0c67d40,c55304d8,c0c679d9,...) at _witness_debugger+0x1e witness_checkorder(c5e73200,9,c0c679d9,11d,0,...) at witness_checkorder +0x818 _sx_xlock(c5e73200,0,c0c679d9,11d,c5d6d89c,...) at _sx_xlock+0x81 ufsdirhash_acquire(d97b3260,e86369cc,3c,da0b95e4,e8636984,...) at ufsdirhash_acquire+0x31 ufsdirhash_add(c5d6d89c,e86369cc,15e4,e8636970,e8636974,...) at ufsdirhash_add+0x13 ufs_direnter(c5d8396c,c65d0000,e86369cc,e8636be0,0,...) at ufs_direnter +0x713 ufs_makeinode(e8636be0) at ufs_makeinode+0x4df ufs_create(e8636c04,c5bbca10,c0d75e40,c5d8396c,e8636c18,...) at ufs_create+0x2c VOP_CREATE_APV(c0d5b5c0,e8636c04,e8636be0,e8636b4c,c5e7e54c,...) at VOP_CREATE_APV+0xda uipc_bind(c604819c,c5e6f560,c5bea240,e8636c64,c08d08d5,...) at uipc_bind +0x31f sobind(c604819c,c5e6f560,c5bea240,c5e6f560,c5bde310,...) at sobind+0x23 kern_bind(c5bea240,3,c5e6f560,c5e6f560,c5be5550,...) at kern_bind+0x99 bind(c5bea240,e8636cf8,c,c0c47a40,c0d291a0,...) at bind+0x42 syscall(e8636d38) at syscall+0x2b4 Xint0x80_syscall() at Xint0x80_syscall+0x20 --- syscall (104, FreeBSD ELF32, bind), eip = 0x33d8f597, esp = 0xbfbfe85c, ebp = 0xbfbfe958 --- lock order reversal: 1st 0xc6c567ac ufs (ufs) @ /usr/src/sys/ufs/ffs/ffs_snapshot.c:423 2nd 0xd9856940 bufwait (bufwait) @ /usr/src/sys/kern/vfs_bio.c:2558 3rd 0xc5c33bdc ufs (ufs) @ /usr/src/sys/ufs/ffs/ffs_snapshot.c:544 KDB: stack backtrace: db_trace_self_wrapper(c0c44382,e8622414,c08a7a6f,c0899476,c0c471de,...) at db_trace_self_wrapper+0x26 kdb_backtrace(c0899476,c0c471de,c552be28,c5530470,e8622470,...) at kdb_backtrace+0x29 _witness_debugger(c0c471de,c5c33bdc,c0c39e3a,c5530470,c0c658b9,...) at _witness_debugger+0x1e witness_checkorder(c5c33bdc,9,c0c658b9,220,0,...) at witness_checkorder +0x818 __lockmgr_args(c5c33bdc,80100,c5c33bf8,0,0,...) at __lockmgr_args+0x75e ffs_lock(e8622584,e8622578,c0eec9a0,c5b6a0a4,c0eec970,...) at ffs_lock +0x7d VOP_LOCK1_APV(c0d5b5c0,e8622584,c5c36508,c0d75a40,c5c33b84,...) at VOP_LOCK1_APV+0xeb _vn_lock(c5c33b84,80100,c0c658b9,220,c556a000,...) at _vn_lock+0x5e ffs_snapshot(c5c36508,c5ade7a0,c0c6721e,15f,3,...) at ffs_snapshot +0x14e2 ffs_mount(c5c36508,0,c0c4da7f,3d2,0,...) at ffs_mount+0x1478 vfs_donmount(c5b6a000,211000,c6bf5280,c6bf5280,c5c20d48,...) at vfs_donmount+0x1016 nmount(c5b6a000,e8622cf8,c,e8622d2c,c0d2af98,...) at nmount+0x65 syscall(e8622d38) at syscall+0x2b4 Xint0x80_syscall() at Xint0x80_syscall+0x20 --- syscall (378, FreeBSD ELF32, nmount), eip = 0x33ceb347, esp = 0xbfbfeadc, ebp = 0xbfbfee28 --- lock order reversal: 1st 0xd979e950 bufwait (bufwait) @ /usr/src/sys/kern/vfs_bio.c:2558 2nd 0xc6c820dc snaplk (snaplk) @ /usr/src/sys/ufs/ffs/ffs_snapshot.c:2223 KDB: stack backtrace: db_trace_self_wrapper(c0c44382,e63f0980,c08a7a6f,c0899476,c0c471c5,...) at db_trace_self_wrapper+0x26 kdb_backtrace(c0899476,c0c471c5,c552be28,c5530e30,e63f09dc,...) at kdb_backtrace+0x29 _witness_debugger(c0c471c5,c6c820dc,c0c6591b,c5530e30,c0c658b9,...) at _witness_debugger+0x1e witness_checkorder(c6c820dc,9,c0c658b9,8af,0,...) at witness_checkorder +0x818 __lockmgr_args(c6c820dc,80900,c5c295b0,0,0,...) at __lockmgr_args+0x75e ffs_copyonwrite(c5c2953c,d979ea40,d979ea40,4,0,...) at ffs_copyonwrite +0x2b2 ffs_geom_strategy(c5c295e4,d979ea40,375,d979ea40,2800,...) at ffs_geom_strategy+0xd4 bufwrite(d979ea40,0,c0c6721e,725,c0c6721e) at bufwrite+0x14b ffs_bufwrite(d979ea40,c5b28800,e63f0ba8,c0a7ff00,d979ea40,...) at ffs_bufwrite+0x273 bawrite(d979ea40,d9cd0000,2800,2800,0,...) at bawrite+0x56 ffs_sbupdate(c5b8de00,3,0,556,df,...) at ffs_sbupdate+0x156 ffs_sync(c5c36508,3,c0c4e260,d68,c5c36508,...) at ffs_sync+0x528 sync_fsync(e63f0c7c,c5c33a78,80400,c0c4e260,69e,...) at sync_fsync+0x18e VOP_FSYNC_APV(c0d3b8c0,e63f0c7c,c0c4e260,69e,c5b6eb40,...) at VOP_FSYNC_APV+0xdf sync_vnode(c0f19eb0,c0f19e9c,64,6cd,4e20,...) at sync_vnode+0x15d sched_sync(0,e63f0d38,c0c3c659,334,c5b67d48,...) at sched_sync+0x26f fork_exit(c08f2541,0,e63f0d38) at fork_exit+0xb8 fork_trampoline() at fork_trampoline+0x8 --- trap 0, eip = 0, esp = 0xe63f0d70, ebp = 0 --- lock order reversal: 1st 0xc6c820dc snaplk (snaplk) @ /usr/src/sys/kern/vfs_vnops.c:295 2nd 0xc6c567ac ufs (ufs) @ /usr/src/sys/ufs/ffs/ffs_snapshot.c:1587 KDB: stack backtrace: db_trace_self_wrapper(c0c44382,e86228b4,c08a7a6f,c0899476,c0c471c5,...) at db_trace_self_wrapper+0x26 kdb_backtrace(c0899476,c0c471c5,c5530e30,c5530470,e8622910,...) at kdb_backtrace+0x29 _witness_debugger(c0c471c5,c6c567ac,c0c39e3a,c5530470,c0c658b9,...) at _witness_debugger+0x1e witness_checkorder(c6c567ac,9,c0c658b9,633,0,...) at witness_checkorder +0x818 __lockmgr_args(c6c567ac,80000,0,0,0,...) at __lockmgr_args+0x75e ffs_snapremove(c6c56754,c5c36508,0,c0c4f429,41c,...) at ffs_snapremove +0x11a softdep_releasefile(c6c2fb54,e8622a90,2,c0eec980,c5b6a0a4,...) at softdep_releasefile+0x39 ufs_inactive(e8622ae0,c0c3f7ac,df,c0c4e260,127,...) at ufs_inactive +0x1bc VOP_INACTIVE_APV(c0d5b5c0,e8622ae0,c0c4e260,925,c0d75840,...) at VOP_INACTIVE_APV+0xdf vinactive(c0d5b5c0,e8622b14,c0c4e260,8ab,c0b81184,...) at vinactive+0x82 vput(c6c56754,e8622b50,c0c4f429,127,0,...) at vput+0x1c0 vn_close(c6c56754,1,c5568900,c5b6a000,0,...) at vn_close+0x196 vn_closefile(c6b9aa80,c5b6a000,e8622c18,0,c6b9aa80,...) at vn_closefile +0xda _fdrop(c6b9aa80,c5b6a000,c0eec970,c5b6a0a4,0,c0d32900,c0c3bb75,c6c1422c,45b,c 0c3bb75,e8622c44,c0870c45,c6c1422c,8,c0c3bb75,45b,4,c6c142b4) at _fdrop +0x45 closef(c6b9aa80,c5b6a000,45b,440,c6c1422c,...) at closef+0x27d kern_close(c5b6a000,4,e8622d2c,c0b74158,c5b6a000,...) at kern_close +0x10d close(c5b6a000,e8622cf8,4,c0c47f72,c0d286e8,...) at close+0x1a syscall(e8622d38) at syscall+0x2b4 Xint0x80_syscall() at Xint0x80_syscall+0x20 --- syscall (6, FreeBSD ELF32, close), eip = 0x33d874eb, esp = 0xbfbfeadc, ebp = 0xbfbfee28 --- mount option is unknown lock order reversal: 1st 0xc60af72c filedesc structure (filedesc structure) @ /usr/src/sys/kern/kern_descrip.c:1088 2nd 0xc68106a0 ufs (ufs) @ /usr/src/sys/kern/vfs_subr.c:4092 KDB: stack backtrace: db_trace_self_wrapper(c0c44382,e85e5a2c,c08a7a6f,c0899476,c0c471c5,...) at db_trace_self_wrapper+0x26 kdb_backtrace(c0899476,c0c471c5,c552c098,c5530470,e85e5a88,...) at kdb_backtrace+0x29 _witness_debugger(c0c471c5,c68106a0,c0c39e3a,c5530470,c0c4e260,...) at _witness_debugger+0x1e witness_checkorder(c68106a0,9,c0c4e260,ffc,c68106bc,...) at witness_checkorder+0x818 __lockmgr_args(c68106a0,80400,c68106bc,0,0,...) at __lockmgr_args+0x75e ffs_lock(e85e5b9c,c5529318,c552c098,c,0,...) at ffs_lock+0x7d VOP_LOCK1_APV(c0d5b5c0,e85e5b9c,e85e5bb0,c0d75a40,c6810648,...) at VOP_LOCK1_APV+0xeb _vn_lock(c6810648,80400,c0c4e260,ffc,e85e5bf8,...) at _vn_lock+0x5e vfs_knllock(c6810648,0,c0c3c053,68a,c6b7ebf4,...) at vfs_knllock+0x29 knlist_remove_kq(0,e85e5c18,c08edbb5,c6b8697c,c6b7ebf4,...) at knlist_remove_kq+0x85 knlist_remove(c6b8697c,c6b7ebf4,0,e85e5c44,c0839753,...) at knlist_remove+0x1b filt_vfsdetach(c6b7ebf4,0,c0c3c053,76b,1e,...) at filt_vfsdetach+0x39 knote_fdclose(c5b6e480,129e,c0c3bb75,440,c60af72c,...) at knote_fdclose +0xec kern_close(c5b6e480,129e,e85e5d2c,c0b74158,c5b6e480,...) at kern_close +0xc8 close(c5b6e480,e85e5cf8,4,c0c47a40,c0d286e8,...) at close+0x1a syscall(e85e5d38) at syscall+0x2b4 Xint0x80_syscall() at Xint0x80_syscall+0x20 --- syscall (6, FreeBSD ELF32, close), eip = 0x33f6a4eb, esp = 0xbfbfe6fc, ebp = 0xbfbfe718 --- dmesg for machine: # dmesg Copyright (c) 1992-2009 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 is a registered trademark of The FreeBSD Foundation. FreeBSD 8.0-CURRENT #0: Sat Jun 20 15:51:37 PDT 2009 root@microtetonics:/usr/obj/usr/src/sys/microtetonics WARNING: WITNESS option enabled, expect reduced performance. Timecounter "i8254" frequency 1193182 Hz quality 0 CPU: Intel(R) Atom(TM) CPU N280 @ 1.66GHz (1662.52-MHz 686-class CPU) Origin = "GenuineIntel" Id = 0x106c2 Stepping = 2 Features=0xbfe9fbff Features2=0x40c39d> AMD Features=0x100000 AMD Features2=0x1 TSC: P-state invariant real memory = 2147483648 (2048 MB) avail memory = 2077466624 (1981 MB) ACPI APIC Table: FreeBSD/SMP: Multiprocessor System Detected: 2 CPUs FreeBSD/SMP: 1 package(s) x 1 core(s) x 2 HTT threads cpu0 (BSP): APIC ID: 0 cpu1 (AP/HT): APIC ID: 1 This module (opensolaris) contains code covered by the Common Development and Distribution License (CDDL) see http://opensolaris.org/os/licensing/opensolaris_license/ ioapic0: Changing APIC ID to 2 ioapic0 irqs 0-23 on motherboard kbd1 at kbdmux0 acpi0: on motherboard acpi0: [ITHREAD] acpi0: Power Button (fixed) acpi0: reservation of 0, a0000 (3) failed acpi0: reservation of 100000, 7f700000 (3) failed Timecounter "ACPI-fast" frequency 3579545 Hz quality 1000 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x808-0x80b on acpi0 acpi_ec0: port 0x62,0x66 on acpi0 acpi_hpet0: iomem 0xfed00000-0xfed003ff on acpi0 Timecounter "HPET" frequency 14318180 Hz quality 900 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 vgapci0: port 0xdc00-0xdc07 mem 0xf7f00000-0xf7f7ffff,0xd0000000-0xdfffffff,0xf7ec0000-0xf7efffff irq 16 at device 2.0 on pci0 agp0: on vgapci0 agp0: detected 7932k stolen memory agp0: aperture size is 256M vgapci1: mem 0xf7f80000-0xf7ffffff at device 2.1 on pci0 hdac0: mem 0xf7eb8000-0xf7ebbfff irq 16 at device 27.0 on pci0 hdac0: HDA Driver Revision: 20090614_0135 hdac0: [ITHREAD] pcib1: irq 16 at device 28.0 on pci0 pci4: on pcib1 pcib2: irq 17 at device 28.1 on pci0 pci3: on pcib2 ale0: port 0xec00-0xec7f mem 0xfbfc0000-0xfbffffff irq 17 at device 0.0 on pci3 ale0: 960 Tx FIFO, 1024 Rx FIFO ale0: Using 1 MSI messages. miibus0: on ale0 atphy0: PHY 0 on miibus0 atphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT-FDX, auto ale0: Ethernet address: 00:24:8c:6e:54:9a ale0: [FILTER] pcib3: irq 19 at device 28.3 on pci0 pci1: on pcib3 ath0: mem 0xfbef0000-0xfbefffff irq 19 at device 0.0 on pci1 ath0: [ITHREAD] ath0: AR9280 mac 128.2 RF5133 phy 13.0 uhci0: port 0xd400-0xd41f irq 23 at device 29.0 on pci0 uhci0: [ITHREAD] uhci0: LegSup = 0x0f30 usbus0: on uhci0 uhci1: port 0xd480-0xd49f irq 19 at device 29.1 on pci0 uhci1: [ITHREAD] uhci1: LegSup = 0x0f30 usbus1: on uhci1 uhci2: port 0xd800-0xd81f irq 18 at device 29.2 on pci0 uhci2: [ITHREAD] uhci2: LegSup = 0x0f30 usbus2: on uhci2 uhci3: port 0xd880-0xd89f irq 16 at device 29.3 on pci0 uhci3: [ITHREAD] uhci3: LegSup = 0x0f30 usbus3: on uhci3 ehci0: mem 0xf7eb7c00-0xf7eb7fff irq 23 at device 29.7 on pci0 ehci0: [ITHREAD] usbus4: EHCI version 1.0 usbus4: on ehci0 pcib4: at device 30.0 on pci0 pci5: on pcib4 isab0: at device 31.0 on pci0 isa0: on isab0 atapci0: port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xffa0-0xffaf at device 31.2 on pci0 ata0: on atapci0 ata0: [ITHREAD] ata1: on atapci0 ata1: [ITHREAD] acpi_asus0: on acpi0 acpi_lid0: on acpi0 acpi_button0: on acpi0 acpi_button1: on acpi0 acpi_tz0: on acpi0 battery0: on acpi0 acpi_acad0: on acpi0 atrtc0: port 0x70-0x71 irq 8 on acpi0 atkbdc0: port 0x60,0x64 irq 1 on acpi0 atkbd0: irq 1 on atkbdc0 kbd0 at atkbd0 atkbd0: [GIANT-LOCKED] atkbd0: [ITHREAD] psm0: irq 12 on atkbdc0 psm0: [GIANT-LOCKED] psm0: [ITHREAD] psm0: model IntelliMouse, device ID 3 cpu0: on acpi0 est0: on cpu0 p4tcc0: on cpu0 cpu1: on acpi0 est1: on cpu1 p4tcc1: on cpu1 pmtimer0 on isa0 sc0: at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=0x300> vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 ppc0: parallel port not found. Timecounters tick every 10.000 msec usbus0: 12Mbps Full Speed USB v1.0 usbus1: 12Mbps Full Speed USB v1.0 usbus2: 12Mbps Full Speed USB v1.0 usbus3: 12Mbps Full Speed USB v1.0 usbus4: 480Mbps High Speed USB v2.0 ad0: 152627MB at ata0-master SATA150 ugen0.1: at usbus0 uhub0: on usbus0 ugen1.1: at usbus1 uhub1: on usbus1 ugen2.1: at usbus2 uhub2: on usbus2 ugen3.1: at usbus3 uhub3: on usbus3 ugen4.1: at usbus4 uhub4: on usbus4 uhub0: 2 ports with 2 removable, self powered uhub1: 2 ports with 2 removable, self powered hdac0: HDA Codec #0: Realtek ALC269 pcm0: at cad 0 nid 1 on hdac0 pcm1: at cad 0 nid 1 on hdac0 SMP: AP CPU #1 Launched! WARNING: WITNESS option enabled, expect reduced performance. uhub3: 2 ports with 2 removable, self powered uhub2: 2 ports with 2 removable, self powered GEOM: ad0s1: geometry does not match label (255h,63s != 16h,63s). Root mount waiting for: usbus4 Root mount waiting for: usbus4 uhub4: 8 ports with 8 removable, self powered Root mount waiting for: usbus4 ugen4.2: at usbus4 uhub5: on usbus4 Root mount waiting for: usbus4 uhub5: 4 ports with 4 removable, self powered Root mount waiting for: usbus4 Root mount waiting for: usbus4 ugen4.3: at usbus4 Trying to mount root from ufs:/dev/ad0s1a ugen3.2: at usbus3 WARNING: /tmp was not properly dismounted WARNING: /usr was not properly dismounted WARNING: /usr/src was not properly dismounted WARNING: /var was not properly dismounted WARNING: TMPFS is considered to be a highly experimental feature in FreeBSD. wlan0: Ethernet address: 00:22:43:91:5f:b9 drm0: on vgapci0 vgapci0: child drm0 requested pci_enable_busmaster info: [drm] AGP at 0xd0000000 256MB info: [drm] Initialized i915 1.6.0 20080730 drm0: [ITHREAD]