Rsync problem

Status
Not open for further replies.

screeny

Dabbler
Joined
Jan 17, 2014
Messages
30
After starting rsync cron job I get some error message az below.

Can anyone help what's the problem?

Thanks in advance!

Mar 8 12:42:03 freenas kernel: (ada4:ahcich0:0:0:0): WRITE_DMA. ACB: ca 00 30 dd 40 42 00 00 00 00 00 00
Mar 8 12:42:03 freenas kernel: (ada4:ahcich0:0:0:0): CAM status: Uncorrectable parity/CRC error
Mar 8 12:42:03 freenas kernel: (ada4:ahcich0:0:0:0): Retrying command
Mar 8 12:42:36 freenas kernel: ahcich0: Timeout on slot 29 port 0
Mar 8 12:42:36 freenas kernel: ahcich0: is 04000000 cs 20000000 ss 00000000 rs 20000000 tfd 50 serr 00400000 cmd 0004dd17
Mar 8 12:42:36 freenas kernel: (aprobe0:ahcich0:0:0:0): ATA_IDENTIFY. ACB: ec 00 00 00 00 40 00 00 00 00 00 00
Mar 8 12:42:36 freenas kernel: (aprobe0:ahcich0:0:0:0): CAM status: Command timeout
Mar 8 12:42:36 freenas kernel: (aprobe0:ahcich0:0:0:0): Error 5, Retry was blocked
Mar 8 12:43:06 freenas kernel: ahcich0: Timeout on slot 29 port 0
Mar 8 12:43:06 freenas kernel: ahcich0: is 00000000 cs 20000000 ss 00000000 rs 20000000 tfd 150 serr 00000000 cmd 0004dd17
Mar 8 12:43:06 freenas kernel: (aprobe0:ahcich0:0:0:0): ATA_IDENTIFY. ACB: ec 00 00 00 00 40 00 00 00 00 00 00
Mar 8 12:43:06 freenas kernel: (aprobe0:ahcich0:0:0:0): CAM status: Command timeout
Mar 8 12:43:06 freenas kernel: (aprobe0:ahcich0:0:0:0): Error 5, Retry was blocked
Mar 8 12:43:06 freenas kernel: (ada4:ahcich0:0:0:0): lost device
Mar 8 12:43:36 freenas kernel: ahcich0: Timeout on slot 29 port 0
Mar 8 12:43:36 freenas kernel: ahcich0: is 00000000 cs 60000000 ss 00000000 rs 60000000 tfd 150 serr 00000000 cmd 0004dd17
Mar 8 12:43:36 freenas kernel: (ada4:ahcich0:0:0:0): WRITE_DMA. ACB: ca 00 30 dd 40 42 00 00 00 00 00 00
Mar 8 12:43:36 freenas kernel: (ada4:ahcich0:0:0:0): CAM status: Command timeout
Mar 8 12:43:36 freenas kernel: (ada4:ahcich0:0:0:0): Error 5, Periph was invalidated
Mar 8 12:43:36 freenas kernel: (ada4:ahcich0:0:0:0): WRITE_DMA. ACB: ca 00 30 de 40 42 00 00 00 00 00 00
Mar 8 12:43:36 freenas kernel: (ada4:ahcich0:0:0:0): CAM status: Unconditionally Re-queue Request
Mar 8 12:43:36 freenas kernel: (ada4:ahcich0:0:0:0): Error 5, Periph was invalidated
Mar 8 12:43:36 freenas kernel: (ada4:ahcich0:0:0:0): removing device entry
Mar 8 12:43:57 freenas kernel: ahcich0: Poll timeout on slot 30 port 0
Mar 8 12:43:57 freenas kernel: ahcich0: is 00000000 cs 40000000 ss 00000000 rs 40000000 tfd 150 serr 01000000 cmd 0004de17
Mar 8 12:43:57 freenas kernel: (aprobe0:ahcich0:0:0:0): SOFT_RESET. ACB: 00 00 00 00 00 00 00 00 00 00 00 00
Mar 8 12:43:57 freenas kernel: (aprobe0:ahcich0:0:0:0): CAM status: Command timeout
Mar 8 12:43:57 freenas kernel: (aprobe0:ahcich0:0:0:0): Error 5, Retries exhausted
 

cyberjock

Inactive Account
Joined
Mar 25, 2012
Messages
19,526
looks like ada4 is having problems. Could be a bad drive, bad cable, bad PSU, or bad/incompatible SATA controller.
 

screeny

Dabbler
Joined
Jan 17, 2014
Messages
30
Thank your for diagnoze. Now I'm going to wipe the new drive (ada4).
Interesting because new separated drive holder and new SATA controller installed.
I can "work" (read-write) properly as tested but when I run rsync it's going to get crazy somehow.

I also received two email from NAS:

1.
This message was generated by the smartd daemon running on:

host name: freenas
DNS domain: local

The following warning/error was logged by the smartd daemon:

Device: /dev/ada4, failed to read SMART Attribute Data

2.
The following warning/error was logged by the smartd daemon:

Device: /dev/ada4, not capable of SMART self-check

Do we know what exaclty means this?
I turned off SMART.
 

screeny

Dabbler
Joined
Jan 17, 2014
Messages
30
I setup a new rsync with wiped&deleted/rebuilt drive and now 15min rsync running smoothly.... I hope will stay in this condition :)
Certainly takes time to rsync 1,5M files at first time :)

Just tell me please if I'm doing wrong :)

Next time I'll check box the "delete" in rsync job to delete the non existing files too.

Thank you!
 

Yatti420

Wizard
Joined
Aug 12, 2012
Messages
1,437
You want smart running.. What is the output of "smartctl -a -q noserial /dev/ada4"
 

screeny

Dabbler
Joined
Jan 17, 2014
Messages
30
NOW I become CRAZY!

After 30min smooth rsync the NAS restarted.
I checked the copied files and it's seems ok... certainly within this 30min.
I don't know what can I do!

I just see this:
Mar 8 19:51:08 freenas kernel: ahcich0: Timeout on slot 27 port 0 Mar 8 19:51:08 freenas kernel: ahcich0: is 00000000 cs 00000000 ss 00000000 rs 08000000 tfd 451 serr 00000000 cmd 0004db17

For "smartctl -a -q noserial /dev/ada4"I got this:
smartctl -a -q noserial /dev/ada4 smartctl 6.1 2013-03-16 r3800 [FreeBSD 9.1-STABLE amd64] (local build) Copyright (C) 2002-13, Bruce Allen, Christian Franke, www.smartmontools.org === START OF INFORMATION SECTION === Model Family: Western Digital Caviar Green (AF, SATA 6Gb/s) Device Model: WDC WD30EZRX-00D8PB0 Firmware Version: 80.00A80 User Capacity: 3,000,592,982,016 bytes [3.00 TB] Sector Size: 512 bytes logical/physical Rotation Rate: 5400 rpm Device is: In smartctl database [for details use: -P show] ATA Version is: ACS-2 (minor revision not indicated) SATA Version is: SATA 3.0, 6.0 Gb/s (current: 3.0 Gb/s) Local Time is: Sat Mar 8 19:56:36 2014 CET SMART support is: Available - device has SMART capability. SMART support is: Enabled Warning! SMART Attribute Data Structure error: invalid SMART checksum.
 

screeny

Dabbler
Joined
Jan 17, 2014
Messages
30
Now after restart (system and rsync) tons of same error:

Mar 8 20:04:24 freenas rsync: rsync: recv_generator: failed to stat "/mnt/Backup/Archiv_2TB_I/2011 PILISI MUNK\#303\#201K/E S K \#303\#234 V \#305\#220 K/Csil\#303\#263 Tibi-Sz\#303\#241sz M\#303\#263nika/ZOL_3075.NEF": Device not configured (6)
 

screeny

Dabbler
Joined
Jan 17, 2014
Messages
30
Hardware:
PCI Express -> 2x SATAIII+2x eSATA Best Connect (ASMedia ASM106x chipset)
Western Digital Caviar Green 3.5" 3TB (WD30EZRX)
Raidsonic ICY BOX IB-351StU3S-B 3.5" SATA USB3.0/eSATA
 

Yatti420

Wizard
Joined
Aug 12, 2012
Messages
1,437
Something isn't correct.. Can you post the full output in code tags... Have you run smart tests on your drives etc?
 

screeny

Dabbler
Joined
Jan 17, 2014
Messages
30
Now I give it up!
Unfortunately I can't reconnect the storage to NAS.
I'm going to attach to a Win machine and setup a backup schedule on it via Gbit network.
For the first time certainly take a lot of time but I have no another idea.

This will works for me for future.

But thank you by the way Yatti420:)
 

cyberjock

Inactive Account
Joined
Mar 25, 2012
Messages
19,526
When I said something is wrong with ada4 a wipe wasn't going to fix it. It might mask it temporarily, but something else is wrong. So yeah, problem not solved.

Post the output like Yatti420 asked and that might give a hint as to if its the hard drive or not.
 

screeny

Dabbler
Joined
Jan 17, 2014
Messages
30
Okay, it's nice to encourage me.

Could you tell me where can I find the output log?
 
Status
Not open for further replies.
Top