Attachment 639625 Details for Bug 872849 – traceback from my 18.24 cleanish reproducer

traceback from my 18.24 cleanish reproducer

traceback (text/plain), 229.47 KB, created by Adam Williamson on 2012-11-06 21:30:00 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Adam Williamson

Created: 2012-11-06 21:30:00 UTC

Size: 229.47 KB

patch

obsolete

>anaconda 18.24 exception report
>Traceback (most recent call first):
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/storage/devicelibs/btrfs.py", line 46, in btrfs
>    raise BTRFSError(ret)
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/storage/devicelibs/btrfs.py", line 95, in delete_subvolume
>    return btrfs(args)
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/storage/devices.py", line 4115, in _destroy
>    btrfs.delete_subvolume(mountpoint, self.name)
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/storage/devices.py", line 819, in destroy
>    self._destroy()
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/storage/deviceaction.py", line 286, in execute
>    self.device.destroy()
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/storage/devicetree.py", line 323, in processActions
>    action.execute()
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/storage/__init__.py", line 293, in doIt
>    self.devicetree.processActions()
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/storage/__init__.py", line 131, in turnOnFilesystems
>    storage.doIt()
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/install.py", line 113, in doInstall
>    turnOnFilesystems(storage)
>  File "/usr/lib64/python2.7/threading.py", line 504, in run
>    self.__target(*self.__args, **self.__kwargs)
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/threads.py", line 91, in run
>    threading.Thread.run(self, *args, **kwargs)
>BTRFSError: 12
>
>Local variables in innermost frame:
>capture: False
>args: ['subvol', 'delete', '/tmp/btrfs-tmp.4khapiP/5']
>exec_func: <function execWithRedirect at 0x7f11fb416b18>
>ret: 12
>kwargs: {'stderr': '/dev/tty5', 'stdout': '/dev/tty5'}
>
>
>Anaconda instance, containing members:
>_instClass: DefaultInstall instance, containing members:
>_intf: GraphicalUserInterface instance, containing members:
>  _intf.instclass: Already dumped (DefaultInstall instance)
>  _intf._hubs: [<class 'pyanaconda.ui.gui.hubs.summary.SummaryHub'>
>, <class 'pyanaconda.ui.gui.hubs.progress.ProgressHub'>
>]
>  _intf.storage: Storage instance, containing members:
>    _intf.storage.clearPartChoice: None
>    _intf.storage.eddDict: {'vda': 128}
>    _intf.storage.dasd: DASD instance, containing members:
>      _intf.storage.dasd.dasdfmt: /sbin/dasdfmt
>      _intf.storage.dasd.commonArgv: [-y, -d, cdl, -b, 4096]
>      _intf.storage.dasd.started: True
>      _intf.storage.dasd.totalCylinders: 0
>      _intf.storage.dasd._maxFormatJobs: 0
>      _intf.storage.dasd._devices: []
>      _intf.storage.dasd._completedCylinders: 0.0
>      _intf.storage.dasd._dasdlist: []
>    _intf.storage.roots: []
>    _intf.storage.zfcp: ZFCP instance, containing members:
>      _intf.storage.zfcp.down: False
>      _intf.storage.zfcp.hasReadConfig: True
>      _intf.storage.zfcp.intf: None
>      _intf.storage.zfcp.fcpdevs: set([])
>    _intf.storage.autoPartEscrowCert: None
>    _intf.storage.autoPartAddBackupPassphrase: False
>    _intf.storage.escrowCertificates: {}
>    _intf.storage.fsset: FSSet instance, containing members:
>      _intf.storage.fsset.origFStab: None
>      _intf.storage.fsset._usb: None
>      _intf.storage.fsset.devicetree: DeviceTree instance, containing members:
>        _intf.storage.fsset.devicetree.populated: True
>        _intf.storage.fsset.devicetree._hidden: []
>        _intf.storage.fsset.devicetree.names: [sr0, vda, loop0, /run/install/repo/LiveOS/squashfs.img, loop1, /LiveOS/rootfs.img, loop2, /overlay (deleted), loop3, loop4, loop5, loop6, loop7, live-rw, root, home]
>        _intf.storage.fsset.devicetree.liveBackingDevice: None
>        _intf.storage.fsset.devicetree.dasd: Already dumped (DASD instance)
>        _intf.storage.fsset.devicetree._cleanup: False
>        _intf.storage.fsset.devicetree.iscsi: iscsi instance, containing members:
>          _intf.storage.fsset.devicetree.iscsi.initiatorSet: False
>          _intf.storage.fsset.devicetree.iscsi.ifaces: {}
>          _intf.storage.fsset.devicetree.iscsi.started: False
>          _intf.storage.fsset.devicetree.iscsi._initiator: Skipped
>          _intf.storage.fsset.devicetree.iscsi.discovered_targets: {}
>          _intf.storage.fsset.devicetree.iscsi.ibftNodes: []
>        _intf.storage.fsset.devicetree.platform: X86 instance, containing members:
>        _intf.storage.fsset.devicetree.exclusiveDisks: []
>        _intf.storage.fsset.devicetree.unusedRaidMembers: []
>        _intf.storage.fsset.devicetree.mpathFriendlyNames: True
>        _intf.storage.fsset.devicetree.topology: MultipathTopology instance, containing members:
>          _intf.storage.fsset.devicetree.topology._multipaths: []
>          _intf.storage.fsset.devicetree.topology._nondisks: [sr0, vda1, vda2]
>          _intf.storage.fsset.devicetree.topology._devmap: {'vda1': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda1
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda1
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/vda1
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: vda1
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: partition
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 1
>, 'vda2': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda2
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda2
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/vda2
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: vda2
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: partition
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 2
>, 'vda': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/pci0000:00/0000:00:06.0/virtio2/block/vda
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/pci0000:00/0000:00:06.0/virtio2/block/vda
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/vda
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: vda
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: disk
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: None
>, 'sr0': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/pci0000:00/0000:00:01.1/ata2/host1/target1:0:0/1:0:0:0/block/sr0
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/pci0000:00/0000:00:01.1/ata2/host1/target1:0:0/1:0:0:0/block/sr0
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/sr0
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: sr0
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: disk
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 0
>, 'dm-0': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/virtual/block/dm-0
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/virtual/block/dm-0
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/dm-0
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: dm-0
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: disk
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 0
>, 'loop3': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/virtual/block/loop3
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/virtual/block/loop3
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/loop3
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: loop3
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: disk
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 3
>, 'loop2': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/virtual/block/loop2
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/virtual/block/loop2
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/loop2
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: loop2
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: disk
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 2
>, 'loop1': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/virtual/block/loop1
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/virtual/block/loop1
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/loop1
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: loop1
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: disk
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 1
>, 'loop0': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/virtual/block/loop0
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/virtual/block/loop0
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/loop0
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: loop0
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: disk
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 0
>, 'loop7': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/virtual/block/loop7
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/virtual/block/loop7
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/loop7
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: loop7
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: disk
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 7
>, 'loop6': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/virtual/block/loop6
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/virtual/block/loop6
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/loop6
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: loop6
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: disk
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 6
>, 'loop5': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/virtual/block/loop5
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/virtual/block/loop5
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/loop5
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: loop5
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: disk
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 5
>, 'loop4': UdevDevice instance, containing members:
>            _intf.storage.fsset.devicetree.topology._devmap.subsystem: block
>            _intf.storage.fsset.devicetree.topology._devmap.syspath: /sys/devices/virtual/block/loop4
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/virtual/block/loop4
>            _intf.storage.fsset.devicetree.topology._devmap.devnode: /dev/loop4
>            _intf.storage.fsset.devicetree.topology._devmap.sysname: loop4
>            _intf.storage.fsset.devicetree.topology._devmap.devtype: disk
>            _intf.storage.fsset.devicetree.topology._devmap.sysnum: 4
>}
>          _intf.storage.fsset.devicetree.topology._devices: [Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>, Already dumped (UdevDevice instance)
>]
>          _intf.storage.fsset.devicetree.topology._singlepaths: [vda, loop0, loop1, loop2, loop3, loop4, loop5, loop6, loop7, dm-0]
>          _intf.storage.fsset.devicetree.topology._mpath_topology: {}
>        _intf.storage.fsset.devicetree._ignoredDisks: [loop3, loop4, loop5, loop6, loop7]
>        _intf.storage.fsset.devicetree.protectedDevSpecs: []
>        _intf.storage.fsset.devicetree._devices: [OpticalDevice instance, containing members:
>          _model: QEMU_DVD-ROM
>          controllable: True
>          major: 11
>          kids: 0
>          _partedDevice: parted.Device instance --
>  model: QEMU QEMU DVD-ROM  path: /dev/sr0  type: 1
>  sectorSize: 2048  physicalSectorSize:  2048
>  length: 132608  openCount: 0  readOnly: True
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: True
>  hardwareGeometry: (8, 255, 63)  biosGeometry: (8, 255, 63)
>  PedDevice: <_ped.Device object at 0x16b8dd0>
>          uuid: None
>          exists: True
>          fstabComment: Skipped
>          _format: Iso9660FS instance, containing members:
>            _format.uuid: 2012-11-03-03-36-26-00
>            _format.exists: True
>            _format._mountpoint: None
>            _format._majorminor: 011000
>            _format._minInstanceSize: None
>            _format._mountType: iso9660
>            _format.fsprofile: None
>            _format.label: Fedora_18-Beta-TC7_x86_64
>            _format._targetSize: 0
>            _format._size: 0
>            _format.mountopts: None
>            _format.mountpoint: None
>            _format._migrate: False
>            _format._device: /dev/sr0
>          sysfsPath: /devices/pci0000:00/0000:00:01.1/ata2/host1/target1:0:0/1:0:0:0/block/sr0
>          _vendor: None
>          _name: sr0
>          _targetSize: 0
>          protected: False
>          parents: []
>          originalFormat: Iso9660FS instance, containing members:
>            originalFormat.uuid: 2012-11-03-03-36-26-00
>            originalFormat.exists: True
>            originalFormat._mountpoint: None
>            originalFormat.mountpoint: None
>            originalFormat._majorminor: None
>            originalFormat.fsprofile: None
>            originalFormat.label: Fedora_18-Beta-TC7_x86_64
>            originalFormat._targetSize: 0
>            originalFormat._minInstanceSize: None
>            originalFormat.mountopts: None
>            originalFormat._size: 0
>            originalFormat._migrate: False
>            originalFormat._device: /dev/sr0
>          bus: Skipped
>          _size: 259.0
>          _serial: None
>          id: 0
>          minor: 0
>, existing 15360MB disk vda (1) with non-existent msdos disklabel
>, FileDevice instance, containing members:
>          _model: Skipped
>          controllable: False
>          major: 0
>          kids: 1
>          _partedDevice: None
>          uuid: None
>          exists: True
>          fstabComment: Skipped
>          _format: existing None
>          sysfsPath: Skipped
>          _vendor: Skipped
>          _name: /run/install/repo/LiveOS/squashfs.img
>          _targetSize: 0
>          protected: False
>          parents: []
>          originalFormat: existing None
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 6
>          minor: 0
>, LoopDevice instance, containing members:
>          _model: Skipped
>          controllable: False
>          major: 0
>          kids: 0
>          _partedDevice: None
>          uuid: None
>          exists: True
>          fstabComment: Skipped
>          _format: existing None
>          sysfsPath: Skipped
>          _vendor: Skipped
>          _name: loop0
>          _targetSize: 0
>          protected: False
>          parents: [Already dumped (FileDevice instance)
>]
>          originalFormat: existing None
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 7
>          minor: 0
>, FileDevice instance, containing members:
>          _model: Skipped
>          controllable: False
>          major: 0
>          kids: 1
>          _partedDevice: None
>          uuid: None
>          exists: True
>          fstabComment: Skipped
>          _format: existing None
>          sysfsPath: Skipped
>          _vendor: Skipped
>          _name: /LiveOS/rootfs.img
>          _targetSize: 0
>          protected: False
>          parents: []
>          originalFormat: existing None
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 8
>          minor: 0
>, LoopDevice instance, containing members:
>          _model: Skipped
>          controllable: False
>          major: 0
>          kids: 0
>          _partedDevice: None
>          uuid: None
>          exists: True
>          fstabComment: Skipped
>          _format: Ext4FS instance, containing members:
>            _format.uuid: a59decfa-d0e7-4b63-b6ea-1ebe58898a3a
>            _format.exists: True
>            _format._mountpoint: None
>            _format._majorminor: None
>            _format._minInstanceSize: 0.0
>            _format._mountType: ext4
>            _format.fsprofile: None
>            _format.label: Anaconda
>            _format._targetSize: 1024.0
>            _format._size: 1024.0
>            _format.mountopts: None
>            _format.mountpoint: None
>            _format._migrate: False
>            _format._device: /dev/loop1
>          sysfsPath: Skipped
>          _vendor: Skipped
>          _name: loop1
>          _targetSize: 0
>          protected: False
>          parents: [Already dumped (FileDevice instance)
>]
>          originalFormat: Ext4FS instance, containing members:
>            originalFormat.uuid: a59decfa-d0e7-4b63-b6ea-1ebe58898a3a
>            originalFormat.exists: True
>            originalFormat._mountpoint: None
>            originalFormat.mountpoint: None
>            originalFormat._majorminor: None
>            originalFormat._mountType: ext4
>            originalFormat.fsprofile: None
>            originalFormat.label: Anaconda
>            originalFormat._targetSize: 1024.0
>            originalFormat._minInstanceSize: 0.0
>            originalFormat.mountopts: None
>            originalFormat._size: 1024.0
>            originalFormat._migrate: False
>            originalFormat._device: /dev/loop1
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 9
>          minor: 0
>, FileDevice instance, containing members:
>          _model: Skipped
>          controllable: False
>          major: 0
>          kids: 1
>          _partedDevice: None
>          uuid: None
>          exists: True
>          fstabComment: Skipped
>          _format: existing None
>          sysfsPath: Skipped
>          _vendor: Skipped
>          _name: /overlay (deleted)
>          _targetSize: 0
>          protected: False
>          parents: []
>          originalFormat: existing None
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 10
>          minor: 0
>, LoopDevice instance, containing members:
>          _model: Skipped
>          controllable: False
>          major: 0
>          kids: 1
>          _partedDevice: None
>          uuid: None
>          exists: True
>          fstabComment: Skipped
>          _format: existing None
>          sysfsPath: Skipped
>          _vendor: Skipped
>          _name: loop2
>          _targetSize: 0
>          protected: False
>          parents: [Already dumped (FileDevice instance)
>]
>          originalFormat: existing None
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 11
>          minor: 0
>, existing 1024MB dm live-rw (12) with existing ext4 filesystem
>, non-existent 12843MB partition vda3 (13) with non-existent btrfs filesystem
>, non-existent 500MB partition vda1 (14) with non-existent ext4 filesystem mounted at /boot
>, non-existent 2016MB partition vda2 (15) with non-existent swap
>, BTRFSVolumeDevice instance, containing members:
>          major: 0
>          _partedDevice: None
>          exists: False
>          req_size: None
>          _size: 0
>          id: 16
>          controllable: True
>          dataLevel: None
>          uuid: None
>          _format: BTRFS instance, containing members:
>            _format.uuid: None
>            _format.exists: None
>            _format._mountpoint: None
>            _format._majorminor: None
>            _format._minInstanceSize: None
>            _format._mountType: btrfs
>            _format.fsprofile: None
>            _format.label: fedora
>            _format._targetSize: 0
>            _format.volUUID: None
>            _format._size: 0
>            _format.mountopts: None
>            _format.mountpoint: None
>            _format._migrate: False
>            _format._device: /dev/vda3
>          parents: [Already dumped (PartitionDevice instance)
>]
>          subvolumes: [BTRFSSubVolumeDevice instance, containing members:
>            major: 0
>            _partedDevice: None
>            exists: False
>            req_size: 1024
>            _size: 0
>            id: 17
>            controllable: True
>            uuid: None
>            _format: BTRFS instance, containing members:
>              _format.uuid: None
>              _format.exists: None
>              _format._mountpoint: None
>              _format._majorminor: None
>              _format._minInstanceSize: None
>              _format._mountType: btrfs
>              _format.fsprofile: None
>              _format.label: None
>              _format._targetSize: 0
>              _format.volUUID: None
>              _format._size: 0
>              _format.mountopts: subvol=root
>              _format.mountpoint: /
>              _format._migrate: False
>              _format._device: /dev/vda3
>            parents: [Already dumped (BTRFSVolumeDevice instance)
>]
>            minor: 0
>            fstabComment: Skipped
>            bus: Skipped
>            sysfsPath: Skipped
>            _targetSize: 0
>            vol_id: None
>            _model: Skipped
>            kids: 0
>            _vendor: Skipped
>            _name: root
>            protected: False
>            originalFormat: non-existent None
>            _serial: None
>, BTRFSSubVolumeDevice instance, containing members:
>            major: 0
>            _partedDevice: None
>            exists: False
>            req_size: 500
>            _size: 0
>            id: 18
>            controllable: True
>            uuid: None
>            _format: BTRFS instance, containing members:
>              _format.uuid: None
>              _format.exists: None
>              _format._mountpoint: None
>              _format._majorminor: None
>              _format._minInstanceSize: None
>              _format._mountType: btrfs
>              _format.fsprofile: None
>              _format.label: None
>              _format._targetSize: 0
>              _format.volUUID: None
>              _format._size: 0
>              _format.mountopts: subvol=home
>              _format.mountpoint: /home
>              _format._migrate: False
>              _format._device: /dev/vda3
>            parents: [Already dumped (BTRFSVolumeDevice instance)
>]
>            minor: 0
>            fstabComment: Skipped
>            bus: Skipped
>            sysfsPath: Skipped
>            _targetSize: 0
>            vol_id: None
>            _model: Skipped
>            kids: 0
>            _vendor: Skipped
>            _name: home
>            protected: False
>            originalFormat: non-existent None
>            _serial: None
>]
>          minor: 0
>          fstabComment: Skipped
>          bus: Skipped
>          sysfsPath: Skipped
>          _targetSize: 0
>          _model: Skipped
>          metaDataLevel: None
>          kids: 2
>          _vendor: Skipped
>          _name: fedora
>          protected: False
>          originalFormat: BTRFS instance, containing members:
>            originalFormat.uuid: None
>            originalFormat.exists: False
>            originalFormat._mountpoint: None
>            originalFormat.mountpoint: None
>            originalFormat._majorminor: None
>            originalFormat._mountType: btrfs
>            originalFormat.fsprofile: None
>            originalFormat.label: None
>            originalFormat._targetSize: 0
>            originalFormat.volUUID: None
>            originalFormat._minInstanceSize: None
>            originalFormat.mountopts: None
>            originalFormat._size: 0
>            originalFormat._migrate: False
>            originalFormat._device: /dev/vda3
>          _serial: None
>, Already dumped (BTRFSSubVolumeDevice instance)
>, Already dumped (BTRFSSubVolumeDevice instance)
>]
>        _intf.storage.fsset.devicetree.protectedDevNames: []
>        _intf.storage.fsset.devicetree.diskImages: {}
>        _intf.storage.fsset.devicetree._actions: [ActionDestroyFormat instance, containing members:
>          device: BTRFSSubVolumeDevice instance, containing members:
>            device.major: 0
>            device._partedDevice: None
>            device.exists: True
>            device.req_size: None
>            device._size: 0
>            device.id: 5
>            device.controllable: True
>            device.uuid: None
>            device._format: existing None
>            device.parents: [BTRFSVolumeDevice instance, containing members:
>              major: 0
>              _partedDevice: None
>              exists: True
>              req_size: None
>              _size: 0
>              id: 4
>              controllable: True
>              dataLevel: None
>              uuid: 5b678d48-5fc8-492a-9ce2-d99112a692b4
>              _format: existing None
>              parents: [existing 12841MB partition vda2 (3)
>]
>              subvolumes: [Already dumped (BTRFSSubVolumeDevice instance)
>]
>              minor: 0
>              fstabComment: Skipped
>              bus: Skipped
>              sysfsPath: Skipped
>              _targetSize: 0
>              _model: Skipped
>              metaDataLevel: None
>              kids: 0
>              _vendor: Skipped
>              _name: btrfs.4
>              protected: False
>              originalFormat: BTRFS instance, containing members:
>                originalFormat.uuid: None
>                originalFormat.exists: True
>                originalFormat._mountpoint: /tmp/btrfs-tmp.4khapiP
>                originalFormat.mountpoint: None
>                originalFormat._majorminor: None
>                originalFormat._mountType: btrfs
>                originalFormat.fsprofile: None
>                originalFormat.label: fedora
>                originalFormat._targetSize: 0
>                originalFormat.volUUID: 5b678d48-5fc8-492a-9ce2-d99112a692b4
>                originalFormat._minInstanceSize: None
>                originalFormat.mountopts: None
>                originalFormat._size: 0
>                originalFormat._migrate: False
>                originalFormat._device: /dev/vda2
>              _serial: None
>]
>            device.minor: 0
>            device.fstabComment: Skipped
>            device.bus: Skipped
>            device.sysfsPath: Skipped
>            device._targetSize: 0
>            device.vol_id: 256
>            device._model: Skipped
>            device.kids: 0
>            device._vendor: Skipped
>            device._name: 5
>            device.protected: False
>            device.originalFormat: BTRFS instance, containing members:
>              device.originalFormat.uuid: None
>              device.originalFormat.exists: True
>              device.originalFormat._mountpoint: None
>              device.originalFormat.mountpoint: None
>              device.originalFormat._majorminor: None
>              device.originalFormat._mountType: btrfs
>              device.originalFormat.fsprofile: None
>              device.originalFormat.label: None
>              device.originalFormat._targetSize: 0
>              device.originalFormat.volUUID: None
>              device.originalFormat._minInstanceSize: None
>              device.originalFormat.mountopts: subvol=5
>              device.originalFormat._size: 0
>              device.originalFormat._migrate: False
>              device.originalFormat._device: /dev/vda2
>            device._serial: None
>          origFormat: BTRFS instance, containing members:
>            origFormat.uuid: None
>            origFormat.exists: True
>            origFormat._mountpoint: None
>            origFormat._majorminor: 252002
>            origFormat._minInstanceSize: None
>            origFormat._mountType: btrfs
>            origFormat.fsprofile: None
>            origFormat.label: None
>            origFormat._targetSize: 0
>            origFormat.volUUID: None
>            origFormat._size: 0
>            origFormat.mountopts: subvol=5
>            origFormat.mountpoint: None
>            origFormat._migrate: False
>            origFormat._device: /dev/vda2
>          id: 1
>, ActionDestroyDevice instance, containing members:
>          device: Already dumped (BTRFSSubVolumeDevice instance)
>          id: 2
>, ActionDestroyFormat instance, containing members:
>          device: Already dumped (BTRFSVolumeDevice instance)
>          origFormat: BTRFS instance, containing members:
>            origFormat.uuid: None
>            origFormat.exists: True
>            origFormat._mountpoint: None
>            origFormat._majorminor: 252002
>            origFormat._minInstanceSize: None
>            origFormat._mountType: btrfs
>            origFormat.fsprofile: None
>            origFormat.label: fedora
>            origFormat._targetSize: 0
>            origFormat.volUUID: 5b678d48-5fc8-492a-9ce2-d99112a692b4
>            origFormat._size: 0
>            origFormat.mountopts: None
>            origFormat.mountpoint: None
>            origFormat._migrate: False
>            origFormat._device: /dev/vda2
>          id: 3
>, ActionDestroyDevice instance, containing members:
>          device: Already dumped (BTRFSVolumeDevice instance)
>          id: 4
>, ActionDestroyFormat instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          origFormat: BTRFS instance, containing members:
>            origFormat.uuid: f6490e2a-bd5e-42c7-9051-b61676ef9b78
>            origFormat.exists: True
>            origFormat._mountpoint: None
>            origFormat._majorminor: 252002
>            origFormat._minInstanceSize: None
>            origFormat._mountType: btrfs
>            origFormat.fsprofile: None
>            origFormat.label: fedora
>            origFormat._targetSize: 0
>            origFormat.volUUID: 5b678d48-5fc8-492a-9ce2-d99112a692b4
>            origFormat._size: 0
>            origFormat.mountopts: None
>            origFormat.mountpoint: None
>            origFormat._migrate: False
>            origFormat._device: /dev/vda2
>          id: 5
>, ActionDestroyDevice instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          id: 6
>, ActionDestroyDevice instance, containing members:
>          device: existing 500MB partition vda1 (2)
>          id: 0
>, ActionDestroyFormat instance, containing members:
>          device: Already dumped (DiskDevice instance)
>          origFormat: existing msdos disklabel
>          id: 7
>, ActionCreateFormat instance, containing members:
>          device: Already dumped (DiskDevice instance)
>          origFormat: existing None
>          id: 8
>, ActionCreateDevice instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          id: 11
>, ActionCreateDevice instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          id: 13
>, ActionCreateFormat instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          origFormat: non-existent None
>          id: 14
>, ActionCreateDevice instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          id: 9
>, ActionCreateFormat instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          origFormat: non-existent None
>          id: 10
>, ActionCreateDevice instance, containing members:
>          device: Already dumped (BTRFSVolumeDevice instance)
>          id: 15
>, ActionCreateFormat instance, containing members:
>          device: Already dumped (BTRFSVolumeDevice instance)
>          origFormat: non-existent None
>          id: 16
>, ActionCreateDevice instance, containing members:
>          device: Already dumped (BTRFSSubVolumeDevice instance)
>          id: 19
>, ActionCreateFormat instance, containing members:
>          device: Already dumped (BTRFSSubVolumeDevice instance)
>          origFormat: non-existent None
>          id: 20
>, ActionCreateDevice instance, containing members:
>          device: Already dumped (BTRFSSubVolumeDevice instance)
>          id: 17
>, ActionCreateFormat instance, containing members:
>          device: Already dumped (BTRFSSubVolumeDevice instance)
>          origFormat: non-existent None
>          id: 18
>, ActionCreateFormat instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          origFormat: non-existent None
>          id: 12
>]
>      _intf.storage.fsset.preserveLines: []
>      _intf.storage.fsset._devshm: None
>      _intf.storage.fsset._dev: None
>      _intf.storage.fsset.blkidTab: None
>      _intf.storage.fsset._proc: None
>      _intf.storage.fsset.active: False
>      _intf.storage.fsset.cryptTab: None
>      _intf.storage.fsset._devpts: None
>      _intf.storage.fsset._sysfs: None
>      _intf.storage.fsset._selinux: None
>    _intf.storage.platform: X86 instance, containing members:
>    _intf.storage.config: StorageDiscoveryConfig instance, containing members:
>      _intf.storage.config.clearPartType: 2
>      _intf.storage.config.clearNonExistent: True
>      _intf.storage.config.ignoredDisks: []
>      _intf.storage.config.protectedDevSpecs: []
>      _intf.storage.config.ignoreDiskInteractive: False
>      _intf.storage.config.exclusiveDisks: [vda]
>      _intf.storage.config.clearPartDevices: []
>      _intf.storage.config.zeroMbr: False
>      _intf.storage.config.diskImages: {}
>      _intf.storage.config.clearPartDisks: [vda]
>      _intf.storage.config.mpathFriendlyNames: True
>      _intf.storage.config.initializeDisks: True
>    _intf.storage.size_sets: []
>    _intf.storage.autoPartType: 1
>    _intf.storage._bootloader: GRUB2 instance, containing members:
>      _intf.storage._bootloader._disk_order: []
>      _intf.storage._bootloader.console_options: Skipped
>      _intf.storage._bootloader.console: Skipped
>      _intf.storage._bootloader.skip_bootloader: False
>      _intf.storage._bootloader.warnings: []
>      _intf.storage._bootloader.chain_images: []
>      _intf.storage._bootloader.stage2_is_preferred_stage1: False
>      _intf.storage._bootloader.stage2_device: Already dumped (PartitionDevice instance)
>      _intf.storage._bootloader.disks: [Already dumped (DiskDevice instance)
>]
>      _intf.storage._bootloader._update_only: False
>      _intf.storage._bootloader._default_image: None
>      _intf.storage._bootloader.platform: Already dumped (X86 instance)
>      _intf.storage._bootloader.encrypted_password: Skipped
>      _intf.storage._bootloader.errors: []
>      _intf.storage._bootloader.stage1_device: Already dumped (DiskDevice instance)
>      _intf.storage._bootloader._timeout: None
>      _intf.storage._bootloader.stage1_disk: Already dumped (DiskDevice instance)
>      _intf.storage._bootloader.password: None
>      _intf.storage._bootloader.dracut_args: 
>      _intf.storage._bootloader.boot_args: $([ -x /usr/sbin/rhcrashkernel-param ] && /usr/sbin/rhcrashkernel-param || :)
>      _intf.storage._bootloader.linux_images: []
>    _intf.storage.devicetree: Already dumped (DeviceTree instance)
>    _intf.storage.defaultFSType: ext4
>    _intf.storage._dumpFile: /tmp/storage.state
>    _intf.storage.services: set([])
>    _intf.storage.data: Skipped
>    _intf.storage.encryptionPassphrase: Skipped
>    _intf.storage.encryptionCipher: None
>    _intf.storage.encryptionRetrofit: False
>    _intf.storage._nextID: 3
>    _intf.storage.fcoe: fcoe instance, containing members:
>      _intf.storage.fcoe.started: True
>      _intf.storage.fcoe.nics: []
>      _intf.storage.fcoe.lldpadStarted: False
>    _intf.storage.autoPartitionRequests: [PartSpec instance (0x7f11ea535f90) -- 
>  mountpoint = /  lv = True  singlePV = False  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024  maxSize = 51200  grow = True
>
>, PartSpec instance (0x7f11ea535e50) -- 
>  mountpoint = /home  lv = True  singlePV = False  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500  maxSize = None  grow = True
>
>, PartSpec instance (0x7f11ea535d50) -- 
>  mountpoint = /boot  lv = False  singlePV = False  btrfs = False
>  weight = 2000  fstype = ext4  encrypted = False
>  size = 500  maxSize = None  grow = False
>
>, PartSpec instance (0x7f11ea5359d0) -- 
>  mountpoint = None  lv = False  singlePV = False  btrfs = False
>  weight = 5000  fstype = biosboot  encrypted = False
>  size = 1  maxSize = None  grow = False
>
>, PartSpec instance (0x7f11ea535a10) -- 
>  mountpoint = None  lv = True  singlePV = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 2016  maxSize = None  grow = False
>
>]
>    _intf.storage.doAutoPart: True
>    _intf.storage.iscsi: Already dumped (iscsi instance)
>    _intf.storage.encryptedAutoPart: False
>  _intf._ui: None
>  _intf._actions: Skipped
>  _intf.payload: YumPayload instance, containing members:
>    _intf.payload.skipBroken: False
>    _intf.payload._groups: Skipped
>    _intf.payload._yum: Skipped
>    _intf.payload.storage: Already dumped (Storage instance)
>    _intf.payload.install_device: None
>    _intf.payload._root_dir: /tmp/yum.root
>    _intf.payload._repos_dir: /etc/yum.repos.d,/etc/anaconda.repos.d,/tmp/updates/anaconda.repos.d,/tmp/product/anaconda.repos.d
>    _intf.payload._packages: []
>    _intf.payload._requiredPackages: []
>    _intf.payload._requiredGroups: []
>    _intf.payload._setup: True
>    _intf.payload.txID: 1352236471.5
>    _intf.payload._createdInitrds: False
>    _intf.payload._space_required: 588.71 MB
>    _intf.payload.data: Skipped
>    _intf.payload._kernelVersionList: []
>updateSrc: None
>rootParts: None
>upgradeRoot: None
>_platform: Already dumped (X86 instance)
>id: None
>rescue: False
>mediaDevice: None
>upgrade: False
>_network: None
>methodstr: None
>proxyPassword: None
>desktop: Desktop instance, containing members:
>  desktop.info: {}
>  desktop.always_quote: False
>  desktop.write_quote: True
>  desktop.filename: None
>  desktop.read_unquote: True
>  desktop.runlevel: 3
>  desktop._lines: []
>canReIPL: False
>xdriver: None
>stage2: hd:LABEL=Fedorax2018-Beta-TC7x20x86_64
>rescue_mount: True
>_bootloader: GRUB2 instance, containing members:
>  _bootloader._disk_order: []
>  _bootloader.console_options: Skipped
>  _bootloader.console: Skipped
>  _bootloader.skip_bootloader: False
>  _bootloader.warnings: []
>  _bootloader.chain_images: []
>  _bootloader.stage2_is_preferred_stage1: False
>  _bootloader.disks: []
>  _bootloader._update_only: False
>  _bootloader._default_image: None
>  _bootloader.platform: Already dumped (X86 instance)
>  _bootloader.encrypted_password: Skipped
>  _bootloader.errors: []
>  _bootloader.stage1_device: None
>  _bootloader._timeout: None
>  _bootloader.stage1_disk: None
>  _bootloader.password: None
>  _bootloader.dracut_args: 
>  _bootloader.boot_args: $([ -x /usr/sbin/rhcrashkernel-param ] && /usr/sbin/rhcrashkernel-param || :)
>  _bootloader.linux_images: []
>_payload: Already dumped (YumPayload instance)
>displayMode: g
>simpleFilter: True
>ksdata: Skipped
>proxyUsername: None
>extraModules: []
>mehConfig: Config instance, containing members:
>  mehConfig.programName: anaconda
>  mehConfig.programVersion: 18.24
>  mehConfig.attrSkipList: [_intf._actions, _intf.storage.bootloader.password, _intf.storage.data, _intf.storage.encryptionPassphrase, _bootloader.encrypted_password, _bootloader.password, payload._groups, payload._yum]
>  mehConfig.localSkipList: [passphrase, password]
>  mehConfig.fileList: [/tmp/anaconda.log, /tmp/packaging.log, /tmp/program.log, /tmp/storage.log, /tmp/ifcfg.log, /tmp/yum.log, /mnt/sysimage/root/install.log, /mnt/sysimage/root/upgrade.log, /proc/cmdline, /tmp/syslog]
>_backend: None
>isHeadless: False
>reIPLMessage: None
>_storage: Already dumped (Storage instance)
>dir: None
>opts: {'noipv6': False, 'noipv4': False, 'updateSrc': None, 'selinux': True, 'module': [], 'syslog': None, 'leavebootorder': False, 'images': [], 'serial': False, 'dmraid': True, 'armPlatform': None, 'virtpconsole': None, 'memcheck': True, 'iscsi': False, 'ksfile': None, 'kbdtype': None, 'runres': None, 'xdriver': None, 'display_mode': 'g', 'stage2': 'hd:LABEL=Fedorax2018-Beta-TC7x20x86_64', 'method': None, 'vncpassword': '', 'vnc': False, 'rescue': False, 'noverifyssl': False, 'autostep': False, 'proxy': None, 'dlabel': False, 'vncconnect': None, 'lang': None, 'liveinst': False, 'loglevel': None, 'isHeadless': False, 'multiLib': False, 'rescue_nomount': False, 'keymap': None, 'mpath': True, 'ibft': True, 'debug': False, 'nofb': None, 'targetArch': None}
>proxy: None
>
>
>/tmp/anaconda.log:
>21:12:43,981 INFO anaconda: /sbin/anaconda 18.24
>21:12:45,095 INFO anaconda: 1048576 kB (1024 MB) are available
>21:12:45,096 INFO anaconda: check_memory(): total:1024, needed:512, graphical:512
>21:12:45,107 INFO anaconda: anaconda called with cmdline = ['/sbin/anaconda']
>21:12:45,108 INFO anaconda: Default encoding = utf-8 
>21:12:45,226 INFO anaconda: ISCSID is /sbin/iscsid
>21:12:45,228 INFO anaconda: no initiator set
>21:12:45,395 INFO anaconda: No FCoE EDD info found: No FCoE boot disk information is found in EDD!
>21:12:45,396 INFO anaconda: no /etc/zfcp.conf; not configuring zfcp
>21:12:45,548 INFO anaconda: Display mode = g
>21:12:45,550 INFO anaconda: 1048576 kB (1024 MB) are available
>21:12:45,550 INFO anaconda: check_memory(): total:1024, needed:512, graphical:512
>21:12:46,276 DEBUG anaconda: X server has signalled a successful start.
>21:12:46,278 INFO anaconda: Starting window manager, pid 677.
>21:12:47,465 INFO anaconda: using only installclass _Fedora
>21:12:48,118 INFO anaconda: Detected 1008M of memory
>21:12:48,119 INFO anaconda: Swap attempt of 2016M
>21:12:48,145 INFO anaconda: Running Thread: AnaStorageThread (139714927011584)
>21:12:48,153 INFO anaconda: Running Thread: AnaPayloadThread (139714918618880)
>21:12:48,222 INFO anaconda: no initiator set
>21:12:48,739 DEBUG anaconda: required disklabel type for vda (15) is None
>21:12:48,740 DEBUG anaconda: default disklabel type for vda is msdos
>21:12:48,741 DEBUG anaconda: selecting msdos disklabel for vda based on size
>21:12:49,336 INFO anaconda: failed to get default SELinux context for /tmp/btrfs-tmp.4zGDWC4: [Errno 2] No such file or directory
>21:12:49,347 DEBUG anaconda: isys.py:mount()- going to mount /dev/vda2 on /tmp/btrfs-tmp.4zGDWC4 as btrfs with options defaults
>21:12:49,363 INFO anaconda: failed to get default SELinux context for /tmp/btrfs-tmp.4zGDWC4: [Errno 2] No such file or directory
>21:12:49,402 DEBUG anaconda: isys.py:umount()- going to unmount /tmp/btrfs-tmp.4zGDWC4, removeDir = False
>21:12:50,488 DEBUG anaconda: isys.py:mount()- going to mount /dev/vda2 on /mnt/sysimage as btrfs with options subvol=5,ro
>21:12:50,717 INFO anaconda: Thread Done: AnaStorageThread (139714927011584)
>16:13:19,238 INFO anaconda: source spoke ready: False
>16:13:19,240 INFO anaconda: source spoke ready: False
>16:13:19,241 INFO anaconda: source spoke ready: False
>16:13:19,242 INFO anaconda: source spoke ready: False
>16:13:19,243 INFO anaconda: source spoke ready: False
>16:13:19,244 INFO anaconda: source spoke ready: False
>16:13:19,244 INFO anaconda: source spoke ready: False
>16:13:19,246 INFO anaconda: Running Thread: AnaSourceWatcher (139714677774080)
>16:13:19,328 INFO anaconda: Running Thread: AnaSoftwareWatcher (139714690447104)
>16:13:19,342 INFO anaconda: Running Thread: AnaStorageWatcher (139714599941888)
>16:13:19,942 INFO anaconda: Running Thread: AnaNTPserver0 (139714927011584)
>16:13:19,948 INFO anaconda: Running Thread: AnaNTPserver1 (139714591549184)
>16:13:19,957 INFO anaconda: Running Thread: AnaNTPserver2 (139714583156480)
>16:13:19,968 INFO anaconda: Running Thread: AnaNTPserver3 (139714574763776)
>16:13:20,004 INFO anaconda: Thread Done: AnaStorageWatcher (139714599941888)
>16:13:20,086 INFO anaconda: Thread Done: AnaNTPserver2 (139714583156480)
>16:13:20,309 INFO anaconda: Thread Done: AnaNTPserver3 (139714574763776)
>16:13:20,346 INFO anaconda: Thread Done: AnaNTPserver1 (139714591549184)
>16:13:29,989 INFO anaconda: Thread Done: AnaNTPserver0 (139714927011584)
>16:13:38,911 WARN anaconda: /usr/lib64/python2.7/site-packages/gi/types.py:47: Warning: g_object_disconnect: invalid signal spec "button-release-event"
>  return info.invoke(*args, **kwargs)
>
>16:13:40,838 DEBUG anaconda: disk free: 2.01 GB  fs free: 0 B  sw needs: 2.8 GB
>16:14:01,069 INFO anaconda: Thread Done: AnaPayloadThread (139714918618880)
>16:14:01,077 DEBUG anaconda: notifying kernel of 'change' event on device /sys/devices/pci0000:00/0000:00:01.1/ata2/host1/target1:0:0/1:0:0:0/block/sr0
>16:14:01,143 DEBUG anaconda: isys.py:mount()- going to mount /dev/sr0 on /mnt/install/isodir as iso9660 with options ro
>16:14:01,156 DEBUG anaconda: isys.py:umount()- going to unmount /mnt/install/isodir, removeDir = False
>16:14:01,165 INFO anaconda: Thread Done: AnaSourceWatcher (139714677774080)
>16:14:12,413 INFO anaconda: source spoke ready: True
>16:14:12,418 INFO anaconda: source spoke ready: True
>16:14:12,418 INFO anaconda: Thread Done: AnaSoftwareWatcher (139714690447104)
>16:14:12,418 INFO anaconda: Running Thread: AnaCheckSoftwareThread (139714583156480)
>16:14:12,746 INFO anaconda: Running Thread: AnaExecuteStorageThread (139714690447104)
>16:14:12,773 DEBUG anaconda: required disklabel type for vda (15) is None
>16:14:12,774 DEBUG anaconda: default disklabel type for vda is msdos
>16:14:12,777 DEBUG anaconda: selecting msdos disklabel for vda based on size
>16:14:12,864 INFO anaconda: Detected 1008M of memory
>16:14:12,865 INFO anaconda: Swap attempt of 2016M
>16:14:13,329 INFO anaconda: Thread Done: AnaExecuteStorageThread (139714690447104)
>16:14:13,330 INFO anaconda: Running Thread: AnaCheckStorageThread (139714918618880)
>16:14:13,341 INFO anaconda: Thread Done: AnaCheckStorageThread (139714918618880)
>16:14:23,825 INFO anaconda: Thread Done: AnaCheckSoftwareThread (139714583156480)
>16:14:24,391 INFO anaconda: source spoke ready: True
>16:14:24,392 INFO anaconda: source spoke ready: True
>16:14:24,393 INFO anaconda: source spoke ready: True
>16:14:24,394 INFO anaconda: source spoke ready: True
>16:14:24,395 INFO anaconda: source spoke ready: True
>16:14:24,396 INFO anaconda: source spoke ready: True
>16:14:31,492 INFO anaconda: Running Thread: AnaCheckSoftwareThread (139714583156480)
>16:14:32,387 INFO anaconda: source spoke ready: True
>16:14:35,921 INFO anaconda: Thread Done: AnaCheckSoftwareThread (139714583156480)
>16:14:36,390 INFO anaconda: source spoke ready: True
>16:14:36,392 INFO anaconda: source spoke ready: True
>16:14:36,393 INFO anaconda: source spoke ready: True
>16:14:36,393 INFO anaconda: source spoke ready: True
>16:14:36,394 INFO anaconda: source spoke ready: True
>16:14:36,395 INFO anaconda: source spoke ready: True
>16:14:38,232 INFO anaconda: Running Thread: AnaInstallThread (139714583156480)
>16:14:39,722 INFO anaconda: failed to get default SELinux context for /tmp/btrfs-tmp.4khapiP: [Errno 2] No such file or directory
>16:14:39,724 DEBUG anaconda: isys.py:mount()- going to mount /dev/vda2 on /tmp/btrfs-tmp.4khapiP as btrfs with options defaults
>16:14:39,742 INFO anaconda: failed to get default SELinux context for /tmp/btrfs-tmp.4khapiP: [Errno 2] No such file or directory
>16:14:39,765 INFO anaconda: Thread Done: AnaInstallThread (139714583156480)
>
>
>/tmp/packaging.log:
>21:12:48,082 DEBUG packaging: getting release version from tree at None (18)
>21:12:48,083 DEBUG packaging: got a release version of 18
>21:12:50,720 INFO packaging: updating base repo
>21:12:50,923 DEBUG packaging: getting release version from tree at None (18)
>21:12:50,927 DEBUG packaging: got a release version of 18
>21:12:50,928 INFO packaging: configuring base repo
>21:12:50,928 DEBUG packaging: /dev/sr0 is mounted on /run/install/repo
>21:12:50,972 DEBUG packaging: getting release version from tree at file:///run/install/repo (18)
>21:12:50,972 DEBUG packaging: retrieving treeinfo from file:///run/install/repo (proxies: {} ; sslverify: True)
>21:12:50,982 INFO packaging: Error downloading treeinfo: [Errno 14] Could not open/read file:///run/install/repo/treeinfo
>21:12:50,982 DEBUG packaging: got a release version of 18
>21:12:51,045 DEBUG packaging: adding yum repo anaconda with baseurl file:///run/install/repo and mirrorlist None
>21:12:51,052 ERR packaging: base repo (cdrom/file:///run/install/repo) not valid -- removing it
>21:12:51,053 INFO packaging: using default repos from local yum configuration
>21:12:51,060 INFO packaging: gathering repo metadata
>21:12:51,061 DEBUG packaging: getting repo metadata for fedora
>16:13:26,634 DEBUG packaging: getting group info for fedora
>16:13:26,844 DEBUG packaging: getting repo metadata for updates-testing
>16:13:46,093 DEBUG packaging: getting group info for updates-testing
>16:13:59,842 DEBUG packaging: getting repo metadata for updates
>16:14:01,066 DEBUG packaging: getting group info for updates
>16:14:01,067 ERR packaging: failed to get groups for repo updates
>16:14:01,068 INFO packaging: metadata retrieval complete
>16:14:12,406 DEBUG packaging: deleting package sacks
>16:14:12,420 INFO packaging: checking software selection
>16:14:12,420 DEBUG packaging: deleting package sacks
>16:14:12,425 DEBUG packaging: deleting yum transaction info
>16:14:12,426 DEBUG packaging: select group core
>16:14:14,684 DEBUG packaging: select group core
>16:14:14,684 DEBUG packaging: select group gnome-desktop
>16:14:14,786 DEBUG packaging: select group multimedia
>16:14:14,808 DEBUG packaging: select group input-methods
>16:14:14,823 DEBUG packaging: select group base-x
>16:14:14,843 DEBUG packaging: select group fonts
>16:14:14,914 DEBUG packaging: select group hardware-support
>16:14:14,938 DEBUG packaging: select group dial-up
>16:14:14,945 DEBUG packaging: select group printing
>16:14:15,019 DEBUG packaging: select group firefox
>16:14:15,022 DEBUG packaging: select group standard
>16:14:15,099 DEBUG packaging: select package kernel-PAE
>16:14:15,262 INFO packaging: no kernel-PAE package
>16:14:15,263 DEBUG packaging: select package kernel
>16:14:15,264 INFO packaging: selected kernel
>16:14:15,265 INFO packaging: checking dependencies
>16:14:23,775 DEBUG packaging: success
>16:14:23,824 INFO packaging: 1173 packages selected totalling 2.78 GB
>16:14:31,496 INFO packaging: checking software selection
>16:14:31,497 DEBUG packaging: deleting package sacks
>16:14:31,497 DEBUG packaging: deleting yum transaction info
>16:14:31,643 DEBUG packaging: select group core
>16:14:33,352 DEBUG packaging: select group core
>16:14:33,352 DEBUG packaging: select package kernel-PAE
>16:14:33,515 INFO packaging: no kernel-PAE package
>16:14:33,516 DEBUG packaging: select package kernel
>16:14:33,517 INFO packaging: selected kernel
>16:14:33,518 INFO packaging: checking dependencies
>16:14:35,911 DEBUG packaging: success
>16:14:35,921 INFO packaging: 197 packages selected totalling 588.71 MB
>16:14:39,501 DEBUG packaging: deleting package sacks
>
>
>/tmp/program.log:
>21:12:45,204 INFO program: Running... udevadm trigger --action=change --subsystem-match=block
>21:12:45,230 INFO program: Running... modprobe fcoe
>21:12:45,312 INFO program: Running... /usr/libexec/fcoe/fcoe_edd.sh -i
>21:12:45,372 INFO program: No FCoE boot disk information is found in EDD!
>21:12:45,397 INFO program: Running... udevadm settle --timeout=300
>21:12:45,466 INFO program: Running... multipath -d
>21:12:45,507 INFO program: Running... multipath -ll
>21:12:46,290 INFO program: Running... metacity --display :1 --sm-disable
>21:12:46,864 ERR program: GLib-GIO-Message: Using the 'memory' GSettings backend.  Your settings will not be saved or shared with other applications.
>21:12:47,029 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,054 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,056 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,064 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,087 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,098 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,113 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,119 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,122 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,124 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,129 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,132 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,134 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,137 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,138 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,149 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,151 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,152 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,155 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,158 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,170 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,174 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,176 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:47,177 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>21:12:48,146 INFO program: Running... udevadm control --property=ANACONDA=1
>21:12:48,189 INFO program: Running... udevadm trigger --action=change --subsystem-match=block
>21:12:48,210 INFO program: Running... systemctl start chronyd.service
>21:12:48,228 INFO program: Running... udevadm settle --timeout=300
>21:12:48,458 INFO program: Running... multipath -d
>21:12:48,499 INFO program: Running... multipath -ll
>21:12:49,352 INFO program: Running... /bin/mount -n -t btrfs -o defaults /dev/vda2 /tmp/btrfs-tmp.4zGDWC4
>21:12:49,370 INFO program: Running... btrfs subvol list /tmp/btrfs-tmp.4zGDWC4
>21:12:49,400 INFO program: ID 256 gen 12 top level 5 path home
>21:12:49,401 INFO program: ID 258 gen 26 top level 5 path root
>21:12:49,406 INFO program: Running... /bin/umount /tmp/btrfs-tmp.4zGDWC4
>21:12:49,703 INFO program: Running... dumpe2fs -h /dev/loop1
>21:12:49,742 INFO program: Filesystem volume name:   Anaconda
>21:12:49,744 INFO program: Last mounted on:          /
>21:12:49,744 INFO program: Filesystem UUID:          a59decfa-d0e7-4b63-b6ea-1ebe58898a3a
>21:12:49,745 INFO program: Filesystem magic number:  0xEF53
>21:12:49,746 INFO program: Filesystem revision #:    1 (dynamic)
>21:12:49,746 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype extent flex_bg sparse_super huge_file uninit_bg dir_nlink extra_isize
>21:12:49,747 INFO program: Filesystem flags:         signed_directory_hash 
>21:12:49,747 INFO program: Default mount options:    user_xattr acl
>21:12:49,748 INFO program: Filesystem state:         clean
>21:12:49,748 INFO program: Errors behavior:          Continue
>21:12:49,749 INFO program: Filesystem OS type:       Linux
>21:12:49,749 INFO program: Inode count:              65536
>21:12:49,750 INFO program: Block count:              1048576
>21:12:49,750 INFO program: Reserved block count:     0
>21:12:49,751 INFO program: Free blocks:              311419
>21:12:49,751 INFO program: Free inodes:              38266
>21:12:49,751 INFO program: First block:              1
>21:12:49,752 INFO program: Block size:               1024
>21:12:49,753 INFO program: Fragment size:            1024
>21:12:49,753 INFO program: Reserved GDT blocks:      256
>21:12:49,754 INFO program: Blocks per group:         8192
>21:12:49,754 INFO program: Fragments per group:      8192
>21:12:49,755 INFO program: Inodes per group:         512
>21:12:49,755 INFO program: Inode blocks per group:   128
>21:12:49,756 INFO program: Flex block group size:    16
>21:12:49,756 INFO program: Filesystem created:       Sat Nov  3 03:31:09 2012
>21:12:49,757 INFO program: Last mount time:          Sat Nov  3 03:31:22 2012
>21:12:49,761 INFO program: Last write time:          Sat Nov  3 03:31:29 2012
>21:12:49,761 INFO program: Mount count:              2
>21:12:49,762 INFO program: Maximum mount count:      -1
>21:12:49,762 INFO program: Last checked:             Sat Nov  3 03:31:09 2012
>21:12:49,763 INFO program: Check interval:           0 (<none>)
>21:12:49,763 INFO program: Lifetime writes:          32 MB
>21:12:49,764 INFO program: Reserved blocks uid:      0 (user root)
>21:12:49,764 INFO program: Reserved blocks gid:      0 (group root)
>21:12:49,765 INFO program: First inode:              11
>21:12:49,765 INFO program: Inode size:	          256
>21:12:49,766 INFO program: Required extra isize:     28
>21:12:49,766 INFO program: Desired extra isize:      28
>21:12:49,767 INFO program: Journal inode:            8
>21:12:49,767 INFO program: Default directory hash:   half_md4
>21:12:49,768 INFO program: Directory Hash Seed:      3a23509c-a72d-4104-aed6-94232ff9d524
>21:12:49,768 INFO program: Journal backup:           inode blocks
>21:12:49,769 INFO program: Journal features:         (none)
>21:12:49,769 INFO program: Journal size:             32M
>21:12:49,770 INFO program: Journal length:           32768
>21:12:49,770 INFO program: Journal sequence:         0x00000007
>21:12:49,770 INFO program: Journal start:            0
>21:12:49,771 INFO program: 
>21:12:49,771 ERR program: dumpe2fs 1.42.5 (29-Jul-2012)
>21:12:49,776 INFO program: Running... dumpe2fs -h /dev/loop1
>21:12:49,787 INFO program: Filesystem volume name:   Anaconda
>21:12:49,788 INFO program: Last mounted on:          /
>21:12:49,789 INFO program: Filesystem UUID:          a59decfa-d0e7-4b63-b6ea-1ebe58898a3a
>21:12:49,789 INFO program: Filesystem magic number:  0xEF53
>21:12:49,790 INFO program: Filesystem revision #:    1 (dynamic)
>21:12:49,790 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype extent flex_bg sparse_super huge_file uninit_bg dir_nlink extra_isize
>21:12:49,791 INFO program: Filesystem flags:         signed_directory_hash 
>21:12:49,791 INFO program: Default mount options:    user_xattr acl
>21:12:49,792 INFO program: Filesystem state:         clean
>21:12:49,792 INFO program: Errors behavior:          Continue
>21:12:49,793 INFO program: Filesystem OS type:       Linux
>21:12:49,793 INFO program: Inode count:              65536
>21:12:49,794 INFO program: Block count:              1048576
>21:12:49,794 INFO program: Reserved block count:     0
>21:12:49,795 INFO program: Free blocks:              311419
>21:12:49,795 INFO program: Free inodes:              38266
>21:12:49,796 INFO program: First block:              1
>21:12:49,799 INFO program: Block size:               1024
>21:12:49,800 INFO program: Fragment size:            1024
>21:12:49,800 INFO program: Reserved GDT blocks:      256
>21:12:49,801 INFO program: Blocks per group:         8192
>21:12:49,801 INFO program: Fragments per group:      8192
>21:12:49,802 INFO program: Inodes per group:         512
>21:12:49,802 INFO program: Inode blocks per group:   128
>21:12:49,803 INFO program: Flex block group size:    16
>21:12:49,803 INFO program: Filesystem created:       Sat Nov  3 03:31:09 2012
>21:12:49,804 INFO program: Last mount time:          Sat Nov  3 03:31:22 2012
>21:12:49,804 INFO program: Last write time:          Sat Nov  3 03:31:29 2012
>21:12:49,805 INFO program: Mount count:              2
>21:12:49,805 INFO program: Maximum mount count:      -1
>21:12:49,806 INFO program: Last checked:             Sat Nov  3 03:31:09 2012
>21:12:49,807 INFO program: Check interval:           0 (<none>)
>21:12:49,807 INFO program: Lifetime writes:          32 MB
>21:12:49,808 INFO program: Reserved blocks uid:      0 (user root)
>21:12:49,808 INFO program: Reserved blocks gid:      0 (group root)
>21:12:49,809 INFO program: First inode:              11
>21:12:49,809 INFO program: Inode size:	          256
>21:12:49,809 INFO program: Required extra isize:     28
>21:12:49,810 INFO program: Desired extra isize:      28
>21:12:49,814 INFO program: Journal inode:            8
>21:12:49,814 INFO program: Default directory hash:   half_md4
>21:12:49,815 INFO program: Directory Hash Seed:      3a23509c-a72d-4104-aed6-94232ff9d524
>21:12:49,815 INFO program: Journal backup:           inode blocks
>21:12:49,816 INFO program: Journal features:         (none)
>21:12:49,816 INFO program: Journal size:             32M
>21:12:49,816 INFO program: Journal length:           32768
>21:12:49,817 INFO program: Journal sequence:         0x00000007
>21:12:49,817 INFO program: Journal start:            0
>21:12:49,817 INFO program: 
>21:12:49,818 ERR program: dumpe2fs 1.42.5 (29-Jul-2012)
>21:12:49,818 INFO program: Running... resize2fs -P /dev/loop1
>21:12:49,854 INFO program: Couldn't find valid filesystem superblock.
>21:12:49,855 ERR program: resize2fs 1.42.5 (29-Jul-2012)
>21:12:49,856 ERR program: resize2fs: Device or resource busy while trying to open /dev/loop1
>21:12:49,939 INFO program: Running... udevadm settle --timeout=300
>21:12:50,030 INFO program: Running... dumpe2fs -h /dev/mapper/live-rw
>21:12:50,045 INFO program: Filesystem volume name:   Anaconda
>21:12:50,045 INFO program: Last mounted on:          /sysroot
>21:12:50,046 INFO program: Filesystem UUID:          a59decfa-d0e7-4b63-b6ea-1ebe58898a3a
>21:12:50,046 INFO program: Filesystem magic number:  0xEF53
>21:12:50,046 INFO program: Filesystem revision #:    1 (dynamic)
>21:12:50,047 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype needs_recovery extent flex_bg sparse_super huge_file uninit_bg dir_nlink extra_isize
>21:12:50,047 INFO program: Filesystem flags:         signed_directory_hash 
>21:12:50,047 INFO program: Default mount options:    user_xattr acl
>21:12:50,047 INFO program: Filesystem state:         clean
>21:12:50,048 INFO program: Errors behavior:          Continue
>21:12:50,048 INFO program: Filesystem OS type:       Linux
>21:12:50,048 INFO program: Inode count:              65536
>21:12:50,048 INFO program: Block count:              1048576
>21:12:50,049 INFO program: Reserved block count:     0
>21:12:50,049 INFO program: Free blocks:              311419
>21:12:50,049 INFO program: Free inodes:              38266
>21:12:50,050 INFO program: First block:              1
>21:12:50,050 INFO program: Block size:               1024
>21:12:50,050 INFO program: Fragment size:            1024
>21:12:50,050 INFO program: Reserved GDT blocks:      256
>21:12:50,051 INFO program: Blocks per group:         8192
>21:12:50,051 INFO program: Fragments per group:      8192
>21:12:50,051 INFO program: Inodes per group:         512
>21:12:50,055 INFO program: Inode blocks per group:   128
>21:12:50,056 INFO program: Flex block group size:    16
>21:12:50,056 INFO program: Filesystem created:       Sat Nov  3 03:31:09 2012
>21:12:50,056 INFO program: Last mount time:          Tue Nov  6 21:12:38 2012
>21:12:50,056 INFO program: Last write time:          Tue Nov  6 21:12:38 2012
>21:12:50,057 INFO program: Mount count:              3
>21:12:50,057 INFO program: Maximum mount count:      -1
>21:12:50,057 INFO program: Last checked:             Sat Nov  3 03:31:09 2012
>21:12:50,058 INFO program: Check interval:           0 (<none>)
>21:12:50,058 INFO program: Lifetime writes:          32 MB
>21:12:50,058 INFO program: Reserved blocks uid:      0 (user root)
>21:12:50,059 INFO program: Reserved blocks gid:      0 (group root)
>21:12:50,059 INFO program: First inode:              11
>21:12:50,059 INFO program: Inode size:	          256
>21:12:50,060 INFO program: Required extra isize:     28
>21:12:50,060 INFO program: Desired extra isize:      28
>21:12:50,060 INFO program: Journal inode:            8
>21:12:50,060 INFO program: Default directory hash:   half_md4
>21:12:50,061 INFO program: Directory Hash Seed:      3a23509c-a72d-4104-aed6-94232ff9d524
>21:12:50,061 INFO program: Journal backup:           inode blocks
>21:12:50,061 INFO program: Journal features:         (none)
>21:12:50,062 INFO program: Journal size:             32M
>21:12:50,062 INFO program: Journal length:           32768
>21:12:50,062 INFO program: Journal sequence:         0x00000008
>21:12:50,062 INFO program: Journal start:            1
>21:12:50,063 INFO program: 
>21:12:50,063 ERR program: dumpe2fs 1.42.5 (29-Jul-2012)
>21:12:50,064 INFO program: Running... dumpe2fs -h /dev/mapper/live-rw
>21:12:50,082 INFO program: Filesystem volume name:   Anaconda
>21:12:50,082 INFO program: Last mounted on:          /sysroot
>21:12:50,083 INFO program: Filesystem UUID:          a59decfa-d0e7-4b63-b6ea-1ebe58898a3a
>21:12:50,083 INFO program: Filesystem magic number:  0xEF53
>21:12:50,083 INFO program: Filesystem revision #:    1 (dynamic)
>21:12:50,083 INFO program: Filesystem features:      has_journal ext_attr resize_inode dir_index filetype needs_recovery extent flex_bg sparse_super huge_file uninit_bg dir_nlink extra_isize
>21:12:50,084 INFO program: Filesystem flags:         signed_directory_hash 
>21:12:50,084 INFO program: Default mount options:    user_xattr acl
>21:12:50,084 INFO program: Filesystem state:         clean
>21:12:50,085 INFO program: Errors behavior:          Continue
>21:12:50,085 INFO program: Filesystem OS type:       Linux
>21:12:50,085 INFO program: Inode count:              65536
>21:12:50,085 INFO program: Block count:              1048576
>21:12:50,086 INFO program: Reserved block count:     0
>21:12:50,086 INFO program: Free blocks:              311419
>21:12:50,086 INFO program: Free inodes:              38266
>21:12:50,086 INFO program: First block:              1
>21:12:50,087 INFO program: Block size:               1024
>21:12:50,087 INFO program: Fragment size:            1024
>21:12:50,087 INFO program: Reserved GDT blocks:      256
>21:12:50,091 INFO program: Blocks per group:         8192
>21:12:50,092 INFO program: Fragments per group:      8192
>21:12:50,092 INFO program: Inodes per group:         512
>21:12:50,092 INFO program: Inode blocks per group:   128
>21:12:50,093 INFO program: Flex block group size:    16
>21:12:50,093 INFO program: Filesystem created:       Sat Nov  3 03:31:09 2012
>21:12:50,093 INFO program: Last mount time:          Tue Nov  6 21:12:38 2012
>21:12:50,093 INFO program: Last write time:          Tue Nov  6 21:12:38 2012
>21:12:50,094 INFO program: Mount count:              3
>21:12:50,094 INFO program: Maximum mount count:      -1
>21:12:50,094 INFO program: Last checked:             Sat Nov  3 03:31:09 2012
>21:12:50,094 INFO program: Check interval:           0 (<none>)
>21:12:50,095 INFO program: Lifetime writes:          32 MB
>21:12:50,095 INFO program: Reserved blocks uid:      0 (user root)
>21:12:50,095 INFO program: Reserved blocks gid:      0 (group root)
>21:12:50,096 INFO program: First inode:              11
>21:12:50,096 INFO program: Inode size:	          256
>21:12:50,096 INFO program: Required extra isize:     28
>21:12:50,096 INFO program: Desired extra isize:      28
>21:12:50,097 INFO program: Journal inode:            8
>21:12:50,097 INFO program: Default directory hash:   half_md4
>21:12:50,097 INFO program: Directory Hash Seed:      3a23509c-a72d-4104-aed6-94232ff9d524
>21:12:50,098 INFO program: Journal backup:           inode blocks
>21:12:50,101 INFO program: Journal features:         (none)
>21:12:50,102 INFO program: Journal size:             32M
>21:12:50,102 INFO program: Journal length:           32768
>21:12:50,102 INFO program: Journal sequence:         0x00000008
>21:12:50,103 INFO program: Journal start:            1
>21:12:50,103 INFO program: 
>21:12:50,103 ERR program: dumpe2fs 1.42.5 (29-Jul-2012)
>21:12:50,104 INFO program: Running... resize2fs -P /dev/mapper/live-rw
>21:12:50,120 INFO program: Estimated minimum size of the filesystem: 734795
>21:12:50,121 ERR program: resize2fs 1.42.5 (29-Jul-2012)
>21:12:50,154 INFO program: Running... udevadm settle --timeout=300
>21:12:50,199 INFO program: Running... udevadm settle --timeout=300
>21:12:50,237 INFO program: Running... udevadm settle --timeout=300
>21:12:50,275 INFO program: Running... udevadm settle --timeout=300
>21:12:50,308 INFO program: Running... udevadm settle --timeout=300
>21:12:50,347 INFO program: Running... udevadm settle --timeout=300
>21:12:50,387 INFO program: Running... udevadm settle --timeout=300
>21:12:50,435 INFO program: Running... udevadm settle --timeout=300
>21:12:50,491 INFO program: Running... /bin/mount -n -t btrfs -o subvol=5,ro /dev/vda2 /mnt/sysimage
>21:12:50,504 ERR program: mount: mount(2) failed: No such file or directory
>21:12:50,519 INFO program: Running... udevadm settle --timeout=300
>16:13:19,420 INFO program: Running... modprobe xfs
>16:13:19,546 INFO program: Running... modprobe vfat
>16:14:01,083 INFO program: Running... udevadm settle --timeout=300
>21:14:01,146 INFO program: Running... /bin/mount -n -t iso9660 -o ro /dev/sr0 /mnt/install/isodir
>21:14:01,160 INFO program: Running... /bin/umount /mnt/install/isodir
>16:14:12,446 INFO program: Running... udevadm settle --timeout=300
>16:14:12,553 INFO program: Running... udevadm settle --timeout=300
>16:14:12,609 INFO program: Running... udevadm settle --timeout=300
>16:14:12,678 INFO program: Running... udevadm settle --timeout=300
>16:14:12,821 INFO program: Running... udevadm settle --timeout=300
>16:14:38,237 INFO program: Running... hwclock --systohc --utc
>16:14:39,512 INFO program: Running... udevadm settle --timeout=300
>16:14:39,599 INFO program: Running... udevadm settle --timeout=300
>16:14:39,626 INFO program: Running... udevadm settle --timeout=300
>16:14:39,647 INFO program: Running... udevadm settle --timeout=300
>16:14:39,680 INFO program: Running... udevadm settle --timeout=300
>21:14:39,728 INFO program: Running... /bin/mount -n -t btrfs -o defaults /dev/vda2 /tmp/btrfs-tmp.4khapiP
>16:14:39,748 INFO program: Running... btrfs subvol delete /tmp/btrfs-tmp.4khapiP/5
>16:14:39,763 ERR program: ERROR: error accessing '/tmp/btrfs-tmp.4khapiP/5'
>
>
>/tmp/storage.log:
>21:12:44,458 DEBUG storage: registered device format class MultipathMember as multipath_member
>21:12:44,460 DEBUG storage: registered device format class DMRaidMember as dmraidmember
>21:12:44,462 DEBUG storage: registered device format class BIOSBoot as biosboot
>21:12:44,463 DEBUG storage: registered device format class PPCPRePBoot as prepboot
>21:12:44,466 DEBUG storage: registered device format class SwapSpace as swap
>21:12:44,497 DEBUG storage: registered device format class LUKS as luks
>21:12:44,503 DEBUG storage: registered device format class MDRaidMember as mdmember
>21:12:44,509 DEBUG storage: registered device format class DiskLabel as disklabel
>21:12:44,512 DEBUG storage: registered device format class LVMPhysicalVolume as lvmpv
>21:12:44,538 DEBUG storage: registered device format class Ext2FS as ext2
>21:12:44,539 DEBUG storage: registered device format class Ext3FS as ext3
>21:12:44,539 DEBUG storage: registered device format class Ext4FS as ext4
>21:12:44,540 DEBUG storage: registered device format class FATFS as vfat
>21:12:44,540 DEBUG storage: registered device format class EFIFS as efi
>21:12:44,541 DEBUG storage: registered device format class BTRFS as btrfs
>21:12:44,541 DEBUG storage: registered device format class GFS2 as gfs2
>21:12:44,542 DEBUG storage: registered device format class JFS as jfs
>21:12:44,542 DEBUG storage: registered device format class ReiserFS as reiserfs
>21:12:44,543 DEBUG storage: registered device format class XFS as xfs
>21:12:44,544 DEBUG storage: registered device format class HFS as hfs
>21:12:44,544 DEBUG storage: registered device format class AppleBootstrapFS as appleboot
>21:12:44,545 DEBUG storage: registered device format class HFSPlus as hfs+
>21:12:44,545 DEBUG storage: registered device format class NTFS as ntfs
>21:12:44,546 DEBUG storage: registered device format class NFS as nfs
>21:12:44,546 DEBUG storage: registered device format class NFSv4 as nfs4
>21:12:44,547 DEBUG storage: registered device format class Iso9660FS as iso9660
>21:12:44,547 DEBUG storage: registered device format class NoDevFS as nodev
>21:12:44,548 DEBUG storage: registered device format class DevPtsFS as devpts
>21:12:44,548 DEBUG storage: registered device format class ProcFS as proc
>21:12:44,549 DEBUG storage: registered device format class SysFS as sysfs
>21:12:44,549 DEBUG storage: registered device format class TmpFS as tmpfs
>21:12:44,550 DEBUG storage: registered device format class BindFS as bind
>21:12:44,550 DEBUG storage: registered device format class SELinuxFS as selinuxfs
>21:12:44,551 DEBUG storage: registered device format class USBFS as usbfs
>21:12:45,446 DEBUG storage:      MultipathTopology._build_topology:
>21:12:45,447 DEBUG storage: /etc/multipath.conf contents:
>21:12:45,448 DEBUG storage: # multipath.conf written by anaconda
>21:12:45,448 DEBUG storage: 
>21:12:45,449 DEBUG storage: defaults {
>21:12:45,449 DEBUG storage: 	user_friendly_names yes
>21:12:45,450 DEBUG storage: }
>21:12:45,451 DEBUG storage: blacklist {
>21:12:45,451 DEBUG storage: 	devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
>21:12:45,452 DEBUG storage: 	devnode "^hd[a-z]"
>21:12:45,453 DEBUG storage: 	devnode "^dcssblk[0-9]*"
>21:12:45,454 DEBUG storage: 	device {
>21:12:45,454 DEBUG storage: 		vendor "DGC"
>21:12:45,455 DEBUG storage: 		product "LUNZ"
>21:12:45,455 DEBUG storage: 	}
>21:12:45,456 DEBUG storage: 	device {
>21:12:45,456 DEBUG storage: 		vendor "IBM"
>21:12:45,457 DEBUG storage: 		product "S/390.*"
>21:12:45,457 DEBUG storage: 	}
>21:12:45,458 DEBUG storage: 	# don't count normal SATA devices as multipaths
>21:12:45,458 DEBUG storage: 	device {
>21:12:45,458 DEBUG storage: 		vendor  "ATA"
>21:12:45,459 DEBUG storage: 	}
>21:12:45,459 DEBUG storage: 	# don't count 3ware devices as multipaths
>21:12:45,460 DEBUG storage: 	device {
>21:12:45,460 DEBUG storage: 		vendor  "3ware"
>21:12:45,461 DEBUG storage: 	}
>21:12:45,461 DEBUG storage: 	device {
>21:12:45,462 DEBUG storage: 		vendor  "AMCC"
>21:12:45,462 DEBUG storage: 	}
>21:12:45,463 DEBUG storage: 	# nor highpoint devices
>21:12:45,463 DEBUG storage: 	device {
>21:12:45,464 DEBUG storage: 		vendor  "HPT"
>21:12:45,464 DEBUG storage: 	}
>21:12:45,464 DEBUG storage: }
>21:12:45,465 DEBUG storage: multipaths {
>21:12:45,465 DEBUG storage: }
>21:12:45,466 DEBUG storage: (end of /etc/multipath.conf)
>21:12:45,525 INFO storage: MultipathTopology: found non-disk device: sr0
>21:12:45,527 INFO storage: MultipathTopology: found singlepath device: vda
>21:12:45,529 INFO storage: MultipathTopology: found non-disk device: vda1
>21:12:45,530 INFO storage: MultipathTopology: found non-disk device: vda2
>21:12:45,531 INFO storage: MultipathTopology: found singlepath device: loop0
>21:12:45,533 INFO storage: MultipathTopology: found singlepath device: loop1
>21:12:45,533 INFO storage: MultipathTopology: found singlepath device: loop2
>21:12:45,534 INFO storage: MultipathTopology: found singlepath device: loop3
>21:12:45,535 INFO storage: MultipathTopology: found singlepath device: loop4
>21:12:45,535 INFO storage: MultipathTopology: found singlepath device: loop5
>21:12:45,536 INFO storage: MultipathTopology: found singlepath device: loop6
>21:12:45,536 INFO storage: MultipathTopology: found singlepath device: loop7
>21:12:45,537 INFO storage: MultipathTopology: found singlepath device: dm-0
>21:12:48,223 INFO storage: not going to create backup copy of non-existent /etc/mdadm.conf
>21:12:48,225 INFO storage: DeviceTree.populate: ignoredDisks is [] ; exclusiveDisks is []
>21:12:48,378 DEBUG storage:           MultipathTopology._build_topology:
>21:12:48,384 DEBUG storage: /etc/multipath.conf contents:
>21:12:48,384 DEBUG storage: # multipath.conf written by anaconda
>21:12:48,385 DEBUG storage: 
>21:12:48,385 DEBUG storage: defaults {
>21:12:48,387 DEBUG storage: 	user_friendly_names yes
>21:12:48,390 DEBUG storage: }
>21:12:48,396 DEBUG storage: blacklist {
>21:12:48,402 DEBUG storage: 	devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
>21:12:48,409 DEBUG storage: 	devnode "^hd[a-z]"
>21:12:48,410 DEBUG storage: 	devnode "^dcssblk[0-9]*"
>21:12:48,410 DEBUG storage: 	device {
>21:12:48,411 DEBUG storage: 		vendor "DGC"
>21:12:48,411 DEBUG storage: 		product "LUNZ"
>21:12:48,412 DEBUG storage: 	}
>21:12:48,412 DEBUG storage: 	device {
>21:12:48,413 DEBUG storage: 		vendor "IBM"
>21:12:48,413 DEBUG storage: 		product "S/390.*"
>21:12:48,414 DEBUG storage: 	}
>21:12:48,414 DEBUG storage: 	# don't count normal SATA devices as multipaths
>21:12:48,415 DEBUG storage: 	device {
>21:12:48,415 DEBUG storage: 		vendor  "ATA"
>21:12:48,416 DEBUG storage: 	}
>21:12:48,416 DEBUG storage: 	# don't count 3ware devices as multipaths
>21:12:48,417 DEBUG storage: 	device {
>21:12:48,418 DEBUG storage: 		vendor  "3ware"
>21:12:48,418 DEBUG storage: 	}
>21:12:48,419 DEBUG storage: 	device {
>21:12:48,419 DEBUG storage: 		vendor  "AMCC"
>21:12:48,453 DEBUG storage: 	}
>21:12:48,454 DEBUG storage: 	# nor highpoint devices
>21:12:48,455 DEBUG storage: 	device {
>21:12:48,455 DEBUG storage: 		vendor  "HPT"
>21:12:48,456 DEBUG storage: 	}
>21:12:48,456 DEBUG storage: }
>21:12:48,457 DEBUG storage: multipaths {
>21:12:48,457 DEBUG storage: }
>21:12:48,458 DEBUG storage: (end of /etc/multipath.conf)
>21:12:48,530 INFO storage: MultipathTopology: found non-disk device: sr0
>21:12:48,532 INFO storage: MultipathTopology: found singlepath device: vda
>21:12:48,533 INFO storage: MultipathTopology: found non-disk device: vda1
>21:12:48,535 INFO storage: MultipathTopology: found non-disk device: vda2
>21:12:48,536 INFO storage: MultipathTopology: found singlepath device: loop0
>21:12:48,537 INFO storage: MultipathTopology: found singlepath device: loop1
>21:12:48,538 INFO storage: MultipathTopology: found singlepath device: loop2
>21:12:48,539 INFO storage: MultipathTopology: found singlepath device: loop3
>21:12:48,539 INFO storage: MultipathTopology: found singlepath device: loop4
>21:12:48,540 INFO storage: MultipathTopology: found singlepath device: loop5
>21:12:48,540 INFO storage: MultipathTopology: found singlepath device: loop6
>21:12:48,541 INFO storage: MultipathTopology: found singlepath device: loop7
>21:12:48,541 INFO storage: MultipathTopology: found singlepath device: dm-0
>21:12:48,542 INFO storage: devices to scan: ['sr0', 'vda', 'vda1', 'vda2', 'loop0', 'loop1', 'loop2', 'loop3', 'loop4', 'loop5', 'loop6', 'loop7', 'dm-0']
>21:12:48,546 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVLINKS': '/dev/cdrom /dev/disk/by-id/ata-QEMU_DVD-ROM_QM00003 /dev/disk/by-label/Fedora\\x2018-Beta-TC7\\x20x86_64 /dev/disk/by-uuid/2012-11-03-03-36-26-00',
> 'DEVNAME': 'sr0',
> 'DEVPATH': '/devices/pci0000:00/0000:00:01.1/ata2/host1/target1:0:0/1:0:0:0/block/sr0',
> 'DEVTYPE': 'disk',
> 'ID_ATA': '1',
> 'ID_BUS': 'ata',
> 'ID_CDROM': '1',
> 'ID_CDROM_DVD': '1',
> 'ID_CDROM_MEDIA': '1',
> 'ID_CDROM_MEDIA_CD': '1',
> 'ID_CDROM_MEDIA_TRACK_COUNT_DATA': '1',
> 'ID_FS_LABEL': 'Fedora_18-Beta-TC7_x86_64',
> 'ID_FS_LABEL_ENC': 'Fedora\\x2018-Beta-TC7\\x20x86_64',
> 'ID_FS_TYPE': 'iso9660',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '2012-11-03-03-36-26-00',
> 'ID_FS_UUID_ENC': '2012-11-03-03-36-26-00',
> 'ID_MODEL': 'QEMU_DVD-ROM',
> 'ID_MODEL_ENC': 'QEMU\\x20DVD-ROM\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20',
> 'ID_PART_TABLE_TYPE': 'dos',
> 'ID_REVISION': '1.0.1',
> 'ID_SERIAL': 'QEMU_DVD-ROM_QM00003',
> 'ID_SERIAL_SHORT': 'QM00003',
> 'ID_TYPE': 'cd',
> 'MAJOR': '11',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':seat:systemd:uaccess:',
> 'USEC_INITIALIZED': '71399',
> 'name': 'sr0',
> 'symlinks': ['/dev/cdrom',
>              '/dev/disk/by-id/ata-QEMU_DVD-ROM_QM00003',
>              '/dev/disk/by-label/Fedora\\x2018-Beta-TC7\\x20x86_64',
>              '/dev/disk/by-uuid/2012-11-03-03-36-26-00'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:01.1/ata2/host1/target1:0:0/1:0:0:0/block/sr0'} ; name: sr0 ;
>21:12:48,560 INFO storage: scanning sr0 (/devices/pci0000:00/0000:00:01.1/ata2/host1/target1:0:0/1:0:0:0/block/sr0)...
>21:12:48,561 DEBUG storage:           DeviceTree.getDeviceByName: name: sr0 ;
>21:12:48,563 DEBUG storage:           DeviceTree.getDeviceByName returned None
>21:12:48,563 INFO storage: sr0 is a cdrom
>21:12:48,565 DEBUG storage:           DeviceTree.addUdevOpticalDevice:
>21:12:48,569 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:48,572 DEBUG storage:               OpticalDevice._setFormat: sr0 ; current: None ; type: None ;
>21:12:48,578 INFO storage: added cdrom sr0 (id 0) to device tree
>21:12:48,580 DEBUG storage:           OpticalDevice.mediaPresent: sr0 ; status: True ;
>21:12:48,582 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: sr0 ;
>21:12:48,584 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: sr0 ; label_type: dos ;
>21:12:48,596 DEBUG storage:             OpticalDevice.setup: sr0 ; status: True ; controllable: True ; orig: False ;
>21:12:48,598 DEBUG storage:              DiskLabel.__init__: device: /dev/sr0 ; labelType: dos ; exists: True ;
>21:12:48,629 WARN storage: disklabel detected but not usable on sr0
>21:12:48,630 INFO storage: type detected on 'sr0' is 'iso9660'
>21:12:48,632 DEBUG storage:              Iso9660FS.supported: supported: True ;
>21:12:48,633 DEBUG storage: getFormat('iso9660') returning Iso9660FS instance
>21:12:48,635 DEBUG storage:             OpticalDevice._setFormat: sr0 ; current: None ; type: iso9660 ;
>21:12:48,651 DEBUG storage:              OpticalDevice.mediaPresent: sr0 ; status: True ;
>21:12:48,661 DEBUG storage: looking up parted Device: /dev/sr0
>21:12:48,665 INFO storage: got device: OpticalDevice instance (0x7f11e1c3e690) --
>  name = sr0  status = True  kids = 0 id = 0
>  parents = []
>  uuid = None  size = 259.0
>  format = existing iso9660 filesystem
>  major = 11  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:01.1/ata2/host1/target1:0:0/1:0:0:0/block/sr0  partedDevice = parted.Device instance --
>  model: QEMU QEMU DVD-ROM  path: /dev/sr0  type: 1
>  sectorSize: 2048  physicalSectorSize:  2048
>  length: 132608  openCount: 0  readOnly: True
>  externalMode: False  dirty: False  bootDirty: False
>  host: 2  did: 0  busy: True
>  hardwareGeometry: (8, 255, 63)  biosGeometry: (8, 255, 63)
>  PedDevice: <_ped.Device object at 0x16b8dd0>
>  target size = 0  path = /dev/sr0
>  format args = []  originalFormat = None
>21:12:48,667 DEBUG storage:             Iso9660FS.supported: supported: True ;
>21:12:48,668 INFO storage: got format: Iso9660FS instance (0x7f11e1b68dd0) --
>  type = iso9660  name = iso9660  status = False
>  device = /dev/sr0  uuid = 2012-11-03-03-36-26-00  exists = True
>  options = ro  supported = True  formattable = False  resizable = False
>  mountpoint = None  mountopts = None
>  label = Fedora_18-Beta-TC7_x86_64  size = 0  targetSize = 0
>
>21:12:48,670 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'vda',
> 'DEVPATH': '/devices/pci0000:00/0000:00:06.0/virtio2/block/vda',
> 'DEVTYPE': 'disk',
> 'ID_PART_TABLE_TYPE': 'dos',
> 'MAJOR': '252',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '8751',
> 'name': 'vda',
> 'symlinks': [],
> 'sysfs_path': '/devices/pci0000:00/0000:00:06.0/virtio2/block/vda'} ; name: vda ;
>21:12:48,674 INFO storage: scanning vda (/devices/pci0000:00/0000:00:06.0/virtio2/block/vda)...
>21:12:48,676 DEBUG storage:           DeviceTree.getDeviceByName: name: vda ;
>21:12:48,677 DEBUG storage:           DeviceTree.getDeviceByName returned None
>21:12:48,678 DEBUG storage:           DeviceTree.addUdevDiskDevice: name: vda ;
>21:12:48,700 INFO storage: vda is a disk
>21:12:48,715 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:48,718 DEBUG storage:               DiskDevice._setFormat: vda ; current: None ; type: None ;
>21:12:48,722 INFO storage: added disk vda (id 1) to device tree
>21:12:48,723 DEBUG storage: looking up parted Device: /dev/vda
>21:12:48,729 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: vda ;
>21:12:48,734 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: vda ; label_type: dos ;
>21:12:48,739 DEBUG storage:             DiskDevice.setup: vda ; status: True ; controllable: True ; orig: False ;
>21:12:48,742 DEBUG storage:              DiskLabel.__init__: device: /dev/vda ; labelType: msdos ; exists: True ;
>21:12:48,755 DEBUG storage: Did not change pmbr_boot on parted.Disk instance --
>  type: msdos  primaryPartitionCount: 2
>  lastPartitionNumber: 2  maxPrimaryPartitionCount: 4
>  partitions: [<parted.partition.Partition object at 0x7f11e1bd7050>, <parted.partition.Partition object at 0x7f11e1bd7410>]
>  device: <parted.device.Device object at 0x7f11e1bcae50>
>  PedDisk: <_ped.Disk object at 0x7f11e1bd5d40>
>21:12:48,760 DEBUG storage: getFormat('disklabel') returning DiskLabel instance
>21:12:48,769 DEBUG storage:              DiskDevice._setFormat: vda ; current: None ; type: disklabel ;
>21:12:48,774 INFO storage: got device: DiskDevice instance (0x7f11e1b46c90) --
>  name = vda  status = True  kids = 0 id = 1
>  parents = []
>  uuid = None  size = 15360.0
>  format = existing msdos disklabel
>  major = 252  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:06.0/virtio2/block/vda  partedDevice = parted.Device instance --
>  model: Virtio Block Device  path: /dev/vda  type: 15
>  sectorSize: 512  physicalSectorSize:  512
>  length: 31457280  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (31207, 16, 63)  biosGeometry: (1958, 255, 63)
>  PedDevice: <_ped.Device object at 0x16b8ef0>
>  target size = 0  path = /dev/vda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7f11e1bcab50>
>21:12:48,776 INFO storage: got format: DiskLabel instance (0x7f11e1bcac50) --
>  type = disklabel  name = partition table (MSDOS)  status = False
>  device = /dev/vda  uuid = None  exists = True
>  options = None  supported = False  formattable = True  resizable = False
>  type = msdos  partition count = 2  sectorSize = 512
>  align_offset = 0  align_grain = 2048
>  partedDisk = parted.Disk instance --
>  type: msdos  primaryPartitionCount: 2
>  lastPartitionNumber: 2  maxPrimaryPartitionCount: 4
>  partitions: [<parted.partition.Partition object at 0x7f11e1bd7050>, <parted.partition.Partition object at 0x7f11e1bd7410>]
>  device: <parted.device.Device object at 0x7f11e1bcae50>
>  PedDisk: <_ped.Disk object at 0x7f11e1bd5d40>
>  origPartedDisk = <parted.disk.Disk object at 0x7f11e1bd7590>
>  partedDevice = parted.Device instance --
>  model: Virtio Block Device  path: /dev/vda  type: 15
>  sectorSize: 512  physicalSectorSize:  512
>  length: 31457280  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (31207, 16, 63)  biosGeometry: (1958, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f11e1bd6050>
>
>21:12:48,781 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'vda1',
> 'DEVPATH': '/devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda1',
> 'DEVTYPE': 'partition',
> 'ID_PART_ENTRY_DISK': '252:0',
> 'ID_PART_ENTRY_FLAGS': '0x80',
> 'ID_PART_ENTRY_NUMBER': '1',
> 'ID_PART_ENTRY_OFFSET': '2048',
> 'ID_PART_ENTRY_SCHEME': 'dos',
> 'ID_PART_ENTRY_SIZE': '1024000',
> 'ID_PART_ENTRY_TYPE': '0x83',
> 'ID_PART_TABLE_TYPE': 'dos',
> 'MAJOR': '252',
> 'MINOR': '1',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '8768',
> 'name': 'vda1',
> 'symlinks': [],
> 'sysfs_path': '/devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda1'} ; name: vda1 ;
>21:12:48,790 INFO storage: scanning vda1 (/devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda1)...
>21:12:48,792 DEBUG storage:           DeviceTree.getDeviceByName: name: vda1 ;
>21:12:48,793 DEBUG storage:           DeviceTree.getDeviceByName returned None
>21:12:48,795 INFO storage: vda1 is a partition
>21:12:48,796 DEBUG storage:           DeviceTree.addUdevPartitionDevice: name: vda1 ;
>21:12:48,806 DEBUG storage:            DeviceTree.getDeviceByName: name: vda ;
>21:12:48,812 DEBUG storage:            DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with existing msdos disklabel
>21:12:48,815 DEBUG storage:               DiskDevice.addChild: kids: 0 ; name: vda ;
>21:12:48,821 DEBUG storage:               PartitionDevice._setFormat: vda1 ;
>21:12:48,823 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:48,826 DEBUG storage:                PartitionDevice._setFormat: vda1 ; current: None ; type: None ;
>21:12:48,849 DEBUG storage: looking up parted Partition: /dev/vda1
>21:12:48,859 DEBUG storage:             PartitionDevice.probe: vda1 ; exists: True ;
>21:12:48,870 DEBUG storage:              PartitionDevice.getFlag: path: /dev/vda1 ; flag: 1 ;
>21:12:48,872 DEBUG storage:             PartitionDevice.getFlag: path: /dev/vda1 ; flag: 10 ;
>21:12:48,877 DEBUG storage:             PartitionDevice.getFlag: path: /dev/vda1 ; flag: 12 ;
>21:12:48,877 INFO storage: added partition vda1 (id 2) to device tree
>21:12:48,879 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: vda1 ;
>21:12:48,909 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: vda1 ; label_type: dos ;
>21:12:48,923 DEBUG storage:             PartitionDevice.setup: vda1 ; status: True ; controllable: True ; orig: False ;
>21:12:48,925 DEBUG storage:              DiskLabel.__init__: device: /dev/vda1 ; labelType: dos ; exists: True ;
>21:12:48,958 WARN storage: disklabel detected but not usable on vda1
>21:12:48,961 DEBUG storage: no type or existing type for vda1, bailing
>21:12:48,967 DEBUG storage: looking up parted Device: /dev/vda1
>21:12:48,969 INFO storage: got device: PartitionDevice instance (0x7f11e1bcad10) --
>  name = vda1  status = True  kids = 0 id = 2
>  parents = ['existing 15360MB disk vda (1) with existing msdos disklabel']
>  uuid = None  size = 500.0
>  format = existing None
>  major = 252  minor = 1  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda1  partedDevice = parted.Device instance --
>  model: Virtio Block Device  path: /dev/vda1  type: 15
>  sectorSize: 512  physicalSectorSize:  512
>  length: 1024000  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (1015, 16, 63)  biosGeometry: (63, 255, 63)
>  PedDevice: <_ped.Device object at 0x16b8d40>
>  target size = 0  path = /dev/vda1
>  format args = []  originalFormat = None  grow = None  max size = 0  bootable = True
>  part type = 0  primary = None
>  partedPartition = parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11e1bcaf10>  fileSystem: None
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11e1bd71d0>  PedPartition: <_ped.Partition object at 0x7f11e1bc8650>
>  disk = existing 15360MB disk vda (1) with existing msdos disklabel
>  start = 2048  end = 1026047  length = 1024000
>  flags = boot
>21:12:48,972 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVLINKS': '/dev/disk/by-label/fedora /dev/disk/by-uuid/5b678d48-5fc8-492a-9ce2-d99112a692b4',
> 'DEVNAME': 'vda2',
> 'DEVPATH': '/devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda2',
> 'DEVTYPE': 'partition',
> 'ID_BTRFS_READY': '1',
> 'ID_FS_LABEL': 'fedora',
> 'ID_FS_LABEL_ENC': 'fedora',
> 'ID_FS_TYPE': 'btrfs',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '5b678d48-5fc8-492a-9ce2-d99112a692b4',
> 'ID_FS_UUID_ENC': '5b678d48-5fc8-492a-9ce2-d99112a692b4',
> 'ID_FS_UUID_SUB': 'f6490e2a-bd5e-42c7-9051-b61676ef9b78',
> 'ID_FS_UUID_SUB_ENC': 'f6490e2a-bd5e-42c7-9051-b61676ef9b78',
> 'ID_PART_ENTRY_DISK': '252:0',
> 'ID_PART_ENTRY_NUMBER': '2',
> 'ID_PART_ENTRY_OFFSET': '1026048',
> 'ID_PART_ENTRY_SCHEME': 'dos',
> 'ID_PART_ENTRY_SIZE': '26298368',
> 'ID_PART_ENTRY_TYPE': '0x83',
> 'ID_PART_TABLE_TYPE': 'dos',
> 'MAJOR': '252',
> 'MINOR': '2',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '8780',
> 'name': 'vda2',
> 'symlinks': ['/dev/disk/by-label/fedora',
>              '/dev/disk/by-uuid/5b678d48-5fc8-492a-9ce2-d99112a692b4'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda2'} ; name: vda2 ;
>21:12:48,999 INFO storage: scanning vda2 (/devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda2)...
>21:12:49,022 DEBUG storage:           DeviceTree.getDeviceByName: name: vda2 ;
>21:12:49,097 DEBUG storage:           DeviceTree.getDeviceByName returned None
>21:12:49,185 INFO storage: vda2 is a partition
>21:12:49,187 DEBUG storage:           DeviceTree.addUdevPartitionDevice: name: vda2 ;
>21:12:49,192 DEBUG storage:            DeviceTree.getDeviceByName: name: vda ;
>21:12:49,193 DEBUG storage:            DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with existing msdos disklabel
>21:12:49,195 DEBUG storage:               DiskDevice.addChild: kids: 1 ; name: vda ;
>21:12:49,200 DEBUG storage:               PartitionDevice._setFormat: vda2 ;
>21:12:49,201 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:49,202 DEBUG storage:                PartitionDevice._setFormat: vda2 ; current: None ; type: None ;
>21:12:49,206 DEBUG storage: looking up parted Partition: /dev/vda2
>21:12:49,207 DEBUG storage:             PartitionDevice.probe: vda2 ; exists: True ;
>21:12:49,209 DEBUG storage:              PartitionDevice.getFlag: path: /dev/vda2 ; flag: 1 ;
>21:12:49,211 DEBUG storage:             PartitionDevice.getFlag: path: /dev/vda2 ; flag: 10 ;
>21:12:49,220 DEBUG storage:             PartitionDevice.getFlag: path: /dev/vda2 ; flag: 12 ;
>21:12:49,229 INFO storage: added partition vda2 (id 3) to device tree
>21:12:49,230 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: vda2 ;
>21:12:49,233 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: vda2 ; label_type: dos ;
>21:12:49,243 DEBUG storage:             PartitionDevice.setup: vda2 ; status: True ; controllable: True ; orig: False ;
>21:12:49,244 DEBUG storage:              DiskLabel.__init__: device: /dev/vda2 ; labelType: dos ; exists: True ;
>21:12:49,257 WARN storage: disklabel detected but not usable on vda2
>21:12:49,259 INFO storage: type detected on 'vda2' is 'btrfs'
>21:12:49,267 DEBUG storage:               BTRFS.supported: supported: True ;
>21:12:49,278 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>21:12:49,279 DEBUG storage:             PartitionDevice._setFormat: vda2 ;
>21:12:49,281 DEBUG storage:              PartitionDevice._setFormat: vda2 ; current: None ; type: btrfs ;
>21:12:49,282 DEBUG storage:            DeviceTree.handleBTRFSFormat: name: vda2 ;
>21:12:49,292 INFO storage: creating btrfs volume btrfs.fedora
>21:12:49,294 DEBUG storage:                 PartitionDevice.addChild: kids: 0 ; name: vda2 ;
>21:12:49,294 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:49,304 DEBUG storage:                  BTRFSVolumeDevice._setFormat: fedora ; current: None ; type: None ;
>21:12:49,306 DEBUG storage:                 BTRFS.supported: supported: True ;
>21:12:49,315 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>21:12:49,316 DEBUG storage:                BTRFSVolumeDevice._setFormat: btrfs.4 ; current: None ; type: btrfs ;
>21:12:49,316 INFO storage: added btrfs volume fedora (id 4) to device tree
>21:12:49,318 DEBUG storage:              BTRFSVolumeDevice.setup: fedora ; status: True ; controllable: True ; orig: True ;
>21:12:49,346 INFO storage: set SELinux context for mountpoint /tmp/btrfs-tmp.4zGDWC4 to None
>21:12:49,369 INFO storage: set SELinux context for newly mounted filesystem root at /tmp/btrfs-tmp.4zGDWC4 to None
>21:12:49,529 DEBUG storage:                BTRFS.supported: supported: True ;
>21:12:49,534 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>21:12:49,536 DEBUG storage:                 BTRFSVolumeDevice.addChild: kids: 0 ; name: fedora ;
>21:12:49,539 DEBUG storage:                 BTRFSSubVolumeDevice._setFormat: 5 ; current: None ; type: btrfs ;
>21:12:49,543 INFO storage: added btrfs subvolume 5 (id 5) to device tree
>21:12:49,549 DEBUG storage: looking up parted Device: /dev/vda2
>21:12:49,551 INFO storage: got device: PartitionDevice instance (0x7f11e1bcab90) --
>  name = vda2  status = True  kids = 1 id = 3
>  parents = ['existing 15360MB disk vda (1) with existing msdos disklabel']
>  uuid = None  size = 12841.0
>  format = existing btrfs filesystem
>  major = 252  minor = 2  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:06.0/virtio2/block/vda/vda2  partedDevice = parted.Device instance --
>  model: Virtio Block Device  path: /dev/vda2  type: 15
>  sectorSize: 512  physicalSectorSize:  512
>  length: 26298368  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (26089, 16, 63)  biosGeometry: (1636, 255, 63)
>  PedDevice: <_ped.Device object at 0x16b8f80>
>  target size = 0  path = /dev/vda2
>  format args = []  originalFormat = None  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11e1bcaf10>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11e1bd74d0>  PedPartition: <_ped.Partition object at 0x7f11e1bc85f0>
>  disk = existing 15360MB disk vda (1) with existing msdos disklabel
>  start = 1026048  end = 27324415  length = 26298368
>  flags = 
>21:12:49,553 DEBUG storage:             BTRFS.supported: supported: True ;
>21:12:49,557 INFO storage: got format: BTRFS instance (0x7f11e1bcadd0) --
>  type = btrfs  name = btrfs  status = False
>  device = /dev/vda2  uuid = f6490e2a-bd5e-42c7-9051-b61676ef9b78  exists = True
>  options = defaults  supported = True  formattable = True  resizable = False
>  mountpoint = None  mountopts = None
>  label = fedora  size = 0  targetSize = 0
>
>21:12:49,559 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop0',
> 'DEVPATH': '/devices/virtual/block/loop0',
> 'DEVTYPE': 'disk',
> 'ID_FS_TYPE': 'squashfs',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_VERSION': '1024.0',
> 'MAJOR': '7',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '17768',
> 'name': 'loop0',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop0'} ; name: loop0 ;
>21:12:49,560 INFO storage: scanning loop0 (/devices/virtual/block/loop0)...
>21:12:49,565 DEBUG storage:           DeviceTree.getDeviceByName: name: loop0 ;
>21:12:49,566 DEBUG storage:           DeviceTree.getDeviceByName returned None
>21:12:49,566 INFO storage: loop0 is a loop device
>21:12:49,568 DEBUG storage:           DeviceTree.addUdevLoopDevice: name: loop0 ;
>21:12:49,572 DEBUG storage:            DeviceTree.getDeviceByName: name: /run/install/repo/LiveOS/squashfs.img ;
>21:12:49,574 DEBUG storage:            DeviceTree.getDeviceByName returned None
>21:12:49,574 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:49,576 DEBUG storage:               FileDevice._setFormat: /run/install/repo/LiveOS/squashfs.img ; current: None ; type: None ;
>21:12:49,578 INFO storage: added file /run/install/repo/LiveOS/squashfs.img (id 6) to device tree
>21:12:49,580 DEBUG storage:               FileDevice.addChild: kids: 0 ; name: /run/install/repo/LiveOS/squashfs.img ;
>21:12:49,584 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:49,585 DEBUG storage:               LoopDevice._setFormat: loop0 ; current: None ; type: None ;
>21:12:49,586 INFO storage: added loop loop0 (id 7) to device tree
>21:12:49,587 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: loop0 ;
>21:12:49,590 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: loop0 ; label_type: None ;
>21:12:49,605 DEBUG storage: getFormat('squashfs') returning DeviceFormat instance
>21:12:49,607 DEBUG storage:             LoopDevice.setup: loop0 ; status: False ; controllable: False ; orig: False ;
>21:12:49,641 DEBUG storage:              DiskLabel.__init__: device: /dev/loop0 ; labelType: None ; exists: True ;
>21:12:49,651 WARN storage: disklabel detected but not usable on loop0
>21:12:49,652 INFO storage: type detected on 'loop0' is 'squashfs'
>21:12:49,663 DEBUG storage: getFormat('squashfs') returning DeviceFormat instance
>21:12:49,665 DEBUG storage:             LoopDevice._setFormat: loop0 ; current: None ; type: None ;
>21:12:49,665 INFO storage: got device: LoopDevice instance (0x7f11e1bed7d0) --
>  name = loop0  status = False  kids = 0 id = 7
>  parents = ['existing 0MB file /run/install/repo/LiveOS/squashfs.img (6)']
>  uuid = None  size = 0
>  format = existing None
>  major = 0  minor = 0  exists = True  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/loop0
>  format args = []  originalFormat = None
>21:12:49,670 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVLINKS': '/dev/disk/by-label/Anaconda /dev/disk/by-uuid/a59decfa-d0e7-4b63-b6ea-1ebe58898a3a',
> 'DEVNAME': 'loop1',
> 'DEVPATH': '/devices/virtual/block/loop1',
> 'DEVTYPE': 'disk',
> 'ID_FS_LABEL': 'Anaconda',
> 'ID_FS_LABEL_ENC': 'Anaconda',
> 'ID_FS_TYPE': 'ext4',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': 'a59decfa-d0e7-4b63-b6ea-1ebe58898a3a',
> 'ID_FS_UUID_ENC': 'a59decfa-d0e7-4b63-b6ea-1ebe58898a3a',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '7',
> 'MINOR': '1',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '17787',
> 'name': 'loop1',
> 'symlinks': ['/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/a59decfa-d0e7-4b63-b6ea-1ebe58898a3a'],
> 'sysfs_path': '/devices/virtual/block/loop1'} ; name: loop1 ;
>21:12:49,671 INFO storage: scanning loop1 (/devices/virtual/block/loop1)...
>21:12:49,672 DEBUG storage:           DeviceTree.getDeviceByName: name: loop1 ;
>21:12:49,677 DEBUG storage:           DeviceTree.getDeviceByName returned None
>21:12:49,678 INFO storage: loop1 is a loop device
>21:12:49,679 DEBUG storage:           DeviceTree.addUdevLoopDevice: name: loop1 ;
>21:12:49,680 DEBUG storage:            DeviceTree.getDeviceByName: name: /LiveOS/rootfs.img ;
>21:12:49,681 DEBUG storage:            DeviceTree.getDeviceByName returned None
>21:12:49,686 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:49,687 DEBUG storage:               FileDevice._setFormat: /LiveOS/rootfs.img ; current: None ; type: None ;
>21:12:49,687 INFO storage: added file /LiveOS/rootfs.img (id 8) to device tree
>21:12:49,689 DEBUG storage:               FileDevice.addChild: kids: 0 ; name: /LiveOS/rootfs.img ;
>21:12:49,689 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:49,691 DEBUG storage:               LoopDevice._setFormat: loop1 ; current: None ; type: None ;
>21:12:49,695 INFO storage: added loop loop1 (id 9) to device tree
>21:12:49,696 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: loop1 ;
>21:12:49,697 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: loop1 ; label_type: None ;
>21:12:49,701 DEBUG storage:               Ext4FS.supported: supported: True ;
>21:12:49,701 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>21:12:49,701 DEBUG storage: device loop1 does not contain a disklabel
>21:12:49,702 INFO storage: type detected on 'loop1' is 'ext4'
>21:12:49,856 DEBUG storage: padding min size from 0 up to 0
>21:12:49,858 DEBUG storage:              Ext4FS.supported: supported: True ;
>21:12:49,858 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>21:12:49,859 DEBUG storage:             LoopDevice._setFormat: loop1 ; current: None ; type: ext4 ;
>21:12:49,864 INFO storage: got device: LoopDevice instance (0x7f11e1bf2410) --
>  name = loop1  status = False  kids = 0 id = 9
>  parents = ['existing 0MB file /LiveOS/rootfs.img (8)']
>  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
>21:12:49,865 DEBUG storage:             Ext4FS.supported: supported: True ;
>21:12:49,866 INFO storage: got format: Ext4FS instance (0x7f11e1bf2890) --
>  type = ext4  name = ext4  status = False
>  device = /dev/loop1  uuid = a59decfa-d0e7-4b63-b6ea-1ebe58898a3a  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 1024.0  targetSize = 1024.0
>
>21:12:49,868 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop2',
> 'DEVPATH': '/devices/virtual/block/loop2',
> 'DEVTYPE': 'disk',
> 'ID_FS_TYPE': 'DM_snapshot_cow',
> 'ID_FS_USAGE': 'other',
> 'MAJOR': '7',
> 'MINOR': '2',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '17804',
> 'name': 'loop2',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop2'} ; name: loop2 ;
>21:12:49,872 INFO storage: scanning loop2 (/devices/virtual/block/loop2)...
>21:12:49,873 DEBUG storage:           DeviceTree.getDeviceByName: name: loop2 ;
>21:12:49,874 DEBUG storage:           DeviceTree.getDeviceByName returned None
>21:12:49,878 INFO storage: loop2 is a loop device
>21:12:49,880 DEBUG storage:           DeviceTree.addUdevLoopDevice: name: loop2 ;
>21:12:49,881 DEBUG storage:            DeviceTree.getDeviceByName: name: /overlay (deleted) ;
>21:12:49,882 DEBUG storage:            DeviceTree.getDeviceByName returned None
>21:12:49,882 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:49,888 DEBUG storage:               FileDevice._setFormat: /overlay (deleted) ; current: None ; type: None ;
>21:12:49,888 INFO storage: added file /overlay (deleted) (id 10) to device tree
>21:12:49,889 DEBUG storage:               FileDevice.addChild: kids: 0 ; name: /overlay (deleted) ;
>21:12:49,890 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:49,891 DEBUG storage:               LoopDevice._setFormat: loop2 ; current: None ; type: None ;
>21:12:49,895 INFO storage: added loop loop2 (id 11) to device tree
>21:12:49,896 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: loop2 ;
>21:12:49,897 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: loop2 ; label_type: None ;
>21:12:49,897 DEBUG storage: getFormat('DM_snapshot_cow') returning DeviceFormat instance
>21:12:49,902 DEBUG storage:             LoopDevice.setup: loop2 ; status: False ; controllable: False ; orig: False ;
>21:12:49,904 DEBUG storage:              DiskLabel.__init__: device: /dev/loop2 ; labelType: None ; exists: True ;
>21:12:49,908 WARN storage: disklabel detected but not usable on loop2
>21:12:49,913 INFO storage: type detected on 'loop2' is 'DM_snapshot_cow'
>21:12:49,914 DEBUG storage: getFormat('DM_snapshot_cow') returning DeviceFormat instance
>21:12:49,915 DEBUG storage:             LoopDevice._setFormat: loop2 ; current: None ; type: None ;
>21:12:49,915 INFO storage: got device: LoopDevice instance (0x7f11e1c02290) --
>  name = loop2  status = False  kids = 0 id = 11
>  parents = ['existing 0MB file /overlay (deleted) (10)']
>  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
>21:12:49,917 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop3',
> 'DEVPATH': '/devices/virtual/block/loop3',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '3',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '19721',
> 'name': 'loop3',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop3'} ; name: loop3 ;
>21:12:49,918 INFO storage: ignoring loop3 (/devices/virtual/block/loop3)
>21:12:49,922 DEBUG storage: lvm filter: adding loop3 to the reject list
>21:12:49,923 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop4',
> 'DEVPATH': '/devices/virtual/block/loop4',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '4',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '19742',
> 'name': 'loop4',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop4'} ; name: loop4 ;
>21:12:49,924 INFO storage: ignoring loop4 (/devices/virtual/block/loop4)
>21:12:49,924 DEBUG storage: lvm filter: adding loop4 to the reject list
>21:12:49,925 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop5',
> 'DEVPATH': '/devices/virtual/block/loop5',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '5',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '20615',
> 'name': 'loop5',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop5'} ; name: loop5 ;
>21:12:49,927 INFO storage: ignoring loop5 (/devices/virtual/block/loop5)
>21:12:49,928 DEBUG storage: lvm filter: adding loop5 to the reject list
>21:12:49,929 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop6',
> 'DEVPATH': '/devices/virtual/block/loop6',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '6',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '21306',
> 'name': 'loop6',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop6'} ; name: loop6 ;
>21:12:49,934 INFO storage: ignoring loop6 (/devices/virtual/block/loop6)
>21:12:49,934 DEBUG storage: lvm filter: adding loop6 to the reject list
>21:12:49,936 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop7',
> 'DEVPATH': '/devices/virtual/block/loop7',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '7',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '21816',
> 'name': 'loop7',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop7'} ; name: loop7 ;
>21:12:49,936 INFO storage: ignoring loop7 (/devices/virtual/block/loop7)
>21:12:49,936 DEBUG storage: lvm filter: adding loop7 to the reject list
>21:12:49,937 DEBUG storage: Skipping a device mapper drive (dm-0) for now
>21:12:49,983 INFO storage: devices to scan: ['dm-0']
>21:12:49,986 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVLINKS': '/dev/disk/by-id/dm-name-live-rw /dev/disk/by-label/Anaconda /dev/disk/by-uuid/a59decfa-d0e7-4b63-b6ea-1ebe58898a3a /dev/mapper/live-rw',
> 'DEVNAME': 'dm-0',
> 'DEVPATH': '/devices/virtual/block/dm-0',
> 'DEVTYPE': 'disk',
> 'DM_NAME': 'live-rw',
> 'DM_SUSPENDED': '0',
> 'DM_UDEV_DISABLE_LIBRARY_FALLBACK_FLAG': '1',
> 'DM_UDEV_PRIMARY_SOURCE_FLAG': '1',
> 'DM_UDEV_RULES_VSN': '2',
> 'ID_FS_LABEL': 'Anaconda',
> 'ID_FS_LABEL_ENC': 'Anaconda',
> 'ID_FS_TYPE': 'ext4',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': 'a59decfa-d0e7-4b63-b6ea-1ebe58898a3a',
> 'ID_FS_UUID_ENC': 'a59decfa-d0e7-4b63-b6ea-1ebe58898a3a',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '253',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '21792',
> 'name': 'dm-0',
> 'symlinks': ['/dev/disk/by-id/dm-name-live-rw',
>              '/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/a59decfa-d0e7-4b63-b6ea-1ebe58898a3a',
>              '/dev/mapper/live-rw'],
> 'sysfs_path': '/devices/virtual/block/dm-0'} ; name: live-rw ;
>21:12:49,990 INFO storage: scanning live-rw (/devices/virtual/block/dm-0)...
>21:12:49,991 DEBUG storage:           DeviceTree.getDeviceByName: name: live-rw ;
>21:12:49,992 DEBUG storage:           DeviceTree.getDeviceByName returned None
>21:12:49,992 INFO storage: live-rw is a device-mapper device
>21:12:49,993 DEBUG storage:           DeviceTree.addUdevDMDevice: name: live-rw ;
>21:12:49,998 DEBUG storage:            DeviceTree.getDeviceByName: name: loop1 ;
>21:12:50,000 DEBUG storage:            DeviceTree.getDeviceByName returned existing 0MB loop loop1 (9) with existing ext4 filesystem
>21:12:50,001 DEBUG storage:            DeviceTree.getDeviceByName: name: loop2 ;
>21:12:50,007 DEBUG storage:            DeviceTree.getDeviceByName returned existing 0MB loop loop2 (11)
>21:12:50,009 DEBUG storage:            DeviceTree.getDeviceByName: name: live-rw ;
>21:12:50,013 DEBUG storage:            DeviceTree.getDeviceByName returned None
>21:12:50,015 DEBUG storage:               LoopDevice.addChild: kids: 0 ; name: loop2 ;
>21:12:50,015 DEBUG storage: getFormat('None') returning DeviceFormat instance
>21:12:50,016 DEBUG storage:               DMDevice._setFormat: live-rw ; current: None ; type: None ;
>21:12:50,021 INFO storage: added dm live-rw (id 12) to device tree
>21:12:50,022 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: live-rw ;
>21:12:50,023 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: live-rw ; label_type: None ;
>21:12:50,024 DEBUG storage:               Ext4FS.supported: supported: True ;
>21:12:50,029 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>21:12:50,029 DEBUG storage: device live-rw does not contain a disklabel
>21:12:50,029 INFO storage: type detected on 'live-rw' is 'ext4'
>21:12:50,122 DEBUG storage: padding min size from 718 up to 789
>21:12:50,123 DEBUG storage:              Ext4FS.supported: supported: True ;
>21:12:50,124 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>21:12:50,125 DEBUG storage:             DMDevice._setFormat: live-rw ; current: None ; type: ext4 ;
>21:12:50,129 DEBUG storage: looking up parted Device: /dev/mapper/live-rw
>21:12:50,144 INFO storage: got device: DMDevice instance (0x7f11e17bef50) --
>  name = live-rw  status = True  kids = 0 id = 12
>  parents = ['existing 0MB loop loop2 (11)']
>  uuid = None  size = 1024.0
>  format = existing ext4 filesystem
>  major = 0  minor = 0  exists = True  protected = True
>  sysfs path = /devices/virtual/block/dm-0  partedDevice = parted.Device instance --
>  model: Linux device-mapper (snapshot)  path: /dev/mapper/live-rw  type: 12
>  sectorSize: 512  physicalSectorSize:  512
>  length: 2097152  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: True
>  hardwareGeometry: (130, 255, 63)  biosGeometry: (130, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f11e1bd6a70>
>  target size = 0  path = /dev/mapper/live-rw
>  format args = []  originalFormat = None  target = None  dmUuid = None
>21:12:50,153 DEBUG storage:             Ext4FS.supported: supported: True ;
>21:12:50,153 INFO storage: got format: Ext4FS instance (0x7f11e17d1410) --
>  type = ext4  name = ext4  status = False
>  device = /dev/mapper/live-rw  uuid = a59decfa-d0e7-4b63-b6ea-1ebe58898a3a  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 1024.0  targetSize = 1024.0
>
>21:12:50,194 DEBUG storage:           OpticalDevice.teardown: sr0 ; status: True ; controllable: True ;
>21:12:50,229 DEBUG storage:           PartitionDevice.teardown: vda1 ; status: True ; controllable: True ;
>21:12:50,231 DEBUG storage:             DeviceFormat.teardown: device: /dev/vda1 ; status: False ; type: None ;
>21:12:50,233 DEBUG storage:             DeviceFormat.teardown: device: /dev/vda1 ; status: False ; type: None ;
>21:12:50,267 DEBUG storage:              DiskDevice.teardown: vda ; status: True ; controllable: True ;
>21:12:50,269 DEBUG storage:                DiskLabel.teardown: device: /dev/vda ; status: False ; type: disklabel ;
>21:12:50,270 DEBUG storage:                DiskLabel.teardown: device: /dev/vda ; status: False ; type: disklabel ;
>21:12:50,306 DEBUG storage:           BTRFSSubVolumeDevice.teardown: 5 ; status: True ; controllable: True ;
>21:12:50,346 DEBUG storage:              BTRFSVolumeDevice.teardown: fedora ; status: True ; controllable: True ;
>21:12:50,386 DEBUG storage:                 PartitionDevice.teardown: vda2 ; status: True ; controllable: True ;
>21:12:50,426 DEBUG storage:                    DiskDevice.teardown: vda ; status: True ; controllable: True ;
>21:12:50,429 DEBUG storage:                      DiskLabel.teardown: device: /dev/vda ; status: False ; type: disklabel ;
>21:12:50,435 DEBUG storage:                      DiskLabel.teardown: device: /dev/vda ; status: False ; type: disklabel ;
>21:12:50,469 DEBUG storage:           LoopDevice.teardown: loop0 ; status: False ; controllable: False ;
>21:12:50,471 DEBUG storage:           LoopDevice.teardown: loop1 ; status: False ; controllable: False ;
>21:12:50,473 DEBUG storage:           DMDevice.teardown: live-rw ; status: True ; controllable: False ;
>21:12:50,477 INFO storage: not going to restore from backup of non-existent /etc/mdadm.conf
>21:12:50,478 INFO storage: edd: collected mbr signatures: {'vda': '0x00065fc2'}
>21:12:50,479 DEBUG storage: edd: data extracted from 0x80:
>	type: SCSI, ata_device: None
>	channel: 0, mbr_signature: 0x00065fc2
>	pci_dev: 00:06.0, scsi_id: 0
>	scsi_lun: 0, sectors: 31457280
>21:12:50,479 DEBUG storage: edd: matched 0x80 to vda using pci_dev
>21:12:50,481 DEBUG storage:         BTRFSSubVolumeDevice.setup: 5 ; status: True ; controllable: True ; orig: False ;
>21:12:50,487 INFO storage: set SELinux context for mountpoint /mnt/sysimage to system_u:object_r:mnt_t:s0
>21:12:50,505 WARN storage: mount of 5 as btrfs failed: mount failed: (32, 'mount: mount(2) failed: No such file or directory')
>21:12:50,513 DEBUG storage:         BTRFSSubVolumeDevice.teardown: 5 ; status: True ; controllable: True ;
>21:12:50,668 DEBUG storage:            BTRFS.supported: supported: True ;
>21:12:50,676 DEBUG storage:            BTRFS.supported: supported: True ;
>21:12:50,687 DEBUG storage:             Ext4FS.supported: supported: True ;
>21:12:50,692 DEBUG storage:            Ext4FS.supported: supported: True ;
>21:12:50,696 DEBUG storage:            OpticalDevice.mediaPresent: sr0 ; status: True ;
>21:12:50,702 DEBUG storage:            Iso9660FS.supported: supported: True ;
>21:12:50,706 DEBUG storage:             BTRFS.supported: supported: True ;
>21:12:50,963 DEBUG storage:          DeviceTree.getDeviceByPath: path: /dev/sr0 ;
>21:12:50,969 DEBUG storage:              OpticalDevice.mediaPresent: sr0 ; status: True ;
>21:12:50,971 DEBUG storage:          DeviceTree.getDeviceByPath returned existing 259MB cdrom sr0 (0) with existing iso9660 filesystem
>16:13:19,369 DEBUG storage:             Iso9660FS.supported: supported: True ;
>16:13:19,371 DEBUG storage:            Iso9660FS.supported: supported: True ;
>16:13:19,372 DEBUG storage:             NFSv4.supported: supported: False ;
>16:13:19,374 DEBUG storage:            NFSv4.supported: supported: False ;
>16:13:19,377 DEBUG storage:              SELinuxFS.supported: supported: False ;
>16:13:19,379 DEBUG storage:            SELinuxFS.supported: supported: False ;
>16:13:19,381 DEBUG storage:             Ext4FS.supported: supported: True ;
>16:13:19,382 DEBUG storage:            Ext4FS.supported: supported: True ;
>16:13:19,384 DEBUG storage:             Ext3FS.supported: supported: True ;
>16:13:19,386 DEBUG storage:            Ext3FS.supported: supported: True ;
>16:13:19,388 DEBUG storage:             Ext2FS.supported: supported: True ;
>16:13:19,390 DEBUG storage:            Ext2FS.supported: supported: True ;
>16:13:19,392 DEBUG storage:              SysFS.supported: supported: False ;
>16:13:19,393 DEBUG storage:            SysFS.supported: supported: False ;
>16:13:19,396 DEBUG storage:            MultipathMember.__init__:
>16:13:19,398 DEBUG storage:            SwapSpace.__init__:
>16:13:19,400 DEBUG storage:              ProcFS.supported: supported: False ;
>16:13:19,402 DEBUG storage:            ProcFS.supported: supported: False ;
>16:13:19,403 DEBUG storage:            DMRaidMember.__init__:
>16:13:19,405 DEBUG storage:              DevPtsFS.supported: supported: False ;
>16:13:19,407 DEBUG storage:            DevPtsFS.supported: supported: False ;
>16:13:19,408 DEBUG storage:              BTRFS.supported: supported: True ;
>16:13:19,410 DEBUG storage:              USBFS.supported: supported: False ;
>16:13:19,412 DEBUG storage:            USBFS.supported: supported: False ;
>16:13:19,414 DEBUG storage:            DiskLabel.__init__:
>16:13:19,414 INFO storage: DiskLabel.partedDevice returning None
>16:13:19,416 DEBUG storage:             HFSPlus.supported: supported: False ;
>16:13:19,418 DEBUG storage:            HFSPlus.supported: supported: False ;
>16:13:19,420 DEBUG storage:             XFS.supported: supported: True ;
>16:13:19,522 DEBUG storage:            XFS.supported: supported: True ;
>16:13:19,525 DEBUG storage:              TmpFS.supported: supported: False ;
>16:13:19,527 DEBUG storage:            TmpFS.supported: supported: False ;
>16:13:19,528 DEBUG storage:            LUKS.__init__:
>16:13:19,530 DEBUG storage:             NTFS.supported: supported: False ;
>16:13:19,532 DEBUG storage:            NTFS.supported: supported: False ;
>16:13:19,533 DEBUG storage:             BindFS.supported: supported: False ;
>16:13:19,535 DEBUG storage:            BindFS.supported: supported: False ;
>16:13:19,536 DEBUG storage:             HFS.supported: supported: False ;
>16:13:19,538 DEBUG storage:            HFS.supported: supported: False ;
>16:13:19,539 DEBUG storage:            LVMPhysicalVolume.__init__:
>16:13:19,541 DEBUG storage:             NFS.supported: supported: False ;
>16:13:19,543 DEBUG storage:            NFS.supported: supported: False ;
>16:13:19,545 DEBUG storage:             FATFS.supported: supported: True ;
>16:13:19,583 DEBUG storage:            FATFS.supported: supported: True ;
>16:13:19,586 DEBUG storage:              NoDevFS.supported: supported: False ;
>16:13:19,588 DEBUG storage:            NoDevFS.supported: supported: False ;
>16:13:19,590 DEBUG storage:            MDRaidMember.__init__:
>16:14:01,072 DEBUG storage:            OpticalDevice.mediaPresent: sr0 ; status: True ;
>16:14:01,076 INFO storage: updating format of device: existing 259MB cdrom sr0 (0) with existing iso9660 filesystem
>16:14:01,118 DEBUG storage:         DeviceTree.handleUdevDeviceFormat: name: sr0 ;
>16:14:01,119 DEBUG storage:          DeviceTree.handleUdevDiskLabelFormat: device: sr0 ; label_type: dos ;
>16:14:01,121 DEBUG storage:           OpticalDevice.setup: sr0 ; status: True ; controllable: True ; orig: False ;
>16:14:01,122 DEBUG storage:            DiskLabel.__init__: device: /dev/sr0 ; labelType: dos ; exists: True ;
>16:14:01,128 WARN storage: disklabel detected but not usable on sr0
>16:14:01,129 DEBUG storage: no type or existing type for sr0, bailing
>16:14:01,129 INFO storage: got format: existing iso9660 filesystem
>16:14:01,142 INFO storage: set SELinux context for mountpoint /mnt/install/isodir to system_u:object_r:var_run_t:s0
>16:14:12,430 DEBUG storage: removing vda1
>16:14:12,433 DEBUG storage:                  PartitionDevice.teardown: vda1 ; status: True ; controllable: True ;
>16:14:12,439 DEBUG storage:                    DeviceFormat.teardown: device: /dev/vda1 ; status: False ; type: None ;
>16:14:12,445 DEBUG storage:                    DeviceFormat.teardown: device: /dev/vda1 ; status: False ; type: None ;
>16:14:12,530 INFO storage: removed partition vda1 (id 2) from device tree
>16:14:12,533 DEBUG storage:                   DiskDevice.removeChild: kids: 2 ; name: vda ;
>16:14:12,534 INFO storage: registered action: [0] Destroy Device partition vda1 (id 2)
>16:14:12,534 DEBUG storage: removing vda2
>16:14:12,535 DEBUG storage: devices to remove: ['fedora', '5']
>16:14:12,536 DEBUG storage: leaves to remove: ['5']
>16:14:12,536 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:12,538 DEBUG storage:                   BTRFSSubVolumeDevice._setFormat: 5 ; current: btrfs ; type: None ;
>16:14:12,543 INFO storage: registered action: [1] Destroy Format btrfs filesystem on btrfs subvolume 5 (id 5)
>16:14:12,545 DEBUG storage:                  BTRFSSubVolumeDevice.teardown: 5 ; status: True ; controllable: True ;
>16:14:12,552 DEBUG storage:                    DeviceFormat.teardown: device: /dev/vda2 ; status: False ; type: None ;
>16:14:12,587 INFO storage: removed btrfs subvolume 5 (id 5) from device tree
>16:14:12,590 DEBUG storage:                   BTRFSVolumeDevice.removeChild: kids: 1 ; name: fedora ;
>16:14:12,591 INFO storage: registered action: [2] Destroy Device btrfs subvolume 5 (id 5)
>16:14:12,591 DEBUG storage: devices to remove: ['fedora']
>16:14:12,592 DEBUG storage: leaves to remove: ['fedora']
>16:14:12,596 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:12,598 DEBUG storage:                    BTRFSVolumeDevice._setFormat: fedora ; current: btrfs ; type: None ;
>16:14:12,599 INFO storage: registered action: [3] Destroy Format btrfs filesystem on btrfs volume btrfs.4 (id 4)
>16:14:12,601 DEBUG storage:                  BTRFSVolumeDevice.teardown: btrfs.4 ; status: True ; controllable: True ;
>16:14:12,605 DEBUG storage:                    DeviceFormat.teardown: device: /dev/vda2 ; status: False ; type: None ;
>16:14:12,648 INFO storage: removed btrfs volume btrfs.4 (id 4) from device tree
>16:14:12,651 DEBUG storage:                   PartitionDevice.removeChild: kids: 1 ; name: vda2 ;
>16:14:12,652 INFO storage: registered action: [4] Destroy Device btrfs volume btrfs.4 (id 4)
>16:14:12,654 DEBUG storage:                   PartitionDevice._setFormat: vda2 ;
>16:14:12,655 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:12,661 DEBUG storage:                    PartitionDevice._setFormat: vda2 ; current: btrfs ; type: None ;
>16:14:12,663 INFO storage: registered action: [5] Destroy Format btrfs filesystem on partition vda2 (id 3)
>16:14:12,671 DEBUG storage:                  PartitionDevice.teardown: vda2 ; status: True ; controllable: True ;
>16:14:12,674 DEBUG storage:                    DeviceFormat.teardown: device: /dev/vda2 ; status: False ; type: None ;
>16:14:12,715 INFO storage: removed partition vda2 (id 3) from device tree
>16:14:12,718 DEBUG storage:                   DiskDevice.removeChild: kids: 1 ; name: vda ;
>16:14:12,719 INFO storage: registered action: [6] Destroy Device partition vda2 (id 3)
>16:14:12,748 DEBUG storage: checking whether disk vda has an empty extended
>16:14:12,752 DEBUG storage: extended is None ; logicals is []
>16:14:12,757 DEBUG storage: clearpart: initializing vda
>16:14:12,760 DEBUG storage:            DiskLabel.teardown: device: /dev/vda ; status: False ; type: disklabel ;
>16:14:12,766 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:12,772 DEBUG storage:             DiskDevice._setFormat: vda ; current: disklabel ; type: None ;
>16:14:12,773 INFO storage: registered action: [7] Destroy Format msdos disklabel on disk vda (id 1)
>16:14:12,781 DEBUG storage:            DiskLabel.__init__: device: /dev/vda ; labelType: msdos ;
>16:14:12,783 DEBUG storage:              DiskLabel.freshPartedDisk: device: /dev/vda ; labelType: msdos ;
>16:14:12,788 DEBUG storage: Did not change pmbr_boot on parted.Disk instance --
>  type: msdos  primaryPartitionCount: 0
>  lastPartitionNumber: -1  maxPrimaryPartitionCount: 4
>  partitions: []
>  device: <parted.device.Device object at 0x7f11ea535e90>
>  PedDisk: <_ped.Disk object at 0x7f11d8ab5bd8>
>16:14:12,792 DEBUG storage: getFormat('disklabel') returning DiskLabel instance
>16:14:12,797 DEBUG storage:            DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>16:14:12,799 DEBUG storage:             DiskDevice._setFormat: vda ; current: None ; type: disklabel ;
>16:14:12,819 INFO storage: registered action: [8] Create Format msdos disklabel on disk vda (id 1)
>16:14:12,820 DEBUG storage: new disk order: []
>16:14:12,856 DEBUG storage:         DeviceTree.getDeviceByName: name: vda ;
>16:14:12,857 DEBUG storage:         DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with non-existent msdos disklabel
>16:14:12,865 DEBUG storage: doAutoPart: True
>16:14:12,866 DEBUG storage: encryptedAutoPart: False
>16:14:12,867 DEBUG storage: autoPartType: 1
>16:14:12,867 DEBUG storage: clearPartType: 2
>16:14:12,868 DEBUG storage: clearPartDisks: ['vda']
>16:14:12,870 DEBUG storage: autoPartitionRequests:
>PartSpec instance (0x7f11ea535f90) -- 
>  mountpoint = /  lv = True  singlePV = False  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024  maxSize = 51200  grow = True
>PartSpec instance (0x7f11ea535e50) -- 
>  mountpoint = /home  lv = True  singlePV = False  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500  maxSize = None  grow = True
>PartSpec instance (0x7f11ea535d50) -- 
>  mountpoint = /boot  lv = False  singlePV = False  btrfs = False
>  weight = 2000  fstype = ext4  encrypted = False
>  size = 500  maxSize = None  grow = False
>PartSpec instance (0x7f11ea5359d0) -- 
>  mountpoint = None  lv = False  singlePV = False  btrfs = False
>  weight = 5000  fstype = biosboot  encrypted = False
>  size = 1  maxSize = None  grow = False
>PartSpec instance (0x7f11ea535a10) -- 
>  mountpoint = None  lv = True  singlePV = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 2016  maxSize = None  grow = False
>
>16:14:12,871 DEBUG storage: storage.disks: ['vda']
>16:14:12,872 DEBUG storage: storage.partitioned: ['vda']
>16:14:12,876 DEBUG storage: all names: ['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/install/repo/LiveOS/squashfs.img', 'live-rw', 'loop0', 'loop1', 'loop2', 'sr0', 'vda']
>16:14:12,879 DEBUG storage:            DeviceTree.getDeviceByName: name: vda ;
>16:14:12,887 DEBUG storage:            DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with non-existent msdos disklabel
>16:14:12,891 DEBUG storage: resolved 'vda' to 'vda' (disk)
>16:14:12,892 DEBUG storage: boot disk: vda
>16:14:12,894 DEBUG storage:               BTRFS.supported: supported: True ;
>16:14:12,898 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>16:14:12,900 DEBUG storage:               DiskDevice.addChild: kids: 0 ; name: vda ;
>16:14:12,902 DEBUG storage:               PartitionDevice._setFormat: req0 ;
>16:14:12,903 DEBUG storage:                PartitionDevice._setFormat: req0 ; current: None ; type: btrfs ;
>16:14:12,908 DEBUG storage:             DiskDevice.removeChild: kids: 1 ; name: vda ;
>16:14:12,909 INFO storage: added partition req0 (id 13) to device tree
>16:14:12,910 INFO storage: registered action: [9] Create Device partition req0 (id 13)
>16:14:12,910 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:12,911 INFO storage: registered action: [10] Create Format btrfs filesystem on partition req0 (id 13)
>16:14:12,913 DEBUG storage: candidate disks: [DiskDevice instance (0x7f11e1b46c90) --
>  name = vda  status = True  kids = 0 id = 1
>  parents = []
>  uuid = None  size = 15360.0
>  format = non-existent msdos disklabel
>  major = 252  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:06.0/virtio2/block/vda  partedDevice = parted.Device instance --
>  model: Virtio Block Device  path: /dev/vda  type: 15
>  sectorSize: 512  physicalSectorSize:  512
>  length: 31457280  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (31207, 16, 63)  biosGeometry: (1958, 255, 63)
>  PedDevice: <_ped.Device object at 0x16b8ef0>
>  target size = 0  path = /dev/vda
>  format args = []  originalFormat = disklabel  removable = False  partedDevice = <parted.device.Device object at 0x7f11e1bcab50>]
>16:14:12,917 DEBUG storage: devs: [PartitionDevice instance (0x7f11ea8c7210) --
>  name = req0  status = False  kids = 0 id = 13
>  parents = []
>  uuid = None  size = 500
>  format = non-existent btrfs filesystem
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/req0
>  format args = []  originalFormat = btrfs  grow = True  max size = 0  bootable = None
>  part type = None  primary = False
>  partedPartition = None
>  disk = None
>]
>16:14:12,919 DEBUG storage: _is_valid_disklabel(vda) returning True
>16:14:12,919 DEBUG storage: _is_valid_size(vda) returning True
>16:14:12,920 DEBUG storage: _is_valid_location(vda) returning True
>16:14:12,920 DEBUG storage: _is_valid_format(vda) returning True
>16:14:12,921 DEBUG storage: is_valid_stage1_device(vda) returning True
>16:14:12,923 DEBUG storage:              Ext4FS.supported: supported: True ;
>16:14:12,927 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>16:14:12,929 DEBUG storage:               DiskDevice.addChild: kids: 0 ; name: vda ;
>16:14:12,931 DEBUG storage:               PartitionDevice._setFormat: req1 ;
>16:14:12,932 DEBUG storage:                PartitionDevice._setFormat: req1 ; current: None ; type: ext4 ;
>16:14:12,937 DEBUG storage:             DiskDevice.removeChild: kids: 1 ; name: vda ;
>16:14:12,938 INFO storage: added partition req1 (id 14) to device tree
>16:14:12,939 INFO storage: registered action: [11] Create Device partition req1 (id 14)
>16:14:12,939 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:12,940 INFO storage: registered action: [12] Create Format ext4 filesystem mounted at /boot on partition req1 (id 14)
>16:14:12,940 INFO storage: skipping unneeded stage1 biosboot request
>16:14:12,941 DEBUG storage: PartSpec instance (0x7f11ea5359d0) -- 
>  mountpoint = None  lv = False  singlePV = False  btrfs = False
>  weight = 5000  fstype = biosboot  encrypted = False
>  size = 1  maxSize = None  grow = False
>
>16:14:12,942 DEBUG storage: existing 15360MB disk vda (1) with non-existent msdos disklabel
>16:14:12,947 DEBUG storage:             SwapSpace.__init__: mountpoint: None ;
>16:14:12,948 DEBUG storage: getFormat('swap') returning SwapSpace instance
>16:14:12,951 DEBUG storage:               DiskDevice.addChild: kids: 0 ; name: vda ;
>16:14:12,958 DEBUG storage:               PartitionDevice._setFormat: req2 ;
>16:14:12,960 DEBUG storage:                PartitionDevice._setFormat: req2 ; current: None ; type: swap ;
>16:14:12,966 DEBUG storage:             DiskDevice.removeChild: kids: 1 ; name: vda ;
>16:14:12,967 INFO storage: added partition req2 (id 15) to device tree
>16:14:12,967 INFO storage: registered action: [13] Create Device partition req2 (id 15)
>16:14:12,968 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:12,969 INFO storage: registered action: [14] Create Format swap on partition req2 (id 15)
>16:14:12,971 DEBUG storage:           DiskDevice.setup: vda ; status: True ; controllable: True ; orig: False ;
>16:14:12,977 DEBUG storage: removing all non-preexisting partitions ['req0(id 13)', 'req1(id 14)', 'req2(id 15)'] from disk(s) ['vda']
>16:14:12,979 DEBUG storage: allocatePartitions: disks=['vda'] ; partitions=['req0(id 13)', 'req1(id 14)', 'req2(id 15)']
>16:14:12,983 DEBUG storage: removing all non-preexisting partitions ['req1(id 14)', 'req2(id 15)', 'req0(id 13)'] from disk(s) ['vda']
>16:14:12,985 DEBUG storage:              DeviceTree.getDeviceByName: name: vda ;
>16:14:12,987 DEBUG storage:              DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with non-existent msdos disklabel
>16:14:12,992 DEBUG storage: resolved 'vda' to 'vda' (disk)
>16:14:12,994 DEBUG storage:              DeviceTree.getDeviceByName: name: vda ;
>16:14:12,996 DEBUG storage:              DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with non-existent msdos disklabel
>16:14:12,997 DEBUG storage: resolved 'vda' to 'vda' (disk)
>16:14:12,997 DEBUG storage: allocating partition: req1 ; id: 14 ; disks: ['vda'] ;
>boot: True ; primary: False ; size: 500MB ; grow: False ; max_size: 0
>16:14:12,998 DEBUG storage: checking freespace on vda
>16:14:12,999 DEBUG storage: getBestFreeSpaceRegion: disk=/dev/vda part_type=0 req_size=500MB boot=True best=None grow=False
>16:14:13,003 DEBUG storage: current free range is 63-31457279 (15359MB)
>16:14:13,003 DEBUG storage: updating use_disk to vda, type: 0
>16:14:13,004 DEBUG storage: new free: 63-31457279 / 15359MB
>16:14:13,004 DEBUG storage: new free allows for 0 sectors of growth
>16:14:13,005 DEBUG storage: found free space for bootable request
>16:14:13,006 DEBUG storage: adjusted start sector from 63 to 2048
>16:14:13,007 DEBUG storage: created partition vda1 of 500MB and added it to /dev/vda
>16:14:13,012 DEBUG storage:             PartitionDevice._setPartedPartition: req1 ;
>16:14:13,013 DEBUG storage: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea8c75d0>  PedPartition: <_ped.Partition object at 0x7f11ea8ec890>
>16:14:13,015 DEBUG storage:             PartitionDevice._setDisk: vda1 ; new: vda ; old: None ;
>16:14:13,020 DEBUG storage:              DiskDevice.addChild: kids: 0 ; name: vda ;
>16:14:13,022 DEBUG storage:             PartitionDevice._setPartedPartition: vda1 ;
>16:14:13,023 DEBUG storage: device vda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea8c76d0>  PedPartition: <_ped.Partition object at 0x7f11ea8ec9b0>
>16:14:13,028 DEBUG storage:              DeviceTree.getDeviceByName: name: vda ;
>16:14:13,030 DEBUG storage:              DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with non-existent msdos disklabel
>16:14:13,031 DEBUG storage: resolved 'vda' to 'vda' (disk)
>16:14:13,032 DEBUG storage:              DeviceTree.getDeviceByName: name: vda ;
>16:14:13,037 DEBUG storage:              DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with non-existent msdos disklabel
>16:14:13,038 DEBUG storage: resolved 'vda' to 'vda' (disk)
>16:14:13,038 DEBUG storage: allocating partition: req2 ; id: 15 ; disks: ['vda'] ;
>boot: False ; primary: False ; size: 2016MB ; grow: False ; max_size: 0
>16:14:13,039 DEBUG storage: checking freespace on vda
>16:14:13,040 DEBUG storage: getBestFreeSpaceRegion: disk=/dev/vda part_type=0 req_size=2016MB boot=False best=None grow=False
>16:14:13,041 DEBUG storage: current free range is 63-2047 (0MB)
>16:14:13,042 DEBUG storage: current free range is 1026048-31457279 (14859MB)
>16:14:13,043 DEBUG storage: updating use_disk to vda, type: 0
>16:14:13,046 DEBUG storage: new free: 1026048-31457279 / 14859MB
>16:14:13,047 DEBUG storage: new free allows for 0 sectors of growth
>16:14:13,048 DEBUG storage: created partition vda2 of 2016MB and added it to /dev/vda
>16:14:13,050 DEBUG storage:             PartitionDevice._setPartedPartition: req2 ;
>16:14:13,051 DEBUG storage: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x1cb78d0>  PedPartition: <_ped.Partition object at 0x7f11ea8ec830>
>16:14:13,052 DEBUG storage:             PartitionDevice._setDisk: vda2 ; new: vda ; old: None ;
>16:14:13,057 DEBUG storage:              DiskDevice.addChild: kids: 1 ; name: vda ;
>16:14:13,059 DEBUG storage:             PartitionDevice._setPartedPartition: vda2 ;
>16:14:13,064 DEBUG storage: device vda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea88cad0>  PedPartition: <_ped.Partition object at 0x7f11ea8ec8f0>
>16:14:13,065 DEBUG storage:              DeviceTree.getDeviceByName: name: vda ;
>16:14:13,067 DEBUG storage:              DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with non-existent msdos disklabel
>16:14:13,068 DEBUG storage: resolved 'vda' to 'vda' (disk)
>16:14:13,069 DEBUG storage:              DeviceTree.getDeviceByName: name: vda ;
>16:14:13,074 DEBUG storage:              DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with non-existent msdos disklabel
>16:14:13,075 DEBUG storage: resolved 'vda' to 'vda' (disk)
>16:14:13,075 DEBUG storage: allocating partition: req0 ; id: 13 ; disks: ['vda'] ;
>boot: False ; primary: False ; size: 500MB ; grow: True ; max_size: 0
>16:14:13,076 DEBUG storage: checking freespace on vda
>16:14:13,077 DEBUG storage: getBestFreeSpaceRegion: disk=/dev/vda part_type=0 req_size=500MB boot=False best=None grow=True
>16:14:13,078 DEBUG storage: current free range is 63-2047 (0MB)
>16:14:13,078 DEBUG storage: current free range is 5154816-31457279 (12843MB)
>16:14:13,082 DEBUG storage: evaluating growth potential for new layout
>16:14:13,083 DEBUG storage: calculating growth for disk /dev/vda
>16:14:13,085 DEBUG storage:             PartitionDevice._setPartedPartition: req0 ;
>16:14:13,086 DEBUG storage: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea88cf10>  PedPartition: <_ped.Partition object at 0x7f11ea8ec7d0>
>16:14:13,087 DEBUG storage:             PartitionDevice._setDisk: vda3 ; new: vda ; old: None ;
>16:14:13,092 DEBUG storage:              DiskDevice.addChild: kids: 2 ; name: vda ;
>16:14:13,093 DEBUG storage: adding request 14 to chunk 31457217 (63-31457279) on /dev/vda
>16:14:13,094 DEBUG storage: adding request 15 to chunk 31457217 (63-31457279) on /dev/vda
>16:14:13,094 DEBUG storage: adding request 13 to chunk 31457217 (63-31457279) on /dev/vda
>16:14:13,095 DEBUG storage: Chunk.growRequests: 31457217 on /dev/vda start = 63  end = 31457279
>sectorSize = 512
>
>16:14:13,095 DEBUG storage: req: PartitionRequest instance --
>id = 14  name = vda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>16:14:13,096 DEBUG storage: req: PartitionRequest instance --
>id = 15  name = vda2  growable = False
>base = 4128768  growth = 0  max_grow = 0
>done = True
>16:14:13,097 DEBUG storage: req: PartitionRequest instance --
>id = 13  name = vda3  growable = True
>base = 1024000  growth = 0  max_grow = 4293943295
>done = False
>16:14:13,097 DEBUG storage: 1 requests and 25280449 (12343MB) left in chunk
>16:14:13,098 DEBUG storage: adding 25280449 (12343MB) to 13 (vda3)
>16:14:13,098 DEBUG storage: new grow amount for request 13 (vda3) is 25280449 units, or 12343MB
>16:14:13,102 DEBUG storage: request 14 (vda1) growth: 0 (0MB) size: 500MB
>16:14:13,103 DEBUG storage: request 15 (vda2) growth: 0 (0MB) size: 2016MB
>16:14:13,103 DEBUG storage: request 13 (vda3) growth: 25280449 (12343MB) size: 12843MB
>16:14:13,104 DEBUG storage: disk /dev/vda growth: 25280449 (12343MB)
>16:14:13,105 DEBUG storage:             PartitionDevice._setPartedPartition: vda3 ;
>16:14:13,106 DEBUG storage: device vda3 new partedPartition None
>16:14:13,107 DEBUG storage:             PartitionDevice._setDisk: req0 ; new: None ; old: vda ;
>16:14:13,109 DEBUG storage:              DiskDevice.removeChild: kids: 3 ; name: vda ;
>16:14:13,113 DEBUG storage: total growth: 25280449 sectors
>16:14:13,114 DEBUG storage: updating use_disk to vda, type: 0
>16:14:13,114 DEBUG storage: new free: 5154816-31457279 / 12843MB
>16:14:13,115 DEBUG storage: new free allows for 25280449 sectors of growth
>16:14:13,116 DEBUG storage: created partition vda3 of 500MB and added it to /dev/vda
>16:14:13,117 DEBUG storage:             PartitionDevice._setPartedPartition: req0 ;
>16:14:13,121 DEBUG storage: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea88c2d0>  PedPartition: <_ped.Partition object at 0x7f11ea8ec890>
>16:14:13,123 DEBUG storage:             PartitionDevice._setDisk: vda3 ; new: vda ; old: None ;
>16:14:13,124 DEBUG storage:              DiskDevice.addChild: kids: 2 ; name: vda ;
>16:14:13,126 DEBUG storage:             PartitionDevice._setPartedPartition: vda3 ;
>16:14:13,130 DEBUG storage: device vda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea88ce50>  PedPartition: <_ped.Partition object at 0x7f11ea8ec710>
>16:14:13,131 DEBUG storage: growPartitions: disks=['vda'], partitions=['vda3(id 13)', 'vda1(id 14)', 'vda2(id 15)']
>16:14:13,132 DEBUG storage: growable partitions are ['vda3']
>16:14:13,132 DEBUG storage: adding request 13 to chunk 31457217 (63-31457279) on /dev/vda
>16:14:13,133 DEBUG storage: adding request 14 to chunk 31457217 (63-31457279) on /dev/vda
>16:14:13,134 DEBUG storage: adding request 15 to chunk 31457217 (63-31457279) on /dev/vda
>16:14:13,134 DEBUG storage: disk vda has 1 chunks
>16:14:13,135 DEBUG storage: Chunk.growRequests: 31457217 on /dev/vda start = 63  end = 31457279
>sectorSize = 512
>
>16:14:13,135 DEBUG storage: req: PartitionRequest instance --
>id = 14  name = vda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>16:14:13,139 DEBUG storage: req: PartitionRequest instance --
>id = 15  name = vda2  growable = False
>base = 4128768  growth = 0  max_grow = 0
>done = True
>16:14:13,140 DEBUG storage: req: PartitionRequest instance --
>id = 13  name = vda3  growable = True
>base = 1024000  growth = 0  max_grow = 4293943295
>done = False
>16:14:13,140 DEBUG storage: 1 requests and 25280449 (12343MB) left in chunk
>16:14:13,141 DEBUG storage: adding 25280449 (12343MB) to 13 (vda3)
>16:14:13,141 DEBUG storage: new grow amount for request 13 (vda3) is 25280449 units, or 12343MB
>16:14:13,142 DEBUG storage: growing partitions on vda
>16:14:13,143 DEBUG storage: partition vda1 (14): 0
>16:14:13,143 DEBUG storage: new geometry for vda1: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x4034890>  PedGeometry: <_ped.Geometry object at 0x7f11ea88ce10>
>16:14:13,144 DEBUG storage: partition vda2 (15): 0
>16:14:13,145 DEBUG storage: new geometry for vda2: parted.Geometry instance --
>  start: 1026048  end: 5154815  length: 4128768
>  device: <parted.device.Device object at 0x4034890>  PedGeometry: <_ped.Geometry object at 0x7f11ea88cc90>
>16:14:13,145 DEBUG storage: partition vda3 (13): 0
>16:14:13,146 DEBUG storage: new geometry for vda3: parted.Geometry instance --
>  start: 5154816  end: 31457279  length: 26302464
>  device: <parted.device.Device object at 0x4034890>  PedGeometry: <_ped.Geometry object at 0x7f11ea88c350>
>16:14:13,147 DEBUG storage: removing all non-preexisting partitions ['vda1(id 14)', 'vda2(id 15)', 'vda3(id 13)'] from disk(s) ['vda']
>16:14:13,148 DEBUG storage:              PartitionDevice._setPartedPartition: vda1 ;
>16:14:13,152 DEBUG storage: device vda1 new partedPartition None
>16:14:13,154 DEBUG storage:              PartitionDevice._setDisk: req1 ; new: None ; old: vda ;
>16:14:13,155 DEBUG storage:               DiskDevice.removeChild: kids: 3 ; name: vda ;
>16:14:13,157 DEBUG storage:              PartitionDevice._setPartedPartition: vda2 ;
>16:14:13,161 DEBUG storage: device vda2 new partedPartition None
>16:14:13,163 DEBUG storage:              PartitionDevice._setDisk: req2 ; new: None ; old: vda ;
>16:14:13,164 DEBUG storage:               DiskDevice.removeChild: kids: 2 ; name: vda ;
>16:14:13,166 DEBUG storage:              PartitionDevice._setPartedPartition: vda3 ;
>16:14:13,170 DEBUG storage: device vda3 new partedPartition None
>16:14:13,172 DEBUG storage:              PartitionDevice._setDisk: req0 ; new: None ; old: vda ;
>16:14:13,173 DEBUG storage:               DiskDevice.removeChild: kids: 1 ; name: vda ;
>16:14:13,174 DEBUG storage: back from removeNewPartitions
>16:14:13,174 DEBUG storage: extended: None
>16:14:13,175 DEBUG storage: setting req1 new geometry: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x4034890>  PedGeometry: <_ped.Geometry object at 0x7f11ea88ce10>
>16:14:13,177 DEBUG storage:             PartitionDevice._setPartedPartition: req1 ;
>16:14:13,182 DEBUG storage: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea88c5d0>  PedPartition: <_ped.Partition object at 0x7f11ea8ec770>
>16:14:13,183 DEBUG storage:             PartitionDevice._setDisk: vda1 ; new: vda ; old: None ;
>16:14:13,185 DEBUG storage:              DiskDevice.addChild: kids: 0 ; name: vda ;
>16:14:13,187 DEBUG storage:             PartitionDevice._setPartedPartition: vda1 ;
>16:14:13,192 DEBUG storage: device vda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea88c610>  PedPartition: <_ped.Partition object at 0x7f11ea8ec9b0>
>16:14:13,193 DEBUG storage: setting req2 new geometry: parted.Geometry instance --
>  start: 1026048  end: 5154815  length: 4128768
>  device: <parted.device.Device object at 0x4034890>  PedGeometry: <_ped.Geometry object at 0x7f11ea88cc90>
>16:14:13,194 DEBUG storage:             PartitionDevice._setPartedPartition: req2 ;
>16:14:13,195 DEBUG storage: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea8c7650>  PedPartition: <_ped.Partition object at 0x7f11ea8ec230>
>16:14:13,200 DEBUG storage:             PartitionDevice._setDisk: vda2 ; new: vda ; old: None ;
>16:14:13,202 DEBUG storage:              DiskDevice.addChild: kids: 1 ; name: vda ;
>16:14:13,203 DEBUG storage:             PartitionDevice._setPartedPartition: vda2 ;
>16:14:13,208 DEBUG storage: device vda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea88c190>  PedPartition: <_ped.Partition object at 0x7f11ea8ec950>
>16:14:13,208 DEBUG storage: setting req0 new geometry: parted.Geometry instance --
>  start: 5154816  end: 31457279  length: 26302464
>  device: <parted.device.Device object at 0x4034890>  PedGeometry: <_ped.Geometry object at 0x7f11ea88c350>
>16:14:13,210 DEBUG storage:             PartitionDevice._setPartedPartition: req0 ;
>16:14:13,211 DEBUG storage: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x1cb78d0>  PedPartition: <_ped.Partition object at 0x7f11ea8eca10>
>16:14:13,216 DEBUG storage:             PartitionDevice._setDisk: vda3 ; new: vda ; old: None ;
>16:14:13,217 DEBUG storage:              DiskDevice.addChild: kids: 2 ; name: vda ;
>16:14:13,219 DEBUG storage:             PartitionDevice._setPartedPartition: vda3 ;
>16:14:13,223 DEBUG storage: device vda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea6cb550>  PedPartition: <_ped.Partition object at 0x7f11ea8a7770>
>16:14:13,224 DEBUG storage: fixing size of non-existent 500MB partition vda1 (14) with non-existent ext4 filesystem mounted at /boot at 500.00
>16:14:13,225 DEBUG storage: fixing size of non-existent 2016MB partition vda2 (15) with non-existent swap at 2016.00
>16:14:13,226 DEBUG storage: fixing size of non-existent 12843MB partition vda3 (13) with non-existent btrfs filesystem at 12843.00
>16:14:13,228 DEBUG storage: newBTRFS: args = () ; kwargs = {'parents': [PartitionDevice instance (0x7f11ea8c7210) --
>  name = vda3  status = False  kids = 0 id = 13
>  parents = ['existing 15360MB disk vda (1) with non-existent msdos disklabel']
>  uuid = None  size = 12843.0
>  format = non-existent btrfs filesystem
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/vda3
>  format args = []  originalFormat = btrfs  grow = False  max size = 0  bootable = False
>  part type = 0  primary = False
>  partedPartition = parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11ea535fd0>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11ea6cb550>  PedPartition: <_ped.Partition object at 0x7f11ea8a7770>
>  disk = existing 15360MB disk vda (1) with non-existent msdos disklabel
>  start = 5154816  end = 31457279  length = 26302464
>  flags = ]}
>16:14:13,234 DEBUG storage:                PartitionDevice.addChild: kids: 0 ; name: vda3 ;
>16:14:13,235 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:13,237 DEBUG storage:                 BTRFSVolumeDevice._setFormat: fedora ; current: None ; type: None ;
>16:14:13,238 DEBUG storage:                BTRFS.supported: supported: True ;
>16:14:13,240 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>16:14:13,242 DEBUG storage:               BTRFSVolumeDevice._setFormat: btrfs.16 ; current: None ; type: btrfs ;
>16:14:13,247 DEBUG storage:               BTRFS.supported: supported: True ;
>16:14:13,248 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>16:14:13,250 DEBUG storage:              BTRFSVolumeDevice._setFormat: btrfs.16 ; current: btrfs ; type: btrfs ;
>16:14:13,254 INFO storage: added btrfs volume fedora (id 16) to device tree
>16:14:13,255 INFO storage: registered action: [15] Create Device btrfs volume fedora (id 16)
>16:14:13,256 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:13,256 INFO storage: registered action: [16] Create Format btrfs filesystem on btrfs volume fedora (id 16)
>16:14:13,257 DEBUG storage: newBTRFS: args = () ; kwargs = {'mountpoint': '/', 'subvol': True, 'fmt_type': 'ext4', 'parents': [BTRFSVolumeDevice instance (0x4034310) --
>  name = fedora  status = False  kids = 0 id = 16
>  parents = ['non-existent 12843MB partition vda3 (13) with non-existent btrfs filesystem']
>  uuid = None  size = 12843.0
>  format = non-existent btrfs filesystem
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/vda3
>  format args = []  originalFormat = btrfs], 'size': 1024}
>16:14:13,260 DEBUG storage:                BTRFSVolumeDevice.addChild: kids: 0 ; name: fedora ;
>16:14:13,263 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:13,264 DEBUG storage:                BTRFSSubVolumeDevice._setFormat: root ; current: None ; type: None ;
>16:14:13,266 DEBUG storage:               BTRFS.supported: supported: True ;
>16:14:13,270 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>16:14:13,271 DEBUG storage:             BTRFSSubVolumeDevice._setFormat: root ; current: None ; type: btrfs ;
>16:14:13,272 INFO storage: added btrfs subvolume root (id 17) to device tree
>16:14:13,272 INFO storage: registered action: [17] Create Device btrfs subvolume root (id 17)
>16:14:13,273 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:13,273 INFO storage: registered action: [18] Create Format btrfs filesystem mounted at / on btrfs subvolume root (id 17)
>16:14:13,274 DEBUG storage: newBTRFS: args = () ; kwargs = {'mountpoint': '/home', 'subvol': True, 'fmt_type': 'ext4', 'parents': [BTRFSVolumeDevice instance (0x4034310) --
>  name = fedora  status = False  kids = 1 id = 16
>  parents = ['non-existent 12843MB partition vda3 (13) with non-existent btrfs filesystem']
>  uuid = None  size = 12843.0
>  format = non-existent btrfs filesystem
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/vda3
>  format args = []  originalFormat = btrfs], 'size': 500}
>16:14:13,276 DEBUG storage:                BTRFSVolumeDevice.addChild: kids: 1 ; name: fedora ;
>16:14:13,280 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:13,282 DEBUG storage:                BTRFSSubVolumeDevice._setFormat: home ; current: None ; type: None ;
>16:14:13,283 DEBUG storage:               BTRFS.supported: supported: True ;
>16:14:13,283 DEBUG storage: getFormat('btrfs') returning BTRFS instance
>16:14:13,285 DEBUG storage:             BTRFSSubVolumeDevice._setFormat: home ; current: None ; type: btrfs ;
>16:14:13,288 INFO storage: added btrfs subvolume home (id 18) to device tree
>16:14:13,289 INFO storage: registered action: [19] Create Device btrfs subvolume home (id 18)
>16:14:13,289 DEBUG storage: getFormat('None') returning DeviceFormat instance
>16:14:13,290 INFO storage: registered action: [20] Create Format btrfs filesystem mounted at /home on btrfs subvolume home (id 18)
>16:14:13,291 DEBUG storage:            DeviceTree.getDeviceByName: name: vda ;
>16:14:13,293 DEBUG storage:            DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with non-existent msdos disklabel
>16:14:13,297 DEBUG storage: resolved 'vda' to 'vda' (disk)
>16:14:13,298 DEBUG storage: stage1 device cannot be of type btrfs volume
>16:14:13,299 DEBUG storage: stage1 device cannot be of type btrfs subvolume
>16:14:13,299 DEBUG storage: stage1 device cannot be of type btrfs subvolume
>16:14:13,300 DEBUG storage: _is_valid_disklabel(vda) returning True
>16:14:13,300 DEBUG storage: _is_valid_size(vda) returning True
>16:14:13,301 DEBUG storage: _is_valid_location(vda) returning True
>16:14:13,301 DEBUG storage: _is_valid_format(vda) returning True
>16:14:13,301 DEBUG storage: is_valid_stage1_device(vda) returning True
>16:14:13,305 DEBUG storage: _is_valid_disklabel(vda) returning True
>16:14:13,308 DEBUG storage: _is_valid_size(vda) returning True
>16:14:13,308 DEBUG storage: _is_valid_location(vda) returning True
>16:14:13,309 DEBUG storage: _is_valid_format(vda) returning True
>16:14:13,313 DEBUG storage: is_valid_stage1_device(vda) returning True
>16:14:13,313 DEBUG storage: _is_valid_disklabel(vda1) returning True
>16:14:13,314 DEBUG storage: _is_valid_size(vda1) returning True
>16:14:13,314 DEBUG storage: _is_valid_location(vda1) returning True
>16:14:13,314 DEBUG storage: _is_valid_partition(vda1) returning True
>16:14:13,315 DEBUG storage: _is_valid_format(vda1) returning True
>16:14:13,315 DEBUG storage: is_valid_stage2_device(vda1) returning True
>16:14:13,317 DEBUG storage:          DeviceTree.getDeviceByName: name: vda ;
>16:14:13,318 DEBUG storage:          DeviceTree.getDeviceByName returned existing 15360MB disk vda (1) with non-existent msdos disklabel
>16:14:13,318 DEBUG storage: resolved 'vda' to 'vda' (disk)
>16:14:13,319 DEBUG storage: stage1 device cannot be of type btrfs volume
>16:14:13,323 DEBUG storage: stage1 device cannot be of type btrfs subvolume
>16:14:13,323 DEBUG storage: stage1 device cannot be of type btrfs subvolume
>16:14:13,324 DEBUG storage: _is_valid_disklabel(vda) returning True
>16:14:13,324 DEBUG storage: _is_valid_size(vda) returning True
>16:14:13,324 DEBUG storage: _is_valid_location(vda) returning True
>16:14:13,325 DEBUG storage: _is_valid_format(vda) returning True
>16:14:13,325 DEBUG storage: is_valid_stage1_device(vda) returning True
>16:14:13,333 DEBUG storage: _is_valid_disklabel(vda) returning True
>16:14:13,337 DEBUG storage: _is_valid_size(vda) returning True
>16:14:13,337 DEBUG storage: _is_valid_location(vda) returning True
>16:14:13,338 DEBUG storage: _is_valid_format(vda) returning True
>16:14:13,338 DEBUG storage: is_valid_stage1_device(vda) returning True
>16:14:13,338 DEBUG storage: _is_valid_disklabel(vda1) returning True
>16:14:13,339 DEBUG storage: _is_valid_size(vda1) returning True
>16:14:13,339 DEBUG storage: _is_valid_location(vda1) returning True
>16:14:13,339 DEBUG storage: _is_valid_partition(vda1) returning True
>16:14:13,340 DEBUG storage: _is_valid_format(vda1) returning True
>16:14:13,340 DEBUG storage: is_valid_stage2_device(vda1) returning True
>16:14:39,510 DEBUG storage:         OpticalDevice.teardown: sr0 ; status: True ; controllable: True ;
>16:14:39,535 DEBUG storage:         LoopDevice.teardown: loop0 ; status: False ; controllable: False ;
>16:14:39,537 DEBUG storage:         LoopDevice.teardown: loop1 ; status: False ; controllable: False ;
>16:14:39,539 DEBUG storage:         DMDevice.teardown: live-rw ; status: True ; controllable: False ;
>16:14:39,541 DEBUG storage:         PartitionDevice.teardown: vda1 ; status: False ; controllable: True ;
>16:14:39,542 DEBUG storage:         PartitionDevice.teardown: vda2 ; status: False ; controllable: True ;
>16:14:39,543 DEBUG storage:         BTRFSSubVolumeDevice.teardown: root ; status: False ; controllable: True ;
>16:14:39,544 DEBUG storage:         BTRFSSubVolumeDevice.teardown: home ; status: False ; controllable: True ;
>16:14:39,545 INFO storage: resetting parted disks...
>16:14:39,546 DEBUG storage:          DiskLabel.resetPartedDisk: device: /dev/vda ;
>16:14:39,548 DEBUG storage:          DiskLabel.resetPartedDisk: device: /dev/vda ;
>16:14:39,549 DEBUG storage:          PartitionDevice.preCommitFixup: vda3 ;
>16:14:39,550 DEBUG storage:          PartitionDevice.preCommitFixup: vda1 ;
>16:14:39,552 DEBUG storage:          PartitionDevice.preCommitFixup: vda2 ;
>16:14:39,553 DEBUG storage:          PartitionDevice.preCommitFixup: vda1 ;
>16:14:39,555 DEBUG storage: sector-based lookup found partition vda1
>16:14:39,556 DEBUG storage:            PartitionDevice._setPartedPartition: vda1 ;
>16:14:39,559 DEBUG storage: device vda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11e1bd7590>  fileSystem: None
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x4249290>  PedPartition: <_ped.Partition object at 0x7f11dae5ee30>
>16:14:39,561 DEBUG storage:          PartitionDevice.preCommitFixup: vda2 ;
>16:14:39,562 DEBUG storage: sector-based lookup found partition vda2
>16:14:39,563 DEBUG storage:            PartitionDevice._setPartedPartition: vda2 ;
>16:14:39,564 DEBUG storage: device vda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f11e1bd7590>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f11e1bd71d0>  PedPartition: <_ped.Partition object at 0x7f11e1bc8650>
>16:14:39,565 DEBUG storage: action: [0] Destroy Device partition vda1 (id 2)
>16:14:39,566 DEBUG storage: action: [1] Destroy Format btrfs filesystem on btrfs subvolume 5 (id 5)
>16:14:39,566 DEBUG storage: action: [2] Destroy Device btrfs subvolume 5 (id 5)
>16:14:39,567 DEBUG storage: action: [3] Destroy Format btrfs filesystem on btrfs volume btrfs.4 (id 4)
>16:14:39,567 DEBUG storage: action: [4] Destroy Device btrfs volume btrfs.4 (id 4)
>16:14:39,568 DEBUG storage: action: [5] Destroy Format btrfs filesystem on partition vda2 (id 3)
>16:14:39,568 DEBUG storage: action: [6] Destroy Device partition vda2 (id 3)
>16:14:39,569 DEBUG storage: action: [7] Destroy Format msdos disklabel on disk vda (id 1)
>16:14:39,570 DEBUG storage: action: [8] Create Format msdos disklabel on disk vda (id 1)
>16:14:39,570 DEBUG storage: action: [9] Create Device partition vda3 (id 13)
>16:14:39,571 DEBUG storage: action: [10] Create Format btrfs filesystem on partition vda3 (id 13)
>16:14:39,571 DEBUG storage: action: [11] Create Device partition vda1 (id 14)
>16:14:39,572 DEBUG storage: action: [12] Create Format ext4 filesystem mounted at /boot on partition vda1 (id 14)
>16:14:39,572 DEBUG storage: action: [13] Create Device partition vda2 (id 15)
>16:14:39,573 DEBUG storage: action: [14] Create Format swap on partition vda2 (id 15)
>16:14:39,573 DEBUG storage: action: [15] Create Device btrfs volume fedora (id 16)
>16:14:39,574 DEBUG storage: action: [16] Create Format btrfs filesystem on btrfs volume fedora (id 16)
>16:14:39,575 DEBUG storage: action: [17] Create Device btrfs subvolume root (id 17)
>16:14:39,575 DEBUG storage: action: [18] Create Format btrfs filesystem mounted at / on btrfs subvolume root (id 17)
>16:14:39,576 DEBUG storage: action: [19] Create Device btrfs subvolume home (id 18)
>16:14:39,576 DEBUG storage: action: [20] Create Format btrfs filesystem mounted at /home on btrfs subvolume home (id 18)
>16:14:39,577 INFO storage: pruning action queue...
>16:14:39,578 INFO storage: sorting actions...
>16:14:39,581 DEBUG storage: action: [1] Destroy Format btrfs filesystem on btrfs subvolume 5 (id 5)
>16:14:39,582 DEBUG storage: action: [2] Destroy Device btrfs subvolume 5 (id 5)
>16:14:39,582 DEBUG storage: action: [3] Destroy Format btrfs filesystem on btrfs volume btrfs.4 (id 4)
>16:14:39,585 DEBUG storage: action: [4] Destroy Device btrfs volume btrfs.4 (id 4)
>16:14:39,586 DEBUG storage: action: [5] Destroy Format btrfs filesystem on partition vda2 (id 3)
>16:14:39,587 DEBUG storage: action: [6] Destroy Device partition vda2 (id 3)
>16:14:39,588 DEBUG storage: action: [0] Destroy Device partition vda1 (id 2)
>16:14:39,588 DEBUG storage: action: [7] Destroy Format msdos disklabel on disk vda (id 1)
>16:14:39,589 DEBUG storage: action: [8] Create Format msdos disklabel on disk vda (id 1)
>16:14:39,590 DEBUG storage: action: [11] Create Device partition vda1 (id 14)
>16:14:39,590 DEBUG storage: action: [13] Create Device partition vda2 (id 15)
>16:14:39,591 DEBUG storage: action: [14] Create Format swap on partition vda2 (id 15)
>16:14:39,591 DEBUG storage: action: [9] Create Device partition vda3 (id 13)
>16:14:39,592 DEBUG storage: action: [10] Create Format btrfs filesystem on partition vda3 (id 13)
>16:14:39,592 DEBUG storage: action: [15] Create Device btrfs volume fedora (id 16)
>16:14:39,593 DEBUG storage: action: [16] Create Format btrfs filesystem on btrfs volume fedora (id 16)
>16:14:39,594 DEBUG storage: action: [19] Create Device btrfs subvolume home (id 18)
>16:14:39,595 DEBUG storage: action: [20] Create Format btrfs filesystem mounted at /home on btrfs subvolume home (id 18)
>16:14:39,595 DEBUG storage: action: [17] Create Device btrfs subvolume root (id 17)
>16:14:39,596 DEBUG storage: action: [18] Create Format btrfs filesystem mounted at / on btrfs subvolume root (id 17)
>16:14:39,596 DEBUG storage: action: [12] Create Format ext4 filesystem mounted at /boot on partition vda1 (id 14)
>16:14:39,597 INFO storage: executing action: [1] Destroy Format btrfs filesystem on btrfs subvolume 5 (id 5)
>16:14:39,598 DEBUG storage:           BTRFSSubVolumeDevice.setup: 5 ; status: True ; controllable: True ; orig: True ;
>16:14:39,622 DEBUG storage:           BTRFSSubVolumeDevice.teardown: 5 ; status: True ; controllable: True ;
>16:14:39,625 DEBUG storage:             DeviceFormat.teardown: device: /dev/vda2 ; status: False ; type: None ;
>16:14:39,670 INFO storage: executing action: [2] Destroy Device btrfs subvolume 5 (id 5)
>16:14:39,672 DEBUG storage:           BTRFSSubVolumeDevice.destroy: 5 ; status: True ;
>16:14:39,674 DEBUG storage:              BTRFSSubVolumeDevice.teardown: 5 ; status: True ; controllable: True ;
>16:14:39,678 DEBUG storage:                DeviceFormat.teardown: device: /dev/vda2 ; status: False ; type: None ;
>16:14:39,705 DEBUG storage:             BTRFSSubVolumeDevice.setupParents: kids: 0 ; name: 5 ; orig: True ;
>16:14:39,707 DEBUG storage:              BTRFSVolumeDevice.setup: btrfs.4 ; status: True ; controllable: True ; orig: True ;
>16:14:39,709 DEBUG storage:            BTRFSSubVolumeDevice._destroy: 5 ; status: True ;
>16:14:39,723 INFO storage: set SELinux context for mountpoint /tmp/btrfs-tmp.4khapiP to None
>16:14:39,747 INFO storage: set SELinux context for newly mounted filesystem root at /tmp/btrfs-tmp.4khapiP to None
>
>
>/tmp/ifcfg.log:
>21:12:48,152 DEBUG ifcfg: NetworkDevice eth0: setDefaultConfig()
>21:12:48,153 DEBUG ifcfg: NetworkDevice eth0 set: DEVICE=eth0 BOOTPROTO=dhcp ONBOOT=no
>21:12:48,154 DEBUG ifcfg: NetworkDevice eth0 set: HWADDR=52:54:00:C8:E7:E9
>21:12:48,155 DEBUG ifcfg: NetworkDevice eth0 set: UUID=a91bf322-9a36-4dc5-9684-2bbaf86f38de
>21:12:48,155 DEBUG ifcfg: /etc/sysconfig/network-scripts/ifcfg-eth0:
>
>21:12:48,156 DEBUG ifcfg: NetworkDevice eth0:
>DEVICE="eth0"
>HWADDR="52:54:00:C8:E7:E9"
>BOOTPROTO="dhcp"
>ONBOOT="no"
>UUID="a91bf322-9a36-4dc5-9684-2bbaf86f38de"
>
>21:12:48,156 DEBUG ifcfg: writeIfcfgFile eth0 to /etc/sysconfig/network-scripts/ifcfg-eth0
>
>
>/proc/cmdline:
>initrd=initrd.img inst.stage2=hd:LABEL=Fedora\x2018-Beta-TC7\x20x86_64 quiet BOOT_IMAGE=vmlinuz 
>
>
>/tmp/syslog:
>21:12:41,094 INFO kernel:imklog 5.8.11, log source = /proc/kmsg started.
>21:12:41,094 INFO rsyslogd: [origin software="rsyslogd" swVersion="5.8.11" x-pid="534" x-info="http://www.rsyslog.com"] start
>21:12:41,099 INFO kernel:[    0.000000] Initializing cgroup subsys cpuset
>21:12:41,099 INFO kernel:[    0.000000] Initializing cgroup subsys cpu
>21:12:41,099 NOTICE kernel:[    0.000000] Linux version 3.6.5-2.fc18.x86_64 (mockbuild@) (gcc version 4.7.2 20121001 (Red Hat 4.7.2-3) (GCC) ) #1 SMP Thu Nov 1 00:39:17 UTC 2012
>21:12:41,099 INFO kernel:[    0.000000] Command line: initrd=initrd.img inst.stage2=hd:LABEL=Fedora\x2018-Beta-TC7\x20x86_64 quiet BOOT_IMAGE=vmlinuz 
>21:12:41,099 INFO kernel:[    0.000000] e820: BIOS-provided physical RAM map:
>21:12:41,099 INFO kernel:[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
>21:12:41,099 INFO kernel:[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
>21:12:41,099 INFO kernel:[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
>21:12:41,099 INFO kernel:[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003fffdfff] usable
>21:12:41,099 INFO kernel:[    0.000000] BIOS-e820: [mem 0x000000003fffe000-0x000000003fffffff] reserved
>21:12:41,099 INFO kernel:[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
>21:12:41,099 INFO kernel:[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
>21:12:41,099 INFO kernel:[    0.000000] NX (Execute Disable) protection: active
>21:12:41,099 INFO kernel:[    0.000000] DMI 2.4 present.
>21:12:41,099 DEBUG kernel:[    0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2011
>21:12:41,099 INFO kernel:[    0.000000] Hypervisor detected: KVM
>21:12:41,099 DEBUG kernel:[    0.000000] e820: update [mem 0x00000000-0x0000ffff] usable ==> reserved
>21:12:41,099 DEBUG kernel:[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
>21:12:41,099 INFO kernel:[    0.000000] No AGP bridge found
>21:12:41,099 INFO kernel:[    0.000000] e820: last_pfn = 0x3fffe max_arch_pfn = 0x400000000
>21:12:41,099 DEBUG kernel:[    0.000000] MTRR default type: write-back
>21:12:41,099 DEBUG kernel:[    0.000000] MTRR fixed ranges enabled:
>21:12:41,099 DEBUG kernel:[    0.000000]   00000-9FFFF write-back
>21:12:41,099 DEBUG kernel:[    0.000000]   A0000-BFFFF uncachable
>21:12:41,099 DEBUG kernel:[    0.000000]   C0000-FFFFF write-protect
>21:12:41,099 DEBUG kernel:[    0.000000] MTRR variable ranges enabled:
>21:12:41,099 DEBUG kernel:[    0.000000]   0 base 00E0000000 mask FFE0000000 uncachable
>21:12:41,099 DEBUG kernel:[    0.000000]   1 disabled
>21:12:41,099 DEBUG kernel:[    0.000000]   2 disabled
>21:12:41,099 DEBUG kernel:[    0.000000]   3 disabled
>21:12:41,099 DEBUG kernel:[    0.000000]   4 disabled
>21:12:41,099 DEBUG kernel:[    0.000000]   5 disabled
>21:12:41,099 DEBUG kernel:[    0.000000]   6 disabled
>21:12:41,099 DEBUG kernel:[    0.000000]   7 disabled
>21:12:41,099 INFO kernel:[    0.000000] PAT not supported by CPU.
>21:12:41,099 INFO kernel:[    0.000000] found SMP MP-table at [mem 0x000fdae0-0x000fdaef] mapped at [ffff8800000fdae0]
>21:12:41,099 DEBUG kernel:[    0.000000] initial memory mapped: [mem 0x00000000-0x1fffffff]
>21:12:41,099 DEBUG kernel:[    0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576
>21:12:41,099 INFO kernel:[    0.000000] init_memory_mapping: [mem 0x00000000-0x3fffdfff]
>21:12:41,099 DEBUG kernel:[    0.000000]  [mem 0x00000000-0x3fdfffff] page 2M
>21:12:41,099 DEBUG kernel:[    0.000000]  [mem 0x3fe00000-0x3fffdfff] page 4k
>21:12:41,099 DEBUG kernel:[    0.000000] kernel direct mapping tables up to 0x3fffdfff @ [mem 0x1fffd000-0x1fffffff]
>21:12:41,099 INFO kernel:[    0.000000] RAMDISK: [mem 0x3e5ab000-0x3ffdcfff]
>21:12:41,099 WARNING kernel:[    0.000000] ACPI: RSDP 00000000000fd980 00014 (v00 BOCHS )
>21:12:41,099 WARNING kernel:[    0.000000] ACPI: RSDT 000000003fffe440 00038 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
>21:12:41,099 WARNING kernel:[    0.000000] ACPI: FACP 000000003fffff80 00074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
>21:12:41,099 WARNING kernel:[    0.000000] ACPI: DSDT 000000003fffe480 0124A (v01   BXPC   BXDSDT 00000001 INTL 20100528)
>21:12:41,099 WARNING kernel:[    0.000000] ACPI: FACS 000000003fffff40 00040
>21:12:41,099 WARNING kernel:[    0.000000] ACPI: SSDT 000000003ffffe90 000AF (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
>21:12:41,099 WARNING kernel:[    0.000000] ACPI: APIC 000000003ffffd70 00078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
>21:12:41,099 WARNING kernel:[    0.000000] ACPI: HPET 000000003ffffd30 00038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
>21:12:41,099 WARNING kernel:[    0.000000] ACPI: SSDT 000000003ffff6d0 00654 (v01   BXPC BXSSDTPC 00000001 INTL 20100528)
>21:12:41,099 DEBUG kernel:[    0.000000] ACPI: Local APIC address 0xfee00000
>21:12:41,099 INFO kernel:[    0.000000] No NUMA configuration found
>21:12:41,099 INFO kernel:[    0.000000] Faking a node at [mem 0x0000000000000000-0x000000003fffdfff]
>21:12:41,099 INFO kernel:[    0.000000] Initmem setup node 0 [mem 0x00000000-0x3fffdfff]
>21:12:41,099 INFO kernel:[    0.000000]   NODE_DATA [mem 0x3ffea000-0x3fffdfff]
>21:12:41,099 INFO kernel:[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
>21:12:41,099 INFO kernel:[    0.000000] kvm-clock: cpu 0, msr 0:1cfac01, boot clock
>21:12:41,099 DEBUG kernel:[    0.000000]  [ffffea0000000000-ffffea0000ffffff] PMD -> [ffff88003cc00000-ffff88003dbfffff] on node 0
>21:12:41,099 WARNING kernel:[    0.000000] Zone ranges:
>21:12:41,099 WARNING kernel:[    0.000000]   DMA      [mem 0x00010000-0x00ffffff]
>21:12:41,099 WARNING kernel:[    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
>21:12:41,099 WARNING kernel:[    0.000000]   Normal   empty
>21:12:41,099 WARNING kernel:[    0.000000] Movable zone start for each node
>21:12:41,099 WARNING kernel:[    0.000000] Early memory node ranges
>21:12:41,099 WARNING kernel:[    0.000000]   node   0: [mem 0x00010000-0x0009efff]
>21:12:41,099 WARNING kernel:[    0.000000]   node   0: [mem 0x00100000-0x3fffdfff]
>21:12:41,099 DEBUG kernel:[    0.000000] On node 0 totalpages: 262029
>21:12:41,099 DEBUG kernel:[    0.000000]   DMA zone: 64 pages used for memmap
>21:12:41,099 DEBUG kernel:[    0.000000]   DMA zone: 6 pages reserved
>21:12:41,099 DEBUG kernel:[    0.000000]   DMA zone: 3913 pages, LIFO batch:0
>21:12:41,099 DEBUG kernel:[    0.000000]   DMA32 zone: 4032 pages used for memmap
>21:12:41,099 DEBUG kernel:[    0.000000]   DMA32 zone: 254014 pages, LIFO batch:31
>21:12:41,099 INFO kernel:[    0.000000] ACPI: PM-Timer IO Port: 0xb008
>21:12:41,099 DEBUG kernel:[    0.000000] ACPI: Local APIC address 0xfee00000
>21:12:41,099 INFO kernel:[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
>21:12:41,099 INFO kernel:[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
>21:12:41,099 INFO kernel:[    0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
>21:12:41,099 INFO kernel:[    0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
>21:12:41,099 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
>21:12:41,099 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
>21:12:41,099 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
>21:12:41,099 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
>21:12:41,099 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
>21:12:41,099 DEBUG kernel:[    0.000000] ACPI: IRQ0 used by override.
>21:12:41,099 DEBUG kernel:[    0.000000] ACPI: IRQ2 used by override.
>21:12:41,099 DEBUG kernel:[    0.000000] ACPI: IRQ5 used by override.
>21:12:41,099 DEBUG kernel:[    0.000000] ACPI: IRQ9 used by override.
>21:12:41,099 DEBUG kernel:[    0.000000] ACPI: IRQ10 used by override.
>21:12:41,099 DEBUG kernel:[    0.000000] ACPI: IRQ11 used by override.
>21:12:41,099 INFO kernel:[    0.000000] Using ACPI (MADT) for SMP configuration information
>21:12:41,099 INFO kernel:[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
>21:12:41,099 INFO kernel:[    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
>21:12:41,099 DEBUG kernel:[    0.000000] nr_irqs_gsi: 40
>21:12:41,099 INFO kernel:[    0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000
>21:12:41,099 INFO kernel:[    0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
>21:12:41,099 INFO kernel:[    0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
>21:12:41,099 INFO kernel:[    0.000000] e820: [mem 0x40000000-0xfeffbfff] available for PCI devices
>21:12:41,099 INFO kernel:[    0.000000] Booting paravirtualized kernel on KVM
>21:12:41,099 INFO kernel:[    0.000000] setup_percpu: NR_CPUS:128 nr_cpumask_bits:128 nr_cpu_ids:1 nr_node_ids:1
>21:12:41,099 INFO kernel:[    0.000000] PERCPU: Embedded 28 pages/cpu @ffff88003e200000 s84288 r8192 d22208 u2097152
>21:12:41,099 DEBUG kernel:[    0.000000] pcpu-alloc: s84288 r8192 d22208 u2097152 alloc=1*2097152
>21:12:41,099 DEBUG kernel:[    0.000000] pcpu-alloc: [0] 0 
>21:12:41,099 INFO kernel:[    0.000000] kvm-clock: cpu 0, msr 0:3e213c01, primary cpu clock
>21:12:41,099 INFO kernel:[    0.000000] KVM setup async PF for cpu 0
>21:12:41,099 INFO kernel:[    0.000000] kvm-stealtime: cpu 0, msr 3e20dec0
>21:12:41,099 WARNING kernel:[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 257927
>21:12:41,099 WARNING kernel:[    0.000000] Policy zone: DMA32
>21:12:41,099 NOTICE kernel:[    0.000000] Kernel command line: initrd=initrd.img inst.stage2=hd:LABEL=Fedora\x2018-Beta-TC7\x20x86_64 quiet BOOT_IMAGE=vmlinuz 
>21:12:41,099 INFO kernel:[    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
>21:12:41,099 NOTICE kernel:[    0.000000] __ex_table already sorted, skipping sort
>21:12:41,099 INFO kernel:[    0.000000] Checking aperture...
>21:12:41,099 INFO kernel:[    0.000000] No AGP bridge found
>21:12:41,099 INFO kernel:[    0.000000] Memory: 988584k/1048568k available (6325k kernel code, 452k absent, 59532k reserved, 6878k data, 1036k init)
>21:12:41,099 INFO kernel:[    0.000000] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
>21:12:41,099 INFO kernel:[    0.000000] Hierarchical RCU implementation.
>21:12:41,099 INFO kernel:[    0.000000] 	RCU restricting CPUs from NR_CPUS=128 to nr_cpu_ids=1.
>21:12:41,099 INFO kernel:[    0.000000] NR_IRQS:8448 nr_irqs:256 16
>21:12:41,099 INFO kernel:[    0.000000] Console: colour VGA+ 80x25
>21:12:41,099 INFO kernel:[    0.000000] console [tty0] enabled
>21:12:41,099 INFO kernel:[    0.000000] allocated 4194304 bytes of page_cgroup
>21:12:41,099 INFO kernel:[    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
>21:12:41,099 DEBUG kernel:[    0.000000] hpet clockevent registered
>21:12:41,099 INFO kernel:[    0.000000] tsc: Detected 2393.828 MHz processor
>21:12:41,099 INFO kernel:[    0.001999] Calibrating delay loop (skipped) preset value.. 4787.65 BogoMIPS (lpj=2393828)
>21:12:41,099 INFO kernel:[    0.001999] pid_max: default: 32768 minimum: 301
>21:12:41,099 INFO kernel:[    0.001999] Security Framework initialized
>21:12:41,099 INFO kernel:[    0.001999] SELinux:  Initializing.
>21:12:41,099 DEBUG kernel:[    0.001999] SELinux:  Starting in permissive mode
>21:12:41,099 INFO kernel:[    0.001999] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes)
>21:12:41,099 INFO kernel:[    0.001999] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes)
>21:12:41,099 INFO kernel:[    0.001999] Mount-cache hash table entries: 256
>21:12:41,099 INFO kernel:[    0.001999] Initializing cgroup subsys cpuacct
>21:12:41,099 INFO kernel:[    0.001999] Initializing cgroup subsys memory
>21:12:41,099 INFO kernel:[    0.001999] Initializing cgroup subsys devices
>21:12:41,099 INFO kernel:[    0.001999] Initializing cgroup subsys freezer
>21:12:41,099 INFO kernel:[    0.001999] Initializing cgroup subsys net_cls
>21:12:41,099 INFO kernel:[    0.001999] Initializing cgroup subsys blkio
>21:12:41,099 INFO kernel:[    0.001999] Initializing cgroup subsys perf_event
>21:12:41,099 INFO kernel:[    0.001999] mce: CPU supports 10 MCE banks
>21:12:41,099 INFO kernel:[    0.001999] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
>21:12:41,099 INFO kernel:[    0.001999] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0
>21:12:41,099 INFO kernel:[    0.001999] tlb_flushall_shift is 0x6
>21:12:41,099 INFO kernel:[    0.001999] SMP alternatives: switching to UP code
>21:12:41,099 INFO kernel:[    0.014272] Freeing SMP alternatives: 24k freed
>21:12:41,099 INFO kernel:[    0.014281] ACPI: Core revision 20120711
>21:12:41,099 INFO kernel:[    0.015142] ftrace: allocating 23468 entries in 92 pages
>21:12:41,099 INFO kernel:[    0.023456] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
>21:12:41,099 INFO kernel:[    0.023460] smpboot: CPU0: Intel QEMU Virtual CPU version 1.0.1 stepping 03
>21:12:41,099 WARNING kernel:[    0.023996] APIC calibration not consistent with PM-Timer: 102ms instead of 100ms
>21:12:41,099 INFO kernel:[    0.023996] APIC delta adjusted to PM-Timer: 6249662 (6436565)
>21:12:41,099 INFO kernel:[    0.023996] Performance Events: unsupported p6 CPU model 2 no PMU driver, software events only.
>21:12:41,099 WARNING kernel:[    0.023996] NMI watchdog: disabled (cpu0): hardware events not enabled
>21:12:41,099 INFO kernel:[    0.023996] Brought up 1 CPUs
>21:12:41,099 INFO kernel:[    0.023996] smpboot: Total of 1 processors activated (4787.65 BogoMIPS)
>21:12:41,099 INFO kernel:[    0.023996] devtmpfs: initialized
>21:12:41,099 INFO kernel:[    0.024906] atomic64 test passed for x86-64 platform with CX8 and with SSE
>21:12:41,099 INFO kernel:[    0.024973] RTC time: 21:12:34, date: 11/06/12
>21:12:41,099 INFO kernel:[    0.025037] NET: Registered protocol family 16
>21:12:41,099 INFO kernel:[    0.025163] ACPI: bus type pci registered
>21:12:41,099 INFO kernel:[    0.025251] PCI: Using configuration type 1 for base access
>21:12:41,099 INFO kernel:[    0.025840] bio: create slab <bio-0> at 0
>21:12:41,099 INFO kernel:[    0.025901] ACPI: Added _OSI(Module Device)
>21:12:41,099 INFO kernel:[    0.025902] ACPI: Added _OSI(Processor Device)
>21:12:41,099 INFO kernel:[    0.025903] ACPI: Added _OSI(3.0 _SCP Extensions)
>21:12:41,099 INFO kernel:[    0.025904] ACPI: Added _OSI(Processor Aggregator Device)
>21:12:41,099 DEBUG kernel:[    0.026308] ACPI: EC: Look up EC in DSDT
>21:12:41,099 INFO kernel:[    0.027509] ACPI: Interpreter enabled
>21:12:41,099 INFO kernel:[    0.027513] ACPI: (supports S0 S5)
>21:12:41,099 INFO kernel:[    0.027520] ACPI: Using IOAPIC for interrupt routing
>21:12:41,099 INFO kernel:[    0.029575] ACPI: No dock devices found.
>21:12:41,099 INFO kernel:[    0.029581] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
>21:12:41,099 INFO kernel:[    0.029644] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
>21:12:41,099 WARNING kernel:[    0.029727] pci_root PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
>21:12:41,099 INFO kernel:[    0.029749] PCI host bridge to bus 0000:00
>21:12:41,099 DEBUG kernel:[    0.029751] pci_bus 0000:00: busn_res: [bus 00-ff] is inserted under domain [bus 00-ff]
>21:12:41,099 INFO kernel:[    0.029753] pci_bus 0000:00: root bus resource [bus 00-ff]
>21:12:41,099 INFO kernel:[    0.029755] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7]
>21:12:41,099 INFO kernel:[    0.029756] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff]
>21:12:41,099 INFO kernel:[    0.029758] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
>21:12:41,099 INFO kernel:[    0.029759] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff]
>21:12:41,099 DEBUG kernel:[    0.029799] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
>21:12:41,099 DEBUG kernel:[    0.030024] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
>21:12:41,099 DEBUG kernel:[    0.030341] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
>21:12:41,099 DEBUG kernel:[    0.030760] pci 0000:00:01.1: reg 20: [io  0xc0c0-0xc0cf]
>21:12:41,099 DEBUG kernel:[    0.030974] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300
>21:12:41,099 DEBUG kernel:[    0.031347] pci 0000:00:01.2: reg 20: [io  0xc040-0xc05f]
>21:12:41,099 DEBUG kernel:[    0.031563] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
>21:12:41,099 INFO kernel:[    0.031840] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
>21:12:41,099 INFO kernel:[    0.031848] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
>21:12:41,099 DEBUG kernel:[    0.031959] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
>21:12:41,099 DEBUG kernel:[    0.032146] pci 0000:00:02.0: reg 10: [mem 0xfd000000-0xfdffffff pref]
>21:12:41,099 DEBUG kernel:[    0.033884] pci 0000:00:02.0: reg 30: [mem 0xfebd0000-0xfebdffff pref]
>21:12:41,099 DEBUG kernel:[    0.034035] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000
>21:12:41,099 DEBUG kernel:[    0.034185] pci 0000:00:03.0: reg 10: [io  0xc060-0xc07f]
>21:12:41,100 DEBUG kernel:[    0.034296] pci 0000:00:03.0: reg 14: [mem 0xfebf4000-0xfebf4fff]
>21:12:41,100 DEBUG kernel:[    0.034872] pci 0000:00:03.0: reg 30: [mem 0xfebe0000-0xfebeffff pref]
>21:12:41,100 DEBUG kernel:[    0.035073] pci 0000:00:04.0: [8086:2668] type 00 class 0x040300
>21:12:41,100 DEBUG kernel:[    0.035212] pci 0000:00:04.0: reg 10: [mem 0xfebf0000-0xfebf3fff]
>21:12:41,100 DEBUG kernel:[    0.035891] pci 0000:00:05.0: [1af4:1003] type 00 class 0x078000
>21:12:41,100 DEBUG kernel:[    0.036045] pci 0000:00:05.0: reg 10: [io  0xc080-0xc09f]
>21:12:41,100 DEBUG kernel:[    0.036157] pci 0000:00:05.0: reg 14: [mem 0xfebf5000-0xfebf5fff]
>21:12:41,100 DEBUG kernel:[    0.036936] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000
>21:12:41,100 DEBUG kernel:[    0.037067] pci 0000:00:06.0: reg 10: [io  0xc000-0xc03f]
>21:12:41,100 DEBUG kernel:[    0.037185] pci 0000:00:06.0: reg 14: [mem 0xfebf6000-0xfebf6fff]
>21:12:41,100 DEBUG kernel:[    0.037929] pci 0000:00:07.0: [1af4:1002] type 00 class 0x050000
>21:12:41,100 DEBUG kernel:[    0.038065] pci 0000:00:07.0: reg 10: [io  0xc0a0-0xc0bf]
>21:12:41,100 DEBUG kernel:[    0.038723] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
>21:12:41,100 INFO kernel:[    0.038984]  pci0000:00: ACPI _OSC support notification failed, disabling PCIe ASPM
>21:12:41,100 INFO kernel:[    0.038985]  pci0000:00: Unable to request _OSC control (_OSC support mask: 0x08)
>21:12:41,100 INFO kernel:[    0.041085] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
>21:12:41,100 INFO kernel:[    0.041155] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
>21:12:41,100 INFO kernel:[    0.041214] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
>21:12:41,100 INFO kernel:[    0.041273] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
>21:12:41,100 INFO kernel:[    0.041329] ACPI: PCI Interrupt Link [LNKS] (IRQs 9) *0
>21:12:41,100 INFO kernel:[    0.041451] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
>21:12:41,100 INFO kernel:[    0.041454] vgaarb: loaded
>21:12:41,100 INFO kernel:[    0.041454] vgaarb: bridge control possible 0000:00:02.0
>21:12:41,100 NOTICE kernel:[    0.041522] SCSI subsystem initialized
>21:12:41,100 INFO kernel:[    0.041524] ACPI: bus type scsi registered
>21:12:41,100 DEBUG kernel:[    0.041572] libata version 3.00 loaded.
>21:12:41,100 INFO kernel:[    0.041595] ACPI: bus type usb registered
>21:12:41,100 INFO kernel:[    0.041609] usbcore: registered new interface driver usbfs
>21:12:41,100 INFO kernel:[    0.041618] usbcore: registered new interface driver hub
>21:12:41,100 INFO kernel:[    0.041633] usbcore: registered new device driver usb
>21:12:41,100 INFO kernel:[    0.041672] PCI: Using ACPI for IRQ routing
>21:12:41,100 DEBUG kernel:[    0.041674] PCI: pci_cache_line_size set to 64 bytes
>21:12:41,100 DEBUG kernel:[    0.041817] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
>21:12:41,100 DEBUG kernel:[    0.041819] e820: reserve RAM buffer [mem 0x3fffe000-0x3fffffff]
>21:12:41,100 INFO kernel:[    0.041899] NetLabel: Initializing
>21:12:41,100 INFO kernel:[    0.041900] NetLabel:  domain hash size = 128
>21:12:41,100 INFO kernel:[    0.041901] NetLabel:  protocols = UNLABELED CIPSOv4
>21:12:41,100 INFO kernel:[    0.041909] NetLabel:  unlabeled traffic allowed by default
>21:12:41,100 INFO kernel:[    0.041954] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
>21:12:41,100 INFO kernel:[    0.041967] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
>21:12:41,100 INFO kernel:[    0.041970] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
>21:12:41,100 INFO kernel:[    0.043050] Switching to clocksource kvm-clock
>21:12:41,100 INFO kernel:[    0.051226] pnp: PnP ACPI init
>21:12:41,100 INFO kernel:[    0.051255] ACPI: bus type pnp registered
>21:12:41,100 DEBUG kernel:[    0.051348] pnp 00:00: [bus 00-ff]
>21:12:41,100 DEBUG kernel:[    0.051350] pnp 00:00: [io  0x0cf8-0x0cff]
>21:12:41,100 DEBUG kernel:[    0.051352] pnp 00:00: [io  0x0000-0x0cf7 window]
>21:12:41,100 DEBUG kernel:[    0.051353] pnp 00:00: [io  0x0d00-0xffff window]
>21:12:41,100 DEBUG kernel:[    0.051355] pnp 00:00: [mem 0x000a0000-0x000bffff window]
>21:12:41,100 DEBUG kernel:[    0.051356] pnp 00:00: [mem 0x40000000-0xfebfffff window]
>21:12:41,100 DEBUG kernel:[    0.051393] pnp 00:00: Plug and Play ACPI device, IDs PNP0a03 (active)
>21:12:41,100 DEBUG kernel:[    0.051402] pnp 00:01: [io  0x0070-0x0071]
>21:12:41,100 DEBUG kernel:[    0.051434] pnp 00:01: [irq 8]
>21:12:41,100 DEBUG kernel:[    0.051436] pnp 00:01: [io  0x0072-0x0077]
>21:12:41,100 DEBUG kernel:[    0.051451] pnp 00:01: Plug and Play ACPI device, IDs PNP0b00 (active)
>21:12:41,100 DEBUG kernel:[    0.051471] pnp 00:02: [io  0x0060]
>21:12:41,100 DEBUG kernel:[    0.051472] pnp 00:02: [io  0x0064]
>21:12:41,100 DEBUG kernel:[    0.051486] pnp 00:02: [irq 1]
>21:12:41,100 DEBUG kernel:[    0.051499] pnp 00:02: Plug and Play ACPI device, IDs PNP0303 (active)
>21:12:41,100 DEBUG kernel:[    0.051526] pnp 00:03: [irq 12]
>21:12:41,100 DEBUG kernel:[    0.051541] pnp 00:03: Plug and Play ACPI device, IDs PNP0f13 (active)
>21:12:41,100 DEBUG kernel:[    0.051559] pnp 00:04: [io  0x03f2-0x03f5]
>21:12:41,100 DEBUG kernel:[    0.051561] pnp 00:04: [io  0x03f7]
>21:12:41,100 DEBUG kernel:[    0.051574] pnp 00:04: [irq 6]
>21:12:41,100 DEBUG kernel:[    0.051576] pnp 00:04: [dma 2]
>21:12:41,100 DEBUG kernel:[    0.051588] pnp 00:04: Plug and Play ACPI device, IDs PNP0700 (active)
>21:12:41,100 DEBUG kernel:[    0.051674] pnp 00:05: [io  0x03f8-0x03ff]
>21:12:41,100 DEBUG kernel:[    0.051687] pnp 00:05: [irq 4]
>21:12:41,100 DEBUG kernel:[    0.051704] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
>21:12:41,100 DEBUG kernel:[    0.051797] pnp 00:06: [mem 0xfed00000-0xfed003ff]
>21:12:41,100 DEBUG kernel:[    0.051815] pnp 00:06: Plug and Play ACPI device, IDs PNP0103 (active)
>21:12:41,100 INFO kernel:[    0.051914] pnp: PnP ACPI: found 7 devices
>21:12:41,100 INFO kernel:[    0.051916] ACPI: ACPI bus type pnp unregistered
>21:12:41,100 DEBUG kernel:[    0.058081] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7]
>21:12:41,100 DEBUG kernel:[    0.058084] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff]
>21:12:41,100 DEBUG kernel:[    0.058086] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
>21:12:41,100 DEBUG kernel:[    0.058087] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff]
>21:12:41,100 INFO kernel:[    0.058126] NET: Registered protocol family 2
>21:12:41,100 INFO kernel:[    0.058811] TCP established hash table entries: 131072 (order: 9, 2097152 bytes)
>21:12:41,100 INFO kernel:[    0.059335] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
>21:12:41,100 INFO kernel:[    0.059537] TCP: Hash tables configured (established 131072 bind 65536)
>21:12:41,100 INFO kernel:[    0.059563] TCP: reno registered
>21:12:41,100 INFO kernel:[    0.059568] UDP hash table entries: 512 (order: 2, 16384 bytes)
>21:12:41,100 INFO kernel:[    0.059573] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
>21:12:41,100 INFO kernel:[    0.059654] NET: Registered protocol family 1
>21:12:41,100 INFO kernel:[    0.059666] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
>21:12:41,100 INFO kernel:[    0.059712] pci 0000:00:01.0: PIIX3: Enabling Passive Release
>21:12:41,100 INFO kernel:[    0.059730] pci 0000:00:01.0: Activating ISA DMA hang workarounds
>21:12:41,100 WARNING kernel:[    0.059876] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
>21:12:41,100 DEBUG kernel:[    0.059979] pci 0000:00:02.0: Boot video device
>21:12:41,100 DEBUG kernel:[    0.060046] PCI: CLS 0 bytes, default 64
>21:12:41,100 INFO kernel:[    0.060094] Unpacking initramfs...
>21:12:41,100 INFO kernel:[    2.903506] Freeing initrd memory: 26824k freed
>21:12:41,100 NOTICE kernel:[    2.910318] Initialise module verification
>21:12:41,100 INFO kernel:[    2.910374] audit: initializing netlink socket (disabled)
>21:12:41,100 NOTICE kernel:[    2.910387] type=2000 audit(1352236358.909:1): initialized
>21:12:41,100 INFO kernel:[    2.926335] HugeTLB registered 2 MB page size, pre-allocated 0 pages
>21:12:41,100 NOTICE kernel:[    2.927448] VFS: Disk quotas dquot_6.5.2
>21:12:41,100 WARNING kernel:[    2.927481] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
>21:12:41,100 INFO kernel:[    2.927781] msgmni has been set to 1983
>21:12:41,100 DEBUG kernel:[    2.927828] SELinux:  Registering netfilter hooks
>21:12:41,100 INFO kernel:[    2.928166] alg: No test for stdrng (krng)
>21:12:41,100 INFO kernel:[    2.928170] NET: Registered protocol family 38
>21:12:41,100 NOTICE kernel:[    2.928172] Key type asymmetric registered
>21:12:41,100 NOTICE kernel:[    2.928173] Asymmetric key parser 'x509' registered
>21:12:41,100 INFO kernel:[    2.928202] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
>21:12:41,100 INFO kernel:[    2.928219] io scheduler noop registered
>21:12:41,100 INFO kernel:[    2.928220] io scheduler deadline registered
>21:12:41,100 INFO kernel:[    2.928269] io scheduler cfq registered (default)
>21:12:41,100 INFO kernel:[    2.928349] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
>21:12:41,100 INFO kernel:[    2.928362] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
>21:12:41,100 INFO kernel:[    2.928363] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
>21:12:41,100 INFO kernel:[    2.928423] acpiphp: Slot [3] registered
>21:12:41,100 INFO kernel:[    2.928433] acpiphp: Slot [4] registered
>21:12:41,100 INFO kernel:[    2.928443] acpiphp: Slot [5] registered
>21:12:41,100 INFO kernel:[    2.928454] acpiphp: Slot [6] registered
>21:12:41,100 INFO kernel:[    2.928463] acpiphp: Slot [7] registered
>21:12:41,100 INFO kernel:[    2.928472] acpiphp: Slot [8] registered
>21:12:41,100 INFO kernel:[    2.928482] acpiphp: Slot [9] registered
>21:12:41,100 INFO kernel:[    2.928493] acpiphp: Slot [10] registered
>21:12:41,100 INFO kernel:[    2.928504] acpiphp: Slot [11] registered
>21:12:41,100 INFO kernel:[    2.928515] acpiphp: Slot [12] registered
>21:12:41,100 INFO kernel:[    2.928525] acpiphp: Slot [13] registered
>21:12:41,100 INFO kernel:[    2.928540] acpiphp: Slot [14] registered
>21:12:41,100 INFO kernel:[    2.928550] acpiphp: Slot [15] registered
>21:12:41,100 INFO kernel:[    2.928559] acpiphp: Slot [16] registered
>21:12:41,100 INFO kernel:[    2.928569] acpiphp: Slot [17] registered
>21:12:41,100 INFO kernel:[    2.928579] acpiphp: Slot [18] registered
>21:12:41,100 INFO kernel:[    2.928589] acpiphp: Slot [19] registered
>21:12:41,100 INFO kernel:[    2.928598] acpiphp: Slot [20] registered
>21:12:41,100 INFO kernel:[    2.928607] acpiphp: Slot [21] registered
>21:12:41,100 INFO kernel:[    2.928618] acpiphp: Slot [22] registered
>21:12:41,100 INFO kernel:[    2.928628] acpiphp: Slot [23] registered
>21:12:41,100 INFO kernel:[    2.928637] acpiphp: Slot [24] registered
>21:12:41,100 INFO kernel:[    2.928646] acpiphp: Slot [25] registered
>21:12:41,100 INFO kernel:[    2.928657] acpiphp: Slot [26] registered
>21:12:41,100 INFO kernel:[    2.928666] acpiphp: Slot [27] registered
>21:12:41,100 INFO kernel:[    2.928676] acpiphp: Slot [28] registered
>21:12:41,100 INFO kernel:[    2.928685] acpiphp: Slot [29] registered
>21:12:41,100 INFO kernel:[    2.928696] acpiphp: Slot [30] registered
>21:12:41,100 INFO kernel:[    2.928705] acpiphp: Slot [31] registered
>21:12:41,100 DEBUG kernel:[    2.928799] intel_idle: does not run on family 6 model 2
>21:12:41,100 INFO kernel:[    2.928843] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
>21:12:41,100 INFO kernel:[    2.928846] ACPI: Power Button [PWRF]
>21:12:41,100 INFO kernel:[    2.930153] GHES: HEST is not enabled!
>21:12:41,100 WARNING kernel:[    2.930342] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
>21:12:41,100 DEBUG kernel:[    2.930386] virtio-pci 0000:00:03.0: setting latency timer to 64
>21:12:41,100 WARNING kernel:[    2.930566] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
>21:12:41,100 DEBUG kernel:[    2.930588] virtio-pci 0000:00:05.0: setting latency timer to 64
>21:12:41,100 WARNING kernel:[    2.930753] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11
>21:12:41,100 DEBUG kernel:[    2.930775] virtio-pci 0000:00:06.0: setting latency timer to 64
>21:12:41,100 DEBUG kernel:[    2.930920] virtio-pci 0000:00:07.0: setting latency timer to 64
>21:12:41,100 INFO kernel:[    2.930995] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
>21:12:41,100 INFO kernel:[    2.953798] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
>21:12:41,100 INFO kernel:[    2.975894] 00:05: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
>21:12:41,100 DEBUG kernel:[    2.976316] virtio-pci 0000:00:05.0: irq 40 for MSI/MSI-X
>21:12:41,100 DEBUG kernel:[    2.976337] virtio-pci 0000:00:05.0: irq 41 for MSI/MSI-X
>21:12:41,100 INFO kernel:[    2.993224] Non-volatile memory driver v1.3
>21:12:41,100 INFO kernel:[    2.993229] Linux agpgart interface v0.103
>21:12:41,100 INFO kernel:[    2.994618] loop: module loaded
>21:12:41,100 DEBUG kernel:[    2.994720] ata_piix 0000:00:01.1: version 2.13
>21:12:41,100 DEBUG kernel:[    2.994863] ata_piix 0000:00:01.1: setting latency timer to 64
>21:12:41,100 INFO kernel:[    2.995497] scsi0 : ata_piix
>21:12:41,100 INFO kernel:[    2.995589] scsi1 : ata_piix
>21:12:41,100 INFO kernel:[    2.995642] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0c0 irq 14
>21:12:41,100 INFO kernel:[    2.995645] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0c8 irq 15
>21:12:41,100 INFO kernel:[    2.995753] libphy: Fixed MDIO Bus: probed
>21:12:41,100 INFO kernel:[    2.995815] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
>21:12:41,100 INFO kernel:[    2.995834] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
>21:12:41,100 INFO kernel:[    2.995849] uhci_hcd: USB Universal Host Controller Interface driver
>21:12:41,100 DEBUG kernel:[    2.995948] uhci_hcd 0000:00:01.2: setting latency timer to 64
>21:12:41,100 INFO kernel:[    2.995964] uhci_hcd 0000:00:01.2: UHCI Host Controller
>21:12:41,100 INFO kernel:[    2.996052] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
>21:12:41,100 INFO kernel:[    2.996226] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c040
>21:12:41,100 INFO kernel:[    2.996350] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
>21:12:41,100 INFO kernel:[    2.996355] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
>21:12:41,100 INFO kernel:[    2.996358] usb usb1: Product: UHCI Host Controller
>21:12:41,100 INFO kernel:[    2.996361] usb usb1: Manufacturer: Linux 3.6.5-2.fc18.x86_64 uhci_hcd
>21:12:41,100 INFO kernel:[    2.996365] usb usb1: SerialNumber: 0000:00:01.2
>21:12:41,100 INFO kernel:[    2.996512] hub 1-0:1.0: USB hub found
>21:12:41,100 INFO kernel:[    2.996519] hub 1-0:1.0: 2 ports detected
>21:12:41,100 INFO kernel:[    2.996715] usbcore: registered new interface driver usbserial
>21:12:41,100 INFO kernel:[    2.996732] usbcore: registered new interface driver usbserial_generic
>21:12:41,100 INFO kernel:[    2.996841] USB Serial support registered for generic
>21:12:41,100 INFO kernel:[    2.996843] usbserial: USB Serial Driver core
>21:12:41,100 INFO kernel:[    2.996888] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
>21:12:41,100 INFO kernel:[    2.998181] serio: i8042 KBD port at 0x60,0x64 irq 1
>21:12:41,100 INFO kernel:[    2.998191] serio: i8042 AUX port at 0x60,0x64 irq 12
>21:12:41,100 INFO kernel:[    2.998328] mousedev: PS/2 mouse device common for all mice
>21:12:41,100 INFO kernel:[    2.998896] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
>21:12:41,100 INFO kernel:[    3.006127] rtc_cmos 00:01: RTC can wake from S4
>21:12:41,100 INFO kernel:[    3.006760] rtc_cmos 00:01: rtc core: registered rtc_cmos as rtc0
>21:12:41,100 INFO kernel:[    3.007084] rtc0: alarms up to one day, 114 bytes nvram, hpet irqs
>21:12:41,100 INFO kernel:[    3.007328] device-mapper: uevent: version 1.0.3
>21:12:41,100 INFO kernel:[    3.007489] device-mapper: ioctl: 4.23.0-ioctl (2012-07-25) initialised: dm-devel@redhat.com
>21:12:41,100 INFO kernel:[    3.007648] cpuidle: using governor ladder
>21:12:41,100 INFO kernel:[    3.007653] cpuidle: using governor menu
>21:12:41,100 INFO kernel:[    3.007786] EFI Variables Facility v0.08 2004-May-17
>21:12:41,100 INFO kernel:[    3.007942] usbcore: registered new interface driver usbhid
>21:12:41,100 INFO kernel:[    3.007944] usbhid: USB HID core driver
>21:12:41,100 INFO kernel:[    3.007975] drop_monitor: Initializing network drop monitor service
>21:12:41,100 INFO kernel:[    3.008181] ip_tables: (C) 2000-2006 Netfilter Core Team
>21:12:41,100 INFO kernel:[    3.008239] TCP: cubic registered
>21:12:41,100 INFO kernel:[    3.008259] Initializing XFRM netlink socket
>21:12:41,100 INFO kernel:[    3.008546] NET: Registered protocol family 10
>21:12:41,100 INFO kernel:[    3.008894] mip6: Mobile IPv6
>21:12:41,100 INFO kernel:[    3.008899] NET: Registered protocol family 17
>21:12:41,100 DEBUG kernel:[    3.009219] PM: Hibernation image not present or could not be loaded.
>21:12:41,100 NOTICE kernel:[    3.009222] Loading module verification certificates
>21:12:41,100 NOTICE kernel:[    3.011296] MODSIGN: Loaded cert 'Fedora kernel signing key: c4edc0723c9674193c4066c76ffd33a800ac519e'
>21:12:41,100 INFO kernel:[    3.011335] registered taskstats version 1
>21:12:41,100 INFO kernel:[    3.012272]   Magic number: 4:876:246
>21:12:41,100 INFO kernel:[    3.012612] rtc_cmos 00:01: setting system clock to 2012-11-06 21:12:37 UTC (1352236357)
>21:12:41,100 DEBUG kernel:[    3.165350] ata2.01: NODEV after polling detection
>21:12:41,100 INFO kernel:[    3.165899] ata2.00: ATAPI: QEMU DVD-ROM, 1.0.1, max UDMA/100
>21:12:41,100 INFO kernel:[    3.166822] ata2.00: configured for MWDMA2
>21:12:41,100 NOTICE kernel:[    3.167572] scsi 1:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     1.0. PQ: 0 ANSI: 5
>21:12:41,100 WARNING kernel:[    3.167978] sr0: scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
>21:12:41,100 INFO kernel:[    3.167980] cdrom: Uniform CD-ROM driver Revision: 3.20
>21:12:41,100 DEBUG kernel:[    3.168089] sr 1:0:0:0: Attached scsi CD-ROM sr0
>21:12:41,100 NOTICE kernel:[    3.168129] sr 1:0:0:0: Attached scsi generic sg0 type 5
>21:12:41,100 INFO kernel:[    3.169347] Freeing unused kernel memory: 1036k freed
>21:12:41,100 INFO kernel:[    3.169517] Write protecting the kernel read-only data: 12288k
>21:12:41,100 INFO kernel:[    3.173859] Freeing unused kernel memory: 1856k freed
>21:12:41,100 INFO kernel:[    3.177773] Freeing unused kernel memory: 1416k freed
>21:12:41,100 WARNING kernel:[    3.252870] Disabling lock debugging due to kernel taint
>21:12:41,100 INFO kernel:[    3.253135] BIOS EDD facility v0.16 2004-Jun-25, 1 devices found
>21:12:41,100 INFO kernel:[    3.298041] usb 1-1: new full-speed USB device number 2 using uhci_hcd
>21:12:41,100 INFO kernel:[    3.339349] squashfs: version 4.0 (2009/01/31) Phillip Lougher
>21:12:41,100 INFO kernel:[    3.340863] Loading iSCSI transport class v2.0-870.
>21:12:41,100 NOTICE kernel:[    3.341698] iscsi: registered transport (tcp)
>21:12:41,100 INFO kernel:[    3.342905] alua: device handler registered
>21:12:41,100 INFO kernel:[    3.344075] emc: device handler registered
>21:12:41,100 INFO kernel:[    3.345191] hp_sw: device handler registered
>21:12:41,100 INFO kernel:[    3.346366] rdac: device handler registered
>21:12:41,100 INFO kernel:[    3.360116] FDC 0 is a S82078B
>21:12:41,100 INFO kernel:[    3.365649] No iBFT detected.
>21:12:41,100 INFO kernel:[    3.367731] md: raid0 personality registered for level 0
>21:12:41,100 INFO kernel:[    3.369061] md: raid1 personality registered for level 1
>21:12:41,100 INFO kernel:[    3.370183] async_tx: api initialized (async)
>21:12:41,100 INFO kernel:[    3.370343] xor: automatically using best checksumming function:
>21:12:41,100 INFO kernel:[    3.380012]    generic_sse: 10084.000 MB/sec
>21:12:41,100 WARNING kernel:[    3.397021] raid6: sse2x1    6746 MB/s
>21:12:41,100 WARNING kernel:[    3.414019] raid6: sse2x2    7871 MB/s
>21:12:41,100 WARNING kernel:[    3.431014] raid6: sse2x4    8722 MB/s
>21:12:41,100 WARNING kernel:[    3.431015] raid6: using algorithm sse2x4 (8722 MB/s)
>21:12:41,100 WARNING kernel:[    3.431016] raid6: using intx1 recovery algorithm
>21:12:41,100 INFO kernel:[    3.432333] md: raid6 personality registered for level 6
>21:12:41,100 INFO kernel:[    3.432335] md: raid5 personality registered for level 5
>21:12:41,100 INFO kernel:[    3.432336] md: raid4 personality registered for level 4
>21:12:41,100 INFO kernel:[    3.436096] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2
>21:12:41,100 INFO kernel:[    3.437208] md: raid10 personality registered for level 10
>21:12:41,100 INFO kernel:[    3.438416] md: linear personality registered for level -1
>21:12:41,100 INFO kernel:[    3.443048] device-mapper: multipath: version 1.5.0 loaded
>21:12:41,100 INFO kernel:[    3.444143] device-mapper: multipath round-robin: version 1.0.0 loaded
>21:12:41,100 INFO kernel:[    3.473113] RPC: Registered named UNIX socket transport module.
>21:12:41,100 INFO kernel:[    3.473116] RPC: Registered udp transport module.
>21:12:41,100 INFO kernel:[    3.473117] RPC: Registered tcp transport module.
>21:12:41,100 INFO kernel:[    3.473118] RPC: Registered tcp NFSv4.1 backchannel transport module.
>21:12:41,100 INFO kernel:[    3.512428] usb 1-1: New USB device found, idVendor=0627, idProduct=0001
>21:12:41,100 INFO kernel:[    3.512432] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
>21:12:41,100 INFO kernel:[    3.512434] usb 1-1: Product: QEMU USB Tablet
>21:12:41,100 INFO kernel:[    3.512439] usb 1-1: Manufacturer: QEMU 1.0.1
>21:12:41,100 INFO kernel:[    3.512440] usb 1-1: SerialNumber: 42
>21:12:41,100 INFO kernel:[    3.547481] input: QEMU 1.0.1 QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/input/input3
>21:12:41,100 INFO kernel:[    3.547562] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Pointer [QEMU 1.0.1 QEMU USB Tablet] on usb-0000:00:01.2-1/input0
>21:12:41,100 DEBUG kernel:[    3.685618] virtio-pci 0000:00:03.0: irq 42 for MSI/MSI-X
>21:12:41,100 DEBUG kernel:[    3.685636] virtio-pci 0000:00:03.0: irq 43 for MSI/MSI-X
>21:12:41,100 DEBUG kernel:[    3.685652] virtio-pci 0000:00:03.0: irq 44 for MSI/MSI-X
>21:12:41,100 DEBUG kernel:[    3.697230] virtio-pci 0000:00:06.0: irq 45 for MSI/MSI-X
>21:12:41,100 DEBUG kernel:[    3.697285] virtio-pci 0000:00:06.0: irq 46 for MSI/MSI-X
>21:12:41,100 INFO kernel:[    3.708375]  vda: vda1 vda2
>21:12:41,100 INFO kernel:[    3.801544] Btrfs loaded
>21:12:41,100 INFO kernel:[    3.808556] device label fedora devid 1 transid 32 /dev/vda2
>21:12:41,100 DEBUG kernel:[    3.896524] ISO 9660 Extensions: Microsoft Joliet Level 3
>21:12:41,100 DEBUG kernel:[    3.900167] ISO 9660 Extensions: RRIP_1991A
>21:12:41,100 INFO kernel:[    3.912101] tsc: Refined TSC clocksource calibration: 2393.824 MHz
>21:12:41,100 INFO kernel:[    4.056349] EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null)
>21:12:41,100 DEBUG kernel:[    4.803534] SELinux: 2048 avtab hash slots, 92725 rules.
>21:12:41,100 DEBUG kernel:[    4.818007] SELinux: 2048 avtab hash slots, 92725 rules.
>21:12:41,100 DEBUG kernel:[    5.061319] SELinux:  9 users, 15 roles, 4330 types, 231 bools, 1 sens, 1024 cats
>21:12:41,100 DEBUG kernel:[    5.061325] SELinux:  83 classes, 92725 rules
>21:12:41,100 DEBUG kernel:[    5.065560] SELinux:  Completing initialization.
>21:12:41,100 DEBUG kernel:[    5.065565] SELinux:  Setting up existing superblocks.
>21:12:41,100 DEBUG kernel:[    5.065572] SELinux: initialized (dev sysfs, type sysfs), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.065576] SELinux: initialized (dev rootfs, type rootfs), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.065587] SELinux: initialized (dev bdev, type bdev), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.065592] SELinux: initialized (dev proc, type proc), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.065602] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>21:12:41,100 DEBUG kernel:[    5.065626] SELinux: initialized (dev devtmpfs, type devtmpfs), uses transition SIDs
>21:12:41,100 DEBUG kernel:[    5.066221] SELinux: initialized (dev sockfs, type sockfs), uses task SIDs
>21:12:41,100 DEBUG kernel:[    5.066225] SELinux: initialized (dev debugfs, type debugfs), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.066856] SELinux: initialized (dev pipefs, type pipefs), uses task SIDs
>21:12:41,100 DEBUG kernel:[    5.066866] SELinux: initialized (dev anon_inodefs, type anon_inodefs), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.066869] SELinux: initialized (dev devpts, type devpts), uses transition SIDs
>21:12:41,100 DEBUG kernel:[    5.066894] SELinux: initialized (dev hugetlbfs, type hugetlbfs), uses transition SIDs
>21:12:41,100 DEBUG kernel:[    5.066901] SELinux: initialized (dev mqueue, type mqueue), uses transition SIDs
>21:12:41,100 DEBUG kernel:[    5.066910] SELinux: initialized (dev selinuxfs, type selinuxfs), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.066920] SELinux: initialized (dev sysfs, type sysfs), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067198] SELinux: initialized (dev securityfs, type securityfs), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067201] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>21:12:41,100 DEBUG kernel:[    5.067207] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>21:12:41,100 DEBUG kernel:[    5.067438] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>21:12:41,100 DEBUG kernel:[    5.067467] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067470] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067475] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067489] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067494] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067497] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067500] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067502] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067507] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067511] SELinux: initialized (dev rpc_pipefs, type rpc_pipefs), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067515] SELinux: initialized (dev sr0, type iso9660), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.067527] SELinux: initialized (dev loop0, type squashfs), uses xattr
>21:12:41,100 DEBUG kernel:[    5.067545] SELinux: initialized (dev dm-0, type ext4), uses xattr
>21:12:41,100 NOTICE kernel:[    5.069095] type=1403 audit(1352236359.555:2): policy loaded auid=4294967295 ses=4294967295
>21:12:41,100 DEBUG kernel:[    5.603827] SELinux: initialized (dev autofs, type autofs), uses genfs_contexts
>21:12:41,100 DEBUG kernel:[    5.797162] SELinux: initialized (dev hugetlbfs, type hugetlbfs), uses transition SIDs
>21:12:41,100 DEBUG kernel:[    5.856401] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>21:12:41,100 DEBUG kernel:[    5.982728] SELinux: initialized (dev configfs, type configfs), uses genfs_contexts
>21:12:41,100 NOTICE kernel:[    6.370182] type=1400 audit(1352236360.856:3): avc:  denied  { create } for  pid=508 comm="systemd-tmpfile" name="tmp" scontext=system_u:system_r:systemd_tmpfiles_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir
>21:12:41,100 NOTICE kernel:[    6.370328] type=1400 audit(1352236360.856:4): avc:  denied  { setattr } for  pid=508 comm="systemd-tmpfile" name="tmp" dev="dm-0" ino=59412 scontext=system_u:system_r:systemd_tmpfiles_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir
>21:12:41,100 NOTICE kernel:[    6.370415] type=1400 audit(1352236360.856:5): avc:  denied  { relabelfrom } for  pid=508 comm="systemd-tmpfile" name="tmp" dev="dm-0" ino=59412 scontext=system_u:system_r:systemd_tmpfiles_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir
>21:12:41,101 INFO systemd: systemd 195 running in system mode. (+PAM +LIBWRAP +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP +GCRYPT +ACL +XZ; fedora)
>21:12:41,101 INFO systemd: Detected virtualization 'kvm'.
>21:12:41,101 INFO systemd: Initializing machine ID from KVM UUID.
>21:12:41,101 WARNING systemd: Cannot add dependency job for unit udev-settle.service, ignoring: Unit udev-settle.service failed to load: No such file or directory. See system logs and 'systemctl status udev-settle.service' for details.
>21:12:41,101 INFO systemd: Started Apply Kernel Variables.
>21:12:41,101 INFO systemd: Started Remount Root and Kernel File Systems.
>21:12:41,101 INFO systemd: Mounted Huge Pages File System.
>21:12:41,101 INFO systemd: Mounted Debug File System.
>21:12:41,101 INFO systemd: Mounted POSIX Message Queue File System.
>21:12:41,101 INFO systemd: Starting Local File Systems (Pre).
>21:12:41,101 INFO systemd: Reached target Local File Systems (Pre).
>21:12:41,135 INFO systemd: Started Terminate Plymouth Boot Screen.
>21:12:41,135 INFO systemd: Started Wait for Plymouth Boot Screen to Quit.
>21:12:41,135 INFO systemd: Starting Shell on tty2...
>21:12:41,135 INFO systemd: Started Shell on tty2.
>21:12:41,164 NOTICE kernel:[    6.669728] type=1400 audit(1352236361.155:6): avc:  denied  { write } for  pid=533 comm="firewalld" name="python2.7" dev="dm-0" ino=1608 scontext=system_u:system_r:firewalld_t:s0 tcontext=unconfined_u:object_r:lib_t:s0 tclass=dir
>21:12:41,164 NOTICE kernel:[    6.669738] type=1400 audit(1352236361.155:7): avc:  denied  { remove_name } for  pid=533 comm="firewalld" name="site.pyc" dev="dm-0" ino=2265 scontext=system_u:system_r:firewalld_t:s0 tcontext=unconfined_u:object_r:lib_t:s0 tclass=dir
>21:12:41,164 NOTICE kernel:[    6.669744] type=1400 audit(1352236361.155:8): avc:  denied  { unlink } for  pid=533 comm="firewalld" name="site.pyc" dev="dm-0" ino=2265 scontext=system_u:system_r:firewalld_t:s0 tcontext=unconfined_u:object_r:lib_t:s0 tclass=lnk_file
>21:12:41,167 NOTICE kernel:[    6.679192] type=1400 audit(1352236361.165:9): avc:  denied  { add_name } for  pid=533 comm="firewalld" name="site.pyc" scontext=system_u:system_r:firewalld_t:s0 tcontext=unconfined_u:object_r:lib_t:s0 tclass=dir
>21:12:41,170 NOTICE kernel:[    6.679272] type=1400 audit(1352236361.165:10): avc:  denied  { create } for  pid=533 comm="firewalld" name="site.pyc" scontext=system_u:system_r:firewalld_t:s0 tcontext=system_u:object_r:lib_t:s0 tclass=file
>21:12:41,416 INFO kernel:[    6.929590] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0xb100, revision 0
>21:12:41,446 ERR systemd-udevd: ctx=0x7fa47dc169c0 path=/lib/modules/3.6.5-2.fc18.x86_64/kernel/sound/pci/hda/snd-hda-codec.ko error=No such file or directory
>21:12:41,446 ERR systemd-udevd: ctx=0x7fa47dc169c0 path=/lib/modules/3.6.5-2.fc18.x86_64/kernel/sound/pci/hda/snd-hda-codec.ko error=No such file or directory
>21:12:41,548 ERR systemd-udevd: ctx=0x7fa47dc169c0 path=/lib/modules/3.6.5-2.fc18.x86_64/kernel/sound/core/snd-pcm.ko error=No such file or directory
>21:12:41,672 INFO kernel:[    7.185937] microcode: CPU0 sig=0x623, pf=0x0, revision=0x1
>21:12:41,859 INFO kernel:[    7.372883] device label fedora devid 1 transid 32 /dev/vda2
>21:12:42,161 INFO kernel:[    7.674641] microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
>21:12:42,675 INFO systemd: Starting D-Bus System Message Bus...
>21:12:42,675 INFO systemd: Started D-Bus System Message Bus.
>21:12:42,718 INFO systemd: Started firewalld - dynamic firewall daemon.
>21:12:42,718 INFO systemd: Starting Network Manager...
>21:12:42,948 INFO NetworkManager: <info> NetworkManager (version 0.9.7.0-6.git20121004.fc18) is starting...
>21:12:42,948 INFO NetworkManager: <info> Read config file /etc/NetworkManager/NetworkManager.conf
>21:12:42,949 INFO NetworkManager: <info> WEXT support is enabled
>21:12:42,960 INFO dbus-daemon: dbus[574]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service'
>21:12:42,960 NOTICE dbus: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service'
>21:12:42,960 INFO systemd: Starting Authorization Manager...
>21:12:43,080 INFO polkitd: Started polkitd version 0.107
>21:12:43,168 INFO dbus-daemon: dbus[574]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
>21:12:43,168 NOTICE dbus: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
>21:12:43,168 INFO systemd: Started Authorization Manager.
>21:12:43,182 WARNING NetworkManager:    ifcfg-rh: Could not get hostname: failed to read /etc/sysconfig/network
>21:12:43,183 NOTICE NetworkManager:    ifcfg-rh: Acquired D-Bus service com.redhat.ifcfgrh1
>21:12:43,184 INFO NetworkManager: <info> Loaded plugin ifcfg-rh: (c) 2007 - 2010 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
>21:12:43,184 INFO NetworkManager: <info> Loaded plugin keyfile: (c) 2007 - 2010 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
>21:12:43,184 NOTICE NetworkManager:    ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-lo ...
>21:12:43,186 INFO NetworkManager: <info> monitoring kernel firmware directory '/lib/firmware'.
>21:12:43,195 INFO systemd: Started Network Manager.
>21:12:43,216 INFO systemd: Starting Anaconda System Services.
>21:12:43,246 INFO systemd: Reached target Anaconda System Services.
>21:12:43,247 INFO systemd: Starting Anaconda...
>21:12:43,250 INFO systemd: Starting Network Manager Wait Online...
>21:12:43,253 INFO NetworkManager: <info> WiFi enabled by radio killswitch; enabled by state file
>21:12:43,254 INFO NetworkManager: <info> WWAN enabled by radio killswitch; enabled by state file
>21:12:43,255 INFO NetworkManager: <info> WiMAX enabled by radio killswitch; enabled by state file
>21:12:43,256 INFO NetworkManager: <info> Networking is enabled by state file
>21:12:43,256 WARNING NetworkManager: <warn> failed to allocate link cache: (-10) Operation not supported
>21:12:43,259 INFO NetworkManager: <info> (eth0): carrier is OFF
>21:12:43,259 ERR NetworkManager: <error> [1352236363.258246] [nm-device-ethernet.c:454] update_permanent_hw_address(): (eth0): unable to read permanent MAC address (error 0)
>21:12:43,260 INFO NetworkManager: <info> (eth0): new Ethernet device (driver: 'virtio_net' ifindex: 2)
>21:12:43,261 INFO NetworkManager: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/0
>21:12:43,274 INFO NetworkManager: <info> (eth0): now managed
>21:12:43,277 INFO NetworkManager: <info> (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
>21:12:43,278 INFO NetworkManager: <info> (eth0): bringing up device.
>21:12:43,279 INFO NetworkManager: <info> (eth0): carrier now ON (device state 20)
>21:12:43,279 INFO NetworkManager: <info> (eth0): preparing device.
>21:12:43,280 INFO NetworkManager: <info> (eth0): deactivating device (reason 'managed') [2]
>21:12:43,313 INFO NetworkManager: <info> Added default wired connection 'Wired connection 1' for /sys/devices/pci0000:00/0000:00:03.0/virtio0/net/eth0
>21:12:43,318 WARNING NetworkManager: <warn> /sys/devices/virtual/net/lo: couldn't determine device driver; ignoring...
>21:12:43,320 WARNING NetworkManager: <warn> /sys/devices/virtual/net/lo: couldn't determine device driver; ignoring...
>21:12:43,322 INFO systemd: Started Anaconda.
>21:12:43,324 INFO systemd: Starting Anaconda Text Console...
>21:12:43,325 INFO systemd: Started Anaconda Text Console.
>21:12:43,327 INFO NetworkManager: <info> (eth0): device state change: unavailable -> disconnected (reason 'none') [20 30 0]
>21:12:43,340 INFO NetworkManager: <info> Auto-activating connection 'Wired connection 1'.
>21:12:43,341 INFO NetworkManager: <info> Activation (eth0) starting connection 'Wired connection 1'
>21:12:43,342 INFO NetworkManager: <info> (eth0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
>21:12:43,344 INFO NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
>21:12:43,346 INFO NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) started...
>21:12:43,346 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
>21:12:43,349 INFO NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
>21:12:43,350 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) starting...
>21:12:43,352 INFO NetworkManager: <info> (eth0): device state change: prepare -> config (reason 'none') [40 50 0]
>21:12:43,352 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) successful.
>21:12:43,375 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) complete.
>21:12:43,377 WARNING NetworkManager: <warn> (eth0) firewall zone add/change failed: (32) INVALID_ZONE: public
>21:12:43,377 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
>21:12:43,379 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
>21:12:43,379 INFO NetworkManager: <info> (eth0): device state change: config -> ip-config (reason 'none') [50 70 0]
>21:12:43,379 INFO NetworkManager: <info> Activation (eth0) Beginning DHCPv4 transaction (timeout in 45 seconds)
>21:12:43,401 INFO NetworkManager: <info> dhclient started with pid 599
>21:12:43,441 INFO NetworkManager: <info> Activation (eth0) Beginning IP6 addrconf.
>21:12:43,460 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
>21:12:43,605 INFO dhclient: Internet Systems Consortium DHCP Client 4.2.4-P2
>21:12:43,605 INFO dhclient: Copyright 2004-2012 Internet Systems Consortium.
>21:12:43,606 INFO dhclient: All rights reserved.
>21:12:43,606 INFO dhclient: For info, please visit https://www.isc.org/software/dhcp/
>21:12:43,606 INFO dhclient:
>21:12:43,621 INFO NetworkManager: <info> (eth0): DHCPv4 state changed nbi -> preinit
>21:12:43,623 WARNING kernel:[    9.136498] audit_printk_skb: 21 callbacks suppressed
>21:12:43,623 NOTICE kernel:[    9.136501] type=1400 audit(1352236363.622:18): avc:  denied  { read write } for  pid=606 comm="hostname" path="/dev/pts/1" dev="devpts" ino=4 scontext=system_u:system_r:hostname_t:s0 tcontext=system_u:object_r:devpts_t:s0 tclass=chr_file
>21:12:43,624 INFO dhclient: Listening on LPF/eth0/52:54:00:c8:e7:e9
>21:12:43,624 INFO dhclient: Sending on   LPF/eth0/52:54:00:c8:e7:e9
>21:12:43,625 INFO dhclient: Sending on   Socket/fallback
>21:12:43,625 INFO dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 5 (xid=0x29b4b014)
>21:12:43,628 INFO dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67 (xid=0x29b4b014)
>21:12:43,628 INFO dhclient: DHCPOFFER from 192.168.122.1
>21:12:43,634 INFO dhclient: DHCPACK from 192.168.122.1 (xid=0x29b4b014)
>21:12:43,637 INFO NetworkManager: <info> (eth0): DHCPv4 state changed preinit -> bound
>21:12:43,637 INFO NetworkManager: <info>   address 192.168.122.127
>21:12:43,637 INFO NetworkManager: <info>   prefix 24 (255.255.255.0)
>21:12:43,637 INFO NetworkManager: <info>   gateway 192.168.122.1
>21:12:43,638 INFO NetworkManager: <info>   nameserver '192.168.122.1'
>21:12:43,639 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
>21:12:43,639 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Commit) started...
>21:12:43,645 INFO dhclient: bound to 192.168.122.127 -- renewal in 1651 seconds.
>21:12:44,644 INFO NetworkManager: <info> (eth0): device state change: ip-config -> secondaries (reason 'none') [70 90 0]
>21:12:44,644 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Commit) complete.
>21:12:44,644 INFO NetworkManager: <info> (eth0): device state change: secondaries -> activated (reason 'none') [90 100 0]
>21:12:44,658 INFO systemd: Started Network Manager Wait Online.
>21:12:44,658 INFO systemd: Starting Network.
>21:12:44,658 INFO systemd: Reached target Network.
>21:12:44,658 INFO systemd: Startup finished in 3s 179ms 755us (kernel) + 2s 1ms 505us (initrd) + 4s 988ms 341us (userspace) = 10s 169ms 601us.
>21:12:44,665 INFO NetworkManager: <info> Policy set 'Wired connection 1' (eth0) as default for IPv4 routing and DNS.
>21:12:44,681 INFO NetworkManager: <info> Activation (eth0) successful, device activated.
>21:12:44,682 NOTICE dbus: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
>21:12:44,689 INFO dbus-daemon: dbus[574]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
>21:12:44,733 INFO dbus-daemon: dbus[574]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
>21:12:44,733 NOTICE dbus: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
>21:12:44,815 INFO dbus-daemon: /etc/NetworkManager/dispatcher.d/04-iscsi: line 14: /sbin/chkconfig: No such file or directory
>21:12:45,105 NOTICE kernel:[   10.618331] type=1400 audit(1352236365.104:19): avc:  denied  { read write } for  pid=634 comm="auditd" path="/dev/mapper/control" dev="devtmpfs" ino=7336 scontext=system_u:system_r:auditd_t:s0 tcontext=system_u:object_r:lvm_control_t:s0 tclass=chr_file
>21:12:45,115 WARNING kernel:[   10.628250] auditd (635): /proc/635/oom_adj is deprecated, please use /proc/635/oom_score_adj instead.
>21:12:45,373 INFO kernel:[   10.886559] device label fedora devid 1 transid 32 /dev/vda2
>21:12:45,394 INFO kernel:[   10.907116] device label fedora devid 1 transid 32 /dev/vda2
>21:12:48,262 INFO systemd: Starting NTP client/server...
>21:12:48,314 INFO kernel:[   13.827369] device label fedora devid 1 transid 32 /dev/vda2
>21:12:48,315 INFO kernel:[   13.828444] device label fedora devid 1 transid 32 /dev/vda2
>21:12:48,322 INFO chrony-helper: tr: write error: Broken pipe
>21:12:48,322 INFO chrony-helper: tr: write error
>21:12:48,353 INFO chronyd: chronyd version 1.27-git1ca844 starting
>21:12:48,354 INFO chronyd: Linux kernel major=3 minor=6 patch=5
>21:12:48,354 INFO chronyd: hz=100 shift_hz=7 freq_scale=1.00000000 nominal_tick=10000 slew_delta_tick=833 max_tick_bias=1000 shift_pll=2
>21:12:48,362 INFO systemd: Started NTP client/server.
>21:12:49,183 NOTICE NetworkManager:    ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-eth0 ...
>21:12:49,183 WARNING NetworkManager: <warn> failed to allocate link cache: (-10) Operation not supported
>21:12:49,183 NOTICE NetworkManager:    ifcfg-rh:     read connection 'System eth0'
>21:12:49,183 WARNING NetworkManager: <warn> failed to allocate link cache: (-10) Operation not supported
>21:12:49,264 INFO kernel:[   14.776549] device label fedora devid 1 transid 32 /dev/vda2
>21:12:49,264 INFO kernel:[   14.777707] device label fedora devid 1 transid 32 /dev/vda2
>21:12:49,358 INFO kernel:[   14.871771] device label fedora devid 1 transid 32 /dev/vda2
>21:12:49,359 INFO kernel:[   14.872877] btrfs: disk space caching is enabled
>21:12:49,361 DEBUG kernel:[   14.874887] SELinux: initialized (dev vda2, type btrfs), uses xattr
>21:12:50,496 INFO kernel:[   16.008490] device label fedora devid 1 transid 34 /dev/vda2
>21:12:50,496 INFO kernel:[   16.009816] btrfs: disk space caching is enabled
>21:12:50,500 DEBUG kernel:[   16.013541] SELinux: initialized (dev vda2, type btrfs), uses xattr
>21:12:53,587 INFO chronyd: Selected source 50.116.38.157
>21:12:53,587 WARNING chronyd: System clock wrong by 2.132207 seconds, adjustment started
>21:12:55,714 INFO chronyd: Selected source 216.45.57.38
>21:13:03,490 INFO NetworkManager: <info> (eth0): IP6 addrconf timed out or failed.
>21:13:03,490 INFO NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
>21:13:03,490 INFO NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IPv6 Configure Timeout) started...
>21:13:03,491 INFO NetworkManager: <info> Activation (eth0) Stage 4 of 5 (IPv6 Configure Timeout) complete.
>21:13:19,518 INFO kernel:[   45.131699] SGI XFS with ACLs, security attributes, large block/inode numbers, no debug enabled
>21:14:39,734 INFO kernel:[  125.347552] device label fedora devid 1 transid 34 /dev/vda2
>21:14:39,736 INFO kernel:[  125.349248] btrfs: disk space caching is enabled
>21:14:39,742 DEBUG kernel:[  125.354064] SELinux: initialized (dev vda2, type btrfs), uses xattr
>

Actions: View

Attachments on bug 872849: 637612 | 637613 | 637614 | 637615 | 637616 | 637617 | 637618 | 637619 | 637620 | 637621 | 637622 | 637623 | 637624 | 637625 | 637626 | 637685 | 637687 | 639625 | 639626 | 639627