* s2disk failed, 2nd attempt worked
@ 2013-05-10 14:00 Toralf Förster
2013-05-10 20:33 ` Rafael J. Wysocki
0 siblings, 1 reply; 2+ messages in thread
From: Toralf Förster @ 2013-05-10 14:00 UTC (permalink / raw)
To: Linux PM list
At a stable 32 bit Gentoo w/ kernel 3.9.1 I need yesterday 2 attempts to s2disk the system.
The first s2disk failed with the error msg :
echo: write error: Cannot allocate memory
at this line of my hibernation script :
echo $1 > /sys/power/state
2013-05-09T22:49:31.000+02:00 n22 sudo: tfoerste : TTY=pts/2 ; PWD=/home/tfoerste ; USER=root ; COMMAND=/home/tfoerste/workspace/acpi/default.sh ibm/hotkey HKEY 00000080 0000100c
2013-05-09T22:49:31.000+02:00 n22 sudo: pam_unix(sudo:session): session opened for user root by tfoerste(uid=0)
2013-05-09T22:49:32.000+02:00 n22 su[27780]: Successful su for boinc by root
2013-05-09T22:49:32.000+02:00 n22 su[27780]: + /dev/pts/2 root:boinc
2013-05-09T22:49:32.000+02:00 n22 su[27780]: pam_unix(su:session): session opened for user boinc by tfoerste(uid=0)
2013-05-09T22:49:32.000+02:00 n22 su[27780]: pam_unix(su:session): session closed for user boinc
2013-05-09T22:49:36.000+02:00 n22 pppd[5159]: Terminating on signal 15
2013-05-09T22:49:36.000+02:00 n22 pppd[5159]: Connect time 465.1 minutes.
2013-05-09T22:49:36.000+02:00 n22 pppd[5159]: Sent 2701783 bytes, received 27205393 bytes.
2013-05-09T22:49:36.000+02:00 n22 pppd[5159]: Connection terminated.
2013-05-09T22:49:36.000+02:00 n22 /etc/init.d/net.ppp0[27911]: status: stopping
2013-05-09T22:49:36.000+02:00 n22 pppd[5159]: Exit.
2013-05-09T22:49:37.327+02:00 n22 kernel: PM: Marking nosave pages: [mem 0x0009d000-0x000fffff]
2013-05-09T22:49:37.327+02:00 n22 kernel: PM: Marking nosave pages: [mem 0x20000000-0x201fffff]
2013-05-09T22:49:37.327+02:00 n22 kernel: PM: Basic memory bitmaps created
2013-05-09T22:49:42.951+02:00 n22 kernel: PM: Syncing filesystems ... done.
2013-05-09T22:49:42.951+02:00 n22 kernel: Freezing user space processes ... (elapsed 0.01 seconds) done.
2013-05-09T22:49:42.951+02:00 n22 kernel: PM: Preallocating image memory... done (allocated 721313 pages)
2013-05-09T22:49:42.951+02:00 n22 kernel: PM: Allocated 2885252 kbytes in 0.95 seconds (3037.10 MB/s)
2013-05-09T22:49:42.951+02:00 n22 kernel: Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
2013-05-09T22:49:42.951+02:00 n22 kernel: Suspending console(s) (use no_console_suspend to debug)
2013-05-09T22:49:42.951+02:00 n22 kernel: kthreadd: page allocation failure: order:1, mode:0x300010
2013-05-09T22:49:42.951+02:00 n22 kernel: Pid: 2, comm: kthreadd Not tainted 3.9.1 #8
2013-05-09T22:49:42.951+02:00 n22 kernel: Call Trace:
2013-05-09T22:49:42.951+02:00 n22 kernel: [<c10d9c5f>] warn_alloc_failed+0xbf/0x100
2013-05-09T22:49:43.728+02:00 n22 kernel: [<c10dc70b>] __alloc_pages_nodemask+0x5cb/0x7d0
2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1032ba3>] copy_process+0x103/0x10c0
2013-05-09T22:49:43.728+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.728+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1033c3e>] do_fork+0x9e/0x2b0
2013-05-09T22:49:43.728+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1033e7d>] kernel_thread+0x2d/0x40
2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1054cb8>] kthreadd+0xd8/0x110
2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1487477>] ret_from_kernel_thread+0x1b/0x28
2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1054be0>] ? kthread_create_on_cpu+0x60/0x60
2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: Deleting interface #3 ppp0, 80.171.222.206#123, interface stats: received=296, sent=296, dropped=0, active_time=27884 secs
2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: 178.254.20.157 interface 80.171.222.206 -> (none)
2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: 213.239.204.119 interface 80.171.222.206 -> (none)
2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: 46.165.212.204 interface 80.171.222.206 -> (none)
2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: 195.50.171.101 interface 80.171.222.206 -> (none)
2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: peers refreshed
2013-05-09T22:49:43.729+02:00 n22 kernel: Mem-Info:
2013-05-09T22:49:43.729+02:00 n22 kernel: DMA per-cpu:
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 0: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 1: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 2: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 3: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.729+02:00 n22 kernel: Normal per-cpu:
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 0: hi: 186, btch: 31 usd: 107
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 1: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 2: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 3: hi: 186, btch: 31 usd: 30
2013-05-09T22:49:43.729+02:00 n22 kernel: HighMem per-cpu:
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 0: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 1: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 2: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.729+02:00 n22 kernel: CPU 3: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.729+02:00 n22 kernel: active_anon:72360 inactive_anon:72399 isolated_anon:0
2013-05-09T22:49:43.729+02:00 n22 kernel: active_file:22347 inactive_file:5125 isolated_file:0
2013-05-09T22:49:43.729+02:00 n22 kernel: unevictable:0 dirty:2 writeback:0 unstable:0
2013-05-09T22:49:43.729+02:00 n22 kernel: free:1131669 slab_reclaimable:4534 slab_unreclaimable:5614
2013-05-09T22:49:43.730+02:00 n22 kernel: mapped:17714 shmem:96025 pagetables:1619 bounce:0
2013-05-09T22:49:43.730+02:00 n22 kernel: free_cma:0
2013-05-09T22:49:43.730+02:00 n22 kernel: DMA free:3868kB min:760kB low:948kB high:1140kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15984kB managed:15360kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:16kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? yes
2013-05-09T22:49:43.730+02:00 n22 kernel: lowmem_reserve[]: 0 779 7964 7964
2013-05-09T22:49:43.730+02:00 n22 kernel: Normal free:41632kB min:39628kB low:49532kB high:59440kB active_anon:0kB inactive_anon:0kB active_file:208kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:894968kB managed:797924kB mlocked:0kB dirty:0kB writeback:0kB mapped:8kB shmem:0kB slab_reclaimable:18136kB slab_unreclaimable:22440kB kernel_stack:2632kB pagetables:6476kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:43 all_unreclaimable? no
2013-05-09T22:49:43.730+02:00 n22 kernel: lowmem_reserve[]: 0 0 57485 57485
2013-05-09T22:49:43.730+02:00 n22 kernel: HighMem free:4481176kB min:512kB low:91872kB high:183232kB active_anon:289440kB inactive_anon:289596kB active_file:89180kB inactive_file:20500kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:7358088kB managed:7358088kB mlocked:0kB dirty:8kB writeback:0kB mapped:70848kB shmem:384100kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:64 all_unreclaimable? no
2013-05-09T22:49:43.730+02:00 n22 kernel: lowmem_reserve[]: 0 0 0 0
2013-05-09T22:49:43.730+02:00 n22 kernel: DMA: 1*4kB (R) 1*8kB (R) 1*16kB (R) 0*32kB 0*64kB 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 1*2048kB (R) 0*4096kB = 3868kB
2013-05-09T22:49:43.730+02:00 n22 kernel: Normal: 7464*4kB (UEM) 332*8kB (UEM) 56*16kB (UE) 6*32kB (E) 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 2*4096kB (R) = 41792kB
2013-05-09T22:49:43.731+02:00 n22 kernel: HighMem: 32646*4kB (UEM) 27911*8kB (UEM) 25180*16kB (UEM) 16711*32kB (UEM) 9814*64kB (UEM) 4119*128kB (UEM) 2162*256kB (UEM) 1165*512kB (UEM) 718*1024kB (M) 49*2048kB (M) 12*4096kB (MR) = 4481520kB
2013-05-09T22:49:43.731+02:00 n22 kernel: 123466 total pagecache pages
2013-05-09T22:49:43.731+02:00 n22 kernel: 0 pages in swap cache
2013-05-09T22:49:43.731+02:00 n22 kernel: Swap cache stats: add 0, delete 0, find 0/0
2013-05-09T22:49:43.731+02:00 n22 kernel: Free swap = 9767516kB
2013-05-09T22:49:43.731+02:00 n22 kernel: Total swap = 9767516kB
2013-05-09T22:49:43.731+02:00 n22 kernel: 2221567 pages RAM
2013-05-09T22:49:43.731+02:00 n22 kernel: 1993218 pages HighMem
2013-05-09T22:49:43.731+02:00 n22 kernel: 178200 pages reserved
2013-05-09T22:49:43.731+02:00 n22 kernel: 390846 pages shared
2013-05-09T22:49:43.732+02:00 n22 kernel: 857380 pages non-shared
2013-05-09T22:49:43.732+02:00 n22 kernel: kthreadd: page allocation failure: order:1, mode:0x300010
2013-05-09T22:49:43.732+02:00 n22 kernel: Pid: 2, comm: kthreadd Not tainted 3.9.1 #8
2013-05-09T22:49:43.732+02:00 n22 kernel: Call Trace:
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c10d9c5f>] warn_alloc_failed+0xbf/0x100
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c10dc70b>] __alloc_pages_nodemask+0x5cb/0x7d0
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c1032ba3>] copy_process+0x103/0x10c0
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c1033c3e>] do_fork+0x9e/0x2b0
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c1063690>] ? default_wake_function+0x10/0x20
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c1033e7d>] kernel_thread+0x2d/0x40
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c1054cb8>] kthreadd+0xd8/0x110
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c1487477>] ret_from_kernel_thread+0x1b/0x28
2013-05-09T22:49:43.732+02:00 n22 kernel: [<c1054be0>] ? kthread_create_on_cpu+0x60/0x60
2013-05-09T22:49:43.732+02:00 n22 kernel: Mem-Info:
2013-05-09T22:49:43.732+02:00 n22 kernel: DMA per-cpu:
2013-05-09T22:49:43.732+02:00 n22 kernel: CPU 0: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.732+02:00 n22 kernel: CPU 1: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.733+02:00 n22 kernel: CPU 2: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.733+02:00 n22 kernel: CPU 3: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.733+02:00 n22 kernel: Normal per-cpu:
2013-05-09T22:49:43.733+02:00 n22 kernel: CPU 0: hi: 186, btch: 31 usd: 107
2013-05-09T22:49:43.733+02:00 n22 kernel: CPU 1: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.733+02:00 n22 kernel: CPU 2: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.733+02:00 n22 kernel: CPU 3: hi: 186, btch: 31 usd: 30
2013-05-09T22:49:43.733+02:00 n22 kernel: HighMem per-cpu:
2013-05-09T22:49:43.733+02:00 n22 kernel: CPU 0: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.733+02:00 n22 kernel: CPU 1: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.734+02:00 n22 kernel: CPU 2: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.734+02:00 n22 kernel: CPU 3: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.734+02:00 n22 kernel: active_anon:72328 inactive_anon:72431 isolated_anon:0
2013-05-09T22:49:43.734+02:00 n22 kernel: active_file:22338 inactive_file:5137 isolated_file:0
2013-05-09T22:49:43.734+02:00 n22 kernel: unevictable:0 dirty:2 writeback:0 unstable:0
2013-05-09T22:49:43.734+02:00 n22 kernel: free:1131737 slab_reclaimable:4516 slab_unreclaimable:5614
2013-05-09T22:49:43.734+02:00 n22 kernel: mapped:17714 shmem:96025 pagetables:1619 bounce:0
2013-05-09T22:49:43.734+02:00 n22 kernel: free_cma:0
2013-05-09T22:49:43.734+02:00 n22 kernel: DMA free:3868kB min:760kB low:948kB high:1140kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15984kB managed:15360kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:16kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? yes
2013-05-09T22:49:43.734+02:00 n22 kernel: lowmem_reserve[]: 0 779 7964 7964
2013-05-09T22:49:43.734+02:00 n22 kernel: Normal free:41720kB min:39628kB low:49532kB high:59440kB active_anon:0kB inactive_anon:0kB active_file:172kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:894968kB managed:797924kB mlocked:0kB dirty:0kB writeback:0kB mapped:8kB shmem:0kB slab_reclaimable:18064kB slab_unreclaimable:22440kB kernel_stack:2632kB pagetables:6476kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:86 all_unreclaimable? no
2013-05-09T22:49:43.734+02:00 n22 kernel: lowmem_reserve[]: 0 0 57485 57485
2013-05-09T22:49:43.734+02:00 n22 kernel: HighMem free:4481360kB min:512kB low:91872kB high:183232kB active_anon:289312kB inactive_anon:289724kB active_file:89180kB inactive_file:20548kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:7358088kB managed:7358088kB mlocked:0kB dirty:8kB writeback:0kB mapped:70848kB shmem:384100kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:64 all_unreclaimable? no
2013-05-09T22:49:43.734+02:00 n22 kernel: lowmem_reserve[]: 0 0 0 0
2013-05-09T22:49:43.734+02:00 n22 kernel: DMA: 1*4kB (R) 1*8kB (R) 1*16kB (R) 0*32kB 0*64kB 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 1*2048kB (R) 0*4096kB = 3868kB
2013-05-09T22:49:43.734+02:00 n22 kernel: Normal: 7464*4kB (UEM) 332*8kB (UEM) 56*16kB (UE) 6*32kB (E) 0*64kB 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 2*4096kB (R) = 41792kB
2013-05-09T22:49:43.734+02:00 n22 kernel: HighMem: 32646*4kB (UEM) 27911*8kB (UEM) 25180*16kB (UEM) 16711*32kB (UEM) 9814*64kB (UEM) 4119*128kB (UEM) 2162*256kB (UEM) 1165*512kB (UEM) 718*1024kB (M) 49*2048kB (M) 12*4096kB (MR) = 4481520kB
2013-05-09T22:49:43.734+02:00 n22 kernel: 123453 total pagecache pages
2013-05-09T22:49:43.734+02:00 n22 kernel: 0 pages in swap cache
2013-05-09T22:49:43.734+02:00 n22 kernel: Swap cache stats: add 0, delete 0, find 0/0
2013-05-09T22:49:43.734+02:00 n22 kernel: Free swap = 9767516kB
2013-05-09T22:49:43.734+02:00 n22 kernel: Total swap = 9767516kB
2013-05-09T22:49:43.734+02:00 n22 kernel: 2221567 pages RAM
2013-05-09T22:49:43.734+02:00 n22 kernel: 1993218 pages HighMem
2013-05-09T22:49:43.734+02:00 n22 kernel: 178200 pages reserved
2013-05-09T22:49:43.734+02:00 n22 kernel: 390746 pages shared
2013-05-09T22:49:43.734+02:00 n22 kernel: 857380 pages non-shared
2013-05-09T22:49:43.734+02:00 n22 kernel: PM: freeze of devices complete after 348.276 msecs
2013-05-09T22:49:43.734+02:00 n22 kernel: PM: late freeze of devices complete after 0.288 msecs
2013-05-09T22:49:43.734+02:00 n22 kernel: PM: noirq freeze of devices complete after 0.944 msecs
2013-05-09T22:49:43.735+02:00 n22 kernel: ACPI: Preparing to enter system sleep state S4
2013-05-09T22:49:43.735+02:00 n22 kernel: PM: Saving platform NVS memory
2013-05-09T22:49:43.735+02:00 n22 kernel: Disabling non-boot CPUs ...
2013-05-09T22:49:43.735+02:00 n22 kernel: smpboot: CPU 1 is now offline
2013-05-09T22:49:43.735+02:00 n22 kernel: smpboot: CPU 2 is now offline
2013-05-09T22:49:43.735+02:00 n22 kernel: smpboot: CPU 3 is now offline
2013-05-09T22:49:43.735+02:00 n22 kernel: PM: Creating hibernation image:
2013-05-09T22:49:43.735+02:00 n22 kernel: PM: Need to copy 212964 pages
2013-05-09T22:49:43.735+02:00 n22 kernel: PM: Normal pages needed: 37997 + 1024, available pages: 189599
2013-05-09T22:49:43.735+02:00 n22 kernel: PM: Hibernation image created (212964 pages copied)
2013-05-09T22:49:43.736+02:00 n22 kernel: Enabling non-boot CPUs ...
2013-05-09T22:49:43.736+02:00 n22 kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1
2013-05-09T22:49:43.736+02:00 n22 kernel: Initializing CPU#1
2013-05-09T22:49:43.736+02:00 n22 kernel: Disabled fast string operations
2013-05-09T22:49:43.736+02:00 n22 kernel: ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20130117/evregion-286)
2013-05-09T22:49:43.736+02:00 n22 kernel: ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node f202a438), AE_BAD_PARAMETER (20130117/psparse-537)
2013-05-09T22:49:43.736+02:00 n22 kernel: ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node f2060438), AE_BAD_PARAMETER (20130117/psparse-537)
2013-05-09T22:49:43.736+02:00 n22 kernel: ACPI Error: Method parse/execution failed [\_PR_.CPU1._PPC] (Node f2060930), AE_BAD_PARAMETER (20130117/psparse-537)
2013-05-09T22:49:43.736+02:00 n22 kernel: ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20130117/processor_perflib-140)
2013-05-09T22:49:43.736+02:00 n22 kernel: CPU1 is up
2013-05-09T22:49:43.736+02:00 n22 kernel: smpboot: Booting Node 0 Processor 2 APIC 0x2
2013-05-09T22:49:43.736+02:00 n22 kernel: Initializing CPU#2
2013-05-09T22:49:43.736+02:00 n22 kernel: Disabled fast string operations
2013-05-09T22:49:43.736+02:00 n22 kernel: ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20130117/evregion-286)
2013-05-09T22:49:43.736+02:00 n22 kernel: ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node f202a438), AE_BAD_PARAMETER (20130117/psparse-537)
2013-05-09T22:49:43.736+02:00 n22 kernel: ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node f2060438), AE_BAD_PARAMETER (20130117/psparse-537)
2013-05-09T22:49:43.736+02:00 n22 kernel: ACPI Error: Method parse/execution failed [\_PR_.CPU2._PPC] (Node f2060b70), AE_BAD_PARAMETER (20130117/psparse-537)
2013-05-09T22:49:43.736+02:00 n22 kernel: ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20130117/processor_perflib-140)
2013-05-09T22:49:43.736+02:00 n22 kernel: CPU2 is up
2013-05-09T22:49:43.736+02:00 n22 kernel: smpboot: Booting Node 0 Processor 3 APIC 0x3
2013-05-09T22:49:43.737+02:00 n22 kernel: Initializing CPU#3
2013-05-09T22:49:43.737+02:00 n22 kernel: Disabled fast string operations
2013-05-09T22:49:43.737+02:00 n22 kernel: ACPI Exception: AE_BAD_PARAMETER, Returned by Handler for [EmbeddedControl] (20130117/evregion-286)
2013-05-09T22:49:43.737+02:00 n22 kernel: ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC_.EC__.LPMD] (Node f202a438), AE_BAD_PARAMETER (20130117/psparse-537)
2013-05-09T22:49:43.737+02:00 n22 kernel: ACPI Error: Method parse/execution failed [\_PR_.CPU0._PPC] (Node f2060438), AE_BAD_PARAMETER (20130117/psparse-537)
2013-05-09T22:49:43.737+02:00 n22 kernel: ACPI Error: Method parse/execution failed [\_PR_.CPU3._PPC] (Node f2060b10), AE_BAD_PARAMETER (20130117/psparse-537)
2013-05-09T22:49:43.737+02:00 n22 kernel: ACPI Exception: AE_BAD_PARAMETER, Evaluating _PPC (20130117/processor_perflib-140)
2013-05-09T22:49:43.737+02:00 n22 kernel: CPU3 is up
2013-05-09T22:49:43.737+02:00 n22 kernel: ACPI: Waking up from system sleep state S4
2013-05-09T22:49:43.737+02:00 n22 kernel: thinkpad_acpi: EC reports that Thermal Table has changed
2013-05-09T22:49:43.738+02:00 n22 kernel: PM: noirq thaw of devices complete after 0.138 msecs
2013-05-09T22:49:43.738+02:00 n22 kernel: PM: early thaw of devices complete after 0.054 msecs
2013-05-09T22:49:43.738+02:00 n22 kernel: [drm] Wrong MCH_SSKPD value: 0x16040307
2013-05-09T22:49:43.738+02:00 n22 kernel: [drm] This can cause pipe underruns and display issues.
2013-05-09T22:49:43.738+02:00 n22 kernel: [drm] Please upgrade your BIOS to fix this.
2013-05-09T22:49:43.738+02:00 n22 kernel: e1000e 0000:00:19.0: setting latency timer to 64
2013-05-09T22:49:43.738+02:00 n22 kernel: e1000e 0000:00:19.0: irq 41 for MSI/MSI-X
2013-05-09T22:49:43.738+02:00 n22 kernel: snd_hda_intel 0000:00:1b.0: irq 43 for MSI/MSI-X
2013-05-09T22:49:43.738+02:00 n22 kernel: ahci 0000:00:1f.2: setting latency timer to 64
2013-05-09T22:49:43.738+02:00 n22 kernel: ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
2013-05-09T22:49:43.738+02:00 n22 kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
2013-05-09T22:49:43.738+02:00 n22 kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
2013-05-09T22:49:43.738+02:00 n22 kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
2013-05-09T22:49:43.738+02:00 n22 kernel: ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
2013-05-09T22:49:43.738+02:00 n22 kernel: ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
2013-05-09T22:49:43.738+02:00 n22 kernel: ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
2013-05-09T22:49:43.738+02:00 n22 kernel: ata1.00: configured for UDMA/100
2013-05-09T22:49:43.738+02:00 n22 kernel: kthreadd: page allocation failure: order:1, mode:0x300010
2013-05-09T22:49:43.738+02:00 n22 kernel: Pid: 2, comm: kthreadd Not tainted 3.9.1 #8
2013-05-09T22:49:43.738+02:00 n22 kernel: Call Trace:
2013-05-09T22:49:43.739+02:00 n22 kernel: [<c10d9c5f>] warn_alloc_failed+0xbf/0x100
2013-05-09T22:49:43.739+02:00 n22 kernel: [<c10dc70b>] __alloc_pages_nodemask+0x5cb/0x7d0
2013-05-09T22:49:43.739+02:00 n22 kernel: [<c1032ba3>] copy_process+0x103/0x10c0
2013-05-09T22:49:43.739+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.739+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.739+02:00 n22 kernel: [<c1033c3e>] do_fork+0x9e/0x2b0
2013-05-09T22:49:43.739+02:00 n22 kernel: [<c1063690>] ? default_wake_function+0x10/0x20
2013-05-09T22:49:43.739+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.739+02:00 n22 kernel: [<c1033e7d>] kernel_thread+0x2d/0x40
2013-05-09T22:49:43.739+02:00 n22 kernel: [<c1054cb8>] kthreadd+0xd8/0x110
2013-05-09T22:49:43.740+02:00 n22 kernel: [<c1487477>] ret_from_kernel_thread+0x1b/0x28
2013-05-09T22:49:43.740+02:00 n22 kernel: [<c1054be0>] ? kthread_create_on_cpu+0x60/0x60
2013-05-09T22:49:43.740+02:00 n22 kernel: Mem-Info:
2013-05-09T22:49:43.740+02:00 n22 kernel: DMA per-cpu:
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 0: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 1: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 2: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 3: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.740+02:00 n22 kernel: Normal per-cpu:
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 0: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 1: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 2: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 3: hi: 186, btch: 31 usd: 13
2013-05-09T22:49:43.740+02:00 n22 kernel: HighMem per-cpu:
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 0: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 1: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 2: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.740+02:00 n22 kernel: CPU 3: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.740+02:00 n22 kernel: active_anon:72359 inactive_anon:72379 isolated_anon:0
2013-05-09T22:49:43.740+02:00 n22 kernel: active_file:22308 inactive_file:5133 isolated_file:0
2013-05-09T22:49:43.741+02:00 n22 kernel: unevictable:0 dirty:2 writeback:0 unstable:0
2013-05-09T22:49:43.741+02:00 n22 kernel: free:1132892 slab_reclaimable:4114 slab_unreclaimable:5347
2013-05-09T22:49:43.741+02:00 n22 kernel: mapped:17714 shmem:96000 pagetables:1619 bounce:0
2013-05-09T22:49:43.741+02:00 n22 kernel: free_cma:0
2013-05-09T22:49:43.741+02:00 n22 kernel: DMA free:3868kB min:760kB low:948kB high:1140kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15984kB managed:15360kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:16kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? yes
2013-05-09T22:49:43.741+02:00 n22 kernel: lowmem_reserve[]: 0 779 7964 7964
2013-05-09T22:49:43.741+02:00 n22 kernel: Normal free:46288kB min:39628kB low:49532kB high:59440kB active_anon:0kB inactive_anon:0kB active_file:172kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:894968kB managed:797924kB mlocked:0kB dirty:0kB writeback:0kB mapped:8kB shmem:0kB slab_reclaimable:16456kB slab_unreclaimable:21372kB kernel_stack:2632kB pagetables:6476kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:29 all_unreclaimable? no
2013-05-09T22:49:43.741+02:00 n22 kernel: lowmem_reserve[]: 0 0 57485 57485
2013-05-09T22:49:43.741+02:00 n22 kernel: HighMem free:4481412kB min:512kB low:91872kB high:183232kB active_anon:289436kB inactive_anon:289516kB active_file:89060kB inactive_file:20532kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:7358088kB managed:7358088kB mlocked:0kB dirty:8kB writeback:0kB mapped:70848kB shmem:384000kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
2013-05-09T22:49:43.741+02:00 n22 kernel: lowmem_reserve[]: 0 0 0 0
2013-05-09T22:49:43.742+02:00 n22 kernel: DMA: 1*4kB (R) 1*8kB (R) 1*16kB (R) 0*32kB 0*64kB 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 1*2048kB (R) 0*4096kB = 3868kB
2013-05-09T22:49:43.742+02:00 n22 kernel: Normal: 7726*4kB (UEM) 533*8kB (UEM) 111*16kB (UEM) 34*32kB (UE) 3*64kB (U) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 2*4096kB (R) = 46416kB
2013-05-09T22:49:43.742+02:00 n22 kernel: HighMem: 32546*4kB (UEM) 27911*8kB (UEM) 25181*16kB (UEM) 16711*32kB (UEM) 9814*64kB (UEM) 4120*128kB (UEM) 2163*256kB (UEM) 1165*512kB (UEM) 718*1024kB (M) 49*2048kB (M) 12*4096kB (MR) = 4481520kB
2013-05-09T22:49:43.742+02:00 n22 kernel: 123373 total pagecache pages
2013-05-09T22:49:43.742+02:00 n22 kernel: 0 pages in swap cache
2013-05-09T22:49:43.742+02:00 n22 kernel: Swap cache stats: add 0, delete 0, find 0/0
2013-05-09T22:49:43.742+02:00 n22 kernel: Free swap = 9767516kB
2013-05-09T22:49:43.742+02:00 n22 kernel: Total swap = 9767516kB
2013-05-09T22:49:43.742+02:00 n22 kernel: 2221567 pages RAM
2013-05-09T22:49:43.742+02:00 n22 kernel: 1993218 pages HighMem
2013-05-09T22:49:43.742+02:00 n22 kernel: 178200 pages reserved
2013-05-09T22:49:43.742+02:00 n22 kernel: 388922 pages shared
2013-05-09T22:49:43.742+02:00 n22 kernel: 856482 pages non-shared
2013-05-09T22:49:43.742+02:00 n22 kernel: ata2: SATA link up 1.5 Gbps (SStatus 113 SControl 300)
2013-05-09T22:49:43.742+02:00 n22 kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded
2013-05-09T22:49:43.742+02:00 n22 kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded
2013-05-09T22:49:43.742+02:00 n22 kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
2013-05-09T22:49:43.742+02:00 n22 kernel: ata2.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded
2013-05-09T22:49:43.742+02:00 n22 kernel: ata2.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded
2013-05-09T22:49:43.742+02:00 n22 kernel: ata2.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
2013-05-09T22:49:43.743+02:00 n22 kernel: ata2.00: configured for UDMA/33
2013-05-09T22:49:43.743+02:00 n22 kernel: ata4: SATA link down (SStatus 0 SControl 300)
2013-05-09T22:49:43.743+02:00 n22 kernel: kthreadd: page allocation failure: order:1, mode:0x300010
2013-05-09T22:49:43.743+02:00 n22 kernel: Pid: 2, comm: kthreadd Not tainted 3.9.1 #8
2013-05-09T22:49:43.743+02:00 n22 kernel: Call Trace:
2013-05-09T22:49:43.743+02:00 n22 kernel: [<c10d9c5f>] warn_alloc_failed+0xbf/0x100
2013-05-09T22:49:43.743+02:00 n22 kernel: [<c10dc70b>] __alloc_pages_nodemask+0x5cb/0x7d0
2013-05-09T22:49:43.743+02:00 n22 kernel: [<c1032ba3>] copy_process+0x103/0x10c0
2013-05-09T22:49:43.743+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.743+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.744+02:00 n22 kernel: [<c1033c3e>] do_fork+0x9e/0x2b0
2013-05-09T22:49:43.744+02:00 n22 kernel: [<c1063690>] ? default_wake_function+0x10/0x20
2013-05-09T22:49:43.744+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.744+02:00 n22 kernel: [<c1033e7d>] kernel_thread+0x2d/0x40
2013-05-09T22:49:43.744+02:00 n22 kernel: [<c1054cb8>] kthreadd+0xd8/0x110
2013-05-09T22:49:43.744+02:00 n22 kernel: [<c1487477>] ret_from_kernel_thread+0x1b/0x28
2013-05-09T22:49:43.744+02:00 n22 kernel: [<c1054be0>] ? kthread_create_on_cpu+0x60/0x60
2013-05-09T22:49:43.744+02:00 n22 kernel: Mem-Info:
2013-05-09T22:49:43.744+02:00 n22 kernel: DMA per-cpu:
2013-05-09T22:49:43.744+02:00 n22 kernel: CPU 0: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.744+02:00 n22 kernel: CPU 1: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.744+02:00 n22 kernel: CPU 2: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.744+02:00 n22 kernel: CPU 3: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.744+02:00 n22 kernel: Normal per-cpu:
2013-05-09T22:49:43.744+02:00 n22 kernel: CPU 0: hi: 186, btch: 31 usd: 31
2013-05-09T22:49:43.744+02:00 n22 kernel: CPU 1: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.744+02:00 n22 kernel: CPU 2: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.744+02:00 n22 kernel: CPU 3: hi: 186, btch: 31 usd: 13
2013-05-09T22:49:43.744+02:00 n22 kernel: HighMem per-cpu:
2013-05-09T22:49:43.744+02:00 n22 kernel: CPU 0: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.745+02:00 n22 kernel: CPU 1: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.745+02:00 n22 kernel: CPU 2: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.745+02:00 n22 kernel: CPU 3: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.745+02:00 n22 kernel: active_anon:72359 inactive_anon:72391 isolated_anon:0
2013-05-09T22:49:43.745+02:00 n22 kernel: active_file:22232 inactive_file:5138 isolated_file:0
2013-05-09T22:49:43.745+02:00 n22 kernel: unevictable:0 dirty:2 writeback:0 unstable:0
2013-05-09T22:49:43.745+02:00 n22 kernel: free:1132920 slab_reclaimable:4098 slab_unreclaimable:5340
2013-05-09T22:49:43.745+02:00 n22 kernel: mapped:17714 shmem:96016 pagetables:1619 bounce:0
2013-05-09T22:49:43.745+02:00 n22 kernel: free_cma:0
2013-05-09T22:49:43.745+02:00 n22 kernel: DMA free:3868kB min:760kB low:948kB high:1140kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15984kB managed:15360kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:16kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? yes
2013-05-09T22:49:43.746+02:00 n22 kernel: lowmem_reserve[]: 0 779 7964 7964
2013-05-09T22:49:43.746+02:00 n22 kernel: Normal free:46292kB min:39628kB low:49532kB high:59440kB active_anon:0kB inactive_anon:0kB active_file:32kB inactive_file:84kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:894968kB managed:797924kB mlocked:0kB dirty:0kB writeback:0kB mapped:8kB shmem:0kB slab_reclaimable:16392kB slab_unreclaimable:21344kB kernel_stack:2632kB pagetables:6476kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:58 all_unreclaimable? no
2013-05-09T22:49:43.746+02:00 n22 kernel: lowmem_reserve[]: 0 0 57485 57485
2013-05-09T22:49:43.746+02:00 n22 kernel: HighMem free:4481520kB min:512kB low:91872kB high:183232kB active_anon:289436kB inactive_anon:289564kB active_file:88896kB inactive_file:20468kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:7358088kB managed:7358088kB mlocked:0kB dirty:8kB writeback:0kB mapped:70848kB shmem:384064kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
2013-05-09T22:49:43.746+02:00 n22 kernel: lowmem_reserve[]: 0 0 0 0
2013-05-09T22:49:43.746+02:00 n22 kernel: DMA: 1*4kB (R) 1*8kB (R) 1*16kB (R) 0*32kB 0*64kB 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 1*2048kB (R) 0*4096kB = 3868kB
2013-05-09T22:49:43.746+02:00 n22 kernel: Normal: 7695*4kB (UEM) 533*8kB (UEM) 111*16kB (UEM) 34*32kB (UE) 3*64kB (U) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 2*4096kB (R) = 46292kB
2013-05-09T22:49:43.746+02:00 n22 kernel: HighMem: 32546*4kB (UEM) 27911*8kB (UEM) 25181*16kB (UEM) 16711*32kB (UEM) 9814*64kB (UEM) 4120*128kB (UEM) 2163*256kB (UEM) 1165*512kB (UEM) 718*1024kB (M) 49*2048kB (M) 12*4096kB (MR) = 4481520kB
2013-05-09T22:49:43.746+02:00 n22 kernel: 123386 total pagecache pages
2013-05-09T22:49:43.746+02:00 n22 kernel: 0 pages in swap cache
2013-05-09T22:49:43.747+02:00 n22 kernel: Swap cache stats: add 0, delete 0, find 0/0
2013-05-09T22:49:43.747+02:00 n22 kernel: Free swap = 9767516kB
2013-05-09T22:49:43.747+02:00 n22 kernel: Total swap = 9767516kB
2013-05-09T22:49:43.747+02:00 n22 kernel: 2221567 pages RAM
2013-05-09T22:49:43.747+02:00 n22 kernel: 1993218 pages HighMem
2013-05-09T22:49:43.747+02:00 n22 kernel: 178200 pages reserved
2013-05-09T22:49:43.747+02:00 n22 kernel: 388922 pages shared
2013-05-09T22:49:43.747+02:00 n22 kernel: 856482 pages non-shared
2013-05-09T22:49:43.747+02:00 n22 kernel: ata5: SATA link down (SStatus 0 SControl 300)
2013-05-09T22:49:43.747+02:00 n22 kernel: PM: thaw of devices complete after 940.796 msecs
2013-05-09T22:49:43.747+02:00 n22 kernel: PM: writing image.
2013-05-09T22:49:43.747+02:00 n22 kernel: [drm] Enabling RC6 states: RC6 on, RC6p on, RC6pp on
2013-05-09T22:49:43.747+02:00 n22 kernel: e1000e: enp0s25 NIC Link is Up 100 Mbps Full Duplex, Flow Control: None
2013-05-09T22:49:43.747+02:00 n22 kernel: kthreadd: page allocation failure: order:1, mode:0x300010
2013-05-09T22:49:43.747+02:00 n22 kernel: Pid: 2, comm: kthreadd Not tainted 3.9.1 #8
2013-05-09T22:49:43.747+02:00 n22 kernel: Call Trace:
2013-05-09T22:49:43.747+02:00 n22 kernel: [<c10d9c5f>] warn_alloc_failed+0xbf/0x100
2013-05-09T22:49:43.747+02:00 n22 kernel: [<c10dc70b>] __alloc_pages_nodemask+0x5cb/0x7d0
2013-05-09T22:49:43.747+02:00 n22 kernel: [<c1032ba3>] copy_process+0x103/0x10c0
2013-05-09T22:49:43.747+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.748+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.748+02:00 n22 kernel: [<c1033c3e>] do_fork+0x9e/0x2b0
2013-05-09T22:49:43.748+02:00 n22 kernel: [<c1063690>] ? default_wake_function+0x10/0x20
2013-05-09T22:49:43.748+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
2013-05-09T22:49:43.748+02:00 n22 kernel: [<c1033e7d>] kernel_thread+0x2d/0x40
2013-05-09T22:49:43.748+02:00 n22 kernel: [<c1054cb8>] kthreadd+0xd8/0x110
2013-05-09T22:49:43.748+02:00 n22 kernel: [<c1487477>] ret_from_kernel_thread+0x1b/0x28
2013-05-09T22:49:43.748+02:00 n22 kernel: [<c1054be0>] ? kthread_create_on_cpu+0x60/0x60
2013-05-09T22:49:43.748+02:00 n22 kernel: Mem-Info:
2013-05-09T22:49:43.748+02:00 n22 kernel: DMA per-cpu:
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 0: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 1: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 2: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 3: hi: 0, btch: 1 usd: 0
2013-05-09T22:49:43.749+02:00 n22 kernel: Normal per-cpu:
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 0: hi: 186, btch: 31 usd: 30
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 1: hi: 186, btch: 31 usd: 30
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 2: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 3: hi: 186, btch: 31 usd: 13
2013-05-09T22:49:43.749+02:00 n22 kernel: HighMem per-cpu:
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 0: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 1: hi: 186, btch: 31 usd: 3
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 2: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.749+02:00 n22 kernel: CPU 3: hi: 186, btch: 31 usd: 0
2013-05-09T22:49:43.749+02:00 n22 kernel: active_anon:72359 inactive_anon:72391 isolated_anon:0
2013-05-09T22:49:43.749+02:00 n22 kernel: active_file:22232 inactive_file:5138 isolated_file:0
2013-05-09T22:49:43.749+02:00 n22 kernel: unevictable:0 dirty:2 writeback:0 unstable:0
2013-05-09T22:49:43.749+02:00 n22 kernel: free:1132672 slab_reclaimable:4098 slab_unreclaimable:5340
2013-05-09T22:49:43.749+02:00 n22 kernel: mapped:17714 shmem:96016 pagetables:1619 bounce:0
2013-05-09T22:49:43.749+02:00 n22 kernel: free_cma:0
2013-05-09T22:49:43.750+02:00 n22 kernel: DMA free:3868kB min:760kB low:948kB high:1140kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:15984kB managed:15360kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:16kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? yes
2013-05-09T22:49:43.750+02:00 n22 kernel: lowmem_reserve[]: 0 779 7964 7964
2013-05-09T22:49:43.750+02:00 n22 kernel: Normal free:46168kB min:39628kB low:49532kB high:59440kB active_anon:0kB inactive_anon:0kB active_file:32kB inactive_file:84kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:894968kB managed:797924kB mlocked:0kB dirty:0kB writeback:0kB mapped:8kB shmem:0kB slab_reclaimable:16392kB slab_unreclaimable:21344kB kernel_stack:2632kB pagetables:6476kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:87 all_unreclaimable? no
2013-05-09T22:49:43.750+02:00 n22 kernel: lowmem_reserve[]: 0 0 57485 57485
2013-05-09T22:49:43.750+02:00 n22 kernel: HighMem free:4480652kB min:512kB low:91872kB high:183232kB active_anon:289436kB inactive_anon:289564kB active_file:88896kB inactive_file:20468kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:7358088kB managed:7358088kB mlocked:0kB dirty:8kB writeback:0kB mapped:70848kB shmem:384064kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB free_cma:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? no
2013-05-09T22:49:43.750+02:00 n22 kernel: lowmem_reserve[]: 0 0 0 0
2013-05-09T22:49:43.750+02:00 n22 kernel: DMA: 1*4kB (R) 1*8kB (R) 1*16kB (R) 0*32kB 0*64kB 0*128kB 1*256kB (R) 1*512kB (R) 1*1024kB (R) 1*2048kB (R) 0*4096kB = 3868kB
2013-05-09T22:49:43.750+02:00 n22 kernel: Normal: 7664*4kB (UEM) 533*8kB (UEM) 111*16kB (UEM) 34*32kB (UE) 3*64kB (U) 0*128kB 0*256kB 0*512kB 0*1024kB 0*2048kB 2*4096kB (R) = 46168kB
2013-05-09T22:49:43.750+02:00 n22 kernel: HighMem: 32329*4kB (UEM) 27911*8kB (UEM) 25181*16kB (UEM) 16711*32kB (UEM) 9814*64kB (UEM) 4120*128kB (UEM) 2163*256kB (UEM) 1165*512kB (UEM) 718*1024kB (M) 49*2048kB (M) 12*4096kB (MR) = 4480652kB
2013-05-09T22:49:43.750+02:00 n22 kernel: 123386 total pagecache pages
2013-05-09T22:49:43.751+02:00 n22 kernel: 0 pages in swap cache
2013-05-09T22:49:43.751+02:00 n22 kernel: Swap cache stats: add 0, delete 0, find 0/0
2013-05-09T22:49:43.751+02:00 n22 kernel: Free swap = 9767508kB
2013-05-09T22:49:43.751+02:00 n22 kernel: Total swap = 9767516kB
2013-05-09T22:49:43.751+02:00 n22 kernel: 2221567 pages RAM
2013-05-09T22:49:43.751+02:00 n22 kernel: 1993218 pages HighMem
2013-05-09T22:49:43.751+02:00 n22 kernel: 178200 pages reserved
2013-05-09T22:49:43.751+02:00 n22 kernel: 388922 pages shared
2013-05-09T22:49:43.751+02:00 n22 kernel: 856698 pages non-shared
2013-05-09T22:49:43.751+02:00 n22 kernel: PM: Cannot start compression threads
2013-05-09T22:49:43.751+02:00 n22 kernel: Restarting tasks ... done.
2013-05-09T22:49:43.751+02:00 n22 kernel: PM: Basic memory bitmaps freed
2013-05-09T22:49:43.751+02:00 n22 kernel: video LNXVIDEO:00: Restoring backlight state
2013-05-09T22:49:43.751+02:00 n22 kernel: thinkpad_acpi: EC reports that Thermal Table has changed
2013-05-09T22:49:45.000+02:00 n22 logger: ACPI event : ibm/hotkey HKEY 00000080 00006030
2013-05-09T22:49:45.000+02:00 n22 logger: ACPI event : ibm/hotkey HKEY 00000080 00006030
2013-05-09T22:49:47.886+02:00 n22 kernel: ata1.00: configured for UDMA/100
2013-05-09T22:49:47.886+02:00 n22 kernel: ata1: EH complete
2013-05-09T22:49:47.886+02:00 n22 kernel: sd 0:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
--
MfG/Sincerely
Toralf Förster
pgp finger print: 7B1A 07F4 EC82 0F90 D4C2 8936 872A E508 7DB6 9DA3
^ permalink raw reply [flat|nested] 2+ messages in thread
* Re: s2disk failed, 2nd attempt worked
2013-05-10 14:00 s2disk failed, 2nd attempt worked Toralf Förster
@ 2013-05-10 20:33 ` Rafael J. Wysocki
0 siblings, 0 replies; 2+ messages in thread
From: Rafael J. Wysocki @ 2013-05-10 20:33 UTC (permalink / raw)
To: Toralf Förster; +Cc: Linux PM list
On Friday, May 10, 2013 04:00:23 PM Toralf Förster wrote:
> At a stable 32 bit Gentoo w/ kernel 3.9.1 I need yesterday 2 attempts to s2disk the system.
> The first s2disk failed with the error msg :
>
> echo: write error: Cannot allocate memory
>
> at this line of my hibernation script :
> echo $1 > /sys/power/state
>
>
> 2013-05-09T22:49:31.000+02:00 n22 sudo: tfoerste : TTY=pts/2 ; PWD=/home/tfoerste ; USER=root ; COMMAND=/home/tfoerste/workspace/acpi/default.sh ibm/hotkey HKEY 00000080 0000100c
> 2013-05-09T22:49:31.000+02:00 n22 sudo: pam_unix(sudo:session): session opened for user root by tfoerste(uid=0)
> 2013-05-09T22:49:32.000+02:00 n22 su[27780]: Successful su for boinc by root
> 2013-05-09T22:49:32.000+02:00 n22 su[27780]: + /dev/pts/2 root:boinc
> 2013-05-09T22:49:32.000+02:00 n22 su[27780]: pam_unix(su:session): session opened for user boinc by tfoerste(uid=0)
> 2013-05-09T22:49:32.000+02:00 n22 su[27780]: pam_unix(su:session): session closed for user boinc
> 2013-05-09T22:49:36.000+02:00 n22 pppd[5159]: Terminating on signal 15
> 2013-05-09T22:49:36.000+02:00 n22 pppd[5159]: Connect time 465.1 minutes.
> 2013-05-09T22:49:36.000+02:00 n22 pppd[5159]: Sent 2701783 bytes, received 27205393 bytes.
> 2013-05-09T22:49:36.000+02:00 n22 pppd[5159]: Connection terminated.
> 2013-05-09T22:49:36.000+02:00 n22 /etc/init.d/net.ppp0[27911]: status: stopping
> 2013-05-09T22:49:36.000+02:00 n22 pppd[5159]: Exit.
> 2013-05-09T22:49:37.327+02:00 n22 kernel: PM: Marking nosave pages: [mem 0x0009d000-0x000fffff]
> 2013-05-09T22:49:37.327+02:00 n22 kernel: PM: Marking nosave pages: [mem 0x20000000-0x201fffff]
> 2013-05-09T22:49:37.327+02:00 n22 kernel: PM: Basic memory bitmaps created
> 2013-05-09T22:49:42.951+02:00 n22 kernel: PM: Syncing filesystems ... done.
> 2013-05-09T22:49:42.951+02:00 n22 kernel: Freezing user space processes ... (elapsed 0.01 seconds) done.
> 2013-05-09T22:49:42.951+02:00 n22 kernel: PM: Preallocating image memory... done (allocated 721313 pages)
> 2013-05-09T22:49:42.951+02:00 n22 kernel: PM: Allocated 2885252 kbytes in 0.95 seconds (3037.10 MB/s)
> 2013-05-09T22:49:42.951+02:00 n22 kernel: Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
> 2013-05-09T22:49:42.951+02:00 n22 kernel: Suspending console(s) (use no_console_suspend to debug)
> 2013-05-09T22:49:42.951+02:00 n22 kernel: kthreadd: page allocation failure: order:1, mode:0x300010
> 2013-05-09T22:49:42.951+02:00 n22 kernel: Pid: 2, comm: kthreadd Not tainted 3.9.1 #8
> 2013-05-09T22:49:42.951+02:00 n22 kernel: Call Trace:
> 2013-05-09T22:49:42.951+02:00 n22 kernel: [<c10d9c5f>] warn_alloc_failed+0xbf/0x100
> 2013-05-09T22:49:43.728+02:00 n22 kernel: [<c10dc70b>] __alloc_pages_nodemask+0x5cb/0x7d0
> 2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1032ba3>] copy_process+0x103/0x10c0
> 2013-05-09T22:49:43.728+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
> 2013-05-09T22:49:43.728+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
> 2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1033c3e>] do_fork+0x9e/0x2b0
> 2013-05-09T22:49:43.728+02:00 n22 kernel: [<c10548b0>] ? flush_kthread_work+0xd0/0xd0
> 2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1033e7d>] kernel_thread+0x2d/0x40
> 2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1054cb8>] kthreadd+0xd8/0x110
> 2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1487477>] ret_from_kernel_thread+0x1b/0x28
> 2013-05-09T22:49:43.728+02:00 n22 kernel: [<c1054be0>] ? kthread_create_on_cpu+0x60/0x60
> 2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: Deleting interface #3 ppp0, 80.171.222.206#123, interface stats: received=296, sent=296, dropped=0, active_time=27884 secs
> 2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: 178.254.20.157 interface 80.171.222.206 -> (none)
> 2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: 213.239.204.119 interface 80.171.222.206 -> (none)
> 2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: 46.165.212.204 interface 80.171.222.206 -> (none)
> 2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: 195.50.171.101 interface 80.171.222.206 -> (none)
> 2013-05-09T22:49:42.000+02:00 n22 ntpd[5772]: peers refreshed
This means there was no room to create a new kernel thread after memory for
hibernation has been preallocated. Most likely you need to reduce the image
size for the system in question.
Thanks,
Rafael
--
I speak only for myself.
Rafael J. Wysocki, Intel Open Source Technology Center.
^ permalink raw reply [flat|nested] 2+ messages in thread
end of thread, other threads:[~2013-05-10 20:24 UTC | newest]
Thread overview: 2+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2013-05-10 14:00 s2disk failed, 2nd attempt worked Toralf Förster
2013-05-10 20:33 ` Rafael J. Wysocki
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox