[Voyage-linux] CuBox-i4, esata, kernel 3.14 - problems writing files?
chris hermansen
(spam-protected)
Fri Jun 6 02:34:16 HKT 2014
Yesterday I bought another hi-res download and decided to try copying it
over, one file at a time, with a break between each file.
This seemed to work fine, no messages in syslog nor any other hiccups.
So I remain puzzled about the behaviour below. Once again, if anyone can
offer ideas on how to diagnose it further, I would be very grateful!
Thanks!
On Thu, May 29, 2014 at 7:15 PM, chris hermansen <clhermansen at gmail.com>
wrote:
> Good people;
>
> The other day, I bought some new music downloads and for the first time
> tried to use ssh to copy them over to my CuBox-i4.
>
> The first few files worked, but then the transfer "hung". I also see the
> following in syslog, which I think is related.
>
> May 22 17:58:25 voyage-mubox vmunix: ata1: exception Emask 0x10 SAct 0x0
> SErr 0x10200 action 0xe frozen
> May 22 17:58:25 voyage-mubox vmunix: ata1: irq_stat 0x00400000, PHY RDY
> changed
> May 22 17:58:25 voyage-mubox vmunix: ata1: SError: { Persist PHYRdyChg }
> May 22 17:58:25 voyage-mubox vmunix: ata1: hard resetting link
> May 22 17:58:26 voyage-mubox vmunix: ata1: SATA link down (SStatus 0
> SControl 300)
> May 22 17:58:31 voyage-mubox vmunix: ata1: hard resetting link
> May 22 17:58:32 voyage-mubox vmunix: ata1: SATA link down (SStatus 0
> SControl 300)
> May 22 17:58:32 voyage-mubox vmunix: ata1: limiting SATA link speed to 1.5
> Gbps
> May 22 17:58:37 voyage-mubox vmunix: ata1: hard resetting link
> May 22 17:58:37 voyage-mubox vmunix: ata1: SATA link down (SStatus 0
> SControl 310)
> May 22 17:58:37 voyage-mubox vmunix: ata1.00: disabled
> May 22 17:58:37 voyage-mubox vmunix: ata1: EH complete
> May 22 17:58:37 voyage-mubox vmunix: ata1.00: detaching (SCSI 0:0:0:0)
> May 22 17:58:37 voyage-mubox vmunix: sd 0:0:0:0: [sda] Synchronizing SCSI
> cache
> May 22 17:58:37 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 22 17:58:37 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 22 17:58:37 voyage-mubox vmunix: sd 0:0:0:0: [sda] Stopping disk
> May 22 17:58:37 voyage-mubox vmunix: sd 0:0:0:0: [sda] START_STOP FAILED
> May 22 17:58:37 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 22 17:58:37 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
>
> and later
>
> May 22 20:00:11 voyage-mubox vmunix: ata1: exception Emask 0x10 SAct 0x0
> SErr 0x4040000 action 0xe frozen
> May 22 20:00:11 voyage-mubox vmunix: ata1: irq_stat 0x00000040, connection
> status changed
> May 22 20:00:11 voyage-mubox vmunix: ata1: SError: { CommWake DevExch }
> May 22 20:00:11 voyage-mubox vmunix: ata1: hard resetting link
> May 22 20:00:16 voyage-mubox vmunix: ata1: SATA link up 3.0 Gbps (SStatus
> 123 SControl 300)
> May 22 20:00:17 voyage-mubox vmunix: ata1.00: ATA-9: WDC
> WD1003FZEX-00MK2A0, 01.01A01, max UDMA/133
> May 22 20:00:17 voyage-mubox vmunix: ata1.00: 1953525168 sectors, multi 0:
> LBA48
> May 22 20:00:17 voyage-mubox vmunix: ata1.00: configured for UDMA/133
> May 22 20:00:17 voyage-mubox vmunix: ata1: EH complete
> May 22 20:00:17 voyage-mubox vmunix: scsi 0:0:0:0: Direct-Access
> ATA WDC WD1003FZEX-0 01.0 PQ: 0 ANSI: 5
> May 22 20:00:17 voyage-mubox vmunix: sd 0:0:0:0: [sda] 1953525168 512-byte
> logical blocks: (1.00 TB/931 GiB)
> May 22 20:00:17 voyage-mubox vmunix: sd 0:0:0:0: [sda] Write Protect is off
> May 22 20:00:17 voyage-mubox vmunix: sd 0:0:0:0: [sda] Mode Sense: 00 3a
> 00 00
> May 22 20:00:17 voyage-mubox vmunix: sd 0:0:0:0: [sda] Write cache:
> enabled, read cache: enabled, doesn't support DPO or FUA
> May 22 20:00:17 voyage-mubox vmunix: sda: sda1
> May 22 20:00:17 voyage-mubox vmunix: sd 0:0:0:0: [sda] Attached SCSI disk
>
> and still later
>
> May 23 17:41:19 voyage-mubox vmunix: ata1.00: exception Emask 0x0 SAct 0x0
> SErr 0x0 action 0x6 frozen
> May 23 17:41:19 voyage-mubox vmunix: ata1.00: failed command: WRITE DMA EXT
> May 23 17:41:19 voyage-mubox vmunix: ata1.00: cmd
> 35/00:00:90:00:14/00:04:4b:00:00/e0 tag 0 dma 524288 out
> May 23 17:41:19 voyage-mubox vmunix: res
> 40/00:01:00:00:00/00:00:00:00:00/00 Emask 0x4 (timeout)
> May 23 17:41:19 voyage-mubox vmunix: ata1.00: status: { DRDY }
> May 23 17:41:19 voyage-mubox vmunix: ata1: hard resetting link
> May 23 17:41:29 voyage-mubox vmunix: ata1: softreset failed (device not
> ready)
> May 23 17:41:29 voyage-mubox vmunix: ata1: hard resetting link
> May 23 17:41:39 voyage-mubox vmunix: ata1: softreset failed (device not
> ready)
> May 23 17:41:39 voyage-mubox vmunix: ata1: hard resetting link
> May 23 17:41:50 voyage-mubox vmunix: ata1: link is slow to respond, please
> be patient (ready=0)
> May 23 17:42:14 voyage-mubox vmunix: ata1: softreset failed (device not
> ready)
> May 23 17:42:14 voyage-mubox vmunix: ata1: limiting SATA link speed to 1.5
> Gbps
> May 23 17:42:14 voyage-mubox vmunix: ata1: hard resetting link
> May 23 17:42:19 voyage-mubox vmunix: ata1: softreset failed (device not
> ready)
> May 23 17:42:19 voyage-mubox vmunix: ata1: reset failed, giving up
> May 23 17:42:19 voyage-mubox vmunix: ata1.00: disabled
> May 23 17:42:19 voyage-mubox vmunix: ata1.00: device reported invalid CHS
> sector 0
> May 23 17:42:19 voyage-mubox vmunix: ata1: EH complete
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:19 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:19 voyage-mubox vmunix: Write(10): 2a 00 4b 14 00 90 00 04 00
> 00
> May 23 17:42:19 voyage-mubox vmunix: end_request: I/O error, dev sda,
> sector 1259602064
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:19 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:19 voyage-mubox vmunix: Write(10): 2a 00 4b 14 04 90 00 03 70
> 00
> May 23 17:42:19 voyage-mubox vmunix: end_request: I/O error, dev sda,
> sector 1259603088
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:19 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:19 voyage-mubox vmunix: Read(10): 28 00 4b 18 08 00 00 00 08
> 00
> May 23 17:42:19 voyage-mubox vmunix: end_request: I/O error, dev sda,
> sector 1259866112
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:19 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:19 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 00 00 08 00 00 00 08
> 00
> May 23 17:42:20 voyage-mubox vmunix: end_request: I/O error, dev sda,
> sector 2048
> May 23 17:42:20 voyage-mubox vmunix: Buffer I/O error on device sda1,
> logical block 0
> May 23 17:42:20 voyage-mubox vmunix: lost page write due to I/O error on
> sda1
> May 23 17:42:20 voyage-mubox vmunix: EXT2-fs (sda1): error:
> read_block_bitmap: Cannot read block bitmap - block_group = 4806, block_b
> itmap = 157483008
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 18 10 00 00 90
> 00
> May 23 17:42:20 voyage-mubox vmunix: end_request: I/O error, dev sda,
> sector 1259608080
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 18 a8 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: end_request: I/O error, dev sda,
> sector 1259608232
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 18 a8 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: end_request: I/O error, dev sda,
> sector 1259608232
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Read(10): 28 00 4b 18 08 00 00 00 08
> 00
> May 23 17:42:20 voyage-mubox vmunix: end_request: I/O error, dev sda,
> sector 1259866112
> May 23 17:42:20 voyage-mubox vmunix: EXT2-fs (sda1): previous I/O error to
> superblock detected
> May 23 17:42:20 voyage-mubox vmunix:
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 1c a8 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: end_request: I/O error, dev sda,
> sector 1259609256
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 00 00 08 00 00 00 08
> 00
> May 23 17:42:20 voyage-mubox vmunix: end_request: I/O error, dev sda,
> sector 2048
> May 23 17:42:20 voyage-mubox vmunix: Buffer I/O error on device sda1,
> logical block 0
> May 23 17:42:20 voyage-mubox vmunix: lost page write due to I/O error on
> sda1
> May 23 17:42:20 voyage-mubox vmunix: EXT2-fs (sda1): error:
> read_block_bitmap: Cannot read block bitmap - block_group = 4806, block_b
> itmap = 157483008
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 20 a8 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: end_request: I/O error, dev sda,
> sector 1259610280
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 24 a8 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 28 a8 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 2c a8 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 30 a8 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 34 a8 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 38 b0 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 3c b0 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 40 b0 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 44 b0 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 48 b0 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 4c b0 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 50 b0 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
> May 23 17:42:20 voyage-mubox vmunix: Result: hostbyte=DID_BAD_TARGET
> driverbyte=DRIVER_OK
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] CDB:
> May 23 17:42:20 voyage-mubox vmunix: Write(10): 2a 00 4b 14 54 b0 00 04 00
> 00
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda] Unhandled error code
> May 23 17:42:20 voyage-mubox vmunix: sd 0:0:0:0: [sda]
>
> and so on.
>
> I unmounted the filesystem, disconnected it, mounted it on a machine
> running Ubuntu via the USB interface (rather than the esata), did an fsck.
> There were some inodes to clean up, and the usual collateral fixing, but
> nothing too serious it seems.
>
> Anyway - anyone have any ideas what might be going on here?
>
> --
> Chris Hermansen · clhermansen "at" gmail "dot" com
>
> C'est ma façon de parler.
>
--
Chris Hermansen · clhermansen "at" gmail "dot" com
C'est ma façon de parler.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://list.voyage.hk/pipermail/voyage-linux/attachments/20140605/cb03f1b2/attachment.html>
More information about the Voyage-linux
mailing list