HTTP Status 500 - Exception occurred while rendering template 'templates/jira/appconsistency/jiralocked.vm'.

Question

i was migrate JIRA to another server and backup files moved to new server i followed https://confluence.atlassian.com/display/JIRA/Migrating+JIRA+to+Another+Server attach the /logs/catalina.out user.timezone : Etc/UTC 2015-05-10 13:03:52,676 localhost-startStop-1 FATAL [atlassian.jira.startup.JiraStartupLogger] ***************************************************************** Could not create subdirectory 'plugins' of jira.home '/data/var'. ***************************************************************** log4j:ERROR setFile(null,true) call failed. java.io.FileNotFoundException: atlassian-jira.log (Permission denied) at java.io.FileOutputStream.open0(Native Method) at java.io.FileOutputStream.open(FileOutputStream.java:270) at java.io.FileOutputStream.(FileOutputStream.java:213) at java.io.FileOutputStream.(FileOutputStream.java:133) at org.apache.log4j.FileAppender.setFile(FileAppender.java:294) at org.apache.log4j.RollingFileAppender.setFile(RollingFileAppender.java:207) at org.apache.log4j.FileAppender.activateOptions(FileAppender.java:165) at com.atlassian.jira.logging.JiraHomeAppender.configureAppender(JiraHomeAppender.java:341) at com.atlassian.jira.logging.JiraHomeAppender.doAppendSync(JiraHomeAppender.java:267) at com.atlassian.jira.logging.JiraHomeAppender.doAppend(JiraHomeAppender.java:248) at org.apache.log4j.helpers.AppenderAttachableImpl.appendLoopOnAppenders(AppenderAttachableImpl.java:66) at org.apache.log4j.Category.callAppenders(Category.java:206) at org.apache.log4j.Category.forcedLog(Category.java:391) at org.apache.log4j.Category.log(Category.java:838) at com.atlassian.jira.startup.FormattedLogMsg.printMessageImpl(FormattedLogMsg.java:222) at com.atlassian.jira.startup.FormattedLogMsg.printMessage(FormattedLogMsg.java:214) at com.atlassian.jira.startup.JiraStartupLogger.printMessage(JiraStartupLogger.java:59) at com.atlassian.jira.startup.StartupStateTemplate$CreateStartupChecksResult.call(StartupStateTemplate.java:124) at com.atlassian.jira.startup.StartupStateTemplate$CreateStartupChecksResult.call(StartupStateTemplate.java:115) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at com.atlassian.jira.startup.StartupStateTemplate.isStartupChecksPassed(StartupStateTemplate.java:47) at com.atlassian.jira.startup.JiraStartupChecklist.startupOK(JiraStartupChecklist.java:52) at com.atlassian.jira.startup.BootstrapContainerLauncher.bootstrapJIRA(BootstrapContainerLauncher.java:52) at com.atlassian.jira.startup.BootstrapContainerLauncher.start(BootstrapContainerLauncher.java:31) at com.atlassian.jira.startup.DefaultJiraLauncher.preDbLaunch(DefaultJiraLauncher.java:98) at com.atlassian.jira.startup.DefaultJiraLauncher.access$000(DefaultJiraLauncher.java:33) at com.atlassian.jira.startup.DefaultJiraLauncher$1.run(DefaultJiraLauncher.java:85) at com.atlassian.jira.util.devspeed.JiraDevSpeedTimer.run(JiraDevSpeedTimer.java:34) at com.atlassian.jira.startup.DefaultJiraLauncher.start(DefaultJiraLauncher.java:81) at com.atlassian.jira.startup.LauncherContextListener.contextInitialized(LauncherContextListener.java:72) at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4992) at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5490) at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150) at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1575) at org.apache.catalina.core.ContainerBase$StartChild.call(ContainerBase.java:1565) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) 2015-05-10 13:03:52,683 localhost-startStop-1 INFO [atlassian.jira.startup.JiraStartupLogger] Running JIRA startup checks. 2015-05-10 13:03:52,683 localhost-startStop-1 FATAL [atlassian.jira.startup.JiraStartupLogger] Startup check failed. JIRA will be locked. 2015-05-10 13:03:52,760 localhost-startStop-1 INFO [jira.config.database.SystemDatabaseConfigurationLoader] Reading database configuration from /data/var/dbconfig.xml 2015-05-10 13:03:53,104 localhost-startStop-1 INFO [atlassian.jira.startup.LauncherContextListener] Memory Usage: --------------------------------------------------------------------------------- Heap memory : Used: 76 MiB. Committed: 460 MiB. Max: 718 MiB Non-heap memory : Used: 32 MiB. Committed: 34 MiB. Max: 1264 MiB --------------------------------------------------------------------------------- TOTAL : Used: 108 MiB. Committed: 494 MiB. Max: 1982 MiB --------------------------------------------------------------------------------- 2015-05-10 13:03:53,400 localhost-startStop-1 WARN [jira.config.properties.ApplicationPropertiesStore] Exception getting property 'jira.trustedapps.user.name.transformation.policy.class' from database. Using default 2015-05-10 13:03:53,564 localhost-startStop-1 ERROR [jira.web.dispatcher.JiraWebworkActionDispatcher] ****************************************** JIRA startup failed, JIRA has been locked. ****************************************** May 10, 2015 1:03:53 PM org.apache.catalina.startup.HostConfig start SEVERE: Unable to create directory for deployment: /data/jira/conf/Catalina/localhost May 10, 2015 1:03:53 PM org.apache.coyote.AbstractProtocol start INFO: Starting ProtocolHandler ["http-bio-8080"] May 10, 2015 1:03:53 PM org.apache.catalina.startup.Catalina start INFO: Server startup in 9555 ms 2015-05-10 13:03:53,935 http-bio-8080-exec-2 ERROR anonymous 783x2x1 - 125.57.206.11 /JiraLockedError [jira.template.velocity.VelocityEngineFactory$Default] Exception initialising Velocity: java.lang.RuntimeException: org.apache.velocity.util.ClassConstructionException: Cannot instantiate class for introspector.cache.classes java.lang.RuntimeException: org.apache.velocity.util.ClassConstructionException: Cannot instantiate class for introspector.cache.classes at com.atlassian.velocity.htmlsafe.introspection.AnnotationBoxingUberspect.init(AnnotationBoxingUberspect.java:59) at org.apache.velocity.runtime.RuntimeInstance.initializeIntrospection(RuntimeInstance.java:366) at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:255) at org.apache.velocity.runtime.RuntimeInstance.init(RuntimeInstance.java:588) at org.apache.velocity.app.VelocityEngine.init(VelocityEngine.java:135) at com.atlassian.jira.template.velocity.VelocityEngineFactory$Default.initialise(VelocityEngineFactory.java:70) at com.atlassian.jira.template.velocity.VelocityEngineFactory$Default.access$000(VelocityEngineFactory.java:24) at com.atlassian.jira.template.velocity.VelocityEngineFactory$Default$1.create(VelocityEngineFactory.java:35) at com.atlassian.jira.template.velocity.VelocityEngineFactory$Default$1.create(VelocityEngineFactory.java:30) at com.atlassian.util.concurrent.LazyReference$Sync.run(LazyReference.java:325) at com.atlassian.util.concurrent.LazyReference.getInterruptibly(LazyReference.java:143) at com.atlassian.util.concurrent.LazyReference.get(LazyReference.java:112) at com.atlassian.jira.template.velocity.VelocityEngineFactory$Default.getEngine(VelocityEngineFactory.java:47) at com.atlassian.jira.startup.JiraStartupChecklistFilter.getVelocityEngine(JiraStartupChecklistFilter.java:117) at com.atlassian.jira.startup.JiraStartupChecklistFilter.doFilter(JiraStartupChecklistFilter.java:98) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208) at com.atlassian.jira.web.filters.MultipartBoundaryCheckFilter.doFilter(MultipartBoundaryCheckFilter.java:41) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208) at com.atlassian.jira.web.filters.steps.ChainedFilterStepRunner.doFilter(ChainedFilterStepRunner.java:87) at com.atlassian.jira.web.filters.JiraFirstFilter.doFilter(JiraFirstFilter.java:61) at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241) at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208) at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220) at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122) at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:501) at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:171) at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:103) at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116) at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:950) at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408) at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1070) at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:611) at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:316) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.velocity.util.ClassConstructionException: Cannot instantiate class for introspector.cache.classes at org.apache.velocity.util.introspection.IntrospectorBase.(IntrospectorBase.java:81) at org.apache.velocity.util.introspection.Introspector.(Introspector.java:65) at org.apache.velocity.util.introspection.UberspectImpl.init(UberspectImpl.java:66) at com.atlassian.velocity.htmlsafe.introspection.AnnotationBoxingUberspect.init(AnnotationBoxingUberspect.java:55) ... 38 more Caused by: org.apache.velocity.util.ClassConstructionException: java.lang.reflect.InvocationTargetException at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:180) at org.apache.velocity.util.introspection.IntrospectorBase.(IntrospectorBase.java:77) ... 41 more Caused by: java.lang.reflect.InvocationTargetException at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) at java.lang.reflect.Constructor.newInstance(Constructor.java:422) at org.apache.velocity.util.ClassUtils.getNewInstance(ClassUtils.java:168) ... 42 more Caused by: java.lang.NullPointerException at com.atlassian.velocity.JiraIntrospectorCache.(JiraIntrospectorCache.java:32) ... 47 more May 10, 2015 1:24:34 PM org.apache.catalina.core.StandardServer await INFO: A valid shutdown command was received via the shutdown port. Stopping the Server instance. May 10, 2015 1:24:34 PM org.apache.coyote.AbstractProtocol pause INFO: Pausing ProtocolHandler ["http-bio-8080"] May 10, 2015 1:24:34 PM org.apache.catalina.core.StandardService stopInternal INFO: Stopping service Catalina log4j:ERROR setFile(null,true) call failed. java.io.FileNotFoundException: atlassian-jira-security.log (Permission denied) at java.io.FileOutputStream.open0(Native Method) at java.io.FileOutputStream.open(FileOutputStream.java:270) at java.io.FileOutputStream.(FileOutputStream.java:213) at java.io.FileOutputStream.(FileOutputStream.java:133) at org.apache.log4j.FileAppender.setFile(FileAppender.java:294) at org.apache.log4j.RollingFileAppender.setFile(RollingFileAppender.java:207) at org.apache.log4j.FileAppender.activateOptions(FileAppender.java:165) at com.atlassian.jira.logging.JiraHomeAppender.configureAppender(JiraHomeAppender.java:341) at com.atlassian.jira.logging.JiraHomeAppender.doAppendSync(JiraHomeAppender.java:267) at com.atlassian.jira.logging.JiraHomeAppender.doAppend(JiraHomeAppender.java:248) at org.apache.log4j.helpers.AppenderAttachableImpl.appendLoopOnAppenders(AppenderAttachableImpl.java:66) at org.apache.log4j.Category.callAppenders(Category.java:206) at org.apache.log4j.Category.forcedLog(Category.java:391) at org.apache.log4j.Category.log(Category.java:856) at org.slf4j.impl.Log4jLoggerAdapter.warn(Log4jLoggerAdapter.java:400) at com.atlassian.seraph.filter.SecurityFilter.destroy(SecurityFilter.java:70) at org.apache.catalina.core.ApplicationFilterConfig.release(ApplicationFilterConfig.java:313) at org.apache.catalina.core.StandardContext.filterStop(StandardContext.java:4864) at org.apache.catalina.core.StandardContext.stopInternal(StandardContext.java:5677) at org.apache.catalina.util.LifecycleBase.stop(LifecycleBase.java:232) at org.apache.catalina.core.ContainerBase$StopChild.call(ContainerBase.java:1591) at org.apache.catalina.core.ContainerBase$StopChild.call(ContainerBase.java:1580) at java.util.concurrent.FutureTask.run(FutureTask.java:266) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) 2015-05-10 13:24:34,539 localhost-startStop-2 INFO [atlassian.jira.startup.DefaultJiraLauncher] Stopping launchers May 10, 2015 1:24:34 PM org.apache.coyote.AbstractProtocol stop INFO: Stopping ProtocolHandler ["http-bio-8080"] May 10, 2015 1:24:34 PM org.apache.coyote.AbstractProtocol destroy INFO: Destroying ProtocolHandler ["http-bio-8080"] please answer me thanks

PAS · Answer

Hi Nic,

You are right. We received the same error message. When we change the user that run the JIRA in the system from "jira" to "root", everything started up and run properly.

The thing is how can we tell which directories that the "jira" user need full permission to?

Thank you,

Nic Brough -Adaptavist- · Answer

The permissions on your new file system are wrong.

You need to make sure the operating system user running JIRA has full read/write/execute/delete permissions on all the directories and subdirectories it uses.  There's one for "JIRA installation" and another for "JIRA home" - it looks to me like you're using /data/var for "JIRA home" and the permissions there are wrong.