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

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