Re: x86: kvmclock: abstract save/restore sched_clock_state

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



On (Fri) 10 Feb 2012 [10:32:16], Marcelo Tosatti wrote:
> On Fri, Feb 10, 2012 at 03:32:11PM +0530, Amit Shah wrote:
> > On (Thu) 09 Feb 2012 [16:13:29], Igor Mammedov wrote:
> > 
> > > Stalls are probably caused by uninitialized percpu hv_clock, with
> > > following patch I don't see stalls. Although I might be just lucky.
> > > http://git.kernel.org/?p=virt/kvm/kvm.git;a=commit;h=e2971ac7e1d186af059e088d305496c5cb47d487
> > 
> > Your commit does make things better, I don't see any stalls on the
> > first resume.
> > 
> > However, a subsequent s4 causes the stall to re-appear on resume, and
> > this time there are no stall messages; the kernel just sits there
> > spinning on something.  I've not found the solution to this one yet (I
> > had a commit similar to Marcelo's in the works, which got me to the
> > previous works-but-stalls behaviour).
> 
> I cannot reproduce it here. Suspend/resume are operating normally after
> several iterations. Igor do you see anything similar?
> 
> Amit, can you please enable CONFIG_PRINTK_TIME=y and post a full dmesg 
> (both during suspend and also the new kernel during resume).

In my case, I run a ping to the host (10.0.2.2) while the s4
suspend/resume operations are performed.

Complete dmesg, for all 3 invocations of the guest.  First one boots,
starts ping, starts s4.  Second one starts s4 after confirming ping is
working fine.  Third one just stays there, spinning.

$ ./x86_64-softmmu/qemu-system-x86_64 -kernel ~/src/linux/arch/x86/boot/bzImage  -append 'root=/dev/vda1 console=tty0 console=ttyS0 no_console_suspend' -drive file=/guests/f14-suspend.qcow2,if=none,id=dr0 -device virtio-blk-pci,drive=dr0 -net nic,model=virtio -net user  -serial stdio  -enable-kvm -m 512  -cpu host -smp 4
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 3.3.0-rc2+ (amit@xxxxxxxxxxxxxxx) (gcc version 4.6.2 20111027 (Red Hat 4.6.2-1) (GCC) ) #295 SMP PREEMPT Fri Feb 10 18:39:48 IST 2012
[    0.000000] Command line: root=/dev/vda1 console=tty0 console=ttyS0 no_console_suspend
[    0.000000] BIOS-provided physical RAM map:
[    0.000000]  BIOS-e820: 0000000000000000 - 000000000009dc00 (usable)
[    0.000000]  BIOS-e820: 000000000009dc00 - 00000000000a0000 (reserved)
[    0.000000]  BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
[    0.000000]  BIOS-e820: 0000000000100000 - 000000001fffd000 (usable)
[    0.000000]  BIOS-e820: 000000001fffd000 - 0000000020000000 (reserved)
[    0.000000]  BIOS-e820: 00000000feffc000 - 00000000ff000000 (reserved)
[    0.000000]  BIOS-e820: 00000000fffc0000 - 0000000100000000 (reserved)
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] DMI 2.4 present.
[    0.000000] No AGP bridge found
[    0.000000] last_pfn = 0x1fffd max_arch_pfn = 0x400000000
[    0.000000] x86 PAT enabled: cpu 0, old 0x70406, new 0x7010600070106
[    0.000000] init_memory_mapping: 0000000000000000-000000001fffd000
[    0.000000] RAMDISK: 1fa2e000 - 1fff0000
[    0.000000] ACPI: RSDP 00000000000fd3f0 00014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 000000001fffd660 00034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 000000001fffff80 00074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 000000001fffd9b0 02589 (v01   BXPC   BXDSDT 00000001 INTL 20100528)
[    0.000000] ACPI: FACS 000000001fffff40 00040
[    0.000000] ACPI: SSDT 000000001fffd7e0 001C1 (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: APIC 000000001fffd6e0 0008A (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 000000001fffd6a0 00038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:18509c1, boot clock
[    0.000000] Zone PFN ranges:
[    0.000000]   DMA      0x00000010 -> 0x00001000
[    0.000000]   DMA32    0x00001000 -> 0x00100000
[    0.000000]   Normal   empty
[    0.000000] Movable zone start PFN for each node
[    0.000000] Early memory PFN ranges
[    0.000000]     0: 0x00000010 -> 0x0000009d
[    0.000000]     0: 0x00000100 -> 0x0001fffd
[    0.000000] ACPI: PM-Timer IO Port: 0xb008
[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[    0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
[    0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x02] enabled)
[    0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x03] enabled)
[    0.000000] ACPI: IOAPIC (id[0x04] address[0xfec00000] gsi_base[0])
[    0.000000] IOAPIC[0]: apic_id 4, version 17, address 0xfec00000, GSI 0-23
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.000000] SMP: Allowing 4 CPUs, 0 hotplug CPUs
[    0.000000] PM: Registered nosave memory: 000000000009d000 - 000000000009e000
[    0.000000] PM: Registered nosave memory: 000000000009e000 - 00000000000a0000
[    0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
[    0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
[    0.000000] Allocating PCI resources starting at 20000000 (gap: 20000000:deffc000)
[    0.000000] Booting paravirtualized kernel on KVM
[    0.000000] setup_percpu: NR_CPUS:4 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
[    0.000000] PERCPU: Embedded 474 pages/cpu @ffff88001f000000 s1910784 r8192 d22528 u2097152
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 128901
[    0.000000] Kernel command line: root=/dev/vda1 console=tty0 console=ttyS0 no_console_suspend
[    0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
[    0.000000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.000000] xsave/xrstor: enabled xstate_bv 0x7, cntxt size 0x340
[    0.000000] Checking aperture...
[    0.000000] No AGP bridge found
[    0.000000] Memory: 481644k/524276k available (3162k kernel code, 460k absent, 42172k reserved, 3483k data, 2420k init)
[    0.000000] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] Preemptible hierarchical RCU implementation.
[    0.000000] NR_IRQS:4352 nr_irqs:712 16
[    0.000000] Console: colour VGA+ 80x25
[    0.000000] console [tty0] enabled
[    0.000000] console [ttyS0] enabled
[    0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.000000] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.000000] ... MAX_LOCK_DEPTH:          48
[    0.000000] ... MAX_LOCKDEP_KEYS:        8191
[    0.000000] ... CLASSHASH_SIZE:          4096
[    0.000000] ... MAX_LOCKDEP_ENTRIES:     16384
[    0.000000] ... MAX_LOCKDEP_CHAINS:      32768
[    0.000000] ... CHAINHASH_SIZE:          16384
[    0.000000]  memory used by lock dependency info: 6367 kB
[    0.000000]  per task-struct memory footprint: 2688 bytes
[    0.000000] Detected 2691.258 MHz processor.
[    0.008000] Calibrating delay loop (skipped) preset value.. 5382.51 BogoMIPS (lpj=10765032)
[    0.008000] pid_max: default: 32768 minimum: 301
[    0.010143] Mount-cache hash table entries: 256
[    0.020001] ACPI: Core revision 20120111
[    0.141619] ftrace: allocating 14018 entries in 55 pages
[    0.151144] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.196275] CPU0: Intel(R) Core(TM) i7-2620M CPU @ 2.70GHz stepping 07
[    0.200011] APIC calibration not consistent with PM-Timer: 91ms instead of 100ms
[    0.200011] APIC delta adjusted to PM-Timer: 6250032 (5749686)
[    0.200011] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only.
[    0.220527] lockdep: fixing up alternatives.
[    0.232533] Booting Node   0, Processors  #1
[    0.008000] kvm-clock: cpu 1, msr 0:1f3d19c1, secondary cpu clock
[    0.256113] lockdep: fixing up alternatives.
[    0.257316]  #2
[    0.008000] kvm-clock: cpu 2, msr 0:1f5d19c1, secondary cpu clock
[    0.280143] lockdep: fixing up alternatives.
[    0.281629]  #3 Ok.
[    0.008000] kvm-clock: cpu 3, msr 0:1f7d19c1, secondary cpu clock
[    0.296077] Brought up 4 CPUs
[    0.296992] Total of 4 processors activated (21530.06 BogoMIPS).
[    0.316988] NET: Registered protocol family 16
[    0.321184] ACPI: bus type pci registered
[    0.322202] PCI: Using configuration type 1 for base access
[    0.348634] bio: create slab <bio-0> at 0
[    0.350786] ACPI: Added _OSI(Module Device)
[    0.353256] ACPI: Added _OSI(Processor Device)
[    0.354509] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.356065] ACPI: Added _OSI(Processor Aggregator Device)
[    0.559295] ACPI: Interpreter enabled
[    0.560039] ACPI: (supports S0 S3 S4 S5)
[    0.562446] ACPI: Using IOAPIC for interrupt routing
[    0.857221] ACPI: No dock devices found.
[    0.858208] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug
[    0.861656] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.864746] PCI host bridge to bus 0000:00
[    0.865675] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
[    0.866989] pci_bus 0000:00: root bus resource [mem 0x00000000-0xffffffffff]
[    0.871061] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
[    0.872068] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
[    0.949295]  pci0000:00: Unable to request _OSC control (_OSC support mask: 0x18)
[    1.558297] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    1.563546] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    1.570707] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    1.576655] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    1.582843] ACPI: PCI Interrupt Link [LNKS] (IRQs 9) *0
[    1.586374] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[    1.588884] vgaarb: loaded
[    1.589714] vgaarb: bridge control possible 0000:00:02.0
[    1.597144] SCSI subsystem initialized
[    1.600542] PCI: Using ACPI for IRQ routing
[    1.606292] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[    1.626553] Switching to clocksource kvm-clock
[    1.895262] pnp: PnP ACPI init
[    1.896376] ACPI: bus type pnp registered
[    1.926511] pnp: PnP ACPI: found 8 devices
[    1.927524] ACPI: ACPI bus type pnp unregistered
[    1.971474] NET: Registered protocol family 2
[    1.973160] IP route cache hash table entries: 4096 (order: 3, 32768 bytes)
[    1.975901] TCP established hash table entries: 16384 (order: 6, 262144 bytes)
[    1.978510] TCP bind hash table entries: 16384 (order: 8, 1310720 bytes)
[    1.981014] TCP: Hash tables configured (established 16384 bind 16384)
[    1.982280] TCP reno registered
[    1.983765] UDP hash table entries: 256 (order: 3, 49152 bytes)
[    1.985783] UDP-Lite hash table entries: 256 (order: 3, 49152 bytes)
[    1.989160] NET: Registered protocol family 1
[    1.990739] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    1.992981] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    1.994737] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    1.997711] Trying to unpack rootfs image as initramfs...
[    2.233326] debug: unmapping init memory ffff88001fa2e000..ffff88001fff0000
[    2.245530] audit: initializing netlink socket (disabled)
[    2.247191] type=2000 audit(1328879438.240:1): initialized
[    2.254089] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[    2.354852] msgmni has been set to 940
[    2.358392] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254)
[    2.361069] io scheduler noop registered (default)
[    2.362417] start plist test
[    2.364468] end plist test
[    2.366458] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[    2.367958] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    2.371062] acpiphp: Slot [1] registered
[    2.373414] acpiphp: Slot [2] registered
[    2.375738] acpiphp: Slot [3] registered
[    2.378232] acpiphp: Slot [4] registered
[    2.380430] acpiphp: Slot [5] registered
[    2.382982] acpiphp: Slot [6] registered
[    2.385529] acpiphp: Slot [7] registered
[    2.394686] acpiphp: Slot [8] registered
[    2.396926] acpiphp: Slot [9] registered
[    2.399437] acpiphp: Slot [10] registered
[    2.402496] acpiphp: Slot [11] registered
[    2.405816] acpiphp: Slot [12] registered
[    2.408017] acpiphp: Slot [13] registered
[    2.410715] acpiphp: Slot [14] registered
[    2.412753] acpiphp: Slot [15] registered
[    2.414808] acpiphp: Slot [16] registered
[    2.416849] acpiphp: Slot [17] registered
[    2.418799] acpiphp: Slot [18] registered
[    2.420801] acpiphp: Slot [19] registered
[    2.422858] acpiphp: Slot [20] registered
[    2.425851] acpiphp: Slot [21] registered
[    2.427757] acpiphp: Slot [22] registered
[    2.429776] acpiphp: Slot [23] registered
[    2.431693] acpiphp: Slot [24] registered
[    2.434041] acpiphp: Slot [25] registered
[    2.436163] acpiphp: Slot [26] registered
[    2.438146] acpiphp: Slot [27] registered
[    2.441263] acpiphp: Slot [28] registered
[    2.443180] acpiphp: Slot [29] registered
[    2.445183] acpiphp: Slot [30] registered
[    2.447125] acpiphp: Slot [31] registered
[    2.638121] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
[    2.645567] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 10
[    2.651847] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
�[    2.932550] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    2.960030] 00:06: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    2.964517] Non-volatile memory driver v1.3
[    2.965508] Linux agpgart interface v0.103
[    3.002429] brd: module loaded
[    3.023044] loop: module loaded
[    3.030536]  vda: vda1 vda2
[    3.046770] scsi0 : ata_piix
[    3.052222] scsi1 : ata_piix
[    3.054620] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc060 irq 14
[    3.055938] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc068 irq 15
[    3.065731] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI
[    3.067108] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    3.069335] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    3.072770] serio: i8042 KBD port at 0x60,0x64 irq 1
[    3.074612] serio: i8042 AUX port at 0x60,0x64 irq 12
[    3.077138] mousedev: PS/2 mouse device common for all mice
[    3.080696] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[    3.086992] device-mapper: ioctl: 4.22.0-ioctl (2011-10-19) initialised: dm-devel@xxxxxxxxxx
[    3.089016] cpuidle: using governor ladder
[    3.089979] cpuidle: using governor menu
[    3.091007] TCP cubic registered
[    3.091920] NET: Registered protocol family 17
[    3.095075] kmemleak: Kernel memory leak detector initialized
[    3.095122] kmemleak: Automatic memory scanning thread started
[    3.213173] ata2.00: ATAPI: QEMU DVD-ROM, 1.0.50, max UDMA/100
[    3.215130] ata2.00: configured for MWDMA2
[    3.218559] scsi 1:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     1.0. PQ: 0 ANSI: 5
[    3.223417] sr0: scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
[    3.224743] cdrom: Uniform CD-ROM driver Revision: 3.20
[    3.232171] Refined TSC clocksource calibration: 2691.272 MHz.
[    3.233667] debug: unmapping init memory ffffffff8167f000..ffffffff818dc000
[    3.235507] Write protecting the kernel read-only data: 6144k
[    3.237158] debug: unmapping init memory ffff880001318000..ffff880001400000
[    3.238618] debug: unmapping init memory ffff8800015a0000..ffff880001600000
modprobe: FATAL: Could not load /lib/modules/3.3.0-rc2+/modules.dep: No such file or directory

[    3.372305] dracut: dracut-004-256.el6
[    3.463437] udev: starting version 147
[    3.465571] udevd (74): /proc/74/oom_adj is deprecated, please use /proc/74/oom_score_adj instead.
[    3.867773] dracut: Starting plymouth daemon
[    4.433636] EXT4-fs (vda1): INFO: recovery required on readonly filesystem
[    4.435071] EXT4-fs (vda1): write access will be enabled during recovery
[    4.514528] EXT4-fs (vda1): recovery complete
[    4.517143] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null)
[    4.539644] dracut: Mounted root filesystem /dev/vda1
modprobe: FATAL: Could not load /lib/modules/3.3.0-rc2+/modules.dep: No such file or directory

[    4.706036] dracut: /sbin/load_policy: Can't load policy: No such device
[    4.902961] dracut: Switching root
     	       Welcome to Fedora 
Starting udev: [    5.302643] udev[224]: starting version 161
[  OK  ]
Setting hostname localhost.localdomain:  [  OK  ]
Checking filesystems
Checking all file systems.
[/sbin/fsck.ext4 (1) -- /] fsck.ext4 -a /dev/vda1 
/dev/vda1: clean, 31463/589824 files, 650384/2359040 blocks
[  OK  ]
Remounting root filesystem in read-write mode:  [    6.881187] EXT4-fs (vda1): re-mounted. Opts: (null)
[  OK  ]
Mounting local filesystems:  [  OK  ]
Enabling local filesystem quotas:  quotaon: Warning: No quota format detected in the kernel.
[  OK  ]
Enabling /etc/fstab swaps:  [    7.498226] Adding 1048572k swap on /dev/vda2.  Priority:-1 extents:1 across:1048572k 
[  OK  ]
Entering non-interactive startup
Starting auditd: [  OK  ]
Starting system logger: [  OK  ]
Starting irqbalance: [  OK  ]
Starting system message bus: [  OK  ]
Starting acpi daemon: [  OK  ]
Retrigger failed udev events[  OK  ]
Starting crond: [  OK  ]
[  OK  ] atd: [  OK  ]

Fedora release 14 (Laughlin)
Kernel 3.3.0-rc2+ on an x86_64 (/dev/ttyS0)

localhost.localdomain login: [   19.927622] PM: Syncing filesystems ... done.
[   19.949462] Freezing user space processes ... (elapsed 0.02 seconds) done.
[   19.973325] PM: Preallocating image memory... done (allocated 36953 pages)
[   20.027658] PM: Allocated 147812 kbytes in 0.05 seconds (2956.24 MB/s)
[   20.028688] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
[   20.051109] PM: freeze of devices complete after 5.348 msecs
[   20.054308] PM: late freeze of devices complete after 1.492 msecs
[   20.056204] ACPI: Preparing to enter system sleep state S4
[   20.058297] PM: Saving platform NVS memory
[   20.059239] Disabling non-boot CPUs ...
[   20.064208] CPU 1 is now offline
[   20.070176] CPU 2 is now offline
[   20.075103] CPU 3 is now offline
[   20.075929] lockdep: fixing up alternatives.
[   20.078259] PM: Creating hibernation image:
[   20.080938] PM: Need to copy 36297 pages
[   20.080938] PM: Hibernation image created (36297 pages copied)
[   20.080938] kvm-clock: cpu 0, msr 0:1f1d19c1, primary cpu clock, resume
[   20.086520] Enabling non-boot CPUs ...
[   20.098149] lockdep: fixing up alternatives.
[   20.098998] Booting Node 0 Processor 1 APIC 0x1
[   20.066584] kvm-clock: cpu 1, msr 0:1f3d19c1, secondary cpu clock
[   20.066584] Calibrating delay loop (skipped) already calibrated this CPU
[   20.140629] CPU1 is up
[   20.142184] lockdep: fixing up alternatives.
[   20.143416] Booting Node 0 Processor 2 APIC 0x2
[   20.072385] kvm-clock: cpu 2, msr 0:1f5d19c1, secondary cpu clock
[   20.072385] Calibrating delay loop (skipped) already calibrated this CPU
[   20.180614] CPU2 is up
[   20.182809] lockdep: fixing up alternatives.
[   20.183847] Booting Node 0 Processor 3 APIC 0x3
[   20.077703] kvm-clock: cpu 3, msr 0:1f7d19c1, secondary cpu clock
[   20.077703] Calibrating delay loop (skipped) already calibrated this CPU
[   20.224597] CPU3 is up
[   20.230960] ACPI: Waking up from system sleep state S4
[   20.233680] PM: early thaw of devices complete after 0.304 msecs
[   20.401644] ata2.00: configured for MWDMA2
[   20.403151] PM: thaw of devices complete after 168.149 msecs
[   20.408851] PM: Using 3 thread(s) for compression.
[   20.408853] PM: Compressing and saving image data (36368 pages) ... done
[   22.576196] PM: Wrote 145472 kbytes in 2.16 seconds (67.34 MB/s)
[   22.579450] PM: S|
[   22.636548] PM: hibernate of devices complete after 2.872 msecs
[   22.638290] PM: late hibernate of devices complete after 0.331 msecs
[   22.639740] ACPI: Preparing to enter system sleep state S4
[   22.641962] PM: Saving platform NVS memory
[   22.642935] Disabling non-boot CPUs ...
[   22.648517] CPU 1 is now offline
[   22.756125] CPU 2 is now offline
[   22.761957] CPU 3 is now offline
[   22.762818] lockdep: fixing up alternatives.


./x86_64-softmmu/qemu-system-x86_64 -kernel ~/src/linux/arch/x86/boot/bzImage  -append 'root=/dev/vda1 console=tty0 console=ttyS0 no_console_suspend' -initrd ~/tmp/initramfs-2.6.32-217.el6.x86_64.img -drive file=/guests/f14-suspend.qcow2,if=none,id=dr0 -device virtio-blk-pci,drive=dr0 -net nic,model=virtio -net user  -serial stdio  -enable-kvm -m 512  -cpu host -smp 4
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 3.3.0-rc2+ (amit@xxxxxxxxxxxxxxx) (gcc version 4.6.2 20111027 (Red Hat 4.6.2-1) (GCC) ) #295 SMP PREEMPT Fri Feb 10 18:39:48 IST 2012
[    0.000000] Command line: root=/dev/vda1 console=tty0 console=ttyS0 no_console_suspend
[    0.000000] BIOS-provided physical RAM map:
[    0.000000]  BIOS-e820: 0000000000000000 - 000000000009dc00 (usable)
[    0.000000]  BIOS-e820: 000000000009dc00 - 00000000000a0000 (reserved)
[    0.000000]  BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
[    0.000000]  BIOS-e820: 0000000000100000 - 000000001fffd000 (usable)
[    0.000000]  BIOS-e820: 000000001fffd000 - 0000000020000000 (reserved)
[    0.000000]  BIOS-e820: 00000000feffc000 - 00000000ff000000 (reserved)
[    0.000000]  BIOS-e820: 00000000fffc0000 - 0000000100000000 (reserved)
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] DMI 2.4 present.
[    0.000000] No AGP bridge found
[    0.000000] last_pfn = 0x1fffd max_arch_pfn = 0x400000000
[    0.000000] x86 PAT enabled: cpu 0, old 0x70406, new 0x7010600070106
[    0.000000] init_memory_mapping: 0000000000000000-000000001fffd000
[    0.000000] RAMDISK: 1fa2e000 - 1fff0000
[    0.000000] ACPI: RSDP 00000000000fd3f0 00014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 000000001fffd660 00034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 000000001fffff80 00074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 000000001fffd9b0 02589 (v01   BXPC   BXDSDT 00000001 INTL 20100528)
[    0.000000] ACPI: FACS 000000001fffff40 00040
[    0.000000] ACPI: SSDT 000000001fffd7e0 001C1 (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: APIC 000000001fffd6e0 0008A (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 000000001fffd6a0 00038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:18509c1, boot clock
[    0.000000] Zone PFN ranges:
[    0.000000]   DMA      0x00000010 -> 0x00001000
[    0.000000]   DMA32    0x00001000 -> 0x00100000
[    0.000000]   Normal   empty
[    0.000000] Movable zone start PFN for each node
[    0.000000] Early memory PFN ranges
[    0.000000]     0: 0x00000010 -> 0x0000009d
[    0.000000]     0: 0x00000100 -> 0x0001fffd
[    0.000000] ACPI: PM-Timer IO Port: 0xb008
[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[    0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
[    0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x02] enabled)
[    0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x03] enabled)
[    0.000000] ACPI: IOAPIC (id[0x04] address[0xfec00000] gsi_base[0])
[    0.000000] IOAPIC[0]: apic_id 4, version 17, address 0xfec00000, GSI 0-23
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.000000] SMP: Allowing 4 CPUs, 0 hotplug CPUs
[    0.000000] PM: Registered nosave memory: 000000000009d000 - 000000000009e000
[    0.000000] PM: Registered nosave memory: 000000000009e000 - 00000000000a0000
[    0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
[    0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
[    0.000000] Allocating PCI resources starting at 20000000 (gap: 20000000:deffc000)
[    0.000000] Booting paravirtualized kernel on KVM
[    0.000000] setup_percpu: NR_CPUS:4 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
[    0.000000] PERCPU: Embedded 474 pages/cpu @ffff88001f000000 s1910784 r8192 d22528 u2097152
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 128901
[    0.000000] Kernel command line: root=/dev/vda1 console=tty0 console=ttyS0 no_console_suspend
[    0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
[    0.000000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.000000] xsave/xrstor: enabled xstate_bv 0x7, cntxt size 0x340
[    0.000000] Checking aperture...
[    0.000000] No AGP bridge found
[    0.000000] Memory: 481644k/524276k available (3162k kernel code, 460k absent, 42172k reserved, 3483k data, 2420k init)
[    0.000000] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] Preemptible hierarchical RCU implementation.
[    0.000000] NR_IRQS:4352 nr_irqs:712 16
[    0.000000] Console: colour VGA+ 80x25
[    0.000000] console [tty0] enabled
[    0.000000] console [ttyS0] enabled
[    0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.000000] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.000000] ... MAX_LOCK_DEPTH:          48
[    0.000000] ... MAX_LOCKDEP_KEYS:        8191
[    0.000000] ... CLASSHASH_SIZE:          4096
[    0.000000] ... MAX_LOCKDEP_ENTRIES:     16384
[    0.000000] ... MAX_LOCKDEP_CHAINS:      32768
[    0.000000] ... CHAINHASH_SIZE:          16384
[    0.000000]  memory used by lock dependency info: 6367 kB
[    0.000000]  per task-struct memory footprint: 2688 bytes
[    0.000000] Detected 2691.258 MHz processor.
[    0.008000] Calibrating delay loop (skipped) preset value.. 5382.51 BogoMIPS (lpj=10765032)
[    0.008000] pid_max: default: 32768 minimum: 301
[    0.012212] Mount-cache hash table entries: 256
[    0.018408] ACPI: Core revision 20120111
[    0.141561] ftrace: allocating 14018 entries in 55 pages
[    0.150614] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.195946] CPU0: Intel(R) Core(TM) i7-2620M CPU @ 2.70GHz stepping 07
[    0.200011] APIC calibration not consistent with PM-Timer: 91ms instead of 100ms
[    0.200011] APIC delta adjusted to PM-Timer: 6249972 (5729866)
[    0.200011] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only.
[    0.220474] lockdep: fixing up alternatives.
[    0.232381] Booting Node   0, Processors  #1
[    0.008000] kvm-clock: cpu 1, msr 0:1f3d19c1, secondary cpu clock
[    0.260131] lockdep: fixing up alternatives.
[    0.261537]  #2
[    0.008000] kvm-clock: cpu 2, msr 0:1f5d19c1, secondary cpu clock
[    0.284158] lockdep: fixing up alternatives.
[    0.285621]  #3 Ok.
[    0.008000] kvm-clock: cpu 3, msr 0:1f7d19c1, secondary cpu clock
[    0.300098] Brought up 4 CPUs
[    0.300948] Total of 4 processors activated (21530.06 BogoMIPS).
[    0.314752] NET: Registered protocol family 16
[    0.318516] ACPI: bus type pci registered
[    0.320059] PCI: Using configuration type 1 for base access
[    0.348760] bio: create slab <bio-0> at 0
[    0.351121] ACPI: Added _OSI(Module Device)
[    0.353139] ACPI: Added _OSI(Processor Device)
[    0.354521] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.356109] ACPI: Added _OSI(Processor Aggregator Device)
[    0.561419] ACPI: Interpreter enabled
[    0.562374] ACPI: (supports S0 S3 S4 S5)
[    0.564868] ACPI: Using IOAPIC for interrupt routing
[    0.859396] ACPI: No dock devices found.
[    0.860059] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug
[    0.862495] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.866923] PCI host bridge to bus 0000:00
[    0.867948] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
[    0.868060] pci_bus 0000:00: root bus resource [mem 0x00000000-0xffffffffff]
[    0.873543] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
[    0.875301] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
[    0.950413]  pci0000:00: Unable to request _OSC control (_OSC support mask: 0x18)
[    1.562832] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    1.567293] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    1.573939] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    1.579086] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    1.584993] ACPI: PCI Interrupt Link [LNKS] (IRQs 9) *0
[    1.591202] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[    1.592213] vgaarb: loaded
[    1.593197] vgaarb: bridge control possible 0000:00:02.0
[    1.600683] SCSI subsystem initialized
[    1.602115] PCI: Using ACPI for IRQ routing
[    1.608286] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[    1.622720] Switching to clocksource kvm-clock
[    1.890639] pnp: PnP ACPI init
[    1.891666] ACPI: bus type pnp registered
[    1.922936] pnp: PnP ACPI: found 8 devices
[    1.923944] ACPI: ACPI bus type pnp unregistered
[    1.968395] NET: Registered protocol family 2
[    1.969976] IP route cache hash table entries: 4096 (order: 3, 32768 bytes)
[    1.973286] TCP established hash table entries: 16384 (order: 6, 262144 bytes)
[    1.976340] TCP bind hash table entries: 16384 (order: 8, 1310720 bytes)
[    1.980266] TCP: Hash tables configured (established 16384 bind 16384)
[    1.982352] TCP reno registered
[    1.983533] UDP hash table entries: 256 (order: 3, 49152 bytes)
[    1.985221] UDP-Lite hash table entries: 256 (order: 3, 49152 bytes)
[    1.987980] NET: Registered protocol family 1
[    1.989836] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    1.991366] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    1.993029] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    1.996522] Trying to unpack rootfs image as initramfs...
[    2.232249] debug: unmapping init memory ffff88001fa2e000..ffff88001fff0000
[    2.245977] audit: initializing netlink socket (disabled)
[    2.247348] type=2000 audit(1328879465.244:1): initialized
[    2.251524] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[    2.351738] msgmni has been set to 940
[    2.355237] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254)
[    2.357442] io scheduler noop registered (default)
[    2.358481] start plist test
[    2.359779] end plist test
[    2.361469] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[    2.362634] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    2.366210] acpiphp: Slot [1] registered
[    2.368727] acpiphp: Slot [2] registered
[    2.370920] acpiphp: Slot [3] registered
[    2.373578] acpiphp: Slot [4] registered
[    2.375487] acpiphp: Slot [5] registered
[    2.377552] acpiphp: Slot [6] registered
[    2.379646] acpiphp: Slot [7] registered
[    2.387397] acpiphp: Slot [8] registered
[    2.390006] acpiphp: Slot [9] registered
[    2.391886] acpiphp: Slot [10] registered
[    2.394514] acpiphp: Slot [11] registered
[    2.396815] acpiphp: Slot [12] registered
[    2.398788] acpiphp: Slot [13] registered
[    2.400736] acpiphp: Slot [14] registered
[    2.402639] acpiphp: Slot [15] registered
[    2.405391] acpiphp: Slot [16] registered
[    2.407292] acpiphp: Slot [17] registered
[    2.409260] acpiphp: Slot [18] registered
[    2.411407] acpiphp: Slot [19] registered
[    2.413523] acpiphp: Slot [20] registered
[    2.415518] acpiphp: Slot [21] registered
[    2.417621] acpiphp: Slot [22] registered
[    2.419568] acpiphp: Slot [23] registered
[    2.422532] acpiphp: Slot [24] registered
[    2.424886] acpiphp: Slot [25] registered
[    2.426863] acpiphp: Slot [26] registered
[    2.428817] acpiphp: Slot [27] registered
[    2.430857] acpiphp: Slot [28] registered
[    2.432838] acpiphp: Slot [29] registered
[    2.434813] acpiphp: Slot [30] registered
[    2.437884] acpiphp: Slot [31] registered
[    2.625069] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
[    2.635091] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 10
[    2.638752] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
�[    2.920580] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    2.947902] 00:06: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    2.952259] Non-volatile memory driver v1.3
[    2.953273] Linux agpgart interface v0.103
[    2.990450] brd: module loaded
[    3.010653] loop: module loaded
[    3.018104]  vda: vda1 vda2
[    3.035013] scsi0 : ata_piix
[    3.040861] scsi1 : ata_piix
[    3.043167] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc060 irq 14
[    3.044520] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc068 irq 15
[    3.053183] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI
[    3.054888] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    3.058466] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    3.063337] serio: i8042 KBD port at 0x60,0x64 irq 1
[    3.065592] serio: i8042 AUX port at 0x60,0x64 irq 12
[    3.068414] mousedev: PS/2 mouse device common for all mice
[    3.073460] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[    3.077951] device-mapper: ioctl: 4.22.0-ioctl (2011-10-19) initialised: dm-devel@xxxxxxxxxx
[    3.080248] cpuidle: using governor ladder
[    3.081293] cpuidle: using governor menu
[    3.082362] TCP cubic registered
[    3.083268] NET: Registered protocol family 17
[    3.087082] kmemleak: Kernel memory leak detector initialized
[    3.087108] kmemleak: Automatic memory scanning thread started
[    3.201317] ata2.00: ATAPI: QEMU DVD-ROM, 1.0.50, max UDMA/100
[    3.204954] ata2.00: configured for MWDMA2
[    3.208856] scsi 1:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     1.0. PQ: 0 ANSI: 5
[    3.213979] sr0: scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
[    3.215259] cdrom: Uniform CD-ROM driver Revision: 3.20
[    3.224212] debug: unmapping init memory ffffffff8167f000..ffffffff818dc000
[    3.226117] Write protecting the kernel read-only data: 6144k
[    3.227745] debug: unmapping init memory ffff880001318000..ffff880001400000
[    3.229802] debug: unmapping init memory ffff8800015a0000..ffff880001600000
[    3.234772] Refined TSC clocksource calibration: 2691.274 MHz.
modprobe: FATAL: Could not load /lib/modules/3.3.0-rc2+/modules.dep: No such file or directory

[    3.376631] dracut: dracut-004-256.el6
[    3.465878] udev: starting version 147
[    3.468440] udevd (74): /proc/74/oom_adj is deprecated, please use /proc/74/oom_score_adj instead.
[    3.787549] dracut: Starting plymouth daemon
[    4.232996] PM: Starting manual resume from disk
[    4.276874] Freezing user space processes ... (elapsed 0.01 seconds) done.
[    4.304223] PM: Using 3 thread(s) for decompression.
[    4.304224] PM: Loading and decompressing image data (36368 pages) ... done
[    6.263529] PM: Read 145472 kbytes in 1.95 seconds (74.60 MB/s)
[    6.277105] PM: quiesce of devices complete after 5.331 msecs
[    6.279903] PM: late quiesce of devices complete after 1.229 msecs
[    6.281790] Disabling non-boot CPUs ...
[    6.286658] CPU 1 is now offline
[    6.392122] CPU 2 is now offline
[    6.397382] CPU 3 is now offline
[    6.397988] lockdep: fixing up alternatives.
[   20.080938] kvm-clock: cpu 0, msr 0:1f1d19c1, primary cpu clock, resume
[   20.080938] PM: Restoring platform NVS memory
[   20.086361] Enabling non-boot CPUs ...
[   20.097892] lockdep: fixing up alternatives.
[   20.099072] Booting Node 0 Processor 1 APIC 0x1
[   20.066584] kvm-clock: cpu 1, msr 0:1f3d19c1, secondary cpu clock
[   20.066584] Calibrating delay loop (skipped) already calibrated this CPU
[   20.140678] CPU1 is up
[   20.142345] lockdep: fixing up alternatives.
[   20.143531] Booting Node 0 Processor 2 APIC 0x2
[   20.072385] kvm-clock: cpu 2, msr 0:1f5d19c1, secondary cpu clock
[   20.072385] Calibrating delay loop (skipped) already calibrated this CPU
[   20.188725] CPU2 is up
[   20.191285] lockdep: fixing up alternatives.
[   20.192714] Booting Node 0 Processor 3 APIC 0x3
[   20.077703] kvm-clock: cpu 3, msr 0:1f7d19c1, secondary cpu clock
[   20.077703] Calibrating delay loop (skipped) already calibrated this CPU
[   20.232565] CPU3 is up
[   20.234208] ACPI: Waking up from system sleep state S4
[   20.236994] PM: early restore of devices complete after 1.341 msecs
[   20.449753] ata2.00: configured for MWDMA2
[   20.451505] PM: restore of devices complete after 164.925 msecs
[   20.454164] Restarting tasks ... done.
[   26.954508] PM: Syncing filesystems ... done.
[   26.962114] Freezing user space processes ... (elapsed 0.01 seconds) done.
[   26.981693] PM: Preallocating image memory... done (allocated 36779 pages)
[   27.031627] PM: Allocated 147116 kbytes in 0.04 seconds (3677.90 MB/s)
[   27.033069] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
[   27.053831] PM: freeze of devices complete after 3.511 msecs
[   27.057025] PM: late freeze of devices complete after 1.345 msecs
[   27.058970] ACPI: Preparing to enter system sleep state S4
[   27.061183] PM: Saving platform NVS memory
[   27.062449] Disabling non-boot CPUs ...
[   27.071546] Broke affinity for irq 1
[   27.172141] CPU 1 is now offline
[   27.280127] CPU 2 is now offline
[   27.285542] CPU 3 is now offline
[   27.286668] lockdep: fixing up alternatives.
[   27.289201] PM: Creating hibernation image:
[   27.292051] PM: Need to copy 36433 pages
[   27.292051] PM: Hibernation image created (36433 pages copied)
[   27.292051] kvm-clock: cpu 0, msr 0:1f1d19c1, primary cpu clock, resume
[   27.297473] Enabling non-boot CPUs ...
[   27.307663] lockdep: fixing up alternatives.
[   27.309283] Booting Node 0 Processor 1 APIC 0x1
[   27.074626] kvm-clock: cpu 1, msr 0:1f3d19c1, secondary cpu clock
[   27.074626] Calibrating delay loop (skipped) already calibrated this CPU
[   27.356732] CPU1 is up
[   27.359102] lockdep: fixing up alternatives.
[   27.360289] Booting Node 0 Processor 2 APIC 0x2
[   27.181025] kvm-clock: cpu 2, msr 0:1f5d19c1, secondary cpu clock
[   27.181025] Calibrating delay loop (skipped) already calibrated this CPU
[   27.404533] CPU2 is up
[   27.406678] lockdep: fixing up alternatives.
[   27.407643] Booting Node 0 Processor 3 APIC 0x3
[   27.288009] kvm-clock: cpu 3, msr 0:1f7d19c1, secondary cpu clock
[   27.288009] Calibrating delay loop (skipped) already calibrated this CPU
[   27.448610] CPU3 is up
[   27.453028] ACPI: Waking up from system sleep state S4
[   27.455146] PM: early thaw of devices complete after 0.398 msecs
[   27.621265] ata2.00: configured for MWDMA2
[   27.623344] PM: thaw of devices complete after 166.397 msecs
[   27.628990] PM: Using 3 thread(s) for compression.
[   27.628991] PM: Compressing and saving image data (36505 pages) ... done
[   29.748964] PM: Wrote 146020 kbytes in 2.11 seconds (69.20 MB/s)
[   29.752724] PM: S|
[   29.809222] PM: hibernate of devices complete after 2.545 msecs
[   29.810821] PM: late hibernate of devices complete after 0.281 msecs
[   29.812158] ACPI: Preparing to enter system sleep state S4
[   29.813841] PM: Saving platform NVS memory
[   29.814814] Disabling non-boot CPUs ...
[   29.920146] CPU 1 is now offline
[   30.028156] CPU 2 is now offline
[   30.033019] Broke affinity for irq 15
[   30.034989] CPU 3 is now offline
[   30.036411] lockdep: fixing up alternatives.



./x86_64-softmmu/qemu-system-x86_64 -kernel ~/src/linux/arch/x86/boot/bzImage  -append 'root=/dev/vda1 console=tty0 console=ttyS0 no_console_suspend' -initrd ~/tmp/initramfs-2.6.32-217.el6.x86_64.img -drive file=/guests/f14-suspend.qcow2,if=none,id=dr0 -device virtio-blk-pci,drive=dr0 -net nic,model=virtio -net user  -serial stdio  -enable-kvm -m 512  -cpu host -smp 4
[    0.000000] Initializing cgroup subsys cpu
[    0.000000] Linux version 3.3.0-rc2+ (amit@xxxxxxxxxxxxxxx) (gcc version 4.6.2 20111027 (Red Hat 4.6.2-1) (GCC) ) #295 SMP PREEMPT Fri Feb 10 18:39:48 IST 2012
[    0.000000] Command line: root=/dev/vda1 console=tty0 console=ttyS0 no_console_suspend
[    0.000000] BIOS-provided physical RAM map:
[    0.000000]  BIOS-e820: 0000000000000000 - 000000000009dc00 (usable)
[    0.000000]  BIOS-e820: 000000000009dc00 - 00000000000a0000 (reserved)
[    0.000000]  BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
[    0.000000]  BIOS-e820: 0000000000100000 - 000000001fffd000 (usable)
[    0.000000]  BIOS-e820: 000000001fffd000 - 0000000020000000 (reserved)
[    0.000000]  BIOS-e820: 00000000feffc000 - 00000000ff000000 (reserved)
[    0.000000]  BIOS-e820: 00000000fffc0000 - 0000000100000000 (reserved)
[    0.000000] NX (Execute Disable) protection: active
[    0.000000] DMI 2.4 present.
[    0.000000] No AGP bridge found
[    0.000000] last_pfn = 0x1fffd max_arch_pfn = 0x400000000
[    0.000000] x86 PAT enabled: cpu 0, old 0x70406, new 0x7010600070106
[    0.000000] init_memory_mapping: 0000000000000000-000000001fffd000
[    0.000000] RAMDISK: 1fa2e000 - 1fff0000
[    0.000000] ACPI: RSDP 00000000000fd3f0 00014 (v00 BOCHS )
[    0.000000] ACPI: RSDT 000000001fffd660 00034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: FACP 000000001fffff80 00074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
[    0.000000] ACPI: DSDT 000000001fffd9b0 02589 (v01   BXPC   BXDSDT 00000001 INTL 20100528)
[    0.000000] ACPI: FACS 000000001fffff40 00040
[    0.000000] ACPI: SSDT 000000001fffd7e0 001C1 (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
[    0.000000] ACPI: APIC 000000001fffd6e0 0008A (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
[    0.000000] ACPI: HPET 000000001fffd6a0 00038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
[    0.000000] kvm-clock: cpu 0, msr 0:18509c1, boot clock
[    0.000000] Zone PFN ranges:
[    0.000000]   DMA      0x00000010 -> 0x00001000
[    0.000000]   DMA32    0x00001000 -> 0x00100000
[    0.000000]   Normal   empty
[    0.000000] Movable zone start PFN for each node
[    0.000000] Early memory PFN ranges
[    0.000000]     0: 0x00000010 -> 0x0000009d
[    0.000000]     0: 0x00000100 -> 0x0001fffd
[    0.000000] ACPI: PM-Timer IO Port: 0xb008
[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[    0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
[    0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x02] enabled)
[    0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x03] enabled)
[    0.000000] ACPI: IOAPIC (id[0x04] address[0xfec00000] gsi_base[0])
[    0.000000] IOAPIC[0]: apic_id 4, version 17, address 0xfec00000, GSI 0-23
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[    0.000000] Using ACPI (MADT) for SMP configuration information
[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[    0.000000] SMP: Allowing 4 CPUs, 0 hotplug CPUs
[    0.000000] PM: Registered nosave memory: 000000000009d000 - 000000000009e000
[    0.000000] PM: Registered nosave memory: 000000000009e000 - 00000000000a0000
[    0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
[    0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
[    0.000000] Allocating PCI resources starting at 20000000 (gap: 20000000:deffc000)
[    0.000000] Booting paravirtualized kernel on KVM
[    0.000000] setup_percpu: NR_CPUS:4 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
[    0.000000] PERCPU: Embedded 474 pages/cpu @ffff88001f000000 s1910784 r8192 d22528 u2097152
[    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 128901
[    0.000000] Kernel command line: root=/dev/vda1 console=tty0 console=ttyS0 no_console_suspend
[    0.000000] PID hash table entries: 2048 (order: 2, 16384 bytes)
[    0.000000] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[    0.000000] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[    0.000000] xsave/xrstor: enabled xstate_bv 0x7, cntxt size 0x340
[    0.000000] Checking aperture...
[    0.000000] No AGP bridge found
[    0.000000] Memory: 481644k/524276k available (3162k kernel code, 460k absent, 42172k reserved, 3483k data, 2420k init)
[    0.000000] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[    0.000000] Preemptible hierarchical RCU implementation.
[    0.000000] NR_IRQS:4352 nr_irqs:712 16
[    0.000000] Console: colour VGA+ 80x25
[    0.000000] console [tty0] enabled
[    0.000000] console [ttyS0] enabled
[    0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.000000] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.000000] ... MAX_LOCK_DEPTH:          48
[    0.000000] ... MAX_LOCKDEP_KEYS:        8191
[    0.000000] ... CLASSHASH_SIZE:          4096
[    0.000000] ... MAX_LOCKDEP_ENTRIES:     16384
[    0.000000] ... MAX_LOCKDEP_CHAINS:      32768
[    0.000000] ... CHAINHASH_SIZE:          16384
[    0.000000]  memory used by lock dependency info: 6367 kB
[    0.000000]  per task-struct memory footprint: 2688 bytes
[    0.000000] Detected 2691.258 MHz processor.
[    0.012000] Calibrating delay loop (skipped) preset value.. 5382.51 BogoMIPS (lpj=10765032)
[    0.012000] pid_max: default: 32768 minimum: 301
[    0.012000] Mount-cache hash table entries: 256
[    0.019120] ACPI: Core revision 20120111
[    0.144778] ftrace: allocating 14018 entries in 55 pages
[    0.153954] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[    0.198922] CPU0: Intel(R) Core(TM) i7-2620M CPU @ 2.70GHz stepping 07
[    0.204012] APIC calibration not consistent with PM-Timer: 92ms instead of 100ms
[    0.204012] APIC delta adjusted to PM-Timer: 6249983 (5750078)
[    0.204012] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only.
[    0.224671] lockdep: fixing up alternatives.
[    0.236366] Booting Node   0, Processors  #1
[    0.012000] kvm-clock: cpu 1, msr 0:1f3d19c1, secondary cpu clock
[    0.264156] lockdep: fixing up alternatives.
[    0.265510]  #2
[    0.012000] kvm-clock: cpu 2, msr 0:1f5d19c1, secondary cpu clock
[    0.288199] lockdep: fixing up alternatives.
[    0.289706]  #3 Ok.
[    0.012000] kvm-clock: cpu 3, msr 0:1f7d19c1, secondary cpu clock
[    0.304090] Brought up 4 CPUs
[    0.305140] Total of 4 processors activated (21530.06 BogoMIPS).
[    0.320274] NET: Registered protocol family 16
[    0.324019] ACPI: bus type pci registered
[    0.324594] PCI: Using configuration type 1 for base access
[    0.353632] bio: create slab <bio-0> at 0
[    0.356647] ACPI: Added _OSI(Module Device)
[    0.358035] ACPI: Added _OSI(Processor Device)
[    0.359445] ACPI: Added _OSI(3.0 _SCP Extensions)
[    0.360842] ACPI: Added _OSI(Processor Aggregator Device)
[    0.565985] ACPI: Interpreter enabled
[    0.567277] ACPI: (supports S0 S3 S4 S5)
[    0.571106] ACPI: Using IOAPIC for interrupt routing
[    0.878052] ACPI: No dock devices found.
[    0.879152] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug
[    0.880511] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[    0.885429] PCI host bridge to bus 0000:00
[    0.886466] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
[    0.887737] pci_bus 0000:00: root bus resource [mem 0x00000000-0xffffffffff]
[    0.892837] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI
[    0.894750] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB
[    0.970335]  pci0000:00: Unable to request _OSC control (_OSC support mask: 0x18)
[    1.583715] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[    1.590390] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[    1.596519] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[    1.602490] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[    1.609401] ACPI: PCI Interrupt Link [LNKS] (IRQs 9) *0
[    1.614133] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[    1.616905] vgaarb: loaded
[    1.617710] vgaarb: bridge control possible 0000:00:02.0
[    1.622992] SCSI subsystem initialized
[    1.625239] PCI: Using ACPI for IRQ routing
[    1.630700] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[    1.654453] Switching to clocksource kvm-clock
[    1.922667] pnp: PnP ACPI init
[    1.923703] ACPI: bus type pnp registered
[    1.954649] pnp: PnP ACPI: found 8 devices
[    1.955665] ACPI: ACPI bus type pnp unregistered
[    1.999911] NET: Registered protocol family 2
[    2.001578] IP route cache hash table entries: 4096 (order: 3, 32768 bytes)
[    2.004869] TCP established hash table entries: 16384 (order: 6, 262144 bytes)
[    2.006856] TCP bind hash table entries: 16384 (order: 8, 1310720 bytes)
[    2.009280] TCP: Hash tables configured (established 16384 bind 16384)
[    2.010583] TCP reno registered
[    2.011458] UDP hash table entries: 256 (order: 3, 49152 bytes)
[    2.013055] UDP-Lite hash table entries: 256 (order: 3, 49152 bytes)
[    2.015547] NET: Registered protocol family 1
[    2.016802] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    2.018184] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[    2.019566] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    2.022396] Trying to unpack rootfs image as initramfs...
[    2.258350] debug: unmapping init memory ffff88001fa2e000..ffff88001fff0000
[    2.271675] audit: initializing netlink socket (disabled)
[    2.273096] type=2000 audit(1328879486.272:1): initialized
[    2.279331] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[    2.377735] msgmni has been set to 940
[    2.381564] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254)
[    2.383252] io scheduler noop registered (default)
[    2.384845] start plist test
[    2.386357] end plist test
[    2.387986] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[    2.389326] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[    2.392128] acpiphp: Slot [1] registered
[    2.394065] acpiphp: Slot [2] registered
[    2.395957] acpiphp: Slot [3] registered
[    2.398352] acpiphp: Slot [4] registered
[    2.400313] acpiphp: Slot [5] registered
[    2.402295] acpiphp: Slot [6] registered
[    2.404291] acpiphp: Slot [7] registered
[    2.412976] acpiphp: Slot [8] registered
[    2.415126] acpiphp: Slot [9] registered
[    2.417209] acpiphp: Slot [10] registered
[    2.419484] acpiphp: Slot [11] registered
[    2.421641] acpiphp: Slot [12] registered
[    2.423644] acpiphp: Slot [13] registered
[    2.425771] acpiphp: Slot [14] registered
[    2.427717] acpiphp: Slot [15] registered
[    2.430512] acpiphp: Slot [16] registered
[    2.432502] acpiphp: Slot [17] registered
[    2.434420] acpiphp: Slot [18] registered
[    2.436616] acpiphp: Slot [19] registered
[    2.438625] acpiphp: Slot [20] registered
[    2.440626] acpiphp: Slot [21] registered
[    2.442586] acpiphp: Slot [22] registered
[    2.445915] acpiphp: Slot [23] registered
[    2.447828] acpiphp: Slot [24] registered
[    2.449849] acpiphp: Slot [25] registered
[    2.451754] acpiphp: Slot [26] registered
[    2.453822] acpiphp: Slot [27] registered
[    2.455815] acpiphp: Slot [28] registered
[    2.457862] acpiphp: Slot [29] registered
[    2.459817] acpiphp: Slot [30] registered
[    2.463363] acpiphp: Slot [31] registered
[    2.652004] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
[    2.662122] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 10
[    2.665594] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
�[    2.944554] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    2.972203] 00:06: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[    2.976490] Non-volatile memory driver v1.3
[    2.977506] Linux agpgart interface v0.103
[    3.014141] brd: module loaded
[    3.033693] loop: module loaded
[    3.041319]  vda: vda1 vda2
[    3.059399] scsi0 : ata_piix
[    3.065431] scsi1 : ata_piix
[    3.068000] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc060 irq 14
[    3.070550] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc068 irq 15
[    3.081620] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI
[    3.083229] e1000: Copyright (c) 1999-2006 Intel Corporation.
[    3.086006] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    3.089426] serio: i8042 KBD port at 0x60,0x64 irq 1
[    3.091309] serio: i8042 AUX port at 0x60,0x64 irq 12
[    3.093860] mousedev: PS/2 mouse device common for all mice
[    3.097682] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
[    3.107859] device-mapper: ioctl: 4.22.0-ioctl (2011-10-19) initialised: dm-devel@xxxxxxxxxx
[    3.110152] cpuidle: using governor ladder
[    3.111213] cpuidle: using governor menu
[    3.112544] TCP cubic registered
[    3.113505] NET: Registered protocol family 17
[    3.116525] kmemleak: Kernel memory leak detector initialized
[    3.116550] kmemleak: Automatic memory scanning thread started
[    3.229160] ata2.00: ATAPI: QEMU DVD-ROM, 1.0.50, max UDMA/100
[    3.230765] ata2.00: configured for MWDMA2
[    3.234229] scsi 1:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     1.0. PQ: 0 ANSI: 5
[    3.240337] sr0: scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
[    3.241736] cdrom: Uniform CD-ROM driver Revision: 3.20
[    3.250342] debug: unmapping init memory ffffffff8167f000..ffffffff818dc000
[    3.252205] Write protecting the kernel read-only data: 6144k
[    3.254771] debug: unmapping init memory ffff880001318000..ffff880001400000
[    3.257081] debug: unmapping init memory ffff8800015a0000..ffff880001600000
[    3.260140] Refined TSC clocksource calibration: 2691.271 MHz.
modprobe: FATAL: Could not load /lib/modules/3.3.0-rc2+/modules.dep: No such file or directory

[    3.398866] dracut: dracut-004-256.el6
[    3.490652] udev: starting version 147
[    3.492541] udevd (74): /proc/74/oom_adj is deprecated, please use /proc/74/oom_score_adj instead.
[    3.810111] dracut: Starting plymouth daemon
[    4.288856] PM: Starting manual resume from disk
[    4.326388] Freezing user space processes ... (elapsed 0.02 seconds) done.
[    4.363688] PM: Using 3 thread(s) for decompression.
[    4.363689] PM: Loading and decompressing image data (36505 pages) ... done
[    6.317330] PM: Read 146020 kbytes in 1.94 seconds (75.26 MB/s)
[    6.331360] PM: quiesce of devices complete after 5.255 msecs
[    6.333865] PM: late quiesce of devices complete after 1.067 msecs
[    6.335089] Disabling non-boot CPUs ...
[    6.340486] CPU 1 is now offline
[    6.448137] CPU 2 is now offline
[    6.556109] CPU 3 is now offline
[    6.557140] lockdep: fixing up alternatives.
[   27.292051] kvm-clock: cpu 0, msr 0:1f1d19c1, primary cpu clock, resume
[   27.292051] PM: Restoring platform NVS memory
[   27.292051] Enabling non-boot CPUs ...
qemu: terminating on signal 2


		Amit
--
To unsubscribe from this list: send the line "unsubscribe kvm" in
the body of a message to majordomo@xxxxxxxxxxxxxxx
More majordomo info at  http://vger.kernel.org/majordomo-info.html


[Index of Archives]     [KVM ARM]     [KVM ia64]     [KVM ppc]     [Virtualization Tools]     [Spice Development]     [Libvirt]     [Libvirt Users]     [Linux USB Devel]     [Linux Audio Users]     [Yosemite Questions]     [Linux Kernel]     [Linux SCSI]     [XFree86]
  Powered by Linux