gistfile1.txt

2014-11-01 19:22:54,843 INFO
VmPool.py._recycle_next: 85
VmPool Recycle Queue: creating instance 1

2014-11-01 19:22:54,844 INFO
VmPool.py._create: 319
VmPool: creating instance 1: engaging VmMaster.lock()

2014-11-01 19:22:54,846 INFO
VmInstance.py.create: 225
creating instance 1

2014-11-01 19:22:54,850 DEBUG
VirtualMachine.py.image_exists: 556
Searching for existing image in libvirt pool <libvirt.virStoragePool object at 0x7f1d4488d110>

2014-11-01 19:22:54,851 DEBUG
VirtualMachine.py.image_exists: 565
Image does not appear to exist

2014-11-01 19:22:54,852 INFO
VmInstance.py.create: 242
creating new image volume for instance 1 in pool default, backed by volume /ssd2/masters/master1.0.img

2014-11-01 19:22:54,872 INFO
VirtualMachine.py.create_volume: 181
creating new storage volume with command ['virsh', 'vol-create-as', '--pool', 'default', 'instance1.0-1.img', '53687091200', '--allocation', '0', '--format', 'qed', '--backing-vol', '/ssd2/masters/master1.0.img', '--backing-vol-format', 'qed']

2014-11-01 19:22:54,934 DEBUG
VirtualMachine.py.status: 468
Domain not created; making a new one

2014-11-01 19:22:54,935 ERROR
VirtualMachine.py.xml_mac_address: 653
Failed to retreive mac addr, using None

2014-11-01 19:22:54,936 INFO
VirtualMachine.py.virt_install_apply_protocol: 201
Using protocol rdp

2014-11-01 19:22:54,936 INFO
VirtualMachine.py.install_domain: 289
Installing VM with cmd ['virt-install', '--name', 'instance1.0-1', '--ram', '2048', '--os-type', 'windows', '--noautoconsole', '--network', 'bridge=br0,model=virtio', '--disk', '/ssd1/images/instance1.0-1.img,bus=virtio', '--cpu', 'host', '--import', '--noreboot', '--graphics', 'vnc,port=5901,listen=0.0.0.0,password=intern1']

2014-11-01 19:22:55,469 INFO
VirtualMachine.py.redefine_libvirt_xml: 298
Redefining XML for instance1.0-1

2014-11-01 19:22:55,470 ERROR
VirtualMachine.py.xml_mac_address: 653
Failed to retreive mac addr, using None

2014-11-01 19:22:55,498 INFO
VirtualMachine.py.shutdown: 805
Cannot shutdown maching with status STOPPED

2014-11-01 19:22:55,502 INFO
VirtualMachine.py.set_windows_name: 1077
setting Windows computer name to N-PC-1

2014-11-01 19:22:55,518 INFO
VirtualMachine.py.set_windows_name: 1082
setting Windows host name to n-pc-1

2014-11-01 19:22:55,534 INFO
VirtualMachine.py.set_windows_name: 1087
merging in Windows registry updates from /var/lib/neverware/tmp/instance1.0-1.reg to /ssd1/images/instance1.0-1.img

2014-11-01 19:23:01,083 INFO
VmInstance.py.create: 262
saving database record for instance 1

2014-11-01 19:23:01,089 INFO
VmInstance.py.create: 268
starting up instance 1

2014-11-01 19:23:01,094 INFO
VirtualMachine.py.start: 825
Staring machine instance1.0-1

2014-11-01 19:23:01,734 ERROR
VirtualMachine.py.subprocess_call: 436
Unhandled exception calling ['virsh', 'start', 'instance1.0-1']
Traceback (most recent call last):
  File "/usr/local/lib/python2.7/site-packages/jbsystem/VirtualMachine.py", line 434, in subprocess_call
    subprocess.check_call(call, *args, **kwargs)
  File "/usr/local/lib/python2.7/subprocess.py", line 540, in check_call
    raise CalledProcessError(retcode, cmd)
CalledProcessError: Command '['virsh', 'start', 'instance1.0-1']' returned non-zero exit status 1
2014-11-01 19:23:01,736 INFO
VmPool.py._create: 331
disengaging VmMaster.lock()

2014-11-01 19:23:01,737 ERROR
VmPool.py.run: 63
VmPool Recycle Queue error:
Traceback (most recent call last):
  File "/usr/local/lib/python2.7/site-packages/jbsystem/VmPool.py", line 57, in run
    self._recycle_next()
  File "/usr/local/lib/python2.7/site-packages/jbsystem/VmPool.py", line 86, in _recycle_next
    self.vmpool._create(instance_id)
  File "/usr/local/lib/python2.7/site-packages/jbsystem/VmPool.py", line 326, in _create
    instance.create()
  File "/usr/local/lib/python2.7/site-packages/jbsystem/VmInstance.py", line 269, in create
    self.start()
  File "/usr/local/lib/python2.7/site-packages/jbsystem/VirtualMachine.py", line 826, in start
    self.subprocess_call(cmd)
  File "/usr/local/lib/python2.7/site-packages/jbsystem/VirtualMachine.py", line 434, in subprocess_call
    subprocess.check_call(call, *args, **kwargs)
  File "/usr/local/lib/python2.7/subprocess.py", line 540, in check_call
    raise CalledProcessError(retcode, cmd)
CalledProcessError: Command '['virsh', 'start', 'instance1.0-1']' returned non-zero exit status 1