You are viewing a plain text version of this content. The canonical link for it is here.
Posted to commits@cassandra.apache.org by "Cyril Scetbon (JIRA)" <ji...@apache.org> on 2015/11/24 17:35:11 UTC
[jira] [Comment Edited] (CASSANDRA-10751) "Pool is shutdown" error
when running Hadoop jobs on Yarn
[ https://issues.apache.org/jira/browse/CASSANDRA-10751?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15024784#comment-15024784 ]
Cyril Scetbon edited comment on CASSANDRA-10751 at 11/24/15 4:34 PM:
---------------------------------------------------------------------
[~alexliu68] The number of splits has not changed and is the same as with 2.0.12. The strange errors are :
{code}
15/11/24 15:26:32 [cluster2-blocking-task-worker-1]: DEBUG core.HostConnectionPool: Creating new connection on busy pool to /10.234.62.20:9042
15/11/24 15:26:32 [cluster2-blocking-task-worker-0]: DEBUG core.HostConnectionPool: Creating new connection on busy pool to /10.234.62.20:9042
15/11/24 15:26:32 [cluster2-nio-worker-34]: DEBUG core.Connection: Connection[/10.234.62.20:9042-5, inFlight=0, closed=false] Connection opened successfully
15/11/24 15:26:32 [cluster2-nio-worker-35]: DEBUG core.Connection: Connection[/10.234.62.20:9042-6, inFlight=0, closed=false] Connection opened successfully
15/11/24 15:26:32 [cluster2-nio-worker-34]: DEBUG Host.STATES: [/10.234.62.20:9042] new connection created, total = 1
15/11/24 15:26:32 [cluster2-nio-worker-35]: DEBUG Host.STATES: [/10.234.62.20:9042] new connection created, total = 2
15/11/24 15:26:32 [cluster2-nio-worker-35]: DEBUG core.Connection: Connection[/10.234.62.20:9042-6, inFlight=0, closed=true] closing connection
15/11/24 15:26:32 [cluster2-nio-worker-34]: DEBUG core.Connection: Connection[/10.234.62.20:9042-5, inFlight=0, closed=true] closing connection
15/11/24 15:26:32 [cluster2-nio-worker-35]: DEBUG Host.STATES: [/10.234.62.20:9042] connection closed, remaining = 1
15/11/24 15:26:32 [cluster2-nio-worker-34]: DEBUG Host.STATES: [/10.234.62.20:9042] connection closed, remaining = 0
15/11/24 15:26:32 [cluster2-nio-worker-35]: DEBUG core.Connection: Connection[/10.234.62.20:9042-6, inFlight=0, closed=true] has already terminated
15/11/24 15:26:32 [cluster2-nio-worker-34]: DEBUG core.Connection: Connection[/10.234.62.20:9042-5, inFlight=0, closed=true] has already terminated
15/11/24 15:26:32 [cluster2-blocking-task-worker-0]: DEBUG Host.STATES: Defuncting Connection[/10.234.62.20:9042-6, inFlight=0, closed=true] because: [/10.234.62.20:9042] Error while setting keyspace
{code}
I can see that the error "Error while setting keyspace" is displayed when there is a ExecutionException. It just weird that it happens so quickly ...
was (Author: cscetbon):
[~alexliu68] The number of splits has not changed and is the same as with 2.0.12. The strange errors are :
{code}
15/11/24 15:26:32 [cluster2-blocking-task-worker-1]: DEBUG core.HostConnectionPool: Creating new connection on busy pool to /10.234.62.20:9042
15/11/24 15:26:32 [cluster2-blocking-task-worker-0]: DEBUG core.HostConnectionPool: Creating new connection on busy pool to /10.234.62.20:9042
15/11/24 15:26:32 [cluster2-nio-worker-34]: DEBUG core.Connection: Connection[/10.234.62.20:9042-5, inFlight=0, closed=false] Connection opened successfully
15/11/24 15:26:32 [cluster2-nio-worker-35]: DEBUG core.Connection: Connection[/10.234.62.20:9042-6, inFlight=0, closed=false] Connection opened successfully
15/11/24 15:26:32 [cluster2-nio-worker-34]: DEBUG Host.STATES: [/10.234.62.20:9042] new connection created, total = 1
15/11/24 15:26:32 [cluster2-nio-worker-35]: DEBUG Host.STATES: [/10.234.62.20:9042] new connection created, total = 2
15/11/24 15:26:32 [cluster2-nio-worker-35]: DEBUG core.Connection: Connection[/10.234.62.20:9042-6, inFlight=0, closed=true] closing connection
15/11/24 15:26:32 [cluster2-nio-worker-34]: DEBUG core.Connection: Connection[/10.234.62.20:9042-5, inFlight=0, closed=true] closing connection
15/11/24 15:26:32 [cluster2-nio-worker-35]: DEBUG Host.STATES: [/10.234.62.20:9042] connection closed, remaining = 1
15/11/24 15:26:32 [cluster2-nio-worker-34]: DEBUG Host.STATES: [/10.234.62.20:9042] connection closed, remaining = 0
15/11/24 15:26:32 [cluster2-nio-worker-35]: DEBUG core.Connection: Connection[/10.234.62.20:9042-6, inFlight=0, closed=true] has already terminated
15/11/24 15:26:32 [cluster2-nio-worker-34]: DEBUG core.Connection: Connection[/10.234.62.20:9042-5, inFlight=0, closed=true] has already terminated
15/11/24 15:26:32 [cluster2-blocking-task-worker-0]: DEBUG Host.STATES: Defuncting Connection[/10.234.62.20:9042-6, inFlight=0, closed=true] because: [/10.234.62.20:9042] Error while setting keyspace
{code}
I can see that the error "Error while setting keyspace" is displayed when there is a BusyConnectionException. It just weird that it happens so quickly ...
> "Pool is shutdown" error when running Hadoop jobs on Yarn
> ---------------------------------------------------------
>
> Key: CASSANDRA-10751
> URL: https://issues.apache.org/jira/browse/CASSANDRA-10751
> Project: Cassandra
> Issue Type: Bug
> Environment: Hadoop 2.7.1 (HDP 2.3.2)
> Cassandra 2.1.11
> Reporter: Cyril Scetbon
> Assignee: Alex Liu
> Attachments: output.log
>
>
> Trying to execute an Hadoop job on Yarn, I get errors from Cassandra's internal code. It seems that connections are shutdown but we can't understand why ...
> Here is a subtract of the errors. I also add a file with the complete debug logs.
> {code}
> 15/11/22 20:05:54 [main]: DEBUG core.RequestHandler: Error querying node006.internal.net/192.168.12.22:9042, trying next host (error is: com.datastax.driver.core.ConnectionException: [node006.internal.net/192.168.12.22:9042] Pool is shutdown)
> Failed with exception java.io.IOException:java.io.IOException: com.datastax.driver.core.exceptions.NoHostAvailableException: All host(s) tried for query failed (tried: node006.internal.net/192.168.12.22:9042 (com.datastax.driver.core.ConnectionException: [node006.internal.net/192.168.12.22:9042] Pool is shutdown))
> 15/11/22 20:05:54 [main]: ERROR CliDriver: Failed with exception java.io.IOException:java.io.IOException: com.datastax.driver.core.exceptions.NoHostAvailableException: All host(s) tried for query failed (tried: node006.internal.net/192.168.12.22:9042 (com.datastax.driver.core.ConnectionException: [node006.internal.net/192.168.12.22:9042] Pool is shutdown))
> java.io.IOException: java.io.IOException: com.datastax.driver.core.exceptions.NoHostAvailableException: All host(s) tried for query failed (tried: node006.internal.net/192.168.12.22:9042 (com.datastax.driver.core.ConnectionException: [node006.internal.net/192.168.12.22:9042] Pool is shutdown))
> at org.apache.hadoop.hive.ql.exec.FetchOperator.getNextRow(FetchOperator.java:508)
> at org.apache.hadoop.hive.ql.exec.FetchOperator.pushRow(FetchOperator.java:415)
> at org.apache.hadoop.hive.ql.exec.FetchTask.fetch(FetchTask.java:140)
> at org.apache.hadoop.hive.ql.Driver.getResults(Driver.java:1672)
> at org.apache.hadoop.hive.cli.CliDriver.processLocalCmd(CliDriver.java:233)
> at org.apache.hadoop.hive.cli.CliDriver.processCmd(CliDriver.java:165)
> at org.apache.hadoop.hive.cli.CliDriver.processLine(CliDriver.java:376)
> at org.apache.hadoop.hive.cli.CliDriver.executeDriver(CliDriver.java:736)
> at org.apache.hadoop.hive.cli.CliDriver.run(CliDriver.java:681)
> at org.apache.hadoop.hive.cli.CliDriver.main(CliDriver.java:621)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:497)
> at org.apache.hadoop.util.RunJar.run(RunJar.java:221)
> at org.apache.hadoop.util.RunJar.main(RunJar.java:136)
> Caused by: java.io.IOException: com.datastax.driver.core.exceptions.NoHostAvailableException: All host(s) tried for query failed (tried: node006.internal.net/192.168.12.22:9042 (com.datastax.driver.core.ConnectionException: [node006.internal.net/192.168.12.22:9042] Pool is shutdown))
> at org.apache.hadoop.hive.cassandra.input.cql.HiveCqlInputFormat.getRecordReader(HiveCqlInputFormat.java:132)
> at org.apache.hadoop.hive.ql.exec.FetchOperator$FetchInputFormatSplit.getRecordReader(FetchOperator.java:674)
> at org.apache.hadoop.hive.ql.exec.FetchOperator.getRecordReader(FetchOperator.java:324)
> at org.apache.hadoop.hive.ql.exec.FetchOperator.getNextRow(FetchOperator.java:446)
> ... 15 more
> Caused by: com.datastax.driver.core.exceptions.NoHostAvailableException: All host(s) tried for query failed (tried: node006.internal.net/192.168.12.22:9042 (com.datastax.driver.core.ConnectionException: [node006.internal.net/192.168.12.22:9042] Pool is shutdown))
> at com.datastax.driver.core.exceptions.NoHostAvailableException.copy(NoHostAvailableException.java:84)
> at com.datastax.driver.core.DriverThrowables.propagateCause(DriverThrowables.java:37)
> at com.datastax.driver.core.DefaultResultSetFuture.getUninterruptibly(DefaultResultSetFuture.java:214)
> at com.datastax.driver.core.AbstractSession.execute(AbstractSession.java:52)
> at com.datastax.driver.core.AbstractSession.execute(AbstractSession.java:36)
> at org.apache.cassandra.hadoop.cql3.CqlRecordReader.fetchKeys(CqlRecordReader.java:578)
> at org.apache.cassandra.hadoop.cql3.CqlRecordReader.buildQuery(CqlRecordReader.java:526)
> at org.apache.cassandra.hadoop.cql3.CqlRecordReader.initialize(CqlRecordReader.java:148)
> {code}
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)