/tmp/CloudImageF27.biLQkO ~
Cloning into 'pungi-fedora'...
Switched to a new branch 'f27'
Branch f27 set up to track remote branch f27 from origin.
cat: /mnt/koji/compose//latest-Fedora-27/COMPOSE_ID: No such file or directory
Cloning into 'releng'...
/tmp/27.20171031.dkKy /tmp/CloudImageF27.biLQkO/pungi-fedora
Cloning into 'fedora-comps'...
/tmp/27.20171031.dkKy/fedora-comps /tmp/27.20171031.dkKy
/tmp/CloudImageF27.biLQkO/pungi-fedora
./update-comps comps-f27.xml
Merging translations into comps-f27.xml.
CREATED comps-f27.xml
/tmp/27.20171031.dkKy /tmp/CloudImageF27.biLQkO/pungi-fedora
/tmp/CloudImageF27.biLQkO/pungi-fedora
2017-10-31 07:15:18 [INFO ] Automatically setting 'supported' flag for a
Release Candidate (RC-20171031.0) compose.
2017-10-31 07:15:18 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'status-change', {'status': 'STARTED', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:15:19 [INFO ] Host:
compose-x86-01.phx2.fedoraproject.org
2017-10-31 07:15:19 [INFO ] Pungi version: 4.1.19
2017-10-31 07:15:19 [INFO ] User name: root
2017-10-31 07:15:19 [INFO ] Working directory: /tmp/CloudImageF27.biLQkO/pungi-fedora
2017-10-31 07:15:19 [INFO ] Command line: /usr/bin/pungi-koji
--notification-script=/usr/bin/pungi-fedmsg-notification --config=fedora-cloud.conf
--old-composes=/mnt/koji/compose/ --skip-phase=productimg --skip-phase=pkgset
--skip-phase=gather --skip-phase=extra_files --skip-phase=creatrepo --label=RC-20171031.0
--target-dir=/mnt/koji/compose/
2017-10-31 07:15:19 [INFO ] Compose top directory:
/mnt/koji/compose/Fedora-Cloud-27-20171031.0
2017-10-31 07:15:19 [INFO ] Current timezone offset: +00:00
2017-10-31 07:15:19 [DEBUG ] Writing variants file:
/mnt/koji/compose/Fedora-Cloud-27-20171031.0/work/global/variants.xml
2017-10-31 07:15:20 [DEBUG ] Exporting file
/tmp/CloudImageF27.biLQkO/pungi-fedora/variants-fedora.xml from current working
directory...
2017-10-31 07:15:20 [INFO ] Excluding variant Atomic: filtered by configuration.
2017-10-31 07:15:20 [INFO ] Excluding variant Docker: filtered by configuration.
2017-10-31 07:15:20 [INFO ] Excluding variant Everything: filtered by configuration.
2017-10-31 07:15:20 [INFO ] Excluding variant Labs: filtered by configuration.
2017-10-31 07:15:20 [INFO ] Excluding variant ostree: filtered by configuration.
2017-10-31 07:15:20 [INFO ] Excluding variant Server: filtered by configuration.
2017-10-31 07:15:20 [INFO ] Excluding variant Spins: filtered by configuration.
2017-10-31 07:15:20 [INFO ] Excluding variant Workstation: filtered by configuration.
2017-10-31 07:15:20 [INFO ] Excluding variant WorkstationOstree: filtered by
configuration.
2017-10-31 07:15:20 [INFO ] Excluding variant Cloud: filtered by configuration.
2017-10-31 07:15:20 [DEBUG ] Not a bootable product. Skipping buildinstall.
2017-10-31 07:15:20 [INFO ] Config section 'live_images' was not found.
Skipping.
2017-10-31 07:15:20 [INFO ] Config section 'live_media' was not found.
Skipping.
2017-10-31 07:15:20 [INFO ] Config section 'ostree' was not found. Skipping.
2017-10-31 07:15:20 [INFO ] Config section 'ostree_installer' was not found.
Skipping.
2017-10-31 07:15:20 [INFO ] Config section 'osbs' was not found. Skipping.
2017-10-31 07:15:20 [INFO ] [BEGIN] ---------- PHASE: INIT ----------
2017-10-31 07:15:20 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'init', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:15:21 [DEBUG ] Writing global comps file:
/mnt/koji/compose/Fedora-Cloud-27-20171031.0/work/global/comps/comps-global.xml
2017-10-31 07:15:21 [DEBUG ] Exporting file
/tmp/CloudImageF27.biLQkO/pungi-fedora/comps-f27.xml from current working directory...
2017-10-31 07:15:21 [DEBUG ] Writing comps file for arch 'x86_64':
/mnt/koji/compose/Fedora-Cloud-27-20171031.0/work/x86_64/comps/comps-x86_64.xml
2017-10-31 07:15:21 [INFO ] [BEGIN] Creating comps repo for arch 'x86_64'
2017-10-31 07:15:22 [INFO ] [DONE ] Creating comps repo for arch 'x86_64'
2017-10-31 07:15:22 [DEBUG ] Copying original comps file (arch: x86_64, variant:
CloudImages):
/mnt/koji/compose/Fedora-Cloud-27-20171031.0/work/x86_64/comps/comps-CloudImages.x86_64.xml
2017-10-31 07:15:22 [INFO ] [DONE ] ---------- PHASE: INIT ----------
2017-10-31 07:15:22 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'init', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:15:23 [WARNING ] [SKIP ] ---------- PHASE: PKGSET ----------
2017-10-31 07:15:23 [DEBUG ] Not a bootable product. Skipping buildinstall.
2017-10-31 07:15:23 [WARNING ] [SKIP ] ---------- PHASE: BUILDINSTALL ----------
2017-10-31 07:15:23 [WARNING ] [SKIP ] ---------- PHASE: GATHER ----------
2017-10-31 07:15:23 [INFO ] Writing RPM manifest:
/mnt/koji/compose/Fedora-Cloud-27-20171031.0/compose/metadata/rpms.json
2017-10-31 07:15:23 [WARNING ] [SKIP ] ---------- PHASE: EXTRA_FILES ----------
2017-10-31 07:15:23 [INFO ] [BEGIN] ---------- PHASE: CREATEREPO ----------
2017-10-31 07:15:23 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'createrepo', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:15:24 [INFO ] No product certificates specified
2017-10-31 07:15:25 [INFO ] [DONE ] ---------- PHASE: CREATEREPO ----------
2017-10-31 07:15:26 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'createrepo', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:15:27 [INFO ] Config section 'ostree' was not found. Skipping.
2017-10-31 07:15:27 [WARNING ] [SKIP ] ---------- PHASE: OSTREE ----------
2017-10-31 07:15:27 [WARNING ] [SKIP ] ---------- PHASE: PRODUCTIMG ----------
2017-10-31 07:15:27 [INFO ] [BEGIN] ---------- PHASE: CREATEISO ----------
2017-10-31 07:15:27 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'createiso', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:15:29 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'createiso-targets', {'compose_id': u'Fedora-Cloud-27-20171031.0',
'deliverables': [], 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose'}
2017-10-31 07:15:31 [INFO ] Config section 'live_images' was not found.
Skipping.
2017-10-31 07:15:31 [WARNING ] [SKIP ] ---------- PHASE: LIVE_IMAGES ----------
2017-10-31 07:15:31 [INFO ] [BEGIN] ---------- PHASE: IMAGE_BUILD ----------
2017-10-31 07:15:31 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'image_build', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:15:33 [INFO ] Config section 'live_media' was not found.
Skipping.
2017-10-31 07:15:33 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating qcow2-raw-xz image
(arches: x86_64, variant: CloudImages, subvariant: Cloud_Base)
2017-10-31 07:15:33 [WARNING ] [SKIP ] ---------- PHASE: LIVE_MEDIA ----------
2017-10-31 07:15:33 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating
vagrant-libvirt-vagrant-virtualbox image (arches: x86_64, variant: CloudImages,
subvariant: Cloud_Base)
2017-10-31 07:15:33 [INFO ] Config section 'ostree_installer' was not found.
Skipping.
2017-10-31 07:15:33 [WARNING ] [SKIP ] ---------- PHASE: OSTREE_INSTALLER ----------
2017-10-31 07:15:33 [INFO ] Config section 'osbs' was not found. Skipping.
2017-10-31 07:15:33 [WARNING ] [SKIP ] ---------- PHASE: OSBS ----------
2017-10-31 07:15:33 [IMAGE_BUILD ] [INFO ] Writing image-build config for
CloudImages.x86_64 into
/mnt/koji/compose/Fedora-Cloud-27-20171031.0/work/image-build/CloudImages/qcow2-raw-xz_Fedora-Cloud-Base_x86_64.cfg
2017-10-31 07:15:33 [IMAGE_BUILD ] [INFO ] Writing image-build config for
CloudImages.x86_64 into
/mnt/koji/compose/Fedora-Cloud-27-20171031.0/work/image-build/CloudImages/vagrant-libvirt-vagrant-virtualbox_Fedora-Cloud-Base-Vagrant_x86_64.cfg
2017-10-31 07:16:01 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output':
"Created task: 22820332\nTask info:
https://koji.fedoraproject.org/koji/taskinfo?taskID=22820332\nWatching tasks (this may be
safely interrupted)...\n22820332 image (f27, Fedora-Cloud-Base-27, fedora-cloud-base.ks):
free\n22820332 image (f27, Fedora-Cloud-Base-27, fedora-cloud-base.ks): free -> open
(buildvm-ppc64-02.ppc.fedoraproject.org)\n 22820333 createImage (f27,
Fedora-Cloud-Base-27-20171031.0, fedora-cloud-base.ks, x86_64): open
(buildhw-06.phx2.fedoraproject.org)\n 22820333 createImage (f27,
Fedora-Cloud-Base-27-20171031.0, fedora-cloud-base.ks, x86_64): open
(
buildhw-06.phx2.fedoraproject.org) -> FAILED: ApplianceError: Image status is FAILED:
Could not reach
https://kojipkgs.fedoraproject.org/pub/alt/releases/27/Cloud/x86_64/os//i... to
fetch boot media: {'AppTime': 'D=4888', 'Content-Length':
'250', 'X-Xss-Protection': '1; mode=block', 'HTTP-Code':
404, 'X-Content-Type-Options':
'nosniff', 'Age': '0', 'Strict-Transport-Security':
'max-age=15768000; includeSubDomains; preload, max-age=15768000; includeSubDomains;
preload', 'Keep-Alive': 'timeout=15, max=500', 'Server':
'Apache/2.4.27 (Fedora)', 'AppServer':
'proxy10.phx2.fedoraproject.org', 'Connection': 'Keep-Alive',
'X-Varnish': '146589608', 'Via': '1.1 varnish
(Varnish/5.0)', 'Date': 'Tue, 31 Oct 2017 07:15:46 GMT',
'Redirect-URL': None, 'X-Frame-Options': 'SAMEORIGIN',
'Referrer-Policy': 'same-origin', 'Content-Type': 'text/html;
charset=iso-8859-1'}\n 0 free 1 open 0 done 1 failed\n22820332 image (f27,
Fedora-Cloud-Base-27, fedora-cloud-base.ks): open (
buildvm-ppc64-02.ppc.fedoraproject.org)
-> FAILED: ApplianceError: Image status is FAILED: Could not reach
https://kojipkgs.fedoraproject.org/pub/alt/releases/27/Cloud/x86_64/os//i... to
fetch boot media: {'AppTime': 'D=4888', 'Content-Length':
'250', 'X-Xss-Protection': '1; mode=block', 'HTTP-Code':
404, 'X-Content-Type-Options': 'nosniff'
, 'Age': '0', 'Strict-Transport-Security': 'max-age=15768000;
includeSubDomains; preload, max-age=15768000; includeSubDomains; preload',
'Keep-Alive': 'timeout=15, max=500', 'Server': 'Apache/2.4.27
(Fedora)', 'AppServer': 'proxy10.phx2.fedoraproject.org',
'Connection': 'Keep-Alive', 'X-Varnish': '146589608',
'Via': '1.1 varnish (Varnish/5.0)', 'Date': 'Tue, 31 Oct 2017
07:15:46 GMT', 'Redirect-URL': None, 'X-Frame-Options':
'SAMEORIGIN', 'Referrer-Policy': 'same-origin',
'Content-Type': 'text/html; charset=iso-8859-1'}\n 0 free 0 open 0 done
2 failed\n\n22820332 image (f27, Fedora-Cloud-Base-27, fedora-cloud-base.ks)
failed\n", 'retcode': 0, 'task_id': 22820332}
2017-10-31 07:16:01 [IMAGE_BUILD ] [INFO ] [DONE ] Creating qcow2-raw-xz image
(arches: x86_64, variant: CloudImages, subvariant: Cloud_Base) (task id: 22820332)
2017-10-31 07:16:04 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output':
"Created task: 22820334\nTask info:
https://koji.fedoraproject.org/koji/taskinfo?taskID=22820334\nWatching tasks (this may be
safely interrupted)...\n22820334 image (f27, Fedora-Cloud-Base-Vagrant-27,
fedora-cloud-base-vagrant.ks): free\n22820334 image (f27, Fedora-Cloud-Base-Vagrant-27,
fedora-cloud-base-vagrant.ks): free -> open (buildvm-ppc64-01.ppc.fedoraproject.org)\n
22820335 createImage (f27, Fedora-Cloud-Base-Vagrant-27-20171031.0,
fedora-cloud-base-vagrant.ks, x86_64): free\n 22820335 createImage (f27,
Fedora-Cloud-Base-Vagrant-27-20171031.0, fedora-cloud-base-vagrant.ks, x86_64): free ->
open (buildhw-04.phx2.fedoraproject.org)\n22820334 image (f27,
Fedora-Cloud-Base-Vagrant-27, fedora-cloud-base-vagrant.ks): open
(
buildvm-ppc64-01.ppc.fedoraproject.org) -> FAILED: ApplianceError: Image status is
FAILED: Could not reach
https://kojipkgs.fedoraproject.org/pub/alt/releases/27/Cloud/x86_64/os//
images/boot.iso to fetch boot media: {'AppTime': 'D=2546',
'Content-Length': '250', 'X-Xss-Protection': '1;
mode=block', 'HTTP-Code': 404, 'X-Content-Type-Options':
'nosniff', 'Age': '0', 'Strict-Transport-Security':
'max-age=15768000; includeSubDomains; preload, max-age=15768000; includeSubDomains;
preload', 'Keep-Alive': 'timeout=15, max=500', 'Server':
'Apache/2.4.27 (Fedora)', 'AppServer':
'proxy10.phx2.fedoraproject.org', 'Connection': 'Keep-Alive',
'X-Varnish': '141724581', 'Via': '1.1 varnish
(Varnish/5.0)', 'Date': 'Tue, 31 Oct 2017 07:15:58 GMT',
'Redirect-URL': None, 'X-Frame-Options': 'SAMEORIGIN',
'Referrer-Policy': 'same-origin', 'Content-Type': 'text/html;
charset=iso-8859-1'}\n 0 free 1 open 0 done 1 failed\n 22820335 createImage (f27,
Fedora-Cloud-Base-Vagrant-27-20171031.0, fedora-cloud-base-vagrant.ks, x86_64): open
(
buildhw-04.phx2.fedoraproject.org) -> FAILED: ApplianceError: Image status is FAILED:
Could not reach
https://kojipkgs.fedoraproject.org/pub/alt/
releases/27/Cloud/x86_64/os//images/boot.iso to fetch boot media: {'AppTime':
'D=2546', 'Content-Length': '250', 'X-Xss-Protection':
'1; mode=block', 'HTTP-Code': 404, 'X-Content-Type-Options':
'nosniff', 'Age': '0', 'Strict-Transport-Security':
'max-age=15768000; includeSubDomains; preload, max-age=15768000; includeSubDomains;
preload', 'Keep-Alive': 'timeout=15, max=500', 'Server':
'Apache/2.4.27 (Fedora)', 'AppServer':
'proxy10.phx2.fedoraproject.org', 'Connection': 'Keep-Alive',
'X-Varnish': '141724581', 'Via': '1.1 varnish
(Varnish/5.0)', 'Date': 'Tue, 31 Oct 2017 07:15:58 GMT',
'Redirect-URL': None, 'X-Frame-Options': 'SAMEORIGIN',
'Referrer-Policy': 'same-origin', 'Content-Type': 'text/html;
charset=iso-8859-1'}\n 0 free 0 open 0 done 2 failed\n\n22820334 image (f27,
Fedora-Cloud-Base-Vagrant-27, fedora-cloud-base-vagrant.ks) failed\n",
'retcode': 0, 'task_id': 22820334}
2017-10-31 07:16:04 [IMAGE_BUILD ] [INFO ] [DONE ] Creating
vagrant-libvirt-vagrant-virtualbox image (arches: x86_64, variant: CloudImages,
subvariant: Cloud_Base) (task id: 22820334)
2017-10-31 07:16:04 [INFO ] [DONE ] ---------- PHASE: IMAGE_BUILD ----------
2017-10-31 07:16:04 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'image_build', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:16:06 [INFO ] [DONE ] ---------- PHASE: CREATEISO ----------
2017-10-31 07:16:06 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'createiso', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:16:07 [INFO ] [BEGIN] ---------- PHASE: IMAGE_CHECKSUM ----------
2017-10-31 07:16:07 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'image_checksum',
'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:16:09 [INFO ] [DONE ] ---------- PHASE: IMAGE_CHECKSUM ----------
2017-10-31 07:16:09 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'image_checksum', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:16:10 [INFO ] [BEGIN] Writing composeinfo
2017-10-31 07:16:10 [INFO ] [DONE ] Writing composeinfo
2017-10-31 07:16:10 [INFO ] [BEGIN] ---------- PHASE: TEST ----------
2017-10-31 07:16:10 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'test', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:16:11 [INFO ] [BEGIN] Running repoclosure
2017-10-31 07:16:11 [INFO ] [DONE ] Running repoclosure
2017-10-31 07:16:11 [INFO ] [DONE ] ---------- PHASE: TEST ----------
2017-10-31 07:16:11 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'test', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:16:13 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'status-change', {'status': 'FINISHED', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171031.0/compose',
'compose_id': u'Fedora-Cloud-27-20171031.0'}
2017-10-31 07:16:14 [INFO ] Compose finished:
/mnt/koji/compose/Fedora-Cloud-27-20171031.0
real 0m57.263s
user 0m7.226s
sys 0m1.570s
cat: /mnt/koji/compose//latest-Fedora-27/COMPOSE_ID: No such file or directory
~