primalmotion/Archipel — Issue #418: live migrate works but VM shown as 'Offline' and unmanageable
Author: bbs2web
Created: 2012-02-29 18:12:44+00:00
State: open

Live migration is working perfectly in that guest moves to other host, remains running (autostart isn't transferred though, but I've seen that logged somewhere else).

Problem is that archipel's VM configuration is not passed correctly between the hosts in that the guest now shows as 'Offline' and displays 'Entity is Offline' when selecting it. The avatar, UUID and name are still correct though.

PS: We imported the VMs with these steps:
service archipel stop;
sleep 10;

archipel-importvirtualmachine --file=/var/lib/archipel/hypervisor.sqlite3 \
--xmppserver=sanjhb1.jhb.maximeb.co.za \
--uuid=3a18bda2-8be8-6096-4130-ae6d2a50f41f --name=testing;
archipel-importvirtualmachine --file=/var/lib/archipel/hypervisor.sqlite3 \
--xmppserver=sanjhb1.jhb.maximeb.co.za \
--uuid=bd5d05cb-d368-8f6a-8c51-bb5284c55553 --name=adjhb;
archipel-importvirtualmachine --file=/var/lib/archipel/hypervisor.sqlite3 \
--xmppserver=sanjhb1.jhb.maximeb.co.za \
--uuid=c9b2336b-7f88-e3d7-ad3e-32a80e8b06d6 --name=pastel;
archipel-importvirtualmachine --file=/var/lib/archipel/hypervisor.sqlite3 \
--xmppserver=sanjhb1.jhb.maximeb.co.za \
--uuid=2ef926d1-00d7-d30f-3115-0527ca1a2bf1 --name=crystalrb03;

service archipel start;

Log from originating host (kvmjhb1):
INFO ::2012-02-29 19:55:16::utils.py:66::TNArchipelVirtualMachine.check_acp (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::acp received: from: sics@sanjhb1.jhb.maximeb.co.za/ArchipelController, type: set, namespace: archipel:vm:control, action: migrate
INFO ::2012-02-29 19:55:16::utils.py:66::TNArchipelVirtualMachine.check_perm (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::Checking permission for action migrate asked by sics@sanjhb1.jhb.maximeb.co.za/ArchipelController
INFO ::2012-02-29 19:55:16::utils.py:66::TNArchipelVirtualMachine.migrate_step2 (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::MIGRATION: remote info: libvirt URI is qemu://192.168.1.6/system
INFO ::2012-02-29 19:55:16::utils.py:66::TNArchipelVirtualMachine.migrate_step2 (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::MIGRATION: remote info: shared folder is /home/kvm/archipel//drives/3a18bda2-8be8-6096-4130-ae6d2a50f41f
INFO ::2012-02-29 19:55:16::utils.py:66::TNArchipelVirtualMachine.change_presence (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::status change: Migrating... show:
INFO ::2012-02-29 19:55:16::utils.py:66::TNArchipelVirtualMachine.migrate_step3 (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::MIGRATION: starting to migrate domain qemu://192.168.1.6/system
DEBUG ::2012-02-29 19:55:16::utils.py:64::TNArchipelVirtualMachine.presence_callback (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::PRESENCE : I just set change presence. The result is Migrating...
INFO ::2012-02-29 19:55:17::utils.py:66::TNArchipelVirtualMachine.check_acp (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::acp received: from: sics@sanjhb1.jhb.maximeb.co.za/ArchipelController, type: get, namespace: archipel:vm:control, action: info
INFO ::2012-02-29 19:55:17::utils.py:66::TNArchipelVirtualMachine.check_perm (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::Checking permission for action info asked by sics@sanjhb1.jhb.maximeb.co.za/ArchipelController
INFO ::2012-02-29 19:55:17::utils.py:66::TNArchipelVirtualMachine.check_acp (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::acp received: from: sics@sanjhb1.jhb.maximeb.co.za/ArchipelController, type: get, namespace: archipel:vm:oom, action: getadjust
INFO ::2012-02-29 19:55:17::utils.py:66::TNArchipelVirtualMachine.check_perm (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::Checking permission for action oom_getadjust asked by sics@sanjhb1.jhb.maximeb.co.za/ArchipelController
INFO ::2012-02-29 19:55:18::utils.py:66::TNArchipelVirtualMachine.check_acp (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::acp received: from: sics@sanjhb1.jhb.maximeb.co.za/ArchipelController, type: get, namespace: archipel:vm:control, action: screenshot
INFO ::2012-02-29 19:55:18::utils.py:66::TNArchipelVirtualMachine.check_perm (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::Checking permission for action screenshot asked by sics@sanjhb1.jhb.maximeb.co.za/ArchipelController
ERROR ::2012-02-29 19:55:18::utils.py:156::.__process_iq_archipel_control: exception raised is: 'Virtual machine is migrating. Can't perform this control operation.' triggered by stanza :

INFO ::2012-02-29 19:55:19::utils.py:66::TNArchipelVirtualMachine.on_domain_event (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::Libvirt event received: 3 with detail 0
INFO ::2012-02-29 19:55:19::utils.py:66::TNArchipelVirtualMachine.on_domain_event (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::Event received but virtual machine is migrating. Ignoring.
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelHypervisor.hypervisor_on_domain_event (kvmjhb1@sanjhb1.jhb.maximeb.co.za/kvmjhb1.jhb.maximeb.co.za)::MIGRATION: Virtual machine 3a18bda2-8be8-6096-4130-ae6d2a50f41f stopped because of live migration. Freeing softly.
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.migrate_step3 (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::MIGRATION: migration to qemu://192.168.1.6/system is a SUCCESS
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.perform_hooks (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::HOOK: going to run methods for hook HOOK_VM_MIGRATED
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.perform_hooks (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::HOOK: performing method stop_novnc_proxy registered in hook with name HOOK_VM_MIGRATED and user_info: None (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.remove_libvirt_handler (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::Removing the libvirt event listener for 3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.stop_novnc_proxy (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::Stopping novnc proxy.
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.push_change (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::PUSH : pushing archipel:push:virtualmachine:vnc->websocketvncstop
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.undefine_and_disconnect (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::undefining virtual machine.
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.unlock (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::releasing lock
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.disconnect_libvirt (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1 is disconnecting from libvirt
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.perform_hooks (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::HOOK: going to run methods for hook HOOK_ARCHIPELENTITY_XMPP_DISCONNECTED
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.undefine_and_disconnect (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1)::Virtual machine undefined and disconnected.
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelHypervisor.soft_free (kvmjhb1@sanjhb1.jhb.maximeb.co.za/kvmjhb1.jhb.maximeb.co.za)::Unregistering the VM from hypervisor's database.
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelHypervisor.change_presence (kvmjhb1@sanjhb1.jhb.maximeb.co.za/kvmjhb1.jhb.maximeb.co.za)::status change: Online (3) show:None
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelHypervisor.perform_hooks (kvmjhb1@sanjhb1.jhb.maximeb.co.za/kvmjhb1.jhb.maximeb.co.za)::HOOK: going to run methods for hook HOOK_HYPERVISOR_MIGRATEDVM_LEAVE
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelHypervisor.presence_callback (kvmjhb1@sanjhb1.jhb.maximeb.co.za/kvmjhb1.jhb.maximeb.co.za)::PRESENCE : I just set change presence. The result is Online (3)
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelHypervisor.perform_hooks (kvmjhb1@sanjhb1.jhb.maximeb.co.za/kvmjhb1.jhb.maximeb.co.za)::HOOK: performing method hypervisor_migrate_leave registered in hook with name HOOK_HYPERVISOR_MIGRATEDVM_LEAVE and user_info: None (oneshot: False)

Log from destination host (kvmjhb2):

INFO ::2012-02-29 19:55:16::utils.py:66::TNArchipelHypervisor.check_acp (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::acp received: from: 3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb1, type: get, namespace: archipel:hypervisor:control, action: migrationinfo
INFO ::2012-02-29 19:55:19::utils.py:66::TNArchipelHypervisor.hypervisor_on_domain_event (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::MIGRATION: Virtual machine 3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za resumed from live migration. Allocating softly.
INFO ::2012-02-29 19:55:19::utils.py:66::TNArchipelHypervisor.soft_alloc (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::Starting xmpp threaded virtual machine with incoming jid : 3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_ARCHIPELENTITY_XMPP_CONNECTED
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_ARCHIPELENTITY_XMPP_DISCONNECTED
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_ARCHIPELENTITY_XMPP_AUTHENTICATED
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_ARCHIPELENTITY_PLUGIN_ALL_LOADED
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method recover_pubsubs for hook name HOOK_ARCHIPELENTITY_XMPP_AUTHENTICATED (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.__init__ (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::jid defined as 3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.connect_libvirt (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Connected to libvirt uri qemu:///system
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.init_permissions (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::initializing permissions of 3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.init_permissions (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::permissions of 3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2 initialized
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_CREATE
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_SHUTOFF
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_STOP
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_DESTROY
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_SUSPEND
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_RESUME
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_UNDEFINE
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_DEFINE
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_INITIALIZE
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_TERMINATE
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_FREE
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_CRASH
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_XMPP_CONNECT
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.create_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: creating hook with name HOOK_VM_MIGRATED
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method connect_domain for hook name HOOK_ARCHIPELENTITY_XMPP_AUTHENTICATED (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method manage_vcard_hook for hook name HOOK_ARCHIPELENTITY_XMPP_AUTHENTICATED (oneshot: False)
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['roster', 'users']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['start', 'create', 'boot', 'play', 'run']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['shutdown', 'stop']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['destroy']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['pause', 'suspend']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['resume', 'unpause']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['info', 'how are you', 'and you']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['desc', 'xml']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['net', 'stat']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['fuck', 'asshole', 'jerk', 'stupid', 'suck']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['hello', 'hey', 'hi', 'good morning', 'yo']
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.perform_hooks (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: going to run methods for hook HOOK_ARCHIPELENTITY_PLUGIN_ALL_LOADED
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['park']
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.initialize_modules (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::PLUGIN: loaded plugin vmparking
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['vnc', 'screen']
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method create_novnc_proxy for hook name HOOK_VM_CREATE (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method stop_novnc_proxy for hook name HOOK_VM_CRASH (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method stop_novnc_proxy for hook name HOOK_VM_STOP (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method stop_novnc_proxy for hook name HOOK_VM_DESTROY (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method stop_novnc_proxy for hook name HOOK_VM_TERMINATE (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method stop_novnc_proxy for hook name HOOK_VM_MIGRATED (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method awake_from_initialization for hook name HOOK_VM_INITIALIZE (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.initialize_modules (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::PLUGIN: loaded plugin vnc
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.__init__ (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::XMPPSERVER: Module is using XMLRPC API for managing XMPP server
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.initialize_modules (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::PLUGIN: loaded plugin xmppserver
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['list appliances']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['attach appliance']
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelVirtualMachine.add_message_registrar_item (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Plugin have registered a method > for commands ['detach appliance']
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.initialize_modules (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::PLUGIN: loaded plugin virtualmachine_appliance
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.initialize_modules (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::PLUGIN: loaded plugin storage
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.initialize_modules (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::PLUGIN: loaded plugin snapshoting
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_initialized for hook name HOOK_VM_INITIALIZE (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_create for hook name HOOK_VM_CREATE (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_terminate for hook name HOOK_VM_TERMINATE (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.__init__ (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::module oom killer initialized
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.initialize_modules (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::PLUGIN: loaded plugin oomkiller
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_create for hook name HOOK_VM_CREATE (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_shutoff for hook name HOOK_VM_SHUTOFF (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_stop for hook name HOOK_VM_STOP (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_destroy for hook name HOOK_VM_DESTROY (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_suspend for hook name HOOK_VM_SUSPEND (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_resume for hook name HOOK_VM_RESUME (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_undefine for hook name HOOK_VM_UNDEFINE (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_define for hook name HOOK_VM_DEFINE (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.initialize_modules (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::PLUGIN: plugin iphone_notification has not been loaded because it is disabled by configuration.
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.initialize_modules (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::PLUGIN: loaded plugin hypervisor_network
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.register_hook (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: registering hook method vm_terminate for hook name HOOK_VM_TERMINATE (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.initialize_modules (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::PLUGIN: loaded plugin action_scheduler
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.perform_hooks (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: going to run methods for hook HOOK_ARCHIPELENTITY_PLUGIN_ALL_LOADED
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelHypervisor.soft_alloc (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::Registering the new VM in hypervisor's database.
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelHypervisor.change_presence (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::status change: Online (1) show:None
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelHypervisor.soft_alloc (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::Migrated XMPP VM is ready.
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelHypervisor.presence_callback (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::PRESENCE : I just set change presence. The result is Online (1)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelHypervisor.perform_hooks (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::HOOK: going to run methods for hook HOOK_HYPERVISOR_SOFT_ALLOC
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelHypervisor.perform_hooks (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::HOOK: going to run methods for hook HOOK_HYPERVISOR_MIGRATEDVM_ARRIVE
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.connect_xmpp (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Successfully connected to XMPP with JID 3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.perform_hooks (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::HOOK: going to run methods for hook HOOK_ARCHIPELENTITY_XMPP_CONNECTED
DEBUG ::2012-02-29 19:55:20::utils.py:64::TNArchipelHypervisor.perform_hooks (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::HOOK: performing method hypervisor_migrate_arrive registered in hook with name HOOK_HYPERVISOR_MIGRATEDVM_ARRIVE and user_info: None (oneshot: False)
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.auth_xmpp (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Trying to authentify the client with username 3a18bda2-8be8-6096-4130-ae6d2a50f41f and resource kvmjhb2
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.auth_xmpp (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Starting registration, according to propertie auto_register.
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.inband_registration (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Trying to register with 3a18bda2-8be8-6096-4130-ae6d2a50f41f to sanjhb1.jhb.maximeb.co.za
INFO ::2012-02-29 19:55:20::utils.py:66::TNArchipelVirtualMachine.inband_registration (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Registration information sent. Wait for response...
ERROR ::2012-02-29 19:55:20::utils.py:70::TNArchipelVirtualMachine.inband_registration (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Unable to register: 3a18bda2-8be8-6096-4130-ae6d2a50f41ffqcVu6kZ058xGwEhehH92gHD2TVBUSMS
ERROR ::2012-02-29 19:55:20::utils.py:70::TNArchipelVirtualMachine.inband_registration (3a18bda2-8be8-6096-4130-ae6d2a50f41f@sanjhb1.jhb.maximeb.co.za/kvmjhb2)::Unable to perform inband registration. Have you activated this in your ejabberd server configuration?
DEBUG ::2012-02-29 19:55:28::utils.py:64::TNArchipelHypervisor.parse_own_repo (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::TNHypervisorRepoManager: begin to refresh own vmcast feed
DEBUG ::2012-02-29 19:55:28::utils.py:64::TNArchipelHypervisor.parse_own_repo (kvmjhb2@sanjhb1.jhb.maximeb.co.za/kvmjhb2.jhb.maximeb.co.za)::TNHypervisorRepoManager: finish to refresh own vmcast feed