Comment 18 for bug 1748103

Revision history for this message
Po-Hsu Lin (cypressyew) wrote : Re: apic test in kvm-unit-test failed with timeout

Looks like it will take about 40 seconds to run on Azure Standard-D48-v3, bump the timeout threshold to 60 or 90 should be able to solve this bug.

06:48:28 INFO | START ubuntu_kvm_unit_tests.apic ubuntu_kvm_unit_tests.apic timestamp=1602571708 timeout=1800 localtime=Oct 13 06:48:28
06:48:28 DEBUG| Persistent state client._record_indent now set to 2
06:48:28 DEBUG| Persistent state client.unexpected_reboot now set to ('ubuntu_kvm_unit_tests.apic', 'ubuntu_kvm_unit_tests.apic')
06:48:28 DEBUG| Waiting for pid 20233 for 1800 seconds
06:48:28 DEBUG| Running 'kvm-ok'
06:48:28 DEBUG| [stdout] INFO: /dev/kvm exists
06:48:28 DEBUG| [stdout] KVM acceleration can be used
06:48:28 DEBUG| Running '/home/azure/autotest/client/tmp/ubuntu_kvm_unit_tests/src/kvm-unit-tests/tests/apic'
06:48:28 DEBUG| [stdout] BUILD_HEAD=4671e4ba
06:48:28 DEBUG| [stdout] timeout -k 1s --foreground 60 /usr/bin/qemu-system-x86_64 -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.kHcsacTcCc -smp 2 -cpu qemu64,+x2apic,+tsc-deadline # -initrd /tmp/tmp.Mc6ec4A6zG
06:48:28 DEBUG| [stderr] qemu-system-x86_64: warning: host doesn't support requested feature: CPUID.80000001H:ECX.svm [bit 2]
06:48:28 DEBUG| [stderr] qemu-system-x86_64: warning: host doesn't support requested feature: CPUID.80000001H:ECX.svm [bit 2]
06:48:29 DEBUG| [stdout] enabling apic
06:48:29 DEBUG| [stdout] enabling apic
06:48:29 DEBUG| [stdout] paging enabled
06:48:29 DEBUG| [stdout] cr0 = 80010011
06:48:29 DEBUG| [stdout] cr3 = 45a000
06:48:29 DEBUG| [stdout] cr4 = 20
06:48:29 DEBUG| [stdout] apic version: 50014
06:48:29 DEBUG| [stdout] PASS: apic existence
06:48:29 DEBUG| [stdout] PASS: xapic id matches cpuid
06:48:29 DEBUG| [stdout] PASS: writeable xapic id
06:48:29 DEBUG| [stdout] PASS: non-writeable x2apic id
06:48:29 DEBUG| [stdout] PASS: sane x2apic id
06:48:29 DEBUG| [stdout] PASS: x2apic id matches cpuid
06:48:29 DEBUG| [stdout] PASS: correct xapic id after reset
06:48:29 DEBUG| [stdout] PASS: apic_disable: Local apic disabled
06:48:29 DEBUG| [stdout] PASS: apic_disable: CPUID.1H:EDX.APIC[bit 9] is clear
06:48:29 DEBUG| [stdout] PASS: apic_disable: *0xfee00030: ffffffff
06:48:29 DEBUG| [stdout] PASS: apic_disable: CR8: 0
06:48:29 DEBUG| [stdout] PASS: apic_disable: CR8: f
06:48:29 DEBUG| [stdout] PASS: apic_disable: *0xfee00080: ffffffff
06:48:29 DEBUG| [stdout] PASS: apic_disable: Local apic enabled in xAPIC mode
06:48:29 DEBUG| [stdout] PASS: apic_disable: CPUID.1H:EDX.APIC[bit 9] is set
06:48:29 DEBUG| [stdout] PASS: apic_disable: *0xfee00030: 50014
06:48:29 DEBUG| [stdout] PASS: apic_disable: *0xfee00080: 0
06:48:29 DEBUG| [stdout] PASS: apic_disable: *0xfee00080: f0
06:48:29 DEBUG| [stdout] PASS: apic_disable: Local apic enabled in x2APIC mode
06:48:29 DEBUG| [stdout] PASS: apic_disable: CPUID.1H:EDX.APIC[bit 9] is set
06:48:29 DEBUG| [stdout] PASS: apic_disable: *0xfee00030: ffffffff
06:48:29 DEBUG| [stdout] PASS: apic_disable: CR8: 0
06:48:29 DEBUG| [stdout] PASS: apic_disable: CR8: f
06:48:29 DEBUG| [stdout] PASS: apic_disable: *0xfee00080: ffffffff
06:48:29 DEBUG| [stdout] x2apic enabled
06:48:29 DEBUG| [stdout] PASS: x2apic enabled to invalid state
06:48:29 DEBUG| [stdout] PASS: x2apic enabled to apic enabled
06:48:29 DEBUG| [stdout] PASS: x2apic enabled to disabled state
06:48:29 DEBUG| [stdout] PASS: disabled to invalid state
06:48:29 DEBUG| [stdout] PASS: disabled to x2apic enabled
06:48:29 DEBUG| [stdout] PASS: apic enabled to invalid state
06:48:29 DEBUG| [stdout] PASS: apicbase: relocate apic
06:48:29 DEBUG| [stdout] PASS: apicbase: reserved physaddr bits
06:48:29 DEBUG| [stdout] PASS: apicbase: reserved low bits
06:48:29 DEBUG| [stdout] PASS: self ipi
06:48:29 DEBUG| [stdout] starting broadcast (x2apic)
06:48:29 DEBUG| [stdout] PASS: APIC physical broadcast address
06:48:29 DEBUG| [stdout] PASS: APIC physical broadcast shorthand
06:48:29 DEBUG| [stdout] SKIP: PV IPIs testing: h-call not available
06:48:29 DEBUG| [stdout] PASS: nmi-after-sti
06:49:04 DEBUG| [stdout] PASS: multiple nmi
06:49:04 DEBUG| [stdout] PASS: APIC LVT timer one shot
06:49:04 DEBUG| [stdout] starting apic change mode
06:49:04 DEBUG| [stdout] PASS: TMICT value reset
06:49:04 DEBUG| [stdout] PASS: TMCCT should have a non-zero value
06:49:04 DEBUG| [stdout] PASS: TMCCT should have reached 0
06:49:04 DEBUG| [stdout] PASS: TMCCT should have a non-zero value
06:49:04 DEBUG| [stdout] PASS: TMCCT should not be reset to TMICT value
06:49:04 DEBUG| [stdout] PASS: TMCCT should be reset to the initial-count
06:49:04 DEBUG| [stdout] PASS: TMCCT should not be reset to init
06:49:04 DEBUG| [stdout] PASS: TMCCT should have reach zero
06:49:04 DEBUG| [stdout] PASS: TMCCT should stay at zero
06:49:04 DEBUG| [stdout] PASS: tsc deadline timer
06:49:04 DEBUG| [stdout] PASS: tsc deadline timer clearing
06:49:04 DEBUG| [stdout] SUMMARY: 51 tests, 1 skipped
06:49:04 DEBUG| [stdout] PASS apic (51 tests, 1 skipped)
06:49:06 INFO | GOOD ubuntu_kvm_unit_tests.apic ubuntu_kvm_unit_tests.apic timestamp=1602571746 localtime=Oct 13 06:49:06 completed successfully
06:49:06 INFO | END GOOD ubuntu_kvm_unit_tests.apic ubuntu_kvm_unit_tests.apic timestamp=1602571746 localtime=Oct 13 06:49:06