cassandra-commits mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Paulo Motta (JIRA)" <j...@apache.org>
Subject [jira] [Commented] (CASSANDRA-10963) Bootstrap stream fails with java.lang.InterruptedException
Date Tue, 12 Jan 2016 22:49:40 GMT

    [ https://issues.apache.org/jira/browse/CASSANDRA-10963?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15095145#comment-15095145
] 

Paulo Motta commented on CASSANDRA-10963:
-----------------------------------------

You're most likely running into CASSANDRA-10797, which was fixed only on 3.0+. Workaround
on 2.2 is to temporarily increase heap of joining node during bootstrap, and potentially combine
with G1 GC which is more efficient than CMS for larger heaps.

> Bootstrap stream fails with java.lang.InterruptedException 
> -----------------------------------------------------------
>
>                 Key: CASSANDRA-10963
>                 URL: https://issues.apache.org/jira/browse/CASSANDRA-10963
>             Project: Cassandra
>          Issue Type: Bug
>          Components: Streaming and Messaging
>         Environment: [cqlsh 5.0.1 | Cassandra 2.2.4 | CQL spec 3.3.1 | Native protocol
v4]
> java version "1.8.0_65"
>            Reporter: Jack Money
>            Assignee: Paulo Motta
>
> hello
> I got 2 nodes in 2 DC.
> Each node own 100% data of keyspace hugespace.
> Keyspace have 21 tables with 2TB data
> Biggest table have 1.6 TB of data.
> Biggest sstable 1,3 TB.
> Schemats:
> {noformat} 
> KEYSPACE hugespace WITH replication = {'class': 'NetworkTopologyStrategy', 'DC1': '3',
'DC2': '1'};
> CREATE TABLE hugespace.content (
>     y int,
>     m int,
>     d int,
>     ts bigint,
>     ha text,
>     co text,
>     he text,
>     ids bigint,
>     ifr text,
>     js text,
>     PRIMARY KEY ((y, m, d), ts, ha)
> ) WITH CLUSTERING ORDER BY (ts ASC, ha ASC)
>     AND bloom_filter_fp_chance = 0.01
>     AND caching = '{"keys":"ALL", "rows_per_partition":"NONE"}'
>     AND comment = ''
>     AND compaction = {'class': 'org.apache.cassandra.db.compaction.SizeTieredCompactionStrategy'}
>     AND compression = {'sstable_compression': 'org.apache.cassandra.io.compress.LZ4Compressor'}
>     AND dclocal_read_repair_chance = 0.1
>     AND default_time_to_live = 0
>     AND gc_grace_seconds = 864000
>     AND max_index_interval = 2048
>     AND memtable_flush_period_in_ms = 0
>     AND min_index_interval = 128
>     AND read_repair_chance = 0.0
>     AND speculative_retry = '99.0PERCENTILE';
> CREATE INDEX content_ids_idx ON hugespace.content (ids);
> {noformat}
> I tried to add one node (target 6 node in DC1) to DC1.
> Names:
> Existing node in DC1 = nodeDC1
> Existing node in DC2 = nodeDC2
> New node joining DC1 = joiningDC1
> joiningDC1
> {noformat} 
> INFO  [main] 2016-01-04 12:17:55,535 StorageService.java:1176 - JOINING: Starting to
bootstrap...
> INFO  [main] 2016-01-04 12:17:55,802 StreamResultFuture.java:86 - [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4]
Executing streaming plan for Bootstrap
> INFO  [StreamConnectionEstablisher:1] 2016-01-04 12:17:55,803 StreamSession.java:232
- [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4] Starting streaming to /nodeDC1
> INFO  [StreamConnectionEstablisher:2] 2016-01-04 12:17:55,803 StreamSession.java:232
- [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4] Starting streaming to /nodeDC2
> DEBUG [StreamConnectionEstablisher:2] 2016-01-04 12:17:55,803 ConnectionHandler.java:82
- [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4] Sending stream init for incoming stream
> DEBUG [StreamConnectionEstablisher:1] 2016-01-04 12:17:55,803 ConnectionHandler.java:82
- [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4] Sending stream init for incoming stream
> DEBUG [StreamConnectionEstablisher:1] 2016-01-04 12:17:55,806 ConnectionHandler.java:87
- [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4] Sending stream init for outgoing stream
> DEBUG [StreamConnectionEstablisher:2] 2016-01-04 12:17:55,806 ConnectionHandler.java:87
- [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4] Sending stream init for outgoing stream
> DEBUG [STREAM-OUT-/nodeDC1] 2016-01-04 12:17:55,810 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending Prepare (5 requests,  0 files}
> DEBUG [STREAM-OUT-/nodeDC2] 2016-01-04 12:17:55,810 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending Prepare (2 requests,  0 files}
> INFO  [StreamConnectionEstablisher:2] 2016-01-04 12:17:55,810 StreamCoordinator.java:213
- [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4, ID#0] Beginning stream session with /nodeDC2
> INFO  [StreamConnectionEstablisher:1] 2016-01-04 12:17:55,810 StreamCoordinator.java:213
- [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4, ID#0] Beginning stream session with /nodeDC1
> DEBUG [STREAM-IN-/nodeDC2] 2016-01-04 12:17:55,821 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received Prepare (0 requests,  1 files}
> INFO  [STREAM-IN-/nodeDC2] 2016-01-04 12:17:55,822 StreamResultFuture.java:168 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4 ID#0] Prepare completed. Receiving 1 files(161 bytes),
sending 0 files(0 bytes)
> DEBUG [STREAM-IN-/nodeDC2] 2016-01-04 12:17:55,828 CompressedStreamReader.java:67 - reading
file from /nodeDC2, repairedAt = 1451483586917
> DEBUG [STREAM-IN-/nodeDC2] 2016-01-04 12:17:55,831 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received File (Header (cfId: 5bc52802-de25-35ed-aeab-188eecebb090,
#0, version: la, format: BIG, estimated keys: 128, transfer size: 161, compressed?: true,
repairedAt: 1451483586917, level: 0), file: /cassandra/data/system_auth/roles-5bc52802de2535edaeab188eecebb090/tmp-la-1-big-Data.db)
> DEBUG [STREAM-OUT-/nodeDC2] 2016-01-04 12:17:55,831 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending Received (5bc52802-de25-35ed-aeab-188eecebb090,
#0)
> DEBUG [STREAM-IN-/nodeDC2] 2016-01-04 12:17:55,832 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received Complete
> DEBUG [STREAM-OUT-/nodeDC2] 2016-01-04 12:17:56,049 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending Complete
> DEBUG [StreamReceiveTask:1] 2016-01-04 12:17:56,049 ConnectionHandler.java:110 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Closing stream connection handler on /nodeDC2
> INFO  [StreamReceiveTask:1] 2016-01-04 12:17:56,049 StreamResultFuture.java:182 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Session with /nodeDC2 is complete
> DEBUG [STREAM-IN-/nodeDC1] 2016-01-04 12:17:56,848 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received Prepare (0 requests,  194 files}
> INFO  [STREAM-IN-/nodeDC1] 2016-01-04 12:17:56,849 StreamResultFuture.java:168 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4 ID#0] Prepare completed. Receiving 194 files(2130405704708
bytes), sending 0 files(0 bytes)
> DEBUG [STREAM-IN-/nodeDC1] 2016-01-04 12:17:56,882 CompressedStreamReader.java:67 - reading
file from /nodeDC1, repairedAt = 1451476116723
> DEBUG [STREAM-IN-/nodeDC1] 2016-01-04 12:18:01,418 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received File (Header (cfId: 99e93a30-814a-11e5-a573-a94b3a1b0e16,
#0, version: la, format: BIG, estimated keys: 128, transfer size: 56333243, compressed?: true,
repairedAt: 1451476116723, level: 0), file: /cassandra/data/hugespace/other_data-99e93a30814a11e5a573a94b3a1b0e16/tmp-la-1-big-Data.db)
> DEBUG [STREAM-OUT-/nodeDC1] 2016-01-04 12:18:01,419 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending Received (99e93a30-814a-11e5-a573-a94b3a1b0e16,
#0)
> DEBUG [STREAM-IN-/nodeDC1] 2016-01-04 12:18:01,596 CompressedStreamReader.java:67 - reading
file from /nodeDC1, repairedAt = 0
> DEBUG [STREAM-IN-/nodeDC1] 2016-01-04 12:18:55,371 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received File (Header (cfId: a5f46580-9e5e-11e5-9e43-a94b3a1b0e16,
#2, version: la, format: BIG, estimated keys: 128, transfer size: 1693486699, compressed?:
true, repairedAt: 0, level: 0), file: /cassandra/data/hugespace/content_demo-a5f465809e5e11e59e43a94b3a1b0e16/tmp-la-1-big-Data.db)
> DEBUG [STREAM-OUT-/nodeDC1] 2016-01-04 12:18:55,374 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending Received (a5f46580-9e5e-11e5-9e43-a94b3a1b0e16,
#2)
> ERROR [Thread-4] 2016-01-04 12:18:55,375 CassandraDaemon.java:185 - Exception in thread
Thread[Thread-4,5,main]
> java.lang.RuntimeException: java.lang.InterruptedException
>         at com.google.common.base.Throwables.propagate(Throwables.java:160) ~[guava-16.0.jar:na]
>         at org.apache.cassandra.utils.WrappedRunnable.run(WrappedRunnable.java:32) ~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) ~[na:1.8.0_65]
> Caused by: java.lang.InterruptedException: null
>         at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1220)
~[na:1.8.0_65]
>         at java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:335)
~[na:1.8.0_65]
>         at java.util.concurrent.ArrayBlockingQueue.put(ArrayBlockingQueue.java:350) ~[na:1.8.0_65]
>         at org.apache.cassandra.streaming.compress.CompressedInputStream$Reader.runMayThrow(CompressedInputStream.java:176)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.utils.WrappedRunnable.run(WrappedRunnable.java:28) ~[apache-cassandra-2.2.4.jar:2.2.4]
>         ... 1 common frames omitted
> ERROR [STREAM-IN-/nodeDC1] 2016-01-04 12:18:55,375 StreamSession.java:524 - [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4]
Streaming error occurred
> java.nio.channels.ClosedChannelException: null
>         at sun.nio.ch.SocketChannelImpl.ensureReadOpen(SocketChannelImpl.java:257) ~[na:1.8.0_65]
>         at sun.nio.ch.SocketChannelImpl.read(SocketChannelImpl.java:300) ~[na:1.8.0_65]
>         at org.apache.cassandra.streaming.messages.StreamMessage.deserialize(StreamMessage.java:53)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$IncomingMessageHandler.run(ConnectionHandler.java:261)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) [na:1.8.0_65]
> DEBUG [STREAM-OUT-/nodeDC1] 2016-01-04 12:18:55,376 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending Session Failed
> DEBUG [STREAM-IN-/nodeDC1] 2016-01-04 12:18:55,488 ConnectionHandler.java:110 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Closing stream connection handler on /nodeDC1
> INFO  [STREAM-IN-/nodeDC1] 2016-01-04 12:18:55,489 StreamResultFuture.java:182 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Session with /nodeDC1 is complete
> WARN  [STREAM-IN-/nodeDC1] 2016-01-04 12:18:55,489 StreamResultFuture.java:209 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Stream failed
> ERROR [main] 2016-01-04 12:18:55,490 StorageService.java:1245 - Error while waiting on
bootstrap to complete. Bootstrap will have to be restarted.
> java.util.concurrent.ExecutionException: org.apache.cassandra.streaming.StreamException:
Stream failed
>         at com.google.common.util.concurrent.AbstractFuture$Sync.getValue(AbstractFuture.java:299)
~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.AbstractFuture$Sync.get(AbstractFuture.java:286)
~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.AbstractFuture.get(AbstractFuture.java:116)
~[guava-16.0.jar:na]
>         at org.apache.cassandra.service.StorageService.bootstrap(StorageService.java:1240)
[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.service.StorageService.joinTokenRing(StorageService.java:920)
[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.service.StorageService.initServer(StorageService.java:705)
[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.service.StorageService.initServer(StorageService.java:581)
[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.service.CassandraDaemon.setup(CassandraDaemon.java:315)
[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.service.CassandraDaemon.activate(CassandraDaemon.java:529)
[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.service.CassandraDaemon.main(CassandraDaemon.java:638)
[apache-cassandra-2.2.4.jar:2.2.4]
> Caused by: org.apache.cassandra.streaming.StreamException: Stream failed
>         at org.apache.cassandra.streaming.management.StreamEventJMXNotifier.onFailure(StreamEventJMXNotifier.java:85)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at com.google.common.util.concurrent.Futures$4.run(Futures.java:1172) ~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.MoreExecutors$SameThreadExecutorService.execute(MoreExecutors.java:297)
~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.ExecutionList.executeListener(ExecutionList.java:156)
~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.ExecutionList.execute(ExecutionList.java:145)
~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.AbstractFuture.setException(AbstractFuture.java:202)
~[guava-16.0.jar:na]
>         at org.apache.cassandra.streaming.StreamResultFuture.maybeComplete(StreamResultFuture.java:210)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.StreamResultFuture.handleSessionComplete(StreamResultFuture.java:186)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.StreamSession.closeSession(StreamSession.java:434)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.StreamSession.onError(StreamSession.java:529)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$IncomingMessageHandler.run(ConnectionHandler.java:279)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) ~[na:1.8.0_65]
> WARN  [main] 2016-01-04 12:18:55,496 StorageService.java:975 - Some data streaming failed.
Use nodetool to check bootstrap state and resume. For more, see `nodetool help bootstrap`.
IN_PROGRESS
> {noformat} 
> nodeDC1
> {noformat} 
> DEBUG [STREAM-OUT-/joiningDC1] 2016-01-04 12:17:56,848 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending Prepare (0 requests,  194 files}
> INFO  [STREAM-IN-/joiningDC1] 2016-01-04 12:17:56,848 StreamResultFuture.java:168 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4 ID#0] Prepare completed. Receiving 0 files(0 bytes),
sending 194 files 2130405704708 bytes)
> DEBUG [STREAM-OUT-/joiningDC1] 2016-01-04 12:17:56,851 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending File (Header (cfId: 99e93a30-814a-11e5-a573-a94b3a1b0e16,
#0, version: la, format: BIG, estimated keys: 128, transfer size: 56333243, compressed?: true,
repairedAt: 1451476116723, level: 0), file: /cassandra/data/hugespace/other_data-99e93a30814a11e5a573a94b3a1b0e16/la-202-big-Data.db)
> DEBUG [STREAM-OUT-/joiningDC1] 2016-01-04 12:17:59,596 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending File (Header (cfId: a5f46580-9e5e-11e5-9e43-a94b3a1b0e16,
#2, version: la, format: BIG, estimated keys: 128, transfer size: 1693486699, compressed?:
true, repairedAt: 0, level: 0), file: /cassandra/data/hugespace/content_demo-a5f465809e5e11e59e43a94b3a1b0e16/la-1280-big-Data.db)
> DEBUG [STREAM-IN-/joiningDC1] 2016-01-04 12:18:01,422 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received Received (99e93a30-814a-11e5-a573-a94b3a1b0e16,
#0)
> DEBUG [STREAM-IN-/joiningDC1] 2016-01-04 12:18:55,375 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received Received (a5f46580-9e5e-11e5-9e43-a94b3a1b0e16,
#2)
> DEBUG [STREAM-IN-/joiningDC1] 2016-01-04 12:18:55,920 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received Session Failed
> DEBUG [STREAM-IN-/joiningDC1] 2016-01-04 12:18:55,920 ConnectionHandler.java:110 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Closing stream connection handler on /joiningDC1
> INFO  [STREAM-IN-/joiningDC1] 2016-01-04 12:18:55,921 StreamResultFuture.java:182 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Session with /joiningDC1 is complete
> WARN  [STREAM-IN-/joiningDC1] 2016-01-04 12:18:55,923 StreamResultFuture.java:209 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Stream failed
> ERROR [STREAM-OUT-/joiningDC1] 2016-01-04 12:18:55,925 StreamSession.java:524 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Streaming error occurred
> org.apache.cassandra.io.FSReadError: java.io.IOException: Broken pipe
>         at org.apache.cassandra.io.util.ChannelProxy.transferTo(ChannelProxy.java:144)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.compress.CompressedStreamWriter$1.apply(CompressedStreamWriter.java:79)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.compress.CompressedStreamWriter$1.apply(CompressedStreamWriter.java:76)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.io.util.BufferedDataOutputStreamPlus.applyToChannel(BufferedDataOutputStreamPlus.java:297)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.compress.CompressedStreamWriter.write(CompressedStreamWriter.java:75)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.OutgoingFileMessage.serialize(OutgoingFileMessage.java:90)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.OutgoingFileMessage$1.serialize(OutgoingFileMessage.java:48)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.OutgoingFileMessage$1.serialize(OutgoingFileMessage.java:40)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.StreamMessage.serialize(StreamMessage.java:47)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$OutgoingMessageHandler.sendMessage(ConnectionHandler.java:363)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$OutgoingMessageHandler.run(ConnectionHandler.java:335)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) [na:1.8.0_65]
> Caused by: java.io.IOException: Broken pipe
>         at sun.nio.ch.FileChannelImpl.transferTo0(Native Method) ~[na:1.8.0_65]
>         at sun.nio.ch.FileChannelImpl.transferToDirectlyInternal(FileChannelImpl.java:427)
~[na:1.8.0_65]
>         at sun.nio.ch.FileChannelImpl.transferToDirectly(FileChannelImpl.java:492) ~[na:1.8.0_65]
>         at sun.nio.ch.FileChannelImpl.transferTo(FileChannelImpl.java:607) ~[na:1.8.0_65]
>         at org.apache.cassandra.io.util.ChannelProxy.transferTo(ChannelProxy.java:140)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         ... 11 common frames omitted
> {noformat} 
> nodeDC2 _other timezone +1_ no error
> {noformat} 
> INFO  [STREAM-INIT-/joiningDC1:46377] 2016-01-04 13:17:55,807 StreamResultFuture.java:111
- [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4 ID#0] Creating new streaming plan for Bootstrap
> INFO  [STREAM-INIT-/joiningDC1:46377] 2016-01-04 13:17:55,808 StreamResultFuture.java:118
- [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4, ID#0] Received streaming plan for Bootstrap
> INFO  [STREAM-INIT-/joiningDC1:46380] 2016-01-04 13:17:55,809 StreamResultFuture.java:118
- [Stream #2f473320-b2dd-11e5-8353-b5506ad414a4, ID#0] Received streaming plan for Bootstrap
> DEBUG [STREAM-IN-/joiningDC1] 2016-01-04 13:17:55,819 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received Prepare (2 requests,  0 files}
> DEBUG [STREAM-IN-/joiningDC1] 2016-01-04 13:17:55,819 StreamSession.java:347 - ViewFilter
for 1/1 sstables
> DEBUG [STREAM-OUT-/joiningDC1] 2016-01-04 13:17:55,820 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending Prepare (0 requests,  1 files}
> INFO  [STREAM-IN-/joiningDC1] 2016-01-04 13:17:55,820 StreamResultFuture.java:168 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4 ID#0] Prepare completed. Receiving 0 files(0 bytes),
sending 1 files(161 bytes)
> DEBUG [STREAM-OUT-/joiningDC1] 2016-01-04 13:17:55,820 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending File (Header (cfId: 5bc52802-de25-35ed-aeab-188eecebb090,
#0, version: la, format: BIG, estimated keys: 128, transfer size: 161, compressed?: true,
repairedAt: 1451483586917, level: 0), file: /srv/cassandra/data/system_auth/roles-5bc52802de2535edaeab188eecebb090/la-1-big-Data.db)
> DEBUG [STREAM-IN-/joiningDC1] 2016-01-04 13:17:55,831 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received Received (5bc52802-de25-35ed-aeab-188eecebb090,
#0)
> DEBUG [STREAM-OUT-/joiningDC1] 2016-01-04 13:17:55,832 ConnectionHandler.java:334 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Sending Complete
> DEBUG [STREAM-IN-/joiningDC1] 2016-01-04 13:17:56,049 ConnectionHandler.java:266 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Received Complete
> DEBUG [STREAM-IN-/joiningDC1] 2016-01-04 13:17:56,050 ConnectionHandler.java:110 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Closing stream connection handler on /joiningDC1
> INFO  [STREAM-IN-/joiningDC1] 2016-01-04 13:17:56,050 StreamResultFuture.java:182 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] Session with /joiningDC1 is complete
> INFO  [STREAM-IN-/joiningDC1] 2016-01-04 13:17:56,050 StreamResultFuture.java:214 - [Stream
#2f473320-b2dd-11e5-8353-b5506ad414a4] All sessions completed
> {noformat} 
> I also ran sstableverify two times on nodeDC1 and i get this error (2 times for the same
sstables)
> {noformat} 
> ERROR 23:13:50 LEAK DETECTED: a reference (org.apache.cassandra.utils.concurrent.Ref$State@799ed08e)
to class org.apache.cassandra.io.util.ChannelProxy$Cleanup@546942821:/cassandra/data/hugespace/content-94be9870814a11e5a573a94b3a1b0e16/la-12252-big-Data.db
was not released before the reference was garbage collected
> ERROR 23:13:50 LEAK DETECTED: a reference (org.apache.cassandra.utils.concurrent.Ref$State@2c747998)
to class org.apache.cassandra.io.util.ChannelProxy$Cleanup@218678140:/cassandra/data/hugespace/content-94be9870814a11e5a573a94b3a1b0e16/la-13487-big-Data.db
was not released before the reference was garbage collected
> ERROR 23:13:50 LEAK DETECTED: a reference (org.apache.cassandra.utils.concurrent.Ref$State@63a80e20)
to class org.apache.cassandra.io.util.ChannelProxy$Cleanup@652932560:/cassandra/data/hugespace/content-94be9870814a11e5a573a94b3a1b0e16/la-13499-big-Data.db
was not released before the reference was garbage collected
> ERROR 23:13:50 LEAK DETECTED: a reference (org.apache.cassandra.utils.concurrent.Ref$State@295df02c)
to class org.apache.cassandra.io.util.ChannelProxy$Cleanup@1644545368:/cassandra/data/hugespace/content-94be9870814a11e5a573a94b3a1b0e16/la-13497-big-Data.db
was not released before the reference was garbage collected
> {noformat} 
> sstable size 176 GB, 94GB, 3,6GB, 3,6GB all in the same table as biggest one - 1,3 TB
> I albo ran nodetool repair on nodeDC1 and i get the same error 
> nodeDC1
> {noformat} 
> ERROR [Thread-10] 2015-12-31 05:09:27,960 CassandraDaemon.java:185 - Exception in thread
Thread[Thread-10,5,main]
> java.lang.RuntimeException: java.lang.InterruptedException
>         at com.google.common.base.Throwables.propagate(Throwables.java:160) ~[guava-16.0.jar:na]
>         at org.apache.cassandra.utils.WrappedRunnable.run(WrappedRunnable.java:32) ~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) ~[na:1.8.0_65]
> Caused by: java.lang.InterruptedException: null
>         at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1220)
~[na:1.8.0_65]
>         at java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:335)
~[na:1.8.0_65]
>         at java.util.concurrent.ArrayBlockingQueue.put(ArrayBlockingQueue.java:350) ~[na:1.8.0_65]
>         at org.apache.cassandra.streaming.compress.CompressedInputStream$Reader.runMayThrow(CompressedInputStream.java:176)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.utils.WrappedRunnable.run(WrappedRunnable.java:28) ~[apache-cassandra-2.2.4.jar:2.2.4]
>         ... 1 common frames omitted
> DEBUG [STREAM-IN-/nodeDC2] 2015-12-31 05:09:27,960 ConnectionHandler.java:266 - [Stream
#8b40bf70-af7c-11e5-8429-a94b3a1b0e16] Received File (Header (cfId: 94be9870-814a-11e5-a573-a94b3a1b0e16,
#0, version: la, format: BIG, estimated keys: 1, transfer size: 5190031760, compressed?: true,
repairedAt: 1451517863052, level: 0), file: /cassandra/data/hugespace/content-94be9870814a11e5a573a94b3a1b0e16/tmp-la-13501-big-Data.db)
> ERROR [STREAM-IN-/nodeDC2] 2015-12-31 05:09:27,967 StreamSession.java:524 - [Stream #8b40bf70-af7c-11e5-8429-a94b3a1b0e16]
Streaming error occurred
> java.nio.channels.ClosedChannelException: null
>         at sun.nio.ch.SocketChannelImpl.ensureReadOpen(SocketChannelImpl.java:257) ~[na:1.8.0_65]
>         at sun.nio.ch.SocketChannelImpl.read(SocketChannelImpl.java:300) ~[na:1.8.0_65]
>         at org.apache.cassandra.streaming.messages.StreamMessage.deserialize(StreamMessage.java:53)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$IncomingMessageHandler.run(ConnectionHandler.java:261)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) [na:1.8.0_65]
> DEBUG [STREAM-IN-/nodeDC2] 2015-12-31 05:09:34,235 ConnectionHandler.java:110 - [Stream
#8b40bf70-af7c-11e5-8429-a94b3a1b0e16] Closing stream connection handler on /nodeDC2
> INFO  [STREAM-IN-/nodeDC2] 2015-12-31 05:09:34,235 StreamResultFuture.java:182 - [Stream
#8b40bf70-af7c-11e5-8429-a94b3a1b0e16] Session with /nodeDC2 is complete
> WARN  [STREAM-IN-/nodeDC2] 2015-12-31 05:09:34,236 StreamResultFuture.java:209 - [Stream
#8b40bf70-af7c-11e5-8429-a94b3a1b0e16] Stream failed
> ERROR [STREAM-OUT-/nodeDC2] 2015-12-31 05:09:34,236 StreamSession.java:524 - [Stream
#8b40bf70-af7c-11e5-8429-a94b3a1b0e16] Streaming error occurred
> org.apache.cassandra.io.FSReadError: java.io.IOException: Broken pipe
>         at org.apache.cassandra.io.util.ChannelProxy.transferTo(ChannelProxy.java:144)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.compress.CompressedStreamWriter$1.apply(CompressedStreamWriter.java:79)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.compress.CompressedStreamWriter$1.apply(CompressedStreamWriter.java:76)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.io.util.BufferedDataOutputStreamPlus.applyToChannel(BufferedDataOutputStreamPlus.java:297)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.compress.CompressedStreamWriter.write(CompressedStreamWriter.java:75)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.OutgoingFileMessage.serialize(OutgoingFileMessage.java:90)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.OutgoingFileMessage$1.serialize(OutgoingFileMessage.java:48)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.OutgoingFileMessage$1.serialize(OutgoingFileMessage.java:40)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.StreamMessage.serialize(StreamMessage.java:47)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$OutgoingMessageHandler.sendMessage(ConnectionHandler.java:363)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$OutgoingMessageHandler.run(ConnectionHandler.java:335)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) [na:1.8.0_65]
> Caused by: java.io.IOException: Broken pipe
>         at sun.nio.ch.FileChannelImpl.transferTo0(Native Method) ~[na:1.8.0_65]
>         at sun.nio.ch.FileChannelImpl.transferToDirectlyInternal(FileChannelImpl.java:427)
~[na:1.8.0_65]
>         at sun.nio.ch.FileChannelImpl.transferToDirectly(FileChannelImpl.java:492) ~[na:1.8.0_65]
>         at sun.nio.ch.FileChannelImpl.transferTo(FileChannelImpl.java:607) ~[na:1.8.0_65]
>         at org.apache.cassandra.io.util.ChannelProxy.transferTo(ChannelProxy.java:140)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         ... 11 common frames omitted
> WARN  [RepairJobTask:17] 2015-12-31 05:09:34,236 RepairJob.java:162 - [repair #75cfdc00-af4c-11e5-8429-a94b3a1b0e16]
content sync failed
> ERROR [RepairJobTask:17] 2015-12-31 05:09:34,238 RepairSession.java:290 - [repair #75cfdc00-af4c-11e5-8429-a94b3a1b0e16]
Session completed with the following error
> org.apache.cassandra.streaming.StreamException: Stream failed
>         at org.apache.cassandra.streaming.management.StreamEventJMXNotifier.onFailure(StreamEventJMXNotifier.java:85)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at com.google.common.util.concurrent.Futures$4.run(Futures.java:1172) ~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.MoreExecutors$SameThreadExecutorService.execute(MoreExecutors.java:297)
~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.ExecutionList.executeListener(ExecutionList.java:156)
~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.ExecutionList.execute(ExecutionList.java:145)
~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.AbstractFuture.setException(AbstractFuture.java:202)
~[guava-16.0.jar:na]
>         at org.apache.cassandra.streaming.StreamResultFuture.maybeComplete(StreamResultFuture.java:210)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.StreamResultFuture.handleSessionComplete(StreamResultFuture.java:186)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.StreamSession.closeSession(StreamSession.java:434)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.StreamSession.onError(StreamSession.java:529)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$IncomingMessageHandler.run(ConnectionHandler.java:279)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) [na:1.8.0_65]
> ERROR [RepairJobTask:17] 2015-12-31 05:09:34,239 RepairRunnable.java:243 - Repair session
75cfdc00-af4c-11e5-8429-a94b3a1b0e16 for range (-308435053110486424,-206175645991596694] failed
with error Stream failed
> org.apache.cassandra.streaming.StreamException: Stream failed
>         at org.apache.cassandra.streaming.management.StreamEventJMXNotifier.onFailure(StreamEventJMXNotifier.java:85)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at com.google.common.util.concurrent.Futures$4.run(Futures.java:1172) ~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.MoreExecutors$SameThreadExecutorService.execute(MoreExecutors.java:297)
~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.ExecutionList.executeListener(ExecutionList.java:156)
~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.ExecutionList.execute(ExecutionList.java:145)
~[guava-16.0.jar:na]
>         at com.google.common.util.concurrent.AbstractFuture.setException(AbstractFuture.java:202)
~[guava-16.0.jar:na]
>         at org.apache.cassandra.streaming.StreamResultFuture.maybeComplete(StreamResultFuture.java:210)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.StreamResultFuture.handleSessionComplete(StreamResultFuture.java:186)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.StreamSession.closeSession(StreamSession.java:434)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.StreamSession.onError(StreamSession.java:529)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$IncomingMessageHandler.run(ConnectionHandler.java:279)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) [na:1.8.0_65]
> {noformat} 
> nodeDC2  _timezone +1_
> {noformat} 
> ERROR [STREAM-OUT-/nodeDC1] 2015-12-31 06:09:28,590 StreamSession.java:524 - [Stream
#8b40bf70-af7c-11e5-8429-a94b3a1b0e16] Streaming error occurred
> org.apache.cassandra.io.FSReadError: java.io.IOException: Broken pipe
>         at org.apache.cassandra.io.util.ChannelProxy.transferTo(ChannelProxy.java:144)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.compress.CompressedStreamWriter$1.apply(CompressedStreamWriter.java:79)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.compress.CompressedStreamWriter$1.apply(CompressedStreamWriter.java:76)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.io.util.BufferedDataOutputStreamPlus.applyToChannel(BufferedDataOutputStreamPlus.java:297)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.compress.CompressedStreamWriter.write(CompressedStreamWriter.java:75)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.OutgoingFileMessage.serialize(OutgoingFileMessage.java:90)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.OutgoingFileMessage$1.serialize(OutgoingFileMessage.java:48)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.OutgoingFileMessage$1.serialize(OutgoingFileMessage.java:40)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.messages.StreamMessage.serialize(StreamMessage.java:47)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$OutgoingMessageHandler.sendMessage(ConnectionHandler.java:363)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$OutgoingMessageHandler.run(ConnectionHandler.java:335)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) [na:1.8.0_65]
> Caused by: java.io.IOException: Broken pipe
>         at sun.nio.ch.FileChannelImpl.transferTo0(Native Method) ~[na:1.8.0_65]
>         at sun.nio.ch.FileChannelImpl.transferToDirectlyInternal(FileChannelImpl.java:427)
~[na:1.8.0_65]
>         at sun.nio.ch.FileChannelImpl.transferToDirectly(FileChannelImpl.java:492) ~[na:1.8.0_65]
>         at sun.nio.ch.FileChannelImpl.transferTo(FileChannelImpl.java:607) ~[na:1.8.0_65]
>         at org.apache.cassandra.io.util.ChannelProxy.transferTo(ChannelProxy.java:140)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         ... 11 common frames omitted
> DEBUG [STREAM-OUT-/nodeDC1] 2015-12-31 06:09:28,591 ConnectionHandler.java:110 - [Stream
#8b40bf70-af7c-11e5-8429-a94b3a1b0e16] Closing stream connection handler on /nodeDC1
> INFO  [STREAM-OUT-/nodeDC1] 2015-12-31 06:09:28,591 StreamResultFuture.java:182 - [Stream
#8b40bf70-af7c-11e5-8429-a94b3a1b0e16] Session with /nodeDC1 is complete
> WARN  [STREAM-OUT-/nodeDC1] 2015-12-31 06:09:28,591 StreamResultFuture.java:209 - [Stream
#8b40bf70-af7c-11e5-8429-a94b3a1b0e16] Stream failed
> ERROR [Thread-25] 2015-12-31 06:09:33,932 CassandraDaemon.java:185 - Exception in thread
Thread[Thread-25,5,main]
> java.lang.RuntimeException: java.lang.InterruptedException
>         at com.google.common.base.Throwables.propagate(Throwables.java:160) ~[guava-16.0.jar:na]
>         at org.apache.cassandra.utils.WrappedRunnable.run(WrappedRunnable.java:32) ~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) ~[na:1.8.0_65]
> Caused by: java.lang.InterruptedException: null
>         at java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireInterruptibly(AbstractQueuedSynchronizer.java:1220)
~[na:1.8.0_65]
>         at java.util.concurrent.locks.ReentrantLock.lockInterruptibly(ReentrantLock.java:335)
~[na:1.8.0_65]
>         at java.util.concurrent.ArrayBlockingQueue.put(ArrayBlockingQueue.java:350) ~[na:1.8.0_65]
>         at org.apache.cassandra.streaming.compress.CompressedInputStream$Reader.runMayThrow(CompressedInputStream.java:176)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.utils.WrappedRunnable.run(WrappedRunnable.java:28) ~[apache-cassandra-2.2.4.jar:2.2.4]
>         ... 1 common frames omitted
> DEBUG [STREAM-IN-/nodeDC1] 2015-12-31 06:09:33,931 ConnectionHandler.java:266 - [Stream
#8b40bf70-af7c-11e5-8429-a94b3a1b0e16] Received File (Header (cfId: 94be9870-814a-11e5-a573-a94b3a1b0e16,
#0, version: la, format: BIG, estimated keys: 1, transfer size: 5344434128, compressed?: true,
repairedAt: 1451517863052, level: 0), file: /srv/cassandra/data/hugespace/content-94be9870814a11e5a573a94b3a1b0e16/tmp-la-13949-big-Data.db)
> ERROR [STREAM-IN-/nodeDC1] 2015-12-31 06:09:33,935 StreamSession.java:524 - [Stream #8b40bf70-af7c-11e5-8429-a94b3a1b0e16]
Streaming error occurred
> java.lang.RuntimeException: Outgoing stream handler has been closed
>         at org.apache.cassandra.streaming.ConnectionHandler.sendMessage(ConnectionHandler.java:132)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.StreamSession.receive(StreamSession.java:587)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.StreamSession.messageReceived(StreamSession.java:476)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at org.apache.cassandra.streaming.ConnectionHandler$IncomingMessageHandler.run(ConnectionHandler.java:267)
~[apache-cassandra-2.2.4.jar:2.2.4]
>         at java.lang.Thread.run(Thread.java:745) [na:1.8.0_65]
> {noformat} 
> Please advice.



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)

Mime
View raw message