Attachment 825282 Details for Bug 1031424 – File: anaconda-tb

File: anaconda-tb

anaconda-tb (text/plain), 162.83 KB, created by Martin Kletzander on 2013-11-17 18:52:24 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Martin Kletzander

Created: 2013-11-17 18:52:24 UTC

Size: 162.83 KB

patch

obsolete

>anaconda 21.6-1 exception report
>Traceback (most recent call first):
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py", line 652, in _configureBaseRepo
>    self._yum.preconf.releasever = self._getReleaseVersion(url)
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py", line 140, in inner_method
>    return method(yum_payload, *args, **kwargs)
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py", line 530, in updateBaseRepo
>    self._configureBaseRepo(self.storage, checkmount=checkmount)
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py", line 140, in inner_method
>    return method(yum_payload, *args, **kwargs)
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/ui/tui/spokes/source.py", line 191, in getRepoMetadata
>    self.payload.updateBaseRepo(fallback=False, checkmount=False)
>  File "/usr/lib64/python2.7/threading.py", line 764, in run
>    self.__target(*self.__args, **self.__kwargs)
>  File "/usr/lib64/python2.7/site-packages/pyanaconda/threads.py", line 168, in run
>    threading.Thread.run(self, *args, **kwargs)
>AttributeError: 'YumBase' object has no attribute 'preconf'
>
>Local variables in innermost frame:
>sslverify: True
>url: http://mirror.hosting90.cz/fedora/linux/development/rawhide/x86_64/os/
>self: <pyanaconda.packaging.yumpayload.YumPayload object at 0x7f4f768f8450>
>storage: <blivet.Blivet object at 0x7f4f76adaa10>
>checkmount: False
>mirrorlist: None
>method: 
>
>
>Anaconda instance, containing members:
>_instClass: DefaultInstall instance, containing members:
>_intf: TextUserInterface instance, containing members:
>  _intf.instclass: Already dumped (DefaultInstall instance)
>  _intf.productTitle: Anaconda
>  _intf._meh_interface: TextIntf instance, containing members:
>    _intf._meh_interface._io: IOHandler instance, containing members:
>      _intf._meh_interface._io.out_func: <built-in function print>
>      _intf._meh_interface._io.in_func: <bound method App.raw_input of <pyanaconda.ui.tui.simpleline.base.App object at 0x7f4f72c8e850>>
>    _intf._meh_interface.screen: None
>  _intf.isFinal: True
>  _intf.storage: Blivet 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._defaultFSType: ext4
>    _intf.storage.autoPartEscrowCert: None
>    _intf.storage.iscsi: iscsi instance, containing members:
>      _intf.storage.iscsi.initiatorSet: False
>      _intf.storage.iscsi.ifaces: {}
>      _intf.storage.iscsi.started: False
>      _intf.storage.iscsi._initiator: Skipped
>      _intf.storage.iscsi.discovered_targets: {}
>      _intf.storage.iscsi.ibftNodes: []
>    _intf.storage.escrowCertificates: {}
>    _intf.storage.fsset: FSSet instance, containing members:
>      _intf.storage.fsset.origFStab: None
>      _intf.storage.fsset._fstab_swaps: set([])
>      _intf.storage.fsset._usb: None
>      _intf.storage.fsset.devicetree: DeviceTree instance, containing members:
>        _intf.storage.fsset.devicetree.dasd: Already dumped (DASD instance)
>        _intf.storage.fsset.devicetree.populated: True
>        _intf.storage.fsset.devicetree.exclusiveDisks: []
>        _intf.storage.fsset.devicetree._actions: []
>        _intf.storage.fsset.devicetree.iscsi: Already dumped (iscsi instance)
>        _intf.storage.fsset.devicetree._cleanup: False
>        _intf.storage.fsset.devicetree._devices: [OpticalDevice instance, containing members:
>          major: 11
>          _partedDevice: parted.Device instance --
>  model: QEMU QEMU DVD-ROM  path: /dev/sr0  type: 1
>  sectorSize: 2048  physicalSectorSize:  2048
>  length: 168960  openCount: 0  readOnly: True
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: True
>  hardwareGeometry: (10, 255, 63)  biosGeometry: (10, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f4f7684a680>
>          exists: True
>          _size: 330.0
>          id: 0
>          controllable: True
>          uuid: None
>          _format: Iso9660FS instance, containing members:
>            _format.uuid: 2013-11-16-13-57-11-00
>            _format.exists: True
>            _format._mountpoint: None
>            _format._majorminor: None
>            _format._minInstanceSize: None
>            _format._mountType: iso9660
>            _format.fsprofile: None
>            _format.label: Fedora_rawhide_x86_64
>            _format._targetSize: 0.0
>            _format._size: 0.0
>            _format.mountopts: None
>            _format.mountpoint: None
>            _format._device: /dev/sr0
>          parents: []
>          deviceLinks: [/dev/cdrom, /dev/disk/by-id/ata-QEMU_DVD-ROM_QM00001, /dev/disk/by-label/Fedora\x20rawhide\x20x86_64, /dev/disk/by-uuid/2013-11-16-13-57-11-00]
>          minor: 0
>          fstabComment: Skipped
>          bus: Skipped
>          sysfsPath: /devices/pci0000:00/0000:00:01.1/ata1/host0/target0:0:0/0:0:0:0/block/sr0
>          _targetSize: 0
>          _model: QEMU_DVD-ROM
>          kids: 0
>          _vendor: None
>          _name: sr0
>          protected: True
>          originalFormat: Iso9660FS instance, containing members:
>            originalFormat.uuid: 2013-11-16-13-57-11-00
>            originalFormat.exists: True
>            originalFormat._mountpoint: None
>            originalFormat.mountpoint: None
>            originalFormat._majorminor: None
>            originalFormat.fsprofile: None
>            originalFormat.label: Fedora_rawhide_x86_64
>            originalFormat._targetSize: 0.0
>            originalFormat._minInstanceSize: None
>            originalFormat.mountopts: None
>            originalFormat._size: 0.0
>            originalFormat._device: /dev/sr0
>          _serial: None
>, existing 15360MB disk vda (1)
>, FileDevice instance, containing members:
>          major: 0
>          _partedDevice: None
>          exists: True
>          _size: 0
>          id: 2
>          controllable: False
>          uuid: None
>          _format: existing None
>          parents: []
>          deviceLinks: []
>          minor: 0
>          fstabComment: Skipped
>          bus: Skipped
>          sysfsPath: Skipped
>          _targetSize: 0
>          _model: Skipped
>          kids: 1
>          _vendor: Skipped
>          _name: /run/install/repo/LiveOS/squashfs.img
>          protected: False
>          originalFormat: existing None
>          _serial: None
>, LoopDevice instance, containing members:
>          major: 0
>          _partedDevice: None
>          exists: True
>          _size: 0
>          id: 3
>          controllable: False
>          uuid: None
>          _format: existing squashfs
>          parents: [Already dumped (FileDevice instance)
>]
>          deviceLinks: []
>          minor: 0
>          fstabComment: Skipped
>          bus: Skipped
>          sysfsPath: Skipped
>          _targetSize: 0
>          _model: Skipped
>          kids: 0
>          _vendor: Skipped
>          _name: loop0
>          protected: False
>          originalFormat: existing squashfs
>          _serial: None
>, FileDevice instance, containing members:
>          major: 0
>          _partedDevice: None
>          exists: True
>          _size: 0
>          id: 4
>          controllable: False
>          uuid: None
>          _format: existing None
>          parents: []
>          deviceLinks: []
>          minor: 0
>          fstabComment: Skipped
>          bus: Skipped
>          sysfsPath: Skipped
>          _targetSize: 0
>          _model: Skipped
>          kids: 1
>          _vendor: Skipped
>          _name: /LiveOS/rootfs.img
>          protected: False
>          originalFormat: existing None
>          _serial: None
>, LoopDevice instance, containing members:
>          major: 0
>          _partedDevice: None
>          exists: True
>          _size: 0
>          id: 5
>          controllable: False
>          uuid: None
>          _format: Ext4FS instance, containing members:
>            _format.errors: False
>            _format.uuid: 9cf5c062-10a1-47b4-a178-3a39f1a1c08e
>            _format.exists: True
>            _format._mountpoint: None
>            _format._majorminor: None
>            _format._minInstanceSize: 0.0
>            _format._mountType: ext4
>            _format.fsprofile: None
>            _format.label: Anaconda
>            _format._targetSize: 2048.0
>            _format.dirty: False
>            _format._size: 2048.0
>            _format.mountopts: None
>            _format.mountpoint: None
>            _format._device: /dev/loop1
>          parents: [Already dumped (FileDevice instance)
>]
>          deviceLinks: [/dev/disk/by-label/Anaconda, /dev/disk/by-uuid/9cf5c062-10a1-47b4-a178-3a39f1a1c08e]
>          minor: 0
>          fstabComment: Skipped
>          bus: Skipped
>          sysfsPath: Skipped
>          _targetSize: 0
>          _model: Skipped
>          kids: 1
>          _vendor: Skipped
>          _name: loop1
>          protected: False
>          originalFormat: Ext4FS instance, containing members:
>            originalFormat.errors: False
>            originalFormat.uuid: 9cf5c062-10a1-47b4-a178-3a39f1a1c08e
>            originalFormat.exists: True
>            originalFormat._mountpoint: None
>            originalFormat.mountpoint: None
>            originalFormat._majorminor: None
>            originalFormat._mountType: ext4
>            originalFormat.fsprofile: None
>            originalFormat.label: Anaconda
>            originalFormat._targetSize: 2048.0
>            originalFormat.dirty: False
>            originalFormat._minInstanceSize: 0.0
>            originalFormat.mountopts: None
>            originalFormat._size: 2048.0
>            originalFormat._device: /dev/loop1
>          _serial: None
>, FileDevice instance, containing members:
>          major: 0
>          _partedDevice: None
>          exists: True
>          _size: 0
>          id: 6
>          controllable: False
>          uuid: None
>          _format: existing None
>          parents: []
>          deviceLinks: []
>          minor: 0
>          fstabComment: Skipped
>          bus: Skipped
>          sysfsPath: Skipped
>          _targetSize: 0
>          _model: Skipped
>          kids: 1
>          _vendor: Skipped
>          _name: /overlay (deleted)
>          protected: False
>          originalFormat: existing None
>          _serial: None
>, LoopDevice instance, containing members:
>          major: 0
>          _partedDevice: None
>          exists: True
>          _size: 0
>          id: 7
>          controllable: False
>          uuid: None
>          _format: existing DM_snapshot_cow
>          parents: [Already dumped (FileDevice instance)
>]
>          deviceLinks: []
>          minor: 0
>          fstabComment: Skipped
>          bus: Skipped
>          sysfsPath: Skipped
>          _targetSize: 0
>          _model: Skipped
>          kids: 1
>          _vendor: Skipped
>          _name: loop2
>          protected: False
>          originalFormat: existing DM_snapshot_cow
>          _serial: None
>, existing 2048MB dm live-rw (8) with existing ext4 filesystem
>, existing 2048MB dm live-base (9) with existing ext4 filesystem
>]
>        _intf.storage.fsset.devicetree.ignoredDisks: []
>        _intf.storage.fsset.devicetree._completed_actions: []
>        _intf.storage.fsset.devicetree.names: [sr0, vda, loop0, /run/install/repo/LiveOS/squashfs.img, loop1, /LiveOS/rootfs.img, loop2, /overlay (deleted), live-rw, live-base]
>        _intf.storage.fsset.devicetree.liveBackingDevice: None
>        _intf.storage.fsset.devicetree.protectedDevNames: [sr0]
>        _intf.storage.fsset.devicetree.unusedRaidMembers: []
>        _intf.storage.fsset.devicetree.diskImages: {}
>        _intf.storage.fsset.devicetree._hidden: []
>        _intf.storage.fsset.devicetree.protectedDevSpecs: [LABEL=Fedora_rawhide_x86_64]
>      _intf.storage.fsset.preserveLines: []
>      _intf.storage.fsset._run: None
>      _intf.storage.fsset._devshm: None
>      _intf.storage.fsset._dev: None
>      _intf.storage.fsset.blkidTab: None
>      _intf.storage.fsset._proc: None
>      _intf.storage.fsset.active: False
>      _intf.storage.fsset.cryptTab: None
>      _intf.storage.fsset._devpts: None
>      _intf.storage.fsset._sysfs: None
>      _intf.storage.fsset._selinux: None
>    _intf.storage.config: StorageDiscoveryConfig instance, containing members:
>      _intf.storage.config.clearPartType: None
>      _intf.storage.config.clearNonExistent: False
>      _intf.storage.config.ignoredDisks: []
>      _intf.storage.config.protectedDevSpecs: [LABEL=Fedora_rawhide_x86_64]
>      _intf.storage.config.ignoreDiskInteractive: False
>      _intf.storage.config.exclusiveDisks: []
>      _intf.storage.config.clearPartDevices: []
>      _intf.storage.config.zeroMbr: False
>      _intf.storage.config.diskImages: {}
>      _intf.storage.config.clearPartDisks: []
>      _intf.storage.config.mpathFriendlyNames: True
>      _intf.storage.config.initializeDisks: False
>    _intf.storage.size_sets: []
>    _intf.storage.autoPartType: 2
>    _intf.storage._bootloader: GRUB2 instance, containing members:
>      _intf.storage._bootloader._disk_order: []
>      _intf.storage._bootloader.console_options: Skipped
>      _intf.storage._bootloader.console: ttyS0
>      _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.disks: []
>      _intf.storage._bootloader.problems: []
>      _intf.storage._bootloader._update_only: False
>      _intf.storage._bootloader._default_image: None
>      _intf.storage._bootloader.stage2_device: None
>      _intf.storage._bootloader.encrypted_password: Skipped
>      _intf.storage._bootloader.errors: []
>      _intf.storage._bootloader.stage1_device: None
>      _intf.storage._bootloader._timeout: None
>      _intf.storage._bootloader.stage1_disk: None
>      _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._dumpFile: /tmp/storage.state
>    _intf.storage.ksdata: #version=DEVEL
># System authorization information
>auth --enableshadow --passalgo=sha512
>
># Use network installation
>url --url="http://mirror.hosting90.cz/fedora/linux/development/rawhide/x86_64/os/"
># Run the Setup Agent on first boot
>firstboot --enable
># System language
>lang en_US.UTF-8
>
># Network information
>network  --bootproto=dhcp --device=eth0 --onboot=off --ipv6=auto --activate
>network  --hostname=localhost.localdomain
># System timezone
>timezone Europe/Prague --isUtc
># System bootloader configuration
>bootloader --location=mbr
>autopart
>
>
>    _intf.storage.services: set([])
>    _intf.storage.encryptionPassphrase: None
>    _intf.storage.encryptionCipher: None
>    _intf.storage.doAutoPart: False
>    _intf.storage.encryptionRetrofit: False
>    _intf.storage._nextID: 0
>    _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 (0x7f4f72c59690) -- 
>  mountpoint = /  lv = True  singlePV = False  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024  maxSize = 51200  grow = True
>
>, PartSpec instance (0x7f4f72c59650) -- 
>  mountpoint = /home  lv = True  singlePV = False  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500  maxSize = None  grow = True
>
>, PartSpec instance (0x7f4f72c59710) -- 
>  mountpoint = /boot  lv = False  singlePV = False  thin = False  btrfs = False
>  weight = 2000  fstype = ext4  encrypted = False
>  size = 500  maxSize = None  grow = False
>
>, PartSpec instance (0x7f4f72c59750) -- 
>  mountpoint = None  lv = False  singlePV = False  thin = False  btrfs = False
>  weight = 5000  fstype = biosboot  encrypted = False
>  size = 1  maxSize = None  grow = False
>
>, PartSpec instance (0x7f4f72c59790) -- 
>  mountpoint = None  lv = True  singlePV = False  thin = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 0  maxSize = None  grow = False
>
>]
>    _intf.storage.autoPartAddBackupPassphrase: False
>    _intf.storage.encryptedAutoPart: False
>  _intf.quitMessage: None
>  _intf._app: App instance, containing members:
>    _intf._app.quit_message: Do you really want to quit?
>    _intf._app._screens: [(<pyanaconda.ui.tui.spokes.progress.ProgressSpoke object at 0x7f4f7686a590>, None, None), (<pyanaconda.ui.tui.hubs.summary.SummaryHub object at 0x7f4f72c8ec10>, None, None)]
>    _intf._app._handlers: {4: [(<function exception_msg_handler at 0x7f4f78271488>, None)], 5: [(<bound method TextUserInterface._handle_show_message of <pyanaconda.ui.tui.TextUserInterface object at 0x7f4f72c59590>>, None)]}
>    _intf._app._redraw: False
>    _intf._app._in_thread_counter: 17
>    _intf._app._width: 80
>    _intf._app._header: Anaconda
>    _intf._app.queue: Queue instance, containing members:
>      _intf._app.queue.unfinished_tasks: 17
>      _intf._app.queue.queue: deque([])
>      _intf._app.queue.maxsize: 0
>      _intf._app.queue.all_tasks_done: <Condition(<thread.lock object at 0x7f4f797aaf10>, 0)>
>      _intf._app.queue.mutex: <thread.lock object at 0x7f4f797aaf10>
>      _intf._app.queue.not_full: <Condition(<thread.lock object at 0x7f4f797aaf10>, 0)>
>      _intf._app.queue.not_empty: <Condition(<thread.lock object at 0x7f4f797aaf10>, 0)>
>    _intf._app._spacer: ================================================================================
>================================================================================
>    _intf._app.quit_question: <class 'pyanaconda.ui.tui.tuiobject.YesNoDialog'>
>  _intf.payload: YumPayload instance, containing members:
>    _intf.payload._br_cache_valid: True
>    _intf.payload._groups: None
>    _intf.payload._yum: Skipped
>    _intf.payload.install_device: None
>    _intf.payload._root_dir: /tmp/yum.root
>    _intf.payload._br_callbacks: []
>    _intf.payload._repos_dir: /etc/yum.repos.d,/etc/anaconda.repos.d,/tmp/updates/anaconda.repos.d,/tmp/product/anaconda.repos.d
>    _intf.payload._setup: True
>    _intf.payload._requiredPackages: []
>    _intf.payload._requiredGroups: []
>    _intf.payload.storage: Already dumped (Blivet instance)
>    _intf.payload.txID: None
>    _intf.payload._cached_base_repo: rawhide
>    _intf.payload.default_repos: [fedora, rawhide]
>    _intf.payload._createdInitrds: False
>    _intf.payload._packages: []
>    _intf.payload._space_required: 3 GB
>    _intf.payload._br_refresh_lock: <thread.lock object at 0x7f4f76b360d0>
>    _intf.payload.data: Already dumped (AnacondaKSHandler instance)
>    _intf.payload._kernelVersionList: []
>    _intf.payload._br_cache_valid_lock: <thread.lock object at 0x7f4f76b36070>
>updateSrc: None
>rootParts: None
>id: None
>rescue: False
>mediaDevice: None
>methodstr: None
>proxyPassword: None
>desktop: Desktop instance, containing members:
>  desktop._runlevel: 3
>  desktop.desktop: None
>canReIPL: False
>xdriver: None
>stage2: hd:LABEL=Fedora_rawhide_x86_64
>rescue_mount: True
>_bootloader: GRUB2 instance, containing members:
>  _bootloader._disk_order: []
>  _bootloader.console_options: Skipped
>  _bootloader.console: ttyS0
>  _bootloader.skip_bootloader: False
>  _bootloader.warnings: []
>  _bootloader.chain_images: []
>  _bootloader.stage2_is_preferred_stage1: False
>  _bootloader.disks: []
>  _bootloader.problems: []
>  _bootloader._update_only: False
>  _bootloader._default_image: None
>  _bootloader.stage2_device: None
>  _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: t
>ksdata: Already dumped (AnacondaKSHandler instance)
>proxyUsername: None
>extraModules: []
>mehConfig: Config instance, containing members:
>  mehConfig.programArch: x86_64
>  mehConfig.callbackDict: {'lsblk_output': (<function lsblk_callback at 0x7f4f72c7e410>, True), 'type': (<function <lambda> at 0x7f4f72c7e5f0>, True), 'nmcli_dev_list': (<function nmcli_dev_list_callback at 0x7f4f72c7e488>, True)}
>  mehConfig.attrSkipList: [_intf._actions, _intf._currentAction._xklwrapper, _intf._currentAction._spokes["KeyboardSpoke"]._xkl_wrapper, _intf._currentAction.language.translations, _intf._currentAction.language.locales, _intf._currentAction._spokes["PasswordSpoke"]._oldweak, _intf._currentAction._spokes["PasswordSpoke"]._password, _intf._currentAction._spokes["UserSpoke"]._password, _intf._currentAction._spokes["UserSpoke"]._oldweak, _intf.storage.bootloader.password, _intf.storage.data, _intf.storage.encryptionPassphrase, _bootloader.encrypted_password, _bootloader.password, payload._groups, payload._yum]
>  mehConfig.programVersion: 21.6-1
>  mehConfig.localSkipList: [passphrase, password, _oldweak, _password]
>  mehConfig.programName: anaconda
>  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, /proc/cmdline, /tmp/syslog]
>isHeadless: False
>reIPLMessage: None
>_storage: Already dumped (Blivet instance)
>dir: None
>opts: {'noipv6': False, 'noipv4': False, 'updateSrc': None, 'selinux': True, 'module': [], 'syslog': None, 'leavebootorder': False, 'images': [], 'dmraid': True, 'armPlatform': None, 'dnf': False, 'memcheck': True, 'iscsi': False, 'ksfile': None, 'dirinstall': False, 'kbdtype': None, 'runres': None, 'xdriver': None, 'display_mode': 't', 'stage2': 'hd:LABEL=Fedora_rawhide_x86_64', 'method': None, 'vncpassword': '', 'vnc': False, 'rescue': False, 'noverifyssl': False, 'autostep': False, 'geoloc': None, 'proxy': None, 'dlabel': False, 'vncconnect': None, 'mpathfriendlynames': True, 'lang': None, 'askmethod': False, 'liveinst': False, 'loglevel': None, 'isHeadless': False, 'eject': True, 'rescue_nomount': False, 'keymap': None, 'mpath': True, 'ibft': True, 'debug': False, 'extlinux': False, 'multiLib': False, 'nofb': None, 'targetArch': None}
>proxy: None
>
>Registered callbacks:
>
>
>/tmp/anaconda.log:
>18:45:08,181 INFO anaconda: /sbin/anaconda 21.6-1
>18:45:08,583 INFO anaconda: 1966080 kB (1920 MB) are available
>18:45:08,583 INFO anaconda: check_memory(): total:1920, needed:512, graphical:512
>18:45:08,621 INFO anaconda: anaconda called with cmdline = ['/sbin/anaconda']
>18:45:08,622 INFO anaconda: Default encoding = utf-8 
>18:45:09,145 INFO anaconda: Running Thread: AnaInputThread0 (139979258820352)
>18:46:45,848 INFO anaconda: Thread Done: AnaInputThread0 (139979258820352)
>18:46:45,849 INFO anaconda: Display mode = t
>18:46:45,851 INFO anaconda: 1966080 kB (1920 MB) are available
>18:46:45,851 INFO anaconda: check_memory(): total:1920, needed:512, graphical:512
>18:46:45,931 WARN anaconda: module import of __init__ failed: <type 'exceptions.AttributeError'>
>18:46:45,933 WARN anaconda: module import of __init__ failed: <type 'exceptions.AttributeError'>
>18:46:45,933 INFO anaconda: using only installclass _Fedora
>18:46:46,716 INFO anaconda: bootloader GRUB2 on X86 platform
>18:46:46,718 INFO anaconda: bootloader GRUB2 on X86 platform
>18:46:46,765 DEBUG anaconda: network: devices found ['eth0']
>18:46:47,206 DEBUG anaconda: network: dumping ifcfg file for default autoconnection on eth0
>18:46:47,313 DEBUG anaconda: network: setting autoconnect of eth0 to False
>18:46:47,314 DEBUG anaconda: network: missing ifcfgs created for devices ['eth0']
>18:46:47,344 DEBUG anaconda: updating hostname localhost.localdomain
>18:46:47,367 INFO anaconda: Running Thread: AnaStorageThread (139979258820352)
>18:46:47,391 INFO anaconda: Running Thread: AnaTimeInitThread (139979190777600)
>18:46:47,394 INFO anaconda: Running Thread: AnaWaitForConnectingNMThread (139979182384896)
>18:46:47,408 INFO anaconda: Running Thread: AnaPayloadThread (139979172939520)
>18:46:47,425 DEBUG anaconda: updating hostname localhost.localdomain
>18:46:47,436 INFO anaconda: got 0 NTP servers from DHCP
>18:46:47,436 INFO anaconda: Thread Done: AnaWaitForConnectingNMThread (139979182384896)
>18:46:47,446 INFO anaconda: Running Thread: AnaGeolocationRefreshThread (139979182384896)
>18:46:47,447 INFO anaconda: Starting geolocation lookup
>18:46:47,447 INFO anaconda: Geolocation provider: Fedora GeoIP
>18:46:47,457 DEBUG anaconda: Geoloc: URLError for Fedora GeoIP API lookup:
><urlopen error [Errno -2] Name or service not known>
>18:46:47,458 INFO anaconda: Geolocation lookup finished in 0.0 seconds
>18:46:47,458 INFO anaconda: no results from geolocation
>18:46:47,459 INFO anaconda: Thread Done: AnaGeolocationRefreshThread (139979182384896)
>18:46:47,873 INFO anaconda: Running Thread: AnaSourceWatcher (139979182384896)
>18:46:47,880 INFO anaconda: Running Thread: AnaSoftwareWatcher (139979160311552)
>18:46:47,889 INFO anaconda: Running Thread: AnaStorageWatcher (139979151918848)
>18:46:48,127 DEBUG anaconda: updating hostname localhost.localdomain
>18:46:48,187 INFO anaconda: Running Thread: AnaBaseRepoRefreshThread (139979143526144)
>18:46:48,207 INFO anaconda: Thread Done: AnaBaseRepoRefreshThread (139979143526144)
>18:46:48,315 INFO anaconda: Running Thread: AnaInputThread0 (139979143526144)
>18:46:49,190 INFO anaconda: Thread Done: AnaStorageThread (139979258820352)
>18:46:49,229 INFO anaconda: Thread Done: AnaStorageWatcher (139979151918848)
>18:46:49,005 INFO anaconda: Thread Done: AnaTimeInitThread (139979190777600)
>18:46:52,855 INFO anaconda: Thread Done: AnaInputThread0 (139979143526144)
>18:46:52,871 INFO anaconda: Running Thread: AnaInputThread1 (139979143526144)
>18:46:54,162 INFO anaconda: Thread Done: AnaInputThread1 (139979143526144)
>18:46:54,185 INFO anaconda: Running Thread: AnaInputThread2 (139979143526144)
>18:46:56,945 INFO anaconda: Thread Done: AnaInputThread2 (139979143526144)
>18:46:56,953 INFO anaconda: Running Thread: AnaBaseRepoRefreshThread (139979143526144)
>18:46:57,058 INFO anaconda: Running Thread: AnaInputThread3 (139979190777600)
>18:46:58,477 INFO anaconda: Thread Done: AnaInputThread3 (139979190777600)
>18:46:58,484 INFO anaconda: Running Thread: AnaInputThread4 (139979190777600)
>18:47:00,302 INFO anaconda: Thread Done: AnaBaseRepoRefreshThread (139979143526144)
>18:47:00,304 INFO anaconda: Thread Done: AnaPayloadThread (139979172939520)
>18:47:00,621 INFO anaconda: Thread Done: AnaSourceWatcher (139979182384896)
>18:47:03,045 INFO anaconda: Thread Done: AnaInputThread4 (139979190777600)
>18:47:03,059 INFO anaconda: Running Thread: AnaInputThread5 (139979190777600)
>18:47:04,628 INFO anaconda: Thread Done: AnaInputThread5 (139979190777600)
>18:47:04,632 INFO anaconda: Running Thread: AnaInputThread6 (139979190777600)
>18:47:10,036 INFO anaconda: Thread Done: AnaSoftwareWatcher (139979160311552)
>18:48:15,842 INFO anaconda: Thread Done: AnaInputThread6 (139979190777600)
>18:48:15,844 INFO anaconda: Running Thread: AnaInputThread7 (139979190777600)
>18:49:26,551 INFO anaconda: Thread Done: AnaInputThread7 (139979190777600)
>18:49:26,551 INFO anaconda: Running Thread: AnaInputThread8 (139979160311552)
>18:49:27,542 INFO anaconda: Thread Done: AnaInputThread8 (139979160311552)
>18:49:27,542 INFO anaconda: Running Thread: AnaInputThread9 (139979190777600)
>18:49:27,989 INFO anaconda: Thread Done: AnaInputThread9 (139979190777600)
>18:49:27,990 INFO anaconda: Running Thread: AnaInputThread10 (139979160311552)
>18:49:28,230 INFO anaconda: Thread Done: AnaInputThread10 (139979160311552)
>18:49:28,231 INFO anaconda: Running Thread: AnaInputThread11 (139979190777600)
>18:49:28,405 INFO anaconda: Thread Done: AnaInputThread11 (139979190777600)
>18:49:28,406 INFO anaconda: Running Thread: AnaInputThread12 (139979160311552)
>18:49:28,565 INFO anaconda: Thread Done: AnaInputThread12 (139979160311552)
>18:49:28,567 INFO anaconda: Running Thread: AnaInputThread13 (139979160311552)
>18:49:32,884 INFO anaconda: Thread Done: AnaInputThread13 (139979160311552)
>18:49:32,887 INFO anaconda: Running Thread: AnaInputThread14 (139979190777600)
>18:50:13,019 INFO anaconda: Thread Done: AnaInputThread14 (139979190777600)
>18:50:13,022 INFO anaconda: Running Thread: AnaInputThread15 (139979160311552)
>18:50:16,696 INFO anaconda: Thread Done: AnaInputThread15 (139979160311552)
>18:50:16,697 INFO anaconda: Running Thread: AnaPayloadMDThread (139979190777600)
>18:50:16,707 INFO anaconda: Running Thread: AnaBaseRepoRefreshThread (139979160311552)
>18:50:16,788 INFO anaconda: Thread Done: AnaBaseRepoRefreshThread (139979160311552)
>18:50:16,843 INFO anaconda: Running Thread: AnaInputThread16 (139979160311552)
>18:50:16,911 DEBUG anaconda: running handleException
>18:50:17,734 DEBUG anaconda: Gtk cannot be initialized
>18:50:17,735 DEBUG anaconda: In a non-main thread, sending a message with exception data
>18:50:17,735 INFO anaconda: Thread Done: AnaPayloadMDThread (139979190777600)
>18:50:17,735 DEBUG anaconda: running handleException
>18:50:17,736 DEBUG anaconda: Gtk cannot be initialized
>18:50:17,738 DEBUG anaconda: In the main thread, running exception handler
>
>
>/tmp/packaging.log:
>18:46:46,714 INFO packaging: about to acquire _yum_lock for MainThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:201 (reset)
>18:46:46,714 INFO packaging: have _yum_lock for MainThread
>18:46:46,715 DEBUG packaging: getting release version from tree at None (rawhide)
>18:46:46,716 DEBUG packaging: got a release version of rawhide
>18:46:46,716 INFO packaging: gave up _yum_lock for MainThread
>18:46:48,200 INFO packaging: about to acquire _yum_lock for AnaBaseRepoRefreshThread at /usr/lib64/python2.7/threading.py:764 (run)
>18:46:48,203 INFO packaging: have _yum_lock for AnaBaseRepoRefreshThread
>18:46:48,206 INFO packaging: gave up _yum_lock for AnaBaseRepoRefreshThread
>18:46:49,192 INFO packaging: updating base repo
>18:46:49,195 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:201 (reset)
>18:46:49,213 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,295 INFO_2 yum.verbose.YumPlugins: Loaded plugins: blacklist, fastestmirror, langpacks, whiteout
>18:46:49,296 INFO_2 yum.verbose.YumPlugins: No plugin match for: fastestmirror
>18:46:49,296 INFO_2 yum.verbose.YumPlugins: No plugin match for: langpacks
>18:46:49,297 DEBUG yum.verbose.plugin: Adding en_US to language list
>18:46:49,302 DEBUG yum.verbose.YumBase: Config time: 0.086
>18:46:49,018 DEBUG packaging: getting release version from tree at None (rawhide)
>18:46:49,018 DEBUG packaging: got a release version of rawhide
>18:46:49,018 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,018 INFO packaging: configuring base repo
>18:46:49,033 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,034 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,034 DEBUG packaging: getting release version from tree at file:///run/install/repo (rawhide)
>18:46:49,034 DEBUG packaging: retrieving treeinfo from file:///run/install/repo (proxy: None ; sslverify: True)
>18:46:49,035 INFO packaging: Error downloading treeinfo: [Errno 14] curl#37 - "Couldn't open file /run/install/repo/treeinfo"
>18:46:49,036 DEBUG packaging: got a release version of rawhide
>18:46:49,036 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,037 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:659 (_configureBaseRepo)
>18:46:49,037 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,044 INFO_2 yum.verbose.YumPlugins: Loaded plugins: blacklist, fastestmirror, langpacks, whiteout
>18:46:49,045 INFO_2 yum.verbose.YumPlugins: No plugin match for: fastestmirror
>18:46:49,045 INFO_2 yum.verbose.YumPlugins: No plugin match for: langpacks
>18:46:49,046 DEBUG yum.verbose.plugin: Adding en_US to language list
>18:46:49,049 DEBUG yum.verbose.YumBase: Config time: 0.012
>18:46:49,050 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,051 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,051 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,070 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,071 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:844 (_addYumRepo)
>18:46:49,071 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,071 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,072 DEBUG packaging: adding yum repo anaconda with baseurl file:///run/install/repo and mirrorlist None
>18:46:49,073 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,073 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,077 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,077 ERR packaging: base repo (cdrom/file:///run/install/repo) not valid -- removing it
>18:46:49,079 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:880 (_removeYumRepo)
>18:46:49,079 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,080 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,082 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,082 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,082 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,083 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:544 (updateBaseRepo)
>18:46:49,084 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,084 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,085 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,085 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,085 INFO packaging: using default repos from local yum configuration
>18:46:49,086 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:550 (updateBaseRepo)
>18:46:49,086 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,086 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,087 DEBUG packaging: enabling repo rawhide
>18:46:49,088 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:919 (enableRepo)
>18:46:49,088 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,088 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,089 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,089 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,089 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,090 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,091 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,091 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,092 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:880 (_removeYumRepo)
>18:46:49,092 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,092 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,093 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,093 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,094 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,094 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:591 (updateBaseRepo)
>18:46:49,095 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,095 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,095 DEBUG packaging: disabling repo fedora
>18:46:49,097 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:932 (disableRepo)
>18:46:49,098 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,098 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,099 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,099 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,099 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,101 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:880 (_removeYumRepo)
>18:46:49,101 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,101 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,102 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,102 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,102 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,103 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:880 (_removeYumRepo)
>18:46:49,104 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,104 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,105 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,105 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,105 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,106 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:591 (updateBaseRepo)
>18:46:49,106 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,106 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,107 DEBUG packaging: disabling repo updates-testing
>18:46:49,108 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:932 (disableRepo)
>18:46:49,108 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,108 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,109 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,109 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,110 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,111 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:880 (_removeYumRepo)
>18:46:49,111 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,111 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,113 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,113 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,114 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,115 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:880 (_removeYumRepo)
>18:46:49,116 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,116 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,117 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,117 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,117 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,118 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:591 (updateBaseRepo)
>18:46:49,118 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,118 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,119 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:880 (_removeYumRepo)
>18:46:49,120 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,120 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,121 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,121 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,121 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,122 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:880 (_removeYumRepo)
>18:46:49,122 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,123 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,124 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,124 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,124 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,125 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:880 (_removeYumRepo)
>18:46:49,125 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,126 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,127 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,127 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,127 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,128 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:591 (updateBaseRepo)
>18:46:49,128 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,128 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,128 DEBUG packaging: disabling repo updates
>18:46:49,130 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:932 (disableRepo)
>18:46:49,131 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,131 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,133 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,133 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,133 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,133 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,133 INFO packaging: gathering repo metadata
>18:46:49,134 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:605 (gatherRepoMetadata)
>18:46:49,135 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,135 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,136 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,136 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,136 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,137 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,137 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,137 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:46:49,138 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:46:49,138 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:49,138 DEBUG packaging: getting repo metadata for rawhide
>18:46:49,139 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:610 (gatherRepoMetadata)
>18:46:49,140 INFO packaging: have _yum_lock for AnaPayloadThread
>18:46:56,955 INFO packaging: about to acquire _yum_lock for AnaBaseRepoRefreshThread at /usr/lib64/python2.7/threading.py:764 (run)
>18:47:00,269 DEBUG packaging: getting group info for rawhide
>18:47:00,295 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:47:00,295 INFO packaging: have _yum_lock for AnaBaseRepoRefreshThread
>18:47:00,296 INFO packaging: about to acquire _yum_lock for AnaBaseRepoRefreshThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:452 (_refreshBaseRepo)
>18:47:00,297 INFO packaging: have _yum_lock for AnaBaseRepoRefreshThread
>18:47:00,297 INFO packaging: gave up _yum_lock for AnaBaseRepoRefreshThread
>18:47:00,298 INFO packaging: about to acquire _yum_lock for AnaBaseRepoRefreshThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:452 (_refreshBaseRepo)
>18:47:00,298 INFO packaging: have _yum_lock for AnaBaseRepoRefreshThread
>18:47:00,295 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:47:00,299 INFO packaging: gave up _yum_lock for AnaBaseRepoRefreshThread
>18:47:00,300 INFO packaging: about to acquire _yum_lock for AnaBaseRepoRefreshThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:452 (_refreshBaseRepo)
>18:47:00,301 INFO packaging: have _yum_lock for AnaBaseRepoRefreshThread
>18:47:00,301 INFO packaging: gave up _yum_lock for AnaBaseRepoRefreshThread
>18:47:00,302 INFO packaging: gave up _yum_lock for AnaBaseRepoRefreshThread
>18:47:00,303 INFO packaging: about to acquire _yum_lock for AnaPayloadThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:47:00,303 INFO packaging: have _yum_lock for AnaPayloadThread
>18:47:00,304 INFO packaging: gave up _yum_lock for AnaPayloadThread
>18:47:00,304 INFO packaging: metadata retrieval complete
>18:47:00,323 INFO packaging: about to acquire _yum_lock for AnaSoftwareWatcher at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:947 (environments)
>18:47:00,324 INFO packaging: have _yum_lock for AnaSoftwareWatcher
>18:47:00,324 DEBUG yum.verbose.YumBase: Setting up Package Sacks
>18:47:00,325 INFO_2 yum.verbose.plugin: Determining fastest mirrors
>18:47:04,051 INFO_2 yum.verbose.plugin:  * rawhide: mirrors.n-ix.net
>18:47:09,776 DEBUG yum.verbose.YumBase: rpmdb time: 0.000
>18:47:09,878 DEBUG yum.verbose.YumBase: pkgsack time: 9.554
>18:47:10,030 DEBUG yum.verbose.YumBase: group time: 9.706
>18:47:10,032 INFO packaging: gave up _yum_lock for AnaSoftwareWatcher
>18:47:10,033 INFO packaging: about to acquire _yum_lock for AnaSoftwareWatcher at /usr/lib64/python2.7/site-packages/pyanaconda/ui/tui/spokes/software.py:67 (_initialize)
>18:47:10,033 INFO packaging: have _yum_lock for AnaSoftwareWatcher
>18:47:10,033 INFO packaging: gave up _yum_lock for AnaSoftwareWatcher
>18:47:10,034 INFO packaging: about to acquire _yum_lock for AnaSoftwareWatcher at /usr/lib64/python2.7/site-packages/pyanaconda/ui/tui/spokes/software.py:71 (_initialize)
>18:47:10,034 INFO packaging: have _yum_lock for AnaSoftwareWatcher
>18:47:10,034 DEBUG packaging: deleting package sacks
>18:47:10,036 INFO packaging: gave up _yum_lock for AnaSoftwareWatcher
>18:50:16,698 INFO packaging: updating base repo
>18:50:16,709 INFO packaging: about to acquire _yum_lock for AnaPayloadMDThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:201 (reset)
>18:50:16,710 INFO packaging: have _yum_lock for AnaPayloadMDThread
>18:50:16,715 INFO packaging: about to acquire _yum_lock for AnaBaseRepoRefreshThread at /usr/lib64/python2.7/threading.py:764 (run)
>18:50:16,715 DEBUG packaging: getting release version from tree at None (rawhide)
>18:50:16,715 DEBUG packaging: got a release version of rawhide
>18:50:16,716 INFO packaging: gave up _yum_lock for AnaPayloadMDThread
>18:50:16,717 INFO packaging: configuring base repo
>18:50:16,718 INFO packaging: have _yum_lock for AnaBaseRepoRefreshThread
>18:50:16,720 INFO packaging: about to acquire _yum_lock for AnaPayloadMDThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:140 (inner_method)
>18:50:16,723 INFO packaging: about to acquire _yum_lock for AnaBaseRepoRefreshThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:452 (_refreshBaseRepo)
>18:50:16,725 INFO packaging: have _yum_lock for AnaBaseRepoRefreshThread
>18:50:16,737 INFO_2 yum.verbose.YumPlugins: Loaded plugins: blacklist, fastestmirror, langpacks, whiteout
>18:50:16,738 INFO_2 yum.verbose.YumPlugins: No plugin match for: fastestmirror
>18:50:16,739 INFO_2 yum.verbose.YumPlugins: No plugin match for: langpacks
>18:50:16,740 DEBUG yum.verbose.plugin: Adding en_US to language list
>18:50:16,744 DEBUG yum.verbose.YumBase: Config time: 0.018
>18:50:16,781 INFO packaging: gave up _yum_lock for AnaBaseRepoRefreshThread
>18:50:16,783 INFO packaging: about to acquire _yum_lock for AnaBaseRepoRefreshThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:452 (_refreshBaseRepo)
>18:50:16,784 INFO packaging: have _yum_lock for AnaBaseRepoRefreshThread
>18:50:16,784 INFO packaging: gave up _yum_lock for AnaBaseRepoRefreshThread
>18:50:16,786 INFO packaging: about to acquire _yum_lock for AnaBaseRepoRefreshThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:452 (_refreshBaseRepo)
>18:50:16,786 INFO packaging: have _yum_lock for AnaBaseRepoRefreshThread
>18:50:16,787 INFO packaging: gave up _yum_lock for AnaBaseRepoRefreshThread
>18:50:16,787 INFO packaging: gave up _yum_lock for AnaBaseRepoRefreshThread
>18:50:16,788 INFO packaging: have _yum_lock for AnaPayloadMDThread
>18:50:16,789 DEBUG packaging: getting release version from tree at http://mirror.hosting90.cz/fedora/linux/development/rawhide/x86_64/os/ (rawhide)
>18:50:16,789 DEBUG packaging: retrieving treeinfo from http://mirror.hosting90.cz/fedora/linux/development/rawhide/x86_64/os/ (proxy:  ; sslverify: True)
>18:50:16,909 DEBUG packaging: got a release version of rawhide
>18:50:16,910 INFO packaging: gave up _yum_lock for AnaPayloadMDThread
>18:50:16,911 INFO packaging: about to acquire _yum_lock for AnaPayloadMDThread at /usr/lib64/python2.7/site-packages/pyanaconda/packaging/yumpayload.py:544 (updateBaseRepo)
>18:50:16,911 INFO packaging: have _yum_lock for AnaPayloadMDThread
>18:50:16,911 INFO packaging: gave up _yum_lock for AnaPayloadMDThread
>
>
>/tmp/program.log:
>18:45:08,732 INFO program: Running... udevadm trigger --action=change --subsystem-match=block
>18:45:08,775 DEBUG program: Return code: 0
>18:45:08,777 INFO program: Running... udevadm settle --timeout=300
>18:45:08,883 DEBUG program: Return code: 0
>18:45:08,885 INFO program: Running... modprobe fcoe
>18:45:08,999 DEBUG program: Return code: 0
>18:45:09,001 INFO program: Running... /usr/libexec/fcoe/fcoe_edd.sh -i
>18:45:09,101 INFO program: No FCoE boot disk information is found in EDD!
>18:45:09,101 DEBUG program: Return code: 1
>18:46:47,371 INFO program: Running... mpathconf --user_friendly_names y --with_multipathd y
>18:46:47,576 DEBUG program: Return code: 0
>18:46:47,576 INFO program: Running... systemctl start chronyd.service
>18:46:47,726 DEBUG program: Return code: 0
>18:46:47,727 INFO program: Running... udevadm settle --timeout=300
>18:46:47,834 DEBUG program: Return code: 0
>18:46:47,848 INFO program: Running... udevadm settle --timeout=300
>18:46:47,959 DEBUG program: Return code: 0
>18:46:48,087 INFO program: Running... multipath -c /dev/vda
>18:46:48,141 DEBUG program: Return code: 1
>18:46:48,333 INFO program: Running... dumpe2fs -h /dev/loop1
>18:46:48,412 INFO program: dumpe2fs 1.42.8 (20-Jun-2013)
>18:46:48,413 INFO program: Filesystem volume name:   Anaconda
>18:46:48,413 INFO program: Last mounted on:          /
>18:46:48,413 INFO program: Filesystem UUID:          9cf5c062-10a1-47b4-a178-3a39f1a1c08e
>18:46:48,414 INFO program: Filesystem magic number:  0xEF53
>18:46:48,415 INFO program: Filesystem revision #:    1 (dynamic)
>18:46:48,415 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
>18:46:48,416 INFO program: Filesystem flags:         signed_directory_hash 
>18:46:48,417 INFO program: Default mount options:    user_xattr acl
>18:46:48,417 INFO program: Filesystem state:         clean
>18:46:48,417 INFO program: Errors behavior:          Continue
>18:46:48,418 INFO program: Filesystem OS type:       Linux
>18:46:48,418 INFO program: Inode count:              131072
>18:46:48,418 INFO program: Block count:              2097152
>18:46:48,419 INFO program: Reserved block count:     0
>18:46:48,419 INFO program: Free blocks:              1267420
>18:46:48,419 INFO program: Free inodes:              102095
>18:46:48,420 INFO program: First block:              1
>18:46:48,420 INFO program: Block size:               1024
>18:46:48,420 INFO program: Fragment size:            1024
>18:46:48,421 INFO program: Reserved GDT blocks:      256
>18:46:48,421 INFO program: Blocks per group:         8192
>18:46:48,421 INFO program: Fragments per group:      8192
>18:46:48,422 INFO program: Inodes per group:         512
>18:46:48,422 INFO program: Inode blocks per group:   128
>18:46:48,422 INFO program: Flex block group size:    16
>18:46:48,423 INFO program: Filesystem created:       Sat Nov 16 13:47:24 2013
>18:46:48,423 INFO program: Last mount time:          Sat Nov 16 13:48:49 2013
>18:46:48,424 INFO program: Last write time:          Sat Nov 16 13:48:59 2013
>18:46:48,424 INFO program: Mount count:              2
>18:46:48,424 INFO program: Maximum mount count:      -1
>18:46:48,424 INFO program: Last checked:             Sat Nov 16 13:47:24 2013
>18:46:48,425 INFO program: Check interval:           0 (<none>)
>18:46:48,425 INFO program: Lifetime writes:          32 MB
>18:46:48,425 INFO program: Reserved blocks uid:      0 (user root)
>18:46:48,426 INFO program: Reserved blocks gid:      0 (group root)
>18:46:48,426 INFO program: First inode:              11
>18:46:48,427 INFO program: Inode size:	          256
>18:46:48,427 INFO program: Required extra isize:     28
>18:46:48,427 INFO program: Desired extra isize:      28
>18:46:48,428 INFO program: Journal inode:            8
>18:46:48,428 INFO program: Default directory hash:   half_md4
>18:46:48,428 INFO program: Directory Hash Seed:      72e38a80-1f42-4c88-8757-ef5d1eaa570e
>18:46:48,429 INFO program: Journal backup:           inode blocks
>18:46:48,429 INFO program: Journal features:         (none)
>18:46:48,429 INFO program: Journal size:             32M
>18:46:48,430 INFO program: Journal length:           32768
>18:46:48,430 INFO program: Journal sequence:         0x00000015
>18:46:48,431 INFO program: Journal start:            0
>18:46:48,431 INFO program: 
>18:46:48,432 DEBUG program: Return code: 0
>18:46:48,433 INFO program: Running... resize2fs -P /dev/loop1
>18:46:48,483 INFO program: resize2fs 1.42.8 (20-Jun-2013)
>18:46:48,484 INFO program: resize2fs: Device or resource busy while trying to open /dev/loop1
>18:46:48,484 INFO program: Couldn't find valid filesystem superblock.
>18:46:48,484 DEBUG program: Return code: 1
>18:46:48,557 INFO program: Running... dumpe2fs -h /dev/mapper/live-rw
>18:46:48,594 INFO program: dumpe2fs 1.42.8 (20-Jun-2013)
>18:46:48,595 INFO program: Filesystem volume name:   Anaconda
>18:46:48,595 INFO program: Last mounted on:          /
>18:46:48,595 INFO program: Filesystem UUID:          9cf5c062-10a1-47b4-a178-3a39f1a1c08e
>18:46:48,596 INFO program: Filesystem magic number:  0xEF53
>18:46:48,596 INFO program: Filesystem revision #:    1 (dynamic)
>18:46:48,596 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
>18:46:48,597 INFO program: Filesystem flags:         signed_directory_hash 
>18:46:48,597 INFO program: Default mount options:    user_xattr acl
>18:46:48,597 INFO program: Filesystem state:         clean
>18:46:48,597 INFO program: Errors behavior:          Continue
>18:46:48,598 INFO program: Filesystem OS type:       Linux
>18:46:48,598 INFO program: Inode count:              131072
>18:46:48,598 INFO program: Block count:              2097152
>18:46:48,598 INFO program: Reserved block count:     0
>18:46:48,599 INFO program: Free blocks:              1267420
>18:46:48,599 INFO program: Free inodes:              102095
>18:46:48,600 INFO program: First block:              1
>18:46:48,600 INFO program: Block size:               1024
>18:46:48,600 INFO program: Fragment size:            1024
>18:46:48,600 INFO program: Reserved GDT blocks:      256
>18:46:48,601 INFO program: Blocks per group:         8192
>18:46:48,601 INFO program: Fragments per group:      8192
>18:46:48,601 INFO program: Inodes per group:         512
>18:46:48,601 INFO program: Inode blocks per group:   128
>18:46:48,601 INFO program: Flex block group size:    16
>18:46:48,602 INFO program: Filesystem created:       Sat Nov 16 13:47:24 2013
>18:46:48,602 INFO program: Last mount time:          Sun Nov 17 18:44:54 2013
>18:46:48,602 INFO program: Last write time:          Sun Nov 17 18:44:54 2013
>18:46:48,602 INFO program: Mount count:              3
>18:46:48,603 INFO program: Maximum mount count:      -1
>18:46:48,603 INFO program: Last checked:             Sat Nov 16 13:47:24 2013
>18:46:48,603 INFO program: Check interval:           0 (<none>)
>18:46:48,603 INFO program: Lifetime writes:          32 MB
>18:46:48,604 INFO program: Reserved blocks uid:      0 (user root)
>18:46:48,604 INFO program: Reserved blocks gid:      0 (group root)
>18:46:48,604 INFO program: First inode:              11
>18:46:48,604 INFO program: Inode size:	          256
>18:46:48,604 INFO program: Required extra isize:     28
>18:46:48,605 INFO program: Desired extra isize:      28
>18:46:48,605 INFO program: Journal inode:            8
>18:46:48,605 INFO program: Default directory hash:   half_md4
>18:46:48,606 INFO program: Directory Hash Seed:      72e38a80-1f42-4c88-8757-ef5d1eaa570e
>18:46:48,606 INFO program: Journal backup:           inode blocks
>18:46:48,606 INFO program: Journal features:         (none)
>18:46:48,606 INFO program: Journal size:             32M
>18:46:48,606 INFO program: Journal length:           32768
>18:46:48,607 INFO program: Journal sequence:         0x00000016
>18:46:48,607 INFO program: Journal start:            1
>18:46:48,607 INFO program: 
>18:46:48,607 DEBUG program: Return code: 0
>18:46:48,608 INFO program: Running... resize2fs -P /dev/mapper/live-rw
>18:46:48,645 INFO program: resize2fs 1.42.8 (20-Jun-2013)
>18:46:48,645 INFO program: Estimated minimum size of the filesystem: 814054
>18:46:48,645 DEBUG program: Return code: 0
>18:46:48,795 INFO program: Running... dumpe2fs -h /dev/mapper/live-base
>18:46:48,835 INFO program: dumpe2fs 1.42.8 (20-Jun-2013)
>18:46:48,835 INFO program: Filesystem volume name:   Anaconda
>18:46:48,836 INFO program: Last mounted on:          /
>18:46:48,836 INFO program: Filesystem UUID:          9cf5c062-10a1-47b4-a178-3a39f1a1c08e
>18:46:48,836 INFO program: Filesystem magic number:  0xEF53
>18:46:48,836 INFO program: Filesystem revision #:    1 (dynamic)
>18:46:48,837 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
>18:46:48,837 INFO program: Filesystem flags:         signed_directory_hash 
>18:46:48,837 INFO program: Default mount options:    user_xattr acl
>18:46:48,838 INFO program: Filesystem state:         clean
>18:46:48,838 INFO program: Errors behavior:          Continue
>18:46:48,838 INFO program: Filesystem OS type:       Linux
>18:46:48,838 INFO program: Inode count:              131072
>18:46:48,838 INFO program: Block count:              2097152
>18:46:48,839 INFO program: Reserved block count:     0
>18:46:48,839 INFO program: Free blocks:              1267420
>18:46:48,839 INFO program: Free inodes:              102095
>18:46:48,839 INFO program: First block:              1
>18:46:48,840 INFO program: Block size:               1024
>18:46:48,840 INFO program: Fragment size:            1024
>18:46:48,840 INFO program: Reserved GDT blocks:      256
>18:46:48,840 INFO program: Blocks per group:         8192
>18:46:48,841 INFO program: Fragments per group:      8192
>18:46:48,841 INFO program: Inodes per group:         512
>18:46:48,841 INFO program: Inode blocks per group:   128
>18:46:48,841 INFO program: Flex block group size:    16
>18:46:48,842 INFO program: Filesystem created:       Sat Nov 16 13:47:24 2013
>18:46:48,842 INFO program: Last mount time:          Sat Nov 16 13:48:49 2013
>18:46:48,842 INFO program: Last write time:          Sat Nov 16 13:48:59 2013
>18:46:48,842 INFO program: Mount count:              2
>18:46:48,843 INFO program: Maximum mount count:      -1
>18:46:48,843 INFO program: Last checked:             Sat Nov 16 13:47:24 2013
>18:46:48,843 INFO program: Check interval:           0 (<none>)
>18:46:48,843 INFO program: Lifetime writes:          32 MB
>18:46:48,843 INFO program: Reserved blocks uid:      0 (user root)
>18:46:48,844 INFO program: Reserved blocks gid:      0 (group root)
>18:46:48,844 INFO program: First inode:              11
>18:46:48,844 INFO program: Inode size:	          256
>18:46:48,844 INFO program: Required extra isize:     28
>18:46:48,845 INFO program: Desired extra isize:      28
>18:46:48,845 INFO program: Journal inode:            8
>18:46:48,845 INFO program: Default directory hash:   half_md4
>18:46:48,845 INFO program: Directory Hash Seed:      72e38a80-1f42-4c88-8757-ef5d1eaa570e
>18:46:48,846 INFO program: Journal backup:           inode blocks
>18:46:48,846 INFO program: Journal features:         (none)
>18:46:48,846 INFO program: Journal size:             32M
>18:46:48,846 INFO program: Journal length:           32768
>18:46:48,847 INFO program: Journal sequence:         0x00000015
>18:46:48,847 INFO program: Journal start:            0
>18:46:48,847 INFO program: 
>18:46:48,847 DEBUG program: Return code: 0
>18:46:48,848 INFO program: Running... resize2fs -P /dev/mapper/live-base
>18:46:48,884 INFO program: resize2fs 1.42.8 (20-Jun-2013)
>18:46:48,885 INFO program: resize2fs: Operation not permitted while trying to open /dev/mapper/live-base
>18:46:48,886 INFO program: Couldn't find valid filesystem superblock.
>18:46:48,886 DEBUG program: Return code: 1
>18:46:48,907 INFO program: Running... udevadm settle --timeout=300
>18:46:48,961 DEBUG program: Return code: 0
>18:46:48,976 INFO program: Running... udevadm settle --timeout=300
>18:46:49,020 DEBUG program: Return code: 0
>18:46:49,192 INFO program: Running... hwclock --hctosys --utc
>18:46:49,004 DEBUG program: Return code: 0
>18:47:00,327 INFO program: Running... udevadm settle --timeout=300
>18:47:00,397 DEBUG program: Return code: 0
>18:47:00,421 INFO program: Running... mount -t iso9660 -o ro /dev/sr0 /tmp/tmpjjHiwz
>18:47:00,495 DEBUG program: Return code: 0
>18:47:00,496 INFO program: Running... udevadm settle --timeout=300
>18:47:00,558 DEBUG program: Return code: 0
>18:47:00,559 INFO program: Running... umount /tmp/tmpjjHiwz
>18:47:00,619 DEBUG program: Return code: 0
>
>
>/tmp/storage.log:
>18:45:08,884 INFO blivet: ISCSID is /sbin/iscsid
>18:45:08,885 INFO blivet: no initiator set
>18:45:09,102 INFO blivet: No FCoE EDD info found: No FCoE boot disk information is found in EDD!
>18:45:09,102 INFO blivet: no /etc/zfcp.conf; not configuring zfcp
>18:46:45,851 DEBUG blivet: trying to set new default fstype to 'ext4'
>18:46:45,918 DEBUG blivet:           Ext4FS.supported: supported: True ;
>18:46:45,920 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>18:46:45,921 DEBUG blivet:        Ext4FS.supported: supported: True ;
>18:46:46,717 INFO blivet: Detected 1936M of memory
>18:46:46,718 INFO blivet: Suggested swap size (3872 M) exceeds 10 % of disk space, using 10 % of disk space (0 M) instead.
>18:46:46,718 INFO blivet: Swap attempt of 0M
>18:46:47,368 INFO blivet: resetting Blivet (version 0.26) instance <blivet.Blivet object at 0x7f4f76adaa10>
>18:46:47,369 INFO blivet: no initiator set
>18:46:47,370 INFO blivet: not going to create backup copy of non-existent /etc/mdadm.conf
>18:46:47,370 INFO blivet: DeviceTree.populate: ignoredDisks is [] ; exclusiveDisks is []
>18:46:47,847 DEBUG blivet: protected device spec LABEL=Fedora_rawhide_x86_64 resolved to sr0
>18:46:47,972 INFO blivet: devices to scan: ['sr0', 'vda', 'loop0', 'loop1', 'loop2', 'dm-0', 'dm-1']
>18:46:47,983 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/cdrom /dev/disk/by-id/ata-QEMU_DVD-ROM_QM00001 /dev/disk/by-label/Fedora\\x20rawhide\\x20x86_64 /dev/disk/by-uuid/2013-11-16-13-57-11-00',
> 'DEVNAME': 'sr0',
> 'DEVPATH': '/devices/pci0000:00/0000:00:01.1/ata1/host0/target0:0:0/0:0:0:0/block/sr0',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1384713899',
> 'ID_ATA': '1',
> 'ID_BUS': 'ata',
> 'ID_CDROM': '1',
> 'ID_CDROM_DVD': '1',
> 'ID_CDROM_MEDIA': '1',
> 'ID_CDROM_MEDIA_CD': '1',
> 'ID_CDROM_MEDIA_SESSION_COUNT': '1',
> 'ID_CDROM_MEDIA_TRACK_COUNT': '1',
> 'ID_CDROM_MEDIA_TRACK_COUNT_DATA': '1',
> 'ID_CDROM_MRW': '1',
> 'ID_CDROM_MRW_W': '1',
> 'ID_FS_APPLICATION_ID': 'GENISOIMAGE\\x20ISO\\x209660\\x2fHFS\\x20FILESYSTEM\\x20CREATOR\\x20\\x28C\\x29\\x201993\\x20E.YOUNGDALE\\x20\\x28C\\x29\\x201997-2006\\x20J.PEARSON\\x2fJ.SCHILLING\\x20\\x28C\\x29\\x202006-2007\\x20CDRKIT\\x20TEAM',
> 'ID_FS_BOOT_SYSTEM_ID': 'EL\\x20TORITO\\x20SPECIFICATION',
> 'ID_FS_LABEL': 'Fedora_rawhide_x86_64',
> 'ID_FS_LABEL_ENC': 'Fedora\\x20rawhide\\x20x86_64',
> 'ID_FS_SYSTEM_ID': 'LINUX',
> 'ID_FS_TYPE': 'iso9660',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '2013-11-16-13-57-11-00',
> 'ID_FS_UUID_ENC': '2013-11-16-13-57-11-00',
> 'ID_FS_VERSION': 'Joliet Extension',
> 'ID_MODEL': 'QEMU_DVD-ROM',
> 'ID_MODEL_ENC': 'QEMU\\x20DVD-ROM\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20',
> 'ID_PART_TABLE_TYPE': 'dos',
> 'ID_PART_TABLE_UUID': '344918af',
> 'ID_REVISION': '1.6.90',
> 'ID_SERIAL': 'QEMU_DVD-ROM_QM00001',
> 'ID_SERIAL_SHORT': 'QM00001',
> 'ID_TYPE': 'cd',
> 'MAJOR': '11',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':seat:systemd:uaccess:',
> 'USEC_INITIALIZED': '401337',
> 'name': 'sr0',
> 'symlinks': ['/dev/cdrom',
>              '/dev/disk/by-id/ata-QEMU_DVD-ROM_QM00001',
>              '/dev/disk/by-label/Fedora\\x20rawhide\\x20x86_64',
>              '/dev/disk/by-uuid/2013-11-16-13-57-11-00'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:01.1/ata1/host0/target0:0:0/0:0:0:0/block/sr0'} ; name: sr0 ;
>18:46:47,986 INFO blivet: scanning sr0 (/devices/pci0000:00/0000:00:01.1/ata1/host0/target0:0:0/0:0:0:0/block/sr0)...
>18:46:47,989 DEBUG blivet:           DeviceTree.getDeviceByName: name: sr0 ;
>18:46:47,991 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>18:46:47,992 INFO blivet: sr0 is a cdrom
>18:46:47,995 DEBUG blivet:           DeviceTree.addUdevOpticalDevice:
>18:46:47,996 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>18:46:47,999 DEBUG blivet:               OpticalDevice._setFormat: sr0 ; current: None ; type: None ;
>18:46:48,000 INFO blivet: added cdrom sr0 (id 0) to device tree
>18:46:48,002 DEBUG blivet:           OpticalDevice.mediaPresent: sr0 ; status: True ;
>18:46:48,008 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: sr0 ;
>18:46:48,009 INFO blivet: type detected on 'sr0' is 'iso9660'
>18:46:48,011 DEBUG blivet:              Iso9660FS.supported: supported: True ;
>18:46:48,011 DEBUG blivet: getFormat('iso9660') returning Iso9660FS instance
>18:46:48,013 DEBUG blivet:             OpticalDevice._setFormat: sr0 ; current: None ; type: iso9660 ;
>18:46:48,016 DEBUG blivet:              OpticalDevice.mediaPresent: sr0 ; status: True ;
>18:46:48,019 DEBUG blivet: looking up parted Device: /dev/sr0
>18:46:48,035 INFO blivet: got device: OpticalDevice instance (0x7f4f76900650) --
>  name = sr0  status = True  kids = 0 id = 0
>  parents = []
>  uuid = None  size = 330.0
>  format = existing iso9660 filesystem
>  major = 11  minor = 0  exists = True  protected = True
>  sysfs path = /devices/pci0000:00/0000:00:01.1/ata1/host0/target0:0:0/0:0:0:0/block/sr0  partedDevice = parted.Device instance --
>  model: QEMU QEMU DVD-ROM  path: /dev/sr0  type: 1
>  sectorSize: 2048  physicalSectorSize:  2048
>  length: 168960  openCount: 0  readOnly: True
>  externalMode: False  dirty: False  bootDirty: False
>  host: 1  did: 0  busy: True
>  hardwareGeometry: (10, 255, 63)  biosGeometry: (10, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f4f7684a680>
>  target size = 0  path = /dev/sr0
>  format args = []  originalFormat = None
>18:46:48,040 DEBUG blivet:             Iso9660FS.supported: supported: True ;
>18:46:48,040 INFO blivet: got format: Iso9660FS instance (0x7f4f72c8e510) --
>  type = iso9660  name = iso9660  status = False
>  device = /dev/sr0  uuid = 2013-11-16-13-57-11-00  exists = True
>  options = ro  supported = True  formattable = False  resizable = False
>  mountpoint = None  mountopts = None
>  label = Fedora_rawhide_x86_64  size = 0.0  targetSize = 0.0
>
>18:46:48,053 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVNAME': 'vda',
> 'DEVPATH': '/devices/pci0000:00/0000:00:05.0/virtio2/block/vda',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1384713899',
> 'MAJOR': '252',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '405494',
> 'name': 'vda',
> 'symlinks': [],
> 'sysfs_path': '/devices/pci0000:00/0000:00:05.0/virtio2/block/vda'} ; name: vda ;
>18:46:48,057 INFO blivet: scanning vda (/devices/pci0000:00/0000:00:05.0/virtio2/block/vda)...
>18:46:48,063 DEBUG blivet:           DeviceTree.getDeviceByName: name: vda ;
>18:46:48,066 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>18:46:48,072 DEBUG blivet:           DeviceTree.addUdevDiskDevice: name: vda ;
>18:46:48,079 INFO blivet: vda is a disk
>18:46:48,081 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>18:46:48,087 DEBUG blivet:               DiskDevice._setFormat: vda ; current: None ; type: None ;
>18:46:48,141 INFO blivet: added disk vda (id 1) to device tree
>18:46:48,141 DEBUG blivet: looking up parted Device: /dev/vda
>18:46:48,146 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: vda ;
>18:46:48,148 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: vda ; label_type: None ;
>18:46:48,148 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>18:46:48,150 DEBUG blivet:             DiskDevice.setup: vda ; status: True ; controllable: True ; orig: False ;
>18:46:48,150 DEBUG blivet: required disklabel type for vda (15) is None
>18:46:48,151 DEBUG blivet: default disklabel type for vda is msdos
>18:46:48,152 DEBUG blivet: selecting msdos disklabel for vda based on size
>18:46:48,186 DEBUG blivet:              DiskLabel.__init__: device: /dev/vda ; labelType: msdos ; exists: True ;
>18:46:48,195 INFO blivet: no usable disklabel on vda
>18:46:48,209 DEBUG blivet: no type or existing type for vda, bailing
>18:46:48,219 INFO blivet: got device: DiskDevice instance (0x7f4f732ca250) --
>  name = vda  status = True  kids = 0 id = 1
>  parents = []
>  uuid = None  size = 15360.0
>  format = existing None
>  major = 252  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:05.0/virtio2/block/vda  partedDevice = parted.Device instance --
>  model: Virtio Block Device  path: /dev/vda  type: 15
>  sectorSize: 512  physicalSectorSize:  512
>  length: 31457280  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (31207, 16, 63)  biosGeometry: (1958, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f4f7684a9e0>
>  target size = 0  path = /dev/vda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7f4f732ca4d0>
>18:46:48,228 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVNAME': 'loop0',
> 'DEVPATH': '/devices/virtual/block/loop0',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1384713899',
> 'ID_FS_TYPE': 'squashfs',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_VERSION': '1024.0',
> 'MAJOR': '7',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '410031',
> 'name': 'loop0',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop0'} ; name: loop0 ;
>18:46:48,234 INFO blivet: scanning loop0 (/devices/virtual/block/loop0)...
>18:46:48,239 DEBUG blivet:           DeviceTree.getDeviceByName: name: loop0 ;
>18:46:48,243 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>18:46:48,245 INFO blivet: loop0 is a loop device
>18:46:48,247 DEBUG blivet:           DeviceTree.addUdevLoopDevice: name: loop0 ;
>18:46:48,251 DEBUG blivet:            DeviceTree.getDeviceByName: name: /run/install/repo/LiveOS/squashfs.img ;
>18:46:48,254 DEBUG blivet:            DeviceTree.getDeviceByName returned None
>18:46:48,255 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>18:46:48,258 DEBUG blivet:               FileDevice._setFormat: /run/install/repo/LiveOS/squashfs.img ; current: None ; type: None ;
>18:46:48,258 INFO blivet: added file /run/install/repo/LiveOS/squashfs.img (id 2) to device tree
>18:46:48,262 DEBUG blivet:               FileDevice.addChild: kids: 0 ; name: /run/install/repo/LiveOS/squashfs.img ;
>18:46:48,263 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>18:46:48,266 DEBUG blivet:               LoopDevice._setFormat: loop0 ; current: None ; type: None ;
>18:46:48,267 INFO blivet: added loop loop0 (id 3) to device tree
>18:46:48,269 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: loop0 ;
>18:46:48,271 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: loop0 ; label_type: None ;
>18:46:48,272 DEBUG blivet: getFormat('squashfs') returning DeviceFormat instance
>18:46:48,272 DEBUG blivet: device loop0 does not contain a disklabel
>18:46:48,274 INFO blivet: type detected on 'loop0' is 'squashfs'
>18:46:48,275 DEBUG blivet: getFormat('squashfs') returning DeviceFormat instance
>18:46:48,277 DEBUG blivet:             LoopDevice._setFormat: loop0 ; current: None ; type: squashfs ;
>18:46:48,281 INFO blivet: got device: LoopDevice instance (0x7f4f769ee810) --
>  name = loop0  status = False  kids = 0 id = 3
>  parents = ['existing 0MB file /run/install/repo/LiveOS/squashfs.img (2)']
>  uuid = None  size = 0
>  format = existing squashfs
>  major = 0  minor = 0  exists = True  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/loop0
>  format args = []  originalFormat = None
>18:46:48,282 INFO blivet: got format: DeviceFormat instance (0x7f4f732ca490) --
>  type = squashfs  name = squashfs  status = False
>  device = /dev/loop0  uuid = None  exists = True
>  options = None  supported = False  formattable = False  resizable = False
>
>18:46:48,288 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-label/Anaconda /dev/disk/by-uuid/9cf5c062-10a1-47b4-a178-3a39f1a1c08e',
> 'DEVNAME': 'loop1',
> 'DEVPATH': '/devices/virtual/block/loop1',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1384713899',
> 'ID_FS_LABEL': 'Anaconda',
> 'ID_FS_LABEL_ENC': 'Anaconda',
> 'ID_FS_TYPE': 'ext4',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '9cf5c062-10a1-47b4-a178-3a39f1a1c08e',
> 'ID_FS_UUID_ENC': '9cf5c062-10a1-47b4-a178-3a39f1a1c08e',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '7',
> 'MINOR': '1',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '410154',
> 'name': 'loop1',
> 'symlinks': ['/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/9cf5c062-10a1-47b4-a178-3a39f1a1c08e'],
> 'sysfs_path': '/devices/virtual/block/loop1'} ; name: loop1 ;
>18:46:48,290 INFO blivet: scanning loop1 (/devices/virtual/block/loop1)...
>18:46:48,292 DEBUG blivet:           DeviceTree.getDeviceByName: name: loop1 ;
>18:46:48,295 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>18:46:48,296 INFO blivet: loop1 is a loop device
>18:46:48,312 DEBUG blivet:           DeviceTree.addUdevLoopDevice: name: loop1 ;
>18:46:48,315 DEBUG blivet:            DeviceTree.getDeviceByName: name: /LiveOS/rootfs.img ;
>18:46:48,319 DEBUG blivet:            DeviceTree.getDeviceByName returned None
>18:46:48,320 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>18:46:48,321 DEBUG blivet:               FileDevice._setFormat: /LiveOS/rootfs.img ; current: None ; type: None ;
>18:46:48,322 INFO blivet: added file /LiveOS/rootfs.img (id 4) to device tree
>18:46:48,323 DEBUG blivet:               FileDevice.addChild: kids: 0 ; name: /LiveOS/rootfs.img ;
>18:46:48,323 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>18:46:48,325 DEBUG blivet:               LoopDevice._setFormat: loop1 ; current: None ; type: None ;
>18:46:48,325 INFO blivet: added loop loop1 (id 5) to device tree
>18:46:48,327 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: loop1 ;
>18:46:48,328 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: loop1 ; label_type: None ;
>18:46:48,330 DEBUG blivet:                Ext4FS.supported: supported: True ;
>18:46:48,330 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>18:46:48,331 DEBUG blivet: device loop1 does not contain a disklabel
>18:46:48,332 INFO blivet: type detected on 'loop1' is 'ext4'
>18:46:48,484 DEBUG blivet: using current size 0 as min size
>18:46:48,487 DEBUG blivet:               Ext4FS.supported: supported: True ;
>18:46:48,487 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>18:46:48,489 DEBUG blivet:             LoopDevice._setFormat: loop1 ; current: None ; type: ext4 ;
>18:46:48,490 INFO blivet: got device: LoopDevice instance (0x7f4f769eecd0) --
>  name = loop1  status = False  kids = 0 id = 5
>  parents = ['existing 0MB file /LiveOS/rootfs.img (4)']
>  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
>18:46:48,493 DEBUG blivet:             Ext4FS.supported: supported: True ;
>18:46:48,494 INFO blivet: got format: Ext4FS instance (0x7f4f769ee450) --
>  type = ext4  name = ext4  status = False
>  device = /dev/loop1  uuid = 9cf5c062-10a1-47b4-a178-3a39f1a1c08e  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 2048.0  targetSize = 2048.0
>
>18:46:48,497 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVNAME': 'loop2',
> 'DEVPATH': '/devices/virtual/block/loop2',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1384713899',
> 'ID_FS_TYPE': 'DM_snapshot_cow',
> 'ID_FS_USAGE': 'other',
> 'MAJOR': '7',
> 'MINOR': '2',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '410259',
> 'name': 'loop2',
> 'symlinks': [],
> 'sysfs_path': '/devices/virtual/block/loop2'} ; name: loop2 ;
>18:46:48,500 INFO blivet: scanning loop2 (/devices/virtual/block/loop2)...
>18:46:48,502 DEBUG blivet:           DeviceTree.getDeviceByName: name: loop2 ;
>18:46:48,503 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>18:46:48,504 INFO blivet: loop2 is a loop device
>18:46:48,505 DEBUG blivet:           DeviceTree.addUdevLoopDevice: name: loop2 ;
>18:46:48,507 DEBUG blivet:            DeviceTree.getDeviceByName: name: /overlay (deleted) ;
>18:46:48,508 DEBUG blivet:            DeviceTree.getDeviceByName returned None
>18:46:48,509 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>18:46:48,510 DEBUG blivet:               FileDevice._setFormat: /overlay (deleted) ; current: None ; type: None ;
>18:46:48,511 INFO blivet: added file /overlay (deleted) (id 6) to device tree
>18:46:48,513 DEBUG blivet:               FileDevice.addChild: kids: 0 ; name: /overlay (deleted) ;
>18:46:48,513 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>18:46:48,515 DEBUG blivet:               LoopDevice._setFormat: loop2 ; current: None ; type: None ;
>18:46:48,516 INFO blivet: added loop loop2 (id 7) to device tree
>18:46:48,517 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: loop2 ;
>18:46:48,519 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: loop2 ; label_type: None ;
>18:46:48,519 DEBUG blivet: getFormat('DM_snapshot_cow') returning DeviceFormat instance
>18:46:48,519 DEBUG blivet: device loop2 does not contain a disklabel
>18:46:48,520 INFO blivet: type detected on 'loop2' is 'DM_snapshot_cow'
>18:46:48,521 DEBUG blivet: getFormat('DM_snapshot_cow') returning DeviceFormat instance
>18:46:48,522 DEBUG blivet:             LoopDevice._setFormat: loop2 ; current: None ; type: DM_snapshot_cow ;
>18:46:48,523 INFO blivet: got device: LoopDevice instance (0x7f4f769ee250) --
>  name = loop2  status = False  kids = 0 id = 7
>  parents = ['existing 0MB file /overlay (deleted) (6)']
>  uuid = None  size = 0
>  format = existing DM_snapshot_cow
>  major = 0  minor = 0  exists = True  protected = False
>  sysfs path =   partedDevice = None
>  target size = 0  path = /dev/loop2
>  format args = []  originalFormat = None
>18:46:48,524 INFO blivet: got format: DeviceFormat instance (0x7f4f769eee90) --
>  type = DM_snapshot_cow  name = DM_snapshot_cow  status = False
>  device = /dev/loop2  uuid = None  exists = True
>  options = None  supported = False  formattable = False  resizable = False
>
>18:46:48,528 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-id/dm-name-live-rw /dev/disk/by-label/Anaconda /dev/disk/by-uuid/9cf5c062-10a1-47b4-a178-3a39f1a1c08e /dev/mapper/live-rw',
> 'DEVNAME': 'dm-0',
> 'DEVPATH': '/devices/virtual/block/dm-0',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1384713899',
> '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': '9cf5c062-10a1-47b4-a178-3a39f1a1c08e',
> 'ID_FS_UUID_ENC': '9cf5c062-10a1-47b4-a178-3a39f1a1c08e',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '253',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '22474',
> 'name': 'dm-0',
> 'symlinks': ['/dev/disk/by-id/dm-name-live-rw',
>              '/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/9cf5c062-10a1-47b4-a178-3a39f1a1c08e',
>              '/dev/mapper/live-rw'],
> 'sysfs_path': '/devices/virtual/block/dm-0'} ; name: live-rw ;
>18:46:48,529 INFO blivet: scanning live-rw (/devices/virtual/block/dm-0)...
>18:46:48,530 DEBUG blivet:           DeviceTree.getDeviceByName: name: live-rw ;
>18:46:48,532 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>18:46:48,533 INFO blivet: live-rw is a device-mapper device
>18:46:48,534 DEBUG blivet:           DeviceTree.addUdevDMDevice: name: live-rw ;
>18:46:48,536 DEBUG blivet:            DeviceTree.getDeviceByName: name: loop1 ;
>18:46:48,538 DEBUG blivet:            DeviceTree.getDeviceByName returned existing 0MB loop loop1 (5) with existing ext4 filesystem
>18:46:48,540 DEBUG blivet:            DeviceTree.getDeviceByName: name: loop2 ;
>18:46:48,542 DEBUG blivet:            DeviceTree.getDeviceByName returned existing 0MB loop loop2 (7) with existing DM_snapshot_cow
>18:46:48,545 DEBUG blivet:            DeviceTree.getDeviceByName: name: live-rw ;
>18:46:48,546 DEBUG blivet:            DeviceTree.getDeviceByName returned None
>18:46:48,548 DEBUG blivet:               LoopDevice.addChild: kids: 0 ; name: loop2 ;
>18:46:48,548 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>18:46:48,550 DEBUG blivet:               DMDevice._setFormat: live-rw ; current: None ; type: None ;
>18:46:48,551 INFO blivet: added dm live-rw (id 8) to device tree
>18:46:48,552 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: live-rw ;
>18:46:48,554 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: live-rw ; label_type: None ;
>18:46:48,555 DEBUG blivet:                Ext4FS.supported: supported: True ;
>18:46:48,556 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>18:46:48,556 DEBUG blivet: device live-rw does not contain a disklabel
>18:46:48,557 INFO blivet: type detected on 'live-rw' is 'ext4'
>18:46:48,646 DEBUG blivet: padding min size from 795 up to 874
>18:46:48,648 DEBUG blivet:               Ext4FS.supported: supported: True ;
>18:46:48,649 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>18:46:48,651 DEBUG blivet:             DMDevice._setFormat: live-rw ; current: None ; type: ext4 ;
>18:46:48,652 DEBUG blivet: looking up parted Device: /dev/mapper/live-rw
>18:46:48,745 INFO blivet: got device: DMDevice instance (0x7f4f769eed10) --
>  name = live-rw  status = True  kids = 0 id = 8
>  parents = ['existing 0MB loop loop2 (7) with existing DM_snapshot_cow']
>  uuid = None  size = 2048.0
>  format = existing ext4 filesystem
>  major = 0  minor = 0  exists = True  protected = True
>  sysfs path = /devices/virtual/block/dm-0  partedDevice = parted.Device instance --
>  model: Linux device-mapper (snapshot)  path: /dev/mapper/live-rw  type: 12
>  sectorSize: 512  physicalSectorSize:  512
>  length: 4194304  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: True
>  hardwareGeometry: (261, 255, 63)  biosGeometry: (261, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f4f7684ab90>
>  target size = 0  path = /dev/mapper/live-rw
>  format args = []  originalFormat = None  target = None  dmUuid = None
>18:46:48,749 DEBUG blivet:             Ext4FS.supported: supported: True ;
>18:46:48,752 INFO blivet: got format: Ext4FS instance (0x7f4f72c8e150) --
>  type = ext4  name = ext4  status = False
>  device = /dev/mapper/live-rw  uuid = 9cf5c062-10a1-47b4-a178-3a39f1a1c08e  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 2048.0  targetSize = 2048.0
>
>18:46:48,765 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-id/dm-name-live-base /dev/disk/by-label/Anaconda /dev/disk/by-uuid/9cf5c062-10a1-47b4-a178-3a39f1a1c08e /dev/mapper/live-base',
> 'DEVNAME': 'dm-1',
> 'DEVPATH': '/devices/virtual/block/dm-1',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1384713899',
> 'DM_NAME': 'live-base',
> 'DM_SUSPENDED': '0',
> 'DM_UDEV_DISABLE_LIBRARY_FALLBACK_FLAG': '1',
> 'DM_UDEV_PRIMARY_SOURCE_FLAG': '1',
> 'DM_UDEV_RULES_VSN': '2',
> 'ID_FS_LABEL': 'Anaconda',
> 'ID_FS_LABEL_ENC': 'Anaconda',
> 'ID_FS_TYPE': 'ext4',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '9cf5c062-10a1-47b4-a178-3a39f1a1c08e',
> 'ID_FS_UUID_ENC': '9cf5c062-10a1-47b4-a178-3a39f1a1c08e',
> 'ID_FS_VERSION': '1.0',
> 'MAJOR': '253',
> 'MINOR': '1',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '90488',
> 'name': 'dm-1',
> 'symlinks': ['/dev/disk/by-id/dm-name-live-base',
>              '/dev/disk/by-label/Anaconda',
>              '/dev/disk/by-uuid/9cf5c062-10a1-47b4-a178-3a39f1a1c08e',
>              '/dev/mapper/live-base'],
> 'sysfs_path': '/devices/virtual/block/dm-1'} ; name: live-base ;
>18:46:48,766 INFO blivet: scanning live-base (/devices/virtual/block/dm-1)...
>18:46:48,768 DEBUG blivet:           DeviceTree.getDeviceByName: name: live-base ;
>18:46:48,769 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>18:46:48,770 INFO blivet: live-base is a device-mapper device
>18:46:48,771 DEBUG blivet:           DeviceTree.addUdevDMDevice: name: live-base ;
>18:46:48,773 DEBUG blivet:            DMDevice.getDMNode: live-rw ; status: True ;
>18:46:48,774 DEBUG blivet:            DeviceTree.getDeviceByName: name: loop1 ;
>18:46:48,776 DEBUG blivet:            DeviceTree.getDeviceByName returned existing 0MB loop loop1 (5) with existing ext4 filesystem
>18:46:48,778 DEBUG blivet:            DeviceTree.getDeviceByName: name: live-base ;
>18:46:48,780 DEBUG blivet:            DeviceTree.getDeviceByName returned None
>18:46:48,782 DEBUG blivet:               LoopDevice.addChild: kids: 0 ; name: loop1 ;
>18:46:48,783 DEBUG blivet: getFormat('None') returning DeviceFormat instance
>18:46:48,786 DEBUG blivet:               DMDevice._setFormat: live-base ; current: None ; type: None ;
>18:46:48,787 INFO blivet: added dm live-base (id 9) to device tree
>18:46:48,789 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: live-base ;
>18:46:48,792 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: live-base ; label_type: None ;
>18:46:48,794 DEBUG blivet:                Ext4FS.supported: supported: True ;
>18:46:48,794 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>18:46:48,795 DEBUG blivet: device live-base does not contain a disklabel
>18:46:48,795 INFO blivet: type detected on 'live-base' is 'ext4'
>18:46:48,886 DEBUG blivet: using current size 0 as min size
>18:46:48,890 DEBUG blivet:               Ext4FS.supported: supported: True ;
>18:46:48,892 DEBUG blivet: getFormat('ext4') returning Ext4FS instance
>18:46:48,895 DEBUG blivet:             DMDevice._setFormat: live-base ; current: None ; type: ext4 ;
>18:46:48,896 DEBUG blivet: looking up parted Device: /dev/mapper/live-base
>18:46:48,902 INFO blivet: got device: DMDevice instance (0x7f4f769eed90) --
>  name = live-base  status = True  kids = 0 id = 9
>  parents = ['existing 0MB loop loop1 (5) with existing ext4 filesystem']
>  uuid = None  size = 2048.0
>  format = existing ext4 filesystem
>  major = 0  minor = 0  exists = True  protected = True
>  sysfs path = /devices/virtual/block/dm-1  partedDevice = parted.Device instance --
>  model: Linux device-mapper (linear)  path: /dev/mapper/live-base  type: 12
>  sectorSize: 512  physicalSectorSize:  512
>  length: 4194304  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (261, 255, 63)  biosGeometry: (261, 255, 63)
>  PedDevice: <_ped.Device object at 0x7f4f7684ac20>
>  target size = 0  path = /dev/mapper/live-base
>  format args = []  originalFormat = None  target = None  dmUuid = None
>18:46:48,905 DEBUG blivet:             Ext4FS.supported: supported: True ;
>18:46:48,906 INFO blivet: got format: Ext4FS instance (0x7f4f72c7f8d0) --
>  type = ext4  name = ext4  status = False
>  device = /dev/mapper/live-base  uuid = 9cf5c062-10a1-47b4-a178-3a39f1a1c08e  exists = True
>  options = defaults  supported = True  formattable = True  resizable = True
>  mountpoint = None  mountopts = None
>  label = Anaconda  size = 2048.0  targetSize = 2048.0
>
>18:46:48,971 DEBUG blivet:           DiskDevice.teardown: vda ; status: True ; controllable: True ;
>18:46:48,973 DEBUG blivet:             DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>18:46:48,976 DEBUG blivet:             DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>18:46:49,022 DEBUG blivet:           LoopDevice.teardown: loop0 ; status: False ; controllable: False ;
>18:46:49,023 INFO blivet: not going to restore from backup of non-existent /etc/mdadm.conf
>18:46:49,023 INFO blivet: edd: collected mbr signatures: {}
>18:46:49,025 DEBUG blivet: 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: 31457280
>18:46:49,026 DEBUG blivet: edd: matched 0x80 to vda using pci_dev
>18:46:49,174 DEBUG blivet:             Ext4FS.supported: supported: True ;
>18:46:49,177 DEBUG blivet:             Ext4FS.supported: supported: True ;
>18:46:49,180 DEBUG blivet:            Ext4FS.supported: supported: True ;
>18:46:49,183 DEBUG blivet:            OpticalDevice.mediaPresent: sr0 ; status: True ;
>18:46:49,187 DEBUG blivet:            Iso9660FS.supported: supported: True ;
>18:46:49,022 DEBUG blivet: /dev/sr0 is mounted on /run/install/repo
>18:46:49,023 DEBUG blivet: /dev/sr0 is mounted on /run/install/repo
>18:46:49,025 DEBUG blivet:             DeviceTree.getDeviceByPath: path: /dev/sr0 ;
>18:46:49,026 DEBUG blivet:                 OpticalDevice.mediaPresent: sr0 ; status: True ;
>18:46:49,032 DEBUG blivet:             DeviceTree.getDeviceByPath returned existing 330MB cdrom sr0 (0) with existing iso9660 filesystem
>18:47:00,309 DEBUG blivet:            OpticalDevice.mediaPresent: sr0 ; status: True ;
>18:47:00,314 INFO blivet: updating format of device: existing 330MB cdrom sr0 (0) with existing iso9660 filesystem
>18:47:00,315 DEBUG blivet: notifying kernel of 'change' event on device /sys/devices/pci0000:00/0000:00:01.1/ata1/host0/target0:0:0/0:0:0:0/block/sr0
>18:47:00,400 DEBUG blivet:         DeviceTree.handleUdevDeviceFormat: name: sr0 ;
>18:47:00,402 DEBUG blivet: no type or existing type for sr0, bailing
>18:47:00,402 INFO blivet: got format: existing iso9660 filesystem
>18:47:00,420 INFO blivet: failed to get default SELinux context for /tmp/tmpjjHiwz: [Errno 2] No such file or directory
>18:47:00,421 INFO blivet: set SELinux context for mountpoint /tmp/tmpjjHiwz to None
>18:50:16,718 DEBUG blivet: /dev/sr0 is mounted on /run/install/repo
>
>
>/tmp/ifcfg.log:
>18:46:46,766 DEBUG ifcfg: content of files (network initialization):
>18:46:46,777 DEBUG ifcfg: all settings: [GLib.Variant('(a{sa{sv}})', ({'connection': {'id': <'Wired connection 1'>, 'uuid': <'5abb46ed-23d7-4921-8520-02d025b49827'>, 'timestamp': <uint64 1384713904>, 'type': <'802-3-ethernet'>}, '802-3-ethernet': {'s390-options': <@a{ss} {}>, 'mac-address': <[byte 0x52, 0x54, 0x00, 0xa2, 0xa3, 0xa7]>}},))]
>18:46:47,314 DEBUG ifcfg: content of files (missing ifcfgs created for devices ['eth0']):
>18:46:47,315 DEBUG ifcfg: /etc/sysconfig/network-scripts/ifcfg-eth0:
>18:46:47,316 DEBUG ifcfg:   TYPE=Ethernet
>18:46:47,316 DEBUG ifcfg:   BOOTPROTO=dhcp
>18:46:47,316 DEBUG ifcfg:   DEFROUTE=yes
>18:46:47,316 DEBUG ifcfg:   IPV4_FAILURE_FATAL=no
>18:46:47,316 DEBUG ifcfg:   IPV6INIT=yes
>18:46:47,317 DEBUG ifcfg:   IPV6_AUTOCONF=yes
>18:46:47,317 DEBUG ifcfg:   IPV6_DEFROUTE=yes
>18:46:47,317 DEBUG ifcfg:   IPV6_PEERDNS=yes
>18:46:47,317 DEBUG ifcfg:   IPV6_PEERROUTES=yes
>18:46:47,317 DEBUG ifcfg:   IPV6_FAILURE_FATAL=no
>18:46:47,317 DEBUG ifcfg:   NAME=eth0
>18:46:47,317 DEBUG ifcfg:   UUID=5abb46ed-23d7-4921-8520-02d025b49827
>18:46:47,318 DEBUG ifcfg:   ONBOOT=no
>18:46:47,318 DEBUG ifcfg:   HWADDR=52:54:00:A2:A3:A7
>18:46:47,318 DEBUG ifcfg:   PEERDNS=yes
>18:46:47,318 DEBUG ifcfg:   PEERROUTES=yes
>18:46:47,333 DEBUG ifcfg: all settings: [GLib.Variant('(a{sa{sv}})', ({'connection': {'id': <'eth0'>, 'uuid': <'5abb46ed-23d7-4921-8520-02d025b49827'>, 'autoconnect': <false>, 'type': <'802-3-ethernet'>, 'timestamp': <uint64 1384713904>}, 'ipv4': {'addresses': <@aau []>, 'dns': <@au []>, 'method': <'auto'>, 'routes': <@aau []>}, '802-3-ethernet': {'s390-options': <@a{ss} {}>, 'mac-address': <[byte 0x52, 0x54, 0x00, 0xa2, 0xa3, 0xa7]>}, 'ipv6': {'addresses': <@a(ayuay) []>, 'dns': <@aay []>, 'method': <'auto'>, 'routes': <@a(ayuayu) []>}},))]
>18:46:48,043 DEBUG ifcfg: IfcfFile.read /etc/sysconfig/network-scripts/ifcfg-eth0
>18:46:48,044 DEBUG ifcfg: IfcfFile.read /etc/sysconfig/network-scripts/ifcfg-eth0
>
>
>/proc/cmdline:
>initrd=initrd.img inst.stage2=hd:LABEL=Fedora\x20rawhide\x20x86_64 text console=ttyS0 utf8 BOOT_IMAGE=vmlinuz 
>
>
>/tmp/syslog:
>18:45:00,747 INFO rsyslogd: [origin software="rsyslogd" swVersion="7.4.2" x-pid="877" x-info="http://www.rsyslog.com"] start
>18:45:00,763 INFO kernel:[    0.000000] Initializing cgroup subsys cpuset
>18:45:00,763 INFO kernel:[    0.000000] Initializing cgroup subsys cpu
>18:45:00,763 INFO kernel:[    0.000000] Initializing cgroup subsys cpuacct
>18:45:00,763 NOTICE kernel:[    0.000000] Linux version 3.13.0-0.rc0.git4.1.fc21.x86_64 (mockbuild@bkernel02) (gcc version 4.8.2 20131111 (Red Hat 4.8.2-4) (GCC) ) #1 SMP Thu Nov 14 18:41:12 UTC 2013
>18:45:00,763 INFO kernel:[    0.000000] Command line: initrd=initrd.img inst.stage2=hd:LABEL=Fedora\x20rawhide\x20x86_64 text console=ttyS0 utf8 BOOT_IMAGE=vmlinuz 
>18:45:00,763 INFO kernel:[    0.000000] e820: BIOS-provided physical RAM map:
>18:45:00,763 INFO kernel:[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
>18:45:00,763 INFO kernel:[    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
>18:45:00,763 INFO kernel:[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
>18:45:00,763 INFO kernel:[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000dfffdfff] usable
>18:45:00,763 INFO kernel:[    0.000000] BIOS-e820: [mem 0x00000000dfffe000-0x00000000dfffffff] reserved
>18:45:00,763 INFO kernel:[    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
>18:45:00,763 INFO kernel:[    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
>18:45:00,763 INFO kernel:[    0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000011fffffff] usable
>18:45:00,763 INFO kernel:[    0.000000] NX (Execute Disable) protection: active
>18:45:00,763 INFO kernel:[    0.000000] SMBIOS 2.4 present.
>18:45:00,763 DEBUG kernel:[    0.000000] DMI: Bochs Bochs, BIOS Bochs 01/01/2011
>18:45:00,763 INFO kernel:[    0.000000] Hypervisor detected: KVM
>18:45:00,763 DEBUG kernel:[    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
>18:45:00,763 DEBUG kernel:[    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
>18:45:00,763 INFO kernel:[    0.000000] e820: last_pfn = 0x120000 max_arch_pfn = 0x400000000
>18:45:00,763 DEBUG kernel:[    0.000000] MTRR default type: write-back
>18:45:00,763 DEBUG kernel:[    0.000000] MTRR fixed ranges enabled:
>18:45:00,763 DEBUG kernel:[    0.000000]   00000-9FFFF write-back
>18:45:00,763 DEBUG kernel:[    0.000000]   A0000-BFFFF uncachable
>18:45:00,763 DEBUG kernel:[    0.000000]   C0000-FFFFF write-protect
>18:45:00,763 DEBUG kernel:[    0.000000] MTRR variable ranges enabled:
>18:45:00,763 DEBUG kernel:[    0.000000]   0 base 00E0000000 mask FFE0000000 uncachable
>18:45:00,763 DEBUG kernel:[    0.000000]   1 disabled
>18:45:00,763 DEBUG kernel:[    0.000000]   2 disabled
>18:45:00,763 DEBUG kernel:[    0.000000]   3 disabled
>18:45:00,763 DEBUG kernel:[    0.000000]   4 disabled
>18:45:00,763 DEBUG kernel:[    0.000000]   5 disabled
>18:45:00,763 DEBUG kernel:[    0.000000]   6 disabled
>18:45:00,763 DEBUG kernel:[    0.000000]   7 disabled
>18:45:00,763 INFO kernel:[    0.000000] x86 PAT enabled: cpu 0, old 0x70406, new 0x7010600070106
>18:45:00,763 INFO kernel:[    0.000000] e820: last_pfn = 0xdfffe max_arch_pfn = 0x400000000
>18:45:00,763 INFO kernel:[    0.000000] found SMP MP-table at [mem 0x000f1820-0x000f182f] mapped at [ffff8800000f1820]
>18:45:00,763 INFO kernel:[    0.000000] Scanning 1 areas for low memory corruption
>18:45:00,763 DEBUG kernel:[    0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576
>18:45:00,763 INFO kernel:[    0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
>18:45:00,763 DEBUG kernel:[    0.000000]  [mem 0x00000000-0x000fffff] page 4k
>18:45:00,763 DEBUG kernel:[    0.000000] BRK [0x02d92000, 0x02d92fff] PGTABLE
>18:45:00,763 DEBUG kernel:[    0.000000] BRK [0x02d93000, 0x02d93fff] PGTABLE
>18:45:00,763 DEBUG kernel:[    0.000000] BRK [0x02d94000, 0x02d94fff] PGTABLE
>18:45:00,763 INFO kernel:[    0.000000] init_memory_mapping: [mem 0x11fe00000-0x11fffffff]
>18:45:00,763 DEBUG kernel:[    0.000000]  [mem 0x11fe00000-0x11fffffff] page 2M
>18:45:00,763 DEBUG kernel:[    0.000000] BRK [0x02d95000, 0x02d95fff] PGTABLE
>18:45:00,763 INFO kernel:[    0.000000] init_memory_mapping: [mem 0x11c000000-0x11fdfffff]
>18:45:00,763 DEBUG kernel:[    0.000000]  [mem 0x11c000000-0x11fdfffff] page 2M
>18:45:00,763 INFO kernel:[    0.000000] init_memory_mapping: [mem 0x100000000-0x11bffffff]
>18:45:00,763 DEBUG kernel:[    0.000000]  [mem 0x100000000-0x11bffffff] page 2M
>18:45:00,763 INFO kernel:[    0.000000] init_memory_mapping: [mem 0x00100000-0xdfffdfff]
>18:45:00,763 DEBUG kernel:[    0.000000]  [mem 0x00100000-0x001fffff] page 4k
>18:45:00,763 DEBUG kernel:[    0.000000]  [mem 0x00200000-0xdfdfffff] page 2M
>18:45:00,763 DEBUG kernel:[    0.000000]  [mem 0xdfe00000-0xdfffdfff] page 4k
>18:45:00,763 INFO kernel:[    0.000000] RAMDISK: [mem 0x7de00000-0x7fffefff]
>18:45:00,763 WARNING kernel:[    0.000000] ACPI: RSDP 00000000000f1670 000014 (v00 BOCHS )
>18:45:00,763 WARNING kernel:[    0.000000] ACPI: RSDT 00000000dfffe3f0 000034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
>18:45:00,763 WARNING kernel:[    0.000000] ACPI: FACP 00000000dfffff80 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
>18:45:00,763 WARNING kernel:[    0.000000] ACPI: DSDT 00000000dfffe430 001137 (v01   BXPC   BXDSDT 00000001 INTL 20100528)
>18:45:00,763 WARNING kernel:[    0.000000] ACPI: FACS 00000000dfffff40 000040
>18:45:00,763 WARNING kernel:[    0.000000] ACPI: SSDT 00000000dffff6a0 000899 (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
>18:45:00,763 WARNING kernel:[    0.000000] ACPI: APIC 00000000dffff5b0 000080 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
>18:45:00,763 WARNING kernel:[    0.000000] ACPI: HPET 00000000dffff570 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
>18:45:00,763 DEBUG kernel:[    0.000000] ACPI: Local APIC address 0xfee00000
>18:45:00,763 INFO kernel:[    0.000000] No NUMA configuration found
>18:45:00,763 INFO kernel:[    0.000000] Faking a node at [mem 0x0000000000000000-0x000000011fffffff]
>18:45:00,763 INFO kernel:[    0.000000] Initmem setup node 0 [mem 0x00000000-0x11fffffff]
>18:45:00,763 INFO kernel:[    0.000000]   NODE_DATA [mem 0x11ffd5000-0x11fffbfff]
>18:45:00,763 INFO kernel:[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
>18:45:00,763 INFO kernel:[    0.000000] kvm-clock: cpu 0, msr 1:1ff55001, boot clock
>18:45:00,763 DEBUG kernel:[    0.000000]  [ffffea0000000000-ffffea00047fffff] PMD -> [ffff88011b600000-ffff88011f5fffff] on node 0
>18:45:00,763 WARNING kernel:[    0.000000] Zone ranges:
>18:45:00,763 WARNING kernel:[    0.000000]   DMA      [mem 0x00001000-0x00ffffff]
>18:45:00,763 WARNING kernel:[    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
>18:45:00,763 WARNING kernel:[    0.000000]   Normal   [mem 0x100000000-0x11fffffff]
>18:45:00,763 WARNING kernel:[    0.000000] Movable zone start for each node
>18:45:00,763 WARNING kernel:[    0.000000] Early memory node ranges
>18:45:00,763 WARNING kernel:[    0.000000]   node   0: [mem 0x00001000-0x0009efff]
>18:45:00,763 WARNING kernel:[    0.000000]   node   0: [mem 0x00100000-0xdfffdfff]
>18:45:00,763 WARNING kernel:[    0.000000]   node   0: [mem 0x100000000-0x11fffffff]
>18:45:00,763 DEBUG kernel:[    0.000000] On node 0 totalpages: 1048476
>18:45:00,763 DEBUG kernel:[    0.000000]   DMA zone: 64 pages used for memmap
>18:45:00,763 DEBUG kernel:[    0.000000]   DMA zone: 21 pages reserved
>18:45:00,763 DEBUG kernel:[    0.000000]   DMA zone: 3998 pages, LIFO batch:0
>18:45:00,763 DEBUG kernel:[    0.000000]   DMA32 zone: 14272 pages used for memmap
>18:45:00,763 DEBUG kernel:[    0.000000]   DMA32 zone: 913406 pages, LIFO batch:31
>18:45:00,763 DEBUG kernel:[    0.000000]   Normal zone: 2048 pages used for memmap
>18:45:00,763 DEBUG kernel:[    0.000000]   Normal zone: 131072 pages, LIFO batch:31
>18:45:00,763 INFO kernel:[    0.000000] ACPI: PM-Timer IO Port: 0xb008
>18:45:00,763 DEBUG kernel:[    0.000000] ACPI: Local APIC address 0xfee00000
>18:45:00,763 INFO kernel:[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
>18:45:00,763 INFO kernel:[    0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
>18:45:00,763 INFO kernel:[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
>18:45:00,763 INFO kernel:[    0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
>18:45:00,763 INFO kernel:[    0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
>18:45:00,763 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
>18:45:00,763 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
>18:45:00,763 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
>18:45:00,763 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
>18:45:00,763 INFO kernel:[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
>18:45:00,763 DEBUG kernel:[    0.000000] ACPI: IRQ0 used by override.
>18:45:00,763 DEBUG kernel:[    0.000000] ACPI: IRQ2 used by override.
>18:45:00,763 DEBUG kernel:[    0.000000] ACPI: IRQ5 used by override.
>18:45:00,763 DEBUG kernel:[    0.000000] ACPI: IRQ9 used by override.
>18:45:00,763 DEBUG kernel:[    0.000000] ACPI: IRQ10 used by override.
>18:45:00,763 DEBUG kernel:[    0.000000] ACPI: IRQ11 used by override.
>18:45:00,763 INFO kernel:[    0.000000] Using ACPI (MADT) for SMP configuration information
>18:45:00,763 INFO kernel:[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
>18:45:00,763 INFO kernel:[    0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
>18:45:00,763 DEBUG kernel:[    0.000000] nr_irqs_gsi: 40
>18:45:00,763 INFO kernel:[    0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
>18:45:00,763 INFO kernel:[    0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
>18:45:00,763 INFO kernel:[    0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
>18:45:00,763 INFO kernel:[    0.000000] PM: Registered nosave memory: [mem 0xdfffe000-0xdfffffff]
>18:45:00,763 INFO kernel:[    0.000000] PM: Registered nosave memory: [mem 0xe0000000-0xfeffbfff]
>18:45:00,763 INFO kernel:[    0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff]
>18:45:00,763 INFO kernel:[    0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff]
>18:45:00,763 INFO kernel:[    0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff]
>18:45:00,763 INFO kernel:[    0.000000] e820: [mem 0xe0000000-0xfeffbfff] available for PCI devices
>18:45:00,763 INFO kernel:[    0.000000] Booting paravirtualized kernel on KVM
>18:45:00,763 INFO kernel:[    0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1
>18:45:00,763 INFO kernel:[    0.000000] PERCPU: Embedded 478 pages/cpu @ffff88011b200000 s1925376 r8192 d24320 u2097152
>18:45:00,763 DEBUG kernel:[    0.000000] pcpu-alloc: s1925376 r8192 d24320 u2097152 alloc=1*2097152
>18:45:00,763 DEBUG kernel:[    0.000000] pcpu-alloc: [0] 0 [0] 1 
>18:45:00,763 INFO kernel:[    0.000000] kvm-clock: cpu 0, msr 1:1ff55001, primary cpu clock
>18:45:00,763 INFO kernel:[    0.000000] KVM setup async PF for cpu 0
>18:45:00,763 INFO kernel:[    0.000000] kvm-stealtime: cpu 0, msr 11b20e140
>18:45:00,763 WARNING kernel:[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 1032071
>18:45:00,763 WARNING kernel:[    0.000000] Policy zone: Normal
>18:45:00,763 NOTICE kernel:[    0.000000] Kernel command line: initrd=initrd.img inst.stage2=hd:LABEL=Fedora\x20rawhide\x20x86_64 text console=ttyS0 utf8 BOOT_IMAGE=vmlinuz 
>18:45:00,763 INFO kernel:[    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
>18:45:00,763 INFO kernel:[    0.000000] xsave: enabled xstate_bv 0x7, cntxt size 0x340
>18:45:00,763 WARNING kernel:[    0.000000] Memory: 3992244K/4193904K available (7568K kernel code, 1561K rwdata, 3208K rodata, 3732K init, 12660K bss, 201660K reserved)
>18:45:00,763 INFO kernel:[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
>18:45:00,763 INFO kernel:[    0.000000] Hierarchical RCU implementation.
>18:45:00,763 INFO kernel:[    0.000000] 	RCU lockdep checking is enabled.
>18:45:00,763 INFO kernel:[    0.000000] 	RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=2.
>18:45:00,763 INFO kernel:[    0.000000] NR_IRQS:524544 nr_irqs:512 16
>18:45:00,763 INFO kernel:[    0.000000] Console: colour VGA+ 80x25
>18:45:00,763 INFO kernel:[    0.000000] console [ttyS0] enabled
>18:45:00,763 WARNING kernel:[    0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
>18:45:00,763 WARNING kernel:[    0.000000] ... MAX_LOCKDEP_SUBCLASSES:  8
>18:45:00,763 WARNING kernel:[    0.000000] ... MAX_LOCK_DEPTH:          48
>18:45:00,763 WARNING kernel:[    0.000000] ... MAX_LOCKDEP_KEYS:        8191
>18:45:00,763 WARNING kernel:[    0.000000] ... CLASSHASH_SIZE:          4096
>18:45:00,763 WARNING kernel:[    0.000000] ... MAX_LOCKDEP_ENTRIES:     16384
>18:45:00,763 WARNING kernel:[    0.000000] ... MAX_LOCKDEP_CHAINS:      32768
>18:45:00,763 WARNING kernel:[    0.000000] ... CHAINHASH_SIZE:          16384
>18:45:00,763 WARNING kernel:[    0.000000]  memory used by lock dependency info: 6367 kB
>18:45:00,763 WARNING kernel:[    0.000000]  per task-struct memory footprint: 2688 bytes
>18:45:00,763 INFO kernel:[    0.000000] allocated 16777216 bytes of page_cgroup
>18:45:00,763 INFO kernel:[    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
>18:45:00,763 DEBUG kernel:[    0.000000] ODEBUG: 19 of 19 active objects replaced
>18:45:00,763 INFO kernel:[    0.000000] kmemleak: Kernel memory leak detector disabled
>18:45:00,763 DEBUG kernel:[    0.000000] hpet clockevent registered
>18:45:00,763 INFO kernel:[    0.000000] tsc: Detected 2591.764 MHz processor
>18:45:00,763 INFO kernel:[    0.002000] Calibrating delay loop (skipped) preset value.. 5183.52 BogoMIPS (lpj=2591764)
>18:45:00,763 INFO kernel:[    0.003009] pid_max: default: 32768 minimum: 301
>18:45:00,763 INFO kernel:[    0.004312] Security Framework initialized
>18:45:00,763 INFO kernel:[    0.005010] SELinux:  Initializing.
>18:45:00,763 DEBUG kernel:[    0.006111] SELinux:  Starting in permissive mode
>18:45:00,763 INFO kernel:[    0.007926] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes)
>18:45:00,763 INFO kernel:[    0.010017] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes)
>18:45:00,763 INFO kernel:[    0.011000] Mount-cache hash table entries: 256
>18:45:00,763 INFO kernel:[    0.013498] Initializing cgroup subsys memory
>18:45:00,763 INFO kernel:[    0.014069] Initializing cgroup subsys devices
>18:45:00,763 INFO kernel:[    0.015024] Initializing cgroup subsys freezer
>18:45:00,763 INFO kernel:[    0.015627] Initializing cgroup subsys net_cls
>18:45:00,763 INFO kernel:[    0.016011] Initializing cgroup subsys blkio
>18:45:00,763 INFO kernel:[    0.016538] Initializing cgroup subsys perf_event
>18:45:00,763 INFO kernel:[    0.017190] mce: CPU supports 10 MCE banks
>18:45:00,763 INFO kernel:[    0.018054] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
>18:45:00,763 INFO kernel:[    0.018054] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0
>18:45:00,763 INFO kernel:[    0.018054] tlb_flushall_shift: 5
>18:45:00,763 INFO kernel:[    0.019312] Freeing SMP alternatives memory: 24K (ffffffff8212d000 - ffffffff82133000)
>18:45:00,763 INFO kernel:[    0.024923] ACPI: Core revision 20130927
>18:45:00,763 WARNING kernel:[    0.054946] ACPI: All ACPI Tables successfully acquired
>18:45:00,763 INFO kernel:[    0.055489] ftrace: allocating 25840 entries in 101 pages
>18:45:00,763 INFO kernel:[    0.063723] Enabling x2apic
>18:45:00,763 INFO kernel:[    0.064000] Enabled x2apic
>18:45:00,763 INFO kernel:[    0.064011] Switched APIC routing to physical x2apic.
>18:45:00,763 INFO kernel:[    0.066861] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
>18:45:00,763 INFO kernel:[    0.067005] smpboot: CPU0: Intel Xeon E312xx (Sandy Bridge) (fam: 06, model: 2a, stepping: 01)
>18:45:00,763 DEBUG kernel:[    0.069029] TSC deadline timer enabled
>18:45:00,763 INFO kernel:[    0.069059] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only.
>18:45:00,763 WARNING kernel:[    0.074281] NMI watchdog: disabled (cpu0): hardware events not enabled
>18:45:00,763 INFO kernel:[    0.075558] x86: Booting SMP configuration:
>18:45:00,763 INFO kernel:[    0.002000] kvm-clock: cpu 1, msr 1:1ff55041, secondary cpu clock
>18:45:00,763 INFO kernel:[    0.076007] .... node  #0, CPUs:      #1
>18:45:00,763 INFO kernel:[    0.089162] x86: Booted up 1 node, 2 CPUs
>18:45:00,763 INFO kernel:[    0.089117] KVM setup async PF for cpu 1
>18:45:00,763 INFO kernel:[    0.089117] kvm-stealtime: cpu 1, msr 11b40e140
>18:45:00,763 INFO kernel:[    0.090007] smpboot: Total of 2 processors activated (10367.05 BogoMIPS)
>18:45:00,763 INFO kernel:[    0.093009] devtmpfs: initialized
>18:45:00,763 INFO kernel:[    0.101073] atomic64 test passed for x86-64 platform with CX8 and with SSE
>18:45:00,763 INFO kernel:[    0.101956] pinctrl core: initialized pinctrl subsystem
>18:45:00,763 INFO kernel:[    0.102341] RTC time: 18:44:45, date: 11/17/13
>18:45:00,763 INFO kernel:[    0.103587] NET: Registered protocol family 16
>18:45:00,763 INFO kernel:[    0.105018] cpuidle: using governor menu
>18:45:00,763 INFO kernel:[    0.105879] ACPI: bus type PCI registered
>18:45:00,763 INFO kernel:[    0.106007] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
>18:45:00,763 INFO kernel:[    0.107249] PCI: Using configuration type 1 for base access
>18:45:00,763 INFO kernel:[    0.122514] bio: create slab <bio-0> at 0
>18:45:00,763 INFO kernel:[    0.124089] ACPI: Added _OSI(Module Device)
>18:45:00,763 INFO kernel:[    0.124617] ACPI: Added _OSI(Processor Device)
>18:45:00,764 INFO kernel:[    0.125007] ACPI: Added _OSI(3.0 _SCP Extensions)
>18:45:00,764 INFO kernel:[    0.125601] ACPI: Added _OSI(Processor Aggregator Device)
>18:45:00,764 INFO kernel:[    0.171204] ACPI: Interpreter enabled
>18:45:00,764 WARNING kernel:[    0.171718] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S1_] (20130927/hwxface-580)
>18:45:00,764 WARNING kernel:[    0.172696] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20130927/hwxface-580)
>18:45:00,764 INFO kernel:[    0.173819] ACPI: (supports S0 S3 S4 S5)
>18:45:00,764 INFO kernel:[    0.174006] ACPI: Using IOAPIC for interrupt routing
>18:45:00,764 INFO kernel:[    0.174789] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
>18:45:00,764 INFO kernel:[    0.186959] ACPI: No dock devices found.
>18:45:00,764 INFO kernel:[    0.271138] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
>18:45:00,764 INFO kernel:[    0.271965] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
>18:45:00,764 INFO kernel:[    0.272148] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
>18:45:00,764 WARNING kernel:[    0.276625] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
>18:45:00,764 INFO kernel:[    0.283186] acpiphp: Slot [3] registered
>18:45:00,764 INFO kernel:[    0.284179] acpiphp: Slot [4] registered
>18:45:00,764 INFO kernel:[    0.284929] acpiphp: Slot [5] registered
>18:45:00,764 INFO kernel:[    0.285257] acpiphp: Slot [6] registered
>18:45:00,764 INFO kernel:[    0.286067] acpiphp: Slot [7] registered
>18:45:00,764 INFO kernel:[    0.287189] acpiphp: Slot [8] registered
>18:45:00,764 INFO kernel:[    0.288309] acpiphp: Slot [9] registered
>18:45:00,764 INFO kernel:[    0.289380] acpiphp: Slot [10] registered
>18:45:00,764 INFO kernel:[    0.290297] acpiphp: Slot [11] registered
>18:45:00,764 INFO kernel:[    0.291230] acpiphp: Slot [12] registered
>18:45:00,764 INFO kernel:[    0.292007] acpiphp: Slot [13] registered
>18:45:00,764 INFO kernel:[    0.292768] acpiphp: Slot [14] registered
>18:45:00,764 INFO kernel:[    0.293252] acpiphp: Slot [15] registered
>18:45:00,764 INFO kernel:[    0.294012] acpiphp: Slot [16] registered
>18:45:00,764 INFO kernel:[    0.294772] acpiphp: Slot [17] registered
>18:45:00,764 INFO kernel:[    0.295378] acpiphp: Slot [18] registered
>18:45:00,764 INFO kernel:[    0.296248] acpiphp: Slot [19] registered
>18:45:00,764 INFO kernel:[    0.297110] acpiphp: Slot [20] registered
>18:45:00,764 INFO kernel:[    0.297893] acpiphp: Slot [21] registered
>18:45:00,764 INFO kernel:[    0.298453] acpiphp: Slot [22] registered
>18:45:00,764 INFO kernel:[    0.299436] acpiphp: Slot [23] registered
>18:45:00,764 INFO kernel:[    0.300412] acpiphp: Slot [24] registered
>18:45:00,764 INFO kernel:[    0.301425] acpiphp: Slot [25] registered
>18:45:00,764 INFO kernel:[    0.302451] acpiphp: Slot [26] registered
>18:45:00,764 INFO kernel:[    0.303486] acpiphp: Slot [27] registered
>18:45:00,764 INFO kernel:[    0.304407] acpiphp: Slot [28] registered
>18:45:00,764 INFO kernel:[    0.305403] acpiphp: Slot [29] registered
>18:45:00,764 INFO kernel:[    0.306462] acpiphp: Slot [30] registered
>18:45:00,764 INFO kernel:[    0.307500] acpiphp: Slot [31] registered
>18:45:00,764 INFO kernel:[    0.308062] PCI host bridge to bus 0000:00
>18:45:00,764 INFO kernel:[    0.308594] pci_bus 0000:00: root bus resource [bus 00-ff]
>18:45:00,764 INFO kernel:[    0.309014] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7]
>18:45:00,764 INFO kernel:[    0.310000] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff]
>18:45:00,764 INFO kernel:[    0.310021] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff]
>18:45:00,764 INFO kernel:[    0.310890] pci_bus 0000:00: root bus resource [mem 0xe0000000-0xfebfffff]
>18:45:00,764 DEBUG kernel:[    0.311089] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
>18:45:00,764 DEBUG kernel:[    0.313498] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
>18:45:00,764 DEBUG kernel:[    0.316539] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
>18:45:00,764 DEBUG kernel:[    0.320016] pci 0000:00:01.1: reg 0x20: [io  0xc0e0-0xc0ef]
>18:45:00,764 DEBUG kernel:[    0.324378] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300
>18:45:00,764 DEBUG kernel:[    0.327747] pci 0000:00:01.2: reg 0x20: [io  0xc0c0-0xc0df]
>18:45:00,764 DEBUG kernel:[    0.331034] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
>18:45:00,764 INFO kernel:[    0.331408] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
>18:45:00,764 INFO kernel:[    0.332018] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
>18:45:00,764 DEBUG kernel:[    0.334671] pci 0000:00:02.0: [1b36:0100] type 00 class 0x030000
>18:45:00,764 DEBUG kernel:[    0.336017] pci 0000:00:02.0: reg 0x10: [mem 0xf4000000-0xf7ffffff]
>18:45:00,764 DEBUG kernel:[    0.338010] pci 0000:00:02.0: reg 0x14: [mem 0xf8000000-0xfbffffff]
>18:45:00,764 DEBUG kernel:[    0.340012] pci 0000:00:02.0: reg 0x18: [mem 0xfc050000-0xfc051fff]
>18:45:00,764 DEBUG kernel:[    0.342017] pci 0000:00:02.0: reg 0x1c: [io  0xc0a0-0xc0bf]
>18:45:00,764 DEBUG kernel:[    0.348020] pci 0000:00:02.0: reg 0x30: [mem 0xfc040000-0xfc04ffff pref]
>18:45:00,764 DEBUG kernel:[    0.349911] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000
>18:45:00,764 DEBUG kernel:[    0.350742] pci 0000:00:03.0: reg 0x10: [io  0xc080-0xc09f]
>18:45:00,764 DEBUG kernel:[    0.351721] pci 0000:00:03.0: reg 0x14: [mem 0xfc054000-0xfc054fff]
>18:45:00,764 DEBUG kernel:[    0.356713] pci 0000:00:03.0: reg 0x30: [mem 0xfc000000-0xfc03ffff pref]
>18:45:00,764 DEBUG kernel:[    0.358633] pci 0000:00:04.0: [1af4:1002] type 00 class 0x00ff00
>18:45:00,764 DEBUG kernel:[    0.359382] pci 0000:00:04.0: reg 0x10: [io  0xc060-0xc07f]
>18:45:00,764 DEBUG kernel:[    0.365202] pci 0000:00:05.0: [1af4:1001] type 00 class 0x010000
>18:45:00,764 DEBUG kernel:[    0.366740] pci 0000:00:05.0: reg 0x10: [io  0xc000-0xc03f]
>18:45:00,764 DEBUG kernel:[    0.367715] pci 0000:00:05.0: reg 0x14: [mem 0xfc053000-0xfc053fff]
>18:45:00,764 DEBUG kernel:[    0.374647] pci 0000:00:06.0: [1af4:1003] type 00 class 0x078000
>18:45:00,764 DEBUG kernel:[    0.375694] pci 0000:00:06.0: reg 0x10: [io  0xc040-0xc05f]
>18:45:00,764 DEBUG kernel:[    0.376685] pci 0000:00:06.0: reg 0x14: [mem 0xfc052000-0xfc052fff]
>18:45:00,764 INFO kernel:[    0.389724] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
>18:45:00,764 INFO kernel:[    0.391849] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
>18:45:00,764 INFO kernel:[    0.393981] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
>18:45:00,764 INFO kernel:[    0.395804] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
>18:45:00,764 INFO kernel:[    0.396844] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
>18:45:00,764 WARNING kernel:[    0.401863] ACPI: Enabled 16 GPEs in block 00 to 0F
>18:45:00,764 DEBUG kernel:[    0.402030] ACPI: \_SB_.PCI0: notify handler is installed
>18:45:00,764 DEBUG kernel:[    0.402178] Found 1 acpi root devices
>18:45:00,764 INFO kernel:[    0.403122] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
>18:45:00,764 INFO kernel:[    0.404010] vgaarb: loaded
>18:45:00,764 INFO kernel:[    0.404360] vgaarb: bridge control possible 0000:00:02.0
>18:45:00,764 NOTICE kernel:[    0.406241] SCSI subsystem initialized
>18:45:00,764 DEBUG kernel:[    0.407093] libata version 3.00 loaded.
>18:45:00,764 INFO kernel:[    0.407342] ACPI: bus type USB registered
>18:45:00,764 INFO kernel:[    0.408117] usbcore: registered new interface driver usbfs
>18:45:00,764 INFO kernel:[    0.409097] usbcore: registered new interface driver hub
>18:45:00,764 INFO kernel:[    0.409894] usbcore: registered new device driver usb
>18:45:00,764 INFO kernel:[    0.410492] PCI: Using ACPI for IRQ routing
>18:45:00,764 DEBUG kernel:[    0.411007] PCI: pci_cache_line_size set to 64 bytes
>18:45:00,764 DEBUG kernel:[    0.411178] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
>18:45:00,764 DEBUG kernel:[    0.411208] e820: reserve RAM buffer [mem 0xdfffe000-0xdfffffff]
>18:45:00,764 INFO kernel:[    0.412314] NetLabel: Initializing
>18:45:00,764 INFO kernel:[    0.412766] NetLabel:  domain hash size = 128
>18:45:00,764 INFO kernel:[    0.413010] NetLabel:  protocols = UNLABELED CIPSOv4
>18:45:00,764 INFO kernel:[    0.414130] NetLabel:  unlabeled traffic allowed by default
>18:45:00,764 INFO kernel:[    0.415133] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
>18:45:00,764 INFO kernel:[    0.416028] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
>18:45:00,764 INFO kernel:[    0.416696] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
>18:45:00,764 INFO kernel:[    0.419194] Switched to clocksource kvm-clock
>18:45:00,764 INFO kernel:[    0.529025] pnp: PnP ACPI init
>18:45:00,764 INFO kernel:[    0.529551] ACPI: bus type PNP registered
>18:45:00,764 DEBUG kernel:[    0.530548] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
>18:45:00,764 DEBUG kernel:[    0.531023] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
>18:45:00,764 DEBUG kernel:[    0.531437] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
>18:45:00,764 DEBUG kernel:[    0.531883] pnp 00:03: [dma 2]
>18:45:00,764 DEBUG kernel:[    0.532089] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
>18:45:00,764 DEBUG kernel:[    0.532721] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
>18:45:00,764 DEBUG kernel:[    0.533430] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
>18:45:00,764 DEBUG kernel:[    0.534082] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active)
>18:45:00,764 DEBUG kernel:[    0.536398] pnp 00:07: Plug and Play ACPI device, IDs PNP0103 (active)
>18:45:00,764 INFO kernel:[    0.538263] pnp: PnP ACPI: found 8 devices
>18:45:00,764 INFO kernel:[    0.538818] ACPI: bus type PNP unregistered
>18:45:00,764 DEBUG kernel:[    0.561168] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7]
>18:45:00,764 DEBUG kernel:[    0.561171] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff]
>18:45:00,764 DEBUG kernel:[    0.561173] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff]
>18:45:00,764 DEBUG kernel:[    0.561175] pci_bus 0000:00: resource 7 [mem 0xe0000000-0xfebfffff]
>18:45:00,764 INFO kernel:[    0.561327] NET: Registered protocol family 2
>18:45:00,764 INFO kernel:[    0.563146] TCP established hash table entries: 32768 (order: 6, 262144 bytes)
>18:45:00,764 INFO kernel:[    0.565411] TCP bind hash table entries: 32768 (order: 9, 2621440 bytes)
>18:45:00,764 INFO kernel:[    0.568456] TCP: Hash tables configured (established 32768 bind 32768)
>18:45:00,764 INFO kernel:[    0.569636] TCP: reno registered
>18:45:00,764 INFO kernel:[    0.570310] UDP hash table entries: 2048 (order: 6, 393216 bytes)
>18:45:00,764 INFO kernel:[    0.571615] UDP-Lite hash table entries: 2048 (order: 6, 393216 bytes)
>18:45:00,764 INFO kernel:[    0.573320] NET: Registered protocol family 1
>18:45:00,764 INFO kernel:[    0.574095] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
>18:45:00,764 INFO kernel:[    0.575222] pci 0000:00:01.0: PIIX3: Enabling Passive Release
>18:45:00,764 INFO kernel:[    0.576302] pci 0000:00:01.0: Activating ISA DMA hang workarounds
>18:45:00,764 WARNING kernel:[    0.584358] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
>18:45:00,764 DEBUG kernel:[    0.591069] pci 0000:00:02.0: Boot video device
>18:45:00,764 DEBUG kernel:[    0.591115] PCI: CLS 0 bytes, default 64
>18:45:00,764 INFO kernel:[    0.591651] Unpacking initramfs...
>18:45:00,764 INFO kernel:[    4.293214] Freeing initrd memory: 34812K (ffff88007de00000 - ffff88007ffff000)
>18:45:00,764 INFO kernel:[    4.499442] DMA-API: preallocated 65536 debug entries
>18:45:00,764 INFO kernel:[    4.500132] DMA-API: debugging enabled by kernel config
>18:45:00,764 INFO kernel:[    4.500780] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
>18:45:00,764 INFO kernel:[    4.501629] software IO TLB [mem 0xdbffe000-0xdfffe000] (64MB) mapped at [ffff8800dbffe000-ffff8800dfffdfff]
>18:45:00,764 INFO kernel:[    4.505605] Scanning for low memory corruption every 60 seconds
>18:45:00,764 WARNING kernel:[    4.507547] cryptomgr_test (28) used greatest stack depth: 5912 bytes left
>18:45:00,764 WARNING kernel:[    4.513154] modprobe (36) used greatest stack depth: 5528 bytes left
>18:45:00,764 WARNING kernel:[    4.518177] cryptomgr_test (33) used greatest stack depth: 5272 bytes left
>18:45:00,764 INFO kernel:[    4.520364] alg: No test for __gcm-aes-aesni (__driver-gcm-aes-aesni)
>18:45:00,764 NOTICE kernel:[    4.525553] Initialise system trusted keyring
>18:45:00,764 INFO kernel:[    4.526332] audit: initializing netlink socket (disabled)
>18:45:00,764 NOTICE kernel:[    4.527074] type=2000 audit(1384713890.717:1): initialized
>18:45:00,764 INFO kernel:[    4.547244] HugeTLB registered 2 MB page size, pre-allocated 0 pages
>18:45:00,764 INFO kernel:[    4.571167] zbud: loaded
>18:45:00,764 NOTICE kernel:[    4.574730] VFS: Disk quotas dquot_6.5.2
>18:45:00,764 WARNING kernel:[    4.575533] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
>18:45:00,764 INFO kernel:[    4.580766] msgmni has been set to 7865
>18:45:00,764 NOTICE kernel:[    4.581829] Key type big_key registered
>18:45:00,764 DEBUG kernel:[    4.582328] SELinux:  Registering netfilter hooks
>18:45:00,764 INFO kernel:[    4.588227] alg: No test for stdrng (krng)
>18:45:00,764 INFO kernel:[    4.588802] NET: Registered protocol family 38
>18:45:00,764 NOTICE kernel:[    4.589476] Key type asymmetric registered
>18:45:00,764 NOTICE kernel:[    4.590023] Asymmetric key parser 'x509' registered
>18:45:00,764 INFO kernel:[    4.590985] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
>18:45:00,764 INFO kernel:[    4.592835] io scheduler noop registered
>18:45:00,764 INFO kernel:[    4.593386] io scheduler deadline registered
>18:45:00,764 INFO kernel:[    4.594766] io scheduler cfq registered (default)
>18:45:00,764 DEBUG kernel:[    4.596603] list_sort_test: start testing list_sort()
>18:45:00,764 INFO kernel:[    4.601255] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
>18:45:00,764 INFO kernel:[    4.602185] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
>18:45:00,764 DEBUG kernel:[    4.603589] intel_idle: does not run on family 6 model 42
>18:45:00,764 INFO kernel:[    4.605308] GHES: HEST is not enabled!
>18:45:00,764 INFO kernel:[    4.606602] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
>18:45:00,764 INFO kernel:[    4.631959] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
>18:45:00,764 INFO kernel:[    4.637296] Non-volatile memory driver v1.3
>18:45:00,764 INFO kernel:[    4.637954] Linux agpgart interface v0.103
>18:45:00,764 DEBUG kernel:[    4.640453] ata_piix 0000:00:01.1: version 2.13
>18:45:00,764 INFO kernel:[    4.644574] scsi0 : ata_piix
>18:45:00,764 INFO kernel:[    4.646660] scsi1 : ata_piix
>18:45:00,764 INFO kernel:[    4.647796] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0e0 irq 14
>18:45:00,764 INFO kernel:[    4.648891] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0e8 irq 15
>18:45:00,764 INFO kernel:[    4.650702] libphy: Fixed MDIO Bus: probed
>18:45:00,764 INFO kernel:[    4.651985] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
>18:45:00,764 INFO kernel:[    4.653109] ehci-pci: EHCI PCI platform driver
>18:45:00,764 INFO kernel:[    4.653780] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
>18:45:00,764 INFO kernel:[    4.654640] ohci-pci: OHCI PCI platform driver
>18:45:00,764 INFO kernel:[    4.655339] uhci_hcd: USB Universal Host Controller Interface driver
>18:45:00,764 INFO kernel:[    4.663429] uhci_hcd 0000:00:01.2: UHCI Host Controller
>18:45:00,764 INFO kernel:[    4.664790] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
>18:45:00,764 INFO kernel:[    4.665953] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c0c0
>18:45:00,764 INFO kernel:[    4.667343] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
>18:45:00,764 INFO kernel:[    4.668268] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
>18:45:00,764 INFO kernel:[    4.669217] usb usb1: Product: UHCI Host Controller
>18:45:00,764 INFO kernel:[    4.669827] usb usb1: Manufacturer: Linux 3.13.0-0.rc0.git4.1.fc21.x86_64 uhci_hcd
>18:45:00,764 INFO kernel:[    4.670822] usb usb1: SerialNumber: 0000:00:01.2
>18:45:00,764 INFO kernel:[    4.672970] hub 1-0:1.0: USB hub found
>18:45:00,764 INFO kernel:[    4.673837] hub 1-0:1.0: 2 ports detected
>18:45:00,764 INFO kernel:[    4.676414] usbcore: registered new interface driver usbserial
>18:45:00,764 INFO kernel:[    4.677275] usbcore: registered new interface driver usbserial_generic
>18:45:00,764 INFO kernel:[    4.678267] usbserial: USB Serial support registered for generic
>18:45:00,764 INFO kernel:[    4.679257] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
>18:45:00,764 INFO kernel:[    4.681951] serio: i8042 KBD port at 0x60,0x64 irq 1
>18:45:00,764 INFO kernel:[    4.683054] serio: i8042 AUX port at 0x60,0x64 irq 12
>18:45:00,764 INFO kernel:[    4.685460] mousedev: PS/2 mouse device common for all mice
>18:45:00,764 INFO kernel:[    4.687776] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
>18:45:00,764 INFO kernel:[    4.689773] rtc_cmos 00:00: RTC can wake from S4
>18:45:00,764 INFO kernel:[    4.692108] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
>18:45:00,764 INFO kernel:[    4.693911] rtc_cmos 00:00: alarms up to one day, 114 bytes nvram, hpet irqs
>18:45:00,764 INFO kernel:[    4.695705] device-mapper: uevent: version 1.0.3
>18:45:00,764 INFO kernel:[    4.697165] device-mapper: ioctl: 4.27.0-ioctl (2013-10-30) initialised: dm-devel@redhat.com
>18:45:00,764 INFO kernel:[    4.698919] Intel P-state driver initializing.
>18:45:00,764 INFO kernel:[    4.699967] Intel pstate controlling: cpu 0
>18:45:00,764 ERR kernel:[    4.700519] cpufreq: __cpufreq_add_dev: ->get() failed
>18:45:00,764 INFO kernel:[    4.701323] Intel pstate controlling: cpu 1
>18:45:00,764 ERR kernel:[    4.701898] cpufreq: __cpufreq_add_dev: ->get() failed
>18:45:00,764 INFO kernel:[    4.704232] hidraw: raw HID events driver (C) Jiri Kosina
>18:45:00,764 INFO kernel:[    4.706597] usbcore: registered new interface driver usbhid
>18:45:00,764 INFO kernel:[    4.707304] usbhid: USB HID core driver
>18:45:00,764 INFO kernel:[    4.708417] drop_monitor: Initializing network drop monitor service
>18:45:00,764 INFO kernel:[    4.710041] ip_tables: (C) 2000-2006 Netfilter Core Team
>18:45:00,764 INFO kernel:[    4.710711] TCP: cubic registered
>18:45:00,764 INFO kernel:[    4.711056] Initializing XFRM netlink socket
>18:45:00,764 INFO kernel:[    4.713940] NET: Registered protocol family 10
>18:45:00,764 INFO kernel:[    4.716841] mip6: Mobile IPv6
>18:45:00,764 INFO kernel:[    4.717310] NET: Registered protocol family 17
>18:45:00,764 NOTICE kernel:[    4.721991] Loading compiled-in X.509 certificates
>18:45:00,764 NOTICE kernel:[    4.724184] Loaded X.509 cert 'Fedora kernel signing key: aa261a16d0acb19f7a520ce80d7dd9113781f3cf'
>18:45:00,764 INFO kernel:[    4.725973] registered taskstats version 1
>18:45:00,764 INFO kernel:[    4.729372]   Magic number: 5:901:746
>18:45:00,764 INFO kernel:[    4.730196] rtc_cmos 00:00: setting system clock to 2013-11-17 18:44:50 UTC (1384713890)
>18:45:00,764 DEBUG kernel:[    4.732097] PM: Hibernation image not present or could not be loaded.
>18:45:00,764 DEBUG kernel:[    4.808626] ata1.01: NODEV after polling detection
>18:45:00,764 INFO kernel:[    4.808924] ata1.00: ATAPI: QEMU DVD-ROM, 1.6.90, max UDMA/100
>18:45:00,764 INFO kernel:[    4.810177] ata1.00: configured for MWDMA2
>18:45:00,764 NOTICE kernel:[    4.812304] scsi 0:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     1.6. PQ: 0 ANSI: 5
>18:45:00,764 WARNING kernel:[    4.814941] sr0: scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
>18:45:00,764 INFO kernel:[    4.815731] cdrom: Uniform CD-ROM driver Revision: 3.20
>18:45:00,764 DEBUG kernel:[    4.817879] sr 0:0:0:0: Attached scsi CD-ROM sr0
>18:45:00,764 NOTICE kernel:[    4.819329] sr 0:0:0:0: Attached scsi generic sg0 type 5
>18:45:00,764 INFO kernel:[    4.826184] Freeing unused kernel memory: 3732K (ffffffff81d88000 - ffffffff8212d000)
>18:45:00,764 INFO kernel:[    4.827498] Write protecting the kernel read-only data: 12288k
>18:45:00,764 INFO kernel:[    4.830470] Freeing unused kernel memory: 612K (ffff880001767000 - ffff880001800000)
>18:45:00,764 INFO kernel:[    4.833327] Freeing unused kernel memory: 888K (ffff880001b22000 - ffff880001c00000)
>18:45:00,764 INFO kernel:[    4.978962] usb 1-1: new full-speed USB device number 2 using uhci_hcd
>18:45:00,764 INFO kernel:[    5.012573] device-mapper: multipath: version 1.6.0 loaded
>18:45:00,764 INFO kernel:[    5.134051] usb 1-1: New USB device found, idVendor=0627, idProduct=0001
>18:45:00,764 INFO kernel:[    5.134892] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
>18:45:00,764 INFO kernel:[    5.136869] usb 1-1: Product: QEMU USB Tablet
>18:45:00,764 INFO kernel:[    5.137842] usb 1-1: Manufacturer: QEMU
>18:45:00,764 INFO kernel:[    5.139500] usb 1-1: SerialNumber: 42
>18:45:00,764 INFO kernel:[    5.154325] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/input/input3
>18:45:00,764 INFO kernel:[    5.159400] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Pointer [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0
>18:45:00,764 INFO kernel:[    5.212979] BIOS EDD facility v0.16 2004-Jun-25, 1 devices found
>18:45:00,764 INFO kernel:[    5.265243] usb 1-2: new full-speed USB device number 3 using uhci_hcd
>18:45:00,764 INFO kernel:[    5.418556] usb 1-2: New USB device found, idVendor=0409, idProduct=55aa
>18:45:00,764 INFO kernel:[    5.420450] usb 1-2: New USB device strings: Mfr=1, Product=2, SerialNumber=3
>18:45:00,764 INFO kernel:[    5.422094] usb 1-2: Product: QEMU USB Hub
>18:45:00,764 INFO kernel:[    5.422859] usb 1-2: Manufacturer: QEMU
>18:45:00,764 INFO kernel:[    5.423655] usb 1-2: SerialNumber: 314159-0000:00:01.2-2
>18:45:00,764 INFO kernel:[    5.426269] hub 1-2:1.0: USB hub found
>18:45:00,764 INFO kernel:[    5.427838] hub 1-2:1.0: 8 ports detected
>18:45:00,764 INFO kernel:[    5.504269] tsc: Refined TSC clocksource calibration: 2591.573 MHz
>18:45:00,764 INFO kernel:[    5.525798] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input2
>18:45:00,764 INFO kernel:[    5.868944] squashfs: version 4.0 (2009/01/31) Phillip Lougher
>18:45:00,764 INFO kernel:[    5.879680] Loading iSCSI transport class v2.0-870.
>18:45:00,764 NOTICE kernel:[    5.889687] iscsi: registered transport (tcp)
>18:45:00,764 INFO kernel:[    5.897507] alua: device handler registered
>18:45:00,764 INFO kernel:[    5.906287] emc: device handler registered
>18:45:00,764 INFO kernel:[    5.913454] hp_sw: device handler registered
>18:45:00,764 INFO kernel:[    5.921411] rdac: device handler registered
>18:45:00,764 INFO kernel:[    5.943642] FDC 0 is a S82078B
>18:45:00,764 WARNING kernel:[    5.945307] modprobe (341) used greatest stack depth: 5032 bytes left
>18:45:00,764 INFO kernel:[    5.960132] No iBFT detected.
>18:45:00,764 INFO kernel:[    5.967901] md: raid0 personality registered for level 0
>18:45:00,764 INFO kernel:[    5.977505] md: raid1 personality registered for level 1
>18:45:00,764 INFO kernel:[    5.984810] async_tx: api initialized (async)
>18:45:00,764 INFO kernel:[    5.987889] xor: automatically using best checksumming function:
>18:45:00,764 INFO kernel:[    5.999014]    avx       : 23204.000 MB/sec
>18:45:00,764 WARNING kernel:[    6.021067] raid6: sse2x1    7511 MB/s
>18:45:00,764 WARNING kernel:[    6.038042] raid6: sse2x2    9664 MB/s
>18:45:00,765 WARNING kernel:[    6.055049] raid6: sse2x4   11062 MB/s
>18:45:00,765 WARNING kernel:[    6.055801] raid6: using algorithm sse2x4 (11062 MB/s)
>18:45:00,765 WARNING kernel:[    6.056679] raid6: using ssse3x2 recovery algorithm
>18:45:00,765 INFO kernel:[    6.066254] md: raid6 personality registered for level 6
>18:45:00,765 INFO kernel:[    6.067217] md: raid5 personality registered for level 5
>18:45:00,765 INFO kernel:[    6.068238] md: raid4 personality registered for level 4
>18:45:00,765 INFO kernel:[    6.088508] md: raid10 personality registered for level 10
>18:45:00,765 INFO kernel:[    6.096759] md: linear personality registered for level -1
>18:45:00,765 INFO kernel:[    6.129998] device-mapper: multipath round-robin: version 1.0.0 loaded
>18:45:00,765 INFO kernel:[    6.151286] sha256_ssse3: Using AVX optimized SHA-256 implementation
>18:45:00,765 INFO kernel:[    6.195487] RPC: Registered named UNIX socket transport module.
>18:45:00,765 INFO kernel:[    6.196329] RPC: Registered udp transport module.
>18:45:00,765 INFO kernel:[    6.196994] RPC: Registered tcp transport module.
>18:45:00,765 INFO kernel:[    6.197596] RPC: Registered tcp NFSv4.1 backchannel transport module.
>18:45:00,765 WARNING kernel:[    6.287211] rpc.statd (378) used greatest stack depth: 4504 bytes left
>18:45:00,765 INFO kernel:[    6.756925] [drm] Initialized drm 1.1.0 20060810
>18:45:00,765 WARNING kernel:[    6.819522] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
>18:45:00,765 WARNING kernel:[    6.826073] cdrom_id (489) used greatest stack depth: 3928 bytes left
>18:45:00,765 INFO kernel:[    6.859163] alg: No test for crc32 (crc32-pclmul)
>18:45:00,765 WARNING kernel:[    6.885363] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10
>18:45:00,765 INFO kernel:[    6.919638] [drm] Device Version 0.0
>18:45:00,765 INFO kernel:[    6.921120] [drm] Compression level 0 log level 0
>18:45:00,765 INFO kernel:[    6.922114] [drm] Currently using mode #0, list at 0x488
>18:45:00,765 INFO kernel:[    6.924269] [drm] 12286 io pages at offset 0x1000000
>18:45:00,765 INFO kernel:[    6.925164] [drm] 16777216 byte draw area at offset 0x0
>18:45:00,765 INFO kernel:[    6.925963] [drm] RAM header offset: 0x3ffe000
>18:45:00,765 INFO kernel:[    6.926671] [drm] rom modes offset 0x488 for 128 modes
>18:45:00,765 INFO kernel:[    6.934276] [TTM] Zone  kernel: Available graphics memory: 2016156 kiB
>18:45:00,765 INFO kernel:[    6.936178] [TTM] Initializing pool allocator
>18:45:00,765 INFO kernel:[    6.952652] [TTM] Initializing DMA pool allocator
>18:45:00,765 INFO kernel:[    6.955294] [drm] qxl: 16M of VRAM memory size
>18:45:00,765 INFO kernel:[    6.956218] [drm] qxl: 63M of IO pages memory ready (VRAM domain)
>18:45:00,765 INFO kernel:[    6.962809] [drm] main mem slot 1 [f4000000,3ffe000)
>18:45:00,765 INFO kernel:[    6.976922] [drm] fb mappable at 0xF4000000, size 3145728
>18:45:00,765 INFO kernel:[    6.979330] [drm] fb: depth 24, pitch 4096, width 1024, height 768
>18:45:00,765 INFO kernel:[    6.982370] fbcon: qxldrmfb (fb0) is primary device
>18:45:00,765 INFO kernel:[    7.067937] Console: switching to colour frame buffer device 128x48
>18:45:00,765 INFO kernel:[    7.127638] qxl 0000:00:02.0: fb0: qxldrmfb frame buffer device
>18:45:00,765 INFO kernel:[    7.128482] qxl 0000:00:02.0: registered panic notifier
>18:45:00,765 INFO kernel:[    7.129376] [drm] Initialized qxl 0.1.0 20120117 for 0000:00:02.0 on minor 0
>18:45:00,765 WARNING kernel:[    7.175262] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 11
>18:45:00,765 DEBUG kernel:[    7.204811] virtio-pci 0000:00:05.0: irq 40 for MSI/MSI-X
>18:45:00,765 DEBUG kernel:[    7.205370] virtio-pci 0000:00:03.0: irq 42 for MSI/MSI-X
>18:45:00,765 DEBUG kernel:[    7.205564] virtio-pci 0000:00:03.0: irq 43 for MSI/MSI-X
>18:45:00,765 DEBUG kernel:[    7.205731] virtio-pci 0000:00:03.0: irq 44 for MSI/MSI-X
>18:45:00,765 DEBUG kernel:[    7.207232] virtio-pci 0000:00:05.0: irq 41 for MSI/MSI-X
>18:45:00,765 INFO kernel:[    7.232366]  vda: unknown partition table
>18:45:00,765 WARNING kernel:[    7.351186] systemd-udevd (480) used greatest stack depth: 2472 bytes left
>18:45:00,765 DEBUG kernel:[    8.335698] ISO 9660 Extensions: Microsoft Joliet Level 3
>18:45:00,765 DEBUG kernel:[    8.342587] ISO 9660 Extensions: RRIP_1991A
>18:45:00,765 INFO kernel:[    8.498486] loop: module loaded
>18:45:00,765 INFO kernel:[    8.628735] bio: create slab <bio-1> at 1
>18:45:00,765 INFO kernel:[    8.693961] bio: create slab <bio-2> at 2
>18:45:00,765 INFO kernel:[    9.223850] EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null)
>18:45:00,765 DEBUG kernel:[   10.596271] SELinux: 2048 avtab hash slots, 101218 rules.
>18:45:00,765 DEBUG kernel:[   11.193279] SELinux: 2048 avtab hash slots, 101218 rules.
>18:45:00,765 DEBUG kernel:[   12.124623] SELinux:  8 users, 98 roles, 4638 types, 264 bools, 1 sens, 1024 cats
>18:45:00,765 DEBUG kernel:[   12.124628] SELinux:  83 classes, 101218 rules
>18:45:00,765 DEBUG kernel:[   12.340555] SELinux:  Completing initialization.
>18:45:00,765 DEBUG kernel:[   12.340560] SELinux:  Setting up existing superblocks.
>18:45:00,765 DEBUG kernel:[   12.340658] SELinux: initialized (dev sysfs, type sysfs), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.340728] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>18:45:00,765 DEBUG kernel:[   12.342758] SELinux: initialized (dev rootfs, type rootfs), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.342853] SELinux: initialized (dev bdev, type bdev), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.342899] SELinux: initialized (dev proc, type proc), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.343056] SELinux: initialized (dev devtmpfs, type devtmpfs), uses transition SIDs
>18:45:00,765 DEBUG kernel:[   12.345910] SELinux: initialized (dev debugfs, type debugfs), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.354149] SELinux: initialized (dev sockfs, type sockfs), uses task SIDs
>18:45:00,765 DEBUG kernel:[   12.354202] SELinux: initialized (dev pipefs, type pipefs), uses task SIDs
>18:45:00,765 DEBUG kernel:[   12.354271] SELinux: initialized (dev anon_inodefs, type anon_inodefs), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.354321] SELinux: initialized (dev aio, type aio), not configured for labeling
>18:45:00,765 DEBUG kernel:[   12.354366] SELinux: initialized (dev devpts, type devpts), uses transition SIDs
>18:45:00,765 DEBUG kernel:[   12.354538] SELinux: initialized (dev hugetlbfs, type hugetlbfs), uses transition SIDs
>18:45:00,765 DEBUG kernel:[   12.354615] SELinux: initialized (dev mqueue, type mqueue), uses transition SIDs
>18:45:00,765 DEBUG kernel:[   12.354680] SELinux: initialized (dev selinuxfs, type selinuxfs), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.354783] SELinux: initialized (dev sysfs, type sysfs), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.357382] SELinux: initialized (dev securityfs, type securityfs), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.357402] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>18:45:00,765 DEBUG kernel:[   12.357448] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>18:45:00,765 DEBUG kernel:[   12.358059] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>18:45:00,765 DEBUG kernel:[   12.358232] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358360] SELinux: initialized (dev pstore, type pstore), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358379] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358417] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358450] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358511] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358533] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358551] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358570] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358637] SELinux: initialized (dev cgroup, type cgroup), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358708] SELinux: initialized (dev rpc_pipefs, type rpc_pipefs), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358788] SELinux: initialized (dev sr0, type iso9660), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   12.358999] SELinux: initialized (dev loop0, type squashfs), uses xattr
>18:45:00,765 DEBUG kernel:[   12.359612] SELinux: initialized (dev dm-0, type ext4), uses xattr
>18:45:00,765 NOTICE kernel:[   12.412688] type=1403 audit(1384713898.181:2): policy loaded auid=4294967295 ses=4294967295
>18:45:00,765 DEBUG kernel:[   13.088126] SELinux: initialized (dev autofs, type autofs), uses genfs_contexts
>18:45:00,765 DEBUG kernel:[   13.257443] SELinux: initialized (dev hugetlbfs, type hugetlbfs), uses transition SIDs
>18:45:00,765 DEBUG kernel:[   13.310951] SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
>18:45:00,765 DEBUG kernel:[   13.332894] SELinux: initialized (dev configfs, type configfs), uses genfs_contexts
>18:45:00,765 NOTICE kernel:[   14.450313] type=1400 audit(1384713900.219:3): avc:  denied  { create } for  pid=872 comm="systemd-tmpfile" name="tmp" scontext=system_u:system_r:systemd_tmpfiles_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir
>18:45:00,765 NOTICE kernel:[   14.450708] type=1400 audit(1384713900.219:4): avc:  denied  { setattr } for  pid=872 comm="systemd-tmpfile" name="tmp" dev="dm-0" ino=91930 scontext=system_u:system_r:systemd_tmpfiles_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir
>18:45:00,765 NOTICE kernel:[   14.450869] type=1400 audit(1384713900.219:5): avc:  denied  { relabelfrom } for  pid=872 comm="systemd-tmpfile" name="tmp" dev="dm-0" ino=91930 scontext=system_u:system_r:systemd_tmpfiles_t:s0 tcontext=system_u:object_r:var_t:s0 tclass=dir
>18:45:00,765 INFO kernel:[   14.769117] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0xb100, revision 0
>18:45:00,765 INFO kernel:[   14.876233] parport_pc 00:04: reported by Plug and Play ACPI
>18:45:01,000 DEBUG kernel:[   15.229391] virtio-pci 0000:00:06.0: irq 45 for MSI/MSI-X
>18:45:01,000 DEBUG kernel:[   15.229580] virtio-pci 0000:00:06.0: irq 46 for MSI/MSI-X
>18:45:01,002 NOTICE kernel:[   15.232227] type=1400 audit(1384713901.001:6): avc:  denied  { read } for  pid=883 comm="bash" name=".profile" dev="dm-0" ino=8194 scontext=system_u:system_r:getty_t:s0-s0:c0.c1023 tcontext=unconfined_u:object_r:admin_home_t:s0 tclass=file
>18:45:01,002 NOTICE kernel:[   15.232324] type=1400 audit(1384713901.001:7): avc:  denied  { open } for  pid=883 comm="bash" path="/root/.profile" dev="dm-0" ino=8194 scontext=system_u:system_r:getty_t:s0-s0:c0.c1023 tcontext=unconfined_u:object_r:admin_home_t:s0 tclass=file
>18:45:01,622 INFO kernel:[   15.852421] microcode: CPU0 sig=0x206a1, pf=0x1, revision=0x1
>18:45:01,779 INFO NetworkManager: <info> NetworkManager (version 0.9.9.0-15.git20131003.fc21) is starting...
>18:45:01,779 INFO NetworkManager: <info> Read config: /etc/NetworkManager/NetworkManager.conf
>18:45:01,779 INFO NetworkManager: <info> WEXT support is enabled
>18:45:01,881 WARNING kernel:[   16.110763] platform microcode: Direct firmware load failed with error -2
>18:45:01,881 WARNING kernel:[   16.110767] platform microcode: Falling back to user helper
>18:45:01,891 INFO kernel:[   16.121884] microcode: CPU1 sig=0x206a1, pf=0x1, revision=0x1
>18:45:01,893 WARNING kernel:[   16.122369] platform microcode: Direct firmware load failed with error -2
>18:45:01,893 WARNING kernel:[   16.122373] platform microcode: Falling back to user helper
>18:45:01,926 INFO kernel:[   16.155830] microcode: Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
>18:45:02,094 NOTICE dbus: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service'
>18:45:02,230 INFO polkitd: Started polkitd version 0.112
>18:45:02,489 NOTICE dbus: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
>18:45:02,565 WARNING NetworkManager:    ifcfg-rh: Could not get hostname: failed to read /etc/sysconfig/network
>18:45:02,567 NOTICE NetworkManager:    ifcfg-rh: Acquired D-Bus service com.redhat.ifcfgrh1
>18:45:02,567 INFO NetworkManager: <info> Loaded plugin ifcfg-rh: (c) 2007 - 2010 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
>18:45:02,567 INFO NetworkManager: <info> Loaded plugin keyfile: (c) 2007 - 2010 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
>18:45:02,723 NOTICE NetworkManager:    ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-lo ... 
>18:45:02,728 NOTICE dbus: [system] Activating via systemd: service name='org.freedesktop.login1' unit='dbus-org.freedesktop.login1.service'
>18:45:02,835 NOTICE dbus: [system] Successfully activated service 'org.freedesktop.login1'
>18:45:02,859 INFO NetworkManager: <info> monitoring kernel firmware directory '/lib/firmware'.
>18:45:02,900 INFO NetworkManager: <info> WiFi enabled by radio killswitch; enabled by state file
>18:45:02,900 INFO NetworkManager: <info> WWAN enabled by radio killswitch; enabled by state file
>18:45:02,900 INFO NetworkManager: <info> WiMAX enabled by radio killswitch; enabled by state file
>18:45:02,900 INFO NetworkManager: <info> Networking is enabled by state file
>18:45:02,938 INFO NetworkManager: <info> startup complete
>18:45:03,031 INFO NetworkManager: <info> (lo): link connected
>18:45:03,031 INFO NetworkManager: <info> (lo): carrier is ON
>18:45:03,031 INFO NetworkManager: <info> (lo): new Generic device (driver: 'unknown' ifindex: 1)
>18:45:03,031 INFO NetworkManager: <info> (lo): exported as /org/freedesktop/NetworkManager/Devices/0
>18:45:03,031 INFO NetworkManager: <info> (lo): No existing connection detected.
>18:45:03,046 INFO NetworkManager: <info> (eth0): carrier is OFF
>18:45:03,046 INFO NetworkManager: <info> (eth0): new Ethernet device (driver: 'virtio_net' ifindex: 2)
>18:45:03,047 INFO NetworkManager: <info> (eth0): exported as /org/freedesktop/NetworkManager/Devices/1
>18:45:03,047 INFO NetworkManager: <info> (eth0): No existing connection detected.
>18:45:03,047 INFO NetworkManager: <info> (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
>18:45:03,047 INFO NetworkManager: <info> (eth0): bringing up device.
>18:45:03,054 INFO NetworkManager: <info> (eth0): link connected
>18:45:03,060 INFO NetworkManager: <info> Added default wired connection 'Wired connection 1' for /sys/devices/pci0000:00/0000:00:03.0/virtio0/net/eth0
>18:45:03,075 INFO NetworkManager: <info> (eth0): device state change: unavailable -> disconnected (reason 'carrier-changed') [20 30 40]
>18:45:03,095 INFO NetworkManager: <info> Auto-activating connection 'Wired connection 1'.
>18:45:03,096 INFO NetworkManager: <info> Activation (eth0) starting connection 'Wired connection 1'
>18:45:03,096 INFO NetworkManager: <info> (eth0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
>18:45:03,096 INFO NetworkManager: <info> NetworkManager state is now CONNECTING
>18:45:03,096 INFO NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
>18:45:03,097 WARNING NetworkManager: <warn> Couldn't get managed objects: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.bluez was not provided by any .service files
>18:45:03,097 INFO NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) started...
>18:45:03,097 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
>18:45:03,097 INFO NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
>18:45:03,098 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) starting...
>18:45:03,098 INFO NetworkManager: <info> (eth0): device state change: prepare -> config (reason 'none') [40 50 0]
>18:45:03,098 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) successful.
>18:45:03,098 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
>18:45:03,100 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) complete.
>18:45:03,101 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
>18:45:03,101 INFO NetworkManager: <info> (eth0): device state change: config -> ip-config (reason 'none') [50 70 0]
>18:45:03,105 INFO NetworkManager: <info> Activation (eth0) Beginning DHCPv4 transaction (timeout in 45 seconds)
>18:45:03,198 INFO NetworkManager: <info> dhclient started with pid 923
>18:45:03,201 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
>18:45:03,202 ERR NetworkManager: <error> [1384713903.202658] [rdisc/nm-lndp-rdisc.c:194] send_rs(): (eth0): cannot send router solicitation: -99.
>18:45:04,014 INFO dhclient: Internet Systems Consortium DHCP Client 4.2.5
>18:45:04,015 INFO dhclient: Copyright 2004-2013 Internet Systems Consortium.
>18:45:04,015 INFO dhclient: All rights reserved.
>18:45:04,015 INFO dhclient: For info, please visit https://www.isc.org/software/dhcp/
>18:45:04,015 INFO dhclient: 
>18:45:04,081 INFO NetworkManager: <info> (eth0): DHCPv4 state changed nbi -> preinit
>18:45:04,128 INFO dhclient: Listening on LPF/eth0/52:54:00:a2:a3:a7
>18:45:04,128 INFO dhclient: Sending on   LPF/eth0/52:54:00:a2:a3:a7
>18:45:04,128 INFO dhclient: Sending on   Socket/fallback
>18:45:04,128 INFO dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 4 (xid=0x4198b87f)
>18:45:04,133 INFO dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67 (xid=0x4198b87f)
>18:45:04,134 INFO dhclient: DHCPOFFER from 192.168.13.1
>18:45:04,476 INFO dhclient: DHCPACK from 192.168.13.1 (xid=0x4198b87f)
>18:45:04,510 INFO NetworkManager: <info> (eth0): DHCPv4 state changed preinit -> bound
>18:45:04,513 INFO NetworkManager: <info>   address 192.168.13.53
>18:45:04,513 INFO NetworkManager: <info>   plen 24 (255.255.255.0)
>18:45:04,513 INFO NetworkManager: <info>   gateway 192.168.13.1
>18:45:04,513 INFO NetworkManager: <info>   lease time 3600
>18:45:04,513 INFO NetworkManager: <info>   hostname 'ipa'
>18:45:04,513 INFO NetworkManager: <info>   nameserver '192.168.13.1'
>18:45:04,513 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
>18:45:04,514 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Commit) started...
>18:45:04,528 INFO NetworkManager: <info> (eth0): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
>18:45:04,532 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Commit) complete.
>18:45:04,555 INFO dhclient: bound to 192.168.13.53 -- renewal in 1700 seconds.
>18:45:04,564 INFO NetworkManager: <info> (eth0): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
>18:45:04,565 INFO NetworkManager: <info> (eth0): device state change: secondaries -> activated (reason 'none') [90 100 0]
>18:45:04,566 INFO NetworkManager: <info> NetworkManager state is now CONNECTED_GLOBAL
>18:45:04,568 INFO NetworkManager: <info> Policy set 'Wired connection 1' (eth0) as default for IPv4 routing and DNS.
>18:45:04,575 INFO NetworkManager: <info> Setting system hostname to 'ipa' (from DHCPv4)
>18:45:04,576 NOTICE dbus: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
>18:45:04,597 INFO NetworkManager: <info> Activation (eth0) successful, device activated.
>18:45:04,649 WARNING spice-vdagentd: no session info, max 1 session agent allowed
>18:45:04,728 NOTICE dbus: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
>18:45:08,617 NOTICE kernel:[   22.846432] type=1400 audit(1384713908.615:8): avc:  denied  { read write } for  pid=983 comm="auditd" path="/dev/mapper/control" dev="devtmpfs" ino=6078 scontext=system_u:system_r:auditd_t:s0 tcontext=system_u:object_r:lvm_control_t:s0 tclass=chr_file
>18:46:46,969 NOTICE NetworkManager:    ifcfg-rh:     read connection 'eth0'
>18:46:46,970 INFO NetworkManager: <info> (eth0): device state change: activated -> disconnected (reason 'connection-removed') [100 30 38]
>18:46:46,970 INFO NetworkManager: <info> (eth0): deactivating device (reason 'connection-removed') [38]
>18:46:47,172 INFO NetworkManager: <info> (eth0): canceled DHCP transaction, DHCP client pid 923
>18:46:47,194 INFO NetworkManager: <info> NetworkManager state is now DISCONNECTED
>18:46:47,194 INFO NetworkManager: <info> Setting system hostname to 'localhost.localdomain' (no default device)
>18:46:47,200 NOTICE dbus: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
>18:46:47,201 INFO NetworkManager: <info> Saved default wired connection 'eth0' to persistent storage
>18:46:47,203 INFO NetworkManager: <info> Auto-activating connection 'eth0'.
>18:46:47,203 INFO NetworkManager: <info> Activation (eth0) starting connection 'eth0'
>18:46:47,203 INFO NetworkManager: <info> (eth0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
>18:46:47,203 INFO NetworkManager: <info> NetworkManager state is now CONNECTING
>18:46:47,203 INFO NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
>18:46:47,209 INFO NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) started...
>18:46:47,209 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
>18:46:47,209 INFO NetworkManager: <info> Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
>18:46:47,210 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) starting...
>18:46:47,210 INFO NetworkManager: <info> (eth0): device state change: prepare -> config (reason 'none') [40 50 0]
>18:46:47,211 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) successful.
>18:46:47,211 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
>18:46:47,211 INFO NetworkManager: <info> Activation (eth0) Stage 2 of 5 (Device Configure) complete.
>18:46:47,211 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
>18:46:47,211 INFO NetworkManager: <info> (eth0): device state change: config -> ip-config (reason 'none') [50 70 0]
>18:46:47,212 INFO NetworkManager: <info> Activation (eth0) Beginning DHCPv4 transaction (timeout in 45 seconds)
>18:46:47,230 INFO NetworkManager: <info> dhclient started with pid 1016
>18:46:47,231 INFO NetworkManager: <info> Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
>18:46:47,242 NOTICE dbus: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
>18:46:47,273 INFO dhclient: Internet Systems Consortium DHCP Client 4.2.5
>18:46:47,273 INFO dhclient: Copyright 2004-2013 Internet Systems Consortium.
>18:46:47,273 INFO dhclient: All rights reserved.
>18:46:47,273 INFO dhclient: For info, please visit https://www.isc.org/software/dhcp/
>18:46:47,274 INFO dhclient: 
>18:46:47,296 INFO NetworkManager: <info> (eth0): DHCPv4 state changed nbi -> preinit
>18:46:47,302 INFO dhclient: Listening on LPF/eth0/52:54:00:a2:a3:a7
>18:46:47,302 INFO dhclient: Sending on   LPF/eth0/52:54:00:a2:a3:a7
>18:46:47,302 INFO dhclient: Sending on   Socket/fallback
>18:46:47,302 INFO dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67 (xid=0x60a7f202)
>18:46:47,320 NOTICE NetworkManager:    ifcfg-rh: updating /etc/sysconfig/network-scripts/ifcfg-eth0
>18:46:47,643 INFO dhclient: DHCPACK from 192.168.13.1 (xid=0x60a7f202)
>18:46:47,658 INFO NetworkManager: <info> (eth0): DHCPv4 state changed preinit -> reboot
>18:46:47,659 INFO NetworkManager: <info>   address 192.168.13.53
>18:46:47,659 INFO NetworkManager: <info>   plen 24 (255.255.255.0)
>18:46:47,659 INFO NetworkManager: <info>   gateway 192.168.13.1
>18:46:47,659 INFO NetworkManager: <info>   lease time 3600
>18:46:47,659 INFO NetworkManager: <info>   hostname 'ipa'
>18:46:47,659 INFO NetworkManager: <info>   nameserver '192.168.13.1'
>18:46:47,659 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
>18:46:47,659 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Commit) started...
>18:46:47,660 INFO NetworkManager: <info> (eth0): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
>18:46:47,660 INFO NetworkManager: <info> Activation (eth0) Stage 5 of 5 (IPv4 Commit) complete.
>18:46:47,665 INFO dhclient: bound to 192.168.13.53 -- renewal in 1670 seconds.
>18:46:47,667 INFO NetworkManager: <info> (eth0): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
>18:46:47,667 INFO NetworkManager: <info> (eth0): device state change: secondaries -> activated (reason 'none') [90 100 0]
>18:46:47,675 INFO NetworkManager: <info> NetworkManager state is now CONNECTED_GLOBAL
>18:46:47,676 INFO NetworkManager: <info> Policy set 'eth0' (eth0) as default for IPv4 routing and DNS.
>18:46:47,676 INFO NetworkManager: <info> Setting system hostname to 'ipa' (from DHCPv4)
>18:46:47,676 INFO chronyd: chronyd version 1.29 starting
>18:46:47,678 INFO NetworkManager: <info> Activation (eth0) successful, device activated.
>18:46:47,681 INFO chronyd: Linux kernel major=3 minor=13 patch=0
>18:46:47,681 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
>18:46:47,683 INFO chronyd: Generated key 1
>18:46:49,266 NOTICE kernel:[  123.495903] type=1400 audit(1384714009.264:9): avc:  denied  { read write } for  pid=1135 comm="hwclock" path="/dev/pts/0" dev="devpts" ino=3 scontext=system_u:system_r:hwclock_t:s0 tcontext=system_u:object_r:devpts_t:s0 tclass=chr_file
>18:46:49,267 NOTICE kernel:[  123.497689] type=1400 audit(1384714009.266:10): avc:  denied  { read write } for  pid=1135 comm="hwclock" path="/dev/mapper/control" dev="devtmpfs" ino=6078 scontext=system_u:system_r:hwclock_t:s0 tcontext=system_u:object_r:lvm_control_t:s0 tclass=chr_file
>18:46:49,001 NOTICE kernel:[  123.549378] type=1400 audit(1384714009.000:11): avc:  denied  { ioctl } for  pid=1135 comm="hwclock" path="/dev/pts/0" dev="devpts" ino=3 scontext=system_u:system_r:hwclock_t:s0 tcontext=system_u:object_r:devpts_t:s0 tclass=chr_file
>18:46:49,001 NOTICE kernel:[  123.549443] type=1400 audit(1384714009.000:12): avc:  denied  { getattr } for  pid=1135 comm="hwclock" path="/dev/pts/0" dev="devpts" ino=3 scontext=system_u:system_r:hwclock_t:s0 tcontext=system_u:object_r:devpts_t:s0 tclass=chr_file
>18:46:52,877 INFO chronyd: Selected source 185.18.149.149
>18:46:52,877 WARNING chronyd: System clock wrong by 1.093572 seconds, adjustment started
>18:46:54,244 INFO chronyd: Selected source 178.63.64.14
>18:47:58,802 INFO chronyd: Selected source 217.79.179.106

Actions: View

Attachments on bug 1031424: 825282 | 825283 | 825284 | 825285 | 825286 | 825287 | 825288 | 825289 | 825290 | 825291 | 825292