New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Fedora 25 template #2455

Closed
marmarek opened this Issue Nov 24, 2016 · 15 comments

Comments

Projects
None yet
8 participants
@marmarek
Member

marmarek commented Nov 24, 2016

This one may be tricky because of X11 -> Wayland migration.
https://fedoramagazine.org/fedora-25-released/

This ticket will be updated with more details when they come.

marmarek added a commit to marmarek/qubes-linux-yum that referenced this issue Nov 25, 2016

marmarek added a commit to marmarek/qubes-builder-rpm that referenced this issue Nov 25, 2016

marmarek added a commit to marmarek/qubes-builder-rpm that referenced this issue Nov 25, 2016

Install c-development group in build environemnt
development-tools group does no longer contain gcc and stuff (at least
in Fedora 25, but maybe also earlier).

QubesOS/qubes-issues#2455

marmarek added a commit to marmarek/qubes-builder-rpm that referenced this issue Nov 25, 2016

@andrewdavidwong andrewdavidwong added this to the Release 4.0 milestone Nov 25, 2016

marmarek added a commit to marmarek/old-qubes-gui-agent-linux that referenced this issue Nov 26, 2016

rpm: fix pulseaudio version
Pulseaudio 9.0 headers are already included, fix BuildRequires
accordingly.

QubesOS/qubes-issues#2455

marmarek added a commit to marmarek/old-qubes-gui-agent-linux that referenced this issue Nov 26, 2016

xf86-video-dummy: adjust for xorg-server-1.19.0
ChangeWindowProperty was dropped, dixChangeWindowProperty should be used
instead. See eb36924 "dix: Remove redundant ChangeWindowProperty" commit
in https://anongit.freedesktop.org/git/xorg/xserver.

QubesOS/qubes-issues#2455

marmarek added a commit to marmarek/old-qubes-gui-agent-linux that referenced this issue Nov 26, 2016

marmarek added a commit to QubesOS/qubes-builder-github that referenced this issue Nov 26, 2016

@andrewdavidwong

This comment has been minimized.

Show comment
Hide comment
@andrewdavidwong

andrewdavidwong Nov 26, 2016

Member

Helpful feedback from Alex:

On 11/26/16 07:13, Alex wrote:

Hi,
I'm reporting some user experience tests for fedora 25 template (ref.
issue mentioned in subject).

I updated a fedora 24 template with many customizations on it, bringing
it to f25 via DNF and enabling qubes-vm-r3.2-current-testing repo.

Environment: Qubes R3.2 fully updated, i3WM as window manager.

Mindset: upgrading my AppVMs, and in the meanwhile helping with issue
#2455, with specific attention to graphical/GUI issues (because of
recent Fedora switch to Wayland, which Qubes does not support, as
mentioned by marmarek on said issue).

# dnf --releasever=25 --enablerepo=qubes-vm-r3.2-current-testing update

The upgrade process was smooth, took 4 hours overall (I was working
during the process, so this may have slowed it down) and template size
(after trim) increased slightly from 8.46GB to 8.57GB (not bad!). The
repos for torproject don't have fc25 as an available release yet...

As far as I am concerned, these were the measured facts:

  • many AppVMs started just fine after changing the template in their
    settings from fedora 24 to fedora 25.
  • firefox, thunderbird and libreoffice work just fine. Firefox can play
    youtube videos without delays, glitches nor jitter.
  • pinta (graphic manipulation program) works ok
  • Android studio works ok
  • gnome-terminal, xterm and urxvt all work with their customizations
    (themes)
  • Android emulator (emulating ARM processor, so it's normally slow)
    works exactly as before
  • Monodevelop works ok
  • window resizing works ok, both dragging corners (for floating windows)
    and splitting monitors in various ways (i3wm is a tiling window manager).

Now for more unsolicited input, but trying to be as specific as I can be

  • please note that I don't fully understand the working of Qubes-GUID (I
    never studied it, until now :)
  • One AppVM with a lot of installed software took a couple of tries to
    correctly start. The first time the start failed with "qrexec daemon not
    running", and in guid log I found a long list of "invalid PMaxSize for
    0x2000001d (32767/32767)" and so on. Cannot reproduce this problem.
  • Qubes-GUID crashed in one AppVM as soon as I started monodevelop the
    first time. Cannot reproduce this problem either. Error in guid log was:
ErrorHandler: BadAccess (attempt to access private resource denied)
                 Major opcode: 130 (MIT-SHM)
                 Minor opcode: 1 (X_ShmAttach)
                 ResourceID:   0x2000054
                 Failed serial number:  3670
                 Current serial number: 3671

may be related to the fact that monodevelop shows and hides many windows
in rapid sequence when starting?

Overall the switch was good. I'll report further problems should they
arise. Thank you for your work, let me know if I can help more.

Member

andrewdavidwong commented Nov 26, 2016

Helpful feedback from Alex:

On 11/26/16 07:13, Alex wrote:

Hi,
I'm reporting some user experience tests for fedora 25 template (ref.
issue mentioned in subject).

I updated a fedora 24 template with many customizations on it, bringing
it to f25 via DNF and enabling qubes-vm-r3.2-current-testing repo.

Environment: Qubes R3.2 fully updated, i3WM as window manager.

Mindset: upgrading my AppVMs, and in the meanwhile helping with issue
#2455, with specific attention to graphical/GUI issues (because of
recent Fedora switch to Wayland, which Qubes does not support, as
mentioned by marmarek on said issue).

# dnf --releasever=25 --enablerepo=qubes-vm-r3.2-current-testing update

The upgrade process was smooth, took 4 hours overall (I was working
during the process, so this may have slowed it down) and template size
(after trim) increased slightly from 8.46GB to 8.57GB (not bad!). The
repos for torproject don't have fc25 as an available release yet...

As far as I am concerned, these were the measured facts:

  • many AppVMs started just fine after changing the template in their
    settings from fedora 24 to fedora 25.
  • firefox, thunderbird and libreoffice work just fine. Firefox can play
    youtube videos without delays, glitches nor jitter.
  • pinta (graphic manipulation program) works ok
  • Android studio works ok
  • gnome-terminal, xterm and urxvt all work with their customizations
    (themes)
  • Android emulator (emulating ARM processor, so it's normally slow)
    works exactly as before
  • Monodevelop works ok
  • window resizing works ok, both dragging corners (for floating windows)
    and splitting monitors in various ways (i3wm is a tiling window manager).

Now for more unsolicited input, but trying to be as specific as I can be

  • please note that I don't fully understand the working of Qubes-GUID (I
    never studied it, until now :)
  • One AppVM with a lot of installed software took a couple of tries to
    correctly start. The first time the start failed with "qrexec daemon not
    running", and in guid log I found a long list of "invalid PMaxSize for
    0x2000001d (32767/32767)" and so on. Cannot reproduce this problem.
  • Qubes-GUID crashed in one AppVM as soon as I started monodevelop the
    first time. Cannot reproduce this problem either. Error in guid log was:
ErrorHandler: BadAccess (attempt to access private resource denied)
                 Major opcode: 130 (MIT-SHM)
                 Minor opcode: 1 (X_ShmAttach)
                 ResourceID:   0x2000054
                 Failed serial number:  3670
                 Current serial number: 3671

may be related to the fact that monodevelop shows and hides many windows
in rapid sequence when starting?

Overall the switch was good. I'll report further problems should they
arise. Thank you for your work, let me know if I can help more.

marmarek added a commit to marmarek/qubes-builder-rpm that referenced this issue Nov 27, 2016

Add default applications list for Fedora 25
This is just a copy from Fedora 24, at least for now.

QubesOS/qubes-issues#2455

marmarek added a commit to marmarek/qubes-builder-rpm that referenced this issue Nov 27, 2016

@0spinboson

This comment has been minimized.

Show comment
Hide comment
@0spinboson

0spinboson Nov 27, 2016

Update (regular fc25 and a self-mutilated fc25-sys templates) went smoothly here as well, though I'm a pretty vanilla user.
Only issue was that I had to recreate sys-net, as there was an issue with 10.137.255.254:8002 not being reachable for VM updates (affecting both fedora and debian templates), although regular browsing worked fine.
Minor stability improvement: when I 'snapped' & enlarged Keepass to a (FHD) quarter of my UHD screen using fc24, or maximized it to 2160p, it crashed without giving any errors. Now it works/(re)draws fine.

0spinboson commented Nov 27, 2016

Update (regular fc25 and a self-mutilated fc25-sys templates) went smoothly here as well, though I'm a pretty vanilla user.
Only issue was that I had to recreate sys-net, as there was an issue with 10.137.255.254:8002 not being reachable for VM updates (affecting both fedora and debian templates), although regular browsing worked fine.
Minor stability improvement: when I 'snapped' & enlarged Keepass to a (FHD) quarter of my UHD screen using fc24, or maximized it to 2160p, it crashed without giving any errors. Now it works/(re)draws fine.

marmarek added a commit to QubesOS/qubes-gui-agent-linux that referenced this issue Dec 15, 2016

rpm: fix pulseaudio version
Pulseaudio 9.0 headers are already included, fix BuildRequires
accordingly.

QubesOS/qubes-issues#2455

(cherry picked from commit 14ab05c)

marmarek added a commit to QubesOS/qubes-gui-agent-linux that referenced this issue Dec 15, 2016

xf86-video-dummy: adjust for xorg-server-1.19.0
ChangeWindowProperty was dropped, dixChangeWindowProperty should be used
instead. See eb36924 "dix: Remove redundant ChangeWindowProperty" commit
in https://anongit.freedesktop.org/git/xorg/xserver.

QubesOS/qubes-issues#2455

(cherry picked from commit 1f368ad)
@dmoerner

This comment has been minimized.

Show comment
Hide comment
@dmoerner

dmoerner Jan 7, 2017

I updated my templates today. Two major improvements: (a) KeepassX works much better with large entries, and (b) #2552 is fixed.

EDIT: There is a definite regression. Sometimes, "poweroff" takes 2 minutes to shut down a VM. I have seen this happen with both template VMs and app VMs. Something is delaying the shutdown, but unless I'm missing something, I can't see what it is in the logs:

Fedora 25 (Twenty Five)
Kernel 4.4.31-11.pvops.qubes.x86_64 on an x86_64 (hvc0)

dev login: [    7.209453] fuse init (API version 7.23)
[  252.083088] loop: module loaded
[  252.502602] EXT4-fs (loop0): mounted filesystem with ordered data mode. Opts: (null)
[ 2220.493027] clocksource: timekeeping watchdog: Marking clocksource 'tsc' as unstable because the skew is too large:
[ 2220.493040] clocksource:                       'xen' wd_now: 16f90e739d7f wd_last: 16f84a0e400b mask: ffffffffffffffff
[ 2220.493046] clocksource:                       'tsc' cs_now: a08f3eae cs_last: 23f064c70f34 mask: ffffffffffffffff
[ 2250.333095] FS-Cache: Loaded
[ 2250.340576] FS-Cache: Netfs 'nfs' registered for caching
[ 2250.346383] Key type dns_resolver registered
[ 2250.353616] NFS: Registering the id_resolver key type
[ 2250.353640] Key type id_resolver registered
[ 2250.353645] Key type id_legacy registered
[ 6862.026838] hrtimer: interrupt took 7027780 ns
[ 9889.256720] xen-blkback: event-channel 7
[ 9889.256933] xen-blkback: /local/domain/36/device/vbd/51760:using single page: ring-ref 1787
[ 9889.257087] xen-blkback: ring-pages:1, event-channel 7, protocol 1 (x86_64-abi) 
[.[0;32m  OK  .[0m] Stopped Qubes base firewall settings.
         Stopping Disk Manager...
         Unmounting RPC Pipe File System...
         Stopping Restore /run/initramfs on shutdown...
         Stopping User Manager for UID 1000...
         Stopping CUPS Scheduler...
[.[0;32m  OK  .[0m] Stopped target Multi-User System.
[.[0;32m  OK  .[0m] Stopped target Login Prompts.
         Stopping Serial Getty on hvc0...
         Stopping D-Bus System Message Bus...
         Stopping Qubes GUI Agent...
         Stopping Entropy Daemon based on the HAVEGE algorithm...
         Stopping ABRT Xorg log watcher...
[.[0;32m  OK  .[0m] Stopped target Timers.
[.[0;32m  OK  .[0m] Stopped Daily Cleanup of Temporary Directories.
         Stopping Qubes misc post-boot actions...
         Stopping RealtimeKit Scheduling Policy Service...
         Stopping Getty on tty1...
         Stopping Install ABRT coredump hook...
         Stopping Qubes remote exec agent...
         Stopping Job spooling tools...
         Stopping Session c1 of user user.
         Stopping ABRT kernel log watcher...
         Stopping Manage Sound Card State (restore and store)...
         Stopping Daemon for power management...
         Stopping Authorization Manager...
[.[0;32m  OK  .[0m] Stopped Periodically check for updates.
[.[0;32m  OK  .[0m] Unmounted /run/user/1000/gvfs.
[.[0;32m  OK  .[0m] Stopped Entropy Daemon based on the HAVEGE algorithm.
[.[0;32m  OK  .[0m] Stopped ABRT Automated Bug Reporting Tool.
[.[0;32m  OK  .[0m] Stopped D-Bus System Message Bus.
[.[0;32m  OK  .[0m] Stopped Serial Getty on hvc0.
[.[0;32m  OK  .[0m] Stopped Job spooling tools.
[.[0;32m  OK  .[0m] Stopped Getty on tty1.
[.[0;32m  OK  .[0m] Stopped ABRT kernel log watcher.
[.[0;32m  OK  .[0m] Stopped ABRT Xorg log watcher.
[.[0;32m  OK  .[0m] Stopped Qubes remote exec agent.
[.[0;32m  OK  .[0m] Stopped RealtimeKit Scheduling Policy Service.
[.[0;32m  OK  .[0m] Stopped Authorization Manager.
[.[0;32m  OK  .[0m] Stopped Daemon for power management.
[.[0;32m  OK  .[0m] Stopped Disk Manager.
[.[0;32m  OK  .[0m] Stopped CUPS Scheduler.
[.[0;32m  OK  .[0m] Unmounted RPC Pipe File System.
[.[0;32m  OK  .[0m] Stopped Restore /run/initramfs on shutdown.
[.[0;32m  OK  .[0m] Stopped Install ABRT coredump hook.
[.[0;32m  OK  .[0m] Stopped Manage Sound Card State (restore and store).
[.[0;32m  OK  .[0m] Stopped Qubes GUI Agent.
         Stopping Qubes memory information reporter...
         Stopping Xen driver domain device daemon...
[.[0;32m  OK  .[0m] Removed slice system-getty.slice.
[.[0;32m  OK  .[0m] Removed slice system-serial\x2dgetty.slice.
[.[0;32m  OK  .[0m] Stopped Qubes memory information reporter.
[.[0;32m  OK  .[0m] Stopped Xen driver domain device daemon.
[.[0;32m  OK  .[0m] Stopped Qubes misc post-boot actions.
[.[0;32m  OK  .[0m] Stopped User Manager for UID 1000.
[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (5s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (6s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (6s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (7s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (7s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (8s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (8s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (9s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (9s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (10s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (10s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (11s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (11s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (12s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (12s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (13s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (13s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (14s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (14s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (15s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (15s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (16s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (16s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (17s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (17s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (18s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (18s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (19s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (19s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (20s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (20s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (21s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (21s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (22s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (22s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (23s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (23s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (24s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (24s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (25s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (25s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (26s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (26s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (27s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (27s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (28s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (28s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (29s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (29s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (30s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (30s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (31s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (31s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (32s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (32s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (33s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (33s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (34s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (34s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (35s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (35s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (36s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (36s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (37s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (37s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (38s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (38s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (39s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (39s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (40s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (40s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (41s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (41s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (42s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (42s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (43s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (43s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (44s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (44s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (45s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (45s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (46s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (46s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (47s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (47s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (48s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (48s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (49s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (49s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (50s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (50s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (51s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (51s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (52s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (52s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (53s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (53s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (54s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (54s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (55s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (55s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (56s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (56s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (57s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (57s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (58s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (58s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (59s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (59s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (1min / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (1min / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (1min 1s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (1min 1s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (1min 2s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (1min 2s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (1min 3s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (1min 3s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (1min 4s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (1min 4s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (1min 5s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (1min 5s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (1min 6s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (1min 6s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (1min 7s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (1min 7s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (1min 8s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (1min 8s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (1min 9s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (1min 9s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 10s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 10s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 11s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 11s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c... user user (1min 12s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 12s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 13s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 13s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 14s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c... user user (1min 14s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c... user user (1min 15s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c... user user (1min 15s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c... user user (1min 16s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c... user user (1min 16s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 17s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 17s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 18s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 18s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c... user user (1min 19s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 19s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 20s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 20s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 21s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c... user user (1min 21s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c... user user (1min 22s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c... user user (1min 22s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c... user user (1min 23s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c... user user (1min 23s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 24s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 24s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 25s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 25s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c... user user (1min 26s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 26s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 27s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 27s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 28s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c... user user (1min 28s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c... user user (1min 29s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c... user user (1min 29s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (1min 30s / 3min)[11605.748109] u2mfn_release, priv=          (null)

.[K[.[0;32m  OK  .[0m] Stopped Session c1 of user user.
[.[0;32m  OK  .[0m] Removed slice User Slice of user.
         Stopping Permit User Sessions...
         Stopping Login Service...
[.[0;32m  OK  .[0m] Stopped Login Service.
[.[0;32m  OK  .[0m] Stopped Permit User Sessions.
[.[0;32m  OK  .[0m] Stopped target Remote File Systems.
         Unmounting /home/user/gateway-nfs...
         Unmounting /rw/home/user/gateway-nfs...
[.[0;32m  OK  .[0m] Unmounted /home/user/gateway-nfs.
         Unmounting /home...
[.[0;32m  OK  .[0m] Unmounted /home.
[.[0;32m  OK  .[0m] Unmounted /rw/home/user/gateway-nfs.
[.[0;32m  OK  .[0m] Stopped target Remote File Systems (Pre).
[.[0;32m  OK  .[0m] Stopped target NFS client services.
         Stopping GSSAPI Proxy Daemon...
[.[0;32m  OK  .[0m] Stopped target Network.
         Unmounting /rw...
[.[0;32m  OK  .[0m] Unmounted /rw.
[.[0;32m  OK  .[0m] Stopped GSSAPI Proxy Daemon.
[.[0;32m  OK  .[0m] Stopped target Basic System.
[.[0;32m  OK  .[0m] Stopped target Slices.
[.[0;32m  OK  .[0m] Removed slice User and Session Slice.
[.[0;32m  OK  .[0m] Stopped target Sockets.
[.[0;32m  OK  .[0m] Closed CUPS Scheduler.
[.[0;32m  OK  .[0m] Closed D-Bus System Message Bus Socket.
[.[0;32m  OK  .[0m] Stopped target Paths.
[.[0;32m  OK  .[0m] Stopped CUPS Scheduler.
[.[0;32m  OK  .[0m] Stopped target System Initialization.
[.[0;32m  OK  .[0m] Stopped Setup Virtual Console.
[.[0;32m  OK  .[0m] Stopped target Encrypted Volumes.
         Stopping Update UTMP about System Boot/Shutdown...
[.[0;32m  OK  .[0m] Stopped Load legacy module configuration.
         Stopping Load/Save Random Seed...
[.[0;32m  OK  .[0m] Stopped Apply Kernel Variables.
[.[0;32m  OK  .[0m] Stopped Load Kernel Modules.
[.[0;32m  OK  .[0m] Stopped Forward Password Requests to Wall Directory Watch.
[.[0;32m  OK  .[0m] Stopped Dispatch Password Requests to Console Directory Watch.
[.[0;32m  OK  .[0m] Stopped Load/Save Random Seed.
[.[0;32m  OK  .[0m] Stopped Update UTMP about System Boot/Shutdown.
         Stopping Security Auditing Service...
[11606.275570] audit: type=1305 audit(1483815943.848:572): audit_pid=0 old=449 auid=4294967295 ses=4294967295 res=1
[.[0;32m  OK  .[0m] Stopped Security Auditing Service.
[11606.278764] audit: type=1131 audit(1483815943.851:573): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=auditd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[.[0;32m  OK  .[0m] Stopped Create Volatile Files and Directories.
[11606.279567] audit: type=1131 audit(1483815943.852:574): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[.[0;32m  OK  .[0m] Stopped target Local File Systems.
         Unmounting /usr/lib/modules/4.4.31-11.pvops.qubes.x86_64...
         Unmounting /run/user/1000...
[.[0;32m  OK  .[0m] Stopped Configure read-only root support.
[11606.297038] audit: type=1131 audit(1483815943.869:575): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=fedora-readonly comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
         Unmounting /var/spool/cron...
         Unmounting Temporary Directory...
[.[0;1;31mFAILED.[0m] Failed unmounting /usr/lib/modules/4.4.31-11.pvops.qubes.x86_64.
[.[0;32m  OK  .[0m] Unmounted /run/user/1000.
[.[0;32m  OK  .[0m] Unmounted Temporary Directory.
[.[0;32m  OK  .[0m] Stopped target Swap.
         Deactivating swap /dev/xvdc1...
[.[0;32m  OK  .[0m] Deactivated swap /dev/disk/by-uuid/...e5e-3115-4069-b92b-d2109011c2c1.
[.[0;32m  OK  .[0m] Deactivated swap /dev/disk/by-partuuid/a7462b99-01.
[.[0;32m  OK  .[0m] Deactivated swap /dev/xvdc1.
[.[0;32m  OK  .[0m] Unmounted /var/spool/cron.
[.[0;32m  OK  .[0m] Reached target Unmount All Filesystems.
[.[0;32m  OK  .[0m] Stopped target Local File Systems (Pre).
[.[0;32m  OK  .[0m] Stopped Remount Root and Kernel File Systems.
[11606.437304] audit: type=1131 audit(1483815944.010:576): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[.[0;32m  OK  .[0m] Stopped Create Static Device Nodes in /dev.
[11606.437951] audit: type=1131 audit(1483815944.010:577): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[.[0;32m  OK  .[0m] Reached target Shutdown.
[11606.510681] systemd-shutdown[1]: Sending SIGTERM to remaining processes...
[11606.513439] systemd-journald[185]: Received SIGTERM from PID 1 (systemd-shutdow).
[11606.533163] systemd-shutdown[1]: Sending SIGKILL to remaining processes...
[11606.534994] systemd-shutdown[1]: Unmounting file systems.
[11606.535212] systemd-shutdown[1]: Remounting '/usr/lib/modules/4.4.31-11.pvops.qubes.x86_64' read-only with options 'data=ordered'.
[11606.535267] EXT4-fs (xvdd): re-mounted. Opts: data=ordered
[11606.535288] systemd-shutdown[1]: Unmounting /usr/lib/modules/4.4.31-11.pvops.qubes.x86_64.
[11606.540726] systemd-shutdown[1]: Remounting '/' read-only with options 'data=ordered'.
[11606.559460] EXT4-fs (dm-0): re-mounted. Opts: data=ordered
[11606.560852] systemd-shutdown[1]: Remounting '/' read-only with options 'data=ordered'.
[11606.560903] EXT4-fs (dm-0): re-mounted. Opts: data=ordered
[11606.560920] systemd-shutdown[1]: Remounting '/' read-only with options 'data=ordered'.
[11606.560945] EXT4-fs (dm-0): re-mounted. Opts: data=ordered
[11606.560958] systemd-shutdown[1]: All filesystems unmounted.
[11606.560968] systemd-shutdown[1]: Deactivating swaps.
[11606.561066] systemd-shutdown[1]: All swaps deactivated.
[11606.561081] systemd-shutdown[1]: Detaching loop devices.
[11606.562498] systemd-shutdown[1]: All loop devices detached.
[11606.562509] systemd-shutdown[1]: Detaching DM devices.
[11606.562687] systemd-shutdown[1]: Not all DM devices detached, 1 left.
[11606.562752] systemd-shutdown[1]: Detaching DM devices.
[11606.562915] systemd-shutdown[1]: Not all DM devices detached, 1 left.
[11606.562923] systemd-shutdown[1]: Cannot finalize remaining DM devices, continuing.
[11606.586257] systemd-shutdown[1]: Failed to finalize  DM devices, ignoring
[11606.586314] systemd-shutdown[1]: Powering off.
[11606.611165] reboot: System halted

dmoerner commented Jan 7, 2017

I updated my templates today. Two major improvements: (a) KeepassX works much better with large entries, and (b) #2552 is fixed.

EDIT: There is a definite regression. Sometimes, "poweroff" takes 2 minutes to shut down a VM. I have seen this happen with both template VMs and app VMs. Something is delaying the shutdown, but unless I'm missing something, I can't see what it is in the logs:

Fedora 25 (Twenty Five)
Kernel 4.4.31-11.pvops.qubes.x86_64 on an x86_64 (hvc0)

dev login: [    7.209453] fuse init (API version 7.23)
[  252.083088] loop: module loaded
[  252.502602] EXT4-fs (loop0): mounted filesystem with ordered data mode. Opts: (null)
[ 2220.493027] clocksource: timekeeping watchdog: Marking clocksource 'tsc' as unstable because the skew is too large:
[ 2220.493040] clocksource:                       'xen' wd_now: 16f90e739d7f wd_last: 16f84a0e400b mask: ffffffffffffffff
[ 2220.493046] clocksource:                       'tsc' cs_now: a08f3eae cs_last: 23f064c70f34 mask: ffffffffffffffff
[ 2250.333095] FS-Cache: Loaded
[ 2250.340576] FS-Cache: Netfs 'nfs' registered for caching
[ 2250.346383] Key type dns_resolver registered
[ 2250.353616] NFS: Registering the id_resolver key type
[ 2250.353640] Key type id_resolver registered
[ 2250.353645] Key type id_legacy registered
[ 6862.026838] hrtimer: interrupt took 7027780 ns
[ 9889.256720] xen-blkback: event-channel 7
[ 9889.256933] xen-blkback: /local/domain/36/device/vbd/51760:using single page: ring-ref 1787
[ 9889.257087] xen-blkback: ring-pages:1, event-channel 7, protocol 1 (x86_64-abi) 
[.[0;32m  OK  .[0m] Stopped Qubes base firewall settings.
         Stopping Disk Manager...
         Unmounting RPC Pipe File System...
         Stopping Restore /run/initramfs on shutdown...
         Stopping User Manager for UID 1000...
         Stopping CUPS Scheduler...
[.[0;32m  OK  .[0m] Stopped target Multi-User System.
[.[0;32m  OK  .[0m] Stopped target Login Prompts.
         Stopping Serial Getty on hvc0...
         Stopping D-Bus System Message Bus...
         Stopping Qubes GUI Agent...
         Stopping Entropy Daemon based on the HAVEGE algorithm...
         Stopping ABRT Xorg log watcher...
[.[0;32m  OK  .[0m] Stopped target Timers.
[.[0;32m  OK  .[0m] Stopped Daily Cleanup of Temporary Directories.
         Stopping Qubes misc post-boot actions...
         Stopping RealtimeKit Scheduling Policy Service...
         Stopping Getty on tty1...
         Stopping Install ABRT coredump hook...
         Stopping Qubes remote exec agent...
         Stopping Job spooling tools...
         Stopping Session c1 of user user.
         Stopping ABRT kernel log watcher...
         Stopping Manage Sound Card State (restore and store)...
         Stopping Daemon for power management...
         Stopping Authorization Manager...
[.[0;32m  OK  .[0m] Stopped Periodically check for updates.
[.[0;32m  OK  .[0m] Unmounted /run/user/1000/gvfs.
[.[0;32m  OK  .[0m] Stopped Entropy Daemon based on the HAVEGE algorithm.
[.[0;32m  OK  .[0m] Stopped ABRT Automated Bug Reporting Tool.
[.[0;32m  OK  .[0m] Stopped D-Bus System Message Bus.
[.[0;32m  OK  .[0m] Stopped Serial Getty on hvc0.
[.[0;32m  OK  .[0m] Stopped Job spooling tools.
[.[0;32m  OK  .[0m] Stopped Getty on tty1.
[.[0;32m  OK  .[0m] Stopped ABRT kernel log watcher.
[.[0;32m  OK  .[0m] Stopped ABRT Xorg log watcher.
[.[0;32m  OK  .[0m] Stopped Qubes remote exec agent.
[.[0;32m  OK  .[0m] Stopped RealtimeKit Scheduling Policy Service.
[.[0;32m  OK  .[0m] Stopped Authorization Manager.
[.[0;32m  OK  .[0m] Stopped Daemon for power management.
[.[0;32m  OK  .[0m] Stopped Disk Manager.
[.[0;32m  OK  .[0m] Stopped CUPS Scheduler.
[.[0;32m  OK  .[0m] Unmounted RPC Pipe File System.
[.[0;32m  OK  .[0m] Stopped Restore /run/initramfs on shutdown.
[.[0;32m  OK  .[0m] Stopped Install ABRT coredump hook.
[.[0;32m  OK  .[0m] Stopped Manage Sound Card State (restore and store).
[.[0;32m  OK  .[0m] Stopped Qubes GUI Agent.
         Stopping Qubes memory information reporter...
         Stopping Xen driver domain device daemon...
[.[0;32m  OK  .[0m] Removed slice system-getty.slice.
[.[0;32m  OK  .[0m] Removed slice system-serial\x2dgetty.slice.
[.[0;32m  OK  .[0m] Stopped Qubes memory information reporter.
[.[0;32m  OK  .[0m] Stopped Xen driver domain device daemon.
[.[0;32m  OK  .[0m] Stopped Qubes misc post-boot actions.
[.[0;32m  OK  .[0m] Stopped User Manager for UID 1000.
[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (5s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (6s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (6s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (7s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (7s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (8s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (8s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (9s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (9s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (10s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (10s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (11s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (11s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (12s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (12s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (13s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (13s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (14s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (14s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (15s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (15s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (16s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (16s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (17s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (17s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (18s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (18s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (19s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (19s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (20s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (20s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (21s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (21s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (22s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (22s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (23s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (23s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (24s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (24s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (25s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (25s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (26s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (26s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (27s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (27s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (28s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (28s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (29s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (29s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (30s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (30s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (31s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (31s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (32s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (32s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (33s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (33s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (34s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (34s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (35s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (35s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (36s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (36s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (37s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (37s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (38s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (38s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (39s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (39s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (40s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (40s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (41s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (41s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (42s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (42s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (43s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (43s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (44s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (44s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (45s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (45s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (46s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (46s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (47s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (47s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (48s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (48s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (49s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (49s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (50s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (50s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (51s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (51s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (52s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (52s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (53s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (53s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (54s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (54s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (55s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (55s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (56s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (56s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (57s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (57s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (58s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (58s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (59s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (59s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (1min / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (1min / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (1min 1s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (1min 1s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (1min 2s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (1min 2s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (1min 3s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (1min 3s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (1min 4s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (1min 4s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c1 of user user (1min 5s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c1 of user user (1min 5s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c1 of user user (1min 6s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c1 of user user (1min 6s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c1 of user user (1min 7s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (1min 7s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (1min 8s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c1 of user user (1min 8s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (1min 9s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c1 of user user (1min 9s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 10s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 10s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 11s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 11s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c... user user (1min 12s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 12s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 13s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 13s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 14s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c... user user (1min 14s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c... user user (1min 15s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c... user user (1min 15s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c... user user (1min 16s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c... user user (1min 16s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 17s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 17s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 18s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 18s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c... user user (1min 19s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 19s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 20s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 20s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 21s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c... user user (1min 21s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c... user user (1min 22s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c... user user (1min 22s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c... user user (1min 23s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c... user user (1min 23s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 24s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 24s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 25s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 25s / 1min 30s)
.[K[     .[0;31m*.[0m] A stop job is running for Session c... user user (1min 26s / 1min 30s)
.[K[    .[0;31m*.[0;1;31m*.[0m] A stop job is running for Session c... user user (1min 26s / 1min 30s)
.[K[   .[0;31m*.[0;1;31m*.[0m.[0;31m*.[0m] A stop job is running for Session c... user user (1min 27s / 1min 30s)
.[K[  .[0;31m*.[0;1;31m*.[0m.[0;31m* .[0m] A stop job is running for Session c... user user (1min 27s / 1min 30s)
.[K[ .[0;31m*.[0;1;31m*.[0m.[0;31m*  .[0m] A stop job is running for Session c... user user (1min 28s / 1min 30s)
.[K[.[0;31m*.[0;1;31m*.[0m.[0;31m*   .[0m] A stop job is running for Session c... user user (1min 28s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c... user user (1min 29s / 1min 30s)
.[K[.[0m.[0;31m*     .[0m] A stop job is running for Session c... user user (1min 29s / 1min 30s)
.[K[.[0;1;31m*.[0m.[0;31m*    .[0m] A stop job is running for Session c1 of user user (1min 30s / 3min)[11605.748109] u2mfn_release, priv=          (null)

.[K[.[0;32m  OK  .[0m] Stopped Session c1 of user user.
[.[0;32m  OK  .[0m] Removed slice User Slice of user.
         Stopping Permit User Sessions...
         Stopping Login Service...
[.[0;32m  OK  .[0m] Stopped Login Service.
[.[0;32m  OK  .[0m] Stopped Permit User Sessions.
[.[0;32m  OK  .[0m] Stopped target Remote File Systems.
         Unmounting /home/user/gateway-nfs...
         Unmounting /rw/home/user/gateway-nfs...
[.[0;32m  OK  .[0m] Unmounted /home/user/gateway-nfs.
         Unmounting /home...
[.[0;32m  OK  .[0m] Unmounted /home.
[.[0;32m  OK  .[0m] Unmounted /rw/home/user/gateway-nfs.
[.[0;32m  OK  .[0m] Stopped target Remote File Systems (Pre).
[.[0;32m  OK  .[0m] Stopped target NFS client services.
         Stopping GSSAPI Proxy Daemon...
[.[0;32m  OK  .[0m] Stopped target Network.
         Unmounting /rw...
[.[0;32m  OK  .[0m] Unmounted /rw.
[.[0;32m  OK  .[0m] Stopped GSSAPI Proxy Daemon.
[.[0;32m  OK  .[0m] Stopped target Basic System.
[.[0;32m  OK  .[0m] Stopped target Slices.
[.[0;32m  OK  .[0m] Removed slice User and Session Slice.
[.[0;32m  OK  .[0m] Stopped target Sockets.
[.[0;32m  OK  .[0m] Closed CUPS Scheduler.
[.[0;32m  OK  .[0m] Closed D-Bus System Message Bus Socket.
[.[0;32m  OK  .[0m] Stopped target Paths.
[.[0;32m  OK  .[0m] Stopped CUPS Scheduler.
[.[0;32m  OK  .[0m] Stopped target System Initialization.
[.[0;32m  OK  .[0m] Stopped Setup Virtual Console.
[.[0;32m  OK  .[0m] Stopped target Encrypted Volumes.
         Stopping Update UTMP about System Boot/Shutdown...
[.[0;32m  OK  .[0m] Stopped Load legacy module configuration.
         Stopping Load/Save Random Seed...
[.[0;32m  OK  .[0m] Stopped Apply Kernel Variables.
[.[0;32m  OK  .[0m] Stopped Load Kernel Modules.
[.[0;32m  OK  .[0m] Stopped Forward Password Requests to Wall Directory Watch.
[.[0;32m  OK  .[0m] Stopped Dispatch Password Requests to Console Directory Watch.
[.[0;32m  OK  .[0m] Stopped Load/Save Random Seed.
[.[0;32m  OK  .[0m] Stopped Update UTMP about System Boot/Shutdown.
         Stopping Security Auditing Service...
[11606.275570] audit: type=1305 audit(1483815943.848:572): audit_pid=0 old=449 auid=4294967295 ses=4294967295 res=1
[.[0;32m  OK  .[0m] Stopped Security Auditing Service.
[11606.278764] audit: type=1131 audit(1483815943.851:573): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=auditd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[.[0;32m  OK  .[0m] Stopped Create Volatile Files and Directories.
[11606.279567] audit: type=1131 audit(1483815943.852:574): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[.[0;32m  OK  .[0m] Stopped target Local File Systems.
         Unmounting /usr/lib/modules/4.4.31-11.pvops.qubes.x86_64...
         Unmounting /run/user/1000...
[.[0;32m  OK  .[0m] Stopped Configure read-only root support.
[11606.297038] audit: type=1131 audit(1483815943.869:575): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=fedora-readonly comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
         Unmounting /var/spool/cron...
         Unmounting Temporary Directory...
[.[0;1;31mFAILED.[0m] Failed unmounting /usr/lib/modules/4.4.31-11.pvops.qubes.x86_64.
[.[0;32m  OK  .[0m] Unmounted /run/user/1000.
[.[0;32m  OK  .[0m] Unmounted Temporary Directory.
[.[0;32m  OK  .[0m] Stopped target Swap.
         Deactivating swap /dev/xvdc1...
[.[0;32m  OK  .[0m] Deactivated swap /dev/disk/by-uuid/...e5e-3115-4069-b92b-d2109011c2c1.
[.[0;32m  OK  .[0m] Deactivated swap /dev/disk/by-partuuid/a7462b99-01.
[.[0;32m  OK  .[0m] Deactivated swap /dev/xvdc1.
[.[0;32m  OK  .[0m] Unmounted /var/spool/cron.
[.[0;32m  OK  .[0m] Reached target Unmount All Filesystems.
[.[0;32m  OK  .[0m] Stopped target Local File Systems (Pre).
[.[0;32m  OK  .[0m] Stopped Remount Root and Kernel File Systems.
[11606.437304] audit: type=1131 audit(1483815944.010:576): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[.[0;32m  OK  .[0m] Stopped Create Static Device Nodes in /dev.
[11606.437951] audit: type=1131 audit(1483815944.010:577): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[.[0;32m  OK  .[0m] Reached target Shutdown.
[11606.510681] systemd-shutdown[1]: Sending SIGTERM to remaining processes...
[11606.513439] systemd-journald[185]: Received SIGTERM from PID 1 (systemd-shutdow).
[11606.533163] systemd-shutdown[1]: Sending SIGKILL to remaining processes...
[11606.534994] systemd-shutdown[1]: Unmounting file systems.
[11606.535212] systemd-shutdown[1]: Remounting '/usr/lib/modules/4.4.31-11.pvops.qubes.x86_64' read-only with options 'data=ordered'.
[11606.535267] EXT4-fs (xvdd): re-mounted. Opts: data=ordered
[11606.535288] systemd-shutdown[1]: Unmounting /usr/lib/modules/4.4.31-11.pvops.qubes.x86_64.
[11606.540726] systemd-shutdown[1]: Remounting '/' read-only with options 'data=ordered'.
[11606.559460] EXT4-fs (dm-0): re-mounted. Opts: data=ordered
[11606.560852] systemd-shutdown[1]: Remounting '/' read-only with options 'data=ordered'.
[11606.560903] EXT4-fs (dm-0): re-mounted. Opts: data=ordered
[11606.560920] systemd-shutdown[1]: Remounting '/' read-only with options 'data=ordered'.
[11606.560945] EXT4-fs (dm-0): re-mounted. Opts: data=ordered
[11606.560958] systemd-shutdown[1]: All filesystems unmounted.
[11606.560968] systemd-shutdown[1]: Deactivating swaps.
[11606.561066] systemd-shutdown[1]: All swaps deactivated.
[11606.561081] systemd-shutdown[1]: Detaching loop devices.
[11606.562498] systemd-shutdown[1]: All loop devices detached.
[11606.562509] systemd-shutdown[1]: Detaching DM devices.
[11606.562687] systemd-shutdown[1]: Not all DM devices detached, 1 left.
[11606.562752] systemd-shutdown[1]: Detaching DM devices.
[11606.562915] systemd-shutdown[1]: Not all DM devices detached, 1 left.
[11606.562923] systemd-shutdown[1]: Cannot finalize remaining DM devices, continuing.
[11606.586257] systemd-shutdown[1]: Failed to finalize  DM devices, ignoring
[11606.586314] systemd-shutdown[1]: Powering off.
[11606.611165] reboot: System halted
@dmoerner

This comment has been minimized.

Show comment
Hide comment
@dmoerner

dmoerner Jan 14, 2017

Hi,

Following up on this issue in https://groups.google.com/forum/#!topic/qubes-users/NSZEZD_k7KE, I have now hit this bug twice: A Fedora 25-based VM crashes, and I see this error in the console:

[   77.469369] U2MFN_GET_MFN_FOR_PAGE: get_user_pages failed, 
ret=0xfffffffffffffff2 

The first time I hit it, it was sys-net, and it just crashed.

The second time I hit it was with an appVM. I had no unusual apps running - just Chrome, Hexchat, and Gnome-Terminal. The crash hit as I repositioned gnome-terminal on the screen.

dmoerner commented Jan 14, 2017

Hi,

Following up on this issue in https://groups.google.com/forum/#!topic/qubes-users/NSZEZD_k7KE, I have now hit this bug twice: A Fedora 25-based VM crashes, and I see this error in the console:

[   77.469369] U2MFN_GET_MFN_FOR_PAGE: get_user_pages failed, 
ret=0xfffffffffffffff2 

The first time I hit it, it was sys-net, and it just crashed.

The second time I hit it was with an appVM. I had no unusual apps running - just Chrome, Hexchat, and Gnome-Terminal. The crash hit as I repositioned gnome-terminal on the screen.

marmarek added a commit to marmarek/old-qubes-gui-agent-linux that referenced this issue Jan 26, 2017

@dmoerner

This comment has been minimized.

Show comment
Hide comment
@dmoerner

dmoerner Feb 2, 2017

Hi, I ran into the crash again. Here is a full paste: https://paste.fedoraproject.org/543078/50253148/

This time, it hit a template VM. I was trying to drag the terminal around, and I dragged it to the edge, and it crashed as soon as xfce tried to make it full screen. (So it has now hit an appVM, a netVM, and a templateVM. For both the appVM and template VM the crash was triggered by moving around gnome-terminal.)

dmoerner commented Feb 2, 2017

Hi, I ran into the crash again. Here is a full paste: https://paste.fedoraproject.org/543078/50253148/

This time, it hit a template VM. I was trying to drag the terminal around, and I dragged it to the edge, and it crashed as soon as xfce tried to make it full screen. (So it has now hit an appVM, a netVM, and a templateVM. For both the appVM and template VM the crash was triggered by moving around gnome-terminal.)

@pdinoto

This comment has been minimized.

Show comment
Hide comment
@pdinoto

pdinoto Feb 2, 2017

I am having similar issues, but with a Debian 9 template (cloned from debian-8 and later updated).

Not sure if it is the same issue: In the past two months, AppVMs based on this template work fine until a concrete graphic action triggers lots of U2MFN_GET_MFN_FOR_PAGE: get_user_pages failed, ret=0xfffffffffffffff2 on the console. When this happens, all windows for that AppVM get closed. Attempting to open new ones, like gnome-terminal result in a brief display of the window and then dissapear. Applications are running, I can shutdown the AppVM from the console.

So far, graphical actions that could trigger the crash are resizing a terminal windown (just before the crash, there are color lines and artifacts on the screen), or opening an existing spreadsheet on LibreOffice (the window is opened, a partial draw of its contents is shown, then window disappear).

As this has concrete GUI impact and is on a different template, I created an specific issue

pdinoto commented Feb 2, 2017

I am having similar issues, but with a Debian 9 template (cloned from debian-8 and later updated).

Not sure if it is the same issue: In the past two months, AppVMs based on this template work fine until a concrete graphic action triggers lots of U2MFN_GET_MFN_FOR_PAGE: get_user_pages failed, ret=0xfffffffffffffff2 on the console. When this happens, all windows for that AppVM get closed. Attempting to open new ones, like gnome-terminal result in a brief display of the window and then dissapear. Applications are running, I can shutdown the AppVM from the console.

So far, graphical actions that could trigger the crash are resizing a terminal windown (just before the crash, there are color lines and artifacts on the screen), or opening an existing spreadsheet on LibreOffice (the window is opened, a partial draw of its contents is shown, then window disappear).

As this has concrete GUI impact and is on a different template, I created an specific issue

@dmoerner

This comment has been minimized.

Show comment
Hide comment
@dmoerner

dmoerner Feb 2, 2017

This bug is hard to reproduce for me. I just hit it twice more within twenty minutes with a Fedora 25 template, but I still can't reproduce it at all reliably.

Both crashes occurred after trying out i3 in dom0. One time, I was able to cause the crash by opening up two windows from the same appVM in tiling mode, and then holding down Mod1+j. But now I can't reproduce this. The second time, it just crashed a few minutes after starting - I was in another workspace entirely at the time.

dmoerner commented Feb 2, 2017

This bug is hard to reproduce for me. I just hit it twice more within twenty minutes with a Fedora 25 template, but I still can't reproduce it at all reliably.

Both crashes occurred after trying out i3 in dom0. One time, I was able to cause the crash by opening up two windows from the same appVM in tiling mode, and then holding down Mod1+j. But now I can't reproduce this. The second time, it just crashed a few minutes after starting - I was in another workspace entirely at the time.

@marmarek

This comment has been minimized.

Show comment
Hide comment
@marmarek

marmarek Feb 2, 2017

Member
Member

marmarek commented Feb 2, 2017

@emdete

This comment has been minimized.

Show comment
Hide comment
@emdete

emdete Feb 15, 2017

i think this is a dublicate of #2617.

emdete commented Feb 15, 2017

i think this is a dublicate of #2617.

@andrewdavidwong

This comment has been minimized.

Show comment
Hide comment
@andrewdavidwong

andrewdavidwong Feb 20, 2017

Member

i think this is a dublicate of #2617.

The whole ticket? If so, why?

Member

andrewdavidwong commented Feb 20, 2017

i think this is a dublicate of #2617.

The whole ticket? If so, why?

@taradiddles

This comment has been minimized.

Show comment
Hide comment
@taradiddles

taradiddles May 28, 2017

I've been using f25 for 2 weeks or so (f24-minimal distro sync'ed to f25, fully updated with repo qubes-vm-r3.2-current-testing enabled). Until now I've encountered the following problems:

  • couldn't install tinyproxy and some other packages ( issue #2606 - looks like Marek fixed it). Workaround: install the packages manually.

  • tinyproxy in sys-net stops (crashes?) after some time ; journalctl doesn't show anything and nothing in the logs either - I'll try to investigate that. Workaround: systemctl restart qubes-updates-proxy.service when needed.

  • sudo dnf install virt-manager fails with

"none of the providers can be installed
(try to add '--allowerasing' to command line to replace conflicting packages)"

dnf --allowerasing would downgrade xen-libs and remove most of qubes-* rpms.

I've been using f25 for 2 weeks or so (f24-minimal distro sync'ed to f25, fully updated with repo qubes-vm-r3.2-current-testing enabled). Until now I've encountered the following problems:

  • couldn't install tinyproxy and some other packages ( issue #2606 - looks like Marek fixed it). Workaround: install the packages manually.

  • tinyproxy in sys-net stops (crashes?) after some time ; journalctl doesn't show anything and nothing in the logs either - I'll try to investigate that. Workaround: systemctl restart qubes-updates-proxy.service when needed.

  • sudo dnf install virt-manager fails with

"none of the providers can be installed
(try to add '--allowerasing' to command line to replace conflicting packages)"

dnf --allowerasing would downgrade xen-libs and remove most of qubes-* rpms.

@marmarek

This comment has been minimized.

Show comment
Hide comment
@marmarek

marmarek Jun 2, 2017

Member

couldn't install tinyproxy and some other package

Another workaround: install the package specifying exact version, or a part of it: sudo dnf install tinyproxy-1*

tinyproxy in sys-net stops (crashes?) after some time ; journalctl doesn't show anything and nothing in the logs either - I'll try to investigate that. Workaround: systemctl restart qubes-updates-proxy.service when needed.

When it crashed, what is the service status?

sudo dnf install virt-manager fails with

I'm afraid it isn't solvable right now, at least not easily. We have newer Xen libraries than upstream Fedora and packages linked with older one are not compatible with Qubes VM. And Fedora (unlike Debian) does not allow to install multiple versions of library packages.
You may try the same on Debian.

Member

marmarek commented Jun 2, 2017

couldn't install tinyproxy and some other package

Another workaround: install the package specifying exact version, or a part of it: sudo dnf install tinyproxy-1*

tinyproxy in sys-net stops (crashes?) after some time ; journalctl doesn't show anything and nothing in the logs either - I'll try to investigate that. Workaround: systemctl restart qubes-updates-proxy.service when needed.

When it crashed, what is the service status?

sudo dnf install virt-manager fails with

I'm afraid it isn't solvable right now, at least not easily. We have newer Xen libraries than upstream Fedora and packages linked with older one are not compatible with Qubes VM. And Fedora (unlike Debian) does not allow to install multiple versions of library packages.
You may try the same on Debian.

@taradiddles

This comment has been minimized.

Show comment
Hide comment
@taradiddles

taradiddles Jun 2, 2017

When it crashed, what is the service status?

Actually it's not crashing: when suspending the laptop, something likely related to a change of hostname when the network interfaces are stopped triggers nm-dispatch; however it does this 4-5 times in a row in 1 second or so and systemd gives up on qubes-updates-proxy because it's restarted too quickly (by the qubes-nmhook dispatcher.d script).

log (pastebin link, github doesn't like the file):

I can try to investigate that further more if the cause is not directly obvious to you.

sudo dnf install virt-manager fails with

I'm afraid it isn't solvable right now

I figured that out :)
For now I just switch to a f24 template when I need to use virt-manager every now and then.

When it crashed, what is the service status?

Actually it's not crashing: when suspending the laptop, something likely related to a change of hostname when the network interfaces are stopped triggers nm-dispatch; however it does this 4-5 times in a row in 1 second or so and systemd gives up on qubes-updates-proxy because it's restarted too quickly (by the qubes-nmhook dispatcher.d script).

log (pastebin link, github doesn't like the file):

I can try to investigate that further more if the cause is not directly obvious to you.

sudo dnf install virt-manager fails with

I'm afraid it isn't solvable right now

I figured that out :)
For now I just switch to a f24 template when I need to use virt-manager every now and then.

@brycepg

This comment has been minimized.

Show comment
Hide comment
@brycepg

brycepg Jul 27, 2017

Fedora 24 EOLs really soon. Is the Fedora 25 template ready?

brycepg commented Jul 27, 2017

Fedora 24 EOLs really soon. Is the Fedora 25 template ready?

@marmarek

This comment has been minimized.

Show comment
Hide comment
@marmarek

marmarek Jul 27, 2017

Member

Fedora 25 template already available in repository:

sudo qubes-dom0-update qubes-template-fedora-25
Member

marmarek commented Jul 27, 2017

Fedora 25 template already available in repository:

sudo qubes-dom0-update qubes-template-fedora-25
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment