You are viewing a plain text version of this content. The canonical link for it is here.
Posted to user@vcl.apache.org by António Aragão <aa...@di.uminho.pt> on 2015/10/06 16:52:22 UTC

Fwd: PROBLEM -- vclnode1|281:281|image|image.pm|vm21>servidor12.di.uminho.pt|vmwarewinxp-XP32_20151006_198-v0|admin

Hi,

any help with this ? I'm getting this error: This operation is only allowed
on the primary domain controller of the domain.

I don't use any primary domain controller.

Thanks.

---------- Forwarded message ----------
From: <ro...@vclnode1.apachevcl.di.uminho.pt>
Date: 2015-10-06 15:27 GMT+01:00
Subject: PROBLEM -- vclnode1|281:281|image|image.pm|vm21>
servidor12.di.uminho.pt|vmwarewinxp-XP32_20151006_198-v0|admin
To: aaragao@di.uminho.pt


vmwarewinxp-XP32_20151006_198-v0 image creation failed
------------------------------------------------------------------------
time: 2015-10-06 15:27:12
caller: image.pm:reservation_failed(387)
( 0) image.pm, reservation_failed (line: 387)
(-1) image.pm, process (line: 167)
(-2) vcld, make_new_child (line: 571)
(-3) vcld, main (line: 350)
------------------------------------------------------------------------
management node: vclnode1.apachevcl.di.uminho.pt
reservation PID: 20034
parent vcld PID: 1826

request ID: 281
reservation ID: 281
request state/laststate: image/inuse
request start time: 2015-10-06 14:30:00
request end time: 2015-10-30 16:00:00
for imaging: yes
log ID: 239

computer: vm21.apachevcl.di.uminho.pt
computer id: 25
computer type: virtualmachine
computer eth0 MAC address: 00:50:56:00:00:28
computer eth1 MAC address: 00:50:56:00:00:29
computer private IP address: 10.100.0.121
computer public IP address: 192.168.93.121
computer in block allocation: no
provisioning module: VCL::Module::Provisioning::VMware::VMware

vm host: servidor12.di.uminho.pt
vm host ID: 1
vm host computer ID: 1
vm profile: vmhostprofile1
vm profile VM path: /vmfs/volumes/datastore1/
vm profile repository path: /vmfs/volumes/vcl_images/
vm profile datastore path: /vmfs/volumes/datastore1/
vm profile disk type: shared

image: vmwarewinxp-XP32_20151006_198-v0
image display name: XP32_20151006_1
image ID: 98
image revision ID: 95
image size: 1450 MB
use Sysprep: no
root access: yes
image owner ID: 1
image owner affiliation: Local
image revision date created: 2015-10-06 15:26:17
image revision production: yes
OS module: VCL::Module::OS::Windows::Version_5::XP

user: admin
user name: vcl admin
user ID: 1
user affiliation: Local
------------------------------------------------------------------------
RECENT LOG ENTRIES FOR THIS PROCESS:
2015-10-06 15:26:40|20034|281:281|image|utils.pm:run_ssh_command(5030)|SSH
command executed on servidor12, command:
|20034|281:281|image| /usr/bin/ssh -i /etc/vcl/vcl.key  -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x servidor12 'stat
/vmfs/volumes/datastore1/vmwarewinxp\-XP32_20151006_198\-v0/vmwarewinxp\-XP32_20151006_198\-v0\.vmdk'
2>&1
|20034|281:281|image| returning (1, "stat: can't stat '/vmfs/volume...")
2015-10-06 15:26:40|20034|281:281|image|utils.pm:run_ssh_command(4902)|executing
SSH command on vm21:
|20034|281:281|image| /usr/bin/ssh -i /etc/vcl/vcl.key  -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x vm21 'chown root
currentimage.txt; chmod 777 currentimage.txt' 2>&1
2015-10-06 15:26:48|20034|281:281|image|utils.pm:run_ssh_command(5020)|run_ssh_command
output:
2015-10-06 15:26:48|20034|281:281|image|utils.pm:run_ssh_command(5034)|SSH
command executed on vm21, returning (0, "")
2015-10-06 15:26:48|20034|281:281|image|utils.pm:write_currentimage_txt(5242)|updated
ownership and permissions on currentimage.txt
2015-10-06 15:26:48|20034|281:281|image|utils.pm:run_ssh_command(4902)|executing
SSH command on vm21:
|20034|281:281|image| /usr/bin/ssh -i /etc/vcl/vcl.key  -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x vm21 'echo -e
"vmwarewinxp-XP32_20151006_198-v0\r\nid=98\r\nprettyname=XP32_20151006_1\r\nimagerevision_id=95\r\nimagerevision_datecreated=2015-10-06
15:26:17\r\ncomputer_id=25\r\ncomputer_hostname=vm21.apachevcl.di.uminho.pt"
> currentimage.txt && cat currentimage.txt' 2>&1
2015-10-06 15:26:49|20034|281:281|image|utils.pm:run_ssh_command(5020)|run_ssh_command
output:
|20034|281:281|image| vmwarewinxp-XP32_20151006_198-v0
|20034|281:281|image| id=98
|20034|281:281|image| prettyname=XP32_20151006_1
|20034|281:281|image| imagerevision_id=95
|20034|281:281|image| imagerevision_datecreated=2015-10-06 15:26:17
|20034|281:281|image| computer_id=25
|20034|281:281|image| computer_hostname=vm21.apachevcl.di.uminho.pt
2015-10-06 15:26:49|20034|281:281|image|utils.pm:run_ssh_command(5034)|SSH
command executed on vm21, returning (0, "vmwarewinxp-XP32_20151006_198-...")
2015-10-06 15:26:49|20034|281:281|image|utils.pm:write_currentimage_txt(5260)|created
currentimage.txt file on vm21:
|20034|281:281|image| vmwarewinxp-XP32_20151006_198-v0
|20034|281:281|image| id=98
|20034|281:281|image| prettyname=XP32_20151006_1
|20034|281:281|image| imagerevision_id=95
|20034|281:281|image| imagerevision_datecreated=2015-10-06 15:26:17
|20034|281:281|image| computer_id=25
|20034|281:281|image| computer_hostname=vm21.apachevcl.di.uminho.pt
2015-10-06
15:26:49|20034|281:281|image|DataStructure.pm:_automethod(847)|data
structure updated, hash path:
$self->request_data->{reservation}{281}{image}{imagemeta}{sysprep}, data
identifier: imagemeta_sysprep, data:
|20034|281:281|image| : 0
2015-10-06
15:26:49|20034|281:281|image|Version_5.pm:pre_capture(104)|calling parent
class pre_capture() subroutine
2015-10-06 15:26:49|20034|281:281|image|OS.pm:pre_capture(89)|beginning
common image capture preparation tasks
2015-10-06 15:26:51|20034|281:281|image|OS.pm:is_ssh_responding(678)|vm21
is responding to SSH, port 22: open, port 24: closed
2015-10-06
15:26:52|20034|281:281|image|OS.pm:create_text_file(1851)|created file on
vm21: ~/currentimage.txt
2015-10-06 15:26:52|20034|281:281|image|OS.pm:pre_capture(125)|completed
common image capture preparation tasks
2015-10-06
15:26:52|20034|281:281|image|Windows.pm:pre_capture(277)|beginning Windows
image capture preparation tasks on vm21
2015-10-06 15:26:52|20034|281:281|image|utils.pm:run_ssh_command(4902)|executing
SSH command on vm21:
|20034|281:281|image| /usr/bin/ssh -i /etc/vcl/vcl.key  -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x vm21
'C:/Windows/System32/qwinsta.exe' 2>&1
2015-10-06 15:26:52|20034|281:281|image|utils.pm:(eval)(4917)|waiting up to
60 seconds for SSH process to finish
2015-10-06
15:26:54|20034|281:281|image|Windows.pm:logoff_users(1636)|attempting to
kill connection:
|20034|281:281|image| line: ' rdp-tcp#1         admin
 1  Active  rdpwd'
|20034|281:281|image| session identifier: 1
2015-10-06 15:26:54|20034|281:281|image|utils.pm:run_ssh_command(4902)|executing
SSH command on vm21:
|20034|281:281|image| /usr/bin/ssh -i /etc/vcl/vcl.key  -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x vm21
'C:/Windows/System32/logoff.exe 1 /V' 2>&1
2015-10-06 15:27:10|20034|281:281|image|utils.pm:run_ssh_command(5020)|run_ssh_command
output:
|20034|281:281|image| Logging off session ID 1
2015-10-06 15:27:10|20034|281:281|image|utils.pm:run_ssh_command(5034)|SSH
command executed on vm21, returning (0, "Logging off session ID 1")
2015-10-06
15:27:10|20034|281:281|image|Windows.pm:logoff_users(1646)|logged off
session: 1, output:
|20034|281:281|image| Logging off session ID 1
2015-10-06
15:27:10|20034|281:281|image|Windows.pm:set_password(1963)|setting password
of root to cl0udy on vm21
2015-10-06 15:27:10|20034|281:281|image|utils.pm:run_ssh_command(4902)|executing
SSH command on vm21:
|20034|281:281|image| /usr/bin/ssh -i /etc/vcl/vcl.key  -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x vm21
'C:/Windows/System32/net.exe user root 'cl0udy'' 2>&1
2015-10-06 15:27:12|20034|281:281|image|utils.pm:run_ssh_command(5020)|run_ssh_command
output:
|20034|281:281|image| This operation is only allowed on the primary domain
controller of the domain.
|20034|281:281|image| More help is available by typing NET HELPMSG 2226.
2015-10-06 15:27:12|20034|281:281|image|utils.pm:run_ssh_command(5030)|SSH
command executed on vm21, command:
|20034|281:281|image| /usr/bin/ssh -i /etc/vcl/vcl.key  -o
StrictHostKeyChecking=no -o UserKnownHostsFile=/dev/null -o
ConnectionAttempts=1 -o ConnectTimeout=3 -l root -p 22 -x vm21
'C:/Windows/System32/net.exe user root 'cl0udy'' 2>&1
|20034|281:281|image| returning (2, "This operation is only allowed...")
|20034|281:281|image| ---- WARNING ----
|20034|281:281|image| 2015-10-06
15:27:12|20034|281:281|image|Windows.pm:set_password(1969)|failed to change
password to 'cl0udy' for user 'root' on vm21, exit status: 2, output:
|20034|281:281|image| This operation is only allowed on the primary domain
controller of the domain.
|20034|281:281|image| More help is available by typing NET HELPMSG 2226.
|20034|281:281|image| ( 0) Windows.pm, set_password (line: 1969)
|20034|281:281|image| (-1) Windows.pm, pre_capture (line: 296)
|20034|281:281|image| (-2) Version_5.pm, pre_capture (line: 105)
|20034|281:281|image| (-3) VMware.pm, capture (line: 712)
|20034|281:281|image| (-4) image.pm, process (line: 162)
|20034|281:281|image| (-5) vcld, make_new_child (line: 571)
|20034|281:281|image| ---- WARNING ----
|20034|281:281|image| 2015-10-06
15:27:12|20034|281:281|image|Windows.pm:pre_capture(297)|unable to set root
password
|20034|281:281|image| ( 0) Windows.pm, pre_capture (line: 297)
|20034|281:281|image| (-1) Version_5.pm, pre_capture (line: 105)
|20034|281:281|image| (-2) VMware.pm, capture (line: 712)
|20034|281:281|image| (-3) image.pm, process (line: 162)
|20034|281:281|image| (-4) vcld, make_new_child (line: 571)
|20034|281:281|image| (-5) vcld, main (line: 350)
|20034|281:281|image| ---- WARNING ----
|20034|281:281|image| 2015-10-06
15:27:12|20034|281:281|image|Version_5.pm:pre_capture(109)|failed to
execute parent class pre_capture() subroutine
|20034|281:281|image| ( 0) Version_5.pm, pre_capture (line: 109)
|20034|281:281|image| (-1) VMware.pm, capture (line: 712)
|20034|281:281|image| (-2) image.pm, process (line: 162)
|20034|281:281|image| (-3) vcld, make_new_child (line: 571)
|20034|281:281|image| (-4) vcld, main (line: 350)
|20034|281:281|image| ---- WARNING ----
|20034|281:281|image| 2015-10-06
15:27:12|20034|281:281|image|VMware.pm:capture(713)|failed to complete OS
module's pre_capture tasks
|20034|281:281|image| ( 0) VMware.pm, capture (line: 713)
|20034|281:281|image| (-1) image.pm, process (line: 162)
|20034|281:281|image| (-2) vcld, make_new_child (line: 571)
|20034|281:281|image| (-3) vcld, main (line: 350)
|20034|281:281|image| ---- WARNING ----
|20034|281:281|image| 2015-10-06
15:27:12|20034|281:281|image|image.pm:process(166)|vmwarewinxp-XP32_20151006_198-v0
image failed to be captured by provisioning module
|20034|281:281|image| ( 0) image.pm, process (line: 166)
|20034|281:281|image| (-1) vcld, make_new_child (line: 571)
|20034|281:281|image| (-2) vcld, main (line: 350)
2015-10-06 15:27:12|20034|281:281|image|utils.pm:get_management_node_info(5456)|retrieving
current management node info for 'vclnode1.apachevcl.di.uminho.pt' from
database, cached data is stale: 61 seconds old
2015-10-06 15:27:12|20034|281:281|image|utils.pm:get_management_node_info(5603)|retrieved
management node info: 'vclnode1.apachevcl.di.uminho.pt' (vclnode1)
2015-10-06
15:27:12|20034|281:281|image|DataStructure.pm:get_computer_private_ip_address(1617)|returning
private IP address previously retrieved: 10.100.0.121
2015-10-06 15:27:12|20034|281:281|image|utils.pm:is_inblockrequest(5760)|zero
rows were returned from database select
2015-10-06
15:27:12|20034|281:281|image|DataStructure.pm:get_image_affiliation_name(2121)|image
owner id: 1
2015-10-06
15:27:12|20034|281:281|image|DataStructure.pm:retrieve_user_data(1412)|attempting
to retrieve and store data for user: user.id = '1'
2015-10-06
15:27:12|20034|281:281|image|DataStructure.pm:retrieve_user_data(1475)|data
has been retrieved for user: admin (id: 1)



--