Attachment 606046 Details for Bug 849223 – rhel58 x64 xen dom0 xend log

rhel58 x64 xen dom0 xend log

rhel58-x64-xen-dom0-xend-log.txt (text/plain), 14.54 KB, created by Pasi Karkkainen on 2012-08-21 20:48:37 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Pasi Karkkainen

Created: 2012-08-21 20:48:37 UTC

Size: 14.54 KB

patch

obsolete

>[2012-08-21 23:31:21 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:261) XendDomainInfo.create(['vm', ['name', 'rhel63x64hvm'], ['memory', 1024], ['shadow_memory', 8], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['vcpus', 1], ['image', ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['device_model', '/usr/lib64/xen/bin/qemu-dm'], ['pae', 1], ['vcpus', 1], ['boot', 'cd'], ['timer_mode', 1], ['serial', 'pty'], ['vnc', 1], ['vncunused', 1], ['display', 'localhost:10.0'], ['xauthority', '/root/.Xauthority'], ['acpi', 1], ['apic', 1], ['usb', 1], ['usbdevice', 'tablet'], ['keymap', 'fi'], ['hpet', 1], ['vncpasswd', '']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroup00/rhel63x64hvm'], ['dev', 'hda'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'file:/root/iso/rhel-server-6.3-x86_64-dvd.iso'], ['dev', 'hdc:cdrom'], ['mode', 'r']]], ['device', ['pci', ['dev', ['domain', '0x0'], ['bus', '0x03'], ['slot', '0x10'], ['func', '0x2']]]], ['device', ['vif', ['bridge', 'virbr0'], ['mac', '00:26:5f:12:12:11'], ['model', 'e1000']]]])
>[2012-08-21 23:31:21 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:383) parseConfig: config is ['vm', ['name', 'rhel63x64hvm'], ['memory', 1024], ['shadow_memory', 8], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['vcpus', 1], ['image', ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['device_model', '/usr/lib64/xen/bin/qemu-dm'], ['pae', 1], ['vcpus', 1], ['boot', 'cd'], ['timer_mode', 1], ['serial', 'pty'], ['vnc', 1], ['vncunused', 1], ['display', 'localhost:10.0'], ['xauthority', '/root/.Xauthority'], ['acpi', 1], ['apic', 1], ['usb', 1], ['usbdevice', 'tablet'], ['keymap', 'fi'], ['hpet', 1], ['vncpasswd', '']]], ['device', ['vbd', ['uname', 'phy:/dev/VolGroup00/rhel63x64hvm'], ['dev', 'hda'], ['mode', 'w']]], ['device', ['vbd', ['uname', 'file:/root/iso/rhel-server-6.3-x86_64-dvd.iso'], ['dev', 'hdc:cdrom'], ['mode', 'r']]], ['device', ['pci', ['dev', ['domain', '0x0'], ['bus', '0x03'], ['slot', '0x10'], ['func', '0x2']]]], ['device', ['vif', ['bridge', 'virbr0'], ['mac', '00:26:5f:12:12:11'], ['model', 'e1000']]]]
>[2012-08-21 23:31:21 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:507) parseConfig: result is {'features': None, 'hpet': None, 'image': ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['device_model', '/usr/lib64/xen/bin/qemu-dm'], ['pae', 1], ['vcpus', 1], ['boot', 'cd'], ['timer_mode', 1], ['serial', 'pty'], ['vnc', 1], ['vncunused', 1], ['display', 'localhost:10.0'], ['xauthority', '/root/.Xauthority'], ['acpi', 1], ['apic', 1], ['usb', 1], ['usbdevice', 'tablet'], ['keymap', 'fi'], ['hpet', 1], ['vncpasswd', '']], 'cpus': None, 'vcpu_avail': None, 'backend': [], 'uuid': None, 'on_reboot': 'restart', 'cpu_weight': None, 'memory': 1024, 'cpu_cap': None, 'localtime': None, 'timer_mode': None, 'start_time': None, 'on_poweroff': 'destroy', 'on_crash': 'restart', 'device': [('vbd', ['vbd', ['uname', 'phy:/dev/VolGroup00/rhel63x64hvm'], ['dev', 'hda'], ['mode', 'w']]), ('vbd', ['vbd', ['uname', 'file:/root/iso/rhel-server-6.3-x86_64-dvd.iso'], ['dev', 'hdc:cdrom'], ['mode', 'r']]), ('pci', ['pci', ['dev', ['domain', '0x0'], ['bus', '0x03'], ['slot', '0x10'], ['func', '0x2']]]), ('vif', ['vif', ['bridge', 'virbr0'], ['mac', '00:26:5f:12:12:11'], ['model', 'e1000']])], 'bootloader': None, 'maxmem': None, 'shadow_memory': 8, 'name': 'rhel63x64hvm', 'bootloader_args': None, 'vcpus': 1, 'cpu': None}
>[2012-08-21 23:31:21 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:1975) XendDomainInfo.construct: None
>[2012-08-21 23:31:21 xend 4564] DEBUG (balloon:146) Balloon: 47152576 KiB free; need 4096; done.
>[2012-08-21 23:31:21 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:2150) XendDomainInfo.initDomain: 3 256
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: boot, val: cd
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: fda, val: None
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: fdb, val: None
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: soundhw, val: None
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: localtime, val: None
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: serial, val: pty
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: std-vga, val: None
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: isa, val: None
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: vcpus, val: 1
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: acpi, val: 1
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: usb, val: 1
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: usbdevice, val: tablet
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:347) args: k, val: fi
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:407) No VNC passwd configured for vfb access
>[2012-08-21 23:31:21 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:2191) _initDomain:shadow_memory=0x8, maxmem=0x400, memory=0x400.
>[2012-08-21 23:31:21 xend 4564] DEBUG (balloon:146) Balloon: 47151524 KiB free; need 1071104; done.
>[2012-08-21 23:31:21 xend 4564] INFO (image:139) buildDomain os=None dom=3 vcpus=1
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:275) domid          = 3
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:276) image          = /usr/lib/xen/boot/hvmloader
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:277) store_evtchn   = 2
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:278) memsize        = 1024
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:279) vcpus          = 1
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:280) pae            = 1
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:281) acpi           = 1
>[2012-08-21 23:31:21 xend 4564] DEBUG (image:282) apic           = 1
>[2012-08-21 23:31:21 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:677) Checking for duplicate for uname: /dev/VolGroup00/rhel63x64hvm [phy:/dev/VolGroup00/rhel63x64hvm], dev: hda, mode: w
>[2012-08-21 23:31:21 xend 4564] DEBUG (blkif:27) exception looking up device number for hda: [Errno 2] No such file or directory: '/dev/hda'
>[2012-08-21 23:31:21 xend 4564] DEBUG (blkif:27) exception looking up device number for hdc: [Errno 2] No such file or directory: '/dev/hdc'
>[2012-08-21 23:31:21 xend 4564] DEBUG (blkif:27) exception looking up device number for hda: [Errno 2] No such file or directory: '/dev/hda'
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:133) DevController: writing {'backend-id': '0', 'virtual-device': '768', 'device-type': 'disk', 'state': '1', 'backend': '/local/domain/0/backend/vbd/3/768'} to /local/domain/3/device/vbd/768.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:135) DevController: writing {'domain': 'rhel63x64hvm', 'frontend': '/local/domain/3/device/vbd/768', 'format': 'raw', 'dev': 'hda', 'state': '1', 'params': '/dev/VolGroup00/rhel63x64hvm', 'mode': 'w', 'online': '1', 'frontend-id': '3', 'type': 'phy'} to /local/domain/0/backend/vbd/3/768.
>[2012-08-21 23:31:21 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:677) Checking for duplicate for uname: /root/iso/rhel-server-6.3-x86_64-dvd.iso [file:/root/iso/rhel-server-6.3-x86_64-dvd.iso], dev: hdc, mode: r
>[2012-08-21 23:31:21 xend 4564] DEBUG (blkif:27) exception looking up device number for hdc: [Errno 2] No such file or directory: '/dev/hdc'
>[2012-08-21 23:31:21 xend 4564] DEBUG (blkif:27) exception looking up device number for hda: [Errno 2] No such file or directory: '/dev/hda'
>[2012-08-21 23:31:21 xend 4564] DEBUG (blkif:27) exception looking up device number for hdc: [Errno 2] No such file or directory: '/dev/hdc'
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:133) DevController: writing {'backend-id': '0', 'virtual-device': '5632', 'device-type': 'cdrom', 'state': '1', 'backend': '/local/domain/0/backend/vbd/3/5632'} to /local/domain/3/device/vbd/5632.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:135) DevController: writing {'domain': 'rhel63x64hvm', 'frontend': '/local/domain/3/device/vbd/5632', 'format': 'raw', 'dev': 'hdc', 'state': '1', 'params': '/root/iso/rhel-server-6.3-x86_64-dvd.iso', 'mode': 'r', 'online': '1', 'frontend-id': '3', 'type': 'file'} to /local/domain/0/backend/vbd/3/5632.
>[2012-08-21 23:31:21 xend 4564] INFO (pciquirk:91) NO quirks found for PCI device [8086:10ed:8086:7a11]
>[2012-08-21 23:31:21 xend 4564] DEBUG (pciquirk:131) Permissive mode NOT enabled for PCI device [8086:10ed:8086:7a11]
>[2012-08-21 23:31:21 xend 4564] DEBUG (pciif:378) pci: enabling iomem 0xde404000/0x4000 pfn 0xde404/0x4
>[2012-08-21 23:31:21 xend 4564] DEBUG (pciif:378) pci: enabling iomem 0xde504000/0x4000 pfn 0xde504/0x4
>[2012-08-21 23:31:21 xend 4564] DEBUG (pciif:398) pci-msix: remove permission for 0xde504000/0x3000 0xde504/0x3
>[2012-08-21 23:31:21 xend 4564] DEBUG (pciif:398) pci-msix: remove permission for 0xde506000/0x1000 0xde506/0x1
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:133) DevController: writing {'state': '1', 'backend-id': '0', 'backend': '/local/domain/0/backend/pci/3/0'} to /local/domain/3/device/pci/0.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:135) DevController: writing {'domain': 'rhel63x64hvm', 'frontend': '/local/domain/3/device/pci/0', 'online': '1', 'frontend-id': '3', 'dev-0': '0000:03:10.2', 'state': '1', 'num_devs': '1'} to /local/domain/0/backend/pci/3/0.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:133) DevController: writing {'backend-id': '0', 'mac': '00:26:5f:12:12:11', 'handle': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/3/0'} to /local/domain/3/device/vif/0.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:135) DevController: writing {'bridge': 'virbr0', 'domain': 'rhel63x64hvm', 'handle': '0', 'script': '/etc/xen/scripts/vif-bridge', 'state': '1', 'frontend': '/local/domain/3/device/vif/0', 'mac': '00:26:5f:12:12:11', 'online': '1', 'frontend-id': '3', 'model': 'e1000'} to /local/domain/0/backend/vif/3/0.
>[2012-08-21 23:31:21 xend 4564] INFO (image:453) spawning device models: /usr/lib64/xen/bin/qemu-dm ['/usr/lib64/xen/bin/qemu-dm', '-d', '3', '-m', '1024', '-boot', 'cd', '-serial', 'pty', '-vcpus', '1', '-acpi', '-usb', '-usbdevice', 'tablet', '-k', 'fi', '-domain-name', 'rhel63x64hvm', '-net', 'nic,vlan=1,macaddr=00:26:5f:12:12:11,model=e1000', '-net', 'tap,vlan=1,bridge=virbr0', '-vnc', '127.0.0.1:3', '-vncunused']
>[2012-08-21 23:31:21 xend 4564] INFO (image:456) device model pid: 5930
>[2012-08-21 23:31:21 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:1072) Storing VM details: {'shadow_memory': '9', 'uuid': '872d10cc-71b8-0ad6-4851-a98ef18c8113', 'on_reboot': 'restart', 'start_time': '1345581081.5', 'on_poweroff': 'destroy', 'name': 'rhel63x64hvm', 'xend/restart_count': '0', 'vcpus': '1', 'vcpu_avail': '1', 'memory': '1024', 'on_crash': 'restart', 'image': '(hvm (kernel /usr/lib/xen/boot/hvmloader) (device_model /usr/lib64/xen/bin/qemu-dm) (pae 1) (vcpus 1) (boot cd) (timer_mode 1) (serial pty) (vnc 1) (vncunused 1) (display localhost:10.0) (xauthority /root/.Xauthority) (acpi 1) (apic 1) (usb 1) (usbdevice tablet) (keymap fi) (hpet 1) (vncpasswd ))', 'maxmem': '1024'}
>[2012-08-21 23:31:21 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:1107) Storing domain details: {'console/port': '3', 'name': 'rhel63x64hvm', 'console/limit': '1048576', 'vm': '/vm/872d10cc-71b8-0ad6-4851-a98ef18c8113', 'domid': '3', 'cpu/0/availability': 'online', 'memory/target': '1048576', 'store/ring-ref': '262142', 'store/port': '2'}
>[2012-08-21 23:31:21 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:1335) XendDomainInfo.handleShutdownWatch
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:179) Waiting for devices vif.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:184) Waiting for 0.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:571) hotplugStatusCallback /local/domain/0/backend/vif/3/0/hotplug-status.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:571) hotplugStatusCallback /local/domain/0/backend/vif/3/0/hotplug-status.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:585) hotplugStatusCallback 1.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:94) Lock released
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:179) Waiting for devices usb.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:179) Waiting for devices vbd.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:184) Waiting for 768.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:571) hotplugStatusCallback /local/domain/0/backend/vbd/3/768/hotplug-status.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:585) hotplugStatusCallback 1.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:94) Lock released
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:184) Waiting for 5632.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:571) hotplugStatusCallback /local/domain/0/backend/vbd/3/5632/hotplug-status.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:585) hotplugStatusCallback 1.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:94) Lock released
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:179) Waiting for devices irq.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:179) Waiting for devices vkbd.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:179) Waiting for devices vfb.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:179) Waiting for devices pci.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:184) Waiting for 0.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:94) Lock released
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:179) Waiting for devices ioports.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:179) Waiting for devices tap.
>[2012-08-21 23:31:21 xend 4564] DEBUG (DevController:179) Waiting for devices vtpm.
>[2012-08-21 23:31:21 xend 4564] INFO (XendDomain:388) Domain rhel63x64hvm (3) unpaused.
>[2012-08-21 23:40:05 xend.XendDomainInfo 4564] INFO (XendDomainInfo:1292) Domain has shutdown: name=rhel63x64hvm id=3 reason=poweroff.
>[2012-08-21 23:40:05 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:2386) XendDomainInfo.destroy: domid=3
>[2012-08-21 23:40:05 xend.XendDomainInfo 4564] INFO (XendDomainInfo:2527) Dev 768 still active, looping...
>[2012-08-21 23:40:06 xend.XendDomainInfo 4564] INFO (XendDomainInfo:2527) Dev 5632 still active, looping...
>[2012-08-21 23:40:06 xend.XendDomainInfo 4564] INFO (XendDomainInfo:2527) Dev 768 still active, looping...
>[2012-08-21 23:40:06 xend.XendDomainInfo 4564] INFO (XendDomainInfo:2527) Dev 5632 still active, looping...
>[2012-08-21 23:40:06 xend.XendDomainInfo 4564] INFO (XendDomainInfo:2527) Dev 5632 still active, looping...
>[2012-08-21 23:40:06 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:2311) UUID Created: True
>[2012-08-21 23:40:06 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:2312) Devices to release: [], domid = 3
>[2012-08-21 23:40:06 xend.XendDomainInfo 4564] DEBUG (XendDomainInfo:2324) Releasing PVFB backend devices ...

Actions: View

Attachments on bug 849223: 606043 | 606044 | 606045 | 606046 | 606050 | 606051 | 606365 | 606370 | 606639 | 610520 | 611505 | 613668 | 614372 | 614373 | 614374 | 614596 | 615391 | 615392 | 615482 | 616740 | 617217 | 617218 | 617260 | 617261 | 617528 | 617541 | 617718 | 618009 | 618145 | 618240 | 618241 | 618312