cancel
Showing results for 
Search instead for 
Did you mean: 

login error: The remote server may be unavailable

hienque
Champ in-the-making
Champ in-the-making
Hi all,
My alfresco has a big error, so I delete entire the folder c:\alfresco and I extract the backup alfresco.rar (I backup when it is OK) . But I can not login again with my account.
The error is "The remote server may be unavailable or your authentication details have not been recognized."
Please help me! It is urgent
11 REPLIES 11

rjohnson
Star Contributor
Star Contributor
Your share / alfresco service is almost certainly not starting or is terminating quickly thereafter. Please check your logs; alfresco.log and catalina.out. These will tell you what your error is caused by. Feel free to post a snippet and someone may be able to help you.

Bob Johnson

hienque
Champ in-the-making
Champ in-the-making
Thanks Mr Bob Johnson!
Here is alfresco.log:

08:19:00,168 ERROR [org.alfresco.module.org_alfresco_module_wcmquickstart.util.WebassetCollectionHelper] Failed to complete update of dynamic asset collection (workspace://SpacesStore/eb477c1e-ad7d-4762-8703-a8c4a3d55d65): select d.* from cmis:document as d where in_tree(d, 'workspace://SpacesStore/cddf5b4f-2bf0-485b-8b00-0fa90bf913f2') and d.cmis:objectTypeId='D:ws:article' order by d.cmis:creationDate desc
org.alfresco.repo.search.impl.lucene.LuceneQueryParserException: 06160087

08:19:00,215 ERROR [org.alfresco.module.org_alfresco_module_wcmquickstart.util.WebassetCollectionHelper] Failed to complete update of dynamic asset collection (workspace://SpacesStore/96cc82df-b3b3-41c4-987a-8daae93efb3a): SELECT d.* FROM cmis:document AS d JOIN ws:webasset AS wa ON d.cmis:objectId = wa.cmis:objectId WHERE d.cmis:objectTypeId='D:ws:article' AND in_tree(d, 'workspace://SpacesStore/2dc7f564-18df-4339-a509-be5b20322bad') ORDER BY wa.ws:publishedTime DESC
org.alfresco.repo.search.impl.lucene.LuceneQueryParserException: 06160088

08:19:00,277 ERROR [org.alfresco.module.org_alfresco_module_wcmquickstart.util.WebassetCollectionHelper] Failed to complete update of dynamic asset collection (workspace://SpacesStore/8b2b1a9f-2494-4c08-8744-c498b6dd3121): SELECT d.* FROM cmis:document AS d JOIN ws:webasset AS wa ON d.cmis:objectId = wa.cmis:objectId WHERE d.cmis:objectTypeId='D:ws:article' AND in_tree(d, 'workspace://SpacesStore/2dc7f564-18df-4339-a509-be5b20322bad') ORDER BY wa.ws:publishedTime DESC
org.alfresco.repo.search.impl.lucene.LuceneQueryParserException: 06160089
   
08:19:00,339 ERROR [org.alfresco.module.org_alfresco_module_wcmquickstart.util.WebassetCollectionHelper] Failed to complete update of dynamic asset collection (workspace://SpacesStore/5b8ca2b5-b052-4a1b-b86c-1883cc3552c2): select d.* from cmis:document as d where in_tree(d, 'workspace://SpacesStore/3f09c8f7-e263-455c-9419-5df1f318fde2') and d.cmis:objectTypeId='D:ws:article' order by d.cmis:creationDate desc
org.alfresco.repo.search.impl.lucene.LuceneQueryParserException: 06160090

08:19:00,402 ERROR [org.alfresco.module.org_alfresco_module_wcmquickstart.util.WebassetCollectionHelper] Failed to complete update of dynamic asset collection (workspace://SpacesStore/5afe053c-f381-4ff8-a663-334fc8a64919): select d.* from cmis:document as d where in_tree(d, 'workspace://SpacesStore/624800d4-57f3-4c84-ab98-1b4840df6737') and d.cmis:objectTypeId='D:ws:article' and d.cmis:name not like 'comment-thankyou.html' order by d.cmis:creationDate desc
org.alfresco.repo.search.impl.lucene.LuceneQueryParserException: 06160091

08:19:00,449 ERROR [org.alfresco.module.org_alfresco_module_wcmquickstart.util.WebassetCollectionHelper] Failed to complete update of dynamic asset collection (workspace://SpacesStore/3a6c9b38-d1ab-44ca-a1a7-36021190d400): select d.* from cmis:document as d where in_tree(d, 'workspace://SpacesStore/19c30e1f-9bdd-4be7-9d2d-d3fbf36a09ac') and d.cmis:objectTypeId='D:ws:article' order by d.cmis:creationDate desc
org.alfresco.repo.search.impl.lucene.LuceneQueryParserException: 06160092

08:19:00,527 ERROR [org.alfresco.module.org_alfresco_module_wcmquickstart.util.WebassetCollectionHelper] Failed to complete update of dynamic asset collection (workspace://SpacesStore/158d397f-773a-43d9-add0-1e34db0d11a5): select d.* from cmis:document as d where in_tree(d, 'workspace://SpacesStore/b1ec0e77-12fc-4fc8-aad0-db87fcd9a5f4') and d.cmis:objectTypeId='D:ws:article' order by d.cmis:creationDate desc
org.alfresco.repo.search.impl.lucene.LuceneQueryParserException: 06160093


- And the catalina.log:

Jul 16, 2013 8:06:42 AM org.apache.catalina.core.AprLifecycleListener init
INFO: Loaded APR based Apache Tomcat Native library 1.1.24 using APR version 1.4.6.
Jul 16, 2013 8:06:42 AM org.apache.catalina.core.AprLifecycleListener init
INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
Jul 16, 2013 8:06:43 AM org.apache.catalina.core.AprLifecycleListener initializeSSL
INFO: OpenSSL successfully initialized (OpenSSL 1.0.1c 10 May 2012)
Jul 16, 2013 8:06:43 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-apr-9999"]
Jul 16, 2013 8:06:43 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-apr-9009"]
Jul 16, 2013 8:06:43 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-9443"]
Jul 16, 2013 8:06:43 AM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 2228 ms
Jul 16, 2013 8:06:43 AM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Jul 16, 2013 8:06:43 AM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.30
Jul 16, 2013 8:06:44 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor C:\Alfresco\tomcat\conf\Catalina\localhost\solr.xml
Jul 16, 2013 8:06:44 AM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
Jul 16, 2013 8:06:52 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\alfresco.war
Jul 16, 2013 8:07:02 AM org.apache.catalina.core.StandardContext addApplicationListener
INFO: The listener "org.apache.myfaces.webapp.StartupServletContextListener" is already configured for this context. The duplicate definition has been ignored.
Jul 16, 2013 8:08:07 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\awe.war
Jul 16, 2013 8:08:14 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\share.war
Jul 16, 2013 8:08:27 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\wcmqs.war
Jul 16, 2013 8:08:33 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory C:\Alfresco\tomcat\webapps\host-manager
Jul 16, 2013 8:08:33 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory C:\Alfresco\tomcat\webapps\manager
Jul 16, 2013 8:08:33 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory C:\Alfresco\tomcat\webapps\ROOT
Jul 16, 2013 8:08:33 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory C:\Alfresco\tomcat\webapps\workdesk
Jul 16, 2013 8:08:36 AM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-apr-9999"]
Jul 16, 2013 8:08:36 AM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-apr-9009"]
Jul 16, 2013 8:08:36 AM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-9443"]
Jul 16, 2013 8:08:36 AM org.apache.catalina.startup.Catalina start
INFO: Server startup in 112363 ms

rjohnson
Star Contributor
Star Contributor
Your server is up at 08:08:36 and at 08:19 it starts spitting errors out about Lucene which is the indexing engine.

Now I would suspect that the problem you have is a corrupted index. The Solr engine starts running after Alfresco has come up so the timings fit and if you were trying to login at 08:19 then that fits to.

I don't know how you did your backup but I do hope that you had Alfresco fully shut down (including PostgreSQL) before you backed up your alf_data or you may have some difficulty.

A starter for 10 would be to rebuild your indexes. As you appear to be using Solr you do need to follow these steps to force an index rebuild. These steps have been collected from a variety of other posts and have always worked for me. It does take a little while to rebuild indexes and as I have no idea how big your installation is, I cannot even guess at the likely timeframe.

<blockquote>

<strong>Rebuilding SOLR</strong>

Occasionally it may be necessary to rebuild the SOLR indexes. This is straightforward enough but you do have to delete the existing indexes very thoroughly. Do as follows:-

1.Stop Alfresco
2.Remove index directory of the archive core at alf_data/solr/archive/SpacesStore
3.
Remove index directory of the workspace core at alf_data/solr/workspace/SpacesStore

4.Remove cached model info directory of the archive core at alf_data/solr/archive-SpacesStore/alfrescoModels
5.Remove cached model info directory of the workspace core at alf_data/solr/workspace-SpacesStore/alfrescoModels
6.Start Alfresco

</blockquote>

You might choose to take a backup copy of the directories you are required to delete just in case.

Good luck

Bob

hienque
Champ in-the-making
Champ in-the-making
Dear Mr Bob Johnson!
I rebuilt SOLR but not success.
My alfresco.log:

08:43:10,815 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
08:43:10,846 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
08:43:23,623 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'sysAdmin' subsystem, ID: [sysAdmin, default]
08:43:23,623 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'sysAdmin' subsystem, ID: [sysAdmin, default]
08:43:23,638 ERROR [org.springframework.web.context.ContextLoader] Context initialization failed
org.springframework.beans.factory.BeanCreationException: Error creating bean with name 'avmRemoteService' defined in class path resource [alfresco/remote-services-context.xml]: Invocation of init method failed; nested exception is java.rmi.server.ExportException: internal error: ObjID already in use
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1420)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.doCreateBean(AbstractAutowireCapableBeanFactory.java:519)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.createBean(AbstractAutowireCapableBeanFactory.java:456)
   at org.springframework.beans.factory.support.AbstractBeanFactory$1.getObject(AbstractBeanFactory.java:291)
   at org.springframework.beans.factory.support.DefaultSingletonBeanRegistry.getSingleton(DefaultSingletonBeanRegistry.java:222)
   at org.springframework.beans.factory.support.AbstractBeanFactory.doGetBean(AbstractBeanFactory.java:288)
   at org.springframework.beans.factory.support.AbstractBeanFactory.getBean(AbstractBeanFactory.java:190)
   at org.springframework.beans.factory.support.DefaultListableBeanFactory.preInstantiateSingletons(DefaultListableBeanFactory.java:580)
   at org.springframework.context.support.AbstractApplicationContext.finishBeanFactoryInitialization(AbstractApplicationContext.java:895)
   at org.springframework.context.support.AbstractApplicationContext.refresh(AbstractApplicationContext.java:425)
   at org.springframework.web.context.ContextLoader.createWebApplicationContext(ContextLoader.java:276)
   at org.springframework.web.context.ContextLoader.initWebApplicationContext(ContextLoader.java:197)
   at org.springframework.web.context.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:47)
   at org.alfresco.web.app.ContextLoaderListener.contextInitialized(ContextLoaderListener.java:63)
   at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4791)
   at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5285)
   at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
   at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:901)
   at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:877)
   at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:618)
   at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:963)
   at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1600)
   at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
   at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
   at java.util.concurrent.FutureTask.run(FutureTask.java:166)
   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
   at java.lang.Thread.run(Thread.java:722)
Caused by: java.rmi.server.ExportException: internal error: ObjID already in use
   at sun.rmi.transport.ObjectTable.putTarget(ObjectTable.java:186)
   at sun.rmi.transport.Transport.exportObject(Transport.java:92)
   at sun.rmi.transport.tcp.TCPTransport.exportObject(TCPTransport.java:247)
   at sun.rmi.transport.tcp.TCPEndpoint.exportObject(TCPEndpoint.java:411)
   at sun.rmi.transport.LiveRef.exportObject(LiveRef.java:147)
   at sun.rmi.server.UnicastServerRef.exportObject(UnicastServerRef.java:207)
   at sun.rmi.registry.RegistryImpl.setup(RegistryImpl.java:122)
   at sun.rmi.registry.RegistryImpl.<init>(RegistryImpl.java:98)
   at java.rmi.registry.LocateRegistry.createRegistry(LocateRegistry.java:239)
   at org.springframework.remoting.rmi.RmiServiceExporter.getRegistry(RmiServiceExporter.java:371)
   at org.springframework.remoting.rmi.RmiServiceExporter.getRegistry(RmiServiceExporter.java:336)
   at org.springframework.remoting.rmi.RmiServiceExporter.prepare(RmiServiceExporter.java:268)
   at org.springframework.remoting.rmi.RmiServiceExporter.afterPropertiesSet(RmiServiceExporter.java:229)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.invokeInitMethods(AbstractAutowireCapableBeanFactory.java:1477)
   at org.springframework.beans.factory.support.AbstractAutowireCapableBeanFactory.initializeBean(AbstractAutowireCapableBeanFactory.java:1417)
   … 27 more


And catalina.log:

ul 17, 2013 8:42:38 AM org.apache.catalina.core.AprLifecycleListener init
INFO: Loaded APR based Apache Tomcat Native library 1.1.24 using APR version 1.4.6.
Jul 17, 2013 8:42:38 AM org.apache.catalina.core.AprLifecycleListener init
INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
Jul 17, 2013 8:42:40 AM org.apache.catalina.core.AprLifecycleListener initializeSSL
INFO: OpenSSL successfully initialized (OpenSSL 1.0.1c 10 May 2012)
Jul 17, 2013 8:42:40 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-apr-9999"]
Jul 17, 2013 8:42:40 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-apr-9009"]
Jul 17, 2013 8:42:40 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-9443"]
Jul 17, 2013 8:42:40 AM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 2248 ms
Jul 17, 2013 8:42:40 AM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Jul 17, 2013 8:42:40 AM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.30
Jul 17, 2013 8:42:40 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor C:\Alfresco\tomcat\conf\Catalina\localhost\solr.xml
Jul 17, 2013 8:42:40 AM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
Jul 17, 2013 8:42:47 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\alfresco.war
Jul 17, 2013 8:42:57 AM org.apache.catalina.core.StandardContext addApplicationListener
INFO: The listener "org.apache.myfaces.webapp.StartupServletContextListener" is already configured for this context. The duplicate definition has been ignored.
Jul 17, 2013 8:43:27 AM org.apache.catalina.core.StandardContext startInternal
SEVERE: Error listenerStart
Jul 17, 2013 8:43:27 AM org.apache.catalina.core.StandardContext startInternal
SEVERE: Context [/alfresco] startup failed due to previous errors
Jul 17, 2013 8:43:27 AM org.apache.catalina.loader.WebappClassLoader checkThreadLocalMapForLeaks
SEVERE: The web application [/alfresco] created a ThreadLocal with key of type [java.lang.ThreadLocal] (value [java.lang.ThreadLocal@404e29e7]) and a value of type [org.alfresco.util.CachingDateFormat] (value [yyyy-MM-dd]) but failed to remove it when the web application was stopped. Threads are going to be renewed over time to try and avoid a probable memory leak.
Jul 17, 2013 8:43:27 AM org.apache.catalina.loader.WebappClassLoader checkThreadLocalMapForLeaks
SEVERE: The web application [/alfresco] created a ThreadLocal with key of type [com.sun.xml.bind.v2.ClassFactory$1] (value [com.sun.xml.bind.v2.ClassFactory$1@4ba11dac]) and a value of type [java.util.WeakHashMap] (value [{class org.alfresco.repo.audit.model._3.Audit=java.lang.ref.WeakReference@4a9b1386, class org.alfresco.repo.audit.model._3.DataGenerator=java.lang.ref.WeakReference@b1ee8ae, class org.alfresco.repo.audit.model._3.RecordValue=java.lang.ref.WeakReference@1a3dfd36, class org.alfresco.repo.audit.model._3.PathMap=java.lang.ref.WeakReference@5bbaf1af, class org.alfresco.repo.audit.model._3.Application=java.lang.ref.WeakReference@4e514735, class javax.xml.bind.annotation.W3CDomHandler=java.lang.ref.WeakReference@3a1a10be, class org.alfresco.repo.audit.model._3.GenerateValue=java.lang.ref.WeakReference@54147bf, class org.alfresco.repo.audit.model._3.DataExtractors=java.lang.ref.WeakReference@cd4f4b, class org.alfresco.repo.audit.model._3.DataExtractor=java.lang.ref.WeakReference@2710c556, class java.util.ArrayList=java.lang.ref.WeakReference@3e0ba523, class org.alfresco.repo.audit.model._3.PathMappings=java.lang.ref.WeakReference@6e86bca7, class org.alfresco.repo.audit.model._3.DataGenerators=java.lang.ref.WeakReference@4fcbb0a1, class org.alfresco.repo.audit.model._3.AuditPath=java.lang.ref.WeakReference@45b942f4}]) but failed to remove it when the web application was stopped. Threads are going to be renewed over time to try and avoid a probable memory leak.
Jul 17, 2013 8:43:27 AM org.apache.catalina.loader.WebappClassLoader checkThreadLocalMapForLeaks
SEVERE: The web application [/alfresco] created a ThreadLocal with key of type [java.lang.ThreadLocal] (value [java.lang.ThreadLocal@5dac4ef]) and a value of type [org.alfresco.repo.dictionary.NamespaceDAOImpl.NamespaceRegistry] (value [org.alfresco.repo.dictionary.NamespaceDAOImpl$NamespaceRegistry@5db729e9]) but failed to remove it when the web application was stopped. Threads are going to be renewed over time to try and avoid a probable memory leak.
Jul 17, 2013 8:43:27 AM org.apache.catalina.loader.WebappClassLoader checkThreadLocalMapForLeaks
SEVERE: The web application [/alfresco] created a ThreadLocal with key of type [java.lang.ThreadLocal] (value [java.lang.ThreadLocal@2420b010]) and a value of type [org.apache.cxf.bus.CXFBusImpl] (value [org.apache.cxf.bus.CXFBusImpl@5e06fcf7]) but failed to remove it when the web application was stopped. Threads are going to be renewed over time to try and avoid a probable memory leak.
Jul 17, 2013 8:43:27 AM org.apache.catalina.loader.WebappClassLoader checkThreadLocalMapForLeaks
SEVERE: The web application [/alfresco] created a ThreadLocal with key of type [com.sun.xml.bind.v2.runtime.Coordinator$1] (value [com.sun.xml.bind.v2.runtime.Coordinator$1@1cc9ec5b]) and a value of type [java.lang.Object[]] (value [[Ljava.lang.Object;@cbc5921]) but failed to remove it when the web application was stopped. Threads are going to be renewed over time to try and avoid a probable memory leak.
Jul 17, 2013 8:43:27 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\awe.war
Jul 17, 2013 8:43:34 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\share.war
Jul 17, 2013 8:43:48 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive C:\Alfresco\tomcat\webapps\wcmqs.war
Jul 17, 2013 8:43:54 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory C:\Alfresco\tomcat\webapps\host-manager
Jul 17, 2013 8:43:54 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory C:\Alfresco\tomcat\webapps\manager
Jul 17, 2013 8:43:54 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory C:\Alfresco\tomcat\webapps\ROOT
Jul 17, 2013 8:43:54 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory C:\Alfresco\tomcat\webapps\workdesk
Jul 17, 2013 8:43:57 AM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-apr-9999"]
Jul 17, 2013 8:43:57 AM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-apr-9009"]
Jul 17, 2013 8:43:57 AM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-9443"]
Jul 17, 2013 8:43:57 AM org.apache.catalina.startup.Catalina start
INFO: Server startup in 76769 ms
Jul 17, 2013 8:43:57 AM org.apache.catalina.loader.WebappClassLoader loadClass
INFO: Illegal access: this web application instance has been stopped already.  Could not load org.bouncycastle.jce.provider.symmetric.AES$ECB.  The eventual following stack trace is caused by an error thrown for debugging purposes as well as to attempt to terminate the thread which caused the illegal access, and has no functional impact.
java.lang.IllegalStateException
   at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1600)
   at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1559)
   at java.security.Provider$Service.getImplClass(Provider.java:1279)
   at java.security.Provider$Service.newInstance(Provider.java:1237)
   at javax.crypto.Cipher.chooseProvider(Cipher.java:845)
   at javax.crypto.Cipher.init(Cipher.java:1348)
   at sun.security.ssl.CipherBox.<init>(CipherBox.java:175)
   at sun.security.ssl.CipherBox.newCipherBox(CipherBox.java:208)
   at sun.security.ssl.CipherSuite$BulkCipher.newCipher(CipherSuite.java:467)
   at sun.security.ssl.CipherSuite$BulkCipher.isAvailable(CipherSuite.java:507)
   at sun.security.ssl.CipherSuite$BulkCipher.isAvailable(CipherSuite.java:485)
   at sun.security.ssl.CipherSuite.isAvailable(CipherSuite.java:190)
   at sun.security.ssl.SSLContextImpl.getApplicableCipherSuiteList(SSLContextImpl.java:342)
   at sun.security.ssl.SSLContextImpl.getDefaultCipherSuiteList(SSLContextImpl.java:293)
   at sun.security.ssl.SSLSocketImpl.init(SSLSocketImpl.java:576)
   at sun.security.ssl.SSLSocketImpl.<init>(SSLSocketImpl.java:494)
   at sun.security.ssl.SSLServerSocketImpl.accept(SSLServerSocketImpl.java:313)
   at org.apache.tomcat.util.net.jsse.JSSESocketFactory.acceptSocket(JSSESocketFactory.java:182)
   at org.apache.tomcat.util.net.JIoEndpoint$Acceptor.run(JIoEndpoint.java:216)
   at java.lang.Thread.run(Thread.java:722)

Jul 17, 2013 8:43:57 AM org.apache.catalina.loader.WebappClassLoader loadClass
INFO: Illegal access: this web application instance has been stopped already.  Could not load org.bouncycastle.jce.provider.symmetric.AES$ECB.  The eventual following stack trace is caused by an error thrown for debugging purposes as well as to attempt to terminate the thread which caused the illegal access, and has no functional impact.
java.lang.IllegalStateException
   at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1600)
   at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1559)
   at java.security.Provider$Service.getImplClass(Provider.java:1279)
   at java.security.Provider$Service.newInstance(Provider.java:1237)
   at javax.crypto.Cipher.chooseProvider(Cipher.java:845)
   at javax.crypto.Cipher.init(Cipher.java:1348)
   at sun.security.ssl.CipherBox.<init>(CipherBox.java:175)
   at sun.security.ssl.CipherBox.newCipherBox(CipherBox.java:208)
   at sun.security.ssl.CipherSuite$BulkCipher.newCipher(CipherSuite.java:467)
   at sun.security.ssl.CipherSuite$BulkCipher.isAvailable(CipherSuite.java:507)
   at sun.security.ssl.CipherSuite$BulkCipher.isAvailable(CipherSuite.java:485)
   at sun.security.ssl.CipherSuite.isAvailable(CipherSuite.java:190)
   at sun.security.ssl.SSLContextImpl.getApplicableCipherSuiteList(SSLContextImpl.java:342)
   at sun.security.ssl.SSLContextImpl.getDefaultCipherSuiteList(SSLContextImpl.java:293)
   at sun.security.ssl.SSLSocketImpl.init(SSLSocketImpl.java:576)
   at sun.security.ssl.SSLSocketImpl.<init>(SSLSocketImpl.java:494)
   at sun.security.ssl.SSLServerSocketImpl.accept(SSLServerSocketImpl.java:313)
   at org.apache.tomcat.util.net.jsse.JSSESocketFactory.acceptSocket(JSSESocketFactory.java:182)
   at org.apache.tomcat.util.net.JIoEndpoint$Acceptor.run(JIoEndpoint.java:216)
   at java.lang.Thread.run(Thread.java:722)

Jul 17, 2013 8:43:57 AM org.apache.catalina.loader.WebappClassLoader loadClass
INFO: Illegal access: this web application instance has been stopped already.  Could not load org.bouncycastle.jce.provider.symmetric.AES$ECB.  The eventual following stack trace is caused by an error thrown for debugging purposes as well as to attempt to terminate the thread which caused the illegal access, and has no functional impact.
java.lang.IllegalStateException
   at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1600)
   at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1559)
   at java.security.Provider$Service.getImplClass(Provider.java:1279)
   at java.security.Provider$Service.newInstance(Provider.java:1237)
   at javax.crypto.Cipher.chooseProvider(Cipher.java:845)
   at javax.crypto.Cipher.init(Cipher.java:1348)
   at sun.security.ssl.CipherBox.<init>(CipherBox.java:175)
   at sun.security.ssl.CipherBox.newCipherBox(CipherBox.java:208)
   at sun.security.ssl.CipherSuite$BulkCipher.newCipher(CipherSuite.java:467)
   at sun.security.ssl.CipherSuite$BulkCipher.isAvailable(CipherSuite.java:507)
   at sun.security.ssl.CipherSuite$BulkCipher.isAvailable(CipherSuite.java:485)
   at sun.security.ssl.CipherSuite.isAvailable(CipherSuite.java:190)
   at sun.security.ssl.SSLContextImpl.getApplicableCipherSuiteList(SSLContextImpl.java:342)
   at sun.security.ssl.SSLContextImpl.getDefaultCipherSuiteList(SSLContextImpl.java:293)
   at sun.security.ssl.SSLSocketImpl.init(SSLSocketImpl.java:576)
   at sun.security.ssl.SSLSocketImpl.<init>(SSLSocketImpl.java:494)
   at sun.security.ssl.SSLServerSocketImpl.accept(SSLServerSocketImpl.java:313)
   at org.apache.tomcat.util.net.jsse.JSSESocketFactory.acceptSocket(JSSESocketFactory.java:182)
   at org.apache.tomcat.util.net.JIoEndpoint$Acceptor.run(JIoEndpoint.java:216)
   at java.lang.Thread.run(Thread.java:722)

rjohnson
Star Contributor
Star Contributor
You now do not have a problem with the indexes. Your problem is now with avmRemoteService and this is beyond my competence except to say there is a fair few entries in these forums on avmRemoteService and ObjId already in use.

see

http://forums.alfresco.com/forum/installation-upgrades-configuration-integration/installation-upgrad...

and several others

Beyond pointing you at that I can't say much more because this is deeper than my understanding.

Sorry

Bob Johnson

vamirr
Champ on-the-rise
Champ on-the-rise
Temporarily turn off your firewall and start the server.  Does it start up?

hienque
Champ in-the-making
Champ in-the-making
@Bob Johnson: thank your enthusiasm
@Vamirr: I turned off firewall and started the server. I can access my alfresco share page but can not login with my account.

rjohnson
Star Contributor
Star Contributor
Whats the error? Are you back to

"The remote server may be unavailable or your authentication details have not been recognized."

Is there anything in either of the logs?

Bob

vishnu511
Champ in-the-making
Champ in-the-making
Hi Bob,
I have the similar situation, my share / alfresco service is not starting or it is terminating quickly thereafter starting the service.
please see below log file of solr.log

23:51:30,111 ERROR [org.quartz.core.JobRunShell] Job Solr.CoreTracker-archive threw an unhandled Exception:
org.alfresco.error.AlfrescoRuntimeException: 07210021 GetModelsDiff return status is 404
   at org.alfresco.solr.client.SOLRAPIClient.getModelsDiff(SOLRAPIClient.java:1036)
   at org.alfresco.solr.tracker.CoreTracker.trackModels(CoreTracker.java:1787)
   at org.alfresco.solr.tracker.CoreTracker.trackRepository(CoreTracker.java:1126)
   at org.alfresco.solr.tracker.CoreTracker.updateIndex(CoreTracker.java:472)
   at org.alfresco.solr.tracker.CoreTrackerJob.execute(CoreTrackerJob.java:45)
   at org.quartz.core.JobRunShell.run(JobRunShell.java:216)
   at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:563)
23:51:30,111 ERROR [org.quartz.core.ErrorLogger] Job (Solr.CoreTracker-archive threw an exception.
org.quartz.SchedulerException: Job threw an unhandled exception. [See nested exception: org.alfresco.error.AlfrescoRuntimeException: 07210021 GetModelsDiff return status is 404]
   at org.quartz.core.JobRunShell.run(JobRunShell.java:227)
   at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:563)
Caused by: org.alfresco.error.AlfrescoRuntimeException: 07210021 GetModelsDiff return status is 404
   at org.alfresco.solr.client.SOLRAPIClient.getModelsDiff(SOLRAPIClient.java:1036)
   at org.alfresco.solr.tracker.CoreTracker.trackModels(CoreTracker.java:1787)
   at org.alfresco.solr.tracker.CoreTracker.trackRepository(CoreTracker.java:1126)
   at org.alfresco.solr.tracker.CoreTracker.updateIndex(CoreTracker.java:472)
   at org.alfresco.solr.tracker.CoreTrackerJob.execute(CoreTrackerJob.java:45)
   at org.quartz.core.JobRunShell.run(JobRunShell.java:216)
   … 1 more
23:51:45,062 ERROR [org.quartz.core.JobRunShell] Job Solr.CoreTracker-alfresco threw an unhandled Exception:
org.alfresco.error.AlfrescoRuntimeException: 07210022 GetModelsDiff return status is 404
   at org.alfresco.solr.client.SOLRAPIClient.getModelsDiff(SOLRAPIClient.java:1036)
   at org.alfresco.solr.tracker.CoreTracker.trackModels(CoreTracker.java:1787)
   at org.alfresco.solr.tracker.CoreTracker.trackRepository(CoreTracker.java:1126)
   at org.alfresco.solr.tracker.CoreTracker.updateIndex(CoreTracker.java:472)
   at org.alfresco.solr.tracker.CoreTrackerJob.execute(CoreTrackerJob.java:45)
   at org.quartz.core.JobRunShell.run(JobRunShell.java:216)