/tmp/CloudImageF27.E5MXIp ~
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.20171101.e3i9 /tmp/CloudImageF27.E5MXIp/pungi-fedora
Cloning into 'fedora-comps'...
/tmp/27.20171101.e3i9/fedora-comps /tmp/27.20171101.e3i9
/tmp/CloudImageF27.E5MXIp/pungi-fedora
./update-comps comps-f27.xml
Merging translations into comps-f27.xml.
CREATED comps-f27.xml
/tmp/27.20171101.e3i9 /tmp/CloudImageF27.E5MXIp/pungi-fedora
/tmp/CloudImageF27.E5MXIp/pungi-fedora
2017-11-01 07:15:18 [INFO ] Automatically setting 'supported' flag for a
Release Candidate (RC-20171101.0) compose.
2017-11-01 07:15:18 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'status-change', {'status': 'STARTED', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:15:20 [INFO ] Host:
compose-x86-01.phx2.fedoraproject.org
2017-11-01 07:15:20 [INFO ] Pungi version: 4.1.19
2017-11-01 07:15:20 [INFO ] User name: root
2017-11-01 07:15:20 [INFO ] Working directory: /tmp/CloudImageF27.E5MXIp/pungi-fedora
2017-11-01 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-20171101.0
--target-dir=/mnt/koji/compose/
2017-11-01 07:15:20 [INFO ] Compose top directory:
/mnt/koji/compose/Fedora-Cloud-27-20171101.0
2017-11-01 07:15:20 [INFO ] Current timezone offset: +00:00
2017-11-01 07:15:20 [DEBUG ] Writing variants file:
/mnt/koji/compose/Fedora-Cloud-27-20171101.0/work/global/variants.xml
2017-11-01 07:15:20 [DEBUG ] Exporting file
/tmp/CloudImageF27.E5MXIp/pungi-fedora/variants-fedora.xml from current working
directory...
2017-11-01 07:15:20 [INFO ] Excluding variant Atomic: filtered by configuration.
2017-11-01 07:15:20 [INFO ] Excluding variant Docker: filtered by configuration.
2017-11-01 07:15:20 [INFO ] Excluding variant Everything: filtered by configuration.
2017-11-01 07:15:20 [INFO ] Excluding variant Labs: filtered by configuration.
2017-11-01 07:15:20 [INFO ] Excluding variant ostree: filtered by configuration.
2017-11-01 07:15:20 [INFO ] Excluding variant Server: filtered by configuration.
2017-11-01 07:15:20 [INFO ] Excluding variant Spins: filtered by configuration.
2017-11-01 07:15:20 [INFO ] Excluding variant Workstation: filtered by configuration.
2017-11-01 07:15:20 [INFO ] Excluding variant WorkstationOstree: filtered by
configuration.
2017-11-01 07:15:20 [INFO ] Excluding variant Cloud: filtered by configuration.
2017-11-01 07:15:20 [DEBUG ] Not a bootable product. Skipping buildinstall.
2017-11-01 07:15:20 [INFO ] Config section 'live_images' was not found.
Skipping.
2017-11-01 07:15:20 [INFO ] Config section 'live_media' was not found.
Skipping.
2017-11-01 07:15:20 [INFO ] Config section 'ostree' was not found. Skipping.
2017-11-01 07:15:20 [INFO ] Config section 'ostree_installer' was not found.
Skipping.
2017-11-01 07:15:20 [INFO ] Config section 'osbs' was not found. Skipping.
2017-11-01 07:15:20 [INFO ] [BEGIN] ---------- PHASE: INIT ----------
2017-11-01 07:15:20 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'init', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:15:21 [DEBUG ] Writing global comps file:
/mnt/koji/compose/Fedora-Cloud-27-20171101.0/work/global/comps/comps-global.xml
2017-11-01 07:15:21 [DEBUG ] Exporting file
/tmp/CloudImageF27.E5MXIp/pungi-fedora/comps-f27.xml from current working directory...
2017-11-01 07:15:21 [DEBUG ] Writing comps file for arch 'x86_64':
/mnt/koji/compose/Fedora-Cloud-27-20171101.0/work/x86_64/comps/comps-x86_64.xml
2017-11-01 07:15:21 [INFO ] [BEGIN] Creating comps repo for arch 'x86_64'
2017-11-01 07:15:22 [INFO ] [DONE ] Creating comps repo for arch 'x86_64'
2017-11-01 07:15:22 [DEBUG ] Copying original comps file (arch: x86_64, variant:
CloudImages):
/mnt/koji/compose/Fedora-Cloud-27-20171101.0/work/x86_64/comps/comps-CloudImages.x86_64.xml
2017-11-01 07:15:22 [INFO ] [DONE ] ---------- PHASE: INIT ----------
2017-11-01 07:15:22 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'init', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:15:23 [WARNING ] [SKIP ] ---------- PHASE: PKGSET ----------
2017-11-01 07:15:23 [DEBUG ] Not a bootable product. Skipping buildinstall.
2017-11-01 07:15:23 [WARNING ] [SKIP ] ---------- PHASE: BUILDINSTALL ----------
2017-11-01 07:15:23 [WARNING ] [SKIP ] ---------- PHASE: GATHER ----------
2017-11-01 07:15:23 [INFO ] Writing RPM manifest:
/mnt/koji/compose/Fedora-Cloud-27-20171101.0/compose/metadata/rpms.json
2017-11-01 07:15:23 [WARNING ] [SKIP ] ---------- PHASE: EXTRA_FILES ----------
2017-11-01 07:15:23 [INFO ] [BEGIN] ---------- PHASE: CREATEREPO ----------
2017-11-01 07:15:23 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'createrepo', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:15:25 [INFO ] No product certificates specified
2017-11-01 07:15:26 [INFO ] [DONE ] ---------- PHASE: CREATEREPO ----------
2017-11-01 07:15:26 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'createrepo', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:15:27 [INFO ] Config section 'ostree' was not found. Skipping.
2017-11-01 07:15:27 [WARNING ] [SKIP ] ---------- PHASE: OSTREE ----------
2017-11-01 07:15:27 [WARNING ] [SKIP ] ---------- PHASE: PRODUCTIMG ----------
2017-11-01 07:15:27 [INFO ] [BEGIN] ---------- PHASE: CREATEISO ----------
2017-11-01 07:15:27 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'createiso', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:15:28 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'createiso-targets', {'compose_id': u'Fedora-Cloud-27-20171101.0',
'deliverables': [], 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose'}
2017-11-01 07:15:30 [INFO ] Config section 'live_images' was not found.
Skipping.
2017-11-01 07:15:30 [WARNING ] [SKIP ] ---------- PHASE: LIVE_IMAGES ----------
2017-11-01 07:15:30 [INFO ] [BEGIN] ---------- PHASE: IMAGE_BUILD ----------
2017-11-01 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-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:15:32 [INFO ] Config section 'live_media' was not found.
Skipping.
2017-11-01 07:15:32 [WARNING ] [SKIP ] ---------- PHASE: LIVE_MEDIA ----------
2017-11-01 07:15:32 [INFO ] Config section 'ostree_installer' was not found.
Skipping.
2017-11-01 07:15:32 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating qcow2-raw-xz image
(arches: x86_64, variant: CloudImages, subvariant: Cloud_Base)
2017-11-01 07:15:32 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating
vagrant-libvirt-vagrant-virtualbox image (arches: x86_64, variant: CloudImages,
subvariant: Cloud_Base)
2017-11-01 07:15:32 [WARNING ] [SKIP ] ---------- PHASE: OSTREE_INSTALLER ----------
2017-11-01 07:15:32 [INFO ] Config section 'osbs' was not found. Skipping.
2017-11-01 07:15:32 [WARNING ] [SKIP ] ---------- PHASE: OSBS ----------
2017-11-01 07:15:32 [IMAGE_BUILD ] [INFO ] Writing image-build config for
CloudImages.x86_64 into
/mnt/koji/compose/Fedora-Cloud-27-20171101.0/work/image-build/CloudImages/qcow2-raw-xz_Fedora-Cloud-Base_x86_64.cfg
2017-11-01 07:15:32 [IMAGE_BUILD ] [INFO ] Writing image-build config for
CloudImages.x86_64 into
/mnt/koji/compose/Fedora-Cloud-27-20171101.0/work/image-build/CloudImages/vagrant-libvirt-vagrant-virtualbox_Fedora-Cloud-Base-Vagrant_x86_64.cfg
2017-11-01 07:15:48 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output':
"Created task: 22837721\nTask info:
https://koji.fedoraproject.org/koji/taskinfo?taskID=22837721\nWatching tasks (this may be
safely interrupted)...\n22837721 image (f27, Fedora-Cloud-Base-27, fedora-cloud-base.ks):
free\n22837721 image (f27, Fedora-Cloud-Base-27, fedora-cloud-base.ks): free -> open
(buildhw-09.phx2.fedoraproject.org)\n 22837722 createImage (f27,
Fedora-Cloud-Base-27-20171101.0, fedora-cloud-base.ks, x86_64): open
(buildhw-02.phx2.fedoraproject.org)\n22837721 image (f27, Fedora-Cloud-Base-27,
fedora-cloud-base.ks): open (
buildhw-09.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=3107', 'Content-Length':
'250', 'X-Xss-Protection': '1; mode=block', 'HTTP-Code':
404, 'X-Content-Type-Options': 'nosniff', 'Age': '0',
'Strict-T
ransport-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': '153433033', 'Via': '1.1 varnish
(Varnish/5.0)', 'Date': 'Wed, 01 Nov 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\n 22837722 createImage (f27,
Fedora-Cloud-Base-27-20171101.0, fedora-cloud-base.ks, x86_64): open
(
buildhw-02.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=3107', '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': '153433033', 'Via': '1.1
varnish (Varnish/5.0)', 'Date': 'Wed, 01 Nov 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\n22837721 image (f27,
Fedora-Cloud-Base-27, fedora-cloud-base.ks) failed\n", 'retcode': 0,
'task_id': 22837721}
2017-11-01 07:15:48 [IMAGE_BUILD ] [INFO ] [DONE ] Creating qcow2-raw-xz image
(arches: x86_64, variant: CloudImages, subvariant: Cloud_Base) (task id: 22837721)
2017-11-01 07:16:03 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output':
"Created task: 22837723\nTask info:
https://koji.fedoraproject.org/koji/taskinfo?taskID=22837723\nWatching tasks (this may be
safely interrupted)...\n22837723 image (f27, Fedora-Cloud-Base-Vagrant-27,
fedora-cloud-base-vagrant.ks): free\n22837723 image (f27, Fedora-Cloud-Base-Vagrant-27,
fedora-cloud-base-vagrant.ks): free -> open (buildhw-09.phx2.fedoraproject.org)\n
22837724 createImage (f27, Fedora-Cloud-Base-Vagrant-27-20171101.0,
fedora-cloud-base-vagrant.ks, x86_64): open (buildhw-09.phx2.fedoraproject.org)\n
22837724 createImage (f27, Fedora-Cloud-Base-Vagrant-27-20171101.0,
fedora-cloud-base-vagrant.ks, x86_64): open (
buildhw-09.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=12151', 'Content-Length':
'250', 'X-Xss-Protection': '
1; mode=block', 'HTTP-Code': 404, 'X-Content-Type-Options':
'nosniff', 'Age': '3', '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': '153586711 153433034', 'Via': '1.1 varnish
(Varnish/5.0)', 'Date': 'Wed, 01 Nov 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\n22837723 image (f27,
Fedora-Cloud-Base-Vagrant-27, fedora-cloud-base-vagrant.ks): open
(
buildhw-09.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=12151', 'Content-Length':
'250', 'X-Xss-P
rotection': '1; mode=block', 'HTTP-Code': 404,
'X-Content-Type-Options': 'nosniff', 'Age': '3',
'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': '153586711 153433034', 'Via': '1.1 varnish
(Varnish/5.0)', 'Date': 'Wed, 01 Nov 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\n22837723 image (f27,
Fedora-Cloud-Base-Vagrant-27, fedora-cloud-base-vagrant.ks) failed\n",
'retcode': 0, 'task_id': 22837723}
2017-11-01 07:16:03 [IMAGE_BUILD ] [INFO ] [DONE ] Creating
vagrant-libvirt-vagrant-virtualbox image (arches: x86_64, variant: CloudImages,
subvariant: Cloud_Base) (task id: 22837723)
2017-11-01 07:16:03 [INFO ] [DONE ] ---------- PHASE: IMAGE_BUILD ----------
2017-11-01 07:16:03 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'image_build', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:16:05 [INFO ] [DONE ] ---------- PHASE: CREATEISO ----------
2017-11-01 07:16:05 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'createiso', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:16:06 [INFO ] [BEGIN] ---------- PHASE: IMAGE_CHECKSUM ----------
2017-11-01 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-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:16:07 [INFO ] [DONE ] ---------- PHASE: IMAGE_CHECKSUM ----------
2017-11-01 07:16:07 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'image_checksum', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:16:09 [INFO ] [BEGIN] Writing composeinfo
2017-11-01 07:16:09 [INFO ] [DONE ] Writing composeinfo
2017-11-01 07:16:09 [INFO ] [BEGIN] ---------- PHASE: TEST ----------
2017-11-01 07:16:09 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'test', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:16:10 [INFO ] [BEGIN] Running repoclosure
2017-11-01 07:16:10 [INFO ] [DONE ] Running repoclosure
2017-11-01 07:16:10 [INFO ] [DONE ] ---------- PHASE: TEST ----------
2017-11-01 07:16:10 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'test', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:16:12 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'status-change', {'status': 'FINISHED', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171101.0/compose',
'compose_id': u'Fedora-Cloud-27-20171101.0'}
2017-11-01 07:16:13 [INFO ] Compose finished:
/mnt/koji/compose/Fedora-Cloud-27-20171101.0
real 0m56.094s
user 0m7.166s
sys 0m1.488s
cat: /mnt/koji/compose//latest-Fedora-27/COMPOSE_ID: No such file or directory
~