Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Windows/330/ Java: 64bit/jdk1.8.0_144 -XX:+UseCompressedOops -XX:+UseSerialGC
3 tests failed. FAILED: junit.framework.TestSuite.org.apache.lucene.store.TestMultiMMap Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\tempDir-006: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\tempDir-006 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testImplementations-006: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testImplementations-006 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testSeekZero-007: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testSeekZero-007 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\tempDir-006: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\tempDir-006 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testImplementations-006: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testImplementations-006 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testSeekZero-007: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testSeekZero-007 at __randomizedtesting.SeedInfo.seed([D4B5C86CD2D0FF53]:0) at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java: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.lang.Thread.run(Thread.java:748) FAILED: junit.framework.TestSuite.org.apache.solr.analytics.value.CastingBooleanValueTest Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001\init-core-data-001: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001\init-core-data-001 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001\init-core-data-001: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001\init-core-data-001 C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001 at __randomizedtesting.SeedInfo.seed([CEA754D47C3F832F]:0) at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java: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.lang.Thread.run(Thread.java:748) FAILED: junit.framework.TestSuite.org.apache.solr.search.join.GraphQueryTest Error Message: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001\tlog: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001\tlog C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001\tlog: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001\tlog C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001 at __randomizedtesting.SeedInfo.seed([54ECD0B74A43AACC]:0) at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:216) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java: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.lang.Thread.run(Thread.java:748) Build Log: [...truncated 305 lines...] [junit4] Suite: org.apache.lucene.store.TestMultiMMap [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {docid=BlockTreeOrds(blocksize=128), junk=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{}, maxPointsInLeafNode=1185, maxMBSortInHeap=6.452693052173814, sim=RandomSimilarity(queryNorm=false): {}, locale=ar-LY, timezone=America/Cayenne [junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=3,threads=1,free=72723456,total=97386496 [junit4] 2> NOTE: All tests run in this JVM: [TestSynonymQuery, TestGeoEncodingUtils, TestConsistentFieldNumbers, TestMergePolicyWrapper, TestIntArrayDocIdSet, TestIndexWriterDeleteByQuery, TestDemoParallelLeafReader, TestComplexExplanations, TestForceMergeForever, TestTerm, TestCodecs, TestPrefixRandom, TestOmitPositions, TestSegmentReader, TestBlockPostingsFormat2, TestDoubleValuesSource, TestTimeLimitingCollector, TestQueryRescorer, TestCodecUtil, TestIOUtils, TestMultiMMap] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestMultiMMap -Dtests.seed=D4B5C86CD2D0FF53 -Dtests.slow=true -Dtests.locale=ar-LY -Dtests.timezone=America/Cayenne -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 0.00s J0 | TestMultiMMap (suite) <<< [junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts): [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\tempDir-006: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\tempDir-006 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testImplementations-006: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testImplementations-006 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testSeekZero-007: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\lucene\build\core\test\J0\temp\lucene.store.TestMultiMMap_D4B5C86CD2D0FF53-001\testSeekZero-007 [junit4] > at __randomizedtesting.SeedInfo.seed([D4B5C86CD2D0FF53]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] Completed [26/458 (1!)] on J0 in 3.63s, 54 tests, 1 error <<< FAILURES! [...truncated 11425 lines...] [junit4] Suite: org.apache.solr.search.join.GraphQueryTest [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001 [junit4] 2> 326226 WARN (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3 numCloses=3 [junit4] 2> 326226 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 326231 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) [junit4] 2> 326231 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> 326233 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 326234 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 326287 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0 [junit4] 2> 326300 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.s.IndexSchema [null] Schema name=example [junit4] 2> 326345 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id [junit4] 2> 326428 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7bdf8c2a [junit4] 2> 326434 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7bdf8c2a [junit4] 2> 326435 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7bdf8c2a [junit4] 2> 326436 INFO (coreLoadExecutor-825-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 326436 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib, /C:/Users/jenkins/workspace/Lucene-Solr-7.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 326500 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0 [junit4] 2> 326539 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example [junit4] 2> 326602 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid field id [junit4] 2> 326613 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1, trusted=true [junit4] 2> 326613 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@7bdf8c2a [junit4] 2> 326613 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 326614 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\core\src\test-files\solr\collection1], dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001\] [junit4] 2> 326616 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=30, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 326727 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 326727 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 326728 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 326728 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 326730 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=41, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0] [junit4] 2> 326730 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@18fcc277[collection1] main] [junit4] 2> 326731 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers [junit4] 2> 326738 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 326775 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 326775 INFO (searcherExecutor-826-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default [junit4] 2> 326775 INFO (coreLoadExecutor-825-thread-1) [ x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1586059609357942784 [junit4] 2> 326778 INFO (searcherExecutor-826-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct [junit4] 2> 326778 INFO (searcherExecutor-826-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak [junit4] 2> 326778 INFO (searcherExecutor-826-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields [junit4] 2> 326778 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 326778 INFO (searcherExecutor-826-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler [junit4] 2> 326778 INFO (searcherExecutor-826-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external [junit4] 2> 326779 INFO (searcherExecutor-826-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq [junit4] 2> 326780 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testGraph [junit4] 2> 326781 INFO (searcherExecutor-826-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn [junit4] 2> 326782 INFO (searcherExecutor-826-thread-1-processing-x:collection1) [ x:collection1] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict [junit4] 2> 326783 INFO (searcherExecutor-826-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@18fcc277[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 326785 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_1 (1586059609363185664)]} 0 4 [junit4] 2> 326791 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_2 (1586059609374720000)]} 0 0 [junit4] 2> 326791 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609374720001,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326792 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609374720001 [junit4] 2> 326803 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@11ca63a8[collection1] main] [junit4] 2> 326806 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@11ca63a8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):C2)))} [junit4] 2> 326806 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326807 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 14 [junit4] 2> 326810 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_3 (1586059609391497216)]} 0 3 [junit4] 2> 326810 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_4 (1586059609394642944)]} 0 0 [junit4] 2> 326810 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609394642945,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326810 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609394642945 [junit4] 2> 326813 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3b76f6e6[collection1] main] [junit4] 2> 326816 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3b76f6e6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):C2) Uninverting(_1(7.3.0):C2)))} [junit4] 2> 326816 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326816 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5 [junit4] 2> 326819 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_5 (1586059609400934400)]} 0 2 [junit4] 2> 326819 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_6 (1586059609404080128)]} 0 0 [junit4] 2> 326820 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_7 (1586059609405128704)]} 0 0 [junit4] 2> 326821 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_8 (1586059609405128705)]} 0 0 [junit4] 2> 326821 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_9 (1586059609406177280)]} 0 0 [junit4] 2> 326821 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609406177281,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326821 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609406177281 [junit4] 2> 326841 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6a9cf90b[collection1] main] [junit4] 2> 326843 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6a9cf90b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):C2) Uninverting(_1(7.3.0):C2) Uninverting(_2(7.3.0):C5)))} [junit4] 2> 326843 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326843 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 21 [junit4] 2> 326847 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_1 (1586059609429245952)]} 0 3 [junit4] 2> 326847 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_2 (1586059609433440256)]} 0 0 [junit4] 2> 326848 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609434488832,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326848 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609434488832 [junit4] 2> 326852 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5b8028f8[collection1] main] [junit4] 2> 326855 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5b8028f8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.3.0):C2) Uninverting(_2(7.3.0):C5) Uninverting(_3(7.3.0):C2)))} [junit4] 2> 326855 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326856 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6 [junit4] 2> 326858 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_10 (1586059609442877440)]} 0 2 [junit4] 2> 326858 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_11 (1586059609444974592)]} 0 0 [junit4] 2> 326859 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_12 (1586059609446023168)]} 0 0 [junit4] 2> 326859 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_13 (1586059609446023169)]} 0 0 [junit4] 2> 326860 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609447071744,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326860 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609447071744 [junit4] 2> 326865 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@618b8839[collection1] main] [junit4] 2> 326866 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326866 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@618b8839[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.3.0):C2) Uninverting(_2(7.3.0):C5) Uninverting(_3(7.3.0):C2) Uninverting(_4(7.3.0):C4)))} [junit4] 2> 326866 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6 [junit4] 2> 326893 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}}id:doc_1} hits=7 status=0 QTime=26 [junit4] 2> 326894 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_ss&q={!graph+from%3D${edge_id}+to%3D${node_id}+maxDepth%3D1}id:doc_1} hits=3 status=0 QTime=0 [junit4] 2> 326895 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse}id:doc_8} hits=8 status=0 QTime=0 [junit4] 2> 326896 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dfalse}id:doc_8} hits=7 status=0 QTime=0 [junit4] 2> 326898 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+traversalFilter%3D'text:foo11'}id:doc_8} hits=2 status=0 QTime=0 [junit4] 2> 326898 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+maxDepth%3D0}id:doc_8} hits=1 status=0 QTime=0 [junit4] 2> 326899 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+maxDepth%3D1}id:doc_8} hits=3 status=0 QTime=0 [junit4] 2> 326899 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dfalse+maxDepth%3D1}id:doc_8} hits=2 status=0 QTime=0 [junit4] 2> 326900 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dtrue+maxDepth%3D2}id:doc_8} hits=1 status=0 QTime=0 [junit4] 2> 326900 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+maxDepth%3D1}id:doc_1} hits=2 status=0 QTime=0 [junit4] 2> 326901 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+maxDepth%3D1}id:doc_1} hits=1 status=0 QTime=0 [junit4] 2> 326903 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_1 (1586059609490063360)]} 0 1 [junit4] 2> 326904 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_2 (1586059609492160512)]} 0 0 [junit4] 2> 326904 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609493209088,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326904 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609493209088 [junit4] 2> 326907 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@656b2f3c[collection1] main] [junit4] 2> 326907 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326910 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@656b2f3c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.3.0):C2) Uninverting(_2(7.3.0):C5) Uninverting(_4(7.3.0):C4) Uninverting(_5(7.3.0):C2)))} [junit4] 2> 326911 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6 [junit4] 2> 326913 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_3 (1586059609500549120)]} 0 1 [junit4] 2> 326913 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_4 (1586059609502646272)]} 0 0 [junit4] 2> 326914 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609503694848,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326914 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609503694848 [junit4] 2> 326915 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@55907400[collection1] main] [junit4] 2> 326916 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326918 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@55907400[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.3.0):C5) Uninverting(_4(7.3.0):C4) Uninverting(_5(7.3.0):C2) Uninverting(_6(7.3.0):C2)))} [junit4] 2> 326919 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 4 [junit4] 2> 326921 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_5 (1586059609508937728)]} 0 1 [junit4] 2> 326921 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_6 (1586059609511034880)]} 0 0 [junit4] 2> 326922 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_7 (1586059609512083456)]} 0 0 [junit4] 2> 326923 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_8 (1586059609512083457)]} 0 0 [junit4] 2> 326923 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_9 (1586059609513132032)]} 0 0 [junit4] 2> 326923 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609513132033,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326924 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609513132033 [junit4] 2> 326928 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6caf88eb[collection1] main] [junit4] 2> 326930 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326931 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6caf88eb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.3.0):C4) Uninverting(_5(7.3.0):C2) Uninverting(_6(7.3.0):C2) Uninverting(_7(7.3.0):C5)))} [junit4] 2> 326931 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 7 [junit4] 2> 326933 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_1 (1586059609521520640)]} 0 1 [junit4] 2> 326934 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_2 (1586059609524666368)]} 0 0 [junit4] 2> 326934 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609524666369,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326934 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609524666369 [junit4] 2> 326936 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5e8093fe[collection1] main] [junit4] 2> 326937 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326939 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5e8093fe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.3.0):C4) Uninverting(_6(7.3.0):C2) Uninverting(_7(7.3.0):C5) Uninverting(_8(7.3.0):C2)))} [junit4] 2> 326939 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 5 [junit4] 2> 326941 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_10 (1586059609530957824)]} 0 1 [junit4] 2> 326942 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_11 (1586059609533054976)]} 0 0 [junit4] 2> 326943 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_12 (1586059609534103552)]} 0 0 [junit4] 2> 326943 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_13 (1586059609534103553)]} 0 0 [junit4] 2> 326944 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609535152128,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326944 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609535152128 [junit4] 2> 326946 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2dfcaa09[collection1] main] [junit4] 2> 326949 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326950 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2dfcaa09[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(7.3.0):C2) Uninverting(_7(7.3.0):C5) Uninverting(_8(7.3.0):C2) Uninverting(_9(7.3.0):C4)))} [junit4] 2> 326950 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6 [junit4] 2> 326952 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ss&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}}id:doc_1} hits=7 status=0 QTime=0 [junit4] 2> 326953 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ss&edge_id=edge_ss&q={!graph+from%3D${edge_id}+to%3D${node_id}+maxDepth%3D1}id:doc_1} hits=3 status=0 QTime=0 [junit4] 2> 326954 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ss&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse}id:doc_8} hits=8 status=0 QTime=0 [junit4] 2> 326955 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ss&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dfalse}id:doc_8} hits=7 status=0 QTime=0 [junit4] 2> 326956 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ss&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+traversalFilter%3D'text:foo11'}id:doc_8} hits=2 status=0 QTime=0 [junit4] 2> 326957 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ss&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+maxDepth%3D0}id:doc_8} hits=1 status=0 QTime=0 [junit4] 2> 326957 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ss&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+maxDepth%3D1}id:doc_8} hits=3 status=0 QTime=0 [junit4] 2> 326958 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ss&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dfalse+maxDepth%3D1}id:doc_8} hits=2 status=0 QTime=0 [junit4] 2> 326958 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ss&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dtrue+maxDepth%3D2}id:doc_8} hits=1 status=0 QTime=0 [junit4] 2> 326959 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ss&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+maxDepth%3D1}id:doc_1} hits=2 status=0 QTime=0 [junit4] 2> 326959 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ss&edge_id=edge_ss&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+maxDepth%3D1}id:doc_1} hits=1 status=0 QTime=0 [junit4] 2> 326961 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_1 (1586059609550880768)]} 0 1 [junit4] 2> 326962 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_2 (1586059609554026496)]} 0 0 [junit4] 2> 326963 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609555075072,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326963 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609555075072 [junit4] 2> 326965 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@55a53305[collection1] main] [junit4] 2> 326968 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@55a53305[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(7.3.0):C2) Uninverting(_7(7.3.0):C5) Uninverting(_9(7.3.0):C4) Uninverting(_a(7.3.0):C2)))} [junit4] 2> 326968 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326969 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 6 [junit4] 2> 326971 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_3 (1586059609561366528)]} 0 1 [junit4] 2> 326972 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_4 (1586059609564512256)]} 0 0 [junit4] 2> 326972 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609564512257,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326972 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609564512257 [junit4] 2> 326976 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7f487e9f[collection1] main] [junit4] 2> 326979 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 326979 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7f487e9f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_7(7.3.0):C5) Uninverting(_9(7.3.0):C4) Uninverting(_a(7.3.0):C2) Uninverting(_b(7.3.0):C2)))} [junit4] 2> 326980 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 7 [junit4] 2> 326982 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_5 (1586059609572900864)]} 0 2 [junit4] 2> 326983 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_6 (1586059609576046592)]} 0 0 [junit4] 2> 326984 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_7 (1586059609577095168)]} 0 0 [junit4] 2> 326984 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_8 (1586059609577095169)]} 0 0 [junit4] 2> 326985 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_9 (1586059609578143744)]} 0 0 [junit4] 2> 326985 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609578143745,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 326985 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609578143745 [junit4] 2> 326988 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@783b53fb[collection1] main] [junit4] 2> 327001 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327003 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@783b53fb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(7.3.0):C4) Uninverting(_a(7.3.0):C2) Uninverting(_b(7.3.0):C2) Uninverting(_c(7.3.0):C5)))} [junit4] 2> 327006 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 21 [junit4] 2> 327013 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_1 (1586059609602260992)]} 0 5 [junit4] 2> 327013 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_2 (1586059609607503872)]} 0 0 [junit4] 2> 327014 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609608552448,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327014 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609608552448 [junit4] 2> 327024 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7b0793d9[collection1] main] [junit4] 2> 327029 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7b0793d9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_9(7.3.0):C4) Uninverting(_b(7.3.0):C2) Uninverting(_c(7.3.0):C5) Uninverting(_d(7.3.0):C2)))} [junit4] 2> 327032 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327034 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 20 [junit4] 2> 327038 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_10 (1586059609630572544)]} 0 3 [junit4] 2> 327039 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_11 (1586059609634766848)]} 0 0 [junit4] 2> 327040 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_12 (1586059609634766849)]} 0 0 [junit4] 2> 327040 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_13 (1586059609635815424)]} 0 0 [junit4] 2> 327040 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609635815425,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327040 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609635815425 [junit4] 2> 327051 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@28071e82[collection1] main] [junit4] 2> 327056 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@28071e82[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(7.3.0):C2) Uninverting(_c(7.3.0):C5) Uninverting(_d(7.3.0):C2) Uninverting(_e(7.3.0):C4)))} [junit4] 2> 327058 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327059 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 18 [junit4] 2> 327100 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ip&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}}id:doc_1} hits=7 status=0 QTime=41 [junit4] 2> 327102 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ip&edge_id=edge_ips&q={!graph+from%3D${edge_id}+to%3D${node_id}+maxDepth%3D1}id:doc_1} hits=3 status=0 QTime=0 [junit4] 2> 327103 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ip&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse}id:doc_8} hits=8 status=0 QTime=0 [junit4] 2> 327104 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ip&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dfalse}id:doc_8} hits=7 status=0 QTime=0 [junit4] 2> 327105 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ip&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+traversalFilter%3D'text:foo11'}id:doc_8} hits=2 status=0 QTime=1 [junit4] 2> 327105 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ip&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+maxDepth%3D0}id:doc_8} hits=1 status=0 QTime=0 [junit4] 2> 327106 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ip&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+maxDepth%3D1}id:doc_8} hits=3 status=0 QTime=0 [junit4] 2> 327106 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ip&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dfalse+maxDepth%3D1}id:doc_8} hits=2 status=0 QTime=0 [junit4] 2> 327107 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ip&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dtrue+maxDepth%3D2}id:doc_8} hits=1 status=0 QTime=0 [junit4] 2> 327107 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ip&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+maxDepth%3D1}id:doc_1} hits=2 status=0 QTime=0 [junit4] 2> 327107 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ip&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+maxDepth%3D1}id:doc_1} hits=1 status=0 QTime=0 [junit4] 2> 327121 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_1 (1586059609707118592)]} 0 13 [junit4] 2> 327122 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_2 (1586059609721798656)]} 0 0 [junit4] 2> 327123 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609722847232,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327123 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609722847232 [junit4] 2> 327136 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@500131fe[collection1] main] [junit4] 2> 327142 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@500131fe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(7.3.0):C2) Uninverting(_c(7.3.0):C5) Uninverting(_e(7.3.0):C4) Uninverting(_f(7.3.0):C2)))} [junit4] 2> 327144 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327145 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 21 [junit4] 2> 327146 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_3 (1586059609745915904)]} 0 1 [junit4] 2> 327148 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_4 (1586059609749061632)]} 0 1 [junit4] 2> 327148 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609749061633,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327148 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609749061633 [junit4] 2> 327152 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5865007c[collection1] main] [junit4] 2> 327178 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5865007c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_c(7.3.0):C5) Uninverting(_e(7.3.0):C4) Uninverting(_f(7.3.0):C2) Uninverting(_g(7.3.0):C2)))} [junit4] 2> 327180 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327181 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 32 [junit4] 2> 327186 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_5 (1586059609784713216)]} 0 4 [junit4] 2> 327187 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_6 (1586059609788907520)]} 0 0 [junit4] 2> 327187 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_7 (1586059609789956096)]} 0 0 [junit4] 2> 327187 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_8 (1586059609789956097)]} 0 0 [junit4] 2> 327188 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_9 (1586059609791004672)]} 0 0 [junit4] 2> 327188 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609791004673,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327188 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609791004673 [junit4] 2> 327193 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6de108a3[collection1] main] [junit4] 2> 327199 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6de108a3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_e(7.3.0):C4) Uninverting(_f(7.3.0):C2) Uninverting(_g(7.3.0):C2) Uninverting(_h(7.3.0):C5)))} [junit4] 2> 327200 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327201 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 13 [junit4] 2> 327205 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_1 (1586059609805684736)]} 0 3 [junit4] 2> 327207 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_2 (1586059609810927616)]} 0 1 [junit4] 2> 327208 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609811976192,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327208 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609811976192 [junit4] 2> 327216 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@47e21b1b[collection1] main] [junit4] 2> 327233 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@47e21b1b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_e(7.3.0):C4) Uninverting(_g(7.3.0):C2) Uninverting(_h(7.3.0):C5) Uninverting(_i(7.3.0):C2)))} [junit4] 2> 327235 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327239 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 31 [junit4] 2> 327242 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_10 (1586059609844482048)]} 0 2 [junit4] 2> 327247 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_11 (1586059609852870656)]} 0 2 [junit4] 2> 327249 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_12 (1586059609853919232)]} 0 1 [junit4] 2> 327251 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_13 (1586059609857064960)]} 0 1 [junit4] 2> 327252 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609858113536,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327252 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609858113536 [junit4] 2> 327262 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1b47d904[collection1] main] [junit4] 2> 327265 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1b47d904[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_g(7.3.0):C2) Uninverting(_h(7.3.0):C5) Uninverting(_i(7.3.0):C2) Uninverting(_j(7.3.0):C4)))} [junit4] 2> 327266 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327267 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 14 [junit4] 2> 327271 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ips&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}}id:doc_1} hits=7 status=0 QTime=3 [junit4] 2> 327278 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ips&edge_id=edge_ips&q={!graph+from%3D${edge_id}+to%3D${node_id}+maxDepth%3D1}id:doc_1} hits=3 status=0 QTime=6 [junit4] 2> 327280 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ips&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse}id:doc_8} hits=8 status=0 QTime=1 [junit4] 2> 327283 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ips&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dfalse}id:doc_8} hits=7 status=0 QTime=2 [junit4] 2> 327286 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ips&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+traversalFilter%3D'text:foo11'}id:doc_8} hits=2 status=0 QTime=2 [junit4] 2> 327288 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ips&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+maxDepth%3D0}id:doc_8} hits=1 status=0 QTime=1 [junit4] 2> 327289 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ips&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+maxDepth%3D1}id:doc_8} hits=3 status=0 QTime=0 [junit4] 2> 327290 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ips&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dfalse+maxDepth%3D1}id:doc_8} hits=2 status=0 QTime=0 [junit4] 2> 327291 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ips&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dtrue+maxDepth%3D2}id:doc_8} hits=1 status=0 QTime=1 [junit4] 2> 327291 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ips&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+maxDepth%3D1}id:doc_1} hits=2 status=0 QTime=0 [junit4] 2> 327292 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_ips&edge_id=edge_ips&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+maxDepth%3D1}id:doc_1} hits=1 status=0 QTime=0 [junit4] 2> 327320 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_1 (1586059609900056576)]} 0 28 [junit4] 2> 327321 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_2 (1586059609930465280)]} 0 0 [junit4] 2> 327322 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609931513856,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327322 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609931513856 [junit4] 2> 327358 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@42c54e08[collection1] main] [junit4] 2> 327360 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327360 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@42c54e08[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_g(7.3.0):C2) Uninverting(_h(7.3.0):C5) Uninverting(_j(7.3.0):C4) Uninverting(_k(7.3.0):C2)))} [junit4] 2> 327360 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 38 [junit4] 2> 327362 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_3 (1586059609972408320)]} 0 1 [junit4] 2> 327363 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_4 (1586059609973456896)]} 0 0 [junit4] 2> 327363 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609974505472,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327363 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609974505472 [junit4] 2> 327369 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@39422921[collection1] main] [junit4] 2> 327371 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@39422921[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_h(7.3.0):C5) Uninverting(_j(7.3.0):C4) Uninverting(_k(7.3.0):C2) Uninverting(_l(7.3.0):C2)))} [junit4] 2> 327372 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327372 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 8 [junit4] 2> 327373 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_5 (1586059609983942656)]} 0 1 [junit4] 2> 327375 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_6 (1586059609986039808)]} 0 0 [junit4] 2> 327375 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_7 (1586059609987088384)]} 0 0 [junit4] 2> 327376 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_8 (1586059609988136960)]} 0 0 [junit4] 2> 327377 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_9 (1586059609989185536)]} 0 0 [junit4] 2> 327377 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059609989185537,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327377 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059609989185537 [junit4] 2> 327381 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@75978736[collection1] main] [junit4] 2> 327389 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@75978736[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_j(7.3.0):C4) Uninverting(_k(7.3.0):C2) Uninverting(_l(7.3.0):C2) Uninverting(_m(7.3.0):C5)))} [junit4] 2> 327389 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327390 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 12 [junit4] 2> 327391 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_1 (1586059610002817024)]} 0 1 [junit4] 2> 327393 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_2 (1586059610003865600)]} 0 0 [junit4] 2> 327393 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059610005962752,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327393 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059610005962752 [junit4] 2> 327403 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@df8f59a[collection1] main] [junit4] 2> 327406 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@df8f59a[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_j(7.3.0):C4) Uninverting(_l(7.3.0):C2) Uninverting(_m(7.3.0):C5) Uninverting(_n(7.3.0):C2)))} [junit4] 2> 327406 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327411 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 18 [junit4] 2> 327415 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_10 (1586059610024837120)]} 0 3 [junit4] 2> 327416 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_11 (1586059610030080000)]} 0 0 [junit4] 2> 327419 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_12 (1586059610031128576)]} 0 1 [junit4] 2> 327423 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_13 (1586059610036371456)]} 0 1 [junit4] 2> 327424 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059610038468608,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327424 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059610038468608 [junit4] 2> 327429 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@672912cd[collection1] main] [junit4] 2> 327431 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@672912cd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_l(7.3.0):C2) Uninverting(_m(7.3.0):C5) Uninverting(_n(7.3.0):C2) Uninverting(_o(7.3.0):C4)))} [junit4] 2> 327432 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327432 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 7 [junit4] 2> 327438 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_lp&edge_id=edge_lps&q={!graph+from%3D${node_id}+to%3D${edge_id}}id:doc_1} hits=7 status=0 QTime=5 [junit4] 2> 327439 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_lp&edge_id=edge_lps&q={!graph+from%3D${edge_id}+to%3D${node_id}+maxDepth%3D1}id:doc_1} hits=3 status=0 QTime=0 [junit4] 2> 327441 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_lp&edge_id=edge_lps&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse}id:doc_8} hits=8 status=0 QTime=1 [junit4] 2> 327441 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_lp&edge_id=edge_lps&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dfalse}id:doc_8} hits=7 status=0 QTime=0 [junit4] 2> 327442 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_lp&edge_id=edge_lps&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+traversalFilter%3D'text:foo11'}id:doc_8} hits=2 status=0 QTime=0 [junit4] 2> 327442 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_lp&edge_id=edge_lps&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+maxDepth%3D0}id:doc_8} hits=1 status=0 QTime=0 [junit4] 2> 327443 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_lp&edge_id=edge_lps&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dtrue+returnOnlyLeaf%3Dfalse+maxDepth%3D1}id:doc_8} hits=3 status=0 QTime=0 [junit4] 2> 327443 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_lp&edge_id=edge_lps&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dfalse+maxDepth%3D1}id:doc_8} hits=2 status=0 QTime=0 [junit4] 2> 327443 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_lp&edge_id=edge_lps&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+returnOnlyLeaf%3Dtrue+maxDepth%3D2}id:doc_8} hits=1 status=0 QTime=0 [junit4] 2> 327444 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_lp&edge_id=edge_lps&q={!graph+from%3D${node_id}+to%3D${edge_id}+maxDepth%3D1}id:doc_1} hits=2 status=0 QTime=0 [junit4] 2> 327444 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_lp&edge_id=edge_lps&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+maxDepth%3D1}id:doc_1} hits=1 status=0 QTime=0 [junit4] 2> 327447 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_1 (1586059610059440128)]} 0 3 [junit4] 2> 327449 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_2 (1586059610064683008)]} 0 0 [junit4] 2> 327451 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1586059610066780160,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 327452 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4c549337 commitCommandVersion:1586059610066780160 [junit4] 2> 327465 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4014f6ca[collection1] main] [junit4] 2> 327469 INFO (searcherExecutor-826-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4014f6ca[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_l(7.3.0):C2) Uninverting(_m(7.3.0):C5) Uninverting(_o(7.3.0):C4) Uninverting(_p(7.3.0):C2)))} [junit4] 2> 327476 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 327477 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 24 [junit4] 2> 327502 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_3 (1586059610094043136)]} 0 24 [junit4] 2> 327503 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[doc_4 (1586059610120257536)]} 0 0 [junit4] 2> 327503 INFO (TEST-GraphQuer [...truncated too long message...] nlyLeaf%3Dtrue+maxDepth%3D2}id:doc_8} hits=1 status=0 QTime=0 [junit4] 2> 328399 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_sdN&edge_id=edge_sdsN&q={!graph+from%3D${node_id}+to%3D${edge_id}+maxDepth%3D1}id:doc_1} hits=2 status=0 QTime=0 [junit4] 2> 328400 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_sdN&edge_id=edge_sdsN&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+maxDepth%3D1}id:doc_1} hits=1 status=0 QTime=0 [junit4] 2> 328400 INFO (TEST-GraphQueryTest.testGraph-seed#[54ECD0B74A43AACC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testGraph [junit4] 2> 328402 INFO (TEST-GraphQueryTest.testGraphQueryParserValidation-seed#[54ECD0B74A43AACC]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testGraphQueryParserValidation [junit4] 2> 328403 INFO (TEST-GraphQueryTest.testGraphQueryParserValidation-seed#[54ECD0B74A43AACC]) [ ] o.a.s.h.RequestHandlerBase Ignoring exception matching . [junit4] 2> 328403 INFO (TEST-GraphQueryTest.testGraphQueryParserValidation-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_nothere&edge_id=edge_ss&message=field+node_nothere+not+defined+in+schema&errorCode=400&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+maxDepth%3D1}id:doc_1} status=400 QTime=0 [junit4] 2> 328403 INFO (TEST-GraphQueryTest.testGraphQueryParserValidation-seed#[54ECD0B74A43AACC]) [ ] o.a.s.h.RequestHandlerBase Ignoring exception matching . [junit4] 2> 328403 INFO (TEST-GraphQueryTest.testGraphQueryParserValidation-seed#[54ECD0B74A43AACC]) [ ] o.a.s.c.S.Request [collection1] webapp=null path=null params={node_id=node_s&edge_id=edge_notthere&message=field+node_nothere+not+defined+in+schema&errorCode=400&q={!graph+from%3D${node_id}+to%3D${edge_id}+returnRoot%3Dfalse+maxDepth%3D1}id:doc_1} status=400 QTime=0 [junit4] 2> 328403 INFO (TEST-GraphQueryTest.testGraphQueryParserValidation-seed#[54ECD0B74A43AACC]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testGraphQueryParserValidation [junit4] 2> 328403 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> 328403 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=680901851 [junit4] 2> 328403 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 328403 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1d8f5327: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@468063aa [junit4] 2> 328406 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 328406 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@15812ec7: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@2ad2049a [junit4] 2> 328408 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 328408 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@693c6c57: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@2eed8518 [junit4] 2> 328409 INFO (coreCloseExecutor-831-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1a0b0f29 [junit4] 2> 328409 INFO (coreCloseExecutor-831-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=436932393 [junit4] 2> 328409 INFO (coreCloseExecutor-831-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3ec8d620: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@4406b301 [junit4] 2> 328425 INFO (SUITE-GraphQueryTest-seed#[54ECD0B74A43AACC]-worker) [ ] o.a.s.SolrTestCaseJ4 ------------------------------------------------------- Done waiting for tracked resources to be released [junit4] 2> NOTE: test params are: codec=Lucene70, sim=RandomSimilarity(queryNorm=false): {}, locale=ko, timezone=America/Indiana/Vevay [junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=3,threads=1,free=63678944,total=213143552 [junit4] 2> NOTE: All tests run in this JVM: [AddBlockUpdateTest, DistributedSpellCheckComponentTest, RegexBoostProcessorTest, CheckHdfsIndexTest, MigrateRouteKeyTest, TestNumericRangeQuery32, TestPrepRecovery, JavabinLoaderTest, TestSegmentSorting, WordBreakSolrSpellCheckerTest, TestLeaderElectionZkExpiry, TestFilteredDocIdSet, TestCSVResponseWriter, TestSolrCloudWithDelegationTokens, TestConfigSets, NotRequiredUniqueKeyTest, ForceLeaderTest, TestReplicaProperties, DistributedExpandComponentTest, TestRTimerTree, TestReqParamsAPI, TestSchemalessBufferedUpdates, GraphQueryTest] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=GraphQueryTest -Dtests.seed=54ECD0B74A43AACC -Dtests.slow=true -Dtests.locale=ko -Dtests.timezone=America/Indiana/Vevay -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 0.00s J0 | GraphQueryTest (suite) <<< [junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts): [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001\tlog: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001\tlog [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\solr-core\test\J0\temp\solr.search.join.GraphQueryTest_54ECD0B74A43AACC-001\init-core-data-001 [junit4] > at __randomizedtesting.SeedInfo.seed([54ECD0B74A43AACC]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] Completed [57/751 (1!)] on J0 in 2.24s, 2 tests, 1 error <<< FAILURES! [...truncated 5285 lines...] [junit4] Suite: org.apache.solr.analytics.value.CastingBooleanValueTest [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001\init-core-data-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1852, maxMBSortInHeap=7.897532914974783, sim=RandomSimilarity(queryNorm=false): {}, locale=lv-LV, timezone=Africa/Freetown [junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=3,threads=1,free=26141584,total=97714176 [junit4] 2> NOTE: All tests run in this JVM: [LegacyAbstractAnalyticsTest, LegacyQueryFacetCloudTest, ExpressionFactoryTest, EqualFunctionTest, LegacyAbstractAnalyticsFacetTest, NegateFunctionTest, CastingIntValueTest, LegacyRangeFacetCloudTest, StringCastFunctionTest, AddFunctionTest, ConcatFunctionTest, ReplaceFunctionTest, PowerFunctionTest, OverallAnalyticsTest, CastingBooleanValueTest] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=CastingBooleanValueTest -Dtests.seed=CEA754D47C3F832F -Dtests.slow=true -Dtests.locale=lv-LV -Dtests.timezone=Africa/Freetown -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s J0 | CastingBooleanValueTest (suite) <<< [junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts): [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001\init-core-data-001: java.nio.file.AccessDeniedException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001\init-core-data-001 [junit4] > C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001: java.nio.file.DirectoryNotEmptyException: C:\Users\jenkins\workspace\Lucene-Solr-7.x-Windows\solr\build\contrib\solr-analytics\test\J0\temp\solr.analytics.value.CastingBooleanValueTest_CEA754D47C3F832F-001 [junit4] > at __randomizedtesting.SeedInfo.seed([CEA754D47C3F832F]:0) [junit4] > at org.apache.lucene.util.IOUtils.rm(IOUtils.java:329) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] Completed [22/78 (1!)] on J0 in 0.09s, 6 tests, 1 error <<< FAILURES! [...truncated 44478 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org