cdrom problems in 2.5.74

cdrom problems in 2.5.74

Post by dave » Fri, 04 Jul 2003 20:10:10



Hi,

I'm getting frequent problems with CDs (reading or writing) in 2.5.74
(and earlier kernels also - at least 2.5.73, maybe earlier). Typically
it hangs the program accessing the cd. I got the following errors trying
to read a cd with cdparanoia:

Hope this is useful

dave

output from dmesg:

hdc: DMA disabled
hdc: irq timeout: status=0xd0 { Busy }
ide-scsi: abort called for 584
Debug: sleeping function called from illegal context at
include/asm/semaphore.h:119
Call Trace:
 [<c012477f>] __might_sleep+0x5f/0x70
 [<c02e7b34>] scsi_sleep+0xf4/0x120
 [<c02e7a20>] scsi_sleep_done+0x0/0x20
 [<c02f9630>] idescsi_abort+0x2c0/0x360
 [<c02e6e01>] scsi_try_to_abort_cmd+0xe1/0x200
 [<c01222d2>] __wake_up_locked+0x22/0x30
 [<c02e7030>] scsi_eh_abort_cmds+0x40/0x80
 [<c02e7fff>] scsi_unjam_host+0x13f/0x1f0
 [<c01220b0>] default_wake_function+0x0/0x30
 [<c02e832c>] scsi_error_handler+0x27c/0x2c0
 [<c02e80b0>] scsi_error_handler+0x0/0x2c0
 [<c0109089>] kernel_thread_helper+0x5/0xc

bad: scheduling while atomic!
Call Trace:
 [<c0122044>] schedule+0x6d4/0x6e0
 [<c01291b7>] printk+0x277/0x400
 [<c0109f35>] __down+0x135/0x350
 [<c01220b0>] default_wake_function+0x0/0x30
 [<c010cc5e>] dump_stack+0x1e/0x20
 [<c010a657>] __down_failed+0xb/0x14
 [<c02e85cf>] .text.lock.scsi_error+0x37/0x48
 [<c02e7a20>] scsi_sleep_done+0x0/0x20
 [<c02f9630>] idescsi_abort+0x2c0/0x360
 [<c02e6e01>] scsi_try_to_abort_cmd+0xe1/0x200
 [<c01222d2>] __wake_up_locked+0x22/0x30
 [<c02e7030>] scsi_eh_abort_cmds+0x40/0x80
 [<c02e7fff>] scsi_unjam_host+0x13f/0x1f0
 [<c01220b0>] default_wake_function+0x0/0x30
 [<c02e832c>] scsi_error_handler+0x27c/0x2c0
 [<c02e80b0>] scsi_error_handler+0x0/0x2c0
 [<c0109089>] kernel_thread_helper+0x5/0xc

hdc: ATAPI reset complete
hdc: irq timeout: status=0xc0 { Busy }
hdc: ATAPI reset complete
hdc: irq timeout: status=0xc0 { Busy }
drivers/scsi/ide-scsi.c:362: spin_lock(drivers/scsi/hosts.c:dfd7d268)
already locked by drivers/scsi/scsi_error.c/712
drivers/scsi/scsi_error.c:714:
spin_unlock(drivers/scsi/hosts.c:dfd7d268) not locked
hdc: irq timeout: status=0xd0 { Busy }
ide-scsi: abort called for 738
Debug: sleeping function called from illegal context at
include/asm/semaphore.h:119
Call Trace:
 [<c012477f>] __might_sleep+0x5f/0x70
 [<c02e7b34>] scsi_sleep+0xf4/0x120
 [<c02e7a20>] scsi_sleep_done+0x0/0x20
 [<c02f9630>] idescsi_abort+0x2c0/0x360
 [<c02e6e01>] scsi_try_to_abort_cmd+0xe1/0x200
 [<c01222d2>] __wake_up_locked+0x22/0x30
 [<c02e7030>] scsi_eh_abort_cmds+0x40/0x80
 [<c02e7fff>] scsi_unjam_host+0x13f/0x1f0
 [<c01220b0>] default_wake_function+0x0/0x30
 [<c02e832c>] scsi_error_handler+0x27c/0x2c0
 [<c02e80b0>] scsi_error_handler+0x0/0x2c0
 [<c0109089>] kernel_thread_helper+0x5/0xc

bad: scheduling while atomic!
Call Trace:
 [<c0122044>] schedule+0x6d4/0x6e0
 [<c01291b7>] printk+0x277/0x400
 [<c0109f35>] __down+0x135/0x350
 [<c01220b0>] default_wake_function+0x0/0x30
 [<c010cc5e>] dump_stack+0x1e/0x20
 [<c010a657>] __down_failed+0xb/0x14
 [<c02e85cf>] .text.lock.scsi_error+0x37/0x48
 [<c02e7a20>] scsi_sleep_done+0x0/0x20
 [<c02f9630>] idescsi_abort+0x2c0/0x360
 [<c02e6e01>] scsi_try_to_abort_cmd+0xe1/0x200
 [<c01222d2>] __wake_up_locked+0x22/0x30
 [<c02e7030>] scsi_eh_abort_cmds+0x40/0x80
 [<c02e7fff>] scsi_unjam_host+0x13f/0x1f0
 [<c01220b0>] default_wake_function+0x0/0x30
 [<c02e832c>] scsi_error_handler+0x27c/0x2c0
 [<c02e80b0>] scsi_error_handler+0x0/0x2c0
 [<c0109089>] kernel_thread_helper+0x5/0xc

hdc: ATAPI reset complete
hdc: irq timeout: status=0xc0 { Busy }
hdc: ATAPI reset complete
hdc: irq timeout: status=0xc0 { Busy }
drivers/scsi/ide-scsi.c:362: spin_lock(drivers/scsi/hosts.c:dfd7d268)
already locked by drivers/scsi/scsi_error.c/712
drivers/scsi/scsi_error.c:714:
spin_unlock(drivers/scsi/hosts.c:dfd7d268) not locked
hdc: irq timeout: status=0xd0 { Busy }
ide-scsi: abort called for 1081
Debug: sleeping function called from illegal context at
include/asm/semaphore.h:119
Call Trace:
 [<c012477f>] __might_sleep+0x5f/0x70
 [<c02e7b34>] scsi_sleep+0xf4/0x120
 [<c02e7a20>] scsi_sleep_done+0x0/0x20
 [<c02f9630>] idescsi_abort+0x2c0/0x360
 [<c02e6e01>] scsi_try_to_abort_cmd+0xe1/0x200
 [<c01222d2>] __wake_up_locked+0x22/0x30
 [<c02e7030>] scsi_eh_abort_cmds+0x40/0x80
 [<c02e7fff>] scsi_unjam_host+0x13f/0x1f0
 [<c01220b0>] default_wake_function+0x0/0x30
 [<c02e832c>] scsi_error_handler+0x27c/0x2c0
 [<c02e80b0>] scsi_error_handler+0x0/0x2c0
 [<c0109089>] kernel_thread_helper+0x5/0xc

bad: scheduling while atomic!
Call Trace:
 [<c0122044>] schedule+0x6d4/0x6e0
 [<c01291b7>] printk+0x277/0x400
 [<c0109f35>] __down+0x135/0x350
 [<c01220b0>] default_wake_function+0x0/0x30
 [<c010cc5e>] dump_stack+0x1e/0x20
 [<c010a657>] __down_failed+0xb/0x14
 [<c02e85cf>] .text.lock.scsi_error+0x37/0x48
 [<c02e7a20>] scsi_sleep_done+0x0/0x20
 [<c02f9630>] idescsi_abort+0x2c0/0x360
 [<c02e6e01>] scsi_try_to_abort_cmd+0xe1/0x200
 [<c01222d2>] __wake_up_locked+0x22/0x30
 [<c02e7030>] scsi_eh_abort_cmds+0x40/0x80
 [<c02e7fff>] scsi_unjam_host+0x13f/0x1f0
 [<c01220b0>] default_wake_function+0x0/0x30
 [<c02e832c>] scsi_error_handler+0x27c/0x2c0
 [<c02e80b0>] scsi_error_handler+0x0/0x2c0
 [<c0109089>] kernel_thread_helper+0x5/0xc

hdc: ATAPI reset complete
hdc: irq timeout: status=0xc0 { Busy }
hdc: ATAPI reset complete
hdc: irq timeout: status=0xc0 { Busy }
drivers/scsi/ide-scsi.c:362: spin_lock(drivers/scsi/hosts.c:dfd7d268)
already locked by drivers/scsi/scsi_error.c/712
Unable to handle kernel paging request at virtual address 6b6b6bd3
 printing eip:
c02f8dce
*pde = 00000000
Oops: 0000 [#1]
CPU:    0
EIP:    0060:[<c02f8dce>]    Tainted: PF
EFLAGS: 00010002
EIP is at idescsi_queue+0x25e/0x800
eax: 00000000   ebx: cdf37d30   ecx: dfd23084   edx: 6b6b6b6b
esi: ca10c000   edi: d886ba14   ebp: ca10dde8   esp: ca10dd8c
ds: 007b   es: 007b   ss: 0068
Process cdparanoia (pid: 4065, threadinfo=ca10c000 task=cb234980)
Stack: c05171c4 d886ba14 00000004 e0c6e9c0 cfc428f4 dfd7ce28 cfc42984
cdf37d30
       00000046 dfd230ec c0450220 ca10dde8 00000246 dfd230d8 ca060000
dfd230d8
       d886ba14 dfd7d42c d886ba14 c05171c4 00000246 dfd7d234 dfd23084
ca10de20
Call Trace:
 [<c02e380c>] scsi_dispatch_cmd+0x2cc/0x420
 [<c02e3ab0>] scsi_done+0x0/0x70
 [<c02e63b0>] scsi_times_out+0x0/0x50
 [<c02e8abf>] scsi_init_cmd_errh+0x9f/0xd0
 [<c02ea6a6>] scsi_request_fn+0x2e6/0x720
 [<c015312e>] __alloc_pages+0x8e/0x330
 [<c02a7a9e>] blk_insert_request+0xde/0x1f0
 [<c02e86f9>] scsi_do_req+0x49/0xa0
 [<c02e8613>] scsi_insert_special_req+0x33/0x40
 [<c02fe6cf>] sg_common_write+0x16f/0x1d0
 [<c02ff980>] sg_cmd_done+0x0/0x270
 [<c02fe226>] sg_write+0x1d6/0x2a0
 [<c0192c10>] sys_select+0x220/0x4c0
 [<c017767d>] vfs_write+0xad/0x120
 [<c0138d6d>] sys_rt_sigprocmask+0x8d/0x2f0
 [<c017778f>] sys_write+0x3f/0x60
 [<c010bf0b>] syscall_call+0x7/0xb

Code: 8b 42 68 8b 40 4c 81 38 3c 4b 24 1d 74 26 89 44 24 0c c7 44
 <6>note: cdparanoia[4065] exited with preempt_count 1
bad: scheduling while atomic!
Call Trace:
 [<c0122044>] schedule+0x6d4/0x6e0
 [<c01609a1>] unmap_page_range+0x41/0x70
 [<c0160bb6>] unmap_vmas+0x1e6/0x350
 [<c016679b>] exit_mmap+0xcb/0x2c0
 [<c0125606>] mmput+0xb6/0x140
 [<c012ba86>] do_exit+0x276/0xa90
 [<c010d0bc>] die+0x21c/0x220
 [<c011fc0c>] do_page_fault+0x15c/0x4ca
 [<c011fab0>] do_page_fault+0x0/0x4ca
 [<c010c915>] error_code+0x2d/0x38
 [<c02f8dce>] idescsi_queue+0x25e/0x800
 [<c02e380c>] scsi_dispatch_cmd+0x2cc/0x420
 [<c02e3ab0>] scsi_done+0x0/0x70
 [<c02e63b0>] scsi_times_out+0x0/0x50
 [<c02e8abf>] scsi_init_cmd_errh+0x9f/0xd0
 [<c02ea6a6>] scsi_request_fn+0x2e6/0x720
 [<c015312e>] __alloc_pages+0x8e/0x330
 [<c02a7a9e>] blk_insert_request+0xde/0x1f0
 [<c02e86f9>] scsi_do_req+0x49/0xa0
 [<c02e8613>] scsi_insert_special_req+0x33/0x40
 [<c02fe6cf>] sg_common_write+0x16f/0x1d0
 [<c02ff980>] sg_cmd_done+0x0/0x270
 [<c02fe226>] sg_write+0x1d6/0x2a0
 [<c0192c10>] sys_select+0x220/0x4c0
 [<c017767d>] vfs_write+0xad/0x120
 [<c0138d6d>] sys_rt_sigprocmask+0x8d/0x2f0
 [<c017778f>] sys_write+0x3f/0x60
 [<c010bf0b>] syscall_call+0x7/0xb

Debug: sleeping function called from illegal context at
include/asm/semaphore.h:119
Call Trace:
 [<c012477f>] __might_sleep+0x5f/0x70
 [<c015fa1d>] clear_page_tables+0xad/0xb0
 [<c0164649>] remove_shared_vm_struct+0x39/0xa0
 [<c01668a2>] exit_mmap+0x1d2/0x2c0
 [<c0125606>] mmput+0xb6/0x140
 [<c012ba86>] do_exit+0x276/0xa90
 [<c010d0bc>] die+0x21c/0x220
 [<c011fc0c>] do_page_fault+0x15c/0x4ca
 [<c011fab0>] do_page_fault+0x0/0x4ca
 [<c010c915>] error_code+0x2d/0x38
 [<c02f8dce>] idescsi_queue+0x25e/0x800
 [<c02e380c>] scsi_dispatch_cmd+0x2cc/0x420
 [<c02e3ab0>] scsi_done+0x0/0x70
 [<c02e63b0>] scsi_times_out+0x0/0x50
 [<c02e8abf>] scsi_init_cmd_errh+0x9f/0xd0
 [<c02ea6a6>] scsi_request_fn+0x2e6/0x720
 [<c015312e>] __alloc_pages+0x8e/0x330
 [<c02a7a9e>] blk_insert_request+0xde/0x1f0
 [<c02e86f9>] scsi_do_req+0x49/0xa0
 [<c02e8613>] scsi_insert_special_req+0x33/0x40
 [<c02fe6cf>] sg_common_write+0x16f/0x1d0
 [<c02ff980>] sg_cmd_done+0x0/0x270
 [<c02fe226>] sg_write+0x1d6/0x2a0
 [<c0192c10>] sys_select+0x220/0x4c0
 [<c017767d>] vfs_write+0xad/0x120
 [<c0138d6d>] sys_rt_sigprocmask+0x8d/0x2f0
 [<c017778f>] sys_write+0x3f/0x60
 [<c010bf0b>] syscall_call+0x7/0xb

bad: scheduling while atomic!
Call Trace:
 [<c0122044>] schedule+0x6d4/0x6e0
 [<c02ea402>] scsi_request_fn+0x42/0x720
 [<c01228b5>] wait_for_completion+0x155/0x340
 [<c01220b0>] default_wake_function+0x0/0x30
 [<c01220b0>] default_wake_function+0x0/0x30
 [<c02e8613>] scsi_insert_special_req+0x33/0x40
 [<c02e89fa>] scsi_wait_req+0xca/0xf0
 [<c02e8750>] scsi_wait_done+0x0/0x1e0
 [<c01589b6>] kmem_cache_alloc+0x146/0x190
 [<c02e4b42>] ioctl_internal_command+0x52/0x190
 [<c02e4ce6>] scsi_set_medium_removal+0x66/0x90
 [<c015c241>] invalidate_inode_pages+0x21/0x30
 [<c0303857>] cdrom_release+0x67/0x120
 [<c0184992>] blkdev_put+0x2c2/0x340
 [<c0197d23>] dput+0x23/0x680
 [<c0178792>] __fput+0x112/0x120
 [<c017676a>] filp_close+0x15a/0x220
 [<c012563c>] mmput+0xec/0x140
 [<c012a7dc>] put_files_struct+0x6c/0xe0
 [<c012bc03>] do_exit+0x3f3/0xa90
 [<c010d0bc>] die+0x21c/0x220
 [<c011fc0c>] do_page_fault+0x15c/0x4ca
 [<c011fab0>] do_page_fault+0x0/0x4ca
 [<c010c915>] error_code+0x2d/0x38
 [<c02f8dce>] idescsi_queue+0x25e/0x800
 [<c02e380c>] scsi_dispatch_cmd+0x2cc/0x420
 [<c02e3ab0>] scsi_done+0x0/0x70
 [<c02e63b0>] scsi_times_out+0x0/0x50
 [<c02e8abf>] scsi_init_cmd_errh+0x9f/0xd0
 [<c02ea6a6>] scsi_request_fn+0x2e6/0x720
 [<c015312e>] __alloc_pages+0x8e/0x330
 [<c02a7a9e>] blk_insert_request+0xde/0x1f0
 [<c02e86f9>] scsi_do_req+0x49/0xa0
 [<c02e8613>] scsi_insert_special_req+0x33/0x40
 [<c02fe6cf>] sg_common_write+0x16f/0x1d0
 [<c02ff980>] sg_cmd_done+0x0/0x270
 [<c02fe226>] sg_write+0x1d6/0x2a0
 [<c0192c10>] sys_select+0x220/0x4c0
 [<c017767d>] vfs_write+0xad/0x120
 [<c0138d6d>] sys_rt_sigprocmask+0x8d/0x2f0
 [<c017778f>] sys_write+0x3f/0x60
 [<c010bf0b>] syscall_call+0x7/0xb

-
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
the body of a message to majord...@vger.kernel.org
More majordomo info at  http://vger.kernel.org/majordomo-info.html
Please read the FAQ at  http://www.tux.org/lkml/

 
 
 

1. 2.5.74 does not boot with TCQ: Unable to handle NULL pointer dereference

2.5.72 + bk : kernel boots fine with TCQ, TASKFILE, and TASKFILE_IO enabled
It froze a bunch of times, but at least it booted.

2.5.74: kernel refuses to boot (kernel panic).
Disabling TASKFILE_IO does not help
Disabling TASKFILE does not help
Disabling TCQ allows the kernel to boot.

Here's the oops data (copied by hand)...
Please CC, I'm not subscribed.

Unable to handle kernel NULL pointer dereference in virtual address 00000000
....
kernel is not tainted...
...
EIP at 0x0
Process swapper

__elv_add_request + 0x36/0x50
ide_do_drive_cmd+0xc2/0x140
ide_diag_taskfile+0xac/0xe0
ide_raw_taskfile+0x27/0x30
ide_tcq_configure+0x7c/0x110
ide_enable_queued+0x5e/0x100
__ide_dma_queued_on+0x94/0xc0
__ide_dma_on+0x53/0x60
via82cxxx_ide_dma_check+0xbf/0xe0
probe_hwif+0x24a/0x480
probe_hwif_init+0x25/0x80
ide_setup_pci_device+0x57/0x90
via_init_one+0x3c/0x50
ide_scan_pcidev+0x5c/0x70
ide_scan_pcibus+0x3e/0xe0
probe_for_hwifs+0x10/0x20
ide_init_builtin_drivers+0x5/0x10
ide_init+0x45/0x60
do_initcalls+0x2c/0xa0
init_workqueues+0xf/0x60
init+0x34/0x1d0
init+0x0/0x1d0
kernel_thread_helper+0x5/0x10

Code: Bad EIP value

<0> Kernel panic: Attempted to kill init.

-
To unsubscribe from this list: send the line "unsubscribe linux-kernel" in

More majordomo info at  http://vger.kernel.org/majordomo-info.html
Please read the FAQ at  http://www.tux.org/lkml/

2. Login + shell + novice

3. 2.5.74 synclink_cs.c

4. TR-UX? (was Re: Ben Rosen the real culprit?)

5. 2.5.74 synclink.c

6. Wanted: Precompiled gcc for SOlaris 2.4

7. 2.5.74: ALSA lockups, and ACPI, IRQ routing

8. Behaviour of XAllocNamedColor on pseudo colour screens

9. 2.5.74 xattr fixes

10. (trivial 2.5.74) compilation fix drivers/mtd/mtd_blkdevs.c

11. [ANNOUNCE] kexec for 2.5.74 available

12. 2.5.74 with contest

13. - 2.5.74 - (frame buffer & radeonfb) - no setfont, loadkeys on all tty