You are viewing a plain text version of this content. The canonical link for it is here.
Posted to commits@cassandra.apache.org by "C. Scott Andreas (JIRA)" <ji...@apache.org> on 2018/11/19 01:42:01 UTC

[jira] [Updated] (CASSANDRA-13734) BufferUnderflowException when using uppercase UUID

     [ https://issues.apache.org/jira/browse/CASSANDRA-13734?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]

C. Scott Andreas updated CASSANDRA-13734:
-----------------------------------------
    Component/s: Local Write-Read Paths

> BufferUnderflowException when using uppercase UUID
> --------------------------------------------------
>
>                 Key: CASSANDRA-13734
>                 URL: https://issues.apache.org/jira/browse/CASSANDRA-13734
>             Project: Cassandra
>          Issue Type: Bug
>          Components: Local Write-Read Paths
>         Environment: Cassandra 2.2.8 running on OSX 10.12.5
> * org.apache.cassandra:cassandra-all:jar:2.2.8
> * com.datastax.cassandra:cassandra-driver-core:jar:3.0.0
> * org.apache.cassandra:cassandra-thrift:jar:2.2.8
>            Reporter: Claudia S
>            Priority: Major
>
> We have a table with a primary key of type uuid which we query for results in JSON format. When I accidentally caused a query passing a UUID which has an uppercase letter I noticed that this causes a BufferUnderflowException on Cassandra.
> I directly attempted the queries using cqlsh, I can retrieve the entry using standard select but whenever I pass JSON I get a BufferUnderflowException.
> {code:title=cql queries}
> cassandra@cqlsh:event_log_system> SELECT * FROM event WHERE id = 559a4d83-9410-4b69-b459-566b8cf57aaa;
> [RESULT REMOVED]
> (1 rows)
> cassandra@cqlsh:event_log_system> SELECT * FROM event WHERE id = 559a4d83-9410-4b69-b459-566b8cf57AAA;
> [RESULT REMOVED]
> (1 rows)
> cassandra@cqlsh:event_log_system> SELECT JSON * FROM event WHERE id = 559a4d83-9410-4b69-b459-566b8cf57AAA;
> ServerError: java.nio.BufferUnderflowException
> cassandra@cqlsh:event_log_system> SELECT JSON * FROM event WHERE id = 559a4d83-9410-4b69-b459-566b8cf57aaa;
> ServerError: java.nio.BufferUnderflowException
> {code}
> {code:title=log}
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,392 Message.java:506 - Received: QUERY SELECT JSON * FROM event WHERE id = 559a4d83-9410-4b69-b459-566b8cf57AAA;, v=4
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,392 QueryProcessor.java:221 - Process org.apache.cassandra.cql3.statements.SelectStatement@67e6c0c @CL.ONE
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,392 ReadCallback.java:76 - Blockfor is 1; setting up requests to localhost/127.0.0.1
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,393 AbstractReadExecutor.java:118 - reading data locally
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,393 SliceQueryFilter.java:269 - collecting 0 of 2147483647: :false:0@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,393 SliceQueryFilter.java:269 - collecting 1 of 2147483647: can_login:false:1@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,393 SliceQueryFilter.java:269 - collecting 1 of 2147483647: is_superuser:false:1@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,393 SliceQueryFilter.java:269 - collecting 1 of 2147483647: salted_hash:false:60@1501267019830000
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,393 StorageProxy.java:1449 - Read: 0 ms.
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,394 ReadCallback.java:76 - Blockfor is 1; setting up requests to localhost/127.0.0.1
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,394 AbstractReadExecutor.java:118 - reading data locally
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,394 SliceQueryFilter.java:269 - collecting 0 of 2147483647: :false:0@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,394 SliceQueryFilter.java:269 - collecting 1 of 2147483647: can_login:false:1@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,394 SliceQueryFilter.java:269 - collecting 1 of 2147483647: is_superuser:false:1@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,394 SliceQueryFilter.java:269 - collecting 1 of 2147483647: salted_hash:false:60@1501267019830000
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,395 StorageProxy.java:1449 - Read: 0 ms.
> DEBUG [SharedPool-Worker-1] 2017-07-28 20:40:41,395 SliceQueryPager.java:92 - Querying next page of slice query; new filter: SliceQueryFilter [reversed=false, slices=[[, ]], count=100, toGroup = 0]
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,395 ReadCallback.java:76 - Blockfor is 1; setting up requests to localhost/127.0.0.1
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,395 AbstractReadExecutor.java:118 - reading data locally
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 0 of 100: :false:0@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 1 of 100: action:false:4@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 1 of 100: action_outcome:false:7@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 1 of 100: business_process_id:false:22@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 1 of 100: created_at:false:8@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 1 of 100: event_type:false:22@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 1 of 100: hp_id:true:4@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 1 of 100: message:true:4@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 1 of 100: participants:false:0@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 1 of 100: patient_id:false:6@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 1 of 100: session_id:false:18@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,396 SliceQueryFilter.java:269 - collecting 1 of 100: session_type:false:6@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,397 SliceQueryFilter.java:269 - collecting 1 of 100: source_id:false:11@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,397 SliceQueryFilter.java:269 - collecting 1 of 100: user:false:25@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:41,397 SliceQueryFilter.java:269 - collecting 1 of 100: version:false:3@1501267173323000
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,397 StorageProxy.java:1449 - Read: 1 ms.
> DEBUG [SharedPool-Worker-1] 2017-07-28 20:40:41,397 AbstractQueryPager.java:95 - Fetched 1 live rows
> DEBUG [SharedPool-Worker-1] 2017-07-28 20:40:41,397 AbstractQueryPager.java:112 - Got result (1) smaller than page size (100), considering pager exhausted
> DEBUG [SharedPool-Worker-1] 2017-07-28 20:40:41,397 AbstractQueryPager.java:133 - Remaining rows to page: 2147483646
> ERROR [SharedPool-Worker-1] 2017-07-28 20:40:41,398 QueryMessage.java:136 - Unexpected error during query
> java.nio.BufferUnderflowException: null
> 	at java.nio.Buffer.nextGetIndex(Buffer.java:506) ~[na:1.8.0_131]
> 	at java.nio.HeapByteBuffer.getInt(HeapByteBuffer.java:361) ~[na:1.8.0_131]
> 	at org.apache.cassandra.serializers.CollectionSerializer.readCollectionSize(CollectionSerializer.java:87) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.db.marshal.ListType.setOrListToJsonString(ListType.java:212) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.db.marshal.SetType.toJSONString(SetType.java:186) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.rowToJson(Selection.java:383) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.getOutputRow(Selection.java:359) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.build(Selection.java:346) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.process(SelectStatement.java:681) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.processResults(SelectStatement.java:282) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:243) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:179) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:76) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.processStatement(QueryProcessor.java:226) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.process(QueryProcessor.java:257) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.process(QueryProcessor.java:242) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.messages.QueryMessage.execute(QueryMessage.java:123) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.Message$Dispatcher.channelRead0(Message.java:507) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.Message$Dispatcher.channelRead0(Message.java:401) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at io.netty.channel.SimpleChannelInboundHandler.channelRead(SimpleChannelInboundHandler.java:105) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:333) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext.access$700(AbstractChannelHandlerContext.java:32) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext$8.run(AbstractChannelHandlerContext.java:324) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [na:1.8.0_131]
> 	at org.apache.cassandra.concurrent.AbstractLocalAwareExecutorService$FutureTask.run(AbstractLocalAwareExecutorService.java:164) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.concurrent.SEPWorker.run(SEPWorker.java:105) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131]
> ERROR [SharedPool-Worker-1] 2017-07-28 20:40:41,398 ErrorMessage.java:338 - Unexpected exception during request
> java.nio.BufferUnderflowException: null
> 	at java.nio.Buffer.nextGetIndex(Buffer.java:506) ~[na:1.8.0_131]
> 	at java.nio.HeapByteBuffer.getInt(HeapByteBuffer.java:361) ~[na:1.8.0_131]
> 	at org.apache.cassandra.serializers.CollectionSerializer.readCollectionSize(CollectionSerializer.java:87) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.db.marshal.ListType.setOrListToJsonString(ListType.java:212) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.db.marshal.SetType.toJSONString(SetType.java:186) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.rowToJson(Selection.java:383) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.getOutputRow(Selection.java:359) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.build(Selection.java:346) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.process(SelectStatement.java:681) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.processResults(SelectStatement.java:282) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:243) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:179) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:76) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.processStatement(QueryProcessor.java:226) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.process(QueryProcessor.java:257) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.process(QueryProcessor.java:242) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.messages.QueryMessage.execute(QueryMessage.java:123) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.Message$Dispatcher.channelRead0(Message.java:507) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.Message$Dispatcher.channelRead0(Message.java:401) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at io.netty.channel.SimpleChannelInboundHandler.channelRead(SimpleChannelInboundHandler.java:105) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:333) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext.access$700(AbstractChannelHandlerContext.java:32) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext$8.run(AbstractChannelHandlerContext.java:324) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [na:1.8.0_131]
> 	at org.apache.cassandra.concurrent.AbstractLocalAwareExecutorService$FutureTask.run(AbstractLocalAwareExecutorService.java:164) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.concurrent.SEPWorker.run(SEPWorker.java:105) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131]
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,399 Tracing.java:156 - request complete
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:41,399 Message.java:525 - Responding: ERROR SERVER_ERROR: java.nio.BufferUnderflowException, v=4
> TRACE [GossipTasks:1] 2017-07-28 20:40:41,420 Gossiper.java:144 - My heartbeat is now 747
> TRACE [GossipTasks:1] 2017-07-28 20:40:41,420 Gossiper.java:502 - Gossip Digests are : localhost/127.0.0.1:1501267007:747
> TRACE [GossipTasks:1] 2017-07-28 20:40:41,420 Gossiper.java:739 - Performing status check ...
> TRACE [EXPIRING-MAP-REAPER:1] 2017-07-28 20:40:41,520 ExpiringMap.java:102 - Expired 0 entries
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,312 Message.java:506 - Received: QUERY SELECT JSON * FROM event WHERE id = 559a4d83-9410-4b69-b459-566b8cf57aaa;, v=4
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,312 QueryProcessor.java:221 - Process org.apache.cassandra.cql3.statements.SelectStatement@33dbcc81 @CL.ONE
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,313 ReadCallback.java:76 - Blockfor is 1; setting up requests to localhost/127.0.0.1
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,313 AbstractReadExecutor.java:118 - reading data locally
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,313 SliceQueryFilter.java:269 - collecting 0 of 2147483647: :false:0@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,313 SliceQueryFilter.java:269 - collecting 1 of 2147483647: can_login:false:1@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,313 SliceQueryFilter.java:269 - collecting 1 of 2147483647: is_superuser:false:1@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,313 SliceQueryFilter.java:269 - collecting 1 of 2147483647: salted_hash:false:60@1501267019830000
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,313 StorageProxy.java:1449 - Read: 0 ms.
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,314 ReadCallback.java:76 - Blockfor is 1; setting up requests to localhost/127.0.0.1
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,314 AbstractReadExecutor.java:118 - reading data locally
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,314 SliceQueryFilter.java:269 - collecting 0 of 2147483647: :false:0@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,314 SliceQueryFilter.java:269 - collecting 1 of 2147483647: can_login:false:1@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,314 SliceQueryFilter.java:269 - collecting 1 of 2147483647: is_superuser:false:1@1501267019830000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,314 SliceQueryFilter.java:269 - collecting 1 of 2147483647: salted_hash:false:60@1501267019830000
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,315 StorageProxy.java:1449 - Read: 0 ms.
> DEBUG [SharedPool-Worker-1] 2017-07-28 20:40:45,315 SliceQueryPager.java:92 - Querying next page of slice query; new filter: SliceQueryFilter [reversed=false, slices=[[, ]], count=100, toGroup = 0]
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,315 ReadCallback.java:76 - Blockfor is 1; setting up requests to localhost/127.0.0.1
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,315 AbstractReadExecutor.java:118 - reading data locally
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,315 SliceQueryFilter.java:269 - collecting 0 of 100: :false:0@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,315 SliceQueryFilter.java:269 - collecting 1 of 100: action:false:4@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,315 SliceQueryFilter.java:269 - collecting 1 of 100: action_outcome:false:7@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,315 SliceQueryFilter.java:269 - collecting 1 of 100: business_process_id:false:22@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,316 SliceQueryFilter.java:269 - collecting 1 of 100: created_at:false:8@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,316 SliceQueryFilter.java:269 - collecting 1 of 100: event_type:false:22@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,316 SliceQueryFilter.java:269 - collecting 1 of 100: hp_id:true:4@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,316 SliceQueryFilter.java:269 - collecting 1 of 100: message:true:4@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,316 SliceQueryFilter.java:269 - collecting 1 of 100: participants:false:0@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,316 SliceQueryFilter.java:269 - collecting 1 of 100: patient_id:false:6@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,316 SliceQueryFilter.java:269 - collecting 1 of 100: session_id:false:18@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,316 SliceQueryFilter.java:269 - collecting 1 of 100: session_type:false:6@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,316 SliceQueryFilter.java:269 - collecting 1 of 100: source_id:false:11@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,316 SliceQueryFilter.java:269 - collecting 1 of 100: user:false:25@1501267173323000
> TRACE [SharedPool-Worker-2] 2017-07-28 20:40:45,316 SliceQueryFilter.java:269 - collecting 1 of 100: version:false:3@1501267173323000
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,316 StorageProxy.java:1449 - Read: 1 ms.
> DEBUG [SharedPool-Worker-1] 2017-07-28 20:40:45,316 AbstractQueryPager.java:95 - Fetched 1 live rows
> DEBUG [SharedPool-Worker-1] 2017-07-28 20:40:45,317 AbstractQueryPager.java:112 - Got result (1) smaller than page size (100), considering pager exhausted
> DEBUG [SharedPool-Worker-1] 2017-07-28 20:40:45,317 AbstractQueryPager.java:133 - Remaining rows to page: 2147483646
> ERROR [SharedPool-Worker-1] 2017-07-28 20:40:45,317 QueryMessage.java:136 - Unexpected error during query
> java.nio.BufferUnderflowException: null
> 	at java.nio.Buffer.nextGetIndex(Buffer.java:506) ~[na:1.8.0_131]
> 	at java.nio.HeapByteBuffer.getInt(HeapByteBuffer.java:361) ~[na:1.8.0_131]
> 	at org.apache.cassandra.serializers.CollectionSerializer.readCollectionSize(CollectionSerializer.java:87) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.db.marshal.ListType.setOrListToJsonString(ListType.java:212) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.db.marshal.SetType.toJSONString(SetType.java:186) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.rowToJson(Selection.java:383) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.getOutputRow(Selection.java:359) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.build(Selection.java:346) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.process(SelectStatement.java:681) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.processResults(SelectStatement.java:282) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:243) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:179) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:76) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.processStatement(QueryProcessor.java:226) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.process(QueryProcessor.java:257) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.process(QueryProcessor.java:242) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.messages.QueryMessage.execute(QueryMessage.java:123) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.Message$Dispatcher.channelRead0(Message.java:507) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.Message$Dispatcher.channelRead0(Message.java:401) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at io.netty.channel.SimpleChannelInboundHandler.channelRead(SimpleChannelInboundHandler.java:105) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:333) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext.access$700(AbstractChannelHandlerContext.java:32) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext$8.run(AbstractChannelHandlerContext.java:324) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [na:1.8.0_131]
> 	at org.apache.cassandra.concurrent.AbstractLocalAwareExecutorService$FutureTask.run(AbstractLocalAwareExecutorService.java:164) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.concurrent.SEPWorker.run(SEPWorker.java:105) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131]
> ERROR [SharedPool-Worker-1] 2017-07-28 20:40:45,317 ErrorMessage.java:338 - Unexpected exception during request
> java.nio.BufferUnderflowException: null
> 	at java.nio.Buffer.nextGetIndex(Buffer.java:506) ~[na:1.8.0_131]
> 	at java.nio.HeapByteBuffer.getInt(HeapByteBuffer.java:361) ~[na:1.8.0_131]
> 	at org.apache.cassandra.serializers.CollectionSerializer.readCollectionSize(CollectionSerializer.java:87) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.db.marshal.ListType.setOrListToJsonString(ListType.java:212) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.db.marshal.SetType.toJSONString(SetType.java:186) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.rowToJson(Selection.java:383) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.getOutputRow(Selection.java:359) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.selection.Selection$ResultSetBuilder.build(Selection.java:346) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.process(SelectStatement.java:681) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.processResults(SelectStatement.java:282) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:243) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:179) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.statements.SelectStatement.execute(SelectStatement.java:76) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.processStatement(QueryProcessor.java:226) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.process(QueryProcessor.java:257) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.cql3.QueryProcessor.process(QueryProcessor.java:242) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.messages.QueryMessage.execute(QueryMessage.java:123) ~[apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.Message$Dispatcher.channelRead0(Message.java:507) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.transport.Message$Dispatcher.channelRead0(Message.java:401) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at io.netty.channel.SimpleChannelInboundHandler.channelRead(SimpleChannelInboundHandler.java:105) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:333) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext.access$700(AbstractChannelHandlerContext.java:32) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at io.netty.channel.AbstractChannelHandlerContext$8.run(AbstractChannelHandlerContext.java:324) [netty-all-4.0.23.Final.jar:4.0.23.Final]
> 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [na:1.8.0_131]
> 	at org.apache.cassandra.concurrent.AbstractLocalAwareExecutorService$FutureTask.run(AbstractLocalAwareExecutorService.java:164) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at org.apache.cassandra.concurrent.SEPWorker.run(SEPWorker.java:105) [apache-cassandra-2.2.8.jar:2.2.8]
> 	at java.lang.Thread.run(Thread.java:748) [na:1.8.0_131]
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,318 Tracing.java:156 - request complete
> TRACE [SharedPool-Worker-1] 2017-07-28 20:40:45,318 Message.java:525 - Responding: ERROR SERVER_ERROR: java.nio.BufferUnderflowException, v=4
> TRACE [GossipTasks:1] 2017-07-28 20:40:45,434 Gossiper.java:144 - My heartbeat is now 759
> TRACE [GossipTasks:1] 2017-07-28 20:40:45,434 Gossiper.java:502 - Gossip Digests are : localhost/127.0.0.1:1501267007:759
> TRACE [GossipTasks:1] 2017-07-28 20:40:45,434 Gossiper.java:739 - Performing status check ...
> {code}
> When the query is executed using {{com.datastax.driver.core.Session}} it works - no matter if the UUID is correct or contains uppercase letters.
> I didn't find a human readable query in the log in this case - for comparison - but in our code we use the template: {{SELECT JSON * FROM event WHERE id = ?}}
> Obviously I did something wrong here but my colleague pointed out that the effect it has is not so cool. ;)



--
This message was sent by Atlassian JIRA
(v7.6.3#76005)

---------------------------------------------------------------------
To unsubscribe, e-mail: commits-unsubscribe@cassandra.apache.org
For additional commands, e-mail: commits-help@cassandra.apache.org