Re: Bug report for ahci-mvebu driver

marius
2023-01-18T19:43:52Z

January 17, 2023 10:27 AM, "Damien Le Moal" <damien.lemoal@opensource.wdc.com> wrote:

> Could you try adding messages in the function sata_down_spd_limit() ?
> I recall that during probe, scr status does not give a current speed,
> which creates the problem of triggering that "return -EINVAL" in the else
> for "if (spd > 1)"...
>
> What I would like you to print is:
>
> diff --git a/drivers/ata/libata-core.c b/drivers/ata/libata-core.c
> index 884ae73b11ea..ad68f86be1c5 100644
> --- a/drivers/ata/libata-core.c
> +++ b/drivers/ata/libata-core.c
> @@ -3081,14 +3081,21 @@ int sata_down_spd_limit(struct ata_link *link, u32
> spd_limit)
> if (!sata_scr_valid(link))
> return -EOPNOTSUPP;
>
> + pr_info("sata_down_spd_limit: limit 0x%0x, cur spd 0x%0x, "
> + "saved limit 0x%0x, hw limit 0x%0x\n",
> + spd_limit, link->sata_spd
> + link->sata_spd_limit, link->hw_sata_spd_limit);
> +
> /* If SCR can be read, use it to determine the current SPD.
> * If not, use cached value in link->sata_spd.
> */
> rc = sata_scr_read(link, SCR_STATUS, &sstatus);
> - if (rc == 0 && ata_sstatus_online(sstatus))
> + if (rc == 0 && ata_sstatus_online(sstatus)) {
> spd = (sstatus >> 4) & 0xf;
> - else
> + pr_info("spd from STS: 0x%0x\n", spd);
> + } else {
> spd = link->sata_spd;
> + }
>
> mask = link->sata_spd_limit;
> if (mask <= 1)
>
> Please try printing that in addition to the messages you already have. And
> please try with default boot (no ata options) and with the 1.5gbps force
> (since that is the only one working).
>
> --
> Damien Le Moal
> Western Digital Research

---- no limit ----
[ 73.075849][ T112] hardreset, Online=>Offline
[ 73.075856][ T112] sata_set_spd_needed, scontrol=0x300
[ 73.080328][ T112] __sata_set_spd_needed, initial limit=0xFFFFFFFF
[ 73.085601][ T112] __sata_set_spd_needed, corrected limit=0xFFFFFFFF
[ 73.091900][ T112] __sata_set_spd_needed, target=0x0
[ 73.098386][ T112] __sata_set_spd_needed, spd=0x0
[ 73.103475][ T112] __sata_set_spd_needed, final *scontrol=0x300
[ 73.109363][ T112] resume, do loop
[ 73.343477][ T112] resume, after do loop
[ 73.403476][ T112] debounce, SCR=0x101
[ 73.463496][ T112] debounce, SCR=0x101
[ 73.523476][ T112] debounce, SCR=0x100
[ 73.583476][ T112] debounce, SCR=0x100
[ 73.643475][ T112] debounce, SCR=0x100
[ 73.703475][ T112] debounce, SCR=0x100
[ 73.763475][ T112] debounce, SCR=0x100
[ 73.823475][ T112] debounce, SCR=0x101
[ 73.883475][ T112] debounce, SCR=0x100
[ 73.943475][ T112] debounce, SCR=0x100
[ 74.003475][ T112] debounce, SCR=0x100
[ 74.063475][ T112] debounce, SCR=0x100
[ 74.123475][ T112] debounce, SCR=0x100
[ 74.183475][ T112] debounce, SCR=0x0
[ 74.243475][ T112] debounce, SCR=0x0
[ 74.303475][ T112] debounce, SCR=0x0
[ 74.363475][ T112] debounce, SCR=0x0
[ 74.423475][ T112] debounce, SCR=0x100
[ 74.427159][ T112] resume, return at end of function
[ 74.431015][ T112] hardreset, ata_phys_link_offline check failed
[ 74.436114][ T112] ata2: SATA link down (SStatus 100 SControl 300)
[ 74.448580][ T112] hardreset, Online=>Offline
[ 74.448586][ T112] sata_set_spd_needed, scontrol=0x300
[ 74.453053][ T112] __sata_set_spd_needed, initial limit=0xFFFFFFFF
[ 74.458318][ T112] __sata_set_spd_needed, corrected limit=0xFFFFFFFF
[ 74.464627][ T112] __sata_set_spd_needed, target=0x0
[ 74.471100][ T112] __sata_set_spd_needed, spd=0x0
[ 74.476189][ T112] __sata_set_spd_needed, final *scontrol=0x300
[ 74.482076][ T112] resume, do loop
[ 74.713476][ T112] resume, after do loop
[ 74.773475][ T112] debounce, SCR=0x101
[ 74.833475][ T112] debounce, SCR=0x100
[ 74.883500][ T112] debounce, SCR=0x100
[ 74.943476][ T112] debounce, SCR=0x100
[ 75.003475][ T112] debounce, SCR=0x100
[ 75.063475][ T112] debounce, SCR=0x101
[ 75.123475][ T112] debounce, SCR=0x100
[ 75.183475][ T112] debounce, SCR=0x101
[ 75.243475][ T112] debounce, SCR=0x100
[ 75.303475][ T112] debounce, SCR=0x100
[ 75.363475][ T112] debounce, SCR=0x100
[ 75.423476][ T112] debounce, SCR=0x100
[ 75.483475][ T112] debounce, SCR=0x100
[ 75.543495][ T112] debounce, SCR=0x100
[ 75.603475][ T112] debounce, SCR=0x100
[ 75.663475][ T112] debounce, SCR=0x100
[ 75.723475][ T112] debounce, SCR=0x101
[ 75.783475][ T112] debounce, SCR=0x100
[ 75.843475][ T112] debounce, SCR=0x100
[ 75.903475][ T112] debounce, SCR=0x100
[ 75.963475][ T112] debounce, SCR=0x100
[ 76.023475][ T112] debounce, SCR=0x100
[ 76.083475][ T112] debounce, SCR=0x100
[ 76.143475][ T112] debounce, SCR=0x100
[ 76.203475][ T112] debounce, SCR=0x100
[ 76.263475][ T112] debounce, SCR=0x100
[ 76.323475][ T112] debounce, SCR=0x100
[ 76.327332][ T112] resume, return at end of function
[ 76.331189][ T112] hardreset, ata_phys_link_offline check failed
[ 76.336287][ T112] ata2: SATA link down (SStatus 100 SControl 300)
[ 76.348747][ T112] sata_down_spd_limit: limit 0x1, cur spd 0x0, saved limit 0xffffffff, hw limit
0xffffffff
[ 76.358641][ T112] hardreset, Online=>Offline
[ 76.358646][ T112] sata_set_spd_needed, scontrol=0x300
[ 76.363113][ T112] __sata_set_spd_needed, initial limit=0xFFFFFFFF
[ 76.368377][ T112] __sata_set_spd_needed, corrected limit=0xFFFFFFFF
[ 76.374687][ T112] __sata_set_spd_needed, target=0x0
[ 76.381160][ T112] __sata_set_spd_needed, spd=0x0
[ 76.386254][ T112] __sata_set_spd_needed, final *scontrol=0x300
[ 76.392141][ T112] resume, do loop
[ 76.623476][ T112] resume, after do loop
[ 76.683475][ T112] debounce, SCR=0x100
[ 76.743475][ T112] debounce, SCR=0x101
[ 76.803475][ T112] debounce, SCR=0x100
[ 76.863475][ T112] debounce, SCR=0x100
[ 76.923475][ T112] debounce, SCR=0x100
[ 76.983476][ T112] debounce, SCR=0x100
[ 77.043475][ T112] debounce, SCR=0x100
[ 77.103495][ T112] debounce, SCR=0x100
[ 77.163476][ T112] debounce, SCR=0x100
[ 77.223475][ T112] debounce, SCR=0x100
[ 77.283475][ T112] debounce, SCR=0x101
[ 77.343475][ T112] debounce, SCR=0x100
[ 77.403475][ T112] debounce, SCR=0x101
[ 77.463475][ T112] debounce, SCR=0x100
[ 77.523475][ T112] debounce, SCR=0x100
[ 77.583475][ T112] debounce, SCR=0x100
[ 77.643475][ T112] debounce, SCR=0x100
[ 77.703475][ T112] debounce, SCR=0x100
[ 77.763475][ T112] debounce, SCR=0x100
[ 77.823475][ T112] debounce, SCR=0x100
[ 77.883475][ T112] debounce, SCR=0x100
[ 77.943475][ T112] debounce, SCR=0x101
[ 78.003475][ T112] debounce, SCR=0x100
[ 78.063475][ T112] debounce, SCR=0x101
[ 78.123475][ T112] debounce, SCR=0x100
[ 78.183475][ T112] debounce, SCR=0x100
[ 78.243475][ T112] debounce, SCR=0x100
[ 78.303476][ T112] debounce, SCR=0x100
[ 78.363475][ T112] debounce, SCR=0x100
[ 78.423475][ T112] debounce, SCR=0x100
[ 78.483475][ T112] debounce, SCR=0x100
[ 78.543475][ T112] debounce, SCR=0x100
[ 78.603475][ T112] debounce, SCR=0x100
[ 78.663494][ T112] debounce, SCR=0x100
[ 78.667353][ T112] resume, return at end of function
[ 78.671209][ T112] hardreset, ata_phys_link_offline check failed
[ 78.676306][ T112] ata2: SATA link down (SStatus 101 SControl 300)
[ 78.688765][ T112] sata_down_spd_limit: limit 0x1, cur spd 0x0, saved limit 0xffffffff, hw limit
0xffffffff
[ 78.698659][ T112] hardreset, Online=>Offline
[ 78.698664][ T112] sata_set_spd_needed, scontrol=0x300
[ 78.703131][ T112] __sata_set_spd_needed, initial limit=0xFFFFFFFF
[ 78.708395][ T112] __sata_set_spd_needed, corrected limit=0xFFFFFFFF
[ 78.714704][ T112] __sata_set_spd_needed, target=0x0
[ 78.721177][ T112] __sata_set_spd_needed, spd=0x0
[ 78.726272][ T112] __sata_set_spd_needed, final *scontrol=0x300
[ 78.732158][ T112] resume, do loop
[ 78.963475][ T112] resume, after do loop
[ 79.023475][ T112] debounce, SCR=0x100
[ 79.083476][ T112] debounce, SCR=0x100
[ 79.143475][ T112] debounce, SCR=0x101
[ 79.203476][ T112] debounce, SCR=0x100
[ 79.263475][ T112] debounce, SCR=0x101
[ 79.323475][ T112] debounce, SCR=0x100
[ 79.383475][ T112] debounce, SCR=0x100
[ 79.443476][ T112] debounce, SCR=0x100
[ 79.503475][ T112] debounce, SCR=0x100
[ 79.563475][ T112] debounce, SCR=0x100
[ 79.623475][ T112] debounce, SCR=0x100
[ 79.683475][ T112] debounce, SCR=0x101
[ 79.743475][ T112] debounce, SCR=0x100
[ 79.803475][ T112] debounce, SCR=0x101
[ 79.863475][ T112] debounce, SCR=0x100
[ 79.923475][ T112] debounce, SCR=0x101
[ 79.983475][ T112] debounce, SCR=0x100
[ 80.043475][ T112] debounce, SCR=0x101
[ 80.103475][ T112] debounce, SCR=0x100
[ 80.163475][ T112] debounce, SCR=0x100
[ 80.223495][ T112] debounce, SCR=0x101
[ 80.283476][ T112] debounce, SCR=0x100
[ 80.343475][ T112] debounce, SCR=0x100
[ 80.403475][ T112] debounce, SCR=0x100
[ 80.463475][ T112] debounce, SCR=0x100
[ 80.523475][ T112] debounce, SCR=0x100
[ 80.583475][ T112] debounce, SCR=0x100
[ 80.643475][ T112] debounce, SCR=0x100
[ 80.703475][ T112] debounce, SCR=0x100
[ 80.763475][ T112] debounce, SCR=0x100
[ 80.823475][ T112] debounce, SCR=0x100
[ 80.827332][ T112] resume, return at end of function
[ 80.831189][ T112] hardreset, ata_phys_link_offline check failed
[ 80.836288][ T112] ata2: SATA link down (SStatus 100 SControl 300)
[ 80.848748][ T112] sata_down_spd_limit: limit 0x1, cur spd 0x0, saved limit 0xffffffff, hw limit
0xffffffff
[ 80.858641][ T112] hardreset, Online=>Offline
[ 80.858646][ T112] sata_set_spd_needed, scontrol=0x300
[ 80.863114][ T112] __sata_set_spd_needed, initial limit=0xFFFFFFFF
[ 80.868377][ T112] __sata_set_spd_needed, corrected limit=0xFFFFFFFF
[ 80.874687][ T112] __sata_set_spd_needed, target=0x0
[ 80.881160][ T112] __sata_set_spd_needed, spd=0x0
[ 80.886255][ T112] __sata_set_spd_needed, final *scontrol=0x300
[ 80.892142][ T112] resume, do loop
[ 81.123500][ T112] resume, after do loop
[ 81.183476][ T112] debounce, SCR=0x100
[ 81.243475][ T112] debounce, SCR=0x100
[ 81.303475][ T112] debounce, SCR=0x100
[ 81.363476][ T112] debounce, SCR=0x100
[ 81.423476][ T112] debounce, SCR=0x100
[ 81.483475][ T112] debounce, SCR=0x100
[ 81.543475][ T112] debounce, SCR=0x100
[ 81.603475][ T112] debounce, SCR=0x100
[ 81.663475][ T112] debounce, SCR=0x100
[ 81.667334][ T112] resume, return at end of function
[ 81.671190][ T112] hardreset, ata_phys_link_offline check failed
[ 81.676288][ T112] ata2: SATA link down (SStatus 100 SControl 300)
[ 81.688731][ T112] ata2: EH pending after 5 tries, giving up

---- limit 1.5Gbps ----

[ 19.819298][ T112] hardreset, Online=>Offline
[ 19.819306][ T112] sata_set_spd_needed, scontrol=0x310
[ 19.823798][ T112] __sata_set_spd_needed, initial limit=0x1
[ 19.829052][ T112] __sata_set_spd_needed, corrected limit=0x1
[ 19.834752][ T112] __sata_set_spd_needed, target=0x1
[ 19.840614][ T112] __sata_set_spd_needed, spd=0x1
[ 19.845703][ T112] __sata_set_spd_needed, final *scontrol=0x310
[ 19.851592][ T112] resume, do loop
[ 20.083568][ T112] resume, after do loop
[ 20.143567][ T112] debounce, SCR=0x113
[ 20.203567][ T112] debounce, SCR=0x113
[ 20.263567][ T112] debounce, SCR=0x113
[ 20.323566][ T112] debounce, SCR=0x113
[ 20.383566][ T112] debounce, SCR=0x113
[ 20.443566][ T112] debounce, SCR=0x113
[ 20.503566][ T112] debounce, SCR=0x113
[ 20.563566][ T112] debounce, SCR=0x113
[ 20.623566][ T112] debounce, SCR=0x113
[ 20.627424][ T112] resume, return at end of function
[ 20.631280][ T112] hardreset, Offline=>Online
[ 20.640838][ T112] hardreset, sata_pmp_supported, before check_ready
[ 20.803595][ T112] ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[ 20.817315][ T112] ata2.15: Port Multiplier 1.2, 0x197b:0x0325 r193, 8 ports, feat 0xf/0x1f
[ 20.825960][ T112] device: 'link2.0': device_add
[ 20.830777][ T112] device: 'link2.0': device_add
[ 20.835790][ T112] device: 'dev2.0.0': device_add
[ 20.840636][ T112] device: 'dev2.0.0': device_add
[ 20.846288][ T112] device: 'link2.1': device_add
[ 20.851053][ T112] device: 'link2.1': device_add
[ 20.856268][ T112] device: 'dev2.1.0': device_add
[ 20.861117][ T112] device: 'dev2.1.0': device_add
[ 20.866722][ T112] device: 'link2.2': device_add
[ 20.871488][ T112] device: 'link2.2': device_add
[ 20.876368][ T112] device: 'dev2.2.0': device_add
[ 20.881214][ T112] device: 'dev2.2.0': device_add
[ 20.886777][ T112] device: 'link2.3': device_add
[ 20.891541][ T112] device: 'link2.3': device_add
[ 20.896427][ T112] device: 'dev2.3.0': device_add
[ 20.901275][ T112] device: 'dev2.3.0': device_add
[ 20.906277][ T112] device: 'link2.4': device_add
[ 20.911039][ T112] device: 'link2.4': device_add
[ 20.915946][ T112] device: 'dev2.4.0': device_add
[ 20.921082][ T112] device: 'dev2.4.0': device_add
[ 20.926100][ T112] device: 'link2.5': device_add
[ 20.930863][ T112] device: 'link2.5': device_add
[ 20.936073][ T112] device: 'dev2.5.0': device_add
[ 20.940925][ T112] device: 'dev2.5.0': device_add
[ 20.946222][ T112] device: 'link2.6': device_add
[ 20.950988][ T112] device: 'link2.6': device_add
[ 20.956436][ T112] device: 'dev2.6.0': device_add
[ 20.961292][ T112] device: 'dev2.6.0': device_add
[ 20.966849][ T112] device: 'link2.7': device_add
[ 20.971618][ T112] device: 'link2.7': device_add
[ 20.976506][ T112] device: 'dev2.7.0': device_add
[ 20.981358][ T112] device: 'dev2.7.0': device_add
[ 20.986928][ T112] device: 'link2.8': device_add
[ 20.991700][ T112] device: 'link2.8': device_add
[ 20.996612][ T112] device: 'dev2.8.0': device_add
[ 21.001760][ T112] device: 'dev2.8.0': device_add
[ 21.006776][ T112] device: 'link2.9': device_add
[ 21.011544][ T112] device: 'link2.9': device_add
[ 21.017066][ T112] device: 'dev2.9.0': device_add
[ 21.021924][ T112] device: 'dev2.9.0': device_add
[ 21.027237][ T112] device: 'link2.10': device_add
[ 21.032095][ T112] device: 'link2.10': device_add
[ 21.037406][ T112] device: 'dev2.10.0': device_add
[ 21.042352][ T112] device: 'dev2.10.0': device_add
[ 21.048268][ T112] device: 'link2.11': device_add
[ 21.053129][ T112] device: 'link2.11': device_add
[ 21.058157][ T112] device: 'dev2.11.0': device_add
[ 21.063101][ T112] device: 'dev2.11.0': device_add
[ 21.068830][ T112] device: 'link2.12': device_add
[ 21.073707][ T112] device: 'link2.12': device_add
[ 21.078703][ T112] device: 'dev2.12.0': device_add
[ 21.083664][ T112] device: 'dev2.12.0': device_add
[ 21.088772][ T112] device: 'link2.13': device_add
[ 21.093645][ T112] device: 'link2.13': device_add
[ 21.098637][ T112] device: 'dev2.13.0': device_add
[ 21.103606][ T112] device: 'dev2.13.0': device_add
[ 21.109014][ T112] device: 'link2.14': device_add
[ 21.113901][ T112] device: 'link2.14': device_add
[ 21.119225][ T112] device: 'dev2.14.0': device_add
[ 21.124190][ T112] device: 'dev2.14.0': device_add
[ 21.130120][ T112] ahci-mvebu f10a8000.sata: FBS is enabled
[ 21.135879][ T112] ata2.00: SCR_CONTROL = 0x300
[ 21.140525][ T112] ata2.00: FORCE: PHY spd limit set to 1.5Gbps
[ 21.146622][ T112] ata2.01: SCR_CONTROL = 0x300
[ 21.151266][ T112] ata2.01: FORCE: PHY spd limit set to 1.5Gbps
[ 21.157358][ T112] ata2.02: SCR_CONTROL = 0x300
[ 21.162001][ T112] ata2.02: FORCE: PHY spd limit set to 1.5Gbps
[ 21.168099][ T112] ata2.03: SCR_CONTROL = 0x300
[ 21.172743][ T112] ata2.03: FORCE: PHY spd limit set to 1.5Gbps
[ 21.178835][ T112] ata2.04: SCR_CONTROL = 0x300
[ 21.183478][ T112] ata2.04: FORCE: PHY spd limit set to 1.5Gbps
[ 21.189572][ T112] ata2.05: SCR_CONTROL = 0x300
[ 21.194235][ T112] ata2.05: FORCE: PHY spd limit set to 1.5Gbps
[ 21.200304][ T112] ata2.06: SCR_CONTROL = 0x300
[ 21.204972][ T112] ata2.06: FORCE: PHY spd limit set to 1.5Gbps
[ 21.211041][ T112] ata2.07: SCR_CONTROL = 0x300
[ 21.215704][ T112] ata2.07: FORCE: PHY spd limit set to 1.5Gbps
[ 21.221851][ T112] ata2.00: hard resetting link
[ 21.226515][ T112] hardreset, Online=>Offline
[ 21.226553][ T112] sata_set_spd_needed, scontrol=0x300
[ 21.231021][ T112] __sata_set_spd_needed, initial limit=0x1
[ 21.236291][ T112] __sata_set_spd_needed, corrected limit=0x1
[ 21.241980][ T112] __sata_set_spd_needed, target=0x1
[ 21.247853][ T112] __sata_set_spd_needed, spd=0x0
[ 21.252930][ T112] __sata_set_spd_needed, final *scontrol=0x310
[ 21.257850][ T112] __sata_set_spd_needed, initial limit=0x1
[ 21.263906][ T112] __sata_set_spd_needed, corrected limit=0x1
[ 21.269594][ T112] __sata_set_spd_needed, target=0x1
[ 21.275467][ T112] __sata_set_spd_needed, spd=0x0
[ 21.280545][ T112] __sata_set_spd_needed, final *scontrol=0x310
[ 21.286568][ T112] resume, do loop
[ 21.513601][ T112] resume, after do loop
[ 21.522240][ T112] debounce, SCR=0x123
[ 21.531389][ T112] debounce, SCR=0x123
[ 21.540363][ T112] debounce, SCR=0x123
[ 21.549337][ T112] debounce, SCR=0x123
[ 21.558293][ T112] debounce, SCR=0x123
[ 21.567248][ T112] debounce, SCR=0x123
[ 21.576203][ T112] debounce, SCR=0x123
[ 21.585159][ T112] debounce, SCR=0x123
[ 21.594114][ T112] debounce, SCR=0x123
[ 21.603069][ T112] debounce, SCR=0x123
[ 21.612041][ T112] debounce, SCR=0x123
[ 21.621017][ T112] debounce, SCR=0x123
[ 21.624952][ T112] resume, return at end of function
[ 21.628840][ T112] hardreset, Offline=>Online
[ 21.638398][ T112] hardreset, after check_ready
[ 21.638610][ T112] ata2.00: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 21.650473][ T112] ata2.01: hard resetting link
[ 21.655136][ T112] hardreset, Online=>Offline
[ 21.655171][ T112] sata_set_spd_needed, scontrol=0x300
[ 21.659639][ T112] __sata_set_spd_needed, initial limit=0x1
[ 21.664908][ T112] __sata_set_spd_needed, corrected limit=0x1
[ 21.670596][ T112] __sata_set_spd_needed, target=0x1
[ 21.676470][ T112] __sata_set_spd_needed, spd=0x0
[ 21.681546][ T112] __sata_set_spd_needed, final *scontrol=0x310
[ 21.686463][ T112] __sata_set_spd_needed, initial limit=0x1
[ 21.692501][ T112] __sata_set_spd_needed, corrected limit=0x1
[ 21.698206][ T112] __sata_set_spd_needed, target=0x1
[ 21.704080][ T112] __sata_set_spd_needed, spd=0x0
[ 21.709157][ T112] __sata_set_spd_needed, final *scontrol=0x310
[ 21.715178][ T112] resume, do loop
[ 21.943601][ T112] resume, after do loop
[ 21.952238][ T112] debounce, SCR=0x123
[ 21.961386][ T112] debounce, SCR=0x123
[ 21.970359][ T112] debounce, SCR=0x123
[ 21.979332][ T112] debounce, SCR=0x123
[ 21.988287][ T112] debounce, SCR=0x123
[ 21.997242][ T112] debounce, SCR=0x123
[ 22.006197][ T112] debounce, SCR=0x123
[ 22.015153][ T112] debounce, SCR=0x123
[ 22.024109][ T112] debounce, SCR=0x123
[ 22.033063][ T112] debounce, SCR=0x123
[ 22.042035][ T112] debounce, SCR=0x123
[ 22.051009][ T112] debounce, SCR=0x123
[ 22.054944][ T112] resume, return at end of function
[ 22.058831][ T112] hardreset, Offline=>Online
[ 22.068388][ T112] hardreset, after check_ready
[ 22.068597][ T112] ata2.01: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 22.080480][ T112] ata2.02: hard resetting link
[ 22.085143][ T112] hardreset, Online=>Offline
[ 22.085179][ T112] sata_set_spd_needed, scontrol=0x300
[ 22.089647][ T112] __sata_set_spd_needed, initial limit=0x1
[ 22.094916][ T112] __sata_set_spd_needed, corrected limit=0x1
[ 22.100604][ T112] __sata_set_spd_needed, target=0x1
[ 22.106477][ T112] __sata_set_spd_needed, spd=0x0
[ 22.111555][ T112] __sata_set_spd_needed, final *scontrol=0x310
[ 22.116472][ T112] __sata_set_spd_needed, initial limit=0x1
[ 22.122510][ T112] __sata_set_spd_needed, corrected limit=0x1
[ 22.128215][ T112] __sata_set_spd_needed, target=0x1
[ 22.134089][ T112] __sata_set_spd_needed, spd=0x0
[ 22.139167][ T112] __sata_set_spd_needed, final *scontrol=0x310
[ 22.145189][ T112] resume, do loop
[ 22.373600][ T112] resume, after do loop
[ 22.382236][ T112] debounce, SCR=0x0
[ 22.391383][ T112] debounce, SCR=0x0
[ 22.400182][ T112] debounce, SCR=0x0
[ 22.408981][ T112] debounce, SCR=0x0
[ 22.417762][ T112] debounce, SCR=0x0
[ 22.426544][ T112] debounce, SCR=0x0
[ 22.435326][ T112] debounce, SCR=0x0
[ 22.444106][ T112] debounce, SCR=0x0
[ 22.452887][ T112] debounce, SCR=0x0
[ 22.461685][ T112] debounce, SCR=0x0
[ 22.470484][ T112] debounce, SCR=0x0
[ 22.479283][ T112] debounce, SCR=0x0
[ 22.488064][ T112] debounce, SCR=0x0
[ 22.491807][ T112] resume, return at end of function
[ 22.495538][ T112] hardreset, ata_phys_link_offline check failed
[ 22.500820][ T112] ata2.02: SATA link down (SStatus 0 SControl 300)
... same for ata2.03 - ata2.07
[ 24.700822][ T112] ata2.07: SATA link down (SStatus 0 SControl 300)
[ 24.713496][ T112] ata2.00: ATA-6: WDC WD50ARC-5040-VOL#01, 0100 AX, max UDMA/133
[ 24.721125][ T112] ata2.00: 976773168 sectors, multi 0: LBA48
[ 24.727228][ T112] ata2.00: configured for UDMA/133
[ 24.732296][ T112] ata2.01: ATA-6: Areca Archive, 0100 AX, max UDMA/133
[ 24.739227][ T112] ata2.01: 23437498368 sectors, multi 0: LBA48
[ 24.745499][ T112] ata2.01: configured for UDMA/133
[ 24.750648][ T112] ata2: EH complete
[ 24.755230][ T63] scsi 1:0:0:0: Direct-Access ATA WDC WD50ARC-5040 n/a PQ: 0 ANSI: 5
[ 24.764991][ T63] device: 'target1:0:0': device_add
[ 24.770118][ T63] bus: 'scsi': add device target1:0:0
[ 24.775498][ T63] device: '1:0:0:0': device_add
[ 24.780565][ T63] bus: 'scsi': add device 1:0:0:0
[ 24.785552][ T63] scsi 1:0:0:0: scheduling asynchronous probe
[ 24.791555][ T63] device: '1:0:0:0': device_add
[ 24.791569][ T118] bus: 'scsi': __driver_probe_device: matched device 1:0:0:0 with driver sd
[ 24.796461][ T63] device: '1:0:0:0': device_add
[ 24.804926][ T118] bus: 'scsi': really_probe: probing driver sd with device 1:0:0:0
[ 24.817484][ T118] sd 1:0:0:0: no default pinctrl state
[ 24.822937][ T118] device: '1:0:0:0': device_add
[ 24.824243][ T63] scsi 1:1:0:0: Direct-Access ATA Areca Archive n/a PQ: 0 ANSI: 5
[ 24.828657][ T118] sd 1:0:0:0: [sdb] 976773168 512-byte logical blocks: (500 GB/466 GiB)
[ 24.837872][ T63] device: 'target1:1:0': device_add
[ 24.845150][ T118] sd 1:0:0:0: [sdb] Write Protect is off
[ 24.849923][ T63] bus: 'scsi': add device target1:1:0
[ 24.855451][ T118] sd 1:0:0:0: [sdb] Mode Sense: 00 3a 00 00
[ 24.860757][ T63] device: '1:1:0:0': device_add
[ 24.866593][ T118] sd 1:0:0:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support
DPO or FUA
[ 24.871964][ T63] bus: 'scsi': add device 1:1:0:0
[ 24.881186][ T118] sd 1:0:0:0: [sdb] Preferred minimum I/O size 512 bytes
[ 24.886609][ T63] scsi 1:1:0:0: scheduling asynchronous probe
[ 24.892843][ T118] device: 'sdb': device_add
[ 24.898807][ T63] device: '1:1:0:0': device_add
[ 24.903982][ T7] bus: 'scsi': __driver_probe_device: matched device 1:1:0:0 with driver sd
[ 24.908057][ T63] device: '1:1:0:0': device_add
[ 24.916484][ T7] bus: 'scsi': really_probe: probing driver sd with device 1:1:0:0
[ 24.929038][ T7] sd 1:1:0:0: no default pinctrl state
[ 24.934513][ T7] device: '1:1:0:0': device_add
[ 24.941340][ T118] device: '8:16': device_add
[ 24.947108][ T7] sd 1:1:0:0: [sdc] 23437498368 512-byte logical blocks: (12.0 TB/10.9 TiB)
[ 24.955826][ T7] sd 1:1:0:0: [sdc] Write Protect is off
[ 24.961351][ T7] sd 1:1:0:0: [sdc] Mode Sense: 00 3a 00 00
[ 24.967286][ T7] sd 1:1:0:0: [sdc] Write cache: enabled, read cache: enabled, doesn't support DPO
or FUA
[ 24.977267][ T7] sd 1:1:0:0: [sdc] Preferred minimum I/O size 512 bytes
[ 24.984224][ T7] device: 'sdc': device_add
[ 24.990405][ T7] device: '8:32': device_add
[ 25.016696][ T7] sd 1:1:0:0: [sdc] Attached SCSI removable disk
[ 25.022920][ T7] driver: 'sd': driver_bound: bound to device '1:1:0:0'
[ 25.030261][ T7] bus: 'scsi': really_probe: bound device 1:1:0:0 to driver sd
[ 25.037753][ T7] sd 1:1:0:0: async probe completed
[ 25.426417][ T118] sd 1:0:0:0: [sdb] Attached SCSI removable disk
[ 25.432640][ T118] driver: 'sd': driver_bound: bound to device '1:0:0:0'
[ 25.439564][ T118] bus: 'scsi': really_probe: bound device 1:0:0:0 to driver sd
[ 25.447043][ T118] sd 1:0:0:0: async probe completed

Marius