2008-07-29 22:35:22

by Tvrtko Ursulin

[permalink] [raw]
Subject: 2.6.26 DVD playing regression with libata


Howdy,

This will probably be a pretty incomplete bug report because I am short on time at the moment, but please ask for whatever else you might need and I will
try to follow it up.

The story goes like this - I have this MythTV box running Ubuntu 8.04 with their 2.6.24 kernel and DVD playing is pretty flawless. At some point I tried
custom compiled vanilla 2.6.25 and that didn't work to well. From memory, something in the libata-scsi-sr-hardware chain would easily get confused, there
would be numerous error messages logged and whatever.

So couple of days ago I went and tried with 2.6.26. That seems even worse in this respect. First DVD I put in and absolutely nothing happened, media
wasn't recognised at all. Eject button wouldn't work and since it was a "projection" time I had to quickly reboot back to Ubuntu's 2.6.24 which had no
problems with this DVD. Later I picked up the logs and some pieces of relevant information and decided to report it.

Below you will find one line from lspci, excerpt from kernel log and attached is complete 2.6.26 configuration. I hope I am not missing something there?
Hopefully someone will be able to make some sense of it.

Regards,

Tvrtko

00:14.1 IDE interface: ATI Technologies Inc IXP SB400 IDE Controller

Jul 25 19:06:17 media kernel: [ 3.063550] scsi2 : pata_atiixp
Jul 25 19:06:17 media kernel: [ 3.063706] scsi3 : pata_atiixp
Jul 25 19:06:17 media kernel: [ 3.064592] ata3: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0xf900 irq 14
Jul 25 19:06:17 media kernel: [ 3.064595] ata4: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0xf908 irq 15
Jul 25 19:06:17 media kernel: [ 3.234566] ata3.00: ATAPI: TSSTcorpCD/DVDW SH-S182D, SB04, max UDMA/33
Jul 25 19:06:17 media kernel: [ 3.272509] ata3.00: configured for UDMA/33
Jul 25 19:06:17 media kernel: [ 3.424047] scsi 2:0:0:0: CD-ROM TSSTcorp CD/DVDW SH-S182D SB04 PQ: 0 ANSI: 5
Jul 25 19:06:17 media kernel: [ 3.424047] ACPI: PCI Interrupt 0000:02:01.0[A] -> GSI 20 (level, low) -> IRQ 20
Jul 25 19:06:17 media kernel: [ 3.481008] firewire_ohci: Added fw-ohci device 0000:02:01.0, OHCI version 1.0
Jul 25 19:06:17 media kernel: [ 3.483368] ACPI: PCI Interrupt 0000:02:03.0[A] -> GSI 21 (level, low) -> IRQ 21
Jul 25 19:06:17 media kernel: [ 3.484574] eth0: RealTek RTL8139 at 0xde00, 00:17:31:9d:c0:82, IRQ 21
Jul 25 19:06:17 media kernel: [ 3.491374] Driver 'sr' needs updating - please use bus_type methods
Jul 25 19:06:17 media kernel: [ 3.497626] Driver 'sd' needs updating - please use bus_type methods
Jul 25 19:06:17 media kernel: [ 3.497717] sd 0:0:0:0: [sda] 976773168 512-byte hardware sectors (500108 MB)
Jul 25 19:06:17 media kernel: [ 3.497729] sd 0:0:0:0: [sda] Write Protect is off
Jul 25 19:06:17 media kernel: [ 3.497751] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Jul 25 19:06:17 media kernel: [ 3.497799] sd 0:0:0:0: [sda] 976773168 512-byte hardware sectors (500108 MB)
Jul 25 19:06:17 media kernel: [ 3.497809] sd 0:0:0:0: [sda] Write Protect is off
Jul 25 19:06:17 media kernel: [ 3.497830] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Jul 25 19:06:17 media kernel: [ 3.497833] sda:sr0: scsi3-mmc drive: 48x/48x writer dvd-ram cd/rw xa/form2 cdda tray
Jul 25 19:06:17 media kernel: [ 3.498561] Uniform CD-ROM driver Revision: 3.20
Jul 25 19:06:17 media kernel: [ 3.501805] sd 0:0:0:0: Attached scsi generic sg0 type 0
Jul 25 19:06:17 media kernel: [ 3.501827] sr 2:0:0:0: Attached scsi generic sg1 type 5
[snip]
Jul 29 21:10:03 media kernel: [353032.319013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.319013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.319013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.319013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320016] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320025] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320034] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320043] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320053] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320062] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320071] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320077] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320083] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320090] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320096] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.320102] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.430059] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.430090] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer
Jul 29 21:10:03 media kernel: [353032.477013] sr 2:0:0:0: [sr0] unaligned transfer


Attachments:
(No filename) (6.29 kB)
config-2.6.26 (51.68 kB)
Download all attachments

2008-07-29 23:37:40

by Alan

[permalink] [raw]
Subject: Re: 2.6.26 DVD playing regression with libata

> Jul 29 21:10:03 media kernel: [353032.319013] sr 2:0:0:0: [sr0] unaligned transfer
> Jul 29 21:10:03 media kernel: [353032.319013] sr 2:0:0:0: [sr0] unaligned transfer

This is coming from the scsi/block layer and definitely isn't good.
Doesn't directly look like a libata bug but seems to be higher up the
stack. What software is triggering this ?

2008-07-30 06:57:43

by Tvrtko Ursulin

[permalink] [raw]
Subject: Re: 2.6.26 DVD playing regression with libata

On Wednesday 30 July 2008 00:20:11 Alan Cox wrote:
> > Jul 29 21:10:03 media kernel: [353032.319013] sr 2:0:0:0: [sr0] unaligned
> > transfer Jul 29 21:10:03 media kernel: [353032.319013] sr 2:0:0:0: [sr0]
> > unaligned transfer
>
> This is coming from the scsi/block layer and definitely isn't good.
> Doesn't directly look like a libata bug but seems to be higher up the
> stack. What software is triggering this ?

I tried to reproduce it now but could not.

After a fresh boot into 2.6.26, I first tried mounting the DVD which was fine. Then I ran lsdvd which also worked and finally mplayer without any problems. In
contrast to that yesterday I ran my playdvd.pl (http://www.ursulin.net/2008/06/effectively-using-mplayer-within-mythtv/) script from within MythTV and it
exited immediately. It looked like either it triggered that failure without any delay or subsystem was already in that failure mode by simple DVD insertion.
When ran directly lsdvd would exit being unable to open /dev/dvd (/dev/scdo). Unfortunately I didn't debug it further at the time.

The only difference is that yesterday box had an uptime of couple of days while this morning it was completely fresh. Unless mounting the disc before
everything else somehow stabilised something. Hm let me do another reboot... no, still can't reproduce it.

One interesting thing, sometimes it detects drive capabilities like this:
[ 3.498951] sr0: scsi3-mmc drive: 62x/62x writer dvd-ram cd/rw xa/form2 cdda tray

And sometimes like this:
[ 3.514104] sr0: scsi3-mmc drive: 48x/48x writer dvd-ram cd/rw xa/form2 cdda tray

Later I think is correct according to drive datasheet.

I will keep 2.6.26 running and see if the problem comes back in following days.

Tvrtko

2008-07-30 06:59:47

by Justin P. Mattock

[permalink] [raw]
Subject: Re: 2.6.26 DVD playing regression with libata

On Tue, Jul 29, 2008 at 11:57 PM, Tvrtko A. Ursulin <[email protected]> wrote:
> On Wednesday 30 July 2008 00:20:11 Alan Cox wrote:
>> > Jul 29 21:10:03 media kernel: [353032.319013] sr 2:0:0:0: [sr0] unaligned
>> > transfer Jul 29 21:10:03 media kernel: [353032.319013] sr 2:0:0:0: [sr0]
>> > unaligned transfer
>>
>> This is coming from the scsi/block layer and definitely isn't good.
>> Doesn't directly look like a libata bug but seems to be higher up the
>> stack. What software is triggering this ?
>
> I tried to reproduce it now but could not.
>
> After a fresh boot into 2.6.26, I first tried mounting the DVD which was fine. Then I ran lsdvd which also worked and finally mplayer without any problems. In
> contrast to that yesterday I ran my playdvd.pl (http://www.ursulin.net/2008/06/effectively-using-mplayer-within-mythtv/) script from within MythTV and it
> exited immediately. It looked like either it triggered that failure without any delay or subsystem was already in that failure mode by simple DVD insertion.
> When ran directly lsdvd would exit being unable to open /dev/dvd (/dev/scdo). Unfortunately I didn't debug it further at the time.
>
> The only difference is that yesterday box had an uptime of couple of days while this morning it was completely fresh. Unless mounting the disc before
> everything else somehow stabilised something. Hm let me do another reboot... no, still can't reproduce it.
>
> One interesting thing, sometimes it detects drive capabilities like this:
> [ 3.498951] sr0: scsi3-mmc drive: 62x/62x writer dvd-ram cd/rw xa/form2 cdda tray
>
> And sometimes like this:
> [ 3.514104] sr0: scsi3-mmc drive: 48x/48x writer dvd-ram cd/rw xa/form2 cdda tray
>
> Later I think is correct according to drive datasheet.
>
> I will keep 2.6.26 running and see if the problem comes back in following days.
>
> Tvrtko
> --
> To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> the body of a message to [email protected]
> More majordomo info at http://vger.kernel.org/majordomo-info.html
> Please read the FAQ at http://www.tux.org/lkml/
>

I usually see these errors with mplayer i.g. insert a dvd
then press play instead of waiting for the dvd to settle down.

--
Justin P. Mattock

2008-07-30 07:08:37

by Tvrtko Ursulin

[permalink] [raw]
Subject: Re: 2.6.26 DVD playing regression with libata


On Wednesday 30 July 2008 07:59:34 Justin Mattock wrote:

[snip]
> I usually see these errors with mplayer i.g. insert a dvd
> then press play instead of waiting for the dvd to settle down.

As transients or do you also have more serious problems when it happens? Or in
other words, does it recover and play, or gets confused for good?

Tvrtko

2008-07-30 07:17:25

by Justin P. Mattock

[permalink] [raw]
Subject: Re: 2.6.26 DVD playing regression with libata

On Wed, Jul 30, 2008 at 12:08 AM, Tvrtko A. Ursulin <[email protected]> wrote:
>
> On Wednesday 30 July 2008 07:59:34 Justin Mattock wrote:
>
> [snip]
>> I usually see these errors with mplayer i.g. insert a dvd
>> then press play instead of waiting for the dvd to settle down.
>
> As transients or do you also have more serious problems when it happens? Or in
> other words, does it recover and play, or gets confused for good?
>
> Tvrtko
>

It gets confused for good.
attached is dmesg:

--
Justin P. Mattock


Attachments:
(No filename) (513.00 B)
sr0 (65.67 kB)
Download all attachments