2:30 pause on boot FreeBSD 10.1

Sat Mar 7 16:38:54 UTC 2015

Hello,

I have strange behaviour on boot on a new server. Supremicro 6028R-WTR. Dual Xeon CPU  256G Ram. 8 x 4TB RAID 5. I have no errors but after it loads the BIOS, the FreeBSD splash screen, and the start of the kernel it pauses for about 2 minutes and 30 seconds indicating "Booting…” Then it loads displaying all the components. This happens with the  install USB stick and the the final install. There are no errors in demsg. In the attached list only 7 HDs are connected. The pause occurs with or without the LSI megaraid configuration.

# dmesg
Copyright (c) 1992-2014 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
	The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 10.1-RELEASE-p6 #0: Tue Feb 24 19:00:21 UTC 2015
    root at amd64-builder.daemonology.net:/usr/obj/usr/src/sys/GENERIC amd64
FreeBSD clang version 3.4.1 (tags/RELEASE_34/dot1-final 208032) 20140512
CPU: Intel(R) Xeon(R) CPU E5-2620 v3 @ 2.40GHz (2400.05-MHz K8-class CPU)
  Origin = "GenuineIntel"  Id = 0x306f2  Family = 0x6  Model = 0x3f  Stepping = 2
  Features=0xbfebfbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE>
  Features2=0x7dfefbff<SSE3,PCLMULQDQ,DTES64,MON,DS_CPL,VMX,SMX,EST,TM2,SSSE3,<b11>,FMA,CX16,xTPR,PDCM,PCID,DCA,SSE4.1,SSE4.2,x2APIC,MOVBE,POPCNT,TSCDLT,XSAVE,OSXSAVE,AVX,F16C,RDRAND>
  AMD Features=0x2c100800<SYSCALL,NX,Page1GB,RDTSCP,LM>
  AMD Features2=0x21<LAHF,ABM>
  Structured Extended Features=0x37ab<FSGSBASE,TSCADJ,BMI1,AVX2,SMEP,BMI2,ERMS,INVPCID>
  VT-x: PAT,HLT,MTF,PAUSE,EPT,UG,VPID,VID,PostIntr
  TSC: P-state invariant, performance statistics
real memory  = 274877906944 (262144 MB)
avail memory = 267083399168 (254710 MB)
Event timer "LAPIC" quality 600
ACPI APIC Table: < >
FreeBSD/SMP: Multiprocessor System Detected: 24 CPUs
FreeBSD/SMP: 2 package(s) x 6 core(s) x 2 SMT threads
 cpu0 (BSP): APIC ID:  0
 cpu1 (AP): APIC ID:  1
 cpu2 (AP): APIC ID:  2
 cpu3 (AP): APIC ID:  3
 cpu4 (AP): APIC ID:  4
 cpu5 (AP): APIC ID:  5
 cpu6 (AP): APIC ID:  6
 cpu7 (AP): APIC ID:  7
 cpu8 (AP): APIC ID:  8
 cpu9 (AP): APIC ID:  9
 cpu10 (AP): APIC ID: 10
 cpu11 (AP): APIC ID: 11
 cpu12 (AP): APIC ID: 16
 cpu13 (AP): APIC ID: 17
 cpu14 (AP): APIC ID: 18
 cpu15 (AP): APIC ID: 19
 cpu16 (AP): APIC ID: 20
 cpu17 (AP): APIC ID: 21
 cpu18 (AP): APIC ID: 22
 cpu19 (AP): APIC ID: 23
 cpu20 (AP): APIC ID: 24
 cpu21 (AP): APIC ID: 25
 cpu22 (AP): APIC ID: 26
 cpu23 (AP): APIC ID: 27
ioapic0 <Version 2.0> irqs 0-23 on motherboard
ioapic1 <Version 2.0> irqs 24-47 on motherboard
ioapic2 <Version 2.0> irqs 48-71 on motherboard
kbd1 at kbdmux0
random: <Software, Yarrow> initialized
module_register_init: MOD_LOAD (vesa, 0xffffffff80d942d0, 0) error 19
acpi0: <> on motherboard
acpi0: Power Button (fixed)
cpu0: <ACPI CPU> on acpi0
cpu1: <ACPI CPU> on acpi0
cpu2: <ACPI CPU> on acpi0
cpu3: <ACPI CPU> on acpi0
cpu4: <ACPI CPU> on acpi0
cpu5: <ACPI CPU> on acpi0
cpu6: <ACPI CPU> on acpi0
cpu7: <ACPI CPU> on acpi0
cpu8: <ACPI CPU> on acpi0
cpu9: <ACPI CPU> on acpi0
cpu10: <ACPI CPU> on acpi0
cpu11: <ACPI CPU> on acpi0
cpu12: <ACPI CPU> on acpi0
cpu13: <ACPI CPU> on acpi0
cpu14: <ACPI CPU> on acpi0
cpu15: <ACPI CPU> on acpi0
cpu16: <ACPI CPU> on acpi0
cpu17: <ACPI CPU> on acpi0
cpu18: <ACPI CPU> on acpi0
cpu19: <ACPI CPU> on acpi0
cpu20: <ACPI CPU> on acpi0
cpu21: <ACPI CPU> on acpi0
cpu22: <ACPI CPU> on acpi0
cpu23: <ACPI CPU> on acpi0
atrtc0: <AT realtime clock> port 0x70-0x71,0x74-0x77 irq 8 on acpi0
Event timer "RTC" frequency 32768 Hz quality 0
attimer0: <AT timer> port 0x40-0x43,0x50-0x53 irq 0 on acpi0
Timecounter "i8254" frequency 1193182 Hz quality 0
Event timer "i8254" frequency 1193182 Hz quality 100
hpet0: <High Precision Event Timer> iomem 0xfed00000-0xfed003ff on acpi0
Timecounter "HPET" frequency 14318180 Hz quality 950
Event timer "HPET" frequency 14318180 Hz quality 350
Event timer "HPET1" frequency 14318180 Hz quality 340
Event timer "HPET2" frequency 14318180 Hz quality 340
Event timer "HPET3" frequency 14318180 Hz quality 340
Event timer "HPET4" frequency 14318180 Hz quality 340
Event timer "HPET5" frequency 14318180 Hz quality 340
Event timer "HPET6" frequency 14318180 Hz quality 340
Event timer "HPET7" frequency 14318180 Hz quality 340
Timecounter "ACPI-fast" frequency 3579545 Hz quality 900
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x408-0x40b on acpi0
pcib0: <ACPI Host-PCI bridge> on acpi0
pci255: <ACPI PCI bus> on pcib0
pcib1: <ACPI Host-PCI bridge> on acpi0
pci127: <ACPI PCI bus> on pcib1
pcib2: <ACPI Host-PCI bridge> port 0xcf8-0xcff on acpi0
pci0: <ACPI PCI bus> on pcib2
pcib3: <ACPI PCI-PCI bridge> irq 26 at device 1.0 on pci0
pci1: <ACPI PCI bus> on pcib3
igb0: <Intel(R) PRO/1000 Network Connection version - 2.4.0> port 0x6020-0x603f mem 0xc7220000-0xc723ffff,0xc7244000-0xc7247fff irq 26 at device 0.0 on pci1
igb0: Using MSIX interrupts with 9 vectors
igb0: Ethernet address: 0c:c4:7a:31:db:1c
igb0: Bound queue 0 to cpu 0
igb0: Bound queue 1 to cpu 1
igb0: Bound queue 2 to cpu 2
igb0: Bound queue 3 to cpu 3
igb0: Bound queue 4 to cpu 4
igb0: Bound queue 5 to cpu 5
igb0: Bound queue 6 to cpu 6
igb0: Bound queue 7 to cpu 7
igb1: <Intel(R) PRO/1000 Network Connection version - 2.4.0> port 0x6000-0x601f mem 0xc7200000-0xc721ffff,0xc7240000-0xc7243fff irq 28 at device 0.1 on pci1
igb1: Using MSIX interrupts with 9 vectors
igb1: Ethernet address: 0c:c4:7a:31:db:1d
igb1: Bound queue 0 to cpu 8
igb1: Bound queue 1 to cpu 9
igb1: Bound queue 2 to cpu 10
igb1: Bound queue 3 to cpu 11
igb1: Bound queue 4 to cpu 12
igb1: Bound queue 5 to cpu 13
igb1: Bound queue 6 to cpu 14
igb1: Bound queue 7 to cpu 15
pcib4: <ACPI PCI-PCI bridge> irq 32 at device 2.0 on pci0
pci2: <ACPI PCI bus> on pcib4
pcib5: <ACPI PCI-PCI bridge> irq 32 at device 2.2 on pci0
pci3: <ACPI PCI bus> on pcib5
mfi0: <LSI MegaSAS Gen2> port 0x5000-0x50ff mem 0xc7160000-0xc7163fff,0xc7100000-0xc713ffff irq 34 at device 0.0 on pci3
mfi0: Using MSI
mfi0: Megaraid SAS driver Ver 4.23 
mfi0: FW MaxCmds = 1008, limiting to 128
pcib6: <ACPI PCI-PCI bridge> irq 40 at device 3.0 on pci0
pci4: <ACPI PCI bus> on pcib6
pci0: <unknown> at device 17.0 (no driver attached)
xhci0: <XHCI (generic) USB 3.0 controller> mem 0xc7300000-0xc730ffff irq 19 at device 20.0 on pci0
xhci0: 32 byte context size.
usbus0 on xhci0
pci0: <simple comms> at device 22.0 (no driver attached)
pci0: <simple comms> at device 22.1 (no driver attached)
ehci0: <EHCI (generic) USB 2.0 controller> mem 0xc7333000-0xc73333ff irq 18 at device 26.0 on pci0
usbus1: EHCI version 1.0
usbus1 on ehci0
pcib7: <ACPI PCI-PCI bridge> irq 16 at device 28.0 on pci0
pci5: <ACPI PCI bus> on pcib7
pcib8: <ACPI PCI-PCI bridge> irq 16 at device 28.4 on pci0
pci6: <ACPI PCI bus> on pcib8
pcib9: <ACPI PCI-PCI bridge> at device 0.0 on pci6
pci7: <ACPI PCI bus> on pcib9
vgapci0: <VGA-compatible display> port 0x4000-0x407f mem 0xc6000000-0xc6ffffff,0xc7000000-0xc701ffff irq 16 at device 0.0 on pci7
vgapci0: Boot video device
ehci1: <EHCI (generic) USB 2.0 controller> mem 0xc7332000-0xc73323ff irq 18 at device 29.0 on pci0
usbus2: EHCI version 1.0
usbus2 on ehci1
isab0: <PCI-ISA bridge> at device 31.0 on pci0
isa0: <ISA bus> on isab0
pcib10: <ACPI Host-PCI bridge> on acpi0
pci128: <ACPI PCI bus> on pcib10
acpi_button0: <Power Button> on acpi0
uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0
uart1: <16550 or compatible> port 0x2f8-0x2ff irq 3 on acpi0
orm0: <ISA Option ROMs> at iomem 0xc0000-0xc7fff,0xc8000-0xce7ff,0xce800-0xcf7ff on isa0
sc0: <System console> at flags 0x100 on isa0
sc0: CGA <16 virtual consoles, flags=0x300>
vga0: <Generic ISA VGA> at port 0x3d0-0x3db iomem 0xb8000-0xbffff on isa0
ppc0: cannot reserve I/O port range
est0: <Enhanced SpeedStep Frequency Control> on cpu0
p4tcc0: <CPU Frequency Thermal Control> on cpu0
est1: <Enhanced SpeedStep Frequency Control> on cpu1
p4tcc1: <CPU Frequency Thermal Control> on cpu1
est2: <Enhanced SpeedStep Frequency Control> on cpu2
p4tcc2: <CPU Frequency Thermal Control> on cpu2
est3: <Enhanced SpeedStep Frequency Control> on cpu3
p4tcc3: <CPU Frequency Thermal Control> on cpu3
est4: <Enhanced SpeedStep Frequency Control> on cpu4
p4tcc4: <CPU Frequency Thermal Control> on cpu4
est5: <Enhanced SpeedStep Frequency Control> on cpu5
p4tcc5: <CPU Frequency Thermal Control> on cpu5
est6: <Enhanced SpeedStep Frequency Control> on cpu6
p4tcc6: <CPU Frequency Thermal Control> on cpu6
est7: <Enhanced SpeedStep Frequency Control> on cpu7
p4tcc7: <CPU Frequency Thermal Control> on cpu7
est8: <Enhanced SpeedStep Frequency Control> on cpu8
p4tcc8: <CPU Frequency Thermal Control> on cpu8
est9: <Enhanced SpeedStep Frequency Control> on cpu9
p4tcc9: <CPU Frequency Thermal Control> on cpu9
est10: <Enhanced SpeedStep Frequency Control> on cpu10
p4tcc10: <CPU Frequency Thermal Control> on cpu10
est11: <Enhanced SpeedStep Frequency Control> on cpu11
p4tcc11: <CPU Frequency Thermal Control> on cpu11
est12: <Enhanced SpeedStep Frequency Control> on cpu12
p4tcc12: <CPU Frequency Thermal Control> on cpu12
est13: <Enhanced SpeedStep Frequency Control> on cpu13
p4tcc13: <CPU Frequency Thermal Control> on cpu13
est14: <Enhanced SpeedStep Frequency Control> on cpu14
p4tcc14: <CPU Frequency Thermal Control> on cpu14
est15: <Enhanced SpeedStep Frequency Control> on cpu15
p4tcc15: <CPU Frequency Thermal Control> on cpu15
est16: <Enhanced SpeedStep Frequency Control> on cpu16
p4tcc16: <CPU Frequency Thermal Control> on cpu16
est17: <Enhanced SpeedStep Frequency Control> on cpu17
p4tcc17: <CPU Frequency Thermal Control> on cpu17
est18: <Enhanced SpeedStep Frequency Control> on cpu18
p4tcc18: <CPU Frequency Thermal Control> on cpu18
est19: <Enhanced SpeedStep Frequency Control> on cpu19
p4tcc19: <CPU Frequency Thermal Control> on cpu19
est20: <Enhanced SpeedStep Frequency Control> on cpu20
p4tcc20: <CPU Frequency Thermal Control> on cpu20
est21: <Enhanced SpeedStep Frequency Control> on cpu21
p4tcc21: <CPU Frequency Thermal Control> on cpu21
est22: <Enhanced SpeedStep Frequency Control> on cpu22
p4tcc22: <CPU Frequency Thermal Control> on cpu22
est23: <Enhanced SpeedStep Frequency Control> on cpu23
p4tcc23: <CPU Frequency Thermal Control> on cpu23
mfi0: 1233 (478987183s/0x0020/info) - Shutdown command received from host
mfi0: 1234 (boot + 3s/0x0020/info) - Firmware initialization started (PCI ID 0079/1000/9261/1000)
mfi0: 1235 (boot + 3s/0x0020/info) - Firmware version 2.130.383-2315
mfi0: 1236 (boot + 5s/0x0008/info) - Battery Present
mfi0: 1237 (boot + 5s/0x0008/info) - Battery Present
mfi0: 1238 (boot + 5s/0x0020/info) - Package version 12.13.0-0154
mfi0: 1239 (boot + 5s/0x0020/info) - Board Revision 85C
mfi0: 1240 (boot + 24s/0x0002/info) - Inserted: PD 08(e0xff/s2)
mfi0: 1241 (boot + 24s/0x0002/info) - Inserted: PD 08(e0xff/s2) Info: enclPd=ffff, scsiType=0, portMap=02, sasAddr=4433221101000000,0000000000000000
mfi0: 1242 (boot + 24s/0x0002/info) - Inserted: PD 09(e0xff/s4)
mfi0: 1243 (boot + 24s/0x0002/info) - Inserted: PD 09(e0xff/s4) Info: enclPd=ffff, scsiType=0, portMap=04, sasAddr=4433221104000000,0000000000000000
mfi0: 1244 (boot + 24s/0x0002/info) - Inserted: PD 0a(e0xff/s0)
mfi0: 1245 (boot + 24s/0x0002/info) - Inserted: PD 0a(e0xff/s0) Info: enclPd=ffff, scsiType=0, portMap=01, sasAddr=4433221103000000,0000000000000000
mfi0: 1246 (boot + 24s/0x0002/info) - Inserted: PD 0b(e0xff/s1)
mfi0: 1247 (boot + 24s/0x0002/info) - Inserted: PD 0b(e0xff/s1) Info: enclPd=ffff, scsiType=0, portMap=03, sasAddr=4433221102000000,0000000000000000
mfi0: 1248 (boot + 24s/0x0002/info) - Inserted: PD 0c(e0xff/s5)
mfi0: 1249 (boot + 24s/0x0002/info) - Inserted: PD 0c(e0xff/s5) Info: enclPd=ffff, scsiType=0, portMap=05, sasAddr=4433221105000000,0000000000000000
mfi0: 1250 (boot + 24s/0x0002/info) - Inserted: PD 0d(e0xff/s6)
mfi0: 1251 (boot + 24s/0x0002/info) - Inserted: PD 0d(e0xff/s6) Info: enclPd=ffff, scsiType=0, portMap=06, sasAddr=4433221106000000,0000000000000000
mfi0: 1252 (boot + 24s/0x0002/info) - Inserted: PD 0f(e0xff/s3)
mfi0: 1253 (boot + 24s/0x0002/info) - Inserted: PD 0f(e0xff/s3) Info: enclPd=ffff, scsiType=0, portMap=00, sasAddr=4433221100000000,0000000000000000
mfi0: 1254 (boot + 24s/0x0020/WARN) - Controller booted in headless mode with errors
mfi0: 1255 (boot + 24s/0x0001/info) - Background Initialization started on VD 00/0
mfi0: 1257 (479035712s/0x0020/info) - Time established as 03/07/15  9:28:32; (42 seconds since power on)
mfi0: 1258 (479035713s/0x0020/WARN) - Patrol Read can't be started, as PDs are either not ONLINE, or are in a VD with an active process, or are in an excluded VD
mfi0: 1259 (479035731s/0x0008/info) - Battery temperature is normal
mfi0: 1261 (479035796s/0x0008/info) - Battery started charging
mfi0: 1263 (479035861s/0x0008/info) - Battery charge complete
mfi0: 1265 (479035942s/0x0020/info) - Host driver is loaded and operational
random: unblocking device.
usbus0: 5.0Gbps Super Speed USB v3.0
Timecounters tick every 1.000 msec
usbus1: 480Mbps High Speed USB v2.0
usbus2: 480Mbps High Speed USB v2.0
mfid0 on mfi0
mfid0: 19074560MB (39064698880 sectors) RAID volume (no label) is optimal
ugen1.1: <Intel> at usbus1
uhub0: <Intel EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus1
ugen0.1: <0x8086> at usbus0
uhub1: <0x8086 XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0
ugen2.1: <Intel> at usbus2
uhub2: <Intel EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus2
SMP: AP CPU #1 Launched!
SMP: AP CPU #7 Launched!
SMP: AP CPU #13 Launched!
SMP: AP CPU #6 Launched!
SMP: AP CPU #18 Launched!
SMP: AP CPU #8 Launched!
SMP: AP CPU #14 Launched!
SMP: AP CPU #9 Launched!
SMP: AP CPU #23 Launched!
SMP: AP CPU #2 Launched!
SMP: AP CPU #12 Launched!
SMP: AP CPU #3 Launched!
SMP: AP CPU #20 Launched!
SMP: AP CPU #10 Launched!
SMP: AP CPU #17 Launched!
SMP: AP CPU #4 Launched!
SMP: AP CPU #19 Launched!
SMP: AP CPU #11 Launched!
SMP: AP CPU #16 Launched!
SMP: AP CPU #5 Launched!
SMP: AP CPU #22 Launched!
SMP: AP CPU #21 Launched!
SMP: AP CPU #15 Launched!
Timecounter "TSC-low" frequency 1200023222 Hz quality 1000
Root mount waiting for: usbus2 usbus1 usbus0
uhub0: 2 ports with 2 removable, self powered
uhub2: 2 ports with 2 removable, self powered
uhub1: 21 ports with 21 removable, self powered
Root mount waiting for: usbus2 usbus1 usbus0
ugen0.2: <Logitech> at usbus0
ukbd0: <Logitech Logitech USB Keyboard, class 0/0, rev 1.10/28.00, addr 1> on usbus0
kbd0 at ukbd0
ugen1.2: <vendor 0x8087> at usbus1
uhub3: <vendor 0x8087 product 0x800a, class 9/0, rev 2.00/0.05, addr 2> on usbus1
ugen2.2: <vendor 0x8087> at usbus2
uhub4: <vendor 0x8087 product 0x8002, class 9/0, rev 2.00/0.05, addr 2> on usbus2
uhub3: 6 ports with 6 removable, self powered
Root mount waiting for: usbus2 usbus0
uhub4: 8 ports with 8 removable, self powered
ugen0.3: <Microsoft> at usbus0
ugen0.4: <vendor 0x0000> at usbus0
uhub5: <vendor 0x0000 product 0x0001, class 9/0, rev 2.00/0.00, addr 3> on usbus0
Root mount waiting for: usbus0
uhub5: 4 ports with 3 removable, self powered
ugen0.5: <vendor 0x0557> at usbus0
ukbd1: <vendor 0x0557 product 0x2419, class 0/0, rev 1.10/1.00, addr 4> on usbus0
kbd2 at ukbd1
Trying to mount root from ufs:/dev/mfid0p2 [rw]...
ums0: <Microsoft Microsoft 3-Button Mouse with IntelliEyeTM, class 0/0, rev 1.10/3.00, addr 2> on usbus0
ums0: 3 buttons and [XYZ] coordinates ID=0
ums1: <vendor 0x0557 product 0x2419, class 0/0, rev 1.10/1.00, addr 4> on usbus0
ums1: 3 buttons and [Z] coordinates ID=0