Bug 12124

Summary: [morty-next] nightly-x86-lsb failed
Product: [Build System, Metadata & Runtime] OE-Core Reporter: Armin Kuster <akuster>
Component: coreAssignee: Armin Kuster <akuster>
Status: RESOLVED DUPLICATE QA Contact:
Severity: normal    
Priority: Medium CC: california.l.sullivan, joshuagloe, meta.mr.watcher, meta.watcher, sgw
Version: 2.2.3   
Target Milestone: 2.2.3   
Hardware: x86   
OS: Multiple   
URL: https://autobuilder.yocto.io/builders/nightly-x86-lsb/builds/506/steps/Running%20Sanity%20Tests/logs/stdio
Whiteboard:
OS type for building Yocto: --- Type of Regression: Regression (Used to work)
Verified: Documentation change: Don't know
Attachments:
Description Flags
CreateAutoConf none

Description Armin Kuster 2017-09-24 20:13:05 UTC
Created attachment 4029 [details]
CreateAutoConf

ERROR: core-image-lsb-1.0-r0 do_testimage: Qemu log output from /home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-lsb/build/build/tmp/work/qemux86-poky-linux/core-image-lsb/1.0-r0/testimage/qemu_boot_log.20170923060723:
[    0.000000] Initializing cgroup subsys cpuset
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Initializing cgroup subsys cpuacct
[    0.000000] Linux version 4.1.43-yocto-standard (pokybuild@opensuse423) (gcc version 6.2.0 (GCC) ) #1 SMP PREEMPT Sat Sep 23 02:30:17 UTC 2017
[    0.000000] KERNEL supported cpus:
[    0.000000]   Intel GenuineIntel
[    0.000000]   AMD AuthenticAMD
[    0.000000]   NSC Geode by NSC
[    0.000000]   Cyrix CyrixInstead
[    0.000000]   Centaur CentaurHauls
[    0.000000]   Transmeta GenuineTMx86
[    0.000000]   Transmeta TransmetaCPU
[    0.000000]   UMC UMC UMC UMC
[    0.000000] e820: BIOS-provided physical RAM map:
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000000ffdbfff] usable
[    0.000000] BIOS-e820: [mem 0x000000000ffdc000-0x000000000fffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] Notice: NX (Execute Disable) protection missing in CPU!
[    0.000000] e820: user-defined physical RAM map:
[    0.000000] user: [mem 0x0000000000000000-0x000000000009fbff] usable
[    0.000000] user: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[    0.000000] user: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[    0.000000] user: [mem 0x0000000000100000-0x000000000ffdbfff] usable
[    0.000000] user: [mem 0x000000000ffdc000-0x000000000fffffff] reserved
[    0.000000] user: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[    0.000000] user: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[    0.000000] SMBIOS 2.8 present.
[    0.000000] Hypervisor detected: KVM
[    0.000000] e820: last_pfn = 0xffdc max_arch_pfn = 0x100000
[    0.000000] PAT configuration [0-7]: WB  WC  UC- UC  WB  WC  UC- UC  
[    0.000000] found SMP MP-table at [mem 0x000f6bc0-0x000f6bcf] mapped at [c00f6bc0]
[    0.000000] Scanning 1 areas for low memory corruption
[    0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
[    0.000000] init_memory_mapping: [mem 0x0f800000-0x0fbfffff]
[    0.000000] init_memory_mapping: [mem 0x00100000-0x0f7fffff]
[    0.000000] init_memory_mapping: [mem 0x0fc00000-0x0ffdbfff]
[    0.000000] ACPI: Early table checksum verification disabled
[    0.000000] ACPI: RSDP 0x00000000000F69D0 000014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 0x000000000FFE18DC 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 0x000000000FFE17B8 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 0x000000000FFE0040 001778 (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACS 0x000000000FFE0000 000040
[    0.000000] ACPI: APIC 0x000000000FFE182C 000078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 0x000000000FFE18A4 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] 0MB HIGHMEM available.
[    0.000000] 255MB LOWMEM available.
[    0.000000]   mapped low ram: 0 - 0ffdc000
[    0.000000]   low ram: 0 - 0ffdc000
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:ffdb001, primary cpu clock
[    0.000000] clocksource kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[    0.000000] Zone ranges:
[    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
[    0.000000]   Normal   [mem 0x0000000001000000-0x000000000ffdbfff]
[    0.000000]   HighMem  empty
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]
[    0.000000]   node   0: [mem 0x0000000000100000-0x000000000ffdbfff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000000ffdbfff]
[    0.000000] Using APIC driver default
[    0.000000] ACPI: PM-Timer IO Port: 0x608
[    0.000000] BIOS bug: APIC version is 0 for CPU 0/0x0, fixing up to 0x10
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[    0.000000] IOAPIC[0]: apic_id 0 already used, trying 1
[    0.000000] IOAPIC[0]: apic_id 1, version 17, address 0xfec00000, GSI 0-23
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
[    0.000000] e820: [mem 0x10000000-0xfeffbfff] available for PCI devices
[    0.000000] Booting paravirtualized kernel on KVM
[    0.000000] clocksource refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[    0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:1 nr_node_ids:1
[    0.000000] PERCPU: Embedded 18 pages/cpu @cfd45000 s45004 r0 d28724 u73728
[    0.000000] KVM setup async PF for cpu 0
[    0.000000] kvm-stealtime: cpu 0, msr fd48bc0
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 64762
[    0.000000] Kernel command line: root=/dev/vda rw highres=off  mem=256M ip=192.168.7.4::192.168.7.3:255.255.255.0 vga=0 uvesafb.mode_option=640x480-32 oprofile.timer=1 uvesafb.task_timeout=-1 console=tty1 console=ttyS0,115200n8 printk.time=1
[    0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
[    0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
[    0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
[    0.000000] Initializing CPU#0
[    0.000000] Initializing HighMem for node 0 (00000000:00000000)
[    0.000000] Memory: 244660K/261608K available (8729K kernel code, 692K rwdata, 2992K rodata, 736K init, 764K bss, 16948K reserved, 0K cma-reserved, 0K highmem)
[    0.000000] virtual kernel memory layout:
[    0.000000]     fixmap  : 0xfff16000 - 0xfffff000   ( 932 kB)
[    0.000000]     pkmap   : 0xff800000 - 0xffc00000   (4096 kB)
[    0.000000]     vmalloc : 0xd07dc000 - 0xff7fe000   ( 752 MB)
[    0.000000]     lowmem  : 0xc0000000 - 0xcffdc000   ( 255 MB)
[    0.000000]       .init : 0xc1c24000 - 0xc1cdc000   ( 736 kB)
[    0.000000]       .data : 0xc188685d - 0xc1c22200   (3694 kB)
[    0.000000]       .text : 0xc1000000 - 0xc188685d   (8730 kB)
[    0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[    0.000000] SLUB: HWalign=128, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] Preemptible hierarchical RCU implementation.
[    0.000000] 	Additional per-CPU info printed with stalls.
[    0.000000] 	RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=1.
[    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[    0.000000] NR_IRQS:2304 nr_irqs:256 16
[    0.000000] Console: colour VGA+ 80x25
[    0.000000] console [tty1] enabled
[    0.000000] console [ttyS0] enabled
[    0.000000] clocksource hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
[    0.000000] tsc: Detected 2599.996 MHz processor
[    0.002000] Calibrating delay loop (skipped) preset value.. 5199.99 BogoMIPS (lpj=2599996)
[    0.002004] pid_max: default: 32768 minimum: 301
[    0.002469] ACPI: Core revision 20150410
[    0.004152] ACPI: All ACPI Tables successfully acquired
[    0.004763] Security Framework initialized
[    0.005028] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.005642] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.006181] Initializing cgroup subsys blkio
[    0.007005] Initializing cgroup subsys memory
[    0.007465] Initializing cgroup subsys devices
[    0.008004] Initializing cgroup subsys freezer
[    0.008456] Initializing cgroup subsys net_cls
[    0.008906] Initializing cgroup subsys debug
[    0.009045] mce: CPU supports 10 MCE banks
[    0.009513] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[    0.010004] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[    0.025580] Freeing SMP alternatives memory: 36K (c1cdc000 - c1ce5000)
[    0.027788] ftrace: allocating 32624 entries in 64 pages
[    0.034083] Enabling APIC mode:  Flat.  Using 1 I/O APICs
[    0.035477] No ESR for 82489DX.
[    0.036266] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1

ERROR: core-image-lsb-1.0-r0 do_testimage: Function failed: core-image-lsb - FAILED to start qemu - check the task log and the boot log
Comment 1 Armin Kuster 2017-09-24 20:13:44 UTC
I don't know which line is the failure. is it the last?
Comment 2 Saul Wold 2017-10-02 16:26:49 UTC
The Full log is here:

https://autobuilder.yocto.io/builders/nightly-x86-lsb/builds/506/steps/Running%20Sanity%20Tests/logs/stdio

This shows that qemu actually just quits, so it seems that it might have failed to get some resource.  This appears to be a one-off/transient failure, given this is also on a newer Tumbleweed Host OS.

I am going to reduce this to Medium, if we can get a reproducible issue, we can move this again
Comment 3 Armin Kuster 2017-10-02 20:09:46 UTC
this issue is again being seen on the weekly morty build. 

host is Tumbleweed, same as before.

https://autobuilder.yocto.io/builders/nightly-x86-64-lsb/builds/516/steps/Running%20Sanity%20Tests/logs/stdio
Comment 4 Joshua Lock 2017-11-07 13:21:05 UTC
Investigation into this issue and a possible solution tracked in #12301

We switched the Tumbleweed kernel from their patched version (kernel-default) to the unmodified upstream kernel sources (kernel-vanilla).

*** This bug has been marked as a duplicate of bug 12301 ***