December 2013 - Users - oVirt List Archives

[Users] Using storage network for gluster
by Juan Pablo Lorier 06 Dec '13

06 Dec '13

H, I'm experimenting with gluster and as my DC is a iscsi dc, I've just created a new cluster with two hosts and now I'm trying to create a volume. I've followed all kind of guides in the web without success. Now I'm having ovirt to complaint about a network error in the volume creation and I'd like to ask two things: - Why I must use ovirtmgmt network for gluster (can't choose other from the add brick drop down list) instead of the network I have set up for iscsi? - What may be the problem with network? I get success on both hosts when I proob each other # gluster peer probe ovirt3.montecarlotv.com.uy peer probe: success: host ovirt3.montecarlotv.com.uy port 24007 already in peer list # gluster peer probe ovirt4.montecarlotv.com.uy peer probe: success: host ovirt4.montecarlotv.com.uy port 24007 already in peer list I get a lot of this ones in engine log: 2013-12-05 03:40:01,882 ERROR [org.ovirt.engine.core.bll.gluster.GlusterSyncJob] (DefaultQuartzScheduler_Worker-50) Error while refreshing Gluster lightweight data of cluster Penryn!: org.ovirt.engine.core.common.errors.VdcBLLException: VdcBLLException: org.ovirt.engine.core.vdsbroker.vdsbroker.VDSNetworkException: org.apache.xmlrpc.XmlRpcException: <type 'exceptions.Exception'>:method "glusterVolumesList" is not supported (Failed with error VDS_NETWORK_ERROR and code 5022) at org.ovirt.engine.core.bll.VdsHandler.handleVdsResult(VdsHandler.java:122) [bll.jar:] at org.ovirt.engine.core.bll.VDSBrokerFrontendImpl.RunVdsCommand(VDSBrokerFrontendImpl.java:33) [bll.jar:] at org.ovirt.engine.core.bll.gluster.GlusterJob.runVdsCommand(GlusterJob.java:64) [bll.jar:] at org.ovirt.engine.core.bll.gluster.GlusterSyncJob.fetchVolumes(GlusterSyncJob.java:389) [bll.jar:] at org.ovirt.engine.core.bll.gluster.GlusterSyncJob.fetchVolumes(GlusterSyncJob.java:375) [bll.jar:] at org.ovirt.engine.core.bll.gluster.GlusterSyncJob.refreshVolumeData(GlusterSyncJob.java:346) [bll.jar:] at org.ovirt.engine.core.bll.gluster.GlusterSyncJob.refreshClusterData(GlusterSyncJob.java:104) [bll.jar:] at org.ovirt.engine.core.bll.gluster.GlusterSyncJob.refreshLightWeightData(GlusterSyncJob.java:83) [bll.jar:] at sun.reflect.GeneratedMethodAccessor99.invoke(Unknown Source) [:1.7.0_45] at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_45] at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_45] at org.ovirt.engine.core.utils.timer.JobWrapper.execute(JobWrapper.java:60) [scheduler.jar:] at org.quartz.core.JobRunShell.run(JobRunShell.java:213) [quartz.jar:] at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:557) [quartz.jar:] So I guess there's something with gluster version maybe: glusterfs.x86_64 3.4.0-8.el6 @glusterfs-epel glusterfs-api.x86_64 3.4.0-8.el6 @glusterfs-epel glusterfs-cli.x86_64 3.4.0-8.el6 @glusterfs-epel glusterfs-fuse.x86_64 3.4.0-8.el6 @glusterfs-epel glusterfs-libs.x86_64 3.4.0-8.el6 @glusterfs-epel glusterfs-rdma.x86_64 3.4.0-8.el6 @glusterfs-epel glusterfs-server.x86_64 3.4.0-8.el6 @glusterfs-epel vdsm-gluster.noarch 4.13.0-11.el6 @ovirt-stable this are the main links I used to configure: http://www.andrewklau.com/returning-to-glusterized-ovirt-3-3/ http://www.gluster.org/2013/09/ovirt-3-3-glusterized/ Regards

3 5

[Users] oVirt auditing
by Jakub Bittner 06 Dec '13

06 Dec '13

This is a multi-part message in MIME format. --------------000306080908080906080609 Content-Type: text/plain; charset=ISO-8859-2; format=flowed Content-Transfer-Encoding: 7bit Hello, I am curious how to audit user actions in oVirt web interface. From engine.log we are able to extract when user logged in, when he updated vnicProfile and so, but we can not get exact changes (behavior). Right now I can get logs like: 2013-12-05 16:35:46,270 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-6) Correlation ID: 7e60ae1, Call Stack: null, Custom Event ID: -1, Message: Interface nic1 (VirtIO) was updated for VM test.test.org. (User: user1) But it would be nice to get logs like: 2013-12-05 16:35:46,270 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-6) Correlation ID: 7e60ae1, Call Stack: null, Custom Event ID: -1, Message: Interface nic1 (VirtIO) was updated for VM test.test.org *from secure_vlan to unsecure_vlan*. (User: user1) My point is to have a feature which can give us possibility to construct exact user behavior and action in managing oVirt. It could be useful not even in hunting bugs, but primary in security problem hunting. Thank you. Jakub Bittner --------------000306080908080906080609 Content-Type: text/html; charset=ISO-8859-2 Content-Transfer-Encoding: 8bit <html> <head> <meta http-equiv="content-type" content="text/html; charset=ISO-8859-2"> </head> <body bgcolor="#FFFFFF" text="#000000"> Hello, I am curious how to audit user actions in oVirt web interface. From engine.log we are able to extract when user logged in, when he updated vnicProfile and so, but we can not get exact changes (behavior). Right now I can get logs like: 2013-12-05 16:35:46,270 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-6) Correlation ID: 7e60ae1, Call Stack: null, Custom Event ID: -1, Message: Interface nic1 (VirtIO) was updated for VM test.test.org. (User: user1) But it would be nice to get logs like: 2013-12-05 16:35:46,270 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-6) Correlation ID: 7e60ae1, Call Stack: null, Custom Event ID: -1, Message: Interface nic1 (VirtIO) was updated for VM test.test.org from secure_vlan to unsecure_vlan. (User: user1) My point is to have a feature which can give us possibility to construct exact user behavior and action in managing oVirt. It could be useful not even in hunting bugs, but primary in security problem hunting. Thank you. Jakub Bittner </body> </html> --------------000306080908080906080609--

4 6

[Users] External authentication
by Maurice James 06 Dec '13

06 Dec '13

------=_NextPart_000_0003_01CEF1F6.79F018B0 Content-Type: text/plain; charset="us-ascii" Content-Transfer-Encoding: 7bit Does anyone know how to get external authentication to 389-ds "without" Kerberos support. I am quite happy with LDAPS and would prefer not to introduce more complexity. Thanks ------=_NextPart_000_0003_01CEF1F6.79F018B0 Content-Type: text/html; charset="us-ascii" Content-Transfer-Encoding: quoted-printable <html xmlns:v=3D"urn:schemas-microsoft-com:vml" = xmlns:o=3D"urn:schemas-microsoft-com:office:office" = xmlns:w=3D"urn:schemas-microsoft-com:office:word" = xmlns:m=3D"http://schemas.microsoft.com/office/2004/12/omml" = xmlns=3D"http://www.w3.org/TR/REC-html40"><head><META = HTTP-EQUIV=3D"Content-Type" CONTENT=3D"text/html; = charset=3Dus-ascii"><meta name=3DGenerator content=3D"Microsoft Word 15 = (filtered medium)"><style></style></head><body lang=3DEN-US = link=3D"#0563C1" vlink=3D"#954F72"><div class=3DWordSection1>Does anyone know how to get external authentication to = 389-ds “without” Kerberos support. I am quite happy with = LDAPS and would prefer not to introduce more = complexity.<o:p></o:p><o:p> </o:p><o:p> </o:p><o:p> </o:p>Thanks<o:p></o:p></div></body></html> ------=_NextPart_000_0003_01CEF1F6.79F018B0--

3 2

Re: [Users] VM with stateless snapshot won't start
by Martijn Grendelman 05 Dec '13

05 Dec '13

Hello Dafna, > If a failure happened and the stateless vm has shut down without delete > of the snapshot, the next time you will try to run it we will try to > delete the snapshot. > from the engine log, it seems that there is a problem deleting the > snapshot because of quota. > can you please try to disable the quota and try to run the vm again? Quota were not enabled on this Data Center, I have never done anything with quota on oVirt. The 'quota' table was empty, and the 'quota_id' field on all VMs in the 'vm_static' table was NULL. Since it was seemingly trying to set the quota_id for this particular VM to '00000000-0000-0000-0000-000000000000', I manually inserted a record into the quota table using this ID. After that, I was able to start te VM. The quota_id field for the VM now contains a reference to this fake id. > Please note that the first time you will run it after disabling the > quota, the snapshot should be deleted but the vm will still not start. > only after the snapshot is deleted you will be able to run the vm again. Indeed, it took two attempts to start the VM. Question: is it harmful to leave the fake quota record with id '00000000-0000-0000-0000-000000000000' and the reference to it in the vm_static table in place? Cheers, Martijn. > > > On 12/05/2013 11:23 AM, Martijn Grendelman wrote: >> Hi, >> >>> After maintenance on a host, I am trying to start a VM that has been >>> running statelessly for a while. It refuses to start and Engine logs the >>> following: >>> >>> 2013-12-05 11:59:18,125 INFO >>> [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] >>> (pool-6-thread-48) Correlation ID: 43d49965, Job ID: >>> 0d943a6d-9d65-4ac1-89b7-139d30b4813c, Call Stack: null, Custom Event ID: >>> -1, Message: Failed to start VM WinXP, because exist snapshot for >>> stateless state. Snapshot will be deleted. >>> >>> Should I submit a bug report for the poor English in this log line? ;-) >>> >>> The 'Snapshots' tab for the VM doesn't show anything, but repeated >>> attempts to start the VM just show the same message in the log. >>> >>> What can I do to start this VM? >> It seems I missed some info in the log that may well indicate the root >> cause of this issue. Please see attached log excerpt. A database query >> is failing due to a foreign key constraint violation. >> >> Please advise how to fix the database inconsistency. >> >> Regards, >> Martijn. >> >> >> >> >> _______________________________________________ >> Users mailing list >> Users(a)ovirt.org >> http://lists.ovirt.org/mailman/listinfo/users > >

3 3

Re: [Users] VM with stateless snapshot won't start
by Martijn Grendelman 05 Dec '13

05 Dec '13

Gilad Chaplik schreef op 5-12-2013 13:48: > hi Martijn, > > Indeed we have a bug there, and we've already solved it [1]. > As long as you're not using quota, your workaround is great. > If you'll decide to use quota you can contact me and we will see how to proceed. Ok, thanks! I have no plans for using quota ATM. Cheers, Martijn. > [1] http://gerrit.ovirt.org/#/c/21332/ > > ----- Original Message ----- >> From: "Martijn Grendelman" <martijn.grendelman(a)isaac.nl> >> To: dron(a)redhat.com, "Doron Fediuck" <dfediuck(a)redhat.com> >> Cc: users(a)ovirt.org >> Sent: Thursday, December 5, 2013 2:01:44 PM >> Subject: Re: [Users] VM with stateless snapshot won't start >> >> Hello Dafna, >> >>> If a failure happened and the stateless vm has shut down without delete >>> of the snapshot, the next time you will try to run it we will try to >>> delete the snapshot. >>> from the engine log, it seems that there is a problem deleting the >>> snapshot because of quota. >>> can you please try to disable the quota and try to run the vm again? >> >> Quota were not enabled on this Data Center, I have never done anything >> with quota on oVirt. The 'quota' table was empty, and the 'quota_id' >> field on all VMs in the 'vm_static' table was NULL. >> >> Since it was seemingly trying to set the quota_id for this particular VM >> to '00000000-0000-0000-0000-000000000000', I manually inserted a record >> into the quota table using this ID. After that, I was able to start te >> VM. The quota_id field for the VM now contains a reference to this fake id. >> >>> Please note that the first time you will run it after disabling the >>> quota, the snapshot should be deleted but the vm will still not start. >>> only after the snapshot is deleted you will be able to run the vm again. >> >> Indeed, it took two attempts to start the VM. >> >> Question: is it harmful to leave the fake quota record with id >> '00000000-0000-0000-0000-000000000000' and the reference to it in the >> vm_static table in place? >> >> Cheers, >> Martijn. >> >> >> >> >>> >>> >>> On 12/05/2013 11:23 AM, Martijn Grendelman wrote: >>>> Hi, >>>> >>>>> After maintenance on a host, I am trying to start a VM that has been >>>>> running statelessly for a while. It refuses to start and Engine logs the >>>>> following: >>>>> >>>>> 2013-12-05 11:59:18,125 INFO >>>>> [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] >>>>> (pool-6-thread-48) Correlation ID: 43d49965, Job ID: >>>>> 0d943a6d-9d65-4ac1-89b7-139d30b4813c, Call Stack: null, Custom Event ID: >>>>> -1, Message: Failed to start VM WinXP, because exist snapshot for >>>>> stateless state. Snapshot will be deleted. >>>>> >>>>> Should I submit a bug report for the poor English in this log line? ;-) >>>>> >>>>> The 'Snapshots' tab for the VM doesn't show anything, but repeated >>>>> attempts to start the VM just show the same message in the log. >>>>> >>>>> What can I do to start this VM? >>>> It seems I missed some info in the log that may well indicate the root >>>> cause of this issue. Please see attached log excerpt. A database query >>>> is failing due to a foreign key constraint violation. >>>> >>>> Please advise how to fix the database inconsistency. >>>> >>>> Regards, >>>> Martijn. >>>> >>>> >>>> >>>> >>>> _______________________________________________ >>>> Users mailing list >>>> Users(a)ovirt.org >>>> http://lists.ovirt.org/mailman/listinfo/users >>> >>> >> _______________________________________________ >> Users mailing list >> Users(a)ovirt.org >> http://lists.ovirt.org/mailman/listinfo/users >>

1 0

Re: [Users] VM with stateless snapshot won't start
by Martijn Grendelman 05 Dec '13

05 Dec '13

Hi, > After maintenance on a host, I am trying to start a VM that has been > running statelessly for a while. It refuses to start and Engine logs the > following: > > 2013-12-05 11:59:18,125 INFO > [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] > (pool-6-thread-48) Correlation ID: 43d49965, Job ID: > 0d943a6d-9d65-4ac1-89b7-139d30b4813c, Call Stack: null, Custom Event ID: > -1, Message: Failed to start VM WinXP, because exist snapshot for > stateless state. Snapshot will be deleted. > > Should I submit a bug report for the poor English in this log line? ;-) > > The 'Snapshots' tab for the VM doesn't show anything, but repeated > attempts to start the VM just show the same message in the log. > > What can I do to start this VM? It seems I missed some info in the log that may well indicate the root cause of this issue. Please see attached log excerpt. A database query is failing due to a foreign key constraint violation. Please advise how to fix the database inconsistency. Regards, Martijn.

2 1

Re: [Users] Failing migration, inconsistent state
by Martijn Grendelman 05 Dec '13

05 Dec '13

Martijn Grendelman schreef op 5-12-2013 11:18: > Martijn Grendelman schreef op 5-12-2013 11:00: >> Hi, >> >> I tried to migrate several VMs from one host to another. Two VMs >> migrated without issues, but for one VM, the migration didn't happen. It >> seems to be hanging, but the UI is now in an inconsistent state: >> >> - The 'Tasks' tab reports 0 active tasks, but the last task (the >> migration in question) is still reported as 'Executing'. >> - The VM status is 'Up' (not migrating) >> - 'Migrate' action is choosable from menu, while 'Cancel Migration' is >> greyed out, but when I choose 'Migrate' and pick a host, I am told >> 'Cannot migrate VM. VM <name> is being migrated.'. >> >> What is the best way to fix this? After a restart of Engine, the message that I got was different, something about no host being available with enough memory (which was correct). So I guess an Engine restart fixed it, even though the initial migration task still shows as unfinished in the Tasks panel. Cheers, Martijn.

1 0

[Users] Failing migration, inconsistent state
by Martijn Grendelman 05 Dec '13

05 Dec '13

Hi, I tried to migrate several VMs from one host to another. Two VMs migrated without issues, but for one VM, the migration didn't happen. It seems to be hanging, but the UI is now in an inconsistent state: - The 'Tasks' tab reports 0 active tasks, but the last task (the migration in question) is still reported as 'Executing'. - The VM status is 'Up' (not migrating) - 'Migrate' action is choosable from menu, while 'Cancel Migration' is greyed out, but when I choose 'Migrate' and pick a host, I am told 'Cannot migrate VM. VM <name> is being migrated.'. What is the best way to fix this? Met vriendelijke groet, Martijn Grendelman

1 0

[Users] Problem with python-cpopen dependency on f19 AIO stable
by Gianluca Cecchi 05 Dec '13

05 Dec '13

Hello, since yesterday evening I have this sort of dependency problem with updates yum update say Resolving Dependencies --> Running transaction check ---> Package python-cpopen.x86_64 0:1.2.3-4.fc19 will be obsoleting ---> Package vdsm-python-cpopen.x86_64 0:4.13.0-11.fc19 will be obsoleted --> Finished Dependency Resolution Dependencies Resolved ============================================================================================================================= Package Arch Version Repository Size ============================================================================================================================= Installing: python-cpopen x86_64 1.2.3-4.fc19 updates 19 k replacing vdsm-python-cpopen.x86_64 4.13.0-11.fc19 Transaction Summary ============================================================================================================================= Install 1 Package If I go ahead and run yum update again I have: Dependencies Resolved ============================================================================================================================= Package Arch Version Repository Size ============================================================================================================================= Installing: vdsm-python-cpopen x86_64 4.13.0-11.fc19 ovirt-stable 20 k replacing python-cpopen.x86_64 1.2.3-4.fc19 Transaction Summary ============================================================================================================================= Install 1 Package and so again in a loop.... Gianluca

2 1

[Users] Host activation removing iscsi sessions
by Juan Pablo Lorier 04 Dec '13

04 Dec '13

This is a multi-part message in MIME format. --------------060401020402070903050401 Content-Type: text/plain; charset=ISO-8859-1 Content-Transfer-Encoding: 7bit Hi, I'm adding two twin nodes to a cluster and I was able to add the first while the second fails as it removes the iscsi sessions and don't bring them back and thus fails with the message : Host Dell4 cannot access one of the Storage Domains attached to the Data Center Default. Setting Host state to Non-Operational. Here is the vdsm.log entries for one activationintent: Thread-20::DEBUG::2013-12-04 09:02:41,760::task::579::TaskManager.Task::(_updateState) Task=`e3529e49-3083-422e-b2e6-c7d8c47b886a`::moving from state init -> state preparing Thread-20::INFO::2013-12-04 09:02:41,760::logUtils::44::dispatcher::(wrapper) Run and protect: repoStats(options=None) Thread-20::INFO::2013-12-04 09:02:41,760::logUtils::47::dispatcher::(wrapper) Run and protect: repoStats, Return response: {} Thread-20::DEBUG::2013-12-04 09:02:41,760::task::1168::TaskManager.Task::(prepare) Task=`e3529e49-3083-422e-b2e6-c7d8c47b886a`::finished: {} Thread-20::DEBUG::2013-12-04 09:02:41,761::task::579::TaskManager.Task::(_updateState) Task=`e3529e49-3083-422e-b2e6-c7d8c47b886a`::moving from state preparing -> state finish ed Thread-20::DEBUG::2013-12-04 09:02:41,761::resourceManager::939::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {} Thread-20::DEBUG::2013-12-04 09:02:41,761::resourceManager::976::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-20::DEBUG::2013-12-04 09:02:41,761::task::974::TaskManager.Task::(_decref) Task=`e3529e49-3083-422e-b2e6-c7d8c47b886a`::ref 0 aborting False Thread-22::DEBUG::2013-12-04 09:02:41,814::BindingXMLRPC::177::vds::(wrapper) client [192.168.128.79] Thread-22::DEBUG::2013-12-04 09:02:41,815::task::579::TaskManager.Task::(_updateState) Task=`337b1ad3-2559-450c-9133-4fb733e6b5da`::moving from state init -> state preparing Thread-22::INFO::2013-12-04 09:02:41,815::logUtils::44::dispatcher::(wrapper) Run and protect: disconnectStoragePool(spUUID='5849b030-626e-47cb-ad90-3ce782d831b3', hostID=5, s csiKey='5849b030-626e-47cb-ad90-3ce782d831b3', remove=False, options=None) Thread-22::WARNING::2013-12-04 09:02:41,815::hsm::1094::Storage.HSM::(disconnectStoragePool) disconnect sp: 5849b030-626e-47cb-ad90-3ce782d831b3 failed. Known pools {} Thread-22::INFO::2013-12-04 09:02:41,815::logUtils::47::dispatcher::(wrapper) Run and protect: disconnectStoragePool, Return response: None Thread-22::DEBUG::2013-12-04 09:02:41,815::task::1168::TaskManager.Task::(prepare) Task=`337b1ad3-2559-450c-9133-4fb733e6b5da`::finished: None Thread-22::DEBUG::2013-12-04 09:02:41,816::task::579::TaskManager.Task::(_updateState) Task=`337b1ad3-2559-450c-9133-4fb733e6b5da`::moving from state preparing -> state finish ed Thread-22::DEBUG::2013-12-04 09:02:41,816::resourceManager::939::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {} Thread-22::DEBUG::2013-12-04 09:02:41,816::resourceManager::976::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-22::DEBUG::2013-12-04 09:02:41,816::task::974::TaskManager.Task::(_decref) Task=`337b1ad3-2559-450c-9133-4fb733e6b5da`::ref 0 aborting False Thread-23::DEBUG::2013-12-04 09:02:41,872::BindingXMLRPC::177::vds::(wrapper) client [192.168.128.79] Thread-23::DEBUG::2013-12-04 09:02:41,872::task::579::TaskManager.Task::(_updateState) Task=`155824b5-48c3-4eb2-90fb-d90e84f2900f`::moving from state init -> state preparing Thread-23::INFO::2013-12-04 09:02:41,873::logUtils::44::dispatcher::(wrapper) Run and protect: disconnectStorageServer(domType=3, spUUID='5849b030-626e-47cb-ad90-3ce782d831b3', conList=[{'connection': '192.168.130.10', 'iqn': 'iqn.1992-08.com.netapp:sn.135056614', 'portal': '1000', 'user': '', 'password': '******', 'id': '478b35df-da9a-4cb0-847f-2f61f17a02f7', 'port': '3260'}, {'connection': '192.168.131.10', 'iqn': 'iqn.1992-08.com.netapp:sn.135056614', 'portal': '1001', 'user': '', 'password': '******', 'id': '717e3505-3290-421b-bb00-25e046f63362', 'port': '3260'}], options=None) Thread-23::DEBUG::2013-12-04 09:02:41,876::misc::809::SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage) Thread-23::DEBUG::2013-12-04 09:02:41,876::misc::811::SamplingMethod::(__call__) Got in to sampling method Thread-23::DEBUG::2013-12-04 09:02:41,877::misc::809::SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan) Thread-23::DEBUG::2013-12-04 09:02:41,877::misc::811::SamplingMethod::(__call__) Got in to sampling method Thread-23::DEBUG::2013-12-04 09:02:41,877::iscsiadm::91::Storage.Misc.excCmd::(_runCmd) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None) Thread-23::DEBUG::2013-12-04 09:02:41,896::iscsiadm::91::Storage.Misc.excCmd::(_runCmd) FAILED: <err> = 'iscsiadm: No session found.\n'; <rc> = 21 Thread-23::DEBUG::2013-12-04 09:02:41,896::misc::819::SamplingMethod::(__call__) Returning last result Thread-23::DEBUG::2013-12-04 09:02:44,915::multipath::112::Storage.Misc.excCmd::(rescan) '/usr/bin/sudo -n /sbin/multipath -r' (cwd None) Thread-23::DEBUG::2013-12-04 09:02:44,966::multipath::112::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0 Thread-23::DEBUG::2013-12-04 09:02:44,967::lvm::510::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,967::lvm::512::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,968::lvm::521::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,968::lvm::523::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,968::lvm::541::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,968::lvm::543::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,968::misc::819::SamplingMethod::(__call__) Returning last result Thread-23::INFO::2013-12-04 09:02:44,969::logUtils::47::dispatcher::(wrapper) Run and protect: disconnectStorageServer, Return response: {'statuslist': [{'status': 0, 'id': '478b35df-da9a-4cb0-847f-2f61f17a02f7'}, {'status': 0, 'id': '717e3505-3290-421b-bb00-25e046f63362'}]} Thread-23::DEBUG::2013-12-04 09:02:44,969::task::1168::TaskManager.Task::(prepare) Task=`155824b5-48c3-4eb2-90fb-d90e84f2900f`::finished: {'statuslist': [{'status': 0, 'id': '478b35df-da9a-4cb0-847f-2f61f17a02f7'}, {'status': 0, 'id': '717e3505-3290-421b-bb00-25e046f63362'}]} Thread-23::DEBUG::2013-12-04 09:02:44,969::task::579::TaskManager.Task::(_updateState) Task=`155824b5-48c3-4eb2-90fb-d90e84f2900f`::moving from state preparing -> state finished Thread-23::DEBUG::2013-12-04 09:02:44,969::resourceManager::939::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {} Thread-23::DEBUG::2013-12-04 09:02:44,969::resourceManager::976::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-23::DEBUG::2013-12-04 09:02:44,970::task::974::TaskManager.Task::(_decref) Task=`155824b5-48c3-4eb2-90fb-d90e84f2900f`::ref 0 aborting False Regards, --------------060401020402070903050401 Content-Type: text/html; charset=ISO-8859-1 Content-Transfer-Encoding: 7bit <html> <head> <meta http-equiv="content-type" content="text/html; charset=ISO-8859-1"> </head> <body bgcolor="#FFFFFF" text="#000000"> Hi, I'm adding two twin nodes to a cluster and I was able to add the first while the second fails as it removes the iscsi sessions and don't bring them back and thus fails with the message : <div title="" tabindex="0" style="outline-style: none;" __gwt_cell="cell-gwt-uid-303550"> <div id="gwt-uid-3368_col2_row2">Host Dell4 cannot access one of the Storage Domains attached to the Data Center Default. Setting Host state to Non-Operational. <big>Here is the vdsm.log entries for one activation<big> </big></big>intent:</div> </div> Thread-20::DEBUG::2013-12-04 09:02:41,760::task::579::TaskManager.Task::(_updateState) Task=`e3529e49-3083-422e-b2e6-c7d8c47b886a`::moving from state init -> state preparing Thread-20::<a class="moz-txt-link-freetext" href="INFO::2013-12-04">INFO::2013-12-04</a> 09:02:41,760::logUtils::44::dispatcher::(wrapper) Run and protect: repoStats(options=None) Thread-20::<a class="moz-txt-link-freetext" href="INFO::2013-12-04">INFO::2013-12-04</a> 09:02:41,760::logUtils::47::dispatcher::(wrapper) Run and protect: repoStats, Return response: {} Thread-20::DEBUG::2013-12-04 09:02:41,760::task::1168::TaskManager.Task::(prepare) Task=`e3529e49-3083-422e-b2e6-c7d8c47b886a`::finished: {} Thread-20::DEBUG::2013-12-04 09:02:41,761::task::579::TaskManager.Task::(_updateState) Task=`e3529e49-3083-422e-b2e6-c7d8c47b886a`::moving from state preparing -> state finish ed Thread-20::DEBUG::2013-12-04 09:02:41,761::resourceManager::939::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {} Thread-20::DEBUG::2013-12-04 09:02:41,761::resourceManager::976::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-20::DEBUG::2013-12-04 09:02:41,761::task::974::TaskManager.Task::(_decref) Task=`e3529e49-3083-422e-b2e6-c7d8c47b886a`::ref 0 aborting False Thread-22::DEBUG::2013-12-04 09:02:41,814::BindingXMLRPC::177::vds::(wrapper) client [192.168.128.79] Thread-22::DEBUG::2013-12-04 09:02:41,815::task::579::TaskManager.Task::(_updateState) Task=`337b1ad3-2559-450c-9133-4fb733e6b5da`::moving from state init -> state preparing Thread-22::<a class="moz-txt-link-freetext" href="INFO::2013-12-04">INFO::2013-12-04</a> 09:02:41,815::logUtils::44::dispatcher::(wrapper) Run and protect: disconnectStoragePool(spUUID='5849b030-626e-47cb-ad90-3ce782d831b3', hostID=5, s csiKey='5849b030-626e-47cb-ad90-3ce782d831b3', remove=False, options=None) Thread-22::WARNING::2013-12-04 09:02:41,815::hsm::1094::Storage.HSM::(disconnectStoragePool) disconnect sp: 5849b030-626e-47cb-ad90-3ce782d831b3 failed. Known pools {} Thread-22::<a class="moz-txt-link-freetext" href="INFO::2013-12-04">INFO::2013-12-04</a> 09:02:41,815::logUtils::47::dispatcher::(wrapper) Run and protect: disconnectStoragePool, Return response: None Thread-22::DEBUG::2013-12-04 09:02:41,815::task::1168::TaskManager.Task::(prepare) Task=`337b1ad3-2559-450c-9133-4fb733e6b5da`::finished: None Thread-22::DEBUG::2013-12-04 09:02:41,816::task::579::TaskManager.Task::(_updateState) Task=`337b1ad3-2559-450c-9133-4fb733e6b5da`::moving from state preparing -> state finish ed Thread-22::DEBUG::2013-12-04 09:02:41,816::resourceManager::939::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {} Thread-22::DEBUG::2013-12-04 09:02:41,816::resourceManager::976::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-22::DEBUG::2013-12-04 09:02:41,816::task::974::TaskManager.Task::(_decref) Task=`337b1ad3-2559-450c-9133-4fb733e6b5da`::ref 0 aborting False Thread-23::DEBUG::2013-12-04 09:02:41,872::BindingXMLRPC::177::vds::(wrapper) client [192.168.128.79] Thread-23::DEBUG::2013-12-04 09:02:41,872::task::579::TaskManager.Task::(_updateState) Task=`155824b5-48c3-4eb2-90fb-d90e84f2900f`::moving from state init -> state preparing Thread-23::<a class="moz-txt-link-freetext" href="INFO::2013-12-04">INFO::2013-12-04</a> 09:02:41,873::logUtils::44::dispatcher::(wrapper) Run and protect: disconnectStorageServer(domType=3, spUUID='5849b030-626e-47cb-ad90-3ce782d831b3', conList=[{'connection': '192.168.130.10', 'iqn': 'iqn.1992-08.com.netapp:sn.135056614', 'portal': '1000', 'user': '', 'password': '******', 'id': '478b35df-da9a-4cb0-847f-2f61f17a02f7', 'port': '3260'}, {'connection': '192.168.131.10', 'iqn': 'iqn.1992-08.com.netapp:sn.135056614', 'portal': '1001', 'user': '', 'password': '******', 'id': '717e3505-3290-421b-bb00-25e046f63362', 'port': '3260'}], options=None) Thread-23::DEBUG::2013-12-04 09:02:41,876::misc::809::SamplingMethod::(__call__) Trying to enter sampling method (storage.sdc.refreshStorage) Thread-23::DEBUG::2013-12-04 09:02:41,876::misc::811::SamplingMethod::(__call__) Got in to sampling method Thread-23::DEBUG::2013-12-04 09:02:41,877::misc::809::SamplingMethod::(__call__) Trying to enter sampling method (storage.iscsi.rescan) Thread-23::DEBUG::2013-12-04 09:02:41,877::misc::811::SamplingMethod::(__call__) Got in to sampling method Thread-23::DEBUG::2013-12-04 09:02:41,877::iscsiadm::91::Storage.Misc.excCmd::(_runCmd) '/usr/bin/sudo -n /sbin/iscsiadm -m session -R' (cwd None) Thread-23::DEBUG::2013-12-04 09:02:41,896::iscsiadm::91::Storage.Misc.excCmd::(_runCmd) FAILED: <err> = 'iscsiadm: No session found.\n'; <rc> = 21 Thread-23::DEBUG::2013-12-04 09:02:41,896::misc::819::SamplingMethod::(__call__) Returning last result Thread-23::DEBUG::2013-12-04 09:02:44,915::multipath::112::Storage.Misc.excCmd::(rescan) '/usr/bin/sudo -n /sbin/multipath -r' (cwd None) Thread-23::DEBUG::2013-12-04 09:02:44,966::multipath::112::Storage.Misc.excCmd::(rescan) SUCCESS: <err> = ''; <rc> = 0 Thread-23::DEBUG::2013-12-04 09:02:44,967::lvm::510::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' got the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,967::lvm::512::OperationMutex::(_invalidateAllPvs) Operation 'lvm invalidate operation' released the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,968::lvm::521::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' got the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,968::lvm::523::OperationMutex::(_invalidateAllVgs) Operation 'lvm invalidate operation' released the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,968::lvm::541::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' got the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,968::lvm::543::OperationMutex::(_invalidateAllLvs) Operation 'lvm invalidate operation' released the operation mutex Thread-23::DEBUG::2013-12-04 09:02:44,968::misc::819::SamplingMethod::(__call__) Returning last result Thread-23::<a class="moz-txt-link-freetext" href="INFO::2013-12-04">INFO::2013-12-04</a> 09:02:44,969::logUtils::47::dispatcher::(wrapper) Run and protect: disconnectStorageServer, Return response: {'statuslist': [{'status': 0, 'id': '478b35df-da9a-4cb0-847f-2f61f17a02f7'}, {'status': 0, 'id': '717e3505-3290-421b-bb00-25e046f63362'}]} Thread-23::DEBUG::2013-12-04 09:02:44,969::task::1168::TaskManager.Task::(prepare) Task=`155824b5-48c3-4eb2-90fb-d90e84f2900f`::finished: {'statuslist': [{'status': 0, 'id': '478b35df-da9a-4cb0-847f-2f61f17a02f7'}, {'status': 0, 'id': '717e3505-3290-421b-bb00-25e046f63362'}]} Thread-23::DEBUG::2013-12-04 09:02:44,969::task::579::TaskManager.Task::(_updateState) Task=`155824b5-48c3-4eb2-90fb-d90e84f2900f`::moving from state preparing -> state finished Thread-23::DEBUG::2013-12-04 09:02:44,969::resourceManager::939::ResourceManager.Owner::(releaseAll) Owner.releaseAll requests {} resources {} Thread-23::DEBUG::2013-12-04 09:02:44,969::resourceManager::976::ResourceManager.Owner::(cancelAll) Owner.cancelAll requests {} Thread-23::DEBUG::2013-12-04 09:02:44,970::task::974::TaskManager.Task::(_decref) Task=`155824b5-48c3-4eb2-90fb-d90e84f2900f`::ref 0 aborting False Regards, </body> </html> --------------060401020402070903050401--

2 3