lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@sd-datasolutions.de>
Subject [JENKINS] Lucene-Solr-4.x-Linux (32bit/jdk1.8.0-ea-b51) - Build # 500 - Failure!
Date Fri, 17 Aug 2012 18:09:57 GMT
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Linux/500/
Java: 32bit/jdk1.8.0-ea-b51 -server -XX:+UseConcMarkSweepGC

1 tests failed.
REGRESSION:  org.apache.solr.cloud.ZkSolrClientTest.testWatchChildren

Error Message:
expected:<2> but was:<1>

Stack Trace:
java.lang.AssertionError: expected:<2> but was:<1>
	at __randomizedtesting.SeedInfo.seed([2034617253769CA8:684A036E14B22613]: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.ZkSolrClientTest.testWatchChildren(ZkSolrClientTest.java:218)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:474)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:345)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:769)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:429)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:40)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:345)
	at java.lang.Thread.run(Thread.java:722)




Build Log:
[...truncated 7286 lines...]
[junit4:junit4] Suite: org.apache.solr.cloud.ZkSolrClientTest
[junit4:junit4]   2> 166 T920 oasu.AbstractSolrTestCase.setUp ####SETUP_START testMakeRootNode
[junit4:junit4]   2> 166 T920 oasu.AbstractSolrTestCase.setUp ####SETUP_END testMakeRootNode
[junit4:junit4]   2> 167 T920 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 167 T921 oazs.ZooKeeperServer.setTickTime tickTime set to 3000
[junit4:junit4]   2> 168 T921 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 168 T921 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 267 T920 oasc.ZkTestServer.run start zk server on port:42208
[junit4:junit4]   2> 267 T920 oaz.ZooKeeper.<init> Initiating client connection,
connectString=127.0.0.1:42208 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@142d6b1
[junit4:junit4]   2> 268 T926 oaz.ClientCnxn$SendThread.startConnect Opening socket connection
to server /127.0.0.1:42208
[junit4:junit4]   2> 268 T926 oaz.ClientCnxn$SendThread.primeConnection Socket connection
established to localhost.localdomain/127.0.0.1:42208, initiating session
[junit4:junit4]   2> 268 T922 oazs.NIOServerCnxn$Factory.run Accepted socket connection
from /127.0.0.1:60045
[junit4:junit4]   2> 269 T922 oazs.NIOServerCnxn.readConnectRequest Client attempting to
establish new session at /127.0.0.1:60045
[junit4:junit4]   2> 269 T924 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 718 T924 oazs.NIOServerCnxn.finishSessionInit Established session
0x13935b9c69d0000 with negotiated timeout 10000 for client /127.0.0.1:60045
[junit4:junit4]   2> 718 T926 oaz.ClientCnxn$SendThread.readConnectResult Session establishment
complete on server localhost.localdomain/127.0.0.1:42208, sessionid = 0x13935b9c69d0000, negotiated
timeout = 10000
[junit4:junit4]   2> 719 T927 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@142d6b1
name:ZooKeeperConnection Watcher:127.0.0.1:42208 got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4:junit4]   2> 719 T920 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 721 T925 oazs.PrepRequestProcessor.pRequest Processed session termination
for sessionid: 0x13935b9c69d0000
[junit4:junit4]   2> 722 T927 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 722 T922 oazs.NIOServerCnxn.closeSock Closed socket connection for
client /127.0.0.1:60045 which had sessionid 0x13935b9c69d0000
[junit4:junit4]   2> 722 T920 oaz.ZooKeeper.close Session: 0x13935b9c69d0000 closed
[junit4:junit4]   2> 722 T920 oaz.ZooKeeper.<init> Initiating client connection,
connectString=127.0.0.1:42208 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@c574e0
[junit4:junit4]   2> 723 T928 oaz.ClientCnxn$SendThread.startConnect Opening socket connection
to server /127.0.0.1:42208
[junit4:junit4]   2> 723 T928 oaz.ClientCnxn$SendThread.primeConnection Socket connection
established to localhost.localdomain/127.0.0.1:42208, initiating session
[junit4:junit4]   2> 723 T922 oazs.NIOServerCnxn$Factory.run Accepted socket connection
from /127.0.0.1:60046
[junit4:junit4]   2> 723 T922 oazs.NIOServerCnxn.readConnectRequest Client attempting to
establish new session at /127.0.0.1:60046
[junit4:junit4]   2> 724 T924 oazs.NIOServerCnxn.finishSessionInit Established session
0x13935b9c69d0001 with negotiated timeout 10000 for client /127.0.0.1:60046
[junit4:junit4]   2> 724 T928 oaz.ClientCnxn$SendThread.readConnectResult Session establishment
complete on server localhost.localdomain/127.0.0.1:42208, sessionid = 0x13935b9c69d0001, negotiated
timeout = 10000
[junit4:junit4]   2> 724 T929 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@c574e0
name:ZooKeeperConnection Watcher:127.0.0.1:42208 got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4:junit4]   2> 724 T925 oazs.PrepRequestProcessor.pRequest Processed session termination
for sessionid: 0x13935b9c69d0001
[junit4:junit4]   2> 725 T922 oazs.NIOServerCnxn.closeSock Closed socket connection for
client /127.0.0.1:60046 which had sessionid 0x13935b9c69d0001
[junit4:junit4]   2> 725 T929 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 725 T920 oaz.ZooKeeper.close Session: 0x13935b9c69d0001 closed
[junit4:junit4]   2> 725 T925 oazs.PrepRequestProcessor.run PrepRequestProcessor exited
loop!
[junit4:junit4]   2> 725 T924 oazs.SyncRequestProcessor.run SyncRequestProcessor exited!
[junit4:junit4]   2> 725 T920 oazs.FinalRequestProcessor.shutdown shutdown of request processor
complete
[junit4:junit4]   2> 730 T922 oazs.NIOServerCnxn$Factory.run NIOServerCnxn factory exited
run method
[junit4:junit4]   2> 731 T920 oazs.FinalRequestProcessor.shutdown shutdown of request processor
complete
[junit4:junit4]   2> 731 T920 oasu.AbstractSolrTestCase.tearDown ####TEARDOWN_START testMakeRootNode
[junit4:junit4]   2> 734 T920 oasu.AbstractSolrTestCase.setUp ####SETUP_START testReconnect
[junit4:junit4]   2> 734 T920 oasu.AbstractSolrTestCase.setUp ####SETUP_END testReconnect
[junit4:junit4]   2> 734 T920 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 735 T930 oazs.ZooKeeperServer.setTickTime tickTime set to 3000
[junit4:junit4]   2> 735 T930 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 736 T930 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 835 T920 oasc.ZkTestServer.run start zk server on port:60923
[junit4:junit4]   2> 835 T920 oaz.ZooKeeper.<init> Initiating client connection,
connectString=127.0.0.1:60923 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@61d05b
[junit4:junit4]   2> 836 T935 oaz.ClientCnxn$SendThread.startConnect Opening socket connection
to server /127.0.0.1:60923
[junit4:junit4]   2> 836 T935 oaz.ClientCnxn$SendThread.primeConnection Socket connection
established to localhost.localdomain/127.0.0.1:60923, initiating session
[junit4:junit4]   2> 836 T931 oazs.NIOServerCnxn$Factory.run Accepted socket connection
from /127.0.0.1:41517
[junit4:junit4]   2> 837 T931 oazs.NIOServerCnxn.readConnectRequest Client attempting to
establish new session at /127.0.0.1:41517
[junit4:junit4]   2> 837 T933 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 868 T933 oazs.NIOServerCnxn.finishSessionInit Established session
0x13935b9c8d20000 with negotiated timeout 10000 for client /127.0.0.1:41517
[junit4:junit4]   2> 868 T935 oaz.ClientCnxn$SendThread.readConnectResult Session establishment
complete on server localhost.localdomain/127.0.0.1:60923, sessionid = 0x13935b9c8d20000, negotiated
timeout = 10000
[junit4:junit4]   2> 869 T936 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@61d05b
name:ZooKeeperConnection Watcher:127.0.0.1:60923 got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4:junit4]   2> 869 T920 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 871 T934 oazs.PrepRequestProcessor.pRequest Processed session termination
for sessionid: 0x13935b9c8d20000
[junit4:junit4]   2> 872 T931 oazs.NIOServerCnxn.closeSock Closed socket connection for
client /127.0.0.1:41517 which had sessionid 0x13935b9c8d20000
[junit4:junit4]   2> 872 T920 oaz.ZooKeeper.close Session: 0x13935b9c8d20000 closed
[junit4:junit4]   2> 872 T936 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 872 T920 oaz.ZooKeeper.<init> Initiating client connection,
connectString=127.0.0.1:60923/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1612fbf
[junit4:junit4]   2> 873 T937 oaz.ClientCnxn$SendThread.startConnect Opening socket connection
to server /127.0.0.1:60923
[junit4:junit4]   2> 873 T937 oaz.ClientCnxn$SendThread.primeConnection Socket connection
established to localhost.localdomain/127.0.0.1:60923, initiating session
[junit4:junit4]   2> 873 T931 oazs.NIOServerCnxn$Factory.run Accepted socket connection
from /127.0.0.1:41518
[junit4:junit4]   2> 873 T931 oazs.NIOServerCnxn.readConnectRequest Client attempting to
establish new session at /127.0.0.1:41518
[junit4:junit4]   2> 874 T933 oazs.NIOServerCnxn.finishSessionInit Established session
0x13935b9c8d20001 with negotiated timeout 10000 for client /127.0.0.1:41518
[junit4:junit4]   2> 874 T937 oaz.ClientCnxn$SendThread.readConnectResult Session establishment
complete on server localhost.localdomain/127.0.0.1:60923, sessionid = 0x13935b9c8d20001, negotiated
timeout = 10000
[junit4:junit4]   2> 874 T938 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1612fbf
name:ZooKeeperConnection Watcher:127.0.0.1:60923/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4:junit4]   2> 874 T920 oascc.SolrZkClient.makePath makePath: /collections/collection1/shards
[junit4:junit4]   2> 876 T920 oascc.SolrZkClient.makePath makePath: collections/collection1
[junit4:junit4]   2> 877 T933 oazs.SyncRequestProcessor.run SyncRequestProcessor exited!
[junit4:junit4]   2> 877 T934 oazs.PrepRequestProcessor.run PrepRequestProcessor exited
loop!
[junit4:junit4]   2> 877 T920 oazs.FinalRequestProcessor.shutdown shutdown of request processor
complete
[junit4:junit4]   2> 878 T920 oazs.NIOServerCnxn.closeSock Closed socket connection for
client /127.0.0.1:41518 which had sessionid 0x13935b9c8d20001
[junit4:junit4]   2> 878 T931 oazs.NIOServerCnxn$Factory.run NIOServerCnxn factory exited
run method
[junit4:junit4]   2> 879 T937 oaz.ClientCnxn$SendThread.run Unable to read additional data
from server sessionid 0x13935b9c8d20001, likely server has closed socket, closing socket connection
and attempting reconnect
[junit4:junit4]   2> 879 T920 oazs.FinalRequestProcessor.shutdown shutdown of request processor
complete
[junit4:junit4]   2> 959 T920 oascc.SolrZkClient.makePath makePath: collections/collection2
[junit4:junit4]   2> 979 T938 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1612fbf
name:ZooKeeperConnection Watcher:127.0.0.1:60923/solr got event WatchedEvent state:Disconnected
type:None path:null path:null type:None
[junit4:junit4]   2> 979 T920 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 980 T939 oazs.ZooKeeperServer.setTickTime tickTime set to 3000
[junit4:junit4]   2> 980 T939 oazs.NIOServerCnxn$Factory.<init> binding to port 0.0.0.0/0.0.0.0:60923
[junit4:junit4]   2> 980 T939 oazsp.FileSnap.deserialize Reading snapshot /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-core/test/J1/./org.apache.solr.cloud.ZkSolrClientTest-1345226131664/zookeeper/server1/data/version-2/snapshot.0
[junit4:junit4]   2> 981 T939 oazsp.FileTxnSnapLog.save Snapshotting: 8
[junit4:junit4]   2> 1080 T920 oasc.ZkTestServer.run start zk server on port:60923
[junit4:junit4]   2> 1680 T920 oascc.SolrZkClient.makePath makePath: collections/collection3
[junit4:junit4]   2> 2070 T923 oazs.SessionTrackerImpl.run SessionTrackerImpl exited loop!
[junit4:junit4]   2> 2070 T932 oazs.SessionTrackerImpl.run SessionTrackerImpl exited loop!
[junit4:junit4]   2> 2222 T937 oaz.ClientCnxn$SendThread.startConnect Opening socket connection
to server localhost.localdomain/127.0.0.1:60923
[junit4:junit4]   2> 2223 T940 oazs.NIOServerCnxn$Factory.run Accepted socket connection
from /127.0.0.1:41519
[junit4:junit4]   2> 2223 T937 oaz.ClientCnxn$SendThread.primeConnection Socket connection
established to localhost.localdomain/127.0.0.1:60923, initiating session
[junit4:junit4]   2> 2223 T940 oazs.NIOServerCnxn.readConnectRequest Client attempting
to renew session 0x13935b9c8d20001 at /127.0.0.1:41519
[junit4:junit4]   2> 2223 T940 oazs.NIOServerCnxn.finishSessionInit Established session
0x13935b9c8d20001 with negotiated timeout 10000 for client /127.0.0.1:41519
[junit4:junit4]   2> 2223 T937 oaz.ClientCnxn$SendThread.readConnectResult Session establishment
complete on server localhost.localdomain/127.0.0.1:60923, sessionid = 0x13935b9c8d20001, negotiated
timeout = 10000
[junit4:junit4]   2> 2223 T938 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1612fbf
name:ZooKeeperConnection Watcher:127.0.0.1:60923/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4:junit4]   2> 2224 T942 oazsp.FileTxnLog.append Creating new log file: log.9
[junit4:junit4]   2> 2227 T920 oazs.ZooKeeperServer.expire Expiring session 0x13935b9c8d20001,
timeout of 4000ms exceeded
[junit4:junit4]   2> 2227 T943 oazs.PrepRequestProcessor.pRequest Processed session termination
for sessionid: 0x13935b9c8d20001
[junit4:junit4]   2> 2228 T942 oazs.NIOServerCnxn.closeSock Closed socket connection for
client /127.0.0.1:41519 which had sessionid 0x13935b9c8d20001
[junit4:junit4]   2> 2228 T937 oaz.ClientCnxn$SendThread.run Unable to read additional
data from server sessionid 0x13935b9c8d20001, likely server has closed socket, closing socket
connection and attempting reconnect
[junit4:junit4]   2> 2328 T938 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1612fbf
name:ZooKeeperConnection Watcher:127.0.0.1:60923/solr got event WatchedEvent state:Disconnected
type:None path:null path:null type:None
[junit4:junit4]   2> 3227 T920 oascc.SolrZkClient.makePath makePath: collections/collection4
[junit4:junit4]   2> 3360 T937 oaz.ClientCnxn$SendThread.startConnect Opening socket connection
to server localhost.localdomain/127.0.0.1:60923
[junit4:junit4]   2> 3361 T937 oaz.ClientCnxn$SendThread.primeConnection Socket connection
established to localhost.localdomain/127.0.0.1:60923, initiating session
[junit4:junit4]   2> 3361 T940 oazs.NIOServerCnxn$Factory.run Accepted socket connection
from /127.0.0.1:41520
[junit4:junit4]   2> 3361 T940 oazs.NIOServerCnxn.readConnectRequest Client attempting
to renew session 0x13935b9c8d20001 at /127.0.0.1:41520
[junit4:junit4]   2> 3361 T940 oazs.NIOServerCnxn.finishSessionInit Invalid session 0x13935b9c8d20001
for client /127.0.0.1:41520, probably expired
[junit4:junit4]   2> 3361 T937 oaz.ClientCnxn$SendThread.run Unable to reconnect to ZooKeeper
service, session 0x13935b9c8d20001 has expired, closing socket connection
[junit4:junit4]   2> 3361 T938 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1612fbf
name:ZooKeeperConnection Watcher:127.0.0.1:60923/solr got event WatchedEvent state:Expired
type:None path:null path:null type:None
[junit4:junit4]   2> 3361 T938 oascc.ConnectionManager.process Attempting to reconnect
to recover relationship with ZooKeeper...
[junit4:junit4]   2> 3362 T940 oazs.NIOServerCnxn.closeSock Closed socket connection for
client /127.0.0.1:41520 which had sessionid 0x13935b9c8d20001
[junit4:junit4]   2> 3362 T938 oascc.DefaultConnectionStrategy.reconnect Connection expired
- starting a new one...
[junit4:junit4]   2> 3362 T938 oaz.ZooKeeper.<init> Initiating client connection,
connectString=127.0.0.1:60923/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1612fbf
[junit4:junit4]   2> 3362 T944 oaz.ClientCnxn$SendThread.startConnect Opening socket connection
to server /127.0.0.1:60923
[junit4:junit4]   2> 3363 T944 oaz.ClientCnxn$SendThread.primeConnection Socket connection
established to localhost.localdomain/127.0.0.1:60923, initiating session
[junit4:junit4]   2> 3363 T940 oazs.NIOServerCnxn$Factory.run Accepted socket connection
from /127.0.0.1:41521
[junit4:junit4]   2> 3363 T940 oazs.NIOServerCnxn.readConnectRequest Client attempting
to establish new session at /127.0.0.1:41521
[junit4:junit4]   2> 3364 T942 oazs.NIOServerCnxn.finishSessionInit Established session
0x13935b9c9c70000 with negotiated timeout 10000 for client /127.0.0.1:41521
[junit4:junit4]   2> 3364 T944 oaz.ClientCnxn$SendThread.readConnectResult Session establishment
complete on server localhost.localdomain/127.0.0.1:60923, sessionid = 0x13935b9c9c70000, negotiated
timeout = 10000
[junit4:junit4]   2> 3364 T945 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1612fbf
name:ZooKeeperConnection Watcher:127.0.0.1:60923/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4:junit4]   2> 3364 T938 oascc.DefaultConnectionStrategy.reconnect Reconnected to
ZooKeeper
[junit4:junit4]   2> 3364 T938 oascc.ConnectionManager.process Connected:true
[junit4:junit4]   2> 3364 T938 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 3462 T920 oascc.SolrZkClient.makePath makePath: collections/collection4
[junit4:junit4]   2> 3463 T943 oazs.PrepRequestProcessor.pRequest Processed session termination
for sessionid: 0x13935b9c9c70000
[junit4:junit4]   2> 3464 T940 oazs.NIOServerCnxn.closeSock Closed socket connection for
client /127.0.0.1:41521 which had sessionid 0x13935b9c9c70000
[junit4:junit4]   2> 3464 T920 oaz.ZooKeeper.close Session: 0x13935b9c9c70000 closed
[junit4:junit4]   2> 3464 T943 oazs.PrepRequestProcessor.run PrepRequestProcessor exited
loop!
[junit4:junit4]   2> 3464 T945 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 3464 T942 oazs.SyncRequestProcessor.run SyncRequestProcessor exited!
[junit4:junit4]   2> 3465 T920 oazs.FinalRequestProcessor.shutdown shutdown of request
processor complete
[junit4:junit4]   2> 3466 T940 oazs.NIOServerCnxn$Factory.run NIOServerCnxn factory exited
run method
[junit4:junit4]   2> 3466 T920 oazs.FinalRequestProcessor.shutdown shutdown of request
processor complete
[junit4:junit4]   2> 3466 T920 oasu.AbstractSolrTestCase.tearDown ####TEARDOWN_START testReconnect
[junit4:junit4]   2> 3468 T920 oasu.AbstractSolrTestCase.setUp ####SETUP_START testConnect
[junit4:junit4]   2> 3468 T920 oasu.AbstractSolrTestCase.setUp ####SETUP_END testConnect
[junit4:junit4]   2> 3468 T920 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 3469 T946 oazs.ZooKeeperServer.setTickTime tickTime set to 3000
[junit4:junit4]   2> 3469 T946 oazs.NIOServerCnxn$Factory.<init> binding to port
0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 3470 T946 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 3569 T920 oasc.ZkTestServer.run start zk server on port:46139
[junit4:junit4]   2> 3569 T920 oaz.ZooKeeper.<init> Initiating client connection,
connectString=127.0.0.1:46139/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@d33c6e
[junit4:junit4]   2> 3570 T951 oaz.ClientCnxn$SendThread.startConnect Opening socket connection
to server /127.0.0.1:46139
[junit4:junit4]   2> 3570 T951 oaz.ClientCnxn$SendThread.primeConnection Socket connection
established to localhost.localdomain/127.0.0.1:46139, initiating session
[junit4:junit4]   2> 3570 T947 oazs.NIOServerCnxn$Factory.run Accepted socket connection
from /127.0.0.1:40409
[junit4:junit4]   2> 3570 T947 oazs.NIOServerCnxn.readConnectRequest Client attempting
to establish new session at /127.0.0.1:40409
[junit4:junit4]   2> 3570 T949 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 3638 T949 oazs.NIOServerCnxn.finishSessionInit Established session
0x13935b9d3800000 with negotiated timeout 10000 for client /127.0.0.1:40409
[junit4:junit4]   2> 3638 T951 oaz.ClientCnxn$SendThread.readConnectResult Session establishment
complete on server localhost.localdomain/127.0.0.1:46139, sessionid = 0x13935b9d3800000, negotiated
timeout = 10000
[junit4:junit4]   2> 3638 T952 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@d33c6e
name:ZooKeeperConnection Watcher:127.0.0.1:46139/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4:junit4]   2> 3639 T950 oazs.PrepRequestProcessor.pRequest Processed session termination
for sessionid: 0x13935b9d3800000
[junit4:junit4]   2> 3640 T952 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 3640 T947 oazs.NIOServerCnxn.closeSock Closed socket connection for
client /127.0.0.1:40409 which had sessionid 0x13935b9d3800000
[junit4:junit4]   2> 3640 T920 oaz.ZooKeeper.close Session: 0x13935b9d3800000 closed
[junit4:junit4]   2> 3640 T950 oazs.PrepRequestProcessor.run PrepRequestProcessor exited
loop!
[junit4:junit4]   2> 3640 T949 oazs.SyncRequestProcessor.run SyncRequestProcessor exited!
[junit4:junit4]   2> 3641 T920 oazs.FinalRequestProcessor.shutdown shutdown of request
processor complete
[junit4:junit4]   2> 3645 T947 oazs.NIOServerCnxn$Factory.run NIOServerCnxn factory exited
run method
[junit4:junit4]   2> 3645 T920 oazs.FinalRequestProcessor.shutdown shutdown of request
processor complete
[junit4:junit4]   2> 3646 T920 oasu.AbstractSolrTestCase.tearDown ####TEARDOWN_START testConnect
[junit4:junit4]   2> 3648 T920 oasu.AbstractSolrTestCase.setUp ####SETUP_START testWatchChildren
[junit4:junit4]   2> 3648 T920 oasu.AbstractSolrTestCase.setUp ####SETUP_END testWatchChildren
[junit4:junit4]   2> 3648 T920 oasc.ZkTestServer.run STARTING ZK TEST SERVER
[junit4:junit4]   2> 3649 T953 oazs.ZooKeeperServer.setTickTime tickTime set to 3000
[junit4:junit4]   2> 3649 T953 oazs.NIOServerCnxn$Factory.<init> binding to port
0.0.0.0/0.0.0.0:0
[junit4:junit4]   2> 3649 T953 oazsp.FileTxnSnapLog.save Snapshotting: 0
[junit4:junit4]   2> 3748 T920 oasc.ZkTestServer.run start zk server on port:54269
[junit4:junit4]   2> 4149 T920 oaz.ZooKeeper.<init> Initiating client connection,
connectString=127.0.0.1:54269 sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@1289f6b
[junit4:junit4]   2> 4149 T958 oaz.ClientCnxn$SendThread.startConnect Opening socket connection
to server /127.0.0.1:54269
[junit4:junit4]   2> 4150 T958 oaz.ClientCnxn$SendThread.primeConnection Socket connection
established to localhost.localdomain/127.0.0.1:54269, initiating session
[junit4:junit4]   2> 4150 T954 oazs.NIOServerCnxn$Factory.run Accepted socket connection
from /127.0.0.1:49071
[junit4:junit4]   2> 4150 T954 oazs.NIOServerCnxn.readConnectRequest Client attempting
to establish new session at /127.0.0.1:49071
[junit4:junit4]   2> 4150 T956 oazsp.FileTxnLog.append Creating new log file: log.1
[junit4:junit4]   2> 4188 T956 oazs.NIOServerCnxn.finishSessionInit Established session
0x13935b9d4330000 with negotiated timeout 10000 for client /127.0.0.1:49071
[junit4:junit4]   2> 4188 T958 oaz.ClientCnxn$SendThread.readConnectResult Session establishment
complete on server localhost.localdomain/127.0.0.1:54269, sessionid = 0x13935b9d4330000, negotiated
timeout = 10000
[junit4:junit4]   2> 4189 T959 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@1289f6b
name:ZooKeeperConnection Watcher:127.0.0.1:54269 got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4:junit4]   2> 4189 T920 oascc.SolrZkClient.makePath makePath: /solr
[junit4:junit4]   2> 4191 T957 oazs.PrepRequestProcessor.pRequest Processed session termination
for sessionid: 0x13935b9d4330000
[junit4:junit4]   2> 4191 T959 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 4192 T954 oazs.NIOServerCnxn.closeSock Closed socket connection for
client /127.0.0.1:49071 which had sessionid 0x13935b9d4330000
[junit4:junit4]   2> 4191 T920 oaz.ZooKeeper.close Session: 0x13935b9d4330000 closed
[junit4:junit4]   2> 4192 T920 oaz.ZooKeeper.<init> Initiating client connection,
connectString=127.0.0.1:54269/solr sessionTimeout=10000 watcher=org.apache.solr.common.cloud.ConnectionManager@86bdad
[junit4:junit4]   2> 4192 T960 oaz.ClientCnxn$SendThread.startConnect Opening socket connection
to server /127.0.0.1:54269
[junit4:junit4]   2> 4193 T954 oazs.NIOServerCnxn$Factory.run Accepted socket connection
from /127.0.0.1:49072
[junit4:junit4]   2> 4193 T960 oaz.ClientCnxn$SendThread.primeConnection Socket connection
established to localhost.localdomain/127.0.0.1:54269, initiating session
[junit4:junit4]   2> 4193 T954 oazs.NIOServerCnxn.readConnectRequest Client attempting
to establish new session at /127.0.0.1:49072
[junit4:junit4]   2> 4193 T956 oazs.NIOServerCnxn.finishSessionInit Established session
0x13935b9d4330001 with negotiated timeout 10000 for client /127.0.0.1:49072
[junit4:junit4]   2> 4193 T960 oaz.ClientCnxn$SendThread.readConnectResult Session establishment
complete on server localhost.localdomain/127.0.0.1:54269, sessionid = 0x13935b9d4330001, negotiated
timeout = 10000
[junit4:junit4]   2> 4193 T961 oascc.ConnectionManager.process Watcher org.apache.solr.common.cloud.ConnectionManager@86bdad
name:ZooKeeperConnection Watcher:127.0.0.1:54269/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4:junit4]   2> 4194 T920 oascc.SolrZkClient.makePath makePath: /collections
[junit4:junit4]   2> 4195 T920 oascc.SolrZkClient.makePath makePath: /collections/collection99/shards
[junit4:junit4]   2> 4198 T920 oascc.SolrZkClient.makePath makePath: collections/collection99/config=collection1
[junit4:junit4]   2> 4200 T920 oascc.SolrZkClient.makePath makePath: collections/collection99/config=collection3
[junit4:junit4]   2> 4201 T920 oascc.SolrZkClient.makePath makePath: /collections/collection97/shards
[junit4:junit4]   2> 5070 T948 oazs.SessionTrackerImpl.run SessionTrackerImpl exited loop!
[junit4:junit4]   2> 5070 T941 oazs.SessionTrackerImpl.run SessionTrackerImpl exited loop!
[junit4:junit4]   2> 12905 T957 oazs.PrepRequestProcessor.pRequest Processed session termination
for sessionid: 0x13935b9d4330001
[junit4:junit4]   2> 12905 T961 oaz.ClientCnxn$EventThread.run EventThread shut down
[junit4:junit4]   2> 12905 T954 oazs.NIOServerCnxn.closeSock Closed socket connection for
client /127.0.0.1:49072 which had sessionid 0x13935b9d4330001
[junit4:junit4]   2> 12905 T920 oaz.ZooKeeper.close Session: 0x13935b9d4330001 closed
[junit4:junit4]   2> 12905 T957 oazs.PrepRequestProcessor.run PrepRequestProcessor exited
loop!
[junit4:junit4]   2> 12905 T956 oazs.SyncRequestProcessor.run SyncRequestProcessor exited!
[junit4:junit4]   2> 12906 T920 oazs.FinalRequestProcessor.shutdown shutdown of request
processor complete
[junit4:junit4]   2> 12907 T954 oazs.NIOServerCnxn$Factory.run NIOServerCnxn factory exited
run method
[junit4:junit4]   2> 12908 T920 oazs.FinalRequestProcessor.shutdown shutdown of request
processor complete
[junit4:junit4]   2> 12908 T920 oasu.AbstractSolrTestCase.tearDown ####TEARDOWN_START testWatchChildren
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=ZkSolrClientTest -Dtests.method=testWatchChildren
-Dtests.seed=2034617253769CA8 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=hu_HU
-Dtests.timezone=Pacific/Apia -Dtests.file.encoding=US-ASCII
[junit4:junit4] FAILURE 9.29s J1 | ZkSolrClientTest.testWatchChildren <<<
[junit4:junit4]    > Throwable #1: java.lang.AssertionError: expected:<2> but was:<1>
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([2034617253769CA8:684A036E14B22613]:0)
[junit4:junit4]    > 	at org.junit.Assert.fail(Assert.java:93)
[junit4:junit4]    > 	at org.junit.Assert.failNotEquals(Assert.java:647)
[junit4:junit4]    > 	at org.junit.Assert.assertEquals(Assert.java:128)
[junit4:junit4]    > 	at org.junit.Assert.assertEquals(Assert.java:472)
[junit4:junit4]    > 	at org.junit.Assert.assertEquals(Assert.java:456)
[junit4:junit4]    > 	at org.apache.solr.cloud.ZkSolrClientTest.testWatchChildren(ZkSolrClientTest.java:218)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4]    > 	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
[junit4:junit4]    > 	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4:junit4]    > 	at java.lang.reflect.Method.invoke(Method.java:474)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:345)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:769)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:429)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4]    > 	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:40)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4]    > 	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4]    > 	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:345)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]   2> 14070 T955 oazs.SessionTrackerImpl.run SessionTrackerImpl exited loop!
[junit4:junit4]   2> NOTE: test params are: codec=Lucene40: {}, sim=RandomSimilarityProvider(queryNorm=true,coord=no):
{}, locale=hu_HU, timezone=Pacific/Apia
[junit4:junit4]   2> NOTE: Linux 3.2.0-29-generic i386/Oracle Corporation 1.8.0-ea (32-bit)/cpus=8,threads=1,free=27458768,total=86507520
[junit4:junit4]   2> NOTE: All tests run in this JVM: [TestQuerySenderListener, TestJmxIntegration,
FieldMutatingUpdateProcessorTest, TestSolrCoreProperties, TestQueryUtils, BasicFunctionalityTest,
PeerSyncTest, TestRecovery, TestFoldingMultitermQuery, TestDocSet, LukeRequestHandlerTest,
TestWriterPerf, SolrCoreTest, TestStressRecovery, TestPhraseSuggestions, CoreContainerCoreInitFailuresTest,
TestBinaryField, TestLRUCache, TestSurroundQueryParser, SolrIndexConfigTest, ClusterStateUpdateTest,
TestRemoteStreaming, SuggesterTSTTest, LeaderElectionTest, TestValueSourceCache, TestCSVLoader,
FullSolrCloudDistribCmdsTest, TestRealTimeGet, TestOmitPositions, QueryEqualityTest, MultiTermTest,
QueryParsingTest, TestReversedWildcardFilterFactory, DistributedQueryElevationComponentTest,
BasicDistributedZk2Test, TimeZoneUtilsTest, TestBM25SimilarityFactory, ZkSolrClientTest]
[junit4:junit4] Completed on J1 in 14.78s, 4 tests, 1 failure <<< FAILURES!

[...truncated 550 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:29: The following error occurred
while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:144: The following error occurred
while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/module-build.xml:62: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1105: The following
error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:797: There were test
failures: 225 suites, 906 tests, 1 failure, 7 ignored (2 assumptions)

Total time: 32 minutes 4 seconds
Build step 'Invoke Ant' marked build as failure
Recording test results
Description set: Java: 32bit/jdk1.8.0-ea-b51 -server -XX:+UseConcMarkSweepGC
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message