Win 7 HVM (template) won't start after tools installed ("qrexec not connected")

[inf...@gmail.com]

Qubes R2 up to date
Hardware is X1 Carbon Gen2

I started with a fully updated Windows 7 Ultimate *template* HVM,
followed the REAME to allow driver installation
installed Windows tools (2.4.0.1) with "Typical" option (with qvmstart wIn7Q --install-windows-tools),
installation appeared to go OK, allowing for reboots and moving of profiles
and now Windows 7 template won't start

When I start it up, it tries throws up the Windows desktop screen (showing log-in in progress), but then bombs out with

              Error starting VM 'win7Q': Domain 'win7Q': qrexec not connected

After that it always hangs in a "yellow" state, and sometimes more worryingly I cannot kill the machine (need to log out)

I looked at https://qubes-os.org/wiki/WindowsTools and this similar thread but might need a little help debugging

FWIW I had the same Windows template working OK with a previous version (~6 months) of the tools

HOWEVER: I have now discovered that if I manually toggle the Seamless Mode checkbox in the VM config ON, then still get behaviour above, but if I then toggle OFF, then the window for Windows opens OK (but the machine state still stays obstinately yellow)

thanks

Caspar
--
Qubes Policy Adviser

[Rafał Wojdyła]

On 2014-12-04 11:30, inf...@gmail.com wrote:
> Qubes R2 up to date
> Hardware is X1 Carbon Gen2
>
> I started with a fully updated Windows 7 Ultimate *template* HVM,
> followed the REAME to allow driver installation
> installed Windows tools (2.4.0.1) with "Typical" option (with qvmstart
> wIn7Q --install-windows-tools),
> installation appeared to go OK, allowing for reboots and moving of profiles
> and now Windows 7 template won't start
>
> When I start it up, it tries throws up the Windows desktop screen
> (showing log-in in progress), but then bombs out with
>
> Error starting VM 'win7Q': Domain 'win7Q': qrexec not
> connected
>
> After that it always hangs in a "yellow" state, and sometimes more
> worryingly I cannot kill the machine (need to log out)
>
> I looked at https://qubes-os.org/wiki/WindowsTools and this

> <https://groups.google.com/d/msg/qubes-users/OxpRQLYQoVg/1esCXiuaIwgJ>

> similar thread but might need a little help debugging
>
> FWIW I had the same Windows template working OK with a previous version
> (~6 months) of the tools
>
> HOWEVER: I have now discovered that if I manually toggle the Seamless
> Mode checkbox in the VM config ON, then still get behaviour above, but
> if I then toggle OFF, then the window for Windows opens OK (but the
> machine state still stays obstinately yellow)
>
> thanks
>
> Caspar
> --
> Qubes Policy Adviser

Can you access the VM in safe mode? If so, please send the qrexec and
wga logs (procedure is described in the wiki article mentioned above).

Also, did you see a message box saying that user profiles will me moved
on the next VM boot and did you restart the VM afterwards? Sometimes the
moving procedure can take a long time (needs investigating) and because
it takes place early in the boot process, qrexec and other services are
not active yet, and the VM *will* show as "yellow" during the process.
That could use some improvement as well...

--
Rafał Wojdyła
Qubes Tools for Windows developer

[IX4 SVS]

I am experiencing similar behaviour. I have completed the installation steps for a Windows 7 template-based HVM to the best of my understanding. Now, whenever I launch my win7-test VM (which is based on win7-x64-template), it gets indefinitely stuck in a "yellow" state and never produces any application windows for me to interact with.

Here are the steps I followed to create the win7 template VM:

[alex@dom0 ~]$ sudo qubes-dom0-update qubes-windows-tools
[alex@dom0 ~]$ qvm-create --hvm-template win7-x64-template -l purple
[alex@dom0 ~]$

Go to Qubes VM manager, increase RAM to 2048MB.

[alex@dom0 ~]$ qvm-start win7-x64-template --cdrom=/home/alex/win7.iso

Wait for Windows to install in the template VM...

(reboot)

[alex@dom0 ~]$ qvm-start win7-x64-template

(reboot)

[alex@dom0 ~]$ qvm-start win7-x64-template

...and we have a desktop!

Poweroff.

[alex@dom0 ~]$ qvm-start win7-x64-template --install-windows-tools

[In Win7 desktop]
cmd -> right click -> run as administrator
bcdedit /set testsigning on

Poweroff

[alex@dom0 ~]$ qvm-start win7-x64-template --install-windows-tools

Install qubes windows tools from the CDROM
choose "complete" installation
accept many scary red prompts
restart
[alex@dom0 ~]$ qvm-start win7-x64-template

We're told the user directory has been moved to D.

restart

[alex@dom0 ~]$ qvm-start win7-x64-template

bcdedit /set testsigning off (from admin cmd.exe in template)

At this point qvm-run -a win7-x64-template explorer.exe produces a Windows Explorer  and all seems well, with all Windows menus having been integrated in the Qubes menu.

Install Windows Updates and MS Security Essentials.

Now let's create an AppVM based off this template:

[alex@dom0 ~]$ qvm-create --hvm win7-test --template win7-x64-template --label black
--> Using TemplateVM: win7-x64-template
--> Creating directory: /var/lib/qubes/appvms/win7-test
--> Creating icon symlink: /var/lib/qubes/appvms/win7-test/icon.png -> /usr/share/icons/hicolor/128x128/devices/appvm-black.png
--> Copying the template's private image: /var/lib/qubes/vm-templates/win7-x64-template/private.img
--> Converting Appmenu Templates...
--> Adding Apps to the Menu...
kbuildsycoca4 running...
[alex@dom0 ~]$

The first invocation seems to have gone well, but any subsequent invocations fail like this:

[alex@dom0 ~]$ qvm-run -a win7-test explorer.exe
Running command on VM: 'win7-test'...
Starting the VM 'win7-test'...
--> Loading the VM (type = HVM)...
--> Setting Xen Store info for the VM...
--> Updating firewall rules...
--> Starting the VM...
--> Starting the qrexec daemon...
Waiting for VM's qrexec agent.............................................................Cannot connect to qrexec agent for 60 seconds, still trying in the background
ERROR(win7-test): Error while starting the 'win7-test' VM: Cannot execute qrexec-daemon!
[alex@dom0 ~]$

Contents of guest-win7-test-dm.log:
Xen Minimal OS!
  start_info: 0x56e000(VA)
    nr_pages: 0x2000
  shared_inf: 0x71b9f000(MA)
     pt_base: 0x571000(VA)
nr_pt_frames: 0x7
    mfn_list: 0x55e000(VA)
   mod_start: 0x0(VA)
     mod_len: 0
       flags: 0x0
    cmd_line:  -d 3
  stack:      0x51ce60-0x53ce60
MM: Init
      _text: 0x0(VA)
     _etext: 0x108683(VA)
   _erodata: 0x15b000(VA)
     _edata: 0x164108(VA)
stack start: 0x51ce60(VA)
       _end: 0x55d768(VA)
  start_pfn: 57b
    max_pfn: 2000
Mapping memory range 0x800000 - 0x2000000
setting 0x0-0x15b000 readonly
skipped 0x1000
MM: Initialise page allocator for 587000(587000)-2000000(2000000)
MM: done
Demand map pfns at 2001000-2002001000.
Heap resides at 2002002000-4002002000.
Initialising timer interface
Initialising console ... done.
gnttab_table mapped at 0x2001000.
Initialising scheduler
Thread "Idle": pointer: 0x2002002050, stack: 0x5a0000
Thread "xenstore": pointer: 0x2002002800, stack: 0x5b0000
xenbus initialised on irq 1 mfn 0x73538
Dummy main: start_info=0x53cf60
Thread "main": pointer: 0x2002002fb0, stack: 0x5c0000
Thread "pcifront": pointer: 0x2002003760, stack: 0x5d0000
pcifront_watches: waiting for backend path to appear device/pci/0/backend
dom vm is at /vm/762a6106-6857-4d7e-be13-201eaedbad4d
"main" "-d" "3" "-d" "3" "-domain-name" "win7-test" "-vnc" "127.0.0.1:0" "-vncunused" "-videoram" "8" "-std-vga" "-boot" "dca" "-usb" "-usbdevice" "tablet" "-acpi" "-vcpus" "4" "-vcpu_avail" "0xf" "-net" "nic,vlan=0,macaddr=00:16:3e:5e:6c:04,model=rtl8139" "-net" "tap,vlan=0,ifname=tap3.0,bridge=xenbr0,script=no" "-net" "lwip,client_ip=10.137.2.7,server_ip=10.137.2.254,dns=10.137.2.1,gw=10.137.2.1,netmask=255.255.255.0" 
domid: 3
domid: 3
************************ NETFRONT for device/vif/0 **********
 
 
net TX ring size 256
net RX ring size 256
backend at /local/domain/2/backend/vif/4/0
mac is 00:16:3e:5e:6c:04
**************************
tap_open((null)) -> 3
Waiting for network.
IP a8902fe netmask ffffff00 gateway a890201.
TCP/IP bringup begins.
Thread "tcpip_thread": pointer: 0x2002007570, stack: 0x6f0000
TCP/IP bringup ends.
registering DHCP server
Network is ready.
xs_daemon_open -> 5, 0x1603b8
Using xvda for guest's hda
******************* BLKFRONT for /local/domain/4/device/vbd/51712 **********
 
 
backend at /local/domain/0/backend/vbd/4/51712
41943040 sectors of 512 bytes
**************************
blk_open(/local/domain/4/device/vbd/51712) -> 6
Using xvdb for guest's hdb
******************* BLKFRONT for /local/domain/4/device/vbd/51728 **********
 
 
backend at /local/domain/0/backend/vbd/4/51728
4194304 sectors of 512 bytes
**************************
blk_open(/local/domain/4/device/vbd/51728) -> 7
xs_directory(/local/domain/4/device/vkbd): ENOENT
xs_directory(/local/domain/4/device/vfb): ENOENT
xs_watch(/local/domain/0/device-model/3/logdirty/cmd, logdirty)
Watching /local/domain/0/device-model/3/logdirty/cmd
xs_watch(/local/domain/0/device-model/3/command, dm-command)
Watching /local/domain/0/device-model/3/command
xs_watch(/local/domain/3/cpu, vcpu-set)
Watching /local/domain/3/cpu
xs_read(/local/domain/0/backend/pci/3/0/msitranslate): EACCES
xs_read(/local/domain/0/backend/pci/3/0/power_mgmt): EACCES
qemu_map_cache_init nr_buckets = 10000 size 4194304
shared page at pfn feffd
buffered io page at pfn feffb
Guest uuid = 762a6106-6857-4d7e-be13-201eaedbad4d
xs_watch(/local/domain/0/backend/console/3, be:0x144eb0:3:0x15b3e0)
evtchn_open() -> 8
fcntl(8, 2, 1/1)
gntmap_init(map=0x1609f8)
xs_watch(/local/domain/3/console, fe:0x200200d010)
xs_write(/local/domain/0/backend/console/3/0/state): EACCES
xs_read(/local/domain/3/console/state): ENOENT
xs_read(/local/domain/3/console/protocol): ENOENT
xs_watch(/local/domain/3/console, fe:0x200200d010)
xen be: console-0: xen be: console-0: watching frontend path (/local/domain/3/console) failed
watching frontend path (/local/domain/3/console) failed
evtchn_open() -> 10
xc_evtchn_bind_interdomain(3, 7) = 0
xc_evtchn_bind_interdomain(3, 1) = 0
xc_evtchn_bind_interdomain(3, 2) = 0
xc_evtchn_bind_interdomain(3, 3) = 0
populating video RAM at ff000000
mapping video RAM from ff000000
xs_read(/local/domain/0/device-model/3/disable_pf): ENOENT
Register xen platform.
Done register platform.
xs_watch(/local/domain/3/log-throttling, /local/domain/3/log-throttling)
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
qubes_gui/init: 660
qubes_gui/init: 669
qubes_gui/init: 672
qubes_gui/init: 681
xs_daemon_open -> 11, 0x160d18
evtchn_open() -> 12
xc_evtchn_bind_unbound_port(0) = 0
qubes gui initialized
resize to 640x480@32, 2560 required
can't store dev vc:80Cx24C name for domid 3 in /serial/0 from a stub domain
xs_read_watch() -> /local/domain/3/log-throttling /local/domain/3/log-throttling
xs_read(/local/domain/3/log-throttling): ENOENT
xs_read(/local/domain/3/log-throttling): read error
qemu: ignoring not-understood drive `/local/domain/3/log-throttling'
medium change watch on `/local/domain/3/log-throttling' - unknown device, ignored
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
resize to 720x400@32, 2880 required
xs_read_watch() -> /local/domain/3/cpu vcpu-set
vcpu-set: watch node error.
[xenstore_process_vcpu_set_event]: /local/domain/3/cpu has no CPU!
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/3/command dm-command
xs_read(/local/domain/0/device-model/3/command): ENOENT
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/3/logdirty/cmd logdirty
xs_read(/local/domain/0/device-model/3/logdirty/cmd): ENOENT
Log-dirty: no command yet.
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
pcifront_watches: waiting for backend to get into the right state /local/domain/0/backend/pci/4/0
******************* PCIFRONT for device/pci/0 **********
 
 
backend at /local/domain/0/backend/pci/4/0
**************************
pcifront_watches: waiting for backend events /local/domain/0/backend/pci/4/0/state
vga s->lfb_addr = f1000000 s->lfb_end = f1800000 
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is ro state.
mapping vram to f1000000 - f1800000
resize to 1024x768@32, 4096 required
Unknown PV product 2 loaded in guest
PV driver build 1
xs_read(/mh/driver-blacklist/gplpv-windows/1): EACCES
close(6)
close blk: backend=/local/domain/0/backend/vbd/4/51712 node=/local/domain/4/device/vbd/51712
close(7)
close blk: backend=/local/domain/0/backend/vbd/4/51728 node=/local/domain/4/device/vbd/51728
region type 1 at [c100,c200).
region type 0 at [f1800000,f1800100).
squash iomem [f1000000, f1800000).
close(3)
close network: backend at /local/domain/2/backend/vif/4/0
vga s->lfb_addr = f1000000 s->lfb_end = f1800000 
shutdown requested in cpu_handle_ioreq
Issued domain 3 poweroff
close(3)
Xen Minimal OS!
  start_info: 0x56e000(VA)
    nr_pages: 0x2000
  shared_inf: 0x227b6000(MA)
     pt_base: 0x571000(VA)
nr_pt_frames: 0x7
    mfn_list: 0x55e000(VA)
   mod_start: 0x0(VA)
     mod_len: 0
       flags: 0x0
    cmd_line:  -d 5
  stack:      0x51ce60-0x53ce60
MM: Init
      _text: 0x0(VA)
     _etext: 0x108683(VA)
   _erodata: 0x15b000(VA)
     _edata: 0x164108(VA)
stack start: 0x51ce60(VA)
       _end: 0x55d768(VA)
  start_pfn: 57b
    max_pfn: 2000
Mapping memory range 0x800000 - 0x2000000
setting 0x0-0x15b000 readonly
skipped 0x1000
MM: Initialise page allocator for 587000(587000)-2000000(2000000)
MM: done
Demand map pfns at 2001000-2002001000.
Heap resides at 2002002000-4002002000.
Initialising timer interface
Initialising console ... done.
gnttab_table mapped at 0x2001000.
Initialising scheduler
Thread "Idle": pointer: 0x2002002050, stack: 0x5a0000
Thread "xenstore": pointer: 0x2002002800, stack: 0x5b0000
xenbus initialised on irq 1 mfn 0x273c2
Dummy main: start_info=0x53cf60
Thread "main": pointer: 0x2002002fb0, stack: 0x5c0000
Thread "pcifront": pointer: 0x2002003760, stack: 0x5d0000
pcifront_watches: waiting for backend path to appear device/pci/0/backend
dom vm is at /vm/713522f4-8203-45c3-8bac-9ac42f91e53a
"main" "-d" "5" "-d" "5" "-domain-name" "win7-test" "-vnc" "127.0.0.1:0" "-vncunused" "-videoram" "8" "-std-vga" "-boot" "dca" "-usb" "-usbdevice" "tablet" "-acpi" "-vcpus" "4" "-vcpu_avail" "0xf" "-net" "nic,vlan=0,macaddr=00:16:3e:5e:6c:04,model=rtl8139" "-net" "tap,vlan=0,ifname=tap5.0,bridge=xenbr0,script=no" "-net" "lwip,client_ip=10.137.2.7,server_ip=10.137.2.254,dns=10.137.2.1,gw=10.137.2.1,netmask=255.255.255.0" 
domid: 5
domid: 5
************************ NETFRONT for device/vif/0 **********
 
 
net TX ring size 256
net RX ring size 256
backend at /local/domain/2/backend/vif/6/0
mac is 00:16:3e:5e:6c:04
**************************
tap_open((null)) -> 3
Waiting for network.
IP a8902fe netmask ffffff00 gateway a890201.
TCP/IP bringup begins.
Thread "tcpip_thread": pointer: 0x2002007590, stack: 0x6f0000
TCP/IP bringup ends.
registering DHCP server
Network is ready.
xs_daemon_open -> 5, 0x1603b8
Using xvda for guest's hda
******************* BLKFRONT for /local/domain/6/device/vbd/51712 **********
 
 
backend at /local/domain/0/backend/vbd/6/51712
41943040 sectors of 512 bytes
**************************
blk_open(/local/domain/6/device/vbd/51712) -> 6
Using xvdb for guest's hdb
******************* BLKFRONT for /local/domain/6/device/vbd/51728 **********
 
 
backend at /local/domain/0/backend/vbd/6/51728
4194304 sectors of 512 bytes
**************************
blk_open(/local/domain/6/device/vbd/51728) -> 7
xs_directory(/local/domain/6/device/vkbd): ENOENT
xs_directory(/local/domain/6/device/vfb): ENOENT
xs_watch(/local/domain/0/device-model/5/logdirty/cmd, logdirty)
Watching /local/domain/0/device-model/5/logdirty/cmd
xs_watch(/local/domain/0/device-model/5/command, dm-command)
Watching /local/domain/0/device-model/5/command
xs_watch(/local/domain/5/cpu, vcpu-set)
Watching /local/domain/5/cpu
xs_read(/local/domain/0/backend/pci/5/0/msitranslate): EACCES
xs_read(/local/domain/0/backend/pci/5/0/power_mgmt): EACCES
qemu_map_cache_init nr_buckets = 10000 size 4194304
shared page at pfn feffd
buffered io page at pfn feffb
Guest uuid = 713522f4-8203-45c3-8bac-9ac42f91e53a
xs_watch(/local/domain/0/backend/console/5, be:0x144eb0:5:0x15b3e0)
evtchn_open() -> 8
fcntl(8, 2, 1/1)
gntmap_init(map=0x1609f8)
xs_watch(/local/domain/5/console, fe:0x200200d010)
xs_write(/local/domain/0/backend/console/5/0/state): EACCES
xs_read(/local/domain/5/console/state): ENOENT
xs_read(/local/domain/5/console/protocol): ENOENT
xs_watch(/local/domain/5/console, fe:0x200200d010)
xen be: console-0: xen be: console-0: watching frontend path (/local/domain/5/console) failed
watching frontend path (/local/domain/5/console) failed
evtchn_open() -> 10
xc_evtchn_bind_interdomain(5, 7) = 0
xc_evtchn_bind_interdomain(5, 1) = 0
xc_evtchn_bind_interdomain(5, 2) = 0
xc_evtchn_bind_interdomain(5, 3) = 0
populating video RAM at ff000000
mapping video RAM from ff000000
xs_read(/local/domain/0/device-model/5/disable_pf): ENOENT
Register xen platform.
Done register platform.
xs_watch(/local/domain/5/log-throttling, /local/domain/5/log-throttling)
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
qubes_gui/init: 660
qubes_gui/init: 669
qubes_gui/init: 672
qubes_gui/init: 681
xs_daemon_open -> 11, 0x160d18
evtchn_open() -> 12
xc_evtchn_bind_unbound_port(0) = 0
qubes gui initialized
resize to 640x480@32, 2560 required
can't store dev vc:80Cx24C name for domid 5 in /serial/0 from a stub domain
xs_read_watch() -> /local/domain/5/log-throttling /local/domain/5/log-throttling
xs_read(/local/domain/5/log-throttling): ENOENT
xs_read(/local/domain/5/log-throttling): read error
qemu: ignoring not-understood drive `/local/domain/5/log-throttling'
medium change watch on `/local/domain/5/log-throttling' - unknown device, ignored
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
resize to 720x400@32, 2880 required
xs_read_watch() -> /local/domain/5/cpu vcpu-set
vcpu-set: watch node error.
[xenstore_process_vcpu_set_event]: /local/domain/5/cpu has no CPU!
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/5/command dm-command
xs_read(/local/domain/0/device-model/5/command): ENOENT
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/5/logdirty/cmd logdirty
xs_read(/local/domain/0/device-model/5/logdirty/cmd): ENOENT
Log-dirty: no command yet.
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
pcifront_watches: waiting for backend to get into the right state /local/domain/0/backend/pci/6/0
******************* PCIFRONT for device/pci/0 **********
 
 
backend at /local/domain/0/backend/pci/6/0
**************************
pcifront_watches: waiting for backend events /local/domain/0/backend/pci/6/0/state
vga s->lfb_addr = f1000000 s->lfb_end = f1800000 
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is ro state.
mapping vram to f1000000 - f1800000
resize to 1024x768@32, 4096 required
Unknown PV product 2 loaded in guest
PV driver build 1
xs_read(/mh/driver-blacklist/gplpv-windows/1): EACCES
close(6)
close blk: backend=/local/domain/0/backend/vbd/6/51712 node=/local/domain/6/device/vbd/51712
close(7)
close blk: backend=/local/domain/0/backend/vbd/6/51728 node=/local/domain/6/device/vbd/51728
region type 1 at [c100,c200).
region type 0 at [f1800000,f1800100).
squash iomem [f1000000, f1800000).
close(3)
close network: backend at /local/domain/2/backend/vif/6/0
vga s->lfb_addr = f1000000 s->lfb_end = f1800000 
shutdown requested in cpu_handle_ioreq
Issued domain 5 poweroff
close(3)
Xen Minimal OS!
  start_info: 0x56e000(VA)
    nr_pages: 0x2000
  shared_inf: 0x27983000(MA)
     pt_base: 0x571000(VA)
nr_pt_frames: 0x7
    mfn_list: 0x55e000(VA)
   mod_start: 0x0(VA)
     mod_len: 0
       flags: 0x0
    cmd_line:  -d 13
  stack:      0x51ce60-0x53ce60
MM: Init
      _text: 0x0(VA)
     _etext: 0x108683(VA)
   _erodata: 0x15b000(VA)
     _edata: 0x164108(VA)
stack start: 0x51ce60(VA)
       _end: 0x55d768(VA)
  start_pfn: 57b
    max_pfn: 2000
Mapping memory range 0x800000 - 0x2000000
setting 0x0-0x15b000 readonly
skipped 0x1000
MM: Initialise page allocator for 587000(587000)-2000000(2000000)
MM: done
Demand map pfns at 2001000-2002001000.
Heap resides at 2002002000-4002002000.
Initialising timer interface
Initialising console ... done.
gnttab_table mapped at 0x2001000.
Initialising scheduler
Thread "Idle": pointer: 0x2002002050, stack: 0x5a0000
Thread "xenstore": pointer: 0x2002002800, stack: 0x5b0000
xenbus initialised on irq 1 mfn 0x2794f
Dummy main: start_info=0x53cf60
Thread "main": pointer: 0x2002002fb0, stack: 0x5c0000
Thread "pcifront": pointer: 0x2002003760, stack: 0x5d0000
pcifront_watches: waiting for backend path to appear device/pci/0/backend
dom vm is at /vm/50c90202-15f4-4157-a95e-8e6bb1e8a0cc
"main" "-d" "13" "-d" "13" "-domain-name" "win7-test" "-vnc" "127.0.0.1:0" "-vncunused" "-videoram" "8" "-std-vga" "-boot" "dca" "-usb" "-usbdevice" "tablet" "-acpi" "-vcpus" "4" "-vcpu_avail" "0xf" "-net" "nic,vlan=0,macaddr=00:16:3e:5e:6c:04,model=rtl8139" "-net" "tap,vlan=0,ifname=tap13.0,bridge=xenbr0,script=no" "-net" "lwip,client_ip=10.137.2.7,server_ip=10.137.2.254,dns=10.137.2.1,gw=10.137.2.1,netmask=255.255.255.0" 
domid: 13
domid: 13
************************ NETFRONT for device/vif/0 **********
 
 
net TX ring size 256
net RX ring size 256
backend at /local/domain/2/backend/vif/14/0
mac is 00:16:3e:5e:6c:04
**************************
tap_open((null)) -> 3
Waiting for network.
IP a8902fe netmask ffffff00 gateway a890201.
TCP/IP bringup begins.
Thread "tcpip_thread": pointer: 0x2002007590, stack: 0x6f0000
TCP/IP bringup ends.
registering DHCP server
Network is ready.
xs_daemon_open -> 5, 0x1603b8
Using xvda for guest's hda
******************* BLKFRONT for /local/domain/14/device/vbd/51712 **********
 
 
backend at /local/domain/0/backend/vbd/14/51712
41943040 sectors of 512 bytes
**************************
blk_open(/local/domain/14/device/vbd/51712) -> 6
Using xvdb for guest's hdb
******************* BLKFRONT for /local/domain/14/device/vbd/51728 **********
 
 
backend at /local/domain/0/backend/vbd/14/51728
4194304 sectors of 512 bytes
**************************
blk_open(/local/domain/14/device/vbd/51728) -> 7
xs_directory(/local/domain/14/device/vkbd): ENOENT
xs_directory(/local/domain/14/device/vfb): ENOENT
xs_watch(/local/domain/0/device-model/13/logdirty/cmd, logdirty)
Watching /local/domain/0/device-model/13/logdirty/cmd
xs_watch(/local/domain/0/device-model/13/command, dm-command)
Watching /local/domain/0/device-model/13/command
xs_watch(/local/domain/13/cpu, vcpu-set)
Watching /local/domain/13/cpu
xs_read(/local/domain/0/backend/pci/13/0/msitranslate): EACCES
xs_read(/local/domain/0/backend/pci/13/0/power_mgmt): EACCES
qemu_map_cache_init nr_buckets = 10000 size 4194304
shared page at pfn feffd
buffered io page at pfn feffb
Guest uuid = 50c90202-15f4-4157-a95e-8e6bb1e8a0cc
xs_watch(/local/domain/0/backend/console/13, be:0x144eb0:13:0x15b3e0)
evtchn_open() -> 8
fcntl(8, 2, 1/1)
gntmap_init(map=0x1609f8)
xs_watch(/local/domain/13/console, fe:0x200200d010)
xs_write(/local/domain/0/backend/console/13/0/state): EACCES
xs_read(/local/domain/13/console/state): ENOENT
xs_read(/local/domain/13/console/protocol): ENOENT
xs_watch(/local/domain/13/console, fe:0x200200d010)
xen be: console-0: xen be: console-0: watching frontend path (/local/domain/13/console) failed
watching frontend path (/local/domain/13/console) failed
evtchn_open() -> 10
xc_evtchn_bind_interdomain(13, 7) = 0
xc_evtchn_bind_interdomain(13, 1) = 0
xc_evtchn_bind_interdomain(13, 2) = 0
xc_evtchn_bind_interdomain(13, 3) = 0
populating video RAM at ff000000
mapping video RAM from ff000000
xs_read(/local/domain/0/device-model/13/disable_pf): ENOENT
Register xen platform.
Done register platform.
xs_watch(/local/domain/13/log-throttling, /local/domain/13/log-throttling)
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
qubes_gui/init: 660
qubes_gui/init: 669
qubes_gui/init: 672
qubes_gui/init: 681
xs_daemon_open -> 11, 0x160d18
evtchn_open() -> 12
xc_evtchn_bind_unbound_port(0) = 0
qubes gui initialized
resize to 640x480@32, 2560 required
can't store dev vc:80Cx24C name for domid 13 in /serial/0 from a stub domain
xs_read_watch() -> /local/domain/13/log-throttling /local/domain/13/log-throttling
xs_read(/local/domain/13/log-throttling): ENOENT
xs_read(/local/domain/13/log-throttling): read error
qemu: ignoring not-understood drive `/local/domain/13/log-throttling'
medium change watch on `/local/domain/13/log-throttling' - unknown device, ignored
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
resize to 720x400@32, 2880 required
xs_read_watch() -> /local/domain/13/cpu vcpu-set
vcpu-set: watch node error.
[xenstore_process_vcpu_set_event]: /local/domain/13/cpu has no CPU!
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/13/command dm-command
xs_read(/local/domain/0/device-model/13/command): ENOENT
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/13/logdirty/cmd logdirty
xs_read(/local/domain/0/device-model/13/logdirty/cmd): ENOENT
Log-dirty: no command yet.
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
pcifront_watches: waiting for backend to get into the right state /local/domain/0/backend/pci/14/0
******************* PCIFRONT for device/pci/0 **********
 
 
backend at /local/domain/0/backend/pci/14/0
**************************
pcifront_watches: waiting for backend events /local/domain/0/backend/pci/14/0/state
vga s->lfb_addr = f1000000 s->lfb_end = f1800000 
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is ro state.
mapping vram to f1000000 - f1800000
resize to 1024x768@32, 4096 required
Xen Minimal OS!
  start_info: 0x56e000(VA)
    nr_pages: 0x2000
  shared_inf: 0x397c2000(MA)
     pt_base: 0x571000(VA)
nr_pt_frames: 0x7
    mfn_list: 0x55e000(VA)
   mod_start: 0x0(VA)
     mod_len: 0
       flags: 0x0
    cmd_line:  -d 5
  stack:      0x51ce60-0x53ce60
MM: Init
      _text: 0x0(VA)
     _etext: 0x108683(VA)
   _erodata: 0x15b000(VA)
     _edata: 0x164108(VA)
stack start: 0x51ce60(VA)
       _end: 0x55d768(VA)
  start_pfn: 57b
    max_pfn: 2000
Mapping memory range 0x800000 - 0x2000000
setting 0x0-0x15b000 readonly
skipped 0x1000
MM: Initialise page allocator for 587000(587000)-2000000(2000000)
MM: done
Demand map pfns at 2001000-2002001000.
Heap resides at 2002002000-4002002000.
Initialising timer interface
Initialising console ... done.
gnttab_table mapped at 0x2001000.
Initialising scheduler
Thread "Idle": pointer: 0x2002002050, stack: 0x5a0000
Thread "xenstore": pointer: 0x2002002800, stack: 0x5b0000
xenbus initialised on irq 1 mfn 0x3d54d
Dummy main: start_info=0x53cf60
Thread "main": pointer: 0x2002002fb0, stack: 0x5c0000
Thread "pcifront": pointer: 0x2002003760, stack: 0x5d0000
pcifront_watches: waiting for backend path to appear device/pci/0/backend
dom vm is at /vm/b20657af-bcca-4b6a-8211-2271a2945a65
"main" "-d" "5" "-d" "5" "-domain-name" "win7-test" "-vnc" "127.0.0.1:0" "-vncunused" "-videoram" "8" "-std-vga" "-boot" "dca" "-usb" "-usbdevice" "tablet" "-acpi" "-vcpus" "4" "-vcpu_avail" "0xf" "-net" "nic,vlan=0,macaddr=00:16:3e:5e:6c:04,model=rtl8139" "-net" "tap,vlan=0,ifname=tap5.0,bridge=xenbr0,script=no" "-net" "lwip,client_ip=10.137.2.7,server_ip=10.137.2.254,dns=10.137.2.1,gw=10.137.2.1,netmask=255.255.255.0" 
domid: 5
domid: 5
************************ NETFRONT for device/vif/0 **********
 
 
net TX ring size 256
net RX ring size 256
backend at /local/domain/2/backend/vif/6/0
mac is 00:16:3e:5e:6c:04
**************************
tap_open((null)) -> 3
Waiting for network.
IP a8902fe netmask ffffff00 gateway a890201.
TCP/IP bringup begins.
Thread "tcpip_thread": pointer: 0x2002007590, stack: 0x6f0000
TCP/IP bringup ends.
registering DHCP server
Network is ready.
xs_daemon_open -> 5, 0x1603b8
Using xvda for guest's hda
******************* BLKFRONT for /local/domain/6/device/vbd/51712 **********
 
 
backend at /local/domain/0/backend/vbd/6/51712
41943040 sectors of 512 bytes
**************************
blk_open(/local/domain/6/device/vbd/51712) -> 6
Using xvdb for guest's hdb
******************* BLKFRONT for /local/domain/6/device/vbd/51728 **********
 
 
backend at /local/domain/0/backend/vbd/6/51728
4194304 sectors of 512 bytes
**************************
blk_open(/local/domain/6/device/vbd/51728) -> 7
xs_directory(/local/domain/6/device/vkbd): ENOENT
xs_directory(/local/domain/6/device/vfb): ENOENT
xs_watch(/local/domain/0/device-model/5/logdirty/cmd, logdirty)
Watching /local/domain/0/device-model/5/logdirty/cmd
xs_watch(/local/domain/0/device-model/5/command, dm-command)
Watching /local/domain/0/device-model/5/command
xs_watch(/local/domain/5/cpu, vcpu-set)
Watching /local/domain/5/cpu
xs_read(/local/domain/0/backend/pci/5/0/msitranslate): EACCES
xs_read(/local/domain/0/backend/pci/5/0/power_mgmt): EACCES
qemu_map_cache_init nr_buckets = 10000 size 4194304
shared page at pfn feffd
buffered io page at pfn feffb
Guest uuid = b20657af-bcca-4b6a-8211-2271a2945a65
xs_watch(/local/domain/0/backend/console/5, be:0x144eb0:5:0x15b3e0)
evtchn_open() -> 8
fcntl(8, 2, 1/1)
gntmap_init(map=0x1609f8)
xs_watch(/local/domain/5/console, fe:0x200200d010)
xs_write(/local/domain/0/backend/console/5/0/state): EACCES
xs_read(/local/domain/5/console/state): ENOENT
xs_read(/local/domain/5/console/protocol): ENOENT
xs_watch(/local/domain/5/console, fe:0x200200d010)
xen be: console-0: xen be: console-0: watching frontend path (/local/domain/5/console) failed
watching frontend path (/local/domain/5/console) failed
evtchn_open() -> 10
xc_evtchn_bind_interdomain(5, 7) = 0
xc_evtchn_bind_interdomain(5, 1) = 0
xc_evtchn_bind_interdomain(5, 2) = 0
xc_evtchn_bind_interdomain(5, 3) = 0
populating video RAM at ff000000
mapping video RAM from ff000000
xs_read(/local/domain/0/device-model/5/disable_pf): ENOENT
Register xen platform.
Done register platform.
xs_watch(/local/domain/5/log-throttling, /local/domain/5/log-throttling)
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
qubes_gui/init: 660
qubes_gui/init: 669
qubes_gui/init: 672
qubes_gui/init: 681
xs_daemon_open -> 11, 0x160d18
evtchn_open() -> 12
xc_evtchn_bind_unbound_port(0) = 0
qubes gui initialized
resize to 640x480@32, 2560 required
can't store dev vc:80Cx24C name for domid 5 in /serial/0 from a stub domain
xs_read_watch() -> /local/domain/5/log-throttling /local/domain/5/log-throttling
xs_read(/local/domain/5/log-throttling): ENOENT
xs_read(/local/domain/5/log-throttling): read error
qemu: ignoring not-understood drive `/local/domain/5/log-throttling'
medium change watch on `/local/domain/5/log-throttling' - unknown device, ignored
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
resize to 720x400@32, 2880 required
xs_read_watch() -> /local/domain/5/cpu vcpu-set
vcpu-set: watch node error.
[xenstore_process_vcpu_set_event]: /local/domain/5/cpu has no CPU!
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/5/command dm-command
xs_read(/local/domain/0/device-model/5/command): ENOENT
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/5/logdirty/cmd logdirty
xs_read(/local/domain/0/device-model/5/logdirty/cmd): ENOENT
Log-dirty: no command yet.
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
pcifront_watches: waiting for backend to get into the right state /local/domain/0/backend/pci/6/0
******************* PCIFRONT for device/pci/0 **********
 
 
backend at /local/domain/0/backend/pci/6/0
**************************
pcifront_watches: waiting for backend events /local/domain/0/backend/pci/6/0/state
vga s->lfb_addr = f1000000 s->lfb_end = f1800000 
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is ro state.
mapping vram to f1000000 - f1800000
resize to 1024x768@32, 4096 required
resize to 640x480@32, 2560 required
vga s->lfb_addr = f1000000 s->lfb_end = f1800000 
resize to 640x480@32, 2560 required
resize to 720x400@32, 2880 required
resize to 1024x768@32, 4096 required
Xen Minimal OS!
  start_info: 0x56e000(VA)
    nr_pages: 0x2000
  shared_inf: 0x3e135000(MA)
     pt_base: 0x571000(VA)
nr_pt_frames: 0x7
    mfn_list: 0x55e000(VA)
   mod_start: 0x0(VA)
     mod_len: 0
       flags: 0x0
    cmd_line:  -d 11
  stack:      0x51ce60-0x53ce60
MM: Init
      _text: 0x0(VA)
     _etext: 0x108683(VA)
   _erodata: 0x15b000(VA)
     _edata: 0x164108(VA)
stack start: 0x51ce60(VA)
       _end: 0x55d768(VA)
  start_pfn: 57b
    max_pfn: 2000
Mapping memory range 0x800000 - 0x2000000
setting 0x0-0x15b000 readonly
skipped 0x1000
MM: Initialise page allocator for 587000(587000)-2000000(2000000)
MM: done
Demand map pfns at 2001000-2002001000.
Heap resides at 2002002000-4002002000.
Initialising timer interface
Initialising console ... done.
gnttab_table mapped at 0x2001000.
Initialising scheduler
Thread "Idle": pointer: 0x2002002050, stack: 0x5a0000
Thread "xenstore": pointer: 0x2002002800, stack: 0x5b0000
xenbus initialised on irq 1 mfn 0x24f40
Dummy main: start_info=0x53cf60
Thread "main": pointer: 0x2002002fb0, stack: 0x5c0000
Thread "pcifront": pointer: 0x2002003760, stack: 0x5d0000
pcifront_watches: waiting for backend path to appear device/pci/0/backend
dom vm is at /vm/722d9626-e496-42c6-837c-e7a50f2faa38
"main" "-d" "11" "-d" "11" "-domain-name" "win7-test" "-vnc" "127.0.0.1:0" "-vncunused" "-videoram" "8" "-std-vga" "-boot" "dca" "-usb" "-usbdevice" "tablet" "-acpi" "-vcpus" "4" "-vcpu_avail" "0xf" "-net" "nic,vlan=0,macaddr=00:16:3e:5e:6c:04,model=rtl8139" "-net" "tap,vlan=0,ifname=tap11.0,bridge=xenbr0,script=no" "-net" "lwip,client_ip=10.137.2.7,server_ip=10.137.2.254,dns=10.137.2.1,gw=10.137.2.1,netmask=255.255.255.0" 
domid: 11
domid: 11
************************ NETFRONT for device/vif/0 **********
 
 
net TX ring size 256
net RX ring size 256
backend at /local/domain/2/backend/vif/12/0
mac is 00:16:3e:5e:6c:04
**************************
tap_open((null)) -> 3
Waiting for network.
IP a8902fe netmask ffffff00 gateway a890201.
TCP/IP bringup begins.
Thread "tcpip_thread": pointer: 0x2002007590, stack: 0x6f0000
TCP/IP bringup ends.
registering DHCP server
Network is ready.
xs_daemon_open -> 5, 0x1603b8
Using xvda for guest's hda
******************* BLKFRONT for /local/domain/12/device/vbd/51712 **********
 
 
backend at /local/domain/0/backend/vbd/12/51712
41943040 sectors of 512 bytes
**************************
blk_open(/local/domain/12/device/vbd/51712) -> 6
Using xvdb for guest's hdb
******************* BLKFRONT for /local/domain/12/device/vbd/51728 **********
 
 
backend at /local/domain/0/backend/vbd/12/51728
4194304 sectors of 512 bytes
**************************
blk_open(/local/domain/12/device/vbd/51728) -> 7
xs_directory(/local/domain/12/device/vkbd): ENOENT
xs_directory(/local/domain/12/device/vfb): ENOENT
xs_watch(/local/domain/0/device-model/11/logdirty/cmd, logdirty)
Watching /local/domain/0/device-model/11/logdirty/cmd
xs_watch(/local/domain/0/device-model/11/command, dm-command)
Watching /local/domain/0/device-model/11/command
xs_watch(/local/domain/11/cpu, vcpu-set)
Watching /local/domain/11/cpu
xs_read(/local/domain/0/backend/pci/11/0/msitranslate): EACCES
xs_read(/local/domain/0/backend/pci/11/0/power_mgmt): EACCES
qemu_map_cache_init nr_buckets = 10000 size 4194304
shared page at pfn feffd
buffered io page at pfn feffb
Guest uuid = 722d9626-e496-42c6-837c-e7a50f2faa38
xs_watch(/local/domain/0/backend/console/11, be:0x144eb0:11:0x15b3e0)
evtchn_open() -> 8
fcntl(8, 2, 1/1)
gntmap_init(map=0x1609f8)
xs_watch(/local/domain/11/console, fe:0x200200d010)
xs_write(/local/domain/0/backend/console/11/0/state): EACCES
xs_read(/local/domain/11/console/state): ENOENT
xs_read(/local/domain/11/console/protocol): ENOENT
xs_watch(/local/domain/11/console, fe:0x200200d010)
xen be: console-0: xen be: console-0: watching frontend path (/local/domain/11/console) failed
watching frontend path (/local/domain/11/console) failed
evtchn_open() -> 10
xc_evtchn_bind_interdomain(11, 7) = 0
xc_evtchn_bind_interdomain(11, 1) = 0
xc_evtchn_bind_interdomain(11, 2) = 0
xc_evtchn_bind_interdomain(11, 3) = 0
populating video RAM at ff000000
mapping video RAM from ff000000
xs_read(/local/domain/0/device-model/11/disable_pf): ENOENT
Register xen platform.
Done register platform.
xs_watch(/local/domain/11/log-throttling, /local/domain/11/log-throttling)
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
qubes_gui/init: 660
qubes_gui/init: 669
qubes_gui/init: 672
qubes_gui/init: 681
xs_daemon_open -> 11, 0x160d18
evtchn_open() -> 12
xc_evtchn_bind_unbound_port(0) = 0
qubes gui initialized
resize to 640x480@32, 2560 required
can't store dev vc:80Cx24C name for domid 11 in /serial/0 from a stub domain
xs_read_watch() -> /local/domain/11/log-throttling /local/domain/11/log-throttling
xs_read(/local/domain/11/log-throttling): ENOENT
xs_read(/local/domain/11/log-throttling): read error
qemu: ignoring not-understood drive `/local/domain/11/log-throttling'
medium change watch on `/local/domain/11/log-throttling' - unknown device, ignored
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
resize to 720x400@32, 2880 required
xs_read_watch() -> /local/domain/11/cpu vcpu-set
vcpu-set: watch node error.
[xenstore_process_vcpu_set_event]: /local/domain/11/cpu has no CPU!
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/11/command dm-command
xs_read(/local/domain/0/device-model/11/command): ENOENT
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/11/logdirty/cmd logdirty
xs_read(/local/domain/0/device-model/11/logdirty/cmd): ENOENT
Log-dirty: no command yet.
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
pcifront_watches: waiting for backend to get into the right state /local/domain/0/backend/pci/12/0
******************* PCIFRONT for device/pci/0 **********
 
 
backend at /local/domain/0/backend/pci/12/0
**************************
pcifront_watches: waiting for backend events /local/domain/0/backend/pci/12/0/state
vga s->lfb_addr = f1000000 s->lfb_end = f1800000 
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is ro state.
mapping vram to f1000000 - f1800000
resize to 1024x768@32, 4096 required
Xen Minimal OS!
  start_info: 0x56e000(VA)
    nr_pages: 0x2000
  shared_inf: 0x23069000(MA)
     pt_base: 0x571000(VA)
nr_pt_frames: 0x7
    mfn_list: 0x55e000(VA)
   mod_start: 0x0(VA)
     mod_len: 0
       flags: 0x0
    cmd_line:  -d 13
  stack:      0x51ce60-0x53ce60
MM: Init
      _text: 0x0(VA)
     _etext: 0x108683(VA)
   _erodata: 0x15b000(VA)
     _edata: 0x164108(VA)
stack start: 0x51ce60(VA)
       _end: 0x55d768(VA)
  start_pfn: 57b
    max_pfn: 2000
Mapping memory range 0x800000 - 0x2000000
setting 0x0-0x15b000 readonly
skipped 0x1000
MM: Initialise page allocator for 587000(587000)-2000000(2000000)
MM: done
Demand map pfns at 2001000-2002001000.
Heap resides at 2002002000-4002002000.
Initialising timer interface
Initialising console ... done.
gnttab_table mapped at 0x2001000.
Initialising scheduler
Thread "Idle": pointer: 0x2002002050, stack: 0x5a0000
Thread "xenstore": pointer: 0x2002002800, stack: 0x5b0000
xenbus initialised on irq 1 mfn 0x255f5
Dummy main: start_info=0x53cf60
Thread "main": pointer: 0x2002002fb0, stack: 0x5c0000
Thread "pcifront": pointer: 0x2002003760, stack: 0x5d0000
pcifront_watches: waiting for backend path to appear device/pci/0/backend
dom vm is at /vm/7519cdf1-1ade-464a-89d0-686daaabbb10
"main" "-d" "13" "-d" "13" "-domain-name" "win7-test" "-vnc" "127.0.0.1:0" "-vncunused" "-videoram" "8" "-std-vga" "-boot" "dca" "-usb" "-usbdevice" "tablet" "-acpi" "-vcpus" "4" "-vcpu_avail" "0xf" "-net" "nic,vlan=0,macaddr=00:16:3e:5e:6c:04,model=rtl8139" "-net" "tap,vlan=0,ifname=tap13.0,bridge=xenbr0,script=no" "-net" "lwip,client_ip=10.137.2.7,server_ip=10.137.2.254,dns=10.137.2.1,gw=10.137.2.1,netmask=255.255.255.0" 
domid: 13
domid: 13
************************ NETFRONT for device/vif/0 **********
 
 
net TX ring size 256
net RX ring size 256
backend at /local/domain/2/backend/vif/14/0
mac is 00:16:3e:5e:6c:04
**************************
tap_open((null)) -> 3
Waiting for network.
IP a8902fe netmask ffffff00 gateway a890201.
TCP/IP bringup begins.
Thread "tcpip_thread": pointer: 0x2002007590, stack: 0x6f0000
TCP/IP bringup ends.
registering DHCP server
Network is ready.
xs_daemon_open -> 5, 0x1603b8
Using xvda for guest's hda
******************* BLKFRONT for /local/domain/14/device/vbd/51712 **********
 
 
backend at /local/domain/0/backend/vbd/14/51712
41943040 sectors of 512 bytes
**************************
blk_open(/local/domain/14/device/vbd/51712) -> 6
Using xvdb for guest's hdb
******************* BLKFRONT for /local/domain/14/device/vbd/51728 **********
 
 
backend at /local/domain/0/backend/vbd/14/51728
4194304 sectors of 512 bytes
**************************
blk_open(/local/domain/14/device/vbd/51728) -> 7
xs_directory(/local/domain/14/device/vkbd): ENOENT
xs_directory(/local/domain/14/device/vfb): ENOENT
xs_watch(/local/domain/0/device-model/13/logdirty/cmd, logdirty)
Watching /local/domain/0/device-model/13/logdirty/cmd
xs_watch(/local/domain/0/device-model/13/command, dm-command)
Watching /local/domain/0/device-model/13/command
xs_watch(/local/domain/13/cpu, vcpu-set)
Watching /local/domain/13/cpu
xs_read(/local/domain/0/backend/pci/13/0/msitranslate): EACCES
xs_read(/local/domain/0/backend/pci/13/0/power_mgmt): EACCES
qemu_map_cache_init nr_buckets = 10000 size 4194304
shared page at pfn feffd
buffered io page at pfn feffb
Guest uuid = 7519cdf1-1ade-464a-89d0-686daaabbb10
xs_watch(/local/domain/0/backend/console/13, be:0x144eb0:13:0x15b3e0)
evtchn_open() -> 8
fcntl(8, 2, 1/1)
gntmap_init(map=0x1609f8)
xs_watch(/local/domain/13/console, fe:0x200200d010)
xs_write(/local/domain/0/backend/console/13/0/state): EACCES
xs_read(/local/domain/13/console/state): ENOENT
xs_read(/local/domain/13/console/protocol): ENOENT
xs_watch(/local/domain/13/console, fe:0x200200d010)
xen be: console-0: xen be: console-0: watching frontend path (/local/domain/13/console) failed
watching frontend path (/local/domain/13/console) failed
evtchn_open() -> 10
xc_evtchn_bind_interdomain(13, 7) = 0
xc_evtchn_bind_interdomain(13, 1) = 0
xc_evtchn_bind_interdomain(13, 2) = 0
xc_evtchn_bind_interdomain(13, 3) = 0
populating video RAM at ff000000
mapping video RAM from ff000000
xs_read(/local/domain/0/device-model/13/disable_pf): ENOENT
Register xen platform.
Done register platform.
xs_watch(/local/domain/13/log-throttling, /local/domain/13/log-throttling)
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
qubes_gui/init: 660
qubes_gui/init: 669
qubes_gui/init: 672
qubes_gui/init: 681
xs_daemon_open -> 11, 0x160d18
evtchn_open() -> 12
xc_evtchn_bind_unbound_port(0) = 0
qubes gui initialized
resize to 640x480@32, 2560 required
can't store dev vc:80Cx24C name for domid 13 in /serial/0 from a stub domain
xs_read_watch() -> /local/domain/13/log-throttling /local/domain/13/log-throttling
xs_read(/local/domain/13/log-throttling): ENOENT
xs_read(/local/domain/13/log-throttling): read error
qemu: ignoring not-understood drive `/local/domain/13/log-throttling'
medium change watch on `/local/domain/13/log-throttling' - unknown device, ignored
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
resize to 720x400@32, 2880 required
xs_read_watch() -> /local/domain/13/cpu vcpu-set
vcpu-set: watch node error.
[xenstore_process_vcpu_set_event]: /local/domain/13/cpu has no CPU!
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/13/command dm-command
xs_read(/local/domain/0/device-model/13/command): ENOENT
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
xs_read_watch() -> /local/domain/0/device-model/13/logdirty/cmd logdirty
xs_read(/local/domain/0/device-model/13/logdirty/cmd): ENOENT
Log-dirty: no command yet.
I/O request not ready: 0, ptr: 0, port: 0, data: 0, count: 0, size: 0
pcifront_watches: waiting for backend to get into the right state /local/domain/0/backend/pci/14/0
******************* PCIFRONT for device/pci/0 **********
 
 
backend at /local/domain/0/backend/pci/14/0
**************************
pcifront_watches: waiting for backend events /local/domain/0/backend/pci/14/0/state
vga s->lfb_addr = f1000000 s->lfb_end = f1800000 
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is rw state.
platform_fixed_ioport: changed ro/rw state of ROM memory area. now is ro state.
mapping vram to f1000000 - f1800000
resize to 1024x768@32, 4096 required

########################################################################
#

# END CONTENTS OF /var/log/xen/console/guest-win7-test-dm.log
#
########################################################################

Contents of /var/log/qubes/guid.win7-test.log:

Icon size: 128x128
invalid PMinSize for 0x3800005 (0/0)
invalid PMaxSize for 0x3800005 (0/0)
invalid PResizeInc for 0x3800005 (0/0)
invalid PBaseSize for 0x3800005 (0/0)
invalid PMinSize for 0x3800006 (0/0)
invalid PMaxSize for 0x3800006 (0/0)
invalid PResizeInc for 0x3800006 (0/0)
invalid PBaseSize for 0x3800006 (0/0)
invalid PMinSize for 0x3800007 (0/0)
invalid PMaxSize for 0x3800007 (0/0)
invalid PResizeInc for 0x3800007 (0/0)
invalid PBaseSize for 0x3800007 (0/0)
invalid PMinSize for 0x3800008 (0/0)
invalid PMaxSize for 0x3800008 (0/0)
invalid PResizeInc for 0x3800008 (0/0)
invalid PBaseSize for 0x3800008 (0/0)
invalid PMinSize for 0x3800009 (0/0)
invalid PMaxSize for 0x3800009 (0/0)
invalid PResizeInc for 0x3800009 (0/0)
invalid PBaseSize for 0x3800009 (0/0)
invalid PMinSize for 0x380000a (0/0)
invalid PMaxSize for 0x380000a (0/0)
invalid PResizeInc for 0x380000a (0/0)
invalid PBaseSize for 0x380000a (0/0)
invalid PMinSize for 0x380000b (0/0)
invalid PMaxSize for 0x380000b (0/0)
invalid PResizeInc for 0x380000b (0/0)
invalid PBaseSize for 0x380000b (0/0)
event channel disconnected
Icon size: 128x128
invalid PMaxSize for 0x3800003 (0/0)
invalid PResizeInc for 0x3800003 (0/0)
invalid PBaseSize for 0x3800003 (0/0)
invalid PMinSize for 0x3800005 (0/0)
invalid PMaxSize for 0x3800005 (0/0)
invalid PResizeInc for 0x3800005 (0/0)
invalid PBaseSize for 0x3800005 (0/0)
event channel disconnected
xs_read domainname: No such file or directory

########################################################################
#
# END CONTENTS OF /var/log/qubes/guid-win7-test.log
#
########################################################################

Other logs appear empty.

Thanks,

Alex

[Hakisho Nukama]

Why do you disable testsigning, and have you tried it with testsigning on?

Best Regards,
Hakisho Nukama

[IX4 SVS]

On Mon, Feb 9, 2015 at 10:22 PM, IX4 SVS <ix4...@gmail.com> wrote:

<snip>

> Alex

>bcdedit /set testsigning off (from admin cmd.exe in template)

Why do you disable testsigning, and have you tried it with testsigning on?

Best Regards,
Hakisho Nukama

Interestingly when launching win7-test or win7-x64-template in debug mode I can see the loader boots up to a "Windows Error Recovery" screen, with "Launch Startup Repair (recommended) preselected". So this would explain why the HVMs are not booting.

After selecting "Start Windows normally" and a long "Windows is loading files..." phase, I am thrown in "Startup Repair" mode, in which Windows is "attempting repairs..." for a while and then asks me to restart the computer.

Start HVM in debug mode again, "Windows is loading files" once more, reports it's unable to fix the problem.

The log says:

Root cause found:

Boot critical file e:\windows\system32\drivers\xenpci.sys is corrupt.
Repair action: File repair

Result: Failed. Error code =  0x2

Time taken=5944ms

So I don't have the chance to fix the signing requirement, wiping these HVMs and starting from scratch appears to have fixed the issue. I did *not* reactivate driver signing checks this time, which I thought was not necessary to leave off permanently.

Now the template (and HVMs created off it) run fine, but certain applications will simply not start, eg:

qvm-run -a win7-techsupport iexplore.exe
qvm-run -a win7-techsupport cmd.exe

...yield nothing, while

qvm-run -a win7-techsupport explorer.exe

and launching the "Control Panel" menu item, work as expected.

Ideas to debug?

Thanks

Alex

Sorry didn't realise I didn't cc the list. Basically, the above steps, without re-enabling driver signing, seem to be a decent cookbook to get template-based Win7 VMs.

Alex