You are not logged in.

#1 2013-01-08 22:57:44

breed808
Member
From: Australia
Registered: 2012-10-27
Posts: 15

[Solved] mkinitcpio 0.12 causing massive boot delays

Hi all, I'm having a bit of trouble with the latest version of mkinitcpio: it's delaying my boot by about 50-60 seconds.
I was able to fix this in the previous version of mkinitcpio by removing the 'pata' and 'scsi' hooks from mkinitcpio.conf. However, as these hooks have been replaced by 'block', I can't find a way to fix this.

Should I consider downgrading mkinitcpio?

Here's the dmesg output (edited for brevity):

[    2.941003] sd 18:0:0:0: [sdc] 15654848 512-byte logical blocks: (8.01 GB/7.46 GiB)
[    2.941507] sd 18:0:0:0: [sdc] Write Protect is off
[    2.941512] sd 18:0:0:0: [sdc] Mode Sense: 16 24 09 51
[    2.942137] sd 18:0:0:0: [sdc] Incomplete mode parameter data
[    2.942925] sd 18:0:0:0: [sdc] Assuming drive cache: write through
[    2.946405] sd 18:0:0:0: [sdc] Incomplete mode parameter data
[    2.947152] sd 18:0:0:0: [sdc] Assuming drive cache: write through
[    2.949037]  sdc: sdc1
[    2.951362] sd 18:0:0:0: [sdc] Incomplete mode parameter data
[    2.952091] sd 18:0:0:0: [sdc] Assuming drive cache: write through
[    2.952933] sd 18:0:0:0: [sdc] Attached SCSI removable disk
[    3.063360] scsi 19:0:0:0: Direct-Access     WD       My Book 1140     1003 PQ: 0 ANSI: 6
[    3.063740] sd 19:0:0:0: [sdd] 3906963456 512-byte logical blocks: (2.00 TB/1.81 TiB)
[    3.063868] scsi 19:0:0:1: Enclosure         WD       SES Device       1003 PQ: 0 ANSI: 6
[    3.064438] sd 19:0:0:0: [sdd] Write Protect is off
[    3.064445] sd 19:0:0:0: [sdd] Mode Sense: 47 00 10 08
[    3.065065] sd 19:0:0:0: [sdd] No Caching mode page present
[    3.065739] sd 19:0:0:0: [sdd] Assuming drive cache: write through
[    3.067998] sd 19:0:0:0: [sdd] No Caching mode page present
[    3.068689] sd 19:0:0:0: [sdd] Assuming drive cache: write through
[    3.516467]  sdd: sdd1 sdd2 sdd3
[    3.518924] sd 19:0:0:0: [sdd] No Caching mode page present
[    3.519701] sd 19:0:0:0: [sdd] Assuming drive cache: write through
[    3.520443] sd 19:0:0:0: [sdd] Attached SCSI disk
[    3.573600] ses 19:0:0:1: Attached Enclosure device
[    6.851172] ata7.00: qc timeout (cmd 0xa0)
[    6.857706] ata7.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[    6.858597] ata7.00: irq_stat 0x40000001
[    6.859065] sr 6:0:0:0: CDB: 
[    6.859066] cdb[0]=0x0: 00 00 00 00 00 00
[    6.859070] ata7.00: cmd a0/00:00:00:00:00/00:00:00:00:00/a0 tag 0
         res 51/24:03:00:00:00/00:00:00:00:00/a0 Emask 0x5 (timeout)
[    6.860663] ata7.00: status: { DRDY ERR }
[    6.861219] ata7: hard resetting link
[    7.187570] ata7: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[    7.194415] ata7.00: configured for UDMA/100
[    7.210901] ata7: EH complete
[   12.218666] ata7.00: qc timeout (cmd 0xa0)
[   12.225298] ata7.00: exception Emask 0x0 SAct 0x0 SErr 0x0 action 0x6 frozen
[   12.226194] ata7.00: irq_stat 0x40000001
[   12.226661] sr 6:0:0:0: CDB: 
[   12.226662] cdb[0]=0x0: 00 00 00 00 00 00
[   12.226666] ata7.00: cmd a0/00:00:00:00:00/00:00:00:00:00/a0 tag 0
         res 51/24:03:00:00:00/00:00:00:00:00/a0 Emask 0x5 (timeout)
[   12.228258] ata7.00: status: { DRDY ERR }
[   12.228807] ata7: hard resetting link
[   12.555156] ata7: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[   17.552957] ata7.00: qc timeout (cmd 0xa1)
[   17.559613] ata7.00: failed to IDENTIFY (I/O error, err_mask=0x4)
[   17.559617] ata7.00: revalidation failed (errno=-5)
[   17.560225] ata7: hard resetting link
[   17.886106] ata7: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[   27.881614] ata7.00: qc timeout (cmd 0xa1)
[   27.888278] ata7.00: failed to IDENTIFY (I/O error, err_mask=0x4)
[   27.888282] ata7.00: revalidation failed (errno=-5)
[   27.888914] ata7: limiting SATA link speed to 1.5 Gbps
[   27.888916] ata7: hard resetting link
[   28.214811] ata7: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[   58.201355] ata7.00: qc timeout (cmd 0xa1)
[   58.208019] ata7.00: failed to IDENTIFY (I/O error, err_mask=0x4)
[   58.208023] ata7.00: revalidation failed (errno=-5)
[   58.208654] ata7.00: disabled
[   58.214671] ata7: hard resetting link
[   58.534552] ata7: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[   58.541205] ata7: EH complete

Last edited by breed808 (2013-01-16 10:10:03)

Offline

#2 2013-01-09 00:37:17

falconindy
Developer
From: New York, USA
Registered: 2009-10-22
Posts: 4,092
Website

Re: [Solved] mkinitcpio 0.12 causing massive boot delays

Has little to do with mkinitcpio. You probably need to blacklist the pata_acpi module.

Offline

#3 2013-01-09 00:54:48

breed808
Member
From: Australia
Registered: 2012-10-27
Posts: 15

Re: [Solved] mkinitcpio 0.12 causing massive boot delays

Fair enough. Where should I be blacklisting this module?

Offline

#4 2013-01-09 00:57:47

WonderWoofy
Member
From: Los Gatos, CA
Registered: 2012-05-19
Posts: 8,412

Re: [Solved] mkinitcpio 0.12 causing massive boot delays

I don't have this problem, but I have read elsewhere that you can blacklist the necessary pata_acpi module.  This can be done in the usual way of creating the necessary /etc/modprobe.d conf file, and then ensuring that the modconf hook is included.  Alternatively, you can specify the created conf file in the FILES section of mkinitcpio.conf.


Edit: my add got the best of me and was snaked by flaconindy.  (also corrected some stuffs)

Last edited by WonderWoofy (2013-01-09 01:03:37)

Offline

#5 2013-01-09 00:58:13

falconindy
Developer
From: New York, USA
Registered: 2009-10-22
Posts: 4,092
Website

Re: [Solved] mkinitcpio 0.12 causing massive boot delays

Where you always blacklist modules: /etc/modprobe.d, with some file ending in ".conf". Make sure your mkinitcpio.conf has the modconf hook and rebuild your images.

Offline

#6 2013-01-09 01:08:43

breed808
Member
From: Australia
Registered: 2012-10-27
Posts: 15

Re: [Solved] mkinitcpio 0.12 causing massive boot delays

Ok, I'll try this. Thanks guys.

EDIT: It appears to have worked! Thanks again.

Last edited by breed808 (2013-01-09 01:14:39)

Offline

#7 2013-01-09 08:34:55

breed808
Member
From: Australia
Registered: 2012-10-27
Posts: 15

Re: [Solved] mkinitcpio 0.12 causing massive boot delays

Sorry guys, apparently the blacklisted module wasn't the cause. Interestingly, this activity isn't occurring every time I reboot (which explains the "It appears to have worked!" from my previous post). Are there any other modules that I should be blacklisting?

[    6.795752] ata5.00: cmd a0/00:00:00:00:00/00:00:00:00:00/a0 tag 0
         res 51/24:03:00:00:00/00:00:00:00:00/a0 Emask 0x5 (timeout)
[    6.797344] ata5.00: status: { DRDY ERR }
[    6.797894] ata5: hard resetting link
[    7.124253] ata5: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[   12.122004] ata5.00: qc timeout (cmd 0xa1)
[   12.128662] ata5.00: failed to IDENTIFY (I/O error, err_mask=0x4)
[   12.128666] ata5.00: revalidation failed (errno=-5)
[   12.129290] ata5: hard resetting link
[   12.455185] ata5: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
[   22.450708] ata5.00: qc timeout (cmd 0xa1)
[   22.457355] ata5.00: failed to IDENTIFY (I/O error, err_mask=0x4)
[   22.457360] ata5.00: revalidation failed (errno=-5)
[   22.457992] ata5: limiting SATA link speed to 1.5 Gbps
[   22.457994] ata5: hard resetting link
[   22.783901] ata5: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[   34.290790] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null)
[   52.770489] ata5.00: qc timeout (cmd 0xa1)
[   52.777099] ata5.00: failed to IDENTIFY (I/O error, err_mask=0x4)
[   52.777104] ata5.00: revalidation failed (errno=-5)
[   52.777736] ata5.00: disabled
[   52.783776] ata5: hard resetting link
[   53.103632] ata5: SATA link up 1.5 Gbps (SStatus 113 SControl 310)
[   53.110302] ata5: EH complete

Offline

#8 2013-01-09 11:17:57

falconindy
Developer
From: New York, USA
Registered: 2009-10-22
Posts: 4,092
Website

Re: [Solved] mkinitcpio 0.12 causing massive boot delays

If blacklisting pata_acpi doesn't work, I suggest you remove it from the blacklist.

Generate an image with mkinitcpio 0.11.x and compare the modules to one made by 0.12.x. lsinitcpio is your friend.

Offline

#9 2013-01-09 11:25:46

breed808
Member
From: Australia
Registered: 2012-10-27
Posts: 15

Re: [Solved] mkinitcpio 0.12 causing massive boot delays

Ah, I should have thought of that earlier. Thank you for the help, falconindy.

Edit: The module that needed blacklisting was sr_mod (NOT sd_mod), thanks again for the help.

Last edited by breed808 (2013-01-16 10:09:48)

Offline

Board footer

Powered by FluxBB