helix-commits mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "stuart meikle (JIRA)" <j...@apache.org>
Subject [jira] [Created] (HELIX-630) Unable to start simple Participant. Threading issues?
Date Fri, 27 May 2016 07:59:13 GMT
stuart meikle created HELIX-630:
-----------------------------------

             Summary: Unable to start simple Participant. Threading issues?
                 Key: HELIX-630
                 URL: https://issues.apache.org/jira/browse/HELIX-630
             Project: Apache Helix
          Issue Type: Bug
          Components: helix-core
    Affects Versions: 0.7.1, 0.6.5
         Environment: Windows 7 64 bit. Running from Intellij. 
            Reporter: stuart meikle


I have a controller app and a v simple participant app, both derived from the Quickstart.java.
I start the controller app in intellij and then up to 3 participant apps. Sometimes the participant
apps fail to start. I'll attach the logs below. Error appears to occur in manager.connect,
and appears intermittently. I noticed you had an earlier bug back in 2014 with similar symptoms.


--

D:\dev\bin\sun\jdk\1.8.0_25-64bit\bin\java -Didea.launcher.port=7578 -Didea.launcher.bin.path=D:\dev\bin\IntelliJIDEA14.1.5\bin
-Dfile.encoding=windows-1252 -classpath D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\charsets.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\deploy.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\javaws.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\jce.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\jfr.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\jfxswt.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\jsse.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\management-agent.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\plugin.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\resources.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\rt.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\access-bridge-64.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\cldrdata.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\dnsns.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\jaccess.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\jfxrt.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\localedata.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\nashorn.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\sunec.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\sunjce_provider.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\sunmscapi.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\sunpkcs11.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\zipfs.jar;D:\dev\projects\helix-proto\build\classes\main;D:\dev\projects\helix-proto\build\resources\main;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.apache.helix\helix-core\0.7.1\bb2700adf022258e0d92b3facde1117a5f268ef7\helix-core-0.7.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\log4j\log4j\1.2.15\f0a0d2e29ed910808c33135a3a5a51bba6358f7b\log4j-1.2.15.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.apache.zookeeper\zookeeper\3.3.4\6471e17c92181da9e143559c4c4779925a5e6eb0\zookeeper-3.3.4.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.codehaus.jackson\jackson-core-asl\1.8.5\713a5564acb9a5467521bbb53221ab8e1fe65039\jackson-core-asl-1.8.5.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.codehaus.jackson\jackson-mapper-asl\1.8.5\56439095aa051521c5abb330235820c66886b5e5\jackson-mapper-asl-1.8.5.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\commons-io\commons-io\1.4\a8762d07e76cfde2395257a5da47ba7c1dbd3dce\commons-io-1.4.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\commons-cli\commons-cli\1.2\2bf96b7aa8b611c177d329452af1dc933e14501c\commons-cli-1.2.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\com.github.sgroschupf\zkclient\0.1\a6cf8ffca10fdda90fe00b0b23665435bae50183\zkclient-0.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.apache.commons\commons-math\2.1\b3c4bdc2778ddccceb8da2acec3e37bfa41303e9\commons-math-2.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\commons-codec\commons-codec\1.6\b7f0fc8f61ecadeb3695f0b9464755eee44374d4\commons-codec-1.6.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\com.google.guava\guava\15.0\ed727a8d9f247e2050281cb083f1c77b09dcb5cd\guava-15.0.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.yaml\snakeyaml\1.12\ebe66a6b88caab31d7a19571ad23656377523545\snakeyaml-1.12.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\jline\jline\0.9.94\99a18e9a44834afdebc467294e1138364c207402\jline-0.9.94.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\javax.mail\mail\1.4\1aa1579ae5ecd41920c4f355b0a9ef40b68315dd\mail-1.4.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\javax.activation\activation\1.1\e6cb541461c2834bdea3eb920f1884d1eb508b50\activation-1.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\junit\junit\3.8.1\99129f16442844f6a4a11ae22fbbee40b14d774f\junit-3.8.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.apache.helix\helix-examples\0.7.1\e502d53990f7ae6e685ac832f299b106bad8eb34\helix-examples-0.7.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\commons-logging\commons-logging-api\1.1\7d4cf5231d46c8524f9b9ed75bb2d1c69ab93322\commons-logging-api-1.1.jar;D:\dev\bin\IntelliJIDEA14.1.5\lib\idea_rt.jar
com.intellij.rt.execution.application.AppMain petrotechnics.proscient.HelixParticipant 2
0 [main] INFO org.apache.helix.manager.zk.ZKHelixManager  - Create a zk-based cluster manager.
zkSvr: localhost:2199, clusterName: HELIX_QUICKSTART, instanceName: localhost_12002, type:
PARTICIPANT
8 [main] INFO org.apache.helix.HelixManagerProperties  - load helix-manager properties: {minimum_supported_version.batch_message=0.6.1,
clustermanager.version=0.7.1, minimum_supported_version.participant=0.4}
21 [main] DEBUG org.I0Itec.zkclient.ZkConnection  - Creating new ZookKeeper instance to connect
to localhost:2199.
21 [ZkClient-EventThread-14-localhost:2199] INFO org.I0Itec.zkclient.ZkEventThread  - Starting
ZkClient event thread.
39 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:zookeeper.version=3.3.3-1203054,
built on 11/17/2011 05:47 GMT
39 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:host.name=LA02340.petrotechnics.com
39 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:java.version=1.8.0_25
40 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:java.vendor=Oracle Corporation
40 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:java.home=D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre
40 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:java.class.path=D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\charsets.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\deploy.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\javaws.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\jce.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\jfr.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\jfxswt.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\jsse.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\management-agent.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\plugin.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\resources.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\rt.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\access-bridge-64.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\cldrdata.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\dnsns.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\jaccess.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\jfxrt.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\localedata.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\nashorn.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\sunec.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\sunjce_provider.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\sunmscapi.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\sunpkcs11.jar;D:\dev\bin\sun\jdk\1.8.0_25-64bit\jre\lib\ext\zipfs.jar;D:\dev\projects\helix-proto\build\classes\main;D:\dev\projects\helix-proto\build\resources\main;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.apache.helix\helix-core\0.7.1\bb2700adf022258e0d92b3facde1117a5f268ef7\helix-core-0.7.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\log4j\log4j\1.2.15\f0a0d2e29ed910808c33135a3a5a51bba6358f7b\log4j-1.2.15.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.apache.zookeeper\zookeeper\3.3.4\6471e17c92181da9e143559c4c4779925a5e6eb0\zookeeper-3.3.4.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.codehaus.jackson\jackson-core-asl\1.8.5\713a5564acb9a5467521bbb53221ab8e1fe65039\jackson-core-asl-1.8.5.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.codehaus.jackson\jackson-mapper-asl\1.8.5\56439095aa051521c5abb330235820c66886b5e5\jackson-mapper-asl-1.8.5.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\commons-io\commons-io\1.4\a8762d07e76cfde2395257a5da47ba7c1dbd3dce\commons-io-1.4.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\commons-cli\commons-cli\1.2\2bf96b7aa8b611c177d329452af1dc933e14501c\commons-cli-1.2.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\com.github.sgroschupf\zkclient\0.1\a6cf8ffca10fdda90fe00b0b23665435bae50183\zkclient-0.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.apache.commons\commons-math\2.1\b3c4bdc2778ddccceb8da2acec3e37bfa41303e9\commons-math-2.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\commons-codec\commons-codec\1.6\b7f0fc8f61ecadeb3695f0b9464755eee44374d4\commons-codec-1.6.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\com.google.guava\guava\15.0\ed727a8d9f247e2050281cb083f1c77b09dcb5cd\guava-15.0.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.yaml\snakeyaml\1.12\ebe66a6b88caab31d7a19571ad23656377523545\snakeyaml-1.12.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\jline\jline\0.9.94\99a18e9a44834afdebc467294e1138364c207402\jline-0.9.94.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\javax.mail\mail\1.4\1aa1579ae5ecd41920c4f355b0a9ef40b68315dd\mail-1.4.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\javax.activation\activation\1.1\e6cb541461c2834bdea3eb920f1884d1eb508b50\activation-1.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\junit\junit\3.8.1\99129f16442844f6a4a11ae22fbbee40b14d774f\junit-3.8.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\org.apache.helix\helix-examples\0.7.1\e502d53990f7ae6e685ac832f299b106bad8eb34\helix-examples-0.7.1.jar;C:\Users\stuart.meikle\.gradle\caches\modules-2\files-2.1\commons-logging\commons-logging-api\1.1\7d4cf5231d46c8524f9b9ed75bb2d1c69ab93322\commons-logging-api-1.1.jar;D:\dev\bin\IntelliJIDEA14.1.5\lib\idea_rt.jar
44 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:java.library.path=D:\dev\bin\sun\jdk\1.8.0_25-64bit\bin;C:\WINDOWS\Sun\Java\bin;C:\WINDOWS\system32;C:\WINDOWS;d:\dev\bin\python\2.7.8;d:\dev\bin\python\2.7.8\scripts;D:\dev\bin\jython\2.5.4rc1;D:\dev\bin\Sencha\Cmd\5.1.0.26;D:\dev\bin\ruby\bin;D:\dev\bin\oracle\11g_express\app\oracle\product\11.2.0\server\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\WINDOWS\System32\WindowsPowerShell\v1.0\;D:\dev\bin\python\2.7.8;D:\dev\bin\python\2.7.8\Scripts;D:\dev\bin\jython\2.5.4rc1;C:\Program
Files (x86)\GnuWin32\bin;D:\dev\bin\Sencha\Cmd\5.0.0.160;C:\Program Files (x86)\Common Files\ColumbiaSoft
Shared;C:\Program Files (x86)\ATI Technologies\ATI.ACE\Core-Static;C:\Program Files (x86)\Enterprise
Vault\EVClient\;C:\Users\stuart.meikle\AppData\Local\Mozilla Firefox;d:\dev\bin\sun\jdk\1.8.0_71-64bit\bin;\d:\dev\bin\python\2.7.8;d:\dev\bin\python\2.7.8\scripts;D:\dev\bin\jython\2.5.4rc1;C:\Users\stuart.meikle\AppData\Local\Apps\cURL\bin;d:\dev\bin\accurev\6.1\bin;.
44 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:java.io.tmpdir=C:\Users\STUART~1.MEI\AppData\Local\Temp\
44 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:java.compiler=<NA>
44 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:os.name=Windows 7
44 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:os.arch=amd64
44 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:os.version=6.1
44 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:user.name=stuart.meikle
44 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:user.home=C:\Users\stuart.meikle
44 [main] INFO org.apache.zookeeper.ZooKeeper  - Client environment:user.dir=D:\dev\projects\helix-proto
45 [main] INFO org.apache.zookeeper.ZooKeeper  - Initiating client connection, connectString=localhost:2199
sessionTimeout=30000 watcher=org.apache.helix.manager.zk.ZkClient@3d82c5f3
47 [main] DEBUG org.apache.zookeeper.ClientCnxn  - zookeeper.disableAutoWatchReset is false
96 [main] DEBUG org.I0Itec.zkclient.ZkClient  - Awaiting connection to Zookeeper server
96 [main-SendThread()] INFO org.apache.zookeeper.ClientCnxn  - Opening socket connection to
server localhost/127.0.0.1:2199
97 [main] DEBUG org.I0Itec.zkclient.ZkClient  - Waiting for keeper state SyncConnected
98 [main-SendThread(localhost:2199)] INFO org.apache.zookeeper.ClientCnxn  - Socket connection
established to localhost/127.0.0.1:2199, initiating session
99 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Session establishment
request sent on localhost/127.0.0.1:2199
103 [main-SendThread(localhost:2199)] INFO org.apache.zookeeper.ClientCnxn  - Session establishment
complete on server localhost/127.0.0.1:2199, sessionid = 0x154f13129940017, negotiated timeout
= 30000
104 [main-EventThread] DEBUG org.I0Itec.zkclient.ZkClient  - Received event: WatchedEvent
state:SyncConnected type:None path:null
105 [main-EventThread] INFO org.I0Itec.zkclient.ZkClient  - zookeeper state changed (SyncConnected)
105 [main-EventThread] DEBUG org.I0Itec.zkclient.ZkClient  - Leaving process event
105 [main] DEBUG org.I0Itec.zkclient.ZkClient  - State is SyncConnected
108 [main] DEBUG org.I0Itec.zkclient.ZkClient  - Waiting for keeper state SyncConnected
109 [main] DEBUG org.I0Itec.zkclient.ZkClient  - State is SyncConnected
109 [main] INFO org.apache.helix.manager.zk.ZkHelixConnection  - Handling new session, session
id: 154f13129940017, zkconnection: State:CONNECTED Timeout:30000 sessionid:0x154f13129940017
local:/127.0.0.1:59700 remoteserver:localhost/127.0.0.1:2199 lastZxid:0 xid:1 sent:1 recv:1
queuedpkts:0 pendingresp:0 queuedevents:0
174 [main] INFO org.apache.helix.messaging.handling.HelixTaskExecutor  - Registered message
handler factory for type: TASK_REPLY, poolSize: 40, factory: org.apache.helix.messaging.handling.AsyncCallbackService@1b0375b3,
pool: java.util.concurrent.ThreadPoolExecutor@2f7c7260[Running, pool size = 0, active threads
= 0, queued tasks = 0, completed tasks = 0]
177 [main] INFO org.apache.helix.participant.HelixStateMachineEngine  - Registering state
model factory for state-model-definition: MyStateModel using factory-name: DEFAULT with: org.apache.helix.examples.MasterSlaveStateModelFactory@7c30a502
190 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
1,3  replyHeader:: 1,3676,0  request:: '/HELIX_QUICKSTART/IDEALSTATES,F  response:: s{3537,3537,1464335411894,1464335411894,0,1,0,0,0,1,3583}

191 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
2,3  replyHeader:: 2,3676,0  request:: '/HELIX_QUICKSTART/CONFIGS/CLUSTER/HELIX_QUICKSTART,F
 response:: s{3542,3543,1464335411907,1464335412034,1,0,0,0,112,0,3542} 
191 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
3,3  replyHeader:: 3,3676,0  request:: '/HELIX_QUICKSTART/CONFIGS/PARTICIPANT,F  response::
s{3544,3544,1464335412036,1464335412036,0,3,0,0,0,3,3573} 
192 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
4,3  replyHeader:: 4,3676,0  request:: '/HELIX_QUICKSTART/CONFIGS/RESOURCE,F  response:: s{3545,3545,1464335412038,1464335412038,0,0,0,0,0,0,3545}

193 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
5,3  replyHeader:: 5,3676,0  request:: '/HELIX_QUICKSTART/PROPERTYSTORE,F  response:: s{3546,3546,1464335412039,1464335412039,0,0,0,0,0,0,3546}

193 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
6,3  replyHeader:: 6,3676,0  request:: '/HELIX_QUICKSTART/LIVEINSTANCES,F  response:: s{3547,3547,1464335412041,1464335412041,0,4,0,0,0,2,3663}

194 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
7,3  replyHeader:: 7,3676,0  request:: '/HELIX_QUICKSTART/INSTANCES,F  response:: s{3548,3548,1464335412043,1464335412043,0,3,0,0,0,3,3575}

195 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
8,3  replyHeader:: 8,3676,0  request:: '/HELIX_QUICKSTART/EXTERNALVIEW,F  response:: s{3549,3549,1464335412044,1464335412044,0,1,0,0,0,1,3589}

196 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
9,3  replyHeader:: 9,3676,0  request:: '/HELIX_QUICKSTART/CONTROLLER,F  response:: s{3551,3551,1464335412047,1464335412047,0,5,0,0,0,5,3586}

196 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
10,3  replyHeader:: 10,3676,0  request:: '/HELIX_QUICKSTART/STATEMODELDEFS,F  response:: s{3550,3550,1464335412046,1464335412046,0,1,0,0,0,1,3581}

197 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
11,3  replyHeader:: 11,3676,0  request:: '/HELIX_QUICKSTART/CONTROLLER/MESSAGES,F  response::
s{3553,3553,1464335412057,1464335412057,0,0,0,0,0,0,3553} 
197 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
12,3  replyHeader:: 12,3676,0  request:: '/HELIX_QUICKSTART/CONTROLLER/ERRORS,F  response::
s{3555,3555,1464335412061,1464335412061,0,0,0,0,0,0,3555} 
198 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
13,3  replyHeader:: 13,3676,0  request:: '/HELIX_QUICKSTART/CONTROLLER/STATUSUPDATES,F  response::
s{3554,3554,1464335412059,1464335412059,0,0,0,0,0,0,3554} 
198 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
14,3  replyHeader:: 14,3676,0  request:: '/HELIX_QUICKSTART/CONTROLLER/HISTORY,F  response::
s{3552,3587,1464335412055,1464335412283,1,0,0,0,150,0,3552} 
201 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
15,3  replyHeader:: 15,3676,0  request:: '/HELIX_QUICKSTART/IDEALSTATES,F  response:: s{3537,3537,1464335411894,1464335411894,0,1,0,0,0,1,3583}

202 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
16,3  replyHeader:: 16,3676,0  request:: '/HELIX_QUICKSTART/CONFIGS/CLUSTER/HELIX_QUICKSTART,F
 response:: s{3542,3543,1464335411907,1464335412034,1,0,0,0,112,0,3542} 
203 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
17,3  replyHeader:: 17,3676,0  request:: '/HELIX_QUICKSTART/CONFIGS/PARTICIPANT,F  response::
s{3544,3544,1464335412036,1464335412036,0,3,0,0,0,3,3573} 
203 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
18,3  replyHeader:: 18,3676,0  request:: '/HELIX_QUICKSTART/CONFIGS/RESOURCE,F  response::
s{3545,3545,1464335412038,1464335412038,0,0,0,0,0,0,3545} 
204 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
19,3  replyHeader:: 19,3676,0  request:: '/HELIX_QUICKSTART/PROPERTYSTORE,F  response:: s{3546,3546,1464335412039,1464335412039,0,0,0,0,0,0,3546}

204 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
20,3  replyHeader:: 20,3676,0  request:: '/HELIX_QUICKSTART/LIVEINSTANCES,F  response:: s{3547,3547,1464335412041,1464335412041,0,4,0,0,0,2,3663}

205 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
21,3  replyHeader:: 21,3676,0  request:: '/HELIX_QUICKSTART/INSTANCES,F  response:: s{3548,3548,1464335412043,1464335412043,0,3,0,0,0,3,3575}

205 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
22,3  replyHeader:: 22,3676,0  request:: '/HELIX_QUICKSTART/EXTERNALVIEW,F  response:: s{3549,3549,1464335412044,1464335412044,0,1,0,0,0,1,3589}

206 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
23,3  replyHeader:: 23,3676,0  request:: '/HELIX_QUICKSTART/CONTROLLER,F  response:: s{3551,3551,1464335412047,1464335412047,0,5,0,0,0,5,3586}

206 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
24,3  replyHeader:: 24,3676,0  request:: '/HELIX_QUICKSTART/STATEMODELDEFS,F  response:: s{3550,3550,1464335412046,1464335412046,0,1,0,0,0,1,3581}

207 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
25,3  replyHeader:: 25,3676,0  request:: '/HELIX_QUICKSTART/CONTROLLER/MESSAGES,F  response::
s{3553,3553,1464335412057,1464335412057,0,0,0,0,0,0,3553} 
208 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
26,3  replyHeader:: 26,3676,0  request:: '/HELIX_QUICKSTART/CONTROLLER/ERRORS,F  response::
s{3555,3555,1464335412061,1464335412061,0,0,0,0,0,0,3555} 
208 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
27,3  replyHeader:: 27,3676,0  request:: '/HELIX_QUICKSTART/CONTROLLER/STATUSUPDATES,F  response::
s{3554,3554,1464335412059,1464335412059,0,0,0,0,0,0,3554} 
209 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
28,3  replyHeader:: 28,3676,0  request:: '/HELIX_QUICKSTART/CONTROLLER/HISTORY,F  response::
s{3552,3587,1464335412055,1464335412283,1,0,0,0,150,0,3552} 
212 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
29,4  replyHeader:: 29,3676,0  request:: '/HELIX_QUICKSTART/CONFIGS/CLUSTER/HELIX_QUICKSTART,F
 response:: #7bda202022696422203a202248454c49585f515549434b5354415254222cda2020226d61704669656c647322203a207bda20207d2cda2020226c6973744669656c647322203a207bda20207d2cda20202273696d706c654669656c647322203a207bda20207dda7d,s{3542,3543,1464335411907,1464335412034,1,0,0,0,112,0,3542}

394 [main] INFO org.apache.helix.manager.zk.ZkHelixParticipant  - instance: localhost_12002
auto-joining HELIX_QUICKSTART is false
395 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
30,3  replyHeader:: 30,3676,0  request:: '/HELIX_QUICKSTART/CONFIGS/PARTICIPANT/localhost_12002,F
 response:: s{3573,3573,1464335412115,1464335412115,0,0,0,0,203,0,3573} 
396 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
31,3  replyHeader:: 31,3676,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES,F
 response:: s{3576,3576,1464335412128,1464335412128,0,4,0,0,0,0,3632} 
398 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
32,3  replyHeader:: 32,3676,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES,F
 response:: s{3577,3577,1464335412130,1464335412130,0,1,0,0,0,1,3627} 
399 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
33,3  replyHeader:: 33,3676,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/STATUSUPDATES,F
 response:: s{3579,3579,1464335412135,1464335412135,0,0,0,0,0,0,3579} 
400 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
34,3  replyHeader:: 34,3676,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/ERRORS,F
 response:: s{3578,3578,1464335412133,1464335412133,0,0,0,0,0,0,3578} 
431 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
35,1  replyHeader:: 35,3677,0  request:: '/HELIX_QUICKSTART/LIVEINSTANCES/localhost_12002,#7bda202022696422203a20226c6f63616c686f73745f3132303032222cda20202273696d706c654669656c647322203a207bda202020202248454c49585f56455253494f4e22203a2022302e372e31222cda20202020224c4956455f494e5354414e434522203a202238363434404c413032333430222cda202020202253455353494f4e5f494422203a202231353466313331323939343030313722da20207d2cda2020226c6973744669656c647322203a207bda20207d2cda2020226d61704669656c647322203a207bda20207dda7d,v{s{31,s{'world,'anyone}}},1
 response:: '/HELIX_QUICKSTART/LIVEINSTANCES/localhost_12002 
435 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
36,8  replyHeader:: 36,3677,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES,F
 response:: v{'154f13129940005} 
436 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
37,8  replyHeader:: 37,3677,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940005,F
 response:: v{'MyResource} 
444 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940005/MyResource
serverPath:/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940005/MyResource
finished:false header:: 38,4  replyHeader:: 38,3677,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940005/MyResource,F
 response:: #7bda202022696422203a20224d795265736f75726365222cda20202273696d706c654669656c647322203a207bda202020202242415443485f4d4553534147455f4d4f444522203a202266616c7365222cda20202020224255434b45545f53495a4522203a202230222cda202020202253455353494f4e5f494422203a2022313534663133313239393430303035222cda202020202253544154455f4d4f44454c5f44454622203a20224d7953746174654d6f64656c222cda202020202253544154455f4d4f44454c5f464143544f52595f4e414d4522203a202244454641554c5422da20207d2cda2020226c6973744669656c647322203a207bda20207d2cda2020226d61704669656c647322203a207bda20202020224d795265736f757263655f3022203a207bda2020202020202243555252454e545f535441544522203a2022534c415645222cda20202020202022494e464f22203a202222da202020207dda20207dda7d,s{3628,3631,1464335433721,1464335433789,1,0,0,0,377,0,3628}

456 [main] INFO org.apache.helix.manager.zk.ZkHelixParticipant  - Carrying over old session:
154f13129940005, resource: MyResource to current session: 154f13129940017
470 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
39,4  replyHeader:: 39,3677,0  request:: '/HELIX_QUICKSTART/STATEMODELDEFS/MyStateModel,F
 response:: #7bda202022696422203a20224d7953746174654d6f64656c222cda2020226d61704669656c647322203a207bda202020202244524f505045442e6d65746122203a207bda20202020202022636f756e7422203a20222d3122da202020207d2cda202020202244524f505045442e6e65787422203a207bda2020202020202244524f5050454422203a202244524f5050454422da202020207d2cda20202020224d41535445522e6d65746122203a207bda20202020202022636f756e7422203a20223122da202020207d2cda20202020224d41535445522e6e65787422203a207bda202020202020224d415354455222203a20224d4153544552222cda20202020202022534c41564522203a2022534c415645222cda2020202020202244524f5050454422203a2022534c415645222cda202020202020224f46464c494e4522203a2022534c41564522da202020207d2cda20202020224f46464c494e452e6d65746122203a207bda20202020202022636f756e7422203a20222d3122da202020207d2cda20202020224f46464c494e452e6e65787422203a207bda20202020202022534c41564522203a2022534c415645222cda202020202020224d415354455222203a2022534c415645222cda2020202020202244524f5050454422203a202244524f50504544222cda202020202020224f46464c494e4522203a20224f46464c494e4522da202020207d2cda2020202022534c4156452e6d65746122203a207bda20202020202022636f756e7422203a20225222da202020207d2cda2020202022534c4156452e6e65787422203a207bda20202020202022534c41564522203a2022534c415645222cda202020202020224d415354455222203a20224d4153544552222cda2020202020202244524f5050454422203a20224f46464c494e45222cda202020202020224f46464c494e4522203a20224f46464c494e4522da202020207dda20207d2cda2020226c6973744669656c647322203a207bda202020202253544154455f5052494f524954595f4c49535422203a205b20224d4153544552222c2022534c415645222c202244524f50504544222c20224f46464c494e4522205d2cda202020202253544154455f5452414e534954494f4e5f5052494f524954594c49535422203a205b2022534c4156452d4d4153544552222c2022534c4156452d4f46464c494e45222c20224f46464c494e452d534c415645222c20224f46464c494e452d44524f50504544222c20224d41535445522d534c41564522205dda20207d2cda20202273696d706c654669656c647322203a207bda2020202022494e495449414c5f535441544522203a20224f46464c494e4522da20207dda7d,s{3581,3581,1464335412170,1464335412170,0,0,0,0,1040,0,3581}

486 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
40,4  replyHeader:: 40,3677,-101  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940017/MyResource,F
 response::  
508 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
41,1  replyHeader:: 41,3678,-101  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940017/MyResource,#7bda202022696422203a20224d795265736f75726365222cda20202273696d706c654669656c647322203a207bda202020202242415443485f4d4553534147455f4d4f444522203a202266616c7365222cda20202020224255434b45545f53495a4522203a202230222cda202020202253455353494f4e5f494422203a2022313534663133313239393430303137222cda202020202253544154455f4d4f44454c5f44454622203a20224d7953746174654d6f64656c222cda202020202253544154455f4d4f44454c5f464143544f52595f4e414d4522203a202244454641554c5422da20207d2cda2020226c6973744669656c647322203a207bda20207d2cda2020226d61704669656c647322203a207bda20202020224d795265736f757263655f3022203a207bda2020202020202243555252454e545f535441544522203a20224f46464c494e4522da202020207dda20207dda7d,v{s{31,s{'world,'anyone}}},0
 response::  
512 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
42,1  replyHeader:: 42,3679,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940017,,v{s{31,s{'world,'anyone}}},0
 response:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940017 
525 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
43,1  replyHeader:: 43,3680,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940017/MyResource,#7bda202022696422203a20224d795265736f75726365222cda20202273696d706c654669656c647322203a207bda202020202242415443485f4d4553534147455f4d4f444522203a202266616c7365222cda20202020224255434b45545f53495a4522203a202230222cda202020202253455353494f4e5f494422203a2022313534663133313239393430303137222cda202020202253544154455f4d4f44454c5f44454622203a20224d7953746174654d6f64656c222cda202020202253544154455f4d4f44454c5f464143544f52595f4e414d4522203a202244454641554c5422da20207d2cda2020226c6973744669656c647322203a207bda20207d2cda2020226d61704669656c647322203a207bda20202020224d795265736f757263655f3022203a207bda2020202020202243555252454e545f535441544522203a20224f46464c494e4522da202020207dda20207dda7d,v{s{31,s{'world,'anyone}}},0
 response:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940017/MyResource

526 [main] INFO org.apache.helix.manager.zk.ZkHelixParticipant  - Removing current states
from previous sessions. path: /HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940005
535 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
44,2  replyHeader:: 44,3681,-111  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940005,-1
 response:: null
541 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
45,8  replyHeader:: 45,3681,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940005,F
 response:: v{'MyResource} 
543 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
46,8  replyHeader:: 46,3681,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940005/MyResource,F
 response:: v{} 
550 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
47,2  replyHeader:: 47,3682,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940005/MyResource,-1
 response:: null
554 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
48,2  replyHeader:: 48,3683,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940005,-1
 response:: null
559 [main] INFO org.apache.helix.manager.zk.ZkCallbackHandler  - 1 START:INVOKE /HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES
listener:org.apache.helix.messaging.handling.HelixTaskExecutor
559 [main] INFO org.apache.helix.manager.zk.ZkCallbackHandler  - localhost_12002 subscribes
child-change. path: /HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES, listener: org.apache.helix.messaging.handling.HelixTaskExecutor@709ba3fb
564 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
49,3  replyHeader:: 49,3683,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES,T
 response:: s{3576,3576,1464335412128,1464335412128,0,4,0,0,0,0,3632} 
568 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
50,8  replyHeader:: 50,3683,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES,T
 response:: v{} 
574 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
51,8  replyHeader:: 51,3683,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES,T
 response:: v{} 
576 [main] INFO org.apache.helix.messaging.handling.HelixTaskExecutor  - Init HelixTaskExecutor
576 [main] INFO org.apache.helix.monitoring.mbeans.MessageQueueMonitor  - Register MBean:
ClusterStatus: cluster=HELIX_QUICKSTART,messageQueue=localhost_12002
580 [main] INFO org.apache.helix.messaging.handling.HelixTaskExecutor  - Skip init a new thread
pool for type: TASK_REPLY, already existing pool: java.util.concurrent.ThreadPoolExecutor@2f7c7260[Running,
pool size = 0, active threads = 0, queued tasks = 0, completed tasks = 0], isShutdown: false
580 [main] INFO org.apache.helix.messaging.handling.HelixTaskExecutor  - No Messages to process
580 [main] INFO org.apache.helix.manager.zk.ZkCallbackHandler  - 1 END:INVOKE /HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES
listener:org.apache.helix.messaging.handling.HelixTaskExecutor Took: 21ms
580 [main] INFO org.apache.helix.manager.zk.ZkHelixConnection  - role: org.apache.helix.manager.zk.ZkHelixParticipant@49e4cb85
added listener: org.apache.helix.messaging.handling.HelixTaskExecutor@709ba3fb for type: MESSAGES
to path: /HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES
581 [main] INFO org.apache.helix.participant.HelixStateMachineEngine  - Registering state
model factory for state-model-definition: SchedulerTaskQueue using factory-name: DEFAULT with:
org.apache.helix.participant.statemachine.ScheduledTaskStateModelFactory@345965f2
581 [main] INFO org.apache.helix.messaging.DefaultMessagingService  - registering msg factory
for type STATE_TRANSITION
587 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
52,3  replyHeader:: 52,3683,0  request:: '/HELIX_QUICKSTART/IDEALSTATES,F  response:: s{3537,3537,1464335411894,1464335411894,0,1,0,0,0,1,3583}

597 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Got notification
sessionid:0x154f13129940017
598 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Got WatchedEvent
state:SyncConnected type:NodeChildrenChanged path:/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES
for sessionid 0x154f13129940017
599 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
53,3  replyHeader:: 53,3684,0  request:: '/HELIX_QUICKSTART/CONFIGS/CLUSTER/HELIX_QUICKSTART,F
 response:: s{3542,3543,1464335411907,1464335412034,1,0,0,0,112,0,3542} 
599 [main-EventThread] DEBUG org.I0Itec.zkclient.ZkClient  - Received event: WatchedEvent
state:SyncConnected type:NodeChildrenChanged path:/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES
599 [main-EventThread] DEBUG org.I0Itec.zkclient.ZkEventThread  - New event: ZkEvent[Children
of /HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES changed sent to org.apache.helix.manager.zk.ZkCallbackHandler@5618c5db]
599 [main-EventThread] DEBUG org.I0Itec.zkclient.ZkClient  - Leaving process event
599 [ZkClient-EventThread-14-localhost:2199] DEBUG org.I0Itec.zkclient.ZkEventThread  - Delivering
event #1 ZkEvent[Children of /HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES changed
sent to org.apache.helix.manager.zk.ZkCallbackHandler@5618c5db]
601 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
54,3  replyHeader:: 54,3684,0  request:: '/HELIX_QUICKSTART/CONFIGS/PARTICIPANT,F  response::
s{3544,3544,1464335412036,1464335412036,0,3,0,0,0,3,3573} 
601 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
55,3  replyHeader:: 55,3684,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES,T
 response:: s{3576,3576,1464335412128,1464335412128,0,5,0,0,0,1,3684} 
604 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
56,3  replyHeader:: 56,3684,0  request:: '/HELIX_QUICKSTART/CONFIGS/RESOURCE,F  response::
s{3545,3545,1464335412038,1464335412038,0,0,0,0,0,0,3545} 
604 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
57,8  replyHeader:: 57,3684,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES,T
 response:: v{'00e5f8b8-9260-41d6-beb2-9ae366806613} 
604 [ZkClient-EventThread-14-localhost:2199] INFO org.apache.helix.manager.zk.ZkCallbackHandler
 - 14 START:INVOKE /HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES listener:org.apache.helix.messaging.handling.HelixTaskExecutor
604 [ZkClient-EventThread-14-localhost:2199] INFO org.apache.helix.manager.zk.ZkCallbackHandler
 - localhost_12002 subscribes child-change. path: /HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES,
listener: org.apache.helix.messaging.handling.HelixTaskExecutor@709ba3fb
608 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
58,3  replyHeader:: 58,3684,0  request:: '/HELIX_QUICKSTART/PROPERTYSTORE,F  response:: s{3546,3546,1464335412039,1464335412039,0,0,0,0,0,0,3546}

608 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
59,3  replyHeader:: 59,3684,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES,T
 response:: s{3576,3576,1464335412128,1464335412128,0,5,0,0,0,1,3684} 
609 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
60,3  replyHeader:: 60,3684,0  request:: '/HELIX_QUICKSTART/LIVEINSTANCES,F  response:: s{3547,3547,1464335412041,1464335412041,0,5,0,0,0,3,3677}

611 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
61,3  replyHeader:: 61,3684,0  request:: '/HELIX_QUICKSTART/INSTANCES,F  response:: s{3548,3548,1464335412043,1464335412043,0,3,0,0,0,3,3575}

611 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
62,8  replyHeader:: 62,3684,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES,T
 response:: v{'00e5f8b8-9260-41d6-beb2-9ae366806613} 
614 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
63,3  replyHeader:: 63,3685,0  request:: '/HELIX_QUICKSTART/EXTERNALVIEW,F  response:: s{3549,3549,1464335412044,1464335412044,0,1,0,0,0,1,3589}

614 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
64,8  replyHeader:: 64,3685,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES,T
 response:: v{'00e5f8b8-9260-41d6-beb2-9ae366806613} 
616 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
65,3  replyHeader:: 65,3685,0  request:: '/HELIX_QUICKSTART/CONTROLLER,F  response:: s{3551,3551,1464335412047,1464335412047,0,5,0,0,0,5,3586}

617 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES/00e5f8b8-9260-41d6-beb2-9ae366806613
serverPath:/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES/00e5f8b8-9260-41d6-beb2-9ae366806613
finished:false header:: 66,4  replyHeader:: 66,3685,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/MESSAGES/00e5f8b8-9260-41d6-beb2-9ae366806613,F
 response:: #7bda202022696422203a202230306535663862382d393236302d343164362d626562322d396165333636383036363133222cda2020226d61704669656c647322203a207bda20207d2cda2020226c6973744669656c647322203a207bda20207d2cda20202273696d706c654669656c647322203a207bda20202020224352454154455f54494d455354414d5022203a202231343634333335343736363431222cda2020202022436c75737465724576656e744e616d6522203a202263757272656e7453746174654368616e6765222cda202020202246524f4d5f535441544522203a20224f46464c494e45222cda20202020224d53475f494422203a202230306535663862382d393236302d343164362d626562322d396165333636383036363133222cda20202020224d53475f535441544522203a20226e6577222cda20202020224d53475f5459504522203a202253544154455f5452414e534954494f4e222cda2020202022504152544954494f4e5f4e414d4522203a20224d795265736f757263655f30222cda20202020225245534f555243455f4e414d4522203a20224d795265736f75726365222cda20202020225352435f4e414d4522203a20226c6f63616c686f73745f39313030222cda20202020225352435f53455353494f4e5f494422203a2022313534663133313239393430303032222cda202020202253544154455f4d4f44454c5f44454622203a20224d7953746174654d6f64656c222cda202020202253544154455f4d4f44454c5f464143544f52595f4e414d4522203a202244454641554c54222cda20202020225447545f4e414d4522203a20226c6f63616c686f73745f3132303032222cda20202020225447545f53455353494f4e5f494422203a2022313534663133313239393430303137222cda2020202022544f5f535441544522203a2022534c41564522da20207dda7d,s{3684,3684,1464335476644,1464335476644,0,0,0,0,722,0,3684}

625 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
67,3  replyHeader:: 67,3685,0  request:: '/HELIX_QUICKSTART/STATEMODELDEFS,F  response:: s{3550,3550,1464335412046,1464335412046,0,1,0,0,0,1,3581}

626 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
68,3  replyHeader:: 68,3685,0  request:: '/HELIX_QUICKSTART/CONTROLLER/MESSAGES,F  response::
s{3553,3553,1464335412057,1464335412057,0,0,0,0,0,0,3553} 
626 [main-SendThread(localhost:2199)] DEBUG org.apache.zookeeper.ClientCnxn  - Reading reply
sessionid:0x154f13129940017, packet:: clientPath:null serverPath:null finished:false header::
69,8  replyHeader:: 69,3685,0  request:: '/HELIX_QUICKSTART/INSTANCES/localhost_12002/CURRENTSTATES/154f13129940017,F
 response:: v{'MyResource} 
627 [ZkClient-EventThread-14-localhost:2199] ERROR org.apache.helix.messaging.handling.HelixTaskExecutor
 - Failed to create message handler for 00e5f8b8-9260-41d6-beb2-9ae366806613
java.lang.NullPointerException
	at org.apache.helix.messaging.handling.HelixTaskExecutor.createMessageHandler(HelixTaskExecutor.java:661)
	at org.apache.helix.messaging.handling.HelixTaskExecutor.onMessage(HelixTaskExecutor.java:581)
	at org.apache.helix.manager.zk.ZkCallbackHandler.invoke(ZkCallbackHandler.java:202)
	at org.apache.helix.manager.zk.ZkCallbackHandler.handleChildChange(ZkCallbackHandler.java:405)
	at org.I0Itec.zkclient.ZkClient$7.run(ZkClient.java:568)
	at org.I0Itec.zkclient.ZkEventThread.run(ZkEventThread.java:71)



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)

Mime
View raw message