[Cialug] DVD burner issue
Daniel A. Ramaley
daniel.ramaley at drake.edu
Wed Dec 2 11:26:00 CST 2009
I have a DVD burner that has developed a strange issue. It can burn
exactly 1 DVD per power cycle. Attempts to burn a second disc resulting
in the drive locking itself, writing just enough to waste a disc, and
blocking IO on the write process such that "kill -9" won't even get rid
of it. A soft reboot isn't sufficient to clear it; a full power-down and
cold reboot is necessary. This is on Debian Testing (amd64) with a
2.6.30 kernel.
Has anyone seen this? My initial guess would be that i need a new drive,
but i'm not convinced that guess is correct. When i boot up i get these
in the kernel log that don't look good:
Driver 'sd' needs updating - please use bus_type methods
Driver 'sr' needs updating - please use bus_type methods
And when i try to burn a disc i get lots of other ugliness in the logs
that makes me think it might be a software problem rather than hardware:
Dec 1 18:06:50 coelacanth kernel: [345123.070361] sr 2:0:0:0: [sr0]
Unhandled sense code
Dec 1 18:06:50 coelacanth kernel: [345123.070370] sr 2:0:0:0: [sr0] Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Dec 1 18:06:50 coelacanth kernel: [345123.070379] sr 2:0:0:0: [sr0] Sense
Key : Blank Check [current]
Dec 1 18:06:50 coelacanth kernel: [345123.070389] sr 2:0:0:0: [sr0] Add.
Sense: No additional sense information
Dec 1 18:06:50 coelacanth kernel: [345123.070400] end_request: I/O error,
dev sr0, sector 0
Dec 1 18:06:50 coelacanth kernel: [345123.070410] Buffer I/O error on device
sr0, logical block 0
Dec 1 18:06:50 coelacanth kernel: [345123.071087] sr 2:0:0:0: [sr0]
Unhandled sense code
Dec 1 18:06:50 coelacanth kernel: [345123.071093] sr 2:0:0:0: [sr0] Result:
hostbyte=DID_OK driverbyte=DRIVER_SENSE
Dec 1 18:06:50 coelacanth kernel: [345123.071101] sr 2:0:0:0: [sr0] Sense
Key : Blank Check [current]
Dec 1 18:06:50 coelacanth kernel: [345123.071109] sr 2:0:0:0: [sr0] Add.
Sense: No additional sense information
Dec 1 18:06:50 coelacanth kernel: [345123.071117] end_request: I/O error,
dev sr0, sector 0
Dec 1 18:06:50 coelacanth kernel: [345123.071123] Buffer I/O error on device
sr0, logical block 0
Dec 1 18:06:50 coelacanth kernel: [345123.077312] cdrom: This disc doesn't
have any tracks I recognize!
Dec 1 18:10:48 coelacanth kernel: [345361.133106] ffff8801ff1414d0
0000000000000086 0000000000000020 ffff8801fb00f800
Dec 1 18:10:48 coelacanth kernel: [345361.133118] ffff8801fc7b8120
00000000000120c0 000000000000e250 ffff8801fd8d6e20
Dec 1 18:10:48 coelacanth kernel: [345361.133129] ffff8801fd8d7110
00000001a00291d6 ffff8801ff1414d0 ffff880102c85208
Dec 1 18:10:48 coelacanth kernel: [345361.133139] Call Trace:
Dec 1 18:10:48 coelacanth kernel: [345361.133220] [<ffffffffa002e7da>] ?
scsi_setup_blk_pc_cmnd+0x39/0x117 [scsi_mod]
Dec 1 18:10:48 coelacanth kernel: [345361.133244] [<ffffffff804b45e8>] ?
schedule+0x9/0x1e
Dec 1 18:10:48 coelacanth kernel: [345361.133255] [<ffffffff804b4762>] ?
schedule_timeout+0x1e/0xb6
Dec 1 18:10:48 coelacanth kernel: [345361.133266] [<ffffffff8033c0c9>] ?
elv_next_request+0xd8/0x1a3
Dec 1 18:10:48 coelacanth kernel: [345361.133276] [<ffffffff804b3cca>] ?
wait_for_common+0xd7/0x148
Dec 1 18:10:48 coelacanth kernel: [345361.133287] [<ffffffff8023bc9a>] ?
default_wake_function+0x0/0x9
Dec 1 18:10:48 coelacanth kernel: [345361.133298] [<ffffffff80340fa0>] ?
blk_execute_rq+0x93/0xab
Dec 1 18:10:48 coelacanth kernel: [345361.133307] [<ffffffff8033e709>] ?
get_request_wait+0x21/0x17e
Dec 1 18:10:48 coelacanth kernel: [345361.133316] [<ffffffff80235f09>] ?
set_next_entity+0x34/0x56
Dec 1 18:10:48 coelacanth kernel: [345361.133355] [<ffffffffa002f11e>] ?
scsi_execute+0xdc/0x12f [scsi_mod]
Dec 1 18:10:48 coelacanth kernel: [345361.133391] [<ffffffffa002f1f8>] ?
scsi_execute_req+0x87/0xb9 [scsi_mod]
Dec 1 18:10:48 coelacanth kernel: [345361.133408] [<ffffffffa0104234>] ?
sr_test_unit_ready+0x5d/0xc0 [sr_mod]
Dec 1 18:10:48 coelacanth kernel: [345361.133423] [<ffffffffa01044bb>] ?
sr_media_change+0x45/0x237 [sr_mod]
Dec 1 18:10:48 coelacanth kernel: [345361.133434] [<ffffffff804b4d5e>] ?
schedule_hrtimeout_range+0xa2/0xf3
Dec 1 18:10:48 coelacanth kernel: [345361.133444] [<ffffffff80254848>] ?
finish_wait+0x35/0x60
Dec 1 18:10:48 coelacanth kernel: [345361.133461] [<ffffffffa00f6074>] ?
media_changed+0x42/0x74 [cdrom]
Dec 1 18:10:48 coelacanth kernel: [345361.133473] [<ffffffff802e1b3c>] ?
check_disk_change+0x22/0x52
Dec 1 18:10:48 coelacanth kernel: [345361.133489] [<ffffffffa00fa4fb>] ?
cdrom_open+0x8c9/0x942 [cdrom]
Dec 1 18:10:48 coelacanth kernel: [345361.133500] [<ffffffff802ce0b8>] ?
pollwake+0x0/0x48
Dec 1 18:10:48 coelacanth kernel: [345361.133508] [<ffffffff802ce0b8>] ?
pollwake+0x0/0x48
Dec 1 18:10:48 coelacanth kernel: [345361.133517] [<ffffffff804b5d55>] ?
page_fault+0x25/0x30
Dec 1 18:10:48 coelacanth kernel: [345361.133527] [<ffffffff802d34af>] ?
__lookup_mnt+0x12/0x4b
Dec 1 18:10:48 coelacanth kernel: [345361.133536] [<ffffffff802d0120>] ?
__d_lookup+0xc3/0x107
Dec 1 18:10:48 coelacanth kernel: [345361.133545] [<ffffffff8034d69b>] ?
kobject_get+0x12/0x17
Dec 1 18:10:48 coelacanth kernel: [345361.133553] [<ffffffff80342b77>] ?
get_disk+0x47/0x62
Dec 1 18:10:48 coelacanth kernel: [345361.133561] [<ffffffff80342b9e>] ?
exact_lock+0xc/0x14
Dec 1 18:10:48 coelacanth kernel: [345361.133572] [<ffffffff803d4334>] ?
kobj_lookup+0x11e/0x155
Dec 1 18:10:48 coelacanth kernel: [345361.133580] [<ffffffff8034d69b>] ?
kobject_get+0x12/0x17
Dec 1 18:10:48 coelacanth kernel: [345361.133594] [<ffffffffa0104452>] ?
sr_block_open+0x86/0x9f [sr_mod]
Dec 1 18:10:48 coelacanth kernel: [345361.133604] [<ffffffff802e2a01>] ?
__blkdev_get+0x260/0x353
Dec 1 18:10:48 coelacanth kernel: [345361.133613] [<ffffffff802e2afb>] ?
blkdev_open+0x0/0x96
Dec 1 18:10:48 coelacanth kernel: [345361.133621] [<ffffffff802e2b62>] ?
blkdev_open+0x67/0x96
Dec 1 18:10:48 coelacanth kernel: [345361.133630] [<ffffffff802bf505>] ?
__dentry_open+0x148/0x260
Dec 1 18:10:48 coelacanth kernel: [345361.133639] [<ffffffff802ca5cf>] ?
do_filp_open+0x463/0x85a
Dec 1 18:10:48 coelacanth kernel: [345361.133651] [<ffffffff8025b4d9>] ?
getnstimeofday+0x55/0xaf
Dec 1 18:10:48 coelacanth kernel: [345361.133660] [<ffffffff802d2ebc>] ?
alloc_fd+0x67/0x10c
Dec 1 18:10:48 coelacanth kernel: [345361.133668] [<ffffffff802bf315>] ?
do_sys_open+0x4b/0xc8
Dec 1 18:10:48 coelacanth kernel: [345361.133679] [<ffffffff8020fa42>] ?
system_call_fastpath+0x16/0x1b
Dec 1 18:10:48 coelacanth kernel: [345361.133714] INFO: task wodim:29654
blocked for more than 120 seconds.
Dec 1 18:10:48 coelacanth kernel: [345361.133719] "echo 0 >
/proc/sys/kernel/hung_task_timeout_secs" disables this message.
Dec 1 18:10:48 coelacanth kernel: [345361.133726] wodim D
ffff8800280600c0 0 29654 6308
Dec 1 18:10:48 coelacanth kernel: [345361.133736] ffff8801ff1414d0
0000000000000086 ffff880039ffd4c0 ffffffffa002e5c6
Dec 1 18:10:48 coelacanth kernel: [345361.133746] ffff880102c854e8
00000000000120c0 000000000000e250 ffff8800a2f4e8b0
Dec 1 18:10:48 coelacanth kernel: [345361.133756] ffff8800a2f4eba0
00000001a002e834 ffffffff802105ce ffff880102c854e8
Dec 1 18:10:48 coelacanth kernel: [345361.133766] Call Trace:
Dec 1 18:10:48 coelacanth kernel: [345361.133803] [<ffffffffa002e5c6>] ?
scsi_init_io+0x21/0x142 [scsi_mod]
Dec 1 18:10:48 coelacanth kernel: [345361.133813] [<ffffffff802105ce>] ?
apic_timer_interrupt+0xe/0x20
Dec 1 18:10:48 coelacanth kernel: [345361.133829] [<ffffffffa0104bdc>] ?
sr_prep_fn+0x2c/0x4bc [sr_mod]
Dec 1 18:10:48 coelacanth kernel: [345361.133839] [<ffffffff804b45e8>] ?
schedule+0x9/0x1e
Dec 1 18:10:48 coelacanth kernel: [345361.133848] [<ffffffff804b4762>] ?
schedule_timeout+0x1e/0xb6
Dec 1 18:10:48 coelacanth kernel: [345361.133883] [<ffffffffa002e06d>] ?
scsi_request_fn+0x429/0x506 [scsi_mod]
Dec 1 18:10:48 coelacanth kernel: [345361.133893] [<ffffffff804b3cca>] ?
wait_for_common+0xd7/0x148
Dec 1 18:10:48 coelacanth kernel: [345361.133902] [<ffffffff8023bc9a>] ?
default_wake_function+0x0/0x9
Dec 1 18:10:48 coelacanth kernel: [345361.133912] [<ffffffff80340fa0>] ?
blk_execute_rq+0x93/0xab
Dec 1 18:10:48 coelacanth kernel: [345361.133922] [<ffffffff80340c05>] ?
blk_rq_append_bio+0x1b/0x4f
Dec 1 18:10:48 coelacanth kernel: [345361.133931] [<ffffffff80340d9d>] ?
blk_rq_map_user+0x164/0x217
Dec 1 18:10:48 coelacanth kernel: [345361.133940] [<ffffffff8033d994>] ?
freed_request+0x23/0x43
Dec 1 18:10:48 coelacanth kernel: [345361.133948] [<ffffffff80343ef8>] ?
sg_io+0x277/0x392
Dec 1 18:10:48 coelacanth kernel: [345361.133957] [<ffffffff802a1a7c>] ?
zone_statistics+0x3c/0x5d
Dec 1 18:10:48 coelacanth kernel: [345361.133967] [<ffffffff803444a7>] ?
scsi_cmd_ioctl+0x1db/0x3a0
Dec 1 18:10:48 coelacanth kernel: [345361.133975] [<ffffffff802358cb>] ?
update_curr+0x41/0x10e
Dec 1 18:10:48 coelacanth kernel: [345361.133983] [<ffffffff80235c14>] ?
check_preempt_wakeup+0x183/0x1dd
Dec 1 18:10:48 coelacanth kernel: [345361.134001] [<ffffffffa00f8ce0>] ?
cdrom_ioctl+0x2c/0xe86 [cdrom]
Dec 1 18:10:48 coelacanth kernel: [345361.134010] [<ffffffff8023bc9a>] ?
default_wake_function+0x0/0x9
Dec 1 18:10:48 coelacanth kernel: [345361.134022] [<ffffffff802348e4>] ?
__wake_up_common+0x44/0x73
Dec 1 18:10:48 coelacanth kernel: [345361.134030] [<ffffffff80235608>] ?
__wake_up+0x30/0x44
Dec 1 18:10:48 coelacanth kernel: [345361.134044] [<ffffffffa010432a>] ?
sr_block_ioctl+0x49/0x85 [sr_mod]
Dec 1 18:10:48 coelacanth kernel: [345361.134052] [<ffffffff802105ce>] ?
apic_timer_interrupt+0xe/0x20
Dec 1 18:10:48 coelacanth kernel: [345361.134060] [<ffffffff80341f81>] ?
__blkdev_driver_ioctl+0x69/0x7e
Dec 1 18:10:48 coelacanth kernel: [345361.134069] [<ffffffff8034279e>] ?
blkdev_ioctl+0x7e4/0x81a
Dec 1 18:10:48 coelacanth kernel: [345361.134078] [<ffffffff804b456c>] ?
thread_return+0x3e/0xb1
Dec 1 18:10:48 coelacanth kernel: [345361.134087] [<ffffffff80254934>] ?
remove_wait_queue+0x12/0x41
Dec 1 18:10:48 coelacanth kernel: [345361.134095] [<ffffffff80235608>] ?
__wake_up+0x30/0x44
Dec 1 18:10:48 coelacanth kernel: [345361.134104] [<ffffffff802e19a3>] ?
block_ioctl+0x38/0x3c
Dec 1 18:10:48 coelacanth kernel: [345361.134113] [<ffffffff802cc07e>] ?
vfs_ioctl+0x21/0x6c
Dec 1 18:10:48 coelacanth kernel: [345361.134122] [<ffffffff802cc4f4>] ?
do_vfs_ioctl+0x42b/0x464
Dec 1 18:10:48 coelacanth kernel: [345361.134131] [<ffffffff802c142d>] ?
vfs_write+0xcd/0x102
Dec 1 18:10:48 coelacanth kernel: [345361.134139] [<ffffffff802cc57e>] ?
sys_ioctl+0x51/0x70
Dec 1 18:10:48 coelacanth kernel: [345361.134149] [<ffffffff8020fa42>] ?
system_call_fastpath+0x16/0x1b
--
Daniel A. Ramaley
Network Engineer 2
Dial Center 118, Drake University
2407 Carpenter Ave / Des Moines IA 50311 USA
Tel: +1 515 271-4540
Fax: +1 515 271-1938
E-mail: daniel.ramaley at drake.edu
More information about the Cialug
mailing list