Alfresco 5,0 -> 201605: Sorl4 Model tracking failed

[dora_vazquez]

Hello Community.

I'm having my first steps in Alfresco, but until now i dont have good experiences with the instalation. I hope somebody can help me here. 

I install Alfresco Community v5.1.0, when I started the service my catalina.out show a lot error and im not sure what

This is my alfresco home:

[root@arlxts24 /]# cd /opt/alfresco-community/

[root@arlxts24 alfresco-community]# ls -l

drwxr-xr-x  8 root root     4096 Sep 17 02:00 alf_data

-rw-r--r--  1 root root   353118 May 13 10:45 alfresco.ico

-rwxr-xr-x  1 root root    38901 Sep 15 14:22 alfresco.sh

drwxr-xr-x  2 root root     4096 Sep 15 14:23 amps

drwxr-xr-x  2 root root     4096 Sep 15 14:23 amps_share

-rw-r--r--  1 root root        0 Sep 15 14:45 awe.log

drwxr-xr-x  2 root root     4096 Sep 15 14:23 bin

drwxr-xr-x  8 root root     4096 Sep 15 14:22 common

drwxr-xr-x  9 root root     4096 Sep 15 14:22 libreoffice

drwxr-xr-x  3 root root     4096 Sep 15 14:23 licenses

-rwx------  1 root root  1648817 Apr 16 2014  manager-linux-x64.run

drwxr-xr-x  4 root root     4096 Sep 15 14:22 modules

-rwx------  1 root root      587 Sep 27 15:53 properties.ini

-rw-r--r--  1 root root      243 Sep 15 14:23 README.txt

drwxr-xr-x  2 root root     4096 Sep 15 14:23 scripts

drwxr-xr-x  8 root root     4096 Sep 15 14:23 solr4

drwxr-xr-x 12 root root     4096 Sep 15 14:22 tomcat

-rwx------  1 root root  5735030 Sep 15 14:24 uninstall

-rw-------  1 root root   148184 Sep 15 14:24 uninstall.dat

I would like use the same tomcat for both applications, alfresco and sorl4 server. Is it possible according you mention in this link http://docs.alfresco.com/5.0/tasks/solr4-install-config.html

These are my others files configuration and location:

The solr4.war file is in /tomcat/webapps directory

the solr4.xml file is in /opt/alfresco-community/tomcat/conf/Catalina/localhost --> Is it correct if my alfresco host is arlxts4?. The content is

<Context debug="0" crossContext="true">

  <Environment name="solr/home"        type="java.lang.String" value="/opt/alfresco-community/solr4" override="true"/>

  <Environment name="solr/model/dir"   type="java.lang.String" value="/opt/alfresco-community/alf_data/solr4/model" override="true"/>

  <Environment name="solr/content/dir" type="java.lang.String" value="/opt/alfresco-community/alf_data/solr4/content" override="true"/>

</Context>

As to solrcore.properties file, I have 4 files, and i set in all of them the

data.dir.root=/opt/alfresco-community/alf_data/solr4/index

data.dir.store=archive/SpacesStore

enable.alfresco.tracking=true

Is ok  have 4 files? you mention just 2 in /opt/alfresco-community/solr4/forder in links i referenced before.

/opt/alfresco-community/solr4/archive-SpacesStore/conf/solrcore.properties

/opt/alfresco-community/solr4/workspace-SpacesStore/conf/solrcore.properties

/opt/alfresco-community/alf_data/solr/archive-SpacesStore/conf/solrcore.properties

/opt/alfresco-community/alf_data/solr/workspace-SpacesStore/conf/solrcore.properties

This error wrote in catalina.out

2016-09-29 18:09:32,001  ERROR [solr.tracker.AbstractTracker] [SolrTrackerScheduler_Worker-6] Model tracking failed

java.net.SocketTimeoutException: Read timed out

        at java.net.SocketInputStream.socketRead0(Native Method)

        at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)

        at java.net.SocketInputStream.read(SocketInputStream.java:170)

        at java.net.SocketInputStream.read(SocketInputStream.java:141)

        at sun.security.ssl.InputRecord.readFully(InputRecord.java:465)

        at sun.security.ssl.InputRecord.read(InputRecord.java:503)

        at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:973)

        at sun.security.ssl.SSLSocketImpl.performInitialHandshake(SSLSocketImpl.java:1375)

        at sun.security.ssl.SSLSocketImpl.writeRecord(SSLSocketImpl.java:747)

        at sun.security.ssl.AppOutputStream.write(AppOutputStream.java:123)

        at java.io.BufferedOutputStream.flushBuffer(BufferedOutputStream.java:82)

        at java.io.BufferedOutputStream.flush(BufferedOutputStream.java:140)

        at org.apache.commons.httpclient.HttpConnection.flushRequestOutputStream(HttpConnection.java:828)

        at org.apache.commons.httpclient.MultiThreadedHttpConnectionManager$HttpConnectionAdapter.flushRequestOutputStream(MultiThreadedHttpConnectionManager.java:1565)

        at org.apache.commons.httpclient.HttpMethodBase.writeRequest(HttpMethodBase.java:2077)

        at org.apache.commons.httpclient.HttpMethodBase.execute(HttpMethodBase.java:1096)

        at org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:398)

        at org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:171)

        at org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:397)

        at org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:323)

        at org.alfresco.httpclient.AbstractHttpClient.executeMethod(AbstractHttpClient.java:135)

        at org.alfresco.httpclient.AbstractHttpClient.sendRemoteRequest(AbstractHttpClient.java:111)

        at org.alfresco.httpclient.HttpClientFactory$HttpsClient.sendRequest(HttpClientFactory.java:408)

        at org.alfresco.solr.client.SOLRAPIClient.getModelsDiff(SOLRAPIClient.java:1154)

        at org.alfresco.solr.tracker.ModelTracker.trackModelsImpl(ModelTracker.java:249)

        at org.alfresco.solr.tracker.ModelTracker.trackModels(ModelTracker.java:207)

        at org.alfresco.solr.tracker.ModelTracker.ensureFirstModelSync(ModelTracker.java:229)

        at org.alfresco.solr.tracker.CoreWatcherJob.registerForCore(CoreWatcherJob.java:131)

        at org.alfresco.solr.tracker.CoreWatcherJob.execute(CoreWatcherJob.java:74)

        at org.quartz.core.JobRunShell.run(JobRunShell.java:216)

        at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:563)

2016-09-29 18:15:30,316  ERROR [quartz.core.JobRunShell] [DefaultScheduler_Worker-10] Job DEFAULT.org.springframework.scheduling.quartz.MethodInvokingJobDetailFactoryBean#624e805d threw an unhandled Exception:

org.springframework.scheduling.quartz.JobMethodInvocationFailedException: Invocation of method 'run' on target class [class org.alfresco.module.org_alfresco_module_wcmquickstart.jobs.FeedbackProcessor] failed; nested exception is org.alfresco.repo.search.impl.lucene.LuceneQueryParserException: 08290004

        at org.springframework.scheduling.quartz.MethodInvokingJobDetailFactoryBean$MethodInvokingJob.executeInternal(MethodInvokingJobDetailFactoryBean.java:321)

        at org.springframework.scheduling.quartz.QuartzJobBean.execute(QuartzJobBean.java:114)

        at org.quartz.core.JobRunShell.run(JobRunShell.java:216)

        at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:563)

Caused by: org.alfresco.repo.search.impl.lucene.LuceneQueryParserException: 08290004

        at org.alfresco.repo.search.impl.solr.SolrQueryHTTPClient.executeQuery(SolrQueryHTTPClient.java:625)

        at org.alfresco.repo.search.impl.solr.SolrQueryLanguage.executeQuery(SolrQueryLanguage.java:51)

        at org.alfresco.repo.search.impl.solr.SolrSearchService.query(SolrSearchService.java:348)

        at org.alfresco.repo.search.impl.solr.SolrSearchService.query(SolrSearchService.java:152)

        at org.alfresco.repo.search.SearcherComponent.query(SearcherComponent.java:66)

        at org.alfresco.repo.search.AbstractSearcherComponent.query(AbstractSearcherComponent.java:53)

        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)

        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)

        at java.lang.reflect.Method.invoke(Method.java:498)

        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:204)

        at com.sun.proxy.$Proxy27.query(Unknown Source)

        at org.alfresco.repo.search.impl.SearchServiceSubSystemDelegator.query(SearchServiceSubSystemDelegator.java:91)

        at org.alfresco.module.org_alfresco_module_wcmquickstart.jobs.FeedbackProcessor$1$1.execute(FeedbackProcessor.java:200)

        at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:457)

        at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:326)

        at org.alfresco.module.org_alfresco_module_wcmquickstart.jobs.FeedbackProcessor$1.doWork(FeedbackProcessor.java:190)

        at org.alfresco.repo.security.authentication.AuthenticationUtil.runAs(AuthenticationUtil.java:548)

        at org.alfresco.module.org_alfresco_module_wcmquickstart.jobs.FeedbackProcessor.runInternal(FeedbackProcessor.java:185)

        at org.alfresco.module.org_alfresco_module_wcmquickstart.jobs.FeedbackProcessor.run(FeedbackProcessor.java:148)

        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

        at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)

        at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)

        at java.lang.reflect.Method.invoke(Method.java:498)

        at org.springframework.util.MethodInvoker.invoke(MethodInvoker.java:269)

        at org.springframework.scheduling.quartz.MethodInvokingJobDetailFactoryBean$MethodInvokingJob.executeInternal(MethodInvokingJobDetailFactoryBean.java:312)

        ... 3 more

Caused by: java.net.ConnectException: Connection refused

        at java.net.PlainSocketImpl.socketConnect(Native Method)

        at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)

        at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)

        at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)

        at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)

        at java.net.Socket.connect(Socket.java:589)

        at java.net.Socket.connect(Socket.java:538)

        at java.net.Socket.<init>(Socket.java:434)

        at java.net.Socket.<init>(Socket.java:286)

        at org.apache.commons.httpclient.protocol.DefaultProtocolSocketFactory.createSocket(DefaultProtocolSocketFactory.java:80)

        at org.apache.commons.httpclient.protocol.DefaultProtocolSocketFactory.createSocket(DefaultProtocolSocketFactory.java:122)

        at org.apache.commons.httpclient.HttpConnection.open(HttpConnection.java:707)

        at org.apache.commons.httpclient.MultiThreadedHttpConnectionManager$HttpConnectionAdapter.open(MultiThreadedHttpConnectionManager.java:1361)

        at org.apache.commons.httpclient.HttpMethodDirector.executeWithRetry(HttpMethodDirector.java:387)

        at org.apache.commons.httpclient.HttpMethodDirector.executeMethod(HttpMethodDirector.java:171)

        at org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:397)

        at org.apache.commons.httpclient.HttpClient.executeMethod(HttpClient.java:323)

        at org.alfresco.repo.search.impl.solr.SolrQueryHTTPClient.postQuery(SolrQueryHTTPClient.java:679)

        at org.alfresco.repo.search.impl.solr.SolrQueryHTTPClient.postSolrQuery(SolrQueryHTTPClient.java:644)

        at org.alfresco.repo.search.impl.solr.SolrQueryHTTPClient.executeQuery(SolrQueryHTTPClient.java:605)

[briant]

There are a couple of things at least which are jumping out at me from your provided information:

1) everything is owned by root.  I believe the installer will set the user and group to alfresco.  How was this system installed, manually or using one of the installers? This could be (just a small) part of the problem.

2) Your solr4.xml file looks correct - and yes, it is in the right location (.../tomcat/conf/Catalina/localhost).

The solr4.war file is in /tomcat/webapps directory

the solr4.xml file is in /opt/alfresco-community/tomcat/conf/Catalina/localhost --> Is it correct if my alfresco host is arlxts4?. The content is

<Context debug="0" crossContext="true">

  <Environment name="solr/home"        type="java.lang.String" value="/opt/alfresco-community/solr4" override="true"/>

  <Environment name="solr/model/dir"   type="java.lang.String" value="/opt/alfresco-community/alf_data/solr4/model" override="true"/>

  <Environment name="solr/content/dir" type="java.lang.String" value="/opt/alfresco-community/alf_data/solr4/content" override="true"/>

</Context>

3) You set all the solrcore.properties files to have the same contents but there are 2 different solr4 'spaces', named 'archive' and 'workspace' - you configured only the archive store - you will need to modify two of them to enable the workspace/SpacesStore, ala "data.dir.store=workspace/SpacesStore", specifically in these two files:

/opt/alfresco-community/solr4/workspace-SpacesStore/conf/solrcore.properties

/opt/alfresco-community/alf_data/solr/workspace-SpacesStore/conf/solrcore.properties

As to solrcore.properties file, I have 4 files, and i set in all of them (emphasis mine) the

data.dir.root=/opt/alfresco-community/alf_data/solr4/index

data.dir.store=archive/SpacesStore

enable.alfresco.tracking=true

4) The below entry suggests that solr is not running?  Quite possibly it isn't. Or maybe trying to connect to the workspace instance which you disabled when you configured them all to use the archive store (see 3 above).

Caused by: java.net.ConnectException: Connection refused

Could you provide the catalina.out log file section where solr is started? That will help us a lot to figure out what else is wrong.  The log should have something like this:

INFO: Deploying configuration descriptor /opt/alfresco/tomcat/conf/Catalina/localhost/solr4.xml

....

2016-11-16 17:16:35,141 INFO [repo.admin.ConfigurationChecker] [localhost-startStop-1] The Alfresco root data directory ('dir.root') is: /opt/alfresco/alf_data
2016-11-16 17:16:35,142 INFO [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Search' subsystem, ID: [Search, managed, solr4]
2016-11-16 17:16:35,662 INFO [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Search' subsystem, ID: [Search, managed, solr4] complete

Do you have similar log messages you can share with us (if you could filter on solr and error it will reduce in size significantly)?

5) You also asked if both alfresco and solr can run in the same tomcat - I believe this is the default if you used one of the installers.

Hope that helps.