[
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
