Attachment 917457 Details for Bug 1118923 – storage.log from an affected run

storage.log from an affected run

storage.log (text/plain), 16.37 KB, created by Adam Williamson on 2014-07-12 00:22:31 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Adam Williamson

Created: 2014-07-12 00:22:31 UTC

Size: 16.37 KB

patch

obsolete

>23:45:32,989 DEBUG blivet: IGNORED:    Caught exception, continuing.
>23:45:32,990 DEBUG blivet: IGNORED:    Problem description: failed to get initiator name from iscsi firmware
>23:45:32,990 DEBUG blivet: IGNORED:    Begin exception details.
>23:45:32,990 DEBUG blivet: IGNORED:        Traceback (most recent call last):
>23:45:32,990 DEBUG blivet: IGNORED:          File "/usr/lib/python2.7/site-packages/blivet/iscsi.py", line 87, in __init__
>23:45:32,991 DEBUG blivet: IGNORED:            initiatorname = libiscsi.get_firmware_initiator_name()
>23:45:32,991 DEBUG blivet: IGNORED:        IOError: Unknown error
>23:45:32,991 DEBUG blivet: IGNORED:    End exception details.
>23:45:32,991 INFO blivet: ISCSID is /sbin/iscsid
>23:45:32,991 INFO blivet: no initiator set
>23:45:33,132 INFO blivet: No FCoE EDD info found: No FCoE boot disk information is found in EDD!
>23:45:33,132 INFO blivet: no /etc/zfcp.conf; not configuring zfcp
>23:45:35,058 DEBUG blivet: trying to set new default fstype to 'ext4'
>23:45:35,092 DEBUG blivet:           Ext4FS.supported: supported: True ;
>23:45:35,105 DEBUG blivet: getFormat('ext4') returning Ext4FS instance with object id 0
>23:45:35,107 DEBUG blivet:        Ext4FS.supported: supported: True ;
>23:45:35,115 DEBUG blivet: IGNORED:       Caught exception, continuing.
>23:45:35,115 DEBUG blivet: IGNORED:       Problem description: failed to get initiator name from iscsi firmware
>23:45:35,115 DEBUG blivet: IGNORED:       Begin exception details.
>23:45:35,116 DEBUG blivet: IGNORED:           Traceback (most recent call last):
>23:45:35,116 DEBUG blivet: IGNORED:             File "/usr/lib/python2.7/site-packages/blivet/iscsi.py", line 87, in __init__
>23:45:35,117 DEBUG blivet: IGNORED:               initiatorname = libiscsi.get_firmware_initiator_name()
>23:45:35,117 DEBUG blivet: IGNORED:           IOError: Unknown error
>23:45:35,117 DEBUG blivet: IGNORED:       End exception details.
>23:45:35,604 INFO blivet: Detected 2048 MiB of memory
>23:45:35,623 INFO blivet: Suggested swap size (2048 MiB) exceeds 10 % of disk space, using 10 % of disk space (0.0) instead.
>23:45:35,647 INFO blivet: Swap attempt of 0.0
>23:45:35,971 INFO blivet: resetting Blivet (version 0.60) instance <blivet.Blivet object at 0x7facc2a9b750>
>23:45:35,971 INFO blivet: no initiator set
>23:45:35,971 INFO blivet: not going to create backup copy of non-existent /etc/mdadm.conf
>23:45:35,972 INFO blivet: DeviceTree.populate: ignoredDisks is [] ; exclusiveDisks is []
>23:45:36,235 DEBUG blivet: protected device spec LABEL=Fedora-rawhide-x86-64 resolved to sr0
>23:45:36,693 INFO blivet: devices to scan: ['sr0', 'vda', 'vda1', 'vda2', 'vda3', 'vda4', 'loop0', 'loop1', 'loop2', 'dm-0', 'dm-1']
>23:45:36,727 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/cdrom /dev/disk/by-id/ata-QEMU_DVD-ROM_QM00003 /dev/disk/by-label/Fedora-rawhide-x86-64 /dev/disk/by-uuid/2014-07-10-09-59-55-00',
> 'DEVNAME': 'sr0',
> 'DEVPATH': '/devices/pci0000:00/0000:00:01.1/ata8/host7/target7:0:0/7:0:0:0/block/sr0',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1405122326',
> '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-rawhide-x86-64',
> 'ID_FS_SYSTEM_ID': 'LINUX',
> 'ID_FS_TYPE': 'iso9660',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '2014-07-10-09-59-55-00',
> 'ID_FS_UUID_ENC': '2014-07-10-09-59-55-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': '295f6dd2',
> 'ID_REVISION': '2.0.91',
> 'ID_SERIAL': 'QEMU_DVD-ROM_QM00003',
> 'ID_SERIAL_SHORT': 'QM00003',
> 'ID_TYPE': 'cd',
> 'MAJOR': '11',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':seat:systemd:uaccess:',
> 'USEC_INITIALIZED': '92775',
> 'name': 'sr0',
> 'symlinks': ['/dev/cdrom',
>              '/dev/disk/by-id/ata-QEMU_DVD-ROM_QM00003',
>              '/dev/disk/by-label/Fedora-rawhide-x86-64',
>              '/dev/disk/by-uuid/2014-07-10-09-59-55-00'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:01.1/ata8/host7/target7:0:0/7:0:0:0/block/sr0'} ; name: sr0 ;
>23:45:36,730 INFO blivet: scanning sr0 (/devices/pci0000:00/0000:00:01.1/ata8/host7/target7:0:0/7:0:0:0/block/sr0)...
>23:45:36,731 DEBUG blivet:           DeviceTree.getDeviceByName: hidden: False ; name: sr0 ; incomplete: False ;
>23:45:36,732 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>23:45:36,734 INFO blivet: sr0 is a cdrom
>23:45:36,735 DEBUG blivet:           DeviceTree.addUdevOpticalDevice:
>23:45:36,741 DEBUG blivet: getFormat('None') returning DeviceFormat instance with object id 2
>23:45:36,743 DEBUG blivet:               OpticalDevice._setFormat: sr0 ; current: None ; type: None ;
>23:45:36,784 INFO blivet: added cdrom sr0 (id 1) to device tree
>23:45:36,787 DEBUG blivet:                        OpticalDevice.mediaPresent: sr0 ; status: True ;
>23:45:36,789 DEBUG blivet: looking up parted Device: /dev/sr0
>23:45:36,784 INFO blivet: got device: OpticalDevice instance (0x7facc150ac50) --
>  name = sr0  status = True  kids = 0 id = 1
>  parents = []
>  uuid = None  size = 398 MiB
>  format = existing None
>  major = 11  minor = 0  exists = True  protected = True
>  sysfs path = /devices/pci0000:00/0000:00:01.1/ata8/host7/target7:0:0/7:0:0:0/block/sr0  partedDevice = parted.Device instance --
>  model: QEMU QEMU DVD-ROM  path: /dev/sr0  type: 1
>  sectorSize: 2048  physicalSectorSize:  2048
>  length: 203776  openCount: 0  readOnly: True
>  externalMode: False  dirty: False  bootDirty: False
>  host: 8  did: 0  busy: True
>  hardwareGeometry: (12, 255, 63)  biosGeometry: (12, 255, 63)
>  PedDevice: <_ped.Device object at 0x7facb6f4a320>
>  target size = 0 B  path = /dev/sr0
>  format args = []  originalFormat = None
>23:45:36,878 DEBUG blivet:                        OpticalDevice.mediaPresent: sr0 ; status: True ;
>23:45:36,982 DEBUG blivet:                        OpticalDevice.mediaPresent: sr0 ; status: True ;
>23:45:37,042 DEBUG blivet:                        OpticalDevice.mediaPresent: sr0 ; status: True ;
>23:45:37,056 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: sr0 ;
>23:45:37,058 DEBUG blivet:            OpticalDevice.mediaPresent: sr0 ; status: True ;
>23:45:37,062 INFO blivet: type detected on 'sr0' is 'iso9660'
>23:45:37,063 DEBUG blivet:              Iso9660FS.supported: supported: True ;
>23:45:37,064 DEBUG blivet: getFormat('iso9660') returning Iso9660FS instance with object id 4
>23:45:37,064 DEBUG blivet:             OpticalDevice._setFormat: sr0 ; current: None ; type: iso9660 ;
>23:45:37,065 INFO blivet: got format: existing iso9660 filesystem
>23:45:37,067 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVNAME': 'vda',
> 'DEVPATH': '/devices/pci0000:00/0000:00:07.0/virtio3/block/vda',
> 'DEVTYPE': 'disk',
> 'DM_MULTIPATH_TIMESTAMP': '1405122326',
> 'ID_PART_TABLE_TYPE': 'gpt',
> 'ID_PART_TABLE_UUID': 'e29598a9-e5ce-4fa2-9b1c-a56177bcd738',
> 'MAJOR': '252',
> 'MINOR': '0',
> 'MPATH_SBIN_PATH': '/sbin',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '874950',
> 'name': 'vda',
> 'symlinks': [],
> 'sysfs_path': '/devices/pci0000:00/0000:00:07.0/virtio3/block/vda'} ; name: vda ;
>23:45:37,073 INFO blivet: scanning vda (/devices/pci0000:00/0000:00:07.0/virtio3/block/vda)...
>23:45:37,074 DEBUG blivet:           DeviceTree.getDeviceByName: hidden: False ; name: vda ; incomplete: False ;
>23:45:37,075 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>23:45:37,466 DEBUG blivet:           DeviceTree.addUdevDiskDevice: name: vda ;
>23:45:37,467 INFO blivet: vda is a disk
>23:45:37,468 DEBUG blivet: getFormat('None') returning DeviceFormat instance with object id 7
>23:45:37,468 DEBUG blivet:               DiskDevice._setFormat: vda ; current: None ; type: None ;
>23:45:37,496 INFO blivet: added disk vda (id 6) to device tree
>23:45:37,497 DEBUG blivet: looking up parted Device: /dev/vda
>23:45:37,496 INFO blivet: got device: DiskDevice instance (0x7facb5fe3490) --
>  name = vda  status = True  kids = 0 id = 6
>  parents = []
>  uuid = None  size = 10 GiB
>  format = existing None
>  major = 252  minor = 0  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:07.0/virtio3/block/vda  partedDevice = parted.Device instance --
>  model: Virtio Block Device  path: /dev/vda  type: 15
>  sectorSize: 512  physicalSectorSize:  512
>  length: 20971520  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (20805, 16, 63)  biosGeometry: (1305, 255, 63)
>  PedDevice: <_ped.Device object at 0x7facb348b4d0>
>  target size = 0 B  path = /dev/vda
>  format args = []  originalFormat = None  removable = False  partedDevice = <parted.device.Device object at 0x7facb5fee410>
>23:45:37,676 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: vda ;
>23:45:37,678 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: vda ; label_type: gpt ;
>23:45:37,681 DEBUG blivet:             DiskDevice.setup: vda ; status: True ; controllable: True ; orig: False ;
>23:45:37,681 DEBUG blivet: required disklabel type for vda (15) is None
>23:45:37,681 DEBUG blivet: default disklabel type for vda is gpt
>23:45:37,682 DEBUG blivet: selecting gpt disklabel for vda based on size
>23:45:37,698 DEBUG blivet:              DiskLabel.__init__: device: /dev/vda ; labelType: gpt ; exists: True ;
>23:45:37,975 DEBUG blivet: Clear pmbr_boot on parted.Disk instance --
>  type: gpt  primaryPartitionCount: 4
>  lastPartitionNumber: 4  maxPrimaryPartitionCount: 128
>  partitions: [<parted.partition.Partition object at 0x7facb60016d0>, <parted.partition.Partition object at 0x7facb6001950>, <parted.partition.Partition object at 0x7facb6001bd0>, <parted.partition.Partition object at 0x7facb6001d50>]
>  device: <parted.device.Device object at 0x7facb6001490>
>  PedDisk: <_ped.Disk object at 0x7facb5fcfb00>
>23:45:37,979 DEBUG blivet: getFormat('disklabel') returning DiskLabel instance with object id 9
>23:45:37,981 DEBUG blivet:              DiskDevice._setFormat: vda ; current: None ; type: disklabel ;
>23:45:37,990 DEBUG blivet:          DeviceTree.addUdevDevice: info: {'DEVLINKS': '/dev/disk/by-label/Recovery /dev/disk/by-partlabel/Basic\\x20data\\x20partition /dev/disk/by-partuuid/7c5c02cd-366c-498b-ba3d-b9ef51dad7a6 /dev/disk/by-uuid/8C44528A445276C4',
> 'DEVNAME': 'vda1',
> 'DEVPATH': '/devices/pci0000:00/0000:00:07.0/virtio3/block/vda/vda1',
> 'DEVTYPE': 'partition',
> 'ID_FS_LABEL': 'Recovery',
> 'ID_FS_LABEL_ENC': 'Recovery',
> 'ID_FS_TYPE': 'ntfs',
> 'ID_FS_USAGE': 'filesystem',
> 'ID_FS_UUID': '8C44528A445276C4',
> 'ID_FS_UUID_ENC': '8C44528A445276C4',
> 'ID_PART_ENTRY_DISK': '252:0',
> 'ID_PART_ENTRY_FLAGS': '0x8000000000000001',
> 'ID_PART_ENTRY_NAME': 'Basic\\x20data\\x20partition',
> 'ID_PART_ENTRY_NUMBER': '1',
> 'ID_PART_ENTRY_OFFSET': '2048',
> 'ID_PART_ENTRY_SCHEME': 'gpt',
> 'ID_PART_ENTRY_SIZE': '614400',
> 'ID_PART_ENTRY_TYPE': 'de94bba4-06d1-4d40-a16a-bfd50179d6ac',
> 'ID_PART_ENTRY_UUID': '7c5c02cd-366c-498b-ba3d-b9ef51dad7a6',
> 'ID_PART_TABLE_TYPE': 'gpt',
> 'ID_PART_TABLE_UUID': 'e29598a9-e5ce-4fa2-9b1c-a56177bcd738',
> 'MAJOR': '252',
> 'MINOR': '1',
> 'SUBSYSTEM': 'block',
> 'TAGS': ':systemd:',
> 'USEC_INITIALIZED': '876705',
> 'name': 'vda1',
> 'symlinks': ['/dev/disk/by-label/Recovery',
>              '/dev/disk/by-partlabel/Basic\\x20data\\x20partition',
>              '/dev/disk/by-partuuid/7c5c02cd-366c-498b-ba3d-b9ef51dad7a6',
>              '/dev/disk/by-uuid/8C44528A445276C4'],
> 'sysfs_path': '/devices/pci0000:00/0000:00:07.0/virtio3/block/vda/vda1'} ; name: vda1 ;
>23:45:37,992 INFO blivet: scanning vda1 (/devices/pci0000:00/0000:00:07.0/virtio3/block/vda/vda1)...
>23:45:38,000 DEBUG blivet:           DeviceTree.getDeviceByName: hidden: False ; name: vda1 ; incomplete: False ;
>23:45:38,001 DEBUG blivet:           DeviceTree.getDeviceByName returned None
>23:45:38,004 INFO blivet: vda1 is a partition
>23:45:38,006 DEBUG blivet:           DeviceTree.addUdevPartitionDevice: name: vda1 ;
>23:45:38,009 DEBUG blivet:            DeviceTree.getDeviceByName: hidden: False ; name: vda ; incomplete: False ;
>23:45:38,013 DEBUG blivet:            DeviceTree.getDeviceByName returned existing 10 GiB disk vda (6) with existing gpt disklabel
>23:45:38,053 DEBUG blivet:                  DiskDevice.addChild: kids: 0 ; name: vda ;
>23:45:38,057 DEBUG blivet:               PartitionDevice._setFormat: vda1 ;
>23:45:38,057 DEBUG blivet: getFormat('None') returning DeviceFormat instance with object id 12
>23:45:38,062 DEBUG blivet:                PartitionDevice._setFormat: vda1 ; current: None ; type: None ;
>23:45:38,062 DEBUG blivet: looking up parted Partition: /dev/vda1
>23:45:38,064 DEBUG blivet:             PartitionDevice.probe: vda1 ; exists: True ;
>23:45:38,065 DEBUG blivet:              PartitionDevice.getFlag: path: /dev/vda1 ; flag: 1 ;
>23:45:38,066 DEBUG blivet:             PartitionDevice.getFlag: path: /dev/vda1 ; flag: 10 ;
>23:45:38,070 DEBUG blivet:             PartitionDevice.getFlag: path: /dev/vda1 ; flag: 12 ;
>23:45:38,070 INFO blivet: added partition vda1 (id 11) to device tree
>23:45:38,078 DEBUG blivet: looking up parted Device: /dev/vda1
>23:45:38,071 INFO blivet: got device: PartitionDevice instance (0x7facb6001f50) --
>  name = vda1  status = True  kids = 0 id = 11
>  parents = ['existing 10 GiB disk vda (6) with existing gpt disklabel']
>  uuid = None  size = 300 MiB
>  format = existing None
>  major = 252  minor = 1  exists = True  protected = False
>  sysfs path = /devices/pci0000:00/0000:00:07.0/virtio3/block/vda/vda1  partedDevice = parted.Device instance --
>  model: Virtio Block Device  path: /dev/vda1  type: 15
>  sectorSize: 512  physicalSectorSize:  512
>  length: 614400  openCount: 0  readOnly: False
>  externalMode: False  dirty: False  bootDirty: False
>  host: 13107  did: 13107  busy: False
>  hardwareGeometry: (609, 16, 63)  biosGeometry: (38, 255, 63)
>  PedDevice: <_ped.Device object at 0x7facb348b830>
>  target size = 0 B  path = /dev/vda1
>  format args = []  originalFormat = None  grow = None  max size = 0 B  bootable = None
>  part type = 0  primary = None  start sector = None  end sector = None
>  partedPartition = parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facb6001550>  fileSystem: <parted.filesystem.FileSystem object at 0x7facb6001a90>
>  number: 1  path: /dev/vda1  type: 0
>  name: Basic data partition  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facb6001790>  PedPartition: <_ped.Partition object at 0x7facb5f53c50>
>  disk = existing 10 GiB disk vda (6) with existing gpt disklabel
>  start = 2048  end = 616447  length = 614400
>  flags = hidden, diag
>23:45:38,205 DEBUG blivet:           DeviceTree.handleUdevDeviceFormat: name: vda1 ;
>23:45:38,209 DEBUG blivet:            DeviceTree.handleUdevDiskLabelFormat: device: vda1 ; label_type: None ;
>23:45:38,211 DEBUG blivet: device vda1 does not contain a disklabel
>23:45:38,211 INFO blivet: type detected on 'vda1' is 'ntfs'
>23:46:12,353 DEBUG blivet:        Iso9660FS.supported: supported: True ;
>23:46:12,354 DEBUG blivet:       Iso9660FS.supported: supported: True ;
>23:46:12,354 DEBUG blivet:        NFSv4.supported: supported: False ;
>23:46:12,355 DEBUG blivet:       NFSv4.supported: supported: False ;
>23:46:12,356 DEBUG blivet:         SELinuxFS.supported: supported: False ;
>23:46:12,356 DEBUG blivet:       SELinuxFS.supported: supported: False ;
>23:46:12,358 DEBUG blivet:         Ext4FS.supported: supported: True ;
>23:46:12,359 DEBUG blivet:       Ext4FS.supported: supported: True ;
>23:46:12,361 DEBUG blivet:         Ext3FS.supported: supported: True ;
>23:46:12,363 DEBUG blivet:       Ext3FS.supported: supported: True ;
>23:46:12,365 DEBUG blivet:         Ext2FS.supported: supported: True ;
>23:46:12,366 DEBUG blivet:       Ext2FS.supported: supported: True ;
>23:46:12,368 DEBUG blivet:         SysFS.supported: supported: False ;
>23:46:12,368 DEBUG blivet:       SysFS.supported: supported: False ;
>

Actions: View

Attachments on bug 1118923: 917457 | 917458 | 917459 | 917460 | 918843 | 918844 | 918845 | 918846 | 918849 | 918850 | 918851 | 918852