kaisun2000 commented on issue #1300:
URL: https://github.com/apache/helix/issues/1300#issuecomment-698083688


   >2020-09-23T05:08:49.1861208Z START TestHelixAdminCli at Wed Sep 23 05:08:49 
UTC 2020
   2020-09-23T05:08:49.3335448Z 1197589 
[ZkClient-EventThread-25630-localhost:2183] ERROR 
org.apache.helix.zookeeper.zkclient.callback.ZkAsyncCallbacks  - Interrupted 
waiting for success
   2020-09-23T05:08:49.3337814Z java.lang.InterruptedException
   2020-09-23T05:08:49.3338699Z         at java.lang.Object.wait(Native Method)
   2020-09-23T05:08:49.3339546Z         at 
java.lang.Object.wait(Object.java:502)
   2020-09-23T05:08:49.3341383Z         at 
org.apache.helix.zookeeper.zkclient.callback.ZkAsyncCallbacks$DefaultCallback.waitForSuccess(ZkAsyncCallbacks.java:220)
   2020-09-23T05:08:49.3343677Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient.issueSync(ZkClient.java:1305)
   2020-09-23T05:08:49.3345356Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient.access$300(ZkClient.java:83)
   2020-09-23T05:08:49.3346813Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient$4.run(ZkClient.java:1331)
   2020-09-23T05:08:49.3348377Z         at 
org.apache.helix.zookeeper.zkclient.ZkEventThread.run(ZkEventThread.java:99)
   2020-09-23T05:08:53.3085745Z 1201556 
[HelixController-pipeline-default-TestHelixAdminCli-(51359ebb_DEFAULT)] ERROR 
org.apache.helix.zookeeper.zkclient.callback.ZkAsyncCallbacks  - Interrupted 
waiting for success
   2020-09-23T05:08:53.3088355Z java.lang.InterruptedException
   2020-09-23T05:08:53.3088980Z         at java.lang.Object.wait(Native Method)
   2020-09-23T05:08:53.3089527Z         at 
java.lang.Object.wait(Object.java:502)
   2020-09-23T05:08:53.3091244Z         at 
org.apache.helix.zookeeper.zkclient.callback.ZkAsyncCallbacks$DefaultCallback.waitForSuccess(ZkAsyncCallbacks.java:220)
   2020-09-23T05:08:53.3093597Z         at 
org.apache.helix.manager.zk.ZkBaseDataAccessor.create(ZkBaseDataAccessor.java:761)
   2020-09-23T05:08:53.3095719Z         at 
org.apache.helix.manager.zk.ZkBaseDataAccessor.createChildren(ZkBaseDataAccessor.java:831)
   2020-09-23T05:08:53.3098099Z         at 
org.apache.helix.manager.zk.ZKHelixDataAccessor.createChildren(ZKHelixDataAccessor.java:515)
   2020-09-23T05:08:53.3100729Z         at 
org.apache.helix.controller.stages.MessageDispatchStage.sendMessages(MessageDispatchStage.java:171)
   2020-09-23T05:08:53.3103834Z         at 
org.apache.helix.controller.stages.MessageDispatchStage.processEvent(MessageDispatchStage.java:81)
   2020-09-23T05:08:53.3107326Z         at 
org.apache.helix.controller.stages.resource.ResourceMessageDispatchStage.process(ResourceMessageDispatchStage.java:33)
   2020-09-23T05:08:53.3110066Z         at 
org.apache.helix.controller.pipeline.Pipeline.handle(Pipeline.java:68)
   2020-09-23T05:08:53.3112170Z         at 
org.apache.helix.controller.GenericHelixController.handleEvent(GenericHelixController.java:777)
   2020-09-23T05:08:53.3114571Z         at 
org.apache.helix.controller.GenericHelixController.access$500(GenericHelixController.java:128)
   2020-09-23T05:08:53.3116852Z         at 
org.apache.helix.controller.GenericHelixController$ClusterEventProcessor.run(GenericHelixController.java:1407)
   2020-09-23T05:08:54.8285053Z testDeactivateCluster deavtive cluster 
TestHelixAdminCli
   2020-09-23T05:08:54.9471743Z 1203203 
[HelixController-pipeline-default-TestHelixAdminCli-(4ebbd400_DEFAULT)] ERROR 
org.apache.helix.controller.GenericHelixController  - Cluster manager: 
controller_9000 is not leader for TestHelixAdminCli. Pipeline will not be 
invoked
   2020-09-23T05:08:54.9490029Z 1203203 
[HelixController-pipeline-task-TestHelixAdminCli-(4ebbd400_TASK)] ERROR 
org.apache.helix.controller.GenericHelixController  - Cluster manager: 
controller_9000 is not leader for TestHelixAdminCli. Pipeline will not be 
invoked
   2020-09-23T05:08:54.9860669Z validated leader path not existing 
TestHelixAdminCli
   2020-09-23T05:08:55.1822844Z 1203434 
[HelixController-pipeline-default-TestHelixAdminCli_grand-(012e378a_DEFAULT)] 
ERROR org.apache.helix.controller.rebalancer.waged.WagedRebalancer  - Failed to 
calculate the new assignments.
   2020-09-23T05:08:55.1827373Z org.apache.helix.HelixRebalanceException: 
Failed to get the current best possible assignment because of unexpected error. 
Failure Type: INVALID_REBALANCER_STATUS
   2020-09-23T05:08:55.1831747Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.getBestPossibleAssignment(WagedRebalancer.java:664)
   2020-09-23T05:08:55.1836423Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.partialRebalance(WagedRebalancer.java:516)
   2020-09-23T05:08:55.1840246Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.computeBestPossibleAssignment(WagedRebalancer.java:357)
   2020-09-23T05:08:55.1844462Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.computeBestPossibleStates(WagedRebalancer.java:327)
   2020-09-23T05:08:55.1848257Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.computeNewIdealStates(WagedRebalancer.java:262)
   2020-09-23T05:08:55.1853838Z         at 
org.apache.helix.controller.stages.BestPossibleStateCalcStage.computeResourceBestPossibleStateWithWagedRebalancer(BestPossibleStateCalcStage.java:270)
   2020-09-23T05:08:55.1858904Z         at 
org.apache.helix.controller.stages.BestPossibleStateCalcStage.compute(BestPossibleStateCalcStage.java:126)
   2020-09-23T05:08:55.1862144Z         at 
org.apache.helix.controller.stages.BestPossibleStateCalcStage.process(BestPossibleStateCalcStage.java:85)
   2020-09-23T05:08:55.1864973Z         at 
org.apache.helix.controller.pipeline.Pipeline.handle(Pipeline.java:68)
   2020-09-23T05:08:55.1867222Z         at 
org.apache.helix.controller.GenericHelixController.handleEvent(GenericHelixController.java:777)
   2020-09-23T05:08:55.1869747Z         at 
org.apache.helix.controller.GenericHelixController.access$500(GenericHelixController.java:128)
   2020-09-23T05:08:55.1872174Z         at 
org.apache.helix.controller.GenericHelixController$ClusterEventProcessor.run(GenericHelixController.java:1407)
   2020-09-23T05:08:55.1876644Z Caused by: 
org.apache.helix.zookeeper.zkclient.exception.ZkInterruptedException: 
java.lang.InterruptedException
   2020-09-23T05:08:55.1879279Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient.retryUntilConnected(ZkClient.java:1689)
   2020-09-23T05:08:55.1924731Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient.readData(ZkClient.java:1826)
   2020-09-23T05:08:55.1926458Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient.readData(ZkClient.java:1818)
   2020-09-23T05:08:55.1928993Z         at 
org.apache.helix.manager.zk.ZkBaseDataAccessor.get(ZkBaseDataAccessor.java:473)
   2020-09-23T05:08:55.1931382Z         at 
org.apache.helix.manager.zk.ZkBucketDataAccessor.compressedBucketRead(ZkBucketDataAccessor.java:260)
   2020-09-23T05:08:55.1934256Z         at 
org.apache.helix.manager.zk.ZkBucketDataAccessor.compressedBucketRead(ZkBucketDataAccessor.java:238)
   2020-09-23T05:08:55.1938125Z         at 
org.apache.helix.controller.rebalancer.waged.AssignmentMetadataStore.getBestPossibleAssignment(AssignmentMetadataStore.java:84)
   2020-09-23T05:08:55.2008862Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.getBestPossibleAssignment(WagedRebalancer.java:661)
   2020-09-23T05:08:55.2010934Z         ... 11 more
   2020-09-23T05:08:55.2011416Z Caused by: java.lang.InterruptedException
   2020-09-23T05:08:55.2012782Z         at java.lang.Object.wait(Native Method)
   2020-09-23T05:08:55.2013697Z         at 
java.lang.Object.wait(Object.java:502)
   2020-09-23T05:08:55.2014758Z         at 
org.apache.zookeeper.ClientCnxn.submitRequest(ClientCnxn.java:1411)
   2020-09-23T05:08:55.2016030Z         at 
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1219)
   2020-09-23T05:08:55.2017136Z         at 
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1250)
   2020-09-23T05:08:55.2018677Z         at 
org.apache.helix.zookeeper.zkclient.ZkConnection.readData(ZkConnection.java:144)
   2020-09-23T05:08:55.2020326Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient$11.call(ZkClient.java:1830)
   2020-09-23T05:08:55.2021654Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient$11.call(ZkClient.java:1826)
   2020-09-23T05:08:55.2023473Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient.retryUntilConnected(ZkClient.java:1673)
   2020-09-23T05:08:55.2024714Z         ... 18 more
   2020-09-23T05:08:55.2033258Z 1203434 
[HelixController-pipeline-default-TestHelixAdminCli_grand-(012e378a_DEFAULT)] 
ERROR org.apache.helix.controller.stages.BestPossibleStateCalcStage  - Event 
012e378a_DEFAULT : Failed to calculate the new Ideal States using the 
rebalancer WagedRebalancer due to INVALID_REBALANCER_STATUS
   2020-09-23T05:08:55.2045999Z org.apache.helix.HelixRebalanceException: 
Failed to get the current best possible assignment because of unexpected error. 
Failure Type: INVALID_REBALANCER_STATUS
   2020-09-23T05:08:55.2055735Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.getBestPossibleAssignment(WagedRebalancer.java:664)
   2020-09-23T05:08:55.2065610Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.partialRebalance(WagedRebalancer.java:516)
   2020-09-23T05:08:55.2076790Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.computeBestPossibleAssignment(WagedRebalancer.java:357)
   2020-09-23T05:08:55.2096796Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.computeBestPossibleStates(WagedRebalancer.java:327)
   2020-09-23T05:08:55.2107688Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.computeNewIdealStates(WagedRebalancer.java:262)
   2020-09-23T05:08:55.2122412Z         at 
org.apache.helix.controller.stages.BestPossibleStateCalcStage.computeResourceBestPossibleStateWithWagedRebalancer(BestPossibleStateCalcStage.java:270)
   2020-09-23T05:08:55.2134962Z         at 
org.apache.helix.controller.stages.BestPossibleStateCalcStage.compute(BestPossibleStateCalcStage.java:126)
   2020-09-23T05:08:55.2145058Z         at 
org.apache.helix.controller.stages.BestPossibleStateCalcStage.process(BestPossibleStateCalcStage.java:85)
   2020-09-23T05:08:55.2155306Z         at 
org.apache.helix.controller.pipeline.Pipeline.handle(Pipeline.java:68)
   2020-09-23T05:08:55.2165092Z         at 
org.apache.helix.controller.GenericHelixController.handleEvent(GenericHelixController.java:777)
   2020-09-23T05:08:55.2174779Z         at 
org.apache.helix.controller.GenericHelixController.access$500(GenericHelixController.java:128)
   2020-09-23T05:08:55.2184115Z         at 
org.apache.helix.controller.GenericHelixController$ClusterEventProcessor.run(GenericHelixController.java:1407)
   2020-09-23T05:08:55.2193459Z Caused by: 
org.apache.helix.zookeeper.zkclient.exception.ZkInterruptedException: 
java.lang.InterruptedException
   2020-09-23T05:08:55.2222030Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient.retryUntilConnected(ZkClient.java:1689)
   2020-09-23T05:08:55.2228830Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient.readData(ZkClient.java:1826)
   2020-09-23T05:08:55.2235286Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient.readData(ZkClient.java:1818)
   2020-09-23T05:08:55.2245941Z         at 
org.apache.helix.manager.zk.ZkBaseDataAccessor.get(ZkBaseDataAccessor.java:473)
   2020-09-23T05:08:56.0029773Z         at 
org.apache.helix.manager.zk.ZkBucketDataAccessor.compressedBucketRead(ZkBucketDataAccessor.java:260)
   2020-09-23T05:08:56.0033520Z         at 
org.apache.helix.manager.zk.ZkBucketDataAccessor.compressedBucketRead(ZkBucketDataAccessor.java:238)
   2020-09-23T05:08:56.0037707Z         at 
org.apache.helix.controller.rebalancer.waged.AssignmentMetadataStore.getBestPossibleAssignment(AssignmentMetadataStore.java:84)
   2020-09-23T05:08:56.0042324Z         at 
org.apache.helix.controller.rebalancer.waged.WagedRebalancer.getBestPossibleAssignment(WagedRebalancer.java:661)
   2020-09-23T05:08:56.0050241Z         ... 11 more
   2020-09-23T05:08:56.0050749Z Caused by: java.lang.InterruptedException
   2020-09-23T05:08:56.0051390Z         at java.lang.Object.wait(Native Method)
   2020-09-23T05:08:56.0051951Z         at 
java.lang.Object.wait(Object.java:502)
   2020-09-23T05:08:56.0052949Z         at 
org.apache.zookeeper.ClientCnxn.submitRequest(ClientCnxn.java:1411)
   2020-09-23T05:08:56.0055097Z         at 
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1219)
   2020-09-23T05:08:56.0056257Z         at 
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1250)
   2020-09-23T05:08:56.0057802Z         at 
org.apache.helix.zookeeper.zkclient.ZkConnection.readData(ZkConnection.java:144)
   2020-09-23T05:08:56.0059455Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient$11.call(ZkClient.java:1830)
   2020-09-23T05:08:56.0060788Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient$11.call(ZkClient.java:1826)
   2020-09-23T05:08:56.0062608Z         at 
org.apache.helix.zookeeper.zkclient.ZkClient.retryUntilConnected(ZkClient.java:1673)
   2020-09-23T05:08:56.0063839Z         ... 18 more
   2020-09-23T05:08:56.0079934Z 1203444 
[HelixController-pipeline-default-TestHelixAdminCli_grand-(012e378a_DEFAULT)] 
ERROR org.apache.helix.controller.GenericHelixController  - Exception while 
executing DEFAULT pipeline: TestHelixAdminCli_grand for cluster 
[org.apache.helix.zookeeper.zkclient.ZkClient.acquireEventLock(ZkClient.java:1629),
 
org.apache.helix.zookeeper.zkclient.ZkClient.waitForKeeperState(ZkClient.java:1607),
 
org.apache.helix.zookeeper.zkclient.ZkClient.waitUntilConnected(ZkClient.java:1598),
 
org.apache.helix.manager.zk.ZKHelixManager.checkConnected(ZKHelixManager.java:396),
 
org.apache.helix.manager.zk.ZKHelixManager.getHelixDataAccessor(ZKHelixManager.java:658),
 
org.apache.helix.controller.stages.MessageDispatchStage.processEvent(MessageDispatchStage.java:64),
 
org.apache.helix.controller.stages.resource.ResourceMessageDispatchStage.process(ResourceMessageDispatchStage.java:33),
 org.apache.helix.controller.pipeline.Pipeline.handle(Pipeline.java:68), 
org.apache.helix.con
 troller.GenericHelixController.handleEvent(GenericHelixController.java:777), 
org.apache.helix.controller.GenericHelixController.access$500(GenericHelixController.java:128),
 
org.apache.helix.controller.GenericHelixController$ClusterEventProcessor.run(GenericHelixController.java:1407)].
 Will not continue to next pipeline
   2020-09-23T05:08:56.0096249Z 1203488 
[HelixController-pipeline-task-TestHelixAdminCli_grand-(b2c13aed_TASK)] ERROR 
org.apache.helix.controller.GenericHelixController  - Cluster manager: 
controller_9001 is not leader for TestHelixAdminCli_grand. Pipeline will not be 
invoked
   2020-09-23T05:08:56.0098411Z END TestHelixAdminCli testDeactivateCluster at 
Wed Sep 23 05:08:55 UTC 2020, took: 6073ms.
   


----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.

For queries about this service, please contact Infrastructure at:
[email protected]



---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to