Attachment 624555 Details for Bug 864765 – File: storage.log

File: storage.log

storage.log (text/plain), 209.64 KB, created by Chris Murphy on 2012-10-10 04:36:46 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Chris Murphy

Created: 2012-10-10 04:36:46 UTC

Size: 209.64 KB

patch

obsolete

>04:32:38,121 DEBUG storage: registered device format class BIOSBoot as biosboot
>04:32:38,123 DEBUG storage: registered device format class DMRaidMember as dmraidmember
>04:32:38,124 DEBUG storage: registered device format class LVMPhysicalVolume as lvmpv
>04:32:38,125 DEBUG storage: registered device format class PPCPRePBoot as prepboot
>04:32:38,151 DEBUG storage: registered device format class LUKS as luks
>04:32:38,153 DEBUG storage: registered device format class MDRaidMember as mdmember
>04:32:38,154 DEBUG storage: registered device format class MultipathMember as multipath_member
>04:32:38,169 DEBUG storage: registered device format class Ext2FS as ext2
>04:32:38,170 DEBUG storage: registered device format class Ext3FS as ext3
>04:32:38,171 DEBUG storage: registered device format class Ext4FS as ext4
>04:32:38,171 DEBUG storage: registered device format class FATFS as vfat
>04:32:38,172 DEBUG storage: registered device format class EFIFS as efi
>04:32:38,172 DEBUG storage: registered device format class BTRFS as btrfs
>04:32:38,173 DEBUG storage: registered device format class GFS2 as gfs2
>04:32:38,173 DEBUG storage: registered device format class JFS as jfs
>04:32:38,174 DEBUG storage: registered device format class ReiserFS as reiserfs
>04:32:38,174 DEBUG storage: registered device format class XFS as xfs
>04:32:38,175 DEBUG storage: registered device format class HFS as hfs
>04:32:38,175 DEBUG storage: registered device format class AppleBootstrapFS as appleboot
>04:32:38,176 DEBUG storage: registered device format class HFSPlus as hfs+
>04:32:38,176 DEBUG storage: registered device format class NTFS as ntfs
>04:32:38,177 DEBUG storage: registered device format class NFS as nfs
>04:32:38,177 DEBUG storage: registered device format class NFSv4 as nfs4
>04:32:38,178 DEBUG storage: registered device format class Iso9660FS as iso9660
>04:32:38,178 DEBUG storage: registered device format class NoDevFS as nodev
>04:32:38,179 DEBUG storage: registered device format class DevPtsFS as devpts
>04:32:38,179 DEBUG storage: registered device format class ProcFS as proc
>04:32:38,180 DEBUG storage: registered device format class SysFS as sysfs
>04:32:38,180 DEBUG storage: registered device format class TmpFS as tmpfs
>04:32:38,181 DEBUG storage: registered device format class BindFS as bind
>04:32:38,181 DEBUG storage: registered device format class SELinuxFS as selinuxfs
>04:32:38,182 DEBUG storage: registered device format class USBFS as usbfs
>04:32:38,185 DEBUG storage: registered device format class DiskLabel as disklabel
>04:32:38,188 DEBUG storage: registered device format class SwapSpace as swap
>04:32:38,799 DEBUG storage:      MultipathTopology._build_topology:
>04:32:38,799 DEBUG storage: /etc/multipath.conf contents:
>04:32:38,799 DEBUG storage: # multipath.conf written by anaconda
>04:32:38,799 DEBUG storage: 
>04:32:38,799 DEBUG storage: defaults {
>04:32:38,800 DEBUG storage: 	user_friendly_names yes
>04:32:38,800 DEBUG storage: }
>04:32:38,800 DEBUG storage: blacklist {
>04:32:38,800 DEBUG storage: 	devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
>04:32:38,800 DEBUG storage: 	devnode "^hd[a-z]"
>04:32:38,800 DEBUG storage: 	devnode "^dcssblk[0-9]*"
>04:32:38,800 DEBUG storage: 	device {
>04:32:38,800 DEBUG storage: 		vendor "DGC"
>04:32:38,800 DEBUG storage: 		product "LUNZ"
>04:32:38,800 DEBUG storage: 	}
>04:32:38,801 DEBUG storage: 	device {
>04:32:38,801 DEBUG storage: 		vendor "IBM"
>04:32:38,801 DEBUG storage: 		product "S/390.*"
>04:32:38,801 DEBUG storage: 	}
>04:32:38,802 DEBUG storage: 	# don't count normal SATA devices as multipaths
>04:32:38,802 DEBUG storage: 	device {
>04:32:38,802 DEBUG storage: 		vendor  "ATA"
>04:32:38,802 DEBUG storage: 	}
>04:32:38,802 DEBUG storage: 	# don't count 3ware devices as multipaths
>04:32:38,802 DEBUG storage: 	device {
>04:32:38,806 DEBUG storage: 		vendor  "3ware"
>04:32:38,806 DEBUG storage: 	}
>04:32:38,806 DEBUG storage: 	device {
>04:32:38,806 DEBUG storage: 		vendor  "AMCC"
>04:32:38,806 DEBUG storage: 	}
>04:32:38,806 DEBUG storage: 	# nor highpoint devices
>04:32:38,806 DEBUG storage: 	device {
>04:32:38,807 DEBUG storage: 		vendor  "HPT"
>04:32:38,807 DEBUG storage: 	}
>04:32:38,807 DEBUG storage: }
>04:32:38,807 DEBUG storage: multipaths {
>04:32:38,808 DEBUG storage: }
>04:32:38,808 DEBUG storage: (end of /etc/multipath.conf)
>04:32:38,858 INFO storage: MultipathTopology: found non-disk device: sr0
>04:32:38,859 INFO storage: MultipathTopology: found singlepath device: sda
>04:32:38,859 INFO storage: MultipathTopology: found singlepath device: sdb
>04:32:38,860 INFO storage: MultipathTopology: found singlepath device: loop0
>04:32:38,860 INFO storage: MultipathTopology: found singlepath device: loop1
>04:32:38,861 INFO storage: MultipathTopology: found singlepath device: loop2
>04:32:38,864 INFO storage: MultipathTopology: found singlepath device: loop3
>04:32:38,870 INFO storage: MultipathTopology: found singlepath device: loop4
>04:32:38,870 INFO storage: MultipathTopology: found singlepath device: loop5
>04:32:38,870 INFO storage: MultipathTopology: found singlepath device: loop6
>04:32:38,871 INFO storage: MultipathTopology: found singlepath device: loop7
>04:32:38,871 INFO storage: MultipathTopology: found singlepath device: dm-0
>04:32:40,788 INFO storage: not going to create backup copy of non-existent /etc/mdadm.conf
>04:32:40,788 INFO storage: DeviceTree.populate: ignoredDisks is [] ; exclusiveDisks is []
>04:32:40,932 DEBUG storage:           MultipathTopology._build_topology:
>04:32:40,933 DEBUG storage: /etc/multipath.conf contents:
>04:32:40,933 DEBUG storage: # multipath.conf written by anaconda
>04:32:40,947 DEBUG storage: 
>04:32:40,948 DEBUG storage: defaults {
>04:32:40,948 DEBUG storage: 	user_friendly_names yes
>04:32:40,948 DEBUG storage: }
>04:32:40,948 DEBUG storage: blacklist {
>04:32:40,949 DEBUG storage: 	devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
>04:32:40,949 DEBUG storage: 	devnode "^hd[a-z]"
>04:32:40,949 DEBUG storage: 	devnode "^dcssblk[0-9]*"
>04:32:40,949 DEBUG storage: 	device {
>04:32:40,950 DEBUG storage: 		vendor "DGC"
>04:32:40,951 DEBUG storage: 		product "LUNZ"
>04:32:40,951 DEBUG storage: 	}
>04:32:40,951 DEBUG storage: 	device {
>04:32:40,951 DEBUG storage: 		vendor "IBM"
>04:32:40,952 DEBUG storage: 		product "S/390.*"
>04:32:40,952 DEBUG storage: 	}
>04:32:40,959 DEBUG storage: 	# don't count normal SATA devices as multipaths
>04:32:40,959 DEBUG storage: 	device {
>04:32:40,959 DEBUG storage: 		vendor  "ATA"
>04:32:40,988 DEBUG storage: 	}
>04:32:40,999 DEBUG storage: 	# don't count 3ware devices as multipaths
>04:32:41,002 DEBUG storage: 	device {
>04:32:41,002 DEBUG storage: 		vendor  "3ware"
>04:32:41,006 DEBUG storage: 	}
>04:32:41,007 DEBUG storage: 	device {
>04:32:41,008 DEBUG storage: 		vendor  "AMCC"
>04:32:41,009 DEBUG storage: 	}
>04:32:41,015 DEBUG storage: 	# nor highpoint devices
>04:32:41,024 DEBUG storage: 	device {
>04:32:41,044 DEBUG storage: 		vendor  "HPT"
>04:32:41,047 DEBUG storage: 	}
>04:32:41,049 DEBUG storage: }
>04:32:41,061 DEBUG storage: multipaths {
>04:32:41,064 DEBUG storage: }
>04:32:41,065 DEBUG storage: (end of /etc/multipath.conf)
>04:32:41,112 INFO storage: MultipathTopology: found non-disk device: sr0
>04:32:41,114 INFO storage: MultipathTopology: found singlepath device: sda
>04:32:41,114 INFO storage: MultipathTopology: found singlepath device: sdb
>04:32:41,115 INFO storage: MultipathTopology: found singlepath device: loop0
>04:32:41,116 INFO storage: MultipathTopology: found singlepath device: loop1
>04:32:41,117 INFO storage: MultipathTopology: found singlepath device: loop2
>04:32:41,117 INFO storage: MultipathTopology: found singlepath device: loop3
>04:32:41,118 INFO storage: MultipathTopology: found singlepath device: loop4
>04:32:41,119 INFO storage: MultipathTopology: found singlepath device: loop5
>04:32:41,119 INFO storage: MultipathTopology: found singlepath device: loop6
>04:32:41,121 INFO storage: MultipathTopology: found singlepath device: loop7
>04:32:41,122 INFO storage: MultipathTopology: found singlepath device: dm-0
>04:32:41,122 INFO storage: devices to scan: ['sr0', 'sda', 'sdb', 'loop0', 'loop1', 'loop2', 'loop3', 'loop4', 'loop5', 'loop6', 'loop7', 'dm-0']
>04:32:41,126 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVLINKS': '/dev/cdrom /dev/disk/by-id/ata-VBOX_CD-ROM_VB0-01f003f6 /dev/disk/by-label/Fedora\\x2018-Beta-TC3\\x20x86_64 /dev/disk/by-uuid/2012-10-09-19-57-35-00',
> 'DEVNAME': 'sr0',
> 'DEVPATH': '/devices/pci0000:00/0000:00:01.1/ata8/host7/target7:0:0/7:0:0:0/block/sr0',
> 'DEVTYPE': 'disk',
> 'ID_ATA': '1',
> 'ID_BUS': 'ata',
> 'ID_CDROM': '1',
> 'ID_CDROM_CD': '1',
> 'ID_CDROM_DVD': '1',
> 'ID_CDROM_MEDIA': '1',
> 'ID_CDROM_MEDIA_CD': '1',
> 'ID_CDROM_MEDIA_SESSION_COUNT': '1',
> 'ID_CDROM_MEDIA_TRACK_COUNT': '1',
> 'ID_CDROM_MEDIA_TRACK_COUNT_DATA': '1',
> 'ID_FS_LABEL': 'Fedora_18-Beta-TC3_x86_64',
> 'ID_FS_LABEL_ENC': 'Fedora\\x2018-Beta-TC3\\x20x86_64',
> 'ID_FS_TYPE': 'iso9660',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '2012-10-09-19-57-35-00',
> 'ID_FS_UUID_ENC': '2012-10-09-19-57-35-00',
> 'ID_MODEL': 'VBOX_CD-ROM',
> 'ID_MODEL_ENC': 'VBOX\\x20CD-ROM\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20',
> 'ID_PART_TABLE_TYPE': 'dos',
> 'ID_REVISION': '1.0',
> 'ID_SERIAL': 'VBOX_CD-ROM_VB0-01f003f6',
> 'ID_SERIAL_SHORT': 'VB0-01f003f6',
> 'ID_TYPE': 'cd',
> 'MAJOR': '11',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':seat:systemd:uaccess:',
> 'USEC_INITIALIZED': '382919',
> 'name': 'sr0',
> 'symlinks': ['/dev/cdrom',
>              '/dev/disk/by-id/ata-VBOX_CD-ROM_VB0-01f003f6',
>              '/dev/disk/by-label/Fedora\\x2018-Beta-TC3\\x20x86_64',
>              '/dev/disk/by-uuid/2012-10-09-19-57-35-00'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:01.1/ata8/host7/target7:0:0/7:0:0:0/block/sr0'} ; name: sr0 ;
>04:32:41,128 INFO storage: scanning sr0 (/devices/pci0000:00/0000:00:01.1/ata8/host7/target7:0:0/7:0:0:0/block/sr0)...
>04:32:41,129 DEBUG storage:           DeviceTree.getDeviceByName: name: sr0 ;
>04:32:41,131 DEBUG storage:           DeviceTree.getDeviceByName returned None
>04:32:41,131 INFO storage: sr0 is a cdrom
>04:32:41,133 DEBUG storage:           DeviceTree.addUdevOpticalDevice:
>04:32:41,134 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,137 DEBUG storage:               OpticalDevice._setFormat: sr0 ; current: None ; type: None ;
>04:32:41,139 INFO storage: added cdrom sr0 (id 0) to device tree
>04:32:41,140 DEBUG storage:           OpticalDevice.mediaPresent: sr0 ; status: True ;
>04:32:41,144 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: sr0 ;
>04:32:41,148 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: sr0 ; label_type: dos ;
>04:32:41,149 DEBUG storage:             OpticalDevice.setup: sr0 ; status: True ; controllable: True ; orig: False ;
>04:32:41,152 DEBUG storage:              DiskLabel.__init__: device: /dev/sr0 ; labelType: dos ; exists: True ;
>04:32:41,167 WARN storage: disklabel detected but not usable on sr0
>04:32:41,169 INFO storage: type detected on 'sr0' is 'iso9660'
>04:32:41,178 DEBUG storage:              Iso9660FS.supported: supported: True ;
>04:32:41,178 DEBUG storage: getFormat('iso9660') returning Iso9660FS instance
>04:32:41,180 DEBUG storage:             OpticalDevice._setFormat: sr0 ; current: None ; type: iso9660 ;
>04:32:41,182 DEBUG storage:              OpticalDevice.mediaPresent: sr0 ; status: True ;
>04:32:41,185 DEBUG storage: looking up parted Device: /dev/sr0
>04:32:41,186 INFO storage: got device: OpticalDevice instance (0x7f7c0acc7610) --
>  name = sr0  status = True  kids = 0 id = 0
>  parents = []
>  uuid = None  size = 261.0
>  format = existing iso9660 filesystem
>  major = 11  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:01.1/ata8/host7/target7:0:0/7:0:0:0/block/sr0  partedDevice = parted.Device instance --
>  model: VBOX CD-ROM  path: /dev/sr0  type: 1
>  sectorSize: 2048  physicalSectorSize:  2048
>  length: 133632  openCount: 0  readOnly: True
>  externalMode: False  dirty: False  bootDirty: False
>  host: 8  did: 0  busy: True
>  hardwareGeometry: (8, 255, 63)  biosGeometry: (8, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f7c115b84d0>
>  target size = 0  path = /dev/sr0
>  format args = []  originalFormat = None
>04:32:41,188 DEBUG storage:             Iso9660FS.supported: supported: True ;
>04:32:41,188 INFO storage: got format: Iso9660FS instance (0x7f7c119105d0) --
>  type = iso9660  name = iso9660  status = False
>  device = /dev/sr0  uuid = 2012-10-09-19-57-35-00  exists = True
>  options = ro  supported = True  formattable = False  resizable = False
>  mountpoint = None  mountopts = None
>  label = Fedora_18-Beta-TC3_x86_64  size = 0  targetSize = 0
>
>04:32:41,192 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVLINKS': '/dev/disk/by-id/ata-VBOX_HARDDISK_VB9d44dad8-52c70106',
> 'DEVNAME': 'sda',
> 'DEVPATH': '/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sda',
> 'DEVTYPE': 'disk',
> 'ID_ATA': '1',
> 'ID_ATA_FEATURE_SET_PM': '1',
> 'ID_ATA_FEATURE_SET_PM_ENABLED': '1',
> 'ID_ATA_SATA': '1',
> 'ID_ATA_SATA_SIGNAL_RATE_GEN2': '1',
> 'ID_ATA_WRITE_CACHE': '1',
> 'ID_ATA_WRITE_CACHE_ENABLED': '1',
> 'ID_BUS': 'ata',
> 'ID_MODEL': 'VBOX_HARDDISK',
> 'ID_MODEL_ENC': 'VBOX\\x20HARDDISK\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20',
> 'ID_REVISION': '1.0',
> 'ID_SERIAL': 'VBOX_HARDDISK_VB9d44dad8-52c70106',
> 'ID_SERIAL_SHORT': 'VB9d44dad8-52c70106',
> 'ID_TYPE': 'disk',
> 'MAJOR': '8',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '411081',
> 'name': 'sda',
> 'symlinks': ['/dev/disk/by-id/ata-VBOX_HARDDISK_VB9d44dad8-52c70106'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sda'} ; name: sda ;
>04:32:41,194 INFO storage: scanning sda (/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sda)...
>04:32:41,195 DEBUG storage:           DeviceTree.getDeviceByName: name: sda ;
>04:32:41,197 DEBUG storage:           DeviceTree.getDeviceByName returned None
>04:32:41,199 DEBUG storage:           DeviceTree.addUdevDiskDevice: name: sda ;
>04:32:41,200 INFO storage: sda is a disk
>04:32:41,201 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,203 DEBUG storage:               DiskDevice._setFormat: sda ; current: None ; type: None ;
>04:32:41,203 INFO storage: added disk sda (id 1) to device tree
>04:32:41,204 DEBUG storage: looking up parted Device: /dev/sda
>04:32:41,214 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: sda ;
>04:32:41,216 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: sda ; label_type: None ;
>04:32:41,220 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,221 DEBUG storage:             DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>04:32:41,225 DEBUG storage:              DiskLabel.__init__: device: /dev/sda ; labelType: msdos ; exists: True ;
>04:32:41,265 INFO storage: no usable disklabel on sda
>04:32:41,266 DEBUG storage: no type or existing type for sda, bailing
>04:32:41,267 INFO storage: got device: DiskDevice instance (0x7f7c118fa890) --
>  name = sda  status = True  kids = 0 id = 1
>  parents = []
>  uuid = None  size = 819200.0
>  format = existing None
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sda  partedDevice = parted.Device instance --
>  model: ATA VBOX HARDDISK  path: /dev/sda  type: 1
>  sectorSize: 512  physicalSectorSize:  512
>  length: 1677721600  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: False
>  hardwareGeometry: (104433, 255, 63)  biosGeometry: (104433, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f7c115b8680>
>  target size = 0  path = /dev/sda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7f7c114de2d0>
>04:32:41,270 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVLINKS': '/dev/disk/by-id/ata-VBOX_HARDDISK_VB5fba628c-098ffa57',
> 'DEVNAME': 'sdb',
> 'DEVPATH': '/devices/pci0000:00/0000:00:0d.0/ata2/host1/target1:0:0/1:0:0:0/block/sdb',
> 'DEVTYPE': 'disk',
> 'ID_ATA': '1',
> 'ID_ATA_FEATURE_SET_PM': '1',
> 'ID_ATA_FEATURE_SET_PM_ENABLED': '1',
> 'ID_ATA_SATA': '1',
> 'ID_ATA_SATA_SIGNAL_RATE_GEN2': '1',
> 'ID_ATA_WRITE_CACHE': '1',
> 'ID_ATA_WRITE_CACHE_ENABLED': '1',
> 'ID_BUS': 'ata',
> 'ID_MODEL': 'VBOX_HARDDISK',
> 'ID_MODEL_ENC': 'VBOX\\x20HARDDISK\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20',
> 'ID_REVISION': '1.0',
> 'ID_SERIAL': 'VBOX_HARDDISK_VB5fba628c-098ffa57',
> 'ID_SERIAL_SHORT': 'VB5fba628c-098ffa57',
> 'ID_TYPE': 'disk',
> 'MAJOR': '8',
> 'MINOR': '16',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '415450',
> 'name': 'sdb',
> 'symlinks': ['/dev/disk/by-id/ata-VBOX_HARDDISK_VB5fba628c-098ffa57'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:0d.0/ata2/host1/target1:0:0/1:0:0:0/block/sdb'} ; name: sdb ;
>04:32:41,272 INFO storage: scanning sdb (/devices/pci0000:00/0000:00:0d.0/ata2/host1/target1:0:0/1:0:0:0/block/sdb)...
>04:32:41,273 DEBUG storage:           DeviceTree.getDeviceByName: name: sdb ;
>04:32:41,274 DEBUG storage:           DeviceTree.getDeviceByName returned None
>04:32:41,276 DEBUG storage:           DeviceTree.addUdevDiskDevice: name: sdb ;
>04:32:41,278 INFO storage: sdb is a disk
>04:32:41,278 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,280 DEBUG storage:               DiskDevice._setFormat: sdb ; current: None ; type: None ;
>04:32:41,280 INFO storage: added disk sdb (id 2) to device tree
>04:32:41,281 DEBUG storage: looking up parted Device: /dev/sdb
>04:32:41,287 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: sdb ;
>04:32:41,296 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: sdb ; label_type: None ;
>04:32:41,301 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,310 DEBUG storage:             DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>04:32:41,313 DEBUG storage:              DiskLabel.__init__: device: /dev/sdb ; labelType: msdos ; exists: True ;
>04:32:41,318 INFO storage: no usable disklabel on sdb
>04:32:41,319 DEBUG storage: no type or existing type for sdb, bailing
>04:32:41,329 INFO storage: got device: DiskDevice instance (0x7f7c114de5d0) --
>  name = sdb  status = True  kids = 0 id = 2
>  parents = []
>  uuid = None  size = 819200.0
>  format = existing None
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:0d.0/ata2/host1/target1:0:0/1:0:0:0/block/sdb  partedDevice = parted.Device instance --
>  model: ATA VBOX HARDDISK  path: /dev/sdb  type: 1
>  sectorSize: 512  physicalSectorSize:  512
>  length: 1677721600  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: False
>  hardwareGeometry: (104433, 255, 63)  biosGeometry: (104433, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f7c115b87a0>
>  target size = 0  path = /dev/sdb
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7f7c114de350>
>04:32:41,331 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop0',
> 'DEVPATH': '/devices/virtual/block/loop0',
> 'DEVTYPE': 'disk',
> 'ID_FS_TYPE': 'squashfs',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_VERSION': '1024.0',
> 'MAJOR': '7',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '502270',
> 'name': 'loop0',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop0'} ; name: loop0 ;
>04:32:41,333 INFO storage: scanning loop0 (/devices/virtual/block/loop0)...
>04:32:41,335 DEBUG storage:           DeviceTree.getDeviceByName: name: loop0 ;
>04:32:41,336 DEBUG storage:           DeviceTree.getDeviceByName returned None
>04:32:41,336 INFO storage: loop0 is a loop device
>04:32:41,338 DEBUG storage:           DeviceTree.addUdevLoopDevice: name: loop0 ;
>04:32:41,339 DEBUG storage:            DeviceTree.getDeviceByName: name: /run/install/repo/LiveOS/squashfs.img ;
>04:32:41,341 DEBUG storage:            DeviceTree.getDeviceByName returned None
>04:32:41,341 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,343 DEBUG storage:               FileDevice._setFormat: /run/install/repo/LiveOS/squashfs.img ; current: None ; type: None ;
>04:32:41,344 INFO storage: added file /run/install/repo/LiveOS/squashfs.img (id 3) to device tree
>04:32:41,345 DEBUG storage:               FileDevice.addChild: kids: 0 ; name: /run/install/repo/LiveOS/squashfs.img ;
>04:32:41,346 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,347 DEBUG storage:               LoopDevice._setFormat: loop0 ; current: None ; type: None ;
>04:32:41,348 INFO storage: added loop loop0 (id 4) to device tree
>04:32:41,349 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: loop0 ;
>04:32:41,351 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: loop0 ; label_type: None ;
>04:32:41,352 DEBUG storage: getFormat('squashfs') returning DeviceFormat instance
>04:32:41,353 DEBUG storage:             LoopDevice.setup: loop0 ; status: False ; controllable: False ; orig: False ;
>04:32:41,355 DEBUG storage:              DiskLabel.__init__: device: /dev/loop0 ; labelType: None ; exists: True ;
>04:32:41,357 WARN storage: disklabel detected but not usable on loop0
>04:32:41,357 INFO storage: type detected on 'loop0' is 'squashfs'
>04:32:41,358 DEBUG storage: getFormat('squashfs') returning DeviceFormat instance
>04:32:41,359 DEBUG storage:             LoopDevice._setFormat: loop0 ; current: None ; type: None ;
>04:32:41,360 INFO storage: got device: LoopDevice instance (0x7f7c114dead0) --
>  name = loop0  status = False  kids = 0 id = 4
>  parents = ['existing 0MB file /run/install/repo/LiveOS/squashfs.img (3)']
>  uuid = None  size = 0
>  format = existing None
>  major = 0  minor = 0  exists = True  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/loop0
>  format args = []  originalFormat = None
>04:32:41,363 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVLINKS': '/dev/disk/by-label/Anaconda /dev/disk/by-uuid/808f46f0-959c-462a-af0a-e6a598d93848',
> 'DEVNAME': 'loop1',
> 'DEVPATH': '/devices/virtual/block/loop1',
> 'DEVTYPE': 'disk',
> 'ID_FS_LABEL': 'Anaconda',
> 'ID_FS_LABEL_ENC': 'Anaconda',
> 'ID_FS_TYPE': 'ext4',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '808f46f0-959c-462a-af0a-e6a598d93848',
> 'ID_FS_UUID_ENC': '808f46f0-959c-462a-af0a-e6a598d93848',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '7',
> 'MINOR': '1',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '502304',
> 'name': 'loop1',
> 'symlinks': ['/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/808f46f0-959c-462a-af0a-e6a598d93848'],
> 'sysfs_path': '/devices/virtual/block/loop1'} ; name: loop1 ;
>04:32:41,364 INFO storage: scanning loop1 (/devices/virtual/block/loop1)...
>04:32:41,365 DEBUG storage:           DeviceTree.getDeviceByName: name: loop1 ;
>04:32:41,368 DEBUG storage:           DeviceTree.getDeviceByName returned None
>04:32:41,368 INFO storage: loop1 is a loop device
>04:32:41,370 DEBUG storage:           DeviceTree.addUdevLoopDevice: name: loop1 ;
>04:32:41,374 DEBUG storage:            DeviceTree.getDeviceByName: name: /LiveOS/rootfs.img ;
>04:32:41,375 DEBUG storage:            DeviceTree.getDeviceByName returned None
>04:32:41,376 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,377 DEBUG storage:               FileDevice._setFormat: /LiveOS/rootfs.img ; current: None ; type: None ;
>04:32:41,377 INFO storage: added file /LiveOS/rootfs.img (id 5) to device tree
>04:32:41,379 DEBUG storage:               FileDevice.addChild: kids: 0 ; name: /LiveOS/rootfs.img ;
>04:32:41,380 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,381 DEBUG storage:               LoopDevice._setFormat: loop1 ; current: None ; type: None ;
>04:32:41,382 INFO storage: added loop loop1 (id 6) to device tree
>04:32:41,383 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: loop1 ;
>04:32:41,384 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: loop1 ; label_type: None ;
>04:32:41,386 DEBUG storage:               Ext4FS.supported: supported: True ;
>04:32:41,387 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>04:32:41,387 DEBUG storage: device loop1 does not contain a disklabel
>04:32:41,388 INFO storage: type detected on 'loop1' is 'ext4'
>04:32:41,583 DEBUG storage:              Ext4FS.supported: supported: True ;
>04:32:41,584 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>04:32:41,585 DEBUG storage:             LoopDevice._setFormat: loop1 ; current: None ; type: ext4 ;
>04:32:41,590 INFO storage: got device: LoopDevice instance (0x7f7c118fa950) --
>  name = loop1  status = False  kids = 0 id = 6
>  parents = ['existing 0MB file /LiveOS/rootfs.img (5)']
>  uuid = None  size = 0
>  format = existing ext4 filesystem
>  major = 0  minor = 0  exists = True  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/loop1
>  format args = []  originalFormat = None
>04:32:41,593 DEBUG storage:             Ext4FS.supported: supported: True ;
>04:32:41,595 INFO storage: got format: Ext4FS instance (0x7f7c114deb90) --
>  type = ext4  name = ext4  status = False
>  device = /dev/loop1  uuid = 808f46f0-959c-462a-af0a-e6a598d93848  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 1024.0  targetSize = 1024.0
>
>04:32:41,604 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop2',
> 'DEVPATH': '/devices/virtual/block/loop2',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '2',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '503308',
> 'name': 'loop2',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop2'} ; name: loop2 ;
>04:32:41,605 INFO storage: scanning loop2 (/devices/virtual/block/loop2)...
>04:32:41,606 DEBUG storage:           DeviceTree.getDeviceByName: name: loop2 ;
>04:32:41,607 DEBUG storage:           DeviceTree.getDeviceByName returned None
>04:32:41,607 INFO storage: loop2 is a loop device
>04:32:41,608 DEBUG storage:           DeviceTree.addUdevLoopDevice: name: loop2 ;
>04:32:41,610 DEBUG storage:            DeviceTree.getDeviceByName: name: /overlay (deleted) ;
>04:32:41,611 DEBUG storage:            DeviceTree.getDeviceByName returned None
>04:32:41,611 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,612 DEBUG storage:               FileDevice._setFormat: /overlay (deleted) ; current: None ; type: None ;
>04:32:41,612 INFO storage: added file /overlay (deleted) (id 7) to device tree
>04:32:41,614 DEBUG storage:               FileDevice.addChild: kids: 0 ; name: /overlay (deleted) ;
>04:32:41,614 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,615 DEBUG storage:               LoopDevice._setFormat: loop2 ; current: None ; type: None ;
>04:32:41,615 INFO storage: added loop loop2 (id 8) to device tree
>04:32:41,616 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: loop2 ;
>04:32:41,618 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: loop2 ; label_type: None ;
>04:32:41,618 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,619 DEBUG storage:             LoopDevice.setup: loop2 ; status: False ; controllable: False ; orig: False ;
>04:32:41,620 DEBUG storage:              DiskLabel.__init__: device: /dev/loop2 ; labelType: None ; exists: True ;
>04:32:41,624 WARN storage: disklabel detected but not usable on loop2
>04:32:41,624 DEBUG storage: no type or existing type for loop2, bailing
>04:32:41,625 INFO storage: got device: LoopDevice instance (0x7f7c114fe4d0) --
>  name = loop2  status = False  kids = 0 id = 8
>  parents = ['existing 0MB file /overlay (deleted) (7)']
>  uuid = None  size = 0
>  format = existing None
>  major = 0  minor = 0  exists = True  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/loop2
>  format args = []  originalFormat = None
>04:32:41,627 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop3',
> 'DEVPATH': '/devices/virtual/block/loop3',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '3',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '503341',
> 'name': 'loop3',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop3'} ; name: loop3 ;
>04:32:41,627 INFO storage: ignoring loop3 (/devices/virtual/block/loop3)
>04:32:41,627 DEBUG storage: lvm filter: adding loop3 to the reject list
>04:32:41,629 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop4',
> 'DEVPATH': '/devices/virtual/block/loop4',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '4',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '505770',
> 'name': 'loop4',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop4'} ; name: loop4 ;
>04:32:41,630 INFO storage: ignoring loop4 (/devices/virtual/block/loop4)
>04:32:41,630 DEBUG storage: lvm filter: adding loop4 to the reject list
>04:32:41,631 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop5',
> 'DEVPATH': '/devices/virtual/block/loop5',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '5',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '505837',
> 'name': 'loop5',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop5'} ; name: loop5 ;
>04:32:41,631 INFO storage: ignoring loop5 (/devices/virtual/block/loop5)
>04:32:41,632 DEBUG storage: lvm filter: adding loop5 to the reject list
>04:32:41,633 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop6',
> 'DEVPATH': '/devices/virtual/block/loop6',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '6',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '505885',
> 'name': 'loop6',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop6'} ; name: loop6 ;
>04:32:41,633 INFO storage: ignoring loop6 (/devices/virtual/block/loop6)
>04:32:41,634 DEBUG storage: lvm filter: adding loop6 to the reject list
>04:32:41,635 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop7',
> 'DEVPATH': '/devices/virtual/block/loop7',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '7',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '514502',
> 'name': 'loop7',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop7'} ; name: loop7 ;
>04:32:41,635 INFO storage: ignoring loop7 (/devices/virtual/block/loop7)
>04:32:41,636 DEBUG storage: lvm filter: adding loop7 to the reject list
>04:32:41,636 DEBUG storage: Skipping a device mapper drive (dm-0) for now
>04:32:41,653 INFO storage: devices to scan: ['dm-0']
>04:32:41,656 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVLINKS': '/dev/disk/by-id/dm-name-live-rw /dev/disk/by-label/Anaconda /dev/disk/by-uuid/808f46f0-959c-462a-af0a-e6a598d93848 /dev/mapper/live-rw',
> 'DEVNAME': 'dm-0',
> 'DEVPATH': '/devices/virtual/block/dm-0',
> 'DEVTYPE': 'disk',
> 'DM_NAME': 'live-rw',
> 'DM_SUSPENDED': '0',
> 'DM_UDEV_DISABLE_LIBRARY_FALLBACK_FLAG': '1',
> 'DM_UDEV_PRIMARY_SOURCE_FLAG': '1',
> 'DM_UDEV_RULES_VSN': '2',
> 'ID_FS_LABEL': 'Anaconda',
> 'ID_FS_LABEL_ENC': 'Anaconda',
> 'ID_FS_TYPE': 'ext4',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '808f46f0-959c-462a-af0a-e6a598d93848',
> 'ID_FS_UUID_ENC': '808f46f0-959c-462a-af0a-e6a598d93848',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '253',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '12363',
> 'name': 'dm-0',
> 'symlinks': ['/dev/disk/by-id/dm-name-live-rw',
>              '/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/808f46f0-959c-462a-af0a-e6a598d93848',
>              '/dev/mapper/live-rw'],
> 'sysfs_path': '/devices/virtual/block/dm-0'} ; name: live-rw ;
>04:32:41,656 INFO storage: scanning live-rw (/devices/virtual/block/dm-0)...
>04:32:41,658 DEBUG storage:           DeviceTree.getDeviceByName: name: live-rw ;
>04:32:41,658 DEBUG storage:           DeviceTree.getDeviceByName returned None
>04:32:41,659 INFO storage: live-rw is a device-mapper device
>04:32:41,660 DEBUG storage:           DeviceTree.addUdevDMDevice: name: live-rw ;
>04:32:41,665 DEBUG storage:            DeviceTree.getDeviceByName: name: loop1 ;
>04:32:41,666 DEBUG storage:            DeviceTree.getDeviceByName returned existing 0MB loop loop1 (6) with existing ext4 filesystem
>04:32:41,668 DEBUG storage:            DeviceTree.getDeviceByName: name: loop2 ;
>04:32:41,676 DEBUG storage:            DeviceTree.getDeviceByName returned existing 0MB loop loop2 (8)
>04:32:41,677 DEBUG storage:            DeviceTree.getDeviceByName: name: live-rw ;
>04:32:41,678 DEBUG storage:            DeviceTree.getDeviceByName returned None
>04:32:41,679 DEBUG storage:               LoopDevice.addChild: kids: 0 ; name: loop2 ;
>04:32:41,679 DEBUG storage: getFormat('None') returning DeviceFormat instance
>04:32:41,681 DEBUG storage:               DMDevice._setFormat: live-rw ; current: None ; type: None ;
>04:32:41,681 INFO storage: added dm live-rw (id 9) to device tree
>04:32:41,688 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: live-rw ;
>04:32:41,690 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: live-rw ; label_type: None ;
>04:32:41,691 DEBUG storage:               Ext4FS.supported: supported: True ;
>04:32:41,691 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>04:32:41,691 DEBUG storage: device live-rw does not contain a disklabel
>04:32:41,692 INFO storage: type detected on 'live-rw' is 'ext4'
>04:32:41,729 DEBUG storage:              Ext4FS.supported: supported: True ;
>04:32:41,730 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>04:32:41,731 DEBUG storage:             DMDevice._setFormat: live-rw ; current: None ; type: ext4 ;
>04:32:41,731 DEBUG storage: looking up parted Device: /dev/mapper/live-rw
>04:32:41,745 INFO storage: got device: DMDevice instance (0x7f7c114fee90) --
>  name = live-rw  status = True  kids = 0 id = 9
>  parents = ['existing 0MB loop loop2 (8)']
>  uuid = None  size = 1024.0
>  format = existing ext4 filesystem
>  major = 0  minor = 0  exists = True  protected = True
>  sysfs path = /devices/virtual/block/dm-0  partedDevice = parted.Device instance --
>  model: Linux device-mapper (snapshot)  path: /dev/mapper/live-rw  type: 12
>  sectorSize: 512  physicalSectorSize:  512
>  length: 2097152  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: True
>  hardwareGeometry: (130, 255, 63)  biosGeometry: (130, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f7c267e48c0>
>  target size = 0  path = /dev/mapper/live-rw
>  format args = []  originalFormat = None  target = None  dmUuid = None
>04:32:41,746 DEBUG storage:             Ext4FS.supported: supported: True ;
>04:32:41,747 INFO storage: got format: Ext4FS instance (0x7f7c114fea50) --
>  type = ext4  name = ext4  status = False
>  device = /dev/mapper/live-rw  uuid = 808f46f0-959c-462a-af0a-e6a598d93848  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 1024.0  targetSize = 1024.0
>
>04:32:41,765 DEBUG storage:           OpticalDevice.teardown: sr0 ; status: True ; controllable: True ;
>04:32:41,780 DEBUG storage:           DiskDevice.teardown: sda ; status: True ; controllable: True ;
>04:32:41,781 DEBUG storage:             DeviceFormat.teardown: device: /dev/sda ; status: False ; type: None ;
>04:32:41,783 DEBUG storage:             DeviceFormat.teardown: device: /dev/sda ; status: False ; type: None ;
>04:32:41,797 DEBUG storage:           DiskDevice.teardown: sdb ; status: True ; controllable: True ;
>04:32:41,799 DEBUG storage:             DeviceFormat.teardown: device: /dev/sdb ; status: False ; type: None ;
>04:32:41,800 DEBUG storage:             DeviceFormat.teardown: device: /dev/sdb ; status: False ; type: None ;
>04:32:41,815 DEBUG storage:           LoopDevice.teardown: loop0 ; status: False ; controllable: False ;
>04:32:41,816 DEBUG storage:           LoopDevice.teardown: loop1 ; status: False ; controllable: False ;
>04:32:41,816 DEBUG storage:           DMDevice.teardown: live-rw ; status: True ; controllable: False ;
>04:32:41,817 INFO storage: not going to restore from backup of non-existent /etc/mdadm.conf
>04:32:41,817 INFO storage: edd: collected mbr signatures: {}
>04:32:41,818 DEBUG storage: edd: data extracted from 0x80:
>	type: None, ata_device: None
>	channel: None, mbr_signature: None
>	pci_dev: None, scsi_id: None
>	scsi_lun: None, sectors: 1677721600
>04:32:41,818 ERR storage: edd: unable to match edd entry 0x80
>04:32:41,818 DEBUG storage: edd: data extracted from 0x81:
>	type: None, ata_device: None
>	channel: None, mbr_signature: None
>	pci_dev: None, scsi_id: None
>	scsi_lun: None, sectors: 1677721600
>04:32:41,818 ERR storage: edd: unable to match edd entry 0x81
>04:32:41,932 DEBUG storage:             Ext4FS.supported: supported: True ;
>04:32:41,940 DEBUG storage:            Ext4FS.supported: supported: True ;
>04:32:41,942 DEBUG storage:            OpticalDevice.mediaPresent: sr0 ; status: True ;
>04:32:41,945 DEBUG storage:            Iso9660FS.supported: supported: True ;
>04:32:42,152 DEBUG storage:          DeviceTree.getDeviceByPath: path: /dev/sr0 ;
>04:32:42,155 DEBUG storage:              OpticalDevice.mediaPresent: sr0 ; status: True ;
>04:32:42,160 DEBUG storage:          DeviceTree.getDeviceByPath returned existing 261MB cdrom sr0 (0) with existing iso9660 filesystem
>00:32:49,302 DEBUG storage:             Iso9660FS.supported: supported: True ;
>00:32:49,306 DEBUG storage:            Iso9660FS.supported: supported: True ;
>00:32:49,308 DEBUG storage:             NFSv4.supported: supported: False ;
>00:32:49,309 DEBUG storage:            NFSv4.supported: supported: False ;
>00:32:49,311 DEBUG storage:              SELinuxFS.supported: supported: False ;
>00:32:49,313 DEBUG storage:            SELinuxFS.supported: supported: False ;
>00:32:49,314 DEBUG storage:             Ext4FS.supported: supported: True ;
>00:32:49,315 DEBUG storage:            Ext4FS.supported: supported: True ;
>00:32:49,317 DEBUG storage:             Ext3FS.supported: supported: True ;
>00:32:49,318 DEBUG storage:            Ext3FS.supported: supported: True ;
>00:32:49,320 DEBUG storage:             Ext2FS.supported: supported: True ;
>00:32:49,323 DEBUG storage:            Ext2FS.supported: supported: True ;
>00:32:49,325 DEBUG storage:              SysFS.supported: supported: False ;
>00:32:49,327 DEBUG storage:            SysFS.supported: supported: False ;
>00:32:49,330 DEBUG storage:            MultipathMember.__init__:
>00:32:49,332 DEBUG storage:            MDRaidMember.__init__:
>00:32:49,333 DEBUG storage:              ProcFS.supported: supported: False ;
>00:32:49,334 DEBUG storage:            ProcFS.supported: supported: False ;
>00:32:49,337 DEBUG storage:            SwapSpace.__init__:
>00:32:49,339 DEBUG storage:            DMRaidMember.__init__:
>00:32:49,340 DEBUG storage:              DevPtsFS.supported: supported: False ;
>00:32:49,342 DEBUG storage:            DevPtsFS.supported: supported: False ;
>00:32:49,344 DEBUG storage:              BTRFS.supported: supported: True ;
>00:32:49,465 DEBUG storage:            BTRFS.supported: supported: True ;
>00:32:49,468 DEBUG storage:              USBFS.supported: supported: False ;
>00:32:49,470 DEBUG storage:            USBFS.supported: supported: False ;
>00:32:49,471 DEBUG storage:            DiskLabel.__init__:
>00:32:49,471 INFO storage: DiskLabel.partedDevice returning None
>00:32:49,472 DEBUG storage:             HFSPlus.supported: supported: False ;
>00:32:49,473 DEBUG storage:            HFSPlus.supported: supported: False ;
>00:32:49,475 DEBUG storage:             XFS.supported: supported: True ;
>00:32:49,542 DEBUG storage:            XFS.supported: supported: True ;
>00:32:49,546 DEBUG storage:              TmpFS.supported: supported: False ;
>00:32:49,548 DEBUG storage:            TmpFS.supported: supported: False ;
>00:32:49,550 DEBUG storage:            LUKS.__init__:
>00:32:49,552 DEBUG storage:             NTFS.supported: supported: False ;
>00:32:49,554 DEBUG storage:            NTFS.supported: supported: False ;
>00:32:49,556 DEBUG storage:             BindFS.supported: supported: False ;
>00:32:49,557 DEBUG storage:            BindFS.supported: supported: False ;
>00:32:49,559 DEBUG storage:             HFS.supported: supported: False ;
>00:32:49,561 DEBUG storage:            HFS.supported: supported: False ;
>00:32:49,562 DEBUG storage:            LVMPhysicalVolume.__init__:
>00:32:49,564 DEBUG storage:             NFS.supported: supported: False ;
>00:32:49,566 DEBUG storage:            NFS.supported: supported: False ;
>00:32:49,568 DEBUG storage:             FATFS.supported: supported: True ;
>00:32:49,595 DEBUG storage:            FATFS.supported: supported: True ;
>00:32:49,598 DEBUG storage:              NoDevFS.supported: supported: False ;
>00:32:49,599 DEBUG storage:            NoDevFS.supported: supported: False ;
>00:32:59,272 DEBUG storage:            OpticalDevice.mediaPresent: sr0 ; status: True ;
>00:32:59,276 INFO storage: updating format of device: existing 261MB cdrom sr0 (0) with existing iso9660 filesystem
>00:32:59,296 DEBUG storage:         DeviceTree.handleUdevDeviceFormat: name: sr0 ;
>00:32:59,297 DEBUG storage:          DeviceTree.handleUdevDiskLabelFormat: device: sr0 ; label_type: dos ;
>00:32:59,298 DEBUG storage:           OpticalDevice.setup: sr0 ; status: True ; controllable: True ; orig: False ;
>00:32:59,299 DEBUG storage:            DiskLabel.__init__: device: /dev/sr0 ; labelType: dos ; exists: True ;
>00:32:59,305 WARN storage: disklabel detected but not usable on sr0
>00:32:59,305 DEBUG storage: no type or existing type for sr0, bailing
>00:32:59,306 INFO storage: got format: existing iso9660 filesystem
>00:32:59,317 INFO storage: set SELinux context for mountpoint /mnt/install/isodir to system_u:object_r:var_run_t:s0
>00:33:16,857 DEBUG storage: clearpart: initializing sda
>00:33:16,859 DEBUG storage:            DeviceFormat.teardown: device: /dev/sda ; status: False ; type: None ;
>00:33:16,860 DEBUG storage: getFormat('None') returning DeviceFormat instance
>00:33:16,861 DEBUG storage:             DiskDevice._setFormat: sda ; current: None ; type: None ;
>00:33:16,862 INFO storage: registered action: [0] Destroy Format None on disk sda (id 1)
>00:33:16,865 DEBUG storage:            DiskLabel.__init__: device: /dev/sda ; labelType: msdos ;
>00:33:16,866 DEBUG storage:              DiskLabel.freshPartedDisk: device: /dev/sda ; labelType: msdos ;
>00:33:16,867 DEBUG storage: Did not set pmbr_boot on parted.Disk instance --
>  type: msdos  primaryPartitionCount: 0
>  lastPartitionNumber: -1  maxPrimaryPartitionCount: 4
>  partitions: []
>  device: <parted.device.Device object at 0x7f7c1a303910>
>  PedDisk: <_ped.Disk object at 0x7f7c05c57f38>
>00:33:16,868 DEBUG storage: getFormat('disklabel') returning DiskLabel instance
>00:33:16,869 DEBUG storage:            DeviceFormat.teardown: device: /dev/sda ; status: False ; type: None ;
>00:33:16,870 DEBUG storage:             DiskDevice._setFormat: sda ; current: None ; type: disklabel ;
>00:33:16,871 INFO storage: registered action: [1] Create Format msdos disklabel on disk sda (id 1)
>00:33:16,871 DEBUG storage: clearpart: initializing sdb
>00:33:16,872 DEBUG storage:            DeviceFormat.teardown: device: /dev/sdb ; status: False ; type: None ;
>00:33:16,873 DEBUG storage: getFormat('None') returning DeviceFormat instance
>00:33:16,874 DEBUG storage:             DiskDevice._setFormat: sdb ; current: None ; type: None ;
>00:33:16,874 INFO storage: registered action: [2] Destroy Format None on disk sdb (id 2)
>00:33:16,877 DEBUG storage:            DiskLabel.__init__: device: /dev/sdb ; labelType: msdos ;
>00:33:16,878 DEBUG storage:              DiskLabel.freshPartedDisk: device: /dev/sdb ; labelType: msdos ;
>00:33:16,879 DEBUG storage: Did not set pmbr_boot on parted.Disk instance --
>  type: msdos  primaryPartitionCount: 0
>  lastPartitionNumber: -1  maxPrimaryPartitionCount: 4
>  partitions: []
>  device: <parted.device.Device object at 0x7f7c1a1e08d0>
>  PedDisk: <_ped.Disk object at 0x7f7c05f3c878>
>00:33:16,880 DEBUG storage: getFormat('disklabel') returning DiskLabel instance
>00:33:16,881 DEBUG storage:            DeviceFormat.teardown: device: /dev/sdb ; status: False ; type: None ;
>00:33:16,883 DEBUG storage:             DiskDevice._setFormat: sdb ; current: None ; type: disklabel ;
>00:33:16,883 INFO storage: registered action: [3] Create Format msdos disklabel on disk sdb (id 2)
>00:33:16,884 DEBUG storage: new disk order: []
>00:33:16,907 DEBUG storage:         DeviceTree.getDeviceByName: name: sda ;
>00:33:16,908 DEBUG storage:         DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:16,910 DEBUG storage:          DeviceTree.getDeviceByName: name: sda ;
>00:33:16,911 DEBUG storage:          DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:16,911 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:16,913 DEBUG storage: _is_valid_disklabel(sda) returning True
>00:33:16,913 DEBUG storage: _is_valid_size(sda) returning True
>00:33:16,914 DEBUG storage: _is_valid_location(sda) returning True
>00:33:16,914 DEBUG storage: _is_valid_format(sda) returning True
>00:33:16,914 DEBUG storage: is_valid_stage1_device(sda) returning True
>00:33:18,548 DEBUG storage.ui: doAutoPart: True
>00:33:18,549 DEBUG storage.ui: encryptedAutoPart: False
>00:33:18,549 DEBUG storage.ui: autoPartType: 0
>00:33:18,550 DEBUG storage.ui: clearPartType: 2
>00:33:18,550 DEBUG storage.ui: clearPartDisks: ['sda', 'sdb']
>00:33:18,551 DEBUG storage.ui: autoPartitionRequests:
>PartSpec instance (0x7f7c1a114dd0) -- 
>  mountpoint = /  lv = True  singlePV = False  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024  maxSize = 51200  grow = True
>PartSpec instance (0x7f7c1a114e90) -- 
>  mountpoint = /home  lv = True  singlePV = False  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500  maxSize = None  grow = True
>PartSpec instance (0x7f7c1a114b10) -- 
>  mountpoint = /boot  lv = False  singlePV = False  btrfs = False
>  weight = 2000  fstype = ext4  encrypted = False
>  size = 500  maxSize = None  grow = False
>PartSpec instance (0x7f7c1a114c10) -- 
>  mountpoint = None  lv = False  singlePV = False  btrfs = False
>  weight = 5000  fstype = biosboot  encrypted = False
>  size = 1  maxSize = None  grow = False
>PartSpec instance (0x4c2a890) -- 
>  mountpoint = None  lv = True  singlePV = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 4032  maxSize = None  grow = False
>
>00:33:18,551 DEBUG storage.ui: storage.disks: ['sda', 'sdb']
>00:33:18,552 DEBUG storage.ui: storage.partitioned: ['sda', 'sdb']
>00:33:18,552 DEBUG storage.ui: all names: ['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/install/repo/LiveOS/squashfs.img', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda', 'sdb', 'sr0']
>00:33:18,555 DEBUG storage.ui:              DeviceTree.getDeviceByName: name: sda ;
>00:33:18,555 DEBUG storage.ui:              DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,556 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,556 DEBUG storage.ui: boot disk: sda
>00:33:18,558 DEBUG storage.ui: candidate disks: [DiskDevice instance (0x7f7c1a303290) --
>  name = sda  status = True  kids = 0 id = 1
>  parents = []
>  uuid = None  size = 819200.0
>  format = non-existent msdos disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sda  partedDevice = parted.Device instance --
>  model: ATA VBOX HARDDISK  path: /dev/sda  type: 1
>  sectorSize: 512  physicalSectorSize:  512
>  length: 1677721600  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: False
>  hardwareGeometry: (104433, 255, 63)  biosGeometry: (104433, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f7c115b8680>
>  target size = 0  path = /dev/sda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x4bf23d0>, DiskDevice instance (0x47cdfd0) --
>  name = sdb  status = True  kids = 0 id = 2
>  parents = []
>  uuid = None  size = 819200.0
>  format = non-existent msdos disklabel
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:0d.0/ata2/host1/target1:0:0/1:0:0:0/block/sdb  partedDevice = parted.Device instance --
>  model: ATA VBOX HARDDISK  path: /dev/sdb  type: 1
>  sectorSize: 512  physicalSectorSize:  512
>  length: 1677721600  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: False
>  hardwareGeometry: (104433, 255, 63)  biosGeometry: (104433, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f7c115b87a0>
>  target size = 0  path = /dev/sdb
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x4225c10>]
>00:33:18,558 DEBUG storage.ui: devs: []
>00:33:18,558 DEBUG storage.ui: _is_valid_disklabel(sda) returning True
>00:33:18,558 DEBUG storage.ui: _is_valid_size(sda) returning True
>00:33:18,558 DEBUG storage.ui: _is_valid_location(sda) returning True
>00:33:18,558 DEBUG storage.ui: _is_valid_format(sda) returning True
>00:33:18,559 DEBUG storage.ui: is_valid_stage1_device(sda) returning True
>00:33:18,560 DEBUG storage.ui:                Ext4FS.supported: supported: True ;
>00:33:18,560 DEBUG storage.ui: getFormat('ext4') returning Ext4FS instance
>00:33:18,562 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sda ;
>00:33:18,563 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:18,564 DEBUG storage.ui:                 PartitionDevice._setFormat: req0 ;
>00:33:18,565 DEBUG storage.ui:                  PartitionDevice._setFormat: req0 ; current: None ; type: ext4 ;
>00:33:18,566 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sda ;
>00:33:18,568 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:18,568 INFO storage.ui: added partition req0 (id 10) to device tree
>00:33:18,569 INFO storage.ui: registered action: [4] Create Device partition req0 (id 10)
>00:33:18,569 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:18,570 INFO storage.ui: registered action: [5] Create Format ext4 filesystem mounted at / on partition req0 (id 10)
>00:33:18,571 DEBUG storage.ui:                Ext4FS.supported: supported: True ;
>00:33:18,572 DEBUG storage.ui: getFormat('ext4') returning Ext4FS instance
>00:33:18,573 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sda ;
>00:33:18,574 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:18,576 DEBUG storage.ui:                 PartitionDevice._setFormat: req1 ;
>00:33:18,577 DEBUG storage.ui:                  PartitionDevice._setFormat: req1 ; current: None ; type: ext4 ;
>00:33:18,579 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sda ;
>00:33:18,580 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:18,580 INFO storage.ui: added partition req1 (id 11) to device tree
>00:33:18,581 INFO storage.ui: registered action: [6] Create Device partition req1 (id 11)
>00:33:18,581 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:18,582 INFO storage.ui: registered action: [7] Create Format ext4 filesystem mounted at /home on partition req1 (id 11)
>00:33:18,583 DEBUG storage.ui:                Ext4FS.supported: supported: True ;
>00:33:18,584 DEBUG storage.ui: getFormat('ext4') returning Ext4FS instance
>00:33:18,585 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sda ;
>00:33:18,587 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:18,588 DEBUG storage.ui:                 PartitionDevice._setFormat: req2 ;
>00:33:18,590 DEBUG storage.ui:                  PartitionDevice._setFormat: req2 ; current: None ; type: ext4 ;
>00:33:18,591 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sda ;
>00:33:18,592 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:18,593 INFO storage.ui: added partition req2 (id 12) to device tree
>00:33:18,593 INFO storage.ui: registered action: [8] Create Device partition req2 (id 12)
>00:33:18,594 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:18,594 INFO storage.ui: registered action: [9] Create Format ext4 filesystem mounted at /boot on partition req2 (id 12)
>00:33:18,595 INFO storage.ui: skipping unneeded stage1 biosboot request
>00:33:18,595 DEBUG storage.ui: PartSpec instance (0x7f7c1a114c10) -- 
>  mountpoint = None  lv = False  singlePV = False  btrfs = False
>  weight = 5000  fstype = biosboot  encrypted = False
>  size = 1  maxSize = None  grow = False
>
>00:33:18,596 DEBUG storage.ui: existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,597 DEBUG storage.ui:               SwapSpace.__init__: mountpoint: None ;
>00:33:18,598 DEBUG storage.ui: getFormat('swap') returning SwapSpace instance
>00:33:18,599 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sda ;
>00:33:18,600 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:18,602 DEBUG storage.ui:                 PartitionDevice._setFormat: req3 ;
>00:33:18,603 DEBUG storage.ui:                  PartitionDevice._setFormat: req3 ; current: None ; type: swap ;
>00:33:18,604 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sda ;
>00:33:18,606 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:18,606 INFO storage.ui: added partition req3 (id 13) to device tree
>00:33:18,606 INFO storage.ui: registered action: [10] Create Device partition req3 (id 13)
>00:33:18,607 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:18,607 INFO storage.ui: registered action: [11] Create Format swap on partition req3 (id 13)
>00:33:18,609 DEBUG storage.ui:             DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>00:33:18,610 DEBUG storage.ui:             DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>00:33:18,611 DEBUG storage.ui: removing all non-preexisting partitions ['req0(id 10)', 'req1(id 11)', 'req2(id 12)', 'req3(id 13)'] from disk(s) ['sda', 'sdb']
>00:33:18,612 DEBUG storage.ui: allocatePartitions: disks=['sda', 'sdb'] ; partitions=['req0(id 10)', 'req1(id 11)', 'req2(id 12)', 'req3(id 13)']
>00:33:18,613 DEBUG storage.ui: removing all non-preexisting partitions ['req2(id 12)', 'req3(id 13)', 'req0(id 10)', 'req1(id 11)'] from disk(s) ['sda', 'sdb']
>00:33:18,614 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,616 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,616 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,617 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,619 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,619 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,620 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,622 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,622 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,624 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,626 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,626 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,627 DEBUG storage.ui: allocating partition: req2 ; id: 12 ; disks: ['sda', 'sdb'] ;
>boot: True ; primary: False ; size: 500MB ; grow: False ; max_size: 0
>00:33:18,627 DEBUG storage.ui: checking freespace on sda
>00:33:18,628 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=500MB boot=True best=None grow=False
>00:33:18,629 DEBUG storage.ui: current free range is 63-1677721599 (819199MB)
>00:33:18,629 DEBUG storage.ui: updating use_disk to sda, type: 0
>00:33:18,630 DEBUG storage.ui: new free: 63-1677721599 / 819199MB
>00:33:18,630 DEBUG storage.ui: new free allows for 0 sectors of growth
>00:33:18,631 DEBUG storage.ui: found free space for bootable request
>00:33:18,632 DEBUG storage.ui: adjusted start sector from 63 to 2048
>00:33:18,632 DEBUG storage.ui: created partition sda1 of 500MB and added it to /dev/sda
>00:33:18,634 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req2 ;
>00:33:18,634 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c065a1410>  PedPartition: <_ped.Partition object at 0x7f7c06537fb0>
>00:33:18,636 DEBUG storage.ui:               PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>00:33:18,637 DEBUG storage.ui:                DiskDevice.addChild: kids: 0 ; name: sda ;
>00:33:18,639 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda1 ;
>00:33:18,639 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c061c3190>  PedPartition: <_ped.Partition object at 0x7f7c06537890>
>00:33:18,641 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,642 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,642 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,644 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,645 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,645 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,647 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,648 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,649 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,650 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,652 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,652 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,652 DEBUG storage.ui: allocating partition: req3 ; id: 13 ; disks: ['sda', 'sdb'] ;
>boot: False ; primary: False ; size: 4032MB ; grow: False ; max_size: 0
>00:33:18,653 DEBUG storage.ui: checking freespace on sda
>00:33:18,654 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=4032MB boot=False best=None grow=False
>00:33:18,654 DEBUG storage.ui: current free range is 63-2047 (0MB)
>00:33:18,655 DEBUG storage.ui: current free range is 1026048-1677721599 (818699MB)
>00:33:18,656 DEBUG storage.ui: updating use_disk to sda, type: 0
>00:33:18,656 DEBUG storage.ui: new free: 1026048-1677721599 / 818699MB
>00:33:18,657 DEBUG storage.ui: new free allows for 0 sectors of growth
>00:33:18,657 DEBUG storage.ui: checking freespace on sdb
>00:33:18,658 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=4032MB boot=False best=parted.Geometry instance --
>  start: 1026048  end: 1677721599  length: 1676695552
>  device: <parted.device.Device object at 0x7f7c1a27fa10>  PedGeometry: <_ped.Geometry object at 0x7f7c1a27f5d0> grow=False
>00:33:18,659 DEBUG storage.ui: current free range is 63-1677721599 (819199MB)
>00:33:18,659 DEBUG storage.ui: not enough free space for primary -- trying logical
>00:33:18,660 DEBUG storage.ui: created partition sda2 of 4032MB and added it to /dev/sda
>00:33:18,661 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req3 ;
>00:33:18,662 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c065a1b50>  PedPartition: <_ped.Partition object at 0x7f7c063855f0>
>00:33:18,663 DEBUG storage.ui:               PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>00:33:18,665 DEBUG storage.ui:                DiskDevice.addChild: kids: 1 ; name: sda ;
>00:33:18,666 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda2 ;
>00:33:18,667 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c065a1d50>  PedPartition: <_ped.Partition object at 0x7f7c06385470>
>00:33:18,668 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,670 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,670 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,671 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,673 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,673 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,675 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,677 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,677 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,679 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,680 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,680 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,681 DEBUG storage.ui: allocating partition: req0 ; id: 10 ; disks: ['sda', 'sdb'] ;
>boot: False ; primary: False ; size: 1024MB ; grow: True ; max_size: 51200
>00:33:18,681 DEBUG storage.ui: checking freespace on sda
>00:33:18,682 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=1024MB boot=False best=None grow=True
>00:33:18,683 DEBUG storage.ui: current free range is 63-2047 (0MB)
>00:33:18,683 DEBUG storage.ui: current free range is 9283584-1677721599 (814667MB)
>00:33:18,684 DEBUG storage.ui: evaluating growth potential for new layout
>00:33:18,684 DEBUG storage.ui: calculating growth for disk /dev/sdb
>00:33:18,685 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:18,685 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>00:33:18,686 DEBUG storage.ui: calculating growth for disk /dev/sda
>00:33:18,688 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req0 ;
>00:33:18,688 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c0672b650>  PedPartition: <_ped.Partition object at 0x7f7c06385230>
>00:33:18,689 DEBUG storage.ui:               PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>00:33:18,691 DEBUG storage.ui:                DiskDevice.addChild: kids: 2 ; name: sda ;
>00:33:18,691 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,692 DEBUG storage.ui: adding request 13 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,692 DEBUG storage.ui: adding request 10 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,693 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:18,694 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:18,694 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda2  growable = False
>base = 8257536  growth = 0  max_grow = 0
>done = True
>00:33:18,694 DEBUG storage.ui: req: PartitionRequest instance --
>id = 10  name = sda3  growable = True
>base = 2097152  growth = 0  max_grow = 102760448
>done = False
>00:33:18,695 DEBUG storage.ui: 1 requests and 1666342849 (813643MB) left in chunk
>00:33:18,695 DEBUG storage.ui: adding 1666342849 (813643MB) to 10 (sda3)
>00:33:18,696 DEBUG storage.ui: taking back 1563582401 (763467MB) from 10 (sda3)
>00:33:18,697 DEBUG storage.ui: new grow amount for request 10 (sda3) is 102760448 units, or 50176MB
>00:33:18,697 DEBUG storage.ui: request 12 (sda1) growth: 0 (0MB) size: 500MB
>00:33:18,697 DEBUG storage.ui: request 13 (sda2) growth: 0 (0MB) size: 4032MB
>00:33:18,698 DEBUG storage.ui: request 10 (sda3) growth: 102760448 (50176MB) size: 51200MB
>00:33:18,698 DEBUG storage.ui: disk /dev/sda growth: 102760448 (50176MB)
>00:33:18,700 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda3 ;
>00:33:18,700 DEBUG storage.ui: device sda3 new partedPartition None
>00:33:18,701 DEBUG storage.ui:               PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>00:33:18,703 DEBUG storage.ui:                DiskDevice.removeChild: kids: 3 ; name: sda ;
>00:33:18,704 DEBUG storage.ui: total growth: 102760448 sectors
>00:33:18,704 DEBUG storage.ui: updating use_disk to sda, type: 0
>00:33:18,705 DEBUG storage.ui: new free: 9283584-1677721599 / 814667MB
>00:33:18,705 DEBUG storage.ui: new free allows for 102760448 sectors of growth
>00:33:18,706 DEBUG storage.ui: checking freespace on sdb
>00:33:18,706 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=1024MB boot=False best=None grow=True
>00:33:18,707 DEBUG storage.ui: current free range is 63-1677721599 (819199MB)
>00:33:18,708 DEBUG storage.ui: evaluating growth potential for new layout
>00:33:18,708 DEBUG storage.ui: calculating growth for disk /dev/sdb
>00:33:18,709 DEBUG storage.ui: adjusted start sector from 63 to 2048
>00:33:18,711 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req0 ;
>00:33:18,711 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c06362b90>  PedPartition: <_ped.Partition object at 0x7f7c06385050>
>00:33:18,713 DEBUG storage.ui:               PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>00:33:18,715 DEBUG storage.ui:                DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:18,715 DEBUG storage.ui: adding request 10 to chunk 1677721537 (63-1677721599) on /dev/sdb
>00:33:18,716 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:18,717 DEBUG storage.ui: req: PartitionRequest instance --
>id = 10  name = sdb1  growable = True
>base = 2097152  growth = 0  max_grow = 102760448
>done = False
>00:33:18,717 DEBUG storage.ui: 1 requests and 1675624385 (818175MB) left in chunk
>00:33:18,718 DEBUG storage.ui: adding 1675624385 (818175MB) to 10 (sdb1)
>00:33:18,718 DEBUG storage.ui: taking back 1572863937 (767999MB) from 10 (sdb1)
>00:33:18,719 DEBUG storage.ui: new grow amount for request 10 (sdb1) is 102760448 units, or 50176MB
>00:33:18,719 DEBUG storage.ui: request 10 (sdb1) growth: 102760448 (50176MB) size: 51200MB
>00:33:18,720 DEBUG storage.ui: disk /dev/sdb growth: 102760448 (50176MB)
>00:33:18,720 DEBUG storage.ui: calculating growth for disk /dev/sda
>00:33:18,721 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,721 DEBUG storage.ui: adding request 13 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,722 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:18,722 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:18,723 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda2  growable = False
>base = 8257536  growth = 0  max_grow = 0
>done = True
>00:33:18,723 DEBUG storage.ui: request 12 (sda1) growth: 0 (0MB) size: 500MB
>00:33:18,724 DEBUG storage.ui: request 13 (sda2) growth: 0 (0MB) size: 4032MB
>00:33:18,724 DEBUG storage.ui: disk /dev/sda growth: 0 (0MB)
>00:33:18,726 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sdb1 ;
>00:33:18,726 DEBUG storage.ui: device sdb1 new partedPartition None
>00:33:18,728 DEBUG storage.ui:               PartitionDevice._setDisk: req0 ; new: None ; old: sdb ;
>00:33:18,729 DEBUG storage.ui:                DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:18,729 DEBUG storage.ui: total growth: 102760448 sectors
>00:33:18,729 DEBUG storage.ui: keeping old free: 102760448 <= 102760448
>00:33:18,729 DEBUG storage.ui: created partition sda3 of 1024MB and added it to /dev/sda
>00:33:18,730 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req0 ;
>00:33:18,731 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c0672bf10>  PedPartition: <_ped.Partition object at 0x7f7c06385230>
>00:33:18,732 DEBUG storage.ui:               PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>00:33:18,734 DEBUG storage.ui:                DiskDevice.addChild: kids: 2 ; name: sda ;
>00:33:18,735 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda3 ;
>00:33:18,736 DEBUG storage.ui: device sda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c0672b5d0>  PedPartition: <_ped.Partition object at 0x7f7c063853b0>
>00:33:18,737 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,739 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,739 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,741 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,742 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,742 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,743 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,745 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,745 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,746 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>00:33:18,748 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,748 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,749 DEBUG storage.ui: allocating partition: req1 ; id: 11 ; disks: ['sda', 'sdb'] ;
>boot: False ; primary: False ; size: 500MB ; grow: True ; max_size: 0
>00:33:18,749 DEBUG storage.ui: checking freespace on sda
>00:33:18,750 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=2 req_size=500MB boot=False best=None grow=True
>00:33:18,751 DEBUG storage.ui: current free range is 63-2047 (0MB)
>00:33:18,751 DEBUG storage.ui: current free range is 11380736-1677721599 (813643MB)
>00:33:18,752 DEBUG storage.ui: evaluating growth potential for new layout
>00:33:18,752 DEBUG storage.ui: calculating growth for disk /dev/sdb
>00:33:18,753 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:18,753 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>00:33:18,754 DEBUG storage.ui: calculating growth for disk /dev/sda
>00:33:18,754 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=1 req_size=500MB boot=False best=None grow=True
>00:33:18,755 DEBUG storage.ui: looking for intersection between extended (11380736-1677721599) and free (63-2047)
>00:33:18,756 DEBUG storage.ui: free region not suitable for request
>00:33:18,756 DEBUG storage.ui: looking for intersection between extended (11380736-1677721599) and free (11380799-1677721599)
>00:33:18,757 DEBUG storage.ui: current free range is 11380799-1677721599 (813642MB)
>00:33:18,758 DEBUG storage.ui: adjusted start sector from 11380799 to 11384832
>00:33:18,759 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req1 ;
>00:33:18,760 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 5  path: /dev/sda5  type: 1
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c06362390>  PedPartition: <_ped.Partition object at 0x7f7c06537fb0>
>00:33:18,761 DEBUG storage.ui:               PartitionDevice._setDisk: sda5 ; new: sda ; old: None ;
>00:33:18,763 DEBUG storage.ui:                DiskDevice.addChild: kids: 3 ; name: sda ;
>00:33:18,763 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,764 DEBUG storage.ui: adding request 13 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,764 DEBUG storage.ui: adding request 10 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,765 DEBUG storage.ui: adding request 11 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,765 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:18,766 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:18,767 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda2  growable = False
>base = 8257536  growth = 0  max_grow = 0
>done = True
>00:33:18,767 DEBUG storage.ui: req: PartitionRequest instance --
>id = 10  name = sda3  growable = True
>base = 2097152  growth = 0  max_grow = 102760448
>done = False
>00:33:18,767 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda5  growable = True
>base = 1024000  growth = 0  max_grow = 4293943295
>done = False
>00:33:18,768 DEBUG storage.ui: 2 requests and 1665318849 (813143MB) left in chunk
>00:33:18,768 DEBUG storage.ui: adding 1118954397 (546364MB) to 10 (sda3)
>00:33:18,769 DEBUG storage.ui: taking back 1016193949 (496188MB) from 10 (sda3)
>00:33:18,769 DEBUG storage.ui: new grow amount for request 10 (sda3) is 102760448 units, or 50176MB
>00:33:18,770 DEBUG storage.ui: adding 546364451 (266779MB) to 11 (sda5)
>00:33:18,770 DEBUG storage.ui: new grow amount for request 11 (sda5) is 546364451 units, or 266779MB
>00:33:18,770 DEBUG storage.ui: 1 requests and 1016193950 (496188MB) left in chunk
>00:33:18,771 DEBUG storage.ui: adding 1016193950 (496188MB) to 11 (sda5)
>00:33:18,771 DEBUG storage.ui: new grow amount for request 11 (sda5) is 1562558401 units, or 762967MB
>00:33:18,771 DEBUG storage.ui: request 12 (sda1) growth: 0 (0MB) size: 500MB
>00:33:18,771 DEBUG storage.ui: request 13 (sda2) growth: 0 (0MB) size: 4032MB
>00:33:18,771 DEBUG storage.ui: request 10 (sda3) growth: 102760448 (50176MB) size: 51200MB
>00:33:18,772 DEBUG storage.ui: request 11 (sda5) growth: 1562558401 (762967MB) size: 763467MB
>00:33:18,772 DEBUG storage.ui: disk /dev/sda growth: 1665318849 (813143MB)
>00:33:18,773 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda5 ;
>00:33:18,773 DEBUG storage.ui: device sda5 new partedPartition None
>00:33:18,774 DEBUG storage.ui:               PartitionDevice._setDisk: req1 ; new: None ; old: sda ;
>00:33:18,775 DEBUG storage.ui:                DiskDevice.removeChild: kids: 4 ; name: sda ;
>00:33:18,776 DEBUG storage.ui: total growth: 1665318849 sectors
>00:33:18,776 DEBUG storage.ui: updating use_disk to sda, type: 2
>00:33:18,777 DEBUG storage.ui: new free: 11380736-1677721599 / 813643MB
>00:33:18,777 DEBUG storage.ui: new free allows for 1665318849 sectors of growth
>00:33:18,777 DEBUG storage.ui: checking freespace on sdb
>00:33:18,778 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=500MB boot=False best=None grow=True
>00:33:18,778 DEBUG storage.ui: current free range is 63-1677721599 (819199MB)
>00:33:18,779 DEBUG storage.ui: evaluating growth potential for new layout
>00:33:18,779 DEBUG storage.ui: calculating growth for disk /dev/sdb
>00:33:18,779 DEBUG storage.ui: adjusted start sector from 63 to 2048
>00:33:18,781 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req1 ;
>00:33:18,781 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c06362890>  PedPartition: <_ped.Partition object at 0x7f7c06385170>
>00:33:18,782 DEBUG storage.ui:               PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>00:33:18,783 DEBUG storage.ui:                DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:18,784 DEBUG storage.ui: adding request 11 to chunk 1677721537 (63-1677721599) on /dev/sdb
>00:33:18,784 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:18,784 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sdb1  growable = True
>base = 1024000  growth = 0  max_grow = 4293943295
>done = False
>00:33:18,784 DEBUG storage.ui: 1 requests and 1676697537 (818699MB) left in chunk
>00:33:18,785 DEBUG storage.ui: adding 1676697537 (818699MB) to 11 (sdb1)
>00:33:18,785 DEBUG storage.ui: new grow amount for request 11 (sdb1) is 1676697537 units, or 818699MB
>00:33:18,785 DEBUG storage.ui: request 11 (sdb1) growth: 1676697537 (818699MB) size: 819199MB
>00:33:18,785 DEBUG storage.ui: disk /dev/sdb growth: 1676697537 (818699MB)
>00:33:18,786 DEBUG storage.ui: calculating growth for disk /dev/sda
>00:33:18,786 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,786 DEBUG storage.ui: adding request 13 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,787 DEBUG storage.ui: adding request 10 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,787 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:18,787 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:18,787 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda2  growable = False
>base = 8257536  growth = 0  max_grow = 0
>done = True
>00:33:18,788 DEBUG storage.ui: req: PartitionRequest instance --
>id = 10  name = sda3  growable = True
>base = 2097152  growth = 0  max_grow = 102760448
>done = False
>00:33:18,788 DEBUG storage.ui: 1 requests and 1666342849 (813643MB) left in chunk
>00:33:18,788 DEBUG storage.ui: adding 1666342849 (813643MB) to 10 (sda3)
>00:33:18,788 DEBUG storage.ui: taking back 1563582401 (763467MB) from 10 (sda3)
>00:33:18,789 DEBUG storage.ui: new grow amount for request 10 (sda3) is 102760448 units, or 50176MB
>00:33:18,789 DEBUG storage.ui: request 12 (sda1) growth: 0 (0MB) size: 500MB
>00:33:18,789 DEBUG storage.ui: request 13 (sda2) growth: 0 (0MB) size: 4032MB
>00:33:18,789 DEBUG storage.ui: request 10 (sda3) growth: 102760448 (50176MB) size: 51200MB
>00:33:18,789 DEBUG storage.ui: disk /dev/sda growth: 102760448 (50176MB)
>00:33:18,791 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sdb1 ;
>00:33:18,791 DEBUG storage.ui: device sdb1 new partedPartition None
>00:33:18,792 DEBUG storage.ui:               PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>00:33:18,793 DEBUG storage.ui:                DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:18,793 DEBUG storage.ui: total growth: 1779457985 sectors
>00:33:18,794 DEBUG storage.ui: updating use_disk to sdb, type: 0
>00:33:18,794 DEBUG storage.ui: new free: 63-1677721599 / 819199MB
>00:33:18,794 DEBUG storage.ui: new free allows for 1779457985 sectors of growth
>00:33:18,794 DEBUG storage.ui: adjusted start sector from 63 to 2048
>00:33:18,795 DEBUG storage.ui: created partition sdb1 of 500MB and added it to /dev/sdb
>00:33:18,796 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req1 ;
>00:33:18,797 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c063624d0>  PedPartition: <_ped.Partition object at 0x7f7c06385530>
>00:33:18,798 DEBUG storage.ui:               PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>00:33:18,799 DEBUG storage.ui:                DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:18,800 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sdb1 ;
>00:33:18,801 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c06362b90>  PedPartition: <_ped.Partition object at 0x7f7c063854d0>
>00:33:18,801 DEBUG storage.ui: growPartitions: disks=['sda', 'sdb'], partitions=['sda3(id 10)', 'sdb1(id 11)', 'sda1(id 12)', 'sda2(id 13)']
>00:33:18,801 DEBUG storage.ui: growable partitions are ['sda3', 'sdb1']
>00:33:18,802 DEBUG storage.ui: adding request 10 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,802 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,803 DEBUG storage.ui: adding request 13 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:18,803 DEBUG storage.ui: disk sda has 1 chunks
>00:33:18,803 DEBUG storage.ui: adding request 11 to chunk 1677721537 (63-1677721599) on /dev/sdb
>00:33:18,803 DEBUG storage.ui: disk sdb has 1 chunks
>00:33:18,804 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:18,804 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:18,804 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda2  growable = False
>base = 8257536  growth = 0  max_grow = 0
>done = True
>00:33:18,804 DEBUG storage.ui: req: PartitionRequest instance --
>id = 10  name = sda3  growable = True
>base = 2097152  growth = 0  max_grow = 102760448
>done = False
>00:33:18,805 DEBUG storage.ui: 1 requests and 1666342849 (813643MB) left in chunk
>00:33:18,805 DEBUG storage.ui: adding 1666342849 (813643MB) to 10 (sda3)
>00:33:18,805 DEBUG storage.ui: taking back 1563582401 (763467MB) from 10 (sda3)
>00:33:18,805 DEBUG storage.ui: new grow amount for request 10 (sda3) is 102760448 units, or 50176MB
>00:33:18,806 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:18,806 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sdb1  growable = True
>base = 1024000  growth = 0  max_grow = 4293943295
>done = False
>00:33:18,806 DEBUG storage.ui: 1 requests and 1676697537 (818699MB) left in chunk
>00:33:18,806 DEBUG storage.ui: adding 1676697537 (818699MB) to 11 (sdb1)
>00:33:18,807 DEBUG storage.ui: new grow amount for request 11 (sdb1) is 1676697537 units, or 818699MB
>00:33:18,807 DEBUG storage.ui: growing partitions on sda
>00:33:18,807 DEBUG storage.ui: partition sda1 (12): 0
>00:33:18,807 DEBUG storage.ui: new geometry for sda1: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c06362c90>
>00:33:18,808 DEBUG storage.ui: partition sda2 (13): 0
>00:33:18,808 DEBUG storage.ui: new geometry for sda2: parted.Geometry instance --
>  start: 1026048  end: 9283583  length: 8257536
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c06362b10>
>00:33:18,809 DEBUG storage.ui: partition sda3 (10): 0
>00:33:18,809 DEBUG storage.ui: new geometry for sda3: parted.Geometry instance --
>  start: 9283584  end: 114141183  length: 104857600
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c1a27f250>
>00:33:18,810 DEBUG storage.ui: removing all non-preexisting partitions ['sda1(id 12)', 'sda2(id 13)', 'sda3(id 10)'] from disk(s) ['sda']
>00:33:18,811 DEBUG storage.ui:                PartitionDevice._setPartedPartition: sda1 ;
>00:33:18,811 DEBUG storage.ui: device sda1 new partedPartition None
>00:33:18,812 DEBUG storage.ui:                PartitionDevice._setDisk: req2 ; new: None ; old: sda ;
>00:33:18,813 DEBUG storage.ui:                 DiskDevice.removeChild: kids: 3 ; name: sda ;
>00:33:18,815 DEBUG storage.ui:                PartitionDevice._setPartedPartition: sda2 ;
>00:33:18,815 DEBUG storage.ui: device sda2 new partedPartition None
>00:33:18,816 DEBUG storage.ui:                PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>00:33:18,817 DEBUG storage.ui:                 DiskDevice.removeChild: kids: 2 ; name: sda ;
>00:33:18,818 DEBUG storage.ui:                PartitionDevice._setPartedPartition: sda3 ;
>00:33:18,819 DEBUG storage.ui: device sda3 new partedPartition None
>00:33:18,820 DEBUG storage.ui:                PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>00:33:18,821 DEBUG storage.ui:                 DiskDevice.removeChild: kids: 1 ; name: sda ;
>00:33:18,821 DEBUG storage.ui: back from removeNewPartitions
>00:33:18,821 DEBUG storage.ui: extended: None
>00:33:18,822 DEBUG storage.ui: setting req2 new geometry: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c06362c90>
>00:33:18,823 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req2 ;
>00:33:18,823 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c065a16d0>  PedPartition: <_ped.Partition object at 0x7f7c06385e90>
>00:33:18,824 DEBUG storage.ui:               PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>00:33:18,825 DEBUG storage.ui:                DiskDevice.addChild: kids: 0 ; name: sda ;
>00:33:18,827 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda1 ;
>00:33:18,827 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c065a1a50>  PedPartition: <_ped.Partition object at 0x7f7c06385230>
>00:33:18,828 DEBUG storage.ui: setting req3 new geometry: parted.Geometry instance --
>  start: 1026048  end: 9283583  length: 8257536
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c06362b10>
>00:33:18,829 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req3 ;
>00:33:18,829 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c065a1410>  PedPartition: <_ped.Partition object at 0x7f7c06385650>
>00:33:18,830 DEBUG storage.ui:               PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>00:33:18,832 DEBUG storage.ui:                DiskDevice.addChild: kids: 1 ; name: sda ;
>00:33:18,833 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda2 ;
>00:33:18,833 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c0672b8d0>  PedPartition: <_ped.Partition object at 0x7f7c06385ef0>
>00:33:18,834 DEBUG storage.ui: setting req0 new geometry: parted.Geometry instance --
>  start: 9283584  end: 114141183  length: 104857600
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c1a27f250>
>00:33:18,835 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req0 ;
>00:33:18,835 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c065a1b50>  PedPartition: <_ped.Partition object at 0x7f7c06537fb0>
>00:33:18,836 DEBUG storage.ui:               PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>00:33:18,838 DEBUG storage.ui:                DiskDevice.addChild: kids: 2 ; name: sda ;
>00:33:18,839 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda3 ;
>00:33:18,839 DEBUG storage.ui: device sda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ed73d0>  PedPartition: <_ped.Partition object at 0x7f7c06385290>
>00:33:18,840 DEBUG storage.ui: growing partitions on sdb
>00:33:18,840 DEBUG storage.ui: partition sdb1 (11): 0
>00:33:18,840 DEBUG storage.ui: new geometry for sdb1: parted.Geometry instance --
>  start: 2048  end: 1677721599  length: 1677719552
>  device: <parted.device.Device object at 0x4225c50>  PedGeometry: <_ped.Geometry object at 0x7f7c065a1d50>
>00:33:18,841 DEBUG storage.ui: removing all non-preexisting partitions ['sdb1(id 11)'] from disk(s) ['sdb']
>00:33:18,842 DEBUG storage.ui:                PartitionDevice._setPartedPartition: sdb1 ;
>00:33:18,842 DEBUG storage.ui: device sdb1 new partedPartition None
>00:33:18,844 DEBUG storage.ui:                PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>00:33:18,845 DEBUG storage.ui:                 DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:18,845 DEBUG storage.ui: back from removeNewPartitions
>00:33:18,845 DEBUG storage.ui: extended: None
>00:33:18,845 DEBUG storage.ui: setting req1 new geometry: parted.Geometry instance --
>  start: 2048  end: 1677721599  length: 1677719552
>  device: <parted.device.Device object at 0x4225c50>  PedGeometry: <_ped.Geometry object at 0x7f7c065a1d50>
>00:33:18,847 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req1 ;
>00:33:18,847 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c0669d350>  PedPartition: <_ped.Partition object at 0x7f7c06385470>
>00:33:18,848 DEBUG storage.ui:               PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>00:33:18,849 DEBUG storage.ui:                DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:18,851 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sdb1 ;
>00:33:18,851 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c0669d4d0>  PedPartition: <_ped.Partition object at 0x7f7c063853b0>
>00:33:18,851 DEBUG storage.ui: fixing size of non-existent 500MB partition sda1 (12) with non-existent ext4 filesystem mounted at /boot at 500.00
>00:33:18,852 DEBUG storage.ui: fixing size of non-existent 4032MB partition sda2 (13) with non-existent swap at 4032.00
>00:33:18,852 DEBUG storage.ui: fixing size of non-existent 51200MB partition sda3 (10) with non-existent ext4 filesystem mounted at / at 51200.00
>00:33:18,853 DEBUG storage.ui: fixing size of non-existent 819199MB partition sdb1 (11) with non-existent ext4 filesystem mounted at /home at 819199.00
>00:33:18,854 DEBUG storage.ui:              DeviceTree.getDeviceByName: name: sda ;
>00:33:18,856 DEBUG storage.ui:              DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:18,856 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:18,857 DEBUG storage.ui: _is_valid_disklabel(sda) returning True
>00:33:18,857 DEBUG storage.ui: _is_valid_size(sda) returning True
>00:33:18,858 DEBUG storage.ui: _is_valid_location(sda) returning True
>00:33:18,858 DEBUG storage.ui: _is_valid_format(sda) returning True
>00:33:18,858 DEBUG storage.ui: is_valid_stage1_device(sda) returning True
>00:33:18,860 DEBUG storage.ui: _is_valid_disklabel(sda) returning True
>00:33:18,861 DEBUG storage.ui: _is_valid_size(sda) returning True
>00:33:18,861 DEBUG storage.ui: _is_valid_location(sda) returning True
>00:33:18,861 DEBUG storage.ui: _is_valid_format(sda) returning True
>00:33:18,861 DEBUG storage.ui: is_valid_stage1_device(sda) returning True
>00:33:18,862 DEBUG storage.ui: _is_valid_disklabel(sda1) returning True
>00:33:18,862 DEBUG storage.ui: _is_valid_size(sda1) returning True
>00:33:18,862 DEBUG storage.ui: _is_valid_location(sda1) returning True
>00:33:18,863 DEBUG storage.ui: _is_valid_partition(sda1) returning True
>00:33:18,863 DEBUG storage.ui: _is_valid_format(sda1) returning True
>00:33:18,863 DEBUG storage.ui: is_valid_stage2_device(sda1) returning True
>00:33:18,885 DEBUG storage: getFormat('None') returning DeviceFormat instance
>00:33:18,888 DEBUG storage:                     Ext4FS.supported: supported: True ;
>00:33:18,888 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>00:33:18,900 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.PartitionFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 500.0, ['sda'], None
>00:33:18,902 DEBUG storage: getFormat('None') returning DeviceFormat instance
>00:33:22,706 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.PartitionFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 500.0, ['sda'], None
>00:33:22,709 DEBUG storage: getFormat('None') returning DeviceFormat instance
>00:33:24,440 DEBUG storage:             BTRFS.supported: supported: True ;
>00:33:24,441 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>00:33:24,443 DEBUG storage:          BTRFS.supported: supported: True ;
>00:33:24,444 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.BTRFSFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 51200.0, ['sda', 'sdb'], single
>00:33:24,449 DEBUG storage:               BTRFS.supported: supported: True ;
>00:33:24,449 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>00:33:28,590 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.BTRFSFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 51200.0, ['sda'], single
>00:33:28,591 INFO storage.ui: removed partition sda3 (id 10) from device tree
>00:33:28,592 DEBUG storage.ui:                DiskDevice.removeChild: kids: 3 ; name: sda ;
>00:33:28,593 INFO storage.ui: registered action: [12] Destroy Device partition sda3 (id 10)
>00:33:28,594 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.BTRFSFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 51200.0, ['sda'], single
>00:33:28,595 DEBUG storage.ui: device requires 51200
>00:33:28,597 DEBUG storage.ui:                   BTRFS.supported: supported: True ;
>00:33:28,597 DEBUG storage.ui: getFormat('btrfs') returning BTRFS instance
>00:33:28,599 DEBUG storage.ui:                   DiskDevice.addChild: kids: 2 ; name: sda ;
>00:33:28,600 DEBUG storage.ui:                   PartitionDevice._setFormat: req4 ;
>00:33:28,602 DEBUG storage.ui:                    PartitionDevice._setFormat: req4 ; current: None ; type: btrfs ;
>00:33:28,603 DEBUG storage.ui:                 DiskDevice.removeChild: kids: 3 ; name: sda ;
>00:33:28,603 INFO storage.ui: added partition req4 (id 14) to device tree
>00:33:28,604 INFO storage.ui: registered action: [13] Create Device partition req4 (id 14)
>00:33:28,604 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:28,605 INFO storage.ui: registered action: [14] Create Format btrfs filesystem on partition req4 (id 14)
>00:33:28,605 DEBUG storage.ui: adding a TotalSizeSet with size 51200
>00:33:28,606 DEBUG storage.ui: set.allocated = 1
>00:33:28,607 DEBUG storage.ui:                 DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>00:33:28,609 DEBUG storage.ui:                 DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>00:33:28,610 DEBUG storage.ui: removing all non-preexisting partitions ['req4(id 14)', 'sda1(id 12)', 'sda2(id 13)', 'sdb1(id 11)'] from disk(s) ['sda', 'sdb']
>00:33:28,611 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda1 ;
>00:33:28,611 DEBUG storage.ui: device sda1 new partedPartition None
>00:33:28,613 DEBUG storage.ui:                   PartitionDevice._setDisk: req2 ; new: None ; old: sda ;
>00:33:28,615 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 2 ; name: sda ;
>00:33:28,617 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda2 ;
>00:33:28,617 DEBUG storage.ui: device sda2 new partedPartition None
>00:33:28,618 DEBUG storage.ui:                   PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>00:33:28,620 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 1 ; name: sda ;
>00:33:28,621 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sdb1 ;
>00:33:28,621 DEBUG storage.ui: device sdb1 new partedPartition None
>00:33:28,623 DEBUG storage.ui:                   PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>00:33:28,625 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:28,626 DEBUG storage.ui: allocatePartitions: disks=['sda', 'sdb'] ; partitions=['req4(id 14)', 'req2(id 12)', 'req3(id 13)', 'req1(id 11)']
>00:33:28,626 DEBUG storage.ui: removing all non-preexisting partitions ['req2(id 12)', 'req4(id 14)', 'req1(id 11)', 'req3(id 13)'] from disk(s) ['sda', 'sdb']
>00:33:28,627 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,629 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,629 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,631 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,632 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,633 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,634 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,636 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,636 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,638 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,640 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,640 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,641 DEBUG storage.ui: allocating partition: req2 ; id: 12 ; disks: ['sda', 'sdb'] ;
>boot: True ; primary: False ; size: 500MB ; grow: False ; max_size: 0
>00:33:28,641 DEBUG storage.ui: checking freespace on sda
>00:33:28,642 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=500MB boot=True best=None grow=False
>00:33:28,643 DEBUG storage.ui: current free range is 63-1677721599 (819199MB)
>00:33:28,643 DEBUG storage.ui: updating use_disk to sda, type: 0
>00:33:28,644 DEBUG storage.ui: new free: 63-1677721599 / 819199MB
>00:33:28,644 DEBUG storage.ui: new free allows for 0 sectors of growth
>00:33:28,645 DEBUG storage.ui: found free space for bootable request
>00:33:28,645 DEBUG storage.ui: adjusted start sector from 63 to 2048
>00:33:28,646 DEBUG storage.ui: created partition sda1 of 500MB and added it to /dev/sda
>00:33:28,647 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req2 ;
>00:33:28,648 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c0669d990>  PedPartition: <_ped.Partition object at 0x7f7c063850b0>
>00:33:28,650 DEBUG storage.ui:                   PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>00:33:28,651 DEBUG storage.ui:                    DiskDevice.addChild: kids: 0 ; name: sda ;
>00:33:28,652 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda1 ;
>00:33:28,653 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c065a1650>  PedPartition: <_ped.Partition object at 0x7f7c063855f0>
>00:33:28,654 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,656 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,656 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,657 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,658 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,658 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,658 DEBUG storage.ui: allocating partition: req4 ; id: 14 ; disks: ['sda'] ;
>boot: False ; primary: False ; size: 1MB ; grow: True ; max_size: 51200.0
>00:33:28,658 DEBUG storage.ui: checking freespace on sda
>00:33:28,659 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=1MB boot=False best=None grow=True
>00:33:28,659 DEBUG storage.ui: current free range is 63-2047 (0MB)
>00:33:28,659 DEBUG storage.ui: current free range is 1026048-1677721599 (818699MB)
>00:33:28,659 DEBUG storage.ui: evaluating growth potential for new layout
>00:33:28,660 DEBUG storage.ui: calculating growth for disk /dev/sdb
>00:33:28,660 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:28,660 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>00:33:28,660 DEBUG storage.ui: calculating growth for disk /dev/sda
>00:33:28,661 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req4 ;
>00:33:28,661 DEBUG storage.ui: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ed7290>  PedPartition: <_ped.Partition object at 0x7f7c06385230>
>00:33:28,663 DEBUG storage.ui:                   PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>00:33:28,664 DEBUG storage.ui:                    DiskDevice.addChild: kids: 1 ; name: sda ;
>00:33:28,664 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:28,664 DEBUG storage.ui: adding request 14 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:28,664 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:28,664 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:28,664 DEBUG storage.ui: req: PartitionRequest instance --
>id = 14  name = sda2  growable = True
>base = 2048  growth = 0  max_grow = 104855552
>done = False
>00:33:28,665 DEBUG storage.ui: 1 requests and 1676695489 (818698MB) left in chunk
>00:33:28,665 DEBUG storage.ui: adding 1676695489 (818698MB) to 14 (sda2)
>00:33:28,665 DEBUG storage.ui: taking back 1571839937 (767499MB) from 14 (sda2)
>00:33:28,665 DEBUG storage.ui: new grow amount for request 14 (sda2) is 104855552 units, or 51199MB
>00:33:28,665 DEBUG storage.ui: request 12 (sda1) growth: 0 (0MB) size: 500MB
>00:33:28,665 DEBUG storage.ui: request 14 (sda2) growth: 104855552 (51199MB) size: 51200MB
>00:33:28,665 DEBUG storage.ui: disk /dev/sda growth: 104855552 (51199MB)
>00:33:28,666 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda2 ;
>00:33:28,666 DEBUG storage.ui: device sda2 new partedPartition None
>00:33:28,667 DEBUG storage.ui:                   PartitionDevice._setDisk: req4 ; new: None ; old: sda ;
>00:33:28,668 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 2 ; name: sda ;
>00:33:28,669 DEBUG storage.ui: total growth: 104855552 sectors
>00:33:28,669 DEBUG storage.ui: updating use_disk to sda, type: 0
>00:33:28,669 DEBUG storage.ui: new free: 1026048-1677721599 / 818699MB
>00:33:28,669 DEBUG storage.ui: new free allows for 104855552 sectors of growth
>00:33:28,669 DEBUG storage.ui: created partition sda2 of 1MB and added it to /dev/sda
>00:33:28,670 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req4 ;
>00:33:28,671 DEBUG storage.ui: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ed7f90>  PedPartition: <_ped.Partition object at 0x7f7c06385ef0>
>00:33:28,672 DEBUG storage.ui:                   PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>00:33:28,673 DEBUG storage.ui:                    DiskDevice.addChild: kids: 1 ; name: sda ;
>00:33:28,674 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda2 ;
>00:33:28,675 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ed7590>  PedPartition: <_ped.Partition object at 0x7f7c066b3110>
>00:33:28,677 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,679 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,679 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,680 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,682 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,683 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,684 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,686 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,686 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,688 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,690 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,690 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,691 DEBUG storage.ui: allocating partition: req1 ; id: 11 ; disks: ['sda', 'sdb'] ;
>boot: False ; primary: False ; size: 819199MB ; grow: False ; max_size: 0
>00:33:28,691 DEBUG storage.ui: checking freespace on sda
>00:33:28,692 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=819199MB boot=False best=None grow=False
>00:33:28,693 DEBUG storage.ui: current free range is 63-2047 (0MB)
>00:33:28,693 DEBUG storage.ui: current free range is 1028096-1677721599 (818698MB)
>00:33:28,694 DEBUG storage.ui: not enough free space for primary -- trying logical
>00:33:28,694 DEBUG storage.ui: checking freespace on sdb
>00:33:28,695 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=819199MB boot=False best=None grow=False
>00:33:28,696 DEBUG storage.ui: current free range is 63-1677721599 (819199MB)
>00:33:28,696 DEBUG storage.ui: evaluating growth potential for new layout
>00:33:28,697 DEBUG storage.ui: calculating growth for disk /dev/sdb
>00:33:28,697 DEBUG storage.ui: adjusted start sector from 63 to 2048
>00:33:28,699 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req1 ;
>00:33:28,699 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c061c3310>  PedPartition: <_ped.Partition object at 0x7f7c063853b0>
>00:33:28,701 DEBUG storage.ui:                   PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>00:33:28,702 DEBUG storage.ui:                    DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:28,703 DEBUG storage.ui: adding request 11 to chunk 1677721537 (63-1677721599) on /dev/sdb
>00:33:28,703 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:28,704 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sdb1  growable = False
>base = 1677719552  growth = 0  max_grow = 0
>done = True
>00:33:28,704 DEBUG storage.ui: request 11 (sdb1) growth: 0 (0MB) size: 819199MB
>00:33:28,705 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>00:33:28,705 DEBUG storage.ui: calculating growth for disk /dev/sda
>00:33:28,706 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:28,707 DEBUG storage.ui: adding request 14 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:28,707 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:28,708 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:28,708 DEBUG storage.ui: req: PartitionRequest instance --
>id = 14  name = sda2  growable = True
>base = 2048  growth = 0  max_grow = 104855552
>done = False
>00:33:28,709 DEBUG storage.ui: 1 requests and 1676695489 (818698MB) left in chunk
>00:33:28,709 DEBUG storage.ui: adding 1676695489 (818698MB) to 14 (sda2)
>00:33:28,710 DEBUG storage.ui: taking back 1571839937 (767499MB) from 14 (sda2)
>00:33:28,710 DEBUG storage.ui: new grow amount for request 14 (sda2) is 104855552 units, or 51199MB
>00:33:28,710 DEBUG storage.ui: request 12 (sda1) growth: 0 (0MB) size: 500MB
>00:33:28,711 DEBUG storage.ui: request 14 (sda2) growth: 104855552 (51199MB) size: 51200MB
>00:33:28,711 DEBUG storage.ui: disk /dev/sda growth: 104855552 (51199MB)
>00:33:28,713 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sdb1 ;
>00:33:28,713 DEBUG storage.ui: device sdb1 new partedPartition None
>00:33:28,715 DEBUG storage.ui:                   PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>00:33:28,716 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:28,716 DEBUG storage.ui: total growth: 104855552 sectors
>00:33:28,717 DEBUG storage.ui: updating use_disk to sdb, type: 0
>00:33:28,717 DEBUG storage.ui: new free: 63-1677721599 / 819199MB
>00:33:28,718 DEBUG storage.ui: new free allows for 104855552 sectors of growth
>00:33:28,718 DEBUG storage.ui: adjusted start sector from 63 to 2048
>00:33:28,719 DEBUG storage.ui: created partition sdb1 of 819199MB and added it to /dev/sdb
>00:33:28,721 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req1 ;
>00:33:28,721 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c065a1ad0>  PedPartition: <_ped.Partition object at 0x7f7c06385230>
>00:33:28,723 DEBUG storage.ui:                   PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>00:33:28,724 DEBUG storage.ui:                    DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:28,726 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sdb1 ;
>00:33:28,726 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c0669d990>  PedPartition: <_ped.Partition object at 0x7f7c06385ef0>
>00:33:28,728 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,729 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,730 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,732 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,733 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,733 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,735 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,736 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,737 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,738 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:28,741 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:28,741 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:28,742 DEBUG storage.ui: allocating partition: req3 ; id: 13 ; disks: ['sda', 'sdb'] ;
>boot: False ; primary: False ; size: 4032MB ; grow: False ; max_size: 0
>00:33:28,742 DEBUG storage.ui: checking freespace on sda
>00:33:28,743 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=4032MB boot=False best=None grow=False
>00:33:28,744 DEBUG storage.ui: current free range is 63-2047 (0MB)
>00:33:28,744 DEBUG storage.ui: current free range is 1028096-1677721599 (818698MB)
>00:33:28,745 DEBUG storage.ui: evaluating growth potential for new layout
>00:33:28,745 DEBUG storage.ui: calculating growth for disk /dev/sdb
>00:33:28,746 DEBUG storage.ui: adding request 11 to chunk 1677721537 (63-1677721599) on /dev/sdb
>00:33:28,746 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:28,747 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sdb1  growable = False
>base = 1677719552  growth = 0  max_grow = 0
>done = True
>00:33:28,747 DEBUG storage.ui: request 11 (sdb1) growth: 0 (0MB) size: 819199MB
>00:33:28,748 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>00:33:28,748 DEBUG storage.ui: calculating growth for disk /dev/sda
>00:33:28,750 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req3 ;
>00:33:28,750 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ce6810>  PedPartition: <_ped.Partition object at 0x7f7c063850b0>
>00:33:28,752 DEBUG storage.ui:                   PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>00:33:28,754 DEBUG storage.ui:                    DiskDevice.addChild: kids: 2 ; name: sda ;
>00:33:28,754 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:28,755 DEBUG storage.ui: adding request 14 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:28,755 DEBUG storage.ui: adding request 13 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:28,756 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:28,756 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:28,757 DEBUG storage.ui: req: PartitionRequest instance --
>id = 14  name = sda2  growable = True
>base = 2048  growth = 0  max_grow = 104855552
>done = False
>00:33:28,757 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda3  growable = False
>base = 8257536  growth = 0  max_grow = 0
>done = True
>00:33:28,758 DEBUG storage.ui: 1 requests and 1668437953 (814666MB) left in chunk
>00:33:28,758 DEBUG storage.ui: adding 1668437953 (814666MB) to 14 (sda2)
>00:33:28,759 DEBUG storage.ui: taking back 1563582401 (763467MB) from 14 (sda2)
>00:33:28,759 DEBUG storage.ui: new grow amount for request 14 (sda2) is 104855552 units, or 51199MB
>00:33:28,760 DEBUG storage.ui: request 12 (sda1) growth: 0 (0MB) size: 500MB
>00:33:28,760 DEBUG storage.ui: request 14 (sda2) growth: 104855552 (51199MB) size: 51200MB
>00:33:28,761 DEBUG storage.ui: request 13 (sda3) growth: 0 (0MB) size: 4032MB
>00:33:28,761 DEBUG storage.ui: disk /dev/sda growth: 104855552 (51199MB)
>00:33:28,763 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda3 ;
>00:33:28,763 DEBUG storage.ui: device sda3 new partedPartition None
>00:33:28,764 DEBUG storage.ui:                   PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>00:33:28,766 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 3 ; name: sda ;
>00:33:28,766 DEBUG storage.ui: total growth: 104855552 sectors
>00:33:28,767 DEBUG storage.ui: updating use_disk to sda, type: 0
>00:33:28,767 DEBUG storage.ui: new free: 1028096-1677721599 / 818698MB
>00:33:28,768 DEBUG storage.ui: new free allows for 104855552 sectors of growth
>00:33:28,768 DEBUG storage.ui: checking freespace on sdb
>00:33:28,769 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=4032MB boot=False best=parted.Geometry instance --
>  start: 1028096  end: 1677721599  length: 1676693504
>  device: <parted.device.Device object at 0x7f7c05ce6510>  PedGeometry: <_ped.Geometry object at 0x7f7c0669d850> grow=False
>00:33:28,769 DEBUG storage.ui: current free range is 63-2047 (0MB)
>00:33:28,770 DEBUG storage.ui: not enough free space for primary -- trying logical
>00:33:28,771 DEBUG storage.ui: created partition sda3 of 4032MB and added it to /dev/sda
>00:33:28,772 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req3 ;
>00:33:28,773 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ce6550>  PedPartition: <_ped.Partition object at 0x7f7c066b3470>
>00:33:28,775 DEBUG storage.ui:                   PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>00:33:28,776 DEBUG storage.ui:                    DiskDevice.addChild: kids: 2 ; name: sda ;
>00:33:28,778 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda3 ;
>00:33:28,779 DEBUG storage.ui: device sda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c063ea850>  PedPartition: <_ped.Partition object at 0x7f7c066b3d70>
>00:33:28,779 DEBUG storage.ui: growPartitions: disks=['sda', 'sdb'], partitions=['sda2(id 14)', 'sda1(id 12)', 'sda3(id 13)', 'sdb1(id 11)']
>00:33:28,780 DEBUG storage.ui: growable partitions are ['sda2']
>00:33:28,780 DEBUG storage.ui: adding request 14 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:28,781 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:28,781 DEBUG storage.ui: adding request 13 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:28,782 DEBUG storage.ui: disk sda has 1 chunks
>00:33:28,782 DEBUG storage.ui: adding request 11 to chunk 1677721537 (63-1677721599) on /dev/sdb
>00:33:28,783 DEBUG storage.ui: disk sdb has 1 chunks
>00:33:28,784 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:28,784 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:28,785 DEBUG storage.ui: req: PartitionRequest instance --
>id = 14  name = sda2  growable = True
>base = 2048  growth = 0  max_grow = 104855552
>done = False
>00:33:28,785 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda3  growable = False
>base = 8257536  growth = 0  max_grow = 0
>done = True
>00:33:28,786 DEBUG storage.ui: 1 requests and 1668437953 (814666MB) left in chunk
>00:33:28,786 DEBUG storage.ui: adding 1668437953 (814666MB) to 14 (sda2)
>00:33:28,787 DEBUG storage.ui: taking back 1563582401 (763467MB) from 14 (sda2)
>00:33:28,787 DEBUG storage.ui: new grow amount for request 14 (sda2) is 104855552 units, or 51199MB
>00:33:28,788 DEBUG storage.ui: set: ['sda2'] 1/51200
>00:33:28,788 DEBUG storage.ui: PartitionRequest instance --
>id = 14  name = sda2  growable = True
>base = 2048  growth = 104855552  max_grow = 104855552
>done = True
>00:33:28,789 DEBUG storage.ui: needed: 51199
>00:33:28,789 DEBUG storage.ui: set: ['sda2'] 1/51200
>00:33:28,790 DEBUG storage.ui: PartitionRequest instance --
>id = 14  name = sda2  growable = True
>base = 2048  growth = 104855552  max_grow = 104855552
>done = True
>00:33:28,790 DEBUG storage.ui: needed: 51199
>00:33:28,791 DEBUG storage.ui: growing partitions on sda
>00:33:28,791 DEBUG storage.ui: partition sda1 (12): 0
>00:33:28,792 DEBUG storage.ui: new geometry for sda1: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c05ed7550>
>00:33:28,792 DEBUG storage.ui: partition sda2 (14): 0
>00:33:28,793 DEBUG storage.ui: new geometry for sda2: parted.Geometry instance --
>  start: 1026048  end: 105883647  length: 104857600
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c0669dd10>
>00:33:28,793 DEBUG storage.ui: partition sda3 (13): 0
>00:33:28,794 DEBUG storage.ui: new geometry for sda3: parted.Geometry instance --
>  start: 105883648  end: 114141183  length: 8257536
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c0669db90>
>00:33:28,794 DEBUG storage.ui: removing all non-preexisting partitions ['sda1(id 12)', 'sda2(id 14)', 'sda3(id 13)'] from disk(s) ['sda']
>00:33:28,795 DEBUG storage.ui:                    PartitionDevice._setPartedPartition: sda1 ;
>00:33:28,795 DEBUG storage.ui: device sda1 new partedPartition None
>00:33:28,797 DEBUG storage.ui:                    PartitionDevice._setDisk: req2 ; new: None ; old: sda ;
>00:33:28,798 DEBUG storage.ui:                     DiskDevice.removeChild: kids: 3 ; name: sda ;
>00:33:28,799 DEBUG storage.ui:                    PartitionDevice._setPartedPartition: sda2 ;
>00:33:28,800 DEBUG storage.ui: device sda2 new partedPartition None
>00:33:28,801 DEBUG storage.ui:                    PartitionDevice._setDisk: req4 ; new: None ; old: sda ;
>00:33:28,803 DEBUG storage.ui:                     DiskDevice.removeChild: kids: 2 ; name: sda ;
>00:33:28,805 DEBUG storage.ui:                    PartitionDevice._setPartedPartition: sda3 ;
>00:33:28,805 DEBUG storage.ui: device sda3 new partedPartition None
>00:33:28,807 DEBUG storage.ui:                    PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>00:33:28,808 DEBUG storage.ui:                     DiskDevice.removeChild: kids: 1 ; name: sda ;
>00:33:28,809 DEBUG storage.ui: back from removeNewPartitions
>00:33:28,809 DEBUG storage.ui: extended: None
>00:33:28,810 DEBUG storage.ui: setting req2 new geometry: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c05ed7550>
>00:33:28,811 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req2 ;
>00:33:28,812 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c063ea6d0>  PedPartition: <_ped.Partition object at 0x7f7c06385230>
>00:33:28,813 DEBUG storage.ui:                   PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>00:33:28,815 DEBUG storage.ui:                    DiskDevice.addChild: kids: 0 ; name: sda ;
>00:33:28,816 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda1 ;
>00:33:28,817 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c063ea510>  PedPartition: <_ped.Partition object at 0x7f7c066b3110>
>00:33:28,817 DEBUG storage.ui: setting req4 new geometry: parted.Geometry instance --
>  start: 1026048  end: 105883647  length: 104857600
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c0669dd10>
>00:33:28,819 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req4 ;
>00:33:28,819 DEBUG storage.ui: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c1a27f350>  PedPartition: <_ped.Partition object at 0x7f7c063853b0>
>00:33:28,820 DEBUG storage.ui:                   PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>00:33:28,822 DEBUG storage.ui:                    DiskDevice.addChild: kids: 1 ; name: sda ;
>00:33:28,823 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda2 ;
>00:33:28,823 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c063ea3d0>  PedPartition: <_ped.Partition object at 0x7f7c066b3710>
>00:33:28,824 DEBUG storage.ui: setting req3 new geometry: parted.Geometry instance --
>  start: 105883648  end: 114141183  length: 8257536
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c0669db90>
>00:33:28,825 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req3 ;
>00:33:28,825 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c06362b10>  PedPartition: <_ped.Partition object at 0x7f7c066b3ef0>
>00:33:28,827 DEBUG storage.ui:                   PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>00:33:28,828 DEBUG storage.ui:                    DiskDevice.addChild: kids: 2 ; name: sda ;
>00:33:28,829 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda3 ;
>00:33:28,830 DEBUG storage.ui: device sda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05d66cd0>  PedPartition: <_ped.Partition object at 0x7f7c066b30b0>
>00:33:28,830 DEBUG storage.ui: growing partitions on sdb
>00:33:28,830 DEBUG storage.ui: fixing size of non-existent 500MB partition sda1 (12) with non-existent ext4 filesystem mounted at /boot at 500.00
>00:33:28,831 DEBUG storage.ui: fixing size of non-existent 51200MB partition sda2 (14) with non-existent btrfs filesystem at 51200.00
>00:33:28,831 DEBUG storage.ui: fixing size of non-existent 4032MB partition sda3 (13) with non-existent swap at 4032.00
>00:33:28,832 DEBUG storage.ui: fixing size of non-existent 819199MB partition sdb1 (11) with non-existent ext4 filesystem mounted at /home at 819199.00
>00:33:28,833 DEBUG storage.ui: creating new container
>00:33:28,834 DEBUG storage.ui: newBTRFS: args = () ; kwargs = {'parents': [PartitionDevice instance (0x7f7c06362950) --
>  name = sda2  status = False  kids = 0 id = 14
>  parents = ['existing 819200MB disk sda (1) with non-existent msdos disklabel']
>  uuid = None  size = 51200.0
>  format = non-existent btrfs filesystem
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path =   partedDevice = None
>  target size = 1  path = /dev/sda2
>  format args = []  originalFormat = btrfs  grow = False  max size = 51200.0  bootable = False
>  part type = 0  primary = False
>  partedPartition = parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c063ea3d0>  PedPartition: <_ped.Partition object at 0x7f7c066b3710>
>  disk = existing 819200MB disk sda (1) with non-existent msdos disklabel
>  start = 1026048  end = 105883647  length = 104857600
>  flags = ]}
>00:33:28,835 DEBUG storage.ui:                    PartitionDevice.addChild: kids: 0 ; name: sda2 ;
>00:33:28,835 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:28,837 DEBUG storage.ui:                     BTRFSVolumeDevice._setFormat: fedora_f18v ; current: None ; type: None ;
>00:33:28,838 DEBUG storage.ui:                    BTRFS.supported: supported: True ;
>00:33:28,839 DEBUG storage.ui: getFormat('btrfs') returning BTRFS instance
>00:33:28,840 DEBUG storage.ui:                   BTRFSVolumeDevice._setFormat: btrfs.15 ; current: None ; type: btrfs ;
>00:33:28,842 DEBUG storage.ui:                   BTRFS.supported: supported: True ;
>00:33:28,842 DEBUG storage.ui: getFormat('btrfs') returning BTRFS instance
>00:33:28,843 DEBUG storage.ui:                  BTRFSVolumeDevice._setFormat: btrfs.15 ; current: btrfs ; type: btrfs ;
>00:33:28,844 INFO storage.ui: added btrfs volume fedora_f18v (id 15) to device tree
>00:33:28,844 INFO storage.ui: registered action: [15] Create Device btrfs volume fedora_f18v (id 15)
>00:33:28,845 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:28,845 INFO storage.ui: registered action: [16] Create Format btrfs filesystem on btrfs volume fedora_f18v (id 15)
>00:33:28,846 DEBUG storage.ui: BTRFSVolumeDevice instance (0x7f7c0672b110) --
>  name = fedora_f18v  status = False  kids = 0 id = 15
>  parents = ['non-existent 51200MB partition sda2 (14) with non-existent btrfs filesystem']
>  uuid = None  size = 51200.0
>  format = non-existent btrfs filesystem
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/sda2
>  format args = []  originalFormat = btrfs
>00:33:28,846 DEBUG storage.ui: creating new device
>00:33:28,846 DEBUG storage.ui: newBTRFS: args = () ; kwargs = {'metaDataLevel': 'single', 'subvol': True, 'fmt_type': 'btrfs', 'fmt_args': {}, 'dataLevel': 'single', 'parents': [BTRFSVolumeDevice instance (0x7f7c0672b110) --
>  name = fedora_f18v  status = False  kids = 0 id = 15
>  parents = ['non-existent 51200MB partition sda2 (14) with non-existent btrfs filesystem']
>  uuid = None  size = 51200.0
>  format = non-existent btrfs filesystem
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/sda2
>  format args = []  originalFormat = btrfs], 'mountpoint': '/', 'size': 51200.0}
>00:33:28,848 DEBUG storage.ui:                      BTRFSVolumeDevice.addChild: kids: 0 ; name: fedora_f18v ;
>00:33:28,848 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:28,850 DEBUG storage.ui:                      BTRFSSubVolumeDevice._setFormat: root ; current: None ; type: None ;
>00:33:28,851 DEBUG storage.ui:                     BTRFS.supported: supported: True ;
>00:33:28,851 DEBUG storage.ui: getFormat('btrfs') returning BTRFS instance
>00:33:28,853 DEBUG storage.ui:                   BTRFSSubVolumeDevice._setFormat: root ; current: None ; type: btrfs ;
>00:33:28,853 INFO storage.ui: added btrfs subvolume root (id 16) to device tree
>00:33:28,853 INFO storage.ui: registered action: [17] Create Device btrfs subvolume root (id 16)
>00:33:28,854 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:28,854 INFO storage.ui: registered action: [18] Create Format btrfs filesystem mounted at / on btrfs subvolume root (id 16)
>00:33:28,863 DEBUG storage: getFormat('None') returning DeviceFormat instance
>00:33:28,865 DEBUG storage: getFormat('None') returning DeviceFormat instance
>00:33:28,867 DEBUG storage:                  Ext4FS.supported: supported: True ;
>00:33:28,867 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>00:33:30,566 DEBUG storage:             BTRFS.supported: supported: True ;
>00:33:30,566 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>00:33:30,567 DEBUG storage:          BTRFS.supported: supported: True ;
>00:33:30,569 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.BTRFSFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 819199.0, ['sda', 'sdb'], single
>00:33:30,572 DEBUG storage:               BTRFS.supported: supported: True ;
>00:33:30,572 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>00:33:32,214 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.BTRFSFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 819199.0, ['sdb'], single
>00:33:32,215 INFO storage.ui: removed partition sdb1 (id 11) from device tree
>00:33:32,217 DEBUG storage.ui:                DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:32,217 INFO storage.ui: registered action: [19] Destroy Device partition sdb1 (id 11)
>00:33:32,218 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.BTRFSFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 819199.0, ['sda', 'sdb'], single
>00:33:32,218 DEBUG storage.ui: using container fedora_f18v with 1 devices
>00:33:32,219 DEBUG storage.ui: raw container size reported as 51200
>00:33:32,219 DEBUG storage.ui: device requires 819199
>00:33:32,221 DEBUG storage.ui:                   BTRFS.supported: supported: True ;
>00:33:32,221 DEBUG storage.ui: getFormat('btrfs') returning BTRFS instance
>00:33:32,222 DEBUG storage.ui:                   DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:32,223 DEBUG storage.ui:                   PartitionDevice._setFormat: req5 ;
>00:33:32,225 DEBUG storage.ui:                    PartitionDevice._setFormat: req5 ; current: None ; type: btrfs ;
>00:33:32,226 DEBUG storage.ui:                 DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:32,226 INFO storage.ui: added partition req5 (id 17) to device tree
>00:33:32,227 INFO storage.ui: registered action: [20] Create Device partition req5 (id 17)
>00:33:32,227 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:32,227 INFO storage.ui: registered action: [21] Create Format btrfs filesystem on partition req5 (id 17)
>00:33:32,229 DEBUG storage.ui:                PartitionDevice.addChild: kids: 0 ; name: req5 ;
>00:33:32,229 DEBUG storage.ui: adding a TotalSizeSet with size 870399
>00:33:32,229 DEBUG storage.ui: set.allocated = 2
>00:33:32,231 DEBUG storage.ui:                 DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>00:33:32,232 DEBUG storage.ui:                 DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>00:33:32,233 DEBUG storage.ui: removing all non-preexisting partitions ['req5(id 17)', 'sda1(id 12)', 'sda2(id 14)', 'sda3(id 13)'] from disk(s) ['sda', 'sdb']
>00:33:32,234 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda1 ;
>00:33:32,235 DEBUG storage.ui: device sda1 new partedPartition None
>00:33:32,236 DEBUG storage.ui:                   PartitionDevice._setDisk: req2 ; new: None ; old: sda ;
>00:33:32,237 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 3 ; name: sda ;
>00:33:32,238 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda2 ;
>00:33:32,239 DEBUG storage.ui: device sda2 new partedPartition None
>00:33:32,240 DEBUG storage.ui:                   PartitionDevice._setDisk: req4 ; new: None ; old: sda ;
>00:33:32,241 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 2 ; name: sda ;
>00:33:32,242 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda3 ;
>00:33:32,243 DEBUG storage.ui: device sda3 new partedPartition None
>00:33:32,244 DEBUG storage.ui:                   PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>00:33:32,245 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 1 ; name: sda ;
>00:33:32,245 DEBUG storage.ui: allocatePartitions: disks=['sda', 'sdb'] ; partitions=['req5(id 17)', 'req2(id 12)', 'req4(id 14)', 'req3(id 13)']
>00:33:32,246 DEBUG storage.ui: removing all non-preexisting partitions ['req2(id 12)', 'req5(id 17)', 'req4(id 14)', 'req3(id 13)'] from disk(s) ['sda', 'sdb']
>00:33:32,247 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,248 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,249 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,250 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,251 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,252 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,254 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,256 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,256 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,257 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,259 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,259 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,259 DEBUG storage.ui: allocating partition: req2 ; id: 12 ; disks: ['sda', 'sdb'] ;
>boot: True ; primary: False ; size: 500MB ; grow: False ; max_size: 0
>00:33:32,260 DEBUG storage.ui: checking freespace on sda
>00:33:32,260 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=500MB boot=True best=None grow=False
>00:33:32,261 DEBUG storage.ui: current free range is 63-1677721599 (819199MB)
>00:33:32,261 DEBUG storage.ui: updating use_disk to sda, type: 0
>00:33:32,261 DEBUG storage.ui: new free: 63-1677721599 / 819199MB
>00:33:32,262 DEBUG storage.ui: new free allows for 0 sectors of growth
>00:33:32,262 DEBUG storage.ui: found free space for bootable request
>00:33:32,262 DEBUG storage.ui: adjusted start sector from 63 to 2048
>00:33:32,263 DEBUG storage.ui: created partition sda1 of 500MB and added it to /dev/sda
>00:33:32,264 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req2 ;
>00:33:32,264 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05d66c90>  PedPartition: <_ped.Partition object at 0x7f7c06537890>
>00:33:32,266 DEBUG storage.ui:                   PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>00:33:32,267 DEBUG storage.ui:                    DiskDevice.addChild: kids: 0 ; name: sda ;
>00:33:32,269 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda1 ;
>00:33:32,269 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05d66cd0>  PedPartition: <_ped.Partition object at 0x7f7c063850b0>
>00:33:32,270 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,271 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,271 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,273 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,274 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,275 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,275 DEBUG storage.ui: allocating partition: req5 ; id: 17 ; disks: ['sdb'] ;
>boot: False ; primary: False ; size: 1MB ; grow: True ; max_size: 870399.0
>00:33:32,275 DEBUG storage.ui: checking freespace on sdb
>00:33:32,276 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=1MB boot=False best=None grow=True
>00:33:32,276 DEBUG storage.ui: current free range is 63-1677721599 (819199MB)
>00:33:32,276 DEBUG storage.ui: evaluating growth potential for new layout
>00:33:32,277 DEBUG storage.ui: calculating growth for disk /dev/sdb
>00:33:32,277 DEBUG storage.ui: adjusted start sector from 63 to 2048
>00:33:32,279 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req5 ;
>00:33:32,279 DEBUG storage.ui: device req5 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ce6450>  PedPartition: <_ped.Partition object at 0x7f7c06385170>
>00:33:32,280 DEBUG storage.ui:                   PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>00:33:32,282 DEBUG storage.ui:                    DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:32,282 DEBUG storage.ui: adding request 17 to chunk 1677721537 (63-1677721599) on /dev/sdb
>00:33:32,282 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:32,283 DEBUG storage.ui: req: PartitionRequest instance --
>id = 17  name = sdb1  growable = True
>base = 2048  growth = 0  max_grow = 1782575104
>done = False
>00:33:32,283 DEBUG storage.ui: 1 requests and 1677719489 (819198MB) left in chunk
>00:33:32,283 DEBUG storage.ui: adding 1677719489 (819198MB) to 17 (sdb1)
>00:33:32,283 DEBUG storage.ui: new grow amount for request 17 (sdb1) is 1677719489 units, or 819198MB
>00:33:32,284 DEBUG storage.ui: request 17 (sdb1) growth: 1677719489 (819198MB) size: 819199MB
>00:33:32,284 DEBUG storage.ui: disk /dev/sdb growth: 1677719489 (819198MB)
>00:33:32,284 DEBUG storage.ui: calculating growth for disk /dev/sda
>00:33:32,284 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:32,285 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:32,285 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:32,285 DEBUG storage.ui: request 12 (sda1) growth: 0 (0MB) size: 500MB
>00:33:32,285 DEBUG storage.ui: disk /dev/sda growth: 0 (0MB)
>00:33:32,287 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sdb1 ;
>00:33:32,287 DEBUG storage.ui: device sdb1 new partedPartition None
>00:33:32,288 DEBUG storage.ui:                   PartitionDevice._setDisk: req5 ; new: None ; old: sdb ;
>00:33:32,289 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:32,290 DEBUG storage.ui: total growth: 1677719489 sectors
>00:33:32,290 DEBUG storage.ui: updating use_disk to sdb, type: 0
>00:33:32,290 DEBUG storage.ui: new free: 63-1677721599 / 819199MB
>00:33:32,291 DEBUG storage.ui: new free allows for 1677719489 sectors of growth
>00:33:32,291 DEBUG storage.ui: adjusted start sector from 63 to 2048
>00:33:32,291 DEBUG storage.ui: created partition sdb1 of 1MB and added it to /dev/sdb
>00:33:32,293 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req5 ;
>00:33:32,293 DEBUG storage.ui: device req5 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ce6810>  PedPartition: <_ped.Partition object at 0x7f7c06385530>
>00:33:32,294 DEBUG storage.ui:                   PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>00:33:32,296 DEBUG storage.ui:                    DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:32,297 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sdb1 ;
>00:33:32,298 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ce6c90>  PedPartition: <_ped.Partition object at 0x7f7c063855f0>
>00:33:32,299 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,300 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,301 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,302 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,303 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,304 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,304 DEBUG storage.ui: allocating partition: req4 ; id: 14 ; disks: ['sda'] ;
>boot: False ; primary: False ; size: 1MB ; grow: True ; max_size: 870399.0
>00:33:32,304 DEBUG storage.ui: checking freespace on sda
>00:33:32,305 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=1MB boot=False best=None grow=True
>00:33:32,305 DEBUG storage.ui: current free range is 63-2047 (0MB)
>00:33:32,305 DEBUG storage.ui: current free range is 1026048-1677721599 (818699MB)
>00:33:32,306 DEBUG storage.ui: evaluating growth potential for new layout
>00:33:32,306 DEBUG storage.ui: calculating growth for disk /dev/sdb
>00:33:32,306 DEBUG storage.ui: adding request 17 to chunk 1677721537 (63-1677721599) on /dev/sdb
>00:33:32,307 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:32,307 DEBUG storage.ui: req: PartitionRequest instance --
>id = 17  name = sdb1  growable = True
>base = 2048  growth = 0  max_grow = 1782575104
>done = False
>00:33:32,307 DEBUG storage.ui: 1 requests and 1677719489 (819198MB) left in chunk
>00:33:32,307 DEBUG storage.ui: adding 1677719489 (819198MB) to 17 (sdb1)
>00:33:32,308 DEBUG storage.ui: new grow amount for request 17 (sdb1) is 1677719489 units, or 819198MB
>00:33:32,308 DEBUG storage.ui: request 17 (sdb1) growth: 1677719489 (819198MB) size: 819199MB
>00:33:32,308 DEBUG storage.ui: disk /dev/sdb growth: 1677719489 (819198MB)
>00:33:32,308 DEBUG storage.ui: calculating growth for disk /dev/sda
>00:33:32,310 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req4 ;
>00:33:32,310 DEBUG storage.ui: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c1a27fa10>  PedPartition: <_ped.Partition object at 0x7f7c06385050>
>00:33:32,312 DEBUG storage.ui:                   PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>00:33:32,313 DEBUG storage.ui:                    DiskDevice.addChild: kids: 1 ; name: sda ;
>00:33:32,314 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:32,314 DEBUG storage.ui: adding request 14 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:32,314 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:32,315 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:32,315 DEBUG storage.ui: req: PartitionRequest instance --
>id = 14  name = sda2  growable = True
>base = 2048  growth = 0  max_grow = 1782575104
>done = False
>00:33:32,315 DEBUG storage.ui: 1 requests and 1676695489 (818698MB) left in chunk
>00:33:32,315 DEBUG storage.ui: adding 1676695489 (818698MB) to 14 (sda2)
>00:33:32,316 DEBUG storage.ui: new grow amount for request 14 (sda2) is 1676695489 units, or 818698MB
>00:33:32,316 DEBUG storage.ui: request 12 (sda1) growth: 0 (0MB) size: 500MB
>00:33:32,316 DEBUG storage.ui: request 14 (sda2) growth: 1676695489 (818698MB) size: 818699MB
>00:33:32,317 DEBUG storage.ui: disk /dev/sda growth: 1676695489 (818698MB)
>00:33:32,318 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda2 ;
>00:33:32,318 DEBUG storage.ui: device sda2 new partedPartition None
>00:33:32,319 DEBUG storage.ui:                   PartitionDevice._setDisk: req4 ; new: None ; old: sda ;
>00:33:32,321 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 2 ; name: sda ;
>00:33:32,321 DEBUG storage.ui: total growth: 3354414978 sectors
>00:33:32,322 DEBUG storage.ui: updating use_disk to sda, type: 0
>00:33:32,322 DEBUG storage.ui: new free: 1026048-1677721599 / 818699MB
>00:33:32,322 DEBUG storage.ui: new free allows for 3354414978 sectors of growth
>00:33:32,323 DEBUG storage.ui: created partition sda2 of 1MB and added it to /dev/sda
>00:33:32,324 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req4 ;
>00:33:32,324 DEBUG storage.ui: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05d66d10>  PedPartition: <_ped.Partition object at 0x7f7c06537890>
>00:33:32,325 DEBUG storage.ui:                   PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>00:33:32,327 DEBUG storage.ui:                    DiskDevice.addChild: kids: 1 ; name: sda ;
>00:33:32,328 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda2 ;
>00:33:32,328 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c0669dd10>  PedPartition: <_ped.Partition object at 0x7f7c06385170>
>00:33:32,330 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,332 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,332 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,333 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,334 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,335 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,336 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,337 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,337 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,339 DEBUG storage.ui:                    DeviceTree.getDeviceByName: name: sda ;
>00:33:32,340 DEBUG storage.ui:                    DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:32,341 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>00:33:32,341 DEBUG storage.ui: allocating partition: req3 ; id: 13 ; disks: ['sda', 'sdb'] ;
>boot: False ; primary: False ; size: 4032MB ; grow: False ; max_size: 0
>00:33:32,341 DEBUG storage.ui: checking freespace on sda
>00:33:32,342 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=4032MB boot=False best=None grow=False
>00:33:32,342 DEBUG storage.ui: current free range is 63-2047 (0MB)
>00:33:32,343 DEBUG storage.ui: current free range is 1028096-1677721599 (818698MB)
>00:33:32,343 DEBUG storage.ui: evaluating growth potential for new layout
>00:33:32,343 DEBUG storage.ui: calculating growth for disk /dev/sdb
>00:33:32,343 DEBUG storage.ui: adding request 17 to chunk 1677721537 (63-1677721599) on /dev/sdb
>00:33:32,344 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:32,344 DEBUG storage.ui: req: PartitionRequest instance --
>id = 17  name = sdb1  growable = True
>base = 2048  growth = 0  max_grow = 1782575104
>done = False
>00:33:32,344 DEBUG storage.ui: 1 requests and 1677719489 (819198MB) left in chunk
>00:33:32,344 DEBUG storage.ui: adding 1677719489 (819198MB) to 17 (sdb1)
>00:33:32,345 DEBUG storage.ui: new grow amount for request 17 (sdb1) is 1677719489 units, or 819198MB
>00:33:32,345 DEBUG storage.ui: request 17 (sdb1) growth: 1677719489 (819198MB) size: 819199MB
>00:33:32,345 DEBUG storage.ui: disk /dev/sdb growth: 1677719489 (819198MB)
>00:33:32,345 DEBUG storage.ui: calculating growth for disk /dev/sda
>00:33:32,346 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req3 ;
>00:33:32,347 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c06362a50>  PedPartition: <_ped.Partition object at 0x7f7c06385230>
>00:33:32,348 DEBUG storage.ui:                   PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>00:33:32,350 DEBUG storage.ui:                    DiskDevice.addChild: kids: 2 ; name: sda ;
>00:33:32,350 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:32,350 DEBUG storage.ui: adding request 14 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:32,351 DEBUG storage.ui: adding request 13 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:32,351 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:32,351 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:32,352 DEBUG storage.ui: req: PartitionRequest instance --
>id = 14  name = sda2  growable = True
>base = 2048  growth = 0  max_grow = 1782575104
>done = False
>00:33:32,352 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda3  growable = False
>base = 8257536  growth = 0  max_grow = 0
>done = True
>00:33:32,352 DEBUG storage.ui: 1 requests and 1668437953 (814666MB) left in chunk
>00:33:32,352 DEBUG storage.ui: adding 1668437953 (814666MB) to 14 (sda2)
>00:33:32,353 DEBUG storage.ui: new grow amount for request 14 (sda2) is 1668437953 units, or 814666MB
>00:33:32,353 DEBUG storage.ui: request 12 (sda1) growth: 0 (0MB) size: 500MB
>00:33:32,353 DEBUG storage.ui: request 14 (sda2) growth: 1668437953 (814666MB) size: 814667MB
>00:33:32,353 DEBUG storage.ui: request 13 (sda3) growth: 0 (0MB) size: 4032MB
>00:33:32,353 DEBUG storage.ui: disk /dev/sda growth: 1668437953 (814666MB)
>00:33:32,355 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda3 ;
>00:33:32,355 DEBUG storage.ui: device sda3 new partedPartition None
>00:33:32,356 DEBUG storage.ui:                   PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>00:33:32,357 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 3 ; name: sda ;
>00:33:32,358 DEBUG storage.ui: total growth: 3346157442 sectors
>00:33:32,358 DEBUG storage.ui: updating use_disk to sda, type: 0
>00:33:32,358 DEBUG storage.ui: new free: 1028096-1677721599 / 818698MB
>00:33:32,358 DEBUG storage.ui: new free allows for 3346157442 sectors of growth
>00:33:32,359 DEBUG storage.ui: checking freespace on sdb
>00:33:32,359 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=4032MB boot=False best=parted.Geometry instance --
>  start: 1028096  end: 1677721599  length: 1676693504
>  device: <parted.device.Device object at 0x7f7c063ea490>  PedGeometry: <_ped.Geometry object at 0x7f7c05d66e90> grow=False
>00:33:32,360 DEBUG storage.ui: current free range is 63-2047 (0MB)
>00:33:32,360 DEBUG storage.ui: current free range is 4096-1677721599 (819198MB)
>00:33:32,360 DEBUG storage.ui: not enough free space for primary -- trying logical
>00:33:32,361 DEBUG storage.ui: created partition sda3 of 4032MB and added it to /dev/sda
>00:33:32,362 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req3 ;
>00:33:32,363 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c063624d0>  PedPartition: <_ped.Partition object at 0x7f7c063853b0>
>00:33:32,364 DEBUG storage.ui:                   PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>00:33:32,365 DEBUG storage.ui:                    DiskDevice.addChild: kids: 2 ; name: sda ;
>00:33:32,367 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda3 ;
>00:33:32,367 DEBUG storage.ui: device sda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c06362750>  PedPartition: <_ped.Partition object at 0x7f7c066b3830>
>00:33:32,368 DEBUG storage.ui: growPartitions: disks=['sda', 'sdb'], partitions=['sdb1(id 17)', 'sda1(id 12)', 'sda2(id 14)', 'sda3(id 13)']
>00:33:32,368 DEBUG storage.ui: growable partitions are ['sdb1', 'sda2']
>00:33:32,368 DEBUG storage.ui: adding request 12 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:32,369 DEBUG storage.ui: adding request 14 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:32,369 DEBUG storage.ui: adding request 13 to chunk 1677721537 (63-1677721599) on /dev/sda
>00:33:32,369 DEBUG storage.ui: disk sda has 1 chunks
>00:33:32,369 DEBUG storage.ui: adding request 17 to chunk 1677721537 (63-1677721599) on /dev/sdb
>00:33:32,370 DEBUG storage.ui: disk sdb has 1 chunks
>00:33:32,370 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sda start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:32,370 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>00:33:32,370 DEBUG storage.ui: req: PartitionRequest instance --
>id = 14  name = sda2  growable = True
>base = 2048  growth = 0  max_grow = 1782575104
>done = False
>00:33:32,371 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda3  growable = False
>base = 8257536  growth = 0  max_grow = 0
>done = True
>00:33:32,371 DEBUG storage.ui: 1 requests and 1668437953 (814666MB) left in chunk
>00:33:32,371 DEBUG storage.ui: adding 1668437953 (814666MB) to 14 (sda2)
>00:33:32,371 DEBUG storage.ui: new grow amount for request 14 (sda2) is 1668437953 units, or 814666MB
>00:33:32,372 DEBUG storage.ui: Chunk.growRequests: 1677721537 on /dev/sdb start = 63  end = 1677721599
>sectorSize = 512
>
>00:33:32,372 DEBUG storage.ui: req: PartitionRequest instance --
>id = 17  name = sdb1  growable = True
>base = 2048  growth = 0  max_grow = 1782575104
>done = False
>00:33:32,372 DEBUG storage.ui: 1 requests and 1677719489 (819198MB) left in chunk
>00:33:32,372 DEBUG storage.ui: adding 1677719489 (819198MB) to 17 (sdb1)
>00:33:32,373 DEBUG storage.ui: new grow amount for request 17 (sdb1) is 1677719489 units, or 819198MB
>00:33:32,373 DEBUG storage.ui: set: ['sda2', 'sdb1'] 2/870399
>00:33:32,373 DEBUG storage.ui: allocating 814666 to TotalSizeSet with 2/870399 (870397 needed)
>00:33:32,374 DEBUG storage.ui: allocating 819198 to TotalSizeSet with 814668/870399 (55730 needed)
>00:33:32,374 DEBUG storage.ui: PartitionRequest instance --
>id = 17  name = sdb1  growable = True
>base = 2048  growth = 1677719489  max_grow = 1782575104
>done = False
>00:33:32,374 DEBUG storage.ui: needed: -763468
>00:33:32,374 DEBUG storage.ui: reclaim: PartitionRequest instance --
>id = 17  name = sdb1  growable = True
>base = 2048  growth = 1677719489  max_grow = 1782575104
>done = False 1563584386 (763468 MB)
>00:33:32,374 DEBUG storage.ui: deallocating 763468 from TotalSizeSet with 1633867/870399 (-763468 needed)
>00:33:32,375 DEBUG storage.ui: PartitionRequest instance --
>id = 14  name = sda2  growable = True
>base = 2048  growth = 1668437953  max_grow = 1782575104
>done = False
>00:33:32,375 DEBUG storage.ui: needed: 0
>00:33:32,375 DEBUG storage.ui: set: ['sda2', 'sdb1'] 870399/870399
>00:33:32,375 DEBUG storage.ui: PartitionRequest instance --
>id = 14  name = sda2  growable = True
>base = 2048  growth = 1668437953  max_grow = 1782575104
>done = True
>00:33:32,376 DEBUG storage.ui: needed: 0
>00:33:32,376 DEBUG storage.ui: PartitionRequest instance --
>id = 17  name = sdb1  growable = True
>base = 2048  growth = 114135103  max_grow = 1782575104
>done = True
>00:33:32,376 DEBUG storage.ui: needed: 0
>00:33:32,376 DEBUG storage.ui: growing partitions on sda
>00:33:32,377 DEBUG storage.ui: partition sda1 (12): 0
>00:33:32,377 DEBUG storage.ui: new geometry for sda1: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c064f0190>
>00:33:32,377 DEBUG storage.ui: partition sda2 (14): 0
>00:33:32,378 DEBUG storage.ui: new geometry for sda2: parted.Geometry instance --
>  start: 1026048  end: 1669464063  length: 1668438016
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c064f0310>
>00:33:32,378 DEBUG storage.ui: partition sda3 (13): 0
>00:33:32,378 DEBUG storage.ui: new geometry for sda3: parted.Geometry instance --
>  start: 1669464064  end: 1677721599  length: 8257536
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c06744e50>
>00:33:32,379 DEBUG storage.ui: removing all non-preexisting partitions ['sda1(id 12)', 'sda2(id 14)', 'sda3(id 13)'] from disk(s) ['sda']
>00:33:32,380 DEBUG storage.ui:                    PartitionDevice._setPartedPartition: sda1 ;
>00:33:32,380 DEBUG storage.ui: device sda1 new partedPartition None
>00:33:32,382 DEBUG storage.ui:                    PartitionDevice._setDisk: req2 ; new: None ; old: sda ;
>00:33:32,383 DEBUG storage.ui:                     DiskDevice.removeChild: kids: 3 ; name: sda ;
>00:33:32,384 DEBUG storage.ui:                    PartitionDevice._setPartedPartition: sda2 ;
>00:33:32,384 DEBUG storage.ui: device sda2 new partedPartition None
>00:33:32,386 DEBUG storage.ui:                    PartitionDevice._setDisk: req4 ; new: None ; old: sda ;
>00:33:32,387 DEBUG storage.ui:                     DiskDevice.removeChild: kids: 2 ; name: sda ;
>00:33:32,388 DEBUG storage.ui:                    PartitionDevice._setPartedPartition: sda3 ;
>00:33:32,389 DEBUG storage.ui: device sda3 new partedPartition None
>00:33:32,390 DEBUG storage.ui:                    PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>00:33:32,391 DEBUG storage.ui:                     DiskDevice.removeChild: kids: 1 ; name: sda ;
>00:33:32,392 DEBUG storage.ui: back from removeNewPartitions
>00:33:32,392 DEBUG storage.ui: extended: None
>00:33:32,392 DEBUG storage.ui: setting req2 new geometry: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c064f0190>
>00:33:32,394 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req2 ;
>00:33:32,394 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ce67d0>  PedPartition: <_ped.Partition object at 0x7f7c06385530>
>00:33:32,395 DEBUG storage.ui:                   PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>00:33:32,397 DEBUG storage.ui:                    DiskDevice.addChild: kids: 0 ; name: sda ;
>00:33:32,398 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda1 ;
>00:33:32,398 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05d66110>  PedPartition: <_ped.Partition object at 0x7f7c06385170>
>00:33:32,399 DEBUG storage.ui: setting req4 new geometry: parted.Geometry instance --
>  start: 1026048  end: 1669464063  length: 1668438016
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c064f0310>
>00:33:32,400 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req4 ;
>00:33:32,401 DEBUG storage.ui: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c1a27f5d0>  PedPartition: <_ped.Partition object at 0x7f7c066b35f0>
>00:33:32,402 DEBUG storage.ui:                   PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>00:33:32,403 DEBUG storage.ui:                    DiskDevice.addChild: kids: 1 ; name: sda ;
>00:33:32,405 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda2 ;
>00:33:32,405 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05d66a50>  PedPartition: <_ped.Partition object at 0x7f7c06385e90>
>00:33:32,406 DEBUG storage.ui: setting req3 new geometry: parted.Geometry instance --
>  start: 1669464064  end: 1677721599  length: 8257536
>  device: <parted.device.Device object at 0x4bf2490>  PedGeometry: <_ped.Geometry object at 0x7f7c06744e50>
>00:33:32,407 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req3 ;
>00:33:32,407 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05d66150>  PedPartition: <_ped.Partition object at 0x7f7c066b30b0>
>00:33:32,408 DEBUG storage.ui:                   PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>00:33:32,410 DEBUG storage.ui:                    DiskDevice.addChild: kids: 2 ; name: sda ;
>00:33:32,412 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda3 ;
>00:33:32,412 DEBUG storage.ui: device sda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a09add0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ed7bd0>  PedPartition: <_ped.Partition object at 0x7f7c066b3470>
>00:33:32,412 DEBUG storage.ui: growing partitions on sdb
>00:33:32,413 DEBUG storage.ui: partition sdb1 (17): 0
>00:33:32,413 DEBUG storage.ui: new geometry for sdb1: parted.Geometry instance --
>  start: 2048  end: 114139135  length: 114137088
>  device: <parted.device.Device object at 0x4225c50>  PedGeometry: <_ped.Geometry object at 0x7f7c06362450>
>00:33:32,413 DEBUG storage.ui: removing all non-preexisting partitions ['sdb1(id 17)'] from disk(s) ['sdb']
>00:33:32,414 DEBUG storage.ui:                    PartitionDevice._setPartedPartition: sdb1 ;
>00:33:32,415 DEBUG storage.ui: device sdb1 new partedPartition None
>00:33:32,416 DEBUG storage.ui:                    PartitionDevice._setDisk: req5 ; new: None ; old: sdb ;
>00:33:32,418 DEBUG storage.ui:                     DiskDevice.removeChild: kids: 1 ; name: sdb ;
>00:33:32,418 DEBUG storage.ui: back from removeNewPartitions
>00:33:32,418 DEBUG storage.ui: extended: None
>00:33:32,418 DEBUG storage.ui: setting req5 new geometry: parted.Geometry instance --
>  start: 2048  end: 114139135  length: 114137088
>  device: <parted.device.Device object at 0x4225c50>  PedGeometry: <_ped.Geometry object at 0x7f7c06362450>
>00:33:32,420 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: req5 ;
>00:33:32,420 DEBUG storage.ui: device req5 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c06744750>  PedPartition: <_ped.Partition object at 0x7f7c06537890>
>00:33:32,421 DEBUG storage.ui:                   PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>00:33:32,423 DEBUG storage.ui:                    DiskDevice.addChild: kids: 0 ; name: sdb ;
>00:33:32,425 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sdb1 ;
>00:33:32,425 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x4225210>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05ed7d50>  PedPartition: <_ped.Partition object at 0x7f7c063850b0>
>00:33:32,425 DEBUG storage.ui: fixing size of non-existent 500MB partition sda1 (12) with non-existent ext4 filesystem mounted at /boot at 500.00
>00:33:32,426 DEBUG storage.ui: fixing size of non-existent 814667MB partition sda2 (14) with non-existent btrfs filesystem at 814667.00
>00:33:32,426 DEBUG storage.ui: fixing size of non-existent 4032MB partition sda3 (13) with non-existent swap at 4032.00
>00:33:32,427 DEBUG storage.ui: fixing size of non-existent 55731MB partition sdb1 (17) with non-existent btrfs filesystem at 55731.00
>00:33:32,428 DEBUG storage.ui: BTRFSVolumeDevice instance (0x7f7c0672b110) --
>  name = fedora_f18v  status = False  kids = 1 id = 15
>  parents = ['non-existent 814667MB partition sda2 (14) with non-existent btrfs filesystem',
> 'non-existent 55731MB partition sdb1 (17) with non-existent btrfs filesystem']
>  uuid = None  size = 870398.0
>  format = non-existent btrfs filesystem
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/sda2
>  format args = []  originalFormat = btrfs
>00:33:32,428 DEBUG storage.ui: creating new device
>00:33:32,429 DEBUG storage.ui: newBTRFS: args = () ; kwargs = {'metaDataLevel': 'single', 'subvol': True, 'fmt_type': 'btrfs', 'fmt_args': {}, 'dataLevel': 'single', 'parents': [BTRFSVolumeDevice instance (0x7f7c0672b110) --
>  name = fedora_f18v  status = False  kids = 1 id = 15
>  parents = ['non-existent 814667MB partition sda2 (14) with non-existent btrfs filesystem',
> 'non-existent 55731MB partition sdb1 (17) with non-existent btrfs filesystem']
>  uuid = None  size = 870398.0
>  format = non-existent btrfs filesystem
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/sda2
>  format args = []  originalFormat = btrfs], 'mountpoint': '/home', 'size': 819199.0}
>00:33:32,430 DEBUG storage.ui:                      BTRFSVolumeDevice.addChild: kids: 1 ; name: fedora_f18v ;
>00:33:32,431 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:32,432 DEBUG storage.ui:                      BTRFSSubVolumeDevice._setFormat: home ; current: None ; type: None ;
>00:33:32,433 DEBUG storage.ui:                     BTRFS.supported: supported: True ;
>00:33:32,434 DEBUG storage.ui: getFormat('btrfs') returning BTRFS instance
>00:33:32,435 DEBUG storage.ui:                   BTRFSSubVolumeDevice._setFormat: home ; current: None ; type: btrfs ;
>00:33:32,435 INFO storage.ui: added btrfs subvolume home (id 18) to device tree
>00:33:32,436 INFO storage.ui: registered action: [22] Create Device btrfs subvolume home (id 18)
>00:33:32,436 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>00:33:32,436 INFO storage.ui: registered action: [23] Create Format btrfs filesystem mounted at /home on btrfs subvolume home (id 18)
>00:33:32,447 DEBUG storage: getFormat('None') returning DeviceFormat instance
>00:33:32,449 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.BTRFSFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 870398.0, ['sda', 'sdb'], single
>00:33:34,285 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.BTRFSFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 870398.0, ['sda', 'sdb'], single
>00:33:34,287 DEBUG storage: getFormat('None') returning DeviceFormat instance
>00:33:34,289 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.BTRFSFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 870398.0, ['sda', 'sdb'], single
>00:33:38,882 DEBUG storage.ui: instantiating <class 'pyanaconda.storage.BTRFSFactory'>: <pyanaconda.storage.Storage object at 0x7f7c1a1e03d0>, 870398.0, ['sda', 'sdb'], single
>00:33:38,894 DEBUG storage:           PartitionDevice._setPartedPartition: sda1 ;
>00:33:38,894 DEBUG storage: device sda1 new partedPartition None
>00:33:38,894 INFO storage: added partition req2 (id 12) to device tree
>00:33:38,895 INFO storage: registered action: [24] Create Device partition req2 (id 12)
>00:33:38,896 DEBUG storage:            PartitionDevice._setFormat: req2 ;
>00:33:38,896 DEBUG storage:             PartitionDevice._setFormat: req2 ; current: ext4 ; type: ext4 ;
>00:33:38,897 INFO storage: registered action: [25] Create Format ext4 filesystem mounted at /boot on partition req2 (id 12)
>00:33:38,898 DEBUG storage:           PartitionDevice._setPartedPartition: sda3 ;
>00:33:38,898 DEBUG storage: device sda3 new partedPartition None
>00:33:38,898 INFO storage: added partition req3 (id 13) to device tree
>00:33:38,898 INFO storage: registered action: [26] Create Device partition req3 (id 13)
>00:33:38,899 DEBUG storage:            PartitionDevice._setFormat: req3 ;
>00:33:38,900 DEBUG storage:             PartitionDevice._setFormat: req3 ; current: swap ; type: swap ;
>00:33:38,901 INFO storage: registered action: [27] Create Format swap on partition req3 (id 13)
>00:33:38,903 DEBUG storage:           PartitionDevice._setPartedPartition: sda2 ;
>00:33:38,903 DEBUG storage: device sda2 new partedPartition None
>00:33:38,903 INFO storage: added partition req4 (id 14) to device tree
>00:33:38,903 INFO storage: registered action: [28] Create Device partition req4 (id 14)
>00:33:38,904 DEBUG storage:            PartitionDevice._setFormat: req4 ;
>00:33:38,905 DEBUG storage:             PartitionDevice._setFormat: req4 ; current: btrfs ; type: btrfs ;
>00:33:38,905 INFO storage: registered action: [29] Create Format btrfs filesystem on partition req4 (id 14)
>00:33:38,906 DEBUG storage:           PartitionDevice._setPartedPartition: sdb1 ;
>00:33:38,906 DEBUG storage: device sdb1 new partedPartition None
>00:33:38,906 INFO storage: added partition req5 (id 17) to device tree
>00:33:38,907 INFO storage: registered action: [30] Create Device partition req5 (id 17)
>00:33:38,908 DEBUG storage:            PartitionDevice._setFormat: req5 ;
>00:33:38,908 DEBUG storage:             PartitionDevice._setFormat: req5 ; current: btrfs ; type: btrfs ;
>00:33:38,909 INFO storage: registered action: [31] Create Format btrfs filesystem on partition req5 (id 17)
>00:33:38,910 DEBUG storage:          DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>00:33:38,910 DEBUG storage:          DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>00:33:38,912 DEBUG storage: removing all non-preexisting partitions ['req2(id 12)', 'req3(id 13)', 'req4(id 14)', 'req5(id 17)'] from disk(s) ['sda', 'sdb']
>00:33:38,913 DEBUG storage: allocatePartitions: disks=['sda', 'sdb'] ; partitions=['req2(id 12)', 'req3(id 13)', 'req4(id 14)', 'req5(id 17)']
>00:33:38,913 DEBUG storage: removing all non-preexisting partitions ['req2(id 12)', 'req4(id 14)', 'req5(id 17)', 'req3(id 13)'] from disk(s) ['sda', 'sdb']
>00:33:38,914 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,916 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,916 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,917 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,919 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,919 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,920 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,922 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,922 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,923 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,925 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,925 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,926 DEBUG storage: allocating partition: req2 ; id: 12 ; disks: ['sda', 'sdb'] ;
>boot: True ; primary: False ; size: 500MB ; grow: False ; max_size: 0
>00:33:38,926 DEBUG storage: checking freespace on sda
>00:33:38,927 DEBUG storage: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=500MB boot=True best=None grow=False
>00:33:38,927 DEBUG storage: current free range is 63-1677721599 (819199MB)
>00:33:38,928 DEBUG storage: updating use_disk to sda, type: 0
>00:33:38,928 DEBUG storage: new free: 63-1677721599 / 819199MB
>00:33:38,929 DEBUG storage: new free allows for 0 sectors of growth
>00:33:38,929 DEBUG storage: found free space for bootable request
>00:33:38,930 DEBUG storage: adjusted start sector from 63 to 2048
>00:33:38,931 DEBUG storage: created partition sda1 of 500MB and added it to /dev/sda
>00:33:38,932 DEBUG storage:            PartitionDevice._setPartedPartition: req2 ;
>00:33:38,933 DEBUG storage: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a303850>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c063ea6d0>  PedPartition: <_ped.Partition object at 0x7f7c06385170>
>00:33:38,934 DEBUG storage:            PartitionDevice._setDisk: sda1 ; new: sda ; old: sda ;
>00:33:38,935 DEBUG storage:             DiskDevice.removeChild: kids: 0 ; name: sda ;
>00:33:38,936 DEBUG storage:             DiskDevice.addChild: kids: -1 ; name: sda ;
>00:33:38,938 DEBUG storage:            PartitionDevice._setPartedPartition: sda1 ;
>00:33:38,938 DEBUG storage: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a303850>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c064f04d0>  PedPartition: <_ped.Partition object at 0x7f7c06385e90>
>00:33:38,940 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,941 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,941 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,943 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,945 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,945 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,946 DEBUG storage: allocating partition: req4 ; id: 14 ; disks: ['sda'] ;
>boot: False ; primary: False ; size: 814667MB ; grow: False ; max_size: 870399.0
>00:33:38,946 DEBUG storage: checking freespace on sda
>00:33:38,947 DEBUG storage: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=814667MB boot=False best=None grow=False
>00:33:38,948 DEBUG storage: current free range is 63-2047 (0MB)
>00:33:38,948 DEBUG storage: current free range is 1026048-1677721599 (818699MB)
>00:33:38,949 DEBUG storage: updating use_disk to sda, type: 0
>00:33:38,949 DEBUG storage: new free: 1026048-1677721599 / 818699MB
>00:33:38,950 DEBUG storage: new free allows for 0 sectors of growth
>00:33:38,951 DEBUG storage: created partition sda2 of 814667MB and added it to /dev/sda
>00:33:38,952 DEBUG storage:            PartitionDevice._setPartedPartition: req4 ;
>00:33:38,953 DEBUG storage: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a303850>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c061c3dd0>  PedPartition: <_ped.Partition object at 0x7f7c063855f0>
>00:33:38,954 DEBUG storage:            PartitionDevice._setDisk: sda2 ; new: sda ; old: sda ;
>00:33:38,955 DEBUG storage:             DiskDevice.removeChild: kids: 0 ; name: sda ;
>00:33:38,956 DEBUG storage:             DiskDevice.addChild: kids: -1 ; name: sda ;
>00:33:38,957 DEBUG storage:            PartitionDevice._setPartedPartition: sda2 ;
>00:33:38,958 DEBUG storage: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a303850>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c061c3e90>  PedPartition: <_ped.Partition object at 0x7f7c066b30b0>
>00:33:38,959 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,961 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,961 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,962 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,964 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,964 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,965 DEBUG storage: allocating partition: req5 ; id: 17 ; disks: ['sdb'] ;
>boot: False ; primary: False ; size: 55731MB ; grow: False ; max_size: 870399.0
>00:33:38,965 DEBUG storage: checking freespace on sdb
>00:33:38,966 DEBUG storage: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=55731MB boot=False best=None grow=False
>00:33:38,966 DEBUG storage: current free range is 63-1677721599 (819199MB)
>00:33:38,967 DEBUG storage: updating use_disk to sdb, type: 0
>00:33:38,967 DEBUG storage: new free: 63-1677721599 / 819199MB
>00:33:38,968 DEBUG storage: new free allows for 0 sectors of growth
>00:33:38,969 DEBUG storage: adjusted start sector from 63 to 2048
>00:33:38,969 DEBUG storage: created partition sdb1 of 55731MB and added it to /dev/sdb
>00:33:38,970 DEBUG storage:            PartitionDevice._setPartedPartition: req5 ;
>00:33:38,971 DEBUG storage: device req5 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a1e0390>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c066c4c10>  PedPartition: <_ped.Partition object at 0x7f7c066b3590>
>00:33:38,972 DEBUG storage:            PartitionDevice._setDisk: sdb1 ; new: sdb ; old: sdb ;
>00:33:38,973 DEBUG storage:             DiskDevice.removeChild: kids: 0 ; name: sdb ;
>00:33:38,974 DEBUG storage:             DiskDevice.addChild: kids: -1 ; name: sdb ;
>00:33:38,976 DEBUG storage:            PartitionDevice._setPartedPartition: sdb1 ;
>00:33:38,976 DEBUG storage: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a1e0390>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c061c3bd0>  PedPartition: <_ped.Partition object at 0x7f7c066b35f0>
>00:33:38,977 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,979 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,979 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,980 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,981 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,982 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,983 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,984 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,984 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,986 DEBUG storage:             DeviceTree.getDeviceByName: name: sda ;
>00:33:38,987 DEBUG storage:             DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:38,987 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:38,988 DEBUG storage: allocating partition: req3 ; id: 13 ; disks: ['sda', 'sdb'] ;
>boot: False ; primary: False ; size: 4032MB ; grow: False ; max_size: 0
>00:33:38,988 DEBUG storage: checking freespace on sda
>00:33:38,989 DEBUG storage: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=4032MB boot=False best=None grow=False
>00:33:38,990 DEBUG storage: current free range is 63-2047 (0MB)
>00:33:38,990 DEBUG storage: current free range is 1669464064-1677721599 (4032MB)
>00:33:38,991 DEBUG storage: updating use_disk to sda, type: 0
>00:33:38,991 DEBUG storage: new free: 1669464064-1677721599 / 4032MB
>00:33:38,992 DEBUG storage: new free allows for 0 sectors of growth
>00:33:38,992 DEBUG storage: checking freespace on sdb
>00:33:38,993 DEBUG storage: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=4032MB boot=False best=parted.Geometry instance --
>  start: 1669464064  end: 1677721599  length: 8257536
>  device: <parted.device.Device object at 0x7f7c05ce67d0>  PedGeometry: <_ped.Geometry object at 0x7f7c1a27fa10> grow=False
>00:33:38,994 DEBUG storage: current free range is 63-2047 (0MB)
>00:33:38,994 DEBUG storage: current free range is 114139136-1677721599 (763468MB)
>00:33:38,995 DEBUG storage: not enough free space for primary -- trying logical
>00:33:38,996 DEBUG storage: created partition sda3 of 4032MB and added it to /dev/sda
>00:33:38,998 DEBUG storage:            PartitionDevice._setPartedPartition: req3 ;
>00:33:38,998 DEBUG storage: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a303850>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c064f0190>  PedPartition: <_ped.Partition object at 0x7f7c06385170>
>00:33:38,999 DEBUG storage:            PartitionDevice._setDisk: sda3 ; new: sda ; old: sda ;
>00:33:39,001 DEBUG storage:             DiskDevice.removeChild: kids: 0 ; name: sda ;
>00:33:39,002 DEBUG storage:             DiskDevice.addChild: kids: -1 ; name: sda ;
>00:33:39,003 DEBUG storage:            PartitionDevice._setPartedPartition: sda3 ;
>00:33:39,004 DEBUG storage: device sda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a303850>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c066c4550>  PedPartition: <_ped.Partition object at 0x7f7c066b3ef0>
>00:33:39,004 DEBUG storage: growPartitions: disks=['sda', 'sdb'], partitions=['sda1(id 12)', 'sda3(id 13)', 'sda2(id 14)', 'sdb1(id 17)']
>00:33:39,005 DEBUG storage: no growable partitions
>00:33:39,005 DEBUG storage: fixing size of non-existent 500MB partition sda1 (12) with non-existent ext4 filesystem mounted at /boot at 500.00
>00:33:39,006 DEBUG storage: fixing size of non-existent 814667MB partition sda2 (14) with non-existent btrfs filesystem at 814667.00
>00:33:39,007 DEBUG storage: fixing size of non-existent 4032MB partition sda3 (13) with non-existent swap at 4032.00
>00:33:39,007 DEBUG storage: fixing size of non-existent 55731MB partition sdb1 (17) with non-existent btrfs filesystem at 55731.00
>00:33:39,009 INFO storage: added btrfs volume fedora_f18v (id 15) to device tree
>00:33:39,010 INFO storage: registered action: [32] Create Device btrfs volume fedora_f18v (id 15)
>00:33:39,011 DEBUG storage:             BTRFSVolumeDevice._setFormat: fedora_f18v ; current: btrfs ; type: btrfs ;
>00:33:39,012 INFO storage: registered action: [33] Create Format btrfs filesystem on btrfs volume fedora_f18v (id 15)
>00:33:39,013 INFO storage: added btrfs subvolume root (id 16) to device tree
>00:33:39,013 INFO storage: registered action: [34] Create Device btrfs subvolume root (id 16)
>00:33:39,015 DEBUG storage:            BTRFSSubVolumeDevice._setFormat: root ; current: btrfs ; type: btrfs ;
>00:33:39,016 INFO storage: registered action: [35] Create Format btrfs filesystem mounted at / on btrfs subvolume root (id 16)
>00:33:39,017 INFO storage: added btrfs subvolume home (id 18) to device tree
>00:33:39,017 INFO storage: registered action: [36] Create Device btrfs subvolume home (id 18)
>00:33:39,019 DEBUG storage:            BTRFSSubVolumeDevice._setFormat: home ; current: btrfs ; type: btrfs ;
>00:33:39,019 INFO storage: registered action: [37] Create Format btrfs filesystem mounted at /home on btrfs subvolume home (id 18)
>00:33:39,021 DEBUG storage:           DeviceTree.getDeviceByName: name: sda ;
>00:33:39,022 DEBUG storage:           DeviceTree.getDeviceByName returned existing 819200MB disk sda (1) with non-existent msdos disklabel
>00:33:39,023 DEBUG storage: resolved 'sda' to 'sda' (disk)
>00:33:39,024 DEBUG storage: stage1 device cannot be of type btrfs volume
>00:33:39,025 DEBUG storage: stage1 device cannot be of type btrfs subvolume
>00:33:39,025 DEBUG storage: stage1 device cannot be of type btrfs subvolume
>00:33:39,026 DEBUG storage: _is_valid_disklabel(sda) returning True
>00:33:39,026 DEBUG storage: _is_valid_size(sda) returning True
>00:33:39,027 DEBUG storage: _is_valid_location(sda) returning True
>00:33:39,027 DEBUG storage: _is_valid_format(sda) returning True
>00:33:39,028 DEBUG storage: is_valid_stage1_device(sda) returning True
>00:33:39,033 DEBUG storage: _is_valid_disklabel(sda) returning True
>00:33:39,033 DEBUG storage: _is_valid_size(sda) returning True
>00:33:39,034 DEBUG storage: _is_valid_location(sda) returning True
>00:33:39,034 DEBUG storage: _is_valid_format(sda) returning True
>00:33:39,035 DEBUG storage: is_valid_stage1_device(sda) returning True
>00:33:39,036 DEBUG storage: _is_valid_disklabel(sda1) returning True
>00:33:39,036 DEBUG storage: _is_valid_size(sda1) returning True
>00:33:39,037 DEBUG storage: _is_valid_location(sda1) returning True
>00:33:39,037 DEBUG storage: _is_valid_partition(sda1) returning True
>00:33:39,038 DEBUG storage: _is_valid_format(sda1) returning True
>00:33:39,039 DEBUG storage: is_valid_stage2_device(sda1) returning True
>00:34:05,815 DEBUG storage:         OpticalDevice.teardown: sr0 ; status: True ; controllable: True ;
>00:34:05,854 DEBUG storage:         DiskDevice.teardown: sda ; status: True ; controllable: True ;
>00:34:05,860 DEBUG storage:           DeviceFormat.teardown: device: /dev/sda ; status: False ; type: None ;
>00:34:05,895 DEBUG storage:         DiskDevice.teardown: sdb ; status: True ; controllable: True ;
>00:34:05,896 DEBUG storage:           DeviceFormat.teardown: device: /dev/sdb ; status: False ; type: None ;
>00:34:05,915 DEBUG storage:         LoopDevice.teardown: loop0 ; status: False ; controllable: False ;
>00:34:05,924 DEBUG storage:         LoopDevice.teardown: loop1 ; status: False ; controllable: False ;
>00:34:05,926 DEBUG storage:         DMDevice.teardown: live-rw ; status: True ; controllable: False ;
>00:34:05,927 DEBUG storage:         PartitionDevice.teardown: sda1 ; status: False ; controllable: True ;
>00:34:05,928 DEBUG storage:         PartitionDevice.teardown: sda3 ; status: False ; controllable: True ;
>00:34:05,929 DEBUG storage:         BTRFSSubVolumeDevice.teardown: root ; status: False ; controllable: True ;
>00:34:05,930 DEBUG storage:         BTRFSSubVolumeDevice.teardown: home ; status: False ; controllable: True ;
>00:34:05,930 INFO storage: resetting parted disks...
>00:34:05,932 DEBUG storage:          DiskLabel.resetPartedDisk: device: /dev/sda ;
>00:34:05,933 DEBUG storage:          DiskLabel.resetPartedDisk: device: /dev/sdb ;
>00:34:05,934 DEBUG storage:          PartitionDevice.preCommitFixup: sda1 ;
>00:34:05,934 DEBUG storage:          PartitionDevice.preCommitFixup: sda3 ;
>00:34:05,935 DEBUG storage:          PartitionDevice.preCommitFixup: sda2 ;
>00:34:05,936 DEBUG storage:          PartitionDevice.preCommitFixup: sdb1 ;
>00:34:05,936 DEBUG storage: action: [0] Destroy Format None on disk sda (id 1)
>00:34:05,936 DEBUG storage: action: [1] Create Format msdos disklabel on disk sda (id 1)
>00:34:05,937 DEBUG storage: action: [2] Destroy Format None on disk sdb (id 2)
>00:34:05,937 DEBUG storage: action: [3] Create Format msdos disklabel on disk sdb (id 2)
>00:34:05,938 DEBUG storage: action: [24] Create Device partition sda1 (id 12)
>00:34:05,938 DEBUG storage: action: [25] Create Format ext4 filesystem mounted at /boot on partition sda1 (id 12)
>00:34:05,938 DEBUG storage: action: [26] Create Device partition sda3 (id 13)
>00:34:05,938 DEBUG storage: action: [27] Create Format swap on partition sda3 (id 13)
>00:34:05,938 DEBUG storage: action: [28] Create Device partition sda2 (id 14)
>00:34:05,938 DEBUG storage: action: [29] Create Format btrfs filesystem on partition sda2 (id 14)
>00:34:05,939 DEBUG storage: action: [30] Create Device partition sdb1 (id 17)
>00:34:05,939 DEBUG storage: action: [31] Create Format btrfs filesystem on partition sdb1 (id 17)
>00:34:05,939 DEBUG storage: action: [32] Create Device btrfs volume fedora_f18v (id 15)
>00:34:05,939 DEBUG storage: action: [33] Create Format btrfs filesystem on btrfs volume fedora_f18v (id 15)
>00:34:05,939 DEBUG storage: action: [34] Create Device btrfs subvolume root (id 16)
>00:34:05,940 DEBUG storage: action: [35] Create Format btrfs filesystem mounted at / on btrfs subvolume root (id 16)
>00:34:05,940 DEBUG storage: action: [36] Create Device btrfs subvolume home (id 18)
>00:34:05,940 DEBUG storage: action: [37] Create Format btrfs filesystem mounted at /home on btrfs subvolume home (id 18)
>00:34:05,940 INFO storage: pruning action queue...
>00:34:05,941 INFO storage: sorting actions...
>00:34:05,944 DEBUG storage: action: [2] Destroy Format None on disk sdb (id 2)
>00:34:05,945 DEBUG storage: action: [0] Destroy Format None on disk sda (id 1)
>00:34:05,945 DEBUG storage: action: [3] Create Format msdos disklabel on disk sdb (id 2)
>00:34:05,946 DEBUG storage: action: [30] Create Device partition sdb1 (id 17)
>00:34:05,946 DEBUG storage: action: [31] Create Format btrfs filesystem on partition sdb1 (id 17)
>00:34:05,947 DEBUG storage: action: [1] Create Format msdos disklabel on disk sda (id 1)
>00:34:05,947 DEBUG storage: action: [24] Create Device partition sda1 (id 12)
>00:34:05,948 DEBUG storage: action: [28] Create Device partition sda2 (id 14)
>00:34:05,948 DEBUG storage: action: [29] Create Format btrfs filesystem on partition sda2 (id 14)
>00:34:05,949 DEBUG storage: action: [32] Create Device btrfs volume fedora_f18v (id 15)
>00:34:05,949 DEBUG storage: action: [33] Create Format btrfs filesystem on btrfs volume fedora_f18v (id 15)
>00:34:05,949 DEBUG storage: action: [36] Create Device btrfs subvolume home (id 18)
>00:34:05,950 DEBUG storage: action: [37] Create Format btrfs filesystem mounted at /home on btrfs subvolume home (id 18)
>00:34:05,950 DEBUG storage: action: [34] Create Device btrfs subvolume root (id 16)
>00:34:05,951 DEBUG storage: action: [35] Create Format btrfs filesystem mounted at / on btrfs subvolume root (id 16)
>00:34:05,951 DEBUG storage: action: [26] Create Device partition sda3 (id 13)
>00:34:05,952 DEBUG storage: action: [27] Create Format swap on partition sda3 (id 13)
>00:34:05,952 DEBUG storage: action: [25] Create Format ext4 filesystem mounted at /boot on partition sda1 (id 12)
>00:34:05,952 INFO storage: executing action: [2] Destroy Format None on disk sdb (id 2)
>00:34:05,953 DEBUG storage:           DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: True ;
>00:34:05,955 DEBUG storage:           DeviceFormat.destroy: device: /dev/sdb ; status: False ; type: None ;
>00:34:06,308 DEBUG storage:           DiskDevice.teardown: sdb ; status: True ; controllable: True ;
>00:34:06,315 DEBUG storage:             DeviceFormat.teardown: device: /dev/sdb ; status: False ; type: None ;
>00:34:06,353 INFO storage: executing action: [0] Destroy Format None on disk sda (id 1)
>00:34:06,355 DEBUG storage:           DiskDevice.setup: sda ; status: True ; controllable: True ; orig: True ;
>00:34:06,357 DEBUG storage:           DeviceFormat.destroy: device: /dev/sda ; status: False ; type: None ;
>00:34:06,404 DEBUG storage:           DiskDevice.teardown: sda ; status: True ; controllable: True ;
>00:34:06,406 DEBUG storage:             DeviceFormat.teardown: device: /dev/sda ; status: False ; type: None ;
>00:34:06,442 INFO storage: executing action: [3] Create Format msdos disklabel on disk sdb (id 2)
>00:34:06,444 DEBUG storage:           DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>00:34:06,446 DEBUG storage:           DiskLabel.create: device: /dev/sdb ; status: False ; type: disklabel ;
>00:34:06,447 DEBUG storage:            DiskLabel.create: device: /dev/sdb ; status: False ; type: disklabel ;
>00:34:06,448 DEBUG storage:            DiskLabel.commit: device: /dev/sdb ; numparts: 0 ;
>00:34:06,553 DEBUG storage:           DiskDevice.updateSysfsPath: sdb ; status: True ;
>00:34:06,554 DEBUG storage: sdb sysfsPath set to /devices/pci0000:00/0000:00:0d.0/ata2/host1/target1:0:0/1:0:0:0/block/sdb
>00:34:06,576 INFO storage: executing action: [30] Create Device partition sdb1 (id 17)
>00:34:06,580 DEBUG storage:           PartitionDevice.create: sdb1 ; status: False ;
>00:34:06,581 DEBUG storage:             PartitionDevice.setupParents: kids: 1 ; name: sdb1 ; orig: False ;
>00:34:06,583 DEBUG storage:              DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>00:34:06,584 DEBUG storage:              DiskLabel.setup: device: /dev/sdb ; status: False ; type: disklabel ;
>00:34:06,585 DEBUG storage:               DiskLabel.setup: device: /dev/sdb ; status: False ; type: disklabel ;
>00:34:06,586 DEBUG storage:            PartitionDevice._create: sdb1 ; status: False ;
>00:34:06,588 DEBUG storage:             DiskLabel.commit: device: /dev/sdb ; numparts: 1 ;
>00:34:06,634 DEBUG storage: post-commit partition path is /dev/sdb1
>00:34:06,637 DEBUG storage:              PartitionDevice._setPartedPartition: sdb1 ;
>00:34:06,638 DEBUG storage: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a527890>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c063ea790>  PedPartition: <_ped.Partition object at 0x7f7c061c13b0>
>00:34:06,640 DEBUG storage:             DeviceFormat.destroy: device: /dev/sdb1 ; status: False ; type: None ;
>00:34:06,662 DEBUG storage:              PartitionDevice.setup: sdb1 ; status: True ; controllable: True ; orig: False ;
>00:34:06,663 DEBUG storage:              PartitionDevice.updateSysfsPath: sdb1 ; status: True ;
>00:34:06,665 DEBUG storage:               PartitionDevice.updateSysfsPath: sdb1 ; status: True ;
>00:34:06,666 DEBUG storage: sdb1 sysfsPath set to /devices/pci0000:00/0000:00:0d.0/ata2/host1/target1:0:0/1:0:0:0/block/sdb/sdb1
>00:34:06,705 INFO storage: executing action: [31] Create Format btrfs filesystem on partition sdb1 (id 17)
>00:34:06,714 DEBUG storage:           PartitionDevice.setup: sdb1 ; status: True ; controllable: True ; orig: False ;
>00:34:06,715 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 1 ;
>00:34:06,716 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 2 ;
>00:34:06,717 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 3 ;
>00:34:06,717 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 4 ;
>00:34:06,719 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 5 ;
>00:34:06,722 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 6 ;
>00:34:06,723 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 8 ;
>00:34:06,724 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 9 ;
>00:34:06,725 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 10 ;
>00:34:06,726 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 11 ;
>00:34:06,730 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 12 ;
>00:34:06,731 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 13 ;
>00:34:06,732 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 14 ;
>00:34:06,733 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sdb1 ; flag: 15 ;
>00:34:06,735 DEBUG storage:           DiskLabel.commitToDisk: device: /dev/sdb ; numparts: 1 ;
>00:34:06,771 DEBUG storage:           PartitionDevice.updateSysfsPath: sdb1 ; status: True ;
>00:34:06,772 DEBUG storage:            PartitionDevice.updateSysfsPath: sdb1 ; status: True ;
>00:34:06,772 DEBUG storage: sdb1 sysfsPath set to /devices/pci0000:00/0000:00:0d.0/ata2/host1/target1:0:0/1:0:0:0/block/sdb/sdb1
>00:34:06,795 INFO storage: executing action: [1] Create Format msdos disklabel on disk sda (id 1)
>00:34:06,796 DEBUG storage:           DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>00:34:06,798 DEBUG storage:           DiskLabel.create: device: /dev/sda ; status: False ; type: disklabel ;
>00:34:06,799 DEBUG storage:            DiskLabel.create: device: /dev/sda ; status: False ; type: disklabel ;
>00:34:06,800 DEBUG storage:            DiskLabel.commit: device: /dev/sda ; numparts: 0 ;
>00:34:06,867 DEBUG storage:           DiskDevice.updateSysfsPath: sda ; status: True ;
>00:34:06,868 DEBUG storage: sda sysfsPath set to /devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sda
>00:34:06,886 INFO storage: executing action: [24] Create Device partition sda1 (id 12)
>00:34:06,887 DEBUG storage:           PartitionDevice.create: sda1 ; status: False ;
>00:34:06,889 DEBUG storage:             PartitionDevice.setupParents: kids: 0 ; name: sda1 ; orig: False ;
>00:34:06,890 DEBUG storage:              DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>00:34:06,891 DEBUG storage:              DiskLabel.setup: device: /dev/sda ; status: False ; type: disklabel ;
>00:34:06,892 DEBUG storage:               DiskLabel.setup: device: /dev/sda ; status: False ; type: disklabel ;
>00:34:06,893 DEBUG storage:            PartitionDevice._create: sda1 ; status: False ;
>00:34:06,895 DEBUG storage:             DiskLabel.commit: device: /dev/sda ; numparts: 1 ;
>00:34:06,948 DEBUG storage: post-commit partition path is /dev/sda1
>00:34:06,950 DEBUG storage:              PartitionDevice._setPartedPartition: sda1 ;
>00:34:06,951 DEBUG storage: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a236710>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c0669da50>  PedPartition: <_ped.Partition object at 0x7f7c1a2fc7d0>
>00:34:06,952 DEBUG storage:             DeviceFormat.destroy: device: /dev/sda1 ; status: False ; type: None ;
>00:34:06,976 DEBUG storage:              PartitionDevice.setup: sda1 ; status: True ; controllable: True ; orig: False ;
>00:34:06,979 DEBUG storage:              PartitionDevice.updateSysfsPath: sda1 ; status: True ;
>00:34:06,982 DEBUG storage:               PartitionDevice.updateSysfsPath: sda1 ; status: True ;
>00:34:06,984 DEBUG storage: sda1 sysfsPath set to /devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sda/sda1
>00:34:07,021 INFO storage: executing action: [28] Create Device partition sda2 (id 14)
>00:34:07,022 DEBUG storage:           PartitionDevice.create: sda2 ; status: False ;
>00:34:07,023 DEBUG storage:             PartitionDevice.setupParents: kids: 1 ; name: sda2 ; orig: False ;
>00:34:07,026 DEBUG storage:              DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>00:34:07,027 DEBUG storage:              DiskLabel.setup: device: /dev/sda ; status: False ; type: disklabel ;
>00:34:07,028 DEBUG storage:               DiskLabel.setup: device: /dev/sda ; status: False ; type: disklabel ;
>00:34:07,030 DEBUG storage:            PartitionDevice._create: sda2 ; status: False ;
>00:34:07,031 DEBUG storage:             DiskLabel.commit: device: /dev/sda ; numparts: 2 ;
>00:34:07,109 DEBUG storage: post-commit partition path is /dev/sda2
>00:34:07,111 DEBUG storage:              PartitionDevice._setPartedPartition: sda2 ;
>00:34:07,112 DEBUG storage: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f7c1a236710>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f7c05f80610>  PedPartition: <_ped.Partition object at 0x7f7c1a2fc290>
>00:34:07,115 DEBUG storage:             DeviceFormat.destroy: device: /dev/sda2 ; status: False ; type: None ;
>00:34:07,139 DEBUG storage:              PartitionDevice.setup: sda2 ; status: True ; controllable: True ; orig: False ;
>00:34:07,143 DEBUG storage:              PartitionDevice.updateSysfsPath: sda2 ; status: True ;
>00:34:07,147 DEBUG storage:               PartitionDevice.updateSysfsPath: sda2 ; status: True ;
>00:34:07,148 DEBUG storage: sda2 sysfsPath set to /devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sda/sda2
>00:34:07,182 INFO storage: executing action: [29] Create Format btrfs filesystem on partition sda2 (id 14)
>00:34:07,184 DEBUG storage:           PartitionDevice.setup: sda2 ; status: True ; controllable: True ; orig: False ;
>00:34:07,185 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 1 ;
>00:34:07,186 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 2 ;
>00:34:07,188 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 3 ;
>00:34:07,189 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 4 ;
>00:34:07,190 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 5 ;
>00:34:07,191 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 6 ;
>00:34:07,193 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 8 ;
>00:34:07,194 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 9 ;
>00:34:07,195 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 10 ;
>00:34:07,196 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 11 ;
>00:34:07,198 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 12 ;
>00:34:07,201 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 13 ;
>00:34:07,202 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 14 ;
>00:34:07,203 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/sda2 ; flag: 15 ;
>00:34:07,205 DEBUG storage:           DiskLabel.commitToDisk: device: /dev/sda ; numparts: 2 ;
>00:34:07,240 DEBUG storage:           PartitionDevice.updateSysfsPath: sda2 ; status: True ;
>00:34:07,241 DEBUG storage:            PartitionDevice.updateSysfsPath: sda2 ; status: True ;
>00:34:07,242 DEBUG storage: sda2 sysfsPath set to /devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sda/sda2
>00:34:07,260 INFO storage: executing action: [32] Create Device btrfs volume fedora_f18v (id 15)
>00:34:07,262 DEBUG storage:           BTRFSVolumeDevice.create: fedora_f18v ; status: True ;
>00:34:07,263 DEBUG storage:             BTRFSVolumeDevice.setupParents: kids: 2 ; name: fedora_f18v ; orig: False ;
>00:34:07,264 DEBUG storage:              PartitionDevice.setup: sda2 ; status: True ; controllable: True ; orig: False ;
>00:34:07,266 DEBUG storage:              PartitionDevice.setup: sdb1 ; status: True ; controllable: True ; orig: False ;
>00:34:07,267 DEBUG storage:            BTRFSVolumeDevice._create: fedora_f18v ; status: True ;

Actions: View

Attachments on bug 864765: 624551 | 624552 | 624553 | 624554 | 624555 | 624556 | 624557 | 624558 | 624559 | 624560 | 624561 | 624562 | 624563 | 624564 | 625334