Hi everyone! I´m having problems creating a base image (windows 7). The creation of the base image starts without a problem until the command *|17511|73:2|image| /usr/bin/ssh -i /etc/vcl/vcl2.key -o StrictHostKeyChecking=no -l root -p 22 -x salad02 'C:/Windows/Sysnative/netsh.exe advfirewall set currentprofile state on' 2>&1 *is executed and after that a "timed out" is generated. This has occurred in the last four/five base image creation.
This is a piece of the log: 2012-09-18 16:27:09|17511|73:2|image|Windows.pm:get_network_configuration(5075)|private interface found: Local Area Connection, description: Intel(R) PRO/1000 MT Network Connection, address(es): 192.168.21.82 2012-09-18 16:27:09|17511|73:2|image|Windows.pm:get_private_ip_address(5299)|returning private IP address: 192.168.21.82 2012-09-18 16:27:10|17511|73:2|image|Version_6.pm:get_firewall_state(1398)|retrieved firewall state 2012-09-18 16:27:10|17511|73:2|image|Version_6.pm:get_firewall_state(1421)|returning firewall state: ON 2012-09-18 16:27:10|17511|73:2|image|Version_6.pm:firewall_enable_ssh(1294)|firewall is on, it will be turned off while SSH port exceptions are altered 2012-09-18 16:27:10|17511|73:2|image|utils.pm:run_ssh_command(5380)|executing SSH command on salad02: |17511|73:2|image| /usr/bin/ssh -i /etc/vcl/vcl2.key -o StrictHostKeyChecking=no -l root -p 22 -x salad02 'C:/Windows/Sysnative/netsh.exe advfirewall set currentprofile state off ; sleep 1 ; C:/Windows/Sysnative/netsh.exe advfirewall firewall delete rule name=all dir=in protocol=TCP localport=22 ; C:/Windows/Sysnative/netsh.exe advfirewall firewall add rule name="VCL: allow SSH port 22 to 192.168.21.82" description="Allows incoming SSH (TCP port 22) traffic to 192.168.21.82" protocol=TCP localport=22 action=allow enable=yes dir=in localip=192.168.21.82 remoteip=any' 2>&1 2012-09-18 16:27:12|17511|73:2|image|utils.pm:run_ssh_command(5464)|run_ssh_command output: |17511|73:2|image| Ok. |17511|73:2|image| Deleted 1 rule(s). |17511|73:2|image| Ok. |17511|73:2|image| Ok. 2012-09-18 16:27:12|17511|73:2|image|utils.pm:run_ssh_command(5478)|SSH command executed on salad02, returning (0, "Ok. Deleted 1 rule(s). Ok. Ok.") 2012-09-18 16:27:12|17511|73:2|image|Version_6.pm:firewall_enable_ssh(1320)|added firewall rule to enable SSH to address: 192.168.21.82 2012-09-18 16:27:12|17511|73:2|image|utils.pm:run_ssh_command(5380)|executing SSH command on salad02: |17511|73:2|image| /usr/bin/ssh -i /etc/vcl/vcl2.key -o StrictHostKeyChecking=no -l root -p 22 -x salad02 'C:/Windows/Sysnative/netsh.exe advfirewall set currentprofile state on' 2>&1 2012-09-18 16:27:13|3674|vcld:main(167)|lastcheckin time updated for management node 1: 2012-09-18 16:27:13 2012-09-18 16:27:18|3674|vcld:main(167)|lastcheckin time updated for management node 1: 2012-09-18 16:27:18 2012-09-18 16:27:23|3674|vcld:main(167)|lastcheckin time updated for management node 1: 2012-09-18 16:27:23 2012-09-18 16:27:28|3674|vcld:main(167)|lastcheckin time updated for management node 1: 2012-09-18 16:27:28 2012-09-18 16:27:33|3674|vcld:main(167)|lastcheckin time updated for management node 1: 2012-09-18 16:27:33 2012-09-18 16:43:02|3674|vcld:main(167)|lastcheckin time updated for management node 1: 2012-09-18 16:43:02 2012-09-18 16:43:07|3674|vcld:main(167)|lastcheckin time updated for management node 1: 2012-09-18 16:43:07 2012-09-18 16:43:12|3674|vcld:main(167)|lastcheckin time updated for management node 1: 2012-09-18 16:43:12 2012-09-18 16:43:17|3674|vcld:main(167)|lastcheckin time updated for management node 1: 2012-09-18 16:43:17 2012-09-18 16:43:20|17511|73:2|image|utils.pm:run_ssh_command(5464)|run_ssh_command output: |17511|73:2|image| Read from remote host salad02: Connection timed out 2012-09-18 16:43:20|17511|73:2|image|utils.pm:run_ssh_command(5474)|SSH command executed on salad02, command: |17511|73:2|image| /usr/bin/ssh -i /etc/vcl/vcl2.key -o StrictHostKeyChecking=no -l root -p 22 -x salad02 'C:/Windows/Sysnative/netsh.exe advfirewall set currentprofile state on' 2>&1 |17511|73:2|image| returning (255, "Read from remote host salad02:...") |17511|73:2|image| ---- WARNING ---- |17511|73:2|image| 2012-09-18 16:43:20|17511|73:2|image|Version_6.pm:firewall_enable_ssh(1340)|failed to turn on firewall after turning it off to alter SSH port exceptions, exit status: 255, output: |17511|73:2|image| Read from remote host salad02: Connection timed out |17511|73:2|image| ( 0) Version_6.pm, firewall_enable_ssh (line: 1340) |17511|73:2|image| (-1) Version_6.pm, firewall_enable_ssh_private (line: 1369) |17511|73:2|image| (-2) Windows.pm, reboot (line: 3335) |17511|73:2|image| (-3) Windows.pm, disable_pagefile (line: 2077) |17511|73:2|image| (-4) Windows.pm, pre_capture (line: 474) |17511|73:2|image| (-5) Version_6.pm, pre_capture (line: 114) I don´t understand why this is happening. My first 10 - 15 image creations were ok. This is an example: 2012-07-21 23:31:02|15645|55:55|image|Windows.pm:clean_hard_drive(6573)|cleanmgr.exe has finished 2012-07-21 23:31:02|15645|55:55|image|Version_6.pm:defragment_hard_drive(1731)|skipping hard drive defragmentation for Windows 6.x because it takes too long, returning 1 2012-07-21 23:31:02|15645|55:55|image|utils.pm:run_ssh_command(5380)|executing SSH command on salas2: |15645|55:55|image| /usr/bin/ssh -i /etc/vcl/vcl2.key -o StrictHostKeyChecking=no -l root -p 22 -x salas2 'C:/Windows/Sysnative/reg.exe add "HKEY_LOCAL_MACHINE\SYSTEM\CurrentControlSet\Control\Session Manager\Memory Management" /v PagingFiles /d "" /t REG_MULTI_SZ /f' 2>&1 2012-07-21 23:31:03|15645|55:55|image|Windows.pm:disable_pagefile(2064)|set registry key to disable pagefile 2012-07-21 23:31:03|15645|55:55|image|Windows.pm:reboot(3321)|rebooting salas2 and waiting for ssh to become active 2012-07-21 23:31:03|15645|55:55|image|Windows.pm:reboot(3330)|reboot will be attempted on salas2 2012-07-21 23:31:03|15645|55:55|image|Module.pm:code_loop_timeout(742)|waiting for salas2 to respond to SSH, maximum of 0 seconds 2012-07-21 23:31:03|15645|55:55|image|Module.pm:code_loop_timeout(759)|attempt 1: waiting for salas2 to respond to SSH 2012-07-21 23:31:04|15645|55:55|image|OS.pm:is_ssh_responding(401)|salas2 is responding to SSH, port 22: open, port 24: closed 2012-07-21 23:31:04|15645|55:55|image|Module.pm:code_loop_timeout(762)|waiting for salas2 to respond to SSH, code returned true 2012-07-21 23:31:04|15645|55:55|image|Windows.pm:get_network_configuration(5040)|network configuration has already been retrieved 2012-07-21 23:31:04|15645|55:55|image|DataStructure.pm:get_computer_private_ip_address(1557)|returning private IP address previously retrieved: 172.19.16.106 2012-07-21 23:31:04|15645|55:55|image|Windows.pm:get_network_configuration(5075)|private interface found: Local Area Connection, description: Intel(R) PRO/1000 MT Network Connection, address(es): 172.19.16.106 2012-07-21 23:31:04|15645|55:55|image|Windows.pm:get_private_ip_address(5299)|returning private IP address: 172.19.16.106 2012-07-21 23:31:04|15645|55:55|image|Version_6.pm:get_firewall_state(1398)|retrieved firewall state 2012-07-21 23:31:04|15645|55:55|image|Version_6.pm:get_firewall_state(1421)|returning firewall state: ON 2012-07-21 23:31:04|15645|55:55|image|Version_6.pm:firewall_enable_ssh(1294)|firewall is on, it will be turned off while SSH port exceptions are altered 2012-07-21 23:31:04|15645|55:55|image|utils.pm:run_ssh_command(5380)|executing SSH command on salas2: |15645|55:55|image| /usr/bin/ssh -i /etc/vcl/vcl2.key -o StrictHostKeyChecking=no -l root -p 22 -x salas2 'C:/Windows/Sysnative/netsh.exe advfirewall set currentprofile state off ; sleep 1 ; C:/Windows/Sysnative/netsh.exe advfirewall firewall delete rule name=all dir=in protocol=TCP localport=22 ; C:/Windows/Sysnative/netsh.exe advfirewall firewall add rule name="VCL: allow SSH port 22 to 172.19.16.106" description="Allows incoming SSH (TCP port 22) traffic to 172.19.16.106" protocol=TCP localport=22 action=allow enable=yes dir=in localip=172.19.16.106 remoteip=any' 2>&1 2012-07-21 23:31:06|15645|55:55|image|utils.pm:run_ssh_command(5464)|run_ssh_command output: |15645|55:55|image| Ok. |15645|55:55|image| Deleted 1 rule(s). |15645|55:55|image| Ok. |15645|55:55|image| Ok. 2012-07-21 23:31:06|15645|55:55|image|utils.pm:run_ssh_command(5478)|SSH command executed on salas2, returning (0, "Ok. Deleted 1 rule(s). Ok. Ok.") 2012-07-21 23:31:06|15645|55:55|image|Version_6.pm:firewall_enable_ssh(1320)|added firewall rule to enable SSH to address: 172.19.16.106 2012-07-21 23:31:06|15645|55:55|image|utils.pm:run_ssh_command(5380)|executing SSH command on salas2: |15645|55:55|image| /usr/bin/ssh -i /etc/vcl/vcl2.key -o StrictHostKeyChecking=no -l root -p 22 -x salas2 'C:/Windows/Sysnative/netsh.exe advfirewall set currentprofile state on' 2>&1 2012-07-21 23:31:07|15645|55:55|image|utils.pm:run_ssh_command(5464)|run_ssh_command output: |15645|55:55|image| Ok. 2012-07-21 23:31:07|15645|55:55|image|utils.pm:run_ssh_command(5478)|SSH command executed on salas2, returning (0, "Ok.") 2012-07-21 23:31:07|15645|55:55|image|Version_6.pm:firewall_enable_ssh(1336)|turned on firewall after turning it off to alter SSH port exceptions 2012-07-21 23:31:07|15645|55:55|image|utils.pm:run_ssh_command(5380)|executing SSH command on salas2: |15645|55:55|image| /usr/bin/ssh -i /etc/vcl/vcl2.key -o StrictHostKeyChecking=no -l root -p 22 -x salas2 'C:/Windows/Sysnative/sc.exe config sshd start= auto' 2>&1 2012-07-21 23:31:08|15645|55:55|image|utils.pm:run_ssh_command(5464)|run_ssh_command output: |15645|55:55|image| [SC] ChangeServiceConfig SUCCESS 2012-07-21 23:31:08|15645|55:55|image|utils.pm:run_ssh_command(5478)|SSH command executed on salas2, returning (0, "[SC] ChangeServiceConfig SUCCE...") 2012-07-21 23:31:08|15645|55:55|image|Windows.pm:set_service_startup_mode(3636)|sshd service startup mode set to auto Any help? What can be wrong? Thanks a lot Dan
