[ovirt-users] SLA : RAM scheduling
noc
noc at nieuwland.nl
Wed Jun 11 12:31:48 UTC 2014
On 26-5-2014 16:22, Gilad Chaplik wrote:
> Hi Nathanaël,
>
> happy to assist :) hope it will work in first run:
>
> 1) install the proxy and ovirtsdk.
> 2) put attached file in the right place (according to docs: ".../plugins"), make sure to edit the file with your ovirt's ip, user at domain and PW.
> 3) restart proxy service.
> 3) use config tool to configure ovirt-engine:
> * "ExternalSchedulerServiceURL"="http://<ip>:18781/"
> * "ExternalSchedulerEnabled"=true
> 4) restart ovirt-engine service.
> 5) under configure->cluster_policy see that weight function memory_even_distribution was added (should be in manage policy units or /sth- you will see it in the main dialog as well).
> 6) clone/copy currernt cluster's used cluster policy (probably none - prefer it to have no balancing modules to avoid conflicts), name it 'your_name' and attach memory_even_distribution weight (you can leave it as the only weight module in weight section to avoid configuring factors).
> 7) replace cluster's cluster policy with newly created one.
>
> try it out and let me know how goes :-)
>
>
Ok, progress of some sort :-)
I added the weight function to the cluster and when I replace my dns
name with localhost in ExternalSchedulerServiceURL then engine.log shows
that it can contact the scheduler. I expected a rebalance but nothing
happened. Stopping and starting a VM does provoke a reaction, an error :-(
From the scheduler.log I see that engine contacts it and pushes some
information, the log also shows that some information is returned and
then there is a big error message in the log of engine.
Joop
-------------- next part --------------
2014-06-11 14:19:03,647 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-79) FINISH, GlusterVolumesListVDSCommand, return: {955b86a9-10b4-463b-8555-3c321bd72f5c=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 37074874, 0bf7869b-873b-4c28-9c09-d31100f4e12a=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 99f2d266, 248aa48d-6aa5-4b21-867e-994265a3f145=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 12074ee1}, log id: 6dca802f
2014-06-11 14:19:08,755 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-9) [5d65b296] START, GlusterVolumesListVDSCommand(HostName = st02, HostId = 5077a01d-7273-4d58-92ee-c3315b0a973e), log id: 3af08062
2014-06-11 14:19:08,870 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-9) [5d65b296] FINISH, GlusterVolumesListVDSCommand, return: {955b86a9-10b4-463b-8555-3c321bd72f5c=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at a301dc77, 0bf7869b-873b-4c28-9c09-d31100f4e12a=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 2cf62fb2, 248aa48d-6aa5-4b21-867e-994265a3f145=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at b2cabf68}, log id: 3af08062
2014-06-11 14:19:13,977 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-19) START, GlusterVolumesListVDSCommand(HostName = st02, HostId = 5077a01d-7273-4d58-92ee-c3315b0a973e), log id: 32bca729
2014-06-11 14:19:14,093 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-19) FINISH, GlusterVolumesListVDSCommand, return: {955b86a9-10b4-463b-8555-3c321bd72f5c=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at a57e1af5, 0bf7869b-873b-4c28-9c09-d31100f4e12a=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at ca2565b6, 248aa48d-6aa5-4b21-867e-994265a3f145=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at c4b83856}, log id: 32bca729
2014-06-11 14:19:16,017 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (ajp--127.0.0.1-8702-6) [67888f4b] START, IsVmDuringInitiatingVDSCommand( vmId = ab505d9b-1811-4153-8d84-3efc7d878898), log id: 4a96a08
2014-06-11 14:19:16,018 INFO [org.ovirt.engine.core.vdsbroker.IsVmDuringInitiatingVDSCommand] (ajp--127.0.0.1-8702-6) [67888f4b] FINISH, IsVmDuringInitiatingVDSCommand, return: false, log id: 4a96a08
2014-06-11 14:19:16,088 INFO [org.ovirt.engine.core.bll.RunVmOnceCommand] (ajp--127.0.0.1-8702-6) [67888f4b] Running command: RunVmOnceCommand internal: false. Entities affected : ID: ab505d9b-1811-4153-8d84-3efc7d878898 Type: VM
2014-06-11 14:19:17,091 INFO [org.ovirt.engine.core.bll.LoginUserCommand] (ajp--127.0.0.1-8702-2) Running command: LoginUserCommand internal: false.
2014-06-11 14:19:17,096 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-2) Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: User admin logged in.
2014-06-11 14:19:18,919 ERROR [org.ovirt.engine.core.bll.scheduling.external.ExternalSchedulerBrokerImpl] (ajp--127.0.0.1-8702-6) [67888f4b] Could not communicate with the external scheduler while running weight modules: org.apache.xmlrpc.XmlRpcException: <type 'exceptions.OverflowError'>:int exceeds XML-RPC limits
at org.apache.xmlrpc.client.XmlRpcStreamTransport.readResponse(XmlRpcStreamTransport.java:197) [xmlrpc-client.jar:3.1.3]
at org.apache.xmlrpc.client.XmlRpcStreamTransport.sendRequest(XmlRpcStreamTransport.java:156) [xmlrpc-client.jar:3.1.3]
at org.apache.xmlrpc.client.XmlRpcHttpTransport.sendRequest(XmlRpcHttpTransport.java:143) [xmlrpc-client.jar:3.1.3]
at org.apache.xmlrpc.client.XmlRpcSunHttpTransport.sendRequest(XmlRpcSunHttpTransport.java:69) [xmlrpc-client.jar:3.1.3]
at org.apache.xmlrpc.client.XmlRpcClientWorker.execute(XmlRpcClientWorker.java:56) [xmlrpc-client.jar:3.1.3]
at org.apache.xmlrpc.client.XmlRpcClient.execute(XmlRpcClient.java:167) [xmlrpc-client.jar:3.1.3]
at org.apache.xmlrpc.client.XmlRpcClient.execute(XmlRpcClient.java:137) [xmlrpc-client.jar:3.1.3]
at org.apache.xmlrpc.client.XmlRpcClient.execute(XmlRpcClient.java:126) [xmlrpc-client.jar:3.1.3]
at org.ovirt.engine.core.bll.scheduling.external.ExternalSchedulerBrokerImpl.runScores(ExternalSchedulerBrokerImpl.java:145) [bll.jar:]
at org.ovirt.engine.core.bll.scheduling.SchedulingManager.runExternalFunctions(SchedulingManager.java:656) [bll.jar:]
at org.ovirt.engine.core.bll.scheduling.SchedulingManager.runFunctions(SchedulingManager.java:608) [bll.jar:]
at org.ovirt.engine.core.bll.scheduling.SchedulingManager.schedule(SchedulingManager.java:280) [bll.jar:]
at org.ovirt.engine.core.bll.RunVmCommand.getVdsToRunOn(RunVmCommand.java:620) [bll.jar:]
at org.ovirt.engine.core.bll.RunVmCommand.runVm(RunVmCommand.java:214) [bll.jar:]
at org.ovirt.engine.core.bll.RunVmCommand.executeVmCommand(RunVmCommand.java:288) [bll.jar:]
at org.ovirt.engine.core.bll.VmCommand.executeCommand(VmCommand.java:89) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.executeWithoutTransaction(CommandBase.java:1123) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.executeActionInTransactionScope(CommandBase.java:1208) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.runInTransaction(CommandBase.java:1884) [bll.jar:]
at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInSuppressed(TransactionSupport.java:174) [utils.jar:]
at org.ovirt.engine.core.utils.transaction.TransactionSupport.executeInScope(TransactionSupport.java:116) [utils.jar:]
at org.ovirt.engine.core.bll.CommandBase.execute(CommandBase.java:1228) [bll.jar:]
at org.ovirt.engine.core.bll.CommandBase.executeAction(CommandBase.java:351) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:413) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runActionImpl(Backend.java:392) [bll.jar:]
at org.ovirt.engine.core.bll.Backend.runAction(Backend.java:350) [bll.jar:]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_51]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_51]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
at org.jboss.as.ee.component.ManagedReferenceMethodInterceptorFactory$ManagedReferenceMethodInterceptor.processInvocation(ManagedReferenceMethodInterceptorFactory.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.InterceptorContext$Invocation.proceed(InterceptorContext.java:374) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.ovirt.engine.core.bll.interceptors.ThreadLocalSessionCleanerInterceptor.injectWebContextToThreadLocal(ThreadLocalSessionCleanerInterceptor.java:13) [bll.jar:]
at sun.reflect.GeneratedMethodAccessor66.invoke(Unknown Source) [:1.7.0_51]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
at org.jboss.as.ee.component.ManagedReferenceLifecycleMethodInterceptorFactory$ManagedReferenceLifecycleMethodInterceptor.processInvocation(ManagedReferenceLifecycleMethodInterceptorFactory.java:123) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.WeavedInterceptor.processInvocation(WeavedInterceptor.java:53) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.interceptors.UserInterceptorFactory$1.processInvocation(UserInterceptorFactory.java:36) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.InitialInterceptor.processInvocation(InitialInterceptor.java:21) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.interceptors.ComponentDispatcherInterceptor.processInvocation(ComponentDispatcherInterceptor.java:53) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.singleton.SingletonComponentInstanceAssociationInterceptor.processInvocation(SingletonComponentInstanceAssociationInterceptor.java:53) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.invokeInNoTx(CMTTxInterceptor.java:211) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.supports(CMTTxInterceptor.java:363) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.as.ejb3.tx.CMTTxInterceptor.processInvocation(CMTTxInterceptor.java:194) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.interceptors.CurrentInvocationContextInterceptor.processInvocation(CurrentInvocationContextInterceptor.java:41) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ejb3.component.interceptors.LoggingInterceptor.processInvocation(LoggingInterceptor.java:59) [jboss-as-ejb3-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.NamespaceContextInterceptor.processInvocation(NamespaceContextInterceptor.java:50) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.TCCLInterceptor.processInvocation(TCCLInterceptor.java:45) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.ViewService$View.invoke(ViewService.java:165) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.as.ee.component.ViewDescription$1.processInvocation(ViewDescription.java:173) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.jboss.invocation.InterceptorContext.proceed(InterceptorContext.java:288) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.invocation.ChainedInterceptor.processInvocation(ChainedInterceptor.java:61) [jboss-invocation-1.1.1.Final.jar:1.1.1.Final]
at org.jboss.as.ee.component.ProxyInvocationHandler.invoke(ProxyInvocationHandler.java:72) [jboss-as-ee-7.1.1.Final.jar:7.1.1.Final]
at org.ovirt.engine.core.common.interfaces.BackendLocal$$$view9.runAction(Unknown Source) [common.jar:]
at org.ovirt.engine.ui.frontend.server.gwt.GenericApiGWTServiceImpl.RunAction(GenericApiGWTServiceImpl.java:137)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [rt.jar:1.7.0_51]
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [rt.jar:1.7.0_51]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [rt.jar:1.7.0_51]
at java.lang.reflect.Method.invoke(Method.java:606) [rt.jar:1.7.0_51]
at com.google.gwt.rpc.server.RPC.invokeAndStreamResponse(RPC.java:196)
at com.google.gwt.rpc.server.RpcServlet.processCall(RpcServlet.java:172)
at com.google.gwt.rpc.server.RpcServlet.processPost(RpcServlet.java:233)
at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:754) [jboss-servlet-api_3.0_spec-1.0.0.Final.jar:1.0.0.Final]
at javax.servlet.http.HttpServlet.service(HttpServlet.java:847) [jboss-servlet-api_3.0_spec-1.0.0.Final.jar:1.0.0.Final]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:329)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at org.ovirt.engine.ui.frontend.server.gwt.GwtCachingFilter.doFilter(GwtCachingFilter.java:132)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:280)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at org.ovirt.engine.core.branding.BrandingFilter.doFilter(BrandingFilter.java:72)
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:280)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at org.ovirt.engine.core.utils.servlet.LocaleFilter.doFilter(LocaleFilter.java:64) [utils.jar:]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:280)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at org.ovirt.engine.core.bll.AutomaticLoginFilter.doFilter(AutomaticLoginFilter.java:58) [bll.jar:]
at org.ovirt.engine.core.bll.AutomaticLoginFilter.doFilter(AutomaticLoginFilter.java:49) [bll.jar:]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:280)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at org.ovirt.engine.core.authentication.AuthenticationFilter.doFilter(AuthenticationFilter.java:80) [common.jar:]
at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:280)
at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:248)
at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:275)
at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:161)
at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:489)
at org.jboss.as.web.security.SecurityContextAssociationValve.invoke(SecurityContextAssociationValve.java:153)
at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:155)
at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
at org.jboss.web.rewrite.RewriteValve.invoke(RewriteValve.java:466)
at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:368)
at org.apache.coyote.ajp.AjpProcessor.process(AjpProcessor.java:505)
at org.apache.coyote.ajp.AjpProtocol$AjpConnectionHandler.process(AjpProtocol.java:445)
at org.apache.tomcat.util.net.JIoEndpoint$Worker.run(JIoEndpoint.java:930)
at java.lang.Thread.run(Thread.java:744) [rt.jar:1.7.0_51]
2014-06-11 14:19:18,955 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-6) [67888f4b] Correlation ID: null, Call Stack: null, Custom Event ID: -1, Message: Failed to connect to external scheduler proxy. External filters, scoring functions and load balancing will not be performed.
2014-06-11 14:19:19,080 INFO [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (ajp--127.0.0.1-8702-6) [67888f4b] START, CreateVmVDSCommand(HostName = host01, HostId = 013d804e-714a-4e79-8fd2-f88e72b74086, vmId=ab505d9b-1811-4153-8d84-3efc7d878898, vm=VM [bluemind]), log id: 4ea2300d
2014-06-11 14:19:19,120 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (ajp--127.0.0.1-8702-6) [67888f4b] START, CreateVDSCommand(HostName = host01, HostId = 013d804e-714a-4e79-8fd2-f88e72b74086, vmId=ab505d9b-1811-4153-8d84-3efc7d878898, vm=VM [bluemind]), log id: 52475d4d
2014-06-11 14:19:19,185 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (ajp--127.0.0.1-8702-6) [67888f4b] org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand spiceSslCipherSuite=DEFAULT,memSize=4096,kvmEnable=true,smp=1,vmType=kvm,emulatedMachine=rhel6.5.0,keyboardLayout=en-us,memGuaranteedSize=4096,pitReinjection=false,nice=0,display=vnc,smartcardEnable=false,tabletEnable=true,smpCoresPerSocket=1,spiceSecureChannels=smain,sinputs,scursor,splayback,srecord,sdisplay,susbredir,ssmartcard,maxVCpus=160,timeOffset=0,transparentHugePages=true,vmId=ab505d9b-1811-4153-8d84-3efc7d878898,devices=[{address={bus=0x00, domain=0x0000, slot=0x02, type=pci, function=0x0}, specParams={vram=32768, heads=1}, device=cirrus, type=video, deviceId=1f745ede-b8b1-4f33-9b3c-a4c581961b2a}, {shared=false, iface=ide, index=2, specParams={path=}, path=, device=cdrom, type=disk, readonly=true, deviceId=0076683f-19a3-400d-b1b1-9910b4886685}, {shared=false, index=0, volumeID=55ec11cc-ef1b-4246-aaee-5c00c66d0c89, propagateErrors=off, format=raw, type=disk, bootOrder=1, iface=virtio, address={bus=0x00, domain=0x0000, slot=0x06, type=pci, function=0x0}, domainID=ed34f8cd-2ace-4522-a610-c3edbcf37064, imageID=54dbd782-65c4-4b01-a175-f0df6613030f, specParams={}, optional=false, device=disk, poolID=5849b030-626e-47cb-ad90-3ce782d831b3, readonly=false, deviceId=54dbd782-65c4-4b01-a175-f0df6613030f}, {bootOrder=2, nicModel=pv, address={bus=0x00, domain=0x0000, slot=0x03, type=pci, function=0x0}, specParams={}, macAddr=00:1a:4a:cf:cf:c3, device=bridge, linkActive=true, type=interface, filter=vdsm-no-mac-spoofing, network=ovirtmgmt, deviceId=50eb0226-2310-4364-af1e-b0044f4fe409}, {specParams={model=virtio}, device=memballoon, type=balloon, deviceId=058966de-5a1d-45f2-8bf3-57d8f926fc2d}, {index=0, model=virtio-scsi, address={bus=0x00, domain=0x0000, slot=0x04, type=pci, function=0x0}, specParams={}, device=scsi, type=controller, deviceId=544cb4f8-5f86-4bcc-b020-43604ce26fd0}],acpiEnable=true,vmName=bluemind,cpuType=Conroe,custom={}
2014-06-11 14:19:19,189 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.CreateVDSCommand] (ajp--127.0.0.1-8702-6) [67888f4b] FINISH, CreateVDSCommand, log id: 52475d4d
2014-06-11 14:19:19,203 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-37) START, GlusterVolumesListVDSCommand(HostName = st02, HostId = 5077a01d-7273-4d58-92ee-c3315b0a973e), log id: 5b3f6966
2014-06-11 14:19:19,206 INFO [org.ovirt.engine.core.vdsbroker.CreateVmVDSCommand] (ajp--127.0.0.1-8702-6) [67888f4b] FINISH, CreateVmVDSCommand, return: WaitForLaunch, log id: 4ea2300d
2014-06-11 14:19:19,223 INFO [org.ovirt.engine.core.dal.dbbroker.auditloghandling.AuditLogDirector] (ajp--127.0.0.1-8702-6) [67888f4b] Correlation ID: 67888f4b, Job ID: 6d3fcb35-1eab-4f44-9d1b-dca7fcd69597, Call Stack: null, Custom Event ID: -1, Message: VM bluemind was started by admin (Host: host01).
2014-06-11 14:19:19,322 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-37) FINISH, GlusterVolumesListVDSCommand, return: {955b86a9-10b4-463b-8555-3c321bd72f5c=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at f751513a, 0bf7869b-873b-4c28-9c09-d31100f4e12a=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 48007ea5, 248aa48d-6aa5-4b21-867e-994265a3f145=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at b67671a8}, log id: 5b3f6966
2014-06-11 14:19:21,982 INFO [org.ovirt.engine.core.vdsbroker.VdsUpdateRunTimeInfo] (DefaultQuartzScheduler_Worker-45) VM bluemind ab505d9b-1811-4153-8d84-3efc7d878898 moved from WaitForLaunch --> PoweringUp
2014-06-11 14:19:21,983 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-45) START, FullListVdsCommand(HostName = host01, HostId = 013d804e-714a-4e79-8fd2-f88e72b74086, vds=Host[host01], vmIds=[ab505d9b-1811-4153-8d84-3efc7d878898]), log id: 7807e74c
2014-06-11 14:19:21,990 INFO [org.ovirt.engine.core.vdsbroker.vdsbroker.FullListVdsCommand] (DefaultQuartzScheduler_Worker-45) FINISH, FullListVdsCommand, return: [{displaySecurePort=-1, kvmEnable=true, nicModel=rtl8139,pv, keyboardLayout=en-us, displayIp=0, pauseCode=NOERR, nice=0, pitReinjection=false, timeOffset=0, transparentHugePages=true, vmId=ab505d9b-1811-4153-8d84-3efc7d878898, acpiEnable=true, custom={}, spiceSslCipherSuite=DEFAULT, memSize=4096, displayPort=5906, smp=1, emulatedMachine=rhel6.5.0, status=Up, vmType=kvm, memGuaranteedSize=4096, display=vnc, pid=20950, smartcardEnable=false, tabletEnable=true, smpCoresPerSocket=1, spiceSecureChannels=smain,sinputs,scursor,splayback,srecord,sdisplay,susbredir,ssmartcard, maxVCpus=160, clientIp=, devices=[Ljava.lang.Object;@4ee26c24, vmName=bluemind, cpuType=Conroe}], log id: 7807e74c
2014-06-11 14:19:24,430 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-66) START, GlusterVolumesListVDSCommand(HostName = st02, HostId = 5077a01d-7273-4d58-92ee-c3315b0a973e), log id: 5493210b
2014-06-11 14:19:24,568 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-66) FINISH, GlusterVolumesListVDSCommand, return: {955b86a9-10b4-463b-8555-3c321bd72f5c=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at a40baef4, 0bf7869b-873b-4c28-9c09-d31100f4e12a=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at d92c3b3b, 248aa48d-6aa5-4b21-867e-994265a3f145=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at cdd8306a}, log id: 5493210b
2014-06-11 14:19:29,671 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-78) START, GlusterVolumesListVDSCommand(HostName = st02, HostId = 5077a01d-7273-4d58-92ee-c3315b0a973e), log id: 2ebc391d
2014-06-11 14:19:29,786 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-78) FINISH, GlusterVolumesListVDSCommand, return: {955b86a9-10b4-463b-8555-3c321bd72f5c=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 78fcbc27, 0bf7869b-873b-4c28-9c09-d31100f4e12a=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 795fece3, 248aa48d-6aa5-4b21-867e-994265a3f145=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 30c54233}, log id: 2ebc391d
2014-06-11 14:19:34,893 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-4) START, GlusterVolumesListVDSCommand(HostName = st02, HostId = 5077a01d-7273-4d58-92ee-c3315b0a973e), log id: 220abfed
2014-06-11 14:19:35,007 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-4) FINISH, GlusterVolumesListVDSCommand, return: {955b86a9-10b4-463b-8555-3c321bd72f5c=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at e7a022f5, 0bf7869b-873b-4c28-9c09-d31100f4e12a=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 83697c47, 248aa48d-6aa5-4b21-867e-994265a3f145=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at e96bfaad}, log id: 220abfed
2014-06-11 14:19:40,115 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-95) START, GlusterVolumesListVDSCommand(HostName = st02, HostId = 5077a01d-7273-4d58-92ee-c3315b0a973e), log id: bd57a89
2014-06-11 14:19:40,230 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-95) FINISH, GlusterVolumesListVDSCommand, return: {955b86a9-10b4-463b-8555-3c321bd72f5c=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 578d78dd, 0bf7869b-873b-4c28-9c09-d31100f4e12a=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at e4564a48, 248aa48d-6aa5-4b21-867e-994265a3f145=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 96ea04d9}, log id: bd57a89
2014-06-11 14:19:45,334 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-6) [373c3a89] START, GlusterVolumesListVDSCommand(HostName = st02, HostId = 5077a01d-7273-4d58-92ee-c3315b0a973e), log id: 412d4b97
2014-06-11 14:19:45,448 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-6) [373c3a89] FINISH, GlusterVolumesListVDSCommand, return: {955b86a9-10b4-463b-8555-3c321bd72f5c=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at f9ff9da9, 0bf7869b-873b-4c28-9c09-d31100f4e12a=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 3dbab1ca, 248aa48d-6aa5-4b21-867e-994265a3f145=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 1378b7f9}, log id: 412d4b97
2014-06-11 14:19:50,556 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-34) START, GlusterVolumesListVDSCommand(HostName = st02, HostId = 5077a01d-7273-4d58-92ee-c3315b0a973e), log id: 18a4b9d
2014-06-11 14:19:50,672 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-34) FINISH, GlusterVolumesListVDSCommand, return: {955b86a9-10b4-463b-8555-3c321bd72f5c=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 20d2e9dd, 0bf7869b-873b-4c28-9c09-d31100f4e12a=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 69fa653d, 248aa48d-6aa5-4b21-867e-994265a3f145=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 6006bd60}, log id: 18a4b9d
2014-06-11 14:19:55,778 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-47) START, GlusterVolumesListVDSCommand(HostName = st02, HostId = 5077a01d-7273-4d58-92ee-c3315b0a973e), log id: 419de435
2014-06-11 14:19:55,897 INFO [org.ovirt.engine.core.vdsbroker.gluster.GlusterVolumesListVDSCommand] (DefaultQuartzScheduler_Worker-47) FINISH, GlusterVolumesListVDSCommand, return: {955b86a9-10b4-463b-8555-3c321bd72f5c=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 423832d4, 0bf7869b-873b-4c28-9c09-d31100f4e12a=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 242eb57, 248aa48d-6aa5-4b21-867e-994265a3f145=org.ovirt.engine.core.common.businessentities.gluster.GlusterVolumeEntity at 4a8043d1}, log id: 419de435
-------------- next part --------------
Wed, 11 Jun 2014 10:48:26 INFO [process:MainProcess, thread:MainThread] Setting up server
Wed, 11 Jun 2014 10:48:26 INFO [process:MainProcess, thread:MainThread] Loading modules from /usr/share/ovirt-scheduler-proxy/plugins
Wed, 11 Jun 2014 10:48:26 INFO [process:MainProcess, thread:MainThread] Loading analyzer from /usr/lib/python2.6/site-packages/ovirtscheduler
Wed, 11 Jun 2014 10:48:26 INFO [process:MainProcess, thread:MainThread] [Request:Main][Method:loadModules] - Trying to load the following files: []
Wed, 11 Jun 2014 10:48:26 INFO [process:MainProcess, thread:MainThread] [Request:Main][Method:loadModules] - registering::loaded- filters:{} scores:{} balancers:{}
Wed, 11 Jun 2014 10:48:26 INFO [process:MainProcess, thread:MainThread] Publishing API
Wed, 11 Jun 2014 11:59:00 INFO [process:MainProcess, thread:MainThread] Setting up server
Wed, 11 Jun 2014 11:59:00 INFO [process:MainProcess, thread:MainThread] Loading modules from /usr/share/ovirt-scheduler-proxy/plugins
Wed, 11 Jun 2014 11:59:00 INFO [process:MainProcess, thread:MainThread] Loading analyzer from /usr/lib/python2.6/site-packages/ovirtscheduler
Wed, 11 Jun 2014 11:59:00 INFO [process:MainProcess, thread:MainThread] [Request:Main][Method:loadModules] - Trying to load the following files: ['memory_even_distribution']
Wed, 11 Jun 2014 11:59:00 DEBUG [process:MainProcess, thread:Thread-1] [Request:Main][Method:PythonMethodRunner] - running ['python', '-c', "import loader; loader.loader().analyze('/usr/share/ovirt-scheduler-proxy/plugins', 'memory_even_distribution')"] in /usr/lib/python2.6/site-packages/ovirtscheduler
Wed, 11 Jun 2014 11:59:01 DEBUG [process:MainProcess, thread:MainThread] [Request:Main][Method:loadModules] - script: ['python', '-c', "import loader; loader.loader().analyze('/usr/share/ovirt-scheduler-proxy/plugins', 'memory_even_distribution')"]
Wed, 11 Jun 2014 11:59:01 INFO [process:MainProcess, thread:MainThread] [Request:Main][Method:loadModules] - registering: ('memory_even_distribution', ('memory_even_distribution', 'do_score', '', ''))
Wed, 11 Jun 2014 11:59:01 INFO [process:MainProcess, thread:MainThread] [Request:Main][Method:loadModules] - registering::loaded- filters:{} scores:{'memory_even_distribution': ('', '')} balancers:{}
Wed, 11 Jun 2014 11:59:01 INFO [process:MainProcess, thread:MainThread] Publishing API
Wed, 11 Jun 2014 12:03:48 INFO [process:MainProcess, thread:MainThread] Setting up server
Wed, 11 Jun 2014 12:03:48 INFO [process:MainProcess, thread:MainThread] Loading modules from /usr/share/ovirt-scheduler-proxy/plugins
Wed, 11 Jun 2014 12:03:48 INFO [process:MainProcess, thread:MainThread] Loading analyzer from /usr/lib/python2.6/site-packages/ovirtscheduler
Wed, 11 Jun 2014 12:03:48 INFO [process:MainProcess, thread:MainThread] [Request:Main][Method:loadModules] - Trying to load the following files: ['memory_even_distribution']
Wed, 11 Jun 2014 12:03:48 DEBUG [process:MainProcess, thread:Thread-1] [Request:Main][Method:PythonMethodRunner] - running ['python', '-c', "import loader; loader.loader().analyze('/usr/share/ovirt-scheduler-proxy/plugins', 'memory_even_distribution')"] in /usr/lib/python2.6/site-packages/ovirtscheduler
Wed, 11 Jun 2014 12:03:49 DEBUG [process:MainProcess, thread:MainThread] [Request:Main][Method:loadModules] - script: ['python', '-c', "import loader; loader.loader().analyze('/usr/share/ovirt-scheduler-proxy/plugins', 'memory_even_distribution')"]
Wed, 11 Jun 2014 12:03:49 INFO [process:MainProcess, thread:MainThread] [Request:Main][Method:loadModules] - registering: ('memory_even_distribution', ('memory_even_distribution', 'do_score', '', ''))
Wed, 11 Jun 2014 12:03:49 INFO [process:MainProcess, thread:MainThread] [Request:Main][Method:loadModules] - registering::loaded- filters:{} scores:{'memory_even_distribution': ('', '')} balancers:{}
Wed, 11 Jun 2014 12:03:49 INFO [process:MainProcess, thread:MainThread] Publishing API
Wed, 11 Jun 2014 12:13:47 INFO [process:MainProcess, thread:Thread-5] [Request:13728aa4-f151-11e3-9669-78e7d1f4ada5][Method:discover] - got request
Wed, 11 Jun 2014 12:13:47 INFO [process:MainProcess, thread:Thread-5] [Request:13728aa4-f151-11e3-9669-78e7d1f4ada5][Method:discover] - returning: {'balance': {}, 'filters': {}, 'scores': {'memory_even_distribution': ('', '')}}
Wed, 11 Jun 2014 14:19:16 INFO [process:MainProcess, thread:Thread-6] [Request:9b09c7fa-f162-11e3-87fd-78e7d1f4ada5][Method:run_cost_functions] - got request: [['memory_even_distribution', 1]]
Wed, 11 Jun 2014 14:19:16 DEBUG [process:MainProcess, thread:Thread-7] [Request:9b09c7fa-f162-11e3-87fd-78e7d1f4ada5][Method:PythonMethodRunner] - running ['python', '-c', "import memory_even_distribution; memory_even_distribution.memory_even_distribution().do_score(['013d804e-714a-4e79-8fd2-f88e72b74086', 'f25a1f66-73ee-4209-b0e2-46b77a11b3f9'], 'ab505d9b-1811-4153-8d84-3efc7d878898', {})"] in /usr/share/ovirt-scheduler-proxy/plugins
Wed, 11 Jun 2014 14:19:16 DEBUG [process:MainProcess, thread:Thread-6] [Request:9b09c7fa-f162-11e3-87fd-78e7d1f4ada5][Method:run_cost_functions] - Waiting for scoring to finish
Wed, 11 Jun 2014 14:19:18 DEBUG [process:MainProcess, thread:Thread-6] [Request:9b09c7fa-f162-11e3-87fd-78e7d1f4ada5][Method:run_cost_functions] - Aggregating results
Wed, 11 Jun 2014 14:19:18 INFO [process:MainProcess, thread:Thread-6] [Request:9b09c7fa-f162-11e3-87fd-78e7d1f4ada5][Method:run_cost_functions] - returning: [('f25a1f66-73ee-4209-b0e2-46b77a11b3f9', 9223372010239819775), ('013d804e-714a-4e79-8fd2-f88e72b74086', 9223372006882279423)]
More information about the Users
mailing list