Hello all -- I'm running into errors running "vcld -setup" to pull a base image from my ESXi 4.1 box. I've managed to troubleshoot all of the errors I've encountered up to this point... The process runs for a long while and gets all the way to pulling the VMDK files from the hypervisor. It appears to fail when attempting to schedule a reservation.
I've included the last sections of the vcld.log file below -- please let me know if more information is needed. The VM is subsequently purged from ESXi and I have to manually rebuild the VM guest profile with the remaining copy of the VMDK disk file. Any assistance available from the list is deeply appreciated! Thanks & regards, Mike |7472|9:9|reload| ---- WARNING ---- |7472|9:9|reload| 2011-12-19 16:49:38|7472|9:9|reload|DataStructure.pm:_automethod(812)|corresponding data has not been initialized for get_computer_eth0_mac_address: $self->request_data->{reservation}{9}{computer}{eth0macaddress} |7472|9:9|reload| ( 0) DataStructure.pm, _automethod (line: 812) |7472|9:9|reload| (-1) Autoload.pm, __ANON__ (line: 80) |7472|9:9|reload| (-2) VMware.pm, prepare_vmx (line: 1457) |7472|9:9|reload| (-3) VMware.pm, load (line: 394) |7472|9:9|reload| (-4) new.pm, reload_image (line: 618) |7472|9:9|reload| (-5) new.pm, process (line: 248) |7472|9:9|reload| ---- WARNING ---- |7472|9:9|reload| 2011-12-19 16:49:38|7472|9:9|reload|VMware.pm:load(395)|failed to prepare vmx file for xpbase on VM host: vmware |7472|9:9|reload| ( 0) VMware.pm, load (line: 395) |7472|9:9|reload| (-1) new.pm, reload_image (line: 618) |7472|9:9|reload| (-2) new.pm, process (line: 248) |7472|9:9|reload| (-3) vcld, make_new_child (line: 568) |7472|9:9|reload| (-4) vcld, main (line: 346) |7472|9:9|reload| ---- WARNING ---- |7472|9:9|reload| 2011-12-19 16:49:38|7472|9:9|reload|new.pm:reload_image(623)|vmwarewinxp-xptest512-v0 failed to load on xpbase, returning |7472|9:9|reload| ( 0) new.pm, reload_image (line: 623) |7472|9:9|reload| (-1) new.pm, process (line: 248) |7472|9:9|reload| (-2) vcld, make_new_child (line: 568) |7472|9:9|reload| (-3) vcld, main (line: 346) 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:insertloadlog(3875)|inserted computer=7, loadimagefailed, vmwarewinxp-xptest512-v0 failed to load on xpbase |7472|9:9|reload| ---- WARNING ---- |7472|9:9|reload| 2011-12-19 16:49:38|7472|9:9|reload|new.pm:process(295)|failed to load xpbase with vmwarewinxp-xptest512-v0 |7472|9:9|reload| ( 0) new.pm, process (line: 295) |7472|9:9|reload| (-1) vcld, make_new_child (line: 568) |7472|9:9|reload| (-2) vcld, main (line: 346) 2011-12-19 16:49:38|7472|9:9|reload|DataStructure.pm:get_computer_state_name(2305)|attempting to retrieve current state of computer xpbase from the database 2011-12-19 16:49:38|7472|9:9|reload|DataStructure.pm:get_computer_state_name(2336)|retrieved current state of computer xpbase from the database: reloading 2011-12-19 16:49:38|7472|9:9|reload|DataStructure.pm:_automethod(834)|data structure updated: $self->request_data->{reservation}{9}{computer}{state}{name} |7472|9:9|reload| computer_state_name = reloading 2011-12-19 16:49:38|7472|9:9|reload|DataStructure.pm:get_computer_private_ip_address(1581)|attempting to retrieve private IP address for computer: xpbase 2011-12-19 16:49:38|7472|9:9|reload|DataStructure.pm:get_computer_private_ip_address(1585)|retrieved contents of /etc/hosts on this management node, contains 6 lines 2011-12-19 16:49:38|7472|9:9|reload|DataStructure.pm:get_computer_private_ip_address(1645)|returning IP address from /etc/hosts file: 10.100.0.245 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:is_inblockrequest(6163)|zero rows were returned from database select 2011-12-19 16:49:38|7472|9:9|reload|DataStructure.pm:get_image_affiliation_name(2035)|image owner id: 1 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:getnewdbh(2709)|database requested (information_schema) does not match handle stored in $ENV{dbh} (vcl:127.0.0.1) 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:getnewdbh(2760)|database handle stored in $ENV{dbh} 2011-12-19 16:49:38|7472|9:9|reload|DataStructure.pm:retrieve_user_data(1352)|attempting to retrieve and store data for user: user.id = '1' 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:getnewdbh(2709)|database requested (vcl) does not match handle stored in $ENV{dbh} (information_schema:127.0.0.1) 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:getnewdbh(2760)|database handle stored in $ENV{dbh} 2011-12-19 16:49:38|7472|9:9|reload|DataStructure.pm:retrieve_user_data(1415)|data has been retrieved for user: admin (id: 1) 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:mail(1268)|SUCCESS -- Sending mail To: 0, PROBLEM -- 9:9|reload|State.pm|xpbase>vmware|vmwarewinxp-xptest512-v0|vclreload |7472|9:9|reload| ---- CRITICAL ---- |7472|9:9|reload| 2011-12-19 16:49:38|7472|9:9|reload|State.pm:reservation_failed(213)|reservation failed on xpbase: process failed after trying to load or make available |7472|9:9|reload| ( 0) State.pm, reservation_failed (line: 213) |7472|9:9|reload| (-1) new.pm, process (line: 298) |7472|9:9|reload| (-2) vcld, make_new_child (line: 568) |7472|9:9|reload| (-3) vcld, main (line: 346) 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:insertloadlog(3875)|inserted computer=7, failed, process failed after trying to load or make available 2011-12-19 16:49:38|7472|9:9|reload|State.pm:reservation_failed(216)|inserted computerloadlog entry 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:update_computer_state(2033)|computer 7 state updated to: failed 2011-12-19 16:49:38|7472|9:9|reload|State.pm:reservation_failed(235)|computer xpbase (7) state set to failed 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:update_request_state(1991)|request 9 state updated to: failed, laststate to: image 2011-12-19 16:49:38|7472|9:9|reload|State.pm:reservation_failed(248)|set request state to 'failed'/'image' 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:is_inblockrequest(6163)|zero rows were returned from database select 2011-12-19 16:49:38|7472|9:9|reload|State.pm:reservation_failed(266)|xpbase is NOT in blockcomputers table 2011-12-19 16:49:38|7472|9:9|reload|State.pm:reservation_failed(269)|exiting 1 2011-12-19 16:49:38|7472|9:9|reload|State.pm:DESTROY(829)|VCL::new destructor called, address: 9a0bb6c 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:delete_computerloadlog_reservation(6742)|removing computerloadlog entries matching loadstate = begin 2011-12-19 16:49:38|7472|9:9|reload|utils.pm:delete_computerloadlog_reservation(6789)|deleted rows from computerloadlog for reservation id=9 2011-12-19 16:49:38|7472|9:9|reload|State.pm:DESTROY(848)|number of database handles state process created: 3 2011-12-19 16:49:38|7472|9:9|reload|State.pm:DESTROY(876)|VCL::new process duration: 6 seconds 2011-12-19 16:49:38|7472|9:9|reload|VIM_SSH.pm:DESTROY(1685)|vim-cmd call count: 2 2011-12-19 16:49:38|2636|vcld:REAPER(718)|VCL process exited for reservation 9, PID: 7472, signal: CHLD