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+ (a...@amit.redhat.com) (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-de...@redhat.com
[ 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+ (a...@amit.redhat.com) (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-de...@redhat.com
[ 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+ (a...@amit.redhat.com) (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-de...@redhat.com
[ 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 majord...@vger.kernel.org
More majordomo info at http://vger.kernel.org/majordomo-info.html
