/tmp/CloudImageF27.kEznOT ~
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.20171029.uWS1 /tmp/CloudImageF27.kEznOT/pungi-fedora
Cloning into 'fedora-comps'...
/tmp/27.20171029.uWS1/fedora-comps /tmp/27.20171029.uWS1
/tmp/CloudImageF27.kEznOT/pungi-fedora
./update-comps comps-f27.xml
Merging translations into comps-f27.xml.
CREATED comps-f27.xml
/tmp/27.20171029.uWS1 /tmp/CloudImageF27.kEznOT/pungi-fedora
/tmp/CloudImageF27.kEznOT/pungi-fedora
2017-10-29 07:15:18 [INFO ] Automatically setting 'supported' flag for a
Release Candidate (RC-20171029.0) compose.
2017-10-29 07:15:19 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'status-change', {'status': 'STARTED', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:15:20 [INFO ] Host:
compose-x86-01.phx2.fedoraproject.org
2017-10-29 07:15:20 [INFO ] Pungi version: 4.1.19
2017-10-29 07:15:20 [INFO ] User name: root
2017-10-29 07:15:20 [INFO ] Working directory: /tmp/CloudImageF27.kEznOT/pungi-fedora
2017-10-29 07:15:20 [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-20171029.0
--target-dir=/mnt/koji/compose/
2017-10-29 07:15:20 [INFO ] Compose top directory:
/mnt/koji/compose/Fedora-Cloud-27-20171029.0
2017-10-29 07:15:20 [INFO ] Current timezone offset: +00:00
2017-10-29 07:15:20 [DEBUG ] Writing variants file:
/mnt/koji/compose/Fedora-Cloud-27-20171029.0/work/global/variants.xml
2017-10-29 07:15:20 [DEBUG ] Exporting file
/tmp/CloudImageF27.kEznOT/pungi-fedora/variants-fedora.xml from current working
directory...
2017-10-29 07:15:20 [INFO ] Excluding variant Atomic: filtered by configuration.
2017-10-29 07:15:20 [INFO ] Excluding variant Docker: filtered by configuration.
2017-10-29 07:15:20 [INFO ] Excluding variant Everything: filtered by configuration.
2017-10-29 07:15:20 [INFO ] Excluding variant Labs: filtered by configuration.
2017-10-29 07:15:20 [INFO ] Excluding variant ostree: filtered by configuration.
2017-10-29 07:15:20 [INFO ] Excluding variant Server: filtered by configuration.
2017-10-29 07:15:20 [INFO ] Excluding variant Spins: filtered by configuration.
2017-10-29 07:15:20 [INFO ] Excluding variant Workstation: filtered by configuration.
2017-10-29 07:15:20 [INFO ] Excluding variant WorkstationOstree: filtered by
configuration.
2017-10-29 07:15:20 [INFO ] Excluding variant Cloud: filtered by configuration.
2017-10-29 07:15:20 [DEBUG ] Not a bootable product. Skipping buildinstall.
2017-10-29 07:15:20 [INFO ] Config section 'live_images' was not found.
Skipping.
2017-10-29 07:15:20 [INFO ] Config section 'live_media' was not found.
Skipping.
2017-10-29 07:15:20 [INFO ] Config section 'ostree' was not found. Skipping.
2017-10-29 07:15:20 [INFO ] Config section 'ostree_installer' was not found.
Skipping.
2017-10-29 07:15:20 [INFO ] Config section 'osbs' was not found. Skipping.
2017-10-29 07:15:20 [INFO ] [BEGIN] ---------- PHASE: INIT ----------
2017-10-29 07:15:20 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'init', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:15:22 [DEBUG ] Writing global comps file:
/mnt/koji/compose/Fedora-Cloud-27-20171029.0/work/global/comps/comps-global.xml
2017-10-29 07:15:22 [DEBUG ] Exporting file
/tmp/CloudImageF27.kEznOT/pungi-fedora/comps-f27.xml from current working directory...
2017-10-29 07:15:22 [DEBUG ] Writing comps file for arch 'x86_64':
/mnt/koji/compose/Fedora-Cloud-27-20171029.0/work/x86_64/comps/comps-x86_64.xml
2017-10-29 07:15:22 [INFO ] [BEGIN] Creating comps repo for arch 'x86_64'
2017-10-29 07:15:22 [INFO ] [DONE ] Creating comps repo for arch 'x86_64'
2017-10-29 07:15:22 [DEBUG ] Copying original comps file (arch: x86_64, variant:
CloudImages):
/mnt/koji/compose/Fedora-Cloud-27-20171029.0/work/x86_64/comps/comps-CloudImages.x86_64.xml
2017-10-29 07:15:22 [INFO ] [DONE ] ---------- PHASE: INIT ----------
2017-10-29 07:15:22 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'init', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:15:24 [WARNING ] [SKIP ] ---------- PHASE: PKGSET ----------
2017-10-29 07:15:24 [DEBUG ] Not a bootable product. Skipping buildinstall.
2017-10-29 07:15:24 [WARNING ] [SKIP ] ---------- PHASE: BUILDINSTALL ----------
2017-10-29 07:15:24 [WARNING ] [SKIP ] ---------- PHASE: GATHER ----------
2017-10-29 07:15:24 [INFO ] Writing RPM manifest:
/mnt/koji/compose/Fedora-Cloud-27-20171029.0/compose/metadata/rpms.json
2017-10-29 07:15:24 [WARNING ] [SKIP ] ---------- PHASE: EXTRA_FILES ----------
2017-10-29 07:15:24 [INFO ] [BEGIN] ---------- PHASE: CREATEREPO ----------
2017-10-29 07:15:24 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'createrepo', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:15:25 [INFO ] No product certificates specified
2017-10-29 07:15:26 [INFO ] [DONE ] ---------- PHASE: CREATEREPO ----------
2017-10-29 07:15:26 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'createrepo', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:15:27 [INFO ] Config section 'ostree' was not found. Skipping.
2017-10-29 07:15:27 [WARNING ] [SKIP ] ---------- PHASE: OSTREE ----------
2017-10-29 07:15:27 [WARNING ] [SKIP ] ---------- PHASE: PRODUCTIMG ----------
2017-10-29 07:15:27 [INFO ] [BEGIN] ---------- PHASE: CREATEISO ----------
2017-10-29 07:15:27 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'createiso', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:15:29 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'createiso-targets', {'compose_id': u'Fedora-Cloud-27-20171029.0',
'deliverables': [], 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose'}
2017-10-29 07:15:30 [INFO ] Config section 'live_images' was not found.
Skipping.
2017-10-29 07:15:30 [WARNING ] [SKIP ] ---------- PHASE: LIVE_IMAGES ----------
2017-10-29 07:15:30 [INFO ] [BEGIN] ---------- PHASE: IMAGE_BUILD ----------
2017-10-29 07:15:30 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'image_build', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:15:33 [INFO ] Config section 'live_media' was not found.
Skipping.
2017-10-29 07:15:33 [WARNING ] [SKIP ] ---------- PHASE: LIVE_MEDIA ----------
2017-10-29 07:15:33 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating qcow2-raw-xz image
(arches: x86_64, variant: CloudImages, subvariant: Cloud_Base)
2017-10-29 07:15:33 [INFO ] Config section 'ostree_installer' was not found.
Skipping.
2017-10-29 07:15:33 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating
vagrant-libvirt-vagrant-virtualbox image (arches: x86_64, variant: CloudImages,
subvariant: Cloud_Base)
2017-10-29 07:15:33 [WARNING ] [SKIP ] ---------- PHASE: OSTREE_INSTALLER ----------
2017-10-29 07:15:33 [INFO ] Config section 'osbs' was not found. Skipping.
2017-10-29 07:15:33 [WARNING ] [SKIP ] ---------- PHASE: OSBS ----------
2017-10-29 07:15:33 [IMAGE_BUILD ] [INFO ] Writing image-build config for
CloudImages.x86_64 into
/mnt/koji/compose/Fedora-Cloud-27-20171029.0/work/image-build/CloudImages/qcow2-raw-xz_Fedora-Cloud-Base_x86_64.cfg
2017-10-29 07:15:33 [IMAGE_BUILD ] [INFO ] Writing image-build config for
CloudImages.x86_64 into
/mnt/koji/compose/Fedora-Cloud-27-20171029.0/work/image-build/CloudImages/vagrant-libvirt-vagrant-virtualbox_Fedora-Cloud-Base-Vagrant_x86_64.cfg
2017-10-29 07:16:01 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output':
"Created task: 22780837\nTask info:
https://koji.fedoraproject.org/koji/taskinfo?taskID=22780837\nWatching tasks (this may be
safely interrupted)...\n22780837 image (f27, Fedora-Cloud-Base-27, fedora-cloud-base.ks):
free\n22780837 image (f27, Fedora-Cloud-Base-27, fedora-cloud-base.ks): free -> open
(buildhw-06.phx2.fedoraproject.org)\n 22780838 createImage (f27,
Fedora-Cloud-Base-27-20171029.0, fedora-cloud-base.ks, x86_64): open
(buildhw-06.phx2.fedoraproject.org)\n 22780838 createImage (f27,
Fedora-Cloud-Base-27-20171029.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=7798', 'Content-Length':
'250', 'X-Xss-Protection': '1; mode=block', 'HTTP-Code':
404, 'X-Content-Type-Options': 'nosn
iff', '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': '133891993', 'Via': '1.1 varnish
(Varnish/5.0)', 'Date': 'Sun, 29 Oct 2017 07:15:45 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\n22780837 image (f27,
Fedora-Cloud-Base-27, fedora-cloud-base.ks): 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=7798', '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': '133891993', 'Via': '1.1
varnish (Varnish/5.0)', 'Date': 'Sun, 29 Oct 2017 07:15:45 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\n22780837 image (f27,
Fedora-Cloud-Base-27, fedora-cloud-base.ks) failed\n", 'retcode': 0,
'task_id': 22780837}
2017-10-29 07:16:01 [IMAGE_BUILD ] [INFO ] [DONE ] Creating qcow2-raw-xz image
(arches: x86_64, variant: CloudImages, subvariant: Cloud_Base) (task id: 22780837)
2017-10-29 07:16:03 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output':
"Created task: 22780839\nTask info:
https://koji.fedoraproject.org/koji/taskinfo?taskID=22780839\nWatching tasks (this may be
safely interrupted)...\n22780839 image (f27, Fedora-Cloud-Base-Vagrant-27,
fedora-cloud-base-vagrant.ks): free\n22780839 image (f27, Fedora-Cloud-Base-Vagrant-27,
fedora-cloud-base-vagrant.ks): free -> open
(buildhw-aarch64-02.arm.fedoraproject.org)\n 22780840 createImage (f27,
Fedora-Cloud-Base-Vagrant-27-20171029.0, fedora-cloud-base-vagrant.ks, x86_64): free\n
22780840 createImage (f27, Fedora-Cloud-Base-Vagrant-27-20171029.0,
fedora-cloud-base-vagrant.ks, x86_64): free -> open
(buildhw-07.phx2.fedoraproject.org)\n 22780840 createImage (f27,
Fedora-Cloud-Base-Vagrant-27-20171029.0, fedora-cloud-base-vagrant.ks, x86_64): open
(
buildhw-07.phx2.fedoraproject.org) -> FAILED: ApplianceError: Image status is FAILED:
Could not reach
https://kojipkgs.fedoraproject.org/pub/alt/relea
ses/27/Cloud/x86_64/os//images/boot.iso to fetch boot media: {'AppTime':
'D=1202', 'Content-Length': '250', 'X-Xss-Protection':
'1; mode=block', 'HTTP-Code': 404, 'X-Content-Type-Options':
'nosniff', 'Age': '7', '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':
'proxy01.phx2.fedoraproject.org', 'Connection': 'Keep-Alive',
'X-Varnish': '133391500 133891994', 'Via': '1.1 varnish
(Varnish/5.0)', 'Date': 'Sun, 29 Oct 2017 07:15:45 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\n22780839 image (f27,
Fedora-Cloud-Base-Vagrant-27, fedora-cloud-base-vagrant.ks): open
(
buildhw-aarch64-02.arm.fedoraproject.org) -> FAILED: ApplianceError: Image status is
FAILED: Could not reach
https://kojipkgs.fedoraprojec
t.org/pub/alt/releases/27/Cloud/x86_64/os//images/boot.iso to fetch boot media:
{'AppTime': 'D=1202', 'Content-Length': '250',
'X-Xss-Protection': '1; mode=block', 'HTTP-Code': 404,
'X-Content-Type-Options': 'nosniff', 'Age': '7',
'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':
'proxy01.phx2.fedoraproject.org', 'Connection': 'Keep-Alive',
'X-Varnish': '133391500 133891994', 'Via': '1.1 varnish
(Varnish/5.0)', 'Date': 'Sun, 29 Oct 2017 07:15:45 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\n22780839 image (f27,
Fedora-Cloud-Base-Vagrant-27, fedora-cloud-base-vagrant.ks) failed\n",
'retcode': 0, 'task_id': 22780839}
2017-10-29 07:16:04 [IMAGE_BUILD ] [INFO ] [DONE ] Creating
vagrant-libvirt-vagrant-virtualbox image (arches: x86_64, variant: CloudImages,
subvariant: Cloud_Base) (task id: 22780839)
2017-10-29 07:16:04 [INFO ] [DONE ] ---------- PHASE: IMAGE_BUILD ----------
2017-10-29 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-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:16:05 [INFO ] [DONE ] ---------- PHASE: CREATEISO ----------
2017-10-29 07:16:05 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'createiso', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:16:06 [INFO ] [BEGIN] ---------- PHASE: IMAGE_CHECKSUM ----------
2017-10-29 07:16:06 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'image_checksum',
'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:16:08 [INFO ] [DONE ] ---------- PHASE: IMAGE_CHECKSUM ----------
2017-10-29 07:16:08 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'image_checksum', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:16:09 [INFO ] [BEGIN] Writing composeinfo
2017-10-29 07:16:09 [INFO ] [DONE ] Writing composeinfo
2017-10-29 07:16:09 [INFO ] [BEGIN] ---------- PHASE: TEST ----------
2017-10-29 07:16:09 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'test', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:16:11 [INFO ] [BEGIN] Running repoclosure
2017-10-29 07:16:11 [INFO ] [DONE ] Running repoclosure
2017-10-29 07:16:11 [INFO ] [DONE ] ---------- PHASE: TEST ----------
2017-10-29 07:16:11 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'test', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:16:12 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'status-change', {'status': 'FINISHED', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171029.0/compose',
'compose_id': u'Fedora-Cloud-27-20171029.0'}
2017-10-29 07:16:14 [INFO ] Compose finished:
/mnt/koji/compose/Fedora-Cloud-27-20171029.0
real 0m56.542s
user 0m7.155s
sys 0m1.595s
cat: /mnt/koji/compose//latest-Fedora-27/COMPOSE_ID: No such file or directory
~