DEBUG: Executing python function do_testimage
NOTE: rootfs file: /home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/build/tmp/work/qemux86_64-poky-linux/core-image-sato/1.0-r0/testimage/core-image-sato-qemux86-64-testimage.ext4
NOTE: Qemu log file: /home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/build/tmp/work/qemux86_64-poky-linux/core-image-sato/1.0-r0/testimage/qemu_boot_log.20151208064014
NOTE: SSH log file: /home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/build/tmp/work/qemux86_64-poky-linux/core-image-sato/1.0-r0/testimage/ssh_target_log.20151208064014
NOTE: Created listening socket for qemu serial console on: 127.0.0.1:43250
NOTE: Created listening socket for qemu serial console on: 127.0.0.1:53354
NOTE: runqemu started, pid is 26326
NOTE: waiting at most 60 seconds for qemu pid
NOTE: qemu started - qemu procces pid is 26391
NOTE: qemu cmdline used:
/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/build/tmp/sysroots/x86_64-linux/usr/bin/qemu-system-x86_64-kernel/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/build/tmp/deploy/images/qemux86-64/bzImage-qemux86-64.bin-netnic,model=virtio-nettap,vlan=0,ifname=tap0,script=no,downscript=no-cpucore2duo-drivefile=/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/build/tmp/work/qemux86_64-poky-linux/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:43250-m256-serialtcp:127.0.0.1:53354--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: [/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/build/tmp/deploy/images/qemux86-64/bzImage-qemux86-64.bin]
ROOTFS: [/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/build/tmp/work/qemux86_64-poky-linux/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...
/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/build/tmp/sysroots/x86_64-linux/usr/bin/qemu-system-x86_64 -kernel /home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/build/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=/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/build/tmp/work/qemux86_64-poky-linux/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:43250 -m 256 -serial tcp:127.0.0.1:53354 --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"
NOTE: Waiting at most 1500 seconds for login banner
NOTE: Connection from 127.0.0.1:44039
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.connman', 'oeqa.runtime.syslog', 'oeqa.runtime.xorg', 'oeqa.runtime.scp', 'oeqa.runtime.vnc', 'oeqa.runtime.date', 'oeqa.runtime.parselogs', 'oeqa.runtime.smart', 'oeqa.runtime.rpm', 'oeqa.runtime.python', 'oeqa.runtime.systemd']
NOTE: Found 51 tests
test_ping (oeqa.runtime.ping.PingTest) ... ok
test_ssh (oeqa.runtime.ssh.SshTest) ... ok
test_df (oeqa.runtime.df.DfTest) ... ok
test_connmand_help (oeqa.runtime.connman.ConnmanTest) ... ok
test_connmand_running (oeqa.runtime.connman.ConnmanTest) ... 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) ... skipped 'Not appropiate for systemd image'
test_xorg_running (oeqa.runtime.xorg.XorgTest) ... ok
test_scp_file (oeqa.runtime.scp.ScpTest) ... ok
test_vnc (oeqa.runtime.vnc.VNCTest) ... ok
test_date (oeqa.runtime.date.DateTest) ... ok
test_parselogs (oeqa.runtime.parselogs.ParseLogsTest) ... 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
*******************************
FAIL
test_parselogs dump data stored in /tmp/oe-saved-tests/201512080644_test_parselogs
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
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_python_exists (oeqa.runtime.python.PythonTest) ... ok
test_python_stdout (oeqa.runtime.python.PythonTest) ... ok
test_python_testfile (oeqa.runtime.python.PythonTest) ... ok
test_systemd_basic (oeqa.runtime.systemd.SystemdBasicTests) ... ok
test_systemd_failed (oeqa.runtime.systemd.SystemdBasicTests) ... ok
test_systemd_list (oeqa.runtime.systemd.SystemdBasicTests) ... ok
test_systemd_journal (oeqa.runtime.systemd.SystemdJournalTests) ... ok
test_systemd_disable_enable (oeqa.runtime.systemd.SystemdServiceTests) ... ok
test_systemd_status (oeqa.runtime.systemd.SystemdServiceTests) ... ok
test_systemd_stop_start (oeqa.runtime.systemd.SystemdServiceTests) ... ok
======================================================================
FAIL: test_parselogs (oeqa.runtime.parselogs.ParseLogsTest)
----------------------------------------------------------------------
Traceback (most recent call last):
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/meta/lib/oeqa/utils/decorators.py", line 106, in wrapped_f
return func(*args, **kwargs)
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/meta/lib/oeqa/utils/decorators.py", line 94, in wrapped_f
return f(*args, **kwargs)
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/meta/lib/oeqa/runtime/parselogs.py", line 254, in test_parselogs
self.assertEqual(errcount, 0, msg=self.msg)
AssertionError: 2 != 0 : Log: dmesg_output.log
-----------------------
Central error: [ 25.630928] uvesafb: mode switch failed (eax=0x4f02, err=1)
***********************
[ 18.759981] EXT4-fs (vda): re-mounted. Opts: (null)
[ 18.853306] systemd[1]: Created slice system-getty.slice.
[ 19.644690] systemd[1]: Mounted POSIX Message Queue File System.
[ 19.721811] systemd[1]: Mounted Debug File System.
[ 19.754400] systemd[1]: Mounted Temporary Directory.
[ 19.965656] systemd[1]: Started Setup Virtual Console.
[ 20.066847] systemd[1]: Started Create list of required static device nodes for the current kernel.
[ 20.165234] uvesafb: no monitor limits have been set, default refresh rate will be used
[ 20.208035] systemd[1]: Started Remount Root and Kernel File Systems.
[ 20.215677] uvesafb: scrolling: redraw
[ 25.630928] uvesafb: mode switch failed (eax=0x4f02, err=1)
[ 25.631149] fbcon_init: detected unhandled fb_set_par error, error code -22
[ 25.688472] Console: switching to colour frame buffer device 80x30
[ 25.714573] uvesafb: framebuffer at 0xfd000000, mapped to 0xffffc90002000000, using 16384k, total 16384k
[ 25.720115] fb0: VESA VGA frame buffer device
[ 25.899880] systemd[1]: Started Load Kernel Modules.
[ 26.515469] systemd[1]: Starting Apply Kernel Variables...
[ 26.629031] systemd[1]: Mounting NFSD configuration filesystem...
[ 26.808965] systemd[1]: Starting Rebuild Dynamic Linker Cache...
[ 26.994558] systemd[1]: Starting Create System Users...
[ 27.325425] systemd[1]: Starting Rebuild Hardware Database...
***********************
Central error: [ 25.631149] fbcon_init: detected unhandled fb_set_par error, error code -22
***********************
[ 18.853306] systemd[1]: Created slice system-getty.slice.
[ 19.644690] systemd[1]: Mounted POSIX Message Queue File System.
[ 19.721811] systemd[1]: Mounted Debug File System.
[ 19.754400] systemd[1]: Mounted Temporary Directory.
[ 19.965656] systemd[1]: Started Setup Virtual Console.
[ 20.066847] systemd[1]: Started Create list of required static device nodes for the current kernel.
[ 20.165234] uvesafb: no monitor limits have been set, default refresh rate will be used
[ 20.208035] systemd[1]: Started Remount Root and Kernel File Systems.
[ 20.215677] uvesafb: scrolling: redraw
[ 25.630928] uvesafb: mode switch failed (eax=0x4f02, err=1)
[ 25.631149] fbcon_init: detected unhandled fb_set_par error, error code -22
[ 25.688472] Console: switching to colour frame buffer device 80x30
[ 25.714573] uvesafb: framebuffer at 0xfd000000, mapped to 0xffffc90002000000, using 16384k, total 16384k
[ 25.720115] fb0: VESA VGA frame buffer device
[ 25.899880] systemd[1]: Started Load Kernel Modules.
[ 26.515469] systemd[1]: Starting Apply Kernel Variables...
[ 26.629031] systemd[1]: Mounting NFSD configuration filesystem...
[ 26.808965] systemd[1]: Starting Rebuild Dynamic Linker Cache...
[ 26.994558] systemd[1]: Starting Create System Users...
[ 27.325425] systemd[1]: Starting Rebuild Hardware Database...
[ 27.945129] systemd[1]: Mounted NFSD configuration filesystem.
***********************
2 errors found in logs.
----------------------------------------------------------------------
Ran 51 tests in 1330.702s
FAILED (failures=1, skipped=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