Screen blanks while computer is in use, but user input can redraw the screen

andrewdavidwong commented 7 years ago

Qubes OS version (e.g., `R3.1`):

R3.2

Description:

Issue separately reported by two users:

I'm encountering seemingly random screen blanking while I'm using Qubes 3.2 (updated from a fresh install of rc3). The screen will blank and momentarily show the logon. Yet if I move the mouse or use the keyboard only the active window will show. Changing desktops, clicking on other windows, or moving the active window around will redraw the rest of the screen.

I never had this issue on this hardware with R3 or R3.1. I'm running dual monitors off an nVidia GTX 560 Ti. The screensaver is set to blank the screen and require a login. That's the screen that keeps popping up. Sometimes it gets so frequent that I need to reboot the system and the problem will go away for a while.

On 2016-10-26 05:43, John Maher wrote:

I'm getting the strangest thing on my screen. I'll be working and the XScreenSaver dialog pops up (indicating the screen is locked) and the screen goes black. However, the screen is not locked. I have to move a window around to redraw my screen. This has always happened since I started using Qubes about 3 weeks ago. There appears to be no pattern that prompts this response. Bizarre! Any thoughts?

andrewdavidwong commented 7 years ago

zby commented 7 years ago

I am also experiencing this. A screenshot attached. It looks like this happens most on heavy used workspaces - that is workspaces where I have Firefox with lots of tabs. screenshot_2016-12-04_16-18-18

andrewdavidwong commented 7 years ago

Thanks for the screenshot, @zby. That's helpful.

StevenLColeman42 commented 7 years ago

I have to report the same problem. First it was the xlockmore which I deleted off the system and it just switched to another screen lock program. Its blanking the dual monitor system but not actually locking anything. I have been turning off and deactivating and even removing all screen lock/saver programs but nothing seems to help.

If i use the desktop pager it forces a refresh and clears the screen, momentarily, and it just blanks it again in about five seconds. Moving any graphic components or the mouse clear the screen where it gets redrawn, which is why the pager works becaus that forces a complete refresh. I play whack-a-mole for a while, and it's ok for a while, and then its back again, over and over. Just writing this note it blanked about ten times or more. Often I can't even clear the screen fast enough to keep up.

andrewdavidwong commented 7 years ago

Additional user report: https://groups.google.com/d/msgid/qubes-users/43c06cd1-526e-4849-a258-512927f49401%40googlegroups.com

ghost commented 7 years ago

@andrewdavidwong I no longer experience this issue, was it solved?

andrewdavidwong commented 7 years ago

@e5f3c2ea895af0f27667: I'm not aware of any specific fix for this. Perhaps as a byproduct of something else?

StevenLColeman42 commented 7 years ago

I read your comment this morning and I was going to respond and say I had not seen this in a while, but then it just happened once just a few minutes ago. What I was doing at the time was editing in my fedora-24 template VM and exploring dnf package exclusion configuration, and was inactive in that template vm for a few minutes while reading some dnf documentation in a vm that has internet access enabled.

My suspicion is that some screen saver in one or more VM's (e.g. fedora-24) goes into screen-saver mode and somehow sends the blanking "image" through to the Qubes GUI for display, but is not then capable of actually locking the physical screen/keyboard, because its dom0 that has that responsibility. I don't have sufficient knowledge of the qubes/Xen architecture to chase that sequence of events but attached the fc24 template vm log file in case you might notice something funny. It has not happened since I shut down that specific vm (normally it repeats many times), and I will be paying more attention to this/any association going forward.

I did have several other vms based on that template open without any issue for weeks at a time, but it may be that installing some software in that template vm set up some service that does not run in the vms using that template. Lately I have been forced to get creative with installing software generically in the template but having only certain targeted vm's running that software.

On Tue, Jan 17, 2017 at 8:18 AM, Andrew David Wong <notifications@github.com

wrote:

@e5f3c2ea895af0f27667 https://github.com/e5f3c2ea895af0f27667: I'm not aware of any specific fix for this. Perhaps as a byproduct of something else?

— You are receiving this because you commented. Reply to this email directly, view it on GitHub https://github.com/QubesOS/qubes-issues/issues/2399#issuecomment-273152138, or mute the thread https://github.com/notifications/unsubscribe-auth/AT8Ghd7Kw6G57wVilrB9Zd1w4hF_fp-jks5rTL-0gaJpZM4Kh7_A .

[ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Linux version 4.4.38-11.pvops.qubes.x86_64 (user@release) (gcc version 5.3.1 20160406 (Red Hat 5.3.1-6) (GCC) ) #1 SMP Mon Dec 12 23:24:39 UTC 2016 [ 0.000000] Command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH rd.plymouth.enable=0 plymouth.enable=0 nopat

[ 0.000000] x86/fpu: Supporting XSAVE feature 0x01: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x02: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x04: 'AVX registers' [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] x86/fpu: Using 'eager' FPU context switches. [ 0.000000] ACPI in unprivileged domain disabled [ 0.000000] Released 0 page(s) [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] Xen: [mem 0x0000000000000000-0x000000000009ffff] usable [ 0.000000] Xen: [mem 0x00000000000a0000-0x00000000000fffff] reserved [ 0.000000] Xen: [mem 0x0000000000100000-0x00000000f9ffffff] usable [ 0.000000] x86/PAT: PAT support disabled. [ 0.000000] x86/PAT: Configuration [0-7]: WB WT UC- UC WC WP UC UC
[ 0.000000] NX (Execute Disable) protection: active [ 0.000000] DMI not present or invalid. [ 0.000000] Hypervisor detected: Xen [ 0.000000] e820: last_pfn = 0xfa000 max_arch_pfn = 0x400000000 [ 0.000000] MTRR: Disabled [ 0.000000] RAMDISK: [mem 0x02057000-0x02b17fff] [ 0.000000] NUMA turned off [ 0.000000] Faking a node at [mem 0x0000000000000000-0x00000000f9ffffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x18839000-0x1884afff] [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000f9ffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009ffff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000f9ffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x00000000f9ffffff] [ 0.000000] p2m virtual area at ffffc90000000000, size is 800000 [ 0.000000] Remapped 0 page(s) [ 0.000000] SFI: Simple Firmware Interface v0.81 http://simplefirmware.org [ 0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs [ 0.000000] e820: [mem 0xfa000000-0xffffffff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on Xen [ 0.000000] Xen version: 4.6.3 (preserve-AD) [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 34 pages/cpu @ffff880013e00000 s98392 r8192 d32680 u1048576 [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes) [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 1007882 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH rd.plymouth.enable=0 plymouth.enable=0 nopat [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] Memory: 299196K/4095612K available (7543K kernel code, 1249K rwdata, 3412K rodata, 1532K init, 1472K bss, 3796416K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] Build-time adjustment of leaf fanout to 64. [ 0.000000] RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=2. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=2 [ 0.000000] Using NULL legacy PIC [ 0.000000] NR_IRQS:4352 nr_irqs:48 0 [ 0.000000] xen:events: Using FIFO-based ABI [ 0.000000] Offload RCU callbacks from all CPUs [ 0.000000] Offload RCU callbacks from CPUs: 0-1. [ 0.000000] Console: colour dummy device 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] console [hvc0] enabled [ 0.000000] clocksource: xen: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] installing Xen timer for CPU 0 [ 0.000000] tsc: Detected 3392.428 MHz processor [ 0.001000] Calibrating delay loop (skipped), value calculated using timer frequency.. 6784.85 BogoMIPS (lpj=3392428) [ 0.001000] pid_max: default: 32768 minimum: 301 [ 0.001000] Security Framework initialized [ 0.001000] AppArmor: AppArmor disabled by boot time parameter [ 0.001488] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes) [ 0.003469] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes) [ 0.004280] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.004327] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.004849] Initializing cgroup subsys io [ 0.004870] Initializing cgroup subsys memory [ 0.004896] Initializing cgroup subsys devices [ 0.004913] Initializing cgroup subsys freezer [ 0.004929] Initializing cgroup subsys net_cls [ 0.004944] Initializing cgroup subsys perf_event [ 0.004960] Initializing cgroup subsys net_prio [ 0.004978] Initializing cgroup subsys hugetlb [ 0.004994] Initializing cgroup subsys pids [ 0.005110] ENERGY_PERF_BIAS: Set to 'normal', was 'performance' [ 0.005126] ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8) [ 0.005145] CPU: Physical Processor ID: 0 [ 0.005155] CPU: Processor Core ID: 0 [ 0.005173] Last level iTLB entries: 4KB 512, 2MB 8, 4MB 8 [ 0.005185] Last level dTLB entries: 4KB 512, 2MB 32, 4MB 32, 1GB 0 [ 0.025696] ftrace: allocating 28748 entries in 113 pages [ 0.031068] cpu 0 spinlock event irq 1 [ 0.031078] Could not initialize VPMU for cpu 0, error -95 [ 0.031115] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only. [ 0.031581] NMI watchdog: disabled (cpu0): hardware events not enabled [ 0.031586] NMI watchdog: Shutting down hard lockup detector on all cpus [ 0.031671] SMP alternatives: switching to SMP code [ 0.047820] installing Xen timer for CPU 1 [ 0.047842] cpu 1 spinlock event irq 8 [ 0.048064] x86: Booted up 1 node, 2 CPUs [ 0.048180] devtmpfs: initialized [ 0.052565] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.052565] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 0.052565] pinctrl core: initialized pinctrl subsystem [ 0.072835] RTC time: 165:165:165, date: 165/165/65 [ 0.072943] NET: Registered protocol family 16 [ 0.072956] xen:grant_table: Grant tables using version 1 layout [ 0.072965] Grant table initialized [ 0.073388] PCI: setting up Xen PCI frontend stub [ 0.076094] ACPI: Interpreter disabled. [ 0.076094] xen:balloon: Initialising balloon driver [ 0.124016] xen_balloon: Initialising balloon driver [ 0.124024] vgaarb: loaded [ 0.124094] SCSI subsystem initialized [ 0.124110] usbcore: registered new interface driver usbfs [ 0.124110] usbcore: registered new interface driver hub [ 0.124110] usbcore: registered new device driver usb [ 0.124110] dmi: Firmware registration failed. [ 0.124110] PCI: System does not support PCI [ 0.124110] PCI: System does not support PCI [ 0.124110] NetLabel: Initializing [ 0.124110] NetLabel: domain hash size = 128 [ 0.124110] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.124120] NetLabel: unlabeled traffic allowed by default [ 0.124169] amd_nb: Cannot enumerate AMD northbridges [ 0.124187] clocksource: Switched to clocksource xen [ 0.128745] pnp: PnP ACPI: disabled [ 0.130645] NET: Registered protocol family 2 [ 0.130784] TCP established hash table entries: 32768 (order: 6, 262144 bytes) [ 0.130879] TCP bind hash table entries: 32768 (order: 7, 524288 bytes) [ 0.130935] TCP: Hash tables configured (established 32768 bind 32768) [ 0.130956] UDP hash table entries: 2048 (order: 4, 65536 bytes) [ 0.130975] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes) [ 0.131020] NET: Registered protocol family 1 [ 0.131070] Unpacking initramfs... [ 0.138842] Freeing initrd memory: 11012K (ffff880002057000 - ffff880002b18000) [ 0.194346] RAPL PMU detected, API unit is 2^-32 Joules, 3 fixed counters 163840 ms ovfl timer [ 0.194377] hw unit of domain pp0-core 2^-16 Joules [ 0.194391] hw unit of domain package 2^-16 Joules [ 0.194395] hw unit of domain pp1-gpu 2^-16 Joules [ 0.195193] futex hash table entries: 512 (order: 3, 32768 bytes) [ 0.195228] audit: initializing netlink subsys (disabled) [ 0.195243] audit: type=2000 audit(1484602650.403:1): initialized [ 0.195429] Initialise system trusted keyring [ 0.196536] zbud: loaded [ 0.196719] VFS: Disk quotas dquot_6.6.0 [ 0.196747] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.196942] hugetlbfs: disabling because there are no supported hugepage sizes [ 0.197047] Key type big_key registered [ 0.200659] NET: Registered protocol family 38 [ 0.200669] Key type asymmetric registered [ 0.200673] Asymmetric key parser 'x509' registered [ 0.200704] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) [ 0.200766] io scheduler noop registered [ 0.200773] io scheduler deadline registered [ 0.200801] io scheduler cfq registered (default) [ 0.201012] xen:xen_evtchn: Event-channel device installed [ 0.201424] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.201790] Non-volatile memory driver v1.3 [ 0.201830] Linux agpgart interface v0.103 [ 0.202100] libphy: Fixed MDIO Bus: probed [ 0.202161] usbcore: registered new interface driver usbserial [ 0.202169] usbcore: registered new interface driver usbserial_generic [ 0.202177] usbserial: USB Serial support registered for generic [ 0.202194] i8042: PNP: No PS/2 controller found. Probing ports directly. [ 1.211445] i8042: No controller found [ 1.211479] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x30e65e02791, max_idle_ns: 440795344677 ns [ 1.211722] mousedev: PS/2 mouse device common for all mice [ 1.211836] device-mapper: uevent: version 1.0.3 [ 1.211950] device-mapper: ioctl: 4.34.0-ioctl (2015-10-28) initialised: dm-devel@redhat.com [ 1.212017] dmi-sysfs: dmi entry is absent. [ 1.212041] hidraw: raw HID events driver (C) Jiri Kosina [ 1.212081] usbcore: registered new interface driver usbhid [ 1.212085] usbhid: USB HID core driver [ 1.212136] drop_monitor: Initializing network drop monitor service [ 1.212191] ip_tables: (C) 2000-2006 Netfilter Core Team [ 1.212299] Initializing XFRM netlink socket [ 1.212394] NET: Registered protocol family 10 [ 1.212530] mip6: Mobile IPv6 [ 1.212536] NET: Registered protocol family 17 [ 1.212545] mce: Unable to init device /dev/mcelog (rc: -5) [ 1.212600] AVX version of gcm_enc/dec engaged. [ 1.212603] AES CTR mode by8 optimization enabled [ 1.244259] registered taskstats version 1 [ 1.244284] Loading compiled-in X.509 certificates [ 1.244307] zswap: loaded using pool lzo/zbud [ 1.244343] xenbus_probe_frontend: Device with no driver: device/vbd/51712 [ 1.244348] xenbus_probe_frontend: Device with no driver: device/vbd/51728 [ 1.244351] xenbus_probe_frontend: Device with no driver: device/vbd/51744 [ 1.244355] xenbus_probe_frontend: Device with no driver: device/vbd/51760 [ 1.244358] xenbus_probe_frontend: Device with no driver: device/vif/0 [ 1.244407] Magic number: 1:252:3141 [ 1.244444] hctosys: unable to open rtc device (rtc0) [ 1.244900] Freeing unused kernel memory: 1532K (ffffffff81d3a000 - ffffffff81eb9000) [ 1.244907] Write protecting the kernel read-only data: 12288k [ 1.251474] Freeing unused kernel memory: 636K (ffff880001761000 - ffff880001800000) [ 1.251905] Freeing unused kernel memory: 684K (ffff880001b55000 - ffff880001c00000) Qubes initramfs script here: [ 1.257372] random: modprobe: uninitialized urandom read (8 bytes read, 22 bits of entropy available) [ 1.318774] blkfront: xvda: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled; [ 1.335840] blkfront: xvdb: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled; [ 1.368384] blkfront: xvdc: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled; [ 1.392007] xvdc: xvdc1 [ 1.393686] blkfront: xvdd: barrier or flush: disabled; persistent grants: enabled; indirect descriptors: enabled; Waiting for /dev/xvda* devices... [ 1.505673] random: cat: uninitialized urandom read (8 bytes read, 36 bits of entropy available) Qubes: Doing R/W setup for TemplateVM... [ 1.509966] xvdc: xvdc1 [ 1.510252] random: sfdisk: uninitialized urandom read (4 bytes read, 36 bits of entropy available) [ 1.510774] xvdc: xvdc1 [ 1.553755] random: mkswap: uninitialized urandom read (8 bytes read, 36 bits of entropy available) Setting up swapspace version 1, size = 1073737728 bytes [ 1.554307] random: mkswap: uninitialized urandom read (16 bytes read, 37 bits of entropy available) UUID=1b175cea-2b32-44e0-a5b8-db39386f3302 [ 1.595483] random: cat: uninitialized urandom read (8 bytes read, 37 bits of entropy available) Qubes: done. [ 1.606389] random: modprobe: uninitialized urandom read (8 bytes read, 37 bits of entropy available) modprobe: module ext4 not found in modules.dep [ 1.607798] random: mkdir: uninitialized urandom read (8 bytes read, 37 bits of entropy available) [ 1.608780] random: mount: uninitialized urandom read (8 bytes read, 37 bits of entropy available) [ 1.609143] EXT4-fs (dm-0): couldn't mount as ext3 due to feature incompatibilities [ 1.609290] EXT4-fs (dm-0): couldn't mount as ext2 due to feature incompatibilities [ 1.610881] EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null) [ 1.611953] random: uname: uninitialized urandom read (8 bytes read, 39 bits of entropy available) Waiting for /dev/xvdd device... [ 1.636560] EXT4-fs (xvdd): mounting ext3 file system using the ext4 subsystem [ 1.647398] EXT4-fs (xvdd): mounted filesystem with ordered data mode. Opts: (null) [ 1.914288] 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) [ 1.914385] systemd[1]: Detected virtualization xen. [ 1.914402] systemd[1]: Detected architecture x86-64.

Welcome to .[0;34mFedora 24 (Workstation Edition).[0m!

[ 1.921912] systemd[1]: No hostname configured. [ 1.921933] systemd[1]: Set hostname to . [ 2.430793] systemd[1]: Listening on Device-mapper event daemon FIFOs. [.[0;32m OK .[0m] Listening on Device-mapper event daemon FIFOs. [ 2.431153] systemd[1]: Listening on LVM2 metadata daemon socket. [.[0;32m OK .[0m] Listening on LVM2 metadata daemon socket. [ 2.431401] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [.[0;32m OK .[0m] Started Dispatch Password Requests to Console Directory Watch. [ 2.431622] systemd[1]: Listening on udev Control Socket. [.[0;32m OK .[0m] Listening on udev Control Socket. [ 2.431883] systemd[1]: Listening on Journal Audit Socket. [.[0;32m OK .[0m] Listening on Journal Audit Socket. [ 2.432198] systemd[1]: Listening on RPCbind Server Activation Socket. [.[0;32m OK .[0m] Listening on RPCbind Server Activation Socket. [ 2.432434] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [.[0;32m OK .[0m] Started Forward Password Requests to Wall Directory Watch. [ 2.433352] systemd[1]: Created slice User and Session Slice. [.[0;32m OK .[0m] Created slice User and Session Slice. [ 2.434742] systemd[1]: Listening on Process Core Dump Socket. [.[0;32m OK .[0m] Listening on Process Core Dump Socket. [ 2.434964] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe. [.[0;32m OK .[0m] Listening on /dev/initctl Compatibility Named Pipe. [ 2.435118] systemd[1]: Reached target RPC Port Mapper. [.[0;32m OK .[0m] Reached target RPC Port Mapper. [ 2.435267] systemd[1]: Listening on LVM2 poll daemon socket. [.[0;32m OK .[0m] Listening on LVM2 poll daemon socket. [ 2.435472] systemd[1]: Listening on Journal Socket. [.[0;32m OK .[0m] Listening on Journal Socket. [ 2.435657] systemd[1]: Listening on udev Kernel Socket. [.[0;32m OK .[0m] Listening on udev Kernel Socket. [ 2.435815] systemd[1]: Listening on Journal Socket (/dev/log). [.[0;32m OK .[0m] Listening on Journal Socket (/dev/log). [ 2.436191] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. [.[0;32m OK .[0m] Set up automount Arbitrary Executab...ats File System Automount Point. [ 2.436542] systemd[1]: Created slice System Slice. [.[0;32m OK .[0m] Created slice System Slice. [ 2.454433] systemd[1]: Starting Load Kernel Modules... Starting Load Kernel Modules... [ 2.456601] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ 2.456825] systemd[1]: Reached target Slices. [.[0;32m OK .[0m] Reached target Slices. [ 2.485319] systemd[1]: Starting Set Up Additional Binary Formats... Starting Set Up Additional Binary Formats... [ 2.561453] systemd[1]: Starting Load legacy module configuration... Starting Load legacy module configuration... [ 2.563882] systemd[1]: Starting Create list of required static device nodes for the current kernel... Starting Create list of required st... nodes for the current kernel... [ 2.660470] systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. [ 2.669243] systemd[1]: Mounting Temporary Directory... Mounting Temporary Directory... [ 2.669873] systemd[1]: Created slice system-getty.slice. [.[0;32m OK .[0m] Created slice system-getty.slice. [ 2.672299] systemd[1]: Starting Setup Virtual Console... Starting Setup Virtual Console... [ 2.684774] systemd[1]: Starting Journal Service... Starting Journal Service... [ 2.686531] systemd[1]: Created slice system-serial\x2dgetty.slice. [.[0;32m OK .[0m] Created slice system-serial\x2dgetty.slice. [ 2.690742] systemd[1]: Mounting Debug File System... Mounting Debug File System... [ 2.706176] systemd[1]: Starting File System Check on Root Device... Starting File System Check on Root Device... [ 2.707160] systemd[1]: Starting Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling... Starting Monitoring of LVM2 mirrors... dmeventd or progress polling... [ 2.708145] systemd[1]: Mounting /proc/xen... Mounting /proc/xen... [ 2.709948] systemd[1]: Mounted POSIX Message Queue File System. [.[0;32m OK .[0m] Mounted POSIX Message Queue File System. [ 2.710027] systemd[1]: Mounted Debug File System. [.[0;32m OK .[0m] Mounted Debug File System. [ 2.710092] systemd[1]: Mounted Temporary Directory. [.[0;32m OK .[0m] Mounted Temporary Directory. [ 2.710520] systemd[1]: Started Setup Virtual Console. [.[0;32m OK .[0m] Started Setup Virtual Console. [ 2.712521] systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 173 (systemd-binfmt) [ 2.747238] systemd[1]: Mounting Arbitrary Executable File Formats File System... Mounting Arbitrary Executable File Formats File System... [ 2.818369] systemd[1]: Started LVM2 metadata daemon. [.[0;32m OK .[0m] Started LVM2 metadata daemon. [ 2.818636] audit: type=1130 audit(1484602653.026:2): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=lvm2-lvmetad comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 2.831495] systemd[1]: Started Journal Service. [.[0;32m OK .[0m] Started Journal Service. [ 2.831686] audit: type=1130 audit(1484602653.039:3): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [.[0;32m OK .[0m] Started Create list of required sta...ce nodes for the current kernel. [ 2.856195] audit: type=1130 audit(1484602653.064:4): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [.[0;32m OK .[0m] Started Load legacy module configuration. [ 2.919550] audit: type=1130 audit(1484602653.127:5): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=fedora-loadmodules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [.[0;32m OK .[0m] Mounted Arbitrary Executable File Formats File System. [.[0;32m OK .[0m] Mounted /proc/xen. [.[0;32m OK .[0m] Started Set Up Additional Binary Formats. [ 3.074582] audit: type=1130 audit(1484602653.282:6): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-binfmt comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [.[0;32m OK .[0m] Started Monitoring of LVM2 mirrors,...ng dmeventd or progress polling. [ 3.163061] audit: type=1130 audit(1484602653.371:7): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=lvm2-monitor comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 3.452788] dummy_hcd dummy_hcd.0: USB Host+Gadget Emulator, driver 02 May 2005 [ 3.452811] dummy_hcd dummy_hcd.0: Dummy host controller [ 3.452922] dummy_hcd dummy_hcd.0: new USB bus registered, assigned bus number 1 [ 3.453075] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 [ 3.453087] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 3.453100] usb usb1: Product: Dummy host controller [ 3.453108] usb usb1: Manufacturer: Linux 4.4.38-11.pvops.qubes.x86_64 dummy_hcd [ 3.453124] usb usb1: SerialNumber: dummy_hcd.0 [ 3.454158] hub 1-0:1.0: USB hub found [ 3.454180] hub 1-0:1.0: 1 port detected [.[0;32m OK .[0m] Started Load Kernel Modules. [ 3.456484] audit: type=1130 audit(1484602653.664:8): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Mounting Configuration File System... Starting Apply Kernel Variables... Starting Qubes DB agent... [.[0;32m OK .[0m] Mounted Configuration File System. [.[0;32m OK .[0m] Started File System Check on Root Device. [ 3.555342] audit: type=1130 audit(1484602653.763:9): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting Remount Root and Kernel File Systems... [ 3.718386] EXT4-fs (dm-0): re-mounted. Opts: (null) [.[0;32m OK .[0m] Started Remount Root and Kernel File Systems. [ 3.720710] audit: type=1130 audit(1484602653.928:10): 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' Starting udev Coldplug all Devices... Starting Configure read-only root support... Starting Create Static Device Nodes in /dev... Starting Flush Journal to Persistent Storage... [.[0;32m OK .[0m] Started Apply Kernel Variables. [.[0;32m OK .[0m] Started Qubes DB agent. [ 3.915297] systemd-journald[184]: Received request to flush runtime journal from PID 1 Starting Init Qubes Services settings... [.[0;32m OK .[0m] Started udev Coldplug all Devices. Starting udev Wait for Complete Device Initialization... [.[0;32m OK .[0m] Started Configure read-only root support. [.[0;32m OK .[0m] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... Starting Load/Save Random Seed... [.[0;32m OK .[0m] Started Load/Save Random Seed. [.[0;32m OK .[0m] Started Init Qubes Services settings. Starting Initialize and mount /rw and /home... [ 4.732205] random: nonblocking pool is initialized [ 6.176820] EXT4-fs (xvdb): mounted filesystem with ordered data mode. Opts: discard [.[0;32m OK .[0m] Started udev Kernel Device Manager. [ 7.889466] audit_printk_skb: 21 callbacks suppressed [ 7.889483] audit: type=1130 audit(1484602658.097:18): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [.[0;32m OK .[0m] Found device /dev/hvc0. [.[0;32m OK .[0m] Found device /dev/xvdc1. Activating swap /dev/xvdc1... [ 9.138520] xen_netfront: Initialising Xen virtual ethernet driver [ 9.244609] input: PC Speaker as /devices/platform/pcspkr/input/input0 [ 9.342831] intel_rapl: Found RAPL domain package [ 9.342848] intel_rapl: Found RAPL domain core [ 9.342857] intel_rapl: Found RAPL domain uncore [ 9.342872] intel_rapl: RAPL package 0 domain package locked by BIOS [ 9.481943] Adding 1048572k swap on /dev/xvdc1. Priority:-1 extents:1 across:1048572k SSFS [.[0;32m OK .[0m] Activated swap /dev/xvdc1. [.[0;32m OK .[0m] Reached target Swap. [.[0;32m OK .[0m] Started Initialize and mount /rw and /home. [ 9.704367] audit: type=1130 audit(1484602659.912:19): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=qubes-mount-dirs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [.[0;32m OK .[0m] Started Flush Journal to Persistent Storage. [ 9.969127] audit: type=1130 audit(1484602660.177:20): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [.[0;32m OK .[0m] Started udev Wait for Complete Device Initialization. [ 11.169569] audit: type=1130 audit(1484602661.377:21): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=systemd-udev-settle comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Starting Activation of DM RAID sets... [.[0;32m OK .[0m] Started Activation of DM RAID sets. [ 11.229272] audit: type=1130 audit(1484602661.437:22): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=dmraid-activation comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 11.229334] audit: type=1131 audit(1484602661.437:23): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=dmraid-activation comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [.[0;32m OK .[0m] Reached target Encrypted Volumes. [.[0;32m OK .[0m] Reached target Local File Systems (Pre). [.[0;32m OK .[0m] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Restore /run/initramfs on shutdown... Starting Early Qubes VM settings... [.[0;32m OK .[0m] Started Restore /run/initramfs on shutdown. [ 11.260556] audit: type=1130 audit(1484602661.468:24): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=dracut-shutdown comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [.[0;32m OK .[0m] Started Create Volatile Files and Directories. [ 11.330512] audit: type=1130 audit(1484602661.538:25): 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' Starting Security Auditing Service... [ 11.627263] audit: type=1305 audit(1484602661.835:26): audit_enabled=1 old=1 auid=4294967295 ses=4294967295 res=1 [ 11.627307] audit: type=1305 audit(1484602661.835:27): audit_pid=457 old=0 auid=4294967295 ses=4294967295 res=1 [.[0;32m OK .[0m] Started Early Qubes VM settings. [.[0;32m OK .[0m] Started Security Auditing Service. Starting Update UTMP about System Boot/Shutdown... [.[0;32m OK .[0m] Started Update UTMP about System Boot/Shutdown. [.[0;32m OK .[0m] Reached target System Initialization. [.[0;32m OK .[0m] Listening on Virtual machine lock manager socket. [.[0;32m OK .[0m] Started Daily Cleanup of Temporary Directories. [.[0;32m OK .[0m] Listening on Virtual machine log manager socket. [.[0;32m OK .[0m] Started Periodically check for updates. [.[0;32m OK .[0m] Listening on D-Bus System Message Bus Socket. [.[0;32m OK .[0m] Listening on CUPS Scheduler. [.[0;32m OK .[0m] Listening on Open-iSCSI iscsiuio Socket. [.[0;32m OK .[0m] Listening on Open-iSCSI iscsid Socket. [.[0;32m OK .[0m] Reached target Sockets. [.[0;32m OK .[0m] Started CUPS Scheduler. [.[0;32m OK .[0m] Reached target Paths. [.[0;32m OK .[0m] Reached target Basic System. Starting Qubes memory information reporter... [.[0;32m OK .[0m] Started Manage Sound Card State (restore and store). Starting Login Service... Starting ABRT Automated Bug Reporting Tool... [.[0;32m OK .[0m] Reached target Containers. [.[0;32m OK .[0m] Started Entropy Daemon based on the HAVEGE algorithm. [.[0;32m OK .[0m] Started D-Bus System Message Bus. Starting LSB: Supports the direct execution of binary formats.... Starting Rollback uncommitted netcf...rk config change transactions... Starting Qubes base firewall settings... [.[0;32m OK .[0m] Started Qubes memory information reporter. [.[0;32m OK .[0m] Started Rollback uncommitted netcf network config change transactions. [.[0;32m OK .[0m] Started Login Service. Starting Qubes GUI Agent... [.[0;32m OK .[0m] Started Qubes GUI Agent. Starting Xen driver domain device daemon... [ 12.930126] nf_conntrack version 0.5.0 (2445 buckets, 9780 max) [.[0;32m OK .[0m] Started LSB: Supports the direct execution of binary formats.. [.[0;32m OK .[0m] Started ABRT Automated Bug Reporting Tool. Starting Install ABRT coredump hook... [.[0;32m OK .[0m] Started ABRT kernel log watcher. [.[0;32m OK .[0m] Started ABRT Xorg log watcher. [.[0;32m OK .[0m] Started Xen driver domain device daemon. Starting Qubes remote exec agent... [.[0;32m OK .[0m] Started Qubes remote exec agent. [ 13.130944] ip6_tables: (C) 2000-2006 Netfilter Core Team [.[0;32m OK .[0m] Started Qubes base firewall settings. Starting Qubes misc post-boot actions... [.[0;32m OK .[0m] Reached target Network. [.[0;32m OK .[0m] Reached target Network is Online. Starting Set time via NTP... [.[0;32m OK .[0m] Started Logout off all iSCSI sessions on shutdown. [.[0;32m OK .[0m] Reached target Remote File Systems (Pre). [.[0;32m OK .[0m] Reached target Remote File Systems. Starting Permit User Sessions... Starting Virtualization daemon... [.[0;32m OK .[0m] Started Permit User Sessions. [.[0;32m OK .[0m] Started Serial Getty on hvc0. [.[0;32m OK .[0m] Started Getty on tty1. [.[0;32m OK .[0m] Reached target Login Prompts. [.[0;32m OK .[0m] Started Job spooling tools. [.[0;32m OK .[0m] Started Install ABRT coredump hook. [.[0;32m OK .[0m] Started Qubes misc post-boot actions. [.[0;32m OK .[0m] Created slice User Slice of user. Starting User Manager for UID 1000... [.[0;32m OK .[0m] Created slice User Slice of root. [.[0;32m OK .[0m] Started Session c1 of user user. [.[0;32m OK .[0m] Started Session c3 of user user. [.[0;32m OK .[0m] Started Session c2 of user root. Starting User Manager for UID 0... [.[0;32m OK .[0m] Started User Manager for UID 1000. [.[0;32m OK .[0m] Started User Manager for UID 0. [.[0;32m OK .[0m] Started Virtualization daemon. [ 17.938085] Ebtables v2.0 registered

Fedora 24 (Workstation Edition) Kernel 4.4.38-11.pvops.qubes.x86_64 on an x86_64 (hvc0)

fedora-24 login: [ 23.154945] fuse init (API version 7.23) [ 1022.962220] hrtimer: interrupt took 2775017 ns [.[0;32m OK .[0m] Stopped target Timers. [.[0;32m OK .[0m] Stopped daily update of the root trust anchor for DNSSEC. Stopping User Manager for UID 1000... Stopping Authorization Manager... Stopping Manage Sound Card State (restore and store)... [.[0;32m OK .[0m] Stopped target RPC Port Mapper. Stopping Session c1 of user user. [.[0;32m OK .[0m] Stopped target Network is Online. [.[0;32m OK .[0m] Stopped Updates mlocate database every day. [.[0;32m OK .[0m] Stopped target System Time Synchronized. [.[0;32m OK .[0m] Stopped target Multi-User System. Stopping LSB: Supports the direct execution of binary formats.... Stopping Qubes remote exec agent... [.[0;32m OK .[0m] Stopped target Login Prompts. Stopping Serial Getty on hvc0... Stopping Entropy Daemon based on the HAVEGE algorithm... Stopping Job spooling tools... Stopping Qubes misc post-boot actions... Stopping ABRT Xorg log watcher... Stopping Qubes GUI Agent... Stopping Install ABRT coredump hook... [.[0;32m OK .[0m] Stopped Periodically check for updates. [.[0;32m OK .[0m] Stopped target Containers. [.[0;32m OK .[0m] Stopped Daily Cleanup of Temporary Directories. Stopping Getty on tty1... [.[0;32m OK .[0m] Stopped Qubes base firewall settings. Stopping RealtimeKit Scheduling Policy Service... Stopping Virtualization daemon... Stopping Restore /run/initramfs on shutdown... Stopping ABRT kernel log watcher... [.[0;32m OK .[0m] Stopped Qubes remote exec agent. [.[0;32m OK .[0m] Stopped Serial Getty on hvc0. [.[0;32m OK .[0m] Stopped Entropy Daemon based on the HAVEGE algorithm. [.[0;32m OK .[0m] Stopped Getty on tty1. [.[0;32m OK .[0m] Stopped Job spooling tools. [.[0;32m OK .[0m] Stopped RealtimeKit Scheduling Policy Service. [.[0;32m OK .[0m] Stopped Authorization Manager. [.[0;32m OK .[0m] Stopped Qubes GUI Agent. [.[0;32m OK .[0m] Stopped User Manager for UID 1000. Stopping Qubes memory information reporter... [.[0;32m OK .[0m] Removed slice system-getty.slice. [.[0;32m OK .[0m] Removed slice system-serial\x2dgetty.slice. Stopping Xen driver domain device daemon... [.[0;32m OK .[0m] Stopped Qubes memory information reporter. [.[0;32m OK .[0m] Stopped Xen driver domain device daemon. [.[0;32m OK .[0m] Stopped Restore /run/initramfs on shutdown. [.[0;32m OK .[0m] Stopped Install ABRT coredump hook. [.[0;32m OK .[0m] Stopped LSB: Supports the direct execution of binary formats.. [.[0;32m OK .[0m] Stopped Qubes misc post-boot actions. [.[0;32m OK .[0m] Stopped Manage Sound Card State (restore and store). [.[0;32m OK .[0m] Stopped ABRT kernel log watcher. [.[0;32m OK .[0m] Stopped ABRT Xorg log watcher. Stopping ABRT Automated Bug Reporting Tool... [.[0;32m OK .[0m] Stopped ABRT Automated Bug Reporting Tool. [ 1897.923495] u2mfn_release, priv= (null) [.[0;32m OK .[0m] Stopped Session c1 of user user. [.[0;32m OK .[0m] Removed slice User Slice of user. Stopping Login Service... Stopping Permit User Sessions... [.[0;32m OK .[0m] Stopped Login Service. [.[0;32m OK .[0m] Stopped Permit User Sessions. [.[0;32m OK .[0m] Stopped Virtualization daemon. [.[0;32m OK .[0m] Stopped target Remote File Systems. [.[0;32m OK .[0m] Stopped target Remote File Systems (Pre). Stopping Logout off all iSCSI sessions on shutdown... Stopping D-Bus System Message Bus... [.[0;32m OK .[0m] Stopped D-Bus System Message Bus. [.[0;32m OK .[0m] Stopped Logout off all iSCSI sessions on shutdown. [.[0;32m OK .[0m] Stopped target Network. [.[0;32m OK .[0m] Stopped Rollback uncommitted netcf network config change transactions. [.[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 Paths. [.[0;32m OK .[0m] Stopped CUPS Scheduler. [.[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 target Sockets. [.[0;32m OK .[0m] Closed CUPS Scheduler. [.[0;32m OK .[0m] Closed D-Bus System Message Bus Socket. [.[0;32m OK .[0m] Closed Open-iSCSI iscsiuio Socket. [.[0;32m OK .[0m] Closed Open-iSCSI iscsid Socket. [.[0;32m OK .[0m] Closed Virtual machine lock manager socket. [.[0;32m OK .[0m] Closed Virtual machine log manager socket. [.[0;32m OK .[0m] Stopped target System Initialization. Stopping Load/Save Random Seed... [.[0;32m OK .[0m] Stopped target Swap. Deactivating swap /dev/xvdc1... [.[0;32m OK .[0m] Stopped Apply Kernel Variables. [.[0;32m OK .[0m] Stopped Load Kernel Modules. [.[0;32m OK .[0m] Stopped Setup Virtual Console. [.[0;32m OK .[0m] Stopped Set Up Additional Binary Formats. Stopping Update UTMP about System Boot/Shutdown... [.[0;32m OK .[0m] Stopped target Encrypted Volumes. [.[0;32m OK .[0m] Stopped Load legacy module configuration. [.[0;32m OK .[0m] Stopped Load/Save Random Seed. [.[0;32m OK .[0m] Stopped Update UTMP about System Boot/Shutdown. Stopping Security Auditing Service... [ 1898.850701] audit: type=1305 audit(1484604549.058:236): audit_pid=0 old=457 auid=4294967295 ses=4294967295 res=1 [.[0;32m OK .[0m] Stopped Security Auditing Service. [ 1898.859404] audit: type=1130 audit(1484604549.067:237): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=auditd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1898.859440] audit: type=1131 audit(1484604549.067:238): 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. [ 1898.860046] audit: type=1130 audit(1484604549.068:239): 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' [ 1898.860113] audit: type=1131 audit(1484604549.068:240): 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.38-11.pvops.qubes.x86_64... Unmounting Temporary Directory... Unmounting /run/user/1000/gvfs... Unmounting /home... [.[0;32m OK .[0m] Stopped Configure read-only root support. [ 1898.883651] audit: type=1130 audit(1484604549.091:241): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=fedora-readonly comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [ 1898.883685] audit: type=1131 audit(1484604549.091:242): pid=1 uid=0 auid=4294967295 ses=4294967295 msg='unit=fedora-readonly comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' [.[0;1;31mFAILED.[0m] Failed unmounting /usr/lib/modules/4.4.38-11.pvops.qubes.x86_64. [.[0;32m OK .[0m] Unmounted /home. [.[0;32m OK .[0m] Unmounted /run/user/1000/gvfs. [.[0;32m OK .[0m] Unmounted Temporary Directory. Unmounting /run/user/1000... Unmounting /rw... [.[0;32m OK .[0m] Deactivated swap /dev/disk/by-uuid/...cea-2b32-44e0-a5b8-db39386f3302. [.[0;32m OK .[0m] Deactivated swap /dev/xvdc1. [.[0;32m OK .[0m] Unmounted /run/user/1000. [.[0;32m OK .[0m] Unmounted /rw. [.[0;32m OK .[0m] Reached target Unmount All Filesystems. [.[0;32m OK .[0m] Stopped target Local File Systems (Pre). Stopping Monitoring of LVM2 mirrors... dmeventd or progress polling... [.[0;32m OK .[0m] Stopped Create Static Device Nodes in /dev. [ 1899.299270] audit: type=1130 audit(1484604549.507:243): 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' [ 1899.299311] audit: type=1131 audit(1484604549.507:244): 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] Stopped Remount Root and Kernel File Systems. [ 1899.299953] audit: type=1130 audit(1484604549.507:245): 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] Reached target Shutdown. [ 1899.401669] systemd-shutdown[1]: Sending SIGTERM to remaining processes... [ 1899.477846] systemd-journald[184]: Received SIGTERM from PID 1 (systemd-shutdow). [ 1901.723350] systemd-shutdown[1]: Sending SIGKILL to remaining processes... [ 1901.726137] systemd-shutdown[1]: Unmounting file systems. [ 1901.726319] systemd-shutdown[1]: Remounting '/usr/lib/modules/4.4.38-11.pvops.qubes.x86_64' read-only with options 'data=ordered'. [ 1901.726558] EXT4-fs (xvdd): re-mounted. Opts: data=ordered [ 1901.726572] systemd-shutdown[1]: Unmounting /usr/lib/modules/4.4.38-11.pvops.qubes.x86_64. [ 1901.741017] systemd-shutdown[1]: Remounting '/' read-only with options 'data=ordered'. [ 1902.337183] EXT4-fs (dm-0): re-mounted. Opts: data=ordered [ 1902.352974] systemd-shutdown[1]: Remounting '/' read-only with options 'data=ordered'. [ 1902.353025] EXT4-fs (dm-0): re-mounted. Opts: data=ordered [ 1902.353038] systemd-shutdown[1]: Remounting '/' read-only with options 'data=ordered'. [ 1902.353060] EXT4-fs (dm-0): re-mounted. Opts: data=ordered [ 1902.353070] systemd-shutdown[1]: All filesystems unmounted. [ 1902.353078] systemd-shutdown[1]: Deactivating swaps. [ 1902.353131] systemd-shutdown[1]: All swaps deactivated. [ 1902.353140] systemd-shutdown[1]: Detaching loop devices. [ 1902.403402] systemd-shutdown[1]: All loop devices detached. [ 1902.403417] systemd-shutdown[1]: Detaching DM devices. [ 1902.403669] systemd-shutdown[1]: Not all DM devices detached, 1 left. [ 1902.403758] systemd-shutdown[1]: Detaching DM devices. [ 1902.403966] systemd-shutdown[1]: Not all DM devices detached, 1 left. [ 1902.403977] systemd-shutdown[1]: Cannot finalize remaining DM devices, continuing. [ 1902.538013] systemd-shutdown[1]: Failed to finalize DM devices, ignoring [ 1902.538060] systemd-shutdown[1]: Powering off. [ 1902.563255] reboot: System halted [ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Linux version 4.4.38-11.pvops.qubes.x86_64 (user@release) (gcc version 5.3.1 20160406 (Red Hat 5.3.1-6) (GCC) ) #1 SMP Mon Dec 12 23:24:39 UTC 2016 [ 0.000000] Command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH rd.plymouth.enable=0 plymouth.enable=0 nopat

[ 0.000000] x86/fpu: Supporting XSAVE feature 0x01: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x02: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x04: 'AVX registers' [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] x86/fpu: Using 'eager' FPU context switches. [ 0.000000] ACPI in unprivileged domain disabled [ 0.000000] Released 0 page(s) [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] Xen: [mem 0x0000000000000000-0x000000000009ffff] usable [ 0.000000] Xen: [mem 0x00000000000a0000-0x00000000000fffff] reserved [ 0.000000] Xen: [mem 0x0000000000100000-0x00000000f9ffffff] usable [ 0.000000] x86/PAT: PAT support disabled. [ 0.000000] x86/PAT: Configuration [0-7]: WB WT UC- UC WC WP UC UC
[ 0.000000] NX (Execute Disable) protection: active [ 0.000000] DMI not present or invalid. [ 0.000000] Hypervisor detected: Xen [ 0.000000] e820: last_pfn = 0xfa000 max_arch_pfn = 0x400000000 [ 0.000000] MTRR: Disabled [ 0.000000] RAMDISK: [mem 0x02057000-0x02b17fff] [ 0.000000] NUMA turned off [ 0.000000] Faking a node at [mem 0x0000000000000000-0x00000000f9ffffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x18839000-0x1884afff] [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x00000000f9ffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009ffff] [ 0.000000] node 0: [mem 0x0000000000100000-0x00000000f9ffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x00000000f9ffffff] [ 0.000000] p2m virtual area at ffffc90000000000, size is 800000 [ 0.000000] Remapped 0 page(s) [ 0.000000] SFI: Simple Firmware Interface v0.81 http://simplefirmware.org [ 0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs [ 0.000000] e820: [mem 0xfa000000-0xffffffff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on Xen [ 0.000000] Xen version: 4.6.3 (preserve-AD) [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [ 0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:2 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 34 pages/cpu @ffff880013e00000 s98392 r8192 d32680 u1048576 [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes) [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 1007882 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH rd.plymouth.enable=0 plymouth.enable=0 nopat [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] Memory: 299196K/4095612K available (7543K kernel code, 1249K rwdata, 3412K rodata, 1532K init, 1472K bss, 3796416K reserved, 0K cma-reserved) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] Build-time adjustment of leaf fanout to 64. [ 0.000000] RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=2. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=2 [ 0.000000] Using NULL legacy PIC [ 0.000000] NR_IRQS:4352 nr_irqs:48 0 [ 0.000000] xen:events: Using FIFO-based ABI [ 0.000000] Offload RCU callbacks from all CPUs [ 0.000000] Offload RCU callbacks from CPUs: 0-1. [ 0.000000] Console: colour dummy device 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] console [hvc0] enabled [ 0.000000] clocksource: xen: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] installing Xen timer for CPU 0 [ 0.000000] tsc: Detected 3392.428 MHz processor [ 0.001000] Calibrating delay loop (skipped), value calculated using timer frequency.. 6784.85 BogoMIPS (lpj=3392428) [ 0.001000] pid_max: default: 32768 minimum: 301 [ 0.001000] Security Framework initialized [ 0.001000] AppArmor: AppArmor disabled by boot time parameter [ 0.001103] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes) [ 0.002856] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes) [ 0.003213] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.003232] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes) [ 0.003717] Initializing cgroup subsys io [ 0.003728] Initializing cgroup subsys memory [ 0.003739] Initializing cgroup subsys devices [ 0.003746] Initializing cgroup subsys freezer [ 0.003753] Initializing cgroup subsys net_cls [ 0.003760] Initializing cgroup subsys perf_event [ 0.003766] Initializing cgroup subsys net_prio [ 0.003773] Initializing cgroup subsys hugetlb [ 0.003780] Initializing cgroup subsys pids [ 0.003832] ENERGY_PERF_BIAS: Set to 'normal', was 'performance' [ 0.003838] ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8) [ 0.003845] CPU: Physical Processor ID: 0 [ 0.003849] CPU: Processor Core ID: 3 [ 0.003858] Last level iTLB entries: 4KB 512, 2MB 8, 4MB 8 [ 0.003863] Last level dTLB entries: 4KB 512, 2MB 32, 4MB 32, 1GB 0 [ 0.033425] ftrace: allocating 28748 entries in 113 pages [ 0.041098] cpu 0 spinlock event irq 1 [ 0.041112] Could not initialize VPMU for cpu 0, error -95 [ 0.041161] Performance Events: unsupported p6 CPU model 42 no PMU driver, software events only. [ 0.041840] NMI watchdog: disabled (cpu0): hardware events not enabled [ 0.041848] NMI watchdog: Shutting down hard lockup detector on all cpus [ 0.041949] SMP alternatives: switching to SMP code [ 0.066538] installing Xen timer for CPU 1 [ 0.066587] cpu 1 spinlock event irq 8 [ 0.067038] x86: Booted up 1 node, 2 CPUs [ 0.067193] devtmpfs: initialized [ 0.069750] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [ 0.069854] atomic64_test: passed for x86-64 platform with CX8 and with SSE [ 0.069864] pinctrl core: initialized pinctrl subsystem [ 0.089835] RTC time: 165:165:165, date: 165/165/65 [ 0.090767] NET: Registered protocol family 16 [ 0.090787] xen:grant_table: Grant tables using version 1 layout [ 0.090801] Grant table initialized [ 0.092011] PCI: setting up Xen PCI frontend stub [ 0.095338] ACPI: Interpreter disabled. [ 0.095363] xen:balloon: Initialising balloon driver [ 0.140039] xen_balloon: Initialising balloon driver [ 0.140075] vgaarb: loaded [ 0.141078] SCSI subsystem initialized [ 0.141100] usbcore: registered new interface driver usbfs [ 0.141100] usbcore: registered new interface driver hub [ 0.141106] usbcore: registered new device driver usb [ 0.141157] dmi: Firmware registration failed. [ 0.141157] PCI: System does not support PCI [ 0.141157] PCI: System does not support PCI [ 0.141157] NetLabel: Initializing [ 0.141161] NetLabel: domain hash size = 128 [ 0.141165] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.141182] NetLabel: unlabeled traffic allowed by default [ 0.141249] amd_nb: Cannot enumerate AMD northbridges [ 0.141426] clocksource: Switched to clocksource xen [ 0.148786] pnp: PnP ACPI: disabled [ 0.152794] NET: Registered protocol family 2 [ 0.152996] TCP established hash table entries: 32768 (order: 6, 262144 bytes) [ 0.153159] TCP bind hash table entries: 32768 (order: 7, 524288 bytes) [ 0.153229] TCP: Hash tables configured (established 32768 bind 32768) [ 0.153258] UDP hash table entries: 2048 (order: 4, 65536 bytes) [ 0.153289] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes) [ 0.153345] NET: Registered protocol family 1 [ 0.153416] Unpacking initramfs... [ 0.192090] Freeing initrd memory: 11012K (ffff880002057000 - ffff880002b18000) [ 0.192224] RAPL PMU detected, API unit is 2^-32 Joules, 3 fixed counters 163840 ms ovfl timer [ 0.192234] hw unit of domain pp0-core 2^-16 Joules [ 0.192239] hw unit of domain package 2^-16 Joules [ 0.192244] hw unit of domain pp1-gpu 2^-16 Joules [ 0.192792] futex hash table entries: 512 (order: 3, 32768 bytes) [ 0.192828] audit: initializing netlink subsys (disabled) [ 0.192848] audit: type=2000 audit(1484611493.441:1): initialized [ 0.193114] Initialise system trusted keyring [ 0.194881] zbud: loaded [ 0.195174] VFS: Disk quotas dquot_6.6.0 [ 0.195222] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.195550] hugetlbfs: disabling because there are no supported hugepage sizes [ 0.195706] Key type big_key registered [ 0.201782] NET: Registered protocol family 38 [ 0.201800] Key type asymmetric registered [ 0.201807] Asymmetric key parser 'x509' registered [ 0.201878] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) [ 0.201917] io scheduler noop registered [ 0.201926] io scheduler deadline registered [ 0.201970] io scheduler cfq registered (default) [ 0.202297] xen:xen_evtchn: Event-channel device installed [ 0.202852] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 0.203426] Non-volatile memory driver v1.3 [ 0.203490] Linux agpgart interface v0.103 [ 0.206018] libphy: Fixed MDIO Bus: probed [ 0.206162] usbcore: registered new interface driver usbserial [ 0.206174] usbcore: registered new interface driver usbserial_generic [ 0.206186] usbserial: USB Serial support registered for generic [ 0.206216] i8042: PNP: No PS/2 controller found. Probing ports directly. [ 1.510048] i8042: No controller found [ 1.510073] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x30e65e02791, max_idle_ns: 440795344677 ns [ 1.510258] mousedev: PS/2 mouse device common for all mice [ 1.510377] device-mapper: uevent: version 1.0.3 [ 1.517773] device-mapper: ioctl: 4.34.0-ioctl (2015-10-28) initialised: dm-devel@redhat.com [ 1.517906] dmi-sysfs: dmi entry is absent. [ 1.517939] hidraw: raw HID events driver (C) Jiri Kosina [ 1.518002] usbcore: registered new interface driver usbhid [ 1.518016] usbhid: USB HID core driver [ 1.518081] drop_monitor: Initializing network drop monitor service [ 1.518153] ip_tables: (C) 2000-2006 Netfilter Core Team [ 1.568846] Initializing XFRM netlink socket [ 1.569043] NET: Registered protocol family 10 [ 1.569251] mip6: Mobile IPv6 [ 1.569260] NET: Registered protocol family 17 [ 1.569273] mce: Unable to init device /dev/mcelog (rc: -5) [ 1.569348] AVX version of gcm_enc/dec engaged. [ 1.569354] AES CTR mode by8 optimization enabled [ 1.604563] registered taskstats version 1 [ 1.604589] Loading compiled-in X.509 certificates [ 1.604626] zswap: loaded using pool lzo/zbud [ 1.604682] xenbus_probe_frontend: Device with no driver: device/vbd/51712 [ 1.604689] xenbus_probe_frontend: Device with no driver: device/vbd/51728 [ 1.604694] xenbus_probe_frontend: Device with no driver: device/vbd/51744 [ 1.604699] xenbus_probe_frontend: Device with no driver: device/vbd/51760 [ 1.604705] xenbus_probe_frontend: Device with no driver: device/vif/0 [ 1.604762] Magic number: 1:252:3141 [ 1.604796] hctosys: unable to open rtc device (rtc0) [ 1.606210] Freeing unused kernel memory: 1532K (ffffffff81d3a000 - ffffffff81eb9000) [ 1.606223] Write protecting the kernel read-only data: 12288k [ 1.613399] Freeing unused kernel memory: 636K (ffff880001761000 - ffff880001800000) [ 1.613873] Freeing unused kernel memory: 684K (ffff880001b55000 - ffff880001c00000) Qubes initramfs script here: [ 1.620158] random: modprobe: uninitialized urandom read (8 bytes read, 21 bits of entropy available) [ 1.682848] blkfront: xvda: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled; [ 1.703047] blkfront: xvdb: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled; [ 1.742957] blkfront: xvdc: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled; [ 1.800861] xvdc: xvdc1 [ 1.802735] blkfront: xvdd: barrier or flush: disabled; persistent grants: enabled; indirect descriptors: enabled; Waiting for /dev/xvda* devices... [ 1.927107] random: cat: uninitialized urandom read (8 bytes read, 31 bits of entropy available) Qubes: Doing R/W setup for TemplateVM... [ 1.930381] xvdc: xvdc1 [ 1.930630] random: sfdisk: uninitialized urandom read (4 bytes read, 31 bits of entropy available) [ 1.931021] xvdc: xvdc1 [ 1.993302] random: mkswap: uninitialized urandom read (8 bytes read, 31 bits of entropy available) Setting up swapspace version 1, size = 1073737728 bytes [ 1.994720] random: mkswap: uninitialized urandom read (16 bytes read, 31 bits of entropy available) UUID=b0332220-9d3a-40ee-bbc2-a51fd162eda1 [ 2.058472] random: cat: uninitialized urandom read (8 bytes read, 31 bits of entropy available) Qubes: done. [ 2.068076] random: modprobe: uninitialized urandom read (8 bytes read, 32 bits of entropy available) modprobe: module ext4 not found in modules.dep [ 2.069723] random: mkdir: uninitialized urandom read (8 bytes read, 32 bits of entropy available) [ 2.072090] random: mount: uninitialized urandom read (8 bytes read, 32 bits of entropy available) [ 2.072490] EXT4-fs (dm-0): couldn't mount as ext3 due to feature incompatibilities [ 2.072595] EXT4-fs (dm-0): couldn't mount as ext2 due to feature incompatibilities [ 2.177706] EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null) [ 2.178696] random: uname: uninitialized urandom read (8 bytes read, 33 bits of entropy available) Waiting for /dev/xvdd device... [ 2.287125] EXT4-fs (xvdd): mounting ext3 file system using the ext4 subsystem [ 2.291364] EXT4-fs (xvdd): mounted filesystem with ordered data mode. Opts: (null) [ 2.834411] 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) [ 2.834492] systemd[1]: Detected virtualization xen. [ 2.834504] systemd[1]: Detected architecture x86-64.

Welcome to .[0;34mFedora 24 (Workstation Edition).[0m!

[ 2.857931] systemd[1]: No hostname configured. [ 2.857947] systemd[1]: Set hostname to . [ 3.442743] systemd[1]: Listening on Journal Audit Socket. [.[0;32m OK .[0m] Listening on Journal Audit Socket. [ 3.443050] systemd[1]: Listening on Journal Socket (/dev/log). [.[0;32m OK .[0m] Listening on Journal Socket (/dev/log). [ 3.443216] systemd[1]: Listening on RPCbind Server Activation Socket. [.[0;32m OK .[0m] Listening on RPCbind Server Activation Socket. [ 3.443293] systemd[1]: Reached target RPC Port Mapper. [.[0;32m OK .[0m] Reached target RPC Port Mapper. [ 3.443385] systemd[1]: Listening on udev Kernel Socket. [.[0;32m OK .[0m] Listening on udev Kernel Socket. [ 3.443481] systemd[1]: Listening on LVM2 poll daemon socket. [.[0;32m OK .[0m] Listening on LVM2 poll daemon socket. [ 3.444421] systemd[1]: Listening on Process Core Dump Socket. [.[0;32m OK .[0m] Listening on Process Core Dump Socket. [ 3.444538] systemd[1]: Listening on Device-mapper event daemon FIFOs. [.[0;32m OK .[0m] Listening on Device-mapper event daemon FIFOs. [ 3.444659] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [.[0;32m OK .[0m] Started Forward Password Requests to Wall Directory Watch. [ 3.444784] systemd[1]: Listening on Journal Socket. [.[0;32m OK .[0m] Listening on Journal Socket. [ 3.445346] systemd[1]: Created slice User and Session Slice. [.[0;32m OK .[0m] Created slice User and Session Slice. [ 3.445463] systemd[1]: Listening on udev Control Socket. [.[0;32m OK .[0m] Listening on udev Control Socket. [ 3.445705] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. [.[0;32m OK .[0m] Set up automount Arbitrary Executab...ats File System Automount Point. [ 3.445841] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [.[0;32m OK .[0m] Started Dispatch Password Requests to Console Directory Watch. [ 3.445946] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe. [.[0;32m OK .[0m] Listening on /dev/initctl Compatibility Named Pipe. [ 3.446041] systemd[1]: Listening on LVM2 metadata daemon socket. [.[0;32m OK .[0m] Listening on LVM2 metadata daemon socket. [ 3.446261] systemd[1]: Created slice System Slice. [.[0;32m OK .[0m] Created slice System Slice. [ 3.446482] systemd[1]: Created slice system-serial\x2dgetty.slice. [.[0;32m OK .[0m] Created slice system-serial\x2dgetty.slice. [ 3.457331] systemd[1]: Starting Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling... Starting Monitoring of LVM2 mirrors... dmeventd or progress polling... [ 3.457714] systemd[1]: Created slice system-getty.slice. [.[0;32m OK .[0m] Created slice system-getty.slice. [ 3.459217] systemd[1]: Mounting Debug File System... Mounting Debug File System... [ 3.459370] systemd[1]: Reached target Slices. [.[0;32m OK .[0m] Reached target Slices. [ 3.460726] systemd[1]: Starting Journal Service... Starting Journal Service... [ 3.462062] systemd[1]: Starting Setup Virtual Console... Starting Setup Virtual Console... [ 3.463374] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ 3.467290] systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. [ 3.468496] systemd[1]: Mounting Temporary Directory... Mounting Temporary Directory... [ 3.480535] systemd[1]: Starting Load Kernel Modules... Starting Load Kernel Modules... [ 3.481922] systemd[1]: Mounting /proc/xen... Mounting /proc/xen... [ 3.483354] systemd[1]: Starting File System Check on Root Device... Starting File System Check on Root Device... [ 3.485579] systemd[1]: Starting Create list of required static device nodes for the current kernel... Starting Create list of required st... nodes for the current kernel... [ 3.517378] systemd[1]: Starting Set Up Additional Binary Formats... Starting Set Up Additional Binary Formats... [ 3.565259] systemd[1]: Starting Load legacy module configuration... Starting Load legacy module configuration... [ 3.567613] systemd[1]: Mounted POSIX Message Queue File System. [.[0;32m OK .[0m] Mounted POSIX Message Queue File System. [ 3.567706] systemd[1]: Mounted Debug File System. [.[0;32m OK .[0m] Mounted Debug File System. [ 3.567768] systemd[1]: Mounted Temporary Directory. [.[0;32m OK .[0m] Mounted Temporary Directory. [ 3.568299] systemd[1]: Started Setup Virtual Console. [.[0;32m OK .[0m] Started Setup Virtual Console. [ 3.571722] systemd[1]: Started Create list of required static device nodes for the current kernel. [.[0;32m OK .[0m] Started Create list of required sta...ce nodes for the current kernel. [ 3.573604] systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 194 (systemd-binfmt) [ 3.624615] systemd[1]: Started LVM2 metadata daemon. [.[0;32m OK .[0m] Started LVM2 metadata daemon. [ 3.626369] systemd[1]: Mounting Arbitrary Executable File Formats File System... Mounting Arbitrary Executable File Formats File System... [ 3.644643] systemd[1]: Mounted Arbit

StevenLColeman42 commented 7 years ago

After not have it happening for 45min to 1 hr I opened up that template and started grepping the logs in the vm for string patterns having anything to do with screen locking and darned if it didn't happen within a few minutes, and the vm was not even idle at the time. Not sure what to think now. It may be confirmation bias but I still suspect an association with that vm for some reason. I didn't find any incriminating evidence before I had to shut it down again. No problems since, but I'll wait a while and see.

On Tue, Jan 17, 2017 at 2:22 PM, Steve Coleman stevenlcoleman42@gmail.com wrote:

I read your comment this morning and I was going to respond and say I had not seen this in a while, but then it just happened once just a few minutes ago. What I was doing at the time was editing in my fedora-24 template VM and exploring dnf package exclusion configuration, and was inactive in that template vm for a few minutes while reading some dnf documentation in a vm that has internet access enabled.

My suspicion is that some screen saver in one or more VM's (e.g. fedora-24) goes into screen-saver mode and somehow sends the blanking "image" through to the Qubes GUI for display, but is not then capable of actually locking the physical screen/keyboard, because its dom0 that has that responsibility. I don't have sufficient knowledge of the qubes/Xen architecture to chase that sequence of events but attached the fc24 template vm log file in case you might notice something funny. It has not happened since I shut down that specific vm (normally it repeats many times), and I will be paying more attention to this/any association going forward.

I did have several other vms based on that template open without any issue for weeks at a time, but it may be that installing some software in that template vm set up some service that does not run in the vms using that template. Lately I have been forced to get creative with installing software generically in the template but having only certain targeted vm's running that software.

On Tue, Jan 17, 2017 at 8:18 AM, Andrew David Wong < notifications@github.com> wrote:

@e5f3c2ea895af0f27667 https://github.com/e5f3c2ea895af0f27667: I'm not aware of any specific fix for this. Perhaps as a byproduct of something else?

— You are receiving this because you commented. Reply to this email directly, view it on GitHub https://github.com/QubesOS/qubes-issues/issues/2399#issuecomment-273152138, or mute the thread https://github.com/notifications/unsubscribe-auth/AT8Ghd7Kw6G57wVilrB9Zd1w4hF_fp-jks5rTL-0gaJpZM4Kh7_A .

ghost commented 7 years ago

@andrewdavidwong @StevenLColeman42 Strangely enough, I noticed the issue again today (it happened only once).

zby commented 7 years ago

Recently it indeed somehow diminished - but not vanished.

I noticed that a sure way to trigger it is to watch videos or have lots of windows (for example small chat windows) that are frequently popping up and being deleted.

miero commented 7 years ago

This issue seems to be related to the PrintScreen key. I can change/clear content of that "pop-up" screen by pressing PrintScreen multiple times, each time with mouse cursor on different monitor.

BTW: This might be relevant: I'm using two monitors, rotated left by 90, radeon driver.

StevenLColeman42 commented 7 years ago

I think your printscreen method is just causing a screen refresh, which any form of which temporarily fixes the display, for the moment. I have personally never uesd the printscreen key for anything, so it cant be the source of the problem but perhaps a way to clear the screen.

I have noticed that closing a VM sometimes fixes my problem, but guessing which is harder, so it might seem to be a program is not playing nice with the Xen/Qubes display driver. My suspicion is on Java because its usually running in an open VM whenever I see the problem, but I don't have a clue what it might specifically do to cause this. I'll have to find a way to do a system trace all the suspected jvm's when it happens the next time just to see what they are doing.

Mine is also dual monitor for what it is worth.

On Tue, Feb 21, 2017, 3:07 AM Miroslav Rudišin notifications@github.com wrote:

This issue seems to be related to the PrintScreen key. I can change/clear content of that "pop-up" screen by pressing PrintScreen multiple times, each time with mouse cursor on different monitor.

BTW: This might be relevant: I'm using two monitors, rotated left by 90, radeon driver.

— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/QubesOS/qubes-issues/issues/2399#issuecomment-281272415, or mute the thread https://github.com/notifications/unsubscribe-auth/AT8GhRoOwvSa6J_wbpHy-1uf7hdvAQX7ks5reptQgaJpZM4Kh7_A .

StevenLColeman42 commented 7 years ago

It started again...

When I play with the "File" menu in Libreoffice in my current Disp2 VM, the system 100% reliably kicks right into this xlock blank screen saver, thus displaying the .xlockrc "text" file from my Dom0 environment. I can play with other VM's app menus without any problem, which is how I am able to write this.

In the mean time Dom0 'xdg-screensaver status' returns 'disabled', and other fairly random movement on the cursor over apps sometimes causes the Dom0 xlock screensaver to kick in. No screensaver apps even exist in any of my VM templates.

After shutting down all VM's except Disp2, and the one I am writing this email from, the screensaver mayhem has stopped. Oddly if I open the Libreoffice file menu that was giving me the initial problem and then switch desktops that same file menu appears on whatever desktop I am on without the Libraoffice app window attached. This Disp2 VM was originally spawned from my email VM when opening a verifiable valid document attachment and had been sitting there quietly for several hours while I tended to other business.

threadpanic commented 7 years ago

I have the same issue, and also the same screen as the posted screenshot, its quite annoying... It doesnt seem to have anything to do with the graphics driver tho, i've got the same thing on two different gpu's.

jpouellet commented 7 years ago

This seems very weird. An ltrace of the gui-agent, gui-daemon, and dom0 x server while experiencing this weird behavior might shed some light on what's going on.

Also, I'm curious if there's a correlation between experiencing this issue and your system (dom0 and/or restored backups of templates) being upgraded from pre-r3.2-release vs being a fresh install.

threadpanic commented 7 years ago

I've always been on R3.2 on both my old and new rig.

But I think I found something. I've disabled compositing in Settings>Window Manager Tweaks>Compositor. SInce then I've not seen the xscreensaver screen pop up on me.

I've got many windows open with animating gifs etc, trying to trigger the issue, and then I run yumex in dom0. With compositing on it gives me garbled screens of other apps (but not the xscreensaver screen), and when I disable compositing, everything displays as normal.

I'm not sure what to do now... I would love it if somebody else could confirm that disabling compositing fixes it, but a bug in the compositor somehow doesn't seem like an odd place for this kind of bug? If there is something I can do I'd be happy to help.

zby commented 7 years ago

Yeah - switching off composing seems to work for me. I waited for the problem to happen then switched it off and it disappeared - this is not definitive - because it sometimes disappear with any screen operation, but the probability is high.

opalraava thanks a lot!

threadpanic commented 7 years ago

Thanks for the confirmation zby :o)

I'm currently trying if the bug stays away if I keep the compositor enabled, but disable all the 'drop shadow' settings in the compositor settings tab, but that's just trying to dig a bit deeper. I found a page on the Archwiki where they talk about similar kinds of bugs, and that you can start xfwm with a --compositor=off parameter.

I'm not sure if this is a Qubes issue, I mean I can't imagine we have anything to do with compositors.

ghost commented 7 years ago

Way I found to replicate this issue: start many applications in many VMs, and then suspend your computer multiple times.

StevenLColeman42 commented 7 years ago

Started happening again, but differently. I had several VM's open and had done some USB drive attachments for doing some big downloads since I kept running out of disk space. Not sure if that matters but just for completeness. I was not doing much otherwise at the time.

This time the behavior is quite different! I'm not even seeing the screensaver this time, but rather an image of my virtual desktop1 as it was several days ago for a long period of time! My screen will just get overlayed with display image data that is stored in memory some where, and I can switch or move controls to bring back my current virutal desktop.

The image of the screensaver we were seeing is simply just old display data sitting around that apparently gets redrawn periodically over the active display. This is why it was not actually locking the keyboard and thus permitted refreshing/redrawing the active display to bring back the active desktop image. Looking for problems in the screen saver proper was likely just a distraction, but it was common across all our problem reports because statistically the screen saver is in memory for a good of the time on average and therefore it was statistically significant across problem reports.

Steve Coleman

threadpanic commented 7 years ago

Have you disabled the compositor? (Settings>Window Manager Tweaks>Compositor)

jpouellet commented 7 years ago

I do remember having rectangles of stale content in 3.1 with KDE. Never happened for me in 3.2 w/ Xfce though.

StevenLColeman42 commented 7 years ago

No, I have been meaning to look into that but was needing to get some things done first. I'll try that monday.

On Sun, Mar 19, 2017, 5:52 AM Opal Raava notifications@github.com wrote:

Have you disabled the compositor? (Settings>Window Manager Tweaks>Compositor)

— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/QubesOS/qubes-issues/issues/2399#issuecomment-287605464, or mute the thread https://github.com/notifications/unsubscribe-auth/AT8GhWrgMISRe57lg0AbFSh-sdmnmAWgks5rnPrkgaJpZM4Kh7_A .

StevenLColeman42 commented 7 years ago

My machine was acting up again this morning, and deactivating the compositor immediately stopped the screen overwrites. Only one text editor window I had still up retained a black border around it, but otherwise the system settled down. I'm going to reboot the system for good measure but I predict that the problem is likely gone.

It just happened that today it was the system menu that was triggering the overwrite problem, so getting to the menu entry to deactivate the compositor was challenging, but it seems to have done the trick.

On Sun, Mar 19, 2017 at 5:52 AM, Opal Raava notifications@github.com wrote:

Have you disabled the compositor? (Settings>Window Manager Tweaks>Compositor)

— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/QubesOS/qubes-issues/issues/2399#issuecomment-287605464, or mute the thread https://github.com/notifications/unsubscribe-auth/AT8GhWrgMISRe57lg0AbFSh-sdmnmAWgks5rnPrkgaJpZM4Kh7_A .

modulistic commented 7 years ago

Hey, I am getting mad with this issue today.

I can say that I killed the xscreensaver process (in dom0) and the issue is still happening. After that, I still experience the issue. After it happens, I can confirm the xscreensaver process is still gone (in dom0, it has not been restarted).

I'm on an up-to-date R3.2. I have a second display attached to my laptop, using both side-by-side.

In the screenshot you can see the unlock dialog from xscreensaver, along with some rectangles with the stuff that has refreshed on the open windows. But if xsreensaver is not running, who is painting the X root window? It should not be something that can be triggered from an appVM.

screenshot_2017-04-22_12-20-11

StevenLColeman42 commented 7 years ago

Pablo, look at the previous discussions on how to turn off the compositor in the window manager. The compositor appears to be responsible for overwriting the screen with old video data. The screensaver image you see is just old graphic data that keeps being copied to your display. After turning off my compositor I have not had this issue since.

The compositor code should be fixed, but for the user turning this setting off will solve their immediate problem.

Steve

On Sat, Apr 22, 2017, 5:54 AM Pablo Costa notifications@github.com wrote:

Hey, I am getting mad with this issue today. I can say that I killed the xscreensaver process and the issue is still happening. After that, I still experience the issue. After it happens, I can confirm the xscreensaver process is still gone (it has not been restarted). I'm on an up-to-date R3.2.

— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/QubesOS/qubes-issues/issues/2399#issuecomment-296362076, or mute the thread https://github.com/notifications/unsubscribe-auth/AT8GhTOl9x7M2eTeS9t0m8-sRKNpPl73ks5ryc49gaJpZM4Kh7_A .

modulistic commented 7 years ago

Hey, thanks Steve!

For the record, in R3.2 with default XFCE destop, the compositor settings can be found under Qubes Menu > System Tools > Window Manager Tweaks, in the "Compositor" tab.

miero commented 7 years ago

(with enabled compositor) the issue is occurring more often if there is high CPU & disk load ... for example every 3 seconds

threadpanic commented 7 years ago

If the problem is in the compositor, it might work to toggle more detailed settings in the compositor settings and perhaps pin down in what subsystem of the compositor the bug is?

miero commented 7 years ago

This seems to be a reliable way to trigger this issue. 1) enable compositor in "Window Manager Tweaks" dialog. 2) open "Window Manager" configuration dialog 3) switch between Biz and Blackwall styles (on each switch between them the screen gets corrupted)

Maybe some windows manger styles will not trigger this issue...

macdanny commented 5 years ago

This issue is happening for me as well. What is interesting is that it only started happening once I installed a second video card in my workstation. I have been using Qubes for only a few weeks but in that time I did not ever have an issue until the day after I added a second card.

I have an HP Z820 with an nVidia Quadro 5000. With only that video card installed, everything works well. But the Quadro only supports two monitors and I have three. The problem started happening the day after I added an additional video card to utilize my third monitor.

I had an old Radeon HD5570 lying around. That's the supplemental card I tried first. It worked several hours in my work day but it starting having issues late in the afternoon and these issues made the system unusable because it was blanking the screen every few seconds. I had to uninstall the supplemental card to keep working.

I was suspicious of the HD5570. It was in a parts box and I was not sure if it worked. I had tried a different card in the same box and it didn't work at all. So I thought the issue was with my video card. I bought a Radeon Pro WX 2100 card to use as a supplemental card. That was on Wednesday night. It worked fine for a couple of days but today it started doing the same screen blanking thing.

I deliberately chose a Radeon card because it was aligned with the Qubes hardware recommendations. But now that I am sitting here writing this and realizing that both cards that failed are Radeon cards, maybe that is the source of the issue.

I may exchange the Radeon Pro WX 2100 for another nVidia based card to see if it improves things. The system requirements favour AMD over nVidia but that contradicts my direct experience. It's not conclusive but it's grounds for further study.

With the compositor disabled everything works well (so far - it's only been a few minutes but it seems like it will work). I tried enabling the compositor but disabling the options underneath ... nothing helped other than disabling the compositor entirely. On the plus side having the compositor disabled seems to make video playback more smooth.

@StevenLColeman42 thank you for communicating that disabling the compositor fixes this issue. It was driving me nuts.

github-actions[bot] commented 1 year ago

This issue is being closed because:

This issue is on the "Release 4.0 updates" milestone.
Qubes OS 4.0 reached EOL (end-of-life) over one year ago.
There has not been any activity on this issue in over one year.

If anyone believes that this issue should be reopened and reassigned to an active milestone, please leave a brief comment. (For example, if a bug still affects Qubes OS 4.1, then the comment "Affects 4.1" will suffice.)

QubesOS / qubes-issues