Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/20121/
Java: 32bit/jdk-9-ea+175 -client -XX:+UseSerialGC --illegal-access=deny

1 tests failed.
FAILED:  org.apache.solr.schema.TestBulkSchemaConcurrent.test

Error Message:
Captured an uncaught exception in thread: Thread[id=26549, name=Thread-4389, 
state=RUNNABLE, group=TGRP-TestBulkSchemaConcurrent]

Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=26549, name=Thread-4389, state=RUNNABLE, 
group=TGRP-TestBulkSchemaConcurrent]
        at 
__randomizedtesting.SeedInfo.seed([1723C6458B5156AA:9F77F99F25AD3B52]:0)
Caused by: java.lang.ArrayIndexOutOfBoundsException: 1
        at __randomizedtesting.SeedInfo.seed([1723C6458B5156AA]:0)
        at java.base/java.util.ArrayList.add(ArrayList.java:467)
        at java.base/java.util.ArrayList.add(ArrayList.java:479)
        at 
org.apache.solr.schema.TestBulkSchemaConcurrent$1.run(TestBulkSchemaConcurrent.java:89)




Build Log:
[...truncated 12999 lines...]
   [junit4] Suite: org.apache.solr.schema.TestBulkSchemaConcurrent
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/init-core-data-001
   [junit4]   2> 1861055 WARN  
(SUITE-TestBulkSchemaConcurrent-seed#[1723C6458B5156AA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=6 numCloses=6
   [junit4]   2> 1861055 INFO  
(SUITE-TestBulkSchemaConcurrent-seed#[1723C6458B5156AA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 1861056 INFO  
(SUITE-TestBulkSchemaConcurrent-seed#[1723C6458B5156AA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, 
clientAuth=0.0/0.0)
   [junit4]   2> 1861057 INFO  
(SUITE-TestBulkSchemaConcurrent-seed#[1723C6458B5156AA]-worker) [    ] 
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: 
/snjn/ti
   [junit4]   2> 1861059 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1861059 INFO  (Thread-4342) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1861059 INFO  (Thread-4342) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1861061 ERROR (Thread-4342) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1861159 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkTestServer start zk server on port:34361
   [junit4]   2> 1861169 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-managed-schema.xml
 to /configs/conf1/solrconfig.xml
   [junit4]   2> 1861170 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/schema.xml
 to /configs/conf1/schema.xml
   [junit4]   2> 1861172 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
 to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
   [junit4]   2> 1861173 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
 to /configs/conf1/stopwords.txt
   [junit4]   2> 1861174 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt
 to /configs/conf1/protwords.txt
   [junit4]   2> 1861175 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml
 to /configs/conf1/currency.xml
   [junit4]   2> 1861176 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
 to /configs/conf1/enumsConfig.xml
   [junit4]   2> 1861177 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
 to /configs/conf1/open-exchange-rates.json
   [junit4]   2> 1861177 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
 to /configs/conf1/mapping-ISOLatin1Accent.txt
   [junit4]   2> 1861178 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
 to /configs/conf1/old_synonyms.txt
   [junit4]   2> 1861179 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractZkTestCase put 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
 to /configs/conf1/synonyms.txt
   [junit4]   2> 1861182 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly 
asked otherwise
   [junit4]   2> 1861263 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1861264 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@534b6b{/snjn/ti,null,AVAILABLE}
   [junit4]   2> 1861266 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1c2889c{SSL,[ssl, 
http/1.1]}{127.0.0.1:༤༢༧༦༥}
   [junit4]   2> 1861266 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.Server Started @༡༨༦༢༧༧༦ms
   [junit4]   2> 1861266 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/snjn/ti, 
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/tempDir-001/control/data,
 hostPort=42765, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/control-001/cores,
 replicaType=NRT}
   [junit4]   2> 1861266 ERROR 
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1861266 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1861266 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1861267 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1861267 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-07-13T06:22:46.979033Z
   [junit4]   2> 1861268 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1861268 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/control-001/solr.xml
   [junit4]   2> 1861270 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1861272 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34361/solr
   [junit4]   2> 1861296 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1861296 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 
127.0.0.1:42765_snjn%2Fti
   [junit4]   2> 1861296 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.Overseer Overseer 
(id=98299213694435333-127.0.0.1:42765_snjn%2Fti-n_0000000000) starting
   [junit4]   2> 1861298 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:42765_snjn%2Fti
   [junit4]   2> 1861298 INFO  (zkCallback-5885-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1861365 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1861368 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1861368 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1861368 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/control-001/cores
   [junit4]   2> 1861377 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1861378 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34361/solr ready
   [junit4]   2> 1861414 INFO  (qtp15077411-26379) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:42765_snjn%252Fti&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1861415 INFO  (OverseerThreadFactory-7997-thread-1) [    ] 
o.a.s.c.CreateCollectionCmd Create collection control_collection
   [junit4]   2> 1861521 INFO  (qtp15077411-26380) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1861521 INFO  (qtp15077411-26380) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1861625 INFO  (zkCallback-5885-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1862532 INFO  (qtp15077411-26380) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1862537 INFO  (qtp15077411-26380) [    ] 
o.a.s.s.ManagedIndexSchemaFactory The schema is configured as managed, but 
managed schema resource managed-schema not found - loading non-managed schema 
schema.xml instead
   [junit4]   2> 1862544 INFO  (qtp15077411-26380) [    ] o.a.s.s.IndexSchema 
[control_collection_shard1_replica_n1] Schema name=test
   [junit4]   2> 1862622 INFO  (qtp15077411-26380) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1862628 INFO  (qtp15077411-26380) [    ] 
o.a.s.s.ManagedIndexSchema Created and persisted managed schema znode at 
/configs/conf1/managed-schema
   [junit4]   2> 1862628 INFO  (qtp15077411-26380) [    ] 
o.a.s.s.ManagedIndexSchemaFactory After upgrading to managed schema in 
ZooKeeper, renamed the non-managed schema /configs/conf1/schema.xml to 
/configs/conf1/schema.xml.bak
   [junit4]   2> 1862628 INFO  (qtp15077411-26380) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'control_collection_shard1_replica_n1' using configuration 
from collection control_collection, trusted=true
   [junit4]   2> 1862629 INFO  (qtp15077411-26380) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.control_collection.shard1.replica_n1' (registry 
'solr.core.control_collection.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1862629 INFO  (qtp15077411-26380) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1862629 INFO  (qtp15077411-26380) [    ] o.a.s.c.SolrCore 
[[control_collection_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/control-001/cores/control_collection_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/control-001/cores/control_collection_shard1_replica_n1/data/]
   [junit4]   2> 1862631 INFO  (qtp15077411-26380) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=6.595703125, 
floorSegmentMB=1.654296875, forceMergeDeletesPctAllowed=20.900986519861533, 
segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1862649 WARN  (qtp15077411-26380) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, registerPath=/solr,/v2, 
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 1862675 INFO  (qtp15077411-26380) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1862675 INFO  (qtp15077411-26380) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1862675 INFO  (qtp15077411-26380) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1862675 INFO  (qtp15077411-26380) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1862676 INFO  (qtp15077411-26380) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8591252144185914]
   [junit4]   2> 1862676 INFO  (qtp15077411-26380) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@fc1fe3[control_collection_shard1_replica_n1] main]
   [junit4]   2> 1862678 INFO  (qtp15077411-26380) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1862678 INFO  (qtp15077411-26380) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1862678 INFO  (qtp15077411-26380) [    ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1862678 INFO  (qtp15077411-26380) [    ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1862679 INFO  (qtp15077411-26380) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1862679 INFO  (searcherExecutor-8000-thread-1) [    ] 
o.a.s.c.SolrCore [control_collection_shard1_replica_n1] Registered new searcher 
Searcher@fc1fe3[control_collection_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1862679 INFO  (qtp15077411-26380) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1572787420807561216
   [junit4]   2> 1862682 INFO  (qtp15077411-26380) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1862682 INFO  (qtp15077411-26380) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1862682 INFO  (qtp15077411-26380) [    ] o.a.s.c.SyncStrategy 
Sync replicas to 
https://127.0.0.1:42765/snjn/ti/control_collection_shard1_replica_n1/
   [junit4]   2> 1862682 INFO  (qtp15077411-26380) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1862682 INFO  (qtp15077411-26380) [    ] o.a.s.c.SyncStrategy 
https://127.0.0.1:42765/snjn/ti/control_collection_shard1_replica_n1/ has no 
replicas
   [junit4]   2> 1862682 INFO  (qtp15077411-26380) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1862683 INFO  (qtp15077411-26380) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:42765/snjn/ti/control_collection_shard1_replica_n1/ shard1
   [junit4]   2> 1862785 INFO  (zkCallback-5885-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1862834 INFO  (qtp15077411-26380) [    ] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 1862836 INFO  (qtp15077411-26380) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1315
   [junit4]   2> 1862840 INFO  (qtp15077411-26379) [    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1862937 INFO  (zkCallback-5885-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/control_collection/state.json] for collection 
[control_collection] has occurred - updating... (live nodes size: [1])
   [junit4]   2> 1863417 INFO  
(OverseerCollectionConfigSetProcessor-98299213694435333-127.0.0.1:42765_snjn%2Fti-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1863840 INFO  (qtp15077411-26379) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:42765_snjn%252Fti&wt=javabin&version=2}
 status=0 QTime=2426
   [junit4]   2> 1863843 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1863844 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34361/solr ready
   [junit4]   2> 1863844 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection 
loss:false
   [junit4]   2> 1863845 INFO  (qtp15077411-26384) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1863846 INFO  (OverseerThreadFactory-7997-thread-2) [    ] 
o.a.s.c.CreateCollectionCmd Create collection collection1
   [junit4]   2> 1863846 WARN  (OverseerThreadFactory-7997-thread-2) [    ] 
o.a.s.c.CreateCollectionCmd It is unusual to create a collection (collection1) 
without cores.
   [junit4]   2> 1864050 INFO  (qtp15077411-26384) [    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1864050 INFO  (qtp15077411-26384) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2}
 status=0 QTime=204
   [junit4]   2> 1864144 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-1-001
 of type NRT
   [junit4]   2> 1864144 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1864145 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@878724{/snjn/ti,null,AVAILABLE}
   [junit4]   2> 1864145 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@4e6557{SSL,[ssl, 
http/1.1]}{127.0.0.1:༣༩༥༧༥}
   [junit4]   2> 1864145 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.Server Started @༡༨༦༥༦༥༥ms
   [junit4]   2> 1864145 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/snjn/ti, 
solrconfig=solrconfig.xml, 
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/tempDir-001/jetty1,
 hostPort=39575, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-1-001/cores,
 replicaType=NRT}
   [junit4]   2> 1864146 ERROR 
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1864146 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1864146 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1864146 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1864146 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-07-13T06:22:49.858291Z
   [junit4]   2> 1864148 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1864148 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-1-001/solr.xml
   [junit4]   2> 1864150 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1864152 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34361/solr
   [junit4]   2> 1864156 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1864157 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1864157 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:39575_snjn%2Fti
   [junit4]   2> 1864158 INFO  (zkCallback-5885-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1864158 INFO  (zkCallback-5897-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1864158 INFO  (zkCallback-5892-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 1864224 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1864228 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1864228 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1864229 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-1-001/cores
   [junit4]   2> 1864244 INFO  (qtp15077411-26380) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:39575_snjn%252Fti&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1864245 INFO  
(OverseerCollectionConfigSetProcessor-98299213694435333-127.0.0.1:42765_snjn%2Fti-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1864245 INFO  (OverseerThreadFactory-7997-thread-3) [    ] 
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:39575_snjn%2Fti for creating 
new replica
   [junit4]   2> 1864274 INFO  (qtp735392-26420) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n0&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1864275 INFO  (qtp735392-26420) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1865281 INFO  (qtp735392-26420) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1865287 INFO  (qtp735392-26420) [    ] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n0] Schema name=test
   [junit4]   2> 1865371 INFO  (qtp735392-26420) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1865378 INFO  (qtp735392-26420) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard2_replica_n0' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 1865378 INFO  (qtp735392-26420) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard2.replica_n0' (registry 
'solr.core.collection1.shard2.replica_n0') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1865379 INFO  (qtp735392-26420) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1865379 INFO  (qtp735392-26420) [    ] o.a.s.c.SolrCore 
[[collection1_shard2_replica_n0] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-1-001/cores/collection1_shard2_replica_n0],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-1-001/cores/collection1_shard2_replica_n0/data/]
   [junit4]   2> 1865381 INFO  (qtp735392-26420) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=6.595703125, 
floorSegmentMB=1.654296875, forceMergeDeletesPctAllowed=20.900986519861533, 
segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1865403 WARN  (qtp735392-26420) [    ] o.a.s.c.RequestHandlers 
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class 
= DumpRequestHandler,attributes = {initParams=a, name=/dump, 
registerPath=/solr,/v2, class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 1865433 INFO  (qtp735392-26420) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1865433 INFO  (qtp735392-26420) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1865433 INFO  (qtp735392-26420) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1865434 INFO  (qtp735392-26420) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1865434 INFO  (qtp735392-26420) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8591252144185914]
   [junit4]   2> 1865435 INFO  (qtp735392-26420) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@fa6216[collection1_shard2_replica_n0] main]
   [junit4]   2> 1865436 INFO  (qtp735392-26420) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1865436 INFO  (qtp735392-26420) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1865436 INFO  (qtp735392-26420) [    ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1865437 INFO  (qtp735392-26420) [    ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1865437 INFO  (qtp735392-26420) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1865438 INFO  (searcherExecutor-8011-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n0] Registered new searcher 
Searcher@fa6216[collection1_shard2_replica_n0] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1865438 INFO  (qtp735392-26420) [    ] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1572787423700582400
   [junit4]   2> 1865441 INFO  (qtp735392-26420) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1865441 INFO  (qtp735392-26420) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1865441 INFO  (qtp735392-26420) [    ] o.a.s.c.SyncStrategy 
Sync replicas to https://127.0.0.1:39575/snjn/ti/collection1_shard2_replica_n0/
   [junit4]   2> 1865441 INFO  (qtp735392-26420) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1865442 INFO  (qtp735392-26420) [    ] o.a.s.c.SyncStrategy 
https://127.0.0.1:39575/snjn/ti/collection1_shard2_replica_n0/ has no replicas
   [junit4]   2> 1865442 INFO  (qtp735392-26420) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1865443 INFO  (qtp735392-26420) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:39575/snjn/ti/collection1_shard2_replica_n0/ shard2
   [junit4]   2> 1865593 INFO  (qtp735392-26420) [    ] o.a.s.c.ZkController I 
am the leader, no recovery necessary
   [junit4]   2> 1865594 INFO  (qtp735392-26420) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n0&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1319
   [junit4]   2> 1865596 INFO  (qtp15077411-26380) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:39575_snjn%252Fti&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2}
 status=0 QTime=1351
   [junit4]   2> 1865699 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-2-001
 of type NRT
   [junit4]   2> 1865700 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1865700 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@c3e95d{/snjn/ti,null,AVAILABLE}
   [junit4]   2> 1865701 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@183aa2a{SSL,[ssl, 
http/1.1]}{127.0.0.1:༤༥༡༠༩}
   [junit4]   2> 1865701 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.Server Started @༡༨༦༧༢༡༠ms
   [junit4]   2> 1865701 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/snjn/ti, 
solrconfig=solrconfig.xml, 
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/tempDir-001/jetty2,
 hostPort=45109, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-2-001/cores}
   [junit4]   2> 1865701 ERROR 
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1865701 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1865701 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1865701 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1865701 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-07-13T06:22:51.413644Z
   [junit4]   2> 1865703 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1865703 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-2-001/solr.xml
   [junit4]   2> 1865705 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1865707 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34361/solr
   [junit4]   2> 1865711 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1865712 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1865712 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45109_snjn%2Fti
   [junit4]   2> 1865713 INFO  (zkCallback-5892-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1865713 INFO  (zkCallback-5897-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1865713 INFO  (zkCallback-5885-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1865713 INFO  (zkCallback-5903-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 1865743 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1865747 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1865747 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1865748 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-2-001/cores
   [junit4]   2> 1865792 INFO  (qtp9356021-26450) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:45109_snjn%252Fti&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1865793 INFO  
(OverseerCollectionConfigSetProcessor-98299213694435333-127.0.0.1:42765_snjn%2Fti-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000004 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1865793 INFO  (OverseerThreadFactory-7997-thread-4) [    ] 
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:45109_snjn%2Fti for creating 
new replica
   [junit4]   2> 1865796 INFO  (qtp9356021-26457) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n0&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1865796 INFO  (qtp9356021-26457) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1866804 INFO  (qtp9356021-26457) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1866811 INFO  (qtp9356021-26457) [    ] o.a.s.s.IndexSchema 
[collection1_shard1_replica_n0] Schema name=test
   [junit4]   2> 1866881 INFO  (qtp9356021-26457) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1866887 INFO  (qtp9356021-26457) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard1_replica_n0' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 1866887 INFO  (qtp9356021-26457) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard1.replica_n0' (registry 
'solr.core.collection1.shard1.replica_n0') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1866887 INFO  (qtp9356021-26457) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1866887 INFO  (qtp9356021-26457) [    ] o.a.s.c.SolrCore 
[[collection1_shard1_replica_n0] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-2-001/cores/collection1_shard1_replica_n0],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-2-001/cores/collection1_shard1_replica_n0/data/]
   [junit4]   2> 1866890 INFO  (qtp9356021-26457) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=6.595703125, 
floorSegmentMB=1.654296875, forceMergeDeletesPctAllowed=20.900986519861533, 
segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1866907 WARN  (qtp9356021-26457) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, registerPath=/solr,/v2, 
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 1866950 INFO  (qtp9356021-26457) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1866950 INFO  (qtp9356021-26457) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1866951 INFO  (qtp9356021-26457) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1866951 INFO  (qtp9356021-26457) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1866952 INFO  (qtp9356021-26457) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8591252144185914]
   [junit4]   2> 1866952 INFO  (qtp9356021-26457) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@16920f0[collection1_shard1_replica_n0] main]
   [junit4]   2> 1866953 INFO  (qtp9356021-26457) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1866953 INFO  (qtp9356021-26457) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1866953 INFO  (qtp9356021-26457) [    ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1866953 INFO  (qtp9356021-26457) [    ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1866954 INFO  (qtp9356021-26457) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1866954 INFO  (searcherExecutor-8022-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard1_replica_n0] Registered new searcher 
Searcher@16920f0[collection1_shard1_replica_n0] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1866954 INFO  (qtp9356021-26457) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1572787425290223616
   [junit4]   2> 1866957 INFO  (qtp9356021-26457) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1866957 INFO  (qtp9356021-26457) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1866957 INFO  (qtp9356021-26457) [    ] o.a.s.c.SyncStrategy 
Sync replicas to https://127.0.0.1:45109/snjn/ti/collection1_shard1_replica_n0/
   [junit4]   2> 1866957 INFO  (qtp9356021-26457) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1866957 INFO  (qtp9356021-26457) [    ] o.a.s.c.SyncStrategy 
https://127.0.0.1:45109/snjn/ti/collection1_shard1_replica_n0/ has no replicas
   [junit4]   2> 1866957 INFO  (qtp9356021-26457) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 1866958 INFO  (qtp9356021-26457) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:45109/snjn/ti/collection1_shard1_replica_n0/ shard1
   [junit4]   2> 1867108 INFO  (qtp9356021-26457) [    ] o.a.s.c.ZkController I 
am the leader, no recovery necessary
   [junit4]   2> 1867109 INFO  (qtp9356021-26457) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n0&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1313
   [junit4]   2> 1867110 INFO  (qtp9356021-26450) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:45109_snjn%252Fti&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2}
 status=0 QTime=1318
   [junit4]   2> 1867174 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-3-001
 of type NRT
   [junit4]   2> 1867175 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1867176 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@f82a26{/snjn/ti,null,AVAILABLE}
   [junit4]   2> 1867176 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1d108f9{SSL,[ssl, 
http/1.1]}{127.0.0.1:༣༣༨༠༩}
   [junit4]   2> 1867176 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.Server Started @༡༨༦༨༦༨༦ms
   [junit4]   2> 1867176 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/snjn/ti, 
solrconfig=solrconfig.xml, 
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/tempDir-001/jetty3,
 hostPort=33809, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-3-001/cores}
   [junit4]   2> 1867176 ERROR 
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1867176 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1867176 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1867176 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1867177 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-07-13T06:22:52.889005Z
   [junit4]   2> 1867178 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1867178 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-3-001/solr.xml
   [junit4]   2> 1867180 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1867182 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34361/solr
   [junit4]   2> 1867185 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 1867186 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1867186 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:33809_snjn%2Fti
   [junit4]   2> 1867187 INFO  (zkCallback-5903-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1867187 INFO  (zkCallback-5885-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1867187 INFO  (zkCallback-5909-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1867187 INFO  (zkCallback-5892-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1867187 INFO  (zkCallback-5897-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 1867240 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1867244 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1867244 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1867245 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-3-001/cores
   [junit4]   2> 1867266 INFO  (qtp9356021-26455) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:33809_snjn%252Fti&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1867267 INFO  
(OverseerCollectionConfigSetProcessor-98299213694435333-127.0.0.1:42765_snjn%2Fti-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000006 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1867267 INFO  (OverseerThreadFactory-7997-thread-5) [    ] 
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:33809_snjn%2Fti for creating 
new replica
   [junit4]   2> 1867299 INFO  (qtp27702682-26479) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n1&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1867299 INFO  (qtp27702682-26479) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1868310 INFO  (qtp27702682-26479) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1868321 INFO  (qtp27702682-26479) [    ] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n1] Schema name=test
   [junit4]   2> 1868422 INFO  (qtp27702682-26479) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1868444 INFO  (qtp27702682-26479) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard2_replica_n1' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 1868445 INFO  (qtp27702682-26479) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard2.replica_n1' (registry 
'solr.core.collection1.shard2.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1868445 INFO  (qtp27702682-26479) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1868445 INFO  (qtp27702682-26479) [    ] o.a.s.c.SolrCore 
[[collection1_shard2_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-3-001/cores/collection1_shard2_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-3-001/cores/collection1_shard2_replica_n1/data/]
   [junit4]   2> 1868447 INFO  (qtp27702682-26479) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=6.595703125, 
floorSegmentMB=1.654296875, forceMergeDeletesPctAllowed=20.900986519861533, 
segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1868466 WARN  (qtp27702682-26479) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, registerPath=/solr,/v2, 
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 1868508 INFO  (qtp27702682-26479) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1868508 INFO  (qtp27702682-26479) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1868509 INFO  (qtp27702682-26479) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1868509 INFO  (qtp27702682-26479) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1868510 INFO  (qtp27702682-26479) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8591252144185914]
   [junit4]   2> 1868510 INFO  (qtp27702682-26479) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@eb0011[collection1_shard2_replica_n1] main]
   [junit4]   2> 1868511 INFO  (qtp27702682-26479) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1868511 INFO  (qtp27702682-26479) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1868511 INFO  (qtp27702682-26479) [    ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1868512 INFO  (qtp27702682-26479) [    ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1868512 INFO  (qtp27702682-26479) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1868512 INFO  (qtp27702682-26479) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1572787426923905024
   [junit4]   2> 1868513 INFO  (searcherExecutor-8033-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n1] Registered new searcher 
Searcher@eb0011[collection1_shard2_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1868514 INFO  (qtp27702682-26479) [    ] o.a.s.c.ZkController 
Core needs to recover:collection1_shard2_replica_n1
   [junit4]   2> 1868514 INFO  (updateExecutor-5906-thread-1) [    ] 
o.a.s.u.DefaultSolrCoreState Running recovery
   [junit4]   2> 1868514 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Starting recovery process. recoveringAfterStartup=true
   [junit4]   2> 1868515 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.c.RecoveryStrategy ###### startupVersions=[[]]
   [junit4]   2> 1868515 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Begin buffering updates. 
core=[collection1_shard2_replica_n1]
   [junit4]   2> 1868515 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE, 
tlog=null}
   [junit4]   2> 1868515 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Publishing state of core 
[collection1_shard2_replica_n1] as recovering, leader is 
[https://127.0.0.1:39575/snjn/ti/collection1_shard2_replica_n0/] and I am 
[https://127.0.0.1:33809/snjn/ti/collection1_shard2_replica_n1/]
   [junit4]   2> 1868515 INFO  (qtp27702682-26479) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n1&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1216
   [junit4]   2> 1868516 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Sending prep recovery command to 
[https://127.0.0.1:39575/snjn/ti]; [WaitForState: 
action=PREPRECOVERY&core=collection1_shard2_replica_n0&nodeName=127.0.0.1:33809_snjn%252Fti&coreNodeName=core_node3&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
   [junit4]   2> 1868516 INFO  (qtp9356021-26455) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:33809_snjn%252Fti&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2}
 status=0 QTime=1249
   [junit4]   2> 1868518 INFO  (qtp735392-26427) [    ] 
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node3, state: 
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true, 
maxTime: 183 s
   [junit4]   2> 1868518 INFO  (qtp735392-26427) [    ] 
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1, 
shard=shard2, thisCore=collection1_shard2_replica_n0, 
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, 
currentState=down, localState=active, nodeName=127.0.0.1:33809_snjn%2Fti, 
coreNodeName=core_node3, onlyIfActiveCheckResult=false, nodeProps: 
core_node3:{"core":"collection1_shard2_replica_n1","base_url":"https://127.0.0.1:33809/snjn/ti","node_name":"127.0.0.1:33809_snjn%2Fti","state":"down","type":"NRT"}
   [junit4]   2> 1868577 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-4-001
 of type NRT
   [junit4]   2> 1868577 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1868578 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3f6f3d{/snjn/ti,null,AVAILABLE}
   [junit4]   2> 1868578 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1b8166d{SSL,[ssl, 
http/1.1]}{127.0.0.1:༤༤༤༢༥}
   [junit4]   2> 1868578 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.Server Started @༡༨༧༠༠༨༨ms
   [junit4]   2> 1868578 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/snjn/ti, 
solrconfig=solrconfig.xml, 
solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/tempDir-001/jetty4,
 hostPort=44425, 
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-4-001/cores}
   [junit4]   2> 1868579 ERROR 
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1868579 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
8.0.0
   [junit4]   2> 1868579 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1868579 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 1868579 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-07-13T06:22:54.291290Z
   [junit4]   2> 1868580 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15d3a9d31f50011, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 1868580 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in 
ZooKeeper)
   [junit4]   2> 1868581 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-4-001/solr.xml
   [junit4]   2> 1868582 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 1868584 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34361/solr
   [junit4]   2> 1868588 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 1868589 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1868589 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:44425_snjn%2Fti
   [junit4]   2> 1868590 INFO  (zkCallback-5897-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1868590 INFO  (zkCallback-5903-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1868590 INFO  (zkCallback-5892-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1868590 INFO  (zkCallback-5909-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1868590 INFO  (zkCallback-5885-thread-2) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1868590 INFO  (zkCallback-5916-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
   [junit4]   2> 1868724 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1868728 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1868728 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1868729 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-4-001/cores
   [junit4]   2> 1868756 INFO  (qtp9356021-26456) [    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params 
node=127.0.0.1:44425_snjn%252Fti&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1868757 INFO  (OverseerThreadFactory-7997-thread-5) [    ] 
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:44425_snjn%2Fti for creating 
new replica
   [junit4]   2> 1868757 INFO  
(OverseerCollectionConfigSetProcessor-98299213694435333-127.0.0.1:42765_snjn%2Fti-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000008 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1868785 INFO  (qtp9500595-26512) [    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n1&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 1868786 INFO  (qtp9500595-26512) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 
transient cores
   [junit4]   2> 1869518 INFO  (qtp735392-26427) [    ] 
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1, 
shard=shard2, thisCore=collection1_shard2_replica_n0, 
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, 
currentState=recovering, localState=active, nodeName=127.0.0.1:33809_snjn%2Fti, 
coreNodeName=core_node3, onlyIfActiveCheckResult=false, nodeProps: 
core_node3:{"core":"collection1_shard2_replica_n1","base_url":"https://127.0.0.1:33809/snjn/ti","node_name":"127.0.0.1:33809_snjn%2Fti","state":"recovering","type":"NRT"}
   [junit4]   2> 1869518 INFO  (qtp735392-26427) [    ] 
o.a.s.h.a.PrepRecoveryOp Waited coreNodeName: core_node3, state: recovering, 
checkLive: true, onlyIfLeader: true for: 1 seconds.
   [junit4]   2> 1869518 INFO  (qtp735392-26427) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={nodeName=127.0.0.1:33809_snjn%252Fti&onlyIfLeaderActive=true&core=collection1_shard2_replica_n0&coreNodeName=core_node3&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
 status=0 QTime=1000
   [junit4]   2> 1869828 INFO  (qtp9500595-26512) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1869837 INFO  (qtp9500595-26512) [    ] o.a.s.s.IndexSchema 
[collection1_shard1_replica_n1] Schema name=test
   [junit4]   2> 1869926 INFO  (qtp9500595-26512) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1869932 INFO  (qtp9500595-26512) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard1_replica_n1' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 1869933 INFO  (qtp9500595-26512) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1.shard1.replica_n1' (registry 
'solr.core.collection1.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1869933 INFO  (qtp9500595-26512) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 1869933 INFO  (qtp9500595-26512) [    ] o.a.s.c.SolrCore 
[[collection1_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-4-001/cores/collection1_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/shard-4-001/cores/collection1_shard1_replica_n1/data/]
   [junit4]   2> 1869936 INFO  (qtp9500595-26512) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=25, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=6.595703125, 
floorSegmentMB=1.654296875, forceMergeDeletesPctAllowed=20.900986519861533, 
segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1869956 WARN  (qtp9500595-26512) [    ] 
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = 
requestHandler,name = /dump,class = DumpRequestHandler,attributes = 
{initParams=a, name=/dump, registerPath=/solr,/v2, 
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
   [junit4]   2> 1869986 INFO  (qtp9500595-26512) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1869986 INFO  (qtp9500595-26512) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1869987 INFO  (qtp9500595-26512) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1869987 INFO  (qtp9500595-26512) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1869989 INFO  (qtp9500595-26512) [    ] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=22, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.8591252144185914]
   [junit4]   2> 1869989 INFO  (qtp9500595-26512) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1f01868[collection1_shard1_replica_n1] main]
   [junit4]   2> 1869990 INFO  (qtp9500595-26512) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf1
   [junit4]   2> 1869990 INFO  (qtp9500595-26512) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf1
   [junit4]   2> 1869990 INFO  (qtp9500595-26512) [    ] 
o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at 
/configs/conf1/managed-schema
   [junit4]   2> 1869991 INFO  (qtp9500595-26512) [    ] 
o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
   [junit4]   2> 1869991 INFO  (qtp9500595-26512) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1869992 INFO  (searcherExecutor-8044-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher 
Searcher@1f01868[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1869992 INFO  (qtp9500595-26512) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1572787428475797504
   [junit4]   2> 1869995 INFO  (qtp9500595-26512) [    ] o.a.s.c.ZkController 
Core needs to recover:collection1_shard1_replica_n1
   [junit4]   2> 1869995 INFO  (updateExecutor-5913-thread-1) [    ] 
o.a.s.u.DefaultSolrCoreState Running recovery
   [junit4]   2> 1869995 INFO  (recoveryExecutor-5914-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Starting recovery process. recoveringAfterStartup=true
   [junit4]   2> 1869996 INFO  (recoveryExecutor-5914-thread-1) [    ] 
o.a.s.c.RecoveryStrategy ###### startupVersions=[[]]
   [junit4]   2> 1869996 INFO  (recoveryExecutor-5914-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Begin buffering updates. 
core=[collection1_shard1_replica_n1]
   [junit4]   2> 1869996 INFO  (recoveryExecutor-5914-thread-1) [    ] 
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE, 
tlog=null}
   [junit4]   2> 1869996 INFO  (recoveryExecutor-5914-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Publishing state of core 
[collection1_shard1_replica_n1] as recovering, leader is 
[https://127.0.0.1:45109/snjn/ti/collection1_shard1_replica_n0/] and I am 
[https://127.0.0.1:44425/snjn/ti/collection1_shard1_replica_n1/]
   [junit4]   2> 1869996 INFO  (qtp9500595-26512) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n1&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1210
   [junit4]   2> 1869997 INFO  (qtp9356021-26456) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/collections 
params={node=127.0.0.1:44425_snjn%252Fti&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2}
 status=0 QTime=1241
   [junit4]   2> 1869999 INFO  (recoveryExecutor-5914-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Sending prep recovery command to 
[https://127.0.0.1:45109/snjn/ti]; [WaitForState: 
action=PREPRECOVERY&core=collection1_shard1_replica_n0&nodeName=127.0.0.1:44425_snjn%252Fti&coreNodeName=core_node4&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
   [junit4]   2> 1869999 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1870000 INFO  (qtp9356021-26452) [    ] 
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node4, state: 
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true, 
maxTime: 183 s
   [junit4]   2> 1870002 INFO  (qtp9356021-26452) [    ] 
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1, 
shard=shard1, thisCore=collection1_shard1_replica_n0, 
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, 
currentState=down, localState=active, nodeName=127.0.0.1:44425_snjn%2Fti, 
coreNodeName=core_node4, onlyIfActiveCheckResult=false, nodeProps: 
core_node4:{"core":"collection1_shard1_replica_n1","base_url":"https://127.0.0.1:44425/snjn/ti","node_name":"127.0.0.1:44425_snjn%2Fti","state":"down","type":"NRT"}
   [junit4]   2> ༧ ༡༣, ༢༠༡༧ ༥:༢༢:༥༥ ཕྱི་ཆ་ 
com.carrotsearch.randomizedtesting.RandomizedRunner$QueueUncaughtExceptionsHandler
 uncaughtException
   [junit4]   2> WARNING: Uncaught exception in thread: 
Thread[Thread-4389,5,TGRP-TestBulkSchemaConcurrent]
   [junit4]   2> java.lang.ArrayIndexOutOfBoundsException: 1
   [junit4]   2>        at 
__randomizedtesting.SeedInfo.seed([1723C6458B5156AA]:0)
   [junit4]   2>        at java.base/java.util.ArrayList.add(ArrayList.java:467)
   [junit4]   2>        at java.base/java.util.ArrayList.add(ArrayList.java:479)
   [junit4]   2>        at 
org.apache.solr.schema.TestBulkSchemaConcurrent$1.run(TestBulkSchemaConcurrent.java:89)
   [junit4]   2> 
   [junit4]   2> 1870013 INFO  (qtp9356021-26455) [    ] o.a.s.s.SchemaManager 
managed schema loaded . version : 0 
   [junit4]   2> 1870016 INFO  (qtp735392-26422) [    ] o.a.s.s.SchemaManager 
managed schema loaded . version : 0 
   [junit4]   2> 1870018 INFO  (qtp9356021-26455) [    ] o.a.s.s.IndexSchema 
[collection1_shard1_replica_n0] Schema name=test
   [junit4]   2> 1870019 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Attempting to PeerSync from 
[https://127.0.0.1:39575/snjn/ti/collection1_shard2_replica_n0/] - 
recoveringAfterStartup=[true]
   [junit4]   2> 1870019 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.u.PeerSync PeerSync: core=collection1_shard2_replica_n1 
url=https://127.0.0.1:33809/snjn/ti START 
replicas=[https://127.0.0.1:39575/snjn/ti/collection1_shard2_replica_n0/] 
nUpdates=100
   [junit4]   2> 1870020 INFO  (qtp735392-26422) [    ] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n0] Schema name=test
   [junit4]   2> 1870022 INFO  (qtp735392-26423) [    ] 
o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 
result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=0, 
maxInHash=0, versionsHash=0, numVersions=0, numDocs=0, maxDoc=0}
   [junit4]   2> 1870022 INFO  (qtp735392-26423) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n0]  webapp=/snjn/ti path=/get 
params={distrib=false&qt=/get&getFingerprint=9223372036854775807&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 1870023 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.u.IndexFingerprint IndexFingerprint millis:0.0 
result:{maxVersionSpecified=9223372036854775807, maxVersionEncountered=0, 
maxInHash=0, versionsHash=0, numVersions=0, numDocs=0, maxDoc=0}
   [junit4]   2> 1870023 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.u.PeerSync We are already in sync. No need to do a PeerSync 
   [junit4]   2> 1870023 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1870023 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 1870023 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1870023 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.c.RecoveryStrategy PeerSync stage of recovery was successful.
   [junit4]   2> 1870023 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Replaying updates buffered during PeerSync.
   [junit4]   2> 1870023 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.c.RecoveryStrategy No replay needed.
   [junit4]   2> 1870023 INFO  (recoveryExecutor-5907-thread-1) [    ] 
o.a.s.c.RecoveryStrategy Registering as Active after recovery.
   [junit4]   2> 1870126 INFO  (qtp9356021-26455) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1870138 INFO  (qtp735392-26422) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1870144 INFO  (zkCallback-5916-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected 
type:NodeDataChanged path:/configs/conf1/managed-schema, has occurred - 
updating schema from ZooKeeper ...
   [junit4]   2> 1870144 INFO  (zkCallback-5903-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected 
type:NodeDataChanged path:/configs/conf1/managed-schema, has occurred - 
updating schema from ZooKeeper ...
   [junit4]   2> 1870144 INFO  (qtp9356021-26455) [    ] o.a.s.c.ZkController 
Persisted config data to node /configs/conf1/managed-schema 
   [junit4]   2> 1870144 INFO  (zkCallback-5909-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected 
type:NodeDataChanged path:/configs/conf1/managed-schema, has occurred - 
updating schema from ZooKeeper ...
   [junit4]   2> 1870144 INFO  (zkCallback-5916-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from ZooKeeper
   [junit4]   2> 1870144 INFO  (zkCallback-5885-thread-2) [    ] 
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected 
type:NodeDataChanged path:/configs/conf1/managed-schema, has occurred - 
updating schema from ZooKeeper ...
   [junit4]   2> 1870144 INFO  (zkCallback-5897-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader A schema change: WatchedEvent state:SyncConnected 
type:NodeDataChanged path:/configs/conf1/managed-schema, has occurred - 
updating schema from ZooKeeper ...
   [junit4]   2> 1870145 INFO  (zkCallback-5909-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from ZooKeeper
   [junit4]   2> 1870145 INFO  (zkCallback-5885-thread-2) [    ] 
o.a.s.s.ZkIndexSchemaReader Retrieved schema version 1 from ZooKeeper
   [junit4]   2> 1870146 INFO  (Thread-4396) [    ] o.a.s.c.SolrCore config 
update listener called for core collection1_shard1_replica_n0
   [junit4]   2> 1870146 INFO  (Thread-4396) [    ] o.a.s.c.SolrCore core 
reload collection1_shard1_replica_n0
   [junit4]   2> 1870147 INFO  (zkCallback-5885-thread-2) [    ] 
o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test
   [junit4]   2> 1870148 INFO  (zkCallback-5916-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1_shard1_replica_n1] Schema name=test
   [junit4]   2> 1870148 INFO  (zkCallback-5909-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1_shard2_replica_n1] Schema name=test
   [junit4]   2> 1870168 INFO  (Thread-4398) [    ] o.a.s.c.SolrCore config 
update listener called for core control_collection_shard1_replica_n1
   [junit4]   2> 1870169 INFO  (Thread-4397) [    ] o.a.s.c.SolrCore config 
update listener called for core collection1_shard1_replica_n1
   [junit4]   2> 1870170 INFO  (Thread-4399) [    ] o.a.s.c.SolrCore config 
update listener called for core collection1_shard2_replica_n0
   [junit4]   2> 1870171 INFO  (Thread-4399) [    ] o.a.s.c.SolrCore core 
reload collection1_shard2_replica_n0
   [junit4]   2> 1870172 INFO  (Thread-4398) [    ] o.a.s.c.SolrCore core 
reload control_collection_shard1_replica_n1
   [junit4]   2> 1870174 INFO  (qtp9356021-26455) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 1870178 INFO  (Thread-4397) [    ] o.a.s.c.SolrCore core 
reload collection1_shard1_replica_n1
   [junit4]   2> 1870194 INFO  (Thread-4398) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.0.0
   [junit4]   2> 1870194 INFO  (Thread-4400) [    ] o.a.s.c.SolrCore config 
update listener called for core collection1_shard2_replica_n1
   [junit4]   2> 1870196 INFO  (Thread-4400) [    ] o.a.s.c.SolrCore core 
reload collection1_shard2_replica_n1
   [junit4]   2> 1870199 INFO  (qtp735392-26422) [    ] o.a.s.c.ZkController 
Failed to persist resource at /configs/conf1/managed-schema - old 0 zkVersion= 1
   [junit4]   2> 1870199 INFO  (qtp735392-26422) [    ] o.a.s.s.SchemaManager 
Schema was modified by another node. Retrying..
   [junit4]   2> 1870200 INFO  (qtp735392-26422) [    ] o.a.s.s.SchemaManager 
managed schema loaded . version : 1 
   [junit4]   2> 1870200 INFO  (Thread-4397) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.0.0
   [junit4]   2> 1870201 INFO  (qtp9356021-26455) [    ] o.a.s.s.IndexSchema 
[collection1_shard1_replica_n0] Schema name=test
   [junit4]   2> 1870203 INFO  (Thread-4400) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.0.0
   [junit4]   2> 1870217 INFO  (qtp735392-26422) [    ] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n0] Schema name=test
   [junit4]   2> 1870225 INFO  (Thread-4399) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.0.0
   [junit4]   2> 1870226 INFO  (Thread-4400) [    ] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n1] Schema name=test
   [junit4]   2> 1870225 INFO  (Thread-4397) [    ] o.a.s.s.IndexSchema 
[collection1_shard1_replica_n1] Schema name=test
   [junit4]   2> 1870226 INFO  (Thread-4398) [    ] o.a.s.s.IndexSchema 
[control_collection_shard1_replica_n1] Schema name=test
   [junit4]   2> 1870249 INFO  (Thread-4399) [    ] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n0] Schema name=test
   [junit4]   2> 1870427 INFO  (zkCallback-5885-thread-2) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1870427 INFO  (zkCallback-5885-thread-2) [    ] 
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 281 ms
   [junit4]   2> 1870430 INFO  (Thread-4398) [    ] o.a.s.s.IndexSchema Loaded 
schema test/1.0 with uniqueid field id
   [junit4]   2> 1870461 INFO  (Thread-4398) [    ] o.a.s.c.CoreContainer 
Reloading SolrCore 'control_collection_shard1_replica_n1' using configuration 
from collection control_collection
   [junit4]   2> 1870463 INFO  (zkCallback-5909-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1870463 INFO  (zkCallback-5909-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 318 ms
   [junit4]   2> 1870471 INFO  (qtp735392-26422) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1870476 INFO  (Thread-4398) [    ] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 'solr.core.control_collection.shard1.replica_n1' (registry 
'solr.core.control_collection.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@1d39490
   [junit4]   2> 1870476 INFO  (Thread-4398) [    ] o.a.s.c.SolrCore 
[[control_collection_shard1_replica_n1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/control-001/cores/control_collection_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.schema.TestBulkSchemaConcurrent_1723C6458B5156AA-001/control-001/cores/control_collection_shard1_replica_n1/data/]
   [junit4]   2> 1870478 INFO  (zkCallback-5916-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1870478 INFO  (qtp9356021-26455) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1870478 INFO  (zkCallback-5916-thread-1) [    ] 
o.a.s.s.ZkIndexSchemaReader Finished refreshing schema in 333 ms
   [junit4]   2> 1870480 INFO  (Thread-4400) [    ] o.a.s.s.IndexSchema Loaded 
schema test/1.0 with uniqueid field id
   [junit4]   2> 1870480 INFO  (Thread-4397) [    ] o.a.s.s.IndexSchema Loaded 
schema test/1.0 with uniqueid field id
   [junit4]   2> 1870

[...truncated too long message...]

Connector@1b8166d{SSL,[ssl, http/1.1]}{127.0.0.1:༠}
   [junit4]   2> 1876348 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3f6f3d{/snjn/ti,null,UNAVAILABLE}
   [junit4]   2> 1876349 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ChaosMonkey monkey: stop jetty! 42765
   [junit4]   2> 1876349 ERROR 
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1876349 INFO  
(TEST-TestBulkSchemaConcurrent.test-seed#[1723C6458B5156AA]) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:34361 34361
   [junit4]   2> 1876381 INFO  (Thread-4342) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:34361 34361
   [junit4]   2> 1876381 WARN  (Thread-4342) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        29      /solr/configs/conf1
   [junit4]   2>        27      /solr/configs/conf1/managed-schema
   [junit4]   2>        7       /solr/aliases.json
   [junit4]   2>        5       /solr/security.json
   [junit4]   2>        4       /solr/collections/collection1/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        7       /solr/clusterstate.json
   [junit4]   2>        7       /solr/clusterprops.json
   [junit4]   2>        3       /solr/configs/conf1/managed-schema
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        7       /solr/live_nodes
   [junit4]   2>        7       /solr/collections
   [junit4]   2>        4       /solr/overseer/queue
   [junit4]   2>        4       /solr/overseer/collection-queue-work
   [junit4]   2> 
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestBulkSchemaConcurrent -Dtests.method=test 
-Dtests.seed=1723C6458B5156AA -Dtests.multiplier=3 -Dtests.slow=true 
-Dtests.locale=dz -Dtests.timezone=Pacific/Efate -Dtests.asserts=true 
-Dtests.file.encoding=UTF-8
   [junit4] ERROR   15.3s J0 | TestBulkSchemaConcurrent.test <<<
   [junit4]    > Throwable #1: 
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught 
exception in thread: Thread[id=26549, name=Thread-4389, state=RUNNABLE, 
group=TGRP-TestBulkSchemaConcurrent]
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([1723C6458B5156AA:9F77F99F25AD3B52]:0)
   [junit4]    > Caused by: java.lang.ArrayIndexOutOfBoundsException: 1
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([1723C6458B5156AA]:0)
   [junit4]    >        at java.base/java.util.ArrayList.add(ArrayList.java:467)
   [junit4]    >        at java.base/java.util.ArrayList.add(ArrayList.java:479)
   [junit4]    >        at 
org.apache.solr.schema.TestBulkSchemaConcurrent$1.run(TestBulkSchemaConcurrent.java:89)
   [junit4]   2> 1876384 INFO  
(SUITE-TestBulkSchemaConcurrent-seed#[1723C6458B5156AA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ------------------------------------------------------- 
Done waiting for tracked resources to be released
   [junit4]   2> Jul 13, 2017 6:23:02 AM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=367, maxMBSortInHeap=7.347757680351162, 
sim=RandomSimilarity(queryNorm=false): {}, locale=dz, timezone=Pacific/Efate
   [junit4]   2> NOTE: Linux 4.10.0-26-generic i386/Oracle Corporation 9 
(32-bit)/cpus=8,threads=1,free=105718080,total=514076672
   [junit4]   2> NOTE: All tests run in this JVM: [TestMergePolicyConfig, 
TestLegacyNumericRangeQueryBuilder, RequestHandlersTest, TestSolrCoreParser, 
TestMaxTokenLenTokenizer, CurrencyFieldTypeTest, PluginInfoTest, 
MoveReplicaHDFSUlogDirTest, DocumentAnalysisRequestHandlerTest, 
TestWordDelimiterFilterFactory, EchoParamsTest, TestStressLucene, 
TestBackupRepositoryFactory, VMParamsZkACLAndCredentialsProvidersTest, 
NodeMutatorTest, TestMinMaxOnMultiValuedField, TestFastOutputStream, 
ReplicationFactorTest, DistribDocExpirationUpdateProcessorTest, 
BadCopyFieldTest, ReplicaListTransformerTest, VersionInfoTest, 
BasicDistributedZkTest, TestSimpleQParserPlugin, TestLocalFSCloudBackupRestore, 
FieldMutatingUpdateProcessorTest, BlockJoinFacetSimpleTest, 
TestImpersonationWithHadoopAuth, DefaultValueUpdateProcessorTest, 
TestSolrCoreSnapshots, TestEmbeddedSolrServerConstructors, 
SpellCheckCollatorTest, CreateCollectionCleanupTest, SolrCloudReportersTest, 
DeleteLastCustomShardedReplicaTest, CursorMarkTest, HLLSerializationTest, 
TestExtendedDismaxParser, RecoveryAfterSoftCommitTest, EnumFieldTest, 
TestPHPSerializedResponseWriter, DistributedExpandComponentTest, 
TestSubQueryTransformer, MigrateRouteKeyTest, TestCryptoKeys, 
TestTolerantUpdateProcessorRandomCloud, SpellingQueryConverterTest, 
TestLRUStatsCache, TestNumericTokenStream, OutputWriterTest, 
TestAnalyzeInfixSuggestions, ChaosMonkeySafeLeaderWithPullReplicasTest, 
WordBreakSolrSpellCheckerTest, CdcrRequestHandlerTest, TestStressUserVersions, 
TestMultiValuedNumericRangeQuery, XmlUpdateRequestHandlerTest, AssignTest, 
HdfsChaosMonkeySafeLeaderTest, SuggestComponentContextFilterQueryTest, 
TestBinaryField, TestSolrDeletionPolicy1, TestClusterStateMutator, TestConfig, 
DataDrivenBlockJoinTest, TestSolrConfigHandlerConcurrent, SuggesterWFSTTest, 
TestSchemaNameResource, TestWriterPerf, ResponseHeaderTest, 
BinaryUpdateRequestHandlerTest, BlockDirectoryTest, TestCSVLoader, 
TestSchemaManager, TestRawTransformer, CoreMergeIndexesAdminHandlerTest, 
TestDistribIDF, TestNestedDocsSort, LeaderFailureAfterFreshStartTest, 
TestNumericTerms32, TestManagedSchemaAPI, BasicZkTest, CursorPagingTest, 
TestIndexingPerformance, TestCustomStream, TestManagedStopFilterFactory, 
TestLegacyFieldReuse, TestSolrQueryParser, 
TestSolrCloudWithSecureImpersonation, PeerSyncTest, 
TolerantUpdateProcessorTest, UpdateParamsTest, IndexBasedSpellCheckerTest, 
TestDownShardTolerantSearch, TestGraphTermsQParserPlugin, MBeansHandlerTest, 
DistributedQueryElevationComponentTest, MetricUtilsTest, 
RAMDirectoryFactoryTest, TestReplicationHandlerBackup, TestBadConfig, 
CloudExitableDirectoryReaderTest, TestCustomSort, 
LeaderElectionIntegrationTest, HighlighterConfigTest, 
TestSchemaVersionResource, TestComponentsName, TestFieldResource, 
TestSolr4Spatial, MetricsConfigTest, TestConfigSetProperties, 
TestUnifiedSolrHighlighter, DebugComponentTest, SynonymTokenizerTest, 
TestJsonRequest, SSLMigrationTest, TestLeaderElectionWithEmptyReplica, 
SyncSliceTest, TestFaceting, WrapperMergePolicyFactoryTest, 
OpenCloseCoreStressTest, OverseerTest, ClusterStateUpdateTest, 
TestRandomFaceting, LeaderElectionTest, TestRandomDVFaceting, 
TestDistributedGrouping, TestRecovery, DistributedSpellCheckComponentTest, 
HardAutoCommitTest, DistributedTermsComponentTest, SolrCoreTest, 
TestGroupingSearch, QueryElevationComponentTest, TestSort, TestFunctionQuery, 
TestLazyCores, SoftAutoCommitTest, TermVectorComponentTest, 
FastVectorHighlighterTest, TestJmxIntegration, TestCSVResponseWriter, 
UniqFieldsUpdateProcessorFactoryTest, TestQuerySenderListener, 
AlternateDirectoryTest, TestSolrIndexConfig, TestQuerySenderNoQuery, 
CopyFieldTest, SolrIndexConfigTest, TestStressRecovery, 
ExternalFileFieldSortTest, TestPhraseSuggestions, TestCodecSupport, 
TestLMJelinekMercerSimilarityFactory, ScriptEngineTest, DateMathParserTest, 
PreAnalyzedFieldTest, TestSystemIdResolver, TestSuggestSpellingConverter, 
ClusterStateTest, TestSolrJ, TestLRUCache, TestUtils, TestDocumentBuilder, 
ZkNodePropsTest, SliceStateTest, SystemInfoHandlerTest, UUIDFieldTest, 
FileUtilsTest, CircularListTest, DistributedMLTComponentTest, 
DistributedIntervalFacetingTest, TestEmbeddedSolrServerSchemaAPI, 
ConnectionReuseTest, CdcrReplicationDistributedZkTest, 
ChaosMonkeyNothingIsSafeWithPullReplicasTest, DeleteInactiveReplicaTest, 
DeleteShardTest, DistributedQueueTest, DocValuesNotIndexedTest, 
ForceLeaderTest, SharedFSAutoReplicaFailoverTest, 
SimpleCollectionCreateDeleteTest, SolrCLIZkUtilsTest, SolrCloudExampleTest, 
TestCloudPivotFacet, TestClusterProperties, TestConfigSetsAPI, 
TestOnReconnectListenerSupport, TestPrepRecovery, TestRandomFlRTGCloud, 
TestRebalanceLeaders, TestSizeLimitedDistributedMap, TestStressLiveNodes, 
TestTolerantUpdateProcessorCloud, HdfsBasicDistributedZk2Test, 
HdfsBasicDistributedZkTest, HdfsCollectionsAPIDistributedZkTest, 
HdfsNNFailoverTest, HdfsRecoverLeaseTest, HdfsSyncSliceTest, 
HdfsUnloadDistributedZkTest, HdfsWriteToMultipleCollectionsTest, 
ZkStateReaderTest, ZkStateWriterTest, ImplicitSnitchTest, RuleEngineTest, 
RulesTest, TestInfoStreamLogging, TestNRTOpen, TestReloadAndDeleteDocs, 
TestShardHandlerFactory, TestSolrConfigHandler, TestSolrXml, 
RequestLoggingTest, SearchHandlerTest, TestBlobHandler, TestSQLHandler, 
TestApiFramework, TestConfigsApi, TestCoreAdminApis, 
DistributedDebugComponentTest, DistributedFacetPivotSmallAdvancedTest, 
FacetPivotSmallTest, ShufflingReplicaListTransformerTest, 
SpatialHeatmapFacetsTest, SolrJmxReporterTest, SolrSlf4jReporterTest, 
TestStreamBody, TestMacroExpander, TestMacros, SmileWriterTest, 
TestCustomDocTransformer, TestExportWriter, TestGeoJSONResponseWriter, 
TestJavabinTupleStreamParser, TestSolrQueryResponse, TestChildDocTransformer, 
TestSubQueryTransformerCrossCore, TestManagedResource, 
TestManagedResourceStorage, TestRestManager, TestBulkSchemaAPI, 
TestClassNameShortening, TestCopyFieldCollectionResource, 
TestDynamicFieldCollectionResource, TestDynamicFieldResource, 
TestFieldCollectionResource, TestFieldTypeResource, 
TestSchemaSimilarityResource, TestUniqueKeyFieldResource, 
TestManagedSynonymFilterFactory, TestManagedSynonymGraphFilterFactory, 
BooleanFieldTest, DateRangeFieldTest, TestBulkSchemaConcurrent]
   [junit4] Completed [656/728 (1!)] on J0 in 16.43s, 1 test, 1 error <<< 
FAILURES!

[...truncated 36663 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to