/tmp/CloudImageF27.tNzhDx ~ Cloning into 'pungi-fedora'... Switched to a new branch 'f27' Branch f27 set up to track remote branch f27 from origin. Cloning into 'releng'... /tmp/27.20171231.EwIS /tmp/CloudImageF27.tNzhDx/pungi-fedora Cloning into 'fedora-comps'... /tmp/27.20171231.EwIS/fedora-comps /tmp/27.20171231.EwIS /tmp/CloudImageF27.tNzhDx/pungi-fedora ./update-comps comps-f27.xml Merging translations into comps-f27.xml. CREATED comps-f27.xml /tmp/27.20171231.EwIS /tmp/CloudImageF27.tNzhDx/pungi-fedora /tmp/CloudImageF27.tNzhDx/pungi-fedora 2017-12-31 07:15:19 [INFO ] Automatically setting 'supported' flag for a Release Candidate (RC-20171231.0) compose. 2017-12-31 07:15:19 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'status-change', {'status': 'STARTED', 'release_type': 'ga', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:15:21 [INFO ] Host: compose-x86-01.phx2.fedoraproject.org 2017-12-31 07:15:21 [INFO ] Pungi version: 4.1.20 2017-12-31 07:15:21 [INFO ] User name: root 2017-12-31 07:15:21 [INFO ] Working directory: /tmp/CloudImageF27.tNzhDx/pungi-fedora 2017-12-31 07:15:21 [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-20171231.0 --target-dir=/mnt/koji/compose/ 2017-12-31 07:15:21 [INFO ] Compose top directory: /mnt/koji/compose/Fedora-Cloud-27-20171231.0 2017-12-31 07:15:21 [INFO ] Current timezone offset: +00:00 2017-12-31 07:15:21 [DEBUG ] Writing variants file: /mnt/koji/compose/Fedora-Cloud-27-20171231.0/work/global/variants.xml 2017-12-31 07:15:21 [DEBUG ] Exporting file /tmp/CloudImageF27.tNzhDx/pungi-fedora/variants-fedora.xml from current working directory... 2017-12-31 07:15:21 [INFO ] Excluding variant Atomic: filtered by configuration. 2017-12-31 07:15:21 [INFO ] Excluding variant Docker: filtered by configuration. 2017-12-31 07:15:21 [INFO ] Excluding variant Everything: filtered by configuration. 2017-12-31 07:15:21 [INFO ] Excluding variant Labs: filtered by configuration. 2017-12-31 07:15:21 [INFO ] Excluding variant ostree: filtered by configuration. 2017-12-31 07:15:21 [INFO ] Excluding variant Server: filtered by configuration. 2017-12-31 07:15:21 [INFO ] Excluding variant Spins: filtered by configuration. 2017-12-31 07:15:21 [INFO ] Excluding variant Workstation: filtered by configuration. 2017-12-31 07:15:21 [INFO ] Excluding variant WorkstationOstree: filtered by configuration. 2017-12-31 07:15:21 [INFO ] Excluding variant Cloud: filtered by configuration. 2017-12-31 07:15:21 [DEBUG ] Not a bootable product. Skipping buildinstall. 2017-12-31 07:15:21 [INFO ] Config section 'live_images' was not found. Skipping. 2017-12-31 07:15:21 [INFO ] Config section 'live_media' was not found. Skipping. 2017-12-31 07:15:21 [INFO ] Config section 'ostree' was not found. Skipping. 2017-12-31 07:15:21 [INFO ] Config section 'ostree_installer' was not found. Skipping. 2017-12-31 07:15:21 [INFO ] Config section 'osbs' was not found. Skipping. 2017-12-31 07:15:21 [INFO ] [BEGIN] ---------- PHASE: INIT ---------- 2017-12-31 07:15:21 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-start', {'release_type': 'ga', 'phase_name': 'init', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:15:23 [DEBUG ] Writing global comps file: /mnt/koji/compose/Fedora-Cloud-27-20171231.0/work/global/comps/comps-global.xml 2017-12-31 07:15:23 [DEBUG ] Exporting file /tmp/CloudImageF27.tNzhDx/pungi-fedora/comps-f27.xml from current working directory... 2017-12-31 07:15:23 [DEBUG ] Writing comps file for arch 'x86_64': /mnt/koji/compose/Fedora-Cloud-27-20171231.0/work/x86_64/comps/comps-x86_64.xml 2017-12-31 07:15:23 [INFO ] [BEGIN] Creating comps repo for arch 'x86_64' 2017-12-31 07:15:23 [INFO ] [DONE ] Creating comps repo for arch 'x86_64' 2017-12-31 07:15:23 [DEBUG ] Copying original comps file (arch: x86_64, variant: CloudImages): /mnt/koji/compose/Fedora-Cloud-27-20171231.0/work/x86_64/comps/comps-CloudImages.x86_64.xml 2017-12-31 07:15:23 [INFO ] [DONE ] ---------- PHASE: INIT ---------- 2017-12-31 07:15:23 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-stop', {'release_type': 'ga', 'phase_name': 'init', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:15:25 [WARNING ] [SKIP ] ---------- PHASE: PKGSET ---------- 2017-12-31 07:15:25 [DEBUG ] Not a bootable product. Skipping buildinstall. 2017-12-31 07:15:25 [WARNING ] [SKIP ] ---------- PHASE: BUILDINSTALL ---------- 2017-12-31 07:15:25 [WARNING ] [SKIP ] ---------- PHASE: GATHER ---------- 2017-12-31 07:15:25 [INFO ] Writing RPM manifest: /mnt/koji/compose/Fedora-Cloud-27-20171231.0/compose/metadata/rpms.json 2017-12-31 07:15:25 [WARNING ] [SKIP ] ---------- PHASE: EXTRA_FILES ---------- 2017-12-31 07:15:25 [INFO ] [BEGIN] ---------- PHASE: CREATEREPO ---------- 2017-12-31 07:15:25 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-start', {'release_type': 'ga', 'phase_name': 'createrepo', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:15:26 [INFO ] No product certificates specified 2017-12-31 07:15:27 [INFO ] [DONE ] ---------- PHASE: CREATEREPO ---------- 2017-12-31 07:15:27 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-stop', {'release_type': 'ga', 'phase_name': 'createrepo', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:15:29 [INFO ] Config section 'ostree' was not found. Skipping. 2017-12-31 07:15:29 [WARNING ] [SKIP ] ---------- PHASE: OSTREE ---------- 2017-12-31 07:15:29 [WARNING ] [SKIP ] ---------- PHASE: PRODUCTIMG ---------- 2017-12-31 07:15:29 [INFO ] Config section 'ostree_installer' was not found. Skipping. 2017-12-31 07:15:29 [WARNING ] [SKIP ] ---------- PHASE: OSTREE_INSTALLER ---------- 2017-12-31 07:15:29 [INFO ] [BEGIN] ---------- PHASE: CREATEISO ---------- 2017-12-31 07:15:29 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-start', {'release_type': 'ga', 'phase_name': 'createiso', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:15:30 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'createiso-targets', {'release_type': 'ga', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'deliverables': [], 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:15:32 [INFO ] Config section 'live_images' was not found. Skipping. 2017-12-31 07:15:32 [WARNING ] [SKIP ] ---------- PHASE: LIVE_IMAGES ---------- 2017-12-31 07:15:32 [INFO ] [BEGIN] ---------- PHASE: IMAGE_BUILD ---------- 2017-12-31 07:15:32 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-start', {'release_type': 'ga', 'phase_name': 'image_build', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:15:34 [INFO ] Config section 'live_media' was not found. Skipping. 2017-12-31 07:15:34 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating image (formats: qcow2-raw-xz, arches: x86_64, variant: CloudImages, subvariant: Cloud_Base) 2017-12-31 07:15:34 [WARNING ] [SKIP ] ---------- PHASE: LIVE_MEDIA ---------- 2017-12-31 07:15:34 [IMAGE_BUILD ] [INFO ] [BEGIN] Creating image (formats: vagrant-libvirt-vagrant-virtualbox, arches: x86_64, variant: CloudImages, subvariant: Cloud_Base) 2017-12-31 07:15:34 [INFO ] Config section 'osbs' was not found. Skipping. 2017-12-31 07:15:34 [WARNING ] [SKIP ] ---------- PHASE: OSBS ---------- 2017-12-31 07:15:34 [IMAGE_BUILD ] [INFO ] Writing image-build config for CloudImages.x86_64 into /mnt/koji/compose/Fedora-Cloud-27-20171231.0/work/image-build/CloudImages/qcow2-raw-xz_Fedora-Cloud-Base_x86_64.cfg 2017-12-31 07:15:34 [IMAGE_BUILD ] [INFO ] Writing image-build config for CloudImages.x86_64 into /mnt/koji/compose/Fedora-Cloud-27-20171231.0/work/image-build/CloudImages/vagrant-libvirt-vagrant-virtualbox_Fedora-Cloud-Base-Vagrant_x86_64.cfg 2017-12-31 07:24:17 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output': 'Created task: 23953903\nTask info: https://koji.fedoraproject.org/koji/taskinfo?taskID=23953903%5CnWatching tasks (this may be safely interrupted)...\n23953903 image (f27, Fedora-Cloud-Base-27, fedora-cloud-base.ks): free\n23953903 image (f27, Fedora-Cloud-Base-27, fedora-cloud-base.ks): free -> open (buildhw-aarch64-02.arm.fedoraproject.org)\n 23953904 createImage (f27, Fedora-Cloud-Base-27-20171231.0, fedora-cloud-base.ks, x86_64): open (buildhw-08.phx2.fedoraproject.org)\n 23953904 createImage (f27, Fedora-Cloud-Base-27-20171231.0, fedora-cloud-base.ks, x86_64): open (buildhw-08.phx2.fedoraproject.org) -> closed\n 0 free 1 open 1 done 0 failed\n 23953967 tagBuild (noarch): closed\n23953903 image (f27, Fedora-Cloud-Base-27, fedora-cloud-base.ks): open (buildhw-aarch64-02.arm.fedoraproject.org) -> closed\n 0 free 0 open 3 done 0 failed\n\n23953903 image (f27, Fedora-Cloud-Base-27, fedora-clou d-base.ks) completed successfully\n', 'retcode': 0, 'task_id': 23953903} 2017-12-31 07:24:17 [IMAGE_BUILD ] [INFO ] Hardlinking /mnt/koji/packages/Fedora-Cloud-Base/27/20171231.0/images/Fedora-Cloud-Base-27-20171231.0.x86_64.qcow2 to /mnt/koji/compose/Fedora-Cloud-27-20171231.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-27-20171231.0.x86_64.qcow2 2017-12-31 07:24:17 [IMAGE_BUILD ] [INFO ] Hardlinking /mnt/koji/packages/Fedora-Cloud-Base/27/20171231.0/images/Fedora-Cloud-Base-27-20171231.0.x86_64.raw.xz to /mnt/koji/compose/Fedora-Cloud-27-20171231.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-27-20171231.0.x86_64.raw.xz 2017-12-31 07:24:17 [IMAGE_BUILD ] [INFO ] [DONE ] Creating image (formats: qcow2-raw-xz, arches: x86_64, variant: CloudImages, subvariant: Cloud_Base) (task id: 23953903) 2017-12-31 07:25:50 [IMAGE_BUILD ] [DEBUG ] build-image outputs: {'output': 'Created task: 23953905\nTask info: https://koji.fedoraproject.org/koji/taskinfo?taskID=23953905%5CnWatching tasks (this may be safely interrupted)...\n23953905 image (f27, Fedora-Cloud-Base-Vagrant-27, fedora-cloud-base-vagrant.ks): free\n23953905 image (f27, Fedora-Cloud-Base-Vagrant-27, fedora-cloud-base-vagrant.ks): free -> open (buildhw-aarch64-01.arm.fedoraproject.org)\n 23953906 createImage (f27, Fedora-Cloud-Base-Vagrant-27-20171231.0, fedora-cloud-base-vagrant.ks, x86_64): open (buildhw-04.phx2.fedoraproject.org)\n 23953906 createImage (f27, Fedora-Cloud-Base-Vagrant-27-20171231.0, fedora-cloud-base-vagrant.ks, x86_64): open (buildhw-04.phx2.fedoraproject.org) -> closed\n 0 free 1 open 1 done 0 failed\n 23953972 tagBuild (noarch): free\n 23953972 tagBuild (noarch): free -> closed\n 0 free 1 open 2 done 0 failed\n23953905 image (f27, Fedora-Cloud-Base-Vagrant-27, fedora-cloud-base-vagr ant.ks): open (buildhw-aarch64-01.arm.fedoraproject.org) -> closed\n 0 free 0 open 3 done 0 failed\n\n23953905 image (f27, Fedora-Cloud-Base-Vagrant-27, fedora-cloud-base-vagrant.ks) completed successfully\n', 'retcode': 0, 'task_id': 23953905} 2017-12-31 07:25:50 [IMAGE_BUILD ] [INFO ] Hardlinking /mnt/koji/packages/Fedora-Cloud-Base-Vagrant/27/20171231.0/images/Fedora-Cloud-Base-Vagrant-27-20171231.0.x86_64.vagrant-virtualbox.box to /mnt/koji/compose/Fedora-Cloud-27-20171231.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-Vagrant-27-20171231.0.x86_64.vagrant-virtualbox.box 2017-12-31 07:25:50 [IMAGE_BUILD ] [INFO ] Hardlinking /mnt/koji/packages/Fedora-Cloud-Base-Vagrant/27/20171231.0/images/Fedora-Cloud-Base-Vagrant-27-20171231.0.x86_64.vagrant-libvirt.box to /mnt/koji/compose/Fedora-Cloud-27-20171231.0/compose/CloudImages/x86_64/images/Fedora-Cloud-Base-Vagrant-27-20171231.0.x86_64.vagrant-libvirt.box 2017-12-31 07:25:50 [IMAGE_BUILD ] [INFO ] [DONE ] Creating image (formats: vagrant-libvirt-vagrant-virtualbox, arches: x86_64, variant: CloudImages, subvariant: Cloud_Base) (task id: 23953905) 2017-12-31 07:25:50 [INFO ] [DONE ] ---------- PHASE: IMAGE_BUILD ---------- 2017-12-31 07:25:50 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-stop', {'release_type': 'ga', 'phase_name': 'image_build', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:25:52 [INFO ] [DONE ] ---------- PHASE: CREATEISO ---------- 2017-12-31 07:25:52 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-stop', {'release_type': 'ga', 'phase_name': 'createiso', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:25:53 [INFO ] [BEGIN] ---------- PHASE: IMAGE_CHECKSUM ---------- 2017-12-31 07:25:53 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-start', {'release_type': 'ga', 'phase_name': 'image_checksum', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:26:01 [INFO ] [DONE ] ---------- PHASE: IMAGE_CHECKSUM ---------- 2017-12-31 07:26:01 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-stop', {'release_type': 'ga', 'phase_name': 'image_checksum', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:26:03 [INFO ] [BEGIN] Writing composeinfo 2017-12-31 07:26:03 [INFO ] [DONE ] Writing composeinfo 2017-12-31 07:26:03 [INFO ] [BEGIN] ---------- PHASE: TEST ---------- 2017-12-31 07:26:03 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-start', {'release_type': 'ga', 'phase_name': 'test', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:26:04 [INFO ] [BEGIN] Running repoclosure 2017-12-31 07:26:04 [INFO ] [DONE ] Running repoclosure 2017-12-31 07:26:04 [INFO ] [DONE ] ---------- PHASE: TEST ---------- 2017-12-31 07:26:04 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'phase-stop', {'release_type': 'ga', 'phase_name': 'test', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:26:06 [DEBUG ] Notification: '/usr/bin/pungi-fedmsg-notification' 'status-change', {'status': 'FINISHED', 'release_type': 'ga', 'compose_label': u'RC-20171231.0', 'compose_respin': 0, 'compose_date': u'20171231', 'release_version': '27', 'location': 'http://kojipkgs.fedoraproject.org/compose/Fedora-Cloud-27-20171231.0/compose', 'compose_type': u'production', 'release_is_layered': False, 'release_name': 'Fedora-Cloud', 'release_short': 'Fedora-Cloud', 'compose_id': u'Fedora-Cloud-27-20171231.0'} 2017-12-31 07:26:07 [INFO ] Compose finished: /mnt/koji/compose/Fedora-Cloud-27-20171231.0
real 10m48.947s user 0m14.522s sys 0m2.109s ~