Attachment 189559 Details for Bug 215972 – ktr capture of the problem

ktr capture of the problem

bhyve-hang.ktrdump.redacted.txt (text/plain), 67.65 KB, created by Andriy Gapon on 2018-01-09 09:34:12 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Andriy Gapon

Created: 2018-01-09 09:34:12 UTC

Size: 67.65 KB

patch

obsolete

>4500819   1 7247346078346917 vm l2arc-test[1]: icrlo 0x00000000000040f5 triggered ipi 245
>4500820   1 7247346078347677 vm l2arc-test[0]: vlapic_set_intr_ready irr0 0x00000000
>4500821   1 7247346078347883 vm l2arc-test[0]: vlapic_set_intr_ready irr1 0x00000000
>4500822   1 7247346078348083 vm l2arc-test[0]: vlapic_set_intr_ready irr2 0x00000000
>4500823   1 7247346078348280 vm l2arc-test[0]: vlapic_set_intr_ready irr3 0x00000000
>4500824   1 7247346078348486 vm l2arc-test[0]: vlapic_set_intr_ready irr4 0x00000000
>4500825   1 7247346078348686 vm l2arc-test[0]: vlapic_set_intr_ready irr5 0x00000000
>4500826   1 7247346078348886 vm l2arc-test[0]: vlapic_set_intr_ready irr6 0x00000000
>4500827   1 7247346078349085 vm l2arc-test[0]: vlapic_set_intr_ready irr7 0x00200000
>4500828   1 7247346078350512 vm l2arc-test[1]: vlapic sending ipi 245 to vcpuid 0
>4500829   1 7247346078351586 vm l2arc-test[1]: vcpu state changed from frozen to running
>4500830   1 7247346078352125 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d38/0xffffffff80946d3c
>4500831   0 7247346078352853 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d4660/0
>4500832   1 7247346078353317 vm l2arc-test[1]: vmcb clean 0x3bf
>4500833   1 7247346078353538 vm l2arc-test[1]: Resume execution at 0xffffffff80946d3c
>4500834   0 7247346078353982 vm l2arc-test[0]: pending intr 245
>4500835   0 7247346078354336 vm l2arc-test[0]: Injecting vector 245 using V_IRQ
>4500836   0 7247346078354877 vm l2arc-test[0]: vmcb clean 0x3b7
>4500837   0 7247346078355096 vm l2arc-test[0]: Resume execution at 0xffffffff806d4660
>4500838   0 7247346078363027 vm l2arc-test[0]: v_intr_vector 245 accepted
>4500839   0 7247346078363546 vm l2arc-test[0]: vlapic_intr_accepted irr0 0x00000000
>4500840   0 7247346078363755 vm l2arc-test[0]: vlapic_intr_accepted irr1 0x00000000
>4500841   0 7247346078363958 vm l2arc-test[0]: vlapic_intr_accepted irr2 0x00000000
>4500842   0 7247346078364162 vm l2arc-test[0]: vlapic_intr_accepted irr3 0x00000000
>4500843   0 7247346078364386 vm l2arc-test[0]: vlapic_intr_accepted irr4 0x00000000
>4500844   0 7247346078364614 vm l2arc-test[0]: vlapic_intr_accepted irr5 0x00000000
>4500845   0 7247346078364862 vm l2arc-test[0]: vlapic_intr_accepted irr6 0x00000000
>4500846   0 7247346078365066 vm l2arc-test[0]: vlapic_intr_accepted irr7 0x00000000
>4500847   0 7247346078365267 vm l2arc-test[0]: vlapic_intr_accepted isr0 0x00000000
>4500848   0 7247346078365475 vm l2arc-test[0]: vlapic_intr_accepted isr1 0x00000000
>4500849   0 7247346078365674 vm l2arc-test[0]: vlapic_intr_accepted isr2 0x00000000
>4500850   0 7247346078365874 vm l2arc-test[0]: vlapic_intr_accepted isr3 0x00000000
>4500851   0 7247346078366074 vm l2arc-test[0]: vlapic_intr_accepted isr4 0x00000000
>4500852   0 7247346078366272 vm l2arc-test[0]: vlapic_intr_accepted isr5 0x00000000
>4500853   0 7247346078366614 vm l2arc-test[0]: vlapic_intr_accepted isr6 0x00000000
>4500854   0 7247346078367192 vm l2arc-test[0]: vlapic_intr_accepted isr7 0x00200000
>4500855   1 7247346078368013 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000004 at rip 0xffffffff80946d76
>4500856   1 7247346078368486 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4500857   0 7247346078369315 vm l2arc-test[0]: vlapic_update_ppr 0xf0
>4500858   1 7247346078370032 vm l2arc-test[1]: vcpu state changed from running to frozen
>4500859   0 7247346078371037 vm l2arc-test[0]: inst_emul fault for gpa 0xfee000b0/0x100000006 at rip 0xffffffff808e34b2
>4500860   1 7247346078371496 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4500861   0 7247346078371909 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff808e34b2/0
>4500862   0 7247346078373210 vm l2arc-test[0]: vcpu state changed from running to frozen
>4500863   0 7247346078374456 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfee000b0
>4500864   1 7247346078384013 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4500865   1 7247346078384630 vm l2arc-test[1]: vlapic read offset 0x300, data 0x40f5
>4500866   1 7247346078386134 vm l2arc-test[1]: vcpu state changed from frozen to running
>4500867   1 7247346078386837 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4500868   1 7247346078387861 vm l2arc-test[1]: vmcb clean 0x3bf
>4500869   1 7247346078388251 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4500870   0 7247346078389125 vm l2arc-test[0]: nextrip updated to 0xffffffff808e34bc after instruction decoding
>4500871   0 7247346078389504 vm l2arc-test[0]: vlapic write offset 0xb0, data 0
>4500872   0 7247346078389760 vm l2arc-test[0]: EOI vector 245
>4500873   0 7247346078390011 vm l2arc-test[0]: vlapic_process_eoi isr0 0x00000000
>4500874   0 7247346078390219 vm l2arc-test[0]: vlapic_process_eoi isr1 0x00000000
>4500875   0 7247346078390429 vm l2arc-test[0]: vlapic_process_eoi isr2 0x00000000
>4500876   0 7247346078390638 vm l2arc-test[0]: vlapic_process_eoi isr3 0x00000000
>4500877   0 7247346078390854 vm l2arc-test[0]: vlapic_process_eoi isr4 0x00000000
>4500878   0 7247346078391064 vm l2arc-test[0]: vlapic_process_eoi isr5 0x00000000
>4500879   0 7247346078391275 vm l2arc-test[0]: vlapic_process_eoi isr6 0x00000000
>4500880   0 7247346078391491 vm l2arc-test[0]: vlapic_process_eoi isr7 0x00000000
>4500881   1 7247346078392464 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00310/0x100000004 at rip 0xffffffff80946d76
>4500882   1 7247346078392832 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4500883   0 7247346078393618 vm l2arc-test[0]: vlapic_update_ppr 0x00
>4500884   1 7247346078394213 vm l2arc-test[1]: vcpu state changed from running to frozen
>4500885   0 7247346078395187 vm l2arc-test[0]: vcpu state changed from frozen to running
>4500886   1 7247346078395528 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00310
>4500887   0 7247346078396402 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff808e34b2/0xffffffff808e34bc
>4500888   0 7247346078396986 vm l2arc-test[0]: Clearing V_IRQ interrupt injection
>4500889   0 7247346078397901 vm l2arc-test[0]: vmcb clean 0x3b7
>4500890   0 7247346078398117 vm l2arc-test[0]: Resume execution at 0xffffffff808e34bc
>4500891   1 7247346078405328 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4500892   1 7247346078405798 vm l2arc-test[1]: vlapic read offset 0x310, data 0
>4500893   1 7247346078406894 vm l2arc-test[1]: vcpu state changed from frozen to running
>4500894   1 7247346078407429 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4500895   1 7247346078408125 vm l2arc-test[1]: vmcb clean 0x3bf
>4500896   1 7247346078408342 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4500897   1 7247346078411658 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000004 at rip 0xffffffff80946d76
>4500898   1 7247346078411870 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4500899   1 7247346078413008 vm l2arc-test[1]: vcpu state changed from running to frozen
>4500900   1 7247346078413931 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4500901   1 7247346078421486 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4500902   1 7247346078421834 vm l2arc-test[1]: vlapic read offset 0x300, data 0x40f5
>4500903   1 7247346078422970 vm l2arc-test[1]: vcpu state changed from frozen to running
>4500904   1 7247346078423510 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4500905   1 7247346078424206 vm l2arc-test[1]: vmcb clean 0x3bf
>4500906   1 7247346078424419 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4500907   1 7247346078427970 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00310/0x100000006 at rip 0xffffffff80946d38
>4500908   1 7247346078428186 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d38/0
>4500909   1 7247346078429158 vm l2arc-test[1]: vcpu state changed from running to frozen
>4500910   1 7247346078429933 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00310
>4500911   1 7247346078437547 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d3c after instruction decoding
>4500912   1 7247346078438043 vm l2arc-test[1]: vlapic write offset 0x310, data 0
>4500913   1 7247346078439034 vm l2arc-test[1]: vcpu state changed from frozen to running
>4500914   1 7247346078439566 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d38/0xffffffff80946d3c
>4500915   1 7247346078440262 vm l2arc-test[1]: vmcb clean 0x3bf
>4500916   1 7247346078440474 vm l2arc-test[1]: Resume execution at 0xffffffff80946d3c
>4500917   1 7247346078443843 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000006 at rip 0xffffffff80946d38
>4500918   1 7247346078444058 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d38/0
>4500919   1 7247346078445061 vm l2arc-test[1]: vcpu state changed from running to frozen
>4500920   1 7247346078445834 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4500921   1 7247346078453382 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d3c after instruction decoding
>4500922   1 7247346078453821 vm l2arc-test[1]: vlapic write offset 0x300, data 0x40f5
>4500923   1 7247346078454088 vm l2arc-test[1]: icrlo 0x00000000000040f5 triggered ipi 245
>4500924   1 7247346078454842 vm l2arc-test[0]: vlapic_set_intr_ready irr0 0x00000000
>4500925   1 7247346078455048 vm l2arc-test[0]: vlapic_set_intr_ready irr1 0x00000000
>4500926   1 7247346078455246 vm l2arc-test[0]: vlapic_set_intr_ready irr2 0x00000000
>4500927   1 7247346078455443 vm l2arc-test[0]: vlapic_set_intr_ready irr3 0x00000000
>4500928   1 7247346078455650 vm l2arc-test[0]: vlapic_set_intr_ready irr4 0x00000000
>4500929   1 7247346078455848 vm l2arc-test[0]: vlapic_set_intr_ready irr5 0x00000000
>4500930   1 7247346078456386 vm l2arc-test[0]: vlapic_set_intr_ready irr6 0x00000000
>4500931   1 7247346078456589 vm l2arc-test[0]: vlapic_set_intr_ready irr7 0x00200000
>4500932   1 7247346078458021 vm l2arc-test[1]: vlapic sending ipi 245 to vcpuid 0
>4500933   1 7247346078459099 vm l2arc-test[1]: vcpu state changed from frozen to running
>4500934   1 7247346078459637 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d38/0xffffffff80946d3c
>4500935   0 7247346078460365 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d46b7/0
>4500936   1 7247346078460848 vm l2arc-test[1]: vmcb clean 0x3bf
>4500937   1 7247346078461069 vm l2arc-test[1]: Resume execution at 0xffffffff80946d3c
>4500938   0 7247346078461515 vm l2arc-test[0]: pending intr 245
>4500939   0 7247346078461850 vm l2arc-test[0]: Injecting vector 245 using V_IRQ
>4500940   0 7247346078462390 vm l2arc-test[0]: vmcb clean 0x3b7
>4500941   0 7247346078462611 vm l2arc-test[0]: Resume execution at 0xffffffff806d46b7
>4500942   0 7247346078469301 vm l2arc-test[0]: v_intr_vector 245 accepted
>4500943   0 7247346078469805 vm l2arc-test[0]: vlapic_intr_accepted irr0 0x00000000
>4500944   0 7247346078470005 vm l2arc-test[0]: vlapic_intr_accepted irr1 0x00000000
>4500945   0 7247346078470206 vm l2arc-test[0]: vlapic_intr_accepted irr2 0x00000000
>4500946   0 7247346078470618 vm l2arc-test[0]: vlapic_intr_accepted irr3 0x00000000
>4500947   0 7247346078470901 vm l2arc-test[0]: vlapic_intr_accepted irr4 0x00000000
>4500948   0 7247346078471120 vm l2arc-test[0]: vlapic_intr_accepted irr5 0x00000000
>4500949   0 7247346078471346 vm l2arc-test[0]: vlapic_intr_accepted irr6 0x00000000
>4500950   0 7247346078471555 vm l2arc-test[0]: vlapic_intr_accepted irr7 0x00000000
>4500951   0 7247346078471762 vm l2arc-test[0]: vlapic_intr_accepted isr0 0x00000000
>4500952   0 7247346078471971 vm l2arc-test[0]: vlapic_intr_accepted isr1 0x00000000
>4500953   0 7247346078472173 vm l2arc-test[0]: vlapic_intr_accepted isr2 0x00000000
>4500954   0 7247346078472376 vm l2arc-test[0]: vlapic_intr_accepted isr3 0x00000000
>4500955   0 7247346078472576 vm l2arc-test[0]: vlapic_intr_accepted isr4 0x00000000
>4500956   0 7247346078472800 vm l2arc-test[0]: vlapic_intr_accepted isr5 0x00000000
>4500957   0 7247346078473008 vm l2arc-test[0]: vlapic_intr_accepted isr6 0x00000000
>4500958   0 7247346078473216 vm l2arc-test[0]: vlapic_intr_accepted isr7 0x00200000
>4500959   1 7247346078474493 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000004 at rip 0xffffffff80946d76
>4500960   1 7247346078474950 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4500961   0 7247346078475346 vm l2arc-test[0]: vlapic_update_ppr 0xf0
>4500962   1 7247346078476419 vm l2arc-test[1]: vcpu state changed from running to frozen
>4500963   0 7247346078477160 vm l2arc-test[0]: inst_emul fault for gpa 0xfee000b0/0x100000006 at rip 0xffffffff808e34b2
>4500964   0 7247346078477813 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff808e34b2/0
>4500965   1 7247346078478104 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4500966   0 7247346078480405 vm l2arc-test[0]: vcpu state changed from running to frozen
>4500967   0 7247346078481514 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfee000b0
>4500968   1 7247346078489328 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4500969   1 7247346078489944 vm l2arc-test[1]: vlapic read offset 0x300, data 0x40f5
>4500970   1 7247346078491525 vm l2arc-test[1]: vcpu state changed from frozen to running
>4500971   1 7247346078492258 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4500972   0 7247346078535475 vm l2arc-test[0]: nextrip updated to 0xffffffff808e34bc after instruction decoding
>4500973   0 7247346078536178 vm l2arc-test[0]: vlapic write offset 0xb0, data 0
>4500974   1 7247346078536381 vm l2arc-test[1]: vmcb clean 0x3bf
>4500975   1 7247346078536922 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4500976   0 7247346078537189 vm l2arc-test[0]: EOI vector 245
>4500977   0 7247346078537454 vm l2arc-test[0]: vlapic_process_eoi isr0 0x00000000
>4500978   0 7247346078538182 vm l2arc-test[0]: vlapic_process_eoi isr1 0x00000000
>4500979   0 7247346078538374 vm l2arc-test[0]: vlapic_process_eoi isr2 0x00000000
>4500980   0 7247346078538570 vm l2arc-test[0]: vlapic_process_eoi isr3 0x00000000
>4500981   0 7247346078538770 vm l2arc-test[0]: vlapic_process_eoi isr4 0x00000000
>4500982   0 7247346078538962 vm l2arc-test[0]: vlapic_process_eoi isr5 0x00000000
>4500983   0 7247346078539154 vm l2arc-test[0]: vlapic_process_eoi isr6 0x00000000
>4500984   0 7247346078539352 vm l2arc-test[0]: vlapic_process_eoi isr7 0x00000000
>4500985   1 7247346078541173 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00310/0x100000004 at rip 0xffffffff80946d76
>4500986   0 7247346078541722 vm l2arc-test[0]: vlapic_update_ppr 0x00
>4500987   1 7247346078541966 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4500988   1 7247346078543293 vm l2arc-test[1]: vcpu state changed from running to frozen
>4500989   0 7247346078543654 vm l2arc-test[0]: vcpu state changed from frozen to running
>4500990   1 7247346078544405 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00310
>4500991   0 7247346078544718 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff808e34b2/0xffffffff808e34bc
>4500992   0 7247346078545254 vm l2arc-test[0]: Clearing V_IRQ interrupt injection
>4500993   0 7247346078546147 vm l2arc-test[0]: vmcb clean 0x3b7
>4500994   0 7247346078546616 vm l2arc-test[0]: Resume execution at 0xffffffff808e34bc
>4500995   1 7247346078553635 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4500996   1 7247346078554146 vm l2arc-test[1]: vlapic read offset 0x310, data 0
>4500997   1 7247346078555301 vm l2arc-test[1]: vcpu state changed from frozen to running
>4500998   1 7247346078555779 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4500999   1 7247346078556402 vm l2arc-test[1]: vmcb clean 0x3bf
>4501000   1 7247346078556602 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4501001   1 7247346078559966 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000004 at rip 0xffffffff80946d76
>4501002   1 7247346078560162 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4501003   1 7247346078561074 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501004   1 7247346078561762 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4501005   1 7247346078568498 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4501006   1 7247346078568806 vm l2arc-test[1]: vlapic read offset 0x300, data 0x40f5
>4501007   1 7247346078569870 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501008   1 7247346078570355 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4501009   1 7247346078570978 vm l2arc-test[1]: vmcb clean 0x3bf
>4501010   1 7247346078571171 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4501011   1 7247346078574384 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00310/0x100000006 at rip 0xffffffff80946d38
>4501012   1 7247346078574579 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d38/0
>4501013   1 7247346078575458 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501014   1 7247346078576154 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00310
>4501015   1 7247346078582998 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d3c after instruction decoding
>4501016   1 7247346078583443 vm l2arc-test[1]: vlapic write offset 0x310, data 0
>4501017   1 7247346078584344 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501018   1 7247346078584822 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d38/0xffffffff80946d3c
>4501019   1 7247346078585459 vm l2arc-test[1]: vmcb clean 0x3bf
>4501020   1 7247346078585653 vm l2arc-test[1]: Resume execution at 0xffffffff80946d3c
>4501021   1 7247346078588699 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000006 at rip 0xffffffff80946d38
>4501022   1 7247346078588899 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d38/0
>4501023   1 7247346078589802 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501024   1 7247346078590498 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4501025   1 7247346078597214 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d3c after instruction decoding
>4501026   1 7247346078597608 vm l2arc-test[1]: vlapic write offset 0x300, data 0x40f5
>4501027   1 7247346078597850 vm l2arc-test[1]: icrlo 0x00000000000040f5 triggered ipi 245
>4501028   1 7247346078598405 vm l2arc-test[0]: vlapic_set_intr_ready irr0 0x00000000
>4501029   1 7247346078598597 vm l2arc-test[0]: vlapic_set_intr_ready irr1 0x00000000
>4501030   1 7247346078598779 vm l2arc-test[0]: vlapic_set_intr_ready irr2 0x00000000
>4501031   1 7247346078598960 vm l2arc-test[0]: vlapic_set_intr_ready irr3 0x00000000
>4501032   1 7247346078599149 vm l2arc-test[0]: vlapic_set_intr_ready irr4 0x00000000
>4501033   1 7247346078599330 vm l2arc-test[0]: vlapic_set_intr_ready irr5 0x00000000
>4501034   1 7247346078599510 vm l2arc-test[0]: vlapic_set_intr_ready irr6 0x00000000
>4501035   1 7247346078599706 vm l2arc-test[0]: vlapic_set_intr_ready irr7 0x00200000
>4501036   1 7247346078601048 vm l2arc-test[1]: vlapic sending ipi 245 to vcpuid 0
>4501037   1 7247346078602006 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501038   1 7247346078602488 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d38/0xffffffff80946d3c
>4501039   0 7247346078603363 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d46b6/0
>4501040   1 7247346078604027 vm l2arc-test[1]: vmcb clean 0x3bf
>4501041   1 7247346078605283 vm l2arc-test[1]: Resume execution at 0xffffffff80946d3c
>4501042   0 7247346078605523 vm l2arc-test[0]: pending intr 245
>4501043   0 7247346078605907 vm l2arc-test[0]: Injecting vector 245 using V_IRQ
>4501044   0 7247346078606400 vm l2arc-test[0]: vmcb clean 0x3b7
>4501045   0 7247346078607056 vm l2arc-test[0]: Resume execution at 0xffffffff806d46b6
>4501046   0 7247346078613043 vm l2arc-test[0]: v_intr_vector 245 accepted
>4501047   0 7247346078613474 vm l2arc-test[0]: vlapic_intr_accepted irr0 0x00000000
>4501048   0 7247346078613701 vm l2arc-test[0]: vlapic_intr_accepted irr1 0x00000000
>4501049   0 7247346078613883 vm l2arc-test[0]: vlapic_intr_accepted irr2 0x00000000
>4501050   0 7247346078614066 vm l2arc-test[0]: vlapic_intr_accepted irr3 0x00000000
>4501051   0 7247346078614266 vm l2arc-test[0]: vlapic_intr_accepted irr4 0x00000000
>4501052   0 7247346078614464 vm l2arc-test[0]: vlapic_intr_accepted irr5 0x00000000
>4501053   0 7247346078614656 vm l2arc-test[0]: vlapic_intr_accepted irr6 0x00000000
>4501054   0 7247346078614840 vm l2arc-test[0]: vlapic_intr_accepted irr7 0x00000000
>4501055   0 7247346078615026 vm l2arc-test[0]: vlapic_intr_accepted isr0 0x00000000
>4501056   0 7247346078615218 vm l2arc-test[0]: vlapic_intr_accepted isr1 0x00000000
>4501057   0 7247346078615400 vm l2arc-test[0]: vlapic_intr_accepted isr2 0x00000000
>4501058   0 7247346078615584 vm l2arc-test[0]: vlapic_intr_accepted isr3 0x00000000
>4501059   0 7247346078615837 vm l2arc-test[0]: vlapic_intr_accepted isr4 0x00000000
>4501060   0 7247346078616037 vm l2arc-test[0]: vlapic_intr_accepted isr5 0x00000000
>4501061   0 7247346078616227 vm l2arc-test[0]: vlapic_intr_accepted isr6 0x00000000
>4501062   0 7247346078616411 vm l2arc-test[0]: vlapic_intr_accepted isr7 0x00200000
>4501063   1 7247346078617560 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000004 at rip 0xffffffff80946d76
>4501064   1 7247346078617846 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4501065   0 7247346078618382 vm l2arc-test[0]: vlapic_update_ppr 0xf0
>4501066   1 7247346078619206 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501067   0 7247346078620046 vm l2arc-test[0]: inst_emul fault for gpa 0xfee000b0/0x100000006 at rip 0xffffffff808e34b2
>4501068   0 7247346078620616 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff808e34b2/0
>4501069   1 7247346078620840 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4501070   0 7247346078621954 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501071   0 7247346078623234 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfee000b0
>4501072   1 7247346078633102 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4501073   1 7247346078633674 vm l2arc-test[1]: vlapic read offset 0x300, data 0x40f5
>4501074   1 7247346078635090 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501075   1 7247346078635731 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4501076   1 7247346078636651 vm l2arc-test[1]: vmcb clean 0x3bf
>4501077   1 7247346078636856 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4501078   0 7247346078637614 vm l2arc-test[0]: nextrip updated to 0xffffffff808e34bc after instruction decoding
>4501079   0 7247346078637995 vm l2arc-test[0]: vlapic write offset 0xb0, data 0
>4501080   0 7247346078638229 vm l2arc-test[0]: EOI vector 245
>4501081   0 7247346078638418 vm l2arc-test[0]: vlapic_process_eoi isr0 0x00000000
>4501082   0 7247346078638608 vm l2arc-test[0]: vlapic_process_eoi isr1 0x00000000
>4501083   0 7247346078638797 vm l2arc-test[0]: vlapic_process_eoi isr2 0x00000000
>4501084   0 7247346078638987 vm l2arc-test[0]: vlapic_process_eoi isr3 0x00000000
>4501085   0 7247346078639179 vm l2arc-test[0]: vlapic_process_eoi isr4 0x00000000
>4501086   0 7247346078639517 vm l2arc-test[0]: vlapic_process_eoi isr5 0x00000000
>4501087   0 7247346078639805 vm l2arc-test[0]: vlapic_process_eoi isr6 0x00000000
>4501088   0 7247346078640170 vm l2arc-test[0]: vlapic_process_eoi isr7 0x00000000
>4501089   1 7247346078640782 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00310/0x100000004 at rip 0xffffffff80946d76
>4501090   1 7247346078641184 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4501091   0 7247346078642131 vm l2arc-test[0]: vlapic_update_ppr 0x00
>4501092   1 7247346078642555 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501093   1 7247346078643626 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00310
>4501094   0 7247346078643994 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501095   0 7247346078644819 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff808e34b2/0xffffffff808e34bc
>4501096   0 7247346078645394 vm l2arc-test[0]: Clearing V_IRQ interrupt injection
>4501097   0 7247346078646139 vm l2arc-test[0]: vmcb clean 0x3b7
>4501098   0 7247346078646610 vm l2arc-test[0]: Resume execution at 0xffffffff808e34bc
>4501099   1 7247346078652626 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4501100   1 7247346078652992 vm l2arc-test[1]: vlapic read offset 0x310, data 0
>4501101   1 7247346078653979 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501102   1 7247346078654462 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4501103   1 7247346078655083 vm l2arc-test[1]: vmcb clean 0x3bf
>4501104   1 7247346078655290 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4501105   1 7247346078658760 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000004 at rip 0xffffffff80946d76
>4501106   1 7247346078658955 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4501107   1 7247346078659792 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501108   1 7247346078660482 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4501109   1 7247346078667232 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4501110   1 7247346078667542 vm l2arc-test[1]: vlapic read offset 0x300, data 0x40f5
>4501111   1 7247346078668562 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501112   1 7247346078669046 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4501113   1 7247346078669669 vm l2arc-test[1]: vmcb clean 0x3bf
>4501114   1 7247346078669862 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4501115   1 7247346078672965 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00310/0x100000006 at rip 0xffffffff80946d38
>4501116   1 7247346078673163 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d38/0
>4501117   1 7247346078674038 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501118   1 7247346078674738 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00310
>4501119   1 7247346078681578 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d3c after instruction decoding
>4501120   1 7247346078682019 vm l2arc-test[1]: vlapic write offset 0x310, data 0
>4501121   1 7247346078682907 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501122   1 7247346078683386 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d38/0xffffffff80946d3c
>4501123   1 7247346078684008 vm l2arc-test[1]: vmcb clean 0x3bf
>4501124   1 7247346078684200 vm l2arc-test[1]: Resume execution at 0xffffffff80946d3c
>4501125   1 7247346078687267 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000006 at rip 0xffffffff80946d38
>4501126   1 7247346078687462 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d38/0
>4501127   1 7247346078688374 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501128   1 7247346078689069 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4501129   1 7247346078695784 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d3c after instruction decoding
>4501130   1 7247346078696171 vm l2arc-test[1]: vlapic write offset 0x300, data 0x40f5
>4501131   1 7247346078696408 vm l2arc-test[1]: icrlo 0x00000000000040f5 triggered ipi 245
>4501132   1 7247346078697483 vm l2arc-test[0]: vlapic_set_intr_ready irr0 0x00000000
>4501133   1 7247346078697778 vm l2arc-test[0]: vlapic_set_intr_ready irr1 0x00000000
>4501134   1 7247346078697982 vm l2arc-test[0]: vlapic_set_intr_ready irr2 0x00000000
>4501135   1 7247346078698163 vm l2arc-test[0]: vlapic_set_intr_ready irr3 0x00000000
>4501136   1 7247346078698355 vm l2arc-test[0]: vlapic_set_intr_ready irr4 0x00000000
>4501137   1 7247346078698541 vm l2arc-test[0]: vlapic_set_intr_ready irr5 0x00000000
>4501138   1 7247346078698722 vm l2arc-test[0]: vlapic_set_intr_ready irr6 0x00000000
>4501139   1 7247346078699104 vm l2arc-test[0]: vlapic_set_intr_ready irr7 0x00200000
>4501140   1 7247346078700590 vm l2arc-test[1]: vlapic sending ipi 245 to vcpuid 0
>4501141   1 7247346078701714 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501142   1 7247346078702198 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d38/0xffffffff80946d3c
>4501143   0 7247346078702741 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d4665/0
>4501144   1 7247346078703326 vm l2arc-test[1]: vmcb clean 0x3bf
>4501145   1 7247346078703750 vm l2arc-test[1]: Resume execution at 0xffffffff80946d3c
>4501146   0 7247346078704013 vm l2arc-test[0]: pending intr 245
>4501147   0 7247346078704482 vm l2arc-test[0]: Injecting vector 245 using V_IRQ
>4501148   0 7247346078704995 vm l2arc-test[0]: vmcb clean 0x3b7
>4501149   0 7247346078705197 vm l2arc-test[0]: Resume execution at 0xffffffff806d4665
>4501150   1 7247346078716870 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000004 at rip 0xffffffff80946d76
>4501151   1 7247346078717504 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4501152   1 7247346078718435 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501153   1 7247346078719322 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4501154   1 7247346078726488 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4501155   1 7247346078726899 vm l2arc-test[1]: vlapic read offset 0x300, data 0x40f5
>4501156   1 7247346078727934 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501157   1 7247346078728570 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4501158   1 7247346078730146 vm l2arc-test[1]: vmcb clean 0x3bf
>4501159   1 7247346078730347 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4501160   1 7247346078733706 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00310/0x100000004 at rip 0xffffffff80946d76
>4501161   1 7247346078734098 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4501162   1 7247346078735160 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501163   1 7247346078736034 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00310
>4501164   1 7247346078742778 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4501165   1 7247346078743106 vm l2arc-test[1]: vlapic read offset 0x310, data 0
>4501166   1 7247346078744080 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501167   1 7247346078744558 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4501168   1 7247346078745189 vm l2arc-test[1]: vmcb clean 0x3bf
>4501169   1 7247346078745382 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4501170   1 7247346078755611 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000004 at rip 0xffffffff80946d76
>4501171   1 7247346078755818 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d76/0
>4501172   1 7247346078756771 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501173   1 7247346078757467 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4501174   1 7247346078764186 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d79 after instruction decoding
>4501175   1 7247346078764496 vm l2arc-test[1]: vlapic read offset 0x300, data 0x40f5
>4501176   1 7247346078765507 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501177   1 7247346078765984 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d76/0xffffffff80946d79
>4501178   1 7247346078766608 vm l2arc-test[1]: vmcb clean 0x3bf
>4501179   1 7247346078767000 vm l2arc-test[1]: Resume execution at 0xffffffff80946d79
>4501180   1 7247346078770043 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00310/0x100000006 at rip 0xffffffff80946d38
>4501181   1 7247346078770251 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d38/0
>4501182   1 7247346078771210 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501183   1 7247346078771907 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00310
>4501184   1 7247346078778765 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d3c after instruction decoding
>4501185   1 7247346078779200 vm l2arc-test[1]: vlapic write offset 0x310, data 0
>4501186   1 7247346078780165 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501187   1 7247346078780768 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d38/0xffffffff80946d3c
>4501188   1 7247346078781390 vm l2arc-test[1]: vmcb clean 0x3bf
>4501189   1 7247346078781589 vm l2arc-test[1]: Resume execution at 0xffffffff80946d3c
>4501190   1 7247346078784571 vm l2arc-test[1]: inst_emul fault for gpa 0xfee00300/0x100000006 at rip 0xffffffff80946d38
>4501191   1 7247346078784768 vm l2arc-test[1]: unhandled nptfault vmexit at 0xffffffff80946d38/0
>4501192   1 7247346078785614 vm l2arc-test[1]: vcpu state changed from running to frozen
>4501193   1 7247346078786304 vm l2arc-test[1]: inst_emul fault accessing gpa 0xfee00300
>4501194   1 7247346078793021 vm l2arc-test[1]: nextrip updated to 0xffffffff80946d3c after instruction decoding
>4501195   1 7247346078793419 vm l2arc-test[1]: vlapic write offset 0x300, data 0x40f5
>4501196   1 7247346078793659 vm l2arc-test[1]: icrlo 0x00000000000040f5 triggered ipi 245
>4501197   1 7247346078794312 vm l2arc-test[0]: vlapic_set_intr_ready irr0 0x00000000
>4501198   1 7247346078794493 vm l2arc-test[0]: vlapic_set_intr_ready irr1 0x00000000
>4501199   1 7247346078794674 vm l2arc-test[0]: vlapic_set_intr_ready irr2 0x00000000
>4501200   1 7247346078794861 vm l2arc-test[0]: vlapic_set_intr_ready irr3 0x00000000
>4501201   1 7247346078795042 vm l2arc-test[0]: vlapic_set_intr_ready irr4 0x00000000
>4501202   1 7247346078795226 vm l2arc-test[0]: vlapic_set_intr_ready irr5 0x00000000
>4501203   1 7247346078795406 vm l2arc-test[0]: vlapic_set_intr_ready irr6 0x00000000
>4501204   1 7247346078795587 vm l2arc-test[0]: vlapic_set_intr_ready irr7 0x00200000
>4501205   1 7247346078796925 vm l2arc-test[1]: vlapic sending ipi 245 to vcpuid 0
>4501206   1 7247346078797882 vm l2arc-test[1]: vcpu state changed from frozen to running
>4501207   1 7247346078798363 vm l2arc-test[1]: Guest interrupt blocking cleared due to rip change: 0xffffffff80946d38/0xffffffff80946d3c
>4501208   1 7247346078798994 vm l2arc-test[1]: vmcb clean 0x3bf
>4501209   1 7247346078799190 vm l2arc-test[1]: Resume execution at 0xffffffff80946d3c
>4501210   0 7247346078899085 vm l2arc-test[0]: v_intr_vector 245 accepted
>4501211   0 7247346078900066 vm l2arc-test[0]: vlapic_intr_accepted irr0 0x00000000
>4501212   0 7247346078900880 vm l2arc-test[0]: vlapic_intr_accepted irr1 0x00000000
>4501213   0 7247346078901566 vm l2arc-test[0]: vlapic_intr_accepted irr2 0x00000000
>4501214   0 7247346078901818 vm l2arc-test[0]: vlapic_intr_accepted irr3 0x00000000
>4501215   0 7247346078902366 vm l2arc-test[0]: vlapic_intr_accepted irr4 0x00000000
>4501216   0 7247346078902981 vm l2arc-test[0]: vlapic_intr_accepted irr5 0x00000000
>4501217   0 7247346078903382 vm l2arc-test[0]: vlapic_intr_accepted irr6 0x00000000
>4501218   0 7247346078903586 vm l2arc-test[0]: vlapic_intr_accepted irr7 0x00000000
>4501219   0 7247346078903800 vm l2arc-test[0]: vlapic_intr_accepted isr0 0x00000000
>4501220   0 7247346078904870 vm l2arc-test[0]: vlapic_intr_accepted isr1 0x00000000
>4501221   1 7247346078905314 vm l2arc-test[1]: handled extintr vmexit at 0xffffffff8094bc47/0
>4501222   0 7247346078905834 vm l2arc-test[0]: vlapic_intr_accepted isr2 0x00000000
>4501223   0 7247346078906736 vm l2arc-test[0]: vlapic_intr_accepted isr3 0x00000000
>4501224   1 7247346078906952 vm l2arc-test[1]: vmcb clean 0x3bf
>4501225   0 7247346078907442 vm l2arc-test[0]: vlapic_intr_accepted isr4 0x00000000
>4501226   1 7247346078907893 vm l2arc-test[1]: Resume execution at 0xffffffff8094bc47
>4501227   0 7247346078908360 vm l2arc-test[0]: vlapic_intr_accepted isr5 0x00000000
>4501228   0 7247346078908880 vm l2arc-test[0]: vlapic_intr_accepted isr6 0x00000000
>4501229   0 7247346078909088 vm l2arc-test[0]: vlapic_intr_accepted isr7 0x00200000
>4501230   0 7247346078911074 vm l2arc-test[0]: vlapic_update_ppr 0xf0
>4501231   2 7247346078911562 vm l2arc-test: hpet t1 fired
>4501232   0 7247346078911717 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff808e34a8/0
>4501233   0 7247346078912782 vm l2arc-test[0]: Clearing V_IRQ interrupt injection
>4501234   0 7247346078913750 vm l2arc-test[0]: vmcb clean 0x3b7
>4501235   0 7247346078914083 vm l2arc-test[0]: Resume execution at 0xffffffff808e34a8
>4501236   2 7247346078917088 vm l2arc-test: lapic MSI addr: 0xfee01000 msg: 0x30
>4501237   2 7247346078917512 vm l2arc-test: lapic MSI physical dest 0x1, vec 48
>4501238   0 7247346078918429 vm l2arc-test[0]: inst_emul fault for gpa 0xfee000b0/0x100000006 at rip 0xffffffff808e34b2
>4501239   0 7247346078918795 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff808e34b2/0
>4501240   0 7247346078919875 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501241   2 7247346078920478 vm l2arc-test[1]: vlapic_set_intr_ready irr0 0x00000000
>4501242   2 7247346078921102 vm l2arc-test[1]: vlapic_set_intr_ready irr1 0x00010000
>4501243   0 7247346078921390 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfee000b0
>4501244   2 7247346078921933 vm l2arc-test[1]: vlapic_set_intr_ready irr2 0x00000000
>4501245   2 7247346078922394 vm l2arc-test[1]: vlapic_set_intr_ready irr3 0x00000000
>4501246   2 7247346078922626 vm l2arc-test[1]: vlapic_set_intr_ready irr4 0x00000000
>4501247   2 7247346078923046 vm l2arc-test[1]: vlapic_set_intr_ready irr5 0x00000000
>4501248   2 7247346078923306 vm l2arc-test[1]: vlapic_set_intr_ready irr6 0x00000000
>4501249   2 7247346078923762 vm l2arc-test[1]: vlapic_set_intr_ready irr7 0x00000000
>4501250   2 7247346078929782 vm l2arc-test: hpet t0 fired
>4501251   1 7247346078930190 vm l2arc-test[1]: handled extintr vmexit at 0xffffffff8094bc46/0
>4501252   1 7247346078931314 vm l2arc-test[1]: pending intr 48
>4501253   1 7247346078931722 vm l2arc-test[1]: Injecting vector 48 using V_IRQ
>4501254   2 7247346078932275 vm l2arc-test: lapic MSI addr: 0xfee00000 msg: 0x37
>4501255   2 7247346078932838 vm l2arc-test: lapic MSI physical dest 0, vec 55
>4501256   1 7247346078933170 vm l2arc-test[1]: vmcb clean 0x3b7
>4501257   1 7247346078933626 vm l2arc-test[1]: Resume execution at 0xffffffff8094bc46
>4501258   2 7247346078934594 vm l2arc-test[0]: vlapic_set_intr_ready irr0 0x00000000
>4501259   0 7247346078934874 vm l2arc-test[0]: nextrip updated to 0xffffffff808e34bc after instruction decoding
>4501260   2 7247346078935408 vm l2arc-test[0]: vlapic_set_intr_ready irr1 0x00800000
>4501261   0 7247346078935814 vm l2arc-test[0]: vlapic write offset 0xb0, data 0
>4501262   2 7247346078936206 vm l2arc-test[0]: vlapic_set_intr_ready irr2 0x00000000
>4501263   0 7247346078936616 vm l2arc-test[0]: EOI vector 245
>4501264   2 7247346078937082 vm l2arc-test[0]: vlapic_set_intr_ready irr3 0x00000000
>4501265   0 7247346078937763 vm l2arc-test[0]: vlapic_process_eoi isr0 0x00000000
>4501266   2 7247346078938371 vm l2arc-test[0]: vlapic_set_intr_ready irr4 0x00000000
>4501267   0 7247346078938838 vm l2arc-test[0]: vlapic_process_eoi isr1 0x00000000
>4501268   2 7247346078939253 vm l2arc-test[0]: vlapic_set_intr_ready irr5 0x00000000
>4501269   0 7247346078939720 vm l2arc-test[0]: vlapic_process_eoi isr2 0x00000000
>4501270   2 7247346078939942 vm l2arc-test[0]: vlapic_set_intr_ready irr6 0x00000000
>4501271   0 7247346078940507 vm l2arc-test[0]: vlapic_process_eoi isr3 0x00000000
>4501272   2 7247346078940787 vm l2arc-test[0]: vlapic_set_intr_ready irr7 0x00000000
>4501273   0 7247346078941440 vm l2arc-test[0]: vlapic_process_eoi isr4 0x00000000
>4501274   0 7247346078941976 vm l2arc-test[0]: vlapic_process_eoi isr5 0x00000000
>4501275   0 7247346078942472 vm l2arc-test[0]: vlapic_process_eoi isr6 0x00000000
>4501276   0 7247346078942867 vm l2arc-test[0]: vlapic_process_eoi isr7 0x00000000
>4501277   0 7247346078944826 vm l2arc-test[0]: vlapic_update_ppr 0x00
>4501278   0 7247346078946408 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501279   0 7247346078947136 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff808e34b2/0xffffffff808e34bc
>4501280   0 7247346078947829 vm l2arc-test[0]: pending intr 55
>4501281   0 7247346078948107 vm l2arc-test[0]: Injecting vector 55 using V_IRQ
>4501282   0 7247346078948411 vm l2arc-test[0]: vmcb clean 0x3b7
>4501283   0 7247346078948624 vm l2arc-test[0]: Resume execution at 0xffffffff808e34bc
>4501284   0 7247346078952790 vm l2arc-test[0]: v_intr_vector 55 accepted
>4501285   0 7247346078953386 vm l2arc-test[0]: vlapic_intr_accepted irr0 0x00000000
>4501286   0 7247346078953602 vm l2arc-test[0]: vlapic_intr_accepted irr1 0x00000000
>4501287   0 7247346078953861 vm l2arc-test[0]: vlapic_intr_accepted irr2 0x00000000
>4501288   0 7247346078954070 vm l2arc-test[0]: vlapic_intr_accepted irr3 0x00000000
>4501289   0 7247346078954280 vm l2arc-test[0]: vlapic_intr_accepted irr4 0x00000000
>4501290   0 7247346078954482 vm l2arc-test[0]: vlapic_intr_accepted irr5 0x00000000
>4501291   0 7247346078954685 vm l2arc-test[0]: vlapic_intr_accepted irr6 0x00000000
>4501292   0 7247346078954886 vm l2arc-test[0]: vlapic_intr_accepted irr7 0x00000000
>4501293   0 7247346078955098 vm l2arc-test[0]: vlapic_intr_accepted isr0 0x00000000
>4501294   0 7247346078955307 vm l2arc-test[0]: vlapic_intr_accepted isr1 0x00800000
>4501295   0 7247346078955507 vm l2arc-test[0]: vlapic_intr_accepted isr2 0x00000000
>4501296   0 7247346078956587 vm l2arc-test[0]: vlapic_intr_accepted isr3 0x00000000
>4501297   0 7247346078956789 vm l2arc-test[0]: vlapic_intr_accepted isr4 0x00000000
>4501298   0 7247346078956994 vm l2arc-test[0]: vlapic_intr_accepted isr5 0x00000000
>4501299   0 7247346078957197 vm l2arc-test[0]: vlapic_intr_accepted isr6 0x00000000
>4501300   0 7247346078957406 vm l2arc-test[0]: vlapic_intr_accepted isr7 0x00000000
>4501301   0 7247346078959192 vm l2arc-test[0]: vlapic_update_ppr 0x30
>4501302   0 7247346078960210 vm l2arc-test[0]: inst_emul fault for gpa 0xfee00110/0x100000004 at rip 0xffffffff808e359a
>4501303   0 7247346078960422 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff808e359a/0
>4501304   0 7247346078961406 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501305   0 7247346078962170 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfee00110
>4501306   0 7247346078969938 vm l2arc-test[0]: nextrip updated to 0xffffffff808e35a0 after instruction decoding
>4501307   0 7247346078970845 vm l2arc-test[0]: vlapic read offset 0x110, data 0x800000
>4501308   0 7247346078972581 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501309   0 7247346078973123 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff808e359a/0xffffffff808e35a0
>4501310   0 7247346078973624 vm l2arc-test[0]: Clearing V_IRQ interrupt injection
>4501311   0 7247346078974037 vm l2arc-test[0]: vmcb clean 0x3b7
>4501312   0 7247346078974254 vm l2arc-test[0]: Resume execution at 0xffffffff808e35a0
>4501313   0 7247346078984565 vm l2arc-test[0]: inst_emul fault for gpa 0xfed000f0/0x100000004 at rip 0xffffffff80900cf8
>4501314   0 7247346078984778 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80900cf8/0
>4501315   0 7247346078985707 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501316   0 7247346078986486 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed000f0
>4501317   0 7247346078994869 vm l2arc-test[0]: nextrip updated to 0xffffffff80900cfa after instruction decoding
>4501318   0 7247346078997696 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501319   0 7247346078998408 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80900cf8/0xffffffff80900cfa
>4501320   0 7247346078999219 vm l2arc-test[0]: vmcb clean 0x3bf
>4501321   0 7247346078999437 vm l2arc-test[0]: Resume execution at 0xffffffff80900cfa
>4501322   0 7247346079020042 vm l2arc-test[0]: inst_emul fault for gpa 0xfed000f0/0x100000004 at rip 0xffffffff80900cf8
>4501323   0 7247346079020254 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80900cf8/0
>4501324   0 7247346079021491 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501325   0 7247346079022354 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed000f0
>4501326   0 7247346079030237 vm l2arc-test[0]: nextrip updated to 0xffffffff80900cfa after instruction decoding
>4501327   0 7247346079032026 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501328   0 7247346079032566 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80900cf8/0xffffffff80900cfa
>4501329   0 7247346079033344 vm l2arc-test[0]: vmcb clean 0x3bf
>4501330   0 7247346079033557 vm l2arc-test[0]: Resume execution at 0xffffffff80900cfa
>4501331   0 7247346079055405 vm l2arc-test[0]: inst_emul fault for gpa 0xfed000f0/0x100000004 at rip 0xffffffff80900cf8
>4501332   0 7247346079055618 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80900cf8/0
>4501333   0 7247346079056637 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501334   0 7247346079057546 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed000f0
>4501335   0 7247346079065352 vm l2arc-test[0]: nextrip updated to 0xffffffff80900cfa after instruction decoding
>4501336   0 7247346079067179 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501337   0 7247346079067725 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80900cf8/0xffffffff80900cfa
>4501338   0 7247346079068613 vm l2arc-test[0]: vmcb clean 0x3bf
>4501339   0 7247346079068829 vm l2arc-test[0]: Resume execution at 0xffffffff80900cfa
>4501340   0 7247346079072325 vm l2arc-test[0]: inst_emul fault for gpa 0xfed00108/0x100000006 at rip 0xffffffff809011d8
>4501341   0 7247346079072546 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff809011d8/0
>4501342   0 7247346079073512 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501343   0 7247346079074253 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed00108
>4501344   0 7247346079082606 vm l2arc-test[0]: nextrip updated to 0xffffffff809011da after instruction decoding
>4501345   0 7247346079088797 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501346   0 7247346079089336 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff809011d8/0xffffffff809011da
>4501347   0 7247346079090168 vm l2arc-test[0]: vmcb clean 0x3bf
>4501348   0 7247346079090381 vm l2arc-test[0]: Resume execution at 0xffffffff809011da
>4501349   0 7247346079093912 vm l2arc-test[0]: inst_emul fault for gpa 0xfed00100/0x100000006 at rip 0xffffffff809011d8
>4501350   0 7247346079094125 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff809011d8/0
>4501351   0 7247346079095050 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501352   0 7247346079095902 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed00100
>4501353   0 7247346079103560 vm l2arc-test[0]: nextrip updated to 0xffffffff809011da after instruction decoding
>4501354   0 7247346079105698 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501355   0 7247346079106230 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff809011d8/0xffffffff809011da
>4501356   0 7247346079106998 vm l2arc-test[0]: vmcb clean 0x3bf
>4501357   0 7247346079107219 vm l2arc-test[0]: Resume execution at 0xffffffff809011da
>4501358   0 7247346079110546 vm l2arc-test[0]: inst_emul fault for gpa 0xfed000f0/0x100000004 at rip 0xffffffff80900cf8
>4501359   0 7247346079110758 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80900cf8/0
>4501360   0 7247346079111690 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501361   0 7247346079112429 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed000f0
>4501362   0 7247346079119946 vm l2arc-test[0]: nextrip updated to 0xffffffff80900cfa after instruction decoding
>4501363   0 7247346079121746 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501364   0 7247346079122280 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80900cf8/0xffffffff80900cfa
>4501365   0 7247346079123224 vm l2arc-test[0]: vmcb clean 0x3bf
>4501366   0 7247346079123557 vm l2arc-test[0]: Resume execution at 0xffffffff80900cfa
>4501367   0 7247346079128939 vm l2arc-test[0]: inst_emul fault for gpa 0xfee000b0/0x100000006 at rip 0xffffffff80947378
>4501368   0 7247346079129152 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80947378/0
>4501369   0 7247346079130144 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501370   0 7247346079131058 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfee000b0
>4501371   0 7247346079139568 vm l2arc-test[0]: nextrip updated to 0xffffffff8094737b after instruction decoding
>4501372   0 7247346079140082 vm l2arc-test[0]: vlapic write offset 0xb0, data 0
>4501373   0 7247346079140486 vm l2arc-test[0]: EOI vector 55
>4501374   0 7247346079140696 vm l2arc-test[0]: vlapic_process_eoi isr0 0x00000000
>4501375   0 7247346079140904 vm l2arc-test[0]: vlapic_process_eoi isr1 0x00000000
>4501376   0 7247346079141118 vm l2arc-test[0]: vlapic_process_eoi isr2 0x00000000
>4501377   0 7247346079141333 vm l2arc-test[0]: vlapic_process_eoi isr3 0x00000000
>4501378   0 7247346079141544 vm l2arc-test[0]: vlapic_process_eoi isr4 0x00000000
>4501379   0 7247346079141816 vm l2arc-test[0]: vlapic_process_eoi isr5 0x00000000
>4501380   0 7247346079142026 vm l2arc-test[0]: vlapic_process_eoi isr6 0x00000000
>4501381   0 7247346079142243 vm l2arc-test[0]: vlapic_process_eoi isr7 0x00000000
>4501382   0 7247346079144034 vm l2arc-test[0]: vlapic_update_ppr 0x00
>4501383   0 7247346079145098 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501384   0 7247346079145650 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80947378/0xffffffff8094737b
>4501385   0 7247346079146382 vm l2arc-test[0]: vmcb clean 0x3bf
>4501386   0 7247346079146594 vm l2arc-test[0]: Resume execution at 0xffffffff8094737b
>4501387   0 7247346079161338 vm l2arc-test[0]: inst_emul fault for gpa 0xfed000f0/0x100000004 at rip 0xffffffff80900cf8
>4501388   0 7247346079161550 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80900cf8/0
>4501389   0 7247346079162584 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501390   0 7247346079163389 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed000f0
>4501391   0 7247346079171856 vm l2arc-test[0]: nextrip updated to 0xffffffff80900cfa after instruction decoding
>4501392   0 7247346079173715 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501393   0 7247346079174269 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80900cf8/0xffffffff80900cfa
>4501394   0 7247346079175061 vm l2arc-test[0]: vmcb clean 0x3bf
>4501395   0 7247346079175278 vm l2arc-test[0]: Resume execution at 0xffffffff80900cfa
>4501396   0 7247346079195045 vm l2arc-test[0]: inst_emul fault for gpa 0xfed000f0/0x100000004 at rip 0xffffffff80900cf8
>4501397   0 7247346079195258 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80900cf8/0
>4501398   0 7247346079197526 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501399   0 7247346079198422 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed000f0
>4501400   0 7247346079206363 vm l2arc-test[0]: nextrip updated to 0xffffffff80900cfa after instruction decoding
>4501401   0 7247346079208178 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501402   0 7247346079208854 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80900cf8/0xffffffff80900cfa
>4501403   0 7247346079209696 vm l2arc-test[0]: vmcb clean 0x3bf
>4501404   0 7247346079209910 vm l2arc-test[0]: Resume execution at 0xffffffff80900cfa
>4501405   0 7247346082064682 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d46b6/0
>4501406   0 7247346082066024 vm l2arc-test[0]: vmcb clean 0x3bf
>4501407   0 7247346082066219 vm l2arc-test[0]: Resume execution at 0xffffffff806d46b6
>4501408   1 7247346082067898 vm l2arc-test[1]: v_intr_vector 48 pending
>4501409   1 7247346082068278 vm l2arc-test[1]: handled extintr vmexit at 0xffffffff8094caf5/0
>4501410   1 7247346082068790 vm l2arc-test[1]: pending intr 48
>4501411   1 7247346082069381 vm l2arc-test[1]: Injecting vector 48 using V_IRQ
>4501412   1 7247346082070013 vm l2arc-test[1]: vmcb clean 0x3b7
>4501413   1 7247346082070224 vm l2arc-test[1]: Resume execution at 0xffffffff8094caf5
>4501414   0 7247346083128027 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d46b4/0
>4501415   0 7247346083129224 vm l2arc-test[0]: vmcb clean 0x3bf
>4501416   0 7247346083129531 vm l2arc-test[0]: Resume execution at 0xffffffff806d46b4
>4501417   0 7247346085141848 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d4660/0
>4501418   0 7247346085142794 vm l2arc-test[0]: vmcb clean 0x3bf
>4501419   0 7247346085143307 vm l2arc-test[0]: Resume execution at 0xffffffff806d4660
>4501420   1 7247346085145771 vm l2arc-test[1]: v_intr_vector 48 pending
>4501421   1 7247346085146114 vm l2arc-test[1]: handled extintr vmexit at 0xffffffff8094bc40/0
>4501422   1 7247346085146570 vm l2arc-test[1]: pending intr 48
>4501423   1 7247346085146779 vm l2arc-test[1]: Injecting vector 48 using V_IRQ
>4501424   1 7247346085147298 vm l2arc-test[1]: vmcb clean 0x3b7
>4501425   1 7247346085147504 vm l2arc-test[1]: Resume execution at 0xffffffff8094bc40
>4501426   0 7247346088366386 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d4660/0
>4501427   0 7247346088367928 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501428   1 7247346088369616 vm l2arc-test[1]: v_intr_vector 48 pending
>4501429   1 7247346088370178 vm l2arc-test[1]: handled extintr vmexit at 0xffffffff8094bc47/0
>4501430   1 7247346088371237 vm l2arc-test[1]: pending intr 48
>4501431   1 7247346088371701 vm l2arc-test[1]: Injecting vector 48 using V_IRQ
>4501432   1 7247346088372237 vm l2arc-test[1]: vmcb clean 0x3b7
>4501433   1 7247346088372600 vm l2arc-test[1]: Resume execution at 0xffffffff8094bc47
>4501434   0 7247346088377677 vm l2arc-test: hpet t0 fired
>4501435   0 7247346088379696 vm l2arc-test: lapic MSI addr: 0xfee00000 msg: 0x37
>4501436   0 7247346088379918 vm l2arc-test: lapic MSI physical dest 0, vec 55
>4501437   0 7247346088381195 vm l2arc-test[0]: vlapic_set_intr_ready irr0 0x00000000
>4501438   0 7247346088381413 vm l2arc-test[0]: vlapic_set_intr_ready irr1 0x00800000
>4501439   0 7247346088381603 vm l2arc-test[0]: vlapic_set_intr_ready irr2 0x00000000
>4501440   0 7247346088381795 vm l2arc-test[0]: vlapic_set_intr_ready irr3 0x00000000
>4501441   0 7247346088382045 vm l2arc-test[0]: vlapic_set_intr_ready irr4 0x00000000
>4501442   0 7247346088382258 vm l2arc-test[0]: vlapic_set_intr_ready irr5 0x00000000
>4501443   0 7247346088382475 vm l2arc-test[0]: vlapic_set_intr_ready irr6 0x00000000
>4501444   0 7247346088382698 vm l2arc-test[0]: vlapic_set_intr_ready irr7 0x00000000
>4501445   0 7247346088387949 vm l2arc-test[0]: retu 0/2
>4501446   0 7247346088389461 vm l2arc-test[0]: vcpu state changed from frozen to idle
>4501447   0 7247346088413350 vm l2arc-test[0]: vcpu state changed from idle to frozen
>4501448   0 7247346088415038 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501449   0 7247346088415998 vm l2arc-test[0]: pending intr 55
>4501450   0 7247346088416264 vm l2arc-test[0]: Injecting vector 55 using V_IRQ
>4501451   0 7247346088416819 vm l2arc-test[0]: vmcb clean 0x3b7
>4501452   0 7247346088417011 vm l2arc-test[0]: Resume execution at 0xffffffff806d4660
>4501453   0 7247346088420024 vm l2arc-test[0]: v_intr_vector 55 accepted
>4501454   0 7247346088420264 vm l2arc-test[0]: vlapic_intr_accepted irr0 0x00000000
>4501455   0 7247346088420464 vm l2arc-test[0]: vlapic_intr_accepted irr1 0x00000000
>4501456   0 7247346088420670 vm l2arc-test[0]: vlapic_intr_accepted irr2 0x00000000
>4501457   0 7247346088420867 vm l2arc-test[0]: vlapic_intr_accepted irr3 0x00000000
>4501458   0 7247346088421315 vm l2arc-test[0]: vlapic_intr_accepted irr4 0x00000000
>4501459   0 7247346088421616 vm l2arc-test[0]: vlapic_intr_accepted irr5 0x00000000
>4501460   0 7247346088421816 vm l2arc-test[0]: vlapic_intr_accepted irr6 0x00000000
>4501461   0 7247346088422010 vm l2arc-test[0]: vlapic_intr_accepted irr7 0x00000000
>4501462   0 7247346088422208 vm l2arc-test[0]: vlapic_intr_accepted isr0 0x00000000
>4501463   0 7247346088422738 vm l2arc-test[0]: vlapic_intr_accepted isr1 0x00800000
>4501464   0 7247346088422930 vm l2arc-test[0]: vlapic_intr_accepted isr2 0x00000000
>4501465   0 7247346088423114 vm l2arc-test[0]: vlapic_intr_accepted isr3 0x00000000
>4501466   0 7247346088423306 vm l2arc-test[0]: vlapic_intr_accepted isr4 0x00000000
>4501467   0 7247346088423491 vm l2arc-test[0]: vlapic_intr_accepted isr5 0x00000000
>4501468   0 7247346088423677 vm l2arc-test[0]: vlapic_intr_accepted isr6 0x00000000
>4501469   0 7247346088423869 vm l2arc-test[0]: vlapic_intr_accepted isr7 0x00000000
>4501470   0 7247346088425507 vm l2arc-test[0]: vlapic_update_ppr 0x30
>4501471   0 7247346088426698 vm l2arc-test[0]: inst_emul fault for gpa 0xfee00110/0x100000004 at rip 0xffffffff808e359a
>4501472   0 7247346088426931 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff808e359a/0
>4501473   0 7247346088427818 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501474   0 7247346088428557 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfee00110
>4501475   0 7247346088436354 vm l2arc-test[0]: nextrip updated to 0xffffffff808e35a0 after instruction decoding
>4501476   0 7247346088436842 vm l2arc-test[0]: vlapic read offset 0x110, data 0x800000
>4501477   0 7247346088438013 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501478   0 7247346088438496 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff808e359a/0xffffffff808e35a0
>4501479   0 7247346088438987 vm l2arc-test[0]: Clearing V_IRQ interrupt injection
>4501480   0 7247346088439381 vm l2arc-test[0]: vmcb clean 0x3b7
>4501481   0 7247346088439574 vm l2arc-test[0]: Resume execution at 0xffffffff808e35a0
>4501482   0 7247346088443595 vm l2arc-test[0]: inst_emul fault for gpa 0xfed000f0/0x100000004 at rip 0xffffffff80900cf8
>4501483   0 7247346088443789 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80900cf8/0
>4501484   0 7247346088444675 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501485   0 7247346088445347 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed000f0
>4501486   0 7247346088452314 vm l2arc-test[0]: nextrip updated to 0xffffffff80900cfa after instruction decoding
>4501487   0 7247346088453971 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501488   0 7247346088454464 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80900cf8/0xffffffff80900cfa
>4501489   0 7247346088455190 vm l2arc-test[0]: vmcb clean 0x3bf
>4501490   0 7247346088455382 vm l2arc-test[0]: Resume execution at 0xffffffff80900cfa
>4501491   0 7247346088462786 vm l2arc-test[0]: inst_emul fault for gpa 0xfed000f0/0x100000004 at rip 0xffffffff80900cf8
>4501492   0 7247346088462979 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80900cf8/0
>4501493   0 7247346088463896 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501494   0 7247346088464814 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed000f0
>4501495   0 7247346088471736 vm l2arc-test[0]: nextrip updated to 0xffffffff80900cfa after instruction decoding
>4501496   0 7247346088473275 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501497   0 7247346088473850 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80900cf8/0xffffffff80900cfa
>4501498   0 7247346088474506 vm l2arc-test[0]: vmcb clean 0x3bf
>4501499   0 7247346088474699 vm l2arc-test[0]: Resume execution at 0xffffffff80900cfa
>4501500   0 7247346088483648 vm l2arc-test[0]: inst_emul fault for gpa 0xfed000f0/0x100000004 at rip 0xffffffff80900cf8
>4501501   0 7247346088483842 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80900cf8/0
>4501502   0 7247346088484720 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501503   0 7247346088485432 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed000f0
>4501504   0 7247346088492274 vm l2arc-test[0]: nextrip updated to 0xffffffff80900cfa after instruction decoding
>4501505   0 7247346088494123 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501506   0 7247346088494672 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80900cf8/0xffffffff80900cfa
>4501507   0 7247346088495379 vm l2arc-test[0]: vmcb clean 0x3bf
>4501508   0 7247346088495581 vm l2arc-test[0]: Resume execution at 0xffffffff80900cfa
>4501509   0 7247346088498582 vm l2arc-test[0]: inst_emul fault for gpa 0xfed00108/0x100000006 at rip 0xffffffff809011d8
>4501510   0 7247346088498776 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff809011d8/0
>4501511   0 7247346088499605 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501512   0 7247346088500277 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed00108
>4501513   0 7247346088507072 vm l2arc-test[0]: nextrip updated to 0xffffffff809011da after instruction decoding
>4501514   0 7247346088510552 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501515   0 7247346088511045 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff809011d8/0xffffffff809011da
>4501516   0 7247346088511734 vm l2arc-test[0]: vmcb clean 0x3bf
>4501517   0 7247346088511933 vm l2arc-test[0]: Resume execution at 0xffffffff809011da
>4501518   0 7247346088515022 vm l2arc-test[0]: inst_emul fault for gpa 0xfed00100/0x100000006 at rip 0xffffffff809011d8
>4501519   0 7247346088515216 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff809011d8/0
>4501520   0 7247346088516043 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501521   0 7247346088516750 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed00100
>4501522   0 7247346088523538 vm l2arc-test[0]: nextrip updated to 0xffffffff809011da after instruction decoding
>4501523   0 7247346088525066 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501524   0 7247346088525557 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff809011d8/0xffffffff809011da
>4501525   0 7247346088526250 vm l2arc-test[0]: vmcb clean 0x3bf
>4501526   0 7247346088526453 vm l2arc-test[0]: Resume execution at 0xffffffff809011da
>4501527   0 7247346088529490 vm l2arc-test[0]: inst_emul fault for gpa 0xfed000f0/0x100000004 at rip 0xffffffff80900cf8
>4501528   0 7247346088529691 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80900cf8/0
>4501529   0 7247346088530624 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501530   0 7247346088531283 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfed000f0
>4501531   0 7247346088538013 vm l2arc-test[0]: nextrip updated to 0xffffffff80900cfa after instruction decoding
>4501532   0 7247346088539530 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501533   0 7247346088540022 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80900cf8/0xffffffff80900cfa
>4501534   0 7247346088540707 vm l2arc-test[0]: vmcb clean 0x3bf
>4501535   0 7247346088540899 vm l2arc-test[0]: Resume execution at 0xffffffff80900cfa
>4501536   0 7247346088544814 vm l2arc-test[0]: inst_emul fault for gpa 0xfee000b0/0x100000006 at rip 0xffffffff80947378
>4501537   0 7247346088545008 vm l2arc-test[0]: unhandled nptfault vmexit at 0xffffffff80947378/0
>4501538   0 7247346088545883 vm l2arc-test[0]: vcpu state changed from running to frozen
>4501539   0 7247346088546614 vm l2arc-test[0]: inst_emul fault accessing gpa 0xfee000b0
>4501540   0 7247346088553461 vm l2arc-test[0]: nextrip updated to 0xffffffff8094737b after instruction decoding
>4501541   0 7247346088553946 vm l2arc-test[0]: vlapic write offset 0xb0, data 0
>4501542   0 7247346088554323 vm l2arc-test[0]: EOI vector 55
>4501543   0 7247346088554512 vm l2arc-test[0]: vlapic_process_eoi isr0 0x00000000
>4501544   0 7247346088554709 vm l2arc-test[0]: vlapic_process_eoi isr1 0x00000000
>4501545   0 7247346088554899 vm l2arc-test[0]: vlapic_process_eoi isr2 0x00000000
>4501546   0 7247346088555090 vm l2arc-test[0]: vlapic_process_eoi isr3 0x00000000
>4501547   0 7247346088555278 vm l2arc-test[0]: vlapic_process_eoi isr4 0x00000000
>4501548   0 7247346088555467 vm l2arc-test[0]: vlapic_process_eoi isr5 0x00000000
>4501549   0 7247346088555664 vm l2arc-test[0]: vlapic_process_eoi isr6 0x00000000
>4501550   0 7247346088555854 vm l2arc-test[0]: vlapic_process_eoi isr7 0x00000000
>4501551   0 7247346088557571 vm l2arc-test[0]: vlapic_update_ppr 0x00
>4501552   0 7247346088558555 vm l2arc-test[0]: vcpu state changed from frozen to running
>4501553   0 7247346088559058 vm l2arc-test[0]: Guest interrupt blocking cleared due to rip change: 0xffffffff80947378/0xffffffff8094737b
>4501554   0 7247346088559712 vm l2arc-test[0]: vmcb clean 0x3bf
>4501555   0 7247346088559906 vm l2arc-test[0]: Resume execution at 0xffffffff8094737b
>4501556   0 7247346091578370 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d46b6/0
>4501557   0 7247346091579262 vm l2arc-test[0]: vmcb clean 0x3bf
>4501558   0 7247346091579712 vm l2arc-test[0]: Resume execution at 0xffffffff806d46b6
>4501559   1 7247346091582157 vm l2arc-test[1]: v_intr_vector 48 pending
>4501560   1 7247346091582614 vm l2arc-test[1]: handled extintr vmexit at 0xffffffff8094bc40/0
>4501561   1 7247346091583099 vm l2arc-test[1]: pending intr 48
>4501562   1 7247346091583310 vm l2arc-test[1]: Injecting vector 48 using V_IRQ
>4501563   1 7247346091583810 vm l2arc-test[1]: vmcb clean 0x3b7
>4501564   1 7247346091584414 vm l2arc-test[1]: Resume execution at 0xffffffff8094bc40
>4501565   0 7247346094776085 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d4660/0
>4501566   0 7247346094777074 vm l2arc-test[0]: vmcb clean 0x3bf
>4501567   0 7247346094777501 vm l2arc-test[0]: Resume execution at 0xffffffff806d4660
>4501568   1 7247346094779304 vm l2arc-test[1]: v_intr_vector 48 pending
>4501569   1 7247346094779749 vm l2arc-test[1]: handled extintr vmexit at 0xffffffff8094bc46/0
>4501570   1 7247346094780173 vm l2arc-test[1]: pending intr 48
>4501571   1 7247346094780379 vm l2arc-test[1]: Injecting vector 48 using V_IRQ
>4501572   1 7247346094780875 vm l2arc-test[1]: vmcb clean 0x3b7
>4501573   1 7247346094781082 vm l2arc-test[1]: Resume execution at 0xffffffff8094bc46
>4501574   0 7247346095807037 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d46b6/0
>4501575   0 7247346095807891 vm l2arc-test[0]: vmcb clean 0x3bf
>4501576   0 7247346095808091 vm l2arc-test[0]: Resume execution at 0xffffffff806d46b6
>4501577   0 7247346097988814 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d46b6/0
>4501578   0 7247346097990256 vm l2arc-test[0]: vmcb clean 0x3bf
>4501579   0 7247346097990830 vm l2arc-test[0]: Resume execution at 0xffffffff806d46b6
>4501580   1 7247346097992099 vm l2arc-test[1]: v_intr_vector 48 pending
>4501581   1 7247346097992578 vm l2arc-test[1]: handled extintr vmexit at 0xffffffff8094caf0/0
>4501582   1 7247346097993045 vm l2arc-test[1]: pending intr 48
>4501583   1 7247346097993470 vm l2arc-test[1]: Injecting vector 48 using V_IRQ
>4501584   1 7247346097994186 vm l2arc-test[1]: vmcb clean 0x3b7
>4501585   1 7247346097994690 vm l2arc-test[1]: Resume execution at 0xffffffff8094caf0
>4501586   0 7247346100735264 vm l2arc-test[0]: handled extintr vmexit at 0xffffffff806d46b6/0
>4501587   0 7247346100736291 vm l2arc-test[0]: vmcb clean 0x3bf
>4501588   0 7247346100736734 vm l2arc-test[0]: Resume execution at 0xffffffff806d46b6
>4501589   1 7247346100739685 vm l2arc-test[1]: v_intr_vector 48 pending
>4501590   1 7247346100740114 vm l2arc-test[1]: handled extintr vmexit at 0xffffffff8094bc46/0
>4501591   1 7247346100740536 vm l2arc-test[1]: pending intr 48
>4501592   1 7247346100740754 vm l2arc-test[1]: Injecting vector 48 using V_IRQ
>4501593   1 7247346100741250 vm l2arc-test[1]: vmcb clean 0x3b7

Actions: View

Attachments on bug 215972: 178755 | 189559