Hi!
I use KVM and have next issue with creation of base image. As I see - VCL
strip IP and try to execute ssh command on host 192 instead of
192.168.51.115.
Maybe somebody has idea - what is root of this issue and how to create
image?
2013-02-22 02:19:03|3189|8:8|image|OS.pm:find_files(2945)|files found: 1,
base directory:
'/usr/local/vcl/bin/../lib/VCL/Module/Provisioning/libvirt/', pattern:
'*.pm'
|3189|8:8|image| command: '/usr/bin/find
"/usr/local/vcl/bin/../lib/VCL/Module/Provisioning/libvirt/" -type f -iname
"*.pm"'
2013-02-22
02:19:03|3189|8:8|image|Module.pm:new(200)|VCL::Module::Provisioning::libvirt::KVM
object created for computer centos_vm1, address: 42f72f0
2013-02-22 02:19:03|3189|8:8|image|utils.pm:run_ssh_command(4902)|executing
SSH command on 192:
|3189|8:8|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 192 'which virsh'
2>&1
|3189|8:8|image| ---- WARNING ----
|3189|8:8|image| 2013-02-22
02:19:03|3189|8:8|image|utils.pm:run_ssh_command(5010)|attempt
1/3: failed to execute SSH command on 192: 'which virsh', exit status: 255,
SSH exits with the exit status of the remote command or with 255 if an
error occurred, output:
|3189|8:8|image| ssh output (which virs...): ssh: connect to host 192 port
22: Invalid argument
|3189|8:8|image| ( 0) utils.pm, run_ssh_command (line: 5010)
|3189|8:8|image| (-1) OS.pm, execute (line: 1992)
|3189|8:8|image| (-2) KVM.pm, initialize (line: 94)
|3189|8:8|image| (-3) Module.pm, new (line: 207)
|3189|8:8|image| (-4) libvirt.pm, (eval) (line: 117)
|3189|8:8|image| (-5) libvirt.pm, initialize (line: 117)
2013-02-22 02:19:03|3189|8:8|image|utils.pm:run_ssh_command(4894)|sleeping
for 2 seconds before making next SSH attempt
2013-02-22 02:19:05|3189|8:8|image|utils.pm:run_ssh_command(4906)|attempt
2/3: executing SSH command on 192:
|3189|8:8|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 192 'which virsh'
2>&1
--
Best Regards, Ilya
2013-02-22 02:18:32|3118|vcld:setup_management_node(830)|checking if setup()
subroutine has been implemented by 'predictive_level_0' module
2013-02-22 02:18:32|3118|vcld:setup_management_node(830)|checking if setup()
subroutine has been implemented by 'os_windows' module
2013-02-22 02:18:32|3118|Module.pm:new(196)|VCL::Module::OS::Windows object
created for image <not set>, address: 48ebd50
2013-02-22 02:18:32|3118|vcld:setup_management_node(830)|checking if setup()
subroutine has been implemented by 'provisioning_vbox' module
2013-02-22 02:18:32|3118|vcld:setup_management_node(830)|checking if setup()
subroutine has been implemented by 'os_linux' module
2013-02-22 02:18:32|3118|utils.pm:setup_get_array_choice(9774)|choices argument:
|3118| VCL Base Module
|3118| VCL Image State Module
|3118| Windows OS Module
2013-02-22 02:18:33|7381|vcld:main(167)|lastcheckin time updated for management
node 1: 2013-02-22 02:18:33
2013-02-22 02:18:38|7381|vcld:main(167)|lastcheckin time updated for management
node 1: 2013-02-22 02:18:38
2013-02-22 02:18:38|3118|utils.pm:setup_get_array_choice(9774)|choices argument:
|3118| Add Local VCL User Account
|3118| Set Local VCL User Account Password
|3118| Test RPC-XML Access
2013-02-22 02:18:41|3118|utils.pm:setup_get_array_choice(9774)|choices argument:
|3118| VCL Base Module
|3118| VCL Image State Module
|3118| Windows OS Module
2013-02-22 02:18:42|3118|utils.pm:setup_get_array_choice(9774)|choices argument:
|3118| Capture Base Image
2013-02-22 02:18:43|7381|vcld:main(167)|lastcheckin time updated for management
node 1: 2013-02-22 02:18:43
2013-02-22
02:18:43|3118|utils.pm:get_management_node_id(8369)|management_node_id
environment variable not set
2013-02-22
02:18:43|3118|utils.pm:get_management_node_id(8375)|get_managementnode_info(): 1
2013-02-22 02:18:48|7381|vcld:main(167)|lastcheckin time updated for management
node 1: 2013-02-22 02:18:48
2013-02-22 02:18:53|3118|utils.pm:get_computer_ids(7967)|found computers
matching identifier: 192.168.51.117, IDs: 2
2013-02-22 02:18:53|3118|utils.pm:setup_get_array_choice(9774)|choices argument:
|3118| Generic Linux (VMware)
|3118| OSX Snow Leopard (VMware)
|3118| Ubuntu (VMware)
|3118| Windows 2003 Server (VMware)
|3118| Windows 7 (VMware)
|3118| Windows Server 2008 (VMware)
|3118| Windows Vista (VMware)
|3118| Windows XP (VMware)
2013-02-22 02:18:53|7381|vcld:main(167)|lastcheckin time updated for management
node 1: 2013-02-22 02:18:53
2013-02-22 02:18:54|3118|utils.pm:setup_get_array_choice(9774)|choices argument:
|3118| x86
|3118| x86_64
2013-02-22 02:18:58|7381|vcld:main(167)|lastcheckin time updated for management
node 1: 2013-02-22 02:18:58
2013-02-22 02:19:03|3118|utils.pm:insert_request(8048)|inserted new reload
request into request table, request id=8
2013-02-22 02:19:03|3118|utils.pm:insert_request(8079)|inserted new reload
request into reservation table, reservation id=8
2013-02-22 02:19:03|7381|vcld:main(167)|lastcheckin time updated for management
node 1: 2013-02-22 02:19:03
2013-02-22
02:19:03|7381|8:8|image|utils.pm:reservation_being_processed(8634)|computerloadlog
'begin' entry does NOT exist for reservation 8
2013-02-22 02:19:03|7381|8:8|image|utils.pm:run_command(8706)|executed command:
pgrep -fl 'vcld [0-9]+:8 ', pid: 3171, exit status: 1, output:
2013-02-22
02:19:03|7381|8:8|image|utils.pm:is_management_node_process_running(8939)|process
is NOT running, identifier: 'vcld [0-9]+:8 '
2013-02-22
02:19:03|7381|8:8|image|utils.pm:reservation_being_processed(8655)|reservation
is NOT currently being processed
2013-02-22 02:19:03|7381|8:8|image|vcld:main(282)|reservation 8 is NOT already
being processed
2013-02-22 02:19:03|7381|8:8|image|utils.pm:get_imagemeta_info(4576)|retrieved
imagemeta info:
|7381|8:8|image| : {
|7381|8:8|image| : "architecture" => "",
|7381|8:8|image| : "checkuser" => 1,
|7381|8:8|image| : "id" => 9,
|7381|8:8|image| : "postoption" => "",
|7381|8:8|image| : "rootaccess" => 1,
|7381|8:8|image| : "subimages" => 0,
|7381|8:8|image| : "sysprep" => 1,
|7381|8:8|image| : "usergroupid" => ""
|7381|8:8|image| : }
2013-02-22
02:19:03|7381|8:8|image|utils.pm:get_management_node_info(5456)|retrieving
current management node info for 'localhost' from database, cached data is
stale: 147 seconds old
2013-02-22
02:19:03|7381|8:8|image|utils.pm:get_management_node_info(5603)|retrieved
management node info: 'localhost' (localhost)
2013-02-22
02:19:03|7381|8:8|image|utils.pm:get_connect_method_info(10059)|attempting to
retrieve connect method info:
|7381|8:8|image| imagerevision: 9 - vmwarelinux-img610-v0
|7381|8:8|image| OS: 36 - vmwarelinux
|7381|8:8|image| OS type: 2 - linux
2013-02-22 02:19:03|7381|8:8|image|utils.pm:get_connect_method_info(10123)|ssh:
connectmethodid=1, OStypeid=2, OSid=NULL, imagerevisionid=NULL, disabled=0
2013-02-22 02:19:03|7381|8:8|image|vcld:main(287)|retrieved request information
from database
2013-02-22
02:19:03|7381|8:8|image|DataStructure.pm:is_parent_reservation(1004)|returning
true: parent reservation ID for this request: 8
2013-02-22 02:19:03|7381|8:8|image|utils.pm:update_request_state(1545)|request
8 state updated to: pending, laststate to: image
2013-02-22 02:19:03|7381|8:8|image|utils.pm:insertloadlog(3665)|inserted
computer=2, begin, beginning to process, state is image
2013-02-22 02:19:03|7381|8:8|image|vcld:make_new_child(518)|loaded VCL::image
module
2013-02-22 02:19:03|7381|8:8|image|vcld:make_new_child(542)|current number of
forked kids: 1
2013-02-22 02:19:03|3189|8:8|image|vcld:make_new_child(558)|vcld environment
variable set to 0 for this process
2013-02-22 02:19:03|3189|8:8|image|DataStructure.pm:_initialize(643)|image ID
argument was specified: noimage, DataStructure object will contain image
information for the production imagerevision of this image
2013-02-22 02:19:03|3189|8:8|image|DataStructure.pm:_initialize(674)|retrieved
data for imagerevision ID: 1
2013-02-22 02:19:03|3189|8:8|image|DataStructure.pm:_initialize(690)|retrieved
data for image ID: 1
2013-02-22
02:19:03|3189|8:8|image|Module.pm:create_mn_os_object(376)|VCL::Module::OS::Linux::ManagementNode
module loaded
2013-02-22
02:19:03|3189|8:8|image|Module.pm:new(196)|VCL::Module::OS::Linux::ManagementNode
object created for image noimage, address: 40eeb90
2013-02-22 02:19:03|3189|8:8|image|DataStructure.pm:_automethod(847)|data
structure updated, hash path:
$self->request_data->{reservation}{0}{computer}{hostname}, data identifier:
computer_hostname, data:
|3189|8:8|image| : "localhost"
2013-02-22 02:19:03|3189|8:8|image|DataStructure.pm:_automethod(847)|data
structure updated, hash path:
$self->request_data->{reservation}{0}{computer}{NODENAME}, data identifier:
computer_node_name, data:
|3189|8:8|image| : "localhost"
2013-02-22 02:19:03|3189|8:8|image|DataStructure.pm:_automethod(847)|data
structure updated, hash path:
$self->request_data->{reservation}{0}{computer}{SHORTNAME}, data identifier:
computer_short_name, data:
|3189|8:8|image| : "localhost"
2013-02-22 02:19:03|3189|8:8|image|DataStructure.pm:_automethod(847)|data
structure updated, hash path:
$self->request_data->{reservation}{0}{computer}{IPaddress}, data identifier:
computer_ip_address, data:
|3189|8:8|image| : "192.168.51.52"
2013-02-22
02:19:03|3189|8:8|image|Module.pm:create_mn_os_object(381)|VCL::Module::OS::Linux::ManagementNode
OS object created, address: 40eeb90
2013-02-22 02:19:03|3189|8:8|image|Module.pm:new(192)|VCL::image object created
for state image, address: 3b8ad60
2013-02-22 02:19:03|3189|8:8|image|State.pm:initialize(88)|obtained a database
handle for this state process, stored as $ENV{dbh}
2013-02-22 02:19:03|3189|8:8|image|State.pm:check_image_os(790)|no corrections
need to be made to image OS: vmwarelinux
2013-02-22
02:19:03|3189|8:8|image|DataStructure.pm:is_parent_reservation(1004)|returning
true: parent reservation ID for this request: 8
2013-02-22
02:19:03|3189|8:8|image|utils.pm:rename_vcld_process(6752)|reservation count: 1
2013-02-22
02:19:03|3189|8:8|image|utils.pm:rename_vcld_process(6771)|PARENTIMAGE: 1
2013-02-22 02:19:03|3189|8:8|image|utils.pm:rename_vcld_process(6772)|SUBIMAGE: 0
2013-02-22 02:19:03|3189|8:8|image|utils.pm:rename_vcld_process(6790)|renamed
process to 'vcld 8:8 image centos_vm1>192.168.51.115 vmwarelinux-img610-v0
admin'
2013-02-22
02:19:03|3189|8:8|image|DataStructure.pm:is_parent_reservation(1004)|returning
true: parent reservation ID for this request: 8
2013-02-22
02:19:03|3189|8:8|image|DataStructure.pm:is_parent_reservation(1004)|returning
true: parent reservation ID for this request: 8
2013-02-22
02:19:03|3189|8:8|image|Module.pm:create_os_object(308)|VCL::Module::OS::Linux
module loaded
2013-02-22 02:19:03|3189|8:8|image|Module.pm:new(196)|VCL::Module::OS::Linux
object created for image vmwarelinux-img610-v0, address: 40f20a0
2013-02-22
02:19:03|3189|8:8|image|Module.pm:create_os_object(314)|VCL::Module::OS::Linux
OS object created, address: 40f20a0
2013-02-22 02:19:03|3189|8:8|image|State.pm:initialize(125)|computer is a VM,
attempting to create VM host OS object
2013-02-22 02:19:03|3189|8:8|image|DataStructure.pm:_initialize(619)|computer
ID argument was specified, retrieving data for computer ID: 1
2013-02-22 02:19:03|3189|8:8|image|DataStructure.pm:_initialize(643)|image ID
argument was specified: 1, DataStructure object will contain image information
for the production imagerevision of this image
2013-02-22 02:19:03|3189|8:8|image|DataStructure.pm:_initialize(674)|retrieved
data for imagerevision ID: 1
2013-02-22 02:19:03|3189|8:8|image|DataStructure.pm:_initialize(690)|retrieved
data for image ID: 1
2013-02-22
02:19:03|3189|8:8|image|Module.pm:create_vmhost_os_object(454)|attempting to
load VM host OS module: VCL::Module::OS::Linux::UnixLab (image: 1)
2013-02-22 02:19:03|3189|8:8|image|Module.pm:create_vmhost_os_object(460)|VM
host OS module loaded: VCL::Module::OS::Linux::UnixLab
2013-02-22
02:19:03|3189|8:8|image|Module.pm:new(196)|VCL::Module::OS::Linux::UnixLab
object created for image noimage, address: 40f2310
2013-02-22
02:19:03|3189|8:8|image|Module.pm:create_vmhost_os_object(465)|VCL::Module::OS::Linux::UnixLab
OS object created, address: 40f2310
2013-02-22
02:19:03|3189|8:8|image|Module.pm:create_provisioning_object(519)|VCL::Module::Provisioning::libvirt
module loaded
2013-02-22
02:19:03|3189|8:8|image|Module.pm:new(200)|VCL::Module::Provisioning::libvirt
object created for computer centos_vm1, address: 40f26b8
2013-02-22 02:19:03|3189|8:8|image|libvirt.pm:initialize(99)|libvirt driver
module directory path: /usr/local/vcl/bin/../lib/VCL/Module/Provisioning/libvirt
2013-02-22 02:19:03|3189|8:8|image|OS.pm:find_files(2917)|attempting to find
files on localhost, base directory path:
'/usr/local/vcl/bin/../lib/VCL/Module/Provisioning/libvirt/', pattern: *.pm,
command: /usr/bin/find
"/usr/local/vcl/bin/../lib/VCL/Module/Provisioning/libvirt/" -type f -iname
"*.pm"
2013-02-22 02:19:03|3189|8:8|image|OS.pm:find_files(2945)|files found: 1, base
directory: '/usr/local/vcl/bin/../lib/VCL/Module/Provisioning/libvirt/',
pattern: '*.pm'
|3189|8:8|image| command: '/usr/bin/find
"/usr/local/vcl/bin/../lib/VCL/Module/Provisioning/libvirt/" -type f -iname
"*.pm"'
2013-02-22
02:19:03|3189|8:8|image|Module.pm:new(200)|VCL::Module::Provisioning::libvirt::KVM
object created for computer centos_vm1, address: 42f72f0
2013-02-22 02:19:03|3189|8:8|image|utils.pm:run_ssh_command(4902)|executing SSH
command on 192:
|3189|8:8|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 192 'which virsh' 2>&1
|3189|8:8|image| ---- WARNING ----
|3189|8:8|image| 2013-02-22
02:19:03|3189|8:8|image|utils.pm:run_ssh_command(5010)|attempt 1/3: failed to
execute SSH command on 192: 'which virsh', exit status: 255, SSH exits with the
exit status of the remote command or with 255 if an error occurred, output:
|3189|8:8|image| ssh output (which virs...): ssh: connect to host 192 port 22:
Invalid argument
|3189|8:8|image| ( 0) utils.pm, run_ssh_command (line: 5010)
|3189|8:8|image| (-1) OS.pm, execute (line: 1992)
|3189|8:8|image| (-2) KVM.pm, initialize (line: 94)
|3189|8:8|image| (-3) Module.pm, new (line: 207)
|3189|8:8|image| (-4) libvirt.pm, (eval) (line: 117)
|3189|8:8|image| (-5) libvirt.pm, initialize (line: 117)
2013-02-22 02:19:03|3189|8:8|image|utils.pm:run_ssh_command(4894)|sleeping for
2 seconds before making next SSH attempt
2013-02-22 02:19:05|3189|8:8|image|utils.pm:run_ssh_command(4906)|attempt 2/3:
executing SSH command on 192:
|3189|8:8|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 192 'which virsh' 2>&1
|3189|8:8|image| ---- WARNING ----
|3189|8:8|image| 2013-02-22
02:19:05|3189|8:8|image|utils.pm:run_ssh_command(5010)|attempt 2/3: failed to
execute SSH command on 192: 'which virsh', exit status: 255, SSH exits with the
exit status of the remote command or with 255 if an error occurred, output:
|3189|8:8|image| ssh output (which virs...): ssh: connect to host 192 port 22:
Invalid argument
|3189|8:8|image| ( 0) utils.pm, run_ssh_command (line: 5010)
|3189|8:8|image| (-1) OS.pm, execute (line: 1992)
|3189|8:8|image| (-2) KVM.pm, initialize (line: 94)
|3189|8:8|image| (-3) Module.pm, new (line: 207)
|3189|8:8|image| (-4) libvirt.pm, (eval) (line: 117)
|3189|8:8|image| (-5) libvirt.pm, initialize (line: 117)
2013-02-22 02:19:05|3189|8:8|image|utils.pm:run_ssh_command(4894)|sleeping for
4 seconds before making next SSH attempt
2013-02-22 02:19:08|7381|vcld:main(167)|lastcheckin time updated for management
node 1: 2013-02-22 02:19:08
2013-02-22 02:19:09|3189|8:8|image|utils.pm:run_ssh_command(4906)|attempt 3/3:
executing SSH command on 192:
|3189|8:8|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 192 'which virsh' 2>&1
|3189|8:8|image| ---- WARNING ----
|3189|8:8|image| 2013-02-22
02:19:09|3189|8:8|image|utils.pm:run_ssh_command(5010)|attempt 3/3: failed to
execute SSH command on 192: 'which virsh', exit status: 255, SSH exits with the
exit status of the remote command or with 255 if an error occurred, output:
|3189|8:8|image| ssh output (which virs...): ssh: connect to host 192 port 22:
Invalid argument
|3189|8:8|image| ( 0) utils.pm, run_ssh_command (line: 5010)
|3189|8:8|image| (-1) OS.pm, execute (line: 1992)
|3189|8:8|image| (-2) KVM.pm, initialize (line: 94)
|3189|8:8|image| (-3) Module.pm, new (line: 207)
|3189|8:8|image| (-4) libvirt.pm, (eval) (line: 117)
|3189|8:8|image| (-5) libvirt.pm, initialize (line: 117)
|3189|8:8|image| ---- WARNING ----
|3189|8:8|image| 2013-02-22
02:19:09|3189|8:8|image|utils.pm:run_ssh_command(5043)|failed to run SSH
command after 3 attempts, command: /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 192 'which virsh'
2>&1, exit status: 255, output:
|3189|8:8|image| ssh output (which virs...): ssh: connect to host 192 port 22:
Invalid argument
|3189|8:8|image| ( 0) utils.pm, run_ssh_command (line: 5043)
|3189|8:8|image| (-1) OS.pm, execute (line: 1992)
|3189|8:8|image| (-2) KVM.pm, initialize (line: 94)
|3189|8:8|image| (-3) Module.pm, new (line: 207)
|3189|8:8|image| (-4) libvirt.pm, (eval) (line: 117)
|3189|8:8|image| (-5) libvirt.pm, initialize (line: 117)
|3189|8:8|image| ---- WARNING ----
|3189|8:8|image| 2013-02-22 02:19:09|3189|8:8|image|OS.pm:execute(2000)|failed
to run command on 192: which virsh
|3189|8:8|image| ( 0) OS.pm, execute (line: 2000)
|3189|8:8|image| (-1) KVM.pm, initialize (line: 94)
|3189|8:8|image| (-2) Module.pm, new (line: 207)
|3189|8:8|image| (-3) libvirt.pm, (eval) (line: 117)
|3189|8:8|image| (-4) libvirt.pm, initialize (line: 117)
|3189|8:8|image| (-5) Module.pm, new (line: 207)
|3189|8:8|image| ---- WARNING ----
|3189|8:8|image| 2013-02-22
02:19:09|3189|8:8|image|KVM.pm:initialize(96)|unable to initialize KVM driver
module to control 192, failed to execute command to determine if the 'virsh'
command is available
|3189|8:8|image| ( 0) KVM.pm, initialize (line: 96)
|3189|8:8|image| (-1) Module.pm, new (line: 207)
|3189|8:8|image| (-2) libvirt.pm, (eval) (line: 117)
|3189|8:8|image| (-3) libvirt.pm, initialize (line: 117)
|3189|8:8|image| (-4) Module.pm, new (line: 207)
|3189|8:8|image| (-5) Module.pm, create_provisioning_object (line: 522)
2013-02-22 02:19:09|3189|8:8|image|libvirt.pm:initialize(129)|libvirt KVM
driver object could not be initialized to control 192
|3189|8:8|image| ---- WARNING ----
|3189|8:8|image| 2013-02-22
02:19:09|3189|8:8|image|libvirt.pm:driver(829)|unable to return libvirt driver
object, $self->{driver} is not set
|3189|8:8|image| ( 0) libvirt.pm, driver (line: 829)
|3189|8:8|image| (-1) libvirt.pm, initialize (line: 134)
|3189|8:8|image| (-2) Module.pm, new (line: 207)
|3189|8:8|image| (-3) Module.pm, create_provisioning_object (line: 522)
|3189|8:8|image| (-4) State.pm, initialize (line: 136)
|3189|8:8|image| (-5) Module.pm, new (line: 207)
|3189|8:8|image| ---- WARNING ----
|3189|8:8|image| 2013-02-22
02:19:09|3189|8:8|image|libvirt.pm:initialize(135)|failed to initialize libvirt
provisioning module, driver object could not be created and initialized
|3189|8:8|image| ( 0) libvirt.pm, initialize (line: 135)
|3189|8:8|image| (-1) Module.pm, new (line: 207)
|3189|8:8|image| (-2) Module.pm, create_provisioning_object (line: 522)
|3189|8:8|image| (-3) State.pm, initialize (line: 136)
|3189|8:8|image| (-4) Module.pm, new (line: 207)
|3189|8:8|image| (-5) vcld, make_new_child (line: 567)
|3189|8:8|image| ---- WARNING ----
|3189|8:8|image| 2013-02-22
02:19:09|3189|8:8|image|Module.pm:create_provisioning_object(530)|provisioning
object could not be created, returning 0
|3189|8:8|image| ( 0) Module.pm, create_provisioning_object (line: 530)
|3189|8:8|image| (-1) State.pm, initialize (line: 136)
|3189|8:8|image| (-2) Module.pm, new (line: 207)
|3189|8:8|image| (-3) vcld, make_new_child (line: 567)
|3189|8:8|image| (-4) vcld, main (line: 350)
|3189|8:8|image| ---- WARNING ----
|3189|8:8|image| 2013-02-22
02:19:09|3189|8:8|image|State.pm:initialize(145)|failed to create provisioning
object
|3189|8:8|image| ( 0) State.pm, initialize (line: 145)
|3189|8:8|image| (-1) Module.pm, new (line: 207)
|3189|8:8|image| (-2) vcld, make_new_child (line: 567)
|3189|8:8|image| (-3) vcld, main (line: 350)
2013-02-22
02:19:09|3189|8:8|image|utils.pm:delete_computerloadlog_reservation(6396)|removing
computerloadlog entries matching loadstate = begin
2013-02-22
02:19:09|3189|8:8|image|utils.pm:delete_computerloadlog_reservation(6443)|deleted
rows from computerloadlog for reservation id=8
2013-02-22 02:19:09|3189|8:8|image|State.pm:DESTROY(929)|VCL::image process
duration: 6 seconds
2013-02-22
02:19:09|3189|8:8|image|DataStructure.pm:get_computer_private_ip_address(1641)|attempting
to retrieve private IP address for computer: centos_vm1
2013-02-22 02:19:09|3189|8:8|image|OS.pm:get_file_contents(1897)|retrieved 4
lines from file on localhost: '/etc/hosts'
2013-02-22
02:19:09|3189|8:8|image|DataStructure.pm:get_computer_private_ip_address(1697)|returning
IP address from /etc/hosts file: 192.168.51.117
2013-02-22 02:19:09|3189|8:8|image|utils.pm:getnewdbh(2474)|unable to use
database handle stored in $ENV{dbh}
2013-02-22 02:19:09|3189|8:8|image|utils.pm:getnewdbh(2531)|database handle
stored in $ENV{dbh}
2013-02-22 02:19:09|3189|8:8|image|utils.pm:is_inblockrequest(5760)|zero rows
were returned from database select
2013-02-22
02:19:09|3189|8:8|image|DataStructure.pm:get_image_affiliation_name(2121)|image
owner id: 1
2013-02-22
02:19:09|3189|8:8|image|DataStructure.pm:retrieve_user_data(1412)|attempting to
retrieve and store data for user: user.id = '1'
2013-02-22
02:19:09|3189|8:8|image|DataStructure.pm:retrieve_user_data(1475)|data has been
retrieved for user: admin (id: 1)
2013-02-22 02:19:10|7381|vcld:REAPER(721)|VCL process exited for reservation 8,
PID: 3189, signal: CHLD
2013-02-22 02:19:10|7381|vcld:main(167)|lastcheckin time updated for management
node 1: 2013-02-22 02:19:10
2013-02-22 02:19:15|7381|vcld:main(167)|lastcheckin time updated for management
node 1: 2013-02-22 02:19:15
2013-02-22 02:19:20|7381|vcld:main(167)|lastcheckin time updated for management
node 1: 2013-02-22 02:19:20
