-----BEGIN PGP SIGNED MESSAGE----- Hash: SHA1 Adrian,
I'm thinking this might be a bug. It looks like it is parsing some extra spaces in to the name of the domain. Can you provide the full log for that reservation? You can get the log for a single reservation by grepping for the requestid:reservationid, which in this case is '54:54'. So "grep '54:54' /var/log/vcld.log" should give you the full long for that specific reservation. Josh On 09/10/12 23:51, Adrian Plummer wrote: > Sorry if this is a newbie question. :( > > I can provide more information about our test setup if needed. > > Regards, Adrian > > > On 24/08/12 09:30, Adrian Plummer wrote: >> Hi >> >> I've just joined this list and this is my first post, so please >> be gentle :) I also apologise if I am posting to the wrong list >> :( >> >> I have setup Apache VCL in a test environment to evaluate for >> deployment for the Faculty of Science at the University of New >> South Wales, Sydney, Australia. >> >> I have been working with both VMWare and KVM (on CentOS 6.3). >> >> I have managed to create a base image on the VMWare system but >> can't seem to get one created on the KVM system. >> >> I can't find any reference to the specifc problem that I am >> having in the list archives, though I have only looked briefly at >> this years archives (July to January 2012). >> >> The logs of the failed image creation is forwarded below. >> >> It looks to me as if the problem is when the the 'libvirt.pm' >> module is trying to find the domain/virtual machine to be used as >> the base image on the kvm host. >> >> It successfully runs the 'virsh list --all' command and gets the >> result correctly: >> >> SNIP 2012-08-23 >> 14:20:12|16421|54:54|image|libvirt.pm:get_domain_info(1749)|listed >> defined domains on kvmhost2 |16421|54:54|image| command: virsh >> list --all |16421|54:54|image| output: |16421|54:54|image| Id >> Name State |16421|54:54|image| >> ---------------------------------------------------- >> |16421|54:54|image| 8 centos63base1 running 2012-08-23 >> 14:20:12|16421|54:54|image|libvirt.pm:get_domain_info(1771)|retrieved >> domain info from kvmhost2: |16421|54:54|image| 8. centos63base1 >> (running) SNIP >> >> But then when it tries to use that information to dump the XML >> config for the domain, there seem to be extra space added to the >> front of the domain name so that the 'virsh dumpxml' command >> fails: >> >> SNIP 2012-08-23 >> 14:20:12|16421|54:54|image|utils.pm:run_ssh_command(4935)|executing >> SSH command on kvmhost2: |16421|54:54|image| /usr/bin/ssh -i >> /etc/vcl/vcl.key -o StrictHostKeyChecking=no -o >> UserKnownHostsFile=/dev/null -o ConnectionAttempts=1 -o >> ConnectTimeout=3 -l root -p 22 -x kvmhost2 'virsh dumpxml " >> centos63base1"' 2>&1 2012-08-23 >> 14:20:12|16421|54:54|image|utils.pm:run_ssh_command(5053)|run_ssh_command >> output: |16421|54:54|image| error: failed to get domain ' >> centos63base1' |16421|54:54|image| error: Domain not found: no >> domain with matching name ' centos63base1' >> >> SNIP >> >> I am not sure if this is something I have done wrong with the >> configuration or what but any advice would be useful. >> >> Regards, Adrian >> >> >> -------- Original Message -------- Subject: PROBLEM -- >> vcltest2|54:54|image|image.pm|tempt037>kvmhost2.maths.unsw.edu.au|linux-centos63base1-29-v0|admin >> >> >> Date: Thu, 23 Aug 2012 14:20:12 +1000 >> From: <[email protected]> To: >> <[email protected]> >> >> >> >> linux-centos63base1-29-v0 image creation failed >> ------------------------------------------------------------------------ >> >> time: 2012-08-23 14:20:12 >> caller: image.pm:reservation_failed(387) ( 0) image.pm, >> reservation_failed (line: 387) (-1) image.pm, process (line: >> 167) (-2) vcld, make_new_child (line: 571) (-3) vcld, main (line: >> 350) >> ------------------------------------------------------------------------ >> >> management node: vcltest2.maths.unsw.edu.au >> reservation PID: 16421 parent vcld PID: 11571 >> >> request ID: 54 reservation ID: 54 request state/laststate: >> image/image request start time: 2012-08-23 14:20:07 request end >> time: 2012-08-23 15:20:07 for imaging: no log ID: none >> >> computer: tempt037 DOMAIN REMOVED computer id: 12 computer type: >> virtualmachine computer eth0 MAC address: 52:54:00:fb:66:ad >> computer eth1 MAC address: 52:54:00:44:41:de computer private IP >> address: IP REMOVED computer public IP address: IP REMOVED >> >> computer in block allocation: no provisioning module: >> VCL::Module::Provisioning::libvirt >> >> vm host: kvmhost2 DOMAIN REMOVED vm host ID: 3 vm host computer >> ID: 4 vm profile: KVM-local and network storage vm profile VM >> path: /local-vms vm profile repository path: <undefined> vm >> profile datastore path: /share/vcltest2/kvmhost2 vm profile disk >> type: dedicated >> >> image: linux-centos63base1-29-v0 image display name: >> centos63base1 image ID: 29 image revision ID: 23 image size: 1450 >> MB use Sysprep: no root access: yes image owner ID: 1 image owner >> affiliation: Local image revision date created: 2012-08-23 >> 14:20:11 image revision production: yes OS module: >> VCL::Module::OS::Linux >> >> user: admin user name: vcl admin user ID: 1 user affiliation: >> Local >> ------------------------------------------------------------------------ >> >> RECENT LOG ENTRIES FOR THIS PROCESS: >> |16421|54:54|image| : "ip_address" => { |16421|54:54|image| : >> "10.64.128.20" => "255.255.255.0" |16421|54:54|image| : }, >> |16421|54:54|image| : "name" => "eth1", |16421|54:54|image| : >> "physical_address" => "52:54:00:fb:66:ad" |16421|54:54|image| : >> }, |16421|54:54|image| : "lo" => { |16421|54:54|image| : >> "name" => "lo" |16421|54:54|image| : } |16421|54:54|image| : } >> 2012-08-23 >> 14:20:12|16421|54:54|image|DataStructure.pm:get_computer_private_ip_address(1630)|attempting >> to retrieve private IP address for computer: tempt037 2012-08-23 >> 14:20:12|16421|54:54|image|DataStructure.pm:get_computer_private_ip_address(1634)|retrieved >> contents of /etc/hosts on this management node, contains 13 >> lines 2012-08-23 >> 14:20:12|16421|54:54|image|DataStructure.pm:get_computer_private_ip_address(1694)|returning >> IP address from /etc/hosts file: IP REMOVED 2012-08-23 >> 14:20:12|16421|54:54|image|OS.pm:get_private_interface_name(1068)|determined >> private interface name: eth0 (IP REMOVED) 2012-08-23 >> 14:20:12|16421|54:54|image|OS.pm:get_mac_address(1350)|returning >> private MAC address: 52:54:00:44:41:de 2012-08-23 >> 14:20:12|16421|54:54|image|DataStructure.pm:get_computer_private_ip_address(1606)|returning >> private IP address previously retrieved: IP REMOVED 2012-08-23 >> 14:20:12|16421|54:54|image|DataStructure.pm:get_computer_private_ip_address(1606)|returning >> private IP address previously retrieved: IP REMOVED 2012-08-23 >> 14:20:12|16421|54:54|image|OS.pm:_get_public_interface_name_helper(1218)|'eth1' >> is more likely the public interface, it is NOT assigned the >> private IP address: IP REMOVED 2012-08-23 >> 14:20:12|16421|54:54|image|OS.pm:get_public_interface_name(1121)|interface >> 'lo' ignored because its name is 'lo' 2012-08-23 >> 14:20:12|16421|54:54|image|OS.pm:get_public_interface_name(1150)|determined >> the public interface name: 'eth1' |16421|54:54|image| : { >> |16421|54:54|image| : "broadcast_address" => "10.64.128.255", >> |16421|54:54|image| : "ip_address" => { |16421|54:54|image| : >> "10.64.128.20" => "255.255.255.0" |16421|54:54|image| : }, >> |16421|54:54|image| : "name" => "eth1", |16421|54:54|image| : >> "physical_address" => "52:54:00:fb:66:ad" |16421|54:54|image| : >> } 2012-08-23 >> 14:20:12|16421|54:54|image|OS.pm:get_mac_address(1350)|returning >> public MAC address: 52:54:00:fb:66:ad 2012-08-23 >> 14:20:12|16421|54:54|image|utils.pm:run_ssh_command(4935)|executing >> SSH command on kvmhost2: |16421|54:54|image| /usr/bin/ssh -i >> /etc/vcl/vcl.key -o StrictHostKeyChecking=no -o >> UserKnownHostsFile=/dev/null -o ConnectionAttempts=1 -o >> ConnectTimeout=3 -l root -p 22 -x kvmhost2 'virsh list --all' >> 2>&1 2012-08-23 >> 14:20:12|16421|54:54|image|utils.pm:run_ssh_command(5053)|run_ssh_command >> output: |16421|54:54|image| Id Name State |16421|54:54|image| >> ---------------------------------------------------- >> |16421|54:54|image| 8 centos63base1 running 2012-08-23 >> 14:20:12|16421|54:54|image|utils.pm:run_ssh_command(5067)|SSH >> command executed on kvmhost2, returning (0, "Id Name State >> ----------------...") 2012-08-23 >> 14:20:12|16421|54:54|image|libvirt.pm:get_domain_info(1749)|listed >> defined domains on kvmhost2 |16421|54:54|image| command: virsh >> list --all |16421|54:54|image| output: |16421|54:54|image| Id >> Name State |16421|54:54|image| >> ---------------------------------------------------- >> |16421|54:54|image| 8 centos63base1 running 2012-08-23 >> 14:20:12|16421|54:54|image|libvirt.pm:get_domain_info(1771)|retrieved >> domain info from kvmhost2: |16421|54:54|image| 8. centos63base1 >> (running) 2012-08-23 >> 14:20:12|16421|54:54|image|utils.pm:run_ssh_command(4935)|executing >> SSH command on kvmhost2: |16421|54:54|image| /usr/bin/ssh -i >> /etc/vcl/vcl.key -o StrictHostKeyChecking=no -o >> UserKnownHostsFile=/dev/null -o ConnectionAttempts=1 -o >> ConnectTimeout=3 -l root -p 22 -x kvmhost2 'virsh dumpxml " >> centos63base1"' 2>&1 2012-08-23 >> 14:20:12|16421|54:54|image|utils.pm:run_ssh_command(5053)|run_ssh_command >> output: |16421|54:54|image| error: failed to get domain ' >> centos63base1' |16421|54:54|image| error: Domain not found: no >> domain with matching name ' centos63base1' 2012-08-23 >> 14:20:12|16421|54:54|image|utils.pm:run_ssh_command(5063)|SSH >> command executed on kvmhost2, command: |16421|54:54|image| >> /usr/bin/ssh -i /etc/vcl/vcl.key -o StrictHostKeyChecking=no -o >> UserKnownHostsFile=/dev/null -o ConnectionAttempts=1 -o >> ConnectTimeout=3 -l root -p 22 -x kvmhost2 'virsh dumpxml " >> centos63base1"' 2>&1 |16421|54:54|image| returning (1, "error: >> failed to get domain ' ...") |16421|54:54|image| ---- WARNING >> ---- |16421|54:54|image| 2012-08-23 >> 14:20:12|16421|54:54|image|libvirt.pm:get_domain_xml_string(1814)|failed >> to retrieve XML definition for ' centos63base1' domain on >> kvmhost2 |16421|54:54|image| command: virsh dumpxml " >> centos63base1" |16421|54:54|image| exit status: 1 >> |16421|54:54|image| output: |16421|54:54|image| error: failed to >> get domain ' centos63base1' |16421|54:54|image| error: Domain >> not found: no domain with matching name ' centos63base1' >> |16421|54:54|image| ( 0) libvirt.pm, get_domain_xml_string (line: >> 1814) |16421|54:54|image| (-1) libvirt.pm, get_domain_xml (line: >> 1847) |16421|54:54|image| (-2) libvirt.pm, >> get_domain_mac_addresses (line: 1938) |16421|54:54|image| (-3) >> libvirt.pm, get_active_domain_name (line: 970) >> |16421|54:54|image| (-4) libvirt.pm, get_domain_name (line: 879) >> |16421|54:54|image| (-5) libvirt.pm, capture (line: 326) >> 2012-08-23 >> 14:20:12|16421|54:54|image|libvirt.pm:get_domain_mac_addresses(1949)|retrieved >> MAC addresses assigned to domain ' centos63base1': 2012-08-23 >> 14:20:12|16421|54:54|image|libvirt.pm:get_active_domain_name(975)|ignoring >> domain ' centos63base1' because MAC address does not match any >> being used by tempt037 |16421|54:54|image| ---- WARNING ---- >> |16421|54:54|image| 2012-08-23 >> 14:20:12|16421|54:54|image|libvirt.pm:get_active_domain_name(984)|failed >> to determine active domain name, did not find any domains >> configured to use MAC address currently being used by tempt037: >> |16421|54:54|image| 5254004441de |16421|54:54|image| >> 525400fb66ad |16421|54:54|image| ( 0) libvirt.pm, >> get_active_domain_name (line: 984) |16421|54:54|image| (-1) >> libvirt.pm, get_domain_name (line: 879) |16421|54:54|image| (-2) >> libvirt.pm, capture (line: 326) |16421|54:54|image| (-3) >> image.pm, process (line: 162) |16421|54:54|image| (-4) vcld, >> make_new_child (line: 571) |16421|54:54|image| (-5) vcld, main >> (line: 350) |16421|54:54|image| ---- WARNING ---- >> |16421|54:54|image| 2012-08-23 >> 14:20:12|16421|54:54|image|libvirt.pm:get_domain_name(885)|unable >> to determine name of domain to be captured |16421|54:54|image| ( >> 0) libvirt.pm, get_domain_name (line: 885) |16421|54:54|image| >> (-1) libvirt.pm, capture (line: 326) |16421|54:54|image| (-2) >> image.pm, process (line: 162) |16421|54:54|image| (-3) vcld, >> make_new_child (line: 571) |16421|54:54|image| (-4) vcld, main >> (line: 350) |16421|54:54|image| ---- WARNING ---- >> |16421|54:54|image| 2012-08-23 >> 14:20:12|16421|54:54|image|libvirt.pm:capture(328)|unable to >> capture image on kvmhost2, domain name could not be determined >> |16421|54:54|image| ( 0) libvirt.pm, capture (line: 328) >> |16421|54:54|image| (-1) image.pm, process (line: 162) >> |16421|54:54|image| (-2) vcld, make_new_child (line: 571) >> |16421|54:54|image| (-3) vcld, main (line: 350) >> |16421|54:54|image| ---- WARNING ---- |16421|54:54|image| >> 2012-08-23 >> 14:20:12|16421|54:54|image|image.pm:process(166)|vmwarelinux-centos63base129-v0 >> image failed to be captured by provisioning module >> |16421|54:54|image| ( 0) image.pm, process (line: 166) >> |16421|54:54|image| (-1) vcld, make_new_child (line: 571) >> |16421|54:54|image| (-2) vcld, main (line: 350) 2012-08-23 >> 14:20:12|16421|54:54|image|DataStructure.pm:get_computer_private_ip_address(1606)|returning >> private IP address previously retrieved: IP REMOVED 2012-08-23 >> 14:20:12|16421|54:54|image|utils.pm:is_inblockrequest(5793)|zero >> rows were returned from database select 2012-08-23 >> 14:20:12|16421|54:54|image|DataStructure.pm:get_image_affiliation_name(2118)|image >> owner id: 1 2012-08-23 >> 14:20:12|16421|54:54|image|DataStructure.pm:retrieve_user_data(1401)|attempting >> to retrieve and store data for user: user.id = '1' 2012-08-23 >> 14:20:12|16421|54:54|image|DataStructure.pm:retrieve_user_data(1464)|data >> has been retrieved for user: admin (id: 1) >> >> >> > - -- - ------------------------------- Josh Thompson VCL Developer North Carolina State University my GPG/PGP key can be found at pgp.mit.edu All electronic mail messages in connection with State business which are sent to or received by this account are subject to the NC Public Records Law and may be disclosed to third parties. -----BEGIN PGP SIGNATURE----- Version: GnuPG v2.0.17 (GNU/Linux) iEYEARECAAYFAlBZw/UACgkQV/LQcNdtPQNCbgCfc8vsNWzOuWShZWqdISrQMwky mWsAn3ANtQbb2gg6v0FSZ8t0dTpHHocf =9KY+ -----END PGP SIGNATURE-----
