Re: Windows Capture error

Wed, 07 Feb 2018 07:55:42 -0800 

Hi Josh,

I disabled UAC. 
In subsequent attempts at image capture, I’m not even getting the VM to remove 
and reload.
It runs through the initial Windows capture tasks, then cmp1 (the computer to 
capture) goes into maintenance.
There is a reservation for the failed image capture created which shows in my 
reservations window.
The VM never gets removed or reloaded. Before capture, Cygwin is running and I 
can SSH to the VM without passwords.
I noticed that the Windows password had changed to the one specified in the 
config, but no other action appears to have happened.

Below is a log of the recent capture. Any help is appreciated.

Thanks,
-- Al Quiros
Enterprise Systems
 
 2018-02-07 10:35:17|113252|85|75|image|VMware.pm:capture|858|vmx info for VM 
cmp1 being captured:
|113252|85|75|image|VMware.pm:capture|858| : {
|113252|85|75|image|VMware.pm:capture|858| :   ".encoding" => "UTF-8",
|113252|85|75|image|VMware.pm:capture|858| :   "cleanshutdown" => "FALSE",
|113252|85|75|image|VMware.pm:capture|858| :   "config.version" => 8,
|113252|85|75|image|VMware.pm:capture|858| :   "displayname" => "New Virtual 
Machine",
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet0.address" => 
"00:50:56:00:00:02",
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet0.addresstype" => 
"static",
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet0.networkname" => "New 
VCL Private",
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet0.pcislotnumber" => 32,
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet0.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet0.virtualdev" => 
"e1000",
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet1.address" => 
"00:50:56:00:00:01",
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet1.addresstype" => 
"static",
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet1.networkname" => "New 
VCL Public",
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet1.pcislotnumber" => 33,
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet1.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "ethernet1.virtualdev" => 
"e1000",
|113252|85|75|image|VMware.pm:capture|858| :   "extendedconfigfile" => "New 
Virtual Machine.vmxf",
|113252|85|75|image|VMware.pm:capture|858| :   "floppy0.clientdevice" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "floppy0.filename" => 
"vmware-null-remote-floppy",
|113252|85|75|image|VMware.pm:capture|858| :   "floppy0.startconnected" => 
"FALSE",
|113252|85|75|image|VMware.pm:capture|858| :   "guestos" => "windows7-64",
|113252|85|75|image|VMware.pm:capture|858| :   "hpet0.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "ide1:0.devicetype" => 
"cdrom-image",
|113252|85|75|image|VMware.pm:capture|858| :   "ide1:0.filename" => 
"/vmfs/volumes/5a68e58a-1e6caf5e-c304-7cd30abf01ba/iso/SW_DVD5_Win_Pro_7_64BIT_English_Full_MLF_X15-71037.ISO",
|113252|85|75|image|VMware.pm:capture|858| :   "ide1:0.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "ide1:0.startconnected" => 
"TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "memsize" => 2048,
|113252|85|75|image|VMware.pm:capture|858| :   "migrate.hostlog" => "./New 
Virtual Machine-4d81bfc4.hlog",
|113252|85|75|image|VMware.pm:capture|858| :   "monitor.phys_bits_used" => 42,
|113252|85|75|image|VMware.pm:capture|858| :   "nvram" => "New Virtual 
Machine.nvram",
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge0.pcislotnumber" => 17,
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge0.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge4.functions" => 8,
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge4.pcislotnumber" => 21,
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge4.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge4.virtualdev" => 
"pcieRootPort",
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge5.functions" => 8,
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge5.pcislotnumber" => 22,
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge5.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge5.virtualdev" => 
"pcieRootPort",
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge6.functions" => 8,
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge6.pcislotnumber" => 23,
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge6.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge6.virtualdev" => 
"pcieRootPort",
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge7.functions" => 8,
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge7.pcislotnumber" => 24,
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge7.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "pcibridge7.virtualdev" => 
"pcieRootPort",
|113252|85|75|image|VMware.pm:capture|858| :   "replay.filename" => "",
|113252|85|75|image|VMware.pm:capture|858| :   "replay.supported" => "FALSE",
|113252|85|75|image|VMware.pm:capture|858| :   "sched.swap.derivedname" => 
"/vmfs/volumes/5a68e58a-1e6caf5e-c304-7cd30abf01ba/New Virtual Machine/New 
Virtual Machine-4d81bfc4.vswp",
|113252|85|75|image|VMware.pm:capture|858| :   "scsi0.pcislotnumber" => 160,
|113252|85|75|image|VMware.pm:capture|858| :   "scsi0.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "scsi0.saswwid" => "50 05 05 68 
97 63 c8 60",
|113252|85|75|image|VMware.pm:capture|858| :   "scsi0.virtualdev" => 
"lsisas1068",
|113252|85|75|image|VMware.pm:capture|858| :   "scsi0:0.devicetype" => 
"scsi-hardDisk",
|113252|85|75|image|VMware.pm:capture|858| :   "scsi0:0.filename" => "New 
Virtual Machine.vmdk",
|113252|85|75|image|VMware.pm:capture|858| :   "scsi0:0.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "scsi0:0.redo" => "",
|113252|85|75|image|VMware.pm:capture|858| :   "softpoweroff" => "FALSE",
|113252|85|75|image|VMware.pm:capture|858| :   "svga.guestbackedprimaryaware" 
=> "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "svga.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "svga.vramsize" => 8388608,
|113252|85|75|image|VMware.pm:capture|858| :   "tools.remindinstall" => "FALSE",
|113252|85|75|image|VMware.pm:capture|858| :   "tools.synctime" => "FALSE",
|113252|85|75|image|VMware.pm:capture|858| :   "toolscripts.afterpoweron" => 
"TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "toolscripts.afterresume" => 
"TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "toolscripts.beforepoweroff" => 
"TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "toolscripts.beforesuspend" => 
"TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   
"toolsinstallmanager.lastinstallerror" => 0,
|113252|85|75|image|VMware.pm:capture|858| :   
"toolsinstallmanager.updatecounter" => 1,
|113252|85|75|image|VMware.pm:capture|858| :   "uuid.bios" => "56 4d c5 48 97 
63 c8 65-78 d3 a7 69 97 f7 45 12",
|113252|85|75|image|VMware.pm:capture|858| :   "uuid.location" => "56 4d c5 48 
97 63 c8 65-78 d3 a7 69 97 f7 45 12",
|113252|85|75|image|VMware.pm:capture|858| :   "vc.uuid" => "52 88 1d a9 66 c1 
0b 3d-e7 98 23 c1 d1 0f 45 66",
|113252|85|75|image|VMware.pm:capture|858| :   "virtualhw.productcompatibility" 
=> "hosted",
|113252|85|75|image|VMware.pm:capture|858| :   "virtualhw.version" => 11,
|113252|85|75|image|VMware.pm:capture|858| :   "vmci0.id" => "-1745402606",
|113252|85|75|image|VMware.pm:capture|858| :   "vmci0.pcislotnumber" => 34,
|113252|85|75|image|VMware.pm:capture|858| :   "vmci0.present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :   "vmdk" => {
|113252|85|75|image|VMware.pm:capture|858| :     "scsi0:0" => {
|113252|85|75|image|VMware.pm:capture|858| :       "devicetype" => 
"scsi-hardDisk",
|113252|85|75|image|VMware.pm:capture|858| :       "mode" => "persistent",
|113252|85|75|image|VMware.pm:capture|858| :       "present" => "TRUE",
|113252|85|75|image|VMware.pm:capture|858| :       "redo" => "",
|113252|85|75|image|VMware.pm:capture|858| :       "vmdk_directory_path" => 
"/vmfs/volumes/datastore1/New Virtual Machine",
|113252|85|75|image|VMware.pm:capture|858| :       "vmdk_file_base_name" => 
"New Virtual Machine",
|113252|85|75|image|VMware.pm:capture|858| :       "vmdk_file_name" => "New 
Virtual Machine.vmdk",
|113252|85|75|image|VMware.pm:capture|858| :       "vmdk_file_path" => 
"/vmfs/volumes/datastore1/New Virtual Machine/New Virtual Machine.vmdk"
|113252|85|75|image|VMware.pm:capture|858| :     }
|113252|85|75|image|VMware.pm:capture|858| :   },
|113252|85|75|image|VMware.pm:capture|858| :   "vmotion.checkpointfbsize" => 
8388608,
|113252|85|75|image|VMware.pm:capture|858| :   
"vmotion.checkpointsvgaprimarysize" => 8388608,
|113252|85|75|image|VMware.pm:capture|858| :   "vmx_directory_path" => 
"/vmfs/volumes/datastore1/New Virtual Machine",
|113252|85|75|image|VMware.pm:capture|858| :   "vmx_file_name" => "New Virtual 
Machine.vmx"
|113252|85|75|image|VMware.pm:capture|858| : }
2018-02-07 10:35:17|113252|85|75|image|VMware.pm:capture|877|vmdk file path 
configured for VM cmp1 being captured: /vmfs/volumes/datastore1/New Virtual 
Machine/New Virtual Machine.vmdk
2018-02-07 
10:35:17|113252|85|75|image|VMware.pm:_get_datastore_names|7197|datastore 
names: datastore1
2018-02-07 
10:35:17|113252|85|75|image|VMware.pm:get_vmdk_base_directory_path_dedicated|3693|using
 VM profile datastore path as the vmdk base directory path: datastore1
2018-02-07 
10:35:17|113252|85|75|image|VMware.pm:_get_datastore_names|7197|datastore 
names: datastore1
2018-02-07 
10:35:17|113252|85|75|image|VMware.pm:get_vmdk_base_directory_path_dedicated|3693|using
 VM profile datastore path as the vmdk base directory path: datastore1
2018-02-07 
10:35:17|113252|85|75|image|VMware.pm:check_file_paths|4124|successfully 
retrieved vmdk file path components:
|113252|85|75|image|VMware.pm:check_file_paths|4124| VM profile VM path:        
        'datastore1'
|113252|85|75|image|VMware.pm:check_file_paths|4124| VM profile datastore path: 
        'datastore1'
|113252|85|75|image|VMware.pm:check_file_paths|4124| vmdk file path:            
        '/vmfs/volumes/datastore1/New Virtual Machine/New Virtual Machine.vmdk'
|113252|85|75|image|VMware.pm:check_file_paths|4124| vmdk directory path:       
        '/vmfs/volumes/datastore1/New Virtual Machine'
|113252|85|75|image|VMware.pm:check_file_paths|4124| vmdk base directory path:  
        '/vmfs/volumes/datastore1'
|113252|85|75|image|VMware.pm:check_file_paths|4124| vmdk directory name:       
        'New Virtual Machine'
|113252|85|75|image|VMware.pm:check_file_paths|4124| vmdk file name:            
        'New Virtual Machine.vmdk'
|113252|85|75|image|VMware.pm:check_file_paths|4124| vmdk file prefix:          
        'New Virtual Machine'
|113252|85|75|image|VMware.pm:check_file_paths|4124| dedicated vmdk file path:  
        '/vmfs/volumes/datastore1/New Virtual Machine/New Virtual Machine.vmdk'
|113252|85|75|image|VMware.pm:check_file_paths|4124| dedicated vmdk directory 
path:     '/vmfs/volumes/datastore1/New Virtual Machine'
|113252|85|75|image|VMware.pm:check_file_paths|4124| dedicated vmdk directory 
name:     'New Virtual Machine'
|113252|85|75|image|VMware.pm:check_file_paths|4124| shared vmdk file path:     
        
'/vmfs/volumes/datastore1/vmwarewin7-Win7test340-v0/vmwarewin7-Win7test340-v0.vmdk'
|113252|85|75|image|VMware.pm:check_file_paths|4124| shared vmdk directory 
path:        '/vmfs/volumes/datastore1/vmwarewin7-Win7test340-v0'
|113252|85|75|image|VMware.pm:check_file_paths|4124| shared vmdk directory 
name:        'vmwarewin7-Win7test340-v0'
|113252|85|75|image|VMware.pm:check_file_paths|4124| vmdk datastore URL path:   
        '/vmfs/volumes/5a68e58a-1e6caf5e-c304-7cd30abf01ba'
|113252|85|75|image|VMware.pm:check_file_paths|4124| vmdk datastore URL:        
        '5a68e58a-1e6caf5e-c304-7cd30abf01ba'
2018-02-07 10:35:17|113252|85|75|image|VMware.pm:set_vmdk_file_path|4053|set 
overridden vmdk file path: '/vmfs/volumes/datastore1/New Virtual Machine/New 
Virtual Machine.vmdk'
2018-02-07 10:35:17|113252|85|75|image|VMware.pm:capture|901|mode of vmdk to be 
captured is valid: persistent
2018-02-07 10:35:17|113252|85|75|image|Linux.pm:file_exists|1708|file or 
directory does not exist on V1: 
'/vmfs/volumes/datastore1/vmwarewin7-Win7test340-v0/vmwarewin7-Win7test340-v0.vmdk'
2018-02-07 10:35:18|113252|85|75|image|Windows.pm:reg_query|2874|retrieved 
registry data:
|113252|85|75|image|Windows.pm:reg_query|2874| key: 
'HKEY_LOCAL_MACHINE\Software\Microsoft\Windows NT\CurrentVersion'
|113252|85|75|image|Windows.pm:reg_query|2874| value: 'ProductName'
|113252|85|75|image|Windows.pm:reg_query|2874| type: REG_SZ
|113252|85|75|image|Windows.pm:reg_query|2874| data: 'Windows 7 Professional'
2018-02-07 
10:35:18|113252|85|75|image|Windows.pm:get_product_name|9231|retrieved Windows 
product name: Windows 7 Professional
2018-02-07 10:35:18|113252|85|75|image|7.pm:pre_capture|99|calling parent class 
pre_capture() subroutine
2018-02-07 10:35:18|113252|85|75|image|Version_6.pm:pre_capture|113|calling 
parent class pre_capture() subroutine
2018-02-07 10:35:18|113252|85|75|image|OS.pm:pre_capture|92|beginning common 
image capture preparation tasks
2018-02-07 10:35:18|113252|85|75|image|utils.pm:nmap_port|2115|port 22 is open 
on 10.106.144.101 (cmp1)
2018-02-07 10:35:18|113252|85|75|image|OS.pm:is_ssh_responding|1082|cmp1 is 
responding to SSH, port 22: open
2018-02-07 10:35:19|113252|85|75|image|Windows.pm:file_exists|1635|file does 
NOT exist on cmp1: 'C:/Cygwin/home/root/VCL'
2018-02-07 10:35:19|113252|85|75|image|Windows.pm:delete_file|1329|file not 
deleted because it does not exist: 'C:/Cygwin/home/root/VCL'
2018-02-07 10:35:19|113252|85|75|image|OS.pm:create_text_file|2934|created text 
file on cmp1: ~/currentimage.txt
2018-02-07 10:35:19|113252|85|75|image|OS.pm:run_stage_scripts|4540|attempting 
to execute custom scripts for 'pre_capture' stage if any exist
2018-02-07 
10:35:19|113252|85|75|image|Module.pm:get_package_hierarchy|1390|returning for 
VCL::Module::OS::Windows::Version_6::7:
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| 
VCL::Module::OS::Windows::Version_6::7
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| 
VCL::Module::OS::Windows::Version_6
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| 
VCL::Module::OS::Windows
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| VCL::Module::OS
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| VCL::Module
2018-02-07 
10:35:19|113252|85|75|image|OS.pm:get_source_configuration_directories|619|package
 source configuration directory: /usr/local/vcl-2.5/bin/../tools/Windows_7
2018-02-07 
10:35:19|113252|85|75|image|OS.pm:get_source_configuration_directories|619|package
 source configuration directory: 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6
2018-02-07 
10:35:19|113252|85|75|image|OS.pm:get_source_configuration_directories|619|package
 source configuration directory: /usr/local/vcl-2.5/bin/../tools/Windows
2018-02-07 
10:35:19|113252|85|75|image|OS.pm:get_source_configuration_directories|615|source
 configuration directory is not defined for VCL::Module::OS
2018-02-07 
10:35:19|113252|85|75|image|OS.pm:get_source_configuration_directories|615|source
 configuration directory is not defined for VCL::Module
2018-02-07 
10:35:19|113252|85|75|image|OS.pm:get_tools_file_paths|4331|attempting for find 
tools files:
|113252|85|75|image|OS.pm:get_tools_file_paths|4331| pattern: 
/Scripts/pre_capture/
|113252|85|75|image|OS.pm:get_tools_file_paths|4331| architecture: x86_64
|113252|85|75|image|OS.pm:get_tools_file_paths|4331| other architecture: x86
2018-02-07 10:35:20|113252|85|75|image|OS.pm:find_files|4197|base directory 
does not exist on cmp1: C:/Cygwin/home/root/VCL/
2018-02-07 10:35:20|113252|85|75|image|OS.pm:find_files|4217|files found under 
C:/Cygwin/home/root/VCL/ matching pattern '*': 0
2018-02-07 10:35:20|113252|85|75|image|OS.pm:find_files|4217|files found under 
/usr/local/vcl-2.5/bin/../tools/Windows/ matching pattern '*': 13
2018-02-07 10:35:20|113252|85|75|image|OS.pm:find_files|4217|files found under 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/ matching pattern '*': 3
2018-02-07 10:35:20|113252|85|75|image|OS.pm:find_files|4217|files found under 
/usr/local/vcl-2.5/bin/../tools/Windows_7/ matching pattern '*': 0
2018-02-07 
10:35:20|113252|85|75|image|OS.pm:get_tools_file_paths|4403|determined list of 
tools files intended for cmp1, pattern: /Scripts/pre_capture/, architecture: 
x86_64:
2018-02-07 
10:35:20|113252|85|75|image|OS.pm:run_stage_scripts_on_computer|4639|no custom 
scripts reside on this management node for vmwarewin7-Win7test340-v0
2018-02-07 10:35:20|113252|85|75|image|OS.pm:find_files|4217|files found under 
/usr/local/vcl-2.5/bin/../tools/ManagementNode/Scripts/pre_capture/ matching 
pattern '*': 0
2018-02-07 
10:35:20|113252|85|75|image|ManagementNode.pm:run_stage_scripts_on_management_node|488|no
 files exist in directory: 
/usr/local/vcl-2.5/bin/../tools/ManagementNode/Scripts/pre_capture
2018-02-07 10:35:20|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 'bash --login -c 
"cmd.exe /c echo %SYSTEMDRIVE%"' 2>&1'
2018-02-07 10:35:20|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'bash --login -c "cmd.exe /c echo %SYSTEMDRIVE%"', exit_status: 0, output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| C:
2018-02-07 
10:35:20|113252|85|75|image|Windows.pm:get_environment_variable_value|11374|retrieved
 value of 'SYSTEMDRIVE' environment variable on cmp1: 'C:'
2018-02-07 
10:35:20|113252|85|75|image|Windows.pm:get_reservation_info_json_file_path|12597|determined
 reservation info JSON file path file path for 
VCL::Module::OS::Windows::Version_6::7 OS module: 
C:/Users/Administrator/reservation_info.json
2018-02-07 10:35:21|113252|85|75|image|Windows.pm:file_exists|1635|file does 
NOT exist on cmp1: 'C:/Users/Administrator/reservation_info.json'
2018-02-07 10:35:21|113252|85|75|image|Windows.pm:delete_file|1329|file not 
deleted because it does not exist: 
'C:/Users/Administrator/reservation_info.json'
2018-02-07 10:35:21|113252|85|75|image|OS.pm:pre_capture|143|completed common 
image capture preparation tasks
2018-02-07 10:35:21|113252|85|75|image|Windows.pm:pre_capture|350|beginning 
Windows image capture preparation tasks on cmp1
2018-02-07 10:35:21|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 
'C:/Windows/System32/netsh.exe advfirewall firewall delete rule name=all dir=in 
protocol=TCP localport=3389' 2>&1'
2018-02-07 10:35:21|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'C:/Windows/System32/netsh.exe advfirewall firewall delete rule name=all dir=in 
protocol=TCP localport=3389', exit_status: 0, output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| Deleted 1 rule(s).
|113252|85|75|image|utils.pm:run_ssh_command|4392| Ok.
2018-02-07 
10:35:21|113252|85|75|image|Version_6.pm:firewall_disable_rdp|1139|deleted 
firewall rules which enable RDP
2018-02-07 10:35:21|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 
'C:/Windows/System32/qwinsta.exe' 2>&1'
2018-02-07 10:35:21|113252|85|75|image|utils.pm:(eval)|4264|waiting up to 60 
seconds for SSH process to finish
2018-02-07 10:35:22|113252|85|75|image|OS.pm:execute|3283|executed command: 
'C:/Windows/System32/qwinsta.exe', exit status: 0, output:
|113252|85|75|image|OS.pm:execute|3283| SESSIONNAME       USERNAME              
   ID  STATE   TYPE        DEVICE 
|113252|85|75|image|OS.pm:execute|3283| >services                               
     0  Disc                        
|113252|85|75|image|OS.pm:execute|3283|  console                                
     3  Conn                        
|113252|85|75|image|OS.pm:execute|3283|  rdp-tcp                                
 65536  Listen
2018-02-07 
10:35:22|113252|85|75|image|Module.pm:get_package_hierarchy|1390|returning for 
VCL::Module::OS::Windows::Version_6::7:
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| 
VCL::Module::OS::Windows::Version_6::7
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| 
VCL::Module::OS::Windows::Version_6
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| 
VCL::Module::OS::Windows
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| VCL::Module::OS
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| VCL::Module
2018-02-07 
10:35:22|113252|85|75|image|OS.pm:get_source_configuration_directories|619|package
 source configuration directory: /usr/local/vcl-2.5/bin/../tools/Windows_7
2018-02-07 
10:35:22|113252|85|75|image|OS.pm:get_source_configuration_directories|619|package
 source configuration directory: 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6
2018-02-07 
10:35:22|113252|85|75|image|OS.pm:get_source_configuration_directories|619|package
 source configuration directory: /usr/local/vcl-2.5/bin/../tools/Windows
2018-02-07 
10:35:22|113252|85|75|image|OS.pm:get_source_configuration_directories|615|source
 configuration directory is not defined for VCL::Module::OS
2018-02-07 
10:35:22|113252|85|75|image|OS.pm:get_source_configuration_directories|615|source
 configuration directory is not defined for VCL::Module
2018-02-07 
10:35:22|113252|85|75|image|Windows.pm:apply_security_templates|7850|checking 
if any security templates exist in: 
/usr/local/vcl-2.5/bin/../tools/Windows/Security
2018-02-07 10:35:22|113252|85|75|image|utils.pm:run_command|9322|executed 
command: 'find /usr/local/vcl-2.5/bin/../tools/Windows/Security -name "*.inf" 
2>&1 | sort -f', exit status: 0, output:
|113252|85|75|image|utils.pm:run_command|9322| 
/usr/local/vcl-2.5/bin/../tools/Windows/Security/Windows_Security_Policies.inf
2018-02-07 
10:35:22|113252|85|75|image|Windows.pm:apply_security_templates|7859|ran find, 
output:
|113252|85|75|image|Windows.pm:apply_security_templates|7859| 
/usr/local/vcl-2.5/bin/../tools/Windows/Security/Windows_Security_Policies.inf
2018-02-07 
10:35:22|113252|85|75|image|Windows.pm:apply_security_templates|7850|checking 
if any security templates exist in: 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security
2018-02-07 10:35:22|113252|85|75|image|utils.pm:run_command|9322|executed 
command: 'find /usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security -name 
"*.inf" 2>&1 | sort -f', exit status: 0, output:
|113252|85|75|image|utils.pm:run_command|9322| 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/My_Computer_Reg_Perms.inf
|113252|85|75|image|utils.pm:run_command|9322| 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/Security_Center_Reg_Perms.inf
|113252|85|75|image|utils.pm:run_command|9322| 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/Sysprep_Reg_Perms.inf
2018-02-07 
10:35:22|113252|85|75|image|Windows.pm:apply_security_templates|7859|ran find, 
output:
|113252|85|75|image|Windows.pm:apply_security_templates|7859| 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/My_Computer_Reg_Perms.inf
|113252|85|75|image|Windows.pm:apply_security_templates|7859| 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/Security_Center_Reg_Perms.inf
|113252|85|75|image|Windows.pm:apply_security_templates|7859| 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/Sysprep_Reg_Perms.inf
2018-02-07 
10:35:22|113252|85|75|image|Windows.pm:apply_security_templates|7850|checking 
if any security templates exist in: 
/usr/local/vcl-2.5/bin/../tools/Windows_7/Security
2018-02-07 10:35:22|113252|85|75|image|utils.pm:run_command|9322|executed 
command: 'find /usr/local/vcl-2.5/bin/../tools/Windows_7/Security -name "*.inf" 
2>&1 | sort -f', exit status: 0, output:
|113252|85|75|image|utils.pm:run_command|9322| find: 
‘/usr/local/vcl-2.5/bin/../tools/Windows_7/Security’: No such file or directory
2018-02-07 
10:35:22|113252|85|75|image|Windows.pm:apply_security_templates|7855|path does 
not exist: /usr/local/vcl-2.5/bin/../tools/Windows_7/Security
2018-02-07 
10:35:22|113252|85|75|image|Windows.pm:apply_security_templates|7874|security 
templates will be applied in this order:
|113252|85|75|image|Windows.pm:apply_security_templates|7874| 
/usr/local/vcl-2.5/bin/../tools/Windows/Security/Windows_Security_Policies.inf
|113252|85|75|image|Windows.pm:apply_security_templates|7874| 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/My_Computer_Reg_Perms.inf
|113252|85|75|image|Windows.pm:apply_security_templates|7874| 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/Security_Center_Reg_Perms.inf
|113252|85|75|image|Windows.pm:apply_security_templates|7874| 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/Sysprep_Reg_Perms.inf
2018-02-07 
10:35:22|113252|85|75|image|Windows.pm:create_directory|1269|attempting to 
create directory: 'C:/Cygwin/home/root/VCL/Security'
2018-02-07 10:35:22|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 'cmd.exe /c "mkdir 
\"C:/Cygwin/home/root/VCL/Security\""' 2>&1'
2018-02-07 10:35:22|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'cmd.exe /c "mkdir \"C:/Cygwin/home/root/VCL/Security\""', exit_status: 0, 
output:
2018-02-07 10:35:22|113252|85|75|image|Windows.pm:create_directory|1275|created 
directory on cmp1: 'C:/Cygwin/home/root/VCL/Security'
2018-02-07 10:35:23|113252|85|75|image|Windows.pm:file_exists|1644|file exists 
on cmp1: 'C:/Cygwin/home/root/VCL/Security'
2018-02-07 
10:35:23|113252|85|75|image|Windows.pm:create_directory|1296|verified directory 
exists on cmp1: 'C:/Cygwin/home/root/VCL/Security'
2018-02-07 
10:35:23|113252|85|75|image|Windows.pm:apply_security_templates|7895|attempting 
to copy file to: 
C:/Cygwin/home/root/VCL/Security/1_Windows_Security_Policies.inf
2018-02-07 10:35:23|113252|85|75|image|utils.pm:run_scp_command|4531|attempting 
to copy file via SCP: 
'/usr/local/vcl-2.5/bin/../tools/Windows/Security/Windows_Security_Policies.inf'
 --> 
'10.106.144.101:C:/Cygwin/home/root/VCL/Security/1_Windows_Security_Policies.inf'
2018-02-07 10:35:23|113252|85|75|image|utils.pm:run_scp_command|4569|copied 
file via SCP: 
'/usr/local/vcl-2.5/bin/../tools/Windows/Security/Windows_Security_Policies.inf'
 --> 
'10.106.144.101:C:/Cygwin/home/root/VCL/Security/1_Windows_Security_Policies.inf'
2018-02-07 
10:35:23|113252|85|75|image|Windows.pm:apply_security_templates|7897|copied 
file: cmp1:C:/Cygwin/home/root/VCL/Security/1_Windows_Security_Policies.inf
2018-02-07 10:35:24|113252|85|75|image|Windows.pm:file_exists|1635|file does 
NOT exist on cmp1: '$SYSTEMROOT/security/Logs/1_Windows_Security_Policies.log'
2018-02-07 10:35:24|113252|85|75|image|Windows.pm:delete_file|1329|file not 
deleted because it does not exist: 
'$SYSTEMROOT/security/Logs/1_Windows_Security_Policies.log'
2018-02-07 
10:35:25|113252|85|75|image|Windows.pm:apply_security_templates|7926|ran 
secedit.exe to apply Windows_Security_Policies.inf
2018-02-07 
10:35:25|113252|85|75|image|Windows.pm:apply_security_templates|7895|attempting 
to copy file to: C:/Cygwin/home/root/VCL/Security/2_My_Computer_Reg_Perms.inf
2018-02-07 10:35:25|113252|85|75|image|utils.pm:run_scp_command|4531|attempting 
to copy file via SCP: 
'/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/My_Computer_Reg_Perms.inf'
 --> 
'10.106.144.101:C:/Cygwin/home/root/VCL/Security/2_My_Computer_Reg_Perms.inf'
2018-02-07 10:35:25|113252|85|75|image|utils.pm:run_scp_command|4569|copied 
file via SCP: 
'/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/My_Computer_Reg_Perms.inf'
 --> 
'10.106.144.101:C:/Cygwin/home/root/VCL/Security/2_My_Computer_Reg_Perms.inf'
2018-02-07 
10:35:25|113252|85|75|image|Windows.pm:apply_security_templates|7897|copied 
file: cmp1:C:/Cygwin/home/root/VCL/Security/2_My_Computer_Reg_Perms.inf
2018-02-07 10:35:26|113252|85|75|image|Windows.pm:file_exists|1635|file does 
NOT exist on cmp1: '$SYSTEMROOT/security/Logs/2_My_Computer_Reg_Perms.log'
2018-02-07 10:35:26|113252|85|75|image|Windows.pm:delete_file|1329|file not 
deleted because it does not exist: 
'$SYSTEMROOT/security/Logs/2_My_Computer_Reg_Perms.log'
2018-02-07 
10:35:27|113252|85|75|image|Windows.pm:apply_security_templates|7926|ran 
secedit.exe to apply My_Computer_Reg_Perms.inf
2018-02-07 
10:35:27|113252|85|75|image|Windows.pm:apply_security_templates|7895|attempting 
to copy file to: 
C:/Cygwin/home/root/VCL/Security/3_Security_Center_Reg_Perms.inf
2018-02-07 10:35:27|113252|85|75|image|utils.pm:run_scp_command|4531|attempting 
to copy file via SCP: 
'/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/Security_Center_Reg_Perms.inf'
 --> 
'10.106.144.101:C:/Cygwin/home/root/VCL/Security/3_Security_Center_Reg_Perms.inf'
2018-02-07 10:35:28|113252|85|75|image|utils.pm:run_scp_command|4569|copied 
file via SCP: 
'/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/Security_Center_Reg_Perms.inf'
 --> 
'10.106.144.101:C:/Cygwin/home/root/VCL/Security/3_Security_Center_Reg_Perms.inf'
2018-02-07 
10:35:28|113252|85|75|image|Windows.pm:apply_security_templates|7897|copied 
file: cmp1:C:/Cygwin/home/root/VCL/Security/3_Security_Center_Reg_Perms.inf
2018-02-07 10:35:29|113252|85|75|image|Windows.pm:file_exists|1635|file does 
NOT exist on cmp1: '$SYSTEMROOT/security/Logs/3_Security_Center_Reg_Perms.log'
2018-02-07 10:35:29|113252|85|75|image|Windows.pm:delete_file|1329|file not 
deleted because it does not exist: 
'$SYSTEMROOT/security/Logs/3_Security_Center_Reg_Perms.log'
2018-02-07 
10:35:29|113252|85|75|image|Windows.pm:apply_security_templates|7926|ran 
secedit.exe to apply Security_Center_Reg_Perms.inf
2018-02-07 
10:35:29|113252|85|75|image|Windows.pm:apply_security_templates|7895|attempting 
to copy file to: C:/Cygwin/home/root/VCL/Security/4_Sysprep_Reg_Perms.inf
2018-02-07 10:35:29|113252|85|75|image|utils.pm:run_scp_command|4531|attempting 
to copy file via SCP: 
'/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/Sysprep_Reg_Perms.inf'
 --> '10.106.144.101:C:/Cygwin/home/root/VCL/Security/4_Sysprep_Reg_Perms.inf'
2018-02-07 10:35:30|113198|||vcld|vcld:main|179|lastcheckin time updated for 
management node 1: 2018-02-07 10:35:30
2018-02-07 10:35:30|113252|85|75|image|utils.pm:run_scp_command|4569|copied 
file via SCP: 
'/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/Security/Sysprep_Reg_Perms.inf'
 --> '10.106.144.101:C:/Cygwin/home/root/VCL/Security/4_Sysprep_Reg_Perms.inf'
2018-02-07 
10:35:30|113252|85|75|image|Windows.pm:apply_security_templates|7897|copied 
file: cmp1:C:/Cygwin/home/root/VCL/Security/4_Sysprep_Reg_Perms.inf
2018-02-07 10:35:31|113252|85|75|image|Windows.pm:file_exists|1635|file does 
NOT exist on cmp1: '$SYSTEMROOT/security/Logs/4_Sysprep_Reg_Perms.log'
2018-02-07 10:35:31|113252|85|75|image|Windows.pm:delete_file|1329|file not 
deleted because it does not exist: 
'$SYSTEMROOT/security/Logs/4_Sysprep_Reg_Perms.log'
2018-02-07 
10:35:32|113252|85|75|image|Windows.pm:apply_security_templates|7926|ran 
secedit.exe to apply Sysprep_Reg_Perms.inf
2018-02-07 10:35:32|113252|85|75|image|Windows.pm:set_password|2288|setting 
password of Administrator to 'cl0udy' on cmp1, command:
|113252|85|75|image|Windows.pm:set_password|2288| C:/Windows/System32/net.exe 
user Administrator "cl0udy"
2018-02-07 10:35:32|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 
'C:/Windows/System32/net.exe user Administrator "cl0udy"' 2>&1'
2018-02-07 10:35:32|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'C:/Windows/System32/net.exe user Administrator "cl0udy"', exit_status: 0, 
output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| The command completed 
successfully.
2018-02-07 10:35:32|113252|85|75|image|Windows.pm:set_password|2290|password 
changed to 'cl0udy' for user 'Administrator' on cmp1, command: 
'C:/Windows/System32/net.exe user Administrator "cl0udy"', output:
|113252|85|75|image|Windows.pm:set_password|2290| The command completed 
successfully.
2018-02-07 
10:35:32|113252|85|75|image|Windows.pm:get_service_configuration|4336|retrieving
 service configuration information from the registry
2018-02-07 10:35:32|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 'cygpath.exe -m /' 
2>&1'
2018-02-07 10:35:33|113252|85|75|image|OS.pm:execute|3283|executed command: 
'cygpath.exe -m /', exit status: 0, output:
|113252|85|75|image|OS.pm:execute|3283| C:/cygwin64
2018-02-07 
10:35:33|113252|85|75|image|Windows.pm:get_cygwin_installation_directory_path|12485|determined
 Cygwin installation directory path on cmp1: C:/cygwin64
2018-02-07 10:35:33|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 'cmd.exe /c "del /Q 
\"C:\\cygwin64\\tmp\\services_cmp1.reg.tmp\" 2>NUL & 
C:/Windows/System32/reg.exe EXPORT 
HKEY_LOCAL_MACHINE\SYSTEM\CurrentControlSet\Services 
\"C:\\cygwin64\\tmp\\services_cmp1.reg.tmp\" && type 
\"C:\\cygwin64\\tmp\\services_cmp1.reg.tmp\" > 
\"C:\\cygwin64\\tmp\\services_cmp1.reg\" && del /Q 
\"C:\\cygwin64\\tmp\\services_cmp1.reg.tmp\""' 2>&1'
2018-02-07 10:35:33|113252|85|75|image|OS.pm:execute|3283|executed command: 
'cmd.exe /c "del /Q \"C:\\cygwin64\\tmp\\services_cmp1.reg.tmp\" 2>NUL & 
C:/Windows/System32/reg.exe EXPORT 
HKEY_LOCAL_MACHINE\SYSTEM\CurrentControlSet\Services 
\"C:\\cygwin64\\tmp\\services_cmp1.reg.tmp\" && type 
\"C:\\cygwin64\\tmp\\services_cmp1.reg.tmp\" > 
\"C:\\cygwin64\\tmp\\services_cmp1.reg\" && del /Q 
\"C:\\cygwin64\\tmp\\services_cmp1.reg.tmp\""', exit status: 0, output:
|113252|85|75|image|OS.pm:execute|3283| The operation completed successfully.
2018-02-07 10:35:33|113252|85|75|image|Windows.pm:reg_export|3227|exported 
registry key HKEY_LOCAL_MACHINE\SYSTEM\CurrentControlSet\Services to file: 
C:\\cygwin64\\tmp\\services_cmp1.reg
2018-02-07 10:35:33|113252|85|75|image|utils.pm:run_scp_command|4531|attempting 
to copy file via SCP: '10.106.144.101:"C:/cygwin64/tmp/services_cmp1.reg"' --> 
'/tmp/vcl/services_cmp1.reg'
2018-02-07 10:35:34|113252|85|75|image|utils.pm:run_scp_command|4569|copied 
file via SCP: '10.106.144.101:"C:/cygwin64/tmp/services_cmp1.reg"' --> 
'/tmp/vcl/services_cmp1.reg'
2018-02-07 10:35:34|113252|85|75|image|OS.pm:copy_file_from|4099|copied file 
from cmp1 to management node: cmp1:'C:/cygwin64/tmp/services_cmp1.reg' --> 
'/tmp/vcl/services_cmp1.reg'
2018-02-07 
10:35:34|113252|85|75|image|ManagementNode.pm:get_file_contents|317|retrieved 
contents of file on mgtvcl01: /tmp/vcl/services_cmp1.reg (34121 lines)
2018-02-07 10:35:34|113252|85|75|image|Windows.pm:file_exists|1644|file exists 
on cmp1: 'C:/cygwin64/tmp/services_cmp1.reg'
2018-02-07 10:35:34|113252|85|75|image|Windows.pm:delete_file|1336|attempting 
to delete file: 'C:/cygwin64/tmp/services_cmp1.reg'
2018-02-07 10:35:36|113252|85|75|image|Windows.pm:file_exists|1635|file does 
NOT exist on cmp1: 'C:/cygwin64/tmp/services_cmp1.reg'
2018-02-07 10:35:36|113252|85|75|image|Windows.pm:delete_file|1400|deleted 
file: 'C:/cygwin64/tmp/services_cmp1.reg'
2018-02-07 10:35:36|113252|85|75|image|Linux.pm:delete_file|1777|deleted 
'/tmp/vcl/services_cmp1.reg' on mgtvcl01
2018-02-07 
10:35:36|113252|85|75|image|Windows.pm:get_services_using_login_id|4427|services
 found using login ID 'Administrator' (0):
2018-02-07 10:35:36|113198|||vcld|vcld:main|179|lastcheckin time updated for 
management node 1: 2018-02-07 10:35:36
2018-02-07 
10:35:37|113252|85|75|image|Windows.pm:get_scheduled_task_info|4591|found 81 
scheduled tasks
2018-02-07 10:35:37|113252|85|75|image|Windows.pm:set_password|2331|changed 
password for user: Administrator
2018-02-07 10:35:37|113252|85|75|image|Windows.pm:set_password|2288|setting 
password of root to 'cl0udy' on cmp1, command:
|113252|85|75|image|Windows.pm:set_password|2288| C:/Windows/System32/net.exe 
user root "cl0udy"
2018-02-07 10:35:37|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 
'C:/Windows/System32/net.exe user root "cl0udy"' 2>&1'
2018-02-07 10:35:38|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'C:/Windows/System32/net.exe user root "cl0udy"', exit_status: 0, output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| The command completed 
successfully.
2018-02-07 10:35:38|113252|85|75|image|Windows.pm:set_password|2290|password 
changed to 'cl0udy' for user 'root' on cmp1, command: 
'C:/Windows/System32/net.exe user root "cl0udy"', output:
|113252|85|75|image|Windows.pm:set_password|2290| The command completed 
successfully.
2018-02-07 
10:35:38|113252|85|75|image|Windows.pm:get_services_using_login_id|4427|services
 found using login ID 'root' (1): sshd
2018-02-07 10:35:38|113252|85|75|image|Windows.pm:set_password|2310|sshd 
service is configured to run as root, updating service credentials
2018-02-07 10:35:38|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 
'C:/Windows/System32/sc.exe config sshd obj= ".\root" password= "cl0udy"' 2>&1'
2018-02-07 10:35:38|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'C:/Windows/System32/sc.exe config sshd obj= ".\root" password= "cl0udy"', 
exit_status: 0, output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| [SC] ChangeServiceConfig 
SUCCESS
2018-02-07 
10:35:38|113252|85|75|image|Windows.pm:set_service_credentials|4295|changed 
logon credentials for 'sshd' service to root (cl0udy) on cmp1
2018-02-07 10:35:38|113252|85|75|image|Windows.pm:set_password|2331|changed 
password for user: root
2018-02-07 10:35:38|113252|85|75|image|Windows.pm:delete_user|2200|attempting 
to delete user admin from cmp1
2018-02-07 10:35:38|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 
'C:/Windows/System32/net.exe user admin /DELETE' 2>&1'
2018-02-07 10:35:39|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'C:/Windows/System32/net.exe user admin /DELETE', exit_status: 2, output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| The user name could not be 
found.
|113252|85|75|image|utils.pm:run_ssh_command|4392| More help is available by 
typing NET HELPMSG 2221.
2018-02-07 10:35:39|113252|85|75|image|Windows.pm:delete_user|2209|user admin 
was not deleted because user does not exist
2018-02-07 10:35:39|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 
'C:/Windows/System32/net.exe localgroup "Administrators"' 2>&1'
2018-02-07 10:35:39|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'C:/Windows/System32/net.exe localgroup "Administrators"', exit_status: 0, 
output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| Alias name     Administrators
|113252|85|75|image|utils.pm:run_ssh_command|4392| Comment        
Administrators have complete and unrestricted access to the computer/domain
|113252|85|75|image|utils.pm:run_ssh_command|4392| Members
|113252|85|75|image|utils.pm:run_ssh_command|4392| 
-------------------------------------------------------------------------------
|113252|85|75|image|utils.pm:run_ssh_command|4392| Administrator
|113252|85|75|image|utils.pm:run_ssh_command|4392| cyg_server
|113252|85|75|image|utils.pm:run_ssh_command|4392| root
|113252|85|75|image|utils.pm:run_ssh_command|4392| The command completed 
successfully.
2018-02-07 
10:35:39|113252|85|75|image|Windows.pm:get_group_members|2169|retrieve members 
of Administrators local group on cmp1: Administrator, cyg_server, root
2018-02-07 
10:35:39|113252|85|75|image|Windows.pm:remove_user_from_group|2075|admin is not 
a member of Administrators local group on cmp1
2018-02-07 10:35:39|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 
'C:/Windows/System32/net.exe localgroup "Remote Desktop Users"' 2>&1'
2018-02-07 10:35:40|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'C:/Windows/System32/net.exe localgroup "Remote Desktop Users"', exit_status: 
0, output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| Alias name     Remote 
Desktop Users
|113252|85|75|image|utils.pm:run_ssh_command|4392| Comment        Members in 
this group are granted the right to logon remotely
|113252|85|75|image|utils.pm:run_ssh_command|4392| Members
|113252|85|75|image|utils.pm:run_ssh_command|4392| 
-------------------------------------------------------------------------------
|113252|85|75|image|utils.pm:run_ssh_command|4392| The command completed 
successfully.
2018-02-07 
10:35:40|113252|85|75|image|Windows.pm:get_group_members|2169|retrieve members 
of Remote Desktop Users local group on cmp1:
2018-02-07 
10:35:40|113252|85|75|image|Windows.pm:remove_user_from_group|2069|admin not 
removed from Remote Desktop Users local group on cmp1, group is either empty or 
membership could not be retrieved
2018-02-07 10:35:40|113252|85|75|image|Windows.pm:file_exists|1635|file does 
NOT exist on cmp1: 'C:/Documents and Settings/admin'
2018-02-07 10:35:40|113252|85|75|image|Windows.pm:delete_file|1329|file not 
deleted because it does not exist: 'C:/Documents and Settings/admin'
2018-02-07 10:35:40|113252|85|75|image|Windows.pm:delete_user|2225|deleted 
profile for user admin from cmp1
2018-02-07 10:35:40|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 'echo | 
C:/Windows/System32/Wbem/wmic.exe COMPUTERSYSTEM GET PartOfDomain,Domain 
/FORMAT:LIST' 2>&1'
2018-02-07 10:35:41|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'echo | C:/Windows/System32/Wbem/wmic.exe COMPUTERSYSTEM GET 
PartOfDomain,Domain /FORMAT:LIST', exit_status: 0, output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| Domain=WORKGROUP
|113252|85|75|image|utils.pm:run_ssh_command|4392| PartOfDomain=FALSE
2018-02-07 
10:35:41|113252|85|75|image|Windows.pm:ad_get_current_domain|14318|cmp1 is NOT 
joined to a domain, output:
|113252|85|75|image|Windows.pm:ad_get_current_domain|14318| Domain=WORKGROUP
|113252|85|75|image|Windows.pm:ad_get_current_domain|14318| PartOfDomain=FALSE
2018-02-07 10:35:41|113252|85|75|image|Windows.pm:set_file_owner|1705|set root 
as the owner of /home/root, files and directories modified: 12
2018-02-07 
10:35:41|113252|85|75|image|OS.pm:get_public_interface_name|1961|attempting to 
determine public interface name, no cache: 0, ignore error: 0
2018-02-07 10:35:41|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 
'C:/Windows/System32/netsh.exe interface ip show address name="Local Area 
Connection 2"' 2>&1'
2018-02-07 10:35:42|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'C:/Windows/System32/netsh.exe interface ip show address name="Local Area 
Connection 2"', exit_status: 0, output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| Configuration for interface 
"Local Area Connection 2"
|113252|85|75|image|utils.pm:run_ssh_command|4392|     DHCP enabled:            
             Yes
|113252|85|75|image|utils.pm:run_ssh_command|4392|     IP Address:              
             10.106.136.39
|113252|85|75|image|utils.pm:run_ssh_command|4392|     Subnet Prefix:           
             10.106.136.0/21 (mask 255.255.248.0)
|113252|85|75|image|utils.pm:run_ssh_command|4392|     Default Gateway:         
             10.106.136.1
|113252|85|75|image|utils.pm:run_ssh_command|4392|     Gateway Metric:          
             0
|113252|85|75|image|utils.pm:run_ssh_command|4392|     InterfaceMetric:         
             10
2018-02-07 10:35:42|113252|85|75|image|Windows.pm:is_dhcp_enabled|6314|DHCP is 
enabled on interface 'Local Area Connection 2'
2018-02-07 10:35:42|113252|85|75|image|Windows.pm:enable_dhcp|6254|DHCP is 
already enabled on interface 'Local Area Connection 2'
2018-02-07 
10:35:42|113252|85|75|image|Module.pm:get_package_hierarchy|1390|returning for 
VCL::Module::OS::Windows::Version_6::7:
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| 
VCL::Module::OS::Windows::Version_6::7
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| 
VCL::Module::OS::Windows::Version_6
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| 
VCL::Module::OS::Windows
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| VCL::Module::OS
|113252|85|75|image|Module.pm:get_package_hierarchy|1390| VCL::Module
2018-02-07 
10:35:42|113252|85|75|image|OS.pm:get_source_configuration_directories|619|package
 source configuration directory: /usr/local/vcl-2.5/bin/../tools/Windows_7
2018-02-07 
10:35:42|113252|85|75|image|OS.pm:get_source_configuration_directories|619|package
 source configuration directory: 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6
2018-02-07 
10:35:42|113252|85|75|image|OS.pm:get_source_configuration_directories|619|package
 source configuration directory: /usr/local/vcl-2.5/bin/../tools/Windows
2018-02-07 
10:35:42|113252|85|75|image|OS.pm:get_source_configuration_directories|615|source
 configuration directory is not defined for VCL::Module::OS
2018-02-07 
10:35:42|113252|85|75|image|OS.pm:get_source_configuration_directories|615|source
 configuration directory is not defined for VCL::Module
2018-02-07 10:35:42|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 
'C:/Windows/System32/schtasks.exe /Delete /F /TN "VCL Startup Configuration"' 
2>&1'
2018-02-07 10:35:42|113198|||vcld|vcld:main|179|lastcheckin time updated for 
management node 1: 2018-02-07 10:35:42
2018-02-07 10:35:42|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'C:/Windows/System32/schtasks.exe /Delete /F /TN "VCL Startup Configuration"', 
exit_status: 1, output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| ERROR: The system cannot 
find the file specified.
2018-02-07 
10:35:42|113252|85|75|image|Windows.pm:delete_scheduled_task|3555|scheduled 
task 'VCL Startup Configuration' does not exist on cmp1
2018-02-07 
10:35:42|113252|85|75|image|Windows.pm:delete_capture_configuration_files|6398|attempting
 to remove old configuration directory if it exists: C:/Cygwin/home/root/VCL
2018-02-07 10:35:43|113252|85|75|image|Windows.pm:file_exists|1644|file exists 
on cmp1: 'C:/Cygwin/home/root/VCL'
2018-02-07 10:35:43|113252|85|75|image|Windows.pm:delete_file|1336|attempting 
to delete file: 'C:/Cygwin/home/root/VCL'
2018-02-07 10:35:44|113252|85|75|image|Windows.pm:file_exists|1635|file does 
NOT exist on cmp1: 'C:/Cygwin/home/root/VCL'
2018-02-07 10:35:44|113252|85|75|image|Windows.pm:delete_file|1400|deleted 
file: 'C:/Cygwin/home/root/VCL'
2018-02-07 
10:35:44|113252|85|75|image|Windows.pm:create_directory|1269|attempting to 
create directory: 'C:/Cygwin/home/root/VCL'
2018-02-07 10:35:44|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 'cmd.exe /c "mkdir 
\"C:/Cygwin/home/root/VCL\""' 2>&1'
2018-02-07 10:35:44|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'cmd.exe /c "mkdir \"C:/Cygwin/home/root/VCL\""', exit_status: 0, output:
2018-02-07 10:35:44|113252|85|75|image|Windows.pm:create_directory|1275|created 
directory on cmp1: 'C:/Cygwin/home/root/VCL'
2018-02-07 10:35:45|113252|85|75|image|Windows.pm:file_exists|1644|file exists 
on cmp1: 'C:/Cygwin/home/root/VCL'
2018-02-07 
10:35:45|113252|85|75|image|Windows.pm:create_directory|1296|verified directory 
exists on cmp1: 'C:/Cygwin/home/root/VCL'
2018-02-07 
10:35:45|113252|85|75|image|Windows.pm:copy_capture_configuration_files|7013|copying
 image capture configuration files from /usr/local/vcl-2.5/bin/../tools/Windows 
to cmp1
2018-02-07 10:35:45|113252|85|75|image|utils.pm:run_scp_command|4531|attempting 
to copy file via SCP: '/usr/local/vcl-2.5/bin/../tools/Windows/*' --> 
'10.106.144.101:C:/Cygwin/home/root/VCL'
2018-02-07 10:35:46|113252|85|75|image|utils.pm:run_scp_command|4569|copied 
file via SCP: '/usr/local/vcl-2.5/bin/../tools/Windows/*' --> 
'10.106.144.101:C:/Cygwin/home/root/VCL'
2018-02-07 
10:35:46|113252|85|75|image|Windows.pm:copy_capture_configuration_files|7015|copied
 /usr/local/vcl-2.5/bin/../tools/Windows directory to 
cmp1:C:/Cygwin/home/root/VCL
2018-02-07 
10:35:46|113252|85|75|image|Windows.pm:copy_capture_configuration_files|7017|setting
 permissions of C:/Cygwin/home/root/VCL to 777 on cmp1
2018-02-07 10:35:46|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 '/usr/bin/chmod.exe 
-R 777 C:/Cygwin/home/root/VCL' 2>&1'
2018-02-07 10:35:47|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'/usr/bin/chmod.exe -R 777 C:/Cygwin/home/root/VCL', exit_status: 0, output:
2018-02-07 
10:35:47|113252|85|75|image|Windows.pm:copy_capture_configuration_files|7013|copying
 image capture configuration files from 
/usr/local/vcl-2.5/bin/../tools/Windows_Version_6 to cmp1
2018-02-07 10:35:47|113252|85|75|image|utils.pm:run_scp_command|4531|attempting 
to copy file via SCP: '/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/*' --> 
'10.106.144.101:C:/Cygwin/home/root/VCL'
2018-02-07 10:35:48|113252|85|75|image|utils.pm:run_scp_command|4569|copied 
file via SCP: '/usr/local/vcl-2.5/bin/../tools/Windows_Version_6/*' --> 
'10.106.144.101:C:/Cygwin/home/root/VCL'
2018-02-07 
10:35:48|113252|85|75|image|Windows.pm:copy_capture_configuration_files|7015|copied
 /usr/local/vcl-2.5/bin/../tools/Windows_Version_6 directory to 
cmp1:C:/Cygwin/home/root/VCL
2018-02-07 
10:35:48|113252|85|75|image|Windows.pm:copy_capture_configuration_files|7017|setting
 permissions of C:/Cygwin/home/root/VCL to 777 on cmp1
2018-02-07 10:35:48|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 '/usr/bin/chmod.exe 
-R 777 C:/Cygwin/home/root/VCL' 2>&1'
2018-02-07 10:35:48|113198|||vcld|vcld:main|179|lastcheckin time updated for 
management node 1: 2018-02-07 10:35:48
2018-02-07 10:35:48|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'/usr/bin/chmod.exe -R 777 C:/Cygwin/home/root/VCL', exit_status: 0, output:
2018-02-07 
10:35:48|113252|85|75|image|Windows.pm:copy_capture_configuration_files|7013|copying
 image capture configuration files from 
/usr/local/vcl-2.5/bin/../tools/Windows_7 to cmp1
2018-02-07 10:35:48|113252|85|75|image|utils.pm:run_scp_command|4531|attempting 
to copy file via SCP: '/usr/local/vcl-2.5/bin/../tools/Windows_7/*' --> 
'10.106.144.101:C:/Cygwin/home/root/VCL'
2018-02-07 10:35:49|113252|85|75|image|utils.pm:run_scp_command|4569|copied 
file via SCP: '/usr/local/vcl-2.5/bin/../tools/Windows_7/*' --> 
'10.106.144.101:C:/Cygwin/home/root/VCL'
2018-02-07 
10:35:49|113252|85|75|image|Windows.pm:copy_capture_configuration_files|7015|copied
 /usr/local/vcl-2.5/bin/../tools/Windows_7 directory to 
cmp1:C:/Cygwin/home/root/VCL
2018-02-07 
10:35:49|113252|85|75|image|Windows.pm:copy_capture_configuration_files|7017|setting
 permissions of C:/Cygwin/home/root/VCL to 777 on cmp1
2018-02-07 10:35:49|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 '/usr/bin/chmod.exe 
-R 777 C:/Cygwin/home/root/VCL' 2>&1'
2018-02-07 10:35:49|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'/usr/bin/chmod.exe -R 777 C:/Cygwin/home/root/VCL', exit_status: 0, output:
2018-02-07 
10:35:49|113252|85|75|image|Windows.pm:delete_files_by_pattern|1485|attempting 
to delete files on cmp1, base directory: 'C:/Cygwin/home/root/VCL', pattern: 
'.*\.svn.*', max depth: unlimited
2018-02-07 10:35:50|113252|85|75|image|Windows.pm:set_file_owner|1705|set root 
as the owner of C:/Cygwin/home/root/VCL, files and directories modified: 32
2018-02-07 
10:35:51|113252|85|75|image|Windows.pm:search_and_replace_in_files|6918|found 
files matching pattern 'WINDOWS_ROOT_PASSWORD' in C:/Cygwin/home/root/VCL:
|113252|85|75|image|Windows.pm:search_and_replace_in_files|6918| 
C:/Cygwin/home/root/VCL/Scripts/autologon_enable.cmd
2018-02-07 
10:35:51|113252|85|75|image|Windows.pm:search_and_replace_in_files|6945|replaced
 'WINDOWS_ROOT_PASSWORD' with 'cl0udy' in 
C:/Cygwin/home/root/VCL/Scripts/autologon_enable.cmd
2018-02-07 10:35:52|113252|85|75|image|OS.pm:get_file_contents|3088|retrieved 
55 lines from file on cmp1: 
'C:/Cygwin/home/root/VCL/Scripts/autologon_enable.cmd'
2018-02-07 
10:35:52|113252|85|75|image|Windows.pm:create_directory|1269|attempting to 
create directory: 'C:/Cygwin/home/root/VCL/Scripts'
2018-02-07 10:35:52|113252|85|75|image|utils.pm:run_ssh_command|4243|executing 
SSH command on 10.106.144.101 (cmp1): '/usr/bin/ssh  -o 
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o 
ConnectionAttempts=1 -o ConnectTimeout=30 -o BatchMode=no -o 
PasswordAuthentication=no -l root -p 22 -x 10.106.144.101 'cmd.exe /c "mkdir 
\"C:/Cygwin/home/root/VCL/Scripts\""' 2>&1'
2018-02-07 10:35:52|113252|85|75|image|utils.pm:run_ssh_command|4392|command: 
'cmd.exe /c "mkdir \"C:/Cygwin/home/root/VCL/Scripts\""', exit_status: 1, 
output:
|113252|85|75|image|utils.pm:run_ssh_command|4392| A subdirectory or file 
C:/Cygwin/home/root/VCL/Scripts already exists.
2018-02-07 
10:35:52|113252|85|75|image|Windows.pm:create_directory|1283|directory already 
exists on cmp1: 'C:/Cygwin/home/root/VCL/Scripts'
2018-02-07 10:35:53|113252|85|75|image|OS.pm:create_text_file|2934|created text 
file on cmp1: C:/Cygwin/home/root/VCL/Scripts/autologon_enable.cmd
2018-02-07 
10:35:53|113252|85|75|image|OS.pm:set_text_file_line_endings|3034|set 
Windows-style line endings for 
C:/Cygwin/home/root/VCL/Scripts/autologon_enable.cmd on cmp1
2018-02-07 
10:35:53|113252|85|75|image|Windows.pm:copy_capture_configuration_files|7034|set
 the Windows root password in configuration files

|113252|85|75|image|Windows.pm:import_registry_string|2725| ---- WARNING ---- 
|113252|85|75|image|Windows.pm:import_registry_string|2725| 2018-02-07 
10:35:53|113252|85|75|image|Windows.pm:import_registry_string|2725|failed to 
echo registry string contents to C:/Cygwin/tmp/disable_autoadminlogon_471.reg, 
exit status: 1, output:
|113252|85|75|image|Windows.pm:import_registry_string|2725| bash: 
C:/Cygwin/tmp/disable_autoadminlogon_471.reg: No such file or directory
|113252|85|75|image|Windows.pm:import_registry_string|2725| ( 0) Windows.pm, 
import_registry_string (line: 2725)
|113252|85|75|image|Windows.pm:import_registry_string|2725| (-1) Windows.pm, 
disable_autoadminlogon (line: 3783)
|113252|85|75|image|Windows.pm:import_registry_string|2725| (-2) Windows.pm, 
pre_capture (line: 471)
|113252|85|75|image|Windows.pm:import_registry_string|2725| (-3) Version_6.pm, 
pre_capture (line: 114)
|113252|85|75|image|Windows.pm:import_registry_string|2725| (-4) 7.pm, 
pre_capture (line: 100)
|113252|85|75|image|Windows.pm:import_registry_string|2725| (-5) VMware.pm, 
capture (line: 929)
|113252|85|75|image|Windows.pm:import_registry_string|2725| (-6) image.pm, 
process (line: 164)
|113252|85|75|image|Windows.pm:import_registry_string|2725| (-7) vcld, 
make_new_child (line: 601)
|113252|85|75|image|Windows.pm:import_registry_string|2725| (-8) vcld, main 
(line: 353)


|113252|85|75|image|Windows.pm:disable_autoadminlogon|3788| ---- WARNING ---- 
|113252|85|75|image|Windows.pm:disable_autoadminlogon|3788| 2018-02-07 
10:35:53|113252|85|75|image|Windows.pm:disable_autoadminlogon|3788|failed to 
disable autoadminlogon
|113252|85|75|image|Windows.pm:disable_autoadminlogon|3788| ( 0) Windows.pm, 
disable_autoadminlogon (line: 3788)
|113252|85|75|image|Windows.pm:disable_autoadminlogon|3788| (-1) Windows.pm, 
pre_capture (line: 471)
|113252|85|75|image|Windows.pm:disable_autoadminlogon|3788| (-2) Version_6.pm, 
pre_capture (line: 114)
|113252|85|75|image|Windows.pm:disable_autoadminlogon|3788| (-3) 7.pm, 
pre_capture (line: 100)
|113252|85|75|image|Windows.pm:disable_autoadminlogon|3788| (-4) VMware.pm, 
capture (line: 929)
|113252|85|75|image|Windows.pm:disable_autoadminlogon|3788| (-5) image.pm, 
process (line: 164)
|113252|85|75|image|Windows.pm:disable_autoadminlogon|3788| (-6) vcld, 
make_new_child (line: 601)
|113252|85|75|image|Windows.pm:disable_autoadminlogon|3788| (-7) vcld, main 
(line: 353)


|113252|85|75|image|Windows.pm:pre_capture|472| ---- WARNING ---- 
|113252|85|75|image|Windows.pm:pre_capture|472| 2018-02-07 
10:35:53|113252|85|75|image|Windows.pm:pre_capture|472|unable to disable 
autoadminlogon
|113252|85|75|image|Windows.pm:pre_capture|472| ( 0) Windows.pm, pre_capture 
(line: 472)
|113252|85|75|image|Windows.pm:pre_capture|472| (-1) Version_6.pm, pre_capture 
(line: 114)
|113252|85|75|image|Windows.pm:pre_capture|472| (-2) 7.pm, pre_capture (line: 
100)
|113252|85|75|image|Windows.pm:pre_capture|472| (-3) VMware.pm, capture (line: 
929)
|113252|85|75|image|Windows.pm:pre_capture|472| (-4) image.pm, process (line: 
164)
|113252|85|75|image|Windows.pm:pre_capture|472| (-5) vcld, make_new_child 
(line: 601)
|113252|85|75|image|Windows.pm:pre_capture|472| (-6) vcld, main (line: 353)


|113252|85|75|image|Version_6.pm:pre_capture|118| ---- WARNING ---- 
|113252|85|75|image|Version_6.pm:pre_capture|118| 2018-02-07 
10:35:53|113252|85|75|image|Version_6.pm:pre_capture|118|failed to execute 
parent class pre_capture() subroutine
|113252|85|75|image|Version_6.pm:pre_capture|118| ( 0) Version_6.pm, 
pre_capture (line: 118)
|113252|85|75|image|Version_6.pm:pre_capture|118| (-1) 7.pm, pre_capture (line: 
100)
|113252|85|75|image|Version_6.pm:pre_capture|118| (-2) VMware.pm, capture 
(line: 929)
|113252|85|75|image|Version_6.pm:pre_capture|118| (-3) image.pm, process (line: 
164)
|113252|85|75|image|Version_6.pm:pre_capture|118| (-4) vcld, make_new_child 
(line: 601)
|113252|85|75|image|Version_6.pm:pre_capture|118| (-5) vcld, main (line: 353)


|113252|85|75|image|7.pm:pre_capture|104| ---- WARNING ---- 
|113252|85|75|image|7.pm:pre_capture|104| 2018-02-07 
10:35:53|113252|85|75|image|7.pm:pre_capture|104|failed to execute parent class 
pre_capture() subroutine
|113252|85|75|image|7.pm:pre_capture|104| ( 0) 7.pm, pre_capture (line: 104)
|113252|85|75|image|7.pm:pre_capture|104| (-1) VMware.pm, capture (line: 929)
|113252|85|75|image|7.pm:pre_capture|104| (-2) image.pm, process (line: 164)
|113252|85|75|image|7.pm:pre_capture|104| (-3) vcld, make_new_child (line: 601)
|113252|85|75|image|7.pm:pre_capture|104| (-4) vcld, main (line: 353)


|113252|85|75|image|VMware.pm:capture|930| ---- WARNING ---- 
|113252|85|75|image|VMware.pm:capture|930| 2018-02-07 
10:35:53|113252|85|75|image|VMware.pm:capture|930|failed to complete OS 
module's pre_capture tasks
|113252|85|75|image|VMware.pm:capture|930| ( 0) VMware.pm, capture (line: 930)
|113252|85|75|image|VMware.pm:capture|930| (-1) image.pm, process (line: 164)
|113252|85|75|image|VMware.pm:capture|930| (-2) vcld, make_new_child (line: 601)
|113252|85|75|image|VMware.pm:capture|930| (-3) vcld, main (line: 353)


|113252|85|75|image|image.pm:process|168| ---- WARNING ---- 
|113252|85|75|image|image.pm:process|168| 2018-02-07 
10:35:53|113252|85|75|image|image.pm:process|168|vmwarewin7-Win7test340-v0 
image failed to be captured by provisioning module
|113252|85|75|image|image.pm:process|168| ( 0) image.pm, process (line: 168)
|113252|85|75|image|image.pm:process|168| (-1) vcld, make_new_child (line: 601)
|113252|85|75|image|image.pm:process|168| (-2) vcld, main (line: 353)

2018-02-07 
10:35:53|113252|85|75|image|utils.pm:get_affiliation_info|10287|retrieved info 
for affiliation Global:
|113252|85|75|image|utils.pm:get_affiliation_info|10287| : {
|113252|85|75|image|utils.pm:get_affiliation_info|10287| :   "dataUpdateText" 
=> "",
|113252|85|75|image|utils.pm:get_affiliation_info|10287| :   "helpaddress" => 
undef,
|113252|85|75|image|utils.pm:get_affiliation_info|10287| :   "id" => 2,
|113252|85|75|image|utils.pm:get_affiliation_info|10287| :   "name" => "Global",
|113252|85|75|image|utils.pm:get_affiliation_info|10287| :   "shibname" => 
undef,
|113252|85|75|image|utils.pm:get_affiliation_info|10287| :   "shibonly" => 0,
|113252|85|75|image|utils.pm:get_affiliation_info|10287| :   "sitewwwaddress" 
=> undef,
|113252|85|75|image|utils.pm:get_affiliation_info|10287| :   "theme" => 
"default"
|113252|85|75|image|utils.pm:get_affiliation_info|10287| : }
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:get_computer_private_ip_address|1580|private
 IP address for cmp1 (7) stored in this object matches IP address stored in 
%ENV: 10.106.144.101
2018-02-07 10:35:53|113252|85|75|image|utils.pm:is_inblockrequest|4933|zero 
rows were returned from database select
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:get_image_affiliation_name|1703|image
 owner id: 1
2018-02-07 10:35:53|113252|85|75|image|utils.pm:mail|1314|SUCCESS -- Sending 
mail To: [email protected], PROBLEM -- 
mgtvcl01|85:75|image|image.pm|cmp1>V1|vmwarewin7-Win7test340-v0|admin

|113252|85|75|image|image.pm:reservation_failed|334| ---- CRITICAL ---- 
|113252|85|75|image|image.pm:reservation_failed|334| 2018-02-07 
10:35:53|113252|85|75|image|image.pm:reservation_failed|334|vmwarewin7-Win7test340-v0
 Image Capture Failed
|113252|85|75|image|image.pm:reservation_failed|334| ( 0) image.pm, 
reservation_failed (line: 334)
|113252|85|75|image|image.pm:reservation_failed|334| (-1) image.pm, process 
(line: 169)
|113252|85|75|image|image.pm:reservation_failed|334| (-2) vcld, make_new_child 
(line: 601)
|113252|85|75|image|image.pm:reservation_failed|334| (-3) vcld, main (line: 353)

2018-02-07 10:35:53|113252|85|75|image|utils.pm:is_variable_set|12830|variable 
is NOT set: usermessage|image_creation_delayed|Local
2018-02-07 
10:35:53|113252|85|75|image|Module.pm:_get_message_variable|1875|affiliation-specific
 variable is NOT set in database: usermessage|image_creation_delayed|Local
2018-02-07 10:35:53|113252|85|75|image|utils.pm:get_variable|12927|data type of 
variable 'usermessage|image_creation_delayed|Global': HASH reference
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[image_prettyname]', 
$self->get_image_prettyname(0) = 'Win7test3'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686|replaced
 all matching sections of input string with values retrieved from this 
DataStructure object:
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| input 
string: 'VCL -- NOTICE DELAY Image Creation [image_prettyname]'
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| output 
string: 'VCL -- NOTICE DELAY Image Creation Win7test3'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[image_prettyname]', 
$self->get_image_prettyname(0) = 'Win7test3'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686|replaced
 all matching sections of input string with values retrieved from this 
DataStructure object:
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| input 
string: 'We apologize for the inconvenience.
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Your 
image creation of [image_prettyname] has been delayed
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| due to a 
system issue that prevented the automatic completion.
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| The 
image creation request and the computing resource have
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| been 
placed in a safe mode. The VCL system administrators
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| have 
been notified for manual intervention.
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Once the 
issues have been resolved, you will be notified
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| by the 
successful completion email or contacted directly
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| by the 
VCL system administrators.
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| If you 
do not receive a response within one business day, please
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| reply to 
this email.
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Thank 
You,
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VCL Team
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| '
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| output 
string: 'We apologize for the inconvenience.
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Your 
image creation of Win7test3 has been delayed
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| due to a 
system issue that prevented the automatic completion.
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| The 
image creation request and the computing resource have
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| been 
placed in a safe mode. The VCL system administrators
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| have 
been notified for manual intervention.
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Once the 
issues have been resolved, you will be notified
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| by the 
successful completion email or contacted directly
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| by the 
VCL system administrators.
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| If you 
do not receive a response within one business day, please
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| reply to 
this email.
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Thank 
You,
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VCL Team
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| '
2018-02-07 
10:35:53|113252|85|75|image|Module.pm:_get_message_variable|1923|retrieved user 
message variable: usermessage|image_creation_delayed|Global, returning array:
|113252|85|75|image|Module.pm:_get_message_variable|1923| subject: VCL -- 
NOTICE DELAY Image Creation Win7test3
|113252|85|75|image|Module.pm:_get_message_variable|1923| message:
|113252|85|75|image|Module.pm:_get_message_variable|1923| We apologize for the 
inconvenience.
|113252|85|75|image|Module.pm:_get_message_variable|1923| Your image creation 
of Win7test3 has been delayed
|113252|85|75|image|Module.pm:_get_message_variable|1923| due to a system issue 
that prevented the automatic completion.
|113252|85|75|image|Module.pm:_get_message_variable|1923| The image creation 
request and the computing resource have
|113252|85|75|image|Module.pm:_get_message_variable|1923| been placed in a safe 
mode. The VCL system administrators
|113252|85|75|image|Module.pm:_get_message_variable|1923| have been notified 
for manual intervention.
|113252|85|75|image|Module.pm:_get_message_variable|1923| Once the issues have 
been resolved, you will be notified
|113252|85|75|image|Module.pm:_get_message_variable|1923| by the successful 
completion email or contacted directly
|113252|85|75|image|Module.pm:_get_message_variable|1923| by the VCL system 
administrators.
|113252|85|75|image|Module.pm:_get_message_variable|1923| If you do not receive 
a response within one business day, please
|113252|85|75|image|Module.pm:_get_message_variable|1923| reply to this email.
|113252|85|75|image|Module.pm:_get_message_variable|1923| Thank You,
|113252|85|75|image|Module.pm:_get_message_variable|1923| VCL Team
2018-02-07 10:35:53|113252|85|75|image|utils.pm:mail|1314|SUCCESS -- Sending 
mail To: root@localhost, VCL -- NOTICE DELAY Image Creation Win7test3
2018-02-07 10:35:53|113252|85|75|image|utils.pm:get_variable|12927|data type of 
variable 'adminmessage|image_creation_failed': HASH reference
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[image_capture_type]', 
$self->get_image_capture_type(0) = 'Capture'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[image_prettyname]', 
$self->get_image_prettyname(0) = 'Win7test3'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686|replaced
 all matching sections of input string with values retrieved from this 
DataStructure object:
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| input 
string: 'VCL -- NOTICE FAILED Image [image_capture_type] [image_prettyname]'
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| output 
string: 'VCL -- NOTICE FAILED Image Capture Win7test3'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[management_node_short_name]', 
$self->get_management_node_short_name(0) = 'mgtvcl01'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[request_id]', 
$self->get_request_id(0) = '85'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[reservation_id]', 
$self->get_reservation_id(0) = '75'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[process_pid]', 
$self->get_process_pid(0) = '113252'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[image_id]', 
$self->get_image_id(0) = '40'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[imagerevision_id]', 
$self->get_imagerevision_id(0) = '36'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[image_name]', 
$self->get_image_name(0) = 'vmwarewin7-Win7test340-v0'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[image_prettyname]', 
$self->get_image_prettyname(0) = 'Win7test3'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[image_os_module_perl_package]', 
$self->get_image_os_module_perl_package(0) = 
'VCL::Module::OS::Windows::Version_6::7'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[user_id]', $self->get_user_id(0) 
= '1'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[user_login_id]', 
$self->get_user_login_id(0) = 'admin'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[user_firstname]', 
$self->get_user_firstname(0) = 'vcl'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[user_lastname]', 
$self->get_user_lastname(0) = 'admin'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[user_affiliation_name]', 
$self->get_user_affiliation_name(0) = 'Local'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: 
'[computer_provisioning_pretty_name]', 
$self->get_computer_provisioning_pretty_name(0) = 'VMware'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[computer_provisioning_name]', 
$self->get_computer_provisioning_name(0) = 'vmware'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: 
'[computer_provisioning_module_perl_package]', 
$self->get_computer_provisioning_module_perl_package(0) = 
'VCL::Module::Provisioning::VMware::VMware'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[computer_id]', 
$self->get_computer_id(0) = '7'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[computer_short_name]', 
$self->get_computer_short_name(0) = 'cmp1'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[vmhost_id]', 
$self->get_vmhost_id(0) = '1'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[vmhost_computer_id]', 
$self->get_vmhost_computer_id(0) = '1'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[vmhost_short_name]', 
$self->get_vmhost_short_name(0) = 'V1'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[vmhost_profile_id]', 
$self->get_vmhost_profile_id(0) = '1'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2669|determined
 replacement value for substitution section: '[vmhost_profile_name]', 
$self->get_vmhost_profile_name(0) = 'VMware ESXi - local storage'
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686|replaced
 all matching sections of input string with values retrieved from this 
DataStructure object:
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| input 
string: 'VCL Image Creation Failed
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| 
Management node: [management_node_short_name]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Request 
ID: [request_id]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| 
Reservation ID: [reservation_id]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| PID: 
[process_pid]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Image 
ID: [image_id]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Image 
revision ID: [imagerevision_id]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Image 
name: [image_name]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Image 
display name: [image_prettyname]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Image OS 
package: [image_os_module_perl_package]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| User ID: 
[user_id]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| User 
login name: [user_login_id]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| User 
name: [user_firstname] [user_lastname]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| User 
affiliation: [user_affiliation_name]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| 
Provisioning module: [computer_provisioning_pretty_name] 
([computer_provisioning_name])
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| 
Provisioning package: [computer_provisioning_module_perl_package]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Computer 
ID: [computer_id]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Computer 
name: [computer_short_name]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VM host 
ID: [vmhost_id]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VM host 
computer ID: [vmhost_computer_id]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VM host 
computer name: [vmhost_short_name]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VM host 
profile ID: [vmhost_profile_id]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VM host 
profile name: [vmhost_profile_name]
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| '
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| output 
string: 'VCL Image Creation Failed
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| 
Management node: mgtvcl01
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Request 
ID: 85
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| 
Reservation ID: 75
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| PID: 
113252
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Image 
ID: 40
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Image 
revision ID: 36
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Image 
name: vmwarewin7-Win7test340-v0
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Image 
display name: Win7test3
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Image OS 
package: VCL::Module::OS::Windows::Version_6::7
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| User ID: 
1
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| User 
login name: admin
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| User 
name: vcl admin
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| User 
affiliation: Local
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| 
Provisioning module: VMware (vmware)
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| 
Provisioning package: VCL::Module::Provisioning::VMware::VMware
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Computer 
ID: 7
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| Computer 
name: cmp1
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VM host 
ID: 1
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VM host 
computer ID: 1
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VM host 
computer name: V1
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VM host 
profile ID: 1
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| VM host 
profile name: VMware ESXi - local storage
|113252|85|75|image|DataStructure.pm:substitute_string_variables|2686| '
2018-02-07 
10:35:53|113252|85|75|image|Module.pm:_get_message_variable|1923|retrieved 
admin message variable: adminmessage|image_creation_failed, returning array:
|113252|85|75|image|Module.pm:_get_message_variable|1923| subject: VCL -- 
NOTICE FAILED Image Capture Win7test3
|113252|85|75|image|Module.pm:_get_message_variable|1923| message:
|113252|85|75|image|Module.pm:_get_message_variable|1923| VCL Image Creation 
Failed
|113252|85|75|image|Module.pm:_get_message_variable|1923| Management node: 
mgtvcl01
|113252|85|75|image|Module.pm:_get_message_variable|1923| Request ID: 85
|113252|85|75|image|Module.pm:_get_message_variable|1923| Reservation ID: 75
|113252|85|75|image|Module.pm:_get_message_variable|1923| PID: 113252
|113252|85|75|image|Module.pm:_get_message_variable|1923| Image ID: 40
|113252|85|75|image|Module.pm:_get_message_variable|1923| Image revision ID: 36
|113252|85|75|image|Module.pm:_get_message_variable|1923| Image name: 
vmwarewin7-Win7test340-v0
|113252|85|75|image|Module.pm:_get_message_variable|1923| Image display name: 
Win7test3
|113252|85|75|image|Module.pm:_get_message_variable|1923| Image OS package: 
VCL::Module::OS::Windows::Version_6::7
|113252|85|75|image|Module.pm:_get_message_variable|1923| User ID: 1
|113252|85|75|image|Module.pm:_get_message_variable|1923| User login name: admin
|113252|85|75|image|Module.pm:_get_message_variable|1923| User name: vcl admin
|113252|85|75|image|Module.pm:_get_message_variable|1923| User affiliation: 
Local
|113252|85|75|image|Module.pm:_get_message_variable|1923| Provisioning module: 
VMware (vmware)
|113252|85|75|image|Module.pm:_get_message_variable|1923| Provisioning package: 
VCL::Module::Provisioning::VMware::VMware
|113252|85|75|image|Module.pm:_get_message_variable|1923| Computer ID: 7
|113252|85|75|image|Module.pm:_get_message_variable|1923| Computer name: cmp1
|113252|85|75|image|Module.pm:_get_message_variable|1923| VM host ID: 1
|113252|85|75|image|Module.pm:_get_message_variable|1923| VM host computer ID: 1
|113252|85|75|image|Module.pm:_get_message_variable|1923| VM host computer 
name: V1
|113252|85|75|image|Module.pm:_get_message_variable|1923| VM host profile ID: 1
|113252|85|75|image|Module.pm:_get_message_variable|1923| VM host profile name: 
VMware ESXi - local storage
2018-02-07 10:35:53|113252|85|75|image|utils.pm:mail|1314|SUCCESS -- Sending 
mail To: [email protected], VCL -- NOTICE FAILED Image Capture Win7test3
2018-02-07 10:35:53|113252|85|75|image|State.pm:state_exit|882|beginning state 
module exit tasks, request state argument: maintenance, computer state 
argument: maintenance, log ending argument: <not specified>
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:is_parent_reservation|1151|this is 
the parent reservation
2018-02-07 
10:35:53|113252|85|75|image|DataStructure.pm:get_computer_state_name|2089|retrieved
 current state of computer cmp1 from the database: available
2018-02-07 
10:35:53|113252|85|75|image|utils.pm:update_computer_state|1504|computer 7 
state updated to: maintenance
2018-02-07 
10:35:53|113252|85|75|image|utils.pm:delete_computerloadlog_reservation|5775|deleted
 rows from computerloadlog for reservation IDs: 75
2018-02-07 10:35:53|113252|85|75|image|utils.pm:insertloadlog|2580|inserted 
'exited' computerloadlog entry
2018-02-07 10:35:53|113252|85|75|image|State.pm:state_exit|1043|request has NOT 
been deleted, updating request state: image/image --> maintenance/image
2018-02-07 
10:35:53|113252|85|75|image|utils.pm:update_request_state|1445|request 85 state 
updated to maintenance/image
2018-02-07 10:35:53|113252|85|75|image|State.pm:state_exit|1066|calling 
subroutine: VCL::image::reservation_failed, calling exit
2018-02-07 10:35:53|113252|85|75|image|State.pm:DESTROY|1093|VCL::image 
destructor called, address: 39cfce0
2018-02-07 10:35:53|113252|85|75|image|Module.pm:DESTROY|2391|destroying 
VCL::image object, address: 39cfce0
2018-02-07 10:35:53|113252|85|75|image|State.pm:DESTROY|1146|VCL::image process 
duration: 55 seconds
2018-02-07 10:35:53|113252|85|75|image|Module.pm:DESTROY|2391|destroying 
VCL::Module::Provisioning::VMware::VMware object, address: 4996208
2018-02-07 10:35:53|113252|85|75|image|Module.pm:DESTROY|2391|destroying 
VCL::Module::OS::Linux object, address: 4995dd0
2018-02-07 10:35:53|113252|85|75|image|Module.pm:DESTROY|2391|destroying 
VCL::Module::Provisioning::VMware::VIM_SSH object, address: 49b5d90
2018-02-07 10:35:53|113252|85|75|image|VIM_SSH.pm:DESTROY|4240|vim-cmd call 
count: 7
2018-02-07 10:35:53|113252|85|75|image|Module.pm:DESTROY|2391|destroying 
VCL::Module::OS::Windows::Version_6::7 object, address: 45782c8
2018-02-07 10:35:53|113252|85|75|image|Module.pm:DESTROY|2391|destroying 
VCL::Module::OS::Linux::ManagementNode object, address: 4989258
2018-02-07 10:35:53|113198|||vcld|vcld:REAPER|758|VCL process exited for 
reservation 75, PID: 113252, signal: CHLD


On 2/7/18, 9:18 AM, "Josh Thompson" <[email protected]> wrote:

    Al,
    
    Do you have User Account Control (UAC) disabled in the image?
    
    
https://www.howtogeek.com/howto/windows-vista/disable-user-account-control-uac-the-easy-way-on-windows-vista/
    
    Josh
    
    On Tuesday, February 6, 2018 1:06:20 PM EST Evelio Quiros wrote:
    > Logging in manually to the reloaded Windows VM, I see that Cygwin is
    > running, and it immediately logs me out.
     I feel that this is “almost” a
    > good capture, but some step was overlooked on my part. 
    > 
    > 1.       The vcld –setup appears to run successfully
    > 
    > 2.       The VM is removed and reloaded from the VM host.
    > 
    > 3.       The computer stays on “reloading” for a long while.
    > 
    > 4.       Eventually, it shows up as “failed”.
    > 
    > 
    > What else can I check for troubleshooting ?
    > 
    > -- Al Quiros
    > Enterprise Systems
    > 
    > 
    > 
    > From: Evelio Quiros <[email protected]>
    > Reply-To: "[email protected]" <[email protected]>
    > Date: Tuesday, February 6, 2018 at 12:57 PM
    > To: "[email protected]" <[email protected]>
    > Subject: Re: Windows Capture error
    > 
    > Interestingly, I can try to reload the failed computer. It does go through
    > turning off and unregistering, then reloading. Perhaps all these functions
    > are part of the VM host doing that.
     
    > Anyway, the Windows capture failed, so I will try it again.
    > 
    > 
    > -- Al Quiros
    > Enterprise Systems
    > 
    > 
    > 
    > From: Joseph Fischetti <[email protected]>
    > Reply-To: "[email protected]" <[email protected]>
    > Date: Tuesday, February 6, 2018 at 12:49 PM
    > To: "[email protected]" <[email protected]>
    > Subject: Re: Windows Capture error
    > 
    > Evelio,
    > I seem to remember making a change in one of the provisioning scripts to 
set
    > the SSH service to "auto".
     You can try manually connecting to the VM,
    > opening up
    > 
services.msc<https://urldefense.proofpoint.com/v2/url?u=http-3A__services.m
    > 
sc&d=DwMFaQ&c=lhMMI368wojMYNABHh1gQQ&r=iomW2cpnE-Hdilsh5YvIBg&m=-OkAOBSqKAwp
    > 
I869QbTnZ87SY-qPPgbinRNfs-uSdDc&s=SGlvOANmKrIOqXphByXvC3e0JZ1tRRDI_wUUBa-vKp
    > Y&e=>, and checking the status of the SSH service to see if that's part of
    > the problem. 
    > Sent from IBM Verse
    > Evelio Quiros --- Re: Windows Capture error ---
    > 
    > From:
    > 
    > "Evelio Quiros" <[email protected]>
    > 
    > To:
    > 
    > [email protected]
    > 
    > Date:
    > 
    > Tue, Feb 6, 2018 12:44 PM
    > 
    > Subject:
    > 
    > Re: Windows Capture error
    > 
    > ________________________________
    > 
    > I was able to copy root’s public key to the list of authorized keys.
    > That got me past the error.
    > 
    > However, after the image capture and subsequent reload on the VM host, I 
see
    > the computer in the list always on “reloading” state.
     It has been
    > reloading for quite a while now. I expect it to time out eventually. 
    > It goes almost all the way through image capture and reload. But I suspect
    > that Cygwin is no longer running, so VCL cannot SSH to the reloaded VM.
     
    > 
    > -- Al Quiros
    > Enterprise Systems
    > 
    > 
    > 
    > From: Evelio Quiros <[email protected]>
    > Reply-To: "[email protected]" <[email protected]>
    > Date: Tuesday, February 6, 2018 at 12:11 PM
    > To: "[email protected]" <[email protected]>
    > Subject: Re: Windows Capture error
    > 
    > Trying to capture a Windows 7 image.
    > I logged into windows as root, ran the config script successfully.
    > I executed Gen-node-key script and tried the SSH command successfully.
    > 
    > However, although I can SSH to the windows VM, vcld still complains that 
SSH
    > is closed.
     
    > Did I miss a step somewhere ?
    > 
    > Al Quiros
    
    -- 
    -------------------------------
    Josh Thompson
    Systems Programmer
    Platform Computing | VCL Developer
    North Carolina State University
    
    [email protected]
    919-515-5323
    
    my GPG/PGP key can be found at pgp.mit.edu
    
    All electronic mail messages in connection with State business which
    are sent to or received by this account are subject to the NC Public
    Records Law and may be disclosed to third parties.

Reply via email to