Return-Path: Delivered-To: apmail-incubator-vcl-dev-archive@minotaur.apache.org Received: (qmail 4861 invoked from network); 4 Feb 2010 21:43:58 -0000 Received: from hermes.apache.org (HELO mail.apache.org) (140.211.11.3) by minotaur.apache.org with SMTP; 4 Feb 2010 21:43:58 -0000 Received: (qmail 92619 invoked by uid 500); 4 Feb 2010 21:43:57 -0000 Delivered-To: apmail-incubator-vcl-dev-archive@incubator.apache.org Received: (qmail 92595 invoked by uid 500); 4 Feb 2010 21:43:57 -0000 Mailing-List: contact vcl-dev-help@incubator.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: vcl-dev@incubator.apache.org Delivered-To: mailing list vcl-dev@incubator.apache.org Received: (qmail 92585 invoked by uid 99); 4 Feb 2010 21:43:57 -0000 Received: from athena.apache.org (HELO athena.apache.org) (140.211.11.136) by apache.org (qpsmtpd/0.29) with ESMTP; Thu, 04 Feb 2010 21:43:57 +0000 X-ASF-Spam-Status: No, hits=-4.0 required=10.0 tests=RCVD_IN_DNSWL_MED,SPF_PASS X-Spam-Check-By: apache.org Received-SPF: pass (athena.apache.org: local policy) Received: from [129.128.5.19] (HELO mail9.srv.ualberta.ca) (129.128.5.19) by apache.org (qpsmtpd/0.29) with ESMTP; Thu, 04 Feb 2010 21:43:50 +0000 Received: from null-0016cb89708a.aict.ualberta.ca (null-0016cb89708a.aict.ualberta.ca [129.128.9.101]) (authenticated bits=0) by mail9.srv.ualberta.ca (8.13.8/8.13.8) with ESMTP id o14LhRLg020206 (version=TLSv1/SSLv3 cipher=AES128-SHA bits=128 verify=NOT) for ; Thu, 4 Feb 2010 14:43:28 -0700 (MST) References: <201001150854.28757.josh_thompson@ncsu.edu> <76A6224F-7379-47A7-8DE1-E36CC0A9D16C@ualberta.ca> <6326B423-CCAD-49F3-8BF9-DE8CD2DCB866@ualberta.ca> <4B66EA51.6050406@ncsu.edu> <0C6191A6-3CCA-41C2-9761-705B44D27D34@ualberta.ca> <4B683FC1.5010607@nc.rr.com> <4B6A28C9.6050208@ncsu.edu> In-Reply-To: <4B6A28C9.6050208@ncsu.edu> Mime-Version: 1.0 (Apple Message framework v1077) Content-Type: text/plain; charset=us-ascii Message-Id: <3DA8517A-1E85-46BA-B5E4-5F5F86853609@ualberta.ca> Content-Transfer-Encoding: quoted-printable From: Terry McGuire Subject: Re: Base image capture failure Date: Thu, 4 Feb 2010 14:43:27 -0700 To: vcl-dev@incubator.apache.org X-Mailer: Apple Mail (2.1077) On 3 Feb 2010, at 1854h, Andy Kurth wrote: > Try this: > -Uninstall Cygwin. There may not be an entry in Add/Remove Programs. = If not, just delete C:\cygwin. > -Download and install setup-legacy.exe which installs Cygwin 1.5: > http://cygwin.com/setup-legacy.exe > -Follow the same VCL Cygwin installation instructions. I'm pretty sure they don't pay you enough, Andy. Once again, this did = the trick. Now, much more happens before it comes to a grinding halt, = but grinding halt it continues to come to. The initial warnings are = these: _________________ 2010-02-04 = 13:56:50|12426|1:15|image|Windows.pm:get_network_configuration(4630)|attem= pting to retrieve network configuration 2010-02-04 = 13:56:50|12426|1:15|image|utils.pm:run_ssh_command(6180)|executing SSH = command on vmguest-1: |12426|1:15|image| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22 -x = vmguest-1 '$SYSTEMROOT/System32/ipconfig.exe /all' 2>&1 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4634)|ran = ipconfig 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4655)|found= interface: vmnet0 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4655)|found= interface: vmnet1 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4706)|savin= g network configuration in $self->{network_configuration} 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4710)|netwo= rk configuration has already been retrieved 2010-02-04 = 13:56:52|12426|1:15|image|DataStructure.pm:get_computer_private_ip_address= (1442)|attempting to retrieve private IP address for computer: vmguest-1 2010-02-04 = 13:56:52|12426|1:15|image|DataStructure.pm:get_computer_private_ip_address= (1446)|retrieved contents of /etc/hosts on this management node, = contains 7 lines 2010-02-04 = 13:56:52|12426|1:15|image|DataStructure.pm:get_computer_private_ip_address= (1479)|found line for 'vmguest-1' in /etc/hosts: |12426|1:15|image| 192.168.1.1 vmguest-1 2010-02-04 = 13:56:52|12426|1:15|image|DataStructure.pm:get_computer_private_ip_address= (1490)|found IP address: 192.168.1.1 2010-02-04 = 13:56:52|12426|1:15|image|DataStructure.pm:_automethod(697)|data = structure updated: = $self->request_data->{reservation}{15}{computer}{privateIPaddress} |12426|1:15|image| computer_private_ip_address =3D 192.168.1.1 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4760)|inter= face ignored because of name: vmnet0, description: VMware Accelerated = AMD PCNet Adapter #2, address(es): 129.128.9.108 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4747)|priva= te interface found: vmnet1, description: VMware Accelerated AMD PCNet = Adapter, address(es): 192.168.1.1 |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4817)|unabl= e to determine the public interface: |12426|1:15|image| % |12426|1:15|image| |--%{vmnet0} |12426|1:15|image| |--{autoconfiguration_enabled} =3D 'Yes' |12426|1:15|image| |--{connection_specific_dns_suffix} =3D = 'aict.ualberta.ca' |12426|1:15|image| |--{default_gateway} =3D '129.128.8.1' |12426|1:15|image| |--{description} =3D 'VMware Accelerated AMD PCNet = Adapter #2' |12426|1:15|image| |--{dhcp_enabled} =3D 'Yes' |12426|1:15|image| |--{dhcp_server} =3D '129.128.3.245' |12426|1:15|image| |--{dns_server} =3D '129.128.76.233' |12426|1:15|image| |--%{vmnet0}{ip_address} |12426|1:15|image| |--{129.128.9.108} =3D '255.255.254.0' |12426|1:15|image| |--{lease_expires} =3D 'Tuesday, February 09, 2010 = 11:03:36 AM' |12426|1:15|image| |--{lease_obtained} =3D 'Thursday, February 04, 2010 = 11:03:36 AM' |12426|1:15|image| |--{physical_address} =3D '00-0C-29-5A-62-45' |12426|1:15|image| |--%{vmnet1} |12426|1:15|image| |--{autoconfiguration_enabled} =3D 'Yes' |12426|1:15|image| |--{default_gateway} =3D '192.168.0.1' |12426|1:15|image| |--{description} =3D 'VMware Accelerated AMD PCNet = Adapter' |12426|1:15|image| |--{dhcp_enabled} =3D 'Yes' |12426|1:15|image| |--{dhcp_server} =3D '192.168.0.1' |12426|1:15|image| |--%{vmnet1}{ip_address} |12426|1:15|image| |--{192.168.1.1} =3D '255.255.0.0' |12426|1:15|image| |--{lease_expires} =3D 'Thursday, February 04, 2010 = 11:03:36 PM' |12426|1:15|image| |--{lease_obtained} =3D 'Thursday, February 04, 2010 = 11:03:36 AM' |12426|1:15|image| |--{physical_address} =3D '00-0C-29-5A-62-4F' |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) Windows.pm, get_network_configuration (line: = 4817) |12426|1:15|image| (-2) Windows.pm, get_public_interface_name (line: = 4871) |12426|1:15|image| (-3) Windows.pm, disable_dynamic_dns (line: 3660) |12426|1:15|image| (-4) Windows.pm, pre_capture (line: 211) |12426|1:15|image| (-5) Version_5.pm, pre_capture (line: 85) |12426|1:15|image| (-6) vmware.pm, capture (line: 1202) |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_public_interface_name(4873)|unabl= e to retrieve network configuration |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) Windows.pm, get_public_interface_name (line: = 4873) |12426|1:15|image| (-2) Windows.pm, disable_dynamic_dns (line: 3660) |12426|1:15|image| (-3) Windows.pm, pre_capture (line: 211) |12426|1:15|image| (-4) Version_5.pm, pre_capture (line: 85) |12426|1:15|image| (-5) vmware.pm, capture (line: 1202) |12426|1:15|image| (-6) image.pm, process (line: 162) 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4710)|netwo= rk configuration has already been retrieved 2010-02-04 = 13:56:52|12426|1:15|image|DataStructure.pm:get_computer_private_ip_address= (1418)|returning private IP address previously retrieved from = /etc/hosts: 192.168.1.1 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4760)|inter= face ignored because of name: vmnet0, description: VMware Accelerated = AMD PCNet Adapter #2, address(es): 129.128.9.108 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4747)|priva= te interface found: vmnet1, description: VMware Accelerated AMD PCNet = Adapter, address(es): 192.168.1.1 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_network_configuration(4750)|retur= ning data for private interface: vmnet1 (192.168.1.1) 2010-02-04 = 13:56:52|12426|1:15|image|Windows.pm:get_private_interface_name(4848)|retu= rning private interface name: vmnet1 Use of uninitialized value in concatenation (.) or string at /usr/local/vcl/bin/../lib/VCL/Module/OS/Windows.pm line 3666 = (#1) (W uninitialized) An undefined value was used as if it were already defined. It was interpreted as a "" or a 0, but maybe it was a = mistake. To suppress this warning assign a defined value to your variables. =20 To help you figure out what was undefined, perl tells you what = operation you used the undefined value in. Note, however, that perl optimizes = your program and the operation displayed in the warning may not = necessarily appear literally in your program. For example, "that $foo" is usually optimized into "that " . $foo, and the warning will refer to the concatenation (.) operator, even though there is no . in your program. =20 |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 13:56:52|12426|1:15|image|vcld:warning_handler(636)|Use of uninitialized = value in concatenation (.) or string at = /usr/local/vcl/bin/../lib/VCL/Module/OS/Windows.pm line 3666. |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) vcld, warning_handler (line: 636) |12426|1:15|image| (-2) Windows.pm, disable_dynamic_dns (line: 3666) |12426|1:15|image| (-3) Windows.pm, pre_capture (line: 211) |12426|1:15|image| (-4) Version_5.pm, pre_capture (line: 85) |12426|1:15|image| (-5) vmware.pm, capture (line: 1202) |12426|1:15|image| (-6) image.pm, process (line: 162) ___________________________ I'm not actually sure how bad those warning are. The process keeps = going for a while, with various additional warnings, some duplicating = the above, some different. Maybe it's worth posting the warnings that = come towards the end: ___________________________ 2010-02-04 13:58:30|12426|1:15|image|Windows.pm:reboot(2687)|rebooting = vmguest-1 and waiting for ssh to become active 2010-02-04 13:58:30|12426|1:15|image|Windows.pm:reboot(2696)|reboot will = be attempted on vmguest-1 2010-02-04 = 13:58:30|12426|1:15|image|Windows.pm:wait_for_ssh(3047)|waiting for = vmguest-1 to respond to ssh, maximum of 0 minutes |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 13:58:30|12426|1:15|image|vcld:warning_handler(636)|Can't exec = "/usr/bin/nmap": No such file or directory at = /usr/local/vcl/bin/../lib/VCL/utils.pm line 3308. |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) vcld, warning_handler (line: 636) |12426|1:15|image| (-2) utils.pm, nmap_port (line: 3308) |12426|1:15|image| (-3) Windows.pm, wait_for_ssh (line: 3058) |12426|1:15|image| (-4) Windows.pm, reboot (line: 2699) |12426|1:15|image| (-5) Windows.pm, disable_pagefile (line: 1799) |12426|1:15|image| (-6) Windows.pm, pre_capture (line: 318) |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 13:58:30|12426|1:15|image|utils.pm:nmap_port(3327)|problems executing = /usr/bin/nmap vmguest-1 -P0 -p 22 Inappropriate ioctl for device |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) utils.pm, nmap_port (line: 3327) |12426|1:15|image| (-2) Windows.pm, wait_for_ssh (line: 3058) |12426|1:15|image| (-3) Windows.pm, reboot (line: 2699) |12426|1:15|image| (-4) Windows.pm, disable_pagefile (line: 1799) |12426|1:15|image| (-5) Windows.pm, pre_capture (line: 318) |12426|1:15|image| (-6) Version_5.pm, pre_capture (line: 85) |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 13:58:30|12426|1:15|image|vcld:warning_handler(636)|Can't exec = "/usr/bin/nmap": No such file or directory at = /usr/local/vcl/bin/../lib/VCL/utils.pm line 3308. |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) vcld, warning_handler (line: 636) |12426|1:15|image| (-2) utils.pm, nmap_port (line: 3308) |12426|1:15|image| (-3) Windows.pm, wait_for_ssh (line: 3058) |12426|1:15|image| (-4) Windows.pm, reboot (line: 2699) |12426|1:15|image| (-5) Windows.pm, disable_pagefile (line: 1799) |12426|1:15|image| (-6) Windows.pm, pre_capture (line: 318) |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 13:58:30|12426|1:15|image|utils.pm:nmap_port(3327)|problems executing = /usr/bin/nmap vmguest-1 -P0 -p 24 Inappropriate ioctl for device |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) utils.pm, nmap_port (line: 3327) |12426|1:15|image| (-2) Windows.pm, wait_for_ssh (line: 3058) |12426|1:15|image| (-3) Windows.pm, reboot (line: 2699) |12426|1:15|image| (-4) Windows.pm, disable_pagefile (line: 1799) |12426|1:15|image| (-5) Windows.pm, pre_capture (line: 318) |12426|1:15|image| (-6) Version_5.pm, pre_capture (line: 85) 2010-02-04 13:58:30|12426|1:15|image|Windows.pm:wait_for_ssh(3059)|ports = 22 and 24 are closed on vmguest-1 according to nmap |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 13:58:30|12426|1:15|image|Windows.pm:wait_for_ssh(3078)|vmguest-1 is not = available via ssh |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) Windows.pm, wait_for_ssh (line: 3078) |12426|1:15|image| (-2) Windows.pm, reboot (line: 2699) |12426|1:15|image| (-3) Windows.pm, disable_pagefile (line: 1799) |12426|1:15|image| (-4) Windows.pm, pre_capture (line: 318) |12426|1:15|image| (-5) Version_5.pm, pre_capture (line: 85) |12426|1:15|image| (-6) vmware.pm, capture (line: 1202) |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 13:58:30|12426|1:15|image|Windows.pm:reboot(2749)|vmguest-1 did not = respond to ssh, graceful reboot cannot be performed, attempting hard = reset |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) Windows.pm, reboot (line: 2749) |12426|1:15|image| (-2) Windows.pm, disable_pagefile (line: 1799) |12426|1:15|image| (-3) Windows.pm, pre_capture (line: 318) |12426|1:15|image| (-4) Version_5.pm, pre_capture (line: 85) |12426|1:15|image| (-5) vmware.pm, capture (line: 1202) |12426|1:15|image| (-6) image.pm, process (line: 162) 2010-02-04 13:58:30|12426|1:15|image|vmware.pm:get_vm_paths(2655)|vm = locations: |12426|1:15|image| vmdk name: vmwarewinxp-base7-v0 |12426|1:15|image| vmx path: /var/lib/vmware/Virtual\ = Machines/15vmguest-1/15vmguest-1.vmx |12426|1:15|image| vm directory: 15vmguest-1 |12426|1:15|image| base vm directory: 15vmguest-1 2010-02-04 = 13:58:30|12426|1:15|image|vmware.pm:power_reset(2522)|attempting to = reset vm using trysoft mode: 15vmguest-1 2010-02-04 = 13:58:30|12426|1:15|image|utils.pm:run_ssh_command(6180)|executing SSH = command on localvmhost: |12426|1:15|image| /usr/bin/ssh -i /etc/vcl/vcl.key -l root -p 22 -x = localvmhost 'vmware-cmd /var/lib/vmware/Virtual\ = Machines/15vmguest-1/15vmguest-1.vmx reset trysoft' 2>&1 |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 13:58:30|12426|1:15|image|vmware.pm:power_reset(2524)|failed to run = vmware-cmd reset on 15vmguest-1, exit status: 11, output: |12426|1:15|image| Use of uninitialized value in string eq at = /usr/lib64/perl5/site_perl/5.8.8/x86_64-linux-thread-multi/VMware/VmPerl.p= m line 114. /usr/bin/vmware-cmd: Could not connect to VM = /var/lib/vmware/Virtual Machines/15vmguest-1/15vmguest-1.vmx = (VMControl error -11: No such virtual machine: The config file = /var/lib/vmware/Virtual Machines/15vmguest-1/15vmguest-1.vmx is not = registered. Please register the config file on the server. For example: = vmware-cmd -s register "/var/lib/vmware/Virtual = Machines/15vmguest-1/15vmguest-1.vmx") |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) vmware.pm, power_reset (line: 2524) |12426|1:15|image| (-2) Windows.pm, reboot (line: 2752) |12426|1:15|image| (-3) Windows.pm, disable_pagefile (line: 1799) |12426|1:15|image| (-4) Windows.pm, pre_capture (line: 318) |12426|1:15|image| (-5) Version_5.pm, pre_capture (line: 85) |12426|1:15|image| (-6) vmware.pm, capture (line: 1202) _________________________ It then goes on to attempt (but fail) to restart the VM, and then try = (but fail) to ping the VM. Of the various warnings at the very end, the = most interesting might be: _________________________ |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 14:08:45|12426|1:15|image|Windows.pm:disable_pagefile(1803)|failed to = reboot computer after disabling pagefile |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) Windows.pm, disable_pagefile (line: 1803) |12426|1:15|image| (-2) Windows.pm, pre_capture (line: 318) |12426|1:15|image| (-3) Version_5.pm, pre_capture (line: 85) |12426|1:15|image| (-4) vmware.pm, capture (line: 1202) |12426|1:15|image| (-5) image.pm, process (line: 162) |12426|1:15|image| (-6) vcld, make_new_child (line: 594) |12426|1:15|image| ---- WARNING ----=20 |12426|1:15|image| 2010-02-04 = 14:08:45|12426|1:15|image|Windows.pm:pre_capture(319)|unable to disable = pagefile |12426|1:15|image| ( 0) utils.pm, notify (line: 737) |12426|1:15|image| (-1) Windows.pm, pre_capture (line: 319) |12426|1:15|image| (-2) Version_5.pm, pre_capture (line: 85) |12426|1:15|image| (-3) vmware.pm, capture (line: 1202) |12426|1:15|image| (-4) image.pm, process (line: 162) |12426|1:15|image| (-5) vcld, make_new_child (line: 594) |12426|1:15|image| (-6) vcld, main (line: 341) ________________________ I set the two network connections up on the vm as per the documentation = here: = http://cwiki.apache.org/VCL/configuring-a-standalone-vmware-vcl-environmen= t.html I'm not sure how important it was to create both interfaces, but = hopefully I did it right. So, I'm pretty sure the end of the tunnel is getting closer, but I'm = still not sure how far I have to go. Any ideas about my current mess? = (And, thanks once again for all the help you're giving me.) Terry