I also think this is a common problem to the case that the receiver has no chance to sent out a ack reply, maybe it died, causing the query to exception over. Then it will cause the allocator thread’s cleanup method to complain about the memory leak as the sender thread’s exception solving logic to release the ByteBuf maybe happed behind the allocator thread.
On Thu, Jun 21, 2018 at 8:51 AM weijie tong <[email protected]> wrote: > Hi Parth: > > Thanks for your reply. Your detail description explain that problem > clearly. This problem is not a common case. The bloom filter has not been > sent out while the query has completed. I meet this exception while open > the bloom filter option to run all the join related test cases, then it > happen at TestHashJoin.simpleEqualityJoin() . Btw, the BloomFilter was > sent out through the data tunnel not the control one. To partitioned > broadcast , the bloom filter will send out from each HashJoin node to the > foreman node . The foreman node will wait for all the bloom filter which it > known at the plan stage to come until the timeout occur. Once the foreman > node received all the bloom filter ,it will aggregate them then broadcast > them to all the probe side scan nodes. The design purpose is that all the > origin flow will not blocked by the runtime bloom filter flow . The bloom > filter sending, receiving , applying behaviors are all async ,just a > helpful behavior to the original execution flow. > > > First, not all the HashJoin scenarios is possible to push down the > join predicate such as the both sides has similar row numbers. I will add > some check according the cost at the plan stage to prevent this happen so > the exception scenario will happen less. > > Send, I think the exception scenario still has to prevent to let the > system robust. Your suggestion to add a synchronization between (3) ,(4) > and (6) is good. But the question is that the corresponding receiving side > has completed, it has no chance to give a reply ack. Maybe some other > special timeout Ack was needed to take the lost role to let the Thread1 to > wait while the sending out behavior failed. To this test case , the > hash join node is the last fragment, and it has few data to complete its > query. > > As normal execution flow has worked out, I will share the dev branch > soon by fix some trivial things. Still need suggestions to this problem. > > > > On Thu, Jun 21, 2018 at 6:44 AM Parth Chandra <[email protected]> wrote: > >> Hi Weijie >> >> It would also help to understand the flow of control that your design >> uses. I've put a screenshot of a query profile here : >> >> https://docs.google.com/document/d/1DgAbGovEWV6rZ4GvioJz5Twe_m5o1ADoBpbqAzqa_aU/edit?usp=sharing >> >> Looking at the subset under [ Hash Join 06-01 ], can you annotate >> and/or >> explain how you see the control messages flowing? Also, are you using the >> control channel to send the bloom filter? >> >> Parth >> >> On Wed, Jun 20, 2018 at 3:28 PM, Parth Chandra <[email protected]> wrote: >> >> > Hi Weijie, >> > This is a tricky problem. So let me first summarize how this should be >> > behaving - >> > >> > Thread 1 | Thread 2 >> > -----------------------------------+------------------------ >> > ------------------ >> > 1) Allocate DrillBuf | >> > 2) Pass memory to RPC layer | get reference to DrillBuf >> > (refcount == 2) >> > 3) | queue up the send (async) >> > 4) | Send and release DrillBuf >> > (refcount == 1) >> > 5) Continue to end of query | >> > 6) Cleanup (release DrillBuf) | >> > 7) Close Allocator (refcount of | >> > DrillBuf *must* be zero) | >> > >> > In your case, steps 3 and 4 are occurring after step 7 which is natural >> > since the RPC send is async, but that is what we have to prevent. The >> only >> > way to do that is to have some synchronization between steps (3), (4), >> and >> > (6) such that (6) only happens after (4). With RPC the way to do so is >> to >> > require an ack. >> > >> > >> > Thread 1 | Thread 2 (Netty) >> > | Thread 3 (foreman) >> > -----------------------------------+------------------------ >> > --------------------+------------------------ >> > 1) Allocate DrillBuf | >> > | >> > 2) Pass memory to RPC layer | get reference to DrillBuf >> > (refcount == 2)| >> > 3) | queue up the send (async) >> > | >> > 4) | Send and release DrillBuf >> > (refcount == 1)| >> > 4.1) | >> > | Recv msg, send back Ack (The RPC layer >> > | >> > | automatically does this) >> > 4.2) Check if Ack received | >> > 5) Continue to end of query | >> > 6) Cleanup (release DrillBuf) | >> > 7) Close Allocator (refcount of | >> > DrillBuf *must* be zero) | >> > >> > Note that (4.2) does not have to complete before (5), only before (6) >> for >> > the memory to be released. >> > >> > One question I have is how the query completed without the Bloom Filter >> > reaching its destination. How does the destination fragment know when it >> > has to wait for the Bloom Filter? I suspect this may be more >> > complicated than it appears at first glance. >> > >> > Not sure if this helps narrow it down. If you can share a dev branch we >> > can help take a look. >> > >> > >> > >> > On Tue, Jun 19, 2018 at 8:35 PM, weijie tong <[email protected]> >> > wrote: >> > >> >> HI: >> >> I faced a complicated problem by releasing the BloomFilter's direct >> >> memory at some special cases. Hope someone could give some advices. >> >> >> >> Say, one join node sends out BloomFilter to the foreman >> >> node(TestHashJoin.simpleEqualityJoin() ) . The sending thread is >> netty's >> >> BitClient. The BloomFilter's direct memory is allocated by another >> thread >> >> allocator (i.e. the HashJoin fragment's allocator). Once the fragment >> >> completes quickly. Then its corresponding close logic will check the >> >> allocator's memory assignment. But the async sender thread has not sent >> >> out >> >> the BloomFilter to release the corresponding direct ByteBuffer as the >> >> query >> >> has completed quickly , the wire has closed. Then the corresponding >> >> fragment's close logic will throw exception to complain about the >> memory >> >> leak. >> >> >> >> So I want to know how to release the allocated direct ByteBuffer at >> >> such case . >> >> >> >> >> >> The exception is : >> >> >> >> [Error Id: 0042b168-8728-4367-b461-653837c3a276 on 10.15.235.86:31010] >> >> at >> >> org.apache.drill.common.exceptions.UserException$Builder. >> >> build(UserException.java:633) >> >> ~[classes/:na] >> >> at >> >> org.apache.drill.exec.work.fragment.FragmentExecutor.sendFin >> >> alState(FragmentExecutor.java:359) >> >> [classes/:na] >> >> at >> >> org.apache.drill.exec.work.fragment.FragmentExecutor.cleanup >> >> (FragmentExecutor.java:214) >> >> [classes/:na] >> >> at >> >> org.apache.drill.exec.work.fragment.FragmentExecutor.run(Fra >> >> gmentExecutor.java:325) >> >> [classes/:na] >> >> at >> >> org.apache.drill.common.SelfCleaningRunnable.run(SelfCleanin >> >> gRunnable.java:38) >> >> [classes/:na] >> >> at >> >> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPool >> >> Executor.java:1149) >> >> [na:1.8.0_161] >> >> at >> >> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoo >> >> lExecutor.java:624) >> >> [na:1.8.0_161] >> >> at java.lang.Thread.run(Thread.java:748) [na:1.8.0_161] >> >> Caused by: java.lang.IllegalStateException: Allocator[frag:0:0] closed >> >> with >> >> outstanding buffers allocated (1). >> >> Allocator(frag:0:0) 4000000/16777216/47664448/30357913941 >> >> (res/actual/peak/limit) >> >> child allocators: 0 >> >> ledgers: 1 >> >> ledger[6268] allocator: frag:0:0), isOwning: true, size: 16777216, >> >> references: 1, life: 505919927431943..0, allocatorManager: [6050, life: >> >> 505919927378312..0] holds 2 buffers. >> >> DrillBuf[10198], udle: [6051 0..16777216] >> >> DrillBuf[10208], udle: [6051 0..16777216] >> >> reservations: 0 >> >> >> >> at org.apache.drill.exec.memory.BaseAllocator.close(BaseAllocat >> >> or.java:503) >> >> ~[classes/:na] >> >> at >> >> org.apache.drill.exec.ops.FragmentContextImpl.suppressingClo >> >> se(FragmentContextImpl.java:484) >> >> ~[classes/:na] >> >> at >> >> org.apache.drill.exec.ops.FragmentContextImpl.close(Fragment >> >> ContextImpl.java:478) >> >> ~[classes/:na] >> >> at >> >> org.apache.drill.exec.work.fragment.FragmentExecutor.closeOu >> >> tResources(FragmentExecutor.java:382) >> >> [classes/:na] >> >> at >> >> org.apache.drill.exec.work.fragment.FragmentExecutor.cleanup >> >> (FragmentExecutor.java:209) >> >> [classes/:na] >> >> ... 5 common frames omitted >> >> =====================fragment:0 : 0done! >> >> *************************receive a bloom filter********** >> >> ************received a bloom filter >> >> 11:00:41.587 [main] ERROR o.a.d.exec.server.BootStrapContext - Error >> >> while >> >> closing >> >> java.lang.IllegalStateException: Allocator[ROOT] closed with >> outstanding >> >> child allocators. >> >> Allocator(ROOT) 0/16777216/55640064/4294967296 (res/actual/peak/limit) >> >> child allocators: 1 >> >> Allocator(frag:0:0) 4000000/16777216/47664448/30357913941 >> >> (res/actual/peak/limit) >> >> child allocators: 0 >> >> ledgers: 1 >> >> ledger[6268] allocator: frag:0:0), isOwning: true, size: >> 16777216, >> >> references: 1, life: 505919927431943..0, allocatorManager: [6050, life: >> >> 505919927378312..0] holds 2 buffers. >> >> DrillBuf[10198], udle: [6051 0..16777216] >> >> DrillBuf[10208], udle: [6051 0..16777216] >> >> reservations: 0 >> >> ledgers: 0 >> >> reservations: 0 >> >> >> >> at org.apache.drill.exec.memory.BaseAllocator.close(BaseAllocat >> >> or.java:496) >> >> ~[classes/:na] >> >> at org.apache.drill.common.AutoCloseables.close(AutoCloseables.java:81) >> >> [classes/:na] >> >> at org.apache.drill.common.AutoCloseables.close(AutoCloseables.java:69) >> >> [classes/:na] >> >> at >> >> org.apache.drill.exec.server.BootStrapContext.close(BootStra >> >> pContext.java:259) >> >> ~[classes/:na] >> >> at org.apache.drill.common.AutoCloseables.close(AutoCloseables.java:81) >> >> [classes/:na] >> >> at org.apache.drill.common.AutoCloseables.close(AutoCloseables.java:69) >> >> [classes/:na] >> >> at org.apache.drill.exec.server.Drillbit.close(Drillbit.java:263) >> >> [classes/:na] >> >> at >> >> org.apache.drill.exec.physical.impl.join.TestHashJoin.simple >> >> EqualityJoin(TestHashJoin.java:147) >> >> [test-classes/:na] >> >> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) >> >> ~[na:1.8.0_161] >> >> at >> >> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAcce >> >> ssorImpl.java:62) >> >> ~[na:1.8.0_161] >> >> at >> >> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMe >> >> thodAccessorImpl.java:43) >> >> ~[na:1.8.0_161] >> >> at java.lang.reflect.Method.invoke(Method.java:498) ~[na:1.8.0_161] >> >> at >> >> org.junit.runners.model.FrameworkMethod$1.runReflectiveCall( >> >> FrameworkMethod.java:50) >> >> [junit-4.12.jar:4.12] >> >> at >> >> org.junit.internal.runners.model.ReflectiveCallable.run(Refl >> >> ectiveCallable.java:12) >> >> [junit-4.12.jar:4.12] >> >> at >> >> org.junit.runners.model.FrameworkMethod.invokeExplosively(Fr >> >> ameworkMethod.java:47) >> >> [junit-4.12.jar:4.12] >> >> at >> >> mockit.integration.junit4.internal.JUnit4TestRunnerDecorator >> >> .executeTestMethod(JUnit4TestRunnerDecorator.java:154) >> >> [jmockit-1.39.jar:1.39] >> >> at >> >> mockit.integration.junit4.internal.JUnit4TestRunnerDecorator >> >> .invokeExplosively(JUnit4TestRunnerDecorator.java:70) >> >> [jmockit-1.39.jar:1.39] >> >> at >> >> mockit.integration.junit4.internal.FakeFrameworkMethod.invok >> >> eExplosively(FakeFrameworkMethod.java:34) >> >> [jmockit-1.39.jar:1.39] >> >> at >> >> org.junit.runners.model.FrameworkMethod.invokeExplosively(Fr >> >> ameworkMethod.java) >> >> [junit-4.12.jar:4.12] >> >> at >> >> org.junit.internal.runners.statements.InvokeMethod.evaluate( >> >> InvokeMethod.java:17) >> >> [junit-4.12.jar:4.12] >> >> at >> >> org.junit.internal.runners.statements.RunBefores.evaluate( >> >> RunBefores.java:26) >> >> [junit-4.12.jar:4.12] >> >> at >> >> org.junit.internal.runners.statements.RunAfters.evaluate(Run >> >> Afters.java:27) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55) >> >> [junit-4.12.jar:4.12] >> >> at >> >> org.junit.rules.ExpectedException$ExpectedExceptionStatement >> >> .evaluate(ExpectedException.java:239) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.rules.RunRules.evaluate(RunRules.java:20) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.runners.ParentRunner.runLeaf(ParentRunner.java:325) >> >> [junit-4.12.jar:4.12] >> >> at >> >> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit >> >> 4ClassRunner.java:78) >> >> [junit-4.12.jar:4.12] >> >> at >> >> org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit >> >> 4ClassRunner.java:57) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.runners.ParentRunner$3.run(ParentRunner.java:290) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:71) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:288) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.runners.ParentRunner.access$000(ParentRunner.java:58) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:268) >> >> [junit-4.12.jar:4.12] >> >> at >> >> org.junit.internal.runners.statements.RunBefores.evaluate( >> >> RunBefores.java:26) >> >> [junit-4.12.jar:4.12] >> >> at >> >> org.junit.internal.runners.statements.RunAfters.evaluate(Run >> >> Afters.java:27) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.rules.TestWatcher$1.evaluate(TestWatcher.java:55) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.rules.RunRules.evaluate(RunRules.java:20) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.runners.ParentRunner.run(ParentRunner.java:363) >> >> [junit-4.12.jar:4.12] >> >> at org.junit.runner.JUnitCore.run(JUnitCore.java:137) >> >> [junit-4.12.jar:4.12] >> >> at >> >> com.intellij.junit4.JUnit4IdeaTestRunner.startRunnerWithArgs >> >> (JUnit4IdeaTestRunner.java:68) >> >> [junit-rt.jar:na] >> >> at >> >> com.intellij.rt.execution.junit.IdeaTestRunner$Repeater.star >> >> tRunnerWithArgs(IdeaTestRunner.java:47) >> >> [junit-rt.jar:na] >> >> at >> >> com.intellij.rt.execution.junit.JUnitStarter.prepareStreamsA >> >> ndStart(JUnitStarter.java:242) >> >> [junit-rt.jar:na] >> >> at com.intellij.rt.execution.junit.JUnitStarter.main(JUnitStart >> >> er.java:70) >> >> [junit-rt.jar:na] >> >> 11:00:41.593 [main] ERROR org.apache.drill.TestReporter - Test Failed >> (d: >> >> 0 >> >> B(1 B), h: -360.8 MiB(52.3 MiB), nh: 3.2 MiB(88.4 MiB)): >> >> >> simpleEqualityJoin(org.apache.drill.exec.physical.impl.join.TestHashJoin) >> >> org.apache.drill.exec.rpc.RpcException: >> >> org.apache.drill.common.exceptions.UserRemoteException: SYSTEM ERROR: >> >> IllegalStateException: Allocator[frag:0:0] closed with outstanding >> buffers >> >> allocated (1). >> >> Allocator(frag:0:0) 4000000/16777216/47664448/30357913941 >> >> (res/actual/peak/limit) >> >> child allocators: 0 >> >> ledgers: 1 >> >> ledger[6268] allocator: frag:0:0), isOwning: true, size: 16777216, >> >> references: 1, life: 505919927431943..0, allocatorManager: [6050, life: >> >> 505919927378312..0] holds 2 buffers. >> >> DrillBuf[10198], udle: [6051 0..16777216] >> >> DrillBuf[10208], udle: [6051 0..16777216] >> >> reservations: 0 >> >> >> >> >> >> Fragment 0:0 >> >> >> >> [Error Id: 0042b168-8728-4367-b461-653837c3a276 on 10.15.235.86:31010] >> >> at >> >> >> org.apache.drill.exec.rpc.RpcException.mapException(RpcException.java:60) >> >> ~[classes/:na] >> >> at >> >> org.apache.drill.exec.client.DrillClient$ListHoldingResultsL >> >> istener.getResults(DrillClient.java:881) >> >> ~[classes/:na] >> >> at org.apache.drill.exec.client.DrillClient.runQuery(DrillClien >> >> t.java:583) >> >> ~[classes/:na] >> >> at >> >> org.apache.drill.exec.physical.impl.join.TestHashJoin.simple >> >> EqualityJoin(TestHashJoin.java:119) >> >> ~[test-classes/:na] >> >> org.apache.drill.common.exceptions.UserRemoteException: SYSTEM ERROR: >> >> IllegalStateException: Allocator[frag:0:0] closed with outstanding >> buffers >> >> allocated (1). >> >> Allocator(frag:0:0) 4000000/16777216/47664448/30357913941 >> >> (res/actual/peak/limit) >> >> child allocators: 0 >> >> ledgers: 1 >> >> ledger[6268] allocator: frag:0:0), isOwning: true, size: 16777216, >> >> references: 1, life: 505919927431943..0, allocatorManager: [6050, life: >> >> 505919927378312..0] holds 2 buffers. >> >> DrillBuf[10198], udle: [6051 0..16777216] >> >> DrillBuf[10208], udle: [6051 0..16777216] >> >> reservations: 0 >> >> >> >> >> >> Fragment 0:0 >> >> >> >> [Error Id: 0042b168-8728-4367-b461-653837c3a276 on 10.15.235.86:31010] >> >> at >> >> org.apache.drill.exec.rpc.user.QueryResultHandler.resultArri >> >> ved(QueryResultHandler.java:123) >> >> ~[classes/:na] >> >> at >> org.apache.drill.exec.rpc.user.UserClient.handle(UserClient.java:422) >> >> ~[classes/:na] >> >> at org.apache.drill.exec.rpc.user.UserClient.handle(UserClient.java:96) >> >> ~[classes/:na] >> >> at org.apache.drill.exec.rpc.RpcBus$InboundHandler.decode(RpcBu >> >> s.java:275) >> >> ~[classes/:na] >> >> at org.apache.drill.exec.rpc.RpcBus$InboundHandler.decode(RpcBu >> >> s.java:245) >> >> ~[classes/:na] >> >> at >> >> io.netty.handler.codec.MessageToMessageDecoder.channelRead(M >> >> essageToMessageDecoder.java:88) >> >> ~[netty-codec-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.fireChannelRe >> >> ad(AbstractChannelHandlerContext.java:335) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.handler.timeout.IdleStateHandler.channelRead(IdleSt >> >> ateHandler.java:287) >> >> ~[netty-handler-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.fireChannelRe >> >> ad(AbstractChannelHandlerContext.java:335) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.handler.codec.MessageToMessageDecoder.channelRead(M >> >> essageToMessageDecoder.java:102) >> >> ~[netty-codec-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.fireChannelRe >> >> ad(AbstractChannelHandlerContext.java:335) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead( >> >> ByteToMessageDecoder.java:312) >> >> ~[netty-codec-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.handler.codec.ByteToMessageDecoder.channelRead(Byte >> >> ToMessageDecoder.java:286) >> >> ~[netty-codec-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.fireChannelRe >> >> ad(AbstractChannelHandlerContext.java:335) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.ChannelInboundHandlerAdapter.channelRead(Ch >> >> annelInboundHandlerAdapter.java:86) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.fireChannelRe >> >> ad(AbstractChannelHandlerContext.java:335) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.DefaultChannelPipeline$HeadContext. >> >> channelRead(DefaultChannelPipeline.java:1294) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.DefaultChannelPipeline.fireChannelRead(Defa >> >> ultChannelPipeline.java:911) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe. >> >> read(AbstractNioByteChannel.java:131) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEven >> >> tLoop.java:645) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimiz >> >> ed(NioEventLoop.java:580) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEve >> >> ntLoop.java:497) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:459) >> >> ~[netty-transport-4.0.48.Final.jar:4.0.48.Final] >> >> at >> >> io.netty.util.concurrent.SingleThreadEventExecutor$2.run( >> >> SingleThreadEventExecutor.java:131) >> >> ~[netty-common-4.0.48.Final.jar:4.0.48.Final] >> >> at java.lang.Thread.run(Thread.java:748) ~[na:1.8.0_161] >> >> >> >> org.apache.drill.exec.rpc.RpcException: >> >> org.apache.drill.common.exceptions.UserRemoteException: SYSTEM ERROR: >> >> IllegalStateException: Allocator[frag:0:0] closed with outstanding >> buffers >> >> allocated (1). >> >> Allocator(frag:0:0) 4000000/16777216/47664448/30357913941 >> >> (res/actual/peak/limit) >> >> child allocators: 0 >> >> ledgers: 1 >> >> ledger[6268] allocator: frag:0:0), isOwning: true, size: 16777216, >> >> references: 1, life: 505919927431943..0, allocatorManager: [6050, life: >> >> 505919927378312..0] holds 2 buffers. >> >> DrillBuf[10198], udle: [6051 0..16777216] >> >> DrillBuf[10208], udle: [6051 0..16777216] >> >> reservations: 0 >> >> >> >> >> >> Fragment 0:0 >> >> >> >> [Error Id: 0042b168-8728-4367-b461-653837c3a276 on 10.15.235.86:31010] >> >> >> >> at org.apache.drill.exec.rpc.RpcException.mapException(RpcExcep >> >> tion.java:60) >> >> at >> >> org.apache.drill.exec.client.DrillClient$ListHoldingResultsL >> >> istener.getResults(DrillClient.java:881) >> >> at org.apache.drill.exec.client.DrillClient.runQuery(DrillClien >> >> t.java:583) >> >> at >> >> org.apache.drill.exec.physical.impl.join.TestHashJoin.simple >> >> EqualityJoin(TestHashJoin.java:119) >> >> Caused by: org.apache.drill.common.exceptions.UserRemoteException: >> SYSTEM >> >> ERROR: IllegalStateException: Allocator[frag:0:0] closed with >> outstanding >> >> buffers allocated (1). >> >> Allocator(frag:0:0) 4000000/16777216/47664448/30357913941 >> >> (res/actual/peak/limit) >> >> child allocators: 0 >> >> ledgers: 1 >> >> ledger[6268] allocator: frag:0:0), isOwning: true, size: 16777216, >> >> references: 1, life: 505919927431943..0, allocatorManager: [6050, life: >> >> 505919927378312..0] holds 2 buffers. >> >> DrillBuf[10198], udle: [6051 0..16777216] >> >> DrillBuf[10208], udle: [6051 0..16777216] >> >> reservations: 0 >> >> >> >> >> >> Fragment 0:0 >> >> >> >> [Error Id: 0042b168-8728-4367-b461-653837c3a276 on 10.15.235.86:31010] >> >> at >> >> org.apache.drill.exec.rpc.user.QueryResultHandler.resultArri >> >> ved(QueryResultHandler.java:123) >> >> at >> org.apache.drill.exec.rpc.user.UserClient.handle(UserClient.java:422) >> >> at org.apache.drill.exec.rpc.user.UserClient.handle(UserClient.java:96) >> >> at org.apache.drill.exec.rpc.RpcBus$InboundHandler.decode(RpcBu >> >> s.java:275) >> >> at org.apache.drill.exec.rpc.RpcBus$InboundHandler.decode(RpcBu >> >> s.java:245) >> >> at >> >> io.netty.handler.codec.MessageToMessageDecoder.channelRead(M >> >> essageToMessageDecoder.java:88) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.fireChannelRe >> >> ad(AbstractChannelHandlerContext.java:335) >> >> at >> >> io.netty.handler.timeout.IdleStateHandler.channelRead(IdleSt >> >> ateHandler.java:287) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.fireChannelRe >> >> ad(AbstractChannelHandlerContext.java:335) >> >> at >> >> io.netty.handler.codec.MessageToMessageDecoder.channelRead(M >> >> essageToMessageDecoder.java:102) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.fireChannelRe >> >> ad(AbstractChannelHandlerContext.java:335) >> >> at >> >> io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead( >> >> ByteToMessageDecoder.java:312) >> >> at >> >> io.netty.handler.codec.ByteToMessageDecoder.channelRead(Byte >> >> ToMessageDecoder.java:286) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.fireChannelRe >> >> ad(AbstractChannelHandlerContext.java:335) >> >> at >> >> io.netty.channel.ChannelInboundHandlerAdapter.channelRead(Ch >> >> annelInboundHandlerAdapter.java:86) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.fireChannelRe >> >> ad(AbstractChannelHandlerContext.java:335) >> >> at >> >> io.netty.channel.DefaultChannelPipeline$HeadContext. >> >> channelRead(DefaultChannelPipeline.java:1294) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:356) >> >> at >> >> io.netty.channel.AbstractChannelHandlerContext.invokeChannel >> >> Read(AbstractChannelHandlerContext.java:342) >> >> at >> >> io.netty.channel.DefaultChannelPipeline.fireChannelRead(Defa >> >> ultChannelPipeline.java:911) >> >> at >> >> io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe. >> >> read(AbstractNioByteChannel.java:131) >> >> at >> >> io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEven >> >> tLoop.java:645) >> >> at >> >> io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimiz >> >> ed(NioEventLoop.java:580) >> >> at >> >> io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEve >> >> ntLoop.java:497) >> >> at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:459) >> >> at >> >> io.netty.util.concurrent.SingleThreadEventExecutor$2.run( >> >> SingleThreadEventExecutor.java:131) >> >> at java.lang.Thread.run(Thread.java:748) >> >> >> > >> > >> >
