Bug#829753: autopkgtest-qemu sometimes exits with error after tar founds unexpected end of file (on a wheezy image)
Santiago Ruano Rincón
santiagorr at riseup.net
Tue Jul 5 19:06:28 UTC 2016
Package: autopkgtest
Version: 4.0.2
Severity: important
Dear Maintainer,
I am running autopkgtest on a wheezy qemu image, but sometimes (I cannot
say when), it fails after tar is unable to extract the input from stdin.
See the attached log.
I have had similar problems in two different unstable machines.
Cheers,
Santiago
-- System Information:
Debian Release: stretch/sid
APT prefers unstable
APT policy: (500, 'unstable'), (500, 'testing')
Architecture: amd64 (x86_64)
Foreign Architectures: i386
Kernel: Linux 4.5.0-2-grsec-amd64 (SMP w/4 CPU cores)
Locale: LANG=es_CO.UTF-8, LC_CTYPE=es_CO.UTF-8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Init: sysvinit (via /sbin/init)
Versions of packages autopkgtest depends on:
ii apt-utils 1.2.14
ii libdpkg-perl 1.18.7
ii procps 2:3.3.11-3
ii python3 3.5.1-4
ii python3-debian 0.1.28
Versions of packages autopkgtest recommends:
ii autodep8 0.6
Versions of packages autopkgtest suggests:
ii lxc 1:2.0.1-3
pn lxd-client <none>
ii qemu-system 1:2.6+dfsg-3
ii qemu-utils 1:2.6+dfsg-3
ii schroot 1.6.10-2
-- no debconf information
-------------- next part --------------
autopkgtest [20:48:45]: version 4.0.2
autopkgtest [20:48:45]: host nomada; command line: /usr/bin/autopkgtest --output-dir /tmp/output-dir '/home/santiago/debian/pkgs/result/squid3_3.1.20-2.2+deb7u6~1~autopkgtests1_amd64.changes' -- qemu --debug /home/santiago/autopkgtest-wheezy.img
qemu: DBG: executing open
qemu: DBG: Creating temporary overlay image in /tmp/autopkgtest-qemu.7xoa2nht/overlay.img
qemu: DBG: execute-timeout: qemu-img create -f qcow2 -b /home/santiago/autopkgtest-wheezy.img /tmp/autopkgtest-qemu.7xoa2nht/overlay.img
qemu: DBG: find_free_port: trying 10022
qemu: DBG: find_free_port: 10022 is free
qemu: DBG: Forwarding local port 10022 to VM ssh port 22
qemu: DBG: Detected KVM capable Intel host CPU, enabling nested KVM
qemu: DBG: expect: " login: "
warning: host doesn't support requested feature: CPUID.01H:ECX.vmx [bit 5]
qemu: DBG: expect: found ""login prompt on ttyS0""
qemu: DBG: expect: "ok"
qemu: DBG: expect: found ""b'ok'""
qemu: DBG: setup_shell(): there already is a shell on ttyS1
qemu: DBG: expect: "#"
qemu: DBG: expect: found ""b'#'""
qemu: DBG: expect: "(qemu)"
qemu: DBG: expect: found ""b'(qemu)'""
qemu: DBG: expect: "(qemu)"
qemu: DBG: expect: found ""b'(qemu)'""
qemu: DBG: expect: "#"
qemu: DBG: expect: found ""b'#'""
qemu: DBG: expect: "#"
qemu: DBG: expect: found ""b'#'""
qemu: DBG: expect: "#"
qemu: DBG: expect: found ""b'#'""
qemu: DBG: Copying host timezone Europe/Paris to VM
qemu: DBG: expect: "#"
qemu: DBG: expect: found ""b'#'""
qemu: DBG: expect: "/python"
qemu: DBG: expect: found ""b'/python'""
qemu: DBG: expect: "# "
qemu: DBG: expect: found ""b'# '""
qemu: DBG: expect: "# "
qemu: DBG: expect: found ""b'# '""
qemu: DBG: execute-timeout: /tmp/autopkgtest-qemu.7xoa2nht/runcmd true
qemu: DBG: can connect to autopkgtest sh in VM
qemu: DBG: determine_normal_user: got user "test"
qemu: DBG: auxverb = ['/tmp/autopkgtest-qemu.7xoa2nht/runcmd'], downtmp = None
qemu: DBG: execute-timeout: /tmp/autopkgtest-qemu.7xoa2nht/runcmd mktemp --directory --tmpdir autopkgtest.XXXXXX
qemu: DBG: execute-timeout: /tmp/autopkgtest-qemu.7xoa2nht/runcmd chmod 1777 /tmp/autopkgtest.KOHLXq
qemu: DBG: executing print-execute-command
qemu: DBG: executing capabilities
autopkgtest [20:48:57]: testbed dpkg architecture: amd64
qemu: DBG: executing copyup /tmp/autopkgtest.KOHLXq/testbed-packages /tmp/output-dir/testbed-packages
qemu: DBG: ['cmdls', "(['/tmp/autopkgtest-qemu.7xoa2nht/runcmd', 'sh', '-ec', 'cat </tmp/autopkgtest.KOHLXq/testbed-packages'], ['cat'])"]
qemu: DBG: ['srcstdin', "<_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>", 'deststdout', "<_io.TextIOWrapper name='/tmp/output-dir/testbed-packages' mode='w' encoding='UTF-8'>", 'devnull_read', <_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>]
qemu: DBG: +< /tmp/autopkgtest-qemu.7xoa2nht/runcmd sh -ec cat </tmp/autopkgtest.KOHLXq/testbed-packages
qemu: DBG: +> cat
qemu: DBG: +>?
qemu: DBG: +<?
autopkgtest [20:49:00]: testbed running kernel: Linux 3.2.0-4-amd64 #1 SMP Debian 3.2.78-1
autopkgtest [20:49:00]: @@@@@@@@@@@@@@@@@@@@ source /home/santiago/debian/pkgs/result/squid3_3.1.20-2.2+deb7u6~1~autopkgtests1.dsc
qemu: DBG: executing copydown /home/santiago/debian/pkgs/result/squid3_3.1.20-2.2%2Bdeb7u6%7E1%7Eautopkgtests1.dsc /tmp/autopkgtest.KOHLXq/squid3_3.1.20-2.2%2Bdeb7u6%7E1%7Eautopkgtests1.dsc
qemu: DBG: ['cmdls', '([\'cat\'], [\'/tmp/autopkgtest-qemu.7xoa2nht/runcmd\', \'sh\', \'-ec\', "cat >\'/tmp/autopkgtest.KOHLXq/squid3_3.1.20-2.2+deb7u6~1~autopkgtests1.dsc\'"])']
qemu: DBG: ['srcstdin', "<_io.TextIOWrapper name='/home/santiago/debian/pkgs/result/squid3_3.1.20-2.2+deb7u6~1~autopkgtests1.dsc' mode='r' encoding='UTF-8'>", 'deststdout', "<_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>", 'devnull_read', <_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>]
qemu: DBG: +< cat
qemu: DBG: +> /tmp/autopkgtest-qemu.7xoa2nht/runcmd sh -ec cat >'/tmp/autopkgtest.KOHLXq/squid3_3.1.20-2.2+deb7u6~1~autopkgtests1.dsc'
qemu: DBG: +>?
qemu: DBG: +<?
qemu: DBG: executing copydown /home/santiago/debian/pkgs/result/squid3_3.1.20.orig.tar.gz /tmp/autopkgtest.KOHLXq/squid3_3.1.20.orig.tar.gz
qemu: DBG: ['cmdls', "(['cat'], ['/tmp/autopkgtest-qemu.7xoa2nht/runcmd', 'sh', '-ec', 'cat >/tmp/autopkgtest.KOHLXq/squid3_3.1.20.orig.tar.gz'])"]
qemu: DBG: ['srcstdin', "<_io.TextIOWrapper name='/home/santiago/debian/pkgs/result/squid3_3.1.20.orig.tar.gz' mode='r' encoding='UTF-8'>", 'deststdout', "<_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>", 'devnull_read', <_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>]
qemu: DBG: +< cat
qemu: DBG: +> /tmp/autopkgtest-qemu.7xoa2nht/runcmd sh -ec cat >/tmp/autopkgtest.KOHLXq/squid3_3.1.20.orig.tar.gz
qemu: DBG: +>?
qemu: DBG: +<?
qemu: DBG: executing copydown /home/santiago/debian/pkgs/result/squid3_3.1.20-2.2%2Bdeb7u6%7E1%7Eautopkgtests1.debian.tar.gz /tmp/autopkgtest.KOHLXq/squid3_3.1.20-2.2%2Bdeb7u6%7E1%7Eautopkgtests1.debian.tar.gz
qemu: DBG: ['cmdls', '([\'cat\'], [\'/tmp/autopkgtest-qemu.7xoa2nht/runcmd\', \'sh\', \'-ec\', "cat >\'/tmp/autopkgtest.KOHLXq/squid3_3.1.20-2.2+deb7u6~1~autopkgtests1.debian.tar.gz\'"])']
qemu: DBG: ['srcstdin', "<_io.TextIOWrapper name='/home/santiago/debian/pkgs/result/squid3_3.1.20-2.2+deb7u6~1~autopkgtests1.debian.tar.gz' mode='r' encoding='UTF-8'>", 'deststdout', "<_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>", 'devnull_read', <_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>]
qemu: DBG: +< cat
qemu: DBG: +> /tmp/autopkgtest-qemu.7xoa2nht/runcmd sh -ec cat >'/tmp/autopkgtest.KOHLXq/squid3_3.1.20-2.2+deb7u6~1~autopkgtests1.debian.tar.gz'
qemu: DBG: +>?
qemu: DBG: +<?
qemu: DBG: executing copydown /tmp/output-dir/autopkgtest-satdep.deb /tmp/autopkgtest.KOHLXq/autopkgtest-satdep.deb
qemu: DBG: ['cmdls', "(['cat'], ['/tmp/autopkgtest-qemu.7xoa2nht/runcmd', 'sh', '-ec', 'cat >/tmp/autopkgtest.KOHLXq/autopkgtest-satdep.deb'])"]
qemu: DBG: ['srcstdin', "<_io.TextIOWrapper name='/tmp/output-dir/autopkgtest-satdep.deb' mode='r' encoding='UTF-8'>", 'deststdout', "<_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>", 'devnull_read', <_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>]
qemu: DBG: +< cat
qemu: DBG: +> /tmp/autopkgtest-qemu.7xoa2nht/runcmd sh -ec cat >/tmp/autopkgtest.KOHLXq/autopkgtest-satdep.deb
qemu: DBG: +>?
qemu: DBG: +<?
Reading package lists...
Building dependency tree...
Reading state information...
Correcting dependencies...Starting
Starting 2
Done
Done
Starting
Starting 2
Done
The following extra packages will be installed:
binutils bzip2 dpkg-dev libclass-isa-perl libdpkg-perl libswitch-perl
libtimedate-perl make patch perl perl-modules
Suggested packages:
binutils-doc bzip2-doc debian-keyring make-doc ed diffutils-doc perl-doc
libterm-readline-gnu-perl libterm-readline-perl-perl libpod-plainer-perl
Recommended packages:
gcc c-compiler build-essential fakeroot libalgorithm-merge-perl
libfile-fcntllock-perl
The following NEW packages will be installed:
binutils bzip2 dpkg-dev libclass-isa-perl libdpkg-perl libswitch-perl
libtimedate-perl make patch perl perl-modules
0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded.
1 not fully installed or removed.
Need to get 15.6 MB of archives.
After this operation, 52.3 MB of additional disk space will be used.
Get:1 http://httpredir.debian.org/debian/ wheezy/main libswitch-perl all 2.16-2 [21.0 kB]
Get:2 http://httpredir.debian.org/debian/ wheezy/main libclass-isa-perl all 0.36-3 [12.3 kB]
Get:3 http://httpredir.debian.org/debian/ wheezy/main perl-modules all 5.14.2-21+deb7u3 [3444 kB]
Get:4 http://httpredir.debian.org/debian/ wheezy/main libtimedate-perl all 1.2000-1 [41.2 kB]
Get:5 http://httpredir.debian.org/debian/ wheezy/main perl amd64 5.14.2-21+deb7u3 [4429 kB]
Get:6 http://httpredir.debian.org/debian/ wheezy/main libdpkg-perl all 1.16.18 [966 kB]
Get:7 http://httpredir.debian.org/debian/ wheezy/main patch amd64 2.6.1-3 [121 kB]
Get:8 http://httpredir.debian.org/debian/ wheezy/main make amd64 3.81-8.2 [396 kB]
Get:9 http://httpredir.debian.org/debian/ wheezy/main bzip2 amd64 1.0.6-4 [50.1 kB]
Get:10 http://httpredir.debian.org/debian/ wheezy/main binutils amd64 2.22-8+deb7u2 [4793 kB]
Get:11 http://httpredir.debian.org/debian/ wheezy/main dpkg-dev all 1.16.18 [1366 kB]
Fetched 15.6 MB in 1s (8542 kB/s)
Selecting previously unselected package libswitch-perl.
(Reading database ... 13764 files and directories currently installed.)
Unpacking libswitch-perl (from .../libswitch-perl_2.16-2_all.deb) ...
Selecting previously unselected package libclass-isa-perl.
Unpacking libclass-isa-perl (from .../libclass-isa-perl_0.36-3_all.deb) ...
Selecting previously unselected package perl-modules.
Unpacking perl-modules (from .../perl-modules_5.14.2-21+deb7u3_all.deb) ...
Selecting previously unselected package perl.
Unpacking perl (from .../perl_5.14.2-21+deb7u3_amd64.deb) ...
Selecting previously unselected package libtimedate-perl.
Unpacking libtimedate-perl (from .../libtimedate-perl_1.2000-1_all.deb) ...
Selecting previously unselected package libdpkg-perl.
Unpacking libdpkg-perl (from .../libdpkg-perl_1.16.18_all.deb) ...
Selecting previously unselected package bzip2.
Unpacking bzip2 (from .../bzip2_1.0.6-4_amd64.deb) ...
Selecting previously unselected package patch.
Unpacking patch (from .../patch_2.6.1-3_amd64.deb) ...
Selecting previously unselected package make.
Unpacking make (from .../make_3.81-8.2_amd64.deb) ...
Selecting previously unselected package binutils.
Unpacking binutils (from .../binutils_2.22-8+deb7u2_amd64.deb) ...
Selecting previously unselected package dpkg-dev.
Unpacking dpkg-dev (from .../dpkg-dev_1.16.18_all.deb) ...
Processing triggers for man-db ...
Setting up libclass-isa-perl (0.36-3) ...
Setting up bzip2 (1.0.6-4) ...
Setting up patch (2.6.1-3) ...
Setting up make (3.81-8.2) ...
Setting up binutils (2.22-8+deb7u2) ...
Setting up libswitch-perl (2.16-2) ...
Setting up perl-modules (5.14.2-21+deb7u3) ...
Setting up perl (5.14.2-21+deb7u3) ...
update-alternatives: using /usr/bin/prename to provide /usr/bin/rename (rename) in auto mode
Setting up libtimedate-perl (1.2000-1) ...
Setting up libdpkg-perl (1.16.18) ...
Setting up dpkg-dev (1.16.18) ...
Setting up autopkgtest-satdep (0) ...
(Reading database ... 15905 files and directories currently installed.)
Removing autopkgtest-satdep ...
dpkg-source: warning: extracting unsigned source package (/tmp/autopkgtest.KOHLXq/squid3_3.1.20-2.2+deb7u6~1~autopkgtests1.dsc)
dpkg-source: info: extracting squid3 in squid3-3.1.20
dpkg-source: info: unpacking squid3_3.1.20.orig.tar.gz
dpkg-source: info: unpacking squid3_3.1.20-2.2+deb7u6~1~autopkgtests1.debian.tar.gz
dpkg-source: info: applying 01-cf.data.debian.patch
dpkg-source: info: applying 02-makefile-defaults.patch
dpkg-source: info: applying 15-cachemgr-default-config.patch
dpkg-source: info: applying 20-ipv6-fix
dpkg-source: info: applying 30-CVE-2012-5643-CVE-2013-0189.patch
dpkg-source: info: applying fix-701123-regression-in-cachemgr.patch
dpkg-source: info: applying fix-712754-assertion-failure-commHandleRead.patch
dpkg-source: info: applying CVE-2014-3609.patch
dpkg-source: info: applying CVE-2015-5400.patch
dpkg-source: info: applying CVE-2016-2571.patch
dpkg-source: info: applying squid31-CVE-2016-4051.patch
dpkg-source: info: applying squid31-CVE-2016-4051-cachemgr-MemBuf.patch
dpkg-source: info: applying squid31-CVE-2016-4052-CVE-2016-4053-CVE-2016-4054.patch
dpkg-source: info: applying CVE-2016-4553.patch
dpkg-source: info: applying CVE-2016-4554.patch
dpkg-source: info: applying CVE-2016-4554-2.patch
dpkg-source: info: applying CVE-2016-4555+CVE-2016-4556.patch
autopkgtest [20:49:16]: testing package squid3 version 3.1.20-2.2+deb7u6~1~autopkgtests1
autopkgtest [20:49:16]: build not needed
qemu: DBG: executing copyup /tmp/autopkgtest.KOHLXq/build.nnE/squid3-3.1.20/ /tmp/output-dir/tests-tree/
qemu: DBG: ['cmdls', "(['/tmp/autopkgtest-qemu.7xoa2nht/runcmd', 'sh', '-ec', 'cd /tmp/autopkgtest.KOHLXq/build.nnE/squid3-3.1.20/; tar --warning=none -c . -f -'], ['tar', '--directory', '/tmp/output-dir/tests-tree/', '--warning=none', '--preserve-permissions', '--extract', '--no-same-owner', '-f', '-'])"]
qemu: DBG: ['srcstdin', "<_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>", 'deststdout', "<_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>", 'devnull_read', <_io.TextIOWrapper name='/dev/null' mode='r' encoding='UTF-8'>]
qemu: DBG: +< /tmp/autopkgtest-qemu.7xoa2nht/runcmd sh -ec cd /tmp/autopkgtest.KOHLXq/build.nnE/squid3-3.1.20/; tar --warning=none -c . -f -
qemu: DBG: +> tar --directory /tmp/output-dir/tests-tree/ --warning=none --preserve-permissions --extract --no-same-owner -f -
qemu: DBG: +>?
tar: Fin de fichero inesperado en el archivo
tar: Fin de fichero inesperado en el archivo
tar: Error is not recoverable: exiting now
qemu: DBG: cleanup...
qemu-system-x86_64: terminating on signal 15 from pid 17295
<VirtSubproc>: failure: copyup destination failed, status 2
autopkgtest [20:49:18]: ERROR: testbed failure: cannot send to testbed: ['BrokenPipeError: [Errno 32] Broken pipe\n']
More information about the autopkgtest-devel
mailing list