lkml.org 
[lkml]   [2013]   [Jan]   [21]   [last100]   RSS Feed
Views: [wrap][no wrap]   [headers]  [forward] 
 
Messages in this thread
/
Date
SubjectRe: jbd2: don't wake kjournald unnecessarily
From
On Mon, Jan 21, 2013 at 11:47 AM, Jan Kara <jack@suse.cz> wrote:
> On Sun 20-01-13 01:06:40, Sedat Dilek wrote:
>> On Sun, Jan 20, 2013 at 12:44 AM, Sedat Dilek <sedat.dilek@gmail.com> wrote:
>> > Hi,
>> >
>> > I and some others hit a similiar problem in Linux-Next
>> > (next-20130118), please see [1] and [2].
>> >
>> > [3] has a interim analyze of my problems.
>> >
>> > After suspecting the problem was caused by TTY-NEXT, it turned out to
>> > be a JBD2 problem finally.
>> > The freezer/pm_test was helpful to hit the issue (Thanks Rafael for the hint!).
>> >
>> > So, the issue has two faces: TTY and JBD2.
>> > [4] gives a list and URLs of the patches I had to apply to have a
>> > clean system again.
>> >
>> > After applying the two TTY patches (without Eric's JBD2-fix!) the
>> > call-trace after freezer/pm_test looked like this;
>> >
>> > [ 433.527986] PM: Syncing filesystems ... done.
>> > [ 433.843761] PM: Preparing system for mem sleep
>> > [ 436.306002] Freezing user space processes ...
>> > [ 456.304956] Freezing of tasks failed after 20.01 seconds (1 tasks
>> > refusing to freeze, wq_busy=0):
>> > [ 456.305060] Cache I/O D ffffffff8180d780 0 2132 1 0x00000004
>> > [ 456.305065] ffff88007b9dfe18 0000000000000046 ffff88007b9dfdc8
>> > 0000000300000001
>> > [ 456.305069] ffff880097e21720 ffff88007b9dffd8 ffff88007b9dffd8
>> > ffff88007b9dffd8
>> > [ 456.305072] ffff880119b32e40 ffff880097e21720 ffff88007b9dfe28
>> > ffff880118077800
>> > [ 456.305076] Call Trace:
>> > [ 456.305085] [<ffffffff816b7469>] schedule+0x29/0x70
>> > [ 456.305089] [<ffffffff8129067d>] jbd2_log_wait_commit+0xcd/0x1a0
>> > [ 456.305094] [<ffffffff8107eac0>] ? add_wait_queue+0x60/0x60
>> > [ 456.305098] [<ffffffff812307a5>] ext4_sync_file+0x205/0x380
>> > [ 456.305103] [<ffffffff811c43ad>] do_fsync+0x5d/0x90
>> > [ 456.305108] [<ffffffff8119442b>] ? sys_write+0x6b/0xa0
>> > [ 456.305111] [<ffffffff811c4790>] sys_fsync+0x10/0x20
>> > [ 456.305114] [<ffffffff816c0edd>] system_call_fastpath+0x1a/0x1f
>> > [ 456.305122]
>> > [ 456.305124] Restarting tasks ... done.
>> > [ 456.315056] video LNXVIDEO:00: Restoring backlight state
>> >
>> > After applying Eric's patch [5], I could not hit the call-trace again.
>> > NOTE: The patch is from December 2012 and is not shipped in latest Linux-Next.
>> >
>> > The attached testcase script was helpful to force the call-trace.
>> > I have run 50 loops of it w/o an issue!
>> >
>> > Feel free to add a Reported-by/Tested-by.
>> > ( The issue kept me busy for the last days. )
>> >
>> > Regards,
>> > - Sedat -
>> >
>> > [1] http://marc.info/?t=135283664600002&r=1&w=2
>> > [2] http://marc.info/?t=135862023700004&r=1&w=2
>> > [3] http://marc.info/?l=linux-kernel&m=135862010419101&w=2
>> > [4] http://marc.info/?l=linux-next&m=135863550923093&w=2
>> > [5] http://patchwork.ozlabs.org/patch/207237/
>>
>> Hi all,
>>
>> this is really ugly... I could cry!
>>
>> GRRR, I have hit the original issue again while running my testcase script!
>>
>> [ 363.831226] PM: Syncing filesystems ... done.
>> [ 363.988855] PM: Preparing system for mem sleep
>> [ 369.032965] Freezing user space processes ... (elapsed 0.11 seconds) done.
>> [ 369.145792] Freezing remaining freezable tasks ...
>> [ 389.137643] Freezing of tasks failed after 20.01 seconds (1 tasks
>> refusing to freeze, wq_busy=0):
>> [ 389.137760] jbd2/loop0-8 D ffffffff8180d780 0 295 2 0x00000000
>> [ 389.137769] ffff8801181dfb68 0000000000000046 ffff880117de5c80
>> 0000000000000001
>> [ 389.137778] ffff880117de5c80 ffff8801181dffd8 ffff8801181dffd8
>> ffff8801181dffd8
>> [ 389.137784] ffffffff81c15440 ffff880117de5c80 ffff8801181dfb68
>> ffff88011fa14738
>> [ 389.137791] Call Trace:
>> [ 389.137810] [<ffffffff811c6830>] ? __wait_on_buffer+0x30/0x30
>> [ 389.137819] [<ffffffff816b7479>] schedule+0x29/0x70
>> [ 389.137825] [<ffffffff816b754f>] io_schedule+0x8f/0xd0
>> [ 389.137832] [<ffffffff811c683e>] sleep_on_buffer+0xe/0x20
>> [ 389.137842] [<ffffffff816b5d4f>] __wait_on_bit+0x5f/0x90
>> [ 389.137849] [<ffffffff811c5ef1>] ? submit_bh+0x121/0x1e0
>> [ 389.137856] [<ffffffff811c6830>] ? __wait_on_buffer+0x30/0x30
>> [ 389.137864] [<ffffffff816b5dfc>] out_of_line_wait_on_bit+0x7c/0x90
>> [ 389.137873] [<ffffffff8107eb00>] ? autoremove_wake_function+0x40/0x40
>> [ 389.137879] [<ffffffff811c682e>] __wait_on_buffer+0x2e/0x30
>> [ 389.137891] [<ffffffff8128c02c>]
>> jbd2_journal_commit_transaction+0x18cc/0x1d60
>> [ 389.137899] [<ffffffff816b860e>] ? _raw_spin_lock_irqsave+0x2e/0x40
>> [ 389.137908] [<ffffffff81069fbf>] ? try_to_del_timer_sync+0x4f/0x70
>> [ 389.137915] [<ffffffff81290836>] kjournald2+0xd6/0x3e0
>> [ 389.137921] [<ffffffff8107eac0>] ? add_wait_queue+0x60/0x60
>> [ 389.137926] [<ffffffff81290760>] ? commit_timeout+0x10/0x10
>> [ 389.137932] [<ffffffff8107ded0>] kthread+0xc0/0xd0
>> [ 389.137939] [<ffffffff8107de10>] ? flush_kthread_worker+0xb0/0xb0
>> [ 389.137946] [<ffffffff816c0e2c>] ret_from_fork+0x7c/0xb0
>> [ 389.137951] [<ffffffff8107de10>] ? flush_kthread_worker+0xb0/0xb0
>> [ 389.138017]
>> [ 389.138021] Restarting kernel threads ... done.
>> [ 389.138173] Restarting tasks ... done.
>> [ 389.147980] video LNXVIDEO:00: Restoring backlight state
>>
>> I suspect there are still issues in JBD2 (BTW I run here EXT4FS).
>>
>> [ 389.137643] Freezing of tasks failed after 20.01 seconds (1 tasks
>> refusing to freeze, wq_busy=0):
>> [ 389.137760] jbd2/loop0-8 D ffffffff8180d780 0 295 2 0x00000000
>>
>> Have a good night, /me -> watching TV!
> The traces don't suggest an ext4/jbd2 problem. What is happening is that
> jbd2 is waiting for IO to finish and that never happens. Seeing that you
> loop device I'd think it's some interaction of the loop device and
> freezing. Can you reproduce the issue without the loop device (i.e. with
> the filesystem directly on e.g. scsi disk)? I suspect the reason is
> something like that the backing filesystem is already frozen so filesystem
> on top of it cannot write all the data and hangs waiting for IO -> suspend
> doesn't happen. Contents of /proc/mounts and losetup -l would help us
> understand what's going on.
>

As said I am here in a very uncommon WUBI environment means my
Ubuntu/precise rootfs-image lays on the Win7-partition (NTFS).
Your explanation sounds reasonable to me as this line from my attached
testcase causes the troubles.

echo mem > /sys/power/state && sleep 1

So, /sys/ is not writable immediately after freezer ends

I checked again and again my logs and have seen "starving" lines
reported by rtkit-daemon, but did not really get wiser what they want
to tell me. Stopping rtkit-daemon or resetting all or all-known
threads before running my pm_test/freezer did not help, too.

/usr/sbin/rtkitctl --help
rtkitctl [options]

-h, --help Show this help
--version Show version

--reset-known Reset real-time status of known threads
--reset-all Reset real-time status of all threads
--start Start RealtimeKit if it is not running already
-k, --exit Terminate running RealtimeKit daemon

Here are the outputs you wanted with some more (fstab, grub-config) etc.
I have here no -l option for losetup command.


- Sedat -

P.S.: Outputs for Honza...

$ sudo cat /proc/mounts
rootfs / rootfs rw 0 0
sysfs /sys sysfs rw,nosuid,nodev,noexec,relatime 0 0
proc /proc proc rw,nosuid,nodev,noexec,relatime 0 0
udev /dev devtmpfs rw,relatime,size=1966948k,nr_inodes=491737,mode=755 0 0
devpts /dev/pts devpts rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000 0 0
tmpfs /run tmpfs rw,nosuid,relatime,size=788076k,mode=755 0 0
/dev/sda2 /host fuseblk
rw,nosuid,nodev,relatime,user_id=0,group_id=0,allow_other,blksize=4096
0 0
/dev/loop0 / ext4 rw,relatime,errors=remount-ro,data=ordered 0 0
none /sys/fs/fuse/connections fusectl rw,relatime 0 0
none /sys/kernel/debug debugfs rw,relatime 0 0
none /sys/kernel/security securityfs rw,relatime 0 0
none /run/lock tmpfs rw,nosuid,nodev,noexec,relatime,size=5120k 0 0
none /run/shm tmpfs rw,nosuid,nodev,relatime 0 0
gvfs-fuse-daemon /home/wearefam/.gvfs fuse.gvfs-fuse-daemon
rw,nosuid,nodev,relatime,user_id=1000,group_id=1000 0 0

$ sudo losetup --all --verbose
/dev/loop0: [0802]:17982 (/host/ubuntu/disks/root.disk)

$ sudo losetup --find --verbose
Loop device is /dev/loop1
/dev/loop1

[ /etc/fstab ]
# /etc/fstab: static file system information.

# Use 'blkid' to print the universally unique identifier for a
# device; this may be used with UUID= as a more robust way to name devices
# that works even if disks are added and removed. See fstab(5).

# <file system> <mount point> <type> <options>
<dump> <pass>
proc /proc proc
nodev,noexec,nosuid 0 0
/host/ubuntu/disks/root.disk / ext4
loop,errors=remount-ro 0 1
/host/ubuntu/disks/swap.disk none swap loop,sw
0 0
- EOF -

[ /boot/grub/grub.cfg ]
...
menuentry 'Ubuntu, mit Linux 3.8.0-rc4-next20130121-1-iniza-generic'
--class ubuntu --class gnu-linux --class gnu --class os {
set gfxpayload=$linux_gfx_mode
insmod part_msdos
insmod ntfs
set root='(hd0,msdos2)'
search --no-floppy --fs-uuid --set=root 001AADA61AAD9964
loopback loop0 /ubuntu/disks/root.disk
set root=(loop0)
linux /boot/vmlinuz-3.8.0-rc4-next20130121-1-iniza-generic
root=UUID=001AADA61AAD9964 loop=/ubuntu/disks/root.disk ro
initrd /boot/initrd.img-3.8.0-rc4-next20130121-1-iniza-generic
}
...

Hope this helps you!

Regards,
- Sedat -

> Honza
> --
> Jan Kara <jack@suse.cz>
> SUSE Labs, CR
Jan 21 08:11:23 fambox NetworkManager[1132]: <info> sleep requested (sleeping: no enabled: yes)
Jan 21 08:11:23 fambox NetworkManager[1132]: <info> sleeping or disabling...
Jan 21 08:11:23 fambox NetworkManager[1132]: <info> (wlan0): now unmanaged
Jan 21 08:11:23 fambox NetworkManager[1132]: <info> (wlan0): device state change: activated -> unmanaged (reason 'sleeping') [100 10 37]
Jan 21 08:11:23 fambox NetworkManager[1132]: <info> (wlan0): deactivating device (reason 'sleeping') [37]
Jan 21 08:11:23 fambox NetworkManager[1132]: <info> (wlan0): canceled DHCP transaction, DHCP client pid 1516
Jan 21 08:11:23 fambox kernel: [ 244.792739] wlan0: deauthenticating from 00:04:0e:e4:00:3d by local choice (reason=3)
Jan 21 08:11:23 fambox avahi-daemon[1031]: Withdrawing address record for 192.168.178.22 on wlan0.
Jan 21 08:11:23 fambox avahi-daemon[1031]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.22.
Jan 21 08:11:23 fambox dnsmasq[1760]: exiting on receipt of SIGTERM
Jan 21 08:11:23 fambox avahi-daemon[1031]: Interface wlan0.IPv4 no longer relevant for mDNS.
Jan 21 08:11:23 fambox avahi-daemon[1031]: Withdrawing address record for 2001:4dd0:f889:0:419:23bf:c9c3:c4da on wlan0.
Jan 21 08:11:23 fambox avahi-daemon[1031]: Leaving mDNS multicast group on interface wlan0.IPv6 with address 2001:4dd0:f889:0:419:23bf:c9c3:c4da.
Jan 21 08:11:23 fambox avahi-daemon[1031]: Joining mDNS multicast group on interface wlan0.IPv6 with address 2001:4dd0:f889:0:8a53:2eff:feac:c312.
Jan 21 08:11:23 fambox kernel: [ 244.806345] cfg80211: Calling CRDA to update world regulatory domain
Jan 21 08:11:23 fambox avahi-daemon[1031]: Withdrawing address record for 2001:4dd0:f889:0:8a53:2eff:feac:c312 on wlan0.
Jan 21 08:11:23 fambox avahi-daemon[1031]: Leaving mDNS multicast group on interface wlan0.IPv6 with address 2001:4dd0:f889:0:8a53:2eff:feac:c312.
Jan 21 08:11:23 fambox avahi-daemon[1031]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::8a53:2eff:feac:c312.
Jan 21 08:11:23 fambox avahi-daemon[1031]: Registering new address record for fe80::8a53:2eff:feac:c312 on wlan0.*.
Jan 21 08:11:23 fambox NetworkManager[1132]: <info> DNS: starting dnsmasq...
Jan 21 08:11:23 fambox NetworkManager[1132]: <info> (wlan0): writing resolv.conf to /sbin/resolvconf
Jan 21 08:11:23 fambox wpa_supplicant[1394]: wlan0: CTRL-EVENT-DISCONNECTED bssid=00:00:00:00:00:00 reason=3
Jan 21 08:11:24 fambox kernel: [ 244.816996] cfg80211: World regulatory domain updated:
Jan 21 08:11:24 fambox kernel: [ 244.817007] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Jan 21 08:11:24 fambox kernel: [ 244.817013] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Jan 21 08:11:24 fambox kernel: [ 244.817018] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Jan 21 08:11:24 fambox kernel: [ 244.817021] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Jan 21 08:11:24 fambox kernel: [ 244.817025] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Jan 21 08:11:24 fambox kernel: [ 244.817028] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Jan 21 08:11:24 fambox dnsmasq[2380]: started, version 2.59 cache disabled
Jan 21 08:11:24 fambox dnsmasq[2380]: compile time options: IPv6 GNU-getopt DBus i18n DHCP TFTP conntrack IDN
Jan 21 08:11:24 fambox dnsmasq[2380]: warning: no upstream servers configured
Jan 21 08:11:24 fambox dnsmasq[2380]: exiting on receipt of SIGTERM
Jan 21 08:11:24 fambox NetworkManager[1132]: <info> DNS: starting dnsmasq...
Jan 21 08:11:24 fambox NetworkManager[1132]: <info> (wlan0): writing resolv.conf to /sbin/resolvconf
Jan 21 08:11:24 fambox dnsmasq[2416]: started, version 2.59 cache disabled
Jan 21 08:11:24 fambox dnsmasq[2416]: compile time options: IPv6 GNU-getopt DBus i18n DHCP TFTP conntrack IDN
Jan 21 08:11:24 fambox dnsmasq[2416]: warning: no upstream servers configured
Jan 21 08:11:24 fambox NetworkManager[1132]: <info> (wlan0): cleaning up...
Jan 21 08:11:24 fambox NetworkManager[1132]: <info> (wlan0): taking down device.
Jan 21 08:11:24 fambox avahi-daemon[1031]: Interface wlan0.IPv6 no longer relevant for mDNS.
Jan 21 08:11:24 fambox avahi-daemon[1031]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::8a53:2eff:feac:c312.
Jan 21 08:11:24 fambox avahi-daemon[1031]: Withdrawing address record for fe80::8a53:2eff:feac:c312 on wlan0.
Jan 21 08:11:24 fambox dbus[865]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
Jan 21 08:11:24 fambox dbus[865]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Jan 21 08:11:25 fambox kernel: [ 246.688282] PM: Syncing filesystems ... done.
Jan 21 08:11:25 fambox kernel: [ 246.693207] PM: Preparing system for mem sleep
Jan 21 08:11:38 fambox kernel: [ 248.377923] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:11:38 fambox kernel: [ 248.393228] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:11:38 fambox kernel: [ 248.409192] PM: Entering mem sleep
Jan 21 08:11:38 fambox kernel: [ 248.409256] Suspending console(s) (use no_console_suspend to debug)
Jan 21 08:11:38 fambox kernel: [ 248.409485] sd 1:0:0:0: [sdb] Synchronizing SCSI cache
Jan 21 08:11:38 fambox kernel: [ 248.409534] sd 0:0:0:0: [sda] Synchronizing SCSI cache
Jan 21 08:11:38 fambox kernel: [ 248.409692] sd 0:0:0:0: [sda] Stopping disk
Jan 21 08:11:38 fambox kernel: [ 248.412157] sd 1:0:0:0: [sdb] Stopping disk
Jan 21 08:11:38 fambox kernel: [ 249.028442] PM: suspend of devices complete after 619.821 msecs
Jan 21 08:11:38 fambox kernel: [ 249.028587] PM: late suspend of devices complete after 0.143 msecs
Jan 21 08:11:38 fambox kernel: [ 249.044387] r8169 0000:02:00.0: System wakeup enabled by ACPI
Jan 21 08:11:38 fambox kernel: [ 249.124225] PM: noirq suspend of devices complete after 95.750 msecs
Jan 21 08:11:38 fambox kernel: [ 249.124491] ACPI: Preparing to enter system sleep state S3
Jan 21 08:11:38 fambox kernel: [ 249.148265] PM: Saving platform NVS memory
Jan 21 08:11:38 fambox kernel: [ 249.153095] Disabling non-boot CPUs ...
Jan 21 08:11:38 fambox kernel: [ 249.256055] smpboot: CPU 1 is now offline
Jan 21 08:11:38 fambox kernel: [ 249.359925] smpboot: CPU 2 is now offline
Jan 21 08:11:38 fambox kernel: [ 249.360418] Broke affinity for irq 23
Jan 21 08:11:38 fambox kernel: [ 249.463784] smpboot: CPU 3 is now offline
Jan 21 08:11:38 fambox kernel: [ 249.464123] Extended CMOS year: 2000
Jan 21 08:11:38 fambox kernel: [ 249.465361] ACPI: Low-level resume complete
Jan 21 08:11:38 fambox kernel: [ 249.465404] PM: Restoring platform NVS memory
Jan 21 08:11:38 fambox kernel: [ 249.466621] Extended CMOS year: 2000
Jan 21 08:11:38 fambox kernel: [ 249.466693] Enabling non-boot CPUs ...
Jan 21 08:11:38 fambox kernel: [ 249.466771] smpboot: Booting Node 0 Processor 1 APIC 0x1
Jan 21 08:11:38 fambox kernel: [ 249.477873] Disabled fast string operations
Jan 21 08:11:38 fambox kernel: [ 249.480182] CPU1 is up
Jan 21 08:11:38 fambox kernel: [ 249.480252] smpboot: Booting Node 0 Processor 2 APIC 0x2
Jan 21 08:11:38 fambox kernel: [ 249.491287] Disabled fast string operations
Jan 21 08:11:38 fambox kernel: [ 249.493605] CPU2 is up
Jan 21 08:11:38 fambox kernel: [ 249.493676] smpboot: Booting Node 0 Processor 3 APIC 0x3
Jan 21 08:11:38 fambox kernel: [ 249.504712] Disabled fast string operations
Jan 21 08:11:38 fambox kernel: [ 249.507110] CPU3 is up
Jan 21 08:11:38 fambox kernel: [ 249.511892] ACPI: Waking up from system sleep state S3
Jan 21 08:11:38 fambox kernel: [ 249.706123] PM: noirq resume of devices complete after 144.003 msecs
Jan 21 08:11:38 fambox kernel: [ 249.706274] PM: early resume of devices complete after 0.111 msecs
Jan 21 08:11:38 fambox kernel: [ 249.706310] i915 0000:00:02.0: setting latency timer to 64
Jan 21 08:11:38 fambox kernel: [ 249.706333] ehci-pci 0000:00:1a.0: setting latency timer to 64
Jan 21 08:11:38 fambox kernel: [ 249.706387] mei 0000:00:16.0: irq 47 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.706429] ehci-pci 0000:00:1d.0: setting latency timer to 64
Jan 21 08:11:38 fambox kernel: [ 249.706447] snd_hda_intel 0000:00:1b.0: irq 50 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.706508] r8169 0000:02:00.0: System wakeup disabled by ACPI
Jan 21 08:11:38 fambox kernel: [ 249.706622] usb usb3: root hub lost power or was reset
Jan 21 08:11:38 fambox kernel: [ 249.706624] usb usb4: root hub lost power or was reset
Jan 21 08:11:38 fambox kernel: [ 249.706626] iwlwifi 0000:01:00.0: RF_KILL bit toggled to enable radio.
Jan 21 08:11:38 fambox kernel: [ 249.706686] ahci 0000:00:1f.2: setting latency timer to 64
Jan 21 08:11:38 fambox kernel: [ 249.711344] xhci_hcd 0000:03:00.0: irq 41 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.711352] xhci_hcd 0000:03:00.0: irq 42 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.711360] xhci_hcd 0000:03:00.0: irq 43 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.711369] xhci_hcd 0000:03:00.0: irq 44 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.711376] xhci_hcd 0000:03:00.0: irq 45 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 250.041632] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Jan 21 08:11:38 fambox kernel: [ 250.045709] ata2.00: configured for UDMA/133
Jan 21 08:11:38 fambox kernel: [ 250.049618] ata4: SATA link down (SStatus 0 SControl 300)
Jan 21 08:11:38 fambox kernel: [ 250.057610] ata5: SATA link down (SStatus 0 SControl 300)
Jan 21 08:11:38 fambox kernel: [ 250.061687] sd 1:0:0:0: [sdb] Starting disk
Jan 21 08:11:38 fambox kernel: [ 250.117763] usb 1-1.2: reset low-speed USB device number 3 using ehci-pci
Jan 21 08:11:38 fambox kernel: [ 250.469164] usb 1-1.4: reset high-speed USB device number 4 using ehci-pci
Jan 21 08:11:38 fambox kernel: [ 251.528028] [drm] Enabling RC6 states: RC6 on, RC6p off, RC6pp off
Jan 21 08:11:38 fambox kernel: [ 252.079185] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Jan 21 08:11:38 fambox kernel: [ 252.081625] ata1.00: configured for UDMA/133
Jan 21 08:11:38 fambox kernel: [ 252.095265] sd 0:0:0:0: [sda] Starting disk
Jan 21 08:11:38 fambox kernel: [ 252.097227] Extended CMOS year: 2000
Jan 21 08:11:38 fambox kernel: [ 252.119773] PM: resume of devices complete after 2416.409 msecs
Jan 21 08:11:38 fambox kernel: [ 252.120213] PM: Finishing wakeup.
Jan 21 08:11:38 fambox kernel: [ 252.120216] Restarting tasks ... done.
Jan 21 08:11:38 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:11:38 fambox acpid: client connected from 1254[0:0]
Jan 21 08:11:38 fambox acpid: 1 client rule loaded
Jan 21 08:11:38 fambox kernel: [ 252.128944] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:11:38 fambox NetworkManager[1132]: <info> wake requested (sleeping: yes enabled: yes)
Jan 21 08:11:38 fambox NetworkManager[1132]: <info> waking up and re-enabling...
Jan 21 08:11:38 fambox NetworkManager[1132]: <info> WWAN now enabled by management service
Jan 21 08:11:38 fambox NetworkManager[1132]: <info> (wlan0): now managed
Jan 21 08:11:38 fambox NetworkManager[1132]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Jan 21 08:11:38 fambox NetworkManager[1132]: <info> (wlan0): bringing up device.
Jan 21 08:11:38 fambox kernel: [ 252.719180] iwlwifi 0000:01:00.0: L1 Enabled; Disabling L0S
Jan 21 08:11:38 fambox kernel: [ 252.726034] iwlwifi 0000:01:00.0: Radio type=0x1-0x2-0x0
Jan 21 08:11:39 fambox NetworkManager[1132]: <info> (wlan0): preparing device.
Jan 21 08:11:39 fambox NetworkManager[1132]: <info> (wlan0): deactivating device (reason 'managed') [2]
Jan 21 08:11:39 fambox NetworkManager[1132]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
Jan 21 08:11:39 NetworkManager[1132]: last message repeated 2 times
Jan 21 08:11:39 fambox kernel: [ 252.955108] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Jan 21 08:11:39 fambox NetworkManager[1132]: <info> (wlan0): supplicant interface state: starting -> ready
Jan 21 08:11:39 fambox NetworkManager[1132]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
Jan 21 08:11:39 fambox NetworkManager[1132]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
Jan 21 08:11:39 fambox NetworkManager[1132]: <info> (wlan0): supplicant interface state: ready -> inactive
Jan 21 08:11:39 fambox NetworkManager[1132]: <warn> Trying to remove a non-existant call id.
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Auto-activating connection 'myCastle-WLAN WPA (Wireless LAN)'.
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) starting connection 'myCastle-WLAN WPA (Wireless LAN)'
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0/wireless): access point 'myCastle-WLAN WPA (Wireless LAN)' has security, but secrets are required.
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> (wlan0): device state change: need-auth -> prepare (reason 'none') [60 40 0]
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0/wireless): connection 'myCastle-WLAN WPA (Wireless LAN)' has security, and secrets exist. No new secrets needed.
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Config: added 'ssid' value 'myCastle-WLAN WPA (Wireless LAN)'
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Config: added 'scan_ssid' value '1'
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Config: added 'key_mgmt' value 'WPA-PSK'
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Config: added 'psk' value '<omitted>'
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> Config: set interface ap_scan to 1
Jan 21 08:11:42 fambox NetworkManager[1132]: <info> (wlan0): supplicant interface state: inactive -> scanning
Jan 21 08:11:45 fambox wpa_supplicant[1394]: wlan0: SME: Trying to authenticate with 00:04:0e:e4:00:3d (SSID='myCastle-WLAN WPA (Wireless LAN)' freq=2442 MHz)
Jan 21 08:11:45 fambox kernel: [ 259.272806] wlan0: authenticate with 00:04:0e:e4:00:3d
Jan 21 08:11:45 fambox kernel: [ 259.281463] wlan0: send auth to 00:04:0e:e4:00:3d (try 1/3)
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> (wlan0): supplicant interface state: scanning -> authenticating
Jan 21 08:11:45 fambox wpa_supplicant[1394]: wlan0: Trying to associate with 00:04:0e:e4:00:3d (SSID='myCastle-WLAN WPA (Wireless LAN)' freq=2442 MHz)
Jan 21 08:11:45 fambox kernel: [ 259.283236] wlan0: authenticated
Jan 21 08:11:45 fambox kernel: [ 259.283530] iwlwifi 0000:01:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP
Jan 21 08:11:45 fambox kernel: [ 259.283541] iwlwifi 0000:01:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP
Jan 21 08:11:45 fambox kernel: [ 259.286367] wlan0: associate with 00:04:0e:e4:00:3d (try 1/3)
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> (wlan0): supplicant interface state: authenticating -> associating
Jan 21 08:11:45 fambox kernel: [ 259.290482] wlan0: RX AssocResp from 00:04:0e:e4:00:3d (capab=0x411 status=0 aid=1)
Jan 21 08:11:45 fambox kernel: [ 259.294170] wlan0: associated
Jan 21 08:11:45 fambox kernel: [ 259.294205] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Jan 21 08:11:45 fambox wpa_supplicant[1394]: wlan0: Associated with 00:04:0e:e4:00:3d
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> (wlan0): supplicant interface state: associating -> 4-way handshake
Jan 21 08:11:45 fambox wpa_supplicant[1394]: wlan0: WPA: Key negotiation completed with 00:04:0e:e4:00:3d [PTK=CCMP GTK=TKIP]
Jan 21 08:11:45 fambox wpa_supplicant[1394]: wlan0: CTRL-EVENT-CONNECTED - Connection to 00:04:0e:e4:00:3d completed (auth) [id=0 id_str=]
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> (wlan0): supplicant interface state: 4-way handshake -> completed
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> Activation (wlan0/wireless) Stage 2 of 5 (Device Configure) successful. Connected to wireless network 'myCastle-WLAN WPA (Wireless LAN)'.
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) scheduled.
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) started...
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> (wlan0): device state change: config -> ip-config (reason 'none') [50 70 0]
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> Unmanaged Device found; state CONNECTED forced. (see http://bugs.launchpad.net/bugs/191889)
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> Activation (wlan0) Beginning DHCPv4 transaction (timeout in 45 seconds)
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> dhclient started with pid 3137
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> Activation (wlan0) Beginning IP6 addrconf.
Jan 21 08:11:45 fambox dhclient: Internet Systems Consortium DHCP Client 4.1-ESV-R4
Jan 21 08:11:45 fambox dhclient: Copyright 2004-2011 Internet Systems Consortium.
Jan 21 08:11:45 fambox dhclient: All rights reserved.
Jan 21 08:11:45 fambox dhclient: For info, please visit https://www.isc.org/software/dhcp/
Jan 21 08:11:45 fambox dhclient:
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 3 of 5 (IP Configure Start) complete.
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> (wlan0): DHCPv4 state changed nbi -> preinit
Jan 21 08:11:45 fambox dhclient: Listening on LPF/wlan0/88:53:2e:ac:c3:12
Jan 21 08:11:45 fambox dhclient: Sending on LPF/wlan0/88:53:2e:ac:c3:12
Jan 21 08:11:45 fambox dhclient: Sending on Socket/fallback
Jan 21 08:11:45 fambox dhclient: DHCPREQUEST of 192.168.178.22 on wlan0 to 255.255.255.255 port 67
Jan 21 08:11:45 fambox dhclient: DHCPACK of 192.168.178.22 from 192.168.178.1
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> (wlan0): DHCPv4 state changed preinit -> reboot
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> address 192.168.178.22
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> prefix 24 (255.255.255.0)
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> gateway 192.168.178.1
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> nameserver '192.168.178.1'
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> domain name 'fritz.box'
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Configure Commit) scheduled...
Jan 21 08:11:45 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) started...
Jan 21 08:11:45 fambox avahi-daemon[1031]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.178.22.
Jan 21 08:11:45 fambox dhclient: bound to 192.168.178.22 -- renewal in 384734 seconds.
Jan 21 08:11:45 fambox avahi-daemon[1031]: New relevant interface wlan0.IPv4 for mDNS.
Jan 21 08:11:45 fambox avahi-daemon[1031]: Registering new address record for 192.168.178.22 on wlan0.IPv4.
Jan 21 08:11:46 fambox dnsmasq[2416]: exiting on receipt of SIGTERM
Jan 21 08:11:46 fambox NetworkManager[1132]: <info> DNS: starting dnsmasq...
Jan 21 08:11:46 fambox NetworkManager[1132]: <info> (wlan0): writing resolv.conf to /sbin/resolvconf
Jan 21 08:11:46 fambox dnsmasq[3140]: started, version 2.59 cache disabled
Jan 21 08:11:46 fambox dnsmasq[3140]: compile time options: IPv6 GNU-getopt DBus i18n DHCP TFTP conntrack IDN
Jan 21 08:11:46 fambox dnsmasq[3140]: using nameserver 192.168.178.1#53
Jan 21 08:11:46 fambox avahi-daemon[1031]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::8a53:2eff:feac:c312.
Jan 21 08:11:46 fambox avahi-daemon[1031]: New relevant interface wlan0.IPv6 for mDNS.
Jan 21 08:11:46 fambox avahi-daemon[1031]: Registering new address record for fe80::8a53:2eff:feac:c312 on wlan0.*.
Jan 21 08:11:46 fambox NetworkManager[1132]: <info> (wlan0): device state change: ip-config -> activated (reason 'none') [70 100 0]
Jan 21 08:11:46 fambox NetworkManager[1132]: <info> Policy set 'myCastle-WLAN WPA (Wireless LAN)' (wlan0) as default for IPv4 routing and DNS.
Jan 21 08:11:46 fambox NetworkManager[1132]: <info> Activation (wlan0) successful, device activated.
Jan 21 08:11:46 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 5 of 5 (IPv4 Commit) complete.
Jan 21 08:11:46 fambox dbus[865]: [system] Activating service name='org.freedesktop.nm_dispatcher' (using servicehelper)
Jan 21 08:11:46 fambox dbus[865]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Jan 21 08:11:47 fambox avahi-daemon[1031]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::8a53:2eff:feac:c312.
Jan 21 08:11:47 fambox avahi-daemon[1031]: Joining mDNS multicast group on interface wlan0.IPv6 with address 2001:4dd0:f889:0:419:23bf:c9c3:c4da.
Jan 21 08:11:47 fambox avahi-daemon[1031]: Registering new address record for 2001:4dd0:f889:0:419:23bf:c9c3:c4da on wlan0.*.
Jan 21 08:11:47 fambox avahi-daemon[1031]: Withdrawing address record for fe80::8a53:2eff:feac:c312 on wlan0.
Jan 21 08:11:47 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 5 of 5 (IPv6 Commit) scheduled...
Jan 21 08:11:47 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 5 of 5 (IPv6 Commit) started...
Jan 21 08:11:48 fambox avahi-daemon[1031]: Registering new address record for 2001:4dd0:f889:0:8a53:2eff:feac:c312 on wlan0.*.
Jan 21 08:11:48 fambox dnsmasq[3140]: exiting on receipt of SIGTERM
Jan 21 08:11:48 fambox NetworkManager[1132]: <info> DNS: starting dnsmasq...
Jan 21 08:11:48 fambox NetworkManager[1132]: <info> (wlan0): writing resolv.conf to /sbin/resolvconf
Jan 21 08:11:48 fambox dnsmasq[3216]: started, version 2.59 cache disabled
Jan 21 08:11:48 fambox dnsmasq[3216]: compile time options: IPv6 GNU-getopt DBus i18n DHCP TFTP conntrack IDN
Jan 21 08:11:48 fambox dnsmasq[3216]: using nameserver 192.168.178.1#53
Jan 21 08:11:48 fambox NetworkManager[1132]: <info> Policy set 'myCastle-WLAN WPA (Wireless LAN)' (wlan0) as default for IPv4 routing and DNS.
Jan 21 08:11:48 fambox NetworkManager[1132]: <info> Policy set 'myCastle-WLAN WPA (Wireless LAN)' (wlan0) as default for IPv6 routing and DNS.
Jan 21 08:11:48 fambox NetworkManager[1132]: <info> Activation (wlan0) Stage 5 of 5 (IPv6 Commit) complete.
Jan 21 08:11:55 fambox ntpdate[3201]: adjust time server 91.189.94.4 offset -0.148119 sec
Jan 21 08:12:33 fambox kernel: [ 307.235839] show_signal_msg: 36 callbacks suppressed
Jan 21 08:12:33 fambox kernel: [ 307.235844] firefox[3244]: segfault at 7fd133927428 ip 00007fd133908362 sp 00007fff8cfda778 error 7 in libGL.so.1.2.0[7fd133908000+7c000]
Jan 21 08:13:28 fambox kernel: [ 362.220464] PM: Syncing filesystems ... done.
Jan 21 08:13:28 fambox kernel: [ 362.385356] PM: Preparing system for mem sleep
Jan 21 08:13:37 fambox kernel: [ 366.625489] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:13:37 fambox kernel: [ 366.641644] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:13:37 fambox kernel: [ 366.657666] suspend debug: Waiting for 5 seconds.
Jan 21 08:13:37 fambox kernel: [ 371.614417] PM: Finishing wakeup.
Jan 21 08:13:37 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:13:37 fambox kernel: [ 371.614419] Restarting tasks ... done.
Jan 21 08:13:37 fambox kernel: [ 371.624384] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:13:37 fambox acpid: client connected from 1254[0:0]
Jan 21 08:13:37 fambox acpid: 1 client rule loaded
Jan 21 08:13:39 fambox kernel: [ 372.627309] PM: Syncing filesystems ... done.
Jan 21 08:13:39 fambox kernel: [ 372.769925] PM: Preparing system for mem sleep
Jan 21 08:13:46 fambox kernel: [ 375.343360] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:13:46 fambox kernel: [ 375.359732] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:13:46 fambox kernel: [ 375.375833] suspend debug: Waiting for 5 seconds.
Jan 21 08:13:46 fambox kernel: [ 380.332539] PM: Finishing wakeup.
Jan 21 08:13:46 fambox kernel: [ 380.332540] Restarting tasks ... done.
Jan 21 08:13:46 fambox kernel: [ 380.345274] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:13:46 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:13:46 fambox acpid: client connected from 1254[0:0]
Jan 21 08:13:46 fambox acpid: 1 client rule loaded
Jan 21 08:13:47 fambox kernel: [ 381.347598] PM: Syncing filesystems ... done.
Jan 21 08:13:47 fambox kernel: [ 381.612879] PM: Preparing system for mem sleep
Jan 21 08:13:56 fambox kernel: [ 384.777396] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:13:56 fambox kernel: [ 384.793742] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:13:56 fambox kernel: [ 384.809867] suspend debug: Waiting for 5 seconds.
Jan 21 08:13:56 fambox kernel: [ 389.766559] PM: Finishing wakeup.
Jan 21 08:13:56 fambox kernel: [ 389.766562] Restarting tasks ... done.
Jan 21 08:13:56 fambox kernel: [ 389.772358] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:13:56 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:13:56 fambox acpid: client connected from 1254[0:0]
Jan 21 08:13:56 fambox acpid: 1 client rule loaded
Jan 21 08:13:57 fambox kernel: [ 390.775105] PM: Syncing filesystems ... done.
Jan 21 08:13:57 fambox kernel: [ 391.052390] PM: Preparing system for mem sleep
Jan 21 08:14:04 fambox kernel: [ 393.723525] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:04 fambox kernel: [ 393.740009] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:04 fambox kernel: [ 393.756006] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:04 fambox kernel: [ 398.712691] PM: Finishing wakeup.
Jan 21 08:14:04 fambox kernel: [ 398.712693] Restarting tasks ... done.
Jan 21 08:14:04 fambox kernel: [ 398.720021] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:04 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:14:04 fambox acpid: client connected from 1254[0:0]
Jan 21 08:14:04 fambox acpid: 1 client rule loaded
Jan 21 08:14:06 fambox kernel: [ 399.721844] PM: Syncing filesystems ... done.
Jan 21 08:14:06 fambox kernel: [ 400.115853] PM: Preparing system for mem sleep
Jan 21 08:14:12 fambox kernel: [ 401.760938] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:12 fambox kernel: [ 401.774315] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:12 fambox kernel: [ 401.790297] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:12 fambox kernel: [ 406.746991] PM: Finishing wakeup.
Jan 21 08:14:12 fambox kernel: [ 406.746993] Restarting tasks ... done.
Jan 21 08:14:13 fambox kernel: [ 406.758469] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:13 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:14:13 fambox acpid: client connected from 1254[0:0]
Jan 21 08:14:13 fambox acpid: 1 client rule loaded
Jan 21 08:14:14 fambox kernel: [ 407.763922] PM: Syncing filesystems ... done.
Jan 21 08:14:14 fambox kernel: [ 407.867994] PM: Preparing system for mem sleep
Jan 21 08:14:22 fambox kernel: [ 410.811958] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:22 fambox kernel: [ 410.828400] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:22 fambox kernel: [ 410.844408] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:22 fambox kernel: [ 415.801093] PM: Finishing wakeup.
Jan 21 08:14:22 fambox AptDaemon: INFO: Quitting due to inactivity
Jan 21 08:14:22 fambox AptDaemon: INFO: Quitting was requested
Jan 21 08:14:22 fambox kernel: [ 415.801095] Restarting tasks ... done.
Jan 21 08:14:22 fambox kernel: [ 415.808417] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:22 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:14:22 fambox acpid: client connected from 1254[0:0]
Jan 21 08:14:22 fambox acpid: 1 client rule loaded
Jan 21 08:14:23 fambox kernel: [ 416.811223] PM: Syncing filesystems ... done.
Jan 21 08:14:23 fambox kernel: [ 416.909207] PM: Preparing system for mem sleep
Jan 21 08:14:30 fambox kernel: [ 418.902297] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:30 fambox kernel: [ 418.918607] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:30 fambox kernel: [ 418.934718] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:30 fambox kernel: [ 423.891419] PM: Finishing wakeup.
Jan 21 08:14:30 fambox kernel: [ 423.891421] Restarting tasks ... done.
Jan 21 08:14:30 fambox kernel: [ 423.897050] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:30 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:14:30 fambox acpid: client connected from 1254[0:0]
Jan 21 08:14:30 fambox acpid: 1 client rule loaded
Jan 21 08:14:31 fambox kernel: [ 424.902824] PM: Syncing filesystems ... done.
Jan 21 08:14:31 fambox kernel: [ 425.005597] PM: Preparing system for mem sleep
Jan 21 08:14:39 fambox kernel: [ 427.936413] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:39 fambox kernel: [ 427.952668] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:39 fambox kernel: [ 427.968820] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:39 fambox kernel: [ 432.925545] PM: Finishing wakeup.
Jan 21 08:14:39 fambox kernel: [ 432.925547] Restarting tasks ... done.
Jan 21 08:14:39 fambox kernel: [ 432.933531] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:39 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:14:39 fambox acpid: client connected from 1254[0:0]
Jan 21 08:14:39 fambox acpid: 1 client rule loaded
Jan 21 08:14:40 fambox kernel: [ 433.936467] PM: Syncing filesystems ... done.
Jan 21 08:14:40 fambox kernel: [ 434.309510] PM: Preparing system for mem sleep
Jan 21 08:14:48 fambox kernel: [ 436.806416] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:48 fambox kernel: [ 436.822973] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:48 fambox kernel: [ 436.838930] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:48 fambox kernel: [ 441.795587] PM: Finishing wakeup.
Jan 21 08:14:48 fambox kernel: [ 441.795589] Restarting tasks ... done.
Jan 21 08:14:48 fambox kernel: [ 441.801976] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:48 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:14:48 fambox acpid: client connected from 1254[0:0]
Jan 21 08:14:48 fambox acpid: 1 client rule loaded
Jan 21 08:14:49 fambox kernel: [ 442.804254] PM: Syncing filesystems ... done.
Jan 21 08:14:49 fambox kernel: [ 443.050353] PM: Preparing system for mem sleep
Jan 21 08:14:58 fambox kernel: [ 446.936427] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:58 fambox kernel: [ 446.952810] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:58 fambox kernel: [ 446.968839] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:58 fambox kernel: [ 451.925556] PM: Finishing wakeup.
Jan 21 08:14:58 fambox rtkit-daemon[1808]: The canary thread is apparently starving. Taking action.
Jan 21 08:14:58 fambox rtkit-daemon[1808]: Demoting known real-time threads.
Jan 21 08:14:58 fambox rtkit-daemon[1808]: Successfully demoted thread 1972 of process 1968 (n/a).
Jan 21 08:14:58 fambox rtkit-daemon[1808]: Successfully demoted thread 1969 of process 1968 (n/a).
Jan 21 08:14:58 fambox rtkit-daemon[1808]: Successfully demoted thread 1968 of process 1968 (n/a).
Jan 21 08:14:58 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:14:58 fambox rtkit-daemon[1808]: Demoted 3 threads.
Jan 21 08:14:58 fambox kernel: [ 451.925558] Restarting tasks ... done.
Jan 21 08:14:58 fambox kernel: [ 451.930859] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:58 fambox acpid: client connected from 1254[0:0]
Jan 21 08:14:58 fambox acpid: 1 client rule loaded
Jan 21 08:17:01 fambox CRON[3403]: (root) CMD ( cd / && run-parts --report /etc/cron.hourly)
Jan 21 08:17:37 fambox kernel: [ 611.195107] SGI XFS with ACLs, security attributes, realtime, large block/inode numbers, no debug enabled
Jan 21 08:17:37 fambox kernel: [ 611.276930] Btrfs loaded
Jan 21 08:17:37 fambox os-prober: debug: running /usr/lib/os-probes/50mounted-tests on /dev/sda1
Jan 21 08:17:38 fambox 50mounted-tests: debug: mounted using GRUB ntfs filesystem driver
Jan 21 08:17:38 fambox 50mounted-tests: debug: running subtest /usr/lib/os-probes/mounted/10freedos
Jan 21 08:17:38 fambox 10freedos: debug: /dev/sda1 is not a FAT partition: exiting
Jan 21 08:17:38 fambox 50mounted-tests: debug: running subtest /usr/lib/os-probes/mounted/10qnx
Jan 21 08:17:38 fambox 10qnx: debug: /dev/sda1 is not a QNX4 partition: exiting
Jan 21 08:17:38 fambox 50mounted-tests: debug: running subtest /usr/lib/os-probes/mounted/20macosx
Jan 21 08:17:38 fambox macosx-prober: debug: /dev/sda1 is not an HFS+ partition: exiting
Jan 21 08:17:38 fambox 50mounted-tests: debug: running subtest /usr/lib/os-probes/mounted/20microsoft
Jan 21 08:17:38 fambox 20microsoft: debug: /dev/sda1 is a NTFS partition
Jan 21 08:17:38 fambox 20microsoft: result: /dev/sda1:Windows 7 (loader):Windows:chain
Jan 21 08:17:38 fambox 50mounted-tests: debug: os found by subtest /usr/lib/os-probes/mounted/20microsoft
Jan 21 08:17:38 fambox os-prober: debug: os detected by /usr/lib/os-probes/50mounted-tests
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/10freedos on mounted /dev/sda2
Jan 21 08:17:38 fambox 10freedos: debug: /dev/sda2 is not a FAT partition: exiting
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/10qnx on mounted /dev/sda2
Jan 21 08:17:38 fambox 10qnx: debug: /dev/sda2 is not a QNX4 partition: exiting
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/20macosx on mounted /dev/sda2
Jan 21 08:17:38 fambox macosx-prober: debug: /dev/sda2 is not an HFS+ partition: exiting
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/20microsoft on mounted /dev/sda2
Jan 21 08:17:38 fambox 20microsoft: debug: /dev/sda2 is a FUSE partition
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/30utility on mounted /dev/sda2
Jan 21 08:17:38 fambox 30utility: debug: /dev/sda2 is not a FAT partition: exiting
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/40lsb on mounted /dev/sda2
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/70hurd on mounted /dev/sda2
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/80minix on mounted /dev/sda2
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/83haiku on mounted /dev/sda2
Jan 21 08:17:38 fambox 83haiku: debug: /dev/sda2 is not a BeFS partition: exiting
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/90bsd-distro on mounted /dev/sda2
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/90linux-distro on mounted /dev/sda2
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/mounted/90solaris on mounted /dev/sda2
Jan 21 08:17:38 fambox os-prober: debug: running /usr/lib/os-probes/50mounted-tests on /dev/sda3
Jan 21 08:17:38 fambox 50mounted-tests: debug: mounted using GRUB ntfs filesystem driver
Jan 21 08:17:38 fambox 50mounted-tests: debug: running subtest /usr/lib/os-probes/mounted/10freedos
Jan 21 08:17:38 fambox 10freedos: debug: /dev/sda3 is not a FAT partition: exiting
Jan 21 08:17:38 fambox 50mounted-tests: debug: running subtest /usr/lib/os-probes/mounted/10qnx
Jan 21 08:17:38 fambox 10qnx: debug: /dev/sda3 is not a QNX4 partition: exiting
Jan 21 08:17:38 fambox 50mounted-tests: debug: running subtest /usr/lib/os-probes/mounted/20macosx
Jan 21 08:17:38 fambox macosx-prober: debug: /dev/sda3 is not an HFS+ partition: exiting
Jan 21 08:17:38 fambox 50mounted-tests: debug: running subtest /usr/lib/os-probes/mounted/20microsoft
Jan 21 08:17:38 fambox 20microsoft: debug: /dev/sda3 is a NTFS partition
Jan 21 08:17:39 fambox 20microsoft: result: /dev/sda3:Windows Recovery Environment (loader):Windows1:chain
Jan 21 08:17:39 fambox 50mounted-tests: debug: os found by subtest /usr/lib/os-probes/mounted/20microsoft
Jan 21 08:17:39 fambox os-prober: debug: os detected by /usr/lib/os-probes/50mounted-tests
Jan 21 08:17:39 fambox os-prober: debug: running /usr/lib/os-probes/50mounted-tests on /dev/sdb1
Jan 21 08:17:39 fambox 50mounted-tests: debug: /dev/sdb1 type not recognised; skipping
Jan 21 08:17:39 fambox os-prober: debug: os detected by /usr/lib/os-probes/50mounted-tests
Jan 21 08:17:39 fambox os-prober: debug: running /usr/lib/os-probes/50mounted-tests on /dev/sdb2
Jan 21 08:17:39 fambox 50mounted-tests: debug: /dev/sdb2 type not recognised; skipping
Jan 21 08:17:39 fambox os-prober: debug: os detected by /usr/lib/os-probes/50mounted-tests
Jan 21 08:18:25 fambox kernel: [ 659.450269] PM: Syncing filesystems ... done.
Jan 21 08:18:25 fambox kernel: [ 659.560807] PM: Preparing system for mem sleep
Jan 21 08:18:52 fambox kernel: [ 666.004376] Freezing user space processes ...
Jan 21 08:18:52 fambox kernel: [ 686.014794] Freezing of tasks failed after 20.01 seconds (1 tasks refusing to freeze, wq_busy=0):
Jan 21 08:18:52 fambox kernel: [ 686.014926] cupsd D ffffffff8180d780 0 1044 1 0x00000004
Jan 21 08:18:52 fambox kernel: [ 686.014935] ffff880101a7be18 0000000000000046 ffff880101a7bdc8 0000000300000001
Jan 21 08:18:52 fambox kernel: [ 686.014944] ffff8801181b4560 ffff880101a7bfd8 ffff880101a7bfd8 ffff880101a7bfd8
Jan 21 08:18:52 fambox kernel: [ 686.014951] ffffffff81c15440 ffff8801181b4560 ffff880101a7be28 ffff88011857f800
Jan 21 08:18:52 fambox kernel: [ 686.014958] Call Trace:
Jan 21 08:18:52 fambox kernel: [ 686.014973] [<ffffffff816b7e39>] schedule+0x29/0x70
Jan 21 08:18:52 fambox kernel: [ 686.014985] [<ffffffff8128fdad>] jbd2_log_wait_commit+0xcd/0x1a0
Jan 21 08:18:52 fambox kernel: [ 686.014993] [<ffffffff8107eb90>] ? add_wait_queue+0x60/0x60
Jan 21 08:18:52 fambox kernel: [ 686.015001] [<ffffffff8122fed5>] ext4_sync_file+0x205/0x380
Jan 21 08:18:52 fambox kernel: [ 686.015009] [<ffffffff811c372d>] do_fsync+0x5d/0x90
Jan 21 08:18:52 fambox kernel: [ 686.015018] [<ffffffff81193792>] ? sys_write+0x52/0xa0
Jan 21 08:18:52 fambox kernel: [ 686.015024] [<ffffffff811c3b10>] sys_fsync+0x10/0x20
Jan 21 08:18:52 fambox kernel: [ 686.015031] [<ffffffff816c189d>] system_call_fastpath+0x1a/0x1f
Jan 21 08:18:52 fambox kernel: [ 686.015093]
Jan 21 08:18:52 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:18:52 fambox rtkit-daemon[1808]: The canary thread is apparently starving. Taking action.
Jan 21 08:18:52 fambox rtkit-daemon[1808]: Demoting known real-time threads.
Jan 21 08:18:52 fambox rtkit-daemon[1808]: Successfully demoted thread 1972 of process 1968 (n/a).
Jan 21 08:18:52 fambox rtkit-daemon[1808]: Successfully demoted thread 1969 of process 1968 (n/a).
Jan 21 08:18:52 fambox rtkit-daemon[1808]: Successfully demoted thread 1968 of process 1968 (n/a).
Jan 21 08:18:52 fambox rtkit-daemon[1808]: Demoted 3 threads.
Jan 21 08:18:52 fambox kernel: [ 686.015096] Restarting tasks ... done.
Jan 21 08:18:52 fambox kernel: [ 686.024031] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:18:52 fambox acpid: client connected from 1254[0:0]
Jan 21 08:18:52 fambox acpid: 1 client rule loaded
Jan 21 08:18:52 fambox kernel: [ 686.024594] PM: Syncing filesystems ... done.
Jan 21 08:18:52 fambox kernel: [ 686.528387] PM: Preparing system for mem sleep
Jan 21 08:19:00 fambox kernel: [ 689.389593] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:19:00 fambox kernel: [ 689.406076] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:19:00 fambox kernel: [ 689.422109] suspend debug: Waiting for 5 seconds.
Jan 21 08:19:00 fambox kernel: [ 694.378815] PM: Finishing wakeup.
Jan 21 08:19:00 fambox kernel: [ 694.378817] Restarting tasks ... done.
Jan 21 08:19:00 fambox kernel: [ 694.386261] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:19:00 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:19:00 fambox acpid: client connected from 1254[0:0]
Jan 21 08:19:00 fambox acpid: 1 client rule loaded
Jan 21 08:19:01 fambox kernel: [ 695.388216] PM: Syncing filesystems ... done.
Jan 21 08:19:01 fambox kernel: [ 695.669009] PM: Preparing system for mem sleep
Jan 21 08:19:09 fambox kernel: [ 698.663894] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:19:09 fambox kernel: [ 698.680202] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:19:09 fambox kernel: [ 698.696290] suspend debug: Waiting for 5 seconds.
Jan 21 08:19:09 fambox kernel: [ 703.652954] PM: Finishing wakeup.
Jan 21 08:19:09 fambox kernel: [ 703.652956] Restarting tasks ... done.
Jan 21 08:19:09 fambox kernel: [ 703.657023] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:19:09 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:19:09 fambox acpid: client connected from 1254[0:0]
Jan 21 08:19:09 fambox acpid: 1 client rule loaded
Jan 21 08:19:11 fambox kernel: [ 704.658252] PM: Syncing filesystems ... done.
Jan 21 08:19:11 fambox kernel: [ 704.773724] PM: Preparing system for mem sleep
Jan 21 08:19:36 fambox kernel: [ 709.879880] Freezing user space processes ... (elapsed 0.06 seconds) done.
Jan 21 08:19:36 fambox kernel: [ 709.944282] Freezing remaining freezable tasks ...
Jan 21 08:19:36 fambox kernel: [ 729.946099] Freezing of tasks failed after 20.01 seconds (1 tasks refusing to freeze, wq_busy=0):
Jan 21 08:19:36 fambox kernel: [ 729.946222] jbd2/loop0-8 D ffffffff8180d780 0 311 2 0x00000000
Jan 21 08:19:36 fambox kernel: [ 729.946231] ffff880115353b68 0000000000000046 ffff8801180f1720 0000000000000001
Jan 21 08:19:36 fambox kernel: [ 729.946240] ffff8801180f1720 ffff880115353fd8 ffff880115353fd8 ffff880115353fd8
Jan 21 08:19:36 fambox kernel: [ 729.946246] ffff880119b32e40 ffff8801180f1720 ffff880115353b68 ffff88011fa94738
Jan 21 08:19:36 fambox kernel: [ 729.946253] Call Trace:
Jan 21 08:19:36 fambox kernel: [ 729.946271] [<ffffffff811c5bb0>] ? __wait_on_buffer+0x30/0x30
Jan 21 08:19:36 fambox kernel: [ 729.946279] [<ffffffff816b7e39>] schedule+0x29/0x70
Jan 21 08:19:36 fambox kernel: [ 729.946285] [<ffffffff816b7f0f>] io_schedule+0x8f/0xd0
Jan 21 08:19:36 fambox kernel: [ 729.946292] [<ffffffff811c5bbe>] sleep_on_buffer+0xe/0x20
Jan 21 08:19:36 fambox kernel: [ 729.946301] [<ffffffff816b670f>] __wait_on_bit+0x5f/0x90
Jan 21 08:19:36 fambox kernel: [ 729.946308] [<ffffffff811c5271>] ? submit_bh+0x121/0x1e0
Jan 21 08:19:36 fambox kernel: [ 729.946315] [<ffffffff811c5bb0>] ? __wait_on_buffer+0x30/0x30
Jan 21 08:19:36 fambox kernel: [ 729.946323] [<ffffffff816b67bc>] out_of_line_wait_on_bit+0x7c/0x90
Jan 21 08:19:36 fambox kernel: [ 729.946331] [<ffffffff8107ebd0>] ? autoremove_wake_function+0x40/0x40
Jan 21 08:19:36 fambox kernel: [ 729.946338] [<ffffffff811c5bae>] __wait_on_buffer+0x2e/0x30
Jan 21 08:19:36 fambox kernel: [ 729.946347] [<ffffffff8128b75c>] jbd2_journal_commit_transaction+0x18cc/0x1d60
Jan 21 08:19:36 fambox kernel: [ 729.946355] [<ffffffff81093d78>] ? set_next_entity+0xa8/0xc0
Jan 21 08:19:36 fambox kernel: [ 729.946362] [<ffffffff816b8fce>] ? _raw_spin_lock_irqsave+0x2e/0x40
Jan 21 08:19:36 fambox kernel: [ 729.946370] [<ffffffff81069fcf>] ? try_to_del_timer_sync+0x4f/0x70
Jan 21 08:19:36 fambox kernel: [ 729.946380] [<ffffffff8128ff66>] kjournald2+0xd6/0x3e0
Jan 21 08:19:36 fambox kernel: [ 729.946386] [<ffffffff8107eb90>] ? add_wait_queue+0x60/0x60
Jan 21 08:19:36 fambox kernel: [ 729.946394] [<ffffffff8128fe90>] ? commit_timeout+0x10/0x10
Jan 21 08:19:36 fambox kernel: [ 729.946399] [<ffffffff8107dfa0>] kthread+0xc0/0xd0
Jan 21 08:19:36 fambox kernel: [ 729.946405] [<ffffffff8107dee0>] ? flush_kthread_worker+0xb0/0xb0
Jan 21 08:19:36 fambox kernel: [ 729.946412] [<ffffffff816c17ec>] ret_from_fork+0x7c/0xb0
Jan 21 08:19:36 fambox kernel: [ 729.946418] [<ffffffff8107dee0>] ? flush_kthread_worker+0xb0/0xb0
Jan 21 08:19:36 fambox kernel: [ 729.946481]
Jan 21 08:19:36 fambox kernel: [ 729.946484] Restarting kernel threads ... done.
Jan 21 08:19:36 fambox rtkit-daemon[1808]: The canary thread is apparently starving. Taking action.
Jan 21 08:19:36 fambox rtkit-daemon[1808]: Demoting known real-time threads.
Jan 21 08:19:36 fambox rtkit-daemon[1808]: Successfully demoted thread 1972 of process 1968 (n/a).
Jan 21 08:19:36 fambox rtkit-daemon[1808]: Successfully demoted thread 1969 of process 1968 (n/a).
Jan 21 08:19:36 fambox rtkit-daemon[1808]: Successfully demoted thread 1968 of process 1968 (n/a).
Jan 21 08:19:36 fambox rtkit-daemon[1808]: Demoted 3 threads.
Jan 21 08:19:36 fambox kernel: [ 729.946638] Restarting tasks ... done.
Jan 21 08:19:36 fambox kernel: [ 729.957292] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:19:36 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:19:36 fambox acpid: client connected from 1254[0:0]
Jan 21 08:19:36 fambox acpid: 1 client rule loaded
Jan 21 08:19:36 fambox kernel: [ 729.957655] PM: Syncing filesystems ... done.
Jan 21 08:19:36 fambox kernel: [ 730.090702] PM: Preparing system for mem sleep
Jan 21 08:19:46 fambox kernel: [ 735.049968] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:19:46 fambox kernel: [ 735.066344] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:19:46 fambox kernel: [ 735.082470] suspend debug: Waiting for 5 seconds.
Jan 21 08:19:46 fambox kernel: [ 740.039150] PM: Finishing wakeup.
Jan 21 08:19:46 fambox rtkit-daemon[1808]: The canary thread is apparently starving. Taking action.
Jan 21 08:19:46 fambox rtkit-daemon[1808]: Demoting known real-time threads.
Jan 21 08:19:46 fambox rtkit-daemon[1808]: Successfully demoted thread 1972 of process 1968 (n/a).
Jan 21 08:19:46 fambox rtkit-daemon[1808]: Successfully demoted thread 1969 of process 1968 (n/a).
Jan 21 08:19:46 fambox rtkit-daemon[1808]: Successfully demoted thread 1968 of process 1968 (n/a).
Jan 21 08:19:46 fambox rtkit-daemon[1808]: Demoted 3 threads.
Jan 21 08:19:46 fambox kernel: [ 740.039152] Restarting tasks ... done.
Jan 21 08:19:46 fambox kernel: [ 740.044754] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:19:46 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:19:46 fambox acpid: client connected from 1254[0:0]
Jan 21 08:19:46 fambox acpid: 1 client rule loaded
Jan 21 08:19:47 fambox kernel: [ 741.047618] PM: Syncing filesystems ... done.
Jan 21 08:19:47 fambox kernel: [ 741.144638] PM: Preparing system for mem sleep
Jan 21 08:20:12 fambox kernel: [ 746.474101] Freezing user space processes ... (elapsed 0.04 seconds) done.
Jan 21 08:20:12 fambox kernel: [ 746.522356] Freezing remaining freezable tasks ...
Jan 21 08:20:12 fambox kernel: [ 766.524155] Freezing of tasks failed after 20.01 seconds (1 tasks refusing to freeze, wq_busy=0):
Jan 21 08:20:12 fambox kernel: [ 766.524280] jbd2/loop0-8 D ffffffff8180d780 0 311 2 0x00000000
Jan 21 08:20:12 fambox kernel: [ 766.524289] ffff880115353b68 0000000000000046 ffff880115353b08 ffffffff81044c29
Jan 21 08:20:12 fambox kernel: [ 766.524297] ffff8801180f1720 ffff880115353fd8 ffff880115353fd8 ffff880115353fd8
Jan 21 08:20:12 fambox kernel: [ 766.524304] ffff880119b32e40 ffff8801180f1720 ffff880115353b68 ffff88011fa94738
Jan 21 08:20:12 fambox kernel: [ 766.524311] Call Trace:
Jan 21 08:20:12 fambox kernel: [ 766.524330] [<ffffffff81044c29>] ? default_spin_lock_flags+0x9/0x10
Jan 21 08:20:12 fambox kernel: [ 766.524340] [<ffffffff811c5bb0>] ? __wait_on_buffer+0x30/0x30
Jan 21 08:20:12 fambox kernel: [ 766.524349] [<ffffffff816b7e39>] schedule+0x29/0x70
Jan 21 08:20:12 fambox kernel: [ 766.524355] [<ffffffff816b7f0f>] io_schedule+0x8f/0xd0
Jan 21 08:20:12 fambox kernel: [ 766.524361] [<ffffffff811c5bbe>] sleep_on_buffer+0xe/0x20
Jan 21 08:20:12 fambox kernel: [ 766.524371] [<ffffffff816b670f>] __wait_on_bit+0x5f/0x90
Jan 21 08:20:12 fambox kernel: [ 766.524378] [<ffffffff811c5271>] ? submit_bh+0x121/0x1e0
Jan 21 08:20:12 fambox kernel: [ 766.524384] [<ffffffff811c5bb0>] ? __wait_on_buffer+0x30/0x30
Jan 21 08:20:12 fambox kernel: [ 766.524392] [<ffffffff816b67bc>] out_of_line_wait_on_bit+0x7c/0x90
Jan 21 08:20:12 fambox kernel: [ 766.524400] [<ffffffff8107ebd0>] ? autoremove_wake_function+0x40/0x40
Jan 21 08:20:12 fambox kernel: [ 766.524407] [<ffffffff811c5bae>] __wait_on_buffer+0x2e/0x30
Jan 21 08:20:12 fambox kernel: [ 766.524417] [<ffffffff8128b75c>] jbd2_journal_commit_transaction+0x18cc/0x1d60
Jan 21 08:20:12 fambox kernel: [ 766.524425] [<ffffffff816b8fce>] ? _raw_spin_lock_irqsave+0x2e/0x40
Jan 21 08:20:12 fambox kernel: [ 766.524434] [<ffffffff81069fcf>] ? try_to_del_timer_sync+0x4f/0x70
Jan 21 08:20:12 fambox kernel: [ 766.524444] [<ffffffff8128ff66>] kjournald2+0xd6/0x3e0
Jan 21 08:20:12 fambox kernel: [ 766.524450] [<ffffffff8107eb90>] ? add_wait_queue+0x60/0x60
Jan 21 08:20:12 fambox kernel: [ 766.524458] [<ffffffff8128fe90>] ? commit_timeout+0x10/0x10
Jan 21 08:20:12 fambox kernel: [ 766.524463] [<ffffffff8107dfa0>] kthread+0xc0/0xd0
Jan 21 08:20:12 fambox kernel: [ 766.524469] [<ffffffff8107dee0>] ? flush_kthread_worker+0xb0/0xb0
Jan 21 08:20:12 fambox kernel: [ 766.524477] [<ffffffff816c17ec>] ret_from_fork+0x7c/0xb0
Jan 21 08:20:12 fambox kernel: [ 766.524482] [<ffffffff8107dee0>] ? flush_kthread_worker+0xb0/0xb0
Jan 21 08:20:12 fambox kernel: [ 766.524549]
Jan 21 08:20:12 fambox kernel: [ 766.524552] Restarting kernel threads ... done.
Jan 21 08:20:12 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:20:12 fambox rtkit-daemon[1808]: The canary thread is apparently starving. Taking action.
Jan 21 08:20:12 fambox rtkit-daemon[1808]: Demoting known real-time threads.
Jan 21 08:20:12 fambox rtkit-daemon[1808]: Successfully demoted thread 1972 of process 1968 (n/a).
Jan 21 08:20:12 fambox rtkit-daemon[1808]: Successfully demoted thread 1969 of process 1968 (n/a).
Jan 21 08:20:12 fambox rtkit-daemon[1808]: Successfully demoted thread 1968 of process 1968 (n/a).
Jan 21 08:20:12 fambox rtkit-daemon[1808]: Demoted 3 threads.
Jan 21 08:20:12 fambox kernel: [ 766.524709] Restarting tasks ... done.
Jan 21 08:20:12 fambox kernel: [ 766.536532] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:20:12 fambox acpid: client connected from 1254[0:0]
Jan 21 08:20:12 fambox acpid: 1 client rule loaded
Jan 21 08:20:13 fambox kernel: [ 766.537083] PM: Syncing filesystems ... done.
Jan 21 08:20:13 fambox kernel: [ 766.787883] PM: Preparing system for mem sleep
Jan 21 08:20:19 fambox kernel: [ 768.478192] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:20:19 fambox kernel: [ 768.494712] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:20:19 fambox kernel: [ 768.510734] suspend debug: Waiting for 5 seconds.
Jan 21 08:20:19 fambox kernel: [ 773.467417] PM: Finishing wakeup.
Jan 21 08:20:19 fambox kernel: [ 773.467420] Restarting tasks ... done.
Jan 21 08:20:19 fambox kernel: [ 773.472865] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:20:19 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:20:19 fambox acpid: client connected from 1254[0:0]
Jan 21 08:20:19 fambox acpid: 1 client rule loaded
Jan 21 08:20:20 fambox kernel: [ 774.477386] PM: Syncing filesystems ... done.
Jan 21 08:20:20 fambox kernel: [ 774.593585] PM: Preparing system for mem sleep
Jan 21 08:20:30 fambox kernel: [ 778.647805] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:20:30 fambox kernel: [ 778.663513] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:20:30 fambox kernel: [ 778.679553] suspend debug: Waiting for 5 seconds.
Jan 21 08:20:30 fambox kernel: [ 783.636254] PM: Finishing wakeup.
Jan 21 08:20:30 fambox rtkit-daemon[1808]: The canary thread is apparently starving. Taking action.
Jan 21 08:20:30 fambox rtkit-daemon[1808]: Demoting known real-time threads.
Jan 21 08:20:30 fambox rtkit-daemon[1808]: Successfully demoted thread 1972 of process 1968 (n/a).
Jan 21 08:20:30 fambox rtkit-daemon[1808]: Successfully demoted thread 1969 of process 1968 (n/a).
Jan 21 08:20:30 fambox rtkit-daemon[1808]: Successfully demoted thread 1968 of process 1968 (n/a).
Jan 21 08:20:30 fambox rtkit-daemon[1808]: Demoted 3 threads.
Jan 21 08:20:30 fambox kernel: [ 783.636256] Restarting tasks ... done.
Jan 21 08:20:30 fambox kernel: [ 783.641310] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:20:30 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:20:30 fambox acpid: client connected from 1254[0:0]
Jan 21 08:20:30 fambox acpid: 1 client rule loaded
Jan 21 08:20:31 fambox kernel: [ 784.643646] PM: Syncing filesystems ... done.
Jan 21 08:20:31 fambox kernel: [ 784.917006] PM: Preparing system for mem sleep
Jan 21 08:20:41 fambox kernel: [ 790.494656] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:20:41 fambox kernel: [ 790.511009] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:20:41 fambox kernel: [ 790.527184] suspend debug: Waiting for 5 seconds.
Jan 21 08:20:41 fambox kernel: [ 795.483884] PM: Finishing wakeup.
Jan 21 08:20:41 fambox kernel: [ 795.483885] Restarting tasks ... done.
Jan 21 08:20:41 fambox kernel: [ 795.490986] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:20:41 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:20:41 fambox acpid: client connected from 1254[0:0]
Jan 21 08:20:41 fambox acpid: 1 client rule loaded
Jan 21 08:20:43 fambox kernel: [ 796.494290] PM: Syncing filesystems ... done.
Jan 21 08:20:43 fambox kernel: [ 796.622749] PM: Preparing system for mem sleep
Jan 21 08:20:54 fambox kernel: [ 802.917838] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:20:54 fambox kernel: [ 802.934348] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:20:54 fambox kernel: [ 802.950288] suspend debug: Waiting for 5 seconds.
Jan 21 08:20:54 fambox kernel: [ 807.907038] PM: Finishing wakeup.
Jan 21 08:20:54 fambox rtkit-daemon[1808]: The canary thread is apparently starving. Taking action.
Jan 21 08:20:54 fambox rtkit-daemon[1808]: Demoting known real-time threads.
Jan 21 08:20:54 fambox rtkit-daemon[1808]: Successfully demoted thread 1972 of process 1968 (n/a).
Jan 21 08:20:54 fambox rtkit-daemon[1808]: Successfully demoted thread 1969 of process 1968 (n/a).
Jan 21 08:20:54 fambox rtkit-daemon[1808]: Successfully demoted thread 1968 of process 1968 (n/a).
Jan 21 08:20:54 fambox rtkit-daemon[1808]: Demoted 3 threads.
Jan 21 08:20:54 fambox kernel: [ 807.907040] Restarting tasks ... done.
Jan 21 08:20:54 fambox kernel: [ 807.915538] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:20:54 fambox acpid: client 1254[0:0] has disconnected
Jan 21 08:20:54 fambox acpid: client connected from 1254[0:0]
Jan 21 08:20:54 fambox acpid: 1 client rule loaded
Jan 21 08:22:18 fambox kernel: [ 892.419318] type=1400 audit(1358752938.864:24): apparmor="DENIED" operation="capable" parent=1 profile="/usr/sbin/cupsd" pid=1044 comm="cupsd" pid=1044 comm="cupsd" capability=36 capname="block_suspend"
[unhandled content-type:application/octet-stream][unhandled content-type:application/x-sh]Jan 21 08:11:23 fambox kernel: [ 244.792739] wlan0: deauthenticating from 00:04:0e:e4:00:3d by local choice (reason=3)
Jan 21 08:11:23 fambox kernel: [ 244.806345] cfg80211: Calling CRDA to update world regulatory domain
Jan 21 08:11:24 fambox kernel: [ 244.816996] cfg80211: World regulatory domain updated:
Jan 21 08:11:24 fambox kernel: [ 244.817007] cfg80211: (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
Jan 21 08:11:24 fambox kernel: [ 244.817013] cfg80211: (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Jan 21 08:11:24 fambox kernel: [ 244.817018] cfg80211: (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Jan 21 08:11:24 fambox kernel: [ 244.817021] cfg80211: (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
Jan 21 08:11:24 fambox kernel: [ 244.817025] cfg80211: (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Jan 21 08:11:24 fambox kernel: [ 244.817028] cfg80211: (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
Jan 21 08:11:25 fambox kernel: [ 246.688282] PM: Syncing filesystems ... done.
Jan 21 08:11:25 fambox kernel: [ 246.693207] PM: Preparing system for mem sleep
Jan 21 08:11:38 fambox kernel: [ 248.377923] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:11:38 fambox kernel: [ 248.393228] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:11:38 fambox kernel: [ 248.409192] PM: Entering mem sleep
Jan 21 08:11:38 fambox kernel: [ 248.409256] Suspending console(s) (use no_console_suspend to debug)
Jan 21 08:11:38 fambox kernel: [ 248.409485] sd 1:0:0:0: [sdb] Synchronizing SCSI cache
Jan 21 08:11:38 fambox kernel: [ 248.409534] sd 0:0:0:0: [sda] Synchronizing SCSI cache
Jan 21 08:11:38 fambox kernel: [ 248.409692] sd 0:0:0:0: [sda] Stopping disk
Jan 21 08:11:38 fambox kernel: [ 248.412157] sd 1:0:0:0: [sdb] Stopping disk
Jan 21 08:11:38 fambox kernel: [ 249.028442] PM: suspend of devices complete after 619.821 msecs
Jan 21 08:11:38 fambox kernel: [ 249.028587] PM: late suspend of devices complete after 0.143 msecs
Jan 21 08:11:38 fambox kernel: [ 249.044387] r8169 0000:02:00.0: System wakeup enabled by ACPI
Jan 21 08:11:38 fambox kernel: [ 249.124225] PM: noirq suspend of devices complete after 95.750 msecs
Jan 21 08:11:38 fambox kernel: [ 249.124491] ACPI: Preparing to enter system sleep state S3
Jan 21 08:11:38 fambox kernel: [ 249.148265] PM: Saving platform NVS memory
Jan 21 08:11:38 fambox kernel: [ 249.153095] Disabling non-boot CPUs ...
Jan 21 08:11:38 fambox kernel: [ 249.256055] smpboot: CPU 1 is now offline
Jan 21 08:11:38 fambox kernel: [ 249.359925] smpboot: CPU 2 is now offline
Jan 21 08:11:38 fambox kernel: [ 249.360418] Broke affinity for irq 23
Jan 21 08:11:38 fambox kernel: [ 249.463784] smpboot: CPU 3 is now offline
Jan 21 08:11:38 fambox kernel: [ 249.464123] Extended CMOS year: 2000
Jan 21 08:11:38 fambox kernel: [ 249.465361] ACPI: Low-level resume complete
Jan 21 08:11:38 fambox kernel: [ 249.465404] PM: Restoring platform NVS memory
Jan 21 08:11:38 fambox kernel: [ 249.466621] Extended CMOS year: 2000
Jan 21 08:11:38 fambox kernel: [ 249.466693] Enabling non-boot CPUs ...
Jan 21 08:11:38 fambox kernel: [ 249.466771] smpboot: Booting Node 0 Processor 1 APIC 0x1
Jan 21 08:11:38 fambox kernel: [ 249.477873] Disabled fast string operations
Jan 21 08:11:38 fambox kernel: [ 249.480182] CPU1 is up
Jan 21 08:11:38 fambox kernel: [ 249.480252] smpboot: Booting Node 0 Processor 2 APIC 0x2
Jan 21 08:11:38 fambox kernel: [ 249.491287] Disabled fast string operations
Jan 21 08:11:38 fambox kernel: [ 249.493605] CPU2 is up
Jan 21 08:11:38 fambox kernel: [ 249.493676] smpboot: Booting Node 0 Processor 3 APIC 0x3
Jan 21 08:11:38 fambox kernel: [ 249.504712] Disabled fast string operations
Jan 21 08:11:38 fambox kernel: [ 249.507110] CPU3 is up
Jan 21 08:11:38 fambox kernel: [ 249.511892] ACPI: Waking up from system sleep state S3
Jan 21 08:11:38 fambox kernel: [ 249.706123] PM: noirq resume of devices complete after 144.003 msecs
Jan 21 08:11:38 fambox kernel: [ 249.706274] PM: early resume of devices complete after 0.111 msecs
Jan 21 08:11:38 fambox kernel: [ 249.706310] i915 0000:00:02.0: setting latency timer to 64
Jan 21 08:11:38 fambox kernel: [ 249.706333] ehci-pci 0000:00:1a.0: setting latency timer to 64
Jan 21 08:11:38 fambox kernel: [ 249.706387] mei 0000:00:16.0: irq 47 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.706429] ehci-pci 0000:00:1d.0: setting latency timer to 64
Jan 21 08:11:38 fambox kernel: [ 249.706447] snd_hda_intel 0000:00:1b.0: irq 50 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.706508] r8169 0000:02:00.0: System wakeup disabled by ACPI
Jan 21 08:11:38 fambox kernel: [ 249.706622] usb usb3: root hub lost power or was reset
Jan 21 08:11:38 fambox kernel: [ 249.706624] usb usb4: root hub lost power or was reset
Jan 21 08:11:38 fambox kernel: [ 249.706626] iwlwifi 0000:01:00.0: RF_KILL bit toggled to enable radio.
Jan 21 08:11:38 fambox kernel: [ 249.706686] ahci 0000:00:1f.2: setting latency timer to 64
Jan 21 08:11:38 fambox kernel: [ 249.711344] xhci_hcd 0000:03:00.0: irq 41 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.711352] xhci_hcd 0000:03:00.0: irq 42 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.711360] xhci_hcd 0000:03:00.0: irq 43 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.711369] xhci_hcd 0000:03:00.0: irq 44 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 249.711376] xhci_hcd 0000:03:00.0: irq 45 for MSI/MSI-X
Jan 21 08:11:38 fambox kernel: [ 250.041632] ata2: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Jan 21 08:11:38 fambox kernel: [ 250.045709] ata2.00: configured for UDMA/133
Jan 21 08:11:38 fambox kernel: [ 250.049618] ata4: SATA link down (SStatus 0 SControl 300)
Jan 21 08:11:38 fambox kernel: [ 250.057610] ata5: SATA link down (SStatus 0 SControl 300)
Jan 21 08:11:38 fambox kernel: [ 250.061687] sd 1:0:0:0: [sdb] Starting disk
Jan 21 08:11:38 fambox kernel: [ 250.117763] usb 1-1.2: reset low-speed USB device number 3 using ehci-pci
Jan 21 08:11:38 fambox kernel: [ 250.469164] usb 1-1.4: reset high-speed USB device number 4 using ehci-pci
Jan 21 08:11:38 fambox kernel: [ 251.528028] [drm] Enabling RC6 states: RC6 on, RC6p off, RC6pp off
Jan 21 08:11:38 fambox kernel: [ 252.079185] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Jan 21 08:11:38 fambox kernel: [ 252.081625] ata1.00: configured for UDMA/133
Jan 21 08:11:38 fambox kernel: [ 252.095265] sd 0:0:0:0: [sda] Starting disk
Jan 21 08:11:38 fambox kernel: [ 252.097227] Extended CMOS year: 2000
Jan 21 08:11:38 fambox kernel: [ 252.119773] PM: resume of devices complete after 2416.409 msecs
Jan 21 08:11:38 fambox kernel: [ 252.120213] PM: Finishing wakeup.
Jan 21 08:11:38 fambox kernel: [ 252.120216] Restarting tasks ... done.
Jan 21 08:11:38 fambox kernel: [ 252.128944] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:11:38 fambox kernel: [ 252.719180] iwlwifi 0000:01:00.0: L1 Enabled; Disabling L0S
Jan 21 08:11:38 fambox kernel: [ 252.726034] iwlwifi 0000:01:00.0: Radio type=0x1-0x2-0x0
Jan 21 08:11:39 fambox kernel: [ 252.955108] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Jan 21 08:11:45 fambox kernel: [ 259.272806] wlan0: authenticate with 00:04:0e:e4:00:3d
Jan 21 08:11:45 fambox kernel: [ 259.281463] wlan0: send auth to 00:04:0e:e4:00:3d (try 1/3)
Jan 21 08:11:45 fambox kernel: [ 259.283236] wlan0: authenticated
Jan 21 08:11:45 fambox kernel: [ 259.283530] iwlwifi 0000:01:00.0 wlan0: disabling HT as WMM/QoS is not supported by the AP
Jan 21 08:11:45 fambox kernel: [ 259.283541] iwlwifi 0000:01:00.0 wlan0: disabling VHT as WMM/QoS is not supported by the AP
Jan 21 08:11:45 fambox kernel: [ 259.286367] wlan0: associate with 00:04:0e:e4:00:3d (try 1/3)
Jan 21 08:11:45 fambox kernel: [ 259.290482] wlan0: RX AssocResp from 00:04:0e:e4:00:3d (capab=0x411 status=0 aid=1)
Jan 21 08:11:45 fambox kernel: [ 259.294170] wlan0: associated
Jan 21 08:11:45 fambox kernel: [ 259.294205] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Jan 21 08:12:33 fambox kernel: [ 307.235839] show_signal_msg: 36 callbacks suppressed
Jan 21 08:12:33 fambox kernel: [ 307.235844] firefox[3244]: segfault at 7fd133927428 ip 00007fd133908362 sp 00007fff8cfda778 error 7 in libGL.so.1.2.0[7fd133908000+7c000]
Jan 21 08:13:28 fambox kernel: [ 362.220464] PM: Syncing filesystems ... done.
Jan 21 08:13:28 fambox kernel: [ 362.385356] PM: Preparing system for mem sleep
Jan 21 08:13:37 fambox kernel: [ 366.625489] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:13:37 fambox kernel: [ 366.641644] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:13:37 fambox kernel: [ 366.657666] suspend debug: Waiting for 5 seconds.
Jan 21 08:13:37 fambox kernel: [ 371.614417] PM: Finishing wakeup.
Jan 21 08:13:37 fambox kernel: [ 371.614419] Restarting tasks ... done.
Jan 21 08:13:37 fambox kernel: [ 371.624384] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:13:39 fambox kernel: [ 372.627309] PM: Syncing filesystems ... done.
Jan 21 08:13:39 fambox kernel: [ 372.769925] PM: Preparing system for mem sleep
Jan 21 08:13:46 fambox kernel: [ 375.343360] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:13:46 fambox kernel: [ 375.359732] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:13:46 fambox kernel: [ 375.375833] suspend debug: Waiting for 5 seconds.
Jan 21 08:13:46 fambox kernel: [ 380.332539] PM: Finishing wakeup.
Jan 21 08:13:46 fambox kernel: [ 380.332540] Restarting tasks ... done.
Jan 21 08:13:46 fambox kernel: [ 380.345274] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:13:47 fambox kernel: [ 381.347598] PM: Syncing filesystems ... done.
Jan 21 08:13:47 fambox kernel: [ 381.612879] PM: Preparing system for mem sleep
Jan 21 08:13:56 fambox kernel: [ 384.777396] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:13:56 fambox kernel: [ 384.793742] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:13:56 fambox kernel: [ 384.809867] suspend debug: Waiting for 5 seconds.
Jan 21 08:13:56 fambox kernel: [ 389.766559] PM: Finishing wakeup.
Jan 21 08:13:56 fambox kernel: [ 389.766562] Restarting tasks ... done.
Jan 21 08:13:56 fambox kernel: [ 389.772358] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:13:57 fambox kernel: [ 390.775105] PM: Syncing filesystems ... done.
Jan 21 08:13:57 fambox kernel: [ 391.052390] PM: Preparing system for mem sleep
Jan 21 08:14:04 fambox kernel: [ 393.723525] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:04 fambox kernel: [ 393.740009] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:04 fambox kernel: [ 393.756006] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:04 fambox kernel: [ 398.712691] PM: Finishing wakeup.
Jan 21 08:14:04 fambox kernel: [ 398.712693] Restarting tasks ... done.
Jan 21 08:14:04 fambox kernel: [ 398.720021] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:06 fambox kernel: [ 399.721844] PM: Syncing filesystems ... done.
Jan 21 08:14:06 fambox kernel: [ 400.115853] PM: Preparing system for mem sleep
Jan 21 08:14:12 fambox kernel: [ 401.760938] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:12 fambox kernel: [ 401.774315] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:12 fambox kernel: [ 401.790297] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:12 fambox kernel: [ 406.746991] PM: Finishing wakeup.
Jan 21 08:14:12 fambox kernel: [ 406.746993] Restarting tasks ... done.
Jan 21 08:14:13 fambox kernel: [ 406.758469] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:14 fambox kernel: [ 407.763922] PM: Syncing filesystems ... done.
Jan 21 08:14:14 fambox kernel: [ 407.867994] PM: Preparing system for mem sleep
Jan 21 08:14:22 fambox kernel: [ 410.811958] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:22 fambox kernel: [ 410.828400] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:22 fambox kernel: [ 410.844408] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:22 fambox kernel: [ 415.801093] PM: Finishing wakeup.
Jan 21 08:14:22 fambox kernel: [ 415.801095] Restarting tasks ... done.
Jan 21 08:14:22 fambox kernel: [ 415.808417] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:23 fambox kernel: [ 416.811223] PM: Syncing filesystems ... done.
Jan 21 08:14:23 fambox kernel: [ 416.909207] PM: Preparing system for mem sleep
Jan 21 08:14:30 fambox kernel: [ 418.902297] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:30 fambox kernel: [ 418.918607] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:30 fambox kernel: [ 418.934718] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:30 fambox kernel: [ 423.891419] PM: Finishing wakeup.
Jan 21 08:14:30 fambox kernel: [ 423.891421] Restarting tasks ... done.
Jan 21 08:14:30 fambox kernel: [ 423.897050] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:31 fambox kernel: [ 424.902824] PM: Syncing filesystems ... done.
Jan 21 08:14:31 fambox kernel: [ 425.005597] PM: Preparing system for mem sleep
Jan 21 08:14:39 fambox kernel: [ 427.936413] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:39 fambox kernel: [ 427.952668] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:39 fambox kernel: [ 427.968820] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:39 fambox kernel: [ 432.925545] PM: Finishing wakeup.
Jan 21 08:14:39 fambox kernel: [ 432.925547] Restarting tasks ... done.
Jan 21 08:14:39 fambox kernel: [ 432.933531] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:40 fambox kernel: [ 433.936467] PM: Syncing filesystems ... done.
Jan 21 08:14:40 fambox kernel: [ 434.309510] PM: Preparing system for mem sleep
Jan 21 08:14:48 fambox kernel: [ 436.806416] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:48 fambox kernel: [ 436.822973] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:48 fambox kernel: [ 436.838930] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:48 fambox kernel: [ 441.795587] PM: Finishing wakeup.
Jan 21 08:14:48 fambox kernel: [ 441.795589] Restarting tasks ... done.
Jan 21 08:14:48 fambox kernel: [ 441.801976] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:14:49 fambox kernel: [ 442.804254] PM: Syncing filesystems ... done.
Jan 21 08:14:49 fambox kernel: [ 443.050353] PM: Preparing system for mem sleep
Jan 21 08:14:58 fambox kernel: [ 446.936427] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:14:58 fambox kernel: [ 446.952810] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:14:58 fambox kernel: [ 446.968839] suspend debug: Waiting for 5 seconds.
Jan 21 08:14:58 fambox kernel: [ 451.925556] PM: Finishing wakeup.
Jan 21 08:14:58 fambox kernel: [ 451.925558] Restarting tasks ... done.
Jan 21 08:14:58 fambox kernel: [ 451.930859] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:17:37 fambox kernel: [ 611.195107] SGI XFS with ACLs, security attributes, realtime, large block/inode numbers, no debug enabled
Jan 21 08:17:37 fambox kernel: [ 611.276930] Btrfs loaded
Jan 21 08:18:25 fambox kernel: [ 659.450269] PM: Syncing filesystems ... done.
Jan 21 08:18:25 fambox kernel: [ 659.560807] PM: Preparing system for mem sleep
Jan 21 08:18:52 fambox kernel: [ 666.004376] Freezing user space processes ...
Jan 21 08:18:52 fambox kernel: [ 686.014794] Freezing of tasks failed after 20.01 seconds (1 tasks refusing to freeze, wq_busy=0):
Jan 21 08:18:52 fambox kernel: [ 686.014926] cupsd D ffffffff8180d780 0 1044 1 0x00000004
Jan 21 08:18:52 fambox kernel: [ 686.014935] ffff880101a7be18 0000000000000046 ffff880101a7bdc8 0000000300000001
Jan 21 08:18:52 fambox kernel: [ 686.014944] ffff8801181b4560 ffff880101a7bfd8 ffff880101a7bfd8 ffff880101a7bfd8
Jan 21 08:18:52 fambox kernel: [ 686.014951] ffffffff81c15440 ffff8801181b4560 ffff880101a7be28 ffff88011857f800
Jan 21 08:18:52 fambox kernel: [ 686.014958] Call Trace:
Jan 21 08:18:52 fambox kernel: [ 686.014973] [<ffffffff816b7e39>] schedule+0x29/0x70
Jan 21 08:18:52 fambox kernel: [ 686.014985] [<ffffffff8128fdad>] jbd2_log_wait_commit+0xcd/0x1a0
Jan 21 08:18:52 fambox kernel: [ 686.014993] [<ffffffff8107eb90>] ? add_wait_queue+0x60/0x60
Jan 21 08:18:52 fambox kernel: [ 686.015001] [<ffffffff8122fed5>] ext4_sync_file+0x205/0x380
Jan 21 08:18:52 fambox kernel: [ 686.015009] [<ffffffff811c372d>] do_fsync+0x5d/0x90
Jan 21 08:18:52 fambox kernel: [ 686.015018] [<ffffffff81193792>] ? sys_write+0x52/0xa0
Jan 21 08:18:52 fambox kernel: [ 686.015024] [<ffffffff811c3b10>] sys_fsync+0x10/0x20
Jan 21 08:18:52 fambox kernel: [ 686.015031] [<ffffffff816c189d>] system_call_fastpath+0x1a/0x1f
Jan 21 08:18:52 fambox kernel: [ 686.015093]
Jan 21 08:18:52 fambox kernel: [ 686.015096] Restarting tasks ... done.
Jan 21 08:18:52 fambox kernel: [ 686.024031] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:18:52 fambox kernel: [ 686.024594] PM: Syncing filesystems ... done.
Jan 21 08:18:52 fambox kernel: [ 686.528387] PM: Preparing system for mem sleep
Jan 21 08:19:00 fambox kernel: [ 689.389593] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:19:00 fambox kernel: [ 689.406076] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:19:00 fambox kernel: [ 689.422109] suspend debug: Waiting for 5 seconds.
Jan 21 08:19:00 fambox kernel: [ 694.378815] PM: Finishing wakeup.
Jan 21 08:19:00 fambox kernel: [ 694.378817] Restarting tasks ... done.
Jan 21 08:19:00 fambox kernel: [ 694.386261] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:19:01 fambox kernel: [ 695.388216] PM: Syncing filesystems ... done.
Jan 21 08:19:01 fambox kernel: [ 695.669009] PM: Preparing system for mem sleep
Jan 21 08:19:09 fambox kernel: [ 698.663894] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:19:09 fambox kernel: [ 698.680202] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:19:09 fambox kernel: [ 698.696290] suspend debug: Waiting for 5 seconds.
Jan 21 08:19:09 fambox kernel: [ 703.652954] PM: Finishing wakeup.
Jan 21 08:19:09 fambox kernel: [ 703.652956] Restarting tasks ... done.
Jan 21 08:19:09 fambox kernel: [ 703.657023] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:19:11 fambox kernel: [ 704.658252] PM: Syncing filesystems ... done.
Jan 21 08:19:11 fambox kernel: [ 704.773724] PM: Preparing system for mem sleep
Jan 21 08:19:36 fambox kernel: [ 709.879880] Freezing user space processes ... (elapsed 0.06 seconds) done.
Jan 21 08:19:36 fambox kernel: [ 709.944282] Freezing remaining freezable tasks ...
Jan 21 08:19:36 fambox kernel: [ 729.946099] Freezing of tasks failed after 20.01 seconds (1 tasks refusing to freeze, wq_busy=0):
Jan 21 08:19:36 fambox kernel: [ 729.946222] jbd2/loop0-8 D ffffffff8180d780 0 311 2 0x00000000
Jan 21 08:19:36 fambox kernel: [ 729.946231] ffff880115353b68 0000000000000046 ffff8801180f1720 0000000000000001
Jan 21 08:19:36 fambox kernel: [ 729.946240] ffff8801180f1720 ffff880115353fd8 ffff880115353fd8 ffff880115353fd8
Jan 21 08:19:36 fambox kernel: [ 729.946246] ffff880119b32e40 ffff8801180f1720 ffff880115353b68 ffff88011fa94738
Jan 21 08:19:36 fambox kernel: [ 729.946253] Call Trace:
Jan 21 08:19:36 fambox kernel: [ 729.946271] [<ffffffff811c5bb0>] ? __wait_on_buffer+0x30/0x30
Jan 21 08:19:36 fambox kernel: [ 729.946279] [<ffffffff816b7e39>] schedule+0x29/0x70
Jan 21 08:19:36 fambox kernel: [ 729.946285] [<ffffffff816b7f0f>] io_schedule+0x8f/0xd0
Jan 21 08:19:36 fambox kernel: [ 729.946292] [<ffffffff811c5bbe>] sleep_on_buffer+0xe/0x20
Jan 21 08:19:36 fambox kernel: [ 729.946301] [<ffffffff816b670f>] __wait_on_bit+0x5f/0x90
Jan 21 08:19:36 fambox kernel: [ 729.946308] [<ffffffff811c5271>] ? submit_bh+0x121/0x1e0
Jan 21 08:19:36 fambox kernel: [ 729.946315] [<ffffffff811c5bb0>] ? __wait_on_buffer+0x30/0x30
Jan 21 08:19:36 fambox kernel: [ 729.946323] [<ffffffff816b67bc>] out_of_line_wait_on_bit+0x7c/0x90
Jan 21 08:19:36 fambox kernel: [ 729.946331] [<ffffffff8107ebd0>] ? autoremove_wake_function+0x40/0x40
Jan 21 08:19:36 fambox kernel: [ 729.946338] [<ffffffff811c5bae>] __wait_on_buffer+0x2e/0x30
Jan 21 08:19:36 fambox kernel: [ 729.946347] [<ffffffff8128b75c>] jbd2_journal_commit_transaction+0x18cc/0x1d60
Jan 21 08:19:36 fambox kernel: [ 729.946355] [<ffffffff81093d78>] ? set_next_entity+0xa8/0xc0
Jan 21 08:19:36 fambox kernel: [ 729.946362] [<ffffffff816b8fce>] ? _raw_spin_lock_irqsave+0x2e/0x40
Jan 21 08:19:36 fambox kernel: [ 729.946370] [<ffffffff81069fcf>] ? try_to_del_timer_sync+0x4f/0x70
Jan 21 08:19:36 fambox kernel: [ 729.946380] [<ffffffff8128ff66>] kjournald2+0xd6/0x3e0
Jan 21 08:19:36 fambox kernel: [ 729.946386] [<ffffffff8107eb90>] ? add_wait_queue+0x60/0x60
Jan 21 08:19:36 fambox kernel: [ 729.946394] [<ffffffff8128fe90>] ? commit_timeout+0x10/0x10
Jan 21 08:19:36 fambox kernel: [ 729.946399] [<ffffffff8107dfa0>] kthread+0xc0/0xd0
Jan 21 08:19:36 fambox kernel: [ 729.946405] [<ffffffff8107dee0>] ? flush_kthread_worker+0xb0/0xb0
Jan 21 08:19:36 fambox kernel: [ 729.946412] [<ffffffff816c17ec>] ret_from_fork+0x7c/0xb0
Jan 21 08:19:36 fambox kernel: [ 729.946418] [<ffffffff8107dee0>] ? flush_kthread_worker+0xb0/0xb0
Jan 21 08:19:36 fambox kernel: [ 729.946481]
Jan 21 08:19:36 fambox kernel: [ 729.946484] Restarting kernel threads ... done.
Jan 21 08:19:36 fambox kernel: [ 729.946638] Restarting tasks ... done.
Jan 21 08:19:36 fambox kernel: [ 729.957292] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:19:36 fambox kernel: [ 729.957655] PM: Syncing filesystems ... done.
Jan 21 08:19:36 fambox kernel: [ 730.090702] PM: Preparing system for mem sleep
Jan 21 08:19:46 fambox kernel: [ 735.049968] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:19:46 fambox kernel: [ 735.066344] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:19:46 fambox kernel: [ 735.082470] suspend debug: Waiting for 5 seconds.
Jan 21 08:19:46 fambox kernel: [ 740.039150] PM: Finishing wakeup.
Jan 21 08:19:46 fambox kernel: [ 740.039152] Restarting tasks ... done.
Jan 21 08:19:46 fambox kernel: [ 740.044754] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:19:47 fambox kernel: [ 741.047618] PM: Syncing filesystems ... done.
Jan 21 08:19:47 fambox kernel: [ 741.144638] PM: Preparing system for mem sleep
Jan 21 08:20:12 fambox kernel: [ 746.474101] Freezing user space processes ... (elapsed 0.04 seconds) done.
Jan 21 08:20:12 fambox kernel: [ 746.522356] Freezing remaining freezable tasks ...
Jan 21 08:20:12 fambox kernel: [ 766.524155] Freezing of tasks failed after 20.01 seconds (1 tasks refusing to freeze, wq_busy=0):
Jan 21 08:20:12 fambox kernel: [ 766.524280] jbd2/loop0-8 D ffffffff8180d780 0 311 2 0x00000000
Jan 21 08:20:12 fambox kernel: [ 766.524289] ffff880115353b68 0000000000000046 ffff880115353b08 ffffffff81044c29
Jan 21 08:20:12 fambox kernel: [ 766.524297] ffff8801180f1720 ffff880115353fd8 ffff880115353fd8 ffff880115353fd8
Jan 21 08:20:12 fambox kernel: [ 766.524304] ffff880119b32e40 ffff8801180f1720 ffff880115353b68 ffff88011fa94738
Jan 21 08:20:12 fambox kernel: [ 766.524311] Call Trace:
Jan 21 08:20:12 fambox kernel: [ 766.524330] [<ffffffff81044c29>] ? default_spin_lock_flags+0x9/0x10
Jan 21 08:20:12 fambox kernel: [ 766.524340] [<ffffffff811c5bb0>] ? __wait_on_buffer+0x30/0x30
Jan 21 08:20:12 fambox kernel: [ 766.524349] [<ffffffff816b7e39>] schedule+0x29/0x70
Jan 21 08:20:12 fambox kernel: [ 766.524355] [<ffffffff816b7f0f>] io_schedule+0x8f/0xd0
Jan 21 08:20:12 fambox kernel: [ 766.524361] [<ffffffff811c5bbe>] sleep_on_buffer+0xe/0x20
Jan 21 08:20:12 fambox kernel: [ 766.524371] [<ffffffff816b670f>] __wait_on_bit+0x5f/0x90
Jan 21 08:20:12 fambox kernel: [ 766.524378] [<ffffffff811c5271>] ? submit_bh+0x121/0x1e0
Jan 21 08:20:12 fambox kernel: [ 766.524384] [<ffffffff811c5bb0>] ? __wait_on_buffer+0x30/0x30
Jan 21 08:20:12 fambox kernel: [ 766.524392] [<ffffffff816b67bc>] out_of_line_wait_on_bit+0x7c/0x90
Jan 21 08:20:12 fambox kernel: [ 766.524400] [<ffffffff8107ebd0>] ? autoremove_wake_function+0x40/0x40
Jan 21 08:20:12 fambox kernel: [ 766.524407] [<ffffffff811c5bae>] __wait_on_buffer+0x2e/0x30
Jan 21 08:20:12 fambox kernel: [ 766.524417] [<ffffffff8128b75c>] jbd2_journal_commit_transaction+0x18cc/0x1d60
Jan 21 08:20:12 fambox kernel: [ 766.524425] [<ffffffff816b8fce>] ? _raw_spin_lock_irqsave+0x2e/0x40
Jan 21 08:20:12 fambox kernel: [ 766.524434] [<ffffffff81069fcf>] ? try_to_del_timer_sync+0x4f/0x70
Jan 21 08:20:12 fambox kernel: [ 766.524444] [<ffffffff8128ff66>] kjournald2+0xd6/0x3e0
Jan 21 08:20:12 fambox kernel: [ 766.524450] [<ffffffff8107eb90>] ? add_wait_queue+0x60/0x60
Jan 21 08:20:12 fambox kernel: [ 766.524458] [<ffffffff8128fe90>] ? commit_timeout+0x10/0x10
Jan 21 08:20:12 fambox kernel: [ 766.524463] [<ffffffff8107dfa0>] kthread+0xc0/0xd0
Jan 21 08:20:12 fambox kernel: [ 766.524469] [<ffffffff8107dee0>] ? flush_kthread_worker+0xb0/0xb0
Jan 21 08:20:12 fambox kernel: [ 766.524477] [<ffffffff816c17ec>] ret_from_fork+0x7c/0xb0
Jan 21 08:20:12 fambox kernel: [ 766.524482] [<ffffffff8107dee0>] ? flush_kthread_worker+0xb0/0xb0
Jan 21 08:20:12 fambox kernel: [ 766.524549]
Jan 21 08:20:12 fambox kernel: [ 766.524552] Restarting kernel threads ... done.
Jan 21 08:20:12 fambox kernel: [ 766.524709] Restarting tasks ... done.
Jan 21 08:20:12 fambox kernel: [ 766.536532] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:20:13 fambox kernel: [ 766.537083] PM: Syncing filesystems ... done.
Jan 21 08:20:13 fambox kernel: [ 766.787883] PM: Preparing system for mem sleep
Jan 21 08:20:19 fambox kernel: [ 768.478192] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:20:19 fambox kernel: [ 768.494712] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:20:19 fambox kernel: [ 768.510734] suspend debug: Waiting for 5 seconds.
Jan 21 08:20:19 fambox kernel: [ 773.467417] PM: Finishing wakeup.
Jan 21 08:20:19 fambox kernel: [ 773.467420] Restarting tasks ... done.
Jan 21 08:20:19 fambox kernel: [ 773.472865] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:20:20 fambox kernel: [ 774.477386] PM: Syncing filesystems ... done.
Jan 21 08:20:20 fambox kernel: [ 774.593585] PM: Preparing system for mem sleep
Jan 21 08:20:30 fambox kernel: [ 778.647805] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:20:30 fambox kernel: [ 778.663513] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:20:30 fambox kernel: [ 778.679553] suspend debug: Waiting for 5 seconds.
Jan 21 08:20:30 fambox kernel: [ 783.636254] PM: Finishing wakeup.
Jan 21 08:20:30 fambox kernel: [ 783.636256] Restarting tasks ... done.
Jan 21 08:20:30 fambox kernel: [ 783.641310] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:20:31 fambox kernel: [ 784.643646] PM: Syncing filesystems ... done.
Jan 21 08:20:31 fambox kernel: [ 784.917006] PM: Preparing system for mem sleep
Jan 21 08:20:41 fambox kernel: [ 790.494656] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:20:41 fambox kernel: [ 790.511009] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:20:41 fambox kernel: [ 790.527184] suspend debug: Waiting for 5 seconds.
Jan 21 08:20:41 fambox kernel: [ 795.483884] PM: Finishing wakeup.
Jan 21 08:20:41 fambox kernel: [ 795.483885] Restarting tasks ... done.
Jan 21 08:20:41 fambox kernel: [ 795.490986] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:20:43 fambox kernel: [ 796.494290] PM: Syncing filesystems ... done.
Jan 21 08:20:43 fambox kernel: [ 796.622749] PM: Preparing system for mem sleep
Jan 21 08:20:54 fambox kernel: [ 802.917838] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jan 21 08:20:54 fambox kernel: [ 802.934348] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jan 21 08:20:54 fambox kernel: [ 802.950288] suspend debug: Waiting for 5 seconds.
Jan 21 08:20:54 fambox kernel: [ 807.907038] PM: Finishing wakeup.
Jan 21 08:20:54 fambox kernel: [ 807.907040] Restarting tasks ... done.
Jan 21 08:20:54 fambox kernel: [ 807.915538] video LNXVIDEO:00: Restoring backlight state
Jan 21 08:22:18 fambox kernel: [ 892.419318] type=1400 audit(1358752938.864:24): apparmor="DENIED" operation="capable" parent=1 profile="/usr/sbin/cupsd" pid=1044 comm="cupsd" pid=1044 comm="cupsd" capability=36 capname="block_suspend"
\
 
 \ /
  Last update: 2013-01-21 13:21    [W:0.113 / U:0.224 seconds]
©2003-2020 Jasper Spaans|hosted at Digital Ocean and TransIP|Read the blog|Advertise on this site