Mailing-List: contact user-help@cassandra.apache.org; run by ezmlm
Precedence: bulk
Reply-To: user@cassandra.apache.org
Received-SPF: pass (athena.apache.org: domain of michalm@opera.com designates
 213.236.208.81 as permitted sender)
Message-ID: <519B4018.1030507@opera.com>
Date: Tue, 21 May 2013 11:36:24 +0200
From: Michal Michalski <michalm@opera.com>
User-Agent: Mozilla/5.0 (X11; Linux x86_64;
 rv:17.0) Gecko/20130329 Thunderbird/17.0.5
MIME-Version: 1.0
To: user@cassandra.apache.org
Subject: Re: Problem with streaming data from Hadoop: DecoratedKey(-1, )
References: <515405D2.9080202@opera.com>
 <BE441DE3-9066-4157-B7DD-0732BA129934@thelastpickle.com>
In-Reply-To: <BE441DE3-9066-4157-B7DD-0732BA129934@thelastpickle.com>
Content-Type: text/plain; charset=UTF-8; format=flowed
Content-Transfer-Encoding: 8bit

I've finally had some time to experiment a bit with this problem (it 
occured twice again) and here's what I found:

1. So far (three occurences in total), *when* it happened, it happened 
only for streaming to  *one* specific C* node (but it works on this node 
too for 99,9% of the time)
2. It happens with compression turned on 
(cassandra.output.compression.class set to 
org.apache.cassandra.io.compress.DeflateCompressor, but it doesn't 
matter what the chunk length is)
3. Everything works fine when compression is turned off.

So it looks like I have a workaround for now, but I don't really 
understand the root cause of this problem and what's the "right" 
solution if we want to keep using compression.

Anyway, the thing that interests me the most is why does it fail so 
rarely and - assuming it's not a coincidence - why only for one C* node...

May it be a DeflateCompressor's bug?
Any other ideas?

Regards,
Michał


W dniu 31.03.2013 12:01, aaron morton pisze:
>>   but yesterday one of 600 mappers failed
>>
> :)
>
>>  From what I can understand by looking into the C* source, it seems to me that the problem is caused by a empty (or surprisingly finished?) input buffer (?) causing token to be set to -1 which is improper for RandomPartitioner:
> Yes, there is a zero length key which as a -1 token.
>
>> However, I can't figure out what's the root cause of this problem.
>> Any ideas?
> mmm, the BulkOutputFormat uses a SSTableSimpleUnsortedWriter and neither of them check for zero length row keys. I would look there first.
>
> There is no validation in the  AbstractSSTableSimpleWriter, not sure if that is by design or an oversight. Can you catch the zero length key in your map job ?
>
> Cheers
>
> -----------------
> Aaron Morton
> Freelance Cassandra Consultant
> New Zealand
>
> @aaronmorton
> http://www.thelastpickle.com
>
> On 28/03/2013, at 2:26 PM, Michal Michalski <michalm@opera.com> wrote:
>
>> We're streaming data to Cassandra directly from MapReduce job using BulkOutputFormat. It's been working for more than a year without any problems, but yesterday one of 600 mappers faild and we got a strange-looking exception on one of the C* nodes.
>>
>> IMPORTANT: It happens on one node and on one cluster only. We've loaded the same data to test cluster and it worked.
>>
>>
>> ERROR [Thread-1340977] 2013-03-28 06:35:47,695 CassandraDaemon.java (line 133) Exception in thread Thread[Thread-1340977,5,main]
>> java.lang.RuntimeException: Last written key DecoratedKey(5664330507961197044404922676062547179, 302c6461696c792c32303133303332352c312c646f6d61696e2c756e6971756575736572732c633a494e2c433a6d63635f6d6e635f636172726965725f43656c6c4f6e655f4b61726e6174616b615f2842616e67616c6f7265295f494e2c643a53616d73756e675f47542d49393037302c703a612c673a3133) >= current key DecoratedKey(-1, ) writing into /cassandra/production/IndexedValues/production-IndexedValues-tmp-ib-240346-Data.db
>> 	at org.apache.cassandra.io.sstable.SSTableWriter.beforeAppend(SSTableWriter.java:133)
>> 	at org.apache.cassandra.io.sstable.SSTableWriter.appendFromStream(SSTableWriter.java:209)
>> 	at org.apache.cassandra.streaming.IncomingStreamReader.streamIn(IncomingStreamReader.java:179)
>> 	at org.apache.cassandra.streaming.IncomingStreamReader.read(IncomingStreamReader.java:122)
>> 	at org.apache.cassandra.net.IncomingTcpConnection.stream(IncomingTcpConnection.java:226)
>> 	at org.apache.cassandra.net.IncomingTcpConnection.handleStream(IncomingTcpConnection.java:166)
>> 	at org.apache.cassandra.net.IncomingTcpConnection.run(IncomingTcpConnection.java:66)
>>
>>
>>  From what I can understand by looking into the C* source, it seems to me that the problem is caused by a empty (or surprisingly finished?) input buffer (?) causing token to be set to -1 which is improper for RandomPartitioner:
>>
>> public BigIntegerToken getToken(ByteBuffer key)
>> {
>>     if (key.remaining() == 0)
>>         return MINIMUM;		// Which is -1
>>     return new BigIntegerToken(FBUtilities.hashToBigInteger(key));
>> }
>>
>> However, I can't figure out what's the root cause of this problem.
>> Any ideas?
>>
>> Of course I can't exclude a bug in my code which streams these data, but - as I said - it works when loading the same data to test cluster (which has different number of nodes, thus different token assignment, which might be a case too).
>>
>> Michał
>
>