From: Hayashi, Daiyu Sent: Wednesday, January 26, 2011 2:55 PM To: '[email protected]' Subject: Image Capture issue
Help - need assistance with VCL 2.2 vHost on ESXi4.1 Issue with Image Capture for Base Image using Windows XP Error message below- Thank you, Daiyu Hayashi Information Technology Consultant Mihaylo College of Business and Economics California State University at Fullerton [email protected] ------------------------------------------------------------------------------------------------------------------------ [root@vcl-manage bin]# ./vcld -setup VCL Management Node Setup ---------------------------------------------------------------------------- Select a module to configure: 1. VCL Base Module 2. VCL Image State Module 3. Windows OS Module [vcld] Make a selection (1-3, 'c' to cancel): 2 ---------------------------------------------------------------------------- Choose an operation: 1. Capture Base Image [vcld/Image] Make a selection (1, 'c' to cancel): 1 Enter the VCL login name or ID of the user who will own the image: [admin]: admin User who will own the image: admin (ID: 1) Enter the hostname or IP address of the computer to be captured: ('c' to cancel): xpbase1 Computer to be captured: xpbase1 (ID: 8) Provisioning module: provisioning_vmware Install type: vmware Select the OS to be captured (install type: vmware): 1. Generic Linux (VMware) 2. Windows 2003 Server (VMware) 3. Windows 7 (VMware) 4. Windows Server 2008 (VMware) 5. Windows Vista (VMware) 6. Windows XP (VMware) [vcld/Image/Capture Base Image] Make a selection (1-6, 'c' to cancel): 6 Selected OS: Windows XP (VMware) Image architecture: 1. x86 2. x86_64 [vcld/Image/Capture Base Image] Make a selection (1-2, 'c' to cancel): 1 Image architecture: x86 Use Sysprep: 1. Yes 2. No [vcld/Image/Capture Base Image] Make a selection (1-2, 'c' to cancel): 2 Use Sysprep: No Enter the name of the image to be captured: ('c' to cancel): xpbase1 Added new image to database: 'xpbase1' image.name: vmwarewinxp-xpbase17-v0 image.id: 7 imagerevision.id: 7 imagemeta.id: 4 resource.id: 20 ---------------------------------------------------------------------------- Inserted imaging request to the database: request ID: 3 reservation ID: 3 This process will now display the contents of the vcld.log file if the vcld daemon is running. If you do not see many lines of additional output, exit this process, start the vcld daemon, and monitor the image capture process by running the command: tail -f /var/log/vcld.log | grep '3:3' ---------------------------------------------------------------------------- 2011-01-26 14:15:01|3906|utils.pm:setup_get_array_choice(9986)|choices argument: |3906| x86 |3906| x86_64 2011-01-26 14:15:02|3906|utils.pm:setup_get_array_choice(9986)|choices argument: |3906| Yes |3906| No 2011-01-26 14:15:02|3514|vcld:main(166)|lastcheckin time updated for management node 1: 2011-01-26 14:15:02 2011-01-26 14:15:07|3514|vcld:main(166)|lastcheckin time updated for management node 1: 2011-01-26 14:15:07 2011-01-26 14:15:10|3906|utils.pm:insert_request(8443)|inserted new reload request into request table, request id=3 2011-01-26 14:15:10|3906|utils.pm:insert_request(8474)|inserted new reload request into reservation table, reservation id=3 2011-01-26 14:15:12|3514|vcld:main(166)|lastcheckin time updated for management node 1: 2011-01-26 14:15:12 2011-01-26 14:15:12|3514|3:3|image|utils.pm:reservation_being_processed(9010)|computerloadlog 'begin' entry does NOT exist for reservation 3 2011-01-26 14:15:13|3514|3:3|image|utils.pm:run_command(9082)|executed command: pgrep -fl 'vcld [0-9]+:3 ', pid: 3912, exit status: 1, output: 2011-01-26 14:15:13|3514|3:3|image|utils.pm:is_management_node_process_running(9259)|process is NOT running, identifier: 'vcld [0-9]+:3 ' 2011-01-26 14:15:13|3514|3:3|image|utils.pm:reservation_being_processed(9031)|reservation is NOT currently being processed 2011-01-26 14:15:13|3514|3:3|image|vcld:main(277)|reservation 3 is NOT already being processed 2011-01-26 14:15:13|3514|3:3|image|utils.pm:get_request_info(4589)|standalone affiliation found: Local 2011-01-26 14:15:13|3514|3:3|image|vcld:main(282)|retrieved request information from database 2011-01-26 14:15:13|3514|3:3|image|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3 2011-01-26 14:15:13|3514|3:3|image|utils.pm:update_request_state(2049)|request 3 state updated to: pending, laststate to: image 2011-01-26 14:15:13|3514|3:3|image|utils.pm:insertloadlog(3933)|inserted computer=8, begin, beginning to process, state is image 2011-01-26 14:15:13|3514|3:3|image|vcld:make_new_child(510)|loaded VCL::image module 2011-01-26 14:15:13|3914|3:3|image|vcld:make_new_child(583)|vcld environment variable set to 0 for this process 2011-01-26 14:15:13|3914|3:3|image|Module.pm:new(134)|constructor called, class=VCL::image 2011-01-26 14:15:13|3914|3:3|image|Module.pm:new(156)|VCL::image object created 2011-01-26 14:15:13|3514|3:3|image|vcld:make_new_child(567)|current number of forked kids: 1 2011-01-26 14:15:13|3914|3:3|image|State.pm:initialize(85)|obtained a database handle for this state process, stored as $ENV{dbh} 2011-01-26 14:15:13|3914|3:3|image|State.pm:check_image_os(836)|no corrections need to be made to image OS: vmwarewinxp 2011-01-26 14:15:13|3914|3:3|image|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3 2011-01-26 14:15:13|3914|3:3|image|utils.pm:rename_vcld_process(7183)|reservation count: 1 2011-01-26 14:15:13|3914|3:3|image|utils.pm:rename_vcld_process(7202)|PARENTIMAGE: 1 2011-01-26 14:15:13|3914|3:3|image|utils.pm:rename_vcld_process(7203)|SUBIMAGE: 0 2011-01-26 14:15:13|3914|3:3|image|utils.pm:rename_vcld_process(7221)|renamed process to 'vcld 3:3 image xpbase1 vmwarewinxp-xpbase17-v0 admin' 2011-01-26 14:15:13|3914|3:3|image|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3 2011-01-26 14:15:13|3914|3:3|image|DataStructure.pm:is_parent_reservation(943)|returning true: parent reservation ID for this request: 3 2011-01-26 14:15:13|3914|3:3|image|State.pm:initialize(118)|attempting to load provisioning module: VCL::Module::Provisioning::VMware::VMware 2011-01-26 14:15:13|3914|3:3|image|State.pm:initialize(124)|VCL::Module::Provisioning::VMware::VMware module loaded 2011-01-26 14:15:13|3914|3:3|image|Module.pm:new(134)|constructor called, class=VCL::Module::Provisioning::VMware::VMware 2011-01-26 14:15:13|3914|3:3|image|Module.pm:new(156)|VCL::Module::Provisioning::VMware::VMware object created |3914|3:3|image| ---- WARNING ---- |3914|3:3|image| 2011-01-26 14:15:13|3914|3:3|image|DataStructure.pm:_automethod(764)|corresponding data has not been initialized for get_vmhost_computer_id: $self->request_data->{reservation}{3}{computer}{vmhost}{computerid} |3914|3:3|image| ( 0) utils.pm, notify (line: 630) |3914|3:3|image| (-1) DataStructure.pm, _automethod (line: 764) |3914|3:3|image| (-2) Autoload.pm, __ANON__ (line: 80) |3914|3:3|image| (-3) VMware.pm, get_vmhost_datastructure (line: 894) |3914|3:3|image| (-4) VMware.pm, initialize (line: 216) |3914|3:3|image| (-5) Module.pm, new (line: 159) |3914|3:3|image| (-6) State.pm, initialize (line: 127) |3914|3:3|image| ---- WARNING ---- |3914|3:3|image| 2011-01-26 14:15:13|3914|3:3|image|State.pm:initialize(132)|provisioning object could not be created, returning 0 |3914|3:3|image| ( 0) utils.pm, notify (line: 630) |3914|3:3|image| (-1) State.pm, initialize (line: 132) |3914|3:3|image| (-2) Module.pm, new (line: 159) |3914|3:3|image| (-3) vcld, make_new_child (line: 591) |3914|3:3|image| (-4) vcld, main (line: 342) 2011-01-26 14:15:13|3914|3:3|image|State.pm:DESTROY(902)|destructor called, ref($self)=VCL::image 2011-01-26 14:15:13|3914|3:3|image|utils.pm:delete_computerloadlog_reservation(6829)|removing computerloadlog entries matching loadstate = begin 2011-01-26 14:15:13|3914|3:3|image|utils.pm:delete_computerloadlog_reservation(6876)|deleted rows from computerloadlog for reservation id=3 2011-01-26 14:15:13|3914|3:3|image|State.pm:DESTROY(909)|removed computerloadlog rows with loadstate=begin for reservation 2011-01-26 14:15:13|3914|3:3|image|State.pm:DESTROY(921)|number of database handles state process created: 1 2011-01-26 14:15:13|3914|3:3|image|State.pm:DESTROY(930)|process has a database handle stored in $ENV{dbh}, attempting disconnect 2011-01-26 14:15:13|3914|3:3|image|State.pm:DESTROY(932)|$ENV{dbh}: database disconnect successful 2011-01-26 14:15:13|3914|3:3|image|State.pm:DESTROY(946)|VCL::image process 3914 exiting 2011-01-26 14:15:13|3914|3:3|image|utils.pm:mail(1247)|SUCCESS -- Sending mail To: 0, PROBLEM -- vcld |3914|3:3|image| ---- CRITICAL ---- |3914|3:3|image| 2011-01-26 14:15:13|3914|3:3|image|vcld:make_new_child(598)|VCL::image object could not be created and initialized |3914|3:3|image| ( 0) utils.pm, notify (line: 630) |3914|3:3|image| (-1) vcld, make_new_child (line: 598) |3914|3:3|image| (-2) vcld, main (line: 342) 2011-01-26 14:15:13|3914|3:3|image|utils.pm:switch_state(7338)|called from VCL::vcld::make_new_child(599) 2011-01-26 14:15:13|3914|3:3|image|utils.pm:switch_state(7374)|parent: parent reservation ID for this request: 3 2011-01-26 14:15:13|3914|3:3|image|utils.pm:getnewdbh(2761)|unable to use database handle stored in $ENV{dbh} 2011-01-26 14:15:13|3914|3:3|image|utils.pm:getnewdbh(2818)|database handle stored in $ENV{dbh} 2011-01-26 14:15:13|3914|3:3|image|utils.pm:insertloadlog(3933)|inserted computer=8, info, VCL::vcld: switching request state to failed 2011-01-26 14:15:13|3914|3:3|image|utils.pm:update_request_state(2049)|request 3 state updated to: failed, laststate to: image 2011-01-26 14:15:13|3914|3:3|image|utils.pm:switch_state(7398)|req=3: request state changed: image->failed, laststate: image->image 2011-01-26 14:15:13|3914|3:3|image|utils.pm:insertloadlog(3933)|inserted computer=8, info, VCL::vcld: request state changed to failed, laststate to image 2011-01-26 14:15:13|3914|3:3|image|utils.pm:switch_state(7408)|req=3: computer state not specified, xpbase1 state not changed 2011-01-26 14:15:13|3914|3:3|image|utils.pm:switch_state(7426)|req=3: log table id=0, ending set to failed 2011-01-26 14:15:13|3914|3:3|image|utils.pm:insertloadlog(3933)|inserted computer=8, info, VCL::vcld: process exiting 2011-01-26 14:15:13|3914|3:3|image|utils.pm:switch_state(7442)|req=3: process exiting 2011-01-26 14:15:13|3514|vcld:REAPER(745)|VCL process exited for reservation 3, PID: 3914, signal: CHLD 2011-01-26 14:15:13|3514|vcld:main(166)|lastcheckin time updated for management node 1: 2011-01-26 14:15:13 2011-01-26 14:15:13|3514|3:3|failed|vcld:main(251)|request deleted 2011-01-26 14:15:18|3514|vcld:main(166)|lastcheckin time updated for management node 1: 2011-01-26 14:15:18 2011-01-26 14:15:23|3514|vcld:main(166)|lastcheckin time updated for management node 1: 2011-01-26 14:15:23 2011-01-26 14:15:28|3514|vcld:main(166)|lastcheckin time updated for management node 1: 2011-01-26 14:15:28
