On Tue, 2021-06-22 at 08:42 +0800, Ed Greshko wrote:
On 22/06/2021 05:41, Patrick O'Callaghan wrote:
On Mon, 2021-06-21 at 21:18 +0800, Ed Greshko wrote:
On 21/06/2021 20:31, Patrick O'Callaghan wrote:
On Mon, 2021-06-21 at 20:02 +0800, Ed Greshko wrote:
I thought I mentioned they should have been taken at the same time.
journal starts at
Jun 20 15:44:50
dmesg
Sun Jun 20 22:38:39 2021
Kinda hard to match things that way. :-)
OK, see reply to Chris below.
Right.
Well, I think it is well understood the HW in some form is responsible for the 30 sec delay in boot times. I see 3 avenues open.
1. Continue to search for the HW cause and hopefully fix it without incurring cost. 2. Find a way to ignore the HW during boot. 3. Live with the 30 second delay.
I was looking at #2 but couldn't find a way with BTRFS raid. Maybe with software raid and ext4.
I do wonder how many brain-seconds have collectively been used in search of a solution. :-) :-)
Well, I'm grateful to everyone who's chipped in, especially you and Chris, but don't feel in any way obliged.
One other data point and I'll leave it unless anything else turns up: I switched the two drives in the dock and got this from dmesg:
[Tue Jun 22 10:52:03 2021] usb 4-3: USB disconnect, device number 2 [Tue Jun 22 10:52:03 2021] sd 6:0:0:0: [sdd] Synchronizing SCSI cache [Tue Jun 22 10:52:03 2021] sd 6:0:0:0: [sdd] Synchronize Cache(10) failed: Result: hostbyte=DID_ERROR driverbyte=DRIVER_OK [Tue Jun 22 10:52:03 2021] sd 6:0:0:1: [sde] Synchronizing SCSI cache [Tue Jun 22 10:52:03 2021] sd 6:0:0:1: [sde] Synchronize Cache(10) failed: Result: hostbyte=DID_ERROR driverbyte=DRIVER_OK [Tue Jun 22 10:52:27 2021] usb 4-3: new SuperSpeed Gen 1 USB device number 4 using xhci_hcd [Tue Jun 22 10:52:27 2021] usb 4-3: New USB device found, idVendor=174c, idProduct=55aa, bcdDevice= 1.00 [Tue Jun 22 10:52:27 2021] usb 4-3: New USB device strings: Mfr=2, Product=3, SerialNumber=1 [Tue Jun 22 10:52:27 2021] usb 4-3: Product: ASM1156-PM [Tue Jun 22 10:52:27 2021] usb 4-3: Manufacturer: ASMT [Tue Jun 22 10:52:27 2021] usb 4-3: SerialNumber: 00000000000000000000 [Tue Jun 22 10:52:27 2021] scsi host6: uas [Tue Jun 22 10:52:27 2021] scsi 6:0:0:0: Direct-Access ASMT ASM1156-PM 0 PQ: 0 ANSI: 6 [Tue Jun 22 10:52:28 2021] scsi 6:0:0:1: Direct-Access ASMT ASM1156-PM 0 PQ: 0 ANSI: 6 [Tue Jun 22 10:52:28 2021] sd 6:0:0:0: Attached scsi generic sg4 type 0 [Tue Jun 22 10:52:28 2021] sd 6:0:0:1: Attached scsi generic sg5 type 0 [Tue Jun 22 10:52:28 2021] sd 6:0:0:0: [sdd] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) [Tue Jun 22 10:52:28 2021] sd 6:0:0:0: [sdd] 4096-byte physical blocks [Tue Jun 22 10:52:28 2021] sd 6:0:0:0: [sdd] Write Protect is off [Tue Jun 22 10:52:28 2021] sd 6:0:0:0: [sdd] Mode Sense: 43 00 00 00 [Tue Jun 22 10:52:28 2021] sd 6:0:0:1: [sde] 1953525168 512-byte logical blocks: (1.00 TB/932 GiB) [Tue Jun 22 10:52:28 2021] sd 6:0:0:1: [sde] 4096-byte physical blocks [Tue Jun 22 10:52:28 2021] sd 6:0:0:0: [sdd] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [Tue Jun 22 10:52:28 2021] sd 6:0:0:1: [sde] Write Protect is off [Tue Jun 22 10:52:28 2021] sd 6:0:0:1: [sde] Mode Sense: 43 00 00 00 [Tue Jun 22 10:52:28 2021] sd 6:0:0:0: [sdd] Optimal transfer size 33553920 bytes not a multiple of physical block size (4096 bytes) [Tue Jun 22 10:52:28 2021] sd 6:0:0:0: [sdd] Attached SCSI disk [Tue Jun 22 10:52:58 2021] sd 6:0:0:1: tag#26 uas_eh_abort_handler 0 uas-tag 2 inflight: IN <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<*** [Tue Jun 22 10:52:58 2021] sd 6:0:0:1: tag#26 CDB: Mode Sense(6) 1a 00 08 00 04 00 [Tue Jun 22 10:52:58 2021] scsi host6: uas_eh_device_reset_handler start [Tue Jun 22 10:52:58 2021] usb 4-3: reset SuperSpeed Gen 1 USB device number 4 using xhci_hcd [Tue Jun 22 10:52:58 2021] scsi host6: uas_eh_device_reset_handler success [Tue Jun 22 10:52:58 2021] sd 6:0:0:1: [sde] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [Tue Jun 22 10:52:58 2021] sd 6:0:0:1: [sde] Optimal transfer size 33553920 bytes not a multiple of physical block size (4096 bytes) [Tue Jun 22 10:52:58 2021] sd 6:0:0:1: [sde] Attached SCSI disk
The uas message is again from device 6:0:0:1 as before, even though the disks have been swapped. IOW the issue definitely comes from the dock, not from the physical drives themselves.
Thanks again.
poc