From: Hayashi, Daiyu
Sent: Wednesday, January 26, 2011 2:55 PM
To: 'vcl-u...@incubator.apache.org'
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
dhaya...@fullerton.edu
------------------------------------------------------------------------------------------------------------------------


[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




Reply via email to