Bug#274167: kernel-image-2.6.8-1-686: reiserfs bug on a firewire harddisk, possible patch found
Package: kernel-image-2.6.8-1-686
Version: 2.6.8-4
Followup-For: Bug #274167
-- System Information:
Debian Release: 3.1
APT prefers testing
APT policy: (500, 'testing')
Architecture: i386 (i686)
Kernel: Linux 2.6.8-1-686
Locale: LANG=de_DE@euro, LC_CTYPE=de_DE@euro
Versions of packages kernel-image-2.6.8-1-686 depends on:
ii coreutils [fileutils] 5.2.1-2 The GNU core utilities
ii initrd-tools 0.1.74 tools to create initrd image for p
ii module-init-tools 3.1-pre6-1 tools for managing Linux kernel mo
-- no debconf information
I encountered a bug that might be related to #274167. See the following
snippet of /var/log/kern.log. The bug occured after the following steps:
* Plugged a 160GB firewire harddisk
* Mount the first partition of the hd (/dev/sda1, 120G)
* tried write a large amount of date (~60G) to the firewire hd
* after the snippet was writted, all processes accessing the hd are
blocked and cannot be interrupted. Even regular system shutdown did not
work. I switched off the computer.
The interesting line of the snippet is
kernel BUG at fs/reiserfs/prints.c:362!
Googling for this leads me to a potential patch, see
http://www.mail-archive.com/reiserfs-list@namesys.com/msg16068.html
Since I'm no kernel hacker at all I can't say anything regarding the
patch.
Regards,
Stefan
Now the snippet:
Nov 2 07:43:04 localhost kernel: ReiserFS: sda1: using ordered data mode
Nov 2 07:43:04 localhost kernel: ReiserFS: sda1: journal params: device sda1, size 8192, journal first block 18, max trans len 1024, max batch 900, max commit age 30, max trans age 30
Nov 2 07:43:04 localhost kernel: ReiserFS: sda1: checking transaction log (sda1)
Nov 2 07:43:07 localhost kernel: ReiserFS: sda1: replayed 30 transactions in 3 seconds
Nov 2 07:43:07 localhost kernel: ReiserFS: sda1: Using r5 hash to sort names
Nov 2 08:07:57 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:07:57 localhost kernel: Write (10) 00 00 04 05 a7 00 00 08 00
Nov 2 08:08:07 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:07 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:08:07 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:07 localhost kernel: Write (10) 00 00 44 00 3f 00 00 08 00
Nov 2 08:08:17 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:17 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:08:17 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:17 localhost kernel: Write (10) 00 00 44 bd bf 00 00 10 00
Nov 2 08:08:27 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:27 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:08:27 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:27 localhost kernel: Write (10) 00 00 44 c1 d7 00 00 08 00
Nov 2 08:08:37 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:37 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:08:37 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:37 localhost kernel: Write (10) 00 00 90 00 3f 00 00 08 00
Nov 2 08:08:47 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:47 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:08:47 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:47 localhost kernel: Write (10) 00 00 90 00 5f 00 00 f8 00
Nov 2 08:08:57 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:57 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:08:57 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:08:57 localhost kernel: Write (10) 00 00 90 01 57 00 00 f8 00
Nov 2 08:09:07 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:09:07 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:09:07 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:09:07 localhost kernel: Write (10) 00 00 90 02 4f 00 00 08 00
Nov 2 08:09:17 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:09:17 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:09:17 localhost kernel: ieee1394: sbp2: reset requested
Nov 2 08:09:17 localhost kernel: ieee1394: sbp2: Generating sbp2 fetch agent reset
Nov 2 08:09:27 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:09:27 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:09:27 localhost kernel: ieee1394: sbp2: reset requested
Nov 2 08:09:27 localhost kernel: ieee1394: sbp2: Generating sbp2 fetch agent reset
Nov 2 08:09:47 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:09:47 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:09:57 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:09:57 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:10:07 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:10:07 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:10:17 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:10:17 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:10:27 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:10:27 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:10:37 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:10:37 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:10:47 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:10:47 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:10:57 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:10:57 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:10:57 localhost kernel: ieee1394: sbp2: reset requested
Nov 2 08:10:57 localhost kernel: ieee1394: sbp2: Generating sbp2 fetch agent reset
Nov 2 08:11:17 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:11:17 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:11:27 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:11:27 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:11:37 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:11:37 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:11:47 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:11:47 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:11:57 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:11:57 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:12:07 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:12:07 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:12:17 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:12:17 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:12:27 localhost kernel: ieee1394: sbp2: aborting sbp2 command
Nov 2 08:12:27 localhost kernel: Test Unit Ready 00 00 00 00 00
Nov 2 08:12:27 localhost kernel: scsi: Device offlined - not ready after error recovery: host 0 channel 0 id 0 lun 0
Nov 2 08:12:27 localhost last message repeated 7 times
Nov 2 08:12:27 localhost kernel: SCSI error : <0 0 0 0> return code = 0x50000
Nov 2 08:12:27 localhost kernel: end_request: I/O error, dev sda, sector 263591
Nov 2 08:12:27 localhost kernel: Buffer I/O error on device sda1, logical block 32941
Nov 2 08:12:27 localhost kernel: lost page write due to I/O error on sda1
Nov 2 08:12:27 localhost kernel: scsi0 (0:0): rejecting I/O to offline device
Nov 2 08:12:27 localhost kernel: Buffer I/O error on device sda1, logical block 1179715
Nov 2 08:12:27 localhost kernel: lost page write due to I/O error on sda1
Nov 2 08:12:27 localhost kernel: Buffer I/O error on device sda1, logical block 1179716
Nov 2 08:12:27 localhost kernel: lost page write due to I/O error on sda1
Nov 2 08:12:27 localhost kernel: Buffer I/O error on device sda1, logical block 1179717
Nov 2 08:12:27 localhost kernel: lost page write due to I/O error on sda1
Nov 2 08:12:27 localhost kernel: Buffer I/O error on device sda1, logical block 1179718
Nov 2 08:12:27 localhost kernel: lost page write due to I/O error on sda1
Nov 2 08:12:27 localhost kernel: Buffer I/O error on device sda1, logical block 1179719
Nov 2 08:12:27 localhost kernel: lost page write due to I/O error on sda1
Nov 2 08:12:27 localhost kernel: Buffer I/O error on device sda1, logical block 1179720
Nov 2 08:12:27 localhost kernel: lost page write due to I/O error on sda1
Nov 2 08:12:27 localhost kernel: Buffer I/O error on device sda1, logical block 1179721
Nov 2 08:12:27 localhost kernel: lost page write due to I/O error on sda1
Nov 2 08:12:27 localhost kernel: Buffer I/O error on device sda1, logical block 1179722
Nov 2 08:12:27 localhost kernel: lost page write due to I/O error on sda1
Nov 2 08:12:27 localhost kernel: Buffer I/O error on device sda1, logical block 1179723
Nov 2 08:12:27 localhost kernel: lost page write due to I/O error on sda1
Nov 2 08:12:27 localhost kernel: scsi0 (0:0): rejecting I/O to offline device
Nov 2 08:12:27 localhost last message repeated 85 times
Nov 2 08:12:27 localhost kernel: SCSI error : <0 0 0 0> return code = 0x50000
Nov 2 08:12:27 localhost kernel: end_request: I/O error, dev sda, sector 4456511
Nov 2 08:12:27 localhost kernel: SCSI error : <0 0 0 0> return code = 0x50000
Nov 2 08:12:27 localhost kernel: end_request: I/O error, dev sda, sector 4505023
Nov 2 08:12:27 localhost kernel: scsi0 (0:0): rejecting I/O to offline device
Nov 2 08:12:27 localhost kernel: SCSI error : <0 0 0 0> return code = 0x50000
Nov 2 08:12:27 localhost kernel: end_request: I/O error, dev sda, sector 4506071
Nov 2 08:12:27 localhost kernel: SCSI error : <0 0 0 0> return code = 0x50000
Nov 2 08:12:27 localhost kernel: end_request: I/O error, dev sda, sector 9437247
Nov 2 08:12:27 localhost kernel: SCSI error : <0 0 0 0> return code = 0x50000
Nov 2 08:12:27 localhost kernel: end_request: I/O error, dev sda, sector 9437279
Nov 2 08:12:27 localhost kernel: scsi0 (0:0): rejecting I/O to offline device
Nov 2 08:12:27 localhost kernel: SCSI error : <0 0 0 0> return code = 0x50000
Nov 2 08:12:27 localhost kernel: end_request: I/O error, dev sda, sector 9437527
Nov 2 08:12:27 localhost kernel: scsi0 (0:0): rejecting I/O to offline device
Nov 2 08:12:27 localhost kernel: SCSI error : <0 0 0 0> return code = 0x50000
Nov 2 08:12:27 localhost kernel: end_request: I/O error, dev sda, sector 9437775
Nov 2 08:12:27 localhost kernel: ReiserFS: sda1: warning: journal-837: IO error during journal replay
Nov 2 08:12:27 localhost kernel: REISERFS: panic (device sda1): journal-712: buffer write failed
Nov 2 08:12:27 localhost kernel:
Nov 2 08:12:27 localhost kernel: ------------[ cut here ]------------
Nov 2 08:12:27 localhost kernel: kernel BUG at fs/reiserfs/prints.c:362!
Nov 2 08:12:27 localhost kernel: invalid operand: 0000 [#1]
Nov 2 08:12:27 localhost kernel: PREEMPT
Nov 2 08:12:27 localhost kernel: Modules linked in: nvidia vmnet vmmon ipv6 ds lp af_packet sd_mod eth1394 sbp2 scsi_mod ohci1394 ieee1394 yenta_socket pcmcia_core b44 mii snd_intel8x0m snd_intel8x0 snd_ac97_codec snd_pcm_oss snd_mixer_oss snd_pcm snd_timer snd_page_alloc gameport snd_mpu401_uart snd_rawmidi snd_seq_device snd soundcore ehci_hcd joydev usbhid uhci_hcd usbcore pci_hotplug intel_agp agpgart parport_pc parport irtty_sir sir_dev irda crc_ccitt pcspkr mousedev tsdev psmouse evdev dm_mod capability commoncap ide_cd cdrom rtc isofs reiserfs ext2 ext3 jbd mbcache ide_generic ide_disk piix ide_core unix font vesafb cfbcopyarea cfbimgblt cfbfillrect
Nov 2 08:12:27 localhost kernel: CPU: 0
Nov 2 08:12:27 localhost kernel: EIP: 0060:[__crc_sk_stream_mem_schedule+1325891/1457199] Tainted: P
Nov 2 08:12:27 localhost kernel: EFLAGS: 00010282 (2.6.8-1-686)
Nov 2 08:12:27 localhost kernel: EIP is at reiserfs_panic+0x52/0x80 [reiserfs]
Nov 2 08:12:27 localhost kernel: eax: 00000044 ebx: e0977a73 ecx: c02bb3d0 edx: 00000282
Nov 2 08:12:27 localhost kernel: esi: de5a9a00 edi: de5a9b2c ebp: 0000006a esp: c72b1da4
Nov 2 08:12:27 localhost kernel: ds: 007b es: 007b ss: 0068
Nov 2 08:12:27 localhost kernel: Process pdflush (pid: 4046, threadinfo=c72b0000 task=c94da8c0)
Nov 2 08:12:27 localhost kernel: Stack: e0974300 de5a9b2c e0980e20 de5a9a00 c0e3bd80 00000000 e096b002 de5a9a00
Nov 2 08:12:27 localhost kernel: e0975920 00001345 cef5a880 e096b427 de5a9a00 0000124a 00001345 de92a3bc
Nov 2 08:12:27 localhost kernel: 00000000 00000000 00000000 0000006a cef5a880 00000002 0000011b 00000100
Nov 2 08:12:27 localhost kernel: Call Trace:
Nov 2 08:12:27 localhost kernel: [__crc_sk_stream_mem_schedule+1378611/1457199] update_journal_header_block+0x42/0x50 [reiserfs]
Nov 2 08:12:27 localhost kernel: [__crc_sk_stream_mem_schedule+1379672/1457199] flush_journal_list+0x387/0x5f0 [reiserfs]
Nov 2 08:12:27 localhost kernel: [__crc_sk_stream_mem_schedule+1381283/1457199] flush_used_journal_lists+0xe2/0xf0 [reiserfs]
Nov 2 08:12:27 localhost kernel: [__crc_sk_stream_mem_schedule+1395467/1457199] flush_old_journal_lists+0x4a/0x70 [reiserfs]
Nov 2 08:12:27 localhost kernel: [__crc_sk_stream_mem_schedule+1397395/1457199] do_journal_end+0x762/0xbd0 [reiserfs]
Nov 2 08:12:27 localhost kernel: [__crc_sk_stream_mem_schedule+1392911/1457199] journal_end_sync+0x4e/0xa0 [reiserfs]
Nov 2 08:12:27 localhost kernel: [__crc_sk_stream_mem_schedule+1311327/1457199] reiserfs_sync_fs+0x5e/0xb0 [reiserfs]
Nov 2 08:12:27 localhost kernel: [sync_supers+168/192] sync_supers+0xa8/0xc0
Nov 2 08:12:27 localhost kernel: [wb_kupdate+53/288] wb_kupdate+0x35/0x120
Nov 2 08:12:27 localhost kernel: [__pdflush+202/464] __pdflush+0xca/0x1d0
Nov 2 08:12:27 localhost kernel: [pdflush+0/48] pdflush+0x0/0x30
Nov 2 08:12:27 localhost kernel: [pdflush+38/48] pdflush+0x26/0x30
Nov 2 08:12:27 localhost kernel: [wb_kupdate+0/288] wb_kupdate+0x0/0x120
Nov 2 08:12:27 localhost kernel: [pdflush+0/48] pdflush+0x0/0x30
Nov 2 08:12:27 localhost kernel: [kthread+170/176] kthread+0xaa/0xb0
Nov 2 08:12:27 localhost kernel: [kthread+0/176] kthread+0x0/0xb0
Nov 2 08:12:27 localhost kernel: [kernel_thread_helper+5/24] kernel_thread_helper+0x5/0x18
Nov 2 08:12:27 localhost kernel: Code: 0f 0b 6a 01 83 7a 97 e0 c7 04 24 40 43 97 e0 85 f6 be 20 0e
Nov 2 08:15:03 localhost kernel: <3>scsi0 (0:0): rejecting I/O to offline device
Nov 2 08:30:48 localhost kernel: ieee1394: Node changed: 0-01:1023 -> 0-00:1023
Nov 2 08:30:48 localhost kernel: ieee1394: Node suspended: ID:BUS[0-00:1023] GUID[0050770e00005184]
Reply to: