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

/bin/sync hangs forever in whonix-ws-dvm #1328

Closed
adrelanos opened this Issue Oct 12, 2015 · 16 comments

Comments

Projects
None yet
2 participants
@adrelanos
Member

adrelanos commented Oct 12, 2015

Trying to set up and document disposable Whonix VMs.

qvm-create-default-dvm whonix-ws

echo konsole | /usr/lib/qubes/qfile-daemon-dvm qubes.VMShell dom0 DEFAULT red

sudo strace -f sync

execve("/bin/sync", ["sync"], [/* 17 vars */]) = 0
brk(0)                                  = 0x1e0e000
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f4e77f72000
access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or directory)
open("/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=82274, ...}) = 0
mmap(NULL, 82274, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7f4e77f5d000
close(3)                                = 0
access("/etc/ld.so.nohwcap", F_OK)      = -1 ENOENT (No such file or directory)
open("/lib/x86_64-linux-gnu/libc.so.6", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0P\34\2\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0755, st_size=1729984, ...}) = 0
mmap(NULL, 3836448, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f4e779ab000
mprotect(0x7f4e77b4a000, 2097152, PROT_NONE) = 0
mmap(0x7f4e77d4a000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x19f000) = 0x7f4e77d4a000
mmap(0x7f4e77d50000, 14880, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f4e77d50000
close(3)                                = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f4e77f5c000
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f4e77f5b000
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f4e77f5a000
arch_prctl(ARCH_SET_FS, 0x7f4e77f5b700) = 0
mprotect(0x7f4e77d4a000, 16384, PROT_READ) = 0
mprotect(0x605000, 4096, PROT_READ)     = 0
mprotect(0x7f4e77f74000, 4096, PROT_READ) = 0
munmap(0x7f4e77f5d000, 82274)           = 0
brk(0)                                  = 0x1e0e000
brk(0x1e2f000)                          = 0x1e2f000
open("/usr/lib/locale/locale-archive", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=1607712, ...}) = 0
mmap(NULL, 1607712, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7f4e77dd1000
close(3)                                = 0
sync(

(Not using the images from #1321 (comment) yet, still downloading.)

@marmarek

This comment has been minimized.

Show comment
Hide comment
@marmarek

marmarek Oct 12, 2015

Member

Did you tried already new images? Does it happen in other (Whonix) AppVMs? Any kernel errors?

Member

marmarek commented Oct 12, 2015

Did you tried already new images? Does it happen in other (Whonix) AppVMs? Any kernel errors?

@adrelanos

This comment has been minimized.

Show comment
Hide comment
@adrelanos

adrelanos Oct 14, 2015

Member

Yes, also happens in the new images from #1321 (comment).

Does not happen in other (Whonix) AppVMs. Only in whonix-ws-dvm.

DispVM /var/log/kern.log:

user@host:~$ cat /var/log/kern.log 
Oct 12 08:18:45 host kernel: [    0.000000] Initializing cgroup subsys cpuset
Oct 12 08:18:45 host kernel: [    0.000000] Initializing cgroup subsys cpu
Oct 12 08:18:45 host kernel: [    0.000000] Initializing cgroup subsys cpuacct
Oct 12 08:18:45 host kernel: [    0.000000] Linux version 3.18.17-6.pvops.qubes.x86_64 (user@release) (gcc version 4.8.3 20140911 (Red Hat 4.8.3-7) (GCC) ) #1 SMP Sat Aug 8 21:27:00 UTC 2015
Oct 12 08:18:45 host kernel: [    0.000000] Command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH 3 nopat
Oct 12 08:18:45 host kernel: [    0.000000] ACPI in unprivileged domain disabled
Oct 12 08:18:45 host kernel: [    0.000000] Set 0 page(s) to 1-1 mapping
Oct 12 08:18:45 host kernel: [    0.000000] Remapped 0 page(s), last_pfn=102400
Oct 12 08:18:45 host kernel: [    0.000000] Released 0 page(s)
Oct 12 08:18:45 host kernel: [    0.000000] e820: BIOS-provided physical RAM map:
Oct 12 08:18:45 host kernel: [    0.000000] Xen: [mem 0x0000000000000000-0x000000000009ffff] usable
Oct 12 08:18:45 host kernel: [    0.000000] Xen: [mem 0x00000000000a0000-0x00000000000fffff] reserved
Oct 12 08:18:45 host kernel: [    0.000000] Xen: [mem 0x0000000000100000-0x00000000f9ffffff] usable
Oct 12 08:18:45 host kernel: [    0.000000] PAT support disabled.
Oct 12 08:18:45 host kernel: [    0.000000] NX (Execute Disable) protection: active
Oct 12 08:18:45 host kernel: [    0.000000] DMI not present or invalid.
Oct 12 08:18:45 host kernel: [    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Oct 12 08:18:45 host kernel: [    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
Oct 12 08:18:45 host kernel: [    0.000000] e820: last_pfn = 0xfa000 max_arch_pfn = 0x400000000
Oct 12 08:18:45 host kernel: [    0.000000] Base memory trampoline at [ffff88000009a000] 9a000 size 24576
Oct 12 08:18:45 host kernel: [    0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
Oct 12 08:18:45 host kernel: [    0.000000]  [mem 0x00000000-0x000fffff] page 4k
Oct 12 08:18:45 host kernel: [    0.000000] init_memory_mapping: [mem 0x18e00000-0x18ffffff]
Oct 12 08:18:45 host kernel: [    0.000000]  [mem 0x18e00000-0x18ffffff] page 4k
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02014000, 0x02014fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] init_memory_mapping: [mem 0x18000000-0x18dfffff]
Oct 12 08:18:45 host kernel: [    0.000000]  [mem 0x18000000-0x18dfffff] page 4k
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02015000, 0x02015fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02016000, 0x02016fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02017000, 0x02017fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02018000, 0x02018fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02019000, 0x02019fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] init_memory_mapping: [mem 0x00100000-0x17ffffff]
Oct 12 08:18:45 host kernel: [    0.000000]  [mem 0x00100000-0x17ffffff] page 4k
Oct 12 08:18:45 host kernel: [    0.000000] init_memory_mapping: [mem 0x19000000-0xf9ffffff]
Oct 12 08:18:45 host kernel: [    0.000000]  [mem 0x19000000-0xf9ffffff] page 4k
Oct 12 08:18:45 host kernel: [    0.000000] RAMDISK: [mem 0x02269000-0x0293afff]
Oct 12 08:18:45 host kernel: [    0.000000] NUMA turned off
Oct 12 08:18:45 host kernel: [    0.000000] Faking a node at [mem 0x0000000000000000-0x00000000f9ffffff]                                                                            
Oct 12 08:18:45 host kernel: [    0.000000] NODE_DATA(0) allocated [mem 0x18835000-0x18848fff]                                                                                      
Oct 12 08:18:45 host kernel: [    0.000000] Zone ranges:                                                                                                                            
Oct 12 08:18:45 host kernel: [    0.000000]   DMA      [mem 0x00001000-0x00ffffff]                                                                                                  
Oct 12 08:18:45 host kernel: [    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
Oct 12 08:18:45 host kernel: [    0.000000]   Normal   empty
Oct 12 08:18:45 host kernel: [    0.000000] Movable zone start for each node
Oct 12 08:18:45 host kernel: [    0.000000] Early memory node ranges
Oct 12 08:18:45 host kernel: [    0.000000]   node   0: [mem 0x00001000-0x0009ffff]
Oct 12 08:18:45 host kernel: [    0.000000]   node   0: [mem 0x00100000-0xf9ffffff]
Oct 12 08:18:45 host kernel: [    0.000000] Initmem setup node 0 [mem 0x00001000-0xf9ffffff]
Oct 12 08:18:45 host kernel: [    0.000000] On node 0 totalpages: 1023903
Oct 12 08:18:45 host kernel: [    0.000000]   DMA zone: 64 pages used for memmap
Oct 12 08:18:45 host kernel: [    0.000000]   DMA zone: 21 pages reserved
Oct 12 08:18:45 host kernel: [    0.000000]   DMA zone: 3999 pages, LIFO batch:0
Oct 12 08:18:45 host kernel: [    0.000000]   DMA32 zone: 15936 pages used for memmap
Oct 12 08:18:45 host kernel: [    0.000000]   DMA32 zone: 1019904 pages, LIFO batch:31
Oct 12 08:18:45 host kernel: [    0.000000] SFI: Simple Firmware Interface v0.81 http://simplefirmware.org
Oct 12 08:18:45 host kernel: [    0.000000] smpboot: Allowing 8 CPUs, 0 hotplug CPUs
Oct 12 08:18:45 host kernel: [    0.000000] e820: [mem 0xfa000000-0xffffffff] available for PCI devices
Oct 12 08:18:45 host kernel: [    0.000000] Booting paravirtualized kernel on Xen
Oct 12 08:18:45 host kernel: [    0.000000] Xen version: 4.4.2 (preserve-AD)
Oct 12 08:18:45 host kernel: [    0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:8 nr_node_ids:1
Oct 12 08:18:45 host kernel: [    0.000000] PERCPU: Embedded 30 pages/cpu @ffff880018200000 s82560 r8192 d32128 u262144
Oct 12 08:18:45 host kernel: [    0.000000] pcpu-alloc: s82560 r8192 d32128 u262144 alloc=1*2097152
Oct 12 08:18:45 host kernel: [    0.000000] pcpu-alloc: [0] 0 1 2 3 4 5 6 7 
Oct 12 08:18:45 host kernel: [    0.000000] xen: PV spinlocks enabled
Oct 12 08:18:45 host kernel: [    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 1007882
Oct 12 08:18:45 host kernel: [    0.000000] Policy zone: DMA32
Oct 12 08:18:45 host kernel: [    0.000000] Kernel command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH 3 nopat
Oct 12 08:18:45 host kernel: [    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
Oct 12 08:18:45 host kernel: [    0.000000] xsave: enabled xstate_bv 0x7, cntxt size 0x340 using standard form
Oct 12 08:18:45 host kernel: [    0.000000] Memory: 309872K/4095612K available (7357K kernel code, 1142K rwdata, 3472K rodata, 1468K init, 1488K bss, 3785740K reserved)
Oct 12 08:18:45 host kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1
Oct 12 08:18:45 host kernel: [    0.000000] Hierarchical RCU implementation.
Oct 12 08:18:45 host kernel: [    0.000000]     RCU dyntick-idle grace-period acceleration is enabled.
Oct 12 08:18:45 host kernel: [    0.000000]     RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=8.
Oct 12 08:18:45 host kernel: [    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=8
Oct 12 08:18:45 host kernel: [    0.000000] NR_IRQS:4352 nr_irqs:80 0
Oct 12 08:18:45 host kernel: [    0.000000] xen:events: Using FIFO-based ABI
Oct 12 08:18:45 host kernel: [    0.000000]     Offload RCU callbacks from all CPUs
Oct 12 08:18:45 host kernel: [    0.000000]     Offload RCU callbacks from CPUs: 0-7.
Oct 12 08:18:45 host kernel: [    0.000000] Console: colour dummy device 80x25
Oct 12 08:18:45 host kernel: [    0.000000] console [tty0] enabled
Oct 12 08:18:45 host kernel: [    0.000000] console [hvc0] enabled
Oct 12 08:18:45 host kernel: [    0.000000] allocated 16777216 bytes of page_cgroup
Oct 12 08:18:45 host kernel: [    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
Oct 12 08:18:45 host kernel: [    0.000000] Xen: using vcpuop timer interface
Oct 12 08:18:45 host kernel: [    0.000000] installing Xen timer for CPU 0
Oct 12 08:18:45 host kernel: [    0.000000] tsc: Detected 2195.024 MHz processor
Oct 12 08:18:45 host kernel: [    0.001000] Calibrating delay loop (skipped), value calculated using timer frequency.. 4390.04 BogoMIPS (lpj=2195024)
Oct 12 08:18:45 host kernel: [    0.001000] pid_max: default: 32768 minimum: 301
Oct 12 08:18:45 host kernel: [    0.001000] Security Framework initialized
Oct 12 08:18:45 host kernel: [    0.001000] AppArmor: AppArmor disabled by boot time parameter
Oct 12 08:18:45 host kernel: [    0.001000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes)
Oct 12 08:18:45 host kernel: [    0.001750] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes)
Oct 12 08:18:45 host kernel: [    0.002005] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes)
Oct 12 08:18:45 host kernel: [    0.002018] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes)
Oct 12 08:18:45 host kernel: [    0.002218] Initializing cgroup subsys memory
Oct 12 08:18:45 host kernel: [    0.002226] Initializing cgroup subsys devices
Oct 12 08:18:45 host kernel: [    0.002229] Initializing cgroup subsys freezer
Oct 12 08:18:45 host kernel: [    0.002232] Initializing cgroup subsys net_cls
Oct 12 08:18:45 host kernel: [    0.002236] Initializing cgroup subsys blkio
Oct 12 08:18:45 host kernel: [    0.002239] Initializing cgroup subsys perf_event
Oct 12 08:18:45 host kernel: [    0.002242] Initializing cgroup subsys net_prio
Oct 12 08:18:45 host kernel: [    0.002245] Initializing cgroup subsys hugetlb
Oct 12 08:18:45 host kernel: [    0.002283] ENERGY_PERF_BIAS: Set to 'normal', was 'performance'
Oct 12 08:18:45 host kernel: [    0.002283] ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8)
Oct 12 08:18:45 host kernel: [    0.002290] CPU: Physical Processor ID: 0
Oct 12 08:18:45 host kernel: [    0.002292] CPU: Processor Core ID: 0
Oct 12 08:18:45 host kernel: [    0.003078] Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024
Oct 12 08:18:45 host kernel: [    0.003078] Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4
Oct 12 08:18:45 host kernel: [    0.028330] ftrace: allocating 27112 entries in 106 pages
Oct 12 08:18:45 host kernel: [    0.033060] cpu 0 spinlock event irq 17
Oct 12 08:18:45 host kernel: [    0.040033] Performance Events: unsupported p6 CPU model 70 no PMU driver, software events only.
Oct 12 08:18:45 host kernel: [    0.041052] NMI watchdog: disabled (cpu0): hardware events not enabled
Oct 12 08:18:45 host kernel: [    0.041114] installing Xen timer for CPU 1
Oct 12 08:18:45 host kernel: [    0.041122] cpu 1 spinlock event irq 24
Oct 12 08:18:45 host kernel: [    0.041160] SMP alternatives: switching to SMP code
Oct 12 08:18:45 host kernel: [    0.064297] installing Xen timer for CPU 2
Oct 12 08:18:45 host kernel: [    0.064306] cpu 2 spinlock event irq 31
Oct 12 08:18:45 host kernel: [    0.065337] installing Xen timer for CPU 3
Oct 12 08:18:45 host kernel: [    0.065354] cpu 3 spinlock event irq 38
Oct 12 08:18:45 host kernel: [    0.066371] installing Xen timer for CPU 4
Oct 12 08:18:45 host kernel: [    0.066379] cpu 4 spinlock event irq 45
Oct 12 08:18:45 host kernel: [    0.067347] installing Xen timer for CPU 5
Oct 12 08:18:45 host kernel: [    0.067359] cpu 5 spinlock event irq 52
Oct 12 08:18:45 host kernel: [    0.068339] installing Xen timer for CPU 6
Oct 12 08:18:45 host kernel: [    0.068348] cpu 6 spinlock event irq 59
Oct 12 08:18:45 host kernel: [    0.069326] installing Xen timer for CPU 7
Oct 12 08:18:45 host kernel: [    0.069337] cpu 7 spinlock event irq 66
Oct 12 08:18:45 host kernel: [    0.070219] x86: Booted up 1 node, 8 CPUs
Oct 12 08:18:45 host kernel: [    0.070303] devtmpfs: initialized
Oct 12 08:18:45 host kernel: [    0.072611] atomic64_test: passed for x86-64 platform with CX8 and with SSE
Oct 12 08:18:45 host kernel: [    0.072611] pinctrl core: initialized pinctrl subsystem
Oct 12 08:18:45 host kernel: [    0.092900] RTC time: 165:165:165, date: 165/165/65
Oct 12 08:18:45 host kernel: [    0.093018] NET: Registered protocol family 16
Oct 12 08:18:45 host kernel: [    0.093031] xen:grant_table: Grant tables using version 1 layout
Oct 12 08:18:45 host kernel: [    0.093038] Grant table initialized
Oct 12 08:18:45 host kernel: [    0.093369] PCI: setting up Xen PCI frontend stub
Oct 12 08:18:45 host kernel: [    0.093375] PCI: pci_cache_line_size set to 64 bytes
Oct 12 08:18:45 host kernel: [    0.097045] ACPI: Interpreter disabled.
Oct 12 08:18:45 host kernel: [    0.097045] xen:balloon: Initialising balloon driver
Oct 12 08:18:45 host kernel: [    0.104017] xen_balloon: Initialising balloon driver
Oct 12 08:18:45 host kernel: [    0.104041] vgaarb: loaded
Oct 12 08:18:45 host kernel: [    0.104075] SCSI subsystem initialized
Oct 12 08:18:45 host kernel: [    0.104104] libata version 3.00 loaded.
Oct 12 08:18:45 host kernel: [    0.104104] usbcore: registered new interface driver usbfs
Oct 12 08:18:45 host kernel: [    0.104104] usbcore: registered new interface driver hub
Oct 12 08:18:45 host kernel: [    0.104104] usbcore: registered new device driver usb
Oct 12 08:18:45 host kernel: [    0.104138] PCI: System does not support PCI
Oct 12 08:18:45 host kernel: [    0.104138] PCI: System does not support PCI
Oct 12 08:18:45 host kernel: [    0.104138] NetLabel: Initializing
Oct 12 08:18:45 host kernel: [    0.104140] NetLabel:  domain hash size = 128
Oct 12 08:18:45 host kernel: [    0.104142] NetLabel:  protocols = UNLABELED CIPSOv4
Oct 12 08:18:45 host kernel: [    0.104151] NetLabel:  unlabeled traffic allowed by default
Oct 12 08:18:45 host kernel: [    0.105125] Switched to clocksource xen
Oct 12 08:18:45 host kernel: [    0.108973] pnp: PnP ACPI: disabled
Oct 12 08:18:45 host kernel: [    0.110658] NET: Registered protocol family 2
Oct 12 08:18:45 host kernel: [    0.110799] TCP established hash table entries: 32768 (order: 6, 262144 bytes)
Oct 12 08:18:45 host kernel: [    0.110892] TCP bind hash table entries: 32768 (order: 7, 524288 bytes)
Oct 12 08:18:45 host kernel: [    0.110944] TCP: Hash tables configured (established 32768 bind 32768)
Oct 12 08:18:45 host kernel: [    0.110954] TCP: reno registered
Oct 12 08:18:45 host kernel: [    0.110965] UDP hash table entries: 2048 (order: 4, 65536 bytes)
Oct 12 08:18:45 host kernel: [    0.110981] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes)
Oct 12 08:18:45 host kernel: [    0.111026] NET: Registered protocol family 1
Oct 12 08:18:45 host kernel: [    0.111035] PCI: CLS 0 bytes, default 64
Oct 12 08:18:45 host kernel: [    0.111066] Unpacking initramfs...
Oct 12 08:18:45 host kernel: [    0.116631] Freeing initrd memory: 6984K (ffff880002269000 - ffff88000293b000)
Oct 12 08:18:45 host kernel: [    0.116715] platform rtc_cmos: registered platform RTC device (no PNP device found)
Oct 12 08:18:45 host kernel: [    0.117437] AVX2 version of gcm_enc/dec engaged.
Oct 12 08:18:45 host kernel: [    0.117441] AES CTR mode by8 optimization enabled
Oct 12 08:18:45 host kernel: [    0.118786] alg: No test for __gcm-aes-aesni (__driver-gcm-aes-aesni)
Oct 12 08:18:45 host kernel: [    0.119136] futex hash table entries: 2048 (order: 5, 131072 bytes)
Oct 12 08:18:45 host kernel: [    0.119159] Initialise system trusted keyring
Oct 12 08:18:45 host kernel: [    0.119176] audit: initializing netlink subsys (disabled)
Oct 12 08:18:45 host kernel: [    0.119186] audit: type=2000 audit(1444637788.753:1): initialized
Oct 12 08:18:45 host kernel: [    0.119390] HugeTLB registered 2 MB page size, pre-allocated 0 pages
Oct 12 08:18:45 host kernel: [    0.120296] zpool: loaded
Oct 12 08:18:45 host kernel: [    0.120299] zbud: loaded
Oct 12 08:18:45 host kernel: [    0.120435] VFS: Disk quotas dquot_6.5.2
Oct 12 08:18:45 host kernel: [    0.120460] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Oct 12 08:18:45 host kernel: [    0.120699] msgmni has been set to 618
Oct 12 08:18:45 host kernel: [    0.121223] alg: No test for stdrng (krng)
Oct 12 08:18:45 host kernel: [    0.121234] NET: Registered protocol family 38
Oct 12 08:18:45 host kernel: [    0.121241] Key type asymmetric registered
Oct 12 08:18:45 host kernel: [    0.121245] Asymmetric key parser 'x509' registered
Oct 12 08:18:45 host kernel: [    0.121272] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Oct 12 08:18:45 host kernel: [    0.121330] io scheduler noop registered
Oct 12 08:18:45 host kernel: [    0.121334] io scheduler deadline registered
Oct 12 08:18:45 host kernel: [    0.121357] io scheduler cfq registered (default)
Oct 12 08:18:45 host kernel: [    0.121424] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
Oct 12 08:18:45 host kernel: [    0.121436] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
Oct 12 08:18:45 host kernel: [    0.263401] intel_idle: does not run on family 6 model 70
Oct 12 08:18:45 host kernel: [    0.263829] xen:xen_evtchn: Event-channel device installed
Oct 12 08:18:45 host kernel: [    0.264183] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Oct 12 08:18:45 host kernel: [    0.264494] Non-volatile memory driver v1.3
Oct 12 08:18:45 host kernel: [    0.264611] libphy: Fixed MDIO Bus: probed
Oct 12 08:18:45 host kernel: [    0.264676] usbcore: registered new interface driver usbserial
Oct 12 08:18:45 host kernel: [    0.264683] usbcore: registered new interface driver usbserial_generic
Oct 12 08:18:45 host kernel: [    0.264689] usbserial: USB Serial support registered for generic
Oct 12 08:18:45 host kernel: [    0.264704] i8042: PNP: No PS/2 controller found. Probing ports directly.
Oct 12 08:18:45 host kernel: [    1.276100] i8042: No controller found
Oct 12 08:18:45 host kernel: [    1.276276] mousedev: PS/2 mouse device common for all mice
Oct 12 08:18:45 host kernel: [    1.336578] rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0
Oct 12 08:18:45 host kernel: [    1.336650] rtc_cmos: probe of rtc_cmos failed with error -38
Oct 12 08:18:45 host kernel: [    1.336725] device-mapper: uevent: version 1.0.3
Oct 12 08:18:45 host kernel: [    1.336808] device-mapper: ioctl: 4.28.0-ioctl (2014-09-17) initialised: dm-devel@redhat.com
Oct 12 08:18:45 host kernel: [    1.336911] hidraw: raw HID events driver (C) Jiri Kosina
Oct 12 08:18:45 host kernel: [    1.336992] usbcore: registered new interface driver usbhid
Oct 12 08:18:45 host kernel: [    1.336995] usbhid: USB HID core driver
Oct 12 08:18:45 host kernel: [    1.337032] drop_monitor: Initializing network drop monitor service
Oct 12 08:18:45 host kernel: [    1.337085] ip_tables: (C) 2000-2006 Netfilter Core Team
Oct 12 08:18:45 host kernel: [    1.337338] TCP: cubic registered
Oct 12 08:18:45 host kernel: [    1.337345] Initializing XFRM netlink socket
Oct 12 08:18:45 host kernel: [    1.337415] NET: Registered protocol family 10
Oct 12 08:18:45 host kernel: [    1.337601] NET: Registered protocol family 17
Oct 12 08:18:45 host kernel: [    1.337610] mce: Unable to init device /dev/mcelog (rc: -5)
Oct 12 08:18:45 host kernel: [    1.337758] Loading compiled-in X.509 certificates
Oct 12 08:18:45 host kernel: [    1.337769] registered taskstats version 1
Oct 12 08:18:45 host kernel: [    1.337820] xenbus_probe_frontend: Device with no driver: device/vbd/51712
Oct 12 08:18:45 host kernel: [    1.337823] xenbus_probe_frontend: Device with no driver: device/vbd/51728
Oct 12 08:18:45 host kernel: [    1.337825] xenbus_probe_frontend: Device with no driver: device/vbd/51744
Oct 12 08:18:45 host kernel: [    1.337827] xenbus_probe_frontend: Device with no driver: device/vbd/51760
Oct 12 08:18:45 host kernel: [    1.337893]   Magic number: 1:252:3141
Oct 12 08:18:45 host kernel: [    1.337913] /home/user/rpmbuild/BUILD/kernel-3.18.17/linux-3.18.17/drivers/rtc/hctosys.c: unable to open rtc device (rtc0)
Oct 12 08:18:45 host kernel: [    1.338421] Freeing unused kernel memory: 1468K (ffffffff81d1f000 - ffffffff81e8e000)
Oct 12 08:18:45 host kernel: [    1.338425] Write protecting the kernel read-only data: 12288k
Oct 12 08:18:45 host kernel: [    1.341782] Freeing unused kernel memory: 824K (ffff880001732000 - ffff880001800000)
Oct 12 08:18:45 host kernel: [    1.341998] Freeing unused kernel memory: 624K (ffff880001b64000 - ffff880001c00000)
Oct 12 08:18:45 host kernel: [    1.345324] random: modprobe urandom read with 35 bits of entropy available
Oct 12 08:18:45 host kernel: [    1.398497] blkfront: xvda: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 12 08:18:45 host kernel: [    1.406088]  xvda: unknown partition table
Oct 12 08:18:45 host kernel: [    1.420387] blkfront: xvdb: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 12 08:18:45 host kernel: [    1.423677]  xvdb: unknown partition table
Oct 12 08:18:45 host kernel: [    1.439781] blkfront: xvdc: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 12 08:18:45 host kernel: [    1.443312]  xvdc: xvdc1 xvdc2
Oct 12 08:18:45 host kernel: [    1.452810] blkfront: xvdd: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 12 08:18:45 host kernel: [    1.454104]  xvdd: unknown partition table
Oct 12 08:18:45 host kernel: [    1.492948] EXT4-fs (dm-0): couldn't mount as ext3 due to feature incompatibilities
Oct 12 08:18:45 host kernel: [    1.493070] EXT4-fs (dm-0): couldn't mount as ext2 due to feature incompatibilities
Oct 12 08:18:45 host kernel: [    1.495329] EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null)
Oct 12 08:18:45 host kernel: [    1.497503] EXT4-fs (xvdd): mounting ext3 file system using the ext4 subsystem
Oct 12 08:18:45 host kernel: [    1.505701] EXT4-fs (xvdd): mounted filesystem with ordered data mode. Opts: (null)
Oct 12 08:18:45 host kernel: [    1.680044] random: nonblocking pool is initialized
Oct 12 08:18:45 host kernel: [    1.964925] lp: driver loaded but no devices found
Oct 12 08:18:45 host kernel: [    1.967042] ppdev: user-space parallel port driver
Oct 12 08:18:45 host kernel: [    1.980371] dummy_hcd dummy_hcd.0: USB Host+Gadget Emulator, driver 02 May 2005
Oct 12 08:18:45 host kernel: [    1.980379] dummy_hcd dummy_hcd.0: Dummy host controller
Oct 12 08:18:45 host kernel: [    1.980426] dummy_hcd dummy_hcd.0: new USB bus registered, assigned bus number 1
Oct 12 08:18:45 host kernel: [    1.980560] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Oct 12 08:18:45 host kernel: [    1.980564] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 12 08:18:45 host kernel: [    1.980567] usb usb1: Product: Dummy host controller
Oct 12 08:18:45 host kernel: [    1.980570] usb usb1: Manufacturer: Linux 3.18.17-6.pvops.qubes.x86_64 dummy_hcd
Oct 12 08:18:45 host kernel: [    1.980572] usb usb1: SerialNumber: dummy_hcd.0
Oct 12 08:18:45 host kernel: [    1.980718] hub 1-0:1.0: USB hub found
Oct 12 08:18:45 host kernel: [    1.980744] hub 1-0:1.0: 1 port detected
Oct 12 08:18:45 host kernel: [    1.984326] EXT4-fs (dm-0): re-mounted. Opts: (null)
Oct 12 08:18:45 host kernel: [    2.076884] input: PC Speaker as /devices/platform/pcspkr/input/input0
Oct 12 08:18:45 host kernel: [    2.089117] alg: No test for crc32 (crc32-pclmul)
Oct 12 08:18:45 host kernel: [    2.096604] Error: Driver 'pcspkr' is already registered, aborting...
Oct 12 08:18:45 host kernel: [    2.100221] Adding 1052252k swap on /dev/xvdc1.  Priority:-1 extents:1 across:1052252k SSFS
Oct 12 08:18:45 host kernel: [    2.144355] nf_conntrack version 0.5.0 (2498 buckets, 9992 max)
Oct 12 08:18:45 host kernel: [    2.184076] ip6_tables: (C) 2000-2006 Netfilter Core Team
Oct 12 08:18:45 host kernel: [    2.338690] EXT4-fs (xvdb): mounted filesystem with ordered data mode. Opts: discard
Oct 14 05:56:14 host kernel: [    0.000000] Initializing cgroup subsys cpuset
Oct 14 05:56:14 host kernel: [    0.000000] Initializing cgroup subsys cpu
Oct 14 05:56:14 host kernel: [    0.000000] Initializing cgroup subsys cpuacct
Oct 14 05:56:14 host kernel: [    0.000000] Linux version 3.18.17-6.pvops.qubes.x86_64 (user@release) (gcc version 4.8.3 20140911 (Red Hat 4.8.3-7) (GCC) ) #1 SMP Sat Aug 8 21:27:00 UTC 2015
Oct 14 05:56:14 host kernel: [    0.000000] Command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH 3 nopat
Oct 14 05:56:14 host kernel: [    0.000000] ACPI in unprivileged domain disabled
Oct 14 05:56:14 host kernel: [    0.000000] Set 0 page(s) to 1-1 mapping
Oct 14 05:56:14 host kernel: [    0.000000] Remapped 0 page(s), last_pfn=109568
Oct 14 05:56:14 host kernel: [    0.000000] Released 0 page(s)
Oct 14 05:56:14 host kernel: [    0.000000] e820: BIOS-provided physical RAM map:
Oct 14 05:56:14 host kernel: [    0.000000] Xen: [mem 0x0000000000000000-0x000000000009ffff] usable
Oct 14 05:56:14 host kernel: [    0.000000] Xen: [mem 0x00000000000a0000-0x00000000000fffff] reserved
Oct 14 05:56:14 host kernel: [    0.000000] Xen: [mem 0x0000000000100000-0x00000000f9ffffff] usable
Oct 14 05:56:14 host kernel: [    0.000000] PAT support disabled.
Oct 14 05:56:14 host kernel: [    0.000000] NX (Execute Disable) protection: active
Oct 14 05:56:14 host kernel: [    0.000000] DMI not present or invalid.
Oct 14 05:56:14 host kernel: [    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Oct 14 05:56:14 host kernel: [    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
Oct 14 05:56:14 host kernel: [    0.000000] e820: last_pfn = 0xfa000 max_arch_pfn = 0x400000000
Oct 14 05:56:14 host kernel: [    0.000000] Base memory trampoline at [ffff88000009a000] 9a000 size 24576
Oct 14 05:56:14 host kernel: [    0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
Oct 14 05:56:14 host kernel: [    0.000000]  [mem 0x00000000-0x000fffff] page 4k
Oct 14 05:56:14 host kernel: [    0.000000] init_memory_mapping: [mem 0x1aa00000-0x1abfffff]
Oct 14 05:56:14 host kernel: [    0.000000]  [mem 0x1aa00000-0x1abfffff] page 4k
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02014000, 0x02014fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] init_memory_mapping: [mem 0x18000000-0x1a9fffff]
Oct 14 05:56:14 host kernel: [    0.000000]  [mem 0x18000000-0x1a9fffff] page 4k
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02015000, 0x02015fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02016000, 0x02016fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02017000, 0x02017fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02018000, 0x02018fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02019000, 0x02019fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] init_memory_mapping: [mem 0x00100000-0x17ffffff]
Oct 14 05:56:14 host kernel: [    0.000000]  [mem 0x00100000-0x17ffffff] page 4k
Oct 14 05:56:14 host kernel: [    0.000000] init_memory_mapping: [mem 0x1ac00000-0xf9ffffff]
Oct 14 05:56:14 host kernel: [    0.000000]  [mem 0x1ac00000-0xf9ffffff] page 4k
Oct 14 05:56:14 host kernel: [    0.000000] RAMDISK: [mem 0x02269000-0x0293afff]
Oct 14 05:56:14 host kernel: [    0.000000] NUMA turned off
Oct 14 05:56:14 host kernel: [    0.000000] Faking a node at [mem 0x0000000000000000-0x00000000f9ffffff]
Oct 14 05:56:14 host kernel: [    0.000000] NODE_DATA(0) allocated [mem 0x1a435000-0x1a448fff]
Oct 14 05:56:14 host kernel: [    0.000000] Zone ranges:
Oct 14 05:56:14 host kernel: [    0.000000]   DMA      [mem 0x00001000-0x00ffffff]
Oct 14 05:56:14 host kernel: [    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
Oct 14 05:56:14 host kernel: [    0.000000]   Normal   empty
Oct 14 05:56:14 host kernel: [    0.000000] Movable zone start for each node
Oct 14 05:56:14 host kernel: [    0.000000] Early memory node ranges
Oct 14 05:56:14 host kernel: [    0.000000]   node   0: [mem 0x00001000-0x0009ffff]
Oct 14 05:56:14 host kernel: [    0.000000]   node   0: [mem 0x00100000-0xf9ffffff]
Oct 14 05:56:14 host kernel: [    0.000000] Initmem setup node 0 [mem 0x00001000-0xf9ffffff]
Oct 14 05:56:14 host kernel: [    0.000000] On node 0 totalpages: 1023903
Oct 14 05:56:14 host kernel: [    0.000000]   DMA zone: 64 pages used for memmap
Oct 14 05:56:14 host kernel: [    0.000000]   DMA zone: 21 pages reserved
Oct 14 05:56:14 host kernel: [    0.000000]   DMA zone: 3999 pages, LIFO batch:0
Oct 14 05:56:14 host kernel: [    0.000000]   DMA32 zone: 15936 pages used for memmap
Oct 14 05:56:14 host kernel: [    0.000000]   DMA32 zone: 1019904 pages, LIFO batch:31
Oct 14 05:56:14 host kernel: [    0.000000] SFI: Simple Firmware Interface v0.81 http://simplefirmware.org
Oct 14 05:56:14 host kernel: [    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
Oct 14 05:56:14 host kernel: [    0.000000] e820: [mem 0xfa000000-0xffffffff] available for PCI devices
Oct 14 05:56:14 host kernel: [    0.000000] Booting paravirtualized kernel on Xen
Oct 14 05:56:14 host kernel: [    0.000000] Xen version: 4.4.2 (preserve-AD)
Oct 14 05:56:14 host kernel: [    0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:1 nr_node_ids:1
Oct 14 05:56:14 host kernel: [    0.000000] PERCPU: Embedded 30 pages/cpu @ffff880019e00000 s82560 r8192 d32128 u2097152
Oct 14 05:56:14 host kernel: [    0.000000] pcpu-alloc: s82560 r8192 d32128 u2097152 alloc=1*2097152
Oct 14 05:56:14 host kernel: [    0.000000] pcpu-alloc: [0] 0 
Oct 14 05:56:14 host kernel: [    0.000000] xen: PV spinlocks enabled
Oct 14 05:56:14 host kernel: [    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 1007882
Oct 14 05:56:14 host kernel: [    0.000000] Policy zone: DMA32
Oct 14 05:56:14 host kernel: [    0.000000] Kernel command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH 3 nopat
Oct 14 05:56:14 host kernel: [    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
Oct 14 05:56:14 host kernel: [    0.000000] xsave: enabled xstate_bv 0x7, cntxt size 0x340 using standard form
Oct 14 05:56:14 host kernel: [    0.000000] Memory: 339328K/4095612K available (7357K kernel code, 1142K rwdata, 3472K rodata, 1468K init, 1488K bss, 3756284K reserved)
Oct 14 05:56:14 host kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
Oct 14 05:56:14 host kernel: [    0.000000] Hierarchical RCU implementation.
Oct 14 05:56:14 host kernel: [    0.000000]     RCU dyntick-idle grace-period acceleration is enabled.
Oct 14 05:56:14 host kernel: [    0.000000]     RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=1.
Oct 14 05:56:14 host kernel: [    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
Oct 14 05:56:14 host kernel: [    0.000000] NR_IRQS:4352 nr_irqs:24 0
Oct 14 05:56:14 host kernel: [    0.000000] xen:events: Using FIFO-based ABI
Oct 14 05:56:14 host kernel: [    0.000000]     Offload RCU callbacks from all CPUs
Oct 14 05:56:14 host kernel: [    0.000000]     Offload RCU callbacks from CPUs: 0.
Oct 14 05:56:14 host kernel: [    0.000000] Console: colour dummy device 80x25
Oct 14 05:56:14 host kernel: [    0.000000] console [tty0] enabled
Oct 14 05:56:14 host kernel: [    0.000000] console [hvc0] enabled
Oct 14 05:56:14 host kernel: [    0.000000] allocated 16777216 bytes of page_cgroup
Oct 14 05:56:14 host kernel: [    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
Oct 14 05:56:14 host kernel: [    0.000000] Xen: using vcpuop timer interface
Oct 14 05:56:14 host kernel: [    0.000000] installing Xen timer for CPU 0
Oct 14 05:56:14 host kernel: [    0.000000] tsc: Detected 2195.024 MHz processor
Oct 14 05:56:14 host kernel: [    0.001000] Calibrating delay loop (skipped), value calculated using timer frequency.. 4390.04 BogoMIPS (lpj=2195024)
Oct 14 05:56:14 host kernel: [    0.001000] pid_max: default: 32768 minimum: 301
Oct 14 05:56:14 host kernel: [    0.001000] Security Framework initialized
Oct 14 05:56:14 host kernel: [    0.001000] AppArmor: AppArmor disabled by boot time parameter
Oct 14 05:56:14 host kernel: [    0.001000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes)
Oct 14 05:56:14 host kernel: [    0.001621] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes)
Oct 14 05:56:14 host kernel: [    0.001886] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes)
Oct 14 05:56:14 host kernel: [    0.001900] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes)
Oct 14 05:56:14 host kernel: [    0.002089] Initializing cgroup subsys memory
Oct 14 05:56:14 host kernel: [    0.002097] Initializing cgroup subsys devices
Oct 14 05:56:14 host kernel: [    0.002101] Initializing cgroup subsys freezer
Oct 14 05:56:14 host kernel: [    0.002104] Initializing cgroup subsys net_cls
Oct 14 05:56:14 host kernel: [    0.002108] Initializing cgroup subsys blkio
Oct 14 05:56:14 host kernel: [    0.002111] Initializing cgroup subsys perf_event
Oct 14 05:56:14 host kernel: [    0.002115] Initializing cgroup subsys net_prio
Oct 14 05:56:14 host kernel: [    0.002119] Initializing cgroup subsys hugetlb
Oct 14 05:56:14 host kernel: [    0.002173] ENERGY_PERF_BIAS: Set to 'normal', was 'performance'
Oct 14 05:56:14 host kernel: [    0.002173] ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8)
Oct 14 05:56:14 host kernel: [    0.002183] CPU: Physical Processor ID: 0
Oct 14 05:56:14 host kernel: [    0.002186] CPU: Processor Core ID: 3
Oct 14 05:56:14 host kernel: [    0.002983] Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024
Oct 14 05:56:14 host kernel: [    0.002983] Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4
Oct 14 05:56:14 host kernel: [    0.029231] Freeing SMP alternatives memory: 28K (ffffffff81e8e000 - ffffffff81e95000)
Oct 14 05:56:14 host kernel: [    0.031550] ftrace: allocating 27112 entries in 106 pages
Oct 14 05:56:14 host kernel: [    0.037063] cpu 0 spinlock event irq 17
Oct 14 05:56:14 host kernel: [    0.045575] Performance Events: unsupported p6 CPU model 70 no PMU driver, software events only.
Oct 14 05:56:14 host kernel: [    0.046652] x86: Booted up 1 node, 1 CPUs
Oct 14 05:56:14 host kernel: [    0.046689] NMI watchdog: disabled (cpu0): hardware events not enabled
Oct 14 05:56:14 host kernel: [    0.046742] devtmpfs: initialized
Oct 14 05:56:14 host kernel: [    0.048965] atomic64_test: passed for x86-64 platform with CX8 and with SSE
Oct 14 05:56:14 host kernel: [    0.048972] pinctrl core: initialized pinctrl subsystem
Oct 14 05:56:14 host kernel: [    0.068897] RTC time: 165:165:165, date: 165/165/65
Oct 14 05:56:14 host kernel: [    0.069028] NET: Registered protocol family 16
Oct 14 05:56:14 host kernel: [    0.069041] xen:grant_table: Grant tables using version 1 layout
Oct 14 05:56:14 host kernel: [    0.069049] Grant table initialized
Oct 14 05:56:14 host kernel: [    0.069386] PCI: setting up Xen PCI frontend stub
Oct 14 05:56:14 host kernel: [    0.069390] PCI: pci_cache_line_size set to 64 bytes
Oct 14 05:56:14 host kernel: [    0.070817] ACPI: Interpreter disabled.
Oct 14 05:56:14 host kernel: [    0.070830] xen:balloon: Initialising balloon driver
Oct 14 05:56:14 host kernel: [    0.078032] xen_balloon: Initialising balloon driver
Oct 14 05:56:14 host kernel: [    0.079095] vgaarb: loaded
Oct 14 05:56:14 host kernel: [    0.079153] SCSI subsystem initialized
Oct 14 05:56:14 host kernel: [    0.079175] libata version 3.00 loaded.
Oct 14 05:56:14 host kernel: [    0.079207] usbcore: registered new interface driver usbfs
Oct 14 05:56:14 host kernel: [    0.079214] usbcore: registered new interface driver hub
Oct 14 05:56:14 host kernel: [    0.079219] usbcore: registered new device driver usb
Oct 14 05:56:14 host kernel: [    0.079282] PCI: System does not support PCI
Oct 14 05:56:14 host kernel: [    0.079285] PCI: System does not support PCI
Oct 14 05:56:14 host kernel: [    0.079356] NetLabel: Initializing
Oct 14 05:56:14 host kernel: [    0.079358] NetLabel:  domain hash size = 128
Oct 14 05:56:14 host kernel: [    0.079359] NetLabel:  protocols = UNLABELED CIPSOv4
Oct 14 05:56:14 host kernel: [    0.079369] NetLabel:  unlabeled traffic allowed by default
Oct 14 05:56:14 host kernel: [    0.079417] Switched to clocksource xen
Oct 14 05:56:14 host kernel: [    0.082264] pnp: PnP ACPI: disabled
Oct 14 05:56:14 host kernel: [    0.083018] NET: Registered protocol family 2
Oct 14 05:56:14 host kernel: [    0.083143] TCP established hash table entries: 32768 (order: 6, 262144 bytes)
Oct 14 05:56:14 host kernel: [    0.083229] TCP bind hash table entries: 32768 (order: 7, 524288 bytes)
Oct 14 05:56:14 host kernel: [    0.083275] TCP: Hash tables configured (established 32768 bind 32768)
Oct 14 05:56:14 host kernel: [    0.083285] TCP: reno registered
Oct 14 05:56:14 host kernel: [    0.083296] UDP hash table entries: 2048 (order: 4, 65536 bytes)
Oct 14 05:56:14 host kernel: [    0.083312] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes)
Oct 14 05:56:14 host kernel: [    0.083341] NET: Registered protocol family 1
Oct 14 05:56:14 host kernel: [    0.083350] PCI: CLS 0 bytes, default 64
Oct 14 05:56:14 host kernel: [    0.083384] Unpacking initramfs...
Oct 14 05:56:14 host kernel: [    0.088461] Freeing initrd memory: 6984K (ffff880002269000 - ffff88000293b000)
Oct 14 05:56:14 host kernel: [    0.088539] platform rtc_cmos: registered platform RTC device (no PNP device found)
Oct 14 05:56:14 host kernel: [    0.088721] AVX2 version of gcm_enc/dec engaged.
Oct 14 05:56:14 host kernel: [    0.088724] AES CTR mode by8 optimization enabled
Oct 14 05:56:14 host kernel: [    0.089816] alg: No test for __gcm-aes-aesni (__driver-gcm-aes-aesni)
Oct 14 05:56:14 host kernel: [    0.089981] futex hash table entries: 256 (order: 2, 16384 bytes)
Oct 14 05:56:14 host kernel: [    0.089989] Initialise system trusted keyring
Oct 14 05:56:14 host kernel: [    0.090010] audit: initializing netlink subsys (disabled)
Oct 14 05:56:14 host kernel: [    0.090021] audit: type=2000 audit(1444802116.223:1): initialized
Oct 14 05:56:14 host kernel: [    0.090200] HugeTLB registered 2 MB page size, pre-allocated 0 pages
Oct 14 05:56:14 host kernel: [    0.091078] zpool: loaded
Oct 14 05:56:14 host kernel: [    0.091083] zbud: loaded
Oct 14 05:56:14 host kernel: [    0.091288] VFS: Disk quotas dquot_6.5.2
Oct 14 05:56:14 host kernel: [    0.091312] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Oct 14 05:56:14 host kernel: [    0.183841] msgmni has been set to 676
Oct 14 05:56:14 host kernel: [    0.184302] alg: No test for stdrng (krng)
Oct 14 05:56:14 host kernel: [    0.184312] NET: Registered protocol family 38
Oct 14 05:56:14 host kernel: [    0.184320] Key type asymmetric registered
Oct 14 05:56:14 host kernel: [    0.184324] Asymmetric key parser 'x509' registered
Oct 14 05:56:14 host kernel: [    0.184362] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Oct 14 05:56:14 host kernel: [    0.184398] io scheduler noop registered
Oct 14 05:56:14 host kernel: [    0.184403] io scheduler deadline registered
Oct 14 05:56:14 host kernel: [    0.184435] io scheduler cfq registered (default)
Oct 14 05:56:14 host kernel: [    0.184518] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
Oct 14 05:56:14 host kernel: [    0.184537] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
Oct 14 05:56:14 host kernel: [    0.184592] intel_idle: does not run on family 6 model 70
Oct 14 05:56:14 host kernel: [    0.184666] xen:xen_evtchn: Event-channel device installed
Oct 14 05:56:14 host kernel: [    0.184856] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Oct 14 05:56:14 host kernel: [    0.185180] Non-volatile memory driver v1.3
Oct 14 05:56:14 host kernel: [    0.185341] libphy: Fixed MDIO Bus: probed
Oct 14 05:56:14 host kernel: [    0.185435] usbcore: registered new interface driver usbserial
Oct 14 05:56:14 host kernel: [    0.185454] usbcore: registered new interface driver usbserial_generic
Oct 14 05:56:14 host kernel: [    0.185464] usbserial: USB Serial support registered for generic
Oct 14 05:56:14 host kernel: [    0.185487] i8042: PNP: No PS/2 controller found. Probing ports directly.
Oct 14 05:56:14 host kernel: [    1.205442] i8042: No controller found
Oct 14 05:56:14 host kernel: [    1.205577] mousedev: PS/2 mouse device common for all mice
Oct 14 05:56:14 host kernel: [    1.265805] rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0
Oct 14 05:56:14 host kernel: [    1.265852] rtc_cmos: probe of rtc_cmos failed with error -38
Oct 14 05:56:14 host kernel: [    1.265908] device-mapper: uevent: version 1.0.3
Oct 14 05:56:14 host kernel: [    1.265955] device-mapper: ioctl: 4.28.0-ioctl (2014-09-17) initialised: dm-devel@redhat.com
Oct 14 05:56:14 host kernel: [    1.266052] hidraw: raw HID events driver (C) Jiri Kosina
Oct 14 05:56:14 host kernel: [    1.266129] usbcore: registered new interface driver usbhid
Oct 14 05:56:14 host kernel: [    1.266131] usbhid: USB HID core driver
Oct 14 05:56:14 host kernel: [    1.266171] drop_monitor: Initializing network drop monitor service
Oct 14 05:56:14 host kernel: [    1.266224] ip_tables: (C) 2000-2006 Netfilter Core Team
Oct 14 05:56:14 host kernel: [    1.266297] TCP: cubic registered
Oct 14 05:56:14 host kernel: [    1.266303] Initializing XFRM netlink socket
Oct 14 05:56:14 host kernel: [    1.266370] NET: Registered protocol family 10
Oct 14 05:56:14 host kernel: [    1.266503] NET: Registered protocol family 17
Oct 14 05:56:14 host kernel: [    1.266512] mce: Unable to init device /dev/mcelog (rc: -5)
Oct 14 05:56:14 host kernel: [    1.266615] Loading compiled-in X.509 certificates
Oct 14 05:56:14 host kernel: [    1.266626] registered taskstats version 1
Oct 14 05:56:14 host kernel: [    1.266664] xenbus_probe_frontend: Device with no driver: device/vbd/51712
Oct 14 05:56:14 host kernel: [    1.266667] xenbus_probe_frontend: Device with no driver: device/vbd/51728
Oct 14 05:56:14 host kernel: [    1.266669] xenbus_probe_frontend: Device with no driver: device/vbd/51744
Oct 14 05:56:14 host kernel: [    1.266671] xenbus_probe_frontend: Device with no driver: device/vbd/51760
Oct 14 05:56:14 host kernel: [    1.266673] xenbus_probe_frontend: Device with no driver: device/vif/0
Oct 14 05:56:14 host kernel: [    1.266694]   Magic number: 1:252:3141
Oct 14 05:56:14 host kernel: [    1.266712] /home/user/rpmbuild/BUILD/kernel-3.18.17/linux-3.18.17/drivers/rtc/hctosys.c: unable to open rtc device (rtc0)
Oct 14 05:56:14 host kernel: [    1.267192] Freeing unused kernel memory: 1468K (ffffffff81d1f000 - ffffffff81e8e000)
Oct 14 05:56:14 host kernel: [    1.267197] Write protecting the kernel read-only data: 12288k
Oct 14 05:56:14 host kernel: [    1.270248] Freeing unused kernel memory: 824K (ffff880001732000 - ffff880001800000)
Oct 14 05:56:14 host kernel: [    1.270439] Freeing unused kernel memory: 624K (ffff880001b64000 - ffff880001c00000)
Oct 14 05:56:14 host kernel: [    1.272704] random: modprobe urandom read with 5 bits of entropy available
Oct 14 05:56:14 host kernel: [    1.331491] blkfront: xvda: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 14 05:56:14 host kernel: [    1.338208]  xvda: unknown partition table
Oct 14 05:56:14 host kernel: [    1.376515] blkfront: xvdb: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 14 05:56:14 host kernel: [    1.381588]  xvdb: unknown partition table
Oct 14 05:56:14 host kernel: [    1.398850] blkfront: xvdc: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 14 05:56:14 host kernel: [    1.401564]  xvdc: xvdc1 xvdc2
Oct 14 05:56:14 host kernel: [    1.426600] blkfront: xvdd: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 14 05:56:14 host kernel: [    1.427517]  xvdd: unknown partition table
Oct 14 05:56:14 host kernel: [    1.449282] EXT4-fs (dm-0): couldn't mount as ext3 due to feature incompatibilities
Oct 14 05:56:14 host kernel: [    1.449476] EXT4-fs (dm-0): couldn't mount as ext2 due to feature incompatibilities
Oct 14 05:56:14 host kernel: [    1.452508] EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null)
Oct 14 05:56:14 host kernel: [    1.458390] EXT4-fs (xvdd): mounting ext3 file system using the ext4 subsystem
Oct 14 05:56:14 host kernel: [    1.459267] EXT4-fs (xvdd): mounted filesystem with ordered data mode. Opts: (null)
Oct 14 05:56:14 host kernel: [    1.873104] random: nonblocking pool is initialized
Oct 14 05:56:14 host kernel: [    1.880632] lp: driver loaded but no devices found
Oct 14 05:56:14 host kernel: [    1.882339] ppdev: user-space parallel port driver
Oct 14 05:56:14 host kernel: [    2.027636] dummy_hcd dummy_hcd.0: USB Host+Gadget Emulator, driver 02 May 2005
Oct 14 05:56:14 host kernel: [    2.027645] dummy_hcd dummy_hcd.0: Dummy host controller
Oct 14 05:56:14 host kernel: [    2.028929] dummy_hcd dummy_hcd.0: new USB bus registered, assigned bus number 1
Oct 14 05:56:14 host kernel: [    2.028963] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Oct 14 05:56:14 host kernel: [    2.028967] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 14 05:56:14 host kernel: [    2.028969] usb usb1: Product: Dummy host controller
Oct 14 05:56:14 host kernel: [    2.028972] usb usb1: Manufacturer: Linux 3.18.17-6.pvops.qubes.x86_64 dummy_hcd
Oct 14 05:56:14 host kernel: [    2.028974] usb usb1: SerialNumber: dummy_hcd.0
Oct 14 05:56:14 host kernel: [    2.029047] hub 1-0:1.0: USB hub found
Oct 14 05:56:14 host kernel: [    2.029054] hub 1-0:1.0: 1 port detected
Oct 14 05:56:14 host kernel: [    2.089784] EXT4-fs (dm-0): re-mounted. Opts: (null)
Oct 14 05:56:14 host kernel: [    2.123795] input: PC Speaker as /devices/platform/pcspkr/input/input0
Oct 14 05:56:14 host kernel: [    2.169834] nf_conntrack version 0.5.0 (2728 buckets, 10912 max)
Oct 14 05:56:14 host kernel: [    2.177175] Error: Driver 'pcspkr' is already registered, aborting...
Oct 14 05:56:14 host kernel: [    2.190176] xen_netfront: Initialising Xen virtual ethernet driver
Oct 14 05:56:14 host kernel: [    2.220036] alg: No test for crc32 (crc32-pclmul)
Oct 14 05:56:14 host kernel: [    2.241511] ip6_tables: (C) 2000-2006 Netfilter Core Team
Oct 14 05:56:14 host kernel: [    5.290544] Adding 1052252k swap on /dev/xvdc1.  Priority:-1 extents:1 across:1052252k SSFS
Oct 14 05:56:14 host kernel: [    5.460525] EXT4-fs (xvdb): recovery complete
Oct 14 05:56:14 host kernel: [    5.469273] EXT4-fs (xvdb): mounted filesystem with ordered data mode. Opts: discard
Oct 14 05:56:24 host kernel: [   15.479389] vbd vbd-51728: 16 Device in use; refusing to close
Oct 14 05:56:34 host kernel: [   25.483142] xen:grant_table: WARNING: g.e. 0x37f still in use!
Oct 14 05:56:34 host kernel: [   25.483152] deferring g.e. 0x37f (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483156] xen:grant_table: WARNING: g.e. 0x381 still in use!
Oct 14 05:56:34 host kernel: [   25.483159] deferring g.e. 0x381 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483160] xen:grant_table: WARNING: g.e. 0x382 still in use!
Oct 14 05:56:34 host kernel: [   25.483163] deferring g.e. 0x382 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483164] xen:grant_table: WARNING: g.e. 0x383 still in use!
Oct 14 05:56:34 host kernel: [   25.483167] deferring g.e. 0x383 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483168] xen:grant_table: WARNING: g.e. 0x380 still in use!
Oct 14 05:56:34 host kernel: [   25.483171] deferring g.e. 0x380 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483172] xen:grant_table: WARNING: g.e. 0x340 still in use!
Oct 14 05:56:34 host kernel: [   25.483175] deferring g.e. 0x340 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483177] xen:grant_table: WARNING: g.e. 0x384 still in use!
Oct 14 05:56:34 host kernel: [   25.483180] deferring g.e. 0x384 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483181] xen:grant_table: WARNING: g.e. 0x385 still in use!
Oct 14 05:56:34 host kernel: [   25.483183] deferring g.e. 0x385 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483184] xen:grant_table: WARNING: g.e. 0x386 still in use!
Oct 14 05:56:34 host kernel: [   25.483186] deferring g.e. 0x386 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483187] xen:grant_table: WARNING: g.e. 0x387 still in use!
Oct 14 05:56:34 host kernel: [   25.483188] deferring g.e. 0x387 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483189] xen:grant_table: WARNING: g.e. 0x388 still in use!
Oct 14 05:56:34 host kernel: [   25.483191] deferring g.e. 0x388 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483192] xen:grant_table: WARNING: g.e. 0x38e still in use!
Oct 14 05:56:34 host kernel: [   25.483194] deferring g.e. 0x38e (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483194] xen:grant_table: WARNING: g.e. 0x38f still in use!
Oct 14 05:56:34 host kernel: [   25.483196] deferring g.e. 0x38f (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483197] xen:grant_table: WARNING: g.e. 0x390 still in use!
Oct 14 05:56:34 host kernel: [   25.483199] deferring g.e. 0x390 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483199] xen:grant_table: WARNING: g.e. 0x391 still in use!
Oct 14 05:56:34 host kernel: [   25.483201] deferring g.e. 0x391 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483202] xen:grant_table: WARNING: g.e. 0x392 still in use!
Oct 14 05:56:34 host kernel: [   25.483204] deferring g.e. 0x392 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483204] xen:grant_table: WARNING: g.e. 0x393 still in use!
Oct 14 05:56:34 host kernel: [   25.483206] deferring g.e. 0x393 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483207] xen:grant_table: WARNING: g.e. 0x394 still in use!
Oct 14 05:56:34 host kernel: [   25.483210] deferring g.e. 0x394 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483211] xen:grant_table: WARNING: g.e. 0x395 still in use!
Oct 14 05:56:34 host kernel: [   25.483213] deferring g.e. 0x395 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483215] xen:grant_table: WARNING: g.e. 0x396 still in use!
Oct 14 05:56:34 host kernel: [   25.483217] deferring g.e. 0x396 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483218] xen:grant_table: WARNING: g.e. 0x39a still in use!
Oct 14 05:56:34 host kernel: [   25.483222] deferring g.e. 0x39a (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483223] xen:grant_table: WARNING: g.e. 0x399 still in use!
Oct 14 05:56:34 host kernel: [   25.483226] deferring g.e. 0x399 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483227] xen:grant_table: WARNING: g.e. 0x37e still in use!
Oct 14 05:56:34 host kernel: [   25.483230] deferring g.e. 0x37e (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483231] xen:grant_table: WARNING: g.e. 0x37d still in use!
Oct 14 05:56:34 host kernel: [   25.483234] deferring g.e. 0x37d (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483234] xen:grant_table: WARNING: g.e. 0x37c still in use!
Oct 14 05:56:34 host kernel: [   25.483237] deferring g.e. 0x37c (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483238] xen:grant_table: WARNING: g.e. 0x38a still in use!
Oct 14 05:56:34 host kernel: [   25.483240] deferring g.e. 0x38a (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483241] xen:grant_table: WARNING: g.e. 0x389 still in use!
Oct 14 05:56:34 host kernel: [   25.483243] deferring g.e. 0x389 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483244] xen:grant_table: WARNING: g.e. 0x38b still in use!
Oct 14 05:56:34 host kernel: [   25.483247] deferring g.e. 0x38b (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483248] xen:grant_table: WARNING: g.e. 0x38d still in use!
Oct 14 05:56:34 host kernel: [   25.483251] deferring g.e. 0x38d (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483252] xen:grant_table: WARNING: g.e. 0x38c still in use!
Oct 14 05:56:34 host kernel: [   25.483255] deferring g.e. 0x38c (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483256] xen:grant_table: WARNING: g.e. 0x398 still in use!
Oct 14 05:56:34 host kernel: [   25.483259] deferring g.e. 0x398 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483261] xen:grant_table: WARNING: g.e. 0x397 still in use!
Oct 14 05:56:34 host kernel: [   25.483264] deferring g.e. 0x397 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483264] xen:grant_table: WARNING: g.e. 0x37b still in use!
Oct 14 05:56:34 host kernel: [   25.483266] deferring g.e. 0x37b (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483267] xen:grant_table: WARNING: g.e. 0x37a still in use!
Oct 14 05:56:34 host kernel: [   25.483269] deferring g.e. 0x37a (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483270] xen:grant_table: WARNING: g.e. 0x379 still in use!
Oct 14 05:56:34 host kernel: [   25.483271] deferring g.e. 0x379 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483272] xen:grant_table: WARNING: g.e. 0x378 still in use!
Oct 14 05:56:34 host kernel: [   25.483275] deferring g.e. 0x378 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483276] xen:grant_table: WARNING: g.e. 0x377 still in use!
Oct 14 05:56:34 host kernel: [   25.483280] deferring g.e. 0x377 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483284] xen:grant_table: WARNING: g.e. 0x376 still in use!
Oct 14 05:56:34 host kernel: [   25.483287] deferring g.e. 0x376 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483288] xen:grant_table: WARNING: g.e. 0x375 still in use!
Oct 14 05:56:34 host kernel: [   25.483291] deferring g.e. 0x375 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483292] xen:grant_table: WARNING: g.e. 0x374 still in use!
Oct 14 05:56:34 host kernel: [   25.483295] deferring g.e. 0x374 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483296] xen:grant_table: WARNING: g.e. 0x373 still in use!
Oct 14 05:56:34 host kernel: [   25.483299] deferring g.e. 0x373 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483300] xen:grant_table: WARNING: g.e. 0x372 still in use!
Oct 14 05:56:34 host kernel: [   25.483303] deferring g.e. 0x372 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483304] xen:grant_table: WARNING: g.e. 0x371 still in use!
Oct 14 05:56:34 host kernel: [   25.483307] deferring g.e. 0x371 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483308] xen:grant_table: WARNING: g.e. 0x370 still in use!
Oct 14 05:56:34 host kernel: [   25.483311] deferring g.e. 0x370 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483313] xen:grant_table: WARNING: g.e. 0x36f still in use!
Oct 14 05:56:34 host kernel: [   25.483316] deferring g.e. 0x36f (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483317] xen:grant_table: WARNING: g.e. 0x36e still in use!
Oct 14 05:56:34 host kernel: [   25.483320] deferring g.e. 0x36e (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483321] xen:grant_table: WARNING: g.e. 0x36d still in use!
Oct 14 05:56:34 host kernel: [   25.483323] deferring g.e. 0x36d (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483324] xen:grant_table: WARNING: g.e. 0x36c still in use!
Oct 14 05:56:34 host kernel: [   25.483328] deferring g.e. 0x36c (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483329] xen:grant_table: WARNING: g.e. 0x36b still in use!
Oct 14 05:56:34 host kernel: [   25.483332] deferring g.e. 0x36b (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483333] xen:grant_table: WARNING: g.e. 0x36a still in use!
Oct 14 05:56:34 host kernel: [   25.483336] deferring g.e. 0x36a (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483337] xen:grant_table: WARNING: g.e. 0x369 still in use!
Oct 14 05:56:34 host kernel: [   25.483340] deferring g.e. 0x369 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483503] block xvdb: device/vbd/51728 was hot-unplugged, 1 stale handles
Oct 14 05:56:35 host kernel: [   26.484067] xen:grant_table: freeing g.e. 0x37f
Oct 14 05:56:35 host kernel: [   26.484121] xen:grant_table: freeing g.e. 0x381
Oct 14 05:56:35 host kernel: [   26.484134] xen:grant_table: freeing g.e. 0x382
Oct 14 05:56:35 host kernel: [   26.484145] xen:grant_table: freeing g.e. 0x383
Oct 14 05:56:35 host kernel: [   26.484155] xen:grant_table: freeing g.e. 0x380
Oct 14 05:56:35 host kernel: [   26.484166] xen:grant_table: freeing g.e. 0x340
Oct 14 05:56:35 host kernel: [   26.484176] xen:grant_table: freeing g.e. 0x384
Oct 14 05:56:35 host kernel: [   26.484186] xen:grant_table: freeing g.e. 0x385
Oct 14 05:56:35 host kernel: [   26.484196] xen:grant_table: freeing g.e. 0x386
Oct 14 05:56:35 host kernel: [   26.484207] xen:grant_table: freeing g.e. 0x387
Oct 14 05:57:37 host kernel: [   26.617782] Freezing user space processes ... (elapsed 0.001 seconds) done.
Oct 14 05:57:37 host kernel: [   26.618924] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
Oct 14 05:57:37 host kernel: [   26.620054] PM: freeze of devices complete after 0.054 msecs
Oct 14 05:57:37 host kernel: [   26.620061] suspending xenstore...
Oct 14 05:57:37 host kernel: [   26.620095] PM: late freeze of devices complete after 0.032 msecs
Oct 14 05:57:37 host kernel: [   26.620129] PM: noirq freeze of devices complete after 0.030 msecs
Oct 14 05:57:37 host kernel: [   26.621056] xen:grant_table: Grant tables using version 1 layout
Oct 14 05:57:37 host kernel: [   26.621056] Using NULL legacy PIC
Oct 14 05:57:37 host kernel: [   26.621056] PM: noirq restore of devices complete after 0.043 msecs
Oct 14 05:57:37 host kernel: [   26.621056] PM: early restore of devices complete after 0.024 msecs
Oct 14 05:57:37 host kernel: [   26.718449] PM: restore of devices complete after 97.335 msecs
Oct 14 05:57:37 host kernel: [   26.718486] Restarting tasks ... done.
Oct 14 05:57:37 host pulseaudio[1831]: vchan module loading
Oct 14 05:57:37 host kernel: [   26.821737] Setting capacity to 20971520
Oct 14 05:57:38 host pulseaudio[1831]: play libvchan_fd_for_select=19, ctrl=0x212e620
Oct 14 05:57:38 host pulseaudio[1831]: rec libvchan_fd_for_select=22, ctrl=0x212f0b0
Oct 14 05:57:38 host pulseaudio[1831]: sink cork req state =1, now state=-2
Oct 14 05:57:38 host pulseaudio[1831]: source cork req state =1, now state=-2
Oct 14 05:57:38 host pulseaudio[1831]: Failed to open cookie file '/home/user/.config/pulse/cookie': No such file or directory
Oct 14 05:57:38 host pulseaudio[1831]: Failed to load authorization key '/home/user/.config/pulse/cookie': No such file or directory
Oct 14 05:57:38 host kernel: [   27.486025] xen:grant_table: freeing g.e. 0x388
Oct 14 05:57:38 host kernel: [   27.486043] xen:grant_table: freeing g.e. 0x38e
Oct 14 05:57:38 host kernel: [   27.486049] xen:grant_table: freeing g.e. 0x38f
Oct 14 05:57:38 host kernel: [   27.486054] xen:grant_table: freeing g.e. 0x390
Oct 14 05:57:38 host kernel: [   27.486059] xen:grant_table: freeing g.e. 0x391
Oct 14 05:57:38 host kernel: [   27.486066] xen:grant_table: freeing g.e. 0x392
Oct 14 05:57:38 host kernel: [   27.486074] xen:grant_table: freeing g.e. 0x393
Oct 14 05:57:38 host kernel: [   27.486081] xen:grant_table: freeing g.e. 0x394
Oct 14 05:57:38 host kernel: [   27.486093] xen:grant_table: freeing g.e. 0x395
Oct 14 05:57:38 host kernel: [   27.486102] xen:grant_table: freeing g.e. 0x396
Oct 14 05:57:39 host kernel: [   28.488045] xen:grant_table: freeing g.e. 0x39a
Oct 14 05:57:39 host kernel: [   28.488071] xen:grant_table: freeing g.e. 0x399
Oct 14 05:57:39 host kernel: [   28.488078] xen:grant_table: freeing g.e. 0x37e
Oct 14 05:57:39 host kernel: [   28.488087] xen:grant_table: freeing g.e. 0x37d
Oct 14 05:57:39 host kernel: [   28.488094] xen:grant_table: freeing g.e. 0x37c
Oct 14 05:57:39 host kernel: [   28.488101] xen:grant_table: freeing g.e. 0x38a
Oct 14 05:57:39 host kernel: [   28.488108] xen:grant_table: freeing g.e. 0x389
Oct 14 05:57:39 host kernel: [   28.488114] xen:grant_table: freeing g.e. 0x38b
Oct 14 05:57:39 host kernel: [   28.488121] xen:grant_table: freeing g.e. 0x38d
Oct 14 05:57:39 host kernel: [   28.488127] xen:grant_table: freeing g.e. 0x38c
Oct 14 05:57:40 host kernel: [   29.490049] xen:grant_table: freeing g.e. 0x398
Oct 14 05:57:40 host kernel: [   29.490092] xen:grant_table: freeing g.e. 0x397
Oct 14 05:57:40 host kernel: [   29.490106] xen:grant_table: freeing g.e. 0x37b
Oct 14 05:57:40 host kernel: [   29.490116] xen:grant_table: freeing g.e. 0x37a
Oct 14 05:57:40 host kernel: [   29.490126] xen:grant_table: freeing g.e. 0x379
Oct 14 05:57:40 host kernel: [   29.490136] xen:grant_table: freeing g.e. 0x378
Oct 14 05:57:40 host kernel: [   29.490146] xen:grant_table: freeing g.e. 0x377
Oct 14 05:57:40 host kernel: [   29.490155] xen:grant_table: freeing g.e. 0x376
Oct 14 05:57:40 host kernel: [   29.490165] xen:grant_table: freeing g.e. 0x375
Oct 14 05:57:40 host kernel: [   29.490175] xen:grant_table: freeing g.e. 0x374
Oct 14 05:57:41 host kernel: [   30.492057] xen:grant_table: freeing g.e. 0x373
Oct 14 05:57:41 host kernel: [   30.492103] xen:grant_table: freeing g.e. 0x372
Oct 14 05:57:41 host kernel: [   30.492115] xen:grant_table: freeing g.e. 0x371
Oct 14 05:57:41 host kernel: [   30.492125] xen:grant_table: freeing g.e. 0x370
Oct 14 05:57:41 host kernel: [   30.492135] xen:grant_table: freeing g.e. 0x36f
Oct 14 05:57:41 host kernel: [   30.492145] xen:grant_table: freeing g.e. 0x36e
Oct 14 05:57:41 host kernel: [   30.492155] xen:grant_table: freeing g.e. 0x36d
Oct 14 05:57:41 host kernel: [   30.492165] xen:grant_table: freeing g.e. 0x36c
Oct 14 05:57:41 host kernel: [   30.492175] xen:grant_table: freeing g.e. 0x36b
Oct 14 05:57:41 host kernel: [   30.492185] xen:grant_table: freeing g.e. 0x36a
Oct 14 05:57:42 host kernel: [   31.494061] xen:grant_table: freeing g.e. 0x369
Oct 14 05:57:43 host pulseaudio[1831]: source cork req state =2, now state=1
Oct 14 05:57:43 host pulseaudio[1831]: sink cork req state =2, now state=1
Member

adrelanos commented Oct 14, 2015

Yes, also happens in the new images from #1321 (comment).

Does not happen in other (Whonix) AppVMs. Only in whonix-ws-dvm.

DispVM /var/log/kern.log:

user@host:~$ cat /var/log/kern.log 
Oct 12 08:18:45 host kernel: [    0.000000] Initializing cgroup subsys cpuset
Oct 12 08:18:45 host kernel: [    0.000000] Initializing cgroup subsys cpu
Oct 12 08:18:45 host kernel: [    0.000000] Initializing cgroup subsys cpuacct
Oct 12 08:18:45 host kernel: [    0.000000] Linux version 3.18.17-6.pvops.qubes.x86_64 (user@release) (gcc version 4.8.3 20140911 (Red Hat 4.8.3-7) (GCC) ) #1 SMP Sat Aug 8 21:27:00 UTC 2015
Oct 12 08:18:45 host kernel: [    0.000000] Command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH 3 nopat
Oct 12 08:18:45 host kernel: [    0.000000] ACPI in unprivileged domain disabled
Oct 12 08:18:45 host kernel: [    0.000000] Set 0 page(s) to 1-1 mapping
Oct 12 08:18:45 host kernel: [    0.000000] Remapped 0 page(s), last_pfn=102400
Oct 12 08:18:45 host kernel: [    0.000000] Released 0 page(s)
Oct 12 08:18:45 host kernel: [    0.000000] e820: BIOS-provided physical RAM map:
Oct 12 08:18:45 host kernel: [    0.000000] Xen: [mem 0x0000000000000000-0x000000000009ffff] usable
Oct 12 08:18:45 host kernel: [    0.000000] Xen: [mem 0x00000000000a0000-0x00000000000fffff] reserved
Oct 12 08:18:45 host kernel: [    0.000000] Xen: [mem 0x0000000000100000-0x00000000f9ffffff] usable
Oct 12 08:18:45 host kernel: [    0.000000] PAT support disabled.
Oct 12 08:18:45 host kernel: [    0.000000] NX (Execute Disable) protection: active
Oct 12 08:18:45 host kernel: [    0.000000] DMI not present or invalid.
Oct 12 08:18:45 host kernel: [    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Oct 12 08:18:45 host kernel: [    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
Oct 12 08:18:45 host kernel: [    0.000000] e820: last_pfn = 0xfa000 max_arch_pfn = 0x400000000
Oct 12 08:18:45 host kernel: [    0.000000] Base memory trampoline at [ffff88000009a000] 9a000 size 24576
Oct 12 08:18:45 host kernel: [    0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
Oct 12 08:18:45 host kernel: [    0.000000]  [mem 0x00000000-0x000fffff] page 4k
Oct 12 08:18:45 host kernel: [    0.000000] init_memory_mapping: [mem 0x18e00000-0x18ffffff]
Oct 12 08:18:45 host kernel: [    0.000000]  [mem 0x18e00000-0x18ffffff] page 4k
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02014000, 0x02014fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] init_memory_mapping: [mem 0x18000000-0x18dfffff]
Oct 12 08:18:45 host kernel: [    0.000000]  [mem 0x18000000-0x18dfffff] page 4k
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02015000, 0x02015fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02016000, 0x02016fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02017000, 0x02017fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02018000, 0x02018fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] BRK [0x02019000, 0x02019fff] PGTABLE
Oct 12 08:18:45 host kernel: [    0.000000] init_memory_mapping: [mem 0x00100000-0x17ffffff]
Oct 12 08:18:45 host kernel: [    0.000000]  [mem 0x00100000-0x17ffffff] page 4k
Oct 12 08:18:45 host kernel: [    0.000000] init_memory_mapping: [mem 0x19000000-0xf9ffffff]
Oct 12 08:18:45 host kernel: [    0.000000]  [mem 0x19000000-0xf9ffffff] page 4k
Oct 12 08:18:45 host kernel: [    0.000000] RAMDISK: [mem 0x02269000-0x0293afff]
Oct 12 08:18:45 host kernel: [    0.000000] NUMA turned off
Oct 12 08:18:45 host kernel: [    0.000000] Faking a node at [mem 0x0000000000000000-0x00000000f9ffffff]                                                                            
Oct 12 08:18:45 host kernel: [    0.000000] NODE_DATA(0) allocated [mem 0x18835000-0x18848fff]                                                                                      
Oct 12 08:18:45 host kernel: [    0.000000] Zone ranges:                                                                                                                            
Oct 12 08:18:45 host kernel: [    0.000000]   DMA      [mem 0x00001000-0x00ffffff]                                                                                                  
Oct 12 08:18:45 host kernel: [    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
Oct 12 08:18:45 host kernel: [    0.000000]   Normal   empty
Oct 12 08:18:45 host kernel: [    0.000000] Movable zone start for each node
Oct 12 08:18:45 host kernel: [    0.000000] Early memory node ranges
Oct 12 08:18:45 host kernel: [    0.000000]   node   0: [mem 0x00001000-0x0009ffff]
Oct 12 08:18:45 host kernel: [    0.000000]   node   0: [mem 0x00100000-0xf9ffffff]
Oct 12 08:18:45 host kernel: [    0.000000] Initmem setup node 0 [mem 0x00001000-0xf9ffffff]
Oct 12 08:18:45 host kernel: [    0.000000] On node 0 totalpages: 1023903
Oct 12 08:18:45 host kernel: [    0.000000]   DMA zone: 64 pages used for memmap
Oct 12 08:18:45 host kernel: [    0.000000]   DMA zone: 21 pages reserved
Oct 12 08:18:45 host kernel: [    0.000000]   DMA zone: 3999 pages, LIFO batch:0
Oct 12 08:18:45 host kernel: [    0.000000]   DMA32 zone: 15936 pages used for memmap
Oct 12 08:18:45 host kernel: [    0.000000]   DMA32 zone: 1019904 pages, LIFO batch:31
Oct 12 08:18:45 host kernel: [    0.000000] SFI: Simple Firmware Interface v0.81 http://simplefirmware.org
Oct 12 08:18:45 host kernel: [    0.000000] smpboot: Allowing 8 CPUs, 0 hotplug CPUs
Oct 12 08:18:45 host kernel: [    0.000000] e820: [mem 0xfa000000-0xffffffff] available for PCI devices
Oct 12 08:18:45 host kernel: [    0.000000] Booting paravirtualized kernel on Xen
Oct 12 08:18:45 host kernel: [    0.000000] Xen version: 4.4.2 (preserve-AD)
Oct 12 08:18:45 host kernel: [    0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:8 nr_node_ids:1
Oct 12 08:18:45 host kernel: [    0.000000] PERCPU: Embedded 30 pages/cpu @ffff880018200000 s82560 r8192 d32128 u262144
Oct 12 08:18:45 host kernel: [    0.000000] pcpu-alloc: s82560 r8192 d32128 u262144 alloc=1*2097152
Oct 12 08:18:45 host kernel: [    0.000000] pcpu-alloc: [0] 0 1 2 3 4 5 6 7 
Oct 12 08:18:45 host kernel: [    0.000000] xen: PV spinlocks enabled
Oct 12 08:18:45 host kernel: [    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 1007882
Oct 12 08:18:45 host kernel: [    0.000000] Policy zone: DMA32
Oct 12 08:18:45 host kernel: [    0.000000] Kernel command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH 3 nopat
Oct 12 08:18:45 host kernel: [    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
Oct 12 08:18:45 host kernel: [    0.000000] xsave: enabled xstate_bv 0x7, cntxt size 0x340 using standard form
Oct 12 08:18:45 host kernel: [    0.000000] Memory: 309872K/4095612K available (7357K kernel code, 1142K rwdata, 3472K rodata, 1468K init, 1488K bss, 3785740K reserved)
Oct 12 08:18:45 host kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1
Oct 12 08:18:45 host kernel: [    0.000000] Hierarchical RCU implementation.
Oct 12 08:18:45 host kernel: [    0.000000]     RCU dyntick-idle grace-period acceleration is enabled.
Oct 12 08:18:45 host kernel: [    0.000000]     RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=8.
Oct 12 08:18:45 host kernel: [    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=8
Oct 12 08:18:45 host kernel: [    0.000000] NR_IRQS:4352 nr_irqs:80 0
Oct 12 08:18:45 host kernel: [    0.000000] xen:events: Using FIFO-based ABI
Oct 12 08:18:45 host kernel: [    0.000000]     Offload RCU callbacks from all CPUs
Oct 12 08:18:45 host kernel: [    0.000000]     Offload RCU callbacks from CPUs: 0-7.
Oct 12 08:18:45 host kernel: [    0.000000] Console: colour dummy device 80x25
Oct 12 08:18:45 host kernel: [    0.000000] console [tty0] enabled
Oct 12 08:18:45 host kernel: [    0.000000] console [hvc0] enabled
Oct 12 08:18:45 host kernel: [    0.000000] allocated 16777216 bytes of page_cgroup
Oct 12 08:18:45 host kernel: [    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
Oct 12 08:18:45 host kernel: [    0.000000] Xen: using vcpuop timer interface
Oct 12 08:18:45 host kernel: [    0.000000] installing Xen timer for CPU 0
Oct 12 08:18:45 host kernel: [    0.000000] tsc: Detected 2195.024 MHz processor
Oct 12 08:18:45 host kernel: [    0.001000] Calibrating delay loop (skipped), value calculated using timer frequency.. 4390.04 BogoMIPS (lpj=2195024)
Oct 12 08:18:45 host kernel: [    0.001000] pid_max: default: 32768 minimum: 301
Oct 12 08:18:45 host kernel: [    0.001000] Security Framework initialized
Oct 12 08:18:45 host kernel: [    0.001000] AppArmor: AppArmor disabled by boot time parameter
Oct 12 08:18:45 host kernel: [    0.001000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes)
Oct 12 08:18:45 host kernel: [    0.001750] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes)
Oct 12 08:18:45 host kernel: [    0.002005] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes)
Oct 12 08:18:45 host kernel: [    0.002018] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes)
Oct 12 08:18:45 host kernel: [    0.002218] Initializing cgroup subsys memory
Oct 12 08:18:45 host kernel: [    0.002226] Initializing cgroup subsys devices
Oct 12 08:18:45 host kernel: [    0.002229] Initializing cgroup subsys freezer
Oct 12 08:18:45 host kernel: [    0.002232] Initializing cgroup subsys net_cls
Oct 12 08:18:45 host kernel: [    0.002236] Initializing cgroup subsys blkio
Oct 12 08:18:45 host kernel: [    0.002239] Initializing cgroup subsys perf_event
Oct 12 08:18:45 host kernel: [    0.002242] Initializing cgroup subsys net_prio
Oct 12 08:18:45 host kernel: [    0.002245] Initializing cgroup subsys hugetlb
Oct 12 08:18:45 host kernel: [    0.002283] ENERGY_PERF_BIAS: Set to 'normal', was 'performance'
Oct 12 08:18:45 host kernel: [    0.002283] ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8)
Oct 12 08:18:45 host kernel: [    0.002290] CPU: Physical Processor ID: 0
Oct 12 08:18:45 host kernel: [    0.002292] CPU: Processor Core ID: 0
Oct 12 08:18:45 host kernel: [    0.003078] Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024
Oct 12 08:18:45 host kernel: [    0.003078] Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4
Oct 12 08:18:45 host kernel: [    0.028330] ftrace: allocating 27112 entries in 106 pages
Oct 12 08:18:45 host kernel: [    0.033060] cpu 0 spinlock event irq 17
Oct 12 08:18:45 host kernel: [    0.040033] Performance Events: unsupported p6 CPU model 70 no PMU driver, software events only.
Oct 12 08:18:45 host kernel: [    0.041052] NMI watchdog: disabled (cpu0): hardware events not enabled
Oct 12 08:18:45 host kernel: [    0.041114] installing Xen timer for CPU 1
Oct 12 08:18:45 host kernel: [    0.041122] cpu 1 spinlock event irq 24
Oct 12 08:18:45 host kernel: [    0.041160] SMP alternatives: switching to SMP code
Oct 12 08:18:45 host kernel: [    0.064297] installing Xen timer for CPU 2
Oct 12 08:18:45 host kernel: [    0.064306] cpu 2 spinlock event irq 31
Oct 12 08:18:45 host kernel: [    0.065337] installing Xen timer for CPU 3
Oct 12 08:18:45 host kernel: [    0.065354] cpu 3 spinlock event irq 38
Oct 12 08:18:45 host kernel: [    0.066371] installing Xen timer for CPU 4
Oct 12 08:18:45 host kernel: [    0.066379] cpu 4 spinlock event irq 45
Oct 12 08:18:45 host kernel: [    0.067347] installing Xen timer for CPU 5
Oct 12 08:18:45 host kernel: [    0.067359] cpu 5 spinlock event irq 52
Oct 12 08:18:45 host kernel: [    0.068339] installing Xen timer for CPU 6
Oct 12 08:18:45 host kernel: [    0.068348] cpu 6 spinlock event irq 59
Oct 12 08:18:45 host kernel: [    0.069326] installing Xen timer for CPU 7
Oct 12 08:18:45 host kernel: [    0.069337] cpu 7 spinlock event irq 66
Oct 12 08:18:45 host kernel: [    0.070219] x86: Booted up 1 node, 8 CPUs
Oct 12 08:18:45 host kernel: [    0.070303] devtmpfs: initialized
Oct 12 08:18:45 host kernel: [    0.072611] atomic64_test: passed for x86-64 platform with CX8 and with SSE
Oct 12 08:18:45 host kernel: [    0.072611] pinctrl core: initialized pinctrl subsystem
Oct 12 08:18:45 host kernel: [    0.092900] RTC time: 165:165:165, date: 165/165/65
Oct 12 08:18:45 host kernel: [    0.093018] NET: Registered protocol family 16
Oct 12 08:18:45 host kernel: [    0.093031] xen:grant_table: Grant tables using version 1 layout
Oct 12 08:18:45 host kernel: [    0.093038] Grant table initialized
Oct 12 08:18:45 host kernel: [    0.093369] PCI: setting up Xen PCI frontend stub
Oct 12 08:18:45 host kernel: [    0.093375] PCI: pci_cache_line_size set to 64 bytes
Oct 12 08:18:45 host kernel: [    0.097045] ACPI: Interpreter disabled.
Oct 12 08:18:45 host kernel: [    0.097045] xen:balloon: Initialising balloon driver
Oct 12 08:18:45 host kernel: [    0.104017] xen_balloon: Initialising balloon driver
Oct 12 08:18:45 host kernel: [    0.104041] vgaarb: loaded
Oct 12 08:18:45 host kernel: [    0.104075] SCSI subsystem initialized
Oct 12 08:18:45 host kernel: [    0.104104] libata version 3.00 loaded.
Oct 12 08:18:45 host kernel: [    0.104104] usbcore: registered new interface driver usbfs
Oct 12 08:18:45 host kernel: [    0.104104] usbcore: registered new interface driver hub
Oct 12 08:18:45 host kernel: [    0.104104] usbcore: registered new device driver usb
Oct 12 08:18:45 host kernel: [    0.104138] PCI: System does not support PCI
Oct 12 08:18:45 host kernel: [    0.104138] PCI: System does not support PCI
Oct 12 08:18:45 host kernel: [    0.104138] NetLabel: Initializing
Oct 12 08:18:45 host kernel: [    0.104140] NetLabel:  domain hash size = 128
Oct 12 08:18:45 host kernel: [    0.104142] NetLabel:  protocols = UNLABELED CIPSOv4
Oct 12 08:18:45 host kernel: [    0.104151] NetLabel:  unlabeled traffic allowed by default
Oct 12 08:18:45 host kernel: [    0.105125] Switched to clocksource xen
Oct 12 08:18:45 host kernel: [    0.108973] pnp: PnP ACPI: disabled
Oct 12 08:18:45 host kernel: [    0.110658] NET: Registered protocol family 2
Oct 12 08:18:45 host kernel: [    0.110799] TCP established hash table entries: 32768 (order: 6, 262144 bytes)
Oct 12 08:18:45 host kernel: [    0.110892] TCP bind hash table entries: 32768 (order: 7, 524288 bytes)
Oct 12 08:18:45 host kernel: [    0.110944] TCP: Hash tables configured (established 32768 bind 32768)
Oct 12 08:18:45 host kernel: [    0.110954] TCP: reno registered
Oct 12 08:18:45 host kernel: [    0.110965] UDP hash table entries: 2048 (order: 4, 65536 bytes)
Oct 12 08:18:45 host kernel: [    0.110981] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes)
Oct 12 08:18:45 host kernel: [    0.111026] NET: Registered protocol family 1
Oct 12 08:18:45 host kernel: [    0.111035] PCI: CLS 0 bytes, default 64
Oct 12 08:18:45 host kernel: [    0.111066] Unpacking initramfs...
Oct 12 08:18:45 host kernel: [    0.116631] Freeing initrd memory: 6984K (ffff880002269000 - ffff88000293b000)
Oct 12 08:18:45 host kernel: [    0.116715] platform rtc_cmos: registered platform RTC device (no PNP device found)
Oct 12 08:18:45 host kernel: [    0.117437] AVX2 version of gcm_enc/dec engaged.
Oct 12 08:18:45 host kernel: [    0.117441] AES CTR mode by8 optimization enabled
Oct 12 08:18:45 host kernel: [    0.118786] alg: No test for __gcm-aes-aesni (__driver-gcm-aes-aesni)
Oct 12 08:18:45 host kernel: [    0.119136] futex hash table entries: 2048 (order: 5, 131072 bytes)
Oct 12 08:18:45 host kernel: [    0.119159] Initialise system trusted keyring
Oct 12 08:18:45 host kernel: [    0.119176] audit: initializing netlink subsys (disabled)
Oct 12 08:18:45 host kernel: [    0.119186] audit: type=2000 audit(1444637788.753:1): initialized
Oct 12 08:18:45 host kernel: [    0.119390] HugeTLB registered 2 MB page size, pre-allocated 0 pages
Oct 12 08:18:45 host kernel: [    0.120296] zpool: loaded
Oct 12 08:18:45 host kernel: [    0.120299] zbud: loaded
Oct 12 08:18:45 host kernel: [    0.120435] VFS: Disk quotas dquot_6.5.2
Oct 12 08:18:45 host kernel: [    0.120460] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Oct 12 08:18:45 host kernel: [    0.120699] msgmni has been set to 618
Oct 12 08:18:45 host kernel: [    0.121223] alg: No test for stdrng (krng)
Oct 12 08:18:45 host kernel: [    0.121234] NET: Registered protocol family 38
Oct 12 08:18:45 host kernel: [    0.121241] Key type asymmetric registered
Oct 12 08:18:45 host kernel: [    0.121245] Asymmetric key parser 'x509' registered
Oct 12 08:18:45 host kernel: [    0.121272] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Oct 12 08:18:45 host kernel: [    0.121330] io scheduler noop registered
Oct 12 08:18:45 host kernel: [    0.121334] io scheduler deadline registered
Oct 12 08:18:45 host kernel: [    0.121357] io scheduler cfq registered (default)
Oct 12 08:18:45 host kernel: [    0.121424] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
Oct 12 08:18:45 host kernel: [    0.121436] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
Oct 12 08:18:45 host kernel: [    0.263401] intel_idle: does not run on family 6 model 70
Oct 12 08:18:45 host kernel: [    0.263829] xen:xen_evtchn: Event-channel device installed
Oct 12 08:18:45 host kernel: [    0.264183] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Oct 12 08:18:45 host kernel: [    0.264494] Non-volatile memory driver v1.3
Oct 12 08:18:45 host kernel: [    0.264611] libphy: Fixed MDIO Bus: probed
Oct 12 08:18:45 host kernel: [    0.264676] usbcore: registered new interface driver usbserial
Oct 12 08:18:45 host kernel: [    0.264683] usbcore: registered new interface driver usbserial_generic
Oct 12 08:18:45 host kernel: [    0.264689] usbserial: USB Serial support registered for generic
Oct 12 08:18:45 host kernel: [    0.264704] i8042: PNP: No PS/2 controller found. Probing ports directly.
Oct 12 08:18:45 host kernel: [    1.276100] i8042: No controller found
Oct 12 08:18:45 host kernel: [    1.276276] mousedev: PS/2 mouse device common for all mice
Oct 12 08:18:45 host kernel: [    1.336578] rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0
Oct 12 08:18:45 host kernel: [    1.336650] rtc_cmos: probe of rtc_cmos failed with error -38
Oct 12 08:18:45 host kernel: [    1.336725] device-mapper: uevent: version 1.0.3
Oct 12 08:18:45 host kernel: [    1.336808] device-mapper: ioctl: 4.28.0-ioctl (2014-09-17) initialised: dm-devel@redhat.com
Oct 12 08:18:45 host kernel: [    1.336911] hidraw: raw HID events driver (C) Jiri Kosina
Oct 12 08:18:45 host kernel: [    1.336992] usbcore: registered new interface driver usbhid
Oct 12 08:18:45 host kernel: [    1.336995] usbhid: USB HID core driver
Oct 12 08:18:45 host kernel: [    1.337032] drop_monitor: Initializing network drop monitor service
Oct 12 08:18:45 host kernel: [    1.337085] ip_tables: (C) 2000-2006 Netfilter Core Team
Oct 12 08:18:45 host kernel: [    1.337338] TCP: cubic registered
Oct 12 08:18:45 host kernel: [    1.337345] Initializing XFRM netlink socket
Oct 12 08:18:45 host kernel: [    1.337415] NET: Registered protocol family 10
Oct 12 08:18:45 host kernel: [    1.337601] NET: Registered protocol family 17
Oct 12 08:18:45 host kernel: [    1.337610] mce: Unable to init device /dev/mcelog (rc: -5)
Oct 12 08:18:45 host kernel: [    1.337758] Loading compiled-in X.509 certificates
Oct 12 08:18:45 host kernel: [    1.337769] registered taskstats version 1
Oct 12 08:18:45 host kernel: [    1.337820] xenbus_probe_frontend: Device with no driver: device/vbd/51712
Oct 12 08:18:45 host kernel: [    1.337823] xenbus_probe_frontend: Device with no driver: device/vbd/51728
Oct 12 08:18:45 host kernel: [    1.337825] xenbus_probe_frontend: Device with no driver: device/vbd/51744
Oct 12 08:18:45 host kernel: [    1.337827] xenbus_probe_frontend: Device with no driver: device/vbd/51760
Oct 12 08:18:45 host kernel: [    1.337893]   Magic number: 1:252:3141
Oct 12 08:18:45 host kernel: [    1.337913] /home/user/rpmbuild/BUILD/kernel-3.18.17/linux-3.18.17/drivers/rtc/hctosys.c: unable to open rtc device (rtc0)
Oct 12 08:18:45 host kernel: [    1.338421] Freeing unused kernel memory: 1468K (ffffffff81d1f000 - ffffffff81e8e000)
Oct 12 08:18:45 host kernel: [    1.338425] Write protecting the kernel read-only data: 12288k
Oct 12 08:18:45 host kernel: [    1.341782] Freeing unused kernel memory: 824K (ffff880001732000 - ffff880001800000)
Oct 12 08:18:45 host kernel: [    1.341998] Freeing unused kernel memory: 624K (ffff880001b64000 - ffff880001c00000)
Oct 12 08:18:45 host kernel: [    1.345324] random: modprobe urandom read with 35 bits of entropy available
Oct 12 08:18:45 host kernel: [    1.398497] blkfront: xvda: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 12 08:18:45 host kernel: [    1.406088]  xvda: unknown partition table
Oct 12 08:18:45 host kernel: [    1.420387] blkfront: xvdb: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 12 08:18:45 host kernel: [    1.423677]  xvdb: unknown partition table
Oct 12 08:18:45 host kernel: [    1.439781] blkfront: xvdc: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 12 08:18:45 host kernel: [    1.443312]  xvdc: xvdc1 xvdc2
Oct 12 08:18:45 host kernel: [    1.452810] blkfront: xvdd: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 12 08:18:45 host kernel: [    1.454104]  xvdd: unknown partition table
Oct 12 08:18:45 host kernel: [    1.492948] EXT4-fs (dm-0): couldn't mount as ext3 due to feature incompatibilities
Oct 12 08:18:45 host kernel: [    1.493070] EXT4-fs (dm-0): couldn't mount as ext2 due to feature incompatibilities
Oct 12 08:18:45 host kernel: [    1.495329] EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null)
Oct 12 08:18:45 host kernel: [    1.497503] EXT4-fs (xvdd): mounting ext3 file system using the ext4 subsystem
Oct 12 08:18:45 host kernel: [    1.505701] EXT4-fs (xvdd): mounted filesystem with ordered data mode. Opts: (null)
Oct 12 08:18:45 host kernel: [    1.680044] random: nonblocking pool is initialized
Oct 12 08:18:45 host kernel: [    1.964925] lp: driver loaded but no devices found
Oct 12 08:18:45 host kernel: [    1.967042] ppdev: user-space parallel port driver
Oct 12 08:18:45 host kernel: [    1.980371] dummy_hcd dummy_hcd.0: USB Host+Gadget Emulator, driver 02 May 2005
Oct 12 08:18:45 host kernel: [    1.980379] dummy_hcd dummy_hcd.0: Dummy host controller
Oct 12 08:18:45 host kernel: [    1.980426] dummy_hcd dummy_hcd.0: new USB bus registered, assigned bus number 1
Oct 12 08:18:45 host kernel: [    1.980560] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Oct 12 08:18:45 host kernel: [    1.980564] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 12 08:18:45 host kernel: [    1.980567] usb usb1: Product: Dummy host controller
Oct 12 08:18:45 host kernel: [    1.980570] usb usb1: Manufacturer: Linux 3.18.17-6.pvops.qubes.x86_64 dummy_hcd
Oct 12 08:18:45 host kernel: [    1.980572] usb usb1: SerialNumber: dummy_hcd.0
Oct 12 08:18:45 host kernel: [    1.980718] hub 1-0:1.0: USB hub found
Oct 12 08:18:45 host kernel: [    1.980744] hub 1-0:1.0: 1 port detected
Oct 12 08:18:45 host kernel: [    1.984326] EXT4-fs (dm-0): re-mounted. Opts: (null)
Oct 12 08:18:45 host kernel: [    2.076884] input: PC Speaker as /devices/platform/pcspkr/input/input0
Oct 12 08:18:45 host kernel: [    2.089117] alg: No test for crc32 (crc32-pclmul)
Oct 12 08:18:45 host kernel: [    2.096604] Error: Driver 'pcspkr' is already registered, aborting...
Oct 12 08:18:45 host kernel: [    2.100221] Adding 1052252k swap on /dev/xvdc1.  Priority:-1 extents:1 across:1052252k SSFS
Oct 12 08:18:45 host kernel: [    2.144355] nf_conntrack version 0.5.0 (2498 buckets, 9992 max)
Oct 12 08:18:45 host kernel: [    2.184076] ip6_tables: (C) 2000-2006 Netfilter Core Team
Oct 12 08:18:45 host kernel: [    2.338690] EXT4-fs (xvdb): mounted filesystem with ordered data mode. Opts: discard
Oct 14 05:56:14 host kernel: [    0.000000] Initializing cgroup subsys cpuset
Oct 14 05:56:14 host kernel: [    0.000000] Initializing cgroup subsys cpu
Oct 14 05:56:14 host kernel: [    0.000000] Initializing cgroup subsys cpuacct
Oct 14 05:56:14 host kernel: [    0.000000] Linux version 3.18.17-6.pvops.qubes.x86_64 (user@release) (gcc version 4.8.3 20140911 (Red Hat 4.8.3-7) (GCC) ) #1 SMP Sat Aug 8 21:27:00 UTC 2015
Oct 14 05:56:14 host kernel: [    0.000000] Command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH 3 nopat
Oct 14 05:56:14 host kernel: [    0.000000] ACPI in unprivileged domain disabled
Oct 14 05:56:14 host kernel: [    0.000000] Set 0 page(s) to 1-1 mapping
Oct 14 05:56:14 host kernel: [    0.000000] Remapped 0 page(s), last_pfn=109568
Oct 14 05:56:14 host kernel: [    0.000000] Released 0 page(s)
Oct 14 05:56:14 host kernel: [    0.000000] e820: BIOS-provided physical RAM map:
Oct 14 05:56:14 host kernel: [    0.000000] Xen: [mem 0x0000000000000000-0x000000000009ffff] usable
Oct 14 05:56:14 host kernel: [    0.000000] Xen: [mem 0x00000000000a0000-0x00000000000fffff] reserved
Oct 14 05:56:14 host kernel: [    0.000000] Xen: [mem 0x0000000000100000-0x00000000f9ffffff] usable
Oct 14 05:56:14 host kernel: [    0.000000] PAT support disabled.
Oct 14 05:56:14 host kernel: [    0.000000] NX (Execute Disable) protection: active
Oct 14 05:56:14 host kernel: [    0.000000] DMI not present or invalid.
Oct 14 05:56:14 host kernel: [    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Oct 14 05:56:14 host kernel: [    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
Oct 14 05:56:14 host kernel: [    0.000000] e820: last_pfn = 0xfa000 max_arch_pfn = 0x400000000
Oct 14 05:56:14 host kernel: [    0.000000] Base memory trampoline at [ffff88000009a000] 9a000 size 24576
Oct 14 05:56:14 host kernel: [    0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff]
Oct 14 05:56:14 host kernel: [    0.000000]  [mem 0x00000000-0x000fffff] page 4k
Oct 14 05:56:14 host kernel: [    0.000000] init_memory_mapping: [mem 0x1aa00000-0x1abfffff]
Oct 14 05:56:14 host kernel: [    0.000000]  [mem 0x1aa00000-0x1abfffff] page 4k
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02014000, 0x02014fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] init_memory_mapping: [mem 0x18000000-0x1a9fffff]
Oct 14 05:56:14 host kernel: [    0.000000]  [mem 0x18000000-0x1a9fffff] page 4k
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02015000, 0x02015fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02016000, 0x02016fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02017000, 0x02017fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02018000, 0x02018fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] BRK [0x02019000, 0x02019fff] PGTABLE
Oct 14 05:56:14 host kernel: [    0.000000] init_memory_mapping: [mem 0x00100000-0x17ffffff]
Oct 14 05:56:14 host kernel: [    0.000000]  [mem 0x00100000-0x17ffffff] page 4k
Oct 14 05:56:14 host kernel: [    0.000000] init_memory_mapping: [mem 0x1ac00000-0xf9ffffff]
Oct 14 05:56:14 host kernel: [    0.000000]  [mem 0x1ac00000-0xf9ffffff] page 4k
Oct 14 05:56:14 host kernel: [    0.000000] RAMDISK: [mem 0x02269000-0x0293afff]
Oct 14 05:56:14 host kernel: [    0.000000] NUMA turned off
Oct 14 05:56:14 host kernel: [    0.000000] Faking a node at [mem 0x0000000000000000-0x00000000f9ffffff]
Oct 14 05:56:14 host kernel: [    0.000000] NODE_DATA(0) allocated [mem 0x1a435000-0x1a448fff]
Oct 14 05:56:14 host kernel: [    0.000000] Zone ranges:
Oct 14 05:56:14 host kernel: [    0.000000]   DMA      [mem 0x00001000-0x00ffffff]
Oct 14 05:56:14 host kernel: [    0.000000]   DMA32    [mem 0x01000000-0xffffffff]
Oct 14 05:56:14 host kernel: [    0.000000]   Normal   empty
Oct 14 05:56:14 host kernel: [    0.000000] Movable zone start for each node
Oct 14 05:56:14 host kernel: [    0.000000] Early memory node ranges
Oct 14 05:56:14 host kernel: [    0.000000]   node   0: [mem 0x00001000-0x0009ffff]
Oct 14 05:56:14 host kernel: [    0.000000]   node   0: [mem 0x00100000-0xf9ffffff]
Oct 14 05:56:14 host kernel: [    0.000000] Initmem setup node 0 [mem 0x00001000-0xf9ffffff]
Oct 14 05:56:14 host kernel: [    0.000000] On node 0 totalpages: 1023903
Oct 14 05:56:14 host kernel: [    0.000000]   DMA zone: 64 pages used for memmap
Oct 14 05:56:14 host kernel: [    0.000000]   DMA zone: 21 pages reserved
Oct 14 05:56:14 host kernel: [    0.000000]   DMA zone: 3999 pages, LIFO batch:0
Oct 14 05:56:14 host kernel: [    0.000000]   DMA32 zone: 15936 pages used for memmap
Oct 14 05:56:14 host kernel: [    0.000000]   DMA32 zone: 1019904 pages, LIFO batch:31
Oct 14 05:56:14 host kernel: [    0.000000] SFI: Simple Firmware Interface v0.81 http://simplefirmware.org
Oct 14 05:56:14 host kernel: [    0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
Oct 14 05:56:14 host kernel: [    0.000000] e820: [mem 0xfa000000-0xffffffff] available for PCI devices
Oct 14 05:56:14 host kernel: [    0.000000] Booting paravirtualized kernel on Xen
Oct 14 05:56:14 host kernel: [    0.000000] Xen version: 4.4.2 (preserve-AD)
Oct 14 05:56:14 host kernel: [    0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:1 nr_node_ids:1
Oct 14 05:56:14 host kernel: [    0.000000] PERCPU: Embedded 30 pages/cpu @ffff880019e00000 s82560 r8192 d32128 u2097152
Oct 14 05:56:14 host kernel: [    0.000000] pcpu-alloc: s82560 r8192 d32128 u2097152 alloc=1*2097152
Oct 14 05:56:14 host kernel: [    0.000000] pcpu-alloc: [0] 0 
Oct 14 05:56:14 host kernel: [    0.000000] xen: PV spinlocks enabled
Oct 14 05:56:14 host kernel: [    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 1007882
Oct 14 05:56:14 host kernel: [    0.000000] Policy zone: DMA32
Oct 14 05:56:14 host kernel: [    0.000000] Kernel command line: root=/dev/mapper/dmroot ro nomodeset console=hvc0 rd_NO_PLYMOUTH 3 nopat
Oct 14 05:56:14 host kernel: [    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
Oct 14 05:56:14 host kernel: [    0.000000] xsave: enabled xstate_bv 0x7, cntxt size 0x340 using standard form
Oct 14 05:56:14 host kernel: [    0.000000] Memory: 339328K/4095612K available (7357K kernel code, 1142K rwdata, 3472K rodata, 1468K init, 1488K bss, 3756284K reserved)
Oct 14 05:56:14 host kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
Oct 14 05:56:14 host kernel: [    0.000000] Hierarchical RCU implementation.
Oct 14 05:56:14 host kernel: [    0.000000]     RCU dyntick-idle grace-period acceleration is enabled.
Oct 14 05:56:14 host kernel: [    0.000000]     RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=1.
Oct 14 05:56:14 host kernel: [    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
Oct 14 05:56:14 host kernel: [    0.000000] NR_IRQS:4352 nr_irqs:24 0
Oct 14 05:56:14 host kernel: [    0.000000] xen:events: Using FIFO-based ABI
Oct 14 05:56:14 host kernel: [    0.000000]     Offload RCU callbacks from all CPUs
Oct 14 05:56:14 host kernel: [    0.000000]     Offload RCU callbacks from CPUs: 0.
Oct 14 05:56:14 host kernel: [    0.000000] Console: colour dummy device 80x25
Oct 14 05:56:14 host kernel: [    0.000000] console [tty0] enabled
Oct 14 05:56:14 host kernel: [    0.000000] console [hvc0] enabled
Oct 14 05:56:14 host kernel: [    0.000000] allocated 16777216 bytes of page_cgroup
Oct 14 05:56:14 host kernel: [    0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
Oct 14 05:56:14 host kernel: [    0.000000] Xen: using vcpuop timer interface
Oct 14 05:56:14 host kernel: [    0.000000] installing Xen timer for CPU 0
Oct 14 05:56:14 host kernel: [    0.000000] tsc: Detected 2195.024 MHz processor
Oct 14 05:56:14 host kernel: [    0.001000] Calibrating delay loop (skipped), value calculated using timer frequency.. 4390.04 BogoMIPS (lpj=2195024)
Oct 14 05:56:14 host kernel: [    0.001000] pid_max: default: 32768 minimum: 301
Oct 14 05:56:14 host kernel: [    0.001000] Security Framework initialized
Oct 14 05:56:14 host kernel: [    0.001000] AppArmor: AppArmor disabled by boot time parameter
Oct 14 05:56:14 host kernel: [    0.001000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes)
Oct 14 05:56:14 host kernel: [    0.001621] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes)
Oct 14 05:56:14 host kernel: [    0.001886] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes)
Oct 14 05:56:14 host kernel: [    0.001900] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes)
Oct 14 05:56:14 host kernel: [    0.002089] Initializing cgroup subsys memory
Oct 14 05:56:14 host kernel: [    0.002097] Initializing cgroup subsys devices
Oct 14 05:56:14 host kernel: [    0.002101] Initializing cgroup subsys freezer
Oct 14 05:56:14 host kernel: [    0.002104] Initializing cgroup subsys net_cls
Oct 14 05:56:14 host kernel: [    0.002108] Initializing cgroup subsys blkio
Oct 14 05:56:14 host kernel: [    0.002111] Initializing cgroup subsys perf_event
Oct 14 05:56:14 host kernel: [    0.002115] Initializing cgroup subsys net_prio
Oct 14 05:56:14 host kernel: [    0.002119] Initializing cgroup subsys hugetlb
Oct 14 05:56:14 host kernel: [    0.002173] ENERGY_PERF_BIAS: Set to 'normal', was 'performance'
Oct 14 05:56:14 host kernel: [    0.002173] ENERGY_PERF_BIAS: View and update with x86_energy_perf_policy(8)
Oct 14 05:56:14 host kernel: [    0.002183] CPU: Physical Processor ID: 0
Oct 14 05:56:14 host kernel: [    0.002186] CPU: Processor Core ID: 3
Oct 14 05:56:14 host kernel: [    0.002983] Last level iTLB entries: 4KB 1024, 2MB 1024, 4MB 1024
Oct 14 05:56:14 host kernel: [    0.002983] Last level dTLB entries: 4KB 1024, 2MB 1024, 4MB 1024, 1GB 4
Oct 14 05:56:14 host kernel: [    0.029231] Freeing SMP alternatives memory: 28K (ffffffff81e8e000 - ffffffff81e95000)
Oct 14 05:56:14 host kernel: [    0.031550] ftrace: allocating 27112 entries in 106 pages
Oct 14 05:56:14 host kernel: [    0.037063] cpu 0 spinlock event irq 17
Oct 14 05:56:14 host kernel: [    0.045575] Performance Events: unsupported p6 CPU model 70 no PMU driver, software events only.
Oct 14 05:56:14 host kernel: [    0.046652] x86: Booted up 1 node, 1 CPUs
Oct 14 05:56:14 host kernel: [    0.046689] NMI watchdog: disabled (cpu0): hardware events not enabled
Oct 14 05:56:14 host kernel: [    0.046742] devtmpfs: initialized
Oct 14 05:56:14 host kernel: [    0.048965] atomic64_test: passed for x86-64 platform with CX8 and with SSE
Oct 14 05:56:14 host kernel: [    0.048972] pinctrl core: initialized pinctrl subsystem
Oct 14 05:56:14 host kernel: [    0.068897] RTC time: 165:165:165, date: 165/165/65
Oct 14 05:56:14 host kernel: [    0.069028] NET: Registered protocol family 16
Oct 14 05:56:14 host kernel: [    0.069041] xen:grant_table: Grant tables using version 1 layout
Oct 14 05:56:14 host kernel: [    0.069049] Grant table initialized
Oct 14 05:56:14 host kernel: [    0.069386] PCI: setting up Xen PCI frontend stub
Oct 14 05:56:14 host kernel: [    0.069390] PCI: pci_cache_line_size set to 64 bytes
Oct 14 05:56:14 host kernel: [    0.070817] ACPI: Interpreter disabled.
Oct 14 05:56:14 host kernel: [    0.070830] xen:balloon: Initialising balloon driver
Oct 14 05:56:14 host kernel: [    0.078032] xen_balloon: Initialising balloon driver
Oct 14 05:56:14 host kernel: [    0.079095] vgaarb: loaded
Oct 14 05:56:14 host kernel: [    0.079153] SCSI subsystem initialized
Oct 14 05:56:14 host kernel: [    0.079175] libata version 3.00 loaded.
Oct 14 05:56:14 host kernel: [    0.079207] usbcore: registered new interface driver usbfs
Oct 14 05:56:14 host kernel: [    0.079214] usbcore: registered new interface driver hub
Oct 14 05:56:14 host kernel: [    0.079219] usbcore: registered new device driver usb
Oct 14 05:56:14 host kernel: [    0.079282] PCI: System does not support PCI
Oct 14 05:56:14 host kernel: [    0.079285] PCI: System does not support PCI
Oct 14 05:56:14 host kernel: [    0.079356] NetLabel: Initializing
Oct 14 05:56:14 host kernel: [    0.079358] NetLabel:  domain hash size = 128
Oct 14 05:56:14 host kernel: [    0.079359] NetLabel:  protocols = UNLABELED CIPSOv4
Oct 14 05:56:14 host kernel: [    0.079369] NetLabel:  unlabeled traffic allowed by default
Oct 14 05:56:14 host kernel: [    0.079417] Switched to clocksource xen
Oct 14 05:56:14 host kernel: [    0.082264] pnp: PnP ACPI: disabled
Oct 14 05:56:14 host kernel: [    0.083018] NET: Registered protocol family 2
Oct 14 05:56:14 host kernel: [    0.083143] TCP established hash table entries: 32768 (order: 6, 262144 bytes)
Oct 14 05:56:14 host kernel: [    0.083229] TCP bind hash table entries: 32768 (order: 7, 524288 bytes)
Oct 14 05:56:14 host kernel: [    0.083275] TCP: Hash tables configured (established 32768 bind 32768)
Oct 14 05:56:14 host kernel: [    0.083285] TCP: reno registered
Oct 14 05:56:14 host kernel: [    0.083296] UDP hash table entries: 2048 (order: 4, 65536 bytes)
Oct 14 05:56:14 host kernel: [    0.083312] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes)
Oct 14 05:56:14 host kernel: [    0.083341] NET: Registered protocol family 1
Oct 14 05:56:14 host kernel: [    0.083350] PCI: CLS 0 bytes, default 64
Oct 14 05:56:14 host kernel: [    0.083384] Unpacking initramfs...
Oct 14 05:56:14 host kernel: [    0.088461] Freeing initrd memory: 6984K (ffff880002269000 - ffff88000293b000)
Oct 14 05:56:14 host kernel: [    0.088539] platform rtc_cmos: registered platform RTC device (no PNP device found)
Oct 14 05:56:14 host kernel: [    0.088721] AVX2 version of gcm_enc/dec engaged.
Oct 14 05:56:14 host kernel: [    0.088724] AES CTR mode by8 optimization enabled
Oct 14 05:56:14 host kernel: [    0.089816] alg: No test for __gcm-aes-aesni (__driver-gcm-aes-aesni)
Oct 14 05:56:14 host kernel: [    0.089981] futex hash table entries: 256 (order: 2, 16384 bytes)
Oct 14 05:56:14 host kernel: [    0.089989] Initialise system trusted keyring
Oct 14 05:56:14 host kernel: [    0.090010] audit: initializing netlink subsys (disabled)
Oct 14 05:56:14 host kernel: [    0.090021] audit: type=2000 audit(1444802116.223:1): initialized
Oct 14 05:56:14 host kernel: [    0.090200] HugeTLB registered 2 MB page size, pre-allocated 0 pages
Oct 14 05:56:14 host kernel: [    0.091078] zpool: loaded
Oct 14 05:56:14 host kernel: [    0.091083] zbud: loaded
Oct 14 05:56:14 host kernel: [    0.091288] VFS: Disk quotas dquot_6.5.2
Oct 14 05:56:14 host kernel: [    0.091312] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Oct 14 05:56:14 host kernel: [    0.183841] msgmni has been set to 676
Oct 14 05:56:14 host kernel: [    0.184302] alg: No test for stdrng (krng)
Oct 14 05:56:14 host kernel: [    0.184312] NET: Registered protocol family 38
Oct 14 05:56:14 host kernel: [    0.184320] Key type asymmetric registered
Oct 14 05:56:14 host kernel: [    0.184324] Asymmetric key parser 'x509' registered
Oct 14 05:56:14 host kernel: [    0.184362] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Oct 14 05:56:14 host kernel: [    0.184398] io scheduler noop registered
Oct 14 05:56:14 host kernel: [    0.184403] io scheduler deadline registered
Oct 14 05:56:14 host kernel: [    0.184435] io scheduler cfq registered (default)
Oct 14 05:56:14 host kernel: [    0.184518] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
Oct 14 05:56:14 host kernel: [    0.184537] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
Oct 14 05:56:14 host kernel: [    0.184592] intel_idle: does not run on family 6 model 70
Oct 14 05:56:14 host kernel: [    0.184666] xen:xen_evtchn: Event-channel device installed
Oct 14 05:56:14 host kernel: [    0.184856] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Oct 14 05:56:14 host kernel: [    0.185180] Non-volatile memory driver v1.3
Oct 14 05:56:14 host kernel: [    0.185341] libphy: Fixed MDIO Bus: probed
Oct 14 05:56:14 host kernel: [    0.185435] usbcore: registered new interface driver usbserial
Oct 14 05:56:14 host kernel: [    0.185454] usbcore: registered new interface driver usbserial_generic
Oct 14 05:56:14 host kernel: [    0.185464] usbserial: USB Serial support registered for generic
Oct 14 05:56:14 host kernel: [    0.185487] i8042: PNP: No PS/2 controller found. Probing ports directly.
Oct 14 05:56:14 host kernel: [    1.205442] i8042: No controller found
Oct 14 05:56:14 host kernel: [    1.205577] mousedev: PS/2 mouse device common for all mice
Oct 14 05:56:14 host kernel: [    1.265805] rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0
Oct 14 05:56:14 host kernel: [    1.265852] rtc_cmos: probe of rtc_cmos failed with error -38
Oct 14 05:56:14 host kernel: [    1.265908] device-mapper: uevent: version 1.0.3
Oct 14 05:56:14 host kernel: [    1.265955] device-mapper: ioctl: 4.28.0-ioctl (2014-09-17) initialised: dm-devel@redhat.com
Oct 14 05:56:14 host kernel: [    1.266052] hidraw: raw HID events driver (C) Jiri Kosina
Oct 14 05:56:14 host kernel: [    1.266129] usbcore: registered new interface driver usbhid
Oct 14 05:56:14 host kernel: [    1.266131] usbhid: USB HID core driver
Oct 14 05:56:14 host kernel: [    1.266171] drop_monitor: Initializing network drop monitor service
Oct 14 05:56:14 host kernel: [    1.266224] ip_tables: (C) 2000-2006 Netfilter Core Team
Oct 14 05:56:14 host kernel: [    1.266297] TCP: cubic registered
Oct 14 05:56:14 host kernel: [    1.266303] Initializing XFRM netlink socket
Oct 14 05:56:14 host kernel: [    1.266370] NET: Registered protocol family 10
Oct 14 05:56:14 host kernel: [    1.266503] NET: Registered protocol family 17
Oct 14 05:56:14 host kernel: [    1.266512] mce: Unable to init device /dev/mcelog (rc: -5)
Oct 14 05:56:14 host kernel: [    1.266615] Loading compiled-in X.509 certificates
Oct 14 05:56:14 host kernel: [    1.266626] registered taskstats version 1
Oct 14 05:56:14 host kernel: [    1.266664] xenbus_probe_frontend: Device with no driver: device/vbd/51712
Oct 14 05:56:14 host kernel: [    1.266667] xenbus_probe_frontend: Device with no driver: device/vbd/51728
Oct 14 05:56:14 host kernel: [    1.266669] xenbus_probe_frontend: Device with no driver: device/vbd/51744
Oct 14 05:56:14 host kernel: [    1.266671] xenbus_probe_frontend: Device with no driver: device/vbd/51760
Oct 14 05:56:14 host kernel: [    1.266673] xenbus_probe_frontend: Device with no driver: device/vif/0
Oct 14 05:56:14 host kernel: [    1.266694]   Magic number: 1:252:3141
Oct 14 05:56:14 host kernel: [    1.266712] /home/user/rpmbuild/BUILD/kernel-3.18.17/linux-3.18.17/drivers/rtc/hctosys.c: unable to open rtc device (rtc0)
Oct 14 05:56:14 host kernel: [    1.267192] Freeing unused kernel memory: 1468K (ffffffff81d1f000 - ffffffff81e8e000)
Oct 14 05:56:14 host kernel: [    1.267197] Write protecting the kernel read-only data: 12288k
Oct 14 05:56:14 host kernel: [    1.270248] Freeing unused kernel memory: 824K (ffff880001732000 - ffff880001800000)
Oct 14 05:56:14 host kernel: [    1.270439] Freeing unused kernel memory: 624K (ffff880001b64000 - ffff880001c00000)
Oct 14 05:56:14 host kernel: [    1.272704] random: modprobe urandom read with 5 bits of entropy available
Oct 14 05:56:14 host kernel: [    1.331491] blkfront: xvda: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 14 05:56:14 host kernel: [    1.338208]  xvda: unknown partition table
Oct 14 05:56:14 host kernel: [    1.376515] blkfront: xvdb: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 14 05:56:14 host kernel: [    1.381588]  xvdb: unknown partition table
Oct 14 05:56:14 host kernel: [    1.398850] blkfront: xvdc: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 14 05:56:14 host kernel: [    1.401564]  xvdc: xvdc1 xvdc2
Oct 14 05:56:14 host kernel: [    1.426600] blkfront: xvdd: flush diskcache: enabled; persistent grants: enabled; indirect descriptors: enabled;
Oct 14 05:56:14 host kernel: [    1.427517]  xvdd: unknown partition table
Oct 14 05:56:14 host kernel: [    1.449282] EXT4-fs (dm-0): couldn't mount as ext3 due to feature incompatibilities
Oct 14 05:56:14 host kernel: [    1.449476] EXT4-fs (dm-0): couldn't mount as ext2 due to feature incompatibilities
Oct 14 05:56:14 host kernel: [    1.452508] EXT4-fs (dm-0): mounted filesystem with ordered data mode. Opts: (null)
Oct 14 05:56:14 host kernel: [    1.458390] EXT4-fs (xvdd): mounting ext3 file system using the ext4 subsystem
Oct 14 05:56:14 host kernel: [    1.459267] EXT4-fs (xvdd): mounted filesystem with ordered data mode. Opts: (null)
Oct 14 05:56:14 host kernel: [    1.873104] random: nonblocking pool is initialized
Oct 14 05:56:14 host kernel: [    1.880632] lp: driver loaded but no devices found
Oct 14 05:56:14 host kernel: [    1.882339] ppdev: user-space parallel port driver
Oct 14 05:56:14 host kernel: [    2.027636] dummy_hcd dummy_hcd.0: USB Host+Gadget Emulator, driver 02 May 2005
Oct 14 05:56:14 host kernel: [    2.027645] dummy_hcd dummy_hcd.0: Dummy host controller
Oct 14 05:56:14 host kernel: [    2.028929] dummy_hcd dummy_hcd.0: new USB bus registered, assigned bus number 1
Oct 14 05:56:14 host kernel: [    2.028963] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Oct 14 05:56:14 host kernel: [    2.028967] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Oct 14 05:56:14 host kernel: [    2.028969] usb usb1: Product: Dummy host controller
Oct 14 05:56:14 host kernel: [    2.028972] usb usb1: Manufacturer: Linux 3.18.17-6.pvops.qubes.x86_64 dummy_hcd
Oct 14 05:56:14 host kernel: [    2.028974] usb usb1: SerialNumber: dummy_hcd.0
Oct 14 05:56:14 host kernel: [    2.029047] hub 1-0:1.0: USB hub found
Oct 14 05:56:14 host kernel: [    2.029054] hub 1-0:1.0: 1 port detected
Oct 14 05:56:14 host kernel: [    2.089784] EXT4-fs (dm-0): re-mounted. Opts: (null)
Oct 14 05:56:14 host kernel: [    2.123795] input: PC Speaker as /devices/platform/pcspkr/input/input0
Oct 14 05:56:14 host kernel: [    2.169834] nf_conntrack version 0.5.0 (2728 buckets, 10912 max)
Oct 14 05:56:14 host kernel: [    2.177175] Error: Driver 'pcspkr' is already registered, aborting...
Oct 14 05:56:14 host kernel: [    2.190176] xen_netfront: Initialising Xen virtual ethernet driver
Oct 14 05:56:14 host kernel: [    2.220036] alg: No test for crc32 (crc32-pclmul)
Oct 14 05:56:14 host kernel: [    2.241511] ip6_tables: (C) 2000-2006 Netfilter Core Team
Oct 14 05:56:14 host kernel: [    5.290544] Adding 1052252k swap on /dev/xvdc1.  Priority:-1 extents:1 across:1052252k SSFS
Oct 14 05:56:14 host kernel: [    5.460525] EXT4-fs (xvdb): recovery complete
Oct 14 05:56:14 host kernel: [    5.469273] EXT4-fs (xvdb): mounted filesystem with ordered data mode. Opts: discard
Oct 14 05:56:24 host kernel: [   15.479389] vbd vbd-51728: 16 Device in use; refusing to close
Oct 14 05:56:34 host kernel: [   25.483142] xen:grant_table: WARNING: g.e. 0x37f still in use!
Oct 14 05:56:34 host kernel: [   25.483152] deferring g.e. 0x37f (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483156] xen:grant_table: WARNING: g.e. 0x381 still in use!
Oct 14 05:56:34 host kernel: [   25.483159] deferring g.e. 0x381 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483160] xen:grant_table: WARNING: g.e. 0x382 still in use!
Oct 14 05:56:34 host kernel: [   25.483163] deferring g.e. 0x382 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483164] xen:grant_table: WARNING: g.e. 0x383 still in use!
Oct 14 05:56:34 host kernel: [   25.483167] deferring g.e. 0x383 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483168] xen:grant_table: WARNING: g.e. 0x380 still in use!
Oct 14 05:56:34 host kernel: [   25.483171] deferring g.e. 0x380 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483172] xen:grant_table: WARNING: g.e. 0x340 still in use!
Oct 14 05:56:34 host kernel: [   25.483175] deferring g.e. 0x340 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483177] xen:grant_table: WARNING: g.e. 0x384 still in use!
Oct 14 05:56:34 host kernel: [   25.483180] deferring g.e. 0x384 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483181] xen:grant_table: WARNING: g.e. 0x385 still in use!
Oct 14 05:56:34 host kernel: [   25.483183] deferring g.e. 0x385 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483184] xen:grant_table: WARNING: g.e. 0x386 still in use!
Oct 14 05:56:34 host kernel: [   25.483186] deferring g.e. 0x386 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483187] xen:grant_table: WARNING: g.e. 0x387 still in use!
Oct 14 05:56:34 host kernel: [   25.483188] deferring g.e. 0x387 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483189] xen:grant_table: WARNING: g.e. 0x388 still in use!
Oct 14 05:56:34 host kernel: [   25.483191] deferring g.e. 0x388 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483192] xen:grant_table: WARNING: g.e. 0x38e still in use!
Oct 14 05:56:34 host kernel: [   25.483194] deferring g.e. 0x38e (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483194] xen:grant_table: WARNING: g.e. 0x38f still in use!
Oct 14 05:56:34 host kernel: [   25.483196] deferring g.e. 0x38f (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483197] xen:grant_table: WARNING: g.e. 0x390 still in use!
Oct 14 05:56:34 host kernel: [   25.483199] deferring g.e. 0x390 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483199] xen:grant_table: WARNING: g.e. 0x391 still in use!
Oct 14 05:56:34 host kernel: [   25.483201] deferring g.e. 0x391 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483202] xen:grant_table: WARNING: g.e. 0x392 still in use!
Oct 14 05:56:34 host kernel: [   25.483204] deferring g.e. 0x392 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483204] xen:grant_table: WARNING: g.e. 0x393 still in use!
Oct 14 05:56:34 host kernel: [   25.483206] deferring g.e. 0x393 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483207] xen:grant_table: WARNING: g.e. 0x394 still in use!
Oct 14 05:56:34 host kernel: [   25.483210] deferring g.e. 0x394 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483211] xen:grant_table: WARNING: g.e. 0x395 still in use!
Oct 14 05:56:34 host kernel: [   25.483213] deferring g.e. 0x395 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483215] xen:grant_table: WARNING: g.e. 0x396 still in use!
Oct 14 05:56:34 host kernel: [   25.483217] deferring g.e. 0x396 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483218] xen:grant_table: WARNING: g.e. 0x39a still in use!
Oct 14 05:56:34 host kernel: [   25.483222] deferring g.e. 0x39a (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483223] xen:grant_table: WARNING: g.e. 0x399 still in use!
Oct 14 05:56:34 host kernel: [   25.483226] deferring g.e. 0x399 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483227] xen:grant_table: WARNING: g.e. 0x37e still in use!
Oct 14 05:56:34 host kernel: [   25.483230] deferring g.e. 0x37e (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483231] xen:grant_table: WARNING: g.e. 0x37d still in use!
Oct 14 05:56:34 host kernel: [   25.483234] deferring g.e. 0x37d (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483234] xen:grant_table: WARNING: g.e. 0x37c still in use!
Oct 14 05:56:34 host kernel: [   25.483237] deferring g.e. 0x37c (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483238] xen:grant_table: WARNING: g.e. 0x38a still in use!
Oct 14 05:56:34 host kernel: [   25.483240] deferring g.e. 0x38a (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483241] xen:grant_table: WARNING: g.e. 0x389 still in use!
Oct 14 05:56:34 host kernel: [   25.483243] deferring g.e. 0x389 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483244] xen:grant_table: WARNING: g.e. 0x38b still in use!
Oct 14 05:56:34 host kernel: [   25.483247] deferring g.e. 0x38b (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483248] xen:grant_table: WARNING: g.e. 0x38d still in use!
Oct 14 05:56:34 host kernel: [   25.483251] deferring g.e. 0x38d (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483252] xen:grant_table: WARNING: g.e. 0x38c still in use!
Oct 14 05:56:34 host kernel: [   25.483255] deferring g.e. 0x38c (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483256] xen:grant_table: WARNING: g.e. 0x398 still in use!
Oct 14 05:56:34 host kernel: [   25.483259] deferring g.e. 0x398 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483261] xen:grant_table: WARNING: g.e. 0x397 still in use!
Oct 14 05:56:34 host kernel: [   25.483264] deferring g.e. 0x397 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483264] xen:grant_table: WARNING: g.e. 0x37b still in use!
Oct 14 05:56:34 host kernel: [   25.483266] deferring g.e. 0x37b (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483267] xen:grant_table: WARNING: g.e. 0x37a still in use!
Oct 14 05:56:34 host kernel: [   25.483269] deferring g.e. 0x37a (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483270] xen:grant_table: WARNING: g.e. 0x379 still in use!
Oct 14 05:56:34 host kernel: [   25.483271] deferring g.e. 0x379 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483272] xen:grant_table: WARNING: g.e. 0x378 still in use!
Oct 14 05:56:34 host kernel: [   25.483275] deferring g.e. 0x378 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483276] xen:grant_table: WARNING: g.e. 0x377 still in use!
Oct 14 05:56:34 host kernel: [   25.483280] deferring g.e. 0x377 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483284] xen:grant_table: WARNING: g.e. 0x376 still in use!
Oct 14 05:56:34 host kernel: [   25.483287] deferring g.e. 0x376 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483288] xen:grant_table: WARNING: g.e. 0x375 still in use!
Oct 14 05:56:34 host kernel: [   25.483291] deferring g.e. 0x375 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483292] xen:grant_table: WARNING: g.e. 0x374 still in use!
Oct 14 05:56:34 host kernel: [   25.483295] deferring g.e. 0x374 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483296] xen:grant_table: WARNING: g.e. 0x373 still in use!
Oct 14 05:56:34 host kernel: [   25.483299] deferring g.e. 0x373 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483300] xen:grant_table: WARNING: g.e. 0x372 still in use!
Oct 14 05:56:34 host kernel: [   25.483303] deferring g.e. 0x372 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483304] xen:grant_table: WARNING: g.e. 0x371 still in use!
Oct 14 05:56:34 host kernel: [   25.483307] deferring g.e. 0x371 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483308] xen:grant_table: WARNING: g.e. 0x370 still in use!
Oct 14 05:56:34 host kernel: [   25.483311] deferring g.e. 0x370 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483313] xen:grant_table: WARNING: g.e. 0x36f still in use!
Oct 14 05:56:34 host kernel: [   25.483316] deferring g.e. 0x36f (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483317] xen:grant_table: WARNING: g.e. 0x36e still in use!
Oct 14 05:56:34 host kernel: [   25.483320] deferring g.e. 0x36e (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483321] xen:grant_table: WARNING: g.e. 0x36d still in use!
Oct 14 05:56:34 host kernel: [   25.483323] deferring g.e. 0x36d (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483324] xen:grant_table: WARNING: g.e. 0x36c still in use!
Oct 14 05:56:34 host kernel: [   25.483328] deferring g.e. 0x36c (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483329] xen:grant_table: WARNING: g.e. 0x36b still in use!
Oct 14 05:56:34 host kernel: [   25.483332] deferring g.e. 0x36b (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483333] xen:grant_table: WARNING: g.e. 0x36a still in use!
Oct 14 05:56:34 host kernel: [   25.483336] deferring g.e. 0x36a (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483337] xen:grant_table: WARNING: g.e. 0x369 still in use!
Oct 14 05:56:34 host kernel: [   25.483340] deferring g.e. 0x369 (pfn 0xffffffffffffffff)
Oct 14 05:56:34 host kernel: [   25.483503] block xvdb: device/vbd/51728 was hot-unplugged, 1 stale handles
Oct 14 05:56:35 host kernel: [   26.484067] xen:grant_table: freeing g.e. 0x37f
Oct 14 05:56:35 host kernel: [   26.484121] xen:grant_table: freeing g.e. 0x381
Oct 14 05:56:35 host kernel: [   26.484134] xen:grant_table: freeing g.e. 0x382
Oct 14 05:56:35 host kernel: [   26.484145] xen:grant_table: freeing g.e. 0x383
Oct 14 05:56:35 host kernel: [   26.484155] xen:grant_table: freeing g.e. 0x380
Oct 14 05:56:35 host kernel: [   26.484166] xen:grant_table: freeing g.e. 0x340
Oct 14 05:56:35 host kernel: [   26.484176] xen:grant_table: freeing g.e. 0x384
Oct 14 05:56:35 host kernel: [   26.484186] xen:grant_table: freeing g.e. 0x385
Oct 14 05:56:35 host kernel: [   26.484196] xen:grant_table: freeing g.e. 0x386
Oct 14 05:56:35 host kernel: [   26.484207] xen:grant_table: freeing g.e. 0x387
Oct 14 05:57:37 host kernel: [   26.617782] Freezing user space processes ... (elapsed 0.001 seconds) done.
Oct 14 05:57:37 host kernel: [   26.618924] Freezing remaining freezable tasks ... (elapsed 0.001 seconds) done.
Oct 14 05:57:37 host kernel: [   26.620054] PM: freeze of devices complete after 0.054 msecs
Oct 14 05:57:37 host kernel: [   26.620061] suspending xenstore...
Oct 14 05:57:37 host kernel: [   26.620095] PM: late freeze of devices complete after 0.032 msecs
Oct 14 05:57:37 host kernel: [   26.620129] PM: noirq freeze of devices complete after 0.030 msecs
Oct 14 05:57:37 host kernel: [   26.621056] xen:grant_table: Grant tables using version 1 layout
Oct 14 05:57:37 host kernel: [   26.621056] Using NULL legacy PIC
Oct 14 05:57:37 host kernel: [   26.621056] PM: noirq restore of devices complete after 0.043 msecs
Oct 14 05:57:37 host kernel: [   26.621056] PM: early restore of devices complete after 0.024 msecs
Oct 14 05:57:37 host kernel: [   26.718449] PM: restore of devices complete after 97.335 msecs
Oct 14 05:57:37 host kernel: [   26.718486] Restarting tasks ... done.
Oct 14 05:57:37 host pulseaudio[1831]: vchan module loading
Oct 14 05:57:37 host kernel: [   26.821737] Setting capacity to 20971520
Oct 14 05:57:38 host pulseaudio[1831]: play libvchan_fd_for_select=19, ctrl=0x212e620
Oct 14 05:57:38 host pulseaudio[1831]: rec libvchan_fd_for_select=22, ctrl=0x212f0b0
Oct 14 05:57:38 host pulseaudio[1831]: sink cork req state =1, now state=-2
Oct 14 05:57:38 host pulseaudio[1831]: source cork req state =1, now state=-2
Oct 14 05:57:38 host pulseaudio[1831]: Failed to open cookie file '/home/user/.config/pulse/cookie': No such file or directory
Oct 14 05:57:38 host pulseaudio[1831]: Failed to load authorization key '/home/user/.config/pulse/cookie': No such file or directory
Oct 14 05:57:38 host kernel: [   27.486025] xen:grant_table: freeing g.e. 0x388
Oct 14 05:57:38 host kernel: [   27.486043] xen:grant_table: freeing g.e. 0x38e
Oct 14 05:57:38 host kernel: [   27.486049] xen:grant_table: freeing g.e. 0x38f
Oct 14 05:57:38 host kernel: [   27.486054] xen:grant_table: freeing g.e. 0x390
Oct 14 05:57:38 host kernel: [   27.486059] xen:grant_table: freeing g.e. 0x391
Oct 14 05:57:38 host kernel: [   27.486066] xen:grant_table: freeing g.e. 0x392
Oct 14 05:57:38 host kernel: [   27.486074] xen:grant_table: freeing g.e. 0x393
Oct 14 05:57:38 host kernel: [   27.486081] xen:grant_table: freeing g.e. 0x394
Oct 14 05:57:38 host kernel: [   27.486093] xen:grant_table: freeing g.e. 0x395
Oct 14 05:57:38 host kernel: [   27.486102] xen:grant_table: freeing g.e. 0x396
Oct 14 05:57:39 host kernel: [   28.488045] xen:grant_table: freeing g.e. 0x39a
Oct 14 05:57:39 host kernel: [   28.488071] xen:grant_table: freeing g.e. 0x399
Oct 14 05:57:39 host kernel: [   28.488078] xen:grant_table: freeing g.e. 0x37e
Oct 14 05:57:39 host kernel: [   28.488087] xen:grant_table: freeing g.e. 0x37d
Oct 14 05:57:39 host kernel: [   28.488094] xen:grant_table: freeing g.e. 0x37c
Oct 14 05:57:39 host kernel: [   28.488101] xen:grant_table: freeing g.e. 0x38a
Oct 14 05:57:39 host kernel: [   28.488108] xen:grant_table: freeing g.e. 0x389
Oct 14 05:57:39 host kernel: [   28.488114] xen:grant_table: freeing g.e. 0x38b
Oct 14 05:57:39 host kernel: [   28.488121] xen:grant_table: freeing g.e. 0x38d
Oct 14 05:57:39 host kernel: [   28.488127] xen:grant_table: freeing g.e. 0x38c
Oct 14 05:57:40 host kernel: [   29.490049] xen:grant_table: freeing g.e. 0x398
Oct 14 05:57:40 host kernel: [   29.490092] xen:grant_table: freeing g.e. 0x397
Oct 14 05:57:40 host kernel: [   29.490106] xen:grant_table: freeing g.e. 0x37b
Oct 14 05:57:40 host kernel: [   29.490116] xen:grant_table: freeing g.e. 0x37a
Oct 14 05:57:40 host kernel: [   29.490126] xen:grant_table: freeing g.e. 0x379
Oct 14 05:57:40 host kernel: [   29.490136] xen:grant_table: freeing g.e. 0x378
Oct 14 05:57:40 host kernel: [   29.490146] xen:grant_table: freeing g.e. 0x377
Oct 14 05:57:40 host kernel: [   29.490155] xen:grant_table: freeing g.e. 0x376
Oct 14 05:57:40 host kernel: [   29.490165] xen:grant_table: freeing g.e. 0x375
Oct 14 05:57:40 host kernel: [   29.490175] xen:grant_table: freeing g.e. 0x374
Oct 14 05:57:41 host kernel: [   30.492057] xen:grant_table: freeing g.e. 0x373
Oct 14 05:57:41 host kernel: [   30.492103] xen:grant_table: freeing g.e. 0x372
Oct 14 05:57:41 host kernel: [   30.492115] xen:grant_table: freeing g.e. 0x371
Oct 14 05:57:41 host kernel: [   30.492125] xen:grant_table: freeing g.e. 0x370
Oct 14 05:57:41 host kernel: [   30.492135] xen:grant_table: freeing g.e. 0x36f
Oct 14 05:57:41 host kernel: [   30.492145] xen:grant_table: freeing g.e. 0x36e
Oct 14 05:57:41 host kernel: [   30.492155] xen:grant_table: freeing g.e. 0x36d
Oct 14 05:57:41 host kernel: [   30.492165] xen:grant_table: freeing g.e. 0x36c
Oct 14 05:57:41 host kernel: [   30.492175] xen:grant_table: freeing g.e. 0x36b
Oct 14 05:57:41 host kernel: [   30.492185] xen:grant_table: freeing g.e. 0x36a
Oct 14 05:57:42 host kernel: [   31.494061] xen:grant_table: freeing g.e. 0x369
Oct 14 05:57:43 host pulseaudio[1831]: source cork req state =2, now state=1
Oct 14 05:57:43 host pulseaudio[1831]: sink cork req state =2, now state=1
@marmarek

This comment has been minimized.

Show comment
Hide comment
@marmarek

marmarek Oct 14, 2015

Member

On Tue, Oct 13, 2015 at 11:09:49PM -0700, Patrick Schleizer wrote:

user@host:~$ cat /var/log/kern.log
(...)
Oct 14 05:56:14 host kernel: [ 5.460525] EXT4-fs (xvdb): recovery complete
Oct 14 05:56:14 host kernel: [ 5.469273] EXT4-fs (xvdb): mounted filesystem with ordered data mode. Opts: discard
Oct 14 05:56:24 host kernel: [ 15.479389] vbd vbd-51728: 16 Device in use; refusing to close
(...)
Oct 14 05:56:34 host kernel: [ 25.483503] block xvdb: device/vbd/51728 was hot-unplugged, 1 stale handles

Ok, I think I know what's the problem. DispVMs are running with /rw
unmounted, but it is accessible during DispVM template preparation (to
source initial user settings), but then unmounted:

https://github.com/QubesOS/qubes-core-agent-linux/blob/master/vm-systemd/prepare-dvm.sh#L15

Since Whonix adds additional bind-mounts, above unmount fails (or more
precisely - do not free /dev/xvdb), which later is detached from the VM
anyway.

To solve this, you can, in case of DispVM, do not bind-mount directories,
but copy the content instead.

BTW For /home it is done only conditionally:
https://github.com/QubesOS/qubes-core-agent-linux/blob/master/misc/dispvm-prerun.sh#L6-L10

And some other relevant script (for /home):
https://github.com/QubesOS/qubes-core-agent-linux/blob/master/vm-systemd/mount-home.sh#L77-L89

Best Regards,
Marek Marczykowski-Górecki
Invisible Things Lab
A: Because it messes up the order in which people normally read text.
Q: Why is top-posting such a bad thing?

Member

marmarek commented Oct 14, 2015

On Tue, Oct 13, 2015 at 11:09:49PM -0700, Patrick Schleizer wrote:

user@host:~$ cat /var/log/kern.log
(...)
Oct 14 05:56:14 host kernel: [ 5.460525] EXT4-fs (xvdb): recovery complete
Oct 14 05:56:14 host kernel: [ 5.469273] EXT4-fs (xvdb): mounted filesystem with ordered data mode. Opts: discard
Oct 14 05:56:24 host kernel: [ 15.479389] vbd vbd-51728: 16 Device in use; refusing to close
(...)
Oct 14 05:56:34 host kernel: [ 25.483503] block xvdb: device/vbd/51728 was hot-unplugged, 1 stale handles

Ok, I think I know what's the problem. DispVMs are running with /rw
unmounted, but it is accessible during DispVM template preparation (to
source initial user settings), but then unmounted:

https://github.com/QubesOS/qubes-core-agent-linux/blob/master/vm-systemd/prepare-dvm.sh#L15

Since Whonix adds additional bind-mounts, above unmount fails (or more
precisely - do not free /dev/xvdb), which later is detached from the VM
anyway.

To solve this, you can, in case of DispVM, do not bind-mount directories,
but copy the content instead.

BTW For /home it is done only conditionally:
https://github.com/QubesOS/qubes-core-agent-linux/blob/master/misc/dispvm-prerun.sh#L6-L10

And some other relevant script (for /home):
https://github.com/QubesOS/qubes-core-agent-linux/blob/master/vm-systemd/mount-home.sh#L77-L89

Best Regards,
Marek Marczykowski-Górecki
Invisible Things Lab
A: Because it messes up the order in which people normally read text.
Q: Why is top-posting such a bad thing?

@marmarek

This comment has been minimized.

Show comment
Hide comment
@marmarek

marmarek Oct 14, 2015

Member

This probably should be handled by
https://phabricator.whonix.org/T414
(in current Whonix-specific package and in the future generic package)

Best Regards,
Marek Marczykowski-Górecki
Invisible Things Lab
A: Because it messes up the order in which people normally read text.
Q: Why is top-posting such a bad thing?

Member

marmarek commented Oct 14, 2015

This probably should be handled by
https://phabricator.whonix.org/T414
(in current Whonix-specific package and in the future generic package)

Best Regards,
Marek Marczykowski-Górecki
Invisible Things Lab
A: Because it messes up the order in which people normally read text.
Q: Why is top-posting such a bad thing?

@marmarek

This comment has been minimized.

Show comment
Hide comment
@marmarek

marmarek Nov 3, 2015

Member

Is it handled already by Whonix scripts, or you want to make it on top of https://phabricator.whonix.org/T414 ?

Member

marmarek commented Nov 3, 2015

Is it handled already by Whonix scripts, or you want to make it on top of https://phabricator.whonix.org/T414 ?

@adrelanos

This comment has been minimized.

Show comment
Hide comment
@adrelanos

adrelanos Nov 3, 2015

Member

Not yet solved. Planned during development of Whonix 13. On top of https://phabricator.whonix.org/T414.

Member

adrelanos commented Nov 3, 2015

Not yet solved. Planned during development of Whonix 13. On top of https://phabricator.whonix.org/T414.

@adrelanos

This comment has been minimized.

Show comment
Hide comment
@adrelanos

adrelanos Jan 6, 2016

Member

Pull request https://github.com/marmarek/qubes-core-agent-linux/pull/58 [and once actually used by Whonix] would solve this ticket, because it would only run inside TemplateBasedVMs. (/qubes-vm-persistence rw-only) Not inside DispVMs. (/qubes-vm-persistence none) Therefore avoid the cause (the bind mount) for this issue.

Member

adrelanos commented Jan 6, 2016

Pull request https://github.com/marmarek/qubes-core-agent-linux/pull/58 [and once actually used by Whonix] would solve this ticket, because it would only run inside TemplateBasedVMs. (/qubes-vm-persistence rw-only) Not inside DispVMs. (/qubes-vm-persistence none) Therefore avoid the cause (the bind mount) for this issue.

@marmarek

This comment has been minimized.

Show comment
Hide comment
@marmarek

marmarek Jan 6, 2016

Member

Is that PR the only missing part for having Disposable Whonix-workstation?

Member

marmarek commented Jan 6, 2016

Is that PR the only missing part for having Disposable Whonix-workstation?

@adrelanos

This comment has been minimized.

Show comment
Hide comment
@adrelanos

adrelanos Jan 6, 2016

Member

Marek Marczykowski-Górecki:

Is that PR the only missing part for having Disposable Whonix-workstation?

On the Qubes side, most likely yes. [Unless other issues are found.]

[On the Whonix side, a commit actually using this is missing. Small deal.]

[As long as VMs initially inherit their TemplateVMs home folder. But
this will be solved for Whonix 13 also.]

I am tracking the progress, user documentation and issues for
Whonix-Workstation DispVMs for now here:

https://www.whonix.org/wiki/Qubes/Disposable_VM

The other issues listed on that page aren't deal breakers.

Member

adrelanos commented Jan 6, 2016

Marek Marczykowski-Górecki:

Is that PR the only missing part for having Disposable Whonix-workstation?

On the Qubes side, most likely yes. [Unless other issues are found.]

[On the Whonix side, a commit actually using this is missing. Small deal.]

[As long as VMs initially inherit their TemplateVMs home folder. But
this will be solved for Whonix 13 also.]

I am tracking the progress, user documentation and issues for
Whonix-Workstation DispVMs for now here:

https://www.whonix.org/wiki/Qubes/Disposable_VM

The other issues listed on that page aren't deal breakers.

@adrelanos adrelanos referenced this issue in marmarek/old-qubes-core-agent-linux Jan 6, 2016

Merged

Binds directories which allows changes in TemplateBasedVM to persist #58

adrelanos added a commit to Whonix/qubes-whonix that referenced this issue Jan 6, 2016

@adrelanos

This comment has been minimized.

Show comment
Hide comment
@adrelanos

adrelanos Jan 6, 2016

Member

fixed '/bin/sync hangs forever in whonix-ws-dvm':
Whonix/qubes-whonix@267e26c
Will appear in Whonix 13.

Member

adrelanos commented Jan 6, 2016

fixed '/bin/sync hangs forever in whonix-ws-dvm':
Whonix/qubes-whonix@267e26c
Will appear in Whonix 13.

@adrelanos

This comment has been minimized.

Show comment
Hide comment
@adrelanos

adrelanos Jan 6, 2016

Member

I currently cannot test if this actually works in a DispVM because of a different issue: #1591.

Member

adrelanos commented Jan 6, 2016

I currently cannot test if this actually works in a DispVM because of a different issue: #1591.

@marmarek

This comment has been minimized.

Show comment
Hide comment
@marmarek

marmarek Jan 6, 2016

Member

I currently cannot test if this actually works in a DispVM because of a different issue: #1328.

Are you sure about the issue number? It is this one...

Member

marmarek commented Jan 6, 2016

I currently cannot test if this actually works in a DispVM because of a different issue: #1328.

Are you sure about the issue number? It is this one...

@adrelanos

This comment has been minimized.

Show comment
Hide comment
@adrelanos

adrelanos Jan 6, 2016

Member

Meant #1591. Fixed that post. (I still sometimes mess up the global copy and paste.)

Member

adrelanos commented Jan 6, 2016

Meant #1591. Fixed that post. (I still sometimes mess up the global copy and paste.)

@adrelanos

This comment has been minimized.

Show comment
Hide comment
@adrelanos

adrelanos Jan 6, 2016

Member

Your analysis in #1591 (comment) helped me to test this. Result:

Does not work in an actual DispVM yet.

qubesdb-read /qubes-vm-persistence outputs rw-only. Therefore /usr/lib/qubes-whonix/bind-directories is still mounting everything.

Do you know why qubesdb-read /qubes-vm-persistence would output rw-only during DispVM startup? Does it have something to do with the qubes-dvm service by chance? In a fully booted DispVM konsole however it outputs the right and expected thing none.

Member

adrelanos commented Jan 6, 2016

Your analysis in #1591 (comment) helped me to test this. Result:

Does not work in an actual DispVM yet.

qubesdb-read /qubes-vm-persistence outputs rw-only. Therefore /usr/lib/qubes-whonix/bind-directories is still mounting everything.

Do you know why qubesdb-read /qubes-vm-persistence would output rw-only during DispVM startup? Does it have something to do with the qubes-dvm service by chance? In a fully booted DispVM konsole however it outputs the right and expected thing none.

@marmarek

This comment has been minimized.

Show comment
Hide comment
@marmarek

marmarek Jan 6, 2016

Member

Do you know why qubesdb-read /qubes-vm-persistence would output rw-only during DispVM startup?

Actually not during DispVM startup, but DispVM savefile creation, which is normal AppVM startup, from core code point of view... And indeed, during that stage (savefile creation), data saved in /rw would persist. This would change after implementing your read-only private image approach.
So, maybe for now, it would be better to check something else in bind-directories script? Like /var/run/qubes-service/qubes-dvm. Maybe in addition to the current check (to support also future DispVM implementation)?

Member

marmarek commented Jan 6, 2016

Do you know why qubesdb-read /qubes-vm-persistence would output rw-only during DispVM startup?

Actually not during DispVM startup, but DispVM savefile creation, which is normal AppVM startup, from core code point of view... And indeed, during that stage (savefile creation), data saved in /rw would persist. This would change after implementing your read-only private image approach.
So, maybe for now, it would be better to check something else in bind-directories script? Like /var/run/qubes-service/qubes-dvm. Maybe in addition to the current check (to support also future DispVM implementation)?

adrelanos added a commit to adrelanos/qubes-whonix that referenced this issue Jan 6, 2016

@adrelanos

This comment has been minimized.

Show comment
Hide comment
@adrelanos

adrelanos Jan 6, 2016

Member

That works!

Member

adrelanos commented Jan 6, 2016

That works!

@adrelanos adrelanos closed this Jan 6, 2016

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment