Environment: Nexus Repository Manager OSS 2.15.1-02 on Linux VM
We have observed the following pair of errors listed at bottom, titled : Task execution failure.
Following response on prior (old) support (#36990)
To fix this, shut down Nexus, and rename “sonatype-work/nexus/indexer” to
“sonatype-work/nexus/indexer.old”.
Then restart, and go to “administration/scheduled tasks” and create and run a repair indexes task against all repositories.
Upon reindexing completion, observed the following (sanitized) logs:
WARN [qtp1658920240-34] anonymous org.sonatype.nexus.content.internal.ContentServlet - java.io.IOException: Template processing error: org.apache.velocity.exception.VelocityException: IO Error rendering template '/org/sonatype/nexus/content/internal/repositoryContentHtml.vm', caused by: org.apache.velocity.exception.VelocityException: IO Error rendering template '/org/sonatype/nexus/content/internal/repositoryContentHtml.vm', caused by: org.eclipse.jetty.io.EofException, caused by: java.io.IOException: Broken pipe [client=,ua=Wget/1.14 (linux-gnu),req=GET http://mavenrepository.corp/nexus/content/repositories/deployables-thirdparty/corp/custom/path/to//groupID/]
ERROR [qtp1658920240-34] org.sonatype.nexus.web.internal.ErrorPageFilter - Internal error: Template processing error: org.apache.velocity.exception.VelocityException: IO Error rendering template '/org/sonatype/nexus/content/internal/repositoryContentHtml.vm'
WARN [qtp1658920240-302] anonymous org.sonatype.nexus.content.internal.ContentServlet - org.eclipse.jetty.io.EofException, caused by: java.io.IOException: Broken pipe [client=,ua=m2e/3.16.0.v20200828-0759/1.16.2.20200910-0936/14.0.2,req=GET http://mavenrepository.corp/nexus/content/groups/authorized/.index/nexus-maven-repository-index.gz]
2022-08-06 17:49:45,097+0000 ERROR [qtp1658920240-302] org.sonatype.nexus.web.internal.ErrorPageFilter - Internal error: null
WARN [qtp1658920240-34] anonymous org.sonatype.nexus.content.internal.ContentServlet - java.io.IOException: Template processing error: org.apache.velocity.exception.VelocityException: IO Error rendering template '/org/sonatype/nexus/content/internal/repositoryContentHtml.vm', caused by: org.apache.velocity.exception.VelocityException: IO Error rendering template '/org/sonatype/nexus/content/internal/repositoryContentHtml.vm', caused by: org.eclipse.jetty.io.EofException, caused by: java.io.IOException: Broken pipe [client=,ua=Wget/1.14 (linux-gnu),req=GET http://mavenrepository.corp/nexus/content/repositories/deployables-thirdparty/corp/custom/path/to//groupID/]
ERROR [qtp1658920240-34] org.sonatype.nexus.web.internal.ErrorPageFilter - Internal error: Template processing error: org.apache.velocity.exception.VelocityException: IO Error rendering template '/org/sonatype/nexus/content/internal/repositoryContentHtml.vm'
WARN [qtp1658920240-304] anonymous org.sonatype.nexus.content.internal.ContentServlet - java.io.IOException: Template processing error: org.apache.velocity.exception.VelocityException: IO Error rendering template '/org/sonatype/nexus/content/internal/repositoryContentHtml.vm', caused by: org.apache.velocity.exception.VelocityException: IO Error rendering template '/org/sonatype/nexus/content/internal/repositoryContentHtml.vm', caused by: org.eclipse.jetty.io.EofException, caused by: java.io.IOException: Broken pipe [client=,ua=Wget/1.14 (linux-gnu),req=GET http://mavenrepository.corp/nexus/content/repositories/deployables-thirdparty/corp/custom/path/to//groupID/]
ERROR [qtp1658920240-304] org.sonatype.nexus.web.internal.ErrorPageFilter - Internal error: Template processing error: org.apache.velocity.exception.VelocityException: IO Error rendering template '/org/sonatype/nexus/content/internal/repositoryContentHtml.vm'
INFO [SessionValidationThread-1] org.apache.shiro.session.mgt.AbstractValidatingSessionManager - Validating all active sessions...
INFO [SessionValidationThread-1] org.apache.shiro.session.mgt.AbstractValidatingSessionManager - Finished session validation. No sessions were stopped.
I can confirm /deployables-thirdparty/corp/custom/path/to/groupID/ (single slash to/groupID) exists and has 3422 elements / versions inside. Not clear why the logs show “//`” or if that’s related to the error.
Please advise if there is in fact an error, and if it is user resolvable..
Update: Further examination of the logs shows the error ( repositoryContentHtml.vm ) predates the reported Task Execution failures (Download Central Index and Download Central Index).
The repositoryContentHtml.vm** occurs up to 15x / day for 62 of the 90 days (some days skipped) of prior logs; the reindexing only drew our attention to its existence.
Originating Task Execution Failures:
Task ID: 13
Task Name: Download Central Index
Stack trace:
java.io.IOException: Cannot fetch remote index for repository "Central" [id=central], error occurred.
at org.sonatype.nexus.index.DefaultIndexerManager.updateRemoteIndex(DefaultIndexerManager.java:1344)
at org.sonatype.nexus.index.DefaultIndexerManager.access$1100(DefaultIndexerManager.java:188)
at org.sonatype.nexus.index.DefaultIndexerManager$9.run(DefaultIndexerManager.java:1158)
at org.sonatype.nexus.index.DefaultIndexerManager.sharedSingle(DefaultIndexerManager.java:2320)
at org.sonatype.nexus.index.DefaultIndexerManager.downloadRepositoryIndex(DefaultIndexerManager.java:1162)
at org.sonatype.nexus.index.DefaultIndexerManager.downloadRepositoryIndex(DefaultIndexerManager.java:1130)
at org.sonatype.nexus.index.DefaultIndexerManager.downloadRepositoryIndex(DefaultIndexerManager.java:1107)
at org.sonatype.nexus.index.tasks.DownloadIndexesTask.doRun(DownloadIndexesTask.java:54)
at org.sonatype.nexus.scheduling.AbstractNexusTask.call(AbstractNexusTask.java:163)
at org.sonatype.scheduling.DefaultScheduledTask.call(DefaultScheduledTask.java:418)
at org.sonatype.nexus.threads.MDCAwareCallable.call(MDCAwareCallable.java:44)
at org.apache.shiro.subject.support.SubjectCallable.doCall(SubjectCallable.java:90)
at org.apache.shiro.subject.support.SubjectCallable.call(SubjectCallable.java:83)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:832)
Caused by: java.lang.IndexOutOfBoundsException: Index: 7650, Size: 35
and
Task ID: 97
Task Name: PublishIndexAuthorized
Stack trace:
java.lang.IndexOutOfBoundsException: Index: 7650, Size: 35
at java.util.ArrayList.rangeCheck(ArrayList.java:659)
at java.util.ArrayList.get(ArrayList.java:435)
at org.apache.lucene.index.FieldInfos.fieldInfo(FieldInfos.java:255)
at org.apache.lucene.index.FieldsReader.doc(FieldsReader.java:238)
at org.apache.lucene.index.SegmentReader.document(SegmentReader.java:492)
at org.apache.lucene.index.DirectoryReader.document(DirectoryReader.java:568)
at org.apache.lucene.index.IndexReader.document(IndexReader.java:1138)
at org.apache.maven.index.incremental.DefaultIncrementalHandler.getIndexChunk(DefaultIncrementalHandler.java:157)
at org.apache.maven.index.incremental.DefaultIncrementalHandler.getIncrementalUpdates(DefaultIncrementalHandler.java:67)
at org.apache.maven.index.packer.DefaultIndexPacker.packIndex(DefaultIndexPacker.java:119)
at org.sonatype.nexus.index.DefaultIndexerManager.publishRepositoryIndex(DefaultIndexerManager.java:1483)
at org.sonatype.nexus.index.DefaultIndexerManager.access$1400(DefaultIndexerManager.java:188)
at org.sonatype.nexus.index.DefaultIndexerManager$14.run(DefaultIndexerManager.java:1447)
at org.sonatype.nexus.index.DefaultIndexerManager.shared(DefaultIndexerManager.java:2295)
at org.sonatype.nexus.index.DefaultIndexerManager.publishRepositoryIndex(DefaultIndexerManager.java:1441)
at org.sonatype.nexus.index.DefaultIndexerManager.publishRepositoryIndex(DefaultIndexerManager.java:1425)
at org.sonatype.nexus.index.DefaultIndexerManager$13.perform(DefaultIndexerManager.java:1420)
at org.sonatype.nexus.index.DefaultIndexerManager$GroupOperation.perform(DefaultIndexerManager.java:384)
at org.sonatype.nexus.index.DefaultIndexerManager.publishRepositoryIndex(DefaultIndexerManager.java:1422)
at org.sonatype.nexus.index.DefaultIndexerManager.publishRepositoryIndex(DefaultIndexerManager.java:1403)
at org.sonatype.nexus.index.tasks.PublishIndexesTask.doRun(PublishIndexesTask.java:56)
at org.sonatype.nexus.scheduling.AbstractNexusTask.call(AbstractNexusTask.java:163)
at org.sonatype.scheduling.DefaultScheduledTask.call(DefaultScheduledTask.java:418)
at org.sonatype.nexus.threads.MDCAwareCallable.call(MDCAwareCallable.java:44)
at org.apache.shiro.subject.support.SubjectCallable.doCall(SubjectCallable.java:90)
at org.apache.shiro.subject.support.SubjectCallable.call(SubjectCallable.java:83)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:832)