Jul 26 18:53:38 freed kernel: [509133.806214] PM: Syncing filesystems ... done.
Jul 26 19:16:31 freed kernel: [509134.388484] Freezing user space processes ... (elapsed 0.01 seconds) done.
Jul 26 19:16:31 freed kernel: [509134.400531] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
Jul 26 19:16:31 freed kernel: [509134.411616] Suspending console(s) (use no_console_suspend to debug)
Jul 26 19:16:31 freed kernel: [509134.576181] sd 0:0:0:0: [sda] Synchronizing SCSI cache
Jul 26 19:16:31 freed kernel: [509134.619364] sd 0:0:0:0: [sda] Stopping disk
Jul 26 19:16:31 freed kernel: [509134.647255] i915 0000:00:02.0: power state changed by ACPI to D3
Jul 26 19:16:31 freed kernel: [509134.655282] e1000e 0000:00:19.0: wake-up capability enabled by ACPI
Jul 26 19:16:31 freed kernel: [509135.009123] PM: suspend of devices complete after 597.697 msecs
Jul 26 19:16:31 freed kernel: [509135.009201] PM: late suspend of devices complete after 0.073 msecs
Jul 26 19:16:31 freed kernel: [509135.020216] ehci_hcd 0000:00:1d.0: wake-up capability enabled by ACPI
Jul 26 19:16:31 freed kernel: [509135.031048] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D3
Jul 26 19:16:31 freed kernel: [509135.031244] ehci_hcd 0000:00:1a.0: wake-up capability enabled by ACPI
Jul 26 19:16:31 freed kernel: [509135.042042] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D3
Jul 26 19:16:31 freed kernel: [509135.042151] PM: noirq suspend of devices complete after 32.965 msecs
Jul 26 19:16:31 freed kernel: [509135.042276] ACPI: Preparing to enter system sleep state S3
Jul 26 19:16:31 freed kernel: [509135.090070] PM: Saving platform NVS memory
Jul 26 19:16:31 freed kernel: [509135.094726] Disabling non-boot CPUs ...
Jul 26 19:16:31 freed kernel: [509135.096722] CPU 1 is now offline
Jul 26 19:16:31 freed kernel: [509135.097259] CPU 1 offline: Remove Rx thread
Jul 26 19:16:31 freed kernel: [509135.098890] CPU 2 is now offline
Jul 26 19:16:31 freed kernel: [509135.099300] CPU 2 offline: Remove Rx thread
Jul 26 19:16:31 freed kernel: [509135.100799] CPU 3 is now offline
Jul 26 19:16:31 freed kernel: [509135.101171] CPU 3 offline: Remove Rx thread
Jul 26 19:16:31 freed kernel: [509135.101304] Extended CMOS year: 2000
Jul 26 19:16:31 freed kernel: [509135.102015] ACPI: Low-level resume complete
Jul 26 19:16:31 freed kernel: [509135.102069] PM: Restoring platform NVS memory
Jul 26 19:16:31 freed kernel: [509135.102715] Extended CMOS year: 2000
Jul 26 19:16:31 freed kernel: [509135.102921] microcode: CPU0 updated to revision 0x3, date = 2011-09-01
Jul 26 19:16:31 freed kernel: [509135.102929] Enabling non-boot CPUs ...
Jul 26 19:16:31 freed kernel: [509135.103080] Booting Node 0 Processor 1 APIC 0x1
Jul 26 19:16:31 freed kernel: [509135.116430] NMI watchdog: enabled, takes one hw-pmu counter.
Jul 26 19:16:31 freed kernel: [509135.121606] microcode: CPU1 updated to revision 0x3, date = 2011-09-01
Jul 26 19:16:31 freed kernel: [509135.121611] bnx2i: CPU 1 online: Create Rx thread
Jul 26 19:16:31 freed kernel: [509135.121633] CPU1 is up
Jul 26 19:16:31 freed kernel: [509135.121695] Booting Node 0 Processor 2 APIC 0x4
Jul 26 19:16:31 freed kernel: [509135.135031] NMI watchdog: enabled, takes one hw-pmu counter.
Jul 26 19:16:31 freed kernel: [509135.139744] microcode: CPU2 updated to revision 0x3, date = 2011-09-01
Jul 26 19:16:31 freed kernel: [509135.139749] bnx2i: CPU 2 online: Create Rx thread
Jul 26 19:16:31 freed kernel: [509135.139820] CPU2 is up
Jul 26 19:16:31 freed kernel: [509135.139895] Booting Node 0 Processor 3 APIC 0x5
Jul 26 19:16:31 freed kernel: [509135.153435] NMI watchdog: enabled, takes one hw-pmu counter.
Jul 26 19:16:31 freed kernel: [509135.157859] microcode: CPU3 updated to revision 0x3, date = 2011-09-01
Jul 26 19:16:31 freed kernel: [509135.157865] bnx2i: CPU 3 online: Create Rx thread
Jul 26 19:16:31 freed kernel: [509135.157997] CPU3 is up
Jul 26 19:16:31 freed kernel: [509135.160739] ACPI: Waking up from system sleep state S3
Jul 26 19:16:31 freed kernel: [509135.236605] ehci_hcd 0000:00:1a.0: wake-up capability disabled by ACPI
Jul 26 19:16:31 freed kernel: [509135.236614] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
Jul 26 19:16:31 freed kernel: [509135.236618] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
Jul 26 19:16:31 freed kernel: [509135.236883] ehci_hcd 0000:00:1d.0: wake-up capability disabled by ACPI
Jul 26 19:16:31 freed kernel: [509135.236889] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
Jul 26 19:16:31 freed kernel: [509135.236893] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
Jul 26 19:16:31 freed kernel: [509135.237342] PM: noirq resume of devices complete after 1.001 msecs
Jul 26 19:16:31 freed kernel: [509135.237445] PM: early resume of devices complete after 0.036 msecs
Jul 26 19:16:31 freed kernel: [509135.237652] e1000e 0000:00:19.0: wake-up capability disabled by ACPI
Jul 26 19:16:31 freed kernel: [509135.237950] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
Jul 26 19:16:31 freed kernel: [509135.238029] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
Jul 26 19:16:31 freed kernel: [509135.239318] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
Jul 26 19:16:31 freed kernel: [509135.239417] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
Jul 26 19:16:31 freed kernel: [509135.239460] i915 0000:00:02.0: power state changed by ACPI to D0
Jul 26 19:16:31 freed kernel: [509135.239465] i915 0000:00:02.0: power state changed by ACPI to D0
Jul 26 19:16:31 freed kernel: [509135.471409] usb 1-1.6: reset high-speed USB device number 4 using ehci_hcd
Jul 26 19:16:31 freed kernel: [509135.544179] ata6: SATA link down (SStatus 0 SControl 300)
Jul 26 19:16:31 freed kernel: [509135.546178] ata2: SATA link down (SStatus 0 SControl 300)
Jul 26 19:16:31 freed kernel: [509135.550150] ata5: SATA link down (SStatus 0 SControl 300)
Jul 26 19:16:31 freed kernel: [509135.633332] usb 1-1.3: reset full-speed USB device number 3 using ehci_hcd
Jul 26 19:16:31 freed kernel: [509137.892863] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
Jul 26 19:16:31 freed kernel: [509138.084244] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Jul 26 19:16:31 freed kernel: [509138.084248] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Jul 26 19:16:31 freed kernel: [509138.088138] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
Jul 26 19:16:31 freed kernel: [509138.088143] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
Jul 26 19:16:31 freed kernel: [509138.089856] ata1.00: configured for UDMA/100
Jul 26 19:16:31 freed kernel: [509138.089990] sd 0:0:0:0: [sda] Starting disk
Jul 26 19:16:31 freed kernel: [509138.115150] PM: resume of devices complete after 2879.323 msecs
Jul 26 19:16:31 freed kernel: [509138.115254] Restarting tasks ... done.
Jul 26 19:16:31 freed kernel: [509138.129029] video LNXVIDEO:00: Restoring backlight state
Jul 26 19:16:31 freed udevd[483]: specified group 'plugdev' unknown
Jul 26 19:16:31 freed pulseaudio[6254]: [pulseaudio] module-alsa-card.c: Failed to find a working profile.
Jul 26 19:16:31 freed pulseaudio[6254]: [pulseaudio] module.c: Failed to load module "module-alsa-card" (argument: "device_id="29" name="platform-thinkpad_acpi" card_name="alsa_card.platform-thinkpad_acpi" namereg_fail=false tsched=yes fixed_latency_range=no ignore_dB=no deferred_volume=yes card_properties="module-udev-detect.discovered=1""): initialization failed.
Jul 26 19:16:31 freed udevd[483]: RUN+="socket:..." support will be removed from a future udev release. Please remove it from: /etc/udev/rules.d/90-hal.rules:2 and use libudev to subscribe to events.
Jul 26 19:16:31 freed NetworkManager[18459]: <info> wake requested (sleeping: yes  enabled: yes)
Jul 26 19:16:31 freed NetworkManager[18459]: <info> waking up and re-enabling...
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (eth0): now managed
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (eth0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (eth0): bringing up device.
Jul 26 19:16:31 freed kernel: [509138.438785] ADDRCONF(NETDEV_UP): eth0: link is not ready
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (eth0): preparing device.
Jul 26 19:16:31 freed kernel: [509138.443534] iwlwifi 0000:02:00.0: L1 Enabled; Disabling L0S
Jul 26 19:16:31 freed kernel: [509138.443730] iwlwifi 0000:02:00.0: Radio type=0x1-0x3-0x1
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (eth0): deactivating device (reason 'managed') [2]
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (wlan0): now managed
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (wlan0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (wlan0): bringing up device.
Jul 26 19:16:31 freed dbus-daemon[833]: dbus[833]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper)
Jul 26 19:16:31 freed dbus[833]: [system] Activating service name='net.reactivated.Fprint' (using servicehelper)
Jul 26 19:16:31 freed dbus-daemon[833]: Launching FprintObject
Jul 26 19:16:31 freed dbus-daemon[833]: dbus[833]: [system] Successfully activated service 'net.reactivated.Fprint'
Jul 26 19:16:31 freed dbus[833]: [system] Successfully activated service 'net.reactivated.Fprint'
Jul 26 19:16:31 freed dbus-daemon[833]: ** Message: D-Bus service launched with name: net.reactivated.Fprint
Jul 26 19:16:31 freed dbus-daemon[833]: ** Message: entering main loop
Jul 26 19:16:31 freed dbus-daemon[833]: ** Message: user 'james' claiming the device: 0
Jul 26 19:16:31 freed dbus-daemon[833]: ** Message: now monitoring fd 10
Jul 26 19:16:31 freed dbus-daemon[833]: ** Message: device 0 claim status 0
Jul 26 19:16:31 freed kernel: [509138.560734] ADDRCONF(NETDEV_UP): wlan0: link is not ready
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (wlan0): preparing device.
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (wlan0): deactivating device (reason 'managed') [2]
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (wlan0) supports 5 scan SSIDs
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (wlan0): supplicant interface state: starting -> ready
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (wlan0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
Jul 26 19:16:31 freed NetworkManager[18459]: <warn> Trying to remove a non-existant call id.
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (wlan0): supplicant interface state: ready -> inactive
Jul 26 19:16:31 freed NetworkManager[18459]: <info> (wlan0) supports 5 scan SSIDs
Jul 26 19:16:31 freed dbus-daemon[833]: ** Message: no longer monitoring fd 10
Jul 26 19:16:31 freed dbus-daemon[833]: ** Message: released device 0
Jul 26 19:16:31 freed kernel: [509138.743561] usb 1-1.4: new full-speed USB device number 34 using ehci_hcd
Jul 26 19:16:32 freed kernel: [509138.833337] usb 1-1.4: New USB device found, idVendor=0a5c, idProduct=217f
Jul 26 19:16:32 freed kernel: [509138.833346] usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Jul 26 19:16:32 freed kernel: [509138.833352] usb 1-1.4: Product: Broadcom Bluetooth Device
Jul 26 19:16:32 freed kernel: [509138.833358] usb 1-1.4: Manufacturer: Broadcom Corp
Jul 26 19:16:32 freed kernel: [509138.833362] usb 1-1.4: SerialNumber: 70F395447613
Jul 26 19:16:32 freed bluetoothd[988]: bluetoothd[988]: HCI dev 0 registered
Jul 26 19:16:32 freed bluetoothd[988]: bluetoothd[988]: Listening for HCI events on hci0
Jul 26 19:16:32 freed bluetoothd[988]: HCI dev 0 registered
Jul 26 19:16:32 freed bluetoothd[988]: Listening for HCI events on hci0
Jul 26 19:16:32 freed bluetoothd[988]: bluetoothd[988]: HCI dev 0 up
Jul 26 19:16:32 freed bluetoothd[988]: HCI dev 0 up
Jul 26 19:16:32 freed bluetoothd[988]: Parsing /etc/bluetooth/serial.conf failed: No such file or directory
Jul 26 19:16:32 freed bluetoothd[988]: Unable to load keys to adapter_ops: Function not implemented (38)
Jul 26 19:16:32 freed bluetoothd[988]: bluetoothd[988]: Parsing /etc/bluetooth/serial.conf failed: No such file or directory
Jul 26 19:16:32 freed bluetoothd[988]: bluetoothd[988]: Unable to load keys to adapter_ops: Function not implemented (38)
Jul 26 19:16:32 freed bluetoothd[988]: Adapter /org/bluez/988/hci0 has been enabled
Jul 26 19:16:32 freed bluetoothd[988]: bluetoothd[988]: Adapter /org/bluez/988/hci0 has been enabled
Jul 26 19:16:32 freed bluetoothd[988]: Endpoint registered: sender=:1.3862 path=/MediaEndpoint/HFPAG
Jul 26 19:16:32 freed bluetoothd[988]: Endpoint registered: sender=:1.3862 path=/MediaEndpoint/A2DPSource
Jul 26 19:16:32 freed bluetoothd[988]: bluetoothd[988]: Endpoint registered: sender=:1.3862 path=/MediaEndpoint/HFPAG
Jul 26 19:16:32 freed bluetoothd[988]: bluetoothd[988]: Endpoint registered: sender=:1.3862 path=/MediaEndpoint/A2DPSource
Jul 26 19:16:34 freed NetworkManager[18459]: <info> Auto-activating connection 'Auto octopus'.
Jul 26 19:16:34 freed NetworkManager[18459]: <info> Activation (wlan0) starting connection 'Auto octopus'
Jul 26 19:16:34 freed NetworkManager[18459]: <info> (wlan0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Jul 26 19:16:34 freed NetworkManager[18459]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) scheduled...
Jul 26 19:16:34 freed NetworkManager[18459]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) started...
Jul 26 19:16:34 freed NetworkManager[18459]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) scheduled...
Jul 26 19:16:34 freed NetworkManager[18459]: <info> Activation (wlan0) Stage 1 of 5 (Device Prepare) complete.
Jul 26 19:16:34 freed NetworkManager[18459]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) starting...
Jul 26 19:16:34 freed NetworkManager[18459]: <info> (wlan0): device state change: prepare -> config (reason 'none') [40 50 0]
Jul 26 19:16:34 freed NetworkManager[18459]: <info> Activation (wlan0/wireless): access point 'Auto octopus' has security, but secrets are required.
Jul 26 19:16:34 freed NetworkManager[18459]: <info> (wlan0): device state change: config -> need-auth (reason 'none') [50 60 0]
Jul 26 19:16:34 freed NetworkManager[18459]: <info> Activation (wlan0) Stage 2 of 5 (Device Configure) complete.
Jul 26 19:16:35 freed dbus-daemon[833]: dbus[833]: [system] Rejected send message, 2 matched rules; type="method_return", sender=":1.0" (uid=0 pid=797 comm="/usr/lib/systemd/systemd-logind ") interface="(unset)" member="(unset)" error name="(unset)" requested_reply="0" destination=":1.3854" (uid=500 pid=6065 comm="gnome-session ")
Jul 26 19:16:35 freed dbus[833]: [system] Rejected send message, 2 matched rules; type="method_return", sender=":1.0" (uid=0 pid=797 comm="/usr/lib/systemd/systemd-logind ") interface="(unset)" member="(unset)" error name="(unset)" requested_reply="0" destination=":1.3854" (uid=500 pid=6065 comm="gnome-session ")
Jul 26 19:16:48 freed dbus-daemon[833]: ** Message: user 'james' claiming the device: 0
Jul 26 19:16:48 freed dbus-daemon[833]: ** Message: now monitoring fd 11
Jul 26 19:16:48 freed dbus-daemon[833]: ** Message: device 0 claim status 0
Jul 26 19:16:48 freed dbus-daemon[833]: ** Message: no longer monitoring fd 11
Jul 26 19:16:48 freed dbus-daemon[833]: ** Message: released device 0
Jul 26 19:17:19 freed dbus-daemon[833]: ** Message: No devices in use, exit
