I think some of the data that VCL needs is not initialized, could you post
your Image, ImageRevision, Computer, Vmprofile, and Vmhost tables?
On Thu, Apr 1, 2010 at 3:25 PM, Kumar, Amit H. <ahku...@odu.edu> wrote:
> Hi All again,
>
> After a long break I am back to where, I was unable to get the Reservation
> to work:
>
> So, I was able to get Image capture work smoothly with the only short come
> of not completing the automatically created reservation process after image
> capture. Which failed at the point after registering the VM on the
> VMhost(ESXi). It does send the correct information and commands for
> registering the VM but it registeres the VM as "Unknown";
>
> Following upon Ryan's comment on un mounting and remounting the NFS store.
> I started to make reservations and yet haven't been successful.
>
> As usual something silly/unknown that I can't see.
> Two unusual things:
>
> 1) esx.pm:node_status(814)|could not set ssh identity variable for
> image type= host=
>
> 2) "SSH exits with the exit status of the remote command or with 255
> if an error occurred, output:" had same issue during image capture, and
> again Ryan pointed out a workaround to point to my NFS store directly.
> "Pushing the problem, doesn't not necessarily solve it" :)
>
> Please advise.......................................
>
> 3 2010-04-01 11:04:58|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:04:58
> 4 2010-04-01 11:05:03|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:03
> 5 2010-04-01 11:05:08|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:08
> 6 2010-04-01 11:05:13|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:13
> 7 2010-04-01 11:05:18|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:18
> 8 2010-04-01 11:05:23|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:23
> 9 2010-04-01 11:05:28|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:28
> 10 2010-04-01 11:05:33|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:33
> 11 2010-04-01 11:05:38|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:38
> 12 2010-04-01 11:05:43|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:43
> 13 2010-04-01 11:05:48|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:48
> 14 2010-04-01 11:05:53|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:53
> 15 2010-04-01
> 11:05:53|5754|8:8|new|utils.pm:reservation_being_processed(9634)|computerloadlog
> 'begin' entry does NOT exist for reservation 8
> 16 2010-04-01
> 11:05:53|5754|8:8|new|utils.pm:reservation_being_processed(9686)|reservation
> is NOT currently being processed
> 17 2010-04-01 11:05:53|5754|8:8|new|vcld:main(276)|reservation 8 is
> NOT already being processed
> 18
> 19 |5754|8:8|new| ---- WARNING ----
> 20 |5754|8:8|new| 2010-04-01
> 11:05:53|5754|8:8|new|utils.pm:get_request_info(5218)|preferredimageid
> is not set for computer id=2
> 21 |5754|8:8|new| ( 0) utils.pm, notify (line: 737)
> 22 |5754|8:8|new| (-1) utils.pm, get_request_info (line: 5218)
> 23 |5754|8:8|new| (-2) vcld, main (line: 280)
> 24
> 25 2010-04-01
> 11:05:53|5754|8:8|new|utils.pm:get_request_info(5354)|standalone
> affiliation found: Local
> 26 2010-04-01
> 11:05:53|5754|8:8|new|utils.pm:get_management_node_info(6815)|management
> node info retrieved from database for colbert
> 27 2010-04-01 11:05:53|5754|8:8|new|vcld:main(281)|retrieved request
> information from database
> 28 2010-04-01
> 11:05:53|5754|8:8|new|DataStructure.pm:is_parent_reservation(854)|returning
> true: parent reservation ID for this request: 8
> 29 2010-04-01
> 11:05:53|5754|8:8|new|utils.pm:update_request_state(2186)|request
> 8 state updated to: pending, laststate to: new
> 30 2010-04-01
> 11:05:53|5754|8:8|new|utils.pm:insertloadlog(4710)|inserted
> computer=2, begin, beginning to process, state is new
> 31 2010-04-01 11:05:53|5754|8:8|new|vcld:make_new_child(509)|loaded
> VCL::new module
> 32 2010-04-01 11:05:53|12084|8:8|new|vcld:make_new_child(582)|vcld
> environment variable set to 0 for this process
> 33 2010-04-01 11:05:53|12084|8:8|new|Module.pm:new(132)|constructor
> called, class=VCL::new
> 34 2010-04-01 11:05:53|5754|8:8|new|vcld:make_new_child(566)|current
> number of forked kids: 1
> 35 2010-04-01 11:05:53|12084|8:8|new|Module.pm:new(154)|VCL::new
> object created
> 36 2010-04-01 11:05:53|12084|8:8|new|State.pm:initialize(85)|obtained
> a database handle for this state process, stored as $ENV{dbh}
> 37 2010-04-01 11:05:53|12084|8:8|new|State.pm:check_image_os(820)|no
> corrections need to be made, not an imaging request, returning 1
> 38 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:is_parent_reservation(854)|returning
> true: parent reservation ID for this request: 8
> 39 2010-04-01
> 11:05:53|12084|8:8|new|utils.pm:rename_vcld_process(7863)|reservation
> count: 1
> 40 2010-04-01
> 11:05:53|12084|8:8|new|utils.pm:rename_vcld_process(7882)|PARENTIMAGE:
> 1
> 41 2010-04-01
> 11:05:53|12084|8:8|new|utils.pm:rename_vcld_process(7883)|SUBIMAGE:
> 0
> 42 2010-04-01
> 11:05:53|12084|8:8|new|utils.pm:rename_vcld_process(7901)|renamed
> process to 'vcld VCL::new 8:8 new'
> 43 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:is_parent_reservation(854)|returning
> true: parent reservation ID for this request: 8
> 44 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:is_parent_reservation(854)|returning
> true: parent reservation ID for this request: 8
> 45 2010-04-01
> 11:05:53|12084|8:8|new|State.pm:initialize(121)|attempting to load
> provisioning module: VCL::Module::Provisioning::esx
> 46 2010-04-01 11:05:53|12084|8:8|new|esx.pm:initialize(138)|esx
> vmware toolkit root path found: /usr/lib/vmware-vcli/apps
> 47 2010-04-01 11:05:53|12084|8:8|new|esx.pm:initialize(140)|vmware
> ESX module initialized
> 48 2010-04-01
> 11:05:53|12084|8:8|new|State.pm:initialize(127)|VCL::Module::Provisioning::esx
> module loaded
> 49 2010-04-01 11:05:53|12084|8:8|new|Module.pm:new(132)|constructor
> called, class=VCL::Module::Provisioning::esx
> 50 2010-04-01
> 11:05:53|12084|8:8|new|Module.pm:new(154)|VCL::Module::Provisioning::esx
> object created
> 51 2010-04-01 11:05:53|12084|8:8|new|esx.pm:initialize(138)|esx
> vmware toolkit root path found: /usr/lib/vmware-vcli/apps
> 52 2010-04-01 11:05:53|12084|8:8|new|esx.pm:initialize(140)|vmware
> ESX module initialized
> 53 2010-04-01
> 11:05:53|12084|8:8|new|State.pm:initialize(131)|VCL::Module::Provisioning::esx
> provisioner object created
> 54 2010-04-01
> 11:05:53|12084|8:8|new|State.pm:initialize(145)|attempting to load OS
> module: VCL::Module::OS::Linux
> 55 2010-04-01
> 11:05:53|12084|8:8|new|State.pm:initialize(151)|VCL::Module::OS::Linux
> module loaded
> 56 2010-04-01 11:05:53|12084|8:8|new|Module.pm:new(132)|constructor
> called, class=VCL::Module::OS::Linux
> 57 2010-04-01
> 11:05:53|12084|8:8|new|Module.pm:new(154)|VCL::Module::OS::Linux object
> created
> 58 2010-04-01
> 11:05:53|12084|8:8|new|State.pm:initialize(154)|VCL::Module::OS::Linux OS
> object created
> 59 2010-04-01
> 11:05:53|12084|8:8|new|State.pm:initialize(169)|returning 1
> 60 2010-04-01
> 11:05:53|12084|8:8|new|vcld:make_new_child(591)|VCL::new object created and
> initialized
> 61 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:is_parent_reservation(854)|returning
> true: parent reservation ID for this request: 8
> 62 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:get_computer_state_name(1946)|attempting
> to retrieve current state of computer esx35-hypervisor-1 from the database
> 63 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:get_computer_state_name(1977)|retrieved
> current state of computer esx35-hypervisor-1 from the database: available
> 64 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(697)|data structure
> updated: $self->request_data->{reservation}{8}{computer}{state}{name}
> 65 |12084|8:8|new| computer_state_name = available
> 66
> 67 |12084|8:8|new| ---- WARNING ----
> 68 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(675)|corresponding data
> has not been initialized for get_computer_preferredimage_id:
> $self->request_data->{reservation}{8}{computer}{preferredimage}{id}
> 69 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 70 |12084|8:8|new| (-1) DataStructure.pm, _automethod (line: 675)
> 71 |12084|8:8|new| (-2) Autoload.pm, __ANON__ (line: 80)
> 72 |12084|8:8|new| (-3) new.pm, process (line: 106)
> 73 |12084|8:8|new| (-4) vcld, make_new_child (line: 594)
> 74 |12084|8:8|new| (-5) vcld, main (line: 341)
> 75
> 76
> 77 |12084|8:8|new| ---- WARNING ----
> 78 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(675)|corresponding data
> has not been initialized for get_computer_preferredimage_name:
> $self->request_data->{reservation}{8}{computer}{preferredimage}{name}
> 79 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 80 |12084|8:8|new| (-1) DataStructure.pm, _automethod (line: 675)
> 81 |12084|8:8|new| (-2) Autoload.pm, __ANON__ (line: 80)
> 82 |12084|8:8|new| (-3) new.pm, process (line: 107)
> 83 |12084|8:8|new| (-4) vcld, make_new_child (line: 594)
> 84 |12084|8:8|new| (-5) vcld, main (line: 341)
> 85
> 86 2010-04-01
> 11:05:53|12084|8:8|new|utils.pm:get_management_node_id(9364)|environment
> variable: 1
> 87 2010-04-01 11:05:53|12084|8:8|new|new.pm:process(134)|reservation
> is parent = 1
> 88 2010-04-01 11:05:53|12084|8:8|new|new.pm:process(135)|preload
> only = 0
> 89 2010-04-01 11:05:53|12084|8:8|new|new.pm:process(136)|originating
> request state = new
> 90 2010-04-01 11:05:53|12084|8:8|new|new.pm:process(137)|originating
> request laststate = new
> 91 2010-04-01 11:05:53|12084|8:8|new|new.pm:process(138)|originating
> computer state = available
> 92 2010-04-01 11:05:53|12084|8:8|new|new.pm:process(139)|originating
> computer type = blade
> 93 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:is_parent_reservation(854)|returning
> true: parent reservation ID for this request: 8
> 94 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:get_computer_state_name(1946)|attempting
> to retrieve current state of computer esx35-hypervisor-1 from the database
> 95 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:get_computer_state_name(1977)|retrieved
> current state of computer esx35-hypervisor-1 from the database: available
> 96 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(697)|data structure
> updated: $self->request_data->{reservation}{8}{computer}{state}{name}
> 97 |12084|8:8|new| computer_state_name = available
> 98
> 99 |12084|8:8|new| ---- WARNING ----
> 100 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(675)|corresponding data
> has not been initialized for get_computer_preferredimage_id:
> $self->request_data->{reservation}{8}{computer}{preferredimage}{id}
> 101 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 102 |12084|8:8|new| (-1) DataStructure.pm, _automethod (line: 675)
> 103 |12084|8:8|new| (-2) Autoload.pm, __ANON__ (line: 80)
> 104 |12084|8:8|new| (-3) new.pm, computer_not_being_used (line: 750)
> 105 |12084|8:8|new| (-4) new.pm, process (line: 170)
> 106 |12084|8:8|new| (-5) vcld, make_new_child (line: 594)
> 107 |12084|8:8|new| (-6) vcld, main (line: 341)
> 108
> 109
> 110 |12084|8:8|new| ---- WARNING ----
> 111 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(675)|corresponding data
> has not been initialized for get_computer_preferredimage_name:
> $self->request_data->{reservation}{8}{computer}{preferredimage}{name}
> 112 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 113 |12084|8:8|new| (-1) DataStructure.pm, _automethod (line: 675)
> 114 |12084|8:8|new| (-2) Autoload.pm, __ANON__ (line: 80)
> 115 |12084|8:8|new| (-3) new.pm, computer_not_being_used (line: 751)
> 116 |12084|8:8|new| (-4) new.pm, process (line: 170)
> 117 |12084|8:8|new| (-5) vcld, make_new_child (line: 594)
> 118 |12084|8:8|new| (-6) vcld, main (line: 341)
> 119
> 120 2010-04-01
> 11:05:53|12084|8:8|new|utils.pm:get_management_node_id(9364)|environment
> variable: 1
> 121 2010-04-01
> 11:05:53|12084|8:8|new|new.pm:computer_not_being_used(788)|esx35-hypervisor-1
> state is available
> 122 2010-04-01
> 11:05:53|12084|8:8|new|new.pm:computer_not_being_used(798)|esx35-hypervisor-1
> is available, its state is available
> 123 2010-04-01
> 11:05:53|12084|8:8|new|new.pm:process(170)|esx35-hypervisor-1
> is not being used
> 124 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:is_parent_reservation(854)|returning
> true: parent reservation ID for this request: 8
> 125 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:get_computer_state_name(1946)|attempting
> to retrieve current state of computer esx35-hypervisor-1 from the database
> 126 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:get_computer_state_name(1977)|retrieved
> current state of computer esx35-hypervisor-1 from the database: available
> 127 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(697)|data structure
> updated: $self->request_data->{reservation}{8}{computer}{state}{name}
> 128 |12084|8:8|new| computer_state_name = available
> 129
> 130 |12084|8:8|new| ---- WARNING ----
> 131 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(675)|corresponding data
> has not been initialized for get_computer_preferredimage_id:
> $self->request_data->{reservation}{8}{computer}{preferredimage}{id}
> 132 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 133 |12084|8:8|new| (-1) DataStructure.pm, _automethod (line: 675)
> 134 |12084|8:8|new| (-2) Autoload.pm, __ANON__ (line: 80)
> 135 |12084|8:8|new| (-3) new.pm, reload_image (line: 480)
> 136 |12084|8:8|new| (-4) new.pm, process (line: 266)
> 137 |12084|8:8|new| (-5) vcld, make_new_child (line: 594)
> 138 |12084|8:8|new| (-6) vcld, main (line: 341)
> 139
> 140
> 141 |12084|8:8|new| ---- WARNING ----
> 142 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(675)|corresponding data
> has not been initialized for get_computer_preferredimage_name:
> $self->request_data->{reservation}{8}{computer}{preferredimage}{name}
> 143 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 144 |12084|8:8|new| (-1) DataStructure.pm, _automethod (line: 675)
> 145 |12084|8:8|new| (-2) Autoload.pm, __ANON__ (line: 80)
> 146 |12084|8:8|new| (-3) new.pm, reload_image (line: 481)
> 147 |12084|8:8|new| (-4) new.pm, process (line: 266)
> 148 |12084|8:8|new| (-5) vcld, make_new_child (line: 594)
> 149 |12084|8:8|new| (-6) vcld, main (line: 341)
> 150
> 151 2010-04-01
> 11:05:53|12084|8:8|new|utils.pm:get_management_node_id(9364)|environment
> variable: 1
> 152 2010-04-01 11:05:53|12084|8:8|new|new.pm:reload_image(514)|calling
> VCL::Module::Provisioning::esx->node_status()
> 153 2010-04-01
> 11:05:53|12084|8:8|new|utils.pm:insertloadlog(4710)|inserted
> computer=2, statuscheck, checking status of node
> 154
> 155 |12084|8:8|new| ---- WARNING ----
> 156 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(675)|corresponding data
> has not been initialized for get_vmhost_profile_vmpath:
> $self->request_data->{reservation}{8}{computer}{vmhost}{vmprofile}{vmpath}
> 157 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 158 |12084|8:8|new| (-1) DataStructure.pm, _automethod (line: 675)
> 159 |12084|8:8|new| (-2) Autoload.pm, __ANON__ (line: 80)
> 160 |12084|8:8|new| (-3) esx.pm, node_status (line: 776)
> 161 |12084|8:8|new| (-4) new.pm, reload_image (line: 518)
> 162 |12084|8:8|new| (-5) new.pm, process (line: 266)
> 163 |12084|8:8|new| (-6) vcld, make_new_child (line: 594)
> 164
> 165
> 166 |12084|8:8|new| ---- WARNING ----
> 167 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(675)|corresponding data
> has not been initialized for get_vmhost_profile_datastore_path:
> $self->request_data->{reservation}{8}{computer}{vmhost}{vmprofile}{datastorepath}
> 168 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 169 |12084|8:8|new| (-1) DataStructure.pm, _automethod (line: 675)
> 170 |12084|8:8|new| (-2) Autoload.pm, __ANON__ (line: 80)
> 171 |12084|8:8|new| (-3) esx.pm, node_status (line: 777)
> 172 |12084|8:8|new| (-4) new.pm, reload_image (line: 518)
> 173 |12084|8:8|new| (-5) new.pm, process (line: 266)
> 174 |12084|8:8|new| (-6) vcld, make_new_child (line: 594)
> 175
> 176
> 177 |12084|8:8|new| ---- WARNING ----
> 178 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(675)|corresponding data
> has not been initialized for get_vmhost_type:
> $self->request_data->{reservation}{8}{computer}{vmhost}{type}
> 179 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 180 |12084|8:8|new| (-1) DataStructure.pm, _automethod (line: 675)
> 181 |12084|8:8|new| (-2) Autoload.pm, __ANON__ (line: 80)
> 182 |12084|8:8|new| (-3) esx.pm, node_status (line: 779)
> 183 |12084|8:8|new| (-4) new.pm, reload_image (line: 518)
> 184 |12084|8:8|new| (-5) new.pm, process (line: 266)
> 185 |12084|8:8|new| (-6) vcld, make_new_child (line: 594)
> 186
> 187
> 188 |12084|8:8|new| ---- WARNING ----
> 189 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(675)|corresponding data
> has not been initialized for get_vmhost_hostname:
> $self->request_data->{reservation}{8}{computer}{vmhost}{hostname}
> 190 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 191 |12084|8:8|new| (-1) DataStructure.pm, _automethod (line: 675)
> 192 |12084|8:8|new| (-2) Autoload.pm, __ANON__ (line: 80)
> 193 |12084|8:8|new| (-3) esx.pm, node_status (line: 780)
> 194 |12084|8:8|new| (-4) new.pm, reload_image (line: 518)
> 195 |12084|8:8|new| (-5) new.pm, process (line: 266)
> 196 |12084|8:8|new| (-6) vcld, make_new_child (line: 594)
> 197
> 198
> 199 |12084|8:8|new| ---- WARNING ----
> 200 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|DataStructure.pm:_automethod(675)|corresponding data
> has not been initialized for get_vmhost_image_name:
> $self->request_data->{reservation}{8}{computer}{vmhost}{imagename}
> 201 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 202 |12084|8:8|new| (-1) DataStructure.pm, _automethod (line: 675)
> 203 |12084|8:8|new| (-2) Autoload.pm, __ANON__ (line: 80)
> 204 |12084|8:8|new| (-3) esx.pm, node_status (line: 781)
> 205 |12084|8:8|new| (-4) new.pm, reload_image (line: 518)
> 206 |12084|8:8|new| (-5) new.pm, process (line: 266)
> 207 |12084|8:8|new| (-6) vcld, make_new_child (line: 594)
> 208
> 216 2010-04-01 11:05:53|12084|8:8|new|esx.pm:node_status(787)|Entering
> node_status, checking status of esx35-hypervisor-1
> 217 2010-04-01
> 11:05:53|12084|8:8|new|esx.pm:node_status(788)|request_for_imaging:
> 0
> 218 2010-04-01 11:05:53|12084|8:8|new|esx.pm:node_status(789)|requeseted
> image name: esx3-basewinxp-v0
> 219 Use of uninitialized value in string eq at
> 220 /usr/local/vcl/bin/../lib/VCL/Module/Provisioning/
> esx.pm line 804 (#1)
> 221 (W uninitialized) An undefined value was used as if it were
> already
> 222 defined. It was interpreted as a "" or a 0, but maybe it was a
> mistake.
> 223 To suppress this warning assign a defined value to your
> variables.
> 224
> 225 To help you figure out what was undefined, perl tells you what
> operation
> 226 you used the undefined value in. Note, however, that perl
> optimizes your
> 227 program and the operation displayed in the warning may not
> necessarily
> 228 appear literally in your program. For example, "that $foo" is
> 229 usually optimized into "that " . $foo, and the warning will
> refer to
> 230 the concatenation (.) operator, even though there is no . in
> your
> 231 program.
> 232
> 233
> 234 |12084|8:8|new| ---- WARNING ----
> 235 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|vcld:warning_handler(636)|Use of uninitialized value
> in string eq at /usr/local/vcl/bin/../lib/VCL/Module/Provisioning/esx.pmline
> 804.
> 236 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 237 |12084|8:8|new| (-1) vcld, warning_handler (line: 636)
> 238 |12084|8:8|new| (-2) esx.pm, node_status (line: 804)
> 239 |12084|8:8|new| (-3) new.pm, reload_image (line: 518)
> 240 |12084|8:8|new| (-4) new.pm, process (line: 266)
> 241 |12084|8:8|new| (-5) vcld, make_new_child (line: 594)
> 242 |12084|8:8|new| (-6) vcld, main (line: 341)
> 243
> 244
> 245 |12084|8:8|new| ---- WARNING ----
> 246 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|vcld:warning_handler(636)|Use of uninitialized value
> in pattern match (m//) at /usr/local/vcl/bin/../lib/VCL/Module/Provisioning/
> esx.pm line 811.
> 247 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 248 |12084|8:8|new| (-1) vcld, warning_handler (line: 636)
> 249 |12084|8:8|new| (-2) esx.pm, node_status (line: 811)
> 250 |12084|8:8|new| (-3) new.pm, reload_image (line: 518)
> 251 |12084|8:8|new| (-4) new.pm, process (line: 266)
> 252 |12084|8:8|new| (-5) vcld, make_new_child (line: 594)
> 253 |12084|8:8|new| (-6) vcld, main (line: 341)
> 254
> 255
> 256 |12084|8:8|new| ---- WARNING ----
> 257 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|vcld:warning_handler(636)|Use of uninitialized value
> in concatenation (.) or string at
> /usr/local/vcl/bin/../lib/VCL/Module/Provisioning/esx.pm line 815.
> 258 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 259 |12084|8:8|new| (-1) vcld, warning_handler (line: 636)
> 260 |12084|8:8|new| (-2) esx.pm, node_status (line: 814)
> 261 |12084|8:8|new| (-3) new.pm, reload_image (line: 518)
> 262 |12084|8:8|new| (-4) new.pm, process (line: 266)
> 263 |12084|8:8|new| (-5) vcld, make_new_child (line: 594)
> 264 |12084|8:8|new| (-6) vcld, main (line: 341)
> 265
> 266
> 267 |12084|8:8|new| ---- WARNING ----
> 268 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|vcld:warning_handler(636)|Use of uninitialized value
> in concatenation (.) or string at
> /usr/local/vcl/bin/../lib/VCL/Module/Provisioning/esx.pm line 815.
> 269 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 270 |12084|8:8|new| (-1) vcld, warning_handler (line: 636)
> 271 |12084|8:8|new| (-2) esx.pm, node_status (line: 814)
> 272 |12084|8:8|new| (-3) new.pm, reload_image (line: 518)
> 273 |12084|8:8|new| (-4) new.pm, process (line: 266)
> 274 |12084|8:8|new| (-5) vcld, make_new_child (line: 594)
> 275 |12084|8:8|new| (-6) vcld, main (line: 341)
> 276
> 277
> 278 |12084|8:8|new| ---- WARNING ----
> 279 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|vcld:warning_handler(636)|Use of uninitialized value
> in concatenation (.) or string at
> /usr/local/vcl/bin/../lib/VCL/Module/Provisioning/esx.pm line 815.
> 280 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 281 |12084|8:8|new| (-1) vcld, warning_handler (line: 636)
> 282 |12084|8:8|new| (-2) esx.pm, node_status (line: 814)
> 283 |12084|8:8|new| (-3) new.pm, reload_image (line: 518)
> 284 |12084|8:8|new| (-4) new.pm, process (line: 266)
> 285 |12084|8:8|new| (-5) vcld, make_new_child (line: 594)
> 286 |12084|8:8|new| (-6) vcld, main (line: 341)
> 287
> 288 No recipient addresses found in header
> 289 2010-04-01 11:05:54|12084|8:8|new|utils.pm:mail(1348)|SUCCESS --
> Sending mail To: , PROBLEM -- esx.pm
> 290
> 291 |12084|8:8|new| ---- CRITICAL ----
> 292 |12084|8:8|new| 2010-04-01
> 11:05:53|12084|8:8|new|esx.pm:node_status(814)|could
> not set ssh identity variable for image type= host=
> 293 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 294 |12084|8:8|new| (-1) esx.pm, node_status (line: 814)
> 295 |12084|8:8|new| (-2) new.pm, reload_image (line: 518)
> 296 |12084|8:8|new| (-3) new.pm, process (line: 266)
> 297 |12084|8:8|new| (-4) vcld, make_new_child (line: 594)
> 298 |12084|8:8|new| (-5) vcld, main (line: 341)
> 299
> 300 2010-04-01 11:05:54|12084|8:8|new|esx.pm:node_status(819)|checking
> if esx35-hypervisor-1 is pingable
> 301 2010-04-01
> 11:05:54|12084|8:8|new|esx.pm:node_status(822)|esx35-hypervisor-1
> is pingable (1)
> 302 2010-04-01 11:05:54|12084|8:8|new|esx.pm:node_status(836)|Trying
> to ssh...
> 303 2010-04-01
> 11:05:54|12084|8:8|new|utils.pm:run_ssh_command(6180)|executing
> SSH command on esx35-hypervisor-1:
> 304 |12084|8:8|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22 -x
> esx35-hypervisor-1 'uname -s' 2>&1
> 305
> 306 |12084|8:8|new| ---- WARNING ----
> 307 |12084|8:8|new| 2010-04-01
> 11:05:54|12084|8:8|new|utils.pm:run_ssh_command(6252)|attempt
> 1/3: failed to execute SSH command on esx35-hypervisor-1: uname -s, exit
> status: 255, SSH exits with the exit status of the remote command or with
> 255 if an error occurred, output:
> 308 |12084|8:8|new| ssh output (uname -s): VMkernel
> 309 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 310 |12084|8:8|new| (-1) utils.pm, run_ssh_command (line: 6252)
> 311 |12084|8:8|new| (-2) utils.pm, _sshd_status (line: 2755)
> 312 |12084|8:8|new| (-3) esx.pm, node_status (line: 839)
> 313 |12084|8:8|new| (-4) new.pm, reload_image (line: 518)
> 314 |12084|8:8|new| (-5) new.pm, process (line: 266)
> 315 |12084|8:8|new| (-6) vcld, make_new_child (line: 594)
> 316
> 317 2010-04-01
> 11:05:54|12084|8:8|new|utils.pm:run_ssh_command(6172)|sleeping
> for 2 seconds before making next SSH attempt
> 318 2010-04-01
> 11:05:56|12084|8:8|new|utils.pm:run_ssh_command(6184)|attempt
> 2/3: executing SSH command on esx35-hypervisor-1:
> 319 |12084|8:8|new| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22 -x
> esx35-hypervisor-1 'uname -s' 2>&1
> 320
> 321 |12084|8:8|new| ---- WARNING ----
> 322 |12084|8:8|new| 2010-04-01
> 11:05:56|12084|8:8|new|utils.pm:run_ssh_command(6252)|attempt
> 2/3: failed to execute SSH command on esx35-hypervisor-1: uname -s, exit
> status: 255, SSH exits with the exit status of the remote command or with
> 255 if an error occurred, output:
> 323 |12084|8:8|new| ssh output (uname -s): VMkernel
> 324 |12084|8:8|new| ( 0) utils.pm, notify (line: 737)
> 325 |12084|8:8|new| (-1) utils.pm, run_ssh_command (line: 6252)
> 326 |12084|8:8|new| (-2) utils.pm, _sshd_status (line: 2755)
> 327 |12084|8:8|new| (-3) esx.pm, node_status (line: 839)
> 328 |12084|8:8|new| (-4) new.pm, reload_image (line: 518)
> 329 |12084|8:8|new| (-5) new.pm, process (line: 266)
> 330 |12084|8:8|new| (-6) vcld, make_new_child (line: 594)
> 331
> 332 2010-04-01
> 11:05:56|12084|8:8|new|utils.pm:run_ssh_command(6172)|sleeping
> for 15 seconds before making next SSH attempt
> 333 2010-04-01 11:05:58|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:05:58
> 334 2010-04-01 11:06:03|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:06:03
> 335 2010-04-01 11:06:08|5754|vcld:main(165)|lastcheckin time updated
> for management node 1: 2010-04-01 11:06:08
> 336
>
>
> Thank you,
> Amit
>
>
