Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Andrew Morton]

> On Thu, 1 Nov 2007 23:30:13 +0200 "Denys" <denys@visp.net.lb> wrote:
> Finally i got full DMESG with 1GB card till end. Seems not readable too.
> 
> Linux version 2.6.24-rc1-git10-embedded (root@homecore.visp.net.lb) (gcc 
> version 4.1.2 (Gentoo 4.1.2 p1.0.1)) #1 Thu Nov 1 23:12:53 EET 2007
> BIOS-provided physical RAM map:
>  BIOS-e801: 0000000000000000 - 000000000009f000 (usable)
>  BIOS-e801: 0000000000100000 - 0000000004000000 (usable)
> 64MB LOWMEM available.
> Zone PFN ranges:
>   DMA             0 ->     4096
>   Normal       4096 ->    16384
> Movable zone start PFN for each node
> early_node_map[1] active PFN ranges
>     0:        0 ->    16384
> DMI not present or invalid.
> Allocating PCI resources starting at 10000000 (gap: 04000000:fc000000)
> Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 16256
> Kernel command line: console=ttyS0,38400n8
> Initializing CPU#0
> PID hash table entries: 256 (order: 8, 1024 bytes)
> Detected 266.627 MHz processor.
> Console: colour dummy device 80x25
> console [ttyS0] enabled
> Dentry cache hash table entries: 8192 (order: 3, 32768 bytes)
> Inode-cache hash table entries: 4096 (order: 2, 16384 bytes)
> Memory: 62836k/65536k available (1020k kernel code, 2292k reserved, 317k 
> data, 112k init, 0k highmem)
> virtual kernel memory layout:
>     fixmap  : 0xffffb000 - 0xfffff000   (  16 kB)
>     vmalloc : 0xc4800000 - 0xffff9000   ( 951 MB)
>     lowmem  : 0xc0000000 - 0xc4000000   (  64 MB)
>       .init : 0xc0252000 - 0xc026e000   ( 112 kB)
>       .data : 0xc01ff111 - 0xc024e6f4   ( 317 kB)
>       .text : 0xc0100000 - 0xc01ff111   (1020 kB)
> Checking if this processor honours the WP bit even in supervisor mode... Ok.
> SLUB: Genslabs=11, HWalign=32, Order=0-1, MinObjects=4, CPUs=1, Nodes=1
> Calibrating delay using timer specific routine.. 534.41 BogoMIPS (lpj=1068836)
> Mount-cache hash table entries: 512
> Compat vDSO mapped to ffffe000.
> CPU: NSC Unknown stepping 01
> Checking 'hlt' instruction... OK.
> Freeing SMP alternatives: 0k freed
> net_namespace: 64 bytes
> NET: Registered protocol family 16
> PCI: PCI BIOS revision 2.10 entry at 0xfc3ad, last bus=0
> PCI: Using configuration type 1
> Setting up standard PCI resources
> SCSI subsystem initialized
> PCI: Probing PCI hardware
> PCI: Device 0000:00:12.5 not found by BIOS
> Time: tsc clocksource has been installed.
> NET: Registered protocol family 2
> IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
> TCP established hash table entries: 2048 (order: 2, 16384 bytes)
> TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
> TCP: Hash tables configured (established 2048 bind 2048)
> TCP reno registered
> scx200: NatSemi SCx200 Driver
> scx200: GPIO base 0xf400
> scx200: Configuration Block base 0x9000
> io scheduler noop registered (default)
> Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing disabled
> serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a NS16550A
> serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a NS16550A
> natsemi dp8381x driver, version 2.1, Sept 11, 2006
>   originally by Donald Becker <becker@scyld.com>
>   2.4.x kernel port by Jeff Garzik, Tjeerd Mulder
> natsemi eth0: NatSemi DP8381[56] at 0x80000000 (0000:00:0e.0), 
> 00:0d:b9:00:8a:30, IRQ 10, port TP.
> scsi0 : sc1200
> scsi1 : sc1200
> ata1: PATA max UDMA/33 cmd 0x1f0 ctl 0x3f6 bmdma 0xfc00 irq 14
> ata2: DUMMY
> ata1.00: CFA: SanDisk SDCFH-1024, HDX 3.07, max MWDMA2
> ata1.00: 2001888 sectors, multi 0: LBA
> ata1.00: configured for MWDMA2
> scsi 0:0:0:0: Direct-Access     ATA      SanDisk SDCFH-10 HDX  PQ: 0 ANSI: 5
> sd 0:0:0:0: [sda] 2001888 512-byte hardware sectors (1025 MB)
> sd 0:0:0:0: [sda] Write Protect is off
> sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support 
> DPO or FUA
> sd 0:0:0:0: [sda] 2001888 512-byte hardware sectors (1025 MB)
> sd 0:0:0:0: [sda] Write Protect is off
> sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support 
> DPO or FUA
>  sda:<4>Clocksource tsc unstable (delta = -334501841 ns)
> Time: pit clocksource has been installed.
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA2
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA2
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA2
> ata1: EH complete
> ata1.00: limiting speed to MWDMA1:PIO4
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA1
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA1
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA1
> sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
> sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
> Descriptor sense data with sense descriptors (in hex):
>         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
>         00 00 00 00
> sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
> end_request: I/O error, dev sda, sector 0
> Buffer I/O error on device sda, logical block 0
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA1
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA1
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA1
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA1
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA1
> ata1: EH complete
> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA1
> sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
> sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
> Descriptor sense data with sense descriptors (in hex):
>         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
>         00 00 00 00
> sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
> end_request: I/O error, dev sda, sector 0
> Buffer I/O error on device sda, logical block 0
> ata1: EH complete
>  unable to read partition table
> sd 0:0:0:0: [sda] Attached SCSI removable disk
> scx200_wdt: timer margin 60 seconds
> cpuidle: using governor ladder
> enabling scx200 high-res timer (1 MHz +0 ppm)
> TCP cubic registered
> Time: scx200_hrt clocksource has been installed.
> NET: Registered protocol family 1
> NET: Registered protocol family 17
> Using IPI Shortcut mode
> VFS: Cannot open root device "<NULL>" or unknown-block(8,18)
> Please append a correct "root=" boot option; here are the available 
> partitions:
> 0800    1000944 sda driver: sd
> Kernel panic - not syncing: VFS: Unable to mount root fs on unknown-
> block(8,18)
> 

(+linux-ide)

So this has never worked on any known kernel?

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Denys Fedoryshchenko]

On Tue, 6 Nov 2007 22:15:21 -0800, Andrew Morton wrote
> > On Thu, 1 Nov 2007 23:30:13 +0200 "Denys" <denys@visp.net.lb> wrote:
> > Finally i got full DMESG with 1GB card till end. Seems not readable too.
> > 
> > Linux version 2.6.24-rc1-git10-embedded (root@homecore.visp.net.lb) (gcc 
> > version 4.1.2 (Gentoo 4.1.2 p1.0.1)) #1 Thu Nov 1 23:12:53 EET 2007
> > BIOS-provided physical RAM map:
> >  BIOS-e801: 0000000000000000 - 000000000009f000 (usable)
> >  BIOS-e801: 0000000000100000 - 0000000004000000 (usable)
> > 64MB LOWMEM available.
> > Zone PFN ranges:
> >   DMA             0 ->     4096
> >   Normal       4096 ->    16384
> > Movable zone start PFN for each node
> > early_node_map[1] active PFN ranges
> >     0:        0 ->    16384
> > DMI not present or invalid.
> > Allocating PCI resources starting at 10000000 (gap: 04000000:fc000000)
> > Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 16256
> > Kernel command line: console=ttyS0,38400n8
> > Initializing CPU#0
> > PID hash table entries: 256 (order: 8, 1024 bytes)
> > Detected 266.627 MHz processor.
> > Console: colour dummy device 80x25
> > console [ttyS0] enabled
> > Dentry cache hash table entries: 8192 (order: 3, 32768 bytes)
> > Inode-cache hash table entries: 4096 (order: 2, 16384 bytes)
> > Memory: 62836k/65536k available (1020k kernel code, 2292k reserved, 317k 
> > data, 112k init, 0k highmem)
> > virtual kernel memory layout:
> >     fixmap  : 0xffffb000 - 0xfffff000   (  16 kB)
> >     vmalloc : 0xc4800000 - 0xffff9000   ( 951 MB)
> >     lowmem  : 0xc0000000 - 0xc4000000   (  64 MB)
> >       .init : 0xc0252000 - 0xc026e000   ( 112 kB)
> >       .data : 0xc01ff111 - 0xc024e6f4   ( 317 kB)
> >       .text : 0xc0100000 - 0xc01ff111   (1020 kB)
> > Checking if this processor honours the WP bit even in supervisor mode... 
Ok.
> > SLUB: Genslabs=11, HWalign=32, Order=0-1, MinObjects=4, CPUs=1, Nodes=1
> > Calibrating delay using timer specific routine.. 534.41 BogoMIPS 
(lpj=1068836)
> > Mount-cache hash table entries: 512
> > Compat vDSO mapped to ffffe000.
> > CPU: NSC Unknown stepping 01
> > Checking 'hlt' instruction... OK.
> > Freeing SMP alternatives: 0k freed
> > net_namespace: 64 bytes
> > NET: Registered protocol family 16
> > PCI: PCI BIOS revision 2.10 entry at 0xfc3ad, last bus=0
> > PCI: Using configuration type 1
> > Setting up standard PCI resources
> > SCSI subsystem initialized
> > PCI: Probing PCI hardware
> > PCI: Device 0000:00:12.5 not found by BIOS
> > Time: tsc clocksource has been installed.
> > NET: Registered protocol family 2
> > IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
> > TCP established hash table entries: 2048 (order: 2, 16384 bytes)
> > TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
> > TCP: Hash tables configured (established 2048 bind 2048)
> > TCP reno registered
> > scx200: NatSemi SCx200 Driver
> > scx200: GPIO base 0xf400
> > scx200: Configuration Block base 0x9000
> > io scheduler noop registered (default)
> > Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ sharing disabled
> > serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a NS16550A
> > serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a NS16550A
> > natsemi dp8381x driver, version 2.1, Sept 11, 2006
> >   originally by Donald Becker <becker@scyld.com>
> >   2.4.x kernel port by Jeff Garzik, Tjeerd Mulder
> > natsemi eth0: NatSemi DP8381[56] at 0x80000000 (0000:00:0e.0), 
> > 00:0d:b9:00:8a:30, IRQ 10, port TP.
> > scsi0 : sc1200
> > scsi1 : sc1200
> > ata1: PATA max UDMA/33 cmd 0x1f0 ctl 0x3f6 bmdma 0xfc00 irq 14
> > ata2: DUMMY
> > ata1.00: CFA: SanDisk SDCFH-1024, HDX 3.07, max MWDMA2
> > ata1.00: 2001888 sectors, multi 0: LBA
> > ata1.00: configured for MWDMA2
> > scsi 0:0:0:0: Direct-Access     ATA      SanDisk SDCFH-10 HDX  PQ: 0 
ANSI: 5
> > sd 0:0:0:0: [sda] 2001888 512-byte hardware sectors (1025 MB)
> > sd 0:0:0:0: [sda] Write Protect is off
> > sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't 
support 
> > DPO or FUA
> > sd 0:0:0:0: [sda] 2001888 512-byte hardware sectors (1025 MB)
> > sd 0:0:0:0: [sda] Write Protect is off
> > sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't 
support 
> > DPO or FUA
> >  sda:<4>Clocksource tsc unstable (delta = -334501841 ns)
> > Time: pit clocksource has been installed.
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA2
> > ata1: EH complete
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA2
> > ata1: EH complete
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA2
> > ata1: EH complete
> > ata1.00: limiting speed to MWDMA1:PIO4
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA1
> > ata1: EH complete
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA1
> > ata1: EH complete
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA1
> > sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
> > sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
> > Descriptor sense data with sense descriptors (in hex):
> >         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
> >         00 00 00 00
> > sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
> > end_request: I/O error, dev sda, sector 0
> > Buffer I/O error on device sda, logical block 0
> > ata1: EH complete
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA1
> > ata1: EH complete
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA1
> > ata1: EH complete
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA1
> > ata1: EH complete
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA1
> > ata1: EH complete
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA1
> > ata1: EH complete
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA1
> > sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
> > sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
> > Descriptor sense data with sense descriptors (in hex):
> >         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
> >         00 00 00 00
> > sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
> > end_request: I/O error, dev sda, sector 0
> > Buffer I/O error on device sda, logical block 0
> > ata1: EH complete
> >  unable to read partition table
> > sd 0:0:0:0: [sda] Attached SCSI removable disk
> > scx200_wdt: timer margin 60 seconds
> > cpuidle: using governor ladder
> > enabling scx200 high-res timer (1 MHz +0 ppm)
> > TCP cubic registered
> > Time: scx200_hrt clocksource has been installed.
> > NET: Registered protocol family 1
> > NET: Registered protocol family 17
> > Using IPI Shortcut mode
> > VFS: Cannot open root device "<NULL>" or unknown-block(8,18)
> > Please append a correct "root=" boot option; here are the available 
> > partitions:
> > 0800    1000944 sda driver: sd
> > Kernel panic - not syncing: VFS: Unable to mount root fs on unknown-
> > block(8,18)
> >
> 
> (+linux-ide)
> 
> So this has never worked on any known kernel?

It is working now on old ide code (not libata).

--
Denys Fedoryshchenko
Technical Manager
Virtual ISP S.A.L.

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[James Andrewartha]

Denys Fedoryshchenko wrote:
> On Tue, 6 Nov 2007 22:15:21 -0800, Andrew Morton wrote
>>> On Thu, 1 Nov 2007 23:30:13 +0200 "Denys" <denys@visp.net.lb> wrote:
>>> Finally i got full DMESG with 1GB card till end. Seems not readable too.
>>> scsi0 : sc1200
>>> scsi1 : sc1200
>>> ata1: PATA max UDMA/33 cmd 0x1f0 ctl 0x3f6 bmdma 0xfc00 irq 14
>>> ata2: DUMMY
>>> ata1.00: CFA: SanDisk SDCFH-1024, HDX 3.07, max MWDMA2
>>> ata1.00: 2001888 sectors, multi 0: LBA
>>> ata1.00: configured for MWDMA2
>>> scsi 0:0:0:0: Direct-Access     ATA      SanDisk SDCFH-10 HDX  PQ: 0 
> ANSI: 5
>>> sd 0:0:0:0: [sda] 2001888 512-byte hardware sectors (1025 MB)
>>> sd 0:0:0:0: [sda] Write Protect is off
>>> sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't 
> support 
>>> DPO or FUA
>>> sd 0:0:0:0: [sda] 2001888 512-byte hardware sectors (1025 MB)
>>> sd 0:0:0:0: [sda] Write Protect is off
>>> sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't 
> support 
>>> DPO or FUA
>>>  sda:<4>Clocksource tsc unstable (delta = -334501841 ns)
>>> Time: pit clocksource has been installed.
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA2
>>> ata1: EH complete
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA2
>>> ata1: EH complete
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA2
>>> ata1: EH complete
>>> ata1.00: limiting speed to MWDMA1:PIO4
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA1
>>> ata1: EH complete
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA1
>>> ata1: EH complete
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA1
>>> sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
>>> sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
>>> Descriptor sense data with sense descriptors (in hex):
>>>         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
>>>         00 00 00 00
>>> sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
>>> end_request: I/O error, dev sda, sector 0
>>> Buffer I/O error on device sda, logical block 0
>>> ata1: EH complete
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA1
>>> ata1: EH complete
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA1
>>> ata1: EH complete
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA1
>>> ata1: EH complete
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA1
>>> ata1: EH complete
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA1
>>> ata1: EH complete
>>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
>>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
> in
>>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
>>> ata1.00: status: { DRDY }
>>> ata1: soft resetting link
>>> ata1.00: configured for MWDMA1
>>> sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
>>> sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
>>> Descriptor sense data with sense descriptors (in hex):
>>>         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
>>>         00 00 00 00
>>> sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
>>> end_request: I/O error, dev sda, sector 0
>>> Buffer I/O error on device sda, logical block 0
>>> ata1: EH complete
>>>  unable to read partition table
>>> sd 0:0:0:0: [sda] Attached SCSI removable disk
>>> scx200_wdt: timer margin 60 seconds
>>> cpuidle: using governor ladder
>>> enabling scx200 high-res timer (1 MHz +0 ppm)
>>> TCP cubic registered
>>> Time: scx200_hrt clocksource has been installed.
>>> NET: Registered protocol family 1
>>> NET: Registered protocol family 17
>>> Using IPI Shortcut mode
>>> VFS: Cannot open root device "<NULL>" or unknown-block(8,18)
>>> Please append a correct "root=" boot option; here are the available 
>>> partitions:
>>> 0800    1000944 sda driver: sd
>>> Kernel panic - not syncing: VFS: Unable to mount root fs on unknown-
>>> block(8,18)
>>>
>> (+linux-ide)
(+alan, tejun)
>> So this has never worked on any known kernel?
> 
> It is working now on old ide code (not libata).

Can you post the dmesg and hdparm -I of a working boot using the old ide
code? The thing that stuck out to me (as just a reader of linux-ide) was
that the problem involves MWDMA and CF, which have had problems (although
not the same as this one) in the past:
http://thread.gmane.org/gmane.linux.ide/22058 and
http://thread.gmane.org/gmane.linux.ide/22400

-- 
James Andrewartha

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Denys Fedoryshchenko]

On Thu, 08 Nov 2007 00:23:10 +0900, James Andrewartha wrote
> Denys Fedoryshchenko wrote:
> > On Tue, 6 Nov 2007 22:15:21 -0800, Andrew Morton wrote
> >>> On Thu, 1 Nov 2007 23:30:13 +0200 "Denys" <denys@visp.net.lb> wrote:
> >>> Finally i got full DMESG with 1GB card till end. Seems not readable too.
> >>> scsi0 : sc1200
> >>> scsi1 : sc1200
> >>> ata1: PATA max UDMA/33 cmd 0x1f0 ctl 0x3f6 bmdma 0xfc00 irq 14
> >>> ata2: DUMMY
> >>> ata1.00: CFA: SanDisk SDCFH-1024, HDX 3.07, max MWDMA2
> >>> ata1.00: 2001888 sectors, multi 0: LBA
> >>> ata1.00: configured for MWDMA2
> >>> scsi 0:0:0:0: Direct-Access     ATA      SanDisk SDCFH-10 HDX  PQ: 0 
> > ANSI: 5
> >>> sd 0:0:0:0: [sda] 2001888 512-byte hardware sectors (1025 MB)
> >>> sd 0:0:0:0: [sda] Write Protect is off
> >>> sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't 
> > support 
> >>> DPO or FUA
> >>> sd 0:0:0:0: [sda] 2001888 512-byte hardware sectors (1025 MB)
> >>> sd 0:0:0:0: [sda] Write Protect is off
> >>> sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't 
> > support 
> >>> DPO or FUA
> >>>  sda:<4>Clocksource tsc unstable (delta = -334501841 ns)
> >>> Time: pit clocksource has been installed.
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA2
> >>> ata1: EH complete
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA2
> >>> ata1: EH complete
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA2
> >>> ata1: EH complete
> >>> ata1.00: limiting speed to MWDMA1:PIO4
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA1
> >>> ata1: EH complete
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA1
> >>> ata1: EH complete
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA1
> >>> sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
> >>> sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
> >>> Descriptor sense data with sense descriptors (in hex):
> >>>         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
> >>>         00 00 00 00
> >>> sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
> >>> end_request: I/O error, dev sda, sector 0
> >>> Buffer I/O error on device sda, logical block 0
> >>> ata1: EH complete
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA1
> >>> ata1: EH complete
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA1
> >>> ata1: EH complete
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA1
> >>> ata1: EH complete
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA1
> >>> ata1: EH complete
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA1
> >>> ata1: EH complete
> >>> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> >>> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 
4096 
> > in
> >>>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> >>> ata1.00: status: { DRDY }
> >>> ata1: soft resetting link
> >>> ata1.00: configured for MWDMA1
> >>> sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
> >>> sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
> >>> Descriptor sense data with sense descriptors (in hex):
> >>>         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
> >>>         00 00 00 00
> >>> sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
> >>> end_request: I/O error, dev sda, sector 0
> >>> Buffer I/O error on device sda, logical block 0
> >>> ata1: EH complete
> >>>  unable to read partition table
> >>> sd 0:0:0:0: [sda] Attached SCSI removable disk
> >>> scx200_wdt: timer margin 60 seconds
> >>> cpuidle: using governor ladder
> >>> enabling scx200 high-res timer (1 MHz +0 ppm)
> >>> TCP cubic registered
> >>> Time: scx200_hrt clocksource has been installed.
> >>> NET: Registered protocol family 1
> >>> NET: Registered protocol family 17
> >>> Using IPI Shortcut mode
> >>> VFS: Cannot open root device "<NULL>" or unknown-block(8,18)
> >>> Please append a correct "root=" boot option; here are the available 
> >>> partitions:
> >>> 0800    1000944 sda driver: sd
> >>> Kernel panic - not syncing: VFS: Unable to mount root fs on unknown-
> >>> block(8,18)
> >>>
> >> (+linux-ide)
> (+alan, tejun)
> >> So this has never worked on any known kernel?
> > 
> > It is working now on old ide code (not libata).
> 
> Can you post the dmesg and hdparm -I of a working boot using the old 
> ide code? The thing that stuck out to me (as just a reader of linux-
> ide) was that the problem involves MWDMA and CF, which have had 
> problems (although not the same as this one) in the past: 
> http://thread.gmane.org/gmane.linux.ide/22058 and http://thread.gmane.org/
gmane.linux.ide/22400
> 
> -- 
> James Andrewartha
WRAP ~ #./hdparm -I /dev/hda

/dev/hda:

ATAPI Write-once device, with non-removable media
        Model Number:       SanDisk SDP3B-16
        Serial Number:      24313671615
        Firmware Revision:  vdd 1.00
Standards:
        Likely used: 3
Configuration:
        DRQ response: 50us.
        Packet size: Unknown
Capabilities:
        LBA, IORDY(may be)(cannot be disabled)
        Buffer size: 1.0kB      bytes avail on r/w long: 4
        DMA: not supported
        PIO: pio0 pio1


Now it is linux-2.6.24-rc1 from wireless-2.6 git (just testing)
All messages about IDE very similar to 2.6.24-rc2 (tested too)

    0.000000] Linux version 2.6.24-rc1-embedded-g09bbb0a3-dirty 
(root@homecore.visp.net.lb) (gcc version 4.1.2 (Gentoo 4.1.2 p1.0.1)) #8 Wed 
Nov 7 04:23:31 EET 2007
[    0.000000] BIOS-provided physical RAM map:
[    0.000000]  BIOS-e801: 0000000000000000 - 000000000009f000 (usable)
[    0.000000]  BIOS-e801: 0000000000100000 - 0000000004000000 (usable)
[    0.000000] 64MB LOWMEM available.
[    0.000000] Entering add_active_range(0, 0, 16384) 0 entries of 256 used
[    0.000000] Zone PFN ranges:
[    0.000000]   DMA             0 ->     4096
[    0.000000]   Normal       4096 ->    16384
[    0.000000] Movable zone start PFN for each node
[    0.000000] early_node_map[1] active PFN ranges
[    0.000000]     0:        0 ->    16384
[    0.000000] On node 0 totalpages: 16384
[    0.000000]   DMA zone: 32 pages used for memmap
[    0.000000]   DMA zone: 0 pages reserved
[    0.000000]   DMA zone: 4064 pages, LIFO batch:0
[    0.000000]   Normal zone: 96 pages used for memmap
[    0.000000]   Normal zone: 12192 pages, LIFO batch:1
[    0.000000]   Movable zone: 0 pages used for memmap
[    0.000000] DMI not present or invalid.
[    0.000000] Allocating PCI resources starting at 10000000 (gap: 
04000000:fc000000)
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total 
pages: 16256
[    0.000000] Kernel command line: console=ttyS0,38400n8 panic=5 reboot=soft 
clocksource=scx200_hrt notsc
[    0.000000] notsc: Kernel compiled with CONFIG_X86_TSC, cannot disable TSC.
[    0.000000] Initializing CPU#0
[    0.000000] PID hash table entries: 256 (order: 8, 1024 bytes)
[    0.000000] Detected 266.627 MHz processor.
[    6.146789] Console: colour dummy device 80x25
[    6.146884] console [ttyS0] enabled
[    6.493841] Dentry cache hash table entries: 8192 (order: 3, 32768 bytes)
[    6.514729] Inode-cache hash table entries: 4096 (order: 2, 16384 bytes)
[    6.553125] Memory: 61992k/65536k available (1113k kernel code, 3136k 
reserved, 454k data, 680k init, 0k highmem)
[    6.584035] virtual kernel memory layout:
[    6.584060]     fixmap  : 0xffffb000 - 0xfffff000   (  16 kB)
[    6.584092]     vmalloc : 0xc4800000 - 0xffff9000   ( 951 MB)
[    6.584124]     lowmem  : 0xc0000000 - 0xc4000000   (  64 MB)
[    6.584157]       .init : 0xc028c000 - 0xc0336000   ( 680 kB)
[    6.584190]       .data : 0xc0216775 - 0xc028824c   ( 454 kB)
[    6.584222]       .text : 0xc0100000 - 0xc0216775   (1113 kB)
[    6.699565] Checking if this processor honours the WP bit even in 
supervisor mode... Ok.
[    6.724157] SLUB: Genslabs=11, HWalign=32, Order=0-1, MinObjects=4, 
CPUs=1, Nodes=1
[    6.827181] Calibrating delay using timer specific routine.. 534.53 
BogoMIPS (lpj=1069066)
[    6.852327] Mount-cache hash table entries: 512
[    6.867065] CPU: After generic identify, caps: 00808131 01818131 00000000 
00000000 00000000 00000000 00000000 00000000
[    6.867249] CPU: After all inits, caps: 00808131 00818131 00000000 
00000001 00000000 00000000 00000000 00000000
[    6.867402] Compat vDSO mapped to ffffe000.
[    6.880052] CPU: NSC Unknown stepping 01
[    6.892089] Checking 'hlt' instruction... OK.
[    6.905494] Freeing SMP alternatives: 0k freed
[    6.921472] net_namespace: 64 bytes
[    6.937068] NET: Registered protocol family 16
[    6.955287] PCI: PCI BIOS revision 2.10 entry at 0xfc3ad, last bus=0
[    6.974479] PCI: Using configuration type 1
[    6.987082] Setting up standard PCI resources
[    7.012835] SCSI subsystem initialized
[    7.024946] PCI: Probing PCI hardware
[    7.036044] PCI: Probing PCI hardware (bus 00)
[    7.044386] PCI: Device 0000:00:12.5 not found by BIOS
[    7.064960] Time: tsc clocksource has been installed.
[    7.084872] NET: Registered protocol family 2
[    7.099253] IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
[    7.122746] TCP established hash table entries: 2048 (order: 2, 16384 
bytes)
[    7.144139] TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
[    7.163374] TCP: Hash tables configured (established 2048 bind 2048)
[    7.182494] TCP reno registered
[    7.545264] apm: BIOS not found.
[    7.555735] scx200: NatSemi SCx200 Driver
[    7.568689] scx200: GPIO base 0xf400
[    7.579604] scx200: Configuration Block base 0x9000
[    7.598345] io scheduler noop registered (default)
[    8.294143] nsc_gpio initializing
[    8.294203] Serial: 8250/16550 driver $Revision: 1.90 $ 4 ports, IRQ 
sharing disabled
[    8.318680] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a NS16550A
[    8.338718] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a NS16550A
[    8.368801] loop: module loaded
[    8.378981] natsemi dp8381x driver, version 2.1, Sept 11, 2006
[    8.379033]   originally by Donald Becker <becker@scyld.com>
[    8.379074]   2.4.x kernel port by Jeff Garzik, Tjeerd Mulder
[    8.435811] natsemi eth0: NatSemi DP8381[56] at 0x80000000 (0000:00:0e.0), 
00:0d:b9:00:8a:30, IRQ 10, port TP.
[    8.466288] Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
[    8.485458] ide: Assuming 33MHz system bus speed for PIO modes; override 
with idebus=xx
[    8.510324] SC1200: IDE controller (0x100b:0x0502 rev 0x01) at  PCI slot 
0000:00:12.2
[    8.533951] SC1200: not 100% native mode: will probe irqs later
[    8.551829]     ide0: BM-DMA at 0xfc00-0xfc07, BIOS settings: hda:pio, 
hdb:pio
[    8.573784]     ide1: BM-DMA at 0xfc08-0xfc0f, BIOS settings: hdc:pio, 
hdd:pio
[    8.595746] Probing IDE interface ide0...
[    8.608917] Clocksource tsc unstable (delta = -497090346 ns)
[    8.625999] Time: pit clocksource has been installed.
[    8.644055] hda: SanDisk SDP3B-16, ATA DISK drive
[    8.658485] hda: applying conservative PIO "downgrade"
[    8.674009] hda: host max PIO4 wanted PIO255(auto-tune) selected PIO0
[    8.674264] hda: set_drive_speed_status: status=0x51 { DriveReady 
SeekComplete Error }
[    8.698231] hda: set_drive_speed_status: error=0x04 { DriveStatusError }
[    8.718590] hda: applying conservative PIO "downgrade"
[    8.734085] hda: host max PIO4 wanted PIO255(auto-tune) selected PIO0
[    8.734337] hda: set_drive_speed_status: status=0x51 { DriveReady 
SeekComplete Error }
[    8.758315] hda: set_drive_speed_status: error=0x04 { DriveStatusError }
[    8.778838] ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
[    8.793310] Probing IDE interface ide1...
[    8.807926] hda: max request size: 128KiB
[    8.820076] hda: 31360 sectors (16 MB) w/1KiB Cache, CHS=490/2/32
[    8.838987]  hda: hda1
[    8.851358] scx200_wdt: NatSemi SCx200 Watchdog Driver
[    8.851431] scx200_wdt: timer margin 60 seconds
[    8.865139] scx200_wdt: disabling watchdog timer
[    8.865921] cpuidle: using governor ladder
[    8.878349] cpuidle: using governor menu
[    8.890225] enabling scx200 high-res timer (1 MHz +0 ppm)
[    8.906518] Netfilter messages via NETLINK v0.30.
[    8.920683] Time: scx200_hrt clocksource has been installed.
[    8.937755] Switched to high resolution mode on CPU 0
[    8.952999] TCP cubic registered
[    8.962739] NET: Registered protocol family 1
[    8.975940] NET: Registered protocol family 17
[    8.989342] Using IPI Shortcut mode
[    9.006475] Freeing unused kernel memory: 680k freed
[   10.189658] eth0: DSPCFG accepted after 0 usec.
[   10.203289] eth0: link up.
[   10.211460] eth0: Setting full-duplex based on negotiated link capability.





--
Denys Fedoryshchenko
Technical Manager
Virtual ISP S.A.L.

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Mark Lord]

> WRAP ~ #./hdparm -I /dev/hda
> 
> /dev/hda:
> 
> ATAPI Write-once device, with non-removable media
>         Model Number:       SanDisk SDP3B-16
>         Serial Number:      24313671615
>         Firmware Revision:  vdd 1.00
> Standards:
>         Likely used: 3
> Configuration:
>         DRQ response: 50us.
>         Packet size: Unknown
> Capabilities:
>         LBA, IORDY(may be)(cannot be disabled)
>         Buffer size: 1.0kB      bytes avail on r/w long: 4
>         DMA: not supported
>         PIO: pio0 pio1

"ATAPI Write-once device"  ???

That cannot be correct (??).  Is this with hdparm-7.7 (latest sourceforge) ??
Can you show us the "hdparm --Istdout" output as well, please.

thanks.

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Denys Fedoryshchenko]

On Wed, 07 Nov 2007 14:12:55 -0500, Mark Lord wrote
> > WRAP ~ #./hdparm -I /dev/hda
> > 
> > /dev/hda:
> > 
> > ATAPI Write-once device, with non-removable media
> >         Model Number:       SanDisk SDP3B-16
> >         Serial Number:      24313671615
> >         Firmware Revision:  vdd 1.00
> > Standards:
> >         Likely used: 3
> > Configuration:
> >         DRQ response: 50us.
> >         Packet size: Unknown
> > Capabilities:
> >         LBA, IORDY(may be)(cannot be disabled)
> >         Buffer size: 1.0kB      bytes avail on r/w long: 4
> >         DMA: not supported
> >         PIO: pio0 pio1
> 
> "ATAPI Write-once device"  ???
> 
> That cannot be correct (??).  Is this with hdparm-7.7 (latest 
> sourceforge) ?? Can you show us the "hdparm --Istdout" output as 
> well, please.
> 
> thanks.
Yes latest hdparm-7.7. But maybe it is related to git kernel? Cause lines
[    8.658485] hda: applying conservative PIO "downgrade"
[    8.674009] hda: host max PIO4 wanted PIO255(auto-tune) selected PIO0
[    8.674264] hda: set_drive_speed_status: status=0x51 { DriveReady SeekComplet
e Error }
[    8.698231] hda: set_drive_speed_status: error=0x04 { DriveStatusError }
[    8.718590] hda: applying conservative PIO "downgrade"
[    8.734085] hda: host max PIO4 wanted PIO255(auto-tune) selected PIO0
[    8.734337] hda: set_drive_speed_status: status=0x51 { DriveReady SeekComplet
e Error }
[    8.758315] hda: set_drive_speed_status: error=0x04 { DriveStatusError }

appeared only in those kernels (2.6.24-git/rc)


Anyways:

WRAP ~ #./hdparm --Istdout /dev/hda

/dev/hda:
844a 01ea 0000 0002 0000 0240 0020 0000
7a80 0000 2020 2020 2020 2020 2032 3433
3133 3637 3136 3135 0002 0002 0004 7664
6420 312e 3030 5361 6e44 6973 6b20 5344
5033 422d 3136 2020 2020 2020 2020 2020
2020 2020 2020 2020 2020 2020 2020 0001
0000 0200 0000 0100 0000 0001 01ea 0002
0020 7a80 0000 0100 7a80 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 2020
2020 2020 2020 2020 2020 2032 3433 3133
3637 3136 3135 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000




--
Denys Fedoryshchenko
Technical Manager
Virtual ISP S.A.L.

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Mark Lord]

Denys Fedoryshchenko wrote:
> On Wed, 07 Nov 2007 14:12:55 -0500, Mark Lord wrote
>>> WRAP ~ #./hdparm -I /dev/hda
>>>
>>> /dev/hda:
>>>
>>> ATAPI Write-once device, with non-removable media
>>>         Model Number:       SanDisk SDP3B-16
>>>         Serial Number:      24313671615
>>>         Firmware Revision:  vdd 1.00
>>> Standards:
>>>         Likely used: 3
>>> Configuration:
>>>         DRQ response: 50us.
>>>         Packet size: Unknown
>>> Capabilities:
>>>         LBA, IORDY(may be)(cannot be disabled)
>>>         Buffer size: 1.0kB      bytes avail on r/w long: 4
>>>         DMA: not supported
>>>         PIO: pio0 pio1
>> "ATAPI Write-once device"  ???
>>
>> That cannot be correct (??).  Is this with hdparm-7.7 (latest 
>> sourceforge) ?? Can you show us the "hdparm --Istdout" output as 
>> well, please.
>>
>> thanks.
> Yes latest hdparm-7.7.
...

> WRAP ~ #./hdparm --Istdout /dev/hda
> 
> /dev/hda:
> 844a 01ea 0000 0002 0000 0240 0020 0000
..

CFA spec requires 848a in word[0], not 844a, which explains
why hdparm thought it might be ATAPI.  I've updated my hdparm
source to detect this for hdparm-7.8 (unreleased).
That card (16MB) is definitely buggy.
But your other (1GB) card looks fine.

Thanks.  Somebody else may help with the libata issue.

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Alan Cox]

> CFA spec requires 848a in word[0], not 844a, which explains
> why hdparm thought it might be ATAPI.  I've updated my hdparm
> source to detect this for hdparm-7.8 (unreleased).
> That card (16MB) is definitely buggy.
> But your other (1GB) card looks fine.
> 
> Thanks.  Somebody else may help with the libata issue.

848A is the preferred configuration value

The use of 044A is also allowed in the case of it being non-removable.
Guess someone got muddled up in the middle.

844A is a bit iffy and it should still be detectable as Word 83 bit 2
should be set ?


As to the old IDE (not libata ?) issue - I suspect a convertor without
DMA support as a first guess.

Alan

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Denys Fedoryshchenko]

This is another flash (1GB probably original Sandisk), 16MB one is called 
SHARP, and it is 2-4 years old. Maybe it is some noname with incorrect 
identification data. But it works well in USB card reader.

[   12.434864] ide: Assuming 33MHz system bus speed for PIO modes; override 
with idebus=xx
[   12.459739] SC1200: IDE controller (0x100b:0x0502 rev 0x01) at  PCI slot 
0000:00:12.2
[   12.483360] SC1200: not 100% native mode: will probe irqs later
[   12.501235]     ide0: BM-DMA at 0xfc00-0xfc07, BIOS settings: hda:pio, 
hdb:pio
[   12.523191]     ide1: BM-DMA at 0xfc08-0xfc0f, BIOS settings: hdc:pio, 
hdd:pio
[   12.545128] Probing IDE interface ide0...
[   12.558292] Clocksource tsc unstable (delta = -497091188 ns)
[   12.575348] Time: pit clocksource has been installed.
[   12.593376] hda: SanDisk SDCFH-1024, CFA DISK drive
[   12.608342] hda: applying conservative PIO "downgrade"
[   12.623867] hda: host max PIO4 wanted PIO255(auto-tune) selected PIO1
[   12.624015] hda: selected mode 0x22
[   12.624308] ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
[   12.638802] Probing IDE interface ide1...
[   12.653412] hda: max request size: 128KiB
[   12.665560] hda: 2001888 sectors (1024 MB) w/1KiB Cache, CHS=1986/16/63, 
DMA
[   12.687374]  hda:<4>hda: dma_timer_expiry: dma status == 0x21
[   12.906900] hda: DMA timeout error
[   12.917152]  ide_dma_end dma_stat=21 err=1 newerr=0
[   12.931812] hda: dma timeout error: status=0x58 { DriveReady SeekComplete 
DataRequest }
[   12.956039] ide: failed opcode was: unknown
[   12.968807] hda: DMA disabled
[   12.978108] ide0: reset: success
[   12.989416]  hda1
[   12.998883] scx200_wdt: NatSemi SCx200 Watchdog Driver
[   12.998957] scx200_wdt: timer margin 60 seconds
[   13.012656] scx200_wdt: disabling watchdog timer
[   13.013427] cpuidle: using governor ladder
[   13.025906] cpuidle: using governor menu
[   13.037808] enabling scx200 high-res timer (1 MHz +0 ppm)
[   13.054084] Netfilter messages via NETLINK v0.30.
[   13.068256] Time: scx200_hrt clocksource has been installed.
[   13.085331] Switched to high resolution mode on CPU 0
[   13.100573] TCP cubic registered
[   13.110312] NET: Registered protocol family 1
[   13.123516] NET: Registered protocol family 17
[   13.136915] Using IPI Shortcut mode
[   13.154057] Freeing unused kernel memory: 680k freed
[   14.340096] eth0: DSPCFG accepted after 0 usec.
[   14.353718] eth0: link up.
[   14.361893] eth0: Setting full-duplex based on negotiated link capability.

here i am trying to mount partition (1Gb) /dev/hda1 to /mnt

[   14.456362] hda: dma_timer_expiry: dma status == 0x21
[   14.491812] hda: DMA timeout error
[   14.502061]  ide_dma_end dma_stat=21 err=1 newerr=0
[   14.516718] hda: dma timeout error: status=0x58 { DriveReady SeekComplete 
DataRequest }
[   14.540944] ide: failed opcode was: unknown
[   14.553712] hda: DMA disabled
[   14.562712] ide0: reset: success
[   14.789644] hda: dma_timer_expiry: dma status == 0x21
[   14.862229] hda: DMA timeout error
[   14.872491]  ide_dma_end dma_stat=21 err=1 newerr=0
[   14.887148] hda: dma timeout error: status=0x58 { DriveReady SeekComplete 
DataRequest }
[   14.911375] ide: failed opcode was: unknown
[   14.924143] hda: DMA disabled
[   14.933142] ide0: reset: success
[   14.988000] hda: dma_timer_expiry: dma status == 0x21
[   15.023352] hda: DMA timeout error
[   15.033608]  ide_dma_end dma_stat=21 err=1 newerr=0
[   15.048267] hda: dma timeout error: status=0x58 { DriveReady SeekComplete 
DataRequest }
[   15.072494] ide: failed opcode was: unknown
[   15.085261] hda: DMA disabled
[   15.094269] ide0: reset: success

and it is failed.

WRAP ~ #./hdparm -I /dev/hda

/dev/hda:

CompactFlash ATA device, with removable media
        Model Number:       SanDisk SDCFH-1024
        Serial Number:      111718F1705D0016
        Firmware Revision:  HDX 3.07
Standards:
        Supported: 4
        Likely used: 4
Configuration:
        Logical         max     current
        cylinders       1986    1986
        heads           16      16
        sectors/track   63      63
        --
        CHS current addressable sectors:    2001888
        LBA    user addressable sectors:    2001888
        device size with M = 1024*1024:         977 MBytes
        device size with M = 1000*1000:        1024 MBytes (1 GB)
Capabilities:
        LBA, IORDY(may be)(cannot be disabled)
        Standby timer values: spec'd by Vendor
        R/W multiple sector transfer: Max = 4   Current = 0
        DMA: mdma0 mdma1 mdma2 (?)
             Cycle time: min=120ns recommended=120ns
        PIO: pio0 pio1 pio2 pio3 pio4
             Cycle time: no flow control=120ns  IORDY flow control=120ns
Commands/features:
        Enabled Supported:
           *    CFA feature set

WRAP ~ #./hdparm --Istdout /dev/hda

/dev/hda:
848a 07c2 0000 0010 0000 0240 003f 001e
8be0 0000 2020 2020 3131 3137 3138 4631
3730 3544 3030 3136 0002 0002 0004 4844
5820 332e 3037 5361 6e44 6973 6b20 5344
4346 482d 3130 3234 2020 2020 2020 2020
2020 2020 2020 2020 2020 2020 2020 0004
0000 0300 0000 0200 0000 0003 07c2 0010
003f 8be0 001e 0100 8be0 001e 0000 0007
0003 0078 0078 0078 0078 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0010 0000 0000 4004 4000 0020 0004 4000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000
0000 0000 0000 0000 0000 0000 0000 0000



On Wed, 07 Nov 2007 14:12:55 -0500, Mark Lord wrote
> > WRAP ~ #./hdparm -I /dev/hda
> > 
> > /dev/hda:
> > 
> > ATAPI Write-once device, with non-removable media
> >         Model Number:       SanDisk SDP3B-16
> >         Serial Number:      24313671615
> >         Firmware Revision:  vdd 1.00
> > Standards:
> >         Likely used: 3
> > Configuration:
> >         DRQ response: 50us.
> >         Packet size: Unknown
> > Capabilities:
> >         LBA, IORDY(may be)(cannot be disabled)
> >         Buffer size: 1.0kB      bytes avail on r/w long: 4
> >         DMA: not supported
> >         PIO: pio0 pio1
> 
> "ATAPI Write-once device"  ???
> 
> That cannot be correct (??).  Is this with hdparm-7.7 (latest 
> sourceforge) ?? Can you show us the "hdparm --Istdout" output as 
> well, please.
> 
> thanks.


--
Denys Fedoryshchenko
Technical Manager
Virtual ISP S.A.L.

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Jeff Garzik]

On Wed, Nov 07, 2007 at 02:12:55PM -0500, Mark Lord wrote:
> That cannot be correct (??).  Is this with hdparm-7.7 (latest sourceforge) 
> ??
> Can you show us the "hdparm --Istdout" output as well, please.

If this is applicable...  FWIW hdparm was only recently (in past <72
hours) updated from 6.9 to 7.7 in Fedora...

	Jeff

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Mark Lord]

Jeff Garzik wrote:
> On Wed, Nov 07, 2007 at 02:12:55PM -0500, Mark Lord wrote:
>> That cannot be correct (??).  Is this with hdparm-7.7 (latest sourceforge) 
>> ??
>> Can you show us the "hdparm --Istdout" output as well, please.
> 
> If this is applicable...  FWIW hdparm was only recently (in past <72
> hours) updated from 6.9 to 7.7 in Fedora...
> 
> 	Jeff

Woo-hoo!

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Denys Fedoryshchenko]

I am using Gentoo (and it is custom build of linux, actually only busybox + 
kernel + uclibc and few other tools), hdparm is vanilla 7.7

I will try to compile now -rc2 to see if there any changes.

With 16MB 2.6.24-rc1 works fine, 1GB working also with some errors in dmesg. 

And IF that all is important, cause it is relatively old hardware and 
probably if it is only this hardware-specific bug, it is enough to issue 
workaround just to be able to use it. I dont think so someone using them now 
much, but IMHO things must work in kernel if they are there.

On Wed, 7 Nov 2007 18:20:45 -0500, Jeff Garzik wrote
> On Wed, Nov 07, 2007 at 02:12:55PM -0500, Mark Lord wrote:
> > That cannot be correct (??).  Is this with hdparm-7.7 (latest 
sourceforge) 
> > ??
> > Can you show us the "hdparm --Istdout" output as well, please.
> 
> If this is applicable...  FWIW hdparm was only recently (in past <72
> hours) updated from 6.9 to 7.7 in Fedora...
> 
> 	Jeff


--
Denys Fedoryshchenko
Technical Manager
Virtual ISP S.A.L.

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Denys Fedoryshchenko]

2.6.24-rc2 not working very well


dmesg
[   12.386395] Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
[   12.405579] ide: Assuming 33MHz system bus speed for PIO modes; override 
with idebus=xx
[   12.430441] SC1200: IDE controller (0x100b:0x0502 rev 0x01) at  PCI slot 
0000:00:12.2
[   12.454070] SC1200: not 100% native mode: will probe irqs later
[   12.471947]     ide0: BM-DMA at 0xfc00-0xfc07, BIOS settings: hda:pio, 
hdb:pio
[   12.493873]     ide1: BM-DMA at 0xfc08-0xfc0f, BIOS settings: hdc:pio, 
hdd:pio
[   12.515810] Probing IDE interface ide0...
[   12.528810] Clocksource tsc unstable (delta = -497423729 ns)
[   12.545888] Time: pit clocksource has been installed.
[   12.563379] hda: SanDisk SDCFH-1024, CFA DISK drive
[   12.578340] hda: applying conservative PIO "downgrade"
[   12.593869] hda: host max PIO4 wanted PIO255(auto-tune) selected PIO1
[   12.594006] hda: MW DMA 2 mode selected
[   12.594297] ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
[   12.608778] Probing IDE interface ide1...
[   12.623192] hda: max request size: 128KiB
[   12.635322] hda: 2001888 sectors (1024 MB) w/1KiB Cache, CHS=1986/16/63, 
DMA
[   12.657134]  hda:<4>hda: dma_timer_expiry: dma status == 0x21
[   12.865846] hda: DMA timeout error
[   12.876092]  ide_dma_end dma_stat=21 err=1 newerr=0
[   12.890753] hda: dma timeout error: status=0x58 { DriveReady SeekComplete 
DataRequest }
[   12.914977] ide: failed opcode was: unknown
[   12.927743] hda: DMA disabled
[   12.937035] ide0: reset: success
[   12.948324]  hda1

Mounting taking long time on 1GB card cause of DMA issues. In dmesg i am not 
sure about timestamp showing few seconds, in real life it took about 2 
minutes.

after that in dmesg
[   14.965070] hda: dma_timer_expiry: dma status == 0x21
[   15.107909] hda: DMA timeout error
[   15.118149]  ide_dma_end dma_stat=21 err=1 newerr=0
[   15.132809] hda: dma timeout error: status=0x58 { DriveReady SeekComplete 
DataRequest }
[   15.157035] ide: failed opcode was: unknown
[   15.169799] hda: DMA disabled
[   15.178797] ide0: reset: success
[   15.312698] hda: dma_timer_expiry: dma status == 0x21
[   15.650705] hda: DMA timeout error
[   15.660952]  ide_dma_end dma_stat=21 err=1 newerr=0
[   15.675614] hda: dma timeout error: status=0x58 { DriveReady SeekComplete 
DataRequest }
[   15.699836] ide: failed opcode was: unknown
[   15.712601] hda: DMA disabled
[   15.721603] ide0: reset: success
[   16.325999] hda: dma_timer_expiry: dma status == 0x21
[   16.565756] hda: DMA timeout error
[   16.576001]  ide_dma_end dma_stat=21 err=1 newerr=0
[   16.590661] hda: dma timeout error: status=0x58 { DriveReady SeekComplete 
DataRequest }
[   16.614886] ide: failed opcode was: unknown
[   16.627651] hda: DMA disabled
[   16.636659] ide0: reset: success
[   16.650061] EXT2-fs warning: mounting unchecked fs, running e2fsck is 
recommended


On Wed, 7 Nov 2007 18:20:45 -0500, Jeff Garzik wrote
> On Wed, Nov 07, 2007 at 02:12:55PM -0500, Mark Lord wrote:
> > That cannot be correct (??).  Is this with hdparm-7.7 (latest 
sourceforge) 
> > ??
> > Can you show us the "hdparm --Istdout" output as well, please.
> 
> If this is applicable...  FWIW hdparm was only recently (in past <72
> hours) updated from 6.9 to 7.7 in Fedora...
> 
> 	Jeff


--
Denys Fedoryshchenko
Technical Manager
Virtual ISP S.A.L.

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Bartlomiej Zolnierkiewicz]

On Thursday 08 November 2007, Denys Fedoryshchenko wrote:
> 2.6.24-rc2 not working very well
> 
> 
> dmesg
> [   12.386395] Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
> [   12.405579] ide: Assuming 33MHz system bus speed for PIO modes; override 
> with idebus=xx
> [   12.430441] SC1200: IDE controller (0x100b:0x0502 rev 0x01) at  PCI slot 
> 0000:00:12.2
> [   12.454070] SC1200: not 100% native mode: will probe irqs later
> [   12.471947]     ide0: BM-DMA at 0xfc00-0xfc07, BIOS settings: hda:pio, 
> hdb:pio
> [   12.493873]     ide1: BM-DMA at 0xfc08-0xfc0f, BIOS settings: hdc:pio, 
> hdd:pio
> [   12.515810] Probing IDE interface ide0...
> [   12.528810] Clocksource tsc unstable (delta = -497423729 ns)
> [   12.545888] Time: pit clocksource has been installed.
> [   12.563379] hda: SanDisk SDCFH-1024, CFA DISK drive
> [   12.578340] hda: applying conservative PIO "downgrade"
> [   12.593869] hda: host max PIO4 wanted PIO255(auto-tune) selected PIO1
> [   12.594006] hda: MW DMA 2 mode selected
> [   12.594297] ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
> [   12.608778] Probing IDE interface ide1...
> [   12.623192] hda: max request size: 128KiB
> [   12.635322] hda: 2001888 sectors (1024 MB) w/1KiB Cache, CHS=1986/16/63, 
> DMA
> [   12.657134]  hda:<4>hda: dma_timer_expiry: dma status == 0x21
> [   12.865846] hda: DMA timeout error
> [   12.876092]  ide_dma_end dma_stat=21 err=1 newerr=0
> [   12.890753] hda: dma timeout error: status=0x58 { DriveReady SeekComplete 
> DataRequest }
> [   12.914977] ide: failed opcode was: unknown
> [   12.927743] hda: DMA disabled
> [   12.937035] ide0: reset: success
> [   12.948324]  hda1
> 
> Mounting taking long time on 1GB card cause of DMA issues. In dmesg i am not 
> sure about timestamp showing few seconds, in real life it took about 2 
> minutes.

Please try booting with "hda=nodma".

It could be a hardware problem (CF adapter without DMA lines).

Thanks,
Bart

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Denys Fedoryshchenko]

Does it work as kernel parameter?

I tried libata_dma_mask=0x4 and to set 0xf or 0xff - doesn't help. How to 
disable DMA in libata, if it is compiled in kernel?

On Thu, 8 Nov 2007 01:30:53 +0100, Bartlomiej Zolnierkiewicz wrote
> On Thursday 08 November 2007, Denys Fedoryshchenko wrote:
> > 2.6.24-rc2 not working very well
> > 
> > 
> > dmesg
> > [   12.386395] Uniform Multi-Platform E-IDE driver Revision: 7.00alpha2
> > [   12.405579] ide: Assuming 33MHz system bus speed for PIO modes; 
override 
> > with idebus=xx
> > [   12.430441] SC1200: IDE controller (0x100b:0x0502 rev 0x01) at  PCI 
slot 
> > 0000:00:12.2
> > [   12.454070] SC1200: not 100% native mode: will probe irqs later
> > [   12.471947]     ide0: BM-DMA at 0xfc00-0xfc07, BIOS settings: hda:pio, 
> > hdb:pio
> > [   12.493873]     ide1: BM-DMA at 0xfc08-0xfc0f, BIOS settings: hdc:pio, 
> > hdd:pio
> > [   12.515810] Probing IDE interface ide0...
> > [   12.528810] Clocksource tsc unstable (delta = -497423729 ns)
> > [   12.545888] Time: pit clocksource has been installed.
> > [   12.563379] hda: SanDisk SDCFH-1024, CFA DISK drive
> > [   12.578340] hda: applying conservative PIO "downgrade"
> > [   12.593869] hda: host max PIO4 wanted PIO255(auto-tune) selected PIO1
> > [   12.594006] hda: MW DMA 2 mode selected
> > [   12.594297] ide0 at 0x1f0-0x1f7,0x3f6 on irq 14
> > [   12.608778] Probing IDE interface ide1...
> > [   12.623192] hda: max request size: 128KiB
> > [   12.635322] hda: 2001888 sectors (1024 MB) w/1KiB Cache, CHS=1986/16/
63, 
> > DMA
> > [   12.657134]  hda:<4>hda: dma_timer_expiry: dma status == 0x21
> > [   12.865846] hda: DMA timeout error
> > [   12.876092]  ide_dma_end dma_stat=21 err=1 newerr=0
> > [   12.890753] hda: dma timeout error: status=0x58 { DriveReady 
SeekComplete 
> > DataRequest }
> > [   12.914977] ide: failed opcode was: unknown
> > [   12.927743] hda: DMA disabled
> > [   12.937035] ide0: reset: success
> > [   12.948324]  hda1
> > 
> > Mounting taking long time on 1GB card cause of DMA issues. In dmesg i am 
not 
> > sure about timestamp showing few seconds, in real life it took about 2 
> > minutes.
> 
> Please try booting with "hda=nodma".
> 
> It could be a hardware problem (CF adapter without DMA lines).
> 
> Thanks,
> Bart


--
Denys Fedoryshchenko
Technical Manager
Virtual ISP S.A.L.

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Alan Cox]

On Thu, 8 Nov 2007 09:16:35 +0200
"Denys Fedoryshchenko" <denys@visp.net.lb> wrote:

> Does it work as kernel parameter?
> 
> I tried libata_dma_mask=0x4 and to set 0xf or 0xff - doesn't help. How to 
> disable DMA in libata, if it is compiled in kernel?

libata.dma_mask=3

will leave you with CD and disk DMA but not CF DMA

(Note libata[DOT] not underscore)

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Denys Fedoryshchenko]

Doesn't help

WRAP ~ #cat /proc/cmdline
console=ttyS0,38400n8 libata.dma_mask=3

and in dmesg

[    8.601592] scsi 0:0:0:0: Direct-Access     ATA      SanDisk SDCFH-10 HDX  
PQ: 0 ANSI: 5
[    8.627943] sd 0:0:0:0: [sda] 2001888 512-byte hardware sectors (1025 MB)
[    8.648634] sd 0:0:0:0: [sda] Write Protect is off
[    8.663129] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    8.663605] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, 
doesn't support DPO or FUA
[    8.691824] sd 0:0:0:0: [sda] 2001888 512-byte hardware sectors (1025 MB)
[    8.712512] sd 0:0:0:0: [sda] Write Protect is off
[    8.726982] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[    8.727462] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, 
doesn't support DPO or FUA
[    8.754700]  sda:<4>Clocksource tsc unstable (delta = 140275209 ns)
[    8.774136] Time: pit clocksource has been installed.
[    8.979224] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[    9.000527] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[    9.000581]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[    9.046810] ata1.00: status: { DRDY }
[    9.057903] ata1: soft resetting link
[    9.071700] ata1.00: configured for MWDMA2
[    9.084159] ata1: EH complete
[    9.283365] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[    9.304673] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[    9.304728]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[    9.350958] ata1.00: status: { DRDY }
[    9.362046] ata1: soft resetting link
[    9.375830] ata1.00: configured for MWDMA2
[    9.388276] ata1: EH complete
[    9.587493] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[    9.608806] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[    9.608861]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[    9.655090] ata1.00: status: { DRDY }
[    9.666182] ata1: soft resetting link
[    9.679975] ata1.00: configured for MWDMA2
[    9.692423] ata1: EH complete
[    9.891737] ata1.00: limiting speed to MWDMA1:PIO4
[    9.906214] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[    9.927483] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[    9.927526]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[    9.973754] ata1.00: status: { DRDY }
[    9.984844] ata1: soft resetting link
[    9.998623] ata1.00: configured for MWDMA1
[   10.011068] ata1: EH complete
[   10.210291] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[   10.231591] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[   10.231634]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[   10.277850] ata1.00: status: { DRDY }
[   10.288943] ata1: soft resetting link
[   10.302724] ata1.00: configured for MWDMA1
[   10.315174] ata1: EH complete
[   10.514480] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[   10.535774] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[   10.535818]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[   10.582034] ata1.00: status: { DRDY }
[   10.593124] ata1: soft resetting link
[   10.606903] ata1.00: configured for MWDMA1
[   10.619335] sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
[   10.638312] sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
[   10.657784] Descriptor sense data with sense descriptors (in hex):
[   10.676411]         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
[   10.696558]         00 00 00 00
[   10.706601] sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
[   10.720127] end_request: I/O error, dev sda, sector 0
[   10.735360] Buffer I/O error on device sda, logical block 0
[   10.752212] ata1: EH complete
[   10.951561] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[   10.972864] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[   10.972907]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[   11.019124] ata1.00: status: { DRDY }
[   11.030214] ata1: soft resetting link
[   11.044001] ata1.00: configured for MWDMA1
[   11.056439] ata1: EH complete
[   11.255766] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[   11.277057] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[   11.277100]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[   11.323315] ata1.00: status: { DRDY }
[   11.334406] ata1: soft resetting link
[   11.348187] ata1.00: configured for MWDMA1
[   11.360617] ata1: EH complete
[   11.559852] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[   11.581152] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[   11.581195]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[   11.627411] ata1.00: status: { DRDY }
[   11.638503] ata1: soft resetting link
[   11.652281] ata1.00: configured for MWDMA1
[   11.664726] ata1: EH complete
[   11.864037] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[   11.885338] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[   11.885382]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[   11.931623] ata1.00: status: { DRDY }
[   11.942712] ata1: soft resetting link
[   11.956488] ata1.00: configured for MWDMA1
[   11.968934] ata1: EH complete
[   12.168151] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[   12.189442] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[   12.189485]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[   12.235701] ata1.00: status: { DRDY }
[   12.246790] ata1: soft resetting link
[   12.260575] ata1.00: configured for MWDMA1
[   12.273015] ata1: EH complete
[   12.472358] ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 
frozen
[   12.493668] ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 
data 4096 in
[   12.493712]          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 
(timeout)
[   12.539929] ata1.00: status: { DRDY }
[   12.551019] ata1: soft resetting link
[   12.564802] ata1.00: configured for MWDMA1
[   12.577247] sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
[   12.596225] sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
[   12.615694] Descriptor sense data with sense descriptors (in hex):
[   12.634324]         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
[   12.654472]         00 00 00 00
[   12.664516] sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
[   12.678039] end_request: I/O error, dev sda, sector 0
[   12.693273] Buffer I/O error on device sda, logical block 0
[   12.710123] ata1: EH complete
[   12.719187]  unable to read partition table
[   12.732602] sd 0:0:0:0: [sda] Attached SCSI removable disk



On Thu, 8 Nov 2007 10:48:13 +0000, Alan Cox wrote
> On Thu, 8 Nov 2007 09:16:35 +0200
> "Denys Fedoryshchenko" <denys@visp.net.lb> wrote:
> 
> > Does it work as kernel parameter?
> > 
> > I tried libata_dma_mask=0x4 and to set 0xf or 0xff - doesn't help. How to 
> > disable DMA in libata, if it is compiled in kernel?
> 
> libata.dma_mask=3
> 
> will leave you with CD and disk DMA but not CF DMA
> 
> (Note libata[DOT] not underscore)


--
Denys Fedoryshchenko
Technical Manager
Virtual ISP S.A.L.

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Jeff Garzik]

On Thu, Nov 08, 2007 at 06:44:31PM +0200, Denys Fedoryshchenko wrote:
> Doesn't help
> 
> WRAP ~ #cat /proc/cmdline
> console=ttyS0,38400n8 libata.dma_mask=3

It's "libata.dma" if its built into the kernel, or 'dma' module option
if built as a kernel module.

	Jeff

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Denys Fedoryshchenko]

Thanks, it works like that.

Seems in libata there is no fall-back to non-DMA mode, if DMA didn't work.

On Thu, 8 Nov 2007 12:31:39 -0500, Jeff Garzik wrote
> On Thu, Nov 08, 2007 at 06:44:31PM +0200, Denys Fedoryshchenko wrote:
> > Doesn't help
> > 
> > WRAP ~ #cat /proc/cmdline
> > console=ttyS0,38400n8 libata.dma_mask=3
> 
> It's "libata.dma" if its built into the kernel, or 'dma' module 
> option if built as a kernel module.
> 
> 	Jeff


--
Denys Fedoryshchenko
Technical Manager
Virtual ISP S.A.L.

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Alan Cox]

On Thu, 8 Nov 2007 21:56:32 +0200
"Denys Fedoryshchenko" <denys@visp.net.lb> wrote:

> Thanks, it works like that.
> 
> Seems in libata there is no fall-back to non-DMA mode, if DMA didn't work.


It should be falling back from UDMA or MWDMA to PIO, if not please file a
bug

Alan

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Tejun Heo]

Denys Fedoryshchenko wrote:
> Thanks, it works like that.
> 
> Seems in libata there is no fall-back to non-DMA mode, if DMA didn't work.

There is, it's just too conservative about that.  With improvements
pending for 2.6.24, it should be quite snappy at falling back to PIO if
configured transfer mode doesn't seem to work at all (consecutive IO
command failures after transfer mode configuration change).

-- 
tejun

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Robert Hancock]

Denys wrote:
> Finally i got full DMESG with 1GB card till end. Seems not readable too.
> 

..


> ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 in
>          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> ata1.00: status: { DRDY }
> ata1: soft resetting link
> ata1.00: configured for MWDMA1
> sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
> sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
> Descriptor sense data with sense descriptors (in hex):
>         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
>         00 00 00 00
> sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
> end_request: I/O error, dev sda, sector 0
> Buffer I/O error on device sda, logical block 0
> ata1: EH complete

I'm guessing that your CF-to-IDE adapter doesn't have the correct lines 
wired up for DMA to work properly, and the card indicates DMA support, 
which libata tries to use but which doesn't work. It looks like it never 
tried falling back to PIO after DMA failed. Seems like a deficiency in 
the speed-down logic?

-- 
Robert Hancock      Saskatoon, SK, Canada
To email, remove "nospam" from hancockr@nospamshaw.ca
Home Page: http://www.roberthancock.com/

Re: SC1200 failure in 2.6.23 and 2.6.24-rc1-git10

[Denys Fedoryshchenko]

You are right, seems no dma lines in adapter. hda=nodma helped, no errors 
anymore. I will try now also libata_dma_mask and will mail result. Btw there 
is no notes in Documentation/kernel-parameters.txt about it.

In any case it is complete board, WRAP.2C made by PCEngines in 2003. Kind of 
popular and mass produced, before was widely used by StarOS, probably known 
GPL violator, who didn't bother himself to supply patches, but at same time 
used it in his projects.

If it is valid for all board with this revision, maybe it is better to put it 
in some kind of fixup/quirk/black list, or how it is called?

On Wed, 07 Nov 2007 19:41:15 -0600, Robert Hancock wrote
> Denys wrote:
> > Finally i got full DMESG with 1GB card till end. Seems not readable too.
> >
> 
> ...
> 
> > ata1.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x2 frozen
> > ata1.00: cmd c8/00:08:00:00:00/00:00:00:00:00/e0 tag 0 cdb 0x0 data 4096 
in
> >          res 40/00:00:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> > ata1.00: status: { DRDY }
> > ata1: soft resetting link
> > ata1.00: configured for MWDMA1
> > sd 0:0:0:0: [sda] Result: hostbyte=0x00 driverbyte=0x08
> > sd 0:0:0:0: [sda] Sense Key : 0xb [current] [descriptor]
> > Descriptor sense data with sense descriptors (in hex):
> >         72 0b 00 00 00 00 00 0c 00 0a 80 00 00 00 00 00
> >         00 00 00 00
> > sd 0:0:0:0: [sda] ASC=0x0 ASCQ=0x0
> > end_request: I/O error, dev sda, sector 0
> > Buffer I/O error on device sda, logical block 0
> > ata1: EH complete
> 
> I'm guessing that your CF-to-IDE adapter doesn't have the correct 
> lines wired up for DMA to work properly, and the card indicates DMA 
> support, which libata tries to use but which doesn't work. It looks 
> like it never tried falling back to PIO after DMA failed. Seems like 
> a deficiency in the speed-down logic?
> 
> -- 
> Robert Hancock      Saskatoon, SK, Canada
> To email, remove "nospam" from hancockr@nospamshaw.ca
> Home Page: http://www.roberthancock.com/


--
Denys Fedoryshchenko
Technical Manager
Virtual ISP S.A.L.