Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.x/815/
1 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler Error Message: file handle leaks: [FileChannel(/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/index-NIOFSDirectory-010/replication.properties), FileChannel(/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/index-NIOFSDirectory-004/replication.properties)] Stack Trace: java.lang.RuntimeException: file handle leaks: [FileChannel(/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/index-NIOFSDirectory-010/replication.properties), FileChannel(/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/index-NIOFSDirectory-004/replication.properties)] at __randomizedtesting.SeedInfo.seed([303C02B061F337C5]:0) at org.apache.lucene.mockfile.LeakFS.onClose(LeakFS.java:64) at org.apache.lucene.mockfile.FilterFileSystem.close(FilterFileSystem.java:78) at org.apache.lucene.mockfile.FilterFileSystem.close(FilterFileSystem.java:79) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:212) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Caused by: java.lang.Exception at org.apache.lucene.mockfile.LeakFS.onOpen(LeakFS.java:47) at org.apache.lucene.mockfile.HandleTrackingFS.callOpenHook(HandleTrackingFS.java:84) at org.apache.lucene.mockfile.HandleTrackingFS.newFileChannel(HandleTrackingFS.java:191) at org.apache.lucene.mockfile.FilterFileSystemProvider.newFileChannel(FilterFileSystemProvider.java:204) at org.apache.lucene.mockfile.HandleTrackingFS.newFileChannel(HandleTrackingFS.java:163) at java.nio.channels.FileChannel.open(FileChannel.java:287) at java.nio.channels.FileChannel.open(FileChannel.java:334) at org.apache.lucene.store.NIOFSDirectory.openInput(NIOFSDirectory.java:82) at org.apache.lucene.util.LuceneTestCase.slowFileExists(LuceneTestCase.java:2487) at org.apache.lucene.store.MockDirectoryWrapper.openInput(MockDirectoryWrapper.java:639) at org.apache.solr.handler.ReplicationHandler.loadReplicationProperties(ReplicationHandler.java:977) at org.apache.solr.handler.IndexFetcher.logReplicationTimeAndConfFiles(IndexFetcher.java:605) at org.apache.solr.handler.IndexFetcher.cleanup(IndexFetcher.java:528) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:518) at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:253) at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:379) at org.apache.solr.handler.ReplicationHandler$2.run(ReplicationHandler.java:1027) at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:304) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:178) at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) ... 1 more Build Log: [...truncated 11314 lines...] [junit4] Suite: org.apache.solr.handler.TestReplicationHandler [junit4] 2> Creating dataDir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/init-core-data-001 [junit4] 2> 1684375 T5460 oas.SolrTestCaseJ4.setUp ###Starting doTestReplicateAfterWrite2Slave [junit4] 2> 1684377 T5460 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/collection1 [junit4] 2> 1684396 T5460 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 1684400 T5460 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:45418 [junit4] 2> 1684803 T5460 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostPort=45418, solr.data.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/collection1/data, hostContext=/solr} [junit4] 2> 1684804 T5460 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@5fb271f1 [junit4] 2> 1684805 T5460 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/' [junit4] 2> 1684861 T5460 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/solr.xml [junit4] 2> 1684934 T5460 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/. [junit4] 2> 1684935 T5460 oasc.CoreContainer.<init> New CoreContainer 54381125 [junit4] 2> 1684935 T5460 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/] [junit4] 2> 1684936 T5460 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/lib [junit4] 2> 1684937 T5460 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/lib). [junit4] 2> 1684952 T5460 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 1684952 T5460 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 1684952 T5460 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 1684953 T5460 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 1684953 T5460 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 1684953 T5460 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 1684954 T5460 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 1684954 T5460 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 1684954 T5460 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 1684955 T5460 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 1684955 T5460 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 1684966 T5460 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1684968 T5460 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1684968 T5460 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1684969 T5460 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 1684971 T5460 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/. [junit4] 2> 1684974 T5460 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {loadOnStartup=true, schema=schema.xml, config=solrconfig.xml, absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/, instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1, dataDir=data/, name=collection1, transient=false} [junit4] 2> 1684975 T5460 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/ [junit4] 2> 1684976 T5460 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1684977 T5470 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/' [junit4] 2> 1685021 T5470 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1685046 T5470 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 1685101 T5470 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1685102 T5470 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/conf/schema.xml [junit4] 2> 1685111 T5470 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1685132 T5470 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1685133 T5470 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/ [junit4] 2> 1685133 T5470 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1685134 T5470 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/data/ [junit4] 2> 1685134 T5470 c:collection1 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 1685136 T5470 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/data [junit4] 2> 1685137 T5470 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/data/index/ [junit4] 2> 1685137 T5470 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1685138 T5470 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/data/index [junit4] 2> 1685138 T5470 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=13, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=74.5966796875, floorSegmentMB=2.1953125, forceMergeDeletesPctAllowed=2.047079338343283, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.830014422319695 [junit4] 2> 1685139 T5470 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@48309204 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6cc269a2),segFN=segments_1,generation=1} [junit4] 2> 1685139 T5470 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1685142 T5470 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1685165 T5470 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1685168 T5470 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1685170 T5470 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1685173 T5470 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1685206 T5470 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1685206 T5470 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /schema,/admin/luke,/config,defaults,/admin/segments,/update/csv,/update,/get,/update/json/docs,/admin/properties,standard,/admin/logging,/admin/threads,/admin/ping,/update/json,lazy,/admin/plugins,/admin/mbeans,/admin/file,/admin/system,/replication [junit4] 2> 1685209 T5470 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1685210 T5470 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1685210 T5470 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1685211 T5470 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@2c9e55ad [junit4] 2> 1685212 T5470 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@48309204 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6cc269a2),segFN=segments_1,generation=1} [junit4] 2> 1685212 T5470 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1685212 T5470 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@54f451d5[collection1] main [junit4] 2> 1685213 T5470 c:collection1 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/conf [junit4] 2> 1685213 T5470 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/conf} [junit4] 2> 1685214 T5470 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-001/./collection1/conf [junit4] 2> 1685215 T5470 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1685215 T5470 c:collection1 oash.ReplicationHandler.inform Replication enabled for following config files: schema.xml,xslt/dummy.xsl [junit4] 2> 1685215 T5470 c:collection1 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 1685215 T5471 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@54f451d5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1685216 T5470 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1685216 T5460 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0 [junit4] 2> 1685217 T5460 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> 1685220 T5460 oas.SolrTestCaseJ4.writeCoreProperties Writing core.properties file to /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/collection1 [junit4] 2> 1685240 T5460 oejs.Server.doStart jetty-8.1.10.v20130312 [junit4] 2> 1685243 T5460 oejs.AbstractConnector.doStart Started SocketConnector@127.0.0.1:45420 [junit4] 2> 1685243 T5460 oascse.JettySolrRunner$1.lifeCycleStarted Jetty properties: {hostContext=/solr, hostPort=45420, solr.data.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/collection1/data} [junit4] 2> 1685244 T5460 oass.SolrDispatchFilter.init SolrDispatchFilter.init()sun.misc.Launcher$AppClassLoader@5fb271f1 [junit4] 2> 1685244 T5460 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/' [junit4] 2> 1685301 T5460 oasc.SolrXmlConfig.fromFile Loading container configuration from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/solr.xml [junit4] 2> 1685369 T5460 oasc.CorePropertiesLocator.<init> Config-defined core root directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/. [junit4] 2> 1685370 T5460 oasc.CoreContainer.<init> New CoreContainer 1570794517 [junit4] 2> 1685370 T5460 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/] [junit4] 2> 1685371 T5460 oasc.CoreContainer.load loading shared library: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/lib [junit4] 2> 1685372 T5460 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: lib (resolved as: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/lib). [junit4] 2> 1685387 T5460 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 90000 [junit4] 2> 1685387 T5460 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: [junit4] 2> 1685388 T5460 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 15000 [junit4] 2> 1685388 T5460 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 1685388 T5460 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 1685389 T5460 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 1685389 T5460 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 1685389 T5460 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 1685390 T5460 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 1685390 T5460 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 1685391 T5460 oashc.HttpShardHandlerFactory.getParameter Setting useRetries to: false [junit4] 2> 1685399 T5460 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 1685401 T5460 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1685401 T5460 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1685401 T5460 oasc.CoreContainer.load Node Name: 127.0.0.1 [junit4] 2> 1685403 T5460 oasc.CorePropertiesLocator.discover Looking for core definitions underneath /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/. [junit4] 2> 1685407 T5460 oasc.CoreDescriptor.<init> CORE DESCRIPTOR: {instanceDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1, absoluteInstDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/, name=collection1, dataDir=data/, loadOnStartup=true, transient=false, schema=schema.xml, config=solrconfig.xml} [junit4] 2> 1685407 T5460 oasc.CorePropertiesLocator.discoverUnder Found core collection1 in /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/ [junit4] 2> 1685408 T5460 oasc.CorePropertiesLocator.discover Found 1 core definitions [junit4] 2> 1685408 T5482 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/' [junit4] 2> 1685457 T5482 oasc.SolrConfig.refreshRequestParams current version of requestparams : -1 [junit4] 2> 1685483 T5482 oasc.SolrConfig.<init> Using Lucene MatchVersion: 5.2.0 [junit4] 2> 1685542 T5482 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1685543 T5482 oass.IndexSchema.readSchema Reading Solr Schema from /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/conf/schema.xml [junit4] 2> 1685552 T5482 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1685576 T5482 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1685578 T5482 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/ [junit4] 2> 1685578 T5482 c:collection1 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 1685579 T5482 c:collection1 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/, dataDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/data/ [junit4] 2> 1685579 T5482 c:collection1 oasc.SolrCore.<init> JMX monitoring not detected for core: collection1 [junit4] 2> 1685581 T5482 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/data [junit4] 2> 1685582 T5482 c:collection1 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/data/index/ [junit4] 2> 1685583 T5482 c:collection1 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 1685583 T5482 c:collection1 oasc.CachingDirectoryFactory.get return new directory for /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/data/index [junit4] 2> 1685584 T5482 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=13, maxMergeAtOnceExplicit=11, maxMergedSegmentMB=74.5966796875, floorSegmentMB=2.1953125, forceMergeDeletesPctAllowed=2.047079338343283, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.830014422319695 [junit4] 2> 1685584 T5482 c:collection1 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@2574c523 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@153a900b),segFN=segments_1,generation=1} [junit4] 2> 1685585 T5482 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1685587 T5482 c:collection1 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1685617 T5482 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1685620 T5482 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1685623 T5482 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1685626 T5482 c:collection1 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1685629 T5482 c:collection1 oasc.PluginBag.createPlugin requestHandler : 'lazy' created with startup=lazy [junit4] 2> 1685629 T5482 c:collection1 oasc.RequestHandlers.initHandlersFromConfig Registered paths: /schema,/admin/luke,/config,defaults,/admin/segments,/update/csv,/update,/get,/update/json/docs,/admin/properties,standard,/admin/logging,/admin/threads,/admin/ping,/update/json,lazy,/admin/plugins,/admin/mbeans,/admin/file,/admin/system,/replication [junit4] 2> 1685632 T5482 c:collection1 oasc.SolrCore.initStatsCache Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 1685633 T5482 c:collection1 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1685633 T5482 c:collection1 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1685634 T5482 c:collection1 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@139b5e16 [junit4] 2> 1685634 T5482 c:collection1 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@2574c523 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@153a900b),segFN=segments_1,generation=1} [junit4] 2> 1685634 T5482 c:collection1 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1685635 T5482 c:collection1 oass.SolrIndexSearcher.<init> Opening Searcher@318ccb41[collection1] main [junit4] 2> 1685636 T5482 c:collection1 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/conf [junit4] 2> 1685636 T5482 c:collection1 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/conf} [junit4] 2> 1685637 T5482 c:collection1 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-002/./collection1/conf [junit4] 2> 1685638 T5482 c:collection1 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1685647 T5482 c:collection1 oash.ReplicationHandler.setupPolling Poll Scheduled at an interval of 1000ms [junit4] 2> 1685647 T5483 c:collection1 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@318ccb41[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1685648 T5482 c:collection1 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1685648 T5460 oass.SolrDispatchFilter.init user.dir=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0 [junit4] 2> 1685649 T5460 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done [junit4] 2> ASYNC NEW_CORE C1009 name=collection1 org.apache.solr.core.SolrCore@754e94a5 [junit4] 2> 1685653 T5469 c:collection1 C1009 oasc.SolrCore.execute [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=1 [junit4] 2> 1685658 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0]} 0 1 [junit4] 2> 1685661 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1]} 0 0 [junit4] 2> 1685664 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2]} 0 0 [junit4] 2> 1685667 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[3]} 0 0 [junit4] 2> 1685671 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[4]} 0 0 [junit4] 2> 1685674 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[5]} 0 0 [junit4] 2> 1685677 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[6]} 0 0 [junit4] 2> 1685680 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[7]} 0 0 [junit4] 2> 1685684 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[8]} 0 0 [junit4] 2> 1685688 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[9]} 0 0 [junit4] 2> 1685691 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[10]} 0 0 [junit4] 2> 1685695 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[11]} 0 0 [junit4] 2> 1685698 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[12]} 0 0 [junit4] 2> 1685701 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[13]} 0 0 [junit4] 2> 1685704 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[14]} 0 0 [junit4] 2> 1685707 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[15]} 0 0 [junit4] 2> 1685710 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[16]} 0 0 [junit4] 2> 1685713 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[17]} 0 0 [junit4] 2> 1685716 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[18]} 0 0 [junit4] 2> 1685719 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[19]} 0 0 [junit4] 2> 1685722 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[20]} 0 0 [junit4] 2> 1685725 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[21]} 0 0 [junit4] 2> 1685728 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[22]} 0 0 [junit4] 2> 1685732 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[23]} 0 0 [junit4] 2> 1685735 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[24]} 0 0 [junit4] 2> 1685738 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[25]} 0 0 [junit4] 2> 1685742 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[26]} 0 0 [junit4] 2> 1685746 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[27]} 0 0 [junit4] 2> 1685749 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[28]} 0 0 [junit4] 2> 1685752 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[29]} 0 0 [junit4] 2> 1685755 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[30]} 0 0 [junit4] 2> 1685758 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[31]} 0 0 [junit4] 2> 1685761 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[32]} 0 0 [junit4] 2> 1685766 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[33]} 0 0 [junit4] 2> 1685770 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[34]} 0 0 [junit4] 2> 1685774 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[35]} 0 0 [junit4] 2> 1685777 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[36]} 0 0 [junit4] 2> 1685781 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[37]} 0 0 [junit4] 2> 1685785 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[38]} 0 0 [junit4] 2> 1685789 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[39]} 0 0 [junit4] 2> 1685792 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[40]} 0 0 [junit4] 2> 1685796 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[41]} 0 0 [junit4] 2> 1685800 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[42]} 0 0 [junit4] 2> 1685803 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[43]} 0 0 [junit4] 2> 1685806 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[44]} 0 0 [junit4] 2> 1685809 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[45]} 0 0 [junit4] 2> 1685813 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[46]} 0 0 [junit4] 2> 1685817 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[47]} 0 0 [junit4] 2> 1685820 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[48]} 0 0 [junit4] 2> 1685824 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[49]} 0 1 [junit4] 2> 1685827 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[50]} 0 0 [junit4] 2> 1685830 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[51]} 0 0 [junit4] 2> 1685833 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[52]} 0 0 [junit4] 2> 1685836 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[53]} 0 0 [junit4] 2> 1685839 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[54]} 0 0 [junit4] 2> 1685842 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[55]} 0 0 [junit4] 2> 1685846 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[56]} 0 0 [junit4] 2> 1685848 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[57]} 0 0 [junit4] 2> 1685851 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[58]} 0 0 [junit4] 2> 1685855 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[59]} 0 0 [junit4] 2> 1685858 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[60]} 0 0 [junit4] 2> 1685861 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[61]} 0 0 [junit4] 2> 1685864 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[62]} 0 0 [junit4] 2> 1685867 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[63]} 0 0 [junit4] 2> 1685870 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[64]} 0 0 [junit4] 2> 1685874 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[65]} 0 0 [junit4] 2> 1685877 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[66]} 0 0 [junit4] 2> 1685881 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[67]} 0 1 [junit4] 2> 1685885 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[68]} 0 0 [junit4] 2> 1685888 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[69]} 0 0 [junit4] 2> 1685892 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[70]} 0 0 [junit4] 2> 1685895 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[71]} 0 0 [junit4] 2> 1685899 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[72]} 0 0 [junit4] 2> 1685902 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[73]} 0 0 [junit4] 2> 1685906 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[74]} 0 0 [junit4] 2> 1685910 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[75]} 0 0 [junit4] 2> 1685914 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[76]} 0 1 [junit4] 2> 1685917 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[77]} 0 0 [junit4] 2> 1685920 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[78]} 0 0 [junit4] 2> 1685923 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[79]} 0 0 [junit4] 2> 1685926 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[80]} 0 0 [junit4] 2> 1685930 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[81]} 0 0 [junit4] 2> 1685933 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[82]} 0 0 [junit4] 2> 1685936 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[83]} 0 0 [junit4] 2> 1685939 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[84]} 0 0 [junit4] 2> 1685942 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[85]} 0 0 [junit4] 2> 1685945 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[86]} 0 0 [junit4] 2> 1685948 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[87]} 0 0 [junit4] 2> 1685951 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[88]} 0 0 [junit4] 2> 1685954 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[89]} 0 0 [junit4] 2> 1685957 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[90]} 0 0 [junit4] 2> 1685961 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[91]} 0 0 [junit4] 2> 1685964 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[92]} 0 0 [junit4] 2> 1685967 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[93]} 0 0 [junit4] 2> 1685970 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[94]} 0 0 [junit4] 2> 1685973 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[95]} 0 0 [junit4] 2> 1685976 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[96]} 0 0 [junit4] 2> 1685979 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[97]} 0 0 [junit4] 2> 1685982 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[98]} 0 0 [junit4] 2> 1685985 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[99]} 0 0 [junit4] 2> 1685988 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[100]} 0 0 [junit4] 2> 1685991 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[101]} 0 0 [junit4] 2> 1685994 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[102]} 0 0 [junit4] 2> 1685997 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[103]} 0 0 [junit4] 2> 1686000 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[104]} 0 0 [junit4] 2> 1686003 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[105]} 0 0 [junit4] 2> 1686006 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[106]} 0 0 [junit4] 2> 1686009 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[107]} 0 0 [junit4] 2> 1686012 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[108]} 0 0 [junit4] 2> 1686015 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[109]} 0 0 [junit4] 2> 1686018 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[110]} 0 0 [junit4] 2> 1686021 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[111]} 0 0 [junit4] 2> 1686024 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[112]} 0 0 [junit4] 2> 1686027 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[113]} 0 0 [junit4] 2> 1686030 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[114]} 0 0 [junit4] 2> 1686033 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[115]} 0 0 [junit4] 2> 1686036 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[116]} 0 0 [junit4] 2> 1686039 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[117]} 0 0 [junit4] 2> 1686042 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[118]} 0 0 [junit4] 2> 1686045 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[119]} 0 0 [junit4] 2> 1686049 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[120]} 0 0 [junit4] 2> 1686052 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[121]} 0 0 [junit4] 2> 1686057 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[122]} 0 0 [junit4] 2> 1686061 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123]} 0 0 [junit4] 2> 1686064 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[124]} 0 0 [junit4] 2> 1686067 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[125]} 0 0 [junit4] 2> 1686070 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[126]} 0 0 [junit4] 2> 1686073 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[127]} 0 0 [junit4] 2> 1686076 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[128]} 0 0 [junit4] 2> 1686079 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[129]} 0 0 [junit4] 2> 1686083 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[130]} 0 0 [junit4] 2> 1686086 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[131]} 0 0 [junit4] 2> 1686089 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[132]} 0 0 [junit4] 2> 1686093 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[133]} 0 0 [junit4] 2> 1686096 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[134]} 0 0 [junit4] 2> 1686099 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[135]} 0 0 [junit4] 2> 1686102 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[136]} 0 0 [junit4] 2> 1686105 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[137]} 0 0 [junit4] 2> 1686108 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[138]} 0 0 [junit4] 2> 1686111 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[139]} 0 0 [junit4] 2> 1686114 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[140]} 0 0 [junit4] 2> 1686117 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[141]} 0 0 [junit4] 2> 1686121 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[142]} 0 0 [junit4] 2> 1686125 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[143]} 0 0 [junit4] 2> 1686128 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[144]} 0 0 [junit4] 2> 1686131 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[145]} 0 0 [junit4] 2> 1686134 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[146]} 0 0 [junit4] 2> 1686137 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[147]} 0 0 [junit4] 2> 1686141 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[148]} 0 0 [junit4] 2> 1686146 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[149]} 0 1 [junit4] 2> 1686146 T5465 c:collection1 C1009 oasc.SolrCore.execute [collection1] webapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0 [junit4] 2> 1686149 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[150]} 0 0 [junit4] 2> 1686152 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[151]} 0 0 [junit4] 2> 1686155 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[152]} 0 0 [junit4] 2> 1686158 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[153]} 0 0 [junit4] 2> 1686161 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[154]} 0 0 [junit4] 2> 1686164 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[155]} 0 0 [junit4] 2> 1686168 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[156]} 0 0 [junit4] 2> 1686171 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[157]} 0 0 [junit4] 2> 1686175 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[158]} 0 1 [junit4] 2> 1686178 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[159]} 0 0 [junit4] 2> 1686181 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[160]} 0 0 [junit4] 2> 1686184 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[161]} 0 0 [junit4] 2> 1686188 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[162]} 0 0 [junit4] 2> 1686191 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[163]} 0 0 [junit4] 2> 1686194 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[164]} 0 0 [junit4] 2> 1686197 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[165]} 0 0 [junit4] 2> 1686200 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[166]} 0 0 [junit4] 2> 1686203 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[167]} 0 0 [junit4] 2> 1686207 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[168]} 0 0 [junit4] 2> 1686210 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[169]} 0 0 [junit4] 2> 1686213 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[170]} 0 0 [junit4] 2> 1686217 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[171]} 0 0 [junit4] 2> 1686220 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[172]} 0 0 [junit4] 2> 1686223 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[173]} 0 0 [junit4] 2> 1686226 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[174]} 0 0 [junit4] 2> 1686229 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[175]} 0 0 [junit4] 2> 1686240 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[176]} 0 7 [junit4] 2> 1686244 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[177]} 0 1 [junit4] 2> 1686247 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[178]} 0 0 [junit4] 2> 1686250 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[179]} 0 0 [junit4] 2> 1686253 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[180]} 0 0 [junit4] 2> 1686256 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[181]} 0 0 [junit4] 2> 1686259 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[182]} 0 0 [junit4] 2> 1686263 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[183]} 0 1 [junit4] 2> 1686266 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[184]} 0 0 [junit4] 2> 1686270 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[185]} 0 0 [junit4] 2> 1686275 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[186]} 0 1 [junit4] 2> 1686279 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[187]} 0 1 [junit4] 2> 1686282 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[188]} 0 0 [junit4] 2> 1686285 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[189]} 0 0 [junit4] 2> 1686289 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[190]} 0 0 [junit4] 2> 1686293 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[191]} 0 0 [junit4] 2> 1686296 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[192]} 0 0 [junit4] 2> 1686301 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[193]} 0 1 [junit4] 2> 1686305 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[194]} 0 1 [junit4] 2> 1686309 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[195]} 0 1 [junit4] 2> 1686314 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[196]} 0 1 [junit4] 2> 1686318 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[197]} 0 1 [junit4] 2> 1686323 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[198]} 0 1 [junit4] 2> 1686326 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[199]} 0 0 [junit4] 2> 1686329 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[200]} 0 0 [junit4] 2> 1686332 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[201]} 0 0 [junit4] 2> 1686336 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[202]} 0 0 [junit4] 2> 1686340 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[203]} 0 0 [junit4] 2> 1686344 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[204]} 0 0 [junit4] 2> 1686349 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[205]} 0 1 [junit4] 2> 1686352 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[206]} 0 0 [junit4] 2> 1686356 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[207]} 0 0 [junit4] 2> 1686359 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[208]} 0 0 [junit4] 2> 1686362 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[209]} 0 0 [junit4] 2> 1686366 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[210]} 0 0 [junit4] 2> 1686371 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[211]} 0 1 [junit4] 2> 1686374 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[212]} 0 0 [junit4] 2> 1686379 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[213]} 0 1 [junit4] 2> 1686383 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[214]} 0 1 [junit4] 2> 1686386 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[215]} 0 0 [junit4] 2> 1686389 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[216]} 0 0 [junit4] 2> 1686392 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[217]} 0 0 [junit4] 2> 1686395 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[218]} 0 0 [junit4] 2> 1686398 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[219]} 0 0 [junit4] 2> 1686402 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[220]} 0 1 [junit4] 2> 1686405 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[221]} 0 0 [junit4] 2> 1686408 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[222]} 0 0 [junit4] 2> 1686413 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[223]} 0 1 [junit4] 2> 1686416 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[224]} 0 0 [junit4] 2> 1686419 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[225]} 0 0 [junit4] 2> 1686422 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[226]} 0 0 [junit4] 2> 1686425 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[227]} 0 0 [junit4] 2> 1686428 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[228]} 0 0 [junit4] 2> 1686432 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[229]} 0 0 [junit4] 2> 1686435 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[230]} 0 0 [junit4] 2> 1686438 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[231]} 0 0 [junit4] 2> 1686441 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[232]} 0 0 [junit4] 2> 1686444 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[233]} 0 0 [junit4] 2> 1686448 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[234]} 0 0 [junit4] 2> 1686451 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[235]} 0 0 [junit4] 2> 1686454 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[236]} 0 0 [junit4] 2> 1686457 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[237]} 0 0 [junit4] 2> 1686460 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[238]} 0 0 [junit4] 2> 1686463 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[239]} 0 0 [junit4] 2> 1686466 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[240]} 0 0 [junit4] 2> 1686469 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[241]} 0 0 [junit4] 2> 1686473 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[242]} 0 1 [junit4] 2> 1686476 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[243]} 0 0 [junit4] 2> 1686480 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[244]} 0 0 [junit4] 2> 1686484 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[245]} 0 0 [junit4] 2> 1686487 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[246]} 0 0 [junit4] 2> 1686490 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[247]} 0 0 [junit4] 2> 1686493 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[248]} 0 0 [junit4] 2> 1686496 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[249]} 0 0 [junit4] 2> 1686499 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[250]} 0 0 [junit4] 2> 1686502 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[251]} 0 0 [junit4] 2> 1686505 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[252]} 0 0 [junit4] 2> 1686509 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[253]} 0 0 [junit4] 2> 1686512 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[254]} 0 0 [junit4] 2> 1686515 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[255]} 0 0 [junit4] 2> 1686518 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[256]} 0 0 [junit4] 2> 1686521 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[257]} 0 0 [junit4] 2> 1686524 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[258]} 0 0 [junit4] 2> 1686528 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[259]} 0 0 [junit4] 2> 1686531 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[260]} 0 0 [junit4] 2> 1686534 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[261]} 0 0 [junit4] 2> 1686538 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[262]} 0 1 [junit4] 2> 1686542 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[263]} 0 1 [junit4] 2> 1686545 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[264]} 0 0 [junit4] 2> 1686548 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[265]} 0 0 [junit4] 2> 1686551 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[266]} 0 0 [junit4] 2> 1686554 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[267]} 0 0 [junit4] 2> 1686557 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[268]} 0 0 [junit4] 2> 1686560 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[269]} 0 0 [junit4] 2> 1686565 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[270]} 0 1 [junit4] 2> 1686568 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[271]} 0 0 [junit4] 2> 1686571 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[272]} 0 0 [junit4] 2> 1686574 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[273]} 0 0 [junit4] 2> 1686578 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[274]} 0 1 [junit4] 2> 1686581 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[275]} 0 0 [junit4] 2> 1686586 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[276]} 0 0 [junit4] 2> 1686591 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[277]} 0 0 [junit4] 2> 1686594 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[278]} 0 0 [junit4] 2> 1686598 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[279]} 0 0 [junit4] 2> 1686601 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[280]} 0 0 [junit4] 2> 1686605 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[281]} 0 1 [junit4] 2> 1686608 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[282]} 0 0 [junit4] 2> 1686612 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[283]} 0 0 [junit4] 2> 1686615 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[284]} 0 0 [junit4] 2> 1686618 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[285]} 0 0 [junit4] 2> 1686621 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[286]} 0 0 [junit4] 2> 1686625 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[287]} 0 0 [junit4] 2> 1686630 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[288]} 0 0 [junit4] 2> 1686634 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[289]} 0 0 [junit4] 2> 1686638 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[290]} 0 0 [junit4] 2> 1686642 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[291]} 0 0 [junit4] 2> 1686646 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[292]} 0 1 [junit4] 2> 1686650 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[293]} 0 1 [junit4] 2> 1686653 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[294]} 0 0 [junit4] 2> 1686656 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[295]} 0 0 [junit4] 2> 1686659 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[296]} 0 0 [junit4] 2> 1686664 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[297]} 0 0 [junit4] 2> 1686669 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[298]} 0 1 [junit4] 2> 1686672 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[299]} 0 0 [junit4] 2> 1686676 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[300]} 0 0 [junit4] 2> 1686679 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[301]} 0 0 [junit4] 2> 1686682 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[302]} 0 0 [junit4] 2> 1686685 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[303]} 0 0 [junit4] 2> 1686688 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[304]} 0 0 [junit4] 2> 1686691 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[305]} 0 0 [junit4] 2> 1686693 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[306]} 0 0 [junit4] 2> 1686696 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[307]} 0 0 [junit4] 2> 1686699 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[308]} 0 0 [junit4] 2> 1686704 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[309]} 0 1 [junit4] 2> 1686707 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[310]} 0 0 [junit4] 2> 1686711 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[311]} 0 0 [junit4] 2> 1686714 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[312]} 0 0 [junit4] 2> 1686717 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[313]} 0 0 [junit4] 2> 1686720 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[314]} 0 0 [junit4] 2> 1686723 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[315]} 0 0 [junit4] 2> 1686726 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[316]} 0 0 [junit4] 2> 1686729 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[317]} 0 0 [junit4] 2> 1686733 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[318]} 0 0 [junit4] 2> 1686736 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[319]} 0 0 [junit4] 2> 1686739 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[320]} 0 0 [junit4] 2> 1686742 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[321]} 0 0 [junit4] 2> 1686745 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[322]} 0 0 [junit4] 2> 1686748 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[323]} 0 0 [junit4] 2> 1686752 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[324]} 0 1 [junit4] 2> 1686755 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[325]} 0 0 [junit4] 2> 1686758 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[326]} 0 0 [junit4] 2> 1686761 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[327]} 0 0 [junit4] 2> 1686764 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[328]} 0 0 [junit4] 2> 1686767 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[329]} 0 0 [junit4] 2> 1686770 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[330]} 0 0 [junit4] 2> 1686773 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[331]} 0 0 [junit4] 2> 1686776 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[332]} 0 0 [junit4] 2> 1686779 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[333]} 0 0 [junit4] 2> 1686783 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[334]} 0 0 [junit4] 2> 1686786 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[335]} 0 0 [junit4] 2> 1686790 T5469 c:collection1 C1009 oasup.LogUpdateProcessor.finish [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[336]} 0 1 [junit4] 2> 1686793 T5469 c:collection1 C1009 oasup.Lo [...truncated too long message...] ulative_errors=0} [junit4] 2> 2907526 T5460 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 2907526 T5460 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 2907527 T5460 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 2907528 T5460 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 2907529 T5460 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 2907529 T5460 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-028/./collection1/data/index.20150413060227652 [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-028/./collection1/data/index.20150413060227652;done=false>>] [junit4] 2> 2907530 T5460 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-028/./collection1/data/index.20150413060227652 [junit4] 2> 2907530 T5460 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-028/./collection1/data [CachedDir<<refCount=0;path=/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-028/./collection1/data;done=false>>] [junit4] 2> 2907530 T5460 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/solr-instance-028/./collection1/data [junit4] 2> 2907531 T5460 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null} [junit4] 2> 2907728 T5460 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> 1223608 T5459 ccr.ThreadLeakControl.checkThreadLeaks WARNING Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50), sim=RandomSimilarityProvider(queryNorm=true,coord=yes): {}, locale=de, timezone=Asia/Dili [junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Oracle Corporation 1.7.0_65 (64-bit)/cpus=16,threads=1,free=37412328,total=243793920 [junit4] 2> NOTE: All tests run in this JVM: [TestManagedStopFilterFactory, TestStressReorder, TestExactStatsCache, HighlighterConfigTest, RequiredFieldsTest, MinimalSchemaTest, HdfsDirectoryTest, QueryParsingTest, SegmentsInfoRequestHandlerTest, ReplicationFactorTest, TestCollationField, SharedFSAutoReplicaFailoverUtilsTest, SpellCheckCollatorTest, TestMissingGroups, TestMacros, OverseerTest, TestSolrDynamicMBean, DeleteShardTest, OpenExchangeRatesOrgProviderTest, ShardRoutingCustomTest, SimpleFacetsTest, TestImplicitCoreProperties, TestCoreContainer, TestXIncludeConfig, TestCustomSort, TestFastLRUCache, TestRandomFaceting, TestSolrCoreProperties, TestManagedSchemaFieldTypeResource, CloudExitableDirectoryReaderTest, TestUpdate, ParsingFieldUpdateProcessorsTest, ExternalFileFieldSortTest, SolrTestCaseJ4Test, SuggesterTest, CustomCollectionTest, PolyFieldTest, DocValuesMissingTest, TestLRUStatsCache, TestSolrConfigHandler, TimeZoneUtilsTest, RemoteQueryErrorTest, RecoveryZkTest, UUIDFieldTest, SolrIndexConfigTest, DistributedQueryElevationComponentTest, OverseerCollectionProcessorTest, TestDynamicLoading, TestNoOpRegenerator, TestClusterStateMutator, SolrCmdDistributorTest, ZkSolrClientTest, TestManagedResourceStorage, TestSort, TestSolrDeletionPolicy2, HdfsSyncSliceTest, TestFaceting, BasicDistributedZkTest, BasicDistributedZk2Test, UnloadDistributedZkTest, SyncSliceTest, ShardRoutingTest, TestReplicationHandler] [junit4] 2> NOTE: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory. [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestReplicationHandler -Dtests.seed=303C02B061F337C5 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/home/jenkins/lucene-data/enwiki.random.lines.txt -Dtests.locale=de -Dtests.timezone=Asia/Dili -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s J0 | TestReplicationHandler (suite) <<< [junit4] > Throwable #1: java.lang.RuntimeException: file handle leaks: [FileChannel(/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/index-NIOFSDirectory-010/replication.properties), FileChannel(/usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler 303C02B061F337C5-001/index-NIOFSDirectory-004/replication.properties)] [junit4] > at __randomizedtesting.SeedInfo.seed([303C02B061F337C5]:0) [junit4] > at org.apache.lucene.mockfile.LeakFS.onClose(LeakFS.java:64) [junit4] > at org.apache.lucene.mockfile.FilterFileSystem.close(FilterFileSystem.java:78) [junit4] > at org.apache.lucene.mockfile.FilterFileSystem.close(FilterFileSystem.java:79) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > Caused by: java.lang.Exception [junit4] > at org.apache.lucene.mockfile.LeakFS.onOpen(LeakFS.java:47) [junit4] > at org.apache.lucene.mockfile.HandleTrackingFS.callOpenHook(HandleTrackingFS.java:84) [junit4] > at org.apache.lucene.mockfile.HandleTrackingFS.newFileChannel(HandleTrackingFS.java:191) [junit4] > at org.apache.lucene.mockfile.FilterFileSystemProvider.newFileChannel(FilterFileSystemProvider.java:204) [junit4] > at org.apache.lucene.mockfile.HandleTrackingFS.newFileChannel(HandleTrackingFS.java:163) [junit4] > at java.nio.channels.FileChannel.open(FileChannel.java:287) [junit4] > at java.nio.channels.FileChannel.open(FileChannel.java:334) [junit4] > at org.apache.lucene.store.NIOFSDirectory.openInput(NIOFSDirectory.java:82) [junit4] > at org.apache.lucene.util.LuceneTestCase.slowFileExists(LuceneTestCase.java:2487) [junit4] > at org.apache.lucene.store.MockDirectoryWrapper.openInput(MockDirectoryWrapper.java:639) [junit4] > at org.apache.solr.handler.ReplicationHandler.loadReplicationProperties(ReplicationHandler.java:977) [junit4] > at org.apache.solr.handler.IndexFetcher.logReplicationTimeAndConfFiles(IndexFetcher.java:605) [junit4] > at org.apache.solr.handler.IndexFetcher.cleanup(IndexFetcher.java:528) [junit4] > at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:518) [junit4] > at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:253) [junit4] > at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:379) [junit4] > at org.apache.solr.handler.ReplicationHandler$2.run(ReplicationHandler.java:1027) [junit4] > at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [junit4] > at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:304) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:178) [junit4] > at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) [junit4] > ... 1 more [junit4] Completed [437/482] on J0 in 1224.17s, 13 tests, 1 error <<< FAILURES! [...truncated 147 lines...] BUILD FAILED /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:543: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:484: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/build.xml:61: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/extra-targets.xml:39: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/build.xml:229: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/solr/common-build.xml:510: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:1434: The following error occurred while executing this line: /usr/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.x/lucene/common-build.xml:991: There were test failures: 482 suites, 1914 tests, 1 suite-level error, 60 ignored (10 assumptions) Total time: 157 minutes 18 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Sending artifact delta relative to Lucene-Solr-NightlyTests-5.x #716 Archived 5 artifacts Archive block size is 32768 Received 0 blocks and 895703055 bytes Compression is 0.0% Took 2 min 38 sec Recording test results Email was triggered for: Failure Sending email for trigger: Failure
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org