Re: ESx 3.5 Crash new maschine, HW replaced still ...

sonicsw · ‎02-22-2008

Hello Guys,

here is one of my ESx Servers. I have a coublle of them but this one is not working.

He crashes in 5min or 4h. downbelow is the logfile.

Does u have an idea whats up with him? THX HW is not HCl but all my other once run and they r all the same...

I have maybe a guess. I have over that office just an x64 PC for admin. work. so i faked the VI Client to run on x64.

Now i have the Feeling when i close my Vi the ESX hangs up. I uninstalled the x64 Version again and took another x86 host and installed the VI.

All okey. Now my man over there said he cloed the Vi x86 and cloese the ESX was down again. Could that be leatet in the log file?

THX for the help im lost in here...

Yout Sonic

TSC: 0 cpu0:0)Init: 387: cpu 0: early measured tsc speed 2400085483 Hz

TSC: 19044 cpu0:0)Cpu: 321: id1.version 6fb

TSC: 30735 cpu0:0)Cpu: 380: APIC ID mask: 0xff000000

TSC: 36315 cpu0:0)Cpu: 806: initial APICID=0x0

TSC: 41967 cpu0:0)MicrocodeIntel: 375: Update signature b300000000, Platform ID 10000088408928.

TSC: 50850 cpu0:0)Cpu: 1002: 36 physical bits, 48 virtual bits

TSC: 56196 cpu0:0)Cpu: 1351: MTRR: cap=0xd08

TSC: 61389 cpu0:0)Cpu: 1365: MTRR: deftype=0xc00

TSC: 67797 cpu0:0)Cpu: 1217: MTRR 0: start=0x0 mask=0xf00000800 end=0x100000000 type=6

TSC: 77283 cpu0:0)Cpu: 1217: MTRR 1: start=0xe0000000 mask=0xfe0000800 end=0x100000000 type=0

TSC: 87318 cpu0:0)Cpu: 1217: MTRR 2: start=0xdff00000 mask=0xffff00800 end=0xe0000000 type=0

TSC: 96750 cpu0:0)Cpu: 1217: MTRR 3: start=0x100000000 mask=0xf00000800 end=0x200000000 type=6

TSC: 106785 cpu0:0)Cpu: 1217: MTRR 4: start=0x200000000 mask=0xfe0000800 end=0x220000000 type=6

TSC: 117387 cpu0:0)Cpu: 1263: start=0x0 type=0x606060606060606

TSC: 921204 cpu0:0)Cpu: 1263: start=0x80000 type=0x606060606060606

TSC: 1729881 cpu0:0)Cpu: 1263: start=0xa0000 type=0x0

TSC: 2536911 cpu0:0)Cpu: 1263: start=0xc0000 type=0x0

TSC: 3343914 cpu0:0)Cpu: 1263: start=0xc8000 type=0x0

TSC: 4150467 cpu0:0)Cpu: 1263: start=0xd0000 type=0x0

TSC: 4957227 cpu0:0)Cpu: 1263: start=0xd8000 type=0x0

TSC: 5764266 cpu0:0)Cpu: 1263: start=0xe0000 type=0x0

TSC: 6570567 cpu0:0)Cpu: 1263: start=0xe8000 type=0x0

TSC: 7377624 cpu0:0)Cpu: 1263: start=0xf0000 type=0x0

TSC: 8184501 cpu0:0)Cpu: 1263: start=0xf8000 type=0x0

TSC: 8990802 cpu0:0)Cpu: 148: type 2

TSC: 9001710 cpu0:0)Cpu: 149: numCores 4, numHT 1

TSC: 9007002 cpu0:0)Cpu: 151: L2 cache : size 4194304, assoc. 16

TSC: 9013311 cpu0:0)Cpu: 153: L3 cache : size -1, assoc. -1

TSC: 9145710 cpu0:0)VGA: 261: start b8000 end c0000

TSC: 9161739 cpu0:0)VGA: 267: 0x3211000

TSC: 9166770 cpu0:0)VGA: 310: 8 screens

TSC: 9171468 cpu0:0)VGA: 1042: 16 pixels high

TSC: 12742983 cpu0:0)Keyboard: 100: keyboard explicitly disabled

TSC: 28035576 cpu0:0)Starting vmkernel initialization...

TSC: 28288386 cpu0:0)Hardware: 1995: BSP Apic ID: 0

TSC: 29421675 cpu0:0)SMBIOS: 519: Can't find SMBIOS - Product Name

TSC: 29427588 cpu0:0)SMBIOS: 529: Can't find SMBIOS - Vendor Name

TSC: 29433078 cpu0:0)SMBIOS: 539: Can't find SMBIOS - Serial Number

TSC: 29439954 cpu0:0)SMBIOS: 472: Can't find SMBIOS System Enclosure Information : Asset Tag

TSC: 29446677 cpu0:0)MPS: 673: Scanning [00000000, 00000400) for MPS

TSC: 29456199 cpu0:0)MPS: 673: Scanning [0009fc00, 000a0000) for MPS

TSC: 29466549 cpu0:0)MPS: 673: Scanning [000f0000, 00100000) for MPS

TSC: 30287304 cpu0:0)MPS: 697: Found MPS at 0x322d980 len=0x1 spec=0x4 feature=[0x0 0x0]

TSC: 30300012 cpu0:0)MPS: 720: MPC at 0x3232990 len=0x160 spec=0x4 count=0x25 lapic=0xfee00000 INTEL S3000AH

TSC: 38855196 cpu0:0)ACPI: 1300: found RSDP @ 0x03250350, RSDT @ 0xdfefe038

TSC: 38865645 cpu0:0)ACPI: 1189: valid RSDT @ 0xdfefe038

TSC: 38920086 cpu0:0)ACPI: 1189: valid APIC @ 0xdfef5000

TSC: 38967399 cpu0:0)ACPI: 1189: valid MCFG @ 0xdfef3000

TSC: 38974464 cpu0:0)ACPI: 1350: MCFG address=0xf0000000 reserved=0x0

TSC: 38982897 cpu0:0)ACPI: 1189: valid FACP @ 0xdfefc000

TSC: 38989602 cpu0:0)ACPI: 1363: RTC Century Byte NVRAM offset: 0x0

TSC: 38995686 cpu0:0)ACPI: 1386: APICID: 00 enabled 1

TSC: 39000969 cpu0:0)ACPI: 1386: APICID: 02 enabled 1

TSC: 39006522 cpu0:0)ACPI: 1386: APICID: 01 enabled 1

TSC: 39011976 cpu0:0)ACPI: 1386: APICID: 03 enabled 1

TSC: 39017448 cpu0:0)ACPI: 1426: override source = 0 global intr = 2 polarity = 0 trigger = 0

TSC: 39025215 cpu0:0)ACPI: 1426: override source = 9 global intr = 9 polarity = 1 trigger = 3

TSC: 39037014 cpu0:0)ACPI: 1243: reg 0x3261000, version 0x170020, numEntries 24

TSC: 39045564 cpu0:0)ACPI: 1408: ioapic 5 (0xfec00000) has 24 pins

TSC: 39063240 cpu0:0)ACPI: 368: <INTEL > <S3000AH>

TSC: 39069432 cpu0:0)MPS: 113: <INTEL > <S3000AH >

TSC: 39075219 cpu0:0)Hardware: 198: SysType: 0

TSC: 39081411 cpu0:0)ACPI: 526: ACPI ID 1, APIC ID 0x00, flags=0x00000001

TSC: 39088071 cpu0:0)ACPI: 526: ACPI ID 2, APIC ID 0x02, flags=0x00000001

TSC: 39094668 cpu0:0)ACPI: 526: ACPI ID 3, APIC ID 0x01, flags=0x00000001

TSC: 39101490 cpu0:0)ACPI: 526: ACPI ID 4, APIC ID 0x03, flags=0x00000001

TSC: 39108348 cpu0:0)SMP: 681: Using ACPI for cpu information, numPCPUs = 4

TSC: 39120606 cpu0:0)MemMap: 1664: vmkmem[0] 78848 69632 916467

TSC: 39128184 cpu0:0)MemMap: 1664: vmkmem[1] 78848 916575 916721

TSC: 39135906 cpu0:0)MemMap: 1664: vmkmem[2] 78848 917215 917228

TSC: 39143592 cpu0:0)MemMap: 1664: vmkmem[3] 78848 917247 917247

TSC: 39150828 cpu0:0)MemMap: 1664: vmkmem[4] 78848 1048576 2228223

TSC: 39158829 cpu0:0)MemMap: 1664: vmkmem[5] 78848 0 0

TSC: 39164931 cpu0:0)MemMap: 1664: vmkmem[6] 78848 0 0

TSC: 39170907 cpu0:0)MemMap: 1664: vmkmem[7] 78848 0 0

TSC: 39176955 cpu0:0)MemMap: 1664: vmkmem[8] 78848 0 0

TSC: 39182949 cpu0:0)MemMap: 1664: vmkmem[9] 78848 0 0

TSC: 39188925 cpu0:0)MemMap: 1664: vmkmem[10] 78848 0 0

TSC: 39195333 cpu0:0)MemMap: 1664: vmkmem[11] 78848 0 0

TSC: 39201687 cpu0:0)MemMap: 1664: vmkmem[12] 78848 0 0

TSC: 39208050 cpu0:0)MemMap: 1664: vmkmem[13] 78848 0 0

TSC: 39214386 cpu0:0)MemMap: 1664: vmkmem[14] 78848 0 0

TSC: 39220677 cpu0:0)MemMap: 1664: vmkmem[15] 78848 0 0

TSC: 39226959 cpu0:0)MemMap: 1664: vmkmem[16] 78848 0 0

TSC: 39233232 cpu0:0)MemMap: 1664: vmkmem[17] 78848 0 0

TSC: 39239532 cpu0:0)MemMap: 1664: vmkmem[18] 78848 0 0

TSC: 39245796 cpu0:0)MemMap: 1664: vmkmem[19] 78848 0 0

TSC: 39252051 cpu0:0)MemMap: 1664: vmkmem[20] 78848 0 0

TSC: 39258351 cpu0:0)MemMap: 1664: vmkmem[21] 78848 0 0

TSC: 39264624 cpu0:0)MemMap: 1664: vmkmem[22] 78848 0 0

TSC: 39270906 cpu0:0)MemMap: 1664: vmkmem[23] 78848 0 0

TSC: 39277035 cpu0:0)MemMap: 1664: vmkmem[24] 78848 0 0

TSC: 39283308 cpu0:0)MemMap: 1664: vmkmem[25] 78848 0 0

TSC: 39289554 cpu0:0)MemMap: 1664: vmkmem[26] 78848 0 0

TSC: 39295809 cpu0:0)MemMap: 1664: vmkmem[27] 78848 0 0

TSC: 39302118 cpu0:0)MemMap: 1664: vmkmem[28] 78848 0 0

TSC: 39308382 cpu0:0)MemMap: 1664: vmkmem[29] 78848 0 0

TSC: 39314691 cpu0:0)MemMap: 1664: vmkmem[30] 78848 0 0

TSC: 39320829 cpu0:0)MemMap: 1664: vmkmem[31] 78848 0 0

TSC: 221972247 cpu0:0)Host: 2110: host is using IOAPIC with 21 irqs

TSC: 221981769 cpu0:0)Host: 2129: vector 0x31 for irq 0 on 00-00

TSC: 221988960 cpu0:0)Host: 2129: vector 0x39 for irq 1 on 00-01

TSC: 221995620 cpu0:0)Host: 2129: vector 0x22 for irq 2 on 00-02

TSC: 222002019 cpu0:0)Host: 2129: vector 0x41 for irq 3 on 00-03

TSC: 222008373 cpu0:0)Host: 2129: vector 0x49 for irq 4 on 00-04

TSC: 222014763 cpu0:0)Host: 2129: vector 0x51 for irq 5 on 00-05

TSC: 222021045 cpu0:0)Host: 2129: vector 0x59 for irq 6 on 00-06

TSC: 222027363 cpu0:0)Host: 2129: vector 0x61 for irq 7 on 00-07

TSC: 222033951 cpu0:0)Host: 2129: vector 0x69 for irq 8 on 00-08

TSC: 222040350 cpu0:0)Host: 2129: vector 0x71 for irq 12 on 00-12

TSC: 222047073 cpu0:0)Host: 2129: vector 0x79 for irq 13 on 00-13

TSC: 222053940 cpu0:0)Host: 2129: vector 0x81 for irq 14 on 00-14

TSC: 222060744 cpu0:0)Host: 2129: vector 0x89 for irq 15 on 00-15

TSC: 222067404 cpu0:0)Host: 2129: vector 0x91 for irq 16 on 00-16

TSC: 222074163 cpu0:0)Host: 2129: vector 0x99 for irq 17 on 00-17

TSC: 222080805 cpu0:0)Host: 2129: vector 0xa1 for irq 18 on 00-18

TSC: 222087573 cpu0:0)Host: 2129: vector 0xa9 for irq 19 on 00-19

TSC: 222094215 cpu0:0)Host: 2129: vector 0xb1 for irq 20 on 00-23

TSC: 293124051 cpu0:0)Host: 2366: cr3=10a55180 mpn=13400 newPT=0

TSC: 293193153 cpu0:0)MemRO: 126: endReadOnly=0x871381 data=0x872000 length=0xb8e000

TSC: 364296051 cpu0:0)Host: 2366: cr3=10a55180 mpn=11272 newPT=1

TSC: 364316481 cpu0:0)Init: 539: Done

TSC: 364331484 cpu0:0)Init: 592: Continuing init

TSC: 364337253 cpu0:0)Initializing memory ...

TSC: 368371278 cpu0:0)XMap: 365: Allocating 1180464 bytes for allocator

TSC: 368416899 cpu0:0)XMap: 391: Range reduced to

TSC: 510911334 cpu0:0)Uplink: 2157: Couldn't find UPLINK_TREE_DEFAULT. Creating ps UPLINK_TREE_DEFAULT

TSC: 510939981 cpu0:0)Initializing chipset ...

TSC: 511194600 cpu0:0)Hardware: 263: 24-bit ACPI PM timer at port 0x408

TSC: 511202061 cpu0:0)Hardware: 266: Using ACPI PM timer for frequency estimation

TSC: 511239258 cpu0:0)Chipset: 540: Using ACPI as the bios data source

TSC: 511246062 cpu0:0)Chipset: 249: vmnixIRQIOAPICInfo 0xe26000, len 256

TSC: 511286382 cpu0:0)APIC: 256: Using flat physical mode for destination

TSC: 511296516 cpu0:0)APIC: 540: enabling LINT1 as normal interrupt

TSC: 511547940 cpu0:0)IDT: 1336: 0xf9 <noop> exclusive, flags 0x0

TSC: 511556661 cpu0:0)IDT: 1336: 0xfc <thermal> exclusive, flags 0x0

TSC: 511563546 cpu0:0)IDT: 1336: 0xfd <lint1> exclusive, flags 0x0

TSC: 511570224 cpu0:0)IDT: 1336: 0xfe <error> exclusive, flags 0x0

TSC: 511577406 cpu0:0)IDT: 1336: 0xff <spurious> exclusive, flags 0x0

TSC: 511584291 cpu0:0)IDT: 1336: 0xe1 <monitor> exclusive, flags 0x0

TSC: 511591428 cpu0:0)APIC: 1550: using 0xdf for APIC timer

TSC: 511597170 cpu0:0)IDT: 1336: 0xdf <timer> exclusive, flags 0x0

TSC: 511623063 cpu0:0)IOAPIC: 534: found 0 (id 05 @ fec00000)

TSC: 511635960 cpu0:0)IOAPIC: 590: version 0x20, number of entries 24

TSC: 511977987 cpu0:0)IDT: 1336: 0xec <ucodeUpdate> exclusive, flags 0x0

TSC: 907270821 cpu0:0)Vmkperf: 2995: Number of perf counters = 2, Perf counter width = 40, Arch Event Bit Vector = 0, Perf counter Read Mask = 1099511627775

TSC: 907297947 cpu0:0)Initializing timing ...

TSC: 5707563804 cpu0:0)Init: 724: cpu 0: measured tsc speed 2400084654 Hz, cpu speed (using TSC) 2400084654 Hz, bus speed 266676113 Hz

TSC: 5707583406 cpu0:0)Timer: 995: reference timer is TSC at 2400084654 Hz

TSC: 5707591074 cpu0:0)Timer: 1018: early timerRCToTC mult=0x1, shift=0, add=0x0

0:00:00:00.000 cpu0:0)Initializing scheduler ...

0:00:00:00.000 cpu0:0)IDT: 1336: 0xe9 <resched> exclusive, flags 0x0

0:00:00:00.000 cpu0:0)CpuSched: 3448: defaultAffinity=0x000000000000000f

0:00:00:00.000 cpu0:0)CpuSched: 3462: node 0: mask=0x000000000000000f

0:00:00:00.001 cpu0:0)CpuSched: 10301: no specified cell size, trying default size 4 (4 cores)

0:00:00:00.001 cpu0:0)CpuSched: 10396: partitioning 4 pcpus into 1 cells

0:00:00:00.001 cpu0:0)CpuSched: 10445: cell 0: pcpuMask=0x000000000000000f (0,1,2,3)

0:00:00:00.002 cpu0:0)World: 776: cpuidFeatures = 0xbfebfbff

0:00:00:00.002 cpu0:0)World: 1816: Creating COS world

0:00:00:00.002 cpu0:0)World: vm 1024: 895: Starting world console with flags 21

0:00:00:00.002 cpu0:1024)Sched: vm 1024: 893: name='console'

0:00:00:00.002 cpu0:1024)SMP: 1051: Updating topology with PCPU=0, initial APICID=0x0, apic core bits=2, apic HT bits=0

0:00:00:00.002 cpu0:1024)SMP: 1571: Booting APs...

0:00:00:00.002 cpu0:1024)World: vm 1025: 895: Starting world idle1 with flags 3

0:00:00:00.002 cpu0:1024)SMP: 1598: kicking pcpu 1, apicID 0x01

0:00:00:00.012 cpu1:1025)Cpu: 391: id1.version 6fb

0:00:00:00.012 cpu1:1025)SMP: 1051: Updating topology with PCPU=1, initial APICID=0x1, apic core bits=2, apic HT bits=0

0:00:00:00.012 cpu1:1025)Cpu: 806: initial APICID=0x1

0:00:00:00.012 cpu1:1025)MicrocodeIntel: 375: Update signature b300000000, Platform ID 10000088408928.

0:00:00:00.012 cpu1:1025)Cpu: 1351: MTRR: cap=0xd08

0:00:00:00.013 cpu0:1024)World: vm 1026: 895: Starting world idle2 with flags 3

0:00:00:00.013 cpu0:1024)SMP: 1598: kicking pcpu 2, apicID 0x02

0:00:00:00.023 cpu2:1026)Cpu: 391: id1.version 6fb

0:00:00:00.023 cpu2:1026)SMP: 1051: Updating topology with PCPU=2, initial APICID=0x2, apic core bits=2, apic HT bits=0

0:00:00:00.023 cpu2:1026)Cpu: 806: initial APICID=0x2

0:00:00:00.023 cpu2:1026)MicrocodeIntel: 375: Update signature b300000000, Platform ID 10000088408928.

0:00:00:00.023 cpu2:1026)Cpu: 1351: MTRR: cap=0xd08

0:00:00:00.023 cpu0:1024)World: vm 1027: 895: Starting world idle3 with flags 3

0:00:00:00.024 cpu0:1024)SMP: 1598: kicking pcpu 3, apicID 0x03

0:00:00:00.034 cpu3:1027)Cpu: 391: id1.version 6fb

0:00:00:00.034 cpu3:1027)SMP: 1051: Updating topology with PCPU=3, initial APICID=0x3, apic core bits=2, apic HT bits=0

0:00:00:00.034 cpu3:1027)Cpu: 806: initial APICID=0x3

0:00:00:00.034 cpu3:1027)MicrocodeIntel: 375: Update signature b300000000, Platform ID 10000088408928.

0:00:00:00.034 cpu3:1027)Cpu: 1351: MTRR: cap=0xd08

0:00:00:00.034 cpu0:1024)SMP: 133: cpu 0: TSC reset 277633407942 -> 117

0:00:00:00.044 cpu1:1025)SMP: 133: cpu 1: TSC reset 277633408275 -> 117

0:00:00:00.054 cpu2:1026)SMP: 133: cpu 2: TSC reset 277633408212 -> 117

0:00:00:00.064 cpu3:1027)SMP: 133: cpu 3: TSC reset 277633407798 -> 117

0:00:00:02.164 cpu0:1024)SMP: 1714: ...finished booting APs, numPCPUs=4, running=4

0:00:00:02.164 cpu0:1024)Initializing device support ...

0:00:00:02.165 cpu0:1024)IDT: 1336: 0xf1 <tlb> exclusive, flags 0x0

0:00:00:02.165 cpu0:1024)Initializing processors ...

0:00:00:02.171 cpu0:1024)Net: 2221: Initializing Pkt allocator

0:00:00:02.171 cpu0:1024)Net: 1266: 40

0:00:00:02.171 cpu0:1024)Net: 1266: 1026

0:00:00:02.171 cpu0:1024)Net: 1266: 2946

0:00:00:02.171 cpu0:1024)Net: 1266: 10132

0:00:00:02.171 cpu0:1024)Net: 3146: Pkt checksum cycles/kB: C=896 asm=686

0:00:00:02.172 cpu0:1024)Uplink: 2157: Couldn't find pps. Creating ps pps

0:00:00:02.172 cpu0:1024)NetPortset: 808: activating portset #0 as pps with 128 ports, index mask is 0x7f

0:00:00:02.173 cpu0:1024)World: vm 1028: 895: Starting world AsyncTimeout with flags 1

0:00:00:02.176 cpu0:1024)World: vm 1029: 895: Starting world DeviceTaskmgmtWatchdog with flags 1

0:00:00:02.177 cpu0:1024)World: vm 1030: 895: Starting world PathTaskmgmtWatchdog with flags 1

0:00:00:02.177 cpu1:1025)Sched: vm 1025: 893: name='idle1'

0:00:00:02.177 cpu3:1027)Sched: vm 1027: 893: name='idle3'

0:00:00:02.177 cpu2:1026)Sched: vm 1026: 893: name='idle2'

0:00:00:02.177 cpu0:1024)Timer: 4002: node 0 (cpus 0-3): consensus bus speed 266676092 Hz

0:00:00:02.177 cpu0:1024)Timer: 4047: TSC speed=2400084828 Hz, cpu speed=2400084828 Hz, bus speed=266676092 Hz

0:00:00:02.177 cpu0:1024)Timer: 4075: timerRCToTC mult=0x1, shift=0, add=0x0

0:00:00:02.177 cpu0:1024)World: vm 1031: 895: Starting world idle0 with flags 3

0:00:00:02.776 cpu0:1024)FDS: 222: genide

0:00:00:02.776 cpu0:1024)FDS: 222: genscsi

0:00:00:02.776 cpu0:1024)FDS: 222: disks

0:00:00:02.777 cpu0:1024)World: vm 1032: 895: Starting world OCFlush with flags 1

0:00:00:02.777 cpu0:1024)FSS: 307: Registered fs vcfs, module 0, fsTypeNum 0x1

0:00:00:02.777 cpu0:1024)FSS: 307: Registered fs devfs, module 0, fsTypeNum 0xdef5

0:00:00:02.777 cpu0:1024)World: vm 1033: 895: Starting world BCFlush with flags 1

0:00:00:02.777 cpu0:1024)FDS: 222: char

0:00:00:02.777 cpu0:1024)VSCSI: 5470: 0

0:00:00:02.777 cpu0:1024)VSCSI: 5470: 1

0:00:00:02.777 cpu0:1024)VSCSI: 5470: 2

0:00:00:02.777 cpu0:1024)VSCSIFilter: 654: Successfully created directory for VSCSI-Filter character devices

0:00:00:02.778 cpu0:1024)World: vm 1034: 895: Starting world helper0-1 with flags 11

0:00:00:02.778 cpu0:1024)World: vm 1035: 895: Starting world helper1-2 with flags 11

0:00:00:02.779 cpu0:1024)World: vm 1036: 895: Starting world helper1-3 with flags 11

0:00:00:02.779 cpu0:1024)World: vm 1037: 895: Starting world helper1-4 with flags 11

0:00:00:02.779 cpu0:1024)World: vm 1038: 895: Starting world helper2-5 with flags 11

0:00:00:02.779 cpu0:1024)World: vm 1039: 895: Starting world helper3-6 with flags 11

0:00:00:02.779 cpu0:1024)World: vm 1040: 895: Starting world helper4-7 with flags 11

0:00:00:02.779 cpu0:1024)World: vm 1041: 895: Starting world helper5-8 with flags 11

0:00:00:02.779 cpu0:1024)World: vm 1042: 895: Starting world helper6-9 with flags 11

0:00:00:02.780 cpu0:1024)World: vm 1043: 895: Starting world helper7-10 with flags 11

0:00:00:02.780 cpu0:1024)World: vm 1044: 895: Starting world helper8-11 with flags 11

0:00:00:02.780 cpu0:1024)World: vm 1045: 895: Starting world helper8-12 with flags 11

0:00:00:02.780 cpu0:1024)World: vm 1046: 895: Starting world helper9-13 with flags 11

0:00:00:02.780 cpu0:1024)World: vm 1047: 895: Starting world helper9-14 with flags 11

0:00:00:02.780 cpu0:1024)World: vm 1048: 895: Starting world helper10-15 with flags 11

0:00:00:02.781 cpu0:1024)World: vm 1049: 895: Starting world helper11-16 with flags 11

0:00:00:02.781 cpu0:1024)World: vm 1050: 895: Starting world helper12-17 with flags 11

0:00:00:02.781 cpu0:1024)World: vm 1051: 895: Starting world helper13-18 with flags 11

0:00:00:02.781 cpu0:1024)World: vm 1052: 895: Starting world helper13-19 with flags 11

0:00:00:02.781 cpu0:1024)World: vm 1053: 895: Starting world helper13-20 with flags 11

0:00:00:02.781 cpu0:1024)World: vm 1054: 895: Starting world helper13-21 with flags 11

0:00:00:02.782 cpu0:1024)World: vm 1055: 895: Starting world helper14-22 with flags 11

0:00:00:02.782 cpu0:1024)World: vm 1056: 895: Starting world reset-handler with flags 1

0:00:00:02.782 cpu0:1024)World: vm 1057: 895: Starting world reset-watchdog with flags 1

0:00:00:02.782 cpu0:1024)Initializing interrupts ...

0:00:00:02.782 cpu0:1024)World: vm 1058: 895: Starting world memsched with flags 1

0:00:00:02.782 cpu0:1024)World: vm 1059: 895: Starting world pshare-est with flags 1

0:00:00:02.783 cpu0:1024)World: vm 1060: 895: Starting world lpage with flags 1

0:00:00:02.783 cpu0:1024)CpuSched: 16758: Reset scheduler statistics

0:00:00:02.784 cpu0:1024)TTY: 173: Allocated 0 out of 0 ttys

0:00:00:02.784 cpu0:1024)Enabling interrupts ...

0:00:00:02.784 cpu0:1024)Init: 899: checksum 0xd89a5a23733ef3c1, vmkernel build Number = 64607, vmnixmod build number = 64607

ACPI: RSDP @ 0x0xf0350/0x0024 (v 002 INTEL )

ACPI: XSDT @ 0x0xdfefe120/0x0074 (v 001 INTEL S3000AH 0x00000000 INTL 0x01000013)

ACPI: FACP @ 0x0xdfefb000/0x00f4 (v 003 INTEL S3000AH 0x00000000 MSFT 0x01000013)

ACPI: DSDT @ 0x0xdfef6000/0x4922 (v 001 INTEL S3000AH 0x00000000 MSFT 0x01000013)

ACPI: FACS @ 0x0xdfe89000/0x0040

ACPI: APIC @ 0x0xdfef5000/0x0078 (v 001 INTEL S3000AH 0x00000000 MSFT 0x01000013)

ACPI: WDDT @ 0x0xdfef4000/0x0040 (v 001 INTEL S3000AH 0x00000000 MSFT 0x01000013)

ACPI: MCFG @ 0x0xdfef3000/0x003c (v 001 INTEL S3000AH 0x00000000 MSFT 0x01000013)

ACPI: ASF! @ 0x0xdfef2000/0x009f (v 032 INTEL S3000AH 0x00000001 MSFT 0x01000013)

ACPI: SSDT @ 0x0xdfef1000/0x0175 (v 001 INTEL Cpu0Ist 0x00000010 MSFT 0x01000013)

ACPI: SSDT @ 0x0xdfef0000/0x0175 (v 001 INTEL Cpu1Ist 0x00000010 MSFT 0x01000013)

ACPI: SSDT @ 0x0xdfeef000/0x0175 (v 001 INTEL Cpu2Ist 0x00000010 MSFT 0x01000013)

ACPI: SSDT @ 0x0xdfeee000/0x0175 (v 001 INTEL Cpu3Ist 0x00000010 MSFT 0x01000013)

ACPI: SSDT @ 0x0xdfeed000/0x01bc (v 001 INTEL CpuPm 0x00000010 MSFT 0x01000013)

0:00:00:02.792 cpu0:1024)ACPI: 1663: Global interrupt 0x9

0:00:00:02.792 cpu0:1024)ACPI: 1683: Found override for interrupt 0x9: pin: 9, polarity: 2, trigger: 2

0:00:00:02.792 cpu0:1024)ACPI: 1706: Found ioapic 5, pin 9 for global interrupt 9

0:00:00:02.792 cpu0:1024)IntrVector: 279: 0x21

0:00:00:02.792 cpu0:1024)IOAPIC: 942: vector 0x21 to 00-09

0:00:00:02.792 cpu0:1024)IDT: 1336: 0x21 <ACPI Interrupt> sharable, flags 0x0

0:00:00:02.794 cpu0:1024)VMKAcpi: 99: Failed to execute method BBN: status AENOT_FOUND

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 16, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 17, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 18, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 19, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 17, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 16, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 18, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 19, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 23, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 19, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 18, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 16, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 22, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 20, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 18, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 0, ioapicid 5, intIn 19, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 99: Failed to execute method BBN: status AENOT_FOUND

0:00:00:02.795 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 30, func 0, pci bridge 1, secBus 6

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 6, ioapicid 5, intIn 17, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 6, ioapicid 5, intIn 18, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 6, ioapicid 5, intIn 22, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 6, ioapicid 5, intIn 21, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 6, ioapicid 5, intIn 20, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 6, ioapicid 5, intIn 23, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 6, ioapicid 5, intIn 21, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 6, ioapicid 5, intIn 22, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 6, ioapicid 5, intIn 23, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 620: busid 6, ioapicid 5, intIn 20, with trigger 2, polarity 1

0:00:00:02.795 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 31, func 0, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 1037: Ignoring disabled device.

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 28, func 0, pci bridge 1, secBus 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 1, ioapicid 5, intIn 16, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 1, ioapicid 5, intIn 17, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 1, ioapicid 5, intIn 18, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 1, ioapicid 5, intIn 19, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 28, func 4, pci bridge 1, secBus 2

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 2, ioapicid 5, intIn 16, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 2, ioapicid 5, intIn 17, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 2, ioapicid 5, intIn 18, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 2, ioapicid 5, intIn 19, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 28, func 5, pci bridge 1, secBus 5

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 5, ioapicid 5, intIn 17, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 5, ioapicid 5, intIn 18, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 5, ioapicid 5, intIn 19, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 620: busid 5, ioapicid 5, intIn 16, with trigger 2, polarity 1

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 29, func 0, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 29, func 1, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 29, func 2, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 29, func 3, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 29, func 7, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 31, func 1, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 5, pciId.bus 5, dev 0, func 0, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 0, func 0, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 31, func 2, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 5, pciId.bus 5, dev 0, func 0, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 919: bus 0, pciId.bus 0, dev 0, func 0, pci bridge 0, secBus 65535

0:00:00:02.796 cpu0:1024)VMKAcpi: 1095: 1 root bridges found, 4 pci-pci bridges found, 3 max depth

0:00:00:02.796 cpu0:1024)VMKAcpi: 1320: ISA irq 2 uses ioapicID 5, intIn 2 which is already present with trigger = 1, polarity = 2

0:00:00:02.796 cpu0:1024)VMKAcpi: 1165: Printing ACPI irq routing information

0:00:00:02.796 cpu0:1024)VMKAcpi: 1174: bus 0

0:00:00:02.796 cpu0:1024)VMKAcpi: 1140: pci bus 0:1, pin INTA, ioapicID 5, intIn = 16, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:1, pin INTB, ioapicID 5, intIn = 17, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:1, pin INTC, ioapicID 5, intIn = 18, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:1, pin INTD, ioapicID 5, intIn = 19, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:28, pin INTA, ioapicID 5, intIn = 17, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:28, pin INTB, ioapicID 5, intIn = 16, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:28, pin INTC, ioapicID 5, intIn = 18, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:28, pin INTD, ioapicID 5, intIn = 19, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:29, pin INTA, ioapicID 5, intIn = 23, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:29, pin INTB, ioapicID 5, intIn = 19, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:29, pin INTC, ioapicID 5, intIn = 18, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:29, pin INTD, ioapicID 5, intIn = 16, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:30, pin INTA, ioapicID 5, intIn = 22, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:30, pin INTB, ioapicID 5, intIn = 20, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:31, pin INTA, ioapicID 5, intIn = 18, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 0:31, pin INTB, ioapicID 5, intIn = 19, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1174: bus 1

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 1:0, pin INTA, ioapicID 5, intIn = 16, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 1:0, pin INTB, ioapicID 5, intIn = 17, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 1:0, pin INTC, ioapicID 5, intIn = 18, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 1:0, pin INTD, ioapicID 5, intIn = 19, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1174: bus 2

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 2:0, pin INTA, ioapicID 5, intIn = 16, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 2:0, pin INTB, ioapicID 5, intIn = 17, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 2:0, pin INTC, ioapicID 5, intIn = 18, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 2:0, pin INTD, ioapicID 5, intIn = 19, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1174: bus 5

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 5:0, pin INTA, ioapicID 5, intIn = 17, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 5:0, pin INTB, ioapicID 5, intIn = 18, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 5:0, pin INTC, ioapicID 5, intIn = 19, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 5:0, pin INTD, ioapicID 5, intIn = 16, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1174: bus 6

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 6:0, pin INTA, ioapicID 5, intIn = 21, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 6:0, pin INTB, ioapicID 5, intIn = 22, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 6:0, pin INTC, ioapicID 5, intIn = 23, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 6:0, pin INTD, ioapicID 5, intIn = 20, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 6:1, pin INTA, ioapicID 5, intIn = 22, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 6:1, pin INTB, ioapicID 5, intIn = 21, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 6:1, pin INTC, ioapicID 5, intIn = 20, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 6:1, pin INTD, ioapicID 5, intIn = 23, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 6:4, pin INTA, ioapicID 5, intIn = 18, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: pci bus 6:5, pin INTA, ioapicID 5, intIn = 17, trigger = levl, polarity = lo

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa* bus 0:0, pin INT , ioapicID 5, intIn = 2, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa bus 0:1, pin INT , ioapicID 5, intIn = 1, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa bus 0:3, pin INT , ioapicID 5, intIn = 3, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa bus 0:4, pin INT , ioapicID 5, intIn = 4, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa bus 0:5, pin INT , ioapicID 5, intIn = 5, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa bus 0:6, pin INT , ioapicID 5, intIn = 6, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa bus 0:7, pin INT , ioapicID 5, intIn = 7, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa bus 0:8, pin INT , ioapicID 5, intIn = 8, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa* bus 0:9, pin INT , ioapicID 5, intIn = 9, trigger = levl, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa bus 0:12, pin INT , ioapicID 5, intIn = 12, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa bus 0:13, pin INT , ioapicID 5, intIn = 13, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa bus 0:14, pin INT , ioapicID 5, intIn = 14, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 1140: isa bus 0:15, pin INT , ioapicID 5, intIn = 15, trigger = edge, polarity = hi

0:00:00:02.797 cpu0:1024)VMKAcpi: 2022: Installing fixed event power handler

0:00:00:02.798 cpu0:1024)Chipset: 469: ioapic 0, id 5 @ 0xfec00000

0:00:00:02.798 cpu0:1024)Chipset: 481: bus pci, id 0

0:00:00:02.798 cpu0:1024)Chipset: 491: 1:A (4) 00-16 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 1:B (5) 00-17 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 1:C (6) 00-18 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 1:D (7) 00-19 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 28:A (112) 00-17 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 28:B (113) 00-16 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 28:C (114) 00-18 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 28:D (115) 00-19 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 29:A (116) 00-23 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 29:B (117) 00-19 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 29:C (118) 00-18 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 29:D (119) 00-16 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 30:A (120) 00-22 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 30:B (121) 00-20 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 31:A (124) 00-18 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 31:B (125) 00-19 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 481: bus pci, id 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:A (0) 00-16 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:B (1) 00-17 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:C (2) 00-18 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:D (3) 00-19 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 481: bus pci, id 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:A (0) 00-16 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:B (1) 00-17 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:C (2) 00-18 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:D (3) 00-19 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 481: bus pci, id 5

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:A (0) 00-17 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:B (1) 00-18 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:C (2) 00-19 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:D (3) 00-16 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 481: bus pci, id 6

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:A (0) 00-21 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:B (1) 00-22 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:C (2) 00-23 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 0:D (3) 00-20 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 1:A (4) 00-22 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 1:B (5) 00-21 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 1:C (6) 00-20 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 1:D (7) 00-23 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 4:A (16) 00-18 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 491: 5:A (20) 00-17 trg 2 pol 1

0:00:00:02.798 cpu0:1024)Chipset: 481: bus isa, id 7

0:00:00:02.798 cpu0:1024)Chipset: 491: 0: (0) 00-02 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 1: (1) 00-01 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 3: (3) 00-03 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 4: (4) 00-04 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 5: (5) 00-05 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 6: (6) 00-06 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 7: (7) 00-07 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 8: (8) 00-08 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 9: (9) 00-09 trg 2 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 12: (12) 00-12 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 13: (13) 00-13 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 14: (14) 00-14 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 491: 15: (15) 00-15 trg 1 pol 2

0:00:00:02.798 cpu0:1024)Chipset: 598: Using ACPI for interrupt routing

0:00:00:02.798 cpu0:1024)ISA: 72: Setting up ISA devices interrupts

0:00:00:02.798 cpu0:1024)ISA: 110: irq 0 is emulated by vmkernel

0:00:00:02.798 cpu0:1024)ISA: 114: irq 1

0:00:00:02.798 cpu0:1024)Chipset: 699: 007:01 busIRQ= 1 on 00-01

0:00:00:02.798 cpu0:1024)IntrVector: 279: 0x29

0:00:00:02.798 cpu0:1024)IOAPIC: 942: vector 0x29 to 00-01

0:00:00:02.798 cpu0:1024)IDT: 1262: 0x29 irq 1 flags 0x3

0:00:00:02.798 cpu0:1024)Host: 2530: IRQ 1(1), vector 41

0:00:00:02.798 cpu0:1024)ISA: 110: irq 2 is emulated by vmkernel

0:00:00:02.798 cpu0:1024)ISA: 114: irq 3

0:00:00:02.798 cpu0:1024)Chipset: 699: 007:03 busIRQ= 3 on 00-03

0:00:00:02.798 cpu0:1024)IntrVector: 279: 0x31

0:00:00:02.798 cpu0:1024)IOAPIC: 942: vector 0x31 to 00-03

0:00:00:02.798 cpu0:1024)IDT: 1262: 0x31 irq 3 flags 0x3

0:00:00:02.798 cpu0:1024)Host: 2530: IRQ 3(1), vector 49

0:00:00:02.798 cpu0:1024)ISA: 114: irq 4

0:00:00:02.798 cpu0:1024)Chipset: 699: 007:04 busIRQ= 4 on 00-04

0:00:00:02.798 cpu0:1024)IntrVector: 279: 0x39

0:00:00:02.798 cpu0:1024)IOAPIC: 942: vector 0x39 to 00-04

0:00:00:02.798 cpu0:1024)IDT: 1262: 0x39 irq 4 flags 0x3

0:00:00:02.798 cpu0:1024)Host: 2530: IRQ 4(1), vector 57

0:00:00:02.798 cpu0:1024)ISA: 114: irq 5

0:00:00:02.798 cpu0:1024)Chipset: 699: 007:05 busIRQ= 5 on 00-05

0:00:00:02.798 cpu0:1024)IntrVector: 279: 0x41

0:00:00:02.798 cpu0:1024)IOAPIC: 942: vector 0x41 to 00-05

0:00:00:02.798 cpu0:1024)IDT: 1262: 0x41 irq 5 flags 0x3

0:00:00:02.798 cpu0:1024)Host: 2530: IRQ 5(1), vector 65

0:00:00:02.798 cpu0:1024)ISA: 114: irq 6

0:00:00:02.798 cpu0:1024)Chipset: 699: 007:06 busIRQ= 6 on 00-06

0:00:00:02.798 cpu0:1024)IntrVector: 279: 0x49

0:00:00:02.798 cpu0:1024)IOAPIC: 942: vector 0x49 to 00-06

0:00:00:02.798 cpu0:1024)IDT: 1262: 0x49 irq 6 flags 0x3

0:00:00:02.798 cpu0:1024)Host: 2530: IRQ 6(1), vector 73

0:00:00:02.798 cpu0:1024)ISA: 114: irq 7

0:00:00:02.798 cpu0:1024)Chipset: 699: 007:07 busIRQ= 7 on 00-07

0:00:00:02.798 cpu0:1024)IntrVector: 279: 0x51

0:00:00:02.798 cpu0:1024)IOAPIC: 942: vector 0x51 to 00-07

0:00:00:02.798 cpu0:1024)IDT: 1262: 0x51 irq 7 flags 0x3

0:00:00:02.798 cpu0:1024)Host: 2530: IRQ 7(1), vector 81

0:00:00:02.798 cpu0:1024)ISA: 114: irq 8

0:00:00:02.798 cpu0:1024)Chipset: 699: 007:08 busIRQ= 8 on 00-08

0:00:00:02.798 cpu0:1024)IntrVector: 279: 0x59

0:00:00:02.798 cpu0:1024)IOAPIC: 942: vector 0x59 to 00-08

0:00:00:02.799 cpu0:1024)IDT: 1262: 0x59 irq 8 flags 0x3

0:00:00:02.799 cpu0:1024)Host: 2530: IRQ 8(1), vector 89

0:00:00:02.799 cpu0:1024)ISA: 88: irq 9 is not ISA

0:00:00:02.799 cpu0:1024)ISA: 88: irq 10 is not ISA

0:00:00:02.799 cpu0:1024)ISA: 88: irq 11 is not ISA

0:00:00:02.799 cpu0:1024)ISA: 114: irq 12

0:00:00:02.799 cpu0:1024)Chipset: 699: 007:12 busIRQ= 12 on 00-12

0:00:00:02.799 cpu0:1024)IntrVector: 279: 0x61

0:00:00:02.799 cpu0:1024)IOAPIC: 942: vector 0x61 to 00-12

0:00:00:02.799 cpu0:1024)IDT: 1262: 0x61 irq 12 flags 0x3

0:00:00:02.799 cpu0:1024)Host: 2530: IRQ 12(1), vector 97

0:00:00:02.799 cpu0:1024)ISA: 114: irq 13

0:00:00:02.799 cpu0:1024)Chipset: 699: 007:13 busIRQ= 13 on 00-13

0:00:00:02.799 cpu0:1024)IntrVector: 279: 0x69

0:00:00:02.799 cpu0:1024)IOAPIC: 942: vector 0x69 to 00-13

0:00:00:02.799 cpu0:1024)IDT: 1262: 0x69 irq 13 flags 0x3

0:00:00:02.799 cpu0:1024)Host: 2530: IRQ 13(1), vector 105

0:00:00:02.799 cpu0:1024)ISA: 114: irq 14

0:00:00:02.799 cpu0:1024)Chipset: 699: 007:14 busIRQ= 14 on 00-14

0:00:00:02.799 cpu0:1024)IntrVector: 279: 0x71

0:00:00:02.799 cpu0:1024)IOAPIC: 942: vector 0x71 to 00-14

0:00:00:02.799 cpu0:1024)IDT: 1262: 0x71 irq 14 flags 0x3

0:00:00:02.799 cpu0:1024)Host: 2530: IRQ 14(1), vector 113

0:00:00:02.799 cpu0:1024)ISA: 114: irq 15

0:00:00:02.799 cpu0:1024)Chipset: 699: 007:15 busIRQ= 15 on 00-15

0:00:00:02.799 cpu0:1024)IntrVector: 279: 0x79

0:00:00:02.799 cpu0:1024)IOAPIC: 942: vector 0x79 to 00-15

0:00:00:02.799 cpu0:1024)IDT: 1262: 0x79 irq 15 flags 0x3

0:00:00:02.799 cpu0:1024)Host: 2530: IRQ 15(1), vector 121

0:00:00:02.799 cpu0:1024)PCI: 1457: Building PCI devices list

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:00.0 8086:2778 8086:348e added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0600 progIFRevID 0000

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:28.0 8086:27d0 0000:0000 added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0604 progIFRevID 0001

0:00:00:02.800 cpu0:1024)PCI: 1182: intPIN A intLine 255

0:00:00:02.800 cpu0:1024)Chipset: 699: 000:28 A busIRQ=112 on 00-17

0:00:00:02.800 cpu0:1024)IntrVector: 279: 0x81

0:00:00:02.800 cpu0:1024)IOAPIC: 942: vector 0x81 to 00-17

0:00:00:02.800 cpu0:1024)PCI: 1190: irq 0 vector 0x81

[7m0:00:00:02.800 cpu0:1024)WARNING: Host: 2499: irq 0 is not valid [0m

0:00:00:02.800 cpu0:1024)PCI: 1198: Adding bus 1 with parent 0

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:28.4 8086:27e0 0000:0000 added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0604 progIFRevID 0001

0:00:00:02.800 cpu0:1024)PCI: 1182: intPIN A intLine 255

0:00:00:02.800 cpu0:1024)Chipset: 699: 000:28 A busIRQ=112 on 00-17

0:00:00:02.800 cpu0:1024)PCI: 1190: irq 0 vector 0x81

[7m0:00:00:02.800 cpu0:1024)WARNING: Host: 2499: irq 0 is not valid [0m

0:00:00:02.800 cpu0:1024)PCI: 1198: Adding bus 2 with parent 0

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:28.5 8086:27e2 0000:0000 added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0604 progIFRevID 0001

0:00:00:02.800 cpu0:1024)PCI: 1182: intPIN B intLine 255

0:00:00:02.800 cpu0:1024)Chipset: 699: 000:28 B busIRQ=113 on 00-16

0:00:00:02.800 cpu0:1024)IntrVector: 279: 0x89

0:00:00:02.800 cpu0:1024)IOAPIC: 942: vector 0x89 to 00-16

0:00:00:02.800 cpu0:1024)PCI: 1190: irq 0 vector 0x89

[7m0:00:00:02.800 cpu0:1024)WARNING: Host: 2499: irq 0 is not valid [0m

0:00:00:02.800 cpu0:1024)PCI: 1198: Adding bus 5 with parent 0

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:29.0 8086:27c8 8086:348e added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0c03 progIFRevID 0001

0:00:00:02.800 cpu0:1024)PCI: 1182: intPIN A intLine 11

0:00:00:02.800 cpu0:1024)Chipset: 699: 000:29 A busIRQ=116 on 00-23

0:00:00:02.800 cpu0:1024)IntrVector: 279: 0x91

0:00:00:02.800 cpu0:1024)IOAPIC: 942: vector 0x91 to 00-23

0:00:00:02.800 cpu0:1024)PCI: 1190: irq 20 vector 0x91

0:00:00:02.800 cpu0:1024)IDT: 1262: 0x91 irq 20 flags 0x0

0:00:00:02.800 cpu0:1024)Host: 2530: IRQ 20(0), vector 145

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:29.1 8086:27c9 8086:348e added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0c03 progIFRevID 0001

0:00:00:02.800 cpu0:1024)PCI: 1182: intPIN B intLine 10

0:00:00:02.800 cpu0:1024)Chipset: 699: 000:29 B busIRQ=117 on 00-19

0:00:00:02.800 cpu0:1024)IntrVector: 279: 0x99

0:00:00:02.800 cpu0:1024)IOAPIC: 942: vector 0x99 to 00-19

0:00:00:02.800 cpu0:1024)PCI: 1190: irq 19 vector 0x99

0:00:00:02.800 cpu0:1024)IDT: 1262: 0x99 irq 19 flags 0x0

0:00:00:02.800 cpu0:1024)Host: 2530: IRQ 19(0), vector 153

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:29.2 8086:27ca 8086:348e added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0c03 progIFRevID 0001

0:00:00:02.800 cpu0:1024)PCI: 1182: intPIN C intLine 11

0:00:00:02.800 cpu0:1024)Chipset: 699: 000:29 C busIRQ=118 on 00-18

0:00:00:02.800 cpu0:1024)IntrVector: 279: 0xa1

0:00:00:02.800 cpu0:1024)IOAPIC: 942: vector 0xa1 to 00-18

0:00:00:02.800 cpu0:1024)PCI: 1190: irq 18 vector 0xa1

0:00:00:02.800 cpu0:1024)IDT: 1262: 0xa1 irq 18 flags 0x0

0:00:00:02.800 cpu0:1024)Host: 2530: IRQ 18(0), vector 161

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:29.3 8086:27cb 8086:348e added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0c03 progIFRevID 0001

0:00:00:02.800 cpu0:1024)PCI: 1182: intPIN D intLine 11

0:00:00:02.800 cpu0:1024)Chipset: 699: 000:29 D busIRQ=119 on 00-16

0:00:00:02.800 cpu0:1024)PCI: 1190: irq 16 vector 0x89

0:00:00:02.800 cpu0:1024)IDT: 1262: 0x89 irq 16 flags 0x0

0:00:00:02.800 cpu0:1024)Host: 2530: IRQ 16(0), vector 137

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:29.7 8086:27cc 8086:348e added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0c03 progIFRevID 2001

0:00:00:02.800 cpu0:1024)PCI: 1182: intPIN A intLine 11

0:00:00:02.800 cpu0:1024)Chipset: 699: 000:29 A busIRQ=116 on 00-23

0:00:00:02.800 cpu0:1024)PCI: 1190: irq 20 vector 0x91

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:30.0 8086:244e 0000:0000 added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0604 progIFRevID 01e1

0:00:00:02.800 cpu0:1024)PCI: 1198: Adding bus 6 with parent 0

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:31.0 8086:27b8 8086:348e added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0601 progIFRevID 0001

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:31.1 8086:27df 8086:348e added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0101 progIFRevID 8a01

0:00:00:02.800 cpu0:1024)PCI: 1182: intPIN A intLine 11

0:00:00:02.800 cpu0:1024)Chipset: 699: 000:31 A busIRQ=124 on 00-18

0:00:00:02.800 cpu0:1024)PCI: 1190: irq 18 vector 0xa1

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:31.2 8086:27c0 8086:348e added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0101 progIFRevID 8f01

0:00:00:02.800 cpu0:1024)PCI: 1182: intPIN B intLine 10

0:00:00:02.800 cpu0:1024)Chipset: 699: 000:31 B busIRQ=125 on 00-19

0:00:00:02.800 cpu0:1024)PCI: 1190: irq 19 vector 0x99

0:00:00:02.800 cpu0:1024)PCI: 1177: 000:31.3 8086:27da 8086:348e added

0:00:00:02.800 cpu0:1024)PCI: 1179: classCode 0c05 progIFRevID 0001

0:00:00:02.800 cpu0:1024)PCI: 1182: intPIN B intLine 10

0:00:00:02.800 cpu0:1024)PCI: 1188: not hooking up interrupt

0:00:00:02.801 cpu0:1024)PCI: 1177: 002:00.0 8086:0370 0000:0000 added

0:00:00:02.801 cpu0:1024)PCI: 1179: classCode 0604 progIFRevID 0000

0:00:00:02.801 cpu0:1024)PCI: 1198: Adding bus 3 with parent 2

0:00:00:02.801 cpu0:1024)PCI: 1177: 002:00.2 8086:0372 0000:0000 added

0:00:00:02.801 cpu0:1024)PCI: 1179: classCode 0604 progIFRevID 0000

0:00:00:02.801 cpu0:1024)PCI: 1198: Adding bus 4 with parent 2

0:00:00:02.801 cpu0:1024)PCI: 1177: 003:14.0 9005:0285 9005:02bb added

0:00:00:02.801 cpu0:1024)PCI: 1179: classCode 0104 progIFRevID 0000

0:00:00:02.801 cpu0:1024)PCI: 1182: intPIN A intLine 11

0:00:00:02.801 cpu0:1024)Chipset: 679: bus 3 isn't present

0:00:00:02.801 cpu0:1024)PCI: 2228: No direct hookup for 003:14.0

0:00:00:02.801 cpu0:1024)PCI: 2251: Trying through bridge at 002:00.0

0:00:00:02.801 cpu0:1024)Chipset: 699: 002:00 C busIRQ= 2 on 00-18

0:00:00:02.801 cpu0:1024)PCI: 1190: irq 18 vector 0xa1

0:00:00:02.801 cpu0:1024)PCI: 1177: 005:00.0 8086:108c 8086:348f added

0:00:00:02.801 cpu0:1024)PCI: 1179: classCode 0200 progIFRevID 0003

0:00:00:02.801 cpu0:1024)PCI: 1182: intPIN A intLine 9

0:00:00:02.801 cpu0:1024)Chipset: 699: 005:00 A busIRQ= 0 on 00-17

0:00:00:02.801 cpu0:1024)PCI: 1190: irq 17 vector 0x81

0:00:00:02.801 cpu0:1024)IDT: 1262: 0x81 irq 17 flags 0x0

0:00:00:02.801 cpu0:1024)Host: 2530: IRQ 17(0), vector 129

0:00:00:02.801 cpu0:1024)PCI: 1177: 005:00.3 8086:108f 8086:0000 added

0:00:00:02.801 cpu0:1024)PCI: 1179: classCode 0700 progIFRevID 0203

0:00:00:02.801 cpu0:1024)PCI: 1182: intPIN C intLine 10

0:00:00:02.801 cpu0:1024)Chipset: 699: 005:00 C busIRQ= 2 on 00-19

0:00:00:02.801 cpu0:1024)PCI: 1190: irq 19 vector 0x99

0:00:00:02.801 cpu0:1024)PCI: 1177: 005:00.4 8086:108e 8086:0000 added

0:00:00:02.801 cpu0:1024)PCI: 1179: classCode 0c07 progIFRevID 0103

0:00:00:02.801 cpu0:1024)PCI: 1182: intPIN D intLine 11

0:00:00:02.801 cpu0:1024)Chipset: 699: 005:00 D busIRQ= 3 on 00-16

0:00:00:02.801 cpu0:1024)PCI: 1190: irq 16 vector 0x89

0:00:00:02.801 cpu0:1024)PCI: 1177: 006:04.0 1002:515e 8086:348e added

0:00:00:02.801 cpu0:1024)PCI: 1179: classCode 0300 progIFRevID 0002

0:00:00:02.801 cpu0:1024)PCI: 1182: intPIN A intLine 11

0:00:00:02.801 cpu0:1024)PCI: 1188: not hooking up interrupt

0:00:00:02.801 cpu0:1024)PCI: 1177: 006:05.0 8086:1076 8086:348f added

0:00:00:02.801 cpu0:1024)PCI: 1179: classCode 0200 progIFRevID 0005

0:00:00:02.801 cpu0:1024)PCI: 1182: intPIN A intLine 9

0:00:00:02.801 cpu0:1024)Chipset: 699: 006:05 A busIRQ= 20 on 00-17

0:00:00:02.801 cpu0:1024)PCI: 1190: irq 17 vector 0x81

0:00:00:02.815 cpu0:1024)PCI: 318: 000:00.0 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:28.0 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:28.4 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:28.5 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:29.0 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:29.1 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:29.2 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:29.3 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:29.7 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:30.0 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:31.0 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:31.1 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:31.2 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 000:31.3 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 002:00.0 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 002:00.2 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 003:14.0 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 005:00.0 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 005:00.3 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 005:00.4 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 006:04.0 owned by COS

0:00:00:02.815 cpu0:1024)PCI: 318: 006:05.0 owned by COS

0:00:00:02.815 cpu0:1024)Host: 2883: Enabling irqs

0:00:00:02.815 cpu0:1024)Host: 2655: irq 1 vector 0x29 (host 0x39)

0:00:00:02.815 cpu0:1024)IOAPIC: 1255: 0x29 retriggerred

0:00:00:02.815 cpu0:1024)Host: 2655: irq 14 vector 0x71 (host 0x81)

0:00:00:02.815 cpu0:1024)IOAPIC: 1255: 0x71 retriggerred

0:00:00:02.815 cpu0:1024)IOAPIC: 1336: IOAPICId 5:

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 1 00000029

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 3 00010031

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 4 00010039

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 5 00010041

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 6 00010049

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 7 00010051

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 8 00010059

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 9 00018021

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 12 00010061

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 13 00010069

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 14 00000071

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 15 00010079

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 16 0001a089

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 17 0001a081

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 18 0001a0a1

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 19 0001a099

0:00:00:02.815 cpu0:1024)IOAPIC: 1366: 23 0001a091

0:00:00:02.815 cpu0:1024)Host: 4356: HOST SW IC: numslices 1 inService=0

0:00:00:02.815 cpu0:1024)Host: 4359: HOST SW IC: for slice 0 pending=0x4003

0:00:00:02.815 cpu0:1024)IDT: 1336: 0x29 <keyboard> exclusive, flags 0x3

0:00:00:02.815 cpu0:1024)Init: 922: Vmkernel initialization done. Returning to console.

0:00:00:02.815 cpu0:1024)Vmkernel loaded successfully.

0:00:00:02.815 cpu2:1057)VSCSI: 3128: Starting reset watchdog world 1057

0:00:00:02.815 cpu3:1030)ScsiCore: 158: Starting taskMgmt watchdog world 1030

0:00:00:02.815 cpu3:1030)World: vm 1061: 895: Starting world PathTaskmgmtHandler with flags 1

0:00:00:02.815 cpu1:1029)ScsiCore: 158: Starting taskMgmt watchdog world 1029

0:00:00:02.815 cpu0:1056)VSCSI: 2927: Starting reset handler world 1056/1

0:00:00:02.815 cpu1:1029)World: vm 1062: 895: Starting world DeviceTaskmgmtHandler with flags 1

0:00:00:02.815 cpu1:1062)ScsiCore: 95: Starting taskmgmt handler world 1062/1

0:00:00:02.815 cpu1:1061)ScsiCore: 95: Starting taskmgmt handler world 1061/1

0:00:00:02.816 cpu0:1024)VMNIX: IRQ: 1308: registering ioapic 0, 0xfec00000, 0

0:00:00:02.817 cpu0:1024)VMNIX: VmkDev: 503: Started vmkdevd.

0:00:00:02.817 cpu0:1024)VMNIX: VmkDev: 1714: vsd

0:00:00:02.817 cpu0:1024)VMNIX: VmkDev: 1740: Registered 1 adapters

0:00:00:02.833 cpu0:1024)VMNIX: VMK: 643: vmnix module STACK_TOP_LA=0xfd802ff0

0:00:00:02.833 cpu0:1024)Mod: 2457: Allocating 556157 bytes for 10559 symbols, 207710 of names

0:00:00:02.924 cpu0:1024)Loading module vmklinux ...

0:00:00:02.924 cpu0:1024)Mod: 936: Starting load for module: vmklinux R/O length: 0x1f000 R/W length: 0x4b000 Md5sum: 6dcaf3613d331e5213f8da37e616a844

0:00:00:03.075 cpu1:1035)Mod: 1373: Module vmklinux: initFunc: 0x87a954 text: 0x877000 data: 0x2869700 bss: 0x287a580 (writeable align 128)

0:00:00:03.075 cpu1:1035)Mod: 1389: modLoaderHeap avail before: 7832440

0:00:00:03.075 cpu1:1035)LinNet: 432: NET_MAX_IMPL_PKT_OVHD: 0 extra bytes reserved

0:00:00:03.076 cpu1:1035)PCI: 1965: for module 1

0:00:00:03.076 cpu1:1035)LinStubs: 2044: fn=0x878574 arg=0x0

0:00:00:03.076 cpu1:1035)World: vm 1063: 895: Starting world driver with flags 1

0:00:00:03.076 cpu3:1063)LinStubs: 2113: fn=0x878574 arg=0x0

0:00:00:03.076 cpu1:1035)Mod: 1436: Initialization for vmklinux succeeded with module ID 1.

0:00:00:03.076 cpu1:1035)vmklinux loaded successfully.

0:00:00:03.076 cpu1:1035)Mod: 1445: modLoaderHeap avail after: 7832440

0:00:00:03.076 cpu1:1035)Mod: 1473: no private ID set

0:00:00:03.076 cpu0:1024)Mod: 2457: Allocating 22104 bytes for 452 symbols, 7188 of names

0:00:00:03.083 cpu1:1035)Config: 489: "CosCorefile" = "/vmfs/volumes/47bdfb24-e9e466aa-8598-00151758c75c/cos-core-esx01", Old value: "" (Status: 0x0)

0:00:00:03.084 cpu1:1035)Init: 2026: vmkernelID = 17541312.

0:00:00:03.084 cpu1:1035)Config: 489: "HostIPAddr" = "192.168.11.1", Old value: "127.0.0.1" (Status: 0x0)

0:00:00:03.084 cpu1:1035)Config: 489: "HostName" = "esx01.1st-sc.de", Old value: "localhost" (Status: 0x0)

0:00:00:03.084 cpu1:1035)PCI: 1884: 000:31.2 named 'vmhba0' (was '')

0:00:00:03.084 cpu1:1035)PCI: 1884: 003:14.0 named 'vmhba1' (was '')

0:00:00:03.084 cpu1:1035)PCI: 1884: 005:00.0 named 'vmnic0' (was '')

0:00:00:03.084 cpu1:1035)PCI: 1884: 006:05.0 named 'vmnic1' (was '')

0:00:00:03.118 cpu0:1024)VMNIX: CosSup: 663: Found 000:31.2 on the console

0:00:00:03.118 cpu0:1024)VMNIX: CosSup: 753: Unplugging 000:31.2

0:00:00:03.118 cpu1:1034)PCI: 1533: 000:31.2 to vmkernel

0:00:00:03.118 cpu1:1034)LinPCI: 39: 000:31.2 vmhba0

0:00:00:03.118 cpu0:1024)VMNIX: Mod: 467: Adding 000:31.2

0:00:00:03.127 cpu0:1024)VMNIX: CosSup: 663: Found 003:14.0 on the console

0:00:00:03.127 cpu0:1024)VMNIX: CosSup: 753: Unplugging 003:14.0

0:00:00:03.127 cpu1:1034)PCI: 1533: 003:14.0 to vmkernel

0:00:00:03.127 cpu1:1034)LinPCI: 39: 003:14.0 vmhba1

0:00:00:03.127 cpu0:1024)VMNIX: Mod: 467: Adding 003:14.0

0:00:00:03.130 cpu0:1024)VMNIX: CosSup: 663: Found 005:00.0 on the console

0:00:00:03.130 cpu0:1024)VMNIX: CosSup: 753: Unplugging 005:00.0

0:00:00:03.130 cpu1:1034)PCI: 1533: 005:00.0 to vmkernel

0:00:00:03.130 cpu1:1034)LinPCI: 39: 005:00.0 vmnic0

0:00:00:03.130 cpu0:1024)VMNIX: Mod: 467: Adding 005:00.0

0:00:00:03.139 cpu0:1024)VMNIX: CosSup: 663: Found 006:05.0 on the console

0:00:00:03.139 cpu0:1024)VMNIX: CosSup: 753: Unplugging 006:05.0

0:00:00:03.139 cpu1:1034)PCI: 1533: 006:05.0 to vmkernel

0:00:00:03.139 cpu1:1034)LinPCI: 39: 006:05.0 vmnic1

0:00:00:03.139 cpu0:1024)VMNIX: Mod: 467: Adding 006:05.0

0:00:00:03.200 cpu0:1024)Loading module ata_piix ...

0:00:00:03.202 cpu0:1024)Mod: 936: Starting load for module: ata_piix R/O length: 0xb000 R/W length: 0x4000 Md5sum: 6e71fac03af3efc88767be5c238866fa

0:00:00:03.291 cpu1:1036)Mod: 1373: Module ata_piix: initFunc: 0x896d28 text: 0x896000 data: 0x28b4780 bss: 0x28b4c20 (writeable align 32)

0:00:00:03.291 cpu1:1036)Mod: 1389: modLoaderHeap avail before: 7810328

0:00:00:03.291 cpu1:1036)Initial heap size : 1048576, max heap size: 8388608

0:00:00:03.291 cpu1:1036)<7>libata version 1.20 loaded.

0:00:00:03.291 cpu1:1036)PCI: driver ata_piix is looking for devices

0:00:00:03.291 cpu1:1036)PCI: Trying 00:1f.2

0:00:00:03.291 cpu1:1036)PCI: Announcing 00:1f.2

<7>PCI(00:1f.2): 0:00:00:03.291 cpu1:1036)version 1.05

0:00:00:03.291 cpu1:1036)<7>PCI: Setting latency timer of device 00:1f.2 to 64

0:00:00:03.291 cpu1:1036)PCI: driver ata_piix claimed device 00:1f.2

0:00:00:03.291 cpu1:1036)Mod: 2545: No post-insert func

0:00:00:03.291 cpu1:1036)PCI: Trying 03:0e.0

0:00:00:03.291 cpu1:1036)PCI: Announcing 03:0e.0

0:00:00:03.291 cpu1:1036)PCI: Trying 05:00.0

0:00:00:03.291 cpu1:1036)PCI: Announcing 05:00.0

0:00:00:03.291 cpu1:1036)PCI: Trying 06:05.0

0:00:00:03.291 cpu1:1036)PCI: Announcing 06:05.0

0:00:00:03.291 cpu1:1036)PCI: driver ata_piix claimed 1 device

0:00:00:03.291 cpu1:1036)<6>ata1: SATA max UDMA/133 cmd 0x30c8 ctl 0x30e6 bmdma 0x30a0 irq 153

0:00:00:03.291 cpu1:1036)<6>ata2: SATA max UDMA/133 cmd 0x30c0 ctl 0x30e2 bmdma 0x30a8 irq 153

0:00:00:03.291 cpu1:1036)IDT: 1336: 0x99 <libata> sharable (entropy source), flags 0x10

0:00:00:03.463 cpu1:1036)<4>ATA: abnormal status 0x7f on port 0x30cf

0:00:00:03.463 cpu1:1036)<3>ata1: disabling port

0:00:00:03.635 cpu1:1036)<4>ATA: abnormal status 0x7f on port 0x30c7

0:00:00:03.635 cpu1:1036)<3>ata2: disabling port

0:00:00:03.635 cpu1:1036)LinPCI: 202: Device 0:fa claimed.

0:00:00:03.635 cpu1:1036)SCSI: 861: GetInfo for adapter vmhba32, , max_vports=0, vports_inuse=0, linktype=0, state=0, failreason=0, rv=-19, sts=bad0001

0:00:00:03.636 cpu1:1036)SCSI: 861: GetInfo for adapter vmhba32, , max_vports=0, vports_inuse=0, linktype=0, state=0, failreason=0, rv=-19, sts=bad0001

0:00:00:03.636 cpu1:1036)SCSI: 861: GetInfo for adapter vmhba0, , max_vports=0, vports_inuse=0, linktype=0, state=0, failreason=0, rv=-19, sts=bad0001

0:00:00:03.636 cpu1:1036)Mod: 1436: Initialization for ata_piix succeeded with module ID 2.

0:00:00:03.636 cpu1:1036)ata_piix loaded successfully.

0:00:00:03.641 cpu1:1036)Mod: 1445: modLoaderHeap avail after: 7810328

0:00:00:03.641 cpu1:1036)Mod: 1473: no private ID set

0:00:00:03.641 cpu0:1024)VMNIX: VmkDev: 1714: ata_piix

0:00:00:03.641 cpu0:1024)VMNIX: VmkDev: 1740: Registered 2 adapters

0:00:00:03.732 cpu0:1024)Loading module aacraid_esx30 ...

0:00:00:03.734 cpu0:1024)Mod: 936: Starting load for module: aacraid_esx30 R/O length: 0x10000 R/W length: 0x9000 Md5sum: a0170137fdcc4807458c4be5f13292da

0:00:00:03.824 cpu1:1036)Mod: 1373: Module aacraid_esx30: initFunc: 0x8a2664 text: 0x8a1000 data: 0x28b87a0 bss: 0x28b96c0 (writeable align 32)

0:00:00:03.824 cpu1:1036)Mod: 1389: modLoaderHeap avail before: 7810312

0:00:00:03.824 cpu1:1036)Initial heap size : 1048576, max heap size: 8388608

0:00:00:03.824 cpu1:1036)<6>Adaptec aacraid_esx30 driver (1.1-5[d-8930]custom-IBM)

0:00:00:03.824 cpu1:1036)PCI: driver aacraid_esx30 is looking for devices

0:00:00:03.824 cpu1:1036)PCI: Trying 00:1f.2

0:00:00:03.824 cpu1:1036)PCI: Trying 03:0e.0

0:00:00:03.824 cpu1:1036)PCI: Announcing 03:0e.0

0:00:00:03.824 cpu1:1036)IDT: 1336: 0xa1 <aacraid> sharable (entropy source), flags 0x10

0:00:00:04.527 cpu1:1036)LinStubs: 2044: fn=0x8a9820 arg=0x2832680

0:00:00:04.527 cpu1:1036)World: vm 1064: 895: Starting world driver with flags 1

0:00:00:04.527 cpu2:1064)LinStubs: 2113: fn=0x8a9820 arg=0x2832680

0:00:00:04.527 cpu1:1036)<6>aacraid0: kernel 5.2-0[15611]

0:00:00:04.527 cpu1:1036)<6>aacraid0: monitor 5.2-0[15611]

0:00:00:04.527 cpu1:1036)<6>aacraid0: bios 5.2-0[15611]

0:00:00:04.527 cpu1:1036)<6>aacraid0: serial 1413a7

0:00:00:04.527 cpu1:1036)<6>aacraid0: Non-DASD support enabled.

0:00:00:04.534 cpu1:1036)PCI: driver aacraid_esx30 claimed device 03:0e.0

0:00:00:04.534 cpu1:1036)Mod: 2545: No post-insert func

0:00:00:04.534 cpu1:1036)PCI: Trying 05:00.0

0:00:00:04.534 cpu1:1036)PCI: Announcing 05:00.0

0:00:00:04.534 cpu1:1036)PCI: Trying 06:05.0

0:00:00:04.534 cpu1:1036)PCI: Announcing 06:05.0

0:00:00:04.534 cpu1:1036)PCI: driver aacraid_esx30 claimed 1 device

0:00:00:04.534 cpu1:1036)LinPCI: 202: Device 3:70 claimed.

0:00:00:04.534 cpu1:1036)SCSI: 861: GetInfo for adapter vmhba1, , max_vports=0, vports_inuse=0, linktype=0, state=0, failreason=0, rv=-25, sts=bad0001

0:00:00:04.535 cpu1:1036)ScsiScan: 395: Path 'vmhba1:C0:T0:L0': Vendor: 'Adaptec ' Model: 'Raid5 ' Rev: 'V1.0'

0:00:00:04.535 cpu1:1036)ScsiScan: 396: Type: 0x0, ANSI rev: 2

VMWARE SCSI Id: Supported VPD pages for vmhba1:C0:T0:L0 : 0x1f 0x0

0:00:00:04.535 cpu1:1036)VMWARE SCSI Id: Could not get disk id for vmhba1:C0:T0:L0

0:00:00:04.535 cpu1:1036)ScsiUid: 754: Path 'vmhba1:C0:T0:L0' does not support VPD Serial Id page.

0:00:00:04.535 cpu1:1036)ScsiUid: 781: Path 'vmhba1:C0:T0:L0' does not support VPD Device Id page.

0:00:00:04.535 cpu1:1036)ScsiScan: 559: Path 'vmhba1:C0:T0:L0': No standard UID: Failure

0:00:00:04.535 cpu1:1036)ScsiScan: 641: Discovered path vmhba1:C0:T0:L0

0:00:00:04.542 cpu1:1036)SCSI: 1923: Device vmhba1:0:0 has not been identified as being attached to an active/passive SAN. It is either attached to an active/active SAN or is a local device.

0:00:00:04.542 cpu1:1036)ScsiPath: 3171: Plugin 'legacyMP' claimed path 'vmhba1:C0:T0:L0'

0:00:00:04.606 cpu1:1036)ScsiDevice: 3459: Adding Device "vmhba1:0:0" from Plugin "legacyMP", Device Type 0

0:00:00:04.606 cpu1:1036)SCSI: 5461: Logical device vmhba1:0:0 for target vmhba1:0:0 was registered successfully.

0:00:00:04.606 cpu1:1036)SCSI: 861: GetInfo for adapter vmhba1, , max_vports=0, vports_inuse=0, linktype=0, state=0, failreason=0, rv=-25, sts=bad0001

0:00:00:04.619 cpu1:1036)Mod: 1436: Initialization for aacraid_esx30 succeeded with module ID 3.

0:00:00:04.619 cpu1:1036)aacraid_esx30 loaded successfully.

0:00:00:04.623 cpu1:1036)Mod: 1445: modLoaderHeap avail after: 7810312

0:00:00:04.623 cpu1:1036)Mod: 1473: no private ID set

0:00:00:04.623 cpu0:1024)VMNIX: VmkDev: 1714: aacraid_esx30

0:00:00:04.623 cpu0:1024)VMNIX: VmkDev: 1740: Registered 1 adapters

0:00:00:04.734 cpu0:1024)Loading module e1000 ...

0:00:00:04.737 cpu0:1024)Mod: 936: Starting load for module: e1000 R/O length: 0x1c000 R/W length: 0x6000 Md5sum: 47297f7bb260979beb485f9373ca69a4

0:00:00:04.856 cpu1:1035)Mod: 1373: Module e1000: initFunc: 0x8b1624 text: 0x8b1000 data: 0x28c17c0 bss: 0x28c2040 (writeable align 32)

0:00:00:04.856 cpu1:1035)Mod: 1389: modLoaderHeap avail before: 7810296

0:00:00:04.856 cpu1:1035)Initial heap size : 102400, max heap size: 4194304

0:00:00:04.856 cpu1:1035)<6>Intel(R) PRO/1000 Network Driver - version 7.3.15

0:00:00:04.856 cpu1:1035)PCI: driver e1000 is looking for devices

0:00:00:04.856 cpu1:1035)PCI: Trying 00:1f.2

0:00:00:04.856 cpu1:1035)PCI: Trying 03:0e.0

0:00:00:04.856 cpu1:1035)PCI: Trying 05:00.0

0:00:00:04.856 cpu1:1035)PCI: Announcing 05:00.0

0:00:00:04.856 cpu1:1035)<7>PCI: Setting latency timer of device 05:00.0 to 64

<6>e1000: 05:00.0: e1000_probe: (PCI Express:2.5Gb/s:Width x1) 00:15:17:58:c7:5b

0:00:00:04.937 cpu1:1035)<6>e1000: vmnic0: e1000_probe: Intel(R) PRO/1000 Network Connection

0:00:00:04.937 cpu1:1035)PCI: driver e1000 claimed device 05:00.0

0:00:00:04.937 cpu1:1035)PCI: Registering network device 05:00.0

0:00:00:04.937 cpu1:1035)Uplink: 2086: Couldn't find vmnic0. Creating a new node

0:00:00:04.937 cpu1:1035)Uplink: 3481: Connecting device vmnic0 to pps

0:00:00:04.937 cpu1:1035)Uplink: 3626: Device vmnic0 yet to come up

0:00:00:04.937 cpu1:1035)LinPCI: 202: Device 5:0 claimed.

0:00:00:04.937 cpu1:1035)Mod: 2529: called already for this device.

0:00:00:04.937 cpu1:1035)PCI: Trying 06:05.0

0:00:00:04.937 cpu1:1035)PCI: Announcing 06:05.0

<6>e1000: 06:05.0: e1000_probe: (PCI:33MHz:32-bit) 00:15:17:58:c7:5c

0:00:00:05.122 cpu1:1035)<6>e1000: vmnic1: e1000_probe: Intel(R) PRO/1000 Network Connection

0:00:00:05.122 cpu1:1035)PCI: driver e1000 claimed device 06:05.0

0:00:00:05.122 cpu1:1035)PCI: Registering network device 06:05.0

0:00:00:05.122 cpu1:1035)Uplink: 2086: Couldn't find vmnic1. Creating a new node

0:00:00:05.122 cpu1:1035)Uplink: 3481: Connecting device vmnic1 to pps

0:00:00:05.122 cpu1:1035)Uplink: 3626: Device vmnic1 yet to come up

0:00:00:05.122 cpu1:1035)LinPCI: 202: Device 6:28 claimed.

0:00:00:05.122 cpu1:1035)Mod: 2529: called already for this device.

0:00:00:05.122 cpu1:1035)PCI: driver e1000 claimed 2 devices

0:00:00:05.123 cpu1:1035)IDT: 1336: 0x81 <vmnic0> sharable (entropy source), flags 0x10

0:00:00:05.124 cpu1:1035)Uplink: 2495: Setting capabilities 0x0 for device vmnic0

0:00:00:05.124 cpu1:1035)NetNCP: 1818: Opening discovery port

0:00:00:05.124 cpu1:1035)NetDiscover: 946: Using port 0x3's output chain

0:00:00:05.124 cpu1:1035)IDT: 1336: 0x81 <vmnic1> sharable (entropy source), flags 0x10

0:00:00:05.124 cpu1:1035)Uplink: 2495: Setting capabilities 0x0 for device vmnic1

0:00:00:05.124 cpu1:1035)NetNCP: 1818: Opening discovery port

0:00:00:05.124 cpu1:1035)NetDiscover: 946: Using port 0x3's output chain

0:00:00:05.124 cpu1:1035)Mod: 1436: Initialization for e1000 succeeded with module ID 4.

0:00:00:05.124 cpu1:1035)e1000 loaded successfully.

0:00:00:05.129 cpu1:1035)Mod: 1445: modLoaderHeap avail after: 7810296

0:00:00:05.129 cpu1:1035)Mod: 1473: no private ID set

0:00:00:05.190 cpu0:1024)Loading module lvmdriver ...

0:00:00:05.192 cpu0:1024)Mod: 936: Starting load for module: lvmdriver R/O length: 0xb000 R/W length: 0x2000 Md5sum: 8217be234285a224528f272b798e8a29

0:00:00:05.281 cpu1:1037)Mod: 1373: Module lvmdriver: initFunc: 0x8cd000 text: 0x8cd000 data: 0x28cd3c0 bss: 0x28cdc00 (writeable align 32)

0:00:00:05.281 cpu1:1037)Mod: 1389: modLoaderHeap avail before: 7810280

0:00:00:05.281 cpu1:1037)LVM: 548: LVM max heap size: 32768KB

0:00:00:05.282 cpu1:1037)FDS: 222: lvm

0:00:00:05.307 cpu1:1037)Mod: 1436: Initialization for lvmdriver succeeded with module ID 5.

0:00:00:05.307 cpu1:1037)lvmdriver loaded successfully.

0:00:00:05.311 cpu1:1037)Mod: 1445: modLoaderHeap avail after: 7810280

0:00:00:05.311 cpu1:1037)Mod: 1473: no private ID set

0:00:00:05.370 cpu0:1024)Loading module vmfs3 ...

0:00:00:05.372 cpu0:1024)Mod: 936: Starting load for module: vmfs3 R/O length: 0x2c000 R/W length: 0x1000 Md5sum: 8a4991ee4b387c61c746207769642a4e

0:00:00:05.552 cpu1:1037)Mod: 1373: Module vmfs3: initFunc: 0x8ff3c0 text: 0x8d8000 data: 0x28cf400 bss: 0x28cf780 (writeable align 32)

0:00:00:05.552 cpu1:1037)Mod: 1389: modLoaderHeap avail before: 7810280

0:00:00:05.552 cpu1:1037)World: vm 1065: 895: Starting world FS3ResMgr with flags 1

0:00:00:05.552 cpu1:1037)FSS: 307: Registered fs vmfs3, module 6, fsTypeNum 0xf530

0:00:00:05.685 cpu1:1037)Mod: 1436: Initialization for vmfs3 succeeded with module ID 6.

0:00:00:05.685 cpu1:1037)vmfs3 loaded successfully.

0:00:00:05.690 cpu1:1037)Mod: 1445: modLoaderHeap avail after: 7810280

0:00:00:05.690 cpu1:1037)Mod: 1473: no private ID set

0:00:00:07.201 cpu0:1024)VMNIX: VGA: 470: 1

0:00:00:07.201 cpu0:1024)VMNIX: VGA: 470: 2

0:00:00:07.201 cpu0:1024)VMNIX: VGA: 470: 3

0:00:00:07.201 cpu0:1024)VMNIX: VGA: 470: 4

0:00:00:07.201 cpu0:1024)VMNIX: VGA: 470: 5

0:00:00:07.201 cpu0:1024)VMNIX: VGA: 470: 6

0:00:00:07.201 cpu0:1024)VMNIX: VGA: 470: 7

0:00:00:07.673 cpu0:1024)<6>e1000: vmnic0: e1000_watchdog: NIC Link is Up 1000 Mbps Full Duplex

0:00:00:08.283 cpu0:1024)Host: 2655: irq 20 vector 0x91 (host 0xb1)

0:00:00:08.403 cpu0:1024)Host: 2655: irq 19 vector 0x99 (host 0xa9)

0:00:00:08.513 cpu0:1024)Host: 2655: irq 18 vector 0xa1 (host 0xa1)

0:00:00:08.623 cpu0:1024)Host: 2655: irq 16 vector 0x89 (host 0x91)

0:00:00:22.831 cpu3:1027)IDT: 1756: cannot steer host shared vector 0xa1 to pcpu 3

0:00:00:23.109 cpu0:1024)Loading module etherswitch ...

0:00:00:23.111 cpu0:1024)Mod: 936: Starting load for module: etherswitch R/O length: 0x3000 R/W length: 0x1000 Md5sum: 3df294244c470147b6a69d0e7dfda1d7

0:00:00:23.171 cpu1:1035)Mod: 1373: Module etherswitch: initFunc: 0x905e00 text: 0x904000 data: 0x28d07c8 bss: 0x28d07c8 (writeable align 4)

0:00:00:23.171 cpu1:1035)Mod: 1389: modLoaderHeap avail before: 7810280

0:00:00:23.171 cpu1:1035)Mod: 1436: Initialization for etherswitch succeeded with module ID 7.

0:00:00:23.171 cpu1:1035)etherswitch loaded successfully.

0:00:00:23.175 cpu1:1035)Mod: 1445: modLoaderHeap avail after: 7810280

0:00:00:23.175 cpu1:1035)Mod: 1473: no private ID set

0:00:00:23.242 cpu0:1024)Loading module shaper ...

0:00:00:23.244 cpu0:1024)Mod: 936: Starting load for module: shaper R/O length: 0x3000 R/W length: 0x1000 Md5sum: a24e688bdf27d2dab59c721f9297e8f9

0:00:00:23.304 cpu1:1035)Mod: 1373: Module shaper: initFunc: 0x90864c text: 0x907000 data: 0x28d17e0 bss: 0x28d1d1c (writeable align 32)

0:00:00:23.304 cpu1:1035)Mod: 1389: modLoaderHeap avail before: 7810280

0:00:00:23.304 cpu1:1035)Mod: 1436: Initialization for shaper succeeded with module ID 8.

0:00:00:23.304 cpu1:1035)shaper loaded successfully.

0:00:00:23.308 cpu1:1035)Mod: 1445: modLoaderHeap avail after: 7810280

0:00:00:23.308 cpu1:1035)Mod: 1473: no private ID set

0:00:00:23.525 cpu0:1024)Uplink: 2157: Couldn't find vSwitch0. Creating ps vSwitch0

0:00:00:23.525 cpu0:1024)NetPortset: 808: activating portset #1 as vSwitch0 with 64 ports, index mask is 0x3f

0:00:00:23.525 cpu0:1024)Uplink: 3525: Disconnecting device vmnic0 from pps

0:00:00:23.525 cpu0:1024)Uplink: 3638: Connecting Port 0x1000001 to device vmnic0

0:00:00:23.525 cpu0:1024)Uplink: 2495: Setting capabilities 0x0 for device vmnic0

0:00:00:23.526 cpu0:1024)NetNCP: 1818: Opening discovery port

0:00:00:23.526 cpu0:1024)NetDiscover: 946: Using port 0x1000002's output chain

0:00:00:23.531 cpu0:1024)Uplink: 2157: Couldn't find vSwitch1. Creating ps vSwitch1

0:00:00:23.531 cpu0:1024)NetPortset: 808: activating portset #2 as vSwitch1 with 64 ports, index mask is 0x3f

0:00:00:23.532 cpu0:1024)Uplink: 3525: Disconnecting device vmnic1 from pps

0:00:00:23.532 cpu0:1024)Uplink: 3638: Connecting Port 0x2000001 to device vmnic1

0:00:00:23.532 cpu0:1024)Uplink: 2495: Setting capabilities 0x0 for device vmnic1

0:00:00:23.532 cpu0:1024)NetNCP: 1818: Opening discovery port

0:00:00:23.532 cpu0:1024)NetDiscover: 946: Using port 0x2000002's output chain

0:00:00:23.668 cpu0:1024)Loading module tcpip ...

0:00:00:23.670 cpu0:1024)Mod: 936: Starting load for module: tcpip R/O length: 0x3a000 R/W length: 0x1c000 Md5sum: 5efa83de8704f2303629a08ed571666e

0:00:00:23.883 cpu1:1037)Mod: 1373: Module tcpip: initFunc: 0x90f0dc text: 0x90a000 data: 0x28d2880 bss: 0x28d4980 (writeable align 128)

0:00:00:23.883 cpu1:1037)Mod: 1389: modLoaderHeap avail before: 7810280

0:00:00:23.883 cpu1:1037)Tcpip: 4548: portsetName = (null)

0:00:00:23.884 cpu1:1037)Tcpip: 4417: support:tcp_timer_init

0:00:00:23.884 cpu1:1037)Tcpip_Support: 3202: Initializing routes

0:00:00:23.884 cpu1:1037)Tcpip_Support: 3214: rfc1323 is ENABLED

0:00:00:23.884 cpu1:1037)Tcpip_Support: 3215: vmk_net_init complete

0:00:00:23.884 cpu1:1037)Mod: 1436: Initialization for tcpip succeeded with module ID 9.

0:00:00:23.884 cpu1:1037)tcpip loaded successfully.

0:00:00:23.888 cpu1:1037)Mod: 1445: modLoaderHeap avail after: 7810280

0:00:00:23.888 cpu1:1037)Mod: 1473: no private ID set

0:00:00:24.079 cpu0:1024)Loading module cosShadow ...

0:00:00:24.082 cpu0:1024)Mod: 936: Starting load for module: cosShadow R/O length: 0x3a000 R/W length: 0x1c000 Md5sum: 5efa83de8704f2303629a08ed571666e

0:00:00:24.294 cpu1:1036)Mod: 1373: Module cosShadow: initFunc: 0x9490dc text: 0x944000 data: 0x28ee900 bss: 0x28f0a00 (writeable align 128)

0:00:00:24.294 cpu1:1036)Mod: 1389: modLoaderHeap avail before: 7810264

0:00:00:24.294 cpu1:1036)Tcpip: 4548: portsetName = (null)

0:00:00:24.295 cpu1:1036)Tcpip: 4417: support:tcp_timer_init

0:00:00:24.295 cpu1:1036)Tcpip_Support: 3202: Initializing routes

0:00:00:24.295 cpu1:1036)Tcpip_Support: 3214: rfc1323 is ENABLED

0:00:00:24.295 cpu1:1036)Tcpip_Support: 3215: vmk_net_init complete

0:00:00:24.295 cpu1:1036)Mod: 1436: Initialization for cosShadow succeeded with module ID 10.

0:00:00:24.295 cpu1:1036)cosShadow loaded successfully.

0:00:00:24.299 cpu1:1036)Mod: 1445: modLoaderHeap avail after: 7810264

0:00:00:24.299 cpu1:1036)Mod: 1473: no private ID set

0:00:00:24.708 cpu0:1024)Uplink: 2495: Setting capabilities 0x2b for device vmnic0

0:00:00:24.822 cpu0:1024)Loading module migration ...

0:00:00:24.824 cpu0:1024)Mod: 936: Starting load for module: migration R/O length: 0xf000 R/W length: 0x2000 Md5sum: e3b12a9fcf9d365b77a9cd3b9ec9c125

0:00:00:24.913 cpu1:1037)Mod: 1373: Module migration: initFunc: 0x988b88 text: 0x97e000 data: 0x290a920 bss: 0x290b520 (writeable align 32)

0:00:00:24.913 cpu1:1037)Mod: 1389: modLoaderHeap avail before: 7810248

0:00:00:24.913 cpu1:1037)Migrate: 101: Registering migration module version 3.0

0:00:00:24.913 cpu1:1037)Migrate: 1503: Initializing migration module with module id 11...

0:00:00:24.914 cpu1:1037)Mod: 1436: Initialization for migration succeeded with module ID 11.

0:00:00:24.914 cpu1:1037)migration loaded successfully.

0:00:00:24.918 cpu1:1037)Mod: 1445: modLoaderHeap avail after: 7810248

0:00:00:24.918 cpu1:1037)Mod: 1473: no private ID set

0:00:00:24.997 cpu0:1024)Loading module nfsclient ...

0:00:00:24.999 cpu0:1024)Mod: 936: Starting load for module: nfsclient R/O length: 0x12000 R/W length: 0x1000 Md5sum: 9ad109134aab31c4e81efa710a367550

0:00:00:25.089 cpu1:1036)Mod: 1373: Module nfsclient: initFunc: 0x996694 text: 0x98d000 data: 0x290c940 bss: 0x290d1c0 (writeable align 32)

0:00:00:25.089 cpu1:1036)Mod: 1389: modLoaderHeap avail before: 7810248

0:00:00:25.089 cpu1:1036)World: vm 1066: 895: Starting world nfsRemountHandler with flags 1

0:00:00:25.089 cpu1:1036)FSS: 307: Registered fs nfs, module 12, fsTypeNum 0xb00f

0:00:00:25.394 cpu1:1036)World: vm 1067: 895: Starting world nfsClientMsgHandler with flags 1

0:00:00:25.394 cpu1:1036)World: vm 1068: 895: Starting world nfsLockFileUpdate with flags 1

0:00:00:25.395 cpu1:1036)NFS: 61: Multiple outstanding NFS requests are supported

0:00:00:25.395 cpu1:1036)Mod: 1436: Initialization for nfsclient succeeded with module ID 12.

0:00:00:25.395 cpu1:1036)nfsclient loaded successfully.

0:00:00:25.399 cpu1:1036)Mod: 1445: modLoaderHeap avail after: 7810248

0:00:00:25.399 cpu1:1036)Mod: 1473: no private ID set

0:00:00:25.492 cpu0:1024)Loading module deltadisk ...

0:00:00:25.494 cpu0:1024)Mod: 936: Starting load for module: deltadisk R/O length: 0x7000 R/W length: 0x1000 Md5sum: 10fea39d920b683a0889077916806d68

0:00:00:25.554 cpu1:1036)Mod: 1373: Module deltadisk: initFunc: 0x99f148 text: 0x99f000 data: 0x290de20 bss: 0x290de4c (writeable align 32)

0:00:00:25.554 cpu1:1036)Mod: 1389: modLoaderHeap avail before: 7810248

0:00:00:25.554 cpu1:1036)FDS: 222: deltadisks

0:00:00:25.554 cpu1:1036)Mod: 1436: Initialization for deltadisk succeeded with module ID 13.

0:00:00:25.554 cpu1:1036)deltadisk loaded successfully.

0:00:00:25.559 cpu1:1036)Mod: 1445: modLoaderHeap avail after: 7810248

0:00:00:25.559 cpu1:1036)Mod: 1473: no private ID set

0:00:00:26.143 cpu1:1036)Config: 414: "BootProgress" = 0, Old Value: 0, (Status: 0x0)

0:00:00:27.202 cpu0:1024)Tcpip_Support: 2823: add dstAddr=0xfea9, netMask=0xffff, gwAddr=0x0 ifName=0x0, ifNameLen=0

0:00:00:27.202 cpu0:1024)Tcpip: 3172: change route failed

0:00:00:27.303 cpu1:1036)Net: 1362: Enabling NIC in the shadow vmkernel tcpip stack

0:00:00:27.303 cpu1:1036)Tcpip: 3008: Opening COSSharedPort port = 0x5381500

0:00:00:27.303 cpu1:1036)Tcpip_Support: 3304: No NIC support for TSO

0:00:00:27.303 cpu1:1036)Tcpip_Support: 3311: No NIC support for checksum offloading

0:00:00:27.303 cpu1:1036)Tcpip_Support: 3317: No NIC support for Scatter-Gather DMA

0:00:00:27.303 cpu1:1036)Tcpip_Support: 3367: ether attach complete

0:00:00:29.307 cpu0:1024)Tcpip_Support: 2723: index = 9738048, ip_addr = 0x10ba8c0, netmask = 0xffffff

0:00:00:29.311 cpu0:1024)VMNIX: NetCos: 206: checking fea9,ffff,0

0:00:00:29.311 cpu0:1024)Tcpip_Support: 2823: add dstAddr=0x0, netMask=0x0, gwAddr=0xa0ba8c0 ifName=0x0, ifNameLen=0

0:00:00:29.314 cpu0:1024)VMNIX: NetCos: 206: checking fea9,ffff,0

0:00:00:29.314 cpu0:1024)VMNIX: NetCos: 208: dup

0:00:00:29.314 cpu0:1024)Tcpip_Support: 2823: add dstAddr=0xfea9, netMask=0xffff, gwAddr=0x0 ifName=0x0, ifNameLen=0

0:00:00:30.165 cpu0:1024)Loading module vmfs2 ...

0:00:00:30.165 cpu0:1024)Mod: 936: Starting load for module: vmfs2 R/O length: 0x10000 R/W length: 0x11000 Md5sum: 9e3e69839928809d4489edad8138201c

0:00:00:30.255 cpu1:1037)Mod: 1373: Module vmfs2: initFunc: 0x9b3cb8 text: 0x9a6000 data: 0x290ee40 bss: 0x290efa0 (writeable align 32)

0:00:00:30.255 cpu1:1037)Mod: 1389: modLoaderHeap avail before: 7810248

0:00:00:30.255 cpu1:1037)FSS: 307: Registered fs vmfs2, module 14, fsTypeNum 0xf520

0:00:00:30.634 cpu1:1037)Mod: 1436: Initialization for vmfs2 succeeded with module ID 14.

0:00:00:30.634 cpu1:1037)vmfs2 loaded successfully.

0:00:00:30.634 cpu1:1037)Mod: 1445: modLoaderHeap avail after: 7810248

0:00:00:30.634 cpu1:1037)Mod: 1473: no private ID set

0:00:01:16.668 cpu1:1036)World: vm 1069: 895: Starting world vmware-vmkauthd with flags 4

0:00:01:36.589 cpu1:1062)LinSCSI: 3201: Abort failed for cmd with serial=71, status=bad0001, retval=bad0001

0:00:02:09.553 cpu1:1062)LinSCSI: 3201: Abort failed for cmd with serial=70, status=bad0001, retval=bad0001

0:00:02:16.591 cpu1:1062)LinSCSI: 3201: Abort failed for cmd with serial=71, status=bad0001, retval=bad0001

[31;1m0:00:02:25.285 cpu1:1025)ALERT: Heartbeat: 470: PCPU 0 didn't have a heartbeat for 62 seconds. may be locked up [0m

[31;1m0:00:02:25.285 cpu0:1037)ALERT: NMI: 1625: Faulting eip:esp [0m

0:00:02:25.285 cpu0:1037)0x3a37d10:[0x63fa9b]Util_Udelay+0x5a stack: 0x5, 0x8a86a5, 0x4020

0:00:02:25.285 cpu0:1037)0x3e641088:[0x8a86b4]aacraid_esx30+0x76b3 stack: 0x0, 0x0, 0x0

0:00:02:49.555 cpu1:1062)LinSCSI: 3201: Abort failed for cmd with serial=70, status=bad0001, retval=bad0001

0:00:02:56.593 cpu1:1062)LinSCSI: 3201: Abort failed for cmd with serial=71, status=bad0001, retval=bad0001

0:00:03:29.557 cpu1:1062)LinSCSI: 3201: Abort failed for cmd with serial=70, status=bad0001, retval=bad0001

0:00:03:36.595 cpu1:1062)LinSCSI: 3201: Abort failed for cmd with serial=71, status=bad0001, retval=bad0001

0:00:04:09.559 cpu1:1062)LinSCSI: 3201: Abort failed for cmd with serial=70, status=bad0001, retval=bad0001

0:00:04:16.597 cpu1:1062)LinSCSI: 3201: Abort failed for cmd with serial=71, status=bad0001, retval=bad0001

[31;1m0:00:04:25.285 cpu1:1025)ALERT: Heartbeat: 470: PCPU 0 didn't have a heartbeat for 182 seconds. may be locked up [0m

[31;1m0:00:04:25.285 cpu0:1037)ALERT: NMI: 1625: Faulting eip:esp [0m

0:00:04:25.285 cpu0:1037)0x3a37d10:[0x63fa9b]Util_Udelay+0x5a stack: 0x5, 0x8a86a5, 0x4020

0:00:04:25.285 cpu0:1037)0x3e641088:[0x8a86b4]aacraid_esx30+0x76b3 stack: 0x0, 0x0, 0x0

0:00:04:32.151 cpu0:1037)<3>aacraid: aac_fib_send: first asynchronous command timed out.

Usually a result of a PCI interrupt routing problem;

update mother board BIOS or consider utilizing one of

the SAFE mode kernel options (acpi, apic etc)

[7m0:00:04:32.152 cpu0:1037)WARNING: CpuSched: vm 1037: 8269: excessive time: deltaSec=183.085397 [0m

[7m0:00:04:32.152 cpu0:1037)WARNING: CpuSched: vm 1037: 8351: excessive time: chargeSec=183.064465 [0m

[45m [33;1mVMware ESX Server [0m

Exception type 14 in world 1024:console @ 0x8aac1f

frame=0x1402d5c ip=0x8aac1f cr2=0xffc00004 cr3=0x13401000 cr4=0x6f0

es=0x4028 ds=0x4028 fs=0x0 gs=0x1480000

eax=0x0 ebx=0x3e6015f8 ecx=0x3e601728 edx=0x0

ebp=0x2832680 esi=0x6b03800 edi=0x0 err=2 eflags=0x10046

*0:1024/console 1:1025/idle1 2:1026/idle2 3:1027/idle3

@BlueScreen: Exception type 14 in world 1024:console @ 0x8aac1f

0x2832680:[0x8aac1f]aacraid_esx30+0x9c1e stack: 0x0, 0x0, 0x0

VMK uptime: 0:00:04:32.153 TSC: 653107148892

0:00:02:25.285 cpu0:1037)NMI: 1625: Faulting eip:esp

0:00:04:25.285 cpu1:1025)Heartbeat: 470: PCPU 0 didn't have a heartbeat for 182 seconds. may be locked up

0:00:04:25.285 cpu0:1037)NMI: 1625: Faulting eip:esp

Starting coredump to disk Starting coredump to disk Dumping using slot 1 of 1... using slot 1 of 1... log

sonicsw · ‎02-22-2008

a small info:

Usually a result of a PCI interrupt routing problem;

update mother board BIOS or consider utilizing one of

the SAFE mode kernel options (acpi, apic etc)

I had the bios on witch is new, rolled mack on witch is running on all my other ESX

S3000AH .44 - Fail

S3000AH .46 - Fail

same symtoms

IRQ2006 · ‎02-22-2008

I am not good in reading Vmware logs, but for a for a recycled servers the following might help you eleminate the cause

- Update the BIOS

- Disconnect any additional cards such as NICs, HBAs etc prior to install ESX

- Use only same type of memory

- Compare BIOS setting with the other identical running machine

Good Luck

sonicsw · ‎02-22-2008

Not bringing me realy foward, but thx for our participation.

now he is up for 6h coz i have nothign running and not touched any VI Client

Goliath222 · ‎05-08-2008

Hi,

I'm having a similar problem with one of our ESX 3.5 Server's running on SUN X4200 M2. Server suddenly ended in POSD an Monday. As long as no VM's running on the host everything is fine, only thing I'm getting during boot in the vmkwarning log is this here :

May 8 11:41:51 TDN3T03VMS0L vmkernel: 0:00:00:02.403 cpu0:1024)WARNING: VMKAcpi: 291: Interrupt (0) from _CRS is not one of _PRS values

May 8 11:41:51 TDN3T03VMS0L vmkernel: 0:00:00:02.403 cpu0:1024)WARNING: VMKAcpi: 399: IRQ from _CRS is bad or not in _PRS, will use from _PRS

May 8 11:41:51 TDN3T03VMS0L vmkernel: 0:00:00:02.403 cpu0:1024)WARNING: VMKAcpi: 291: Interrupt (11) from _CRS is not one of _PRS values

May 8 11:41:51 TDN3T03VMS0L vmkernel: 0:00:00:02.403 cpu0:1024)WARNING: VMKAcpi: 399: IRQ from _CRS is bad or not in _PRS, will use from _PRS

May 8 11:41:51 TDN3T03VMS0L vmkernel: 0:00:00:02.403 cpu0:1024)WARNING: VMKAcpi: 291: Interrupt (5) from _CRS is not one of _PRS values

May 8 11:41:51 TDN3T03VMS0L vmkernel: 0:00:00:02.403 cpu0:1024)WARNING: VMKAcpi: 399: IRQ from _CRS is bad or not in _PRS, will use from _PRS

May 8 11:41:51 TDN3T03VMS0L vmkernel: 0:00:00:02.404 cpu0:1024)WARNING: VMKAcpi: 291: Interrupt (15) from _CRS is not one of _PRS values

May 8 11:41:51 TDN3T03VMS0L vmkernel: 0:00:00:02.404 cpu0:1024)WARNING: VMKAcpi: 399: IRQ from _CRS is bad or not in _PRS, will use from _PRS

May 8 11:41:51 TDN3T03VMS0L vmkernel: 0:00:00:02.404 cpu0:1024)WARNING: VMKAcpi: 291: Interrupt (0) from _CRS is not one of _PRS values

May 8 11:41:51 TDN3T03VMS0L vmkernel: 0:00:00:02.404 cpu0:1024)WARNING: VMKAcpi: 399: IRQ from _CRS is bad or not in _PRS, will use from _PRS

May 8 11:41:51 TDN3T03VMS0L vmkernel: 0:00:00:02.404 cpu0:1024)WARNING: VMKAcpi: 291: Interrupt (0) from _CRS is not one of _PRS values

May 8 11:41:52 TDN3T03VMS0L vmkernel: 0:00:00:02.404 cpu0:1024)WARNING: VMKAcpi: 399: IRQ from _CRS is bad or not in _PRS, will use from _PRS

May 8 11:41:52 TDN3T03VMS0L vmkernel: 0:00:00:02.405 cpu0:1024)WARNING: VMKAcpi: 291: Interrupt (0) from _CRS is not one of _PRS values

May 8 11:41:52 TDN3T03VMS0L vmkernel: 0:00:00:02.405 cpu0:1024)WARNING: VMKAcpi: 399: IRQ from _CRS is bad or not in _PRS, will use from _PRS

May 8 11:41:52 TDN3T03VMS0L vmkernel: 0:00:00:02.405 cpu0:1024)WARNING: VMKAcpi: 291: Interrupt (0) from _CRS is not one of _PRS values

May 8 11:41:52 TDN3T03VMS0L vmkernel: 0:00:00:02.405 cpu0:1024)WARNING: VMKAcpi: 399: IRQ from _CRS is bad or not in _PRS, will use from _PRS

Once I power up some maschines on the server it takes between 1 hour and a day the server goes back into POSD. I opened a support case with VMware, they are assuming a hardware problem. Right now I also opened a case with SUN to change the Motherboard.

Never saw thiis message before on any of the other ESX Servers and we are using arround 10 servers on this Hardware. Also reinstalled the ESX, but behaviour is the same...

Texiwill · ‎05-08-2008

Hello,

I would suggest you contact your VMware Support Representative for this one. However, most crashes are due to hardware more than anything else. I would do the following:

1) Upgrade any BIOS

2) Reseat any cards

3) Run Vendor HW Diags for at least 48 hours

4) Run memtest86+ for at least 48 hours

If you still fail after that and no problems show up open a Support Case.

Best regards,

Edward L. Haletky

VMware Communities User Moderator

====

Author of the book 'VMWare ESX Server in the Enterprise: Planning and Securing Virtualization Servers', Copyright 2008 Pearson Education. As well as the Virtualization Wiki at http://www.astroarch.com/wiki/index.php/Virtualization

--
Edward L. Haletky
vExpert XIV: 2009-2023,
VMTN Community Moderator
vSphere Upgrade Saga: https://www.astroarch.com/blogs
GitHub Repo: https://github.com/Texiwill

fhinokcvm · ‎06-30-2008

Goliath222, I am getting exactly the same errors. I am running the SUN x6220 Blade. I have three identical x6220 blades running ESX 3.0.2 and no problems. I am going to open a case with Vmware as well. Let me know if u find out anything.

Thanks

tasonis · ‎07-30-2008

I found a similar post with possible information that may help. Indeed, a BIOS update may fix the problem (notice the PCPU 0 didn't have a heartbeat message in your log). I'd also check any other firmwares that can be applied, e.g. SCSI, Embedded Server Management, etc. Good Luck! Or try swapping out PCPU 0 with one of your other machines (if thats possible).

Here is the post... http://communities.vmware.com/thread/101997

All

ESx 3.5 Crash new maschine, HW replaced still the same