JasperServer crashes after importing a portlet organization?

[f_chas01]

I've discovered the following problem:

 

While integrating JasperServer in Liferay via JasperServer portlet the portlet organization is being imported in JasperServer. It works and one can work with JasperServer via portlet _as long as JasperServer is running_.

If you try to restart JasperServer, it will not start. I tested it several times - each time the same effect. Can anybody please take a look on the logs?

Here are the logs. The first part is for for the importing the portlet organization and user in JasperServer:

2011-06-16 10:37:25,172 DEBUG JIPortletAuthenticationProcessingFilter,http-8484-4:75 - Trusted Host Authentication.
2011-06-16 10:37:25,172 DEBUG JIPortletAuthenticationProcessingFilter,http-8484-4:86 - Requested from Trusted Host IP:192.168.5.101
2011-06-16 10:37:25,219 DEBUG JIPortletAuthenticationProcessingFilter,http-8484-4:139 - Created New User:bruno@7cogs.com
2011-06-16 10:37:25,219  INFO MTJIPortletAuthenticationProcessingFilter,http-8484-4:153 - Creating portlet tenant 10494
2011-06-16 10:37:31,687 DEBUG JIPortletAuthenticationProcessingFilter,http-8484-4:151 - Created Authentication Object within JIPortletAuthenticationProcessingFilter
2011-06-16 10:37:31,687 DEBUG MTBasicProcessingFilter,http-8484-4:74 - Authorization header: Basic YnJ1bm9AN2NvZ3MuY29tOg==
2011-06-16 10:37:31,906 DEBUG MTUserAuthorityServiceImpl,http-8484-4:141 - No such user as: bruno@7cogs.com in tenant null
2011-06-16 10:37:31,906 DEBUG MTUserAuthorityServiceImpl,http-8484-4:191 - User not found with username "bruno@7cogs.com" in tenant alias null
2011-06-16 10:37:31,922  WARN LoggerListener,http-8484-4:60 - Authentication event AuthenticationFailureBadCredentialsEvent: bruno@7cogs.com; details: com.jaspersoft.jasperserver.multipleTenancy.MTWebServicesAuthenticationDetails@84b158; exception: Bad credentials
2011-06-16 10:37:31,984  WARN LoggerListener,http-8484-4:60 - Authentication event AuthenticationSuccessEvent: bruno@7cogs.com; details: com.jaspersoft.jasperserver.multipleTenancy.MTWebServicesAuthenticationDetails@3c12f
2011-06-16 10:37:31,984 DEBUG MTBasicProcessingFilter,http-8484-4:169 - Authentication success: org.springframework.security.providers.UsernamePasswordAuthenticationToken@fed80c01: Principal: MetadataUserDetails: bruno@7cogs.com; Password: [PROTECTED]; Authenticated: true; Details: com.jaspersoft.jasperserver.multipleTenancy.MTWebServicesAuthenticationDetails@3c12f; Granted Authorities: com.jaspersoft.jasperserver.api.metadata.user.domain.impl.client.TenantAwareGrantedAuthority@802d16, com.jaspersoft.jasperserver.api.metadata.user.domain.impl.client.TenantAwareGrantedAuthority@1101c54
 

While trying to restart JasperServer the following happening:

2011-06-16 10:41:03,703 ERROR ContextLoader,Thread-1:215 - Context initialization failed
org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'proOnStartPropagator' defined in ServletContext resource [/WEB-INF/applicationContext-multiTenancy-web.xml]: Invocation of init method failed; nested exception is com.jaspersoft.jasperserver.api.metadata.common.service.JSResourceNotFoundException: jsexception.folder.not.found.at
    at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1338)
    at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:473)
    at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory$1.run(AbstractAutowireCapableBeanFactory.java:409)
    at java.security.AccessController.doPrivileged(Native Method)
    at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:380)
    at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:264)
    at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222)
    at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:261)
    at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:185)
    at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:164)
    at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:429)
    at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:728)
    at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:380)
    at org.springframework.web.context.ContextLoader.createWebApplicationContext(ContextLoader.java:255)
    at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:199)
    at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:45)
    at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:3972)
    at org.apache.catalina.core.StandardContext.start(StandardContext.java:4467)
    at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:791)
    at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:771)
    at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:546)
    at org.apache.catalina.startup.HostConfig.deployDescriptor(HostConfig.java:637)
    at org.apache.catalina.startup.HostConfig.deployDescriptors(HostConfig.java:563)
    at org.apache.catalina.startup.HostConfig.deployApps(HostConfig.java:498)
    at org.apache.catalina.startup.HostConfig.start(HostConfig.java:1277)
    at org.apache.catalina.startup.HostConfig.lifecycleEvent(HostConfig.java:321)
    at org.apache.catalina.util.LifecycleSupport.fireLifecycleEvent(LifecycleSupport.java:119)
    at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1053)
    at org.apache.catalina.core.StandardHost.start(StandardHost.java:785)
    at org.apache.catalina.core.ContainerBase.start(ContainerBase.java:1045)
    at org.apache.catalina.core.StandardEngine.start(StandardEngine.java:443)
    at org.apache.catalina.core.StandardService.start(StandardService.java:519)
    at org.apache.catalina.core.StandardServer.start(StandardServer.java:710)
    at org.apache.catalina.startup.Catalina.start(Catalina.java:581)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
    at java.lang.reflect.Method.invoke(Method.java:597)
    at org.apache.catalina.startup.Bootstrap.start(Bootstrap.java:289)
    at org.apache.catalina.startup.Bootstrap.main(Bootstrap.java:414)
Caused by: com.jaspersoft.jasperserver.api.metadata.common.service.JSResourceNotFoundException: jsexception.folder.not.found.at
    at com.jaspersoft.jasperserver.api.metadata.common.service.impl.hibernate.HibernateRepositoryServiceImpl.getFolder(HibernateRepositoryServiceImpl.java:382)
    at com.jaspersoft.jasperserver.api.metadata.common.service.impl.hibernate.HibernateRepositoryServiceImpl$11.execute(HibernateRepositoryServiceImpl.java:336)
    at com.jaspersoft.jasperserver.api.metadata.common.service.impl.HibernateDaoImpl.executeWriteCallback(HibernateDaoImpl.java:73)
    at com.jaspersoft.jasperserver.api.metadata.common.service.impl.HibernateDaoImpl.executeWriteCallback(HibernateDaoImpl.java:64)
    at com.jaspersoft.jasperserver.api.metadata.common.service.impl.hibernate.HibernateRepositoryServiceImpl.saveFolder(HibernateRepositoryServiceImpl.java:304)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
    at java.lang.reflect.Method.invoke(Method.java:597)
    at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:307)
    at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:182)
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:149)
    at org.springframework.transaction.interceptor.TransactionInterceptor.invoke(TransactionInterceptor.java:106)
    at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:171)
    at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
    at $Proxy0.saveFolder(Unknown Source)
    at com.jaspersoft.ji.war.themes.MTThemeOnStartPropagator.createFolderByTemplate(MTThemeOnStartPropagator.java:133)
    at com.jaspersoft.ji.war.themes.MTThemeOnStartPropagator.ensureDefaultFolder(MTThemeOnStartPropagator.java:111)
    at com.jaspersoft.ji.war.themes.MTThemeOnStartPropagator.afterPropertiesSet(MTThemeOnStartPropagator.java:53)
    at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1369)
    at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1335)
    ... 39 more

 

[f_chas01]

This must be the deciding part:

2011-06-16 10:37:25,172 DEBUG JIPortletAuthenticationProcessingFilter,http-8484-4:86 - Requested from Trusted Host IP:192.168.5.101
2011-06-16 10:37:25,219 DEBUG JIPortletAuthenticationProcessingFilter,http-8484-4:139 - Created New User:bruno@7cogs.com

-^user object is created here^-
2011-06-16 10:37:25,219  INFO MTJIPortletAuthenticationProcessingFilter,http-8484-4:153 - Creating portlet tenant 10494

-^portlet organization is created, 10494 is the ID of the Liferay orga^-
2011-06-16 10:37:31,687 DEBUG JIPortletAuthenticationProcessingFilter,http-8484-4:151 - Created Authentication Object within JIPortletAuthenticationProcessingFilter
2011-06-16 10:37:31,687 DEBUG MTBasicProcessingFilter,http-8484-4:74 - Authorization header: Basic YnJ1bm9AN2NvZ3MuY29tOg==
2011-06-16 10:37:31,906 DEBUG MTUserAuthorityServiceImpl,http-8484-4:141 - No such user as: bruno@7cogs.com in tenant null

-^This is where it looks like something going wrong. Why is the tanant null when few seconds ago the tenant 10494 was created?^ -
2011-06-16 10:37:31,906 DEBUG MTUserAuthorityServiceImpl,http-8484-4:191 - User not found with username "bruno@7cogs.com" in tenant alias null

-^The same here^ -
2011-06-16 10:37:31,922  WARN LoggerListener,http-8484-4:60 - Authentication event AuthenticationFailureBadCredentialsEvent: bruno@7cogs.com; details: com.jaspersoft.jasperserver.multipleTenancy.MTWebServicesAuthenticationDetails@84b158; exception: Bad credentials

-^This part is also weird. How could there be bad credentials when user successfully logs on into the JasperServer and can browse the repository of the portlet organization?^ -

Post Edited by f_chas01 at 06/17/2011 07:43

[ramnik]

This seems to be real bug in the application in 4.1 release and will be fixed in next release - 4.2 which is coming in end of july

 

thanks

Ramnik Kaur

Senior QA Engineer

[bjeup]

Just as an FYI I am also experiencing this same problem with 4.0. Since 4.2 is on its way I suppose it may not matter a whole lot just figured I'd chime in.

Also, is there anyway to get Jasperserver to start again after this has occurred? Throughout my testing I have not been able to get it to restart once this happens.

[ernestoo]

 So not quite sure what the problem is - I'll lookup the bug id and make sure it's being looked at. The only way I found to revive JasperReports server was to delete the Portal organization and it's users from the database

1st DELETE FROM JIUserRole

2nd DELETE FROM `JIAccessEvent` WHERE `user_id` =  your user id

3rd DELETE FROM JIUserRole

4th DELETE FROM JIUser

5th DELETE FROM JITenant