[EN] LXQT and one minute hibernation

[geoinsbay]

Good Day
I have update an ancient 32bit laptop today. Everything boots up fine and I get the see the screen for one minute and it goes into hibernation. Can't make to many changes when the screen is only visible for 1 minute.  The laptop stays plug in all the the time and is used for for a file server. So how does one find documentation for this problem or maybe how to fix it?
Thanks
Geordie

[devil]

Are you sure this is actualy hibernation? What happens if you wake it?


greetz
devil

[geoinsbay]

Hi devil
This is not very scientific, however the screen goes blank, the power button flashes this awful orange  red colour. When the power button is pressed again the screen returns to were one left it. Almost instantly for this old machine. Then less than a minute late the screen goes blank, the computer shuts down and the orange red blinking continues. I may not be calling it the right name for I rarely use sleep, hibernation or any derivitatve thereof. However no login is required. Would this activity be logged somewhere?
I hope this helps

[devil]

You could try journalctl -f (this is a live log) before it goes to sleep the first time. Then check if it wrote something usefull after you wake it again. If not, you could still copy/paste the last ~ 50 lines of journalctl -b after waking from sleep. This is all a bit diffuse, as I don't know what to grep for at this point.


greetz
devil

[geoinsbay]

This took a little longer than it should and things were a little hectic here

journalctl -f --lines=50

Code: [Select]

$ journalctl -f --lines=50
-- Logs begin at Thu 2014-01-02 09:33:47 EST. --
Oct 11 09:57:58 basementserver ntpd[888]: Listen normally on 4 lo ::1 UDP 123
Oct 11 09:57:58 basementserver ntpd[888]: Listen normally on 5 eth0 fe80::20f:b0ff:fe6a:f0d5 UDP 123
Oct 11 09:57:58 basementserver ntpd[888]: peers refreshed
Oct 11 09:57:58 basementserver ntpd[888]: Listening on routing socket on fd #22 for interface updates
Oct 11 09:57:59 basementserver avahi-daemon[703]: Service "basementserver" (/services/udisks.service) successfully established.
Oct 11 09:57:59 basementserver avahi-daemon[703]: Service "apt-cacher-ng proxy on basementserver" (/services/apt-cacher-ng.service) successfully established.
Oct 11 09:57:59 basementserver dhclient[573]: bound to 10.0.0.6 -- renewal in 1209654 seconds.
Oct 11 09:57:59 basementserver ifup[557]: bound to 10.0.0.6 -- renewal in 1209654 seconds.
Oct 11 09:57:59 basementserver lightdm[823]: ** (lightdm:823): WARNING **: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.Accounts was not provided by any .service files                                                         
Oct 11 09:57:59 basementserver polkitd[887]: started daemon version 0.105 using authority implementation `local' version `0.105'                             
Oct 11 09:57:59 basementserver dbus[711]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'                                               
Oct 11 09:58:00 basementserver systemd-udevd[194]: Network interface NamePolicy= disabled on kernel commandline, ignoring.                                   
Oct 11 09:58:00 basementserver ntpdate[975]: the NTP socket is in use, exiting                                                                               
Oct 11 09:58:01 basementserver loadcpufreq[817]: Loading cpufreq kernel modules...done (acpi-cpufreq).                                                       
Oct 11 09:58:01 basementserver saned[1025]: saned disabled; edit /etc/default/saned                                                                         
Oct 11 09:58:01 basementserver cpufrequtils[1031]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...done.                               
Oct 11 09:58:01 basementserver sshd[700]: Received SIGHUP; restarting.                                                                                       
Oct 11 09:58:01 basementserver sshd[700]: Server listening on 0.0.0.0 port 22.                                                                               
Oct 11 09:58:01 basementserver sshd[700]: Server listening on :: port 22.                                                                                   
Oct 11 09:58:02 basementserver lightdm[823]: ** (lightdm:823): CRITICAL **: user_get_uid: assertion 'user != NULL' failed                                   
Oct 11 09:58:02 basementserver ModemManager[695]: <warn>  Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:14.4/0000:02:02.0': not supported by any plugin                                                                                                                                           
Oct 11 09:58:02 basementserver ModemManager[695]: <warn>  Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:14.4/0000:02:03.0': not supported by any plugin                                                                                                                                           
Oct 11 09:58:03 basementserver lightdm[823]: ** (process:1082): WARNING **: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.Accounts was not provided by any .service files                                                       
Oct 11 09:58:03 basementserver lightdm[1082]: pam_unix(lightdm-autologin:session): session opened for user basement by (uid=0)                               
Oct 11 09:58:03 basementserver systemd-logind[709]: New session c1 of user basement.                                                                         
Oct 11 09:58:03 basementserver systemd[1091]: pam_unix(systemd-user:session): session opened for user basement by (uid=0)                                   
Oct 11 09:58:03 basementserver systemd[1091]: Starting Paths.                                                                                               
Oct 11 09:58:03 basementserver systemd[1091]: Reached target Paths.                                                                                         
Oct 11 09:58:03 basementserver systemd[1091]: Starting Timers.                                                                                               
Oct 11 09:58:03 basementserver systemd[1091]: Reached target Timers.                                                                                         
Oct 11 09:58:03 basementserver systemd[1091]: Starting Sockets.                                                                                             
Oct 11 09:58:03 basementserver systemd[1091]: Reached target Sockets.                                                                                       
Oct 11 09:58:03 basementserver systemd[1091]: Starting Basic System.                                                                                         
Oct 11 09:58:03 basementserver systemd[1091]: Reached target Basic System.                                                                                   
Oct 11 09:58:03 basementserver systemd[1091]: Starting Default.                                                                                             
Oct 11 09:58:03 basementserver systemd[1091]: Reached target Default.                                                                                       
Oct 11 09:58:03 basementserver systemd[1091]: Startup finished in 185ms.                                                                                     
Oct 11 09:58:11 basementserver polkitd(authority=local)[887]: Registered Authentication Agent for unix-session:c1 (system bus name :1.11 [razor-policykit-agent], object path /org/razorqt/PolicyKit1/AuthenticationAgent, locale en_CA.UTF-8)                                                                           
Oct 11 09:58:17 basementserver dbus[711]: [system] Activating via systemd: service name='org.freedesktop.UPower' unit='upower.service'                       
Oct 11 09:58:18 basementserver dbus[711]: [system] Successfully activated service 'org.freedesktop.UPower'
Oct 11 09:58:19 basementserver dbus[711]: [system] Activating via systemd: service name='org.freedesktop.ConsoleKit' unit='console-kit-daemon.service'
Oct 11 09:58:19 basementserver console-kit-daemon[1271]: (process:1334): GLib-CRITICAL **: g_slice_set_config: assertion 'sys_page_size == 0' failed
Oct 11 09:58:19 basementserver console-kit-daemon[1271]: missing action
Oct 11 09:58:19 basementserver dbus[711]: [system] Successfully activated service 'org.freedesktop.ConsoleKit'
Oct 11 09:58:20 basementserver dbus[711]: [system] Activating via systemd: service name='org.freedesktop.UDisks2' unit='udisks2.service'
Oct 11 09:58:20 basementserver udisksd[1344]: udisks daemon version 2.1.3 starting
Oct 11 09:58:20 basementserver dbus[711]: [system] Successfully activated service 'org.freedesktop.UDisks2'
Oct 11 09:58:20 basementserver udisksd[1344]: Acquired the name org.freedesktop.UDisks2 on the system message bus
Oct 11 09:58:20 basementserver dbus[711]: [system] Activating via systemd: service name='org.freedesktop.UDisks' unit='udisks.service'
Oct 11 09:58:20 basementserver dbus[711]: [system] Successfully activated service 'org.freedesktop.UDisks'

After the awakening
[code]$ journalctl -f --lines=50
-- Logs begin at Thu 2014-01-02 09:33:47 EST. --
Oct 11 10:00:42 basementserver kernel: Disabling non-boot CPUs ...
Oct 11 10:00:42 basementserver kernel: smpboot: CPU 1 is now offline
Oct 11 10:00:42 basementserver kernel: ACPI: Low-level resume complete
Oct 11 10:00:42 basementserver kernel: PM: Restoring platform NVS memory
Oct 11 10:00:42 basementserver kernel: Enabling non-boot CPUs ...
Oct 11 10:00:42 basementserver kernel: x86: Booting SMP configuration:
Oct 11 10:00:42 basementserver kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1
Oct 11 10:00:42 basementserver kernel: Initializing CPU#1
Oct 11 10:00:42 basementserver kernel: CPU1 is up
Oct 11 10:00:42 basementserver kernel: ACPI: Waking up from system sleep state S3
Oct 11 10:00:42 basementserver kernel: ohci-pci 0000:00:13.0: System wakeup disabled by ACPI
Oct 11 10:00:42 basementserver kernel: ohci-pci 0000:00:13.1: System wakeup disabled by ACPI
Oct 11 10:00:42 basementserver kernel: ehci-pci 0000:00:13.2: System wakeup disabled by ACPI
Oct 11 10:00:42 basementserver kernel: PM: noirq resume of devices complete after 12.956 msecs
Oct 11 10:00:42 basementserver kernel: PM: early resume of devices complete after 0.470 msecs
Oct 11 10:00:42 basementserver kernel: 8139too 0000:02:03.0 eth0: link down
Oct 11 10:00:42 basementserver kernel: sd 0:0:0:0: [sda] Starting disk
Oct 11 10:00:42 basementserver kernel: [drm] AGP mode requested: 8
Oct 11 10:00:42 basementserver kernel: agpgart-ati 0000:00:00.0: AGP 3.0 bridge
Oct 11 10:00:42 basementserver kernel: agpgart-ati 0000:00:00.0: putting AGP V3 device into 8x mode
Oct 11 10:00:42 basementserver kernel: radeon 0000:01:05.0: putting AGP V3 device into 8x mode
Oct 11 10:00:42 basementserver kernel: radeon 0000:01:05.0: GTT: 32M 0xD2000000 - 0xD3FFFFFF
Oct 11 10:00:42 basementserver kernel: ACPI Error: No handler for Region [ECR_] (f582a6c0) [EmbeddedControl] (20140724/evregion-163)
Oct 11 10:00:42 basementserver kernel: ACPI Error: Region EmbeddedControl (ID=3) has no handler (20140724/exfldio-299)
Oct 11 10:00:42 basementserver kernel: ACPI Error: Method parse/execution failed [\_SB_.EPWR.PCLK] (Node f5829858), AE_NOT_EXIST (20140724/psparse-536)
Oct 11 10:00:42 basementserver kernel: ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC0.EC0_._Q1E] (Node f5831930), AE_NOT_EXIST (20140724/psparse-536)
Oct 11 10:00:42 basementserver kernel: radeon 0000:01:05.0: WB disabled
Oct 11 10:00:42 basementserver kernel: radeon 0000:01:05.0: fence driver on ring 0 use gpu addr 0x00000000d2000000 and cpu addr 0xf8004000
Oct 11 10:00:42 basementserver kernel: [drm] radeon: ring at 0x00000000D2001000
Oct 11 10:00:42 basementserver kernel: [drm] ring test succeeded in 0 usecs
Oct 11 10:00:42 basementserver kernel: [drm] ib test succeeded in 0 usecs
Oct 11 10:00:42 basementserver kernel: rtc_cmos 00:00: System wakeup disabled by ACPI
Oct 11 10:00:42 basementserver kernel: parport_pc 00:06: activated
Oct 11 10:00:42 basementserver kernel: usb usb2: root hub lost power or was reset
Oct 11 10:00:42 basementserver kernel: usb usb3: root hub lost power or was reset
Oct 11 10:00:42 basementserver kernel: ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:00:42 basementserver kernel: ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:00:42 basementserver kernel: ata2.00: configured for UDMA/33
Oct 11 10:00:42 basementserver kernel: usb 1-2: reset high-speed USB device number 2 using ehci-pci
Oct 11 10:00:42 basementserver kernel: PM: resume of devices complete after 538.936 msecs
Oct 11 10:00:42 basementserver kernel: Restarting tasks ...
Oct 11 10:00:42 basementserver kernel: firewire_core 0000:02:00.0: rediscovered device fw0
Oct 11 10:00:42 basementserver kernel: done.
Oct 11 10:00:42 basementserver systemd[1091]: Time has been changed
Oct 11 10:00:42 basementserver systemd-sleep[1917]: System resumed.
Oct 11 10:00:42 basementserver systemd-logind[709]: Operation finished.
Oct 11 10:00:43 basementserver kernel: 8139too 0000:02:03.0 eth0: link up, 100Mbps, full-duplex, lpa 0xC5E1
Oct 11 10:00:43 basementserver kernel: ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:00:43 basementserver kernel: ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:00:43 basementserver kernel: ata1.00: configured for UDMA/100
Oct 11 10:01:11 basementserver systemd-logind[709]: Suspending...
Oct 11 10:01:11 basementserver systemd-sleep[2083]: Suspending system...
Oct 11 10:01:11 basementserver kernel: PM: Syncing filesystems ... done.
Oct 11 10:01:20 basementserver kernel: Freezing user space processes ... (elapsed 0.002 seconds) done.
Oct 11 10:01:20 basementserver kernel: Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
Oct 11 10:01:20 basementserver kernel: Suspending console(s) (use no_console_suspend to debug)
Oct 11 10:01:20 basementserver kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache
Oct 11 10:01:20 basementserver kernel: sd 0:0:0:0: [sda] Stopping disk
Oct 11 10:01:20 basementserver kernel: parport_pc 00:06: disabled
Oct 11 10:01:20 basementserver kernel: PM: suspend of devices complete after 384.630 msecs
Oct 11 10:01:20 basementserver kernel: PM: late suspend of devices complete after 0.625 msecs
Oct 11 10:01:20 basementserver kernel: ehci-pci 0000:00:13.2: System wakeup enabled by ACPI
Oct 11 10:01:20 basementserver kernel: ohci-pci 0000:00:13.1: System wakeup enabled by ACPI
Oct 11 10:01:20 basementserver kernel: ohci-pci 0000:00:13.0: System wakeup enabled by ACPI
Oct 11 10:01:20 basementserver kernel: PM: noirq suspend of devices complete after 11.780 msecs
Oct 11 10:01:20 basementserver kernel: ACPI: Preparing to enter system sleep state S3
Oct 11 10:01:20 basementserver kernel: PM: Saving platform NVS memory
Oct 11 10:01:20 basementserver kernel: Disabling non-boot CPUs ...
Oct 11 10:01:20 basementserver kernel: smpboot: CPU 1 is now offline
Oct 11 10:01:20 basementserver kernel: ACPI: Low-level resume complete
Oct 11 10:01:20 basementserver kernel: PM: Restoring platform NVS memory
Oct 11 10:01:20 basementserver kernel: Enabling non-boot CPUs ...
Oct 11 10:01:20 basementserver kernel: x86: Booting SMP configuration:
Oct 11 10:01:20 basementserver kernel: smpboot: Booting Node 0 Processor 1 APIC 0x1
Oct 11 10:01:20 basementserver kernel: Initializing CPU#1
Oct 11 10:01:20 basementserver kernel: CPU1 is up
Oct 11 10:01:20 basementserver kernel: ACPI: Waking up from system sleep state S3
Oct 11 10:01:20 basementserver kernel: ohci-pci 0000:00:13.0: System wakeup disabled by ACPI
Oct 11 10:01:20 basementserver kernel: ohci-pci 0000:00:13.1: System wakeup disabled by ACPI
Oct 11 10:01:20 basementserver kernel: ehci-pci 0000:00:13.2: System wakeup disabled by ACPI
Oct 11 10:01:20 basementserver kernel: PM: noirq resume of devices complete after 12.608 msecs
Oct 11 10:01:20 basementserver kernel: PM: early resume of devices complete after 0.467 msecs
Oct 11 10:01:20 basementserver kernel: 8139too 0000:02:03.0 eth0: link down
Oct 11 10:01:20 basementserver kernel: [drm] AGP mode requested: 8
Oct 11 10:01:20 basementserver kernel: agpgart-ati 0000:00:00.0: AGP 3.0 bridge
Oct 11 10:01:20 basementserver kernel: agpgart-ati 0000:00:00.0: putting AGP V3 device into 8x mode
Oct 11 10:01:20 basementserver kernel: radeon 0000:01:05.0: putting AGP V3 device into 8x mode
Oct 11 10:01:20 basementserver kernel: radeon 0000:01:05.0: GTT: 32M 0xD2000000 - 0xD3FFFFFF
Oct 11 10:01:20 basementserver kernel: sd 0:0:0:0: [sda] Starting disk
Oct 11 10:01:20 basementserver kernel: ACPI Error: No handler for Region [ECR_] (f582a6c0) [EmbeddedControl] (20140724/evregion-163)
Oct 11 10:01:20 basementserver kernel: ACPI Error: Region EmbeddedControl (ID=3) has no handler (20140724/exfldio-299)
Oct 11 10:01:20 basementserver kernel: ACPI Error: Method parse/execution failed [\_SB_.EPWR.PCLK] (Node f5829858), AE_NOT_EXIST (20140724/psparse-536)
Oct 11 10:01:20 basementserver kernel: ACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC0.EC0_._Q1E] (Node f5831930), AE_NOT_EXIST (20140724/psparse-536)
Oct 11 10:01:20 basementserver kernel: radeon 0000:01:05.0: WB disabled
Oct 11 10:01:20 basementserver kernel: radeon 0000:01:05.0: fence driver on ring 0 use gpu addr 0x00000000d2000000 and cpu addr 0xf8004000
Oct 11 10:01:20 basementserver kernel: [drm] radeon: ring at 0x00000000D2001000
Oct 11 10:01:20 basementserver kernel: [drm] ring test succeeded in 0 usecs
Oct 11 10:01:20 basementserver kernel: [drm] ib test succeeded in 0 usecs
Oct 11 10:01:20 basementserver kernel: rtc_cmos 00:00: System wakeup disabled by ACPI
Oct 11 10:01:20 basementserver kernel: parport_pc 00:06: activated
Oct 11 10:01:20 basementserver kernel: usb usb2: root hub lost power or was reset
Oct 11 10:01:20 basementserver kernel: usb usb3: root hub lost power or was reset
Oct 11 10:01:20 basementserver kernel: ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:01:20 basementserver kernel: ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:01:20 basementserver kernel: ata2.00: configured for UDMA/33
Oct 11 10:01:20 basementserver kernel: usb 1-2: reset high-speed USB device number 2 using ehci-pci
Oct 11 10:01:20 basementserver kernel: PM: resume of devices complete after 542.212 msecs
Oct 11 10:01:20 basementserver kernel: Restarting tasks ...
Oct 11 10:01:20 basementserver kernel: firewire_core 0000:02:00.0: rediscovered device fw0
Oct 11 10:01:20 basementserver kernel: done.
Oct 11 10:01:20 basementserver systemd-udevd[194]: Network interface NamePolicy= disabled on kernel commandline, ignoring.
Oct 11 10:01:20 basementserver systemd[1091]: Time has been changed
Oct 11 10:01:20 basementserver systemd-sleep[2083]: System resumed.
Oct 11 10:01:20 basementserver systemd[1]: Requested transaction contradicts existing jobs: File exists
Oct 11 10:01:20 basementserver systemd-logind[709]: Operation finished.
Oct 11 10:01:21 basementserver kernel: 8139too 0000:02:03.0 eth0: link up, 100Mbps, full-duplex, lpa 0xC5E1
Oct 11 10:01:21 basementserver kernel: ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:01:21 basementserver kernel: ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:01:21 basementserver kernel: ata1.00: configured for UDMA/100
Oct 11 10:01:25 basementserver systemd[1091]: Time has been changed




[geoinsbay]

Apparently I exceeded my character

journalctl -n --lines=50

Code: [Select]

kernel: ohci-pci 0000:00:13.0: System wakeup disabled by ACPI
Oct 11 10:02:28 basementserver kernel: ohci-pci 0000:00:13.1: System wakeup disabled by ACPI
Oct 11 10:02:28 basementserver kernel: ehci-pci 0000:00:13.2: System wakeup disabled by ACPI
Oct 11 10:02:28 basementserver kernel: PM: noirq resume of devices complete after 12.340 msecs
Oct 11 10:02:28 basementserver kernel: PM: early resume of devices complete after 0.511 msecs
Oct 11 10:02:28 basementserver kernel: 8139too 0000:02:03.0 eth0: link down
Oct 11 10:02:28 basementserver kernel: ^[[1;39msd 0:0:0:0: [sda] Starting disk
Oct 11 10:02:28 basementserver kernel: [drm] AGP mode requested: 8
Oct 11 10:02:28 basementserver kernel: agpgart-ati 0000:00:00.0: AGP 3.0 bridge
Oct 11 10:02:28 basementserver kernel: agpgart-ati 0000:00:00.0: putting AGP V3 device into 8x mode
Oct 11 10:02:28 basementserver kernel: radeon 0000:01:05.0: putting AGP V3 device into 8x mode
Oct 11 10:02:28 basementserver kernel: radeon 0000:01:05.0: GTT: 32M 0xD2000000 - 0xD3FFFFFF
Oct 11 10:02:28 basementserver kernel: ^[[1;39mACPI Error: No handler for Region [ECR_] (f582a6c0) [EmbeddedControl] (20140724/evregion-163)
Oct 11 10:02:28 basementserver kernel: ^[[1;39mACPI Error: Region EmbeddedControl (ID=3) has no handler (20140724/exfldio-299)
Oct 11 10:02:28 basementserver kernel: ^[[1;39mACPI Error: Method parse/execution failed [\_SB_.EPWR.PCLK] (Node f5829858), AE_NOT_EXIST (20140724/psparse-5$
Oct 11 10:02:28 basementserver kernel: ^[[1;39mACPI Error: Method parse/execution failed [\_SB_.PCI0.LPC0.EC0_._Q1E] (Node f5831930), AE_NOT_EXIST (20140724$
Oct 11 10:02:28 basementserver kernel: radeon 0000:01:05.0: WB disabled
Oct 11 10:02:28 basementserver kernel: radeon 0000:01:05.0: fence driver on ring 0 use gpu addr 0x00000000d2000000 and cpu addr 0xf8004000
Oct 11 10:02:28 basementserver kernel: [drm] radeon: ring at 0x00000000D2001000
Oct 11 10:02:28 basementserver kernel: [drm] ring test succeeded in 0 usecs
Oct 11 10:02:28 basementserver kernel: [drm] ib test succeeded in 0 usecs
Oct 11 10:02:28 basementserver kernel: rtc_cmos 00:00: System wakeup disabled by ACPI
Oct 11 10:02:28 basementserver kernel: parport_pc 00:06: activated
Oct 11 10:02:28 basementserver kernel: ^[[1;39musb usb2: root hub lost power or was reset
Oct 11 10:02:28 basementserver kernel: ^[[1;39musb usb3: root hub lost power or was reset
Oct 11 10:02:28 basementserver kernel: ata2.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:02:28 basementserver kernel: ata2.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:02:28 basementserver kernel: ata2.00: configured for UDMA/33
Oct 11 10:02:28 basementserver kernel: usb 1-2: reset high-speed USB device number 2 using ehci-pci
Oct 11 10:02:28 basementserver kernel: PM: resume of devices complete after 542.200 msecs
Oct 11 10:02:28 basementserver kernel: ^[[1;39mRestarting tasks ...
Oct 11 10:02:28 basementserver kernel: ^[[1;39mfirewire_core 0000:02:00.0: rediscovered device fw0
Oct 11 10:02:28 basementserver kernel: ^[[1;39mdone.
Oct 11 10:02:28 basementserver systemd[1091]: Time has been changed
Oct 11 10:02:28 basementserver systemd-udevd[194]: Network interface NamePolicy= disabled on kernel commandline, ignoring.
Oct 11 10:02:29 basementserver systemd-sleep[2337]: System resumed.
Oct 11 10:02:29 basementserver systemd[1]: ^[[1;39mRequested transaction contradicts existing jobs: File exists
Oct 11 10:02:29 basementserver systemd-logind[709]: Operation finished.
Oct 11 10:02:29 basementserver kernel: ata1.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:02:29 basementserver kernel: ata1.00: ACPI cmd ef/03:45:00:00:00:a0 (SET FEATURES) filtered out
Oct 11 10:02:29 basementserver kernel: ata1.00: configured for UDMA/100
Oct 11 10:02:29 basementserver kernel: 8139too 0000:02:03.0 eth0: link up, 100Mbps, full-duplex, lpa 0xC5E1

Thanks for looking


[devil]

It would be nice if you could come to IRC, #debian-systemd. there was another case similar to yours but the user left before he could show some output. We would like to solve this and find out what triggers it.

You can contact me there

greetz
devil

[devil]

You can also increase the loglevel by appending

Code: [Select]

systemd.log_level=debug systemd.log_target=kmsg log_buf_len=1M to the kernel bootline at boot time, so we get a more verbose output. Then put

Code: [Select]

journalctl -b | grep logind to a pastebin like http://paste.debian.net and give us the URL. This is far more readable as attatching it here.


greetz
devil

[geoinsbay]

Hi
I will come back with the info sunday Oct11 mourning baring any difficulties. I am may give irc a go but I would not count on that
Thanks

[geoinsbay]

Hi
I apologize for being a little thick here but I am assuming

systemd.log_level=debug systemd.log_target=kmsg log_buf_len=1M

is placed in grub, then press e when the menu shows up, does it matter where it is placed.

Grub is something I do not play with, so I am lacking a little knowledge here

[devil]

It needs to be appended to the line that ends with 'quiet'


greetz
devil

[geoinsbay]

The output was not very large so I pasted it here

Code: [Select]

$ journalctl -b | grep logind
Oct 12 16:24:23 basementserver systemd[1]: Installed new job systemd-logind.service/start as 106
Oct 12 16:24:34 basementserver systemd[1]: About to execute: /lib/systemd/systemd-logind
Oct 12 16:24:34 basementserver systemd[1]: Forked /lib/systemd/systemd-logind as 635
Oct 12 16:24:34 basementserver systemd[1]: systemd-logind.service changed dead -> start
Oct 12 16:24:34 basementserver systemd[635]: Executing: /lib/systemd/systemd-logind
Oct 12 16:24:39 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:24:39 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:24:39 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:24:39 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:24:39 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:24:39 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:24:39 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:24:39 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (READY=1...)
Oct 12 16:24:39 basementserver systemd[1]: systemd-logind.service: got STATUS=Processing requests...
Oct 12 16:24:39 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:24:39 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (READY=1...)
Oct 12 16:24:39 basementserver systemd[1]: systemd-logind.service: got STATUS=Processing requests...
Oct 12 16:24:39 basementserver systemd[1]: Sent message type=signal sender=n/a destination=n/a object=/org/freedesktop/systemd1/unit/systemd_2dlogind_2eservice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=18 reply_cookie=0 error=n/a
Oct 12 16:24:39 basementserver systemd[1]: Sent message type=signal sender=n/a destination=n/a object=/org/freedesktop/systemd1/unit/systemd_2dlogind_2eservice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=19 reply_cookie=0 error=n/a
Oct 12 16:24:39 basementserver systemd[1]: systemd-logind.service's D-Bus name org.freedesktop.login1 now registered by :1.1
Oct 12 16:24:39 basementserver systemd[1]: systemd-logind.service changed start -> running
Oct 12 16:24:39 basementserver systemd[1]: Job systemd-logind.service/start finished, result=done
Oct 12 16:24:39 basementserver systemd[1]: Sent message type=signal sender=n/a destination=n/a object=/org/freedesktop/systemd1/unit/systemd_2dlogind_2eservice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=21 reply_cookie=0 error=n/a
Oct 12 16:24:39 basementserver systemd[1]: Sent message type=signal sender=n/a destination=n/a object=/org/freedesktop/systemd1/unit/systemd_2dlogind_2eservice interface=org.freedesktop.DBus.Properties member=PropertiesChanged cookie=22 reply_cookie=0 error=n/a
Oct 12 16:24:39 basementserver systemd-logind[635]: New seat seat0.
Oct 12 16:24:39 basementserver systemd-logind[635]: Watching system buttons on /dev/input/event3 (Power Button)
Oct 12 16:24:39 basementserver systemd-logind[635]: Watching system buttons on /dev/input/event4 (Video Bus)
Oct 12 16:24:39 basementserver systemd-logind[635]: Watching system buttons on /dev/input/event2 (Power Button)
Oct 12 16:24:39 basementserver systemd-logind[635]: Watching system buttons on /dev/input/event1 (Lid Switch)
Oct 12 16:24:45 basementserver systemd-logind[635]: New session c1 of user basement.
Oct 12 16:24:50 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:24:50 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:24:50 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:24:50 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:24:50 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:24:50 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:25:12 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:25:12 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:25:12 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:25:12 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:25:12 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:25:12 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:25:52 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:25:52 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:25:52 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:25:52 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:25:52 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:25:52 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:26:25 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:26:25 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:26:25 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:26:25 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:26:25 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:26:25 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:27:02 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:27:02 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:27:02 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:27:02 basementserver systemd[1]: Got notification message for unit systemd-logind.service
Oct 12 16:27:02 basementserver systemd[1]: systemd-logind.service: Got notification message from PID 635 (WATCHDOG=1...)
Oct 12 16:27:02 basementserver systemd[1]: systemd-logind.service: got WATCHDOG=1
Oct 12 16:27:15 basementserver systemd-logind[635]: Suspending...
Oct 12 16:29:41 basementserver systemd-logind[635]: Operation finished.