* Re: [sisyphus] Syspend2 disk
2007-05-29 11:20 ` Dmitri Kolobov
2007-05-29 12:25 ` Lebedev Sergey
2007-05-29 15:37 ` Andrey Rahmatullin
@ 2007-05-30 3:49 ` Dmitri Kolobov
2007-05-30 6:53 ` Andrey Rahmatullin
2 siblings, 1 reply; 7+ messages in thread
From: Dmitri Kolobov @ 2007-05-30 3:49 UTC (permalink / raw)
To: sisyphus
У меня это при засыпании в память в основном происходит,
при засыпании на диск ситуация аналогичная, и 1 из 10 случаев приводит к зависанию (но логов пока нет).
Про extra_pages_allowance - знаю, когда он на него ругается, у меня в логах пишется именно про extra_pages.
(стоит Procsetting extra_pages_allowance 40500, но, насколько понимаю, работает только для засыпания на диск)
Т.е. это видимо одна ситуация.
А другая, когда у меня в /var/log/messages пишется:
[fglrx:firegl_pm_save_framebuffer] *ERROR* Failed to allocate 16000 KB for saving frame buffer object.
после этого hibernate сразу продолжается - т.е. идет просыпание, и в его логах ничего особенного.
Следующие засыпание (и на диск, и в память) - мертвое зависание.
гуглить (и по рассылке) пробовал, не нашел
вот лог при засыпании в память:
May 15 11:28:15 frame-6 kernel: CPU 1 is now offline
May 15 11:28:15 frame-6 kernel: SMP alternatives: switching to UP code
May 15 11:45:42 frame-6 kernel: CPU1 is down
May 15 11:45:42 frame-6 kernel: Stopping tasks... done.
May 15 11:45:42 frame-6 kernel: usbdev5.2_ep82: PM: suspend 0->2, parent 5-4:1.0 already 1
May 15 11:45:44 frame-6 kernel: usbdev5.2_ep81: PM: suspend 0->2, parent 5-4:1.0 already 1
May 15 11:45:44 frame-6 kernel: ACPI: PCI interrupt for device 0000:06:00.1 disabled
May 15 11:45:44 frame-6 kernel: eth%%d: Going into suspend...
May 15 11:45:44 frame-6 kernel: ACPI: PCI interrupt for device 0000:02:00.0 disabled
May 15 11:45:44 frame-6 kernel: echo: page allocation failure. order:0, mode:0x20
May 15 11:45:44 frame-6 kernel: [<b01044ba>] show_trace_log_lvl+0x5b/0x16d
May 15 11:45:44 frame-6 kernel: [<b0104b3a>] show_trace+0xf/0x11
May 15 11:45:44 frame-6 kernel: [<b0104c37>] dump_stack+0x15/0x17
May 15 11:45:44 frame-6 kernel: [<b01549ac>] __alloc_pages+0x285/0x296
May 15 11:45:44 frame-6 kernel: [<b01612f0>] __vmalloc_area_node+0xca/0x11e
May 15 11:45:44 frame-6 kernel: [<b01613bd>] __vmalloc+0xf/0x11
May 15 11:45:44 frame-6 kernel: [<f1351a1f>] firegl_pm_save_framebuffer+0x17f/0x1d0 [fglrx]
May 15 11:45:44 frame-6 ifplugd(eth0)[2005]: Link beat lost.
May 15 11:45:44 frame-6 kernel: DWARF2 unwinder stuck at firegl_pm_save_framebuffer+0x17f/0x1d0 [fglrx]
May 15 11:45:44 frame-6 kernel: Leftover inexact backtrace:
May 15 11:45:44 frame-6 kernel: [<f1353cb9>] firegl_cail_powerdown+0x69/0x120 [fglrx]
May 15 11:45:44 frame-6 kernel: [<b0235220>] pcibios_disable_device+0x16/0x18
May 15 11:45:44 frame-6 kernel: [<f133b237>] fglrx_pci_suspend+0x58/0x95 [fglrx]
May 15 11:45:44 frame-6 kernel: [<b01c77b4>] pci_device_suspend+0x18/0x47
May 15 11:45:44 frame-6 kernel: [<b021f435>] suspend_device+0xb3/0xe5
May 15 11:45:44 frame-6 kernel: [<b021f536>] device_suspend+0x60/0x164
May 15 11:45:44 frame-6 kernel: [<b01389b9>] enter_state+0xf3/0x18e
May 15 11:45:44 frame-6 kernel: [<b0138ad9>] state_store+0x85/0x99
May 15 11:45:44 frame-6 kernel: [<b0138a54>] state_store+0x0/0x99
May 15 11:45:44 frame-6 kernel: [<b01a006e>] subsys_attr_store+0x1e/0x22
May 15 11:45:44 frame-6 kernel: [<b01a02ad>] sysfs_write_file+0x90/0xb7
May 15 11:45:44 frame-6 kernel: [<b01a021d>] sysfs_write_file+0x0/0xb7
May 15 11:45:44 frame-6 kernel: [<b016bbe6>] vfs_write+0xa8/0x15f
May 15 11:45:44 frame-6 kernel: [<b016c21e>] sys_write+0x41/0x67
May 15 11:45:44 frame-6 kernel: [<b0102e47>] syscall_call+0x7/0xb
May 15 11:45:44 frame-6 kernel: Mem-info:
May 15 11:45:44 frame-6 kernel: DMA per-cpu:
May 15 11:45:44 frame-6 kernel: cpu 0 hot: high 0, batch 1 used:0
May 15 11:45:44 frame-6 kernel: cpu 0 cold: high 0, batch 1 used:0
May 15 11:45:44 frame-6 kernel: DMA32 per-cpu: empty
May 15 11:45:44 frame-6 kernel: Normal per-cpu:
May 15 11:45:44 frame-6 kernel: cpu 0 hot: high 186, batch 31 used:30
May 15 11:45:44 frame-6 kernel: cpu 0 cold: high 62, batch 15 used:0
May 15 11:45:44 frame-6 kernel: HighMem per-cpu: empty
May 15 11:45:44 frame-6 kernel: Free pages: 5444kB (0kB HighMem)
May 15 11:45:44 frame-6 kernel: Active:130062 inactive:98669 dirty:0 writeback:0 unstable:0 free:1361 slab:12188 mapped:19364 pagetables:509
May 15 11:45:44 frame-6 kernel: DMA free:4052kB min:60kB low:72kB high:88kB lots:120kB active:2312kB inactive:4948kB present:16384kB pages_scanned:0 all_unreclaimable? no
May 15 11:45:44 frame-6 kernel: lowmem_reserve[]: 0 0 1007 1007
May 15 11:45:44 frame-6 kernel: DMA32 free:0kB min:0kB low:0kB high:0kB lots:0kB active:0kB inactive:0kB present:0kB pages_scanned:0 all_unreclaimable? no
May 15 11:45:44 frame-6 kernel: lowmem_reserve[]: 0 0 1007 1007
May 15 11:45:44 frame-6 kernel: Normal free:1392kB min:4028kB low:5032kB high:6040kB lots:8056kB active:517936kB inactive:389728kB present:1031936kB pages_scanned:0 all_unreclaimable? no
May 15 11:45:44 frame-6 kernel: lowmem_reserve[]: 0 0 0 0
May 15 11:45:44 frame-6 kernel: HighMem free:0kB min:128kB low:128kB high:128kB lots:128kB active:0kB inactive:0kB present:0kB pages_scanned:0 all_unreclaimable? no
May 15 11:45:44 frame-6 kernel: lowmem_reserve[]: 0 0 0 0
May 15 11:45:44 frame-6 kernel: DMA: 1*4kB 0*8kB 1*16kB 0*32kB 1*64kB 1*128kB 1*256kB 1*512kB 1*1024kB 1*2048kB 0*4096kB = 4052kB
May 15 11:45:44 frame-6 kernel: DMA32: empty
May 15 11:45:44 frame-6 kernel: Normal: 0*4kB 0*8kB 1*16kB 1*32kB 1*64kB 0*128kB 1*256kB 0*512kB 1*1024kB 0*2048kB 0*4096kB = 1392kB
May 15 11:45:44 frame-6 kernel: HighMem: empty
May 15 11:45:44 frame-6 kernel: Swap cache: add 0, delete 0, find 0/0, race 0+0
May 15 11:45:44 frame-6 kernel: Free swap = 1935792kB
May 15 11:45:44 frame-6 kernel: Total swap = 1935792kB
May 15 11:45:44 frame-6 kernel: Free swap: 1935792kB
May 15 11:45:44 frame-6 smartd[4132]: Device: /dev/sda, SMART Usage Attribute: 194 Temperature_Celsius changed from 134 to 161
May 15 11:45:44 frame-6 kernel: 262080 pages of RAM
May 15 11:45:44 frame-6 kernel: 0 pages of HIGHMEM
May 15 11:45:44 frame-6 kernel: 6406 reserved pages
May 15 11:45:44 frame-6 kernel: 0 pages of BadRAM
May 15 11:45:44 frame-6 kernel: 123013 pages shared
May 15 11:45:44 frame-6 kernel: 0 pages swap cached
May 15 11:45:44 frame-6 kernel: 0 pages dirty
May 15 11:45:44 frame-6 kernel: 0 pages writeback
May 15 11:45:44 frame-6 kernel: 19364 pages mapped
May 15 11:45:44 frame-6 kernel: 12188 pages slab
May 15 11:45:44 frame-6 kernel: 509 pages pagetables
-----------------------------------------
следующая строчка с ошибкой:
-----------------------------------------
May 15 11:45:44 frame-6 kernel: [fglrx:firegl_pm_save_framebuffer] *ERROR* Failed to allocate 16000 KB for saving frame buffer object.
May 15 11:45:45 frame-6 kernel: [fglrx] firegl_gps_setpowerdown .
May 15 11:45:45 frame-6 kernel: ACPI: PCI interrupt for device 0000:01:00.0 disabled
May 15 11:45:45 frame-6 kernel: ACPI: PCI interrupt for device 0000:00:1f.2 disabled
May 15 11:45:45 frame-6 kernel: ACPI: PCI interrupt for device 0000:00:1d.7 disabled
May 15 11:45:45 frame-6 kernel: ACPI: PCI interrupt for device 0000:00:1d.3 disabled
May 15 11:45:45 frame-6 kernel: ACPI: PCI interrupt for device 0000:00:1d.2 disabled
May 15 11:45:45 frame-6 kernel: ACPI: PCI interrupt for device 0000:00:1d.1 disabled
May 15 11:45:45 frame-6 kernel: ACPI: PCI interrupt for device 0000:00:1d.0 disabled
May 15 11:45:45 frame-6 kernel: ACPI: PCI interrupt for device 0000:00:1b.0 disabled
May 15 11:45:45 frame-6 kernel: Intel machine check architecture supported.
May 15 11:45:45 frame-6 kernel: Intel machine check reporting enabled on CPU#0.
May 15 11:45:45 frame-6 kernel: ACPI: Transitioning device [FN00] to D3
May 15 11:45:45 frame-6 kernel: ACPI: Transitioning device [FN00] to D3
May 15 11:45:45 frame-6 kernel: PCI: Enabling device 0000:00:1b.0 (0000 -> 0002)
May 15 11:45:45 frame-6 kernel: ACPI: PCI Interrupt 0000:00:1b.0[A] -> GSI 21 (level, low) -> IRQ 74
May 15 11:45:45 frame-6 kernel: PCI: Enabling device 0000:00:1d.0 (0000 -> 0001)
May 15 11:45:45 frame-6 kernel: ACPI: PCI Interrupt 0000:00:1d.0[A] -> GSI 23 (level, low) -> IRQ 233
May 15 11:45:45 frame-6 kernel: usb usb1: root hub lost power or was reset
May 15 11:45:45 frame-6 kernel: PCI: Enabling device 0000:00:1d.1 (0000 -> 0001)
May 15 11:45:45 frame-6 kernel: ACPI: PCI Interrupt 0000:00:1d.1[B] -> GSI 19 (level, low) -> IRQ 185
May 15 11:45:45 frame-6 kernel: usb usb2: root hub lost power or was reset
May 15 11:45:45 frame-6 kernel: PCI: Enabling device 0000:00:1d.2 (0000 -> 0001)
May 15 11:45:45 frame-6 kernel: ACPI: PCI Interrupt 0000:00:1d.2[C] -> GSI 20 (level, low) -> IRQ 50
May 15 11:45:45 frame-6 kernel: usb usb3: root hub lost power or was reset
May 15 11:45:45 frame-6 kernel: PCI: Enabling device 0000:00:1d.3 (0000 -> 0001)
May 15 11:45:45 frame-6 kernel: ACPI: PCI Interrupt 0000:00:1d.3[D] -> GSI 22 (level, low) -> IRQ 58
May 15 11:45:45 frame-6 kernel: usb usb4: root hub lost power or was reset
May 15 11:45:45 frame-6 kernel: PCI: Enabling device 0000:00:1d.7 (0100 -> 0102)
May 15 11:45:45 frame-6 kernel: ACPI: PCI Interrupt 0000:00:1d.7[A] -> GSI 23 (level, low) -> IRQ 233
May 15 11:45:45 frame-6 kernel: ACPI: PCI Interrupt 0000:00:1f.2[B] -> GSI 19 (level, low) -> IRQ 185
May 15 11:45:45 frame-6 kernel: ACPI: PCI Interrupt 0000:01:00.0[A] -> GSI 16 (level, low) -> IRQ 169
May 15 11:45:45 frame-6 kernel: [fglrx] firegl_gps_setpowerup .
May 15 11:45:45 frame-6 kernel: eth%%d: Coming out of suspend...
May 15 11:45:45 frame-6 kernel: PCI: Enabling device 0000:02:00.0 (0000 -> 0002)
May 15 11:45:45 frame-6 kernel: ACPI: PCI Interrupt 0000:02:00.0[A] -> GSI 16 (level, low) -> IRQ 169
May 15 11:45:45 frame-6 kernel: ACPI: PCI Interrupt 0000:06:00.1[B] -> GSI 17 (level, low) -> IRQ 66
May 15 11:45:45 frame-6 kernel: pnp: Failed to activate device 00:04.
May 15 11:45:45 frame-6 kernel: pnp: Failed to activate device 00:05.
May 15 11:45:45 frame-6 kernel: usbdev5.2_ep81: PM: resume from 0, parent 5-4:1.0 still 1
May 15 11:45:45 frame-6 kernel: usbdev5.2_ep82: PM: resume from 0, parent 5-4:1.0 still 1
May 15 11:45:45 frame-6 kernel: Restarting tasks...done.
May 15 11:45:45 frame-6 kernel: Thawing cpus ...
May 15 11:45:45 frame-6 kernel: SMP alternatives: switching to SMP code
May 15 11:45:45 frame-6 kernel: Booting processor 1/1 eip 3000
May 15 11:45:45 frame-6 kernel: Initializing CPU#1
May 15 11:45:45 frame-6 kernel: Calibrating delay using timer specific routine.. 3657.03 BogoMIPS (lpj=1828515)
May 15 11:45:45 frame-6 kernel: monitor/mwait feature present.
May 15 11:45:45 frame-6 kernel: CPU: L1 I cache: 32K, L1 D cache: 32K
May 15 11:45:45 frame-6 kernel: CPU: L2 cache: 2048K
May 15 11:45:45 frame-6 kernel: CPU: Physical Processor ID: 0
May 15 11:45:45 frame-6 kernel: CPU: Processor Core ID: 1
May 15 11:45:45 frame-6 kernel: Intel machine check architecture supported.
May 15 11:45:45 frame-6 kernel: Intel machine check reporting enabled on CPU#1.
May 15 11:45:45 frame-6 kernel: CPU1: Intel(R) Core(TM)2 CPU T5600 @ 1.83GHz stepping 06
May 15 11:45:45 frame-6 kernel: CPU1 is up
May 15 11:45:45 frame-6 kernel: ATA: abnormal status 0x7F on port 0x177
May 15 11:45:45 frame-6 kernel: ATA: abnormal status 0x7F on port 0x177
May 15 11:45:45 frame-6 kernel: ata2.01: configured for UDMA/33
May 15 11:45:45 frame-6 kernel: ata1.00: configured for UDMA/100
May 15 11:45:45 frame-6 kernel: SCSI device sda: 195371568 512-byte hdwr sectors (100030 MB)
May 15 11:45:45 frame-6 kernel: sda: Write Protect is off
May 15 11:45:45 frame-6 kernel: SCSI device sda: drive cache: write back
May 15 11:45:49 frame-6 kernel: ACPI: Power Button (FF) [PWRF]
May 15 11:45:49 frame-6 kernel: ACPI: Lid Switch [LID]
May 15 11:45:49 frame-6 kernel: ACPI: Power Button (CM) [PWRB]
May 15 11:45:49 frame-6 kernel: ACPI: Sleep Button (CM) [SLPB]
May 15 11:45:49 frame-6 kernel: NET: Registered protocol family 23
May 15 11:45:49 frame-6 kernel: IrCOMM protocol (Dag Brattli)
May 15 11:45:49 frame-6 kernel: r8169 Gigabit Ethernet driver 2.2LK-NAPI loaded
May 15 11:45:49 frame-6 kernel: PCI: Enabling device 0000:03:00.0 (0000 -> 0003)
May 15 11:45:49 frame-6 kernel: ACPI: PCI Interrupt 0000:03:00.0[A] -> GSI 18 (level, low) -> IRQ 177
^ permalink raw reply [flat|nested] 7+ messages in thread