Uploaded image for project: 'Nuxeo Platform'
  1. Nuxeo Platform
  2. NXP-16410

NPE in Elasticsearch indexing worker

    XMLWordPrintable

    Details

      Description

      Visible in http://qa.nuxeo.org/jenkins/job/FT-nuxeo-master-cmis-cap-tomcat-multiosdb/Slave=MULTIDB_WINDOWS,dbprofile=default,jdk=openjdk-7-jdk/

      See http://qa.nuxeo.org/jenkins/job/FT-nuxeo-master-cmis-cap-tomcat-multiosdb/Slave=MULTIDB_WINDOWS,dbprofile=default,jdk=openjdk-7-jdk/254/artifact/nuxeo-distribution/nuxeo-distribution-cap-cmis-tests/target/tomcat/log/server.log

      2015-01-16 06:17:01,592 WARN  [Nuxeo-Work-elasticSearchIndexing-2] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-e4850286-3333-4a1a-947e-befcf1d47b9f","type":"DELETE","docId":"587f7d01-e03f-47dd-b85f-4d67243e48b6","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:02,206 WARN  [Nuxeo-Work-elasticSearchIndexing-1] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-b1c4efe9-29c1-4500-b69e-cd1e5ec71a37","type":"DELETE","docId":"d8cfa359-0d32-499a-b168-8a101144d6f5","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:02,264 INFO  [http-bio-0.0.0.0-8080-exec-12] [org.apache.jasper.compiler.TldLocationsCache] At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
      2015-01-16 06:17:13,593 WARN  [Nuxeo-Work-elasticSearchIndexing-3] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-3659e8e3-7202-4341-938f-5f5779c33e4d","type":"DELETE","docId":"25b8b59a-f790-4fd2-8a4c-cbe5ddb6f8b7","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:16,012 WARN  [Nuxeo-Work-elasticSearchIndexing-3] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-0f9c8fc7-a7c1-49df-a98d-d58e8b8866f5","type":"DELETE","docId":"1b297c07-5950-4199-86f8-940e9fba0a75","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:16,768 WARN  [Nuxeo-Work-elasticSearchIndexing-2] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-d8e1f712-0c7c-48f2-bf2d-c84abed52652","type":"DELETE","docId":"385c50f9-fe0d-4401-bf03-cea5f60312b2","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:17,876 WARN  [Nuxeo-Work-elasticSearchIndexing-1] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-9442c3ae-f7e4-45c0-9466-072c6526b840","type":"DELETE","docId":"3d7c4545-f513-490d-93a3-7b2154659a08","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:18,786 WARN  [Nuxeo-Work-elasticSearchIndexing-4] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-14574200-8074-401a-8f0e-32818c0179f2","type":"DELETE","docId":"1e25e208-d5f9-4d35-9b46-56dcd6e9b0f8","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:19,658 WARN  [Nuxeo-Work-elasticSearchIndexing-1] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-c3711b0e-199c-4633-9d76-a43b396e3b52","type":"DELETE","docId":"e89b5d02-57e2-479d-92c0-263e31e07d39","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:21,534 WARN  [Nuxeo-Work-elasticSearchIndexing-4] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-53f5171b-f51c-448e-b200-4dac073b457c","type":"DELETE","docId":"b7b1715a-0a4e-472a-a9ae-55766fbaf12d","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:24,325 WARN  [Nuxeo-Work-elasticSearchIndexing-4] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-5a583842-2ae3-4c97-881c-a1c802207ed2","type":"DELETE","docId":"cd5493e4-de6c-4947-ac8b-9af7a590483e","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:25,470 WARN  [Nuxeo-Work-elasticSearchIndexing-1] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-8fc6b57e-1f70-47b2-8559-7075f568faf3","type":"DELETE","docId":"201bac50-2e75-4aea-a85a-d252982a0053","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:29,745 WARN  [Nuxeo-Work-default-1] [org.nuxeo.ecm.core.event.impl.ReconnectedEventBundleImpl] Listener 'updateThumbListener' cannot refetch missing document: 4c445174-3e0a-4624-b8da-3bd78fad16df (/default-domain/cmislib DocumentTest 142/250px-Cmis_logo.png)
      2015-01-16 06:17:33,075 WARN  [Nuxeo-Work-elasticSearchIndexing-3] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-d4fc8421-a66b-4fb3-a6a8-8c94e7e89b79","type":"DELETE","docId":"e58d54c0-20aa-4fae-84be-635b1b7b8b8c","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:33,915 WARN  [Nuxeo-Work-elasticSearchIndexing-3] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-6434e5cb-e448-41e6-b09d-f67bb71a404c","type":"DELETE","docId":"37d9f611-d17c-45c2-a487-bbced58caaac","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:35,143 WARN  [Nuxeo-Work-elasticSearchIndexing-4] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-59da5ef1-d10d-4d96-869e-9beb120953ed","type":"DELETE","docId":"2067e4d2-8f3e-4203-9dcc-9b2112cf2cc1","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:35,946 WARN  [http-bio-0.0.0.0-8080-exec-2] [org.nuxeo.ecm.core.event.impl.PostCommitEventExecutor] Events postcommit execution exceeded timeout of 300ms, leaving thread running
      2015-01-16 06:17:39,628 WARN  [Nuxeo-Work-elasticSearchIndexing-4] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-615826e4-f798-4583-8788-dbb3e4a0e542","type":"DELETE","docId":"258cc643-b517-49d4-a86c-764c16094cc0","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:44,297 WARN  [Nuxeo-Work-elasticSearchIndexing-2] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-a5892da3-6e83-4b0a-92b2-5eb11a352ec9","type":"DELETE","docId":"492cc146-c6da-42b9-9ffd-69df61d2b3c9","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:44,869 WARN  [Nuxeo-Work-elasticSearchIndexing-2] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-e7ddac45-0c65-42a5-803b-ee56b4640d89","type":"DELETE","docId":"e8757730-d76d-4621-babd-9d4d673e176e","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:45,230 WARN  [Nuxeo-Work-elasticSearchIndexing-2] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-b0fb868f-2882-49af-9835-08e19781becb","type":"DELETE","docId":"f4374470-2f55-4612-9292-c2d5ee798d94","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:46,616 WARN  [Nuxeo-Work-elasticSearchIndexing-1] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-722a7f6a-deb4-488f-8921-96f742016e9c","type":"DELETE","docId":"719e196f-5786-41f3-8362-5b6666525c58","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:47,099 WARN  [Nuxeo-Work-elasticSearchIndexing-2] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-37e0dd20-6765-4e8f-942f-8ea9a927fac7","type":"DELETE","docId":"f42d25ac-2a11-4c77-ae0d-c815242f7f5d","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:47,379 WARN  [Nuxeo-Work-elasticSearchIndexing-3] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-f201d2ff-e173-4d75-910a-408a367a727d","type":"DELETE","docId":"fba2266d-001a-435f-9e80-9abb2fc2853e","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:49,001 WARN  [Nuxeo-Work-elasticSearchIndexing-2] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-064601da-b9fb-4992-bdfb-dab4686f4040","type":"DELETE","docId":"1f9690c2-26a7-4b44-912d-e4af1081ca3b","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:49,277 WARN  [Nuxeo-Work-elasticSearchIndexing-4] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-737185e1-7126-4967-b29c-36b4a7acb8a7","type":"DELETE","docId":"d6b49032-50b1-4def-a810-9272b7ae2ec4","path":null,"repo":"default","recurse":true,"sync":false}
      2015-01-16 06:17:51,438 ERROR [Nuxeo-Work-elasticSearchIndexing-1] [org.nuxeo.ecm.core.work.AbstractWork] Exception during work: IndexingWorker(ec76f9dd-ae3b-4210-a89a-88ca84eb5b6c, , Progress(?%, ?/0), null)
      java.lang.NullPointerException
      	at org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl.getPathOfDocFromEs(ElasticSearchIndexingImpl.java:299)
      	at org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl.processDeleteCommandRecursive(ElasticSearchIndexingImpl.java:259)
      	at org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl.processDeleteCommand(ElasticSearchIndexingImpl.java:239)
      	at org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl.indexNonRecursive(ElasticSearchIndexingImpl.java:199)
      	at org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl.indexNonRecursive(ElasticSearchIndexingImpl.java:115)
      	at org.nuxeo.elasticsearch.ElasticSearchComponent.indexNonRecursive(ElasticSearchComponent.java:306)
      	at org.nuxeo.elasticsearch.work.IndexingWorker.doIndexingWork(IndexingWorker.java:63)
      	at org.nuxeo.elasticsearch.work.AbstractIndexingWorker.doWork(AbstractIndexingWorker.java:62)
      	at org.nuxeo.elasticsearch.work.BaseIndexingWorker.work(BaseIndexingWorker.java:58)
      	at org.nuxeo.ecm.core.work.AbstractWork.runWorkWithTransaction(AbstractWork.java:343)
      	at org.nuxeo.ecm.core.work.AbstractWork.runWorkWithTransactionAndCheckExceptions(AbstractWork.java:304)
      	at org.nuxeo.ecm.core.work.AbstractWork.run(AbstractWork.java:273)
      	at org.nuxeo.ecm.core.work.WorkHolder.run(WorkHolder.java:52)
      	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:722)
      2015-01-16 06:17:51,443 ERROR [Nuxeo-Work-elasticSearchIndexing-1] [org.nuxeo.ecm.core.work.WorkManagerImpl] Uncaught error on thread Nuxeo-Work-elasticSearchIndexing-1
      java.lang.NullPointerException
      	at org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl.getPathOfDocFromEs(ElasticSearchIndexingImpl.java:299)
      	at org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl.processDeleteCommandRecursive(ElasticSearchIndexingImpl.java:259)
      	at org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl.processDeleteCommand(ElasticSearchIndexingImpl.java:239)
      	at org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl.indexNonRecursive(ElasticSearchIndexingImpl.java:199)
      	at org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl.indexNonRecursive(ElasticSearchIndexingImpl.java:115)
      	at org.nuxeo.elasticsearch.ElasticSearchComponent.indexNonRecursive(ElasticSearchComponent.java:306)
      	at org.nuxeo.elasticsearch.work.IndexingWorker.doIndexingWork(IndexingWorker.java:63)
      	at org.nuxeo.elasticsearch.work.AbstractIndexingWorker.doWork(AbstractIndexingWorker.java:62)
      	at org.nuxeo.elasticsearch.work.BaseIndexingWorker.work(BaseIndexingWorker.java:58)
      	at org.nuxeo.ecm.core.work.AbstractWork.runWorkWithTransaction(AbstractWork.java:343)
      	at org.nuxeo.ecm.core.work.AbstractWork.runWorkWithTransactionAndCheckExceptions(AbstractWork.java:304)
      	at org.nuxeo.ecm.core.work.AbstractWork.run(AbstractWork.java:273)
      	at org.nuxeo.ecm.core.work.WorkHolder.run(WorkHolder.java:52)
      	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:722)
      2015-01-16 06:17:51,446 WARN  [Nuxeo-Work-elasticSearchIndexing-2] [org.nuxeo.elasticsearch.core.ElasticSearchIndexingImpl] Trying to delete a non existing doc: {"id":"IndexingCommand-f0f3af41-e388-4ce3-a271-c13406d27818","type":"DELETE","docId":"d447519c-54b6-4586-9e30-c93d2cd0a876","path":"/default-domain/cmislib RepositoryTest 1","repo":"default","recurse":true,"sync":false}
      

      Also happened on January 15th, see http://qa.nuxeo.org/jenkins/job/FT-nuxeo-master-cmis-cap-tomcat-multiosdb/Slave=MULTIDB_WINDOWS,dbprofile=default,jdk=openjdk-7-jdk/236/artifact/nuxeo-distribution/nuxeo-distribution-cap-cmis-tests/target/tomcat/log/server.log

      But on January 8th, we get the WARN with no following ERROR, see http://qa.nuxeo.org/jenkins/job/FT-nuxeo-master-cmis-cap-tomcat-multiosdb/Slave=MULTIDB_WINDOWS,dbprofile=default,jdk=openjdk-7-jdk/226/artifact/nuxeo-distribution/nuxeo-distribution-cap-cmis-tests/target/tomcat/log/server.log

        Attachments

          Activity

            People

            • Votes:
              0 Vote for this issue
              Watchers:
              2 Start watching this issue

              Dates

              • Created:
                Updated:
                Resolved: