Attachment 619624 Details for Bug 861847 – File: anaconda-tb

File: anaconda-tb

anaconda-tb (text/plain), 215.20 KB, created by Honza Horak on 2012-10-01 06:42:42 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Honza Horak

Created: 2012-10-01 06:42:42 UTC

Size: 215.20 KB

patch

obsolete

>anaconda 18.8 exception report
>Traceback (most recent call first):
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/errors.py", line 248, in cb
>    StorageError.PartitioningWarning: self._partitionWarningHandler,
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py", line 1164, in install
>    if errorHandler.cb(exn) == ERROR_RAISE:
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/install.py", line 113, in doInstall
>    payload.install()
>  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 87, in run
>    threading.Thread.run(self, *args, **kwargs)
>AttributeError: 'module' object has no attribute 'PartitioningWarning'
>
>Local variables in innermost frame:
>NoSuchGroup: <class 'pyanaconda.packaging.NoSuchGroup'>
>args: ()
>NoSuchPackage: <class 'pyanaconda.packaging.NoSuchPackage'>
>KickstartError: <class 'pykickstart.errors.KickstartError'>
>exn: failure: Packages/m/mesa-libgbm-9.0-0.2.fc18.x86_64.rpm from anaconda: [Errno 256] No more mirrors to try.
>http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/Packages/m/mesa-libgbm-9.0-0.2.fc18.x86_64.rpm: [Errno 12] Timeout on http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/Packages/m/mesa-libgbm-9.0-0.2.fc18.x86_64.rpm: (28, '')
>self: <pyanaconda.errors.ErrorHandler object at 0x7ffed7820dd0>
>rc: 0
>kwargs: {}
>StorageError: <module 'pyanaconda.storage.errors' from '/usr/lib64/python2.7/site-packages/pyanaconda/storage/errors.py'>
>
>
>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: NoDevice instance, containing members:
>        _intf.storage.fsset._usb._model: Skipped
>        _intf.storage.fsset._usb.controllable: True
>        _intf.storage.fsset._usb.major: 0
>        _intf.storage.fsset._usb.kids: 0
>        _intf.storage.fsset._usb._partedDevice: None
>        _intf.storage.fsset._usb.uuid: None
>        _intf.storage.fsset._usb.exists: True
>        _intf.storage.fsset._usb.fstabComment: Skipped
>        _intf.storage.fsset._usb._format: USBFS instance, containing members:
>          _intf.storage.fsset._usb._format.uuid: None
>          _intf.storage.fsset._usb._format.exists: True
>          _intf.storage.fsset._usb._format._mountpoint: None
>          _intf.storage.fsset._usb._format._majorminor: None
>          _intf.storage.fsset._usb._format._minInstanceSize: None
>          _intf.storage.fsset._usb._format._mountType: usbfs
>          _intf.storage.fsset._usb._format.fsprofile: None
>          _intf.storage.fsset._usb._format.label: None
>          _intf.storage.fsset._usb._format._targetSize: 0
>          _intf.storage.fsset._usb._format._size: 0
>          _intf.storage.fsset._usb._format.mountopts: None
>          _intf.storage.fsset._usb._format.mountpoint: /proc/bus/usb
>          _intf.storage.fsset._usb._format._migrate: False
>          _intf.storage.fsset._usb._format._device: usbfs
>        _intf.storage.fsset._usb.sysfsPath: Skipped
>        _intf.storage.fsset._usb._vendor: Skipped
>        _intf.storage.fsset._usb._name: usbfs
>        _intf.storage.fsset._usb._targetSize: 0
>        _intf.storage.fsset._usb.protected: False
>        _intf.storage.fsset._usb.parents: []
>        _intf.storage.fsset._usb.originalFormat: Already dumped (USBFS instance)
>        _intf.storage.fsset._usb.bus: Skipped
>        _intf.storage.fsset._usb._size: 0
>        _intf.storage.fsset._usb._serial: None
>        _intf.storage.fsset._usb.id: 17
>        _intf.storage.fsset._usb.minor: 0
>      _intf.storage.fsset.devicetree: DeviceTree instance, containing members:
>        _intf.storage.fsset.devicetree.populated: True
>        _intf.storage.fsset.devicetree._hidden: []
>        _intf.storage.fsset.devicetree.names: [vda, loop0, /tmp/curl_fetch_url1/squashfs.img (deleted), loop1, /LiveOS/rootfs.img, loop2, /overlay (deleted), loop3, loop4, loop5, loop6, loop7, live-rw]
>        _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.shouldClear: <bound method Storage.shouldClear of <pyanaconda.storage.Storage object at 0x7ffed5494950>>
>        _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: []
>          _intf.storage.fsset.devicetree.topology._devmap: {'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:05.0/virtio1/block/vda
>            _intf.storage.fsset.devicetree.topology._devmap.devpath: /devices/pci0000:00/0000:00:05.0/virtio1/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
>, '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)
>]
>          _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: [existing 8192MB disk vda (0) with existing 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: /tmp/curl_fetch_url1/squashfs.img (deleted)
>          _targetSize: 0
>          protected: False
>          parents: []
>          originalFormat: Already dumped (DeviceFormat instance)
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 1
>          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: Already dumped (DeviceFormat instance)
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 2
>          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: Already dumped (DeviceFormat instance)
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 3
>          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: 7665a7af-d474-4551-aed7-4f614ae7402c
>            _format.exists: True
>            _format._mountpoint: None
>            _format._majorminor: None
>            _format._minInstanceSize: 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: Already dumped (Ext4FS instance)
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 4
>          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: Already dumped (DeviceFormat instance)
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 5
>          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: Already dumped (DeviceFormat instance)
>          bus: Skipped
>          _size: 0
>          _serial: None
>          id: 6
>          minor: 0
>, existing 1024MB dm live-rw (7) with existing ext4 filesystem
>, existing 5707MB partition vda3 (8) with existing ext4 filesystem mounted at /
>, existing 500MB partition vda1 (9) with existing ext4 filesystem mounted at /boot
>, existing 1984MB partition vda2 (10) with existing swap
>]
>        _intf.storage.fsset.devicetree.protectedDevNames: []
>        _intf.storage.fsset.devicetree.diskImages: {}
>        _intf.storage.fsset.devicetree._actions: [ActionDestroyFormat instance, containing members:
>          device: Already dumped (DiskDevice instance)
>          origFormat: non-existent None
>          id: 0
>, ActionCreateFormat instance, containing members:
>          device: Already dumped (DiskDevice instance)
>          origFormat: existing None
>          id: 1
>, ActionCreateDevice instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          id: 4
>, ActionCreateDevice instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          id: 6
>, ActionCreateFormat instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          origFormat: non-existent None
>          id: 7
>, ActionCreateDevice instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          id: 2
>, ActionCreateFormat instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          origFormat: non-existent None
>          id: 3
>, ActionCreateFormat instance, containing members:
>          device: Already dumped (PartitionDevice instance)
>          origFormat: non-existent None
>          id: 5
>]
>      _intf.storage.fsset.preserveLines: []
>      _intf.storage.fsset._devshm: NoDevice instance, containing members:
>        _intf.storage.fsset._devshm._model: Skipped
>        _intf.storage.fsset._devshm.controllable: True
>        _intf.storage.fsset._devshm.major: 0
>        _intf.storage.fsset._devshm.kids: 0
>        _intf.storage.fsset._devshm._partedDevice: None
>        _intf.storage.fsset._devshm.uuid: None
>        _intf.storage.fsset._devshm.exists: True
>        _intf.storage.fsset._devshm.fstabComment: Skipped
>        _intf.storage.fsset._devshm._format: TmpFS instance, containing members:
>          _intf.storage.fsset._devshm._format.uuid: None
>          _intf.storage.fsset._devshm._format.exists: True
>          _intf.storage.fsset._devshm._format._mountpoint: /mnt/sysimage/dev/shm
>          _intf.storage.fsset._devshm._format._majorminor: None
>          _intf.storage.fsset._devshm._format._minInstanceSize: None
>          _intf.storage.fsset._devshm._format._mountType: tmpfs
>          _intf.storage.fsset._devshm._format.fsprofile: None
>          _intf.storage.fsset._devshm._format.label: None
>          _intf.storage.fsset._devshm._format._targetSize: 0
>          _intf.storage.fsset._devshm._format._size: 0
>          _intf.storage.fsset._devshm._format.mountopts: None
>          _intf.storage.fsset._devshm._format.mountpoint: /dev/shm
>          _intf.storage.fsset._devshm._format._migrate: False
>          _intf.storage.fsset._devshm._format._device: tmpfs
>        _intf.storage.fsset._devshm.sysfsPath: Skipped
>        _intf.storage.fsset._devshm._vendor: Skipped
>        _intf.storage.fsset._devshm._name: tmpfs
>        _intf.storage.fsset._devshm._targetSize: 0
>        _intf.storage.fsset._devshm.protected: False
>        _intf.storage.fsset._devshm.parents: []
>        _intf.storage.fsset._devshm.originalFormat: Already dumped (TmpFS instance)
>        _intf.storage.fsset._devshm.bus: Skipped
>        _intf.storage.fsset._devshm._size: 0
>        _intf.storage.fsset._devshm._serial: None
>        _intf.storage.fsset._devshm.id: 12
>        _intf.storage.fsset._devshm.minor: 0
>      _intf.storage.fsset._dev: DirectoryDevice instance, containing members:
>        _intf.storage.fsset._dev._model: Skipped
>        _intf.storage.fsset._dev.controllable: True
>        _intf.storage.fsset._dev.major: 0
>        _intf.storage.fsset._dev.kids: 0
>        _intf.storage.fsset._dev._partedDevice: None
>        _intf.storage.fsset._dev.uuid: None
>        _intf.storage.fsset._dev.exists: True
>        _intf.storage.fsset._dev.fstabComment: Skipped
>        _intf.storage.fsset._dev._format: BindFS instance, containing members:
>          _intf.storage.fsset._dev._format.uuid: None
>          _intf.storage.fsset._dev._format.exists: True
>          _intf.storage.fsset._dev._format._mountpoint: /mnt/sysimage/dev
>          _intf.storage.fsset._dev._format._majorminor: None
>          _intf.storage.fsset._dev._format._minInstanceSize: None
>          _intf.storage.fsset._dev._format._mountType: bind
>          _intf.storage.fsset._dev._format.fsprofile: None
>          _intf.storage.fsset._dev._format.label: None
>          _intf.storage.fsset._dev._format._targetSize: None
>          _intf.storage.fsset._dev._format._size: None
>          _intf.storage.fsset._dev._format.mountopts: None
>          _intf.storage.fsset._dev._format.mountpoint: /dev
>          _intf.storage.fsset._dev._format._migrate: False
>          _intf.storage.fsset._dev._format._device: /dev
>        _intf.storage.fsset._dev.sysfsPath: Skipped
>        _intf.storage.fsset._dev._vendor: Skipped
>        _intf.storage.fsset._dev._name: /dev
>        _intf.storage.fsset._dev._targetSize: 0
>        _intf.storage.fsset._dev.protected: False
>        _intf.storage.fsset._dev.parents: []
>        _intf.storage.fsset._dev.originalFormat: Already dumped (BindFS instance)
>        _intf.storage.fsset._dev.bus: Skipped
>        _intf.storage.fsset._dev._size: 0
>        _intf.storage.fsset._dev._serial: None
>        _intf.storage.fsset._dev.id: 11
>        _intf.storage.fsset._dev.minor: 0
>      _intf.storage.fsset.blkidTab: None
>      _intf.storage.fsset._proc: NoDevice instance, containing members:
>        _intf.storage.fsset._proc._model: Skipped
>        _intf.storage.fsset._proc.controllable: True
>        _intf.storage.fsset._proc.major: 0
>        _intf.storage.fsset._proc.kids: 0
>        _intf.storage.fsset._proc._partedDevice: None
>        _intf.storage.fsset._proc.uuid: None
>        _intf.storage.fsset._proc.exists: True
>        _intf.storage.fsset._proc.fstabComment: Skipped
>        _intf.storage.fsset._proc._format: ProcFS instance, containing members:
>          _intf.storage.fsset._proc._format.uuid: None
>          _intf.storage.fsset._proc._format.exists: True
>          _intf.storage.fsset._proc._format._mountpoint: /mnt/sysimage/proc
>          _intf.storage.fsset._proc._format._majorminor: None
>          _intf.storage.fsset._proc._format._minInstanceSize: None
>          _intf.storage.fsset._proc._format._mountType: proc
>          _intf.storage.fsset._proc._format.fsprofile: None
>          _intf.storage.fsset._proc._format.label: None
>          _intf.storage.fsset._proc._format._targetSize: 0
>          _intf.storage.fsset._proc._format._size: 0
>          _intf.storage.fsset._proc._format.mountopts: None
>          _intf.storage.fsset._proc._format.mountpoint: /proc
>          _intf.storage.fsset._proc._format._migrate: False
>          _intf.storage.fsset._proc._format._device: proc
>        _intf.storage.fsset._proc.sysfsPath: Skipped
>        _intf.storage.fsset._proc._vendor: Skipped
>        _intf.storage.fsset._proc._name: proc
>        _intf.storage.fsset._proc._targetSize: 0
>        _intf.storage.fsset._proc.protected: False
>        _intf.storage.fsset._proc.parents: []
>        _intf.storage.fsset._proc.originalFormat: Already dumped (ProcFS instance)
>        _intf.storage.fsset._proc.bus: Skipped
>        _intf.storage.fsset._proc._size: 0
>        _intf.storage.fsset._proc._serial: None
>        _intf.storage.fsset._proc.id: 15
>        _intf.storage.fsset._proc.minor: 0
>      _intf.storage.fsset.active: True
>      _intf.storage.fsset.cryptTab: CryptTab instance, containing members:
>        _intf.storage.fsset.cryptTab.devicetree: Already dumped (DeviceTree instance)
>        _intf.storage.fsset.cryptTab.blkidTab: None
>        _intf.storage.fsset.cryptTab.chroot: Skipped
>        _intf.storage.fsset.cryptTab.mappings: {}
>      _intf.storage.fsset._devpts: NoDevice instance, containing members:
>        _intf.storage.fsset._devpts._model: Skipped
>        _intf.storage.fsset._devpts.controllable: True
>        _intf.storage.fsset._devpts.major: 0
>        _intf.storage.fsset._devpts.kids: 0
>        _intf.storage.fsset._devpts._partedDevice: None
>        _intf.storage.fsset._devpts.uuid: None
>        _intf.storage.fsset._devpts.exists: True
>        _intf.storage.fsset._devpts.fstabComment: Skipped
>        _intf.storage.fsset._devpts._format: DevPtsFS instance, containing members:
>          _intf.storage.fsset._devpts._format.uuid: None
>          _intf.storage.fsset._devpts._format.exists: True
>          _intf.storage.fsset._devpts._format._mountpoint: /mnt/sysimage/dev/pts
>          _intf.storage.fsset._devpts._format._majorminor: None
>          _intf.storage.fsset._devpts._format._minInstanceSize: None
>          _intf.storage.fsset._devpts._format._mountType: devpts
>          _intf.storage.fsset._devpts._format.fsprofile: None
>          _intf.storage.fsset._devpts._format.label: None
>          _intf.storage.fsset._devpts._format._targetSize: 0
>          _intf.storage.fsset._devpts._format._size: 0
>          _intf.storage.fsset._devpts._format.mountopts: None
>          _intf.storage.fsset._devpts._format.mountpoint: /dev/pts
>          _intf.storage.fsset._devpts._format._migrate: False
>          _intf.storage.fsset._devpts._format._device: devpts
>        _intf.storage.fsset._devpts.sysfsPath: Skipped
>        _intf.storage.fsset._devpts._vendor: Skipped
>        _intf.storage.fsset._devpts._name: devpts
>        _intf.storage.fsset._devpts._targetSize: 0
>        _intf.storage.fsset._devpts.protected: False
>        _intf.storage.fsset._devpts.parents: []
>        _intf.storage.fsset._devpts.originalFormat: Already dumped (DevPtsFS instance)
>        _intf.storage.fsset._devpts.bus: Skipped
>        _intf.storage.fsset._devpts._size: 0
>        _intf.storage.fsset._devpts._serial: None
>        _intf.storage.fsset._devpts.id: 13
>        _intf.storage.fsset._devpts.minor: 0
>      _intf.storage.fsset._sysfs: NoDevice instance, containing members:
>        _intf.storage.fsset._sysfs._model: Skipped
>        _intf.storage.fsset._sysfs.controllable: True
>        _intf.storage.fsset._sysfs.major: 0
>        _intf.storage.fsset._sysfs.kids: 0
>        _intf.storage.fsset._sysfs._partedDevice: None
>        _intf.storage.fsset._sysfs.uuid: None
>        _intf.storage.fsset._sysfs.exists: True
>        _intf.storage.fsset._sysfs.fstabComment: Skipped
>        _intf.storage.fsset._sysfs._format: SysFS instance, containing members:
>          _intf.storage.fsset._sysfs._format.uuid: None
>          _intf.storage.fsset._sysfs._format.exists: True
>          _intf.storage.fsset._sysfs._format._mountpoint: /mnt/sysimage/sys
>          _intf.storage.fsset._sysfs._format._majorminor: None
>          _intf.storage.fsset._sysfs._format._minInstanceSize: None
>          _intf.storage.fsset._sysfs._format._mountType: sysfs
>          _intf.storage.fsset._sysfs._format.fsprofile: None
>          _intf.storage.fsset._sysfs._format.label: None
>          _intf.storage.fsset._sysfs._format._targetSize: 0
>          _intf.storage.fsset._sysfs._format._size: 0
>          _intf.storage.fsset._sysfs._format.mountopts: None
>          _intf.storage.fsset._sysfs._format.mountpoint: /sys
>          _intf.storage.fsset._sysfs._format._migrate: False
>          _intf.storage.fsset._sysfs._format._device: sysfs
>        _intf.storage.fsset._sysfs.sysfsPath: Skipped
>        _intf.storage.fsset._sysfs._vendor: Skipped
>        _intf.storage.fsset._sysfs._name: sysfs
>        _intf.storage.fsset._sysfs._targetSize: 0
>        _intf.storage.fsset._sysfs.protected: False
>        _intf.storage.fsset._sysfs.parents: []
>        _intf.storage.fsset._sysfs.originalFormat: Already dumped (SysFS instance)
>        _intf.storage.fsset._sysfs.bus: Skipped
>        _intf.storage.fsset._sysfs._size: 0
>        _intf.storage.fsset._sysfs._serial: None
>        _intf.storage.fsset._sysfs.id: 14
>        _intf.storage.fsset._sysfs.minor: 0
>      _intf.storage.fsset._selinux: NoDevice instance, containing members:
>        _intf.storage.fsset._selinux._model: Skipped
>        _intf.storage.fsset._selinux.controllable: True
>        _intf.storage.fsset._selinux.major: 0
>        _intf.storage.fsset._selinux.kids: 0
>        _intf.storage.fsset._selinux._partedDevice: None
>        _intf.storage.fsset._selinux.uuid: None
>        _intf.storage.fsset._selinux.exists: True
>        _intf.storage.fsset._selinux.fstabComment: Skipped
>        _intf.storage.fsset._selinux._format: SELinuxFS instance, containing members:
>          _intf.storage.fsset._selinux._format.uuid: None
>          _intf.storage.fsset._selinux._format.exists: True
>          _intf.storage.fsset._selinux._format._mountpoint: /mnt/sysimage/sys/fs/selinux
>          _intf.storage.fsset._selinux._format._majorminor: None
>          _intf.storage.fsset._selinux._format._minInstanceSize: None
>          _intf.storage.fsset._selinux._format._mountType: selinuxfs
>          _intf.storage.fsset._selinux._format.fsprofile: None
>          _intf.storage.fsset._selinux._format.label: None
>          _intf.storage.fsset._selinux._format._targetSize: 0
>          _intf.storage.fsset._selinux._format._size: 0
>          _intf.storage.fsset._selinux._format.mountopts: None
>          _intf.storage.fsset._selinux._format.mountpoint: /sys/fs/selinux
>          _intf.storage.fsset._selinux._format._migrate: False
>          _intf.storage.fsset._selinux._format._device: selinuxfs
>        _intf.storage.fsset._selinux.sysfsPath: Skipped
>        _intf.storage.fsset._selinux._vendor: Skipped
>        _intf.storage.fsset._selinux._name: selinuxfs
>        _intf.storage.fsset._selinux._targetSize: 0
>        _intf.storage.fsset._selinux.protected: False
>        _intf.storage.fsset._selinux.parents: []
>        _intf.storage.fsset._selinux.originalFormat: Already dumped (SELinuxFS instance)
>        _intf.storage.fsset._selinux.bus: Skipped
>        _intf.storage.fsset._selinux._size: 0
>        _intf.storage.fsset._selinux._serial: None
>        _intf.storage.fsset._selinux.id: 16
>        _intf.storage.fsset._selinux.minor: 0
>    _intf.storage.platform: X86 instance, containing members:
>    _intf.storage.config: StorageDiscoveryConfig instance, containing members:
>      _intf.storage.config.clearPartType: 1
>      _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: 0
>    _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: 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 (0x7ffebb657090) -- 
>  mountpoint = /  lv = True  singlePV = False  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024  maxSize = 51200  grow = True
>
>, PartSpec instance (0x7ffebc4cac50) -- 
>  mountpoint = /home  lv = True  singlePV = False  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500  maxSize = None  grow = True
>
>, PartSpec instance (0x7ffebdbb6bd0) -- 
>  mountpoint = /boot  lv = False  singlePV = False  btrfs = False
>  weight = 2000  fstype = ext4  encrypted = False
>  size = 500  maxSize = None  grow = False
>
>, PartSpec instance (0x7ffebdbb6ad0) -- 
>  mountpoint = None  lv = False  singlePV = False  btrfs = False
>  weight = 5000  fstype = biosboot  encrypted = False
>  size = 1  maxSize = None  grow = False
>
>, PartSpec instance (0x7ffebdbb6dd0) -- 
>  mountpoint = None  lv = True  singlePV = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 1984  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._groups: Skipped
>    _intf.payload._yum: Skipped
>    _intf.payload.install_device: None
>    _intf.payload._root_dir: /tmp/yum.root
>    _intf.payload._repos_dir: /tmp/yum.repos.d
>    _intf.payload._packages: []
>    _intf.payload._setup: True
>    _intf.payload.txID: 1349073300.36
>    _intf.payload._createdInitrds: False
>    _intf.payload._space_required: 2.69 Gb
>    _intf.payload.data: Skipped
>    _intf.payload._kernelVersionList: []
>updateSrc: None
>firewall: Firewall instance, containing members:
>  firewall.portlist: []
>  firewall.servicelist: []
>  firewall.trustdevs: []
>  firewall.enabled: 1
>rootParts: None
>clearPartTypeSystem: None
>upgradeRoot: None
>_platform: Already dumped (X86 instance)
>id: None
>rescue: False
>mediaDevice: None
>upgrade: False
>_network: None
>methodstr: http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/
>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: None
>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.8
>  mehConfig.attrSkipList: [_intf._actions, _intf.storage.bootloader.password, _intf.storage.data, _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
>clearPartTypeSelection: 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': None, 'method': 'http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/', '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:
>06:27:59,400 INFO anaconda: /sbin/anaconda 18.8
>06:28:01,647 INFO anaconda: 1048576 kB (1024 MB) are available
>06:28:01,647 INFO anaconda: check_memory(): total:1024, needed:512, graphical:512
>06:28:01,686 INFO anaconda: anaconda called with cmdline = ['/sbin/anaconda']
>06:28:01,690 INFO anaconda: Default encoding = utf-8 
>06:28:02,526 INFO anaconda: No FCoE EDD info found: No FCoE boot disk information is found in EDD!
>06:28:02,529 INFO anaconda: no /etc/zfcp.conf; not configuring zfcp
>06:28:03,077 INFO anaconda: Display mode = g
>06:28:03,081 INFO anaconda: 1048576 kB (1024 MB) are available
>06:28:03,084 INFO anaconda: check_memory(): total:1024, needed:512, graphical:512
>06:28:05,258 DEBUG anaconda: X server has signalled a successful start.
>06:28:05,276 INFO anaconda: Starting window manager, pid 721.
>06:28:08,966 INFO anaconda: using only installclass _Fedora
>06:28:10,616 INFO anaconda: Detected 992M of memory
>06:28:10,619 INFO anaconda: Swap attempt of 1984M
>06:28:14,755 DEBUG anaconda: required disklabel type for vda (15) is None
>06:28:14,758 DEBUG anaconda: default disklabel type for vda is msdos
>06:28:14,763 DEBUG anaconda: selecting msdos disklabel for vda based on size
>06:32:41,757 WARN anaconda:  is not a valid timezone, falling back to default (America/New_York)
>08:34:26,016 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)
>
>08:34:29,548 DEBUG anaconda: required disklabel type for vda (15) is None
>08:34:29,555 DEBUG anaconda: default disklabel type for vda is msdos
>08:34:29,652 DEBUG anaconda: selecting msdos disklabel for vda based on size
>08:34:30,842 INFO anaconda: Detected 992M of memory
>08:34:30,846 INFO anaconda: Swap attempt of 1984M
>08:34:41,511 DEBUG anaconda: notifying kernel of 'change' event on device /sys/class/block/vda2
>08:34:51,529 DEBUG anaconda: notifying kernel of 'change' event on device /sys/class/block/vda3
>08:34:53,761 DEBUG anaconda: notifying kernel of 'change' event on device /sys/class/block/vda1
>08:34:55,321 DEBUG anaconda: isys.py:mount()- going to mount /dev/vda3 on /mnt/sysimage as ext4 with options defaults
>08:34:55,942 DEBUG anaconda: isys.py:mount()- going to mount /dev/vda1 on /mnt/sysimage/boot as ext4 with options defaults
>08:34:56,259 DEBUG anaconda: isys.py:mount()- going to mount /dev on /mnt/sysimage/dev as bind with options defaults,bind
>08:34:56,412 DEBUG anaconda: isys.py:mount()- going to mount devpts on /mnt/sysimage/dev/pts as devpts with options gid=5,mode=620
>08:34:56,545 DEBUG anaconda: isys.py:mount()- going to mount tmpfs on /mnt/sysimage/dev/shm as tmpfs with options defaults
>08:34:56,751 INFO anaconda: failed to get default SELinux context for /proc: [Errno 2] No such file or directory
>08:34:56,757 DEBUG anaconda: isys.py:mount()- going to mount proc on /mnt/sysimage/proc as proc with options defaults
>08:34:56,811 INFO anaconda: failed to get default SELinux context for /proc: [Errno 2] No such file or directory
>08:34:57,741 DEBUG anaconda: isys.py:mount()- going to mount sysfs on /mnt/sysimage/sys as sysfs with options defaults
>08:34:57,916 DEBUG anaconda: isys.py:mount()- going to mount selinuxfs on /mnt/sysimage/sys/fs/selinux as selinuxfs with options defaults
>08:34:58,012 INFO anaconda: failed to set SELinux context for /mnt/sysimage/sys/fs/selinux: [Errno 95] Operation not supported
>08:34:58,103 INFO anaconda: copy_to_sysimage: source '/etc/multipath/wwids' does not exist.
>08:34:58,106 INFO anaconda: copy_to_sysimage: source '/etc/multipath/bindings' does not exist.
>
>
>/tmp/packaging.log:
>06:28:10,568 DEBUG packaging: getting release version from tree at None (18)
>06:28:10,571 DEBUG packaging: got a release version of 18
>06:28:20,176 INFO packaging: updating base repo
>06:28:20,831 DEBUG packaging: getting release version from tree at None (18)
>06:28:20,840 DEBUG packaging: got a release version of 18
>06:28:20,842 INFO packaging: configuring base repo
>06:28:20,847 DEBUG packaging: getting release version from tree at http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/ (18)
>06:28:20,847 DEBUG packaging: retrieving treeinfo from http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/ (proxies: {} ; sslverify: True)
>06:28:21,073 DEBUG packaging: got a release version of 18
>06:28:21,140 DEBUG packaging: adding yum repo anaconda with baseurl http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/ and mirrorlist None
>06:28:21,261 DEBUG packaging: disabling repo fedora
>06:28:21,265 DEBUG packaging: disabling repo updates-testing
>06:28:21,266 DEBUG packaging: disabling repo updates
>06:28:21,266 INFO packaging: gathering repo metadata
>06:28:21,267 DEBUG packaging: getting repo metadata for anaconda
>06:28:22,292 DEBUG packaging: getting group info for anaconda
>06:28:22,615 INFO packaging: metadata retrieval complete
>02:32:54,006 DEBUG packaging: deleting package sacks
>02:33:40,040 INFO packaging: checking software selection
>02:33:40,047 DEBUG packaging: deleting package sacks
>02:33:40,051 DEBUG packaging: select group core
>02:33:41,257 DEBUG packaging: select group core
>02:33:41,260 DEBUG packaging: select group gnome-desktop
>02:33:41,351 DEBUG packaging: select group multimedia
>02:33:41,379 DEBUG packaging: select group input-methods
>02:33:41,394 DEBUG packaging: select group base-x
>02:33:41,417 DEBUG packaging: select group fonts
>02:33:41,480 DEBUG packaging: select group hardware-support
>02:33:41,502 DEBUG packaging: select group dial-up
>02:33:41,511 DEBUG packaging: select group printing
>02:33:41,576 DEBUG packaging: select group firefox
>02:33:41,582 DEBUG packaging: select group standard
>02:33:41,660 DEBUG packaging: select package kernel-PAE
>02:33:41,828 INFO packaging: no kernel-PAE package
>02:33:41,831 DEBUG packaging: select package kernel
>02:33:41,832 INFO packaging: selected kernel
>02:33:41,832 INFO packaging: checking dependencies
>08:33:54,105 DEBUG packaging: success
>08:33:54,179 INFO packaging: 1091 packages selected totalling 2.65 Gb
>08:34:35,137 DEBUG packaging: deleting package sacks
>08:34:58,637 DEBUG packaging: getting release version from tree at None (18)
>08:34:58,641 DEBUG packaging: got a release version of 18
>08:34:58,644 DEBUG packaging: setting releasever to previous value of 18
>08:34:58,900 INFO packaging: gathering repo metadata
>08:34:58,910 DEBUG packaging: getting repo metadata for anaconda
>08:35:00,100 DEBUG packaging: getting group info for anaconda
>08:35:00,349 INFO packaging: metadata retrieval complete
>08:35:00,353 DEBUG packaging: installation yum config repos: anaconda
>08:35:00,357 INFO packaging: checking software selection
>08:35:00,357 DEBUG packaging: deleting package sacks
>08:35:00,395 DEBUG packaging: select group core
>08:35:02,489 DEBUG packaging: select package chrony
>08:35:02,500 DEBUG packaging: select package grub2
>08:35:02,504 DEBUG packaging: select package e2fsprogs
>08:35:02,507 DEBUG packaging: select package authconfig
>08:35:02,508 DEBUG packaging: select package system-config-firewall-base
>08:35:02,736 DEBUG packaging: select group core
>08:35:02,739 DEBUG packaging: select group gnome-desktop
>08:35:02,841 DEBUG packaging: select group multimedia
>08:35:02,870 DEBUG packaging: select group input-methods
>08:35:02,892 DEBUG packaging: select group base-x
>08:35:02,919 DEBUG packaging: select group fonts
>08:35:03,001 DEBUG packaging: select group hardware-support
>08:35:03,031 DEBUG packaging: select group dial-up
>08:35:03,049 DEBUG packaging: select group printing
>08:35:03,136 DEBUG packaging: select group firefox
>08:35:03,152 DEBUG packaging: select group standard
>08:35:03,280 DEBUG packaging: select package kernel-PAE
>08:35:03,568 INFO packaging: no kernel-PAE package
>08:35:03,571 DEBUG packaging: select package kernel
>08:35:03,572 INFO packaging: selected kernel
>08:35:03,573 INFO packaging: checking dependencies
>08:35:16,053 DEBUG packaging: success
>08:35:16,138 INFO packaging: 1097 packages selected totalling 2.69 Gb
>08:35:16,141 INFO packaging: preparing transaction
>08:35:16,153 DEBUG packaging: initialize transaction set
>08:35:16,156 DEBUG packaging: populate transaction set
>08:36:21,174 ERR packaging: error populating transaction: failure: Packages/m/mesa-libgbm-9.0-0.2.fc18.x86_64.rpm from anaconda: [Errno 256] No more mirrors to try.
>http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/Packages/m/mesa-libgbm-9.0-0.2.fc18.x86_64.rpm: [Errno 12] Timeout on http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/Packages/m/mesa-libgbm-9.0-0.2.fc18.x86_64.rpm: (28, '')
>
>
>/tmp/program.log:
>06:28:01,869 INFO program: Running... udevadm trigger --action=change --subsystem-match=block
>06:28:01,930 INFO program: Running... modprobe fcoe
>06:28:02,283 INFO program: Running... /usr/libexec/fcoe/fcoe_edd.sh -i
>06:28:02,522 INFO program: No FCoE boot disk information is found in EDD!
>06:28:02,533 INFO program: Running... modprobe scsi_wait_scan
>06:28:02,566 ERR program: FATAL: Module scsi_wait_scan not found.
>06:28:02,572 INFO program: Running... rmmod scsi_wait_scan
>06:28:02,600 ERR program: Error: Module scsi_wait_scan is not currently loaded
>06:28:02,606 INFO program: Running... udevadm settle --timeout=300
>06:28:02,800 INFO program: Running... multipath -d
>06:28:02,958 INFO program: Running... multipath -ll
>06:28:05,281 INFO program: Running... metacity --display :1 --sm-disable
>06:28:07,493 ERR program: GLib-GIO-Message: Using the 'memory' GSettings backend.  Your settings will not be saved or shared with other applications.
>06:28:07,928 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:07,981 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:07,994 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,002 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,018 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,035 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,045 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,052 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,212 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,217 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,228 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,235 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,248 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,256 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,266 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,278 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,284 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,289 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,296 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,305 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,313 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,328 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,335 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:08,344 ERR program: Window manager warning: Log level 16: Unable to locate theme engine in module_path: "pixmap",
>06:28:10,765 INFO program: Running... udevadm control --property=ANACONDA=1
>06:28:11,128 INFO program: Running... udevadm trigger --action=change --subsystem-match=block
>06:28:11,162 INFO program: Running... systemctl start chronyd.service
>06:28:11,827 INFO program: Running... modprobe scsi_wait_scan
>06:28:12,032 ERR program: FATAL: Module scsi_wait_scan not found.
>06:28:12,084 INFO program: Running... rmmod scsi_wait_scan
>06:28:12,238 ERR program: Error: Module scsi_wait_scan is not currently loaded
>06:28:12,242 INFO program: Running... udevadm settle --timeout=300
>06:28:13,996 INFO program: Running... multipath -d
>06:28:14,379 INFO program: Running... multipath -ll
>06:28:15,576 INFO program: Running... dumpe2fs -h /dev/loop1
>06:28:16,079 INFO program: Filesystem volume name:   Anaconda
>06:28:16,084 INFO program: Last mounted on:          /tmp/lorax.imgutils.72Mepw
>06:28:16,087 INFO program: Filesystem UUID:          7665a7af-d474-4551-aed7-4f614ae7402c
>06:28:16,088 INFO program: Filesystem magic number:  0xEF53
>06:28:16,091 INFO program: Filesystem revision #:    1 (dynamic)
>06:28:16,095 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
>06:28:16,096 INFO program: Filesystem flags:         signed_directory_hash 
>06:28:16,097 INFO program: Default mount options:    user_xattr acl
>06:28:16,100 INFO program: Filesystem state:         clean
>06:28:16,102 INFO program: Errors behavior:          Continue
>06:28:16,103 INFO program: Filesystem OS type:       Linux
>06:28:16,124 INFO program: Inode count:              65536
>06:28:16,126 INFO program: Block count:              1048576
>06:28:16,126 INFO program: Reserved block count:     0
>06:28:16,129 INFO program: Free blocks:              313970
>06:28:16,130 INFO program: Free inodes:              38931
>06:28:16,131 INFO program: First block:              1
>06:28:16,134 INFO program: Block size:               1024
>06:28:16,135 INFO program: Fragment size:            1024
>06:28:16,136 INFO program: Reserved GDT blocks:      256
>06:28:16,138 INFO program: Blocks per group:         8192
>06:28:16,139 INFO program: Fragments per group:      8192
>06:28:16,143 INFO program: Inodes per group:         512
>06:28:16,149 INFO program: Inode blocks per group:   128
>06:28:16,161 INFO program: Flex block group size:    16
>06:28:16,169 INFO program: Filesystem created:       Sun Sep 30 12:23:02 2012
>06:28:16,171 INFO program: Last mount time:          Sun Sep 30 12:25:45 2012
>06:28:16,177 INFO program: Last write time:          Sun Sep 30 12:25:58 2012
>06:28:16,183 INFO program: Mount count:              2
>06:28:16,189 INFO program: Maximum mount count:      -1
>06:28:16,202 INFO program: Last checked:             Sun Sep 30 12:23:02 2012
>06:28:16,218 INFO program: Check interval:           0 (<none>)
>06:28:16,218 INFO program: Lifetime writes:          32 MB
>06:28:16,247 INFO program: Reserved blocks uid:      0 (user root)
>06:28:16,247 INFO program: Reserved blocks gid:      0 (group root)
>06:28:16,254 INFO program: First inode:              11
>06:28:16,262 INFO program: Inode size:	          256
>06:28:16,291 INFO program: Required extra isize:     28
>06:28:16,292 INFO program: Desired extra isize:      28
>06:28:16,299 INFO program: Journal inode:            8
>06:28:16,326 INFO program: Default directory hash:   half_md4
>06:28:16,331 INFO program: Directory Hash Seed:      33ef4047-2b20-4680-ad8a-029433f5c059
>06:28:16,339 INFO program: Journal backup:           inode blocks
>06:28:16,363 INFO program: Journal features:         (none)
>06:28:16,369 INFO program: Journal size:             32M
>06:28:16,397 INFO program: Journal length:           32768
>06:28:16,398 INFO program: Journal sequence:         0x00000028
>06:28:16,401 INFO program: Journal start:            0
>06:28:16,407 INFO program: 
>06:28:16,418 ERR program: dumpe2fs 1.42.5 (29-Jul-2012)
>06:28:16,422 INFO program: Running... dumpe2fs -h /dev/loop1
>06:28:16,550 INFO program: Filesystem volume name:   Anaconda
>06:28:16,553 INFO program: Last mounted on:          /tmp/lorax.imgutils.72Mepw
>06:28:16,556 INFO program: Filesystem UUID:          7665a7af-d474-4551-aed7-4f614ae7402c
>06:28:16,556 INFO program: Filesystem magic number:  0xEF53
>06:28:16,557 INFO program: Filesystem revision #:    1 (dynamic)
>06:28:16,559 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
>06:28:16,560 INFO program: Filesystem flags:         signed_directory_hash 
>06:28:16,560 INFO program: Default mount options:    user_xattr acl
>06:28:16,561 INFO program: Filesystem state:         clean
>06:28:16,561 INFO program: Errors behavior:          Continue
>06:28:16,586 INFO program: Filesystem OS type:       Linux
>06:28:16,586 INFO program: Inode count:              65536
>06:28:16,587 INFO program: Block count:              1048576
>06:28:16,587 INFO program: Reserved block count:     0
>06:28:16,587 INFO program: Free blocks:              313970
>06:28:16,587 INFO program: Free inodes:              38931
>06:28:16,590 INFO program: First block:              1
>06:28:16,590 INFO program: Block size:               1024
>06:28:16,591 INFO program: Fragment size:            1024
>06:28:16,593 INFO program: Reserved GDT blocks:      256
>06:28:16,594 INFO program: Blocks per group:         8192
>06:28:16,594 INFO program: Fragments per group:      8192
>06:28:16,595 INFO program: Inodes per group:         512
>06:28:16,595 INFO program: Inode blocks per group:   128
>06:28:16,600 INFO program: Flex block group size:    16
>06:28:16,625 INFO program: Filesystem created:       Sun Sep 30 12:23:02 2012
>06:28:16,625 INFO program: Last mount time:          Sun Sep 30 12:25:45 2012
>06:28:16,626 INFO program: Last write time:          Sun Sep 30 12:25:58 2012
>06:28:16,628 INFO program: Mount count:              2
>06:28:16,638 INFO program: Maximum mount count:      -1
>06:28:16,638 INFO program: Last checked:             Sun Sep 30 12:23:02 2012
>06:28:16,641 INFO program: Check interval:           0 (<none>)
>06:28:16,647 INFO program: Lifetime writes:          32 MB
>06:28:16,668 INFO program: Reserved blocks uid:      0 (user root)
>06:28:16,673 INFO program: Reserved blocks gid:      0 (group root)
>06:28:16,680 INFO program: First inode:              11
>06:28:16,683 INFO program: Inode size:	          256
>06:28:16,688 INFO program: Required extra isize:     28
>06:28:16,693 INFO program: Desired extra isize:      28
>06:28:16,701 INFO program: Journal inode:            8
>06:28:16,702 INFO program: Default directory hash:   half_md4
>06:28:16,724 INFO program: Directory Hash Seed:      33ef4047-2b20-4680-ad8a-029433f5c059
>06:28:16,729 INFO program: Journal backup:           inode blocks
>06:28:16,730 INFO program: Journal features:         (none)
>06:28:16,730 INFO program: Journal size:             32M
>06:28:16,739 INFO program: Journal length:           32768
>06:28:16,740 INFO program: Journal sequence:         0x00000028
>06:28:16,748 INFO program: Journal start:            0
>06:28:16,749 INFO program: 
>06:28:16,758 ERR program: dumpe2fs 1.42.5 (29-Jul-2012)
>06:28:16,759 INFO program: Running... resize2fs -P /dev/loop1
>06:28:16,921 INFO program: Couldn't find valid filesystem superblock.
>06:28:16,925 ERR program: resize2fs 1.42.5 (29-Jul-2012)
>06:28:16,928 ERR program: resize2fs: Device or resource busy while trying to open /dev/loop1
>06:28:17,254 INFO program: Running... modprobe scsi_wait_scan
>06:28:17,419 ERR program: FATAL: Module scsi_wait_scan not found.
>06:28:17,426 INFO program: Running... rmmod scsi_wait_scan
>06:28:17,597 ERR program: Error: Module scsi_wait_scan is not currently loaded
>06:28:17,603 INFO program: Running... udevadm settle --timeout=300
>06:28:18,023 INFO program: Running... dumpe2fs -h /dev/mapper/live-rw
>06:28:18,136 INFO program: Filesystem volume name:   Anaconda
>06:28:18,139 INFO program: Last mounted on:          /sysroot
>06:28:18,142 INFO program: Filesystem UUID:          7665a7af-d474-4551-aed7-4f614ae7402c
>06:28:18,142 INFO program: Filesystem magic number:  0xEF53
>06:28:18,145 INFO program: Filesystem revision #:    1 (dynamic)
>06:28:18,145 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
>06:28:18,145 INFO program: Filesystem flags:         signed_directory_hash 
>06:28:18,146 INFO program: Default mount options:    user_xattr acl
>06:28:18,146 INFO program: Filesystem state:         clean
>06:28:18,146 INFO program: Errors behavior:          Continue
>06:28:18,147 INFO program: Filesystem OS type:       Linux
>06:28:18,149 INFO program: Inode count:              65536
>06:28:18,150 INFO program: Block count:              1048576
>06:28:18,150 INFO program: Reserved block count:     0
>06:28:18,150 INFO program: Free blocks:              313970
>06:28:18,151 INFO program: Free inodes:              38931
>06:28:18,158 INFO program: First block:              1
>06:28:18,158 INFO program: Block size:               1024
>06:28:18,158 INFO program: Fragment size:            1024
>06:28:18,167 INFO program: Reserved GDT blocks:      256
>06:28:18,168 INFO program: Blocks per group:         8192
>06:28:18,171 INFO program: Fragments per group:      8192
>06:28:18,180 INFO program: Inodes per group:         512
>06:28:18,181 INFO program: Inode blocks per group:   128
>06:28:18,189 INFO program: Flex block group size:    16
>06:28:18,193 INFO program: Filesystem created:       Sun Sep 30 12:23:02 2012
>06:28:18,200 INFO program: Last mount time:          Mon Oct  1 06:27:29 2012
>06:28:18,204 INFO program: Last write time:          Mon Oct  1 06:27:29 2012
>06:28:18,211 INFO program: Mount count:              3
>06:28:18,221 INFO program: Maximum mount count:      -1
>06:28:18,222 INFO program: Last checked:             Sun Sep 30 12:23:02 2012
>06:28:18,229 INFO program: Check interval:           0 (<none>)
>06:28:18,234 INFO program: Lifetime writes:          32 MB
>06:28:18,241 INFO program: Reserved blocks uid:      0 (user root)
>06:28:18,247 INFO program: Reserved blocks gid:      0 (group root)
>06:28:18,251 INFO program: First inode:              11
>06:28:18,257 INFO program: Inode size:	          256
>06:28:18,260 INFO program: Required extra isize:     28
>06:28:18,270 INFO program: Desired extra isize:      28
>06:28:18,270 INFO program: Journal inode:            8
>06:28:18,280 INFO program: Default directory hash:   half_md4
>06:28:18,280 INFO program: Directory Hash Seed:      33ef4047-2b20-4680-ad8a-029433f5c059
>06:28:18,288 INFO program: Journal backup:           inode blocks
>06:28:18,296 INFO program: Journal features:         (none)
>06:28:18,301 INFO program: Journal size:             32M
>06:28:18,308 INFO program: Journal length:           32768
>06:28:18,318 INFO program: Journal sequence:         0x00000029
>06:28:18,318 INFO program: Journal start:            1
>06:28:18,321 INFO program: 
>06:28:18,331 ERR program: dumpe2fs 1.42.5 (29-Jul-2012)
>06:28:18,334 INFO program: Running... dumpe2fs -h /dev/mapper/live-rw
>06:28:18,475 INFO program: Filesystem volume name:   Anaconda
>06:28:18,479 INFO program: Last mounted on:          /sysroot
>06:28:18,481 INFO program: Filesystem UUID:          7665a7af-d474-4551-aed7-4f614ae7402c
>06:28:18,482 INFO program: Filesystem magic number:  0xEF53
>06:28:18,482 INFO program: Filesystem revision #:    1 (dynamic)
>06:28:18,483 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
>06:28:18,485 INFO program: Filesystem flags:         signed_directory_hash 
>06:28:18,486 INFO program: Default mount options:    user_xattr acl
>06:28:18,486 INFO program: Filesystem state:         clean
>06:28:18,487 INFO program: Errors behavior:          Continue
>06:28:18,487 INFO program: Filesystem OS type:       Linux
>06:28:18,490 INFO program: Inode count:              65536
>06:28:18,490 INFO program: Block count:              1048576
>06:28:18,490 INFO program: Reserved block count:     0
>06:28:18,491 INFO program: Free blocks:              313970
>06:28:18,492 INFO program: Free inodes:              38931
>06:28:18,499 INFO program: First block:              1
>06:28:18,500 INFO program: Block size:               1024
>06:28:18,500 INFO program: Fragment size:            1024
>06:28:18,504 INFO program: Reserved GDT blocks:      256
>06:28:18,510 INFO program: Blocks per group:         8192
>06:28:18,513 INFO program: Fragments per group:      8192
>06:28:18,522 INFO program: Inodes per group:         512
>06:28:18,523 INFO program: Inode blocks per group:   128
>06:28:18,533 INFO program: Flex block group size:    16
>06:28:18,533 INFO program: Filesystem created:       Sun Sep 30 12:23:02 2012
>06:28:18,536 INFO program: Last mount time:          Mon Oct  1 06:27:29 2012
>06:28:18,544 INFO program: Last write time:          Mon Oct  1 06:27:29 2012
>06:28:18,544 INFO program: Mount count:              3
>06:28:18,550 INFO program: Maximum mount count:      -1
>06:28:18,554 INFO program: Last checked:             Sun Sep 30 12:23:02 2012
>06:28:18,564 INFO program: Check interval:           0 (<none>)
>06:28:18,564 INFO program: Lifetime writes:          32 MB
>06:28:18,569 INFO program: Reserved blocks uid:      0 (user root)
>06:28:18,575 INFO program: Reserved blocks gid:      0 (group root)
>06:28:18,577 INFO program: First inode:              11
>06:28:18,586 INFO program: Inode size:	          256
>06:28:18,587 INFO program: Required extra isize:     28
>06:28:18,595 INFO program: Desired extra isize:      28
>06:28:18,595 INFO program: Journal inode:            8
>06:28:18,604 INFO program: Default directory hash:   half_md4
>06:28:18,604 INFO program: Directory Hash Seed:      33ef4047-2b20-4680-ad8a-029433f5c059
>06:28:18,614 INFO program: Journal backup:           inode blocks
>06:28:18,614 INFO program: Journal features:         (none)
>06:28:18,624 INFO program: Journal size:             32M
>06:28:18,625 INFO program: Journal length:           32768
>06:28:18,629 INFO program: Journal sequence:         0x00000029
>06:28:18,639 INFO program: Journal start:            1
>06:28:18,639 INFO program: 
>06:28:18,648 ERR program: dumpe2fs 1.42.5 (29-Jul-2012)
>06:28:18,649 INFO program: Running... resize2fs -P /dev/mapper/live-rw
>06:28:18,848 INFO program: Estimated minimum size of the filesystem: 732509
>06:28:18,851 ERR program: resize2fs 1.42.5 (29-Jul-2012)
>06:28:19,047 INFO program: Running... modprobe scsi_wait_scan
>06:28:19,380 ERR program: FATAL: Module scsi_wait_scan not found.
>06:28:19,385 INFO program: Running... rmmod scsi_wait_scan
>06:28:19,462 ERR program: Error: Module scsi_wait_scan is not currently loaded
>06:28:19,472 INFO program: Running... udevadm settle --timeout=300
>06:28:19,631 INFO program: Running... udevadm settle --timeout=300
>02:32:42,174 INFO program: Running... modprobe btrfs
>02:32:43,027 INFO program: Running... modprobe xfs
>02:32:44,111 INFO program: Running... modprobe vfat
>02:33:46,713 INFO program: Running... systemctl status chronyd.service
>02:33:47,504 INFO program: chronyd.service - NTP client/server
>02:33:47,511 INFO program: 	  Loaded: loaded (/usr/lib/systemd/system/chronyd.service; disabled)
>02:33:47,516 INFO program: 	  Active: active (running) since Mon, 01 Oct 2012 02:28:11 -0400; 5min ago
>02:33:47,519 INFO program: 	 Process: 774 ExecStartPost=/usr/libexec/chrony-helper add-dhclient-servers (code=exited, status=0/SUCCESS)
>02:33:47,520 INFO program: 	 Process: 771 ExecStart=/usr/sbin/chronyd -u chrony $OPTIONS (code=exited, status=0/SUCCESS)
>02:33:47,521 INFO program: 	 Process: 759 ExecStartPre=/usr/libexec/chrony-helper generate-commandkey (code=exited, status=0/SUCCESS)
>02:33:47,523 INFO program: 	Main PID: 773 (chronyd)
>02:33:47,524 INFO program: 	  CGroup: name=systemd:/system/chronyd.service
>02:33:47,530 INFO program: 		  â 773 /usr/sbin/chronyd -u chrony
>02:33:47,531 INFO program: 
>02:33:47,531 INFO program: Oct 01 02:28:11 localhost chrony-helper[759]: tr: write error: Broken pipe
>02:33:47,535 INFO program: Oct 01 02:28:11 localhost chrony-helper[759]: tr: write error
>02:33:47,535 INFO program: Oct 01 02:28:11 localhost chronyd[773]: chronyd version 1.27-git1ca844 starting
>02:33:47,536 INFO program: Oct 01 02:28:11 localhost chronyd[773]: Linux kernel major=3 minor=6 patch=0
>02:33:47,536 INFO program: Oct 01 02:28:11 localhost chronyd[773]: hz=100 shift_hz=7 freq_scale=1.00000...2
>02:33:47,560 INFO program: Running... systemctl start chronyd.service
>08:34:29,721 INFO program: Running... modprobe scsi_wait_scan
>08:34:30,121 ERR program: FATAL: Module scsi_wait_scan not found.
>08:34:30,129 INFO program: Running... rmmod scsi_wait_scan
>08:34:30,232 ERR program: Error: Module scsi_wait_scan is not currently loaded
>08:34:30,245 INFO program: Running... udevadm settle --timeout=300
>08:34:35,634 INFO program: Running... wipefs -a /dev/vda
>08:34:36,375 INFO program: Running... udevadm settle --timeout=300
>08:34:36,506 INFO program: Running... udevadm settle --timeout=300
>08:34:36,601 INFO program: Running... udevadm settle --timeout=300
>08:34:37,017 INFO program: Running... udevadm settle --timeout=300
>08:34:37,423 INFO program: Running... udevadm settle --timeout=300
>08:34:37,593 INFO program: Running... udevadm settle --timeout=300
>08:34:37,998 INFO program: Running... udevadm settle --timeout=300
>08:34:39,104 INFO program: Running... wipefs -a /dev/vda1
>08:34:39,313 INFO program: Running... udevadm settle --timeout=300
>08:34:39,444 INFO program: Running... udevadm settle --timeout=300
>08:34:39,799 INFO program: Running... udevadm settle --timeout=300
>08:34:40,392 INFO program: Running... wipefs -a /dev/vda2
>08:34:40,659 INFO program: Running... udevadm settle --timeout=300
>08:34:40,794 INFO program: Running... udevadm settle --timeout=300
>08:34:41,181 INFO program: Running... mkswap -f /dev/vda2
>08:34:41,484 INFO program: Setting up swapspace version 1, size = 2031612 KiB
>08:34:41,496 INFO program: no label, UUID=cfaf7814-5248-4961-b233-6faab04f8d59
>08:34:41,522 INFO program: Running... udevadm settle --timeout=300
>08:34:41,690 INFO program: Running... udevadm settle --timeout=300
>08:34:42,036 INFO program: Running... udevadm settle --timeout=300
>08:34:42,384 INFO program: Running... wipefs -a /dev/vda3
>08:34:42,603 INFO program: Running... udevadm settle --timeout=300
>08:34:42,739 INFO program: Running... udevadm settle --timeout=300
>08:34:43,145 INFO program: Running... mke2fs -t ext4 /dev/vda3
>08:34:43,460 ERR program: mke2fs 1.42.5 (29-Jul-2012)
>08:34:43,482 INFO program: Filesystem label=
>08:34:43,487 INFO program: OS type: Linux
>08:34:43,491 INFO program: Block size=4096 (log=2)
>08:34:43,492 INFO program: Fragment size=4096 (log=2)
>08:34:43,501 INFO program: Stride=0 blocks, Stripe width=0 blocks
>08:34:43,502 INFO program: 365760 inodes, 1460992 blocks
>08:34:43,504 INFO program: 73049 blocks (5.00%) reserved for the super user
>08:34:43,505 INFO program: First data block=0
>08:34:43,505 INFO program: Maximum filesystem blocks=1497366528
>08:34:43,506 INFO program: 45 block groups
>08:34:43,506 INFO program: 32768 blocks per group, 32768 fragments per group
>08:34:43,511 INFO program: 8128 inodes per group
>08:34:43,511 INFO program: Superblock backups stored on blocks: 
>08:34:43,516 INFO program: 	32768, 98304, 163840, 229376, 294912, 819200, 884736
>08:34:43,519 INFO program: 
>08:34:43,536 INFO program: Allocating group tables:  0/45 1/45 2/45 3/45 4/45 5/45 6/45 7/45 8/45 9/4510/4511/4512/4513/4514/4515/4516/4517/4518/4519/4520/4521/4522/4523/4524/4525/4526/4527/4528/4529/4530/4531/4532/4533/4534/4535/4536/4537/4538/4539/4540/4541/4542/4543/4544/45     done                            
>08:34:43,553 INFO program: Writing inode tables:  0/45 1/45 2/45 3/45 4/45 5/45 6/45 7/45 8/45 9/4510/4511/4512/4513/4514/4515/4516/4517/4518/4519/4520/4521/4522/4523/4524/4525/4526/4527/4528/4529/4530/4531/4532/4533/4534/4535/4536/4537/4538/4539/4540/4541/4542/4543/4544/45     done                            
>08:34:50,672 INFO program: Creating journal (32768 blocks): done
>08:34:51,381 INFO program: Writing superblocks and filesystem accounting information:  0/45 1/45 2/45 3/45 4/45 5/45 6/45 7/45 8/45 9/4510/4511/4512/4513/4514/4515/4516/4517/4518/4519/4520/4521/4522/4523/4524/4525/4526/4527/4528/4529/4530/4531/4532/4533/4534/4535/4536/4537/4538/4539/4540/4541/4542/4543/4544/45     done
>08:34:51,467 INFO program: 
>08:34:51,536 INFO program: Running... udevadm settle --timeout=300
>08:34:52,135 INFO program: Running... udevadm settle --timeout=300
>08:34:52,667 INFO program: Running... mke2fs -t ext4 /dev/vda1
>08:34:52,862 ERR program: mke2fs 1.42.5 (29-Jul-2012)
>08:34:52,877 INFO program: Filesystem label=
>08:34:52,880 INFO program: OS type: Linux
>08:34:52,883 INFO program: Block size=1024 (log=0)
>08:34:52,884 INFO program: Fragment size=1024 (log=0)
>08:34:52,887 INFO program: Stride=0 blocks, Stripe width=0 blocks
>08:34:52,888 INFO program: 128016 inodes, 512000 blocks
>08:34:52,892 INFO program: 25600 blocks (5.00%) reserved for the super user
>08:34:52,893 INFO program: First data block=1
>08:34:52,893 INFO program: Maximum filesystem blocks=67633152
>08:34:52,894 INFO program: 63 block groups
>08:34:52,898 INFO program: 8192 blocks per group, 8192 fragments per group
>08:34:52,898 INFO program: 2032 inodes per group
>08:34:52,899 INFO program: Superblock backups stored on blocks: 
>08:34:52,899 INFO program: 	8193, 24577, 40961, 57345, 73729, 204801, 221185, 401409
>08:34:52,902 INFO program: 
>08:34:52,912 INFO program: Allocating group tables:  0/63 1/63 2/63 3/63 4/63 5/63 6/63 7/63 8/63 9/6310/6311/6312/6313/6314/6315/6316/6317/6318/6319/6320/6321/6322/6323/6324/6325/6326/6327/6328/6329/6330/6331/6332/6333/6334/6335/6336/6337/6338/6339/6340/6341/6342/6343/6344/6345/6346/6347/6348/6349/6350/6351/6352/6353/6354/6355/6356/6357/6358/6359/6360/6361/6362/63     done                            
>08:34:52,925 INFO program: Writing inode tables:  0/63 1/63 2/63 3/63 4/63 5/63 6/63 7/63 8/63 9/6310/6311/6312/6313/6314/6315/6316/6317/6318/6319/6320/6321/6322/6323/6324/6325/6326/6327/6328/6329/6330/6331/6332/6333/6334/6335/6336/6337/6338/6339/6340/6341/6342/6343/6344/6345/6346/6347/6348/6349/6350/6351/6352/6353/6354/6355/6356/6357/6358/6359/6360/6361/6362/63     done                            
>08:34:53,414 INFO program: Creating journal (8192 blocks): done
>08:34:53,723 INFO program: Writing superblocks and filesystem accounting information:  0/63 1/63 2/63 3/63 4/63 5/63 6/63 7/63 8/63 9/6310/6311/6312/6313/6314/6315/6316/6317/6318/6319/6320/6321/6322/6323/6324/6325/6326/6327/6328/6329/6330/6331/6332/6333/6334/6335/6336/6337/6338/6339/6340/6341/6342/6343/6344/6345/6346/6347/6348/6349/6350/6351/6352/6353/6354/6355/6356/6357/6358/6359/6360/6361/6362/63     done
>08:34:53,731 INFO program: 
>08:34:53,769 INFO program: Running... udevadm settle --timeout=300
>08:34:53,958 INFO program: Running... udevadm settle --timeout=300
>08:34:54,615 INFO program: Running... swapon /dev/vda2
>06:34:55,377 INFO program: Running... /bin/mount -n -t ext4 -o defaults /dev/vda3 /mnt/sysimage
>06:34:55,984 INFO program: Running... /bin/mount -n -t ext4 -o defaults /dev/vda1 /mnt/sysimage/boot
>06:34:56,313 INFO program: Running... /bin/mount -n -t bind -o defaults,bind /dev /mnt/sysimage/dev
>06:34:56,467 INFO program: Running... /bin/mount -n -t devpts -o gid=5,mode=620 /dev/devpts /mnt/sysimage/dev/pts
>06:34:56,581 INFO program: Running... /bin/mount -n -t tmpfs -o defaults /dev/tmpfs /mnt/sysimage/dev/shm
>06:34:56,783 INFO program: Running... /bin/mount -n -t proc -o defaults /dev/proc /mnt/sysimage/proc
>06:34:57,776 INFO program: Running... /bin/mount -n -t sysfs -o defaults /dev/sysfs /mnt/sysimage/sys
>06:34:57,957 INFO program: Running... /bin/mount -n -t selinuxfs -o defaults /dev/selinuxfs /mnt/sysimage/sys/fs/selinux
>
>
>/tmp/storage.log:
>06:28:00,681 DEBUG storage: registered device format class LVMPhysicalVolume as lvmpv
>06:28:00,687 DEBUG storage: registered device format class PPCPRePBoot as prepboot
>06:28:00,726 DEBUG storage: registered device format class Ext2FS as ext2
>06:28:00,729 DEBUG storage: registered device format class Ext3FS as ext3
>06:28:00,731 DEBUG storage: registered device format class Ext4FS as ext4
>06:28:00,732 DEBUG storage: registered device format class FATFS as vfat
>06:28:00,735 DEBUG storage: registered device format class EFIFS as efi
>06:28:00,735 DEBUG storage: registered device format class BTRFS as btrfs
>06:28:00,736 DEBUG storage: registered device format class GFS2 as gfs2
>06:28:00,736 DEBUG storage: registered device format class JFS as jfs
>06:28:00,739 DEBUG storage: registered device format class ReiserFS as reiserfs
>06:28:00,739 DEBUG storage: registered device format class XFS as xfs
>06:28:00,740 DEBUG storage: registered device format class HFS as hfs
>06:28:00,740 DEBUG storage: registered device format class AppleBootstrapFS as appleboot
>06:28:00,743 DEBUG storage: registered device format class HFSPlus as hfs+
>06:28:00,743 DEBUG storage: registered device format class NTFS as ntfs
>06:28:00,744 DEBUG storage: registered device format class NFS as nfs
>06:28:00,744 DEBUG storage: registered device format class NFSv4 as nfs4
>06:28:00,745 DEBUG storage: registered device format class Iso9660FS as iso9660
>06:28:00,747 DEBUG storage: registered device format class NoDevFS as nodev
>06:28:00,748 DEBUG storage: registered device format class DevPtsFS as devpts
>06:28:00,750 DEBUG storage: registered device format class ProcFS as proc
>06:28:00,752 DEBUG storage: registered device format class SysFS as sysfs
>06:28:00,755 DEBUG storage: registered device format class TmpFS as tmpfs
>06:28:00,757 DEBUG storage: registered device format class BindFS as bind
>06:28:00,760 DEBUG storage: registered device format class SELinuxFS as selinuxfs
>06:28:00,763 DEBUG storage: registered device format class USBFS as usbfs
>06:28:00,768 DEBUG storage: registered device format class DMRaidMember as dmraidmember
>06:28:00,783 DEBUG storage: registered device format class DiskLabel as disklabel
>06:28:00,877 DEBUG storage: registered device format class LUKS as luks
>06:28:00,888 DEBUG storage: registered device format class SwapSpace as swap
>06:28:00,892 DEBUG storage: registered device format class BIOSBoot as biosboot
>06:28:00,897 DEBUG storage: registered device format class MDRaidMember as mdmember
>06:28:00,901 DEBUG storage: registered device format class MultipathMember as multipath_member
>06:28:02,723 DEBUG storage:      MultipathTopology._build_topology:
>06:28:02,728 DEBUG storage: /etc/multipath.conf contents:
>06:28:02,731 DEBUG storage: # multipath.conf written by anaconda
>06:28:02,731 DEBUG storage: 
>06:28:02,734 DEBUG storage: defaults {
>06:28:02,734 DEBUG storage: 	user_friendly_names yes
>06:28:02,735 DEBUG storage: }
>06:28:02,735 DEBUG storage: blacklist {
>06:28:02,736 DEBUG storage: 	devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
>06:28:02,736 DEBUG storage: 	devnode "^hd[a-z]"
>06:28:02,739 DEBUG storage: 	devnode "^dcssblk[0-9]*"
>06:28:02,739 DEBUG storage: 	device {
>06:28:02,740 DEBUG storage: 		vendor "DGC"
>06:28:02,740 DEBUG storage: 		product "LUNZ"
>06:28:02,741 DEBUG storage: 	}
>06:28:02,741 DEBUG storage: 	device {
>06:28:02,744 DEBUG storage: 		vendor "IBM"
>06:28:02,744 DEBUG storage: 		product "S/390.*"
>06:28:02,746 DEBUG storage: 	}
>06:28:02,749 DEBUG storage: 	# don't count normal SATA devices as multipaths
>06:28:02,751 DEBUG storage: 	device {
>06:28:02,754 DEBUG storage: 		vendor  "ATA"
>06:28:02,756 DEBUG storage: 	}
>06:28:02,759 DEBUG storage: 	# don't count 3ware devices as multipaths
>06:28:02,762 DEBUG storage: 	device {
>06:28:02,764 DEBUG storage: 		vendor  "3ware"
>06:28:02,767 DEBUG storage: 	}
>06:28:02,769 DEBUG storage: 	device {
>06:28:02,772 DEBUG storage: 		vendor  "AMCC"
>06:28:02,774 DEBUG storage: 	}
>06:28:02,777 DEBUG storage: 	# nor highpoint devices
>06:28:02,781 DEBUG storage: 	device {
>06:28:02,784 DEBUG storage: 		vendor  "HPT"
>06:28:02,787 DEBUG storage: 	}
>06:28:02,790 DEBUG storage: }
>06:28:02,792 DEBUG storage: multipaths {
>06:28:02,795 DEBUG storage: }
>06:28:02,797 DEBUG storage: (end of /etc/multipath.conf)
>06:28:03,022 INFO storage: MultipathTopology: found singlepath device: vda
>06:28:03,027 INFO storage: MultipathTopology: found singlepath device: loop0
>06:28:03,031 INFO storage: MultipathTopology: found singlepath device: loop1
>06:28:03,032 INFO storage: MultipathTopology: found singlepath device: loop2
>06:28:03,035 INFO storage: MultipathTopology: found singlepath device: loop3
>06:28:03,037 INFO storage: MultipathTopology: found singlepath device: loop4
>06:28:03,038 INFO storage: MultipathTopology: found singlepath device: loop5
>06:28:03,042 INFO storage: MultipathTopology: found singlepath device: loop6
>06:28:03,043 INFO storage: MultipathTopology: found singlepath device: loop7
>06:28:03,045 INFO storage: MultipathTopology: found singlepath device: dm-0
>06:28:11,785 INFO storage: not going to create backup copy of non-existent /etc/mdadm.conf
>06:28:11,791 INFO storage: DeviceTree.populate: ignoredDisks is [] ; exclusiveDisks is []
>06:28:13,231 DEBUG storage:           MultipathTopology._build_topology:
>06:28:13,281 DEBUG storage: /etc/multipath.conf contents:
>06:28:13,285 DEBUG storage: # multipath.conf written by anaconda
>06:28:13,288 DEBUG storage: 
>06:28:13,300 DEBUG storage: defaults {
>06:28:13,368 DEBUG storage: 	user_friendly_names yes
>06:28:13,368 DEBUG storage: }
>06:28:13,382 DEBUG storage: blacklist {
>06:28:13,382 DEBUG storage: 	devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
>06:28:13,382 DEBUG storage: 	devnode "^hd[a-z]"
>06:28:13,382 DEBUG storage: 	devnode "^dcssblk[0-9]*"
>06:28:13,382 DEBUG storage: 	device {
>06:28:13,399 DEBUG storage: 		vendor "DGC"
>06:28:13,415 DEBUG storage: 		product "LUNZ"
>06:28:13,423 DEBUG storage: 	}
>06:28:13,446 DEBUG storage: 	device {
>06:28:13,464 DEBUG storage: 		vendor "IBM"
>06:28:13,476 DEBUG storage: 		product "S/390.*"
>06:28:13,550 DEBUG storage: 	}
>06:28:13,550 DEBUG storage: 	# don't count normal SATA devices as multipaths
>06:28:13,649 DEBUG storage: 	device {
>06:28:13,685 DEBUG storage: 		vendor  "ATA"
>06:28:13,702 DEBUG storage: 	}
>06:28:13,726 DEBUG storage: 	# don't count 3ware devices as multipaths
>06:28:13,739 DEBUG storage: 	device {
>06:28:13,803 DEBUG storage: 		vendor  "3ware"
>06:28:13,804 DEBUG storage: 	}
>06:28:13,962 DEBUG storage: 	device {
>06:28:13,980 DEBUG storage: 		vendor  "AMCC"
>06:28:13,983 DEBUG storage: 	}
>06:28:13,983 DEBUG storage: 	# nor highpoint devices
>06:28:13,985 DEBUG storage: 	device {
>06:28:13,985 DEBUG storage: 		vendor  "HPT"
>06:28:13,989 DEBUG storage: 	}
>06:28:13,989 DEBUG storage: }
>06:28:13,990 DEBUG storage: multipaths {
>06:28:13,994 DEBUG storage: }
>06:28:13,995 DEBUG storage: (end of /etc/multipath.conf)
>06:28:14,516 INFO storage: MultipathTopology: found singlepath device: vda
>06:28:14,522 INFO storage: MultipathTopology: found singlepath device: loop0
>06:28:14,525 INFO storage: MultipathTopology: found singlepath device: loop1
>06:28:14,526 INFO storage: MultipathTopology: found singlepath device: loop2
>06:28:14,530 INFO storage: MultipathTopology: found singlepath device: loop3
>06:28:14,531 INFO storage: MultipathTopology: found singlepath device: loop4
>06:28:14,532 INFO storage: MultipathTopology: found singlepath device: loop5
>06:28:14,545 INFO storage: MultipathTopology: found singlepath device: loop6
>06:28:14,552 INFO storage: MultipathTopology: found singlepath device: loop7
>06:28:14,557 INFO storage: MultipathTopology: found singlepath device: dm-0
>06:28:14,562 INFO storage: devices to scan: ['vda', 'loop0', 'loop1', 'loop2', 'loop3', 'loop4', 'loop5', 'loop6', 'loop7', 'dm-0']
>06:28:14,582 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'vda',
> 'DEVPATH': '/devices/pci0000:00/0000:00:05.0/virtio1/block/vda',
> 'DEVTYPE': 'disk',
> 'MAJOR': '252',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '820267',
> 'name': 'vda',
> 'symlinks': [],
> 'sysfs_path': '/devices/pci0000:00/0000:00:05.0/virtio1/block/vda'} ; name: vda ;
>06:28:14,618 INFO storage: scanning vda (/devices/pci0000:00/0000:00:05.0/virtio1/block/vda)...
>06:28:14,621 DEBUG storage:           DeviceTree.getDeviceByName: name: vda ;
>06:28:14,631 DEBUG storage:           DeviceTree.getDeviceByName returned None
>06:28:14,642 DEBUG storage:           DeviceTree.addUdevDiskDevice: name: vda ;
>06:28:14,664 INFO storage: vda is a disk
>06:28:14,672 DEBUG storage: getFormat('None') returning DeviceFormat instance
>06:28:14,686 DEBUG storage:               DiskDevice._setFormat: vda ; current: None ; type: None ;
>06:28:14,689 INFO storage: added disk vda (id 0) to device tree
>06:28:14,692 DEBUG storage: looking up parted Device: /dev/vda
>06:28:14,714 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: vda ;
>06:28:14,730 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: vda ; label_type: None ;
>06:28:14,736 DEBUG storage: getFormat('None') returning DeviceFormat instance
>06:28:14,741 DEBUG storage:             DiskDevice.setup: vda ; status: True ; controllable: True ; orig: False ;
>06:28:14,769 DEBUG storage:              DiskLabel.__init__: device: /dev/vda ; labelType: msdos ; exists: True ;
>06:28:14,788 INFO storage: no usable disklabel on vda
>06:28:14,802 DEBUG storage: no type or existing type for vda, bailing
>06:28:14,828 INFO storage: got device: DiskDevice instance (0x7ffec8ada410) --
>  name = vda  status = True  kids = 0 id = 0
>  parents = []
>  uuid = None  size = 8192.0
>  format = existing None
>  major = 252  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:05.0/virtio1/block/vda  partedDevice = parted.Device instance --
>  model: Virtio Block Device  path: /dev/vda  type: 15
>  sectorSize: 512  physicalSectorSize:  512
>  length: 16777216  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (16644, 16, 63)  biosGeometry: (1044, 255, 63)
>  PedDevice: <_ped.Device object at 0x7ffec8c56680>
>  target size = 0  path = /dev/vda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7ffec8bf7790>
>06:28:14,836 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': '52272249',
> 'name': 'loop0',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop0'} ; name: loop0 ;
>06:28:14,852 INFO storage: scanning loop0 (/devices/virtual/block/loop0)...
>06:28:14,860 DEBUG storage:           DeviceTree.getDeviceByName: name: loop0 ;
>06:28:14,874 DEBUG storage:           DeviceTree.getDeviceByName returned None
>06:28:14,895 INFO storage: loop0 is a loop device
>06:28:14,909 DEBUG storage:           DeviceTree.addUdevLoopDevice: name: loop0 ;
>06:28:14,924 DEBUG storage:            DeviceTree.getDeviceByName: name: /tmp/curl_fetch_url1/squashfs.img (deleted) ;
>06:28:14,953 DEBUG storage:            DeviceTree.getDeviceByName returned None
>06:28:14,960 DEBUG storage: getFormat('None') returning DeviceFormat instance
>06:28:14,966 DEBUG storage:               FileDevice._setFormat: /tmp/curl_fetch_url1/squashfs.img (deleted) ; current: None ; type: None ;
>06:28:14,971 INFO storage: added file /tmp/curl_fetch_url1/squashfs.img (deleted) (id 1) to device tree
>06:28:14,977 DEBUG storage:               FileDevice.addChild: kids: 0 ; name: /tmp/curl_fetch_url1/squashfs.img (deleted) ;
>06:28:14,984 DEBUG storage: getFormat('None') returning DeviceFormat instance
>06:28:14,989 DEBUG storage:               LoopDevice._setFormat: loop0 ; current: None ; type: None ;
>06:28:14,994 INFO storage: added loop loop0 (id 2) to device tree
>06:28:14,999 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: loop0 ;
>06:28:15,007 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: loop0 ; label_type: None ;
>06:28:15,021 DEBUG storage: getFormat('squashfs') returning DeviceFormat instance
>06:28:15,026 DEBUG storage:             LoopDevice.setup: loop0 ; status: False ; controllable: False ; orig: False ;
>06:28:15,064 DEBUG storage:              DiskLabel.__init__: device: /dev/loop0 ; labelType: None ; exists: True ;
>06:28:15,133 WARN storage: disklabel detected but not usable on loop0
>06:28:15,137 INFO storage: type detected on 'loop0' is 'squashfs'
>06:28:15,141 DEBUG storage: getFormat('squashfs') returning DeviceFormat instance
>06:28:15,148 DEBUG storage:             LoopDevice._setFormat: loop0 ; current: None ; type: None ;
>06:28:15,158 INFO storage: got device: LoopDevice instance (0x7ffec8c0b750) --
>  name = loop0  status = False  kids = 0 id = 2
>  parents = ['existing 0MB file /tmp/curl_fetch_url1/squashfs.img (deleted) (1)']
>  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
>06:28:15,164 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVLINKS': '/dev/disk/by-label/Anaconda /dev/disk/by-uuid/7665a7af-d474-4551-aed7-4f614ae7402c',
> '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': '7665a7af-d474-4551-aed7-4f614ae7402c',
> 'ID_FS_UUID_ENC': '7665a7af-d474-4551-aed7-4f614ae7402c',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '7',
> 'MINOR': '1',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '409806',
> 'name': 'loop1',
> 'symlinks': ['/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/7665a7af-d474-4551-aed7-4f614ae7402c'],
> 'sysfs_path': '/devices/virtual/block/loop1'} ; name: loop1 ;
>06:28:15,189 INFO storage: scanning loop1 (/devices/virtual/block/loop1)...
>06:28:15,196 DEBUG storage:           DeviceTree.getDeviceByName: name: loop1 ;
>06:28:15,253 DEBUG storage:           DeviceTree.getDeviceByName returned None
>06:28:15,266 INFO storage: loop1 is a loop device
>06:28:15,283 DEBUG storage:           DeviceTree.addUdevLoopDevice: name: loop1 ;
>06:28:15,294 DEBUG storage:            DeviceTree.getDeviceByName: name: /LiveOS/rootfs.img ;
>06:28:15,302 DEBUG storage:            DeviceTree.getDeviceByName returned None
>06:28:15,308 DEBUG storage: getFormat('None') returning DeviceFormat instance
>06:28:15,317 DEBUG storage:               FileDevice._setFormat: /LiveOS/rootfs.img ; current: None ; type: None ;
>06:28:15,324 INFO storage: added file /LiveOS/rootfs.img (id 3) to device tree
>06:28:15,341 DEBUG storage:               FileDevice.addChild: kids: 0 ; name: /LiveOS/rootfs.img ;
>06:28:15,349 DEBUG storage: getFormat('None') returning DeviceFormat instance
>06:28:15,355 DEBUG storage:               LoopDevice._setFormat: loop1 ; current: None ; type: None ;
>06:28:15,381 INFO storage: added loop loop1 (id 4) to device tree
>06:28:15,387 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: loop1 ;
>06:28:15,431 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: loop1 ; label_type: None ;
>06:28:15,487 DEBUG storage:               Ext4FS.supported: supported: True ;
>06:28:15,532 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>06:28:15,554 DEBUG storage: device loop1 does not contain a disklabel
>06:28:15,572 INFO storage: type detected on 'loop1' is 'ext4'
>06:28:16,933 DEBUG storage:              Ext4FS.supported: supported: True ;
>06:28:16,943 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>06:28:16,947 DEBUG storage:             LoopDevice._setFormat: loop1 ; current: None ; type: ext4 ;
>06:28:16,967 INFO storage: got device: LoopDevice instance (0x7ffed0445450) --
>  name = loop1  status = False  kids = 0 id = 4
>  parents = ['existing 0MB file /LiveOS/rootfs.img (3)']
>  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
>06:28:16,977 DEBUG storage:             Ext4FS.supported: supported: True ;
>06:28:16,984 INFO storage: got format: Ext4FS instance (0x7ffeddb322d0) --
>  type = ext4  name = ext4  status = False
>  device = /dev/loop1  uuid = 7665a7af-d474-4551-aed7-4f614ae7402c  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 1024.0  targetSize = 1024.0
>
>06:28:16,990 DEBUG storage:          DeviceTree.addUdevDevice: info: {'ANACBIN': '/sbin',
> 'DEVNAME': 'loop2',
> 'DEVPATH': '/devices/virtual/block/loop2',
> 'DEVTYPE': 'disk',
> 'MAJOR': '7',
> 'MINOR': '2',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'USEC_INITIALIZED': '413590',
> 'name': 'loop2',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop2'} ; name: loop2 ;
>06:28:16,997 INFO storage: scanning loop2 (/devices/virtual/block/loop2)...
>06:28:17,002 DEBUG storage:           DeviceTree.getDeviceByName: name: loop2 ;
>06:28:17,006 DEBUG storage:           DeviceTree.getDeviceByName returned None
>06:28:17,015 INFO storage: loop2 is a loop device
>06:28:17,020 DEBUG storage:           DeviceTree.addUdevLoopDevice: name: loop2 ;
>06:28:17,025 DEBUG storage:            DeviceTree.getDeviceByName: name: /overlay (deleted) ;
>06:28:17,039 DEBUG storage:            DeviceTree.getDeviceByName returned None
>06:28:17,047 DEBUG storage: getFormat('None') returning DeviceFormat instance
>06:28:17,052 DEBUG storage:               FileDevice._setFormat: /overlay (deleted) ; current: None ; type: None ;
>06:28:17,055 INFO storage: added file /overlay (deleted) (id 5) to device tree
>06:28:17,061 DEBUG storage:               FileDevice.addChild: kids: 0 ; name: /overlay (deleted) ;
>06:28:17,069 DEBUG storage: getFormat('None') returning DeviceFormat instance
>06:28:17,074 DEBUG storage:               LoopDevice._setFormat: loop2 ; current: None ; type: None ;
>06:28:17,080 INFO storage: added loop loop2 (id 6) to device tree
>06:28:17,084 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: loop2 ;
>06:28:17,088 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: loop2 ; label_type: None ;
>06:28:17,095 DEBUG storage: getFormat('None') returning DeviceFormat instance
>06:28:17,099 DEBUG storage:             LoopDevice.setup: loop2 ; status: False ; controllable: False ; orig: False ;
>06:28:17,104 DEBUG storage:              DiskLabel.__init__: device: /dev/loop2 ; labelType: None ; exists: True ;
>06:28:17,133 WARN storage: disklabel detected but not usable on loop2
>06:28:17,140 DEBUG storage: no type or existing type for loop2, bailing
>06:28:17,143 INFO storage: got device: LoopDevice instance (0x7ffeddb3b950) --
>  name = loop2  status = False  kids = 0 id = 6
>  parents = ['existing 0MB file /overlay (deleted) (5)']
>  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
>06:28:17,148 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': '423235',
> 'name': 'loop3',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop3'} ; name: loop3 ;
>06:28:17,155 INFO storage: ignoring loop3 (/devices/virtual/block/loop3)
>06:28:17,158 DEBUG storage: lvm filter: adding loop3 to the reject list
>06:28:17,166 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': '489043',
> 'name': 'loop4',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop4'} ; name: loop4 ;
>06:28:17,171 INFO storage: ignoring loop4 (/devices/virtual/block/loop4)
>06:28:17,174 DEBUG storage: lvm filter: adding loop4 to the reject list
>06:28:17,176 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': '509537',
> 'name': 'loop5',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop5'} ; name: loop5 ;
>06:28:17,189 INFO storage: ignoring loop5 (/devices/virtual/block/loop5)
>06:28:17,193 DEBUG storage: lvm filter: adding loop5 to the reject list
>06:28:17,205 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': '537235',
> 'name': 'loop6',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop6'} ; name: loop6 ;
>06:28:17,210 INFO storage: ignoring loop6 (/devices/virtual/block/loop6)
>06:28:17,225 DEBUG storage: lvm filter: adding loop6 to the reject list
>06:28:17,236 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': '601537',
> 'name': 'loop7',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop7'} ; name: loop7 ;
>06:28:17,246 INFO storage: ignoring loop7 (/devices/virtual/block/loop7)
>06:28:17,249 DEBUG storage: lvm filter: adding loop7 to the reject list
>06:28:17,250 DEBUG storage: Skipping a device mapper drive (dm-0) for now
>06:28:17,857 INFO storage: devices to scan: ['dm-0']
>06:28:17,864 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/7665a7af-d474-4551-aed7-4f614ae7402c /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': '7665a7af-d474-4551-aed7-4f614ae7402c',
> 'ID_FS_UUID_ENC': '7665a7af-d474-4551-aed7-4f614ae7402c',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '253',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '287956',
> 'name': 'dm-0',
> 'symlinks': ['/dev/disk/by-id/dm-name-live-rw',
>              '/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/7665a7af-d474-4551-aed7-4f614ae7402c',
>              '/dev/mapper/live-rw'],
> 'sysfs_path': '/devices/virtual/block/dm-0'} ; name: live-rw ;
>06:28:17,886 INFO storage: scanning live-rw (/devices/virtual/block/dm-0)...
>06:28:17,891 DEBUG storage:           DeviceTree.getDeviceByName: name: live-rw ;
>06:28:17,895 DEBUG storage:           DeviceTree.getDeviceByName returned None
>06:28:17,906 INFO storage: live-rw is a device-mapper device
>06:28:17,911 DEBUG storage:           DeviceTree.addUdevDMDevice: name: live-rw ;
>06:28:17,920 DEBUG storage:            DeviceTree.getDeviceByName: name: loop1 ;
>06:28:17,929 DEBUG storage:            DeviceTree.getDeviceByName returned existing 0MB loop loop1 (4) with existing ext4 filesystem
>06:28:17,935 DEBUG storage:            DeviceTree.getDeviceByName: name: loop2 ;
>06:28:17,944 DEBUG storage:            DeviceTree.getDeviceByName returned existing 0MB loop loop2 (6)
>06:28:17,954 DEBUG storage:            DeviceTree.getDeviceByName: name: live-rw ;
>06:28:17,964 DEBUG storage:            DeviceTree.getDeviceByName returned None
>06:28:17,969 DEBUG storage:               LoopDevice.addChild: kids: 0 ; name: loop2 ;
>06:28:17,981 DEBUG storage: getFormat('None') returning DeviceFormat instance
>06:28:17,985 DEBUG storage:               DMDevice._setFormat: live-rw ; current: None ; type: None ;
>06:28:17,992 INFO storage: added dm live-rw (id 7) to device tree
>06:28:17,996 DEBUG storage:           DeviceTree.handleUdevDeviceFormat: name: live-rw ;
>06:28:18,003 DEBUG storage:            DeviceTree.handleUdevDiskLabelFormat: device: live-rw ; label_type: None ;
>06:28:18,008 DEBUG storage:               Ext4FS.supported: supported: True ;
>06:28:18,016 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>06:28:18,019 DEBUG storage: device live-rw does not contain a disklabel
>06:28:18,020 INFO storage: type detected on 'live-rw' is 'ext4'
>06:28:18,856 DEBUG storage:              Ext4FS.supported: supported: True ;
>06:28:18,872 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>06:28:18,879 DEBUG storage:             DMDevice._setFormat: live-rw ; current: None ; type: ext4 ;
>06:28:18,898 DEBUG storage: looking up parted Device: /dev/mapper/live-rw
>06:28:18,999 INFO storage: got device: DMDevice instance (0x7ffeddb37f90) --
>  name = live-rw  status = True  kids = 0 id = 7
>  parents = ['existing 0MB loop loop2 (6)']
>  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 0x7ffec8bc4e60>
>  target size = 0  path = /dev/mapper/live-rw
>  format args = []  originalFormat = None  target = None  dmUuid = None
>06:28:19,016 DEBUG storage:             Ext4FS.supported: supported: True ;
>06:28:19,030 INFO storage: got format: Ext4FS instance (0x7ffeddb3bad0) --
>  type = ext4  name = ext4  status = False
>  device = /dev/mapper/live-rw  uuid = 7665a7af-d474-4551-aed7-4f614ae7402c  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 1024.0  targetSize = 1024.0
>
>06:28:19,605 DEBUG storage:           DiskDevice.teardown: vda ; status: True ; controllable: True ;
>06:28:19,614 DEBUG storage:             DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>06:28:19,624 DEBUG storage:             DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>06:28:19,733 DEBUG storage:           LoopDevice.teardown: loop0 ; status: False ; controllable: False ;
>06:28:19,742 DEBUG storage:           LoopDevice.teardown: loop1 ; status: False ; controllable: False ;
>06:28:19,748 DEBUG storage:           DMDevice.teardown: live-rw ; status: True ; controllable: False ;
>06:28:19,756 INFO storage: not going to restore from backup of non-existent /etc/mdadm.conf
>06:28:19,759 INFO storage: edd: collected mbr signatures: {}
>06:28:19,790 DEBUG storage: edd: data extracted from 0x80:
>	type: SCSI, ata_device: None
>	channel: 0, mbr_signature: None
>	pci_dev: 00:05.0, scsi_id: 0
>	scsi_lun: 0, sectors: 16777216
>06:28:19,794 DEBUG storage: edd: matched 0x80 to vda using pci_dev
>06:28:20,157 DEBUG storage:             Ext4FS.supported: supported: True ;
>06:28:20,164 DEBUG storage:            Ext4FS.supported: supported: True ;
>02:32:41,908 DEBUG storage:             Iso9660FS.supported: supported: True ;
>02:32:41,926 DEBUG storage:            Iso9660FS.supported: supported: True ;
>02:32:41,934 DEBUG storage:             NFSv4.supported: supported: False ;
>02:32:41,947 DEBUG storage:            NFSv4.supported: supported: False ;
>02:32:41,960 DEBUG storage:              SELinuxFS.supported: supported: False ;
>02:32:41,974 DEBUG storage:            SELinuxFS.supported: supported: False ;
>02:32:41,981 DEBUG storage:             Ext4FS.supported: supported: True ;
>02:32:41,996 DEBUG storage:            Ext4FS.supported: supported: True ;
>02:32:42,006 DEBUG storage:             Ext3FS.supported: supported: True ;
>02:32:42,014 DEBUG storage:            Ext3FS.supported: supported: True ;
>02:32:42,020 DEBUG storage:             Ext2FS.supported: supported: True ;
>02:32:42,027 DEBUG storage:            Ext2FS.supported: supported: True ;
>02:32:42,049 DEBUG storage:              SysFS.supported: supported: False ;
>02:32:42,058 DEBUG storage:            SysFS.supported: supported: False ;
>02:32:42,068 DEBUG storage:            MultipathMember.__init__:
>02:32:42,083 DEBUG storage:            SwapSpace.__init__:
>02:32:42,093 DEBUG storage:              ProcFS.supported: supported: False ;
>02:32:42,099 DEBUG storage:            ProcFS.supported: supported: False ;
>02:32:42,112 DEBUG storage:              NoDevFS.supported: supported: False ;
>02:32:42,117 DEBUG storage:            NoDevFS.supported: supported: False ;
>02:32:42,136 DEBUG storage:              DevPtsFS.supported: supported: False ;
>02:32:42,149 DEBUG storage:            DevPtsFS.supported: supported: False ;
>02:32:42,165 DEBUG storage:              BTRFS.supported: supported: True ;
>02:32:42,946 DEBUG storage:            BTRFS.supported: supported: True ;
>02:32:42,959 DEBUG storage:              USBFS.supported: supported: False ;
>02:32:42,976 DEBUG storage:            USBFS.supported: supported: False ;
>02:32:42,985 DEBUG storage:            DiskLabel.__init__:
>02:32:42,990 INFO storage: DiskLabel.partedDevice returning None
>02:32:43,002 DEBUG storage:             HFSPlus.supported: supported: False ;
>02:32:43,010 DEBUG storage:            HFSPlus.supported: supported: False ;
>02:32:43,017 DEBUG storage:             XFS.supported: supported: True ;
>02:32:43,982 DEBUG storage:            XFS.supported: supported: True ;
>02:32:43,990 DEBUG storage:              TmpFS.supported: supported: False ;
>02:32:43,995 DEBUG storage:            TmpFS.supported: supported: False ;
>02:32:44,006 DEBUG storage:            LUKS.__init__:
>02:32:44,024 DEBUG storage:             NTFS.supported: supported: False ;
>02:32:44,033 DEBUG storage:            NTFS.supported: supported: False ;
>02:32:44,040 DEBUG storage:             BindFS.supported: supported: False ;
>02:32:44,044 DEBUG storage:            BindFS.supported: supported: False ;
>02:32:44,049 DEBUG storage:             HFS.supported: supported: False ;
>02:32:44,054 DEBUG storage:            HFS.supported: supported: False ;
>02:32:44,060 DEBUG storage:            LVMPhysicalVolume.__init__:
>02:32:44,066 DEBUG storage:             NFS.supported: supported: False ;
>02:32:44,071 DEBUG storage:            NFS.supported: supported: False ;
>02:32:44,076 DEBUG storage:             FATFS.supported: supported: True ;
>02:32:44,333 DEBUG storage:            FATFS.supported: supported: True ;
>02:32:44,354 DEBUG storage:            DMRaidMember.__init__:
>02:32:44,366 DEBUG storage:            MDRaidMember.__init__:
>08:34:29,402 DEBUG storage: clearpart: initializing vda
>08:34:29,521 DEBUG storage:            DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>08:34:29,531 DEBUG storage: getFormat('None') returning DeviceFormat instance
>08:34:29,537 DEBUG storage:             DiskDevice._setFormat: vda ; current: None ; type: None ;
>08:34:29,545 INFO storage: registered action: [0] Destroy Format None on disk vda (id 0)
>08:34:29,659 DEBUG storage:            DiskLabel.__init__: device: /dev/vda ; labelType: msdos ;
>08:34:29,664 DEBUG storage:              DiskLabel.freshPartedDisk: device: /dev/vda ; labelType: msdos ;
>08:34:29,686 DEBUG storage: Did not set pmbr_boot on parted.Disk instance --
>  type: msdos  primaryPartitionCount: 0
>  lastPartitionNumber: -1  maxPrimaryPartitionCount: 4
>  partitions: []
>  device: <parted.device.Device object at 0x7ffebdbb6a50>
>  PedDisk: <_ped.Disk object at 0x7ffebacff200>
>08:34:29,694 DEBUG storage: getFormat('disklabel') returning DiskLabel instance
>08:34:29,701 DEBUG storage:            DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>08:34:29,712 DEBUG storage:             DiskDevice._setFormat: vda ; current: None ; type: disklabel ;
>08:34:29,715 INFO storage: registered action: [1] Create Format msdos disklabel on disk vda (id 0)
>08:34:29,720 DEBUG storage: new disk order: []
>08:34:30,830 DEBUG storage:         DeviceTree.getDeviceByName: name: vda ;
>08:34:30,837 DEBUG storage:         DeviceTree.getDeviceByName returned existing 8192MB disk vda (0) with non-existent msdos disklabel
>08:34:30,847 DEBUG storage: doAutoPart: True
>08:34:30,850 DEBUG storage: encryptedAutoPart: False
>08:34:30,850 DEBUG storage: autoPartType: 0
>08:34:30,851 DEBUG storage: clearPartType: 1
>08:34:30,851 DEBUG storage: clearPartDisks: ['vda']
>08:34:30,852 DEBUG storage: autoPartitionRequests:
>PartSpec instance (0x7ffebb657090) -- 
>  mountpoint = /  lv = True  singlePV = False  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024  maxSize = 51200  grow = True
>PartSpec instance (0x7ffebc4cac50) -- 
>  mountpoint = /home  lv = True  singlePV = False  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500  maxSize = None  grow = True
>PartSpec instance (0x7ffebdbb6bd0) -- 
>  mountpoint = /boot  lv = False  singlePV = False  btrfs = False
>  weight = 2000  fstype = ext4  encrypted = False
>  size = 500  maxSize = None  grow = False
>PartSpec instance (0x7ffebdbb6ad0) -- 
>  mountpoint = None  lv = False  singlePV = False  btrfs = False
>  weight = 5000  fstype = biosboot  encrypted = False
>  size = 1  maxSize = None  grow = False
>PartSpec instance (0x7ffebdbb6dd0) -- 
>  mountpoint = None  lv = True  singlePV = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 1984  maxSize = None  grow = False
>
>08:34:30,856 DEBUG storage: storage.disks: ['vda']
>08:34:30,856 DEBUG storage: storage.partitioned: ['vda']
>08:34:30,857 DEBUG storage: all names: ['/LiveOS/rootfs.img', '/overlay (deleted)', '/tmp/curl_fetch_url1/squashfs.img (deleted)', 'live-rw', 'loop0', 'loop1', 'loop2', 'vda']
>08:34:30,878 DEBUG storage:            DeviceTree.getDeviceByPath: path: /dev/vda ;
>08:34:30,883 DEBUG storage:            DeviceTree.getDeviceByPath returned existing 8192MB disk vda (0) with non-existent msdos disklabel
>08:34:30,889 DEBUG storage: resolved '/dev/vda' to 'vda' (disk)
>08:34:30,890 DEBUG storage: boot disk: vda
>08:34:30,911 DEBUG storage: candidate disks: [DiskDevice instance (0x7ffec8ada410) --
>  name = vda  status = True  kids = 0 id = 0
>  parents = []
>  uuid = None  size = 8192.0
>  format = non-existent msdos disklabel
>  major = 252  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:05.0/virtio1/block/vda  partedDevice = parted.Device instance --
>  model: Virtio Block Device  path: /dev/vda  type: 15
>  sectorSize: 512  physicalSectorSize:  512
>  length: 16777216  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (16644, 16, 63)  biosGeometry: (1044, 255, 63)
>  PedDevice: <_ped.Device object at 0x7ffec8c56680>
>  target size = 0  path = /dev/vda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7ffec8bf7790>]
>08:34:30,915 DEBUG storage: devs: []
>08:34:30,919 DEBUG storage: _is_valid_disklabel(vda) returning True
>08:34:30,919 DEBUG storage: _is_valid_size(vda) returning True
>08:34:30,920 DEBUG storage: _is_valid_location(vda) returning True
>08:34:30,920 DEBUG storage: _is_valid_format(vda) returning True
>08:34:30,923 DEBUG storage: is_valid_stage1_device(vda) returning True
>08:34:30,926 DEBUG storage:              Ext4FS.supported: supported: True ;
>08:34:30,933 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>08:34:30,936 DEBUG storage:               DiskDevice.addChild: kids: 0 ; name: vda ;
>08:34:30,941 DEBUG storage:               PartitionDevice._setFormat: req0 ;
>08:34:30,947 DEBUG storage:                PartitionDevice._setFormat: req0 ; current: None ; type: ext4 ;
>08:34:30,956 DEBUG storage:             DiskDevice.removeChild: kids: 1 ; name: vda ;
>08:34:30,959 INFO storage: added partition req0 (id 8) to device tree
>08:34:30,960 INFO storage: registered action: [2] Create Device partition req0 (id 8)
>08:34:30,960 DEBUG storage: getFormat('None') returning DeviceFormat instance
>08:34:30,964 INFO storage: registered action: [3] Create Format ext4 filesystem mounted at / on partition req0 (id 8)
>08:34:30,967 DEBUG storage:              Ext4FS.supported: supported: True ;
>08:34:30,971 DEBUG storage: getFormat('ext4') returning Ext4FS instance
>08:34:30,977 DEBUG storage:               DiskDevice.addChild: kids: 0 ; name: vda ;
>08:34:30,982 DEBUG storage:               PartitionDevice._setFormat: req1 ;
>08:34:30,990 DEBUG storage:                PartitionDevice._setFormat: req1 ; current: None ; type: ext4 ;
>08:34:30,994 DEBUG storage:             DiskDevice.removeChild: kids: 1 ; name: vda ;
>08:34:30,998 INFO storage: added partition req1 (id 9) to device tree
>08:34:30,999 INFO storage: registered action: [4] Create Device partition req1 (id 9)
>08:34:30,999 DEBUG storage: getFormat('None') returning DeviceFormat instance
>08:34:31,003 INFO storage: registered action: [5] Create Format ext4 filesystem mounted at /boot on partition req1 (id 9)
>08:34:31,006 INFO storage: skipping unneeded stage1 biosboot request
>08:34:31,009 DEBUG storage: PartSpec instance (0x7ffebdbb6ad0) -- 
>  mountpoint = None  lv = False  singlePV = False  btrfs = False
>  weight = 5000  fstype = biosboot  encrypted = False
>  size = 1  maxSize = None  grow = False
>
>08:34:31,013 DEBUG storage: existing 8192MB disk vda (0) with non-existent msdos disklabel
>08:34:31,019 DEBUG storage:             SwapSpace.__init__: mountpoint: None ;
>08:34:31,022 DEBUG storage: getFormat('swap') returning SwapSpace instance
>08:34:31,027 DEBUG storage:               DiskDevice.addChild: kids: 0 ; name: vda ;
>08:34:31,031 DEBUG storage:               PartitionDevice._setFormat: req2 ;
>08:34:31,036 DEBUG storage:                PartitionDevice._setFormat: req2 ; current: None ; type: swap ;
>08:34:31,041 DEBUG storage:             DiskDevice.removeChild: kids: 1 ; name: vda ;
>08:34:31,044 INFO storage: added partition req2 (id 10) to device tree
>08:34:31,048 INFO storage: registered action: [6] Create Device partition req2 (id 10)
>08:34:31,051 DEBUG storage: getFormat('None') returning DeviceFormat instance
>08:34:31,054 INFO storage: registered action: [7] Create Format swap on partition req2 (id 10)
>08:34:31,060 DEBUG storage:           DiskDevice.setup: vda ; status: True ; controllable: True ; orig: False ;
>08:34:31,065 DEBUG storage: removing all non-preexisting partitions ['req0(id 8)', 'req1(id 9)', 'req2(id 10)'] from disk(s) ['vda']
>08:34:31,069 DEBUG storage: allocatePartitions: disks=['vda'] ; partitions=['req0(id 8)', 'req1(id 9)', 'req2(id 10)']
>08:34:31,072 DEBUG storage: removing all non-preexisting partitions ['req1(id 9)', 'req2(id 10)', 'req0(id 8)'] from disk(s) ['vda']
>08:34:31,078 DEBUG storage:              DeviceTree.getDeviceByPath: path: /dev/vda ;
>08:34:31,083 DEBUG storage:              DeviceTree.getDeviceByPath returned existing 8192MB disk vda (0) with non-existent msdos disklabel
>08:34:31,086 DEBUG storage: resolved '/dev/vda' to 'vda' (disk)
>08:34:31,090 DEBUG storage:              DeviceTree.getDeviceByPath: path: /dev/vda ;
>08:34:31,096 DEBUG storage:              DeviceTree.getDeviceByPath returned existing 8192MB disk vda (0) with non-existent msdos disklabel
>08:34:31,100 DEBUG storage: resolved '/dev/vda' to 'vda' (disk)
>08:34:31,102 DEBUG storage: allocating partition: req1 ; id: 9 ; disks: ['vda'] ;
>boot: True ; primary: False ; size: 500MB ; grow: False ; max_size: 0
>08:34:31,106 DEBUG storage: checking freespace on vda
>08:34:31,110 DEBUG storage: getBestFreeSpaceRegion: disk=/dev/vda part_type=0 req_size=500MB boot=True best=None grow=False
>08:34:31,114 DEBUG storage: current free range is 63-16777215 (8191MB)
>08:34:31,116 DEBUG storage: updating use_disk to vda, type: 0
>08:34:31,119 DEBUG storage: new free: 63-16777215 / 8191MB
>08:34:31,122 DEBUG storage: new free allows for 0 sectors of growth
>08:34:31,125 DEBUG storage: found free space for bootable request
>08:34:31,129 DEBUG storage: adjusted start sector from 63 to 2048
>08:34:31,146 DEBUG storage: created partition vda1 of 500MB and added it to /dev/vda
>08:34:31,151 DEBUG storage:             PartitionDevice._setPartedPartition: req1 ;
>08:34:31,154 DEBUG storage: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a67310>  PedPartition: <_ped.Partition object at 0x7ffebdbcef50>
>08:34:31,159 DEBUG storage:             PartitionDevice._setDisk: vda1 ; new: vda ; old: None ;
>08:34:31,164 DEBUG storage:              DiskDevice.addChild: kids: 0 ; name: vda ;
>08:34:31,169 DEBUG storage:             PartitionDevice._setPartedPartition: vda1 ;
>08:34:31,173 DEBUG storage: device vda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a67290>  PedPartition: <_ped.Partition object at 0x7ffebdbceef0>
>08:34:31,178 DEBUG storage:              DeviceTree.getDeviceByPath: path: /dev/vda ;
>08:34:31,184 DEBUG storage:              DeviceTree.getDeviceByPath returned existing 8192MB disk vda (0) with non-existent msdos disklabel
>08:34:31,188 DEBUG storage: resolved '/dev/vda' to 'vda' (disk)
>08:34:31,192 DEBUG storage:              DeviceTree.getDeviceByPath: path: /dev/vda ;
>08:34:31,198 DEBUG storage:              DeviceTree.getDeviceByPath returned existing 8192MB disk vda (0) with non-existent msdos disklabel
>08:34:31,201 DEBUG storage: resolved '/dev/vda' to 'vda' (disk)
>08:34:31,204 DEBUG storage: allocating partition: req2 ; id: 10 ; disks: ['vda'] ;
>boot: False ; primary: False ; size: 1984MB ; grow: False ; max_size: 0
>08:34:31,208 DEBUG storage: checking freespace on vda
>08:34:31,212 DEBUG storage: getBestFreeSpaceRegion: disk=/dev/vda part_type=0 req_size=1984MB boot=False best=None grow=False
>08:34:31,216 DEBUG storage: current free range is 63-2047 (0MB)
>08:34:31,220 DEBUG storage: current free range is 1026048-16777215 (7691MB)
>08:34:31,224 DEBUG storage: updating use_disk to vda, type: 0
>08:34:31,228 DEBUG storage: new free: 1026048-16777215 / 7691MB
>08:34:31,232 DEBUG storage: new free allows for 0 sectors of growth
>08:34:31,238 DEBUG storage: created partition vda2 of 1984MB and added it to /dev/vda
>08:34:31,244 DEBUG storage:             PartitionDevice._setPartedPartition: req2 ;
>08:34:31,251 DEBUG storage: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a676d0>  PedPartition: <_ped.Partition object at 0x7ffebdbcefb0>
>08:34:31,266 DEBUG storage:             PartitionDevice._setDisk: vda2 ; new: vda ; old: None ;
>08:34:31,276 DEBUG storage:              DiskDevice.addChild: kids: 1 ; name: vda ;
>08:34:31,289 DEBUG storage:             PartitionDevice._setPartedPartition: vda2 ;
>08:34:31,295 DEBUG storage: device vda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a67310>  PedPartition: <_ped.Partition object at 0x7ffebdbcee90>
>08:34:31,301 DEBUG storage:              DeviceTree.getDeviceByPath: path: /dev/vda ;
>08:34:31,321 DEBUG storage:              DeviceTree.getDeviceByPath returned existing 8192MB disk vda (0) with non-existent msdos disklabel
>08:34:31,322 DEBUG storage: resolved '/dev/vda' to 'vda' (disk)
>08:34:31,332 DEBUG storage:              DeviceTree.getDeviceByPath: path: /dev/vda ;
>08:34:31,346 DEBUG storage:              DeviceTree.getDeviceByPath returned existing 8192MB disk vda (0) with non-existent msdos disklabel
>08:34:31,347 DEBUG storage: resolved '/dev/vda' to 'vda' (disk)
>08:34:31,349 DEBUG storage: allocating partition: req0 ; id: 8 ; disks: ['vda'] ;
>boot: False ; primary: False ; size: 1024MB ; grow: True ; max_size: 51200
>08:34:31,353 DEBUG storage: checking freespace on vda
>08:34:31,360 DEBUG storage: getBestFreeSpaceRegion: disk=/dev/vda part_type=0 req_size=1024MB boot=False best=None grow=True
>08:34:31,366 DEBUG storage: current free range is 63-2047 (0MB)
>08:34:31,372 DEBUG storage: current free range is 5089280-16777215 (5707MB)
>08:34:31,378 DEBUG storage: evaluating growth potential for new layout
>08:34:31,383 DEBUG storage: calculating growth for disk /dev/vda
>08:34:31,391 DEBUG storage:             PartitionDevice._setPartedPartition: req0 ;
>08:34:31,396 DEBUG storage: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a67950>  PedPartition: <_ped.Partition object at 0x7ffec2a6c0b0>
>08:34:31,402 DEBUG storage:             PartitionDevice._setDisk: vda3 ; new: vda ; old: None ;
>08:34:31,408 DEBUG storage:              DiskDevice.addChild: kids: 2 ; name: vda ;
>08:34:31,412 DEBUG storage: adding request 9 to chunk 16777153 (63-16777215) on /dev/vda
>08:34:31,416 DEBUG storage: adding request 10 to chunk 16777153 (63-16777215) on /dev/vda
>08:34:31,420 DEBUG storage: adding request 8 to chunk 16777153 (63-16777215) on /dev/vda
>08:34:31,423 DEBUG storage: Chunk.growRequests: 16777153 on /dev/vda start = 63  end = 16777215
>sectorSize = 512
>
>08:34:31,427 DEBUG storage: req: PartitionRequest instance --
>id = 9  name = vda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>08:34:31,431 DEBUG storage: req: PartitionRequest instance --
>id = 10  name = vda2  growable = False
>base = 4063232  growth = 0  max_grow = 0
>done = True
>08:34:31,435 DEBUG storage: req: PartitionRequest instance --
>id = 8  name = vda3  growable = True
>base = 2097152  growth = 0  max_grow = 102760448
>done = False
>08:34:31,438 DEBUG storage: 1 requests and 9592769 (4683MB) left in chunk
>08:34:31,441 DEBUG storage: adding 9592769 (4683MB) to 8 (vda3)
>08:34:31,444 DEBUG storage: new grow amount for request 8 (vda3) is 9592769 units, or 4683MB
>08:34:31,447 DEBUG storage: request 9 (vda1) growth: 0 (0MB) size: 500MB
>08:34:31,449 DEBUG storage: request 10 (vda2) growth: 0 (0MB) size: 1984MB
>08:34:31,452 DEBUG storage: request 8 (vda3) growth: 9592769 (4683MB) size: 5707MB
>08:34:31,455 DEBUG storage: disk /dev/vda growth: 9592769 (4683MB)
>08:34:31,460 DEBUG storage:             PartitionDevice._setPartedPartition: vda3 ;
>08:34:31,463 DEBUG storage: device vda3 new partedPartition None
>08:34:31,468 DEBUG storage:             PartitionDevice._setDisk: req0 ; new: None ; old: vda ;
>08:34:31,473 DEBUG storage:              DiskDevice.removeChild: kids: 3 ; name: vda ;
>08:34:31,477 DEBUG storage: total growth: 9592769 sectors
>08:34:31,479 DEBUG storage: updating use_disk to vda, type: 0
>08:34:31,482 DEBUG storage: new free: 5089280-16777215 / 5707MB
>08:34:31,485 DEBUG storage: new free allows for 9592769 sectors of growth
>08:34:31,489 DEBUG storage: created partition vda3 of 1024MB and added it to /dev/vda
>08:34:31,493 DEBUG storage:             PartitionDevice._setPartedPartition: req0 ;
>08:34:31,497 DEBUG storage: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a67bd0>  PedPartition: <_ped.Partition object at 0x7ffec2a6c050>
>08:34:31,501 DEBUG storage:             PartitionDevice._setDisk: vda3 ; new: vda ; old: None ;
>08:34:31,507 DEBUG storage:              DiskDevice.addChild: kids: 2 ; name: vda ;
>08:34:31,513 DEBUG storage:             PartitionDevice._setPartedPartition: vda3 ;
>08:34:31,516 DEBUG storage: device vda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a67c50>  PedPartition: <_ped.Partition object at 0x7ffec2a6c110>
>08:34:31,520 DEBUG storage: growPartitions: disks=['vda'], partitions=['vda3(id 8)', 'vda1(id 9)', 'vda2(id 10)']
>08:34:31,523 DEBUG storage: growable partitions are ['vda3']
>08:34:31,527 DEBUG storage: adding request 8 to chunk 16777153 (63-16777215) on /dev/vda
>08:34:31,530 DEBUG storage: adding request 9 to chunk 16777153 (63-16777215) on /dev/vda
>08:34:31,533 DEBUG storage: adding request 10 to chunk 16777153 (63-16777215) on /dev/vda
>08:34:31,536 DEBUG storage: disk vda has 1 chunks
>08:34:31,538 DEBUG storage: Chunk.growRequests: 16777153 on /dev/vda start = 63  end = 16777215
>sectorSize = 512
>
>08:34:31,541 DEBUG storage: req: PartitionRequest instance --
>id = 9  name = vda1  growable = False
>base = 1024000  growth = 0  max_grow = 0
>done = True
>08:34:31,544 DEBUG storage: req: PartitionRequest instance --
>id = 10  name = vda2  growable = False
>base = 4063232  growth = 0  max_grow = 0
>done = True
>08:34:31,547 DEBUG storage: req: PartitionRequest instance --
>id = 8  name = vda3  growable = True
>base = 2097152  growth = 0  max_grow = 102760448
>done = False
>08:34:31,550 DEBUG storage: 1 requests and 9592769 (4683MB) left in chunk
>08:34:31,553 DEBUG storage: adding 9592769 (4683MB) to 8 (vda3)
>08:34:31,556 DEBUG storage: new grow amount for request 8 (vda3) is 9592769 units, or 4683MB
>08:34:31,559 DEBUG storage: growing partitions on vda
>08:34:31,561 DEBUG storage: partition vda1 (9): 0
>08:34:31,565 DEBUG storage: new geometry for vda1: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x7ffebdbb6810>  PedGeometry: <_ped.Geometry object at 0x7ffec2a67cd0>
>08:34:31,568 DEBUG storage: partition vda2 (10): 0
>08:34:31,572 DEBUG storage: new geometry for vda2: parted.Geometry instance --
>  start: 1026048  end: 5089279  length: 4063232
>  device: <parted.device.Device object at 0x7ffebdbb6810>  PedGeometry: <_ped.Geometry object at 0x7ffec2a67e90>
>08:34:31,576 DEBUG storage: partition vda3 (8): 0
>08:34:31,580 DEBUG storage: new geometry for vda3: parted.Geometry instance --
>  start: 5089280  end: 16777215  length: 11687936
>  device: <parted.device.Device object at 0x7ffebdbb6810>  PedGeometry: <_ped.Geometry object at 0x7ffec2a6d050>
>08:34:31,583 DEBUG storage: removing all non-preexisting partitions ['vda1(id 9)', 'vda2(id 10)', 'vda3(id 8)'] from disk(s) ['vda']
>08:34:31,588 DEBUG storage:              PartitionDevice._setPartedPartition: vda1 ;
>08:34:31,591 DEBUG storage: device vda1 new partedPartition None
>08:34:31,596 DEBUG storage:              PartitionDevice._setDisk: req1 ; new: None ; old: vda ;
>08:34:31,601 DEBUG storage:               DiskDevice.removeChild: kids: 3 ; name: vda ;
>08:34:31,606 DEBUG storage:              PartitionDevice._setPartedPartition: vda2 ;
>08:34:31,609 DEBUG storage: device vda2 new partedPartition None
>08:34:31,614 DEBUG storage:              PartitionDevice._setDisk: req2 ; new: None ; old: vda ;
>08:34:31,619 DEBUG storage:               DiskDevice.removeChild: kids: 2 ; name: vda ;
>08:34:31,624 DEBUG storage:              PartitionDevice._setPartedPartition: vda3 ;
>08:34:31,627 DEBUG storage: device vda3 new partedPartition None
>08:34:31,633 DEBUG storage:              PartitionDevice._setDisk: req0 ; new: None ; old: vda ;
>08:34:31,639 DEBUG storage:               DiskDevice.removeChild: kids: 1 ; name: vda ;
>08:34:31,642 DEBUG storage: back from removeNewPartitions
>08:34:31,693 DEBUG storage: extended: None
>08:34:31,696 DEBUG storage: setting req1 new geometry: parted.Geometry instance --
>  start: 2048  end: 1026047  length: 1024000
>  device: <parted.device.Device object at 0x7ffebdbb6810>  PedGeometry: <_ped.Geometry object at 0x7ffec2a67cd0>
>08:34:31,702 DEBUG storage:             PartitionDevice._setPartedPartition: req1 ;
>08:34:31,705 DEBUG storage: device req1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a6d310>  PedPartition: <_ped.Partition object at 0x7ffebdbcef50>
>08:34:31,710 DEBUG storage:             PartitionDevice._setDisk: vda1 ; new: vda ; old: None ;
>08:34:31,715 DEBUG storage:              DiskDevice.addChild: kids: 0 ; name: vda ;
>08:34:31,720 DEBUG storage:             PartitionDevice._setPartedPartition: vda1 ;
>08:34:31,723 DEBUG storage: device vda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a6d510>  PedPartition: <_ped.Partition object at 0x7ffec2a6c290>
>08:34:31,726 DEBUG storage: setting req2 new geometry: parted.Geometry instance --
>  start: 1026048  end: 5089279  length: 4063232
>  device: <parted.device.Device object at 0x7ffebdbb6810>  PedGeometry: <_ped.Geometry object at 0x7ffec2a67e90>
>08:34:31,731 DEBUG storage:             PartitionDevice._setPartedPartition: req2 ;
>08:34:31,735 DEBUG storage: device req2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffebdbcded0>  PedPartition: <_ped.Partition object at 0x7ffec2a6c1d0>
>08:34:31,741 DEBUG storage:             PartitionDevice._setDisk: vda2 ; new: vda ; old: None ;
>08:34:31,748 DEBUG storage:              DiskDevice.addChild: kids: 1 ; name: vda ;
>08:34:31,753 DEBUG storage:             PartitionDevice._setPartedPartition: vda2 ;
>08:34:31,756 DEBUG storage: device vda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a67bd0>  PedPartition: <_ped.Partition object at 0x7ffebdbceef0>
>08:34:31,760 DEBUG storage: setting req0 new geometry: parted.Geometry instance --
>  start: 5089280  end: 16777215  length: 11687936
>  device: <parted.device.Device object at 0x7ffebdbb6810>  PedGeometry: <_ped.Geometry object at 0x7ffec2a6d050>
>08:34:31,765 DEBUG storage:             PartitionDevice._setPartedPartition: req0 ;
>08:34:31,768 DEBUG storage: device req0 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffebdbcdd50>  PedPartition: <_ped.Partition object at 0x7ffec2a6c230>
>08:34:31,773 DEBUG storage:             PartitionDevice._setDisk: vda3 ; new: vda ; old: None ;
>08:34:31,777 DEBUG storage:              DiskDevice.addChild: kids: 2 ; name: vda ;
>08:34:31,783 DEBUG storage:             PartitionDevice._setPartedPartition: vda3 ;
>08:34:31,786 DEBUG storage: device vda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6a10>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a67310>  PedPartition: <_ped.Partition object at 0x7ffec2a6c110>
>08:34:31,789 DEBUG storage: fixing size of non-existent 500MB partition vda1 (9) with non-existent ext4 filesystem mounted at /boot at 500.00
>08:34:31,793 DEBUG storage: fixing size of non-existent 1984MB partition vda2 (10) with non-existent swap at 1984.00
>08:34:31,797 DEBUG storage: fixing size of non-existent 5707MB partition vda3 (8) with non-existent ext4 filesystem mounted at / at 5707.00
>08:34:31,804 DEBUG storage:            DeviceTree.getDeviceByPath: path: /dev/vda ;
>08:34:31,809 DEBUG storage:            DeviceTree.getDeviceByPath returned existing 8192MB disk vda (0) with non-existent msdos disklabel
>08:34:31,812 DEBUG storage: resolved '/dev/vda' to 'vda' (disk)
>08:34:31,817 DEBUG storage: _is_valid_disklabel(vda) returning True
>08:34:31,820 DEBUG storage: _is_valid_size(vda) returning True
>08:34:31,822 DEBUG storage: _is_valid_location(vda) returning True
>08:34:31,825 DEBUG storage: _is_valid_format(vda) returning True
>08:34:31,828 DEBUG storage: is_valid_stage1_device(vda) returning True
>08:34:31,838 DEBUG storage: _is_valid_disklabel(vda) returning True
>08:34:31,838 DEBUG storage: _is_valid_size(vda) returning True
>08:34:31,841 DEBUG storage: _is_valid_location(vda) returning True
>08:34:31,844 DEBUG storage: _is_valid_format(vda) returning True
>08:34:31,848 DEBUG storage: is_valid_stage1_device(vda) returning True
>08:34:31,851 DEBUG storage: _is_valid_disklabel(vda1) returning True
>08:34:31,855 DEBUG storage: _is_valid_size(vda1) returning True
>08:34:31,858 DEBUG storage: _is_valid_location(vda1) returning True
>08:34:31,861 DEBUG storage: _is_valid_partition(vda1) returning True
>08:34:31,864 DEBUG storage: _is_valid_format(vda1) returning True
>08:34:31,867 DEBUG storage: is_valid_stage2_device(vda1) returning True
>08:34:31,872 DEBUG storage:          DeviceTree.getDeviceByPath: path: /dev/vda ;
>08:34:31,876 DEBUG storage:          DeviceTree.getDeviceByPath returned existing 8192MB disk vda (0) with non-existent msdos disklabel
>08:34:31,879 DEBUG storage: resolved '/dev/vda' to 'vda' (disk)
>08:34:31,884 DEBUG storage: _is_valid_disklabel(vda) returning True
>08:34:31,886 DEBUG storage: _is_valid_size(vda) returning True
>08:34:31,889 DEBUG storage: _is_valid_location(vda) returning True
>08:34:31,892 DEBUG storage: _is_valid_format(vda) returning True
>08:34:31,895 DEBUG storage: is_valid_stage1_device(vda) returning True
>08:34:31,908 DEBUG storage: _is_valid_disklabel(vda) returning True
>08:34:31,916 DEBUG storage: _is_valid_size(vda) returning True
>08:34:31,916 DEBUG storage: _is_valid_location(vda) returning True
>08:34:31,919 DEBUG storage: _is_valid_format(vda) returning True
>08:34:31,922 DEBUG storage: is_valid_stage1_device(vda) returning True
>08:34:31,925 DEBUG storage: _is_valid_disklabel(vda1) returning True
>08:34:31,928 DEBUG storage: _is_valid_size(vda1) returning True
>08:34:31,930 DEBUG storage: _is_valid_location(vda1) returning True
>08:34:31,933 DEBUG storage: _is_valid_partition(vda1) returning True
>08:34:31,936 DEBUG storage: _is_valid_format(vda1) returning True
>08:34:31,939 DEBUG storage: is_valid_stage2_device(vda1) returning True
>08:34:35,191 DEBUG storage:         LoopDevice.teardown: loop0 ; status: False ; controllable: False ;
>08:34:35,199 DEBUG storage:         LoopDevice.teardown: loop1 ; status: False ; controllable: False ;
>08:34:35,525 DEBUG storage:         DMDevice.teardown: live-rw ; status: True ; controllable: False ;
>08:34:35,529 DEBUG storage:         PartitionDevice.teardown: vda3 ; status: False ; controllable: True ;
>08:34:35,537 DEBUG storage:         PartitionDevice.teardown: vda1 ; status: False ; controllable: True ;
>08:34:35,540 DEBUG storage:         PartitionDevice.teardown: vda2 ; status: False ; controllable: True ;
>08:34:35,546 INFO storage: resetting parted disks...
>08:34:35,552 DEBUG storage:          DiskLabel.resetPartedDisk: device: /dev/vda ;
>08:34:35,557 DEBUG storage:          PartitionDevice.preCommitFixup: vda3 ;
>08:34:35,565 DEBUG storage:          PartitionDevice.preCommitFixup: vda1 ;
>08:34:35,568 DEBUG storage:          PartitionDevice.preCommitFixup: vda2 ;
>08:34:35,571 DEBUG storage: action: [0] Destroy Format None on disk vda (id 0)
>08:34:35,572 DEBUG storage: action: [1] Create Format msdos disklabel on disk vda (id 0)
>08:34:35,573 DEBUG storage: action: [2] Create Device partition vda3 (id 8)
>08:34:35,575 DEBUG storage: action: [3] Create Format ext4 filesystem mounted at / on partition vda3 (id 8)
>08:34:35,576 DEBUG storage: action: [4] Create Device partition vda1 (id 9)
>08:34:35,577 DEBUG storage: action: [5] Create Format ext4 filesystem mounted at /boot on partition vda1 (id 9)
>08:34:35,589 DEBUG storage: action: [6] Create Device partition vda2 (id 10)
>08:34:35,590 DEBUG storage: action: [7] Create Format swap on partition vda2 (id 10)
>08:34:35,593 INFO storage: pruning action queue...
>08:34:35,597 INFO storage: sorting actions...
>08:34:35,600 DEBUG storage: action: [0] Destroy Format None on disk vda (id 0)
>08:34:35,605 DEBUG storage: action: [1] Create Format msdos disklabel on disk vda (id 0)
>08:34:35,607 DEBUG storage: action: [4] Create Device partition vda1 (id 9)
>08:34:35,608 DEBUG storage: action: [6] Create Device partition vda2 (id 10)
>08:34:35,609 DEBUG storage: action: [7] Create Format swap on partition vda2 (id 10)
>08:34:35,610 DEBUG storage: action: [2] Create Device partition vda3 (id 8)
>08:34:35,611 DEBUG storage: action: [3] Create Format ext4 filesystem mounted at / on partition vda3 (id 8)
>08:34:35,614 DEBUG storage: action: [5] Create Format ext4 filesystem mounted at /boot on partition vda1 (id 9)
>08:34:35,615 INFO storage: executing action: [0] Destroy Format None on disk vda (id 0)
>08:34:35,621 DEBUG storage:           DiskDevice.setup: vda ; status: True ; controllable: True ; orig: True ;
>08:34:35,630 DEBUG storage:           DeviceFormat.destroy: device: /dev/vda ; status: False ; type: None ;
>08:34:36,497 DEBUG storage:           DiskDevice.teardown: vda ; status: True ; controllable: True ;
>08:34:36,710 INFO storage: executing action: [1] Create Format msdos disklabel on disk vda (id 0)
>08:34:36,721 DEBUG storage:           DiskDevice.setup: vda ; status: True ; controllable: True ; orig: False ;
>08:34:36,729 DEBUG storage:           DiskLabel.create: device: /dev/vda ; status: False ; type: disklabel ;
>08:34:36,733 DEBUG storage:            DiskLabel.create: device: /dev/vda ; status: False ; type: disklabel ;
>08:34:36,736 DEBUG storage:            DiskLabel.commit: device: /dev/vda ; numparts: 0 ;
>08:34:37,587 DEBUG storage:           DiskDevice.updateSysfsPath: vda ; status: True ;
>08:34:37,590 DEBUG storage: vda sysfsPath set to /devices/pci0000:00/0000:00:05.0/virtio1/block/vda
>08:34:37,693 INFO storage: executing action: [4] Create Device partition vda1 (id 9)
>08:34:37,704 DEBUG storage:           PartitionDevice.create: vda1 ; status: False ;
>08:34:37,712 DEBUG storage:             PartitionDevice.setupParents: kids: 0 ; name: vda1 ; orig: False ;
>08:34:37,715 DEBUG storage:              DiskDevice.setup: vda ; status: True ; controllable: True ; orig: False ;
>08:34:37,720 DEBUG storage:              DiskLabel.setup: device: /dev/vda ; status: False ; type: disklabel ;
>08:34:37,732 DEBUG storage:               DiskLabel.setup: device: /dev/vda ; status: False ; type: disklabel ;
>08:34:37,735 DEBUG storage:            PartitionDevice._create: vda1 ; status: False ;
>08:34:37,740 DEBUG storage:             DiskLabel.commit: device: /dev/vda ; numparts: 1 ;
>08:34:39,080 DEBUG storage: post-commit partition path is /dev/vda1
>08:34:39,093 DEBUG storage:              PartitionDevice._setPartedPartition: vda1 ;
>08:34:39,097 DEBUG storage: device vda1 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6c90>  fileSystem: None
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a6dd90>  PedPartition: <_ped.Partition object at 0x7ffec2a6ca70>
>08:34:39,102 DEBUG storage:             DeviceFormat.destroy: device: /dev/vda1 ; status: False ; type: None ;
>08:34:39,260 DEBUG storage:              PartitionDevice.setup: vda1 ; status: True ; controllable: True ; orig: False ;
>08:34:39,298 DEBUG storage:              PartitionDevice.updateSysfsPath: vda1 ; status: True ;
>08:34:39,306 DEBUG storage:               PartitionDevice.updateSysfsPath: vda1 ; status: True ;
>08:34:39,310 DEBUG storage: vda1 sysfsPath set to /devices/pci0000:00/0000:00:05.0/virtio1/block/vda/vda1
>08:34:39,551 INFO storage: executing action: [6] Create Device partition vda2 (id 10)
>08:34:39,569 DEBUG storage:           PartitionDevice.create: vda2 ; status: False ;
>08:34:39,576 DEBUG storage:             PartitionDevice.setupParents: kids: 0 ; name: vda2 ; orig: False ;
>08:34:39,579 DEBUG storage:              DiskDevice.setup: vda ; status: True ; controllable: True ; orig: False ;
>08:34:39,596 DEBUG storage:              DiskLabel.setup: device: /dev/vda ; status: False ; type: disklabel ;
>08:34:39,602 DEBUG storage:               DiskLabel.setup: device: /dev/vda ; status: False ; type: disklabel ;
>08:34:39,607 DEBUG storage:            PartitionDevice._create: vda2 ; status: False ;
>08:34:39,623 DEBUG storage:             DiskLabel.commit: device: /dev/vda ; numparts: 2 ;
>08:34:40,345 DEBUG storage: post-commit partition path is /dev/vda2
>08:34:40,352 DEBUG storage:              PartitionDevice._setPartedPartition: vda2 ;
>08:34:40,361 DEBUG storage: device vda2 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6c90>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a6df90>  PedPartition: <_ped.Partition object at 0x7ffec2a6ca10>
>08:34:40,385 DEBUG storage:             DeviceFormat.destroy: device: /dev/vda2 ; status: False ; type: None ;
>08:34:40,623 DEBUG storage:              PartitionDevice.setup: vda2 ; status: True ; controllable: True ; orig: False ;
>08:34:40,635 DEBUG storage:              PartitionDevice.updateSysfsPath: vda2 ; status: True ;
>08:34:40,644 DEBUG storage:               PartitionDevice.updateSysfsPath: vda2 ; status: True ;
>08:34:40,655 DEBUG storage: vda2 sysfsPath set to /devices/pci0000:00/0000:00:05.0/virtio1/block/vda/vda2
>08:34:40,900 INFO storage: executing action: [7] Create Format swap on partition vda2 (id 10)
>08:34:40,916 DEBUG storage:           PartitionDevice.setup: vda2 ; status: True ; controllable: True ; orig: False ;
>08:34:40,922 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 1 ;
>08:34:40,927 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 2 ;
>08:34:40,942 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 4 ;
>08:34:40,947 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 5 ;
>08:34:40,952 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 6 ;
>08:34:40,968 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 8 ;
>08:34:40,973 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 9 ;
>08:34:40,980 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 10 ;
>08:34:40,994 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 11 ;
>08:34:41,003 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 12 ;
>08:34:41,019 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 13 ;
>08:34:41,024 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 14 ;
>08:34:41,029 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda2 ; flag: 15 ;
>08:34:41,034 DEBUG storage:           PartitionDevice.setFlag: path: /dev/vda2 ; flag: 3 ;
>08:34:41,049 DEBUG storage:           DiskLabel.commitToDisk: device: /dev/vda ; numparts: 2 ;
>08:34:41,148 DEBUG storage:           SwapSpace.create: device: /dev/vda2 ; status: None ; type: swap ;
>08:34:41,165 DEBUG storage:            SwapSpace.create: device: /dev/vda2 ; status: None ; type: swap ;
>08:34:41,503 DEBUG storage:            SwapSpace.notifyKernel: device: /dev/vda2 ; type: swap ;
>08:34:41,653 DEBUG storage:           PartitionDevice.updateSysfsPath: vda2 ; status: True ;
>08:34:41,670 DEBUG storage:            PartitionDevice.updateSysfsPath: vda2 ; status: True ;
>08:34:41,675 DEBUG storage: vda2 sysfsPath set to /devices/pci0000:00/0000:00:05.0/virtio1/block/vda/vda2
>08:34:41,802 INFO storage: executing action: [2] Create Device partition vda3 (id 8)
>08:34:41,809 DEBUG storage:           PartitionDevice.create: vda3 ; status: False ;
>08:34:41,815 DEBUG storage:             PartitionDevice.setupParents: kids: 0 ; name: vda3 ; orig: False ;
>08:34:41,830 DEBUG storage:              DiskDevice.setup: vda ; status: True ; controllable: True ; orig: False ;
>08:34:41,836 DEBUG storage:              DiskLabel.setup: device: /dev/vda ; status: False ; type: disklabel ;
>08:34:41,850 DEBUG storage:               DiskLabel.setup: device: /dev/vda ; status: False ; type: disklabel ;
>08:34:41,856 DEBUG storage:            PartitionDevice._create: vda3 ; status: False ;
>08:34:41,863 DEBUG storage:             DiskLabel.commit: device: /dev/vda ; numparts: 3 ;
>08:34:42,319 DEBUG storage: post-commit partition path is /dev/vda3
>08:34:42,336 DEBUG storage:              PartitionDevice._setPartedPartition: vda3 ;
>08:34:42,351 DEBUG storage: device vda3 new partedPartition parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7ffebdbb6c90>  fileSystem: None
>  number: 3  path: /dev/vda3  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7ffec2a6ddd0>  PedPartition: <_ped.Partition object at 0x7ffec2a6c950>
>08:34:42,374 DEBUG storage:             DeviceFormat.destroy: device: /dev/vda3 ; status: False ; type: None ;
>08:34:42,562 DEBUG storage:              PartitionDevice.setup: vda3 ; status: True ; controllable: True ; orig: False ;
>08:34:42,572 DEBUG storage:              PartitionDevice.updateSysfsPath: vda3 ; status: True ;
>08:34:42,581 DEBUG storage:               PartitionDevice.updateSysfsPath: vda3 ; status: True ;
>08:34:42,593 DEBUG storage: vda3 sysfsPath set to /devices/pci0000:00/0000:00:05.0/virtio1/block/vda/vda3
>08:34:42,868 INFO storage: executing action: [3] Create Format ext4 filesystem mounted at / on partition vda3 (id 8)
>08:34:42,886 DEBUG storage:           PartitionDevice.setup: vda3 ; status: True ; controllable: True ; orig: False ;
>08:34:42,893 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 1 ;
>08:34:42,908 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 2 ;
>08:34:42,913 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 3 ;
>08:34:42,918 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 4 ;
>08:34:42,933 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 5 ;
>08:34:42,938 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 6 ;
>08:34:42,945 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 8 ;
>08:34:42,955 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 9 ;
>08:34:42,961 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 10 ;
>08:34:42,969 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 11 ;
>08:34:42,978 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 12 ;
>08:34:42,988 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 13 ;
>08:34:42,997 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 14 ;
>08:34:43,004 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda3 ; flag: 15 ;
>08:34:43,020 DEBUG storage:           DiskLabel.commitToDisk: device: /dev/vda ; numparts: 3 ;
>08:34:43,106 DEBUG storage:            Ext4FS.create: device: /dev/vda3 ; status: False ; type: ext4 ;
>08:34:43,141 DEBUG storage:             Ext4FS.doFormat: device: /dev/vda3 ; mountpoint: / ; type: ext4 ;
>08:34:51,514 DEBUG storage:              Ext4FS.notifyKernel: device: /dev/vda3 ; type: ext4 ;
>08:34:52,100 DEBUG storage:           PartitionDevice.updateSysfsPath: vda3 ; status: True ;
>08:34:52,118 DEBUG storage:            PartitionDevice.updateSysfsPath: vda3 ; status: True ;
>08:34:52,126 DEBUG storage: vda3 sysfsPath set to /devices/pci0000:00/0000:00:05.0/virtio1/block/vda/vda3
>08:34:52,343 INFO storage: executing action: [5] Create Format ext4 filesystem mounted at /boot on partition vda1 (id 9)
>08:34:52,354 DEBUG storage:           PartitionDevice.setup: vda1 ; status: True ; controllable: True ; orig: False ;
>08:34:52,364 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 1 ;
>08:34:52,372 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 2 ;
>08:34:52,379 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 3 ;
>08:34:52,388 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 4 ;
>08:34:52,396 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 5 ;
>08:34:52,404 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 6 ;
>08:34:52,418 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 8 ;
>08:34:52,429 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 9 ;
>08:34:52,436 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 10 ;
>08:34:52,453 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 11 ;
>08:34:52,458 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 12 ;
>08:34:52,468 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 13 ;
>08:34:52,477 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 14 ;
>08:34:52,482 DEBUG storage:           PartitionDevice.unsetFlag: path: /dev/vda1 ; flag: 15 ;
>08:34:52,492 DEBUG storage:           DiskLabel.commitToDisk: device: /dev/vda ; numparts: 3 ;
>08:34:52,647 DEBUG storage:            Ext4FS.create: device: /dev/vda1 ; status: False ; type: ext4 ;
>08:34:52,654 DEBUG storage:             Ext4FS.doFormat: device: /dev/vda1 ; mountpoint: /boot ; type: ext4 ;
>08:34:53,752 DEBUG storage:              Ext4FS.notifyKernel: device: /dev/vda1 ; type: ext4 ;
>08:34:53,936 DEBUG storage:           PartitionDevice.updateSysfsPath: vda1 ; status: True ;
>08:34:53,949 DEBUG storage:            PartitionDevice.updateSysfsPath: vda1 ; status: True ;
>08:34:53,954 DEBUG storage: vda1 sysfsPath set to /devices/pci0000:00/0000:00:05.0/virtio1/block/vda/vda1
>08:34:54,058 INFO storage: setting boot flag on vda1
>08:34:54,073 DEBUG storage:          PartitionDevice.setFlag: path: /dev/vda1 ; flag: 1 ;
>08:34:54,077 DEBUG storage:         DiskDevice.setup: vda ; status: True ; controllable: True ; orig: False ;
>08:34:54,082 DEBUG storage:         DiskLabel.commitToDisk: device: /dev/vda ; numparts: 3 ;
>08:34:54,510 DEBUG storage:              Ext4FS.supported: supported: True ;
>08:34:54,523 DEBUG storage:             Ext4FS.supported: supported: True ;
>08:34:54,538 DEBUG storage:              Ext4FS.supported: supported: True ;
>08:34:54,557 DEBUG storage:              Ext4FS.supported: supported: True ;
>08:34:54,589 DEBUG storage:          PartitionDevice.setup: vda2 ; status: True ; controllable: True ; orig: False ;
>08:34:54,598 DEBUG storage:          SwapSpace.setup: device: /dev/vda2 ; status: False ; type: swap ;
>08:34:54,603 DEBUG storage:           SwapSpace.setup: device: /dev/vda2 ; status: False ; type: swap ;
>08:34:55,026 DEBUG storage:             BindFS.supported: supported: False ;
>08:34:55,035 DEBUG storage: getFormat('bind') returning BindFS instance
>08:34:55,052 DEBUG storage:              DirectoryDevice._setFormat: /dev ; current: None ; type: bind ;
>08:34:55,065 DEBUG storage:              TmpFS.supported: supported: False ;
>08:34:55,073 DEBUG storage: getFormat('tmpfs') returning TmpFS instance
>08:34:55,081 DEBUG storage:              NoDevice._setFormat: tmpfs ; current: None ; type: tmpfs ;
>08:34:55,090 DEBUG storage:              DevPtsFS.supported: supported: False ;
>08:34:55,092 DEBUG storage: getFormat('devpts') returning DevPtsFS instance
>08:34:55,097 DEBUG storage:              NoDevice._setFormat: devpts ; current: None ; type: devpts ;
>08:34:55,117 DEBUG storage:              SysFS.supported: supported: False ;
>08:34:55,120 DEBUG storage: getFormat('sysfs') returning SysFS instance
>08:34:55,126 DEBUG storage:              NoDevice._setFormat: sysfs ; current: None ; type: sysfs ;
>08:34:55,135 DEBUG storage:              ProcFS.supported: supported: False ;
>08:34:55,143 DEBUG storage: getFormat('proc') returning ProcFS instance
>08:34:55,148 DEBUG storage:              NoDevice._setFormat: proc ; current: None ; type: proc ;
>08:34:55,158 DEBUG storage:              SELinuxFS.supported: supported: False ;
>08:34:55,161 DEBUG storage: getFormat('selinuxfs') returning SELinuxFS instance
>08:34:55,165 DEBUG storage:              NoDevice._setFormat: selinuxfs ; current: None ; type: selinuxfs ;
>08:34:55,176 DEBUG storage:              USBFS.supported: supported: False ;
>08:34:55,184 DEBUG storage: getFormat('usbfs') returning USBFS instance
>08:34:55,189 DEBUG storage:              NoDevice._setFormat: usbfs ; current: None ; type: usbfs ;
>08:34:55,198 DEBUG storage:          PartitionDevice.setup: vda3 ; status: True ; controllable: True ; orig: False ;
>08:34:55,312 INFO storage: set SELinux context for mountpoint / to system_u:object_r:root_t:s0
>08:34:55,678 INFO storage: set SELinux context for newly mounted filesystem root at / to system_u:object_r:root_t:s0
>08:34:55,730 DEBUG storage:          PartitionDevice.setup: vda1 ; status: True ; controllable: True ; orig: False ;
>08:34:55,939 INFO storage: set SELinux context for mountpoint /boot to system_u:object_r:boot_t:s0
>08:34:56,107 INFO storage: set SELinux context for newly mounted filesystem root at /boot to system_u:object_r:boot_t:s0
>08:34:56,115 DEBUG storage:          DirectoryDevice.setup: /dev ; status: True ; controllable: True ; orig: False ;
>08:34:56,254 INFO storage: set SELinux context for mountpoint /dev to system_u:object_r:device_t:s0
>08:34:56,381 INFO storage: set SELinux context for newly mounted filesystem root at /dev to system_u:object_r:device_t:s0
>08:34:56,397 DEBUG storage:          NoDevice.setup: devpts ; status: False ; controllable: True ; orig: False ;
>08:34:56,407 INFO storage: set SELinux context for mountpoint /dev/pts to system_u:object_r:devpts_t:s0
>08:34:56,511 INFO storage: set SELinux context for newly mounted filesystem root at /dev/pts to system_u:object_r:devpts_t:s0
>08:34:56,530 DEBUG storage:          NoDevice.setup: tmpfs ; status: False ; controllable: True ; orig: False ;
>08:34:56,535 INFO storage: set SELinux context for mountpoint /dev/shm to system_u:object_r:tmpfs_t:s0
>08:34:56,687 INFO storage: set SELinux context for newly mounted filesystem root at /dev/shm to system_u:object_r:tmpfs_t:s0
>08:34:56,693 DEBUG storage:          NoDevice.setup: proc ; status: False ; controllable: True ; orig: False ;
>08:34:56,754 INFO storage: set SELinux context for mountpoint /proc to None
>08:34:56,823 INFO storage: set SELinux context for newly mounted filesystem root at /proc to None
>08:34:57,700 DEBUG storage:          NoDevice.setup: sysfs ; status: False ; controllable: True ; orig: False ;
>08:34:57,737 INFO storage: set SELinux context for mountpoint /sys to system_u:object_r:sysfs_t:s0
>08:34:57,893 INFO storage: set SELinux context for newly mounted filesystem root at /sys to system_u:object_r:sysfs_t:s0
>08:34:57,900 DEBUG storage:          NoDevice.setup: selinuxfs ; status: False ; controllable: True ; orig: False ;
>08:34:57,903 INFO storage: set SELinux context for mountpoint /sys/fs/selinux to system_u:object_r:sysfs_t:s0
>08:34:58,016 INFO storage: set SELinux context for newly mounted filesystem root at /sys/fs/selinux to None
>08:34:58,096 INFO storage: not writing out mpath configuration
>
>
>/tmp/ifcfg.log:
>
>
>/proc/cmdline:
>method=http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/
>
>
>/tmp/syslog:
>06:27:51,067 INFO kernel:imklog 5.8.11, log source = /proc/kmsg started.
>06:27:51,067 INFO rsyslogd: [origin software="rsyslogd" swVersion="5.8.11" x-pid="603" x-info="http://www.rsyslog.com"] start
>06:27:51,213 INFO systemd: Successfully loaded SELinux policy in 9s 884ms 799us.
>06:27:51,213 INFO systemd: Relabelled /dev and /run in 88ms 93us.
>06:27:51,213 INFO systemd: systemd 188 running in system mode. (+PAM +LIBWRAP +AUDIT +SELINUX +IMA +SYSVINIT +LIBCRYPTSETUP; fedora)
>06:27:51,213 INFO systemd: Detected virtualization 'kvm'.
>06:27:51,213 INFO systemd: Initializing machine ID from KVM UUID.
>06:27:51,213 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.
>06:27:51,213 INFO systemd-modules-load: Inserted module 'uinput'
>06:27:51,268 INFO kernel:[    0.000000] Initializing cgroup subsys cpuset
>06:27:51,269 INFO kernel:[    0.000000] Initializing cgroup subsys cpu
>06:27:51,269 NOTICE kernel:[    0.000000] Linux version 3.6.0-0.rc6.git0.2.fc18.x86_64 (mockbuild@) (gcc version 4.7.1 20120720 (Red Hat 4.7.1-5) (GCC) ) #1 SMP Mon Sep 17 17:29:08 UTC 2012
>06:27:51,276 INFO kernel:[    0.000000] Command line: method=http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/
>06:27:51,277 INFO kernel:[    0.000000] e820: BIOS-provided physical RAM map:
>06:27:51,277 INFO kernel:[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009dbff] usable
>06:27:51,277 INFO kernel:[    0.000000] BIOS-e820: [mem 0x000000000009dc00-0x000000000009ffff] reserved
>06:27:51,278 INFO kernel:[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
>06:27:51,278 INFO kernel:[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003fffdfff] usable
>06:27:51,278 INFO kernel:[    0.000000] BIOS-e820: [mem 0x000000003fffe000-0x000000003fffffff] reserved
>06:27:51,279 INFO kernel:[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
>06:27:51,279 INFO kernel:[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
>06:27:51,280 INFO kernel:[    0.000000] NX (Execute Disable) protection: active
>06:27:51,280 INFO kernel:[    0.000000] DMI 2.4 present.
>06:27:51,280 DEBUG kernel:[    0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2007
>06:27:51,281 INFO kernel:[    0.000000] Hypervisor detected: KVM
>06:27:51,281 DEBUG kernel:[    0.000000] e820: update [mem 0x00000000-0x0000ffff] usable ==> reserved
>06:27:51,282 DEBUG kernel:[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
>06:27:51,282 INFO kernel:[    0.000000] No AGP bridge found
>06:27:51,282 INFO kernel:[    0.000000] e820: last_pfn = 0x3fffe max_arch_pfn = 0x400000000
>06:27:51,282 DEBUG kernel:[    0.000000] MTRR default type: write-back
>06:27:51,282 DEBUG kernel:[    0.000000] MTRR fixed ranges enabled:
>06:27:51,282 DEBUG kernel:[    0.000000]   00000-9FFFF write-back
>06:27:51,282 DEBUG kernel:[    0.000000]   A0000-BFFFF uncachable
>06:27:51,282 DEBUG kernel:[    0.000000]   C0000-FFFFF write-protect
>06:27:51,282 DEBUG kernel:[    0.000000] MTRR variable ranges enabled:
>06:27:51,282 DEBUG kernel:[    0.000000]   0 base 00E0000000 mask FFE0000000 uncachable
>06:27:51,282 DEBUG kernel:[    0.000000]   1 disabled
>06:27:51,282 DEBUG kernel:[    0.000000]   2 disabled
>06:27:51,282 DEBUG kernel:[    0.000000]   3 disabled
>06:27:51,282 DEBUG kernel:[    0.000000]   4 disabled
>06:27:51,282 DEBUG kernel:[    0.000000]   5 disabled
>06:27:51,282 DEBUG kernel:[    0.000000]   6 disabled
>06:27:51,282 DEBUG kernel:[    0.000000]   7 disabled
>06:27:51,282 INFO kernel:[    0.000000] PAT not supported by CPU.
>06:27:51,282 INFO kernel:[    0.000000] found SMP MP-table at [mem 0x000fdae0-0x000fdaef] mapped at [ffff8800000fdae0]
>06:27:51,282 DEBUG kernel:[    0.000000] initial memory mapped: [mem 0x00000000-0x1fffffff]
>06:27:51,282 DEBUG kernel:[    0.000000] Base memory trampoline at [ffff880000097000] 97000 size 24576
>06:27:51,282 INFO kernel:[    0.000000] init_memory_mapping: [mem 0x00000000-0x3fffdfff]
>06:27:51,282 DEBUG kernel:[    0.000000]  [mem 0x00000000-0x3fdfffff] page 2M
>06:27:51,282 DEBUG kernel:[    0.000000]  [mem 0x3fe00000-0x3fffdfff] page 4k
>06:27:51,282 DEBUG kernel:[    0.000000] kernel direct mapping tables up to 0x3fffdfff @ [mem 0x1fdfe000-0x1fffffff]
>06:27:51,282 INFO kernel:[    0.000000] RAMDISK: [mem 0x3e652000-0x3ffeffff]
>06:27:51,282 WARNING kernel:[    0.000000] ACPI: RSDP 00000000000fd980 00014 (v00 BOCHS )
>06:27:51,282 WARNING kernel:[    0.000000] ACPI: RSDT 000000003fffe5d0 00038 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
>06:27:51,282 WARNING kernel:[    0.000000] ACPI: FACP 000000003fffff80 00074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
>06:27:51,282 WARNING kernel:[    0.000000] ACPI: DSDT 000000003fffe610 01109 (v01   BXPC   BXDSDT 00000001 INTL 20100528)
>06:27:51,282 WARNING kernel:[    0.000000] ACPI: FACS 000000003fffff40 00040
>06:27:51,282 WARNING kernel:[    0.000000] ACPI: SSDT 000000003ffffea0 0009E (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
>06:27:51,282 WARNING kernel:[    0.000000] ACPI: APIC 000000003ffffdb0 00078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
>06:27:51,282 WARNING kernel:[    0.000000] ACPI: HPET 000000003ffffd70 00038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
>06:27:51,282 WARNING kernel:[    0.000000] ACPI: SSDT 000000003ffff720 00644 (v01   BXPC BXSSDTPC 00000001 INTL 20100528)
>06:27:51,282 DEBUG kernel:[    0.000000] ACPI: Local APIC address 0xfee00000
>06:27:51,282 INFO kernel:[    0.000000] No NUMA configuration found
>06:27:51,282 INFO kernel:[    0.000000] Faking a node at [mem 0x0000000000000000-0x000000003fffdfff]
>06:27:51,282 INFO kernel:[    0.000000] Initmem setup node 0 [mem 0x00000000-0x3fffdfff]
>06:27:51,282 INFO kernel:[    0.000000]   NODE_DATA [mem 0x3e62b000-0x3e651fff]
>06:27:51,282 INFO kernel:[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
>06:27:51,282 INFO kernel:[    0.000000] kvm-clock: cpu 0, msr 0:1f07a81, boot clock
>06:27:51,282 DEBUG kernel:[    0.000000]  [ffffea0000000000-ffffea0000ffffff] PMD -> [ffff88003ce00000-ffff88003ddfffff] on node 0
>06:27:51,282 WARNING kernel:[    0.000000] Zone ranges:
>06:27:51,282 WARNING kernel:[    0.000000]   DMA      [mem 0x00010000-0x00ffffff]
>06:27:51,282 WARNING kernel:[    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
>06:27:51,282 WARNING kernel:[    0.000000]   Normal   empty
>06:27:51,282 WARNING kernel:[    0.000000] Movable zone start for each node
>06:27:51,282 WARNING kernel:[    0.000000] Early memory node ranges
>06:27:51,282 WARNING kernel:[    0.000000]   node   0: [mem 0x00010000-0x0009cfff]
>06:27:51,282 WARNING kernel:[    0.000000]   node   0: [mem 0x00100000-0x3fffdfff]
>06:27:51,282 DEBUG kernel:[    0.000000] On node 0 totalpages: 262027
>06:27:51,282 DEBUG kernel:[    0.000000]   DMA zone: 64 pages used for memmap
>06:27:51,282 DEBUG kernel:[    0.000000]   DMA zone: 6 pages reserved
>06:27:51,282 DEBUG kernel:[    0.000000]   DMA zone: 3911 pages, LIFO batch:0
>06:27:51,282 DEBUG kernel:[    0.000000]   DMA32 zone: 4032 pages used for memmap
>06:27:51,282 DEBUG kernel:[    0.000000]   DMA32 zone: 254014 pages, LIFO batch:31
>06:27:51,282 INFO kernel:[    0.000000] ACPI: PM-Timer IO Port: 0xb008
>06:27:51,282 DEBUG kernel:[    0.000000] ACPI: Local APIC address 0xfee00000
>06:27:51,282 INFO kernel:[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
>06:27:51,282 INFO kernel:[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
>06:27:51,282 INFO kernel:[    0.000000] ACPI: IOAPIC (id[0x01] address[0xfec00000] gsi_base[0])
>06:27:51,282 INFO kernel:[    0.000000] IOAPIC[0]: apic_id 1, version 17, address 0xfec00000, GSI 0-23
>06:27:51,282 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
>06:27:51,282 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
>06:27:51,282 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
>06:27:51,282 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
>06:27:51,282 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
>06:27:51,282 DEBUG kernel:[    0.000000] ACPI: IRQ0 used by override.
>06:27:51,282 DEBUG kernel:[    0.000000] ACPI: IRQ2 used by override.
>06:27:51,282 DEBUG kernel:[    0.000000] ACPI: IRQ5 used by override.
>06:27:51,282 DEBUG kernel:[    0.000000] ACPI: IRQ9 used by override.
>06:27:51,282 DEBUG kernel:[    0.000000] ACPI: IRQ10 used by override.
>06:27:51,282 DEBUG kernel:[    0.000000] ACPI: IRQ11 used by override.
>06:27:51,282 INFO kernel:[    0.000000] Using ACPI (MADT) for SMP configuration information
>06:27:51,282 INFO kernel:[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
>06:27:51,282 INFO kernel:[    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
>06:27:51,282 DEBUG kernel:[    0.000000] nr_irqs_gsi: 40
>06:27:51,282 INFO kernel:[    0.000000] PM: Registered nosave memory: 000000000009d000 - 000000000009e000
>06:27:51,282 INFO kernel:[    0.000000] PM: Registered nosave memory: 000000000009e000 - 00000000000a0000
>06:27:51,282 INFO kernel:[    0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
>06:27:51,282 INFO kernel:[    0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
>06:27:51,282 INFO kernel:[    0.000000] e820: [mem 0x40000000-0xfeffbfff] available for PCI devices
>06:27:51,282 INFO kernel:[    0.000000] Booting paravirtualized kernel on KVM
>06:27:51,282 INFO kernel:[    0.000000] setup_percpu: NR_CPUS:4096 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
>06:27:51,282 INFO kernel:[    0.000000] PERCPU: Embedded 477 pages/cpu @ffff88003e400000 s1923392 r8192 d22208 u2097152
>06:27:51,282 DEBUG kernel:[    0.000000] pcpu-alloc: s1923392 r8192 d22208 u2097152 alloc=1*2097152
>06:27:51,282 DEBUG kernel:[    0.000000] pcpu-alloc: [0] 0 
>06:27:51,282 INFO kernel:[    0.000000] kvm-clock: cpu 0, msr 0:3e5d4a81, primary cpu clock
>06:27:51,282 INFO kernel:[    0.000000] KVM setup async PF for cpu 0
>06:27:51,282 INFO kernel:[    0.000000] kvm-stealtime: cpu 0, msr 3e40e0c0
>06:27:51,282 WARNING kernel:[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 257925
>06:27:51,282 WARNING kernel:[    0.000000] Policy zone: DMA32
>06:27:51,282 NOTICE kernel:[    0.000000] Kernel command line: method=http://download.eng.brq.redhat.com/pub/fedora/linux/development-snapshot-20120930/18/x86_64/os/
>06:27:51,282 INFO kernel:[    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
>06:27:51,282 NOTICE kernel:[    0.000000] __ex_table already sorted, skipping sort
>06:27:51,282 INFO kernel:[    0.000000] Checking aperture...
>06:27:51,282 INFO kernel:[    0.000000] No AGP bridge found
>06:27:51,282 INFO kernel:[    0.000000] Memory: 973272k/1048568k available (7085k kernel code, 460k absent, 74836k reserved, 6424k data, 3244k init)
>06:27:51,282 INFO kernel:[    0.000000] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
>06:27:51,282 INFO kernel:[    0.000000] Hierarchical RCU implementation.
>06:27:51,282 INFO kernel:[    0.000000] 	RCU lockdep checking is enabled.
>06:27:51,282 INFO kernel:[    0.000000] 	RCU restricting CPUs from NR_CPUS=4096 to nr_cpu_ids=1.
>06:27:51,282 INFO kernel:[    0.000000] NR_IRQS:262400 nr_irqs:256 16
>06:27:51,282 INFO kernel:[    0.000000] Console: colour VGA+ 80x25
>06:27:51,283 INFO kernel:[    0.000000] console [tty0] enabled
>06:27:51,283 WARNING kernel:[    0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
>06:27:51,283 WARNING kernel:[    0.000000] ... MAX_LOCKDEP_SUBCLASSES:  8
>06:27:51,283 WARNING kernel:[    0.000000] ... MAX_LOCK_DEPTH:          48
>06:27:51,283 WARNING kernel:[    0.000000] ... MAX_LOCKDEP_KEYS:        8191
>06:27:51,283 WARNING kernel:[    0.000000] ... CLASSHASH_SIZE:          4096
>06:27:51,283 WARNING kernel:[    0.000000] ... MAX_LOCKDEP_ENTRIES:     16384
>06:27:51,283 WARNING kernel:[    0.000000] ... MAX_LOCKDEP_CHAINS:      32768
>06:27:51,283 WARNING kernel:[    0.000000] ... CHAINHASH_SIZE:          16384
>06:27:51,283 WARNING kernel:[    0.000000]  memory used by lock dependency info: 6367 kB
>06:27:51,283 WARNING kernel:[    0.000000]  per task-struct memory footprint: 2688 bytes
>06:27:51,283 INFO kernel:[    0.000000] allocated 4194304 bytes of page_cgroup
>06:27:51,283 INFO kernel:[    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
>06:27:51,283 DEBUG kernel:[    0.000000] ODEBUG: 17 of 17 active objects replaced
>06:27:51,283 INFO kernel:[    0.000000] kmemleak: Kernel memory leak detector disabled
>06:27:51,283 DEBUG kernel:[    0.000000] hpet clockevent registered
>06:27:51,283 INFO kernel:[    0.000000] tsc: Detected 2659.998 MHz processor
>06:27:51,283 INFO kernel:[    0.000999] Calibrating delay loop (skipped) preset value.. 5319.99 BogoMIPS (lpj=2659998)
>06:27:51,283 INFO kernel:[    0.001027] pid_max: default: 32768 minimum: 301
>06:27:51,283 INFO kernel:[    0.001724] Security Framework initialized
>06:27:51,283 INFO kernel:[    0.002015] SELinux:  Initializing.
>06:27:51,283 DEBUG kernel:[    0.002398] SELinux:  Starting in permissive mode
>06:27:51,283 INFO kernel:[    0.003015] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes)
>06:27:51,283 INFO kernel:[    0.004340] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes)
>06:27:51,283 INFO kernel:[    0.005208] Mount-cache hash table entries: 256
>06:27:51,283 INFO kernel:[    0.008118] Initializing cgroup subsys cpuacct
>06:27:51,283 INFO kernel:[    0.008499] Initializing cgroup subsys memory
>06:27:51,283 INFO kernel:[    0.009085] Initializing cgroup subsys devices
>06:27:51,283 INFO kernel:[    0.009544] Initializing cgroup subsys freezer
>06:27:51,283 INFO kernel:[    0.010017] Initializing cgroup subsys net_cls
>06:27:51,283 INFO kernel:[    0.010375] Initializing cgroup subsys blkio
>06:27:51,283 INFO kernel:[    0.010703] Initializing cgroup subsys perf_event
>06:27:51,283 INFO kernel:[    0.011404] mce: CPU supports 10 MCE banks
>06:27:51,283 INFO kernel:[    0.012056] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
>06:27:51,283 INFO kernel:[    0.012056] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0
>06:27:51,283 INFO kernel:[    0.012056] tlb_flushall_shift is 0x6
>06:27:51,283 INFO kernel:[    0.013158] SMP alternatives: switching to UP code
>06:27:51,283 INFO kernel:[    0.035046] Freeing SMP alternatives: 20k freed
>06:27:51,283 INFO kernel:[    0.035386] ACPI: Core revision 20120711
>06:27:51,283 INFO kernel:[    0.068211] ftrace: allocating 23642 entries in 93 pages
>06:27:51,283 INFO kernel:[    0.075988] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
>06:27:51,283 INFO kernel:[    0.075993] smpboot: CPU0: Intel QEMU Virtual CPU version 1.0,1 stepping 03
>06:27:51,283 INFO kernel:[    0.076988] Performance Events: unsupported p6 CPU model 2 no PMU driver, software events only.
>06:27:51,283 WARNING kernel:[    0.079732] NMI watchdog: disabled (cpu0): hardware events not enabled
>06:27:51,283 INFO kernel:[    0.080140] Brought up 1 CPUs
>06:27:51,283 INFO kernel:[    0.080379] smpboot: Total of 1 processors activated (5319.99 BogoMIPS)
>06:27:51,283 INFO kernel:[    0.083290] devtmpfs: initialized
>06:27:51,283 INFO kernel:[    0.087447] atomic64 test passed for x86-64 platform with CX8 and with SSE
>06:27:51,283 INFO kernel:[    0.087933] RTC time:  6:27:00, date: 10/01/12
>06:27:51,283 INFO kernel:[    0.088559] NET: Registered protocol family 16
>06:27:51,283 INFO kernel:[    0.090491] ACPI: bus type pci registered
>06:27:51,283 INFO kernel:[    0.091337] PCI: Using configuration type 1 for base access
>06:27:51,283 INFO kernel:[    0.105761] bio: create slab <bio-0> at 0
>06:27:51,283 INFO kernel:[    0.106755] ACPI: Added _OSI(Module Device)
>06:27:51,283 INFO kernel:[    0.106997] ACPI: Added _OSI(Processor Device)
>06:27:51,283 INFO kernel:[    0.107288] ACPI: Added _OSI(3.0 _SCP Extensions)
>06:27:51,283 INFO kernel:[    0.107601] ACPI: Added _OSI(Processor Aggregator Device)
>06:27:51,283 DEBUG kernel:[    0.110583] ACPI: EC: Look up EC in DSDT
>06:27:51,283 INFO kernel:[    0.163214] ACPI: Interpreter enabled
>06:27:51,283 INFO kernel:[    0.163493] ACPI: (supports S0 S5)
>06:27:51,283 INFO kernel:[    0.163981] ACPI: Using IOAPIC for interrupt routing
>06:27:51,283 INFO kernel:[    0.235979] ACPI: No dock devices found.
>06:27:51,283 INFO kernel:[    0.236281] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug
>06:27:51,283 INFO kernel:[    0.237065] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
>06:27:51,283 DEBUG kernel:[    0.237630] pci_root PNP0A03:00: host bridge window [io  0x0000-0x0cf7] (ignored)
>06:27:51,283 DEBUG kernel:[    0.237632] pci_root PNP0A03:00: host bridge window [io  0x0d00-0xffff] (ignored)
>06:27:51,283 DEBUG kernel:[    0.237634] pci_root PNP0A03:00: host bridge window [mem 0x000a0000-0x000bffff] (ignored)
>06:27:51,283 DEBUG kernel:[    0.237636] pci_root PNP0A03:00: host bridge window [mem 0xe0000000-0xfebfffff] (ignored)
>06:27:51,283 DEBUG kernel:[    0.237652] PCI: root bus 00: using default resources
>06:27:51,283 WARNING kernel:[    0.237687] pci_root PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
>06:27:51,283 INFO kernel:[    0.238536] PCI host bridge to bus 0000:00
>06:27:51,283 DEBUG kernel:[    0.238983] pci_bus 0000:00: busn_res: [bus 00-ff] is inserted under domain [bus 00-ff]
>06:27:51,283 INFO kernel:[    0.238986] pci_bus 0000:00: root bus resource [bus 00-ff]
>06:27:51,283 INFO kernel:[    0.239300] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
>06:27:51,283 INFO kernel:[    0.239640] pci_bus 0000:00: root bus resource [mem 0x00000000-0xffffffffff]
>06:27:51,283 DEBUG kernel:[    0.240053] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
>06:27:51,283 DEBUG kernel:[    0.240378] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
>06:27:51,283 DEBUG kernel:[    0.241005] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
>06:27:51,283 DEBUG kernel:[    0.241421] pci 0000:00:01.1: reg 20: [io  0xc0c0-0xc0cf]
>06:27:51,283 DEBUG kernel:[    0.241742] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300
>06:27:51,283 DEBUG kernel:[    0.242166] pci 0000:00:01.2: reg 20: [io  0xc040-0xc05f]
>06:27:51,283 DEBUG kernel:[    0.242456] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
>06:27:51,283 INFO kernel:[    0.242826] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
>06:27:51,283 INFO kernel:[    0.242979] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
>06:27:51,283 DEBUG kernel:[    0.243482] pci 0000:00:02.0: [1b36:0100] type 00 class 0x030000
>06:27:51,283 DEBUG kernel:[    0.245014] pci 0000:00:02.0: reg 10: [mem 0xf4000000-0xf7ffffff]
>06:27:51,283 DEBUG kernel:[    0.246997] pci 0000:00:02.0: reg 14: [mem 0xf8000000-0xfbffffff]
>06:27:51,283 DEBUG kernel:[    0.248037] pci 0000:00:02.0: reg 18: [mem 0xfc024000-0xfc025fff]
>06:27:51,283 DEBUG kernel:[    0.249997] pci 0000:00:02.0: reg 1c: [io  0xc060-0xc07f]
>06:27:51,283 DEBUG kernel:[    0.254694] pci 0000:00:02.0: reg 30: [mem 0xfc000000-0xfc00ffff pref]
>06:27:51,283 DEBUG kernel:[    0.255196] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000
>06:27:51,283 DEBUG kernel:[    0.255366] pci 0000:00:03.0: reg 10: [io  0xc080-0xc09f]
>06:27:51,283 DEBUG kernel:[    0.255488] pci 0000:00:03.0: reg 14: [mem 0xfc026000-0xfc026fff]
>06:27:51,283 DEBUG kernel:[    0.256087] pci 0000:00:03.0: reg 30: [mem 0xfc010000-0xfc01ffff pref]
>06:27:51,283 DEBUG kernel:[    0.256361] pci 0000:00:04.0: [8086:2668] type 00 class 0x040300
>06:27:51,283 DEBUG kernel:[    0.256493] pci 0000:00:04.0: reg 10: [mem 0xfc020000-0xfc023fff]
>06:27:51,283 DEBUG kernel:[    0.257285] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000
>06:27:51,283 DEBUG kernel:[    0.257565] pci 0000:00:05.0: reg 10: [io  0xc000-0xc03f]
>06:27:51,283 DEBUG kernel:[    0.257803] pci 0000:00:05.0: reg 14: [mem 0xfc027000-0xfc027fff]
>06:27:51,283 DEBUG kernel:[    0.260465] pci 0000:00:06.0: [1af4:1002] type 00 class 0x050000
>06:27:51,283 DEBUG kernel:[    0.260582] pci 0000:00:06.0: reg 10: [io  0xc0a0-0xc0bf]
>06:27:51,283 DEBUG kernel:[    0.261423] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
>06:27:51,283 INFO kernel:[    0.280239]  pci0000:00: ACPI _OSC support notification failed, disabling PCIe ASPM
>06:27:51,283 INFO kernel:[    0.280746]  pci0000:00: Unable to request _OSC control (_OSC support mask: 0x08)
>06:27:51,283 INFO kernel:[    0.427912] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
>06:27:51,283 INFO kernel:[    0.429767] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
>06:27:51,283 INFO kernel:[    0.431626] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
>06:27:51,283 INFO kernel:[    0.433580] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
>06:27:51,283 INFO kernel:[    0.435410] ACPI: PCI Interrupt Link [LNKS] (IRQs 9) *0
>06:27:51,283 INFO kernel:[    0.437840] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
>06:27:51,283 INFO kernel:[    0.437981] vgaarb: loaded
>06:27:51,283 INFO kernel:[    0.439947] vgaarb: bridge control possible 0000:00:02.0
>06:27:51,283 NOTICE kernel:[    0.442234] SCSI subsystem initialized
>06:27:51,283 INFO kernel:[    0.442545] ACPI: bus type scsi registered
>06:27:51,283 DEBUG kernel:[    0.443397] libata version 3.00 loaded.
>06:27:51,283 INFO kernel:[    0.443775] ACPI: bus type usb registered
>06:27:51,283 INFO kernel:[    0.444434] usbcore: registered new interface driver usbfs
>06:27:51,283 INFO kernel:[    0.445026] usbcore: registered new interface driver hub
>06:27:51,283 INFO kernel:[    0.445497] usbcore: registered new device driver usb
>06:27:51,283 INFO kernel:[    0.446596] PCI: Using ACPI for IRQ routing
>06:27:51,283 DEBUG kernel:[    0.446866] PCI: pci_cache_line_size set to 64 bytes
>06:27:51,283 DEBUG kernel:[    0.447257] e820: reserve RAM buffer [mem 0x0009dc00-0x0009ffff]
>06:27:51,283 DEBUG kernel:[    0.447278] e820: reserve RAM buffer [mem 0x3fffe000-0x3fffffff]
>06:27:51,283 INFO kernel:[    0.448712] NetLabel: Initializing
>06:27:51,283 INFO kernel:[    0.448936] NetLabel:  domain hash size = 128
>06:27:51,283 INFO kernel:[    0.449846] NetLabel:  protocols = UNLABELED CIPSOv4
>06:27:51,283 INFO kernel:[    0.450110] NetLabel:  unlabeled traffic allowed by default
>06:27:51,283 INFO kernel:[    0.450566] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
>06:27:51,478 INFO kernel:[    0.450959] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
>06:27:51,478 INFO kernel:[    0.451440] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
>06:27:51,478 INFO kernel:[    0.455408] Switching to clocksource kvm-clock
>06:27:51,478 INFO kernel:[    0.713834] pnp: PnP ACPI init
>06:27:51,478 INFO kernel:[    0.714277] ACPI: bus type pnp registered
>06:27:51,478 DEBUG kernel:[    0.714736] pnp 00:00: [bus 00-ff]
>06:27:51,478 DEBUG kernel:[    0.714744] pnp 00:00: [io  0x0cf8-0x0cff]
>06:27:51,478 DEBUG kernel:[    0.714750] pnp 00:00: [io  0x0000-0x0cf7 window]
>06:27:51,478 DEBUG kernel:[    0.714756] pnp 00:00: [io  0x0d00-0xffff window]
>06:27:51,478 DEBUG kernel:[    0.714762] pnp 00:00: [mem 0x000a0000-0x000bffff window]
>06:27:51,478 DEBUG kernel:[    0.714768] pnp 00:00: [mem 0xe0000000-0xfebfffff window]
>06:27:51,478 DEBUG kernel:[    0.715088] pnp 00:00: Plug and Play ACPI device, IDs PNP0a03 (active)
>06:27:51,478 DEBUG kernel:[    0.715252] pnp 00:01: [io  0x0070-0x0071]
>06:27:51,478 DEBUG kernel:[    0.715336] pnp 00:01: [irq 8]
>06:27:51,478 DEBUG kernel:[    0.715342] pnp 00:01: [io  0x0072-0x0077]
>06:27:51,478 DEBUG kernel:[    0.715580] pnp 00:01: Plug and Play ACPI device, IDs PNP0b00 (active)
>06:27:51,478 DEBUG kernel:[    0.716111] pnp 00:02: [io  0x0060]
>06:27:51,478 DEBUG kernel:[    0.716132] pnp 00:02: [io  0x0064]
>06:27:51,478 DEBUG kernel:[    0.716173] pnp 00:02: [irq 1]
>06:27:51,478 DEBUG kernel:[    0.716410] pnp 00:02: Plug and Play ACPI device, IDs PNP0303 (active)
>06:27:51,478 DEBUG kernel:[    0.716964] pnp 00:03: [irq 12]
>06:27:51,478 DEBUG kernel:[    0.717260] pnp 00:03: Plug and Play ACPI device, IDs PNP0f13 (active)
>06:27:51,478 DEBUG kernel:[    0.717809] pnp 00:04: [io  0x03f2-0x03f5]
>06:27:51,478 DEBUG kernel:[    0.717817] pnp 00:04: [io  0x03f7]
>06:27:51,478 DEBUG kernel:[    0.717859] pnp 00:04: [irq 6]
>06:27:51,478 DEBUG kernel:[    0.717865] pnp 00:04: [dma 2]
>06:27:51,478 DEBUG kernel:[    0.718173] pnp 00:04: Plug and Play ACPI device, IDs PNP0700 (active)
>06:27:51,478 DEBUG kernel:[    0.719536] pnp 00:05: [io  0x03f8-0x03ff]
>06:27:51,478 DEBUG kernel:[    0.719571] pnp 00:05: [irq 4]
>06:27:51,478 DEBUG kernel:[    0.719852] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
>06:27:51,478 DEBUG kernel:[    0.722549] pnp 00:06: [mem 0xfed00000-0xfed003ff]
>06:27:51,478 DEBUG kernel:[    0.722830] pnp 00:06: Plug and Play ACPI device, IDs PNP0103 (active)
>06:27:51,478 INFO kernel:[    0.725131] pnp: PnP ACPI: found 7 devices
>06:27:51,478 INFO kernel:[    0.725391] ACPI: ACPI bus type pnp unregistered
>06:27:51,478 DEBUG kernel:[    0.751465] pci_bus 0000:00: resource 4 [io  0x0000-0xffff]
>06:27:51,478 DEBUG kernel:[    0.751469] pci_bus 0000:00: resource 5 [mem 0x00000000-0xffffffffff]
>06:27:51,478 INFO kernel:[    0.751707] NET: Registered protocol family 2
>06:27:51,478 INFO kernel:[    0.753343] TCP established hash table entries: 131072 (order: 9, 2097152 bytes)
>06:27:51,478 INFO kernel:[    0.755791] TCP bind hash table entries: 65536 (order: 10, 5242880 bytes)
>06:27:51,478 INFO kernel:[    0.762671] TCP: Hash tables configured (established 131072 bind 65536)
>06:27:51,478 INFO kernel:[    0.763166] TCP: reno registered
>06:27:51,478 INFO kernel:[    0.763461] UDP hash table entries: 512 (order: 4, 98304 bytes)
>06:27:51,478 INFO kernel:[    0.763885] UDP-Lite hash table entries: 512 (order: 4, 98304 bytes)
>06:27:51,478 INFO kernel:[    0.764858] NET: Registered protocol family 1
>06:27:51,478 INFO kernel:[    0.765206] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
>06:27:51,478 INFO kernel:[    0.765516] pci 0000:00:01.0: PIIX3: Enabling Passive Release
>06:27:51,478 INFO kernel:[    0.765836] pci 0000:00:01.0: Activating ISA DMA hang workarounds
>06:27:51,478 WARNING kernel:[    0.769592] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
>06:27:51,478 DEBUG kernel:[    0.770113] pci 0000:00:02.0: Boot video device
>06:27:51,478 DEBUG kernel:[    0.770196] PCI: CLS 0 bytes, default 64
>06:27:51,478 INFO kernel:[    0.770839] Unpacking initramfs...
>06:27:51,478 INFO kernel:[    4.294678] Freeing initrd memory: 26232k freed
>06:27:51,478 INFO kernel:[    4.440721] DMA-API: preallocated 32768 debug entries
>06:27:51,478 INFO kernel:[    4.441074] DMA-API: debugging enabled by kernel config
>06:27:51,478 NOTICE kernel:[    4.445622] Initialise module verification
>06:27:51,478 INFO kernel:[    4.446081] audit: initializing netlink socket (disabled)
>06:27:51,478 NOTICE kernel:[    4.446501] type=2000 audit(1349072825.445:1): initialized
>06:27:51,478 WARNING kernel:[    4.464211] cryptomgr_test (21) used greatest stack depth: 5624 bytes left
>06:27:51,478 INFO kernel:[    4.467547] HugeTLB registered 2 MB page size, pre-allocated 0 pages
>06:27:51,478 NOTICE kernel:[    4.503411] VFS: Disk quotas dquot_6.5.2
>06:27:51,478 WARNING kernel:[    4.504095] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
>06:27:51,478 INFO kernel:[    4.510211] msgmni has been set to 1952
>06:27:51,478 NOTICE kernel:[    4.511141] Key type crypto registered
>06:27:51,478 NOTICE kernel:[    4.511478] Crypto key parser 'pgp' registered
>06:27:51,478 NOTICE kernel:[    4.511746] Crypto signature parser 'pgp' registered
>06:27:51,478 DEBUG kernel:[    4.512040] SELinux:  Registering netfilter hooks
>06:27:51,478 WARNING kernel:[    4.514271] cryptomgr_test (28) used greatest stack depth: 5448 bytes left
>06:27:51,478 WARNING kernel:[    4.515973] cryptomgr_test (33) used greatest stack depth: 5304 bytes left
>06:27:51,478 INFO kernel:[    4.516529] alg: No test for stdrng (krng)
>06:27:51,478 INFO kernel:[    4.516811] NET: Registered protocol family 38
>06:27:51,478 INFO kernel:[    4.519382] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
>06:27:51,478 INFO kernel:[    4.520256] io scheduler noop registered
>06:27:51,478 INFO kernel:[    4.520515] io scheduler deadline registered
>06:27:51,478 INFO kernel:[    4.521348] io scheduler cfq registered (default)
>06:27:51,478 INFO kernel:[    4.521626] start plist test
>06:27:51,478 INFO kernel:[    4.523208] end plist test
>06:27:51,478 DEBUG kernel:[    4.523439] list_sort_test: start testing list_sort()
>06:27:51,478 INFO kernel:[    4.529108] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
>06:27:51,478 INFO kernel:[    4.529708] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
>06:27:51,478 INFO kernel:[    4.530028] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
>06:27:51,478 INFO kernel:[    4.531620] acpiphp: Slot [3] registered
>06:27:51,478 INFO kernel:[    4.532392] acpiphp: Slot [4] registered
>06:27:51,478 INFO kernel:[    4.532951] acpiphp: Slot [5] registered
>06:27:51,478 INFO kernel:[    4.533550] acpiphp: Slot [6] registered
>06:27:51,478 INFO kernel:[    4.534136] acpiphp: Slot [7] registered
>06:27:51,478 INFO kernel:[    4.534685] acpiphp: Slot [8] registered
>06:27:51,478 INFO kernel:[    4.535382] acpiphp: Slot [9] registered
>06:27:51,478 INFO kernel:[    4.535933] acpiphp: Slot [10] registered
>06:27:51,478 INFO kernel:[    4.536736] acpiphp: Slot [11] registered
>06:27:51,478 INFO kernel:[    4.537343] acpiphp: Slot [12] registered
>06:27:51,478 INFO kernel:[    4.537965] acpiphp: Slot [13] registered
>06:27:51,478 INFO kernel:[    4.538576] acpiphp: Slot [14] registered
>06:27:51,478 INFO kernel:[    4.539175] acpiphp: Slot [15] registered
>06:27:51,478 INFO kernel:[    4.539738] acpiphp: Slot [16] registered
>06:27:51,478 INFO kernel:[    4.540462] acpiphp: Slot [17] registered
>06:27:51,478 INFO kernel:[    4.541027] acpiphp: Slot [18] registered
>06:27:51,478 INFO kernel:[    4.541639] acpiphp: Slot [19] registered
>06:27:51,478 INFO kernel:[    4.542222] acpiphp: Slot [20] registered
>06:27:51,478 INFO kernel:[    4.542769] acpiphp: Slot [21] registered
>06:27:51,478 INFO kernel:[    4.543463] acpiphp: Slot [22] registered
>06:27:51,478 INFO kernel:[    4.544264] acpiphp: Slot [23] registered
>06:27:51,478 INFO kernel:[    4.544806] acpiphp: Slot [24] registered
>06:27:51,478 INFO kernel:[    4.545405] acpiphp: Slot [25] registered
>06:27:51,478 INFO kernel:[    4.545953] acpiphp: Slot [26] registered
>06:27:51,478 INFO kernel:[    4.546526] acpiphp: Slot [27] registered
>06:27:51,478 INFO kernel:[    4.547097] acpiphp: Slot [28] registered
>06:27:51,478 INFO kernel:[    4.549273] acpiphp: Slot [29] registered
>06:27:51,478 INFO kernel:[    4.549828] acpiphp: Slot [30] registered
>06:27:51,478 INFO kernel:[    4.550409] acpiphp: Slot [31] registered
>06:27:51,478 DEBUG kernel:[    4.553867] intel_idle: does not run on family 6 model 2
>06:27:51,478 INFO kernel:[    4.554523] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
>06:27:51,478 INFO kernel:[    4.555061] ACPI: Power Button [PWRF]
>06:27:51,478 INFO kernel:[    4.609831] GHES: HEST is not enabled!
>06:27:51,478 WARNING kernel:[    4.612561] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
>06:27:51,478 DEBUG kernel:[    4.613029] virtio-pci 0000:00:03.0: setting latency timer to 64
>06:27:51,478 WARNING kernel:[    4.615939] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
>06:27:51,478 DEBUG kernel:[    4.616326] virtio-pci 0000:00:05.0: setting latency timer to 64
>06:27:51,478 WARNING kernel:[    4.618833] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11
>06:27:51,478 DEBUG kernel:[    4.619203] virtio-pci 0000:00:06.0: setting latency timer to 64
>06:27:51,478 INFO kernel:[    4.619947] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
>06:27:51,478 INFO kernel:[    4.642639] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
>06:27:51,478 INFO kernel:[    4.667048] 00:05: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
>06:27:51,478 INFO kernel:[    4.671383] Non-volatile memory driver v1.3
>06:27:51,478 INFO kernel:[    4.671680] Linux agpgart interface v0.103
>06:27:51,478 INFO kernel:[    4.682405] loop: module loaded
>06:27:51,478 DEBUG kernel:[    4.683608] ata_piix 0000:00:01.1: version 2.13
>06:27:51,478 DEBUG kernel:[    4.683938] ata_piix 0000:00:01.1: setting latency timer to 64
>06:27:51,478 INFO kernel:[    4.688441] scsi0 : ata_piix
>06:27:51,478 INFO kernel:[    4.690408] scsi1 : ata_piix
>06:27:51,478 INFO kernel:[    4.691202] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0c0 irq 14
>06:27:51,478 INFO kernel:[    4.691555] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0c8 irq 15
>06:27:51,478 INFO kernel:[    4.692911] libphy: Fixed MDIO Bus: probed
>06:27:51,478 INFO kernel:[    4.693667] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
>06:27:51,478 INFO kernel:[    4.694149] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
>06:27:51,478 INFO kernel:[    4.694513] uhci_hcd: USB Universal Host Controller Interface driver
>06:27:51,478 DEBUG kernel:[    4.695307] uhci_hcd 0000:00:01.2: setting latency timer to 64
>06:27:51,478 INFO kernel:[    4.695315] uhci_hcd 0000:00:01.2: UHCI Host Controller
>06:27:51,478 INFO kernel:[    4.696537] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
>06:27:51,478 INFO kernel:[    4.698659] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c040
>06:27:51,478 INFO kernel:[    4.699743] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
>06:27:51,478 INFO kernel:[    4.700152] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
>06:27:51,478 INFO kernel:[    4.700880] usb usb1: Product: UHCI Host Controller
>06:27:51,478 INFO kernel:[    4.701459] usb usb1: Manufacturer: Linux 3.6.0-0.rc6.git0.2.fc18.x86_64 uhci_hcd
>06:27:51,478 INFO kernel:[    4.702060] usb usb1: SerialNumber: 0000:00:01.2
>06:27:51,478 INFO kernel:[    4.704478] hub 1-0:1.0: USB hub found
>06:27:51,478 INFO kernel:[    4.704892] hub 1-0:1.0: 2 ports detected
>06:27:51,478 INFO kernel:[    4.706787] usbcore: registered new interface driver usbserial
>06:27:51,478 INFO kernel:[    4.707495] usbcore: registered new interface driver usbserial_generic
>06:27:51,478 INFO kernel:[    4.707944] USB Serial support registered for generic
>06:27:51,478 INFO kernel:[    4.708266] usbserial: USB Serial Driver core
>06:27:51,478 INFO kernel:[    4.708794] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
>06:27:51,478 INFO kernel:[    4.710511] serio: i8042 KBD port at 0x60,0x64 irq 1
>06:27:51,478 INFO kernel:[    4.710909] serio: i8042 AUX port at 0x60,0x64 irq 12
>06:27:51,478 INFO kernel:[    4.712532] mousedev: PS/2 mouse device common for all mice
>06:27:51,478 INFO kernel:[    4.714629] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
>06:27:51,478 INFO kernel:[    4.719313] rtc_cmos 00:01: RTC can wake from S4
>06:27:51,478 INFO kernel:[    4.720485] rtc_cmos 00:01: rtc core: registered rtc_cmos as rtc0
>06:27:51,478 INFO kernel:[    4.720965] rtc0: alarms up to one day, 114 bytes nvram, hpet irqs
>06:27:51,478 INFO kernel:[    4.722897] device-mapper: uevent: version 1.0.3
>06:27:51,478 INFO kernel:[    4.724219] device-mapper: ioctl: 4.23.0-ioctl (2012-07-25) initialised: dm-devel@redhat.com
>06:27:51,478 INFO kernel:[    4.725795] cpuidle: using governor ladder
>06:27:51,478 INFO kernel:[    4.726076] cpuidle: using governor menu
>06:27:51,478 INFO kernel:[    4.728904] EFI Variables Facility v0.08 2004-May-17
>06:27:51,478 INFO kernel:[    4.730564] usbcore: registered new interface driver usbhid
>06:27:51,478 INFO kernel:[    4.730866] usbhid: USB HID core driver
>06:27:51,478 INFO kernel:[    4.731593] drop_monitor: Initializing network drop monitor service
>06:27:51,478 INFO kernel:[    4.732728] ip_tables: (C) 2000-2006 Netfilter Core Team
>06:27:51,478 INFO kernel:[    4.733170] TCP: cubic registered
>06:27:51,478 INFO kernel:[    4.733452] Initializing XFRM netlink socket
>06:27:51,478 INFO kernel:[    4.735379] NET: Registered protocol family 10
>06:27:51,478 INFO kernel:[    4.738069] mip6: Mobile IPv6
>06:27:51,478 INFO kernel:[    4.738377] NET: Registered protocol family 17
>06:27:51,478 DEBUG kernel:[    4.740503] PM: Hibernation image not present or could not be loaded.
>06:27:51,478 NOTICE kernel:[    4.740506] Load module verification keys
>06:27:51,478 NOTICE kernel:[    4.741068] Loaded Fedora Project 18526876 key: 70427b2e3efd503efa231d059f2836ff18526876
>06:27:51,478 INFO kernel:[    4.741854] registered taskstats version 1
>06:27:51,478 INFO kernel:[    4.744582]   Magic number: 0:658:467
>06:27:51,478 INFO kernel:[    4.745129] rtc_cmos 00:01: setting system clock to 2012-10-01 06:27:05 UTC (1349072825)
>06:27:51,478 INFO kernel:[    4.852219] Freeing unused kernel memory: 3244k freed
>06:27:51,478 INFO kernel:[    4.858217] Write protecting the kernel read-only data: 12288k
>06:27:51,478 INFO kernel:[    4.861653] Freeing unused kernel memory: 1096k freed
>06:27:51,478 INFO kernel:[    4.866096] Freeing unused kernel memory: 1216k freed
>06:27:51,478 WARNING kernel:[    4.938278] systemd-cryptse (44) used greatest stack depth: 4896 bytes left
>06:27:51,478 WARNING kernel:[    4.960343] cp (47) used greatest stack depth: 4872 bytes left
>06:27:51,478 WARNING kernel:[    4.962572] service-to-run (45) used greatest stack depth: 4592 bytes left
>06:27:51,478 INFO kernel:[    5.011112] usb 1-1: new full-speed USB device number 2 using uhci_hcd
>06:27:51,478 INFO kernel:[    5.156477] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2
>06:27:51,478 INFO kernel:[    5.259432] usb 1-1: New USB device found, idVendor=0627, idProduct=0001
>06:27:51,478 INFO kernel:[    5.259796] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
>06:27:51,478 INFO kernel:[    5.261171] usb 1-1: Product: QEMU USB Tablet
>06:27:51,478 INFO kernel:[    5.261572] usb 1-1: Manufacturer: QEMU 1.0,1
>06:27:51,478 INFO kernel:[    5.261852] usb 1-1: SerialNumber: 42
>06:27:51,479 INFO kernel:[    5.301448] 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
>06:27:51,479 INFO kernel:[    5.304367] 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
>06:27:51,479 INFO kernel:[    5.384410] BIOS EDD facility v0.16 2004-Jun-25, 1 devices found
>06:27:51,479 INFO kernel:[    5.444435] tsc: Refined TSC clocksource calibration: 2659.649 MHz
>06:27:51,479 INFO kernel:[    5.725328] squashfs: version 4.0 (2009/01/31) Phillip Lougher
>06:27:51,479 INFO kernel:[    5.741538] alua: device handler registered
>06:27:51,479 INFO kernel:[    5.751522] emc: device handler registered
>06:27:51,479 INFO kernel:[    5.760839] hp_sw: device handler registered
>06:27:51,479 INFO kernel:[    5.769208] rdac: device handler registered
>06:27:51,479 INFO kernel:[    5.795638] FDC 0 is a S82078B
>06:27:51,479 INFO kernel:[    5.821168] md: raid0 personality registered for level 0
>06:27:51,479 INFO kernel:[    5.831844] md: raid1 personality registered for level 1
>06:27:51,479 INFO kernel:[    5.843684] async_tx: api initialized (async)
>06:27:51,479 INFO kernel:[    5.942156] xor: automatically using best checksumming function:
>06:27:51,479 INFO kernel:[    5.952036]    generic_sse:   132.000 MB/sec
>06:27:51,479 WARNING kernel:[    5.972033] raid6: sse2x1    6203 MB/s
>06:27:51,479 WARNING kernel:[    5.989030] raid6: sse2x2    8246 MB/s
>06:27:51,479 WARNING kernel:[    6.006125] raid6: sse2x4    8246 MB/s
>06:27:51,479 WARNING kernel:[    6.006410] raid6: using algorithm sse2x2 (8246 MB/s)
>06:27:51,479 WARNING kernel:[    6.006678] raid6: using intx1 recovery algorithm
>06:27:51,479 INFO kernel:[    6.016097] md: raid6 personality registered for level 6
>06:27:51,479 INFO kernel:[    6.016437] md: raid5 personality registered for level 5
>06:27:51,479 INFO kernel:[    6.016709] md: raid4 personality registered for level 4
>06:27:51,479 INFO kernel:[    6.043530] md: raid10 personality registered for level 10
>06:27:51,479 INFO kernel:[    6.052268] md: linear personality registered for level -1
>06:27:51,479 INFO kernel:[    6.096516] device-mapper: multipath: version 1.5.0 loaded
>06:27:51,479 INFO kernel:[    6.106777] device-mapper: multipath round-robin: version 1.0.0 loaded
>06:27:51,479 INFO kernel:[    6.284302] RPC: Registered named UNIX socket transport module.
>06:27:51,479 INFO kernel:[    6.364896] RPC: Registered udp transport module.
>06:27:51,479 INFO kernel:[    6.365222] RPC: Registered tcp transport module.
>06:27:51,479 INFO kernel:[    6.365485] RPC: Registered tcp NFSv4.1 backchannel transport module.
>06:27:51,479 WARNING kernel:[    6.366845] modprobe (208) used greatest stack depth: 4224 bytes left
>06:27:51,479 WARNING kernel:[    6.852327] systemd-cgroups (256) used greatest stack depth: 4208 bytes left
>06:27:51,479 DEBUG kernel:[    9.361070] virtio-pci 0000:00:03.0: irq 40 for MSI/MSI-X
>06:27:51,479 DEBUG kernel:[    9.361168] virtio-pci 0000:00:03.0: irq 41 for MSI/MSI-X
>06:27:51,479 DEBUG kernel:[    9.361261] virtio-pci 0000:00:03.0: irq 42 for MSI/MSI-X
>06:27:51,479 DEBUG kernel:[    9.435228] virtio-pci 0000:00:05.0: irq 43 for MSI/MSI-X
>06:27:51,479 DEBUG kernel:[    9.435392] virtio-pci 0000:00:05.0: irq 44 for MSI/MSI-X
>06:27:51,479 INFO kernel:[    9.475133]  vda: unknown partition table
>06:27:51,479 WARNING kernel:[   10.005434] ip (313) used greatest stack depth: 3248 bytes left
>06:27:51,479 WARNING kernel:[   13.133279] systemd-udevd (259) used greatest stack depth: 2960 bytes left
>06:27:51,479 INFO kernel:[   28.291881] EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null)
>06:27:51,479 DEBUG kernel:[   34.387541] SELinux: 2048 avtab hash slots, 94105 rules.
>06:27:51,479 DEBUG kernel:[   35.835234] SELinux: 2048 avtab hash slots, 94105 rules.
>06:27:51,479 DEBUG kernel:[   42.065259] SELinux:  9 users, 15 roles, 4245 types, 234 bools, 1 sens, 1024 cats
>06:27:51,479 DEBUG kernel:[   42.065265] SELinux:  83 classes, 94105 rules
>06:27:51,479 DEBUG kernel:[   42.387180] SELinux:  Completing initialization.
>06:27:51,479 DEBUG kernel:[   42.387189] SELinux:  Setting up existing superblocks.
>06:27:51,479 DEBUG kernel:[   42.387667] SELinux: initialized (dev sysfs, type sysfs), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   42.387907] SELinux: initialized (dev rootfs, type rootfs), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   42.388149] SELinux: initialized (dev bdev, type bdev), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   42.388258] SELinux: initialized (dev proc, type proc), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   42.389012] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>06:27:51,479 DEBUG kernel:[   42.389248] SELinux: initialized (dev devtmpfs, type devtmpfs), uses transition SIDs
>06:27:51,479 DEBUG kernel:[   42.468593] SELinux: initialized (dev sockfs, type sockfs), uses task SIDs
>06:27:51,479 DEBUG kernel:[   42.468734] SELinux: initialized (dev debugfs, type debugfs), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   42.908895] SELinux: initialized (dev pipefs, type pipefs), uses task SIDs
>06:27:51,479 DEBUG kernel:[   42.924481] SELinux: initialized (dev anon_inodefs, type anon_inodefs), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   42.924620] SELinux: initialized (dev devpts, type devpts), uses transition SIDs
>06:27:51,479 DEBUG kernel:[   42.944716] SELinux: initialized (dev hugetlbfs, type hugetlbfs), uses transition SIDs
>06:27:51,479 DEBUG kernel:[   42.946816] SELinux: initialized (dev mqueue, type mqueue), uses transition SIDs
>06:27:51,479 DEBUG kernel:[   42.946939] SELinux: initialized (dev selinuxfs, type selinuxfs), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   42.952714] SELinux: initialized (dev sysfs, type sysfs), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   42.991852] SELinux: initialized (dev securityfs, type securityfs), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   42.991900] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>06:27:51,479 DEBUG kernel:[   42.991974] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>06:27:51,479 DEBUG kernel:[   42.992726] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>06:27:51,479 DEBUG kernel:[   42.992928] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   42.992987] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   42.993088] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   43.000178] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   43.000383] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   43.000430] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   43.000462] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   43.000497] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   43.000639] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   43.000789] SELinux: initialized (dev rpc_pipefs, type rpc_pipefs), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   43.002471] SELinux: initialized (dev loop0, type squashfs), uses xattr
>06:27:51,479 DEBUG kernel:[   43.003295] SELinux: initialized (dev dm-0, type ext4), uses xattr
>06:27:51,479 NOTICE kernel:[   43.069982] type=1403 audit(1349072863.823:2): policy loaded auid=4294967295 ses=4294967295
>06:27:51,479 DEBUG kernel:[   45.100214] SELinux: initialized (dev autofs, type autofs), uses genfs_contexts
>06:27:51,479 DEBUG kernel:[   46.146255] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>06:27:51,479 DEBUG kernel:[   46.721967] SELinux: initialized (dev hugetlbfs, type hugetlbfs), uses transition SIDs
>06:27:51,479 NOTICE kernel:[   47.681536] type=1400 audit(1349072868.435:3): avc:  denied  { create } for  pid=579 comm="systemd-tmpfile" name="tmp" scontext=system_u:system_r:systemd_tmpfiles_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir
>06:27:51,479 NOTICE kernel:[   47.682073] type=1400 audit(1349072868.435:4): avc:  denied  { setattr } for  pid=579 comm="systemd-tmpfile" name="tmp" dev="dm-0" ino=43414 scontext=system_u:system_r:systemd_tmpfiles_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir
>06:27:51,479 NOTICE kernel:[   47.692978] type=1400 audit(1349072868.446:5): avc:  denied  { relabelfrom } for  pid=579 comm="systemd-tmpfile" name="tmp" dev="dm-0" ino=43414 scontext=system_u:system_r:systemd_tmpfiles_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir
>06:27:51,479 DEBUG kernel:[   47.834092] SELinux: initialized (dev configfs, type configfs), uses genfs_contexts
>06:27:51,479 NOTICE kernel:[   50.462776] type=1400 audit(1349072871.216:6): avc:  denied  { read } for  pid=609 comm="bash" name=".profile" dev="dm-0" ino=43404 scontext=system_u:system_r:getty_t:s0 tcontext=system_u:object_r:admin_home_t:s0 tclass=file
>06:27:51,479 NOTICE kernel:[   50.487753] type=1400 audit(1349072871.216:7): avc:  denied  { open } for  pid=609 comm="bash" path="/root/.profile" dev="dm-0" ino=43404 scontext=system_u:system_r:getty_t:s0 tcontext=system_u:object_r:admin_home_t:s0 tclass=file
>06:27:51,479 NOTICE kernel:[   50.666285] type=1400 audit(1349072871.420:8): avc:  denied  { read } for  pid=609 comm="bash" name="linux" dev="dm-0" ino=42967 scontext=system_u:system_r:getty_t:s0 tcontext=system_u:object_r:usr_t:s0 tclass=file
>06:27:51,479 NOTICE kernel:[   50.667016] type=1400 audit(1349072871.420:9): avc:  denied  { open } for  pid=609 comm="bash" path="/usr/share/terminfo/l/linux" dev="dm-0" ino=42967 scontext=system_u:system_r:getty_t:s0 tcontext=system_u:object_r:usr_t:s0 tclass=file
>06:27:51,479 NOTICE kernel:[   50.669394] type=1400 audit(1349072871.423:10): avc:  denied  { getattr } for  pid=609 comm="bash" path="/usr/share/terminfo/l/linux" dev="dm-0" ino=42967 scontext=system_u:system_r:getty_t:s0 tcontext=system_u:object_r:usr_t:s0 tclass=file
>06:27:51,664 ERR systemd-udevd: ctx=0x7f696ff679c0 path=/lib/modules/3.6.0-0.rc6.git0.2.fc18.x86_64/kernel/sound/pci/hda/snd-hda-codec.ko error=No such file or directory
>06:27:51,741 ERR systemd-udevd: ctx=0x7f696ff679c0 path=/lib/modules/3.6.0-0.rc6.git0.2.fc18.x86_64/kernel/sound/pci/hda/snd-hda-codec.ko error=No such file or directory
>06:27:51,784 ERR systemd-udevd: ctx=0x7f696ff679c0 path=/lib/modules/3.6.0-0.rc6.git0.2.fc18.x86_64/kernel/sound/core/snd-pcm.ko error=No such file or directory
>06:27:51,868 INFO NetworkManager: <info> NetworkManager (version 0.9.7.0-1.git20120820.fc18) is starting...
>06:27:51,895 INFO NetworkManager: <info> Read config file /etc/NetworkManager/NetworkManager.conf
>06:27:51,926 INFO NetworkManager: <info> WEXT support is enabled
>06:27:52,705 INFO dbus-daemon: dbus[620]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service'
>06:27:52,717 NOTICE dbus: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service'
>06:27:53,153 INFO polkitd: Started polkitd version 0.107
>06:27:53,377 INFO kernel:[   52.621546] microcode: CPU0 sig=0x623, pf=0x0, revision=0x1
>06:27:53,582 NOTICE dbus: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
>06:27:53,596 INFO dbus-daemon: dbus[620]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
>06:27:53,644 WARNING NetworkManager:    ifcfg-rh: Could not get hostname: failed to read /etc/sysconfig/network
>06:27:53,665 NOTICE NetworkManager:    ifcfg-rh: Acquired D-Bus service com.redhat.ifcfgrh1
>06:27:53,668 INFO NetworkManager: <info> Loaded plugin ifcfg-rh: (c) 2007 - 2010 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
>06:27:53,670 INFO NetworkManager: <info> Loaded plugin keyfile: (c) 2007 - 2010 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
>06:27:53,672 NOTICE NetworkManager:    ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-lo ...
>06:27:53,677 NOTICE NetworkManager:    ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-eth0 ...
>06:27:53,688 NOTICE NetworkManager:    ifcfg-rh:     read connection 'Boot Disk'
>06:27:53,719 INFO NetworkManager: <info> trying to start the modem manager...
>06:27:53,783 NOTICE dbus: [system] Activating service name='org.freedesktop.ModemManager' (using servicehelper)
>06:27:53,844 INFO NetworkManager: <info> monitoring kernel firmware directory '/lib/firmware'.
>06:27:53,853 INFO NetworkManager: <info> WiFi enabled by radio killswitch; enabled by state file
>06:27:53,885 INFO NetworkManager: <info> WWAN enabled by radio killswitch; enabled by state file
>06:27:53,917 INFO NetworkManager: <info> WiMAX enabled by radio killswitch; enabled by state file
>06:27:53,931 INFO NetworkManager: <info> Networking is enabled by state file
>06:27:54,012 WARNING NetworkManager: <warn> failed to allocate link cache: (-10) Operation not supported
>06:27:54,031 INFO dbus-daemon: dbus[620]: [system] Activating service name='org.freedesktop.ModemManager' (using servicehelper)
>06:27:54,113 INFO NetworkManager: <info> (eth0): carrier is ON
>06:27:54,119 INFO dbus-daemon: modem-manager[634]: <info>  ModemManager (version 0.6.0.0-1.fc18) starting...
>06:27:54,128 INFO modem-manager: <info>  ModemManager (version 0.6.0.0-1.fc18) starting...
>06:27:54,139 ERR NetworkManager: <error> [1349072874.125879] [nm-device-ethernet.c:456] real_update_permanent_hw_address(): (eth0): unable to read permanent MAC address (error 0)
>06:27:54,156 INFO NetworkManager: <info> (eth0): new Ethernet device (driver: 'virtio_net' ifindex: 2)
>06:27:54,170 INFO NetworkManager: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/0
>06:27:54,200 INFO NetworkManager: <info> (eth0): now managed
>06:27:54,258 INFO NetworkManager: <info> (eth0): device state change: unmanaged -> unavailable (reason 'connection-assumed') [10 20 41]
>06:27:54,314 INFO NetworkManager: <info> (eth0): preparing device.
>06:27:54,329 INFO NetworkManager: <info> Activation (eth0) starting connection 'Boot Disk'
>06:27:54,361 INFO NetworkManager: <info> (eth0): device state change: unavailable -> ip-config (reason 'none') [20 70 0]
>06:27:54,381 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
>06:27:54,434 WARNING NetworkManager: <warn> /sys/devices/virtual/net/lo: couldn't determine device driver; ignoring...
>06:27:54,467 NOTICE dbus: [system] Successfully activated service 'org.freedesktop.ModemManager'
>06:27:54,487 WARNING NetworkManager: <warn> /sys/devices/virtual/net/lo: couldn't determine device driver; ignoring...
>06:27:54,511 INFO NetworkManager: <info> modem-manager is now available
>06:27:54,550 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
>06:27:54,586 INFO NetworkManager: <info> Activation (eth0) Beginning DHCPv4 transaction (timeout in 45 seconds)
>06:27:54,603 INFO NetworkManager: <info> dhclient started with pid 639
>06:27:54,622 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
>06:27:54,653 INFO dbus-daemon: dbus[620]: [system] Successfully activated service 'org.freedesktop.ModemManager'
>06:27:54,726 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'ZTE'
>06:27:54,728 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'X22X'
>06:27:54,744 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'AnyData'
>06:27:54,773 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Longcheer'
>06:27:54,815 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Huawei'
>06:27:54,865 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Ericsson MBM'
>06:27:54,918 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Nokia'
>06:27:54,977 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Wavecom'
>06:27:55,003 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'SimTech'
>06:27:55,025 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Option'
>06:27:55,076 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Gobi'
>06:27:55,129 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Samsung'
>06:27:55,204 INFO modem-manager: <info>  Loaded plugin 'ZTE'
>06:27:55,230 INFO modem-manager: <info>  Loaded plugin 'X22X'
>06:27:55,263 INFO modem-manager: <info>  Loaded plugin 'AnyData'
>06:27:55,314 INFO modem-manager: <info>  Loaded plugin 'Longcheer'
>06:27:55,337 INFO modem-manager: <info>  Loaded plugin 'Huawei'
>06:27:55,357 INFO modem-manager: <info>  Loaded plugin 'Ericsson MBM'
>06:27:55,368 INFO modem-manager: <info>  Loaded plugin 'Nokia'
>06:27:55,383 INFO modem-manager: <info>  Loaded plugin 'Wavecom'
>06:27:55,392 INFO modem-manager: <info>  Loaded plugin 'SimTech'
>06:27:55,415 INFO modem-manager: <info>  Loaded plugin 'Option'
>06:27:55,418 INFO modem-manager: <info>  Loaded plugin 'Gobi'
>06:27:55,444 INFO modem-manager: <info>  Loaded plugin 'Samsung'
>06:27:55,463 INFO modem-manager: <info>  Loaded plugin 'Novatel'
>06:27:55,518 INFO modem-manager: <info>  Loaded plugin 'Linktop'
>06:27:55,530 INFO modem-manager: <info>  Loaded plugin 'Option High-Speed'
>06:27:55,543 INFO modem-manager: <info>  Loaded plugin 'MotoC'
>06:27:55,590 INFO modem-manager: <info>  Loaded plugin 'Sierra'
>06:27:55,593 INFO modem-manager: <info>  Loaded plugin 'Cinterion'
>06:27:55,621 INFO modem-manager: <info>  Loaded plugin 'Iridium'
>06:27:55,638 INFO modem-manager: <info>  Loaded plugin 'Generic'
>06:27:55,692 INFO modem-manager: <info>  Successfully loaded 20 plugins
>06:27:55,701 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Novatel'
>06:27:55,736 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Linktop'
>06:27:55,755 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Option High-Speed'
>06:27:55,784 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'MotoC'
>06:27:55,830 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Sierra'
>06:27:55,842 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Cinterion'
>06:27:55,854 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Iridium'
>06:27:55,874 INFO dbus-daemon: modem-manager[634]: <info>  Loaded plugin 'Generic'
>06:27:55,888 INFO dbus-daemon: modem-manager[634]: <info>  Successfully loaded 20 plugins
>06:27:55,948 INFO systemd: Startup finished in 4s 873ms 600us (kernel) + 38s 637ms 994us (initrd) + 10s 909ms 328us (userspace) = 54s 420ms 922us.
>06:27:56,111 INFO dhclient: Internet Systems Consortium DHCP Client 4.2.4-P2
>06:27:56,120 INFO dhclient: Copyright 2004-2012 Internet Systems Consortium.
>06:27:56,122 INFO dhclient: All rights reserved.
>06:27:56,130 INFO dhclient: For info, please visit https://www.isc.org/software/dhcp/
>06:27:56,139 INFO dhclient:
>06:27:56,284 INFO NetworkManager: <info> (eth0): DHCPv4 state changed nbi -> preinit
>06:27:56,292 INFO dhclient: Listening on LPF/eth0/52:54:00:47:65:06
>06:27:56,307 INFO dhclient: Sending on   LPF/eth0/52:54:00:47:65:06
>06:27:56,314 INFO dhclient: Sending on   Socket/fallback
>06:27:56,330 INFO dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67 (xid=0xdd34afc)
>06:27:56,459 INFO dhclient: DHCPACK from 192.168.122.1 (xid=0xdd34afc)
>06:27:56,500 INFO NetworkManager: <info> (eth0): DHCPv4 state changed preinit -> reboot
>06:27:56,525 INFO NetworkManager: <info>   address 192.168.122.141
>06:27:56,531 INFO NetworkManager: <info>   prefix 24 (255.255.255.0)
>06:27:56,535 INFO NetworkManager: <info>   gateway 192.168.122.1
>06:27:56,565 INFO NetworkManager: <info>   nameserver '192.168.122.1'
>06:27:56,583 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
>06:27:56,610 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Commit) started...
>06:27:56,618 INFO NetworkManager: <info> (eth0): device state change: ip-config -> activated (reason 'none') [70 100 0]
>06:27:56,707 INFO dhclient: bound to 192.168.122.141 -- renewal in 1530 seconds.
>06:27:56,731 INFO NetworkManager: <info> Policy set 'Boot Disk' (eth0) as default for IPv4 routing and DNS.
>06:27:56,741 INFO NetworkManager: <info> Activation (eth0) successful, device activated.
>06:27:56,751 INFO dbus-daemon: dbus[620]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
>06:27:56,761 NOTICE dbus: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
>06:27:56,774 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Commit) complete.
>06:27:56,920 WARNING NetworkManager: <warn> /sys/devices/virtual/net/lo: couldn't determine device driver; ignoring...
>06:27:56,933 INFO dbus-daemon: dbus[620]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
>06:27:56,952 NOTICE dbus: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
>06:27:57,037 INFO kernel:[   56.265266] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0xb100, revision 0
>06:27:57,607 INFO dbus-daemon: /etc/NetworkManager/dispatcher.d/04-iscsi: line 14: /sbin/chkconfig: No such file or directory
>06:27:57,904 INFO dbus-daemon: Failed to issue method call: Unit chronyd.service is not loaded.
>06:27:58,549 INFO kernel:[   57.793776] microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
>06:28:01,677 NOTICE kernel:[   60.920723] type=1400 audit(1349072881.674:11): avc:  denied  { read write } for  pid=683 comm="auditd" path="/dev/mapper/control" dev="devtmpfs" ino=7348 scontext=system_u:system_r:auditd_t:s0 tcontext=system_u:object_r:lvm_control_t:s0 tclass=chr_file
>06:28:01,697 WARNING kernel:[   60.941682] auditd (684): /proc/684/oom_adj is deprecated, please use /proc/684/oom_score_adj instead.
>06:28:11,603 INFO chrony-helper: tr: write error: Broken pipe
>06:28:11,617 INFO chrony-helper: tr: write error
>06:28:11,690 INFO chronyd: chronyd version 1.27-git1ca844 starting
>06:28:11,718 INFO chronyd: Linux kernel major=3 minor=6 patch=0
>06:28:11,721 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
>06:32:42,935 INFO kernel:[  343.479103] Btrfs loaded
>06:32:43,802 INFO kernel:[  344.345373] SGI XFS with ACLs, security attributes, large block/inode numbers, no debug enabled
>06:34:54,928 INFO kernel:[  475.434979] Adding 2031612k swap on /dev/vda2.  Priority:-1 extents:1 across:2031612k 
>06:34:55,644 INFO kernel:[  476.179020] EXT4-fs (vda3): mounted filesystem with ordered data mode. Opts: (null)
>06:34:55,663 DEBUG kernel:[  476.189451] SELinux: initialized (dev vda3, type ext4), uses xattr
>06:34:56,062 INFO kernel:[  476.602555] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null)
>06:34:56,062 DEBUG kernel:[  476.602593] SELinux: initialized (dev vda1, type ext4), uses xattr
>06:34:56,682 DEBUG kernel:[  477.161041] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>06:36:21,404 WARNING kernel:[  561.932433] anaconda (951) used greatest stack depth: 2768 bytes left

Actions: View

Attachments on bug 861847: 619624 | 619625 | 619626 | 619627 | 619628 | 619629 | 619630 | 619631 | 619632 | 619633 | 619634 | 619635 | 619636