<86>Feb 15 09:47:21 userdel[11611]: delete user 'rooter' <86>Feb 15 09:47:21 userdel[11611]: removed group 'rooter' owned by 'rooter' <86>Feb 15 09:47:21 userdel[11611]: removed shadow group 'rooter' owned by 'rooter' <86>Feb 15 09:47:21 groupadd[11656]: group added to /etc/group: name=rooter, GID=609 <86>Feb 15 09:47:21 groupadd[11656]: group added to /etc/gshadow: name=rooter <86>Feb 15 09:47:21 groupadd[11656]: new group: name=rooter, GID=609 <86>Feb 15 09:47:21 useradd[11669]: new user: name=rooter, UID=609, GID=609, home=/root, shell=/bin/bash <86>Feb 15 09:47:21 userdel[11703]: delete user 'builder' <86>Feb 15 09:47:21 userdel[11703]: removed group 'builder' owned by 'builder' <86>Feb 15 09:47:21 userdel[11703]: removed shadow group 'builder' owned by 'builder' <86>Feb 15 09:47:21 groupadd[11731]: group added to /etc/group: name=builder, GID=610 <86>Feb 15 09:47:21 groupadd[11731]: group added to /etc/gshadow: name=builder <86>Feb 15 09:47:21 groupadd[11731]: new group: name=builder, GID=610 <86>Feb 15 09:47:21 useradd[11752]: new user: name=builder, UID=610, GID=610, home=/usr/src, shell=/bin/bash <13>Feb 15 09:47:43 rpmi: libjpeg-2:1.5.1-alt1 1498218318 installed <13>Feb 15 09:47:43 rpmi: libogg-1.3.3-alt1 sisyphus.217914.100 1545006091 installed <13>Feb 15 09:47:43 rpmi: libpng16-1.6.36-alt1 sisyphus+219478.100.1.1 1547633314 installed <13>Feb 15 09:47:43 rpmi: libexpat-2.2.4-alt1 1503305345 installed <13>Feb 15 09:47:43 rpmi: libusb-1.0.22-alt1 1525452055 installed <13>Feb 15 09:47:43 rpmi: libwayland-client-1.16.0-alt1 1535614871 installed <13>Feb 15 09:47:43 rpmi: perl-common-sense-3.74-alt1 1444597122 installed <13>Feb 15 09:47:43 rpmi: perl-HTTP-Date-6.02-alt1 1348645274 installed <13>Feb 15 09:47:43 rpmi: libidn2-2.1.1-alt1 sisyphus+221274.100.1.2 1549951289 installed <13>Feb 15 09:47:43 rpmi: libtheora-2:1.1.1-alt6 1450061541 installed <13>Feb 15 09:47:43 rpmi: libvorbis-1.3.6-alt2 sisyphus+220072.200.2.2 1548744475 installed <13>Feb 15 09:47:43 rpmi: perl-Unicode-Normalize-1:5.28.1-alt1 sisyphus+219907.100.1.1 1548343222 installed <13>Feb 15 09:47:43 rpmi: msulogin-1.0-alt1 1366288515 installed <13>Feb 15 09:47:43 rpmi: libseccomp-2.3.3-alt2 sisyphus+219817.100.1.1 1548172104 installed <13>Feb 15 09:47:43 rpmi: udev-rules-1:240-alt4 sisyphus.219244.100 1547241418 installed <13>Feb 15 09:47:43 rpmi: libepoxy-1.5.3-alt1 sisyphus.214119.100 1538723829 installed <13>Feb 15 09:47:43 rpmi: libsqlite3-3.26.0-alt2 sisyphus+220766.100.5.1 1549611685 installed <13>Feb 15 09:47:43 rpmi: libpixman-3:0.38.0-alt1 sisyphus+221327.100.1.1 1549959657 installed <13>Feb 15 09:47:43 rpmi: perl-IO-Socket-IP-0.39-alt1 1494508514 installed <13>Feb 15 09:47:43 rpmi: perl-Compress-Raw-Zlib-2.084-alt1.1 sisyphus+219907.700.1.1 1548343625 installed <13>Feb 15 09:47:43 rpmi: perl-XML-NamespaceSupport-1.12-alt1 1491296348 installed <13>Feb 15 09:47:43 rpmi: libnettle6-3.4.1-alt1 sisyphus.217427.100 1544107917 installed <13>Feb 15 09:47:43 rpmi: libp11-kit-0.23.9-alt5 1525798298 installed <13>Feb 15 09:47:43 rpmi: liblz4-1:1.8.3-alt2 sisyphus.217095.200 1547082375 installed <13>Feb 15 09:47:43 rpmi: perl-unicore-1:5.28.1-alt1 sisyphus+219907.100.1.1 1548343070 installed <13>Feb 15 09:47:43 rpmi: perl-Types-Serialiser-1.0-alt1 1385991867 installed <13>Feb 15 09:47:43 rpmi: libjasper-2.0.14-alt1 1530105217 installed <13>Feb 15 09:47:43 rpmi: libtiff5-4.0.3-alt1 1348347501 installed <13>Feb 15 09:47:43 rpmi: libv4l-1.16.2-alt2 sisyphus+220174.100.1.1 1548772000 installed <13>Feb 15 09:47:43 rpmi: chrooted-0.3.9-alt1 1524554183 installed <13>Feb 15 09:47:43 rpmi: perl-IO-String-1.08-alt2 1321677915 installed <13>Feb 15 09:47:43 rpmi: perl-Digest-SHA-6.02-alt1.1 sisyphus+219907.1500.1.1 1548343935 installed <13>Feb 15 09:47:43 rpmi: perl-Image-Base-1.17-alt1 1348646151 installed <13>Feb 15 09:47:43 rpmi: perl-Time-Piece-1:1.33-alt1.2 sisyphus+219907.1600.1.1 1548343976 installed <13>Feb 15 09:47:43 rpmi: perl-Term-Cap-1.17-alt1 1445018869 installed <13>Feb 15 09:47:43 rpmi: perl-Pod-Escapes-1.07-alt1 1418767892 installed <13>Feb 15 09:47:43 rpmi: libtbb-2019-alt1.u2 sisyphus+221493.100.1.1 1550132478 installed <13>Feb 15 09:47:43 rpmi: libkmod-25-alt1 1522318408 installed <13>Feb 15 09:47:43 rpmi: libgdbm-1.8.3-alt10 1454943334 installed <13>Feb 15 09:47:43 rpmi: libraw1394-11-2.1.0-alt1.1 1501764699 installed <13>Feb 15 09:47:43 rpmi: libunicap-0.9.8-alt4 sisyphus.213915.400 1538553831 installed <13>Feb 15 09:47:43 rpmi: liblcms2-2.9-alt1 1516411892 installed <13>Feb 15 09:47:43 rpmi: libnspr-1:4.20-alt1 sisyphus.216395.100 1542113039 installed <13>Feb 15 09:47:43 rpmi: libpng15-1.5.28-alt2 1497966749 installed <13>Feb 15 09:47:43 rpmi: libwebp7-1.0.2-alt1 sisyphus+219651.100.1.2 1548057725 installed <13>Feb 15 09:47:43 rpmi: libopus-1.2.1-alt1.1 1504605295 installed <13>Feb 15 09:47:43 rpmi: libgsm-1.0.17-alt1 1523356165 installed <13>Feb 15 09:47:43 rpmi: libglvnd-7:1.1.0-alt3 sisyphus.215982.100 1541498632 installed <13>Feb 15 09:47:43 rpmi: libwayland-server-1.16.0-alt1 1535614871 installed <13>Feb 15 09:47:43 rpmi: ilmbase12-common-2.2.0-alt1.1 1434452921 installed <13>Feb 15 09:47:43 rpmi: libiex12-2.2.0-alt1.1 1434452921 installed <13>Feb 15 09:47:43 rpmi: perl-Try-Tiny-0.30-alt1 1514318058 installed <13>Feb 15 09:47:43 rpmi: perl-LWP-MediaTypes-6.02-alt1 1329754558 installed <13>Feb 15 09:47:43 rpmi: perl-libnet-1:3.11-alt1 1511423541 installed <13>Feb 15 09:47:43 rpmi: perl-Term-ANSIColor-4.06-alt1 1479407083 installed <13>Feb 15 09:47:43 rpmi: perl-Data-Dump-1.23-alt1 1444601978 installed <13>Feb 15 09:47:43 rpmi: perl-XML-SAX-Base-1.09-alt1 1494364363 installed <13>Feb 15 09:47:43 rpmi: libopenjpeg2.0-2.3.0-alt2 sisyphus.216213.100 1541598437 installed <13>Feb 15 09:47:43 rpmi: libjson-c-0.12.1-alt2 1517446106 installed <13>Feb 15 09:47:43 rpmi: libglog-0.3.4-alt4 1520334127 installed <13>Feb 15 09:47:44 rpmi: libopenblas-0.2.20-alt1 1527005646 installed <13>Feb 15 09:47:44 rpmi: libtasn1-4.13-alt2 1521133850 installed <13>Feb 15 09:47:44 rpmi: libICE-1.0.9-alt1 1409902721 installed <13>Feb 15 09:47:44 rpmi: libSM-1.2.3-alt1 sisyphus.215747.100 1540812795 installed <13>Feb 15 09:47:44 rpmi: libilmthread12-2.2.0-alt1.1 1434452921 installed <13>Feb 15 09:47:44 rpmi: libhalf12-2.2.0-alt1.1 1434452921 installed <13>Feb 15 09:47:44 rpmi: libdc1394-22-2.2.5-alt1 1529659263 installed <13>Feb 15 09:47:44 rpmi: libgdbm-devel-1.8.3-alt10 1454943334 installed <13>Feb 15 09:47:44 rpmi: perl-DBM-1:5.28.1-alt1 sisyphus+219907.100.1.1 1548343222 installed <13>Feb 15 09:47:44 rpmi: tbb-devel-2019-alt1.u2 sisyphus+221493.100.1.1 1550132478 installed <13>Feb 15 09:47:44 rpmi: perl-Image-Xbm-1.10-alt1 1457019883 installed <13>Feb 15 09:47:44 rpmi: perl-Image-Xpm-1.13-alt1 1482091733 installed <13>Feb 15 09:47:44 rpmi: perl-Digest-HMAC-1.03-alt1 1317790505 installed <13>Feb 15 09:47:44 rpmi: chrooted-resolv-0.3.1-alt2 1176155250 installed <13>Feb 15 09:47:44 rpmi: libnss-myhostname-1:240-alt4 sisyphus.219244.100 1547241502 installed <13>Feb 15 09:47:44 rpmi: perl-Net-IDN-Encode-2.500-alt1 sisyphus+221481.100.1.1 1550127196 installed <13>Feb 15 09:47:44 rpmi: libhogweed4-3.4.1-alt1 sisyphus.217427.100 1544107917 installed <13>Feb 15 09:47:44 rpmi: libgnutls30-3.6.6-alt1 sisyphus+219978.100.1.1 1548422819 installed <13>Feb 15 09:47:44 rpmi: sysvinit-2.88-alt5 1424350686 installed <13>Feb 15 09:47:44 rpmi: perl-File-Listing-6.04-alt1 1329758996 installed <13>Feb 15 09:47:44 rpmi: perl-EV-4.25-alt1.1 sisyphus+219907.12400.1.1 1548358383 installed <13>Feb 15 09:47:44 rpmi: libwayland-cursor-1.16.0-alt1 1535614871 installed <13>Feb 15 09:47:44 rpmi: libwayland-egl-4:18.1.0-alt1 1535614871 installed <13>Feb 15 09:47:44 rpmi: libusbredir-0.8.0-alt1 1535145369 installed <13>Feb 15 09:47:44 rpmi: libflac8-1.3.2-alt1 1507623955 installed <13>Feb 15 09:47:44 rpmi: libsndfile-1.0.28-alt2 sisyphus.212728.100 1536333068 installed <13>Feb 15 09:47:44 rpmi: libogg-devel-1.3.3-alt1 sisyphus.217914.100 1545006091 installed <13>Feb 15 09:47:44 rpmi: perl-Readonly-2.05-alt1 1465835045 installed <13>Feb 15 09:47:44 rpmi: perl-Readonly-XS-1.05-alt7 sisyphus+220216.100.1.1 1548846829 installed <13>Feb 15 09:47:44 rpmi: mount-2.32-alt2 1528296111 installed <13>Feb 15 09:47:44 rpmi: seabios-1.12.0-alt1 sisyphus.217032.100 1543425555 installed <13>Feb 15 09:47:44 rpmi: seavgabios-1.12.0-alt1 sisyphus.217032.100 1543425555 installed <13>Feb 15 09:47:44 rpmi: qemu-aux-3.1.0-alt1 sisyphus+221468.400.1.1 1550074424 installed <13>Feb 15 09:47:44 rpmi: perl-Tie-RefHash-1.39-alt1 1316492563 installed <13>Feb 15 09:47:44 rpmi: perl-UNIVERSAL-require-0.18-alt1 1427942083 installed <13>Feb 15 09:47:44 rpmi: perl-Sub-Uplevel-1:0.2800-alt1 1491294966 installed <13>Feb 15 09:47:44 rpmi: perl-Sub-Identify-0.14-alt1.2 sisyphus+219907.3700.1.1 1548345622 installed <13>Feb 15 09:47:44 rpmi: perl-SUPER-1.20141117-alt2_11 1531828770 installed <13>Feb 15 09:47:44 rpmi: perl-String-Format-1.18-alt1 1520211609 installed <13>Feb 15 09:47:44 rpmi: perl-Path-Tiny-0.108-alt1 1533171115 installed <13>Feb 15 09:47:44 rpmi: perl-Params-Util-1.07-alt2.2 sisyphus+219907.2300.1.1 1548344251 installed <13>Feb 15 09:47:44 rpmi: perl-Socket6-0.29-alt1.1 sisyphus+219907.11200.1.1 1548356208 installed <13>Feb 15 09:47:44 rpmi: su-0.60-alt35 1484567251 installed <13>Feb 15 09:47:44 rpmi: perl-experimental-0.020-alt1_2 1531647790 installed <13>Feb 15 09:47:44 rpmi: perl-Module-Pluggable-5.2-alt1 1444625395 installed <13>Feb 15 09:47:44 rpmi: perl-List-MoreUtils-XS-0.428-alt2_3 sisyphus+219907.2700.1.1 1548345097 installed <13>Feb 15 09:47:44 rpmi: perl-Lingua-EN-Inflect-1.903-alt1 1509547512 installed <13>Feb 15 09:47:44 rpmi: perl-IO-Stty-0.03-alt1 1295640044 installed <13>Feb 15 09:47:44 rpmi: perl-IO-Tty-1.12-alt2.1 sisyphus+219907.7500.1.1 1548355290 installed <13>Feb 15 09:47:44 rpmi: perl-Exporter-Tiny-1.002001-alt1 1532104024 installed <13>Feb 15 09:47:44 rpmi: perl-List-MoreUtils-0.428-alt1 1513722080 installed <13>Feb 15 09:47:44 rpmi: perl-Digest-SHA1-2.13-alt5.2 sisyphus+219907.4500.1.1 1548350054 installed <13>Feb 15 09:47:44 rpmi: perl-Devel-Symdump-2.18-alt1 1487063672 installed <13>Feb 15 09:47:44 rpmi: perl-Devel-StackTrace-1:2.03-alt1 1511420922 installed <13>Feb 15 09:47:44 rpmi: perl-Sereal-Encoder-4.005-alt1.1 sisyphus+219907.16100.1.1 1548363940 installed <13>Feb 15 09:47:44 rpmi: perl-Sereal-Decoder-4.005-alt1.1 sisyphus+219907.15700.1.1 1548363550 installed <13>Feb 15 09:47:44 rpmi: perl-Crypt-DES-2.07-alt2.2 sisyphus+219907.15400.1.1 1548363251 installed <13>Feb 15 09:47:45 rpmi: perl-Cpanel-JSON-XS-4.08-alt1.1 sisyphus+219907.7000.1.1 1548354351 installed <13>Feb 15 09:47:45 rpmi: perl-JSON-MaybeXS-1.004000-alt1 1524682788 installed <13>Feb 15 09:47:45 rpmi: perl-Convert-Bencode-1.03-alt1 1346737293 installed <13>Feb 15 09:47:45 rpmi: perl-Config-Tiny-2.23-alt1 1444991717 installed <13>Feb 15 09:47:45 rpmi: perl-Compress-LZF-1:3.8-alt1.2 sisyphus+219907.2100.1.1 1548344159 installed <13>Feb 15 09:47:45 rpmi: perl-Clone-0.41-alt1.1 sisyphus+219907.3100.1.1 1548345180 installed <13>Feb 15 09:47:45 rpmi: perl-PPI-1.236-alt1 1501732134 installed <13>Feb 15 09:47:45 rpmi: perl-PPIx-Regexp-0.063-alt1 sisyphus.216315.100 1541769571 installed <13>Feb 15 09:47:45 rpmi: perl-Sub-Exporter-Progressive-0.001013-alt1 1479395404 installed <13>Feb 15 09:47:45 rpmi: perl-Devel-GlobalDestruction-1:0.14-alt1 1479389769 installed <13>Feb 15 09:47:45 rpmi: perl-Class-Tiny-1.006-alt1 1474394512 installed <13>Feb 15 09:47:45 rpmi: perl-Class-Inspector-1.32-alt1 1504113975 installed <13>Feb 15 09:47:45 rpmi: perl-File-ShareDir-1.116-alt1 1530023191 installed <13>Feb 15 09:47:45 rpmi: perl-Class-Data-Inheritable-0.08-alt2 1316996762 installed <13>Feb 15 09:47:45 rpmi: perl-Exception-Class-1.44-alt1 1513614520 installed <13>Feb 15 09:47:45 rpmi: perl-PPIx-Utilities-1.001000-alt1 1311854781 installed <13>Feb 15 09:47:45 rpmi: perl-Sub-Name-1:0.21-alt1.2 sisyphus+219907.5500.1.1 1548352532 installed <13>Feb 15 09:47:45 rpmi: perl-Capture-Tiny-0.48-alt1 1524680703 installed <13>Feb 15 09:47:45 rpmi: perl-CPAN-Meta-Requirements-2.140-alt1 1450184784 installed <13>Feb 15 09:47:45 rpmi: perl-Math-Complex-1.59-alt1 1334229876 installed <13>Feb 15 09:47:45 rpmi: perl-Math-BigInt-1.999816-alt1 sisyphus.215687.100 1540751517 installed <13>Feb 15 09:47:45 rpmi: perl-Math-BigInt-FastCalc-0.5008-alt2 sisyphus+220214.100.1.1 1548845048 installed <13>Feb 15 09:47:45 rpmi: perl-Math-BigRat-1:0.2614-alt1 1524163090 installed <13>Feb 15 09:47:45 rpmi: perl-B-Keywords-1.19-alt1 1535183565 installed <13>Feb 15 09:47:45 rpmi: perl-AppConfig-1.71-alt1 1427917875 installed <13>Feb 15 09:47:45 rpmi: libsnappy-1.1.3-alt1 1450962245 installed <13>Feb 15 09:47:45 rpmi: zlib-devel-1.2.11-alt1 sisyphus.217171.100 1543710737 installed <13>Feb 15 09:47:45 rpmi: libpcre2-10.32-alt1 sisyphus.212994.100 1536866761 installed <13>Feb 15 09:47:45 rpmi: libalsa-1:1.1.8-alt1 sisyphus+219888.100.4.1 1548752826 installed <13>Feb 15 09:47:45 rpmi: libprotobuf15-3.5.2-alt2 sisyphus.218609.100 1545821975 installed <13>Feb 15 09:47:45 rpmi: tinyxml-2.6.2-alt1.2 1465754828 installed <13>Feb 15 09:47:45 rpmi: openni-1.5.7.10-alt2_13 1525876452 installed <13>Feb 15 09:47:45 rpmi: libnuma-2.0.11-alt1 1450022594 installed <13>Feb 15 09:47:45 rpmi: liblzo2-2.08-alt1 1405435918 installed <13>Feb 15 09:47:45 rpmi: libiptables-1.4.21-alt4 sisyphus+218805.200.9.1 1550099201 installed <13>Feb 15 09:47:45 rpmi: openexr22-common-2.2.0-alt3 sisyphus+221267.100.1.2 1549944972 installed <13>Feb 15 09:47:45 rpmi: libilmimf22-2.2.0-alt3 sisyphus+221267.100.1.2 1549944972 installed <13>Feb 15 09:47:45 rpmi: libxkbcommon-0.8.3-alt1 sisyphus+221080.100.1.2 1549739888 installed <13>Feb 15 09:47:45 rpmi: publicsuffix-list-dafsa-20181106-alt1 sisyphus.216228.100 1541611754 installed <13>Feb 15 09:47:45 rpmi: libpsl-0.20.2-alt2 sisyphus.216228.200 1541611889 installed <13>Feb 15 09:47:45 rpmi: libgudev-1:232-alt3 1523738518 installed <13>Feb 15 09:47:45 rpmi: libgflags-2.2.1-alt1 1506439788 installed <13>Feb 15 09:47:45 rpmi: libnl3-3.4.0-alt2 1507570088 installed <13>Feb 15 09:47:45 rpmi: libibverbs-22-alt2 sisyphus+219620.100.1.1 1547867729 installed <13>Feb 15 09:47:45 rpmi: librdmacm-22-alt2 sisyphus+219620.100.1.1 1547867729 installed <13>Feb 15 09:47:45 rpmi: tcsh-6.20.00-alt2 1503603381 installed <13>Feb 15 09:47:45 rpmi: rpm-macros-mpi-selector-1.0.3-alt3 1504498675 installed <13>Feb 15 09:47:45 rpmi: mpi-selector-1.0.3-alt3 1504498675 installed <13>Feb 15 09:47:46 rpmi: openmpi-compat-1.6.4-alt5 1523663996 installed <13>Feb 15 09:47:46 rpmi: openmpi-lib-compat-1.6.4-alt5 1523663996 installed <13>Feb 15 09:47:46 rpmi: libfftw3-mpi-1:3.3.4-alt1.1 1449202259 installed <13>Feb 15 09:47:46 rpmi: libfdt-1.4.7-alt1 1534554880 installed <13>Feb 15 09:47:46 rpmi: libdb4.7-devel-4.7.25-alt9 1490438479 installed <13>Feb 15 09:47:46 rpmi: perl-devel-1:5.28.1-alt1 sisyphus+219907.100.1.1 1548343222 installed <13>Feb 15 09:47:46 rpmi: perl-YAML-LibYAML-1:0.76-alt1.1_1 sisyphus+221092.100.1.1 1549721403 installed <13>Feb 15 09:47:46 rpmi: libverto-0.3.0-alt1_5 1525957714 installed <13>Feb 15 09:47:46 rpmi: libkeyutils-1.6-alt2 sisyphus.217337.100 1544003161 installed <13>Feb 15 09:47:46 rpmi: libdevmapper-1.02.152-alt2 sisyphus.216915.100 1543418921 installed <13>Feb 15 09:47:46 rpmi: libcom_err-1.44.5-alt1 sisyphus.218838.100 1546206118 installed <13>Feb 15 09:47:46 rpmi: libpcsclite-1.8.23-alt1 1513827863 installed <13>Feb 15 09:47:46 rpmi: libbluez-5.50-alt1 1529698484 installed <13>Feb 15 09:47:46 rpmi: libudfread-1.0.0-alt3 1528906339 installed <13>Feb 15 09:47:46 rpmi: libsoxr-0.1.2-alt4 sisyphus.215929.100 1541001035 installed <13>Feb 15 09:47:46 rpmi: libxvid-1.3.4-alt1 1507033991 installed <13>Feb 15 09:47:46 rpmi: libx265-160-2.8-alt1 1529659188 installed <13>Feb 15 09:47:46 rpmi: libx264-148-alt2 1496163832 installed <13>Feb 15 09:47:46 rpmi: libwavpack-5.1.0-alt1 1486754497 installed <13>Feb 15 09:47:46 rpmi: libvpx5-1.7.0-alt1 1529659550 installed <13>Feb 15 09:47:46 rpmi: libtwolame-0.3.13-alt1 1486717206 installed <13>Feb 15 09:47:46 rpmi: libspeex-1.2-alt1 1528115225 installed <13>Feb 15 09:47:46 rpmi: libdatrie-0.2.9-alt1_6 1511686676 installed <13>Feb 15 09:47:47 rpmi: libthai-0.1.28-alt1_1 sisyphus.214516.100 1539257851 installed <13>Feb 15 09:47:47 rpmi: libfribidi-1.0.5-alt1 1532424345 installed <13>Feb 15 09:47:47 rpmi: libopencore-amrwb0-0.1.5-alt1 1529659346 installed <13>Feb 15 09:47:47 rpmi: libopencore-amrnb0-0.1.5-alt1 1529659346 installed <13>Feb 15 09:47:47 rpmi: liblame-3.100-alt1 1527082574 installed <13>Feb 15 09:47:47 rpmi: libcodec2-0.8.1-alt1 1533802541 installed <13>Feb 15 09:47:47 rpmi: libargon2-20171227-alt2 sisyphus.216770.100 1542965282 installed <13>Feb 15 09:47:47 rpmi: libaio-0.3.111-alt1 1530122162 installed <13>Feb 15 09:47:47 rpmi: qemu-img-3.1.0-alt1 sisyphus+221468.400.1.1 1550074703 installed <86>Feb 15 09:47:47 groupadd[4605]: group added to /etc/group: name=vmusers, GID=499 <86>Feb 15 09:47:47 groupadd[4605]: group added to /etc/gshadow: name=vmusers <86>Feb 15 09:47:47 groupadd[4605]: new group: name=vmusers, GID=499 <13>Feb 15 09:47:47 rpmi: qemu-common-3.1.0-alt1 sisyphus+221468.400.1.1 1550074424 installed <13>Feb 15 09:47:47 rpmi: libgraphite2-1.3.13-alt1 sisyphus.218545.100 1545686511 installed <13>Feb 15 09:47:47 rpmi: libharfbuzz-2.2.0-alt1 sisyphus.218134.500 1545261518 installed <13>Feb 15 09:47:47 rpmi: libfreetype-2.9.1-alt1.S1 1530781053 installed <13>Feb 15 09:47:47 rpmi: fontconfig-2.13.1-alt1 sisyphus.215917.100 1540973886 installed Updating fonts cache: <29>Feb 15 09:47:48 fontconfig: Updating fonts cache: succeeded [ DONE ] <13>Feb 15 09:47:48 rpmi: libbluray-1.0.2-alt1 1529659859 installed <13>Feb 15 09:47:48 rpmi: libxshmfence-1.2-alt2 1518613552 installed <13>Feb 15 09:47:48 rpmi: libpciaccess-1:0.14-alt1 1528969252 installed <13>Feb 15 09:47:48 rpmi: libdrm-1:2.4.97-alt1 sisyphus+220483.100.1.1 1549270242 installed <13>Feb 15 09:47:48 rpmi: libgbm-4:18.3.3-alt1 sisyphus+220483.200.1.1 1549271174 installed <13>Feb 15 09:47:48 rpmi: ipxe-roms-qemu-1:20180825-alt2.git133f4c47 sisyphus.217697.200 1545066237 installed <13>Feb 15 09:47:48 rpmi: perl-Compress-Raw-Bzip2-2.084-alt1.1 sisyphus+219907.1000.1.1 1548343668 installed <13>Feb 15 09:47:48 rpmi: perl-HTML-Tagset-3.20-alt2 1317725093 installed <13>Feb 15 09:47:48 rpmi: perl-Filter-1.59-alt1.1 sisyphus+219907.400.1.1 1548343389 installed <13>Feb 15 09:47:48 rpmi: perl-Encode-3.00-alt1 sisyphus+220447.100.1.1 1549145397 installed <13>Feb 15 09:47:48 rpmi: perl-URI-1.76-alt1 sisyphus+220243.100.1.1 1548863244 installed <13>Feb 15 09:47:48 rpmi: perl-HTML-Parser-3.72-alt1.2 sisyphus+219907.600.1.1 1548343581 installed <13>Feb 15 09:47:48 rpmi: perl-IO-Compress-2.084-alt1 sisyphus+219744.100.2.1 1548168679 installed <13>Feb 15 09:47:48 rpmi: perl-Pod-Simple-3.35-alt1 1482098090 installed <13>Feb 15 09:47:48 rpmi: perl-Pod-Usage-1.69-alt1 1464274721 installed <13>Feb 15 09:47:48 rpmi: perl-podlators-4.11-alt1 1525935408 installed <13>Feb 15 09:47:48 rpmi: perl-Pod-Parser-1.63-alt1 1447282032 installed <13>Feb 15 09:47:48 rpmi: perl-JSON-PP-1:4.00-alt1 sisyphus.217511.100 1544226505 installed <13>Feb 15 09:47:48 rpmi: perl-Pod-Spell-1.20-alt1 1462288378 installed <13>Feb 15 09:47:48 rpmi: perl-B-C-1.55_04-alt1.2 sisyphus+219907.22100.1.1 1548371399 installed <13>Feb 15 09:47:48 rpmi: perl-B-Debug-1.26-alt1 1513614689 installed <13>Feb 15 09:47:48 rpmi: perl-Net-HTTP-6.18-alt1 1526560501 installed <13>Feb 15 09:47:48 rpmi: perl-CGI-4.40-alt1 1534844766 installed <13>Feb 15 09:47:49 rpmi: perl-Perl-Tidy-20181120-alt1 sisyphus.218833.100 1546190378 installed <13>Feb 15 09:47:49 rpmi: perl-WWW-RobotRules-6.02-alt1 1329756211 installed <13>Feb 15 09:47:49 rpmi: perl-CBOR-XS-2:1.71-alt1.1 sisyphus+219907.1700.1.1 1548344030 installed <13>Feb 15 09:47:49 rpmi: perl-JSON-XS-3:3.04-alt1.1 sisyphus+219907.2200.1.1 1548344207 installed <13>Feb 15 09:47:49 rpmi: perl-Encode-Locale-1.05-alt1 1444608613 installed <13>Feb 15 09:47:49 rpmi: perl-IO-HTML-1.001-alt1 1404821752 installed <13>Feb 15 09:47:49 rpmi: perl-HTTP-Message-6.18-alt1 1528288416 installed <13>Feb 15 09:47:49 rpmi: perl-HTTP-Cookies-6.04-alt1 1504116575 installed <13>Feb 15 09:47:49 rpmi: perl-HTTP-Negotiate-6.01-alt1 1329760563 installed <13>Feb 15 09:47:49 rpmi: perl-libwww-6.36-alt1 sisyphus.215515.100 1540400896 installed <13>Feb 15 09:47:49 rpmi: perl-XML-LibXML-2.0134-alt1 sisyphus+221347.100.1.1 1549969058 installed <13>Feb 15 09:47:49 rpmi: perl-XML-SAX-1.00-alt1 1519094959 installed <13>Feb 15 09:47:49 rpmi: perl-XML-Simple-2.25-alt1 1521437714 installed <13>Feb 15 09:47:49 rpmi: icon-naming-utils-0.8.90-alt1 1236573102 installed <13>Feb 15 09:47:50 rpmi: icon-theme-adwaita-3.30.1-alt1 sisyphus.216736.100 1542889653 installed <13>Feb 15 09:47:50 rpmi: perl-Image-Info-1.41-alt1 1501707783 installed <13>Feb 15 09:47:50 rpmi: perl-XML-Parser-2.44-alt2.2 sisyphus+219907.1300.1.1 1548343835 installed <13>Feb 15 09:47:50 rpmi: perl-XML-Twig-3.52-alt1 1480505257 installed <13>Feb 15 09:47:50 rpmi: perl-CPAN-Meta-YAML-0.018-alt1 1450184987 installed <13>Feb 15 09:47:50 rpmi: perl-Parse-CPAN-Meta-2.150010-alt2 1474746050 installed <13>Feb 15 09:47:50 rpmi: perl-CPAN-Meta-2.150010-alt2 1474746050 installed <13>Feb 15 09:47:50 rpmi: perl-Pod-POM-2.01-alt1 1447282236 installed <13>Feb 15 09:47:50 rpmi: perl-Template-2.28-alt1.1 sisyphus+219907.7600.1.1 1548355365 installed <13>Feb 15 09:47:50 rpmi: perl-Geography-Countries-2009041301-alt1 1317311190 installed <13>Feb 15 09:47:50 rpmi: perl-IP-Country-2.28-alt1 1374731220 installed <13>Feb 15 09:47:50 rpmi: perl-PPIx-QuoteLike-0.006-alt1 1531393901 installed <13>Feb 15 09:47:50 rpmi: perl-Perl-Critic-1.132-alt1 1528036836 installed <13>Feb 15 09:47:50 rpmi: hwclock-1:2.32-alt2 1528296111 installed <13>Feb 15 09:47:50 rpmi: libgdk-pixbuf-locales-2.38.0-alt4 sisyphus.219229.400 1547220196 installed <13>Feb 15 09:47:50 rpmi: gtk+3-themes-incompatible-3.20-alt3 1461944560 installed <13>Feb 15 09:47:50 rpmi: libproxy-0.4.15-alt2 sisyphus.214008.100 1538585336 installed <13>Feb 15 09:47:50 rpmi: libCharLS-1.0-alt2 1389518019 installed <13>Feb 15 09:47:50 rpmi: gcc-c++-common-1.4.23-alt1 sisyphus.218115.200 1545282875 installed <13>Feb 15 09:47:51 rpmi: libstdc++8-devel-8.2.1-alt5 sisyphus+219286.200.2.1 1549854113 installed <13>Feb 15 09:47:52 rpmi: gcc8-c++-8.2.1-alt5 sisyphus+219286.200.2.1 1549854113 installed <13>Feb 15 09:47:52 rpmi: libmetis-5.1.0-alt1.1 1465299656 installed <13>Feb 15 09:47:52 rpmi: libxblas-1.0.248-alt1.1 1496143682 installed <13>Feb 15 09:47:52 rpmi: libquadmath0-8.2.1-alt5 sisyphus+219286.200.2.1 1549854113 installed <13>Feb 15 09:47:52 rpmi: libgfortran5-8.2.1-alt5 sisyphus+219286.200.2.1 1549854113 installed <13>Feb 15 09:47:53 rpmi: liblapack-1:3.8.0-alt3 sisyphus+221521.100.1.1 1550134903 installed <13>Feb 15 09:47:53 rpmi: libgomp1-8.2.1-alt5 sisyphus+219286.200.2.1 1549854113 installed <13>Feb 15 09:47:53 rpmi: libsuitesparse-5.1.2-alt2 sisyphus.217149.100 1543595939 installed <13>Feb 15 09:47:53 rpmi: ceres-solver-1.13.0-alt1_8 sisyphus.217991.100 1545069210 installed <13>Feb 15 09:47:53 rpmi: libatk-locales-2.30.0-alt1 sisyphus.212779.100 1536768328 installed <13>Feb 15 09:47:53 rpmi: libatk-2.30.0-alt1 sisyphus.212779.100 1536768334 installed <13>Feb 15 09:47:53 rpmi: shared-mime-info-1.12-alt1 sisyphus+219597.100.2.2 1548057005 installed <13>Feb 15 09:47:53 rpmi: gsettings-desktop-schemas-data-3.28.1-alt1 sisyphus.212587.100 1536082062 installed <13>Feb 15 09:47:53 rpmi: libgio-2.58.3-alt1 sisyphus+219722.100.1.1 1548088777 installed <13>Feb 15 09:47:53 rpmi: gsettings-desktop-schemas-3.28.1-alt1 sisyphus.212587.100 1536082066 installed <13>Feb 15 09:47:53 rpmi: libgdk-pixbuf-2.38.0-alt4 sisyphus.219229.400 1547220208 installed <13>Feb 15 09:47:53 rpmi: libgusb-0.3.0-alt1 1518891735 installed <13>Feb 15 09:47:53 rpmi: libcolord-1.4.3-alt1 1524052018 installed <13>Feb 15 09:47:53 rpmi: gtk-update-icon-cache-3.24.5-alt1 sisyphus+220558.100.1.1 1549311199 installed <13>Feb 15 09:47:53 rpmi: libdconf-0.30.1-alt1 sisyphus.215477.100 1540419162 installed <13>Feb 15 09:47:53 rpmi: libjson-glib-1.4.4-alt1 sisyphus.213175.100 1537249589 installed <13>Feb 15 09:47:53 rpmi: libgpg-error-1.31-alt1.S1 1529015802 installed <13>Feb 15 09:47:53 rpmi: libgcrypt20-1.8.3-alt4 sisyphus.218050.200 1545223289 installed <13>Feb 15 09:47:53 rpmi: libsystemd-1:240-alt4 sisyphus.219244.100 1547241502 installed <13>Feb 15 09:47:53 rpmi: libdbus-1.12.12-alt2 sisyphus+221234.100.1.2 1549918047 installed <13>Feb 15 09:47:53 rpmi: dbus-tools-1.12.12-alt2 sisyphus+221234.100.1.2 1549918047 installed <86>Feb 15 09:47:53 groupadd[8199]: group added to /etc/group: name=messagebus, GID=498 <86>Feb 15 09:47:53 groupadd[8199]: group added to /etc/gshadow: name=messagebus <86>Feb 15 09:47:53 groupadd[8199]: new group: name=messagebus, GID=498 <86>Feb 15 09:47:53 useradd[8203]: new user: name=messagebus, UID=499, GID=498, home=/run/dbus, shell=/dev/null <13>Feb 15 09:47:53 rpmi: dbus-1.12.12-alt2 sisyphus+221234.100.1.2 1549918047 installed <13>Feb 15 09:47:53 rpmi: pam_systemd-1:240-alt4 sisyphus.219244.100 1547241502 installed <13>Feb 15 09:47:54 rpmi: libcryptsetup-2.0.6-alt1 sisyphus.217248.100 1543864717 installed <13>Feb 15 09:47:54 rpmi: startup-0.9.9.6-alt1 sisyphus.215964.200 1542884274 installed <13>Feb 15 09:47:54 rpmi: systemd-utils-1:240-alt4 sisyphus.219244.100 1547241502 installed <13>Feb 15 09:47:54 rpmi: systemd-services-1:240-alt4 sisyphus.219244.100 1547241502 installed <13>Feb 15 09:47:54 rpmi: dconf-0.30.1-alt1 sisyphus.215477.100 1540419162 installed <13>Feb 15 09:47:54 rpmi: libgtk+3-schemas-3.24.5-alt1 sisyphus+220558.100.1.1 1549311168 installed <13>Feb 15 09:47:54 rpmi: libavahi-0.6.32-alt1 1500485702 installed <13>Feb 15 09:47:54 rpmi: libpolkit-0.115-alt5 sisyphus.219065.100 1547027030 installed <86>Feb 15 09:47:54 groupadd[8283]: group added to /etc/group: name=colord, GID=497 <86>Feb 15 09:47:54 groupadd[8283]: group added to /etc/gshadow: name=colord <86>Feb 15 09:47:54 groupadd[8283]: new group: name=colord, GID=497 <86>Feb 15 09:47:54 useradd[8287]: new user: name=colord, UID=498, GID=497, home=/var/colord, shell=/dev/null <13>Feb 15 09:47:54 rpmi: colord-1.4.3-alt1 1524052018 installed <13>Feb 15 09:47:54 rpmi: libX11-locales-3:1.6.7-alt1 sisyphus.214413.200 1539171080 installed <13>Feb 15 09:47:54 rpmi: libXdmcp-1.1.1-alt1 1334617701 installed <13>Feb 15 09:47:54 rpmi: libXau-1.0.8-alt1 1369565808 installed <13>Feb 15 09:47:54 rpmi: libxcb-1.13.1-alt1 sisyphus.214413.100 1539170896 installed <13>Feb 15 09:47:54 rpmi: libX11-3:1.6.7-alt1 sisyphus.214413.200 1539171143 installed <13>Feb 15 09:47:54 rpmi: libXext-1.3.3-alt1 1409902959 installed <13>Feb 15 09:47:54 rpmi: libXrender-0.9.8-alt1 1371312112 installed <13>Feb 15 09:47:54 rpmi: libXfixes-5.0.3-alt1 sisyphus.216396.300 1542022162 installed <13>Feb 15 09:47:54 rpmi: libat-spi2-core-2.30.0-alt1 sisyphus.212651.600 1536647587 installed <13>Feb 15 09:47:54 rpmi: libXdamage-1.1.3-alt4 1297162593 installed <13>Feb 15 09:47:54 rpmi: libXcursor-1.1.15-alt1.S1 1512373366 installed <13>Feb 15 09:47:54 rpmi: libXft-2.3.2-alt1 1409902660 installed <13>Feb 15 09:47:54 rpmi: libXrandr-1.5.0-alt1 1431936189 installed <13>Feb 15 09:47:54 rpmi: libXtst-1.2.2-alt1 1369984893 installed <13>Feb 15 09:47:54 rpmi: libXxf86vm-1.1.4-alt2 1527672187 installed <13>Feb 15 09:47:54 rpmi: libGLX-mesa-4:18.3.3-alt1 sisyphus+220483.200.1.1 1549271174 installed <13>Feb 15 09:47:54 rpmi: libEGL-mesa-4:18.3.3-alt1 sisyphus+220483.200.1.1 1549271174 installed <13>Feb 15 09:47:54 rpmi: libEGL-7:1.1.0-alt3 sisyphus.215982.100 1541498632 installed <13>Feb 15 09:47:54 rpmi: libGLX-7:1.1.0-alt3 sisyphus.215982.100 1541498632 installed <13>Feb 15 09:47:54 rpmi: libGL-7:1.1.0-alt3 sisyphus.215982.100 1541498632 installed <13>Feb 15 09:47:54 rpmi: libcairo-1:1.16.0-alt1 sisyphus.215566.100 1540457683 installed <13>Feb 15 09:47:54 rpmi: libpango-1.42.4-alt1 1534787259 installed <13>Feb 15 09:47:54 rpmi: libva-2.3.0-alt1 sisyphus.214267.100 1539001610 installed <13>Feb 15 09:47:54 rpmi: librsvg-1:2.44.12-alt1 sisyphus+219722.400.2.2 1548107893 installed <13>Feb 15 09:47:54 rpmi: libucil-0.9.8-alt4.1 1349410514 installed <13>Feb 15 09:47:54 rpmi: libcairo-gobject-1:1.16.0-alt1 sisyphus.215566.100 1540457683 installed <13>Feb 15 09:47:54 rpmi: libXi-1.7.9-alt1.S1 1515755342 installed <13>Feb 15 09:47:54 rpmi: libXinerama-1.1.3-alt2 1527671619 installed <13>Feb 15 09:47:54 rpmi: libvdpau-1:1.1.1-alt1 1441098581 installed <13>Feb 15 09:47:55 rpmi: libavutil56-2:4.1-alt1 sisyphus.216261.100 1541676633 installed <13>Feb 15 09:47:55 rpmi: libswresample3-2:4.1-alt1 sisyphus.216261.100 1541676633 installed <13>Feb 15 09:47:55 rpmi: libswscale5-2:4.1-alt1 sisyphus.216261.100 1541676633 installed <13>Feb 15 09:47:55 rpmi: dbus-tools-gui-1.12.12-alt2 sisyphus+221234.100.1.2 1549918047 installed <13>Feb 15 09:47:55 rpmi: at-spi2-core-2.30.0-alt1 sisyphus.212651.600 1536647587 installed <13>Feb 15 09:47:55 rpmi: at-spi2-atk-2.30.0-alt2 sisyphus.213822.100 1538377854 installed <13>Feb 15 09:47:55 rpmi: libXcomposite-0.4.3-alt3 1297306936 installed <13>Feb 15 09:47:55 rpmi: libzvbi-0.2.35-alt1 1410514327 installed <13>Feb 15 09:47:55 rpmi: libavcodec58-2:4.1-alt1 sisyphus.216261.100 1541676633 installed <13>Feb 15 09:47:55 rpmi: libavformat58-2:4.1-alt1 sisyphus.216261.100 1541676633 installed <13>Feb 15 09:47:55 rpmi: libvirglrenderer-0.7.0-alt1 sisyphus.215037.100 1539629528 installed <13>Feb 15 09:47:55 rpmi: rpm-macros-alternatives-0.5.0-alt1 sisyphus.219012.300 1546745004 installed <13>Feb 15 09:47:55 rpmi: alternatives-0.5.0-alt1 sisyphus.219012.300 1546745004 installed <13>Feb 15 09:47:56 rpmi: ca-certificates-2019.02.01-alt1 sisyphus+220384.200.1.1 1549032756 installed <13>Feb 15 09:47:56 rpmi: ca-trust-0.1.1-alt2 1515595785 installed <13>Feb 15 09:47:56 rpmi: p11-kit-trust-0.23.9-alt5 1525798298 installed <13>Feb 15 09:47:56 rpmi: libcrypto1.1-1.1.0j-alt1 sisyphus.216647.100 1542743878 installed <13>Feb 15 09:47:56 rpmi: libssl1.1-1.1.0j-alt1 sisyphus.216647.100 1542743878 installed <86>Feb 15 09:47:56 groupadd[8912]: group added to /etc/group: name=_keytab, GID=496 <86>Feb 15 09:47:56 groupadd[8912]: group added to /etc/gshadow: name=_keytab <86>Feb 15 09:47:56 groupadd[8912]: new group: name=_keytab, GID=496 <13>Feb 15 09:47:56 rpmi: libkrb5-1.16.3-alt1 sisyphus.219042.100 1547045815 installed <86>Feb 15 09:47:56 groupadd[8935]: group added to /etc/group: name=sasl, GID=495 <86>Feb 15 09:47:56 groupadd[8935]: group added to /etc/gshadow: name=sasl <86>Feb 15 09:47:56 groupadd[8935]: new group: name=sasl, GID=495 <13>Feb 15 09:47:56 rpmi: libsasl2-3-2.1.27-alt1 sisyphus.218476.200 1545647755 installed <13>Feb 15 09:47:56 rpmi: libspice-server-0.14.1-alt2 sisyphus.212825.100 1537192320 installed <13>Feb 15 09:47:56 rpmi: libcups-2.2.6-alt1 1510070343 installed <13>Feb 15 09:47:56 rpmi: perl-Net-SSLeay-1.85-alt1.2 sisyphus+219907.3300.1.1 1548345451 installed <13>Feb 15 09:47:56 rpmi: perl-IO-Socket-SSL-2.060-alt1 sisyphus.213414.100 1537479277 installed <13>Feb 15 09:47:56 rpmi: perl-Mojolicious-8.12-alt1 sisyphus+220446.100.1.1 1549144872 installed <13>Feb 15 09:47:56 rpmi: gdcm-2.8.4-alt3_11 sisyphus+221511.100.1.2 1550151960 installed <13>Feb 15 09:47:56 rpmi: libssh2-1.8.0-alt1 1535747073 installed <13>Feb 15 09:47:56 rpmi: glib-networking-2.58.0-alt1 sisyphus.212651.1500 1536648953 installed <13>Feb 15 09:47:56 rpmi: libsoup-2.64.2-alt1 sisyphus.215425.140 1540400356 installed <13>Feb 15 09:47:56 rpmi: libsoup-gnome-2.64.2-alt1 sisyphus.215425.140 1540400356 installed <13>Feb 15 09:47:56 rpmi: librest-0.8.1-alt1 1508266400 installed <13>Feb 15 09:47:57 rpmi: libgtk+3-3.24.5-alt1 sisyphus+220558.100.1.1 1549311199 installed <13>Feb 15 09:47:59 rpmi: libopencv3.4-1:3.4.5-alt1 sisyphus+219877.200.2.1 1548321563 installed <13>Feb 15 09:47:59 rpmi: libnss-3.42.1-alt1 sisyphus+220384.100.1.1 1549032573 installed <13>Feb 15 09:47:59 rpmi: libcacard-2.6.1-alt1 sisyphus.215092.100 1539716606 installed <13>Feb 15 09:47:59 rpmi: login-0.60-alt35 1484567251 installed <13>Feb 15 09:47:59 rpmi: agetty-2.32-alt2 1528296111 installed <13>Feb 15 09:47:59 rpmi: acl-2.2.53-alt1 sisyphus.217169.200 1543706508 installed <86>Feb 15 09:47:59 groupadd[9459]: group added to /etc/group: name=systemd-journal, GID=494 <86>Feb 15 09:47:59 groupadd[9459]: group added to /etc/gshadow: name=systemd-journal <86>Feb 15 09:47:59 groupadd[9459]: new group: name=systemd-journal, GID=494 <13>Feb 15 09:47:59 rpmi: systemd-1:240-alt4 sisyphus.219244.100 1547241502 installed <13>Feb 15 09:48:00 rpmi: qemu-system-x86-core-3.1.0-alt1 sisyphus+221468.400.1.1 1550074703 installed <13>Feb 15 09:48:08 rpmi: libopencv-devel-1:3.4.5-alt1 sisyphus+219877.200.2.1 1548321563 installed <13>Feb 15 09:48:08 rpmi: perl-Net-SSH2-0.69-alt2.1 sisyphus+219907.30400.1.1 1548376328 installed <13>Feb 15 09:48:08 rpmi: perl-Mojo-IOLoop-ReadWriteProcess-0.23-alt1 1534269523 installed <13>Feb 15 09:48:08 rpmi: perl-Net-DBus-1.1.0-alt1.2 sisyphus+219907.17100.1.1 1548365672 installed <13>Feb 15 09:48:08 rpmi: gcc-c++-8-alt1 sisyphus.214000.40 1542664775 installed <13>Feb 15 09:48:08 rpmi: perlcritic-1.132-alt1 1528036836 installed <13>Feb 15 09:48:08 rpmi: perl-Net-IP-1.26-alt1 1381336832 installed <13>Feb 15 09:48:08 rpmi: perl-Devel-Cover-1.31-alt1.1 sisyphus+219907.25100.1.1 1548374477 installed <13>Feb 15 09:48:08 rpmi: perl-Module-CPANfile-1.1004-alt1 1525297092 installed <13>Feb 15 09:48:08 rpmi: perl-JSON-4.01-alt1 sisyphus+219746.100.1.2 1548118569 installed <13>Feb 15 09:48:08 rpmi: perl-Pod-Coverage-0.23-alt2 1507677806 installed <13>Feb 15 09:48:08 rpmi: perl-Test-Pod-1.52-alt1 1524163463 installed <13>Feb 15 09:48:08 rpmi: perl-Term-ReadLine-Gnu-1.35-alt1.1 sisyphus+219907.1400.1.1 1548343889 installed <13>Feb 15 09:48:08 rpmi: perl-Test-Compile-1.3.0-alt1 1530182188 installed <13>Feb 15 09:48:08 rpmi: perl-Test-Exception-0.43-alt1 1451924067 installed <13>Feb 15 09:48:08 rpmi: perl-Test-Fatal-0.014-alt1 1418768336 installed <13>Feb 15 09:48:08 rpmi: perl-Test-Output-1.031-alt1 1491295195 installed <13>Feb 15 09:48:08 rpmi: perl-Test-Warnings-0.026-alt1_8 1531851188 installed <13>Feb 15 09:48:08 rpmi: libfftw3-mpi-devel-1:3.3.4-alt1.1 1449202259 installed <13>Feb 15 09:48:08 rpmi: libpng-devel-1.6.36-alt1 sisyphus+219478.100.1.1 1547633314 installed <13>Feb 15 09:48:08 rpmi: perl-Net-SNMP-6.0.1-alt3 1530297290 installed <13>Feb 15 09:48:08 rpmi: perl-Class-Accessor-0.51-alt1 1509545431 installed <13>Feb 15 09:48:08 rpmi: perl-IPC-Run-20180523.0-alt1 1527291851 installed <13>Feb 15 09:48:08 rpmi: perl-Test-MockModule-0.170.0-alt1_1 sisyphus.214566.100 1539266848 installed <13>Feb 15 09:48:08 rpmi: perl-autodie-2.29-alt1 1445013559 installed <13>Feb 15 09:48:08 rpmi: libtheora-devel-2:1.1.1-alt6 1450061541 installed <13>Feb 15 09:48:08 rpmi: libsndfile-devel-1.0.28-alt2 sisyphus.212728.100 1536333068 installed <13>Feb 15 09:48:08 rpmi: perl-Test-MockTime-0.17-alt1_2 1531846492 installed <13>Feb 15 09:48:08 rpmi: perl-Socket-MsgHdr-0.05-alt1.1 sisyphus+219907.35100.1.1 1548381290 installed <13>Feb 15 09:48:08 rpmi: perl-Package-Generator-1.106-alt1 1388763390 installed <13>Feb 15 09:48:08 rpmi: perl-IPC-System-Simple-1.25-alt2_1 1388863478 installed <13>Feb 15 09:48:08 rpmi: perl-File-Which-1.23-alt1 sisyphus.218871.100 1546337313 installed <13>Feb 15 09:48:08 rpmi: perl-Carp-Always-0.16-alt1_1 sisyphus.214542.100 1539262263 installed Building target platforms: i586 Building for target i586 Wrote: /usr/src/in/nosrpm/os-autoinst-4.5.1527308405.8b586d5-alt2.nosrc.rpm Installing os-autoinst-4.5.1527308405.8b586d5-alt2.src.rpm Building target platforms: i586 Building for target i586 Executing(%prep): /bin/sh -e /usr/src/tmp/rpm-tmp.12841 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + rm -rf os-autoinst-4.5.1527308405.8b586d5 + echo 'Source #0 (os-autoinst-4.5.1527308405.8b586d5.tar):' Source #0 (os-autoinst-4.5.1527308405.8b586d5.tar): + /bin/tar -xf /usr/src/RPM/SOURCES/os-autoinst-4.5.1527308405.8b586d5.tar + cd os-autoinst-4.5.1527308405.8b586d5 + /bin/chmod -c -Rf u+rwX,go-w . + echo 'Patch #0 (fixdependencies.patch):' Patch #0 (fixdependencies.patch): + /usr/bin/patch -p1 patching file t/03-testapi.t Hunk #1 succeeded at 9 with fuzz 2 (offset 3 lines). + sed -i 's/ my $thisversion = qx{git rev-parse HEAD};/ my $thisversion = "4.5.1527308405.8b586d5";/' isotovideo + sed -i 's/ chomp(my $git_hash = qx{git rev-parse HEAD});/ chomp(my $git_hash = "4.5.1527308405.8b586d5");/' OpenQA/Isotovideo/Utils.pm + rm -f t/99-full-stack.t + sed -i -e 's, 99-full-stack.t,,g' t/Makefile.am + sed -i -e 's|/usr/lib/systemd/|/lib/systemd/|' Makefile.am + exit 0 Executing(%build): /bin/sh -e /usr/src/tmp/rpm-tmp.30793 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + cd os-autoinst-4.5.1527308405.8b586d5 + mkdir -p m4 + autoreconf -fisv autoreconf-default: Entering directory `.' autoreconf-default: configure.ac: not using Gettext autoreconf-default: running: aclocal --force -I m4 autoreconf-default: configure.ac: tracing autoreconf-default: running: libtoolize --force --install libtoolize-default: putting auxiliary files in `.'. libtoolize-default: linking file `./config.guess' libtoolize-default: linking file `./config.sub' libtoolize-default: linking file `./install-sh' libtoolize-default: linking file `./ltmain.sh' libtoolize-default: putting macros in AC_CONFIG_MACRO_DIR, `m4'. libtoolize-default: linking file `m4/libtool.m4' libtoolize-default: linking file `m4/ltoptions.m4' libtoolize-default: linking file `m4/ltsugar.m4' libtoolize-default: linking file `m4/ltversion.m4' libtoolize-default: linking file `m4/lt~obsolete.m4' autoreconf-default: configure.ac: not using Intltool autoreconf-default: configure.ac: not using gtk-doc autoreconf-default: running: /usr/bin/autoconf-2.60 --force autoreconf-default: configure.ac: not using Autoheader autoreconf-default: running: automake --add-missing --force-missing configure.ac:25: installing './compile' configure.ac:17: installing './missing' Makefile.am: installing './depcomp' parallel-tests: installing './test-driver' autoreconf-default: Leaving directory `.' + CFLAGS='-pipe -frecord-gcc-switches -Wall -g -O2 -march=i586 -mtune=generic' + export CFLAGS + CXXFLAGS='-pipe -frecord-gcc-switches -Wall -g -O2 -march=i586 -mtune=generic' + export CXXFLAGS + FFLAGS='-pipe -frecord-gcc-switches -Wall -g -O2 -march=i586 -mtune=generic' + export FFLAGS + '[' -n '' ']' ++ printf %s '-pipe -frecord-gcc-switches -Wall -g -O2 -march=i586 -mtune=generic' ++ sed -r 's/(^|[[:space:]]+)-[^m][^[:space:]]*//g' + ASFLAGS=' -march=i586 -mtune=generic' + export ASFLAGS + export lt_cv_deplibs_check_method=pass_all + lt_cv_deplibs_check_method=pass_all + readlink -e -- ./configure + xargs -ri dirname -- '{}' + xargs -ri find '{}' -type f '(' -name config.sub -or -name config.guess ')' -printf '%h/\n' + sort -u + xargs -rn1 install -pm755 -- /usr/share/gnu-config/config.sub /usr/share/gnu-config/config.guess + ./configure --build=i586-alt-linux --host=i586-alt-linux --prefix=/usr --exec-prefix=/usr --bindir=/usr/bin --sbindir=/usr/sbin --sysconfdir=/etc --datadir=/usr/share --includedir=/usr/include --libdir=/usr/lib --libexecdir=/usr/lib --localstatedir=/var/lib --sharedstatedir=/var/lib --mandir=/usr/share/man --infodir=/usr/share/info --disable-dependency-tracking --without-included-gettext --docdir=/usr/share/doc/os-autoinst-4.5.1527308405.8b586d5 configure: WARNING: unrecognized options: --without-included-gettext checking for a BSD-compatible install... /bin/install -c checking whether build environment is sane... yes checking for a thread-safe mkdir -p... /bin/mkdir -p checking for gawk... gawk checking whether make sets $(MAKE)... yes checking whether make supports nested variables... yes checking whether make supports nested variables... (cached) yes checking for i586-alt-linux-g++... i586-alt-linux-g++ checking whether the C++ compiler works... yes checking for C++ compiler default output file name... a.out checking for suffix of executables... checking whether we are cross compiling... no checking for suffix of object files... o checking whether we are using the GNU C++ compiler... yes checking whether i586-alt-linux-g++ accepts -g... yes checking for style of include used by make... GNU checking dependency style of i586-alt-linux-g++... none checking whether i586-alt-linux-g++ supports C++11 features by default... yes checking build system type... i586-alt-linux-gnu checking host system type... i586-alt-linux-gnu checking how to print strings... printf checking for i586-alt-linux-gcc... i586-alt-linux-gcc checking whether we are using the GNU C compiler... yes checking whether i586-alt-linux-gcc accepts -g... yes checking for i586-alt-linux-gcc option to accept ISO C89... none needed checking whether i586-alt-linux-gcc understands -c and -o together... yes checking dependency style of i586-alt-linux-gcc... none checking for a sed that does not truncate output... /bin/sed checking for grep that handles long lines and -e... /bin/grep checking for egrep... /bin/grep -E checking for fgrep... /bin/grep -F checking for ld used by i586-alt-linux-gcc... /usr/bin/ld checking if the linker (/usr/bin/ld) is GNU ld... yes checking for BSD- or MS-compatible name lister (nm)... /usr/bin/nm -B checking the name lister (/usr/bin/nm -B) interface... BSD nm checking whether ln -s works... yes checking the maximum length of command line arguments... 1572864 checking whether the shell understands some XSI constructs... yes checking whether the shell understands "+="... yes checking how to convert i586-alt-linux-gnu file names to i586-alt-linux-gnu format... func_convert_file_noop checking how to convert i586-alt-linux-gnu file names to toolchain format... func_convert_file_noop checking for /usr/bin/ld option to reload object files... -r checking for i586-alt-linux-objdump... no checking for objdump... objdump checking how to recognize dependent libraries... (cached) pass_all checking for i586-alt-linux-dlltool... no checking for dlltool... no checking how to associate runtime and link libraries... printf %s\n checking for i586-alt-linux-ar... no checking for ar... ar checking for archiver @FILE support... @ checking for i586-alt-linux-strip... no checking for strip... strip checking for i586-alt-linux-ranlib... no checking for ranlib... ranlib checking command to parse /usr/bin/nm -B output from i586-alt-linux-gcc object... ok checking for sysroot... no checking for i586-alt-linux-mt... no checking for mt... no checking if : is a manifest tool... no checking how to run the C preprocessor... i586-alt-linux-gcc -E checking for ANSI C header files... yes checking for sys/types.h... yes checking for sys/stat.h... yes checking for stdlib.h... yes checking for string.h... yes checking for memory.h... yes checking for strings.h... yes checking for inttypes.h... yes checking for stdint.h... yes checking for unistd.h... yes checking for dlfcn.h... yes checking for objdir... .libs checking if i586-alt-linux-gcc supports -fno-rtti -fno-exceptions... no checking for i586-alt-linux-gcc option to produce PIC... -fPIC -DPIC checking if i586-alt-linux-gcc PIC flag -fPIC -DPIC works... yes checking if i586-alt-linux-gcc static flag -static works... no checking if i586-alt-linux-gcc supports -c -o file.o... yes checking if i586-alt-linux-gcc supports -c -o file.o... (cached) yes checking whether the i586-alt-linux-gcc linker (/usr/bin/ld) supports shared libraries... yes checking whether -lc should be explicitly linked in... no checking dynamic linker characteristics... GNU/Linux ld.so checking how to hardcode library paths into programs... immediate checking whether stripping libraries is possible... yes checking if libtool supports shared libraries... yes checking whether to build shared libraries... yes checking whether to build static libraries... yes checking how to run the C++ preprocessor... i586-alt-linux-g++ -E checking for ld used by i586-alt-linux-g++... /usr/bin/ld checking if the linker (/usr/bin/ld) is GNU ld... yes checking whether the i586-alt-linux-g++ linker (/usr/bin/ld) supports shared libraries... yes checking for i586-alt-linux-g++ option to produce PIC... -fPIC -DPIC checking if i586-alt-linux-g++ PIC flag -fPIC -DPIC works... yes checking if i586-alt-linux-g++ static flag -static works... no checking if i586-alt-linux-g++ supports -c -o file.o... yes checking if i586-alt-linux-g++ supports -c -o file.o... (cached) yes checking whether the i586-alt-linux-g++ linker (/usr/bin/ld) supports shared libraries... yes checking dynamic linker characteristics... (cached) GNU/Linux ld.so checking how to hardcode library paths into programs... immediate checking for i586-alt-linux-pkg-config... no checking for pkg-config... /usr/bin/pkg-config checking pkg-config is at least version 0.20... yes checking perl CFLAGS... -D_REENTRANT -D_GNU_SOURCE -fwrapv -fno-strict-aliasing -pipe -fstack-protector-strong -I/usr/local/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -I/usr/lib/perl5/CORE checking for opencv >= 2.4... yes checking for theoraenc >= 1.1... yes checking for fftw3... yes checking for sndfile... yes checking that generated files are newer than configure... done configure: creating ./config.status config.status: creating Makefile config.status: creating t/Makefile config.status: creating debugviewer/Makefile config.status: creating snd2png/Makefile config.status: executing depfiles commands config.status: executing libtool commands configure: WARNING: unrecognized options: --without-included-gettext + make -j8 INSTALLDIRS=vendor Making all in t make[1]: Nothing to be done for 'all'. Making all in debugviewer make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/debugviewer' CXX debugviewer.o make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/debugviewer' make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/debugviewer' CXXLD debugviewer make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/debugviewer' Making all in snd2png make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/snd2png' CXX snd2png.o snd2png.cpp: In function 'int main(int, char**)': snd2png.cpp:71:21: warning: format '%ld' expects argument of type 'long int', but argument 5 has type 'sf_count_t' {aka 'long long int'} [-Wformat=] fprintf(stderr, "snd2png: %d channels, samplerate %d Hz, %ld frames (%.2f seconds)\n", info_in.channels, ^~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~ info_in.samplerate, info_in.frames, (float)(info_in.frames)/info_in.samplerate); ~~~~~~~~~~~~~~ snd2png.cpp:100:21: warning: format '%ld' expects argument of type 'long int', but argument 3 has type 'sf_count_t' {aka 'long long int'} [-Wformat=] fprintf(stderr, "snd2png: %ld frequency bins\n", nDftSamples); ^~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~ ~~~~~~~~~~~ make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/snd2png' make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/snd2png' CXXLD snd2png make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/snd2png' make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' CXX videoencoder.o videoencoder.cpp: In function 'int main(int, char**)': videoencoder.cpp:312:20: warning: comparison of integer expressions of different signedness: 'int' and 'ogg_uint32_t' {aka 'unsigned int'} [-Wsign-compare] if (repeat >= (keyframe_frequency - 1) || line[0] != 'R') { ~~~~~~~^~~~~~~~~~~~~~~~~~~~~~~~~~~ videoencoder.cpp:340:33: warning: format '%ld' expects argument of type 'long int', but argument 3 has type 'size_t' {aka 'unsigned int'} [-Wformat=] fprintf(stderr, "Unexpected end of data %ld\n", r); ^~~~~~~~~~~~~~~~~~~~~~~~~~~~~~ ~ videoencoder.cpp:372:20: warning: ignoring return value of 'int symlink(const char*, const char*)', declared with attribute warn_unused_result [-Wunused-result] symlink(basename(path), "qemuscreenshot/last.png"); ~~~~~~~^~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~~ make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' CXXLD videoencoder make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' pod2html basetest.pm > doc/basetest.html make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' pod2html testapi.pm > doc/testapi.html make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' cd ppmclibs && \ perl Makefile.PL OPTIMIZE="-pipe -frecord-gcc-switches -Wall -g -O2 -march=i586 -mtune=generic" CC="i586-alt-linux-g++" \1 better written as $1 at Makefile.PL line 7. Generating a Unix-style Makefile Writing Makefile for tinycv make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' make -C ppmclibs make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' Running Mkbootstrap for tinycv () chmod 644 "tinycv.bs" make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' "/usr/bin/perl" -MExtUtils::Command::MM -e 'cp_nonempty' -- tinycv.bs blib/arch/auto/tinycv/tinycv.bs 644 make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' cp tinycv.pm blib/lib/tinycv.pm make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' "/usr/bin/perl" "/usr/share/perl5/ExtUtils/xsubpp" -C++ -typemap '/usr/share/perl5/ExtUtils/typemap' -typemap '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs/typemap' tinycv.xs > tinycv.xsc mv tinycv.xsc tinycv.c make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' i586-alt-linux-g++ -c -I/usr/include/opencv -D_REENTRANT -D_GNU_SOURCE -fwrapv -fno-strict-aliasing -pipe -fstack-protector-strong -I/usr/local/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -pipe -frecord-gcc-switches -Wall -g -O2 -march=i586 -mtune=generic -DVERSION=\"1.0\" -DXS_VERSION=\"1.0\" -fPIC "-I/usr/lib/perl5/CORE" -Wall tinycv_ast2100.cc make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' i586-alt-linux-g++ -c -I/usr/include/opencv -D_REENTRANT -D_GNU_SOURCE -fwrapv -fno-strict-aliasing -pipe -fstack-protector-strong -I/usr/local/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -pipe -frecord-gcc-switches -Wall -g -O2 -march=i586 -mtune=generic -DVERSION=\"1.0\" -DXS_VERSION=\"1.0\" -fPIC "-I/usr/lib/perl5/CORE" -Wall tinycv.c make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' i586-alt-linux-g++ -c -I/usr/include/opencv -D_REENTRANT -D_GNU_SOURCE -fwrapv -fno-strict-aliasing -pipe -fstack-protector-strong -I/usr/local/include -D_LARGEFILE_SOURCE -D_FILE_OFFSET_BITS=64 -pipe -frecord-gcc-switches -Wall -g -O2 -march=i586 -mtune=generic -DVERSION=\"1.0\" -DXS_VERSION=\"1.0\" -fPIC "-I/usr/lib/perl5/CORE" -Wall tinycv_impl.cc make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' rm -f blib/arch/auto/tinycv/tinycv.so g++ -lpthread -shared -L/usr/local/lib -fstack-protector-strong tinycv.o tinycv_ast2100.o tinycv_impl.o -o blib/arch/auto/tinycv/tinycv.so \ -lopencv_core -lopencv_imgcodecs \ -L/usr/lib/perl5/CORE -lperl -lpthread chmod 755 blib/arch/auto/tinycv/tinycv.so make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' + exit 0 Executing(%install): /bin/sh -e /usr/src/tmp/rpm-tmp.50642 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + /bin/chmod -Rf u+rwX -- /usr/src/tmp/os-autoinst-buildroot + : + /bin/rm -rf -- /usr/src/tmp/os-autoinst-buildroot + cd os-autoinst-4.5.1527308405.8b586d5 + make 'INSTALL=/bin/install -p' install DESTDIR=/usr/src/tmp/os-autoinst-buildroot INSTALLDIRS=vendor make: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' Making install in t make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' make[2]: Nothing to be done for 'install-exec-am'. make[2]: Nothing to be done for 'install-data-am'. make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' Making install in debugviewer make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/debugviewer' make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/debugviewer' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/bin' /bin/sh ../libtool --mode=install /bin/install -p debugviewer '/usr/src/tmp/os-autoinst-buildroot/usr/bin' libtool: install: /bin/install -p debugviewer /usr/src/tmp/os-autoinst-buildroot/usr/bin/debugviewer make[2]: Nothing to be done for 'install-data-am'. make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/debugviewer' make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/debugviewer' Making install in snd2png make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/snd2png' make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/snd2png' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/bin' /bin/sh ../libtool --mode=install /bin/install -p snd2png '/usr/src/tmp/os-autoinst-buildroot/usr/bin' libtool: install: /bin/install -p snd2png /usr/src/tmp/os-autoinst-buildroot/usr/bin/snd2png make[2]: Nothing to be done for 'install-data-am'. make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/snd2png' make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/snd2png' make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/backend' /bin/install -p -m 644 backend/baseclass.pm backend/console_proxy.pm backend/driver.pm backend/generalhw.pm backend/ikvm.pm backend/ipmi.pm backend/qemu.pm backend/s390x.pm backend/svirt.pm backend/pvm.pm backend/spvm.pm backend/virt.pm '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/backend' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/bin' /bin/install -p isotovideo '/usr/src/tmp/os-autoinst-buildroot/usr/bin' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/consoles' /bin/install -p -m 644 consoles/console.pm consoles/icewm.cfg consoles/ipmiSol.pm consoles/localXvnc.pm consoles/remoteVnc.pm consoles/s3270.pm consoles/sshX3270.pm consoles/sshVirtsh.pm consoles/sshVirtshSUT.pm consoles/sshIucvconn.pm consoles/sshXtermIPMI.pm consoles/sshXtermVt.pm consoles/ttyConsole.pm consoles/virtio_screen.pm consoles/virtio_terminal.pm consoles/vnc_base.pm consoles/network_console.pm consoles/VNC.pm '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/consoles' make -C ppmclibs pure_install DESTDIR="/usr/src/tmp/os-autoinst-buildroot" INSTALLDIRS="vendor" make[3]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' "/usr/bin/perl" -MExtUtils::Command::MM -e 'cp_nonempty' -- tinycv.bs blib/arch/auto/tinycv/tinycv.bs 644 Files found in blib/arch: installing files in blib/lib into architecture dependent library tree Installing /usr/src/tmp/os-autoinst-buildroot/usr/lib/perl5/auto/tinycv/tinycv.so Installing /usr/src/tmp/os-autoinst-buildroot/usr/lib/perl5/tinycv.pm make[3]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/ppmclibs' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/OpenQA' /bin/install -p -m 644 OpenQA/Commands.pm OpenQA/Exceptions.pm '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/OpenQA' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/OpenQA/Benchmark' /bin/install -p -m 644 OpenQA/Benchmark/Stopwatch.pm '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/OpenQA/Benchmark' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/OpenQA/Qemu' /bin/install -p -m 644 OpenQA/Qemu/BlockDevConf.pm OpenQA/Qemu/BlockDev.pm OpenQA/Qemu/ControllerConf.pm OpenQA/Qemu/DriveController.pm OpenQA/Qemu/DriveDevice.pm OpenQA/Qemu/DrivePath.pm OpenQA/Qemu/MutParams.pm OpenQA/Qemu/PFlashDevice.pm OpenQA/Qemu/Proc.pm OpenQA/Qemu/SnapshotConf.pm OpenQA/Qemu/Snapshot.pm '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/OpenQA/Qemu' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/OpenQA/Test' /bin/install -p -m 644 OpenQA/Test/RunArgs.pm '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/OpenQA/Test' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst' /bin/install -p -m 644 autotest.pm basetest.pm bmwqemu.pm testapi.pm myjsonrpc.pm mmapi.pm lockapi.pm commands.pm distribution.pm ocr.pm cv.pm needle.pm osutils.pm '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst' /bin/sh ./libtool --mode=install /bin/install -p videoencoder '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst' libtool: install: /bin/install -p videoencoder /usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/videoencoder /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst' /bin/install -p crop.py os-autoinst-openvswitch '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst' make install-exec-hook make[3]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' sed -i -e "s,\$installprefix = undef;,\$installprefix = '/usr/lib/os-autoinst';," /usr/src/tmp/os-autoinst-buildroot/usr/bin/isotovideo && \ sed -i -e "s,\$sysdir = undef;,\$sysdir = '/usr/lib/os-autoinst';," /usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/cv.pm make[3]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' rm -f systemd/os-autoinst-openvswitch.service systemd/os-autoinst-openvswitch.service.tmp sed -e 's,@pkglibexecdir[@],/usr/lib/os-autoinst,g' './systemd/os-autoinst-openvswitch.service.in' > './systemd/os-autoinst-openvswitch.service.tmp' mv './systemd/os-autoinst-openvswitch.service.tmp' './systemd/os-autoinst-openvswitch.service' /bin/mkdir -p /usr/src/tmp/os-autoinst-buildroot/ ; \ for i in ; do \ cp -r ./$i "/usr/src/tmp/os-autoinst-buildroot/" ; \ done /bin/mkdir -p "/usr/src/tmp/os-autoinst-buildroot//usr/share/os-autoinst" ; \ for i in tools inst inst.d dmidata ; do \ cp -r ./$i "/usr/src/tmp/os-autoinst-buildroot//usr/lib/os-autoinst" ; \ done cp: cannot stat './inst': No such file or directory cp: cannot stat './inst.d': No such file or directory install -D -m 644 ./etc/dbus-1/system.d/org.opensuse.os_autoinst.switch.conf "/usr/src/tmp/os-autoinst-buildroot/etc/dbus-1/system.d/org.opensuse.os_autoinst.switch.conf" install -D -m 644 "./systemd/os-autoinst-openvswitch.service" "/usr/src/tmp/os-autoinst-buildroot/lib/systemd/system/os-autoinst-openvswitch.service" /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/share/doc/os-autoinst-4.5.1527308405.8b586d5' /bin/install -p -m 644 README.asciidoc INSTALL.asciidoc COPYING doc/basetest.html doc/testapi.html '/usr/src/tmp/os-autoinst-buildroot/usr/share/doc/os-autoinst-4.5.1527308405.8b586d5' /bin/mkdir -p '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/OpenQA/Isotovideo' /bin/install -p -m 644 OpenQA/Isotovideo/CommandHandler.pm OpenQA/Isotovideo/NeedleDownloader.pm OpenQA/Isotovideo/Interface.pm OpenQA/Isotovideo/Utils.pm '/usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/OpenQA/Isotovideo' make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' make: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' + rm /usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/tools/tidy + rm -r /usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/tools/lib/perlcritic + rm /usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/tools/check_coverage + rm /usr/src/tmp/os-autoinst-buildroot/usr/lib/os-autoinst/crop.py + /usr/lib/rpm/brp-alt Cleaning files in /usr/src/tmp/os-autoinst-buildroot (auto) removed './usr/lib/perl5/auto/tinycv/.packlist' mode of './usr/lib/perl5/auto/tinycv/tinycv.so' changed from 0755 (rwxr-xr-x) to 0644 (rw-r--r--) Verifying and fixing files in /usr/src/tmp/os-autoinst-buildroot (binconfig,pkgconfig,libtool,desktop) Checking contents of files in /usr/src/tmp/os-autoinst-buildroot/ (default) Compressing files in /usr/src/tmp/os-autoinst-buildroot (auto) Adjusting library links in /usr/src/tmp/os-autoinst-buildroot ./lib: ./usr/lib: ./usr/lib/os-autoinst/tools/lib: Verifying ELF objects in /usr/src/tmp/os-autoinst-buildroot (arch=normal,fhs=normal,lfs=relaxed,lint=relaxed,rpath=normal,stack=normal,textrel=normal,unresolved=normal) Hardlinking identical .pyc and .pyo files Executing(%check): /bin/sh -e /usr/src/tmp/rpm-tmp.44498 + umask 022 + /bin/mkdir -p /usr/src/RPM/BUILD + cd /usr/src/RPM/BUILD + cd os-autoinst-4.5.1527308405.8b586d5 + sed -i -e '/tidy --check/d' Makefile + make check VERBOSE=1 make: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' Making check in t make[1]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' make PERL5OPT="-MDevel::Cover=-db,/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/cover_db,-ignore,^*\.t|^data\/tests\/*|^fake\/tests\/*" PERL5LIB="..:../ppmclibs:../ppmclibs/blib/arch/auto/tinycv:$PERL5LIB" check-TESTS make[2]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' make[3]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' PASS: 00-compile-check-all.t PASS: 01-test_needle.t PASS: 02-test_ocr.t PASS: 03-testapi.t PASS: 04-check_vars_docu.t PASS: 05-pod.t PASS: 06-pod-coverage.t PASS: 07-commands.t PASS: 08-autotest.t PASS: 09-lockapi.t PASS: 10-terminal.t PASS: 11-image-ppm.t PASS: 12-bmwqemu.t PASS: 13-osutils.t PASS: 14-isotovideo.t PASS: 16-send_with_fd.t PASS: 17-basetest.t PASS: 18-qemu.t FAIL: 18-qemu-options.t PASS: 20-openqa-benchmark-stopwatch-utils.t make[4]: Entering directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' make[4]: Nothing to be done for 'all'. make[4]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' ========================================= os-autoinst 1.1.0: t/test-suite.log ========================================= # TOTAL: 20 # PASS: 19 # SKIP: 0 # XFAIL: 0 # FAIL: 1 # XPASS: 0 # ERROR: 0 .. contents:: :depth: 2 FAIL: 18-qemu-options.t ======================= ^* matches null string many times in regex; marked by <-- HERE in m/^* <-- HERE \.t|^data\/tests\/*|^fake\/tests\/*/ at /usr/lib/perl5/Devel/Cover.pm line 379. # Subtest: qemu_append_option ^* matches null string many times in regex; marked by <-- HERE in m/^* <-- HERE \.t|^data\/tests\/*|^fake\/tests\/*/ at /usr/lib/perl5/Devel/Cover.pm line 379. [2019-02-15T10:00:46.002 UTC] [debug] Current version is 4.5.1527308405.8b586d5 [interface v13] [2019-02-15T10:00:46.011 UTC] [debug] Setting forced test parameter QEMU_DISABLE_SNAPSHOTS -> 1 [2019-02-15T10:00:46.014 UTC] [debug] git hash in /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests: 4.5.1527308405.8b586d5 [2019-02-15T10:00:46.066 UTC] [info] cmdsrv: daemon reachable under http://*:15223/mkITHWABJC/ [2019-02-15T10:00:46.076 UTC] [info] Listening at "http://0.0.0.0:15223" Server available at http://0.0.0.0:15223 [2019-02-15T10:00:46.152 UTC] [debug] scheduling boot tests/boot.pm [2019-02-15T10:00:46.155 UTC] [debug] scheduling select_console_fail_test tests/select_console_fail_test.pm [2019-02-15T10:00:46.158 UTC] [debug] scheduling select_ssh_console_fail_test tests/select_ssh_console_fail_test.pm [2019-02-15T10:00:46.161 UTC] [debug] scheduling assert_screen_fail_test tests/assert_screen_fail_test.pm [2019-02-15T10:00:46.164 UTC] [debug] scheduling typing tests/typing.pm [2019-02-15T10:00:46.167 UTC] [debug] scheduling reload_needles tests/reload_needles.pm [2019-02-15T10:00:46.170 UTC] [debug] scheduling modify_and_upload_file tests/modify_and_upload_file.pm [2019-02-15T10:00:46.172 UTC] [debug] scheduling shutdown tests/shutdown.pm [2019-02-15T10:00:46.178 UTC] [debug] init needles from /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests/needles [2019-02-15T10:00:46.188 UTC] [debug] loaded 4 needles [2019-02-15T10:00:46.188 UTC] [debug] git hash in /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests/needles: 4.5.1527308405.8b586d5 3323: channel_out 17, channel_in 16 5009: cmdpipe 15, rsppipe 18 [2019-02-15T10:00:47.170 UTC] [debug] started mgmt loop with pid 5009 remove_tree qemuscreenshot Use of uninitialized value in string ne at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/backend/qemu.pm line 512. [2019-02-15T10:00:47.238 UTC] [debug] running /usr/bin/chattr -f +C /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid [2019-02-15T10:01:07.593 UTC] [debug] running /usr/bin/qemu-img info --output=json /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso [2019-02-15T10:01:28.437 UTC] [debug] { "virtual-size": 11116544, "filename": "/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso", "format": "raw", "actual-size": 11116544, "dirty-flag": false } [2019-02-15T10:01:28.440 UTC] [debug] running /usr/bin/qemu-img create -f qcow2 /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0 10G [2019-02-15T10:01:46.991 UTC] [debug] Formatting '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0', fmt=qcow2 size=10737418240 cluster_size=65536 lazy_refcounts=off refcount_bits=16 [2019-02-15T10:01:46.992 UTC] [debug] running /usr/bin/qemu-img create -f qcow2 -b /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0 11116544 [2019-02-15T10:02:07.502 UTC] [debug] Formatting '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0', fmt=qcow2 size=11116544 backing_file=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso cluster_size=65536 lazy_refcounts=off refcount_bits=16 [2019-02-15T10:02:07.514 UTC] [debug] starting: /usr/bin/qemu-system-i386 -vga cirrus -chardev ringbuf,id=serial0,logfile=serial0,logappend=on -serial chardev:serial0 -soundhw ac97 -m 1024 -netdev user,id=qanet0 -device virtio-net,netdev=qanet0,mac=52:54:00:12:34:56 -boot once=d,menu=on,splash-time=5000 -smp 1 -no-shutdown -vnc :90,share=force-shared -device virtio-serial -chardev socket,path=virtio_console,server,nowait,id=virtio_console,logfile=virtio_console.log,logappend=on -device virtconsole,chardev=virtio_console,name=org.openqa.console.virtio_console -chardev socket,path=qmp_socket,server,nowait,id=qmp_socket,logfile=qmp_socket.log,logappend=on -qmp chardev:qmp_socket -S -version -blockdev driver=file,node-name=hd0-file,filename=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0,cache.no-flush=on -blockdev driver=qcow2,node-name=hd0,file=hd0-file,cache.no-flush=on -device ide-drive,id=hd0-device,drive=hd0,serial=hd0 -blockdev driver=file,node-name=cd0-overlay0-file,filename=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0,cache.no-flush=on -blockdev driver=qcow2,node-name=cd0-overlay0,file=cd0-overlay0-file,cache.no-flush=on -device ide-cd,id=cd0-device,drive=cd0-overlay0,serial=cd0 Attempt 0 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 1 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 2 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 3 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 4 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 5 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 6 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 7 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 8 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 9 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 10 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 11 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 12 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 13 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 14 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 15 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 16 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 17 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 18 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 19 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. [2019-02-15T10:02:27.266 UTC] [debug] Backend process died, backend errors are reported below in the following lines: can't open qmp at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/OpenQA/Qemu/Proc.pm line 404. [2019-02-15T10:02:27.269 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json last frame [2019-02-15T10:02:27.617 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json [2019-02-15T10:02:27.629 UTC] [debug] QEMU: QEMU emulator version 3.1.0 (qemu-3.1.0-alt1) [2019-02-15T10:02:27.630 UTC] [debug] QEMU: Copyright (c) 2003-2018 Fabrice Bellard and the QEMU Project developers [2019-02-15T10:02:27.631 UTC] [debug] QEMU: QEMU emulator version 3.1.0 (qemu-3.1.0-alt1) [2019-02-15T10:02:27.631 UTC] [debug] QEMU: Copyright (c) 2003-2018 Fabrice Bellard and the QEMU Project developers [2019-02-15T10:02:27.637 UTC] [debug] sending magic and exit [2019-02-15T10:02:27.638 UTC] [debug] received magic close [2019-02-15T10:02:28.639 UTC] [debug] backend got TERM [2019-02-15T10:02:28.639 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json [2019-02-15T10:02:28.641 UTC] [debug] sending magic and exit print() on closed filehandle GEN22 at /usr/lib/perl5/IO/Handle.pm line 418. [2019-02-15T10:02:28.664 UTC] [debug] backend process exited: 0 failed to start VM at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/backend/driver.pm line 137. 3323: EXIT 1 ok 1 - -version option added ok 2 - QEMU version printed ok 3 - Copyright printed ok 4 - no invalid option detected ^* matches null string many times in regex; marked by <-- HERE in m/^* <-- HERE \.t|^data\/tests\/*|^fake\/tests\/*/ at /usr/lib/perl5/Devel/Cover.pm line 379. [2019-02-15T10:03:00.015 UTC] [debug] Current version is 4.5.1527308405.8b586d5 [interface v13] [2019-02-15T10:03:00.033 UTC] [debug] Setting forced test parameter QEMU_DISABLE_SNAPSHOTS -> 1 [2019-02-15T10:03:00.041 UTC] [debug] git hash in /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests: 4.5.1527308405.8b586d5 [2019-02-15T10:03:00.102 UTC] [info] cmdsrv: daemon reachable under http://*:15223/veVKHwKKMz/ [2019-02-15T10:03:00.117 UTC] [info] Listening at "http://0.0.0.0:15223" Server available at http://0.0.0.0:15223 [2019-02-15T10:03:00.311 UTC] [debug] scheduling boot tests/boot.pm [2019-02-15T10:03:00.318 UTC] [debug] scheduling select_console_fail_test tests/select_console_fail_test.pm [2019-02-15T10:03:00.323 UTC] [debug] scheduling select_ssh_console_fail_test tests/select_ssh_console_fail_test.pm [2019-02-15T10:03:00.328 UTC] [debug] scheduling assert_screen_fail_test tests/assert_screen_fail_test.pm [2019-02-15T10:03:00.334 UTC] [debug] scheduling typing tests/typing.pm [2019-02-15T10:03:00.341 UTC] [debug] scheduling reload_needles tests/reload_needles.pm [2019-02-15T10:03:00.347 UTC] [debug] scheduling modify_and_upload_file tests/modify_and_upload_file.pm [2019-02-15T10:03:00.353 UTC] [debug] scheduling shutdown tests/shutdown.pm [2019-02-15T10:03:00.365 UTC] [debug] init needles from /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests/needles [2019-02-15T10:03:00.387 UTC] [debug] loaded 4 needles [2019-02-15T10:03:00.387 UTC] [debug] git hash in /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests/needles: 4.5.1527308405.8b586d5 30348: channel_out 17, channel_in 16 4246: cmdpipe 15, rsppipe 18 [2019-02-15T10:03:01.875 UTC] [debug] started mgmt loop with pid 4246 remove_tree qemuscreenshot Use of uninitialized value in string ne at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/backend/qemu.pm line 512. [2019-02-15T10:03:01.922 UTC] [debug] running /usr/bin/chattr -f +C /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid [2019-02-15T10:03:23.990 UTC] [debug] running /usr/bin/qemu-img info --output=json /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso [2019-02-15T10:03:44.540 UTC] [debug] { "virtual-size": 11116544, "filename": "/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso", "format": "raw", "actual-size": 11116544, "dirty-flag": false } [2019-02-15T10:03:44.544 UTC] [debug] running /usr/bin/qemu-img create -f qcow2 /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0 10G [2019-02-15T10:04:03.700 UTC] [debug] Formatting '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0', fmt=qcow2 size=10737418240 cluster_size=65536 lazy_refcounts=off refcount_bits=16 [2019-02-15T10:04:03.700 UTC] [debug] running /usr/bin/qemu-img create -f qcow2 -b /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0 11116544 [2019-02-15T10:04:23.049 UTC] [debug] Formatting '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0', fmt=qcow2 size=11116544 backing_file=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso cluster_size=65536 lazy_refcounts=off refcount_bits=16 [2019-02-15T10:04:23.061 UTC] [debug] starting: /usr/bin/qemu-system-i386 -vga cirrus -chardev ringbuf,id=serial0,logfile=serial0,logappend=on -serial chardev:serial0 -soundhw ac97 -m 1024 -netdev user,id=qanet0 -device virtio-net,netdev=qanet0,mac=52:54:00:12:34:56 -boot once=d,menu=on,splash-time=5000 -smp 1 -no-shutdown -vnc :90,share=force-shared -device virtio-serial -chardev socket,path=virtio_console,server,nowait,id=virtio_console,logfile=virtio_console.log,logappend=on -device virtconsole,chardev=virtio_console,name=org.openqa.console.virtio_console -chardev socket,path=qmp_socket,server,nowait,id=qmp_socket,logfile=qmp_socket.log,logappend=on -qmp chardev:qmp_socket -S -M ? -blockdev driver=file,node-name=hd0-file,filename=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0,cache.no-flush=on -blockdev driver=qcow2,node-name=hd0,file=hd0-file,cache.no-flush=on -device ide-drive,id=hd0-device,drive=hd0,serial=hd0 -blockdev driver=file,node-name=cd0-overlay0-file,filename=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0,cache.no-flush=on -blockdev driver=qcow2,node-name=cd0-overlay0,file=cd0-overlay0-file,cache.no-flush=on -device ide-cd,id=cd0-device,drive=cd0-overlay0,serial=cd0 Attempt 0 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 1 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 2 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 3 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 4 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 5 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 6 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 7 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 8 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 9 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 10 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 11 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 12 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 13 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 14 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 15 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 16 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 17 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 18 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 19 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. [2019-02-15T10:04:43.109 UTC] [debug] Backend process died, backend errors are reported below in the following lines: can't open qmp at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/OpenQA/Qemu/Proc.pm line 404. [2019-02-15T10:04:43.112 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json last frame [2019-02-15T10:04:45.494 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json [2019-02-15T10:04:45.504 UTC] [debug] QEMU: QEMU emulator version 3.1.0 (qemu-3.1.0-alt1) [2019-02-15T10:04:45.505 UTC] [debug] QEMU: Copyright (c) 2003-2018 Fabrice Bellard and the QEMU Project developers [2019-02-15T10:04:45.514 UTC] [debug] sending magic and exit [2019-02-15T10:04:45.516 UTC] [debug] received magic close [2019-02-15T10:04:46.518 UTC] [debug] backend got TERM [2019-02-15T10:04:46.518 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json [2019-02-15T10:04:46.521 UTC] [debug] sending magic and exit print() on closed filehandle GEN22 at /usr/lib/perl5/IO/Handle.pm line 418. [2019-02-15T10:04:46.545 UTC] [debug] backend process exited: 0 failed to start VM at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/backend/driver.pm line 137. 30348: EXIT 1 ok 5 - -M ? option added not ok 6 - Supported machines listed # Failed test 'Supported machines listed' # at ./18-qemu-options.t line 95. # got: '256' # expected: '0' ok 7 - no invalid option detected ^* matches null string many times in regex; marked by <-- HERE in m/^* <-- HERE \.t|^data\/tests\/*|^fake\/tests\/*/ at /usr/lib/perl5/Devel/Cover.pm line 379. [2019-02-15T10:05:19.207 UTC] [debug] Current version is 4.5.1527308405.8b586d5 [interface v13] [2019-02-15T10:05:19.234 UTC] [debug] Setting forced test parameter QEMU_DISABLE_SNAPSHOTS -> 1 [2019-02-15T10:05:19.247 UTC] [debug] git hash in /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests: 4.5.1527308405.8b586d5 [2019-02-15T10:05:19.314 UTC] [info] cmdsrv: daemon reachable under http://*:15223/ACDQFQIZqr/ [2019-02-15T10:05:19.330 UTC] [info] Listening at "http://0.0.0.0:15223" Server available at http://0.0.0.0:15223 [2019-02-15T10:05:19.588 UTC] [debug] scheduling boot tests/boot.pm [2019-02-15T10:05:19.593 UTC] [debug] scheduling select_console_fail_test tests/select_console_fail_test.pm [2019-02-15T10:05:19.599 UTC] [debug] scheduling select_ssh_console_fail_test tests/select_ssh_console_fail_test.pm [2019-02-15T10:05:19.605 UTC] [debug] scheduling assert_screen_fail_test tests/assert_screen_fail_test.pm [2019-02-15T10:05:19.611 UTC] [debug] scheduling typing tests/typing.pm [2019-02-15T10:05:19.616 UTC] [debug] scheduling reload_needles tests/reload_needles.pm [2019-02-15T10:05:19.621 UTC] [debug] scheduling modify_and_upload_file tests/modify_and_upload_file.pm [2019-02-15T10:05:19.627 UTC] [debug] scheduling shutdown tests/shutdown.pm [2019-02-15T10:05:19.637 UTC] [debug] init needles from /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests/needles [2019-02-15T10:05:19.657 UTC] [debug] loaded 4 needles [2019-02-15T10:05:19.658 UTC] [debug] git hash in /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests/needles: 4.5.1527308405.8b586d5 20795: channel_out 17, channel_in 16 23235: cmdpipe 15, rsppipe 18 [2019-02-15T10:05:20.893 UTC] [debug] started mgmt loop with pid 23235 remove_tree qemuscreenshot Use of uninitialized value in string ne at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/backend/qemu.pm line 512. [2019-02-15T10:05:20.957 UTC] [debug] running /usr/bin/chattr -f +C /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid [2019-02-15T10:05:40.450 UTC] [debug] running /usr/bin/qemu-img info --output=json /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso [2019-02-15T10:06:00.564 UTC] [debug] { "virtual-size": 11116544, "filename": "/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso", "format": "raw", "actual-size": 11116544, "dirty-flag": false } [2019-02-15T10:06:00.568 UTC] [debug] running /usr/bin/qemu-img create -f qcow2 /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0 10G [2019-02-15T10:06:22.013 UTC] [debug] Formatting '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0', fmt=qcow2 size=10737418240 cluster_size=65536 lazy_refcounts=off refcount_bits=16 [2019-02-15T10:06:22.013 UTC] [debug] running /usr/bin/qemu-img create -f qcow2 -b /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0 11116544 [2019-02-15T10:06:42.208 UTC] [debug] Formatting '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0', fmt=qcow2 size=11116544 backing_file=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso cluster_size=65536 lazy_refcounts=off refcount_bits=16 [2019-02-15T10:06:42.218 UTC] [debug] starting: /usr/bin/qemu-system-i386 -vga cirrus -chardev ringbuf,id=serial0,logfile=serial0,logappend=on -serial chardev:serial0 -soundhw ac97 -m 1024 -netdev user,id=qanet0 -device virtio-net,netdev=qanet0,mac=52:54:00:12:34:56 -boot once=d,menu=on,splash-time=5000 -smp 1 -no-shutdown -vnc :90,share=force-shared -device virtio-serial -chardev socket,path=virtio_console,server,nowait,id=virtio_console,logfile=virtio_console.log,logappend=on -device virtconsole,chardev=virtio_console,name=org.openqa.console.virtio_console -chardev socket,path=qmp_socket,server,nowait,id=qmp_socket,logfile=qmp_socket.log,logappend=on -qmp chardev:qmp_socket -S -M ? -version -blockdev driver=file,node-name=hd0-file,filename=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0,cache.no-flush=on -blockdev driver=qcow2,node-name=hd0,file=hd0-file,cache.no-flush=on -device ide-drive,id=hd0-device,drive=hd0,serial=hd0 -blockdev driver=file,node-name=cd0-overlay0-file,filename=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0,cache.no-flush=on -blockdev driver=qcow2,node-name=cd0-overlay0,file=cd0-overlay0-file,cache.no-flush=on -device ide-cd,id=cd0-device,drive=cd0-overlay0,serial=cd0 Attempt 0 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 1 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 2 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 3 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 4 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 5 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 6 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 7 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 8 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 9 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 10 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 11 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 12 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 13 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 14 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 15 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 16 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 17 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 18 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 19 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. [2019-02-15T10:07:02.155 UTC] [debug] Backend process died, backend errors are reported below in the following lines: can't open qmp at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/OpenQA/Qemu/Proc.pm line 404. [2019-02-15T10:07:02.159 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json last frame [2019-02-15T10:07:02.555 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json [2019-02-15T10:07:02.571 UTC] [debug] QEMU: QEMU emulator version 3.1.0 (qemu-3.1.0-alt1) [2019-02-15T10:07:02.571 UTC] [debug] QEMU: Copyright (c) 2003-2018 Fabrice Bellard and the QEMU Project developers [2019-02-15T10:07:02.572 UTC] [debug] QEMU: QEMU emulator version 3.1.0 (qemu-3.1.0-alt1) [2019-02-15T10:07:02.574 UTC] [debug] QEMU: Copyright (c) 2003-2018 Fabrice Bellard and the QEMU Project developers [2019-02-15T10:07:02.585 UTC] [debug] sending magic and exit [2019-02-15T10:07:02.586 UTC] [debug] received magic close [2019-02-15T10:07:03.593 UTC] [debug] backend got TERM [2019-02-15T10:07:03.593 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json [2019-02-15T10:07:03.596 UTC] [debug] sending magic and exit print() on closed filehandle GEN22 at /usr/lib/perl5/IO/Handle.pm line 418. [2019-02-15T10:07:03.632 UTC] [debug] backend process exited: 0 failed to start VM at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/backend/driver.pm line 137. 20795: EXIT 1 ok 8 - -version option added ok 9 - QEMU version printed ok 10 - Copyright printed ok 11 - no invalid option detected ^* matches null string many times in regex; marked by <-- HERE in m/^* <-- HERE \.t|^data\/tests\/*|^fake\/tests\/*/ at /usr/lib/perl5/Devel/Cover.pm line 379. [2019-02-15T10:07:37.564 UTC] [debug] Current version is 4.5.1527308405.8b586d5 [interface v13] [2019-02-15T10:07:37.588 UTC] [debug] Setting forced test parameter QEMU_DISABLE_SNAPSHOTS -> 1 [2019-02-15T10:07:37.609 UTC] [debug] git hash in /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests: 4.5.1527308405.8b586d5 [2019-02-15T10:07:37.656 UTC] [info] cmdsrv: daemon reachable under http://*:15223/IMVXcrIALQ/ [2019-02-15T10:07:37.667 UTC] [info] Listening at "http://0.0.0.0:15223" Server available at http://0.0.0.0:15223 [2019-02-15T10:07:37.921 UTC] [debug] scheduling boot tests/boot.pm [2019-02-15T10:07:37.927 UTC] [debug] scheduling select_console_fail_test tests/select_console_fail_test.pm [2019-02-15T10:07:37.933 UTC] [debug] scheduling select_ssh_console_fail_test tests/select_ssh_console_fail_test.pm [2019-02-15T10:07:37.939 UTC] [debug] scheduling assert_screen_fail_test tests/assert_screen_fail_test.pm [2019-02-15T10:07:37.945 UTC] [debug] scheduling typing tests/typing.pm [2019-02-15T10:07:37.951 UTC] [debug] scheduling reload_needles tests/reload_needles.pm [2019-02-15T10:07:37.957 UTC] [debug] scheduling modify_and_upload_file tests/modify_and_upload_file.pm [2019-02-15T10:07:37.962 UTC] [debug] scheduling shutdown tests/shutdown.pm [2019-02-15T10:07:37.973 UTC] [debug] init needles from /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests/needles [2019-02-15T10:07:37.993 UTC] [debug] loaded 4 needles [2019-02-15T10:07:37.993 UTC] [debug] git hash in /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//tests/needles: 4.5.1527308405.8b586d5 23586: channel_out 17, channel_in 16 26333: cmdpipe 15, rsppipe 18 [2019-02-15T10:07:38.598 UTC] [debug] started mgmt loop with pid 26333 remove_tree qemuscreenshot Use of uninitialized value in string ne at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/backend/qemu.pm line 512. [2019-02-15T10:07:38.647 UTC] [debug] running /usr/bin/chattr -f +C /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid [2019-02-15T10:07:59.013 UTC] [debug] running /usr/bin/qemu-img info --output=json /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso [2019-02-15T10:08:20.741 UTC] [debug] { "virtual-size": 11116544, "filename": "/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso", "format": "raw", "actual-size": 11116544, "dirty-flag": false } [2019-02-15T10:08:20.745 UTC] [debug] running /usr/bin/qemu-img create -f qcow2 /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0 10G [2019-02-15T10:08:41.163 UTC] [debug] Formatting '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0', fmt=qcow2 size=10737418240 cluster_size=65536 lazy_refcounts=off refcount_bits=16 [2019-02-15T10:08:41.163 UTC] [debug] running /usr/bin/qemu-img create -f qcow2 -b /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0 11116544 [2019-02-15T10:09:00.275 UTC] [debug] Formatting '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0', fmt=qcow2 size=11116544 backing_file=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/data//Core-7.2.iso cluster_size=65536 lazy_refcounts=off refcount_bits=16 [2019-02-15T10:09:00.286 UTC] [debug] starting: /usr/bin/qemu-system-i386 -vga cirrus -chardev ringbuf,id=serial0,logfile=serial0,logappend=on -serial chardev:serial0 -soundhw ac97 -m 1024 -netdev user,id=qanet0 -device virtio-net,netdev=qanet0,mac=52:54:00:12:34:56 -boot once=d,menu=on,splash-time=5000 -smp 1 -no-shutdown -vnc :90,share=force-shared -device virtio-serial -chardev socket,path=virtio_console,server,nowait,id=virtio_console,logfile=virtio_console.log,logappend=on -device virtconsole,chardev=virtio_console,name=org.openqa.console.virtio_console -chardev socket,path=qmp_socket,server,nowait,id=qmp_socket,logfile=qmp_socket.log,logappend=on -qmp chardev:qmp_socket -S -broken option -blockdev driver=file,node-name=hd0-file,filename=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/hd0,cache.no-flush=on -blockdev driver=qcow2,node-name=hd0,file=hd0-file,cache.no-flush=on -device ide-drive,id=hd0-device,drive=hd0,serial=hd0 -blockdev driver=file,node-name=cd0-overlay0-file,filename=/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t/pool/raid/cd0-overlay0,cache.no-flush=on -blockdev driver=qcow2,node-name=cd0-overlay0,file=cd0-overlay0-file,cache.no-flush=on -device ide-cd,id=cd0-device,drive=cd0-overlay0,serial=cd0 Attempt 0 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 1 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 2 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 3 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 4 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 5 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 6 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 7 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 8 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 9 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 10 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 11 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 12 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 13 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 14 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 15 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 16 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 17 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 18 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. Attempt 19 at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/osutils.pm line 130. [2019-02-15T10:09:20.119 UTC] [debug] Backend process died, backend errors are reported below in the following lines: can't open qmp at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/OpenQA/Qemu/Proc.pm line 404. [2019-02-15T10:09:20.120 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json last frame [2019-02-15T10:09:20.249 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json [2019-02-15T10:09:20.253 UTC] [debug] QEMU: QEMU emulator version 3.1.0 (qemu-3.1.0-alt1) [2019-02-15T10:09:20.254 UTC] [debug] QEMU: Copyright (c) 2003-2018 Fabrice Bellard and the QEMU Project developers [2019-02-15T10:09:20.254 UTC] [debug] QEMU: qemu-system-i386: -broken: invalid option [2019-02-15T10:09:20.257 UTC] [debug] sending magic and exit [2019-02-15T10:09:20.258 UTC] [debug] received magic close [2019-02-15T10:09:21.259 UTC] [debug] backend got TERM [2019-02-15T10:09:21.260 UTC] [info] ::: OpenQA::Qemu::Proc::save_state: Saving QEMU state to qemu_state.json [2019-02-15T10:09:21.263 UTC] [debug] sending magic and exit print() on closed filehandle GEN22 at /usr/lib/perl5/IO/Handle.pm line 418. [2019-02-15T10:09:21.301 UTC] [debug] backend process exited: 0 failed to start VM at /usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/backend/driver.pm line 137. 23586: EXIT 1 ok 12 - -broken option added ok 13 - invalid option detected 1..13 # Looks like you failed 1 test of 13. not ok 1 - qemu_append_option # Failed test 'qemu_append_option' # at ./18-qemu-options.t line 151. ok 2 - no (unexpected) warnings (via done_testing) 1..2 # Looks like you failed 1 test of 2. ============================================================================ Testsuite summary for os-autoinst 1.1.0 ============================================================================ # TOTAL: 20 # PASS: 19 # SKIP: 0 # XFAIL: 0 # FAIL: 1 # XPASS: 0 # ERROR: 0 ============================================================================ See t/test-suite.log Please report to https://github.com/os-autoinst/os-autoinst ============================================================================ make[3]: *** [Makefile:519: test-suite.log] Error 1 make[3]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' make[2]: *** [Makefile:627: check-TESTS] Error 2 make[2]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' make[1]: *** [Makefile:830: check-am] Error 2 make[1]: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5/t' make: *** [Makefile:925: check-recursive] Error 1 make: Leaving directory '/usr/src/RPM/BUILD/os-autoinst-4.5.1527308405.8b586d5' error: Bad exit status from /usr/src/tmp/rpm-tmp.44498 (%check) RPM build errors: Bad exit status from /usr/src/tmp/rpm-tmp.44498 (%check) Command exited with non-zero status 1 451.26user 17.15system 21:24.03elapsed 36%CPU (0avgtext+0avgdata 169368maxresident)k 0inputs+0outputs (0major+2683759minor)pagefaults 0swaps hsh-rebuild: rebuild of `os-autoinst-4.5.1527308405.8b586d5-alt2.src.rpm' failed. Command exited with non-zero status 1 520.00user 25.64system 22:43.37elapsed 40%CPU (0avgtext+0avgdata 169368maxresident)k 24056inputs+0outputs (0major+3329041minor)pagefaults 0swaps