You are not logged in.

#1 2016-02-27 00:29:04

dgalt
Member
Registered: 2015-04-22
Posts: 52

"A stop job is running..." on shutdown/reboot if i3 not quit first

When I go to reboot or shutdown my system I get a message:

 
a stop job is running for Session c13 of user XX (Xs / 1min 30s)

I've had this issue crop up a few times before and it usually went away without me doing anything, but recently it's been every time I go to reboot. I found a few threads talking about this, in particular this one:
https://bbs.archlinux.org/viewtopic.php?id=203112

Reading through that I thought to see what would happen if I either 1. didn't start X / i3 or 2. quit (or kill) i3 before trying to reboot. If i3 is not running (and / or whatever else would be stopped by quitting i3), the system reboots fine.

I have logs from a few different scenarios:

1. Reboot with i3 (i3-gaps actually) running:

Feb 26 16:57:16 home_desktop systemd-logind[415]: System is rebooting.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped target Timers.
Feb 26 16:57:16 home_desktop systemd[1]: Stopping NFS status monitor for NFSv2/3 locking....
Feb 26 16:57:16 home_desktop systemd[1]: Stopped Daily Cleanup of Temporary Directories.
Feb 26 16:57:16 home_desktop systemd[1]: Stopping Authorization Manager...
Feb 26 16:57:16 home_desktop systemd[1]: Unmounting RPC Pipe File System...
Feb 26 16:57:16 home_desktop systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.
Feb 26 16:57:16 home_desktop systemd[1]: Stopping Disk Manager...
Feb 26 16:57:16 home_desktop systemd[1]: Stopped target Sound Card.
Feb 26 16:57:16 home_desktop systemd[1]: Stopping User Manager for UID 1000...
Feb 26 16:57:16 home_desktop systemd[1]: Stopping CUPS Scheduler...
Feb 26 16:57:16 home_desktop systemd[1]: Stopping Manage, Install and Generate Color Profiles...
Feb 26 16:57:16 home_desktop systemd[1]: Stopping Session c1 of user dan.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped target Graphical Interface.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped target Multi-User System.
Feb 26 16:57:16 home_desktop systemd[1]: Stopping D-Bus System Message Bus...
Feb 26 16:57:16 home_desktop systemd[1]: Stopped Daily verification of password and group files.
Feb 26 16:57:16 home_desktop login[431]: pam_unix(login:session): session closed for user dan
Feb 26 16:57:16 home_desktop systemd[1]: Stopped Daily rotation of log files.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped target Login Prompts.
Feb 26 16:57:16 home_desktop systemd[1]: Stopping Getty on tty1...
Feb 26 16:57:16 home_desktop systemd[1]: Stopped Daily man-db cache update.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped target System Time Synchronized.
Feb 26 16:57:16 home_desktop systemd[1]: Stopping RPC bind service...
Feb 26 16:57:16 home_desktop systemd[1]: Starting Generate shutdown-ramfs...
Feb 26 16:57:16 home_desktop systemd[1]: Stopped RPC bind service.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped NFS status monitor for NFSv2/3 locking..
Feb 26 16:57:16 home_desktop systemd[1]: Stopped Disk Manager.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped CUPS Scheduler.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped Authorization Manager.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped D-Bus System Message Bus.
Feb 26 16:57:16 home_desktop login[431]: pam_systemd(login:session): Failed to release session: Connection reset by peer
Feb 26 16:57:16 home_desktop systemd-logind[415]: Failed to abandon session scope: Transport endpoint is not connected
Feb 26 16:57:16 home_desktop systemd[613]: Stopping D-Bus User Message Bus...
Feb 26 16:57:16 home_desktop systemd[613]: Stopped target Default.
Feb 26 16:57:16 home_desktop systemd[613]: Stopping Bittorent Sync per-user service...
Feb 26 16:57:16 home_desktop systemd[613]: Stopped D-Bus User Message Bus.
Feb 26 16:57:16 home_desktop mkinitcpio[1181]: ==> Starting build: none
Feb 26 16:57:16 home_desktop mkinitcpio[1181]:   -> Running build hook: [sd-shutdown]
Feb 26 16:57:16 home_desktop mkinitcpio[1181]: ==> Build complete.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped Getty on tty1.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped Manage, Install and Generate Color Profiles.
Feb 26 16:57:16 home_desktop systemd[1]: Started Generate shutdown-ramfs.
Feb 26 16:57:16 home_desktop umount[1231]: umount: /var/lib/nfs/rpc_pipefs: not mounted
Feb 26 16:57:16 home_desktop systemd[1]: var-lib-nfs-rpc_pipefs.mount: Mount process exited, code=exited status=32
Feb 26 16:57:16 home_desktop systemd[1]: Unmounted RPC Pipe File System.
Feb 26 16:57:16 home_desktop systemd[1]: var-lib-nfs-rpc_pipefs.mount: Unit entered failed state.
Feb 26 16:57:16 home_desktop systemd[1]: Removed slice system-getty.slice.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped target Host and Network Name Lookups.
Feb 26 16:57:16 home_desktop systemd[1]: Stopped target RPC Port Mapper.
Feb 26 16:57:19 home_desktop systemd[613]: Stopped Bittorent Sync per-user service.
Feb 26 16:57:19 home_desktop systemd[613]: Stopped target Basic System.
Feb 26 16:57:19 home_desktop systemd[613]: Stopped target Timers.
Feb 26 16:57:19 home_desktop systemd[613]: Stopped target Sockets.
Feb 26 16:57:19 home_desktop systemd[613]: Closed D-Bus User Message Bus Socket.
Feb 26 16:57:19 home_desktop systemd[613]: Reached target Shutdown.
Feb 26 16:57:19 home_desktop systemd[613]: Starting Exit the Session...
Feb 26 16:57:19 home_desktop systemd[613]: Stopped target Paths.
Feb 26 16:57:19 home_desktop systemd[613]: Received SIGRTMIN+24 from PID 1245 (kill).
Feb 26 16:57:19 home_desktop systemd[617]: pam_unix(systemd-user:session): session closed for user dan
Feb 26 16:57:19 home_desktop systemd[1]: Stopped User Manager for UID 1000.
Feb 26 16:58:46 home_desktop systemd[1]: session-c1.scope: Stopping timed out. Killing.
Feb 26 16:58:46 home_desktop systemd[1]: Stopped Session c1 of user dan.
Feb 26 16:58:46 home_desktop systemd[1]: session-c1.scope: Unit entered failed state.
Feb 26 16:58:46 home_desktop systemd[1]: Removed slice User Slice of dan.
Feb 26 16:58:46 home_desktop systemd[1]: Stopping Permit User Sessions...
Feb 26 16:58:46 home_desktop systemd[1]: Stopping Login Service...
Feb 26 16:58:46 home_desktop systemd[1]: Stopped Permit User Sessions.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Remote File Systems.
Feb 26 16:58:47 home_desktop systemd[1]: Unmounting /net/tower/TV...
Feb 26 16:58:47 home_desktop systemd[1]: Unmounting /net/tower/Movies...
Feb 26 16:58:47 home_desktop systemd[1]: Unmounted /net/tower/TV.
Feb 26 16:58:47 home_desktop systemd[1]: Unset automount net-tower-TV.automount.
Feb 26 16:58:47 home_desktop systemd[1]: Unmounted /net/tower/Movies.
Feb 26 16:58:47 home_desktop systemd[1]: Unset automount net-tower-Movies.automount.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Network is Online.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Network.
Feb 26 16:58:47 home_desktop systemd[1]: Stopping dhcpcd on eno1...
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Remote File Systems (Pre).
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target NFS client services.
Feb 26 16:58:47 home_desktop systemd[1]: Stopping GSSAPI Proxy Daemon...
Feb 26 16:58:47 home_desktop dhcpcd[1267]: sending signal TERM to pid 837
Feb 26 16:58:47 home_desktop dhcpcd[1267]: waiting for pid 837 to exit
Feb 26 16:58:47 home_desktop systemd[1]: Stopped GSSAPI Proxy Daemon.
Feb 26 16:58:47 home_desktop dhcpcd[837]: received SIGTERM, stopping
Feb 26 16:58:47 home_desktop dhcpcd[837]: eno1: removing interface
Feb 26 16:58:47 home_desktop dhcpcd[837]: dhcpcd exited
Feb 26 16:58:47 home_desktop dhcpcd[1267]: sending signal TERM to pid 837
Feb 26 16:58:47 home_desktop dhcpcd[1267]: waiting for pid 837 to exit
Feb 26 16:58:47 home_desktop systemd[1]: Stopped dhcpcd on eno1.
Feb 26 16:58:47 home_desktop systemd[1]: Removed slice system-dhcpcd.slice.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped Login Service.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Basic System.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Paths.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped CUPS Scheduler.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Sockets.
Feb 26 16:58:47 home_desktop systemd[1]: Closed RPCbind Server Activation Socket.
Feb 26 16:58:47 home_desktop systemd[1]: Closed CUPS Scheduler.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Slices.
Feb 26 16:58:47 home_desktop systemd[1]: Closed D-Bus System Message Bus Socket.
Feb 26 16:58:47 home_desktop systemd[1]: Removed slice User and Session Slice.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target System Initialization.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Swap.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped Apply Kernel Variables.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Encrypted Volumes.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped Setup Virtual Console.
Feb 26 16:58:47 home_desktop systemd[1]: Stopping Update UTMP about System Boot/Shutdown...
Feb 26 16:58:47 home_desktop systemd[1]: Stopping Load/Save Random Seed...
Feb 26 16:58:47 home_desktop systemd[1]: Stopping Network Time Synchronization...
Feb 26 16:58:47 home_desktop systemd[1]: Stopped Load/Save Random Seed.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped Update UTMP about System Boot/Shutdown.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped Network Time Synchronization.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped Create Volatile Files and Directories.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Local File Systems.
Feb 26 16:58:47 home_desktop systemd[1]: Unmounting /boot...
Feb 26 16:58:47 home_desktop systemd[1]: Unmounting /home...
Feb 26 16:58:47 home_desktop systemd[1]: Unmounting /run/user/1000...
Feb 26 16:58:47 home_desktop systemd[1]: Unmounting Temporary Directory...
Feb 26 16:58:47 home_desktop systemd[1]: Unmounted /boot.
Feb 26 16:58:47 home_desktop systemd[1]: Unmounted /run/user/1000.
Feb 26 16:58:47 home_desktop systemd[1]: Unmounted Temporary Directory.
Feb 26 16:58:47 home_desktop systemd[1]: Unmounted /home.
Feb 26 16:58:47 home_desktop systemd[1]: Reached target Unmount All Filesystems.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped File System Check on /dev/disk/by-uuid/2b1ffdbf-eba5-400e-939f-1b0aadd99097.
Feb 26 16:58:47 home_desktop systemd[1]: Removed slice system-systemd\x2dfsck.slice.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped target Local File Systems (Pre).
Feb 26 16:58:47 home_desktop systemd[1]: Stopped Remount Root and Kernel File Systems.
Feb 26 16:58:47 home_desktop systemd[1]: Stopped Create Static Device Nodes in /dev.
Feb 26 16:58:47 home_desktop systemd[1]: Reached target Shutdown.
Feb 26 16:58:47 home_desktop systemd[1]: Reached target Final Step.
Feb 26 16:58:47 home_desktop systemd[1]: Starting Reboot...
Feb 26 16:58:47 home_desktop systemd[1]: Shutting down.
Feb 26 16:58:47 home_desktop systemd[1]: Hardware watchdog 'iTCO_wdt', version 0
Feb 26 16:58:47 home_desktop systemd[1]: Set hardware watchdog to 10min.
Feb 26 16:58:47 home_desktop kernel: watchdog watchdog0: watchdog did not stop!
Feb 26 16:58:47 home_desktop systemd-shutdown[1]: Sending SIGTERM to remaining processes...
Feb 26 16:58:47 home_desktop systemd-journald[221]: Journal stopped
-- Reboot --

2. Reboot without ever starting X / i3 (so, just log in and reboot)

Feb 26 16:56:08 home_desktop systemd-logind[417]: System is rebooting.
Feb 26 16:56:08 home_desktop systemd[1]: Stopping Session c1 of user dan.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped target Timers.
Feb 26 16:56:08 home_desktop systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped target Sound Card.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped target Graphical Interface.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped Daily Cleanup of Temporary Directories.
Feb 26 16:56:08 home_desktop systemd[1]: Stopping CUPS Scheduler...
Feb 26 16:56:08 home_desktop login[430]: pam_unix(login:session): session closed for user dan
Feb 26 16:56:08 home_desktop systemd[1]: Starting Generate shutdown-ramfs...
Feb 26 16:56:08 home_desktop systemd[1]: Stopped target Multi-User System.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped target Login Prompts.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped Daily verification of password and group files.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped Daily man-db cache update.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped Daily rotation of log files.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped target System Time Synchronized.
Feb 26 16:56:08 home_desktop systemd[1]: Stopping NFS status monitor for NFSv2/3 locking....
Feb 26 16:56:08 home_desktop systemd[1]: Stopping Getty on tty1...
Feb 26 16:56:08 home_desktop systemd[1]: Stopping User Manager for UID 1000...
Feb 26 16:56:08 home_desktop systemd[1]: Stopping Manage, Install and Generate Color Profiles...
Feb 26 16:56:08 home_desktop systemd[1]: Stopping Authorization Manager...
Feb 26 16:56:08 home_desktop systemd[1]: Stopping RPC bind service...
Feb 26 16:56:08 home_desktop systemd[1]: Stopping D-Bus System Message Bus...
Feb 26 16:56:08 home_desktop systemd-logind[417]: Failed to abandon session scope: Connection reset by peer
Feb 26 16:56:08 home_desktop systemd[1]: Unmounting RPC Pipe File System...
Feb 26 16:56:08 home_desktop systemd[1]: Stopped CUPS Scheduler.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped D-Bus System Message Bus.
Feb 26 16:56:08 home_desktop systemd[684]: Stopped target Default.
Feb 26 16:56:08 home_desktop systemd[684]: Stopping Bittorent Sync per-user service...
Feb 26 16:56:08 home_desktop systemd[1]: Stopped Getty on tty1.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped Session c1 of user dan.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped Manage, Install and Generate Color Profiles.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped RPC bind service.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped NFS status monitor for NFSv2/3 locking..
Feb 26 16:56:08 home_desktop systemd[1]: Stopped Authorization Manager.
Feb 26 16:56:08 home_desktop mkinitcpio[883]: ==> Starting build: none
Feb 26 16:56:08 home_desktop mkinitcpio[883]:   -> Running build hook: [sd-shutdown]
Feb 26 16:56:08 home_desktop systemd[1]: Stopped target Host and Network Name Lookups.
Feb 26 16:56:08 home_desktop systemd[1]: Stopped target RPC Port Mapper.
Feb 26 16:56:08 home_desktop systemd[1]: Removed slice system-getty.slice.
Feb 26 16:56:08 home_desktop systemd[1]: Unmounted RPC Pipe File System.
Feb 26 16:56:08 home_desktop mkinitcpio[883]: ==> Build complete.
Feb 26 16:56:08 home_desktop systemd[1]: Started Generate shutdown-ramfs.
Feb 26 16:56:11 home_desktop systemd[684]: Stopped Bittorent Sync per-user service.
Feb 26 16:56:11 home_desktop systemd[684]: Stopped target Basic System.
Feb 26 16:56:11 home_desktop systemd[684]: Stopped target Sockets.
Feb 26 16:56:11 home_desktop systemd[684]: Closed D-Bus User Message Bus Socket.
Feb 26 16:56:11 home_desktop systemd[684]: Reached target Shutdown.
Feb 26 16:56:11 home_desktop systemd[684]: Starting Exit the Session...
Feb 26 16:56:11 home_desktop systemd[684]: Stopped target Paths.
Feb 26 16:56:11 home_desktop systemd[684]: Stopped target Timers.
Feb 26 16:56:11 home_desktop systemd[684]: Received SIGRTMIN+24 from PID 940 (kill).
Feb 26 16:56:11 home_desktop systemd[690]: pam_unix(systemd-user:session): session closed for user dan
Feb 26 16:56:11 home_desktop systemd[1]: Stopped User Manager for UID 1000.
Feb 26 16:56:11 home_desktop systemd[1]: Removed slice User Slice of dan.
Feb 26 16:56:11 home_desktop systemd[1]: Stopping Login Service...
Feb 26 16:56:11 home_desktop systemd[1]: Stopping Permit User Sessions...
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Permit User Sessions.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Remote File Systems.
Feb 26 16:56:11 home_desktop systemd[1]: Unmounting /net/tower/Movies...
Feb 26 16:56:11 home_desktop systemd[1]: Unmounting /net/tower/TV...
Feb 26 16:56:11 home_desktop systemd[1]: Unmounted /net/tower/TV.
Feb 26 16:56:11 home_desktop systemd[1]: Unset automount net-tower-TV.automount.
Feb 26 16:56:11 home_desktop systemd[1]: Unmounted /net/tower/Movies.
Feb 26 16:56:11 home_desktop systemd[1]: Unset automount net-tower-Movies.automount.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Remote File Systems (Pre).
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target NFS client services.
Feb 26 16:56:11 home_desktop systemd[1]: Stopping GSSAPI Proxy Daemon...
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Network is Online.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Network.
Feb 26 16:56:11 home_desktop systemd[1]: Stopping dhcpcd on eno1...
Feb 26 16:56:11 home_desktop dhcpcd[961]: sending signal TERM to pid 649
Feb 26 16:56:11 home_desktop dhcpcd[961]: waiting for pid 649 to exit
Feb 26 16:56:11 home_desktop dhcpcd[649]: received SIGTERM, stopping
Feb 26 16:56:11 home_desktop dhcpcd[649]: eno1: removing interface
Feb 26 16:56:11 home_desktop systemd[1]: Stopped GSSAPI Proxy Daemon.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Login Service.
Feb 26 16:56:11 home_desktop dhcpcd[649]: dhcpcd exited
Feb 26 16:56:11 home_desktop dhcpcd[961]: sending signal TERM to pid 649
Feb 26 16:56:11 home_desktop dhcpcd[961]: waiting for pid 649 to exit
Feb 26 16:56:11 home_desktop systemd[1]: Stopped dhcpcd on eno1.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Basic System.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Paths.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped CUPS Scheduler.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Slices.
Feb 26 16:56:11 home_desktop systemd[1]: Removed slice User and Session Slice.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Sockets.
Feb 26 16:56:11 home_desktop systemd[1]: Closed D-Bus System Message Bus Socket.
Feb 26 16:56:11 home_desktop systemd[1]: Closed RPCbind Server Activation Socket.
Feb 26 16:56:11 home_desktop systemd[1]: Closed CUPS Scheduler.
Feb 26 16:56:11 home_desktop systemd[1]: Removed slice system-dhcpcd.slice.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target System Initialization.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Setup Virtual Console.
Feb 26 16:56:11 home_desktop systemd[1]: Stopping Update UTMP about System Boot/Shutdown...
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Apply Kernel Variables.
Feb 26 16:56:11 home_desktop systemd[1]: Stopping Network Time Synchronization...
Feb 26 16:56:11 home_desktop systemd[1]: Stopping Load/Save Random Seed...
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Swap.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Encrypted Volumes.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Load/Save Random Seed.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Update UTMP about System Boot/Shutdown.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Network Time Synchronization.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Create Volatile Files and Directories.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Local File Systems.
Feb 26 16:56:11 home_desktop systemd[1]: Unmounting /run/user/1000...
Feb 26 16:56:11 home_desktop systemd[1]: Unmounting /boot...
Feb 26 16:56:11 home_desktop systemd[1]: Unmounting /home...
Feb 26 16:56:11 home_desktop systemd[1]: Unmounting Temporary Directory...
Feb 26 16:56:11 home_desktop systemd[1]: Unmounted /boot.
Feb 26 16:56:11 home_desktop systemd[1]: Unmounted /run/user/1000.
Feb 26 16:56:11 home_desktop systemd[1]: Unmounted Temporary Directory.
Feb 26 16:56:11 home_desktop systemd[1]: Unmounted /home.
Feb 26 16:56:11 home_desktop systemd[1]: Reached target Unmount All Filesystems.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped File System Check on /dev/disk/by-uuid/2b1ffdbf-eba5-400e-939f-1b0aadd99097.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped target Local File Systems (Pre).
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Remount Root and Kernel File Systems.
Feb 26 16:56:11 home_desktop systemd[1]: Stopped Create Static Device Nodes in /dev.
Feb 26 16:56:11 home_desktop systemd[1]: Removed slice system-systemd\x2dfsck.slice.
Feb 26 16:56:11 home_desktop systemd[1]: Reached target Shutdown.
Feb 26 16:56:11 home_desktop systemd[1]: Reached target Final Step.
Feb 26 16:56:11 home_desktop systemd[1]: Starting Reboot...
Feb 26 16:56:11 home_desktop systemd[1]: Shutting down.
Feb 26 16:56:11 home_desktop systemd[1]: Hardware watchdog 'iTCO_wdt', version 0
Feb 26 16:56:11 home_desktop systemd[1]: Set hardware watchdog to 10min.
Feb 26 16:56:11 home_desktop kernel: watchdog watchdog0: watchdog did not stop!
Feb 26 16:56:11 home_desktop systemd-shutdown[1]: Sending SIGTERM to remaining processes...
Feb 26 16:56:11 home_desktop systemd-journald[211]: Journal stopped
-- Reboot -- 

3. Reboot after quitting i3

Feb 26 17:26:10 home_desktop systemd-logind[420]: System is rebooting.
Feb 26 17:26:10 home_desktop systemd[1]: Unmounting RPC Pipe File System...
Feb 26 17:26:10 home_desktop systemd[1]: Stopping User Manager for UID 1000...
Feb 26 17:26:10 home_desktop systemd[1]: Starting Generate shutdown-ramfs...
Feb 26 17:26:10 home_desktop systemd[1]: Stopping Session c1 of user dan.
Feb 26 17:26:10 home_desktop systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped target Graphical Interface.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped target Timers.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped Daily Cleanup of Temporary Directories.
Feb 26 17:26:10 home_desktop login[433]: pam_unix(login:session): session closed for user dan
Feb 26 17:26:10 home_desktop systemd[1]: Stopped target Multi-User System.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped target Login Prompts.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped Daily rotation of log files.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped Daily man-db cache update.
Feb 26 17:26:10 home_desktop systemd[1]: Stopping Disk Manager...
Feb 26 17:26:10 home_desktop systemd[1]: Stopping RPC bind service...
Feb 26 17:26:10 home_desktop systemd[1]: Stopping D-Bus System Message Bus...
Feb 26 17:26:10 home_desktop systemd[1]: Stopping Getty on tty1...
Feb 26 17:26:10 home_desktop systemd[1]: Stopping CUPS Scheduler...
Feb 26 17:26:10 home_desktop systemd[1]: Stopping Manage, Install and Generate Color Profiles...
Feb 26 17:26:10 home_desktop systemd[1]: Stopping NFS status monitor for NFSv2/3 locking....
Feb 26 17:26:10 home_desktop systemd[1]: Stopped Daily verification of password and group files.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped target System Time Synchronized.
Feb 26 17:26:10 home_desktop systemd[1]: Stopping Authorization Manager...
Feb 26 17:26:10 home_desktop systemd[1]: Stopped target Sound Card.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped RPC bind service.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped D-Bus System Message Bus.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped Disk Manager.
Feb 26 17:26:10 home_desktop login[433]: pam_systemd(login:session): Failed to release session: Connection reset by peer
Feb 26 17:26:10 home_desktop systemd-logind[420]: Failed to abandon session scope: Transport endpoint is not connected
Feb 26 17:26:10 home_desktop systemd[614]: Stopping D-Bus User Message Bus...
Feb 26 17:26:10 home_desktop systemd[614]: Stopped target Default.
Feb 26 17:26:10 home_desktop systemd[614]: Stopping Bittorent Sync per-user service...
Feb 26 17:26:10 home_desktop systemd[614]: Stopped D-Bus User Message Bus.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped Getty on tty1.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped Session c1 of user dan.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped CUPS Scheduler.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped NFS status monitor for NFSv2/3 locking..
Feb 26 17:26:10 home_desktop systemd[1]: Stopped Authorization Manager.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped Manage, Install and Generate Color Profiles.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped target RPC Port Mapper.
Feb 26 17:26:10 home_desktop systemd[1]: Stopped target Host and Network Name Lookups.
Feb 26 17:26:10 home_desktop systemd[1]: Removed slice system-getty.slice.
Feb 26 17:26:10 home_desktop mkinitcpio[1022]: ==> Starting build: none
Feb 26 17:26:10 home_desktop mkinitcpio[1022]:   -> Running build hook: [sd-shutdown]
Feb 26 17:26:10 home_desktop systemd[1]: Unmounted RPC Pipe File System.
Feb 26 17:26:10 home_desktop mkinitcpio[1022]: ==> Build complete.
Feb 26 17:26:10 home_desktop systemd[1]: Started Generate shutdown-ramfs.
Feb 26 17:26:11 home_desktop systemd-timesyncd[412]: Synchronized to time server 142.54.181.202:123 (2.arch.pool.ntp.org).
Feb 26 17:26:13 home_desktop systemd[614]: Stopped Bittorent Sync per-user service.
Feb 26 17:26:13 home_desktop systemd[614]: Stopped target Basic System.
Feb 26 17:26:13 home_desktop systemd[614]: Stopped target Timers.
Feb 26 17:26:13 home_desktop systemd[614]: Stopped target Paths.
Feb 26 17:26:13 home_desktop systemd[614]: Stopped target Sockets.
Feb 26 17:26:13 home_desktop systemd[614]: Closed D-Bus User Message Bus Socket.
Feb 26 17:26:13 home_desktop systemd[614]: Reached target Shutdown.
Feb 26 17:26:13 home_desktop systemd[614]: Starting Exit the Session...
Feb 26 17:26:13 home_desktop systemd[614]: Received SIGRTMIN+24 from PID 1079 (kill).
Feb 26 17:26:13 home_desktop systemd[618]: pam_unix(systemd-user:session): session closed for user dan
Feb 26 17:26:13 home_desktop systemd[1]: Stopped User Manager for UID 1000.
Feb 26 17:26:13 home_desktop systemd[1]: Removed slice User Slice of dan.
Feb 26 17:26:13 home_desktop systemd[1]: Stopping Permit User Sessions...
Feb 26 17:26:13 home_desktop systemd[1]: Stopping Login Service...
Feb 26 17:26:13 home_desktop systemd[1]: Stopped Permit User Sessions.
Feb 26 17:26:13 home_desktop systemd[1]: Stopped target Remote File Systems.
Feb 26 17:26:13 home_desktop systemd[1]: Unmounting /net/tower/Movies...
Feb 26 17:26:13 home_desktop systemd[1]: Unmounting /net/tower/TV...
Feb 26 17:26:13 home_desktop systemd[1]: Unmounted /net/tower/Movies.
Feb 26 17:26:13 home_desktop systemd[1]: Unset automount net-tower-Movies.automount.
Feb 26 17:26:13 home_desktop systemd[1]: Unmounted /net/tower/TV.
Feb 26 17:26:13 home_desktop systemd[1]: Unset automount net-tower-TV.automount.
Feb 26 17:26:13 home_desktop systemd[1]: Stopped target Remote File Systems (Pre).
Feb 26 17:26:13 home_desktop systemd[1]: Stopped target NFS client services.
Feb 26 17:26:13 home_desktop systemd[1]: Stopping GSSAPI Proxy Daemon...
Feb 26 17:26:13 home_desktop systemd[1]: Stopped target Network is Online.
Feb 26 17:26:13 home_desktop systemd[1]: Stopped target Network.
Feb 26 17:26:13 home_desktop systemd[1]: Stopping dhcpcd on eno1...
Feb 26 17:26:13 home_desktop systemd[1]: Stopped GSSAPI Proxy Daemon.
Feb 26 17:26:13 home_desktop dhcpcd[1102]: sending signal TERM to pid 838
Feb 26 17:26:13 home_desktop dhcpcd[1102]: waiting for pid 838 to exit
Feb 26 17:26:13 home_desktop dhcpcd[838]: received SIGTERM, stopping
Feb 26 17:26:13 home_desktop dhcpcd[838]: eno1: removing interface
Feb 26 17:26:13 home_desktop systemd[1]: Stopped Login Service.
Feb 26 17:26:13 home_desktop dhcpcd[838]: dhcpcd exited
Feb 26 17:26:14 home_desktop dhcpcd[1102]: sending signal TERM to pid 838
Feb 26 17:26:14 home_desktop dhcpcd[1102]: waiting for pid 838 to exit
Feb 26 17:26:14 home_desktop systemd[1]: Stopped dhcpcd on eno1.
Feb 26 17:26:14 home_desktop systemd[1]: Removed slice system-dhcpcd.slice.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped target Basic System.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped target Sockets.
Feb 26 17:26:14 home_desktop systemd[1]: Closed D-Bus System Message Bus Socket.
Feb 26 17:26:14 home_desktop systemd[1]: Closed RPCbind Server Activation Socket.
Feb 26 17:26:14 home_desktop systemd[1]: Closed CUPS Scheduler.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped target Slices.
Feb 26 17:26:14 home_desktop systemd[1]: Removed slice User and Session Slice.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped target Paths.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped CUPS Scheduler.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped target System Initialization.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped Setup Virtual Console.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped target Swap.
Feb 26 17:26:14 home_desktop systemd[1]: Stopping Load/Save Random Seed...
Feb 26 17:26:14 home_desktop systemd[1]: Stopping Update UTMP about System Boot/Shutdown...
Feb 26 17:26:14 home_desktop systemd[1]: Stopped Apply Kernel Variables.
Feb 26 17:26:14 home_desktop systemd[1]: Stopping Network Time Synchronization...
Feb 26 17:26:14 home_desktop systemd[1]: Stopped target Encrypted Volumes.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped Load/Save Random Seed.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped Update UTMP about System Boot/Shutdown.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped Network Time Synchronization.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped Create Volatile Files and Directories.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped target Local File Systems.
Feb 26 17:26:14 home_desktop systemd[1]: Unmounting /run/user/1000...
Feb 26 17:26:14 home_desktop systemd[1]: Unmounting /home...
Feb 26 17:26:14 home_desktop systemd[1]: Unmounting /boot...
Feb 26 17:26:14 home_desktop systemd[1]: Unmounting Temporary Directory...
Feb 26 17:26:14 home_desktop systemd[1]: Unmounted /run/user/1000.
Feb 26 17:26:14 home_desktop systemd[1]: Unmounted Temporary Directory.
Feb 26 17:26:14 home_desktop systemd[1]: Unmounted /boot.
Feb 26 17:26:14 home_desktop systemd[1]: Unmounted /home.
Feb 26 17:26:14 home_desktop systemd[1]: Reached target Unmount All Filesystems.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped File System Check on /dev/disk/by-uuid/2b1ffdbf-eba5-400e-939f-1b0aadd99097.
Feb 26 17:26:14 home_desktop systemd[1]: Removed slice system-systemd\x2dfsck.slice.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped target Local File Systems (Pre).
Feb 26 17:26:14 home_desktop systemd[1]: Stopped Remount Root and Kernel File Systems.
Feb 26 17:26:14 home_desktop systemd[1]: Stopped Create Static Device Nodes in /dev.
Feb 26 17:26:14 home_desktop systemd[1]: Reached target Shutdown.
Feb 26 17:26:14 home_desktop systemd[1]: Reached target Final Step.
Feb 26 17:26:14 home_desktop systemd[1]: Starting Reboot...
Feb 26 17:26:14 home_desktop systemd[1]: Shutting down.
Feb 26 17:26:14 home_desktop systemd[1]: Hardware watchdog 'iTCO_wdt', version 0
Feb 26 17:26:14 home_desktop systemd[1]: Set hardware watchdog to 10min.
Feb 26 17:26:14 home_desktop kernel: watchdog watchdog0: watchdog did not stop!
Feb 26 17:26:14 home_desktop systemd-shutdown[1]: Sending SIGTERM to remaining processes...
Feb 26 17:26:14 home_desktop systemd-journald[226]: Journal stopped
-- Reboot --

The couple of lines that differ that jump out:

Feb 26 16:57:16 home_desktop systemd[1]: var-lib-nfs-rpc_pipefs.mount: Mount process exited, code=exited status=32
Feb 26 16:57:16 home_desktop systemd[1]: Unmounted RPC Pipe File System.
Feb 26 16:57:16 home_desktop systemd[1]: var-lib-nfs-rpc_pipefs.mount: Unit entered failed state.
Feb 26 16:58:46 home_desktop systemd[1]: session-c1.scope: Stopping timed out. Killing.
Feb 26 16:58:46 home_desktop systemd[1]: Stopped Session c1 of user dan.
Feb 26 16:58:46 home_desktop systemd[1]: session-c1.scope: Unit entered failed state.

I don't know if this is something specific with i3 or killing i3 results in something else being stopped that is really the culprit. Not sure how to proceed on figuring that out.

Last edited by dgalt (2016-02-27 00:30:16)

Offline

#2 2016-02-27 05:10:40

x33a
Forum Fellow
Registered: 2009-08-15
Posts: 4,587

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Please post your i3 config.

Offline

#3 2016-02-27 17:02:50

dgalt
Member
Registered: 2015-04-22
Posts: 52

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Available here: https://github.com/DGalt/dotfiles/blob/ … .i3/config

This is apparently, though, an issue with conky and/or google-chrome, and not specific to i3. Those two applications aren't shutting down properly (for lack of a better way to explain it) when reboot is called. Right now I'm using:

#!/bin/bash
killall -q -w -s KILL chrome
killall -q -w -s KILL conky
systemctl reboot

to reboot and the system restarts just fine. Not really sure if that's a good solution, but that's what I settled on last night.

Offline

#4 2016-02-28 19:32:06

YAOMTC
Member
Registered: 2010-02-23
Posts: 204

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

This happens to me with KDE Plasma 5 and SDDM. If I don't log out of Plasma first (which returns me to SDDM), I get a 90 second delay on my shutdown, with a message in the journal saying "session-c2.scope: Stopping timed out. Killing." Also, I don't use Google Chrome, chromium, or Conky. Should I create a separate thread?

Last edited by YAOMTC (2016-02-28 19:49:26)

Offline

#5 2016-02-28 19:35:49

akgrant0710
Member
Registered: 2015-12-30
Posts: 25

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Another data point:  It appears to happen with awesome wm and chromium.

Offline

#6 2016-02-28 22:58:11

dgalt
Member
Registered: 2015-04-22
Posts: 52

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

So maybe the issue isn't specifically with conky or chrome or whatever, but how systemd is shutting these things off? No idea, maybe would be helpful if you both posted logs as well?

Offline

#7 2016-02-29 23:32:33

YAOMTC
Member
Registered: 2010-02-23
Posts: 204

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Feb 29 18:18:19 archdesk ksmserver[587]: Shutdown called with confirm  -1  type  2  and mode  -1
Feb 29 18:18:19 archdesk ksmserver[587]: After modifications confirm is  -1  type is  2  and mode  3
Feb 29 18:18:20 archdesk kdeinit5[551]: powerdevil: DBus service  ":1.16"  is requesting inhibition
Feb 29 18:18:20 archdesk kdeinit5[551]: powerdevil: Added inhibition with cookie  1  from  "ksmserver"  with  "Shutting down system"
Feb 29 18:18:20 archdesk kdeinit5[551]: powerdevil: Added interrupt session
Feb 29 18:18:20 archdesk ksmserver[587]: saveSession is  false
Feb 29 18:18:20 archdesk ksmserver[587]: ksmserver: Saving legacy session apps
Feb 29 18:18:20 archdesk ksmserver[587]: ksmserver: Done saving  0  legacy session apps
Feb 29 18:18:20 archdesk ksmserver[587]: clients should be empty,  false
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: state is  7
Feb 29 18:18:20 archdesk ksmserver[587]: QPainter::begin: Paint device returned engine == 0, type: 2
Feb 29 18:18:20 archdesk ksmserver[587]: QPainter::end: Painter not active, aborted
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: Starting killing clients
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "/usr/bin/krunner" ( 10c5d7d6d3000145678785500000005870000 )
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "kwinsmhelper" ( 10c5d7d6d3000145678785500000005870001 )
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "/usr/bin/plasmashell" ( 10c5d7d6d3000145678785500000005870002 )
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "/usr/lib/polkit-kde/polkit-kde-authentication-agent-1" ( 10c5d7d6d300014567878550000000587000
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "/usr/bin/xembedsniproxy" ( 10c5d7d6d3000145678785500000005870004 )
Feb 29 18:17:39 archdesk kdeinit5[551]: Registering ":1.41/org/ayatana/NotificationItem/dropbox_client_731" to system tray
Feb 29 18:17:40 archdesk systemd-networkd[369]: enp3s0: Starting DHCPv6 client after NDisc timeout failed: Invalid argument
Feb 29 18:17:40 archdesk systemd-networkd[369]: enp3s0: Configured
Feb 29 18:17:40 archdesk systemd-timesyncd[351]: Network configuration changed, trying to establish connection.
Feb 29 18:17:40 archdesk systemd-timesyncd[351]: Synchronized to time server 108.61.194.85:123 (2.arch.pool.ntp.org).
Feb 29 18:18:19 archdesk ksmserver[587]: Shutdown called with confirm  -1  type  2  and mode  -1
Feb 29 18:18:19 archdesk ksmserver[587]: After modifications confirm is  -1  type is  2  and mode  3
Feb 29 18:18:20 archdesk kdeinit5[551]: powerdevil: DBus service  ":1.16"  is requesting inhibition
Feb 29 18:18:20 archdesk kdeinit5[551]: powerdevil: Added inhibition with cookie  1  from  "ksmserver"  with  "Shutting down system"
Feb 29 18:18:20 archdesk kdeinit5[551]: powerdevil: Added interrupt session
Feb 29 18:18:20 archdesk ksmserver[587]: saveSession is  false
Feb 29 18:18:20 archdesk ksmserver[587]: ksmserver: Saving legacy session apps
Feb 29 18:18:20 archdesk ksmserver[587]: ksmserver: Done saving  0  legacy session apps
Feb 29 18:18:20 archdesk ksmserver[587]: clients should be empty,  false
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: completeShutdownOrCheckpoint called
Feb 29 18:18:20 archdesk ksmserver[587]: state is  7
Feb 29 18:18:20 archdesk ksmserver[587]: QPainter::begin: Paint device returned engine == 0, type: 2
Feb 29 18:18:20 archdesk ksmserver[587]: QPainter::end: Painter not active, aborted
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: Starting killing clients
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "/usr/bin/krunner" ( 10c5d7d6d3000145678785500000005870000 )
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "kwinsmhelper" ( 10c5d7d6d3000145678785500000005870001 )
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "/usr/bin/plasmashell" ( 10c5d7d6d3000145678785500000005870002 )
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "/usr/lib/polkit-kde/polkit-kde-authentication-agent-1" ( 10c5d7d6d300014567878550000000587000
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "/usr/bin/xembedsniproxy" ( 10c5d7d6d3000145678785500000005870004 )
Feb 29 18:18:25 archdesk polkitd[457]: Unregistered Authentication Agent for unix-session:c2 (system bus name :1.32, object path /org/kde/PolicyKit1/AuthenticationAgent, lo
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "pulseaudio" ( 10c5d7d6d3000145678785500000005870005 )
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "/usr/bin/akregator" ( 10c5d7d6d3000143360468000000006020009 )
Feb 29 18:18:25 archdesk xembedsniproxy[653]: kde.xembedsniproxy: closing
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "/usr/bin/kmix" ( 10c5d7d6d3000143360468000000006020010 )
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: completeShutdown: client  "/home/chris/.dropbox-dist/dropbox-lnx.x86_64-3.14.7/dropbox" ( 10c5d7d6d300014567878590000000
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver:  We killed all clients. We have now clients.count()= 10 
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKilling clients.count()= 10 
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKilling clients.count()= 9 
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKilling clients.count()= 8 
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKilling clients.count()= 7 
Feb 29 18:18:25 archdesk polkit-kde-authentication-agent-1[644]: Destroying listener
Feb 29 18:18:25 archdesk polkit-kde-authentication-agent-1[644]: Removing listener  PolkitQt1::Agent::Listener(0x1b85db0)
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKilling clients.count()= 6 
Feb 29 18:18:25 archdesk kwin_x11[627]: QXcbConnection: XCB error: 3 (BadWindow), sequence: 2328, resource id: 37748741, major code: 18 (ChangeProperty), minor code: 0
Feb 29 18:18:25 archdesk kwin_x11[627]: QXcbConnection: XCB error: 3 (BadWindow), sequence: 2332, resource id: 31457284, major code: 18 (ChangeProperty), minor code: 0
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKilling clients.count()= 5 
Feb 29 18:18:25 archdesk kwin_x11[627]: QXcbConnection: XCB error: 3 (BadWindow), sequence: 2336, resource id: 25165838, major code: 18 (ChangeProperty), minor code: 0
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKilling clients.count()= 4 
Feb 29 18:18:25 archdesk kdeinit5[551]: Service  "org.kde.StatusNotifierItem-668-1" unregistered
Feb 29 18:18:25 archdesk kdeinit5[551]: kscreen: Failed to retrieve current config:  "Backend invalidated"
Feb 29 18:18:25 archdesk kdeinit5[551]: Service  "org.kde.StatusNotifierItem-659-1" unregistered
Feb 29 18:18:25 archdesk akregator[659]: 0x14bbaf0 deleted without having been removed from the factory first. This will leak standalone popupmenus and could lead to crashe
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKilling clients.count()= 3 
Feb 29 18:18:25 archdesk kwin_x11[627]: QXcbConnection: XCB error: 3 (BadWindow), sequence: 2340, resource id: 44040199, major code: 18 (ChangeProperty), minor code: 0
Feb 29 18:18:25 archdesk kdeinit5[551]: kscreen: Failed to retrieve current config:  "Backend invalidated"
Feb 29 18:18:25 archdesk kdeinit5[551]: Service  "org.kde.StatusNotifierHost-639" unregistered
Feb 29 18:18:25 archdesk kdeinit5[551]: kscreen: Failed to retrieve current config:  "Backend invalidated"
Feb 29 18:18:25 archdesk kdeinit5[551]: kscreen: Failed to retrieve current config:  "Backend invalidated"
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKilling clients.count()= 2 
Feb 29 18:18:25 archdesk kwin_x11[627]: QXcbConnection: XCB error: 3 (BadWindow), sequence: 2344, resource id: 29360221, major code: 18 (ChangeProperty), minor code: 0
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKilling clients.count()= 1 
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: Starting killing WM
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: killWM: client  "kwin_x11" ( 10c5d7d6d3000143360467900000006020001 )
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKillingWM clients.count()= 1 
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKillingWM clients.count()= 1 
Feb 29 18:18:25 archdesk kdeinit5[551]: Service  ":1.41" unregistered
Feb 29 18:18:25 archdesk ksmserver[587]: ksmserver: KSMServer::completeKillingWM clients.count()= 0 
Feb 29 18:18:25 archdesk systemd-logind[358]: System is powering down.
Feb 29 18:18:25 archdesk systemd[1]: Stopping Daemon for power management...
Feb 29 18:18:25 archdesk systemd[1]: Stopping Session c2 of user chris.
Feb 29 18:18:25 archdesk systemd[1]: Stopping Authorization Manager...
Feb 29 18:18:25 archdesk org.a11y.atspi.Registry[779]: XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0"
Feb 29 18:18:25 archdesk org.a11y.atspi.Registry[779]:       after 33 requests (33 known processed) with 0 events remaining.
Feb 29 18:18:25 archdesk systemd[1]: Stopping Manage, Install and Generate Color Profiles...
Feb 29 18:18:25 archdesk systemd[1]: Stopped target Sound Card.
Feb 29 18:18:25 archdesk systemd[1]: Removed slice system-getty.slice.
Feb 29 18:18:25 archdesk systemd[1]: Stopped target Timers.
Feb 29 18:18:25 archdesk systemd[1]: Stopped Daily Cleanup of Temporary Directories.
Feb 29 18:18:25 archdesk systemd[1]: Stopping CUPS Scheduler...
Feb 29 18:18:25 archdesk sddm[374]: Authentication error: "Process crashed"
Feb 29 18:18:25 archdesk sddm[374]: Auth: sddm-helper crashed (exit code 15)
Feb 29 18:18:25 archdesk sddm[374]: Authentication error: "Process crashed"
Feb 29 18:18:25 archdesk sddm[374]: Auth: sddm-helper exited with 15
Feb 29 18:18:25 archdesk haveged[363]: haveged: Stopping due to signal 15
Feb 29 18:18:25 archdesk haveged[363]: haveged starting up
Feb 29 18:18:25 archdesk unbound[381]: [381:0] info: service stopped (unbound 1.5.7).
Feb 29 18:18:25 archdesk sddm[374]: Socket server stopping...
Feb 29 18:18:25 archdesk unbound[381]: [381:0] info: server stats for thread 0: 0 queries, 0 answers from cache, 0 recursions, 0 prefetch
Feb 29 18:18:25 archdesk sddm[374]: Socket server stopped.
Feb 29 18:18:25 archdesk unbound[381]: [381:0] info: server stats for thread 0: requestlist max 0 avg 0 exceeded 0 jostled 0
Feb 29 18:18:25 archdesk sddm[374]: Display server stopping...
Feb 29 18:18:25 archdesk kglobalaccel5[613]: The X11 connection broke (error 1). Did the X11 server die?
Feb 29 18:18:25 archdesk kwin_x11[627]: QCoreApplication::applicationFilePath: Please instantiate the QApplication object first
Feb 29 18:18:25 archdesk kscreen_backend_launcher[649]: The X11 connection broke (error 1). Did the X11 server die?
Feb 29 18:18:25 archdesk kdeconnectd[688]: The X11 connection broke (error 1). Did the X11 server die?
Feb 29 18:18:25 archdesk kdeinit5[551]: The X11 connection broke (error 1). Did the X11 server die?
Feb 29 18:18:25 archdesk systemd[1]: Stopping Save/Restore Sound Card State...
Feb 29 18:18:25 archdesk systemd[1]: Stopped target Graphical Interface.
Feb 29 18:18:25 archdesk systemd[1]: Stopping Simple Desktop Display Manager...
Feb 29 18:18:25 archdesk systemd[1]: Stopped target Multi-User System.
Feb 29 18:18:25 archdesk systemd[1]: Stopping Network Name Resolution...
Feb 29 18:18:25 archdesk systemd[1]: Stopped Daily rotation of log files.
Feb 29 18:18:25 archdesk systemd[1]: Stopped target Login Prompts.
Feb 29 18:18:25 archdesk systemd[1]: Stopped Daily verification of password and group files.
Feb 29 18:18:25 archdesk systemd[1]: Stopping Entropy Harvesting Daemon...
Feb 29 18:18:25 archdesk systemd[1]: Stopped Daily man-db cache update.
Feb 29 18:18:25 archdesk systemd[1]: Stopped target System Time Synchronized.
Feb 29 18:18:25 archdesk systemd[1]: Starting Generate shutdown-ramfs...
Feb 29 18:18:25 archdesk systemd[1]: Stopping User Manager for UID 1000...
Feb 29 18:18:25 archdesk systemd[1]: Stopping RealtimeKit Scheduling Policy Service...
Feb 29 18:18:25 archdesk systemd[1]: Stopping Unbound DNS Resolver...
Feb 29 18:18:25 archdesk systemd[1]: Stopping Disk Manager...
Feb 29 18:18:25 archdesk systemd[1]: Stopped CUPS Scheduler.
Feb 29 18:18:25 archdesk systemd[1]: Stopped Authorization Manager.
Feb 29 18:18:25 archdesk systemd[1]: Stopped Entropy Harvesting Daemon.
Feb 29 18:18:25 archdesk systemd[1]: Stopped Unbound DNS Resolver.
Feb 29 18:18:25 archdesk systemd[1]: Stopped RealtimeKit Scheduling Policy Service.
Feb 29 18:18:25 archdesk systemd[1]: Stopped Daemon for power management.
Feb 29 18:18:25 archdesk systemd[435]: Stopping D-Bus User Message Bus...
Feb 29 18:18:25 archdesk systemd[435]: Stopping Virtual filesystem service...
Feb 29 18:18:25 archdesk systemd[435]: Stopped target Default.
Feb 29 18:18:25 archdesk systemd[435]: Stopping Sound Service...
Feb 29 18:18:25 archdesk systemd[1]: Stopped Disk Manager.
Feb 29 18:18:25 archdesk systemd[435]: Stopped Virtual filesystem service.
Feb 29 18:18:25 archdesk systemd[1]: Stopped Manage, Install and Generate Color Profiles.
Feb 29 18:18:25 archdesk systemd[1]: Stopped Save/Restore Sound Card State.
Feb 29 18:18:25 archdesk systemd[435]: Stopped Sound Service.
Feb 29 18:18:25 archdesk systemd[1]: Stopped Network Name Resolution.
Feb 29 18:18:25 archdesk mkinitcpio[858]: ==> Starting build: none
Feb 29 18:18:25 archdesk mkinitcpio[858]:   -> Running build hook: [sd-shutdown]
Feb 29 18:18:25 archdesk systemd[1]: Stopped target Network.
Feb 29 18:18:25 archdesk systemd[1]: Stopping Network Service...
Feb 29 18:18:25 archdesk systemd-timesyncd[351]: Network configuration changed, trying to establish connection.
Feb 29 18:18:25 archdesk mkinitcpio[858]: ==> Build complete.
Feb 29 18:18:25 archdesk systemd[1]: Stopped Network Service.
Feb 29 18:18:25 archdesk systemd[1]: Started Generate shutdown-ramfs.
Feb 29 18:18:25 archdesk systemd[1]: Stopping D-Bus System Message Bus...
Feb 29 18:18:25 archdesk systemd[1]: Stopped D-Bus System Message Bus.
Feb 29 18:18:25 archdesk systemd-timesyncd[351]: Synchronized to time server 108.61.194.85:123 (2.arch.pool.ntp.org).
Feb 29 18:18:26 archdesk kernel: nvidia-modeset: Freed GPU:0 (GPU-d673dc96-7e71-4303-ec37-5aae356e7d14) @ PCI:0000:01:00.0
Feb 29 18:18:26 archdesk systemd[435]: Stopped D-Bus User Message Bus.
Feb 29 18:18:26 archdesk systemd[435]: Stopped target Basic System.
Feb 29 18:18:26 archdesk systemd[435]: Stopped target Paths.
Feb 29 18:18:26 archdesk systemd[435]: Stopped target Timers.
Feb 29 18:18:26 archdesk systemd[435]: Stopped target Sockets.
Feb 29 18:18:26 archdesk systemd[435]: Closed Sound System.
Feb 29 18:18:26 archdesk systemd[435]: Closed D-Bus User Message Bus Socket.
Feb 29 18:18:26 archdesk systemd[435]: Reached target Shutdown.
Feb 29 18:18:26 archdesk sddm[374]: Display server stopped.
Feb 29 18:18:26 archdesk sddm[374]: Running display stop script  "/usr/share/sddm/scripts/Xstop"
Feb 29 18:18:26 archdesk sddm[374]: Removing display ":0" ...
Feb 29 18:18:26 archdesk sddm[374]: Adding new display on vt 1 ...
Feb 29 18:18:26 archdesk sddm[374]: Display server starting...
Feb 29 18:18:26 archdesk sddm[374]: Running: /usr/bin/X -nolisten tcp -auth /var/run/sddm/{2b2646dd-f249-46a7-ade1-ce32136be1fa} -background none -noreset -displayfd 18 vt1
Feb 29 18:18:26 archdesk systemd[435]: Starting Exit the Session...
Feb 29 18:18:26 archdesk systemd[435]: Received SIGRTMIN+24 from PID 921 (kill).
Feb 29 18:18:26 archdesk systemd[437]: pam_unix(systemd-user:session): session closed for user chris
Feb 29 18:18:26 archdesk systemd[1]: Stopped User Manager for UID 1000.
Feb 29 18:18:26 archdesk kernel: nvidia-modeset: Allocated GPU:0 (GPU-d673dc96-7e71-4303-ec37-5aae356e7d14) @ PCI:0000:01:00.0
Feb 29 18:18:26 archdesk kernel: snd_hda_codec_hdmi hdaudioC1D0: HDMI: invalid ELD data byte 2
Feb 29 18:18:26 archdesk sddm[374]: Running display setup script  "/usr/share/sddm/scripts/Xsetup"
Feb 29 18:18:26 archdesk sddm[374]: Display server started.
Feb 29 18:18:26 archdesk sddm[374]: Socket server starting...
Feb 29 18:18:26 archdesk sddm[374]: Socket server started.
Feb 29 18:18:26 archdesk sddm[374]: Greeter starting...
Feb 29 18:18:26 archdesk sddm[374]: Adding cookie to "/var/run/sddm/{2b2646dd-f249-46a7-ade1-ce32136be1fa}"
Feb 29 18:18:26 archdesk sddm[374]: Signal received: SIGTERM
Feb 29 18:18:26 archdesk sddm[374]: Socket server stopping...
Feb 29 18:18:26 archdesk sddm[374]: Socket server stopped.
Feb 29 18:18:26 archdesk sddm[374]: Display server stopping...
Feb 29 18:18:26 archdesk sddm-helper[928]: [PAM] Starting...
Feb 29 18:18:26 archdesk sddm-helper[928]: [PAM] Authenticating...
Feb 29 18:18:26 archdesk sddm-helper[928]: [PAM] returning.
Feb 29 18:18:26 archdesk kernel: snd_hda_codec_hdmi hdaudioC1D0: HDMI: invalid ELD data byte 35
Feb 29 18:18:26 archdesk systemd[1]: Requested transaction contradicts existing jobs: Transaction is destructive.
Feb 29 18:18:26 archdesk systemd[1]: systemd-coredump.socket: Failed to queue service startup job (Maybe the service file is missing or not a non-template unit?): Transacti
Feb 29 18:18:26 archdesk systemd[1]: systemd-coredump.socket: Unit entered failed state.
Feb 29 18:18:27 archdesk kernel: nvidia-modeset: Freed GPU:0 (GPU-d673dc96-7e71-4303-ec37-5aae356e7d14) @ PCI:0000:01:00.0
Feb 29 18:18:27 archdesk sddm[374]: Display server stopped.
Feb 29 18:18:27 archdesk sddm[374]: Running display stop script  "/usr/share/sddm/scripts/Xstop"
Feb 29 18:18:27 archdesk sddm[374]: QProcess: Destroyed while process ("/usr/lib/sddm/sddm-helper") is still running.
Feb 29 18:18:27 archdesk systemd[1]: Stopped Simple Desktop Display Manager.
Feb 29 18:19:55 archdesk systemd[1]: session-c2.scope: Stopping timed out. Killing.
Feb 29 18:19:55 archdesk systemd[1]: Stopped Session c2 of user chris.
Feb 29 18:19:55 archdesk systemd[1]: session-c2.scope: Unit entered failed state.
Feb 29 18:19:55 archdesk systemd[1]: Removed slice User Slice of chris.
Feb 29 18:19:55 archdesk systemd[1]: Stopping Permit User Sessions...
Feb 29 18:19:55 archdesk systemd[1]: Stopping Login Service...
Feb 29 18:19:55 archdesk systemd[1]: Stopped Permit User Sessions.
Feb 29 18:19:55 archdesk systemd[1]: Stopped target Remote File Systems.
Feb 29 18:19:55 archdesk systemd[1]: Stopped Login Service.
Feb 29 18:19:55 archdesk systemd[1]: Stopped target Basic System.
Feb 29 18:19:55 archdesk systemd[1]: Stopped target Paths.
Feb 29 18:19:55 archdesk systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
Feb 29 18:19:55 archdesk systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.
Feb 29 18:19:55 archdesk systemd[1]: Stopped CUPS Scheduler.
Feb 29 18:19:55 archdesk systemd[1]: Stopped target Slices.
Feb 29 18:19:55 archdesk systemd[1]: Stopped target Sockets.
Feb 29 18:19:55 archdesk systemd[1]: Closed D-Bus System Message Bus Socket.
Feb 29 18:19:55 archdesk systemd[1]: Closed CUPS Scheduler.
Feb 29 18:19:55 archdesk systemd[1]: Removed slice User and Session Slice.
Feb 29 18:19:55 archdesk systemd[1]: Stopped target System Initialization.
Feb 29 18:19:55 archdesk systemd[1]: Stopping Update UTMP about System Boot/Shutdown...
Feb 29 18:19:55 archdesk systemd[1]: Stopped Set Up Additional Binary Formats.
Feb 29 18:19:55 archdesk systemd[1]: Stopped Apply Kernel Variables.
Feb 29 18:19:55 archdesk systemd[1]: Stopped Setup Virtual Console.
Feb 29 18:19:55 archdesk systemd[1]: Stopped target Swap.
Feb 29 18:19:55 archdesk systemd[1]: Stopped target Encrypted Volumes.
Feb 29 18:19:55 archdesk systemd[1]: Stopping Load/Save Random Seed...
Feb 29 18:19:55 archdesk systemd[1]: Stopping Network Time Synchronization...
Feb 29 18:19:55 archdesk systemd[1]: Stopped Load/Save Random Seed.
Feb 29 18:19:55 archdesk systemd[1]: Stopped Update UTMP about System Boot/Shutdown.
Feb 29 18:19:56 archdesk systemd[1]: Stopped Network Time Synchronization.
Feb 29 18:19:56 archdesk systemd[1]: Stopped Create Volatile Files and Directories.
Feb 29 18:19:56 archdesk systemd[1]: Stopped target Local File Systems.
Feb 29 18:19:56 archdesk systemd[1]: Unmounting /run/user/1000/gvfs...
Feb 29 18:19:56 archdesk systemd[1]: Unmounting /mnt/WD1TBlue...
Feb 29 18:19:56 archdesk systemd[1]: Unmounting /run/user/1000/gvfs...
Feb 29 18:19:56 archdesk systemd[1]: Unmounting /mnt/WD1TBlue...
Feb 29 18:19:56 archdesk systemd[1]: Unmounting /mnt/WD1TBlue2...
Feb 29 18:19:56 archdesk systemd[1]: Unmounting /mnt/SSD64GB...
Feb 29 18:19:56 archdesk systemd[1]: Unmounting Temporary Directory...
Feb 29 18:19:56 archdesk ntfs-3g[336]: Unmounting /dev/sdc2 (WD1TBlue2)
Feb 29 18:19:56 archdesk systemd[1]: Unmounted /mnt/WD1TBlue2.
Feb 29 18:19:56 archdesk ntfs-3g[328]: Unmounting /dev/sdb1 (SSD64GB)
Feb 29 18:19:56 archdesk systemd[1]: Unmounted Temporary Directory.
Feb 29 18:19:56 archdesk systemd[1]: Unmounted /mnt/SSD64GB.
Feb 29 18:19:56 archdesk ntfs-3g[334]: Unmounting /dev/sdd1 (WD1TBlue)
Feb 29 18:19:56 archdesk systemd[1]: Unmounted /run/user/1000/gvfs.
Feb 29 18:19:56 archdesk systemd[1]: Unmounted /mnt/WD1TBlue.
Feb 29 18:19:56 archdesk systemd[1]: Unmounting /run/user/1000...
Feb 29 18:19:56 archdesk systemd[1]: Unmounted /run/user/1000.
Feb 29 18:19:56 archdesk systemd[1]: Reached target Unmount All Filesystems.
Feb 29 18:19:56 archdesk systemd[1]: Stopped target Local File Systems (Pre).
Feb 29 18:19:56 archdesk systemd[1]: Stopped Create Static Device Nodes in /dev.
Feb 29 18:19:56 archdesk systemd[1]: Stopped Remount Root and Kernel File Systems.
Feb 29 18:19:56 archdesk systemd[1]: Reached target Shutdown.
Feb 29 18:19:56 archdesk systemd[1]: Reached target Final Step.
Feb 29 18:19:56 archdesk systemd[1]: Starting Power-Off...
Feb 29 18:19:56 archdesk systemd[1]: Shutting down.
Feb 29 18:19:56 archdesk systemd-shutdown[1]: Sending SIGTERM to remaining processes...
Feb 29 18:19:56 archdesk systemd-journald[165]: Journal stopped

Offline

#8 2016-03-01 18:13:14

akgrant0710
Member
Registered: 2015-12-30
Posts: 25

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

dgalt wrote:

So maybe the issue isn't specifically with conky or chrome or whatever, but how systemd is shutting these things off? No idea, maybe would be helpful if you both posted logs as well?

-- Logs begin at Fri 2016-01-15 03:40:37 CET, end at Tue 2016-03-01 19:10:38 CET. --
Mar 01 19:02:07 alistair-xps13 systemd-journald[185]: Runtime journal (/run/log/journal/) is 8.0M, max 394.6M, 386.6M free.
Mar 01 19:02:07 alistair-xps13 systemd-journald[185]: System journal (/var/log/journal/) is 496.0M, max 4.0G, 3.5G free.
Mar 01 19:02:07 alistair-xps13 systemd-journald[185]: Time spent on flushing to /var is 89.493ms for 2 entries.
Mar 01 19:02:07 alistair-xps13 kernel: microcode: CPU0 microcode updated early to revision 0x1d, date = 2015-08-13
Mar 01 19:02:07 alistair-xps13 kernel: Initializing cgroup subsys cpuset
Mar 01 19:02:07 alistair-xps13 kernel: Initializing cgroup subsys cpu
Mar 01 19:02:07 alistair-xps13 kernel: Initializing cgroup subsys cpuacct
Mar 01 19:02:07 alistair-xps13 kernel: Linux version 4.4.1-2-ARCH (builduser@foutrelis) (gcc version 5.3.0 (GCC) ) #1 SMP PREEMPT Wed Feb 3 13:12:33 UTC 2016
Mar 01 19:02:07 alistair-xps13 kernel: Command line: initrd=\intel-ucode.img initrd=\initramfs-linux.img root=PARTUUID=70615500-6d75-45f9-972e-2af5aee3f359 rw
Mar 01 19:02:07 alistair-xps13 kernel: x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
Mar 01 19:02:07 alistair-xps13 kernel: x86/fpu: Supporting XSAVE feature 0x01: 'x87 floating point registers'
Mar 01 19:02:07 alistair-xps13 kernel: x86/fpu: Supporting XSAVE feature 0x02: 'SSE registers'
Mar 01 19:02:07 alistair-xps13 kernel: x86/fpu: Supporting XSAVE feature 0x04: 'AVX registers'
Mar 01 19:02:07 alistair-xps13 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
Mar 01 19:02:07 alistair-xps13 kernel: x86/fpu: Using 'eager' FPU context switches.
Mar 01 19:02:07 alistair-xps13 kernel: e820: BIOS-provided physical RAM map:
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x0000000000000000-0x0000000000057fff] usable
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x0000000000058000-0x0000000000058fff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x0000000000059000-0x000000000008bfff] usable
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x000000000008c000-0x00000000000bffff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000c491ffff] usable
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x00000000c4920000-0x00000000c4b21fff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x00000000c4b22000-0x00000000dadb6fff] usable
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x00000000dadb7000-0x00000000dceeefff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x00000000dceef000-0x00000000dcf9efff] ACPI NVS
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x00000000dcf9f000-0x00000000dcffefff] ACPI data
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x00000000dcfff000-0x00000000dcffffff] usable
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x00000000dd000000-0x00000000df9fffff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x00000000f80f8000-0x00000000f80f8fff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x00000000fe101000-0x00000000fe112fff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: BIOS-e820: [mem 0x0000000100000000-0x000000021f5fffff] usable
Mar 01 19:02:07 alistair-xps13 kernel: NX (Execute Disable) protection: active
Mar 01 19:02:07 alistair-xps13 kernel: e820: update [mem 0xc5895018-0xc58a5057] usable ==> usable
Mar 01 19:02:07 alistair-xps13 kernel: e820: update [mem 0xc5888018-0xc5894057] usable ==> usable
Mar 01 19:02:07 alistair-xps13 kernel: e820: update [mem 0xc5876018-0xc5887857] usable ==> usable
Mar 01 19:02:07 alistair-xps13 kernel: extended physical RAM map:
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x0000000000000000-0x0000000000057fff] usable
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x0000000000058000-0x0000000000058fff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x0000000000059000-0x000000000008bfff] usable
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x000000000008c000-0x00000000000bffff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000000e0000-0x00000000000fffff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x0000000000100000-0x00000000c491ffff] usable
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000c4920000-0x00000000c4b21fff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000c4b22000-0x00000000c5876017] usable
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000c5876018-0x00000000c5887857] usable
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000c5887858-0x00000000c5888017] usable
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000c5888018-0x00000000c5894057] usable
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000c5894058-0x00000000c5895017] usable
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000c5895018-0x00000000c58a5057] usable
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000c58a5058-0x00000000dadb6fff] usable
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000dadb7000-0x00000000dceeefff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000dceef000-0x00000000dcf9efff] ACPI NVS
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000dcf9f000-0x00000000dcffefff] ACPI data
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000dcfff000-0x00000000dcffffff] usable
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000dd000000-0x00000000df9fffff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000f80f8000-0x00000000f80f8fff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000fe101000-0x00000000fe112fff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved
Mar 01 19:02:07 alistair-xps13 kernel: reserve setup_data: [mem 0x0000000100000000-0x000000021f5fffff] usable
Mar 01 19:02:07 alistair-xps13 kernel: efi: EFI v2.31 by Phoenix Technologies Ltd.
Mar 01 19:02:07 alistair-xps13 kernel: efi:  ACPI=0xdcffe000  ACPI 2.0=0xdcffe014  SMBIOS=0xdcc45000 
Mar 01 19:02:07 alistair-xps13 kernel: SMBIOS 2.7 present.
Mar 01 19:02:07 alistair-xps13 kernel: DMI: Dell Inc. XPS13 9333/099TN4, BIOS A06 11/07/2014
Mar 01 19:02:07 alistair-xps13 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Mar 01 19:02:07 alistair-xps13 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable
Mar 01 19:02:07 alistair-xps13 kernel: e820: last_pfn = 0x21f600 max_arch_pfn = 0x400000000
Mar 01 19:02:07 alistair-xps13 kernel: MTRR default type: write-back
Mar 01 19:02:07 alistair-xps13 kernel: MTRR fixed ranges enabled:
Mar 01 19:02:07 alistair-xps13 kernel:   00000-9FFFF write-back
Mar 01 19:02:07 alistair-xps13 kernel:   A0000-BFFFF uncachable
Mar 01 19:02:07 alistair-xps13 kernel:   C0000-FFFFF write-protect
Mar 01 19:02:07 alistair-xps13 kernel: MTRR variable ranges enabled:
Mar 01 19:02:07 alistair-xps13 kernel:   0 base 00E0000000 mask 7FE0000000 uncachable
Mar 01 19:02:07 alistair-xps13 kernel:   1 base 00DE000000 mask 7FFE000000 uncachable
Mar 01 19:02:07 alistair-xps13 kernel:   2 base 00DD000000 mask 7FFF000000 uncachable
Mar 01 19:02:07 alistair-xps13 kernel:   3 disabled
Mar 01 19:02:07 alistair-xps13 kernel:   4 disabled
Mar 01 19:02:07 alistair-xps13 kernel:   5 disabled
Mar 01 19:02:07 alistair-xps13 kernel:   6 disabled
Mar 01 19:02:07 alistair-xps13 kernel:   7 disabled
Mar 01 19:02:07 alistair-xps13 kernel:   8 disabled
Mar 01 19:02:07 alistair-xps13 kernel:   9 disabled
Mar 01 19:02:07 alistair-xps13 kernel: x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WC  UC- WT  
Mar 01 19:02:07 alistair-xps13 kernel: e820: last_pfn = 0xdd000 max_arch_pfn = 0x400000000
Mar 01 19:02:07 alistair-xps13 kernel: Scanning 1 areas for low memory corruption
Mar 01 19:02:07 alistair-xps13 kernel: Base memory trampoline at [ffff880000064000] 64000 size 24576
Mar 01 19:02:07 alistair-xps13 kernel: Using GB pages for direct mapping
Mar 01 19:02:07 alistair-xps13 kernel: BRK [0x01b3f000, 0x01b3ffff] PGTABLE
Mar 01 19:02:07 alistair-xps13 kernel: BRK [0x01b40000, 0x01b40fff] PGTABLE
Mar 01 19:02:07 alistair-xps13 kernel: BRK [0x01b41000, 0x01b41fff] PGTABLE
Mar 01 19:02:07 alistair-xps13 kernel: BRK [0x01b42000, 0x01b42fff] PGTABLE
Mar 01 19:02:07 alistair-xps13 kernel: BRK [0x01b43000, 0x01b43fff] PGTABLE
Mar 01 19:02:07 alistair-xps13 kernel: BRK [0x01b44000, 0x01b44fff] PGTABLE
Mar 01 19:02:07 alistair-xps13 kernel: RAMDISK: [mem 0x7f96e000-0x7fffffff]
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Early table checksum verification disabled
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: RSDP 0x00000000DCFFE014 000024 (v02 DELL  )
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: XSDT 0x00000000DCFFE170 0000CC (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: FACP 0x00000000DCFFB000 00010C (v05 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: DSDT 0x00000000DCFE6000 010640 (v02 DELL   HSW-LPT  00000000 INTL 20120711)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: FACS 0x00000000DCF9C000 000040
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: ASF! 0x00000000DCFFD000 0000A5 (v32 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: HPET 0x00000000DCFFA000 000038 (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: LPIT 0x00000000DCFF9000 000094 (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: APIC 0x00000000DCFF8000 000098 (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: MCFG 0x00000000DCFF7000 00003C (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: SSDT 0x00000000DCFE5000 000228 (v01 DELL   sensrhub 00000000 INTL 20120711)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: SSDT 0x00000000DCFE2000 002028 (v01 DELL   PtidDevc 00001000 INTL 20120711)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: SSDT 0x00000000DCFE1000 000539 (v01 DELL   Cpu0Ist  00003000 INTL 20120711)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: SSDT 0x00000000DCFE0000 000AD8 (v01 DELL   CpuPm    00003000 INTL 20120711)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: SSDT 0x00000000DCFDC000 003688 (v01 DELL   SaSsdt   00003000 INTL 20120711)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: UEFI 0x00000000DCFDB000 000042 (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: MSDM 0x00000000DCF77000 000055 (v03 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: BATB 0x00000000DCFDA000 000046 (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: FPDT 0x00000000DCFD9000 000064 (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: SLIC 0x00000000DCFD8000 000176 (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: UEFI 0x00000000DCFD7000 0002A6 (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: SSDT 0x00000000DCFD6000 0005C1 (v01 DELL   IsctTabl 00001000 INTL 20120711)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: BGRT 0x00000000DCFD5000 000038 (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: CSRT 0x00000000DCFD4000 0000C4 (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: DMAR 0x00000000DCFD3000 0000B0 (v01 DELL   QA09     00000002 LOHR 00000002)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Local APIC address 0xfee00000
Mar 01 19:02:07 alistair-xps13 kernel: No NUMA configuration found
Mar 01 19:02:07 alistair-xps13 kernel: Faking a node at [mem 0x0000000000000000-0x000000021f5fffff]
Mar 01 19:02:07 alistair-xps13 kernel: NODE_DATA(0) allocated [mem 0x21f5f9000-0x21f5fcfff]
Mar 01 19:02:07 alistair-xps13 kernel: Zone ranges:
Mar 01 19:02:07 alistair-xps13 kernel:   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
Mar 01 19:02:07 alistair-xps13 kernel:   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
Mar 01 19:02:07 alistair-xps13 kernel:   Normal   [mem 0x0000000100000000-0x000000021f5fffff]
Mar 01 19:02:07 alistair-xps13 kernel: Movable zone start for each node
Mar 01 19:02:07 alistair-xps13 kernel: Early memory node ranges
Mar 01 19:02:07 alistair-xps13 kernel:   node   0: [mem 0x0000000000001000-0x0000000000057fff]
Mar 01 19:02:07 alistair-xps13 kernel:   node   0: [mem 0x0000000000059000-0x000000000008bfff]
Mar 01 19:02:07 alistair-xps13 kernel:   node   0: [mem 0x0000000000100000-0x00000000c491ffff]
Mar 01 19:02:07 alistair-xps13 kernel:   node   0: [mem 0x00000000c4b22000-0x00000000dadb6fff]
Mar 01 19:02:07 alistair-xps13 kernel:   node   0: [mem 0x00000000dcfff000-0x00000000dcffffff]
Mar 01 19:02:07 alistair-xps13 kernel:   node   0: [mem 0x0000000100000000-0x000000021f5fffff]
Mar 01 19:02:07 alistair-xps13 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000021f5fffff]
Mar 01 19:02:07 alistair-xps13 kernel: On node 0 totalpages: 2072896
Mar 01 19:02:07 alistair-xps13 kernel:   DMA zone: 64 pages used for memmap
Mar 01 19:02:07 alistair-xps13 kernel:   DMA zone: 71 pages reserved
Mar 01 19:02:07 alistair-xps13 kernel:   DMA zone: 3978 pages, LIFO batch:0
Mar 01 19:02:07 alistair-xps13 kernel:   DMA32 zone: 13935 pages used for memmap
Mar 01 19:02:07 alistair-xps13 kernel:   DMA32 zone: 891830 pages, LIFO batch:31
Mar 01 19:02:07 alistair-xps13 kernel:   Normal zone: 18392 pages used for memmap
Mar 01 19:02:07 alistair-xps13 kernel:   Normal zone: 1177088 pages, LIFO batch:31
Mar 01 19:02:07 alistair-xps13 kernel: Reserving Intel graphics stolen memory at 0xdda00000-0xdf9fffff
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: PM-Timer IO Port: 0x1808
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Local APIC address 0xfee00000
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1])
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
Mar 01 19:02:07 alistair-xps13 kernel: IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-39
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: IRQ0 used by override.
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: IRQ9 used by override.
Mar 01 19:02:07 alistair-xps13 kernel: Using ACPI (MADT) for SMP configuration information
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: HPET id: 0x8086a301 base: 0xfed00000
Mar 01 19:02:07 alistair-xps13 kernel: smpboot: Allowing 8 CPUs, 4 hotplug CPUs
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0x00058000-0x00058fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0x0008c000-0x000bffff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0x000c0000-0x000dffff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0x000e0000-0x000fffff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xc4920000-0xc4b21fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xc5876000-0xc5876fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xc5887000-0xc5887fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xc5888000-0xc5888fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xc5894000-0xc5894fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xc5895000-0xc5895fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xc58a5000-0xc58a5fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xdadb7000-0xdceeefff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xdceef000-0xdcf9efff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xdcf9f000-0xdcffefff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xdd000000-0xdf9fffff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xdfa00000-0xf80f7fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xf80f8000-0xf80f8fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xf80f9000-0xfe100fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xfe101000-0xfe112fff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xfe113000-0xfed1bfff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xfed1c000-0xfed1ffff]
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registered nosave memory: [mem 0xfed20000-0xffffffff]
Mar 01 19:02:07 alistair-xps13 kernel: e820: [mem 0xdfa00000-0xf80f7fff] available for PCI devices
Mar 01 19:02:07 alistair-xps13 kernel: Booting paravirtualized kernel on bare hardware
Mar 01 19:02:07 alistair-xps13 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370452778343963 ns
Mar 01 19:02:07 alistair-xps13 kernel: setup_percpu: NR_CPUS:128 nr_cpumask_bits:128 nr_cpu_ids:8 nr_node_ids:1
Mar 01 19:02:07 alistair-xps13 kernel: PERCPU: Embedded 32 pages/cpu @ffff88021f200000 s92696 r8192 d30184 u262144
Mar 01 19:02:07 alistair-xps13 kernel: pcpu-alloc: s92696 r8192 d30184 u262144 alloc=1*2097152
Mar 01 19:02:07 alistair-xps13 kernel: pcpu-alloc: [0] 0 1 2 3 4 5 6 7 
Mar 01 19:02:07 alistair-xps13 kernel: Built 1 zonelists in Node order, mobility grouping on.  Total pages: 2040434
Mar 01 19:02:07 alistair-xps13 kernel: Policy zone: Normal
Mar 01 19:02:07 alistair-xps13 kernel: Kernel command line: initrd=\intel-ucode.img initrd=\initramfs-linux.img root=PARTUUID=70615500-6d75-45f9-972e-2af5aee3f359 rw
Mar 01 19:02:07 alistair-xps13 kernel: PID hash table entries: 4096 (order: 3, 32768 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: Calgary: detecting Calgary via BIOS EBDA area
Mar 01 19:02:07 alistair-xps13 kernel: Calgary: Unable to locate Rio Grande table in EBDA - bailing!
Mar 01 19:02:07 alistair-xps13 kernel: Memory: 7871824K/8291584K available (5721K kernel code, 945K rwdata, 1820K rodata, 1188K init, 1156K bss, 419760K reserved, 0K cma-reserved)
Mar 01 19:02:07 alistair-xps13 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1
Mar 01 19:02:07 alistair-xps13 kernel: Preemptible hierarchical RCU implementation.
Mar 01 19:02:07 alistair-xps13 kernel:         Build-time adjustment of leaf fanout to 64.
Mar 01 19:02:07 alistair-xps13 kernel:         RCU restricting CPUs from NR_CPUS=128 to nr_cpu_ids=8.
Mar 01 19:02:07 alistair-xps13 kernel: RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=8
Mar 01 19:02:07 alistair-xps13 kernel: NR_IRQS:8448 nr_irqs:760 16
Mar 01 19:02:07 alistair-xps13 kernel: Console: colour dummy device 80x25
Mar 01 19:02:07 alistair-xps13 kernel: console [tty0] enabled
Mar 01 19:02:07 alistair-xps13 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 133484882848 ns
Mar 01 19:02:07 alistair-xps13 kernel: hpet clockevent registered
Mar 01 19:02:07 alistair-xps13 kernel: tsc: Fast TSC calibration using PIT
Mar 01 19:02:07 alistair-xps13 kernel: tsc: Detected 2294.617 MHz processor
Mar 01 19:02:07 alistair-xps13 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 4591.45 BogoMIPS (lpj=7648723)
Mar 01 19:02:07 alistair-xps13 kernel: pid_max: default: 32768 minimum: 301
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Core revision 20150930
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: 7 ACPI AML tables successfully acquired and loaded
Mar 01 19:02:07 alistair-xps13 kernel: Security Framework initialized
Mar 01 19:02:07 alistair-xps13 kernel: Yama: becoming mindful.
Mar 01 19:02:07 alistair-xps13 kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: Initializing cgroup subsys io
Mar 01 19:02:07 alistair-xps13 kernel: Initializing cgroup subsys memory
Mar 01 19:02:07 alistair-xps13 kernel: Initializing cgroup subsys devices
Mar 01 19:02:07 alistair-xps13 kernel: Initializing cgroup subsys freezer
Mar 01 19:02:07 alistair-xps13 kernel: Initializing cgroup subsys net_cls
Mar 01 19:02:07 alistair-xps13 kernel: Initializing cgroup subsys pids
Mar 01 19:02:07 alistair-xps13 kernel: CPU: Physical Processor ID: 0
Mar 01 19:02:07 alistair-xps13 kernel: CPU: Processor Core ID: 0
Mar 01 19:02:07 alistair-xps13 kernel: ENERGY_PERF_BIAS: Set to 'normal', was 'performance'
Mar 01 19:02:07 alistair-xps13 kernel: ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8)
Mar 01 19:02:07 alistair-xps13 kernel: mce: CPU supports 7 MCE banks
Mar 01 19:02:07 alistair-xps13 kernel: CPU0: Thermal monitoring enabled (TM1)
Mar 01 19:02:07 alistair-xps13 kernel: process: using mwait in idle threads
Mar 01 19:02:07 alistair-xps13 kernel: Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024
Mar 01 19:02:07 alistair-xps13 kernel: Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4
Mar 01 19:02:07 alistair-xps13 kernel: Freeing SMP alternatives memory: 20K (ffffffff81a17000 - ffffffff81a1c000)
Mar 01 19:02:07 alistair-xps13 kernel: ftrace: allocating 22852 entries in 90 pages
Mar 01 19:02:07 alistair-xps13 kernel: DMAR: Host address width 39
Mar 01 19:02:07 alistair-xps13 kernel: DMAR: DRHD base: 0x000000fed90000 flags: 0x0
Mar 01 19:02:07 alistair-xps13 kernel: DMAR: dmar0: reg_base_addr fed90000 ver 1:0 cap c0000020660462 ecap f0101a
Mar 01 19:02:07 alistair-xps13 kernel: DMAR: DRHD base: 0x000000fed91000 flags: 0x1
Mar 01 19:02:07 alistair-xps13 kernel: DMAR: dmar1: reg_base_addr fed91000 ver 1:0 cap d2008020660462 ecap f010da
Mar 01 19:02:07 alistair-xps13 kernel: DMAR: RMRR base: 0x000000dc36d000 end: 0x000000dc383fff
Mar 01 19:02:07 alistair-xps13 kernel: DMAR: RMRR base: 0x000000dd800000 end: 0x000000df9fffff
Mar 01 19:02:07 alistair-xps13 kernel: DMAR-IR: IOAPIC id 2 under DRHD base  0xfed91000 IOMMU 1
Mar 01 19:02:07 alistair-xps13 kernel: DMAR-IR: HPET id 0 under DRHD base 0xfed91000
Mar 01 19:02:07 alistair-xps13 kernel: DMAR-IR: Queued invalidation will be enabled to support x2apic and Intr-remapping.
Mar 01 19:02:07 alistair-xps13 kernel: DMAR-IR: Enabled IRQ remapping in x2apic mode
Mar 01 19:02:07 alistair-xps13 kernel: x2apic enabled
Mar 01 19:02:07 alistair-xps13 kernel: Switched APIC routing to cluster x2apic.
Mar 01 19:02:07 alistair-xps13 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
Mar 01 19:02:07 alistair-xps13 kernel: TSC deadline timer enabled
Mar 01 19:02:07 alistair-xps13 kernel: smpboot: CPU0: Intel(R) Core(TM) i7-4650U CPU @ 1.70GHz (family: 0x6, model: 0x45, stepping: 0x1)
Mar 01 19:02:07 alistair-xps13 kernel: Performance Events: PEBS fmt2+, 16-deep LBR, Haswell events, full-width counters, Intel PMU driver.
Mar 01 19:02:07 alistair-xps13 kernel: ... version:                3
Mar 01 19:02:07 alistair-xps13 kernel: ... bit width:              48
Mar 01 19:02:07 alistair-xps13 kernel: ... generic registers:      4
Mar 01 19:02:07 alistair-xps13 kernel: ... value mask:             0000ffffffffffff
Mar 01 19:02:07 alistair-xps13 kernel: ... max period:             0000ffffffffffff
Mar 01 19:02:07 alistair-xps13 kernel: ... fixed-purpose events:   3
Mar 01 19:02:07 alistair-xps13 kernel: ... event mask:             000000070000000f
Mar 01 19:02:07 alistair-xps13 kernel: x86: Booting SMP configuration:
Mar 01 19:02:07 alistair-xps13 kernel: .... node  #0, CPUs:      #1
Mar 01 19:02:07 alistair-xps13 kernel: NMI watchdog: enabled on all CPUs, permanently consumes one hw-PMU counter.
Mar 01 19:02:07 alistair-xps13 kernel:  #2
Mar 01 19:02:07 alistair-xps13 kernel: microcode: CPU2 microcode updated early to revision 0x1d, date = 2015-08-13
Mar 01 19:02:07 alistair-xps13 kernel:  #3
Mar 01 19:02:07 alistair-xps13 kernel: x86: Booted up 1 node, 4 CPUs
Mar 01 19:02:07 alistair-xps13 kernel: smpboot: Total of 4 processors activated (18364.80 BogoMIPS)
Mar 01 19:02:07 alistair-xps13 kernel: devtmpfs: initialized
Mar 01 19:02:07 alistair-xps13 kernel: PM: Registering ACPI NVS region [mem 0xdceef000-0xdcf9efff] (720896 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 6370867519511994 ns
Mar 01 19:02:07 alistair-xps13 kernel: pinctrl core: initialized pinctrl subsystem
Mar 01 19:02:07 alistair-xps13 kernel: RTC time: 18:01:56, date: 03/01/16
Mar 01 19:02:07 alistair-xps13 kernel: NET: Registered protocol family 16
Mar 01 19:02:07 alistair-xps13 kernel: cpuidle: using governor ladder
Mar 01 19:02:07 alistair-xps13 kernel: cpuidle: using governor menu
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: bus type PCI registered
Mar 01 19:02:07 alistair-xps13 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Mar 01 19:02:07 alistair-xps13 kernel: PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xf8000000-0xfbffffff] (base 0xf8000000)
Mar 01 19:02:07 alistair-xps13 kernel: PCI: not using MMCONFIG
Mar 01 19:02:07 alistair-xps13 kernel: PCI: Using configuration type 1 for base access
Mar 01 19:02:07 alistair-xps13 kernel: dmi type 0xB1 record - unknown flag
Mar 01 19:02:07 alistair-xps13 kernel: perf_event_intel: PMU erratum BJ122, BV98, HSD29 worked around, HT is on
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Added _OSI(Module Device)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Added _OSI(Processor Device)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Added _OSI(Processor Aggregator Device)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Executed 1 blocks of module-level executable AML code
Mar 01 19:02:07 alistair-xps13 kernel: [Firmware Bug]: ACPI: BIOS _OSI(Linux) query ignored
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Dynamic OEM Table Load:
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: SSDT 0xFFFF8802150A8800 0003D3 (v01 PmRef  Cpu0Cst  00003001 INTL 20120711)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Dynamic OEM Table Load:
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: SSDT 0xFFFF880215052000 0005AA (v01 PmRef  ApIst    00003000 INTL 20120711)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Dynamic OEM Table Load:
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: SSDT 0xFFFF88021505B000 000119 (v01 PmRef  ApCst    00003000 INTL 20120711)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI : EC: EC started
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Interpreter enabled
Mar 01 19:02:07 alistair-xps13 kernel: ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State [\_S2_] (20150930/hwxface-580)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: (supports S0 S1 S3 S4 S5)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Using IOAPIC for interrupt routing
Mar 01 19:02:07 alistair-xps13 kernel: PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xf8000000-0xfbffffff] (base 0xf8000000)
Mar 01 19:02:07 alistair-xps13 kernel: PCI: MMCONFIG at [mem 0xf8000000-0xfbffffff] reserved in ACPI motherboard resources
Mar 01 19:02:07 alistair-xps13 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-3e])
Mar 01 19:02:07 alistair-xps13 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI]
Mar 01 19:02:07 alistair-xps13 kernel: \_SB_.PCI0:_OSC invalid UUID
Mar 01 19:02:07 alistair-xps13 kernel: _OSC request data:1 1f 0 
Mar 01 19:02:07 alistair-xps13 kernel: acpi PNP0A08:00: _OSC failed (AE_ERROR); disabling ASPM
Mar 01 19:02:07 alistair-xps13 kernel: PCI host bridge to bus 0000:00
Mar 01 19:02:07 alistair-xps13 kernel: pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
Mar 01 19:02:07 alistair-xps13 kernel: pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
Mar 01 19:02:07 alistair-xps13 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
Mar 01 19:02:07 alistair-xps13 kernel: pci_bus 0000:00: root bus resource [mem 0xdfa00000-0xfeafffff window]
Mar 01 19:02:07 alistair-xps13 kernel: pci_bus 0000:00: root bus resource [bus 00-3e]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:00.0: [8086:0a04] type 00 class 0x060000
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:02.0: [8086:0a26] type 00 class 0x030000
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xf0000000-0xf03fffff 64bit]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xe0000000-0xefffffff 64bit pref]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:02.0: reg 0x20: [io  0x3000-0x303f]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:03.0: [8086:0a0c] type 00 class 0x040300
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:03.0: reg 0x10: [mem 0xf0510000-0xf0513fff 64bit]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:14.0: [8086:9c31] type 00 class 0x0c0330
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:14.0: reg 0x10: [mem 0xf0500000-0xf050ffff 64bit]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:14.0: PME# supported from D3hot D3cold
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:14.0: System wakeup disabled by ACPI
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:16.0: [8086:9c3a] type 00 class 0x078000
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:16.0: reg 0x10: [mem 0xf0519000-0xf051901f 64bit]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:16.0: PME# supported from D0 D3hot D3cold
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1b.0: [8086:9c20] type 00 class 0x040300
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1b.0: reg 0x10: [mem 0xf0514000-0xf0517fff 64bit]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1b.0: System wakeup disabled by ACPI
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.0: [8086:9c10] type 01 class 0x060400
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.0: System wakeup disabled by ACPI
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.2: [8086:9c14] type 01 class 0x060400
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.2: PME# supported from D0 D3hot D3cold
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.2: System wakeup disabled by ACPI
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1d.0: [8086:9c26] type 00 class 0x0c0320
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1d.0: reg 0x10: [mem 0xf051d000-0xf051d3ff]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1d.0: PME# supported from D0 D3hot D3cold
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1d.0: System wakeup disabled by ACPI
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.0: [8086:9c43] type 00 class 0x060100
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.2: [8086:9c03] type 00 class 0x010601
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.2: reg 0x10: [io  0x3088-0x308f]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.2: reg 0x14: [io  0x3094-0x3097]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.2: reg 0x18: [io  0x3080-0x3087]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.2: reg 0x1c: [io  0x3090-0x3093]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.2: reg 0x20: [io  0x3060-0x307f]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xf051c000-0xf051c7ff]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.2: PME# supported from D3hot
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.3: [8086:9c22] type 00 class 0x0c0500
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.3: reg 0x10: [mem 0xf0518000-0xf05180ff 64bit]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1f.3: reg 0x20: [io  0xefa0-0xefbf]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.0: PCI bridge to [bus 01]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:02:00.0: [8086:08b1] type 00 class 0x028000
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:02:00.0: reg 0x10: [mem 0xf0400000-0xf0401fff 64bit]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:02:00.0: PME# supported from D0 D3hot D3cold
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:02:00.0: System wakeup disabled by ACPI
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.2: PCI bridge to [bus 02]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.2:   bridge window [mem 0xf0400000-0xf04fffff]
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 10 *11 12 14 15)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled.
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled.
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled.
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled.
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled.
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled.
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 10 11 12 14 15) *0, disabled.
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Enabled 5 GPEs in block 00 to 7F
Mar 01 19:02:07 alistair-xps13 kernel: ACPI : EC: GPE = 0xa, I/O: command/status = 0x66, data = 0x62
Mar 01 19:02:07 alistair-xps13 kernel: vgaarb: setting as boot device: PCI:0000:00:02.0
Mar 01 19:02:07 alistair-xps13 kernel: vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
Mar 01 19:02:07 alistair-xps13 kernel: vgaarb: loaded
Mar 01 19:02:07 alistair-xps13 kernel: vgaarb: bridge control possible 0000:00:02.0
Mar 01 19:02:07 alistair-xps13 kernel: PCI: Using ACPI for IRQ routing
Mar 01 19:02:07 alistair-xps13 kernel: PCI: pci_cache_line_size set to 64 bytes
Mar 01 19:02:07 alistair-xps13 kernel: e820: reserve RAM buffer [mem 0x00058000-0x0005ffff]
Mar 01 19:02:07 alistair-xps13 kernel: e820: reserve RAM buffer [mem 0x0008c000-0x0008ffff]
Mar 01 19:02:07 alistair-xps13 kernel: e820: reserve RAM buffer [mem 0xc4920000-0xc7ffffff]
Mar 01 19:02:07 alistair-xps13 kernel: e820: reserve RAM buffer [mem 0xc5876018-0xc7ffffff]
Mar 01 19:02:07 alistair-xps13 kernel: e820: reserve RAM buffer [mem 0xc5888018-0xc7ffffff]
Mar 01 19:02:07 alistair-xps13 kernel: e820: reserve RAM buffer [mem 0xc5895018-0xc7ffffff]
Mar 01 19:02:07 alistair-xps13 kernel: e820: reserve RAM buffer [mem 0xdadb7000-0xdbffffff]
Mar 01 19:02:07 alistair-xps13 kernel: e820: reserve RAM buffer [mem 0xdd000000-0xdfffffff]
Mar 01 19:02:07 alistair-xps13 kernel: e820: reserve RAM buffer [mem 0x21f600000-0x21fffffff]
Mar 01 19:02:07 alistair-xps13 kernel: NetLabel: Initializing
Mar 01 19:02:07 alistair-xps13 kernel: NetLabel:  domain hash size = 128
Mar 01 19:02:07 alistair-xps13 kernel: NetLabel:  protocols = UNLABELED CIPSOv4
Mar 01 19:02:07 alistair-xps13 kernel: NetLabel:  unlabeled traffic allowed by default
Mar 01 19:02:07 alistair-xps13 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0
Mar 01 19:02:07 alistair-xps13 kernel: hpet0: 8 comparators, 64-bit 14.318180 MHz counter
Mar 01 19:02:07 alistair-xps13 kernel: clocksource: Switched to clocksource hpet
Mar 01 19:02:07 alistair-xps13 kernel: pnp: PnP ACPI init
Mar 01 19:02:07 alistair-xps13 kernel: system 00:00: [io  0x0680-0x069f] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:00: [io  0xffff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:00: [io  0xffff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:00: [io  0xffff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:00: [io  0x1800-0x18fe] could not be reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:00: [io  0x164e-0x164f] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:00: Plug and Play ACPI device, IDs PNP0c02 (active)
Mar 01 19:02:07 alistair-xps13 kernel: pnp 00:01: Plug and Play ACPI device, IDs PNP0b00 (active)
Mar 01 19:02:07 alistair-xps13 kernel: system 00:02: [io  0x1854-0x1857] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:02: Plug and Play ACPI device, IDs INT3f0d PNP0c02 (active)
Mar 01 19:02:07 alistair-xps13 kernel: pnp 00:03: Plug and Play ACPI device, IDs PNP0303 (active)
Mar 01 19:02:07 alistair-xps13 kernel: pnp 00:04: Plug and Play ACPI device, IDs SYN0608 PNP0f03 (active)
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: [mem 0xfed1c000-0xfed1ffff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: [mem 0xfed10000-0xfed17fff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: [mem 0xfed18000-0xfed18fff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: [mem 0xfed19000-0xfed19fff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: [mem 0xf8000000-0xfbffffff] could not be reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: [mem 0xfed20000-0xfed3ffff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: [mem 0xfed90000-0xfed93fff] could not be reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: [mem 0xfed45000-0xfed8ffff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: [mem 0xff000000-0xffffffff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: [mem 0xfee00000-0xfeefffff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: [mem 0xdfa10000-0xdfa1ffff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:05: Plug and Play ACPI device, IDs PNP0c02 (active)
Mar 01 19:02:07 alistair-xps13 kernel: system 00:06: [mem 0xfe102000-0xfe102fff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:06: [mem 0xfe104000-0xfe104fff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:06: [mem 0xfe106000-0xfe106fff] has been reserved
Mar 01 19:02:07 alistair-xps13 kernel: system 00:06: Plug and Play ACPI device, IDs PNP0c02 (active)
Mar 01 19:02:07 alistair-xps13 kernel: pnp: PnP ACPI: found 7 devices
Mar 01 19:02:07 alistair-xps13 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.0: PCI bridge to [bus 01]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.2: PCI bridge to [bus 02]
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:1c.2:   bridge window [mem 0xf0400000-0xf04fffff]
Mar 01 19:02:07 alistair-xps13 kernel: pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
Mar 01 19:02:07 alistair-xps13 kernel: pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
Mar 01 19:02:07 alistair-xps13 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
Mar 01 19:02:07 alistair-xps13 kernel: pci_bus 0000:00: resource 7 [mem 0xdfa00000-0xfeafffff window]
Mar 01 19:02:07 alistair-xps13 kernel: pci_bus 0000:02: resource 1 [mem 0xf0400000-0xf04fffff]
Mar 01 19:02:07 alistair-xps13 kernel: NET: Registered protocol family 2
Mar 01 19:02:07 alistair-xps13 kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: TCP: Hash tables configured (established 65536 bind 65536)
Mar 01 19:02:07 alistair-xps13 kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: NET: Registered protocol family 1
Mar 01 19:02:07 alistair-xps13 kernel: pci 0000:00:02.0: Video device with shadowed ROM
Mar 01 19:02:07 alistair-xps13 kernel: PCI: CLS 64 bytes, default 64
Mar 01 19:02:07 alistair-xps13 kernel: Unpacking initramfs...
Mar 01 19:02:07 alistair-xps13 kernel: Freeing initrd memory: 6728K (ffff88007f96e000 - ffff880080000000)
Mar 01 19:02:07 alistair-xps13 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
Mar 01 19:02:07 alistair-xps13 kernel: software IO TLB [mem 0xc8de8000-0xccde8000] (64MB) mapped at [ffff8800c8de8000-ffff8800ccde7fff]
Mar 01 19:02:07 alistair-xps13 kernel: RAPL PMU detected, API unit is 2^-32 Joules, 4 fixed counters 655360 ms ovfl timer
Mar 01 19:02:07 alistair-xps13 kernel: hw unit of domain pp0-core 2^-14 Joules
Mar 01 19:02:07 alistair-xps13 kernel: hw unit of domain package 2^-14 Joules
Mar 01 19:02:07 alistair-xps13 kernel: hw unit of domain dram 2^-14 Joules
Mar 01 19:02:07 alistair-xps13 kernel: hw unit of domain pp1-gpu 2^-14 Joules
Mar 01 19:02:07 alistair-xps13 kernel: Scanning for low memory corruption every 60 seconds
Mar 01 19:02:07 alistair-xps13 kernel: futex hash table entries: 2048 (order: 5, 131072 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: Initialise system trusted keyring
Mar 01 19:02:07 alistair-xps13 kernel: HugeTLB registered 2 MB page size, pre-allocated 0 pages
Mar 01 19:02:07 alistair-xps13 kernel: zbud: loaded
Mar 01 19:02:07 alistair-xps13 kernel: VFS: Disk quotas dquot_6.6.0
Mar 01 19:02:07 alistair-xps13 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Mar 01 19:02:07 alistair-xps13 kernel: Key type big_key registered
Mar 01 19:02:07 alistair-xps13 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
Mar 01 19:02:07 alistair-xps13 kernel: io scheduler noop registered
Mar 01 19:02:07 alistair-xps13 kernel: io scheduler deadline registered
Mar 01 19:02:07 alistair-xps13 kernel: io scheduler cfq registered (default)
Mar 01 19:02:07 alistair-xps13 kernel: pci_hotplug: PCI Hot Plug PCI Core version: 0.5
Mar 01 19:02:07 alistair-xps13 kernel: pciehp: PCI Express Hot Plug Controller Driver version: 0.4
Mar 01 19:02:07 alistair-xps13 kernel: efifb: probing for efifb
Mar 01 19:02:07 alistair-xps13 kernel: efifb: framebuffer at 0xe0000000, mapped to 0xffffc90001000000, using 8100k, total 8100k
Mar 01 19:02:07 alistair-xps13 kernel: efifb: mode is 1920x1080x32, linelength=7680, pages=1
Mar 01 19:02:07 alistair-xps13 kernel: efifb: scrolling: redraw
Mar 01 19:02:07 alistair-xps13 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0
Mar 01 19:02:07 alistair-xps13 kernel: Console: switching to colour frame buffer device 240x67
Mar 01 19:02:07 alistair-xps13 kernel: fb0: EFI VGA frame buffer device
Mar 01 19:02:07 alistair-xps13 kernel: intel_idle: MWAIT substates: 0x11142120
Mar 01 19:02:07 alistair-xps13 kernel: intel_idle: v0.4 model 0x45
Mar 01 19:02:07 alistair-xps13 kernel: intel_idle: lapic_timer_reliable_states 0xffffffff
Mar 01 19:02:07 alistair-xps13 kernel: GHES: HEST is not enabled!
Mar 01 19:02:07 alistair-xps13 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
Mar 01 19:02:07 alistair-xps13 kernel: Linux agpgart interface v0.103
Mar 01 19:02:07 alistair-xps13 kernel: rtc_cmos 00:01: RTC can wake from S4
Mar 01 19:02:07 alistair-xps13 kernel: rtc_cmos 00:01: rtc core: registered rtc_cmos as rtc0
Mar 01 19:02:07 alistair-xps13 kernel: rtc_cmos 00:01: alarms up to one month, y3k, 242 bytes nvram, hpet irqs
Mar 01 19:02:07 alistair-xps13 kernel: Intel P-state driver initializing.
Mar 01 19:02:07 alistair-xps13 kernel: ledtrig-cpu: registered to indicate activity on CPUs
Mar 01 19:02:07 alistair-xps13 kernel: NET: Registered protocol family 10
Mar 01 19:02:07 alistair-xps13 kernel: NET: Registered protocol family 17
Mar 01 19:02:07 alistair-xps13 kernel: microcode: CPU0 sig=0x40651, pf=0x40, revision=0x1d
Mar 01 19:02:07 alistair-xps13 kernel: microcode: CPU1 sig=0x40651, pf=0x40, revision=0x1d
Mar 01 19:02:07 alistair-xps13 kernel: microcode: CPU2 sig=0x40651, pf=0x40, revision=0x1d
Mar 01 19:02:07 alistair-xps13 kernel: microcode: CPU3 sig=0x40651, pf=0x40, revision=0x1d
Mar 01 19:02:07 alistair-xps13 kernel: microcode: Microcode Update Driver: v2.01 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
Mar 01 19:02:07 alistair-xps13 kernel: registered taskstats version 1
Mar 01 19:02:07 alistair-xps13 kernel: Loading compiled-in X.509 certificates
Mar 01 19:02:07 alistair-xps13 kernel: zswap: loaded using pool lzo/zbud
Mar 01 19:02:07 alistair-xps13 kernel:   Magic number: 8:924:37
Mar 01 19:02:07 alistair-xps13 kernel: rtc_cmos 00:01: setting system clock to 2016-03-01 18:01:56 UTC (1456855316)
Mar 01 19:02:07 alistair-xps13 kernel: PM: Hibernation image not present or could not be loaded.
Mar 01 19:02:07 alistair-xps13 kernel: Freeing unused kernel memory: 1188K (ffffffff818ee000 - ffffffff81a17000)
Mar 01 19:02:07 alistair-xps13 kernel: Write protecting the kernel read-only data: 8192k
Mar 01 19:02:07 alistair-xps13 kernel: Freeing unused kernel memory: 412K (ffff880001599000 - ffff880001600000)
Mar 01 19:02:07 alistair-xps13 kernel: Freeing unused kernel memory: 228K (ffff8800017c7000 - ffff880001800000)
Mar 01 19:02:07 alistair-xps13 kernel: random: systemd-tmpfile urandom read with 3 bits of entropy available
Mar 01 19:02:07 alistair-xps13 kernel: i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f03:PS2M] at 0x60,0x64 irq 1,12
Mar 01 19:02:07 alistair-xps13 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1
Mar 01 19:02:07 alistair-xps13 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12
Mar 01 19:02:07 alistair-xps13 kernel: sdhci: Secure Digital Host Controller Interface driver
Mar 01 19:02:07 alistair-xps13 kernel: sdhci: Copyright(c) Pierre Ossman
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: bus type USB registered
Mar 01 19:02:07 alistair-xps13 kernel: usbcore: registered new interface driver usbfs
Mar 01 19:02:07 alistair-xps13 kernel: usbcore: registered new interface driver hub
Mar 01 19:02:07 alistair-xps13 kernel: usbcore: registered new device driver usb
Mar 01 19:02:07 alistair-xps13 kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Mar 01 19:02:07 alistair-xps13 kernel: ehci-pci: EHCI PCI platform driver
Mar 01 19:02:07 alistair-xps13 kernel: ehci-pci 0000:00:1d.0: EHCI Host Controller
Mar 01 19:02:07 alistair-xps13 kernel: ehci-pci 0000:00:1d.0: new USB bus registered, assigned bus number 1
Mar 01 19:02:07 alistair-xps13 kernel: ehci-pci 0000:00:1d.0: debug port 2
Mar 01 19:02:07 alistair-xps13 kernel: SCSI subsystem initialized
Mar 01 19:02:07 alistair-xps13 kernel: libata version 3.00 loaded.
Mar 01 19:02:07 alistair-xps13 kernel: ehci-pci 0000:00:1d.0: cache line size of 64 is not supported
Mar 01 19:02:07 alistair-xps13 kernel: ehci-pci 0000:00:1d.0: irq 23, io mem 0xf051d000
Mar 01 19:02:07 alistair-xps13 kernel: ehci-pci 0000:00:1d.0: USB 2.0 started, EHCI 1.00
Mar 01 19:02:07 alistair-xps13 kernel: hub 1-0:1.0: USB hub found
Mar 01 19:02:07 alistair-xps13 kernel: hub 1-0:1.0: 2 ports detected
Mar 01 19:02:07 alistair-xps13 kernel: xhci_hcd 0000:00:14.0: can't derive routing for PCI INT A
Mar 01 19:02:07 alistair-xps13 kernel: xhci_hcd 0000:00:14.0: PCI INT A: no GSI
Mar 01 19:02:07 alistair-xps13 kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller
Mar 01 19:02:07 alistair-xps13 kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 2
Mar 01 19:02:07 alistair-xps13 kernel: xhci_hcd 0000:00:14.0: hcc params 0x200077c1 hci version 0x100 quirks 0x0004b810
Mar 01 19:02:07 alistair-xps13 kernel: xhci_hcd 0000:00:14.0: cache line size of 64 is not supported
Mar 01 19:02:07 alistair-xps13 kernel: hub 2-0:1.0: USB hub found
Mar 01 19:02:07 alistair-xps13 kernel: hub 2-0:1.0: 9 ports detected
Mar 01 19:02:07 alistair-xps13 kernel: xhci_hcd 0000:00:14.0: xHCI Host Controller
Mar 01 19:02:07 alistair-xps13 kernel: xhci_hcd 0000:00:14.0: new USB bus registered, assigned bus number 3
Mar 01 19:02:07 alistair-xps13 kernel: hub 3-0:1.0: USB hub found
Mar 01 19:02:07 alistair-xps13 kernel: hub 3-0:1.0: 4 ports detected
Mar 01 19:02:07 alistair-xps13 kernel: ahci 0000:00:1f.2: version 3.0
Mar 01 19:02:07 alistair-xps13 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
Mar 01 19:02:07 alistair-xps13 kernel: ahci 0000:00:1f.2: AHCI 0001.0300 32 slots 4 ports 6 Gbps 0x4 impl SATA mode
Mar 01 19:02:07 alistair-xps13 kernel: ahci 0000:00:1f.2: flags: 64bit ncq pm led clo only pio slum part deso sadm sds apst 
Mar 01 19:02:07 alistair-xps13 kernel: scsi host0: ahci
Mar 01 19:02:07 alistair-xps13 kernel: scsi host1: ahci
Mar 01 19:02:07 alistair-xps13 kernel: scsi host2: ahci
Mar 01 19:02:07 alistair-xps13 kernel: scsi host3: ahci
Mar 01 19:02:07 alistair-xps13 kernel: ata1: DUMMY
Mar 01 19:02:07 alistair-xps13 kernel: ata2: DUMMY
Mar 01 19:02:07 alistair-xps13 kernel: ata3: SATA max UDMA/133 abar m2048@0xf051c000 port 0xf051c200 irq 43
Mar 01 19:02:07 alistair-xps13 kernel: ata4: DUMMY
Mar 01 19:02:07 alistair-xps13 kernel: usb 3-2: new SuperSpeed USB device number 2 using xhci_hcd
Mar 01 19:02:07 alistair-xps13 kernel: usb 1-1: new high-speed USB device number 2 using ehci-pci
Mar 01 19:02:07 alistair-xps13 kernel: ata3: SATA link up 6.0 Gbps (SStatus 133 SControl 300)
Mar 01 19:02:07 alistair-xps13 kernel: ata3.00: ATA-8: SK hynix SH920 mSATA 256GB, 10104L00, max UDMA/133
Mar 01 19:02:07 alistair-xps13 kernel: ata3.00: 500118192 sectors, multi 1: LBA48 NCQ (depth 31/32), AA
Mar 01 19:02:07 alistair-xps13 kernel: ata3.00: configured for UDMA/133
Mar 01 19:02:07 alistair-xps13 kernel: scsi 2:0:0:0: Direct-Access     ATA      SK hynix SH920 m 4L00 PQ: 0 ANSI: 5
Mar 01 19:02:07 alistair-xps13 kernel: sd 2:0:0:0: [sda] 500118192 512-byte logical blocks: (256 GB/238 GiB)
Mar 01 19:02:07 alistair-xps13 kernel: sd 2:0:0:0: [sda] Write Protect is off
Mar 01 19:02:07 alistair-xps13 kernel: sd 2:0:0:0: [sda] Mode Sense: 00 3a 00 00
Mar 01 19:02:07 alistair-xps13 kernel: sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Mar 01 19:02:07 alistair-xps13 kernel:  sda: sda1 sda2 sda3 sda4
Mar 01 19:02:07 alistair-xps13 kernel: sd 2:0:0:0: [sda] Attached SCSI disk
Mar 01 19:02:07 alistair-xps13 kernel: usb 2-2: new high-speed USB device number 2 using xhci_hcd
Mar 01 19:02:07 alistair-xps13 kernel: hub 1-1:1.0: USB hub found
Mar 01 19:02:07 alistair-xps13 kernel: hub 1-1:1.0: 8 ports detected
Mar 01 19:02:07 alistair-xps13 kernel: hub 3-2:1.0: USB hub found
Mar 01 19:02:07 alistair-xps13 kernel: hub 3-2:1.0: 4 ports detected
Mar 01 19:02:07 alistair-xps13 kernel: hub 2-2:1.0: USB hub found
Mar 01 19:02:07 alistair-xps13 kernel: hub 2-2:1.0: 4 ports detected
Mar 01 19:02:07 alistair-xps13 kernel: usb 2-3: new full-speed USB device number 3 using xhci_hcd
Mar 01 19:02:07 alistair-xps13 kernel: hidraw: raw HID events driver (C) Jiri Kosina
Mar 01 19:02:07 alistair-xps13 kernel: usbcore: registered new interface driver usbhid
Mar 01 19:02:07 alistair-xps13 kernel: usbhid: USB HID core driver
Mar 01 19:02:07 alistair-xps13 kernel: input: SYNAPTICS Synaptics Large Touch Screen as /devices/pci0000:00/0000:00:14.0/usb2/2-3/2-3:1.0/0003:06CB:0AF8.0001/input/input2
Mar 01 19:02:07 alistair-xps13 kernel: hid-multitouch 0003:06CB:0AF8.0001: input,hiddev0,hidraw0: USB HID v1.11 Mouse [SYNAPTICS Synaptics Large Touch Screen] on usb-0000:00:14.0-3/input0
Mar 01 19:02:07 alistair-xps13 kernel: tsc: Refined TSC clocksource calibration: 2294.692 MHz
Mar 01 19:02:07 alistair-xps13 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x21139ef1243, max_idle_ns: 440795281462 ns
Mar 01 19:02:07 alistair-xps13 kernel: usb 2-2.3: new high-speed USB device number 4 using xhci_hcd
Mar 01 19:02:07 alistair-xps13 kernel: usb 2-5: new high-speed USB device number 5 using xhci_hcd
Mar 01 19:02:07 alistair-xps13 kernel: usb 2-2.4: new low-speed USB device number 6 using xhci_hcd
Mar 01 19:02:07 alistair-xps13 kernel: usb 2-2.4: ep 0x81 - rounding interval to 64 microframes, ep desc says 80 microframes
Mar 01 19:02:07 alistair-xps13 kernel: usb 2-6: new full-speed USB device number 7 using xhci_hcd
Mar 01 19:02:07 alistair-xps13 kernel: clocksource: Switched to clocksource tsc
Mar 01 19:02:07 alistair-xps13 kernel: EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null)
Mar 01 19:02:07 alistair-xps13 kernel: ip_tables: (C) 2000-2006 Netfilter Core Team
Mar 01 19:02:07 alistair-xps13 systemd[1]: systemd 229 running in system mode. (+PAM -AUDIT -SELINUX -IMA -APPARMOR +SMACK -SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN)
Mar 01 19:02:07 alistair-xps13 systemd[1]: Detected architecture x86-64.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Set hostname to <alistair-xps13>.
Mar 01 19:02:07 alistair-xps13 systemd-fstab-generator[169]: Checking was requested for "/home/zoneminder/events", but it is not a device.
Mar 01 19:02:07 alistair-xps13 systemd-fstab-generator[169]: Checking was requested for "/home/zoneminder/images", but it is not a device.
Mar 01 19:02:07 alistair-xps13 systemd-fstab-generator[169]: Checking was requested for "/home/zoneminder/temp", but it is not a device.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Listening on LVM2 metadata daemon socket.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Created slice User and Session Slice.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started Forward Password Requests to Wall Directory Watch.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Listening on Device-mapper event daemon FIFOs.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Listening on udev Control Socket.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Listening on udev Kernel Socket.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Listening on Journal Socket (/dev/log).
Mar 01 19:02:07 alistair-xps13 systemd[1]: Created slice System Slice.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Reached target Slices.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Created slice system-systemd\x2dfsck.slice.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Created slice system-getty.slice.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Reached target Paths.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Reached target Remote File Systems.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Listening on Process Core Dump Socket.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Reached target Encrypted Volumes.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Listening on Journal Socket.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting Create list of required static device nodes for the current kernel...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounting Debug File System...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting Load Kernel Modules...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounting POSIX Message Queue File System...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounting Huge Pages File System...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounting Temporary Directory...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting Journal Service...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting Remount Root and Kernel File Systems...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting Set Up Additional Binary Formats...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting Setup Virtual Console...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started Create list of required static device nodes for the current kernel.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started Setup Virtual Console.
Mar 01 19:02:07 alistair-xps13 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 191 (systemd-binfmt)
Mar 01 19:02:07 alistair-xps13 kernel: EXT4-fs (sda2): re-mounted. Opts: data=ordered
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounted Huge Pages File System.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounted Temporary Directory.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounted POSIX Message Queue File System.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounted Debug File System.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started Remount Root and Kernel File Systems.
Mar 01 19:02:07 alistair-xps13 kernel: zavl: module license 'CDDL' taints kernel.
Mar 01 19:02:07 alistair-xps13 kernel: Disabling lock debugging due to kernel taint
Mar 01 19:02:07 alistair-xps13 kernel: SPL: Loaded module v0.6.5.4-1
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting Load/Save Random Seed...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting udev Coldplug all Devices...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounting Arbitrary Executable File Formats File System...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting Create Static Device Nodes in /dev...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounted Arbitrary Executable File Formats File System.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started Set Up Additional Binary Formats.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started Load/Save Random Seed.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started udev Coldplug all Devices.
Mar 01 19:02:07 alistair-xps13 kernel: ZFS: Loaded module v0.6.5.4-1, ZFS pool version 5000, ZFS filesystem version 5
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started Load Kernel Modules.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounting Configuration File System...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting Apply Kernel Variables...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounted Configuration File System.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started Apply Kernel Variables.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started Create Static Device Nodes in /dev.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Reached target Local File Systems (Pre).
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting udev Kernel Device Manager...
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started udev Kernel Device Manager.
Mar 01 19:02:07 alistair-xps13 kernel: FUJITSU Extended Socket Network Device Driver - version 1.0 - Copyright (c) 2015 FUJITSU LIMITED
Mar 01 19:02:07 alistair-xps13 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input4
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Power Button [PWRB]
Mar 01 19:02:07 alistair-xps13 kernel: input: Lid Switch as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0D:00/input/input5
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Lid Switch [LID0]
Mar 01 19:02:07 alistair-xps13 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input6
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Power Button [PWRF]
Mar 01 19:02:07 alistair-xps13 kernel: thermal LNXTHERM:00: registered as thermal_zone0
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Thermal Zone [TZ00] (28 C)
Mar 01 19:02:07 alistair-xps13 kernel: thermal LNXTHERM:01: registered as thermal_zone1
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Thermal Zone [TZ01] (30 C)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: AC Adapter [ADP0] (on-line)
Mar 01 19:02:07 alistair-xps13 kernel: input: DELL Wireless hotkeys as /devices/virtual/input/input7
Mar 01 19:02:07 alistair-xps13 kernel: ACPI Warning: SystemIO range 0x000000000000EFA0-0x000000000000EFBF conflicts with OpRegion 0x000000000000EFA0-0x000000000000EFAF (\_SB_.PCI0.SBUS.SMBI) (20150930/utaddress-254)
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Battery Slot [BAT0] (battery present)
Mar 01 19:02:07 alistair-xps13 kernel: wmi: Mapper loaded
Mar 01 19:02:07 alistair-xps13 kernel: shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
Mar 01 19:02:07 alistair-xps13 kernel: input: PC Speaker as /devices/platform/pcspkr/input/input8
Mar 01 19:02:07 alistair-xps13 kernel: [drm] Initialized drm 1.1.0 20060810
Mar 01 19:02:07 alistair-xps13 kernel: snd_hda_codec_realtek hdaudioC1D0: autoconfig for ALC3661: line_outs=1 (0x14/0x0/0x0/0x0/0x0) type:speaker
Mar 01 19:02:07 alistair-xps13 kernel: snd_hda_codec_realtek hdaudioC1D0:    speaker_outs=0 (0x0/0x0/0x0/0x0/0x0)
Mar 01 19:02:07 alistair-xps13 kernel: snd_hda_codec_realtek hdaudioC1D0:    hp_outs=1 (0x15/0x0/0x0/0x0/0x0)
Mar 01 19:02:07 alistair-xps13 kernel: snd_hda_codec_realtek hdaudioC1D0:    mono: mono_out=0x0
Mar 01 19:02:07 alistair-xps13 kernel: snd_hda_codec_realtek hdaudioC1D0:    inputs:
Mar 01 19:02:07 alistair-xps13 kernel: snd_hda_codec_realtek hdaudioC1D0:      Headphone Mic=0x19
Mar 01 19:02:07 alistair-xps13 kernel: snd_hda_codec_realtek hdaudioC1D0:      Headset Mic=0x1b
Mar 01 19:02:07 alistair-xps13 kernel: snd_hda_codec_realtek hdaudioC1D0:      Internal Mic=0x12
Mar 01 19:02:07 alistair-xps13 kernel: AVX2 version of gcm_enc/dec engaged.
Mar 01 19:02:07 alistair-xps13 kernel: AES CTR mode by8 optimization enabled
Mar 01 19:02:07 alistair-xps13 kernel: input: HDA Digital PCBeep as /devices/pci0000:00/0000:00:1b.0/sound/card1/input10
Mar 01 19:02:07 alistair-xps13 kernel: input: HDA Intel PCH Headphone Mic as /devices/pci0000:00/0000:00:1b.0/sound/card1/input11
Mar 01 19:02:07 alistair-xps13 kernel: dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2)
Mar 01 19:02:07 alistair-xps13 kernel: Intel(R) Wireless WiFi driver for Linux
Mar 01 19:02:07 alistair-xps13 kernel: Copyright(c) 2003- 2015 Intel Corporation
Mar 01 19:02:07 alistair-xps13 kernel: [drm] Memory usable by graphics device = 2048M
Mar 01 19:02:07 alistair-xps13 kernel: checking generic (e0000000 7e9000) vs hw (e0000000 10000000)
Mar 01 19:02:07 alistair-xps13 kernel: fb: switching to inteldrmfb from EFI VGA
Mar 01 19:02:07 alistair-xps13 kernel: Console: switching to colour dummy device 80x25
Mar 01 19:02:07 alistair-xps13 kernel: [drm] Replacing VGA console driver
Mar 01 19:02:07 alistair-xps13 kernel: iwlwifi 0000:02:00.0: Direct firmware load for iwlwifi-7260-17.ucode failed with error -2
Mar 01 19:02:07 alistair-xps13 kernel: [drm] Supports vblank timestamp caching Rev 2 (21.10.2013).
Mar 01 19:02:07 alistair-xps13 kernel: [drm] Driver supports precise vblank timestamp query.
Mar 01 19:02:07 alistair-xps13 kernel: vgaarb: device changed decodes: PCI:0000:00:02.0,olddecodes=io+mem,decodes=io+mem:owns=io+mem
Mar 01 19:02:07 alistair-xps13 kernel: iwlwifi 0000:02:00.0: loaded firmware version 16.242414.0 op_mode iwlmvm
Mar 01 19:02:07 alistair-xps13 systemd[1]: Found device SK_hynix_SH920_mSATA_256GB 3.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Found device SK_hynix_SH920_mSATA_256GB 3.
Mar 01 19:02:07 alistair-xps13 kernel: ACPI: Video Device [GFX0] (multi-head: yes  rom: no  post: no)
Mar 01 19:02:07 alistair-xps13 kernel: input: Video Bus as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A08:00/LNXVIDEO:00/input/input12
Mar 01 19:02:07 alistair-xps13 systemd[1]: Activating swap Swap Partition...
Mar 01 19:02:07 alistair-xps13 kernel: iwlwifi 0000:02:00.0: Detected Intel(R) Dual Band Wireless AC 7260, REV=0x144
Mar 01 19:02:07 alistair-xps13 kernel: iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
Mar 01 19:02:07 alistair-xps13 kernel: iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
Mar 01 19:02:07 alistair-xps13 systemd[1]: Found device SK_hynix_SH920_mSATA_256GB 1.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting File System Check on /dev/disk/by-uuid/3546-0C81...
Mar 01 19:02:07 alistair-xps13 kernel: Adding 8388604k swap on /dev/sda3.  Priority:-1 extents:1 across:8388604k SSFS
Mar 01 19:02:07 alistair-xps13 systemd[1]: Activated swap Swap Partition.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Activated swap /dev/disk/by-uuid/a313a6dd-4767-40ef-bbdf-b4b078500d6f.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Reached target Swap.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started File System Check on /dev/disk/by-uuid/3546-0C81.
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounting /boot...
Mar 01 19:02:07 alistair-xps13 kernel: raid6: sse2x1   gen()  4150 MB/s
Mar 01 19:02:07 alistair-xps13 kernel: intel_rapl: Found RAPL domain package
Mar 01 19:02:07 alistair-xps13 kernel: intel_rapl: Found RAPL domain core
Mar 01 19:02:07 alistair-xps13 kernel: intel_rapl: Found RAPL domain uncore
Mar 01 19:02:07 alistair-xps13 kernel: intel_rapl: Found RAPL domain dram
Mar 01 19:02:07 alistair-xps13 kernel: input: Logitech USB Optical Mouse as /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2.4/2-2.4:1.0/0003:046D:C077.0002/input/input13
Mar 01 19:02:07 alistair-xps13 kernel: hid-generic 0003:046D:C077.0002: input,hidraw1: USB HID v1.11 Mouse [Logitech USB Optical Mouse] on usb-0000:00:14.0-2.4/input0
Mar 01 19:02:07 alistair-xps13 kernel: media: Linux media interface: v0.10
Mar 01 19:02:07 alistair-xps13 kernel: Bluetooth: Core ver 2.21
Mar 01 19:02:07 alistair-xps13 kernel: NET: Registered protocol family 31
Mar 01 19:02:07 alistair-xps13 kernel: Bluetooth: HCI device and connection manager initialized
Mar 01 19:02:07 alistair-xps13 kernel: Bluetooth: HCI socket layer initialized
Mar 01 19:02:07 alistair-xps13 kernel: Bluetooth: L2CAP socket layer initialized
Mar 01 19:02:07 alistair-xps13 kernel: Bluetooth: SCO socket layer initialized
Mar 01 19:02:07 alistair-xps13 kernel: mousedev: PS/2 mouse device common for all mice
Mar 01 19:02:07 alistair-xps13 kernel: Linux video capture interface: v2.00
Mar 01 19:02:07 alistair-xps13 systemd-journald[185]: Journal started
Mar 01 19:02:07 alistair-xps13 mtp-probe[376]: checking bus 2, device 3: "/sys/devices/pci0000:00/0000:00:14.0/usb2/2-3"
Mar 01 19:02:07 alistair-xps13 systemd[1]: Started Journal Service.
Mar 01 19:02:07 alistair-xps13 kernel: usbcore: registered new interface driver btusb
Mar 01 19:02:07 alistair-xps13 systemd-modules-load[178]: Inserted module 'zfs'
Mar 01 19:02:07 alistair-xps13 mtp-probe[376]: bus: 2, device: 3 was not an MTP device
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting Flush Journal to Persistent Storage...
Mar 01 19:02:07 alistair-xps13 kernel: fbcon: inteldrmfb (fb0) is primary device
Mar 01 19:02:07 alistair-xps13 kernel: Bluetooth: hci0: read Intel version: 370710018002030d00
Mar 01 19:02:07 alistair-xps13 kernel: iTCO_vendor_support: vendor-support=0
Mar 01 19:02:07 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: Scanning PDT...
Mar 01 19:02:07 alistair-xps13 kernel: input: Dell WMI hotkeys as /devices/virtual/input/input15
Mar 01 19:02:07 alistair-xps13 kernel: iTCO_wdt: Intel TCO WatchDog Timer Driver v1.11
Mar 01 19:02:07 alistair-xps13 kernel: iTCO_wdt: Found a Lynx Point_LP TCO device (Version=2, TCOBASE=0x1860)
Mar 01 19:02:07 alistair-xps13 kernel: iTCO_wdt: initialized. heartbeat=30 sec (nowayout=0)
Mar 01 19:02:07 alistair-xps13 kernel: raid6: sse2x1   xor()  3147 MB/s
Mar 01 19:02:07 alistair-xps13 kernel: Bluetooth: hci0: Intel Bluetooth firmware file: intel/ibt-hw-37.7.10-fw-1.80.2.3.d.bseq
Mar 01 19:02:07 alistair-xps13 kernel: uvcvideo: Found UVC 1.00 device Integrated_Webcam_HD (0bda:5752)
Mar 01 19:02:07 alistair-xps13 kernel: input: Integrated_Webcam_HD as /devices/pci0000:00/0000:00:14.0/usb2/2-5/2-5:1.0/input/input16
Mar 01 19:02:07 alistair-xps13 kernel: usbcore: registered new interface driver uvcvideo
Mar 01 19:02:07 alistair-xps13 kernel: USB Video Class driver (1.1.1)
Mar 01 19:02:07 alistair-xps13 mtp-probe[377]: checking bus 2, device 5: "/sys/devices/pci0000:00/0000:00:14.0/usb2/2-5"
Mar 01 19:02:07 alistair-xps13 systemd[1]: Mounted /boot.
Mar 01 19:02:07 alistair-xps13 mtp-probe[377]: bus: 2, device: 5 was not an MTP device
Mar 01 19:02:07 alistair-xps13 systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Mar 01 19:02:07 alistair-xps13 mtp-probe[393]: checking bus 2, device 4: "/sys/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2.3"
Mar 01 19:02:07 alistair-xps13 systemd[1]: Starting Load/Save RF Kill Switch Status...
Mar 01 19:02:07 alistair-xps13 mtp-probe[397]: checking bus 2, device 6: "/sys/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2.4"
Mar 01 19:02:07 alistair-xps13 mtp-probe[397]: bus: 2, device: 6 was not an MTP device
Mar 01 19:02:07 alistair-xps13 mtp-probe[393]: bus: 2, device: 4 was not an MTP device
Mar 01 19:02:07 alistair-xps13 systemd-fsck[415]: fsck.fat 3.0.28 (2015-05-16)
Mar 01 19:02:07 alistair-xps13 systemd-fsck[415]: /dev/sda1: 13 files, 7950/130812 clusters
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Load/Save RF Kill Switch Status.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Flush Journal to Persistent Storage.
Mar 01 19:02:09 alistair-xps13 kernel: raid6: sse2x2   gen()  7079 MB/s
Mar 01 19:02:09 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: Found F34 on page 0x00
Mar 01 19:02:09 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: Found F01 on page 0x00
Mar 01 19:02:09 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: Found F11 on page 0x00
Mar 01 19:02:09 alistair-xps13 kernel: raid6: sse2x2   xor()  8209 MB/s
Mar 01 19:02:09 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: Found F54 on page 0x01
Mar 01 19:02:09 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: Found F30 on page 0x01
Mar 01 19:02:09 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: Found F55 on page 0x02
Mar 01 19:02:09 alistair-xps13 kernel: Bluetooth: hci0: Intel Bluetooth firmware patch completed and activated
Mar 01 19:02:09 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: Found F51 on page 0x03
Mar 01 19:02:09 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: rmi_scan_pdt: Done with PDT scan.
Mar 01 19:02:09 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: rmi_populate_f11: size in mm: 97 x 59
Mar 01 19:02:09 alistair-xps13 kernel: raid6: sse2x4   gen() 12992 MB/s
Mar 01 19:02:09 alistair-xps13 kernel: random: nonblocking pool is initialized
Mar 01 19:02:09 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: firmware id: 1522295
Mar 01 19:02:09 alistair-xps13 kernel: input: DLL060A:00 06CB:2734 as /devices/pci0000:00/INT33C3:00/i2c-0/i2c-DLL060A:00/0018:06CB:2734.0003/input/input14
Mar 01 19:02:09 alistair-xps13 kernel: hid-rmi 0018:06CB:2734.0003: input,hidraw2: I2C HID v1.00 Pointer [DLL060A:00 06CB:2734] on i2c-DLL060A:00
Mar 01 19:02:09 alistair-xps13 kernel: raid6: sse2x4   xor()  9955 MB/s
Mar 01 19:02:09 alistair-xps13 kernel: ieee80211 phy0: Selected rate control algorithm 'iwl-mvm-rs'
Mar 01 19:02:09 alistair-xps13 kernel: iwlwifi 0000:02:00.0 wlp2s0: renamed from wlan0
Mar 01 19:02:09 alistair-xps13 kernel: raid6: avx2x1   gen() 17155 MB/s
Mar 01 19:02:09 alistair-xps13 kernel: raid6: avx2x2   gen() 20817 MB/s
Mar 01 19:02:09 alistair-xps13 kernel: raid6: avx2x4   gen() 23988 MB/s
Mar 01 19:02:09 alistair-xps13 kernel: raid6: using algorithm avx2x4 gen() 23988 MB/s
Mar 01 19:02:09 alistair-xps13 kernel: raid6: using avx2x2 recovery algorithm
Mar 01 19:02:09 alistair-xps13 kernel: xor: automatically using best checksumming function:
Mar 01 19:02:09 alistair-xps13 kernel:    avx       : 32752.800 MB/sec
Mar 01 19:02:09 alistair-xps13 kernel: Btrfs loaded
Mar 01 19:02:09 alistair-xps13 kernel: BTRFS: device fsid 43974227-2a72-4508-9fdc-89c822c3be27 devid 1 transid 44713 /dev/sda4
Mar 01 19:02:09 alistair-xps13 kernel: asix 2-2.3:1.0 eth0: register 'asix' at usb-0000:00:14.0-2.3, ASIX AX88772 USB 2.0 Ethernet, 9c:eb:e8:10:0a:3d
Mar 01 19:02:09 alistair-xps13 kernel: usbcore: registered new interface driver asix
Mar 01 19:02:09 alistair-xps13 kernel: asix 2-2.3:1.0 enp0s20u2u3: renamed from eth0
Mar 01 19:02:09 alistair-xps13 kernel: snd_hda_intel 0000:00:03.0: bound 0000:00:02.0 (ops i915_audio_component_bind_ops [i915])
Mar 01 19:02:09 alistair-xps13 kernel: [drm] Initialized i915 1.6.0 20151010 for 0000:00:02.0 on minor 0
Mar 01 19:02:09 alistair-xps13 kernel: Console: switching to colour frame buffer device 240x67
Mar 01 19:02:09 alistair-xps13 kernel: i915 0000:00:02.0: fb0: inteldrmfb frame buffer device
Mar 01 19:02:09 alistair-xps13 systemd[1]: Found device SK_hynix_SH920_mSATA_256GB 4.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Mounting /home...
Mar 01 19:02:09 alistair-xps13 systemd[1]: Reached target Bluetooth.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Created slice system-systemd\x2dbacklight.slice.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Starting Load/Save Screen Backlight Brightness of leds:dell::kbd_backlight...
Mar 01 19:02:09 alistair-xps13 systemd[1]: Reached target Sound Card.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Starting Load/Save Screen Backlight Brightness of backlight:intel_backlight...
Mar 01 19:02:09 alistair-xps13 kernel: BTRFS info (device sda4): use ssd allocation scheme
Mar 01 19:02:09 alistair-xps13 kernel: BTRFS info (device sda4): enabling auto defrag
Mar 01 19:02:09 alistair-xps13 kernel: BTRFS info (device sda4): disk space caching is enabled
Mar 01 19:02:09 alistair-xps13 kernel: BTRFS: has skinny extents
Mar 01 19:02:09 alistair-xps13 kernel: input: HDA Intel HDMI HDMI/DP,pcm=3 as /devices/pci0000:00/0000:00:03.0/sound/card0/input17
Mar 01 19:02:09 alistair-xps13 kernel: input: HDA Intel HDMI HDMI/DP,pcm=7 as /devices/pci0000:00/0000:00:03.0/sound/card0/input18
Mar 01 19:02:09 alistair-xps13 kernel: input: HDA Intel HDMI HDMI/DP,pcm=8 as /devices/pci0000:00/0000:00:03.0/sound/card0/input19
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Load/Save Screen Backlight Brightness of leds:dell::kbd_backlight.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Load/Save Screen Backlight Brightness of backlight:intel_backlight.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Mounted /home.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Mounting /var/cache/zoneminder/events...
Mar 01 19:02:09 alistair-xps13 systemd[1]: Mounting /var/cache/zoneminder/images...
Mar 01 19:02:09 alistair-xps13 systemd[1]: Mounting /var/cache/zoneminder/temp...
Mar 01 19:02:09 alistair-xps13 systemd[1]: Mounted /var/cache/zoneminder/events.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Mounted /var/cache/zoneminder/temp.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Mounted /var/cache/zoneminder/images.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Reached target Local File Systems.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Starting Create Volatile Files and Directories...
Mar 01 19:02:09 alistair-xps13 kernel: BTRFS error (device sda4): could not find root 8
Mar 01 19:02:09 alistair-xps13 kernel: BTRFS error (device sda4): could not find root 8
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Create Volatile Files and Directories.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Update UTMP about System Boot/Shutdown.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Reached target System Initialization.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Daily verification of password and group files.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Listening on D-Bus System Message Bus Socket.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Reached target Sockets.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Daily man-db cache update.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Daily Cleanup of Temporary Directories.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Reached target Basic System.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Starting Login Service...
Mar 01 19:02:09 alistair-xps13 systemd[1]: Starting Enable access to XPS13 screen brightness...
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started D-Bus System Message Bus.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Starting Network Manager...
Mar 01 19:02:09 alistair-xps13 systemd[1]: Starting Permit User Sessions...
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Daily rotation of log files.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Reached target Timers.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Enable access to XPS13 screen brightness.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Permit User Sessions.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Getty on tty1.
Mar 01 19:02:09 alistair-xps13 systemd-logind[574]: New seat seat0.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Reached target Login Prompts.
Mar 01 19:02:09 alistair-xps13 systemd-logind[574]: Watching system buttons on /dev/input/event4 (Power Button)
Mar 01 19:02:09 alistair-xps13 systemd-logind[574]: Watching system buttons on /dev/input/event9 (Video Bus)
Mar 01 19:02:09 alistair-xps13 systemd-logind[574]: Watching system buttons on /dev/input/event2 (Power Button)
Mar 01 19:02:09 alistair-xps13 systemd-logind[574]: Watching system buttons on /dev/input/event3 (Lid Switch)
Mar 01 19:02:09 alistair-xps13 systemd-logind[574]: Watching system buttons on /dev/input/event11 (Dell WMI hotkeys)
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Login Service.
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  NetworkManager (version 1.0.10) is starting...
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Read config: /etc/NetworkManager/NetworkManager.conf
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Network Manager.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Reached target Network.
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded settings plugin keyfile: (c) 2007 - 2015 Red Hat, Inc.  To report bugs please use the NetworkManager mailing list.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Apache Web Server.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Reached target Multi-User System.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Reached target Graphical Interface.
Mar 01 19:02:09 alistair-xps13 systemd[1]: Startup finished in 11.021s (kernel) + 2.282s (userspace) = 21.080s.
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  keyfile: new connection /etc/NetworkManager/system-connections/TP-LINK_5GHz_6D317F (aafcec08-841c-47bb-8fed-6e2624434ec5,"TP-LINK_5GHz_6D317F")
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  keyfile: new connection /etc/NetworkManager/system-connections/WMS_jungle_arena (781050a2-b154-4078-9d40-2f706f68606f,"WMS_jungle_arena")
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  keyfile: new connection /etc/NetworkManager/system-connections/Bludo (3eef0bb5-0de4-471b-bfd9-fc861da22888,"Bludo")
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  keyfile: new connection /etc/NetworkManager/system-connections/Internet_68 (5cae7937-9adc-4ea7-af68-bb4def472a61,"Internet_68")
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  keyfile: new connection /etc/NetworkManager/system-connections/COSTA (294ec60f-3896-444d-b83e-98588d5a4755,"COSTA")
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  keyfile: new connection /etc/NetworkManager/system-connections/DXB Free WiFi (26e7f2a1-b961-4116-b60f-8cf4ebaacca6,"DXB Free WiFi")
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  keyfile: new connection /etc/NetworkManager/system-connections/Airport Free Wi-Fi (1eaad652-b91d-40c8-9ebb-a8ee781c5187,"Airport Free Wi-Fi")
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  keyfile: new connection /etc/NetworkManager/system-connections/TP-LINK_2.4GHz_72714B (4784de78-0125-4908-9bb9-69ccf9277029,"TP-LINK_2.4GHz_72714B")
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  keyfile: new connection /etc/NetworkManager/system-connections/TP-LINK_5GHz_72714C (7cba613d-8905-4577-b6e3-054635644c37,"TP-LINK_5GHz_72714C")
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  monitoring kernel firmware directory '/usr/lib/firmware'.
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  rfkill1: found WiFi radio killswitch (at /sys/devices/pci0000:00/0000:00:1c.2/0000:02:00.0/ieee80211/phy0/rfkill1) (driver iwlwifi)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  WiFi hardware radio set enabled
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  WWAN hardware radio set enabled
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMVxlanFactory (internal)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMVlanFactory (internal)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMVethFactory (internal)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMTunFactory (internal)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMMacvlanFactory (internal)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMInfinibandFactory (internal)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMGreFactory (internal)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMEthernetFactory (internal)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMBridgeFactory (internal)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMBondFactory (internal)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMAtmManager (/usr/lib/NetworkManager/libnm-device-plugin-adsl.so)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMBluezManager (/usr/lib/NetworkManager/libnm-device-plugin-bluetooth.so)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMWwanFactory (/usr/lib/NetworkManager/libnm-device-plugin-wwan.so)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMTeamFactory (/usr/lib/NetworkManager/libnm-device-plugin-team.so)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Loaded device plugin: NMWifiFactory (/usr/lib/NetworkManager/libnm-device-plugin-wifi.so)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  WiFi enabled by radio killswitch; enabled by state file
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  WWAN enabled by radio killswitch; enabled by state file
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  WiMAX enabled by radio killswitch; enabled by state file
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  Networking is enabled by state file
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (enp0s20u2u3): new Ethernet device (carrier: OFF, driver: 'asix', ifindex: 3)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (enp0s20u2u3): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Mar 01 19:02:09 alistair-xps13 kernel: IPv6: ADDRCONF(NETDEV_UP): enp0s20u2u3: link is not ready
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  keyfile: add connection in-memory (88b3e1af-dfce-49f7-bec0-0393d97431c8,"Wired connection 1")
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (enp0s20u2u3): created default wired connection 'Wired connection 1'
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): using nl80211 for WiFi device control
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): driver supports Access Point (AP) mode
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): new 802.11 WiFi device (carrier: UNKNOWN, driver: 'iwlwifi', ifindex: 2)
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): device state change: unmanaged -> unavailable (reason 'managed') [10 20 2]
Mar 01 19:02:09 alistair-xps13 kernel: asix 2-2.3:1.0 enp0s20u2u3: link down
Mar 01 19:02:09 alistair-xps13 kernel: IPv6: ADDRCONF(NETDEV_UP): enp0s20u2u3: link is not ready
Mar 01 19:02:09 alistair-xps13 kernel: IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
Mar 01 19:02:09 alistair-xps13 kernel: iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
Mar 01 19:02:09 alistair-xps13 kernel: iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
Mar 01 19:02:09 alistair-xps13 kernel: iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
Mar 01 19:02:09 alistair-xps13 kernel: iwlwifi 0000:02:00.0: L1 Enabled - LTR Enabled
Mar 01 19:02:09 alistair-xps13 kernel: IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (lo): link connected
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (lo): new Generic device (carrier: ON, driver: 'unknown', ifindex: 1)
Mar 01 19:02:09 alistair-xps13 dbus[577]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service'
Mar 01 19:02:09 alistair-xps13 dbus[577]: [system] Activating via systemd: service name='fi.w1.wpa_supplicant1' unit='wpa_supplicant.service'
Mar 01 19:02:09 alistair-xps13 systemd[1]: Starting WPA supplicant...
Mar 01 19:02:09 alistair-xps13 systemd[1]: Starting Authorization Manager...
Mar 01 19:02:09 alistair-xps13 dbus[577]: [system] Successfully activated service 'fi.w1.wpa_supplicant1'
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  wpa_supplicant running
Mar 01 19:02:09 alistair-xps13 wpa_supplicant[604]: Successfully initialized wpa_supplicant
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started WPA supplicant.
Mar 01 19:02:09 alistair-xps13 polkitd[606]: Started polkitd version 0.113
Mar 01 19:02:09 alistair-xps13 polkitd[606]: Loading rules from directory /etc/polkit-1/rules.d
Mar 01 19:02:09 alistair-xps13 polkitd[606]: Loading rules from directory /usr/share/polkit-1/rules.d
Mar 01 19:02:09 alistair-xps13 polkitd[606]: Finished loading, compiling and executing 3 rules
Mar 01 19:02:09 alistair-xps13 dbus[577]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Mar 01 19:02:09 alistair-xps13 systemd[1]: Started Authorization Manager.
Mar 01 19:02:09 alistair-xps13 polkitd[606]: Acquired the name org.freedesktop.PolicyKit1 on the system bus
Mar 01 19:02:09 alistair-xps13 wpa_supplicant[604]: Could not read interface p2p-dev-wlp2s0 flags: No such device
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0) supports 5 scan SSIDs
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): supplicant interface state: starting -> ready
Mar 01 19:02:09 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): device state change: unavailable -> disconnected (reason 'supplicant-available') [20 30 42]
Mar 01 19:02:09 alistair-xps13 kernel: IPv6: ADDRCONF(NETDEV_UP): wlp2s0: link is not ready
Mar 01 19:02:13 alistair-xps13 wpa_supplicant[604]: wlp2s0: Reject scan trigger since one is already pending
Mar 01 19:02:13 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): supplicant interface state: ready -> inactive
Mar 01 19:02:14 alistair-xps13 login[586]: pam_unix(login:session): session opened for user alistair by LOGIN(uid=0)
Mar 01 19:02:14 alistair-xps13 systemd[1]: Created slice User Slice of alistair.
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  Auto-activating connection 'Internet_68'.
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): Activation: starting connection 'Internet_68' (5cae7937-9adc-4ea7-af68-bb4def472a61)
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): device state change: disconnected -> prepare (reason 'none') [30 40 0]
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  NetworkManager state is now CONNECTING
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): device state change: prepare -> config (reason 'none') [40 50 0]
Mar 01 19:02:14 alistair-xps13 kernel: wlp2s0: authenticate with 5c:f4:ab:04:37:6b
Mar 01 19:02:14 alistair-xps13 kernel: wlp2s0: send auth to 5c:f4:ab:04:37:6b (try 1/3)
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): Activation: (wifi) connection 'Internet_68' has security, and secrets exist.  No new secrets needed.
Mar 01 19:02:14 alistair-xps13 systemd[1]: Starting User Manager for UID 1000...
Mar 01 19:02:14 alistair-xps13 wpa_supplicant[604]: wlp2s0: SME: Trying to authenticate with 5c:f4:ab:04:37:6b (SSID='Internet_68' freq=2447 MHz)
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  Config: added 'ssid' value 'Internet_68'
Mar 01 19:02:14 alistair-xps13 wpa_supplicant[604]: wlp2s0: Trying to associate with 5c:f4:ab:04:37:6b (SSID='Internet_68' freq=2447 MHz)
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  Config: added 'scan_ssid' value '1'
Mar 01 19:02:14 alistair-xps13 systemd-logind[574]: New session c1 of user alistair.
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  Config: added 'key_mgmt' value 'WPA-PSK'
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  Config: added 'auth_alg' value 'OPEN'
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  Config: added 'psk' value '<omitted>'
Mar 01 19:02:14 alistair-xps13 kernel: wlp2s0: authenticated
Mar 01 19:02:14 alistair-xps13 kernel: wlp2s0: associate with 5c:f4:ab:04:37:6b (try 1/3)
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  Config: set interface ap_scan to 1
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): supplicant interface state: inactive -> authenticating
Mar 01 19:02:14 alistair-xps13 systemd[1]: Started Session c1 of user alistair.
Mar 01 19:02:14 alistair-xps13 systemd[625]: pam_unix(systemd-user:session): session opened for user alistair by (uid=0)
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): supplicant interface state: authenticating -> associating
Mar 01 19:02:14 alistair-xps13 wpa_supplicant[604]: wlp2s0: Associated with 5c:f4:ab:04:37:6b
Mar 01 19:02:14 alistair-xps13 kernel: wlp2s0: RX AssocResp from 5c:f4:ab:04:37:6b (capab=0x411 status=0 aid=1)
Mar 01 19:02:14 alistair-xps13 kernel: wlp2s0: associated
Mar 01 19:02:14 alistair-xps13 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlp2s0: link becomes ready
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): supplicant interface state: associating -> associated
Mar 01 19:02:14 alistair-xps13 systemd[625]: Starting D-Bus User Message Bus Socket.
Mar 01 19:02:14 alistair-xps13 systemd[625]: Reached target Paths.
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): supplicant interface state: associated -> 4-way handshake
Mar 01 19:02:14 alistair-xps13 systemd[625]: Reached target Timers.
Mar 01 19:02:14 alistair-xps13 login[586]: LOGIN ON tty1 BY alistair
Mar 01 19:02:14 alistair-xps13 systemd[625]: Listening on Sound System.
Mar 01 19:02:14 alistair-xps13 systemd[625]: Listening on D-Bus User Message Bus Socket.
Mar 01 19:02:14 alistair-xps13 systemd[625]: Reached target Sockets.
Mar 01 19:02:14 alistair-xps13 systemd[625]: Reached target Basic System.
Mar 01 19:02:14 alistair-xps13 systemd[625]: Reached target Default.
Mar 01 19:02:14 alistair-xps13 systemd[625]: Startup finished in 19ms.
Mar 01 19:02:14 alistair-xps13 systemd[1]: Started User Manager for UID 1000.
Mar 01 19:02:14 alistair-xps13 wpa_supplicant[604]: wlp2s0: WPA: Key negotiation completed with 5c:f4:ab:04:37:6b [PTK=CCMP GTK=CCMP]
Mar 01 19:02:14 alistair-xps13 wpa_supplicant[604]: wlp2s0: CTRL-EVENT-CONNECTED - Connection to 5c:f4:ab:04:37:6b completed [id=0 id_str=]
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): supplicant interface state: 4-way handshake -> completed
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): Activation: (wifi) Stage 2 of 5 (Device Configure) successful.  Connected to wireless network 'Internet_68'.
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): device state change: config -> ip-config (reason 'none') [50 70 0]
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  Activation (wlp2s0) Beginning DHCPv4 transaction (timeout in 45 seconds)
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  dhclient started with pid 712
Mar 01 19:02:14 alistair-xps13 dhclient[712]: irs_resconf_load failed: 59.
Mar 01 19:02:14 alistair-xps13 dhclient[712]: Unable to set resolver from resolv.conf; startup continuing but DDNS support may be affected
Mar 01 19:02:14 alistair-xps13 dhclient[712]: DHCPREQUEST on wlp2s0 to 255.255.255.255 port 67
Mar 01 19:02:14 alistair-xps13 dhclient[712]: DHCPACK from 10.0.0.138
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>    address 10.0.0.43
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>    plen 24 (255.255.255.0)
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>    gateway 10.0.0.138
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>    server identifier 10.0.0.138
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>    lease time 86400
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>    nameserver '10.0.0.138'
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>    domain name 'Home'
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): DHCPv4 state changed unknown -> bound
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): device state change: ip-config -> ip-check (reason 'none') [70 80 0]
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): device state change: ip-check -> secondaries (reason 'none') [80 90 0]
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): device state change: secondaries -> activated (reason 'none') [90 100 0]
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  NetworkManager state is now CONNECTED_LOCAL
Mar 01 19:02:14 alistair-xps13 dhclient[712]: bound to 10.0.0.43 -- renewal in 34113 seconds.
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  NetworkManager state is now CONNECTED_GLOBAL
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  Policy set 'Internet_68' (wlp2s0) as default for IPv4 routing and DNS.
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  Writing DNS information to /usr/bin/resolvconf
Mar 01 19:02:14 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): Activation: successful, device activated.
Mar 01 19:02:14 alistair-xps13 dbus[577]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service'
Mar 01 19:02:14 alistair-xps13 systemd[1]: Starting Network Manager Script Dispatcher Service...
Mar 01 19:02:14 alistair-xps13 dbus[577]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
Mar 01 19:02:14 alistair-xps13 systemd[1]: Started Network Manager Script Dispatcher Service.
Mar 01 19:02:15 alistair-xps13 NetworkManager[581]: <info>  startup complete
Mar 01 19:02:16 alistair-xps13 NetworkManager[581]: <info>  Activation (wlp2s0) Beginning DHCPv6 transaction (timeout in 45 seconds)
Mar 01 19:02:16 alistair-xps13 NetworkManager[581]: <info>  dhclient started with pid 767
Mar 01 19:02:16 alistair-xps13 dhclient[767]: XMT: Info-Request on wlp2s0, interval 1020ms.
Mar 01 19:02:16 alistair-xps13 dhclient[767]: RCV: Reply message on wlp2s0 from fe80::1.
Mar 01 19:02:16 alistair-xps13 NetworkManager[581]: <info>    nameserver 'fe80::1'
Mar 01 19:02:16 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): DHCPv6 state changed unknown -> bound
Mar 01 19:02:16 alistair-xps13 NetworkManager[581]: <info>  Policy set 'Internet_68' (wlp2s0) as default for IPv6 routing and DNS.
Mar 01 19:02:16 alistair-xps13 NetworkManager[581]: <info>  Writing DNS information to /usr/bin/resolvconf
Mar 01 19:02:16 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): DHCPv6 client pid 767 exited with status 0
Mar 01 19:02:16 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): DHCPv6 state changed bound -> done
Mar 01 19:02:36 alistair-xps13 sudo[873]: alistair : TTY=tty1 ; PWD=/home/alistair ; USER=root ; COMMAND=/usr/bin/journalctl -b 1
Mar 01 19:02:36 alistair-xps13 sudo[873]: pam_unix(sudo:session): session opened for user root by alistair(uid=0)
Mar 01 19:02:36 alistair-xps13 sudo[873]: pam_unix(sudo:session): session closed for user root
Mar 01 19:03:08 alistair-xps13 kernel: usb 2-2.4: USB disconnect, device number 6
Mar 01 19:03:09 alistair-xps13 kernel: usb 2-2.4: new low-speed USB device number 8 using xhci_hcd
Mar 01 19:03:09 alistair-xps13 kernel: usb 2-2.4: ep 0x81 - rounding interval to 64 microframes, ep desc says 80 microframes
Mar 01 19:03:09 alistair-xps13 kernel: input: Logitech USB Optical Mouse as /devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2.4/2-2.4:1.0/0003:046D:C077.0004/input/input20
Mar 01 19:03:09 alistair-xps13 kernel: hid-generic 0003:046D:C077.0004: input,hidraw1: USB HID v1.11 Mouse [Logitech USB Optical Mouse] on usb-0000:00:14.0-2.4/input0
Mar 01 19:03:09 alistair-xps13 mtp-probe[917]: checking bus 2, device 8: "/sys/devices/pci0000:00/0000:00:14.0/usb2/2-2/2-2.4"
Mar 01 19:03:09 alistair-xps13 mtp-probe[917]: bus: 2, device: 8 was not an MTP device
Mar 01 19:03:56 alistair-xps13 systemd[625]: Started D-Bus User Message Bus.
Mar 01 19:03:56 alistair-xps13 gnome-keyring-daemon[977]: couldn't access control socket: /run/user/1000/keyring/control: No such file or directory
Mar 01 19:04:02 alistair-xps13 dbus-daemon[974]: Activating via systemd: service name='org.gtk.vfs.Daemon' unit='gvfs-daemon.service'
Mar 01 19:04:02 alistair-xps13 systemd[625]: Starting Virtual filesystem service...
Mar 01 19:04:02 alistair-xps13 dbus-daemon[974]: Successfully activated service 'org.gtk.vfs.Daemon'
Mar 01 19:04:02 alistair-xps13 systemd[625]: Started Virtual filesystem service.
Mar 01 19:04:02 alistair-xps13 kernel: fuse init (API version 7.23)
Mar 01 19:04:02 alistair-xps13 dbus-daemon[974]: Activating service name='org.a11y.Bus'
Mar 01 19:04:02 alistair-xps13 dbus-daemon[974]: Successfully activated service 'org.a11y.Bus'
Mar 01 19:04:02 alistair-xps13 org.a11y.Bus[974]: Activating service name='org.a11y.atspi.Registry'
Mar 01 19:04:02 alistair-xps13 org.a11y.Bus[974]: Successfully activated service 'org.a11y.atspi.Registry'
Mar 01 19:04:02 alistair-xps13 org.a11y.atspi.Registry[1038]: SpiRegistry daemon is running with well-known name - org.a11y.atspi.Registry
Mar 01 19:04:03 alistair-xps13 dbus[577]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service'
Mar 01 19:04:03 alistair-xps13 dbus[577]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service not found.
Mar 01 19:04:03 alistair-xps13 systemd[625]: Starting Sound Service...
Mar 01 19:04:03 alistair-xps13 dbus[577]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service'
Mar 01 19:04:03 alistair-xps13 systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Mar 01 19:04:03 alistair-xps13 dbus[577]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Successfully called chroot.
Mar 01 19:04:03 alistair-xps13 systemd[1]: Started RealtimeKit Scheduling Policy Service.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Successfully dropped privileges.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Successfully limited resources.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Running.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Watchdog thread running.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Canary thread running.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Successfully made thread 1074 of process 1074 (/usr/bin/pulseaudio) owned by '1000' high priority at nice level -11.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Supervising 1 threads of 1 processes of 1 users.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Supervising 1 threads of 1 processes of 1 users.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Successfully made thread 1084 of process 1074 (/usr/bin/pulseaudio) owned by '1000' RT at priority 5.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Supervising 2 threads of 1 processes of 1 users.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Supervising 2 threads of 1 processes of 1 users.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Successfully made thread 1089 of process 1074 (/usr/bin/pulseaudio) owned by '1000' RT at priority 5.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Supervising 3 threads of 1 processes of 1 users.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Supervising 3 threads of 1 processes of 1 users.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Successfully made thread 1090 of process 1074 (/usr/bin/pulseaudio) owned by '1000' RT at priority 5.
Mar 01 19:04:03 alistair-xps13 rtkit-daemon[1080]: Supervising 4 threads of 1 processes of 1 users.
Mar 01 19:04:03 alistair-xps13 systemd[625]: Started Sound Service.
Mar 01 19:04:04 alistair-xps13 dbus[577]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service'
Mar 01 19:04:04 alistair-xps13 dbus[577]: [system] Activation via systemd failed for unit 'dbus-org.bluez.service': Unit dbus-org.bluez.service not found.
Mar 01 19:04:48 alistair-xps13 sudo[1602]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/journalctl -b
Mar 01 19:04:48 alistair-xps13 sudo[1602]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:04:49 alistair-xps13 sudo[1602]: pam_unix(sudo:session): session closed for user root
Mar 01 19:04:54 alistair-xps13 sudo[1777]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/journalctl -b
Mar 01 19:04:54 alistair-xps13 sudo[1777]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:04:54 alistair-xps13 sudo[1777]: pam_unix(sudo:session): session closed for user root
Mar 01 19:04:57 alistair-xps13 sudo[1792]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/journalctl -b 1
Mar 01 19:04:57 alistair-xps13 sudo[1792]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:04:57 alistair-xps13 sudo[1792]: pam_unix(sudo:session): session closed for user root
Mar 01 19:05:00 alistair-xps13 sudo[1806]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/journalctl -b 2
Mar 01 19:05:00 alistair-xps13 sudo[1806]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:05:00 alistair-xps13 sudo[1806]: pam_unix(sudo:session): session closed for user root
Mar 01 19:05:04 alistair-xps13 sudo[1820]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/journalctl -b 3
Mar 01 19:05:04 alistair-xps13 sudo[1820]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:05:04 alistair-xps13 sudo[1820]: pam_unix(sudo:session): session closed for user root
Mar 01 19:05:06 alistair-xps13 sudo[1848]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/journalctl -b 3
Mar 01 19:05:06 alistair-xps13 sudo[1848]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:05:10 alistair-xps13 sudo[1848]: pam_unix(sudo:session): session closed for user root
Mar 01 19:05:11 alistair-xps13 sudo[1859]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/journalctl -b
Mar 01 19:05:11 alistair-xps13 sudo[1859]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:05:14 alistair-xps13 sudo[1859]: pam_unix(sudo:session): session closed for user root
Mar 01 19:05:18 alistair-xps13 sudo[1873]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/journalctl -b -1
Mar 01 19:05:18 alistair-xps13 sudo[1873]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:05:19 alistair-xps13 sudo[1873]: pam_unix(sudo:session): session closed for user root
Mar 01 19:05:24 alistair-xps13 sudo[1918]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/journalctl -b -1
Mar 01 19:05:24 alistair-xps13 sudo[1918]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:05:24 alistair-xps13 sudo[1918]: pam_unix(sudo:session): session closed for user root
Mar 01 19:05:30 alistair-xps13 sudo[1946]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/journalctl -b -1
Mar 01 19:05:30 alistair-xps13 sudo[1946]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:05:57 alistair-xps13 sudo[1946]: pam_unix(sudo:session): session closed for user root
Mar 01 19:06:48 alistair-xps13 sudo[1966]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/journalctl -b -1
Mar 01 19:06:48 alistair-xps13 sudo[1966]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:06:49 alistair-xps13 sudo[1966]: pam_unix(sudo:session): session closed for user root
Mar 01 19:07:59 alistair-xps13 sudo[2007]: alistair : TTY=pts/0 ; PWD=/home/alistair/tmp ; USER=root ; COMMAND=/usr/bin/shutdown -P now
Mar 01 19:07:59 alistair-xps13 sudo[2007]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopping User Manager for UID 1000...
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped target Sound Card.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.
Mar 01 19:07:59 alistair-xps13 systemd[625]: Stopping Virtual filesystem service...
Mar 01 19:07:59 alistair-xps13 systemd[625]: Stopping D-Bus User Message Bus...
Mar 01 19:07:59 alistair-xps13 sudo[2007]: pam_unix(sudo:session): session closed for user root
Mar 01 19:07:59 alistair-xps13 systemd[625]: Stopped target Default.
Mar 01 19:07:59 alistair-xps13 systemd[625]: Stopping Sound Service...
Mar 01 19:07:59 alistair-xps13 systemd[1]: Starting Generate shutdown-ramfs...
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped target Graphical Interface.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped target Multi-User System.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopping D-Bus System Message Bus...
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopping Session c1 of user alistair.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopping Apache Web Server...
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped target Login Prompts.
Mar 01 19:07:59 alistair-xps13 systemd[625]: Stopped D-Bus User Message Bus.
Mar 01 19:07:59 alistair-xps13 NetworkManager[581]: <warn>  disconnected by the system bus.
Mar 01 19:07:59 alistair-xps13 wpa_supplicant[604]: nl80211: deinit ifname=p2p-dev-wlp2s0 disabled_11b_rates=0
Mar 01 19:07:59 alistair-xps13 systemd[625]: Stopped Sound Service.
Mar 01 19:07:59 alistair-xps13 login[586]: pam_unix(login:session): session closed for user alistair
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopping Getty on tty1...
Mar 01 19:07:59 alistair-xps13 NetworkManager[581]: <info>  caught SIGTERM, shutting down normally.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopping Authorization Manager...
Mar 01 19:07:59 alistair-xps13 NetworkManager[581]: <info>  (enp0s20u2u3): device state change: unavailable -> unmanaged (reason 'unmanaged') [20 10 3]
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped target Bluetooth.
Mar 01 19:07:59 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): device state change: activated -> deactivating (reason 'unmanaged') [100 110 3]
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped target Timers.
Mar 01 19:07:59 alistair-xps13 NetworkManager[581]: <info>  NetworkManager state is now DISCONNECTING
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped Daily rotation of log files.
Mar 01 19:07:59 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): device state change: deactivating -> unmanaged (reason 'unmanaged') [110 10 3]
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped Daily verification of password and group files.
Mar 01 19:07:59 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): canceled DHCP transaction, DHCP client pid 712
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped Daily man-db cache update.
Mar 01 19:07:59 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): DHCPv4 state changed bound -> done
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped Daily Cleanup of Temporary Directories.
Mar 01 19:07:59 alistair-xps13 NetworkManager[581]: <info>  (wlp2s0): canceled DHCP transaction
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopping RealtimeKit Scheduling Policy Service...
Mar 01 19:07:59 alistair-xps13 NetworkManager[581]: <info>  Writing DNS information to /usr/bin/resolvconf
Mar 01 19:07:59 alistair-xps13 systemd[1]: Unmounted /run/user/1000/gvfs.
Mar 01 19:07:59 alistair-xps13 login[586]: pam_systemd(login:session): Failed to release session: Connection reset by peer
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped Authorization Manager.
Mar 01 19:07:59 alistair-xps13 mkinitcpio[2010]: ==> Starting build: none
Mar 01 19:07:59 alistair-xps13 systemd[629]: pam_unix(systemd-user:session): session closed for user alistair
Mar 01 19:07:59 alistair-xps13 systemd[625]: Stopped Virtual filesystem service.
Mar 01 19:07:59 alistair-xps13 mkinitcpio[2010]:   -> Running build hook: [sd-shutdown]
Mar 01 19:07:59 alistair-xps13 systemd[625]: Stopped target Basic System.
Mar 01 19:07:59 alistair-xps13 systemd[625]: Stopped target Sockets.
Mar 01 19:07:59 alistair-xps13 systemd[625]: Closed D-Bus User Message Bus Socket.
Mar 01 19:07:59 alistair-xps13 systemd[625]: Closed Sound System.
Mar 01 19:07:59 alistair-xps13 systemd[625]: Reached target Shutdown.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped D-Bus System Message Bus.
Mar 01 19:07:59 alistair-xps13 systemd[625]: Starting Exit the Session...
Mar 01 19:07:59 alistair-xps13 systemd[625]: Stopped target Paths.
Mar 01 19:07:59 alistair-xps13 systemd[625]: Stopped target Timers.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped RealtimeKit Scheduling Policy Service.
Mar 01 19:07:59 alistair-xps13 systemd[625]: Received SIGRTMIN+24 from PID 2031 (kill).
Mar 01 19:07:59 alistair-xps13 wpa_supplicant[604]: p2p-dev-wlp2s0: CTRL-EVENT-TERMINATING
Mar 01 19:07:59 alistair-xps13 kernel: wlp2s0: deauthenticating from 5c:f4:ab:04:37:6b by local choice (Reason: 3=DEAUTH_LEAVING)
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped User Manager for UID 1000.
Mar 01 19:07:59 alistair-xps13 systemd-logind[574]: Failed to abandon session scope: Transport endpoint is not connected
Mar 01 19:07:59 alistair-xps13 wpa_supplicant[604]: wlp2s0: CTRL-EVENT-DISCONNECTED bssid=5c:f4:ab:04:37:6b reason=3 locally_generated=1
Mar 01 19:07:59 alistair-xps13 wpa_supplicant[604]: nl80211: deinit ifname=wlp2s0 disabled_11b_rates=0
Mar 01 19:07:59 alistair-xps13 mkinitcpio[2010]: ==> Build complete.
Mar 01 19:07:59 alistair-xps13 wpa_supplicant[604]: wlp2s0: CTRL-EVENT-TERMINATING
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped Getty on tty1.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped WPA supplicant.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Started Generate shutdown-ramfs.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Requested transaction contradicts existing jobs: Transaction is destructive.
Mar 01 19:07:59 alistair-xps13 systemd[1]: systemd-coredump.socket: Failed to queue service startup job (Maybe the service file is missing or not a non-template unit?): Transaction is destructive.
Mar 01 19:07:59 alistair-xps13 systemd[1]: systemd-coredump.socket: Unit entered failed state.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Removed slice system-getty.slice.
Mar 01 19:07:59 alistair-xps13 NetworkManager[581]: <info>  Removing DNS information from /usr/bin/resolvconf
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped Apache Web Server.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped target Network.
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopping Network Manager...
Mar 01 19:07:59 alistair-xps13 systemd[1]: Stopped Network Manager.
Mar 01 19:09:29 alistair-xps13 systemd[1]: session-c1.scope: Stopping timed out. Killing.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Session c1 of user alistair.
Mar 01 19:09:29 alistair-xps13 systemd[1]: session-c1.scope: Unit entered failed state.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Removed slice User Slice of alistair.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopping Login Service...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopping Permit User Sessions...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Permit User Sessions.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped target Remote File Systems.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Login Service.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped target Basic System.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped target Sockets.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped target Paths.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped target Slices.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Removed slice User and Session Slice.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Closed D-Bus System Message Bus Socket.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped target System Initialization.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Apply Kernel Variables.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopping Load/Save Random Seed...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Setup Virtual Console.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Load Kernel Modules.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped target Encrypted Volumes.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped target Swap.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Deactivating swap /dev/disk/by-path/pci-0000:00:1f.2-ata-3-part3...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Deactivating swap Swap Partition...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Set Up Additional Binary Formats.
Mar 01 19:09:29 alistair-xps13 swapoff[2177]: swapoff: /dev/disk/by-uuid/a313a6dd-4767-40ef-bbdf-b4b078500d6f: swapoff failed: Invalid argument
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopping Load/Save Screen Backlight Brightness of leds:dell::kbd_backlight...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopping Load/Save Screen Backlight Brightness of backlight:intel_backlight...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopping Update UTMP about System Boot/Shutdown...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Load/Save Random Seed.
Mar 01 19:09:29 alistair-xps13 systemd[1]: dev-disk-by\x2duuid-a313a6dd\x2d4767\x2d40ef\x2dbbdf\x2db4b078500d6f.swap: Swap process exited, code=exited status=255
Mar 01 19:09:29 alistair-xps13 systemd[1]: Deactivated swap /dev/disk/by-uuid/a313a6dd-4767-40ef-bbdf-b4b078500d6f.
Mar 01 19:09:29 alistair-xps13 systemd[1]: dev-disk-by\x2duuid-a313a6dd\x2d4767\x2d40ef\x2dbbdf\x2db4b078500d6f.swap: Unit entered failed state.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Deactivated swap Swap Partition.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Load/Save Screen Backlight Brightness of leds:dell::kbd_backlight.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Load/Save Screen Backlight Brightness of backlight:intel_backlight.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Deactivated swap /dev/disk/by-path/pci-0000:00:1f.2-ata-3-part3.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Deactivated swap /dev/disk/by-partuuid/34eba519-e251-40fa-926e-f3bb0a4b1535.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Deactivated swap /dev/disk/by-id/ata-SK_hynix_SH920_mSATA_256GB_EI3BN043213B93486-part3.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Update UTMP about System Boot/Shutdown.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Create Volatile Files and Directories.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped target Local File Systems.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounting Temporary Directory...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounting /var/cache/zoneminder/temp...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounting /boot...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounting /run/user/1000...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounting /var/cache/zoneminder/events...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounting /var/cache/zoneminder/images...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Removed slice system-systemd\x2dbacklight.slice.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounted /var/cache/zoneminder/temp.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounted /var/cache/zoneminder/events.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounted /var/cache/zoneminder/images.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounted /boot.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounted Temporary Directory.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounted /run/user/1000.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped File System Check on /dev/disk/by-uuid/3546-0C81.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Removed slice system-systemd\x2dfsck.slice.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounting /home...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Unmounted /home.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Reached target Unmount All Filesystems.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped target Local File Systems (Pre).
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Create Static Device Nodes in /dev.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Stopped Remount Root and Kernel File Systems.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Reached target Shutdown.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Reached target Final Step.
Mar 01 19:09:29 alistair-xps13 systemd[1]: Starting Power-Off...
Mar 01 19:09:29 alistair-xps13 systemd[1]: Shutting down.
Mar 01 19:09:29 alistair-xps13 systemd-journald[185]: Journal stopped

Thanks,
Alistair

Offline

#9 2016-03-01 23:40:33

damjan
Member
Registered: 2006-05-30
Posts: 451

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

gpg-agent run from the session perhaps? (run it from systemd --user instead if thats the problem)

Offline

#10 2016-03-02 05:55:09

akgrant0710
Member
Registered: 2015-12-30
Posts: 25

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

damjan wrote:

gpg-agent run from the session perhaps? (run it from systemd --user instead if thats the problem)

Thanks for the thought, but I don't use gpg-agent (others may).

Cheers,
Alistair

Offline

#11 2016-03-02 07:09:38

akgrant0710
Member
Registered: 2015-12-30
Posts: 25

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

A similar report for Ubuntu
(https://bugs.launchpad.net/ubuntu/+sour … ug/1457400) had a couple of useful bits:

1. The first was to try and narrow down the problem by using the systemd debug
shell (see https://wiki.archlinux.org/index.php/boot_debugging) and
during the hang save the output of:

loginctl session-status c2 > /root/session-c2.txt

(or c1, in my case).

I just get:

loginctl session-status c1
Failed to get session: Connection reset by peer

The command does work prior to initiating shutdown.

2. A partial workaround for the problem is to reduce the timeout:

/etc/systemd/system.conf

or a similar file should be your friend

http://www.freedesktop.org/software/systemd/man/systemd-system.conf.html

search for

DefaultTimeoutStartSec=
DefaultTimeoutStopSec=
TimeoutSec=

and enter lower values

Cheers,
Alistair

Offline

#12 2016-03-02 09:52:20

evilwmuser
Member
Registered: 2016-02-25
Posts: 6

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

I've tried altering the system timeout, but wasn't happy with that. I can confirm that this seems to have solved the problem on my system (for the last few boots in any case):

pacman -S watchdog
systemctl enable watchdog
sync

Last edited by evilwmuser (2016-03-02 09:53:43)


Toshiba Tecra (Pentium II, 256mb RAM). Arch & evilwm.

Offline

#13 2016-03-02 19:29:18

Vain
Member
Registered: 2008-10-19
Posts: 179
Website

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

This happens when a program refuses to quit by means of common signals. For example:

#include <signal.h>

int
main()
{
    signal(SIGTERM, SIG_IGN);
    signal(SIGHUP, SIG_IGN);
    signal(SIGINT, SIG_IGN);

    for (;;);
}

This program can only be killed by SIGKILL (and some other signals which are unlikely to be used by an init system to tell a process to shut down). Run this in a terminal and try to shut down. I'm very positive that you'll reliably get the "A stop job is running ..." message.

Now, there's nothing systemd (or any other init system) can do. The program has been asked to shut down gracefully. It doesn't. Well. Your only option is to wait for some time and finally kill the program.

If you're seeing that message on shut down, you obviously have to find out which process is still running in that session. akgrant0710 has mentioned the systemd debug shell, which, I think, is the way to go. If "loginctl session-status c1" does not work (it didn't work in my tests), you can try running "systemd-cgls" in the debug shell when a hang happens. You should then be able to identify the remaining process which didn't agree to terminate.

Offline

#14 2016-03-02 20:45:41

akgrant0710
Member
Registered: 2015-12-30
Posts: 25

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Vain wrote:

This happens when a program refuses to quit by means of common signals. For example:

#include <signal.h>

int
main()
{
    signal(SIGTERM, SIG_IGN);
    signal(SIGHUP, SIG_IGN);
    signal(SIGINT, SIG_IGN);

    for (;;);
}

This program can only be killed by SIGKILL (and some other signals which are unlikely to be used by an init system to tell a process to shut down). Run this in a terminal and try to shut down. I'm very positive that you'll reliably get the "A stop job is running ..." message.

Now, there's nothing systemd (or any other init system) can do. The program has been asked to shut down gracefully. It doesn't. Well. Your only option is to wait for some time and finally kill the program.

If you're seeing that message on shut down, you obviously have to find out which process is still running in that session. akgrant0710 has mentioned the systemd debug shell, which, I think, is the way to go. If "loginctl session-status c1" does not work (it didn't work in my tests), you can try running "systemd-cgls" in the debug shell when a hang happens. You should then be able to identify the remaining process which didn't agree to terminate.


Thanks for the tip about systemd-cgls:

Control group /:
-.slice
|-init.scope
| `-1 /sbin/init
|-system.slice
| |-systemd-journald.service
| | `-211 /usr/lib/systemd/systemd-journald
| |-systemd-logind.service
| | `-578 /usr/lib/systemd/systemd-logind
| |-systemd-udevd.service
| | `-321 /usr/lib/systemd/systemd-udevd
| |-debug-shell.service
| | |- 181 /bin/sh
| | `-1929 systemd-cgls
| `-NetworkManager.service
|   `-694 /usr/bin/dhclient -d -q -sf /usr/lib/networkmanager/nm-dhcp-helper ...
`-user.slice
  `-user-1000.slice
    `-session-c1.scope
      `-1048 /usr/lib/chromium/chromium

What you say makes perfect sense, but... :-)

If I reboot (so the system is in a relatively clean state), start chromium and then shutdown, the system hangs for 90s.

If I reboot, start chromium, killall -SIGTERM chromium and then shutdown, there's no problem.

Offline

#15 2016-03-02 22:17:34

YAOMTC
Member
Registered: 2010-02-23
Posts: 204

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Control group /:
-.slice
|-init.scope
| `-1 /sbin/init
|-system.slice
| |-mnt-WD1TBlue2.mount
| | `-340 /sbin/mount.ntfs-3g /dev/sdc2 /mnt/WD1TBlue2 -o rw,uid=1000,gid=100...
| |-systemd-journald.service
| | `-164 /usr/lib/systemd/systemd-journald
| |-systemd-timesyncd.service
| | `-351 /usr/lib/systemd/systemd-timesyncd
| |-systemd-logind.service
| | `-373 /usr/lib/systemd/systemd-logind
| |-mnt-SSD64GB.mount
| | `-326 /sbin/mount.ntfs-3g /dev/sdb1 /mnt/SSD64GB -o rw,uid=1000,gid=100
| |-systemd-udevd.service
| | `-220 /usr/lib/systemd/systemd-udevd
| |-debug-shell.service
| | |-187 /bin/sh
| | `-941 systemd-cgls
| `-mnt-WD1TBlue.mount
|   `-338 /sbin/mount.ntfs-3g /dev/sdd1 /mnt/WD1TBlue -o rw,uid=1000,gid=100
`-user.slice
  `-user-1000.slice
    `-session-c2.scope
      `-631 kwin_x11 -session 10c5d7d6d3000143360467900000006020001_145158479...

So kwin_x11 isn't ending properly for me? That's what this means? If so, how can I troubleshoot this?

Offline

#16 2016-03-03 18:50:59

Vain
Member
Registered: 2008-10-19
Posts: 179
Website

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Try to find out what those processes are doing. Are they running? Are they waiting for some resource? What happens when you issue another "kill -TERM $pid" on them? Can you find any kind of log file, specific to those processes?

IIUC, tools like strace should be available in the debug shell at this particular point.

I guess it'll be a bit of work to find out what's going on here. sad

By the way, I'm having those issues, too. I just can't reproduce it, so it's pretty hard to debug ... For now, I'm using the following to shut down the system:

sudo systemctl start debug-shell
sleep 1
sudo poweroff

This way, I'll have a debug shell ready if the system decides to hang (but the shell won't run all the time which would leave a root shell available for anyone in the room). It's probably also handy to increase the timeouts mentioned in earlier posts, so you have more time to debug the problem.

---

For the record, the following threads deal with similar problems:

https://bbs.archlinux.org/viewtopic.php?pid=1609293
https://bbs.archlinux.org/viewtopic.php?id=209587
https://bbs.archlinux.org/viewtopic.php?id=209651

Last edited by Vain (2016-03-03 18:52:57)

Offline

#17 2016-03-08 18:25:33

Vain
Member
Registered: 2008-10-19
Posts: 179
Website

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Okay, if my shutdown hangs, it's always chromium that's blocking the shutdown. Just like it's happening for akgrant0710.

It's not 100% reproducible. There's a ~40% chance that a shutdown while chromium was running will hang.

I tried to debug what's going on but I'm not really sure how to do this. What I have found:

  • Chromium's main process appears to wait for all of its threads to finish and quit. The process is in the "D" state according to htop and waiting on the "do_exit" wchan.

  • One of its threads (which does not appear in systemd-cgls) is in the "S" state and waiting on a "pipe_wait" wchan. /proc/$threadid/syscall says syscall number 234 is currently being run. If I'm not mistaken, this is tgkill().

  • When I try to attach to that one thread using strace or send a SIGTERM to it, chromium finally quits and shutdown continues.

I'm not really sure what to make of this. My best guess is that chromium can end up in a deadlock during shutdown. Maybe X11 got killed before chromium or dbus before chromium or whatever. I don't know. If that's true then it's a bug in chromium.

I, personally, can live with that. To be fair, it's a little harsh to do a "sudo poweroff" from a running session. smile I'm pretty sure the init system will just try to kill my session without caring about "process A should be terminated before process B" (if order actually matters -- pure speculation on my end). I'm okay with quitting chromium using a script before issuing a shutdown...

Offline

#18 2016-03-08 19:47:41

akgrant0710
Member
Registered: 2015-12-30
Posts: 25

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Vain wrote:

Okay, if my shutdown hangs, it's always chromium that's blocking the shutdown. Just like it's happening for akgrant0710.

It's not 100% reproducible. There's a ~40% chance that a shutdown while chromium was running will hang.

It's 100% reliable for me.  I've also noticed that I sometimes lose access to the other ttys, i.e. Ctrl-Alt-F2, etc., including tty9 at the time (with systemd debug shell running).

Vain wrote:

I tried to debug what's going on but I'm not really sure how to do this. What I have found:

  • Chromium's main process appears to wait for all of its threads to finish and quit. The process is in the "D" state according to htop and waiting on the "do_exit" wchan.

  • One of its threads (which does not appear in systemd-cgls) is in the "S" state and waiting on a "pipe_wait" wchan. /proc/$threadid/syscall says syscall number 234 is currently being run. If I'm not mistaken, this is tgkill().

  • When I try to attach to that one thread using strace or send a SIGTERM to it, chromium finally quits and shutdown continues.

I'm not really sure what to make of this. My best guess is that chromium can end up in a deadlock during shutdown. Maybe X11 got killed before chromium or dbus before chromium or whatever. I don't know. If that's true then it's a bug in chromium.

I, personally, can live with that. To be fair, it's a little harsh to do a "sudo poweroff" from a running session. smile I'm pretty sure the init system will just try to kill my session without caring about "process A should be terminated before process B" (if order actually matters -- pure speculation on my end). I'm okay with quitting chromium using a script before issuing a shutdown...

I can't really add much to this, but I am learning a lot about system debugging.  Just in case it's useful:

# systemd-cgls
Control group /:
-.slice
|-init.scope
| `-1 /sbin/init
|-system.slice
| |-systemd-journald.service
| | `-180 /usr/lib/systemd/systemd-journald
| |-systemd-logind.service
| | `-599 /usr/lib/systemd/systemd-logind
| |-systemd-udevd.service
| | `-318 /usr/lib/systemd/systemd-udevd
| |-debug-shell.service
| | |- 186 /bin/sh
| | |-1907 /bin/bash /home/alistair/tmp/systemd.sh
| | `-1908 systemd-cgls
| `-NetworkManager.service
|   `-707 /usr/bin/dhclient -d -q -sf /usr/lib/networkmanager/nm-dhcp-helper ...
`-user.slice
  `-user-1000.slice
    `-session-c1.scope
      `-1077 /usr/lib/chromium/chromium


# ps -ef | grep chromium
alistair  1077     1 14 20:16 ?        00:00:08 /usr/lib/chromium/chromium
alistair  1111  1077  7 20:16 ?        00:00:04 [chromium] <defunct>
root      1910  1907  0 20:17 tty9     00:00:00 grep chromium


# cat /proc/1077/syscall
56 0x3d0f00 0x7f7e8aec4d70 0x7f7e8aec59d0 0x7f7e8aec59d0 0x7f7e8aec5700 0x7f7e8aec5700 0x7ffd44691a18 0x7f7e9644cc81

# cat /proc/1111/syscall
7 0x17a1ac78d760 0x3 0xffffffff 0x17a1ac773120 0x3 0x1 0x7ffcb3d1a910 0x7fb20c6d3c3d

HTH,
Alistair

Offline

#19 2016-03-09 12:04:17

axel
Member
Registered: 2007-12-10
Posts: 77

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Vain wrote:

Okay, if my shutdown hangs, it's always chromium that's blocking the shutdown. Just like it's happening for akgrant0710.

It's not 100% reproducible. There's a ~40% chance that a shutdown while chromium was running will hang.

I agree with that.

I've also noticed that it is most likely to happen if I close chromium from the X button instead of closing it from its menu. Moreover the times that my shutdown hangs when I log in again and open chromium it doesn't remember the opened tabs correctly (I have restore tabs enabled).

If I close chromium from the menu, log out from KDE and then poweroff from ssdm menu the hang is most likely not happening (can't remember if it actually happens at all).

Offline

#20 2016-03-09 13:03:04

Nordicruler
Member
From: Sweden
Registered: 2005-02-05
Posts: 13

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

evilwmuser wrote:

I've tried altering the system timeout, but wasn't happy with that. I can confirm that this seems to have solved the problem on my system (for the last few boots in any case):

pacman -S watchdog
systemctl enable watchdog
sync

Thank you that solves my problem, i have been searching for a solution for quite some time.


The world is going to an end, Please log off!!

Offline

#21 2016-03-09 15:52:56

evilwmuser
Member
Registered: 2016-02-25
Posts: 6

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Thanks Nordicruler. There's another thread on here where people are looking for a better fix, but this does seem to have cleared it up for me.
smile


Toshiba Tecra (Pentium II, 256mb RAM). Arch & evilwm.

Offline

#22 2016-03-09 23:52:40

Nordicruler
Member
From: Sweden
Registered: 2005-02-05
Posts: 13

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

evilwmuser wrote:

Thanks Nordicruler. There's another thread on here where people are looking for a better fix, but this does seem to have cleared it up for me.
smile

Yes i have tried different versions of systemd (226, 228, 229) and always same delay and i dont have it in any other distro than arch so
it would be very nice to know what is causing this to happen.


The world is going to an end, Please log off!!

Offline

#23 2016-03-10 07:37:41

akgrant0710
Member
Registered: 2015-12-30
Posts: 25

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

Nordicruler wrote:

Yes i have tried different versions of systemd (226, 228, 229) and always same delay and i dont have it in any other distro than arch so
it would be very nice to know what is causing this to happen.

There's a confirmed bug report in Ubuntu that looks similar: https://bugs.launchpad.net/ubuntu/+sour … ug/1457400

And a longer closed bug report in Fedora (which I didn't read completely): https://bugzilla.redhat.com/show_bug.cgi?id=1088619

Offline

#24 2016-03-23 09:11:30

boban_dj
Member
Registered: 2015-03-17
Posts: 150

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

I use i3, and had same problem with hanging shutdown, first with conky, then chrome, also avahi-deamon. The best explanation so far I read from comment #6 here: https://bbs.archlinux.org/viewtopic.php?id=202018

To avoid the .bash_history issue, use the AUR's systemd-kill-fix package.  It reverts a single upstream commit, that changed a boolean from false to true.  Other than that boolean value, it's pure upstream systemd.
Having the commit eliminates a race condition during shutdown that otherwise could lead to a 90 second or so wait during shutdown.  But, it means many programs are given a SIGKILL (kill -9) upon reboot/shutdown so they can't shutdown gracefully.  This has caused data loss, thankfully the most common is .bash_history.  But, there have been many other situations of more severe data loss.
Most distributions (including Debian, Ubuntu, Fedora, and RedHat) have reverted the commit.  The head upstream developer (poettering) refuses to revert the commit.  No one else seems to have expressed agreement with the decision, but it is his project.  (We can all be thankful he's made systemd, no sarcasm intended here by me.)
My understanding is it is planned that systemd will continue operating the way it does, risking data loss, until kernel 4.3 is out.
You can see much frustration here and here on systemd GitHub, and many tickets on distribution-specific forums about the issue, some of which are linked to on those GitHub pages.

the links he is refering to in the comment are here and here

And the comment from Poettering himself:

poettering commented on Jun 24, 2015
Nope. This is working around one bug by introducing another. It's really not that simple.
To make this clear: the issue only applies to scope units that aren't properly taken down by the process registering them. Login sessions are normally actually not of that kind, during normal operation (i.e. when a user logs in, then logs out again). The only exception is if a session is left hanging and is shut down by the system instead of the registering process, how it happens when the system is shut down while login sessions are still around.
@poettering
systemd member
poettering commented on Jun 24, 2015
The right fix has probably to wait until systemd adopted the unified cgroup hierarchy, since that will provide us with full support for notifications when cgroups run empty.

My system:

$ pacman -Q systemd
systemd 229-3

$ uname -a
Linux archz800 4.1.19-1-lts #1 SMP Sun Mar 6 09:23:49 CET 2016 x86_64 GNU/Linux

Last edited by boban_dj (2016-03-23 11:42:34)

Offline

#25 2016-03-25 20:11:26

akgrant0710
Member
Registered: 2015-12-30
Posts: 25

Re: "A stop job is running..." on shutdown/reboot if i3 not quit first

boban_dj wrote:

I use i3, and had same problem with hanging shutdown, first with conky, then chrome, also avahi-deamon. The best explanation so far I read from comment #6 here: https://bbs.archlinux.org/viewtopic.php?id=202018

Thanks very much for the update and links.

boban_dj wrote:

To avoid the .bash_history issue, use the AUR's systemd-kill-fix package.  It reverts a single upstream commit, that changed a boolean from false to true.  Other than that boolean value, it's pure upstream systemd.
Having the commit eliminates a race condition during shutdown that otherwise could lead to a 90 second or so wait during shutdown.  But, it means many programs are given a SIGKILL (kill -9) upon reboot/shutdown so they can't shutdown gracefully.  This has caused data loss, thankfully the most common is .bash_history.  But, there have been many other situations of more severe data loss.
Most distributions (including Debian, Ubuntu, Fedora, and RedHat) have reverted the commit.  The head upstream developer (poettering) refuses to revert the commit.  No one else seems to have expressed agreement with the decision, but it is his project.  (We can all be thankful he's made systemd, no sarcasm intended here by me.)
My understanding is it is planned that systemd will continue operating the way it does, risking data loss, until kernel 4.3 is out.
You can see much frustration here and here on systemd GitHub, and many tickets on distribution-specific forums about the issue, some of which are linked to on those GitHub pages.

the links he is refering to in the comment are here and here

And the comment from Poettering himself:

poettering commented on Jun 24, 2015
Nope. This is working around one bug by introducing another. It's really not that simple.
To make this clear: the issue only applies to scope units that aren't properly taken down by the process registering them. Login sessions are normally actually not of that kind, during normal operation (i.e. when a user logs in, then logs out again). The only exception is if a session is left hanging and is shut down by the system instead of the registering process, how it happens when the system is shut down while login sessions are still around.
@poettering
systemd member
poettering commented on Jun 24, 2015
The right fix has probably to wait until systemd adopted the unified cgroup hierarchy, since that will provide us with full support for notifications when cgroups run empty.

Maybe I'm just getting old and muddle-minded, but I found most of the discussion quite difficult to follow as both the original commit and the reversion are sometimes just referred to as "the commit".

My understanding is that you can either have:

* A 90 second delay on shutdown (with default timeouts), but everything is given time to exit cleanly, or
* Quick shutdown, but some applications may lose data

Assuming I'm understanding it correctly, my vote would be for the first option, it's quite easy to work around, and doesn't involve potential data loss.  Although I can image some sys admins not feeling the same way.

I saw a systemd commit message today titled "update unified hierarchy support", so hopefully the real fix is on its way.

boban_dj wrote:

My system:

$ pacman -Q systemd
systemd 229-3

Ditto.

Thanks!
Alistair

Offline

Board footer

Powered by FluxBB