You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@vcl.apache.org by Alexander Patterson <al...@csueastbay.edu> on 2011/08/04 00:38:29 UTC
Images Failing Due to error occurred setting root as the owner of
/home/root, error output:
Hello,
I'm having an issue with VCL 2.2.1 I have my old images and If I try
to create or update them I run into this error
error occurred setting root as the owner of /home/root, error output:
`/home/root/.ssh': Permission denied
chown -R root /home/root/.ssh has been set
I have my root dir as chmod 777
The .ssh file is set to 700
Here is the log
2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:set_vmx_file_path(2932)|set
overridden vmx file path:
'/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmx'
2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:get_vmx_info(4401)|returning
previously retrieved info from vmx file:
/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmx
2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:capture(488)|vmx
info for VM vmguest-37 being captured:
|31856|56238:55974|image| : {
|31856|56238:55974|image| : ".encoding" => "UTF-8",
|31856|56238:55974|image| : "cleanshutdown" => "FALSE",
|31856|56238:55974|image| : "computer_id" => 41,
|31856|56238:55974|image| : "config.version" => 8,
|31856|56238:55974|image| : "disk.locking" => "false",
|31856|56238:55974|image| : "displayname" =>
"vmguest-37:vmwarewinxp-CSUEBVisualStudio2010Express114-v4
(persistent)",
|31856|56238:55974|image| : "ethernet0.address" => "00:50:56:2a:3b:4a",
|31856|56238:55974|image| : "ethernet0.addresstype" => "static",
|31856|56238:55974|image| : "ethernet0.connectiontype" => "bridged",
|31856|56238:55974|image| : "ethernet0.networkname" => "VLAN-private",
|31856|56238:55974|image| : "ethernet0.pcislotnumber" => 32,
|31856|56238:55974|image| : "ethernet0.present" => "TRUE",
|31856|56238:55974|image| : "ethernet0.virtualdev" => "vlance",
|31856|56238:55974|image| : "ethernet1.address" => "00:50:56:2a:3b:4b",
|31856|56238:55974|image| : "ethernet1.addresstype" => "static",
|31856|56238:55974|image| : "ethernet1.connectiontype" => "bridged",
|31856|56238:55974|image| : "ethernet1.networkname" => "VLAN-public",
|31856|56238:55974|image| : "ethernet1.pcislotnumber" => 33,
|31856|56238:55974|image| : "ethernet1.present" => "TRUE",
|31856|56238:55974|image| : "ethernet1.virtualdev" => "vlance",
|31856|56238:55974|image| : "evccompatibilitymode" => "FALSE",
|31856|56238:55974|image| : "extendedconfigfile" => "vmguest-37_114-v4.vmxf",
|31856|56238:55974|image| : "floppy0.present" => "FALSE",
|31856|56238:55974|image| : "guestcpuid.0" =>
"0000000b756e65476c65746e49656e69",
|31856|56238:55974|image| : "guestcpuid.1" =>
"000106a500010800809822010febfbff",
|31856|56238:55974|image| : "guestcpuid.80000001" =>
"00000000000000000000000128100800",
|31856|56238:55974|image| : "guestos" => "winxppro",
|31856|56238:55974|image| : "gui.exitonclihlt" => "TRUE",
|31856|56238:55974|image| : "hostcpuid.0" =>
"0000000b756e65476c65746e49656e69",
|31856|56238:55974|image| : "hostcpuid.1" =>
"000106a500100800009ce3bdbfebfbff",
|31856|56238:55974|image| : "hostcpuid.80000001" =>
"00000000000000000000000128100800",
|31856|56238:55974|image| : "ide0:0.filename" =>
"/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk",
|31856|56238:55974|image| : "ide0:0.mode" => "independent-persistent",
|31856|56238:55974|image| : "ide0:0.present" => "TRUE",
|31856|56238:55974|image| : "ide0:0.redo" => "",
|31856|56238:55974|image| : "ide0:0.sharedbus" => "none",
|31856|56238:55974|image| : "ide0:0.writethrough" => "TRUE",
|31856|56238:55974|image| : "image_id" => 114,
|31856|56238:55974|image| : "imagerevision_id" => 264,
|31856|56238:55974|image| : "mainmem.usenamedfile" => "FALSE",
|31856|56238:55974|image| : "memsize" => 1536,
|31856|56238:55974|image| : "memtrimrate" => 0,
|31856|56238:55974|image| : "msg.autoanswer" => "TRUE",
|31856|56238:55974|image| : "numvcpus" => 1,
|31856|56238:55974|image| : "pcibridge0.pcislotnumber" => 17,
|31856|56238:55974|image| : "pcibridge0.present" => "TRUE",
|31856|56238:55974|image| : "pcibridge4.functions" => 8,
|31856|56238:55974|image| : "pcibridge4.pcislotnumber" => 21,
|31856|56238:55974|image| : "pcibridge4.present" => "TRUE",
|31856|56238:55974|image| : "pcibridge4.virtualdev" => "pcieRootPort",
|31856|56238:55974|image| : "pcibridge5.functions" => 8,
|31856|56238:55974|image| : "pcibridge5.pcislotnumber" => 22,
|31856|56238:55974|image| : "pcibridge5.present" => "TRUE",
|31856|56238:55974|image| : "pcibridge5.virtualdev" => "pcieRootPort",
|31856|56238:55974|image| : "pcibridge6.functions" => 8,
|31856|56238:55974|image| : "pcibridge6.pcislotnumber" => 23,
|31856|56238:55974|image| : "pcibridge6.present" => "TRUE",
|31856|56238:55974|image| : "pcibridge6.virtualdev" => "pcieRootPort",
|31856|56238:55974|image| : "pcibridge7.functions" => 8,
|31856|56238:55974|image| : "pcibridge7.pcislotnumber" => 24,
|31856|56238:55974|image| : "pcibridge7.present" => "TRUE",
|31856|56238:55974|image| : "pcibridge7.virtualdev" => "pcieRootPort",
|31856|56238:55974|image| : "powertype.poweroff" => "soft",
|31856|56238:55974|image| : "powertype.poweron" => "hard",
|31856|56238:55974|image| : "powertype.reset" => "soft",
|31856|56238:55974|image| : "powertype.suspend" => "hard",
|31856|56238:55974|image| : "replay.supported" => "FALSE",
|31856|56238:55974|image| : "sched.mem.pshare.enable" => "FALSE",
|31856|56238:55974|image| : "sched.swap.derivedname" =>
"/vmfs/volumes/b254e2be-e75868fb/vmguest-37_114-v4/vmguest-37_114-v4-92eeafbd.vswp",
|31856|56238:55974|image| : "snapshot.disabled" => "TRUE",
|31856|56238:55974|image| : "svga.autodetect" => "TRUE",
|31856|56238:55974|image| : "svga.vramsize" => 16777216,
|31856|56238:55974|image| : "tools.remindinstall" => "FALSE",
|31856|56238:55974|image| : "tools.synctime" => "FALSE",
|31856|56238:55974|image| : "toolscripts.afterpoweron" => "FALSE",
|31856|56238:55974|image| : "toolscripts.afterresume" => "FALSE",
|31856|56238:55974|image| : "toolscripts.beforepoweroff" => "FALSE",
|31856|56238:55974|image| : "toolscripts.beforesuspend" => "FALSE",
|31856|56238:55974|image| : "usercpuid.0" =>
"0000000b756e65476c65746e49656e69",
|31856|56238:55974|image| : "usercpuid.1" =>
"000106a500100800009822010febfbff",
|31856|56238:55974|image| : "usercpuid.80000001" =>
"00000000000000000000000128100800",
|31856|56238:55974|image| : "uuid.action" => "keep",
|31856|56238:55974|image| : "uuid.bios" => "56 4d 1b 88 36 f4 56
22-8b 80 4c b4 cc 54 f0 42",
|31856|56238:55974|image| : "uuid.location" => "56 4d 1b 88 36 f4 56
22-8b 80 4c b4 cc 54 f0 42",
|31856|56238:55974|image| : "virtualhw.productcompatibility" => "hosted",
|31856|56238:55974|image| : "virtualhw.version" => 7,
|31856|56238:55974|image| : "vmci0.id" => -866848702,
|31856|56238:55974|image| : "vmci0.pcislotnumber" => 34,
|31856|56238:55974|image| : "vmci0.present" => "TRUE",
|31856|56238:55974|image| : "vmdk" => {
|31856|56238:55974|image| : "ide0:0" => {
|31856|56238:55974|image| : "mode" => "independent-persistent",
|31856|56238:55974|image| : "present" => "TRUE",
|31856|56238:55974|image| : "redo" => "",
|31856|56238:55974|image| : "sharedbus" => "none",
|31856|56238:55974|image| : "vmdk_directory_path" =>
"/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4",
|31856|56238:55974|image| : "vmdk_file_name" => "vmguest-37_114-v4",
|31856|56238:55974|image| : "vmdk_file_path" =>
"/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk",
|31856|56238:55974|image| : "writethrough" => "TRUE"
|31856|56238:55974|image| : }
|31856|56238:55974|image| : },
|31856|56238:55974|image| : "vmotion.checkpointfbsize" => 16777216,
|31856|56238:55974|image| : "vmx_directory_path" =>
"/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4",
|31856|56238:55974|image| : "vmx_file_name" => "vmguest-37_114-v4.vmx"
|31856|56238:55974|image| : }
2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:capture(507)|vmdk
file path configured for VM vmguest-37 being captured:
/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk
2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:check_file_paths(3502)|successfully
retrieved vmdk file path components:
|31856|56238:55974|image| VM profile VM path:
'/vmfs/volumes/netappfiler02-sata1'
|31856|56238:55974|image| VM profile datastore path:
'/vmfs/volumes/netappfiler02-sata1'
|31856|56238:55974|image| vmdk file path:
'/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk'
|31856|56238:55974|image| vmdk directory path:
'/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4'
|31856|56238:55974|image| vmdk base directory path:
'/vmfs/volumes/netappfiler02-sata1'
|31856|56238:55974|image| vmdk directory name: 'vmguest-37_114-v4'
|31856|56238:55974|image| vmdk file name:
'vmguest-37_114-v4.vmdk'
|31856|56238:55974|image| vmdk file prefix: 'vmguest-37_114-v4'
|31856|56238:55974|image| persistent vmdk file path:
'/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk'
|31856|56238:55974|image| persistent vmdk directory path:
'/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4'
|31856|56238:55974|image| persistent vmdk directory name: 'vmguest-37_114-v4'
|31856|56238:55974|image| nonpersistent vmdk file path:
'/vmfs/volumes/netappfiler02-sata1/vmwarewinxp-CSUEBVisualStudio2010Express114-v5/vmwarewinxp-CSUEBVisualStudio2010Express114-v5.vmdk'
|31856|56238:55974|image| nonpersistent vmdk directory path:
'/vmfs/volumes/netappfiler02-sata1/vmwarewinxp-CSUEBVisualStudio2010Express114-v5'
|31856|56238:55974|image| nonpersistent vmdk directory name:
'vmwarewinxp-CSUEBVisualStudio2010Express114-v5'
2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:set_vmdk_file_path(3435)|set
overridden vmdk file path:
'/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk'
2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:capture(531)|mode
of vmdk to be captured is valid: independent-persistent
2011-08-03 15:31:52|31856|56238:55974|image|Linux.pm:file_exists(1390)|file
or directory does not exist on vclesxi20:
'/vmfs/volumes/netappfiler02-sata1/vmwarewinxp-CSUEBVisualStudio2010Express114-v5/vmwarewinxp-CSUEBVisualStudio2010Express114-v5.vmdk'
2011-08-03 15:31:52|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
SSH command on vmguest-37:
|31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -l root -p 22 -x vmguest-37 'chown root
currentimage.txt; chmod 777 currentimage.txt' 2>&1
2011-08-03 15:32:00|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
output:
2011-08-03 15:32:00|31856|56238:55974|image|utils.pm:run_ssh_command(5478)|SSH
command executed on vmguest-37, returning (0, "")
2011-08-03 15:32:00|31856|56238:55974|image|utils.pm:write_currentimage_txt(5685)|updated
ownership and permissions on currentimage.txt
2011-08-03 15:32:00|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
SSH command on vmguest-37:
|31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -l root -p 22 -x vmguest-37 'echo -e
"vmwarewinxp-CSUEBVisualStudio2010Express114-v5\r\nid=114\r\nprettyname=CSUEB
Visual Studio 2010
Express\r\nimagerevision_id=276\r\nimagerevision_datecreated=2011-08-03
15:29:03\r\ncomputer_id=41\r\ncomputer_hostname=vmguest-37" >
currentimage.txt && cat currentimage.txt' 2>&1
2011-08-03 15:32:05|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
output:
|31856|56238:55974|image| vmwarewinxp-CSUEBVisualStudio2010Express114-v5
|31856|56238:55974|image| id=114
|31856|56238:55974|image| prettyname=CSUEB Visual Studio 2010 Express
|31856|56238:55974|image| imagerevision_id=276
|31856|56238:55974|image| imagerevision_datecreated=2011-08-03 15:29:03
|31856|56238:55974|image| computer_id=41
|31856|56238:55974|image| computer_hostname=vmguest-37
2011-08-03 15:32:05|31856|56238:55974|image|utils.pm:run_ssh_command(5478)|SSH
command executed on vmguest-37, returning (0,
"vmwarewinxp-CSUEBVisualStudio2...")
2011-08-03 15:32:05|31856|56238:55974|image|utils.pm:write_currentimage_txt(5695)|created
currentimage.txt file on vmguest-37:
|31856|56238:55974|image| vmwarewinxp-CSUEBVisualStudio2010Express114-v5
|31856|56238:55974|image| id=114
|31856|56238:55974|image| prettyname=CSUEB Visual Studio 2010 Express
|31856|56238:55974|image| imagerevision_id=276
|31856|56238:55974|image| imagerevision_datecreated=2011-08-03 15:29:03
|31856|56238:55974|image| computer_id=41
|31856|56238:55974|image| computer_hostname=vmguest-37
2011-08-03 15:32:05|31856|56238:55974|image|DataStructure.pm:_automethod(834)|data
structure updated:
$self->request_data->{reservation}{55974}{image}{imagemeta}{sysprep}
|31856|56238:55974|image| imagemeta_sysprep = 0
2011-08-03 15:32:05|31856|56238:55974|image|Version_5.pm:pre_capture(104)|calling
parent class pre_capture() subroutine
2011-08-03 15:32:05|31856|56238:55974|image|Windows.pm:pre_capture(231)|beginning
Windows image capture preparation tasks on vmguest-37
2011-08-03 15:32:05|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
SSH command on vmguest-37:
|31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -l root -p 22 -x vmguest-37
'C:/Windows/System32/qwinsta.exe' 2>&1
2011-08-03 15:32:11|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
output:
|31856|56238:55974|image| SESSIONNAME USERNAME ID STATE TYPE DEVICE
|31856|56238:55974|image| >console 0 Conn wdcon
|31856|56238:55974|image| rdp-tcp 65536 Listen rdpwd
|31856|56238:55974|image| Administrator 2 Disc rdpwd
2011-08-03 15:32:11|31856|56238:55974|image|utils.pm:run_ssh_command(5478)|SSH
command executed on vmguest-37, returning (0, "SESSIONNAME USERNAME ID
STATE ...")
2011-08-03 15:32:11|31856|56238:55974|image|Windows.pm:set_password(1905)|setting
password of root to vclPassword on vmguest-37
2011-08-03 15:32:11|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
SSH command on vmguest-37:
|31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -l root -p 22 -x vmguest-37
'C:/Windows/System32/net.exe user root 'vclPassword'' 2>&1
2011-08-03 15:32:16|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
output:
|31856|56238:55974|image| The command completed successfully.
2011-08-03 15:32:16|31856|56238:55974|image|utils.pm:run_ssh_command(5478)|SSH
command executed on vmguest-37, returning (0, "The command completed
successf...")
2011-08-03 15:32:16|31856|56238:55974|image|Windows.pm:set_password(1907)|password
changed to 'vclPassword' for user 'root' on vmguest-37
2011-08-03 15:32:16|31856|56238:55974|image|Windows.pm:set_password(1921)|root
account password changed, must also change sshd service credentials
2011-08-03 15:32:16|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
SSH command on vmguest-37:
|31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -l root -p 22 -x vmguest-37
'C:/Windows/System32/sc.exe config sshd obj= ".\root" password=
"vclPassword"' 2>&1
2011-08-03 15:32:21|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
output:
|31856|56238:55974|image| [SC] ChangeServiceConfig SUCCESS
2011-08-03 15:32:21|31856|56238:55974|image|utils.pm:run_ssh_command(5478)|SSH
command executed on vmguest-37, returning (0, "[SC]
ChangeServiceConfig SUCCE...")
2011-08-03 15:32:21|31856|56238:55974|image|Windows.pm:set_service_credentials(3795)|changed
logon credentials for 'sshd' service to root (vclPassword) on
vmguest-37
2011-08-03 15:32:21|31856|56238:55974|image|Windows.pm:set_password(1929)|changing
passwords for scheduled tasks
2011-08-03 15:32:26|31856|56238:55974|image|Windows.pm:set_password(1931)|queried
scheduled tasks on vmguest-37
2011-08-03 15:32:26|31856|56238:55974|image|Windows.pm:set_password(1982)|changed
password for user: root
2011-08-03 15:32:26|31856|56238:55974|image|Windows.pm:delete_user(1834)|attempting
to delete user wv4973 from vmguest-37
2011-08-03 15:32:26|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
SSH command on vmguest-37:
|31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -l root -p 22 -x vmguest-37
'C:/Windows/System32/net.exe user wv4973 /DELETE' 2>&1
2011-08-03 15:32:32|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
output:
|31856|56238:55974|image| The user name could not be found.
|31856|56238:55974|image| More help is available by typing NET HELPMSG 2221.
2011-08-03 15:32:32|31856|56238:55974|image|utils.pm:run_ssh_command(5474)|SSH
command executed on vmguest-37, command:
|31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
StrictHostKeyChecking=no -l root -p 22 -x vmguest-37
'C:/Windows/System32/net.exe user wv4973 /DELETE' 2>&1
|31856|56238:55974|image| returning (2, "The user name could not be fou...")
2011-08-03 15:32:32|31856|56238:55974|image|Windows.pm:delete_user(1839)|user
wv4973 was not deleted because user does not exist
2011-08-03 15:32:37|31856|56238:55974|image|Windows.pm:file_exists(1336)|file
does NOT exist on vmguest-37: 'C:/Documents and Settings/wv4973'
2011-08-03 15:32:37|31856|56238:55974|image|Windows.pm:delete_file(1095)|failed
not deleted because it does not exist: 'C:/Documents and
Settings/wv4973'
2011-08-03 15:32:37|31856|56238:55974|image|Windows.pm:delete_user(1855)|deleted
profile for user wv4973 from vmguest-37
2011-08-03 15:32:37|31856|56238:55974|image|Windows.pm:delete_users(1609)|deleted
1 users from vmguest-37
|31856|56238:55974|image| ---- WARNING ----
|31856|56238:55974|image| 2011-08-03
15:32:49|31856|56238:55974|image|Windows.pm:set_file_owner(1398)|error
occurred setting root as the owner of /home/root, error output:
|31856|56238:55974|image| /usr/bin/chown: cannot read directory
`/home/root/.ssh': Permission denied
|31856|56238:55974|image| failed to change ownership of
`/home/root/.ssh' to root
|31856|56238:55974|image| ( 0) Windows.pm, set_file_owner (line: 1398)
|31856|56238:55974|image| (-1) Windows.pm, pre_capture (line: 272)
|31856|56238:55974|image| (-2) Version_5.pm, pre_capture (line: 105)
|31856|56238:55974|image| (-3) VMware.pm, capture (line: 556)
|31856|56238:55974|image| (-4) image.pm, process (line: 162)
|31856|56238:55974|image| (-5) vcld, make_new_child (line: 568)
|31856|56238:55974|image| ---- WARNING ----
|31856|56238:55974|image| 2011-08-03
15:32:49|31856|56238:55974|image|Windows.pm:pre_capture(273)|unable to
set root as the owner of /home/root
|31856|56238:55974|image| ( 0) Windows.pm, pre_capture (line: 273)
|31856|56238:55974|image| (-1) Version_5.pm, pre_capture (line: 105)
|31856|56238:55974|image| (-2) VMware.pm, capture (line: 556)
|31856|56238:55974|image| (-3) image.pm, process (line: 162)
|31856|56238:55974|image| (-4) vcld, make_new_child (line: 568)
|31856|56238:55974|image| (-5) vcld, main (line: 346)
|31856|56238:55974|image| ---- WARNING ----
|31856|56238:55974|image| 2011-08-03
15:32:49|31856|56238:55974|image|Version_5.pm:pre_capture(109)|failed
to execute parent class pre_capture() subroutine
|31856|56238:55974|image| ( 0) Version_5.pm, pre_capture (line: 109)
|31856|56238:55974|image| (-1) VMware.pm, capture (line: 556)
|31856|56238:55974|image| (-2) image.pm, process (line: 162)
|31856|56238:55974|image| (-3) vcld, make_new_child (line: 568)
|31856|56238:55974|image| (-4) vcld, main (line: 346)
|31856|56238:55974|image| ---- WARNING ----
|31856|56238:55974|image| 2011-08-03
15:32:49|31856|56238:55974|image|VMware.pm:capture(557)|failed to
complete OS module's pre_capture tasks
|31856|56238:55974|image| ( 0) VMware.pm, capture (line: 557)
|31856|56238:55974|image| (-1) image.pm, process (line: 162)
|31856|56238:55974|image| (-2) vcld, make_new_child (line: 568)
|31856|56238:55974|image| (-3) vcld, main (line: 346)
|31856|56238:55974|image| ---- WARNING ----
|31856|56238:55974|image| 2011-08-03
15:32:49|31856|56238:55974|image|image.pm:process(166)|vmwarewinxp-CSUEBVisualStudio2010Express114-v5
image failed to be captured by provisioning module
|31856|56238:55974|image| ( 0) image.pm, process (line: 166)
|31856|56238:55974|image| (-1) vcld, make_new_child (line: 568)
|31856|56238:55974|image| (-2) vcld, main (line: 346)
2011-08-03 15:32:49|31856|56238:55974|image|DataStructure.pm:get_computer_private_ip_address(1557)|returning
private IP address previously retrieved: 10.10.10.117
2011-08-03 15:32:49|31856|56238:55974|image|utils.pm:is_inblockrequest(6163)|zero
rows were returned from database select
2011-08-03 15:32:49|31856|56238:55974|image|DataStructure.pm:get_image_affiliation_name(2035)|image
owner id: 10
2011-08-03 15:32:49|31856|56238:55974|image|utils.pm:getnewdbh(2709)|database
requested (information_schema) does not match handle stored in
$ENV{dbh} (vcl:localhost)
2011-08-03 15:32:49|31856|56238:55974|image|utils.pm:getnewdbh(2760)|database
handle stored in $ENV{dbh}
2011-08-03 15:32:49|31856|56238:55974|image|DataStructure.pm:retrieve_user_data(1352)|attempting
to retrieve and store data for user: user.id = '10'
2011-08-03 15:32:49|31856|56238:55974|image|utils.pm:getnewdbh(2709)|database
requested (vcl) does not match handle stored in $ENV{dbh}
(information_schema:localhost)
2011-08-03 15:32:49|31856|56238:55974|image|utils.pm:getnewdbh(2760)|database
handle stored in $ENV{dbh}
2011-08-03 15:32:49|31856|56238:55974|image|DataStructure.pm:retrieve_user_data(1415)|data
has been retrieved for user: wv4973 (id: 10)
2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:mail(1255)|SUCCESS
-- Sending mail To: alexander.patterson@csueastbay.edu, PROBLEM --
56238:55974|image|image.pm|vmguest-37>vclesxi20|vmwarewinxp-CSUEBVisualStudio2010Express114-v5|wv4973
|31856|56238:55974|image| ---- CRITICAL ----
|31856|56238:55974|image| 2011-08-03
15:32:49|31856|56238:55974|image|image.pm:reservation_failed(385)|vmwarewinxp-CSUEBVisualStudio2010Express114-v5
image creation failed
|31856|56238:55974|image| ( 0) image.pm, reservation_failed (line: 385)
|31856|56238:55974|image| (-1) image.pm, process (line: 167)
|31856|56238:55974|image| (-2) vcld, make_new_child (line: 568)
|31856|56238:55974|image| (-3) vcld, main (line: 346)
2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:mail(1255)|SUCCESS
-- Sending mail To: alexander.patterson@csueastbay.edu, VCL -- NOTICE
DELAY Image Creation CSUEB Visual Studio 2010 Express
2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:mail(1255)|SUCCESS
-- Sending mail To: alexander.patterson@csueastbay.edu, VCL -- NOTICE
FAILED Image Creation CSUEB Visual Studio 2010 Express
2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:update_request_state(1991)|request
56238 state updated to: maintenance, laststate to: image
2011-08-03 15:32:55|31856|56238:55974|image|image.pm:reservation_failed(437)|request
state set to maintenance, laststate to image
2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:update_computer_state(2033)|computer
41 state updated to: maintenance
2011-08-03 15:32:55|31856|56238:55974|image|image.pm:reservation_failed(445)|vmguest-37
state set to maintenance
2011-08-03 15:32:55|31856|56238:55974|image|image.pm:reservation_failed(452)|exiting
2011-08-03 15:32:55|31856|56238:55974|image|State.pm:DESTROY(829)|VCL::image
destructor called, address: 1a510d10
2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:delete_computerloadlog_reservation(6742)|removing
computerloadlog entries matching loadstate = begin
2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:delete_computerloadlog_reservation(6789)|deleted
rows from computerloadlog for reservation id=55974
2011-08-03 15:32:55|31856|56238:55974|image|State.pm:DESTROY(848)|number
of database handles state process created: 3
2011-08-03 15:32:55|31856|56238:55974|image|State.pm:DESTROY(876)|VCL::image
process duration: 234 seconds
2011-08-03 15:32:55|31856|56238:55974|image|VIM_SSH.pm:DESTROY(1685)|vim-cmd
call count: 12
--
Thanks,
Alex Patterson
User Support Services
Operating System Analyst
California State University, East Bay
Re: Images Failing Due to error occurred setting root as the owner of
/home/root, error output:
Posted by Andy Kurth <an...@ncsu.edu>.
By any chance did you install Cygwin as a user other than root? This
can cause all sorts of permission problems like what you're
experiencing. Either way, I would recommend uninstalling Cygwin and
reinstalling it while logged in as root. Uninstalling Cygwin pretty
much involves deleting C:\cygwin. You may have to take ownership via
the Windows GUI and grant Full Control to root in order to delete it.
Also FYI, it appears that you're trying to capture an XP image.
However, if/when you attempt to capture a Win7 or 2008 image be sure
to disable User Account Control and reboot before installing Cygwin.
Similar permission problems will occur otherwise.
Hope this helps,
Andy
On Wed, Aug 3, 2011 at 6:38 PM, Alexander Patterson
<al...@csueastbay.edu> wrote:
> Hello,
>
> I'm having an issue with VCL 2.2.1 I have my old images and If I try
> to create or update them I run into this error
>
> error occurred setting root as the owner of /home/root, error output:
>
> `/home/root/.ssh': Permission denied
>
> chown -R root /home/root/.ssh has been set
>
> I have my root dir as chmod 777
>
> The .ssh file is set to 700
>
> Here is the log
>
> 2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:set_vmx_file_path(2932)|set
> overridden vmx file path:
> '/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmx'
> 2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:get_vmx_info(4401)|returning
> previously retrieved info from vmx file:
> /vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmx
> 2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:capture(488)|vmx
> info for VM vmguest-37 being captured:
> |31856|56238:55974|image| : {
> |31856|56238:55974|image| : ".encoding" => "UTF-8",
> |31856|56238:55974|image| : "cleanshutdown" => "FALSE",
> |31856|56238:55974|image| : "computer_id" => 41,
> |31856|56238:55974|image| : "config.version" => 8,
> |31856|56238:55974|image| : "disk.locking" => "false",
> |31856|56238:55974|image| : "displayname" =>
> "vmguest-37:vmwarewinxp-CSUEBVisualStudio2010Express114-v4
> (persistent)",
> |31856|56238:55974|image| : "ethernet0.address" => "00:50:56:2a:3b:4a",
> |31856|56238:55974|image| : "ethernet0.addresstype" => "static",
> |31856|56238:55974|image| : "ethernet0.connectiontype" => "bridged",
> |31856|56238:55974|image| : "ethernet0.networkname" => "VLAN-private",
> |31856|56238:55974|image| : "ethernet0.pcislotnumber" => 32,
> |31856|56238:55974|image| : "ethernet0.present" => "TRUE",
> |31856|56238:55974|image| : "ethernet0.virtualdev" => "vlance",
> |31856|56238:55974|image| : "ethernet1.address" => "00:50:56:2a:3b:4b",
> |31856|56238:55974|image| : "ethernet1.addresstype" => "static",
> |31856|56238:55974|image| : "ethernet1.connectiontype" => "bridged",
> |31856|56238:55974|image| : "ethernet1.networkname" => "VLAN-public",
> |31856|56238:55974|image| : "ethernet1.pcislotnumber" => 33,
> |31856|56238:55974|image| : "ethernet1.present" => "TRUE",
> |31856|56238:55974|image| : "ethernet1.virtualdev" => "vlance",
> |31856|56238:55974|image| : "evccompatibilitymode" => "FALSE",
> |31856|56238:55974|image| : "extendedconfigfile" => "vmguest-37_114-v4.vmxf",
> |31856|56238:55974|image| : "floppy0.present" => "FALSE",
> |31856|56238:55974|image| : "guestcpuid.0" =>
> "0000000b756e65476c65746e49656e69",
> |31856|56238:55974|image| : "guestcpuid.1" =>
> "000106a500010800809822010febfbff",
> |31856|56238:55974|image| : "guestcpuid.80000001" =>
> "00000000000000000000000128100800",
> |31856|56238:55974|image| : "guestos" => "winxppro",
> |31856|56238:55974|image| : "gui.exitonclihlt" => "TRUE",
> |31856|56238:55974|image| : "hostcpuid.0" =>
> "0000000b756e65476c65746e49656e69",
> |31856|56238:55974|image| : "hostcpuid.1" =>
> "000106a500100800009ce3bdbfebfbff",
> |31856|56238:55974|image| : "hostcpuid.80000001" =>
> "00000000000000000000000128100800",
> |31856|56238:55974|image| : "ide0:0.filename" =>
> "/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk",
> |31856|56238:55974|image| : "ide0:0.mode" => "independent-persistent",
> |31856|56238:55974|image| : "ide0:0.present" => "TRUE",
> |31856|56238:55974|image| : "ide0:0.redo" => "",
> |31856|56238:55974|image| : "ide0:0.sharedbus" => "none",
> |31856|56238:55974|image| : "ide0:0.writethrough" => "TRUE",
> |31856|56238:55974|image| : "image_id" => 114,
> |31856|56238:55974|image| : "imagerevision_id" => 264,
> |31856|56238:55974|image| : "mainmem.usenamedfile" => "FALSE",
> |31856|56238:55974|image| : "memsize" => 1536,
> |31856|56238:55974|image| : "memtrimrate" => 0,
> |31856|56238:55974|image| : "msg.autoanswer" => "TRUE",
> |31856|56238:55974|image| : "numvcpus" => 1,
> |31856|56238:55974|image| : "pcibridge0.pcislotnumber" => 17,
> |31856|56238:55974|image| : "pcibridge0.present" => "TRUE",
> |31856|56238:55974|image| : "pcibridge4.functions" => 8,
> |31856|56238:55974|image| : "pcibridge4.pcislotnumber" => 21,
> |31856|56238:55974|image| : "pcibridge4.present" => "TRUE",
> |31856|56238:55974|image| : "pcibridge4.virtualdev" => "pcieRootPort",
> |31856|56238:55974|image| : "pcibridge5.functions" => 8,
> |31856|56238:55974|image| : "pcibridge5.pcislotnumber" => 22,
> |31856|56238:55974|image| : "pcibridge5.present" => "TRUE",
> |31856|56238:55974|image| : "pcibridge5.virtualdev" => "pcieRootPort",
> |31856|56238:55974|image| : "pcibridge6.functions" => 8,
> |31856|56238:55974|image| : "pcibridge6.pcislotnumber" => 23,
> |31856|56238:55974|image| : "pcibridge6.present" => "TRUE",
> |31856|56238:55974|image| : "pcibridge6.virtualdev" => "pcieRootPort",
> |31856|56238:55974|image| : "pcibridge7.functions" => 8,
> |31856|56238:55974|image| : "pcibridge7.pcislotnumber" => 24,
> |31856|56238:55974|image| : "pcibridge7.present" => "TRUE",
> |31856|56238:55974|image| : "pcibridge7.virtualdev" => "pcieRootPort",
> |31856|56238:55974|image| : "powertype.poweroff" => "soft",
> |31856|56238:55974|image| : "powertype.poweron" => "hard",
> |31856|56238:55974|image| : "powertype.reset" => "soft",
> |31856|56238:55974|image| : "powertype.suspend" => "hard",
> |31856|56238:55974|image| : "replay.supported" => "FALSE",
> |31856|56238:55974|image| : "sched.mem.pshare.enable" => "FALSE",
> |31856|56238:55974|image| : "sched.swap.derivedname" =>
> "/vmfs/volumes/b254e2be-e75868fb/vmguest-37_114-v4/vmguest-37_114-v4-92eeafbd.vswp",
> |31856|56238:55974|image| : "snapshot.disabled" => "TRUE",
> |31856|56238:55974|image| : "svga.autodetect" => "TRUE",
> |31856|56238:55974|image| : "svga.vramsize" => 16777216,
> |31856|56238:55974|image| : "tools.remindinstall" => "FALSE",
> |31856|56238:55974|image| : "tools.synctime" => "FALSE",
> |31856|56238:55974|image| : "toolscripts.afterpoweron" => "FALSE",
> |31856|56238:55974|image| : "toolscripts.afterresume" => "FALSE",
> |31856|56238:55974|image| : "toolscripts.beforepoweroff" => "FALSE",
> |31856|56238:55974|image| : "toolscripts.beforesuspend" => "FALSE",
> |31856|56238:55974|image| : "usercpuid.0" =>
> "0000000b756e65476c65746e49656e69",
> |31856|56238:55974|image| : "usercpuid.1" =>
> "000106a500100800009822010febfbff",
> |31856|56238:55974|image| : "usercpuid.80000001" =>
> "00000000000000000000000128100800",
> |31856|56238:55974|image| : "uuid.action" => "keep",
> |31856|56238:55974|image| : "uuid.bios" => "56 4d 1b 88 36 f4 56
> 22-8b 80 4c b4 cc 54 f0 42",
> |31856|56238:55974|image| : "uuid.location" => "56 4d 1b 88 36 f4 56
> 22-8b 80 4c b4 cc 54 f0 42",
> |31856|56238:55974|image| : "virtualhw.productcompatibility" => "hosted",
> |31856|56238:55974|image| : "virtualhw.version" => 7,
> |31856|56238:55974|image| : "vmci0.id" => -866848702,
> |31856|56238:55974|image| : "vmci0.pcislotnumber" => 34,
> |31856|56238:55974|image| : "vmci0.present" => "TRUE",
> |31856|56238:55974|image| : "vmdk" => {
> |31856|56238:55974|image| : "ide0:0" => {
> |31856|56238:55974|image| : "mode" => "independent-persistent",
> |31856|56238:55974|image| : "present" => "TRUE",
> |31856|56238:55974|image| : "redo" => "",
> |31856|56238:55974|image| : "sharedbus" => "none",
> |31856|56238:55974|image| : "vmdk_directory_path" =>
> "/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4",
> |31856|56238:55974|image| : "vmdk_file_name" => "vmguest-37_114-v4",
> |31856|56238:55974|image| : "vmdk_file_path" =>
> "/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk",
> |31856|56238:55974|image| : "writethrough" => "TRUE"
> |31856|56238:55974|image| : }
> |31856|56238:55974|image| : },
> |31856|56238:55974|image| : "vmotion.checkpointfbsize" => 16777216,
> |31856|56238:55974|image| : "vmx_directory_path" =>
> "/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4",
> |31856|56238:55974|image| : "vmx_file_name" => "vmguest-37_114-v4.vmx"
> |31856|56238:55974|image| : }
> 2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:capture(507)|vmdk
> file path configured for VM vmguest-37 being captured:
> /vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk
> 2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:check_file_paths(3502)|successfully
> retrieved vmdk file path components:
> |31856|56238:55974|image| VM profile VM path:
> '/vmfs/volumes/netappfiler02-sata1'
> |31856|56238:55974|image| VM profile datastore path:
> '/vmfs/volumes/netappfiler02-sata1'
> |31856|56238:55974|image| vmdk file path:
> '/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk'
> |31856|56238:55974|image| vmdk directory path:
> '/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4'
> |31856|56238:55974|image| vmdk base directory path:
> '/vmfs/volumes/netappfiler02-sata1'
> |31856|56238:55974|image| vmdk directory name: 'vmguest-37_114-v4'
> |31856|56238:55974|image| vmdk file name:
> 'vmguest-37_114-v4.vmdk'
> |31856|56238:55974|image| vmdk file prefix: 'vmguest-37_114-v4'
> |31856|56238:55974|image| persistent vmdk file path:
> '/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk'
> |31856|56238:55974|image| persistent vmdk directory path:
> '/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4'
> |31856|56238:55974|image| persistent vmdk directory name: 'vmguest-37_114-v4'
> |31856|56238:55974|image| nonpersistent vmdk file path:
> '/vmfs/volumes/netappfiler02-sata1/vmwarewinxp-CSUEBVisualStudio2010Express114-v5/vmwarewinxp-CSUEBVisualStudio2010Express114-v5.vmdk'
> |31856|56238:55974|image| nonpersistent vmdk directory path:
> '/vmfs/volumes/netappfiler02-sata1/vmwarewinxp-CSUEBVisualStudio2010Express114-v5'
> |31856|56238:55974|image| nonpersistent vmdk directory name:
> 'vmwarewinxp-CSUEBVisualStudio2010Express114-v5'
> 2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:set_vmdk_file_path(3435)|set
> overridden vmdk file path:
> '/vmfs/volumes/netappfiler02-sata1/vmguest-37_114-v4/vmguest-37_114-v4.vmdk'
> 2011-08-03 15:31:52|31856|56238:55974|image|VMware.pm:capture(531)|mode
> of vmdk to be captured is valid: independent-persistent
> 2011-08-03 15:31:52|31856|56238:55974|image|Linux.pm:file_exists(1390)|file
> or directory does not exist on vclesxi20:
> '/vmfs/volumes/netappfiler02-sata1/vmwarewinxp-CSUEBVisualStudio2010Express114-v5/vmwarewinxp-CSUEBVisualStudio2010Express114-v5.vmdk'
> 2011-08-03 15:31:52|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
> SSH command on vmguest-37:
> |31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
> StrictHostKeyChecking=no -l root -p 22 -x vmguest-37 'chown root
> currentimage.txt; chmod 777 currentimage.txt' 2>&1
> 2011-08-03 15:32:00|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
> output:
> 2011-08-03 15:32:00|31856|56238:55974|image|utils.pm:run_ssh_command(5478)|SSH
> command executed on vmguest-37, returning (0, "")
> 2011-08-03 15:32:00|31856|56238:55974|image|utils.pm:write_currentimage_txt(5685)|updated
> ownership and permissions on currentimage.txt
> 2011-08-03 15:32:00|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
> SSH command on vmguest-37:
> |31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
> StrictHostKeyChecking=no -l root -p 22 -x vmguest-37 'echo -e
> "vmwarewinxp-CSUEBVisualStudio2010Express114-v5\r\nid=114\r\nprettyname=CSUEB
> Visual Studio 2010
> Express\r\nimagerevision_id=276\r\nimagerevision_datecreated=2011-08-03
> 15:29:03\r\ncomputer_id=41\r\ncomputer_hostname=vmguest-37" >
> currentimage.txt && cat currentimage.txt' 2>&1
> 2011-08-03 15:32:05|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
> output:
> |31856|56238:55974|image| vmwarewinxp-CSUEBVisualStudio2010Express114-v5
> |31856|56238:55974|image| id=114
> |31856|56238:55974|image| prettyname=CSUEB Visual Studio 2010 Express
> |31856|56238:55974|image| imagerevision_id=276
> |31856|56238:55974|image| imagerevision_datecreated=2011-08-03 15:29:03
> |31856|56238:55974|image| computer_id=41
> |31856|56238:55974|image| computer_hostname=vmguest-37
> 2011-08-03 15:32:05|31856|56238:55974|image|utils.pm:run_ssh_command(5478)|SSH
> command executed on vmguest-37, returning (0,
> "vmwarewinxp-CSUEBVisualStudio2...")
> 2011-08-03 15:32:05|31856|56238:55974|image|utils.pm:write_currentimage_txt(5695)|created
> currentimage.txt file on vmguest-37:
> |31856|56238:55974|image| vmwarewinxp-CSUEBVisualStudio2010Express114-v5
> |31856|56238:55974|image| id=114
> |31856|56238:55974|image| prettyname=CSUEB Visual Studio 2010 Express
> |31856|56238:55974|image| imagerevision_id=276
> |31856|56238:55974|image| imagerevision_datecreated=2011-08-03 15:29:03
> |31856|56238:55974|image| computer_id=41
> |31856|56238:55974|image| computer_hostname=vmguest-37
> 2011-08-03 15:32:05|31856|56238:55974|image|DataStructure.pm:_automethod(834)|data
> structure updated:
> $self->request_data->{reservation}{55974}{image}{imagemeta}{sysprep}
> |31856|56238:55974|image| imagemeta_sysprep = 0
> 2011-08-03 15:32:05|31856|56238:55974|image|Version_5.pm:pre_capture(104)|calling
> parent class pre_capture() subroutine
> 2011-08-03 15:32:05|31856|56238:55974|image|Windows.pm:pre_capture(231)|beginning
> Windows image capture preparation tasks on vmguest-37
> 2011-08-03 15:32:05|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
> SSH command on vmguest-37:
> |31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
> StrictHostKeyChecking=no -l root -p 22 -x vmguest-37
> 'C:/Windows/System32/qwinsta.exe' 2>&1
> 2011-08-03 15:32:11|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
> output:
> |31856|56238:55974|image| SESSIONNAME USERNAME ID STATE TYPE DEVICE
> |31856|56238:55974|image| >console 0 Conn wdcon
> |31856|56238:55974|image| rdp-tcp 65536 Listen rdpwd
> |31856|56238:55974|image| Administrator 2 Disc rdpwd
> 2011-08-03 15:32:11|31856|56238:55974|image|utils.pm:run_ssh_command(5478)|SSH
> command executed on vmguest-37, returning (0, "SESSIONNAME USERNAME ID
> STATE ...")
> 2011-08-03 15:32:11|31856|56238:55974|image|Windows.pm:set_password(1905)|setting
> password of root to vclPassword on vmguest-37
> 2011-08-03 15:32:11|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
> SSH command on vmguest-37:
> |31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
> StrictHostKeyChecking=no -l root -p 22 -x vmguest-37
> 'C:/Windows/System32/net.exe user root 'vclPassword'' 2>&1
> 2011-08-03 15:32:16|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
> output:
> |31856|56238:55974|image| The command completed successfully.
> 2011-08-03 15:32:16|31856|56238:55974|image|utils.pm:run_ssh_command(5478)|SSH
> command executed on vmguest-37, returning (0, "The command completed
> successf...")
> 2011-08-03 15:32:16|31856|56238:55974|image|Windows.pm:set_password(1907)|password
> changed to 'vclPassword' for user 'root' on vmguest-37
> 2011-08-03 15:32:16|31856|56238:55974|image|Windows.pm:set_password(1921)|root
> account password changed, must also change sshd service credentials
> 2011-08-03 15:32:16|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
> SSH command on vmguest-37:
> |31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
> StrictHostKeyChecking=no -l root -p 22 -x vmguest-37
> 'C:/Windows/System32/sc.exe config sshd obj= ".\root" password=
> "vclPassword"' 2>&1
> 2011-08-03 15:32:21|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
> output:
> |31856|56238:55974|image| [SC] ChangeServiceConfig SUCCESS
> 2011-08-03 15:32:21|31856|56238:55974|image|utils.pm:run_ssh_command(5478)|SSH
> command executed on vmguest-37, returning (0, "[SC]
> ChangeServiceConfig SUCCE...")
> 2011-08-03 15:32:21|31856|56238:55974|image|Windows.pm:set_service_credentials(3795)|changed
> logon credentials for 'sshd' service to root (vclPassword) on
> vmguest-37
> 2011-08-03 15:32:21|31856|56238:55974|image|Windows.pm:set_password(1929)|changing
> passwords for scheduled tasks
> 2011-08-03 15:32:26|31856|56238:55974|image|Windows.pm:set_password(1931)|queried
> scheduled tasks on vmguest-37
> 2011-08-03 15:32:26|31856|56238:55974|image|Windows.pm:set_password(1982)|changed
> password for user: root
> 2011-08-03 15:32:26|31856|56238:55974|image|Windows.pm:delete_user(1834)|attempting
> to delete user wv4973 from vmguest-37
> 2011-08-03 15:32:26|31856|56238:55974|image|utils.pm:run_ssh_command(5380)|executing
> SSH command on vmguest-37:
> |31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
> StrictHostKeyChecking=no -l root -p 22 -x vmguest-37
> 'C:/Windows/System32/net.exe user wv4973 /DELETE' 2>&1
> 2011-08-03 15:32:32|31856|56238:55974|image|utils.pm:run_ssh_command(5464)|run_ssh_command
> output:
> |31856|56238:55974|image| The user name could not be found.
> |31856|56238:55974|image| More help is available by typing NET HELPMSG 2221.
> 2011-08-03 15:32:32|31856|56238:55974|image|utils.pm:run_ssh_command(5474)|SSH
> command executed on vmguest-37, command:
> |31856|56238:55974|image| /usr/bin/ssh -i /etc/vcl/vcl.key -o
> StrictHostKeyChecking=no -l root -p 22 -x vmguest-37
> 'C:/Windows/System32/net.exe user wv4973 /DELETE' 2>&1
> |31856|56238:55974|image| returning (2, "The user name could not be fou...")
> 2011-08-03 15:32:32|31856|56238:55974|image|Windows.pm:delete_user(1839)|user
> wv4973 was not deleted because user does not exist
> 2011-08-03 15:32:37|31856|56238:55974|image|Windows.pm:file_exists(1336)|file
> does NOT exist on vmguest-37: 'C:/Documents and Settings/wv4973'
> 2011-08-03 15:32:37|31856|56238:55974|image|Windows.pm:delete_file(1095)|failed
> not deleted because it does not exist: 'C:/Documents and
> Settings/wv4973'
> 2011-08-03 15:32:37|31856|56238:55974|image|Windows.pm:delete_user(1855)|deleted
> profile for user wv4973 from vmguest-37
> 2011-08-03 15:32:37|31856|56238:55974|image|Windows.pm:delete_users(1609)|deleted
> 1 users from vmguest-37
> |31856|56238:55974|image| ---- WARNING ----
> |31856|56238:55974|image| 2011-08-03
> 15:32:49|31856|56238:55974|image|Windows.pm:set_file_owner(1398)|error
> occurred setting root as the owner of /home/root, error output:
> |31856|56238:55974|image| /usr/bin/chown: cannot read directory
> `/home/root/.ssh': Permission denied
> |31856|56238:55974|image| failed to change ownership of
> `/home/root/.ssh' to root
> |31856|56238:55974|image| ( 0) Windows.pm, set_file_owner (line: 1398)
> |31856|56238:55974|image| (-1) Windows.pm, pre_capture (line: 272)
> |31856|56238:55974|image| (-2) Version_5.pm, pre_capture (line: 105)
> |31856|56238:55974|image| (-3) VMware.pm, capture (line: 556)
> |31856|56238:55974|image| (-4) image.pm, process (line: 162)
> |31856|56238:55974|image| (-5) vcld, make_new_child (line: 568)
> |31856|56238:55974|image| ---- WARNING ----
> |31856|56238:55974|image| 2011-08-03
> 15:32:49|31856|56238:55974|image|Windows.pm:pre_capture(273)|unable to
> set root as the owner of /home/root
> |31856|56238:55974|image| ( 0) Windows.pm, pre_capture (line: 273)
> |31856|56238:55974|image| (-1) Version_5.pm, pre_capture (line: 105)
> |31856|56238:55974|image| (-2) VMware.pm, capture (line: 556)
> |31856|56238:55974|image| (-3) image.pm, process (line: 162)
> |31856|56238:55974|image| (-4) vcld, make_new_child (line: 568)
> |31856|56238:55974|image| (-5) vcld, main (line: 346)
> |31856|56238:55974|image| ---- WARNING ----
> |31856|56238:55974|image| 2011-08-03
> 15:32:49|31856|56238:55974|image|Version_5.pm:pre_capture(109)|failed
> to execute parent class pre_capture() subroutine
> |31856|56238:55974|image| ( 0) Version_5.pm, pre_capture (line: 109)
> |31856|56238:55974|image| (-1) VMware.pm, capture (line: 556)
> |31856|56238:55974|image| (-2) image.pm, process (line: 162)
> |31856|56238:55974|image| (-3) vcld, make_new_child (line: 568)
> |31856|56238:55974|image| (-4) vcld, main (line: 346)
> |31856|56238:55974|image| ---- WARNING ----
> |31856|56238:55974|image| 2011-08-03
> 15:32:49|31856|56238:55974|image|VMware.pm:capture(557)|failed to
> complete OS module's pre_capture tasks
> |31856|56238:55974|image| ( 0) VMware.pm, capture (line: 557)
> |31856|56238:55974|image| (-1) image.pm, process (line: 162)
> |31856|56238:55974|image| (-2) vcld, make_new_child (line: 568)
> |31856|56238:55974|image| (-3) vcld, main (line: 346)
> |31856|56238:55974|image| ---- WARNING ----
> |31856|56238:55974|image| 2011-08-03
> 15:32:49|31856|56238:55974|image|image.pm:process(166)|vmwarewinxp-CSUEBVisualStudio2010Express114-v5
> image failed to be captured by provisioning module
> |31856|56238:55974|image| ( 0) image.pm, process (line: 166)
> |31856|56238:55974|image| (-1) vcld, make_new_child (line: 568)
> |31856|56238:55974|image| (-2) vcld, main (line: 346)
> 2011-08-03 15:32:49|31856|56238:55974|image|DataStructure.pm:get_computer_private_ip_address(1557)|returning
> private IP address previously retrieved: 10.10.10.117
> 2011-08-03 15:32:49|31856|56238:55974|image|utils.pm:is_inblockrequest(6163)|zero
> rows were returned from database select
> 2011-08-03 15:32:49|31856|56238:55974|image|DataStructure.pm:get_image_affiliation_name(2035)|image
> owner id: 10
> 2011-08-03 15:32:49|31856|56238:55974|image|utils.pm:getnewdbh(2709)|database
> requested (information_schema) does not match handle stored in
> $ENV{dbh} (vcl:localhost)
> 2011-08-03 15:32:49|31856|56238:55974|image|utils.pm:getnewdbh(2760)|database
> handle stored in $ENV{dbh}
> 2011-08-03 15:32:49|31856|56238:55974|image|DataStructure.pm:retrieve_user_data(1352)|attempting
> to retrieve and store data for user: user.id = '10'
> 2011-08-03 15:32:49|31856|56238:55974|image|utils.pm:getnewdbh(2709)|database
> requested (vcl) does not match handle stored in $ENV{dbh}
> (information_schema:localhost)
> 2011-08-03 15:32:49|31856|56238:55974|image|utils.pm:getnewdbh(2760)|database
> handle stored in $ENV{dbh}
> 2011-08-03 15:32:49|31856|56238:55974|image|DataStructure.pm:retrieve_user_data(1415)|data
> has been retrieved for user: wv4973 (id: 10)
> 2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:mail(1255)|SUCCESS
> -- Sending mail To: alexander.patterson@csueastbay.edu, PROBLEM --
> 56238:55974|image|image.pm|vmguest-37>vclesxi20|vmwarewinxp-CSUEBVisualStudio2010Express114-v5|wv4973
> |31856|56238:55974|image| ---- CRITICAL ----
> |31856|56238:55974|image| 2011-08-03
> 15:32:49|31856|56238:55974|image|image.pm:reservation_failed(385)|vmwarewinxp-CSUEBVisualStudio2010Express114-v5
> image creation failed
> |31856|56238:55974|image| ( 0) image.pm, reservation_failed (line: 385)
> |31856|56238:55974|image| (-1) image.pm, process (line: 167)
> |31856|56238:55974|image| (-2) vcld, make_new_child (line: 568)
> |31856|56238:55974|image| (-3) vcld, main (line: 346)
> 2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:mail(1255)|SUCCESS
> -- Sending mail To: alexander.patterson@csueastbay.edu, VCL -- NOTICE
> DELAY Image Creation CSUEB Visual Studio 2010 Express
> 2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:mail(1255)|SUCCESS
> -- Sending mail To: alexander.patterson@csueastbay.edu, VCL -- NOTICE
> FAILED Image Creation CSUEB Visual Studio 2010 Express
> 2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:update_request_state(1991)|request
> 56238 state updated to: maintenance, laststate to: image
> 2011-08-03 15:32:55|31856|56238:55974|image|image.pm:reservation_failed(437)|request
> state set to maintenance, laststate to image
> 2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:update_computer_state(2033)|computer
> 41 state updated to: maintenance
> 2011-08-03 15:32:55|31856|56238:55974|image|image.pm:reservation_failed(445)|vmguest-37
> state set to maintenance
> 2011-08-03 15:32:55|31856|56238:55974|image|image.pm:reservation_failed(452)|exiting
> 2011-08-03 15:32:55|31856|56238:55974|image|State.pm:DESTROY(829)|VCL::image
> destructor called, address: 1a510d10
> 2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:delete_computerloadlog_reservation(6742)|removing
> computerloadlog entries matching loadstate = begin
> 2011-08-03 15:32:55|31856|56238:55974|image|utils.pm:delete_computerloadlog_reservation(6789)|deleted
> rows from computerloadlog for reservation id=55974
> 2011-08-03 15:32:55|31856|56238:55974|image|State.pm:DESTROY(848)|number
> of database handles state process created: 3
> 2011-08-03 15:32:55|31856|56238:55974|image|State.pm:DESTROY(876)|VCL::image
> process duration: 234 seconds
> 2011-08-03 15:32:55|31856|56238:55974|image|VIM_SSH.pm:DESTROY(1685)|vim-cmd
> call count: 12
>
>
> --
> Thanks,
> Alex Patterson
> User Support Services
> Operating System Analyst
> California State University, East Bay
>