Return-Path: X-Original-To: apmail-ignite-issues-archive@minotaur.apache.org Delivered-To: apmail-ignite-issues-archive@minotaur.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id 6593A17DFD for ; Sat, 9 May 2015 16:51:07 +0000 (UTC) Received: (qmail 35641 invoked by uid 500); 9 May 2015 16:51:07 -0000 Delivered-To: apmail-ignite-issues-archive@ignite.apache.org Received: (qmail 35617 invoked by uid 500); 9 May 2015 16:51:07 -0000 Mailing-List: contact issues-help@ignite.incubator.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: dev@ignite.incubator.apache.org Delivered-To: mailing list issues@ignite.incubator.apache.org Received: (qmail 35608 invoked by uid 99); 9 May 2015 16:51:07 -0000 Received: from Unknown (HELO spamd3-us-west.apache.org) (209.188.14.142) by apache.org (qpsmtpd/0.29) with ESMTP; Sat, 09 May 2015 16:51:07 +0000 Received: from localhost (localhost [127.0.0.1]) by spamd3-us-west.apache.org (ASF Mail Server at spamd3-us-west.apache.org) with ESMTP id D8E691826A2 for ; Sat, 9 May 2015 16:51:06 +0000 (UTC) X-Virus-Scanned: Debian amavisd-new at spamd3-us-west.apache.org X-Spam-Flag: NO X-Spam-Score: 0.97 X-Spam-Level: X-Spam-Status: No, score=0.97 tagged_above=-999 required=6.31 tests=[KAM_LAZY_DOMAIN_SECURITY=1, RCVD_IN_MSPIKE_H3=-0.01, RCVD_IN_MSPIKE_WL=-0.01, T_RP_MATCHES_RCVD=-0.01] autolearn=disabled Received: from mx1-us-west.apache.org ([10.40.0.8]) by localhost (spamd3-us-west.apache.org [10.40.0.10]) (amavisd-new, port 10024) with ESMTP id cuMMtf48wyKy for ; Sat, 9 May 2015 16:51:04 +0000 (UTC) Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by mx1-us-west.apache.org (ASF Mail Server at mx1-us-west.apache.org) with SMTP id 146B924BCB for ; Sat, 9 May 2015 16:51:04 +0000 (UTC) Received: (qmail 88576 invoked by uid 99); 9 May 2015 15:51:04 -0000 Received: from arcas.apache.org (HELO arcas.apache.org) (140.211.11.28) by apache.org (qpsmtpd/0.29) with ESMTP; Sat, 09 May 2015 15:51:03 +0000 Date: Sat, 9 May 2015 15:51:03 +0000 (UTC) From: "Dmitriy Setrakyan (JIRA)" To: issues@ignite.incubator.apache.org Message-ID: In-Reply-To: References: Subject: [jira] [Updated] (IGNITE-885) NPE in GridMapQueryExecutor under load on changing topology MIME-Version: 1.0 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: quoted-printable X-JIRA-FingerPrint: 30527f35849b9dde25b450d4833f0394 [ https://issues.apache.org/jira/browse/IGNITE-885?page=3Dcom.atlassia= n.jira.plugin.system.issuetabpanels:all-tabpanel ] Dmitriy Setrakyan updated IGNITE-885: ------------------------------------- Description:=20 The error is reproduced with "streaming.wordcount" example. # Start instance of {{ExampleNodeStartup}} # Start {{StreamWords}} instance # Start {{QueryWords}} instance # Watch query results coming # Start another {{ExampleNodeStartup}} instance. On the new {{ExampleNodeStartup}} I get the following error: {code} [08:31:31] / _/ ___/ |/ / _/_ __/ __/=20 [08:31:31] _/ // (7 7 // / / / / _/ =20 [08:31:31] /___/\___/_/|_/___/ /_/ /___/ =20 [08:31:31] =20 [08:31:31] ver. 1.0.4#20150507-sha1:0c13a08b [08:31:31] 2015 Copyright(C) Apache Software Foundation [08:31:31]=20 [08:31:31] Quiet mode. [08:31:31] ^-- Logging to file '/Users/Dmitriy/GridGain/gitroot/incubator= -ignite/work/log/ignite-0b843b9b.log' [08:31:31] ^-- To see **FULL** console log here add -DIGNITE_QUIET=3Dfals= e or "-v" to ignite.{sh|bat} [08:31:31]=20 [08:31:31] Configured plugins: [08:31:31] ^-- None [08:31:31]=20 [08:31:33,018][ERROR][ignite-#8%pub-null%][GridMapQueryExecutor] Failed to = process message: GridQueryRequest [reqId=3D57, pageSize=3D1024, space=3Dwor= ds, qrys=3D[GridCacheSqlQuery [alias=3D__Z0(), qry=3DSELECT _VAL __C0, COUNT(_VAL) __C1 FROM "words".STRING GROUP BY __C0 ORDER BY 2 DESC LIMIT 10, params=3D[]]]] java.lang.NullPointerException =09at org.apache.ignite.internal.processors.query.h2.twostep.GridMapQueryEx= ecutor.onQueryRequest(GridMapQueryExecutor.java:225) =09at org.apache.ignite.internal.processors.query.h2.twostep.GridMapQueryEx= ecutor.onMessage(GridMapQueryExecutor.java:150) =09at org.apache.ignite.internal.processors.query.h2.twostep.GridMapQueryEx= ecutor$2.onMessage(GridMapQueryExecutor.java:125) =09at org.apache.ignite.internal.managers.communication.GridIoManager$Array= Listener.onMessage(GridIoManager.java:1603) =09at org.apache.ignite.internal.managers.communication.GridIoManager.proce= ssRegularMessage0(GridIoManager.java:690) =09at org.apache.ignite.internal.managers.communication.GridIoManager.acces= s$1500(GridIoManager.java:58) =09at org.apache.ignite.internal.managers.communication.GridIoManager$5.run= (GridIoManager.java:653) =09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.= java:1142) =09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor= .java:617) =09at java.lang.Thread.run(Thread.java:745) [08:31:34] Performance suggestions for grid (fix if possible) [08:31:34] To disable, set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=3Dtrue [08:31:34] ^-- Disable peer class loading (set 'peerClassLoadingEnabled' = to false) [08:31:34] ^-- Disable grid events (remove 'includeEventTypes' from confi= guration) [08:31:34]=20 [08:31:34] To start Console Management & Monitoring run ignitevisorcmd.{sh|= bat} [08:31:34]=20 [08:31:34] Ignite node started OK (id=3D0b843b9b) [08:31:34] Topology snapshot [ver=3D7, nodes=3D3, CPUs=3D4, heap=3D9.6GB] ... {code} was: The error is reproduced with "streaming.wordcount" example. # Start instance of {{ExampleNodeStartup}} # Start {{StreamWords}} instance # Start {{QueryWords}} instance # Watch query results coming # Start another {{ExampleNodeStartup}} instance. On the new {{ExampleNodeStartup}} I get the following error: {code} /Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/bin/java -m= s3g -mx3g -Didea.launcher.port=3D7552 "-Didea.launcher.bin.path=3D/Applicat= ions/IntelliJ IDEA 14.app/Contents/bin" -Dfile.encoding=3DUTF-8 -classpath = "/Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/lib/ant-ja= vafx.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/li= b/dt.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/li= b/javafx-mx.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/= Home/lib/jconsole.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Con= tents/Home/lib/sa-jdi.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk= /Contents/Home/lib/tools.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25.= jdk/Contents/Home/jre/lib/charsets.jar:/Library/Java/JavaVirtualMachines/jd= k1.8.0_25.jdk/Contents/Home/jre/lib/deploy.jar:/Library/Java/JavaVirtualMac= hines/jdk1.8.0_25.jdk/Contents/Home/jre/lib/javaws.jar:/Library/Java/JavaVi= rtualMachines/jdk1.8.0_25.jdk/Contents/Home/jre/lib/jce.jar:/Library/Java/J= avaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/jre/lib/jfr.jar:/Library/J= ava/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/jre/lib/jfxswt.jar:/L= ibrary/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/jre/lib/jsse.= jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/jre/lib= /management-agent.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Con= tents/Home/jre/lib/plugin.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25= .jdk/Contents/Home/jre/lib/resources.jar:/Library/Java/JavaVirtualMachines/= jdk1.8.0_25.jdk/Contents/Home/jre/lib/rt.jar:/Library/Java/JavaVirtualMachi= nes/jdk1.8.0_25.jdk/Contents/Home/jre/lib/ext/cldrdata.jar:/Library/Java/Ja= vaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/jre/lib/ext/dnsns.jar:/Libr= ary/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/jre/lib/ext/jfxr= t.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/jre/l= ib/ext/localedata.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Con= tents/Home/jre/lib/ext/nashorn.jar:/Library/Java/JavaVirtualMachines/jdk1.8= .0_25.jdk/Contents/Home/jre/lib/ext/sunec.jar:/Library/Java/JavaVirtualMach= ines/jdk1.8.0_25.jdk/Contents/Home/jre/lib/ext/sunjce_provider.jar:/Library= /Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/jre/lib/ext/sunpkcs= 11.jar:/Library/Java/JavaVirtualMachines/jdk1.8.0_25.jdk/Contents/Home/jre/= lib/ext/zipfs.jar:/Users/Dmitriy/GridGain/release/community/1.0.4/gridgain-= community-fabric-1.0.4/examples/target/classes:/Users/Dmitriy/.m2/repositor= y/javax/cache/cache-api/1.0.0/cache-api-1.0.0.jar:/Users/Dmitriy/.m2/reposi= tory/org/apache/ignite/ignite-core/1.0.4/ignite-core-1.0.4.jar:/Users/Dmitr= iy/.m2/repository/org/apache/ignite/ignite-hibernate/1.0.4/ignite-hibernate= -1.0.4.jar:/Users/Dmitriy/.m2/repository/org/hibernate/hibernate-core/4.2.6= .Final/hibernate-core-4.2.6.Final.jar:/Users/Dmitriy/.m2/repository/antlr/a= ntlr/2.7.7/antlr-2.7.7.jar:/Users/Dmitriy/.m2/repository/org/jboss/logging/= jboss-logging/3.1.0.GA/jboss-logging-3.1.0.GA.jar:/Users/Dmitriy/.m2/reposi= tory/dom4j/dom4j/1.6.1/dom4j-1.6.1.jar:/Users/Dmitriy/.m2/repository/org/jb= oss/spec/javax/transaction/jboss-transaction-api_1.1_spec/1.0.1.Final/jboss= -transaction-api_1.1_spec-1.0.1.Final.jar:/Users/Dmitriy/.m2/repository/org= /hibernate/javax/persistence/hibernate-jpa-2.0-api/1.0.1.Final/hibernate-jp= a-2.0-api-1.0.1.Final.jar:/Users/Dmitriy/.m2/repository/org/hibernate/commo= n/hibernate-commons-annotations/4.0.2.Final/hibernate-commons-annotations-4= .0.2.Final.jar:/Users/Dmitriy/.m2/repository/org/javassist/javassist/3.15.0= -GA/javassist-3.15.0-GA.jar:/Users/Dmitriy/.m2/repository/org/apache/ignite= /ignite-spring/1.0.4/ignite-spring-1.0.4.jar:/Users/Dmitriy/.m2/repository/= org/springframework/spring-core/4.1.0.RELEASE/spring-core-4.1.0.RELEASE.jar= :/Users/Dmitriy/.m2/repository/org/springframework/spring-aop/4.1.0.RELEASE= /spring-aop-4.1.0.RELEASE.jar:/Users/Dmitriy/.m2/repository/aopalliance/aop= alliance/1.0/aopalliance-1.0.jar:/Users/Dmitriy/.m2/repository/org/springfr= amework/spring-beans/4.1.0.RELEASE/spring-beans-4.1.0.RELEASE.jar:/Users/Dm= itriy/.m2/repository/org/springframework/spring-context/4.1.0.RELEASE/sprin= g-context-4.1.0.RELEASE.jar:/Users/Dmitriy/.m2/repository/org/springframewo= rk/spring-expression/4.1.0.RELEASE/spring-expression-4.1.0.RELEASE.jar:/Use= rs/Dmitriy/.m2/repository/org/springframework/spring-tx/4.1.0.RELEASE/sprin= g-tx-4.1.0.RELEASE.jar:/Users/Dmitriy/.m2/repository/commons-logging/common= s-logging/1.1.1/commons-logging-1.1.1.jar:/Users/Dmitriy/.m2/repository/org= /apache/ignite/ignite-log4j/1.0.4/ignite-log4j-1.0.4.jar:/Users/Dmitriy/.m2= /repository/log4j/log4j/1.2.17/log4j-1.2.17.jar:/Users/Dmitriy/.m2/reposito= ry/org/apache/ignite/ignite-indexing/1.0.4/ignite-indexing-1.0.4.jar:/Users= /Dmitriy/.m2/repository/commons-codec/commons-codec/1.6/commons-codec-1.6.j= ar:/Users/Dmitriy/.m2/repository/org/apache/lucene/lucene-core/3.5.0/lucene= -core-3.5.0.jar:/Users/Dmitriy/.m2/repository/com/h2database/h2/1.3.175/h2-= 1.3.175.jar:/Users/Dmitriy/.m2/repository/org/apache/ignite/ignite-schedule= /1.0.4/ignite-schedule-1.0.4.jar:/Users/Dmitriy/.m2/repository/it/sauronsof= tware/cron4j/cron4j/2.2.5/cron4j-2.2.5.jar:/Users/Dmitriy/.m2/repository/co= m/google/code/simple-spring-memcached/spymemcached/2.7.3/spymemcached-2.7.3= .jar:/Users/Dmitriy/.m2/repository/org/jboss/netty/netty/3.2.0.Final/netty-= 3.2.0.Final.jar:/Users/Dmitriy/.m2/repository/org/codehaus/jettison/jettiso= n/1.1/jettison-1.1.jar:/Users/Dmitriy/.m2/repository/stax/stax-api/1.0.1/st= ax-api-1.0.1.jar:/Applications/IntelliJ IDEA 14.app/Contents/lib/idea_rt.ja= r" com.intellij.rt.execution.application.AppMain org.apache.ignite.examples= .ExampleNodeStartup [08:31:31] __________ ________________=20 [08:31:31] / _/ ___/ |/ / _/_ __/ __/=20 [08:31:31] _/ // (7 7 // / / / / _/ =20 [08:31:31] /___/\___/_/|_/___/ /_/ /___/ =20 [08:31:31] =20 [08:31:31] ver. 1.0.4#20150507-sha1:0c13a08b [08:31:31] 2015 Copyright(C) Apache Software Foundation [08:31:31]=20 [08:31:31] Quiet mode. [08:31:31] ^-- Logging to file '/Users/Dmitriy/GridGain/gitroot/incubator= -ignite/work/log/ignite-0b843b9b.log' [08:31:31] ^-- To see **FULL** console log here add -DIGNITE_QUIET=3Dfals= e or "-v" to ignite.{sh|bat} [08:31:31]=20 [08:31:31] Configured plugins: [08:31:31] ^-- None [08:31:31]=20 [08:31:33,018][ERROR][ignite-#8%pub-null%][GridMapQueryExecutor] Failed to = process message: GridQueryRequest [reqId=3D57, pageSize=3D1024, space=3Dwor= ds, qrys=3D[GridCacheSqlQuery [alias=3D__Z0(), qry=3DSELECT _VAL __C0, COUNT(_VAL) __C1 FROM "words".STRING GROUP BY __C0 ORDER BY 2 DESC LIMIT 10, params=3D[]]]] java.lang.NullPointerException =09at org.apache.ignite.internal.processors.query.h2.twostep.GridMapQueryEx= ecutor.onQueryRequest(GridMapQueryExecutor.java:225) =09at org.apache.ignite.internal.processors.query.h2.twostep.GridMapQueryEx= ecutor.onMessage(GridMapQueryExecutor.java:150) =09at org.apache.ignite.internal.processors.query.h2.twostep.GridMapQueryEx= ecutor$2.onMessage(GridMapQueryExecutor.java:125) =09at org.apache.ignite.internal.managers.communication.GridIoManager$Array= Listener.onMessage(GridIoManager.java:1603) =09at org.apache.ignite.internal.managers.communication.GridIoManager.proce= ssRegularMessage0(GridIoManager.java:690) =09at org.apache.ignite.internal.managers.communication.GridIoManager.acces= s$1500(GridIoManager.java:58) =09at org.apache.ignite.internal.managers.communication.GridIoManager$5.run= (GridIoManager.java:653) =09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.= java:1142) =09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor= .java:617) =09at java.lang.Thread.run(Thread.java:745) [08:31:34] Performance suggestions for grid (fix if possible) [08:31:34] To disable, set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=3Dtrue [08:31:34] ^-- Disable peer class loading (set 'peerClassLoadingEnabled' = to false) [08:31:34] ^-- Disable grid events (remove 'includeEventTypes' from confi= guration) [08:31:34]=20 [08:31:34] To start Console Management & Monitoring run ignitevisorcmd.{sh|= bat} [08:31:34]=20 [08:31:34] Ignite node started OK (id=3D0b843b9b) [08:31:34] Topology snapshot [ver=3D7, nodes=3D3, CPUs=3D4, heap=3D9.6GB] ... {code} > NPE in GridMapQueryExecutor under load on changing topology > ----------------------------------------------------------- > > Key: IGNITE-885 > URL: https://issues.apache.org/jira/browse/IGNITE-885 > Project: Ignite > Issue Type: Bug > Components: cache > Reporter: Dmitriy Setrakyan > Assignee: Sergi Vladykin > Priority: Blocker > Fix For: sprint-4 > > > The error is reproduced with "streaming.wordcount" example. > # Start instance of {{ExampleNodeStartup}} > # Start {{StreamWords}} instance > # Start {{QueryWords}} instance > # Watch query results coming > # Start another {{ExampleNodeStartup}} instance. > On the new {{ExampleNodeStartup}} I get the following error: > {code} > [08:31:31] / _/ ___/ |/ / _/_ __/ __/=20 > [08:31:31] _/ // (7 7 // / / / / _/ =20 > [08:31:31] /___/\___/_/|_/___/ /_/ /___/ =20 > [08:31:31] =20 > [08:31:31] ver. 1.0.4#20150507-sha1:0c13a08b > [08:31:31] 2015 Copyright(C) Apache Software Foundation > [08:31:31]=20 > [08:31:31] Quiet mode. > [08:31:31] ^-- Logging to file '/Users/Dmitriy/GridGain/gitroot/incubat= or-ignite/work/log/ignite-0b843b9b.log' > [08:31:31] ^-- To see **FULL** console log here add -DIGNITE_QUIET=3Dfa= lse or "-v" to ignite.{sh|bat} > [08:31:31]=20 > [08:31:31] Configured plugins: > [08:31:31] ^-- None > [08:31:31]=20 > [08:31:33,018][ERROR][ignite-#8%pub-null%][GridMapQueryExecutor] Failed t= o process message: GridQueryRequest [reqId=3D57, pageSize=3D1024, space=3Dw= ords, qrys=3D[GridCacheSqlQuery [alias=3D__Z0(), qry=3DSELECT > _VAL __C0, > COUNT(_VAL) __C1 > FROM "words".STRING > GROUP BY __C0 > ORDER BY 2 DESC LIMIT 10, params=3D[]]]] > java.lang.NullPointerException > =09at org.apache.ignite.internal.processors.query.h2.twostep.GridMapQuery= Executor.onQueryRequest(GridMapQueryExecutor.java:225) > =09at org.apache.ignite.internal.processors.query.h2.twostep.GridMapQuery= Executor.onMessage(GridMapQueryExecutor.java:150) > =09at org.apache.ignite.internal.processors.query.h2.twostep.GridMapQuery= Executor$2.onMessage(GridMapQueryExecutor.java:125) > =09at org.apache.ignite.internal.managers.communication.GridIoManager$Arr= ayListener.onMessage(GridIoManager.java:1603) > =09at org.apache.ignite.internal.managers.communication.GridIoManager.pro= cessRegularMessage0(GridIoManager.java:690) > =09at org.apache.ignite.internal.managers.communication.GridIoManager.acc= ess$1500(GridIoManager.java:58) > =09at org.apache.ignite.internal.managers.communication.GridIoManager$5.r= un(GridIoManager.java:653) > =09at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecuto= r.java:1142) > =09at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecut= or.java:617) > =09at java.lang.Thread.run(Thread.java:745) > [08:31:34] Performance suggestions for grid (fix if possible) > [08:31:34] To disable, set -DIGNITE_PERFORMANCE_SUGGESTIONS_DISABLED=3Dtr= ue > [08:31:34] ^-- Disable peer class loading (set 'peerClassLoadingEnabled= ' to false) > [08:31:34] ^-- Disable grid events (remove 'includeEventTypes' from con= figuration) > [08:31:34]=20 > [08:31:34] To start Console Management & Monitoring run ignitevisorcmd.{s= h|bat} > [08:31:34]=20 > [08:31:34] Ignite node started OK (id=3D0b843b9b) > [08:31:34] Topology snapshot [ver=3D7, nodes=3D3, CPUs=3D4, heap=3D9.6GB] > ... > {code} -- This message was sent by Atlassian JIRA (v6.3.4#6332)