AnsweredAssumed Answered

[solr] Tracking communication timed out

Question asked by alexw on Oct 3, 2013
Latest reply on Jun 7, 2014 by bhuvan
Hi,

I was testing the search functionality in Share when it started hanging, resulting a few minutes later in a 503 error. I checked the logs and found the following error (repeated multiple times):

2013-10-03 00:22:05,440  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-2] Tracking communication timed out.



Since I didn't know what was causing this timeout, I tried increasing the solr (
solr.solrConnectTimeout=10000
) and re-indexing the repository by following the walkthrough in the documentation, with no luck.

If I restart the Alfresco service, Share is available again, but searching will trigger the 503 error and leave Share hanging once again.


Here are the logs I had after restarting the service:


Oct 03, 2013 12:20:21 AM org.apache.catalina.core.AprLifecycleListener init
INFO: Loaded APR based Apache Tomcat Native library 1.1.27 using APR version 1.4.6.
Oct 03, 2013 12:20:21 AM org.apache.catalina.core.AprLifecycleListener init
INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
Oct 03, 2013 12:20:21 AM org.apache.catalina.core.AprLifecycleListener initializeSSL
INFO: OpenSSL successfully initialized (OpenSSL 0.9.8o 01 Jun 2010)
Oct 03, 2013 12:20:21 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-apr-8080"]
Oct 03, 2013 12:20:21 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-apr-8009"]
Oct 03, 2013 12:20:21 AM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
Oct 03, 2013 12:20:21 AM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 907 ms
Oct 03, 2013 12:20:21 AM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Oct 03, 2013 12:20:21 AM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.42
Oct 03, 2013 12:20:21 AM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor /opt/alfresco-4.2.d/tomcat/conf/Catalina/localhost/solr.xml
Oct 03, 2013 12:20:22 AM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
Oct 03, 2013 12:20:51 AM org.apache.catalina.util.SessionIdGenerator createSecureRandom
INFO: Creation of SecureRandom instance for session ID generation using [SHA1PRNG] took [28,126] milliseconds.
2013-10-03 00:20:55,417  WARN  [solr.core.SolrCore] [localhost-startStop-1] [archive] Solr index directory '/opt/alfresco-4.2.d/alf_data/solr/archive/SpacesStore/index' doesn't exist. Creating new index…
2013-10-03 00:20:55,656  WARN  [handler.component.SpellCheckComponent] [localhost-startStop-1] No queryConverter defined, using default converter
2013-10-03 00:20:56,865  WARN  [solr.core.SolrCore] [localhost-startStop-1] [alfresco] Solr index directory '/opt/alfresco-4.2.d/alf_data/solr/workspace/SpacesStore/index' doesn't exist. Creating new index…
2013-10-03 00:20:56,882  WARN  [handler.component.SpellCheckComponent] [localhost-startStop-1] No queryConverter defined, using default converter
Oct 03, 2013 12:20:56 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /opt/alfresco-4.2.d/tomcat/webapps/share.war
2013-10-03 00:21:05,196  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2013-10-03 00:21:05,262  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2013-10-03 00:21:05,262  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2013-10-03 00:21:05,267  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2013-10-03 00:21:07,736  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 354 Web Scripts (+0 failed), 368 URLs
2013-10-03 00:21:07,736  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 8 Package Description Documents (+0 failed)
2013-10-03 00:21:07,736  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2013-10-03 00:21:07,970  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Spring Surf Container Web Script Container (in 2694.1675ms)
2013-10-03 00:21:07,976  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2013-10-03 00:21:07,980  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
Oct 03, 2013 12:21:08 AM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /opt/alfresco-4.2.d/tomcat/webapps/alfresco.war
Oct 03, 2013 12:21:14 AM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/core is already defined
Oct 03, 2013 12:21:15 AM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2013-10-03 00:21:19,585  INFO  [alfresco.repo.admin] [localhost-startStop-1] Using database URL 'jdbc:postgresql://localhost:5432/alfresco' with user 'alfresco'.
2013-10-03 00:21:19,684  INFO  [alfresco.repo.admin] [localhost-startStop-1] Connected to database PostgreSQL version 9.2.4
2013-10-03 00:21:25,767  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
2013-10-03 00:21:25,784  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
2013-10-03 00:21:34,145  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor Repository Template Processor for extension ftl
2013-10-03 00:21:34,148  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor Repository Script Processor for extension js
2013-10-03 00:21:40,552  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Connecting to database: jdbc:postgresql://localhost:5432/alfresco, UserName=alfresco, PostgreSQL Native Driver
2013-10-03 00:21:40,552  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema managed by database dialect org.hibernate.dialect.PostgreSQLDialect.
2013-10-03 00:21:42,864  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] No changes were made to the schema.
2013-10-03 00:21:43,360  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2013-10-03 00:21:43,481  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
2013-10-03 00:21:43,482  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, kerberos1]
2013-10-03 00:21:43,597  INFO  [management.subsystems.ChildApplicationContextFactory] [asynchronouslyRefreshedCacheThreadPool1] Starting 'Search' subsystem, ID: [Search, managed, solr]
2013-10-03 00:21:43,762  INFO  [management.subsystems.ChildApplicationContextFactory] [asynchronouslyRefreshedCacheThreadPool1] Startup of 'Search' subsystem, ID: [Search, managed, solr] complete
2013-10-03 00:21:44,089  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, kerberos1] complete
2013-10-03 00:21:44,089  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, ldap-ad1]
2013-10-03 00:21:44,153  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, ldap-ad1] complete
2013-10-03 00:21:44,516  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
2013-10-03 00:21:44,600  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
2013-10-03 00:21:44,600  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
2013-10-03 00:21:44,949  WARN  [alfresco.util.OpenOfficeConnectionTester] [localhost-startStop-1] 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.
2013-10-03 00:21:44,954  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
2013-10-03 00:21:44,956  INFO  [repo.admin.ConfigurationChecker] [localhost-startStop-1] The Alfresco root data directory ('dir.root') is: /opt/alfresco-4.2.d/alf_data
2013-10-03 00:21:44,978  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] Checking for patches to apply …
2013-10-03 00:21:45,698  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] No patches were required.
2013-10-03 00:21:45,708  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Found 2 module(s).
2013-10-03 00:21:45,740  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.module.vti' version 1.3.
2013-10-03 00:21:45,772  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.integrations.google.docs' version 2.0.4.
2013-10-03 00:21:45,789  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'fileServers' subsystem, ID: [fileServers, default]
2013-10-03 00:21:51,213  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS, Unable to get local domain/workgroup name, using default of WORKGROUP. This may be due to firewall settings or incorrect <broadcast> setting)
2013-10-03 00:21:51,241  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
2013-10-03 00:21:51,241  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'imap' subsystem, ID: [imap, default]
2013-10-03 00:21:51,321  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'imap' subsystem, ID: [imap, default] complete
2013-10-03 00:21:51,321  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, outbound]
2013-10-03 00:21:51,389  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, outbound] complete
2013-10-03 00:21:51,389  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, inbound]
2013-10-03 00:21:51,656  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, inbound] complete
2013-10-03 00:21:51,656  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
2013-10-03 00:21:51,674  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
2013-10-03 00:21:51,704  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
2013-10-03 00:21:51,844  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Synchronizing users and groups with user registry 'ldap-ad1'
2013-10-03 00:21:51,881  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Retrieving groups changed since Sep 20, 2013 8:43:42 AM from user registry 'ldap-ad1'
2013-10-03 00:21:51,902  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Synchronization,Category=directory,id1=ldap-ad1,id2=1 Group Analysis: Commencing batch of 0 entries
2013-10-03 00:21:51,903  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Synchronization,Category=directory,id1=ldap-ad1,id2=1 Group Analysis: Completed batch of 0 entries
2013-10-03 00:21:51,910  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Retrieving users changed since Oct 2, 2013 3:07:19 PM from user registry 'ldap-ad1'
2013-10-03 00:21:51,921  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Synchronization,Category=directory,id1=ldap-ad1,id2=6 User Creation and Association: Commencing batch of 0 entries
2013-10-03 00:21:51,921  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Synchronization,Category=directory,id1=ldap-ad1,id2=6 User Creation and Association: Completed batch of 0 entries
2013-10-03 00:21:51,941  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] Finished synchronizing users and groups with user registry 'ldap-ad1'
2013-10-03 00:21:51,941  INFO  [security.sync.ChainingUserRegistrySynchronizer] [localhost-startStop-1] 0 user(s) and 0 group(s) processed
2013-10-03 00:21:51,987  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
2013-10-03 00:21:52,020  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco JVM - v1.7.0_25-b15; maximum heap size 3640.938MB
2013-10-03 00:21:52,020  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco started (Community). Current version: 4.2.0 (r54676-b4795) schema 6,032. Originally installed version: 4.2.0 (r54676-b4795) schema 6,032.
2013-10-03 00:21:52,054  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2013-10-03 00:21:52,162  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
2013-10-03 00:21:52,162  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Replication' subsystem, ID: [Replication, default]
2013-10-03 00:21:52,170  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Replication' subsystem, ID: [Replication, default] complete
2013-10-03 00:21:54,644  INFO  [module.vti.VtiServer] [localhost-startStop-1] Vti server started successfully on port: 7070
2013-10-03 00:21:54,644  INFO  [module.vti.VtiServer] [localhost-startStop-1] Vti server SessionIdManagerWorkerName: jetty1
2013-10-03 00:21:54,645  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'googledocs' subsystem, ID: [googledocs, v2]
2013-10-03 00:21:54,734  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'googledocs' subsystem, ID: [googledocs, v2] complete
2013-10-03 00:22:00,610  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 501 Web Scripts (+0 failed), 783 URLs
2013-10-03 00:22:00,610  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 2 Package Description Documents (+0 failed)
2013-10-03 00:22:00,610  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 1 Schema Description Documents (+0 failed)
2013-10-03 00:22:00,624  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Repository Web Script Container (in 5867.2246ms)
2013-10-03 00:22:00,638  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2013-10-03 00:22:00,639  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2013-10-03 00:22:00,754  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 11 Web Scripts (+0 failed), 82 URLs
2013-10-03 00:22:00,754  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Package Description Documents (+0 failed)
2013-10-03 00:22:00,754  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2013-10-03 00:22:00,766  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Public Api Web Script Container (in 118.00142ms)
Oct 03, 2013 12:22:00 AM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextInitialized
INFO: WSSERVLET12: JAX-WS context listener initializing
Oct 03, 2013 12:22:04 AM com.sun.xml.ws.transport.http.servlet.WSServletDelegate <init>
INFO: WSSERVLET14: JAX-WS servlet initializing
Oct 03, 2013 12:22:04 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /opt/alfresco-4.2.d/tomcat/webapps/manager
Oct 03, 2013 12:22:04 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /opt/alfresco-4.2.d/tomcat/webapps/host-manager
Oct 03, 2013 12:22:05 AM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /opt/alfresco-4.2.d/tomcat/webapps/ROOT
Oct 03, 2013 12:22:05 AM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-apr-8080"]
Oct 03, 2013 12:22:05 AM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-apr-8009"]
Oct 03, 2013 12:22:05 AM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8443"]
Oct 03, 2013 12:22:05 AM org.apache.catalina.startup.Catalina start
INFO: Server startup in 103148 ms
2013-10-03 00:22:05,440  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-2] Tracking communication timed out.
2013-10-03 00:22:05,443  WARN  [solr.tracker.CoreTracker] [SolrTrackerScheduler_Worker-3] Tracking communication timed out.
2013-10-03 00:22:05,528  ERROR [extensions.webscripts.AbstractRuntime] [http-bio-8443-exec-1] Exception from executeScript - redirecting to status template error: 09030003 Invalid JSON
org.springframework.extensions.webscripts.WebScriptException: 09030003 Invalid JSON
   at org.alfresco.repo.web.scripts.solr.AlfrescoModelsDiff.executeImpl(AlfrescoModelsDiff.java:55)
   at org.springframework.extensions.webscripts.DeclarativeWebScript.executeImpl(DeclarativeWebScript.java:235)
   at org.springframework.extensions.webscripts.DeclarativeWebScript.execute(DeclarativeWebScript.java:64)
   at org.alfresco.repo.web.scripts.RepositoryContainer$3.execute(RepositoryContainer.java:439)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:447)
   at org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecute(RepositoryContainer.java:508)
   at org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecuteAs(RepositoryContainer.java:546)
   at org.alfresco.repo.web.scripts.RepositoryContainer.executeScript(RepositoryContainer.java:285)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:376)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:209)
   at org.springframework.extensions.webscripts.servlet.WebScriptServlet.service(WebScriptServlet.java:132)
   at javax.servlet.http.HttpServlet.service(HttpServlet.java:728)
   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:611)
   at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:171)
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:99)
   at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:953)
   at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:118)
   at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
   at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1023)
   at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:589)
   at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:310)
   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
   at java.lang.Thread.run(Thread.java:724)
Caused by: org.json.JSONException: A JSONObject text must begin with '{' at character 1
   at org.json.JSONTokener.syntaxError(JSONTokener.java:413)
   at org.json.JSONObject.<init>(JSONObject.java:180)
   at org.json.JSONObject.<init>(JSONObject.java:420)
   at org.alfresco.repo.web.scripts.solr.AlfrescoModelsDiff.buildModel(AlfrescoModelsDiff.java:68)
   at org.alfresco.repo.web.scripts.solr.AlfrescoModelsDiff.executeImpl(AlfrescoModelsDiff.java:42)
   … 30 more
2013-10-03 00:22:05,528  ERROR [extensions.webscripts.AbstractRuntime] [http-bio-8443-exec-2] Exception from executeScript - redirecting to status template error: 09030002 Invalid JSON
org.springframework.extensions.webscripts.WebScriptException: 09030002 Invalid JSON
   at org.alfresco.repo.web.scripts.solr.AlfrescoModelsDiff.executeImpl(AlfrescoModelsDiff.java:55)
   at org.springframework.extensions.webscripts.DeclarativeWebScript.executeImpl(DeclarativeWebScript.java:235)
   at org.springframework.extensions.webscripts.DeclarativeWebScript.execute(DeclarativeWebScript.java:64)
   at org.alfresco.repo.web.scripts.RepositoryContainer$3.execute(RepositoryContainer.java:439)
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:447)
   at org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecute(RepositoryContainer.java:508)
   at org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecuteAs(RepositoryContainer.java:546)
   at org.alfresco.repo.web.scripts.RepositoryContainer.executeScript(RepositoryContainer.java:285)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:376)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:209)
   at org.springframework.extensions.webscripts.servlet.WebScriptServlet.service(WebScriptServlet.java:132)
   at javax.servlet.http.HttpServlet.service(HttpServlet.java:728)
   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:611)
   at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:171)
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:99)
   at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:953)
   at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:118)
   at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
   at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1023)
   at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:589)
   at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:310)
   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
   at java.lang.Thread.run(Thread.java:724)
Caused by: org.json.JSONException: A JSONObject text must begin with '{' at character 1
   at org.json.JSONTokener.syntaxError(JSONTokener.java:413)
   at org.json.JSONObject.<init>(JSONObject.java:180)
   at org.json.JSONObject.<init>(JSONObject.java:420)
   at org.alfresco.repo.web.scripts.solr.AlfrescoModelsDiff.buildModel(AlfrescoModelsDiff.java:68)
   at org.alfresco.repo.web.scripts.solr.AlfrescoModelsDiff.executeImpl(AlfrescoModelsDiff.java:42)
   … 30 more
2013-10-03 00:22:27,275  INFO  [management.subsystems.ChildApplicationContextFactory] [http-bio-8443-exec-9] Starting 'Transformers' subsystem, ID: [Transformers, default]
2013-10-03 00:22:27,372  ERROR [content.transform.TransformerConfigDynamicTransformers] [http-bio-8443-exec-9] Cannot create dynamic transformer transformer.complex.JodConverter.Image as sub transformers could not be found or created ("JodConverter.2Pdf|pdf|complex.PDF.Image").
2013-10-03 00:22:27,373  ERROR [content.transform.TransformerConfigDynamicTransformers] [http-bio-8443-exec-9] Cannot create dynamic transformer transformer.complex.JodConverter.Pdf2swf as sub transformers could not be found or created ("JodConverter.2Pdf|pdf|Pdf2swf").
2013-10-03 00:22:27,373  ERROR [content.transform.TransformerConfigDynamicTransformers] [http-bio-8443-exec-9] Cannot create dynamic transformer transformer.JodConverter.Html2Pdf as sub transformers could not be found or created ("JodConverter|odt|JodConverter").
2013-10-03 00:22:27,373  ERROR [content.transform.TransformerConfigDynamicTransformers] [http-bio-8443-exec-9] Cannot create dynamic transformer transformer.JodConverter.2Pdf as sub transformers could not be found or created ("JodConverter|JodConverter.Html2Pdf").
2013-10-03 00:22:27,373  ERROR [content.transform.TransformerConfigDynamicTransformers] [http-bio-8443-exec-9] Cannot create dynamic transformer transformer.complex.JodConverter.PdfBox as sub transformers could not be found or created ("JodConverter.2Pdf|pdf|PdfBox").
2013-10-03 00:22:27,457  INFO  [management.subsystems.ChildApplicationContextFactory] [http-bio-8443-exec-9] Startup of 'Transformers' subsystem, ID: [Transformers, default] complete
unable to determine cannonical charset name for iso-utf-8 - using ISO-8859-1
2013-10-03 00:36:49,173  ERROR [extensions.webscripts.AbstractRuntime] [http-apr-8080-exec-1] Exception from executeScript - redirecting to status template error: 09030004 Authentication failed for Web Script org/alfresco/repository/admin/restrictions.get
org.springframework.extensions.webscripts.WebScriptException: 09030004 Authentication failed for Web Script org/alfresco/repository/admin/restrictions.get
   at org.alfresco.repo.web.scripts.RepositoryContainer.executeScript(RepositoryContainer.java:362)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:376)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:209)
   at org.springframework.extensions.webscripts.servlet.WebScriptServlet.service(WebScriptServlet.java:132)
   at javax.servlet.http.HttpServlet.service(HttpServlet.java:728)
   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:502)
   at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:171)
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:99)
   at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:953)
   at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:118)
   at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
   at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1023)
   at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:589)
   at org.apache.tomcat.util.net.AprEndpoint$SocketWithOptionsProcessor.run(AprEndpoint.java:1810)
   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
   at java.lang.Thread.run(Thread.java:724)
2013-10-03 00:36:49,224  ERROR [extensions.webscripts.AbstractRuntime] [http-apr-8080-exec-2] Exception from executeScript - redirecting to status template error: 09030005 Authentication failed for Web Script org/alfresco/repository/admin/restrictions.get
org.springframework.extensions.webscripts.WebScriptException: 09030005 Authentication failed for Web Script org/alfresco/repository/admin/restrictions.get
   at org.alfresco.repo.web.scripts.RepositoryContainer.executeScript(RepositoryContainer.java:362)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:376)
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:209)
   at org.springframework.extensions.webscripts.servlet.WebScriptServlet.service(WebScriptServlet.java:132)
   at javax.servlet.http.HttpServlet.service(HttpServlet.java:728)
   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:502)
   at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:171)
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:99)
   at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:953)
   at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:118)
   at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
   at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1023)
   at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:589)
   at org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.run(AprEndpoint.java:1852)
   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
   at java.lang.Thread.run(Thread.java:724)
2013-10-03 00:36:49,478  INFO  [web.site.EditionInterceptor] [ajp-apr-8009-exec-5] Successfully retrieved license information from Alfresco.
2013-10-03 00:36:56,921  INFO  [web.scripts.ImapServerStatus] [ajp-apr-8009-exec-7] Successfully retrieved IMAP server status from Alfresco: disabled




And here is my alfresco-global.properties:



###############################
## Common Alfresco Properties #
###############################

dir.root=/opt/alfresco-4.2.d/alf_data

alfresco.context=alfresco
alfresco.host=127.0.0.1
alfresco.port=8080
alfresco.protocol=http

share.context=share
share.host=127.0.0.1
share.port=8080
share.protocol=http

### database connection properties ###
db.driver=org.postgresql.Driver
db.username=alfresco
db.password=#47AWZ369bq
db.name=alfresco
db.url=jdbc:postgresql://localhost:5432/${db.name}

### FTP Server Configuration ###
ftp.enabled=true
ftp.port=21

### RMI service ports ###
alfresco.rmi.services.port=50500
avm.rmi.service.port=0
avmsync.rmi.service.port=0
attribute.rmi.service.port=0
authentication.rmi.service.port=0
repo.rmi.service.port=0
action.rmi.service.port=0
deployment.rmi.service.port=0

### External executable locations ###
ooo.exe=/opt/alfresco-4.2.d/libreoffice/program/soffice.bin
ooo.enabled=true
ooo.port=8100
img.gslib=/usr/local/share/ghostscript/lib
img.root=/opt/alfresco-4.2.d/common
img.dyn=${img.root}/lib
img.exe=${img.root}/bin/convert
swf.exe=/usr/local/bin/pdf2swf
swf.languagedir=/opt/alfresco-4.2.d/common/japanese

jodconverter.enabled=false
jodconverter.officeHome=/opt/alfresco-4.2.d/libreoffice
jodconverter.portNumbers=8100

### Initial admin password ###
alfresco_user_store.adminpassword=dfc4797039507ad49e2b1be76261be4b

### E-mail site invitation setting ###
notification.email.siteinvite=false

### License location ###
dir.license.external=/opt/alfresco-4.2.d

### Solr indexing ###
index.subsystem.name=solr
dir.keystore=${dir.root}/keystore
solr.solrConnectTimeout=10000
solr.port.ssl=8443

### BPM Engine ###
system.workflow.engine.jbpm.enabled=false

### Authentication chain ###
authentication.chain=alfrescoNtlm1:alfrescoNtlm,kerberos1:kerberos,ldap-ad1:ldap-ad

### Desktop actions setting ###
cifs.pseudoFiles.enabled=false



Any input on why Solr is having a hard time with my searches will be greatly appreciated.

Outcomes