DEBUG: Executing python function do_testimage
NOTE: rootfs file: /home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-64-lsb/build/build/tmp/work/qemux86_64-poky-linux/core-image-lsb-sdk/1.0-r0/testimage/core-image-lsb-sdk-qemux86-64-testimage.ext4
NOTE: Qemu log file: /home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-64-lsb/build/build/tmp/work/qemux86_64-poky-linux/core-image-lsb-sdk/1.0-r0/testimage/qemu_boot_log.20150922192444
NOTE: SSH log file: /home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-64-lsb/build/build/tmp/work/qemux86_64-poky-linux/core-image-lsb-sdk/1.0-r0/testimage/ssh_target_log.20150922192444
NOTE: Created listening socket for qemu serial console on: 127.0.0.1:51753
NOTE: Created listening socket for qemu serial console on: 127.0.0.1:37653
NOTE: runqemu started, pid is 2883
NOTE: waiting at most 60 seconds for qemu pid
NOTE: qemu started - qemu procces pid is 2942
NOTE: qemu cmdline used:
/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-64-lsb/build/build/tmp/sysroots/x86_64-linux/usr/bin/qemu-system-x86_64 -kernel /home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-64-lsb/build/build/tmp/deploy/images/qemux86-64/bzImage-qemux86-64.bin -net nic,vlan=0 -net tap,vlan=0,ifname=tap2,script=no,downscript=no -cpu core2duo -drive file=/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-64-lsb/build/build/tmp/work/qemux86_64-poky-linux/core-image-lsb-sdk/1.0-r0/testimage/core-image-lsb-sdk-qemux86-64-testimage.ext4,if=ide,format=raw -show-cursor -usb -usbdevice wacom-tablet -vga vmware -no-reboot -serial tcp:127.0.0.1:51753 -m 256 -serial tcp:127.0.0.1:37653 --append vga=0 uvesafb.mode_option=640x480-32 root=/dev/hda 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: Waiting at most 1500 seconds for login banner
NOTE: Connection from 127.0.0.1:58713
NOTE: Reached login banner
NOTE: Logged as root in serial console
NOTE: Test modules ['oeqa.runtime.ping', 'oeqa.runtime.buildcvs', 'oeqa.runtime.buildiptables', 'oeqa.runtime.buildsudoku', 'oeqa.runtime.connman', 'oeqa.runtime.date', 'oeqa.runtime.df', 'oeqa.runtime.gcc', 'oeqa.runtime.kernelmodule', 'oeqa.runtime.ldd', 'oeqa.runtime.pam', 'oeqa.runtime.parselogs', 'oeqa.runtime.perl', 'oeqa.runtime.python', 'oeqa.runtime.scp', 'oeqa.runtime.smart', 'oeqa.runtime.rpm', 'oeqa.runtime.ssh', 'oeqa.runtime.syslog', 'oeqa.runtime.logrotate']
NOTE: Found 58 tests
test_ping (oeqa.runtime.ping.PingTest) ... ok
--2015-09-22 19:27:50-- http://ftp.gnu.org/non-gnu/cvs/source/feature/1.12.13/cvs-1.12.13.tar.bz2
Resolving ftp.gnu.org (ftp.gnu.org)... 208.118.235.20, 2001:4830:134:3::b
Connecting to ftp.gnu.org (ftp.gnu.org)|208.118.235.20|:80... connected.
HTTP request sent, awaiting response... 200 OK
Length: 3911104 (3.7M) [application/x-bzip2]
Saving to: '/tmp/cvs-1.12.13.tar.bz2'
0K .......... .......... .......... .......... .......... 1% 308K 12s
50K .......... .......... .......... .......... .......... 2% 616K 9s
100K .......... .......... .......... .......... .......... 3% 59.4M 6s
150K .......... .......... .......... .......... .......... 5% 65.0M 4s
200K .......... .......... .......... .......... .......... 6% 624K 5s
250K .......... .......... .......... .......... .......... 7% 58.5M 4s
300K .......... .......... .......... .......... .......... 9% 63.6M 3s
350K .......... .......... .......... .......... .......... 10% 42.7M 3s
400K .......... .......... .......... .......... .......... 11% 643K 3s
450K .......... .......... .......... .......... .......... 13% 67.4M 3s
500K .......... .......... .......... .......... .......... 14% 62.7M 2s
550K .......... .......... .......... .......... .......... 15% 44.2M 2s
600K .......... .......... .......... .......... .......... 17% 49.0M 2s
650K .......... .......... .......... .......... .......... 18% 649K 2s
700K .......... .......... .......... .......... .......... 19% 64.3M 2s
750K .......... .......... .......... .......... .......... 20% 64.5M 2s
800K .......... .......... .......... .......... .......... 22% 64.9M 2s
850K .......... .......... .......... .......... .......... 23% 40.6M 2s
900K .......... .......... .......... .......... .......... 24% 57.9M 1s
950K .......... .......... .......... .......... .......... 26% 647K 2s
1000K .......... .......... .......... .......... .......... 27% 38.0M 2s
1050K .......... .......... .......... .......... .......... 28% 72.7M 1s
1100K .......... .......... .......... .......... .......... 30% 68.8M 1s
1150K .......... .......... .......... .......... .......... 31% 76.0M 1s
1200K .......... .......... .......... .......... .......... 32% 64.2M 1s
1250K .......... .......... .......... .......... .......... 34% 643K 1s
1300K .......... .......... .......... .......... .......... 35% 57.1M 1s
1350K .......... .......... .......... .......... .......... 36% 50.0M 1s
1400K .......... .......... .......... .......... .......... 37% 51.3M 1s
1450K .......... .......... .......... .......... .......... 39% 28.8M 1s
1500K .......... .......... .......... .......... .......... 40% 94.6M 1s
1550K .......... .......... .......... .......... .......... 41% 657K 1s
1600K .......... .......... .......... .......... .......... 43% 50.1M 1s
1650K .......... .......... .......... .......... .......... 44% 66.1M 1s
1700K .......... .......... .......... .......... .......... 45% 41.3M 1s
1750K .......... .......... .......... .......... .......... 47% 65.8M 1s
1800K .......... .......... .......... .......... .......... 48% 38.2M 1s
1850K .......... .......... .......... .......... .......... 49% 657K 1s
1900K .......... .......... .......... .......... .......... 51% 33.0M 1s
1950K .......... .......... .......... .......... .......... 52% 37.8M 1s
2000K .......... .......... .......... .......... .......... 53% 99.1M 1s
2050K .......... .......... .......... .......... .......... 54% 73.0M 1s
2100K .......... .......... .......... .......... .......... 56% 60.0M 1s
2150K .......... .......... .......... .......... .......... 57% 32.4M 1s
2200K .......... .......... .......... .......... .......... 58% 667K 1s
2250K .......... .......... .......... .......... .......... 60% 39.2M 1s
2300K .......... .......... .......... .......... .......... 61% 37.9M 1s
2350K .......... .......... .......... .......... .......... 62% 53.1M 1s
2400K .......... .......... .......... .......... .......... 64% 54.6M 1s
2450K .......... .......... .......... .......... .......... 65% 45.9M 0s
2500K .......... .......... .......... .......... .......... 66% 18.3M 0s
2550K .......... .......... .......... .......... .......... 68% 686K 0s
2600K .......... .......... .......... .......... .......... 69% 30.1M 0s
2650K .......... .......... .......... .......... .......... 70% 23.0M 0s
2700K .......... .......... .......... .......... .......... 72% 55.0M 0s
2750K .......... .......... .......... .......... .......... 73% 58.2M 0s
2800K .......... .......... .......... .......... .......... 74% 39.1M 0s
2850K .......... .......... .......... .......... .......... 75% 47.7M 0s
2900K .......... .......... .......... .......... .......... 77% 684K 0s
2950K .......... .......... .......... .......... .......... 78% 63.9M 0s
3000K .......... .......... .......... .......... .......... 79% 24.8M 0s
3050K .......... .......... .......... .......... .......... 81% 22.8M 0s
3100K .......... .......... .......... .......... .......... 82% 66.7M 0s
3150K .......... .......... .......... .......... .......... 83% 81.2M 0s
3200K .......... .......... .......... .......... .......... 85% 35.5M 0s
3250K .......... .......... .......... .......... .......... 86% 90.4M 0s
3300K .......... .......... .......... .......... .......... 87% 679K 0s
3350K .......... .......... .......... .......... .......... 89% 31.5M 0s
3400K .......... .......... .......... .......... .......... 90% 39.3M 0s
3450K .......... .......... .......... .......... .......... 91% 27.3M 0s
3500K .......... .......... .......... .......... .......... 92% 59.1M 0s
3550K .......... .......... .......... .......... .......... 94% 88.1M 0s
3600K .......... .......... .......... .......... .......... 95% 54.2M 0s
3650K .......... .......... .......... .......... .......... 96% 68.7M 0s
3700K .......... .......... .......... .......... .......... 98% 681K 0s
3750K .......... .......... .......... .......... .......... 99% 43.4M 0s
3800K .......... ......... 100% 41.2M=1.2s
2015-09-22 19:27:52 (3.06 MB/s) - '/tmp/cvs-1.12.13.tar.bz2' saved [3911104/3911104]
test_cvs (oeqa.runtime.buildcvs.BuildCvsTest) ... ok
--2015-09-22 20:20:37-- http://netfilter.org/projects/iptables/files/iptables-1.4.13.tar.bz2
Resolving netfilter.org (netfilter.org)... 150.214.142.167
Connecting to netfilter.org (netfilter.org)|150.214.142.167|:80... connected.
HTTP request sent, awaiting response... 200 OK
Length: 502942 (491K) [application/x-bzip2]
Saving to: '/tmp/iptables-1.4.13.tar.bz2'
0K .......... .......... .......... .......... .......... 10% 103K 4s
50K .......... .......... .......... .......... .......... 20% 206K 3s
100K .......... .......... .......... .......... .......... 30% 36.5M 2s
150K .......... .......... .......... .......... .......... 40% 207K 1s
200K .......... .......... .......... .......... .......... 50% 33.2M 1s
250K .......... .......... .......... .......... .......... 61% 209K 1s
300K .......... .......... .......... .......... .......... 71% 21.1M 0s
350K .......... .......... .......... .......... .......... 81% 53.8M 0s
400K .......... .......... .......... .......... .......... 91% 27.3M 0s
450K .......... .......... .......... .......... . 100% 1.06M=1.3s
2015-09-22 20:20:38 (393 KB/s) - '/tmp/iptables-1.4.13.tar.bz2' saved [502942/502942]
test_iptables (oeqa.runtime.buildiptables.BuildIptablesTest) ... ok
--2015-09-22 20:42:01-- http://downloads.sourceforge.net/project/sudoku-savant/sudoku-savant/sudoku-savant-1.3/sudoku-savant-1.3.tar.bz2
Resolving downloads.sourceforge.net (downloads.sourceforge.net)... 216.34.181.59
Connecting to downloads.sourceforge.net (downloads.sourceforge.net)|216.34.181.59|:80... connected.
HTTP request sent, awaiting response... 302 Found
Location: http://tcpdiag.dl.sourceforge.net/project/sudoku-savant/sudoku-savant/sudoku-savant-1.3/sudoku-savant-1.3.tar.bz2 [following]
--2015-09-22 20:42:01-- http://tcpdiag.dl.sourceforge.net/project/sudoku-savant/sudoku-savant/sudoku-savant-1.3/sudoku-savant-1.3.tar.bz2
Resolving tcpdiag.dl.sourceforge.net (tcpdiag.dl.sourceforge.net)... 69.160.243.51
Connecting to tcpdiag.dl.sourceforge.net (tcpdiag.dl.sourceforge.net)|69.160.243.51|:80... connected.
HTTP request sent, awaiting response... 200 OK
Length: 236435 (231K) [application/octet-stream]
Saving to: '/tmp/sudoku-savant-1.3.tar.bz2'
0K .......... .......... .......... .......... .......... 21% 256K 1s
50K .......... .......... .......... .......... .......... 43% 694K 0s
100K .......... .......... .......... .......... .......... 64% 1.35M 0s
150K .......... .......... .......... .......... .......... 86% 1.35M 0s
200K .......... .......... .......... 100% 860K=0.4s
2015-09-22 20:42:24 (615 KB/s) - '/tmp/sudoku-savant-1.3.tar.bz2' saved [236435/236435]
test_sudoku (oeqa.runtime.buildsudoku.SudokuTest) ... ok
test_connmand_help (oeqa.runtime.connman.ConnmanTest) ... ok
test_connmand_running (oeqa.runtime.connman.ConnmanTest) ... ok
test_only_one_connmand_in_background (oeqa.runtime.connman.ConnmanTest) ... ok
test_date (oeqa.runtime.date.DateTest) ... ok
test_df (oeqa.runtime.df.DfTest) ... ok
test_gcc_compile (oeqa.runtime.gcc.GccCompileTest) ... ok
test_gpp2_compile (oeqa.runtime.gcc.GccCompileTest) ... ok
test_gpp_compile (oeqa.runtime.gcc.GccCompileTest) ... ok
test_make (oeqa.runtime.gcc.GccCompileTest) ... ok
test_kernel_module (oeqa.runtime.kernelmodule.KernelModuleTest) ... ok
test_ldd_exists (oeqa.runtime.ldd.LddTest) ... ok
test_ldd_rtldlist_check (oeqa.runtime.ldd.LddTest) ... ok
test_pam (oeqa.runtime.pam.PamBasicTest) ... 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_perl_exists (oeqa.runtime.perl.PerlTest) ... ok
test_perl_works (oeqa.runtime.perl.PerlTest) ... 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_scp_file (oeqa.runtime.scp.ScpTest) ... 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) ... FAIL
test_smart_remote_repo dump data stored in /tmp/oe-saved-tests/201509222212_test_smart_remote_repo
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_ssh (oeqa.runtime.ssh.SshTest) ... 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 'Non-busybox syslog'
test_syslog_startup_config dump data stored in /tmp/oe-saved-tests/201509222226_test_syslog_startup_config
test_1_logrotate_setup (oeqa.runtime.logrotate.LogrotateTest) ... ok
test_2_logrotate (oeqa.runtime.logrotate.LogrotateTest) ... ok
======================================================================
FAIL: test_smart_remote_repo (oeqa.runtime.smart.SmartRepoTest)
----------------------------------------------------------------------
Traceback (most recent call last):
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-64-lsb/build/meta/lib/oeqa/utils/decorators.py", line 102, in wrapped_f
return func(*args)
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-64-lsb/build/meta/lib/oeqa/utils/decorators.py", line 90, in wrapped_f
return f(*args)
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-64-lsb/build/meta/lib/oeqa/runtime/smart.py", line 136, in test_smart_remote_repo
self.smart('update')
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-64-lsb/build/meta/lib/oeqa/utils/decorators.py", line 90, in wrapped_f
return f(*args)
File "/home/pokybuild/yocto-autobuilder/yocto-worker/nightly-x86-64-lsb/build/meta/lib/oeqa/runtime/smart.py", line 22, in smart
self.assertEqual(status, expected, message)
AssertionError: 1 != 0 : smart update
Loading cache...
Updating cache... ######################################## [100%]
Fetching information for 'all'...
-> http://192.168.7.5:48723/rpm/all/repodata/repomd.xml
repomd.xml ######################################## [ 16%]
Traceback (most recent call last):
File "/usr/bin/smart", line 200, in <module>
Fetching information for 'qemux86_64'...
-> http://192.168.7.5:48723/rpm/qemux86_64/repodata/repomd.xml
repomd.xml ######################################## [ 41%]
main(sys.argv[1:])
File "/usr/bin/smart", line 173, in main
exitcode = iface.run(opts.command, opts.argv)
File "/usr/lib/python2.7/site-packages/smart/interface.py", line 53, in run
result = _command.main(self._ctrl, opts)
File "/usr/lib/python2.7/site-packages/smart/commands/update.py", line 82, in main
failed = not ctrl.reloadChannels(channels, caching=NEVER)
File "/usr/lib/python2.7/site-packages/smart/control.py", line 388, in reloadChannels
if not channel.fetch(self._fetcher, progress):
File "/usr/lib/python2.7/site-packages/smart/channels/rpm_md.py", line 242, in fetch
digest = getFileDigest(item.getTargetPath())
File "/usr/lib/python2.7/site-packages/smart/util/filetools.py", line 34, in getFileDigest
file = open(path)
TypeError: coercing to Unicode: need string or buffer, NoneType found
----------------------------------------------------------------------
Ran 58 tests in 10739.844s
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-lsb-sdk - FAILED - check the task log and the ssh log