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.20160115105551
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.20160115105551
NOTE: Created listening socket for qemu serial console on: 127.0.0.1:45028
NOTE: Created listening socket for qemu serial console on: 127.0.0.1:40302
NOTE: runqemu started, pid is 10795
NOTE: waiting at most 60 seconds for qemu pid
NOTE: qemu started - qemu procces pid is 10861
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=tap2,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-usbdevicewacom-tablet-vgavmware-no-reboot-serialtcp:127.0.0.1:45028-m256-serialtcp:127.0.0.1:40302--appendvga=0 uvesafb.mode_option=640x480-32 root=/dev/vda rw mem=256M ip=192.168.7.6::192.168.7.5:255.255.255.0 oprofile.timer=1 rootfstype=ext4 console=tty1 console=ttyS0,115200n8
NOTE: Target IP: 192.168.7.6
NOTE: Server IP: 192.168.7.5
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...
Acquiring lockfile for tap1...
Acquiring lockfile for tap2...
Using preconfigured tap device 'tap2'
If this is not intended, touch /tmp/qemu-tap-locks/tap2.skip to make runqemu skip tap2.
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=tap2,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 wacom-tablet -vga vmware -no-reboot -serial tcp:127.0.0.1:45028 -m 256 -serial tcp:127.0.0.1:40302 --append "vga=0 uvesafb.mode_option=640x480-32 root=/dev/vda rw mem=256M ip=192.168.7.6::192.168.7.5:255.255.255.0 oprofile.timer=1 rootfstype=ext4 console=tty1 console=ttyS0,115200n8"
NOTE: Waiting at most 1500 seconds for login banner
NOTE: Connection from 127.0.0.1:38990
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.dmesg', 'oeqa.runtime.parselogs', 'oeqa.runtime.smart', 'oeqa.runtime.rpm', 'oeqa.runtime.python', 'oeqa.runtime.systemd']
NOTE: Found 52 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_dmesg (oeqa.runtime.dmesg.DmesgTest) ... 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
*******************************
ok
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) ... FAIL
test_systemd_failed dump data stored in /tmp/oe-saved-tests/201601151117_test_systemd_failed
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) ... FAIL
test_systemd_status dump data stored in /tmp/oe-saved-tests/201601151118_test_systemd_status
test_systemd_stop_start (oeqa.runtime.systemd.SystemdServiceTests) ... skipped 'Testcase dependency not met: test_systemd_status'
======================================================================
FAIL: test_systemd_failed (oeqa.runtime.systemd.SystemdBasicTests)
----------------------------------------------------------------------
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/systemd.py", line 65, in test_systemd_failed
self.assertTrue(match, msg="Some systemd units failed:\n%s" % output)
AssertionError: None is not true : Some systemd units failed:
UNIT LOAD ACTIVE SUB DESCRIPTION
? avahi-daemon.service loaded failed failed Avahi mDNS/DNS-SD Stack
? bluetooth.service loaded failed failed Bluetooth service
? ofono.service loaded failed failed Telephony service
? wpa_supplicant.service loaded failed failed WPA supplicant
LOAD = Reflects whether the unit definition was properly loaded.
ACTIVE = The high-level unit activation state, i.e. generalization of SUB.
SUB = The low-level unit activation state, values depend on unit type.
4 loaded units listed. Pass --all to see loaded but inactive units, too.
To show all installed unit files use 'systemctl list-unit-files'.? qemux86-64
State: degraded
Jobs: 0 queued
Failed: 4 units
Since: Fri 2016-01-15 10:56:44 UTC; 21min ago
CGroup: /
?? 1 /sbin/init
??80 /sbin/v86d
??system.slice
??dbus.service
? ??280 /usr/bin/dbus-daemon --system --address=systemd: --nofork --nopidfile --systemd-activation
??distcc.service
? ??495 /usr/bin/distccd --verbose --no-detach --daemon --allow 192.168.7.0/24
? ??503 /usr/bin/distccd --verbose --no-detach --daemon --allow 192.168.7.0/24
? ??507 /usr/bin/distccd --verbose --no-detach --daemon --allow 192.168.7.0/24
? ??510 /usr/bin/distccd --verbose --no-detach --daemon --allow 192.168.7.0/24
??busybox-klogd.service
? ??251 /sbin/klogd -n
??system-serial\x2dgetty.slice
? ??serial-getty@ttyS1.service
? ? ??498 -sh
? ??serial-getty@ttyS0.service
? ??497 /sbin/agetty -8 -L --keep-baud ttyS0 115200 xterm
??systemd-journald.service
? ??78 /lib/systemd/systemd-journald
??connman.service
? ??430 /usr/sbin/connmand -n
??systemd-timesyncd.service
? ??662 /lib/systemd/systemd-timesyncd
??systemd-logind.service
? ??499 /lib/systemd/systemd-logind
??system-getty.slice
? ??getty@tty1.service
? ??275 /sbin/agetty --noclear tty1 linux
??systemd-udevd.service
? ??101 /lib/systemd/systemd-udevd
??busybox-syslog.service
? ??582 /sbin/syslogd -n -C
??system-dropbear.slice
? ??dropbear@13-192.168.7.6:22-192.168.7.5:37914.service
? ? ??617 x11vnc -display :0 -bg -o x11vnc.log
? ??dropbear@135-192.168.7.6:22-192.168.7.5:38055.service
? ??1773 /usr/sbin/dropbear -i -r /etc/dropbear/dropbear_rsa_host_key -B
? ??1774 sh -c . /etc/profile; systemctl status --full --failed
? ??1775 systemctl status --full --failed
??xserver-nodm.service
??264 xinit /etc/X11/Xsession -- /usr/bin/Xorg :0 -br -pn
??292 /usr/bin/Xorg :0 -br -pn
??353 matchbox-window-manager -theme Sato -use_desktop_mode decorated -use_cursor no
??358 dbus-launch --sh-syntax --exit-with-session
??359 /usr/bin/dbus-daemon --fork --print-pid 4 --print-address 6 --session
??376 connman-applet
??386 /usr/lib/gconf/gconfd-2
??401 matchbox-desktop
??402 matchbox-panel --titlebar --start-applets showdesktop,windowselector --end-applets clock,battery,,systray,startup-notify,notify
??403 /usr/bin/settings-daemon
======================================================================
FAIL: test_systemd_status (oeqa.runtime.systemd.SystemdServiceTests)
----------------------------------------------------------------------
Traceback (most recent call last):
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/systemd.py", line 77, in test_systemd_status
self.systemctl('status --full', 'avahi-daemon.service')
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-qa-systemd/build/meta/lib/oeqa/runtime/systemd.py", line 21, in systemctl
self.assertEqual(status, expected, message)
AssertionError: 3 != 0 : systemctl status --full avahi-daemon.service
? avahi-daemon.service - Avahi mDNS/DNS-SD Stack
Loaded: loaded (/lib/systemd/system/avahi-daemon.service; enabled; vendor preset: enabled)
Active: failed (Result: timeout) since Fri 2016-01-15 10:58:55 UTC; 19min ago
Main PID: 262 (code=exited, status=0/SUCCESS)
Status: "avahi-daemon 0.6.31 starting up."
Jan 15 10:58:23 qemux86-64 avahi-daemon[262]: Server startup complete. Host name is qemux86-64.local. Local service cookie is 3756040364.
Jan 15 10:58:24 qemux86-64 avahi-daemon[262]: Service "qemux86-64" (/services/ssh.service) successfully established.
Jan 15 10:58:24 qemux86-64 avahi-daemon[262]: Service "qemux86-64" (/services/sftp-ssh.service) successfully established.
Jan 15 10:58:55 qemux86-64 systemd[1]: avahi-daemon.service: Start operation timed out. Terminating.
Jan 15 10:58:55 qemux86-64 avahi-daemon[262]: Got SIGTERM, quitting.
Jan 15 10:58:55 qemux86-64 avahi-daemon[262]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.7.6.
Jan 15 10:58:55 qemux86-64 avahi-daemon[262]: avahi-daemon 0.6.31 exiting.
Jan 15 10:58:55 qemux86-64 systemd[1]: Failed to start Avahi mDNS/DNS-SD Stack.
Jan 15 10:58:55 qemux86-64 systemd[1]: avahi-daemon.service: Unit entered failed state.
Jan 15 10:58:55 qemux86-64 systemd[1]: avahi-daemon.service: Failed with result 'timeout'.
----------------------------------------------------------------------
Ran 52 tests in 1221.654s
FAILED (failures=2, skipped=2)
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
