Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7381/ Java: 64bit/jdk-10.0.1 -XX:+UseCompressedOops -XX:+UseSerialGC
3 tests failed. FAILED: org.apache.solr.cloud.autoscaling.ScheduledTriggerTest.testTrigger Error Message: expected:<3> but was:<2> Stack Trace: java.lang.AssertionError: expected:<3> but was:<2> at __randomizedtesting.SeedInfo.seed([D5334340A560A11F:B6F875C23CAFD232]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.junit.Assert.assertEquals(Assert.java:456) at org.apache.solr.cloud.autoscaling.ScheduledTriggerTest.scheduledTriggerTest(ScheduledTriggerTest.java:112) at org.apache.solr.cloud.autoscaling.ScheduledTriggerTest.testTrigger(ScheduledTriggerTest.java:65) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.common.util.TestTimeSource.testEpochTime Error Message: SimTimeSource:50.0 time diff=21410000 Stack Trace: java.lang.AssertionError: SimTimeSource:50.0 time diff=21410000 at __randomizedtesting.SeedInfo.seed([B392DD911BE0BC66:8BFEAEB48F301E20]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.common.util.TestTimeSource.doTestEpochTime(TestTimeSource.java:52) at org.apache.solr.common.util.TestTimeSource.testEpochTime(TestTimeSource.java:32) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.common.util.TestTimeSource.testEpochTime Error Message: SimTimeSource:50.0 time diff=17074950 Stack Trace: java.lang.AssertionError: SimTimeSource:50.0 time diff=17074950 at __randomizedtesting.SeedInfo.seed([B392DD911BE0BC66:8BFEAEB48F301E20]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.assertTrue(Assert.java:43) at org.apache.solr.common.util.TestTimeSource.doTestEpochTime(TestTimeSource.java:52) at org.apache.solr.common.util.TestTimeSource.testEpochTime(TestTimeSource.java:32) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.base/java.lang.reflect.Method.invoke(Method.java:564) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368) at java.base/java.lang.Thread.run(Thread.java:844) Build Log: [...truncated 13932 lines...] [junit4] Suite: org.apache.solr.cloud.autoscaling.ScheduledTriggerTest [junit4] 2> 1598604 INFO (SUITE-ScheduledTriggerTest-seed#[D5334340A560A11F]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerTest_D5334340A560A11F-001\init-core-data-001 [junit4] 2> 1598605 WARN (SUITE-ScheduledTriggerTest-seed#[D5334340A560A11F]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=16 numCloses=16 [junit4] 2> 1598605 INFO (SUITE-ScheduledTriggerTest-seed#[D5334340A560A11F]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 1598606 INFO (SUITE-ScheduledTriggerTest-seed#[D5334340A560A11F]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 1598607 INFO (SUITE-ScheduledTriggerTest-seed#[D5334340A560A11F]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerTest_D5334340A560A11F-001\tempDir-001 [junit4] 2> 1598607 INFO (SUITE-ScheduledTriggerTest-seed#[D5334340A560A11F]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 1598607 INFO (Thread-2937) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 1598607 INFO (Thread-2937) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 1598611 ERROR (Thread-2937) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 1598708 INFO (SUITE-ScheduledTriggerTest-seed#[D5334340A560A11F]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:63108 [junit4] 2> 1598711 INFO (zkConnectionManagerCallback-5619-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1598713 INFO (jetty-launcher-5616-thread-1) [ ] o.e.j.s.Server jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git: d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 10.0.1+10 [junit4] 2> 1598715 INFO (jetty-launcher-5616-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 1598715 INFO (jetty-launcher-5616-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 1598715 INFO (jetty-launcher-5616-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 1598715 INFO (jetty-launcher-5616-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7dd2b492{/solr,null,AVAILABLE} [junit4] 2> 1598716 INFO (jetty-launcher-5616-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@61fb7ba6{HTTP/1.1,[http/1.1]}{127.0.0.1:63112} [junit4] 2> 1598716 INFO (jetty-launcher-5616-thread-1) [ ] o.e.j.s.Server Started @1598746ms [junit4] 2> 1598716 INFO (jetty-launcher-5616-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=63112} [junit4] 2> 1598716 ERROR (jetty-launcher-5616-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 1598716 INFO (jetty-launcher-5616-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 1598716 INFO (jetty-launcher-5616-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0 [junit4] 2> 1598716 INFO (jetty-launcher-5616-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 1598716 INFO (jetty-launcher-5616-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 1598716 INFO (jetty-launcher-5616-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-06-26T06:59:11.460097400Z [junit4] 2> 1598719 INFO (zkConnectionManagerCallback-5621-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1598719 INFO (jetty-launcher-5616-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 1598722 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10040a81fcf0001, likely client has closed socket [junit4] 2> 1599017 INFO (jetty-launcher-5616-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63108/solr [junit4] 2> 1599019 INFO (zkConnectionManagerCallback-5625-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1599022 INFO (zkConnectionManagerCallback-5627-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1599117 INFO (jetty-launcher-5616-thread-1) [n:127.0.0.1:63112_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 1599117 INFO (jetty-launcher-5616-thread-1) [n:127.0.0.1:63112_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:63112_solr [junit4] 2> 1599118 INFO (jetty-launcher-5616-thread-1) [n:127.0.0.1:63112_solr ] o.a.s.c.Overseer Overseer (id=72128684870270979-127.0.0.1:63112_solr-n_0000000000) starting [junit4] 2> 1599126 INFO (zkConnectionManagerCallback-5634-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1599129 INFO (jetty-launcher-5616-thread-1) [n:127.0.0.1:63112_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:63108/solr ready [junit4] 2> 1599130 INFO (jetty-launcher-5616-thread-1) [n:127.0.0.1:63112_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:63112_solr [junit4] 2> 1599130 DEBUG (OverseerAutoScalingTriggerThread-72128684870270979-127.0.0.1:63112_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Adding .auto_add_replicas and .scheduled_maintenance triggers [junit4] 2> 1599130 INFO (OverseerStateUpdate-72128684870270979-127.0.0.1:63112_solr-n_0000000000) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1599130 DEBUG (OverseerAutoScalingTriggerThread-72128684870270979-127.0.0.1:63112_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Refreshing /autoscaling.json with znode version 1 [junit4] 2> 1599131 DEBUG (OverseerAutoScalingTriggerThread-72128684870270979-127.0.0.1:63112_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion -1 [junit4] 2> 1599131 DEBUG (OverseerAutoScalingTriggerThread-72128684870270979-127.0.0.1:63112_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Processed trigger updates upto znodeVersion 1 [junit4] 2> 1599132 INFO (zkCallback-5633-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1599134 DEBUG (OverseerAutoScalingTriggerThread-72128684870270979-127.0.0.1:63112_solr-n_0000000000) [ ] o.a.s.c.a.NodeLostTrigger NodeLostTrigger .auto_add_replicas - Initial livenodes: [127.0.0.1:63112_solr] [junit4] 2> 1599134 DEBUG (OverseerAutoScalingTriggerThread-72128684870270979-127.0.0.1:63112_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread -- clean old nodeAdded markers [junit4] 2> 1599135 DEBUG (OverseerAutoScalingTriggerThread-72128684870270979-127.0.0.1:63112_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread Current znodeVersion 1, lastZnodeVersion 1 [junit4] 2> 1599135 DEBUG (ScheduledTrigger-7534-thread-1) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1599148 INFO (jetty-launcher-5616-thread-1) [n:127.0.0.1:63112_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory. [junit4] 2> 1599165 INFO (jetty-launcher-5616-thread-1) [n:127.0.0.1:63112_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63112.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56b34dd2 [junit4] 2> 1599170 INFO (jetty-launcher-5616-thread-1) [n:127.0.0.1:63112_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63112.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56b34dd2 [junit4] 2> 1599171 INFO (jetty-launcher-5616-thread-1) [n:127.0.0.1:63112_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_63112.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@56b34dd2 [junit4] 2> 1599172 INFO (jetty-launcher-5616-thread-1) [n:127.0.0.1:63112_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerTest_D5334340A560A11F-001\tempDir-001\node1\. [junit4] 2> 1599185 INFO (zkConnectionManagerCallback-5637-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1599187 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x10040a81fcf0005, likely client has closed socket [junit4] 2> 1599189 INFO (zkConnectionManagerCallback-5642-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 1599190 INFO (SUITE-ScheduledTriggerTest-seed#[D5334340A560A11F]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 1599190 INFO (SUITE-ScheduledTriggerTest-seed#[D5334340A560A11F]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:63108/solr ready [junit4] 2> 1599201 INFO (TEST-ScheduledTriggerTest.testTrigger-seed#[D5334340A560A11F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTrigger [junit4] 2> 1600136 DEBUG (ScheduledTrigger-7534-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1601137 DEBUG (ScheduledTrigger-7534-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1602137 DEBUG (ScheduledTrigger-7534-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1603138 DEBUG (ScheduledTrigger-7534-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1604139 DEBUG (ScheduledTrigger-7534-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1605140 DEBUG (ScheduledTrigger-7534-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1605202 WARN (TEST-ScheduledTriggerTest.testTrigger-seed#[D5334340A560A11F]) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-06-26T06:59:14.945Z. Now: 2018-06-26T06:59:17.944Z [junit4] 2> 1606142 DEBUG (ScheduledTrigger-7534-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1607144 DEBUG (ScheduledTrigger-7534-thread-4) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1608146 DEBUG (ScheduledTrigger-7534-thread-3) [ ] o.a.s.c.a.NodeLostTrigger Running NodeLostTrigger: .auto_add_replicas with currently live nodes: 1 [junit4] 2> 1608203 WARN (TEST-ScheduledTriggerTest.testTrigger-seed#[D5334340A560A11F]) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-06-26T06:59:17.945Z. Now: 2018-06-26T06:59:20.944Z [junit4] 2> 1608203 INFO (TEST-ScheduledTriggerTest.testTrigger-seed#[D5334340A560A11F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testTrigger [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ScheduledTriggerTest -Dtests.method=testTrigger -Dtests.seed=D5334340A560A11F -Dtests.slow=true -Dtests.locale=ar-DZ -Dtests.timezone=America/Panama -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [junit4] FAILURE 9.01s J1 | ScheduledTriggerTest.testTrigger <<< [junit4] > Throwable #1: java.lang.AssertionError: expected:<3> but was:<2> [junit4] > at __randomizedtesting.SeedInfo.seed([D5334340A560A11F:B6F875C23CAFD232]:0) [junit4] > at org.apache.solr.cloud.autoscaling.ScheduledTriggerTest.scheduledTriggerTest(ScheduledTriggerTest.java:112) [junit4] > at org.apache.solr.cloud.autoscaling.ScheduledTriggerTest.testTrigger(ScheduledTriggerTest.java:65) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564) [junit4] > at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 1608211 INFO (TEST-ScheduledTriggerTest.testIgnoredEvent-seed#[D5334340A560A11F]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testIgnoredEvent [junit4] 2> 1608212 WARN (TEST-ScheduledTriggerTest.testIgnoredEvent-seed#[D5334340A560A11F]) [ ] o.a.s.c.a.ScheduledTrigger ScheduledTrigger was not able to run event at scheduled time: 2018-06-25T06:59:20.955Z. Now: 2018-06-26T06:59:20.954Z [junit4] 2> 1608213 INFO (TEST-ScheduledTriggerTest.testIgnoredEvent-seed#[D5334340A560A11F]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testIgnoredEvent [junit4] 2> 1608216 INFO (jetty-closer-5617-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@61fb7ba6{HTTP/1.1,[http/1.1]}{127.0.0.1:0} [junit4] 2> 1608217 INFO (jetty-closer-5617-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1811212889 [junit4] 2> 1608217 INFO (jetty-closer-5617-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null [junit4] 2> 1608217 INFO (jetty-closer-5617-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3b654780: rootName = solr_63112, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@4bf54635 [junit4] 2> 1608227 INFO (jetty-closer-5617-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null [junit4] 2> 1608227 INFO (jetty-closer-5617-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@46e7229: rootName = solr_63112, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@caedfdd [junit4] 2> 1608229 INFO (jetty-closer-5617-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null [junit4] 2> 1608229 INFO (jetty-closer-5617-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4fbe9fd7: rootName = solr_63112, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3884ccca [junit4] 2> 1608231 INFO (jetty-closer-5617-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:63112_solr [junit4] 2> 1608233 INFO (jetty-closer-5617-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null [junit4] 2> 1608234 INFO (jetty-closer-5617-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 1608234 INFO (jetty-closer-5617-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72128684870270979-127.0.0.1:63112_solr-n_0000000000) closing [junit4] 2> 1608234 WARN (OverseerAutoScalingTriggerThread-72128684870270979-127.0.0.1:63112_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 1608234 INFO (OverseerStateUpdate-72128684870270979-127.0.0.1:63112_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:63112_solr [junit4] 2> 1608235 DEBUG (jetty-closer-5617-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Shutting down scheduled thread pool executor now [junit4] 2> 1608235 DEBUG (jetty-closer-5617-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Shutting down action executor now [junit4] 2> 1608235 DEBUG (jetty-closer-5617-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for action executor [junit4] 2> 1608235 DEBUG (jetty-closer-5617-thread-1) [ ] o.a.s.c.a.ScheduledTriggers Awaiting termination for scheduled thread pool executor [junit4] 2> 1608235 INFO (zkCallback-5633-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0) [junit4] 2> 1608235 INFO (zkCallback-5626-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0) [junit4] 2> 1608237 DEBUG (jetty-closer-5617-thread-1) [ ] o.a.s.c.a.ScheduledTriggers ScheduledTriggers closed completely [junit4] 2> 1608237 DEBUG (jetty-closer-5617-thread-1) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread has been closed explicitly [junit4] 2> 1608240 INFO (jetty-closer-5617-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7dd2b492{/solr,null,UNAVAILABLE} [junit4] 2> 1608240 INFO (jetty-closer-5617-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 1608242 ERROR (SUITE-ScheduledTriggerTest-seed#[D5334340A560A11F]-worker) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes [junit4] 2> 1608242 INFO (SUITE-ScheduledTriggerTest-seed#[D5334340A560A11F]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63108 63108 [junit4] 2> 1608243 INFO (Thread-2937) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:63108 63108 [junit4] 2> 1608244 WARN (Thread-2937) [ ] o.a.s.c.ZkTestServer Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 3 /solr/aliases.json [junit4] 2> 3 /solr/clusterprops.json [junit4] 2> [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2> [junit4] 2> 3 /solr/clusterstate.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 3 /solr/live_nodes [junit4] 2> 3 /solr/collections [junit4] 2> [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J1\temp\solr.cloud.autoscaling.ScheduledTriggerTest_D5334340A560A11F-001 [junit4] 2> Jun 26, 2018 6:59:20 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 4 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=844, maxMBSortInHeap=5.166516534861013, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@1afa01b7), locale=ar-DZ, timezone=America/Panama [junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 10.0.1 (64-bit)/cpus=3,threads=1,free=168397664,total=476069888 [junit4] 2> NOTE: All tests run in this JVM: [TestConfig, TestStressCloudBlindAtomicUpdates, TestConfigSets, TestSchemaManager, TestDocumentBuilder, RecoveryAfterSoftCommitTest, TestNestedDocsSort, UniqFieldsUpdateProcessorFactoryTest, TestDelegationWithHadoopAuth, PeerSyncWithLeaderTest, DistributedQueryComponentCustomSortTest, LeaderVoteWaitTimeoutTest, MoveReplicaHDFSTest, TestRestManager, AutoAddReplicasIntegrationTest, TestPullReplica, PeerSyncTest, DocumentAnalysisRequestHandlerTest, BinaryUpdateRequestHandlerTest, StatsReloadRaceTest, HighlighterMaxOffsetTest, TriggerIntegrationTest, NodeAddedTriggerIntegrationTest, HttpPartitionTest, TestObjectReleaseTracker, TestSchemaResource, MultiTermTest, IndexSchemaTest, ImplicitSnitchTest, TestRuleBasedAuthorizationPlugin, TestAuthenticationFramework, SmileWriterTest, TestConfigSetImmutable, AutoscalingHistoryHandlerTest, FullHLLTest, TestWriterPerf, LargeFieldTest, RulesTest, Tagger2Test, TestReversedWildcardFilterFactory, TestNodeAddedTrigger, TestImplicitCoreProperties, TestNoOpRegenerator, ScheduledMaintenanceTriggerTest, TestPostingsSolrHighlighter, CreateCollectionCleanupTest, TestPayloadCheckQParserPlugin, ForceLeaderTest, CoreAdminRequestStatusTest, TestManagedSchemaAPI, InfoHandlerTest, TestGraphMLResponseWriter, TestMacros, BasicAuthStandaloneTest, TestConfigSetsAPIExclusivity, HdfsChaosMonkeySafeLeaderTest, ParsingFieldUpdateProcessorsTest, TestSolrCloudSnapshots, OrderedExecutorTest, TestLegacyNumericUtils, TestXmlQParserPlugin, JsonLoaderTest, GraphQueryTest, AssignTest, SortSpecParsingTest, CollectionsAPIDistributedZkTest, SpatialRPTFieldTypeTest, TestConfigsApi, TestSolrQueryParser, RequestHandlersTest, ZkFailoverTest, DocumentBuilderTest, TestSmileRequest, QueryElevationComponentTest, SSLMigrationTest, TestDocTermOrdsUninvertLimit, TestCustomStream, TestJsonFacets, TestStandardQParsers, AnalysisErrorHandlingTest, TestRawResponseWriter, TestRebalanceLeaders, TestSortableTextField, TestSortByMinMaxFunction, CachingDirectoryFactoryTest, MetricUtilsTest, AddSchemaFieldsUpdateProcessorFactoryTest, TermVectorComponentTest, TestLegacyNumericRangeQueryBuilder, TestRetrieveFieldsOptimizer, TestNRTOpen, TestMinMaxOnMultiValuedField, DistributedFacetPivotWhiteBoxTest, CollectionPropsTest, TestSkipOverseerOperations, SharedFSAutoReplicaFailoverTest, SchemaVersionSpecificBehaviorTest, HDFSCollectionsAPITest, SimplePostToolTest, TestDownShardTolerantSearch, TestHighlightDedupGrouping, TestSolrDeletionPolicy2, TestUseDocValuesAsStored2, BJQParserTest, ZkShardTermsTest, TestIBSimilarityFactory, CollectionsAPISolrJTest, TestCharFilters, TestCloudPivotFacet, SolrRrdBackendFactoryTest, TestCoreDiscovery, CircularListTest, TestUtilizeNode, TestValueSourceCache, CloneFieldUpdateProcessorFactoryTest, TestEmbeddedSolrServerSchemaAPI, TestCloudDeleteByQuery, TestTriggerIntegration, AutoScalingHandlerTest, TestSuggestSpellingConverter, CopyFieldTest, HdfsLockFactoryTest, TestFieldCacheWithThreads, DataDrivenBlockJoinTest, TestSystemIdResolver, TestPseudoReturnFields, TestSolrConfigHandlerConcurrent, TestStressRecovery, OpenCloseCoreStressTest, UtilsToolTest, TestDFISimilarityFactory, TestCopyFieldCollectionResource, TestBlobHandler, NodeLostTriggerIntegrationTest, DistribCursorPagingTest, OverriddenZkACLAndCredentialsProvidersTest, TestIndexingPerformance, TestLockTree, TestCloudRecovery, TestExceedMaxTermLength, TestReplicaProperties, TestGenericDistributedQueue, LIRRollingUpdatesTest, StatsComponentTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, TestStressLiveNodes, FastVectorHighlighterTest, SolrCloudReportersTest, V2ApiIntegrationTest, TestClusterStateProvider, DistributedExpandComponentTest, TestFiltering, HLLUtilTest, SearchRateTriggerTest, ExternalFileFieldSortTest, MissingSegmentRecoveryTest, OverseerTest, LeaderElectionIntegrationTest, CleanupOldIndexTest, TestAddFieldRealTimeGet, SolrCLIZkUtilsTest, TestFastOutputStream, BlobRepositoryCloudTest, TestBlendedInfixSuggestions, EmbeddedSolrNoSerializeTest, SuggesterFSTTest, TimeRoutedAliasUpdateProcessorTest, PeerSyncWithIndexFingerprintCachingTest, TestHdfsCloudBackupRestore, TestFieldCacheReopen, TestScoreJoinQPScore, ResponseBuilderTest, TestFieldTypeResource, TestBinaryField, TestFreeTextSuggestions, PolyFieldTest, DistributedSuggestComponentTest, TestComplexPhraseLeadingWildcard, CacheHeaderTest, SegmentsInfoRequestHandlerTest, TransactionLogTest, SolrTestCaseJ4Test, HdfsThreadLeakTest, QueryResultKeyTest, BitVectorTest, TestSSLRandomization, SolrCmdDistributorTest, ScheduledTriggerTest] [junit4] Completed [437/820 (1!)] on J1 in 10.15s, 2 tests, 1 failure <<< FAILURES! [...truncated 2441 lines...] [junit4] Suite: org.apache.solr.common.util.TestTimeSource [junit4] 2> 227114 INFO (SUITE-TestTimeSource-seed#[B392DD911BE0BC66]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J1\temp\solr.common.util.TestTimeSource_B392DD911BE0BC66-001\init-core-data-001 [junit4] 2> 227114 INFO (SUITE-TestTimeSource-seed#[B392DD911BE0BC66]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 227115 INFO (SUITE-TestTimeSource-seed#[B392DD911BE0BC66]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 227117 INFO (TEST-TestTimeSource.testEpochTime-seed#[B392DD911BE0BC66]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testEpochTime [junit4] 2> 237135 INFO (TEST-TestTimeSource.testEpochTime-seed#[B392DD911BE0BC66]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testEpochTime [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestTimeSource -Dtests.method=testEpochTime -Dtests.seed=B392DD911BE0BC66 -Dtests.slow=true -Dtests.locale=xog -Dtests.timezone=PST8PDT -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] FAILURE 10.0s J1 | TestTimeSource.testEpochTime <<< [junit4] > Throwable #1: java.lang.AssertionError: SimTimeSource:50.0 time diff=17074950 [junit4] > at __randomizedtesting.SeedInfo.seed([B392DD911BE0BC66:8BFEAEB48F301E20]:0) [junit4] > at org.apache.solr.common.util.TestTimeSource.doTestEpochTime(TestTimeSource.java:52) [junit4] > at org.apache.solr.common.util.TestTimeSource.testEpochTime(TestTimeSource.java:32) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564) [junit4] > at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J1\temp\solr.common.util.TestTimeSource_B392DD911BE0BC66-001 [junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@400202), locale=xog, timezone=PST8PDT [junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 10.0.1 (64-bit)/cpus=3,threads=1,free=114902832,total=216555520 [junit4] 2> NOTE: All tests run in this JVM: [NormalDistributionEvaluatorTest, CumulativeProbabilityEvaluatorTest, AppendEvaluatorTest, JsonValidatorTest, TestSolrProperties, FloorEvaluatorTest, TestCoreAdmin, NotEvaluatorTest, LBHttpSolrClientBuilderTest, TestCollectionStateWatchers, TestPathTrie, JettyWebappTest, SolrSchemalessExampleTest, TestSuggesterResponse, AddEvaluatorTest, SchemaTest, SineEvaluatorTest, TestCollectionAdminRequest, SolrDocumentTest, StreamExpressionToExpessionTest, RecursiveEvaluatorTest, JdbcTest, ArrayEvaluatorTest, CommonAdminParamsTest, ConcurrentUpdateSolrClientBuilderTest, LessThanEvaluatorTest, CollectionAdminRequestRequiredParamsTest, StreamDecoratorTest, LargeVolumeEmbeddedTest, EmpiricalDistributionEvaluatorTest, HttpClientUtilTest, GraphTest, UuidEvaluatorTest, SolrParamTest, TestLang, TestDocumentObjectBinder, LengthEvaluatorTest, LargeVolumeJettyTest, MergeIndexesEmbeddedTest, SolrExampleEmbeddedTest, SolrExampleJettyTest, SolrExampleStreamingTest, CloudSolrClientBuilderTest, CloudSolrClientCacheTest, CloudSolrClientMultiConstructorTest, HttpSolrClientBuilderTest, HttpSolrClientConPoolTest, JDBCStreamTest, StreamExpressionToExplanationTest, StreamingTest, GreaterThanEvaluatorTest, HyperbolicSineEvaluatorTest, MultiplyEvaluatorTest, PowerEvaluatorTest, ReverseEvaluatorTest, SubtractEvaluatorTest, ConcatOperationTest, TestV1toV2ApiMapper, AnlysisResponseBaseTest, DocumentAnalysisResponseTest, FacetFieldTest, FieldAnalysisResponseTest, NoOpResponseParserTest, QueryResponseTest, TermsResponseTest, TestClusteringResponse, TestDelegationTokenResponse, TestToleratedUpdateError, SolrZkClientTest, CommonParamsTest, ModifiableSolrParamsTest, NamedListTest, TestFastInputStream, TestFastWriter, TestHash, TestJavaBinCodec, TestJsonRecordReader, TestRetryUtil, TestSolrJsonWriter, TestTimeSource] [junit4] Completed [154/154 (1!)] on J1 in 10.03s, 1 test, 1 failure <<< FAILURES! [...truncated 42828 lines...] [repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/7381/consoleText [repro] Revision: 095f9eb90db92649a0805e83ff5a0ec93763a31f [repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" [repro] ant clean [...truncated 6 lines...] [repro] Test suites by module: [repro] solr\core [repro] ScheduledTriggerTest [repro] solr\solrj [repro] TestTimeSource [repro] ant compile-test [...truncated 3326 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.ScheduledTriggerTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=D5334340A560A11F -Dtests.slow=true -Dtests.locale=ar-DZ -Dtests.timezone=America/Panama -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1 [...truncated 79 lines...] [repro] ant compile-test [...truncated 447 lines...] [repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.TestTimeSource" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=B392DD911BE0BC66 -Dtests.slow=true -Dtests.locale=xog -Dtests.timezone=PST8PDT -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [...truncated 36 lines...] [junit4] Suite: org.apache.solr.common.util.TestTimeSource [junit4] 2> SLF4J: Class path contains multiple SLF4J bindings. [junit4] 2> SLF4J: Found binding in [jar:file:/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/solrj/test-lib/log4j-slf4j-impl-2.11.0.jar!/org/slf4j/impl/StaticLoggerBinder.class] [junit4] 2> SLF4J: Found binding in [jar:file:/C:/Users/jenkins/workspace/Lucene-Solr-master-Windows/solr/core/lib/log4j-slf4j-impl-2.11.0.jar!/org/slf4j/impl/StaticLoggerBinder.class] [junit4] 2> SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. [junit4] 2> SLF4J: Actual binding is of type [org.apache.logging.slf4j.Log4jLoggerFactory] [junit4] 2> 11554 INFO (SUITE-TestTimeSource-seed#[B392DD911BE0BC66]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J1\temp\solr.common.util.TestTimeSource_B392DD911BE0BC66-001\init-core-data-001 [junit4] 2> 11622 INFO (SUITE-TestTimeSource-seed#[B392DD911BE0BC66]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false [junit4] 2> 11659 INFO (SUITE-TestTimeSource-seed#[B392DD911BE0BC66]-worker) [ ] o.e.j.u.log Logging initialized @11696ms to org.eclipse.jetty.util.log.Slf4jLog [junit4] 2> 11667 INFO (SUITE-TestTimeSource-seed#[B392DD911BE0BC66]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, clientAuth=0.0/0.0) [junit4] 2> 11780 INFO (TEST-TestTimeSource.testEpochTime-seed#[B392DD911BE0BC66]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testEpochTime [junit4] 2> 21845 INFO (TEST-TestTimeSource.testEpochTime-seed#[B392DD911BE0BC66]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testEpochTime [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestTimeSource -Dtests.method=testEpochTime -Dtests.seed=B392DD911BE0BC66 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=xog -Dtests.timezone=PST8PDT -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] FAILURE 10.1s J1 | TestTimeSource.testEpochTime <<< [junit4] > Throwable #1: java.lang.AssertionError: SimTimeSource:50.0 time diff=21410000 [junit4] > at __randomizedtesting.SeedInfo.seed([B392DD911BE0BC66:8BFEAEB48F301E20]:0) [junit4] > at org.apache.solr.common.util.TestTimeSource.doTestEpochTime(TestTimeSource.java:52) [junit4] > at org.apache.solr.common.util.TestTimeSource.testEpochTime(TestTimeSource.java:32) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:564) [junit4] > at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J1\temp\solr.common.util.TestTimeSource_B392DD911BE0BC66-001 [junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@3db93389), locale=xog, timezone=PST8PDT [junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 10.0.1 (64-bit)/cpus=3,threads=1,free=73897864,total=97386496 [junit4] 2> NOTE: All tests run in this JVM: [TestTimeSource] [junit4] Completed [2/5 (1!)] on J1 in 20.44s, 1 test, 1 failure <<< FAILURES! [...truncated 23 lines...] BUILD FAILED C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:1568: The following error occurred while executing this line: C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\lucene\common-build.xml:1092: There were test failures: 5 suites, 5 tests, 1 failure [seed: B392DD911BE0BC66] Total time: 44 seconds [repro] Setting last failure code to 1 [repro] Failures: [repro] 0/5 failed: org.apache.solr.cloud.autoscaling.ScheduledTriggerTest [repro] 1/5 failed: org.apache.solr.common.util.TestTimeSource [repro] Exiting with code 1 C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST lucene\build move /y lucene\build lucene\build.repro 1 dir(s) moved. C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST solr\build move /y solr\build solr\build.repro 1 dir(s) moved. C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST lucene\build.orig move /y lucene\build.orig lucene\build 1 dir(s) moved. C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>IF EXIST solr\build.orig move /y solr\build.orig solr\build 1 dir(s) moved. C:\Users\jenkins\workspace\Lucene-Solr-master-Windows>exit 0 Archiving artifacts Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2 [WARNINGS] Parsing warnings in console log with parser Java Compiler (javac) Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2 Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2 <Git Blamer> Using GitBlamer to create author and commit information for all warnings. <Git Blamer> GIT_COMMIT=095f9eb90db92649a0805e83ff5a0ec93763a31f, workspace=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows [WARNINGS] Computing warning deltas based on reference build #7380 Recording test results Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2 Build step 'Publish JUnit test result report' changed build result to UNSTABLE Email was triggered for: Unstable (Test Failures) Sending email for trigger: Unstable (Test Failures) Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2 Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2 Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2 Setting ANT_1_8_2_HOME=C:\Users\jenkins\tools\hudson.tasks.Ant_AntInstallation\ANT_1.8.2
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org