Solr ne démarre plus

cancel
Showing results for 
Search instead for 
Did you mean: 
geminux
Member II

Solr ne démarre plus

Bonsoir à tous,

j'ai un alfresco 4.2-c qui tourne sans problème depuis longtemps.
Suite à un reboot, solr ne démarre plus. La recherche ne fonctionne pas et les tags sont indisponibles.

Je ne vois pas bien où chercher… voici le log :
—-
avr. 25, 2015 12:45:58 AM org.apache.catalina.core.AprLifecycleListener init
INFO: Loaded APR based Apache Tomcat Native library 1.1.24 using APR version 1.4.6.
avr. 25, 2015 12:45:58 AM org.apache.catalina.core.AprLifecycleListener init
INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
avr. 25, 2015 12:45:58 AM org.apache.catalina.core.AprLifecycleListener initializeSSL
INFO: OpenSSL successfully initialized (OpenSSL 0.9.8o 01 Jun 2010)
avr. 25, 2015 12:45:58 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-apr-8080"]
avr. 25, 2015 12:45:58 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-apr-8009"]
avr. 25, 2015 12:45:58 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
avr. 25, 2015 12:45:58 AM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 752 ms
avr. 25, 2015 12:45:58 AM org.apache.catalina.core.StandardService startInternal
INFO: Démarrage du service Catalina
avr. 25, 2015 12:45:58 AM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.30
avr. 25, 2015 12:45:58 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Déploiement du descripteur de configuration /opt/alfresco-4.2.c/tomcat/conf/Catalina/localhost/solr.xml
2015-04-25 00:46:00,803  ERROR [util.plugin.AbstractPluginLoader] [localhost-startStop-1] org.alfresco.service.cmr.dictionary.DictionaryException: 03250000 Failed to parse model
   at org.alfresco.repo.dictionary.M2Model.createModel(M2Model.java:102)
   at org.alfresco.repo.dictionary.M2Model.createModel(M2Model.java:88)
   at org.alfresco.solr.AlfrescoDataType.init(AlfrescoDataType.java:168)
   at org.apache.solr.schema.FieldType.setArgs(FieldType.java:117)
   at org.apache.solr.schema.IndexSchema$1.init(IndexSchema.java:443)
   at org.apache.solr.schema.IndexSchema$1.init(IndexSchema.java:414)
   at org.apache.solr.util.plugin.AbstractPluginLoader.load(AbstractPluginLoader.java:176)
   at org.apache.solr.schema.IndexSchema.readSchema(IndexSchema.java:456)
   at org.apache.solr.schema.IndexSchema.<init>(IndexSchema.java:95)
   at org.apache.solr.core.CoreContainer.create(CoreContainer.java:426)
   at org.apache.solr.core.CoreContainer.load(CoreContainer.java:278)
   at org.apache.solr.core.CoreContainer$Initializer.initialize(CoreContainer.java:117)
   at org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:83)
   at org.apache.catalina.core.ApplicationFilterConfig.initFilter(ApplicationFilterConfig.java:277)
   at org.apache.catalina.core.ApplicationFilterConfig.getFilter(ApplicationFilterConfig.java:258)
   at org.apache.catalina.core.ApplicationFilterConfig.setFilterDef(ApplicationFilterConfig.java:382)
   at org.apache.catalina.core.ApplicationFilterConfig.<init>(ApplicationFilterConfig.java:103)
   at org.apache.catalina.core.StandardContext.filterStart(StandardContext.java:4650)
   at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5306)
   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.deployDescriptor(HostConfig.java:650)
   at org.apache.catalina.startup.HostConfig$DeployDescriptor.run(HostConfig.java:1582)
   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: org.jibx.runtime.JiBXException: Error parsing document (line 1, col 1)
   at org.jibx.runtime.impl.StAXReaderWrapper.next(StAXReaderWrapper.java:302)
   at org.jibx.runtime.impl.UnmarshallingContext.toStart(UnmarshallingContext.java:446)
   at org.jibx.runtime.impl.UnmarshallingContext.unmarshalElement(UnmarshallingContext.java:2750)
   at org.jibx.runtime.impl.UnmarshallingContext.unmarshalDocument(UnmarshallingContext.java:2900)
   at org.alfresco.repo.dictionary.M2Model.createModel(M2Model.java:97)
   … 30 more
Caused by: com.ctc.wstx.exc.WstxEOFException: Unexpected EOF in prolog
at [row,col {unknown-source}]: [1,0]
   at com.ctc.wstx.sr.StreamScanner.throwUnexpectedEOF(StreamScanner.java:686)
   at com.ctc.wstx.sr.BasicStreamReader.handleEOF(BasicStreamReader.java:2134)
   at com.ctc.wstx.sr.BasicStreamReader.nextFromProlog(BasicStreamReader.java:2040)
   at com.ctc.wstx.sr.BasicStreamReader.next(BasicStreamReader.java:1069)
   at org.jibx.runtime.impl.StAXReaderWrapper.next(StAXReaderWrapper.java:240)
   … 34 more

2015-04-25 00:46:00,877  ERROR [solr.core.CoreContainer] [localhost-startStop-1] java.lang.NullPointerException
   at org.alfresco.solr.AlfrescoSolrDataModel.getSolrLuceneAnalyser(AlfrescoSolrDataModel.java:1561)
   at org.alfresco.solr.AlfrescoDataType.getAnalyzer(AlfrescoDataType.java:258)
   at org.alfresco.solr.AlfrescoDataType.getAnalyzer(AlfrescoDataType.java:75)
   at org.apache.solr.schema.IndexSchema$SolrIndexAnalyzer.analyzerCache(IndexSchema.java:345)
   at org.apache.solr.schema.IndexSchema$SolrIndexAnalyzer.<init>(IndexSchema.java:339)
   at org.apache.solr.schema.IndexSchema.refreshAnalyzers(IndexSchema.java:331)
   at org.apache.solr.schema.IndexSchema.readSchema(IndexSchema.java:660)
   at org.apache.solr.schema.IndexSchema.<init>(IndexSchema.java:95)
   at org.apache.solr.core.CoreContainer.create(CoreContainer.java:426)
   at org.apache.solr.core.CoreContainer.load(CoreContainer.java:278)
   at org.apache.solr.core.CoreContainer$Initializer.initialize(CoreContainer.java:117)
   at org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:83)
   at org.apache.catalina.core.ApplicationFilterConfig.initFilter(ApplicationFilterConfig.java:277)
   at org.apache.catalina.core.ApplicationFilterConfig.getFilter(ApplicationFilterConfig.java:258)
   at org.apache.catalina.core.ApplicationFilterConfig.setFilterDef(ApplicationFilterConfig.java:382)
   at org.apache.catalina.core.ApplicationFilterConfig.<init>(ApplicationFilterConfig.java:103)
   at org.apache.catalina.core.StandardContext.filterStart(StandardContext.java:4650)
   at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5306)
   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.deployDescriptor(HostConfig.java:650)
   at org.apache.catalina.startup.HostConfig$DeployDescriptor.run(HostConfig.java:1582)
   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)

2015-04-25 00:46:01,065  ERROR [util.plugin.AbstractPluginLoader] [localhost-startStop-1] org.alfresco.service.cmr.dictionary.DictionaryException: 03250001 Failed to parse model
   at org.alfresco.repo.dictionary.M2Model.createModel(M2Model.java:102)
   at org.alfresco.repo.dictionary.M2Model.createModel(M2Model.java:88)
   at org.alfresco.solr.AlfrescoDataType.init(AlfrescoDataType.java:168)
   at org.apache.solr.schema.FieldType.setArgs(FieldType.java:117)
   at org.apache.solr.schema.IndexSchema$1.init(IndexSchema.java:443)
   at org.apache.solr.schema.IndexSchema$1.init(IndexSchema.java:414)
   at org.apache.solr.util.plugin.AbstractPluginLoader.load(AbstractPluginLoader.java:176)
   at org.apache.solr.schema.IndexSchema.readSchema(IndexSchema.java:456)
   at org.apache.solr.schema.IndexSchema.<init>(IndexSchema.java:95)
   at org.apache.solr.core.CoreContainer.create(CoreContainer.java:426)
   at org.apache.solr.core.CoreContainer.load(CoreContainer.java:278)
   at org.apache.solr.core.CoreContainer$Initializer.initialize(CoreContainer.java:117)
   at org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:83)
   at org.apache.catalina.core.ApplicationFilterConfig.initFilter(ApplicationFilterConfig.java:277)
   at org.apache.catalina.core.ApplicationFilterConfig.getFilter(ApplicationFilterConfig.java:258)
   at org.apache.catalina.core.ApplicationFilterConfig.setFilterDef(ApplicationFilterConfig.java:382)
   at org.apache.catalina.core.ApplicationFilterConfig.<init>(ApplicationFilterConfig.java:103)
   at org.apache.catalina.core.StandardContext.filterStart(StandardContext.java:4650)
   at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5306)
   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.deployDescriptor(HostConfig.java:650)
   at org.apache.catalina.startup.HostConfig$DeployDescriptor.run(HostConfig.java:1582)
   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: org.jibx.runtime.JiBXException: Error parsing document (line 1, col 1)
   at org.jibx.runtime.impl.StAXReaderWrapper.next(StAXReaderWrapper.java:302)
   at org.jibx.runtime.impl.UnmarshallingContext.toStart(UnmarshallingContext.java:446)
   at org.jibx.runtime.impl.UnmarshallingContext.unmarshalElement(UnmarshallingContext.java:2750)
   at org.jibx.runtime.impl.UnmarshallingContext.unmarshalDocument(UnmarshallingContext.java:2900)
   at org.alfresco.repo.dictionary.M2Model.createModel(M2Model.java:97)
   … 30 more
Caused by: com.ctc.wstx.exc.WstxEOFException: Unexpected EOF in prolog
at [row,col {unknown-source}]: [1,0]
   at com.ctc.wstx.sr.StreamScanner.throwUnexpectedEOF(StreamScanner.java:686)
   at com.ctc.wstx.sr.BasicStreamReader.handleEOF(BasicStreamReader.java:2134)
   at com.ctc.wstx.sr.BasicStreamReader.nextFromProlog(BasicStreamReader.java:2040)
   at com.ctc.wstx.sr.BasicStreamReader.next(BasicStreamReader.java:1069)
   at org.jibx.runtime.impl.StAXReaderWrapper.next(StAXReaderWrapper.java:240)
   … 34 more

2015-04-25 00:46:01,069  ERROR [solr.core.CoreContainer] [localhost-startStop-1] java.lang.NullPointerException
   at org.alfresco.solr.AlfrescoSolrDataModel.getSolrLuceneAnalyser(AlfrescoSolrDataModel.java:1561)
   at org.alfresco.solr.AlfrescoDataType.getAnalyzer(AlfrescoDataType.java:258)
   at org.alfresco.solr.AlfrescoDataType.getAnalyzer(AlfrescoDataType.java:75)
   at org.apache.solr.schema.IndexSchema$SolrIndexAnalyzer.analyzerCache(IndexSchema.java:345)
   at org.apache.solr.schema.IndexSchema$SolrIndexAnalyzer.<init>(IndexSchema.java:339)
   at org.apache.solr.schema.IndexSchema.refreshAnalyzers(IndexSchema.java:331)
   at org.apache.solr.schema.IndexSchema.readSchema(IndexSchema.java:660)
   at org.apache.solr.schema.IndexSchema.<init>(IndexSchema.java:95)
   at org.apache.solr.core.CoreContainer.create(CoreContainer.java:426)
   at org.apache.solr.core.CoreContainer.load(CoreContainer.java:278)
   at org.apache.solr.core.CoreContainer$Initializer.initialize(CoreContainer.java:117)
   at org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:83)
   at org.apache.catalina.core.ApplicationFilterConfig.initFilter(ApplicationFilterConfig.java:277)
   at org.apache.catalina.core.ApplicationFilterConfig.getFilter(ApplicationFilterConfig.java:258)
   at org.apache.catalina.core.ApplicationFilterConfig.setFilterDef(ApplicationFilterConfig.java:382)
   at org.apache.catalina.core.ApplicationFilterConfig.<init>(ApplicationFilterConfig.java:103)
   at org.apache.catalina.core.StandardContext.filterStart(StandardContext.java:4650)
   at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5306)
   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.deployDescriptor(HostConfig.java:650)
   at org.apache.catalina.startup.HostConfig$DeployDescriptor.run(HostConfig.java:1582)
   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)
[…]


Merci pour votre aide
5 Replies
ycoulon
Alfresco Employee

Re: Solr ne démarre plus

Salut,

Les logs que tu as transmis semble indiqué un problème au niveau de l'interprétation du model Alfresco. As-tu effectué une modification dans un fichier de model avant le reboot ?

Alfresco est-il correctement démarré lorsque SolR tente d'y accéder ?

Yann
geminux
Member II

Re: Solr ne démarre plus

Bonjour,

Merci de ta réponse.

Il y a 3 mois j'ai rajouté un modèle de document pour gérer des numéros de facture via des aspects. J'ai vérifié et les fichiers en question n'ont pas été modifiés depuis Janvier alors que le serveur a été rebooté sans problème entre temps… A tout hasard j'ai quand même supprimé tous mes fichiers "custom" et ça ne change rien.

Le problème avec le log c'est qu'on voit bien qu'il n'arrive pas à parser le modèle à cause de :

Caused by: org.jibx.runtime.JiBXException: Error parsing document (line 1, col 1)

et

Caused by: com.ctc.wstx.exc.WstxEOFException: Unexpected EOF in prolog
at [row,col {unknown-source}]: [1,0]

mais il n'y a aucune indication sur le fichier qui pose pb.

Comment trouver ce fichier ? (verbosité des logs ou autre)

merci
ycoulon
Alfresco Employee

Re: Solr ne démarre plus

Bonjour,

Pourrais-tu faire une sauvegarde des données de SolR et le relancer sans données. Pour voir s'il arrive à démarrer correctement dans ce cas la.

Yann
geminux
Member II

Re: Solr ne démarre plus

Bonjour,

Merci beaucoup! ça a l'air de fonctionner. La recherche et les tags refonctionnent.

En me basant sur cette doc http://docs.alfresco.com/4.2/tasks/remove-solr.html, j'ai fait ceci :

root@alfresco:/opt/alfresco-4.2.c# ./alfresco.sh stop
Using CATALINA_BASE:   /opt/alfresco-4.2.c/tomcat
Using CATALINA_HOME:   /opt/alfresco-4.2.c/tomcat
Using CATALINA_TMPDIR: /opt/alfresco-4.2.c/tomcat/temp
Using JRE_HOME:        /opt/alfresco-4.2.c/java
Using CLASSPATH:       /opt/alfresco-4.2.c/tomcat/bin/bootstrap.jar:/opt/alfresco-4.2.c/tomcat/bin/tomcat-juli.jar
Using CATALINA_PID:    /opt/alfresco-4.2.c/tomcat/temp/catalina.pid
/opt/alfresco-4.2.c/tomcat/scripts/ctl.sh : tomcat stopped

root@alfresco:/opt/alfresco-4.2.c# mkdir /opt/solr_bkp/
root@alfresco:/opt/alfresco-4.2.c# cp -pr /opt/alfresco-4.2.c/alf_data/solr/ /opt/solr_bkp/
root@alfresco:/opt/alfresco-4.2.c# rm -r /opt/alfresco-4.2.c/alf_data/solr/archive
root@alfresco:/opt/alfresco-4.2.c# rm /opt/alfresco-4.2.c/alf_data/solr/archive-SpacesStore/alfrescoModels/*.xml
root@alfresco:/opt/alfresco-4.2.c# rm -r /opt/alfresco-4.2.c/alf_data/solr/workspace
root@alfresco:/opt/alfresco-4.2.c# rm /opt/alfresco-4.2.c/alf_data/solr/workspace-SpacesStore/alfrescoModels/*.xml

root@alfresco:/opt/alfresco-4.2.c# ./alfresco.sh start


Tout redémarre sans erreur. (Voir ci dessous le log de startup)
Par contre quand j'accède au Share ça génère un paquet de logs d'erreurs en tout genre (voir plus bas le log post-startup)

<strong> 2 questions:</strong>

Est-ce que j'ai perdu des données entre les données solr que je viens de sauvegarder et les nouvelles qui vont être créés ?
Est-ce que tu peux m'éclairer rapidement sur les nouvelles erreur dans le log (elles n'ont pas l'air d'avoir d'incidence sur l'ajout, la consultation et l'édition des documents, la recherche…)

LOG STARTUP:

avr. 29, 2015 4:31:38 PM org.apache.catalina.core.AprLifecycleListener init
INFO: Loaded APR based Apache Tomcat Native library 1.1.24 using APR version 1.4.6.
avr. 29, 2015 4:31:38 PM org.apache.catalina.core.AprLifecycleListener init
INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
avr. 29, 2015 4:31:38 PM org.apache.catalina.core.AprLifecycleListener initializeSSL
INFO: OpenSSL successfully initialized (OpenSSL 0.9.8o 01 Jun 2010)
avr. 29, 2015 4:31:38 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-apr-8080"]
avr. 29, 2015 4:31:38 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-apr-8009"]
avr. 29, 2015 4:31:38 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
avr. 29, 2015 4:31:38 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 822 ms
avr. 29, 2015 4:31:38 PM org.apache.catalina.core.StandardService startInternal
INFO: Démarrage du service Catalina
avr. 29, 2015 4:31:38 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.30
avr. 29, 2015 4:31:38 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Déploiement du descripteur de configuration /opt/alfresco-4.2.c/tomcat/conf/Catalina/localhost/solr.xml
avr. 29, 2015 4:31:38 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
2015-04-29 16:31:40,883  WARN  [solr.core.SolrCore] [localhost-startStop-1] [archive] Solr index directory '/opt/alfresco-4.2.c/alf_data/solr/archive/SpacesStore/index' doesn't exist. Creating new index…
2015-04-29 16:31:41,125  WARN  [handler.component.SpellCheckComponent] [localhost-startStop-1] No queryConverter defined, using default converter
2015-04-29 16:31:41,332  WARN  [solr.core.SolrCore] [localhost-startStop-1] [alfresco] Solr index directory '/opt/alfresco-4.2.c/alf_data/solr/workspace/SpacesStore/index' doesn't exist. Creating new index…
2015-04-29 16:31:41,351  WARN  [handler.component.SpellCheckComponent] [localhost-startStop-1] No queryConverter defined, using default converter
avr. 29, 2015 4:31:41 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Déploiement de l'archive /opt/alfresco-4.2.c/tomcat/webapps/share.war de l'application web
2015-04-29 16:31:48,754  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-04-29 16:31:48,852  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-04-29 16:31:48,853  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-04-29 16:31:48,856  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-04-29 16:31:50,758  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 374 Web Scripts (+0 failed), 388 URLs
2015-04-29 16:31:50,758  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 8 Package Description Documents (+0 failed)
2015-04-29 16:31:50,758  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-04-29 16:31:51,031  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Spring Surf Container Web Script Container (in 2171.3447ms)
2015-04-29 16:31:51,043  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-04-29 16:31:51,046  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
avr. 29, 2015 4:31:51 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Déploiement de l'archive /opt/alfresco-4.2.c/tomcat/webapps/alfresco.war de l'application web
avr. 29, 2015 4:31:55 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/core is already defined
avr. 29, 2015 4:31:55 PM 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.
avr. 29, 2015 4:31:56 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-04-29 16:32:04,061  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-04-29 16:32:04,082  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
avr. 29, 2015 4:32:10 PM org.activiti.engine.impl.ProcessEngineImpl <init>
INFO: ProcessEngine default created
2015-04-29 16:32:13,435  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor Repository Template Processor for extension ftl
2015-04-29 16:32:13,437  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor Repository Script Processor for extension js
2015-04-29 16:32:19,811  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Connecting to database: jdbc:mysql://localhost/alfresco?useUnicode=yes&characterEncoding=UTF-8, UserName=root@localhost, MySQL Connector Java
2015-04-29 16:32:19,811  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
2015-04-29 16:32:20,119  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] No changes were made to the schema.
avr. 29, 2015 4:32:20 PM org.activiti.engine.impl.jobexecutor.JobExecutor start
INFO: Starting up the JobExecutor[org.activiti.engine.impl.jobexecutor.DefaultJobExecutor].
avr. 29, 2015 4:32:20 PM org.activiti.engine.impl.jobexecutor.AcquireJobsRunnable run
INFO: JobExecutor[org.activiti.engine.impl.jobexecutor.DefaultJobExecutor] starting to acquire jobs
2015-04-29 16:32:20,470  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Search' subsystem, ID: [Search, managed, solr]
2015-04-29 16:32:20,554  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Search' subsystem, ID: [Search, managed, solr] complete
2015-04-29 16:32:20,695  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
2015-04-29 16:32:20,736  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
2015-04-29 16:32:20,736  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-04-29 16:32:20,992  WARN  [alfresco.util.OpenOfficeConnectionTester] [localhost-startStop-1] An initial OpenOffice connection could not be established.
2015-04-29 16:32:20,995  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
2015-04-29 16:32:21,001  INFO  [repo.admin.ConfigurationChecker] [localhost-startStop-1] The Alfresco root data directory ('dir.root') is: /opt/alfresco-4.2.c/alf_data
2015-04-29 16:32:21,035  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] Checking for patches to apply …
2015-04-29 16:32:21,777  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] No patches were required.
2015-04-29 16:32:21,784  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Found 2 module(s).
2015-04-29 16:32:21,814  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.module.vti' version 1.2.
2015-04-29 16:32:21,865  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.integrations.google.docs' version 2.0.1.
2015-04-29 16:32:21,912  WARN  [repo.module.ModuleServiceImpl] [localhost-startStop-1] A previously-installed module 'org_alfresco_module_wcmquickstart' (version 1.0) is not present in your distribution.
2015-04-29 16:32:21,927  WARN  [repo.module.ModuleServiceImpl] [localhost-startStop-1] A previously-installed module 'org_alfresco_module_dod5015' (version 1.0) is not present in your distribution.
2015-04-29 16:32:21,943  WARN  [repo.module.ModuleServiceImpl] [localhost-startStop-1] A previously-installed module 'org.alfresco.module.quickr' (version 1.0) is not present in your distribution.
2015-04-29 16:32:21,950  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'fileServers' subsystem, ID: [fileServers, default]
2015-04-29 16:32:22,338  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-04-29 16:32:22,521  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
2015-04-29 16:32:22,521  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, ldap1]
2015-04-29 16:32:22,567  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, ldap1] complete
2015-04-29 16:32:22,625  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
2015-04-29 16:32:22,625  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'imap' subsystem, ID: [imap, default]
2015-04-29 16:32:22,740  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'imap' subsystem, ID: [imap, default] complete
2015-04-29 16:32:22,740  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, outbound]
2015-04-29 16:32:22,784  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, outbound] complete
2015-04-29 16:32:22,784  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, inbound]
2015-04-29 16:32:22,865  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, inbound] complete
2015-04-29 16:32:22,865  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'googledocs' subsystem, ID: [googledocs, default]
2015-04-29 16:32:22,907  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'googledocs' subsystem, ID: [googledocs, default] complete
2015-04-29 16:32:22,907  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-04-29 16:32:22,915  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
2015-04-29 16:32:22,915  INFO  [repo.usage.UserUsageTrackingComponent] [localhost-startStop-1] Disabled - clear non-missing user usages …
2015-04-29 16:32:22,924  INFO  [repo.usage.UserUsageTrackingComponent] [localhost-startStop-1] Found 0 users to clear
2015-04-29 16:32:22,924  INFO  [repo.usage.UserUsageTrackingComponent] [localhost-startStop-1] … cleared non-missing usages for 0 users
2015-04-29 16:32:22,925  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
2015-04-29 16:32:22,945  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Synchronizing users and groups with user registry 'ldap1'
2015-04-29 16:32:22,976  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Retrieving groups changed since 26 janv. 2015 17:24:09 from user registry 'ldap1'
2015-04-29 16:32:22,996  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] ldap1 Group Analysis: Commencing batch of 0 entries
2015-04-29 16:32:22,999  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] ldap1 Group Analysis: Completed batch of 0 entries
2015-04-29 16:32:23,003  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Retrieving users changed since 10 mars 2015 16:30:51 from user registry 'ldap1'
2015-04-29 16:32:23,008  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] ldap1 User Creation and Association: Commencing batch of 0 entries
2015-04-29 16:32:23,008  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] ldap1 User Creation and Association: Completed batch of 0 entries
2015-04-29 16:32:23,021  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Finished synchronizing users and groups with user registry 'ldap1'
2015-04-29 16:32:23,022  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] 0 user(s) and 0 group(s) processed
2015-04-29 16:32:23,026  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
2015-04-29 16:32:23,087  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco JVM - v1.7.0_07-b10; maximum heap size 910,250MB
2015-04-29 16:32:23,087  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco started (Community). Current version: 4.2.0 (4576) schema 6 022. Originally installed version: 3.4.0 (d 3370) schema 4 113.
2015-04-29 16:32:23,088  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-04-29 16:32:23,193  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
2015-04-29 16:32:23,193  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Replication' subsystem, ID: [Replication, default]
2015-04-29 16:32:23,209  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Replication' subsystem, ID: [Replication, default] complete
2015-04-29 16:32:26,099  INFO  [module.vti.VtiServer] [localhost-startStop-1] Vti server started successfully on port: 7070
2015-04-29 16:32:26,100  INFO  [module.vti.VtiServer] [localhost-startStop-1] Vti server SessionIdManagerWorkerName: jetty1
2015-04-29 16:32:26,100  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'googledocs' subsystem, ID: [googledocs, v2]
2015-04-29 16:32:26,144  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'googledocs' subsystem, ID: [googledocs, v2] complete
2015-04-29 16:32:30,202  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 497 Web Scripts (+0 failed), 782 URLs
2015-04-29 16:32:30,202  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 2 Package Description Documents (+0 failed)
2015-04-29 16:32:30,202  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 1 Schema Description Documents (+0 failed)
2015-04-29 16:32:30,204  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Repository Web Script Container (in 4037.4563ms)
2015-04-29 16:32:30,215  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-04-29 16:32:30,217  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
avr. 29, 2015 4:32:30 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextInitialized
INFO: WSSERVLET12: JAX-WS context listener initializing
avr. 29, 2015 4:32:32 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate <init>
INFO: WSSERVLET14: JAX-WS servlet initializing
avr. 29, 2015 4:32:33 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire /opt/alfresco-4.2.c/tomcat/webapps/host-manager de l'application web
avr. 29, 2015 4:32:33 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire /opt/alfresco-4.2.c/tomcat/webapps/ROOT de l'application web
avr. 29, 2015 4:32:33 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Déploiement du répertoire /opt/alfresco-4.2.c/tomcat/webapps/manager de l'application web
avr. 29, 2015 4:32:33 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-apr-8080"]
avr. 29, 2015 4:32:33 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-apr-8009"]
avr. 29, 2015 4:32:33 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8443"]
avr. 29, 2015 4:32:33 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 54709 ms


LOG POST STARTUP:

2015-04-29 16:32:55,738  ERROR [extensions.webscripts.AbstractRuntime] [http-bio-8443-exec-1] Exception from executeScript - redirecting to status template error: 03290001 Wrapped Exception (with status template): 03290002 Problem converting to Freemarker using node workspace://SpacesStore/records_management_custom_model
org.springframework.extensions.webscripts.WebScriptException: 03290001 Wrapped Exception (with status template): 03290002 Problem converting to Freemarker using node workspace://SpacesStore/records_management_custom_model
   at org.springframework.extensions.webscripts.AbstractWebScript.createStatusException(AbstractWebScript.java:1067)
   at org.springframework.extensions.webscripts.DeclarativeWebScript.execute(DeclarativeWebScript.java:171)
   at org.alfresco.repo.web.scripts.RepositoryContainer$3.execute(RepositoryContainer.java:426)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:433)
   at org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecute(RepositoryContainer.java:495)
   at org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecuteAs(RepositoryContainer.java:533)
   at org.alfresco.repo.web.scripts.RepositoryContainer.executeScript(RepositoryContainer.java:276)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:377)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:209)
   at org.springframework.extensions.webscripts.servlet.WebScriptServlet.service(WebScriptServlet.java:118)
   at javax.servlet.http.HttpServlet.service(HttpServlet.java:722)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:305)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:210)
   at org.alfresco.web.app.servlet.GlobalLocalizationFilter.doFilter(GlobalLocalizationFilter.java:61)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:243)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:210)
   at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:222)
   at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:123)
   at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:581)
   at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:168)
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:99)
   at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:929)
   at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:118)
   at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:407)
   at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1002)
   at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:585)
   at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:312)
   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: org.alfresco.error.AlfrescoRuntimeException: 03290002 Problem converting to Freemarker using node workspace://SpacesStore/records_management_custom_model
   at org.alfresco.repo.web.scripts.solr.NodesMetaDataGet$1.handleNodeMetaData(NodesMetaDataGet.java:198)
   at org.alfresco.repo.solr.SOLRTrackingComponentImpl$NodeMetaDataQueryRowHandler.processResult(SOLRTrackingComponentImpl.java:963)
   at org.alfresco.repo.solr.SOLRTrackingComponentImpl.getNodesMetadata(SOLRTrackingComponentImpl.java:819)
   at sun.reflect.GeneratedMethodAccessor460.invoke(Unknown Source)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   at java.lang.reflect.Method.invoke(Method.java:601)
   at org.alfresco.repo.management.subsystems.SubsystemProxyFactory$1.invoke(SubsystemProxyFactory.java:72)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
   at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202)
   at $Proxy148.getNodesMetadata(Unknown Source)
   at org.alfresco.repo.web.scripts.solr.NodesMetaDataGet.executeImpl(NodesMetaDataGet.java:181)
   at org.springframework.extensions.webscripts.DeclarativeWebScript.executeImpl(DeclarativeWebScript.java:235)
   at org.springframework.extensions.webscripts.DeclarativeWebScript.execute(DeclarativeWebScript.java:64)
   … 28 more
Caused by: org.alfresco.service.namespace.NamespaceException: A namespace prefix is not registered for uri http://www.alfresco.org/model/rmcustom/1.0
   at org.alfresco.service.namespace.QName.toPrefixString(QName.java:414)
   at org.alfresco.repo.web.scripts.solr.SOLRSerializer$SOLRTypeConverter$2.convert(SOLRSerializer.java:231)
   at org.alfresco.repo.web.scripts.solr.SOLRSerializer$SOLRTypeConverter$2.convert(SOLRSerializer.java:228)
   at org.alfresco.service.cmr.repository.datatype.TypeConverter.convert(TypeConverter.java:112)
   at org.alfresco.repo.web.scripts.solr.SOLRSerializer.serializeToJSONString(SOLRSerializer.java:108)
   at org.alfresco.repo.web.scripts.solr.SOLRSerializer.serialize(SOLRSerializer.java:170)
   at org.alfresco.repo.web.scripts.solr.NodesMetaDataGet$FreemarkerNodeMetaData.<init>(NodesMetaDataGet.java:297)
   at org.alfresco.repo.web.scripts.solr.NodesMetaDataGet$1.handleNodeMetaData(NodesMetaDataGet.java:193)
   … 40 more
2015-04-29 16:32:56,244  WARN  [solr.tracker.CoreTracker] [SolrTrackingPool-alfresco3] Node index failed and skipped for 501 in Tx 10
org.alfresco.error.AlfrescoRuntimeException: 03290000 GetNodeMetaData return status is 500
   at org.alfresco.solr.client.SOLRAPIClient.getNodesMetaData(SOLRAPIClient.java:747)
   at org.alfresco.solr.tracker.CoreTracker.indexNode(CoreTracker.java:2248)
   at org.alfresco.solr.tracker.MultiThreadedCoreTracker$NodeIndexWorkerRunnable.doWork(MultiThreadedCoreTracker.java:758)
   at org.alfresco.solr.tracker.MultiThreadedCoreTracker$AbstractWorkerRunnable.run(MultiThreadedCoreTracker.java:699)
   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)
2015-04-29 16:33:00,572  WARN  [alfresco.util.OpenOfficeConnectionTester] [DefaultScheduler_Worker-4] Error trying to query Open Office version information. OpenOffice.org's ConfigurationRegistry not implemented in this version of OOo. This should not affect the operation of OOo.
2015-04-29 16:33:00,573  INFO  [alfresco.util.OpenOfficeConnectionTester] [DefaultScheduler_Worker-4] The OpenOffice connection was re-established.
2015-04-29 16:33:28,833  INFO  [web.scripts.ImapServerStatus] [http-apr-8080-exec-4] Successfully retrieved IMAP server status from Alfresco: disabled
avr. 29, 2015 4:33:30 PM org.activiti.engine.impl.bpmn.deployer.BpmnDeployer deploy
INFO: Processing resource 4801dda9-3abe-44f1-b9f8-0da2bca23091bpmn20.xml
avr. 29, 2015 4:33:30 PM org.activiti.engine.impl.bpmn.parser.BpmnParse parseDefinitionsAttributes
INFO: XMLSchema currently not supported as typeLanguage
avr. 29, 2015 4:33:30 PM org.activiti.engine.impl.bpmn.parser.BpmnParse parseDefinitionsAttributes
INFO: XPath currently not supported as expressionLanguage
avr. 29, 2015 4:33:32 PM org.activiti.engine.impl.bpmn.deployer.BpmnDeployer deploy
INFO: Processing resource c9e8e636-0f0a-4166-abfe-9724d28a3e1ebpmn20.xml
avr. 29, 2015 4:33:32 PM org.activiti.engine.impl.bpmn.parser.BpmnParse parseDefinitionsAttributes
INFO: XMLSchema currently not supported as typeLanguage
avr. 29, 2015 4:33:32 PM org.activiti.engine.impl.bpmn.parser.BpmnParse parseDefinitionsAttributes
INFO: XPath currently not supported as expressionLanguage
2015-04-29 16:33:52,255  WARN  [solr.tracker.CoreTracker] [SolrTrackingPool-archive1] Node index failed and skipped for 80453 in Tx 361563
org.json.JSONException: Unterminated string at character 1167
   at org.json.JSONTokener.syntaxError(JSONTokener.java:413)
   at org.json.JSONTokener.nextString(JSONTokener.java:244)
   at org.json.JSONTokener.nextValue(JSONTokener.java:344)
   at org.json.JSONObject.<init>(JSONObject.java:206)
   at org.json.JSONTokener.nextValue(JSONTokener.java:347)
   at org.json.JSONObject.<init>(JSONObject.java:206)
   at org.json.JSONTokener.nextValue(JSONTokener.java:347)
   at org.json.JSONArray.<init>(JSONArray.java:125)
   at org.json.JSONTokener.nextValue(JSONTokener.java:351)
   at org.json.JSONObject.<init>(JSONObject.java:206)
   at org.alfresco.solr.client.SOLRAPIClient.getNodesMetaData(SOLRAPIClient.java:751)
   at org.alfresco.solr.tracker.CoreTracker.indexNode(CoreTracker.java:2248)
   at org.alfresco.solr.tracker.MultiThreadedCoreTracker$NodeIndexWorkerRunnable.doWork(MultiThreadedCoreTracker.java:758)
   at org.alfresco.solr.tracker.MultiThreadedCoreTracker$AbstractWorkerRunnable.run(MultiThreadedCoreTracker.java:699)
   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)
2015-04-29 16:34:10,614  WARN  [repo.dictionary.DictionaryDAO] [http-bio-8443-exec-7] Type not found: {http://www.alfresco.org/model/website/1.0}websiteContainer
2015-04-29 16:34:10,644  ERROR [extensions.webscripts.AbstractRuntime] [http-bio-8443-exec-7] Exception from executeScript - redirecting to status template error: 03290002 Wrapped Exception (with status template): 03290060 Nodes with no type are ignored by SOLR
org.springframework.extensions.webscripts.WebScriptException: 03290002 Wrapped Exception (with status template): 03290060 Nodes with no type are ignored by SOLR
   at org.springframework.extensions.webscripts.AbstractWebScript.createStatusException(AbstractWebScript.java:1067)
   at org.springframework.extensions.webscripts.DeclarativeWebScript.execute(DeclarativeWebScript.java:171)
   at org.alfresco.repo.web.scripts.RepositoryContainer$3.execute(RepositoryContainer.java:426)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:433)
   at org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecute(RepositoryContainer.java:495)
   at org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecuteAs(RepositoryContainer.java:533)
   at org.alfresco.repo.web.scripts.RepositoryContainer.executeScript(RepositoryContainer.java:276)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:377)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:209)
   at org.springframework.extensions.webscripts.servlet.WebScriptServlet.service(WebScriptServlet.java:118)
   at javax.servlet.http.HttpServlet.service(HttpServlet.java:722)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:305)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:210)
   at org.alfresco.web.app.servlet.GlobalLocalizationFilter.doFilter(GlobalLocalizationFilter.java:61)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:243)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:210)
   at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:222)
   at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:123)
   at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:581)
   at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:168)
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:99)
   at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:929)
   at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:118)
   at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:407)
   at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1002)
   at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:585)
   at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:312)
   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: org.alfresco.error.AlfrescoRuntimeException: 03290060 Nodes with no type are ignored by SOLR
   at org.alfresco.repo.solr.SOLRTrackingComponentImpl.getNodesMetadata(SOLRTrackingComponentImpl.java:625)
   at sun.reflect.GeneratedMethodAccessor460.invoke(Unknown Source)
   at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   at java.lang.reflect.Method.invoke(Method.java:601)
   at org.alfresco.repo.management.subsystems.SubsystemProxyFactory$1.invoke(SubsystemProxyFactory.java:72)
   at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
   at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:202)
   at $Proxy148.getNodesMetadata(Unknown Source)
   at org.alfresco.repo.web.scripts.solr.NodesMetaDataGet.executeImpl(NodesMetaDataGet.java:181)
   at org.springframework.extensions.webscripts.DeclarativeWebScript.executeImpl(DeclarativeWebScript.java:235)
   at org.springframework.extensions.webscripts.DeclarativeWebScript.execute(DeclarativeWebScript.java:64)
   … 28 more
2015-04-29 16:34:10,672  WARN  [solr.tracker.CoreTracker] [SolrTrackingPool-alfresco1] Node index failed and skipped for 32016 in Tx 18912
org.alfresco.error.AlfrescoRuntimeException: 03290001 GetNodeMetaData return status is 500
   at org.alfresco.solr.client.SOLRAPIClient.getNodesMetaData(SOLRAPIClient.java:747)
   at org.alfresco.solr.tracker.CoreTracker.indexNode(CoreTracker.java:2248)
   at org.alfresco.solr.tracker.MultiThreadedCoreTracker$NodeIndexWorkerRunnable.doWork(MultiThreadedCoreTracker.java:758)
   at org.alfresco.solr.tracker.MultiThreadedCoreTracker$AbstractWorkerRunnable.run(MultiThreadedCoreTracker.java:699)
   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)


ycoulon
Alfresco Employee

Re: Solr ne démarre plus

Salut,

Les données SolR ne sont que les index. La sauvegarde était juste au cas ou. SolR va ré-indexer l'ensemble de tes contenus.

Pour les erreurs Alfresco, il semble que ce soit lié à tes models : "A namespace prefix is not registered for uri http://www.alfresco.org/model/rmcustom/1.0"

Pour la partie SolR tu peux jeter un oeil à cet article : http://posts.orderofthebee.org/post/117688490521/how-to-debug-solr-exceptions-warnings-for-alfresco
Il pourra peut être te fournir quelque info sur les derniers messages qui semble provenir de SolR.

Yann