[SOLVED] All programs gone after resuming from suspend

jakub · 2015-04-18 11:03:49

Hi,

recently (I don't know exactly since when) I'm struggling with suspend/resume on my laptop. Let's say I suspend my computer (or "schedule" it by something like "sleep 1000 && xfce4-session-logout -s") and when I resume and type password (I have screensaver set up) I see that all my previously opened applications are gone. I have to start everything manually. At least when starting Chrome it asks me if I want to restore opened tabs.

So - I don't have a clue whats going on. Do you guys know about any issue which could cause this problem?

[kuba@t61:~]$ uname -a
Linux t61 3.19.4-1-ck #1 SMP PREEMPT Mon Apr 13 15:30:01 EDT 2015 x86_64 GNU/Linux

Last edited by jakub (2015-04-18 12:48:14)

Trilby · 2015-04-18 11:17:52

Do you always logout when you suspend? Can you try suspending without logging out and/or try logging out without suspending? This would determine if it is an effect of suspending, or just a failure of xfce's session manager.

jakub · 2015-04-18 11:22:12

What about suspending, this is what journalctl -b -0 shows.

...
kwi 18 07:34:33 t61 NetworkManager[255]: <info>  sleep requested (sleeping: no  enabled: yes)
kwi 18 07:34:33 t61 NetworkManager[255]: <info>  sleeping...
kwi 18 07:34:33 t61 NetworkManager[255]: <info>  (wlp3s0): device state change: disconnected -> unmanaged (reason 'sleeping') [30 10 37]
kwi 18 07:34:33 t61 NetworkManager[255]: <info>  (enp0s25): device state change: activated -> unmanaged (reason 'sleeping') [100 10 37]
kwi 18 07:34:33 t61 NetworkManager[255]: <info>  (enp0s25): deactivating device (reason 'sleeping') [37]
kwi 18 07:34:33 t61 pppd[5628]: Terminating on signal 15
kwi 18 07:34:33 t61 pppd[5628]: Connect time 21.1 minutes.
kwi 18 07:34:33 t61 pppd[5628]: Sent 20003558 bytes, received 1297559 bytes.
kwi 18 07:34:33 t61 pppd[5628]: Connection terminated.
kwi 18 07:34:33 t61 kernel: IPv6: ADDRCONF(NETDEV_UP): wlp3s0: link is not ready
kwi 18 07:34:33 t61 NetworkManager[255]: Terminating on signal 15
kwi 18 07:34:33 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 10 / phase 'terminate'
kwi 18 07:34:33 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network'
kwi 18 07:34:33 t61 NetworkManager[255]: Connect time 21.1 minutes.
kwi 18 07:34:33 t61 NetworkManager[255]: Sent 20003558 bytes, received 1297559 bytes.
kwi 18 07:34:33 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
kwi 18 07:34:33 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 11 / phase 'disconnect'
kwi 18 07:34:33 t61 NetworkManager[255]: Connection terminated.
kwi 18 07:34:33 t61 NetworkManager[255]: <error> [1429335273.284502] [platform/nm-linux-platform.c:1844] delete_object(): Netlink error deleting 78.9.5.16/32 lft fore
kwi 18 07:34:33 t61 pppoe[5632]: read (asyncReadFromPPP): Session 22530: Input/output error
kwi 18 07:34:33 t61 pppoe[5632]: Sent PADT
kwi 18 07:34:33 t61 NetworkManager[255]: <info>  Removing DNS information from /usr/bin/resolvconf
kwi 18 07:34:33 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 1 / phase 'dead'
kwi 18 07:34:33 t61 NetworkManager[255]: pppoe: read (asyncReadFromPPP): Session 22530: Input/output error
kwi 18 07:34:33 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_exit_notify): cleaning up
kwi 18 07:34:33 t61 pppd[5628]: Exit.
kwi 18 07:34:34 t61 NetworkManager[255]: <info>  NetworkManager state is now ASLEEP
kwi 18 07:34:34 t61 kernel: e1000e: enp0s25 NIC Link is Down
kwi 18 07:34:34 t61 NetworkManager[255]: <info>  (enp0s25): link disconnected
kwi 18 07:34:34 t61 dbus[259]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
kwi 18 07:34:34 t61 systemd[1]: Starting Sleep.
kwi 18 07:34:34 t61 systemd[1]: Reached target Sleep.
kwi 18 07:34:34 t61 systemd[1]: Starting Suspend...
kwi 18 07:34:34 t61 systemd[1]: Starting Network Manager Script Dispatcher Service...
kwi 18 07:34:34 t61 systemd-sleep[6693]: Suspending system...
kwi 18 07:34:34 t61 dbus[259]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
kwi 18 07:34:34 t61 systemd[1]: Started Network Manager Script Dispatcher Service.
kwi 18 07:34:34 t61 kernel: PM: Syncing filesystems ... done.
kwi 18 07:34:34 t61 kernel: PM: Preparing system for mem sleep
kwi 18 07:34:36 t61 ntpd[268]: Deleting interface #6 ppp0, 78.9.5.16#123, interface stats: received=17, sent=16, dropped=0, active_time=1265 secs
kwi 18 07:34:36 t61 ntpd[268]: 31.216.56.5 local addr 78.9.5.16 -> <null>
kwi 18 07:34:36 t61 ntpd[268]: 195.46.37.22 local addr 78.9.5.16 -> <null>
kwi 18 07:34:36 t61 ntpd[268]: 87.239.223.35 local addr 78.9.5.16 -> <null>
kwi 18 07:34:36 t61 ntpd[268]: Deleting interface #7 enp0s25, fe80::221:86ff:fe9a:c859%3#123, interface stats: received=0, sent=0, dropped=0, active_time=1265 secs
kwi 18 11:58:02 t61 kernel: Freezing user space processes ... (elapsed 0.002 seconds) done.
kwi 18 11:58:02 t61 kernel: Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
kwi 18 11:58:02 t61 kernel: PM: Entering mem sleep
kwi 18 11:58:02 t61 kernel: Suspending console(s) (use no_console_suspend to debug)
kwi 18 11:58:02 t61 kernel: sd 2:0:0:0: [sda] Synchronizing SCSI cache
kwi 18 11:58:02 t61 kernel: sd 2:0:0:0: [sda] Stopping disk
kwi 18 11:58:02 t61 kernel: e1000e: EEE TX LPI TIMER: 00000000
kwi 18 11:58:02 t61 kernel: PM: suspend of devices complete after 387.786 msecs
kwi 18 11:58:02 t61 kernel: PM: late suspend of devices complete after 0.593 msecs
kwi 18 11:58:02 t61 kernel: uhci_hcd 0000:00:1a.0: System wakeup enabled by ACPI
kwi 18 11:58:02 t61 kernel: uhci_hcd 0000:00:1d.1: System wakeup enabled by ACPI
kwi 18 11:58:02 t61 kernel: uhci_hcd 0000:00:1a.1: System wakeup enabled by ACPI
kwi 18 11:58:02 t61 kernel: ehci-pci 0000:00:1d.7: System wakeup enabled by ACPI
kwi 18 11:58:02 t61 kernel: uhci_hcd 0000:00:1d.2: System wakeup enabled by ACPI
kwi 18 11:58:02 t61 kernel: ehci-pci 0000:00:1a.7: System wakeup enabled by ACPI
kwi 18 11:58:02 t61 kernel: e1000e 0000:00:19.0: System wakeup enabled by ACPI
kwi 18 11:58:02 t61 kernel: uhci_hcd 0000:00:1d.0: System wakeup enabled by ACPI
kwi 18 11:58:02 t61 kernel: PM: noirq suspend of devices complete after 12.202 msecs
kwi 18 11:58:02 t61 kernel: ACPI: Preparing to enter system sleep state S3
kwi 18 11:58:02 t61 kernel: PM: Saving platform NVS memory
kwi 18 11:58:02 t61 kernel: Disabling non-boot CPUs ...
kwi 18 11:58:02 t61 kernel: Removed affinity for 480 processes to cpu 1
kwi 18 11:58:02 t61 kernel: kvm: disabling virtualization on CPU1
kwi 18 11:58:02 t61 kernel: smpboot: CPU 1 is now offline
kwi 18 11:58:02 t61 kernel: ACPI: Low-level resume complete
kwi 18 11:58:02 t61 kernel: PM: Restoring platform NVS memory
kwi 18 11:58:02 t61 kernel: Enabling non-boot CPUs ...
kwi 18 11:58:02 t61 kernel: x86: Booting SMP configuration:
kwi 18 11:58:02 t61 kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1
kwi 18 11:58:02 t61 kernel: kvm: enabling virtualization on CPU1
kwi 18 11:58:02 t61 kernel: Added affinity for 453 processes to cpu 1
kwi 18 11:58:02 t61 kernel: Released forced binding to cpu0 for 453 processes
kwi 18 11:58:02 t61 kernel: CPU1 is up
kwi 18 11:58:02 t61 kernel: ACPI: Waking up from system sleep state S3
kwi 18 11:58:02 t61 kernel: uhci_hcd 0000:00:1a.0: System wakeup disabled by ACPI
kwi 18 11:58:02 t61 kernel: uhci_hcd 0000:00:1a.1: System wakeup disabled by ACPI
kwi 18 11:58:02 t61 kernel: ehci-pci 0000:00:1a.7: System wakeup disabled by ACPI
kwi 18 11:58:02 t61 kernel: uhci_hcd 0000:00:1d.0: System wakeup disabled by ACPI
kwi 18 11:58:02 t61 kernel: ehci-pci 0000:00:1d.7: System wakeup disabled by ACPI
kwi 18 11:58:02 t61 kernel: uhci_hcd 0000:00:1d.1: System wakeup disabled by ACPI
kwi 18 11:58:02 t61 kernel: uhci_hcd 0000:00:1d.2: System wakeup disabled by ACPI
kwi 18 11:58:02 t61 kernel: PM: noirq resume of devices complete after 12.396 msecs
kwi 18 11:58:02 t61 kernel: PM: early resume of devices complete after 0.255 msecs
kwi 18 11:58:02 t61 kernel: e1000e 0000:00:19.0: System wakeup disabled by ACPI
kwi 18 11:58:02 t61 kernel: usb usb6: root hub lost power or was reset
kwi 18 11:58:02 t61 kernel: usb usb7: root hub lost power or was reset
kwi 18 11:58:02 t61 kernel: usb usb5: root hub lost power or was reset
kwi 18 11:58:02 t61 kernel: usb usb3: root hub lost power or was reset
kwi 18 11:58:02 t61 kernel: usb usb2: root hub lost power or was reset
kwi 18 11:58:02 t61 kernel: pciehp 0000:00:1c.3:pcie04: Timeout on hotplug command 0x1038 (issued 1274319 msec ago)
kwi 18 11:58:02 t61 kernel: ata2: port disabled--ignoring
kwi 18 11:58:02 t61 kernel: rtc_cmos 00:02: System wakeup disabled by ACPI
kwi 18 11:58:02 t61 kernel: sd 2:0:0:0: [sda] Starting disk
kwi 18 11:58:02 t61 kernel: tpm_tis 00:05: TPM is disabled/deactivated (0x6)
kwi 18 11:58:02 t61 kernel: ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
kwi 18 11:58:02 t61 kernel: ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
kwi 18 11:58:02 t61 kernel: ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
kwi 18 11:58:02 t61 kernel: ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
kwi 18 11:58:02 t61 kernel: ata3.00: supports DRM functions and may not be fully accessible
kwi 18 11:58:02 t61 kernel: ata3.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
kwi 18 11:58:02 t61 kernel: ata3.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
kwi 18 11:58:02 t61 kernel: ata3.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
kwi 18 11:58:02 t61 kernel: ata3.00: supports DRM functions and may not be fully accessible
kwi 18 11:58:02 t61 kernel: ata3.00: configured for UDMA/133
kwi 18 11:58:02 t61 kernel: ata1.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out
kwi 18 11:58:02 t61 kernel: ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
kwi 18 11:58:02 t61 kernel: ata1.00: ACPI cmd e3/00:1f:00:00:00:a0 (IDLE) succeeded
kwi 18 11:58:02 t61 kernel: ata1.00: ACPI cmd e3/00:02:00:00:00:a0 (IDLE) succeeded
kwi 18 11:58:02 t61 kernel: ata1.00: configured for UDMA/33
kwi 18 11:58:02 t61 kernel: usb 2-1: reset full-speed USB device number 2 using uhci_hcd
kwi 18 11:58:02 t61 kernel: usb 3-1: reset low-speed USB device number 2 using uhci_hcd
kwi 18 11:58:03 t61 kernel: usb 5-2: reset low-speed USB device number 2 using uhci_hcd
kwi 18 11:58:03 t61 kernel: usb 2-2: reset full-speed USB device number 3 using uhci_hcd
kwi 18 11:58:03 t61 kernel: firewire_core 0000:15:00.1: rediscovered device fw0
kwi 18 11:58:03 t61 kernel: thinkpad_acpi: ACPI backlight control delay disabled
kwi 18 11:58:03 t61 kernel: PM: resume of devices complete after 1813.580 msecs
kwi 18 11:58:03 t61 kernel: PM: Finishing wakeup.
kwi 18 11:58:03 t61 kernel: Restarting tasks ... done.
kwi 18 11:58:03 t61 kernel: video LNXVIDEO:01: Restoring backlight state
kwi 18 11:58:02 t61 systemd[1]: Time has been changed
kwi 18 11:58:02 t61 systemd[411]: Time has been changed
kwi 18 11:58:02 t61 systemd[302]: Time has been changed
kwi 18 11:58:02 t61 systemd[1]: Stopping Load/Save RF Kill Switch Status of rfkill3...
kwi 18 11:58:02 t61 systemd-sleep[6693]: System resumed.
kwi 18 11:58:03 t61 systemd[1]: Started Suspend.
kwi 18 11:58:03 t61 systemd[1]: Unit sleep.target is not needed anymore. Stopping.
kwi 18 11:58:03 t61 systemd[1]: Stopped Load/Save RF Kill Switch Status of rfkill3.
kwi 18 11:58:03 t61 systemd[1]: Starting Load/Save RF Kill Switch Status of rfkill4...
kwi 18 11:58:03 t61 systemd[1]: Stopping Sleep.
kwi 18 11:58:03 t61 systemd[1]: Stopped target Sleep.
kwi 18 11:58:03 t61 systemd[1]: Starting Suspend.
kwi 18 11:58:03 t61 systemd[1]: Reached target Suspend.
kwi 18 11:58:03 t61 systemd-logind[264]: Operation finished.
kwi 18 11:58:03 t61 systemd[1]: Unit suspend.target is bound to inactive service. Stopping, too.
kwi 18 11:58:03 t61 NetworkManager[255]: <info>  wake requested (sleeping: yes  enabled: yes)
kwi 18 11:58:03 t61 NetworkManager[255]: <info>  waking up...
kwi 18 11:58:03 t61 NetworkManager[255]: <info>  (wlp3s0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
kwi 18 11:58:04 t61 NetworkManager[255]: <info>  (wlp3s0): preparing device
kwi 18 11:58:04 t61 NetworkManager[255]: <info>  (enp0s25): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
kwi 18 11:58:04 t61 NetworkManager[255]: <info>  (enp0s25): preparing device
kwi 18 11:58:04 t61 NetworkManager[255]: <info>  NetworkManager state is now DISCONNECTED
kwi 18 11:58:04 t61 NetworkManager[255]: <info>  (wlp3s0) supports 5 scan SSIDs
kwi 18 11:58:04 t61 NetworkManager[255]: <info>  (wlp3s0): supplicant interface state: starting -> ready
kwi 18 11:58:04 t61 NetworkManager[255]: <info>  (wlp3s0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
kwi 18 11:58:04 t61 NetworkManager[255]: <info>  (wlp3s0): supplicant interface state: ready -> disconnected
kwi 18 11:58:04 t61 NetworkManager[255]: <info>  (wlp3s0) supports 5 scan SSIDs
kwi 18 11:58:05 t61 kernel: e1000e: enp0s25 NIC Link is Up 100 Mbps Full Duplex, Flow Control: None
kwi 18 11:58:05 t61 kernel: e1000e 0000:00:19.0 enp0s25: 10/100 speed: disabling TSO
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): link connected
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): device state change: unavailable -> disconnected (reason 'carrier-changed') [20 30 40]
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  Auto-activating connection 'DSL'.
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): Activation: starting connection 'DSL'
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 1 of 5 (Device Prepare) scheduled...
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 1 of 5 (Device Prepare) started...
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): device state change: disconnected -> prepare (reason 'none') [30 40 0]
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  NetworkManager state is now CONNECTING
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 2 of 5 (Device Configure) scheduled...
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 1 of 5 (Device Prepare) complete.
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 2 of 5 (Device Configure) starting...
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): device state change: prepare -> config (reason 'none') [40 50 0]
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 2 of 5 (Device Configure) successful.
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 2 of 5 (Device Configure) complete.
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 3 of 5 (IP Configure Start) scheduled.
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 3 of 5 (IP Configure Start) started...
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): device state change: config -> ip-config (reason 'none') [50 70 0]
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  starting PPP connection
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  pppd started with pid 6849
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 3 of 5 (IP Configure Start) complete.
kwi 18 11:58:05 t61 pppd[6849]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded.
kwi 18 11:58:05 t61 pppd[6849]: pppd 2.4.7 started by root, uid 0
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (ppp0): new Generic device (driver: 'unknown' ifindex: 6)
kwi 18 11:58:05 t61 NetworkManager[255]: <info>  (ppp0): exported as /org/freedesktop/NetworkManager/Devices/5
kwi 18 11:58:05 t61 NetworkManager[255]: Plugin /usr/lib/pppd/2.4.7/nm-pppd-plugin.so loaded.
kwi 18 11:58:05 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (plugin_init): initializing
kwi 18 11:58:05 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 3 / phase 'serial connection'
kwi 18 11:58:05 t61 pppd[6849]: Using interface ppp0
kwi 18 11:58:06 t61 NetworkManager[255]: Using interface ppp0
kwi 18 11:58:06 t61 pppd[6849]: Connect: ppp0 <--> /dev/pts/0
kwi 18 11:58:06 t61 NetworkManager[255]: Connect: ppp0 <--> /dev/pts/0
kwi 18 11:58:06 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 5 / phase 'establish'
kwi 18 11:58:06 t61 pppoe[6851]: PADS: Service-Name: 'dialnet.pl'
kwi 18 11:58:06 t61 pppoe[6851]: PPP session is 26538 (0x67aa)
kwi 18 11:58:06 t61 NetworkManager[255]: <info>  (wlp3s0): supplicant interface state: disconnected -> inactive
kwi 18 11:58:06 t61 org.freedesktop.Notifications[426]: xfce4-notifyd: Fatal IO error 11 (Zasoby chwilowo niedostępne) on X server :0.
kwi 18 11:58:06 t61 kernel: traps: vlc[3419] general protection ip:7fb522458cfd sp:7fb4dd7aaa30 error:0 in libc-2.21.so[7fb522423000+199000]
kwi 18 11:58:06 t61 polkitd[279]: Unregistered Authentication Agent for unix-session:c2 (system bus name :1.24, object path /org/gnome/PolicyKit1/AuthenticationAgent,
kwi 18 11:58:06 t61 org.a11y.atspi.Registry[492]: XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
kwi 18 11:58:06 t61 org.a11y.atspi.Registry[492]: after 3305 requests (3305 known processed) with 0 events remaining.
kwi 18 11:58:07 t61 org.gtk.vfs.Daemon[426]: A connection to the bus can't be made
kwi 18 11:58:07 t61 org.gtk.vfs.Daemon[426]: g_dbus_connection_real_closed: Remote peer vanished with error: Underlying GIOStream returned 0 bytes on an async read (g
kwi 18 11:58:07 t61 org.gtk.vfs.Daemon[426]: g_dbus_connection_real_closed: Remote peer vanished with error: Underlying GIOStream returned 0 bytes on an async read (g
kwi 18 11:58:07 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 6 / phase 'authenticate'
kwi 18 11:58:07 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (get_credentials): passwd-hook, requesting credentials...
kwi 18 11:58:07 t61 org.gtk.Private.UDisks2VolumeMonitor[426]: g_dbus_connection_real_closed: Remote peer vanished with error: Błąd podczas pobierania komunikatu: Poł
kwi 18 11:58:07 t61 lightdm[322]: pam_unix(lightdm:session): session closed for user kuba
kwi 18 11:58:07 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (get_credentials): got credentials from NetworkManager
kwi 18 11:58:07 t61 kernel: Telegram[986]: segfault at 0 ip 00000000013299a3 sp 00007ffc7e028c68 error 4 in Telegram[400000+1ed6000]
kwi 18 11:58:07 t61 org.gtk.Private.AfcVolumeMonitor[426]: g_dbus_connection_real_closed: Remote peer vanished with error: Błąd podczas pobierania komunikatu: Połącze
kwi 18 11:58:07 t61 org.a11y.Bus[426]: g_dbus_connection_real_closed: Remote peer vanished with error: Underlying GIOStream returned 0 bytes on an async read (g-io-er
kwi 18 11:58:07 t61 pppd[6849]: CHAP authentication succeeded: CHAP authentication success, unit 34760
kwi 18 11:58:07 t61 pppd[6849]: CHAP authentication succeeded
kwi 18 11:58:07 t61 NetworkManager[255]: CHAP authentication succeeded: CHAP authentication success, unit 34760
kwi 18 11:58:07 t61 NetworkManager[255]: CHAP authentication succeeded
kwi 18 11:58:07 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 8 / phase 'network'
kwi 18 11:58:07 t61 pppd[6849]: Cannot determine ethernet address for proxy ARP
kwi 18 11:58:07 t61 NetworkManager[255]: Cannot determine ethernet address for proxy ARP
kwi 18 11:58:07 t61 pppd[6849]: local  IP address 78.10.129.88
kwi 18 11:58:07 t61 NetworkManager[255]: local  IP address 78.10.129.88
kwi 18 11:58:07 t61 pppd[6849]: remote IP address 62.87.220.4
kwi 18 11:58:07 t61 pppd[6849]: primary   DNS address 87.204.204.204
kwi 18 11:58:07 t61 pppd[6849]: secondary DNS address 62.233.233.233
kwi 18 11:58:07 t61 NetworkManager[255]: remote IP address 62.87.220.4
kwi 18 11:58:07 t61 NetworkManager[255]: primary   DNS address 87.204.204.204
kwi 18 11:58:07 t61 NetworkManager[255]: secondary DNS address 62.233.233.233
kwi 18 11:58:07 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_phasechange): status 9 / phase 'running'
kwi 18 11:58:07 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_ip_up): ip-up event
kwi 18 11:58:07 t61 NetworkManager[255]: nm-pppd-plugin-Message: nm-ppp-plugin: (nm_ip_up): sending IPv4 config to NetworkManager...
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): device state change: unmanaged -> unavailable (reason 'connection-assumed') [10 20 41]
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): device state change: unavailable -> disconnected (reason 'connection-assumed') [20 30 41]
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: starting connection 'ppp0'
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 1 of 5 (Device Prepare) scheduled...
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  PPP manager (IPv4 Config Get) reply received.
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 5 of 5 (IPv4 Configure Commit) scheduled...
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 1 of 5 (Device Prepare) started...
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 2 of 5 (Device Configure) scheduled...
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 1 of 5 (Device Prepare) complete.
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 5 of 5 (IPv4 Commit) started...
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (enp0s25): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 5 of 5 (IPv4 Commit) complete.
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 2 of 5 (Device Configure) starting...
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): device state change: prepare -> config (reason 'none') [40 50 0]
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 2 of 5 (Device Configure) successful.
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 3 of 5 (IP Configure Start) scheduled.
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 2 of 5 (Device Configure) complete.
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 3 of 5 (IP Configure Start) started...
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): device state change: config -> ip-config (reason 'none') [50 70 0]
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 5 of 5 (IPv4 Configure Commit) scheduled...
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 3 of 5 (IP Configure Start) complete.
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (enp0s25): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 5 of 5 (IPv4 Commit) started...
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (ppp0): Activation: Stage 5 of 5 (IPv4 Commit) complete.
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  (enp0s25): device state change: secondaries -> activated (reason 'none') [90 100 0]
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  NetworkManager state is now CONNECTED_LOCAL
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  Policy set 'ppp0' (ppp0) as default for IPv4 routing and DNS.
kwi 18 11:58:07 t61 NetworkManager[255]: <info>  Writing DNS information to /usr/bin/resolvconf
kwi 18 11:58:08 t61 NetworkManager[255]: <info>  (enp0s25): Activation: successful, device activated.
kwi 18 11:58:08 t61 NetworkManager[255]: <info>  (ppp0): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
kwi 18 11:58:08 t61 systemd-coredump[6857]: Process 986 (Telegram) of user 1000 dumped core.
kwi 18 11:58:09 t61 lightdm[269]: ** (process:6939): WARNING **: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.Service
kwi 18 11:58:09 t61 ntpd[268]: Listen normally on 8 ppp0 78.10.129.88:123
kwi 18 11:58:09 t61 ntpd[268]: Listen normally on 9 enp0s25 [fe80::221:86ff:fe9a:c859%3]:123
kwi 18 11:58:09 t61 ntpd[268]: new interface(s) found: waking up resolver
kwi 18 11:58:09 t61 lightdm[6939]: pam_unix(lightdm-greeter:session): session opened for user lightdm by (uid=0)
kwi 18 11:58:09 t61 systemd[1]: Starting Session c3 of user lightdm.
kwi 18 11:58:09 t61 systemd-logind[264]: New session c3 of user lightdm.
kwi 18 11:58:09 t61 systemd[1]: Started Session c3 of user lightdm.
kwi 18 11:58:09 t61 systemd-coredump[6848]: Process 273 (Xorg) of user 0 dumped core.
kwi 18 11:58:09 t61 systemd-coredump[6855]: Process 3391 (vlc) of user 1000 dumped core.
kwi 18 11:58:09 t61 systemd-logind[264]: Removed session c1.
kwi 18 11:58:10 t61 systemd[411]: Time has been changed
kwi 18 11:58:10 t61 systemd[302]: Time has been changed
kwi 18 11:58:10 t61 systemd[1]: Time has been changed
kwi 18 11:58:10 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 4 of 5 (IPv6 Configure Timeout) scheduled...
kwi 18 11:58:10 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 4 of 5 (IPv6 Configure Timeout) started...
kwi 18 11:58:10 t61 NetworkManager[255]: <info>  (enp0s25): Activation: Stage 4 of 5 (IPv6 Configure Timeout) complete.
kwi 18 11:58:11 t61 lightdm[269]: ** (process:6962): WARNING **: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.Service
kwi 18 11:58:11 t61 lightdm[6939]: pam_unix(lightdm-greeter:session): session closed for user lightdm
kwi 18 11:58:11 t61 lightdm[6962]: pam_unix(lightdm:session): session opened for user kuba by (uid=0)
kwi 18 11:58:11 t61 systemd[1]: Starting Session c4 of user kuba.
kwi 18 11:58:11 t61 systemd[1]: Started Session c4 of user kuba.
kwi 18 11:58:11 t61 systemd-logind[264]: New session c4 of user kuba.
kwi 18 11:58:12 t61 rtkit-daemon[476]: Successfully made thread 7028 of process 7028 (/usr/bin/pulseaudio) owned by '1000' high priority at nice level -11.
kwi 18 11:58:12 t61 rtkit-daemon[476]: Supervising 1 threads of 1 processes of 1 users.
kwi 18 11:58:12 t61 pulseaudio[7028]: [pulseaudio] pid.c: Stale PID file, overwriting.
kwi 18 11:58:12 t61 pulseaudio[7028]: [pulseaudio] bluez5-util.c: GetManagedObjects() failed: org.freedesktop.DBus.Error.ServiceUnknown: The name org.bluez was not pr
kwi 18 11:58:12 t61 org.a11y.Bus[6980]: Activating service name='org.a11y.atspi.Registry'
kwi 18 11:58:12 t61 org.a11y.Bus[6980]: Successfully activated service 'org.a11y.atspi.Registry'
kwi 18 11:58:12 t61 org.a11y.atspi.Registry[7042]: SpiRegistry daemon is running with well-known name - org.a11y.atspi.Registry
kwi 18 11:58:13 t61 polkitd[279]: Registered Authentication Agent for unix-session:c4 (system bus name :1.51 [/usr/lib/polkit-gnome/polkit-gnome-authentication-agent-
kwi 18 11:58:13 t61 org.freedesktop.thumbnails.Thumbnailer1[6980]: (tumblerd:7063): tumbler-WARNING **: Failed to load plugin "tumbler-raw-thumbnailer.so": libopenraw
kwi 18 11:58:13 t61 org.freedesktop.thumbnails.Thumbnailer1[6980]: (tumblerd:7063): tumbler-WARNING **: Failed to load plugin "tumbler-odf-thumbnailer.so": libgsf-1.s
kwi 18 11:58:13 t61 org.freedesktop.thumbnails.Thumbnailer1[6980]: (tumblerd:7063): tumbler-WARNING **: Failed to load plugin "tumbler-ffmpeg-thumbnailer.so": libffmp
kwi 18 11:58:14 t61 org.gtk.Private.UDisks2VolumeMonitor[6980]: index_parse.c:190: indx_parse(): error opening /media/storage/BDMV/index.bdmv
kwi 18 11:58:14 t61 org.gtk.Private.UDisks2VolumeMonitor[6980]: index_parse.c:190: indx_parse(): error opening /media/storage/BDMV/BACKUP/index.bdmv
kwi 18 11:58:16 t61 org.gtk.Private.UDisks2VolumeMonitor[6980]: index_parse.c:190: indx_parse(): error opening /run/media/kuba/ExtStorage/BDMV/index.bdmv
kwi 18 11:58:16 t61 org.gtk.Private.UDisks2VolumeMonitor[6980]: index_parse.c:190: indx_parse(): error opening /run/media/kuba/ExtStorage/BDMV/BACKUP/index.bdmv
kwi 18 11:58:16 t61 org.gtk.Private.UDisks2VolumeMonitor[6980]: index_parse.c:190: indx_parse(): error opening /run/media/kuba/ExtArch/BDMV/index.bdmv
kwi 18 11:58:16 t61 org.gtk.Private.UDisks2VolumeMonitor[6980]: index_parse.c:190: indx_parse(): error opening /run/media/kuba/ExtArch/BDMV/BACKUP/index.bdmv
kwi 18 11:58:16 t61 org.gtk.Private.AfcVolumeMonitor[6980]: Volume monitor alive
...

Does it look OK?

Last edited by jakub (2015-04-18 11:22:42)

Trilby · 2015-04-18 11:26:38

Thanks for the log information but I'm not so good at interpreting journal entries so I prefer to narrow down the issue first: did you read my previous post?

jakub · 2015-04-18 12:47:44

Yes I did read it and... had an overview of XFCE session manager once again. Silly - on 'general' tab there is a setting to save the session before logging out. It was disabled (feeling ashamed ;p).

Arch Linux

#1 2015-04-18 11:03:49

[SOLVED] All programs gone after resuming from suspend

#2 2015-04-18 11:17:52

Re: [SOLVED] All programs gone after resuming from suspend

#3 2015-04-18 11:22:12

Re: [SOLVED] All programs gone after resuming from suspend

#4 2015-04-18 11:26:38

Re: [SOLVED] All programs gone after resuming from suspend

#5 2015-04-18 12:47:44

Re: [SOLVED] All programs gone after resuming from suspend

Board footer