canonical-ubuntu-qa team mailing list archive

Thread
Date
[Bug 1943841] Re: svm from ubuntu_kvm_unit_tests interrupt with "Unhandled exception 13 #GP at ip 00000000004027e3" on F-intel-5.13

To: canonical-ubuntu-qa@xxxxxxxxxxxxxxxxxxx
From: Mehmet Basaran <1943841@xxxxxxxxxxxxxxxxxx>
Date: Mon, 21 Oct 2024 09:44:39 -0000
Reply-to: Bug 1943841 <1943841@xxxxxxxxxxxxxxxxxx>
Sender: noreply@xxxxxxxxxxxxx
Similar error happens with noble:linux-lowlatency 6.8.0-48.48.3 on
riccioli (SRU cycle: 2024.09.30)


20:28:53 INFO |     START    ubuntu_kvm_unit_tests.svm    ubuntu_kvm_unit_tests.svm    timeout=1800    timestamp=1729283333    localtime=Oct 18 20:28:53    
20:28:53 DEBUG| Persistent state client._record_indent now set to 2
20:28:53 DEBUG| Persistent state client.unexpected_reboot now set to ('ubuntu_kvm_unit_tests.svm', 'ubuntu_kvm_unit_tests.svm')
20:28:53 DEBUG| Waiting for pid 18157 for 1800 seconds
20:28:53 WARNI| System python is too old, crash handling disabled
20:28:53 DEBUG| Running 'kvm-ok'
20:28:53 DEBUG| [stdout] INFO: /dev/kvm exists
20:28:53 DEBUG| [stdout] KVM acceleration can be used
20:28:53 DEBUG| Running '/home/ubuntu/autotest/client/tmp/ubuntu_kvm_unit_tests/src/kvm-unit-tests/tests/svm'
20:28:53 DEBUG| [stdout] BUILD_HEAD=b04954c9
20:28:53 DEBUG| [stdout] timeout -k 1s --foreground 90s /usr/bin/qemu-system-x86_64 --no-reboot -nodefaults -device pc-testdev -device isa-debug-exit,iobase=0xf4,iosize=0x4 -vnc none -serial stdio -device pci-testdev -machine accel=kvm -kernel /tmp/tmp.jgXFu3YdzN -smp 2 -cpu max,+svm -m 4g -append -pause_filter_test # -initrd /tmp/tmp.jZ1NEkg5BI
20:28:54 DEBUG| [stdout] enabling apic
20:28:54 DEBUG| [stdout] smp: waiting for 1 APs
20:28:54 DEBUG| [stdout] enabling apic
20:28:54 DEBUG| [stdout] setup: CPU 1 online
20:28:54 DEBUG| [stdout] paging enabled
20:28:54 DEBUG| [stdout] cr0 = 80010011
20:28:54 DEBUG| [stdout] cr3 = 10bf000
20:28:54 DEBUG| [stdout] cr4 = 20
20:28:54 DEBUG| [stdout] NPT detected - running all tests with NPT enabled
20:28:54 DEBUG| [stdout] PASS: null
20:28:54 DEBUG| [stdout] PASS: vmrun
20:28:54 DEBUG| [stdout] PASS: ioio
20:28:54 DEBUG| [stdout] PASS: vmrun intercept check
20:28:54 DEBUG| [stdout] PASS: rsm
20:28:54 DEBUG| [stdout] PASS: cr3 read intercept
20:28:54 DEBUG| [stdout] PASS: cr3 read nointercept
20:28:54 DEBUG| [stdout] PASS: cr3 read intercept emulate
20:28:54 DEBUG| [stdout] PASS: dr intercept check
20:28:54 DEBUG| [stdout] PASS: next_rip
20:28:54 DEBUG| [stdout] PASS: msr intercept check
20:28:54 DEBUG| [stdout] PASS: mode_switch
20:28:54 DEBUG| [stdout] PASS: asid_zero
20:28:54 DEBUG| [stdout] PASS: sel_cr0_bug
20:28:54 DEBUG| [stdout] PASS: tsc_adjust
20:28:58 DEBUG| [stdout]     Latency VMRUN : max: 4793660 min: 6460 avg: 8899
20:28:58 DEBUG| [stdout]     Latency VMEXIT: max: 4766600 min: 3580 avg: 3774
20:28:58 DEBUG| [stdout] PASS: latency_run_exit
20:29:03 DEBUG| [stdout]     Latency VMRUN : max: 2145480 min: 8480 avg: 8898
20:29:03 DEBUG| [stdout]     Latency VMEXIT: max: 2133480 min: 3580 avg: 3788
20:29:03 DEBUG| [stdout] PASS: latency_run_exit_clean
20:29:03 DEBUG| [stdout]     Latency VMLOAD: max: 2443180 min: 260 avg: 275
20:29:03 DEBUG| [stdout]     Latency VMSAVE: max: 1971420 min: 240 avg: 263
20:29:03 DEBUG| [stdout]     Latency STGI:   max: 9740 min: 40 avg: 49
20:29:03 DEBUG| [stdout]     Latency CLGI:   max: 46560 min: 40 avg: 53
20:29:03 DEBUG| [stdout] PASS: latency_svm_insn
20:29:03 DEBUG| [stdout] PASS: exception with vector 2 not injected
20:29:03 DEBUG| [stdout] PASS: divide overflow exception injected
20:29:03 DEBUG| [stdout] PASS: eventinj.VALID cleared
20:29:03 DEBUG| [stdout] PASS: exc_inject
20:29:03 DEBUG| [stdout] PASS: pending_event
20:29:03 DEBUG| [stdout] PASS: pending_event_cli
20:29:03 DEBUG| [stdout] PASS: direct interrupt while running guest
20:29:03 DEBUG| [stdout] PASS: intercepted interrupt while running guest
20:29:03 DEBUG| [stdout] PASS: direct interrupt + hlt
20:29:03 DEBUG| [stdout] PASS: intercepted interrupt + hlt
20:29:03 DEBUG| [stdout] PASS: interrupt
20:29:03 DEBUG| [stdout] PASS: direct NMI while running guest
20:29:03 DEBUG| [stdout] PASS: NMI intercept while running guest
20:29:03 DEBUG| [stdout] PASS: nmi
20:29:03 DEBUG| [stdout] PASS: direct NMI + hlt
20:29:03 DEBUG| [stdout] PASS: NMI intercept while running guest
20:29:03 DEBUG| [stdout] PASS: intercepted NMI + hlt
20:29:03 DEBUG| [stdout] PASS: nmi_hlt
20:29:03 DEBUG| [stdout] PASS: virq_inject
20:29:05 DEBUG| [stdout] PASS: No RIP corruption detected after 10000 timer interrupts
20:29:05 DEBUG| [stdout] PASS: reg_corruption
20:29:05 DEBUG| [stdout] enabling apic
20:29:05 DEBUG| [stdout] setup: CPU 1 online
20:29:05 DEBUG| [stdout] PASS: svm_init_startup_test
20:29:05 DEBUG| [stdout] PASS: host_rflags
20:29:05 DEBUG| [stdout] PASS: STGI set VGIF bit.
20:29:05 DEBUG| [stdout] PASS: CLGI cleared VGIF bit.
20:29:05 DEBUG| [stdout] PASS: vgif
20:29:05 DEBUG| [stdout] PASS: CPUID.01H:ECX.XSAVE set before VMRUN
20:29:05 DEBUG| [stdout] PASS: svm_cr4_osxsave_test_guest finished with VMMCALL
20:29:05 DEBUG| [stdout] PASS: CPUID.01H:ECX.XSAVE set after VMRUN
20:29:05 DEBUG| [stdout] PASS: EFER.SVME: 1500
20:29:05 DEBUG| [stdout] PASS: EFER.SVME: 500
20:29:05 DEBUG| [stdout] PASS: Test EFER 9:8: 1700
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 11500
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 101500
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 1001500
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 10001500
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 100001500
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 1000001500
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 10000001500
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 100000001500
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 1000000001500
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 10000000001500
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 100000000001500
20:29:05 DEBUG| [stdout] PASS: Test EFER 63:16: 1000000000001500
20:29:05 DEBUG| [stdout] PASS: EFER.LME=1 (1500), CR0.PG=1 (80010011) and CR4.PAE=0 (40000)
20:29:05 DEBUG| [stdout] PASS: EFER.LME=1 (1500), CR0.PG=1 and CR0.PE=0 (80010010)
20:29:05 DEBUG| [stdout] PASS: EFER.LME=1 (1500), CR0.PG=1 (80010011), CR4.PAE=1 (40020), CS.L=1 and CS.D=1 (699)
20:29:05 DEBUG| [stdout] PASS: Test CR0 CD=1,NW=0: c0010011
20:29:05 DEBUG| [stdout] PASS: Test CR0 CD=1,NW=1: e0010011
20:29:05 DEBUG| [stdout] PASS: Test CR0 CD=0,NW=0: 80010011
20:29:05 DEBUG| [stdout] PASS: Test CR0 CD=0,NW=1: a0010011
20:29:05 DEBUG| [stdout] PASS: Test CR0 63:32: 180010011
20:29:05 DEBUG| [stdout] PASS: Test CR0 63:32: 1080010011
20:29:05 DEBUG| [stdout] PASS: Test CR0 63:32: 10080010011
20:29:05 DEBUG| [stdout] PASS: Test CR0 63:32: 100080010011
20:29:05 DEBUG| [stdout] PASS: Test CR0 63:32: 1000080010011
20:29:05 DEBUG| [stdout] PASS: Test CR0 63:32: 10000080010011
20:29:05 DEBUG| [stdout] PASS: Test CR0 63:32: 100000080010011
20:29:05 DEBUG| [stdout] PASS: Test CR0 63:32: 1000000080010011
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 100000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 200000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 400000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 800000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 1000000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 2000000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 4000000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 8000000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 10000000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 20000000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 40000000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 80000000010bf000, wanted exit 0xffffffff, got 0xffffffff
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 10bf000
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=1) 11:0: 10bf001, wanted exit 0x81, got 0x81
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=1) 11:0: 10bf002, wanted exit 0x81, got 0x81
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=1) 11:0: 10bf004, wanted exit 0x81, got 0x81
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=1) 11:0: 10bf020, wanted exit 0x81, got 0x81
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=1) 11:0: 10bf040, wanted exit 0x81, got 0x81
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=1) 11:0: 10bf080, wanted exit 0x81, got 0x81
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=1) 11:0: 10bf100, wanted exit 0x81, got 0x81
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=1) 11:0: 10bf200, wanted exit 0x81, got 0x81
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=1) 11:0: 10bf400, wanted exit 0x81, got 0x81
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=1) 11:0: 10bf800, wanted exit 0x81, got 0x81
20:29:05 DEBUG| [stdout] PASS: Test CR3 63:0: 10bf000
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=0) 11:0: 10bf001, wanted exit 0x400, got 0x400
20:29:05 DEBUG| [stdout] PASS: Test CR3 (PCIDE=0) 11:0: 10bf002, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR3 (PCIDE=0) 11:0: 10bf004, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR3 (PCIDE=0) 11:0: 10bf020, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR3 (PCIDE=0) 11:0: 10bf040, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR3 (PCIDE=0) 11:0: 10bf080, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR3 (PCIDE=0) 11:0: 10bf100, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR3 (PCIDE=0) 11:0: 10bf200, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR3 (PCIDE=0) 11:0: 10bf400, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR3 (PCIDE=0) 11:0: 10bf800, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR3 (PAE) 2:0: 10bf001, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR3 (PAE) 2:0: 10bf002, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR3 (PAE) 2:0: 10bf004, wanted exit 0x400, got 0x400
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 42020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 44020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 48020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: c0020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 1040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 2040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 4040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 8040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 10040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 20040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 40040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 80040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 42020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 44020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 48020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: c0020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 1040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 2040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 4040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 8040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 10040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 20040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 40040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 31:12: 80040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 63:32: 100040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 63:32: 1000040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 63:32: 10000040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 63:32: 100000040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 63:32: 1000000040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 63:32: 10000000040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 63:32: 100000000040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test CR4 63:32: 1000000000040020, wanted exit 0xffffffff, got 0xffffffff
20:29:06 DEBUG| [stdout] PASS: Test DR6 63:32: 1ffff0ff0
20:29:06 DEBUG| [stdout] PASS: Test DR6 63:32: 10ffff0ff0
20:29:06 DEBUG| [stdout] PASS: Test DR6 63:32: 100ffff0ff0
20:29:06 DEBUG| [stdout] PASS: Test DR6 63:32: 1000ffff0ff0
20:29:06 DEBUG| [stdout] PASS: Test DR6 63:32: 10000ffff0ff0
20:29:06 DEBUG| [stdout] PASS: Test DR6 63:32: 100000ffff0ff0
20:29:06 DEBUG| [stdout] PASS: Test DR6 63:32: 1000000ffff0ff0
20:29:06 DEBUG| [stdout] PASS: Test DR6 63:32: 10000000ffff0ff0
20:29:06 DEBUG| [stdout] PASS: Test DR7 63:32: 100000400
20:29:06 DEBUG| [stdout] PASS: Test DR7 63:32: 1000000400
20:29:06 DEBUG| [stdout] PASS: Test DR7 63:32: 10000000400
20:29:06 DEBUG| [stdout] PASS: Test DR7 63:32: 100000000400
20:29:06 DEBUG| [stdout] PASS: Test DR7 63:32: 1000000000400
20:29:06 DEBUG| [stdout] PASS: Test DR7 63:32: 10000000000400
20:29:06 DEBUG| [stdout] PASS: Test DR7 63:32: 100000000000400
20:29:06 DEBUG| [stdout] PASS: Test DR7 63:32: 1000000000000400
20:29:06 DEBUG| [stdout] PASS: Test MSRPM address: ffffffffe000
20:29:06 DEBUG| [stdout] PASS: Test MSRPM address: ffffffffe001
20:29:06 DEBUG| [stdout] PASS: Test MSRPM address: fffffffff000
20:29:06 DEBUG| [stdout] PASS: Test MSRPM address: 430000
20:29:06 DEBUG| [stdout] PASS: Test MSRPM address: 430fff
20:29:06 DEBUG| [stdout] PASS: Test IOPM address: ffffffffc000
20:29:06 DEBUG| [stdout] PASS: Test IOPM address: ffffffffd000
20:29:06 DEBUG| [stdout] PASS: Test IOPM address: ffffffffdffe
20:29:06 DEBUG| [stdout] PASS: Test IOPM address: ffffffffe000
20:29:06 DEBUG| [stdout] PASS: Test IOPM address: fffffffff000
20:29:06 DEBUG| [stdout] PASS: Test IOPM address: 433000
20:29:06 DEBUG| [stdout] PASS: Test IOPM address: 433fff
20:29:06 DEBUG| [stdout] PASS: Test FS.base for canonical form: 0
20:29:06 DEBUG| [stdout] PASS: Test GS.base for canonical form: 534c80
20:29:06 DEBUG| [stdout] PASS: Test LDTR.base for canonical form: 0
20:29:06 DEBUG| [stdout] PASS: Test TR.base for canonical form: 53ed20
20:29:06 DEBUG| [stdout] PASS: Test KERNEL GS.base for canonical form: 0
20:29:06 DEBUG| [stdout] PASS: Successful VMRUN with noncanonical ES.base
20:29:06 DEBUG| [stdout] PASS: Successful VMRUN with noncanonical CS.base
20:29:06 DEBUG| [stdout] PASS: Successful VMRUN with noncanonical SS.base
20:29:06 DEBUG| [stdout] PASS: Successful VMRUN with noncanonical DS.base
20:29:06 DEBUG| [stdout] PASS: Successful VMRUN with noncanonical GDTR.base
20:29:06 DEBUG| [stdout] PASS: Successful VMRUN with noncanonical IDTR.base
20:29:08 DEBUG| [stdout] PASS: All guest memory tested, no bug found
20:29:08 DEBUG| [stdout] PASS: Test VMLOAD/VMSAVE intercept: Expected VMMCALL #VMEXIT
20:29:08 DEBUG| [stdout] PASS: Test VMLOAD/VMSAVE intercept: Expected VMLOAD #VMEXIT
20:29:08 DEBUG| [stdout] PASS: Test VMLOAD/VMSAVE intercept: Expected VMSAVE #VMEXIT
20:29:08 DEBUG| [stdout] PASS: Test VMLOAD/VMSAVE intercept: Expected VMMCALL #VMEXIT
20:29:08 DEBUG| [stdout] PASS: Test VMLOAD/VMSAVE intercept: Expected VMLOAD #VMEXIT
20:29:08 DEBUG| [stdout] PASS: Test VMLOAD/VMSAVE intercept: Expected VMMCALL #VMEXIT
20:29:08 DEBUG| [stdout] PASS: Test VMLOAD/VMSAVE intercept: Expected VMSAVE #VMEXIT
20:29:08 DEBUG| [stdout] PASS: Test VMLOAD/VMSAVE intercept: Expected VMMCALL #VMEXIT
20:29:08 DEBUG| [stdout] PASS: Test EFLAGS.TF on VMRUN: trap expected  after completion of first guest instruction
20:29:08 DEBUG| [stdout] PASS: Test EFLAGS.TF on VMRUN: trap not expected
20:29:08 DEBUG| [stdout] PASS: Test EFLAGS.TF on VMRUN: guest execution completion
20:29:08 DEBUG| [stdout] PASS: fnop with CR0.TS and CR0.EM unset no #NM excpetion
20:29:08 DEBUG| [stdout] PASS: Handling #GP in L2's exception handler
20:29:08 DEBUG| [stdout] PASS: #GP handled by L2
20:29:08 DEBUG| [stdout] PASS: #GP handled by L1
20:29:08 DEBUG| [stdout] PASS: Handling #UD in L2's exception handler
20:29:08 DEBUG| [stdout] PASS: #UD handled by L2
20:29:08 DEBUG| [stdout] PASS: #UD handled by L1
20:29:08 DEBUG| [stdout] PASS: Handling #DE in L2's exception handler
20:29:08 DEBUG| [stdout] PASS: #DE handled by L2
20:29:08 DEBUG| [stdout] PASS: #DE handled by L1
20:29:08 DEBUG| [stdout] PASS: Handling #DB in L2's exception handler
20:29:08 DEBUG| [stdout] PASS: #DB handled by L2
20:29:08 DEBUG| [stdout] PASS: #DB handled by L1
20:29:08 DEBUG| [stdout] PASS: Handling #BP in L2's exception handler
20:29:08 DEBUG| [stdout] PASS: #BP handled by L2
20:29:08 DEBUG| [stdout] PASS: #BP handled by L1
20:29:08 DEBUG| [stdout] PASS: Usermode #AC handled in L2
20:29:08 DEBUG| [stdout] PASS: #AC handled by L2
20:29:08 DEBUG| [stdout] PASS: #AC handled by L1
20:29:08 DEBUG| [stdout] PASS: Handling #OF in L2's exception handler
20:29:08 DEBUG| [stdout] PASS: #OF handled by L2
20:29:08 DEBUG| [stdout] PASS: #OF handled by L1
20:29:08 DEBUG| [stdout] PASS: Handling #NM in L2's exception handler
20:29:08 DEBUG| [stdout] PASS: #NM handled by L2
20:29:08 DEBUG| [stdout] PASS: #NM handled by L1
20:29:08 DEBUG| [stdout] PASS: Handling #NM in L2's exception handler
20:29:08 DEBUG| [stdout] PASS: #NM handled by L2
20:29:08 DEBUG| [stdout] PASS: #NM handled by L1
20:29:08 DEBUG| [stdout] PASS: Basic LBR test
20:29:08 DEBUG| [stdout] FAIL: MSR_IA32_LASTBRANCHFROMIP, expected=0x401f4d, actual=0x401f4d
20:29:08 DEBUG| [stdout] PASS: Test that without LBRV enabled, guest LBR state does 'leak' to the host(1)
20:29:08 DEBUG| [stdout] Unhandled exception 6 #UD at ip 0000000000401750
20:29:08 DEBUG| [stdout] error_code=0000      rflags=00010086      cs=00000008
20:29:08 DEBUG| [stdout] rax=00000000004016db rcx=00000000000001dc rdx=80000000004016db rbx=0000000080010015
20:29:08 DEBUG| [stdout] rbp=000000000042fb68 rsi=000000000041776f rdi=0000000000414d40
20:29:08 DEBUG| [stdout]  r8=000000000041776f  r9=00000000000003f8 r10=000000000000000d r11=0000000000000000
20:29:08 DEBUG| [stdout] r12=0000000000000000 r13=0000000000000000 r14=0000000000000000 r15=0000000000000000
20:29:08 DEBUG| [stdout] cr0=0000000080010011 cr2=0000000000000000 cr3=00000000010bf000 cr4=0000000000040020
20:29:08 DEBUG| [stdout] cr8=0000000000000000
20:29:08 DEBUG| [stdout]     STACK: @401750 4001d6 414df0 40bf1e 40bb72 4001d6 414df0 40bf1e 40bb72 4001d6 414df0 40bf1e 40bb72 4001d6 414df0 40bf1e 40bb72 4001d6 414df0 40bf1e
20:29:08 DEBUG| [stdout] FAIL svm

-- 
You received this bug notification because you are a member of Canonical
Platform QA Team, which is subscribed to ubuntu-kernel-tests.
https://bugs.launchpad.net/bugs/1943841

Title:
  svm from ubuntu_kvm_unit_tests interrupt with "Unhandled exception 13
  #GP at ip 00000000004027e3" on F-intel-5.13

Status in ubuntu-kernel-tests:
  New
Status in linux-intel-5.13 package in Ubuntu:
  New

Bug description:
  Failing with Focal Intel 5.13.0-1004.4 on node gonzo

  A bit like bug 1934939, but this time it looks like this has passed
  through more cases than that bug.

  Running '/home/ubuntu/autotest/client/tmp/ubuntu_kvm_unit_tests/src/kvm-unit-tests/tests/svm'
   BUILD_HEAD=1593e88a
   timeout -k 1s --foreground 90s /usr/bin/qemu-system-x86_64 --no-reboot -nodefaults -device pc-testdev -device isa-debug-exit,iobase=0xf4,iosize=0x4 -vnc none -serial stdio -device pci-testdev -machine accel=kvm -kernel /tmp/tmp.8QIXdsXIyJ -smp 2 -cpu max,+svm -m 4g # -initrd /tmp/tmp.VvuuwXHRuX
   enabling apic
   enabling apic
   paging enabled
   cr0 = 80010011
   cr3 = 10bf000
   cr4 = 20
   NPT detected - running all tests with NPT enabled
   PASS: null
   PASS: vmrun
   PASS: ioio
   PASS: vmrun intercept check
   PASS: rsm
   PASS: cr3 read intercept
   PASS: cr3 read nointercept
   PASS: cr3 read intercept emulate
   PASS: dr intercept check
   PASS: next_rip
   PASS: msr intercept check
   PASS: mode_switch
   PASS: asid_zero
   PASS: sel_cr0_bug
   PASS: npt_nx
   PASS: npt_np
   PASS: npt_us
   PASS: npt_rw
   PASS: npt_rw_pfwalk
   PASS: npt_l1mmio
   PASS: npt_rw_l1mmio
   PASS: tsc_adjust
       Latency VMRUN : max: 322434 min: 21233 avg: 36460
       Latency VMEXIT: max: 298726 min: 16889 avg: 17717
   PASS: latency_run_exit
       Latency VMRUN : max: 334040 min: 23446 avg: 36313
       Latency VMEXIT: max: 310725 min: 16935 avg: 17618
   PASS: latency_run_exit_clean
       Latency VMLOAD: max: 732466 min: 4675 avg: 4879
       Latency VMSAVE: max: 60901 min: 4565 avg: 4850
       Latency STGI:   max: 43057 min: 3726 avg: 3862
       Latency CLGI:   max: 723675 min: 3644 avg: 3724
   PASS: latency_svm_insn
   PASS: exception with vector 2 not injected
   PASS: divide overflow exception injected
   PASS: eventinj.VALID cleared
   PASS: exc_inject
   PASS: pending_event
   PASS: pending_event_cli
   PASS: direct interrupt while running guest
   PASS: intercepted interrupt while running guest
   PASS: direct interrupt + hlt
   PASS: intercepted interrupt + hlt
   PASS: interrupt
   PASS: direct NMI while running guest
   PASS: NMI intercept while running guest
   PASS: nmi
   PASS: direct NMI + hlt
   PASS: NMI intercept while running guest
   PASS: intercepted NMI + hlt
   PASS: nmi_hlt
   PASS: virq_inject
   PASS: No RIP corruption detected after 10000 timer interrupts
   PASS: reg_corruption
   enabling apic
   PASS: svm_init_startup_test
   PASS: host_rflags
   PASS: CPUID.01H:ECX.XSAVE set before VMRUN
   PASS: svm_cr4_osxsave_test_guest finished with VMMCALL
   PASS: CPUID.01H:ECX.XSAVE set after VMRUN
   PASS: EFER.SVME: 1500
   PASS: EFER.SVME: 500
   PASS: Test EFER 9:8: 1700
   PASS: Test EFER 63:16: 11500
   PASS: Test EFER 63:16: 101500
   PASS: Test EFER 63:16: 1001500
   PASS: Test EFER 63:16: 10001500
   PASS: Test EFER 63:16: 100001500
   PASS: Test EFER 63:16: 1000001500
   PASS: Test EFER 63:16: 10000001500
   PASS: Test EFER 63:16: 100000001500
   PASS: Test EFER 63:16: 1000000001500
   PASS: Test EFER 63:16: 10000000001500
   PASS: Test EFER 63:16: 100000000001500
   PASS: Test EFER 63:16: 1000000000001500
   PASS: EFER.LME=1 (1500), CR0.PG=1 (80010011) and CR4.PAE=0 (40000)
   PASS: EFER.LME=1 (1500), CR0.PG=1 and CR0.PE=0 (80010010)
   PASS: EFER.LME=1 (1500), CR0.PG=1 (80010011), CR4.PAE=1 (40020), CS.L=1 and CS.D=1 (699)
   PASS: Test CR0 CD=1,NW=0: c0010011
   PASS: Test CR0 CD=1,NW=1: e0010011
   PASS: Test CR0 CD=0,NW=0: 80010011
   PASS: Test CR0 CD=0,NW=1: a0010011
   PASS: Test CR0 63:32: 180010011
   PASS: Test CR0 63:32: 1080010011
   PASS: Test CR0 63:32: 10080010011
   PASS: Test CR0 63:32: 100080010011
   PASS: Test CR0 63:32: 1000080010011
   PASS: Test CR0 63:32: 10000080010011
   PASS: Test CR0 63:32: 100000080010011
   PASS: Test CR0 63:32: 1000000080010011
   PASS: Test CR3 63:0: 100000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 200000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 400000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 800000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 1000000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 2000000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 4000000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 8000000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 10000000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 20000000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 40000000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 80000000010bf000, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR3 63:0: 10bf000
   PASS: Test CR3 (PCIDE=0) 11:0: 10bf001, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PCIDE=0) 11:0: 10bf002, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PCIDE=0) 11:0: 10bf004, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PCIDE=0) 11:0: 10bf020, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PCIDE=0) 11:0: 10bf040, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PCIDE=0) 11:0: 10bf080, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PCIDE=0) 11:0: 10bf100, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PCIDE=0) 11:0: 10bf200, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PCIDE=0) 11:0: 10bf400, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PCIDE=0) 11:0: 10bf800, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PAE) 2:0: 10bf001, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PAE) 2:0: 10bf002, wanted exit 0x400, got 0x400
   PASS: Test CR3 (PAE) 2:0: 10bf004, wanted exit 0x400, got 0x400
   PASS: Test CR4 31:12: 41020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 42020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 44020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 48020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: c0020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 840020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 1040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 2040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 4040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 8040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 10040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 20040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 40040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 80040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 41020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 42020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 44020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 48020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: c0020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 840020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 1040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 2040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 4040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 8040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 10040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 20040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 40040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 31:12: 80040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 63:32: 100040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 63:32: 1000040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 63:32: 10000040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 63:32: 100000040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 63:32: 1000000040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 63:32: 10000000040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 63:32: 100000000040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test CR4 63:32: 1000000000040020, wanted exit 0xffffffff, got 0xffffffff
   PASS: Test DR6 63:32: 1ffff0ff0
   PASS: Test DR6 63:32: 10ffff0ff0
   PASS: Test DR6 63:32: 100ffff0ff0
   PASS: Test DR6 63:32: 1000ffff0ff0
   PASS: Test DR6 63:32: 10000ffff0ff0
   PASS: Test DR6 63:32: 100000ffff0ff0
   PASS: Test DR6 63:32: 1000000ffff0ff0
   PASS: Test DR6 63:32: 10000000ffff0ff0
   PASS: Test DR7 63:32: 100000400
   PASS: Test DR7 63:32: 1000000400
   PASS: Test DR7 63:32: 10000000400
   PASS: Test DR7 63:32: 100000000400
   PASS: Test DR7 63:32: 1000000000400
   PASS: Test DR7 63:32: 10000000000400
   PASS: Test DR7 63:32: 100000000000400
   PASS: Test DR7 63:32: 1000000000000400
   PASS: Test MSRPM address: ffffffe000
   PASS: Test MSRPM address: ffffffe001
   PASS: Test MSRPM address: fffffff000
   PASS: Test MSRPM address: 435000
   PASS: Test MSRPM address: 435fff
   PASS: Test IOPM address: ffffffc000
   PASS: Test IOPM address: ffffffd000
   PASS: Test IOPM address: ffffffdffe
   PASS: Test IOPM address: ffffffe000
   PASS: Test IOPM address: fffffff000
   PASS: Test IOPM address: 438000
   PASS: Test IOPM address: 438fff
   PASS: Test FS.base for canonical form: 0
   PASS: Test GS.base for canonical form: 53ddb0
   PASS: Test LDTR.base for canonical form: 0
   PASS: Test TR.base for canonical form: 41407a
   PASS: Test KERNEL GS.base for canonical form: 0
   PASS: Successful VMRUN with noncanonical ES.base
   PASS: Successful VMRUN with noncanonical CS.base
   PASS: Successful VMRUN with noncanonical SS.base
   PASS: Successful VMRUN with noncanonical DS.base
   PASS: Successful VMRUN with noncanonical GDTR.base
   PASS: Successful VMRUN with noncanonical IDTR.base
   PASS: Wanted #NPF on rsvd bits = 0x8000000000000000, got exit = 0x400
   PASS: Wanted PFEC = 0x10000000d, got PFEC = 10000000d, PxE = 0x8000000000401067.  host.NX = 0, host.SMEP = 0, guest.NX = 0, guest.SMEP = 0
   PASS: Wanted #NPF on rsvd bits = 0x3600000000000, got exit = 0x400
   PASS: Wanted PFEC = 0x10000001d, got PFEC = 10000001d, PxE = 0x3600000401067.  host.NX = 1, host.SMEP = 0, guest.NX = 0, guest.SMEP = 0
   Unhandled exception 13 #GP at ip 00000000004027e3
   error_code=0000      rflags=00010256      cs=00000008
   rax=0000000000001500 rcx=00000000c0000080 rdx=0000000000000000 rbx=0000000000140020
   rbp=000000000053ed00 rsi=000000000000000a rdi=00000000000003fd
    r8=000000000041c83a  r9=00000000000003f8 r10=000000000000000d r11=00000000bf9f9000
   r12=0000000000000002 r13=00000000bfec9008 r14=0000000000040020 r15=0000000000001500
   cr0=0000000080010011 cr2=0000000000000000 cr3=00000000010bf000 cr4=0000000000040020
   cr8=0000000000000000
       STACK: @4027e3 402961 400ecc 400368
   FAIL svm

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu-kernel-tests/+bug/1943841/+subscriptions