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

Attached traceback automatically from anaconda.

anacdump.txt (text/plain), 178.85 KB, created by James Laska on 2009-05-15 12:56:01 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: James Laska

Created: 2009-05-15 12:56:01 UTC

Size: 178.85 KB

patch

obsolete

>anaconda 11.5.0.52 exception report
>Traceback (most recent call first):
>  File "/usr/lib/anaconda/storage/formats/fs.py", line 439, in doCheck
>    raise FSError("filesystem check failed: %s" % rc)
>  File "/usr/lib/anaconda/storage/formats/fs.py", line 373, 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 0x7facdc2cc490>
>intf: <gui.InstallInterface instance at 0x7face6357560>
>w: <gui.ProgressWindow instance at 0x7facdb010320>
>rc: 8
>
>
>Anaconda instance, containing members:
>rescue_mount: True
>intf: InstallInterface instance, containing members:
>  intf.icw: InstallControlWindow instance, containing members:
>    intf.icw.handle: 484
>    intf.icw.currentWindow: PartitionWindow instance, containing members:
>      intf.icw.currentWindow.checkmark_pixbuf: <gtk.gdk.Pixbuf object at 0x7facdbbe85a0 (GdkPixbuf at 0x28dea80)>
>      intf.icw.currentWindow.intf: Already dumped
>      intf.icw.currentWindow.diskStripeGraph: DiskStripeGraph instance, containing members:
>        intf.icw.currentWindow.diskStripeGraph.canvas: <gnome.canvas.Canvas object at 0x7facdbbe89b0 (GnomeCanvas at 0x2802010)>
>        intf.icw.currentWindow.diskStripeGraph.textlabels: []
>        intf.icw.currentWindow.diskStripeGraph.tree: <DiskTreeModel object at 0x7facdbbe8690 (GtkTreeStore at 0x2968b30)>
>        intf.icw.currentWindow.diskStripeGraph.editCB: <bound method PartitionWindow.editCB of <PartitionWindow.PartitionWindow instance at 0x7facdbc09ea8>>
>        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 0x7facdbbe85f0 (GdkPixbuf at 0x28fc450)>
>      intf.icw.currentWindow.storage: <storage.Storage object at 0x7facdc2fef10>
>      intf.icw.currentWindow.tree: <DiskTreeModel object at 0x7facdbbe8690 (GtkTreeStore at 0x2968b30)>
>      intf.icw.currentWindow.toggleViewButton: <gtk.CheckButton object at 0x7facdaff5320 (GtkCheckButton at 0x2836b50)>
>      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 0x7facdbbe8910 (GtkTreeSelection at 0x2962900)>
>      intf.icw.currentWindow.treeView: <gtk.TreeView object at 0x7facdbbe8960 (GtkTreeView at 0x2864640)>
>    intf.icw.mainxml: <gtk.glade.XML object at 0x7face63681e0 (PyGladeXML at 0x233da40)>
>    intf.icw.window: <gtk.Window object at 0x7face6368190 (GtkWindow at 0x2344160)>
>    intf.icw.installFrame: <gtk.Frame object at 0x7face63680f0 (GtkFrame at 0x230b320)>
>    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 0x7face6365890>
>rootPath: /mnt/sysimage
>platform: <platform.X86 object at 0x7face8127510>
>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 0x7facdbd736d0>, '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 0x7facdc2fef10>
>  id.desktop: Desktop instance, containing members:
>    id.desktop.info: {}
>    id.desktop.runlevel: 3
>  id.rootParts: [(<storage.devices.LVMLogicalVolumeDevice object at 0x7facdbd736d0>, '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 0x7facdc2fef10>
>    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:4E:31:B3
>ONBOOT=yes
>
>}
>    id.network.ksdevice: None
>    id.network.overrideDHCPhostname: False
>    id.network.hostname: test1036.test.redhat.com
>    id.network.domains: []
>  id.instClass: <installclass.DefaultInstall object at 0x7face8127e90>
>  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-140.fc11.x86_64 (mockbuild@x86-4.fedora.phx.redhat.com) (gcc version 4.4.0 20090506 (Red Hat 4.4.0-4) (GCC) ) #1 SMP Tue May 12 10:44:27 EDT 2009
><6>Command line: method=http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os console=ttyS0 lang=en keymap=us 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: 3ed67000 - 3ffefc4c
><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 [003ed67000 - 003ffefc4c]          RAMDISK ==> [003ed67000 - 003ffefc4c]
><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 lang=en keymap=us ip=dhcp vnc
><6>Initializing CPU#0
><4>PID hash table entries: 4096 (order: 12, 32768 bytes)
><4>Detected 2493.630 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: 994404k/1048512k available (3785k kernel code, 388k absent, 53720k reserved, 2291k 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.. 4987.26 BogoMIPS (lpj=2493630)
><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 18877 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.. 4987.26 BogoMIPS (lpj=2493630)
><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 10533598529 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 (9974.52 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: 12:38:42  Date: 05/15/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 = 4393822335333 ns)
><6>Freeing initrd memory: 18979k freed
><6>audit: initializing netlink socket (disabled)
><5>type=2000 audit(1242391124.217: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-140.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>input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input2
><6>rtc0: alarms up to one day, 114 bytes nvram
><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:971:632
><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>usb 1-2: new full speed USB device using uhci_hcd and address 2
><6>usb 1-2: New USB device found, idVendor=0627, idProduct=0001
><6>usb 1-2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
><6>usb 1-2: Product: QEMU USB Tablet
><6>usb 1-2: Manufacturer: QEMU 0.10.1
><6>usb 1-2: SerialNumber: 1
><6>usb 1-2: configuration #1 chosen from 1 choice
><6>input: QEMU 0.10.1 QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-2/1-2:1.0/input/input4
><6>generic-usb 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Pointer [QEMU 0.10.1 QEMU USB Tablet] on usb-0000:00:01.2-2/input0
><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/input5
><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 15 12:38:47 udevd-event[298]: 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 15 12:38:48 NetworkManager: <info>  starting...
>
><29>May 15 12:38:48 NetworkManager: <info>  Waiting for HAL to start...
>
><28>May 15 12:38:48 NetworkManager: <WARN>  nm_generic_enable_loopback(): error -17 returned from rtnl_addr_add():
>Sucess
>
>
><29>May 15 12:38:48 NetworkManager: <info>  Trying to start the supplicant...
>
><29>May 15 12:38:48 NetworkManager: <info>  Trying to start the system settings daemon...
>
><28>May 15 12:38:48 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 15 12:38:48 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 15 12:38:48 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 15 12:38:48 nm-system-settings:    ifcfg-rh: Could not get hostname: failed to read /etc/sysconfig/network
><29>May 15 12:38:48 nm-system-settings: Loaded plugin ifcfg-rh: (c) 2007 - 2008 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
><29>May 15 12:38:48 nm-system-settings:    ifcfg-rh: parsing /etc/sysconfig/network-scripts/ifcfg-eth0 ... 
><29>May 15 12:38:48 nm-system-settings:    ifcfg-rh:     read connection 'System eth0'
><29>May 15 12:38:48 nm-system-settings:    ifcfg-rh: Ignoring connection 'System eth0' and its device because NM_CONTROLLED was false.
><29>May 15 12:38:48 NetworkManager: <info>  HAL re-appeared
>
><29>May 15 12:38:48 NetworkManager: <info>  (eth0): new Ethernet device (driver: 'virtio_net')
>
><29>May 15 12:38:48 NetworkManager: <info>  (eth0): exported as /org/freedesktop/Hal/devices/net_54_52_00_4e_31_b3
>
><29>May 15 12:38:50 nm-system-settings:    ifcfg-rh: updating /etc/sysconfig/network-scripts/ifcfg-eth0
><29>May 15 12:38:50 nm-system-settings:    ifcfg-rh: Managing connection 'System eth0' and its device because NM_CONTROLLED was true.
><29>May 15 12:38:51 nm-system-settings:    ifcfg-rh: updating /etc/sysconfig/network-scripts/ifcfg-eth0
><29>May 15 12:38:53 NetworkManager: <info>  (eth0): device state change: 1 -> 2
>
><29>May 15 12:38:53 NetworkManager: <info>  (eth0): bringing up device.
>
><29>May 15 12:38:53 NetworkManager: <info>  (eth0): preparing device.
>
><29>May 15 12:38:53 NetworkManager: <info>  (eth0): deactivating device (reason: 2).
>
><29>May 15 12:38:53 NetworkManager: <info>  (eth0): carrier now ON (device state 2)
>
><29>May 15 12:38:53 NetworkManager: <info>  (eth0): device state change: 2 -> 3
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) starting connection 'System eth0'
>
><29>May 15 12:38:53 NetworkManager: <info>  (eth0): device state change: 3 -> 4
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) scheduled...
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) started...
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) scheduled...
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) Stage 1 of 5 (Device Prepare) complete.
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) starting...
>
><29>May 15 12:38:53 NetworkManager: <info>  (eth0): device state change: 4 -> 5
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) successful.
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) scheduled.
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) Stage 2 of 5 (Device Configure) complete.
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) started...
>
><29>May 15 12:38:53 NetworkManager: <info>  (eth0): device state change: 5 -> 7
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) Beginning DHCP transaction.
>
><29>May 15 12:38:53 NetworkManager: <info>  dhclient started with pid 559
>
><29>May 15 12:38:53 NetworkManager: <info>  Activation (eth0) Stage 3 of 5 (IP Configure Start) complete.
>
><30>May 15 12:38:53 dhclient: Internet Systems Consortium DHCP Client 4.1.0
><30>May 15 12:38:53 dhclient: Copyright 2004-2008 Internet Systems Consortium.
><30>May 15 12:38:53 dhclient: All rights reserved.
><30>May 15 12:38:53 dhclient: For info, please visit http://www.isc.org/sw/dhcp/
><30>May 15 12:38:53 dhclient: 
><29>May 15 12:38:53 NetworkManager: <info>  DHCP: device eth0 state changed (null) -> preinit
>
><30>May 15 12:38:53 dhclient: Listening on LPF/eth0/54:52:00:4e:31:b3
><30>May 15 12:38:53 dhclient: Sending on   LPF/eth0/54:52:00:4e:31:b3
><30>May 15 12:38:53 dhclient: Sending on   Socket/fallback
><30>May 15 12:38:57 dhclient: DHCPDISCOVER on eth0 to 255.255.255.255 port 67 interval 7
><30>May 15 12:38:57 dhclient: DHCPOFFER from 10.10.36.113
><30>May 15 12:38:57 dhclient: DHCPREQUEST on eth0 to 255.255.255.255 port 67
><30>May 15 12:38:57 dhclient: DHCPACK from 10.10.36.113
><29>May 15 12:38:57 NetworkManager: <info>  DHCP: device eth0 state changed preinit -> bound
>
><29>May 15 12:38:57 NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) scheduled...
>
><29>May 15 12:38:57 NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) started...
>
><29>May 15 12:38:57 NetworkManager: <info>    address 192.168.34.36
>
><29>May 15 12:38:57 NetworkManager: <info>    prefix 22 (255.255.252.0)
>
><29>May 15 12:38:57 NetworkManager: <info>    gateway 192.168.35.254
>
><29>May 15 12:38:57 NetworkManager: <info>    nameserver '192.168.32.2'
>
><29>May 15 12:38:57 NetworkManager: <info>    domain name 'test.redhat.com'
>
><29>May 15 12:38:57 NetworkManager: <info>    domain name 'devel.redhat.com'
>
><29>May 15 12:38:57 NetworkManager: <info>    domain name 'redhat.com'
>
><30>May 15 12:38:57 dhclient: bound to 192.168.34.36 -- renewal in 18916 seconds.
><29>May 15 12:38:57 NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) scheduled...
>
><29>May 15 12:38:57 NetworkManager: <info>  Activation (eth0) Stage 4 of 5 (IP Configure Get) complete.
>
><29>May 15 12:38:57 NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) started...
>
><29>May 15 12:38:58 NetworkManager: <info>  (eth0): device state change: 7 -> 8
>
><29>May 15 12:38:58 NetworkManager: <info>  Policy set 'System eth0' (eth0) as default for routing and DNS.
>
><29>May 15 12:38:58 NetworkManager: <info>  Activation (eth0) successful, device activated.
>
><29>May 15 12:38:58 NetworkManager: <info>  Activation (eth0) Stage 5 of 5 (IP Configure Commit) complete.
>
><29>May 15 12:38:58 NetworkManager: <info>  Setting system hostname to 'test1036.test.redhat.com' (from address lookup)
>
><28>May 15 12:38:58 nm-dispatcher.action: nm_dispatcher_action: Invalid connection: '(null)' / 'connection setting not found' invalid: 1
><29>May 15 12:38:59 nm-system-settings:    ifcfg-rh: updating /etc/sysconfig/network-scripts/ifcfg-eth0
><29>May 15 12:39:10 dbus-daemon: Unable to reload configuration: Error in file /etc/dbus-1/system.d/avahi-dbus.conf, line 1, column 0: no element found
>
><29>May 15 12:39:10 dbus-daemon: Unable to reload configuration: Error in file /etc/dbus-1/system.d/hal.conf, line 1, column 0: no element found
>
><29>May 15 12:39:10 dbus-daemon: Unable to reload configuration: Error in file /etc/dbus-1/system.d/hal.conf, line 1, column 0: no element found
>
><29>May 15 12:39:10 dbus-daemon: Unable to reload configuration: Error in file /etc/dbus-1/system.d/nm-system-settings.conf, line 1, column 0: no element found
>
><29>May 15 12:39:10 dbus-daemon: Unable to reload configuration: Error in file /etc/dbus-1/system.d/nm-system-settings.conf, line 1, column 0: no element found
>
><29>May 15 12:39:10 dbus-daemon: Reloaded configuration
><7>SELinux: 8192 avtab hash slots, 122227 rules.
><7>SELinux: 8192 avtab hash slots, 122227 rules.
><7>SELinux:  8 users, 13 roles, 2696 types, 126 bools, 1 sens, 1024 cats
><7>SELinux:  74 classes, 122227 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 ramfs, type ramfs), uses genfs_contexts
><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(1242391150.315: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:   900.000 MB/sec
><6>xor: using function: generic_sse (900.000 MB/sec)
><6>async_tx: api initialized (async)
><4>raid6: int64x1   1644 MB/s
><4>raid6: int64x2   2230 MB/s
><4>raid6: int64x4   1917 MB/s
><4>raid6: int64x8   1464 MB/s
><4>raid6: sse2x1    3042 MB/s
><4>raid6: sse2x2    4773 MB/s
><4>raid6: sse2x4    5234 MB/s
><4>raid6: using algorithm sse2x4 (5234 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 1312, 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>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 1598, 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:
>12:38:47 INFO    : kernel command line: method=http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os console=ttyS0 lang=en keymap=us ip=dhcp vnc
>
>12:38:47 WARNING : method= is deprecated.  Please use repo= instead.
>12:38:47 INFO    : vnc forced cmdline mode from cmdline
>12:38:47 INFO    : early networking required for syslog
>12:38:47 DEBUG   : no ifcfg files found in /etc/sysconfig/network-scripts
>12:38:47 INFO    : anaconda version 11.5.0.52 on x86_64 starting
>12:38:47 INFO    : 1014688 kB are available
>12:38:47 DEBUG   : going to set language to en_US.UTF-8
>12:38:47 INFO    : setting language to en_US.UTF-8
>12:38:47 DEBUG   : probing buses
>12:38:47 DEBUG   : waiting for hardware to initialize
>12:38:49 INFO    : trying to mount CD device /dev/sr0 on /mnt/stage2
>12:38:49 INFO    : drive status is CDS_NO_DISC
>12:38:49 INFO    : no stage2= given, assuming http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/install.img
>12:38:49 DEBUG   : going to set language to en_US.UTF-8
>12:38:49 INFO    : setting language to en_US.UTF-8
>12:38:49 INFO    : need to set up networking
>12:38:49 INFO    : going to pick interface
>12:38:49 INFO    : only have one network device: eth0
>12:38:49 INFO    : going to do getNetConfig
>12:38:49 INFO    : doing kickstart... setting it up
>12:38:49 DEBUG   : configuring device eth0
>12:38:59 INFO    : get_connection (2068): NetworkManager connected
>12:38:59 INFO    : starting STEP_STAGE2
>12:38:59 INFO    : URL_STAGE_MAIN: url is http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/install.img
>12:38:59 DEBUG   : url address gromit.redhat.com
>12:38:59 DEBUG   : url prefix /pub/fedora/linux/development/x86_64/os/images/install.img
>12:38:59 INFO    : transferring http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/updates.img to a fd
>12:38:59 INFO    : transferring http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/product.img to a fd
>12:38:59 INFO    : transferring http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/install.img to a fd
>12:39:10 DEBUG   : copied 116355072 bytes to /tmp/install.img (complete)
>12:39:10 INFO    : mounted loopback device /mnt/runtime on /dev/loop0 as /tmp/install.img
>12:39:10 INFO    : got stage2 at url http://gromit.redhat.com/pub/fedora/linux/development/x86_64/os/images/install.img
>12:39:10 INFO    : Loading SELinux policy
>12:39:10 INFO    : getting ready to spawn shell now
>12:39:10 INFO    : not spawning a shell
>12:39:10 INFO    : Running anaconda script /usr/bin/anaconda
>12:39:10 DEBUG   : adding extraArg --vnc
>12:39:12 INFO    : using only installclass _Fedora
>12:39:12 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']
>12:39:12 INFO    : Display mode = g
>12:39:12 INFO    : Starting VNC...
>12:39:12 INFO    : ip of eth0 is 192.168.34.36
>12:39:13 INFO    : The VNC server is now running.
>12:39:13 WARNING : 
>
>WARNING!!! VNC server running with NO PASSWORD!
>You can use the vncpassword=<password> boot option
>if you would like to secure the server.
>
>
>12:39:13 INFO    : Please manually connect your vnc client to test1036.test.redhat.com:1 (192.168.34.36) to begin the install.
>12:39:13 INFO    : Started mini-wm
>12:39:13 INFO    : Starting graphical installation...
>12:39:13 INFO    : Detected 992M of memory
>12:39:13 INFO    : Swap attempt of 992M to 1984M
>12:39:14 WARNING : step installtype does not exist
>12:39:14 WARNING : step confirminstall does not exist
>12:39:14 WARNING : step complete does not exist
>12:39:14 INFO    : moving (1) to step welcome
>12:51:22 INFO    : moving (1) to step betanag
>12:51:40 INFO    : moving (1) to step storageinit
>12:51:40 INFO    : ISCSID is /usr/sbin/iscsid
>12:51:40 INFO    : no initiator set
>12:51:40 INFO    : no /tmp/fcpconfig; not configuring zfcp
>12:51:41 DEBUG   : DeviceTree.addUdevDevice: name: sr0 ;
>12:51:41 DEBUG   : DeviceTree.addUdevOpticalDevice:
>12:51:41 DEBUG   : OpticalDevice._setFormat: sr0 ; current: None ; type: None ;
>12:51:41 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: sr0 ;
>12:51:41 DEBUG   : DeviceTree.addUdevDevice: name: vda ;
>12:51:41 DEBUG   : DeviceTree.addUdevDiskDevice: name: vda ;
>12:51:41 DEBUG   : DiskDevice._setFormat: vda ; current: None ; type: None ;
>12:51:41 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vda ;
>12:51:41 DEBUG   : DeviceTree.addUdevDevice: name: vda1 ;
>12:51:41 DEBUG   : DeviceTree.addUdevPartitionDevice: name: vda1 ;
>12:51:41 DEBUG   : DiskDevice.addChild: kids: 0 ; name: vda ;
>12:51:41 DEBUG   : PartitionDevice._setFormat: vda1 ;
>12:51:41 DEBUG   : PartitionDevice._setFormat: vda1 ; current: None ; type: None ;
>12:51:41 DEBUG   : PartitionDevice.probe: vda1 ; exists: True ;
>12:51:41 DEBUG   : PartitionDevice._computeResize: vda1 ; status: True ;
>12:51:41 DEBUG   : PartitionDevice.getFlag: path: /dev/vda1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: <parted.filesystem.FileSystem object at 0x7facdbd5b2d0>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b250>  PedPartition: <_ped.Partition object at 0x7facdbd51b90> ;
>12:51:41 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: <parted.filesystem.FileSystem object at 0x7facdbd5b2d0>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b250>  PedPartition: <_ped.Partition object at 0x7facdbd51b90> ;
>12:51:41 DEBUG   : PartitionDevice.getFlag: path: /dev/vda1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: <parted.filesystem.FileSystem object at 0x7facdbd5b2d0>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b250>  PedPartition: <_ped.Partition object at 0x7facdbd51b90> ;
>12:51:41 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: <parted.filesystem.FileSystem object at 0x7facdbd5b2d0>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b250>  PedPartition: <_ped.Partition object at 0x7facdbd51b90> ;
>12:51:41 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vda1 ;
>12:51:42 DEBUG   : isys.py:mount()- going to mount /dev/vda1 on /tmp/getsize-ohu_2v as ext3 with options ro
>12:51:42 DEBUG   : Ext3FS.supported: supported: True ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vda1 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vda1 ; current: None ; type: ext3 ;
>12:51:42 DEBUG   : DeviceTree.addUdevDevice: name: vda2 ;
>12:51:42 DEBUG   : DeviceTree.addUdevPartitionDevice: name: vda2 ;
>12:51:42 DEBUG   : DiskDevice.addChild: kids: 1 ; name: vda ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vda2 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vda2 ; current: None ; type: None ;
>12:51:42 DEBUG   : PartitionDevice.probe: vda2 ; exists: True ;
>12:51:42 DEBUG   : PartitionDevice._computeResize: vda2 ; status: True ;
>12:51:42 DEBUG   : PartitionDevice.getFlag: path: /dev/vda2 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b0d0>  PedPartition: <_ped.Partition object at 0x7facdbd51bf0> ;
>12:51:42 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda2 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b0d0>  PedPartition: <_ped.Partition object at 0x7facdbd51bf0> ;
>12:51:42 DEBUG   : PartitionDevice.getFlag: path: /dev/vda2 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b0d0>  PedPartition: <_ped.Partition object at 0x7facdbd51bf0> ;
>12:51:42 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda2 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b0d0>  PedPartition: <_ped.Partition object at 0x7facdbd51bf0> ;
>12:51:42 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vda2 ;
>12:51:42 DEBUG   : LVMPhysicalVolume.__init__: vgName: vg_test150 ; uuid: wKUfAL-4Slh-vVMW-qtMf-Xc4d-ZYpE-dUJ6an ; exists: True ; vgUuid: D952VY-RmMB-PSF7-Vw4y-bJCa-ywLO-yw2VT8 ; label: None ; peStart: 0.1875 ; device: /dev/vda2 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vda2 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vda2 ; current: None ; type: lvmpv ;
>12:51:42 DEBUG   : DeviceTree.handleUdevLVMPVFormat: type: lvmpv ; name: vda2 ;
>12:51:42 DEBUG   : PartitionDevice.addChild: kids: 0 ; name: vda2 ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice._setFormat: vg_test150 ; current: None ; type: None ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: vg_test150 ;
>12:51:42 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-lv_root ; current: None ; type: None ;
>12:51:42 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: vg_test150 ;
>12:51:42 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-lv_swap ; current: None ; type: None ;
>12:51:42 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_swap ; status: False ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>12:51:42 DEBUG   : DeviceTree.addUdevDevice: name: vdb ;
>12:51:42 DEBUG   : DeviceTree.addUdevDiskDevice: name: vdb ;
>12:51:42 DEBUG   : DiskDevice._setFormat: vdb ; current: None ; type: None ;
>12:51:42 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdb ;
>12:51:42 DEBUG   : DeviceTree.addUdevDevice: name: vdb1 ;
>12:51:42 DEBUG   : DeviceTree.addUdevPartitionDevice: name: vdb1 ;
>12:51:42 DEBUG   : DiskDevice.addChild: kids: 0 ; name: vdb ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdb1 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdb1 ; current: None ; type: None ;
>12:51:42 DEBUG   : PartitionDevice.probe: vdb1 ; exists: True ;
>12:51:42 DEBUG   : PartitionDevice._computeResize: vdb1 ; status: True ;
>12:51:42 DEBUG   : PartitionDevice.getFlag: path: /dev/vdb1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd73ad0>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd73fd0>  PedPartition: <_ped.Partition object at 0x7facdbd70b90> ;
>12:51:42 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdb1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd73ad0>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd73fd0>  PedPartition: <_ped.Partition object at 0x7facdbd70b90> ;
>12:51:42 DEBUG   : PartitionDevice.getFlag: path: /dev/vdb1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd73ad0>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd73fd0>  PedPartition: <_ped.Partition object at 0x7facdbd70b90> ;
>12:51:42 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdb1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd73ad0>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd73fd0>  PedPartition: <_ped.Partition object at 0x7facdbd70b90> ;
>12:51:42 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdb1 ;
>12:51:42 DEBUG   : LVMPhysicalVolume.__init__: vgName: vg_test150 ; uuid: wVMPNF-PNcZ-Di82-H3PB-x4J9-w03B-4CpFja ; exists: True ; vgUuid: D952VY-RmMB-PSF7-Vw4y-bJCa-ywLO-yw2VT8 ; label: None ; peStart: 0.1875 ; device: /dev/vdb1 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdb1 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdb1 ; current: None ; type: lvmpv ;
>12:51:42 DEBUG   : DeviceTree.handleUdevLVMPVFormat: type: lvmpv ; name: vdb1 ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice._addDevice: vg_test150 ; device: vdb1 ; status: False ;
>12:51:42 DEBUG   : PartitionDevice.addChild: kids: 0 ; name: vdb1 ;
>12:51:42 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>12:51:42 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_swap ; status: False ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>12:51:42 DEBUG   : DeviceTree.addUdevDevice: name: vdc ;
>12:51:42 DEBUG   : DeviceTree.addUdevDiskDevice: name: vdc ;
>12:51:42 DEBUG   : DiskDevice._setFormat: vdc ; current: None ; type: None ;
>12:51:42 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdc ;
>12:51:42 DEBUG   : LVMPhysicalVolume.__init__: device: /dev/vdc ; uuid: 1FLgcz-5mNp-7xSV-CM33-mmTR-rPA6-k2wHch ; exists: True ; label: None ;
>12:51:42 DEBUG   : DiskDevice._setFormat: vdc ; current: None ; type: lvmpv ;
>12:51:42 DEBUG   : DiskDevice._setFormat: vdc ; current: lvmpv ; type: None ;
>12:51:42 DEBUG   : DeviceTree.addUdevDevice: name: vdc1 ;
>12:51:42 DEBUG   : DeviceTree.addUdevPartitionDevice: name: vdc1 ;
>12:51:42 DEBUG   : DiskDevice.addChild: kids: 0 ; name: vdc ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdc1 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdc1 ; current: None ; type: None ;
>12:51:42 DEBUG   : PartitionDevice.probe: vdc1 ; exists: True ;
>12:51:42 DEBUG   : PartitionDevice._computeResize: vdc1 ; status: True ;
>12:51:42 DEBUG   : PartitionDevice.getFlag: path: /dev/vdc1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77090>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd776d0>  PedPartition: <_ped.Partition object at 0x7facdbd70c50> ;
>12:51:42 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdc1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77090>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd776d0>  PedPartition: <_ped.Partition object at 0x7facdbd70c50> ;
>12:51:42 DEBUG   : PartitionDevice.getFlag: path: /dev/vdc1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77090>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd776d0>  PedPartition: <_ped.Partition object at 0x7facdbd70c50> ;
>12:51:42 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdc1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77090>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd776d0>  PedPartition: <_ped.Partition object at 0x7facdbd70c50> ;
>12:51:42 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdc1 ;
>12:51:42 DEBUG   : LVMPhysicalVolume.__init__: vgName: vg_test150 ; uuid: fszsgi-xRLd-SoCK-VgDr-qUL6-KdAE-zv9aoV ; exists: True ; vgUuid: D952VY-RmMB-PSF7-Vw4y-bJCa-ywLO-yw2VT8 ; label: None ; peStart: 0.1875 ; device: /dev/vdc1 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdc1 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdc1 ; current: None ; type: lvmpv ;
>12:51:42 DEBUG   : DeviceTree.handleUdevLVMPVFormat: type: lvmpv ; name: vdc1 ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice._addDevice: vg_test150 ; device: vdc1 ; status: False ;
>12:51:42 DEBUG   : PartitionDevice.addChild: kids: 0 ; name: vdc1 ;
>12:51:42 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>12:51:42 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_swap ; status: False ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: False ;
>12:51:42 DEBUG   : DeviceTree.addUdevDevice: name: vdd ;
>12:51:42 DEBUG   : DeviceTree.addUdevDiskDevice: name: vdd ;
>12:51:42 DEBUG   : DiskDevice._setFormat: vdd ; current: None ; type: None ;
>12:51:42 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdd ;
>12:51:42 DEBUG   : LVMPhysicalVolume.__init__: device: /dev/vdd ; uuid: rsZ72n-d3H4-eDlm-v12H-hJd4-4dVG-tiqKcm ; exists: True ; label: None ;
>12:51:42 DEBUG   : DiskDevice._setFormat: vdd ; current: None ; type: lvmpv ;
>12:51:42 DEBUG   : DiskDevice._setFormat: vdd ; current: lvmpv ; type: None ;
>12:51:42 DEBUG   : DeviceTree.addUdevDevice: name: vdd1 ;
>12:51:42 DEBUG   : DeviceTree.addUdevPartitionDevice: name: vdd1 ;
>12:51:42 DEBUG   : DiskDevice.addChild: kids: 0 ; name: vdd ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdd1 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdd1 ; current: None ; type: None ;
>12:51:42 DEBUG   : PartitionDevice.probe: vdd1 ; exists: True ;
>12:51:42 DEBUG   : PartitionDevice._computeResize: vdd1 ; status: True ;
>12:51:42 DEBUG   : PartitionDevice.getFlag: path: /dev/vdd1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77750>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd77d90>  PedPartition: <_ped.Partition object at 0x7facdbd70bf0> ;
>12:51:42 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdd1 ; flag: 1 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77750>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd77d90>  PedPartition: <_ped.Partition object at 0x7facdbd70bf0> ;
>12:51:42 DEBUG   : PartitionDevice.getFlag: path: /dev/vdd1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77750>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd77d90>  PedPartition: <_ped.Partition object at 0x7facdbd70bf0> ;
>12:51:42 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdd1 ; flag: 10 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77750>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd77d90>  PedPartition: <_ped.Partition object at 0x7facdbd70bf0> ;
>12:51:42 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vdd1 ;
>12:51:42 DEBUG   : LVMPhysicalVolume.__init__: vgName: vg_test150 ; uuid: l30c6H-TcfP-M6zd-hwC9-vh7S-3NCV-xQAWX5 ; exists: True ; vgUuid: D952VY-RmMB-PSF7-Vw4y-bJCa-ywLO-yw2VT8 ; label: None ; peStart: 0.1875 ; device: /dev/vdd1 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdd1 ;
>12:51:42 DEBUG   : PartitionDevice._setFormat: vdd1 ; current: None ; type: lvmpv ;
>12:51:42 DEBUG   : DeviceTree.handleUdevLVMPVFormat: type: lvmpv ; name: vdd1 ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice._addDevice: vg_test150 ; device: vdd1 ; status: False ;
>12:51:42 DEBUG   : PartitionDevice.addChild: kids: 0 ; name: vdd1 ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: True ;
>12:51:42 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>12:51:42 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: True ;
>12:51:43 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_swap ; status: False ;
>12:51:43 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: True ;
>12:51:43 DEBUG   : DeviceTree.addUdevDevice: name: vg_test150-lv_root ;
>12:51:43 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vg_test150-lv_root ;
>12:51:43 DEBUG   : isys.py:mount()- going to mount /dev/mapper/vg_test150-lv_root on /tmp/getsize-kKzioX as ext4 with options ro
>12:51:44 DEBUG   : Ext4FS.supported: supported: True ;
>12:51:44 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-lv_root ; current: None ; type: ext4 ;
>12:51:44 DEBUG   : DeviceTree.addUdevDevice: name: vg_test150-lv_swap ;
>12:51:44 DEBUG   : DeviceTree.handleUdevDeviceFormat: name: vg_test150-lv_swap ;
>12:51:44 DEBUG   : SwapSpace.__init__: device: /dev/mapper/vg_test150-lv_swap ; uuid: 8c940c1d-296e-47a6-abf5-7a262223ebe6 ; exists: True ; label: None ;
>12:51:44 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-lv_swap ; current: None ; type: swap ;
>12:51:44 DEBUG   : OpticalDevice.teardown: sr0 ; status: True ;
>12:51:44 DEBUG   : DeviceFormat.teardown: device: /dev/sr0 ; status: False ; type: None ;
>12:51:44 DEBUG   : PartitionDevice.teardown: vda1 ; status: True ;
>12:51:44 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>12:51:44 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>12:51:44 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-lv_root ; status: True ;
>12:51:44 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>12:51:44 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>12:51:44 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>12:51:44 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>12:51:44 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>12:51:44 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>12:51:44 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>12:51:44 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>12:51:44 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>12:51:44 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>12:51:44 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>12:51:44 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>12:51:44 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>12:51:44 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>12:51:44 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>12:51:45 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>12:51:45 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>12:51:45 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-lv_swap ; status: False ;
>12:51:45 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>12:51:45 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>12:51:45 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>12:51:45 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>12:51:45 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>12:51:45 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>12:51:45 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>12:51:45 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>12:51:45 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>12:51:45 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>12:51:45 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>12:51:45 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>12:51:45 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>12:51:45 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>12:51:45 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>12:51:45 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>12:51:45 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>12:51:45 INFO    : moving (1) to step findrootparts
>12:51:45 DEBUG   : PartitionDevice.setup: vda1 ; status: True ;
>12:51:45 DEBUG   : DiskDevice.setup: vda ; status: True ;
>12:51:45 DEBUG   : DeviceFormat.setup: device: /dev/vda ; status: False ; type: None ;
>12:51:45 DEBUG   : isys.py:mount()- going to mount /dev/vda1 on /mnt/sysimage as ext3 with options ro
>12:51:45 DEBUG   : PartitionDevice.teardown: vda1 ; status: True ;
>12:51:45 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>12:51:45 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>12:51:45 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>12:51:45 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: True ;
>12:51:45 DEBUG   : isys.py:mount()- going to mount /dev/mapper/vg_test150-lv_root on /mnt/sysimage as ext4 with options ro
>12:51:46 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-lv_root ; status: True ;
>12:51:46 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>12:51:46 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>12:51:46 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>12:51:46 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>12:51:46 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>12:51:46 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>12:51:46 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>12:51:46 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>12:51:46 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>12:51:46 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>12:51:46 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>12:51:46 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>12:51:46 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>12:51:46 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>12:51:46 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>12:51:46 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>12:51:46 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>12:51:46 WARNING : step complete does not exist
>12:51:46 INFO    : moving (1) to step findinstall
>12:51:50 WARNING : step complete does not exist
>12:51:50 INFO    : moving (1) to step network
>12:51:50 INFO    : moving (1) to step timezone
>12:51:51 INFO    : moving (1) to step accounts
>12:51:55 INFO    : moving (1) to step setuptime
>08:51:55 INFO    : moving (1) to step parttype
>08:51:55 INFO    : ISCSID is /usr/sbin/iscsid
>08:51:59 INFO    : moving (1) to step partition
>08:51:59 DEBUG   : PartitionDevice.getFlag: path: /dev/vda1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: <parted.filesystem.FileSystem object at 0x7facdbd5b2d0>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b250>  PedPartition: <_ped.Partition object at 0x7facdbd51b90> ;
>08:51:59 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: <parted.filesystem.FileSystem object at 0x7facdbd5b2d0>
>  number: 1  path: /dev/vda1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b250>  PedPartition: <_ped.Partition object at 0x7facdbd51b90> ;
>08:51:59 DEBUG   : PartitionDevice.getFlag: path: /dev/vda2 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b0d0>  PedPartition: <_ped.Partition object at 0x7facdbd51bf0> ;
>08:51:59 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vda2 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd55c10>  fileSystem: None
>  number: 2  path: /dev/vda2  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd5b0d0>  PedPartition: <_ped.Partition object at 0x7facdbd51bf0> ;
>08:51:59 DEBUG   : PartitionDevice.getFlag: path: /dev/vdb1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd73ad0>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd73fd0>  PedPartition: <_ped.Partition object at 0x7facdbd70b90> ;
>08:51:59 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdb1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd73ad0>  fileSystem: None
>  number: 1  path: /dev/vdb1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd73fd0>  PedPartition: <_ped.Partition object at 0x7facdbd70b90> ;
>08:51:59 DEBUG   : PartitionDevice.getFlag: path: /dev/vdc1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77090>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd776d0>  PedPartition: <_ped.Partition object at 0x7facdbd70c50> ;
>08:51:59 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdc1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77090>  fileSystem: None
>  number: 1  path: /dev/vdc1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd776d0>  PedPartition: <_ped.Partition object at 0x7facdbd70c50> ;
>08:51:59 DEBUG   : PartitionDevice.getFlag: path: /dev/vdd1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77750>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd77d90>  PedPartition: <_ped.Partition object at 0x7facdbd70bf0> ;
>08:51:59 DEBUG   : PartitionDevice.flagAvailable: path: /dev/vdd1 ; flag: 3 ; part: parted.Partition instance --
>  disk: <parted.disk.Disk object at 0x7facdbd77750>  fileSystem: None
>  number: 1  path: /dev/vdd1  type: 0
>  name: None  active: True  busy: False
>  geometry: <parted.geometry.Geometry object at 0x7facdbd77d90>  PedPartition: <_ped.Partition object at 0x7facdbd70bf0> ;
>08:52:15 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>08:52:15 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>08:52:15 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>08:52:15 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>08:52:15 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>08:52:15 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>08:52:15 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>08:52:15 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>08:52:15 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>08:52:17 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>08:52:17 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>08:52:17 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>08:52:17 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>08:52:17 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>08:52:17 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>08:52:17 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>08:52:17 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>08:52:17 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>08:52:17 DEBUG   : BindFS.supported: supported: False ;
>08:52:17 DEBUG   : BindFS.supported: supported: False ;
>08:52:17 DEBUG   : DevPtsFS.supported: supported: False ;
>08:52:17 DEBUG   : DevPtsFS.supported: supported: False ;
>08:52:17 DEBUG   : DMRaidMember.__init__:
>08:52:17 DEBUG   : Ext2FS.supported: supported: True ;
>08:52:17 DEBUG   : Ext2FS.supported: supported: True ;
>08:52:17 DEBUG   : Ext3FS.supported: supported: True ;
>08:52:17 DEBUG   : Ext3FS.supported: supported: True ;
>08:52:17 DEBUG   : Ext4FS.supported: supported: True ;
>08:52:17 DEBUG   : Ext4FS.supported: supported: True ;
>08:52:17 DEBUG   : HFS.supported: supported: False ;
>08:52:17 DEBUG   : HFS.supported: supported: False ;
>08:52:17 DEBUG   : HFSPlus.supported: supported: False ;
>08:52:17 DEBUG   : HFSPlus.supported: supported: False ;
>08:52:17 DEBUG   : Iso9660FS.supported: supported: True ;
>08:52:17 DEBUG   : Iso9660FS.supported: supported: True ;
>08:52:17 DEBUG   : LUKS.__init__:
>08:52:17 DEBUG   : LVMPhysicalVolume.__init__:
>08:52:17 DEBUG   : MDRaidMember.__init__:
>08:52:17 DEBUG   : NFS.supported: supported: False ;
>08:52:17 DEBUG   : NFS.supported: supported: False ;
>08:52:17 DEBUG   : NFSv4.supported: supported: False ;
>08:52:17 DEBUG   : NFSv4.supported: supported: False ;
>08:52:17 DEBUG   : NoDevFS.supported: supported: False ;
>08:52:17 DEBUG   : NoDevFS.supported: supported: False ;
>08:52:17 DEBUG   : NTFS.supported: supported: False ;
>08:52:17 DEBUG   : NTFS.supported: supported: False ;
>08:52:17 DEBUG   : ProcFS.supported: supported: False ;
>08:52:17 DEBUG   : ProcFS.supported: supported: False ;
>08:52:17 DEBUG   : SwapSpace.__init__:
>08:52:17 DEBUG   : SysFS.supported: supported: False ;
>08:52:17 DEBUG   : SysFS.supported: supported: False ;
>08:52:17 DEBUG   : TmpFS.supported: supported: False ;
>08:52:17 DEBUG   : TmpFS.supported: supported: False ;
>08:52:17 DEBUG   : FATFS.supported: supported: True ;
>08:52:17 DEBUG   : FATFS.supported: supported: True ;
>08:52:17 DEBUG   : XFS.supported: supported: True ;
>08:52:17 DEBUG   : XFS.supported: supported: True ;
>08:52:17 DEBUG   : SwapSpace.__init__:
>08:52:18 DEBUG   : SwapSpace.__init__:
>08:52:22 DEBUG   : SwapSpace.__init__:
>08:52:22 DEBUG   : SwapSpace.__init__: mountpoint: <Not Applicable> ;
>08:52:22 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: swap ; type: swap ;
>08:52:22 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: swap ; type: swap ;
>08:52:22 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>08:52:22 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>08:52:22 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>08:52:22 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>08:52:22 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>08:52:22 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>08:52:22 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>08:52:22 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>08:52:22 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>08:52:23 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>08:52:23 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>08:52:23 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>08:52:23 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>08:52:23 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>08:52:23 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>08:52:23 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>08:52:23 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>08:52:23 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>08:52:23 DEBUG   : Ext4FS.supported: supported: True ;
>08:52:23 DEBUG   : BindFS.supported: supported: False ;
>08:52:23 DEBUG   : BindFS.supported: supported: False ;
>08:52:23 DEBUG   : DevPtsFS.supported: supported: False ;
>08:52:23 DEBUG   : DevPtsFS.supported: supported: False ;
>08:52:23 DEBUG   : DMRaidMember.__init__:
>08:52:23 DEBUG   : Ext2FS.supported: supported: True ;
>08:52:23 DEBUG   : Ext2FS.supported: supported: True ;
>08:52:23 DEBUG   : Ext3FS.supported: supported: True ;
>08:52:23 DEBUG   : Ext3FS.supported: supported: True ;
>08:52:23 DEBUG   : Ext4FS.supported: supported: True ;
>08:52:23 DEBUG   : Ext4FS.supported: supported: True ;
>08:52:23 DEBUG   : HFS.supported: supported: False ;
>08:52:23 DEBUG   : HFS.supported: supported: False ;
>08:52:23 DEBUG   : HFSPlus.supported: supported: False ;
>08:52:23 DEBUG   : HFSPlus.supported: supported: False ;
>08:52:23 DEBUG   : Iso9660FS.supported: supported: True ;
>08:52:23 DEBUG   : Iso9660FS.supported: supported: True ;
>08:52:23 DEBUG   : LUKS.__init__:
>08:52:23 DEBUG   : LVMPhysicalVolume.__init__:
>08:52:23 DEBUG   : MDRaidMember.__init__:
>08:52:23 DEBUG   : NFS.supported: supported: False ;
>08:52:23 DEBUG   : NFS.supported: supported: False ;
>08:52:23 DEBUG   : NFSv4.supported: supported: False ;
>08:52:23 DEBUG   : NFSv4.supported: supported: False ;
>08:52:23 DEBUG   : NoDevFS.supported: supported: False ;
>08:52:23 DEBUG   : NoDevFS.supported: supported: False ;
>08:52:23 DEBUG   : NTFS.supported: supported: False ;
>08:52:23 DEBUG   : NTFS.supported: supported: False ;
>08:52:23 DEBUG   : ProcFS.supported: supported: False ;
>08:52:23 DEBUG   : ProcFS.supported: supported: False ;
>08:52:23 DEBUG   : SwapSpace.__init__:
>08:52:23 DEBUG   : SysFS.supported: supported: False ;
>08:52:23 DEBUG   : SysFS.supported: supported: False ;
>08:52:23 DEBUG   : TmpFS.supported: supported: False ;
>08:52:23 DEBUG   : TmpFS.supported: supported: False ;
>08:52:23 DEBUG   : FATFS.supported: supported: True ;
>08:52:23 DEBUG   : FATFS.supported: supported: True ;
>08:52:23 DEBUG   : XFS.supported: supported: True ;
>08:52:23 DEBUG   : XFS.supported: supported: True ;
>08:52:23 DEBUG   : Ext4FS.supported: supported: True ;
>08:52:29 DEBUG   : Ext4FS.supported: supported: True ;
>08:52:29 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: ext4 ; type: ext4 ;
>08:52:29 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>08:52:29 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>08:52:29 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>08:52:29 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>08:52:29 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>08:52:29 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>08:52:29 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>08:52:29 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>08:52:29 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>08:52:30 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>08:52:30 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>08:52:30 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>08:52:30 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>08:52:30 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>08:52:30 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>08:52:30 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>08:52:30 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>08:52:30 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>08:52:30 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>08:52:30 DEBUG   : Ext4FS.supported: supported: True ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>08:52:30 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>08:52:30 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>08:52:30 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>08:52:30 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>08:52:30 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>08:52:30 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>08:52:30 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 2 ; name: tmp-vg_test150 ;
>08:52:30 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-LogVol02 ; current: None ; type: ext4 ;
>08:52:30 DEBUG   : Ext4FS.supported: supported: True ;
>08:52:30 DEBUG   : BindFS.supported: supported: False ;
>08:52:30 DEBUG   : BindFS.supported: supported: False ;
>08:52:30 DEBUG   : DevPtsFS.supported: supported: False ;
>08:52:30 DEBUG   : DevPtsFS.supported: supported: False ;
>08:52:30 DEBUG   : DMRaidMember.__init__:
>08:52:30 DEBUG   : Ext2FS.supported: supported: True ;
>08:52:30 DEBUG   : Ext2FS.supported: supported: True ;
>08:52:30 DEBUG   : Ext3FS.supported: supported: True ;
>08:52:30 DEBUG   : Ext3FS.supported: supported: True ;
>08:52:30 DEBUG   : Ext4FS.supported: supported: True ;
>08:52:30 DEBUG   : Ext4FS.supported: supported: True ;
>08:52:30 DEBUG   : HFS.supported: supported: False ;
>08:52:30 DEBUG   : HFS.supported: supported: False ;
>08:52:30 DEBUG   : HFSPlus.supported: supported: False ;
>08:52:30 DEBUG   : HFSPlus.supported: supported: False ;
>08:52:30 DEBUG   : Iso9660FS.supported: supported: True ;
>08:52:30 DEBUG   : Iso9660FS.supported: supported: True ;
>08:52:30 DEBUG   : LUKS.__init__:
>08:52:30 DEBUG   : LVMPhysicalVolume.__init__:
>08:52:30 DEBUG   : MDRaidMember.__init__:
>08:52:30 DEBUG   : NFS.supported: supported: False ;
>08:52:30 DEBUG   : NFS.supported: supported: False ;
>08:52:30 DEBUG   : NFSv4.supported: supported: False ;
>08:52:30 DEBUG   : NFSv4.supported: supported: False ;
>08:52:30 DEBUG   : NoDevFS.supported: supported: False ;
>08:52:30 DEBUG   : NoDevFS.supported: supported: False ;
>08:52:30 DEBUG   : NTFS.supported: supported: False ;
>08:52:30 DEBUG   : NTFS.supported: supported: False ;
>08:52:30 DEBUG   : ProcFS.supported: supported: False ;
>08:52:30 DEBUG   : ProcFS.supported: supported: False ;
>08:52:30 DEBUG   : SwapSpace.__init__:
>08:52:30 DEBUG   : SysFS.supported: supported: False ;
>08:52:30 DEBUG   : SysFS.supported: supported: False ;
>08:52:30 DEBUG   : TmpFS.supported: supported: False ;
>08:52:30 DEBUG   : TmpFS.supported: supported: False ;
>08:52:30 DEBUG   : FATFS.supported: supported: True ;
>08:52:30 DEBUG   : FATFS.supported: supported: True ;
>08:52:30 DEBUG   : XFS.supported: supported: True ;
>08:52:30 DEBUG   : XFS.supported: supported: True ;
>08:52:30 DEBUG   : Ext4FS.supported: supported: True ;
>08:53:36 DEBUG   : Ext4FS.supported: supported: True ;
>08:53:36 DEBUG   : Ext4FS.supported: supported: True ;
>08:53:36 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-new_root ; current: ext4 ; type: ext4 ;
>08:53:36 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>08:53:36 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>08:53:36 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>08:53:36 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>08:53:36 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>08:53:36 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>08:53:36 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>08:53:36 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>08:53:36 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>08:53:36 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 2 ; name: tmp-vg_test150 ;
>08:53:36 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-new_root ; current: None ; type: ext4 ;
>08:53:38 DEBUG   : finished editing vg
>08:53:38 DEBUG   : pvs: ['vda2', 'vdb1', 'vdc1', 'vdd1']
>08:53:38 DEBUG   : luks: []
>08:53:38 DEBUG   : lv {'format': <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>, 'name': 'lv_root', 'exists': True, 'size': 5000}
>08:53:38 DEBUG   : lv {'format': <storage.formats.swap.SwapSpace object at 0x7facdaff7f10>, 'name': 'lv_swap', 'exists': True, 'size': 1984.0}
>08:53:38 DEBUG   : lv {'format': <storage.formats.fs.Ext4FS object at 0x7facdb006490>, 'name': 'new_root', 'exists': False, 'size': 11232L}
>08:53:38 DEBUG   : old lv lv_root...
>08:53:38 DEBUG   : old lv lv_swap...
>08:53:38 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vda2 ;
>08:53:38 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdb1 ;
>08:53:38 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdc1 ;
>08:53:38 DEBUG   : PartitionDevice.addChild: kids: 1 ; name: vdd1 ;
>08:53:38 DEBUG   : LVMVolumeGroupDevice._setFormat: tmp-vg_test150 ; current: None ; type: None ;
>08:53:38 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 0 ; name: tmp-vg_test150 ;
>08:53:38 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_root ; current: None ; type: ext4 ;
>08:53:38 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 1 ; name: tmp-vg_test150 ;
>08:53:38 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-lv_swap ; current: None ; type: swap ;
>08:53:38 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 2 ; name: tmp-vg_test150 ;
>08:53:38 DEBUG   : LVMLogicalVolumeDevice._setFormat: tmp-vg_test150-new_root ; current: None ; type: ext4 ;
>08:53:38 DEBUG   : new lv LVMLogicalVolumeDevice instance (0x7facdbbe2fd0) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb008350>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>  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 0x7facdb008350>  percent = 0
>08:53:38 DEBUG   : lv lv_root already exists
>08:53:38 DEBUG   : format already exists
>08:53:38 DEBUG   : new lv LVMLogicalVolumeDevice instance (0x7facdafda1d0) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb008350>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7facdaff7f10>  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 0x7facdb008350>  percent = 0
>08:53:38 DEBUG   : lv lv_swap already exists
>08:53:38 DEBUG   : new format: swap
>08:53:38 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-lv_swap ; current: swap ; type: None ;
>08:53:38 DEBUG   : SwapSpace.__init__: device: /dev/mapper/vg_test150-lv_swap ; mountpoint: None ;
>08:53:38 DEBUG   : DeviceFormat.teardown: device: /dev/mapper/vg_test150-lv_swap ; status: False ; type: None ;
>08:53:38 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-lv_swap ; current: None ; type: swap ;
>08:53:38 DEBUG   : new lv LVMLogicalVolumeDevice instance (0x7facdafda190) --
>  description =   name = tmp-vg_test150-new_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb008350>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdb006490>  size = 11232
>  major = 0  minor = 0  exists = False
>  sysfs path =   label = None
>  target size = 11232  path = /dev/mapper/tmp--vg_test150-new_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7facdb008350>  percent = 0
>08:53:38 DEBUG   : creating lv new_root
>08:53:38 DEBUG   : LVMVolumeGroupDevice.addChild: kids: 2 ; name: vg_test150 ;
>08:53:38 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-new_root ; current: None ; type: None ;
>08:53:38 DEBUG   : Ext4FS.supported: supported: True ;
>08:53:38 DEBUG   : LVMLogicalVolumeDevice._setFormat: vg_test150-new_root ; current: None ; type: ext4 ;
>08:53:38 DEBUG   : refresh: justRedraw=True
>08:53:40 DEBUG   : Ext3FS.supported: supported: True ;
>08:53:40 DEBUG   : BindFS.supported: supported: False ;
>08:53:40 DEBUG   : BindFS.supported: supported: False ;
>08:53:40 DEBUG   : DevPtsFS.supported: supported: False ;
>08:53:40 DEBUG   : DevPtsFS.supported: supported: False ;
>08:53:40 DEBUG   : DMRaidMember.__init__:
>08:53:40 DEBUG   : Ext2FS.supported: supported: True ;
>08:53:40 DEBUG   : Ext2FS.supported: supported: True ;
>08:53:40 DEBUG   : Ext3FS.supported: supported: True ;
>08:53:40 DEBUG   : Ext3FS.supported: supported: True ;
>08:53:40 DEBUG   : Ext4FS.supported: supported: True ;
>08:53:40 DEBUG   : Ext4FS.supported: supported: True ;
>08:53:40 DEBUG   : HFS.supported: supported: False ;
>08:53:40 DEBUG   : HFS.supported: supported: False ;
>08:53:40 DEBUG   : HFSPlus.supported: supported: False ;
>08:53:40 DEBUG   : HFSPlus.supported: supported: False ;
>08:53:40 DEBUG   : Iso9660FS.supported: supported: True ;
>08:53:40 DEBUG   : Iso9660FS.supported: supported: True ;
>08:53:40 DEBUG   : LUKS.__init__:
>08:53:40 DEBUG   : LVMPhysicalVolume.__init__:
>08:53:40 DEBUG   : MDRaidMember.__init__:
>08:53:40 DEBUG   : NFS.supported: supported: False ;
>08:53:40 DEBUG   : NFS.supported: supported: False ;
>08:53:40 DEBUG   : NFSv4.supported: supported: False ;
>08:53:40 DEBUG   : NFSv4.supported: supported: False ;
>08:53:40 DEBUG   : NoDevFS.supported: supported: False ;
>08:53:40 DEBUG   : NoDevFS.supported: supported: False ;
>08:53:40 DEBUG   : NTFS.supported: supported: False ;
>08:53:40 DEBUG   : NTFS.supported: supported: False ;
>08:53:40 DEBUG   : ProcFS.supported: supported: False ;
>08:53:40 DEBUG   : ProcFS.supported: supported: False ;
>08:53:40 DEBUG   : SwapSpace.__init__:
>08:53:40 DEBUG   : SysFS.supported: supported: False ;
>08:53:40 DEBUG   : SysFS.supported: supported: False ;
>08:53:40 DEBUG   : TmpFS.supported: supported: False ;
>08:53:40 DEBUG   : TmpFS.supported: supported: False ;
>08:53:40 DEBUG   : FATFS.supported: supported: True ;
>08:53:40 DEBUG   : FATFS.supported: supported: True ;
>08:53:40 DEBUG   : XFS.supported: supported: True ;
>08:53:40 DEBUG   : XFS.supported: supported: True ;
>08:53:40 DEBUG   : Ext3FS.supported: supported: True ;
>08:53:45 DEBUG   : PartitionDevice._computeResize: vda1 ; status: True ;
>08:53:45 DEBUG   : refresh: justRedraw=False
>08:53:45 DEBUG   : DiskDevice.setup: vda ; status: True ;
>08:53:45 DEBUG   : DiskDevice.setup: vdb ; status: True ;
>08:53:45 DEBUG   : DiskDevice.setup: vdc ; status: True ;
>08:53:45 DEBUG   : DiskDevice.setup: vdd ; status: True ;
>08:53:53 INFO    : moving (1) to step storagedone
>08:53:54 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>08:53:54 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>08:53:54 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>08:53:54 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>08:53:54 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>08:53:54 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>08:53:54 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>08:53:54 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>08:53:54 INFO    : moving (1) to step enablefilesystems
>08:53:54 DEBUG   : OpticalDevice.teardown: sr0 ; status: True ;
>08:53:54 DEBUG   : DeviceFormat.teardown: device: /dev/sr0 ; status: False ; type: None ;
>08:53:54 DEBUG   : PartitionDevice.teardown: vda1 ; status: True ;
>08:53:54 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>08:53:54 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>08:53:54 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-lv_root ; status: False ;
>08:53:54 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>08:53:54 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>08:53:54 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>08:53:54 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>08:53:54 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>08:53:54 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>08:53:54 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>08:53:54 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>08:53:54 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>08:53:54 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>08:53:54 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>08:53:54 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>08:53:54 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>08:53:54 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>08:53:54 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>08:53:54 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>08:53:54 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>08:53:54 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-lv_swap ; status: False ;
>08:53:54 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>08:53:54 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>08:53:54 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>08:53:55 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>08:53:55 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>08:53:55 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>08:53:55 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>08:53:55 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>08:53:55 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>08:53:55 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>08:53:55 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>08:53:55 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>08:53:55 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>08:53:55 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>08:53:55 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>08:53:55 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>08:53:55 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>08:53:55 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-new_root ; status: False ;
>08:53:55 DEBUG   : LVMVolumeGroupDevice.teardown: vg_test150 ; status: True ;
>08:53:55 DEBUG   : PartitionDevice.teardown: vda2 ; status: True ;
>08:53:55 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vda2 ; status: False ; type: lvmpv ;
>08:53:55 DEBUG   : DiskDevice.teardown: vda ; status: True ;
>08:53:55 DEBUG   : DeviceFormat.teardown: device: /dev/vda ; status: False ; type: None ;
>08:53:55 DEBUG   : PartitionDevice.teardown: vdb1 ; status: True ;
>08:53:55 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdb1 ; status: False ; type: lvmpv ;
>08:53:55 DEBUG   : DiskDevice.teardown: vdb ; status: True ;
>08:53:55 DEBUG   : DeviceFormat.teardown: device: /dev/vdb ; status: False ; type: None ;
>08:53:55 DEBUG   : PartitionDevice.teardown: vdc1 ; status: True ;
>08:53:55 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdc1 ; status: False ; type: lvmpv ;
>08:53:55 DEBUG   : DiskDevice.teardown: vdc ; status: True ;
>08:53:55 DEBUG   : DeviceFormat.teardown: device: /dev/vdc ; status: False ; type: None ;
>08:53:55 DEBUG   : PartitionDevice.teardown: vdd1 ; status: True ;
>08:53:55 DEBUG   : LVMPhysicalVolume.teardown: device: /dev/vdd1 ; status: False ; type: lvmpv ;
>08:53:55 DEBUG   : DiskDevice.teardown: vdd ; status: True ;
>08:53:55 DEBUG   : DeviceFormat.teardown: device: /dev/vdd ; status: False ; type: None ;
>08:53:55 DEBUG   : DiskDevice.resetPartedDisk: vdc ;
>08:53:55 DEBUG   : DiskDevice.resetPartedDisk: vdb ;
>08:53:55 DEBUG   : DiskDevice.resetPartedDisk: vda ;
>08:53:55 DEBUG   : DiskDevice.resetPartedDisk: vdd ;
>08:53:55 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_swap ; status: False ;
>08:53:55 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: True ;
>08:53:56 DEBUG   : SwapSpace.destroy: device: /dev/mapper/vg_test150-lv_swap ; status: False ; type: swap ;
>08:53:56 DEBUG   : LVMLogicalVolumeDevice.teardown: vg_test150-lv_swap ; status: True ;
>08:53:56 DEBUG   : LVMLogicalVolumeDevice.resize: vg_test150-lv_root ; status: False ;
>08:53:56 DEBUG   : PartitionDevice.setup: vda2 ; status: True ;
>08:53:56 DEBUG   : DiskDevice.setup: vda ; status: True ;
>08:53:56 DEBUG   : DeviceFormat.setup: device: /dev/vda ; status: False ; type: None ;
>08:53:56 DEBUG   : PartitionDevice.setup: vdb1 ; status: True ;
>08:53:56 DEBUG   : DiskDevice.setup: vdb ; status: True ;
>08:53:56 DEBUG   : DeviceFormat.setup: device: /dev/vdb ; status: False ; type: None ;
>08:53:56 DEBUG   : PartitionDevice.setup: vdc1 ; status: True ;
>08:53:56 DEBUG   : DiskDevice.setup: vdc ; status: True ;
>08:53:56 DEBUG   : DeviceFormat.setup: device: /dev/vdc ; status: False ; type: None ;
>08:53:56 DEBUG   : PartitionDevice.setup: vdd1 ; status: True ;
>08:53:56 DEBUG   : DiskDevice.setup: vdd ; status: True ;
>08:53:56 DEBUG   : DeviceFormat.setup: device: /dev/vdd ; status: False ; type: None ;
>08:53:57 DEBUG   : LVMLogicalVolumeDevice.setup: vg_test150-lv_root ; status: False ;
>08:53:57 DEBUG   : LVMVolumeGroupDevice.setup: vg_test150 ; status: True ;
>
>
>/tmp/program.log:
>Running... ['udevadm', 'trigger', '--subsystem-match=block']
>Running... ['udevadm', 'settle', '--timeout=30']
>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... ['resize2fs', '-P', '/dev/mapper/vg_test150-lv_root']
>Estimated minimum size of the filesystem: 281236
>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... ['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... ['lvm', 'lvchange', '-a', 'y', 'vg_test150/lv_swap']
>Running... ['udevadm', 'settle']
>Running... ['lvm', 'lvchange', '-a', 'n', 'vg_test150/lv_swap']
>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-15 12:39:11,328]    DEBUG: registered device format class DMRaidMember as dmraidmember
>[2009-05-15 12:39:11,352]    DEBUG: registered device format class Ext2FS as ext2
>[2009-05-15 12:39:11,352]    DEBUG: registered device format class Ext3FS as ext3
>[2009-05-15 12:39:11,352]    DEBUG: registered device format class Ext4FS as ext4
>[2009-05-15 12:39:11,352]    DEBUG: registered device format class FATFS as vfat
>[2009-05-15 12:39:11,352]    DEBUG: registered device format class EFIFS as efi
>[2009-05-15 12:39:11,353]    DEBUG: registered device format class BTRFS as btrfs
>[2009-05-15 12:39:11,353]    DEBUG: registered device format class GFS2 as gfs2
>[2009-05-15 12:39:11,353]    DEBUG: registered device format class JFS as jfs
>[2009-05-15 12:39:11,353]    DEBUG: registered device format class XFS as xfs
>[2009-05-15 12:39:11,353]    DEBUG: registered device format class HFS as hfs
>[2009-05-15 12:39:11,353]    DEBUG: registered device format class AppleBootstrapFS as appleboot
>[2009-05-15 12:39:11,354]    DEBUG: registered device format class HFSPlus as hfs+
>[2009-05-15 12:39:11,354]    DEBUG: registered device format class NTFS as ntfs
>[2009-05-15 12:39:11,354]    DEBUG: registered device format class NFS as nfs
>[2009-05-15 12:39:11,354]    DEBUG: registered device format class NFSv4 as nfs4
>[2009-05-15 12:39:11,354]    DEBUG: registered device format class Iso9660FS as iso9660
>[2009-05-15 12:39:11,355]    DEBUG: registered device format class NoDevFS as nodev
>[2009-05-15 12:39:11,355]    DEBUG: registered device format class DevPtsFS as devpts
>[2009-05-15 12:39:11,355]    DEBUG: registered device format class ProcFS as proc
>[2009-05-15 12:39:11,355]    DEBUG: registered device format class SysFS as sysfs
>[2009-05-15 12:39:11,355]    DEBUG: registered device format class TmpFS as tmpfs
>[2009-05-15 12:39:11,355]    DEBUG: registered device format class BindFS as bind
>[2009-05-15 12:39:11,371]    DEBUG: registered device format class LUKS as luks
>[2009-05-15 12:39:11,373]    DEBUG: registered device format class LVMPhysicalVolume as lvmpv
>[2009-05-15 12:39:11,374]    DEBUG: registered device format class MDRaidMember as mdmember
>[2009-05-15 12:39:11,374]    DEBUG: registered device format class PPCPRePBoot as prepboot
>[2009-05-15 12:39:11,377]    DEBUG: registered device format class SwapSpace as swap
>[2009-05-15 12:51:41,611]     INFO: devices to scan: ['sr0', 'vda', 'vda1', 'vda2', 'vdb', 'vdb1', 'vdc', 'vdc1', 'vdd', 'vdd1']
>[2009-05-15 12:51:41,701]    DEBUG: scanning sr0 (/devices/pci0000:00/0000:00:01.1/host1/target1:0:0/1:0:0:0/block/sr0)...
>[2009-05-15 12:51:41,701]    DEBUG: looking for device 'sr0'...
>[2009-05-15 12:51:41,701]    DEBUG: found None
>[2009-05-15 12:51:41,701]    DEBUG: sr0 is a cdrom
>[2009-05-15 12:51:41,703]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:41,707]    DEBUG: added sr0 (cdrom) to device tree
>[2009-05-15 12:51:41,709]    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-15 12:51:41,709]    DEBUG: no type or existing type for sr0, bailing
>[2009-05-15 12:51:41,710]    DEBUG: scanning vda (/devices/virtio-pci/virtio1/block/vda)...
>[2009-05-15 12:51:41,710]    DEBUG: looking for device 'vda'...
>[2009-05-15 12:51:41,710]    DEBUG: found None
>[2009-05-15 12:51:41,712]    DEBUG: vda is a disk
>[2009-05-15 12:51:41,712]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:41,713]    DEBUG: looking up parted Device: /dev/vda
>[2009-05-15 12:51:41,714]    DEBUG: looking up parted Device: /dev/vda
>[2009-05-15 12:51:41,715]    DEBUG: creating parted Disk: /dev/vda
>[2009-05-15 12:51:41,933]    DEBUG: added vda (disk) to device tree
>[2009-05-15 12:51:41,935]    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-15 12:51:41,936]    DEBUG: no type or existing type for vda, bailing
>[2009-05-15 12:51:41,938]    DEBUG: scanning vda1 (/devices/virtio-pci/virtio1/block/vda/vda1)...
>[2009-05-15 12:51:41,938]    DEBUG: looking for device 'vda1'...
>[2009-05-15 12:51:41,938]    DEBUG: found None
>[2009-05-15 12:51:41,939]    DEBUG: vda1 is a partition
>[2009-05-15 12:51:41,941]    DEBUG: looking for device 'vda'...
>[2009-05-15 12:51:41,942]    DEBUG: found DiskDevice instance (0x7facdbd55a90) --
>  description =   name = vda  status = True  parents = []
>  kids = 0
>  uuid = None  format = <storage.formats.DeviceFormat object at 0x7facdbd559d0>  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 0x7facdbd55b10>
>  partedDisk = <parted.disk.Disk object at 0x7facdbd55c10>
>[2009-05-15 12:51:41,947]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:41,949]    DEBUG: looking up parted Partition: /dev/vda1
>[2009-05-15 12:51:41,951]    DEBUG: looking up parted Device: /dev/vda1
>[2009-05-15 12:51:41,962]    DEBUG: added vda1 (partition) to device tree
>[2009-05-15 12:51:41,963]    DEBUG: {'symlinks': ['block/252:1', 'disk/by-uuid/ea12772a-4aca-4e11-ae64-f892991b2408'], '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': 'ea12772a-4aca-4e11-ae64-f892991b2408', 'ID_FS_VERSION': '1.0', 'ID_FS_UUID_ENC': 'ea12772a-4aca-4e11-ae64-f892991b2408', 'ID_FS_TYPE': 'ext3', 'MINOR': '1'}
>[2009-05-15 12:51:41,963]    DEBUG: type detected on 'vda1' is 'ext3'
>[2009-05-15 12:51:42,042]     INFO: set SELinux context for mountpoint /tmp/getsize-ohu_2v to None
>[2009-05-15 12:51:42,099]     INFO: set SELinux context for newly mounted filesystem root at /tmp/getsize-ohu_2v to None
>[2009-05-15 12:51:42,195]    DEBUG: getFormat('ext3') returning Ext3FS instance
>[2009-05-15 12:51:42,204]    DEBUG: scanning vda2 (/devices/virtio-pci/virtio1/block/vda/vda2)...
>[2009-05-15 12:51:42,204]    DEBUG: looking for device 'vda2'...
>[2009-05-15 12:51:42,205]    DEBUG: found None
>[2009-05-15 12:51:42,205]    DEBUG: vda2 is a partition
>[2009-05-15 12:51:42,207]    DEBUG: looking for device 'vda'...
>[2009-05-15 12:51:42,208]    DEBUG: found DiskDevice instance (0x7facdbd55a90) --
>  description =   name = vda  status = True  parents = []
>  kids = 1
>  uuid = None  format = <storage.formats.DeviceFormat object at 0x7facdbd559d0>  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 0x7facdbd55b10>
>  partedDisk = <parted.disk.Disk object at 0x7facdbd55c10>
>[2009-05-15 12:51:42,212]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,214]    DEBUG: looking up parted Partition: /dev/vda2
>[2009-05-15 12:51:42,215]    DEBUG: looking up parted Device: /dev/vda2
>[2009-05-15 12:51:42,237]    DEBUG: added vda2 (partition) to device tree
>[2009-05-15 12:51:42,239]    DEBUG: {'LVM2_PV_UUID': 'wKUfAL-4Slh-vVMW-qtMf-Xc4d-ZYpE-dUJ6an', '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': 'D952VY-RmMB-PSF7-Vw4y-bJCa-ywLO-yw2VT8', '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': 'wKUfAL-4Slh-vVMW-qtMf-Xc4d-ZYpE-dUJ6an', 'ID_FS_UUID_ENC': 'wKUfAL-4Slh-vVMW-qtMf-Xc4d-ZYpE-dUJ6an', 'ID_FS_TYPE': 'LVM2_member', 'LVM2_LV_UUID': ['29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud', 'SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V'], '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-15 12:51:42,239]    DEBUG: type detected on 'vda2' is 'LVM2_member'
>[2009-05-15 12:51:42,241]    DEBUG: getFormat('LVM2_member') returning LVMPhysicalVolume instance
>[2009-05-15 12:51:42,249]    DEBUG: looking for device 'vg_test150'...
>[2009-05-15 12:51:42,249]    DEBUG: found None
>[2009-05-15 12:51:42,252]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,256]    DEBUG: added vg_test150 (lvmvg) to device tree
>[2009-05-15 12:51:42,257]    DEBUG: looking for device 'vg_test150-lv_root'...
>[2009-05-15 12:51:42,257]    DEBUG: found None
>[2009-05-15 12:51:42,260]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,262]    DEBUG: added vg_test150-lv_root (lvmlv) to device tree
>[2009-05-15 12:51:42,269]     INFO: setup of vg_test150-lv_root failed: cannot activate VG with missing PV(s)
>[2009-05-15 12:51:42,269]    DEBUG: looking for device 'vg_test150-lv_swap'...
>[2009-05-15 12:51:42,269]    DEBUG: found None
>[2009-05-15 12:51:42,271]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,273]    DEBUG: added vg_test150-lv_swap (lvmlv) to device tree
>[2009-05-15 12:51:42,276]     INFO: setup of vg_test150-lv_swap failed: cannot activate VG with missing PV(s)
>[2009-05-15 12:51:42,277]    DEBUG: scanning vdb (/devices/virtio-pci/virtio2/block/vdb)...
>[2009-05-15 12:51:42,277]    DEBUG: looking for device 'vdb'...
>[2009-05-15 12:51:42,277]    DEBUG: found None
>[2009-05-15 12:51:42,279]    DEBUG: vdb is a disk
>[2009-05-15 12:51:42,279]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,281]    DEBUG: looking up parted Device: /dev/vdb
>[2009-05-15 12:51:42,281]    DEBUG: looking up parted Device: /dev/vdb
>[2009-05-15 12:51:42,283]    DEBUG: creating parted Disk: /dev/vdb
>[2009-05-15 12:51:42,413]    DEBUG: added vdb (disk) to device tree
>[2009-05-15 12:51:42,414]    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-15 12:51:42,415]    DEBUG: no type or existing type for vdb, bailing
>[2009-05-15 12:51:42,416]    DEBUG: scanning vdb1 (/devices/virtio-pci/virtio2/block/vdb/vdb1)...
>[2009-05-15 12:51:42,416]    DEBUG: looking for device 'vdb1'...
>[2009-05-15 12:51:42,416]    DEBUG: found None
>[2009-05-15 12:51:42,416]    DEBUG: vdb1 is a partition
>[2009-05-15 12:51:42,418]    DEBUG: looking for device 'vdb'...
>[2009-05-15 12:51:42,418]    DEBUG: found DiskDevice instance (0x7facdbd73a50) --
>  description =   name = vdb  status = True  parents = []
>  kids = 0
>  uuid = None  format = <storage.formats.DeviceFormat object at 0x7facdbd739d0>  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 0x7facdbd73650>
>  partedDisk = <parted.disk.Disk object at 0x7facdbd73ad0>
>[2009-05-15 12:51:42,421]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,423]    DEBUG: looking up parted Partition: /dev/vdb1
>[2009-05-15 12:51:42,425]    DEBUG: looking up parted Device: /dev/vdb1
>[2009-05-15 12:51:42,433]    DEBUG: added vdb1 (partition) to device tree
>[2009-05-15 12:51:42,435]    DEBUG: {'LVM2_PV_UUID': 'wVMPNF-PNcZ-Di82-H3PB-x4J9-w03B-4CpFja', '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': 'D952VY-RmMB-PSF7-Vw4y-bJCa-ywLO-yw2VT8', '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': 'wVMPNF-PNcZ-Di82-H3PB-x4J9-w03B-4CpFja', 'ID_FS_UUID_ENC': 'wVMPNF-PNcZ-Di82-H3PB-x4J9-w03B-4CpFja', 'ID_FS_TYPE': 'LVM2_member', 'LVM2_LV_UUID': ['29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud', 'SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V'], '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-15 12:51:42,435]    DEBUG: type detected on 'vdb1' is 'LVM2_member'
>[2009-05-15 12:51:42,436]    DEBUG: getFormat('LVM2_member') returning LVMPhysicalVolume instance
>[2009-05-15 12:51:42,440]    DEBUG: looking for device 'vg_test150'...
>[2009-05-15 12:51:42,441]    DEBUG: vg_test150 size is 15156MB
>[2009-05-15 12:51:42,441]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdbd736d0) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = 29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud  format = <storage.formats.DeviceFormat object at 0x7facdbd73910>  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 0x7facdbd73490>  percent = 0) uses 16232MB
>[2009-05-15 12:51:42,442]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdbd738d0) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V  format = <storage.formats.DeviceFormat object at 0x7facdbd73850>  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 0x7facdbd73490>  percent = 0) uses 1984MB
>[2009-05-15 12:51:42,442]    DEBUG: vg vg_test150 has -3060MB free
>[2009-05-15 12:51:42,442]    DEBUG: vg_test150 size is 15156MB
>[2009-05-15 12:51:42,442]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdbd736d0) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = 29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud  format = <storage.formats.DeviceFormat object at 0x7facdbd73910>  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 0x7facdbd73490>  percent = 0) uses 16232MB
>[2009-05-15 12:51:42,443]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdbd738d0) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V  format = <storage.formats.DeviceFormat object at 0x7facdbd73850>  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 0x7facdbd73490>  percent = 0) uses 1984MB
>[2009-05-15 12:51:42,443]    DEBUG: vg vg_test150 has -3060MB free
>[2009-05-15 12:51:42,443]    DEBUG: found LVMVolumeGroupDevice instance (0x7facdbd73490) --
>  description =   name = vg_test150  status = False  parents = [<storage.devices.PartitionDevice object at 0x7facdbd55e90>]
>  kids = 2
>  uuid = D952VY-RmMB-PSF7-Vw4y-bJCa-ywLO-yw2VT8  format = <storage.formats.DeviceFormat object at 0x7facdbd73810>  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 0x7facdbd55e90>]
>  LVs = [<storage.devices.LVMLogicalVolumeDevice object at 0x7facdbd736d0>, <storage.devices.LVMLogicalVolumeDevice object at 0x7facdbd738d0>]
>[2009-05-15 12:51:42,449]     INFO: setup of vg_test150-lv_root failed: cannot activate VG with missing PV(s)
>[2009-05-15 12:51:42,452]     INFO: setup of vg_test150-lv_swap failed: cannot activate VG with missing PV(s)
>[2009-05-15 12:51:42,453]    DEBUG: scanning vdc (/devices/virtio-pci/virtio3/block/vdc)...
>[2009-05-15 12:51:42,453]    DEBUG: looking for device 'vdc'...
>[2009-05-15 12:51:42,454]    DEBUG: found None
>[2009-05-15 12:51:42,455]    DEBUG: vdc is a disk
>[2009-05-15 12:51:42,455]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,457]    DEBUG: looking up parted Device: /dev/vdc
>[2009-05-15 12:51:42,457]    DEBUG: looking up parted Device: /dev/vdc
>[2009-05-15 12:51:42,458]    DEBUG: creating parted Disk: /dev/vdc
>[2009-05-15 12:51:42,587]    DEBUG: added vdc (disk) to device tree
>[2009-05-15 12:51:42,588]    DEBUG: {'symlinks': ['block/252:32'], 'MAJOR': '252', 'name': 'vdc', 'ANACBIN': '/usr/sbin', 'DEVTYPE': 'disk', 'sysfs_path': '/devices/virtio-pci/virtio3/block/vdc', 'ID_FS_USAGE': 'raid', 'ID_FS_UUID': '1FLgcz-5mNp-7xSV-CM33-mmTR-rPA6-k2wHch', 'ID_FS_VERSION': 'LVM2\\x20001', 'ID_FS_UUID_ENC': '1FLgcz-5mNp-7xSV-CM33-mmTR-rPA6-k2wHch', 'ID_FS_TYPE': 'LVM2_member', 'MINOR': '32'}
>[2009-05-15 12:51:42,589]    DEBUG: PV vdc has no vg_name
>[2009-05-15 12:51:42,589]    DEBUG: PV vdc has no vg_uuid
>[2009-05-15 12:51:42,589]    DEBUG: PV vdc has no pe_start
>[2009-05-15 12:51:42,589]    DEBUG: type detected on 'vdc' is 'LVM2_member'
>[2009-05-15 12:51:42,590]    DEBUG: getFormat('LVM2_member') returning LVMPhysicalVolume instance
>[2009-05-15 12:51:42,592]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,594]    DEBUG: scanning vdc1 (/devices/virtio-pci/virtio3/block/vdc/vdc1)...
>[2009-05-15 12:51:42,595]    DEBUG: looking for device 'vdc1'...
>[2009-05-15 12:51:42,595]    DEBUG: found None
>[2009-05-15 12:51:42,595]    DEBUG: vdc1 is a partition
>[2009-05-15 12:51:42,596]    DEBUG: looking for device 'vdc'...
>[2009-05-15 12:51:42,597]    DEBUG: found DiskDevice instance (0x7facdbd73c50) --
>  description =   name = vdc  status = True  parents = []
>  kids = 0
>  uuid = None  format = <storage.formats.DeviceFormat object at 0x7facdbd73d50>  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 0x7facdbd77110>
>  partedDisk = <parted.disk.Disk object at 0x7facdbd77090>
>[2009-05-15 12:51:42,600]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,601]    DEBUG: looking up parted Partition: /dev/vdc1
>[2009-05-15 12:51:42,603]    DEBUG: looking up parted Device: /dev/vdc1
>[2009-05-15 12:51:42,613]    DEBUG: added vdc1 (partition) to device tree
>[2009-05-15 12:51:42,614]    DEBUG: {'LVM2_PV_UUID': 'fszsgi-xRLd-SoCK-VgDr-qUL6-KdAE-zv9aoV', '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': 'D952VY-RmMB-PSF7-Vw4y-bJCa-ywLO-yw2VT8', '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': 'fszsgi-xRLd-SoCK-VgDr-qUL6-KdAE-zv9aoV', 'ID_FS_UUID_ENC': 'fszsgi-xRLd-SoCK-VgDr-qUL6-KdAE-zv9aoV', 'ID_FS_TYPE': 'LVM2_member', 'LVM2_LV_UUID': ['29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud', 'SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V'], '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-15 12:51:42,614]    DEBUG: type detected on 'vdc1' is 'LVM2_member'
>[2009-05-15 12:51:42,616]    DEBUG: getFormat('LVM2_member') returning LVMPhysicalVolume instance
>[2009-05-15 12:51:42,625]    DEBUG: looking for device 'vg_test150'...
>[2009-05-15 12:51:42,626]    DEBUG: vg_test150 size is 17200MB
>[2009-05-15 12:51:42,627]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdbd736d0) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = 29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud  format = <storage.formats.DeviceFormat object at 0x7facdbd73910>  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 0x7facdbd73490>  percent = 0) uses 16232MB
>[2009-05-15 12:51:42,627]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdbd738d0) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V  format = <storage.formats.DeviceFormat object at 0x7facdbd73850>  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 0x7facdbd73490>  percent = 0) uses 1984MB
>[2009-05-15 12:51:42,628]    DEBUG: vg vg_test150 has -1016MB free
>[2009-05-15 12:51:42,628]    DEBUG: vg_test150 size is 17200MB
>[2009-05-15 12:51:42,628]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdbd736d0) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = 29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud  format = <storage.formats.DeviceFormat object at 0x7facdbd73910>  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 0x7facdbd73490>  percent = 0) uses 16232MB
>[2009-05-15 12:51:42,629]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdbd738d0) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V  format = <storage.formats.DeviceFormat object at 0x7facdbd73850>  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 0x7facdbd73490>  percent = 0) uses 1984MB
>[2009-05-15 12:51:42,629]    DEBUG: vg vg_test150 has -1016MB free
>[2009-05-15 12:51:42,629]    DEBUG: found LVMVolumeGroupDevice instance (0x7facdbd73490) --
>  description =   name = vg_test150  status = False  parents = [<storage.devices.PartitionDevice object at 0x7facdbd55e90>, <storage.devices.PartitionDevice object at 0x7facdbd73d90>]
>  kids = 2
>  uuid = D952VY-RmMB-PSF7-Vw4y-bJCa-ywLO-yw2VT8  format = <storage.formats.DeviceFormat object at 0x7facdbd73810>  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 0x7facdbd55e90>, <storage.devices.PartitionDevice object at 0x7facdbd73d90>]
>  LVs = [<storage.devices.LVMLogicalVolumeDevice object at 0x7facdbd736d0>, <storage.devices.LVMLogicalVolumeDevice object at 0x7facdbd738d0>]
>[2009-05-15 12:51:42,637]     INFO: setup of vg_test150-lv_root failed: cannot activate VG with missing PV(s)
>[2009-05-15 12:51:42,640]     INFO: setup of vg_test150-lv_swap failed: cannot activate VG with missing PV(s)
>[2009-05-15 12:51:42,641]    DEBUG: scanning vdd (/devices/virtio-pci/virtio4/block/vdd)...
>[2009-05-15 12:51:42,641]    DEBUG: looking for device 'vdd'...
>[2009-05-15 12:51:42,642]    DEBUG: found None
>[2009-05-15 12:51:42,643]    DEBUG: vdd is a disk
>[2009-05-15 12:51:42,643]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,645]    DEBUG: looking up parted Device: /dev/vdd
>[2009-05-15 12:51:42,645]    DEBUG: looking up parted Device: /dev/vdd
>[2009-05-15 12:51:42,646]    DEBUG: creating parted Disk: /dev/vdd
>[2009-05-15 12:51:42,752]    DEBUG: added vdd (disk) to device tree
>[2009-05-15 12:51:42,755]    DEBUG: {'symlinks': ['block/252:48'], 'MAJOR': '252', 'name': 'vdd', 'ANACBIN': '/usr/sbin', 'DEVTYPE': 'disk', 'sysfs_path': '/devices/virtio-pci/virtio4/block/vdd', 'ID_FS_USAGE': 'raid', 'ID_FS_UUID': 'rsZ72n-d3H4-eDlm-v12H-hJd4-4dVG-tiqKcm', 'ID_FS_VERSION': 'LVM2\\x20001', 'ID_FS_UUID_ENC': 'rsZ72n-d3H4-eDlm-v12H-hJd4-4dVG-tiqKcm', 'ID_FS_TYPE': 'LVM2_member', 'MINOR': '48'}
>[2009-05-15 12:51:42,755]    DEBUG: PV vdd has no vg_name
>[2009-05-15 12:51:42,755]    DEBUG: PV vdd has no vg_uuid
>[2009-05-15 12:51:42,756]    DEBUG: PV vdd has no pe_start
>[2009-05-15 12:51:42,756]    DEBUG: type detected on 'vdd' is 'LVM2_member'
>[2009-05-15 12:51:42,758]    DEBUG: getFormat('LVM2_member') returning LVMPhysicalVolume instance
>[2009-05-15 12:51:42,760]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,762]    DEBUG: scanning vdd1 (/devices/virtio-pci/virtio4/block/vdd/vdd1)...
>[2009-05-15 12:51:42,763]    DEBUG: looking for device 'vdd1'...
>[2009-05-15 12:51:42,763]    DEBUG: found None
>[2009-05-15 12:51:42,763]    DEBUG: vdd1 is a partition
>[2009-05-15 12:51:42,765]    DEBUG: looking for device 'vdd'...
>[2009-05-15 12:51:42,766]    DEBUG: found DiskDevice instance (0x7facdbd77590) --
>  description =   name = vdd  status = True  parents = []
>  kids = 0
>  uuid = None  format = <storage.formats.DeviceFormat object at 0x7facdbd77550>  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 0x7facdbd777d0>
>  partedDisk = <parted.disk.Disk object at 0x7facdbd77750>
>[2009-05-15 12:51:42,773]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 12:51:42,775]    DEBUG: looking up parted Partition: /dev/vdd1
>[2009-05-15 12:51:42,777]    DEBUG: looking up parted Device: /dev/vdd1
>[2009-05-15 12:51:42,810]    DEBUG: added vdd1 (partition) to device tree
>[2009-05-15 12:51:42,812]    DEBUG: {'LVM2_PV_UUID': 'l30c6H-TcfP-M6zd-hwC9-vh7S-3NCV-xQAWX5', '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': 'D952VY-RmMB-PSF7-Vw4y-bJCa-ywLO-yw2VT8', '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': 'l30c6H-TcfP-M6zd-hwC9-vh7S-3NCV-xQAWX5', 'ID_FS_UUID_ENC': 'l30c6H-TcfP-M6zd-hwC9-vh7S-3NCV-xQAWX5', 'ID_FS_TYPE': 'LVM2_member', 'LVM2_LV_UUID': ['29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud', 'SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V'], '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-15 12:51:42,812]    DEBUG: type detected on 'vdd1' is 'LVM2_member'
>[2009-05-15 12:51:42,814]    DEBUG: getFormat('LVM2_member') returning LVMPhysicalVolume instance
>[2009-05-15 12:51:42,833]    DEBUG: looking for device 'vg_test150'...
>[2009-05-15 12:51:42,834]    DEBUG: vg_test150 size is 17708MB
>[2009-05-15 12:51:42,834]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdbd736d0) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = 29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud  format = <storage.formats.DeviceFormat object at 0x7facdbd73910>  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 0x7facdbd73490>  percent = 0) uses 16232MB
>[2009-05-15 12:51:42,835]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdbd738d0) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V  format = <storage.formats.DeviceFormat object at 0x7facdbd73850>  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 0x7facdbd73490>  percent = 0) uses 1984MB
>[2009-05-15 12:51:42,835]    DEBUG: vg vg_test150 has -508MB free
>[2009-05-15 12:51:42,835]    DEBUG: vg_test150 size is 17708MB
>[2009-05-15 12:51:42,836]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdbd736d0) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = 29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud  format = <storage.formats.DeviceFormat object at 0x7facdbd73910>  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 0x7facdbd73490>  percent = 0) uses 16232MB
>[2009-05-15 12:51:42,836]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdbd738d0) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V  format = <storage.formats.DeviceFormat object at 0x7facdbd73850>  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 0x7facdbd73490>  percent = 0) uses 1984MB
>[2009-05-15 12:51:42,836]    DEBUG: vg vg_test150 has -508MB free
>[2009-05-15 12:51:42,836]    DEBUG: found LVMVolumeGroupDevice instance (0x7facdbd73490) --
>  description =   name = vg_test150  status = False  parents = [<storage.devices.PartitionDevice object at 0x7facdbd55e90>, <storage.devices.PartitionDevice object at 0x7facdbd73d90>, <storage.devices.PartitionDevice object at 0x7facdbd773d0>]
>  kids = 2
>  uuid = D952VY-RmMB-PSF7-Vw4y-bJCa-ywLO-yw2VT8  format = <storage.formats.DeviceFormat object at 0x7facdbd73810>  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 0x7facdbd55e90>, <storage.devices.PartitionDevice object at 0x7facdbd73d90>, <storage.devices.PartitionDevice object at 0x7facdbd773d0>]
>  LVs = [<storage.devices.LVMLogicalVolumeDevice object at 0x7facdbd736d0>, <storage.devices.LVMLogicalVolumeDevice object at 0x7facdbd738d0>]
>[2009-05-15 12:51:43,256]    DEBUG: looking up parted Device: /dev/mapper/vg_test150-lv_root
>[2009-05-15 12:51:43,754]    DEBUG: looking up parted Device: /dev/mapper/vg_test150-lv_swap
>[2009-05-15 12:51:43,943]     INFO: devices to scan: ['dm-0', 'dm-1']
>[2009-05-15 12:51:43,947]    DEBUG: scanning vg_test150-lv_root (/devices/virtual/block/dm-0)...
>[2009-05-15 12:51:43,947]    DEBUG: looking for device 'vg_test150-lv_root'...
>[2009-05-15 12:51:43,948]    DEBUG: found LVMLogicalVolumeDevice instance (0x7facdbd736d0) --
>  description =   name = vg_test150-lv_root  status = True  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = 29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud  format = <storage.formats.DeviceFormat object at 0x7facdbd73910>  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 0x7facdbd73490>  percent = 0
>[2009-05-15 12:51:43,948]    DEBUG: vg_test150-lv_root is a device-mapper device
>[2009-05-15 12:51:43,950]    DEBUG: {'symlinks': ['block/253:0', 'disk/by-id/dm-name-vg_test150-lv_root', 'disk/by-id/dm-uuid-LVM-D952VYRmMBPSF7Vw4ybJCaywLOyw2VT829nuoNPCsSOWNAdf5oQ9Ulxn8qGZfEud', 'disk/by-uuid/1c6bf3b5-27fb-41a3-bbc2-51c533437f4e'], 'DM_TABLES_LOADED': 'Live', 'DM_NAME': 'vg_test150-lv_root', 'DM_MAJOR': '253', 'name': 'dm-0', 'ANACBIN': '/usr/sbin', 'MAJOR': '253', 'DM_UUID': 'LVM-D952VYRmMBPSF7Vw4ybJCaywLOyw2VT829nuoNPCsSOWNAdf5oQ9Ulxn8qGZfEud', 'DM_SUSPENDED': 'Active', 'ID_FS_UUID': '1c6bf3b5-27fb-41a3-bbc2-51c533437f4e', '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': '1c6bf3b5-27fb-41a3-bbc2-51c533437f4e', 'DM_OPEN': '0', 'ID_FS_TYPE': 'ext4', 'MINOR': '0', 'DM_MINOR': '0'}
>[2009-05-15 12:51:43,950]    DEBUG: type detected on 'vg_test150-lv_root' is 'ext4'
>[2009-05-15 12:51:43,952]     INFO: set SELinux context for mountpoint /tmp/getsize-kKzioX to None
>[2009-05-15 12:51:44,005]     INFO: set SELinux context for newly mounted filesystem root at /tmp/getsize-kKzioX to None
>[2009-05-15 12:51:44,063]    DEBUG: getFormat('ext4') returning Ext4FS instance
>[2009-05-15 12:51:44,066]    DEBUG: scanning vg_test150-lv_swap (/devices/virtual/block/dm-1)...
>[2009-05-15 12:51:44,067]    DEBUG: looking for device 'vg_test150-lv_swap'...
>[2009-05-15 12:51:44,067]    DEBUG: found LVMLogicalVolumeDevice instance (0x7facdbd738d0) --
>  description =   name = vg_test150-lv_swap  status = True  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V  format = <storage.formats.DeviceFormat object at 0x7facdbd73850>  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 0x7facdbd73490>  percent = 0
>[2009-05-15 12:51:44,067]    DEBUG: vg_test150-lv_swap is a device-mapper device
>[2009-05-15 12:51:44,069]    DEBUG: {'symlinks': ['block/253:1', 'disk/by-id/dm-name-vg_test150-lv_swap', 'disk/by-id/dm-uuid-LVM-D952VYRmMBPSF7Vw4ybJCaywLOyw2VT8SdZfqrsPEH1PoY0sz0iu2LOEtu31740V', 'disk/by-uuid/8c940c1d-296e-47a6-abf5-7a262223ebe6'], 'DM_TABLES_LOADED': 'Live', 'DM_NAME': 'vg_test150-lv_swap', 'DM_MAJOR': '253', 'name': 'dm-1', 'ANACBIN': '/usr/sbin', 'MAJOR': '253', 'DM_UUID': 'LVM-D952VYRmMBPSF7Vw4ybJCaywLOyw2VT8SdZfqrsPEH1PoY0sz0iu2LOEtu31740V', 'DM_SUSPENDED': 'Active', 'ID_FS_UUID': '8c940c1d-296e-47a6-abf5-7a262223ebe6', 'sysfs_path': '/devices/virtual/block/dm-1', 'ID_FS_USAGE': 'other', 'DM_READONLY': 'Writeable', 'DEVTYPE': 'disk', 'ID_FS_VERSION': '2', 'ID_FS_UUID_ENC': '8c940c1d-296e-47a6-abf5-7a262223ebe6', 'DM_OPEN': '0', 'ID_FS_TYPE': 'swap', 'MINOR': '1', 'DM_MINOR': '1'}
>[2009-05-15 12:51:44,069]    DEBUG: type detected on 'vg_test150-lv_swap' is 'swap'
>[2009-05-15 12:51:44,071]    DEBUG: getFormat('swap') returning SwapSpace instance
>[2009-05-15 12:51:45,431]     INFO: failed to unlink /etc/mdadm.conf
>[2009-05-15 12:51:45,442]     INFO: set SELinux context for mountpoint /mnt/sysimage to None
>[2009-05-15 12:51:45,463]     INFO: set SELinux context for newly mounted filesystem root at /mnt/sysimage to system_u:object_r:mnt_t:s0
>[2009-05-15 12:51:45,930]     INFO: set SELinux context for mountpoint /mnt/sysimage to None
>[2009-05-15 12:51:45,971]     INFO: set SELinux context for newly mounted filesystem root at /mnt/sysimage to system_u:object_r:mnt_t:s0
>[2009-05-15 08:51:59,562]    DEBUG: looking for device 'vda1'...
>[2009-05-15 08:51:59,562]    DEBUG: found PartitionDevice instance (0x7facdbd55fd0) --
>  description =   name = vda1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd55a90>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext3FS object at 0x7facdbd5b410>  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 0x7facdbd5b210>  disk = <storage.devices.DiskDevice object at 0x7facdbd55a90>
>[2009-05-15 08:51:59,564]    DEBUG: looking for device 'vda2'...
>[2009-05-15 08:51:59,564]    DEBUG: found PartitionDevice instance (0x7facdbd55e90) --
>  description =   name = vda2  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd55a90>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd73750>  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 0x7facdbd5b050>  disk = <storage.devices.DiskDevice object at 0x7facdbd55a90>
>[2009-05-15 08:51:59,566]    DEBUG: looking for device 'vdb1'...
>[2009-05-15 08:51:59,566]    DEBUG: found PartitionDevice instance (0x7facdbd73d90) --
>  description =   name = vdb1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd73a50>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd73e90>  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 0x7facdbd73f90>  disk = <storage.devices.DiskDevice object at 0x7facdbd73a50>
>[2009-05-15 08:51:59,567]    DEBUG: looking for device 'vdc1'...
>[2009-05-15 08:51:59,568]    DEBUG: found PartitionDevice instance (0x7facdbd773d0) --
>  description =   name = vdc1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd73c50>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd77890>  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 0x7facdbd77690>  disk = <storage.devices.DiskDevice object at 0x7facdbd73c50>
>[2009-05-15 08:51:59,569]    DEBUG: looking for device 'vdd1'...
>[2009-05-15 08:51:59,569]    DEBUG: found PartitionDevice instance (0x7facdbd77a90) --
>  description =   name = vdd1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd77590>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd77f50>  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 0x7facdbd77d50>  disk = <storage.devices.DiskDevice object at 0x7facdbd77590>
>[2009-05-15 08:52:15,113]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:52:15,120]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-15 08:52:15,121]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdaff3290) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbbab790>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>  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 0x7facdbbab790>  percent = 0) uses 16232MB
>[2009-05-15 08:52:15,121]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdaff3310) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbbab790>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7facdbbe2e50>  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 0x7facdbbab790>  percent = 0) uses 1984MB
>[2009-05-15 08:52:15,121]    DEBUG: vg tmp-vg_test150 has 0MB free
>[2009-05-15 08:52:17,454]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:52:22,449]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:52:22,457]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-15 08:52:22,458]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdb006850) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdaff7f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>  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 0x7facdaff7f50>  percent = 0) uses 16232MB
>[2009-05-15 08:52:22,458]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdb006a10) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdaff7f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7facdaff7f10>  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 0x7facdaff7f50>  percent = 0) uses 1984MB
>[2009-05-15 08:52:22,458]    DEBUG: vg tmp-vg_test150 has 0MB free
>[2009-05-15 08:52:23,911]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:52:29,275]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:52:29,283]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-15 08:52:29,284]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdb008d90) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb008610>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>  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 0x7facdb008610>  percent = 0) uses 5000MB
>[2009-05-15 08:52:29,284]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdb008f50) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb008610>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7facdaff7f10>  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 0x7facdb008610>  percent = 0) uses 1984MB
>[2009-05-15 08:52:29,284]    DEBUG: vg tmp-vg_test150 has 11232MB free
>[2009-05-15 08:52:30,528]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:52:30,536]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-15 08:52:30,536]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdb008790) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb008f90>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>  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 0x7facdb008f90>  percent = 0) uses 5000MB
>[2009-05-15 08:52:30,536]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdb008a50) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb008f90>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7facdaff7f10>  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 0x7facdb008f90>  percent = 0) uses 1984MB
>[2009-05-15 08:52:30,537]    DEBUG: vg tmp-vg_test150 has 11232MB free
>[2009-05-15 08:52:30,543]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:52:30,551]    DEBUG: getFormat('ext4') returning Ext4FS instance
>[2009-05-15 08:52:30,558]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:52:30,567]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-15 08:52:30,568]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdb006150) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdaff7f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>  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 0x7facdaff7f50>  percent = 0) uses 5000MB
>[2009-05-15 08:52:30,568]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdb0064d0) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdaff7f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7facdaff7f10>  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 0x7facdaff7f50>  percent = 0) uses 1984MB
>[2009-05-15 08:52:30,568]    DEBUG: vg tmp-vg_test150 has 11232MB free
>[2009-05-15 08:52:30,620]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-15 08:52:30,620]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdb006150) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdaff7f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>  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 0x7facdaff7f50>  percent = 0) uses 5000MB
>[2009-05-15 08:52:30,620]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdb0064d0) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdaff7f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7facdaff7f10>  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 0x7facdaff7f50>  percent = 0) uses 1984MB
>[2009-05-15 08:52:30,621]    DEBUG: lv tmp-vg_test150-LogVol02 (LVMLogicalVolumeDevice instance (0x7facdb006390) --
>  description =   name = tmp-vg_test150-LogVol02  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdaff7f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdb008350>  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 0x7facdaff7f50>  percent = 0) uses 11232MB
>[2009-05-15 08:52:30,621]    DEBUG: vg tmp-vg_test150 has 0MB free
>[2009-05-15 08:53:36,788]    DEBUG: trying to set lv tmp-vg_test150-new_root size to 11232MB
>[2009-05-15 08:53:36,789]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-15 08:53:36,789]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdb006150) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdaff7f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>  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 0x7facdaff7f50>  percent = 0) uses 5000MB
>[2009-05-15 08:53:36,789]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdb0064d0) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdaff7f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7facdaff7f10>  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 0x7facdaff7f50>  percent = 0) uses 1984MB
>[2009-05-15 08:53:36,790]    DEBUG: lv tmp-vg_test150-new_root (LVMLogicalVolumeDevice instance (0x7facdb006390) --
>  description =   name = tmp-vg_test150-new_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdaff7f50>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdb008350>  size = 11232
>  major = 0  minor = 0  exists = False
>  sysfs path =   label = None
>  target size = 11232  path = /dev/mapper/tmp--vg_test150-new_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7facdaff7f50>  percent = 0) uses 11232MB
>[2009-05-15 08:53:36,790]    DEBUG: vg tmp-vg_test150 has 0MB free
>[2009-05-15 08:53:36,800]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:53:36,811]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-15 08:53:36,811]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdaff3350) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb006650>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>  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 0x7facdb006650>  percent = 0) uses 5000MB
>[2009-05-15 08:53:36,811]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdaff3850) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb006650>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7facdaff7f10>  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 0x7facdb006650>  percent = 0) uses 1984MB
>[2009-05-15 08:53:36,811]    DEBUG: vg tmp-vg_test150 has 11232MB free
>[2009-05-15 08:53:36,812]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-15 08:53:36,812]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdaff3350) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb006650>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>  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 0x7facdb006650>  percent = 0) uses 5000MB
>[2009-05-15 08:53:36,812]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdaff3850) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb006650>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7facdaff7f10>  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 0x7facdb006650>  percent = 0) uses 1984MB
>[2009-05-15 08:53:36,812]    DEBUG: lv tmp-vg_test150-new_root (LVMLogicalVolumeDevice instance (0x7facdaff3710) --
>  description =   name = tmp-vg_test150-new_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb006650>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdb006490>  size = 11232
>  major = 0  minor = 0  exists = False
>  sysfs path =   label = None
>  target size = 11232  path = /dev/mapper/tmp--vg_test150-new_root
>  format args = []  target = None  dmUuid = None  VG device = <storage.devices.LVMVolumeGroupDevice object at 0x7facdb006650>  percent = 0) uses 11232MB
>[2009-05-15 08:53:36,813]    DEBUG: vg tmp-vg_test150 has 0MB free
>[2009-05-15 08:53:38,042]    DEBUG: looking for device 'vda2'...
>[2009-05-15 08:53:38,043]    DEBUG: found PartitionDevice instance (0x7facdbd55e90) --
>  description =   name = vda2  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd55a90>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd73750>  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 0x7facdbd5b050>  disk = <storage.devices.DiskDevice object at 0x7facdbd55a90>
>[2009-05-15 08:53:38,043]    DEBUG: looking for device 'vdb1'...
>[2009-05-15 08:53:38,043]    DEBUG: found PartitionDevice instance (0x7facdbd73d90) --
>  description =   name = vdb1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd73a50>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd73e90>  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 0x7facdbd73f90>  disk = <storage.devices.DiskDevice object at 0x7facdbd73a50>
>[2009-05-15 08:53:38,044]    DEBUG: looking for device 'vdc1'...
>[2009-05-15 08:53:38,044]    DEBUG: found PartitionDevice instance (0x7facdbd773d0) --
>  description =   name = vdc1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd73c50>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd77890>  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 0x7facdbd77690>  disk = <storage.devices.DiskDevice object at 0x7facdbd73c50>
>[2009-05-15 08:53:38,044]    DEBUG: looking for device 'vdd1'...
>[2009-05-15 08:53:38,044]    DEBUG: found PartitionDevice instance (0x7facdbd77a90) --
>  description =   name = vdd1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd77590>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd77f50>  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 0x7facdbd77d50>  disk = <storage.devices.DiskDevice object at 0x7facdbd77590>
>[2009-05-15 08:53:38,053]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:53:38,061]    DEBUG: tmp-vg_test150 size is 18216MB
>[2009-05-15 08:53:38,061]    DEBUG: lv tmp-vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdbbe2fd0) --
>  description =   name = tmp-vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb008350>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext4FS object at 0x7facdbbe2d90>  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 0x7facdb008350>  percent = 0) uses 5000MB
>[2009-05-15 08:53:38,062]    DEBUG: lv tmp-vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdafda1d0) --
>  description =   name = tmp-vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdb008350>]
>  kids = 0
>  uuid = None  format = <storage.formats.swap.SwapSpace object at 0x7facdaff7f10>  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 0x7facdb008350>  percent = 0) uses 1984MB
>[2009-05-15 08:53:38,062]    DEBUG: vg tmp-vg_test150 has 11232MB free
>[2009-05-15 08:53:38,065]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:53:38,068]    DEBUG: getFormat('swap') returning SwapSpace instance
>[2009-05-15 08:53:38,071]    DEBUG: getFormat('None') returning DeviceFormat instance
>[2009-05-15 08:53:38,072]    DEBUG: vg_test150 size is 18216MB
>[2009-05-15 08:53:38,073]    DEBUG: lv vg_test150-lv_root (LVMLogicalVolumeDevice instance (0x7facdbd736d0) --
>  description =   name = vg_test150-lv_root  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = 29nuoN-PCsS-OWNA-df5o-Q9Ul-xn8q-GZfEud  format = <storage.formats.fs.Ext4FS object at 0x7facdc2cc490>  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 0x7facdbd73490>  percent = 0) uses 5000MB
>[2009-05-15 08:53:38,073]    DEBUG: lv vg_test150-lv_swap (LVMLogicalVolumeDevice instance (0x7facdbd738d0) --
>  description =   name = vg_test150-lv_swap  status = False  parents = [<storage.devices.LVMVolumeGroupDevice object at 0x7facdbd73490>]
>  kids = 0
>  uuid = SdZfqr-sPEH-1PoY-0sz0-iu2L-OEtu-31740V  format = <storage.formats.swap.SwapSpace object at 0x7facdbd73910>  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 0x7facdbd73490>  percent = 0) uses 1984MB
>[2009-05-15 08:53:38,073]    DEBUG: vg vg_test150 has 11232MB free
>[2009-05-15 08:53:38,075]    DEBUG: getFormat('ext4') returning Ext4FS instance
>[2009-05-15 08:53:38,076]    DEBUG: registered action: Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:38,076]    DEBUG: registered action: Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:38,076]    DEBUG: registered action: Destroy Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:38,076]    DEBUG: registered action: Create Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:38,077]    DEBUG: added vg_test150-new_root (lvmlv) to device tree
>[2009-05-15 08:53:38,077]    DEBUG: registered action: Create Device vg_test150-new_root (lvmlv)
>[2009-05-15 08:53:38,077]    DEBUG: registered action: Create Format ext4 on vg_test150-new_root (lvmlv)
>[2009-05-15 08:53:38,081]    DEBUG: looking for device 'vda1'...
>[2009-05-15 08:53:38,081]    DEBUG: found PartitionDevice instance (0x7facdbd55fd0) --
>  description =   name = vda1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd55a90>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext3FS object at 0x7facdbd5b410>  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 0x7facdbd5b210>  disk = <storage.devices.DiskDevice object at 0x7facdbd55a90>
>[2009-05-15 08:53:38,082]    DEBUG: looking for device 'vda2'...
>[2009-05-15 08:53:38,082]    DEBUG: found PartitionDevice instance (0x7facdbd55e90) --
>  description =   name = vda2  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd55a90>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd73750>  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 0x7facdbd5b050>  disk = <storage.devices.DiskDevice object at 0x7facdbd55a90>
>[2009-05-15 08:53:38,084]    DEBUG: looking for device 'vdb1'...
>[2009-05-15 08:53:38,084]    DEBUG: found PartitionDevice instance (0x7facdbd73d90) --
>  description =   name = vdb1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd73a50>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd73e90>  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 0x7facdbd73f90>  disk = <storage.devices.DiskDevice object at 0x7facdbd73a50>
>[2009-05-15 08:53:38,085]    DEBUG: looking for device 'vdc1'...
>[2009-05-15 08:53:38,085]    DEBUG: found PartitionDevice instance (0x7facdbd773d0) --
>  description =   name = vdc1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd73c50>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd77890>  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 0x7facdbd77690>  disk = <storage.devices.DiskDevice object at 0x7facdbd73c50>
>[2009-05-15 08:53:38,087]    DEBUG: looking for device 'vdd1'...
>[2009-05-15 08:53:38,087]    DEBUG: found PartitionDevice instance (0x7facdbd77a90) --
>  description =   name = vdd1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd77590>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd77f50>  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 0x7facdbd77d50>  disk = <storage.devices.DiskDevice object at 0x7facdbd77590>
>[2009-05-15 08:53:45,677]    DEBUG: registered action: Resize Device (Shrink) vda1 (partition)
>[2009-05-15 08:53:45,677]    DEBUG: registered action: Resize Format (Grow) ext3 on vda1 (partition)
>[2009-05-15 08:53:45,684]    DEBUG: allocatePartitions: disks=[<storage.devices.DiskDevice object at 0x7facdbd55a90>, <storage.devices.DiskDevice object at 0x7facdbd73a50>, <storage.devices.DiskDevice object at 0x7facdbd73c50>, <storage.devices.DiskDevice object at 0x7facdbd77590>] ; partitions=[]
>[2009-05-15 08:53:45,685]    DEBUG: removing all non-preexisting from disk(s)
>[2009-05-15 08:53:45,685]    DEBUG: growPartitions: disks=['vda', 'vdb', 'vdc', 'vdd'], partitions=[]
>[2009-05-15 08:53:45,688]    DEBUG: looking for device 'vda1'...
>[2009-05-15 08:53:45,688]    DEBUG: found PartitionDevice instance (0x7facdbd55fd0) --
>  description =   name = vda1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd55a90>]
>  kids = 0
>  uuid = None  format = <storage.formats.fs.Ext3FS object at 0x7facdbd5b410>  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 0x7facdbd5b210>  disk = <storage.devices.DiskDevice object at 0x7facdbd55a90>
>[2009-05-15 08:53:45,689]    DEBUG: looking for device 'vda-1'...
>[2009-05-15 08:53:45,689]    DEBUG: found None
>[2009-05-15 08:53:45,690]    DEBUG: looking for device 'vda2'...
>[2009-05-15 08:53:45,690]    DEBUG: found PartitionDevice instance (0x7facdbd55e90) --
>  description =   name = vda2  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd55a90>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd73750>  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 0x7facdbd5b050>  disk = <storage.devices.DiskDevice object at 0x7facdbd55a90>
>[2009-05-15 08:53:45,691]    DEBUG: looking for device 'vdb1'...
>[2009-05-15 08:53:45,692]    DEBUG: found PartitionDevice instance (0x7facdbd73d90) --
>  description =   name = vdb1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd73a50>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd73e90>  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 0x7facdbd73f90>  disk = <storage.devices.DiskDevice object at 0x7facdbd73a50>
>[2009-05-15 08:53:45,693]    DEBUG: looking for device 'vdc1'...
>[2009-05-15 08:53:45,693]    DEBUG: found PartitionDevice instance (0x7facdbd773d0) --
>  description =   name = vdc1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd73c50>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd77890>  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 0x7facdbd77690>  disk = <storage.devices.DiskDevice object at 0x7facdbd73c50>
>[2009-05-15 08:53:45,694]    DEBUG: looking for device 'vdd1'...
>[2009-05-15 08:53:45,695]    DEBUG: found PartitionDevice instance (0x7facdbd77a90) --
>  description =   name = vdd1  status = True  parents = [<storage.devices.DiskDevice object at 0x7facdbd77590>]
>  kids = 1
>  uuid = None  format = <storage.formats.lvmpv.LVMPhysicalVolume object at 0x7facdbd77f50>  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 0x7facdbd77d50>  disk = <storage.devices.DiskDevice object at 0x7facdbd77590>
>[2009-05-15 08:53:55,713]    DEBUG: action: Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,714]    DEBUG: action: Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,715]    DEBUG: action: Destroy Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:55,715]    DEBUG: action: Create Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:55,715]    DEBUG: action: Create Device vg_test150-new_root (lvmlv)
>[2009-05-15 08:53:55,715]    DEBUG: action: Create Format ext4 on vg_test150-new_root (lvmlv)
>[2009-05-15 08:53:55,715]    DEBUG: action: Resize Device (Shrink) vda1 (partition)
>[2009-05-15 08:53:55,716]    DEBUG: action: Resize Format (Grow) ext3 on vda1 (partition)
>[2009-05-15 08:53:55,716]    DEBUG: pruning action queue...
>[2009-05-15 08:53:55,716]    DEBUG: action 'Create Device vg_test150-new_root (lvmlv)' (140380385355664)
>[2009-05-15 08:53:55,716]    DEBUG: action 'Resize Device (Shrink) vg_test150-lv_root (lvmlv)' (140380385157392)
>[2009-05-15 08:53:55,717]    DEBUG: action 'Resize Device (Shrink) vda1 (partition)' (140380385357776)
>[2009-05-15 08:53:55,717]    DEBUG: action 'Destroy Format swap on vg_test150-lv_swap (lvmlv)' (140380385158160)
>[2009-05-15 08:53:55,717]    DEBUG: action 'Create Format swap on vg_test150-lv_swap (lvmlv)' (140380385157968)
>[2009-05-15 08:53:55,717]    DEBUG: action 'Create Format ext4 on vg_test150-new_root (lvmlv)' (140380385355920)
>[2009-05-15 08:53:55,718]    DEBUG: action 'Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)' (140380385157840)
>[2009-05-15 08:53:55,718]    DEBUG: action 'Resize Format (Grow) ext3 on vda1 (partition)' (140380385357712)
>[2009-05-15 08:53:55,718]    DEBUG: action: Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,718]    DEBUG: action: Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,718]    DEBUG: action: Destroy Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:55,718]    DEBUG: action: Create Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:55,719]    DEBUG: action: Create Device vg_test150-new_root (lvmlv)
>[2009-05-15 08:53:55,719]    DEBUG: action: Create Format ext4 on vg_test150-new_root (lvmlv)
>[2009-05-15 08:53:55,719]    DEBUG: action: Resize Device (Shrink) vda1 (partition)
>[2009-05-15 08:53:55,719]    DEBUG: action: Resize Format (Grow) ext3 on vda1 (partition)
>[2009-05-15 08:53:55,719]    DEBUG: sorting actions...
>[2009-05-15 08:53:55,719]    DEBUG: cmp: 0 -- Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv) | Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,720]    DEBUG: cmp: -1 -- Destroy Format swap on vg_test150-lv_swap (lvmlv) | Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,720]    DEBUG: cmp: -1 -- Destroy Format swap on vg_test150-lv_swap (lvmlv) | Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,720]    DEBUG: cmp: -1 -- Destroy Format swap on vg_test150-lv_swap (lvmlv) | Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,720]    DEBUG: cmp: 1 -- Create Format swap on vg_test150-lv_swap (lvmlv) | Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,720]    DEBUG: cmp: 1 -- Create Format swap on vg_test150-lv_swap (lvmlv) | Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,720]    DEBUG: cmp: 1 -- Create Device vg_test150-new_root (lvmlv) | Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,721]    DEBUG: cmp: 0 -- Create Device vg_test150-new_root (lvmlv) | Create Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:55,721]    DEBUG: cmp: 1 -- Create Format ext4 on vg_test150-new_root (lvmlv) | Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,721]    DEBUG: cmp: 1 -- Create Format ext4 on vg_test150-new_root (lvmlv) | Create Device vg_test150-new_root (lvmlv)
>[2009-05-15 08:53:55,721]    DEBUG: cmp: -1 -- Resize Device (Shrink) vda1 (partition) | Create Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:55,722]    DEBUG: cmp: 1 -- Resize Device (Shrink) vda1 (partition) | Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,722]    DEBUG: cmp: 1 -- Resize Device (Shrink) vda1 (partition) | Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,722]    DEBUG: cmp: 0 -- Resize Format (Grow) ext3 on vda1 (partition) | Resize Device (Shrink) vda1 (partition)
>[2009-05-15 08:53:55,722]    DEBUG: cmp: -1 -- Resize Format (Grow) ext3 on vda1 (partition) | Create Device vg_test150-new_root (lvmlv)
>[2009-05-15 08:53:55,722]    DEBUG: cmp: -1 -- Resize Format (Grow) ext3 on vda1 (partition) | Create Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:55,723]    DEBUG: action: Destroy Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:55,723]    DEBUG: action: Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,723]    DEBUG: action: Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:55,723]    DEBUG: action: Resize Device (Shrink) vda1 (partition)
>[2009-05-15 08:53:55,723]    DEBUG: action: Resize Format (Grow) ext3 on vda1 (partition)
>[2009-05-15 08:53:55,723]    DEBUG: action: Create Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:55,723]    DEBUG: action: Create Device vg_test150-new_root (lvmlv)
>[2009-05-15 08:53:55,724]    DEBUG: action: Create Format ext4 on vg_test150-new_root (lvmlv)
>[2009-05-15 08:53:55,724]    DEBUG: resetting parted disks...
>[2009-05-15 08:53:55,730]     INFO: executing action: Destroy Format swap on vg_test150-lv_swap (lvmlv)
>[2009-05-15 08:53:56,118]    DEBUG: zeroing out beginning and end of /dev/mapper/vg_test150-lv_swap...
>[2009-05-15 08:53:56,839]     INFO: executing action: Resize Device (Shrink) vg_test150-lv_root (lvmlv)
>[2009-05-15 08:53:57,399]     INFO: executing action: Resize Format (Shrink) ext4 on vg_test150-lv_root (lvmlv)

Actions: View

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