Package: linux-image-2.6.25-2-686 Version: 2.6.25-5 Followup-For: Bug #481525
This sounds like the problem I've had with an MSI cd-rw drive going bad: Jun 24 09:03:13 victoria kernel: [39238.824892] INFO: task hald-addon-stor:3675 blocked for more than 120 seconds. Jun 24 09:03:13 victoria kernel: [39238.824941] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Jun 24 09:03:13 victoria kernel: [39238.824965] hald-addon-st D e604b3ed 0 3675 3619 Jun 24 09:03:13 victoria kernel: [39238.824995] d22019c0 00000082 0000000c e604b3ed 000001b1 d2201b4c c128b0e0 00000000 Jun 24 09:03:13 victoria kernel: [39238.825048] 00000000 d48a15ce 0004a099 00000000 00000000 d48382ac 00000088 d2f83d08 Jun 24 09:03:13 victoria kernel: [39238.825099] 7fffffff 7fffffff d2f83c74 00000002 c02bcd28 d4838260 00000000 00000092 Jun 24 09:03:13 victoria kernel: [39238.825149] Call Trace: Jun 24 09:03:13 victoria kernel: [39238.825261] [<d48a15ce>] cdrom_start_packet_command+0xb6/0xbd [ide_cd_mod] Jun 24 09:03:13 victoria kernel: [39238.825390] [<c02bcd28>] schedule_timeout+0x13/0x86 Jun 24 09:03:13 victoria kernel: [39238.825474] [<c0180c61>] do_sys_poll+0x267/0x2e7 Jun 24 09:03:13 victoria kernel: [39238.825567] [<c02bc441>] wait_for_common+0xd3/0x140 Jun 24 09:03:13 victoria kernel: [39238.825616] [<c011c52f>] default_wake_function+0x0/0x8 Jun 24 09:03:13 victoria kernel: [39238.825696] [<d4826ef2>] ide_do_drive_cmd+0xd6/0xf2 [ide_core] Jun 24 09:03:13 victoria kernel: [39238.825943] [<d48a1c65>] ide_cd_queue_pc+0x35/0xb4 [ide_cd_mod] Jun 24 09:03:13 victoria kernel: [39238.825992] [<c0110070>] lapic_watchdog_init+0x71/0xfc Jun 24 09:03:13 victoria kernel: [39238.826059] [<c02bcb67>] schedule+0x64c/0x66d Jun 24 09:03:13 victoria kernel: [39238.826159] [<d48a1f03>] cdrom_check_status+0x5a/0x65 [ide_cd_mod] Jun 24 09:03:13 victoria kernel: [39238.826428] [<c01d698f>] blk_end_sync_rq+0x0/0x25 Jun 24 09:03:13 victoria kernel: [39238.826518] [<d48a38df>] ide_cdrom_check_media_change_real+0x1b/0x36 [ide_cd_mod] Jun 24 09:03:13 victoria kernel: [39238.826582] [<d489806e>] media_changed+0x40/0x6e [cdrom] Jun 24 09:03:13 victoria kernel: [39238.826667] [<c0195d7c>] check_disk_change+0x13/0x57 Jun 24 09:03:13 victoria kernel: [39238.826716] [<d489bf2a>] cdrom_open+0x882/0x8f8 [cdrom] Jun 24 09:03:13 victoria kernel: [39238.826777] [<c017c1f3>] do_lookup+0x53/0x145 Jun 24 09:03:13 victoria kernel: [39238.826838] [<c01843ea>] dput+0x15/0xbb Jun 24 09:03:13 victoria kernel: [39238.826876] [<c017e1a9>] __link_path_walk+0xa5b/0xb67 Jun 24 09:03:13 victoria kernel: [39238.826930] [<c01de860>] kobject_get+0xf/0x13 Jun 24 09:03:13 victoria kernel: [39238.826993] [<c01d860d>] get_disk+0x33/0x49 Jun 24 09:03:13 victoria kernel: [39238.827041] [<c01d862a>] exact_lock+0x7/0xd Jun 24 09:03:13 victoria kernel: [39238.827073] [<c0241e22>] kobj_lookup+0xe4/0x10e Jun 24 09:03:13 victoria kernel: [39238.827144] [<d48a14f1>] idecd_open+0x44/0x6b [ide_cd_mod] Jun 24 09:03:13 victoria kernel: [39238.827212] [<c019637b>] do_open+0xa1/0x278 Jun 24 09:03:13 victoria kernel: [39238.827281] [<c01966cd>] blkdev_open+0x0/0x4d Jun 24 09:03:13 victoria kernel: [39238.827309] [<c01966f2>] blkdev_open+0x25/0x4d Jun 24 09:03:13 victoria kernel: [39238.827353] [<c0174aeb>] __dentry_open+0x10d/0x1fc Jun 24 09:03:13 victoria kernel: [39238.827431] [<c0174bf6>] nameidata_to_filp+0x1c/0x2c Jun 24 09:03:13 victoria kernel: [39238.827484] [<c017f38a>] do_filp_open+0x34f/0x6b0 Jun 24 09:03:13 victoria kernel: [39238.827571] [<d4899322>] cdrom_release+0x179/0x1ae [cdrom] Jun 24 09:03:13 victoria kernel: [39238.827628] [<d4a45183>] snd_emu10k1_playback_pointer+0x2a/0x52 [snd_emu10k1] Jun 24 09:03:13 victoria kernel: [39238.827806] [<d4a4724d>] snd_emu10k1_voice_intr_ack+0x15/0x52 [snd_emu10k1] Jun 24 09:03:13 victoria kernel: [39238.827987] [<c0174908>] do_sys_open+0x40/0xb0 Jun 24 09:03:13 victoria kernel: [39238.828051] [<c01749bc>] sys_open+0x1e/0x23 Jun 24 09:03:13 victoria kernel: [39238.828102] [<c0105863>] sysenter_past_esp+0x78/0xb1 This problem happened with a large number of test kernels as well (can't be sure if any recent kernels *didn't* show this problem). It would be nice if the kernel could handle cd drives going bad more gracefully. This problem also locked up dosbox. After changing to a known good pioneer dvd-rw drive, I started getting the following errors when playing an audio cd: Jun 24 22:51:57 victoria kernel: [ 7076.365804] hdc: command error: status=0x51 { DriveReady SeekComplete Error } Jun 24 22:51:57 victoria kernel: [ 7076.365876] hdc: command error: error=0x50 { LastFailedSense=0x05 } Jun 24 22:51:57 victoria kernel: [ 7076.365909] ide: failed opcode was: unknown Jun 24 22:51:57 victoria kernel: [ 7076.366282] ATAPI device hdc: Jun 24 22:51:57 victoria kernel: [ 7076.366301] Error: Illegal request -- (Sense key=0x05) Jun 24 22:51:57 victoria kernel: [ 7076.366335] Illegal mode for this track or incompatible medium -- (asc=0x64, ascq=0x00) Jun 24 22:51:57 victoria kernel: [ 7076.366359] The failed "Read 10" packet command was: Jun 24 22:51:57 victoria kernel: [ 7076.366371] "28 00 00 00 00 00 00 00 08 00 00 00 00 00 00 00 " Jun 24 22:51:57 victoria kernel: [ 7076.366462] end_request: I/O error, dev hdc, sector 0 Jun 24 22:51:57 victoria kernel: [ 7076.366495] Buffer I/O error on device hdc, logical block 0 Jun 24 22:51:57 victoria kernel: [ 7076.366545] Buffer I/O error on device hdc, logical block 1 Jun 24 22:51:57 victoria kernel: [ 7076.366572] Buffer I/O error on device hdc, logical block 2 Jun 24 22:51:57 victoria kernel: [ 7076.366598] Buffer I/O error on device hdc, logical block 3 Jun 24 22:51:57 victoria kernel: [ 7076.367827] hdc: command error: status=0x51 { DriveReady SeekComplete Error } Jun 24 22:51:57 victoria kernel: [ 7076.367872] hdc: command error: error=0x50 { LastFailedSense=0x05 } Jun 24 22:51:57 victoria kernel: [ 7076.367902] ide: failed opcode was: unknown Jun 24 22:51:57 victoria kernel: [ 7076.372053] ATAPI device hdc: Jun 24 22:51:57 victoria kernel: [ 7076.372080] Error: Illegal request -- (Sense key=0x05) Jun 24 22:51:57 victoria kernel: [ 7076.372114] Illegal mode for this track or incompatible medium -- (asc=0x64, ascq=0x00) Jun 24 22:51:57 victoria kernel: [ 7076.372138] The failed "Read 10" packet command was: Jun 24 22:51:57 victoria kernel: [ 7076.372149] "28 00 00 00 00 00 00 00 02 00 00 00 00 00 00 00 " Jun 24 22:51:57 victoria kernel: [ 7076.372239] end_request: I/O error, dev hdc, sector 0 Jun 24 22:51:57 victoria kernel: [ 7076.372268] Buffer I/O error on device hdc, logical block 0 Jun 24 22:51:57 victoria kernel: [ 7076.473670] hdc: command error: status=0x51 { DriveReady SeekComplete Error } Jun 24 22:51:57 victoria kernel: [ 7076.473729] hdc: command error: error=0x50 { LastFailedSense=0x05 } Jun 24 22:51:57 victoria kernel: [ 7076.473760] ide: failed opcode was: unknown Jun 24 22:51:57 victoria kernel: [ 7076.474080] ATAPI device hdc: Jun 24 22:51:57 victoria kernel: [ 7076.474101] Error: Illegal request -- (Sense key=0x05) Jun 24 22:51:57 victoria kernel: [ 7076.474134] Illegal mode for this track or incompatible medium -- (asc=0x64, ascq=0x00) Jun 24 22:51:57 victoria kernel: [ 7076.474158] The failed "Read 10" packet command was: Jun 24 22:51:57 victoria kernel: [ 7076.474170] "28 00 00 00 00 00 00 00 02 00 00 00 00 00 00 00 " Jun 24 22:51:57 victoria kernel: [ 7076.474258] end_request: I/O error, dev hdc, sector 0 Jun 24 22:51:57 victoria kernel: [ 7076.474260] Buffer I/O error on device hdc, logical block 0 Jun 24 22:51:57 victoria kernel: [ 7076.493664] hdc: command error: status=0x51 { DriveReady SeekComplete Error } Jun 24 22:51:57 victoria kernel: [ 7076.493718] hdc: command error: error=0x50 { LastFailedSense=0x05 } Jun 24 22:51:57 victoria kernel: [ 7076.493749] ide: failed opcode was: unknown Jun 24 22:51:57 victoria kernel: [ 7076.498497] ATAPI device hdc: Jun 24 22:51:57 victoria kernel: [ 7076.498520] Error: Illegal request -- (Sense key=0x05) Jun 24 22:51:57 victoria kernel: [ 7076.498554] Illegal mode for this track or incompatible medium -- (asc=0x64, ascq=0x00) Jun 24 22:51:57 victoria kernel: [ 7076.498578] The failed "Read 10" packet command was: Jun 24 22:51:57 victoria kernel: [ 7076.498590] "28 00 00 00 00 00 00 00 02 00 00 00 00 00 00 00 " Jun 24 22:51:57 victoria kernel: [ 7076.498679] end_request: I/O error, dev hdc, sector 0 Jun 24 22:51:57 victoria kernel: [ 7076.498710] Buffer I/O error on device hdc, logical block 0 Jun 24 22:51:57 victoria kernel: [ 7076.559279] hdc: command error: status=0x51 { DriveReady SeekComplete Error } Jun 24 22:51:57 victoria kernel: [ 7076.559356] hdc: command error: error=0x50 { LastFailedSense=0x05 } Jun 24 22:51:57 victoria kernel: [ 7076.559388] ide: failed opcode was: unknown Jun 24 22:51:57 victoria kernel: [ 7076.559708] ATAPI device hdc: Jun 24 22:51:57 victoria kernel: [ 7076.559728] Error: Illegal request -- (Sense key=0x05) Jun 24 22:51:57 victoria kernel: [ 7076.559762] Illegal mode for this track or incompatible medium -- (asc=0x64, ascq=0x00) Jun 24 22:51:57 victoria kernel: [ 7076.559786] The failed "Read 10" packet command was: Jun 24 22:51:57 victoria kernel: [ 7076.559798] "28 00 00 00 00 00 00 00 02 00 00 00 00 00 00 00 " Jun 24 22:51:57 victoria kernel: [ 7076.559888] end_request: I/O error, dev hdc, sector 0 Jun 24 22:51:57 victoria kernel: [ 7076.559920] Buffer I/O error on device hdc, logical block 0 Jun 24 22:51:57 victoria kernel: [ 7076.579360] hdc: command error: status=0x51 { DriveReady SeekComplete Error } Jun 24 22:51:57 victoria kernel: [ 7076.579435] hdc: command error: error=0x50 { LastFailedSense=0x05 } Jun 24 22:51:57 victoria kernel: [ 7076.579467] ide: failed opcode was: unknown Jun 24 22:51:57 victoria kernel: [ 7076.584008] ATAPI device hdc: Jun 24 22:51:57 victoria kernel: [ 7076.584053] Error: Illegal request -- (Sense key=0x05) Jun 24 22:51:57 victoria kernel: [ 7076.584088] Illegal mode for this track or incompatible medium -- (asc=0x64, ascq=0x00) Jun 24 22:51:57 victoria kernel: [ 7076.584113] The failed "Read 10" packet command was: Jun 24 22:51:57 victoria kernel: [ 7076.584124] "28 00 00 00 00 00 00 00 02 00 00 00 00 00 00 00 " Jun 24 22:51:57 victoria kernel: [ 7076.584216] end_request: I/O error, dev hdc, sector 0 Jun 24 22:51:57 victoria kernel: [ 7076.584249] Buffer I/O error on device hdc, logical block 0 Any suggestions beyond the usual disabling DMA? The cd-rw and now dvd-rw drive is the only device on the secondary IDE channel. hdparm reports: # hdparm /dev/hdc /dev/hdc: IO_support = 0 (default) unmaskirq = 0 (off) using_dma = 1 (on) keepsettings = 0 (off) readonly = 0 (off) readahead = 256 (on) HDIO_GETGEO failed: Inappropriate ioctl for device -- Package-specific info: -- System Information: Debian Release: lenny/sid APT prefers unstable APT policy: (500, 'unstable'), (500, 'testing'), (500, 'stable') Architecture: i386 (i686) Kernel: Linux 2.6.26-rc7 (SMP w/1 CPU core; PREEMPT) Locale: LANG=en_AU.UTF-8, LC_CTYPE=en_AU.UTF-8 (charmap=UTF-8) Shell: /bin/sh linked to /bin/bash Versions of packages linux-image-2.6.25-2-686 depends on: ii debconf [debconf-2.0] 1.5.22 Debian configuration management sy ii initramfs-tools [linux-initra 0.92b tools for generating an initramfs ii module-init-tools 3.4-1 tools for managing Linux kernel mo ii yaird [linux-initramfs-tool] 0.0.12-25 Yet Another mkInitRD Versions of packages linux-image-2.6.25-2-686 recommends: ii libc6-i686 2.7-12 GNU C Library: Shared libraries [i -- debconf-show failed -- To UNSUBSCRIBE, email to [EMAIL PROTECTED] with a subject of "unsubscribe". Trouble? Contact [EMAIL PROTECTED]