/tmp/CloudImageF25.l4b6Au ~
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.20170901.D8he /tmp/CloudImageF25.l4b6Au/pungi-fedora
Cloning into 'fedora-comps'...
/tmp/25.20170901.D8he/fedora-comps /tmp/25.20170901.D8he
/tmp/CloudImageF25.l4b6Au/pungi-fedora
./update-comps comps-f25.xml
Merging translations into comps-f25.xml.
CREATED comps-f25.xml
/tmp/25.20170901.D8he /tmp/CloudImageF25.l4b6Au/pungi-fedora
/tmp/CloudImageF25.l4b6Au/pungi-fedora
2017-09-01 07:15:17 [INFO ] Automatically setting 'supported' flag for a
Release Candidate (RC-20170901.0) compose.
2017-09-01 07:15:17 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'status-change', {'status': 'STARTED', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:15:18 [INFO ] Host:
compose-x86-01.phx2.fedoraproject.org
2017-09-01 07:15:18 [INFO ] Pungi version: 4.1.17
2017-09-01 07:15:18 [INFO ] User name: root
2017-09-01 07:15:18 [INFO ] Working directory: /tmp/CloudImageF25.l4b6Au/pungi-fedora
2017-09-01 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-20170901.0
--target-dir=/mnt/koji/compose/
2017-09-01 07:15:18 [INFO ] Compose top directory:
/mnt/koji/compose/Fedora-Cloud-25-20170901.0
2017-09-01 07:15:18 [DEBUG ] Writing variants file:
/mnt/koji/compose/Fedora-Cloud-25-20170901.0/work/global/variants.xml
2017-09-01 07:15:18 [DEBUG ] Exporting file
/tmp/CloudImageF25.l4b6Au/pungi-fedora/variants-fedora.xml from current working
directory...
2017-09-01 07:15:19 [INFO ] Excluding variant Atomic: filtered by configuration.
2017-09-01 07:15:19 [INFO ] Excluding variant Docker: filtered by configuration.
2017-09-01 07:15:19 [INFO ] Excluding variant Everything: filtered by configuration.
2017-09-01 07:15:19 [INFO ] Excluding variant Labs: filtered by configuration.
2017-09-01 07:15:19 [INFO ] Excluding variant ostree: filtered by configuration.
2017-09-01 07:15:19 [INFO ] Excluding variant Server: filtered by configuration.
2017-09-01 07:15:19 [INFO ] Excluding variant Spins: filtered by configuration.
2017-09-01 07:15:19 [INFO ] Excluding variant Workstation: filtered by configuration.
2017-09-01 07:15:19 [INFO ] Excluding variant Cloud: filtered by configuration.
2017-09-01 07:15:19 [DEBUG ] Not a bootable product. Skipping buildinstall.
2017-09-01 07:15:19 [INFO ] Config section 'live_images' was not found.
Skipping.
2017-09-01 07:15:19 [INFO ] Config section 'live_media' was not found.
Skipping.
2017-09-01 07:15:19 [INFO ] Config section 'ostree' was not found. Skipping.
2017-09-01 07:15:19 [INFO ] Config section 'ostree_installer' was not found.
Skipping.
2017-09-01 07:15:19 [INFO ] Config section 'osbs' was not found. Skipping.
2017-09-01 07:15:19 [INFO ] [BEGIN] ---------- PHASE: INIT ----------
2017-09-01 07:15:19 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'init', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:15:21 [DEBUG ] Writing global comps file:
/mnt/koji/compose/Fedora-Cloud-25-20170901.0/work/global/comps/comps-global.xml
2017-09-01 07:15:21 [DEBUG ] Exporting file
/tmp/CloudImageF25.l4b6Au/pungi-fedora/comps-f25.xml from current working directory...
2017-09-01 07:15:21 [DEBUG ] Writing comps file for arch 'x86_64':
/mnt/koji/compose/Fedora-Cloud-25-20170901.0/work/x86_64/comps/comps-x86_64.xml
2017-09-01 07:15:21 [INFO ] [BEGIN] Creating comps repo for arch 'x86_64'
2017-09-01 07:15:24 [INFO ] [DONE ] Creating comps repo for arch 'x86_64'
2017-09-01 07:15:24 [DEBUG ] Copying original comps file (arch: x86_64, variant:
CloudImages):
/mnt/koji/compose/Fedora-Cloud-25-20170901.0/work/x86_64/comps/comps-CloudImages.x86_64.xml
2017-09-01 07:15:24 [INFO ] [DONE ] ---------- PHASE: INIT ----------
2017-09-01 07:15:24 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'init', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:15:26 [WARNING ] [SKIP ] ---------- PHASE: PKGSET ----------
2017-09-01 07:15:26 [DEBUG ] Not a bootable product. Skipping buildinstall.
2017-09-01 07:15:26 [WARNING ] [SKIP ] ---------- PHASE: BUILDINSTALL ----------
2017-09-01 07:15:26 [WARNING ] [SKIP ] ---------- PHASE: GATHER ----------
2017-09-01 07:15:26 [INFO ] Writing RPM manifest:
/mnt/koji/compose/Fedora-Cloud-25-20170901.0/compose/metadata/rpms.json
2017-09-01 07:15:26 [WARNING ] [SKIP ] ---------- PHASE: EXTRA_FILES ----------
2017-09-01 07:15:26 [INFO ] [BEGIN] ---------- PHASE: CREATEREPO ----------
2017-09-01 07:15:26 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'createrepo', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:15:28 [INFO ] No product certificates specified
2017-09-01 07:15:29 [INFO ] [DONE ] ---------- PHASE: CREATEREPO ----------
2017-09-01 07:15:29 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'createrepo', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:15:30 [INFO ] Config section 'ostree' was not found. Skipping.
2017-09-01 07:15:30 [WARNING ] [SKIP ] ---------- PHASE: OSTREE ----------
2017-09-01 07:15:30 [WARNING ] [SKIP ] ---------- PHASE: PRODUCTIMG ----------
2017-09-01 07:15:30 [INFO ] [BEGIN] ---------- PHASE: CREATEISO ----------
2017-09-01 07:15:30 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'createiso', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:15:32 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'createiso-targets', {'compose_id': u'Fedora-Cloud-25-20170901.0',
'deliverables': [], 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose'}
2017-09-01 07:15:34 [INFO ] Config section 'live_images' was not found.
Skipping.
2017-09-01 07:15:34 [WARNING ] [SKIP ] ---------- PHASE: LIVE_IMAGES ----------
2017-09-01 07:15:34 [INFO ] [BEGIN] ---------- PHASE: IMAGE_BUILD ----------
2017-09-01 07:15:34 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'image_build', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:15:36 [INFO ] Config section 'live_media' was not found.
Skipping.
2017-09-01 07:15:36 [WARNING ] [SKIP ] ---------- PHASE: LIVE_MEDIA ----------
2017-09-01 07:15:36 [INFO ] Config section 'ostree_installer' was not found.
Skipping.
2017-09-01 07:15:36 [WARNING ] [SKIP ] ---------- PHASE: OSTREE_INSTALLER ----------
2017-09-01 07:15:36 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating qcow2-raw-xz image
(arches: x86_64, variant: CloudImages, subvariant: Cloud_Base)
2017-09-01 07:15:36 [INFO ] Config section 'osbs' was not found. Skipping.
2017-09-01 07:15:36 [WARNING ] [SKIP ] ---------- PHASE: OSBS ----------
2017-09-01 07:15:36 [IMAGE_BUILD ] [INFO ] Writing image-build config for
CloudImages.x86_64 into
/mnt/koji/compose/Fedora-Cloud-25-20170901.0/work/image-build/CloudImages/qcow2-raw-xz_Fedora-Cloud-Base.cfg
2017-09-01 07:15:36 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating
vagrant-libvirt-vagrant-virtualbox image (arches: x86_64, variant: CloudImages,
subvariant: Cloud_Base)
2017-09-01 07:15:36 [IMAGE_BUILD ] [INFO ] Writing image-build config for
CloudImages.x86_64 into
/mnt/koji/compose/Fedora-Cloud-25-20170901.0/work/image-build/CloudImages/vagrant-libvirt-vagrant-virtualbox_Fedora-Cloud-Base-Vagrant.cfg
2017-09-01 07:37:58 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output':
'Created task: 21602136\nTask info:
https://koji.fedoraproject.org/koji/taskinfo?taskID=21602136\nWatching tasks (this may be
safely interrupted)...\n21602136 image (f25, Fedora-Cloud-Base-25, fedora-cloud-base.ks):
free\n21602136 image (f25, Fedora-Cloud-Base-25, fedora-cloud-base.ks): free -> open
(buildvm-ppc64-02.ppc.fedoraproject.org)\n 21602138 createImage (f25,
Fedora-Cloud-Base-25-20170901.0, fedora-cloud-base.ks, x86_64): open
(buildhw-06.phx2.fedoraproject.org)\n 21602138 createImage (f25,
Fedora-Cloud-Base-25-20170901.0, fedora-cloud-base.ks, x86_64): open
(
buildhw-06.phx2.fedoraproject.org) -> closed\n 0 free 1 open 1 done 0 failed\n
21602463 tagBuild (noarch): closed\n21602136 image (f25, Fedora-Cloud-Base-25,
fedora-cloud-base.ks): open (
buildvm-ppc64-02.ppc.fedoraproject.org) -> closed\n 0
free 0 open 3 done 0 failed\n\n21602136 image (f25, Fedora-Cloud-Base-25,
fedora-cloud-ba
se.ks) completed successfully\n', 'retcode': 0, 'task_id': 21602136}
2017-09-01 07:37:58 [IMAGE_BUILD ] [INFO ] Hardlinking
/mnt/koji/packages/Fedora-Cloud-Base/25/20170901.0/images/Fedora-Cloud-Base-25-20170901.0.x86_64.qcow2
to
/mnt/koji/compose/Fedora-Cloud-25-20170901.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-25-20170901.0.x86_64.qcow2
2017-09-01 07:37:58 [IMAGE_BUILD ] [INFO ] Hardlinking
/mnt/koji/packages/Fedora-Cloud-Base/25/20170901.0/images/Fedora-Cloud-Base-25-20170901.0.x86_64.raw.xz
to
/mnt/koji/compose/Fedora-Cloud-25-20170901.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-25-20170901.0.x86_64.raw.xz
2017-09-01 07:37:58 [IMAGE_BUILD ] [INFO ] [DONE ] Creating qcow2-raw-xz image
(arches: x86_64, variant: CloudImages, subvariant: Cloud_Base) (task id: 21602136)
2017-09-01 07:43:41 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output':
'Created task: 21602139\nTask info:
https://koji.fedoraproject.org/koji/taskinfo?taskID=21602139\nWatching tasks (this may be
safely interrupted)...\n21602139 image (f25, Fedora-Cloud-Base-Vagrant-25,
fedora-cloud-base-vagrant.ks): free\n21602139 image (f25, Fedora-Cloud-Base-Vagrant-25,
fedora-cloud-base-vagrant.ks): free -> open
(buildhw-aarch64-03.arm.fedoraproject.org)\n 21602141 createImage (f25,
Fedora-Cloud-Base-Vagrant-25-20170901.0, fedora-cloud-base-vagrant.ks, x86_64): open
(buildhw-07.phx2.fedoraproject.org)\n 21602141 createImage (f25,
Fedora-Cloud-Base-Vagrant-25-20170901.0, fedora-cloud-base-vagrant.ks, x86_64): open
(
buildhw-07.phx2.fedoraproject.org) -> closed\n 0 free 1 open 1 done 0 failed\n
21602494 tagBuild (noarch): closed\n21602139 image (f25, Fedora-Cloud-Base-Vagrant-25,
fedora-cloud-base-vagrant.ks): open (
buildhw-aarch64-03.arm.fedoraproject.org) ->
closed\n 0 free 0
open 3 done 0 failed\n\n21602139 image (f25, Fedora-Cloud-Base-Vagrant-25,
fedora-cloud-base-vagrant.ks) completed successfully\n', 'retcode': 0,
'task_id': 21602139}
2017-09-01 07:43:42 [IMAGE_BUILD ] [INFO ] Hardlinking
/mnt/koji/packages/Fedora-Cloud-Base-Vagrant/25/20170901.0/images/Fedora-Cloud-Base-Vagrant-25-20170901.0.x86_64.vagrant-virtualbox.box
to
/mnt/koji/compose/Fedora-Cloud-25-20170901.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-Vagrant-25-20170901.0.x86_64.vagrant-virtualbox.box
2017-09-01 07:43:42 [IMAGE_BUILD ] [INFO ] Hardlinking
/mnt/koji/packages/Fedora-Cloud-Base-Vagrant/25/20170901.0/images/Fedora-Cloud-Base-Vagrant-25-20170901.0.x86_64.vagrant-libvirt.box
to
/mnt/koji/compose/Fedora-Cloud-25-20170901.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-Vagrant-25-20170901.0.x86_64.vagrant-libvirt.box
2017-09-01 07:43:42 [IMAGE_BUILD ] [INFO ] [DONE ] Creating
vagrant-libvirt-vagrant-virtualbox image (arches: x86_64, variant: CloudImages,
subvariant: Cloud_Base) (task id: 21602139)
2017-09-01 07:43:42 [INFO ] [DONE ] ---------- PHASE: IMAGE_BUILD ----------
2017-09-01 07:43:42 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'image_build', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:43:43 [INFO ] [DONE ] ---------- PHASE: CREATEISO ----------
2017-09-01 07:43:43 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'createiso', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:43:45 [INFO ] [BEGIN] ---------- PHASE: IMAGE_CHECKSUM ----------
2017-09-01 07:43:45 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'image_checksum',
'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:44:07 [INFO ] [DONE ] ---------- PHASE: IMAGE_CHECKSUM ----------
2017-09-01 07:44:07 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'image_checksum', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:44:09 [INFO ] [BEGIN] Writing composeinfo
2017-09-01 07:44:09 [INFO ] [DONE ] Writing composeinfo
2017-09-01 07:44:09 [INFO ] [BEGIN] ---------- PHASE: TEST ----------
2017-09-01 07:44:09 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-start', {'phase_name': 'test', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:44:11 [INFO ] [BEGIN] Running repoclosure
2017-09-01 07:44:11 [INFO ] [DONE ] Running repoclosure
2017-09-01 07:44:11 [INFO ] [DONE ] ---------- PHASE: TEST ----------
2017-09-01 07:44:11 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'phase-stop', {'phase_name': 'test', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:44:13 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification'
'status-change', {'status': 'FINISHED', 'location':
'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-25-20170901.0/compose',
'compose_id': u'Fedora-Cloud-25-20170901.0'}
2017-09-01 07:44:15 [INFO ] Compose finished:
/mnt/koji/compose/Fedora-Cloud-25-20170901.0
real 28m59.181s
user 0m19.067s
sys 0m2.242s
cat: /mnt/koji/compose//latest-Fedora-25/COMPOSE_ID: No such file or directory
~