Adobe Experience Manager Sites & More

mikezooz · 10/15/15

Hi All,

I am using local CQ instance 5.6.1, frequently its got closed by automatically. Do you have any idea, why its happening?

Java version 1.6

Thanks,

Michael

Lokesh_Shivalingaiah · 10/15/15

ok.. here it says your heap memory is not enough. what is your permsize and xmx ?? normally -XX:MaxPermSize=256m -Xmx1024M is the configuration which we would give.

View solution in original post

Lokesh_Shivalingaiah · 10/15/15

Can you check your logs when you start the instance and also when it closes ?? If you see any errors please do post the same which would help us in finding the issue.

Lokesh_Shivalingaiah · 10/15/15

quickly, I can think of is it may be due to memory or disk space.

Whats your memory and disk space of your m/c ?

mikezooz · 10/15/15

12.10.2015 19:04:24.122 *INFO* [FelixStartLevel] groovy-all BundleEvent STARTING
12.10.2015 19:04:24.123 *INFO* [FelixStartLevel] groovy-all BundleEvent STARTED
12.10.2015 19:04:24.127 *INFO* [FelixStartLevel] itextpdf-Bundle-modfied BundleEvent STARTING
12.10.2015 19:04:24.131 *INFO* [FelixStartLevel] itextpdf-Bundle-modfied BundleEvent STARTED
12.10.2015 19:04:24.136 *INFO* [FelixStartLevel] itextxmlworker-Bundle BundleEvent STARTING
12.10.2015 19:04:24.138 *INFO* [FelixStartLevel] itextxmlworker-Bundle BundleEvent STARTED
12.10.2015 19:04:24.162 *INFO* [FelixStartLevel] Oracle_JDBC_Driver_Bundle BundleEvent RESOLVED
12.10.2015 19:04:24.173 *INFO* [FelixStartLevel] Oracle_JDBC_Driver_Bundle BundleEvent STARTING
12.10.2015 19:04:24.181 *INFO* [FelixStartLevel] Oracle_JDBC_Driver_Bundle BundleEvent STARTED
12.10.2015 19:04:24.253 *INFO* [FelixStartLevel] com.day.cq.cq-compat-codeupgrade BundleEvent RESOLVED
12.10.2015 19:04:24.256 *INFO* [FelixStartLevel] com.day.cq.cq-compat-codeupgrade BundleEvent STARTING
12.10.2015 19:04:24.260 *INFO* [FelixStartLevel] com.day.cq.cq-compat-codeupgrade BundleEvent STARTED
12.10.2015 19:04:24.278 *INFO* [FelixStartLevel] com.day.cq.cq-compat-codeupgrade Service [com.day.cq.compat.codeupgrade.impl.cq561.Cq561StartupCodeUpgrade,2103] ServiceEvent REGISTERED
12.10.2015 19:04:24.293 *INFO* [FelixStartLevel] com.day.cq.cq-compat-codeupgrade Service [com.day.cq.compat.codeupgrade.impl.cq54.Cq54StartupCodeUpgrade,2104] ServiceEvent REGISTERED
12.10.2015 19:04:24.325 *INFO* [FelixStartLevel] com.day.cq.cq-compat-codeupgrade Service [com.day.cq.compat.codeupgrade.impl.CodeUpgraderFactoryImpl,2105] ServiceEvent REGISTERED
12.10.2015 19:04:24.380 *INFO* [FelixStartLevel] com.day.cq.cq-compat-codeupgrade Service [com.day.cq.compat.codeupgrade.impl.cq56.Cq56StartupCodeUpgrade,2106] ServiceEvent REGISTERED
12.10.2015 19:04:24.427 *INFO* [FelixStartLevel] com.day.cq.cq-compat-codeupgrade Service [com.day.cq.compat.codeupgrade.impl.cq53.Cq53StartupCodeUpgrade,2107] ServiceEvent REGISTERED
12.10.2015 19:04:24.560 *INFO* [FelixStartLevel] com.day.cq.cq-upgrades-executor BundleEvent RESOLVED
12.10.2015 19:04:24.600 *INFO* [FelixStartLevel] com.day.cq.cq-upgrades-executor BundleEvent STARTING
12.10.2015 19:04:24.684 *INFO* [FelixStartLevel] com.day.cq.cq-upgrades-executor BundleEvent STARTED
12.10.2015 19:04:24.685 *INFO* [FelixStartLevel] org.apache.sling.startupfilter.disabler BundleEvent RESOLVED
12.10.2015 19:04:24.687 *INFO* [FelixStartLevel] org.apache.sling.startupfilter.disabler BundleEvent STARTING
12.10.2015 19:04:24.688 *INFO* [FelixStartLevel] org.apache.sling.startupfilter.disabler BundleEvent STARTED
12.10.2015 19:04:24.719 *WARN* [FelixDispatchQueue] org.codehaus.groovy.runtime.m12n.MetaInfExtensionModule Module [groovy-all] - Unable to load extension class [org.codehaus.groovy.runtime.NioGroovyMethods]
12.10.2015 19:04:24.747 *INFO* [FelixStartLevel] org.apache.sling.startupfilter.disabler Service [org.apache.sling.startupfilterdisabler.impl.StartupFilterDisablerImpl,2108] ServiceEvent REGISTERED
12.10.2015 19:04:24.809 *INFO* [main] org.apache.felix.framework BundleEvent STARTED
12.10.2015 19:04:24.912 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Adding ScriptEngine Groovy Scripting Engine, 2.0 for language Groovy, 2.4.3
12.10.2015 19:04:24.914 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Adding ScriptEngine Apache Sling JST script engine (Sling JavaScript Templates), 1.0 for language JavaScript Templates, 1.0
12.10.2015 19:04:24.915 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Adding ScriptEngine Apache Sling Scripting Java Support, 2.0.6 for language Java Servlet Compiler, 1.5
12.10.2015 19:04:24.915 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Adding ScriptEngine Apache Sling Scripting JSP Support, 2.0.28 for language Java Server Pages, 2.1
12.10.2015 19:04:24.916 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Adding ScriptEngine Apache Sling Scripting JavaScript Support (Rhino 1.6 release 6 2007 07 26), 2.0.12 for language ECMAScript, 0
12.10.2015 19:04:24.917 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Script extension 'ecma' is now handled by ScriptEngine 'Apache Sling Scripting JavaScript Support (Rhino 1.6 release 6 2007 07 26)', version='2.0.12', class='org.apache.sling.scripting.javascript.internal.RhinoJavaScriptEngine'
12.10.2015 19:04:24.918 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Script extension 'esp' is now handled by ScriptEngine 'Apache Sling Scripting JavaScript Support (Rhino 1.6 release 6 2007 07 26)', version='2.0.12', class='org.apache.sling.scripting.javascript.internal.RhinoJavaScriptEngine'
12.10.2015 19:04:24.941 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Script extension 'groovy' is now handled by ScriptEngine 'Groovy Scripting Engine', version='2.0', class='org.codehaus.groovy.jsr223.GroovyScriptEngineImpl'
12.10.2015 19:04:24.942 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Script extension 'java' is now handled by ScriptEngine 'Apache Sling Scripting Java Support', version='2.0.6', class='org.apache.sling.scripting.java.impl.JavaScriptEngineFactory$JavaScriptEngine'
12.10.2015 19:04:24.943 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Script extension 'jsp' is now handled by ScriptEngine 'Apache Sling Scripting JSP Support', version='2.0.28', class='org.apache.sling.scripting.jsp.JspScriptEngineFactory$JspScriptEngine'
12.10.2015 19:04:24.943 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Script extension 'jspf' is now handled by ScriptEngine 'Apache Sling Scripting JSP Support', version='2.0.28', class='org.apache.sling.scripting.jsp.JspScriptEngineFactory$JspScriptEngine'
12.10.2015 19:04:24.944 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Script extension 'jspx' is now handled by ScriptEngine 'Apache Sling Scripting JSP Support', version='2.0.28', class='org.apache.sling.scripting.jsp.JspScriptEngineFactory$JspScriptEngine'
12.10.2015 19:04:24.945 *INFO* [FelixDispatchQueue] org.apache.sling.scripting.core.impl.ScriptEngineManagerFactory Script extension 'jst' is now handled by ScriptEngine 'Apache Sling JST script engine (Sling JavaScript Templates)', version='1.0', class='org.apache.sling.scripting.jst.JstScriptEngine'
12.10.2015 19:04:25.233 *INFO* [FelixDispatchQueue] com.adobe.cq.social.ugc.impl.LuceneUgcSearch activating 4 extensions after startup complete
12.10.2015 19:04:26.146 *INFO* [FelixDispatchQueue] com.adobe.granite.workflow.core.launcher.WorkflowLauncherListener StartupListener.startupFinished called
12.10.2015 19:04:26.234 *INFO* [FelixDispatchQueue] com.adobe.granite.installer.factory.packages.impl.PackageTransformer Running in RESTART mode
12.10.2015 19:04:26.236 *INFO* [FelixDispatchQueue] org.apache.felix.framework FrameworkEvent STARTED
12.10.2015 19:04:27.034 *INFO* [127.0.0.1 [1444656867032] GET / HTTP/1.1] org.apache.sling.auth.core.impl.SlingAuthenticator getAnonymousResolver: Anonymous access not allowed by configuration - requesting credentials
12.10.2015 19:04:27.101 *INFO* [Workflow Starter Thread] com.adobe.granite.workflow.core.launcher.WorkflowLauncherListener Startup finished, workflow queue processing starting
12.10.2015 19:04:30.451 *INFO* [127.0.0.1 [1444656870448] OPTIONS / HTTP/1.1] org.apache.sling.auth.core.impl.SlingAuthenticator getAnonymousResolver: Anonymous access not allowed by configuration - requesting credentials
12.10.2015 19:04:33.690 *INFO* [Thread-47] com.adobe.cq.social.storage.index.AbstractBaseReindexer Completed reindexing /content/geometrixx-outdoors/en/support/jcr:content/par/forum
12.10.2015 19:04:34.594 *INFO* [127.0.0.1 [1444656874591] OPTIONS / HTTP/1.1] org.apache.sling.auth.core.impl.SlingAuthenticator getAnonymousResolver: Anonymous access not allowed by configuration - requesting credentials
12.10.2015 19:04:34.642 *INFO* [127.0.0.1 [1444656874641] GET / HTTP/1.1] org.apache.sling.auth.core.impl.SlingAuthenticator getAnonymousResolver: Anonymous access not allowed by configuration - requesting credentials
12.10.2015 19:04:34.682 *INFO* [127.0.0.1 [1444656874681] HEAD / HTTP/1.1] org.apache.sling.auth.core.impl.SlingAuthenticator getAnonymousResolver: Anonymous access not allowed by configuration - requesting credentials
12.10.2015 19:04:36.946 *INFO* [127.0.0.1 [1444656876945] PUT /libs/sling/topology/connector.a924453d-0bfc-44d8-8dd5-a801bdd8a96b.json HTTP/1.1] org.apache.sling.startupfilter.impl.StartupFilterImpl StartupFilterDisabler service present, disabling StartupFilter (org.apache.sling.startupfilterdisabler.impl.StartupFilterDisablerImpl@8e4b0b is active)

Opkar_Gill · 10/15/15

Hi Michael,

is that the end of the error log after your instance stopped unexpectedly? Usually if the instance is shutdown gracefully, you will get logs saying shutting down.

Does the instance stop at random times or the same time everyday? Are you monitoring the server to measure CPU/memory usage, as would be good to see what is happening when the instance stops.

Are you using windows or linux?

Regards,

Opkar

Lokesh_Shivalingaiah · 10/15/15

I dont see any error or problems here... Do you mind attaching the complete log file !

Also what is your system configuration ?

mikezooz · 10/15/15

12.10.2015 19:43:04.230 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
   at com.day.j2ee.servletengine.ServletHandlerImpl.<init>(ServletHandlerImpl.java:224)
   at com.day.j2ee.servletengine.HttpListener$Worker.<init>(HttpListener.java:562)
   at com.day.j2ee.servletengine.HttpListener.newWorkerThread(HttpListener.java:492)
   at com.day.j2ee.servletengine.HttpListener.createWorkerThread(HttpListener.java:477)
   at com.day.j2ee.servletengine.HttpListener.getWorkerThread(HttpListener.java:505)
   at com.day.j2ee.servletengine.HttpListener.processSocket(HttpListener.java:427)
   at com.day.j2ee.servletengine.HttpListener$Acceptor.run(HttpListener.java:397)
   at java.lang.Thread.run(Unknown Source)
12.10.2015 19:43:05.607 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:06.906 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:08.244 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:09.450 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:10.840 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:12.066 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:13.256 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:14.539 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:15.819 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:17.167 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:18.716 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:19.975 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:21.336 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:22.695 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:24.036 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:25.235 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:26.533 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:26.557 *INFO* [pool-6-thread-1] org.apache.jackrabbit.core.persistence.bundle.AbstractBundlePersistenceManager cachename=crx.defaultBundleCache[ConcurrentCache@e2ad6f], elements=2725, usedmemorykb=8189, maxmemorykb=8192, access=74041, miss=18362
12.10.2015 19:43:28.065 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:28.067 *WARN* [pool-6-thread-1] org.apache.sling.discovery.impl.topology.connector.TopologyConnectorClient ping: got IOException [suppressing further warns]: java.net.SocketException: Software caused connection abort: recv failed, uri=http://localhost:4502/libs/sling/topology/connector.a924453d-0bfc-44d8-8dd5-a801bdd8a96b.json
12.10.2015 19:43:30.579 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:33.470 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space
12.10.2015 19:43:49.181 *ERROR* [CQSE Listener [0.0.0.0:4502]] servletengine Error while assigning socket java.lang.OutOfMemoryError: Java heap space

Lokesh_Shivalingaiah · 10/15/15

ok.. here it says your heap memory is not enough. what is your permsize and xmx ?? normally -XX:MaxPermSize=256m -Xmx1024M is the configuration which we would give.