[ https://issues.apache.org/jira/browse/CLOUDSTACK-3091?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13689087#comment-13689087 ]
Wei Zhou commented on CLOUDSTACK-3091: -------------------------------------- 2013-06-18 14:40:20,588 DEBUG [sf.ehcache.CacheManager] (Timer-1:null) Creating new CacheManager with default config 2013-06-18 14:40:20,593 DEBUG [sf.ehcache.CacheManager] (Timer-1:null) Configuring ehcache from classpath. 2013-06-18 14:40:20,596 DEBUG [ehcache.config.ConfigurationFactory] (Timer-1:null) Configuring ehcache from ehcache.xml found in the classpath: file:/usr/share/cloudstack-management/webapps/client/WEB-INF/classes/ehcache.xml 2013-06-18 14:40:20,596 DEBUG [ehcache.config.ConfigurationFactory] (Timer-1:null) Configuring ehcache from URL: file:/usr/share/cloudstack-management/webapps/client/WEB-INF/classes/ehcache.xml 2013-06-18 14:40:20,596 DEBUG [ehcache.config.ConfigurationFactory] (Timer-1:null) Configuring ehcache from InputStream 2013-06-18 14:40:20,606 DEBUG [ehcache.config.ConfigurationFactory] (Timer-1:null) Did not find a system property for the ${multicastGroupPort} token specified in the configuration.Replacing with "" 2013-06-18 14:40:20,606 DEBUG [ehcache.config.ConfigurationFactory] (Timer-1:null) Did not find a system property for the ${token} token specified in the configuration.Replacing with "" 2013-06-18 14:40:20,629 DEBUG [ehcache.config.BeanHandler] (Timer-1:null) Ignoring ehcache attribute xmlns:xsi 2013-06-18 14:40:20,629 DEBUG [ehcache.config.BeanHandler] (Timer-1:null) Ignoring ehcache attribute xsi:noNamespaceSchemaLocation 2013-06-18 14:40:20,641 DEBUG [sf.ehcache.CacheManager] (Timer-1:null) No disk store path defined. Skipping disk store path conflict test. 2013-06-18 14:40:20,641 DEBUG [ehcache.config.ConfigurationHelper] (Timer-1:null) No CacheManagerEventListenerFactory class specified. Skipping... 2013-06-18 14:40:20,650 DEBUG [ehcache.util.PropertyUtil] (Timer-1:null) propertiesString is null. 2013-06-18 14:40:20,653 DEBUG [ehcache.distribution.RMICacheManagerPeerListener] (Timer-1:null) Automatically finding a free TCP/IP port to listen on: 52130 2013-06-18 14:40:20,667 DEBUG [ehcache.util.PropertyUtil] (Timer-1:null) Value found for peerDiscovery: automatic 2013-06-18 14:40:20,667 DEBUG [ehcache.util.PropertyUtil] (Timer-1:null) Value found for multicastGroupAddress: 230.0.0.1 2013-06-18 14:40:20,667 DEBUG [ehcache.util.PropertyUtil] (Timer-1:null) Value found for multicastGroupPort: 4446 2013-06-18 14:40:20,667 DEBUG [ehcache.util.PropertyUtil] (Timer-1:null) Value found for timeToLive: 1 2013-06-18 14:40:20,693 DEBUG [ehcache.config.DiskStoreConfiguration] (Timer-1:null) Disk Store Path: /usr/share/cloudstack-management/temp 2013-06-18 14:40:20,694 DEBUG [ehcache.config.ConfigurationHelper] (Timer-1:null) No BootstrapCacheLoaderFactory class specified. Skipping... 2013-06-18 14:40:20,694 DEBUG [ehcache.config.ConfigurationHelper] (Timer-1:null) No CacheLoaderFactory class specified. Skipping... 2013-06-18 14:40:20,694 DEBUG [ehcache.config.ConfigurationHelper] (Timer-1:null) No CacheExceptionHandlerFactory class specified. Skipping... 2013-06-18 14:41:03,836 INFO [factory.annotation.AutowiredAnnotationBeanPostProcessor] (catalina-exec-1:null) JSR-330 'javax.inject.Inject' annotation found and supported for autowiring 2013-06-18 14:41:03,837 DEBUG [factory.annotation.InjectionMetadata] (catalina-exec-1:null) Found injected element on class [com.cloud.api.ApiServlet]: AutowiredFieldElement for com.cloud.api.ApiServerService com.cloud.api.ApiServlet._ap iServer 2013-06-18 14:41:03,837 DEBUG [factory.annotation.InjectionMetadata] (catalina-exec-1:null) Found injected element on class [com.cloud.api.ApiServlet]: AutowiredFieldElement for com.cloud.user.AccountService com.cloud.api.ApiServlet._acc ountMgr 2013-06-18 14:41:03,837 DEBUG [factory.annotation.InjectionMetadata] (catalina-exec-1:null) Processing injected method of bean 'null': AutowiredFieldElement for com.cloud.api.ApiServerService com.cloud.api.ApiServlet._apiServer 2013-06-18 14:41:03,837 DEBUG [factory.support.DefaultListableBeanFactory] (catalina-exec-1:null) Returning cached instance of singleton bean 'apiServer' 2013-06-18 14:41:03,837 DEBUG [factory.annotation.InjectionMetadata] (catalina-exec-1:null) Processing injected method of bean 'null': AutowiredFieldElement for com.cloud.user.AccountService com.cloud.api.ApiServlet._accountMgr 2013-06-18 14:41:03,837 DEBUG [factory.support.DefaultListableBeanFactory] (catalina-exec-1:null) Returning cached instance of singleton bean 'accountManagerImpl' 2013-06-18 14:41:03,855 DEBUG [cloud.api.ApiServlet] (catalina-exec-1:null) ===START=== 10.0.28.12 -- GET command=listVirtualMachines&details=stats&id=48d307fb-15aa-4c57-bed4-0fd2119061b4&response=json&sessionkey=Gs2CL7Qd5Br7uedft00C8z ab5xc%3D&_=1371559263733 2013-06-18 14:41:03,897 DEBUG [cloud.api.ApiServlet] (catalina-exec-1:null) ===END=== 10.0.28.12 -- GET command=listVirtualMachines&details=stats&id=48d307fb-15aa-4c57-bed4-0fd2119061b4&response=json&sessionkey=Gs2CL7Qd5Br7uedft00C8zab 5xc%3D&_=1371559263733 2013-06-18 14:41:06,651 DEBUG [cloud.api.ApiServlet] (catalina-exec-13:null) ===START=== 10.0.28.12 -- GET command=listCapabilities&response=json&sessionkey=Gs2CL7Qd5Br7uedft00C8zab5xc%3D&_=1371559266619 2013-06-18 14:41:06,656 DEBUG [cloud.api.ApiServlet] (catalina-exec-13:null) ===END=== 10.0.28.12 -- GET command=listCapabilities&response=json&sessionkey=Gs2CL7Qd5Br7uedft00C8zab5xc%3D&_=1371559266619 2013-06-18 14:41:10,934 DEBUG [cloud.api.ApiServlet] (catalina-exec-4:null) ===START=== 10.0.28.12 -- POST null 2013-06-18 14:41:10,945 DEBUG [cloud.user.AccountManagerImpl] (catalina-exec-4:null) Attempting to log in user: admin in domain 1 2013-06-18 14:41:10,945 DEBUG [server.auth.SHA256SaltedUserAuthenticator] (catalina-exec-4:null) Retrieving user: admin 2013-06-18 14:41:11,068 DEBUG [cloud.user.AccountManagerImpl] (catalina-exec-4:null) User: admin in domain 1 has successfully logged in 2013-06-18 14:41:11,131 DEBUG [cloud.api.ApiServlet] (catalina-exec-4:null) ===END=== 10.0.28.12 -- POST null 2013-06-18 14:41:11,137 DEBUG [cloud.api.ApiServlet] (catalina-exec-5:null) ===START=== 10.0.28.12 -- GET command=listCapabilities&response=json&sessionkey=9lwiB0W25gsUf6eT937aFOuDy6o%3D&_=1371559271115 2013-06-18 14:41:11,161 DEBUG [cloud.api.ApiServer] (catalina-exec-5:null) The given command:listCapabilities does not exist or it is not available for user with id:2 2013-06-18 14:41:11,163 DEBUG [cloud.api.ApiServlet] (catalina-exec-5:null) ===END=== 10.0.28.12 -- GET command=listCapabilities&response=json&sessionkey=9lwiB0W25gsUf6eT937aFOuDy6o%3D&_=1371559271115 2013-06-18 14:41:11,168 DEBUG [cloud.api.ApiServlet] (catalina-exec-9:null) ===START=== 10.0.28.12 -- GET command=listSwifts&response=json&sessionkey=9lwiB0W25gsUf6eT937aFOuDy6o%3D&_=1371559271146 2013-06-18 14:41:11,187 DEBUG [cloud.api.ApiServer] (catalina-exec-9:null) The given command:listSwifts does not exist or it is not available for user with id:2 2013-06-18 14:41:11,189 DEBUG [cloud.api.ApiServlet] (catalina-exec-9:null) ===END=== 10.0.28.12 -- GET command=listSwifts&response=json&sessionkey=9lwiB0W25gsUf6eT937aFOuDy6o%3D&_=1371559271146 2013-06-18 14:41:23,763 DEBUG [ehcache.distribution.RMICacheManagerPeerListener] (Timer-1:null) 0 RMICachePeers bound in registry for RMI listener 2013-06-18 14:41:23,763 DEBUG [ehcache.config.DiskStoreConfiguration] (Timer-1:null) Disk Store Path: /usr/share/cloudstack-management/temp 2013-06-18 14:41:23,768 DEBUG [ehcache.store.MemoryStore] (Timer-1:null) Initialized net.sf.ehcache.store.LruMemoryStore for UserDaoImpl_EnhancerByCloudStack_9d3ad635 2013-06-18 14:41:23,769 DEBUG [ehcache.store.LruMemoryStore] (Timer-1:null) UserDaoImpl_EnhancerByCloudStack_9d3ad635 Cache: Using SpoolingLinkedHashMap implementation 2013-06-18 14:41:23,770 DEBUG [sf.ehcache.Cache] (Timer-1:null) Initialised cache: UserDaoImpl_EnhancerByCloudStack_9d3ad635 2013-06-18 14:41:23,770 DEBUG [ehcache.distribution.RMICacheManagerPeerListener] (Timer-1:null) Adding UserDaoImpl_EnhancerByCloudStack_9d3ad635 to RMI listener 2013-06-18 14:41:23,770 DEBUG [ehcache.distribution.RMICacheManagerPeerListener] (Timer-1:null) 0 RMICachePeers bound in registry for RMI listener > Not able to login to the CS UI using admin:password after modifying the > internallbvm.service.offering and restarting management server > -------------------------------------------------------------------------------------------------------------------------------------- > > Key: CLOUDSTACK-3091 > URL: https://issues.apache.org/jira/browse/CLOUDSTACK-3091 > Project: CloudStack > Issue Type: Bug > Security Level: Public(Anyone can view this level - this is the > default.) > Components: Management Server > Affects Versions: 4.2.0 > Reporter: Abhinav Roy > Assignee: Alena Prokharchyk > Fix For: 4.2.0 > > Attachments: apilog.log, CS-3091.dmp, management-server.log > > > Steps & Observations : > ================================== > 1. Goto global setting and set internallbvm.service.offering to some UUID > (belonging to some other service offering) > 2. Restart management server service > #service cloudstack-management restart > Following error is seen in management server logs > 013-06-20 14:28:02,597 DEBUG [cloud.user.AccountManagerImpl] > (catalina-exec-1:null) Attempting to log in user: admin in domain 1 > 2013-06-20 14:28:02,597 DEBUG [server.auth.SHA256SaltedUserAuthenticator] > (catalina-exec-1:null) Retrieving user: admin > 2013-06-20 14:28:02,847 DEBUG [cloud.user.AccountManagerImpl] > (catalina-exec-1:null) User: admin in domain 1 has successfully logged in > 2013-06-20 14:28:02,870 DEBUG [cloud.api.ApiServlet] (catalina-exec-1:null) > ===END=== 10.144.6.28 -- POST null > 2013-06-20 14:28:02,892 DEBUG [cloud.api.ApiServlet] (catalina-exec-2:null) > ===START=== 10.144.6.28 -- GET > command=listCapabilities&response=json&sessionkey=m6pPGoe%2FSIgDok2pOfO8CMTbmTE%3D&_=1371718818773 > 2013-06-20 14:28:02,899 DEBUG [cloud.api.ApiServer] (catalina-exec-2:null) > The given command:listCapabilities does not exist or it is not available for > user with id:2 > 2013-06-20 14:28:02,907 DEBUG [cloud.api.ApiServlet] (catalina-exec-2:null) > ===END=== 10.144.6.28 -- GET > command=listCapabilities&response=json&sessionkey=m6pPGoe%2FSIgDok2pOfO8CMTbmTE%3D&_=1371718818773 > 2013-06-20 14:28:02,928 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) > ===START=== 10.144.6.28 -- GET > command=listSwifts&response=json&sessionkey=m6pPGoe%2FSIgDok2pOfO8CMTbmTE%3D&_=1371718818816 > 2013-06-20 14:28:02,933 DEBUG [cloud.api.ApiServer] (catalina-exec-3:null) > The given command:listSwifts does not exist or it is not available for user > with id:2 > 2013-06-20 14:28:02,935 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) > ===END=== 10.144.6.28 -- GET > command=listSwifts&response=json&sessionkey=m6pPGoe%2FSIgDok2pOfO8CMTbmTE%3D&_=1371718818816 > 2013-06-20 14:28:05,361 DEBUG [storage.secondary.SecondaryStorageManagerImpl] > (secstorage-1:null) Zone 1 is not ready to launch secondary storage VM yet > api server logs : > ------------------------------------------------- > 013-06-20 14:28:02,597 DEBUG [cloud.user.AccountManagerImpl] > (catalina-exec-1:null) Attempting to log in user: admin in domain 1 > 2013-06-20 14:28:02,597 DEBUG [server.auth.SHA256SaltedUserAuthenticator] > (catalina-exec-1:null) Retrieving user: admin > 2013-06-20 14:28:02,847 DEBUG [cloud.user.AccountManagerImpl] > (catalina-exec-1:null) User: admin in domain 1 has successfully logged in > 2013-06-20 14:28:02,870 DEBUG [cloud.api.ApiServlet] (catalina-exec-1:null) > ===END=== 10.144.6.28 -- POST null > 2013-06-20 14:28:02,892 DEBUG [cloud.api.ApiServlet] (catalina-exec-2:null) > ===START=== 10.144.6.28 -- GET > command=listCapabilities&response=json&sessionkey=m6pPGoe%2FSIgDok2pOfO8CMTbmTE%3D&_=1371718818773 > 2013-06-20 14:28:02,899 DEBUG [cloud.api.ApiServer] (catalina-exec-2:null) > The given command:listCapabilities does not exist or it is not available for > user with id:2 > 2013-06-20 14:28:02,907 DEBUG [cloud.api.ApiServlet] (catalina-exec-2:null) > ===END=== 10.144.6.28 -- GET > command=listCapabilities&response=json&sessionkey=m6pPGoe%2FSIgDok2pOfO8CMTbmTE%3D&_=1371718818773 > 2013-06-20 14:28:02,928 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) > ===START=== 10.144.6.28 -- GET > command=listSwifts&response=json&sessionkey=m6pPGoe%2FSIgDok2pOfO8CMTbmTE%3D&_=1371718818816 > 2013-06-20 14:28:02,933 DEBUG [cloud.api.ApiServer] (catalina-exec-3:null) > The given command:listSwifts does not exist or it is not available for user > with id:2 > 2013-06-20 14:28:02,935 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) > ===END=== 10.144.6.28 -- GET > command=listSwifts&response=json&sessionkey=m6pPGoe%2FSIgDok2pOfO8CMTbmTE%3D&_=1371718818816 > 2013-06-20 14:28:05,361 DEBUG [storage.secondary.SecondaryStorageManagerImpl] > (secstorage-1:null) Zone 1 is not ready to launch secondary storage VM yet > 3. Now login to the DB and remove that uuid, set the value of > interballbvm.service.offering to NULL again. > 4. Restart management server service > This time no error is seen, management server comes up and login to UI > succeeds. -- This message is automatically generated by JIRA. If you think it was sent incorrectly, please contact your JIRA administrators For more information on JIRA, see: http://www.atlassian.com/software/jira