DEBUG: Executing python function do_testimage
WARNING: Test test_syslog_running (oeqa.runtime.syslog.SyslogTest) was declared as @skipUnlessPassed('test_syslog_help') but that test is either not defined or not active. Will run the test anyway.
NOTE: rootfs file: /tmp/work/qemux86_64-poky-linux-gnux32/core-image-sato/1.0-r0/testimage/core-image-sato-qemux86-64-testimage.ext4
NOTE: Qemu log file: /tmp/work/qemux86_64-poky-linux-gnux32/core-image-sato/1.0-r0/testimage/qemu_boot_log.20160613100940
NOTE: SSH log file: /tmp/work/qemux86_64-poky-linux-gnux32/core-image-sato/1.0-r0/testimage/ssh_target_log.20160613100940
NOTE: Created listening socket for qemu serial console on: 127.0.0.1:40917
NOTE: Created listening socket for qemu serial console on: 127.0.0.1:58675
NOTE: runqemu started, pid is 2840
NOTE: waiting at most 60 seconds for qemu pid
NOTE: qemu started - qemu procces pid is 3717
NOTE: qemu cmdline used:
/tmp/sysroots/x86_64-linux/usr/bin/qemu-system-x86_64-kernel /tmp/deploy/images/qemux86-64/bzImage-qemux86-64.bin-netnic,model=virtio-nettap,vlan=0,ifname=tap0,script=no,downscript=no-cpucore2duo-drivefile= /tmp/work/qemux86_64-poky-linux-gnux32/core-image-sato/1.0-r0/testimage/core-image-sato-qemux86-64-testimage.ext4,if=virtio,format=raw-show-cursor-usb-usbdevicetablet-vgavmware-no-reboot-serialtcp:127.0.0.1:40917-m256-serialtcp:127.0.0.1:58675-appendvga=0 uvesafb.mode_option=640x480-32 root=/dev/vda rw mem=256M ip=192.168.7.2::192.168.7.1:255.255.255.0 oprofile.timer=1 rootfstype=ext4 console=tty1 console=ttyS0,115200n8 printk.time=1
NOTE: Target IP: 192.168.7.2
NOTE: Server IP: 192.168.7.1
NOTE: Starting logging thread
NOTE: Starting thread event loop
NOTE: Connection request received
NOTE: Setting connection established event
NOTE: Output from runqemu:
Please use simplified serial or kvm options instead
Continuing with the following parameters:
KERNEL: [ /tmp/deploy/images/qemux86-64/bzImage-qemux86-64.bin]
ROOTFS: [ /tmp/work/qemux86_64-poky-linux-gnux32/core-image-sato/1.0-r0/testimage/core-image-sato-qemux86-64-testimage.ext4]
FSTYPE: [ext4]
stty: standard input: Inappropriate ioctl for device
Acquiring lockfile for tap0...
Using preconfigured tap device 'tap0'
If this is not intended, touch /tmp/qemu-tap-locks/tap0.skip to make runqemu skip tap0.
Running qemu-system-x86_64...
/tmp/sysroots/x86_64-linux/usr/bin/qemu-system-x86_64 -kernel /tmp/deploy/images/qemux86-64/bzImage-qemux86-64.bin -net nic,model=virtio -net tap,vlan=0,ifname=tap0,script=no,downscript=no -cpu core2duo -drive file= /tmp/work/qemux86_64-poky-linux-gnux32/core-image-sato/1.0-r0/testimage/core-image-sato-qemux86-64-testimage.ext4,if=virtio,format=raw -show-cursor -usb -usbdevice tablet -vga vmware -no-reboot -serial tcp:127.0.0.1:40917 -m 256 -serial tcp:127.0.0.1:58675 -append "vga=0 uvesafb.mode_option=640x480-32 root=/dev/vda rw mem=256M ip=192.168.7.2::192.168.7.1:255.255.255.0 oprofile.timer=1 rootfstype=ext4 console=tty1 console=ttyS0,115200n8 printk.time=1"
warning: TCG doesn't support requested feature: CPUID.01H:EDX.vme [bit 1]
NOTE: Waiting at most 1500 seconds for login banner
NOTE: Connection from 127.0.0.1:36516
NOTE: Reached login banner
NOTE: Logged as root in serial console
NOTE: Test modules ['oeqa.runtime.ping', 'oeqa.runtime.ssh', 'oeqa.runtime.df', 'oeqa.runtime.date', 'oeqa.runtime.scp', 'oeqa.runtime.syslog', 'oeqa.runtime.connman', 'oeqa.runtime.xorg', 'oeqa.runtime.parselogs', 'oeqa.runtime.smart', 'oeqa.runtime.rpm', 'oeqa.runtime.python', 'oeqa.runtime.x32lib']
NOTE: Found 44 tests
test_ping (oeqa.runtime.ping.PingTest) ... ok
test_syslog_running (oeqa.runtime.syslog.SyslogTest) ... ok
test_syslog_logger (oeqa.runtime.syslog.SyslogTestConfig) ... ok
test_syslog_restart (oeqa.runtime.syslog.SyslogTestConfig) ... ok
test_syslog_startup_config (oeqa.runtime.syslog.SyslogTestConfig) ... ok
test_python_exists (oeqa.runtime.python.PythonTest) ... ok
test_python_stdout (oeqa.runtime.python.PythonTest) ... ok
test_python_testfile (oeqa.runtime.python.PythonTest) ... ok
test_ssh (oeqa.runtime.ssh.SshTest) ... ok
test_df (oeqa.runtime.df.DfTest) ... ok
test_date (oeqa.runtime.date.DateTest) ... ok
test_scp_file (oeqa.runtime.scp.ScpTest) ... ok
test_connmand_help (oeqa.runtime.connman.ConnmanTest) ... ok
test_connmand_running (oeqa.runtime.connman.ConnmanTest) ... ok
test_xorg_running (oeqa.runtime.xorg.XorgTest) ... ok
test_parselogs (oeqa.runtime.parselogs.ParseLogsTest) ... FAIL
test_smart_help (oeqa.runtime.smart.SmartBasicTest) ... ok
test_smart_info (oeqa.runtime.smart.SmartBasicTest) ... ok
test_smart_query (oeqa.runtime.smart.SmartBasicTest) ... ok
test_smart_search (oeqa.runtime.smart.SmartBasicTest) ... ok
test_smart_stats (oeqa.runtime.smart.SmartBasicTest) ... ok
test_smart_version (oeqa.runtime.smart.SmartBasicTest) ... ok
Machine information:
*******************************
Machine name: qemux86-64
CPU: Intel(R) Core(TM)2 Duo CPU T7700 @ 2.40GHz
Arch: x86_64
Physical cores: 1
Logical cores: 1
*******************************
test_smart_add_rpmdir (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_channel (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_channel_add (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_channel_help (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_channel_list (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_channel_rpmsys (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_channel_show (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_install (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_install_dependency (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_install_from_disk (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_install_from_http (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_local_dir (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_reinstall (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_remote_repo (oeqa.runtime.smart.SmartRepoTest) ... ok
test_smart_remove_package (oeqa.runtime.smart.SmartRepoTest) ... ok
test_rpm_help (oeqa.runtime.rpm.RpmBasicTest) ... ok
test_rpm_query (oeqa.runtime.rpm.RpmBasicTest) ... ok
test_check_rpm_install_removal_log_file_size (oeqa.runtime.rpm.RpmInstallRemoveTest) ... ok
test_rpm_install (oeqa.runtime.rpm.RpmInstallRemoveTest) ... ok
test_rpm_query_nonroot (oeqa.runtime.rpm.RpmInstallRemoveTest) ... ok
test_rpm_remove (oeqa.runtime.rpm.RpmInstallRemoveTest) ... ok
test_x32_file (oeqa.runtime.x32lib.X32libTest) ... ok
======================================================================
FAIL: test_parselogs (oeqa.runtime.parselogs.ParseLogsTest)
----------------------------------------------------------------------
Traceback (most recent call last):
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x32/build/meta/lib/oeqa/utils/decorators.py", line 109, in wrapped_f
return func(*args, **kwargs)
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x32/build/meta/lib/oeqa/utils/decorators.py", line 97, in wrapped_f
return f(*args, **kwargs)
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x32/build/meta/lib/oeqa/runtime/parselogs.py", line 277, in test_parselogs
self.assertEqual(errcount, 0, msg=self.msg)
AssertionError: 6 != 0 : Log: dmesg
-----------------------
Central error: [ 49.131865] uvesafb: mode switch failed (eax=0x4f02, err=1)
***********************
[ 12.116609] md: autorun ...
[ 12.121137] md: ... autorun DONE.
[ 13.647229] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
[ 13.658484] VFS: Mounted root (ext4 filesystem) on device 253:0.
[ 13.680773] devtmpfs: mounted
[ 13.775283] Freeing unused kernel memory: 1316K (ffffffff81cc6000 - ffffffff81e0f000)
[ 15.321664] uvesafb: SeaBIOS Developers, SeaBIOS VBE Adapter, Rev. 1, OEM: SeaBIOS VBE(C) 2011, VBE v3.0
[ 15.819083] uvesafb: no monitor limits have been set, default refresh rate will be used
[ 15.837334] uvesafb: scrolling: redraw
[ 49.109088] uvesafb: 5000 ms task timeout error
[ 49.131865] uvesafb: mode switch failed (eax=0x4f02, err=1)
[ 49.132098] fbcon_init: detected unhandled fb_set_par error, error code -22
[ 49.210758] Console: switching to colour frame buffer device 80x30
[ 49.326091] uvesafb: framebuffer at 0xfd000000, mapped to 0xffffc90002000000, using 16384k, total 16384k
[ 49.344519] fb0: VESA VGA frame buffer device
[ 51.548011] udevd[109]: starting version 3.2
[ 51.613080] random: udevd urandom read with 46 bits of entropy available
[ 51.880680] udevd[110]: starting eudev-3.2
[ 92.302077] EXT4-fs (vda): re-mounted. Opts: data=ordered
[ 93.968118] random: nonblocking pool is initialized
[ 169.908835] clocksource: timekeeping watchdog: Marking clocksource 'tsc' as unstable because the skew is too large:
***********************
Central error: [ 49.132098] fbcon_init: detected unhandled fb_set_par error, error code -22
***********************
[ 12.121137] md: ... autorun DONE.
[ 13.647229] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
[ 13.658484] VFS: Mounted root (ext4 filesystem) on device 253:0.
[ 13.680773] devtmpfs: mounted
[ 13.775283] Freeing unused kernel memory: 1316K (ffffffff81cc6000 - ffffffff81e0f000)
[ 15.321664] uvesafb: SeaBIOS Developers, SeaBIOS VBE Adapter, Rev. 1, OEM: SeaBIOS VBE(C) 2011, VBE v3.0
[ 15.819083] uvesafb: no monitor limits have been set, default refresh rate will be used
[ 15.837334] uvesafb: scrolling: redraw
[ 49.109088] uvesafb: 5000 ms task timeout error
[ 49.131865] uvesafb: mode switch failed (eax=0x4f02, err=1)
[ 49.132098] fbcon_init: detected unhandled fb_set_par error, error code -22
[ 49.210758] Console: switching to colour frame buffer device 80x30
[ 49.326091] uvesafb: framebuffer at 0xfd000000, mapped to 0xffffc90002000000, using 16384k, total 16384k
[ 49.344519] fb0: VESA VGA frame buffer device
[ 51.548011] udevd[109]: starting version 3.2
[ 51.613080] random: udevd urandom read with 46 bits of entropy available
[ 51.880680] udevd[110]: starting eudev-3.2
[ 92.302077] EXT4-fs (vda): re-mounted. Opts: data=ordered
[ 93.968118] random: nonblocking pool is initialized
[ 169.908835] clocksource: timekeeping watchdog: Marking clocksource 'tsc' as unstable because the skew is too large:
[ 169.932177] clocksource: 'hpet' wd_now: fd9dd0cb wd_last: ec0756f2 mask: ffffffff
***********************
Central error: [ 49.109088] uvesafb: 5000 ms task timeout error
***********************
[ 12.105936] md: Scanned 0 and added 0 devices.
[ 12.116609] md: autorun ...
[ 12.121137] md: ... autorun DONE.
[ 13.647229] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
[ 13.658484] VFS: Mounted root (ext4 filesystem) on device 253:0.
[ 13.680773] devtmpfs: mounted
[ 13.775283] Freeing unused kernel memory: 1316K (ffffffff81cc6000 - ffffffff81e0f000)
[ 15.321664] uvesafb: SeaBIOS Developers, SeaBIOS VBE Adapter, Rev. 1, OEM: SeaBIOS VBE(C) 2011, VBE v3.0
[ 15.819083] uvesafb: no monitor limits have been set, default refresh rate will be used
[ 15.837334] uvesafb: scrolling: redraw
[ 49.109088] uvesafb: 5000 ms task timeout error
[ 49.131865] uvesafb: mode switch failed (eax=0x4f02, err=1)
[ 49.132098] fbcon_init: detected unhandled fb_set_par error, error code -22
[ 49.210758] Console: switching to colour frame buffer device 80x30
[ 49.326091] uvesafb: framebuffer at 0xfd000000, mapped to 0xffffc90002000000, using 16384k, total 16384k
[ 49.344519] fb0: VESA VGA frame buffer device
[ 51.548011] udevd[109]: starting version 3.2
[ 51.613080] random: udevd urandom read with 46 bits of entropy available
[ 51.880680] udevd[110]: starting eudev-3.2
[ 92.302077] EXT4-fs (vda): re-mounted. Opts: data=ordered
[ 93.968118] random: nonblocking pool is initialized
***********************
Log: dmesg_output.log
-----------------------
Central error: [ 49.131865] uvesafb: mode switch failed (eax=0x4f02, err=1)
***********************
[ 12.116609] md: autorun ...
[ 12.121137] md: ... autorun DONE.
[ 13.647229] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
[ 13.658484] VFS: Mounted root (ext4 filesystem) on device 253:0.
[ 13.680773] devtmpfs: mounted
[ 13.775283] Freeing unused kernel memory: 1316K (ffffffff81cc6000 - ffffffff81e0f000)
[ 15.321664] uvesafb: SeaBIOS Developers, SeaBIOS VBE Adapter, Rev. 1, OEM: SeaBIOS VBE(C) 2011, VBE v3.0
[ 15.819083] uvesafb: no monitor limits have been set, default refresh rate will be used
[ 15.837334] uvesafb: scrolling: redraw
[ 49.109088] uvesafb: 5000 ms task timeout error
[ 49.131865] uvesafb: mode switch failed (eax=0x4f02, err=1)
[ 49.132098] fbcon_init: detected unhandled fb_set_par error, error code -22
[ 49.210758] Console: switching to colour frame buffer device 80x30
[ 49.326091] uvesafb: framebuffer at 0xfd000000, mapped to 0xffffc90002000000, using 16384k, total 16384k
[ 49.344519] fb0: VESA VGA frame buffer device
[ 51.548011] udevd[109]: starting version 3.2
[ 51.613080] random: udevd urandom read with 46 bits of entropy available
[ 51.880680] udevd[110]: starting eudev-3.2
[ 92.302077] EXT4-fs (vda): re-mounted. Opts: data=ordered
[ 93.968118] random: nonblocking pool is initialized
[ 169.908835] clocksource: timekeeping watchdog: Marking clocksource 'tsc' as unstable because the skew is too large:
***********************
Central error: [ 49.132098] fbcon_init: detected unhandled fb_set_par error, error code -22
***********************
[ 12.121137] md: ... autorun DONE.
[ 13.647229] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
[ 13.658484] VFS: Mounted root (ext4 filesystem) on device 253:0.
[ 13.680773] devtmpfs: mounted
[ 13.775283] Freeing unused kernel memory: 1316K (ffffffff81cc6000 - ffffffff81e0f000)
[ 15.321664] uvesafb: SeaBIOS Developers, SeaBIOS VBE Adapter, Rev. 1, OEM: SeaBIOS VBE(C) 2011, VBE v3.0
[ 15.819083] uvesafb: no monitor limits have been set, default refresh rate will be used
[ 15.837334] uvesafb: scrolling: redraw
[ 49.109088] uvesafb: 5000 ms task timeout error
[ 49.131865] uvesafb: mode switch failed (eax=0x4f02, err=1)
[ 49.132098] fbcon_init: detected unhandled fb_set_par error, error code -22
[ 49.210758] Console: switching to colour frame buffer device 80x30
[ 49.326091] uvesafb: framebuffer at 0xfd000000, mapped to 0xffffc90002000000, using 16384k, total 16384k
[ 49.344519] fb0: VESA VGA frame buffer device
[ 51.548011] udevd[109]: starting version 3.2
[ 51.613080] random: udevd urandom read with 46 bits of entropy available
[ 51.880680] udevd[110]: starting eudev-3.2
[ 92.302077] EXT4-fs (vda): re-mounted. Opts: data=ordered
[ 93.968118] random: nonblocking pool is initialized
[ 169.908835] clocksource: timekeeping watchdog: Marking clocksource 'tsc' as unstable because the skew is too large:
[ 169.932177] clocksource: 'hpet' wd_now: fd9dd0cb wd_last: ec0756f2 mask: ffffffff
***********************
Central error: [ 49.109088] uvesafb: 5000 ms task timeout error
***********************
[ 12.105936] md: Scanned 0 and added 0 devices.
[ 12.116609] md: autorun ...
[ 12.121137] md: ... autorun DONE.
[ 13.647229] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
[ 13.658484] VFS: Mounted root (ext4 filesystem) on device 253:0.
[ 13.680773] devtmpfs: mounted
[ 13.775283] Freeing unused kernel memory: 1316K (ffffffff81cc6000 - ffffffff81e0f000)
[ 15.321664] uvesafb: SeaBIOS Developers, SeaBIOS VBE Adapter, Rev. 1, OEM: SeaBIOS VBE(C) 2011, VBE v3.0
[ 15.819083] uvesafb: no monitor limits have been set, default refresh rate will be used
[ 15.837334] uvesafb: scrolling: redraw
[ 49.109088] uvesafb: 5000 ms task timeout error
[ 49.131865] uvesafb: mode switch failed (eax=0x4f02, err=1)
[ 49.132098] fbcon_init: detected unhandled fb_set_par error, error code -22
[ 49.210758] Console: switching to colour frame buffer device 80x30
[ 49.326091] uvesafb: framebuffer at 0xfd000000, mapped to 0xffffc90002000000, using 16384k, total 16384k
[ 49.344519] fb0: VESA VGA frame buffer device
[ 51.548011] udevd[109]: starting version 3.2
[ 51.613080] random: udevd urandom read with 46 bits of entropy available
[ 51.880680] udevd[110]: starting eudev-3.2
[ 92.302077] EXT4-fs (vda): re-mounted. Opts: data=ordered
[ 93.968118] random: nonblocking pool is initialized
***********************
6 errors found in logs.
----------------------------------------------------------------------
Ran 44 tests in 1230.327s
FAILED (failures=1)
NOTE: Stopping logging thread
NOTE: Stop event received
NOTE: Tearing down logging thread
NOTE: Sending SIGTERM to runqemu
DEBUG: Python function do_testimage finished
ERROR: Function failed: core-image-sato - FAILED - check the task log and the ssh log
