Tony Bussieres created BLUR-240:
-----------------------------------
Summary: BlurClusterTest Unit test failing with a no such method
error
Key: BLUR-240
URL: https://issues.apache.org/jira/browse/BLUR-240
Project: Apache Blur
Issue Type: Bug
Affects Versions: 0.3.0
Environment: Ubuntu 12.04.2 LTS
Linux 2.6.32-042stab057.1 #1 SMP Fri Jun 22 02:17:07 MSD 2012 x86_64 x86_64
x86_64 GNU/Linux
java version "1.7.0_21"
Java(TM) SE Runtime Environment (build 1.7.0_21-b11)
Java HotSpot(TM) 64-Bit Server VM (build 23.21-b01, mixed mode)
commit aeba56bdf30997f8516837c600e856334131ef8d
(2f9e54b7e0bc1da65ca0a84cfca0bf13319f44e9 + license patch from issue BLUR-239)
Reporter: Tony Bussieres
Priority: Minor
Likely to be a version mismatch in the pom.xml ?
Running org.apache.blur.thrift.BlurClusterTest
INFO 20130920_13:08:58:058_EDT [main] utils.GCWatcher: GCWatcher was setup.
INFO 20130920_13:08:58:058_EDT [gc-watch] utils.GCWatcher: totalTime spent in
GC [132 ms] collected [36,953,400 bytes]
INFO 20130920_13:08:58:058_EDT [main] mortbay.log: jetty-6.1.26
INFO 20130920_13:08:58:058_EDT [main] mortbay.log: Extract
jar:file:/home/tbussier/.m2/repository/org/apache/hadoop/hadoop-core/1.2.1/hadoop-core-1.2.1.jar!/webapps/hdfs
to /tmp/Jetty_localhost_59000_hdfs____.c461je/webapp
INFO 20130920_13:08:58:058_EDT [main] mortbay.log: Started
SelectChannelConnector@localhost:59000
Starting DataNode 0 with dfs.data.dir:
file:/home/tbussier/incubator-blur/blur-core/target/target/tmp/blur-cluster-test/cluster/hdfs/dfs/data/data1,file:/home/tbussier/incubator-blur/blur-core/target/target/tmp/blur-cluster-test/cluster/hdfs/dfs/data/data2
INFO 20130920_13:08:58:058_EDT [main] mortbay.log: jetty-6.1.26
INFO 20130920_13:08:58:058_EDT [main] mortbay.log: Extract
jar:file:/home/tbussier/.m2/repository/org/apache/hadoop/hadoop-core/1.2.1/hadoop-core-1.2.1.jar!/webapps/datanode
to /tmp/Jetty_localhost_60828_datanode____.b9vc0l/webapp
INFO 20130920_13:08:58:058_EDT [main] mortbay.log: Started
SelectChannelConnector@localhost:60828
Cluster is active
Cluster is active
INFO 20130920_13:08:58:058_EDT [Thread-956] server.ZooKeeperServerMain:
Starting server
INFO 20130920_13:08:58:058_EDT [Thread-956] server.ZooKeeperServer: tickTime
set to 2000
INFO 20130920_13:08:58:058_EDT [Thread-956] server.ZooKeeperServer:
minSessionTimeout set to -1
INFO 20130920_13:08:58:058_EDT [Thread-956] server.ZooKeeperServer:
maxSessionTimeout set to -1
INFO 20130920_13:08:58:058_EDT [Thread-956] server.NIOServerCnxnFactory:
binding to port 0.0.0.0/0.0.0.0:21810
INFO 20130920_13:08:58:058_EDT [Thread-956] persistence.FileTxnSnapLog:
Snapshotting: 0x0 to
file:/home/tbussier/incubator-blur/blur-core/target/target/tmp/blur-cluster-test/cluster/zk/zk_test/version-2/snapshot.0
INFO 20130920_13:08:58:058_EDT [main] zookeeper.ZooKeeper: Initiating client
connection, connectString=localhost:21810 sessionTimeout=30000
watcher=org.apache.blur.MiniCluster$5@7f1ba300
INFO 20130920_13:08:58:058_EDT [main-EventThread] zookeeper.ClientCnxn:
EventThread shut down
INFO 20130920_13:08:58:058_EDT [main] zookeeper.ZooKeeper: Session: 0x0 closed
INFO 20130920_13:08:58:058_EDT [main] thrift.ThriftBlurControllerServer: Shard
Server using index [0] bind address [0.0.0.0:40010]
INFO 20130920_13:08:58:058_EDT [main] zookeeper.ZooKeeper: Initiating client
connection, connectString=localhost:21810 sessionTimeout=90000
watcher=org.apache.blur.zookeeper.ZkUtils$ConnectionWatcher@2b01ad2b
INFO 20130920_13:08:58:058_EDT [main-SendThread(localhost:21810)]
zookeeper.ClientCnxn: Opening socket connection to server
localhost/0:0:0:0:0:0:0:1:21810. Will not attempt to authenticate using SASL
(unknown error)
INFO 20130920_13:08:58:058_EDT [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:21810]
server.NIOServerCnxnFactory: Accepted socket connection from
/0:0:0:0:0:0:0:1:57660
INFO 20130920_13:08:58:058_EDT [main-SendThread(localhost:21810)]
zookeeper.ClientCnxn: Socket connection established to
localhost/0:0:0:0:0:0:0:1:21810, initiating session
INFO 20130920_13:08:58:058_EDT [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:21810]
server.ZooKeeperServer: Client attempting to establish new session at
/0:0:0:0:0:0:0:1:57660
INFO 20130920_13:08:58:058_EDT [SyncThread:0] persistence.FileTxnLog: Creating
new log file: log.1
INFO 20130920_13:08:58:058_EDT [SyncThread:0] server.ZooKeeperServer:
Established session 0x1413c588ef60000 with negotiated timeout 40000 for client
/0:0:0:0:0:0:0:1:57660
INFO 20130920_13:08:58:058_EDT [main-SendThread(localhost:21810)]
zookeeper.ClientCnxn: Session establishment complete on server
localhost/0:0:0:0:0:0:0:1:21810, sessionid = 0x1413c588ef60000, negotiated
timeout = 40000
INFO 20130920_13:08:58:058_EDT [main-EventThread] zookeeper.ZkUtils: ZooKeeper
[localhost:21810] timeout [90,000] changed to [SyncConnected] state
WARN 20130920_13:08:59:059_EDT [Watch Children
[/blur/clusters][0578ae54-640b-4500-ac3c-6ab2a0b9913d]]
zookeeper.WatchNodeExistance: Closing [85735304-4b59-4cc1-863b-d914bb56ff80]
WARN 20130920_13:08:59:059_EDT [Watch Children
[/blur/clusters][0578ae54-640b-4500-ac3c-6ab2a0b9913d]]
zookeeper.WatchNodeExistance: Closing [f7150a06-7939-4430-b976-a1db9fded1d4]
INFO 20130920_13:08:59:059_EDT [Watch Children
[/blur/clusters/default/tables][0c4defbf-0e89-4086-af64-001de0b81a54]]
thrift.BlurControllerServer: Layout change.
INFO 20130920_13:08:59:059_EDT [Watch Children
[/blur/clusters/default/online-nodes][00785eba-66f5-40e1-b25d-94122e7fa584]]
thrift.BlurControllerServer: Layout change.
WARN 20130920_13:08:59:059_EDT [main] zookeeper.WatchChildren: Closing
[0578ae54-640b-4500-ac3c-6ab2a0b9913d]
WARN 20130920_13:08:59:059_EDT [main] zookeeper.WatchChildren: Closing
[00785eba-66f5-40e1-b25d-94122e7fa584]
WARN 20130920_13:08:59:059_EDT [main] zookeeper.WatchNodeExistance: Closing
[d7b038f7-cd9c-4fc1-9474-a580eacd8da6]
WARN 20130920_13:08:59:059_EDT [main] zookeeper.WatchChildren: Closing
[0c4defbf-0e89-4086-af64-001de0b81a54]
WARN 20130920_13:08:59:059_EDT [main] zookeeper.WatchNodeExistance: Closing
[45d97866-7abe-4e40-a66d-572d29e6d6ee]
WARN 20130920_13:08:59:059_EDT [main] zookeeper.WatchChildren: Closing
[82ebb44c-5850-470e-8763-e11ae9edef80]
WARN 20130920_13:08:59:059_EDT [main] zookeeper.WatchChildren: Closing
[7fef3edb-b7e0-4cfb-a194-4c8d44ebfe34]
INFO 20130920_13:08:59:059_EDT [ProcessThread(sid:0 cport:-1):]
server.PrepRequestProcessor: Processed session termination for sessionid:
0x1413c588ef60000
INFO 20130920_13:08:59:059_EDT [main] zookeeper.ZooKeeper: Session:
0x1413c588ef60000 closed
INFO 20130920_13:08:59:059_EDT [NIOServerCxn.Factory:0.0.0.0/0.0.0.0:21810]
server.NIOServerCnxn: Closed socket connection for client
/0:0:0:0:0:0:0:1:57660 which had sessionid 0x1413c588ef60000
INFO 20130920_13:08:59:059_EDT [main-EventThread] zookeeper.ClientCnxn:
EventThread shut down
Tests run: 2, Failures: 0, Errors: 2, Skipped: 0, Time elapsed: 1.848 sec <<<
FAILURE!
org.apache.blur.thrift.BlurClusterTest Time elapsed: 1.848 sec <<< ERROR!
java.lang.NoSuchMethodError:
org.apache.blur.thrift.Connection.getConnectionStr()Ljava/lang/Object;
at org.apache.blur.MiniCluster.startControllers(MiniCluster.java:243)
at org.apache.blur.MiniCluster.startControllers(MiniCluster.java:201)
at org.apache.blur.MiniCluster.startBlurCluster(MiniCluster.java:138)
at
org.apache.blur.thrift.BlurClusterTest.startCluster(BlurClusterTest.java:94)
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:601)
at
org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
at
org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
at
org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
at
org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:27)
at
org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
at
org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:252)
at
org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:141)
at
org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:112)
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:601)
at
org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189)
at
org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165)
at
org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85)
at
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:115)
at
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:75)
org.apache.blur.thrift.BlurClusterTest Time elapsed: 1.848 sec <<< ERROR!
java.lang.NullPointerException
at org.apache.blur.thrift.ThriftServer.close(ThriftServer.java:157)
at org.apache.blur.MiniCluster.stopControllers(MiniCluster.java:189)
at org.apache.blur.MiniCluster.shutdownBlurCluster(MiniCluster.java:148)
at
org.apache.blur.thrift.BlurClusterTest.shutdownCluster(BlurClusterTest.java:99)
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:601)
at
org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
at
org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
at
org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
at
org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:37)
at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
at
org.apache.maven.surefire.junit4.JUnit4Provider.execute(JUnit4Provider.java:252)
at
org.apache.maven.surefire.junit4.JUnit4Provider.executeTestSet(JUnit4Provider.java:141)
at
org.apache.maven.surefire.junit4.JUnit4Provider.invoke(JUnit4Provider.java:112)
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:601)
at
org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189)
at
org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165)
at
org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85)
at
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:115)
at
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:75)
INFO 20130920_13:09:00:000_EDT [Thread-975] indexserver.BlurServerShutDown:
Closing zookeeper.
--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira
