Attachment 345491 Details for Bug 501000 – Attached traceback automatically from anaconda.

Attached traceback automatically from anaconda.

anacdump.txt (text/plain), 169.12 KB, created by James Laska on 2009-05-26 16:02:46 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: James Laska

Created: 2009-05-26 16:02:46 UTC

Size: 169.12 KB

patch

obsolete

>anaconda 11.5.0.54 exception report
>Traceback (most recent call first):
>  File "/usr/lib/anaconda/storage/formats/fs.py", line 502, in doCheck
>    raise FSError("filesystem check failed: %s" % rc)
>  File "/usr/lib/anaconda/storage/formats/fs.py", line 436, in doResize
>    self.doCheck(intf=intf)
>  File "/usr/lib/anaconda/storage/deviceaction.py", line 358, in execute
>    self.device.format.doResize(intf=intf)
>  File "/usr/lib/anaconda/storage/devicetree.py", line 671, in processActions
>    action.execute(intf=self.intf)
>  File "/usr/lib/anaconda/storage/__init__.py", line 238, in doIt
>    self.devicetree.processActions()
>  File "/usr/lib/anaconda/packages.py", line 117, in turnOnFilesystems
>    anaconda.id.storage.doIt()
>FSError: filesystem check failed: 8
>
>Local variables in innermost frame:
>self: <storage.formats.fs.Ext4FS object at 0x7f8c15ec5610>
>intf: <gui.InstallInterface instance at 0x7f8c1d214758>
>w: <gui.ProgressWindow instance at 0x7f8c15202d88>
>rc: 8
>
>
>Anaconda instance, containing members:
>rescue_mount: True
>intf: InstallInterface instance, containing members:
>  intf.icw: InstallControlWindow instance, containing members:
>    intf.icw.handle: 385
>    intf.icw.currentWindow: PartitionWindow instance, containing members:
>      intf.icw.currentWindow.checkmark_pixbuf: <gtk.gdk.Pixbuf object at 0x7f8c1d308960 (GdkPixbuf at 0x2960990)>
>      intf.icw.currentWindow.intf: Already dumped
>      intf.icw.currentWindow.diskStripeGraph: DiskStripeGraph instance, containing members:
>        intf.icw.currentWindow.diskStripeGraph.canvas: <gnome.canvas.Canvas object at 0x7f8c15ef23c0 (GnomeCanvas at 0x28420a0)>
>        intf.icw.currentWindow.diskStripeGraph.textlabels: []
>        intf.icw.currentWindow.diskStripeGraph.tree: <DiskTreeModel object at 0x7f8c1d308a50 (GtkTreeStore at 0x28e0eb0)>
>        intf.icw.currentWindow.diskStripeGraph.editCB: <bound method PartitionWindow.editCB of <PartitionWindow.PartitionWindow instance at 0x7f8c160167a0>>
>        intf.icw.currentWindow.diskStripeGraph.next_ypos: 0.0
>        intf.icw.currentWindow.diskStripeGraph.diskStripes: []
>      intf.icw.currentWindow.show_uneditable: 1
>      intf.icw.currentWindow.lock_pixbuf: <gtk.gdk.Pixbuf object at 0x7f8c1d3089b0 (GdkPixbuf at 0x29ce1e0)>
>      intf.icw.currentWindow.storage: <storage.Storage object at 0x7f8c1d266150>
>      intf.icw.currentWindow.tree: <DiskTreeModel object at 0x7f8c1d308a50 (GtkTreeStore at 0x28e0eb0)>
>      intf.icw.currentWindow.toggleViewButton: <gtk.CheckButton object at 0x7f8c1d2ee6e0 (GtkCheckButton at 0x2903b70)>
>      intf.icw.currentWindow.anaconda: Already dumped
>      intf.icw.currentWindow.ics: InstallControlState instance, containing members:
>        intf.icw.currentWindow.ics.prevEnabled: True
>        intf.icw.currentWindow.ics.cw: Already dumped
>        intf.icw.currentWindow.ics.nextEnabled: True
>        intf.icw.currentWindow.ics.grabNext: True
>        intf.icw.currentWindow.ics.title: Partitioning
>      intf.icw.currentWindow.treeViewSelection: <gtk.TreeSelection object at 0x7f8c1d308cd0 (GtkTreeSelection at 0x2a308c0)>
>      intf.icw.currentWindow.treeView: <gtk.TreeView object at 0x7f8c1d308d20 (GtkTreeView at 0x29346f0)>
>    intf.icw.mainxml: <gtk.glade.XML object at 0x7f8c28c161e0 (PyGladeXML at 0x2405240)>
>    intf.icw.window: <gtk.Window object at 0x7f8c28c16230 (GtkWindow at 0x2472160)>
>    intf.icw.installFrame: <gtk.Frame object at 0x7f8c28c16140 (GtkFrame at 0x23d2b20)>
>    intf.icw.anaconda: Already dumped
>    intf.icw.reloadRcQueued: 0
>  intf.runres: 800x600
>  intf.anaconda: Already dumped
>rescue: False
>updateSrc: None
>mediaDevice: None
>methodstr: http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os
>dispatch: <dispatch.Dispatcher object at 0x7f8c1d21ea90>
>rootPath: /mnt/sysimage
>platform: <platform.X86 object at 0x7f8c22054710>
>canReIPL: False
>xdriver: None
>reIPLMessage: None
>isKickstart: False
>stage2: http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/install.img
>id: InstallData instance, containing members:
>  id.firewall: Firewall instance, containing members:
>    id.firewall.portlist: []
>    id.firewall.servicelist: []
>    id.firewall.trustdevs: []
>    id.firewall.enabled: 1
>  id.anaconda: Already dumped
>  id.upgradeRoot: [(<storage.devices.LVMLogicalVolumeDevice object at 0x7f8c206a9850>, 'Fedora 11')]
>  id.keyboard: Keyboard instance, containing members:
>    id.keyboard.info: {'LAYOUT': us, 'KEYBOARDTYPE': pc, 'VARIANT': , 'KEYTABLE': us, 'MODEL': pc105+inet, 'OPTIONS': }
>    id.keyboard.type: PC
>    id.keyboard._mods: KeyboardModels instance, containing members:
>    id.keyboard.beenset: 0
>  id.timezone: Timezone instance, containing members:
>    id.timezone.utc: True
>    id.timezone.tz: America/New_York
>  id.backend: YumBackend instance, containing members:
>    id.backend.modeText: 
>    id.backend.instPath: /mnt/sysimage
>    id.backend.skipFormatRoot: False
>    id.backend.instLog: None
>    id.backend.supportsUpgrades: True
>    id.backend._loopbackFile: None
>    id.backend.rootFsType: None
>    id.backend.supportsPackageSelection: True
>  id.upgrade: False
>  id.monitor: None
>  id.storage: <storage.Storage object at 0x7f8c1d266150>
>  id.desktop: Desktop instance, containing members:
>    id.desktop.info: {}
>    id.desktop.runlevel: 3
>  id.rootParts: [(<storage.devices.LVMLogicalVolumeDevice object at 0x7f8c206a9850>, 'Fedora 11')]
>  id.x_already_set: 0
>  id.firstboot: 0
>  id.users: None
>  id.displayMode: g
>  id.auth: --enableshadow --passalgo=sha512 --enablefingerprint
>  id.ksdata: None
>  id.bootloader: x86BootloaderInfo instance, containing members:
>    id.bootloader._configdir: /boot/grub
>    id.bootloader.doUpgradeOnly: 0
>    id.bootloader.above1024: 0
>    id.bootloader.defaultDevice: None
>    id.bootloader.pure: None
>    id.bootloader.storage: <storage.Storage object at 0x7f8c1d266150>
>    id.bootloader.serialOptions: 
>    id.bootloader.args: KernelArguments instance, containing members:
>      id.bootloader.args.args: console=ttyS0
>    id.bootloader.kernelLocation: /boot/
>    id.bootloader.timeout: 5
>    id.bootloader._configname: grub.conf
>    id.bootloader.device: None
>    id.bootloader.kickstart: 0
>    id.bootloader.serialDevice: ttyS0
>    id.bootloader.useGrubVal: 1
>    id.bootloader._drivelist: [vda, vdb, vdc, vdd]
>    id.bootloader.images: BootImages instance, containing members:
>      id.bootloader.images.default: None
>      id.bootloader.images.images: {}
>    id.bootloader.serial: 1
>    id.bootloader.password: None
>    id.bootloader.forceLBA32: 0
>  id.extraModules: []
>  id.network: Network instance, containing members:
>    id.network.netdevices: {'eth0': DEVICE=eth0
>BOOTPROTO=dhcp
>HWADDR=54:52:00:09:B5:84
>ONBOOT=yes
>
>}
>    id.network.ksdevice: eth0
>    id.network.overrideDHCPhostname: False
>    id.network.hostname: test1236.test.redhat.com
>    id.network.domains: []
>  id.instClass: <installclass.DefaultInstall object at 0x7f8c2205b0d0>
>  id.isHeadless: 0
>  id.videocard: None
>  id.instLanguage: Language instance, containing members:
>    id.instLanguage.targetLang: None
>    id.instLanguage.default: en
>    id.instLanguage.displayMode: g
>    id.instLanguage.current: en_US.UTF-8
>  id.security: Security instance, containing members:
>    id.security.selinux: 1
>  id.upgradeSwapInfo: None
>dir: 1
>backend: Already dumped
>
>
>/tmp/syslog:
><6>Initializing cgroup subsys cpuset
><6>Initializing cgroup subsys cpu
><5>Linux version 2.6.29.3-155.fc11.x86_64 (mockbuild@xenbuilder2.fedora.redhat.com) (gcc version 4.4.0 20090506 (Red Hat 4.4.0-4) (GCC) ) #1 SMP Wed May 20 17:43:16 EDT 2009
><6>Command line: method=http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os console=ttyS0 serial lang=en keymap=us ksdevice=link ip=dhcp vnc
><4>KERNEL supported cpus:
><4>  Intel GenuineIntel
><4>  AMD AuthenticAMD
><4>  Centaur CentaurHauls
><6>PAT WC disabled due to known CPU erratum.
><6>BIOS-provided physical RAM map:
><6> BIOS-e820: 0000000000000000 - 000000000009f000 (usable)
><6> BIOS-e820: 000000000009f000 - 00000000000a0000 (reserved)
><6> BIOS-e820: 00000000000e8000 - 0000000000100000 (reserved)
><6> BIOS-e820: 0000000000100000 - 000000003fff0000 (usable)
><6> BIOS-e820: 000000003fff0000 - 0000000040000000 (ACPI data)
><6> BIOS-e820: 00000000fffbc000 - 0000000100000000 (reserved)
><6>DMI 2.4 present.
><6>last_pfn = 0x3fff0 max_arch_pfn = 0x100000000
><6>init_memory_mapping: 0000000000000000-000000003fff0000
><7> 0000000000 - 003fe00000 page 2M
><7> 003fe00000 - 003fff0000 page 4k
><7>kernel direct mapping tables up to 3fff0000 @ 8000-b000
><6>last_map_addr: 3fff0000 end: 3fff0000
><6>RAMDISK: 3ed26000 - 3ffefc42
><4>ACPI: RSDP 000FBE50, 0014 (r0 QEMU  )
><4>ACPI: RSDT 3FFF0000, 002C (r1 QEMU   QEMURSDT        1 QEMU        1)
><4>ACPI: FACP 3FFF002C, 0074 (r1 QEMU   QEMUFACP        1 QEMU        1)
><4>FADT: X_PM1a_EVT_BLK.bit_width (16) does not match PM1_EVT_LEN (4)
><4>ACPI: DSDT 3FFF0100, 2540 (r1   BXPC   BXDSDT        1 INTL 20090123)
><4>ACPI: FACS 3FFF00C0, 0040
><4>ACPI: APIC 3FFF2640, 00E0 (r1 QEMU   QEMUAPIC        1 QEMU        1)
><7>ACPI: Local APIC address 0xfee00000
><6>No NUMA configuration found
><6>Faking a node at 0000000000000000-000000003fff0000
><6>Bootmem setup node 0 0000000000000000-000000003fff0000
><6>  NODE_DATA [0000000000009000 - 000000000001dfff]
><6>  bootmap [000000000001e000 -  0000000000025fff] pages 8
><6>(6 early reservations) ==> bootmem [0000000000 - 003fff0000]
><6>  #0 [0000000000 - 0000001000]   BIOS data page ==> [0000000000 - 0000001000]
><6>  #1 [0000006000 - 0000008000]       TRAMPOLINE ==> [0000006000 - 0000008000]
><6>  #2 [0000200000 - 0000ac700c]    TEXT DATA BSS ==> [0000200000 - 0000ac700c]
><6>  #3 [003ed26000 - 003ffefc42]          RAMDISK ==> [003ed26000 - 003ffefc42]
><6>  #4 [000009fc00 - 0000100000]    BIOS reserved ==> [000009fc00 - 0000100000]
><6>  #5 [0000008000 - 0000009000]          PGTABLE ==> [0000008000 - 0000009000]
><6>found SMP MP-table at [ffff8800000fbd10] 000fbd10
><6>kvm-clock: cpu 0, msr 0:982281, boot clock
><7> [ffffe20000000000-ffffe20000dfffff] PMD -> [ffff880001200000-ffff880001ffffff] on node 0
><4>Zone PFN ranges:
><4>  DMA      0x00000000 -> 0x00001000
><4>  DMA32    0x00001000 -> 0x00100000
><4>  Normal   0x00100000 -> 0x00100000
><4>Movable zone start PFN for each node
><4>early_node_map[2] active PFN ranges
><4>    0: 0x00000000 -> 0x0000009f
><4>    0: 0x00000100 -> 0x0003fff0
><7>On node 0 totalpages: 262031
><7>  DMA zone: 56 pages used for memmap
><7>  DMA zone: 2349 pages reserved
><7>  DMA zone: 1594 pages, LIFO batch:0
><7>  DMA32 zone: 3528 pages used for memmap
><7>  DMA32 zone: 254504 pages, LIFO batch:31
><6>ACPI: PM-Timer IO Port: 0xb008
><7>ACPI: Local APIC address 0xfee00000
><6>ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
><6>ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
><6>ACPI: LAPIC (acpi_id[0x02] lapic_id[0x02] disabled)
><6>ACPI: LAPIC (acpi_id[0x03] lapic_id[0x03] disabled)
><6>ACPI: LAPIC (acpi_id[0x04] lapic_id[0x04] disabled)
><6>ACPI: LAPIC (acpi_id[0x05] lapic_id[0x05] disabled)
><6>ACPI: LAPIC (acpi_id[0x06] lapic_id[0x06] disabled)
><6>ACPI: LAPIC (acpi_id[0x07] lapic_id[0x07] disabled)
><6>ACPI: LAPIC (acpi_id[0x08] lapic_id[0x08] disabled)
><6>ACPI: LAPIC (acpi_id[0x09] lapic_id[0x09] disabled)
><6>ACPI: LAPIC (acpi_id[0x0a] lapic_id[0x0a] disabled)
><6>ACPI: LAPIC (acpi_id[0x0b] lapic_id[0x0b] disabled)
><6>ACPI: LAPIC (acpi_id[0x0c] lapic_id[0x0c] disabled)
><6>ACPI: LAPIC (acpi_id[0x0d] lapic_id[0x0d] disabled)
><6>ACPI: LAPIC (acpi_id[0x0e] lapic_id[0x0e] disabled)
><6>ACPI: LAPIC (acpi_id[0x0f] lapic_id[0x0f] disabled)
><6>ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
><6>IOAPIC[0]: apic_id 2, version 0, address 0xfec00000, GSI 0-23
><6>ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
><6>ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
><6>ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
><6>ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
><7>ACPI: IRQ5 used by override.
><7>ACPI: IRQ9 used by override.
><7>ACPI: IRQ10 used by override.
><7>ACPI: IRQ11 used by override.
><6>Using ACPI (MADT) for SMP configuration information
><6>SMP: Allowing 16 CPUs, 14 hotplug CPUs
><7>nr_irqs_gsi: 24
><6>PM: Registered nosave memory: 000000000009f000 - 00000000000a0000
><6>PM: Registered nosave memory: 00000000000a0000 - 00000000000e8000
><6>PM: Registered nosave memory: 00000000000e8000 - 0000000000100000
><6>Allocating PCI resources starting at 50000000 (gap: 40000000:bffbc000)
><6>NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:16 nr_node_ids:1
><6>PERCPU: Allocating 57344 bytes of per cpu data
><6>kvm-clock: cpu 0, msr 0:1015281, primary cpu clock
><4>Built 1 zonelists in Node order, mobility grouping on.  Total pages: 256098
><4>Policy zone: DMA32
><5>Kernel command line: method=http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os console=ttyS0 serial lang=en keymap=us ksdevice=link ip=dhcp vnc
><6>Initializing CPU#0
><4>PID hash table entries: 4096 (order: 12, 32768 bytes)
><4>Detected 2494.030 MHz processor.
><4>Console: colour VGA+ 80x25
><6>console [ttyS0] enabled
><6>allocated 10485760 bytes of page_cgroup
><6>please try cgroup_disable=memory option if you don't want
><6>Checking aperture...
><6>No AGP bridge found
><7>Calgary: detecting Calgary via BIOS EBDA area
><7>Calgary: Unable to locate Rio Grande table in EBDA - bailing!
><6>Memory: 994144k/1048512k available (3785k kernel code, 388k absent, 53980k reserved, 2290k data, 1304k init)
><6>SLUB: Genslabs=13, HWalign=64, Order=0-3, MinObjects=0, CPUs=16, Nodes=1
><6>Calibrating delay loop (skipped) preset value.. 4988.06 BogoMIPS (lpj=2494030)
><6>Security Framework initialized
><6>SELinux:  Initializing.
><7>SELinux:  Starting in permissive mode
><6>Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes)
><6>Inode-cache hash table entries: 65536 (order: 7, 524288 bytes)
><4>Mount-cache hash table entries: 256
><6>Initializing cgroup subsys ns
><6>Initializing cgroup subsys cpuacct
><6>Initializing cgroup subsys memory
><6>Initializing cgroup subsys devices
><6>Initializing cgroup subsys freezer
><6>Initializing cgroup subsys net_cls
><6>CPU: L1 I cache: 32K, L1 D cache: 32K
><6>CPU: L2 cache: 2048K
><6>CPU 0/0x0 -> Node 0
><6>ACPI: Core revision 20081204
><6>ftrace: converting mcount calls to 0f 1f 44 00 00
><6>ftrace: allocating 18880 entries in 149 pages
><6>Setting APIC routing to flat
><6>..TIMER: vector=0x30 apic1=0 pin1=0 apic2=-1 pin2=-1
><6>CPU0: Intel QEMU Virtual CPU version 0.10.1 stepping 03
><6>Booting processor 1 APIC 0x1 ip 0x6000
><6>Initializing CPU#1
><6>Calibrating delay loop (skipped) preset value.. 4988.06 BogoMIPS (lpj=2494030)
><6>CPU: L1 I cache: 32K, L1 D cache: 32K
><6>CPU: L2 cache: 2048K
><6>CPU 1/0x1 -> Node 0
><6>CPU1: Intel QEMU Virtual CPU version 0.10.1 stepping 03
><6>checking TSC synchronization [CPU#0 -> CPU#1]:
><4>Measured 10408631168 cycles TSC warp between CPUs, turning off TSC clock.
><4>Marking TSC unstable due to check_tsc_sync_source failed
><6>kvm-clock: cpu 1, msr 0:1023281, secondary cpu clock
><6>Brought up 2 CPUs
><6>Total of 2 processors activated (9976.12 BogoMIPS).
><7>sizeof(vma)=176 bytes
><7>sizeof(page)=56 bytes
><7>sizeof(inode)=560 bytes
><7>sizeof(dentry)=192 bytes
><7>sizeof(ext3inode)=760 bytes
><7>sizeof(buffer_head)=104 bytes
><7>sizeof(skbuff)=232 bytes
><7>sizeof(task_struct)=5880 bytes
><7>CPU0 attaching sched-domain:
><7> domain 0: span 0-1 level CPU
><7>  groups: 0 1
><7>CPU1 attaching sched-domain:
><7> domain 0: span 0-1 level CPU
><7>  groups: 1 0
><6>net_namespace: 1904 bytes
><6>Booting paravirtualized kernel on KVM
><6>regulator: core version 0.5
><4>Time: 16:00:40  Date: 05/26/09
><6>NET: Registered protocol family 16
><6>ACPI: bus type pci registered
><6>PCI: Using configuration type 1 for base access
><4>bio: create slab <bio-0> at 0
><7>ACPI: EC: Look up EC in DSDT
><6>ACPI: Interpreter enabled
><6>ACPI: (supports S0 S3 S4 S5)
><6>ACPI: Using IOAPIC for interrupt routing
><6>ACPI: No dock devices found.
><6>ACPI: PCI Root Bridge [PCI0] (0000:00)
><7>pci 0000:00:01.1: reg 20 io port: [0xc000-0xc00f]
><7>pci 0000:00:01.2: reg 20 io port: [0xc020-0xc03f]
><6>pci 0000:00:01.3: quirk: region b000-b03f claimed by PIIX4 ACPI
><6>pci 0000:00:01.3: quirk: region b100-b10f claimed by PIIX4 SMB
><7>pci 0000:00:02.0: reg 10 32bit mmio: [0xf0000000-0xf1ffffff]
><7>pci 0000:00:02.0: reg 14 32bit mmio: [0xf2000000-0xf2000fff]
><7>pci 0000:00:03.0: reg 10 io port: [0xc040-0xc05f]
><7>pci 0000:00:04.0: reg 10 io port: [0xc080-0xc0bf]
><7>pci 0000:00:05.0: reg 10 io port: [0xc0c0-0xc0ff]
><7>pci 0000:00:06.0: reg 10 io port: [0xc100-0xc13f]
><7>pci 0000:00:07.0: reg 10 io port: [0xc140-0xc17f]
><7>pci 0000:00:08.0: reg 10 io port: [0xc180-0xc19f]
><7>ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
><6>ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
><6>ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
><6>ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
><6>ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
><5>SCSI subsystem initialized
><7>libata version 3.00 loaded.
><6>usbcore: registered new interface driver usbfs
><6>usbcore: registered new interface driver hub
><6>usbcore: registered new device driver usb
><6>PCI: Using ACPI for IRQ routing
><6>NetLabel: Initializing
><6>NetLabel:  domain hash size = 128
><6>NetLabel:  protocols = UNLABELED CIPSOv4
><6>NetLabel:  unlabeled traffic allowed by default
><7>Switched to high resolution mode on CPU 0
><7>Switched to high resolution mode on CPU 1
><6>pnp: PnP ACPI init
><6>ACPI: bus type pnp registered
><6>pnp: PnP ACPI: found 6 devices
><6>ACPI: ACPI bus type pnp unregistered
><7>pci_bus 0000:00: resource 0 io:  [0x00-0xffff]
><7>pci_bus 0000:00: resource 1 mem: [0x000000-0xffffffffffffffff]
><6>NET: Registered protocol family 2
><6>IP route cache hash table entries: 32768 (order: 6, 262144 bytes)
><6>TCP established hash table entries: 131072 (order: 9, 2097152 bytes)
><6>TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
><6>TCP: Hash tables configured (established 131072 bind 65536)
><6>TCP reno registered
><6>NET: Registered protocol family 1
><6>checking if image is initramfs... it is
><4>Clocksource tsc unstable (delta = 4393873036692 ns)
><6>Freeing initrd memory: 19239k freed
><6>audit: initializing netlink socket (disabled)
><5>type=2000 audit(1243353641.253:1): initialized
><6>HugeTLB registered 2 MB page size, pre-allocated 0 pages
><5>VFS: Disk quotas dquot_6.5.2
><4>Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
><6>msgmni has been set to 1979
><7>SELinux:  Registering netfilter hooks
><6>alg: No test for stdrng (krng)
><6>Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
><6>io scheduler noop registered
><6>io scheduler anticipatory registered
><6>io scheduler deadline registered
><6>io scheduler cfq registered (default)
><6>pci 0000:00:00.0: Limiting direct PCI/PCI transfers
><6>pci 0000:00:01.0: PIIX3: Enabling Passive Release
><6>pci 0000:00:01.0: Activating ISA DMA hang workarounds
><7>pci 0000:00:02.0: Boot video device
><6>pci_hotplug: PCI Hot Plug PCI Core version: 0.5
><6>pciehp: PCI Express Hot Plug Controller Driver version: 0.4
><6>acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
><4>acpiphp_glue: can't get bus number, assuming 0
><4>decode_hpp: Could not get hotplug parameters. Use defaults
><6>acpiphp: Slot [1] registered
><6>acpiphp: Slot [2] registered
><6>acpiphp: Slot [3] registered
><6>acpiphp: Slot [4] registered
><6>acpiphp: Slot [5] registered
><6>acpiphp: Slot [6] registered
><6>acpiphp: Slot [7] registered
><6>acpiphp: Slot [8] registered
><6>acpiphp: Slot [9] registered
><6>acpiphp: Slot [10] registered
><6>acpiphp: Slot [11] registered
><6>acpiphp: Slot [12] registered
><6>acpiphp: Slot [13] registered
><6>acpiphp: Slot [14] registered
><6>acpiphp: Slot [15] registered
><6>acpiphp: Slot [16] registered
><6>acpiphp: Slot [17] registered
><6>acpiphp: Slot [18] registered
><6>acpiphp: Slot [19] registered
><6>acpiphp: Slot [20] registered
><6>acpiphp: Slot [21] registered
><6>acpiphp: Slot [22] registered
><6>acpiphp: Slot [23] registered
><6>acpiphp: Slot [24] registered
><6>acpiphp: Slot [25] registered
><6>acpiphp: Slot [26] registered
><6>acpiphp: Slot [27] registered
><6>acpiphp: Slot [28] registered
><6>acpiphp: Slot [29] registered
><6>acpiphp: Slot [30] registered
><6>acpiphp: Slot [31] registered
><6>input: Power Button (FF) as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
><6>ACPI: Power Button (FF) [PWRF]
><6>processor ACPI_CPU:00: registered as cooling_device0
><6>processor ACPI_CPU:01: registered as cooling_device1
><6>Non-volatile memory driver v1.3
><6>Linux agpgart interface v0.103
><6>Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
><6>serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
><6>00:05: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
><6>brd: module loaded
><6>loop: module loaded
><6>Fixed MDIO Bus: probed
><6>input: Macintosh mouse button emulation as /devices/virtual/input/input1
><4>Driver 'sd' needs updating - please use bus_type methods
><4>Driver 'sr' needs updating - please use bus_type methods
><7>ata_piix 0000:00:01.1: version 2.12
><7>ata_piix 0000:00:01.1: setting latency timer to 64
><6>scsi0 : ata_piix
><6>scsi1 : ata_piix
><6>ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc000 irq 14
><6>ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc008 irq 15
><7>ata2.01: NODEV after polling detection
><6>ata2.00: ATAPI: QEMU DVD-ROM, 0.10.1, max UDMA/100
><6>ata2.00: configured for MWDMA2
><4>isa bounce pool size: 16 pages
><5>scsi 1:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     0.10 PQ: 0 ANSI: 5
><4>sr0: scsi3-mmc drive: 4x/4x xa/form2 tray
><6>Uniform CD-ROM driver Revision: 3.20
><7>sr 1:0:0:0: Attached scsi CD-ROM sr0
><5>sr 1:0:0:0: Attached scsi generic sg0 type 5
><6>ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
><6>ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
><6>uhci_hcd: USB Universal Host Controller Interface driver
><4>ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
><6>uhci_hcd 0000:00:01.2: PCI INT D -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11
><7>uhci_hcd 0000:00:01.2: setting latency timer to 64
><6>uhci_hcd 0000:00:01.2: UHCI Host Controller
><6>uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
><6>uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c020
><6>usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
><6>usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
><6>usb usb1: Product: UHCI Host Controller
><6>usb usb1: Manufacturer: Linux 2.6.29.3-155.fc11.x86_64 uhci_hcd
><6>usb usb1: SerialNumber: 0000:00:01.2
><6>usb usb1: configuration #1 chosen from 1 choice
><6>hub 1-0:1.0: USB hub found
><6>hub 1-0:1.0: 2 ports detected
><6>PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
><6>serio: i8042 KBD port at 0x60,0x64 irq 1
><6>serio: i8042 AUX port at 0x60,0x64 irq 12
><6>mice: PS/2 mouse device common for all mice
><6>rtc_cmos 00:01: rtc core: registered rtc_cmos as rtc0
><6>rtc0: alarms up to one day, 114 bytes nvram
><6>input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input2
><6>device-mapper: uevent: version 1.0.3
><6>device-mapper: ioctl: 4.14.0-ioctl (2008-04-23) initialised: dm-devel@redhat.com
><6>cpuidle: using governor ladder
><6>cpuidle: using governor menu
><6>usbcore: registered new interface driver hiddev
><6>usbcore: registered new interface driver usbhid
><6>usbhid: v2.6:USB HID core driver
><4>nf_conntrack version 0.5.0 (8191 buckets, 32764 max)
><4>CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
><4>nf_conntrack.acct=1 kernel paramater, acct=1 nf_conntrack module option or
><4>sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
><6>ip_tables: (C) 2000-2006 Netfilter Core Team
><6>TCP cubic registered
><6>Initializing XFRM netlink socket
><6>NET: Registered protocol family 17
><4>registered taskstats version 1
><4>  Magic number: 9:605:35
><6>bdi 7:0: hash matches
><6>Initalizing network drop monitor service
><6>Freeing unused kernel memory: 1304k freed
><6>Write protecting the kernel read-only data: 1840k
><6>input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3
><6>FDC 0 is a S82078B
><6>BIOS EDD facility v0.16 2004-Jun-25, 1 devices found
><6>input: PC Speaker as /devices/platform/pcspkr/input/input4
><6>squashfs: version 4.0 (2009/01/31) Phillip Lougher
><6>Loading iSCSI transport class v2.0-870.
><5>iscsi: registered transport (tcp)
><6>No iBFT detected.
><4>ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10
><6>virtio-pci 0000:00:03.0: PCI INT A -> Link[LNKC] -> GSI 10 (level, high) -> IRQ 10
><6>virtio-pci 0000:00:04.0: PCI INT A -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11
><4>ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
><6>virtio-pci 0000:00:05.0: PCI INT A -> Link[LNKA] -> GSI 10 (level, high) -> IRQ 10
><4>ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11
><6>virtio-pci 0000:00:06.0: PCI INT A -> Link[LNKB] -> GSI 11 (level, high) -> IRQ 11
><6>virtio-pci 0000:00:07.0: PCI INT A -> Link[LNKC] -> GSI 10 (level, high) -> IRQ 10
><6>virtio-pci 0000:00:08.0: PCI INT A -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11
><27>May 26 16:00:44 udevd-event[269]: device node '/dev/rtc' already exists, link to '/dev/rtc0' will not overwrite it
>
><6> vda: vda1 vda2
><6> vdb: vdb1
><6> vdc: vdc1
><6> vdd: vdd1
><29>May 26 16:00:45 NetworkManager: <info>  starting...
>
><29>May 26 16:00:45 NetworkManager: <info>  Waiting for HAL to start...
>
><28>May 26 16:00:45 NetworkManager: <WARN>  nm_generic_enable_loopback(): error -17 returned from rtnl_addr_add():
>Sucess
>
>
><29>May 26 16:00:45 NetworkManager: <info>  Trying to start the supplicant...
>
><29>May 26 16:00:45 NetworkManager: <info>  Trying to start the system settings daemon...
>
><28>May 26 16:00:45 nm-system-settings: initial_add_devices_of_type: could not get device from HAL: The name org.freedesktop.Hal was not provided by any .service files (2).
><28>May 26 16:00:45 nm-system-settings: initial_add_devices_of_type: could not get device from HAL: The name org.freedesktop.Hal was not provided by any .service files (2).
><28>May 26 16:00:45 nm-system-settings: initial_add_devices_of_type: could not get device from HAL: The name org.freedesktop.Hal was not provided by any .service files (2).
><28>May 26 16:00:45 nm-system-settings:    ifcfg-rh: Could not get hostname: failed to read /etc/sysconfig/network
><29>May 26 16:00:45 nm-system-settings: Loaded plugin ifcfg-rh: (c) 2007 - 2008 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
><29>May 26 16:00:45 nm-system-settings:    ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-eth0 ... 
><29>May 26 16:00:45 nm-system-settings:    ifcfg-rh:     read connection 'System eth0'
><29>May 26 16:00:45 nm-system-settings:    ifcfg-rh: Ignoring connection 'System eth0' and its device because NM_CONTROLLED was false.
><29>May 26 16:00:45 NetworkManager: <info>  HAL re-appeared
>
><29>May 26 16:00:45 NetworkManager: <info>  (eth0): new Ethernet device (driver: 'virtio_net')
>
><29>May 26 16:00:45 NetworkManager: <info>  (eth0): exported as /org/freedesktop/Hal/devices/net_54_52_00_09_b5_84
>
><29>May 26 16:00:47 nm-system-settings:    ifcfg-rh: updating /etc/sysconfig/network-scripts/ifcfg-eth0
><29>May 26 16:00:47 nm-system-settings:    ifcfg-rh: Managing connection 'System eth0' and its device because NM_CONTROLLED was true.
><29>May 26 16:00:48 nm-system-settings:    ifcfg-rh: updating /etc/sysconfig/network-scripts/ifcfg-eth0
><29>May 26 16:00:50 NetworkManager: <info>  (eth0): device state change: 1 -> 2
>
><29>May 26 16:00:50 NetworkManager: <info>  (eth0): bringing up device.
>
><29>May 26 16:00:50 NetworkManager: <info>  (eth0): preparing device.
>
><29>May 26 16:00:50 NetworkManager: <info>  (eth0): deactivating device (reason: 2).
>
><29>May 26 16:00:50 NetworkManager: <info>  (eth0): carrier now ON (device state 2)
>
><29>May 26 16:00:50 NetworkManager: <info>  (eth0): device state change: 2 -> 3
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) starting connection 'System eth0'
>
><29>May 26 16:00:50 NetworkManager: <info>  (eth0): device state change: 3 -> 4
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) started...
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) starting...
>
><29>May 26 16:00:50 NetworkManager: <info>  (eth0): device state change: 4 -> 5
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) successful.
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) complete.
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
>
><29>May 26 16:00:50 NetworkManager: <info>  (eth0): device state change: 5 -> 7
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) Beginning DHCP transaction.
>
><29>May 26 16:00:50 NetworkManager: <info>  dhclient started with pid 525
>
><29>May 26 16:00:50 NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
>
><30>May 26 16:00:50 dhclient: Internet Systems Consortium DHCP Client 4.1.0
><30>May 26 16:00:50 dhclient: Copyright 2004-2008 Internet Systems Consortium.
><30>May 26 16:00:50 dhclient: All rights reserved.
><30>May 26 16:00:50 dhclient: For info, please visit http://www.isc.org/sw/dhcp/
><30>May 26 16:00:50 dhclient: 
><29>May 26 16:00:50 NetworkManager: <info>  DHCP: device eth0 state changed (null) -> preinit
>
><30>May 26 16:00:50 dhclient: Listening on LPF/eth0/54:52:00:09:b5:84
><30>May 26 16:00:50 dhclient: Sending on   LPF/eth0/54:52:00:09:b5:84
><30>May 26 16:00:50 dhclient: Sending on   Socket/fallback
><30>May 26 16:00:51 dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 4
><30>May 26 16:00:51 dhclient: DHCPOFFER from 10.10.36.113
><30>May 26 16:00:51 dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67
><30>May 26 16:00:51 dhclient: DHCPACK from 10.10.36.113
><29>May 26 16:00:51 NetworkManager: <info>  DHCP: device eth0 state changed preinit -> bound
>
><29>May 26 16:00:51 NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) scheduled...
>
><29>May 26 16:00:51 NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) started...
>
><29>May 26 16:00:51 NetworkManager: <info>    address 192.168.34.236
>
><29>May 26 16:00:51 NetworkManager: <info>    prefix 22 (255.255.252.0)
>
><29>May 26 16:00:51 NetworkManager: <info>    gateway 192.168.35.254
>
><29>May 26 16:00:51 NetworkManager: <info>    nameserver '192.168.32.2'
>
><29>May 26 16:00:51 NetworkManager: <info>    domain name 'test.redhat.com'
>
><29>May 26 16:00:51 NetworkManager: <info>    domain name 'devel.redhat.com'
>
><29>May 26 16:00:51 NetworkManager: <info>    domain name 'redhat.com'
>
><30>May 26 16:00:51 dhclient: bound to 192.168.34.236 -- renewal in 18759 seconds.
><29>May 26 16:00:51 NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) scheduled...
>
><29>May 26 16:00:51 NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) complete.
>
><29>May 26 16:00:51 NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) started...
>
><29>May 26 16:00:52 NetworkManager: <info>  (eth0): device state change: 7 -> 8
>
><29>May 26 16:00:52 NetworkManager: <info>  Policy set 'System eth0' (eth0) as default for routing and DNS.
>
><29>May 26 16:00:52 NetworkManager: <info>  Activation (eth0) successful, device activated.
>
><29>May 26 16:00:52 NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) complete.
>
><29>May 26 16:00:52 NetworkManager: <info>  Setting system hostname to 'test1236.test.redhat.com' (from address lookup)
>
><28>May 26 16:00:52 nm-dispatcher.action: nm_dispatcher_action: Invalid connection: '(null)' / 'connection setting not found' invalid: 1
><29>May 26 16:00:53 nm-system-settings:    ifcfg-rh: updating /etc/sysconfig/network-scripts/ifcfg-eth0
><29>May 26 16:01:04 dbus-daemon: Reloaded configuration
><7>SELinux: 8192 avtab hash slots, 123719 rules.
><7>SELinux: 8192 avtab hash slots, 123719 rules.
><7>SELinux:  8 users, 11 roles, 2722 types, 127 bools, 1 sens, 1024 cats
><7>SELinux:  74 classes, 123719 rules
><7>SELinux:  Completing initialization.
><7>SELinux:  Setting up existing superblocks.
><7>SELinux: initialized (dev loop0, type squashfs), not configured for labeling
><7>SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
><7>SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
><7>SELinux: initialized (dev usbfs, type usbfs), uses genfs_contexts
><7>SELinux: initialized (dev selinuxfs, type selinuxfs), uses genfs_contexts
><7>SELinux: initialized (dev mqueue, type mqueue), uses transition SIDs
><7>SELinux: initialized (dev hugetlbfs, type hugetlbfs), uses genfs_contexts
><7>SELinux: initialized (dev devpts, type devpts), uses transition SIDs
><7>SELinux: initialized (dev inotifyfs, type inotifyfs), uses genfs_contexts
><7>SELinux: initialized (dev tmpfs, type tmpfs), uses transition SIDs
><7>SELinux: initialized (dev anon_inodefs, type anon_inodefs), uses genfs_contexts
><7>SELinux: initialized (dev pipefs, type pipefs), uses task SIDs
><7>SELinux: initialized (dev debugfs, type debugfs), uses genfs_contexts
><7>SELinux: initialized (dev sockfs, type sockfs), uses task SIDs
><7>SELinux: initialized (dev proc, type proc), uses genfs_contexts
><7>SELinux: initialized (dev bdev, type bdev), uses genfs_contexts
><7>SELinux: initialized (dev rootfs, type rootfs), uses genfs_contexts
><7>SELinux: initialized (dev sysfs, type sysfs), uses genfs_contexts
><5>type=1403 audit(1243353664.533:2): policy loaded auid=4294967295 ses=4294967295
><6>md: raid0 personality registered for level 0
><6>md: raid1 personality registered for level 1
><6>xor: automatically using best checksumming function: generic_sse
><6>   generic_sse:   892.000 MB/sec
><6>xor: using function: generic_sse (892.000 MB/sec)
><6>async_tx: api initialized (async)
><4>raid6: int64x1   1605 MB/s
><4>raid6: int64x2   2226 MB/s
><4>raid6: int64x4   1925 MB/s
><4>raid6: int64x8   1468 MB/s
><4>raid6: sse2x1    3007 MB/s
><4>raid6: sse2x2    4792 MB/s
><4>raid6: sse2x4    5222 MB/s
><4>raid6: using algorithm sse2x4 (5222 MB/s)
><6>md: raid6 personality registered for level 6
><6>md: raid5 personality registered for level 5
><6>md: raid4 personality registered for level 4
><6>md: raid10 personality registered for level 10
><6>md: linear personality registered for level -1
><6>device-mapper: multipath: version 1.0.5 loaded
><6>device-mapper: multipath round-robin: version 1.0.0 loaded
><6>NET: Registered protocol family 10
><6>lo: Disabled Privacy Extensions
><6>kjournald starting.  Commit interval 5 seconds
><6>EXT3-fs: mounted filesystem with ordered data mode.
><7>SELinux: initialized (dev vda1, type ext3), uses xattr
><6>EXT4-fs: barriers enabled
><6>kjournald2 starting: pid 1540, dev dm-0:8, commit interval 5 seconds
><6>EXT4-fs: delayed allocation enabled
><6>EXT4-fs: file extents enabled
><6>EXT4-fs: mballoc enabled
><6>EXT4-fs: mounted filesystem dm-0 with ordered data mode
><7>SELinux: initialized (dev dm-0, type ext4), uses xattr
><6>EXT4-fs: mballoc: 0 blocks 0 reqs (0 success)
><6>EXT4-fs: mballoc: 0 extents scanned, 0 goal hits, 0 2^N hits, 0 breaks, 0 lost
><6>EXT4-fs: mballoc: 0 generated and it took 0
><6>EXT4-fs: mballoc: 0 preallocated, 0 discarded
><6>SGI XFS with ACLs, security attributes, large block/inode numbers, no debug enabled
><6>SGI XFS Quota Management subsystem
>
>
>/tmp/anaconda.log:
>16:00:44 INFO    : kernel command line: method=http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os console=ttyS0 serial lang=en keymap=us ksdevice=link ip=dhcp vnc
>
>16:00:44 WARNING : method= is deprecated.  Please use repo= instead.
>16:00:44 INFO    : vnc forced cmdline mode from cmdline
>16:00:44 INFO    : early networking required for syslog
>16:00:44 DEBUG   : no ifcfg files found in /etc/sysconfig/network-scripts
>16:00:44 INFO    : anaconda version 11.5.0.54 on x86_64 starting
>16:00:44 INFO    : 1014688 kB are available
>16:00:44 DEBUG   : going to set language to en_US.UTF-8
>16:00:44 INFO    : setting language to en_US.UTF-8
>16:00:44 DEBUG   : probing buses
>16:00:44 DEBUG   : waiting for hardware to initialize
>16:00:46 INFO    : trying to mount CD device /dev/sr0 on /mnt/stage2
>16:00:46 INFO    : drive status is CDS_NO_DISC
>16:00:46 INFO    : no stage2= given, assuming http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/install.img
>16:00:46 DEBUG   : going to set language to en_US.UTF-8
>16:00:46 INFO    : setting language to en_US.UTF-8
>16:00:46 INFO    : need to set up networking
>16:00:46 INFO    : going to pick interface
>16:00:46 INFO    : only have one network device: eth0
>16:00:46 INFO    : going to do getNetConfig
>16:00:46 INFO    : doing kickstart... setting it up
>16:00:46 DEBUG   : configuring device eth0
>16:00:53 INFO    : get_connection (2068): NetworkManager connected
>16:00:53 INFO    : starting STEP_STAGE2
>16:00:53 INFO    : URL_STAGE_MAIN: url is http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/install.img
>16:00:53 DEBUG   : url address gromit.redhat.com
>16:00:53 DEBUG   : url prefix /pub/fedora/linux/development/x86_64/os/images/install.img
>16:00:53 INFO    : transferring http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/updates.img to a fd
>16:00:53 INFO    : transferring http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/product.img to a fd
>16:00:53 INFO    : transferring http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/install.img to a fd
>16:01:04 DEBUG   : copied 116391936 bytes to /tmp/install.img (complete)
>16:01:04 INFO    : mounted loopback device /mnt/runtime on /dev/loop0 as /tmp/install.img
>16:01:04 INFO    : got stage2 at url http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/install.img
>16:01:04 INFO    : Loading SELinux policy
>16:01:04 INFO    : getting ready to spawn shell now
>16:01:04 INFO    : not spawning a shell
>16:01:04 INFO    : Running anaconda script /usr/bin/anaconda
>16:01:04 DEBUG   : adding extraArg --vnc
>16:01:06 INFO    : using only installclass _Fedora
>16:01:06 INFO    : anaconda called with cmdline = ['/usr/bin/anaconda', '--stage2', 'http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/install.img', '--vnc', '--serial', '--graphical', '--selinux', '--lang', 'en', '--keymap', 'us', '--repo', 'http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os']
>16:01:06 INFO    : Display mode = g
>16:01:06 INFO    : Starting VNC...
>16:01:06 INFO    : ip of eth0 is 192.168.34.236
>16:01:07 INFO    : The VNC server is now running.
>16:01:07 WARNING : 
>
>WARNING!!! VNC server running with NO PASSWORD!
>You can use the vncpassword=<password> boot option
>if you would like to secure the server.
>
>
>16:01:07 INFO    : Please manually connect your vnc client to test1236.test.redhat.com:1 (192.168.34.236) to begin the install.
>16:01:07 INFO    : Started mini-wm
>16:01:07 INFO    : Starting graphical installation...
>16:01:08 INFO    : Detected 992M of memory
>16:01:08 INFO    : Swap attempt of 992M to 1984M
>16:01:08 WARNING : step installtype does not exist
>16:01:08 WARNING : step confirminstall does not exist
>16:01:08 WARNING : step complete does not exist
>16:01:08 INFO    : moving (1) to step welcome
>16:01:11 INFO    : moving (1) to step storageinit
>16:01:11 INFO    : ISCSID is /usr/sbin/iscsid
>16:01:11 INFO    : no initiator set
>16:01:11 INFO    : no /tmp/fcpconfig; not configuring zfcp
>16:01:12 DEBUG   : DeviceTree.addUdevDevice: name: sr0 ;
>16:01:12 DEBUG   : DeviceTree.addUdevOpticalDevice:
>16:01:12 DEBUG   : OpticalDevice._setFormat: sr0 ; current: None ; type: None ;
>16:01:12 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: sr0 ;
>16:01:12 DEBUG   : DeviceTree.addUdevDevice: name: vda ;
>16:01:12 DEBUG   : DeviceTree.addUdevDiskDevice: name: vda ;
>16:01:12 DEBUG   : DiskDevice._setFormat: vda ; current: None ; type: None ;
>16:01:13 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vda ;
>16:01:13 DEBUG   : DeviceTree.addUdevDevice: name: vda1 ;
>16:01:13 DEBUG   : DeviceTree.addUdevPartitionDevice: name: vda1 ;
>16:01:13 DEBUG   : DiskDevice.addChild: kids: 0 ; name: vda ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vda1 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vda1 ; current: None ; type: None ;
>16:01:13 DEBUG   : PartitionDevice.probe: vda1 ; exists: True ;
>16:01:13 DEBUG   : PartitionDevice._computeResize: vda1 ; status: True ;
>16:01:13 DEBUG   : PartitionDevice.getFlag: path: /dev/vda1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: <parted.filesystem.FileSystem object at 0x7f8c2068e450>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e3d0>  PedPartition: <_ped.Partition object at 0x7f8c20685bf0> ;
>16:01:13 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: <parted.filesystem.FileSystem object at 0x7f8c2068e450>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e3d0>  PedPartition: <_ped.Partition object at 0x7f8c20685bf0> ;
>16:01:13 DEBUG   : PartitionDevice.getFlag: path: /dev/vda1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: <parted.filesystem.FileSystem object at 0x7f8c2068e450>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e3d0>  PedPartition: <_ped.Partition object at 0x7f8c20685bf0> ;
>16:01:13 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: <parted.filesystem.FileSystem object at 0x7f8c2068e450>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e3d0>  PedPartition: <_ped.Partition object at 0x7f8c20685bf0> ;
>16:01:13 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vda1 ;
>16:01:13 DEBUG   : Ext3FS.supported: supported: True ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vda1 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vda1 ; current: None ; type: ext3 ;
>16:01:13 DEBUG   : DeviceTree.addUdevDevice: name: vda2 ;
>16:01:13 DEBUG   : DeviceTree.addUdevPartitionDevice: name: vda2 ;
>16:01:13 DEBUG   : DiskDevice.addChild: kids: 1 ; name: vda ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vda2 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vda2 ; current: None ; type: None ;
>16:01:13 DEBUG   : PartitionDevice.probe: vda2 ; exists: True ;
>16:01:13 DEBUG   : PartitionDevice._computeResize: vda2 ; status: True ;
>16:01:13 DEBUG   : PartitionDevice.getFlag: path: /dev/vda2 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e250>  PedPartition: <_ped.Partition object at 0x7f8c20685c50> ;
>16:01:13 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda2 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e250>  PedPartition: <_ped.Partition object at 0x7f8c20685c50> ;
>16:01:13 DEBUG   : PartitionDevice.getFlag: path: /dev/vda2 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e250>  PedPartition: <_ped.Partition object at 0x7f8c20685c50> ;
>16:01:13 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda2 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e250>  PedPartition: <_ped.Partition object at 0x7f8c20685c50> ;
>16:01:13 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vda2 ;
>16:01:13 DEBUG   : LVMPhysicalVolume.__init__: vgName: vg_test150 ; uuid: 7Mt7dk-s8Kf-IfUo-09HW-W0qc-fp4I-tcP9Xw ; exists: True ; vgUuid: 0lYl4m-PHgQ-Rt5y-wKC1-FXG3-985v-PVMcYa ; label: None ; peStart: 0.1875 ; device: /dev/vda2 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vda2 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vda2 ; current: None ; type: lvmpv ;
>16:01:13 DEBUG   : DeviceTree.handleUdevLVMPVFormat: type: lvmpv ; name: vda2 ;
>16:01:13 DEBUG   : PartitionDevice.addChild: kids: 0 ; name: vda2 ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice._setFormat: vg_test150 ; current: None ; type: None ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: vg_test150 ;
>16:01:13 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-lv_root ; current: None ; type: None ;
>16:01:13 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: vg_test150 ;
>16:01:13 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-lv_swap ; current: None ; type: None ;
>16:01:13 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_swap ; status: False ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>16:01:13 DEBUG   : DeviceTree.addUdevDevice: name: vdb ;
>16:01:13 DEBUG   : DeviceTree.addUdevDiskDevice: name: vdb ;
>16:01:13 DEBUG   : DiskDevice._setFormat: vdb ; current: None ; type: None ;
>16:01:13 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdb ;
>16:01:13 DEBUG   : DeviceTree.addUdevDevice: name: vdb1 ;
>16:01:13 DEBUG   : DeviceTree.addUdevPartitionDevice: name: vdb1 ;
>16:01:13 DEBUG   : DiskDevice.addChild: kids: 0 ; name: vdb ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdb1 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdb1 ; current: None ; type: None ;
>16:01:13 DEBUG   : PartitionDevice.probe: vdb1 ; exists: True ;
>16:01:13 DEBUG   : PartitionDevice._computeResize: vdb1 ; status: True ;
>16:01:13 DEBUG   : PartitionDevice.getFlag: path: /dev/vdb1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206a9c50>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad190>  PedPartition: <_ped.Partition object at 0x7f8c206ae050> ;
>16:01:13 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdb1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206a9c50>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad190>  PedPartition: <_ped.Partition object at 0x7f8c206ae050> ;
>16:01:13 DEBUG   : PartitionDevice.getFlag: path: /dev/vdb1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206a9c50>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad190>  PedPartition: <_ped.Partition object at 0x7f8c206ae050> ;
>16:01:13 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdb1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206a9c50>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad190>  PedPartition: <_ped.Partition object at 0x7f8c206ae050> ;
>16:01:13 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdb1 ;
>16:01:13 DEBUG   : LVMPhysicalVolume.__init__: vgName: vg_test150 ; uuid: AFkxE8-rBys-nOPh-QXrs-sEFb-0FZS-EkEq79 ; exists: True ; vgUuid: 0lYl4m-PHgQ-Rt5y-wKC1-FXG3-985v-PVMcYa ; label: None ; peStart: 0.1875 ; device: /dev/vdb1 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdb1 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdb1 ; current: None ; type: lvmpv ;
>16:01:13 DEBUG   : DeviceTree.handleUdevLVMPVFormat: type: lvmpv ; name: vdb1 ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice._addDevice: vg_test150 ; device: vdb1 ; status: False ;
>16:01:13 DEBUG   : PartitionDevice.addChild: kids: 0 ; name: vdb1 ;
>16:01:13 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>16:01:13 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_swap ; status: False ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>16:01:13 DEBUG   : DeviceTree.addUdevDevice: name: vdc ;
>16:01:13 DEBUG   : DeviceTree.addUdevDiskDevice: name: vdc ;
>16:01:13 DEBUG   : DiskDevice._setFormat: vdc ; current: None ; type: None ;
>16:01:13 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdc ;
>16:01:13 DEBUG   : DeviceTree.addUdevDevice: name: vdc1 ;
>16:01:13 DEBUG   : DeviceTree.addUdevPartitionDevice: name: vdc1 ;
>16:01:13 DEBUG   : DiskDevice.addChild: kids: 0 ; name: vdc ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdc1 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdc1 ; current: None ; type: None ;
>16:01:13 DEBUG   : PartitionDevice.probe: vdc1 ; exists: True ;
>16:01:13 DEBUG   : PartitionDevice._computeResize: vdc1 ; status: True ;
>16:01:13 DEBUG   : PartitionDevice.getFlag: path: /dev/vdc1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad210>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad850>  PedPartition: <_ped.Partition object at 0x7f8c206ae0b0> ;
>16:01:13 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdc1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad210>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad850>  PedPartition: <_ped.Partition object at 0x7f8c206ae0b0> ;
>16:01:13 DEBUG   : PartitionDevice.getFlag: path: /dev/vdc1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad210>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad850>  PedPartition: <_ped.Partition object at 0x7f8c206ae0b0> ;
>16:01:13 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdc1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad210>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad850>  PedPartition: <_ped.Partition object at 0x7f8c206ae0b0> ;
>16:01:13 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdc1 ;
>16:01:13 DEBUG   : LVMPhysicalVolume.__init__: vgName: vg_test150 ; uuid: a7Vgib-d7eo-g2ed-OEPe-DPXY-iePM-9eJVE7 ; exists: True ; vgUuid: 0lYl4m-PHgQ-Rt5y-wKC1-FXG3-985v-PVMcYa ; label: None ; peStart: 0.1875 ; device: /dev/vdc1 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdc1 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdc1 ; current: None ; type: lvmpv ;
>16:01:13 DEBUG   : DeviceTree.handleUdevLVMPVFormat: type: lvmpv ; name: vdc1 ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice._addDevice: vg_test150 ; device: vdc1 ; status: False ;
>16:01:13 DEBUG   : PartitionDevice.addChild: kids: 0 ; name: vdc1 ;
>16:01:13 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>16:01:13 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_swap ; status: False ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>16:01:13 DEBUG   : DeviceTree.addUdevDevice: name: vdd ;
>16:01:13 DEBUG   : DeviceTree.addUdevDiskDevice: name: vdd ;
>16:01:13 DEBUG   : DiskDevice._setFormat: vdd ; current: None ; type: None ;
>16:01:13 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdd ;
>16:01:13 DEBUG   : DeviceTree.addUdevDevice: name: vdd1 ;
>16:01:13 DEBUG   : DeviceTree.addUdevPartitionDevice: name: vdd1 ;
>16:01:13 DEBUG   : DiskDevice.addChild: kids: 0 ; name: vdd ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdd1 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdd1 ; current: None ; type: None ;
>16:01:13 DEBUG   : PartitionDevice.probe: vdd1 ; exists: True ;
>16:01:13 DEBUG   : PartitionDevice._computeResize: vdd1 ; status: True ;
>16:01:13 DEBUG   : PartitionDevice.getFlag: path: /dev/vdd1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad8d0>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206adf10>  PedPartition: <_ped.Partition object at 0x7f8c206ae110> ;
>16:01:13 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdd1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad8d0>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206adf10>  PedPartition: <_ped.Partition object at 0x7f8c206ae110> ;
>16:01:13 DEBUG   : PartitionDevice.getFlag: path: /dev/vdd1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad8d0>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206adf10>  PedPartition: <_ped.Partition object at 0x7f8c206ae110> ;
>16:01:13 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdd1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad8d0>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206adf10>  PedPartition: <_ped.Partition object at 0x7f8c206ae110> ;
>16:01:13 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdd1 ;
>16:01:13 DEBUG   : LVMPhysicalVolume.__init__: vgName: vg_test150 ; uuid: 1TayDe-pLbN-7Fhn-H3S1-rHRh-0g1N-F0qMfk ; exists: True ; vgUuid: 0lYl4m-PHgQ-Rt5y-wKC1-FXG3-985v-PVMcYa ; label: None ; peStart: 0.1875 ; device: /dev/vdd1 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdd1 ;
>16:01:13 DEBUG   : PartitionDevice._setFormat: vdd1 ; current: None ; type: lvmpv ;
>16:01:13 DEBUG   : DeviceTree.handleUdevLVMPVFormat: type: lvmpv ; name: vdd1 ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice._addDevice: vg_test150 ; device: vdd1 ; status: False ;
>16:01:13 DEBUG   : PartitionDevice.addChild: kids: 0 ; name: vdd1 ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: True ;
>16:01:13 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>16:01:13 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: True ;
>16:01:14 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_swap ; status: False ;
>16:01:14 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: True ;
>16:01:14 DEBUG   : DeviceTree.addUdevDevice: name: vg_test150-lv_root ;
>16:01:14 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vg_test150-lv_root ;
>16:01:15 DEBUG   : Ext4FS.supported: supported: True ;
>16:01:15 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-lv_root ; current: None ; type: ext4 ;
>16:01:15 DEBUG   : DeviceTree.addUdevDevice: name: vg_test150-lv_swap ;
>16:01:15 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vg_test150-lv_swap ;
>16:01:15 DEBUG   : SwapSpace.__init__: device: /dev/mapper/vg_test150-lv_swap ; uuid: cdbf2e92-072c-4a9b-b683-af6db37b75ad ; exists: True ; label: None ;
>16:01:15 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-lv_swap ; current: None ; type: swap ;
>16:01:15 DEBUG   : OpticalDevice.teardown: sr0 ; status: True ;
>16:01:15 DEBUG   : DeviceFormat.teardown: device: /dev/sr0 ; status: False ; type: None ;
>16:01:15 DEBUG   : PartitionDevice.teardown: vda1 ; status: True ;
>16:01:15 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>16:01:15 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>16:01:15 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-lv_root ; status: True ;
>16:01:15 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>16:01:15 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>16:01:15 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>16:01:15 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>16:01:15 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>16:01:15 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>16:01:15 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>16:01:15 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>16:01:15 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>16:01:15 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>16:01:15 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>16:01:15 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>16:01:15 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>16:01:15 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>16:01:15 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>16:01:16 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>16:01:16 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>16:01:16 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-lv_swap ; status: False ;
>16:01:16 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>16:01:16 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>16:01:16 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>16:01:16 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>16:01:16 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>16:01:16 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>16:01:16 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>16:01:16 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>16:01:16 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>16:01:16 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>16:01:16 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>16:01:16 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>16:01:16 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>16:01:16 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>16:01:16 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>16:01:16 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>16:01:16 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>16:01:16 INFO    : moving (1) to step findrootparts
>16:01:16 DEBUG   : PartitionDevice.setup: vda1 ; status: True ;
>16:01:16 DEBUG   : DiskDevice.setup: vda ; status: True ;
>16:01:16 DEBUG   : DeviceFormat.setup: device: /dev/vda ; status: False ; type: None ;
>16:01:16 DEBUG   : isys.py:mount()- going to mount /dev/vda1 on /mnt/sysimage as ext3 with options ro
>16:01:16 DEBUG   : PartitionDevice.teardown: vda1 ; status: True ;
>16:01:16 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>16:01:16 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>16:01:16 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>16:01:16 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: True ;
>16:01:17 DEBUG   : isys.py:mount()- going to mount /dev/mapper/vg_test150-lv_root on /mnt/sysimage as ext4 with options ro
>16:01:17 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-lv_root ; status: True ;
>16:01:17 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>16:01:17 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>16:01:17 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>16:01:17 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>16:01:17 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>16:01:17 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>16:01:17 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>16:01:17 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>16:01:17 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>16:01:17 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>16:01:17 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>16:01:17 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>16:01:17 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>16:01:18 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>16:01:18 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>16:01:18 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>16:01:18 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>16:01:18 WARNING : step complete does not exist
>16:01:18 INFO    : moving (1) to step findinstall
>16:01:19 WARNING : step complete does not exist
>16:01:19 INFO    : moving (1) to step network
>16:01:19 INFO    : moving (1) to step timezone
>16:01:20 INFO    : moving (1) to step accounts
>16:01:26 INFO    : moving (1) to step setuptime
>12:01:27 INFO    : moving (1) to step parttype
>12:01:27 INFO    : ISCSID is /usr/sbin/iscsid
>12:01:30 INFO    : moving (1) to step partition
>12:01:30 DEBUG   : PartitionDevice.getFlag: path: /dev/vda1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: <parted.filesystem.FileSystem object at 0x7f8c2068e450>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e3d0>  PedPartition: <_ped.Partition object at 0x7f8c20685bf0> ;
>12:01:30 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: <parted.filesystem.FileSystem object at 0x7f8c2068e450>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e3d0>  PedPartition: <_ped.Partition object at 0x7f8c20685bf0> ;
>12:01:30 DEBUG   : PartitionDevice.getFlag: path: /dev/vda2 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e250>  PedPartition: <_ped.Partition object at 0x7f8c20685c50> ;
>12:01:30 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda2 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c20686d90>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c2068e250>  PedPartition: <_ped.Partition object at 0x7f8c20685c50> ;
>12:01:30 DEBUG   : PartitionDevice.getFlag: path: /dev/vdb1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206a9c50>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad190>  PedPartition: <_ped.Partition object at 0x7f8c206ae050> ;
>12:01:30 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdb1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206a9c50>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad190>  PedPartition: <_ped.Partition object at 0x7f8c206ae050> ;
>12:01:30 DEBUG   : PartitionDevice.getFlag: path: /dev/vdc1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad210>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad850>  PedPartition: <_ped.Partition object at 0x7f8c206ae0b0> ;
>12:01:30 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdc1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad210>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206ad850>  PedPartition: <_ped.Partition object at 0x7f8c206ae0b0> ;
>12:01:30 DEBUG   : PartitionDevice.getFlag: path: /dev/vdd1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad8d0>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206adf10>  PedPartition: <_ped.Partition object at 0x7f8c206ae110> ;
>12:01:30 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdd1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7f8c206ad8d0>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7f8c206adf10>  PedPartition: <_ped.Partition object at 0x7f8c206ae110> ;
>12:01:39 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>12:01:39 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>12:01:39 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>12:01:39 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>12:01:39 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>12:01:39 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>12:01:39 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>12:01:39 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>12:01:39 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>12:01:40 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>12:01:40 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>12:01:40 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>12:01:40 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>12:01:40 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>12:01:40 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>12:01:40 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>12:01:40 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>12:01:40 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>12:01:40 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:40 DEBUG   : BindFS.supported: supported: False ;
>12:01:40 DEBUG   : BindFS.supported: supported: False ;
>12:01:40 DEBUG   : DevPtsFS.supported: supported: False ;
>12:01:40 DEBUG   : DevPtsFS.supported: supported: False ;
>12:01:40 DEBUG   : DMRaidMember.__init__:
>12:01:40 DEBUG   : Ext2FS.supported: supported: True ;
>12:01:40 DEBUG   : Ext2FS.supported: supported: True ;
>12:01:40 DEBUG   : Ext3FS.supported: supported: True ;
>12:01:40 DEBUG   : Ext3FS.supported: supported: True ;
>12:01:40 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:40 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:40 DEBUG   : HFS.supported: supported: False ;
>12:01:40 DEBUG   : HFS.supported: supported: False ;
>12:01:40 DEBUG   : HFSPlus.supported: supported: False ;
>12:01:40 DEBUG   : HFSPlus.supported: supported: False ;
>12:01:40 DEBUG   : Iso9660FS.supported: supported: True ;
>12:01:40 DEBUG   : Iso9660FS.supported: supported: True ;
>12:01:40 DEBUG   : LUKS.__init__:
>12:01:40 DEBUG   : LVMPhysicalVolume.__init__:
>12:01:40 DEBUG   : MDRaidMember.__init__:
>12:01:40 DEBUG   : NFS.supported: supported: False ;
>12:01:40 DEBUG   : NFS.supported: supported: False ;
>12:01:40 DEBUG   : NFSv4.supported: supported: False ;
>12:01:40 DEBUG   : NFSv4.supported: supported: False ;
>12:01:40 DEBUG   : NoDevFS.supported: supported: False ;
>12:01:40 DEBUG   : NoDevFS.supported: supported: False ;
>12:01:40 DEBUG   : NTFS.supported: supported: False ;
>12:01:40 DEBUG   : NTFS.supported: supported: False ;
>12:01:40 DEBUG   : ProcFS.supported: supported: False ;
>12:01:40 DEBUG   : ProcFS.supported: supported: False ;
>12:01:40 DEBUG   : SwapSpace.__init__:
>12:01:40 DEBUG   : SysFS.supported: supported: False ;
>12:01:40 DEBUG   : SysFS.supported: supported: False ;
>12:01:40 DEBUG   : TmpFS.supported: supported: False ;
>12:01:40 DEBUG   : TmpFS.supported: supported: False ;
>12:01:40 DEBUG   : FATFS.supported: supported: True ;
>12:01:40 DEBUG   : FATFS.supported: supported: True ;
>12:01:40 DEBUG   : XFS.supported: supported: True ;
>12:01:40 DEBUG   : XFS.supported: supported: True ;
>12:01:40 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:47 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:47 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>12:01:47 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>12:01:47 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>12:01:47 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>12:01:47 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>12:01:47 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>12:01:47 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>12:01:47 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>12:01:47 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>12:01:53 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>12:01:53 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>12:01:53 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>12:01:53 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>12:01:53 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>12:01:53 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>12:01:53 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>12:01:53 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>12:01:53 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>12:01:53 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>12:01:53 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>12:01:53 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>12:01:53 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>12:01:53 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>12:01:53 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>12:01:53 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>12:01:53 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>12:01:53 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 2 ; name: tmp-vg_test150 ;
>12:01:53 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-LogVol02 ; current: None ; type: ext4 ;
>12:01:53 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:53 DEBUG   : BindFS.supported: supported: False ;
>12:01:53 DEBUG   : BindFS.supported: supported: False ;
>12:01:53 DEBUG   : DevPtsFS.supported: supported: False ;
>12:01:53 DEBUG   : DevPtsFS.supported: supported: False ;
>12:01:53 DEBUG   : DMRaidMember.__init__:
>12:01:53 DEBUG   : Ext2FS.supported: supported: True ;
>12:01:53 DEBUG   : Ext2FS.supported: supported: True ;
>12:01:53 DEBUG   : Ext3FS.supported: supported: True ;
>12:01:53 DEBUG   : Ext3FS.supported: supported: True ;
>12:01:53 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:53 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:53 DEBUG   : HFS.supported: supported: False ;
>12:01:53 DEBUG   : HFS.supported: supported: False ;
>12:01:53 DEBUG   : HFSPlus.supported: supported: False ;
>12:01:53 DEBUG   : HFSPlus.supported: supported: False ;
>12:01:53 DEBUG   : Iso9660FS.supported: supported: True ;
>12:01:53 DEBUG   : Iso9660FS.supported: supported: True ;
>12:01:53 DEBUG   : LUKS.__init__:
>12:01:53 DEBUG   : LVMPhysicalVolume.__init__:
>12:01:53 DEBUG   : MDRaidMember.__init__:
>12:01:53 DEBUG   : NFS.supported: supported: False ;
>12:01:53 DEBUG   : NFS.supported: supported: False ;
>12:01:53 DEBUG   : NFSv4.supported: supported: False ;
>12:01:53 DEBUG   : NFSv4.supported: supported: False ;
>12:01:53 DEBUG   : NoDevFS.supported: supported: False ;
>12:01:53 DEBUG   : NoDevFS.supported: supported: False ;
>12:01:53 DEBUG   : NTFS.supported: supported: False ;
>12:01:53 DEBUG   : NTFS.supported: supported: False ;
>12:01:53 DEBUG   : ProcFS.supported: supported: False ;
>12:01:53 DEBUG   : ProcFS.supported: supported: False ;
>12:01:53 DEBUG   : SwapSpace.__init__:
>12:01:53 DEBUG   : SysFS.supported: supported: False ;
>12:01:53 DEBUG   : SysFS.supported: supported: False ;
>12:01:53 DEBUG   : TmpFS.supported: supported: False ;
>12:01:53 DEBUG   : TmpFS.supported: supported: False ;
>12:01:53 DEBUG   : FATFS.supported: supported: True ;
>12:01:53 DEBUG   : FATFS.supported: supported: True ;
>12:01:53 DEBUG   : XFS.supported: supported: True ;
>12:01:53 DEBUG   : XFS.supported: supported: True ;
>12:01:53 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:59 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:59 DEBUG   : Ext4FS.supported: supported: True ;
>12:01:59 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-LogVol02 ; current: ext4 ; type: ext4 ;
>12:01:59 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>12:01:59 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>12:01:59 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>12:01:59 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>12:01:59 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>12:01:59 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>12:01:59 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>12:01:59 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>12:01:59 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>12:01:59 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 2 ; name: tmp-vg_test150 ;
>12:01:59 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-LogVol02 ; current: None ; type: ext4 ;
>12:02:00 DEBUG   : finished editing vg
>12:02:00 DEBUG   : pvs: ['vda2', 'vdb1', 'vdc1', 'vdd1']
>12:02:00 DEBUG   : luks: []
>12:02:00 DEBUG   : lv {'format': <storage.formats.fs.Ext4FS object at 0x7f8c15f26f90>, 'name': 'lv_root', 'exists': True, 'size': 5000}
>12:02:00 DEBUG   : lv {'format': <storage.formats.swap.SwapSpace object at 0x7f8c15f26fd0>, 'name': 'lv_swap', 'exists': True, 'size': 1984.0}
>12:02:00 DEBUG   : lv {'format': <storage.formats.fs.Ext4FS object at 0x7f8c1d321150>, 'name': 'LogVol02', 'exists': False, 'size': 11232L}
>12:02:00 DEBUG   : old lv lv_root...
>12:02:00 DEBUG   : old lv lv_swap...
>12:02:00 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>12:02:00 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>12:02:00 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>12:02:00 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>12:02:00 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>12:02:00 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>12:02:00 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>12:02:00 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>12:02:00 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>12:02:00 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 2 ; name: tmp-vg_test150 ;
>12:02:00 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-LogVol02 ; current: None ; type: ext4 ;
>12:02:00 DEBUG   : new lv LVMLogicalVolumeDevice instance (0x7f8c1d307710) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c15f26f90>  size = 5000
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 5000  path = /dev/mapper/tmp--vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321f50>  percent = 0
>12:02:00 DEBUG   : lv lv_root already exists
>12:02:00 DEBUG   : format already exists
>12:02:00 DEBUG   : new lv LVMLogicalVolumeDevice instance (0x7f8c1d307a90) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7f8c15f26fd0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/tmp--vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321f50>  percent = 0
>12:02:00 DEBUG   : lv lv_swap already exists
>12:02:00 DEBUG   : format already exists
>12:02:00 DEBUG   : new lv LVMLogicalVolumeDevice instance (0x7f8c1d307950) --
>  description =   name = tmp-vg_test150-LogVol02  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c1d321150>  size = 11232
>  major = 0  minor = 0  exists = False
>  sysfs path =   label = None
>  target size = 11232  path = /dev/mapper/tmp--vg_test150-LogVol02
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321f50>  percent = 0
>12:02:00 DEBUG   : creating lv LogVol02
>12:02:00 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 2 ; name: vg_test150 ;
>12:02:00 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-LogVol02 ; current: None ; type: None ;
>12:02:00 DEBUG   : Ext4FS.supported: supported: True ;
>12:02:00 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-LogVol02 ; current: None ; type: ext4 ;
>12:02:00 DEBUG   : refresh: justRedraw=True
>12:02:01 DEBUG   : Ext3FS.supported: supported: True ;
>12:02:01 DEBUG   : BindFS.supported: supported: False ;
>12:02:01 DEBUG   : BindFS.supported: supported: False ;
>12:02:01 DEBUG   : DevPtsFS.supported: supported: False ;
>12:02:01 DEBUG   : DevPtsFS.supported: supported: False ;
>12:02:01 DEBUG   : DMRaidMember.__init__:
>12:02:01 DEBUG   : Ext2FS.supported: supported: True ;
>12:02:01 DEBUG   : Ext2FS.supported: supported: True ;
>12:02:01 DEBUG   : Ext3FS.supported: supported: True ;
>12:02:01 DEBUG   : Ext3FS.supported: supported: True ;
>12:02:01 DEBUG   : Ext4FS.supported: supported: True ;
>12:02:01 DEBUG   : Ext4FS.supported: supported: True ;
>12:02:01 DEBUG   : HFS.supported: supported: False ;
>12:02:01 DEBUG   : HFS.supported: supported: False ;
>12:02:01 DEBUG   : HFSPlus.supported: supported: False ;
>12:02:01 DEBUG   : HFSPlus.supported: supported: False ;
>12:02:01 DEBUG   : Iso9660FS.supported: supported: True ;
>12:02:01 DEBUG   : Iso9660FS.supported: supported: True ;
>12:02:01 DEBUG   : LUKS.__init__:
>12:02:01 DEBUG   : LVMPhysicalVolume.__init__:
>12:02:01 DEBUG   : MDRaidMember.__init__:
>12:02:01 DEBUG   : NFS.supported: supported: False ;
>12:02:01 DEBUG   : NFS.supported: supported: False ;
>12:02:01 DEBUG   : NFSv4.supported: supported: False ;
>12:02:01 DEBUG   : NFSv4.supported: supported: False ;
>12:02:01 DEBUG   : NoDevFS.supported: supported: False ;
>12:02:01 DEBUG   : NoDevFS.supported: supported: False ;
>12:02:01 DEBUG   : NTFS.supported: supported: False ;
>12:02:01 DEBUG   : NTFS.supported: supported: False ;
>12:02:01 DEBUG   : ProcFS.supported: supported: False ;
>12:02:01 DEBUG   : ProcFS.supported: supported: False ;
>12:02:01 DEBUG   : SwapSpace.__init__:
>12:02:01 DEBUG   : SysFS.supported: supported: False ;
>12:02:01 DEBUG   : SysFS.supported: supported: False ;
>12:02:01 DEBUG   : TmpFS.supported: supported: False ;
>12:02:01 DEBUG   : TmpFS.supported: supported: False ;
>12:02:01 DEBUG   : FATFS.supported: supported: True ;
>12:02:01 DEBUG   : FATFS.supported: supported: True ;
>12:02:01 DEBUG   : XFS.supported: supported: True ;
>12:02:01 DEBUG   : XFS.supported: supported: True ;
>12:02:01 DEBUG   : Ext3FS.supported: supported: True ;
>12:02:01 DEBUG   : Ext3FS.supported: supported: True ;
>12:02:01 DEBUG   : Ext4FS.supported: supported: True ;
>12:02:01 DEBUG   : Ext4FS.supported: supported: True ;
>12:02:05 DEBUG   : Ext3FS.supported: supported: True ;
>12:02:07 DEBUG   : Ext3FS.supported: supported: True ;
>12:02:07 DEBUG   : PartitionDevice._setFormat: vda1 ;
>12:02:07 DEBUG   : PartitionDevice._setFormat: vda1 ; current: ext3 ; type: ext3 ;
>12:02:07 DEBUG   : PartitionDevice._computeResize: vda1 ; status: True ;
>12:02:07 DEBUG   : refresh: justRedraw=False
>12:02:07 DEBUG   : DiskDevice.setup: vda ; status: True ;
>12:02:07 DEBUG   : DiskDevice.setup: vdb ; status: True ;
>12:02:07 DEBUG   : DiskDevice.setup: vdc ; status: True ;
>12:02:07 DEBUG   : DiskDevice.setup: vdd ; status: True ;
>12:02:11 INFO    : moving (1) to step storagedone
>12:02:12 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>12:02:12 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>12:02:12 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>12:02:12 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>12:02:12 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>12:02:12 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>12:02:12 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>12:02:12 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>12:02:12 INFO    : moving (1) to step enablefilesystems
>12:02:12 DEBUG   : OpticalDevice.teardown: sr0 ; status: True ;
>12:02:12 DEBUG   : DeviceFormat.teardown: device: /dev/sr0 ; status: False ; type: None ;
>12:02:12 DEBUG   : PartitionDevice.teardown: vda1 ; status: True ;
>12:02:12 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>12:02:12 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>12:02:12 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-lv_root ; status: False ;
>12:02:12 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>12:02:12 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>12:02:12 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>12:02:12 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>12:02:12 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>12:02:12 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>12:02:12 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>12:02:12 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>12:02:12 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>12:02:13 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>12:02:13 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>12:02:13 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>12:02:13 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>12:02:13 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>12:02:13 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>12:02:13 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-lv_swap ; status: False ;
>12:02:13 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>12:02:13 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>12:02:13 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>12:02:13 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>12:02:13 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>12:02:13 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>12:02:13 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>12:02:13 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>12:02:13 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>12:02:13 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>12:02:13 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>12:02:13 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>12:02:13 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>12:02:13 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-LogVol02 ; status: False ;
>12:02:13 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>12:02:13 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>12:02:13 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>12:02:13 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>12:02:13 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>12:02:13 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>12:02:13 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>12:02:13 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>12:02:13 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>12:02:13 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>12:02:13 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>12:02:13 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>12:02:13 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>12:02:13 DEBUG   : DiskDevice.resetPartedDisk: vdc ;
>12:02:13 DEBUG   : DiskDevice.resetPartedDisk: vdb ;
>12:02:13 DEBUG   : DiskDevice.resetPartedDisk: vda ;
>12:02:13 DEBUG   : DiskDevice.resetPartedDisk: vdd ;
>12:02:13 DEBUG   : LVMLogicalVolumeDevice.resize: vg_test150-lv_root ; status: False ;
>12:02:13 DEBUG   : PartitionDevice.setup: vda2 ; status: True ;
>12:02:13 DEBUG   : DiskDevice.setup: vda ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.setup: device: /dev/vda ; status: False ; type: None ;
>12:02:13 DEBUG   : PartitionDevice.setup: vdb1 ; status: True ;
>12:02:13 DEBUG   : DiskDevice.setup: vdb ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.setup: device: /dev/vdb ; status: False ; type: None ;
>12:02:13 DEBUG   : PartitionDevice.setup: vdc1 ; status: True ;
>12:02:13 DEBUG   : DiskDevice.setup: vdc ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.setup: device: /dev/vdc ; status: False ; type: None ;
>12:02:13 DEBUG   : PartitionDevice.setup: vdd1 ; status: True ;
>12:02:13 DEBUG   : DiskDevice.setup: vdd ; status: True ;
>12:02:13 DEBUG   : DeviceFormat.setup: device: /dev/vdd ; status: False ; type: None ;
>12:02:14 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>12:02:14 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: True ;
>
>
>/tmp/program.log:
>Running... ['udevadm', 'trigger', '--subsystem-match=block']
>Running... ['udevadm', 'settle', '--timeout=30']
>Running... ['dumpe2fs', '-h', '/dev/vda1']
>Filesystem volume name:   <none>
>Last mounted on:          <not available>
>Filesystem UUID:          d03af131-b721-429c-9576-822685af647a
>Filesystem magic number:  0xEF53
>Filesystem revision #:    1 (dynamic)
>Filesystem features:      has_journal ext_attr resize_inode dir_index filetype sparse_super
>Filesystem flags:         signed_directory_hash 
>Default mount options:    user_xattr acl
>Filesystem state:         clean
>Errors behavior:          Continue
>Filesystem OS type:       Linux
>Inode count:              51200
>Block count:              204800
>Reserved block count:     10240
>Free blocks:              184201
>Free inodes:              51164
>First block:              1
>Block size:               1024
>Fragment size:            1024
>Reserved GDT blocks:      256
>Blocks per group:         8192
>Fragments per group:      8192
>Inodes per group:         2048
>Inode blocks per group:   256
>Filesystem created:       Tue May 26 15:52:22 2009
>Last mount time:          Tue May 26 15:52:41 2009
>Last write time:          Tue May 26 15:58:24 2009
>Mount count:              1
>Maximum mount count:      -1
>Last checked:             Tue May 26 15:52:22 2009
>Check interval:           0 (<none>)
>Reserved blocks uid:      0 (user root)
>Reserved blocks gid:      0 (group root)
>First inode:              11
>Inode size:	          128
>Journal inode:            8
>Default directory hash:   half_md4
>Directory Hash Seed:      9bce74cf-c748-4538-a61a-0543257f6b1a
>Journal backup:           inode blocks
>Journal size:             4113k
>
>dumpe2fs 1.41.4 (27-Jan-2009)
>Running... ['resize2fs', '-P', '/dev/vda1']
>Estimated minimum size of the filesystem: 13633
>resize2fs 1.41.4 (27-Jan-2009)
>Running... ['lvm', 'lvchange', '-a', 'y', 'vg_test150/lv_root']
>Running... ['lvm', 'lvchange', '-a', 'y', 'vg_test150/lv_swap']
>Running... ['udevadm', 'settle', '--timeout=30']
>Running... ['dumpe2fs', '-h', '/dev/mapper/vg_test150-lv_root']
>Filesystem volume name:   <none>
>Last mounted on:          <not available>
>Filesystem UUID:          696804f5-6079-4009-bfa8-fc48d3fb1bc1
>Filesystem magic number:  0xEF53
>Filesystem revision #:    1 (dynamic)
>Filesystem features:      has_journal ext_attr resize_inode dir_index filetype extent flex_bg sparse_super large_file huge_file uninit_bg dir_nlink extra_isize
>Filesystem flags:         signed_directory_hash 
>Default mount options:    user_xattr acl
>Filesystem state:         clean
>Errors behavior:          Continue
>Filesystem OS type:       Linux
>Inode count:              1040384
>Block count:              4155392
>Reserved block count:     207769
>Free blocks:              3811575
>Free inodes:              999804
>First block:              0
>Block size:               4096
>Fragment size:            4096
>Reserved GDT blocks:      1014
>Blocks per group:         32768
>Fragments per group:      32768
>Inodes per group:         8192
>Inode blocks per group:   512
>Flex block group size:    16
>Filesystem created:       Tue May 26 15:52:28 2009
>Last mount time:          Tue May 26 15:52:41 2009
>Last write time:          Tue May 26 15:58:24 2009
>Mount count:              1
>Maximum mount count:      -1
>Last checked:             Tue May 26 15:52:28 2009
>Check interval:           0 (<none>)
>Reserved blocks uid:      0 (user root)
>Reserved blocks gid:      0 (group root)
>First inode:              11
>Inode size:	          256
>Required extra isize:     28
>Desired extra isize:      28
>Journal inode:            8
>Default directory hash:   half_md4
>Directory Hash Seed:      4a278407-c09a-4aab-9636-bbe59a0869cf
>Journal backup:           inode blocks
>Journal size:             128M
>
>dumpe2fs 1.41.4 (27-Jan-2009)
>Running... ['resize2fs', '-P', '/dev/mapper/vg_test150-lv_root']
>Estimated minimum size of the filesystem: 290468
>resize2fs 1.41.4 (27-Jan-2009)
>Running... ['udevadm', 'settle', '--timeout=30']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['lvm', 'lvchange', '-a', 'n', 'vg_test150/lv_root']
>Running... ['lvm', 'vgchange', '-a', 'n', 'vg_test150']
>  0 logical volume(s) in volume group "vg_test150" now active
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['lvm', 'vgchange', '-a', 'n', 'vg_test150']
>  0 logical volume(s) in volume group "vg_test150" now active
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['lvm', 'lvchange', '-a', 'y', 'vg_test150/lv_root']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['lvm', 'lvchange', '-a', 'n', 'vg_test150/lv_root']
>Running... ['lvm', 'vgchange', '-a', 'n', 'vg_test150']
>  0 logical volume(s) in volume group "vg_test150" now active
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['/usr/sbin/hwclock', '--hctosys', '-u']
>Running... ['modprobe', 'ext2']
>Running... ['modprobe', 'vfat']
>Running... ['modprobe', 'xfs']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['swapoff', '-a']
>swapoff: /etc/fstab: No such file or directory
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['lvm', 'vgchange', '-a', 'n', 'vg_test150']
>  0 logical volume(s) in volume group "vg_test150" now active
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['lvm', 'vgchange', '-a', 'n', 'vg_test150']
>  0 logical volume(s) in volume group "vg_test150" now active
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['lvm', 'vgchange', '-a', 'n', 'vg_test150']
>  0 logical volume(s) in volume group "vg_test150" now active
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['lvm', 'lvresize', '-L', '5000m', 'vg_test150/lv_root']
>  Reducing logical volume lv_root to 4.88 GB
>  Logical volume lv_root successfully resized
>Running... ['udevadm', 'settle', '--timeout=10']
>Running... ['lvm', 'lvchange', '-a', 'y', 'vg_test150/lv_root']
>Running... ['e2fsck', '-f', '-p', '-C', '0', '/dev/mapper/vg_test150-lv_root']
>
>
>/tmp/storage.log:
>[2009-05-26 16:01:05,586]    DEBUG: registered device format class DMRaidMember as dmraidmember
>[2009-05-26 16:01:05,610]    DEBUG: registered device format class Ext2FS as ext2
>[2009-05-26 16:01:05,610]    DEBUG: registered device format class Ext3FS as ext3
>[2009-05-26 16:01:05,611]    DEBUG: registered device format class Ext4FS as ext4
>[2009-05-26 16:01:05,611]    DEBUG: registered device format class FATFS as vfat
>[2009-05-26 16:01:05,611]    DEBUG: registered device format class EFIFS as efi
>[2009-05-26 16:01:05,611]    DEBUG: registered device format class BTRFS as btrfs
>[2009-05-26 16:01:05,611]    DEBUG: registered device format class GFS2 as gfs2
>[2009-05-26 16:01:05,611]    DEBUG: registered device format class JFS as jfs
>[2009-05-26 16:01:05,612]    DEBUG: registered device format class XFS as xfs
>[2009-05-26 16:01:05,612]    DEBUG: registered device format class HFS as hfs
>[2009-05-26 16:01:05,612]    DEBUG: registered device format class AppleBootstrapFS as appleboot
>[2009-05-26 16:01:05,612]    DEBUG: registered device format class HFSPlus as hfs+
>[2009-05-26 16:01:05,612]    DEBUG: registered device format class NTFS as ntfs
>[2009-05-26 16:01:05,613]    DEBUG: registered device format class NFS as nfs
>[2009-05-26 16:01:05,613]    DEBUG: registered device format class NFSv4 as nfs4
>[2009-05-26 16:01:05,613]    DEBUG: registered device format class Iso9660FS as iso9660
>[2009-05-26 16:01:05,613]    DEBUG: registered device format class NoDevFS as nodev
>[2009-05-26 16:01:05,613]    DEBUG: registered device format class DevPtsFS as devpts
>[2009-05-26 16:01:05,613]    DEBUG: registered device format class ProcFS as proc
>[2009-05-26 16:01:05,614]    DEBUG: registered device format class SysFS as sysfs
>[2009-05-26 16:01:05,614]    DEBUG: registered device format class TmpFS as tmpfs
>[2009-05-26 16:01:05,614]    DEBUG: registered device format class BindFS as bind
>[2009-05-26 16:01:05,630]    DEBUG: registered device format class LUKS as luks
>[2009-05-26 16:01:05,631]    DEBUG: registered device format class LVMPhysicalVolume as lvmpv
>[2009-05-26 16:01:05,632]    DEBUG: registered device format class MDRaidMember as mdmember
>[2009-05-26 16:01:05,633]    DEBUG: registered device format class PPCPRePBoot as prepboot
>[2009-05-26 16:01:05,636]    DEBUG: registered device format class SwapSpace as swap
>[2009-05-26 16:01:12,672]     INFO: devices to scan: ['sr0', 'vda', 'vda1', 'vda2', 'vdb', 'vdb1', 'vdc', 'vdc1', 'vdd', 'vdd1']
>[2009-05-26 16:01:12,761]    DEBUG: scanning sr0 (/devices/pci0000:00/0000:00:01.1/host1/target1:0:0/1:0:0:0/block/sr0)...
>[2009-05-26 16:01:12,761]    DEBUG: looking for device 'sr0'...
>[2009-05-26 16:01:12,761]    DEBUG: found None
>[2009-05-26 16:01:12,761]    DEBUG: sr0 is a cdrom
>[2009-05-26 16:01:12,763]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:12,767]    DEBUG: added sr0 (cdrom) to device tree
>[2009-05-26 16:01:12,769]    DEBUG: {'symlinks': ['block/11:0', 'scd0', 'disk/by-path/pci-0000:00:01.1-scsi-1:0:0:0'], 'MAJOR': '11', 'DEVTYPE': 'disk', 'ID_VENDOR': 'QEMU', 'ID_CDROM': '1', 'ID_MODEL': 'QEMU_DVD-ROM', 'MINOR': '0', 'ANACBIN': '/usr/sbin', 'sysfs_path': '/devices/pci0000:00/0000:00:01.1/host1/target1:0:0/1:0:0:0/block/sr0', 'ID_REVISION': '0.10', 'ID_PATH': 'pci-0000:00:01.1-scsi-1:0:0:0', 'ID_MODEL_ENC': 'QEMU\\x20DVD-ROM\\x20\\x20\\x20\\x20', 'ID_CDROM_MRW': '1', 'ID_TYPE': 'cd', 'ID_CDROM_MRW_W': '1', 'ID_VENDOR_ENC': 'QEMU\\x20\\x20\\x20\\x20', 'ID_BUS': 'scsi', 'name': 'sr0'}
>[2009-05-26 16:01:12,769]    DEBUG: no type or existing type for sr0, bailing
>[2009-05-26 16:01:12,770]    DEBUG: scanning vda (/devices/virtio-pci/virtio1/block/vda)...
>[2009-05-26 16:01:12,770]    DEBUG: looking for device 'vda'...
>[2009-05-26 16:01:12,770]    DEBUG: found None
>[2009-05-26 16:01:12,772]    DEBUG: vda is a disk
>[2009-05-26 16:01:12,772]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:12,774]    DEBUG: looking up parted Device: /dev/vda
>[2009-05-26 16:01:12,774]    DEBUG: looking up parted Device: /dev/vda
>[2009-05-26 16:01:12,779]    DEBUG: creating parted Disk: /dev/vda
>[2009-05-26 16:01:13,062]    DEBUG: added vda (disk) to device tree
>[2009-05-26 16:01:13,064]    DEBUG: {'symlinks': ['block/252:0'], 'MAJOR': '252', 'name': 'vda', 'ANACBIN': '/usr/sbin', 'DEVTYPE': 'disk', 'sysfs_path': '/devices/virtio-pci/virtio1/block/vda', 'MINOR': '0'}
>[2009-05-26 16:01:13,065]    DEBUG: no type or existing type for vda, bailing
>[2009-05-26 16:01:13,066]    DEBUG: scanning vda1 (/devices/virtio-pci/virtio1/block/vda/vda1)...
>[2009-05-26 16:01:13,067]    DEBUG: looking for device 'vda1'...
>[2009-05-26 16:01:13,067]    DEBUG: found None
>[2009-05-26 16:01:13,067]    DEBUG: vda1 is a partition
>[2009-05-26 16:01:13,070]    DEBUG: looking for device 'vda'...
>[2009-05-26 16:01:13,071]    DEBUG: found DiskDevice instance (0x7f8c20686c10) --
>  description =   name = vda  status = True  parents = []
>  kids = 0
>  uuid = None  format = <storage.formats.DeviceFormat object at 0x7f8c20686b50>  size = 15359.0185547
>  major = 252  minor = 0  exists = True
>  sysfs path = /devices/virtio-pci/virtio1/block/vda  label = None
>  target size = 0  path = /dev/vda
>  format args = []  removable = False  partedDevice = <parted.device.Device object at 0x7f8c20686c90>
>  partedDisk = <parted.disk.Disk object at 0x7f8c20686d90>
>[2009-05-26 16:01:13,076]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:13,078]    DEBUG: looking up parted Partition: /dev/vda1
>[2009-05-26 16:01:13,081]    DEBUG: looking up parted Device: /dev/vda1
>[2009-05-26 16:01:13,093]    DEBUG: added vda1 (partition) to device tree
>[2009-05-26 16:01:13,096]    DEBUG: {'symlinks': ['block/252:1', 'disk/by-uuid/d03af131-b721-429c-9576-822685af647a'], 'MAJOR': '252', 'name': 'vda1', 'ANACBIN': '/usr/sbin', 'DEVTYPE': 'partition', 'sysfs_path': '/devices/virtio-pci/virtio1/block/vda/vda1', 'ID_FS_USAGE': 'filesystem', 'ID_FS_UUID': 'd03af131-b721-429c-9576-822685af647a', 'ID_FS_VERSION': '1.0', 'ID_FS_UUID_ENC': 'd03af131-b721-429c-9576-822685af647a', 'ID_FS_TYPE': 'ext3', 'MINOR': '1'}
>[2009-05-26 16:01:13,097]    DEBUG: type detected on 'vda1' is 'ext3'
>[2009-05-26 16:01:13,182]    DEBUG: getFormat('ext3') returning Ext3FS instance
>[2009-05-26 16:01:13,189]    DEBUG: scanning vda2 (/devices/virtio-pci/virtio1/block/vda/vda2)...
>[2009-05-26 16:01:13,189]    DEBUG: looking for device 'vda2'...
>[2009-05-26 16:01:13,189]    DEBUG: found None
>[2009-05-26 16:01:13,190]    DEBUG: vda2 is a partition
>[2009-05-26 16:01:13,191]    DEBUG: looking for device 'vda'...
>[2009-05-26 16:01:13,192]    DEBUG: found DiskDevice instance (0x7f8c20686c10) --
>  description =   name = vda  status = True  parents = []
>  kids = 1
>  uuid = None  format = <storage.formats.DeviceFormat object at 0x7f8c20686b50>  size = 15359.0185547
>  major = 252  minor = 0  exists = True
>  sysfs path = /devices/virtio-pci/virtio1/block/vda  label = None
>  target size = 0  path = /dev/vda
>  format args = []  removable = False  partedDevice = <parted.device.Device object at 0x7f8c20686c90>
>  partedDisk = <parted.disk.Disk object at 0x7f8c20686d90>
>[2009-05-26 16:01:13,196]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:13,197]    DEBUG: looking up parted Partition: /dev/vda2
>[2009-05-26 16:01:13,199]    DEBUG: looking up parted Device: /dev/vda2
>[2009-05-26 16:01:13,214]    DEBUG: added vda2 (partition) to device tree
>[2009-05-26 16:01:13,216]    DEBUG: {'LVM2_PV_UUID': '7Mt7dk-s8Kf-IfUo-09HW-W0qc-fp4I-tcP9Xw', 'LVM2_VG_EXTENT_SIZE': '4096.00', 'LVM2_PV_SIZE': '15519744.00', 'LVM2_PV_PE_ALLOC_COUNT': '3789', 'ID_FS_VERSION': 'LVM2\\x20001', 'LVM2_VG_UUID': '0lYl4m-PHgQ-Rt5y-wKC1-FXG3-985v-PVMcYa', 'LVM2_LV_SIZE': ['16621568.00', '2031616.00'], 'LVM2_PE_START': '192.00', 'LVM2_PV_NAME': '/dev/vda2', 'ANACBIN': '/usr/sbin', 'DEVTYPE': 'partition', 'MINOR': '2', 'LVM2_LV_NAME': ['lv_root', 'lv_swap'], 'ID_FS_UUID': '7Mt7dk-s8Kf-IfUo-09HW-W0qc-fp4I-tcP9Xw', 'ID_FS_UUID_ENC': '7Mt7dk-s8Kf-IfUo-09HW-W0qc-fp4I-tcP9Xw', 'ID_FS_TYPE': 'LVM2_member', 'LVM2_LV_UUID': ['qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj', 'XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto'], 'LVM2_PV_COUNT': '4', 'LVM2_VG_EXTENT_COUNT': '4554', 'sysfs_path': '/devices/virtio-pci/virtio1/block/vda/vda2', 'ID_FS_USAGE': 'raid', 'LVM2_VG_NAME': 'vg_test150', 'LVM2_VG_FREE': '0', 'LVM2_PV_PE_COUNT': '3789', 'symlinks': ['block/252:2'], 'MAJOR': '252', 'name': 'vda2', 'LVM2_VG_FREE_COUNT': '0', 'LVM2_VG_SIZE': '18653184.00'}
>[2009-05-26 16:01:13,216]    DEBUG: type detected on 'vda2' is 'LVM2_member'
>[2009-05-26 16:01:13,218]    DEBUG: getFormat('LVM2_member') returning LVMPhysicalVolume instance
>[2009-05-26 16:01:13,224]    DEBUG: looking for device 'vg_test150'...
>[2009-05-26 16:01:13,224]    DEBUG: found None
>[2009-05-26 16:01:13,227]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:13,229]    DEBUG: added vg_test150 (lvmvg) to device tree
>[2009-05-26 16:01:13,229]    DEBUG: looking for device 'vg_test150-lv_root'...
>[2009-05-26 16:01:13,229]    DEBUG: found None
>[2009-05-26 16:01:13,231]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:13,233]    DEBUG: added vg_test150-lv_root (lvmlv) to device tree
>[2009-05-26 16:01:13,236]     INFO: setup of vg_test150-lv_root failed: cannot activate VG with missing PV(s)
>[2009-05-26 16:01:13,236]    DEBUG: looking for device 'vg_test150-lv_swap'...
>[2009-05-26 16:01:13,236]    DEBUG: found None
>[2009-05-26 16:01:13,238]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:13,243]    DEBUG: added vg_test150-lv_swap (lvmlv) to device tree
>[2009-05-26 16:01:13,246]     INFO: setup of vg_test150-lv_swap failed: cannot activate VG with missing PV(s)
>[2009-05-26 16:01:13,247]    DEBUG: scanning vdb (/devices/virtio-pci/virtio2/block/vdb)...
>[2009-05-26 16:01:13,247]    DEBUG: looking for device 'vdb'...
>[2009-05-26 16:01:13,247]    DEBUG: found None
>[2009-05-26 16:01:13,249]    DEBUG: vdb is a disk
>[2009-05-26 16:01:13,249]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:13,250]    DEBUG: looking up parted Device: /dev/vdb
>[2009-05-26 16:01:13,251]    DEBUG: looking up parted Device: /dev/vdb
>[2009-05-26 16:01:13,253]    DEBUG: creating parted Disk: /dev/vdb
>[2009-05-26 16:01:13,381]    DEBUG: added vdb (disk) to device tree
>[2009-05-26 16:01:13,384]    DEBUG: {'symlinks': ['block/252:16'], 'MAJOR': '252', 'name': 'vdb', 'ANACBIN': '/usr/sbin', 'DEVTYPE': 'disk', 'sysfs_path': '/devices/virtio-pci/virtio2/block/vdb', 'MINOR': '16'}
>[2009-05-26 16:01:13,384]    DEBUG: no type or existing type for vdb, bailing
>[2009-05-26 16:01:13,387]    DEBUG: scanning vdb1 (/devices/virtio-pci/virtio2/block/vdb/vdb1)...
>[2009-05-26 16:01:13,387]    DEBUG: looking for device 'vdb1'...
>[2009-05-26 16:01:13,387]    DEBUG: found None
>[2009-05-26 16:01:13,388]    DEBUG: vdb1 is a partition
>[2009-05-26 16:01:13,389]    DEBUG: looking for device 'vdb'...
>[2009-05-26 16:01:13,390]    DEBUG: found DiskDevice instance (0x7f8c206a9bd0) --
>  description =   name = vdb  status = True  parents = []
>  kids = 0
>  uuid = None  format = <storage.formats.DeviceFormat object at 0x7f8c206a9b50>  size = 2047.34619141
>  major = 252  minor = 16  exists = True
>  sysfs path = /devices/virtio-pci/virtio2/block/vdb  label = None
>  target size = 0  path = /dev/vdb
>  format args = []  removable = False  partedDevice = <parted.device.Device object at 0x7f8c206a97d0>
>  partedDisk = <parted.disk.Disk object at 0x7f8c206a9c50>
>[2009-05-26 16:01:13,394]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:13,396]    DEBUG: looking up parted Partition: /dev/vdb1
>[2009-05-26 16:01:13,400]    DEBUG: looking up parted Device: /dev/vdb1
>[2009-05-26 16:01:13,410]    DEBUG: added vdb1 (partition) to device tree
>[2009-05-26 16:01:13,412]    DEBUG: {'LVM2_PV_UUID': 'AFkxE8-rBys-nOPh-QXrs-sEFb-0FZS-EkEq79', 'LVM2_VG_EXTENT_SIZE': '4096.00', 'LVM2_PV_SIZE': '2093056.00', 'LVM2_PV_PE_ALLOC_COUNT': '511', 'ID_FS_VERSION': 'LVM2\\x20001', 'LVM2_VG_UUID': '0lYl4m-PHgQ-Rt5y-wKC1-FXG3-985v-PVMcYa', 'LVM2_LV_SIZE': ['16621568.00', '2031616.00'], 'LVM2_PE_START': '192.00', 'LVM2_PV_NAME': '/dev/vdb1', 'ANACBIN': '/usr/sbin', 'DEVTYPE': 'partition', 'MINOR': '17', 'LVM2_LV_NAME': ['lv_root', 'lv_swap'], 'ID_FS_UUID': 'AFkxE8-rBys-nOPh-QXrs-sEFb-0FZS-EkEq79', 'ID_FS_UUID_ENC': 'AFkxE8-rBys-nOPh-QXrs-sEFb-0FZS-EkEq79', 'ID_FS_TYPE': 'LVM2_member', 'LVM2_LV_UUID': ['qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj', 'XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto'], 'LVM2_PV_COUNT': '4', 'LVM2_VG_EXTENT_COUNT': '4554', 'sysfs_path': '/devices/virtio-pci/virtio2/block/vdb/vdb1', 'ID_FS_USAGE': 'raid', 'LVM2_VG_NAME': 'vg_test150', 'LVM2_VG_FREE': '0', 'LVM2_PV_PE_COUNT': '511', 'symlinks': ['block/252:17'], 'MAJOR': '252', 'name': 'vdb1', 'LVM2_VG_FREE_COUNT': '0', 'LVM2_VG_SIZE': '18653184.00'}
>[2009-05-26 16:01:13,412]    DEBUG: type detected on 'vdb1' is 'LVM2_member'
>[2009-05-26 16:01:13,413]    DEBUG: getFormat('LVM2_member') returning LVMPhysicalVolume instance
>[2009-05-26 16:01:13,422]    DEBUG: looking for device 'vg_test150'...
>[2009-05-26 16:01:13,423]    DEBUG: vg_test150 size is 15156MB
>[2009-05-26 16:01:13,423]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c206a9850) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj  format = <storage.formats.DeviceFormat object at 0x7f8c206a9a90>  size = 16232.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 16232.0  path = /dev/mapper/vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 16232MB
>[2009-05-26 16:01:13,423]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c206a9a50) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto  format = <storage.formats.DeviceFormat object at 0x7f8c206a99d0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 1984MB
>[2009-05-26 16:01:13,424]    DEBUG: vg vg_test150 has -3060MB free
>[2009-05-26 16:01:13,424]    DEBUG: vg_test150 size is 15156MB
>[2009-05-26 16:01:13,424]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c206a9850) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj  format = <storage.formats.DeviceFormat object at 0x7f8c206a9a90>  size = 16232.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 16232.0  path = /dev/mapper/vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 16232MB
>[2009-05-26 16:01:13,424]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c206a9a50) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto  format = <storage.formats.DeviceFormat object at 0x7f8c206a99d0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 1984MB
>[2009-05-26 16:01:13,425]    DEBUG: vg vg_test150 has -3060MB free
>[2009-05-26 16:01:13,425]    DEBUG: found LVMVolumeGroupDevice instance (0x7f8c206a9610) --
>  description =   name = vg_test150  status = False  parents = [<storage.devices.PartitionDevice object at 0x7f8c2068e050>]
>  kids = 2
>  uuid = 0lYl4m-PHgQ-Rt5y-wKC1-FXG3-985v-PVMcYa  format = <storage.formats.DeviceFormat object at 0x7f8c206a9990>  size = 15156
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 0  path = /dev/mapper/vg_test150
>  format args = []  target = None  dmUuid = None  free = 0.0  PE Size = 4.0  PE Count = 4554
>  PE Free = 0  PV Count = 4
>  LV Names = []  modified = False
>  extents = 3789.0  free space = -3060
>  free extents = -765.0
>  PVs = [<storage.devices.PartitionDevice object at 0x7f8c2068e050>]
>  LVs = [<storage.devices.LVMLogicalVolumeDevice object at 0x7f8c206a9850>, <storage.devices.LVMLogicalVolumeDevice object at 0x7f8c206a9a50>]
>[2009-05-26 16:01:13,432]     INFO: setup of vg_test150-lv_root failed: cannot activate VG with missing PV(s)
>[2009-05-26 16:01:13,436]     INFO: setup of vg_test150-lv_swap failed: cannot activate VG with missing PV(s)
>[2009-05-26 16:01:13,437]    DEBUG: scanning vdc (/devices/virtio-pci/virtio3/block/vdc)...
>[2009-05-26 16:01:13,437]    DEBUG: looking for device 'vdc'...
>[2009-05-26 16:01:13,438]    DEBUG: found None
>[2009-05-26 16:01:13,439]    DEBUG: vdc is a disk
>[2009-05-26 16:01:13,439]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:13,443]    DEBUG: looking up parted Device: /dev/vdc
>[2009-05-26 16:01:13,443]    DEBUG: looking up parted Device: /dev/vdc
>[2009-05-26 16:01:13,446]    DEBUG: creating parted Disk: /dev/vdc
>[2009-05-26 16:01:13,564]    DEBUG: added vdc (disk) to device tree
>[2009-05-26 16:01:13,566]    DEBUG: {'symlinks': ['block/252:32'], 'MAJOR': '252', 'name': 'vdc', 'ANACBIN': '/usr/sbin', 'DEVTYPE': 'disk', 'sysfs_path': '/devices/virtio-pci/virtio3/block/vdc', 'MINOR': '32'}
>[2009-05-26 16:01:13,567]    DEBUG: no type or existing type for vdc, bailing
>[2009-05-26 16:01:13,568]    DEBUG: scanning vdc1 (/devices/virtio-pci/virtio3/block/vdc/vdc1)...
>[2009-05-26 16:01:13,568]    DEBUG: looking for device 'vdc1'...
>[2009-05-26 16:01:13,569]    DEBUG: found None
>[2009-05-26 16:01:13,569]    DEBUG: vdc1 is a partition
>[2009-05-26 16:01:13,571]    DEBUG: looking for device 'vdc'...
>[2009-05-26 16:01:13,571]    DEBUG: found DiskDevice instance (0x7f8c206a9dd0) --
>  description =   name = vdc  status = True  parents = []
>  kids = 0
>  uuid = None  format = <storage.formats.DeviceFormat object at 0x7f8c206a9ed0>  size = 509.875488281
>  major = 252  minor = 32  exists = True
>  sysfs path = /devices/virtio-pci/virtio3/block/vdc  label = None
>  target size = 0  path = /dev/vdc
>  format args = []  removable = False  partedDevice = <parted.device.Device object at 0x7f8c206ad290>
>  partedDisk = <parted.disk.Disk object at 0x7f8c206ad210>
>[2009-05-26 16:01:13,575]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:13,577]    DEBUG: looking up parted Partition: /dev/vdc1
>[2009-05-26 16:01:13,579]    DEBUG: looking up parted Device: /dev/vdc1
>[2009-05-26 16:01:13,589]    DEBUG: added vdc1 (partition) to device tree
>[2009-05-26 16:01:13,590]    DEBUG: {'LVM2_PV_UUID': 'a7Vgib-d7eo-g2ed-OEPe-DPXY-iePM-9eJVE7', 'LVM2_VG_EXTENT_SIZE': '4096.00', 'LVM2_PV_SIZE': '520192.00', 'LVM2_PV_PE_ALLOC_COUNT': '127', 'ID_FS_VERSION': 'LVM2\\x20001', 'LVM2_VG_UUID': '0lYl4m-PHgQ-Rt5y-wKC1-FXG3-985v-PVMcYa', 'LVM2_LV_SIZE': ['16621568.00', '2031616.00'], 'LVM2_PE_START': '192.00', 'LVM2_PV_NAME': '/dev/vdc1', 'ANACBIN': '/usr/sbin', 'DEVTYPE': 'partition', 'MINOR': '33', 'LVM2_LV_NAME': ['lv_root', 'lv_swap'], 'ID_FS_UUID': 'a7Vgib-d7eo-g2ed-OEPe-DPXY-iePM-9eJVE7', 'ID_FS_UUID_ENC': 'a7Vgib-d7eo-g2ed-OEPe-DPXY-iePM-9eJVE7', 'ID_FS_TYPE': 'LVM2_member', 'LVM2_LV_UUID': ['qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj', 'XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto'], 'LVM2_PV_COUNT': '4', 'LVM2_VG_EXTENT_COUNT': '4554', 'sysfs_path': '/devices/virtio-pci/virtio3/block/vdc/vdc1', 'ID_FS_USAGE': 'raid', 'LVM2_VG_NAME': 'vg_test150', 'LVM2_VG_FREE': '0', 'LVM2_PV_PE_COUNT': '127', 'symlinks': ['block/252:33'], 'MAJOR': '252', 'name': 'vdc1', 'LVM2_VG_FREE_COUNT': '0', 'LVM2_VG_SIZE': '18653184.00'}
>[2009-05-26 16:01:13,590]    DEBUG: type detected on 'vdc1' is 'LVM2_member'
>[2009-05-26 16:01:13,592]    DEBUG: getFormat('LVM2_member') returning LVMPhysicalVolume instance
>[2009-05-26 16:01:13,599]    DEBUG: looking for device 'vg_test150'...
>[2009-05-26 16:01:13,600]    DEBUG: vg_test150 size is 17200MB
>[2009-05-26 16:01:13,600]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c206a9850) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj  format = <storage.formats.DeviceFormat object at 0x7f8c206a9a90>  size = 16232.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 16232.0  path = /dev/mapper/vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 16232MB
>[2009-05-26 16:01:13,601]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c206a9a50) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto  format = <storage.formats.DeviceFormat object at 0x7f8c206a99d0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 1984MB
>[2009-05-26 16:01:13,601]    DEBUG: vg vg_test150 has -1016MB free
>[2009-05-26 16:01:13,601]    DEBUG: vg_test150 size is 17200MB
>[2009-05-26 16:01:13,602]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c206a9850) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj  format = <storage.formats.DeviceFormat object at 0x7f8c206a9a90>  size = 16232.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 16232.0  path = /dev/mapper/vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 16232MB
>[2009-05-26 16:01:13,605]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c206a9a50) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto  format = <storage.formats.DeviceFormat object at 0x7f8c206a99d0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 1984MB
>[2009-05-26 16:01:13,606]    DEBUG: vg vg_test150 has -1016MB free
>[2009-05-26 16:01:13,606]    DEBUG: found LVMVolumeGroupDevice instance (0x7f8c206a9610) --
>  description =   name = vg_test150  status = False  parents = [<storage.devices.PartitionDevice object at 0x7f8c2068e050>, <storage.devices.PartitionDevice object at 0x7f8c206a9f10>]
>  kids = 2
>  uuid = 0lYl4m-PHgQ-Rt5y-wKC1-FXG3-985v-PVMcYa  format = <storage.formats.DeviceFormat object at 0x7f8c206a9990>  size = 17200
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 0  path = /dev/mapper/vg_test150
>  format args = []  target = None  dmUuid = None  free = 0.0  PE Size = 4.0  PE Count = 4554
>  PE Free = 0  PV Count = 4
>  LV Names = []  modified = False
>  extents = 4300.0  free space = -1016
>  free extents = -254.0
>  PVs = [<storage.devices.PartitionDevice object at 0x7f8c2068e050>, <storage.devices.PartitionDevice object at 0x7f8c206a9f10>]
>  LVs = [<storage.devices.LVMLogicalVolumeDevice object at 0x7f8c206a9850>, <storage.devices.LVMLogicalVolumeDevice object at 0x7f8c206a9a50>]
>[2009-05-26 16:01:13,614]     INFO: setup of vg_test150-lv_root failed: cannot activate VG with missing PV(s)
>[2009-05-26 16:01:13,618]     INFO: setup of vg_test150-lv_swap failed: cannot activate VG with missing PV(s)
>[2009-05-26 16:01:13,620]    DEBUG: scanning vdd (/devices/virtio-pci/virtio4/block/vdd)...
>[2009-05-26 16:01:13,620]    DEBUG: looking for device 'vdd'...
>[2009-05-26 16:01:13,620]    DEBUG: found None
>[2009-05-26 16:01:13,623]    DEBUG: vdd is a disk
>[2009-05-26 16:01:13,623]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:13,626]    DEBUG: looking up parted Device: /dev/vdd
>[2009-05-26 16:01:13,626]    DEBUG: looking up parted Device: /dev/vdd
>[2009-05-26 16:01:13,627]    DEBUG: creating parted Disk: /dev/vdd
>[2009-05-26 16:01:13,741]    DEBUG: added vdd (disk) to device tree
>[2009-05-26 16:01:13,743]    DEBUG: {'symlinks': ['block/252:48'], 'MAJOR': '252', 'name': 'vdd', 'ANACBIN': '/usr/sbin', 'DEVTYPE': 'disk', 'sysfs_path': '/devices/virtio-pci/virtio4/block/vdd', 'MINOR': '48'}
>[2009-05-26 16:01:13,743]    DEBUG: no type or existing type for vdd, bailing
>[2009-05-26 16:01:13,745]    DEBUG: scanning vdd1 (/devices/virtio-pci/virtio4/block/vdd/vdd1)...
>[2009-05-26 16:01:13,745]    DEBUG: looking for device 'vdd1'...
>[2009-05-26 16:01:13,745]    DEBUG: found None
>[2009-05-26 16:01:13,745]    DEBUG: vdd1 is a partition
>[2009-05-26 16:01:13,747]    DEBUG: looking for device 'vdd'...
>[2009-05-26 16:01:13,747]    DEBUG: found DiskDevice instance (0x7f8c206ad710) --
>  description =   name = vdd  status = True  parents = []
>  kids = 0
>  uuid = None  format = <storage.formats.DeviceFormat object at 0x7f8c206ad6d0>  size = 509.875488281
>  major = 252  minor = 48  exists = True
>  sysfs path = /devices/virtio-pci/virtio4/block/vdd  label = None
>  target size = 0  path = /dev/vdd
>  format args = []  removable = False  partedDevice = <parted.device.Device object at 0x7f8c206ad950>
>  partedDisk = <parted.disk.Disk object at 0x7f8c206ad8d0>
>[2009-05-26 16:01:13,752]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 16:01:13,753]    DEBUG: looking up parted Partition: /dev/vdd1
>[2009-05-26 16:01:13,757]    DEBUG: looking up parted Device: /dev/vdd1
>[2009-05-26 16:01:13,771]    DEBUG: added vdd1 (partition) to device tree
>[2009-05-26 16:01:13,772]    DEBUG: {'LVM2_PV_UUID': '1TayDe-pLbN-7Fhn-H3S1-rHRh-0g1N-F0qMfk', 'LVM2_VG_EXTENT_SIZE': '4096.00', 'LVM2_PV_SIZE': '520192.00', 'LVM2_PV_PE_ALLOC_COUNT': '127', 'ID_FS_VERSION': 'LVM2\\x20001', 'LVM2_VG_UUID': '0lYl4m-PHgQ-Rt5y-wKC1-FXG3-985v-PVMcYa', 'LVM2_LV_SIZE': ['16621568.00', '2031616.00'], 'LVM2_PE_START': '192.00', 'LVM2_PV_NAME': '/dev/vdd1', 'ANACBIN': '/usr/sbin', 'DEVTYPE': 'partition', 'MINOR': '49', 'LVM2_LV_NAME': ['lv_root', 'lv_swap'], 'ID_FS_UUID': '1TayDe-pLbN-7Fhn-H3S1-rHRh-0g1N-F0qMfk', 'ID_FS_UUID_ENC': '1TayDe-pLbN-7Fhn-H3S1-rHRh-0g1N-F0qMfk', 'ID_FS_TYPE': 'LVM2_member', 'LVM2_LV_UUID': ['qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj', 'XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto'], 'LVM2_PV_COUNT': '4', 'LVM2_VG_EXTENT_COUNT': '4554', 'sysfs_path': '/devices/virtio-pci/virtio4/block/vdd/vdd1', 'ID_FS_USAGE': 'raid', 'LVM2_VG_NAME': 'vg_test150', 'LVM2_VG_FREE': '0', 'LVM2_PV_PE_COUNT': '127', 'symlinks': ['block/252:49'], 'MAJOR': '252', 'name': 'vdd1', 'LVM2_VG_FREE_COUNT': '0', 'LVM2_VG_SIZE': '18653184.00'}
>[2009-05-26 16:01:13,773]    DEBUG: type detected on 'vdd1' is 'LVM2_member'
>[2009-05-26 16:01:13,781]    DEBUG: getFormat('LVM2_member') returning LVMPhysicalVolume instance
>[2009-05-26 16:01:13,796]    DEBUG: looking for device 'vg_test150'...
>[2009-05-26 16:01:13,797]    DEBUG: vg_test150 size is 17708MB
>[2009-05-26 16:01:13,797]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c206a9850) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj  format = <storage.formats.DeviceFormat object at 0x7f8c206a9a90>  size = 16232.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 16232.0  path = /dev/mapper/vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 16232MB
>[2009-05-26 16:01:13,797]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c206a9a50) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto  format = <storage.formats.DeviceFormat object at 0x7f8c206a99d0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 1984MB
>[2009-05-26 16:01:13,805]    DEBUG: vg vg_test150 has -508MB free
>[2009-05-26 16:01:13,806]    DEBUG: vg_test150 size is 17708MB
>[2009-05-26 16:01:13,806]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c206a9850) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj  format = <storage.formats.DeviceFormat object at 0x7f8c206a9a90>  size = 16232.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 16232.0  path = /dev/mapper/vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 16232MB
>[2009-05-26 16:01:13,806]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c206a9a50) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto  format = <storage.formats.DeviceFormat object at 0x7f8c206a99d0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 1984MB
>[2009-05-26 16:01:13,807]    DEBUG: vg vg_test150 has -508MB free
>[2009-05-26 16:01:13,807]    DEBUG: found LVMVolumeGroupDevice instance (0x7f8c206a9610) --
>  description =   name = vg_test150  status = False  parents = [<storage.devices.PartitionDevice object at 0x7f8c2068e050>, <storage.devices.PartitionDevice object at 0x7f8c206a9f10>, <storage.devices.PartitionDevice object at 0x7f8c206ad650>]
>  kids = 2
>  uuid = 0lYl4m-PHgQ-Rt5y-wKC1-FXG3-985v-PVMcYa  format = <storage.formats.DeviceFormat object at 0x7f8c206a9990>  size = 17708
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 0  path = /dev/mapper/vg_test150
>  format args = []  target = None  dmUuid = None  free = 0.0  PE Size = 4.0  PE Count = 4554
>  PE Free = 0  PV Count = 4
>  LV Names = []  modified = False
>  extents = 4427.0  free space = -508
>  free extents = -127.0
>  PVs = [<storage.devices.PartitionDevice object at 0x7f8c2068e050>, <storage.devices.PartitionDevice object at 0x7f8c206a9f10>, <storage.devices.PartitionDevice object at 0x7f8c206ad650>]
>  LVs = [<storage.devices.LVMLogicalVolumeDevice object at 0x7f8c206a9850>, <storage.devices.LVMLogicalVolumeDevice object at 0x7f8c206a9a50>]
>[2009-05-26 16:01:14,261]    DEBUG: looking up parted Device: /dev/mapper/vg_test150-lv_root
>[2009-05-26 16:01:14,751]    DEBUG: looking up parted Device: /dev/mapper/vg_test150-lv_swap
>[2009-05-26 16:01:14,960]     INFO: devices to scan: ['dm-0', 'dm-1']
>[2009-05-26 16:01:14,964]    DEBUG: scanning vg_test150-lv_root (/devices/virtual/block/dm-0)...
>[2009-05-26 16:01:14,964]    DEBUG: looking for device 'vg_test150-lv_root'...
>[2009-05-26 16:01:14,965]    DEBUG: found LVMLogicalVolumeDevice instance (0x7f8c206a9850) --
>  description =   name = vg_test150-lv_root  status = True  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj  format = <storage.formats.DeviceFormat object at 0x7f8c206a9a90>  size = 16232.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 16232.0  path = /dev/mapper/vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0
>[2009-05-26 16:01:14,965]    DEBUG: vg_test150-lv_root is a device-mapper device
>[2009-05-26 16:01:14,967]    DEBUG: {'symlinks': ['block/253:0', 'disk/by-id/dm-name-vg_test150-lv_root', 'disk/by-id/dm-uuid-LVM-0lYl4mPHgQRt5ywKC1FXG3985vPVMcYaqpwK1eFjzq9sqiFdoFH9VfwdTZO5Zfhj', 'disk/by-uuid/696804f5-6079-4009-bfa8-fc48d3fb1bc1'], 'DM_TABLES_LOADED': 'Live', 'DM_NAME': 'vg_test150-lv_root', 'DM_MAJOR': '253', 'name': 'dm-0', 'ANACBIN': '/usr/sbin', 'MAJOR': '253', 'DM_UUID': 'LVM-0lYl4mPHgQRt5ywKC1FXG3985vPVMcYaqpwK1eFjzq9sqiFdoFH9VfwdTZO5Zfhj', 'DM_SUSPENDED': 'Active', 'ID_FS_UUID': '696804f5-6079-4009-bfa8-fc48d3fb1bc1', 'sysfs_path': '/devices/virtual/block/dm-0', 'ID_FS_USAGE': 'filesystem', 'DM_READONLY': 'Writeable', 'DEVTYPE': 'disk', 'ID_FS_VERSION': '1.0', 'ID_FS_UUID_ENC': '696804f5-6079-4009-bfa8-fc48d3fb1bc1', 'DM_OPEN': '0', 'ID_FS_TYPE': 'ext4', 'MINOR': '0', 'DM_MINOR': '0'}
>[2009-05-26 16:01:14,967]    DEBUG: type detected on 'vg_test150-lv_root' is 'ext4'
>[2009-05-26 16:01:15,038]    DEBUG: getFormat('ext4') returning Ext4FS instance
>[2009-05-26 16:01:15,042]    DEBUG: scanning vg_test150-lv_swap (/devices/virtual/block/dm-1)...
>[2009-05-26 16:01:15,042]    DEBUG: looking for device 'vg_test150-lv_swap'...
>[2009-05-26 16:01:15,043]    DEBUG: found LVMLogicalVolumeDevice instance (0x7f8c206a9a50) --
>  description =   name = vg_test150-lv_swap  status = True  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto  format = <storage.formats.DeviceFormat object at 0x7f8c206a99d0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0
>[2009-05-26 16:01:15,043]    DEBUG: vg_test150-lv_swap is a device-mapper device
>[2009-05-26 16:01:15,044]    DEBUG: {'symlinks': ['block/253:1', 'disk/by-id/dm-name-vg_test150-lv_swap', 'disk/by-id/dm-uuid-LVM-0lYl4mPHgQRt5ywKC1FXG3985vPVMcYaXZZJAvlx2xwcUGdbhYysk67dD9ZuPJto', 'disk/by-uuid/cdbf2e92-072c-4a9b-b683-af6db37b75ad'], 'DM_TABLES_LOADED': 'Live', 'DM_NAME': 'vg_test150-lv_swap', 'DM_MAJOR': '253', 'name': 'dm-1', 'ANACBIN': '/usr/sbin', 'MAJOR': '253', 'DM_UUID': 'LVM-0lYl4mPHgQRt5ywKC1FXG3985vPVMcYaXZZJAvlx2xwcUGdbhYysk67dD9ZuPJto', 'DM_SUSPENDED': 'Active', 'ID_FS_UUID': 'cdbf2e92-072c-4a9b-b683-af6db37b75ad', 'sysfs_path': '/devices/virtual/block/dm-1', 'ID_FS_USAGE': 'other', 'DM_READONLY': 'Writeable', 'DEVTYPE': 'disk', 'ID_FS_VERSION': '2', 'ID_FS_UUID_ENC': 'cdbf2e92-072c-4a9b-b683-af6db37b75ad', 'DM_OPEN': '0', 'ID_FS_TYPE': 'swap', 'MINOR': '1', 'DM_MINOR': '1'}
>[2009-05-26 16:01:15,045]    DEBUG: type detected on 'vg_test150-lv_swap' is 'swap'
>[2009-05-26 16:01:15,047]    DEBUG: getFormat('swap') returning SwapSpace instance
>[2009-05-26 16:01:16,404]     INFO: failed to unlink /etc/mdadm.conf
>[2009-05-26 16:01:16,481]     INFO: set SELinux context for mountpoint /mnt/sysimage to None
>[2009-05-26 16:01:16,530]     INFO: set SELinux context for newly mounted filesystem root at /mnt/sysimage to system_u:object_r:mnt_t:s0
>[2009-05-26 16:01:17,052]     INFO: set SELinux context for mountpoint /mnt/sysimage to None
>[2009-05-26 16:01:17,145]     INFO: set SELinux context for newly mounted filesystem root at /mnt/sysimage to system_u:object_r:mnt_t:s0
>[2009-05-26 12:01:30,258]    DEBUG: looking for device 'vda1'...
>[2009-05-26 12:01:30,259]    DEBUG: found PartitionDevice instance (0x7f8c2068e190) --
>  description =   name = vda1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c20686c10>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext3FS object at 0x7f8c2068e590>  size = 200.0
>  major = 252  minor = 1  exists = True
>  sysfs path = /devices/virtio-pci/virtio1/block/vda/vda1  label = None
>  target size = 200.0  path = /dev/vda1
>  format args = []  grow = None  max size = 0  bootable = True
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c2068e390>  disk = <storage.devices.DiskDevice object at 0x7f8c20686c10>
>[2009-05-26 12:01:30,261]    DEBUG: looking for device 'vda2'...
>[2009-05-26 12:01:30,261]    DEBUG: found PartitionDevice instance (0x7f8c2068e050) --
>  description =   name = vda2  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c20686c10>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206a98d0>  size = 15158.987793
>  major = 252  minor = 2  exists = True
>  sysfs path = /devices/virtio-pci/virtio1/block/vda/vda2  label = None
>  target size = 15158.987793  path = /dev/vda2
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c2068e210>  disk = <storage.devices.DiskDevice object at 0x7f8c20686c10>
>[2009-05-26 12:01:30,262]    DEBUG: looking for device 'vdb1'...
>[2009-05-26 12:01:30,262]    DEBUG: found PartitionDevice instance (0x7f8c206a9f10) --
>  description =   name = vdb1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206a9bd0>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206a9fd0>  size = 2047.31542969
>  major = 252  minor = 17  exists = True
>  sysfs path = /devices/virtio-pci/virtio2/block/vdb/vdb1  label = None
>  target size = 2047.31542969  path = /dev/vdb1
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206ad150>  disk = <storage.devices.DiskDevice object at 0x7f8c206a9bd0>
>[2009-05-26 12:01:30,264]    DEBUG: looking for device 'vdc1'...
>[2009-05-26 12:01:30,264]    DEBUG: found PartitionDevice instance (0x7f8c206ad650) --
>  description =   name = vdc1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206a9dd0>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206ada10>  size = 509.844726562
>  major = 252  minor = 33  exists = True
>  sysfs path = /devices/virtio-pci/virtio3/block/vdc/vdc1  label = None
>  target size = 509.844726562  path = /dev/vdc1
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206ad810>  disk = <storage.devices.DiskDevice object at 0x7f8c206a9dd0>
>[2009-05-26 12:01:30,265]    DEBUG: looking for device 'vdd1'...
>[2009-05-26 12:01:30,265]    DEBUG: found PartitionDevice instance (0x7f8c206add10) --
>  description =   name = vdd1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206ad710>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206adfd0>  size = 509.844726562
>  major = 252  minor = 49  exists = True
>  sysfs path = /devices/virtio-pci/virtio4/block/vdd/vdd1  label = None
>  target size = 509.844726562  path = /dev/vdd1
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206aded0>  disk = <storage.devices.DiskDevice object at 0x7f8c206ad710>
>[2009-05-26 12:01:39,070]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 12:01:39,077]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-26 12:01:39,077]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c1d307490) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c15f12950>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c15f26f90>  size = 16232.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 16232.0  path = /dev/mapper/tmp--vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c15f12950>  percent = 0) uses 16232MB
>[2009-05-26 12:01:39,078]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c1d307510) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c15f12950>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7f8c15f26fd0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/tmp--vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c15f12950>  percent = 0) uses 1984MB
>[2009-05-26 12:01:39,078]    DEBUG: vg tmp-vg_test150 has 0MB free
>[2009-05-26 12:01:40,692]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 12:01:47,466]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 12:01:47,477]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-26 12:01:47,477]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c1d31fa10) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d31f210>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c15f26f90>  size = 5000
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 5000  path = /dev/mapper/tmp--vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d31f210>  percent = 0) uses 5000MB
>[2009-05-26 12:01:47,477]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c1d31fbd0) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d31f210>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7f8c15f26fd0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/tmp--vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d31f210>  percent = 0) uses 1984MB
>[2009-05-26 12:01:47,478]    DEBUG: vg tmp-vg_test150 has 11232MB free
>[2009-05-26 12:01:53,876]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 12:01:53,885]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-26 12:01:53,886]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c1d321550) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d31fd90>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c15f26f90>  size = 5000
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 5000  path = /dev/mapper/tmp--vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d31fd90>  percent = 0) uses 5000MB
>[2009-05-26 12:01:53,886]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c1d321710) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d31fd90>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7f8c15f26fd0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/tmp--vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d31fd90>  percent = 0) uses 1984MB
>[2009-05-26 12:01:53,886]    DEBUG: vg tmp-vg_test150 has 11232MB free
>[2009-05-26 12:01:53,895]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 12:01:53,906]    DEBUG: getFormat('ext4') returning Ext4FS instance
>[2009-05-26 12:01:53,915]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 12:01:53,925]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-26 12:01:53,925]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c1d321350) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c15f26f90>  size = 5000
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 5000  path = /dev/mapper/tmp--vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>  percent = 0) uses 5000MB
>[2009-05-26 12:01:53,925]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c1d321290) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7f8c15f26fd0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/tmp--vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>  percent = 0) uses 1984MB
>[2009-05-26 12:01:53,925]    DEBUG: vg tmp-vg_test150 has 11232MB free
>[2009-05-26 12:01:53,981]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-26 12:01:53,982]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c1d321350) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c15f26f90>  size = 5000
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 5000  path = /dev/mapper/tmp--vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>  percent = 0) uses 5000MB
>[2009-05-26 12:01:53,982]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c1d321290) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7f8c15f26fd0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/tmp--vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>  percent = 0) uses 1984MB
>[2009-05-26 12:01:53,982]    DEBUG: lv tmp-vg_test150-LogVol02 (LVMLogicalVolumeDevice instance (0x7f8c1d3210d0) --
>  description =   name = tmp-vg_test150-LogVol02  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c1d321f50>  size = 11232
>  major = 0  minor = 0  exists = False
>  sysfs path =   label = None
>  target size = 11232  path = /dev/mapper/tmp--vg_test150-LogVol02
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>  percent = 0) uses 11232MB
>[2009-05-26 12:01:53,983]    DEBUG: vg tmp-vg_test150 has 0MB free
>[2009-05-26 12:01:59,270]    DEBUG: trying to set lv tmp-vg_test150-LogVol02 size to 11232MB
>[2009-05-26 12:01:59,271]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-26 12:01:59,271]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c1d321350) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c15f26f90>  size = 5000
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 5000  path = /dev/mapper/tmp--vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>  percent = 0) uses 5000MB
>[2009-05-26 12:01:59,271]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c1d321290) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7f8c15f26fd0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/tmp--vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>  percent = 0) uses 1984MB
>[2009-05-26 12:01:59,272]    DEBUG: lv tmp-vg_test150-LogVol02 (LVMLogicalVolumeDevice instance (0x7f8c1d3210d0) --
>  description =   name = tmp-vg_test150-LogVol02  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c1d321f50>  size = 11232
>  major = 0  minor = 0  exists = False
>  sysfs path =   label = None
>  target size = 11232  path = /dev/mapper/tmp--vg_test150-LogVol02
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321250>  percent = 0) uses 11232MB
>[2009-05-26 12:01:59,272]    DEBUG: vg tmp-vg_test150 has 0MB free
>[2009-05-26 12:01:59,283]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 12:01:59,293]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-26 12:01:59,293]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c1d31f2d0) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321650>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c15f26f90>  size = 5000
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 5000  path = /dev/mapper/tmp--vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321650>  percent = 0) uses 5000MB
>[2009-05-26 12:01:59,294]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c1d31f650) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321650>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7f8c15f26fd0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/tmp--vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321650>  percent = 0) uses 1984MB
>[2009-05-26 12:01:59,294]    DEBUG: vg tmp-vg_test150 has 11232MB free
>[2009-05-26 12:01:59,294]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-26 12:01:59,295]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c1d31f2d0) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321650>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c15f26f90>  size = 5000
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 5000  path = /dev/mapper/tmp--vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321650>  percent = 0) uses 5000MB
>[2009-05-26 12:01:59,295]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c1d31f650) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321650>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7f8c15f26fd0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/tmp--vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321650>  percent = 0) uses 1984MB
>[2009-05-26 12:01:59,295]    DEBUG: lv tmp-vg_test150-LogVol02 (LVMLogicalVolumeDevice instance (0x7f8c1d31f510) --
>  description =   name = tmp-vg_test150-LogVol02  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321650>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c1d321150>  size = 11232
>  major = 0  minor = 0  exists = False
>  sysfs path =   label = None
>  target size = 11232  path = /dev/mapper/tmp--vg_test150-LogVol02
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321650>  percent = 0) uses 11232MB
>[2009-05-26 12:01:59,295]    DEBUG: vg tmp-vg_test150 has 0MB free
>[2009-05-26 12:02:00,100]    DEBUG: looking for device 'vda2'...
>[2009-05-26 12:02:00,101]    DEBUG: found PartitionDevice instance (0x7f8c2068e050) --
>  description =   name = vda2  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c20686c10>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206a98d0>  size = 15158.987793
>  major = 252  minor = 2  exists = True
>  sysfs path = /devices/virtio-pci/virtio1/block/vda/vda2  label = None
>  target size = 15158.987793  path = /dev/vda2
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c2068e210>  disk = <storage.devices.DiskDevice object at 0x7f8c20686c10>
>[2009-05-26 12:02:00,101]    DEBUG: looking for device 'vdb1'...
>[2009-05-26 12:02:00,101]    DEBUG: found PartitionDevice instance (0x7f8c206a9f10) --
>  description =   name = vdb1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206a9bd0>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206a9fd0>  size = 2047.31542969
>  major = 252  minor = 17  exists = True
>  sysfs path = /devices/virtio-pci/virtio2/block/vdb/vdb1  label = None
>  target size = 2047.31542969  path = /dev/vdb1
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206ad150>  disk = <storage.devices.DiskDevice object at 0x7f8c206a9bd0>
>[2009-05-26 12:02:00,102]    DEBUG: looking for device 'vdc1'...
>[2009-05-26 12:02:00,102]    DEBUG: found PartitionDevice instance (0x7f8c206ad650) --
>  description =   name = vdc1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206a9dd0>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206ada10>  size = 509.844726562
>  major = 252  minor = 33  exists = True
>  sysfs path = /devices/virtio-pci/virtio3/block/vdc/vdc1  label = None
>  target size = 509.844726562  path = /dev/vdc1
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206ad810>  disk = <storage.devices.DiskDevice object at 0x7f8c206a9dd0>
>[2009-05-26 12:02:00,102]    DEBUG: looking for device 'vdd1'...
>[2009-05-26 12:02:00,102]    DEBUG: found PartitionDevice instance (0x7f8c206add10) --
>  description =   name = vdd1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206ad710>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206adfd0>  size = 509.844726562
>  major = 252  minor = 49  exists = True
>  sysfs path = /devices/virtio-pci/virtio4/block/vdd/vdd1  label = None
>  target size = 509.844726562  path = /dev/vdd1
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206aded0>  disk = <storage.devices.DiskDevice object at 0x7f8c206ad710>
>[2009-05-26 12:02:00,112]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 12:02:00,123]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-26 12:02:00,124]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c1d307710) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7f8c15f26f90>  size = 5000
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 5000  path = /dev/mapper/tmp--vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321f50>  percent = 0) uses 5000MB
>[2009-05-26 12:02:00,124]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c1d307a90) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7f8c15f26fd0>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/tmp--vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c1d321f50>  percent = 0) uses 1984MB
>[2009-05-26 12:02:00,124]    DEBUG: vg tmp-vg_test150 has 11232MB free
>[2009-05-26 12:02:00,128]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-26 12:02:00,129]    DEBUG: vg_test150 size is 18216MB
>[2009-05-26 12:02:00,130]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7f8c206a9850) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = qpwK1e-Fjzq-9sqi-FdoF-H9Vf-wdTZ-O5Zfhj  format = <storage.formats.fs.Ext4FS object at 0x7f8c15ec5610>  size = 5000
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 5000  path = /dev/mapper/vg_test150-lv_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 5000MB
>[2009-05-26 12:02:00,130]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7f8c206a9a50) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>]
>  kids = 0
>  uuid = XZZJAv-lx2x-wcUG-dbhY-ysk6-7dD9-ZuPJto  format = <storage.formats.swap.SwapSpace object at 0x7f8c206a9a90>  size = 1984.0
>  major = 0  minor = 0  exists = True
>  sysfs path =   label = None
>  target size = 1984.0  path = /dev/mapper/vg_test150-lv_swap
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7f8c206a9610>  percent = 0) uses 1984MB
>[2009-05-26 12:02:00,131]    DEBUG: vg vg_test150 has 11232MB free
>[2009-05-26 12:02:00,133]    DEBUG: getFormat('ext4') returning Ext4FS instance
>[2009-05-26 12:02:00,135]    DEBUG: registered action: Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:00,135]    DEBUG: registered action: Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:00,135]    DEBUG: added vg_test150-LogVol02 (lvmlv) to device tree
>[2009-05-26 12:02:00,135]    DEBUG: registered action: Create Device vg_test150-LogVol02 (lvmlv)
>[2009-05-26 12:02:00,136]    DEBUG: registered action: Create Format ext4 on vg_test150-LogVol02 (lvmlv)
>[2009-05-26 12:02:00,141]    DEBUG: looking for device 'vda1'...
>[2009-05-26 12:02:00,141]    DEBUG: found PartitionDevice instance (0x7f8c2068e190) --
>  description =   name = vda1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c20686c10>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext3FS object at 0x7f8c2068e590>  size = 200.0
>  major = 252  minor = 1  exists = True
>  sysfs path = /devices/virtio-pci/virtio1/block/vda/vda1  label = None
>  target size = 200.0  path = /dev/vda1
>  format args = []  grow = None  max size = 0  bootable = True
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c2068e390>  disk = <storage.devices.DiskDevice object at 0x7f8c20686c10>
>[2009-05-26 12:02:00,142]    DEBUG: looking for device 'vda2'...
>[2009-05-26 12:02:00,143]    DEBUG: found PartitionDevice instance (0x7f8c2068e050) --
>  description =   name = vda2  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c20686c10>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206a98d0>  size = 15158.987793
>  major = 252  minor = 2  exists = True
>  sysfs path = /devices/virtio-pci/virtio1/block/vda/vda2  label = None
>  target size = 15158.987793  path = /dev/vda2
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c2068e210>  disk = <storage.devices.DiskDevice object at 0x7f8c20686c10>
>[2009-05-26 12:02:00,144]    DEBUG: looking for device 'vdb1'...
>[2009-05-26 12:02:00,144]    DEBUG: found PartitionDevice instance (0x7f8c206a9f10) --
>  description =   name = vdb1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206a9bd0>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206a9fd0>  size = 2047.31542969
>  major = 252  minor = 17  exists = True
>  sysfs path = /devices/virtio-pci/virtio2/block/vdb/vdb1  label = None
>  target size = 2047.31542969  path = /dev/vdb1
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206ad150>  disk = <storage.devices.DiskDevice object at 0x7f8c206a9bd0>
>[2009-05-26 12:02:00,146]    DEBUG: looking for device 'vdc1'...
>[2009-05-26 12:02:00,146]    DEBUG: found PartitionDevice instance (0x7f8c206ad650) --
>  description =   name = vdc1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206a9dd0>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206ada10>  size = 509.844726562
>  major = 252  minor = 33  exists = True
>  sysfs path = /devices/virtio-pci/virtio3/block/vdc/vdc1  label = None
>  target size = 509.844726562  path = /dev/vdc1
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206ad810>  disk = <storage.devices.DiskDevice object at 0x7f8c206a9dd0>
>[2009-05-26 12:02:00,148]    DEBUG: looking for device 'vdd1'...
>[2009-05-26 12:02:00,148]    DEBUG: found PartitionDevice instance (0x7f8c206add10) --
>  description =   name = vdd1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206ad710>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206adfd0>  size = 509.844726562
>  major = 252  minor = 49  exists = True
>  sysfs path = /devices/virtio-pci/virtio4/block/vdd/vdd1  label = None
>  target size = 509.844726562  path = /dev/vdd1
>  format args = []  grow = None  max size = 0  bootable = None
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206aded0>  disk = <storage.devices.DiskDevice object at 0x7f8c206ad710>
>[2009-05-26 12:02:07,364]    DEBUG: registered action: Create Format ext3 on vda1 (partition)
>[2009-05-26 12:02:07,364]    DEBUG: registered action: Resize Device (Shrink) vda1 (partition)
>[2009-05-26 12:02:07,372]    DEBUG: allocatePartitions: disks=[<storage.devices.DiskDevice object at 0x7f8c20686c10>, <storage.devices.DiskDevice object at 0x7f8c206a9bd0>, <storage.devices.DiskDevice object at 0x7f8c206a9dd0>, <storage.devices.DiskDevice object at 0x7f8c206ad710>] ; partitions=[]
>[2009-05-26 12:02:07,372]    DEBUG: removing all non-preexisting from disk(s)
>[2009-05-26 12:02:07,372]    DEBUG: growPartitions: disks=['vda', 'vdb', 'vdc', 'vdd'], partitions=[]
>[2009-05-26 12:02:07,376]    DEBUG: looking for device 'vda1'...
>[2009-05-26 12:02:07,376]    DEBUG: found PartitionDevice instance (0x7f8c2068e190) --
>  description =   name = vda1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c20686c10>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext3FS object at 0x7f8c1d320c10>  size = 196.0
>  major = 252  minor = 1  exists = True
>  sysfs path = /devices/virtio-pci/virtio1/block/vda/vda1  label = None
>  target size = 196  path = /dev/vda1
>  format args = []  grow = None  max size = 0  bootable = True
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c2068e390>  disk = <storage.devices.DiskDevice object at 0x7f8c20686c10>
>[2009-05-26 12:02:07,377]    DEBUG: looking for device 'vda-1'...
>[2009-05-26 12:02:07,377]    DEBUG: found None
>[2009-05-26 12:02:07,378]    DEBUG: looking for device 'vda2'...
>[2009-05-26 12:02:07,378]    DEBUG: found PartitionDevice instance (0x7f8c2068e050) --
>  description =   name = vda2  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c20686c10>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206a98d0>  size = 15158.987793
>  major = 252  minor = 2  exists = True
>  sysfs path = /devices/virtio-pci/virtio1/block/vda/vda2  label = None
>  target size = 15158.987793  path = /dev/vda2
>  format args = []  grow = None  max size = 0  bootable = False
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c2068e210>  disk = <storage.devices.DiskDevice object at 0x7f8c20686c10>
>[2009-05-26 12:02:07,380]    DEBUG: looking for device 'vdb1'...
>[2009-05-26 12:02:07,380]    DEBUG: found PartitionDevice instance (0x7f8c206a9f10) --
>  description =   name = vdb1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206a9bd0>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206a9fd0>  size = 2047.31542969
>  major = 252  minor = 17  exists = True
>  sysfs path = /devices/virtio-pci/virtio2/block/vdb/vdb1  label = None
>  target size = 2047.31542969  path = /dev/vdb1
>  format args = []  grow = None  max size = 0  bootable = False
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206ad150>  disk = <storage.devices.DiskDevice object at 0x7f8c206a9bd0>
>[2009-05-26 12:02:07,382]    DEBUG: looking for device 'vdc1'...
>[2009-05-26 12:02:07,382]    DEBUG: found PartitionDevice instance (0x7f8c206ad650) --
>  description =   name = vdc1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206a9dd0>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206ada10>  size = 509.844726562
>  major = 252  minor = 33  exists = True
>  sysfs path = /devices/virtio-pci/virtio3/block/vdc/vdc1  label = None
>  target size = 509.844726562  path = /dev/vdc1
>  format args = []  grow = None  max size = 0  bootable = False
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206ad810>  disk = <storage.devices.DiskDevice object at 0x7f8c206a9dd0>
>[2009-05-26 12:02:07,384]    DEBUG: looking for device 'vdd1'...
>[2009-05-26 12:02:07,384]    DEBUG: found PartitionDevice instance (0x7f8c206add10) --
>  description =   name = vdd1  status = True  parents = [<storage.devices.DiskDevice object at 0x7f8c206ad710>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7f8c206adfd0>  size = 509.844726562
>  major = 252  minor = 49  exists = True
>  sysfs path = /devices/virtio-pci/virtio4/block/vdd/vdd1  label = None
>  target size = 509.844726562  path = /dev/vdd1
>  format args = []  grow = None  max size = 0  bootable = False
>  part type = 0  primary = None
>  partedPartition = <parted.partition.Partition object at 0x7f8c206aded0>  disk = <storage.devices.DiskDevice object at 0x7f8c206ad710>
>[2009-05-26 12:02:13,908]    DEBUG: action: Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:13,909]    DEBUG: action: Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:13,909]    DEBUG: action: Create Device vg_test150-LogVol02 (lvmlv)
>[2009-05-26 12:02:13,909]    DEBUG: action: Create Format ext4 on vg_test150-LogVol02 (lvmlv)
>[2009-05-26 12:02:13,910]    DEBUG: action: Create Format ext3 on vda1 (partition)
>[2009-05-26 12:02:13,910]    DEBUG: action: Resize Device (Shrink) vda1 (partition)
>[2009-05-26 12:02:13,910]    DEBUG: pruning action queue...
>[2009-05-26 12:02:13,910]    DEBUG: action 'Create Device vg_test150-LogVol02 (lvmlv)' (140239761866064)
>[2009-05-26 12:02:13,910]    DEBUG: action 'Resize Device (Shrink) vg_test150-lv_root (lvmlv)' (140239761864656)
>[2009-05-26 12:02:13,911]    DEBUG: action 'Resize Device (Shrink) vda1 (partition)' (140239761968080)
>[2009-05-26 12:02:13,911]    DEBUG: action 'Create Format ext4 on vg_test150-LogVol02 (lvmlv)' (140239761865616)
>[2009-05-26 12:02:13,911]    DEBUG: action 'Create Format ext3 on vda1 (partition)' (140239761968016)
>[2009-05-26 12:02:13,911]    DEBUG: action 'Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)' (140239761864528)
>[2009-05-26 12:02:13,912]    DEBUG: action: Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:13,912]    DEBUG: action: Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:13,912]    DEBUG: action: Create Device vg_test150-LogVol02 (lvmlv)
>[2009-05-26 12:02:13,912]    DEBUG: action: Create Format ext4 on vg_test150-LogVol02 (lvmlv)
>[2009-05-26 12:02:13,912]    DEBUG: action: Create Format ext3 on vda1 (partition)
>[2009-05-26 12:02:13,912]    DEBUG: action: Resize Device (Shrink) vda1 (partition)
>[2009-05-26 12:02:13,912]    DEBUG: sorting actions...
>[2009-05-26 12:02:13,913]    DEBUG: cmp: 0 -- Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv) | Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:13,913]    DEBUG: cmp: 1 -- Create Device vg_test150-LogVol02 (lvmlv) | Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:13,913]    DEBUG: cmp: 1 -- Create Format ext4 on vg_test150-LogVol02 (lvmlv) | Create Device vg_test150-LogVol02 (lvmlv)
>[2009-05-26 12:02:13,913]    DEBUG: cmp: -1 -- Create Format ext3 on vda1 (partition) | Create Format ext4 on vg_test150-LogVol02 (lvmlv)
>[2009-05-26 12:02:13,914]    DEBUG: cmp: -1 -- Create Format ext3 on vda1 (partition) | Create Device vg_test150-LogVol02 (lvmlv)
>[2009-05-26 12:02:13,914]    DEBUG: cmp: 1 -- Create Format ext3 on vda1 (partition) | Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:13,914]    DEBUG: cmp: -1 -- Resize Device (Shrink) vda1 (partition) | Create Format ext3 on vda1 (partition)
>[2009-05-26 12:02:13,914]    DEBUG: cmp: 1 -- Resize Device (Shrink) vda1 (partition) | Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:13,914]    DEBUG: action: Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:13,914]    DEBUG: action: Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:13,915]    DEBUG: action: Resize Device (Shrink) vda1 (partition)
>[2009-05-26 12:02:13,915]    DEBUG: action: Create Format ext3 on vda1 (partition)
>[2009-05-26 12:02:13,915]    DEBUG: action: Create Device vg_test150-LogVol02 (lvmlv)
>[2009-05-26 12:02:13,915]    DEBUG: action: Create Format ext4 on vg_test150-LogVol02 (lvmlv)
>[2009-05-26 12:02:13,915]    DEBUG: resetting parted disks...
>[2009-05-26 12:02:13,921]     INFO: executing action: Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-26 12:02:14,429]     INFO: executing action: Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)

Actions: View

Attachments on bug 501000: 344144 | 345491 | 346039 | 347933