http://fedorapeople.org/groups/cockpit/logs/pull-907-20191121-090101-e0d55748-weldr-lorax--rhel-7-8-openstack/log.html Testing e0d55748738464e28d11ad89f00adc7ae100ed85 for pull-907-20191121-090101 with rhel-7-8/openstack on 2-ci-srv-05... git tag -f HEAD warning: refname 'HEAD' is ambiguous. The archive is in lorax-composer-19.7.36.tar.gz rpmbuild -bs \ --define "_sourcedir /build/cockpit-project/bots/make-checkout-workdir" \ --define "_srcrpmdir /build/cockpit-project/bots/make-checkout-workdir" \ lorax-composer.spec Wrote: /build/cockpit-project/bots/make-checkout-workdir/lorax-composer-19.7.36-1.fc30.src.rpm git clone --quiet --reference-if-able ${XDG_CACHE_HOME:-$HOME/.cache}/cockpit-project/bots https://github.com/cockpit-project/bots.git if [ -n "$COCKPIT_BOTS_REF" ]; then git -C bots fetch --quiet --depth=1 origin "$COCKPIT_BOTS_REF"; git -C bots checkout --quiet FETCH_HEAD; fi checked out bots/ ref 9e4717b9072f3296387a8ab3ec06216544823bc8 srpm=lorax-composer-19.7.36-1.fc30.src.rpm ; \ bots/image-customize -v \ --resize 20G \ --upload $srpm:/var/tmp \ --upload /build/cockpit-project/bots/make-checkout-workdir/test/vm.install:/var/tmp/vm.install \ --upload /build/cockpit-project/bots/make-checkout-workdir/tests:/ \ --run-command "chmod +x /var/tmp/vm.install" \ --run-command "cd /var/tmp; /var/tmp/vm.install $srpm" \ rhel-7-8 Image resized. 8165f9a0-9a25-4d51-9d94-fd1b8aa090e6 + SRPM=lorax-composer-19.7.36-1.fc30.src.rpm + cat + grep anaconda + xargs yum -y remove + rpm -qa Loaded plugins: product-id, search-disabled-repos, subscription-manager This system is not registered with an entitlement server. You can use subscription-manager to register. Resolving Dependencies --> Running transaction check ---> Package anaconda-core.x86_64 0:21.48.22.158-1.el7 will be erased ---> Package anaconda-tui.x86_64 0:21.48.22.158-1.el7 will be erased --> Processing Dependency: anaconda-tui for package: lorax-composer-19.7.35-1.el7.x86_64 ---> Package libreport-anaconda.x86_64 0:2.1.11-53.el7 will be erased ---> Package libreport-rhel-anaconda-bugzilla.x86_64 0:2.1.11-53.el7 will be erased --> Running transaction check ---> Package lorax-composer.x86_64 0:19.7.35-1.el7 will be erased --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Removing: anaconda-core x86_64 21.48.22.158-1.el7 @RHEL-7.8 8.2 M anaconda-tui x86_64 21.48.22.158-1.el7 @RHEL-7.8 447 k libreport-anaconda x86_64 2.1.11-53.el7 @RHEL-7.8 20 k libreport-rhel-anaconda-bugzilla x86_64 2.1.11-53.el7 @RHEL-7.8 5.2 k Removing for dependencies: lorax-composer x86_64 19.7.35-1.el7 @EXTRAS-7.8 3.5 M Transaction Summary ================================================================================ Remove 4 Packages (+1 Dependent package) Installed size: 12 M Downloading packages: Running transaction check Running transaction test Transaction test succeeded Running transaction Erasing : lorax-composer-19.7.35-1.el7.x86_64 1/5 Erasing : anaconda-core-21.48.22.158-1.el7.x86_64 2/5 Erasing : anaconda-tui-21.48.22.158-1.el7.x86_64 3/5 Erasing : libreport-anaconda-2.1.11-53.el7.x86_64 4/5 Erasing : libreport-rhel-anaconda-bugzilla-2.1.11-53.el7.x86_64 5/5 Verifying : lorax-composer-19.7.35-1.el7.x86_64 1/5 Verifying : libreport-rhel-anaconda-bugzilla-2.1.11-53.el7.x86_64 2/5 Verifying : anaconda-tui-21.48.22.158-1.el7.x86_64 3/5 Verifying : anaconda-core-21.48.22.158-1.el7.x86_64 4/5 Verifying : libreport-anaconda-2.1.11-53.el7.x86_64 5/5 Removed: anaconda-core.x86_64 0:21.48.22.158-1.el7 anaconda-tui.x86_64 0:21.48.22.158-1.el7 libreport-anaconda.x86_64 0:2.1.11-53.el7 libreport-rhel-anaconda-bugzilla.x86_64 0:2.1.11-53.el7 Dependency Removed: lorax-composer.x86_64 0:19.7.35-1.el7 Complete! + grep lorax + xargs yum -y remove + rpm -qa Loaded plugins: product-id, search-disabled-repos, subscription-manager This system is not registered with an entitlement server. You can use subscription-manager to register. Resolving Dependencies --> Running transaction check ---> Package lorax.x86_64 0:19.7.25-1.el7 will be erased --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Removing: lorax x86_64 19.7.25-1.el7 @RHEL-7.8 2.5 M Transaction Summary ================================================================================ Remove 1 Package Installed size: 2.5 M Downloading packages: Running transaction check Running transaction test Transaction test succeeded Running transaction Erasing : lorax-19.7.25-1.el7.x86_64 1/1 Verifying : lorax-19.7.25-1.el7.x86_64 1/1 Removed: lorax.x86_64 0:19.7.25-1.el7 Complete! + LATEST_REPO=/etc/yum.repos.d/rhel7-rel-eng-latest.repo + '[' '!' -f /etc/yum.repos.d/rhel7-rel-eng-latest.repo ']' + cat + rpm -q beakerlib package beakerlib is not installed ++ . /etc/os-release +++ NAME='Red Hat Enterprise Linux Server' +++ VERSION='7.8 (Maipo)' +++ ID=rhel +++ ID_LIKE=fedora +++ VARIANT=Server +++ VARIANT_ID=server +++ VERSION_ID=7.8 +++ PRETTY_NAME='Red Hat Enterprise Linux Server 7.8 Beta (Maipo)' +++ ANSI_COLOR='0;31' +++ CPE_NAME=cpe:/o:redhat:enterprise_linux:7.8:beta:server +++ HOME_URL=https://www.redhat.com/ +++ BUG_REPORT_URL=https://bugzilla.redhat.com/ +++ REDHAT_BUGZILLA_PRODUCT='Red Hat Enterprise Linux 7' +++ REDHAT_BUGZILLA_PRODUCT_VERSION=7.8 +++ REDHAT_SUPPORT_PRODUCT='Red Hat Enterprise Linux' +++ REDHAT_SUPPORT_PRODUCT_VERSION='7.8 Beta' ++ echo rhel + '[' rhel = rhel ']' + cd /etc/yum.repos.d + curl -O -L http://download.devel.redhat.com/beakerrepos/beaker-client-RedHatEnterpriseLinux.repo % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 271 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 403 100 403 0 0 1260 0 --:--:-- --:--:-- --:--:-- 1260 + sed -i 's/\(gpgcheck=0\)/\1\nsslverify=0/' /etc/yum.repos.d/beaker-client-RedHatEnterpriseLinux.repo + yum install -y beakerlib Loaded plugins: product-id, search-disabled-repos, subscription-manager This system is not registered with an entitlement server. You can use subscription-manager to register. This system is not registered with an entitlement server. You can use subscription-manager to register. Resolving Dependencies --> Running transaction check ---> Package beakerlib.noarch 0:1.18-7.el7bkr will be installed --> Processing Dependency: wget for package: beakerlib-1.18-7.el7bkr.noarch --> Running transaction check ---> Package wget.x86_64 0:1.14-18.el7_6.1 will be installed --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Installing: beakerlib noarch 1.18-7.el7bkr beaker-client 157 k Installing for dependencies: wget x86_64 1.14-18.el7_6.1 RHEL-7.8 547 k Transaction Summary ================================================================================ Install 1 Package (+1 Dependent package) Total download size: 704 k Installed size: 2.4 M Downloading packages: -------------------------------------------------------------------------------- Total 3.0 MB/s | 704 kB 00:00 Running transaction check Running transaction test Transaction test succeeded Running transaction Installing : wget-1.14-18.el7_6.1.x86_64 1/2 Installing : beakerlib-1.18-7.el7bkr.noarch 2/2 Verifying : wget-1.14-18.el7_6.1.x86_64 1/2 Verifying : beakerlib-1.18-7.el7bkr.noarch 2/2 Installed: beakerlib.noarch 0:1.18-7.el7bkr Dependency Installed: wget.x86_64 0:1.14-18.el7_6.1 Complete! + EPEL_REPO=/etc/yum.repos.d/epel7.repo + '[' '!' -f /etc/yum.repos.d/epel7.repo ']' + cat + rpm -q python2-pip package python2-pip is not installed + yum -y install python2-pip Loaded plugins: product-id, search-disabled-repos, subscription-manager This system is not registered with an entitlement server. You can use subscription-manager to register. This system is not registered with an entitlement server. You can use subscription-manager to register. http://csc.mcs.sdsmt.edu/epel/7/x86_64/repodata/fe6b87bb242232c28935154404a147bc9f6104926f030885108ebfd92f9b0678-updateinfo.xml.bz2: [Errno 12] Timeout on http://csc.mcs.sdsmt.edu/epel/7/x86_64/repodata/fe6b87bb242232c28935154404a147bc9f6104926f030885108ebfd92f9b0678-updateinfo.xml.bz2: (28, 'Operation too slow. Less than 1000 bytes/sec transferred the last 30 seconds') Trying other mirror. Resolving Dependencies --> Running transaction check ---> Package python2-pip.noarch 0:8.1.2-10.el7 will be installed --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Installing: python2-pip noarch 8.1.2-10.el7 epel7 1.7 M Transaction Summary ================================================================================ Install 1 Package Total download size: 1.7 M Installed size: 7.2 M Downloading packages: Running transaction check Running transaction test Transaction test succeeded Running transaction Installing : python2-pip-8.1.2-10.el7.noarch 1/1 Verifying : python2-pip-8.1.2-10.el7.noarch 1/1 Installed: python2-pip.noarch 0:8.1.2-10.el7 Complete! + rpm -q python-virtualenv package python-virtualenv is not installed + yum -y install python-virtualenv Loaded plugins: product-id, search-disabled-repos, subscription-manager This system is not registered with an entitlement server. You can use subscription-manager to register. This system is not registered with an entitlement server. You can use subscription-manager to register. Resolving Dependencies --> Running transaction check ---> Package python-virtualenv.noarch 0:15.1.0-2.el7 will be installed --> Processing Dependency: python2-devel for package: python-virtualenv-15.1.0-2.el7.noarch --> Running transaction check ---> Package python-devel.x86_64 0:2.7.5-88.el7 will be installed --> Processing Dependency: python2-rpm-macros > 3-30 for package: python-devel-2.7.5-88.el7.x86_64 --> Processing Dependency: python-rpm-macros > 3-30 for package: python-devel-2.7.5-88.el7.x86_64 --> Running transaction check ---> Package python-rpm-macros.noarch 0:3-32.el7 will be installed ---> Package python2-rpm-macros.noarch 0:3-32.el7 will be installed --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Installing: python-virtualenv noarch 15.1.0-2.el7 RHEL-7.8 1.7 M Installing for dependencies: python-devel x86_64 2.7.5-88.el7 RHEL-7.8 398 k python-rpm-macros noarch 3-32.el7 RHEL-7.8 8.9 k python2-rpm-macros noarch 3-32.el7 RHEL-7.8 7.8 k Transaction Summary ================================================================================ Install 1 Package (+3 Dependent packages) Total download size: 2.1 M Installed size: 3.1 M Downloading packages: -------------------------------------------------------------------------------- Total 6.9 MB/s | 2.1 MB 00:00 Running transaction check Running transaction test Transaction test succeeded Running transaction Installing : python-rpm-macros-3-32.el7.noarch 1/4 Installing : python2-rpm-macros-3-32.el7.noarch 2/4 Installing : python-devel-2.7.5-88.el7.x86_64 3/4 Installing : python-virtualenv-15.1.0-2.el7.noarch 4/4 Verifying : python-devel-2.7.5-88.el7.x86_64 1/4 Verifying : python2-rpm-macros-3-32.el7.noarch 2/4 Verifying : python-virtualenv-15.1.0-2.el7.noarch 3/4 Verifying : python-rpm-macros-3-32.el7.noarch 4/4 Installed: python-virtualenv.noarch 0:15.1.0-2.el7 Dependency Installed: python-devel.x86_64 0:2.7.5-88.el7 python-rpm-macros.noarch 0:3-32.el7 python2-rpm-macros.noarch 0:3-32.el7 Complete! + rm -f /etc/yum.repos.d/epel7.repo + rpm -q python2-cryptography python2-cryptography-1.7.2-2.el7.x86_64 + yum remove -y python2-cryptography Loaded plugins: product-id, search-disabled-repos, subscription-manager This system is not registered with an entitlement server. You can use subscription-manager to register. Resolving Dependencies --> Running transaction check ---> Package python2-cryptography.x86_64 0:1.7.2-2.el7 will be erased --> Processing Dependency: python-cryptography >= 1.5 for package: python-jwcrypto-0.4.2-1.el7.noarch --> Processing Dependency: python2-cryptography >= 1.4 for package: python2-ipalib-4.6.6-9.el7.noarch --> Running transaction check ---> Package python-jwcrypto.noarch 0:0.4.2-1.el7 will be erased ---> Package python2-ipalib.noarch 0:4.6.6-9.el7 will be erased --> Processing Dependency: python2-ipalib = 4.6.6-9.el7 for package: python2-ipaclient-4.6.6-9.el7.noarch --> Running transaction check ---> Package python2-ipaclient.noarch 0:4.6.6-9.el7 will be erased --> Processing Dependency: python2-ipaclient = 4.6.6-9.el7 for package: ipa-client-4.6.6-9.el7.x86_64 --> Running transaction check ---> Package ipa-client.x86_64 0:4.6.6-9.el7 will be erased --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Removing: python2-cryptography x86_64 1.7.2-2.el7 @RHEL-7.8 2.6 M Removing for dependencies: ipa-client x86_64 4.6.6-9.el7 @RHEL-7.8 254 k python-jwcrypto noarch 0.4.2-1.el7 @RHEL-7.8 249 k python2-ipaclient noarch 4.6.6-9.el7 @RHEL-7.8 7.7 M python2-ipalib noarch 4.6.6-9.el7 @RHEL-7.8 2.7 M Transaction Summary ================================================================================ Remove 1 Package (+4 Dependent packages) Installed size: 14 M Downloading packages: Running transaction check Running transaction test Transaction test succeeded Running transaction Erasing : ipa-client-4.6.6-9.el7.x86_64 1/5 Erasing : python2-ipaclient-4.6.6-9.el7.noarch 2/5 Erasing : python2-ipalib-4.6.6-9.el7.noarch 3/5 Erasing : python-jwcrypto-0.4.2-1.el7.noarch 4/5 Erasing : python2-cryptography-1.7.2-2.el7.x86_64 5/5 Verifying : python2-ipalib-4.6.6-9.el7.noarch 1/5 Verifying : ipa-client-4.6.6-9.el7.x86_64 2/5 Verifying : python2-cryptography-1.7.2-2.el7.x86_64 3/5 Verifying : python2-ipaclient-4.6.6-9.el7.noarch 4/5 Verifying : python-jwcrypto-0.4.2-1.el7.noarch 5/5 Removed: python2-cryptography.x86_64 0:1.7.2-2.el7 Dependency Removed: ipa-client.x86_64 0:4.6.6-9.el7 python-jwcrypto.noarch 0:0.4.2-1.el7 python2-ipaclient.noarch 0:4.6.6-9.el7 python2-ipalib.noarch 0:4.6.6-9.el7 Complete! + rpm -q pyparsing pyparsing-1.5.6-9.el7.noarch + yum remove -y pyparsing Loaded plugins: product-id, search-disabled-repos, subscription-manager This system is not registered with an entitlement server. You can use subscription-manager to register. Resolving Dependencies --> Running transaction check ---> Package pyparsing.noarch 0:1.5.6-9.el7 will be erased --> Processing Dependency: pyparsing for package: 1:python-configshell-1.1.fb25-1.el7.noarch --> Running transaction check ---> Package python-configshell.noarch 1:1.1.fb25-1.el7 will be erased --> Processing Dependency: python-configshell for package: targetcli-2.1.fb49-1.el7.noarch --> Running transaction check ---> Package targetcli.noarch 0:2.1.fb49-1.el7 will be erased --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Removing: pyparsing noarch 1.5.6-9.el7 @RHEL-7.8 367 k Removing for dependencies: python-configshell noarch 1:1.1.fb25-1.el7 @RHEL-7.8 495 k targetcli noarch 2.1.fb49-1.el7 @RHEL-7.8 233 k Transaction Summary ================================================================================ Remove 1 Package (+2 Dependent packages) Installed size: 1.1 M Downloading packages: Running transaction check Running transaction test Transaction test succeeded Running transaction Erasing : targetcli-2.1.fb49-1.el7.noarch 1/3 Erasing : 1:python-configshell-1.1.fb25-1.el7.noarch 2/3 Erasing : pyparsing-1.5.6-9.el7.noarch 3/3 Verifying : pyparsing-1.5.6-9.el7.noarch 1/3 Verifying : targetcli-2.1.fb49-1.el7.noarch 2/3 Verifying : 1:python-configshell-1.1.fb25-1.el7.noarch 3/3 Removed: pyparsing.noarch 0:1.5.6-9.el7 Dependency Removed: python-configshell.noarch 1:1.1.fb25-1.el7 targetcli.noarch 0:2.1.fb49-1.el7 Complete! + rpm -q git package git is not installed + yum install -y git Loaded plugins: product-id, search-disabled-repos, subscription-manager This system is not registered with an entitlement server. You can use subscription-manager to register. This system is not registered with an entitlement server. You can use subscription-manager to register. Resolving Dependencies --> Running transaction check ---> Package git.x86_64 0:1.8.3.1-20.el7 will be installed --> Processing Dependency: perl-Git = 1.8.3.1-20.el7 for package: git-1.8.3.1-20.el7.x86_64 --> Processing Dependency: perl(Term::ReadKey) for package: git-1.8.3.1-20.el7.x86_64 --> Processing Dependency: perl(Git) for package: git-1.8.3.1-20.el7.x86_64 --> Processing Dependency: perl(Error) for package: git-1.8.3.1-20.el7.x86_64 --> Running transaction check ---> Package perl-Error.noarch 1:0.17020-2.el7 will be installed ---> Package perl-Git.noarch 0:1.8.3.1-20.el7 will be installed ---> Package perl-TermReadKey.x86_64 0:2.30-20.el7 will be installed --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Installing: git x86_64 1.8.3.1-20.el7 RHEL-7.8 4.4 M Installing for dependencies: perl-Error noarch 1:0.17020-2.el7 RHEL-7.8 32 k perl-Git noarch 1.8.3.1-20.el7 RHEL-7.8 55 k perl-TermReadKey x86_64 2.30-20.el7 RHEL-7.8 31 k Transaction Summary ================================================================================ Install 1 Package (+3 Dependent packages) Total download size: 4.5 M Installed size: 22 M Downloading packages: -------------------------------------------------------------------------------- Total 12 MB/s | 4.5 MB 00:00 Running transaction check Running transaction test Transaction test succeeded Running transaction Installing : 1:perl-Error-0.17020-2.el7.noarch 1/4 Installing : perl-TermReadKey-2.30-20.el7.x86_64 2/4 Installing : git-1.8.3.1-20.el7.x86_64 3/4 Installing : perl-Git-1.8.3.1-20.el7.noarch 4/4 Verifying : perl-Git-1.8.3.1-20.el7.noarch 1/4 Verifying : 1:perl-Error-0.17020-2.el7.noarch 2/4 Verifying : git-1.8.3.1-20.el7.x86_64 3/4 Verifying : perl-TermReadKey-2.30-20.el7.x86_64 4/4 Installed: git.x86_64 0:1.8.3.1-20.el7 Dependency Installed: perl-Error.noarch 1:0.17020-2.el7 perl-Git.noarch 0:1.8.3.1-20.el7 perl-TermReadKey.x86_64 0:2.30-20.el7 Complete! + parted --script /dev/vda resizepart 2 100% + partprobe Warning: Unable to open /dev/sr0 read-write (Read-only file system). /dev/sr0 has been opened read-only. + pvs --noheadings -opv_name + xargs pvresize Physical volume "/dev/vda2" changed 1 physical volume(s) resized or updated / 0 physical volume(s) not resized ++ findmnt --noheadings -oSOURCE / + rootlv=/dev/mapper/rhel-root + lvresize /dev/mapper/rhel-root -l+100%FREE -r Size of logical volume rhel/root changed from 9.79 GiB (2507 extents) to <17.80 GiB (4556 extents). Logical volume rhel/root successfully resized. meta-data=/dev/mapper/rhel-root isize=512 agcount=4, agsize=641792 blks = sectsz=512 attr=2, projid32bit=1 = crc=1 finobt=0 spinodes=0 data = bsize=4096 blocks=2567168, imaxpct=25 = sunit=0 swidth=0 blks naming =version 2 bsize=4096 ascii-ci=0 ftype=1 log =internal bsize=4096 blocks=2560, version=2 = sectsz=512 sunit=0 blks, lazy-count=1 realtime =none extsz=4096 blocks=0, rtextents=0 data blocks changed from 2567168 to 4665344 + rm -rf build-results + su builder -c '/usr/bin/mock --no-clean --resultdir build-results --rebuild lorax-composer-19.7.36-1.fc30.src.rpm' INFO: mock.py version 1.4.20 starting (python version = 3.6.8)... Start: init plugins INFO: selinux enabled Finish: init plugins INFO: Signal handler active Start: run INFO: Start(lorax-composer-19.7.36-1.fc30.src.rpm) Config(epel-7-x86_64) Start: chroot init INFO: calling preinit hooks INFO: enabled root cache INFO: enabled yum cache Start: cleaning yum metadata Finish: cleaning yum metadata INFO: enabled HW Info plugin Mock Version: 1.4.20 INFO: Mock Version: 1.4.20 Finish: chroot init Start: build phase for lorax-composer-19.7.36-1.fc30.src.rpm Start: build setup for lorax-composer-19.7.36-1.fc30.src.rpm Finish: build setup for lorax-composer-19.7.36-1.fc30.src.rpm Start: rpmbuild lorax-composer-19.7.36-1.fc30.src.rpm Start: Outputting list of installed packages Finish: Outputting list of installed packages Finish: rpmbuild lorax-composer-19.7.36-1.fc30.src.rpm Finish: build phase for lorax-composer-19.7.36-1.fc30.src.rpm INFO: Done(lorax-composer-19.7.36-1.fc30.src.rpm) Config(default) 0 minutes 49 seconds INFO: Results and/or logs in: build-results INFO: Cleaning up build root ('cleanup_on_success=True') Start: clean chroot Finish: clean chroot Finish: run ++ find build-results -name '*.rpm' -not -name '*.src.rpm' + packages='build-results/lorax-composer-19.7.36-1.el7.x86_64.rpm build-results/composer-cli-19.7.36-1.el7.x86_64.rpm' ++ basename -a build-results/lorax-composer-19.7.36-1.el7.x86_64.rpm build-results/composer-cli-19.7.36-1.el7.x86_64.rpm ++ sed 's/-[0-9].*.rpm$//' + rpm -e --verbose lorax-composer composer-cli error: package lorax-composer is not installed error: package composer-cli is not installed + true + yum install -y build-results/lorax-composer-19.7.36-1.el7.x86_64.rpm build-results/composer-cli-19.7.36-1.el7.x86_64.rpm Loaded plugins: product-id, search-disabled-repos, subscription-manager This system is not registered with an entitlement server. You can use subscription-manager to register. Examining build-results/lorax-composer-19.7.36-1.el7.x86_64.rpm: lorax-composer-19.7.36-1.el7.x86_64 Marking build-results/lorax-composer-19.7.36-1.el7.x86_64.rpm to be installed Examining build-results/composer-cli-19.7.36-1.el7.x86_64.rpm: composer-cli-19.7.36-1.el7.x86_64 Marking build-results/composer-cli-19.7.36-1.el7.x86_64.rpm to be installed Resolving Dependencies --> Running transaction check ---> Package composer-cli.x86_64 0:19.7.36-1.el7 will be installed ---> Package lorax-composer.x86_64 0:19.7.36-1.el7 will be installed --> Processing Dependency: lorax >= 19.7.22 for package: lorax-composer-19.7.36-1.el7.x86_64 This system is not registered with an entitlement server. You can use subscription-manager to register. --> Processing Dependency: anaconda-tui for package: lorax-composer-19.7.36-1.el7.x86_64 --> Running transaction check ---> Package anaconda-tui.x86_64 0:21.48.22.158-1.el7.bcl.1 will be installed --> Processing Dependency: anaconda-core = 21.48.22.158-1.el7.bcl.1 for package: anaconda-tui-21.48.22.158-1.el7.bcl.1.x86_64 ---> Package lorax.x86_64 0:19.7.25-1.el7 will be installed --> Running transaction check ---> Package anaconda-core.x86_64 0:21.48.22.158-1.el7.bcl.1 will be installed --> Processing Dependency: libreport-anaconda >= 2.0.21-1 for package: anaconda-core-21.48.22.158-1.el7.bcl.1.x86_64 --> Processing Dependency: libreport-rhel-anaconda-bugzilla >= 2.1.11-1 for package: anaconda-core-21.48.22.158-1.el7.bcl.1.x86_64 --> Running transaction check ---> Package libreport-anaconda.x86_64 0:2.1.11-53.el7 will be installed ---> Package libreport-rhel-anaconda-bugzilla.x86_64 0:2.1.11-53.el7 will be installed --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Installing: composer-cli x86_64 19.7.36-1.el7 /composer-cli-19.7.36-1.el7.x86_64 152 k lorax-composer x86_64 19.7.36-1.el7 /lorax-composer-19.7.36-1.el7.x86_64 3.6 M Installing for dependencies: anaconda-core x86_64 21.48.22.158-1.el7.bcl.1 scratch 1.6 M anaconda-tui x86_64 21.48.22.158-1.el7.bcl.1 scratch 290 k libreport-anaconda x86_64 2.1.11-53.el7 RHEL-7.8 51 k libreport-rhel-anaconda-bugzilla x86_64 2.1.11-53.el7 RHEL-7.8 43 k lorax x86_64 19.7.25-1.el7 RHEL-7.8 452 k Transaction Summary ================================================================================ Install 2 Packages (+5 Dependent packages) Total size: 6.2 M Total download size: 2.5 M Installed size: 15 M Downloading packages: -------------------------------------------------------------------------------- Total 4.6 MB/s | 2.5 MB 00:00 Running transaction check Running transaction test Transaction test succeeded Running transaction Installing : libreport-rhel-anaconda-bugzilla-2.1.11-53.el7.x86_64 1/7 Installing : libreport-anaconda-2.1.11-53.el7.x86_64 2/7 Installing : anaconda-core-21.48.22.158-1.el7.bcl.1.x86_64 3/7 Installing : anaconda-tui-21.48.22.158-1.el7.bcl.1.x86_64 4/7 Installing : lorax-19.7.25-1.el7.x86_64 5/7 Installing : lorax-composer-19.7.36-1.el7.x86_64 6/7 Installing : composer-cli-19.7.36-1.el7.x86_64 7/7 Verifying : anaconda-tui-21.48.22.158-1.el7.bcl.1.x86_64 1/7 Verifying : lorax-19.7.25-1.el7.x86_64 2/7 Verifying : anaconda-core-21.48.22.158-1.el7.bcl.1.x86_64 3/7 Verifying : lorax-composer-19.7.36-1.el7.x86_64 4/7 Verifying : libreport-anaconda-2.1.11-53.el7.x86_64 5/7 Verifying : libreport-rhel-anaconda-bugzilla-2.1.11-53.el7.x86_64 6/7 Verifying : composer-cli-19.7.36-1.el7.x86_64 7/7 Installed: composer-cli.x86_64 0:19.7.36-1.el7 lorax-composer.x86_64 0:19.7.36-1.el7 Dependency Installed: anaconda-core.x86_64 0:21.48.22.158-1.el7.bcl.1 anaconda-tui.x86_64 0:21.48.22.158-1.el7.bcl.1 libreport-anaconda.x86_64 0:2.1.11-53.el7 libreport-rhel-anaconda-bugzilla.x86_64 0:2.1.11-53.el7 lorax.x86_64 0:19.7.25-1.el7 Complete! + systemctl enable lorax-composer.socket Created symlink from /etc/systemd/system/sockets.target.wants/lorax-composer.socket to /usr/lib/systemd/system/lorax-composer.socket. + '[' -f /usr/bin/docker ']' ++ rpm -qf /usr/bin/docker + yum remove -y docker-common-1.13.1-104.git4ef4b30.el7.x86_64 Loaded plugins: product-id, search-disabled-repos, subscription-manager This system is not registered with an entitlement server. You can use subscription-manager to register. Resolving Dependencies --> Running transaction check ---> Package docker-common.x86_64 2:1.13.1-104.git4ef4b30.el7 will be erased --> Processing Dependency: docker-common for package: 2:docker-client-1.13.1-104.git4ef4b30.el7.x86_64 --> Processing Dependency: docker-common = 2:1.13.1-104.git4ef4b30.el7 for package: 2:docker-1.13.1-104.git4ef4b30.el7.x86_64 --> Running transaction check ---> Package docker.x86_64 2:1.13.1-104.git4ef4b30.el7 will be erased ---> Package docker-client.x86_64 2:1.13.1-104.git4ef4b30.el7 will be erased --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Removing: docker-common x86_64 2:1.13.1-104.git4ef4b30.el7 @EXTRAS-7.8 4.4 k Removing for dependencies: docker x86_64 2:1.13.1-104.git4ef4b30.el7 @EXTRAS-7.8 65 M docker-client x86_64 2:1.13.1-104.git4ef4b30.el7 @EXTRAS-7.8 13 M Transaction Summary ================================================================================ Remove 1 Package (+2 Dependent packages) Installed size: 77 M Downloading packages: Running transaction check Running transaction test Transaction test succeeded Running transaction Erasing : 2:docker-1.13.1-104.git4ef4b30.el7.x86_64 1/3 warning: /etc/sysconfig/docker-storage saved as /etc/sysconfig/docker-storage.rpmsave Erasing : 2:docker-client-1.13.1-104.git4ef4b30.el7.x86_64 2/3 Erasing : 2:docker-common-1.13.1-104.git4ef4b30.el7.x86_64 3/3 Verifying : 2:docker-client-1.13.1-104.git4ef4b30.el7.x86_64 1/3 Verifying : 2:docker-1.13.1-104.git4ef4b30.el7.x86_64 2/3 Verifying : 2:docker-common-1.13.1-104.git4ef4b30.el7.x86_64 3/3 Removed: docker-common.x86_64 2:1.13.1-104.git4ef4b30.el7 Dependency Removed: docker.x86_64 2:1.13.1-104.git4ef4b30.el7 docker-client.x86_64 2:1.13.1-104.git4ef4b30.el7 Complete! + rpm -q podman-docker package podman-docker is not installed + yum install -y podman-docker Loaded plugins: product-id, search-disabled-repos, subscription-manager This system is not registered with an entitlement server. You can use subscription-manager to register. This system is not registered with an entitlement server. You can use subscription-manager to register. Resolving Dependencies --> Running transaction check ---> Package podman-docker.noarch 0:1.4.4-4.el7 will be installed --> Processing Dependency: podman = 1.4.4-4.el7 for package: podman-docker-1.4.4-4.el7.noarch --> Running transaction check ---> Package podman.x86_64 0:1.4.4-4.el7 will be installed --> Processing Dependency: containernetworking-plugins >= 0.8.1-1 for package: podman-1.4.4-4.el7.x86_64 --> Running transaction check ---> Package containernetworking-plugins.x86_64 0:0.8.1-2.el7 will be installed --> Finished Dependency Resolution Dependencies Resolved ================================================================================ Package Arch Version Repository Size ================================================================================ Installing: podman-docker noarch 1.4.4-4.el7 EXTRAS-7.8 26 k Installing for dependencies: containernetworking-plugins x86_64 0.8.1-2.el7 EXTRAS-7.8 16 M podman x86_64 1.4.4-4.el7 EXTRAS-7.8 9.3 M Transaction Summary ================================================================================ Install 1 Package (+2 Dependent packages) Total download size: 26 M Installed size: 103 M Downloading packages: -------------------------------------------------------------------------------- Total 41 MB/s | 26 MB 00:00 Running transaction check Running transaction test Transaction test succeeded Running transaction Installing : containernetworking-plugins-0.8.1-2.el7.x86_64 1/3 Installing : podman-1.4.4-4.el7.x86_64 2/3 Installing : podman-docker-1.4.4-4.el7.noarch 3/3 Verifying : podman-1.4.4-4.el7.x86_64 1/3 Verifying : podman-docker-1.4.4-4.el7.noarch 2/3 Verifying : containernetworking-plugins-0.8.1-2.el7.x86_64 3/3 Installed: podman-docker.noarch 0:1.4.4-4.el7 Dependency Installed: containernetworking-plugins.x86_64 0:0.8.1-2.el7 podman.x86_64 0:1.4.4-4.el7 Complete! + ! test -f /run/nologin && cat /proc/sys/kernel/random/boot_id Uploading /build/cockpit-project/bots/make-checkout-workdir/lorax-composer-19.7.36-1.fc30.src.rpm scp -B -r -p -P 2201 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o ControlPath=/build/tmp/ssh-%h-%p-%r-653 -o BatchMode=yes /build/cockpit-project/bots/make-checkout-workdir/lorax-composer-19.7.36-1.fc30.src.rpm root@[127.0.0.2]:/var/tmp Uploading /build/cockpit-project/bots/make-checkout-workdir/test/vm.install scp -B -r -p -P 2201 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o ControlPath=/build/tmp/ssh-%h-%p-%r-653 -o BatchMode=yes /build/cockpit-project/bots/make-checkout-workdir/test/vm.install root@[127.0.0.2]:/var/tmp/vm.install Uploading /build/cockpit-project/bots/make-checkout-workdir/tests scp -B -r -p -P 2201 -o StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o ControlPath=/build/tmp/ssh-%h-%p-%r-653 -o BatchMode=yes /build/cockpit-project/bots/make-checkout-workdir/tests root@[127.0.0.2]:/ + chmod +x /var/tmp/vm.install + cd /var/tmp; /var/tmp/vm.install lorax-composer-19.7.36-1.fc30.src.rpm killing ssh master process 721 [ -f ~/.config/lorax-test-env ] && bots/image-customize \ --upload ~/.config/lorax-test-env:/var/tmp/lorax-test-env \ rhel-7-8 || echo echo /build/cockpit-project/bots/make-checkout-workdir/test/images/rhel-7-8 /build/cockpit-project/bots/make-checkout-workdir/test/images/rhel-7-8 1..1 # ---------------------------------------------------------------------- # TestCloud.test_openstack % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:01 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:02 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:03 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:04 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:05 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:06 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:07 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:08 --:--:-- 0 100 301 100 301 0 0 36 0 0:00:08 0:00:08 --:--:-- 69 "db_supported": true, :: [ 04:06:50 ] :: [ INFO ] :: skipping xml journal creation :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Setup :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:06:50 ] :: [ INFO ] :: OS_AUTH_URL=https://rhos-d.infra.prod.upshift.rdu2.redhat.com:13000/v3/ :: [ 04:06:50 ] :: [ INFO ] :: OS_USERNAME=psi-composer-jenkins :: [ 04:06:50 ] :: [ INFO ] :: OS_PROJECT_NAME=composer-jenkins :: [ 04:06:50 ] :: [ INFO ] :: OS_PASSWORD is configured python2-pip-8.1.2-10.el7.noarch :: [ 04:06:50 ] :: [ LOG ] :: Package python2-pip is present :: [ 04:06:50 ] :: [ LOG ] :: Package versions: :: [ 04:06:50 ] :: [ LOG ] :: python2-pip-8.1.2-10.el7.noarch python-virtualenv-15.1.0-2.el7.noarch :: [ 04:06:50 ] :: [ PASS ] :: Checking for the presence of python-virtualenv rpm :: [ 04:06:50 ] :: [ LOG ] :: Package versions: :: [ 04:06:50 ] :: [ LOG ] :: python-virtualenv-15.1.0-2.el7.noarch :: [ 04:06:50 ] :: [ BEGIN ] :: Running 'virtualenv /tmp/ansible.venv.Vgs' STDOUT: New python executable in /tmp/ansible.venv.Vgs/bin/python STDOUT: Installing setuptools, pip, wheel...done. :: [ 04:06:53 ] :: [ PASS ] :: Command 'virtualenv /tmp/ansible.venv.Vgs' (Expected 0, got 0) :: [ 04:06:53 ] :: [ BEGIN ] :: Running 'pip install --upgrade pip setuptools' STDOUT: Collecting pip STDOUT: Downloading https://files.pythonhosted.org/packages/00/b6/9cfa56b4081ad13874b0c6f96af8ce16cfbc1cb06bedf8e9164ce5551ec1/pip-19.3.1-py2.py3-none-any.whl (1.4MB) STDOUT: Collecting setuptools STDOUT: Downloading https://files.pythonhosted.org/packages/d9/de/554b6310ac87c5b921bc45634b07b11394fe63bc4cb5176f5240addf18ab/setuptools-41.6.0-py2.py3-none-any.whl (582kB) STDOUT: Installing collected packages: pip, setuptools STDOUT: Found existing installation: pip 9.0.1 STDOUT: Uninstalling pip-9.0.1: STDOUT: Successfully uninstalled pip-9.0.1 STDOUT: Found existing installation: setuptools 28.8.0 STDOUT: Uninstalling setuptools-28.8.0: STDOUT: Successfully uninstalled setuptools-28.8.0 STDOUT: Successfully installed pip-19.3.1 setuptools-41.6.0 :: [ 04:06:58 ] :: [ PASS ] :: Command 'pip install --upgrade pip setuptools' (Expected 0, got 0) :: [ 04:06:58 ] :: [ BEGIN ] :: Running 'pip install ansible openstacksdk' STDERR: DEPRECATION: Python 2.7 will reach the end of its life on January 1st, 2020. Please upgrade your Python as Python 2.7 won't be maintained after that date. A future version of pip will drop support for Python 2.7. More details about Python 2 support in pip, can be found at https://pip.pypa.io/en/latest/development/release-process/#python-2-support STDOUT: Collecting ansible STDOUT: Downloading https://files.pythonhosted.org/packages/4b/c5/fb70a2d9817eb48c358a67952ed3a1869e5cda8a5e4f1911cffc75f42375/ansible-2.9.1.tar.gz (14.1MB) STDOUT: Collecting openstacksdk STDOUT: Downloading https://files.pythonhosted.org/packages/66/4d/67444e41587b8ac7ae1f14dbf7721436b86998d8940a45b56af0e44823b3/openstacksdk-0.37.0-py2.py3-none-any.whl (1.3MB) STDOUT: Collecting jinja2 STDOUT: Downloading https://files.pythonhosted.org/packages/65/e0/eb35e762802015cab1ccee04e8a277b03f1d8e53da3ec3106882ec42558b/Jinja2-2.10.3-py2.py3-none-any.whl (125kB) STDOUT: Collecting PyYAML STDOUT: Downloading https://files.pythonhosted.org/packages/e3/e8/b3212641ee2718d556df0f23f78de8303f068fe29cdaa7a91018849582fe/PyYAML-5.1.2.tar.gz (265kB) STDOUT: Collecting cryptography STDOUT: Downloading https://files.pythonhosted.org/packages/c8/52/ad7f2cbe3b6e9340526dc401b38bb67c06160449446e15b0bf5f947fa168/cryptography-2.8-cp27-cp27mu-manylinux2010_x86_64.whl (2.3MB) STDOUT: Collecting munch>=2.1.0 STDOUT: Downloading https://files.pythonhosted.org/packages/cc/ab/85d8da5c9a45e072301beb37ad7f833cd344e04c817d97e0cc75681d248f/munch-2.5.0-py2.py3-none-any.whl STDOUT: Collecting appdirs>=1.3.0 STDOUT: Downloading https://files.pythonhosted.org/packages/56/eb/810e700ed1349edde4cbdc1b2a21e28cdf115f9faf263f6bbf8447c1abf3/appdirs-1.4.3-py2.py3-none-any.whl STDOUT: Collecting dogpile.cache>=0.6.2 STDOUT: Downloading https://files.pythonhosted.org/packages/ac/6a/9ac405686a94b7f009a20a50070a5786b0e1aedc707b88d40d0c4b51a82e/dogpile.cache-0.9.0.tar.gz (325kB) STDOUT: Collecting jsonpatch!=1.20,>=1.16 STDOUT: Downloading https://files.pythonhosted.org/packages/86/7e/035d19a73306278673039f0805b863be8798057cc1b4008b9c8c7d1d32a3/jsonpatch-1.24-py2.py3-none-any.whl STDOUT: Collecting six>=1.10.0 STDOUT: Downloading https://files.pythonhosted.org/packages/65/26/32b8464df2a97e6dd1b656ed26b2c194606c16fe163c695a992b36c11cdf/six-1.13.0-py2.py3-none-any.whl STDOUT: Collecting pbr!=2.1.0,>=2.0.0 STDOUT: Downloading https://files.pythonhosted.org/packages/46/a4/d5c83831a3452713e4b4f126149bc4fbda170f7cb16a86a00ce57ce0e9ad/pbr-5.4.3-py2.py3-none-any.whl (110kB) STDOUT: Collecting netifaces>=0.10.4 STDOUT: Downloading https://files.pythonhosted.org/packages/7e/02/ad1a92a72620cc17d448fe4dbdfbdf8fe1487ee7bfd82bb48308712c2f3c/netifaces-0.10.9-cp27-cp27mu-manylinux1_x86_64.whl STDOUT: Collecting jmespath>=0.9.0 STDOUT: Downloading https://files.pythonhosted.org/packages/83/94/7179c3832a6d45b266ddb2aac329e101367fbdb11f425f13771d27f225bb/jmespath-0.9.4-py2.py3-none-any.whl STDOUT: Collecting os-service-types>=1.7.0 STDOUT: Downloading https://files.pythonhosted.org/packages/10/2d/318b2b631f68e0fc221ba8f45d163bf810cdb795cf242fe85ad3e5d45639/os_service_types-1.7.0-py2.py3-none-any.whl STDOUT: Collecting decorator>=3.4.0 STDOUT: Downloading https://files.pythonhosted.org/packages/8f/b7/f329cfdc75f3d28d12c65980e4469e2fa373f1953f5df6e370e84ea2e875/decorator-4.4.1-py2.py3-none-any.whl STDOUT: Collecting futures>=3.0.0; python_version == "2.7" or python_version == "2.6" STDOUT: Downloading https://files.pythonhosted.org/packages/d8/a6/f46ae3f1da0cd4361c344888f59ec2f5785e69c872e175a748ef6071cdb5/futures-3.3.0-py2-none-any.whl STDOUT: Collecting requestsexceptions>=1.2.0 STDOUT: Downloading https://files.pythonhosted.org/packages/01/8c/49ca60ea8c907260da4662582c434bec98716177674e88df3fd340acf06d/requestsexceptions-1.4.0-py2.py3-none-any.whl STDOUT: Collecting ipaddress>=1.0.17; python_version < "3.3" STDOUT: Downloading https://files.pythonhosted.org/packages/c2/f8/49697181b1651d8347d24c095ce46c7346c37335ddc7d255833e7cde674d/ipaddress-1.0.23-py2.py3-none-any.whl STDOUT: Collecting iso8601>=0.1.11 STDOUT: Downloading https://files.pythonhosted.org/packages/ef/57/7162609dab394d38bbc7077b7ba0a6f10fb09d8b7701ea56fa1edc0c4345/iso8601-0.1.12-py2.py3-none-any.whl STDOUT: Collecting keystoneauth1>=3.18.0 STDOUT: Downloading https://files.pythonhosted.org/packages/97/f6/6d17bcad6eff1561e3cfde1ea4d1d6bb9aac612b3fdfe78ec5049d01694e/keystoneauth1-3.18.0-py2.py3-none-any.whl (310kB) STDOUT: Collecting MarkupSafe>=0.23 STDOUT: Downloading https://files.pythonhosted.org/packages/fb/40/f3adb7cf24a8012813c5edb20329eb22d5d8e2a0ecf73d21d6b85865da11/MarkupSafe-1.1.1-cp27-cp27mu-manylinux1_x86_64.whl STDOUT: Collecting enum34; python_version < "3" STDOUT: Downloading https://files.pythonhosted.org/packages/c5/db/e56e6b4bbac7c4a06de1c50de6fe1ef3810018ae11732a50f15f62c7d050/enum34-1.1.6-py2-none-any.whl STDOUT: Collecting cffi!=1.11.3,>=1.8 STDOUT: Downloading https://files.pythonhosted.org/packages/93/5d/c4f950891251e478929036ca07b22f0b10324460c1d0a4434c584481db51/cffi-1.13.2-cp27-cp27mu-manylinux1_x86_64.whl (384kB) STDOUT: Collecting jsonpointer>=1.9 STDOUT: Downloading https://files.pythonhosted.org/packages/18/b0/a80d29577c08eea401659254dfaed87f1af45272899e1812d7e01b679bc5/jsonpointer-2.0-py2.py3-none-any.whl STDOUT: Collecting stevedore>=1.20.0 STDOUT: Downloading https://files.pythonhosted.org/packages/b1/e1/f5ddbd83f60b03f522f173c03e406c1bff8343f0232a292ac96aa633b47a/stevedore-1.31.0-py2.py3-none-any.whl (43kB) STDOUT: Collecting requests>=2.14.2 STDOUT: Downloading https://files.pythonhosted.org/packages/51/bd/23c926cd341ea6b7dd0b2a00aba99ae0f828be89d72b2190f27c11d4b7fb/requests-2.22.0-py2.py3-none-any.whl (57kB) STDOUT: Collecting pycparser STDOUT: Downloading https://files.pythonhosted.org/packages/68/9e/49196946aee219aead1290e00d1e7fdeab8567783e83e1b9ab5585e6206a/pycparser-2.19.tar.gz (158kB) STDOUT: Collecting urllib3!=1.25.0,!=1.25.1,<1.26,>=1.21.1 STDOUT: Downloading https://files.pythonhosted.org/packages/b4/40/a9837291310ee1ccc242ceb6ebfd9eb21539649f193a7c8c86ba15b98539/urllib3-1.25.7-py2.py3-none-any.whl (125kB) STDOUT: Collecting certifi>=2017.4.17 STDOUT: Downloading https://files.pythonhosted.org/packages/18/b0/8146a4f8dd402f60744fa380bc73ca47303cccf8b9190fd16a827281eac2/certifi-2019.9.11-py2.py3-none-any.whl (154kB) STDOUT: Collecting chardet<3.1.0,>=3.0.2 STDOUT: Downloading https://files.pythonhosted.org/packages/bc/a9/01ffebfb562e4274b6487b4bb1ddec7ca55ec7510b22e4c51f14098443b8/chardet-3.0.4-py2.py3-none-any.whl (133kB) STDOUT: Collecting idna<2.9,>=2.5 STDOUT: Downloading https://files.pythonhosted.org/packages/14/2c/cd551d81dbe15200be1cf41cd03869a46fe7226e7450af7a6545bfc474c9/idna-2.8-py2.py3-none-any.whl (58kB) STDOUT: Building wheels for collected packages: ansible, PyYAML, dogpile.cache, pycparser STDOUT: Building wheel for ansible (setup.py): started STDOUT: Building wheel for ansible (setup.py): finished with status 'done' STDOUT: Created wheel for ansible: filename=ansible-2.9.1-cp27-none-any.whl size=16130459 sha256=de499abe42db236e30d0eb3b1fc2fc8151ec372ebb9ff77edc9c3f69f5f9077c STDOUT: Stored in directory: /root/.cache/pip/wheels/5b/77/78/7b71e95b6489fb4d5bda764e40798cf379fba3228f576bb1ad STDOUT: Building wheel for PyYAML (setup.py): started STDOUT: Building wheel for PyYAML (setup.py): finished with status 'done' STDOUT: Created wheel for PyYAML: filename=PyYAML-5.1.2-cp27-cp27mu-linux_x86_64.whl size=46204 sha256=cce2b51941119c0909cebee1da19dd5e494cffaa5634e6dea65a5d86ad710921 STDOUT: Stored in directory: /root/.cache/pip/wheels/d9/45/dd/65f0b38450c47cf7e5312883deb97d065e030c5cca0a365030 STDOUT: Building wheel for dogpile.cache (setup.py): started STDOUT: Building wheel for dogpile.cache (setup.py): finished with status 'done' STDOUT: Created wheel for dogpile.cache: filename=dogpile.cache-0.9.0-py2.py3-none-any.whl size=46469 sha256=d412168ca47cb68bea0399973fe22f7fd1a78e9c57632865dabef22547735529 STDOUT: Stored in directory: /root/.cache/pip/wheels/b4/ad/c4/1faa9b2da61b12b7c3821cda298be230c457ee740bd8658cb2 STDOUT: Building wheel for pycparser (setup.py): started STDOUT: Building wheel for pycparser (setup.py): finished with status 'done' STDOUT: Created wheel for pycparser: filename=pycparser-2.19-py2.py3-none-any.whl size=112038 sha256=dbfa3a245f9a6fe81aebc7c00665cdd90a12997ee60b68389e3297175c45707d STDOUT: Stored in directory: /root/.cache/pip/wheels/f2/9a/90/de94f8556265ddc9d9c8b271b0f63e57b26fb1d67a45564511 STDOUT: Successfully built ansible PyYAML dogpile.cache pycparser STDOUT: Installing collected packages: MarkupSafe, jinja2, PyYAML, enum34, pycparser, cffi, six, ipaddress, cryptography, ansible, munch, appdirs, decorator, dogpile.cache, jsonpointer, jsonpatch, pbr, netifaces, jmespath, os-service-types, futures, requestsexceptions, iso8601, stevedore, urllib3, certifi, chardet, idna, requests, keystoneauth1, openstacksdk STDOUT: Successfully installed MarkupSafe-1.1.1 PyYAML-5.1.2 ansible-2.9.1 appdirs-1.4.3 certifi-2019.9.11 cffi-1.13.2 chardet-3.0.4 cryptography-2.8 decorator-4.4.1 dogpile.cache-0.9.0 enum34-1.1.6 futures-3.3.0 idna-2.8 ipaddress-1.0.23 iso8601-0.1.12 jinja2-2.10.3 jmespath-0.9.4 jsonpatch-1.24 jsonpointer-2.0 keystoneauth1-3.18.0 munch-2.5.0 netifaces-0.10.9 openstacksdk-0.37.0 os-service-types-1.7.0 pbr-5.4.3 pycparser-2.19 requests-2.22.0 requestsexceptions-1.4.0 six-1.13.0 stevedore-1.31.0 urllib3-1.25.7 :: [ 04:07:55 ] :: [ PASS ] :: Command 'pip install ansible openstacksdk' (Expected 0, got 0) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 65s :: Assertions: 4 good, 0 bad :: RESULT: PASS (Setup) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: compose start :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:07:55 ] :: [ PASS ] :: SELinux operates in enforcing mode (Assert: 'Enforcing' should equal 'Enforcing') :: [ 04:07:55 ] :: [ BEGIN ] :: Running '/usr/bin/composer-cli blueprints push /http-with-rng.toml' :: [ 04:07:55 ] :: [ PASS ] :: Command '/usr/bin/composer-cli blueprints push /http-with-rng.toml' (Expected 0, got 0) :: [ 04:07:58 ] :: [ PASS ] :: exit code should be zero (Assert: '0' should equal '0') :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 3s :: Assertions: 3 good, 0 bad :: RESULT: PASS (compose start) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: compose finished :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:08:18 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:08:39 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:08:59 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:09:19 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:09:39 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:09:59 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:10:20 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:10:40 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:11:00 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:11:20 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:11:40 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:12:00 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:12:21 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:12:41 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:13:01 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:13:21 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:13:41 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:14:01 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:14:22 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:14:42 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:15:02 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:15:22 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:15:44 ] :: [ INFO ] :: Waiting for compose to finish ... b25389c0-bcc7-4957-9e3f-c9371722fe8d FINISHED http-with-rng 0.0.1 openstack 1617756160 :: [ 04:15:44 ] :: [ BEGIN ] :: Running 'mkdir -p /var/log//tests/cli/test_build_and_deploy_openstack.sh' :: [ 04:15:44 ] :: [ PASS ] :: Command 'mkdir -p /var/log//tests/cli/test_build_and_deploy_openstack.sh' (Expected 0, got 0) :: [ 04:15:44 ] :: [ BEGIN ] :: Running '/usr/bin/composer-cli compose logs b25389c0-bcc7-4957-9e3f-c9371722fe8d' STDOUT: :: [ 04:15:44 ] :: [ PASS ] :: Command '/usr/bin/composer-cli compose logs b25389c0-bcc7-4957-9e3f-c9371722fe8d' (Expected 0, got 0) :: [ 04:15:44 ] :: [ BEGIN ] :: Running 'mv b25389c0-bcc7-4957-9e3f-c9371722fe8d-logs.tar /var/log//tests/cli/test_build_and_deploy_openstack.sh' :: [ 04:15:44 ] :: [ PASS ] :: Command 'mv b25389c0-bcc7-4957-9e3f-c9371722fe8d-logs.tar /var/log//tests/cli/test_build_and_deploy_openstack.sh' (Expected 0, got 0) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 467s :: Assertions: 3 good, 0 bad :: RESULT: PASS (compose finished) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Upload QCOW2 image to OpenStack :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:15:45 ] :: [ BEGIN ] :: Running '/usr/bin/composer-cli compose image b25389c0-bcc7-4957-9e3f-c9371722fe8d' STDOUT: :: [ 04:15:59 ] :: [ PASS ] :: Command '/usr/bin/composer-cli compose image b25389c0-bcc7-4957-9e3f-c9371722fe8d' (Expected 0, got 0) [WARNING]: No inventory was parsed, only implicit localhost is available :: [ 04:18:09 ] :: [ PASS ] :: Image upload successfull (Assert: expected 0, got 0) :: [ 04:18:09 ] :: [ INFO ] :: localhost | CHANGED => { "changed": true, "id": "2be0c3ea-d7b7-4b47-886d-d5492f84c4c2", "image": { "checksum": "5cefce0d73289233054bfacc62c574d5", "container_format": "bare", "created": "2019-11-21T09:16:54Z", "created_at": "2019-11-21T09:16:54Z", "direct_url": "rbd://03e3321d-071f-4b28-a3f9-0256f384bdca/images_d/2be0c3ea-d7b7-4b47-886d-d5492f84c4c2/snap", "disk_format": "qcow2", "file": "/v2/images/2be0c3ea-d7b7-4b47-886d-d5492f84c4c2/file", "id": "2be0c3ea-d7b7-4b47-886d-d5492f84c4c2", "is_protected": false, "is_public": false, "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "locations": [ { "metadata": {}, "url": "rbd://03e3321d-071f-4b28-a3f9-0256f384bdca/images_d/2be0c3ea-d7b7-4b47-886d-d5492f84c4c2/snap" } ], "metadata": { "owner_specified.openstack.md5": "5cefce0d73289233054bfacc62c574d5", "owner_specified.openstack.object": "images/Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import", "owner_specified.openstack.sha256": "bc8a1d28f64ab7d2bf2486c1607ff77bfe054d6947cf8562b09fb73691ef0b71", "schema": "/v2/schemas/image" }, "minDisk": 0, "minRam": 0, "min_disk": 0, "min_ram": 0, "name": "Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import", "owner": "6a80eb816d3742d2a222f1e9680d5194", "owner_specified.openstack.md5": "5cefce0d73289233054bfacc62c574d5", "owner_specified.openstack.object": "images/Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import", "owner_specified.openstack.sha256": "bc8a1d28f64ab7d2bf2486c1607ff77bfe054d6947cf8562b09fb73691ef0b71", "properties": { "owner_specified.openstack.md5": "5cefce0d73289233054bfacc62c574d5", "owner_specified.openstack.object": "images/Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import", "owner_specified.openstack.sha256": "bc8a1d28f64ab7d2bf2486c1607ff77bfe054d6947cf8562b09fb73691ef0b71", "schema": "/v2/schemas/image" }, "protected": false, "schema": "/v2/schemas/image", "size": 1617756160, "status": "active", "tags": [], "updated": "2019-11-21T09:17:24Z", "updated_at": "2019-11-21T09:17:24Z", "virtual_size": 0, "visibility": "private" } } :: [ 04:18:09 ] :: [ INFO ] :: OS_IMAGE_UUID=2be0c3ea-d7b7-4b47-886d-d5492f84c4c2 :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 144s :: Assertions: 2 good, 0 bad :: RESULT: PASS (Upload QCOW2 image to OpenStack) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Start VM instance :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:18:09 ] :: [ BEGIN ] :: Running 'ssh-keygen -t rsa -N '' -f /tmp/composer-ssh-keys.M6ro4n/id_rsa' STDOUT: Generating public/private rsa key pair. STDOUT: Your identification has been saved in /tmp/composer-ssh-keys.M6ro4n/id_rsa. STDOUT: Your public key has been saved in /tmp/composer-ssh-keys.M6ro4n/id_rsa.pub. STDOUT: The key fingerprint is: STDOUT: SHA256:936KrQ8xe4aNZ/5qL1i4Nu9DozDANIrxoSsSXAWpbys root@m1.cockpit.lan STDOUT: The key's randomart image is: STDOUT: +---[RSA 2048]----+ STDOUT: | .+. | STDOUT: | .o. o | STDOUT: |. o= = . | STDOUT: |.oo o o | STDOUT: | ... .S +. | STDOUT: |o .o o..O+ | STDOUT: |... . o=*B. | STDOUT: | E . *@+ . | STDOUT: | . .oBXOo | STDOUT: +----[SHA256]-----+ :: [ 04:18:09 ] :: [ PASS ] :: Command 'ssh-keygen -t rsa -N '' -f /tmp/composer-ssh-keys.M6ro4n/id_rsa' (Expected 0, got 0) :: [ 04:18:09 ] :: [ BEGIN ] :: Running 'ansible localhost -m os_keypair -a 'name=Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key public_key_file=/tmp/composer-ssh-keys.M6ro4n/id_rsa.pub'' STDERR: [WARNING]: No inventory was parsed, only implicit localhost is available STDOUT: localhost | CHANGED => { STDOUT: "changed": true, STDOUT: "id": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key", STDOUT: "key": { STDOUT: "created_at": null, STDOUT: "fingerprint": "f3:3a:c9:84:52:ad:21:13:04:59:68:f1:bd:ca:53:a2", STDOUT: "id": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key", STDOUT: "is_deleted": null, STDOUT: "location": { STDOUT: "cloud": "envvars", STDOUT: "project": { STDOUT: "domain_id": null, STDOUT: "domain_name": "redhat.com", STDOUT: "id": "6a80eb816d3742d2a222f1e9680d5194", STDOUT: "name": "composer-jenkins" STDOUT: }, STDOUT: "region_name": "", STDOUT: "zone": null STDOUT: }, STDOUT: "name": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key", STDOUT: "private_key": null, STDOUT: "public_key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC1oyuQOTEhJhbjSxioh8i2nt48ekl/tKfAJAFrX+2Lylj/DB7DVtARr2UY3S6u7qgyz8STIda3QcIkB6nbWkTqNSliE/4mjZdZjT/6u9LVo/IW390SCmDAit5ZWgUQicPvmE3JhAT5XBp7++RdAwvOzqVSmCiJnrAb8LhkHSG8qtz3OA2f61ozf3JlDQfqm+5bHcDpyKxg1r1Z3vUQ6V8qN7OffvxJ6hzCJdsHaRlNxZtfX6eUsbLFdzIheu/kDCAjSWoiKGYRJ7Tu+Yqy41uggxhAWQpZhZHul17Ub7KioZzcBr3uP2Aa1ft3TBJQ038a7YI3Vtlz6tWVy3BMbnOP root@m1.cockpit.lan", STDOUT: "type": "ssh", STDOUT: "user_id": "19d5cc50fe7fc5f8f502c7cbebc7c7382b33ca700fdacd7f6f9d918d2537ae98" STDOUT: } STDOUT: } :: [ 04:18:12 ] :: [ PASS ] :: Command 'ansible localhost -m os_keypair -a 'name=Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key public_key_file=/tmp/composer-ssh-keys.M6ro4n/id_rsa.pub'' (Expected 0, got 0) [WARNING]: No inventory was parsed, only implicit localhost is available :: [ 04:19:47 ] :: [ PASS ] :: VM started successfully (Assert: expected 0, got 0) :: [ 04:19:47 ] :: [ INFO ] :: localhost | CHANGED => { "changed": true, "id": "2aa4a9ee-1a0c-4516-8d80-d081c221dde7", "openstack": { "OS-DCF:diskConfig": "MANUAL", "OS-EXT-AZ:availability_zone": "nova", "OS-EXT-SRV-ATTR:host": null, "OS-EXT-SRV-ATTR:hostname": null, "OS-EXT-SRV-ATTR:hypervisor_hostname": null, "OS-EXT-SRV-ATTR:instance_name": null, "OS-EXT-SRV-ATTR:kernel_id": null, "OS-EXT-SRV-ATTR:launch_index": null, "OS-EXT-SRV-ATTR:ramdisk_id": null, "OS-EXT-SRV-ATTR:reservation_id": null, "OS-EXT-SRV-ATTR:root_device_name": null, "OS-EXT-SRV-ATTR:user_data": null, "OS-EXT-STS:power_state": 1, "OS-EXT-STS:task_state": null, "OS-EXT-STS:vm_state": "active", "OS-SCH-HNT:scheduler_hints": null, "OS-SRV-USG:launched_at": "2019-11-21T09:19:25.000000", "OS-SRV-USG:terminated_at": null, "accessIPv4": "10.0.138.4", "accessIPv6": "2620:52:0:88:f816:3eff:fe34:4b9", "addresses": { "provider_net_cci_2": [ { "OS-EXT-IPS-MAC:mac_addr": "fa:16:3e:34:04:b9", "OS-EXT-IPS:type": "fixed", "addr": "10.0.138.4", "version": 4 }, { "OS-EXT-IPS-MAC:mac_addr": "fa:16:3e:34:04:b9", "OS-EXT-IPS:type": "fixed", "addr": "2620:52:0:88:f816:3eff:fe34:4b9", "version": 6 } ] }, "adminPass": "kQAG6KY6JF3o", "az": "nova", "block_device_mapping": null, "cloud": "envvars", "config_drive": "", "created": "2019-11-21T09:19:01Z", "created_at": "2019-11-21T09:19:01Z", "description": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d", "disk_config": "MANUAL", "flavor": { "disk": 30, "ephemeral": 10, "extra_specs": { "aggregate_instance_extra_specs:server_type:aggregate": "ci" }, "name": "ci.m1.medium.ephemeral", "original_name": "ci.m1.medium.ephemeral", "ram": 4096, "swap": 0, "vcpus": 2 }, "has_config_drive": false, "host": null, "hostId": "5894b70ad6080c4a88fe1d13b26a2ee97869d736f7679d9b1a4eaedf", "host_id": "5894b70ad6080c4a88fe1d13b26a2ee97869d736f7679d9b1a4eaedf", "host_status": null, "hostname": null, "hypervisor_hostname": null, "id": "2aa4a9ee-1a0c-4516-8d80-d081c221dde7", "image": { "id": "2be0c3ea-d7b7-4b47-886d-d5492f84c4c2", "name": "Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import" }, "instance_name": null, "interface_ip": "2620:52:0:88:f816:3eff:fe34:4b9", "kernel_id": null, "key_name": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key", "launch_index": null, "launched_at": "2019-11-21T09:19:25.000000", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": "nova" }, "locked": false, "metadata": {}, "name": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d", "networks": {}, "os-extended-volumes:volumes_attached": [], "personality": null, "power_state": 1, "private_v4": "", "progress": 0, "project_id": "6a80eb816d3742d2a222f1e9680d5194", "properties": { "OS-DCF:diskConfig": "MANUAL", "OS-EXT-AZ:availability_zone": "nova", "OS-EXT-SRV-ATTR:host": null, "OS-EXT-SRV-ATTR:hostname": null, "OS-EXT-SRV-ATTR:hypervisor_hostname": null, "OS-EXT-SRV-ATTR:instance_name": null, "OS-EXT-SRV-ATTR:kernel_id": null, "OS-EXT-SRV-ATTR:launch_index": null, "OS-EXT-SRV-ATTR:ramdisk_id": null, "OS-EXT-SRV-ATTR:reservation_id": null, "OS-EXT-SRV-ATTR:root_device_name": null, "OS-EXT-SRV-ATTR:user_data": null, "OS-EXT-STS:power_state": 1, "OS-EXT-STS:task_state": null, "OS-EXT-STS:vm_state": "active", "OS-SCH-HNT:scheduler_hints": null, "OS-SRV-USG:launched_at": "2019-11-21T09:19:25.000000", "OS-SRV-USG:terminated_at": null, "host_status": null, "locked": false, "os-extended-volumes:volumes_attached": [], "trusted_image_certificates": null }, "public_v4": "10.0.138.4", "public_v6": "2620:52:0:88:f816:3eff:fe34:4b9", "ramdisk_id": null, "region": "", "reservation_id": null, "root_device_name": null, "scheduler_hints": null, "security_groups": [ { "description": "Default security group", "id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "name": "default", "project_id": "6a80eb816d3742d2a222f1e9680d5194", "properties": {}, "security_group_rules": [ { "direction": "ingress", "ethertype": "IPv4", "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" }, "id": "0a098982-4c23-48d8-b2bd-ba62ee23e631", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": null, "port_range_min": null, "project_id": "", "properties": { "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } }, "protocol": null, "remote_group_id": null, "remote_ip_prefix": null, "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": {}, "id": "532e832a-1fb5-4d18-a116-153e4bdc9cdf", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": 22, "port_range_min": 22, "project_id": "", "properties": { "group": {} }, "protocol": "tcp", "remote_group_id": null, "remote_ip_prefix": "0.0.0.0/0", "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" }, "id": "bb908ca2-1d69-443b-98e7-f30c74248b24", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": null, "port_range_min": null, "project_id": "", "properties": { "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } }, "protocol": null, "remote_group_id": null, "remote_ip_prefix": null, "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": {}, "id": "d49a4869-b96d-4aa4-97b7-a0f1bce15531", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": 22, "port_range_min": 22, "project_id": "", "properties": { "group": {} }, "protocol": "tcp", "remote_group_id": null, "remote_ip_prefix": "::/0", "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" } ], "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } ], "server_groups": null, "status": "ACTIVE", "tags": [], "task_state": null, "tenant_id": "6a80eb816d3742d2a222f1e9680d5194", "terminated_at": null, "trusted_image_certificates": null, "updated": "2019-11-21T09:19:25Z", "user_data": null, "user_id": "19d5cc50fe7fc5f8f502c7cbebc7c7382b33ca700fdacd7f6f9d918d2537ae98", "vm_state": "active", "volumes": [] }, "server": { "OS-DCF:diskConfig": "MANUAL", "OS-EXT-AZ:availability_zone": "nova", "OS-EXT-SRV-ATTR:host": null, "OS-EXT-SRV-ATTR:hostname": null, "OS-EXT-SRV-ATTR:hypervisor_hostname": null, "OS-EXT-SRV-ATTR:instance_name": null, "OS-EXT-SRV-ATTR:kernel_id": null, "OS-EXT-SRV-ATTR:launch_index": null, "OS-EXT-SRV-ATTR:ramdisk_id": null, "OS-EXT-SRV-ATTR:reservation_id": null, "OS-EXT-SRV-ATTR:root_device_name": null, "OS-EXT-SRV-ATTR:user_data": null, "OS-EXT-STS:power_state": 1, "OS-EXT-STS:task_state": null, "OS-EXT-STS:vm_state": "active", "OS-SCH-HNT:scheduler_hints": null, "OS-SRV-USG:launched_at": "2019-11-21T09:19:25.000000", "OS-SRV-USG:terminated_at": null, "accessIPv4": "10.0.138.4", "accessIPv6": "2620:52:0:88:f816:3eff:fe34:4b9", "addresses": { "provider_net_cci_2": [ { "OS-EXT-IPS-MAC:mac_addr": "fa:16:3e:34:04:b9", "OS-EXT-IPS:type": "fixed", "addr": "10.0.138.4", "version": 4 }, { "OS-EXT-IPS-MAC:mac_addr": "fa:16:3e:34:04:b9", "OS-EXT-IPS:type": "fixed", "addr": "2620:52:0:88:f816:3eff:fe34:4b9", "version": 6 } ] }, "adminPass": "kQAG6KY6JF3o", "az": "nova", "block_device_mapping": null, "cloud": "envvars", "config_drive": "", "created": "2019-11-21T09:19:01Z", "created_at": "2019-11-21T09:19:01Z", "description": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d", "disk_config": "MANUAL", "flavor": { "disk": 30, "ephemeral": 10, "extra_specs": { "aggregate_instance_extra_specs:server_type:aggregate": "ci" }, "name": "ci.m1.medium.ephemeral", "original_name": "ci.m1.medium.ephemeral", "ram": 4096, "swap": 0, "vcpus": 2 }, "has_config_drive": false, "host": null, "hostId": "5894b70ad6080c4a88fe1d13b26a2ee97869d736f7679d9b1a4eaedf", "host_id": "5894b70ad6080c4a88fe1d13b26a2ee97869d736f7679d9b1a4eaedf", "host_status": null, "hostname": null, "hypervisor_hostname": null, "id": "2aa4a9ee-1a0c-4516-8d80-d081c221dde7", "image": { "id": "2be0c3ea-d7b7-4b47-886d-d5492f84c4c2", "name": "Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import" }, "instance_name": null, "interface_ip": "2620:52:0:88:f816:3eff:fe34:4b9", "kernel_id": null, "key_name": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key", "launch_index": null, "launched_at": "2019-11-21T09:19:25.000000", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": "nova" }, "locked": false, "metadata": {}, "name": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d", "networks": {}, "os-extended-volumes:volumes_attached": [], "personality": null, "power_state": 1, "private_v4": "", "progress": 0, "project_id": "6a80eb816d3742d2a222f1e9680d5194", "properties": { "OS-DCF:diskConfig": "MANUAL", "OS-EXT-AZ:availability_zone": "nova", "OS-EXT-SRV-ATTR:host": null, "OS-EXT-SRV-ATTR:hostname": null, "OS-EXT-SRV-ATTR:hypervisor_hostname": null, "OS-EXT-SRV-ATTR:instance_name": null, "OS-EXT-SRV-ATTR:kernel_id": null, "OS-EXT-SRV-ATTR:launch_index": null, "OS-EXT-SRV-ATTR:ramdisk_id": null, "OS-EXT-SRV-ATTR:reservation_id": null, "OS-EXT-SRV-ATTR:root_device_name": null, "OS-EXT-SRV-ATTR:user_data": null, "OS-EXT-STS:power_state": 1, "OS-EXT-STS:task_state": null, "OS-EXT-STS:vm_state": "active", "OS-SCH-HNT:scheduler_hints": null, "OS-SRV-USG:launched_at": "2019-11-21T09:19:25.000000", "OS-SRV-USG:terminated_at": null, "host_status": null, "locked": false, "os-extended-volumes:volumes_attached": [], "trusted_image_certificates": null }, "public_v4": "10.0.138.4", "public_v6": "2620:52:0:88:f816:3eff:fe34:4b9", "ramdisk_id": null, "region": "", "reservation_id": null, "root_device_name": null, "scheduler_hints": null, "security_groups": [ { "description": "Default security group", "id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "name": "default", "project_id": "6a80eb816d3742d2a222f1e9680d5194", "properties": {}, "security_group_rules": [ { "direction": "ingress", "ethertype": "IPv4", "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" }, "id": "0a098982-4c23-48d8-b2bd-ba62ee23e631", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": null, "port_range_min": null, "project_id": "", "properties": { "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } }, "protocol": null, "remote_group_id": null, "remote_ip_prefix": null, "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": {}, "id": "532e832a-1fb5-4d18-a116-153e4bdc9cdf", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": 22, "port_range_min": 22, "project_id": "", "properties": { "group": {} }, "protocol": "tcp", "remote_group_id": null, "remote_ip_prefix": "0.0.0.0/0", "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" }, "id": "bb908ca2-1d69-443b-98e7-f30c74248b24", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": null, "port_range_min": null, "project_id": "", "properties": { "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } }, "protocol": null, "remote_group_id": null, "remote_ip_prefix": null, "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": {}, "id": "d49a4869-b96d-4aa4-97b7-a0f1bce15531", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": 22, "port_range_min": 22, "project_id": "", "properties": { "group": {} }, "protocol": "tcp", "remote_group_id": null, "remote_ip_prefix": "::/0", "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" } ], "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } ], "server_groups": null, "status": "ACTIVE", "tags": [], "task_state": null, "tenant_id": "6a80eb816d3742d2a222f1e9680d5194", "terminated_at": null, "trusted_image_certificates": null, "updated": "2019-11-21T09:19:25Z", "user_data": null, "user_id": "19d5cc50fe7fc5f8f502c7cbebc7c7382b33ca700fdacd7f6f9d918d2537ae98", "vm_state": "active", "volumes": [] } } :: [ 04:19:47 ] :: [ INFO ] :: Running instance IP_ADDRESS=10.0.138.4 :: [ 04:19:47 ] :: [ INFO ] :: Waiting 60sec for instance to initialize ... :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 158s :: Assertions: 3 good, 0 bad :: RESULT: PASS (Start VM instance) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Verify VM instance :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:20:47 ] :: [ INFO ] :: verify_image: SSH_OPTS:'-o StrictHostKeyChecking=no -o BatchMode=yes -i /tmp/composer-ssh-keys.M6ro4n/id_rsa' SSH_USER:'cloud-user' SSH_MACHINE: '10.0.138.4' :: [ 04:20:48 ] :: [ BEGIN ] :: Can't ssh to '10.0.138.4' as root using password-based auth :: actually running 'ssh -o StrictHostKeyChecking=no -o BatchMode=yes -i /tmp/composer-ssh-keys.M6ro4n/id_rsa -o PubkeyAuthentication=no root@10.0.138.4 2>&1 | grep -i 'permission denied ('' STDOUT: Permission denied (publickey,gssapi-keyex,gssapi-with-mic). :: [ 04:21:00 ] :: [ PASS ] :: Can't ssh to '10.0.138.4' as root using password-based auth (Expected 0, got 0) :: [ 04:21:00 ] :: [ BEGIN ] :: root account is disabled in /etc/shadow :: actually running 'ssh -o StrictHostKeyChecking=no -o BatchMode=yes -i /tmp/composer-ssh-keys.M6ro4n/id_rsa cloud-user@10.0.138.4 "sudo passwd --status root | grep -E '^root\s+LK?'"' STDOUT: root LK 1969-12-31 0 99999 7 -1 (Password locked.) :: [ 04:21:01 ] :: [ PASS ] :: root account is disabled in /etc/shadow (Expected 0, got 0) :: [ 04:21:01 ] :: [ BEGIN ] :: audit.log contains entry about unsuccessful root login :: actually running 'ssh -o StrictHostKeyChecking=no -o BatchMode=yes -i /tmp/composer-ssh-keys.M6ro4n/id_rsa cloud-user@10.0.138.4 "sudo grep 'USER_LOGIN.*acct=\"root\".*terminal=ssh.*res=failed' /var/log/audit/audit.log"' STDOUT: type=USER_LOGIN msg=audit(1574328061.079:85): pid=1275 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:sshd_t:s0-s0:c0.c1023 msg='op=login acct="root" exe="/usr/sbin/sshd" hostname=? addr=10.19.115.74 terminal=ssh res=failed' :: [ 04:21:02 ] :: [ PASS ] :: audit.log contains entry about unsuccessful root login (Expected 0, got 0) :: [ 04:21:02 ] :: [ BEGIN ] :: Login with empty passwords is disabled in sshd config file :: actually running 'ssh -o StrictHostKeyChecking=no -o BatchMode=yes -i /tmp/composer-ssh-keys.M6ro4n/id_rsa cloud-user@10.0.138.4 'sudo grep -E "^[[:blank:]]*PermitEmptyPasswords[[:blank:]]*yes" /etc/ssh/sshd_config'' :: [ 04:21:03 ] :: [ PASS ] :: Login with empty passwords is disabled in sshd config file (Expected 1, got 1) :: [ 04:21:03 ] :: [ BEGIN ] :: Running 'ssh -o StrictHostKeyChecking=no -o BatchMode=yes -i /tmp/composer-ssh-keys.M6ro4n/id_rsa cloud-user@10.0.138.4 'cat /etc/redhat-release'' STDOUT: Red Hat Enterprise Linux Server release 7.8 Beta (Maipo) :: [ 04:21:04 ] :: [ PASS ] :: Command 'ssh -o StrictHostKeyChecking=no -o BatchMode=yes -i /tmp/composer-ssh-keys.M6ro4n/id_rsa cloud-user@10.0.138.4 'cat /etc/redhat-release'' (Expected 0, got 0) :: [ 04:21:04 ] :: [ BEGIN ] :: System booted from the image contains specified parameter on kernel command line :: actually running 'ssh -o StrictHostKeyChecking=no -o BatchMode=yes -i /tmp/composer-ssh-keys.M6ro4n/id_rsa cloud-user@10.0.138.4 'grep custom_cmdline_arg /proc/cmdline'' STDOUT: BOOT_IMAGE=/boot/vmlinuz-3.10.0-1111.el7.x86_64 root=UUID=016162e9-b9ff-4623-804a-c88cca339362 ro no_timer_check console=ttyS0,115200n8 console=tty1 custom_cmdline_arg biosdevname=0 net.ifnames=0 console=ttyS0,115200 :: [ 04:21:05 ] :: [ PASS ] :: System booted from the image contains specified parameter on kernel command line (Expected 0, got 0) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 18s :: Assertions: 6 good, 0 bad :: RESULT: PASS (Verify VM instance) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Cleanup :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:21:05 ] :: [ BEGIN ] :: Running 'ansible localhost -m os_keypair -a 'name=Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key state=absent'' STDERR: [WARNING]: No inventory was parsed, only implicit localhost is available STDOUT: localhost | CHANGED => { STDOUT: "changed": true STDOUT: } :: [ 04:21:08 ] :: [ PASS ] :: Command 'ansible localhost -m os_keypair -a 'name=Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key state=absent'' (Expected 0, got 0) :: [ 04:21:08 ] :: [ BEGIN ] :: Running 'ansible localhost -m os_server -a 'name=Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d state=absent'' STDERR: [WARNING]: No inventory was parsed, only implicit localhost is available STDOUT: localhost | CHANGED => { STDOUT: "changed": true, STDOUT: "result": "deleted" STDOUT: } :: [ 04:21:18 ] :: [ PASS ] :: Command 'ansible localhost -m os_server -a 'name=Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d state=absent'' (Expected 0, got 0) :: [ 04:21:18 ] :: [ BEGIN ] :: Running 'ansible localhost -m os_image -a 'name=Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import state=absent'' STDERR: [WARNING]: No inventory was parsed, only implicit localhost is available STDOUT: localhost | CHANGED => { STDOUT: "changed": true STDOUT: } :: [ 04:22:28 ] :: [ PASS ] :: Command 'ansible localhost -m os_image -a 'name=Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import state=absent'' (Expected 0, got 0) :: [ 04:22:28 ] :: [ BEGIN ] :: Running '/usr/bin/composer-cli compose delete b25389c0-bcc7-4957-9e3f-c9371722fe8d' :: [ 04:22:29 ] :: [ PASS ] :: Command '/usr/bin/composer-cli compose delete b25389c0-bcc7-4957-9e3f-c9371722fe8d' (Expected 0, got 0) :: [ 04:22:29 ] :: [ BEGIN ] :: Running 'rm -rf b25389c0-bcc7-4957-9e3f-c9371722fe8d-disk.qcow2 /tmp/composer-ssh-keys.M6ro4n /tmp/ansible.venv.Vgs' :: [ 04:22:29 ] :: [ PASS ] :: Command 'rm -rf b25389c0-bcc7-4957-9e3f-c9371722fe8d-disk.qcow2 /tmp/composer-ssh-keys.M6ro4n /tmp/ansible.venv.Vgs' (Expected 0, got 0) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 84s :: Assertions: 5 good, 0 bad :: RESULT: PASS (Cleanup) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: /tests/cli/test_build_and_deploy_openstack.sh :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:22:29 ] :: [ LOG ] :: JOURNAL TXT: /tmp/composer-test.Lk68qm/journal.txt :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 939s :: Phases: 7 good, 0 bad :: OVERALL RESULT: PASS (/tests/cli/test_build_and_deploy_openstack.sh) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: TEST PROTOCOL :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: Package : cli beakerlib RPM : beakerlib-1.18-7.el7bkr.noarch Test name : /tests/cli/test_build_and_deploy_openstack.sh Test started : 2019-11-21 04:06:50 EST Test finished : 2019-11-21 04:22:29 EST Test duration : 939 seconds Distro : Red Hat Enterprise Linux Server release 7.8 Beta (Maipo) Hostname : m1.cockpit.lan Architecture : x86_64 CPUs : 2 x Intel(R) Xeon(R) CPU E5-2630 v3 @ 2.40GHz RAM size : 1837 MB HDD size : 18.77 GB :: [ 04:06:50 ] :: [ INFO ] :: skipping xml journal creation :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Setup :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:06:50 ] :: [ INFO ] :: OS_AUTH_URL=https://rhos-d.infra.prod.upshift.rdu2.redhat.com:13000/v3/ :: [ 04:06:50 ] :: [ INFO ] :: OS_USERNAME=psi-composer-jenkins :: [ 04:06:50 ] :: [ INFO ] :: OS_PROJECT_NAME=composer-jenkins :: [ 04:06:50 ] :: [ INFO ] :: OS_PASSWORD is configured :: [ 04:06:50 ] :: [ LOG ] :: Package python2-pip is present :: [ 04:06:50 ] :: [ LOG ] :: Package versions: :: [ 04:06:50 ] :: [ LOG ] :: python2-pip-8.1.2-10.el7.noarch :: [ 04:06:50 ] :: [ PASS ] :: Checking for the presence of python-virtualenv rpm :: [ 04:06:50 ] :: [ LOG ] :: Package versions: :: [ 04:06:50 ] :: [ LOG ] :: python-virtualenv-15.1.0-2.el7.noarch :: [ 04:06:53 ] :: [ PASS ] :: Command 'virtualenv /tmp/ansible.venv.Vgs' (Expected 0, got 0) :: [ 04:06:58 ] :: [ PASS ] :: Command 'pip install --upgrade pip setuptools' (Expected 0, got 0) :: [ 04:07:55 ] :: [ PASS ] :: Command 'pip install ansible openstacksdk' (Expected 0, got 0) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 65s :: Assertions: 4 good, 0 bad :: RESULT: PASS (Setup) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: compose start :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:07:55 ] :: [ PASS ] :: SELinux operates in enforcing mode (Assert: 'Enforcing' should equal 'Enforcing') :: [ 04:07:55 ] :: [ PASS ] :: Command '/usr/bin/composer-cli blueprints push /http-with-rng.toml' (Expected 0, got 0) :: [ 04:07:58 ] :: [ PASS ] :: exit code should be zero (Assert: '0' should equal '0') :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 3s :: Assertions: 3 good, 0 bad :: RESULT: PASS (compose start) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: compose finished :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:08:18 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:08:39 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:08:59 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:09:19 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:09:39 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:09:59 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:10:20 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:10:40 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:11:00 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:11:20 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:11:40 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:12:00 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:12:21 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:12:41 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:13:01 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:13:21 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:13:41 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:14:01 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:14:22 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:14:42 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:15:02 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:15:22 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:15:44 ] :: [ INFO ] :: Waiting for compose to finish ... :: [ 04:15:44 ] :: [ PASS ] :: Command 'mkdir -p /var/log//tests/cli/test_build_and_deploy_openstack.sh' (Expected 0, got 0) :: [ 04:15:44 ] :: [ PASS ] :: Command '/usr/bin/composer-cli compose logs b25389c0-bcc7-4957-9e3f-c9371722fe8d' (Expected 0, got 0) :: [ 04:15:44 ] :: [ PASS ] :: Command 'mv b25389c0-bcc7-4957-9e3f-c9371722fe8d-logs.tar /var/log//tests/cli/test_build_and_deploy_openstack.sh' (Expected 0, got 0) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 467s :: Assertions: 3 good, 0 bad :: RESULT: PASS (compose finished) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Upload QCOW2 image to OpenStack :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:15:59 ] :: [ PASS ] :: Command '/usr/bin/composer-cli compose image b25389c0-bcc7-4957-9e3f-c9371722fe8d' (Expected 0, got 0) :: [ 04:18:09 ] :: [ PASS ] :: Image upload successfull (Assert: expected 0, got 0) :: [ 04:18:09 ] :: [ INFO ] :: localhost | CHANGED => { "changed": true, "id": "2be0c3ea-d7b7-4b47-886d-d5492f84c4c2", "image": { "checksum": "5cefce0d73289233054bfacc62c574d5", "container_format": "bare", "created": "2019-11-21T09:16:54Z", "created_at": "2019-11-21T09:16:54Z", "direct_url": "rbd://03e3321d-071f-4b28-a3f9-0256f384bdca/images_d/2be0c3ea-d7b7-4b47-886d-d5492f84c4c2/snap", "disk_format": "qcow2", "file": "/v2/images/2be0c3ea-d7b7-4b47-886d-d5492f84c4c2/file", "id": "2be0c3ea-d7b7-4b47-886d-d5492f84c4c2", "is_protected": false, "is_public": false, "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "locations": [ { "metadata": {}, "url": "rbd://03e3321d-071f-4b28-a3f9-0256f384bdca/images_d/2be0c3ea-d7b7-4b47-886d-d5492f84c4c2/snap" } ], "metadata": { "owner_specified.openstack.md5": "5cefce0d73289233054bfacc62c574d5", "owner_specified.openstack.object": "images/Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import", "owner_specified.openstack.sha256": "bc8a1d28f64ab7d2bf2486c1607ff77bfe054d6947cf8562b09fb73691ef0b71", "schema": "/v2/schemas/image" }, "minDisk": 0, "minRam": 0, "min_disk": 0, "min_ram": 0, "name": "Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import", "owner": "6a80eb816d3742d2a222f1e9680d5194", "owner_specified.openstack.md5": "5cefce0d73289233054bfacc62c574d5", "owner_specified.openstack.object": "images/Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import", "owner_specified.openstack.sha256": "bc8a1d28f64ab7d2bf2486c1607ff77bfe054d6947cf8562b09fb73691ef0b71", "properties": { "owner_specified.openstack.md5": "5cefce0d73289233054bfacc62c574d5", "owner_specified.openstack.object": "images/Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import", "owner_specified.openstack.sha256": "bc8a1d28f64ab7d2bf2486c1607ff77bfe054d6947cf8562b09fb73691ef0b71", "schema": "/v2/schemas/image" }, "protected": false, "schema": "/v2/schemas/image", "size": 1617756160, "status": "active", "tags": [], "updated": "2019-11-21T09:17:24Z", "updated_at": "2019-11-21T09:17:24Z", "virtual_size": 0, "visibility": "private" } } :: [ 04:18:09 ] :: [ INFO ] :: OS_IMAGE_UUID=2be0c3ea-d7b7-4b47-886d-d5492f84c4c2 :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 144s :: Assertions: 2 good, 0 bad :: RESULT: PASS (Upload QCOW2 image to OpenStack) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Start VM instance :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:18:09 ] :: [ PASS ] :: Command 'ssh-keygen -t rsa -N '' -f /tmp/composer-ssh-keys.M6ro4n/id_rsa' (Expected 0, got 0) :: [ 04:18:12 ] :: [ PASS ] :: Command 'ansible localhost -m os_keypair -a 'name=Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key public_key_file=/tmp/composer-ssh-keys.M6ro4n/id_rsa.pub'' (Expected 0, got 0) :: [ 04:19:47 ] :: [ PASS ] :: VM started successfully (Assert: expected 0, got 0) :: [ 04:19:47 ] :: [ INFO ] :: localhost | CHANGED => { "changed": true, "id": "2aa4a9ee-1a0c-4516-8d80-d081c221dde7", "openstack": { "OS-DCF:diskConfig": "MANUAL", "OS-EXT-AZ:availability_zone": "nova", "OS-EXT-SRV-ATTR:host": null, "OS-EXT-SRV-ATTR:hostname": null, "OS-EXT-SRV-ATTR:hypervisor_hostname": null, "OS-EXT-SRV-ATTR:instance_name": null, "OS-EXT-SRV-ATTR:kernel_id": null, "OS-EXT-SRV-ATTR:launch_index": null, "OS-EXT-SRV-ATTR:ramdisk_id": null, "OS-EXT-SRV-ATTR:reservation_id": null, "OS-EXT-SRV-ATTR:root_device_name": null, "OS-EXT-SRV-ATTR:user_data": null, "OS-EXT-STS:power_state": 1, "OS-EXT-STS:task_state": null, "OS-EXT-STS:vm_state": "active", "OS-SCH-HNT:scheduler_hints": null, "OS-SRV-USG:launched_at": "2019-11-21T09:19:25.000000", "OS-SRV-USG:terminated_at": null, "accessIPv4": "10.0.138.4", "accessIPv6": "2620:52:0:88:f816:3eff:fe34:4b9", "addresses": { "provider_net_cci_2": [ { "OS-EXT-IPS-MAC:mac_addr": "fa:16:3e:34:04:b9", "OS-EXT-IPS:type": "fixed", "addr": "10.0.138.4", "version": 4 }, { "OS-EXT-IPS-MAC:mac_addr": "fa:16:3e:34:04:b9", "OS-EXT-IPS:type": "fixed", "addr": "2620:52:0:88:f816:3eff:fe34:4b9", "version": 6 } ] }, "adminPass": "kQAG6KY6JF3o", "az": "nova", "block_device_mapping": null, "cloud": "envvars", "config_drive": "", "created": "2019-11-21T09:19:01Z", "created_at": "2019-11-21T09:19:01Z", "description": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d", "disk_config": "MANUAL", "flavor": { "disk": 30, "ephemeral": 10, "extra_specs": { "aggregate_instance_extra_specs:server_type:aggregate": "ci" }, "name": "ci.m1.medium.ephemeral", "original_name": "ci.m1.medium.ephemeral", "ram": 4096, "swap": 0, "vcpus": 2 }, "has_config_drive": false, "host": null, "hostId": "5894b70ad6080c4a88fe1d13b26a2ee97869d736f7679d9b1a4eaedf", "host_id": "5894b70ad6080c4a88fe1d13b26a2ee97869d736f7679d9b1a4eaedf", "host_status": null, "hostname": null, "hypervisor_hostname": null, "id": "2aa4a9ee-1a0c-4516-8d80-d081c221dde7", "image": { "id": "2be0c3ea-d7b7-4b47-886d-d5492f84c4c2", "name": "Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import" }, "instance_name": null, "interface_ip": "2620:52:0:88:f816:3eff:fe34:4b9", "kernel_id": null, "key_name": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key", "launch_index": null, "launched_at": "2019-11-21T09:19:25.000000", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": "nova" }, "locked": false, "metadata": {}, "name": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d", "networks": {}, "os-extended-volumes:volumes_attached": [], "personality": null, "power_state": 1, "private_v4": "", "progress": 0, "project_id": "6a80eb816d3742d2a222f1e9680d5194", "properties": { "OS-DCF:diskConfig": "MANUAL", "OS-EXT-AZ:availability_zone": "nova", "OS-EXT-SRV-ATTR:host": null, "OS-EXT-SRV-ATTR:hostname": null, "OS-EXT-SRV-ATTR:hypervisor_hostname": null, "OS-EXT-SRV-ATTR:instance_name": null, "OS-EXT-SRV-ATTR:kernel_id": null, "OS-EXT-SRV-ATTR:launch_index": null, "OS-EXT-SRV-ATTR:ramdisk_id": null, "OS-EXT-SRV-ATTR:reservation_id": null, "OS-EXT-SRV-ATTR:root_device_name": null, "OS-EXT-SRV-ATTR:user_data": null, "OS-EXT-STS:power_state": 1, "OS-EXT-STS:task_state": null, "OS-EXT-STS:vm_state": "active", "OS-SCH-HNT:scheduler_hints": null, "OS-SRV-USG:launched_at": "2019-11-21T09:19:25.000000", "OS-SRV-USG:terminated_at": null, "host_status": null, "locked": false, "os-extended-volumes:volumes_attached": [], "trusted_image_certificates": null }, "public_v4": "10.0.138.4", "public_v6": "2620:52:0:88:f816:3eff:fe34:4b9", "ramdisk_id": null, "region": "", "reservation_id": null, "root_device_name": null, "scheduler_hints": null, "security_groups": [ { "description": "Default security group", "id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "name": "default", "project_id": "6a80eb816d3742d2a222f1e9680d5194", "properties": {}, "security_group_rules": [ { "direction": "ingress", "ethertype": "IPv4", "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" }, "id": "0a098982-4c23-48d8-b2bd-ba62ee23e631", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": null, "port_range_min": null, "project_id": "", "properties": { "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } }, "protocol": null, "remote_group_id": null, "remote_ip_prefix": null, "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": {}, "id": "532e832a-1fb5-4d18-a116-153e4bdc9cdf", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": 22, "port_range_min": 22, "project_id": "", "properties": { "group": {} }, "protocol": "tcp", "remote_group_id": null, "remote_ip_prefix": "0.0.0.0/0", "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" }, "id": "bb908ca2-1d69-443b-98e7-f30c74248b24", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": null, "port_range_min": null, "project_id": "", "properties": { "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } }, "protocol": null, "remote_group_id": null, "remote_ip_prefix": null, "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": {}, "id": "d49a4869-b96d-4aa4-97b7-a0f1bce15531", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": 22, "port_range_min": 22, "project_id": "", "properties": { "group": {} }, "protocol": "tcp", "remote_group_id": null, "remote_ip_prefix": "::/0", "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" } ], "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } ], "server_groups": null, "status": "ACTIVE", "tags": [], "task_state": null, "tenant_id": "6a80eb816d3742d2a222f1e9680d5194", "terminated_at": null, "trusted_image_certificates": null, "updated": "2019-11-21T09:19:25Z", "user_data": null, "user_id": "19d5cc50fe7fc5f8f502c7cbebc7c7382b33ca700fdacd7f6f9d918d2537ae98", "vm_state": "active", "volumes": [] }, "server": { "OS-DCF:diskConfig": "MANUAL", "OS-EXT-AZ:availability_zone": "nova", "OS-EXT-SRV-ATTR:host": null, "OS-EXT-SRV-ATTR:hostname": null, "OS-EXT-SRV-ATTR:hypervisor_hostname": null, "OS-EXT-SRV-ATTR:instance_name": null, "OS-EXT-SRV-ATTR:kernel_id": null, "OS-EXT-SRV-ATTR:launch_index": null, "OS-EXT-SRV-ATTR:ramdisk_id": null, "OS-EXT-SRV-ATTR:reservation_id": null, "OS-EXT-SRV-ATTR:root_device_name": null, "OS-EXT-SRV-ATTR:user_data": null, "OS-EXT-STS:power_state": 1, "OS-EXT-STS:task_state": null, "OS-EXT-STS:vm_state": "active", "OS-SCH-HNT:scheduler_hints": null, "OS-SRV-USG:launched_at": "2019-11-21T09:19:25.000000", "OS-SRV-USG:terminated_at": null, "accessIPv4": "10.0.138.4", "accessIPv6": "2620:52:0:88:f816:3eff:fe34:4b9", "addresses": { "provider_net_cci_2": [ { "OS-EXT-IPS-MAC:mac_addr": "fa:16:3e:34:04:b9", "OS-EXT-IPS:type": "fixed", "addr": "10.0.138.4", "version": 4 }, { "OS-EXT-IPS-MAC:mac_addr": "fa:16:3e:34:04:b9", "OS-EXT-IPS:type": "fixed", "addr": "2620:52:0:88:f816:3eff:fe34:4b9", "version": 6 } ] }, "adminPass": "kQAG6KY6JF3o", "az": "nova", "block_device_mapping": null, "cloud": "envvars", "config_drive": "", "created": "2019-11-21T09:19:01Z", "created_at": "2019-11-21T09:19:01Z", "description": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d", "disk_config": "MANUAL", "flavor": { "disk": 30, "ephemeral": 10, "extra_specs": { "aggregate_instance_extra_specs:server_type:aggregate": "ci" }, "name": "ci.m1.medium.ephemeral", "original_name": "ci.m1.medium.ephemeral", "ram": 4096, "swap": 0, "vcpus": 2 }, "has_config_drive": false, "host": null, "hostId": "5894b70ad6080c4a88fe1d13b26a2ee97869d736f7679d9b1a4eaedf", "host_id": "5894b70ad6080c4a88fe1d13b26a2ee97869d736f7679d9b1a4eaedf", "host_status": null, "hostname": null, "hypervisor_hostname": null, "id": "2aa4a9ee-1a0c-4516-8d80-d081c221dde7", "image": { "id": "2be0c3ea-d7b7-4b47-886d-d5492f84c4c2", "name": "Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import" }, "instance_name": null, "interface_ip": "2620:52:0:88:f816:3eff:fe34:4b9", "kernel_id": null, "key_name": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key", "launch_index": null, "launched_at": "2019-11-21T09:19:25.000000", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": "nova" }, "locked": false, "metadata": {}, "name": "Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d", "networks": {}, "os-extended-volumes:volumes_attached": [], "personality": null, "power_state": 1, "private_v4": "", "progress": 0, "project_id": "6a80eb816d3742d2a222f1e9680d5194", "properties": { "OS-DCF:diskConfig": "MANUAL", "OS-EXT-AZ:availability_zone": "nova", "OS-EXT-SRV-ATTR:host": null, "OS-EXT-SRV-ATTR:hostname": null, "OS-EXT-SRV-ATTR:hypervisor_hostname": null, "OS-EXT-SRV-ATTR:instance_name": null, "OS-EXT-SRV-ATTR:kernel_id": null, "OS-EXT-SRV-ATTR:launch_index": null, "OS-EXT-SRV-ATTR:ramdisk_id": null, "OS-EXT-SRV-ATTR:reservation_id": null, "OS-EXT-SRV-ATTR:root_device_name": null, "OS-EXT-SRV-ATTR:user_data": null, "OS-EXT-STS:power_state": 1, "OS-EXT-STS:task_state": null, "OS-EXT-STS:vm_state": "active", "OS-SCH-HNT:scheduler_hints": null, "OS-SRV-USG:launched_at": "2019-11-21T09:19:25.000000", "OS-SRV-USG:terminated_at": null, "host_status": null, "locked": false, "os-extended-volumes:volumes_attached": [], "trusted_image_certificates": null }, "public_v4": "10.0.138.4", "public_v6": "2620:52:0:88:f816:3eff:fe34:4b9", "ramdisk_id": null, "region": "", "reservation_id": null, "root_device_name": null, "scheduler_hints": null, "security_groups": [ { "description": "Default security group", "id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "name": "default", "project_id": "6a80eb816d3742d2a222f1e9680d5194", "properties": {}, "security_group_rules": [ { "direction": "ingress", "ethertype": "IPv4", "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" }, "id": "0a098982-4c23-48d8-b2bd-ba62ee23e631", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": null, "port_range_min": null, "project_id": "", "properties": { "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } }, "protocol": null, "remote_group_id": null, "remote_ip_prefix": null, "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": {}, "id": "532e832a-1fb5-4d18-a116-153e4bdc9cdf", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": 22, "port_range_min": 22, "project_id": "", "properties": { "group": {} }, "protocol": "tcp", "remote_group_id": null, "remote_ip_prefix": "0.0.0.0/0", "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" }, "id": "bb908ca2-1d69-443b-98e7-f30c74248b24", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": null, "port_range_min": null, "project_id": "", "properties": { "group": { "name": "default", "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } }, "protocol": null, "remote_group_id": null, "remote_ip_prefix": null, "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" }, { "direction": "ingress", "ethertype": "IPv4", "group": {}, "id": "d49a4869-b96d-4aa4-97b7-a0f1bce15531", "location": { "cloud": "envvars", "project": { "domain_id": null, "domain_name": "redhat.com", "id": "6a80eb816d3742d2a222f1e9680d5194", "name": "composer-jenkins" }, "region_name": "", "zone": null }, "port_range_max": 22, "port_range_min": 22, "project_id": "", "properties": { "group": {} }, "protocol": "tcp", "remote_group_id": null, "remote_ip_prefix": "::/0", "security_group_id": "28cceacb-8ec4-4f7d-b595-31a4691f7ec5", "tenant_id": "" } ], "tenant_id": "6a80eb816d3742d2a222f1e9680d5194" } ], "server_groups": null, "status": "ACTIVE", "tags": [], "task_state": null, "tenant_id": "6a80eb816d3742d2a222f1e9680d5194", "terminated_at": null, "trusted_image_certificates": null, "updated": "2019-11-21T09:19:25Z", "user_data": null, "user_id": "19d5cc50fe7fc5f8f502c7cbebc7c7382b33ca700fdacd7f6f9d918d2537ae98", "vm_state": "active", "volumes": [] } } :: [ 04:19:47 ] :: [ INFO ] :: Running instance IP_ADDRESS=10.0.138.4 :: [ 04:19:47 ] :: [ INFO ] :: Waiting 60sec for instance to initialize ... :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 158s :: Assertions: 3 good, 0 bad :: RESULT: PASS (Start VM instance) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Verify VM instance :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:20:47 ] :: [ INFO ] :: verify_image: SSH_OPTS:'-o StrictHostKeyChecking=no -o BatchMode=yes -i /tmp/composer-ssh-keys.M6ro4n/id_rsa' SSH_USER:'cloud-user' SSH_MACHINE: '10.0.138.4' :: [ 04:21:00 ] :: [ PASS ] :: Can't ssh to '10.0.138.4' as root using password-based auth (Expected 0, got 0) :: [ 04:21:01 ] :: [ PASS ] :: root account is disabled in /etc/shadow (Expected 0, got 0) :: [ 04:21:02 ] :: [ PASS ] :: audit.log contains entry about unsuccessful root login (Expected 0, got 0) :: [ 04:21:03 ] :: [ PASS ] :: Login with empty passwords is disabled in sshd config file (Expected 1, got 1) :: [ 04:21:04 ] :: [ PASS ] :: Command 'ssh -o StrictHostKeyChecking=no -o BatchMode=yes -i /tmp/composer-ssh-keys.M6ro4n/id_rsa cloud-user@10.0.138.4 'cat /etc/redhat-release'' (Expected 0, got 0) :: [ 04:21:05 ] :: [ PASS ] :: System booted from the image contains specified parameter on kernel command line (Expected 0, got 0) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 18s :: Assertions: 6 good, 0 bad :: RESULT: PASS (Verify VM instance) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Cleanup :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:21:08 ] :: [ PASS ] :: Command 'ansible localhost -m os_keypair -a 'name=Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d-key state=absent'' (Expected 0, got 0) :: [ 04:21:18 ] :: [ PASS ] :: Command 'ansible localhost -m os_server -a 'name=Composer-Auto-VM-b25389c0-bcc7-4957-9e3f-c9371722fe8d state=absent'' (Expected 0, got 0) :: [ 04:22:28 ] :: [ PASS ] :: Command 'ansible localhost -m os_image -a 'name=Composer-b25389c0-bcc7-4957-9e3f-c9371722fe8d-Automated-Import state=absent'' (Expected 0, got 0) :: [ 04:22:29 ] :: [ PASS ] :: Command '/usr/bin/composer-cli compose delete b25389c0-bcc7-4957-9e3f-c9371722fe8d' (Expected 0, got 0) :: [ 04:22:29 ] :: [ PASS ] :: Command 'rm -rf b25389c0-bcc7-4957-9e3f-c9371722fe8d-disk.qcow2 /tmp/composer-ssh-keys.M6ro4n /tmp/ansible.venv.Vgs' (Expected 0, got 0) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 84s :: Assertions: 5 good, 0 bad :: RESULT: PASS (Cleanup) :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: /tests/cli/test_build_and_deploy_openstack.sh :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: [ 04:22:29 ] :: [ LOG ] :: JOURNAL TXT: /tmp/composer-test.Lk68qm/journal.txt :::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::::: :: Duration: 939s :: Phases: 7 good, 0 bad :: OVERALL RESULT: PASS (/tests/cli/test_build_and_deploy_openstack.sh) % Total % Received % Xferd Average Speed Time Time Time Current Dload Upload Total Spent Left Speed 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:01 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:02 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:03 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:04 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:05 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:06 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:07 --:--:-- 0 0 0 0 0 0 0 0 0 --:--:-- 0:00:08 --:--:-- 0 100 301 100 301 0 0 33 0 0:00:09 0:00:08 0:00:01 60 100 301 100 301 0 0 33 0 0:00:09 0:00:08 0:00:01 75 "db_supported": true, Starting virtual machine 'rhel-7-8' Machine is up. Connect to it via: ssh -o ControlPath=/build/tmp/ssh-%h-%p-%r-924 -p 2201 root@127.0.0.2 Waiting for lorax-composer to become ready... ok 1 TestCloud.test_openstack