/tmp/CloudImageF25.HqhC3Z ~
Cloning into 'pungi-fedora'...
Switched to a new branch 'f25'
Branch f25 set up to track remote branch f25 from origin.
cat: /mnt/koji/compose//latest-Fedora-25/COMPOSE_ID: No such file or directory
Cloning into 'releng'...
/tmp/25.20170930.yxq5 /tmp/CloudImageF25.HqhC3Z/pungi-fedora
Cloning into 'fedora-comps'...
/tmp/25.20170930.yxq5/fedora-comps /tmp/25.20170930.yxq5
/tmp/CloudImageF25.HqhC3Z/pungi-fedora
./update-comps comps-f25.xml
Merging translations into comps-f25.xml.
CREATED comps-f25.xml
/tmp/25.20170930.yxq5 /tmp/CloudImageF25.HqhC3Z/pungi-fedora
/tmp/CloudImageF25.HqhC3Z/pungi-fedora
2017-09-30 07:15:16 [INFO ] Automatically setting 'supported' flag for a
Release Candidate (RC-20170930.0) compose.
2017-09-30 07:15:16 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'status-change', {'status': 'STARTED', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:15:18 [INFO ] Host:
compose-x86-01.phx2.fedoraproject.org
2017-09-30 07:15:18 [INFO ] Pungi version: 4.1.17
2017-09-30 07:15:18 [INFO ] User name: root
2017-09-30 07:15:18 [INFO ] Working directory: /tmp/CloudImageF25.HqhC3Z/pungi-fedora
2017-09-30 07:15:18 [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-20170930.0
--target-dir=/mnt/koji/compose/
2017-09-30 07:15:18 [INFO ] Compose top directory:
/mnt/koji/compose/Fedora-Cloud-25-20170930.0
2017-09-30 07:15:18 [DEBUG ] Writing variants file:
/mnt/koji/compose/Fedora-Cloud-25-20170930.0/work/global/variants.xml
2017-09-30 07:15:18 [DEBUG ] Exporting file
/tmp/CloudImageF25.HqhC3Z/pungi-fedora/variants-fedora.xml from current working
directory...
2017-09-30 07:15:18 [INFO ] Excluding variant Atomic: filtered by configuration.
2017-09-30 07:15:18 [INFO ] Excluding variant Docker: filtered by configuration.
2017-09-30 07:15:18 [INFO ] Excluding variant Everything: filtered by configuration.
2017-09-30 07:15:18 [INFO ] Excluding variant Labs: filtered by configuration.
2017-09-30 07:15:18 [INFO ] Excluding variant ostree: filtered by configuration.
2017-09-30 07:15:18 [INFO ] Excluding variant Server: filtered by configuration.
2017-09-30 07:15:18 [INFO ] Excluding variant Spins: filtered by configuration.
2017-09-30 07:15:18 [INFO ] Excluding variant Workstation: filtered by configuration.
2017-09-30 07:15:18 [INFO ] Excluding variant Cloud: filtered by configuration.
2017-09-30 07:15:18 [DEBUG ] Not a bootable product. Skipping buildinstall.
2017-09-30 07:15:18 [INFO ] Config section 'live_images' was not found.
Skipping.
2017-09-30 07:15:18 [INFO ] Config section 'live_media' was not found.
Skipping.
2017-09-30 07:15:18 [INFO ] Config section 'ostree' was not found. Skipping.
2017-09-30 07:15:18 [INFO ] Config section 'ostree_installer' was not found.
Skipping.
2017-09-30 07:15:18 [INFO ] Config section 'osbs' was not found. Skipping.
2017-09-30 07:15:18 [INFO ] [BEGIN] ---------- PHASE: INIT ----------
2017-09-30 07:15:18 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'init', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:15:20 [DEBUG ] Writing global comps file:
/mnt/koji/compose/Fedora-Cloud-25-20170930.0/work/global/comps/comps-global.xml
2017-09-30 07:15:20 [DEBUG ] Exporting file
/tmp/CloudImageF25.HqhC3Z/pungi-fedora/comps-f25.xml from current working directory...
2017-09-30 07:15:20 [DEBUG ] Writing comps file for arch 'x86_64':
/mnt/koji/compose/Fedora-Cloud-25-20170930.0/work/x86_64/comps/comps-x86_64.xml
2017-09-30 07:15:20 [INFO ] [BEGIN] Creating comps repo for arch 'x86_64'
2017-09-30 07:15:20 [INFO ] [DONE ] Creating comps repo for arch 'x86_64'
2017-09-30 07:15:20 [DEBUG ] Copying original comps file (arch: x86_64, variant:
CloudImages):
/mnt/koji/compose/Fedora-Cloud-25-20170930.0/work/x86_64/comps/comps-CloudImages.x86_64.xml
2017-09-30 07:15:20 [INFO ] [DONE ] ---------- PHASE: INIT ----------
2017-09-30 07:15:20 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'init', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:15:22 [WARNING ] [SKIP ] ---------- PHASE: PKGSET ----------
2017-09-30 07:15:22 [DEBUG ] Not a bootable product. Skipping buildinstall.
2017-09-30 07:15:22 [WARNING ] [SKIP ] ---------- PHASE: BUILDINSTALL ----------
2017-09-30 07:15:22 [WARNING ] [SKIP ] ---------- PHASE: GATHER ----------
2017-09-30 07:15:22 [INFO ] Writing RPM manifest:
/mnt/koji/compose/Fedora-Cloud-25-20170930.0/compose/metadata/rpms.json
2017-09-30 07:15:22 [WARNING ] [SKIP ] ---------- PHASE: EXTRA_FILES ----------
2017-09-30 07:15:22 [INFO ] [BEGIN] ---------- PHASE: CREATEREPO ----------
2017-09-30 07:15:22 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'createrepo', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:15:23 [INFO ] No product certificates specified
2017-09-30 07:15:24 [INFO ] [DONE ] ---------- PHASE: CREATEREPO ----------
2017-09-30 07:15:24 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'createrepo', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:15:25 [INFO ] Config section 'ostree' was not found. Skipping.
2017-09-30 07:15:25 [WARNING ] [SKIP ] ---------- PHASE: OSTREE ----------
2017-09-30 07:15:25 [WARNING ] [SKIP ] ---------- PHASE: PRODUCTIMG ----------
2017-09-30 07:15:25 [INFO ] [BEGIN] ---------- PHASE: CREATEISO ----------
2017-09-30 07:15:25 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'createiso', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:15:27 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'createiso-targets', {'compose_id': u'Fedora-Cloud-25-20170930.0',
'deliverables': [], 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose'}
2017-09-30 07:15:28 [INFO ] Config section 'live_images' was not found.
Skipping.
2017-09-30 07:15:28 [WARNING ] [SKIP ] ---------- PHASE: LIVE_IMAGES ----------
2017-09-30 07:15:28 [INFO ] [BEGIN] ---------- PHASE: IMAGE_BUILD ----------
2017-09-30 07:15:28 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'image_build', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:15:30 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating qcow2-raw-xz image
(arches: x86_64, variant: CloudImages, subvariant: Cloud_Base)
2017-09-30 07:15:30 [INFO ] Config section 'live_media' was not found.
Skipping.
2017-09-30 07:15:30 [WARNING ] [SKIP ] ---------- PHASE: LIVE_MEDIA ----------
2017-09-30 07:15:30 [INFO ] Config section 'ostree_installer' was not found.
Skipping.
2017-09-30 07:15:30 [WARNING ] [SKIP ] ---------- PHASE: OSTREE_INSTALLER ----------
2017-09-30 07:15:30 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating
vagrant-libvirt-vagrant-virtualbox image (arches: x86_64, variant: CloudImages,
subvariant: Cloud_Base)
2017-09-30 07:15:30 [INFO ] Config section 'osbs' was not found. Skipping.
2017-09-30 07:15:30 [WARNING ] [SKIP ] ---------- PHASE: OSBS ----------
2017-09-30 07:15:30 [IMAGE_BUILD ] [INFO ] Writing image-build config for
CloudImages.x86_64 into
/mnt/koji/compose/Fedora-Cloud-25-20170930.0/work/image-build/CloudImages/qcow2-raw-xz_Fedora-Cloud-Base.cfg
2017-09-30 07:15:30 [IMAGE_BUILD ] [INFO ] Writing image-build config for
CloudImages.x86_64 into
/mnt/koji/compose/Fedora-Cloud-25-20170930.0/work/image-build/CloudImages/vagrant-libvirt-vagrant-virtualbox_Fedora-Cloud-Base-Vagrant.cfg
2017-09-30 07:22:40 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output':
'Created task: 22153699\nTask info:
https://koji.fedoraproject.org/koji/taskinfo?taskID=22153699\nWatching tasks (this may be
safely interrupted)...\n22153699 image (f25, Fedora-Cloud-Base-25, fedora-cloud-base.ks):
free\n22153699 image (f25, Fedora-Cloud-Base-25, fedora-cloud-base.ks): free -> open
(buildhw-10.phx2.fedoraproject.org)\n 22153700 createImage (f25,
Fedora-Cloud-Base-25-20170930.0, fedora-cloud-base.ks, x86_64): free\n 22153700
createImage (f25, Fedora-Cloud-Base-25-20170930.0, fedora-cloud-base.ks, x86_64): free
-> open (buildhw-05.phx2.fedoraproject.org)\n 22153700 createImage (f25,
Fedora-Cloud-Base-25-20170930.0, fedora-cloud-base.ks, x86_64): open
(
buildhw-05.phx2.fedoraproject.org) -> closed\n 0 free 1 open 1 done 0 failed\n
22153766 tagBuild (noarch): free\n 22153766 tagBuild (noarch): free -> closed\n 0
free 1 open 2 done 0 failed\n22153699 image (f25, Fedora-Cloud-Bas
e-25, fedora-cloud-base.ks): open (
buildhw-10.phx2.fedoraproject.org) -> closed\n 0
free 0 open 3 done 0 failed\n\n22153699 image (f25, Fedora-Cloud-Base-25,
fedora-cloud-base.ks) completed successfully\n', 'retcode': 0,
'task_id': 22153699}
2017-09-30 07:22:40 [IMAGE_BUILD ] [INFO ] Hardlinking
/mnt/koji/packages/Fedora-Cloud-Base/25/20170930.0/images/Fedora-Cloud-Base-25-20170930.0.x86_64.qcow2
to
/mnt/koji/compose/Fedora-Cloud-25-20170930.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-25-20170930.0.x86_64.qcow2
2017-09-30 07:22:40 [IMAGE_BUILD ] [INFO ] Hardlinking
/mnt/koji/packages/Fedora-Cloud-Base/25/20170930.0/images/Fedora-Cloud-Base-25-20170930.0.x86_64.raw.xz
to
/mnt/koji/compose/Fedora-Cloud-25-20170930.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-25-20170930.0.x86_64.raw.xz
2017-09-30 07:22:40 [IMAGE_BUILD ] [INFO ] [DONE ] Creating qcow2-raw-xz image
(arches: x86_64, variant: CloudImages, subvariant: Cloud_Base) (task id: 22153699)
2017-09-30 07:24:56 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output':
'Created task: 22153701\nTask info:
https://koji.fedoraproject.org/koji/taskinfo?taskID=22153701\nWatching tasks (this may be
safely interrupted)...\n22153701 image (f25, Fedora-Cloud-Base-Vagrant-25,
fedora-cloud-base-vagrant.ks): free\n22153701 image (f25, Fedora-Cloud-Base-Vagrant-25,
fedora-cloud-base-vagrant.ks): free -> open (buildhw-04.phx2.fedoraproject.org)\n
22153702 createImage (f25, Fedora-Cloud-Base-Vagrant-25-20170930.0,
fedora-cloud-base-vagrant.ks, x86_64): free\n 22153702 createImage (f25,
Fedora-Cloud-Base-Vagrant-25-20170930.0, fedora-cloud-base-vagrant.ks, x86_64): free ->
open (buildhw-09.phx2.fedoraproject.org)\n 22153702 createImage (f25,
Fedora-Cloud-Base-Vagrant-25-20170930.0, fedora-cloud-base-vagrant.ks, x86_64): open
(
buildhw-09.phx2.fedoraproject.org) -> closed\n 0 free 1 open 1 done 0 failed\n
22153795 tagBuild (noarch): open (buildhw-03.phx2.fedoraproject.org)\n 2
2153795 tagBuild (noarch): open (
buildhw-03.phx2.fedoraproject.org) -> closed\n 0
free 1 open 2 done 0 failed\n22153701 image (f25, Fedora-Cloud-Base-Vagrant-25,
fedora-cloud-base-vagrant.ks): open (
buildhw-04.phx2.fedoraproject.org) -> closed\n 0
free 0 open 3 done 0 failed\n\n22153701 image (f25, Fedora-Cloud-Base-Vagrant-25,
fedora-cloud-base-vagrant.ks) completed successfully\n', 'retcode': 0,
'task_id': 22153701}
2017-09-30 07:24:56 [IMAGE_BUILD ] [INFO ] Hardlinking
/mnt/koji/packages/Fedora-Cloud-Base-Vagrant/25/20170930.0/images/Fedora-Cloud-Base-Vagrant-25-20170930.0.x86_64.vagrant-virtualbox.box
to
/mnt/koji/compose/Fedora-Cloud-25-20170930.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-Vagrant-25-20170930.0.x86_64.vagrant-virtualbox.box
2017-09-30 07:24:56 [IMAGE_BUILD ] [INFO ] Hardlinking
/mnt/koji/packages/Fedora-Cloud-Base-Vagrant/25/20170930.0/images/Fedora-Cloud-Base-Vagrant-25-20170930.0.x86_64.vagrant-libvirt.box
to
/mnt/koji/compose/Fedora-Cloud-25-20170930.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-Vagrant-25-20170930.0.x86_64.vagrant-libvirt.box
2017-09-30 07:24:56 [IMAGE_BUILD ] [INFO ] [DONE ] Creating
vagrant-libvirt-vagrant-virtualbox image (arches: x86_64, variant: CloudImages,
subvariant: Cloud_Base) (task id: 22153701)
2017-09-30 07:24:56 [INFO ] [DONE ] ---------- PHASE: IMAGE_BUILD ----------
2017-09-30 07:24:56 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'image_build', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:24:58 [INFO ] [DONE ] ---------- PHASE: CREATEISO ----------
2017-09-30 07:24:58 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'createiso', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:24:59 [INFO ] [BEGIN] ---------- PHASE: IMAGE_CHECKSUM ----------
2017-09-30 07:24:59 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'image_checksum',
'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:25:09 [INFO ] [DONE ] ---------- PHASE: IMAGE_CHECKSUM ----------
2017-09-30 07:25:09 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'image_checksum', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:25:12 [INFO ] [BEGIN] Writing composeinfo
2017-09-30 07:25:12 [INFO ] [DONE ] Writing composeinfo
2017-09-30 07:25:12 [INFO ] [BEGIN] ---------- PHASE: TEST ----------
2017-09-30 07:25:12 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'test', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:25:13 [INFO ] [BEGIN] Running repoclosure
2017-09-30 07:25:13 [INFO ] [DONE ] Running repoclosure
2017-09-30 07:25:13 [INFO ] [DONE ] ---------- PHASE: TEST ----------
2017-09-30 07:25:13 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'test', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:25:15 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'status-change', {'status': 'FINISHED', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170930.0/compose',
'compose_id': u'Fedora-Cloud-25-20170930.0'}
2017-09-30 07:25:16 [INFO ] Compose finished:
/mnt/koji/compose/Fedora-Cloud-25-20170930.0
real 10m0.220s
user 0m13.069s
sys 0m2.142s
cat: /mnt/koji/compose//latest-Fedora-25/COMPOSE_ID: No such file or directory
~