Attachment 907209 Details for Bug 1107667 – File: program.log

File: program.log

program.log (text/plain), 80.58 KB, created by Radek Vykydal on 2014-06-10 12:36:22 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Radek Vykydal

Created: 2014-06-10 12:36:22 UTC

Size: 80.58 KB

patch

obsolete

>12:30:33,989 INFO program: Running... udevadm trigger --action=change --subsystem-match=block
>12:30:34,025 DEBUG program: Return code: 0
>12:30:34,026 INFO program: Running... udevadm settle --timeout=300
>12:30:34,665 DEBUG program: Return code: 0
>12:30:34,744 INFO program: Running... modprobe fcoe
>12:30:34,920 DEBUG program: Return code: 0
>12:30:34,921 INFO program: Running... /usr/libexec/fcoe/fcoe_edd.sh -i
>12:30:34,951 INFO program: No FCoE boot disk information is found in EDD!
>12:30:34,952 DEBUG program: Return code: 1
>12:30:34,961 INFO program: Running... loadkeys us
>12:30:35,117 DEBUG program: Return code: 0
>12:30:35,118 INFO program: Running... loadkeys us
>12:30:35,232 DEBUG program: Return code: 0
>12:30:37,271 INFO program: Running... metacity --display :1 --sm-disable
>12:30:37,276 INFO program: Running... spice-vdagent
>12:30:37,343 DEBUG program: Return code: 0
>12:30:40,096 INFO program: Running... hwclock --hctosys --localtime
>12:30:41,002 DEBUG program: Return code: 0
>12:30:41,003 INFO program: Running... udevadm settle --timeout=300
>12:30:41,046 DEBUG program: Return code: 0
>12:30:41,047 INFO program: Running... systemctl start chronyd.service
>12:30:41,148 DEBUG program: Return code: 0
>12:30:41,151 INFO program: Running... mpathconf --user_friendly_names y --with_multipathd y
>12:30:41,307 DEBUG program: Return code: 0
>12:30:41,958 INFO program: Running... udevadm settle --timeout=300
>12:30:42,112 DEBUG program: Return code: 0
>12:30:42,254 INFO program: Running... multipath -c /dev/sdb
>12:30:42,295 DEBUG program: Return code: 1
>12:30:42,352 INFO program: Running... multipath -c /dev/sdc
>12:30:42,388 DEBUG program: Return code: 1
>12:30:42,441 INFO program: Running... multipath -c /dev/sdd
>12:30:42,475 DEBUG program: Return code: 1
>12:30:42,541 INFO program: Running... multipath -c /dev/sde
>12:30:42,579 DEBUG program: Return code: 1
>12:30:42,644 INFO program: Running... multipath -c /dev/sda
>12:30:42,683 INFO program: /dev/sda is not a valid multipath device path
>12:30:42,684 DEBUG program: Return code: 1
>12:30:43,040 INFO program: Running... dumpe2fs -h /dev/sda1
>12:30:43,114 INFO program: dumpe2fs 1.42.10 (18-May-2014)
>12:30:43,115 INFO program: Filesystem volume name:   <none>
>12:30:43,115 INFO program: Last mounted on:          /mnt/sysimage/boot
>12:30:43,116 INFO program: Filesystem UUID:          96101960-0d9e-4d10-a62d-7cd896920ce6
>12:30:43,116 INFO program: Filesystem magic number:  0xEF53
>12:30:43,116 INFO program: Filesystem revision #:    1 (dynamic)
>12:30:43,116 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype extent flex_bg sparse_super huge_file uninit_bg dir_nlink extra_isize
>12:30:43,117 INFO program: Filesystem flags:         signed_directory_hash 
>12:30:43,117 INFO program: Default mount options:    user_xattr acl
>12:30:43,118 INFO program: Filesystem state:         clean
>12:30:43,118 INFO program: Errors behavior:          Continue
>12:30:43,118 INFO program: Filesystem OS type:       Linux
>12:30:43,118 INFO program: Inode count:              128016
>12:30:43,119 INFO program: Block count:              512000
>12:30:43,119 INFO program: Reserved block count:     25600
>12:30:43,119 INFO program: Free blocks:              450837
>12:30:43,120 INFO program: Free inodes:              127943
>12:30:43,120 INFO program: First block:              1
>12:30:43,120 INFO program: Block size:               1024
>12:30:43,121 INFO program: Fragment size:            1024
>12:30:43,121 INFO program: Reserved GDT blocks:      256
>12:30:43,121 INFO program: Blocks per group:         8192
>12:30:43,121 INFO program: Fragments per group:      8192
>12:30:43,122 INFO program: Inodes per group:         2032
>12:30:43,122 INFO program: Inode blocks per group:   254
>12:30:43,122 INFO program: Flex block group size:    16
>12:30:43,123 INFO program: Filesystem created:       Tue Jun 10 09:36:15 2014
>12:30:43,123 INFO program: Last mount time:          Tue Jun 10 11:39:10 2014
>12:30:43,123 INFO program: Last write time:          Tue Jun 10 12:21:52 2014
>12:30:43,124 INFO program: Mount count:              2
>12:30:43,124 INFO program: Maximum mount count:      -1
>12:30:43,124 INFO program: Last checked:             Tue Jun 10 09:36:15 2014
>12:30:43,124 INFO program: Check interval:           0 (<none>)
>12:30:43,125 INFO program: Lifetime writes:          58 MB
>12:30:43,125 INFO program: Reserved blocks uid:      0 (user root)
>12:30:43,125 INFO program: Reserved blocks gid:      0 (group root)
>12:30:43,126 INFO program: First inode:              11
>12:30:43,126 INFO program: Inode size:	          128
>12:30:43,126 INFO program: Journal inode:            8
>12:30:43,127 INFO program: Default directory hash:   half_md4
>12:30:43,127 INFO program: Directory Hash Seed:      3d2dc291-5af9-4aa3-9423-f0440f5425ba
>12:30:43,127 INFO program: Journal backup:           inode blocks
>12:30:43,127 INFO program: Journal features:         (none)
>12:30:43,128 INFO program: Journal size:             8M
>12:30:43,128 INFO program: Journal length:           8192
>12:30:43,128 INFO program: Journal sequence:         0x00000015
>12:30:43,129 INFO program: Journal start:            0
>12:30:43,129 INFO program: 
>12:30:43,129 DEBUG program: Return code: 0
>12:30:43,130 INFO program: Running... resize2fs -P /dev/sda1
>12:30:43,170 INFO program: resize2fs 1.42.10 (18-May-2014)
>12:30:43,171 INFO program: Estimated minimum size of the filesystem: 82147
>12:30:43,171 DEBUG program: Return code: 0
>12:30:43,380 INFO program: Running... lvm pvs --unit=k --nosuffix --nameprefixes --unquoted --noheadings -opv_name,pv_uuid,pe_start,vg_name,vg_uuid,vg_size,vg_free,vg_extent_size,vg_extent_count,vg_free_count,pv_count --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] } global {locking_type=4} 
>12:30:43,446 INFO program:   LVM2_PV_NAME=/dev/sda2 LVM2_PV_UUID=5QbQeK-umTU-mceM-qGzv-N74Q-u2ce-t8y25Z LVM2_PE_START=1024.00 LVM2_VG_NAME=fedora_gasoline LVM2_VG_UUID=big1lV-rp2B-Kqg2-DZEg-XBWc-py3d-p3g659 LVM2_VG_SIZE=487870464.00 LVM2_VG_FREE=65536.00 LVM2_VG_EXTENT_SIZE=4096.00 LVM2_VG_EXTENT_COUNT=119109 LVM2_VG_FREE_COUNT=16 LVM2_PV_COUNT=1
>12:30:43,448 DEBUG program: Return code: 0
>12:30:43,494 INFO program: Running... lvm lvs -a --unit k --nosuffix --nameprefixes --unquoted --noheadings -ovg_name,lv_name,lv_uuid,lv_size,lv_attr,segtype --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] } global {locking_type=4} 
>12:30:43,553 INFO program:   LVM2_VG_NAME=fedora_gasoline LVM2_LV_NAME=home LVM2_LV_UUID=J4CFG6-yEhW-PDEh-MGOV-djvr-ZnX2-P5mlvP LVM2_LV_SIZE=431312896.00 LVM2_LV_ATTR=-wi-a----- LVM2_SEGTYPE=linear
>12:30:43,554 INFO program:   LVM2_VG_NAME=fedora_gasoline LVM2_LV_NAME=root LVM2_LV_UUID=wJzWlS-MraO-Pbda-MNg6-GO7f-dcYy-FzH7ez LVM2_LV_SIZE=52428800.00 LVM2_LV_ATTR=-wi-a----- LVM2_SEGTYPE=linear
>12:30:43,555 INFO program:   LVM2_VG_NAME=fedora_gasoline LVM2_LV_NAME=swap LVM2_LV_UUID=aP1cwS-xpu8-t7jo-pBNC-ooC1-jMD9-XDutV5 LVM2_LV_SIZE=4063232.00 LVM2_LV_ATTR=-wi-a----- LVM2_SEGTYPE=linear
>12:30:43,555 DEBUG program: Return code: 0
>12:30:45,024 INFO program: Running... dumpe2fs -h /dev/mapper/fedora_gasoline-home
>12:30:45,091 INFO program: dumpe2fs 1.42.10 (18-May-2014)
>12:30:45,092 INFO program: Filesystem volume name:   <none>
>12:30:45,092 INFO program: Last mounted on:          <not available>
>12:30:45,093 INFO program: Filesystem UUID:          b0ff9e76-3078-4852-b28c-589a8134d98d
>12:30:45,094 INFO program: Filesystem magic number:  0xEF53
>12:30:45,095 INFO program: Filesystem revision #:    1 (dynamic)
>12:30:45,095 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype extent flex_bg sparse_super large_file huge_file uninit_bg dir_nlink extra_isize
>12:30:45,096 INFO program: Filesystem flags:         signed_directory_hash 
>12:30:45,097 INFO program: Default mount options:    user_xattr acl
>12:30:45,098 INFO program: Filesystem state:         clean
>12:30:45,099 INFO program: Errors behavior:          Continue
>12:30:45,100 INFO program: Filesystem OS type:       Linux
>12:30:45,101 INFO program: Inode count:              26959872
>12:30:45,102 INFO program: Block count:              107828224
>12:30:45,104 INFO program: Reserved block count:     5391411
>12:30:45,105 INFO program: Free blocks:              106085426
>12:30:45,105 INFO program: Free inodes:              26959861
>12:30:45,107 INFO program: First block:              0
>12:30:45,108 INFO program: Block size:               4096
>12:30:45,109 INFO program: Fragment size:            4096
>12:30:45,110 INFO program: Reserved GDT blocks:      998
>12:30:45,111 INFO program: Blocks per group:         32768
>12:30:45,112 INFO program: Fragments per group:      32768
>12:30:45,117 INFO program: Inodes per group:         8192
>12:30:45,118 INFO program: Inode blocks per group:   512
>12:30:45,119 INFO program: Flex block group size:    16
>12:30:45,120 INFO program: Filesystem created:       Tue Jun 10 09:36:18 2014
>12:30:45,122 INFO program: Last mount time:          Tue Jun 10 11:36:27 2014
>12:30:45,123 INFO program: Last write time:          Tue Jun 10 11:39:05 2014
>12:30:45,124 INFO program: Mount count:              1
>12:30:45,127 INFO program: Maximum mount count:      -1
>12:30:45,128 INFO program: Last checked:             Tue Jun 10 09:36:18 2014
>12:30:45,129 INFO program: Check interval:           0 (<none>)
>12:30:45,131 INFO program: Lifetime writes:          933 MB
>12:30:45,132 INFO program: Reserved blocks uid:      0 (user root)
>12:30:45,133 INFO program: Reserved blocks gid:      0 (group root)
>12:30:45,135 INFO program: First inode:              11
>12:30:45,136 INFO program: Inode size:	          256
>12:30:45,137 INFO program: Required extra isize:     28
>12:30:45,137 INFO program: Desired extra isize:      28
>12:30:45,138 INFO program: Journal inode:            8
>12:30:45,139 INFO program: Default directory hash:   half_md4
>12:30:45,140 INFO program: Directory Hash Seed:      d9682537-98aa-476c-8f8d-3a9d3dd9aa3f
>12:30:45,141 INFO program: Journal backup:           inode blocks
>12:30:45,142 INFO program: Journal features:         (none)
>12:30:45,143 INFO program: Journal size:             128M
>12:30:45,143 INFO program: Journal length:           32768
>12:30:45,147 INFO program: Journal sequence:         0x00000021
>12:30:45,148 INFO program: Journal start:            0
>12:30:45,149 INFO program: 
>12:30:45,150 DEBUG program: Return code: 0
>12:30:45,150 INFO program: Running... resize2fs -P /dev/mapper/fedora_gasoline-home
>12:30:45,191 INFO program: resize2fs 1.42.10 (18-May-2014)
>12:30:45,192 INFO program: Estimated minimum size of the filesystem: 48784
>12:30:45,193 DEBUG program: Return code: 0
>12:30:45,280 INFO program: Running... modprobe btrfs
>12:30:45,418 DEBUG program: Return code: 0
>12:30:46,265 INFO program: Running... modprobe xfs
>12:30:46,443 DEBUG program: Return code: 0
>12:30:47,034 INFO program: Running... modprobe vfat
>12:30:47,115 DEBUG program: Return code: 0
>12:30:47,560 INFO program: Running... dumpe2fs -h /dev/mapper/fedora_gasoline-root
>12:30:47,624 INFO program: dumpe2fs 1.42.10 (18-May-2014)
>12:30:47,625 INFO program: Filesystem volume name:   <none>
>12:30:47,626 INFO program: Last mounted on:          /mnt/sysimage
>12:30:47,626 INFO program: Filesystem UUID:          8526bc0c-8029-455f-be52-bd4bb7855820
>12:30:47,626 INFO program: Filesystem magic number:  0xEF53
>12:30:47,627 INFO program: Filesystem revision #:    1 (dynamic)
>12:30:47,627 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype extent flex_bg sparse_super large_file huge_file uninit_bg dir_nlink extra_isize
>12:30:47,627 INFO program: Filesystem flags:         signed_directory_hash 
>12:30:47,628 INFO program: Default mount options:    user_xattr acl
>12:30:47,628 INFO program: Filesystem state:         clean
>12:30:47,628 INFO program: Errors behavior:          Continue
>12:30:47,628 INFO program: Filesystem OS type:       Linux
>12:30:47,629 INFO program: Inode count:              3276800
>12:30:47,629 INFO program: Block count:              13107200
>12:30:47,629 INFO program: Reserved block count:     655360
>12:30:47,630 INFO program: Free blocks:              12690781
>12:30:47,630 INFO program: Free inodes:              3253116
>12:30:47,630 INFO program: First block:              0
>12:30:47,631 INFO program: Block size:               4096
>12:30:47,631 INFO program: Fragment size:            4096
>12:30:47,632 INFO program: Reserved GDT blocks:      1020
>12:30:47,632 INFO program: Blocks per group:         32768
>12:30:47,632 INFO program: Fragments per group:      32768
>12:30:47,632 INFO program: Inodes per group:         8192
>12:30:47,633 INFO program: Inode blocks per group:   512
>12:30:47,633 INFO program: Flex block group size:    16
>12:30:47,633 INFO program: Filesystem created:       Tue Jun 10 11:36:23 2014
>12:30:47,634 INFO program: Last mount time:          Tue Jun 10 11:39:09 2014
>12:30:47,634 INFO program: Last write time:          Tue Jun 10 11:39:09 2014
>12:30:47,634 INFO program: Mount count:              2
>12:30:47,634 INFO program: Maximum mount count:      -1
>12:30:47,635 INFO program: Last checked:             Tue Jun 10 11:36:23 2014
>12:30:47,635 INFO program: Check interval:           0 (<none>)
>12:30:47,635 INFO program: Lifetime writes:          1722 MB
>12:30:47,635 INFO program: Reserved blocks uid:      0 (user root)
>12:30:47,636 INFO program: Reserved blocks gid:      0 (group root)
>12:30:47,636 INFO program: First inode:              11
>12:30:47,637 INFO program: Inode size:	          256
>12:30:47,637 INFO program: Required extra isize:     28
>12:30:47,637 INFO program: Desired extra isize:      28
>12:30:47,637 INFO program: Journal inode:            8
>12:30:47,638 INFO program: Default directory hash:   half_md4
>12:30:47,638 INFO program: Directory Hash Seed:      24099832-0757-4977-b0ba-8b2c4941ee9b
>12:30:47,639 INFO program: Journal backup:           inode blocks
>12:30:47,639 INFO program: Journal features:         (none)
>12:30:47,639 INFO program: Journal size:             128M
>12:30:47,639 INFO program: Journal length:           32768
>12:30:47,640 INFO program: Journal sequence:         0x00000bf4
>12:30:47,640 INFO program: Journal start:            0
>12:30:47,640 INFO program: 
>12:30:47,641 DEBUG program: Return code: 0
>12:30:47,641 INFO program: Running... resize2fs -P /dev/mapper/fedora_gasoline-root
>12:30:47,683 INFO program: resize2fs 1.42.10 (18-May-2014)
>12:30:47,683 INFO program: Estimated minimum size of the filesystem: 337448
>12:30:47,684 DEBUG program: Return code: 0
>12:30:48,593 INFO program: Running... hostnamectl set-hostname gasoline.anaconda.englab.brq.redhat.com
>12:30:48,750 DEBUG program: Return code: 0
>12:30:48,751 INFO program: Running... dumpe2fs -h /dev/loop1
>12:30:48,793 INFO program: dumpe2fs 1.42.10 (18-May-2014)
>12:30:48,794 INFO program: Filesystem volume name:   Anaconda
>12:30:48,794 INFO program: Last mounted on:          /
>12:30:48,794 INFO program: Filesystem UUID:          ee533e9b-3ada-4bfc-b950-c5e2b6fc2103
>12:30:48,795 INFO program: Filesystem magic number:  0xEF53
>12:30:48,795 INFO program: Filesystem revision #:    1 (dynamic)
>12:30:48,795 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype extent flex_bg sparse_super huge_file uninit_bg dir_nlink extra_isize
>12:30:48,796 INFO program: Filesystem flags:         signed_directory_hash 
>12:30:48,796 INFO program: Default mount options:    user_xattr acl
>12:30:48,796 INFO program: Filesystem state:         clean
>12:30:48,797 INFO program: Errors behavior:          Continue
>12:30:48,797 INFO program: Filesystem OS type:       Linux
>12:30:48,797 INFO program: Inode count:              131072
>12:30:48,798 INFO program: Block count:              2097152
>12:30:48,798 INFO program: Reserved block count:     0
>12:30:48,798 INFO program: Free blocks:              1184818
>12:30:48,799 INFO program: Free inodes:              99904
>12:30:48,799 INFO program: First block:              1
>12:30:48,800 INFO program: Block size:               1024
>12:30:48,800 INFO program: Fragment size:            1024
>12:30:48,801 INFO program: Reserved GDT blocks:      256
>12:30:48,801 INFO program: Blocks per group:         8192
>12:30:48,802 INFO program: Fragments per group:      8192
>12:30:48,802 INFO program: Inodes per group:         512
>12:30:48,802 INFO program: Inode blocks per group:   128
>12:30:48,802 INFO program: Flex block group size:    16
>12:30:48,803 INFO program: Filesystem created:       Wed Jun  4 10:13:22 2014
>12:30:48,803 INFO program: Last mount time:          Wed Jun  4 10:13:41 2014
>12:30:48,803 INFO program: Last write time:          Wed Jun  4 10:13:51 2014
>12:30:48,804 INFO program: Mount count:              2
>12:30:48,804 INFO program: Maximum mount count:      -1
>12:30:48,804 INFO program: Last checked:             Wed Jun  4 10:13:22 2014
>12:30:48,804 INFO program: Check interval:           0 (<none>)
>12:30:48,805 INFO program: Lifetime writes:          32 MB
>12:30:48,805 INFO program: Reserved blocks uid:      0 (user root)
>12:30:48,805 INFO program: Reserved blocks gid:      0 (group root)
>12:30:48,806 INFO program: First inode:              11
>12:30:48,806 INFO program: Inode size:	          256
>12:30:48,806 INFO program: Required extra isize:     28
>12:30:48,807 INFO program: Desired extra isize:      28
>12:30:48,807 INFO program: Journal inode:            8
>12:30:48,807 INFO program: Default directory hash:   half_md4
>12:30:48,807 INFO program: Directory Hash Seed:      5f50b0a4-124a-4c22-b844-00da6d525130
>12:30:48,808 INFO program: Journal backup:           inode blocks
>12:30:48,808 INFO program: Journal features:         (none)
>12:30:48,808 INFO program: Journal size:             32M
>12:30:48,809 INFO program: Journal length:           32768
>12:30:48,809 INFO program: Journal sequence:         0x00000009
>12:30:48,809 INFO program: Journal start:            0
>12:30:48,809 INFO program: 
>12:30:48,810 DEBUG program: Return code: 0
>12:30:48,810 INFO program: Running... resize2fs -P /dev/loop1
>12:30:48,852 INFO program: resize2fs 1.42.10 (18-May-2014)
>12:30:48,853 INFO program: resize2fs: Device or resource busy while trying to open /dev/loop1
>12:30:48,853 INFO program: Couldn't find valid filesystem superblock.
>12:30:48,854 DEBUG program: Return code: 1
>12:30:48,959 INFO program: Running... dumpe2fs -h /dev/loop4
>12:30:49,004 INFO program: dumpe2fs 1.42.10 (18-May-2014)
>12:30:49,005 INFO program: Filesystem volume name:   Anaconda
>12:30:49,005 INFO program: Last mounted on:          /
>12:30:49,005 INFO program: Filesystem UUID:          ee533e9b-3ada-4bfc-b950-c5e2b6fc2103
>12:30:49,005 INFO program: Filesystem magic number:  0xEF53
>12:30:49,006 INFO program: Filesystem revision #:    1 (dynamic)
>12:30:49,006 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype extent flex_bg sparse_super huge_file uninit_bg dir_nlink extra_isize
>12:30:49,006 INFO program: Filesystem flags:         signed_directory_hash 
>12:30:49,007 INFO program: Default mount options:    user_xattr acl
>12:30:49,007 INFO program: Filesystem state:         clean
>12:30:49,007 INFO program: Errors behavior:          Continue
>12:30:49,007 INFO program: Filesystem OS type:       Linux
>12:30:49,008 INFO program: Inode count:              131072
>12:30:49,008 INFO program: Block count:              2097152
>12:30:49,008 INFO program: Reserved block count:     0
>12:30:49,008 INFO program: Free blocks:              1184818
>12:30:49,009 INFO program: Free inodes:              99904
>12:30:49,009 INFO program: First block:              1
>12:30:49,009 INFO program: Block size:               1024
>12:30:49,009 INFO program: Fragment size:            1024
>12:30:49,010 INFO program: Reserved GDT blocks:      256
>12:30:49,010 INFO program: Blocks per group:         8192
>12:30:49,010 INFO program: Fragments per group:      8192
>12:30:49,010 INFO program: Inodes per group:         512
>12:30:49,011 INFO program: Inode blocks per group:   128
>12:30:49,011 INFO program: Flex block group size:    16
>12:30:49,011 INFO program: Filesystem created:       Wed Jun  4 10:13:22 2014
>12:30:49,011 INFO program: Last mount time:          Wed Jun  4 10:13:41 2014
>12:30:49,012 INFO program: Last write time:          Wed Jun  4 10:13:51 2014
>12:30:49,012 INFO program: Mount count:              2
>12:30:49,012 INFO program: Maximum mount count:      -1
>12:30:49,012 INFO program: Last checked:             Wed Jun  4 10:13:22 2014
>12:30:49,013 INFO program: Check interval:           0 (<none>)
>12:30:49,013 INFO program: Lifetime writes:          32 MB
>12:30:49,013 INFO program: Reserved blocks uid:      0 (user root)
>12:30:49,013 INFO program: Reserved blocks gid:      0 (group root)
>12:30:49,014 INFO program: First inode:              11
>12:30:49,014 INFO program: Inode size:	          256
>12:30:49,014 INFO program: Required extra isize:     28
>12:30:49,015 INFO program: Desired extra isize:      28
>12:30:49,015 INFO program: Journal inode:            8
>12:30:49,015 INFO program: Default directory hash:   half_md4
>12:30:49,015 INFO program: Directory Hash Seed:      5f50b0a4-124a-4c22-b844-00da6d525130
>12:30:49,016 INFO program: Journal backup:           inode blocks
>12:30:49,016 INFO program: Journal features:         (none)
>12:30:49,016 INFO program: Journal size:             32M
>12:30:49,016 INFO program: Journal length:           32768
>12:30:49,017 INFO program: Journal sequence:         0x00000009
>12:30:49,017 INFO program: Journal start:            0
>12:30:49,017 INFO program: 
>12:30:49,017 DEBUG program: Return code: 0
>12:30:49,018 INFO program: Running... resize2fs -P /dev/loop4
>12:30:49,059 INFO program: resize2fs 1.42.10 (18-May-2014)
>12:30:49,059 INFO program: resize2fs: Operation not permitted while trying to open /dev/loop4
>12:30:49,060 INFO program: Couldn't find valid filesystem superblock.
>12:30:49,060 DEBUG program: Return code: 1
>12:30:49,166 INFO program: Running... dumpe2fs -h /dev/loop7
>12:30:49,211 INFO program: dumpe2fs 1.42.10 (18-May-2014)
>12:30:49,211 INFO program: Filesystem volume name:   Anaconda
>12:30:49,212 INFO program: Last mounted on:          /
>12:30:49,212 INFO program: Filesystem UUID:          ee533e9b-3ada-4bfc-b950-c5e2b6fc2103
>12:30:49,212 INFO program: Filesystem magic number:  0xEF53
>12:30:49,212 INFO program: Filesystem revision #:    1 (dynamic)
>12:30:49,213 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype extent flex_bg sparse_super huge_file uninit_bg dir_nlink extra_isize
>12:30:49,213 INFO program: Filesystem flags:         signed_directory_hash 
>12:30:49,213 INFO program: Default mount options:    user_xattr acl
>12:30:49,214 INFO program: Filesystem state:         clean
>12:30:49,214 INFO program: Errors behavior:          Continue
>12:30:49,214 INFO program: Filesystem OS type:       Linux
>12:30:49,214 INFO program: Inode count:              131072
>12:30:49,215 INFO program: Block count:              2097152
>12:30:49,215 INFO program: Reserved block count:     0
>12:30:49,215 INFO program: Free blocks:              1184818
>12:30:49,215 INFO program: Free inodes:              99904
>12:30:49,216 INFO program: First block:              1
>12:30:49,216 INFO program: Block size:               1024
>12:30:49,216 INFO program: Fragment size:            1024
>12:30:49,216 INFO program: Reserved GDT blocks:      256
>12:30:49,217 INFO program: Blocks per group:         8192
>12:30:49,217 INFO program: Fragments per group:      8192
>12:30:49,217 INFO program: Inodes per group:         512
>12:30:49,217 INFO program: Inode blocks per group:   128
>12:30:49,218 INFO program: Flex block group size:    16
>12:30:49,218 INFO program: Filesystem created:       Wed Jun  4 10:13:22 2014
>12:30:49,218 INFO program: Last mount time:          Wed Jun  4 10:13:41 2014
>12:30:49,218 INFO program: Last write time:          Wed Jun  4 10:13:51 2014
>12:30:49,219 INFO program: Mount count:              2
>12:30:49,219 INFO program: Maximum mount count:      -1
>12:30:49,219 INFO program: Last checked:             Wed Jun  4 10:13:22 2014
>12:30:49,219 INFO program: Check interval:           0 (<none>)
>12:30:49,220 INFO program: Lifetime writes:          32 MB
>12:30:49,220 INFO program: Reserved blocks uid:      0 (user root)
>12:30:49,220 INFO program: Reserved blocks gid:      0 (group root)
>12:30:49,220 INFO program: First inode:              11
>12:30:49,221 INFO program: Inode size:	          256
>12:30:49,221 INFO program: Required extra isize:     28
>12:30:49,221 INFO program: Desired extra isize:      28
>12:30:49,221 INFO program: Journal inode:            8
>12:30:49,222 INFO program: Default directory hash:   half_md4
>12:30:49,222 INFO program: Directory Hash Seed:      5f50b0a4-124a-4c22-b844-00da6d525130
>12:30:49,222 INFO program: Journal backup:           inode blocks
>12:30:49,222 INFO program: Journal features:         (none)
>12:30:49,223 INFO program: Journal size:             32M
>12:30:49,223 INFO program: Journal length:           32768
>12:30:49,223 INFO program: Journal sequence:         0x00000009
>12:30:49,223 INFO program: Journal start:            0
>12:30:49,224 INFO program: 
>12:30:49,224 DEBUG program: Return code: 0
>12:30:49,225 INFO program: Running... resize2fs -P /dev/loop7
>12:30:49,262 INFO program: resize2fs 1.42.10 (18-May-2014)
>12:30:49,263 INFO program: resize2fs: Operation not permitted while trying to open /dev/loop7
>12:30:49,263 INFO program: Couldn't find valid filesystem superblock.
>12:30:49,264 DEBUG program: Return code: 1
>12:30:49,467 INFO program: Running... dumpe2fs -h /dev/mapper/live-rw
>12:30:49,512 INFO program: dumpe2fs 1.42.10 (18-May-2014)
>12:30:49,513 INFO program: Filesystem volume name:   Anaconda
>12:30:49,513 INFO program: Last mounted on:          /
>12:30:49,513 INFO program: Filesystem UUID:          ee533e9b-3ada-4bfc-b950-c5e2b6fc2103
>12:30:49,514 INFO program: Filesystem magic number:  0xEF53
>12:30:49,514 INFO program: Filesystem revision #:    1 (dynamic)
>12:30:49,514 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype needs_recovery extent flex_bg sparse_super huge_file uninit_bg dir_nlink extra_isize
>12:30:49,515 INFO program: Filesystem flags:         signed_directory_hash 
>12:30:49,515 INFO program: Default mount options:    user_xattr acl
>12:30:49,515 INFO program: Filesystem state:         clean
>12:30:49,515 INFO program: Errors behavior:          Continue
>12:30:49,516 INFO program: Filesystem OS type:       Linux
>12:30:49,516 INFO program: Inode count:              131072
>12:30:49,516 INFO program: Block count:              2097152
>12:30:49,517 INFO program: Reserved block count:     0
>12:30:49,517 INFO program: Free blocks:              1184818
>12:30:49,517 INFO program: Free inodes:              99904
>12:30:49,517 INFO program: First block:              1
>12:30:49,518 INFO program: Block size:               1024
>12:30:49,518 INFO program: Fragment size:            1024
>12:30:49,518 INFO program: Reserved GDT blocks:      256
>12:30:49,518 INFO program: Blocks per group:         8192
>12:30:49,519 INFO program: Fragments per group:      8192
>12:30:49,519 INFO program: Inodes per group:         512
>12:30:49,519 INFO program: Inode blocks per group:   128
>12:30:49,519 INFO program: Flex block group size:    16
>12:30:49,520 INFO program: Filesystem created:       Wed Jun  4 10:13:22 2014
>12:30:49,520 INFO program: Last mount time:          Tue Jun 10 12:30:07 2014
>12:30:49,520 INFO program: Last write time:          Tue Jun 10 12:30:07 2014
>12:30:49,521 INFO program: Mount count:              3
>12:30:49,521 INFO program: Maximum mount count:      -1
>12:30:49,521 INFO program: Last checked:             Wed Jun  4 10:13:22 2014
>12:30:49,521 INFO program: Check interval:           0 (<none>)
>12:30:49,522 INFO program: Lifetime writes:          32 MB
>12:30:49,522 INFO program: Reserved blocks uid:      0 (user root)
>12:30:49,522 INFO program: Reserved blocks gid:      0 (group root)
>12:30:49,522 INFO program: First inode:              11
>12:30:49,523 INFO program: Inode size:	          256
>12:30:49,523 INFO program: Required extra isize:     28
>12:30:49,523 INFO program: Desired extra isize:      28
>12:30:49,523 INFO program: Journal inode:            8
>12:30:49,524 INFO program: Default directory hash:   half_md4
>12:30:49,524 INFO program: Directory Hash Seed:      5f50b0a4-124a-4c22-b844-00da6d525130
>12:30:49,524 INFO program: Journal backup:           inode blocks
>12:30:49,525 INFO program: Journal features:         (none)
>12:30:49,525 INFO program: Journal size:             32M
>12:30:49,525 INFO program: Journal length:           32768
>12:30:49,525 INFO program: Journal sequence:         0x0000000a
>12:30:49,526 INFO program: Journal start:            1
>12:30:49,526 INFO program: 
>12:30:49,526 DEBUG program: Return code: 0
>12:30:49,527 INFO program: Running... resize2fs -P /dev/mapper/live-rw
>12:30:49,568 INFO program: resize2fs 1.42.10 (18-May-2014)
>12:30:49,569 INFO program: Estimated minimum size of the filesystem: 919630
>12:30:49,569 DEBUG program: Return code: 0
>12:30:49,692 INFO program: Running... dumpe2fs -h /dev/mapper/live-base
>12:30:49,732 INFO program: dumpe2fs 1.42.10 (18-May-2014)
>12:30:49,733 INFO program: Filesystem volume name:   Anaconda
>12:30:49,733 INFO program: Last mounted on:          /
>12:30:49,734 INFO program: Filesystem UUID:          ee533e9b-3ada-4bfc-b950-c5e2b6fc2103
>12:30:49,734 INFO program: Filesystem magic number:  0xEF53
>12:30:49,734 INFO program: Filesystem revision #:    1 (dynamic)
>12:30:49,734 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype extent flex_bg sparse_super huge_file uninit_bg dir_nlink extra_isize
>12:30:49,735 INFO program: Filesystem flags:         signed_directory_hash 
>12:30:49,735 INFO program: Default mount options:    user_xattr acl
>12:30:49,735 INFO program: Filesystem state:         clean
>12:30:49,736 INFO program: Errors behavior:          Continue
>12:30:49,736 INFO program: Filesystem OS type:       Linux
>12:30:49,736 INFO program: Inode count:              131072
>12:30:49,737 INFO program: Block count:              2097152
>12:30:49,737 INFO program: Reserved block count:     0
>12:30:49,737 INFO program: Free blocks:              1184818
>12:30:49,737 INFO program: Free inodes:              99904
>12:30:49,738 INFO program: First block:              1
>12:30:49,738 INFO program: Block size:               1024
>12:30:49,738 INFO program: Fragment size:            1024
>12:30:49,738 INFO program: Reserved GDT blocks:      256
>12:30:49,739 INFO program: Blocks per group:         8192
>12:30:49,739 INFO program: Fragments per group:      8192
>12:30:49,739 INFO program: Inodes per group:         512
>12:30:49,739 INFO program: Inode blocks per group:   128
>12:30:49,740 INFO program: Flex block group size:    16
>12:30:49,740 INFO program: Filesystem created:       Wed Jun  4 10:13:22 2014
>12:30:49,740 INFO program: Last mount time:          Wed Jun  4 10:13:41 2014
>12:30:49,740 INFO program: Last write time:          Wed Jun  4 10:13:51 2014
>12:30:49,741 INFO program: Mount count:              2
>12:30:49,741 INFO program: Maximum mount count:      -1
>12:30:49,741 INFO program: Last checked:             Wed Jun  4 10:13:22 2014
>12:30:49,741 INFO program: Check interval:           0 (<none>)
>12:30:49,742 INFO program: Lifetime writes:          32 MB
>12:30:49,742 INFO program: Reserved blocks uid:      0 (user root)
>12:30:49,742 INFO program: Reserved blocks gid:      0 (group root)
>12:30:49,742 INFO program: First inode:              11
>12:30:49,743 INFO program: Inode size:	          256
>12:30:49,743 INFO program: Required extra isize:     28
>12:30:49,743 INFO program: Desired extra isize:      28
>12:30:49,743 INFO program: Journal inode:            8
>12:30:49,744 INFO program: Default directory hash:   half_md4
>12:30:49,744 INFO program: Directory Hash Seed:      5f50b0a4-124a-4c22-b844-00da6d525130
>12:30:49,744 INFO program: Journal backup:           inode blocks
>12:30:49,745 INFO program: Journal features:         (none)
>12:30:49,745 INFO program: Journal size:             32M
>12:30:49,745 INFO program: Journal length:           32768
>12:30:49,745 INFO program: Journal sequence:         0x00000009
>12:30:49,745 INFO program: Journal start:            0
>12:30:49,746 INFO program: 
>12:30:49,746 DEBUG program: Return code: 0
>12:30:49,747 INFO program: Running... resize2fs -P /dev/mapper/live-base
>12:30:49,786 INFO program: resize2fs 1.42.10 (18-May-2014)
>12:30:49,787 INFO program: resize2fs: Operation not permitted while trying to open /dev/mapper/live-base
>12:30:49,788 INFO program: Couldn't find valid filesystem superblock.
>12:30:49,788 DEBUG program: Return code: 1
>12:30:51,927 INFO program: Running... udevadm settle --timeout=300
>12:30:51,978 DEBUG program: Return code: 0
>12:30:52,006 INFO program: Running... udevadm settle --timeout=300
>12:30:52,053 DEBUG program: Return code: 0
>12:30:52,063 INFO program: Running... udevadm settle --timeout=300
>12:30:52,109 DEBUG program: Return code: 0
>12:30:52,116 INFO program: Running... udevadm settle --timeout=300
>12:30:52,167 DEBUG program: Return code: 0
>12:30:52,175 INFO program: Running... udevadm settle --timeout=300
>12:30:52,220 DEBUG program: Return code: 0
>12:30:52,224 INFO program: Running... udevadm settle --timeout=300
>12:30:52,272 DEBUG program: Return code: 0
>12:30:52,282 INFO program: Running... udevadm settle --timeout=300
>12:30:52,331 DEBUG program: Return code: 0
>12:30:52,336 INFO program: Running... udevadm settle --timeout=300
>12:30:52,385 DEBUG program: Return code: 0
>12:30:52,388 INFO program: Running... lvm lvchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/home
>12:30:52,569 DEBUG program: Return code: 0
>12:30:52,579 INFO program: Running... udevadm settle --timeout=300
>12:30:52,627 DEBUG program: Return code: 0
>12:30:52,628 INFO program: Running... systemctl status chronyd.service
>12:30:52,684 INFO program: * chronyd.service - NTP client/server
>12:30:52,684 INFO program: Loaded: loaded (/usr/lib/systemd/system/chronyd.service; enabled)
>12:30:52,685 INFO program: Active: active (running) since Tue 2014-06-10 12:30:41 UTC; 11s ago
>12:30:52,685 INFO program: Process: 2020 ExecStartPost=/usr/libexec/chrony-helper add-dhclient-servers (code=exited, status=0/SUCCESS)
>12:30:52,686 INFO program: Process: 2017 ExecStart=/usr/sbin/chronyd -u chrony $OPTIONS (code=exited, status=0/SUCCESS)
>12:30:52,686 INFO program: Main PID: 2019 (chronyd)
>12:30:52,686 INFO program: CGroup: /system.slice/chronyd.service
>12:30:52,687 INFO program: `-2019 /usr/sbin/chronyd -u chrony
>12:30:52,687 INFO program: 
>12:30:52,687 INFO program: Jun 10 12:30:41 gasoline.anaconda.englab.brq.redhat.com systemd[1]: Started NTP client/server.
>12:30:52,687 DEBUG program: Return code: 0
>12:30:52,688 INFO program: Running... lvm vgchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline
>12:30:52,835 INFO program:   0 logical volume(s) in volume group "fedora_gasoline" now active
>12:30:52,836 DEBUG program: Return code: 0
>12:30:52,845 INFO program: Running... udevadm settle --timeout=300
>12:30:52,895 DEBUG program: Return code: 0
>12:30:52,905 INFO program: Running... udevadm settle --timeout=300
>12:30:52,948 DEBUG program: Return code: 0
>12:30:52,961 INFO program: Running... udevadm settle --timeout=300
>12:30:53,012 DEBUG program: Return code: 0
>12:30:53,075 INFO program: Running... mount -t ext4 -o defaults,ro /dev/sda1 /mnt/sysimage
>12:30:53,132 DEBUG program: Return code: 0
>12:30:53,144 INFO program: Running... udevadm settle --timeout=300
>12:30:53,196 DEBUG program: Return code: 0
>12:30:53,198 INFO program: Running... umount /mnt/sysimage
>12:30:53,254 DEBUG program: Return code: 0
>12:30:53,254 INFO program: Running... udevadm settle --timeout=300
>12:30:53,306 DEBUG program: Return code: 0
>12:30:53,326 INFO program: Running... udevadm settle --timeout=300
>12:30:53,378 DEBUG program: Return code: 0
>12:30:53,400 INFO program: Running... lvm lvchange -a y --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/home
>12:30:53,714 DEBUG program: Return code: 0
>12:30:53,715 INFO program: Running... udevadm settle --timeout=300
>12:30:53,764 DEBUG program: Return code: 0
>12:30:53,766 INFO program: Running... mount -t ext4 -o defaults,ro /dev/mapper/fedora_gasoline-home /mnt/sysimage
>12:30:53,842 DEBUG program: Return code: 0
>12:30:53,864 INFO program: Running... udevadm settle --timeout=300
>12:30:53,915 DEBUG program: Return code: 0
>12:30:53,916 INFO program: Running... umount /mnt/sysimage
>12:30:53,970 DEBUG program: Return code: 0
>12:30:53,971 INFO program: Running... udevadm settle --timeout=300
>12:30:54,021 DEBUG program: Return code: 0
>12:30:54,027 INFO program: Running... lvm lvchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/home
>12:30:54,150 DEBUG program: Return code: 0
>12:30:54,170 INFO program: Running... udevadm settle --timeout=300
>12:30:54,220 DEBUG program: Return code: 0
>12:30:54,227 INFO program: Running... lvm vgchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline
>12:30:54,314 INFO program:   0 logical volume(s) in volume group "fedora_gasoline" now active
>12:30:54,315 DEBUG program: Return code: 0
>12:30:54,339 INFO program: Running... udevadm settle --timeout=300
>12:30:54,389 DEBUG program: Return code: 0
>12:30:54,411 INFO program: Running... udevadm settle --timeout=300
>12:30:54,463 DEBUG program: Return code: 0
>12:30:54,481 INFO program: Running... lvm lvchange -a y --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/root
>12:30:54,719 DEBUG program: Return code: 0
>12:30:54,720 INFO program: Running... udevadm settle --timeout=300
>12:30:54,768 DEBUG program: Return code: 0
>12:30:54,771 INFO program: Running... mount -t ext4 -o defaults,ro /dev/mapper/fedora_gasoline-root /mnt/sysimage
>12:30:54,828 DEBUG program: Return code: 0
>12:30:54,850 INFO program: Running... udevadm settle --timeout=300
>12:30:54,900 DEBUG program: Return code: 0
>12:30:54,901 INFO program: Running... umount /mnt/sysimage
>12:30:54,951 DEBUG program: Return code: 0
>12:30:54,953 INFO program: Running... udevadm settle --timeout=300
>12:30:55,004 DEBUG program: Return code: 0
>12:30:55,009 INFO program: Running... lvm lvchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/root
>12:30:55,141 DEBUG program: Return code: 0
>12:30:55,157 INFO program: Running... udevadm settle --timeout=300
>12:30:55,209 DEBUG program: Return code: 0
>12:30:55,216 INFO program: Running... lvm vgchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline
>12:30:55,306 INFO program:   0 logical volume(s) in volume group "fedora_gasoline" now active
>12:30:55,307 DEBUG program: Return code: 0
>12:30:55,307 INFO program: Running... systemctl status chronyd.service
>12:30:55,354 INFO program: * chronyd.service - NTP client/server
>12:30:55,354 INFO program: Loaded: loaded (/usr/lib/systemd/system/chronyd.service; enabled)
>12:30:55,355 INFO program: Active: active (running) since Tue 2014-06-10 12:30:41 UTC; 14s ago
>12:30:55,355 INFO program: Process: 2020 ExecStartPost=/usr/libexec/chrony-helper add-dhclient-servers (code=exited, status=0/SUCCESS)
>12:30:55,355 INFO program: Process: 2017 ExecStart=/usr/sbin/chronyd -u chrony $OPTIONS (code=exited, status=0/SUCCESS)
>12:30:55,356 INFO program: Main PID: 2019 (chronyd)
>12:30:55,356 INFO program: CGroup: /system.slice/chronyd.service
>12:30:55,356 INFO program: `-2019 /usr/sbin/chronyd -u chrony
>12:30:55,356 INFO program: 
>12:30:55,357 INFO program: Jun 10 12:30:41 gasoline.anaconda.englab.brq.redhat.com systemd[1]: Started NTP client/server.
>12:30:55,357 DEBUG program: Return code: 0
>12:30:55,357 INFO program: Running... udevadm settle --timeout=300
>12:30:55,410 DEBUG program: Return code: 0
>12:30:55,411 INFO program: Running... systemctl start chronyd.service
>12:30:55,456 DEBUG program: Return code: 0
>12:30:55,458 INFO program: Running... udevadm settle --timeout=300
>12:30:55,509 DEBUG program: Return code: 0
>12:30:55,674 INFO program: Running... udevadm settle --timeout=300
>12:30:55,725 DEBUG program: Return code: 0
>12:30:55,767 INFO program: Running... udevadm settle --timeout=300
>12:30:55,819 DEBUG program: Return code: 0
>14:30:57,844 INFO program: Running... systemctl status chronyd.service
>14:30:57,880 INFO program: * chronyd.service - NTP client/server
>14:30:57,881 INFO program: Loaded: loaded (/usr/lib/systemd/system/chronyd.service; enabled)
>14:30:57,881 INFO program: Active: active (running) since Tue 2014-06-10 12:30:41 UTC; 16s ago
>14:30:57,882 INFO program: Process: 2020 ExecStartPost=/usr/libexec/chrony-helper add-dhclient-servers (code=exited, status=0/SUCCESS)
>14:30:57,882 INFO program: Process: 2017 ExecStart=/usr/sbin/chronyd -u chrony $OPTIONS (code=exited, status=0/SUCCESS)
>14:30:57,882 INFO program: Main PID: 2019 (chronyd)
>14:30:57,882 INFO program: CGroup: /system.slice/chronyd.service
>14:30:57,883 INFO program: `-2019 /usr/sbin/chronyd -u chrony
>14:30:57,883 INFO program: 
>14:30:57,883 INFO program: Jun 10 12:30:41 gasoline.anaconda.englab.brq.redhat.com systemd[1]: Started NTP client/server.
>14:30:57,883 INFO program: Jun 10 12:30:55 gasoline.anaconda.englab.brq.redhat.com systemd[1]: Started NTP client/server.
>14:30:57,884 DEBUG program: Return code: 0
>12:31:06,406 INFO program: Running... udevadm settle --timeout=300
>12:31:06,454 DEBUG program: Return code: 0
>12:31:06,476 INFO program: Running... udevadm settle --timeout=300
>12:31:06,524 DEBUG program: Return code: 0
>12:31:08,040 INFO program: Running... udevadm settle --timeout=300
>12:31:08,088 DEBUG program: Return code: 0
>12:31:08,105 INFO program: Running... udevadm settle --timeout=300
>12:31:08,149 DEBUG program: Return code: 0
>12:31:08,214 INFO program: Running... udevadm settle --timeout=300
>12:31:08,260 DEBUG program: Return code: 0
>12:31:08,279 INFO program: Running... udevadm settle --timeout=300
>12:31:08,324 DEBUG program: Return code: 0
>12:31:09,967 INFO program: Running... hwclock --systohc --local
>12:31:11,503 DEBUG program: Return code: 0
>12:31:11,533 INFO program: Running... udevadm settle --timeout=300
>12:31:11,583 DEBUG program: Return code: 0
>12:31:11,592 INFO program: Running... udevadm settle --timeout=300
>12:31:11,644 DEBUG program: Return code: 0
>12:31:11,652 INFO program: Running... udevadm settle --timeout=300
>12:31:11,702 DEBUG program: Return code: 0
>12:31:11,709 INFO program: Running... udevadm settle --timeout=300
>12:31:11,758 DEBUG program: Return code: 0
>12:31:11,765 INFO program: Running... udevadm settle --timeout=300
>12:31:11,814 DEBUG program: Return code: 0
>12:31:11,883 INFO program: Running... wipefs -f -a /dev/sda1
>12:31:12,013 INFO program: /dev/sda1: 2 bytes were erased at offset 0x00000438 (ext4): 53 ef
>12:31:12,015 DEBUG program: Return code: 0
>12:31:12,015 INFO program: Running... udevadm settle --timeout=300
>12:31:12,067 DEBUG program: Return code: 0
>12:31:12,068 INFO program: Running... udevadm settle --timeout=300
>12:31:12,115 DEBUG program: Return code: 0
>12:31:12,123 INFO program: Running... lvm lvchange -a y --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/home
>12:31:12,454 DEBUG program: Return code: 0
>12:31:12,455 INFO program: Running... udevadm settle --timeout=300
>12:31:12,505 DEBUG program: Return code: 0
>12:31:12,508 INFO program: Running... wipefs -f -a /dev/mapper/fedora_gasoline-home
>12:31:12,565 INFO program: /dev/mapper/fedora_gasoline-home: 2 bytes were erased at offset 0x00000438 (ext4): 53 ef
>12:31:12,566 DEBUG program: Return code: 0
>12:31:12,566 INFO program: Running... udevadm settle --timeout=300
>12:31:12,615 DEBUG program: Return code: 0
>12:31:12,621 INFO program: Running... udevadm settle --timeout=300
>12:31:12,668 DEBUG program: Return code: 0
>12:31:12,671 INFO program: Running... lvm lvchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/home
>12:31:12,792 DEBUG program: Return code: 0
>12:31:12,793 INFO program: Running... udevadm settle --timeout=300
>12:31:12,840 DEBUG program: Return code: 0
>12:31:12,854 INFO program: Running... lvm lvremove --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/home
>12:31:12,952 INFO program:   Logical volume "home" successfully removed
>12:31:12,953 DEBUG program: Return code: 0
>12:31:12,953 INFO program: Running... udevadm settle --timeout=300
>12:31:13,000 DEBUG program: Return code: 0
>12:31:13,010 INFO program: Running... lvm lvchange -a y --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/swap
>12:31:13,258 DEBUG program: Return code: 0
>12:31:13,259 INFO program: Running... udevadm settle --timeout=300
>12:31:13,308 DEBUG program: Return code: 0
>12:31:13,312 INFO program: Running... wipefs -f -a /dev/mapper/fedora_gasoline-swap
>12:31:13,381 INFO program: /dev/mapper/fedora_gasoline-swap: 10 bytes were erased at offset 0x00000ff6 (swap): 53 57 41 50 53 50 41 43 45 32
>12:31:13,382 DEBUG program: Return code: 0
>12:31:13,382 INFO program: Running... udevadm settle --timeout=300
>12:31:13,431 DEBUG program: Return code: 0
>12:31:13,440 INFO program: Running... udevadm settle --timeout=300
>12:31:13,488 DEBUG program: Return code: 0
>12:31:13,490 INFO program: Running... lvm lvchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/swap
>12:31:13,615 DEBUG program: Return code: 0
>12:31:13,616 INFO program: Running... udevadm settle --timeout=300
>12:31:13,662 DEBUG program: Return code: 0
>12:31:13,673 INFO program: Running... lvm lvremove --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/swap
>12:31:13,762 INFO program:   Logical volume "swap" successfully removed
>12:31:13,763 DEBUG program: Return code: 0
>12:31:13,764 INFO program: Running... udevadm settle --timeout=300
>12:31:13,812 DEBUG program: Return code: 0
>12:31:13,821 INFO program: Running... lvm lvchange -a y --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/root
>12:31:14,058 DEBUG program: Return code: 0
>12:31:14,059 INFO program: Running... udevadm settle --timeout=300
>12:31:14,106 DEBUG program: Return code: 0
>12:31:14,109 INFO program: Running... wipefs -f -a /dev/mapper/fedora_gasoline-root
>12:31:14,177 INFO program: /dev/mapper/fedora_gasoline-root: 2 bytes were erased at offset 0x00000438 (ext4): 53 ef
>12:31:14,178 DEBUG program: Return code: 0
>12:31:14,179 INFO program: Running... udevadm settle --timeout=300
>12:31:14,230 DEBUG program: Return code: 0
>12:31:14,238 INFO program: Running... udevadm settle --timeout=300
>12:31:14,289 DEBUG program: Return code: 0
>12:31:14,292 INFO program: Running... lvm lvchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/root
>12:31:14,431 DEBUG program: Return code: 0
>12:31:14,432 INFO program: Running... udevadm settle --timeout=300
>12:31:14,478 DEBUG program: Return code: 0
>12:31:14,490 INFO program: Running... lvm lvremove --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/root
>12:31:14,577 INFO program:   Logical volume "root" successfully removed
>12:31:14,578 DEBUG program: Return code: 0
>12:31:14,579 INFO program: Running... udevadm settle --timeout=300
>12:31:14,625 DEBUG program: Return code: 0
>12:31:14,634 INFO program: Running... udevadm settle --timeout=300
>12:31:14,679 DEBUG program: Return code: 0
>12:31:14,682 INFO program: Running... lvm vgchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline
>12:31:14,768 INFO program:   0 logical volume(s) in volume group "fedora_gasoline" now active
>12:31:14,769 DEBUG program: Return code: 0
>12:31:14,778 INFO program: Running... lvm vgreduce --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  --removemissing --force fedora_gasoline
>12:31:14,857 INFO program:   Volume group "fedora_gasoline" is already consistent
>12:31:14,858 DEBUG program: Return code: 0
>12:31:14,858 INFO program: Running... lvm vgchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline
>12:31:14,937 INFO program:   0 logical volume(s) in volume group "fedora_gasoline" now active
>12:31:14,938 DEBUG program: Return code: 0
>12:31:14,938 INFO program: Running... lvm vgremove --force --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline
>12:31:15,020 INFO program:   Volume group "fedora_gasoline" successfully removed
>12:31:15,021 DEBUG program: Return code: 0
>12:31:15,021 INFO program: Running... udevadm settle --timeout=300
>12:31:15,067 DEBUG program: Return code: 0
>12:31:15,072 INFO program: Running... lvm pvremove --force --force --yes --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  /dev/sda2
>12:31:15,153 INFO program:   Labels on physical volume "/dev/sda2" successfully wiped
>12:31:15,154 DEBUG program: Return code: 0
>12:31:15,154 INFO program: Running... lvm pvscan --cache --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  /dev/sda2
>12:31:15,220 INFO program:   No PV label found on /dev/sda2.
>12:31:15,221 DEBUG program: Return code: 0
>12:31:15,224 INFO program: Running... udevadm settle --timeout=300
>12:31:15,271 DEBUG program: Return code: 0
>12:31:15,272 INFO program: Running... udevadm settle --timeout=300
>12:31:15,321 DEBUG program: Return code: 0
>12:31:15,333 INFO program: Running... udevadm settle --timeout=300
>12:31:15,385 DEBUG program: Return code: 0
>12:31:15,504 INFO program: Running... udevadm settle --timeout=300
>12:31:15,634 DEBUG program: Return code: 0
>12:31:15,636 INFO program: Running... udevadm settle --timeout=300
>12:31:15,686 DEBUG program: Return code: 0
>12:31:15,694 INFO program: Running... udevadm settle --timeout=300
>12:31:15,740 DEBUG program: Return code: 0
>12:31:15,814 INFO program: Running... udevadm settle --timeout=300
>12:31:15,868 DEBUG program: Return code: 0
>12:31:15,869 INFO program: Running... udevadm settle --timeout=300
>12:31:15,918 DEBUG program: Return code: 0
>12:31:15,923 INFO program: Running... wipefs -f -a /dev/sda
>12:31:15,982 INFO program: /dev/sda: 2 bytes were erased at offset 0x000001fe (dos): 55 aa
>12:31:15,983 INFO program: /dev/sda: calling ioclt to re-read partition table: Success
>12:31:15,983 DEBUG program: Return code: 0
>12:31:15,984 INFO program: Running... udevadm settle --timeout=300
>12:31:16,034 DEBUG program: Return code: 0
>12:31:16,035 INFO program: Running... udevadm settle --timeout=300
>12:31:16,082 DEBUG program: Return code: 0
>12:31:16,191 INFO program: Running... udevadm settle --timeout=300
>12:31:16,242 DEBUG program: Return code: 0
>12:31:16,243 INFO program: Running... udevadm settle --timeout=300
>12:31:16,291 DEBUG program: Return code: 0
>12:31:16,296 INFO program: Running... udevadm settle --timeout=300
>12:31:16,344 DEBUG program: Return code: 0
>12:31:16,356 INFO program: Running... dd if=/dev/zero of=/dev/sda bs=512 seek=2048 count=2048
>12:31:16,480 INFO program: 2048+0 records in
>12:31:16,481 INFO program: 2048+0 records out
>12:31:16,481 INFO program: 1048576 bytes (1.0 MB) copied, 0.0801596 s, 13.1 MB/s
>12:31:16,482 DEBUG program: Return code: 0
>12:31:16,482 INFO program: Running... udevadm settle --timeout=300
>12:31:16,560 DEBUG program: Return code: 0
>12:31:16,601 INFO program: Running... udevadm settle --timeout=300
>12:31:16,661 DEBUG program: Return code: 0
>12:31:16,672 INFO program: Running... wipefs -f -a /dev/sda1
>12:31:16,723 DEBUG program: Return code: 0
>12:31:16,731 INFO program: Running... udevadm settle --timeout=300
>12:31:16,778 DEBUG program: Return code: 0
>12:31:16,779 INFO program: Running... udevadm settle --timeout=300
>12:31:16,830 DEBUG program: Return code: 0
>12:31:16,900 INFO program: Running... mke2fs -t ext4 /dev/sda1
>12:31:17,308 INFO program: mke2fs 1.42.10 (18-May-2014)
>12:31:17,309 INFO program: Creating filesystem with 512000 1k blocks and 128016 inodes
>12:31:17,309 INFO program: Filesystem UUID: 25fa0b0e-c575-4489-b674-995d620f35a4
>12:31:17,309 INFO program: Superblock backups stored on blocks: 
>12:31:17,310 INFO program: 	8193, 24577, 40961, 57345, 73729, 204801, 221185, 401409
>12:31:17,310 INFO program: 
>12:31:17,310 INFO program: Allocating group tables:  0/63     done                            
>12:31:17,311 INFO program: Writing inode tables:  0/63     done                            
>12:31:17,311 INFO program: Creating journal (8192 blocks): done
>12:31:17,311 INFO program: Writing superblocks and filesystem accounting information:  0/63     done
>12:31:17,312 INFO program: 
>12:31:17,312 DEBUG program: Return code: 0
>12:31:17,316 INFO program: Running... udevadm settle --timeout=300
>12:31:17,391 DEBUG program: Return code: 0
>12:31:17,400 INFO program: Running... udevadm settle --timeout=300
>12:31:17,448 DEBUG program: Return code: 0
>12:31:17,464 INFO program: Running... dd if=/dev/zero of=/dev/sda bs=512 seek=1026048 count=2048
>12:31:17,569 INFO program: 2048+0 records in
>12:31:17,570 INFO program: 2048+0 records out
>12:31:17,570 INFO program: 1048576 bytes (1.0 MB) copied, 0.0712964 s, 14.7 MB/s
>12:31:17,571 DEBUG program: Return code: 0
>12:31:17,571 INFO program: Running... udevadm settle --timeout=300
>12:31:17,685 DEBUG program: Return code: 0
>12:31:17,755 INFO program: Running... udevadm settle --timeout=300
>12:31:17,852 DEBUG program: Return code: 0
>12:31:17,863 INFO program: Running... wipefs -f -a /dev/sda2
>12:31:17,915 DEBUG program: Return code: 0
>12:31:17,923 INFO program: Running... udevadm settle --timeout=300
>12:31:17,972 DEBUG program: Return code: 0
>12:31:17,974 INFO program: Running... udevadm settle --timeout=300
>12:31:18,025 DEBUG program: Return code: 0
>12:31:18,102 INFO program: Running... wipefs -f -a /dev/sda2
>12:31:18,164 DEBUG program: Return code: 0
>12:31:18,165 INFO program: Running... lvm pvscan --cache --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  /dev/sda2
>12:31:18,237 INFO program:   No PV label found on /dev/sda2.
>12:31:18,237 DEBUG program: Return code: 0
>12:31:18,238 INFO program: Running... lvm pvcreate --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  --dataalignment 1024k /dev/sda2
>12:31:18,368 INFO program:   Physical volume "/dev/sda2" successfully created
>12:31:18,368 DEBUG program: Return code: 0
>12:31:18,369 INFO program: Running... lvm pvscan --cache --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  /dev/sda2
>12:31:18,440 DEBUG program: Return code: 0
>12:31:18,444 INFO program: Running... udevadm settle --timeout=300
>12:31:18,495 DEBUG program: Return code: 0
>12:31:18,501 INFO program: Running... udevadm settle --timeout=300
>12:31:18,548 DEBUG program: Return code: 0
>12:31:18,557 INFO program: Running... lvm vgcreate -s 4m --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline /dev/sda2
>12:31:18,651 INFO program:   Volume group "fedora_gasoline" successfully created
>12:31:18,652 DEBUG program: Return code: 0
>12:31:18,657 INFO program: Running... udevadm settle --timeout=300
>12:31:18,706 DEBUG program: Return code: 0
>12:31:18,707 INFO program: Running... udevadm settle --timeout=300
>12:31:18,756 DEBUG program: Return code: 0
>12:31:18,765 INFO program: Running... lvm vgs --noheadings --nosuffix --nameprefixes --unquoted --units m -o uuid,size,free,extent_size,extent_count,free_count,pv_count --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] } global {locking_type=4}  fedora_gasoline
>12:31:18,828 INFO program:   LVM2_VG_UUID=mSmiQT-YgvB-RwoW-3CSl-bxG7-LM0v-DNlzVV LVM2_VG_SIZE=476436.00 LVM2_VG_FREE=476436.00 LVM2_VG_EXTENT_SIZE=4.00 LVM2_VG_EXTENT_COUNT=119109 LVM2_VG_FREE_COUNT=119109 LVM2_PV_COUNT=1
>12:31:18,829 DEBUG program: Return code: 0
>12:31:18,832 INFO program: Running... lvm lvcreate -L 3968m -n swap -y --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline
>12:31:19,058 INFO program:   Logical volume "swap" created
>12:31:19,058 DEBUG program: Return code: 0
>12:31:19,066 INFO program: Running... udevadm settle --timeout=300
>12:31:19,115 DEBUG program: Return code: 0
>12:31:19,122 INFO program: Running... udevadm settle --timeout=300
>12:31:19,174 DEBUG program: Return code: 0
>12:31:19,182 INFO program: Running... mkswap -f /dev/mapper/fedora_gasoline-swap
>12:31:19,254 INFO program: Setting up swapspace version 1, size = 4063228 KiB
>12:31:19,255 INFO program: no label, UUID=5af788b5-b3ee-4b01-ad7c-36da0118712d
>12:31:19,255 DEBUG program: Return code: 0
>12:31:19,259 INFO program: Running... udevadm settle --timeout=300
>12:31:19,336 DEBUG program: Return code: 0
>12:31:19,344 INFO program: Running... udevadm settle --timeout=300
>12:31:19,392 DEBUG program: Return code: 0
>12:31:19,401 INFO program: Running... lvm vgs --noheadings --nosuffix --nameprefixes --unquoted --units m -o uuid,size,free,extent_size,extent_count,free_count,pv_count --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] } global {locking_type=4}  fedora_gasoline
>12:31:19,465 INFO program:   LVM2_VG_UUID=mSmiQT-YgvB-RwoW-3CSl-bxG7-LM0v-DNlzVV LVM2_VG_SIZE=476436.00 LVM2_VG_FREE=472468.00 LVM2_VG_EXTENT_SIZE=4.00 LVM2_VG_EXTENT_COUNT=119109 LVM2_VG_FREE_COUNT=118117 LVM2_PV_COUNT=1
>12:31:19,466 DEBUG program: Return code: 0
>12:31:19,470 INFO program: Running... lvm lvcreate -L 421204m -n home -y --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline
>12:31:19,743 INFO program:   Logical volume "home" created
>12:31:19,744 DEBUG program: Return code: 0
>12:31:19,753 INFO program: Running... udevadm settle --timeout=300
>12:31:19,803 DEBUG program: Return code: 0
>12:31:19,830 INFO program: Running... udevadm settle --timeout=300
>12:31:19,884 DEBUG program: Return code: 0
>12:31:19,894 INFO program: Running... mke2fs -t ext4 /dev/mapper/fedora_gasoline-home
>12:31:23,673 INFO program: mke2fs 1.42.10 (18-May-2014)
>12:31:23,674 INFO program: Creating filesystem with 107828224 4k blocks and 26959872 inodes
>12:31:23,674 INFO program: Filesystem UUID: 6e2dd650-6c75-4a54-8a24-e1f2c9d56ec0
>12:31:23,675 INFO program: Superblock backups stored on blocks: 
>12:31:23,675 INFO program: 	32768, 98304, 163840, 229376, 294912, 819200, 884736, 1605632, 2654208, 
>12:31:23,675 INFO program: 	4096000, 7962624, 11239424, 20480000, 23887872, 71663616, 78675968, 
>12:31:23,676 INFO program: 	102400000
>12:31:23,676 INFO program: 
>12:31:23,676 INFO program: Allocating group tables:    0/3291         done                            
>12:31:23,676 INFO program: Writing inode tables:    0/3291         done                            
>12:31:23,677 INFO program: Creating journal (32768 blocks): done
>12:31:23,677 INFO program: Writing superblocks and filesystem accounting information:    0/3291         done
>12:31:23,677 INFO program: 
>12:31:23,677 DEBUG program: Return code: 0
>12:31:23,681 INFO program: Running... udevadm settle --timeout=300
>12:31:23,842 DEBUG program: Return code: 0
>12:31:23,849 INFO program: Running... udevadm settle --timeout=300
>12:31:23,899 DEBUG program: Return code: 0
>12:31:23,908 INFO program: Running... lvm vgs --noheadings --nosuffix --nameprefixes --unquoted --units m -o uuid,size,free,extent_size,extent_count,free_count,pv_count --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] } global {locking_type=4}  fedora_gasoline
>12:31:24,013 INFO program:   LVM2_VG_UUID=mSmiQT-YgvB-RwoW-3CSl-bxG7-LM0v-DNlzVV LVM2_VG_SIZE=476436.00 LVM2_VG_FREE=51264.00 LVM2_VG_EXTENT_SIZE=4.00 LVM2_VG_EXTENT_COUNT=119109 LVM2_VG_FREE_COUNT=12816 LVM2_PV_COUNT=1
>12:31:24,014 DEBUG program: Return code: 0
>12:31:24,017 INFO program: Running... lvm lvcreate -L 51200m -n root -y --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline
>12:31:24,315 INFO program:   Logical volume "root" created
>12:31:24,316 DEBUG program: Return code: 0
>12:31:24,322 INFO program: Running... udevadm settle --timeout=300
>12:31:24,390 DEBUG program: Return code: 0
>12:31:24,399 INFO program: Running... udevadm settle --timeout=300
>12:31:24,450 DEBUG program: Return code: 0
>12:31:24,460 INFO program: Running... mke2fs -t ext4 /dev/mapper/fedora_gasoline-root
>12:31:27,421 INFO program: mke2fs 1.42.10 (18-May-2014)
>12:31:27,422 INFO program: Creating filesystem with 13107200 4k blocks and 3276800 inodes
>12:31:27,422 INFO program: Filesystem UUID: 36bc4f5c-02b8-4f72-a85d-7bda09f0ca53
>12:31:27,422 INFO program: Superblock backups stored on blocks: 
>12:31:27,422 INFO program: 	32768, 98304, 163840, 229376, 294912, 819200, 884736, 1605632, 2654208, 
>12:31:27,423 INFO program: 	4096000, 7962624, 11239424
>12:31:27,423 INFO program: 
>12:31:27,423 INFO program: Allocating group tables:   0/400       done                            
>12:31:27,423 INFO program: Writing inode tables:   0/400       done                            
>12:31:27,424 INFO program: Creating journal (32768 blocks): done
>12:31:27,424 INFO program: Writing superblocks and filesystem accounting information:   0/400       done
>12:31:27,424 INFO program: 
>12:31:27,424 DEBUG program: Return code: 0
>12:31:27,427 INFO program: Running... udevadm settle --timeout=300
>12:31:27,498 DEBUG program: Return code: 0
>12:31:27,505 INFO program: Running... udevadm settle --timeout=300
>12:31:27,555 DEBUG program: Return code: 0
>12:31:28,001 INFO program: Running... swapon /dev/mapper/fedora_gasoline-swap
>12:31:28,048 DEBUG program: Return code: 0
>12:31:28,138 INFO program: Running... mount -t ext4 -o defaults /dev/mapper/fedora_gasoline-root /mnt/sysimage
>12:31:28,226 DEBUG program: Return code: 0
>12:31:28,267 INFO program: Running... mount -t ext4 -o defaults /dev/sda1 /mnt/sysimage/boot
>12:31:28,328 DEBUG program: Return code: 0
>12:31:28,364 INFO program: Running... mount -t bind -o bind,defaults /dev /mnt/sysimage/dev
>12:31:28,403 DEBUG program: Return code: 0
>12:31:28,407 INFO program: Running... mount -t devpts -o gid=5,mode=620 devpts /mnt/sysimage/dev/pts
>12:31:28,446 DEBUG program: Return code: 0
>12:31:28,450 INFO program: Running... mount -t tmpfs -o defaults tmpfs /mnt/sysimage/dev/shm
>12:31:28,489 DEBUG program: Return code: 0
>12:31:28,518 INFO program: Running... mount -t ext4 -o defaults /dev/mapper/fedora_gasoline-home /mnt/sysimage/home
>12:31:28,623 DEBUG program: Return code: 0
>12:31:28,667 INFO program: Running... mount -t proc -o defaults proc /mnt/sysimage/proc
>12:31:28,704 DEBUG program: Return code: 0
>12:31:28,890 INFO program: Running... mount -t bind -o bind,defaults /run /mnt/sysimage/run
>12:31:28,929 DEBUG program: Return code: 0
>12:31:28,947 INFO program: Running... mount -t sysfs -o defaults sysfs /mnt/sysimage/sys
>12:31:28,984 DEBUG program: Return code: 0
>12:31:28,989 INFO program: Running... mount -t selinuxfs -o defaults selinuxfs /mnt/sysimage/sys/fs/selinux
>12:31:29,027 DEBUG program: Return code: 0
>12:31:29,041 INFO program: Running... ostree admin --sysroot=/mnt/sysimage init-fs /mnt/sysimage
>12:31:29,192 DEBUG program: Return code: 0
>12:31:29,193 INFO program: Running... ostree --repo=/mnt/sysimage/ostree/repo remote add --set=gpg-verify=false fedora-atomic http://10.34.102.95:8000/repo
>12:31:29,279 DEBUG program: Return code: 0
>14:32:42,952 INFO program: Running... ostree admin --sysroot=/mnt/sysimage os-init fedora-atomic
>14:32:43,012 INFO program: /mnt/sysimage/ostree/deploy/fedora-atomic initialized as OSTree root
>14:32:43,013 DEBUG program: Return code: 0
>14:32:43,014 INFO program: Running... ostree admin --sysroot=/mnt/sysimage deploy --os=fedora-atomic fedora-atomic:fedora-atomic/rawhide/x86_64/base
>14:33:59,409 INFO program: ostadmin: Creating deployment /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0
>14:33:59,410 INFO program: ostadmin: No previous configuration changes to merge
>14:33:59,410 INFO program: ostadmin: Didn't find '/mnt/sysimage/ostree/deploy/fedora-atomic/var/.ostree-selabeled', relabeling /var
>14:33:59,411 INFO program: Transaction complete; bootconfig swap: yes deployment count change: 1)
>14:33:59,411 DEBUG program: Return code: 0
>14:33:59,468 INFO program: Running... udevadm settle --timeout=300
>14:33:59,530 DEBUG program: Return code: 0
>14:33:59,531 INFO program: Running... umount /mnt/sysimage/sys/fs/selinux
>14:33:59,586 DEBUG program: Return code: 0
>14:33:59,590 INFO program: Running... udevadm settle --timeout=300
>14:33:59,648 DEBUG program: Return code: 0
>14:33:59,649 INFO program: Running... umount /mnt/sysimage/sys
>14:33:59,699 DEBUG program: Return code: 0
>14:33:59,703 INFO program: Running... udevadm settle --timeout=300
>14:33:59,759 DEBUG program: Return code: 0
>14:33:59,760 INFO program: Running... umount /mnt/sysimage/run
>14:33:59,812 DEBUG program: Return code: 0
>14:33:59,817 INFO program: Running... udevadm settle --timeout=300
>14:33:59,874 DEBUG program: Return code: 0
>14:33:59,958 INFO program: Running... udevadm settle --timeout=300
>14:34:00,014 DEBUG program: Return code: 0
>14:34:00,015 INFO program: Running... umount /mnt/sysimage/proc
>14:34:00,075 DEBUG program: Return code: 0
>14:34:00,079 INFO program: Running... udevadm settle --timeout=300
>14:34:00,134 DEBUG program: Return code: 0
>14:34:00,135 INFO program: Running... umount /mnt/sysimage/home
>14:34:00,393 DEBUG program: Return code: 0
>14:34:00,399 INFO program: Running... udevadm settle --timeout=300
>14:34:00,455 DEBUG program: Return code: 0
>14:34:00,458 INFO program: Running... lvm lvchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/home
>14:34:00,644 DEBUG program: Return code: 0
>14:34:00,646 INFO program: Running... udevadm settle --timeout=300
>14:34:00,701 DEBUG program: Return code: 0
>14:34:00,702 INFO program: Running... umount /mnt/sysimage/dev/shm
>14:34:00,755 DEBUG program: Return code: 0
>14:34:00,758 INFO program: Running... udevadm settle --timeout=300
>14:34:00,813 DEBUG program: Return code: 0
>14:34:00,814 INFO program: Running... umount /mnt/sysimage/dev/pts
>14:34:00,873 DEBUG program: Return code: 0
>14:34:00,877 INFO program: Running... udevadm settle --timeout=300
>14:34:00,935 DEBUG program: Return code: 0
>14:34:00,936 INFO program: Running... umount /mnt/sysimage/dev
>14:34:00,990 DEBUG program: Return code: 0
>14:34:00,995 INFO program: Running... udevadm settle --timeout=300
>14:34:01,050 DEBUG program: Return code: 0
>14:34:01,052 INFO program: Running... udevadm settle --timeout=300
>14:34:01,109 DEBUG program: Return code: 0
>14:34:01,110 INFO program: Running... umount /mnt/sysimage/boot
>14:34:01,335 DEBUG program: Return code: 0
>14:34:01,341 INFO program: Running... udevadm settle --timeout=300
>14:34:01,393 DEBUG program: Return code: 0
>14:34:01,394 INFO program: Running... udevadm settle --timeout=300
>14:34:01,448 DEBUG program: Return code: 0
>14:34:01,449 INFO program: Running... umount /mnt/sysimage
>14:34:03,607 DEBUG program: Return code: 0
>14:34:03,612 INFO program: Running... udevadm settle --timeout=300
>14:34:03,665 DEBUG program: Return code: 0
>14:34:03,668 INFO program: Running... lvm lvchange -a n --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/root
>14:34:03,823 DEBUG program: Return code: 0
>14:34:03,836 INFO program: Running... lvm lvchange -a y --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/root
>14:34:04,108 DEBUG program: Return code: 0
>14:34:04,109 INFO program: Running... udevadm settle --timeout=300
>14:34:04,163 DEBUG program: Return code: 0
>14:34:04,165 INFO program: Running... mount -t ext4 -o defaults /dev/mapper/fedora_gasoline-root /mnt/sysimage
>14:34:04,285 DEBUG program: Return code: 0
>14:34:04,299 INFO program: Running... mount --bind /mnt/sysimage /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/sysroot
>14:34:04,397 DEBUG program: Return code: 0
>14:34:04,397 INFO program: Running... mount --bind /mnt/sysimage/ostree/deploy/fedora-atomic/var /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/var
>14:34:04,445 DEBUG program: Return code: 0
>14:34:04,446 INFO program: Running... mount --bind /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/usr /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/usr
>14:34:04,492 DEBUG program: Return code: 0
>14:34:04,493 INFO program: Running... mount --bind -o ro /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/usr /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/usr
>14:34:04,539 DEBUG program: Return code: 0
>14:34:04,540 INFO program: Running... systemd-tmpfiles --create --boot --root=/mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0 --prefix=/var/home
>14:34:04,652 DEBUG program: Return code: 0
>14:34:04,653 INFO program: Running... systemd-tmpfiles --create --boot --root=/mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0 --prefix=/var/roothome
>14:34:04,713 DEBUG program: Return code: 0
>14:34:04,714 INFO program: Running... systemd-tmpfiles --create --boot --root=/mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0 --prefix=/var/lib/rpm
>14:34:04,778 DEBUG program: Return code: 0
>14:34:04,779 INFO program: Running... systemd-tmpfiles --create --boot --root=/mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0 --prefix=/var/opt
>14:34:04,841 DEBUG program: Return code: 0
>14:34:04,842 INFO program: Running... systemd-tmpfiles --create --boot --root=/mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0 --prefix=/var/srv
>14:34:04,904 DEBUG program: Return code: 0
>14:34:04,905 INFO program: Running... systemd-tmpfiles --create --boot --root=/mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0 --prefix=/var/usrlocal
>14:34:04,968 DEBUG program: Return code: 0
>14:34:04,969 INFO program: Running... systemd-tmpfiles --create --boot --root=/mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0 --prefix=/var/mnt
>14:34:05,033 DEBUG program: Return code: 0
>14:34:05,034 INFO program: Running... systemd-tmpfiles --create --boot --root=/mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0 --prefix=/var/media
>14:34:05,096 DEBUG program: Return code: 0
>14:34:05,102 INFO program: Running... mount -t ext4 -o defaults /dev/sda1 /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/boot
>14:34:05,195 DEBUG program: Return code: 0
>14:34:05,203 INFO program: Running... mount -t bind -o bind,defaults /dev /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/dev
>14:34:05,249 DEBUG program: Return code: 0
>14:34:05,253 INFO program: Running... mount -t devpts -o gid=5,mode=620 devpts /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/dev/pts
>14:34:05,298 DEBUG program: Return code: 0
>14:34:05,303 INFO program: Running... mount -t tmpfs -o defaults tmpfs /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/dev/shm
>14:34:05,348 DEBUG program: Return code: 0
>14:34:05,359 INFO program: Running... lvm lvchange -a y --config  devices { preferred_names=["^/dev/mapper/", "^/dev/md/", "^/dev/sd"] }  fedora_gasoline/home
>14:34:05,646 DEBUG program: Return code: 0
>14:34:05,647 INFO program: Running... udevadm settle --timeout=300
>14:34:05,703 DEBUG program: Return code: 0
>14:35:01,283 INFO program: Running... lsblk --perms --fs --bytes
>14:35:01,357 INFO program: NAME                             SIZE OWNER GROUP MODE       NAME                     FSTYPE          LABEL    UUID                                   MOUNTPOINT
>14:35:01,358 INFO program: sda                      500107862016 root  disk  brw-rw---- sda
>14:35:01,358 INFO program: |-sda1                      524288000 root  disk  brw-rw---- |-sda1                   ext4                     25fa0b0e-c575-4489-b674-995d620f35a4   /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/sysroot/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/boot
>14:35:01,359 INFO program: `-sda2                   499582500864 root  disk  brw-rw---- `-sda2                   LVM2_member              a2GoIS-26JW-YCXF-XlFz-I6S3-c6sP-osuCUW
>14:35:01,359 INFO program: |-fedora_gasoline-swap   4160749568 root  disk  brw-rw----   |-fedora_gasoline-swap swap                     5af788b5-b3ee-4b01-ad7c-36da0118712d   [SWAP]
>14:35:01,359 INFO program: |-fedora_gasoline-root  53687091200 root  disk  brw-rw----   |-fedora_gasoline-root ext4                     36bc4f5c-02b8-4f72-a85d-7bda09f0ca53   /mnt/sysimage/ostree/deploy/fedora-atomic/deploy/60506ba30bdd1a5070dda106492f4bacd2cf947026f615343e78437608947c71.0/sysroot
>14:35:01,360 INFO program: `-fedora_gasoline-home 441664405504 root  disk  brw-rw----   `-fedora_gasoline-home ext4                     6e2dd650-6c75-4a54-8a24-e1f2c9d56ec0
>14:35:01,360 INFO program: sr0                        1073741312 root  cdrom brw-rw---- sr0
>14:35:01,360 INFO program: loop0                       285392896 root  disk  brw-rw---- loop0                    squashfs
>14:35:01,361 INFO program: loop1                      2147483648 root  disk  brw-rw---- loop1                    ext4            Anaconda ee533e9b-3ada-4bfc-b950-c5e2b6fc2103
>14:35:01,361 INFO program: |-live-rw                  2147483648 root  disk  brw-rw---- |-live-rw                ext4            Anaconda ee533e9b-3ada-4bfc-b950-c5e2b6fc2103   /
>14:35:01,361 INFO program: `-live-base                2147483648 root  disk  brw-rw---- `-live-base              ext4            Anaconda ee533e9b-3ada-4bfc-b950-c5e2b6fc2103
>14:35:01,362 INFO program: loop2                       536870912 root  disk  brw-rw---- loop2
>14:35:01,362 INFO program: `-live-rw                  2147483648 root  disk  brw-rw---- `-live-rw                ext4            Anaconda ee533e9b-3ada-4bfc-b950-c5e2b6fc2103   /
>14:35:01,362 INFO program: loop3                       285392896 root  disk  brw-rw---- loop3                    squashfs
>14:35:01,362 INFO program: loop4                      2147483648 root  disk  brw-rw---- loop4                    ext4            Anaconda ee533e9b-3ada-4bfc-b950-c5e2b6fc2103
>14:35:01,363 INFO program: loop5                       536870912 root  disk  brw-rw---- loop5                    DM_snapshot_cow
>14:35:01,363 INFO program: loop6                       285392896 root  disk  brw-rw---- loop6                    squashfs
>14:35:01,363 INFO program: loop7                      2147483648 root  disk  brw-rw---- loop7                    ext4            Anaconda ee533e9b-3ada-4bfc-b950-c5e2b6fc2103
>14:35:01,364 INFO program: loop8                       536870912 root  disk  brw-rw---- loop8                    DM_snapshot_cow
>14:35:01,364 DEBUG program: Return code: 0
>14:35:01,364 INFO program: Running... nmcli device show
>14:35:01,464 INFO program: GENERAL.DEVICE:                         em1
>14:35:01,465 INFO program: GENERAL.TYPE:                           ethernet
>14:35:01,466 INFO program: GENERAL.HWADDR:                         F4:CE:46:2C:44:7A
>14:35:01,466 INFO program: GENERAL.MTU:                            1500
>14:35:01,466 INFO program: GENERAL.STATE:                          100 (connected)
>14:35:01,467 INFO program: GENERAL.CONNECTION:                     em1
>14:35:01,467 INFO program: GENERAL.CON-PATH:                       /org/freedesktop/NetworkManager/ActiveConnection/0
>14:35:01,467 INFO program: WIRED-PROPERTIES.CARRIER:               on
>14:35:01,468 INFO program: IP4.ADDRESS[1]:                         ip = 10.34.102.101/24, gw = 10.34.102.254
>14:35:01,468 INFO program: IP4.ROUTE[1]:                           dst = 10.34.39.2/32, nh = 10.34.102.254, mt = 0
>14:35:01,469 INFO program: IP4.DNS[1]:                             10.34.39.2
>14:35:01,469 INFO program: IP4.DOMAIN[1]:                          anaconda.englab.brq.redhat.com
>14:35:01,469 INFO program: IP4.DOMAIN[2]:                          englab.brq.redhat.com
>14:35:01,470 INFO program: IP4.DOMAIN[3]:                          brq.redhat.com
>14:35:01,470 INFO program: IP4.DOMAIN[4]:                          redhat.com
>14:35:01,470 INFO program: IP6.ADDRESS[1]:                         ip = 2620:52:0:2266:f6ce:46ff:fe2c:447a/64, gw = fe80::5675:d0ff:feac:4d3f
>14:35:01,471 INFO program: IP6.ADDRESS[2]:                         ip = fe80::f6ce:46ff:fe2c:447a/64, gw = fe80::5675:d0ff:feac:4d3f
>14:35:01,471 INFO program: IP6.ROUTE[1]:                           dst = 2620:52:0:2266::/64, nh = ::, mt = 0
>14:35:01,472 INFO program: 
>14:35:01,472 INFO program: GENERAL.DEVICE:                         p3p1
>14:35:01,472 INFO program: GENERAL.TYPE:                           ethernet
>14:35:01,472 INFO program: GENERAL.HWADDR:                         00:15:17:96:75:0A
>14:35:01,473 INFO program: GENERAL.MTU:                            1500
>14:35:01,473 INFO program: GENERAL.STATE:                          100 (connected)
>14:35:01,474 INFO program: GENERAL.CONNECTION:                     p3p1
>14:35:01,474 INFO program: GENERAL.CON-PATH:                       /org/freedesktop/NetworkManager/ActiveConnection/1
>14:35:01,474 INFO program: WIRED-PROPERTIES.CARRIER:               on
>14:35:01,475 INFO program: IP4.ADDRESS[1]:                         ip = 10.34.102.50/24, gw = 10.34.102.254
>14:35:01,475 INFO program: IP4.ADDRESS[2]:                         ip = 10.34.102.52/24, gw = 10.34.102.254
>14:35:01,475 INFO program: IP4.ROUTE[1]:                           dst = 10.34.39.2/32, nh = 10.34.102.254, mt = 0
>14:35:01,476 INFO program: IP4.DNS[1]:                             10.34.39.2
>14:35:01,476 INFO program: IP4.DOMAIN[1]:                          anaconda.englab.brq.redhat.com
>14:35:01,476 INFO program: IP4.DOMAIN[2]:                          englab.brq.redhat.com
>14:35:01,477 INFO program: IP4.DOMAIN[3]:                          brq.redhat.com
>14:35:01,477 INFO program: IP4.DOMAIN[4]:                          redhat.com
>14:35:01,478 INFO program: IP6.ADDRESS[1]:                         ip = 2620:52:0:2266:215:17ff:fe96:750a/64, gw = fe80::5675:d0ff:feac:4d3f
>14:35:01,478 INFO program: IP6.ADDRESS[2]:                         ip = fe80::215:17ff:fe96:750a/64, gw = fe80::5675:d0ff:feac:4d3f
>14:35:01,478 INFO program: IP6.ROUTE[1]:                           dst = 2620:52:0:2266::/64, nh = ::, mt = 0
>14:35:01,479 INFO program: 
>14:35:01,479 INFO program: GENERAL.DEVICE:                         p3p2
>14:35:01,479 INFO program: GENERAL.TYPE:                           ethernet
>14:35:01,480 INFO program: GENERAL.HWADDR:                         00:15:17:96:75:0B
>14:35:01,480 INFO program: GENERAL.MTU:                            1500
>14:35:01,480 INFO program: GENERAL.STATE:                          100 (connected)
>14:35:01,481 INFO program: GENERAL.CONNECTION:                     p3p2
>14:35:01,481 INFO program: GENERAL.CON-PATH:                       /org/freedesktop/NetworkManager/ActiveConnection/2
>14:35:01,481 INFO program: WIRED-PROPERTIES.CARRIER:               on
>14:35:01,482 INFO program: IP4.ADDRESS[1]:                         ip = 10.34.102.49/24, gw = 10.34.102.254
>14:35:01,482 INFO program: IP4.ADDRESS[2]:                         ip = 10.34.102.91/24, gw = 10.34.102.254
>14:35:01,482 INFO program: IP4.ROUTE[1]:                           dst = 10.34.39.2/32, nh = 10.34.102.254, mt = 0
>14:35:01,483 INFO program: IP4.DNS[1]:                             10.34.39.2
>14:35:01,483 INFO program: IP4.DOMAIN[1]:                          anaconda.englab.brq.redhat.com
>14:35:01,483 INFO program: IP4.DOMAIN[2]:                          englab.brq.redhat.com
>14:35:01,484 INFO program: IP4.DOMAIN[3]:                          brq.redhat.com
>14:35:01,484 INFO program: IP4.DOMAIN[4]:                          redhat.com
>14:35:01,485 INFO program: IP6.ADDRESS[1]:                         ip = 2620:52:0:2266:215:17ff:fe96:750b/64, gw = fe80::5675:d0ff:feac:4d3f
>14:35:01,485 INFO program: IP6.ADDRESS[2]:                         ip = fe80::215:17ff:fe96:750b/64, gw = fe80::5675:d0ff:feac:4d3f
>14:35:01,485 INFO program: IP6.ROUTE[1]:                           dst = 2620:52:0:2266::/64, nh = ::, mt = 0
>14:35:01,486 INFO program: 
>14:35:01,486 INFO program: GENERAL.DEVICE:                         lo
>14:35:01,486 INFO program: GENERAL.TYPE:                           loopback
>14:35:01,487 INFO program: GENERAL.HWADDR:                         00:00:00:00:00:00
>14:35:01,487 INFO program: GENERAL.MTU:                            65536
>14:35:01,487 INFO program: GENERAL.STATE:                          10 (unmanaged)
>14:35:01,488 INFO program: GENERAL.CONNECTION:                     --
>14:35:01,488 INFO program: GENERAL.CON-PATH:                       --
>14:35:01,488 DEBUG program: Return code: 0

Actions: View

Attachments on bug 1107667: 907202 | 907203 | 907204 | 907205 | 907206 | 907207 | 907208 | 907209 | 907210 | 907211 | 907212