Most recent kernel where this bug did not occur: Anyone around 2.6.22.x Distribution: Debian Sid Hardware Environment: 32 bit System Software Environment: ext3 filesystem Problem Description: I've got a file on my harddisk, which I can't move, delete or change their rights. Then I looked into my dmesg and found this entrys: WARNING: at fs/inotify.c:172 set_dentry_child_flags() [<c0182b9c>] set_dentry_child_flags+0x10c/0x1a0 [<c0182c80>] remove_watch_no_event+0x50/0x60 [<c0182d98>] inotify_remove_watch_locked+0x18/0x50 [<c0182f1c>] inotify_rm_wd+0x6c/0xb0 [<c01836a8>] sys_inotify_rm_watch+0x38/0x60 [<c01029da>] syscall_call+0x7/0xb ======================= WARNING: at fs/inotify.c:172 set_dentry_child_flags() [<c0182b9c>] set_dentry_child_flags+0x10c/0x1a0 [<c018330e>] inotify_add_watch+0xfe/0x110 [<c0183e61>] sys_inotify_add_watch+0x151/0x180 [<c015d5de>] sys_stat64+0x1e/0x30 [<c01541ed>] shmem_lock+0x6d/0x80 [<c01029da>] syscall_call+0x7/0xb ======================= This is the file: the-me:~# ls -l /var/lib/dpkg/info/bc.list -rw-r--r-- 1 root root 511 2006-10-08 11:15 /var/lib/dpkg/info/bc.list the-me:~# LC_ALL=en_GB chmod u+x /var/lib/dpkg/info/bc.list chmod: changing permissions of `/var/lib/dpkg/info/bc.list': Operation not permitted the-me:~# LC_ALL=en_GB stat /var/lib/dpkg/info/bc.list File: `/var/lib/dpkg/info/bc.list' Size: 511 Blocks: 8 IO Block: 4096 regular file Device: 301h/769d Inode: 4243830 Links: 1 Access: (0644/-rw-r--r--) Uid: ( 0/ root) Gid: ( 0/ root) Access: 2007-08-25 16:28:13.000000000 +0200 Modify: 2006-10-08 11:15:29.000000000 +0200 Change: 2006-10-08 11:15:29.000000000 +0200 the-me:~# LC_ALL=en_GB cat /var/lib/dpkg/info/bc.list /. /usr /usr/bin /usr/bin/bc /usr/share /usr/share/doc /usr/share/doc/bc /usr/share/doc/bc/README /usr/share/doc/bc/AUTHORS /usr/share/doc/bc/copyright /usr/share/doc/bc/examples /usr/share/doc/bc/examples/ckbook.b /usr/share/doc/bc/examples/pi.b /usr/share/doc/bc/examples/primes.b /usr/share/doc/bc/examples/twins.b /usr/share/doc/bc/changelog.gz /usr/share/doc/bc/NEWS.gz /usr/share/doc/bc/changelog.Debian.gz /usr/share/menu /usr/share/menu/bc /usr/share/man /usr/share/man/man1 /usr/share/man/man1/bc.1.gz
Created attachment 12529 [details] And here's my kernel config :)
Oh I'm sorry. This file has got chattr permissions... I have no idea, why, because I never used it. So I can now remove /move etc the file, but this error at dmesg is a real problem :)
Interesting. We've beenchasing this for years. Does it still happen after a reboot? Please don't lose that filesystem! We've never been able to repeat it before.
I think the problem is now, that I don't know how to reproduce this bug, I never saw this before. Maybe any tips?
There is a patch in bug #7785 (attachment id=12196) which I would like you to try. It is not a final patch, but it might give us a lead. Let me know if you have any trouble, and importantly, what result you get in the end! Thanks for reporting.
First we had to find out, how I can reproduce it. I only have ext3 filesystems and a brand new crypted container with truecrypt. Here's my normal dmesg: Linux version 2.6.22.5 (root@the-me) (gcc version 4.2.1 (Debian 4.2.1-3)) #1 PREEMPT Thu Aug 23 14:32:21 CEST 2007 BIOS-provided physical RAM map: BIOS-e820: 0000000000000000 - 000000000009f400 (usable) BIOS-e820: 000000000009f400 - 00000000000a0000 (reserved) BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved) BIOS-e820: 0000000000100000 - 000000003fff0000 (usable) BIOS-e820: 000000003fff0000 - 000000003fff3000 (ACPI NVS) BIOS-e820: 000000003fff3000 - 0000000040000000 (ACPI data) BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved) BIOS-e820: 00000000fec00000 - 0000000100000000 (reserved) 127MB HIGHMEM available. 896MB LOWMEM available. Entering add_active_range(0, 0, 262128) 0 entries of 256 used Zone PFN ranges: DMA 0 -> 4096 Normal 4096 -> 229376 HighMem 229376 -> 262128 early_node_map[1] active PFN ranges 0: 0 -> 262128 On node 0 totalpages: 262128 DMA zone: 32 pages used for memmap DMA zone: 0 pages reserved DMA zone: 4064 pages, LIFO batch:0 Normal zone: 1760 pages used for memmap Normal zone: 223520 pages, LIFO batch:31 HighMem zone: 255 pages used for memmap HighMem zone: 32497 pages, LIFO batch:7 DMI 2.3 present. ACPI: RSDP 000F9260, 0014 (r0 Nvidia) ACPI: RSDT 3FFF3040, 0034 (r1 Nvidia AWRDACPI 42302E31 AWRD 0) ACPI: FACP 3FFF30C0, 0074 (r1 Nvidia AWRDACPI 42302E31 AWRD 0) ACPI: DSDT 3FFF3180, 63C4 (r1 NVIDIA AWRDACPI 1000 MSFT 100000E) ACPI: FACS 3FFF0000, 0040 ACPI: SSDT 3FFF9680, 0118 (r1 PTLTD POWERNOW 1 LTP 1) ACPI: MCFG 3FFF9800, 003C (r1 Nvidia AWRDACPI 42302E31 AWRD 0) ACPI: APIC 3FFF95C0, 0072 (r1 Nvidia AWRDACPI 42302E31 AWRD 0) ACPI: PM-Timer IO Port: 0x4008 Allocating PCI resources starting at 50000000 (gap: 40000000:a0000000) Built 1 zonelists. Total pages: 260081 Kernel command line: root=/dev/hda1 ro Enabling fast FPU save and restore... done. Enabling unmasked SIMD FPU exception support... done. Initializing CPU#0 PID hash table entries: 4096 (order: 12, 16384 bytes) Detected 2412.368 MHz processor. spurious 8259A interrupt: IRQ7. Console: colour VGA+ 80x25 Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) Memory: 1034236k/1048512k available (1460k kernel code, 13468k reserved, 470k data, 164k init, 131008k highmem) virtual kernel memory layout: fixmap : 0xfffeb000 - 0xfffff000 ( 80 kB) pkmap : 0xff800000 - 0xffc00000 (4096 kB) vmalloc : 0xf8800000 - 0xff7fe000 ( 111 MB) lowmem : 0xc0000000 - 0xf8000000 ( 896 MB) .init : 0xc02e6000 - 0xc030f000 ( 164 kB) .data : 0xc026d277 - 0xc02e2cec ( 470 kB) .text : 0xc0100000 - 0xc026d277 (1460 kB) Checking if this processor honours the WP bit even in supervisor mode... Ok. SLUB: Genslabs=22, HWalign=64, Order=0-1, MinObjects=4, CPUs=1, Nodes=1 Calibrating delay using timer specific routine.. 4827.67 BogoMIPS (lpj=9655350) Mount-cache hash table entries: 512 CPU: After generic identify, caps: 078bfbff e3d3fbff 00000000 00000000 00000001 00000000 00000001 CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line) CPU: L2 Cache: 1024K (64 bytes/line) CPU: After all inits, caps: 078bfbff e3d3fbff 00000000 00000410 00000001 00000000 00000001 Compat vDSO mapped to ffffe000. CPU: AMD Athlon(tm) 64 Processor 4000+ stepping 02 Checking 'hlt' instruction... OK. ACPI: Core revision 20070126 ACPI: setting ELCR to 0200 (from 0cb8) NET: Registered protocol family 16 ACPI: bus type pci registered PCI: Using MMCONFIG PCI: No mmconfig possible on device 00:18 Setting up standard PCI resources ACPI: Interpreter enabled ACPI: Using PIC for interrupt routing ACPI: PCI Root Bridge [PCI0] (0000:00) PCI: Probing PCI hardware (bus 00) PCI: Transparent bridge - 0000:00:09.0 ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.HUB0._PRT] ACPI: PCI Interrupt Link [LNK1] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. ACPI: PCI Interrupt Link [LNK2] (IRQs 3 4 5 7 9 *10 11 12 14 15) ACPI: PCI Interrupt Link [LNK3] (IRQs 3 4 *5 7 9 10 11 12 14 15) ACPI: PCI Interrupt Link [LNK4] (IRQs 3 *4 5 7 9 10 11 12 14 15) ACPI: PCI Interrupt Link [LNK5] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. ACPI: PCI Interrupt Link [LUBA] (IRQs 3 4 5 7 9 *10 11 12 14 15) ACPI: PCI Interrupt Link [LUBB] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. ACPI: PCI Interrupt Link [LMAC] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. ACPI: PCI Interrupt Link [LACI] (IRQs 3 4 5 *7 9 10 11 12 14 15) ACPI: PCI Interrupt Link [LMCI] (IRQs *3 4 5 7 9 10 11 12 14 15) ACPI: PCI Interrupt Link [LSMB] (IRQs 3 4 *5 7 9 10 11 12 14 15) ACPI: PCI Interrupt Link [LUB2] (IRQs 3 4 5 7 9 10 *11 12 14 15) ACPI: PCI Interrupt Link [LIDE] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. ACPI: PCI Interrupt Link [LSID] (IRQs 3 4 5 7 9 10 *11 12 14 15) ACPI: PCI Interrupt Link [LFID] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. ACPI: PCI Interrupt Link [LPCA] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. ACPI: PCI Interrupt Link [APC1] (IRQs 16) *0, disabled. ACPI: PCI Interrupt Link [APC2] (IRQs 17) *0, disabled. ACPI: PCI Interrupt Link [APC3] (IRQs 18) *0, disabled. ACPI: PCI Interrupt Link [APC4] (IRQs 19) *0, disabled. ACPI: PCI Interrupt Link [APC5] (IRQs *16), disabled. ACPI: PCI Interrupt Link [APCF] (IRQs 20 21 22 23) *0, disabled. ACPI: PCI Interrupt Link [APCG] (IRQs 20 21 22 23) *0, disabled. ACPI: PCI Interrupt Link [APCH] (IRQs 20 21 22 23) *0, disabled. ACPI: PCI Interrupt Link [APCJ] (IRQs 20 21 22 23) *0, disabled. ACPI: PCI Interrupt Link [APCK] (IRQs 20 21 22 23) *0, disabled. ACPI: PCI Interrupt Link [APCS] (IRQs 20 21 22 23) *0, disabled. ACPI: PCI Interrupt Link [APCL] (IRQs 20 21 22 23) *0, disabled. ACPI: PCI Interrupt Link [APCZ] (IRQs 20 21 22 23) *0, disabled. ACPI: PCI Interrupt Link [APSI] (IRQs 20 21 22 23) *0, disabled. ACPI: PCI Interrupt Link [APSJ] (IRQs 20 21 22 23) *0, disabled. ACPI: PCI Interrupt Link [APCP] (IRQs 20 21 22 23) *0, disabled. Linux Plug and Play Support v0.97 (c) Adam Belay pnp: PnP ACPI init ACPI: bus type pnp registered pnp: PnP ACPI: found 10 devices ACPI: ACPI bus type pnp unregistered PCI: Using ACPI for IRQ routing PCI: If a device doesn't work, try "pci=routeirq". If it helps, post a report pnp: 00:01: ioport range 0x4000-0x407f has been reserved pnp: 00:01: ioport range 0x4080-0x40ff has been reserved pnp: 00:01: ioport range 0x4400-0x447f has been reserved pnp: 00:01: ioport range 0x4480-0x44ff has been reserved pnp: 00:01: ioport range 0x4800-0x487f has been reserved pnp: 00:01: ioport range 0x4880-0x48ff has been reserved pnp: 00:08: iomem range 0xe0000000-0xefffffff could not be reserved pnp: 00:09: iomem range 0xf0000-0xf3fff could not be reserved pnp: 00:09: iomem range 0xf4000-0xf7fff could not be reserved pnp: 00:09: iomem range 0xf8000-0xfbfff could not be reserved pnp: 00:09: iomem range 0xfc000-0xfffff could not be reserved Time: tsc clocksource has been installed. PCI: Bridge: 0000:00:09.0 IO window: b000-bfff MEM window: fdf00000-fdffffff PREFETCH window: fde00000-fdefffff PCI: Bridge: 0000:00:0b.0 IO window: a000-afff MEM window: fdd00000-fddfffff PREFETCH window: fdc00000-fdcfffff PCI: Bridge: 0000:00:0c.0 IO window: 9000-9fff MEM window: fdb00000-fdbfffff PREFETCH window: fda00000-fdafffff PCI: Bridge: 0000:00:0d.0 IO window: 8000-8fff MEM window: fd900000-fd9fffff PREFETCH window: fd800000-fd8fffff PCI: Bridge: 0000:00:0e.0 IO window: 7000-7fff MEM window: fd700000-fd7fffff PREFETCH window: d0000000-dfffffff PCI: Setting latency timer of device 0000:00:09.0 to 64 PCI: Setting latency timer of device 0000:00:0b.0 to 64 PCI: Setting latency timer of device 0000:00:0c.0 to 64 PCI: Setting latency timer of device 0000:00:0d.0 to 64 PCI: Setting latency timer of device 0000:00:0e.0 to 64 NET: Registered protocol family 2 IP route cache hash table entries: 32768 (order: 5, 131072 bytes) TCP established hash table entries: 131072 (order: 8, 1048576 bytes) TCP bind hash table entries: 65536 (order: 6, 262144 bytes) TCP: Hash tables configured (established 131072 bind 65536) TCP reno registered checking if image is initramfs... it is Freeing initrd memory: 2143k freed highmem bounce pool size: 64 pages io scheduler noop registered io scheduler cfq registered (default) PCI: Linking AER extended capability on 0000:00:0b.0 PCI: Linking AER extended capability on 0000:00:0c.0 PCI: Linking AER extended capability on 0000:00:0d.0 PCI: Linking AER extended capability on 0000:00:0e.0 Boot video device is 0000:05:00.0 PCI: Setting latency timer of device 0000:00:0b.0 to 64 assign_interrupt_mode Found MSI capability Allocate Port Service[0000:00:0b.0:pcie00] Allocate Port Service[0000:00:0b.0:pcie03] PCI: Setting latency timer of device 0000:00:0c.0 to 64 assign_interrupt_mode Found MSI capability Allocate Port Service[0000:00:0c.0:pcie00] Allocate Port Service[0000:00:0c.0:pcie03] PCI: Setting latency timer of device 0000:00:0d.0 to 64 assign_interrupt_mode Found MSI capability Allocate Port Service[0000:00:0d.0:pcie00] Allocate Port Service[0000:00:0d.0:pcie03] PCI: Setting latency timer of device 0000:00:0e.0 to 64 assign_interrupt_mode Found MSI capability Allocate Port Service[0000:00:0e.0:pcie00] Allocate Port Service[0000:00:0e.0:pcie03] RAMDISK driver initialized: 2 RAM disks of 8192K size 1024 blocksize PNP: PS/2 Controller [PNP0303:PS2K] at 0x60,0x64 irq 1 PNP: PS/2 controller doesn't have AUX irq; using default 12 serio: i8042 KBD port at 0x60,0x64 irq 1 serio: i8042 AUX port at 0x60,0x64 irq 12 mice: PS/2 mouse device common for all mice device-mapper: ioctl: 4.11.0-ioctl (2006-10-12) initialised: dm-devel@redhat.com TCP cubic registered NET: Registered protocol family 1 NET: Registered protocol family 17 powernow-k8: Found 1 AMD Athlon(tm) 64 Processor 4000+ processors (version 2.00.00) powernow-k8: 0 : fid 0x10 (2400 MHz), vid 0x8 powernow-k8: 1 : fid 0xe (2200 MHz), vid 0x8 powernow-k8: 2 : fid 0xc (2000 MHz), vid 0xa powernow-k8: 3 : fid 0xa (1800 MHz), vid 0xc powernow-k8: 4 : fid 0x2 (1000 MHz), vid 0x12 powernow-k8: ph2 null fid transition 0x10 Using IPI Shortcut mode Freeing unused kernel memory: 164k freed input: AT Translated Set 2 keyboard as /class/input/input0 ACPI: Fan [FAN] (on) ACPI: Thermal Zone [THRM] (22 C) usbcore: registered new interface driver usbfs usbcore: registered new interface driver hub usbcore: registered new device driver usb ohci_hcd: 2006 August 04 USB 1.1 'Open' Host Controller (OHCI) Driver ACPI: PCI Interrupt Link [LUBA] enabled at IRQ 10 PCI: setting IRQ 10 as level-triggered ACPI: PCI Interrupt 0000:00:02.0[A] -> Link [LUBA] -> GSI 10 (level, low) -> IRQ 10 PCI: Setting latency timer of device 0000:00:02.0 to 64 ohci_hcd 0000:00:02.0: OHCI Host Controller ohci_hcd 0000:00:02.0: new USB bus registered, assigned bus number 1 ohci_hcd 0000:00:02.0: irq 10, io mem 0xfe02f000 Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2 ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx 8139too Fast Ethernet driver 0.9.28 usb usb1: configuration #1 chosen from 1 choice hub 1-0:1.0: USB hub found hub 1-0:1.0: 10 ports detected NFORCE-CK804: IDE controller at PCI slot 0000:00:06.0 NFORCE-CK804: chipset revision 242 NFORCE-CK804: not 100% native mode: will probe irqs later NFORCE-CK804: 0000:00:06.0 (rev f2) UDMA133 controller ide0: BM-DMA at 0xe000-0xe007, BIOS settings: hda:DMA, hdb:DMA ide1: BM-DMA at 0xe008-0xe00f, BIOS settings: hdc:DMA, hdd:DMA Probing IDE interface ide0... Switched to NOHz mode on CPU #0 hda: Maxtor 6E040L0, ATA DISK drive usb 1-2: new low speed USB device using ohci_hcd and address 2 usb 1-2: configuration #1 chosen from 1 choice hdb: Maxtor 6L250R0, ATA DISK drive ide0 at 0x1f0-0x1f7,0x3f6 on irq 14 Probing IDE interface ide1... usb 1-8: new low speed USB device using ohci_hcd and address 3 usb 1-8: configuration #1 chosen from 1 choice input: Logitech Logitech(R) Precision(TM) Gamepad as /class/input/input1 input: USB HID v1.10 Joystick [Logitech Logitech(R) Precision(TM) Gamepad] on usb-0000:00:02.0-2 input: Logitech USB-PS/2 Optical Mouse as /class/input/input2 input: USB HID v1.10 Mouse [Logitech USB-PS/2 Optical Mouse] on usb-0000:00:02.0-8 usbcore: registered new interface driver usbhid drivers/hid/usbhid/hid-core.c: v2.6:USB HID core driver hdc: HL-DT-ST DVDRAM GSA-4163B, ATAPI CD/DVD-ROM drive hdd: SONY CD-RW CRX210E1, ATAPI CD/DVD-ROM drive ide1 at 0x170-0x177,0x376 on irq 15 ACPI: PCI Interrupt Link [LUB2] enabled at IRQ 11 PCI: setting IRQ 11 as level-triggered ACPI: PCI Interrupt 0000:00:02.1[B] -> Link [LUB2] -> GSI 11 (level, low) -> IRQ 11 PCI: Setting latency timer of device 0000:00:02.1 to 64 ehci_hcd 0000:00:02.1: EHCI Host Controller ehci_hcd 0000:00:02.1: new USB bus registered, assigned bus number 2 ehci_hcd 0000:00:02.1: debug port 1 PCI: cache line size of 64 is not supported by device 0000:00:02.1 ehci_hcd 0000:00:02.1: irq 11, io mem 0xfeb00000 ehci_hcd 0000:00:02.1: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004 usb 1-2: USB disconnect, address 2 usb usb2: configuration #1 chosen from 1 choice hub 2-0:1.0: USB hub found hub 2-0:1.0: 10 ports detected SCSI subsystem initialized libata version 2.21 loaded. sata_nv 0000:00:07.0: version 3.4 ACPI: PCI Interrupt Link [LSID] enabled at IRQ 11 ACPI: PCI Interrupt 0000:00:07.0[A] -> Link [LSID] -> GSI 11 (level, low) -> IRQ 11 sata_nv 0000:00:07.0: Using ADMA mode PCI: Setting latency timer of device 0000:00:07.0 to 64 scsi0 : sata_nv scsi1 : sata_nv ata1: SATA max UDMA/133 cmd 0xf881c480 ctl 0xf881c4a0 bmdma 0x0001cc00 irq 11 ata2: SATA max UDMA/133 cmd 0xf881c580 ctl 0xf881c5a0 bmdma 0x0001cc08 irq 11 hda: max request size: 128KiB usb 1-8: USB disconnect, address 3 hda: 80293248 sectors (41110 MB) w/2048KiB Cache, CHS=65535/16/63, UDMA(133) hda: cache flushes supported hda: hda1 hda2 < hda5 > hdb: max request size: 512KiB hdb: 490234752 sectors (251000 MB) w/16384KiB Cache, CHS=30515/255/63, UDMA(133) hdb: cache flushes supported hdb: hdb1 hdc: ATAPI 40X DVD-ROM DVD-R-RAM CD-R/RW drive, 2048kB Cache, UDMA(33) Uniform CD-ROM driver Revision: 3.20 hdd: ATAPI 40X CD-ROM CD-R/RW drive, 2048kB Cache, UDMA(33) ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) ata1.00: ATA-7: MAXTOR STM3250820AS, 3.AAE, max UDMA/133 ata1.00: 488397168 sectors, multi 16: LBA48 NCQ (depth 31/32) ata1.00: configured for UDMA/133 usb 1-2: new low speed USB device using ohci_hcd and address 4 ata2: SATA link down (SStatus 0 SControl 300) scsi 0:0:0:0: Direct-Access ATA MAXTOR STM325082 3.AA PQ: 0 ANSI: 5 ata1: bounce limit 0xFFFFFFFFFFFFFFFF, segment boundary 0xFFFFFFFF, hw segs 61 ACPI: PCI Interrupt Link [LNK2] enabled at IRQ 10 ACPI: PCI Interrupt 0000:01:07.0[A] -> Link [LNK2] -> GSI 10 (level, low) -> IRQ 10 eth0: RealTek RTL8139 at 0xf8816000, 00:02:2a:df:47:10, IRQ 10 eth0: Identified 8139 chip type 'RTL-8100B/8139D' ACPI: PCI Interrupt Link [LNK4] enabled at IRQ 4 PCI: setting IRQ 4 as level-triggered ACPI: PCI Interrupt 0000:01:09.0[A] -> Link [LNK4] -> GSI 4 (level, low) -> IRQ 4 PCI: Setting latency timer of device 0000:01:09.0 to 64 ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[4] MMIO=[fdffe000-fdffe7ff] Max Packet=[2048] IR/IT contexts=[4/8] sd 0:0:0:0: [sda] 488397168 512-byte hardware sectors (250059 MB) sd 0:0:0:0: [sda] Write Protect is off sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA sd 0:0:0:0: [sda] 488397168 512-byte hardware sectors (250059 MB) sd 0:0:0:0: [sda] Write Protect is off sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA sda: sda1 sd 0:0:0:0: [sda] Attached SCSI disk usb 1-2: configuration #1 chosen from 1 choice input: Logitech Logitech(R) Precision(TM) Gamepad as /class/input/input3 input: USB HID v1.10 Joystick [Logitech Logitech(R) Precision(TM) Gamepad] on usb-0000:00:02.0-2 kjournald starting. Commit interval 5 seconds EXT3-fs: mounted filesystem with ordered data mode. usb 1-8: new low speed USB device using ohci_hcd and address 5 usb 1-8: configuration #1 chosen from 1 choice input: Logitech USB-PS/2 Optical Mouse as /class/input/input4 input: USB HID v1.10 Mouse [Logitech USB-PS/2 Optical Mouse] on usb-0000:00:02.0-8 ieee1394: Host added: ID:BUS[0-00:1023] GUID[000108002000f7f3] Real Time Clock Driver v1.12ac i2c-adapter i2c-0: nForce2 SMBus adapter at 0x4c00 i2c-adapter i2c-1: nForce2 SMBus adapter at 0x4c40 ACPI: PCI Interrupt Link [LNK3] enabled at IRQ 5 PCI: setting IRQ 5 as level-triggered ACPI: PCI Interrupt 0000:01:08.0[A] -> Link [LNK3] -> GSI 5 (level, low) -> IRQ 5 PCI: Setting latency timer of device 0000:01:08.0 to 64 Adding 1662688k swap on /dev/hda5. Priority:-1 extents:1 across:1662688k EXT3 FS on hda1, internal journal w83627ehf: unsupported chip ID: 0xffff kjournald starting. Commit interval 5 seconds EXT3 FS on hdb1, internal journal EXT3-fs: mounted filesystem with ordered data mode. kjournald starting. Commit interval 5 seconds EXT3 FS on sda1, internal journal EXT3-fs: recovery complete. EXT3-fs: mounted filesystem with ordered data mode. eth0: link up, 100Mbps, full-duplex, lpa 0x45E1 input: Power Button (FF) as /class/input/input5 ACPI: Power Button (FF) [PWRF] input: Power Button (CM) as /class/input/input6 ACPI: Power Button (CM) [PWRB] Marking TSC unstable due to: cpufreq changes. Time: acpi_pm clocksource has been installed. Clocksource tsc unstable (delta = -111190859 ns)
So you can't reproduce it by changing the file attributes back and attempting to move, delete, etc. like you were before? bugme-daemon@bugzilla.kernel.org wrote: >http://bugzilla.kernel.org/show_bug.cgi?id=8938 > > > > > >------- Comment #6 from patrick.matthaei@web.de 2007-08-26 03:23 ------- >First we had to find out, how I can reproduce it. > >I only have ext3 filesystems and a brand new crypted container with truecrypt. >Here's my normal dmesg: > >Linux version 2.6.22.5 (root@the-me) (gcc version 4.2.1 (Debian 4.2.1-3)) #1 >PREEMPT Thu Aug 23 14:32:21 CEST 2007 >BIOS-provided physical RAM map: > BIOS-e820: 0000000000000000 - 000000000009f400 (usable) > BIOS-e820: 000000000009f400 - 00000000000a0000 (reserved) > BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved) > BIOS-e820: 0000000000100000 - 000000003fff0000 (usable) > BIOS-e820: 000000003fff0000 - 000000003fff3000 (ACPI NVS) > BIOS-e820: 000000003fff3000 - 0000000040000000 (ACPI data) > BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved) > BIOS-e820: 00000000fec00000 - 0000000100000000 (reserved) >127MB HIGHMEM available. >896MB LOWMEM available. >Entering add_active_range(0, 0, 262128) 0 entries of 256 used >Zone PFN ranges: > DMA 0 -> 4096 > Normal 4096 -> 229376 > HighMem 229376 -> 262128 >early_node_map[1] active PFN ranges > 0: 0 -> 262128 >On node 0 totalpages: 262128 > DMA zone: 32 pages used for memmap > DMA zone: 0 pages reserved > DMA zone: 4064 pages, LIFO batch:0 > Normal zone: 1760 pages used for memmap > Normal zone: 223520 pages, LIFO batch:31 > HighMem zone: 255 pages used for memmap > HighMem zone: 32497 pages, LIFO batch:7 >DMI 2.3 present. >ACPI: RSDP 000F9260, 0014 (r0 Nvidia) >ACPI: RSDT 3FFF3040, 0034 (r1 Nvidia AWRDACPI 42302E31 AWRD 0) >ACPI: FACP 3FFF30C0, 0074 (r1 Nvidia AWRDACPI 42302E31 AWRD 0) >ACPI: DSDT 3FFF3180, 63C4 (r1 NVIDIA AWRDACPI 1000 MSFT 100000E) >ACPI: FACS 3FFF0000, 0040 >ACPI: SSDT 3FFF9680, 0118 (r1 PTLTD POWERNOW 1 LTP 1) >ACPI: MCFG 3FFF9800, 003C (r1 Nvidia AWRDACPI 42302E31 AWRD 0) >ACPI: APIC 3FFF95C0, 0072 (r1 Nvidia AWRDACPI 42302E31 AWRD 0) >ACPI: PM-Timer IO Port: 0x4008 >Allocating PCI resources starting at 50000000 (gap: 40000000:a0000000) >Built 1 zonelists. Total pages: 260081 >Kernel command line: root=/dev/hda1 ro >Enabling fast FPU save and restore... done. >Enabling unmasked SIMD FPU exception support... done. >Initializing CPU#0 >PID hash table entries: 4096 (order: 12, 16384 bytes) >Detected 2412.368 MHz processor. >spurious 8259A interrupt: IRQ7. >Console: colour VGA+ 80x25 >Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) >Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) >Memory: 1034236k/1048512k available (1460k kernel code, 13468k reserved, 470k >data, 164k init, 131008k highmem) >virtual kernel memory layout: > fixmap : 0xfffeb000 - 0xfffff000 ( 80 kB) > pkmap : 0xff800000 - 0xffc00000 (4096 kB) > vmalloc : 0xf8800000 - 0xff7fe000 ( 111 MB) > lowmem : 0xc0000000 - 0xf8000000 ( 896 MB) > .init : 0xc02e6000 - 0xc030f000 ( 164 kB) > .data : 0xc026d277 - 0xc02e2cec ( 470 kB) > .text : 0xc0100000 - 0xc026d277 (1460 kB) >Checking if this processor honours the WP bit even in supervisor mode... Ok. >SLUB: Genslabs=22, HWalign=64, Order=0-1, MinObjects=4, CPUs=1, Nodes=1 >Calibrating delay using timer specific routine.. 4827.67 BogoMIPS >(lpj=9655350) >Mount-cache hash table entries: 512 >CPU: After generic identify, caps: 078bfbff e3d3fbff 00000000 00000000 >00000001 >00000000 00000001 >CPU: L1 I Cache: 64K (64 bytes/line), D cache 64K (64 bytes/line) >CPU: L2 Cache: 1024K (64 bytes/line) >CPU: After all inits, caps: 078bfbff e3d3fbff 00000000 00000410 00000001 >00000000 00000001 >Compat vDSO mapped to ffffe000. >CPU: AMD Athlon(tm) 64 Processor 4000+ stepping 02 >Checking 'hlt' instruction... OK. >ACPI: Core revision 20070126 >ACPI: setting ELCR to 0200 (from 0cb8) >NET: Registered protocol family 16 >ACPI: bus type pci registered >PCI: Using MMCONFIG >PCI: No mmconfig possible on device 00:18 >Setting up standard PCI resources >ACPI: Interpreter enabled >ACPI: Using PIC for interrupt routing >ACPI: PCI Root Bridge [PCI0] (0000:00) >PCI: Probing PCI hardware (bus 00) >PCI: Transparent bridge - 0000:00:09.0 >ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT] >ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.HUB0._PRT] >ACPI: PCI Interrupt Link [LNK1] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. >ACPI: PCI Interrupt Link [LNK2] (IRQs 3 4 5 7 9 *10 11 12 14 15) >ACPI: PCI Interrupt Link [LNK3] (IRQs 3 4 *5 7 9 10 11 12 14 15) >ACPI: PCI Interrupt Link [LNK4] (IRQs 3 *4 5 7 9 10 11 12 14 15) >ACPI: PCI Interrupt Link [LNK5] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. >ACPI: PCI Interrupt Link [LUBA] (IRQs 3 4 5 7 9 *10 11 12 14 15) >ACPI: PCI Interrupt Link [LUBB] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. >ACPI: PCI Interrupt Link [LMAC] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. >ACPI: PCI Interrupt Link [LACI] (IRQs 3 4 5 *7 9 10 11 12 14 15) >ACPI: PCI Interrupt Link [LMCI] (IRQs *3 4 5 7 9 10 11 12 14 15) >ACPI: PCI Interrupt Link [LSMB] (IRQs 3 4 *5 7 9 10 11 12 14 15) >ACPI: PCI Interrupt Link [LUB2] (IRQs 3 4 5 7 9 10 *11 12 14 15) >ACPI: PCI Interrupt Link [LIDE] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. >ACPI: PCI Interrupt Link [LSID] (IRQs 3 4 5 7 9 10 *11 12 14 15) >ACPI: PCI Interrupt Link [LFID] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. >ACPI: PCI Interrupt Link [LPCA] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled. >ACPI: PCI Interrupt Link [APC1] (IRQs 16) *0, disabled. >ACPI: PCI Interrupt Link [APC2] (IRQs 17) *0, disabled. >ACPI: PCI Interrupt Link [APC3] (IRQs 18) *0, disabled. >ACPI: PCI Interrupt Link [APC4] (IRQs 19) *0, disabled. >ACPI: PCI Interrupt Link [APC5] (IRQs *16), disabled. >ACPI: PCI Interrupt Link [APCF] (IRQs 20 21 22 23) *0, disabled. >ACPI: PCI Interrupt Link [APCG] (IRQs 20 21 22 23) *0, disabled. >ACPI: PCI Interrupt Link [APCH] (IRQs 20 21 22 23) *0, disabled. >ACPI: PCI Interrupt Link [APCJ] (IRQs 20 21 22 23) *0, disabled. >ACPI: PCI Interrupt Link [APCK] (IRQs 20 21 22 23) *0, disabled. >ACPI: PCI Interrupt Link [APCS] (IRQs 20 21 22 23) *0, disabled. >ACPI: PCI Interrupt Link [APCL] (IRQs 20 21 22 23) *0, disabled. >ACPI: PCI Interrupt Link [APCZ] (IRQs 20 21 22 23) *0, disabled. >ACPI: PCI Interrupt Link [APSI] (IRQs 20 21 22 23) *0, disabled. >ACPI: PCI Interrupt Link [APSJ] (IRQs 20 21 22 23) *0, disabled. >ACPI: PCI Interrupt Link [APCP] (IRQs 20 21 22 23) *0, disabled. >Linux Plug and Play Support v0.97 (c) Adam Belay >pnp: PnP ACPI init >ACPI: bus type pnp registered >pnp: PnP ACPI: found 10 devices >ACPI: ACPI bus type pnp unregistered >PCI: Using ACPI for IRQ routing >PCI: If a device doesn't work, try "pci=routeirq". If it helps, post a report >pnp: 00:01: ioport range 0x4000-0x407f has been reserved >pnp: 00:01: ioport range 0x4080-0x40ff has been reserved >pnp: 00:01: ioport range 0x4400-0x447f has been reserved >pnp: 00:01: ioport range 0x4480-0x44ff has been reserved >pnp: 00:01: ioport range 0x4800-0x487f has been reserved >pnp: 00:01: ioport range 0x4880-0x48ff has been reserved >pnp: 00:08: iomem range 0xe0000000-0xefffffff could not be reserved >pnp: 00:09: iomem range 0xf0000-0xf3fff could not be reserved >pnp: 00:09: iomem range 0xf4000-0xf7fff could not be reserved >pnp: 00:09: iomem range 0xf8000-0xfbfff could not be reserved >pnp: 00:09: iomem range 0xfc000-0xfffff could not be reserved >Time: tsc clocksource has been installed. >PCI: Bridge: 0000:00:09.0 > IO window: b000-bfff > MEM window: fdf00000-fdffffff > PREFETCH window: fde00000-fdefffff >PCI: Bridge: 0000:00:0b.0 > IO window: a000-afff > MEM window: fdd00000-fddfffff > PREFETCH window: fdc00000-fdcfffff >PCI: Bridge: 0000:00:0c.0 > IO window: 9000-9fff > MEM window: fdb00000-fdbfffff > PREFETCH window: fda00000-fdafffff >PCI: Bridge: 0000:00:0d.0 > IO window: 8000-8fff > MEM window: fd900000-fd9fffff > PREFETCH window: fd800000-fd8fffff >PCI: Bridge: 0000:00:0e.0 > IO window: 7000-7fff > MEM window: fd700000-fd7fffff > PREFETCH window: d0000000-dfffffff >PCI: Setting latency timer of device 0000:00:09.0 to 64 >PCI: Setting latency timer of device 0000:00:0b.0 to 64 >PCI: Setting latency timer of device 0000:00:0c.0 to 64 >PCI: Setting latency timer of device 0000:00:0d.0 to 64 >PCI: Setting latency timer of device 0000:00:0e.0 to 64 >NET: Registered protocol family 2 >IP route cache hash table entries: 32768 (order: 5, 131072 bytes) >TCP established hash table entries: 131072 (order: 8, 1048576 bytes) >TCP bind hash table entries: 65536 (order: 6, 262144 bytes) >TCP: Hash tables configured (established 131072 bind 65536) >TCP reno registered >checking if image is initramfs... it is >Freeing initrd memory: 2143k freed >highmem bounce pool size: 64 pages >io scheduler noop registered >io scheduler cfq registered (default) >PCI: Linking AER extended capability on 0000:00:0b.0 >PCI: Linking AER extended capability on 0000:00:0c.0 >PCI: Linking AER extended capability on 0000:00:0d.0 >PCI: Linking AER extended capability on 0000:00:0e.0 >Boot video device is 0000:05:00.0 >PCI: Setting latency timer of device 0000:00:0b.0 to 64 >assign_interrupt_mode Found MSI capability >Allocate Port Service[0000:00:0b.0:pcie00] >Allocate Port Service[0000:00:0b.0:pcie03] >PCI: Setting latency timer of device 0000:00:0c.0 to 64 >assign_interrupt_mode Found MSI capability >Allocate Port Service[0000:00:0c.0:pcie00] >Allocate Port Service[0000:00:0c.0:pcie03] >PCI: Setting latency timer of device 0000:00:0d.0 to 64 >assign_interrupt_mode Found MSI capability >Allocate Port Service[0000:00:0d.0:pcie00] >Allocate Port Service[0000:00:0d.0:pcie03] >PCI: Setting latency timer of device 0000:00:0e.0 to 64 >assign_interrupt_mode Found MSI capability >Allocate Port Service[0000:00:0e.0:pcie00] >Allocate Port Service[0000:00:0e.0:pcie03] >RAMDISK driver initialized: 2 RAM disks of 8192K size 1024 blocksize >PNP: PS/2 Controller [PNP0303:PS2K] at 0x60,0x64 irq 1 >PNP: PS/2 controller doesn't have AUX irq; using default 12 >serio: i8042 KBD port at 0x60,0x64 irq 1 >serio: i8042 AUX port at 0x60,0x64 irq 12 >mice: PS/2 mouse device common for all mice >device-mapper: ioctl: 4.11.0-ioctl (2006-10-12) initialised: >dm-devel@redhat.com >TCP cubic registered >NET: Registered protocol family 1 >NET: Registered protocol family 17 >powernow-k8: Found 1 AMD Athlon(tm) 64 Processor 4000+ processors (version >2.00.00) >powernow-k8: 0 : fid 0x10 (2400 MHz), vid 0x8 >powernow-k8: 1 : fid 0xe (2200 MHz), vid 0x8 >powernow-k8: 2 : fid 0xc (2000 MHz), vid 0xa >powernow-k8: 3 : fid 0xa (1800 MHz), vid 0xc >powernow-k8: 4 : fid 0x2 (1000 MHz), vid 0x12 >powernow-k8: ph2 null fid transition 0x10 >Using IPI Shortcut mode >Freeing unused kernel memory: 164k freed >input: AT Translated Set 2 keyboard as /class/input/input0 >ACPI: Fan [FAN] (on) >ACPI: Thermal Zone [THRM] (22 C) >usbcore: registered new interface driver usbfs >usbcore: registered new interface driver hub >usbcore: registered new device driver usb >ohci_hcd: 2006 August 04 USB 1.1 'Open' Host Controller (OHCI) Driver >ACPI: PCI Interrupt Link [LUBA] enabled at IRQ 10 >PCI: setting IRQ 10 as level-triggered >ACPI: PCI Interrupt 0000:00:02.0[A] -> Link [LUBA] -> GSI 10 (level, low) -> >IRQ 10 >PCI: Setting latency timer of device 0000:00:02.0 to 64 >ohci_hcd 0000:00:02.0: OHCI Host Controller >ohci_hcd 0000:00:02.0: new USB bus registered, assigned bus number 1 >ohci_hcd 0000:00:02.0: irq 10, io mem 0xfe02f000 >Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2 >ide: Assuming 33MHz system bus speed for PIO modes; override with idebus=xx >8139too Fast Ethernet driver 0.9.28 >usb usb1: configuration #1 chosen from 1 choice >hub 1-0:1.0: USB hub found >hub 1-0:1.0: 10 ports detected >NFORCE-CK804: IDE controller at PCI slot 0000:00:06.0 >NFORCE-CK804: chipset revision 242 >NFORCE-CK804: not 100% native mode: will probe irqs later >NFORCE-CK804: 0000:00:06.0 (rev f2) UDMA133 controller > ide0: BM-DMA at 0xe000-0xe007, BIOS settings: hda:DMA, hdb:DMA > ide1: BM-DMA at 0xe008-0xe00f, BIOS settings: hdc:DMA, hdd:DMA >Probing IDE interface ide0... >Switched to NOHz mode on CPU #0 >hda: Maxtor 6E040L0, ATA DISK drive >usb 1-2: new low speed USB device using ohci_hcd and address 2 >usb 1-2: configuration #1 chosen from 1 choice >hdb: Maxtor 6L250R0, ATA DISK drive >ide0 at 0x1f0-0x1f7,0x3f6 on irq 14 >Probing IDE interface ide1... >usb 1-8: new low speed USB device using ohci_hcd and address 3 >usb 1-8: configuration #1 chosen from 1 choice >input: Logitech Logitech(R) Precision(TM) Gamepad as /class/input/input1 >input: USB HID v1.10 Joystick [Logitech Logitech(R) Precision(TM) Gamepad] on >usb-0000:00:02.0-2 >input: Logitech USB-PS/2 Optical Mouse as /class/input/input2 >input: USB HID v1.10 Mouse [Logitech USB-PS/2 Optical Mouse] on >usb-0000:00:02.0-8 >usbcore: registered new interface driver usbhid >drivers/hid/usbhid/hid-core.c: v2.6:USB HID core driver >hdc: HL-DT-ST DVDRAM GSA-4163B, ATAPI CD/DVD-ROM drive >hdd: SONY CD-RW CRX210E1, ATAPI CD/DVD-ROM drive >ide1 at 0x170-0x177,0x376 on irq 15 >ACPI: PCI Interrupt Link [LUB2] enabled at IRQ 11 >PCI: setting IRQ 11 as level-triggered >ACPI: PCI Interrupt 0000:00:02.1[B] -> Link [LUB2] -> GSI 11 (level, low) -> >IRQ 11 >PCI: Setting latency timer of device 0000:00:02.1 to 64 >ehci_hcd 0000:00:02.1: EHCI Host Controller >ehci_hcd 0000:00:02.1: new USB bus registered, assigned bus number 2 >ehci_hcd 0000:00:02.1: debug port 1 >PCI: cache line size of 64 is not supported by device 0000:00:02.1 >ehci_hcd 0000:00:02.1: irq 11, io mem 0xfeb00000 >ehci_hcd 0000:00:02.1: USB 2.0 started, EHCI 1.00, driver 10 Dec 2004 >usb 1-2: USB disconnect, address 2 >usb usb2: configuration #1 chosen from 1 choice >hub 2-0:1.0: USB hub found >hub 2-0:1.0: 10 ports detected >SCSI subsystem initialized >libata version 2.21 loaded. >sata_nv 0000:00:07.0: version 3.4 >ACPI: PCI Interrupt Link [LSID] enabled at IRQ 11 >ACPI: PCI Interrupt 0000:00:07.0[A] -> Link [LSID] -> GSI 11 (level, low) -> >IRQ 11 >sata_nv 0000:00:07.0: Using ADMA mode >PCI: Setting latency timer of device 0000:00:07.0 to 64 >scsi0 : sata_nv >scsi1 : sata_nv >ata1: SATA max UDMA/133 cmd 0xf881c480 ctl 0xf881c4a0 bmdma 0x0001cc00 irq 11 >ata2: SATA max UDMA/133 cmd 0xf881c580 ctl 0xf881c5a0 bmdma 0x0001cc08 irq 11 >hda: max request size: 128KiB >usb 1-8: USB disconnect, address 3 >hda: 80293248 sectors (41110 MB) w/2048KiB Cache, CHS=65535/16/63, UDMA(133) >hda: cache flushes supported > hda: hda1 hda2 < hda5 > >hdb: max request size: 512KiB >hdb: 490234752 sectors (251000 MB) w/16384KiB Cache, CHS=30515/255/63, >UDMA(133) >hdb: cache flushes supported > hdb: hdb1 >hdc: ATAPI 40X DVD-ROM DVD-R-RAM CD-R/RW drive, 2048kB Cache, UDMA(33) >Uniform CD-ROM driver Revision: 3.20 >hdd: ATAPI 40X CD-ROM CD-R/RW drive, 2048kB Cache, UDMA(33) >ata1: SATA link up 1.5 Gbps (SStatus 113 SControl 300) >ata1.00: ATA-7: MAXTOR STM3250820AS, 3.AAE, max UDMA/133 >ata1.00: 488397168 sectors, multi 16: LBA48 NCQ (depth 31/32) >ata1.00: configured for UDMA/133 >usb 1-2: new low speed USB device using ohci_hcd and address 4 >ata2: SATA link down (SStatus 0 SControl 300) >scsi 0:0:0:0: Direct-Access ATA MAXTOR STM325082 3.AA PQ: 0 ANSI: 5 >ata1: bounce limit 0xFFFFFFFFFFFFFFFF, segment boundary 0xFFFFFFFF, hw segs 61 >ACPI: PCI Interrupt Link [LNK2] enabled at IRQ 10 >ACPI: PCI Interrupt 0000:01:07.0[A] -> Link [LNK2] -> GSI 10 (level, low) -> >IRQ 10 >eth0: RealTek RTL8139 at 0xf8816000, 00:02:2a:df:47:10, IRQ 10 >eth0: Identified 8139 chip type 'RTL-8100B/8139D' >ACPI: PCI Interrupt Link [LNK4] enabled at IRQ 4 >PCI: setting IRQ 4 as level-triggered >ACPI: PCI Interrupt 0000:01:09.0[A] -> Link [LNK4] -> GSI 4 (level, low) -> >IRQ >4 >PCI: Setting latency timer of device 0000:01:09.0 to 64 >ohci1394: fw-host0: OHCI-1394 1.1 (PCI): IRQ=[4] MMIO=[fdffe000-fdffe7ff] >Max >Packet=[2048] IR/IT contexts=[4/8] >sd 0:0:0:0: [sda] 488397168 512-byte hardware sectors (250059 MB) >sd 0:0:0:0: [sda] Write Protect is off >sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 >sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support >DPO or FUA >sd 0:0:0:0: [sda] 488397168 512-byte hardware sectors (250059 MB) >sd 0:0:0:0: [sda] Write Protect is off >sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 >sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support >DPO or FUA > sda: sda1 >sd 0:0:0:0: [sda] Attached SCSI disk >usb 1-2: configuration #1 chosen from 1 choice >input: Logitech Logitech(R) Precision(TM) Gamepad as /class/input/input3 >input: USB HID v1.10 Joystick [Logitech Logitech(R) Precision(TM) Gamepad] on >usb-0000:00:02.0-2 >kjournald starting. Commit interval 5 seconds >EXT3-fs: mounted filesystem with ordered data mode. >usb 1-8: new low speed USB device using ohci_hcd and address 5 >usb 1-8: configuration #1 chosen from 1 choice >input: Logitech USB-PS/2 Optical Mouse as /class/input/input4 >input: USB HID v1.10 Mouse [Logitech USB-PS/2 Optical Mouse] on >usb-0000:00:02.0-8 >ieee1394: Host added: ID:BUS[0-00:1023] GUID[000108002000f7f3] >Real Time Clock Driver v1.12ac >i2c-adapter i2c-0: nForce2 SMBus adapter at 0x4c00 >i2c-adapter i2c-1: nForce2 SMBus adapter at 0x4c40 >ACPI: PCI Interrupt Link [LNK3] enabled at IRQ 5 >PCI: setting IRQ 5 as level-triggered >ACPI: PCI Interrupt 0000:01:08.0[A] -> Link [LNK3] -> GSI 5 (level, low) -> >IRQ >5 >PCI: Setting latency timer of device 0000:01:08.0 to 64 >Adding 1662688k swap on /dev/hda5. Priority:-1 extents:1 across:1662688k >EXT3 FS on hda1, internal journal >w83627ehf: unsupported chip ID: 0xffff >kjournald starting. Commit interval 5 seconds >EXT3 FS on hdb1, internal journal >EXT3-fs: mounted filesystem with ordered data mode. >kjournald starting. Commit interval 5 seconds >EXT3 FS on sda1, internal journal >EXT3-fs: recovery complete. >EXT3-fs: mounted filesystem with ordered data mode. >eth0: link up, 100Mbps, full-duplex, lpa 0x45E1 >input: Power Button (FF) as /class/input/input5 >ACPI: Power Button (FF) [PWRF] >input: Power Button (CM) as /class/input/input6 >ACPI: Power Button (CM) [PWRB] >Marking TSC unstable due to: cpufreq changes. >Time: acpi_pm clocksource has been installed. >Clocksource tsc unstable (delta = -111190859 ns) > > > >
I think I've done now all what I know from my history and the lsattr / chattr steps etc. to reproduce it, but no error appeared.
We've had people hitting this in Fedora too. https://bugzilla.redhat.com/show_bug.cgi?id=248355
Found a possible race in that code: http://lkml.org/lkml/2007/8/23/180 static void set_dentry_child_flags(struct inode *inode, int watched) ... spin_lock(&dcache_lock); list_for_each_entry(alias, &inode->i_dentry, d_alias) { struct dentry *child; list_for_each_entry(child, &alias->d_subdirs, d_u.d_child) { if (!child->d_inode) { WARN_ON(child->d_flags & DCACHE_INOTIFY_PARENT_WATCHED); continue; } But in dcache.c, the locks are dropped before this flag is cleared, leaving a race window: void d_delete(struct dentry * dentry) ... spin_lock(&dcache_lock); spin_lock(&dentry->d_lock); isdir = S_ISDIR(dentry->d_inode->i_mode); if (atomic_read(&dentry->d_count) == 1) { dentry_iput(dentry); <================ drops dcache_lock and dentry->d_lock fsnotify_nameremove(dentry, isdir); /* remove this and other inotify debug checks after 2.6.18 */ dentry->d_flags &= ~DCACHE_INOTIFY_PARENT_WATCHED; return; } (The comment is nice, it says the debug code should have been removed long ago.)
I think there could be a real race there though (aside from the races with the warnings). See other bug. I think we probably should just fix that and rip out the debug code. Sigh. I had been trying to get someone who can reproduce this to verify it for the past year or so but when I post a patch, that tends to be the end of that.
Hi Nick, I hit this but rarely on a bigger production machine as well (https://bugzilla.redhat.com/show_bug.cgi?id=248355) and I'd be willing to test it, but for that I'd need your patch in a RH FC7 kernel (Nick/Chuck) ?
This is what I have done: http://www.kernel.org/pub/linux/kernel/people/akpm/patches/2.6/2.6.24-rc6/2.6.24-rc6-mm1/broken-out/inotify-fix-race.patch http://www.kernel.org/pub/linux/kernel/people/akpm/patches/2.6/2.6.24-rc6/2.6.24-rc6-mm1/broken-out/inotify-remove-debug-code.patch I have fixed one real (although small) race in the inotify code. And also just removed the debug checks from there completely as well. They were a bit racy as well, and it is hard to get any useful information out of them. It seems a bit unsatisfactory just to remove the checks, however I haven't ever had any reports of missing inotify events, so I'm not too unhappy to see the checks go. In that case, I don't know if testing is going to help at all: unless you were actually seeing incorrect behaviour from inotify then you won't be able to tell if anything was fixed!
Any updates please. Patrick, Helge, have you had any problems since the patches were incorporated?
Never occured again on any system. At the moment I'm on 2.6.24.2.
I suppose we can close this bug then. Thanks!
Hello, I had an look today in my dmesg (same machine as reported above) and what's there? :) Again the same with 2.6.24.3: WARNING: at fs/inotify.c:172 set_dentry_child_flags() Pid: 2710, comm: plasma Tainted: P 2.6.24.3-exez #1 [<c018a03c>] set_dentry_child_flags+0x10c/0x1a0 [<c018a120>] remove_watch_no_event+0x50/0x60 [<c018a238>] inotify_remove_watch_locked+0x18/0x50 [<c018a3ec>] inotify_rm_wd+0x6c/0xb0 [<c018abf8>] sys_inotify_rm_watch+0x38/0x60 [<c0102a76>] syscall_call+0x7/0xb ======================= WARNING: at fs/inotify.c:172 set_dentry_child_flags() Pid: 2710, comm: plasma Tainted: P 2.6.24.3-exez #1 [<c018a03c>] set_dentry_child_flags+0x10c/0x1a0 [<c018a8d1>] inotify_add_watch+0xe1/0xf0 [<c018b391>] sys_inotify_add_watch+0x151/0x180 [<c018a354>] put_inotify_watch+0x34/0x60 [<c018a401>] inotify_rm_wd+0x81/0xb0 [<c0102a76>] syscall_call+0x7/0xb ======================= WARNING: at fs/inotify.c:172 set_dentry_child_flags() Pid: 2710, comm: plasma Tainted: P 2.6.24.3-exez #1 [<c018a03c>] set_dentry_child_flags+0x10c/0x1a0 [<c018a120>] remove_watch_no_event+0x50/0x60 [<c018a238>] inotify_remove_watch_locked+0x18/0x50 [<c018a3ec>] inotify_rm_wd+0x6c/0xb0 [<c018abf8>] sys_inotify_rm_watch+0x38/0x60 [<c0102a76>] syscall_call+0x7/0xb ======================= WARNING: at fs/inotify.c:172 set_dentry_child_flags() Pid: 2710, comm: plasma Tainted: P 2.6.24.3-exez #1 [<c018a03c>] set_dentry_child_flags+0x10c/0x1a0 [<c018a8d1>] inotify_add_watch+0xe1/0xf0 [<c018b391>] sys_inotify_add_watch+0x151/0x180 [<c018a354>] put_inotify_watch+0x34/0x60 [<c018a401>] inotify_rm_wd+0x81/0xb0 [<c0102a76>] syscall_call+0x7/0xb ======================= Don't blame me for the tainted kernel, I've to use at the moment on this machine fglrx. No I've browsed my var/log/messages and saw that this happens multiple times. This happens while I'm copying something around 4 GB datas from my laptop about sshfs to this machine.
Never appeared again and I'm using radeonhd as driver at the moment. In the next time I'm upgrading the computer where this occurs and have to use fglrx again.. If the error comes back with fglrx, I'll write it down here, then we know, that it's maybe a bug of fglrx and not of linux.