2.5.21: "ata_task_file: unknown command 50"

2.5.21: "ata_task_file: unknown command 50"

[Gert Vervoort]

kernel 2.5.21 hangs with repeating the message "ata_task_file: unknown command 50" forever.

2.5.21: "ata_task_file: unknown command 50"

[Miles Lane]

Gert wrote:
 > kernel 2.5.21 hangs with repeating the message "ata_task_file: 
unknown command 50" forever.

I am getting this hang as well.

00:00.0 Host bridge: Advanced Micro Devices [AMD] AMD-751 [Irongate] 
System Controller (rev 25)
00:01.0 PCI bridge: Advanced Micro Devices [AMD] AMD-751 [Irongate] AGP 
Bridge (rev 01)
00:07.0 ISA bridge: Advanced Micro Devices [AMD] AMD-756 [Viper] ISA 
(rev 01)
00:07.1 IDE interface: Advanced Micro Devices [AMD] AMD-756 [Viper] IDE 
(rev 03)00:07.3 Bridge: Advanced Micro Devices [AMD] AMD-756 [Viper] 
ACPI (rev 03)

# ATA and ATAPI Block devices
#
CONFIG_BLK_DEV_IDE=y

#
# Please see Documentation/ide.txt for help/info on IDE drives
#
CONFIG_BLK_DEV_IDEDISK=y
CONFIG_IDEDISK_MULTI_MODE=y
CONFIG_BLK_DEV_IDECD=y
CONFIG_BLK_DEV_IDESCSI=y

#
#   PCI host chip set support
#
CONFIG_IDEPCI_SHARE_IRQ=y
CONFIG_BLK_DEV_IDEDMA_PCI=y
CONFIG_IDEDMA_PCI_AUTO=y
CONFIG_BLK_DEV_IDEDMA=y
CONFIG_BLK_DEV_AMD74XX=y
CONFIG_ATAPI=y
CONFIG_IDEDMA_AUTO=y

idetool says:

keep settings: Invalid argument
'Model' 'QUANTUM FIREBALLP LM30'
'Firmware' 'A35.0700'
'Serial No.' '18600683'
'Geometry' '16383/16/63'
'Cache' '1900Kb (Dual Port Cache)'
'Status' 'Active/Idle'
'DMA Mode' 'Enabled'
'IO Mode' '32-bit'
'IRQ Unmask' 'Enabled'
'Multisector' 'No'
'On Reset' 'Keep settings'
keep settings: Invalid argument
multi: Invalid argument

This chunk of a 2.5.15 log should give a good idea of
the configuration:

md: linear personality registered as nr 1
md: raid0 personality registered as nr 2
md: md driver 0.90.0 MAX_MD_DEVS=256, MD_SB_DISKS=27
md: Autodetecting RAID arrays.
  [events: 000000f4]
  [events: 000000f4]
md: autorun ...
md: considering hda12 ...
md:  adding hda12 ...
md:  adding hda11 ...
md: created md0
md: bind<hda11,1>
md0: WARNING: hda12 appears to be on the same physical disk as hda11. True
      protection against single-disk failure might be compromised.
md: bind<hda12,2>
md: running: <hda12><hda11>
md: hda12's event counter: 000000f4
md: hda11's event counter: 000000f4
md0: max total readahead window set to 512k
md0: 2 data-disks, max readahead per data-disk: 256k
raid0: looking at hda11
raid0:   comparing hda11(1028032) with hda11(1028032)
raid0:   END
raid0:   ==> UNIQUE
raid0: 1 zones
raid0: looking at hda12
raid0:   comparing hda12(1028032) with hda11(1028032)
raid0:   EQUAL
raid0: FINAL 1 zones
raid0: zone 0
raid0: checking hda11 ... contained as device 0
   (1028032) is smallest!.
raid0: checking hda12 ... contained as device 1
raid0: zone->nb_dev: 2, size: 2056064
raid0: current zone offset: 1028032
raid0: done.
raid0 : md_size is 2056064 blocks.
raid0 : conf->smallest->size is 2056064 blocks.
raid0 : nb_zone is 1.
raid0 : Allocating 8 bytes for hash.
md: updating md0 RAID superblock on device
md: hda12 [events: 000000f5]<6>(write) hda12's sb offset: 1028032
md: hda11 [events: 000000f5]<6>(write) hda11's sb offset: 1028032
md: ... autorun DONE.
EXT3-fs: INFO: recovery required on readonly filesystem.
EXT3-fs: write access will be enabled during recovery.
kjournald starting.  Commit interval 5 seconds
EXT3-fs: ide0(3,6): orphan cleanup on readonly fs
EXT3-fs: ide0(3,6): 18 orphan inodes deleted
EXT3-fs: recovery complete.
EXT3-fs: mounted filesystem with ordered data mode.
EXT3 FS 2.4-0.9.16, 02 Dec 2001 on ide0(3,6), internal journal
kjournald starting.  Commit interval 5 seconds
EXT3 FS 2.4-0.9.16, 02 Dec 2001 on ide0(3,5), internal journal
EXT3-fs: mounted filesystem with ordered data mode.
kjournald starting.  Commit interval 5 seconds
EXT3 FS 2.4-0.9.16, 02 Dec 2001 on md(9,0), internal journal
EXT3-fs: mounted filesystem with ordered data mode.

Re: 2.5.21: "ata_task_file: unknown command 50"

[Gert Vervoort]

> kernel 2.5.21 hangs with repeating the message "ata_task_file: unknown command 50" forever.

more information of my system from 2.5.20 boot log:

Jun  3 20:53:32 viper kernel: ATA/ATAPI device driver v7.0.0
Jun  3 20:53:32 viper kernel: ATA: PCI bus speed 33.3MHz
Jun  3 20:53:32 viper kernel: ATA: Intel Corp. 82371AB PIIX4 IDE, PCI slot 00:07.1
Jun  3 20:53:32 viper kernel: ATA: chipset rev.: 1
Jun  3 20:53:32 viper kernel: ATA: non-legacy mode: IRQ probe delayed
Jun  3 20:53:32 viper kernel: PIIX: Intel Corp. 82371AB PIIX4 IDE UDMA33 controller on pci00:07.1
Jun  3 20:53:32 viper kernel:     ide0: BM-DMA at 0xf000-0xf007, BIOS settings: hda:pio, hdb:pio
Jun  3 20:53:32 viper kernel:     ide1: BM-DMA at 0xf008-0xf00f, BIOS settings: hdc:pio, hdd:pio
Jun  3 20:53:32 viper kernel: hda: Maxtor 90845D4, DISK drive
Jun  3 20:53:32 viper kernel: hdb: LITEON DVD-ROM LTD122, ATAPI CD/DVD-ROM drive
Jun  3 20:53:32 viper kernel: hdc: PHILIPS PCA460RW, ATAPI CD/DVD-ROM drive
Jun  3 20:53:32 viper kernel: ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
Jun  3 20:53:32 viper kernel: ide1 at 0x170-0x177,0x376 on irq 15
Jun  3 20:53:32 viper kernel:  hda: 16514064 sectors w/512KiB Cache, CHS=16383/16/63, UDMA(33)
Jun  3 20:53:32 viper kernel:  hda: [PTBL] [1027/255/63] hda1 hda2 < hda5 hda6 hda7 hda8 >
Jun  3 20:53:32 viper kernel: hdb: ATAPI 40X DVD-ROM drive, 512kB Cache, UDMA(33)
Jun  3 20:53:32 viper kernel: Uniform CD-ROM driver Revision: 3.12
Jun  3 20:53:32 viper kernel: SCSI subsystem driver Revision: 1.00
Jun  3 20:53:32 viper kernel: scsi0 : SCSI host adapter emulation for ATAPI devices
Jun  3 20:53:32 viper kernel:   Vendor: PHILIPS   Model: PCA460RW          Rev: 1.0g
Jun  3 20:53:32 viper kernel:   Type:   CD-ROM                             ANSI SCSI revision: 02
Jun  3 20:53:32 viper kernel: ppa: Version 2.07 (for Linux 2.4.x)
Jun  3 20:53:32 viper kernel: ppa: Found device at ID 6, Attempting to use EPP 16 bit
Jun  3 20:53:32 viper kernel: ppa: Communication established with ID 6 using EPP 16 bit
Jun  3 20:53:32 viper kernel: scsi1 : Iomega VPI0 (ppa) interface
Jun  3 20:53:32 viper kernel:   Vendor: IOMEGA    Model: ZIP 100           Rev: D.13
Jun  3 20:53:32 viper kernel:   Type:   Direct-Access                      ANSI SCSI revision: 02
Jun  3 20:53:32 viper kernel: Attached scsi removable disk sda at scsi1, channel 0, id 6, lun 0
Jun  3 20:53:32 viper kernel: sda : READ CAPACITY failed.
Jun  3 20:53:32 viper kernel: sda : status=1, message=00, host=0, driver=08 
Jun  3 20:53:32 viper kernel: Current sd00:00: sense key Not Ready
Jun  3 20:53:32 viper kernel: Additional sense indicates Medium not present
Jun  3 20:53:32 viper kernel: sda : block size assumed to be 512 bytes, disk size 1GB.  
Jun  3 20:53:32 viper kernel:  sda:end_request: I/O error, dev 08:00, sector 0
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 0
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 1
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 2
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 3
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 4
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 5
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 6
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 7
Jun  3 20:53:32 viper kernel: end_request: I/O error, dev 08:00, sector 0
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 0
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 1
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 2
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 3
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 4
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 5
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 6
Jun  3 20:53:32 viper kernel: Buffer I/O error on device sd(8,0), logical block 7
Jun  3 20:53:32 viper kernel:  unable to read partition table
Jun  3 20:53:32 viper kernel: Attached scsi CD-ROM sr0 at scsi0, channel 0, id 0, lun 0
Jun  3 20:53:32 viper kernel: sr0: scsi3-mmc drive: 16x/16x writer cd/rw xa/form2 cdda tray

FORMAT OPCODE == (Re: 2.5.21: "ata_task_file: unknown command 50")

[Andre Hedrick]

Why the hell is the kernel sending down a low-level format command to
media?  How stupid can we get in writing a driver?  What next, modify the
microcode on the devices between boots and kernels?

Do backup between boots if this kind of crap is going in to the base
driver.  Even MircoSoft has more brains than to permit this rogue from
their product.

Andre Hedrick
LAD Storage Consulting Group

On Sun, 9 Jun 2002, Gert Vervoort wrote:

> 
> kernel 2.5.21 hangs with repeating the message "ata_task_file: unknown command 50" forever.
> -
> To unsubscribe from this list: send the line "unsubscribe linux-kernel" in
> the body of a message to majordomo@vger.kernel.org
> More majordomo info at  http://vger.kernel.org/majordomo-info.html
> Please read the FAQ at  http://www.tux.org/lkml/
> 

Re: 2.5.21: "ata_task_file: unknown command 50"

[Miles Lane]

Now, I managed to work around this lockup by not using
the AMD IDE chipset support.  I no longer get the hang
or the "ata_task_file: unknown command 50" message.
Unfortunately, my 800MHz Athlon machine's performance has
dropped into the toilet with this configuration and 2.5.21.

/dev/hda:
  Timing buffered disk reads:  64 MB in 13.51 seconds =  4.74 MB/sec
/dev/hda:
  Timing buffer-cache reads:   128 MB in  0.85 seconds =150.59 MB/sec
/dev/hda:
  Model=QUANTUM FIREBALLP LM30, FwRev=A35.0700, SerialNo=186006831114
  Config={ HardSect NotMFM HdSw>15uSec Fixed DTR>10Mbs }
  RawCHS=16383/16/63, TrkSize=32256, SectSize=21298, ECCbytes=4
  BuffType=DualPortCache, BuffSize=1900kB, MaxMultSect=16, MultSect=off
  CurCHS=16383/16/63, CurSects=-66060037, LBA=yes, LBAsects=58633344
  IORDY=on/off, tPIO={min:120,w/IORDY:120}, tDMA={min:120,rec:120}
  PIO modes: pio0 pio1 pio2 pio3 pio4
  DMA modes: mdma0 mdma1 mdma2 udma0 udma1 udma2 udma3 *udma4
  AdvancedPM=no
  Drive Supports : ATA/ATAPI-5 T13 1321D revision 1 : ATA-1 ATA-2 ATA-3 
ATA-4 ATA-5

Also, I am getting some very scary kernel log messages:

hda: lost interrupt
raid0_make_request bug: can't convert block across chunks or bigger than 
64k 94712 8
raid0_make_request bug: can't convert block across chunks or bigger than 
64k 1340144 12
raid0_make_request bug: can't convert block across chunks or bigger than 
64k 1342192 20

I am getting long periodic hangs of up to 10 seconds where the only 
thing that
responds is the mouse.  Then, everything wakes up for a while.

This kernel has several patches applied, which got it to build:

	vmalloc patch
	Martin's ide-clean-86 patch
	Martin's locks patch
	emu10k1 patch
	ALSA misc.c patch

My configuration:


Jun 10 00:08:15 turbulence kernel: ATA/ATAPI device driver v7.0.0
Jun 10 00:08:15 turbulence kernel: ATA: PCI bus speed 33.3MHz
Jun 10 00:08:15 turbulence kernel: ATA: unknown interface: Advanced 
Micro Devices [AMD] AMD-756 [Viper] IDE, PCI slot 00:07.1
Jun 10 00:08:16 turbulence kernel: hda: QUANTUM FIREBALLP LM30, DISK drive
Jun 10 00:08:16 turbulence kernel: hdc: Pioneer DVD-ROM ATAPIModel 
DVD-114 0117, ATAPI CD/DVD-ROM drive
Jun 10 00:08:16 turbulence kernel: hdd: R/RW 4x4x24, ATAPI CD/DVD-ROM drive
Jun 10 00:08:16 turbulence kernel: ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
Jun 10 00:08:26 turbulence kernel: ide1 at 0x170-0x177,0x376 on irq 15
Jun 10 00:08:26 turbulence kernel:  hda: 58633344 sectors w/1900KiB 
Cache, CHS=58168/16/63
Jun 10 00:08:26 turbulence kernel:  hda: [PTBL] [3649/255/63] hda1 hda2 
< hda5 hda6 hda7 hda8 hda9 hda10 hda11 hda12 hda13 >
Jun 10 00:08:26 turbulence kernel: SCSI subsystem driver Revision: 1.00
Jun 10 00:08:26 turbulence kernel: scsi0 : Adaptec AIC7XXX EISA/VLB/PCI 
SCSI HBA DRIVER, Rev 6.2.4
Jun 10 00:08:26 turbulence kernel:         <Adaptec 2930CU SCSI adapter>
Jun 10 00:08:26 turbulence kernel:         aic7860: Ultra Single Channel 
A, SCSI Id=7, 3/253 SCBs
Jun 10 00:08:36 turbulence kernel: md: linear personality registered as nr 1
Jun 10 00:08:36 turbulence kernel: md: raid0 personality registered as nr 2
Jun 10 00:08:37 turbulence kernel: md: md driver 0.90.0 MAX_MD_DEVS=256, 
MD_SB_DISKS=27
Jun 10 00:08:37 turbulence kernel: md: Autodetecting RAID arrays.
Jun 10 00:08:37 turbulence kernel:  [events: 000000f5]
Jun 10 00:08:37 turbulence kernel:  [events: 000000f5]
Jun 10 00:08:37 turbulence kernel: md: autorun ...
Jun 10 00:08:37 turbulence kernel: md: considering hda12 ...
Jun 10 00:08:47 turbulence kernel: md:  adding hda12 ...
Jun 10 00:08:47 turbulence kernel: md:  adding hda11 ...
Jun 10 00:08:47 turbulence kernel: md: created md0
Jun 10 00:08:47 turbulence kernel: md: bind<hda11,1>
Jun 10 00:08:47 turbulence kernel: md0: WARNING: hda12 appears to be on 
the same physical disk as hda11. True
Jun 10 00:08:47 turbulence kernel:      protection against single-disk 
failure might be compromised.
Jun 10 00:08:47 turbulence kernel: md: bind<hda12,2>
Jun 10 00:08:47 turbulence kernel: md: running: <hda12><hda11>
Jun 10 00:08:47 turbulence kernel: md: hda12's event counter: 000000f5
Jun 10 00:08:47 turbulence kernel: md: hda11's event counter: 000000f5
Jun 10 00:08:47 turbulence kernel: md0: max total readahead window set 
to 512k
Jun 10 00:08:47 turbulence kernel: md0: 2 data-disks, max readahead per 
data-disk: 256k
Jun 10 00:08:47 turbulence kernel: raid0: looking at hda11
Jun 10 00:08:47 turbulence kernel: raid0:   comparing hda11(1028032) 
with hda11(1028032)
Jun 10 00:08:47 turbulence kernel: raid0:   END
Jun 10 00:08:47 turbulence kernel: raid0:   ==> UNIQUE
Jun 10 00:08:47 turbulence kernel: raid0: 1 zones
Jun 10 00:08:47 turbulence kernel: raid0: looking at hda12
Jun 10 00:08:47 turbulence kernel: raid0:   comparing hda12(1028032) 
with hda11(1028032)
Jun 10 00:08:47 turbulence kernel: raid0:   EQUAL
Jun 10 00:08:47 turbulence kernel: raid0: FINAL 1 zones
Jun 10 00:08:47 turbulence kernel: raid0: zone 0
Jun 10 00:08:48 turbulence kernel: raid0: checking hda11 ... contained 
as device 0
Jun 10 00:08:48 turbulence kernel:   (1028032) is smallest!.
Jun 10 00:08:48 turbulence kernel: raid0: checking hda12 ... contained 
as device 1
Jun 10 00:08:48 turbulence kernel: raid0: zone->nb_dev: 2, size: 2056064
Jun 10 00:08:48 turbulence kernel: raid0: current zone offset: 1028032
Jun 10 00:08:58 turbulence kernel: raid0: done.
Jun 10 00:08:58 turbulence kernel: raid0 : md_size is 2056064 blocks.
Jun 10 00:09:08 turbulence kernel: raid0 : conf->smallest->size is 
2056064 blocks.
Jun 10 00:09:08 turbulence kernel: raid0 : nb_zone is 1.
Jun 10 00:09:09 turbulence kernel: raid0 : Allocating 8 bytes for hash.
Jun 10 00:09:09 turbulence kernel: md: updating md0 RAID superblock on 
device
Jun 10 00:09:09 turbulence kernel: md: hda12 [events: 
000000f6]<6>(write) hda12's sb offset: 1028032
Jun 10 00:09:09 turbulence kernel: md: hda11 [events: 
000000f6]<6>(write) hda11's sb offset: 1028032
Jun 10 00:09:09 turbulence kernel: md: ... autorun DONE.

Re: 2.5.21: "ata_task_file: unknown command 50"

[Svetoslav Slavtchev]

>raid0_make_request bug: can't convert block across chunks or bigger than 
>64k 94712 8
>raid0_make_request bug: can't convert block across chunks or bigger than 
>64k 1340144 12
>raid0_make_request bug: can't convert block across chunks or bigger than 
>64k 1342192 20

that's a problem of the raid-0 code
it needs a request splitter and/or more bio changes
it's here since 2.5.5 AFAIK 
are you using raid

i'm useing lvm over soft raid-0 and i can not mount my
xfs LV's because of that

svetljo  

Re: 2.5.21: "ata_task_file: unknown command 50"

[Skip Ford]

Miles Lane wrote:
> This kernel has several patches applied, which got it to build:
> 
> 	vmalloc patch

If that's the patch I sent then you should reverse it and apply the
patch Anton sent.  I got it wrong.  It won't affect any of the errors
you're getting though.

I'm including his patch in case you need it...


--- tng/kernel/ksyms.c.old	Mon Jun 10 03:19:58 2002
+++ tng/kernel/ksyms.c	Mon Jun 10 03:21:18 2002
@@ -108,6 +108,9 @@ EXPORT_SYMBOL(kmalloc);
 EXPORT_SYMBOL(kfree);
 EXPORT_SYMBOL(vfree);
 EXPORT_SYMBOL(__vmalloc);
+EXPORT_SYMBOL(vmalloc);
+EXPORT_SYMBOL(vmalloc_dma);
+EXPORT_SYMBOL(vmalloc_32);
 EXPORT_SYMBOL(vmalloc_to_page);
 EXPORT_SYMBOL(mem_map);
 EXPORT_SYMBOL(remap_page_range);


-- 
Skip

Re: 2.5.21: "ata_task_file: unknown command 50"

[Martin Dalecki]

Miles Lane wrote:
> Gert wrote:
>  > kernel 2.5.21 hangs with repeating the message "ata_task_file: 
> unknown command 50" forever.


IDE 86 should fix it.

Re: 2.5.21: "ata_task_file: unknown command 50"

[Martin Dalecki]

Zwane Mwaikambo wrote:
> On Mon, 10 Jun 2002, Martin Dalecki wrote:
> 
> 
>>Miles Lane wrote:
>>
>>>Gert wrote:
>>> > kernel 2.5.21 hangs with repeating the message "ata_task_file: 
>>>unknown command 50" forever.
>>
>>
>>IDE 86 should fix it.
> 
> 
> What is command 50?
> 
> Thanks,
> 	Zwane

hdregs.h will tell you.
But it really doesn't matter. The problem is that ide-scsi
was using REQ_SEPCIAL where it should be using REQ_PC in first
palce.

Re: 2.5.21: "ata_task_file: unknown command 50"

[Zwane Mwaikambo]

On Mon, 10 Jun 2002, Martin Dalecki wrote:

> Miles Lane wrote:
> > Gert wrote:
> >  > kernel 2.5.21 hangs with repeating the message "ata_task_file: 
> > unknown command 50" forever.
> 
> 
> IDE 86 should fix it.

What is command 50?

Thanks,
	Zwane
-- 
http://function.linuxpower.ca
		

Re: 2.5.21: "ata_task_file: unknown command 50"

[Thunder from the hill]

Hi,

On Mon, 10 Jun 2002, Zwane Mwaikambo wrote:
> What is command 50?

According to Andre Hedrick, it's Low Level Format.

Regards,
Thunder
-- 
German attitude becoming        |	Thunder from the hill at ngforever
rightaway popular:		|
       "Get outa my way,  	|	free inhabitant not directly
    for I got a mobile phone!"	|	belonging anywhere

Re: 2.5.21: "ata_task_file: unknown command 50"

[Gert Vervoort]

Martin Dalecki wrote:
> 
> Miles Lane wrote:
> > Gert wrote:
> >  > kernel 2.5.21 hangs with repeating the message "ata_task_file:
> > unknown command 50" forever.
> 
> IDE 86 should fix it.

Yes, this patch fixes it.

Re: 2.5.21: "ata_task_file: unknown command 50"

[Miles Lane]

On Mon, 2002-06-10 at 02:55, Svetoslav Slavtchev wrote:
> >raid0_make_request bug: can't convert block across chunks or bigger than 
> >64k 94712 8
> >raid0_make_request bug: can't convert block across chunks or bigger than 
> >64k 1340144 12
> >raid0_make_request bug: can't convert block across chunks or bigger than 
> >64k 1342192 20
> 
> that's a problem of the raid-0 code
> it needs a request splitter and/or more bio changes
> it's here since 2.5.5 AFAIK 
> are you using raid
> 
> i'm useing lvm over soft raid-0 and i can not mount my
> xfs LV's because of that

Yeah, I am using software raid0, as well.

	Miles