Attachment 857165 Details for Bug 1059346 – File: storage.log

File: storage.log

storage.log (text/plain), 224.61 KB, created by M. Scherer on 2014-01-29 16:59:19 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: M. Scherer

Created: 2014-01-29 16:59:19 UTC

Size: 224.61 KB

patch

obsolete

>17:49:46,133 INFO blivet: ISCSID is /sbin/iscsid
>17:49:46,133 INFO blivet: no initiator set
>17:49:46,222 INFO blivet: No FCoE EDD info found: No FCoE boot disk information is found in EDD!
>17:49:46,222 INFO blivet: no /etc/zfcp.conf; not configuring zfcp
>17:49:47,530 DEBUG blivet: trying to set new default fstype to 'ext4'
>17:49:47,552 DEBUG blivet:           Ext4FS.supported: supported: True ;
>17:49:47,553 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>17:49:47,553 DEBUG blivet:        Ext4FS.supported: supported: True ;
>17:49:47,557 DEBUG blivet: trying to set new default fstype to 'xfs'
>17:49:47,558 DEBUG blivet:         XFS.supported: supported: True ;
>17:49:47,608 DEBUG blivet: getFormat('xfs') returning XFS instance
>17:49:47,608 DEBUG blivet:       XFS.supported: supported: True ;
>17:49:47,967 INFO blivet: Detected 7952M of memory
>17:49:47,968 INFO blivet: Suggested swap size (7952 M) exceeds 10 % of disk space, using 10 % of disk space (0 M) instead.
>17:49:47,968 INFO blivet: Swap attempt of 0M
>17:49:48,072 INFO blivet: resetting Blivet (version 0.18.19) instance <blivet.Blivet object at 0x7fab908746d0>
>17:49:48,072 INFO blivet: no initiator set
>17:49:48,073 INFO blivet: not going to create backup copy of non-existent /etc/mdadm.conf
>17:49:48,073 INFO blivet: DeviceTree.populate: ignoredDisks is [] ; exclusiveDisks is []
>17:49:48,280 DEBUG blivet: protected device spec LABEL=RHEL-7.0_x86_64 resolved to sdc
>17:49:48,295 INFO blivet: devices to scan: ['sdc', 'sdc1', 'sdc2', 'sda', 'sdb', 'loop0', 'loop1', 'loop2', 'dm-0', 'dm-1']
>17:49:48,299 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-id/usb-General_USB_Flash_Disk_040405000000022F-0:0 /dev/disk/by-label/RHEL-7.0\\x20x86_64 /dev/disk/by-path/pci-0000:03:00.0-usb-0:1:1.0-scsi-0:0:0:0 /dev/disk/by-uuid/2014-01-27-05-11-15-00',
> 'DEVNAME': 'sdc',
> 'DEVPATH': '/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/usb3/3-1/3-1:1.0/host0/target0:0:0/0:0:0:0/block/sdc',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1391017781',
> 'ID_BUS': 'usb',
> 'ID_FS_APPLICATION_ID': 'GENISOIMAGE\\x20ISO\\x209660\\x2fHFS\\x20FILESYSTEM\\x20CREATOR\\x20\\x28C\\x29\\x201993\\x20E.YOUNGDALE\\x20\\x28C\\x29\\x201997-2006\\x20J.PEARSON\\x2fJ.SCHILLING\\x20\\x28C\\x29\\x202006-2007\\x20CDRKIT\\x20TEAM',
> 'ID_FS_BOOT_SYSTEM_ID': 'EL\\x20TORITO\\x20SPECIFICATION',
> 'ID_FS_LABEL': 'RHEL-7.0_x86_64',
> 'ID_FS_LABEL_ENC': 'RHEL-7.0\\x20x86_64',
> 'ID_FS_SYSTEM_ID': 'LINUX',
> 'ID_FS_TYPE': 'iso9660',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '2014-01-27-05-11-15-00',
> 'ID_FS_UUID_ENC': '2014-01-27-05-11-15-00',
> 'ID_FS_VERSION': 'Joliet Extension',
> 'ID_INSTANCE': '0:0',
> 'ID_MODEL': 'USB_Flash_Disk',
> 'ID_MODEL_ENC': 'USB\\x20Flash\\x20Disk\\x20\\x20',
> 'ID_MODEL_ID': '800e',
> 'ID_PART_TABLE_TYPE': 'dos',
> 'ID_PATH': 'pci-0000:03:00.0-usb-0:1:1.0-scsi-0:0:0:0',
> 'ID_PATH_TAG': 'pci-0000_03_00_0-usb-0_1_1_0-scsi-0_0_0_0',
> 'ID_REVISION': '1.0',
> 'ID_SERIAL': 'General_USB_Flash_Disk_040405000000022F-0:0',
> 'ID_SERIAL_SHORT': '040405000000022F',
> 'ID_TYPE': 'disk',
> 'ID_USB_DRIVER': 'usb-storage',
> 'ID_USB_INTERFACES': ':080650:',
> 'ID_USB_INTERFACE_NUM': '00',
> 'ID_VENDOR': 'General',
> 'ID_VENDOR_ENC': 'General\\x20',
> 'ID_VENDOR_ID': '8644',
> 'MAJOR': '8',
> 'MINOR': '32',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '506642',
> 'name': 'sdc',
> 'symlinks': ['/dev/disk/by-id/usb-General_USB_Flash_Disk_040405000000022F-0:0',
>              '/dev/disk/by-label/RHEL-7.0\\x20x86_64',
>              '/dev/disk/by-path/pci-0000:03:00.0-usb-0:1:1.0-scsi-0:0:0:0',
>              '/dev/disk/by-uuid/2014-01-27-05-11-15-00'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/usb3/3-1/3-1:1.0/host0/target0:0:0/0:0:0:0/block/sdc'} ; name: sdc ;
>17:49:48,299 INFO blivet: scanning sdc (/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/usb3/3-1/3-1:1.0/host0/target0:0:0/0:0:0:0/block/sdc)...
>17:49:48,300 DEBUG blivet:           DeviceTree.getDeviceByName: name: sdc ;
>17:49:48,301 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>17:49:48,301 DEBUG blivet:           DeviceTree.addUdevDiskDevice: name: sdc ;
>17:49:48,302 INFO blivet: sdc is a disk
>17:49:48,303 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,304 DEBUG blivet:               DiskDevice._setFormat: sdc ; current: None ; type: None ;
>17:49:48,314 INFO blivet: added disk sdc (id 0) to device tree
>17:49:48,314 DEBUG blivet: looking up parted Device: /dev/sdc
>17:49:48,317 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: sdc ;
>17:49:48,318 INFO blivet: type detected on 'sdc' is 'iso9660'
>17:49:48,318 DEBUG blivet:              Iso9660FS.supported: supported: True ;
>17:49:48,318 DEBUG blivet: getFormat('iso9660') returning Iso9660FS instance
>17:49:48,319 DEBUG blivet:             DiskDevice._setFormat: sdc ; current: None ; type: iso9660 ;
>17:49:48,320 INFO blivet: got device: DiskDevice instance (0x7fab86f60e90) --
>  name = sdc  status = True  kids = 0 id = 0
>  parents = []
>  uuid = None  size = 3824.0
>  format = existing iso9660 filesystem
>  major = 8  minor = 32  exists = True  protected = True
>  sysfs path = /devices/pci0000:00/0000:00:1c.1/0000:03:00.0/usb3/3-1/3-1:1.0/host0/target0:0:0/0:0:0:0/block/sdc  partedDevice = parted.Device instance --
>  model: General USB Flash Disk  path: /dev/sdc  type: 1
>  sectorSize: 512  physicalSectorSize:  512
>  length: 7831552  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 0  did: 0  busy: True
>  hardwareGeometry: (1018, 124, 62)  biosGeometry: (487, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f68050>
>  target size = 0  path = /dev/sdc
>  format args = []  originalFormat = None  removable = True  partedDevice = <parted.device.Device object at 0x7fab86e76c50>
>17:49:48,320 DEBUG blivet:             Iso9660FS.supported: supported: True ;
>17:49:48,321 INFO blivet: got format: Iso9660FS instance (0x7fab86e76d10) --
>  type = iso9660  name = iso9660  status = False
>  device = /dev/sdc  uuid = 2014-01-27-05-11-15-00  exists = True
>  options = ro  supported = True  formattable = False  resizable = False
>  mountpoint = None  mountopts = None
>  label = RHEL-7.0_x86_64  size = 0.0  targetSize = 0.0
>
>17:49:48,324 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-id/usb-General_USB_Flash_Disk_040405000000022F-0:0-part1 /dev/disk/by-label/RHEL-7.0\\x20x86_64 /dev/disk/by-path/pci-0000:03:00.0-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-uuid/2014-01-27-05-11-15-00',
> 'DEVNAME': 'sdc1',
> 'DEVPATH': '/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/usb3/3-1/3-1:1.0/host0/target0:0:0/0:0:0:0/block/sdc/sdc1',
> 'DEVTYPE': 'partition',
> 'ID_BUS': 'usb',
> 'ID_FS_APPLICATION_ID': 'GENISOIMAGE\\x20ISO\\x209660\\x2fHFS\\x20FILESYSTEM\\x20CREATOR\\x20\\x28C\\x29\\x201993\\x20E.YOUNGDALE\\x20\\x28C\\x29\\x201997-2006\\x20J.PEARSON\\x2fJ.SCHILLING\\x20\\x28C\\x29\\x202006-2007\\x20CDRKIT\\x20TEAM',
> 'ID_FS_BOOT_SYSTEM_ID': 'EL\\x20TORITO\\x20SPECIFICATION',
> 'ID_FS_LABEL': 'RHEL-7.0_x86_64',
> 'ID_FS_LABEL_ENC': 'RHEL-7.0\\x20x86_64',
> 'ID_FS_SYSTEM_ID': 'LINUX',
> 'ID_FS_TYPE': 'iso9660',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '2014-01-27-05-11-15-00',
> 'ID_FS_UUID_ENC': '2014-01-27-05-11-15-00',
> 'ID_FS_VERSION': 'Joliet Extension',
> 'ID_INSTANCE': '0:0',
> 'ID_MODEL': 'USB_Flash_Disk',
> 'ID_MODEL_ENC': 'USB\\x20Flash\\x20Disk\\x20\\x20',
> 'ID_MODEL_ID': '800e',
> 'ID_PART_ENTRY_DISK': '8:32',
> 'ID_PART_ENTRY_FLAGS': '0x80',
> 'ID_PART_ENTRY_NUMBER': '1',
> 'ID_PART_ENTRY_OFFSET': '0',
> 'ID_PART_ENTRY_SCHEME': 'dos',
> 'ID_PART_ENTRY_SIZE': '657408',
> 'ID_PART_ENTRY_TYPE': '0x0',
> 'ID_PART_TABLE_TYPE': 'dos',
> 'ID_PATH': 'pci-0000:03:00.0-usb-0:1:1.0-scsi-0:0:0:0',
> 'ID_PATH_TAG': 'pci-0000_03_00_0-usb-0_1_1_0-scsi-0_0_0_0',
> 'ID_REVISION': '1.0',
> 'ID_SERIAL': 'General_USB_Flash_Disk_040405000000022F-0:0',
> 'ID_SERIAL_SHORT': '040405000000022F',
> 'ID_TYPE': 'disk',
> 'ID_USB_DRIVER': 'usb-storage',
> 'ID_USB_INTERFACES': ':080650:',
> 'ID_USB_INTERFACE_NUM': '00',
> 'ID_VENDOR': 'General',
> 'ID_VENDOR_ENC': 'General\\x20',
> 'ID_VENDOR_ID': '8644',
> 'MAJOR': '8',
> 'MINOR': '33',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '506674',
> 'name': 'sdc1',
> 'symlinks': ['/dev/disk/by-id/usb-General_USB_Flash_Disk_040405000000022F-0:0-part1',
>              '/dev/disk/by-label/RHEL-7.0\\x20x86_64',
>              '/dev/disk/by-path/pci-0000:03:00.0-usb-0:1:1.0-scsi-0:0:0:0-part1',
>              '/dev/disk/by-uuid/2014-01-27-05-11-15-00'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/usb3/3-1/3-1:1.0/host0/target0:0:0/0:0:0:0/block/sdc/sdc1'} ; name: sdc1 ;
>17:49:48,325 INFO blivet: scanning sdc1 (/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/usb3/3-1/3-1:1.0/host0/target0:0:0/0:0:0:0/block/sdc/sdc1)...
>17:49:48,325 DEBUG blivet:           DeviceTree.getDeviceByName: name: sdc1 ;
>17:49:48,326 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>17:49:48,326 INFO blivet: sdc1 is a partition
>17:49:48,326 DEBUG blivet:           DeviceTree.addUdevPartitionDevice: name: sdc1 ;
>17:49:48,327 DEBUG blivet:            DeviceTree.getDeviceByName: name: sdc ;
>17:49:48,328 DEBUG blivet:            DeviceTree.getDeviceByName returned existing 3824MB disk sdc (0) with existing iso9660 filesystem
>17:49:48,328 DEBUG blivet: lvm filter: adding sdc1 to the reject list
>17:49:48,328 DEBUG blivet: ignoring partition sdc1 on iso9660
>17:49:48,328 DEBUG blivet: no device or no media present
>17:49:48,335 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-id/usb-General_USB_Flash_Disk_040405000000022F-0:0-part2 /dev/disk/by-label/ANACONDA /dev/disk/by-path/pci-0000:03:00.0-usb-0:1:1.0-scsi-0:0:0:0-part2 /dev/disk/by-uuid/0C29-D646',
> 'DEVNAME': 'sdc2',
> 'DEVPATH': '/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/usb3/3-1/3-1:1.0/host0/target0:0:0/0:0:0:0/block/sdc/sdc2',
> 'DEVTYPE': 'partition',
> 'ID_BUS': 'usb',
> 'ID_FS_APPLICATION_ID': 'GENISOIMAGE\\x20ISO\\x209660\\x2fHFS\\x20FILESYSTEM\\x20CREATOR\\x20\\x28C\\x29\\x201993\\x20E.YOUNGDALE\\x20\\x28C\\x29\\x201997-2006\\x20J.PEARSON\\x2fJ.SCHILLING\\x20\\x28C\\x29\\x202006-2007\\x20CDRKIT\\x20TEAM',
> 'ID_FS_BOOT_SYSTEM_ID': 'EL\\x20TORITO\\x20SPECIFICATION',
> 'ID_FS_LABEL': 'ANACONDA',
> 'ID_FS_LABEL_ENC': 'ANACONDA',
> 'ID_FS_SYSTEM_ID': 'LINUX',
> 'ID_FS_TYPE': 'vfat',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '0C29-D646',
> 'ID_FS_UUID_ENC': '0C29-D646',
> 'ID_FS_VERSION': 'FAT12',
> 'ID_INSTANCE': '0:0',
> 'ID_MODEL': 'USB_Flash_Disk',
> 'ID_MODEL_ENC': 'USB\\x20Flash\\x20Disk\\x20\\x20',
> 'ID_MODEL_ID': '800e',
> 'ID_PART_ENTRY_DISK': '8:32',
> 'ID_PART_ENTRY_NUMBER': '2',
> 'ID_PART_ENTRY_OFFSET': '139048',
> 'ID_PART_ENTRY_SCHEME': 'dos',
> 'ID_PART_ENTRY_SIZE': '12656',
> 'ID_PART_ENTRY_TYPE': '0xef',
> 'ID_PART_TABLE_TYPE': 'dos',
> 'ID_PATH': 'pci-0000:03:00.0-usb-0:1:1.0-scsi-0:0:0:0',
> 'ID_PATH_TAG': 'pci-0000_03_00_0-usb-0_1_1_0-scsi-0_0_0_0',
> 'ID_REVISION': '1.0',
> 'ID_SERIAL': 'General_USB_Flash_Disk_040405000000022F-0:0',
> 'ID_SERIAL_SHORT': '040405000000022F',
> 'ID_TYPE': 'disk',
> 'ID_USB_DRIVER': 'usb-storage',
> 'ID_USB_INTERFACES': ':080650:',
> 'ID_USB_INTERFACE_NUM': '00',
> 'ID_VENDOR': 'General',
> 'ID_VENDOR_ENC': 'General\\x20',
> 'ID_VENDOR_ID': '8644',
> 'MAJOR': '8',
> 'MINOR': '34',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '506705',
> 'name': 'sdc2',
> 'symlinks': ['/dev/disk/by-id/usb-General_USB_Flash_Disk_040405000000022F-0:0-part2',
>              '/dev/disk/by-label/ANACONDA',
>              '/dev/disk/by-path/pci-0000:03:00.0-usb-0:1:1.0-scsi-0:0:0:0-part2',
>              '/dev/disk/by-uuid/0C29-D646'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/usb3/3-1/3-1:1.0/host0/target0:0:0/0:0:0:0/block/sdc/sdc2'} ; name: sdc2 ;
>17:49:48,336 INFO blivet: scanning sdc2 (/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/usb3/3-1/3-1:1.0/host0/target0:0:0/0:0:0:0/block/sdc/sdc2)...
>17:49:48,337 DEBUG blivet:           DeviceTree.getDeviceByName: name: sdc2 ;
>17:49:48,337 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>17:49:48,338 INFO blivet: sdc2 is a partition
>17:49:48,339 DEBUG blivet:           DeviceTree.addUdevPartitionDevice: name: sdc2 ;
>17:49:48,339 DEBUG blivet:            DeviceTree.getDeviceByName: name: sdc ;
>17:49:48,340 DEBUG blivet:            DeviceTree.getDeviceByName returned existing 3824MB disk sdc (0) with existing iso9660 filesystem
>17:49:48,341 DEBUG blivet: lvm filter: adding sdc2 to the reject list
>17:49:48,341 DEBUG blivet: ignoring partition sdc2 on iso9660
>17:49:48,341 DEBUG blivet: no device or no media present
>17:49:48,346 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-id/ata-ST1000DM003-1CH162_Z1D9A2RA /dev/disk/by-id/wwn-0x5000c50065e6de0e',
> 'DEVNAME': 'sda',
> 'DEVPATH': '/devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1391017781',
> 'ID_ATA': '1',
> 'ID_ATA_DOWNLOAD_MICROCODE': '1',
> 'ID_ATA_FEATURE_SET_APM': '1',
> 'ID_ATA_FEATURE_SET_APM_CURRENT_VALUE': '128',
> 'ID_ATA_FEATURE_SET_APM_ENABLED': '1',
> 'ID_ATA_FEATURE_SET_HPA': '1',
> 'ID_ATA_FEATURE_SET_HPA_ENABLED': '1',
> 'ID_ATA_FEATURE_SET_PM': '1',
> 'ID_ATA_FEATURE_SET_PM_ENABLED': '1',
> 'ID_ATA_FEATURE_SET_PUIS': '1',
> 'ID_ATA_FEATURE_SET_PUIS_ENABLED': '0',
> 'ID_ATA_FEATURE_SET_SECURITY': '1',
> 'ID_ATA_FEATURE_SET_SECURITY_ENABLED': '0',
> 'ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN': '104',
> 'ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN': '104',
> 'ID_ATA_FEATURE_SET_SECURITY_FROZEN': '1',
> 'ID_ATA_FEATURE_SET_SMART': '1',
> 'ID_ATA_FEATURE_SET_SMART_ENABLED': '1',
> 'ID_ATA_ROTATION_RATE_RPM': '7200',
> 'ID_ATA_SATA': '1',
> 'ID_ATA_SATA_SIGNAL_RATE_GEN1': '1',
> 'ID_ATA_SATA_SIGNAL_RATE_GEN2': '1',
> 'ID_ATA_WRITE_CACHE': '1',
> 'ID_ATA_WRITE_CACHE_ENABLED': '1',
> 'ID_BUS': 'ata',
> 'ID_MODEL': 'ST1000DM003-1CH162',
> 'ID_MODEL_ENC': 'ST1000DM003-1CH162\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20',
> 'ID_REVISION': 'CC49',
> 'ID_SERIAL': 'ST1000DM003-1CH162_Z1D9A2RA',
> 'ID_SERIAL_SHORT': 'Z1D9A2RA',
> 'ID_TYPE': 'disk',
> 'ID_WWN': '0x5000c50065e6de0e',
> 'ID_WWN_WITH_EXTENSION': '0x5000c50065e6de0e',
> 'MAJOR': '8',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '508054',
> 'name': 'sda',
> 'symlinks': ['/dev/disk/by-id/ata-ST1000DM003-1CH162_Z1D9A2RA',
>              '/dev/disk/by-id/wwn-0x5000c50065e6de0e'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda'} ; name: sda ;
>17:49:48,346 INFO blivet: scanning sda (/devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda)...
>17:49:48,347 DEBUG blivet:           DeviceTree.getDeviceByName: name: sda ;
>17:49:48,348 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>17:49:48,349 DEBUG blivet:           DeviceTree.addUdevDiskDevice: name: sda ;
>17:49:48,349 INFO blivet: sda is a disk
>17:49:48,350 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,350 DEBUG blivet:               DiskDevice._setFormat: sda ; current: None ; type: None ;
>17:49:48,357 INFO blivet: added disk sda (id 1) to device tree
>17:49:48,357 DEBUG blivet: looking up parted Device: /dev/sda
>17:49:48,359 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: sda ;
>17:49:48,360 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: sda ; label_type: None ;
>17:49:48,361 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,361 DEBUG blivet:             DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>17:49:48,361 DEBUG blivet: required disklabel type for sda (1) is None
>17:49:48,362 DEBUG blivet: default disklabel type for sda is msdos
>17:49:48,362 DEBUG blivet: selecting msdos disklabel for sda based on size
>17:49:48,363 DEBUG blivet:              DiskLabel.__init__: device: /dev/sda ; labelType: msdos ; exists: True ;
>17:49:48,389 INFO blivet: no usable disklabel on sda
>17:49:48,389 DEBUG blivet: no type or existing type for sda, bailing
>17:49:48,390 INFO blivet: got device: DiskDevice instance (0x7fab86f60e10) --
>  name = sda  status = True  kids = 0 id = 1
>  parents = []
>  uuid = None  size = 953869.710938
>  format = existing None
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sda  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f685f0>
>  target size = 0  path = /dev/sda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab86e76f90>
>17:49:48,393 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-id/ata-ST1000DM003-1CH162_Z1D9A2T7 /dev/disk/by-id/wwn-0x5000c50065e6dd75',
> 'DEVNAME': 'sdb',
> 'DEVPATH': '/devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1391017781',
> 'ID_ATA': '1',
> 'ID_ATA_DOWNLOAD_MICROCODE': '1',
> 'ID_ATA_FEATURE_SET_APM': '1',
> 'ID_ATA_FEATURE_SET_APM_CURRENT_VALUE': '128',
> 'ID_ATA_FEATURE_SET_APM_ENABLED': '1',
> 'ID_ATA_FEATURE_SET_HPA': '1',
> 'ID_ATA_FEATURE_SET_HPA_ENABLED': '1',
> 'ID_ATA_FEATURE_SET_PM': '1',
> 'ID_ATA_FEATURE_SET_PM_ENABLED': '1',
> 'ID_ATA_FEATURE_SET_PUIS': '1',
> 'ID_ATA_FEATURE_SET_PUIS_ENABLED': '0',
> 'ID_ATA_FEATURE_SET_SECURITY': '1',
> 'ID_ATA_FEATURE_SET_SECURITY_ENABLED': '0',
> 'ID_ATA_FEATURE_SET_SECURITY_ENHANCED_ERASE_UNIT_MIN': '106',
> 'ID_ATA_FEATURE_SET_SECURITY_ERASE_UNIT_MIN': '106',
> 'ID_ATA_FEATURE_SET_SECURITY_FROZEN': '1',
> 'ID_ATA_FEATURE_SET_SMART': '1',
> 'ID_ATA_FEATURE_SET_SMART_ENABLED': '1',
> 'ID_ATA_ROTATION_RATE_RPM': '7200',
> 'ID_ATA_SATA': '1',
> 'ID_ATA_SATA_SIGNAL_RATE_GEN1': '1',
> 'ID_ATA_SATA_SIGNAL_RATE_GEN2': '1',
> 'ID_ATA_WRITE_CACHE': '1',
> 'ID_ATA_WRITE_CACHE_ENABLED': '1',
> 'ID_BUS': 'ata',
> 'ID_MODEL': 'ST1000DM003-1CH162',
> 'ID_MODEL_ENC': 'ST1000DM003-1CH162\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20',
> 'ID_REVISION': 'CC49',
> 'ID_SERIAL': 'ST1000DM003-1CH162_Z1D9A2T7',
> 'ID_SERIAL_SHORT': 'Z1D9A2T7',
> 'ID_TYPE': 'disk',
> 'ID_WWN': '0x5000c50065e6dd75',
> 'ID_WWN_WITH_EXTENSION': '0x5000c50065e6dd75',
> 'MAJOR': '8',
> 'MINOR': '16',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '508623',
> 'name': 'sdb',
> 'symlinks': ['/dev/disk/by-id/ata-ST1000DM003-1CH162_Z1D9A2T7',
>              '/dev/disk/by-id/wwn-0x5000c50065e6dd75'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb'} ; name: sdb ;
>17:49:48,394 INFO blivet: scanning sdb (/devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb)...
>17:49:48,394 DEBUG blivet:           DeviceTree.getDeviceByName: name: sdb ;
>17:49:48,395 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>17:49:48,396 DEBUG blivet:           DeviceTree.addUdevDiskDevice: name: sdb ;
>17:49:48,396 INFO blivet: sdb is a disk
>17:49:48,396 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,397 DEBUG blivet:               DiskDevice._setFormat: sdb ; current: None ; type: None ;
>17:49:48,404 INFO blivet: added disk sdb (id 2) to device tree
>17:49:48,405 DEBUG blivet: looking up parted Device: /dev/sdb
>17:49:48,406 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: sdb ;
>17:49:48,407 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: sdb ; label_type: None ;
>17:49:48,407 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,408 DEBUG blivet:             DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>17:49:48,408 DEBUG blivet: required disklabel type for sdb (1) is None
>17:49:48,408 DEBUG blivet: default disklabel type for sdb is msdos
>17:49:48,408 DEBUG blivet: selecting msdos disklabel for sdb based on size
>17:49:48,409 DEBUG blivet:              DiskLabel.__init__: device: /dev/sdb ; labelType: msdos ; exists: True ;
>17:49:48,429 INFO blivet: no usable disklabel on sdb
>17:49:48,430 DEBUG blivet: no type or existing type for sdb, bailing
>17:49:48,431 INFO blivet: got device: DiskDevice instance (0x7fab86e76ed0) --
>  name = sdb  status = True  kids = 0 id = 2
>  parents = []
>  uuid = None  size = 953869.710938
>  format = existing None
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sdb  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f687a0>
>  target size = 0  path = /dev/sdb
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab89948110>
>17:49:48,432 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVNAME': 'loop0',
> 'DEVPATH': '/devices/virtual/block/loop0',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1391017781',
> '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': '540520',
> 'name': 'loop0',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop0'} ; name: loop0 ;
>17:49:48,433 INFO blivet: scanning loop0 (/devices/virtual/block/loop0)...
>17:49:48,433 DEBUG blivet:           DeviceTree.getDeviceByName: name: loop0 ;
>17:49:48,434 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>17:49:48,434 INFO blivet: loop0 is a loop device
>17:49:48,435 DEBUG blivet:           DeviceTree.addUdevLoopDevice: name: loop0 ;
>17:49:48,435 DEBUG blivet:            DeviceTree.getDeviceByName: name: /run/install/repo/LiveOS/squashfs.img ;
>17:49:48,436 DEBUG blivet:            DeviceTree.getDeviceByName returned None
>17:49:48,436 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,437 DEBUG blivet:               FileDevice._setFormat: /run/install/repo/LiveOS/squashfs.img ; current: None ; type: None ;
>17:49:48,437 INFO blivet: added file /run/install/repo/LiveOS/squashfs.img (id 3) to device tree
>17:49:48,438 DEBUG blivet:               FileDevice.addChild: kids: 0 ; name: /run/install/repo/LiveOS/squashfs.img ;
>17:49:48,438 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,439 DEBUG blivet:               LoopDevice._setFormat: loop0 ; current: None ; type: None ;
>17:49:48,439 INFO blivet: added loop loop0 (id 4) to device tree
>17:49:48,439 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: loop0 ;
>17:49:48,440 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: loop0 ; label_type: None ;
>17:49:48,440 DEBUG blivet: getFormat('squashfs') returning DeviceFormat instance
>17:49:48,440 DEBUG blivet: device loop0 does not contain a disklabel
>17:49:48,440 INFO blivet: type detected on 'loop0' is 'squashfs'
>17:49:48,441 DEBUG blivet: getFormat('squashfs') returning DeviceFormat instance
>17:49:48,441 DEBUG blivet:             LoopDevice._setFormat: loop0 ; current: None ; type: squashfs ;
>17:49:48,442 INFO blivet: got device: LoopDevice instance (0x7fab899485d0) --
>  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 squashfs
>  major = 0  minor = 0  exists = True  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/loop0
>  format args = []  originalFormat = None
>17:49:48,442 INFO blivet: got format: DeviceFormat instance (0x7fab89948690) --
>  type = squashfs  name = squashfs  status = False
>  device = /dev/loop0  uuid = None  exists = True
>  options = None  supported = False  formattable = False  resizable = False
>
>17:49:48,444 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-label/Anaconda /dev/disk/by-uuid/8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf',
> 'DEVNAME': 'loop1',
> 'DEVPATH': '/devices/virtual/block/loop1',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1391017781',
> 'ID_FS_LABEL': 'Anaconda',
> 'ID_FS_LABEL_ENC': 'Anaconda',
> 'ID_FS_TYPE': 'ext4',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf',
> 'ID_FS_UUID_ENC': '8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '7',
> 'MINOR': '1',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '541022',
> 'name': 'loop1',
> 'symlinks': ['/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf'],
> 'sysfs_path': '/devices/virtual/block/loop1'} ; name: loop1 ;
>17:49:48,444 INFO blivet: scanning loop1 (/devices/virtual/block/loop1)...
>17:49:48,444 DEBUG blivet:           DeviceTree.getDeviceByName: name: loop1 ;
>17:49:48,445 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>17:49:48,445 INFO blivet: loop1 is a loop device
>17:49:48,446 DEBUG blivet:           DeviceTree.addUdevLoopDevice: name: loop1 ;
>17:49:48,447 DEBUG blivet:            DeviceTree.getDeviceByName: name: /LiveOS/rootfs.img ;
>17:49:48,447 DEBUG blivet:            DeviceTree.getDeviceByName returned None
>17:49:48,448 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,448 DEBUG blivet:               FileDevice._setFormat: /LiveOS/rootfs.img ; current: None ; type: None ;
>17:49:48,449 INFO blivet: added file /LiveOS/rootfs.img (id 5) to device tree
>17:49:48,449 DEBUG blivet:               FileDevice.addChild: kids: 0 ; name: /LiveOS/rootfs.img ;
>17:49:48,449 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,450 DEBUG blivet:               LoopDevice._setFormat: loop1 ; current: None ; type: None ;
>17:49:48,450 INFO blivet: added loop loop1 (id 6) to device tree
>17:49:48,451 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: loop1 ;
>17:49:48,451 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: loop1 ; label_type: None ;
>17:49:48,452 DEBUG blivet:                Ext4FS.supported: supported: True ;
>17:49:48,452 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>17:49:48,453 DEBUG blivet: device loop1 does not contain a disklabel
>17:49:48,453 INFO blivet: type detected on 'loop1' is 'ext4'
>17:49:48,529 DEBUG blivet: using current size 0 as min size
>17:49:48,530 DEBUG blivet:               Ext4FS.supported: supported: True ;
>17:49:48,530 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>17:49:48,531 DEBUG blivet:             LoopDevice._setFormat: loop1 ; current: None ; type: ext4 ;
>17:49:48,531 INFO blivet: got device: LoopDevice instance (0x7fab89936f90) --
>  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
>17:49:48,532 DEBUG blivet:             Ext4FS.supported: supported: True ;
>17:49:48,532 INFO blivet: got format: Ext4FS instance (0x7fab86e76e10) --
>  type = ext4  name = ext4  status = False
>  device = /dev/loop1  uuid = 8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 2048.0  targetSize = 2048.0
>
>17:49:48,533 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVNAME': 'loop2',
> 'DEVPATH': '/devices/virtual/block/loop2',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1391017781',
> 'MAJOR': '7',
> 'MINOR': '2',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '541526',
> 'name': 'loop2',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop2'} ; name: loop2 ;
>17:49:48,534 INFO blivet: scanning loop2 (/devices/virtual/block/loop2)...
>17:49:48,534 DEBUG blivet:           DeviceTree.getDeviceByName: name: loop2 ;
>17:49:48,535 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>17:49:48,535 INFO blivet: loop2 is a loop device
>17:49:48,536 DEBUG blivet:           DeviceTree.addUdevLoopDevice: name: loop2 ;
>17:49:48,536 DEBUG blivet:            DeviceTree.getDeviceByName: name: /overlay (deleted) ;
>17:49:48,537 DEBUG blivet:            DeviceTree.getDeviceByName returned None
>17:49:48,537 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,538 DEBUG blivet:               FileDevice._setFormat: /overlay (deleted) ; current: None ; type: None ;
>17:49:48,538 INFO blivet: added file /overlay (deleted) (id 7) to device tree
>17:49:48,539 DEBUG blivet:               FileDevice.addChild: kids: 0 ; name: /overlay (deleted) ;
>17:49:48,539 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,540 DEBUG blivet:               LoopDevice._setFormat: loop2 ; current: None ; type: None ;
>17:49:48,540 INFO blivet: added loop loop2 (id 8) to device tree
>17:49:48,541 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: loop2 ;
>17:49:48,541 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: loop2 ; label_type: None ;
>17:49:48,541 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,542 DEBUG blivet:             LoopDevice.setup: loop2 ; status: False ; controllable: False ; orig: False ;
>17:49:48,543 DEBUG blivet:              DiskLabel.__init__: device: /dev/loop2 ; labelType: None ; exists: True ;
>17:49:48,544 WARN blivet: disklabel detected but not usable on loop2
>17:49:48,545 DEBUG blivet: no type or existing type for loop2, bailing
>17:49:48,545 INFO blivet: got device: LoopDevice instance (0x7fab899486d0) --
>  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
>17:49:48,547 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-id/dm-name-live-rw /dev/disk/by-label/Anaconda /dev/disk/by-uuid/8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf /dev/mapper/live-rw',
> 'DEVNAME': 'dm-0',
> 'DEVPATH': '/devices/virtual/block/dm-0',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1391017781',
> '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': '8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf',
> 'ID_FS_UUID_ENC': '8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '253',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '24681',
> 'name': 'dm-0',
> 'symlinks': ['/dev/disk/by-id/dm-name-live-rw',
>              '/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf',
>              '/dev/mapper/live-rw'],
> 'sysfs_path': '/devices/virtual/block/dm-0'} ; name: live-rw ;
>17:49:48,547 INFO blivet: scanning live-rw (/devices/virtual/block/dm-0)...
>17:49:48,548 DEBUG blivet:           DeviceTree.getDeviceByName: name: live-rw ;
>17:49:48,548 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>17:49:48,549 INFO blivet: live-rw is a device-mapper device
>17:49:48,549 DEBUG blivet:           DeviceTree.addUdevDMDevice: name: live-rw ;
>17:49:48,550 DEBUG blivet:            DeviceTree.getDeviceByName: name: loop1 ;
>17:49:48,551 DEBUG blivet:            DeviceTree.getDeviceByName returned existing 0MB loop loop1 (6) with existing ext4 filesystem
>17:49:48,551 DEBUG blivet:            DeviceTree.getDeviceByName: name: loop2 ;
>17:49:48,552 DEBUG blivet:            DeviceTree.getDeviceByName returned existing 0MB loop loop2 (8)
>17:49:48,553 DEBUG blivet:            DeviceTree.getDeviceByName: name: live-rw ;
>17:49:48,554 DEBUG blivet:            DeviceTree.getDeviceByName returned None
>17:49:48,554 DEBUG blivet:               LoopDevice.addChild: kids: 0 ; name: loop2 ;
>17:49:48,555 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,555 DEBUG blivet:               DMDevice._setFormat: live-rw ; current: None ; type: None ;
>17:49:48,555 INFO blivet: added dm live-rw (id 9) to device tree
>17:49:48,556 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: live-rw ;
>17:49:48,557 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: live-rw ; label_type: None ;
>17:49:48,558 DEBUG blivet:                Ext4FS.supported: supported: True ;
>17:49:48,558 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>17:49:48,558 DEBUG blivet: device live-rw does not contain a disklabel
>17:49:48,558 INFO blivet: type detected on 'live-rw' is 'ext4'
>17:49:48,574 DEBUG blivet: padding min size from 924 up to 1016
>17:49:48,575 DEBUG blivet:               Ext4FS.supported: supported: True ;
>17:49:48,575 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>17:49:48,576 DEBUG blivet:             DMDevice._setFormat: live-rw ; current: None ; type: ext4 ;
>17:49:48,577 DEBUG blivet: looking up parted Device: /dev/mapper/live-rw
>17:49:48,673 INFO blivet: got device: DMDevice instance (0x7fab89948390) --
>  name = live-rw  status = True  kids = 0 id = 9
>  parents = ['existing 0MB loop loop2 (8)']
>  uuid = None  size = 2048.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: 4194304  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: True
>  hardwareGeometry: (261, 255, 63)  biosGeometry: (261, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f68680>
>  target size = 0  path = /dev/mapper/live-rw
>  format args = []  originalFormat = None  target = None  dmUuid = None
>17:49:48,674 DEBUG blivet:             Ext4FS.supported: supported: True ;
>17:49:48,674 INFO blivet: got format: Ext4FS instance (0x7fab86e76e90) --
>  type = ext4  name = ext4  status = False
>  device = /dev/mapper/live-rw  uuid = 8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 2048.0  targetSize = 2048.0
>
>17:49:48,677 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-id/dm-name-live-base /dev/disk/by-label/Anaconda /dev/disk/by-uuid/8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf /dev/mapper/live-base',
> 'DEVNAME': 'dm-1',
> 'DEVPATH': '/devices/virtual/block/dm-1',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1391017781',
> 'DM_NAME': 'live-base',
> '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': '8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf',
> 'ID_FS_UUID_ENC': '8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '253',
> 'MINOR': '1',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '39906',
> 'name': 'dm-1',
> 'symlinks': ['/dev/disk/by-id/dm-name-live-base',
>              '/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf',
>              '/dev/mapper/live-base'],
> 'sysfs_path': '/devices/virtual/block/dm-1'} ; name: live-base ;
>17:49:48,677 INFO blivet: scanning live-base (/devices/virtual/block/dm-1)...
>17:49:48,677 DEBUG blivet:           DeviceTree.getDeviceByName: name: live-base ;
>17:49:48,678 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>17:49:48,678 INFO blivet: live-base is a device-mapper device
>17:49:48,679 DEBUG blivet:           DeviceTree.addUdevDMDevice: name: live-base ;
>17:49:48,679 DEBUG blivet:            DMDevice.getDMNode: live-rw ; status: True ;
>17:49:48,680 DEBUG blivet:            DeviceTree.getDeviceByName: name: loop1 ;
>17:49:48,681 DEBUG blivet:            DeviceTree.getDeviceByName returned existing 0MB loop loop1 (6) with existing ext4 filesystem
>17:49:48,682 DEBUG blivet:            DeviceTree.getDeviceByName: name: live-base ;
>17:49:48,682 DEBUG blivet:            DeviceTree.getDeviceByName returned None
>17:49:48,683 DEBUG blivet:               LoopDevice.addChild: kids: 0 ; name: loop1 ;
>17:49:48,683 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>17:49:48,684 DEBUG blivet:               DMDevice._setFormat: live-base ; current: None ; type: None ;
>17:49:48,684 INFO blivet: added dm live-base (id 10) to device tree
>17:49:48,685 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: live-base ;
>17:49:48,685 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: live-base ; label_type: None ;
>17:49:48,686 DEBUG blivet:                Ext4FS.supported: supported: True ;
>17:49:48,686 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>17:49:48,686 DEBUG blivet: device live-base does not contain a disklabel
>17:49:48,687 INFO blivet: type detected on 'live-base' is 'ext4'
>17:49:48,715 DEBUG blivet: using current size 0 as min size
>17:49:48,716 DEBUG blivet:               Ext4FS.supported: supported: True ;
>17:49:48,716 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>17:49:48,717 DEBUG blivet:             DMDevice._setFormat: live-base ; current: None ; type: ext4 ;
>17:49:48,718 DEBUG blivet: looking up parted Device: /dev/mapper/live-base
>17:49:48,719 INFO blivet: got device: DMDevice instance (0x7fab89948350) --
>  name = live-base  status = True  kids = 0 id = 10
>  parents = ['existing 0MB loop loop1 (6) with existing ext4 filesystem']
>  uuid = None  size = 2048.0
>  format = existing ext4 filesystem
>  major = 0  minor = 0  exists = True  protected = True
>  sysfs path = /devices/virtual/block/dm-1  partedDevice = parted.Device instance --
>  model: Linux device-mapper (linear)  path: /dev/mapper/live-base  type: 12
>  sectorSize: 512  physicalSectorSize:  512
>  length: 4194304  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (261, 255, 63)  biosGeometry: (261, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f684d0>
>  target size = 0  path = /dev/mapper/live-base
>  format args = []  originalFormat = None  target = None  dmUuid = None
>17:49:48,720 DEBUG blivet:             Ext4FS.supported: supported: True ;
>17:49:48,720 INFO blivet: got format: Ext4FS instance (0x7fab89948950) --
>  type = ext4  name = ext4  status = False
>  device = /dev/mapper/live-base  uuid = 8b7dc4aa-9238-4e1d-bf19-7cefe4e457cf  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 2048.0  targetSize = 2048.0
>
>17:49:48,808 DEBUG blivet:           DiskDevice.teardown: sda ; status: True ; controllable: True ;
>17:49:48,808 DEBUG blivet:             DeviceFormat.teardown: device: /dev/sda ; status: False ; type: None ;
>17:49:48,810 DEBUG blivet:             DeviceFormat.teardown: device: /dev/sda ; status: False ; type: None ;
>17:49:48,820 DEBUG blivet:           DiskDevice.teardown: sdb ; status: True ; controllable: True ;
>17:49:48,821 DEBUG blivet:             DeviceFormat.teardown: device: /dev/sdb ; status: False ; type: None ;
>17:49:48,822 DEBUG blivet:             DeviceFormat.teardown: device: /dev/sdb ; status: False ; type: None ;
>17:49:48,832 DEBUG blivet:           LoopDevice.teardown: loop0 ; status: False ; controllable: False ;
>17:49:48,833 INFO blivet: not going to restore from backup of non-existent /etc/mdadm.conf
>17:49:48,833 INFO blivet: edd: collected mbr signatures: {}
>17:49:48,833 DEBUG blivet: edd: data extracted from 0x80:
>	type: USB, ata_device: None
>	channel: 0, mbr_signature: 0x30165d0d
>	pci_dev: 03:00.0, scsi_id: None
>	scsi_lun: None, sectors: 7831552
>17:49:48,834 ERR blivet: edd: unable to match edd entry 0x80
>17:49:48,834 DEBUG blivet: edd: data extracted from 0x81:
>	type: SATA, ata_device: None
>	channel: 255, mbr_signature: None
>	pci_dev: 00:1f.2, scsi_id: None
>	scsi_lun: None, sectors: 1953525168
>17:49:48,834 ERR blivet: edd: unable to match edd entry 0x81
>17:49:48,834 DEBUG blivet: edd: data extracted from 0x82:
>	type: SATA, ata_device: None
>	channel: 255, mbr_signature: None
>	pci_dev: 00:1f.2, scsi_id: None
>	scsi_lun: None, sectors: 1953525168
>17:49:48,834 ERR blivet: edd: unable to match edd entry 0x82
>17:49:48,908 DEBUG blivet:             Ext4FS.supported: supported: True ;
>17:49:48,911 DEBUG blivet:             Ext4FS.supported: supported: True ;
>17:49:48,913 DEBUG blivet:            Ext4FS.supported: supported: True ;
>17:49:48,914 DEBUG blivet:            Iso9660FS.supported: supported: True ;
>17:49:48,918 DEBUG blivet: /dev/sdc is mounted on /run/install/repo
>17:49:48,918 DEBUG blivet: /dev/sdc is mounted on /run/install/repo
>17:49:48,919 DEBUG blivet:          DeviceTree.getDeviceByPath: path: /dev/sdc ;
>17:49:48,920 DEBUG blivet:          DeviceTree.getDeviceByPath returned existing 3824MB disk sdc (0) with existing iso9660 filesystem
>17:49:49,069 DEBUG blivet: /dev/sdc is mounted on /run/install/repo
>17:49:49,069 DEBUG blivet: /dev/sdc is mounted on /run/install/repo
>17:49:49,070 DEBUG blivet:          DeviceTree.getDeviceByPath: path: /dev/sdc ;
>17:49:49,071 DEBUG blivet:          DeviceTree.getDeviceByPath returned existing 3824MB disk sdc (0) with existing iso9660 filesystem
>17:52:22,261 DEBUG blivet: /dev/sdc is mounted on /run/install/repo
>17:52:22,261 DEBUG blivet: /dev/sdc is mounted on /run/install/repo
>17:52:22,262 DEBUG blivet:          DeviceTree.getDeviceByPath: path: /dev/sdc ;
>17:52:22,263 DEBUG blivet:          DeviceTree.getDeviceByPath returned existing 3824MB disk sdc (0) with existing iso9660 filesystem
>17:52:22,276 DEBUG blivet: /dev/sdc is mounted on /run/install/repo
>17:52:22,277 DEBUG blivet: /dev/sdc is mounted on /run/install/repo
>17:52:22,277 DEBUG blivet:          DeviceTree.getDeviceByPath: path: /dev/sdc ;
>17:52:22,278 DEBUG blivet:          DeviceTree.getDeviceByPath returned existing 3824MB disk sdc (0) with existing iso9660 filesystem
>17:52:22,573 INFO blivet: updating format of device: existing 3824MB disk sdc (0) with existing iso9660 filesystem
>17:52:22,573 DEBUG blivet: notifying kernel of 'change' event on device /sys/devices/pci0000:00/0000:00:1c.1/0000:03:00.0/usb3/3-1/3-1:1.0/host0/target0:0:0/0:0:0:0/block/sdc
>17:52:22,587 DEBUG blivet:         DeviceTree.handleUdevDeviceFormat: name: sdc ;
>17:52:22,588 DEBUG blivet: no type or existing type for sdc, bailing
>17:52:22,588 INFO blivet: got format: existing iso9660 filesystem
>17:52:22,645 DEBUG blivet:        Iso9660FS.supported: supported: True ;
>17:52:22,645 DEBUG blivet:       Iso9660FS.supported: supported: True ;
>17:52:22,646 DEBUG blivet:        NFSv4.supported: supported: False ;
>17:52:22,646 DEBUG blivet:       NFSv4.supported: supported: False ;
>17:52:22,647 DEBUG blivet:         SELinuxFS.supported: supported: False ;
>17:52:22,647 DEBUG blivet:       SELinuxFS.supported: supported: False ;
>17:52:22,648 DEBUG blivet:         Ext4FS.supported: supported: True ;
>17:52:22,649 DEBUG blivet:       Ext4FS.supported: supported: True ;
>17:52:22,995 DEBUG blivet:         Ext3FS.supported: supported: True ;
>17:52:22,995 DEBUG blivet:       Ext3FS.supported: supported: True ;
>17:52:23,045 DEBUG blivet:         Ext2FS.supported: supported: True ;
>17:52:23,046 DEBUG blivet:       Ext2FS.supported: supported: True ;
>17:52:23,072 DEBUG blivet:         SysFS.supported: supported: False ;
>17:52:23,072 DEBUG blivet:       SysFS.supported: supported: False ;
>17:52:23,073 DEBUG blivet:       MultipathMember.__init__:
>17:52:23,073 DEBUG blivet:       SwapSpace.__init__:
>17:52:23,074 DEBUG blivet:         ProcFS.supported: supported: False ;
>17:52:23,075 DEBUG blivet:       ProcFS.supported: supported: False ;
>17:52:23,075 DEBUG blivet:         NoDevFS.supported: supported: False ;
>17:52:23,076 DEBUG blivet:       NoDevFS.supported: supported: False ;
>17:52:23,076 DEBUG blivet:         DevPtsFS.supported: supported: False ;
>17:52:23,077 DEBUG blivet:       DevPtsFS.supported: supported: False ;
>17:52:23,077 DEBUG blivet:         BTRFS.supported: supported: True ;
>17:52:23,132 DEBUG blivet:         USBFS.supported: supported: False ;
>17:52:23,132 DEBUG blivet:       USBFS.supported: supported: False ;
>17:52:23,133 DEBUG blivet:       DiskLabel.__init__:
>17:52:23,133 INFO blivet: DiskLabel.partedDevice returning None
>17:52:23,134 DEBUG blivet:        HFSPlus.supported: supported: False ;
>17:52:23,134 DEBUG blivet:       HFSPlus.supported: supported: False ;
>17:52:23,134 DEBUG blivet:        XFS.supported: supported: True ;
>17:52:23,135 DEBUG blivet:       XFS.supported: supported: True ;
>17:52:23,136 DEBUG blivet:          TmpFS.supported: supported: True ;
>17:52:23,144 DEBUG blivet:       TmpFS.supported: supported: True ;
>17:52:23,145 DEBUG blivet:       LUKS.__init__:
>17:52:23,146 DEBUG blivet:        NTFS.supported: supported: False ;
>17:52:23,146 DEBUG blivet:       NTFS.supported: supported: False ;
>17:52:23,147 DEBUG blivet:        BindFS.supported: supported: False ;
>17:52:23,147 DEBUG blivet:       BindFS.supported: supported: False ;
>17:52:23,148 DEBUG blivet:        HFS.supported: supported: False ;
>17:52:23,148 DEBUG blivet:       HFS.supported: supported: False ;
>17:52:23,149 DEBUG blivet:       LVMPhysicalVolume.__init__:
>17:52:23,149 DEBUG blivet:        NFS.supported: supported: False ;
>17:52:23,150 DEBUG blivet:       NFS.supported: supported: False ;
>17:52:23,150 DEBUG blivet:        FATFS.supported: supported: True ;
>17:52:23,168 DEBUG blivet:       FATFS.supported: supported: True ;
>17:52:23,169 DEBUG blivet:       DMRaidMember.__init__:
>17:52:23,170 DEBUG blivet:       MDRaidMember.__init__:
>16:52:48,029 INFO blivet: Detected 7952M of memory
>16:52:48,029 INFO blivet: Swap attempt of 7952M
>16:52:48,031 DEBUG blivet: clearpart: initializing sda
>16:52:48,032 DEBUG blivet: removing sda
>16:52:48,036 DEBUG blivet:            DeviceFormat.teardown: device: /dev/sda ; status: False ; type: None ;
>16:52:48,037 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>16:52:48,039 DEBUG blivet:             DiskDevice._setFormat: sda ; current: None ; type: None ;
>16:52:48,040 INFO blivet: registered action: [0] Destroy Format None on disk sda (id 1)
>16:52:48,042 DEBUG blivet:            DeviceFormat.teardown: device: /dev/sda ; status: False ; type: None ;
>16:52:48,042 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>16:52:48,045 DEBUG blivet:             DiskDevice._setFormat: sda ; current: None ; type: None ;
>16:52:48,045 INFO blivet: registered action: [1] Destroy Format None on disk sda (id 1)
>16:52:48,045 DEBUG blivet: required disklabel type for sda (1) is None
>16:52:48,045 DEBUG blivet: default disklabel type for sda is msdos
>16:52:48,046 DEBUG blivet: selecting msdos disklabel for sda based on size
>16:52:48,047 DEBUG blivet:            DiskLabel.__init__: device: /dev/sda ; labelType: msdos ;
>16:52:48,049 DEBUG blivet:               DiskLabel.freshPartedDisk: device: /dev/sda ; labelType: msdos ;
>16:52:48,050 DEBUG blivet: Did not change pmbr_boot on parted.Disk instance --
>  type: msdos  primaryPartitionCount: 0
>  lastPartitionNumber: -1  maxPrimaryPartitionCount: 4
>  partitions: []
>  device: <parted.device.Device object at 0x7fab7f509690>
>  PedDisk: <_ped.Disk object at 0x7fab7f4d2758>
>16:52:48,051 DEBUG blivet: getFormat('disklabel') returning DiskLabel instance
>16:52:48,053 DEBUG blivet:            DeviceFormat.teardown: device: /dev/sda ; status: False ; type: None ;
>16:52:48,056 DEBUG blivet:             DiskDevice._setFormat: sda ; current: None ; type: disklabel ;
>16:52:48,056 INFO blivet: registered action: [2] Create Format msdos disklabel on disk sda (id 1)
>16:52:48,057 DEBUG blivet: clearpart: initializing sdb
>16:52:48,057 DEBUG blivet: removing sdb
>16:52:48,059 DEBUG blivet:            DeviceFormat.teardown: device: /dev/sdb ; status: False ; type: None ;
>16:52:48,059 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>16:52:48,061 DEBUG blivet:             DiskDevice._setFormat: sdb ; current: None ; type: None ;
>16:52:48,061 INFO blivet: registered action: [3] Destroy Format None on disk sdb (id 2)
>16:52:48,062 DEBUG blivet:            DeviceFormat.teardown: device: /dev/sdb ; status: False ; type: None ;
>16:52:48,062 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>16:52:48,063 DEBUG blivet:             DiskDevice._setFormat: sdb ; current: None ; type: None ;
>16:52:48,064 INFO blivet: registered action: [4] Destroy Format None on disk sdb (id 2)
>16:52:48,064 DEBUG blivet: required disklabel type for sdb (1) is None
>16:52:48,064 DEBUG blivet: default disklabel type for sdb is msdos
>16:52:48,064 DEBUG blivet: selecting msdos disklabel for sdb based on size
>16:52:48,065 DEBUG blivet:            DiskLabel.__init__: device: /dev/sdb ; labelType: msdos ;
>16:52:48,066 DEBUG blivet:               DiskLabel.freshPartedDisk: device: /dev/sdb ; labelType: msdos ;
>16:52:48,067 DEBUG blivet: Did not change pmbr_boot on parted.Disk instance --
>  type: msdos  primaryPartitionCount: 0
>  lastPartitionNumber: -1  maxPrimaryPartitionCount: 4
>  partitions: []
>  device: <parted.device.Device object at 0x7fab84d5ead0>
>  PedDisk: <_ped.Disk object at 0x7fab7f498fc8>
>16:52:48,067 DEBUG blivet: getFormat('disklabel') returning DiskLabel instance
>16:52:48,068 DEBUG blivet:            DeviceFormat.teardown: device: /dev/sdb ; status: False ; type: None ;
>16:52:48,069 DEBUG blivet:             DiskDevice._setFormat: sdb ; current: None ; type: disklabel ;
>16:52:48,069 INFO blivet: registered action: [5] Create Format msdos disklabel on disk sdb (id 2)
>16:52:48,087 DEBUG blivet:         DeviceTree.getDeviceByName: name: sda ;
>16:52:48,088 DEBUG blivet:         DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:52:48,104 DEBUG blivet:          DeviceTree.getDeviceByName: name: sda ;
>16:52:48,105 DEBUG blivet:          DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:52:48,106 DEBUG blivet:          DeviceTree.getDeviceByName: name: sda ;
>16:52:48,107 DEBUG blivet:          DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:52:48,107 DEBUG blivet: resolved 'sda' to 'sda' (disk)
>16:52:48,162 DEBUG blivet: starting Blivet copy
>16:52:48,181 DEBUG blivet: finished Blivet copy
>16:52:48,182 INFO blivet: hiding device disk sdc (id 0)
>16:52:48,182 DEBUG blivet: lvm filter: adding sdc to the reject list
>16:52:57,956 DEBUG blivet: getFormat('appleboot') returning AppleBootstrapFS instance
>16:52:57,956 DEBUG blivet: getFormat('biosboot') returning BIOSBoot instance
>16:52:57,956 DEBUG blivet: getFormat('prepboot') returning PPCPRePBoot instance
>16:53:06,095 DEBUG storage.ui: doAutoPart: True
>16:53:06,095 DEBUG storage.ui: encryptedAutoPart: False
>16:53:06,095 DEBUG storage.ui: autoPartType: 2
>16:53:06,095 DEBUG storage.ui: clearPartType: 2
>16:53:06,095 DEBUG storage.ui: clearPartDisks: ['sda', 'sdb']
>16:53:06,096 DEBUG storage.ui: autoPartitionRequests:
>PartSpec instance (0x7fab84d75ed0) -- 
>  mountpoint = /  lv = True  singlePV = False  thin = True  btrfs = True
>  weight = 0  fstype = xfs  encrypted = True
>  size = 1024  maxSize = 51200  grow = True
>PartSpec instance (0x7fab84d75f10) -- 
>  mountpoint = /home  lv = True  singlePV = False  thin = True  btrfs = True
>  weight = 0  fstype = xfs  encrypted = True
>  size = 500  maxSize = None  grow = True
>PartSpec instance (0x7fab84d75f50) -- 
>  mountpoint = /boot  lv = False  singlePV = False  thin = False  btrfs = False
>  weight = 2000  fstype = xfs  encrypted = False
>  size = 500  maxSize = None  grow = False
>PartSpec instance (0x7fab84d75f90) -- 
>  mountpoint = None  lv = False  singlePV = False  thin = False  btrfs = False
>  weight = 5000  fstype = biosboot  encrypted = False
>  size = 1  maxSize = None  grow = False
>PartSpec instance (0x7fab84d75fd0) -- 
>  mountpoint = None  lv = True  singlePV = False  thin = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 7952  maxSize = None  grow = False
>
>16:53:06,096 DEBUG storage.ui: storage.disks: ['sda', 'sdb']
>16:53:06,096 DEBUG storage.ui: storage.partitioned: ['sda', 'sdb']
>16:53:06,096 DEBUG storage.ui: all names: ['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/install/repo/LiveOS/squashfs.img', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda', 'sdb']
>16:53:06,098 DEBUG storage.ui:              DeviceTree.getDeviceByName: name: sda ;
>16:53:06,099 DEBUG storage.ui:              DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,099 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:06,099 DEBUG storage.ui: boot disk: sda
>16:53:06,101 DEBUG storage.ui:               LVMPhysicalVolume.__init__: mountpoint: None ;
>16:53:06,101 DEBUG storage.ui: getFormat('lvmpv') returning LVMPhysicalVolume instance
>16:53:06,102 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sda ;
>16:53:06,103 DEBUG storage.ui:                 PartitionDevice._setFormat: req0 ;
>16:53:06,104 DEBUG storage.ui:                  PartitionDevice._setFormat: req0 ; current: None ; type: lvmpv ;
>16:53:06,105 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sda ;
>16:53:06,105 INFO storage.ui: added partition req0 (id 11) to device tree
>16:53:06,106 INFO storage.ui: registered action: [6] Create Device partition req0 (id 11)
>16:53:06,106 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:06,106 INFO storage.ui: registered action: [7] Create Format lvmpv on partition req0 (id 11)
>16:53:06,107 DEBUG storage.ui:               LVMPhysicalVolume.__init__: mountpoint: None ;
>16:53:06,107 DEBUG storage.ui: getFormat('lvmpv') returning LVMPhysicalVolume instance
>16:53:06,108 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:06,109 DEBUG storage.ui:                 PartitionDevice._setFormat: req1 ;
>16:53:06,110 DEBUG storage.ui:                  PartitionDevice._setFormat: req1 ; current: None ; type: lvmpv ;
>16:53:06,111 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:06,111 INFO storage.ui: added partition req1 (id 12) to device tree
>16:53:06,112 INFO storage.ui: registered action: [8] Create Device partition req1 (id 12)
>16:53:06,112 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:06,112 INFO storage.ui: registered action: [9] Create Format lvmpv on partition req1 (id 12)
>16:53:06,113 DEBUG storage.ui: candidate disks: [DiskDevice instance (0x7fab84d5ef50) --
>  name = sda  status = True  kids = 0 id = 1
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sda  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f685f0>
>  target size = 0  path = /dev/sda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab84d5ef10>, DiskDevice instance (0x7fab7f48f450) --
>  name = sdb  status = True  kids = 0 id = 2
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sdb  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f687a0>
>  target size = 0  path = /dev/sdb
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab7f48f510>]
>16:53:06,113 DEBUG storage.ui: devs: [PartitionDevice instance (0x7fab84d26290) --
>  name = req0  status = False  kids = 0 id = 11
>  parents = []
>  uuid = None  size = 500
>  format = non-existent lvmpv
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/req0
>  format args = []  originalFormat = lvmpv  grow = True  max size = 0  bootable = None
>  part type = None  primary = False  start sector = None  end sector = None
>  partedPartition = None
>  disk = None
>, PartitionDevice instance (0x7fab84d260d0) --
>  name = req1  status = False  kids = 0 id = 12
>  parents = []
>  uuid = None  size = 500
>  format = non-existent lvmpv
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/req1
>  format args = []  originalFormat = lvmpv  grow = True  max size = 0  bootable = None
>  part type = None  primary = False  start sector = None  end sector = None
>  partedPartition = None
>  disk = None
>]
>16:53:06,115 DEBUG storage.ui:                XFS.supported: supported: True ;
>16:53:06,115 DEBUG storage.ui: getFormat('xfs') returning XFS instance
>16:53:06,116 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sda ;
>16:53:06,117 DEBUG storage.ui:                 DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:06,118 DEBUG storage.ui:                 PartitionDevice._setFormat: req2 ;
>16:53:06,119 DEBUG storage.ui:                  PartitionDevice._setFormat: req2 ; current: None ; type: xfs ;
>16:53:06,120 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sda ;
>16:53:06,121 DEBUG storage.ui:               DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:06,121 INFO storage.ui: added partition req2 (id 13) to device tree
>16:53:06,122 INFO storage.ui: registered action: [10] Create Device partition req2 (id 13)
>16:53:06,122 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:06,122 INFO storage.ui: registered action: [11] Create Format xfs filesystem mounted at /boot on partition req2 (id 13)
>16:53:06,122 INFO storage.ui: skipping unneeded stage1 biosboot request
>16:53:06,122 DEBUG storage.ui: PartSpec instance (0x7fab84d75f90) -- 
>  mountpoint = None  lv = False  singlePV = False  thin = False  btrfs = False
>  weight = 5000  fstype = biosboot  encrypted = False
>  size = 1  maxSize = None  grow = False
>
>16:53:06,122 DEBUG storage.ui: existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,125 DEBUG storage.ui:             DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>16:53:06,126 DEBUG storage.ui:             DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>16:53:06,126 DEBUG storage.ui: removing all non-preexisting partitions ['req0(id 11)', 'req1(id 12)', 'req2(id 13)'] from disk(s) ['sda', 'sdb']
>16:53:06,127 DEBUG storage.ui: allocatePartitions: disks=['sda', 'sdb'] ; partitions=['req0(id 11)', 'req1(id 12)', 'req2(id 13)']
>16:53:06,127 DEBUG storage.ui: removing all non-preexisting partitions ['req2(id 13)', 'req0(id 11)', 'req1(id 12)'] from disk(s) ['sda', 'sdb']
>16:53:06,128 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>16:53:06,129 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,129 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:06,130 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>16:53:06,131 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,131 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:06,132 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>16:53:06,133 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,133 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:06,134 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>16:53:06,135 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,135 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:06,135 DEBUG storage.ui: allocating partition: req2 ; id: 13 ; disks: ['sda', 'sdb'] ;
>boot: True ; primary: False ; size: 500MB ; grow: False ; max_size: 0 ; start: None ; end: None
>16:53:06,135 DEBUG storage.ui: checking freespace on sda
>16:53:06,136 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=500MB boot=True best=None grow=False start=None
>16:53:06,136 DEBUG storage.ui: checking 63-1953525167 (953869 MB)
>16:53:06,136 DEBUG storage.ui: current free range is 63-1953525167 (953869MB)
>16:53:06,136 DEBUG storage.ui: updating use_disk to sda, type: 0
>16:53:06,136 DEBUG storage.ui: new free: 63-1953525167 / 953869MB
>16:53:06,136 DEBUG storage.ui: new free allows for 0 sectors of growth
>16:53:06,136 DEBUG storage.ui: found free space for bootable request
>16:53:06,137 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:06,137 DEBUG storage.ui: created partition sda1 of 500MB and added it to /dev/sda
>16:53:06,138 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req2 ;
>16:53:06,138 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84d26d10>  PedPartition: <_ped.Partition object at 0x7fab84d234d0>
>16:53:06,139 DEBUG storage.ui:               PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>16:53:06,140 DEBUG storage.ui:                DiskDevice.addChild: kids: 0 ; name: sda ;
>16:53:06,141 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda1 ;
>16:53:06,141 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84d26c10>  PedPartition: <_ped.Partition object at 0x7fab84d23470>
>16:53:06,142 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>16:53:06,143 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,143 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:06,144 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>16:53:06,145 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,145 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:06,146 DEBUG storage.ui: allocating partition: req0 ; id: 11 ; disks: ['sda'] ;
>boot: False ; primary: False ; size: 500MB ; grow: True ; max_size: 0 ; start: None ; end: None
>16:53:06,146 DEBUG storage.ui: checking freespace on sda
>16:53:06,146 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=500MB boot=False best=None grow=True start=None
>16:53:06,146 DEBUG storage.ui: checking 63-2047 (0 MB)
>16:53:06,146 DEBUG storage.ui: current free range is 63-2047 (0MB)
>16:53:06,146 DEBUG storage.ui: checking 1026048-1953525167 (953368 MB)
>16:53:06,147 DEBUG storage.ui: current free range is 1026048-1953525167 (953368MB)
>16:53:06,147 DEBUG storage.ui: evaluating growth potential for new layout
>16:53:06,147 DEBUG storage.ui: calculating growth for disk /dev/sdb
>16:53:06,147 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:06,147 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>16:53:06,147 DEBUG storage.ui: calculating growth for disk /dev/sda
>16:53:06,148 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req0 ;
>16:53:06,149 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84d2e150>  PedPartition: <_ped.Partition object at 0x7fab84d23530>
>16:53:06,149 DEBUG storage.ui:               PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>16:53:06,150 DEBUG storage.ui:                DiskDevice.addChild: kids: 1 ; name: sda ;
>16:53:06,150 DEBUG storage.ui: adding request 13 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:06,151 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:06,151 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:06,151 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>16:53:06,151 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda2  growable = True
>base = 1024000  growth = 0  max_grow = 4293943295
>done = False
>16:53:06,151 DEBUG storage.ui: 1 requests and 1951477105 (952869MB) left in chunk
>16:53:06,151 DEBUG storage.ui: adding 1951477105 (952869MB) to 11 (sda2)
>16:53:06,151 DEBUG storage.ui: new grow amount for request 11 (sda2) is 1951477105 units, or 952869MB
>16:53:06,151 DEBUG storage.ui: request 13 (sda1) growth: 0 (0MB) size: 500MB
>16:53:06,152 DEBUG storage.ui: request 11 (sda2) growth: 1951477105 (952869MB) size: 953369MB
>16:53:06,152 DEBUG storage.ui: disk /dev/sda growth: 1951477105 (952869MB)
>16:53:06,152 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda2 ;
>16:53:06,153 DEBUG storage.ui: device sda2 new partedPartition None
>16:53:06,153 DEBUG storage.ui:               PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>16:53:06,154 DEBUG storage.ui:                DiskDevice.removeChild: kids: 2 ; name: sda ;
>16:53:06,154 DEBUG storage.ui: total growth: 1951477105 sectors
>16:53:06,154 DEBUG storage.ui: updating use_disk to sda, type: 0
>16:53:06,155 DEBUG storage.ui: new free: 1026048-1953525167 / 953368MB
>16:53:06,155 DEBUG storage.ui: new free allows for 1951477105 sectors of growth
>16:53:06,155 DEBUG storage.ui: created partition sda2 of 500MB and added it to /dev/sda
>16:53:06,156 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req0 ;
>16:53:06,156 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84d2e350>  PedPartition: <_ped.Partition object at 0x7fab84d235f0>
>16:53:06,157 DEBUG storage.ui:               PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>16:53:06,158 DEBUG storage.ui:                DiskDevice.addChild: kids: 1 ; name: sda ;
>16:53:06,161 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda2 ;
>16:53:06,161 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84d2e3d0>  PedPartition: <_ped.Partition object at 0x7fab84d23590>
>16:53:06,162 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>16:53:06,163 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,163 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:06,164 DEBUG storage.ui:                DeviceTree.getDeviceByName: name: sda ;
>16:53:06,165 DEBUG storage.ui:                DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,165 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:06,165 DEBUG storage.ui: allocating partition: req1 ; id: 12 ; disks: ['sdb'] ;
>boot: False ; primary: False ; size: 500MB ; grow: True ; max_size: 0 ; start: None ; end: None
>16:53:06,165 DEBUG storage.ui: checking freespace on sdb
>16:53:06,165 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=500MB boot=False best=None grow=True start=None
>16:53:06,166 DEBUG storage.ui: checking 63-1953525167 (953869 MB)
>16:53:06,166 DEBUG storage.ui: current free range is 63-1953525167 (953869MB)
>16:53:06,166 DEBUG storage.ui: evaluating growth potential for new layout
>16:53:06,166 DEBUG storage.ui: calculating growth for disk /dev/sdb
>16:53:06,166 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:06,167 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req1 ;
>16:53:06,168 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab7f4cd750>  PedPartition: <_ped.Partition object at 0x7fab84d234d0>
>16:53:06,169 DEBUG storage.ui:               PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>16:53:06,169 DEBUG storage.ui:                DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:06,170 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:06,170 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:06,170 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sdb1  growable = True
>base = 1024000  growth = 0  max_grow = 4293943295
>done = False
>16:53:06,170 DEBUG storage.ui: 1 requests and 1952501105 (953369MB) left in chunk
>16:53:06,170 DEBUG storage.ui: adding 1952501105 (953369MB) to 12 (sdb1)
>16:53:06,170 DEBUG storage.ui: new grow amount for request 12 (sdb1) is 1952501105 units, or 953369MB
>16:53:06,170 DEBUG storage.ui: request 12 (sdb1) growth: 1952501105 (953369MB) size: 953869MB
>16:53:06,170 DEBUG storage.ui: disk /dev/sdb growth: 1952501105 (953369MB)
>16:53:06,170 DEBUG storage.ui: calculating growth for disk /dev/sda
>16:53:06,171 DEBUG storage.ui: adding request 13 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:06,171 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:06,171 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:06,171 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>16:53:06,171 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda2  growable = True
>base = 1024000  growth = 0  max_grow = 4293943295
>done = False
>16:53:06,171 DEBUG storage.ui: 1 requests and 1951477105 (952869MB) left in chunk
>16:53:06,171 DEBUG storage.ui: adding 1951477105 (952869MB) to 11 (sda2)
>16:53:06,171 DEBUG storage.ui: new grow amount for request 11 (sda2) is 1951477105 units, or 952869MB
>16:53:06,171 DEBUG storage.ui: request 13 (sda1) growth: 0 (0MB) size: 500MB
>16:53:06,172 DEBUG storage.ui: request 11 (sda2) growth: 1951477105 (952869MB) size: 953369MB
>16:53:06,172 DEBUG storage.ui: disk /dev/sda growth: 1951477105 (952869MB)
>16:53:06,172 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sdb1 ;
>16:53:06,173 DEBUG storage.ui: device sdb1 new partedPartition None
>16:53:06,173 DEBUG storage.ui:               PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>16:53:06,174 DEBUG storage.ui:                DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:06,174 DEBUG storage.ui: total growth: 3903978210 sectors
>16:53:06,174 DEBUG storage.ui: updating use_disk to sdb, type: 0
>16:53:06,174 DEBUG storage.ui: new free: 63-1953525167 / 953869MB
>16:53:06,175 DEBUG storage.ui: new free allows for 3903978210 sectors of growth
>16:53:06,175 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:06,175 DEBUG storage.ui: created partition sdb1 of 500MB and added it to /dev/sdb
>16:53:06,176 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req1 ;
>16:53:06,176 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab7f4cd650>  PedPartition: <_ped.Partition object at 0x7fab84d236b0>
>16:53:06,177 DEBUG storage.ui:               PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>16:53:06,178 DEBUG storage.ui:                DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:06,179 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sdb1 ;
>16:53:06,179 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84d26e10>  PedPartition: <_ped.Partition object at 0x7fab84d235f0>
>16:53:06,179 DEBUG storage.ui: growPartitions: disks=['sda', 'sdb'], partitions=['sda2(id 11)', 'sdb1(id 12)', 'sda1(id 13)']
>16:53:06,179 DEBUG storage.ui: growable partitions are ['sda2', 'sdb1']
>16:53:06,180 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:06,180 DEBUG storage.ui: adding request 13 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:06,180 DEBUG storage.ui: disk sda has 1 chunks
>16:53:06,180 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:06,180 DEBUG storage.ui: disk sdb has 1 chunks
>16:53:06,180 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:06,180 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>16:53:06,180 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda2  growable = True
>base = 1024000  growth = 0  max_grow = 4293943295
>done = False
>16:53:06,181 DEBUG storage.ui: 1 requests and 1951477105 (952869MB) left in chunk
>16:53:06,181 DEBUG storage.ui: adding 1951477105 (952869MB) to 11 (sda2)
>16:53:06,181 DEBUG storage.ui: new grow amount for request 11 (sda2) is 1951477105 units, or 952869MB
>16:53:06,181 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:06,181 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sdb1  growable = True
>base = 1024000  growth = 0  max_grow = 4293943295
>done = False
>16:53:06,181 DEBUG storage.ui: 1 requests and 1952501105 (953369MB) left in chunk
>16:53:06,181 DEBUG storage.ui: adding 1952501105 (953369MB) to 12 (sdb1)
>16:53:06,181 DEBUG storage.ui: new grow amount for request 12 (sdb1) is 1952501105 units, or 953369MB
>16:53:06,181 DEBUG storage.ui: growing partitions on sda
>16:53:06,182 DEBUG storage.ui: partition sda1 (13): 0
>16:53:06,182 DEBUG storage.ui: new geometry for sda1: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab7f4cd410>
>16:53:06,182 DEBUG storage.ui: partition sda2 (11): 0
>16:53:06,182 DEBUG storage.ui: new geometry for sda2: parted.Geometry instance --
>  start: 1026048  end: 1953523711  length: 1952497664
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab7f4cd110>
>16:53:06,182 DEBUG storage.ui: removing all non-preexisting partitions ['sda1(id 13)', 'sda2(id 11)'] from disk(s) ['sda']
>16:53:06,183 DEBUG storage.ui:                PartitionDevice._setPartedPartition: sda1 ;
>16:53:06,183 DEBUG storage.ui: device sda1 new partedPartition None
>16:53:06,184 DEBUG storage.ui:                PartitionDevice._setDisk: req2 ; new: None ; old: sda ;
>16:53:06,185 DEBUG storage.ui:                 DiskDevice.removeChild: kids: 2 ; name: sda ;
>16:53:06,186 DEBUG storage.ui:                PartitionDevice._setPartedPartition: sda2 ;
>16:53:06,186 DEBUG storage.ui: device sda2 new partedPartition None
>16:53:06,187 DEBUG storage.ui:                PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>16:53:06,188 DEBUG storage.ui:                 DiskDevice.removeChild: kids: 1 ; name: sda ;
>16:53:06,188 DEBUG storage.ui: back from removeNewPartitions
>16:53:06,188 DEBUG storage.ui: extended: None
>16:53:06,188 DEBUG storage.ui: setting req2 new geometry: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab7f4cd410>
>16:53:06,189 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req2 ;
>16:53:06,189 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab7f4cd1d0>  PedPartition: <_ped.Partition object at 0x7fab84d23650>
>16:53:06,190 DEBUG storage.ui:               PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>16:53:06,191 DEBUG storage.ui:                DiskDevice.addChild: kids: 0 ; name: sda ;
>16:53:06,192 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda1 ;
>16:53:06,192 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab804f1b90>  PedPartition: <_ped.Partition object at 0x7fab84d23710>
>16:53:06,192 DEBUG storage.ui: setting req0 new geometry: parted.Geometry instance --
>  start: 1026048  end: 1953523711  length: 1952497664
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab7f4cd110>
>16:53:06,193 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req0 ;
>16:53:06,193 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab7f4cd590>  PedPartition: <_ped.Partition object at 0x7fab84d23530>
>16:53:06,194 DEBUG storage.ui:               PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>16:53:06,195 DEBUG storage.ui:                DiskDevice.addChild: kids: 1 ; name: sda ;
>16:53:06,196 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sda2 ;
>16:53:06,196 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab804f1890>  PedPartition: <_ped.Partition object at 0x7fab84d23770>
>16:53:06,197 DEBUG storage.ui: growing partitions on sdb
>16:53:06,197 DEBUG storage.ui: partition sdb1 (12): 0
>16:53:06,197 DEBUG storage.ui: new geometry for sdb1: parted.Geometry instance --
>  start: 2048  end: 1953523711  length: 1953521664
>  device: <parted.device.Device object at 0x7fab7f48f5d0>  PedGeometry: <_ped.Geometry object at 0x7fab804f1e10>
>16:53:06,197 DEBUG storage.ui: removing all non-preexisting partitions ['sdb1(id 12)'] from disk(s) ['sdb']
>16:53:06,198 DEBUG storage.ui:                PartitionDevice._setPartedPartition: sdb1 ;
>16:53:06,198 DEBUG storage.ui: device sdb1 new partedPartition None
>16:53:06,199 DEBUG storage.ui:                PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>16:53:06,200 DEBUG storage.ui:                 DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:06,200 DEBUG storage.ui: back from removeNewPartitions
>16:53:06,200 DEBUG storage.ui: extended: None
>16:53:06,200 DEBUG storage.ui: setting req1 new geometry: parted.Geometry instance --
>  start: 2048  end: 1953523711  length: 1953521664
>  device: <parted.device.Device object at 0x7fab7f48f5d0>  PedGeometry: <_ped.Geometry object at 0x7fab804f1e10>
>16:53:06,201 DEBUG storage.ui:               PartitionDevice._setPartedPartition: req1 ;
>16:53:06,202 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab7f4cd210>  PedPartition: <_ped.Partition object at 0x7fab84d237d0>
>16:53:06,202 DEBUG storage.ui:               PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>16:53:06,203 DEBUG storage.ui:                DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:06,204 DEBUG storage.ui:               PartitionDevice._setPartedPartition: sdb1 ;
>16:53:06,204 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84d26b90>  PedPartition: <_ped.Partition object at 0x7fab84d23410>
>16:53:06,205 DEBUG storage.ui: fixing size of non-existent 500MB partition sda1 (13) with non-existent xfs filesystem mounted at /boot at 500.00
>16:53:06,205 DEBUG storage.ui: fixing size of non-existent 953368MB partition sda2 (11) with non-existent lvmpv at 953368.00
>16:53:06,205 DEBUG storage.ui: fixing size of non-existent 953868MB partition sdb1 (12) with non-existent lvmpv at 953868.00
>16:53:06,207 DEBUG storage.ui:                  PartitionDevice.addChild: kids: 0 ; name: sda2 ;
>16:53:06,208 DEBUG storage.ui:                  PartitionDevice.addChild: kids: 0 ; name: sdb1 ;
>16:53:06,208 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:06,209 DEBUG storage.ui:                  LVMVolumeGroupDevice._setFormat: rhel_sarkhan ; current: None ; type: None ;
>16:53:06,209 INFO storage.ui: added lvmvg rhel_sarkhan (id 14) to device tree
>16:53:06,209 INFO storage.ui: registered action: [12] Create Device lvmvg rhel_sarkhan (id 14)
>16:53:06,210 DEBUG storage.ui:                XFS.supported: supported: True ;
>16:53:06,211 DEBUG storage.ui: getFormat('xfs') returning XFS instance
>16:53:06,211 DEBUG storage.ui:                  LVMVolumeGroupDevice.addChild: kids: 0 ; name: rhel_sarkhan ;
>16:53:06,212 DEBUG storage.ui:                  LVMLogicalVolumeDevice._setFormat: rhel_sarkhan-root ; current: None ; type: xfs ;
>16:53:06,213 DEBUG storage.ui: rhel_sarkhan size is 1907228MB
>16:53:06,213 DEBUG storage.ui: vg rhel_sarkhan has 1907228MB free
>16:53:06,213 DEBUG storage.ui: Adding rhel_sarkhan-root/1024MB to rhel_sarkhan
>16:53:06,213 INFO storage.ui: added lvmlv rhel_sarkhan-root (id 15) to device tree
>16:53:06,213 INFO storage.ui: registered action: [13] Create Device lvmlv rhel_sarkhan-root (id 15)
>16:53:06,213 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:06,213 INFO storage.ui: registered action: [14] Create Format xfs filesystem mounted at / on lvmlv rhel_sarkhan-root (id 15)
>16:53:06,214 DEBUG storage.ui:                XFS.supported: supported: True ;
>16:53:06,215 DEBUG storage.ui: getFormat('xfs') returning XFS instance
>16:53:06,216 DEBUG storage.ui:                  LVMVolumeGroupDevice.addChild: kids: 1 ; name: rhel_sarkhan ;
>16:53:06,216 DEBUG storage.ui:                  LVMLogicalVolumeDevice._setFormat: rhel_sarkhan-home ; current: None ; type: xfs ;
>16:53:06,217 DEBUG storage.ui: rhel_sarkhan size is 1907228MB
>16:53:06,217 DEBUG storage.ui: vg rhel_sarkhan has 1906204MB free
>16:53:06,217 DEBUG storage.ui: Adding rhel_sarkhan-home/500MB to rhel_sarkhan
>16:53:06,217 INFO storage.ui: added lvmlv rhel_sarkhan-home (id 16) to device tree
>16:53:06,217 INFO storage.ui: registered action: [15] Create Device lvmlv rhel_sarkhan-home (id 16)
>16:53:06,217 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:06,218 INFO storage.ui: registered action: [16] Create Format xfs filesystem mounted at /home on lvmlv rhel_sarkhan-home (id 16)
>16:53:06,218 DEBUG storage.ui:               SwapSpace.__init__: mountpoint: None ;
>16:53:06,219 DEBUG storage.ui: getFormat('swap') returning SwapSpace instance
>16:53:06,219 DEBUG storage.ui:                  LVMVolumeGroupDevice.addChild: kids: 2 ; name: rhel_sarkhan ;
>16:53:06,220 DEBUG storage.ui:                  LVMLogicalVolumeDevice._setFormat: rhel_sarkhan-swap ; current: None ; type: swap ;
>16:53:06,221 DEBUG storage.ui: rhel_sarkhan size is 1907228MB
>16:53:06,221 DEBUG storage.ui: vg rhel_sarkhan has 1905704MB free
>16:53:06,221 DEBUG storage.ui: Adding rhel_sarkhan-swap/7952MB to rhel_sarkhan
>16:53:06,221 INFO storage.ui: added lvmlv rhel_sarkhan-swap (id 17) to device tree
>16:53:06,221 INFO storage.ui: registered action: [17] Create Device lvmlv rhel_sarkhan-swap (id 17)
>16:53:06,221 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:06,221 INFO storage.ui: registered action: [18] Create Format swap on lvmlv rhel_sarkhan-swap (id 17)
>16:53:06,222 DEBUG storage.ui: rhel_sarkhan size is 1907228MB
>16:53:06,222 DEBUG storage.ui: vg rhel_sarkhan has 1897752MB free
>16:53:06,222 DEBUG storage.ui: vg rhel_sarkhan: 1897752MB free ; lvs: ['root', 'home', 'swap']
>16:53:06,222 DEBUG storage.ui: adding request 15 to chunk 476807 on /dev/mapper/rhel_sarkhan
>16:53:06,222 DEBUG storage.ui: adding request 16 to chunk 476807 on /dev/mapper/rhel_sarkhan
>16:53:06,222 DEBUG storage.ui: adding request 17 to chunk 476807 on /dev/mapper/rhel_sarkhan
>16:53:06,223 DEBUG storage.ui: Chunk.growRequests: VGChunk instance --
>device = /dev/mapper/rhel_sarkhan  length = 476807  size = 1907228
>remaining = 2  pool = 474438
>16:53:06,223 DEBUG storage.ui: req: LVRequest instance --
>id = 17  name = rhel_sarkhan-swap  growable = False
>base = 1988  growth = 0  max_grow = 0
>done = True
>16:53:06,223 DEBUG storage.ui: req: LVRequest instance --
>id = 15  name = rhel_sarkhan-root  growable = True
>base = 256  growth = 0  max_grow = 12544
>done = False
>16:53:06,223 DEBUG storage.ui: req: LVRequest instance --
>id = 16  name = rhel_sarkhan-home  growable = True
>base = 125  growth = 0  max_grow = 4398046510979
>done = False
>16:53:06,223 DEBUG storage.ui: 2 requests and 474438 (1897752MB) left in chunk
>16:53:06,223 DEBUG storage.ui: adding 318782 (1275128MB) to 15 (rhel_sarkhan-root)
>16:53:06,223 DEBUG storage.ui: taking back 306238 (1224952MB) from 15 (rhel_sarkhan-root)
>16:53:06,223 DEBUG storage.ui: new grow amount for request 15 (rhel_sarkhan-root) is 12544 units, or 50176MB
>16:53:06,223 DEBUG storage.ui: adding 155655 (622620MB) to 16 (rhel_sarkhan-home)
>16:53:06,223 DEBUG storage.ui: new grow amount for request 16 (rhel_sarkhan-home) is 155655 units, or 622620MB
>16:53:06,223 DEBUG storage.ui: 1 requests and 306239 (1224956MB) left in chunk
>16:53:06,224 DEBUG storage.ui: adding 306239 (1224956MB) to 16 (rhel_sarkhan-home)
>16:53:06,224 DEBUG storage.ui: new grow amount for request 16 (rhel_sarkhan-home) is 461894 units, or 1847576MB
>16:53:06,224 DEBUG storage.ui: trying to set lv rhel_sarkhan-root size to 51200MB
>16:53:06,224 DEBUG storage.ui: rhel_sarkhan size is 1907228MB
>16:53:06,224 DEBUG storage.ui: vg rhel_sarkhan has 1897752MB free
>16:53:06,224 DEBUG storage.ui: trying to set lv rhel_sarkhan-home size to 1848076MB
>16:53:06,224 DEBUG storage.ui: rhel_sarkhan size is 1907228MB
>16:53:06,225 DEBUG storage.ui: vg rhel_sarkhan has 1847576MB free
>16:53:06,239 DEBUG storage.ui:              DeviceTree.getDeviceByName: name: sda ;
>16:53:06,240 DEBUG storage.ui:              DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,241 DEBUG storage.ui:              DeviceTree.getDeviceByName: name: sda ;
>16:53:06,242 DEBUG storage.ui:              DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:06,242 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:06,278 DEBUG blivet:                     XFS.supported: supported: True ;
>16:53:06,278 DEBUG blivet: getFormat('xfs') returning XFS instance
>16:53:08,938 DEBUG blivet:               XFS.supported: supported: True ;
>16:53:08,939 DEBUG blivet: getFormat('xfs') returning XFS instance
>16:53:08,940 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.PartitionFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 500, ['sda'], {'encrypted': False, 'raid_level': None}
>16:53:08,947 DEBUG blivet:               SwapSpace.__init__:
>16:53:08,948 DEBUG blivet: getFormat('swap') returning SwapSpace instance
>16:53:08,957 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.LVMFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 0, [], {}
>16:53:08,967 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.LVMFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 0, [], {}
>16:53:09,450 DEBUG blivet:              SwapSpace.__init__:
>16:53:09,450 DEBUG blivet: getFormat('swap') returning SwapSpace instance
>16:53:09,451 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.LVMFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 7952, ['sda', 'sdb'], {'encrypted': False, 'raid_level': None}
>16:53:09,451 DEBUG blivet: rhel_sarkhan size is 1907228MB
>16:53:09,451 DEBUG blivet: vg rhel_sarkhan has 0MB free
>16:53:09,458 DEBUG blivet:                XFS.supported: supported: True ;
>16:53:09,458 DEBUG blivet: getFormat('xfs') returning XFS instance
>16:53:09,463 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.LVMFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 0, [], {}
>16:53:09,473 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.LVMFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 0, [], {}
>16:53:15,827 DEBUG blivet:               XFS.supported: supported: True ;
>16:53:15,827 DEBUG blivet: getFormat('xfs') returning XFS instance
>16:53:15,830 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.MDFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 51200, ['sda', 'sdb'], {'encrypted': False, 'raid_level': 'raid1'}
>16:53:15,831 INFO storage.ui: removed lvmlv rhel_sarkhan-root (id 15) from device tree
>16:53:15,832 DEBUG storage.ui:                 LVMVolumeGroupDevice.removeChild: kids: 3 ; name: rhel_sarkhan ;
>16:53:15,833 INFO storage.ui: registered action: [19] Destroy Device lvmlv rhel_sarkhan-root (id 15)
>16:53:15,833 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.LVMFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 0, ['sda', 'sdb'], {'container_raid_level': None, 'container_encrypted': False, 'container_size': 0, 'container_name': 'rhel_sarkhan'}
>16:53:15,834 DEBUG storage.ui:              LVMFactory.configure: parent_factory: None ;
>16:53:15,834 DEBUG storage.ui: starting Blivet copy
>16:53:15,862 DEBUG storage.ui:                  PartitionDevice._setPartedPartition: sda1 ;
>16:53:15,863 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84ccd050>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd3190>  PedPartition: <_ped.Partition object at 0x7fab84d4b5f0>
>16:53:15,864 DEBUG storage.ui:                  PartitionDevice._setPartedPartition: sda2 ;
>16:53:15,864 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84ccd050>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd3310>  PedPartition: <_ped.Partition object at 0x7fab84d4b650>
>16:53:15,866 DEBUG storage.ui:                  PartitionDevice._setPartedPartition: sdb1 ;
>16:53:15,866 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84ccd690>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd3410>  PedPartition: <_ped.Partition object at 0x7fab84d4b6b0>
>16:53:15,866 DEBUG storage.ui: finished Blivet copy
>16:53:15,866 DEBUG storage.ui: rhel_sarkhan size is 1907228MB
>16:53:15,867 DEBUG storage.ui: vg rhel_sarkhan has 51200MB free
>16:53:15,867 DEBUG storage.ui: size bumped to 1856036 to include new device space
>16:53:15,867 DEBUG storage.ui: child factory class: <class 'blivet.devicefactory.PartitionSetFactory'>
>16:53:15,868 DEBUG storage.ui: child factory args: [<blivet.Blivet object at 0x7fab84d5eed0>, 1856036.0, [DiskDevice instance (0x7fab84d5ef50) --
>  name = sda  status = True  kids = 2 id = 1
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sda  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f685f0>
>  target size = 0  path = /dev/sda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab84d5ef10>, DiskDevice instance (0x7fab7f48f450) --
>  name = sdb  status = True  kids = 1 id = 2
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sdb  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f687a0>
>  target size = 0  path = /dev/sdb
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab7f48f510>]]
>16:53:15,868 DEBUG storage.ui: child factory kwargs: {'encrypted': False, 'fstype': 'lvmpv'}
>16:53:15,869 DEBUG storage.ui:                 PartitionSetFactory.configure: parent_factory: <blivet.devicefactory.LVMFactory object at 0x7fab84d7f410> ;
>16:53:15,869 DEBUG storage.ui: parent factory container: non-existent 1907228MB lvmvg rhel_sarkhan (14)
>16:53:15,870 DEBUG storage.ui: members: ['sda2', 'sdb1']
>16:53:15,870 DEBUG storage.ui: add_disks: []
>16:53:15,870 DEBUG storage.ui: remove_disks: []
>16:53:15,871 DEBUG storage.ui:                    LVMPhysicalVolume.__init__:
>16:53:15,871 DEBUG storage.ui: getFormat('lvmpv') returning LVMPhysicalVolume instance
>16:53:15,871 DEBUG storage.ui: rhel_sarkhan size is 1907228MB
>16:53:15,872 DEBUG storage.ui: vg rhel_sarkhan has 51200MB free
>16:53:15,872 DEBUG storage.ui: size bumped to 1856036 to include new device space
>16:53:15,872 DEBUG storage.ui: adding a TotalSizeSet with size 1856036
>16:53:15,872 DEBUG storage.ui: set.allocated = 16
>16:53:15,873 DEBUG storage.ui:                    DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>16:53:15,874 DEBUG storage.ui:                    DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>16:53:15,875 DEBUG storage.ui: removing all non-preexisting partitions ['sda1(id 13)', 'sda2(id 11)', 'sdb1(id 12)'] from disk(s) ['sda', 'sdb']
>16:53:15,876 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:15,876 DEBUG storage.ui: device sda1 new partedPartition None
>16:53:15,878 DEBUG storage.ui:                      PartitionDevice._setDisk: req2 ; new: None ; old: sda ;
>16:53:15,879 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 2 ; name: sda ;
>16:53:15,880 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda2 ;
>16:53:15,880 DEBUG storage.ui: device sda2 new partedPartition None
>16:53:15,881 DEBUG storage.ui:                      PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>16:53:15,882 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 1 ; name: sda ;
>16:53:15,884 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb1 ;
>16:53:15,884 DEBUG storage.ui: device sdb1 new partedPartition None
>16:53:15,885 DEBUG storage.ui:                      PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>16:53:15,886 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:15,886 DEBUG storage.ui: allocatePartitions: disks=['sda', 'sdb'] ; partitions=['req2(id 13)', 'req0(id 11)', 'req1(id 12)']
>16:53:15,887 DEBUG storage.ui: removing all non-preexisting partitions ['req2(id 13)', 'req0(id 11)', 'req1(id 12)'] from disk(s) ['sda', 'sdb']
>16:53:15,888 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:15,889 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:15,889 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:15,890 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:15,892 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:15,892 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:15,893 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:15,894 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:15,894 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:15,896 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:15,897 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:15,897 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:15,897 DEBUG storage.ui: allocating partition: req2 ; id: 13 ; disks: ['sda', 'sdb'] ;
>boot: True ; primary: False ; size: 500MB ; grow: False ; max_size: 0 ; start: None ; end: None
>16:53:15,897 DEBUG storage.ui: checking freespace on sda
>16:53:15,897 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=500MB boot=True best=None grow=False start=None
>16:53:15,898 DEBUG storage.ui: checking 63-1953525167 (953869 MB)
>16:53:15,898 DEBUG storage.ui: current free range is 63-1953525167 (953869MB)
>16:53:15,898 DEBUG storage.ui: updating use_disk to sda, type: 0
>16:53:15,898 DEBUG storage.ui: new free: 63-1953525167 / 953869MB
>16:53:15,898 DEBUG storage.ui: new free allows for 0 sectors of growth
>16:53:15,898 DEBUG storage.ui: found free space for bootable request
>16:53:15,898 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:15,899 DEBUG storage.ui: created partition sda1 of 500MB and added it to /dev/sda
>16:53:15,900 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req2 ;
>16:53:15,900 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd1f10>  PedPartition: <_ped.Partition object at 0x7fab84d23770>
>16:53:15,901 DEBUG storage.ui:                      PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>16:53:15,903 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sda ;
>16:53:15,904 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:15,904 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab804f17d0>  PedPartition: <_ped.Partition object at 0x7fab84d23470>
>16:53:15,905 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:15,906 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:15,907 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:15,908 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:15,909 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:15,909 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:15,909 DEBUG storage.ui: allocating partition: req0 ; id: 11 ; disks: ['sda'] ;
>boot: False ; primary: False ; size: 8MB ; grow: True ; max_size: 1856036.0 ; start: None ; end: None
>16:53:15,909 DEBUG storage.ui: checking freespace on sda
>16:53:15,909 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=8MB boot=False best=None grow=True start=None
>16:53:15,910 DEBUG storage.ui: checking 63-2047 (0 MB)
>16:53:15,910 DEBUG storage.ui: current free range is 63-2047 (0MB)
>16:53:15,910 DEBUG storage.ui: checking 1026048-1953525167 (953368 MB)
>16:53:15,910 DEBUG storage.ui: current free range is 1026048-1953525167 (953368MB)
>16:53:15,910 DEBUG storage.ui: evaluating growth potential for new layout
>16:53:15,910 DEBUG storage.ui: calculating growth for disk /dev/sdb
>16:53:15,910 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:15,910 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>16:53:15,911 DEBUG storage.ui: calculating growth for disk /dev/sda
>16:53:15,912 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req0 ;
>16:53:15,912 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd3b50>  PedPartition: <_ped.Partition object at 0x7fab84d23710>
>16:53:15,913 DEBUG storage.ui:                      PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>16:53:15,914 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sda ;
>16:53:15,915 DEBUG storage.ui: adding request 13 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:15,915 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:15,915 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:15,915 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>16:53:15,915 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda2  growable = True
>base = 16384  growth = 0  max_grow = 3801145344
>done = False
>16:53:15,915 DEBUG storage.ui: 1 requests and 1952484721 (953361MB) left in chunk
>16:53:15,915 DEBUG storage.ui: adding 1952484721 (953361MB) to 11 (sda2)
>16:53:15,915 DEBUG storage.ui: new grow amount for request 11 (sda2) is 1952484721 units, or 953361MB
>16:53:15,915 DEBUG storage.ui: request 13 (sda1) growth: 0 (0MB) size: 500MB
>16:53:15,916 DEBUG storage.ui: request 11 (sda2) growth: 1952484721 (953361MB) size: 953369MB
>16:53:15,916 DEBUG storage.ui: disk /dev/sda growth: 1952484721 (953361MB)
>16:53:15,917 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda2 ;
>16:53:15,917 DEBUG storage.ui: device sda2 new partedPartition None
>16:53:15,918 DEBUG storage.ui:                      PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>16:53:15,919 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 2 ; name: sda ;
>16:53:15,919 DEBUG storage.ui: total growth: 1952484721 sectors
>16:53:15,919 DEBUG storage.ui: updating use_disk to sda, type: 0
>16:53:15,919 DEBUG storage.ui: new free: 1026048-1953525167 / 953368MB
>16:53:15,919 DEBUG storage.ui: new free allows for 1952484721 sectors of growth
>16:53:15,920 DEBUG storage.ui: created partition sda2 of 8MB and added it to /dev/sda
>16:53:15,921 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req0 ;
>16:53:15,921 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd3ed0>  PedPartition: <_ped.Partition object at 0x7fab84d4b7d0>
>16:53:15,922 DEBUG storage.ui:                      PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>16:53:15,923 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sda ;
>16:53:15,925 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda2 ;
>16:53:15,925 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cde050>  PedPartition: <_ped.Partition object at 0x7fab84d4b770>
>16:53:15,926 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:15,927 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:15,927 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:15,929 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:15,930 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:15,930 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:15,930 DEBUG storage.ui: allocating partition: req1 ; id: 12 ; disks: ['sdb'] ;
>boot: False ; primary: False ; size: 8MB ; grow: True ; max_size: 1856036.0 ; start: None ; end: None
>16:53:15,930 DEBUG storage.ui: checking freespace on sdb
>16:53:15,931 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=8MB boot=False best=None grow=True start=None
>16:53:15,931 DEBUG storage.ui: checking 63-1953525167 (953869 MB)
>16:53:15,931 DEBUG storage.ui: current free range is 63-1953525167 (953869MB)
>16:53:15,931 DEBUG storage.ui: evaluating growth potential for new layout
>16:53:15,931 DEBUG storage.ui: calculating growth for disk /dev/sdb
>16:53:15,931 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:15,933 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req1 ;
>16:53:15,933 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd1e50>  PedPartition: <_ped.Partition object at 0x7fab84d23770>
>16:53:15,934 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>16:53:15,935 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:15,935 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:15,935 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:15,936 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sdb1  growable = True
>base = 16384  growth = 0  max_grow = 3801145344
>done = False
>16:53:15,936 DEBUG storage.ui: 1 requests and 1953508721 (953861MB) left in chunk
>16:53:15,936 DEBUG storage.ui: adding 1953508721 (953861MB) to 12 (sdb1)
>16:53:15,936 DEBUG storage.ui: new grow amount for request 12 (sdb1) is 1953508721 units, or 953861MB
>16:53:15,936 DEBUG storage.ui: request 12 (sdb1) growth: 1953508721 (953861MB) size: 953869MB
>16:53:15,936 DEBUG storage.ui: disk /dev/sdb growth: 1953508721 (953861MB)
>16:53:15,936 DEBUG storage.ui: calculating growth for disk /dev/sda
>16:53:15,936 DEBUG storage.ui: adding request 13 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:15,937 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:15,937 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:15,937 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>16:53:15,937 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda2  growable = True
>base = 16384  growth = 0  max_grow = 3801145344
>done = False
>16:53:15,937 DEBUG storage.ui: 1 requests and 1952484721 (953361MB) left in chunk
>16:53:15,937 DEBUG storage.ui: adding 1952484721 (953361MB) to 11 (sda2)
>16:53:15,937 DEBUG storage.ui: new grow amount for request 11 (sda2) is 1952484721 units, or 953361MB
>16:53:15,937 DEBUG storage.ui: request 13 (sda1) growth: 0 (0MB) size: 500MB
>16:53:15,937 DEBUG storage.ui: request 11 (sda2) growth: 1952484721 (953361MB) size: 953369MB
>16:53:15,937 DEBUG storage.ui: disk /dev/sda growth: 1952484721 (953361MB)
>16:53:15,939 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb1 ;
>16:53:15,939 DEBUG storage.ui: device sdb1 new partedPartition None
>16:53:15,940 DEBUG storage.ui:                      PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>16:53:15,941 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:15,941 DEBUG storage.ui: total growth: 3905993442 sectors
>16:53:15,941 DEBUG storage.ui: updating use_disk to sdb, type: 0
>16:53:15,941 DEBUG storage.ui: new free: 63-1953525167 / 953869MB
>16:53:15,941 DEBUG storage.ui: new free allows for 3905993442 sectors of growth
>16:53:15,941 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:15,942 DEBUG storage.ui: created partition sdb1 of 8MB and added it to /dev/sdb
>16:53:15,943 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req1 ;
>16:53:15,943 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab7f4cd1d0>  PedPartition: <_ped.Partition object at 0x7fab84d23710>
>16:53:15,944 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>16:53:15,945 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:15,947 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb1 ;
>16:53:15,947 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd3bd0>  PedPartition: <_ped.Partition object at 0x7fab84d23410>
>16:53:15,947 DEBUG storage.ui: growPartitions: disks=['sda', 'sdb'], partitions=['sda1(id 13)', 'sda2(id 11)', 'sdb1(id 12)']
>16:53:15,947 DEBUG storage.ui: growable partitions are ['sda2', 'sdb1']
>16:53:15,947 DEBUG storage.ui: adding request 13 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:15,948 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:15,948 DEBUG storage.ui: disk sda has 1 chunks
>16:53:15,948 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:15,948 DEBUG storage.ui: disk sdb has 1 chunks
>16:53:15,948 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:15,948 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>16:53:15,948 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda2  growable = True
>base = 16384  growth = 0  max_grow = 3801145344
>done = False
>16:53:15,948 DEBUG storage.ui: 1 requests and 1952484721 (953361MB) left in chunk
>16:53:15,948 DEBUG storage.ui: adding 1952484721 (953361MB) to 11 (sda2)
>16:53:15,949 DEBUG storage.ui: new grow amount for request 11 (sda2) is 1952484721 units, or 953361MB
>16:53:15,949 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:15,949 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sdb1  growable = True
>base = 16384  growth = 0  max_grow = 3801145344
>done = False
>16:53:15,949 DEBUG storage.ui: 1 requests and 1953508721 (953861MB) left in chunk
>16:53:15,949 DEBUG storage.ui: adding 1953508721 (953861MB) to 12 (sdb1)
>16:53:15,949 DEBUG storage.ui: new grow amount for request 12 (sdb1) is 1953508721 units, or 953861MB
>16:53:15,949 DEBUG storage.ui: set: ['sda2', 'sdb1'] 16/1856036
>16:53:15,949 DEBUG storage.ui: allocating 953361 to TotalSizeSet with 16/1856036 (1856020 needed)
>16:53:15,949 DEBUG storage.ui: allocating 953861 to TotalSizeSet with 953377/1856036 (902658 needed)
>16:53:15,949 DEBUG storage.ui: PartitionRequest instance --
>id = 12  name = sdb1  growable = True
>base = 16384  growth = 1953508721  max_grow = 3801145344
>done = False
>16:53:15,950 DEBUG storage.ui: needed: -51203
>16:53:15,950 DEBUG storage.ui: reclaim: PartitionRequest instance --
>id = 12  name = sdb1  growable = True
>base = 16384  growth = 1953508721  max_grow = 3801145344
>done = False 52432241 (25601 MB)
>16:53:15,950 DEBUG storage.ui: deallocating 25601 from TotalSizeSet with 1907239/1856036 (-51203 needed)
>16:53:15,950 DEBUG storage.ui: PartitionRequest instance --
>id = 11  name = sda2  growable = True
>base = 16384  growth = 1952484721  max_grow = 3801145344
>done = False
>16:53:15,950 DEBUG storage.ui: needed: -25601
>16:53:15,950 DEBUG storage.ui: reclaim: PartitionRequest instance --
>id = 11  name = sda2  growable = True
>base = 16384  growth = 1952484721  max_grow = 3801145344
>done = False 52432241 (25601 MB)
>16:53:15,950 DEBUG storage.ui: deallocating 25601 from TotalSizeSet with 1881637/1856036 (-25601 needed)
>16:53:15,950 DEBUG storage.ui: set: ['sda2', 'sdb1'] 1856036/1856036
>16:53:15,950 DEBUG storage.ui: allocating 0 to TotalSizeSet with 1856036/1856036 (0 needed)
>16:53:15,950 DEBUG storage.ui: allocating 0 to TotalSizeSet with 1856036/1856036 (0 needed)
>16:53:15,950 DEBUG storage.ui: PartitionRequest instance --
>id = 12  name = sdb1  growable = True
>base = 16384  growth = 1901076480  max_grow = 3801145344
>done = True
>16:53:15,951 DEBUG storage.ui: needed: 0
>16:53:15,951 DEBUG storage.ui: PartitionRequest instance --
>id = 11  name = sda2  growable = True
>base = 16384  growth = 1900052480  max_grow = 3801145344
>done = True
>16:53:15,951 DEBUG storage.ui: needed: 0
>16:53:15,951 DEBUG storage.ui: growing partitions on sda
>16:53:15,951 DEBUG storage.ui: partition sda1 (13): 0
>16:53:15,951 DEBUG storage.ui: new geometry for sda1: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab7f4cd350>
>16:53:15,951 DEBUG storage.ui: partition sda2 (11): 0
>16:53:15,951 DEBUG storage.ui: new geometry for sda2: parted.Geometry instance --
>  start: 1026048  end: 1901094911  length: 1900068864
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab804f1a90>
>16:53:15,952 DEBUG storage.ui: removing all non-preexisting partitions ['sda1(id 13)', 'sda2(id 11)'] from disk(s) ['sda']
>16:53:15,953 DEBUG storage.ui:                       PartitionDevice._setPartedPartition: sda1 ;
>16:53:15,953 DEBUG storage.ui: device sda1 new partedPartition None
>16:53:15,954 DEBUG storage.ui:                       PartitionDevice._setDisk: req2 ; new: None ; old: sda ;
>16:53:15,955 DEBUG storage.ui:                        DiskDevice.removeChild: kids: 2 ; name: sda ;
>16:53:15,956 DEBUG storage.ui:                       PartitionDevice._setPartedPartition: sda2 ;
>16:53:15,956 DEBUG storage.ui: device sda2 new partedPartition None
>16:53:15,957 DEBUG storage.ui:                       PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>16:53:15,959 DEBUG storage.ui:                        DiskDevice.removeChild: kids: 1 ; name: sda ;
>16:53:15,959 DEBUG storage.ui: back from removeNewPartitions
>16:53:15,959 DEBUG storage.ui: extended: None
>16:53:15,959 DEBUG storage.ui: setting req2 new geometry: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab7f4cd350>
>16:53:15,960 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req2 ;
>16:53:15,960 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cde450>  PedPartition: <_ped.Partition object at 0x7fab84d4b7d0>
>16:53:15,961 DEBUG storage.ui:                      PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>16:53:15,963 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sda ;
>16:53:15,964 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:15,964 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cde650>  PedPartition: <_ped.Partition object at 0x7fab84d4b890>
>16:53:15,964 DEBUG storage.ui: setting req0 new geometry: parted.Geometry instance --
>  start: 1026048  end: 1901094911  length: 1900068864
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab804f1a90>
>16:53:15,965 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req0 ;
>16:53:15,966 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cde1d0>  PedPartition: <_ped.Partition object at 0x7fab84d4b830>
>16:53:15,967 DEBUG storage.ui:                      PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>16:53:15,968 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sda ;
>16:53:15,969 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda2 ;
>16:53:15,970 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cde950>  PedPartition: <_ped.Partition object at 0x7fab84d4b770>
>16:53:15,970 DEBUG storage.ui: growing partitions on sdb
>16:53:15,970 DEBUG storage.ui: partition sdb1 (12): 0
>16:53:15,970 DEBUG storage.ui: new geometry for sdb1: parted.Geometry instance --
>  start: 2048  end: 1901094911  length: 1901092864
>  device: <parted.device.Device object at 0x7fab7f48f5d0>  PedGeometry: <_ped.Geometry object at 0x7fab804f1dd0>
>16:53:15,970 DEBUG storage.ui: removing all non-preexisting partitions ['sdb1(id 12)'] from disk(s) ['sdb']
>16:53:15,972 DEBUG storage.ui:                       PartitionDevice._setPartedPartition: sdb1 ;
>16:53:15,972 DEBUG storage.ui: device sdb1 new partedPartition None
>16:53:15,973 DEBUG storage.ui:                       PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>16:53:15,974 DEBUG storage.ui:                        DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:15,974 DEBUG storage.ui: back from removeNewPartitions
>16:53:15,974 DEBUG storage.ui: extended: None
>16:53:15,974 DEBUG storage.ui: setting req1 new geometry: parted.Geometry instance --
>  start: 2048  end: 1901094911  length: 1901092864
>  device: <parted.device.Device object at 0x7fab7f48f5d0>  PedGeometry: <_ped.Geometry object at 0x7fab804f1dd0>
>16:53:15,975 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req1 ;
>16:53:15,976 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84ccec90>  PedPartition: <_ped.Partition object at 0x7fab84d4b7d0>
>16:53:15,977 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>16:53:15,978 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:15,979 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb1 ;
>16:53:15,979 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd3fd0>  PedPartition: <_ped.Partition object at 0x7fab84d4b710>
>16:53:15,980 DEBUG storage.ui: fixing size of non-existent 500MB partition sda1 (13) with non-existent xfs filesystem mounted at /boot at 500.00
>16:53:15,980 DEBUG storage.ui: fixing size of non-existent 927768MB partition sda2 (11) with non-existent lvmpv at 927768.00
>16:53:15,980 DEBUG storage.ui: fixing size of non-existent 928268MB partition sdb1 (12) with non-existent lvmpv at 928268.00
>16:53:15,981 DEBUG storage.ui: new member set: ['sda2', 'sdb1']
>16:53:15,981 DEBUG storage.ui: old member set: ['sda2', 'sdb1']
>16:53:15,982 DEBUG storage.ui:              Blivet.factoryDevice: 1 ; 51200 ; container_raid_level: None ; name: root ; encrypted: False ; container_encrypted: False ; disks: [DiskDevice instance (0x7fab84d5ef50) --
>  name = sda  status = True  kids = 2 id = 1
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sda  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f685f0>
>  target size = 0  path = /dev/sda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab84d5ef10>, DiskDevice instance (0x7fab7f48f450) --
>  name = sdb  status = True  kids = 1 id = 2
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sdb  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f687a0>
>  target size = 0  path = /dev/sdb
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab7f48f510>] ; raid_level: raid1 ; label:  ; container_name: rhel_sarkhan ; device: None ; mountpoint: / ; fstype: xfs ; container_size: 0 ;
>16:53:15,983 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.MDFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 51200, ['sda', 'sdb'], {'container_raid_level': None, 'name': 'root', 'encrypted': False, 'container_encrypted': False, 'raid_level': 'raid1', 'label': '', 'container_name': 'rhel_sarkhan', 'device': None, 'mountpoint': '/', 'fstype': 'xfs', 'container_size': 0}
>16:53:15,983 DEBUG storage.ui:               MDFactory.configure: parent_factory: None ;
>16:53:15,983 DEBUG storage.ui: starting Blivet copy
>16:53:16,004 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda1 ;
>16:53:16,005 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cde110>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cef510>  PedPartition: <_ped.Partition object at 0x7fab84d23410>
>16:53:16,006 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda2 ;
>16:53:16,006 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cde110>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cef690>  PedPartition: <_ped.Partition object at 0x7fab84d4b8f0>
>16:53:16,007 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sdb1 ;
>16:53:16,007 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cdec50>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cef790>  PedPartition: <_ped.Partition object at 0x7fab84d4b950>
>16:53:16,008 DEBUG storage.ui: finished Blivet copy
>16:53:16,008 INFO storage.ui: Using 32MB superBlockSize
>16:53:16,008 DEBUG storage.ui: child factory class: <class 'blivet.devicefactory.PartitionSetFactory'>
>16:53:16,009 DEBUG storage.ui: child factory args: [<blivet.Blivet object at 0x7fab84d5eed0>, 102464, [DiskDevice instance (0x7fab84d5ef50) --
>  name = sda  status = True  kids = 2 id = 1
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sda  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f685f0>
>  target size = 0  path = /dev/sda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab84d5ef10>, DiskDevice instance (0x7fab7f48f450) --
>  name = sdb  status = True  kids = 1 id = 2
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sdb  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f687a0>
>  target size = 0  path = /dev/sdb
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab7f48f510>]]
>16:53:16,009 DEBUG storage.ui: child factory kwargs: {'fstype': 'mdmember'}
>16:53:16,010 DEBUG storage.ui:                 PartitionSetFactory.configure: parent_factory: <blivet.devicefactory.MDFactory object at 0x7fab804fd250> ;
>16:53:16,010 DEBUG storage.ui: parent factory container: None
>16:53:16,010 DEBUG storage.ui: members: []
>16:53:16,010 DEBUG storage.ui: add_disks: ['sda', 'sdb']
>16:53:16,011 DEBUG storage.ui: remove_disks: []
>16:53:16,012 DEBUG storage.ui:                    MDRaidMember.__init__:
>16:53:16,012 DEBUG storage.ui: getFormat('mdmember') returning MDRaidMember instance
>16:53:16,013 DEBUG storage.ui:                    MDRaidMember.__init__: mountpoint: None ;
>16:53:16,013 DEBUG storage.ui: getFormat('mdmember') returning MDRaidMember instance
>16:53:16,014 DEBUG storage.ui:                      DiskDevice.addChild: kids: 2 ; name: sda ;
>16:53:16,015 DEBUG storage.ui:                      PartitionDevice._setFormat: req3 ;
>16:53:16,016 DEBUG storage.ui:                       PartitionDevice._setFormat: req3 ; current: None ; type: mdmember ;
>16:53:16,017 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 3 ; name: sda ;
>16:53:16,017 INFO storage.ui: added partition req3 (id 18) to device tree
>16:53:16,017 INFO storage.ui: registered action: [20] Create Device partition req3 (id 18)
>16:53:16,018 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:16,018 INFO storage.ui: registered action: [21] Create Format mdmember on partition req3 (id 18)
>16:53:16,019 DEBUG storage.ui:                    MDRaidMember.__init__: mountpoint: None ;
>16:53:16,019 DEBUG storage.ui: getFormat('mdmember') returning MDRaidMember instance
>16:53:16,020 DEBUG storage.ui:                      DiskDevice.addChild: kids: 1 ; name: sdb ;
>16:53:16,021 DEBUG storage.ui:                      PartitionDevice._setFormat: req4 ;
>16:53:16,022 DEBUG storage.ui:                       PartitionDevice._setFormat: req4 ; current: None ; type: mdmember ;
>16:53:16,023 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 2 ; name: sdb ;
>16:53:16,023 INFO storage.ui: added partition req4 (id 19) to device tree
>16:53:16,023 INFO storage.ui: registered action: [22] Create Device partition req4 (id 19)
>16:53:16,023 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:16,023 INFO storage.ui: registered action: [23] Create Format mdmember on partition req4 (id 19)
>16:53:16,024 INFO storage.ui: Using 32MB superBlockSize
>16:53:16,024 DEBUG storage.ui: adding a SameSizeSet with size 102464
>16:53:16,025 DEBUG storage.ui:                    DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>16:53:16,026 DEBUG storage.ui:                    DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>16:53:16,027 DEBUG storage.ui: removing all non-preexisting partitions ['req3(id 18)', 'req4(id 19)', 'sda1(id 13)', 'sda2(id 11)', 'sdb1(id 12)'] from disk(s) ['sda', 'sdb']
>16:53:16,028 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:16,028 DEBUG storage.ui: device sda1 new partedPartition None
>16:53:16,029 DEBUG storage.ui:                      PartitionDevice._setDisk: req2 ; new: None ; old: sda ;
>16:53:16,032 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 2 ; name: sda ;
>16:53:16,033 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda2 ;
>16:53:16,033 DEBUG storage.ui: device sda2 new partedPartition None
>16:53:16,034 DEBUG storage.ui:                      PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>16:53:16,035 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 1 ; name: sda ;
>16:53:16,036 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb1 ;
>16:53:16,036 DEBUG storage.ui: device sdb1 new partedPartition None
>16:53:16,037 DEBUG storage.ui:                      PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>16:53:16,039 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:16,039 DEBUG storage.ui: allocatePartitions: disks=['sda', 'sdb'] ; partitions=['req3(id 18)', 'req4(id 19)', 'req2(id 13)', 'req0(id 11)', 'req1(id 12)']
>16:53:16,039 DEBUG storage.ui: removing all non-preexisting partitions ['req2(id 13)', 'req1(id 12)', 'req0(id 11)', 'req3(id 18)', 'req4(id 19)'] from disk(s) ['sda', 'sdb']
>16:53:16,040 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,041 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,041 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,043 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,044 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,044 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,045 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,046 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,046 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,047 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,048 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,048 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,049 DEBUG storage.ui: allocating partition: req2 ; id: 13 ; disks: ['sda', 'sdb'] ;
>boot: True ; primary: False ; size: 500MB ; grow: False ; max_size: 0 ; start: None ; end: None
>16:53:16,049 DEBUG storage.ui: checking freespace on sda
>16:53:16,049 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=500MB boot=True best=None grow=False start=None
>16:53:16,049 DEBUG storage.ui: checking 63-1953525167 (953869 MB)
>16:53:16,050 DEBUG storage.ui: current free range is 63-1953525167 (953869MB)
>16:53:16,050 DEBUG storage.ui: updating use_disk to sda, type: 0
>16:53:16,050 DEBUG storage.ui: new free: 63-1953525167 / 953869MB
>16:53:16,050 DEBUG storage.ui: new free allows for 0 sectors of growth
>16:53:16,050 DEBUG storage.ui: found free space for bootable request
>16:53:16,050 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:16,051 DEBUG storage.ui: created partition sda1 of 500MB and added it to /dev/sda
>16:53:16,052 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req2 ;
>16:53:16,052 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd9310>  PedPartition: <_ped.Partition object at 0x7fab84d23770>
>16:53:16,053 DEBUG storage.ui:                      PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>16:53:16,054 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sda ;
>16:53:16,055 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:16,056 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd9450>  PedPartition: <_ped.Partition object at 0x7fab84d23470>
>16:53:16,057 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,058 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,058 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,059 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,060 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,060 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,061 DEBUG storage.ui: allocating partition: req1 ; id: 12 ; disks: ['sdb'] ;
>boot: False ; primary: False ; size: 928268MB ; grow: False ; max_size: 1856036.0 ; start: None ; end: None
>16:53:16,061 DEBUG storage.ui: checking freespace on sdb
>16:53:16,061 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=928268MB boot=False best=None grow=False start=None
>16:53:16,061 DEBUG storage.ui: checking 63-1953525167 (953869 MB)
>16:53:16,061 DEBUG storage.ui: current free range is 63-1953525167 (953869MB)
>16:53:16,062 DEBUG storage.ui: updating use_disk to sdb, type: 0
>16:53:16,062 DEBUG storage.ui: new free: 63-1953525167 / 953869MB
>16:53:16,062 DEBUG storage.ui: new free allows for 0 sectors of growth
>16:53:16,062 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:16,062 DEBUG storage.ui: created partition sdb1 of 928268MB and added it to /dev/sdb
>16:53:16,063 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req1 ;
>16:53:16,064 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84d26f50>  PedPartition: <_ped.Partition object at 0x7fab84d23710>
>16:53:16,065 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>16:53:16,066 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:16,067 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb1 ;
>16:53:16,067 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84d26cd0>  PedPartition: <_ped.Partition object at 0x7fab84d4b710>
>16:53:16,069 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,070 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,070 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,071 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,072 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,072 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,072 DEBUG storage.ui: allocating partition: req0 ; id: 11 ; disks: ['sda'] ;
>boot: False ; primary: False ; size: 927768MB ; grow: False ; max_size: 1856036.0 ; start: None ; end: None
>16:53:16,073 DEBUG storage.ui: checking freespace on sda
>16:53:16,073 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=927768MB boot=False best=None grow=False start=None
>16:53:16,073 DEBUG storage.ui: checking 63-2047 (0 MB)
>16:53:16,073 DEBUG storage.ui: current free range is 63-2047 (0MB)
>16:53:16,073 DEBUG storage.ui: checking 1026048-1953525167 (953368 MB)
>16:53:16,074 DEBUG storage.ui: current free range is 1026048-1953525167 (953368MB)
>16:53:16,074 DEBUG storage.ui: updating use_disk to sda, type: 0
>16:53:16,074 DEBUG storage.ui: new free: 1026048-1953525167 / 953368MB
>16:53:16,074 DEBUG storage.ui: new free allows for 0 sectors of growth
>16:53:16,074 DEBUG storage.ui: created partition sda2 of 927768MB and added it to /dev/sda
>16:53:16,075 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req0 ;
>16:53:16,076 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd9510>  PedPartition: <_ped.Partition object at 0x7fab84d23770>
>16:53:16,077 DEBUG storage.ui:                      PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>16:53:16,078 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sda ;
>16:53:16,079 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda2 ;
>16:53:16,080 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd9250>  PedPartition: <_ped.Partition object at 0x7fab84d4b770>
>16:53:16,081 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,082 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,082 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,083 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,084 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,084 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,084 DEBUG storage.ui: allocating partition: req3 ; id: 18 ; disks: ['sda'] ;
>boot: False ; primary: False ; size: 1MB ; grow: True ; max_size: 51232 ; start: None ; end: None
>16:53:16,084 DEBUG storage.ui: checking freespace on sda
>16:53:16,085 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=1MB boot=False best=None grow=True start=None
>16:53:16,085 DEBUG storage.ui: checking 63-2047 (0 MB)
>16:53:16,085 DEBUG storage.ui: current free range is 63-2047 (0MB)
>16:53:16,085 DEBUG storage.ui: checking 1901094912-1953525167 (25600 MB)
>16:53:16,085 DEBUG storage.ui: current free range is 1901094912-1953525167 (25600MB)
>16:53:16,086 DEBUG storage.ui: evaluating growth potential for new layout
>16:53:16,086 DEBUG storage.ui: calculating growth for disk /dev/sdb
>16:53:16,086 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:16,086 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:16,086 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sdb1  growable = False
>base = 1901092864  growth = 0  max_grow = 0
>done = True
>16:53:16,086 DEBUG storage.ui: request 12 (sdb1) growth: 0 (0MB) size: 928268MB
>16:53:16,086 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>16:53:16,086 DEBUG storage.ui: calculating growth for disk /dev/sda
>16:53:16,088 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req3 ;
>16:53:16,088 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84ccf410>  PedPartition: <_ped.Partition object at 0x7fab84d4b830>
>16:53:16,089 DEBUG storage.ui:                      PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>16:53:16,090 DEBUG storage.ui:                       DiskDevice.addChild: kids: 2 ; name: sda ;
>16:53:16,090 DEBUG storage.ui: adding request 13 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:16,091 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:16,091 DEBUG storage.ui: adding request 18 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:16,091 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:16,091 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>16:53:16,091 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda2  growable = False
>base = 1900068864  growth = 0  max_grow = 0
>done = True
>16:53:16,091 DEBUG storage.ui: req: PartitionRequest instance --
>id = 18  name = sda3  growable = True
>base = 2048  growth = 0  max_grow = 104921088
>done = False
>16:53:16,091 DEBUG storage.ui: 1 requests and 52430193 (25600MB) left in chunk
>16:53:16,091 DEBUG storage.ui: adding 52430193 (25600MB) to 18 (sda3)
>16:53:16,092 DEBUG storage.ui: new grow amount for request 18 (sda3) is 52430193 units, or 25600MB
>16:53:16,092 DEBUG storage.ui: request 13 (sda1) growth: 0 (0MB) size: 500MB
>16:53:16,092 DEBUG storage.ui: request 11 (sda2) growth: 0 (0MB) size: 927768MB
>16:53:16,092 DEBUG storage.ui: request 18 (sda3) growth: 52430193 (25600MB) size: 25601MB
>16:53:16,092 DEBUG storage.ui: disk /dev/sda growth: 52430193 (25600MB)
>16:53:16,093 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda3 ;
>16:53:16,093 DEBUG storage.ui: device sda3 new partedPartition None
>16:53:16,094 DEBUG storage.ui:                      PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>16:53:16,095 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 3 ; name: sda ;
>16:53:16,095 DEBUG storage.ui: total growth: 52430193 sectors
>16:53:16,096 DEBUG storage.ui: updating use_disk to sda, type: 0
>16:53:16,096 DEBUG storage.ui: new free: 1901094912-1953525167 / 25600MB
>16:53:16,096 DEBUG storage.ui: new free allows for 52430193 sectors of growth
>16:53:16,096 DEBUG storage.ui: created partition sda3 of 1MB and added it to /dev/sda
>16:53:16,097 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req3 ;
>16:53:16,098 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84ccf6d0>  PedPartition: <_ped.Partition object at 0x7fab84d4b7d0>
>16:53:16,099 DEBUG storage.ui:                      PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>16:53:16,100 DEBUG storage.ui:                       DiskDevice.addChild: kids: 2 ; name: sda ;
>16:53:16,101 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda3 ;
>16:53:16,101 DEBUG storage.ui: device sda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84ccf590>  PedPartition: <_ped.Partition object at 0x7fab84d4b5f0>
>16:53:16,103 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,104 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,104 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,105 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:16,106 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:16,106 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:16,106 DEBUG storage.ui: allocating partition: req4 ; id: 19 ; disks: ['sdb'] ;
>boot: False ; primary: False ; size: 1MB ; grow: True ; max_size: 51232 ; start: None ; end: None
>16:53:16,106 DEBUG storage.ui: checking freespace on sdb
>16:53:16,107 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=1MB boot=False best=None grow=True start=None
>16:53:16,107 DEBUG storage.ui: checking 63-2047 (0 MB)
>16:53:16,107 DEBUG storage.ui: current free range is 63-2047 (0MB)
>16:53:16,107 DEBUG storage.ui: checking 1901094912-1953525167 (25600 MB)
>16:53:16,107 DEBUG storage.ui: current free range is 1901094912-1953525167 (25600MB)
>16:53:16,107 DEBUG storage.ui: evaluating growth potential for new layout
>16:53:16,108 DEBUG storage.ui: calculating growth for disk /dev/sdb
>16:53:16,109 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req4 ;
>16:53:16,109 DEBUG storage.ui: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 2  path: /dev/sdb2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd19d0>  PedPartition: <_ped.Partition object at 0x7fab84d23710>
>16:53:16,110 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb2 ; new: sdb ; old: None ;
>16:53:16,112 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sdb ;
>16:53:16,112 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:16,112 DEBUG storage.ui: adding request 19 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:16,112 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:16,112 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sdb1  growable = False
>base = 1901092864  growth = 0  max_grow = 0
>done = True
>16:53:16,112 DEBUG storage.ui: req: PartitionRequest instance --
>id = 19  name = sdb2  growable = True
>base = 2048  growth = 0  max_grow = 104921088
>done = False
>16:53:16,112 DEBUG storage.ui: 1 requests and 52430193 (25600MB) left in chunk
>16:53:16,112 DEBUG storage.ui: adding 52430193 (25600MB) to 19 (sdb2)
>16:53:16,113 DEBUG storage.ui: new grow amount for request 19 (sdb2) is 52430193 units, or 25600MB
>16:53:16,113 DEBUG storage.ui: request 12 (sdb1) growth: 0 (0MB) size: 928268MB
>16:53:16,113 DEBUG storage.ui: request 19 (sdb2) growth: 52430193 (25600MB) size: 25601MB
>16:53:16,113 DEBUG storage.ui: disk /dev/sdb growth: 52430193 (25600MB)
>16:53:16,113 DEBUG storage.ui: calculating growth for disk /dev/sda
>16:53:16,113 DEBUG storage.ui: adding request 13 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:16,113 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:16,113 DEBUG storage.ui: adding request 18 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:16,114 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:16,114 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>16:53:16,114 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda2  growable = False
>base = 1900068864  growth = 0  max_grow = 0
>done = True
>16:53:16,114 DEBUG storage.ui: req: PartitionRequest instance --
>id = 18  name = sda3  growable = True
>base = 2048  growth = 0  max_grow = 104921088
>done = False
>16:53:16,114 DEBUG storage.ui: 1 requests and 52430193 (25600MB) left in chunk
>16:53:16,114 DEBUG storage.ui: adding 52430193 (25600MB) to 18 (sda3)
>16:53:16,114 DEBUG storage.ui: new grow amount for request 18 (sda3) is 52430193 units, or 25600MB
>16:53:16,114 DEBUG storage.ui: request 13 (sda1) growth: 0 (0MB) size: 500MB
>16:53:16,114 DEBUG storage.ui: request 11 (sda2) growth: 0 (0MB) size: 927768MB
>16:53:16,114 DEBUG storage.ui: request 18 (sda3) growth: 52430193 (25600MB) size: 25601MB
>16:53:16,114 DEBUG storage.ui: disk /dev/sda growth: 52430193 (25600MB)
>16:53:16,116 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb2 ;
>16:53:16,116 DEBUG storage.ui: device sdb2 new partedPartition None
>16:53:16,117 DEBUG storage.ui:                      PartitionDevice._setDisk: req4 ; new: None ; old: sdb ;
>16:53:16,118 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 2 ; name: sdb ;
>16:53:16,118 DEBUG storage.ui: total growth: 104860386 sectors
>16:53:16,118 DEBUG storage.ui: updating use_disk to sdb, type: 0
>16:53:16,118 DEBUG storage.ui: new free: 1901094912-1953525167 / 25600MB
>16:53:16,118 DEBUG storage.ui: new free allows for 104860386 sectors of growth
>16:53:16,119 DEBUG storage.ui: created partition sdb2 of 1MB and added it to /dev/sdb
>16:53:16,120 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req4 ;
>16:53:16,120 DEBUG storage.ui: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 2  path: /dev/sdb2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd9310>  PedPartition: <_ped.Partition object at 0x7fab84d23770>
>16:53:16,121 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb2 ; new: sdb ; old: None ;
>16:53:16,122 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sdb ;
>16:53:16,124 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb2 ;
>16:53:16,124 DEBUG storage.ui: device sdb2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 2  path: /dev/sdb2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd9810>  PedPartition: <_ped.Partition object at 0x7fab84d4b890>
>16:53:16,124 DEBUG storage.ui: growPartitions: disks=['sda', 'sdb'], partitions=['sda3(id 18)', 'sdb2(id 19)', 'sda1(id 13)', 'sda2(id 11)', 'sdb1(id 12)']
>16:53:16,124 DEBUG storage.ui: growable partitions are ['sda3', 'sdb2']
>16:53:16,124 DEBUG storage.ui: adding request 18 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:16,124 DEBUG storage.ui: adding request 13 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:16,125 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:16,125 DEBUG storage.ui: disk sda has 1 chunks
>16:53:16,125 DEBUG storage.ui: adding request 19 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:16,125 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:16,125 DEBUG storage.ui: disk sdb has 1 chunks
>16:53:16,125 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:16,125 DEBUG storage.ui: req: PartitionRequest instance --
>id = 13  name = sda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>16:53:16,125 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda2  growable = False
>base = 1900068864  growth = 0  max_grow = 0
>done = True
>16:53:16,125 DEBUG storage.ui: req: PartitionRequest instance --
>id = 18  name = sda3  growable = True
>base = 2048  growth = 0  max_grow = 104921088
>done = False
>16:53:16,126 DEBUG storage.ui: 1 requests and 52430193 (25600MB) left in chunk
>16:53:16,126 DEBUG storage.ui: adding 52430193 (25600MB) to 18 (sda3)
>16:53:16,126 DEBUG storage.ui: new grow amount for request 18 (sda3) is 52430193 units, or 25600MB
>16:53:16,126 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:16,126 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sdb1  growable = False
>base = 1901092864  growth = 0  max_grow = 0
>done = True
>16:53:16,126 DEBUG storage.ui: req: PartitionRequest instance --
>id = 19  name = sdb2  growable = True
>base = 2048  growth = 0  max_grow = 104921088
>done = False
>16:53:16,126 DEBUG storage.ui: 1 requests and 52430193 (25600MB) left in chunk
>16:53:16,126 DEBUG storage.ui: adding 52430193 (25600MB) to 19 (sdb2)
>16:53:16,126 DEBUG storage.ui: new grow amount for request 19 (sdb2) is 52430193 units, or 25600MB
>16:53:16,126 DEBUG storage.ui: set: ['sda3', 'sdb2'] 51232
>16:53:16,127 DEBUG storage.ui: min growth is 52430193
>16:53:16,127 DEBUG storage.ui: max growth for PartitionRequest instance --
>id = 18  name = sda3  growable = True
>base = 2048  growth = 52430193  max_grow = 104921088
>done = False is 104921088
>16:53:16,127 DEBUG storage.ui: max growth for PartitionRequest instance --
>id = 19  name = sdb2  growable = True
>base = 2048  growth = 52430193  max_grow = 104921088
>done = False is 104921088
>16:53:16,127 DEBUG storage.ui: set: ['sda3', 'sdb2'] 51232
>16:53:16,127 DEBUG storage.ui: min growth is 52430193
>16:53:16,127 DEBUG storage.ui: max growth for PartitionRequest instance --
>id = 18  name = sda3  growable = True
>base = 2048  growth = 52430193  max_grow = 104921088
>done = True is 104921088
>16:53:16,127 DEBUG storage.ui: max growth for PartitionRequest instance --
>id = 19  name = sdb2  growable = True
>base = 2048  growth = 52430193  max_grow = 104921088
>done = True is 104921088
>16:53:16,127 DEBUG storage.ui: growing partitions on sda
>16:53:16,127 DEBUG storage.ui: partition sda1 (13): 0
>16:53:16,128 DEBUG storage.ui: new geometry for sda1: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab84cd9e10>
>16:53:16,128 DEBUG storage.ui: partition sda2 (11): 0
>16:53:16,128 DEBUG storage.ui: new geometry for sda2: parted.Geometry instance --
>  start: 1026048  end: 1901094911  length: 1900068864
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab84cd9550>
>16:53:16,128 DEBUG storage.ui: partition sda3 (18): 0
>16:53:16,128 DEBUG storage.ui: new geometry for sda3: parted.Geometry instance --
>  start: 1901094912  end: 1953523711  length: 52428800
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab84cd1a10>
>16:53:16,128 DEBUG storage.ui: removing all non-preexisting partitions ['sda1(id 13)', 'sda2(id 11)', 'sda3(id 18)'] from disk(s) ['sda']
>16:53:16,129 DEBUG storage.ui:                       PartitionDevice._setPartedPartition: sda1 ;
>16:53:16,130 DEBUG storage.ui: device sda1 new partedPartition None
>16:53:16,131 DEBUG storage.ui:                       PartitionDevice._setDisk: req2 ; new: None ; old: sda ;
>16:53:16,132 DEBUG storage.ui:                        DiskDevice.removeChild: kids: 3 ; name: sda ;
>16:53:16,133 DEBUG storage.ui:                       PartitionDevice._setPartedPartition: sda2 ;
>16:53:16,133 DEBUG storage.ui: device sda2 new partedPartition None
>16:53:16,134 DEBUG storage.ui:                       PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>16:53:16,135 DEBUG storage.ui:                        DiskDevice.removeChild: kids: 2 ; name: sda ;
>16:53:16,136 DEBUG storage.ui:                       PartitionDevice._setPartedPartition: sda3 ;
>16:53:16,137 DEBUG storage.ui: device sda3 new partedPartition None
>16:53:16,138 DEBUG storage.ui:                       PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>16:53:16,139 DEBUG storage.ui:                        DiskDevice.removeChild: kids: 1 ; name: sda ;
>16:53:16,139 DEBUG storage.ui: back from removeNewPartitions
>16:53:16,139 DEBUG storage.ui: extended: None
>16:53:16,139 DEBUG storage.ui: setting req2 new geometry: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab84cd9e10>
>16:53:16,140 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req2 ;
>16:53:16,140 DEBUG storage.ui: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd1d10>  PedPartition: <_ped.Partition object at 0x7fab84d4b830>
>16:53:16,142 DEBUG storage.ui:                      PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>16:53:16,143 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sda ;
>16:53:16,144 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:16,144 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd3f90>  PedPartition: <_ped.Partition object at 0x7fab84d4b770>
>16:53:16,144 DEBUG storage.ui: setting req0 new geometry: parted.Geometry instance --
>  start: 1026048  end: 1901094911  length: 1900068864
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab84cd9550>
>16:53:16,146 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req0 ;
>16:53:16,146 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd9450>  PedPartition: <_ped.Partition object at 0x7fab84d4ba10>
>16:53:16,147 DEBUG storage.ui:                      PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>16:53:16,148 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sda ;
>16:53:16,149 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda2 ;
>16:53:16,150 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd3490>  PedPartition: <_ped.Partition object at 0x7fab84d4b6b0>
>16:53:16,150 DEBUG storage.ui: setting req3 new geometry: parted.Geometry instance --
>  start: 1901094912  end: 1953523711  length: 52428800
>  device: <parted.device.Device object at 0x7fab84d5ee90>  PedGeometry: <_ped.Geometry object at 0x7fab84cd1a10>
>16:53:16,151 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req3 ;
>16:53:16,151 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84ccf750>  PedPartition: <_ped.Partition object at 0x7fab84d4ba70>
>16:53:16,152 DEBUG storage.ui:                      PartitionDevice._setDisk: sda3 ; new: sda ; old: None ;
>16:53:16,154 DEBUG storage.ui:                       DiskDevice.addChild: kids: 2 ; name: sda ;
>16:53:16,155 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda3 ;
>16:53:16,155 DEBUG storage.ui: device sda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab804f1890>  PedPartition: <_ped.Partition object at 0x7fab84d4bad0>
>16:53:16,155 DEBUG storage.ui: growing partitions on sdb
>16:53:16,156 DEBUG storage.ui: partition sdb1 (12): 0
>16:53:16,156 DEBUG storage.ui: new geometry for sdb1: parted.Geometry instance --
>  start: 2048  end: 1901094911  length: 1901092864
>  device: <parted.device.Device object at 0x7fab7f48f5d0>  PedGeometry: <_ped.Geometry object at 0x7fab7f4cd3d0>
>16:53:16,156 DEBUG storage.ui: partition sdb2 (19): 0
>16:53:16,156 DEBUG storage.ui: new geometry for sdb2: parted.Geometry instance --
>  start: 1901094912  end: 1953523711  length: 52428800
>  device: <parted.device.Device object at 0x7fab7f48f5d0>  PedGeometry: <_ped.Geometry object at 0x7fab84cd9950>
>16:53:16,156 DEBUG storage.ui: removing all non-preexisting partitions ['sdb1(id 12)', 'sdb2(id 19)'] from disk(s) ['sdb']
>16:53:16,157 DEBUG storage.ui:                       PartitionDevice._setPartedPartition: sdb1 ;
>16:53:16,157 DEBUG storage.ui: device sdb1 new partedPartition None
>16:53:16,159 DEBUG storage.ui:                       PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>16:53:16,160 DEBUG storage.ui:                        DiskDevice.removeChild: kids: 2 ; name: sdb ;
>16:53:16,161 DEBUG storage.ui:                       PartitionDevice._setPartedPartition: sdb2 ;
>16:53:16,161 DEBUG storage.ui: device sdb2 new partedPartition None
>16:53:16,162 DEBUG storage.ui:                       PartitionDevice._setDisk: req4 ; new: None ; old: sdb ;
>16:53:16,163 DEBUG storage.ui:                        DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:16,163 DEBUG storage.ui: back from removeNewPartitions
>16:53:16,163 DEBUG storage.ui: extended: None
>16:53:16,164 DEBUG storage.ui: setting req1 new geometry: parted.Geometry instance --
>  start: 2048  end: 1901094911  length: 1901092864
>  device: <parted.device.Device object at 0x7fab7f48f5d0>  PedGeometry: <_ped.Geometry object at 0x7fab7f4cd3d0>
>16:53:16,165 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req1 ;
>16:53:16,165 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84d26bd0>  PedPartition: <_ped.Partition object at 0x7fab84d23470>
>16:53:16,166 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>16:53:16,167 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:16,169 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb1 ;
>16:53:16,169 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84ccf290>  PedPartition: <_ped.Partition object at 0x7fab84d4b5f0>
>16:53:16,169 DEBUG storage.ui: setting req4 new geometry: parted.Geometry instance --
>  start: 1901094912  end: 1953523711  length: 52428800
>  device: <parted.device.Device object at 0x7fab7f48f5d0>  PedGeometry: <_ped.Geometry object at 0x7fab84cd9950>
>16:53:16,170 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req4 ;
>16:53:16,170 DEBUG storage.ui: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 2  path: /dev/sdb2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84d26c10>  PedPartition: <_ped.Partition object at 0x7fab84d4b830>
>16:53:16,172 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb2 ; new: sdb ; old: None ;
>16:53:16,173 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sdb ;
>16:53:16,174 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb2 ;
>16:53:16,174 DEBUG storage.ui: device sdb2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f6d0>  fileSystem: None
>  number: 2  path: /dev/sdb2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd3e10>  PedPartition: <_ped.Partition object at 0x7fab84d4b890>
>16:53:16,174 DEBUG storage.ui: fixing size of non-existent 500MB partition sda1 (13) with non-existent xfs filesystem mounted at /boot at 500.00
>16:53:16,175 DEBUG storage.ui: fixing size of non-existent 927768MB partition sda2 (11) with non-existent lvmpv at 927768.00
>16:53:16,175 DEBUG storage.ui: fixing size of non-existent 25600MB partition sda3 (18) with non-existent mdmember at 25600.00
>16:53:16,175 DEBUG storage.ui: fixing size of non-existent 928268MB partition sdb1 (12) with non-existent lvmpv at 928268.00
>16:53:16,176 DEBUG storage.ui: fixing size of non-existent 25600MB partition sdb2 (19) with non-existent mdmember at 25600.00
>16:53:16,177 DEBUG storage.ui:                      XFS.supported: supported: True ;
>16:53:16,177 DEBUG storage.ui: getFormat('xfs') returning XFS instance
>16:53:16,179 DEBUG storage.ui:                       PartitionDevice.addChild: kids: 0 ; name: sda3 ;
>16:53:16,180 DEBUG storage.ui:                       PartitionDevice.addChild: kids: 0 ; name: sdb2 ;
>16:53:16,181 DEBUG storage.ui:                       MDRaidArrayDevice._setFormat: root ; current: None ; type: xfs ;
>16:53:16,181 INFO storage.ui: added mdarray root (id 20) to device tree
>16:53:16,181 INFO storage.ui: registered action: [24] Create Device mdarray root (id 20)
>16:53:16,181 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:16,181 INFO storage.ui: registered action: [25] Create Format xfs filesystem mounted at / on mdarray root (id 20)
>16:53:16,182 DEBUG storage.ui: raw RAID 1 size == 25600.0
>16:53:16,182 INFO storage.ui: Using 16MB superBlockSize
>16:53:16,182 DEBUG storage.ui: non-existent RAID 1 size == 25584.0
>16:53:16,182 DEBUG storage.ui: raw RAID 1 size == 25600.0
>16:53:16,183 INFO storage.ui: Using 16MB superBlockSize
>16:53:16,183 DEBUG storage.ui: non-existent RAID 1 size == 25584.0
>16:53:16,189 DEBUG blivet: raw RAID 1 size == 25600.0
>16:53:16,189 INFO blivet: Using 16MB superBlockSize
>16:53:16,190 DEBUG blivet: non-existent RAID 1 size == 25584.0
>16:53:16,205 DEBUG blivet: raw RAID 1 size == 25600.0
>16:53:16,205 INFO blivet: Using 16MB superBlockSize
>16:53:16,206 DEBUG blivet: non-existent RAID 1 size == 25584.0
>16:53:16,207 DEBUG blivet: raw RAID 1 size == 25600.0
>16:53:16,207 INFO blivet: Using 16MB superBlockSize
>16:53:16,207 DEBUG blivet: non-existent RAID 1 size == 25584.0
>16:53:18,915 DEBUG blivet:               XFS.supported: supported: True ;
>16:53:18,915 DEBUG blivet: getFormat('xfs') returning XFS instance
>16:53:18,916 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.MDFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 500, ['sda'], {'encrypted': False, 'raid_level': 'raid1'}
>16:53:18,918 INFO storage.ui: removed partition sda1 (id 13) from device tree
>16:53:18,918 DEBUG storage.ui:                 DiskDevice.removeChild: kids: 3 ; name: sda ;
>16:53:18,919 INFO storage.ui: registered action: [26] Destroy Device partition sda1 (id 13)
>16:53:18,920 DEBUG storage.ui:              Blivet.factoryDevice: 1 ; 500 ; container_raid_level: None ; name: boot ; encrypted: False ; container_encrypted: False ; disks: [DiskDevice instance (0x7fab84d5ef50) --
>  name = sda  status = True  kids = 2 id = 1
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sda  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f685f0>
>  target size = 0  path = /dev/sda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab84d5ef10>, DiskDevice instance (0x7fab7f48f450) --
>  name = sdb  status = True  kids = 2 id = 2
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sdb  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f687a0>
>  target size = 0  path = /dev/sdb
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab7f48f510>] ; raid_level: raid1 ; label:  ; container_name: None ; device: None ; mountpoint: /boot ; fstype: xfs ; container_size: 0 ;
>16:53:18,920 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.MDFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 500, ['sda', 'sdb'], {'container_raid_level': None, 'name': 'boot', 'encrypted': False, 'container_encrypted': False, 'raid_level': 'raid1', 'label': '', 'container_name': None, 'device': None, 'mountpoint': '/boot', 'fstype': 'xfs', 'container_size': 0}
>16:53:18,921 DEBUG storage.ui:               MDFactory.configure: parent_factory: None ;
>16:53:18,921 DEBUG storage.ui: starting Blivet copy
>16:53:18,943 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda2 ;
>16:53:18,944 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd33d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84ce3e90>  PedPartition: <_ped.Partition object at 0x7fab84d23f50>
>16:53:18,945 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda3 ;
>16:53:18,945 DEBUG storage.ui: device sda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd33d0>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cf2050>  PedPartition: <_ped.Partition object at 0x7fab84d4bbf0>
>16:53:18,946 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sdb1 ;
>16:53:18,946 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd1a90>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cf2150>  PedPartition: <_ped.Partition object at 0x7fab84d4ba10>
>16:53:18,948 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sdb2 ;
>16:53:18,948 DEBUG storage.ui: device sdb2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd1a90>  fileSystem: None
>  number: 2  path: /dev/sdb2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cf22d0>  PedPartition: <_ped.Partition object at 0x7fab84d4bb30>
>16:53:18,948 DEBUG storage.ui: finished Blivet copy
>16:53:18,948 INFO storage.ui: Using 0MB superBlockSize
>16:53:18,948 DEBUG storage.ui: child factory class: <class 'blivet.devicefactory.PartitionSetFactory'>
>16:53:18,949 DEBUG storage.ui: child factory args: [<blivet.Blivet object at 0x7fab84d5eed0>, 1000, [DiskDevice instance (0x7fab84d5ef50) --
>  name = sda  status = True  kids = 2 id = 1
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sda  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f685f0>
>  target size = 0  path = /dev/sda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab84d5ef10>, DiskDevice instance (0x7fab7f48f450) --
>  name = sdb  status = True  kids = 2 id = 2
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sdb  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f687a0>
>  target size = 0  path = /dev/sdb
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab7f48f510>]]
>16:53:18,949 DEBUG storage.ui: child factory kwargs: {'fstype': 'mdmember'}
>16:53:18,950 DEBUG storage.ui:                 PartitionSetFactory.configure: parent_factory: <blivet.devicefactory.MDFactory object at 0x7fab84cd34d0> ;
>16:53:18,950 DEBUG storage.ui: parent factory container: None
>16:53:18,950 DEBUG storage.ui: members: []
>16:53:18,951 DEBUG storage.ui: add_disks: ['sda']
>16:53:18,951 DEBUG storage.ui: remove_disks: []
>16:53:18,952 DEBUG storage.ui:                    MDRaidMember.__init__:
>16:53:18,952 DEBUG storage.ui: getFormat('mdmember') returning MDRaidMember instance
>16:53:18,953 DEBUG storage.ui:                    MDRaidMember.__init__: mountpoint: None ;
>16:53:18,953 DEBUG storage.ui: getFormat('mdmember') returning MDRaidMember instance
>16:53:18,954 DEBUG storage.ui:                      DiskDevice.addChild: kids: 2 ; name: sda ;
>16:53:18,955 DEBUG storage.ui:                      PartitionDevice._setFormat: req5 ;
>16:53:18,956 DEBUG storage.ui:                       PartitionDevice._setFormat: req5 ; current: None ; type: mdmember ;
>16:53:18,957 DEBUG storage.ui:                    DiskDevice.removeChild: kids: 3 ; name: sda ;
>16:53:18,957 INFO storage.ui: added partition req5 (id 21) to device tree
>16:53:18,958 INFO storage.ui: registered action: [27] Create Device partition req5 (id 21)
>16:53:18,958 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:18,958 INFO storage.ui: registered action: [28] Create Format mdmember on partition req5 (id 21)
>16:53:18,958 ERR storage.ui: failed to configure device factory: raid1 requires at least 2 disks
>16:53:18,959 DEBUG storage.ui: raw RAID 1 size == 25600.0
>16:53:18,959 INFO storage.ui: Using 16MB superBlockSize
>16:53:18,959 DEBUG storage.ui: non-existent RAID 1 size == 25584.0
>16:53:18,970 DEBUG storage.ui:              Blivet.factoryDevice: 2 ; 500.0 ; container_raid_level: None ; name: sda1 ; encrypted: False ; container_encrypted: False ; disks: [DiskDevice instance (0x7fab84d5ef50) --
>  name = sda  status = True  kids = 2 id = 1
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sda  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f685f0>
>  target size = 0  path = /dev/sda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab84d5ef10>, DiskDevice instance (0x7fab7f48f450) --
>  name = sdb  status = True  kids = 2 id = 2
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sdb  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f687a0>
>  target size = 0  path = /dev/sdb
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab7f48f510>] ; raid_level: None ; label:  ; container_name: None ; mountpoint: /boot ; fstype: xfs ; container_size: 0 ;
>16:53:18,971 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.PartitionFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 500.0, ['sda', 'sdb'], {'container_raid_level': None, 'name': 'sda1', 'encrypted': False, 'container_encrypted': False, 'raid_level': None, 'label': '', 'container_name': None, 'mountpoint': '/boot', 'fstype': 'xfs', 'container_size': 0}
>16:53:18,971 DEBUG storage.ui:               PartitionFactory.configure: parent_factory: None ;
>16:53:18,971 DEBUG storage.ui: starting Blivet copy
>16:53:18,993 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda2 ;
>16:53:18,993 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84d26190>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd5a10>  PedPartition: <_ped.Partition object at 0x7fab84d4bd10>
>16:53:18,994 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sda3 ;
>16:53:18,995 DEBUG storage.ui: device sda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84d26190>  fileSystem: None
>  number: 3  path: /dev/sda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd5b90>  PedPartition: <_ped.Partition object at 0x7fab84d4bc50>
>16:53:18,996 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sdb1 ;
>16:53:18,996 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd3a50>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd5c90>  PedPartition: <_ped.Partition object at 0x7fab84d4bb90>
>16:53:18,997 DEBUG storage.ui:                   PartitionDevice._setPartedPartition: sdb2 ;
>16:53:18,998 DEBUG storage.ui: device sdb2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd3a50>  fileSystem: None
>  number: 2  path: /dev/sdb2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd5e10>  PedPartition: <_ped.Partition object at 0x7fab84d4bd70>
>16:53:18,998 DEBUG storage.ui: finished Blivet copy
>16:53:18,999 DEBUG storage.ui:                      XFS.supported: supported: True ;
>16:53:18,999 DEBUG storage.ui: getFormat('xfs') returning XFS instance
>16:53:19,000 DEBUG storage.ui:                      XFS.supported: supported: True ;
>16:53:19,000 DEBUG storage.ui: getFormat('xfs') returning XFS instance
>16:53:19,001 DEBUG storage.ui:                      XFS.supported: supported: True ;
>16:53:19,001 DEBUG storage.ui: getFormat('xfs') returning XFS instance
>16:53:19,003 DEBUG storage.ui:                       DiskDevice.addChild: kids: 2 ; name: sda ;
>16:53:19,004 DEBUG storage.ui:                       DiskDevice.addChild: kids: 2 ; name: sdb ;
>16:53:19,005 DEBUG storage.ui:                       PartitionDevice._setFormat: sda1 ;
>16:53:19,006 DEBUG storage.ui:                        PartitionDevice._setFormat: sda1 ; current: None ; type: xfs ;
>16:53:19,007 DEBUG storage.ui:                     DiskDevice.removeChild: kids: 3 ; name: sda ;
>16:53:19,008 DEBUG storage.ui:                     DiskDevice.removeChild: kids: 3 ; name: sdb ;
>16:53:19,008 INFO storage.ui: added partition sda1 (id 22) to device tree
>16:53:19,008 INFO storage.ui: registered action: [29] Create Device partition sda1 (id 22)
>16:53:19,008 DEBUG storage.ui: getFormat('None') returning DeviceFormat instance
>16:53:19,009 INFO storage.ui: registered action: [30] Create Format xfs filesystem mounted at /boot on partition sda1 (id 22)
>16:53:19,010 DEBUG storage.ui:                    DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>16:53:19,011 DEBUG storage.ui:                    DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>16:53:19,011 DEBUG storage.ui: removing all non-preexisting partitions ['sda1(id 22)', 'sda2(id 11)', 'sda3(id 18)', 'sdb1(id 12)', 'sdb2(id 19)'] from disk(s) ['sda', 'sdb']
>16:53:19,013 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda2 ;
>16:53:19,013 DEBUG storage.ui: device sda2 new partedPartition None
>16:53:19,014 DEBUG storage.ui:                      PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>16:53:19,015 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 2 ; name: sda ;
>16:53:19,016 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda3 ;
>16:53:19,016 DEBUG storage.ui: device sda3 new partedPartition None
>16:53:19,017 DEBUG storage.ui:                      PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>16:53:19,018 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 1 ; name: sda ;
>16:53:19,019 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb1 ;
>16:53:19,019 DEBUG storage.ui: device sdb1 new partedPartition None
>16:53:19,021 DEBUG storage.ui:                      PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>16:53:19,022 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 2 ; name: sdb ;
>16:53:19,023 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb2 ;
>16:53:19,023 DEBUG storage.ui: device sdb2 new partedPartition None
>16:53:19,024 DEBUG storage.ui:                      PartitionDevice._setDisk: req4 ; new: None ; old: sdb ;
>16:53:19,027 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:19,027 DEBUG storage.ui: allocatePartitions: disks=['sda', 'sdb'] ; partitions=['sda1(id 22)', 'req0(id 11)', 'req3(id 18)', 'req1(id 12)', 'req4(id 19)']
>16:53:19,027 DEBUG storage.ui: removing all non-preexisting partitions ['sda1(id 22)', 'req1(id 12)', 'req0(id 11)', 'req3(id 18)', 'req4(id 19)'] from disk(s) ['sda', 'sdb']
>16:53:19,028 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,030 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,030 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,031 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,032 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,032 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,033 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,034 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,035 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,036 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,037 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,037 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,037 DEBUG storage.ui: allocating partition: sda1 ; id: 22 ; disks: ['sda', 'sdb'] ;
>boot: True ; primary: False ; size: 1MB ; grow: True ; max_size: 500.0 ; start: None ; end: None
>16:53:19,037 DEBUG storage.ui: checking freespace on sda
>16:53:19,038 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=1MB boot=True best=None grow=True start=None
>16:53:19,038 DEBUG storage.ui: checking 63-1953525167 (953869 MB)
>16:53:19,038 DEBUG storage.ui: current free range is 63-1953525167 (953869MB)
>16:53:19,038 DEBUG storage.ui: evaluating growth potential for new layout
>16:53:19,038 DEBUG storage.ui: calculating growth for disk /dev/sdb
>16:53:19,038 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:19,038 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>16:53:19,039 DEBUG storage.ui: calculating growth for disk /dev/sda
>16:53:19,039 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:19,040 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:19,040 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd33d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cee950>  PedPartition: <_ped.Partition object at 0x7fab84d23770>
>16:53:19,041 DEBUG storage.ui:                      PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>16:53:19,043 DEBUG storage.ui:                       DiskDevice.addChild: kids: 2 ; name: sda ;
>16:53:19,043 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:19,043 DEBUG storage.ui: disk /dev/sda growth: 0 (0MB)
>16:53:19,044 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:19,044 DEBUG storage.ui: device sda1 new partedPartition None
>16:53:19,045 DEBUG storage.ui:                      PartitionDevice._setDisk: sda1 ; new: None ; old: sda ;
>16:53:19,046 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 3 ; name: sda ;
>16:53:19,046 DEBUG storage.ui: total growth: 0 sectors
>16:53:19,046 DEBUG storage.ui: updating use_disk to sda, type: 0
>16:53:19,046 DEBUG storage.ui: new free: 63-1953525167 / 953869MB
>16:53:19,047 DEBUG storage.ui: new free allows for 0 sectors of growth
>16:53:19,047 DEBUG storage.ui: found free space for bootable request
>16:53:19,047 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:19,047 DEBUG storage.ui: created partition sda1 of 1MB and added it to /dev/sda
>16:53:19,048 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:19,049 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cee190>  PedPartition: <_ped.Partition object at 0x7fab84d23f50>
>16:53:19,050 DEBUG storage.ui:                      PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>16:53:19,051 DEBUG storage.ui:                       DiskDevice.addChild: kids: 2 ; name: sda ;
>16:53:19,052 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:19,052 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48f0d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cee250>  PedPartition: <_ped.Partition object at 0x7fab84d23470>
>16:53:19,054 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,055 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,055 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,056 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,057 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,057 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,057 DEBUG storage.ui: allocating partition: req1 ; id: 12 ; disks: ['sdb'] ;
>boot: False ; primary: False ; size: 928268MB ; grow: False ; max_size: 1856036.0 ; start: None ; end: None
>16:53:19,057 DEBUG storage.ui: checking freespace on sdb
>16:53:19,058 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=928268MB boot=False best=None grow=False start=None
>16:53:19,058 DEBUG storage.ui: checking 63-1953525167 (953869 MB)
>16:53:19,058 DEBUG storage.ui: current free range is 63-1953525167 (953869MB)
>16:53:19,058 DEBUG storage.ui: evaluating growth potential for new layout
>16:53:19,058 DEBUG storage.ui: calculating growth for disk /dev/sdb
>16:53:19,059 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:19,060 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req1 ;
>16:53:19,060 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd1a90>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84ceed50>  PedPartition: <_ped.Partition object at 0x7fab84d4bb30>
>16:53:19,061 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>16:53:19,062 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:19,063 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:19,063 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:19,063 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sdb1  growable = False
>base = 1901092864  growth = 0  max_grow = 0
>done = True
>16:53:19,063 DEBUG storage.ui: request 12 (sdb1) growth: 0 (0MB) size: 928268MB
>16:53:19,063 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>16:53:19,063 DEBUG storage.ui: calculating growth for disk /dev/sda
>16:53:19,063 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:19,063 DEBUG storage.ui: disk /dev/sda growth: 0 (0MB)
>16:53:19,065 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb1 ;
>16:53:19,065 DEBUG storage.ui: device sdb1 new partedPartition None
>16:53:19,066 DEBUG storage.ui:                      PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>16:53:19,067 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:19,067 DEBUG storage.ui: total growth: 0 sectors
>16:53:19,067 DEBUG storage.ui: updating use_disk to sdb, type: 0
>16:53:19,067 DEBUG storage.ui: new free: 63-1953525167 / 953869MB
>16:53:19,067 DEBUG storage.ui: new free allows for 0 sectors of growth
>16:53:19,068 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:19,068 DEBUG storage.ui: created partition sdb1 of 928268MB and added it to /dev/sdb
>16:53:19,069 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req1 ;
>16:53:19,069 DEBUG storage.ui: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd1a90>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab7f4cfd10>  PedPartition: <_ped.Partition object at 0x7fab84d23770>
>16:53:19,070 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb1 ; new: sdb ; old: None ;
>16:53:19,071 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sdb ;
>16:53:19,073 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb1 ;
>16:53:19,073 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd1a90>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab7f4cfa50>  PedPartition: <_ped.Partition object at 0x7fab84d23f50>
>16:53:19,074 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,075 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,075 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,077 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,078 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,078 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,078 DEBUG storage.ui: allocating partition: req0 ; id: 11 ; disks: ['sda'] ;
>boot: False ; primary: False ; size: 927768MB ; grow: False ; max_size: 1856036.0 ; start: None ; end: None
>16:53:19,078 DEBUG storage.ui: checking freespace on sda
>16:53:19,078 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=927768MB boot=False best=None grow=False start=None
>16:53:19,079 DEBUG storage.ui: checking 63-1953525167 (953869 MB)
>16:53:19,079 DEBUG storage.ui: current free range is 63-1953525167 (953869MB)
>16:53:19,079 DEBUG storage.ui: evaluating growth potential for new layout
>16:53:19,079 DEBUG storage.ui: calculating growth for disk /dev/sdb
>16:53:19,079 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:19,079 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:19,079 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sdb1  growable = False
>base = 1901092864  growth = 0  max_grow = 0
>done = True
>16:53:19,080 DEBUG storage.ui: request 12 (sdb1) growth: 0 (0MB) size: 928268MB
>16:53:19,080 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>16:53:19,080 DEBUG storage.ui: calculating growth for disk /dev/sda
>16:53:19,080 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:19,081 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req0 ;
>16:53:19,081 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd33d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84ceef90>  PedPartition: <_ped.Partition object at 0x7fab84d4ba10>
>16:53:19,083 DEBUG storage.ui:                      PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>16:53:19,084 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sda ;
>16:53:19,084 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:19,084 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:19,084 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda1  growable = False
>base = 1900068864  growth = 0  max_grow = 0
>done = True
>16:53:19,084 DEBUG storage.ui: request 11 (sda1) growth: 0 (0MB) size: 927768MB
>16:53:19,084 DEBUG storage.ui: disk /dev/sda growth: 0 (0MB)
>16:53:19,085 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:19,085 DEBUG storage.ui: device sda1 new partedPartition None
>16:53:19,087 DEBUG storage.ui:                      PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>16:53:19,088 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 1 ; name: sda ;
>16:53:19,088 DEBUG storage.ui: total growth: 0 sectors
>16:53:19,088 DEBUG storage.ui: updating use_disk to sda, type: 0
>16:53:19,088 DEBUG storage.ui: new free: 63-1953525167 / 953869MB
>16:53:19,088 DEBUG storage.ui: new free allows for 0 sectors of growth
>16:53:19,088 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:19,089 DEBUG storage.ui: created partition sda1 of 927768MB and added it to /dev/sda
>16:53:19,090 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req0 ;
>16:53:19,090 DEBUG storage.ui: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd33d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84ceed10>  PedPartition: <_ped.Partition object at 0x7fab84d4bb30>
>16:53:19,091 DEBUG storage.ui:                      PartitionDevice._setDisk: sda1 ; new: sda ; old: None ;
>16:53:19,092 DEBUG storage.ui:                       DiskDevice.addChild: kids: 0 ; name: sda ;
>16:53:19,093 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:19,094 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd33d0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84ceea90>  PedPartition: <_ped.Partition object at 0x7fab84d4b9b0>
>16:53:19,095 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,096 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,096 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,097 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,098 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,098 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,099 DEBUG storage.ui: allocating partition: req3 ; id: 18 ; disks: ['sda'] ;
>boot: False ; primary: False ; size: 25600MB ; grow: False ; max_size: 51232 ; start: None ; end: None
>16:53:19,099 DEBUG storage.ui: checking freespace on sda
>16:53:19,099 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=25600MB boot=False best=None grow=False start=None
>16:53:19,099 DEBUG storage.ui: checking 63-2047 (0 MB)
>16:53:19,099 DEBUG storage.ui: current free range is 63-2047 (0MB)
>16:53:19,100 DEBUG storage.ui: checking 1900070912-1953525167 (26100 MB)
>16:53:19,100 DEBUG storage.ui: current free range is 1900070912-1953525167 (26100MB)
>16:53:19,100 DEBUG storage.ui: evaluating growth potential for new layout
>16:53:19,100 DEBUG storage.ui: calculating growth for disk /dev/sdb
>16:53:19,100 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:19,100 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:19,100 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sdb1  growable = False
>base = 1901092864  growth = 0  max_grow = 0
>done = True
>16:53:19,100 DEBUG storage.ui: request 12 (sdb1) growth: 0 (0MB) size: 928268MB
>16:53:19,100 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>16:53:19,101 DEBUG storage.ui: calculating growth for disk /dev/sda
>16:53:19,102 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req3 ;
>16:53:19,102 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd33d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd5450>  PedPartition: <_ped.Partition object at 0x7fab84d4ba70>
>16:53:19,103 DEBUG storage.ui:                      PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>16:53:19,104 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sda ;
>16:53:19,105 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:19,105 DEBUG storage.ui: adding request 18 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:19,105 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:19,105 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda1  growable = False
>base = 1900068864  growth = 0  max_grow = 0
>done = True
>16:53:19,105 DEBUG storage.ui: req: PartitionRequest instance --
>id = 18  name = sda2  growable = False
>base = 52428800  growth = 0  max_grow = 0
>done = True
>16:53:19,105 DEBUG storage.ui: request 11 (sda1) growth: 0 (0MB) size: 927768MB
>16:53:19,105 DEBUG storage.ui: request 18 (sda2) growth: 0 (0MB) size: 25600MB
>16:53:19,105 DEBUG storage.ui: disk /dev/sda growth: 0 (0MB)
>16:53:19,106 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda2 ;
>16:53:19,107 DEBUG storage.ui: device sda2 new partedPartition None
>16:53:19,108 DEBUG storage.ui:                      PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>16:53:19,109 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 2 ; name: sda ;
>16:53:19,109 DEBUG storage.ui: total growth: 0 sectors
>16:53:19,109 DEBUG storage.ui: updating use_disk to sda, type: 0
>16:53:19,109 DEBUG storage.ui: new free: 1900070912-1953525167 / 26100MB
>16:53:19,109 DEBUG storage.ui: new free allows for 0 sectors of growth
>16:53:19,110 DEBUG storage.ui: created partition sda2 of 25600MB and added it to /dev/sda
>16:53:19,111 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req3 ;
>16:53:19,111 DEBUG storage.ui: device req3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd33d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab7f4cfcd0>  PedPartition: <_ped.Partition object at 0x7fab84d23770>
>16:53:19,112 DEBUG storage.ui:                      PartitionDevice._setDisk: sda2 ; new: sda ; old: None ;
>16:53:19,113 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sda ;
>16:53:19,115 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda2 ;
>16:53:19,115 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd33d0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cee810>  PedPartition: <_ped.Partition object at 0x7fab84d4ba10>
>16:53:19,116 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,117 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,117 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,119 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:19,120 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:19,120 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:19,120 DEBUG storage.ui: allocating partition: req4 ; id: 19 ; disks: ['sdb'] ;
>boot: False ; primary: False ; size: 25600MB ; grow: False ; max_size: 51232 ; start: None ; end: None
>16:53:19,120 DEBUG storage.ui: checking freespace on sdb
>16:53:19,120 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sdb part_type=0 req_size=25600MB boot=False best=None grow=False start=None
>16:53:19,120 DEBUG storage.ui: checking 63-2047 (0 MB)
>16:53:19,121 DEBUG storage.ui: current free range is 63-2047 (0MB)
>16:53:19,121 DEBUG storage.ui: checking 1901094912-1953525167 (25600 MB)
>16:53:19,121 DEBUG storage.ui: current free range is 1901094912-1953525167 (25600MB)
>16:53:19,121 DEBUG storage.ui: evaluating growth potential for new layout
>16:53:19,121 DEBUG storage.ui: calculating growth for disk /dev/sdb
>16:53:19,122 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req4 ;
>16:53:19,123 DEBUG storage.ui: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd1a90>  fileSystem: None
>  number: 2  path: /dev/sdb2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd5610>  PedPartition: <_ped.Partition object at 0x7fab84d4b7d0>
>16:53:19,124 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb2 ; new: sdb ; old: None ;
>16:53:19,125 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sdb ;
>16:53:19,125 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:19,125 DEBUG storage.ui: adding request 19 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:19,125 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sdb start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:19,126 DEBUG storage.ui: req: PartitionRequest instance --
>id = 12  name = sdb1  growable = False
>base = 1901092864  growth = 0  max_grow = 0
>done = True
>16:53:19,126 DEBUG storage.ui: req: PartitionRequest instance --
>id = 19  name = sdb2  growable = False
>base = 52428800  growth = 0  max_grow = 0
>done = True
>16:53:19,126 DEBUG storage.ui: request 12 (sdb1) growth: 0 (0MB) size: 928268MB
>16:53:19,126 DEBUG storage.ui: request 19 (sdb2) growth: 0 (0MB) size: 25600MB
>16:53:19,126 DEBUG storage.ui: disk /dev/sdb growth: 0 (0MB)
>16:53:19,126 DEBUG storage.ui: calculating growth for disk /dev/sda
>16:53:19,126 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:19,126 DEBUG storage.ui: adding request 18 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:19,126 DEBUG storage.ui: Chunk.growRequests: 1953525105 on /dev/sda start = 63  end = 1953525167
>sectorSize = 512
>
>16:53:19,127 DEBUG storage.ui: req: PartitionRequest instance --
>id = 11  name = sda1  growable = False
>base = 1900068864  growth = 0  max_grow = 0
>done = True
>16:53:19,127 DEBUG storage.ui: req: PartitionRequest instance --
>id = 18  name = sda2  growable = False
>base = 52428800  growth = 0  max_grow = 0
>done = True
>16:53:19,127 DEBUG storage.ui: request 11 (sda1) growth: 0 (0MB) size: 927768MB
>16:53:19,127 DEBUG storage.ui: request 18 (sda2) growth: 0 (0MB) size: 25600MB
>16:53:19,127 DEBUG storage.ui: disk /dev/sda growth: 0 (0MB)
>16:53:19,128 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb2 ;
>16:53:19,128 DEBUG storage.ui: device sdb2 new partedPartition None
>16:53:19,129 DEBUG storage.ui:                      PartitionDevice._setDisk: req4 ; new: None ; old: sdb ;
>16:53:19,130 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 2 ; name: sdb ;
>16:53:19,130 DEBUG storage.ui: total growth: 0 sectors
>16:53:19,131 DEBUG storage.ui: updating use_disk to sdb, type: 0
>16:53:19,131 DEBUG storage.ui: new free: 1901094912-1953525167 / 25600MB
>16:53:19,131 DEBUG storage.ui: new free allows for 0 sectors of growth
>16:53:19,131 DEBUG storage.ui: created partition sdb2 of 25600MB and added it to /dev/sdb
>16:53:19,132 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: req4 ;
>16:53:19,133 DEBUG storage.ui: device req4 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd1a90>  fileSystem: None
>  number: 2  path: /dev/sdb2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd5510>  PedPartition: <_ped.Partition object at 0x7fab84d4ba70>
>16:53:19,134 DEBUG storage.ui:                      PartitionDevice._setDisk: sdb2 ; new: sdb ; old: None ;
>16:53:19,135 DEBUG storage.ui:                       DiskDevice.addChild: kids: 1 ; name: sdb ;
>16:53:19,136 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb2 ;
>16:53:19,136 DEBUG storage.ui: device sdb2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd1a90>  fileSystem: None
>  number: 2  path: /dev/sdb2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cd50d0>  PedPartition: <_ped.Partition object at 0x7fab84d4b830>
>16:53:19,137 DEBUG storage.ui: growPartitions: disks=['sda', 'sdb'], partitions=['sda1(id 22)', 'sda1(id 11)', 'sda2(id 18)', 'sdb1(id 12)', 'sdb2(id 19)']
>16:53:19,137 DEBUG storage.ui: growable partitions are ['sda1']
>16:53:19,137 DEBUG storage.ui: adding request 11 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:19,137 DEBUG storage.ui: adding request 18 to chunk 1953525105 (63-1953525167) on /dev/sda
>16:53:19,137 DEBUG storage.ui: disk sda has 1 chunks
>16:53:19,137 DEBUG storage.ui: adding request 12 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:19,137 DEBUG storage.ui: adding request 19 to chunk 1953525105 (63-1953525167) on /dev/sdb
>16:53:19,138 DEBUG storage.ui: disk sdb has 1 chunks
>16:53:19,138 DEBUG storage.ui: growing partitions on sda
>16:53:19,138 DEBUG storage.ui: growing partitions on sdb
>16:53:19,138 DEBUG storage.ui: fixing size of non-existent 927768MB partition sda1 (11) with non-existent lvmpv at 927768.00
>16:53:19,138 DEBUG storage.ui: fixing size of non-existent 1MB partition sda1 (22) with non-existent xfs filesystem mounted at /boot at 1.00
>16:53:19,138 DEBUG storage.ui: fixing size of non-existent 25600MB partition sda2 (18) with non-existent mdmember at 25600.00
>16:53:19,139 DEBUG storage.ui: fixing size of non-existent 928268MB partition sdb1 (12) with non-existent lvmpv at 928268.00
>16:53:19,139 DEBUG storage.ui: fixing size of non-existent 25600MB partition sdb2 (19) with non-existent mdmember at 25600.00
>16:53:19,146 DEBUG blivet: raw RAID 1 size == 25600.0
>16:53:19,147 INFO blivet: Using 16MB superBlockSize
>16:53:19,147 DEBUG blivet: non-existent RAID 1 size == 25584.0
>16:53:19,190 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.LVMFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 0, [], {}
>16:53:19,201 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.LVMFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 0, [], {}
>16:53:22,243 DEBUG blivet:               XFS.supported: supported: True ;
>16:53:22,244 DEBUG blivet: getFormat('xfs') returning XFS instance
>16:53:22,245 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.MDFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 1848076, ['sda', 'sdb'], {'encrypted': False, 'raid_level': 'raid1'}
>16:53:22,247 INFO storage.ui: removed lvmlv rhel_sarkhan-home (id 16) from device tree
>16:53:22,249 DEBUG storage.ui:                 LVMVolumeGroupDevice.removeChild: kids: 2 ; name: rhel_sarkhan ;
>16:53:22,249 INFO storage.ui: registered action: [31] Destroy Device lvmlv rhel_sarkhan-home (id 16)
>16:53:22,249 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.LVMFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 0, ['sda', 'sdb'], {'container_raid_level': None, 'container_encrypted': False, 'container_size': 0, 'container_name': 'rhel_sarkhan'}
>16:53:22,250 DEBUG storage.ui:              LVMFactory.configure: parent_factory: None ;
>16:53:22,250 DEBUG storage.ui: starting Blivet copy
>16:53:22,276 DEBUG storage.ui:                  PartitionDevice._setPartedPartition: sda1 ;
>16:53:22,276 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48fed0>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cff250>  PedPartition: <_ped.Partition object at 0x7fab84d23770>
>16:53:22,277 DEBUG storage.ui:                  PartitionDevice._setPartedPartition: sda1 ;
>16:53:22,278 DEBUG storage.ui: device sda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84ce3190>  fileSystem: None
>  number: 1  path: /dev/sda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cff490>  PedPartition: <_ped.Partition object at 0x7fab84d4bdd0>
>16:53:22,279 DEBUG storage.ui:                  PartitionDevice._setPartedPartition: sda2 ;
>16:53:22,279 DEBUG storage.ui: device sda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab7f48fed0>  fileSystem: None
>  number: 2  path: /dev/sda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cff3d0>  PedPartition: <_ped.Partition object at 0x7fab84d4bef0>
>16:53:22,280 DEBUG storage.ui:                  PartitionDevice._setPartedPartition: sdb1 ;
>16:53:22,280 DEBUG storage.ui: device sdb1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd5190>  fileSystem: None
>  number: 1  path: /dev/sdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cff910>  PedPartition: <_ped.Partition object at 0x7fab84d4be90>
>16:53:22,281 DEBUG storage.ui:                  PartitionDevice._setPartedPartition: sdb2 ;
>16:53:22,282 DEBUG storage.ui: device sdb2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7fab84cd5190>  fileSystem: None
>  number: 2  path: /dev/sdb2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7fab84cffa90>  PedPartition: <_ped.Partition object at 0x7fab84d4bf50>
>16:53:22,282 DEBUG storage.ui: finished Blivet copy
>16:53:22,282 DEBUG storage.ui: rhel_sarkhan size is 1856028MB
>16:53:22,282 DEBUG storage.ui: vg rhel_sarkhan has 1848076MB free
>16:53:22,283 DEBUG storage.ui: size bumped to 7960 to include new device space
>16:53:22,283 DEBUG storage.ui: child factory class: <class 'blivet.devicefactory.PartitionSetFactory'>
>16:53:22,284 DEBUG storage.ui: child factory args: [<blivet.Blivet object at 0x7fab84d5eed0>, 7960.0, [DiskDevice instance (0x7fab84cd3750) --
>  name = sda  status = True  kids = 2 id = 1
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata1/host1/target1:0:0/1:0:0:0/block/sda  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sda  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f685f0>
>  target size = 0  path = /dev/sda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab84cd3a90>, DiskDevice instance (0x7fab7f4cd3d0) --
>  name = sdb  status = True  kids = 2 id = 2
>  parents = []
>  uuid = None  size = 953869.710938
>  format = non-existent msdos disklabel
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:1f.2/ata2/host2/target2:0:0/2:0:0:0/block/sdb  partedDevice = parted.Device instance --
>  model: ATA ST1000DM003-1CH1  path: /dev/sdb  type: 1
>  sectorSize: 512  physicalSectorSize:  4096
>  length: 1953525168  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: False
>  hardwareGeometry: (121601, 255, 63)  biosGeometry: (121601, 255, 63)
>  PedDevice: <_ped.Device object at 0x7fab86f687a0>
>  target size = 0  path = /dev/sdb
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7fab7f4cd1d0>]]
>16:53:22,284 DEBUG storage.ui: child factory kwargs: {'encrypted': False, 'fstype': 'lvmpv'}
>16:53:22,285 DEBUG storage.ui:                 PartitionSetFactory.configure: parent_factory: <blivet.devicefactory.LVMFactory object at 0x7fab84d67190> ;
>16:53:22,285 DEBUG storage.ui: parent factory container: non-existent 1856028MB lvmvg rhel_sarkhan (14)
>16:53:22,285 DEBUG storage.ui: members: ['sda1', 'sdb1']
>16:53:22,285 DEBUG storage.ui: add_disks: []
>16:53:22,285 DEBUG storage.ui: remove_disks: []
>16:53:22,286 DEBUG storage.ui:                    LVMPhysicalVolume.__init__:
>16:53:22,286 DEBUG storage.ui: getFormat('lvmpv') returning LVMPhysicalVolume instance
>16:53:22,286 DEBUG storage.ui: rhel_sarkhan size is 1856028MB
>16:53:22,287 DEBUG storage.ui: vg rhel_sarkhan has 1848076MB free
>16:53:22,287 DEBUG storage.ui: size bumped to 7960 to include new device space
>16:53:22,287 DEBUG storage.ui: adding a TotalSizeSet with size 7960
>16:53:22,287 DEBUG storage.ui: set.allocated = 16
>16:53:22,288 DEBUG storage.ui:                    DiskDevice.setup: sda ; status: True ; controllable: True ; orig: False ;
>16:53:22,289 DEBUG storage.ui:                    DiskDevice.setup: sdb ; status: True ; controllable: True ; orig: False ;
>16:53:22,290 DEBUG storage.ui: removing all non-preexisting partitions ['sda1(id 11)', 'sda1(id 22)', 'sda2(id 18)', 'sdb1(id 12)', 'sdb2(id 19)'] from disk(s) ['sda', 'sdb']
>16:53:22,291 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda1 ;
>16:53:22,291 DEBUG storage.ui: device sda1 new partedPartition None
>16:53:22,292 DEBUG storage.ui:                      PartitionDevice._setDisk: req0 ; new: None ; old: sda ;
>16:53:22,293 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 2 ; name: sda ;
>16:53:22,294 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sda2 ;
>16:53:22,294 DEBUG storage.ui: device sda2 new partedPartition None
>16:53:22,295 DEBUG storage.ui:                      PartitionDevice._setDisk: req3 ; new: None ; old: sda ;
>16:53:22,296 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 1 ; name: sda ;
>16:53:22,298 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb1 ;
>16:53:22,298 DEBUG storage.ui: device sdb1 new partedPartition None
>16:53:22,299 DEBUG storage.ui:                      PartitionDevice._setDisk: req1 ; new: None ; old: sdb ;
>16:53:22,300 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 2 ; name: sdb ;
>16:53:22,301 DEBUG storage.ui:                      PartitionDevice._setPartedPartition: sdb2 ;
>16:53:22,301 DEBUG storage.ui: device sdb2 new partedPartition None
>16:53:22,302 DEBUG storage.ui:                      PartitionDevice._setDisk: req4 ; new: None ; old: sdb ;
>16:53:22,303 DEBUG storage.ui:                       DiskDevice.removeChild: kids: 1 ; name: sdb ;
>16:53:22,303 DEBUG storage.ui: allocatePartitions: disks=['sda', 'sdb'] ; partitions=['req0(id 11)', 'sda1(id 22)', 'req3(id 18)', 'req1(id 12)', 'req4(id 19)']
>16:53:22,304 DEBUG storage.ui: removing all non-preexisting partitions ['sda1(id 22)', 'req3(id 18)', 'req4(id 19)', 'req0(id 11)', 'req1(id 12)'] from disk(s) ['sda', 'sdb']
>16:53:22,305 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:22,306 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:22,306 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:22,307 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:22,308 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:22,308 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:22,310 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:22,311 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:22,311 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:22,312 DEBUG storage.ui:                       DeviceTree.getDeviceByName: name: sda ;
>16:53:22,313 DEBUG storage.ui:                       DeviceTree.getDeviceByName returned existing 953869MB disk sda (1) with non-existent msdos disklabel
>16:53:22,313 DEBUG storage.ui: resolved 'sda' to 'sda' (disk)
>16:53:22,313 DEBUG storage.ui: allocating partition: sda1 ; id: 22 ; disks: ['sda', 'sdb'] ;
>boot: True ; primary: False ; size: 1MB ; grow: False ; max_size: 500.0 ; start: None ; end: None
>16:53:22,314 DEBUG storage.ui: checking freespace on sda
>16:53:22,314 DEBUG storage.ui: getBestFreeSpaceRegion: disk=/dev/sda part_type=0 req_size=1MB boot=True best=None grow=False start=None
>16:53:22,314 DEBUG storage.ui: checking 63-1953525167 (953869 MB)
>16:53:22,314 DEBUG storage.ui: current free range is 63-1953525167 (953869MB)
>16:53:22,315 DEBUG storage.ui: updating use_disk to sda, type: 0
>16:53:22,315 DEBUG storage.ui: new free: 63-1953525167 / 953869MB
>16:53:22,315 DEBUG storage.ui: new free allows for 0 sectors of growth
>16:53:22,315 DEBUG storage.ui: found free space for bootable request
>16:53:22,315 DEBUG storage.ui: adjusted start sector from 63 to 2048
>16:53:22,316 ERR storage.ui: failed to configure device factory: Can't have overlapping partitions.
>16:53:22,398 DEBUG storage.ui: raw RAID 1 size == 1
>16:53:22,398 INFO storage.ui: Using 0MB superBlockSize
>16:53:22,399 DEBUG storage.ui: non-existent RAID 1 size == 1
>16:53:23,487 DEBUG storage.ui:                   SwapSpace.__init__:
>16:53:23,487 DEBUG storage.ui: getFormat('swap') returning SwapSpace instance
>16:53:23,496 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.LVMFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 0, [], {}
>16:53:23,505 DEBUG storage.ui: instantiating <class 'blivet.devicefactory.LVMFactory'>: <blivet.Blivet object at 0x7fab84d5eed0>, 0, [], {}

Actions: View

Attachments on bug 1059346: 857158 | 857159 | 857160 | 857161 | 857162 | 857163 | 857164 | 857165 | 857166 | 857167 | 857168