Dbms.logs.query.allocation_logging_enabled gets java.lang.ArrayIndexOutOfBoundsException: Index 256 out of bounds for length 256

[raul]

I am trying to profile the memory consumption of queries, since we are experiencing java Heap space crashes.

I enabled the dbms.logs.query.allocation_logging_enabled setting
together with the dbms.track_query_allocation=true param.

But I am getting an exception, seems like a bug.

neo version: 4.0.5

pr, I_s, s RETURN * - {} - {} Index 256 out of bounds for length 256
java.lang.ArrayIndexOutOfBoundsException: Index 256 out of bounds for length 256
at org.neo4j.cypher.internal.runtime.pipelined.execution.MorselExecutionContext.estimatedHeapUsage(MorselExecutionContext.scala:373)
at org.neo4j.cypher.internal.runtime.BoundedMemoryTracker.allocated(QueryMemoryTracker.scala:139)
at org.neo4j.cypher.internal.runtime.pipelined.state.buffers.MemoryTrackingStandardBuffer.put(StandardBuffer.scala:54)
at org.neo4j.cypher.internal.runtime.pipelined.state.buffers.MemoryTrackingStandardBuffer.put(StandardBuffer.scala:52)
at org.neo4j.cypher.internal.runtime.pipelined.state.buffers.StandardOptionalBuffer.put(OptionalMorselBuffer.scala:282)
at org.neo4j.cypher.internal.runtime.pipelined.state.buffers.ArgumentStateBuffer.put(ArgumentStateBuffer.scala:27)
at org.neo4j.cypher.internal.runtime.pipelined.state.buffers.ArgumentStateBuffer.update(ArgumentStateBuffer.scala:22)
at org.neo4j.cypher.internal.runtime.pipelined.state.buffers.OptionalMorselBuffer.$anonfun$put$1(OptionalMorselBuffer.scala:102)
at org.neo4j.cypher.internal.runtime.pipelined.state.buffers.OptionalMorselBuffer.$anonfun$put$1$adapted(OptionalMorselBuffer.scala:101)
at org.neo4j.cypher.internal.runtime.pipelined.state.AbstractArgumentStateMap.update(AbstractArgumentStateMap.scala:38)
at org.neo4j.cypher.internal.runtime.pipelined.state.buffers.OptionalMorselBuffer.put(OptionalMorselBuffer.scala:101)
at org.neo4j.cypher.internal.runtime.pipelined.state.buffers.OptionalMorselBuffer.put(OptionalMorselBuffer.scala:28)
at org.neo4j.cypher.internal.runtime.pipelined.execution.AlarmSink.put(WorkerWaker.scala:27)
at org.neo4j.cypher.internal.runtime.pipelined.operators.MorselArgumentStateBufferPreparedOutput.produce(OutputOperator.scala:151)
at org.neo4j.cypher.internal.runtime.pipelined.Worker.executeTask(Worker.scala:136)
at org.neo4j.cypher.internal.runtime.pipelined.Worker.workOnQuery(Worker.scala:84)
at org.neo4j.cypher.internal.runtime.pipelined.execution.CallingThreadExecutingQuery.request(CallingThreadExecutingQuery.scala:30)
at org.neo4j.cypher.internal.PipelinedRuntime$PipelinedRuntimeResult.request(PipelinedRuntime.scala:326)
at org.neo4j.cypher.internal.result.StandardInternalExecutionResult.request(StandardInternalExecutionResult.scala:88)
at org.neo4j.cypher.internal.result.ClosingExecutionResult.request(ClosingExecutionResult.scala:135)
at org.neo4j.bolt.runtime.AbstractCypherAdapterStream.handleRecords(AbstractCypherAdapterStream.java:105)
at org.neo4j.bolt.v3.messaging.ResultHandler.onPullRecords(ResultHandler.java:41)
at org.neo4j.bolt.v4.messaging.PullResultConsumer.consume(PullResultConsumer.java:42)
at org.neo4j.bolt.runtime.statemachine.impl.TransactionStateMachine$State.consumeResult(TransactionStateMachine.java:511)
at org.neo4j.bolt.runtime.statemachine.impl.TransactionStateMachine$State$2.streamResult(TransactionStateMachine.java:355)
at org.neo4j.bolt.runtime.statemachine.impl.TransactionStateMachine.streamResult(TransactionStateMachine.java:92)
at org.neo4j.bolt.v4.runtime.InTransactionState.processStreamResultMessage(InTransactionState.java:73)
at org.neo4j.bolt.v4.runtime.AbstractStreamingState.processUnsafe(AbstractStreamingState.java:49)
at org.neo4j.bolt.v4.runtime.InTransactionState.processUnsafe(InTransactionState.java:60)
at org.neo4j.bolt.v3.runtime.FailSafeBoltStateMachineState.process(FailSafeBoltStateMachineState.java:48)
at org.neo4j.bolt.runtime.statemachine.impl.AbstractBoltStateMachine.nextState(AbstractBoltStateMachine.java:143)
at org.neo4j.bolt.runtime.statemachine.impl.AbstractBoltStateMachine.process(AbstractBoltStateMachine.java:91)
at org.neo4j.bolt.messaging.BoltRequestMessageReader.lambda$doRead$1(BoltRequestMessageReader.java:90)
at org.neo4j.bolt.runtime.DefaultBoltConnection.lambda$enqueue$0(DefaultBoltConnection.java:151)
at org.neo4j.bolt.runtime.DefaultBoltConnection.processNextBatchInternal(DefaultBoltConnection.java:240)
at org.neo4j.bolt.runtime.DefaultBoltConnection.processNextBatch(DefaultBoltConnection.java:175)
at org.neo4j.bolt.runtime.DefaultBoltConnection.processNextBatch(DefaultBoltConnection.java:165)
at org.neo4j.bolt.runtime.scheduling.ExecutorBoltScheduler.executeBatch(ExecutorBoltScheduler.java:212)
at org.neo4j.bolt.runtime.scheduling.ExecutorBoltScheduler.lambda$scheduleBatchOrHandleError$2(ExecutorBoltScheduler.java:195)
at java.base/java.util.concurrent.CompletableFuture$AsyncSupply.run(CompletableFuture.java:1700)
at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1128)
at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)
at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30)
at java.base/java.lang.Thread.run(Thread.java:834)

2020-07-08 15:59:58.731+0000 WARN [io.netty.channel.nio.NioEventLoop] Unexpected exception in the selector loop. Java heap space
java.lang.OutOfMemoryError: Java heap space
2020-07-08 15:59:58.731+0000 WARN [io.netty.channel.nio.NioEventLoop] Unexpected exception in the selector loop. Java heap space
java.lang.OutOfMemoryError: Java heap space
2020-07-08 15:59:58.731+0000 WARN [io.netty.util.concurrent.SingleThreadEventExecutor] Unexpected exception from an event executor: Java heap space
java.lang.OutOfMemoryError: Java heap space