Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/576/
Java: 64bit/jdk-9 -XX:-UseCompressedOops -XX:+UseParallelGC
--illegal-access=deny
1 tests failed.
FAILED: org.apache.solr.store.hdfs.HdfsDirectoryTest.testEOF
Error Message:
Stack Trace:
java.lang.NullPointerException
at
__randomizedtesting.SeedInfo.seed([E59A0BD1AF7D7725:74F149D9ED59D159]:0)
at
org.apache.lucene.store.RAMInputStream.readByte(RAMInputStream.java:69)
at
org.apache.solr.store.hdfs.HdfsDirectoryTest.testEof(HdfsDirectoryTest.java:158)
at
org.apache.solr.store.hdfs.HdfsDirectoryTest.testEOF(HdfsDirectoryTest.java:150)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Build Log:
[...truncated 13201 lines...]
[junit4] Suite: org.apache.solr.store.hdfs.HdfsDirectoryTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/init-core-data-001
[junit4] 2> 1636847 WARN
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 1636847 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1636848 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-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> 1636848 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 1636928 WARN
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ]
o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 1636933 WARN
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 1636935 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log
jetty-6.1.x
[junit4] 2> 1636939 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log Extract
jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/hdfs
to ./temp/Jetty_localhost_localdomain_45125_hdfs____d7oxd9/webapp
[junit4] 2> 1637013 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost.localdomain:45125
[junit4] 2> 1637071 WARN
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 1637072 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log
jetty-6.1.x
[junit4] 2> 1637076 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log Extract
jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_46711_datanode____.i9qbic/webapp
[junit4] 2> 1637146 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:46711
[junit4] 2> 1637169 WARN
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 1637170 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log
jetty-6.1.x
[junit4] 2> 1637172 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log Extract
jar:file:/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.4-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_32877_datanode____9symrk/webapp
[junit4] 2> 1637232 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:32877
[junit4] 2> 1637240 ERROR (DataNode:
[[[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data1/,
[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data2/]]
heartbeating to localhost.localdomain/127.0.0.1:42277) [ ]
o.a.h.h.s.d.DirectoryScanner
dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1
ms/sec. Assuming default value of 1000
[junit4] 2> 1637246 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0xc3ec8f21fba33: from storage
DS-d0ea59d8-f8e3-47ec-b0f3-d9ef0b74c0f8 node
DatanodeRegistration(127.0.0.1:34787,
datanodeUuid=142fc76e-66e7-415d-9446-28103de2d1d9, infoPort=39683,
infoSecurePort=0, ipcPort=33353,
storageInfo=lv=-56;cid=testClusterID;nsid=822018429;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 1637246 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0xc3ec8f21fba33: from storage
DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004 node
DatanodeRegistration(127.0.0.1:34787,
datanodeUuid=142fc76e-66e7-415d-9446-28103de2d1d9, infoPort=39683,
infoSecurePort=0, ipcPort=33353,
storageInfo=lv=-56;cid=testClusterID;nsid=822018429;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 1637325 ERROR (DataNode:
[[[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data3/,
[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data4/]]
heartbeating to localhost.localdomain/127.0.0.1:42277) [ ]
o.a.h.h.s.d.DirectoryScanner
dfs.datanode.directoryscan.throttle.limit.ms.per.sec set to value below 1
ms/sec. Assuming default value of 1000
[junit4] 2> 1637328 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0xc3ec8f711b1fa: from storage
DS-c630d304-8042-414b-93cf-754573ba138e node
DatanodeRegistration(127.0.0.1:34715,
datanodeUuid=e52da5de-3df7-40eb-ae0d-ba6224179fd9, infoPort=46775,
infoSecurePort=0, ipcPort=35273,
storageInfo=lv=-56;cid=testClusterID;nsid=822018429;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 1637329 INFO (Block report processor) [ ] BlockStateChange
BLOCK* processReport 0xc3ec8f711b1fa: from storage
DS-dcf05d19-cb2e-4c86-8b1a-7796b5066620 node
DatanodeRegistration(127.0.0.1:34715,
datanodeUuid=e52da5de-3df7-40eb-ae0d-ba6224179fd9, infoPort=46775,
infoSecurePort=0, ipcPort=35273,
storageInfo=lv=-56;cid=testClusterID;nsid=822018429;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 1637367 INFO
(TEST-HdfsDirectoryTest.testWritingAndReadingAFile-seed#[E59A0BD1AF7D7725]) [
] o.a.s.SolrTestCaseJ4 ###Starting testWritingAndReadingAFile
[junit4] 2> 1637386 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-dcf05d19-cb2e-4c86-8b1a-7796b5066620:NORMAL:127.0.0.1:34715|RBW],
ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW]]}
size 0
[junit4] 2> 1637387 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|FINALIZED]]}
size 0
[junit4] 2> 1637396 INFO (IPC Server handler 1 on 42277) [ ]
BlockStateChange BLOCK* addToInvalidates: blk_1073741825_1001 127.0.0.1:34715
127.0.0.1:34787
[junit4] 2> 1637397 INFO
(TEST-HdfsDirectoryTest.testWritingAndReadingAFile-seed#[E59A0BD1AF7D7725]) [
] o.a.s.SolrTestCaseJ4 ###Ending testWritingAndReadingAFile
[junit4] 2> 1637411 INFO
(TEST-HdfsDirectoryTest.testRandomAccessWrites-seed#[E59A0BD1AF7D7725]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testRandomAccessWrites
[junit4] 1> Working on pass [0] contains [false]
[junit4] 2> 1637430 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-d0ea59d8-f8e3-47ec-b0f3-d9ef0b74c0f8:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-dcf05d19-cb2e-4c86-8b1a-7796b5066620:NORMAL:127.0.0.1:34715|RBW]]}
size 0
[junit4] 2> 1637430 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-d0ea59d8-f8e3-47ec-b0f3-d9ef0b74c0f8:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-dcf05d19-cb2e-4c86-8b1a-7796b5066620:NORMAL:127.0.0.1:34715|RBW]]}
size 0
[junit4] 2> 1640053 INFO
(org.apache.hadoop.hdfs.server.blockmanagement.BlockManager$ReplicationMonitor@48cd2dc4)
[ ] BlockStateChange BLOCK* BlockManager: ask 127.0.0.1:34787 to delete
[blk_1073741825_1001]
[junit4] 1> Working on pass [1] contains [false]
[junit4] 2> 1641317 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741827_1003{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|FINALIZED]]}
size 0
[junit4] 2> 1641317 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741827_1003{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|FINALIZED]]}
size 0
[junit4] 1> Working on pass [2] contains [false]
[junit4] 2> 1642045 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741828_1004{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|RBW],
ReplicaUC[[DISK]DS-d0ea59d8-f8e3-47ec-b0f3-d9ef0b74c0f8:NORMAL:127.0.0.1:34787|RBW]]}
size 0
[junit4] 2> 1642048 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741828_1004{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-d0ea59d8-f8e3-47ec-b0f3-d9ef0b74c0f8:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-dcf05d19-cb2e-4c86-8b1a-7796b5066620:NORMAL:127.0.0.1:34715|FINALIZED]]}
size 0
[junit4] 1> Working on pass [3] contains [false]
[junit4] 2> 1642315 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741829_1005{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|RBW],
ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|FINALIZED]]}
size 0
[junit4] 2> 1642315 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741829_1005{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|RBW],
ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|FINALIZED]]}
size 0
[junit4] 2> 1643053 INFO
(org.apache.hadoop.hdfs.server.blockmanagement.BlockManager$ReplicationMonitor@48cd2dc4)
[ ] BlockStateChange BLOCK* BlockManager: ask 127.0.0.1:34715 to delete
[blk_1073741825_1001]
[junit4] 1> Working on pass [4] contains [false]
[junit4] 2> 1644523 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741830_1006{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-dcf05d19-cb2e-4c86-8b1a-7796b5066620:NORMAL:127.0.0.1:34715|RBW]]}
size 0
[junit4] 2> 1644523 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741830_1006{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-dcf05d19-cb2e-4c86-8b1a-7796b5066620:NORMAL:127.0.0.1:34715|RBW],
ReplicaUC[[DISK]DS-d0ea59d8-f8e3-47ec-b0f3-d9ef0b74c0f8:NORMAL:127.0.0.1:34787|FINALIZED]]}
size 0
[junit4] 1> Working on pass [5] contains [false]
[junit4] 2> 1645003 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741831_1007{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|FINALIZED]]}
size 0
[junit4] 2> 1645004 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741831_1007{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|FINALIZED]]}
size 0
[junit4] 1> Working on pass [6] contains [false]
[junit4] 2> 1646379 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741832_1008{UCState=COMMITTED, truncateBlock=null, primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-dcf05d19-cb2e-4c86-8b1a-7796b5066620:NORMAL:127.0.0.1:34715|RBW]]}
size 841791
[junit4] 2> 1646379 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741832_1008 size 841791
[junit4] 1> Working on pass [7] contains [false]
[junit4] 2> 1648312 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741833_1009{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-d0ea59d8-f8e3-47ec-b0f3-d9ef0b74c0f8:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|RBW]]}
size 0
[junit4] 2> 1648312 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741833_1009{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|RBW],
ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|FINALIZED]]}
size 0
[junit4] 1> Working on pass [8] contains [false]
[junit4] 2> 1650165 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741834_1010{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-dcf05d19-cb2e-4c86-8b1a-7796b5066620:NORMAL:127.0.0.1:34715|RBW],
ReplicaUC[[DISK]DS-d0ea59d8-f8e3-47ec-b0f3-d9ef0b74c0f8:NORMAL:127.0.0.1:34787|RBW]]}
size 0
[junit4] 2> 1650165 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741834_1010{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-dcf05d19-cb2e-4c86-8b1a-7796b5066620:NORMAL:127.0.0.1:34715|RBW],
ReplicaUC[[DISK]DS-d0ea59d8-f8e3-47ec-b0f3-d9ef0b74c0f8:NORMAL:127.0.0.1:34787|RBW]]}
size 0
[junit4] 1> Working on pass [9] contains [false]
[junit4] 2> 1650602 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741835_1011{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|FINALIZED]]}
size 0
[junit4] 2> 1650602 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741835_1011{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|FINALIZED]]}
size 0
[junit4] 2> 1652302 INFO
(TEST-HdfsDirectoryTest.testRandomAccessWrites-seed#[E59A0BD1AF7D7725]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testRandomAccessWrites
[junit4] 2> 1652311 INFO
(TEST-HdfsDirectoryTest.testEOF-seed#[E59A0BD1AF7D7725]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testEOF
[junit4] 2> 1652330 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741836_1012{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-d0ea59d8-f8e3-47ec-b0f3-d9ef0b74c0f8:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-dcf05d19-cb2e-4c86-8b1a-7796b5066620:NORMAL:127.0.0.1:34715|RBW]]}
size 0
[junit4] 2> 1652331 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741836_1012 size 1315840
[junit4] 2> 1652331 INFO
(TEST-HdfsDirectoryTest.testEOF-seed#[E59A0BD1AF7D7725]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testEOF
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HdfsDirectoryTest
-Dtests.method=testEOF -Dtests.seed=E59A0BD1AF7D7725 -Dtests.multiplier=3
-Dtests.slow=true -Dtests.locale=en-BW -Dtests.timezone=Etc/Zulu
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 0.03s J2 | HdfsDirectoryTest.testEOF <<<
[junit4] > Throwable #1: java.lang.NullPointerException
[junit4] > at
__randomizedtesting.SeedInfo.seed([E59A0BD1AF7D7725:74F149D9ED59D159]:0)
[junit4] > at
org.apache.lucene.store.RAMInputStream.readByte(RAMInputStream.java:69)
[junit4] > at
org.apache.solr.store.hdfs.HdfsDirectoryTest.testEof(HdfsDirectoryTest.java:158)
[junit4] > at
org.apache.solr.store.hdfs.HdfsDirectoryTest.testEOF(HdfsDirectoryTest.java:150)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at
java.base/java.lang.reflect.Method.invoke(Method.java:564)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 1652343 INFO
(TEST-HdfsDirectoryTest.testRename-seed#[E59A0BD1AF7D7725]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testRename
[junit4] 2> 1652351 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34715 is added to
blk_1073741837_1013{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|FINALIZED]]}
size 0
[junit4] 2> 1652351 INFO (Block report processor) [ ] BlockStateChange
BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34787 is added to
blk_1073741837_1013{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-55f7e5cf-4ab2-4815-bc3b-a94e8f288004:NORMAL:127.0.0.1:34787|RBW],
ReplicaUC[[DISK]DS-c630d304-8042-414b-93cf-754573ba138e:NORMAL:127.0.0.1:34715|FINALIZED]]}
size 0
[junit4] 2> 1652358 INFO (IPC Server handler 6 on 42277) [ ]
BlockStateChange BLOCK* addToInvalidates: blk_1073741837_1013 127.0.0.1:34787
127.0.0.1:34715
[junit4] 2> 1652359 INFO
(TEST-HdfsDirectoryTest.testRename-seed#[E59A0BD1AF7D7725]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testRename
[junit4] 2> 1652359 WARN
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ]
o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
[junit4] 2> 1652379 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log Stopped
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
[junit4] 2> 1652480 WARN (DataNode:
[[[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data3/,
[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data4/]]
heartbeating to localhost.localdomain/127.0.0.1:42277) [ ]
o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager
interrupted
[junit4] 2> 1652480 WARN (DataNode:
[[[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data3/,
[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data4/]]
heartbeating to localhost.localdomain/127.0.0.1:42277) [ ]
o.a.h.h.s.d.DataNode Ending block pool service for: Block pool
BP-1950471810-88.99.242.108-1507527882789 (Datanode Uuid
e52da5de-3df7-40eb-ae0d-ba6224179fd9) service to
localhost.localdomain/127.0.0.1:42277
[junit4] 2> 1652481 WARN
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ]
o.a.h.h.s.d.DirectoryScanner DirectoryScanner: shutdown has been called
[junit4] 2> 1652495 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log Stopped
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
[junit4] 2> 1652596 WARN (DataNode:
[[[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data1/,
[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data2/]]
heartbeating to localhost.localdomain/127.0.0.1:42277) [ ]
o.a.h.h.s.d.IncrementalBlockReportManager IncrementalBlockReportManager
interrupted
[junit4] 2> 1652596 WARN (DataNode:
[[[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data1/,
[DISK]file:/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001/tempDir-001/hdfsBaseDir/data/data2/]]
heartbeating to localhost.localdomain/127.0.0.1:42277) [ ]
o.a.h.h.s.d.DataNode Ending block pool service for: Block pool
BP-1950471810-88.99.242.108-1507527882789 (Datanode Uuid
142fc76e-66e7-415d-9446-28103de2d1d9) service to
localhost.localdomain/127.0.0.1:42277
[junit4] 2> 1652602 INFO
(SUITE-HdfsDirectoryTest-seed#[E59A0BD1AF7D7725]-worker) [ ] o.m.log Stopped
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost.localdomain:0
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J2/temp/solr.store.hdfs.HdfsDirectoryTest_E59A0BD1AF7D7725-001
[junit4] 2> Oct 09, 2017 5:44:58 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 66 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=1521, maxMBSortInHeap=6.6903162663104165,
sim=RandomSimilarity(queryNorm=true): {}, locale=en-BW, timezone=Etc/Zulu
[junit4] 2> NOTE: Linux 4.10.0-33-generic amd64/Oracle Corporation 9
(64-bit)/cpus=8,threads=2,free=77539224,total=516423680
[junit4] 2> NOTE: All tests run in this JVM: [SubstringBytesRefFilterTest,
TestSolrQueryResponse, PingRequestHandlerTest, TestTrackingShardHandlerFactory,
TestIndexSearcher, TestRuleBasedAuthorizationPlugin,
DistributedFacetPivotLongTailTest, MoveReplicaHDFSTest,
ExitableDirectoryReaderTest, ReturnFieldsTest, SolrXmlInZkTest,
TestSolrCoreSnapshots, ConnectionManagerTest, TestDistribIDF,
DeleteReplicaTest, BaseCdcrDistributedZkTest,
TlogReplayBufferedWhileIndexingTest, DocumentBuilderTest,
TestSolrConfigHandlerConcurrent, TestFoldingMultitermQuery,
TestConfigSetProperties, TestLeaderElectionWithEmptyReplica,
BlockJoinFacetSimpleTest, TestXmlQParserPlugin, TestLegacyFieldCache,
DeleteInactiveReplicaTest, TestClassicSimilarityFactory,
TestSolrCloudWithDelegationTokens, TestRecovery, DistributedQueueTest,
TestStreamBody, ZkFailoverTest, FastVectorHighlighterTest,
DistribCursorPagingTest, CursorMarkTest, CopyFieldTest,
DistributedSuggestComponentTest, TestCustomStream, ReplicaListTransformerTest,
ShardSplitTest, BJQParserTest, TestUninvertingReader,
TestReplicationHandlerBackup, HdfsBasicDistributedZk2Test,
WrapperMergePolicyFactoryTest, TestSolrConfigHandler,
PKIAuthenticationIntegrationTest, LeaderElectionTest, DocValuesMissingTest,
PreAnalyzedFieldManagedSchemaCloudTest, TermVectorComponentDistributedTest,
UniqFieldsUpdateProcessorFactoryTest, UpdateLogTest, CollectionsAPISolrJTest,
TestManagedSchemaAPI, StatsReloadRaceTest, TestMultiWordSynonyms,
TestInfoStreamLogging, TestUniqueKeyFieldResource, TestGraphMLResponseWriter,
NumericFieldsTest, TestQueryUtils, TestOnReconnectListenerSupport,
TestCollationFieldDocValues, V2StandaloneTest, TestManagedResourceStorage,
TestMinMaxOnMultiValuedField, ForceLeaderTest, TestRecoveryHdfs,
PeerSyncReplicationTest, ReplaceNodeTest, TestReversedWildcardFilterFactory,
TestMultiValuedNumericRangeQuery, SuggesterTest, TestCryptoKeys,
OverriddenZkACLAndCredentialsProvidersTest, DateFieldTest,
PrimitiveFieldTypeTest, TestLRUStatsCache, TestTrie, RollingRestartTest,
TestLegacyFieldReuse, TestRebalanceLeaders, CollectionStateFormat2Test,
HdfsSyncSliceTest, PreAnalyzedUpdateProcessorTest, TestNumericTokenStream,
ConfigureRecoveryStrategyTest, TestRandomCollapseQParserPlugin,
TestSimpleQParserPlugin, JSONWriterTest, TestFastWriter,
TestEmbeddedSolrServerConstructors, TestPayloadCheckQParserPlugin,
BasicDistributedZk2Test, ShowFileRequestHandlerTest, TestJmxIntegration,
SuggestComponentContextFilterQueryTest, SortByFunctionTest, TestReload,
TestSchemaSimilarityResource, HdfsDirectoryTest]
[junit4] Completed [500/734 (1!)] on J2 in 25.72s, 4 tests, 1 error <<<
FAILURES!
[...truncated 40538 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
