By type
cds-cluster:dev-cds-blueprints-processor-568978cc79-w7qdf APP Config HOME : /opt/app/onap/config Warning: use -cacerts option to access cacerts keystore Certificate was added to keystore 10:59:48,153 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 10:59:48,155 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy] 10:59:48,157 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [jar:file:/opt/app/onap/lib/org.onap.ccsdk.cds.blueprintsprocessor-blueprintsprocessor-application-1.1.2.jar!/logback.xml] 10:59:48,159 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs multiple times on the classpath. 10:59:48,159 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [jar:file:/opt/app/onap/lib/org.onap.ccsdk.cds.blueprintsprocessor-blueprintsprocessor-application-1.1.2.jar!/logback.xml] 10:59:48,159 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [file:/opt/app/onap/config/logback.xml] 10:59:48,191 |-INFO in ch.qos.logback.core.joran.spi.ConfigurationWatchList@45c7e403 - URL [jar:file:/opt/app/onap/lib/org.onap.ccsdk.cds.blueprintsprocessor-blueprintsprocessor-application-1.1.2.jar!/logback.xml] is not of type file 10:59:48,343 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set 10:59:48,356 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 10:59:48,362 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT] 10:59:48,371 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 10:59:48,462 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.springframework] to INFO 10:59:48,462 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.springframework.web] to INFO 10:59:48,462 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.hibernate] to ERROR 10:59:48,463 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.hazelcast] to ERROR 10:59:48,463 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.onap.ccsdk.cds] to INFO 10:59:48,463 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO 10:59:48,463 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT] 10:59:48,464 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration. 10:59:48,466 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2925bf5b - Registering current configuration as safe fallback point . ____ _ __ _ _ /\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \ ( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \ \\/ ___)| |_)| | | | | || (_| | ) ) ) ) ' |____| .__|_| |_|_| |_\__, | / / / / =========|_|==============|___/=/_/_/_/ :: Spring Boot :: (v2.3.8.RELEASE) 2021-04-08 10:59:49,427|||main||||INFO||||||| Starting BlueprintProcessorApplicationKt v1.1.2 on dev-cds-blueprints-processor-568978cc79-w7qdf with PID 1 (/opt/app/onap/lib/org.onap.ccsdk.cds.blueprintsprocessor-blueprintsprocessor-application-1.1.2.jar started by onap in /app) 2021-04-08 10:59:49,431|||main||||INFO||||||| No active profile set, falling back to default profiles: default 2021-04-08 10:59:52,283|||main||||INFO||||||| Bootstrapping Spring Data JPA repositories in DEFAULT mode. 2021-04-08 10:59:52,908|||main||||INFO||||||| Finished Spring Data repository scanning in 615ms. Found 10 JPA repository interfaces. 2021-04-08 10:59:56,223|||main||||INFO||||||| HHH000204: Processing PersistenceUnitInfo [name: default] 2021-04-08 10:59:56,315|||main||||INFO||||||| HHH000412: Hibernate ORM core version 5.4.27.Final 2021-04-08 10:59:56,659|||main||||INFO||||||| HCANN000001: Hibernate Commons Annotations {5.1.2.Final} 2021-04-08 10:59:57,555|||main||||INFO||||||| HHH000400: Using dialect: org.hibernate.dialect.MySQL5InnoDBDialect 2021-04-08 10:59:57,991|||main||||WARN||||||| HHH000481: Encountered Java type [class com.fasterxml.jackson.databind.JsonNode] for which we could not locate a JavaTypeDescriptor and which does not appear to implement equals and/or hashCode. This can lead to significant performance problems when performing equality/dirty checking involving this Java type. Consider registering a custom JavaTypeDescriptor or at least implementing equals/hashCode. 2021-04-08 10:59:58,000|||main||||WARN||||||| HHH000481: Encountered Java type [class org.onap.ccsdk.cds.controllerblueprints.resource.dict.ResourceDefinition] for which we could not locate a JavaTypeDescriptor and which does not appear to implement equals and/or hashCode. This can lead to significant performance problems when performing equality/dirty checking involving this Java type. Consider registering a custom JavaTypeDescriptor or at least implementing equals/hashCode. 2021-04-08 10:59:58,257|||main||||INFO||||||| HV000001: Hibernate Validator 6.1.7.Final 2021-04-08 10:59:59,311|||main||||INFO||||||| HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform] 2021-04-08 10:59:59,323|||main||||INFO||||||| Initialized JPA EntityManagerFactory for persistence unit 'default' 2021-04-08 10:59:59,431|||main||||INFO||||||| Application ID: cds > Initializing error catalog message from properties... 2021-04-08 11:00:01,169|||main||||INFO||||||| Audit service is disabled 2021-04-08 11:00:01,381|||main||||INFO||||||| Dependency Management module created... 2021-04-08 11:00:02,216|||main||||INFO||||||| Registering Dictionary Sources : [processor-db=source-db, input=source-input, default=source-default, sdnc=source-rest, aai-data=source-rest, capability=source-capability, rest=source-rest, vault-data=source-rest, script=source-capability] 2021-04-08 11:00:04,928|||main||||INFO||||||| Exposing 14 endpoint(s) beneath base path '/actuator' 2021-04-08 11:00:05,424|||main||||INFO||||||| Initialised Primary Transaction Manager for url jdbc:mysql://cds-db:3306/sdnctl 2021-04-08 11:00:07,019|||main||||INFO||||||| Netty started on port(s): 8080 2021-04-08 11:00:09,597|||main||||INFO||||||| Starting Blueprint Processor GRPC Starting.. 2021-04-08 11:00:10,014|||main||||INFO||||||| Blueprint Processor GRPC server started and ready to serve on port(9111)... 2021-04-08 11:00:10,021|||main||||INFO||||||| Started BlueprintProcessorApplicationKt in 21.385 seconds (JVM running for 22.516) 2021-04-08 11:00:10,071|||DefaultDispatcher-worker-1||||INFO||||||| ****** Cluster configuration file(/opt/app/onap/config/hazelcast.yaml) **** Apr 08, 2021 11:00:10 AM com.hazelcast.config.FileSystemYamlConfig INFO: Configuring Hazelcast from '/opt/app/onap/config/hazelcast.yaml'. Apr 08, 2021 11:00:10 AM com.hazelcast.instance.impl.HazelcastInstanceFactory WARNING: Hazelcast is starting in a Java modular environment (Java 9 and newer) but without proper access to required Java packages. Use additional Java arguments to provide Hazelcast access to Java internal API. The internal API access is used to get the best performance results. Arguments to be used: --add-modules java.se --add-exports java.base/jdk.internal.ref=ALL-UNNAMED --add-opens java.base/java.lang=ALL-UNNAMED --add-opens java.base/java.nio=ALL-UNNAMED --add-opens java.base/sun.nio.ch=ALL-UNNAMED --add-opens java.management/sun.management=ALL-UNNAMED --add-opens jdk.management/com.sun.management.internal=ALL-UNNAMED 2021-04-08 11:00:10,462|||DefaultDispatcher-worker-1||||INFO||||||| [LOCAL] [cds-cluster] [4.0] Prefer IPv4 stack is true, prefer IPv6 addresses is false 2021-04-08 11:00:10,494|||DefaultDispatcher-worker-1||||INFO||||||| [LOCAL] [cds-cluster] [4.0] Picked [10.242.94.70]:5701, using socket ServerSocket[addr=/0:0:0:0:0:0:0:0,localport=5701], bind any local is true 2021-04-08 11:00:10,598|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Hazelcast 4.0 (20200204 - 8b959f5) starting at [10.242.94.70]:5701 2021-04-08 11:00:10,598|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Copyright (c) 2008-2020, Hazelcast, Inc. All Rights Reserved. 2021-04-08 11:00:11,237|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Backpressure is disabled 2021-04-08 11:00:11,583|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Kubernetes Discovery properties: { service-dns: null, service-dns-timeout: 5, service-name: cds-blueprints-processor-cluster, service-port: 0, service-label: null, service-label-value: true, namespace: onap, pod-label: null, pod-label-value: null, resolve-not-ready-addresses: true, use-node-name-as-external-address: false, kubernetes-api-retries: 3, kubernetes-master: https://kubernetes.default.svc} 2021-04-08 11:00:11,587|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Kubernetes Discovery activated with mode: KUBERNETES_API 2021-04-08 11:00:11,769|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Activating Discovery SPI Joiner 2021-04-08 11:00:11,775|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is enabled with 3 members. 2021-04-08 11:00:12,334|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Starting 2 partition threads and 3 generic threads (1 dedicated for priority tasks) 2021-04-08 11:00:12,339|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Diagnostics disabled. To enable add -Dhazelcast.diagnostics.enabled=true to the JVM arguments. 2021-04-08 11:00:12,350|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] [10.242.94.70]:5701 is STARTING WARNING: An illegal reflective access operation has occurred WARNING: Illegal reflective access by com.hazelcast.internal.networking.nio.SelectorOptimizer (file:/opt/app/onap/lib/com.hazelcast-hazelcast-all-4.0.jar) to field sun.nio.ch.SelectorImpl.selectedKeys WARNING: Please consider reporting this to the maintainers of com.hazelcast.internal.networking.nio.SelectorOptimizer WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations WARNING: All illegal access operations will be denied in a future release 2021-04-08 11:00:13,015|||DefaultDispatcher-worker-1||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Cannot fetch the current zone, ZONE_AWARE feature is disabled 2021-04-08 11:00:13,362|||DefaultDispatcher-worker-1||||WARN||||||| Cannot fetch public IPs of Hazelcast Member PODs, you won't be able to use Hazelcast Smart Client from outside of the Kubernetes network 2021-04-08 11:00:13,394|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-3||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connecting to /10.242.53.5:5701, timeout: 10000, bind-any: true 2021-04-08 11:00:13,394|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connecting to /10.242.29.198:5701, timeout: 10000, bind-any: true 2021-04-08 11:00:13,403|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Could not connect to: /10.242.29.198:5701. Reason: SocketException[Connection refused to address /10.242.29.198:5701] 2021-04-08 11:00:13,403|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] [10.242.29.198]:5701 is added to the blacklist. 2021-04-08 11:00:13,546|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:57571 and /10.242.53.5:5701 2021-04-08 11:00:19,422|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.generic-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Members {size:2, ver:2} [ Member [10.242.53.5]:5701 - e7fbd9f7-e281-4ab7-94e7-de19e3451027 Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this ] 2021-04-08 11:00:20,366|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-3||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:00:20,418|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] [10.242.94.70]:5701 is STARTED 2021-04-08 11:00:25,375|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:00:30,383|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-3||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:00:35,393|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:00:40,397|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:00:45,399|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:00:50,402|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-3||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:00:55,406|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:00,410|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:05,413|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:10,415|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:15,417|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:20,420|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:25,422|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:30,426|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:35,428|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:40,430|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:45,438|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:49,932|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:5701 and /10.242.29.198:45263 2021-04-08 11:01:50,440|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:55,442|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 2 2021-04-08 11:01:55,942|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.priority-generic-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Members {size:3, ver:3} [ Member [10.242.53.5]:5701 - e7fbd9f7-e281-4ab7-94e7-de19e3451027 Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e ] 2021-04-08 11:01:56,471|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] RaftNode[CPGroupId{name='METADATA', seed=0, groupId=0}] is created with [RaftEndpoint{uuid='e367bd26-c935-4927-b9be-edf58db8f335'}, RaftEndpoint{uuid='e7fbd9f7-e281-4ab7-94e7-de19e3451027'}, RaftEndpoint{uuid='f7efea0e-eb17-4439-9d02-fd086abe2a9e'}] 2021-04-08 11:01:56,480|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Status is set to: ACTIVE 2021-04-08 11:01:58,566|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Granted pre-vote for PreVoteRequest{candidate=RaftEndpoint{uuid='e7fbd9f7-e281-4ab7-94e7-de19e3451027'}, nextTerm=1, lastLogTerm=0, lastLogIndex=0} 2021-04-08 11:01:58,572|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Moving to new term: 1 from current term: 0 after VoteRequest{candidate=RaftEndpoint{uuid='e7fbd9f7-e281-4ab7-94e7-de19e3451027'}, term=1, lastLogTerm=0, lastLogIndex=0, disruptive=false} 2021-04-08 11:01:58,572|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:1, logIndex:0} [ CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} - FOLLOWER this CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} ] 2021-04-08 11:01:58,572|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Granted vote for VoteRequest{candidate=RaftEndpoint{uuid='e7fbd9f7-e281-4ab7-94e7-de19e3451027'}, term=1, lastLogTerm=0, lastLogIndex=0, disruptive=false} 2021-04-08 11:01:58,581|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Setting leader: RaftEndpoint{uuid='e7fbd9f7-e281-4ab7-94e7-de19e3451027'} 2021-04-08 11:01:58,581|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:1, logIndex:0} [ CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} - FOLLOWER this CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} - LEADER CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} ] 2021-04-08 11:01:59,061|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Subsystem is initialized with: [CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701}, CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701}, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701}] 2021-04-08 11:01:59,065|||DefaultDispatcher-worker-1||||INFO||||||| Promoted as CP member(Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this) 2021-04-08 11:01:59,077|||DefaultDispatcher-worker-1||||INFO||||||| CP Members(3): [CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701}, CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701}, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701}] 2021-04-08 11:01:59,080|||DefaultDispatcher-worker-1||||INFO||||||| CP Group Members(3): [CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701}, CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701}, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701}] 2021-04-08 11:01:59,082|||DefaultDispatcher-worker-1||||INFO||||||| Cluster(cds-cluster) node(dev-cds-blueprints-processor-568978cc79-w7qdf) created successfully.... 2021-04-08 11:01:59,084|||DefaultDispatcher-worker-1||||INFO||||||| Registering BlueprintCompilerCacheMessageListener 2021-04-08 11:01:59,084|||DefaultDispatcher-worker-1||||INFO||||||| Cluster(cds-cluster) node(dev-cds-blueprints-processor-568978cc79-w7qdf) listening to topic(BLUEPRINT_CLEAN_COMPILER_CACHE)... 2021-04-08 11:15:28,944|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leader RaftEndpoint{uuid='e7fbd9f7-e281-4ab7-94e7-de19e3451027'}'s heartbeats are timed-out. Will start new election round... 2021-04-08 11:15:28,946|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:1, logIndex:0} [ CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} - FOLLOWER this CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} ] 2021-04-08 11:15:28,949|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Pre-vote started for next term: 2, last log index: 4, last log term: 1 2021-04-08 11:15:28,949|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:1, logIndex:0} [ CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} - FOLLOWER this CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} ] 2021-04-08 11:15:28,956|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Pre-vote granted from RaftEndpoint{uuid='f7efea0e-eb17-4439-9d02-fd086abe2a9e'} for term: 2, number of votes: 2, majority: 2 2021-04-08 11:15:28,956|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] We have the majority during pre-vote phase. Let's start real election! 2021-04-08 11:15:28,957|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Leader election started for term: 2, last log index: 4, last log term: 1 2021-04-08 11:15:28,957|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:2, logIndex:0} [ CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} - CANDIDATE this CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} ] 2021-04-08 11:15:28,961|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Vote granted from RaftEndpoint{uuid='f7efea0e-eb17-4439-9d02-fd086abe2a9e'} for term: 2, number of votes: 2, majority: 2 2021-04-08 11:15:28,962|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] We are the LEADER! 2021-04-08 11:15:28,965|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:2, logIndex:0} [ CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} - LEADER this CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} ] 2021-04-08 11:16:12,294|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Suspecting Member [10.242.53.5]:5701 - e7fbd9f7-e281-4ab7-94e7-de19e3451027 because it has not sent any heartbeats since 2021-04-08 11:15:07.305. Now: 2021-04-08 11:16:11.820, heartbeat timeout: 60000 ms, suspicion level: 1.00 2021-04-08 11:16:12,294|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Member [10.242.53.5]:5701 - e7fbd9f7-e281-4ab7-94e7-de19e3451027 is suspected to be dead for reason: Suspecting Member [10.242.53.5]:5701 - e7fbd9f7-e281-4ab7-94e7-de19e3451027 because it has not sent any heartbeats since 2021-04-08 11:15:07.305. Now: 2021-04-08 11:16:11.820, heartbeat timeout: 60000 ms, suspicion level: 1.00 2021-04-08 11:16:12,295|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=1, /10.242.94.70:57571->/10.242.53.5:5701, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Suspecting Member [10.242.53.5]:5701 - e7fbd9f7-e281-4ab7-94e7-de19e3451027 because it has not sent any heartbeats since 2021-04-08 11:15:07.305. Now: 2021-04-08 11:16:11.820, heartbeat timeout: 60000 ms, suspicion level: 1.00 2021-04-08 11:16:12,299|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Starting mastership claim process... 2021-04-08 11:16:12,300|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Local MembersView{version=3, members=[MemberInfo{address=[10.242.53.5]:5701, uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, liteMember=false, memberListJoinVersion=1}, MemberInfo{address=[10.242.94.70]:5701, uuid=e367bd26-c935-4927-b9be-edf58db8f335, liteMember=false, memberListJoinVersion=2}, MemberInfo{address=[10.242.29.198]:5701, uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, liteMember=false, memberListJoinVersion=3}]} with suspected members: [[10.242.53.5]:5701] and initial addresses to ask: [Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e] 2021-04-08 11:16:12,319|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-4||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Members {size:2, ver:4} [ Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e ] 2021-04-08 11:16:12,320|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-4||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Mastership is claimed with: MembersView{version=4, members=[MemberInfo{address=[10.242.94.70]:5701, uuid=e367bd26-c935-4927-b9be-edf58db8f335, liteMember=false, memberListJoinVersion=2}, MemberInfo{address=[10.242.29.198]:5701, uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, liteMember=false, memberListJoinVersion=3}]} 2021-04-08 11:16:12,340|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.event-1||||INFO||||||| MembershipEvent: MembershipEvent {member=Member [10.242.53.5]:5701 - e7fbd9f7-e281-4ab7-94e7-de19e3451027, type=removed, members=[Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this, Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e]} 2021-04-08 11:16:12,341|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Committing/rolling-back live transactions of [10.242.53.5]:5701, UUID: e7fbd9f7-e281-4ab7-94e7-de19e3451027 2021-04-08 11:16:12,343|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Fetching most recent partition table! my version: 814 2021-04-08 11:16:12,345|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} is not present in the cluster. It will be auto-removed after 120 seconds. 2021-04-08 11:16:12,349|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Most recent partition table version: 814 2021-04-08 11:16:12,351|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Cannot execute leadership rebalance at the moment: java.util.concurrent.CompletionException: com.hazelcast.spi.exception.TargetNotMemberException: Not Member! target: [10.242.53.5]:5701, partitionId: -1, operation: com.hazelcast.cp.internal.operation.GetLeadedGroupsOp, service: hz:core:raft 2021-04-08 11:16:12,445|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Repartitioning cluster data. Migration tasks count: 181 2021-04-08 11:16:14,556|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] All migration tasks have been completed. (repartitionTime=Thu Apr 08 11:16:12 GMT 2021, plannedMigrations=181, completedMigrations=181, remainingMigrations=0, totalCompletedMigrations=181, elapsedMigrationTime=1075ms, totalElapsedMigrationTime=1075ms) 2021-04-08 11:16:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Cannot execute leadership rebalance at the moment: java.util.concurrent.CompletionException: com.hazelcast.spi.exception.TargetNotMemberException: Not Member! target: [10.242.53.5]:5701, partitionId: -1, operation: com.hazelcast.cp.internal.operation.GetLeadedGroupsOp, service: hz:core:raft 2021-04-08 11:17:14,530|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:60027 and /10.242.53.5:5701 2021-04-08 11:17:14,709|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:5701 and /10.242.53.5:54939 2021-04-08 11:17:14,808|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.generic-operation.thread-1||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Not updating members because caller: [10.242.53.5]:5701 is not known master: [10.242.94.70]:5701 2021-04-08 11:17:15,000|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.RaftQueryOp, service: hz:core:raft 2021-04-08 11:17:15,002|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.RaftQueryOp, service: hz:core:raft 2021-04-08 11:17:15,033|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=3, /10.242.94.70:60027->/10.242.53.5:5701, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Connection closed by the other side 2021-04-08 11:17:15,220|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:5701 and /10.242.53.5:42325 2021-04-08 11:17:15,294|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.priority-generic-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] This is the master node and received partition table update from [10.242.53.5]:5701. Ignoring incoming state! 2021-04-08 11:17:15,295|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.priority-generic-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] [10.242.53.5]:5701 should merge to us because our data member count is bigger than theirs [2 > 1] 2021-04-08 11:17:15,296|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.priority-generic-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Updating local member list version: 4 to 6 because of split brain merge caller: [10.242.53.5]:5701 with member list version: 5 2021-04-08 11:17:15,297|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.priority-generic-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Members {size:2, ver:6} [ Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e ] 2021-04-08 11:17:16,676|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:17:16,699|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=5, /10.242.94.70:5701->/10.242.53.5:42325, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Connection closed by the other side 2021-04-08 11:17:16,700|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=4, /10.242.94.70:5701->/10.242.53.5:54939, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Connection closed by the other side 2021-04-08 11:17:16,891|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:5701 and /10.242.53.5:57059 2021-04-08 11:17:19,334|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:17:21,797|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:17:22,895|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} is removed from the missing members list as it is in the cluster. 2021-04-08 11:17:22,895|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.event-1||||INFO||||||| MembershipEvent: MembershipEvent {member=Member [10.242.53.5]:5701 - 2bd09d06-1485-4add-8df5-34df9b34aff0, type=added, members=[Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this, Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e, Member [10.242.53.5]:5701 - 2bd09d06-1485-4add-8df5-34df9b34aff0]} 2021-04-08 11:17:22,895|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.priority-generic-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Members {size:3, ver:7} [ Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e Member [10.242.53.5]:5701 - 2bd09d06-1485-4add-8df5-34df9b34aff0 ] 2021-04-08 11:17:23,158|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Repartitioning cluster data. Migration tasks count: 271 2021-04-08 11:17:26,316|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] All migration tasks have been completed. (repartitionTime=Thu Apr 08 11:17:23 GMT 2021, plannedMigrations=271, completedMigrations=271, remainingMigrations=0, totalCompletedMigrations=452, elapsedMigrationTime=2148ms, totalElapsedMigrationTime=3224ms) 2021-04-08 11:17:59,077|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} has 0 leaderships. 2021-04-08 11:17:59,078|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:19:14,324|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Invocations:5 timeouts:1 backup-timeouts:0 2021-04-08 11:19:27,288|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Suspecting Member [10.242.53.5]:5701 - 2bd09d06-1485-4add-8df5-34df9b34aff0 because it has not sent any heartbeats since 2021-04-08 11:18:21.841. Now: 2021-04-08 11:19:26.820, heartbeat timeout: 60000 ms, suspicion level: 1.00 2021-04-08 11:19:27,289|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=6, /10.242.94.70:5701->/10.242.53.5:57059, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Suspecting Member [10.242.53.5]:5701 - 2bd09d06-1485-4add-8df5-34df9b34aff0 because it has not sent any heartbeats since 2021-04-08 11:18:21.841. Now: 2021-04-08 11:19:26.820, heartbeat timeout: 60000 ms, suspicion level: 1.00 2021-04-08 11:19:27,290|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Removing Member [10.242.53.5]:5701 - 2bd09d06-1485-4add-8df5-34df9b34aff0 2021-04-08 11:19:27,292|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Cannot execute leadership rebalance at the moment: java.util.concurrent.CompletionException: com.hazelcast.core.MemberLeftException: Member [10.242.53.5]:5701 - 2bd09d06-1485-4add-8df5-34df9b34aff0 has left cluster! 2021-04-08 11:19:27,293|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Members {size:2, ver:8} [ Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e ] 2021-04-08 11:19:27,294|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.event-1||||INFO||||||| MembershipEvent: MembershipEvent {member=Member [10.242.53.5]:5701 - 2bd09d06-1485-4add-8df5-34df9b34aff0, type=removed, members=[Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this, Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e]} 2021-04-08 11:19:27,293|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Committing/rolling-back live transactions of [10.242.53.5]:5701, UUID: 2bd09d06-1485-4add-8df5-34df9b34aff0 2021-04-08 11:19:27,294|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} is not present in the cluster. It will be auto-removed after 120 seconds. 2021-04-08 11:19:27,299|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connecting to /10.242.53.5:5701, timeout: 10000, bind-any: true 2021-04-08 11:19:27,332|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Repartitioning cluster data. Migration tasks count: 180 2021-04-08 11:19:29,438|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] All migration tasks have been completed. (repartitionTime=Thu Apr 08 11:19:27 GMT 2021, plannedMigrations=180, completedMigrations=180, remainingMigrations=0, totalCompletedMigrations=632, elapsedMigrationTime=1101ms, totalElapsedMigrationTime=4325ms) 2021-04-08 11:19:59,070|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Cannot execute leadership rebalance at the moment: java.util.concurrent.CompletionException: com.hazelcast.spi.exception.TargetNotMemberException: Not Member! target: [10.242.53.5]:5701, partitionId: -1, operation: com.hazelcast.cp.internal.operation.GetLeadedGroupsOp, service: hz:core:raft 2021-04-08 11:20:01,887|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2000489177, partitionId=-1, replicaIndex=0, callId=2647, invocationTime=1617880801419 (2021-04-08 11:20:01.419), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=100, callTimeoutMillis=60000, firstInvocationTimeMs=1617880767300, firstInvocationTime='2021-04-08 11:19:27.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:20:01,890|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=66149356, partitionId=-1, replicaIndex=0, callId=2649, invocationTime=1617880801423 (2021-04-08 11:20:01.423), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=100, callTimeoutMillis=60000, firstInvocationTimeMs=1617880767298, firstInvocationTime='2021-04-08 11:19:27.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:20:01,891|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=928440263, partitionId=-1, replicaIndex=0, callId=2650, invocationTime=1617880801423 (2021-04-08 11:20:01.423), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=100, callTimeoutMillis=60000, firstInvocationTimeMs=1617880767312, firstInvocationTime='2021-04-08 11:19:27.312', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:20:02,404|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2000489177, partitionId=-1, replicaIndex=0, callId=2679, invocationTime=1617880801937 (2021-04-08 11:20:01.937), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=110, callTimeoutMillis=60000, firstInvocationTimeMs=1617880767300, firstInvocationTime='2021-04-08 11:19:27.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:20:02,405|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=66149356, partitionId=-1, replicaIndex=0, callId=2680, invocationTime=1617880801937 (2021-04-08 11:20:01.937), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=110, callTimeoutMillis=60000, firstInvocationTimeMs=1617880767298, firstInvocationTime='2021-04-08 11:19:27.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:20:02,406|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=928440263, partitionId=-1, replicaIndex=0, callId=2681, invocationTime=1617880801938 (2021-04-08 11:20:01.938), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=110, callTimeoutMillis=60000, firstInvocationTimeMs=1617880767312, firstInvocationTime='2021-04-08 11:19:27.312', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:20:07,408|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2000489177, partitionId=-1, replicaIndex=0, callId=2719, invocationTime=1617880806940 (2021-04-08 11:20:06.940), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=120, callTimeoutMillis=60000, firstInvocationTimeMs=1617880767300, firstInvocationTime='2021-04-08 11:19:27.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:20:07,409|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=66149356, partitionId=-1, replicaIndex=0, callId=2720, invocationTime=1617880806941 (2021-04-08 11:20:06.941), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=120, callTimeoutMillis=60000, firstInvocationTimeMs=1617880767298, firstInvocationTime='2021-04-08 11:19:27.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:20:07,410|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=928440263, partitionId=-1, replicaIndex=0, callId=2721, invocationTime=1617880806942 (2021-04-08 11:20:06.942), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=120, callTimeoutMillis=60000, firstInvocationTimeMs=1617880767312, firstInvocationTime='2021-04-08 11:19:27.312', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:20:11,156|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:39947 and /10.242.53.5:5701 2021-04-08 11:20:11,212|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.response-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] No Invocation found for call timeout response with callId=1729 sent from [10.242.53.5]:5701 2021-04-08 11:20:11,212|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.response-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] No Invocation found for normal response with callId=1798 sent from [10.242.53.5]:5701 2021-04-08 11:20:11,212|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.response-1||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] No Invocation found for normal response with callId=1766 sent from [10.242.53.5]:5701 2021-04-08 11:20:11,212|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.response-1||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] No Invocation found for call timeout response with callId=1738 sent from [10.242.53.5]:5701 2021-04-08 11:20:11,222|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:5701 and /10.242.53.5:56505 2021-04-08 11:20:11,237|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:20:11,238|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:20:11,238|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:20:11,238|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:20:11,238|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:20:11,238|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:20:11,270|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=7, /10.242.94.70:39947->/10.242.53.5:5701, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Connection closed by the other side 2021-04-08 11:20:11,281|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:5701 and /10.242.53.5:52675 2021-04-08 11:20:11,282|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:5701 and /10.242.53.5:55083 2021-04-08 11:20:11,595|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=9, /10.242.94.70:5701->/10.242.53.5:52675, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Connection closed by the other side 2021-04-08 11:20:12,735|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:5701 and /10.242.53.5:47229 2021-04-08 11:20:12,763|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.priority-generic-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] [10.242.53.5]:5701 should merge to us because our data member count is bigger than theirs [2 > 1] 2021-04-08 11:20:12,777|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=11, /10.242.94.70:5701->/10.242.53.5:47229, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Connection closed by the other side 2021-04-08 11:20:12,783|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=10, /10.242.94.70:5701->/10.242.53.5:55083, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Connection closed by the other side 2021-04-08 11:20:12,783|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=8, /10.242.94.70:5701->/10.242.53.5:56505, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Connection closed by the other side 2021-04-08 11:20:12,872|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:5701 and /10.242.53.5:56507 2021-04-08 11:20:18,884|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} is removed from the missing members list as it is in the cluster. 2021-04-08 11:20:18,884|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.priority-generic-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Members {size:3, ver:9} [ Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e Member [10.242.53.5]:5701 - 4ee82710-6216-4ca1-bfc1-1ac6cab67785 ] 2021-04-08 11:20:18,884|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.event-1||||INFO||||||| MembershipEvent: MembershipEvent {member=Member [10.242.53.5]:5701 - 4ee82710-6216-4ca1-bfc1-1ac6cab67785, type=added, members=[Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this, Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e, Member [10.242.53.5]:5701 - 4ee82710-6216-4ca1-bfc1-1ac6cab67785]} 2021-04-08 11:20:19,141|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Repartitioning cluster data. Migration tasks count: 271 2021-04-08 11:20:21,989|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] All migration tasks have been completed. (repartitionTime=Thu Apr 08 11:20:19 GMT 2021, plannedMigrations=271, completedMigrations=271, remainingMigrations=0, totalCompletedMigrations=903, elapsedMigrationTime=1844ms, totalElapsedMigrationTime=6170ms) 2021-04-08 11:20:59,247|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} has 0 leaderships. 2021-04-08 11:20:59,248|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:22:02,289|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Suspecting Member [10.242.53.5]:5701 - 4ee82710-6216-4ca1-bfc1-1ac6cab67785 because it has not sent any heartbeats since 2021-04-08 11:20:56.842. Now: 2021-04-08 11:22:01.820, heartbeat timeout: 60000 ms, suspicion level: 1.00 2021-04-08 11:22:02,290|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=12, /10.242.94.70:5701->/10.242.53.5:56507, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Suspecting Member [10.242.53.5]:5701 - 4ee82710-6216-4ca1-bfc1-1ac6cab67785 because it has not sent any heartbeats since 2021-04-08 11:20:56.842. Now: 2021-04-08 11:22:01.820, heartbeat timeout: 60000 ms, suspicion level: 1.00 2021-04-08 11:22:02,291|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Removing Member [10.242.53.5]:5701 - 4ee82710-6216-4ca1-bfc1-1ac6cab67785 2021-04-08 11:22:02,296|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Members {size:2, ver:10} [ Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e ] 2021-04-08 11:22:02,296|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.event-1||||INFO||||||| MembershipEvent: MembershipEvent {member=Member [10.242.53.5]:5701 - 4ee82710-6216-4ca1-bfc1-1ac6cab67785, type=removed, members=[Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this, Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e]} 2021-04-08 11:22:02,300|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-4||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connecting to /10.242.53.5:5701, timeout: 10000, bind-any: true 2021-04-08 11:22:02,313|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Cannot execute leadership rebalance at the moment: java.util.concurrent.CompletionException: com.hazelcast.core.MemberLeftException: Member [10.242.53.5]:5701 - 4ee82710-6216-4ca1-bfc1-1ac6cab67785 has left cluster! 2021-04-08 11:22:02,314|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Committing/rolling-back live transactions of [10.242.53.5]:5701, UUID: 4ee82710-6216-4ca1-bfc1-1ac6cab67785 2021-04-08 11:22:02,314|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} is not present in the cluster. It will be auto-removed after 120 seconds. 2021-04-08 11:22:02,329|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Repartitioning cluster data. Migration tasks count: 180 2021-04-08 11:22:04,262|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] All migration tasks have been completed. (repartitionTime=Thu Apr 08 11:22:02 GMT 2021, plannedMigrations=180, completedMigrations=180, remainingMigrations=0, totalCompletedMigrations=1083, elapsedMigrationTime=930ms, totalElapsedMigrationTime=7100ms) 2021-04-08 11:22:36,878|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=4825, invocationTime=1617880956410 (2021-04-08 11:22:36.410), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=100, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:36,879|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=4826, invocationTime=1617880956412 (2021-04-08 11:22:36.412), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=100, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:36,879|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=4827, invocationTime=1617880956412 (2021-04-08 11:22:36.412), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=100, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:36,880|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=4828, invocationTime=1617880956412 (2021-04-08 11:22:36.412), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=100, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:37,394|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=4867, invocationTime=1617880956926 (2021-04-08 11:22:36.926), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=110, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:37,394|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=4868, invocationTime=1617880956927 (2021-04-08 11:22:36.927), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=110, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:37,395|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=4869, invocationTime=1617880956928 (2021-04-08 11:22:36.928), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=110, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:37,396|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=4870, invocationTime=1617880956928 (2021-04-08 11:22:36.928), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=110, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:42,397|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=4918, invocationTime=1617880961930 (2021-04-08 11:22:41.930), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=120, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:42,398|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=4919, invocationTime=1617880961931 (2021-04-08 11:22:41.931), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=120, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:42,398|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=4920, invocationTime=1617880961931 (2021-04-08 11:22:41.931), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=120, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:42,399|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=4921, invocationTime=1617880961932 (2021-04-08 11:22:41.932), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=120, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:47,403|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=4968, invocationTime=1617880966935 (2021-04-08 11:22:46.935), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=130, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:47,404|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=4969, invocationTime=1617880966937 (2021-04-08 11:22:46.937), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=130, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:47,404|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=4970, invocationTime=1617880966937 (2021-04-08 11:22:46.937), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=130, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:47,405|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=4971, invocationTime=1617880966938 (2021-04-08 11:22:46.938), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=130, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:48,533|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=5010, invocationTime=1617880968066 (2021-04-08 11:22:48.066), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=140, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:48,534|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=5011, invocationTime=1617880968066 (2021-04-08 11:22:48.066), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=140, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:48,534|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=5012, invocationTime=1617880968067 (2021-04-08 11:22:48.067), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=140, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:48,535|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=5013, invocationTime=1617880968067 (2021-04-08 11:22:48.067), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=140, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:52,921|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=5058, invocationTime=1617880972454 (2021-04-08 11:22:52.454), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=150, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:52,929|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=5059, invocationTime=1617880972461 (2021-04-08 11:22:52.461), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=150, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:52,929|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=5060, invocationTime=1617880972462 (2021-04-08 11:22:52.462), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=150, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:52,929|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=5061, invocationTime=1617880972462 (2021-04-08 11:22:52.462), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=150, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:57,932|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=5109, invocationTime=1617880977464 (2021-04-08 11:22:57.464), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=160, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:57,932|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=5110, invocationTime=1617880977465 (2021-04-08 11:22:57.465), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=160, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:57,933|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=5111, invocationTime=1617880977465 (2021-04-08 11:22:57.465), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=160, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:57,933|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=5112, invocationTime=1617880977466 (2021-04-08 11:22:57.466), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=160, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:59,070|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-4||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Cannot execute leadership rebalance at the moment: java.util.concurrent.CompletionException: com.hazelcast.spi.exception.TargetNotMemberException: Not Member! target: [10.242.53.5]:5701, partitionId: -1, operation: com.hazelcast.cp.internal.operation.GetLeadedGroupsOp, service: hz:core:raft 2021-04-08 11:22:59,966|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=5158, invocationTime=1617880979498 (2021-04-08 11:22:59.498), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=170, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:59,967|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=5159, invocationTime=1617880979500 (2021-04-08 11:22:59.500), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=170, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:59,968|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=5160, invocationTime=1617880979500 (2021-04-08 11:22:59.500), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=170, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:22:59,969|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=5161, invocationTime=1617880979502 (2021-04-08 11:22:59.502), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=170, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:03,453|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=5206, invocationTime=1617880982985 (2021-04-08 11:23:02.985), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=180, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:03,453|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=5207, invocationTime=1617880982986 (2021-04-08 11:23:02.986), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=180, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:03,454|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=5208, invocationTime=1617880982986 (2021-04-08 11:23:02.986), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=180, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:03,454|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=5209, invocationTime=1617880982987 (2021-04-08 11:23:02.987), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=180, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:08,456|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=5256, invocationTime=1617880987989 (2021-04-08 11:23:07.989), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=190, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:08,457|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=5257, invocationTime=1617880987990 (2021-04-08 11:23:07.990), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=190, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:08,457|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=5258, invocationTime=1617880987990 (2021-04-08 11:23:07.990), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=190, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:08,457|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=5259, invocationTime=1617880987990 (2021-04-08 11:23:07.990), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=190, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:11,467|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=5302, invocationTime=1617880991000 (2021-04-08 11:23:11.000), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=200, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:11,468|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=5303, invocationTime=1617880991001 (2021-04-08 11:23:11.001), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=200, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:11,468|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=5304, invocationTime=1617880991001 (2021-04-08 11:23:11.001), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=200, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:11,469|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=5305, invocationTime=1617880991001 (2021-04-08 11:23:11.001), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=200, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:13,980|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=5347, invocationTime=1617880993512 (2021-04-08 11:23:13.512), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=210, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:13,981|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=5348, invocationTime=1617880993513 (2021-04-08 11:23:13.513), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=210, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:13,981|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=5349, invocationTime=1617880993514 (2021-04-08 11:23:13.514), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=210, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:13,982|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=5350, invocationTime=1617880993514 (2021-04-08 11:23:13.514), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=210, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:18,983|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=5397, invocationTime=1617880998516 (2021-04-08 11:23:18.516), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=220, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:18,984|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=5398, invocationTime=1617880998517 (2021-04-08 11:23:18.517), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=220, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:18,984|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=5399, invocationTime=1617880998517 (2021-04-08 11:23:18.517), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=220, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:18,985|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=5400, invocationTime=1617880998518 (2021-04-08 11:23:18.518), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=220, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:22,988|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=5445, invocationTime=1617881002520 (2021-04-08 11:23:22.520), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=230, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:22,988|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=5446, invocationTime=1617881002521 (2021-04-08 11:23:22.521), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=230, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:22,989|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=5447, invocationTime=1617881002521 (2021-04-08 11:23:22.521), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=230, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:22,989|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=5448, invocationTime=1617881002522 (2021-04-08 11:23:22.522), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=230, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:24,505|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=2099977367, partitionId=-1, replicaIndex=0, callId=5489, invocationTime=1617881004037 (2021-04-08 11:23:24.037), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=240, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922298, firstInvocationTime='2021-04-08 11:22:02.298', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:24,505|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1658829353, partitionId=-1, replicaIndex=0, callId=5490, invocationTime=1617881004038 (2021-04-08 11:23:24.038), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=240, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922300, firstInvocationTime='2021-04-08 11:22:02.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:24,506|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1803072421, partitionId=-1, replicaIndex=0, callId=5491, invocationTime=1617881004038 (2021-04-08 11:23:24.038), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=240, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922302, firstInvocationTime='2021-04-08 11:22:02.302', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:24,506|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.InvocationMonitorThread||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1792143850, partitionId=-1, replicaIndex=0, callId=5492, invocationTime=1617881004039 (2021-04-08 11:23:24.039), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=240, callTimeoutMillis=60000, firstInvocationTimeMs=1617880922314, firstInvocationTime='2021-04-08 11:22:02.314', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.53.5]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.53.5]:5701 over null 2021-04-08 11:23:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-3||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Cannot execute leadership rebalance at the moment: java.util.concurrent.CompletionException: com.hazelcast.spi.exception.TargetNotMemberException: Not Member! target: [10.242.53.5]:5701, partitionId: -1, operation: com.hazelcast.cp.internal.operation.GetLeadedGroupsOp, service: hz:core:raft 2021-04-08 11:24:03,307|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-3||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Removing CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} since it is absent for 120 seconds. 2021-04-08 11:24:03,345|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} will be removed from [CPGroupId{name='METADATA', seed=0, groupId=0}] 2021-04-08 11:24:04,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] New members after REMOVE RaftEndpoint{uuid='e7fbd9f7-e281-4ab7-94e7-de19e3451027'} -> [RaftEndpoint{uuid='e367bd26-c935-4927-b9be-edf58db8f335'}, RaftEndpoint{uuid='f7efea0e-eb17-4439-9d02-fd086abe2a9e'}] 2021-04-08 11:24:04,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Status is set to: UPDATING_GROUP_MEMBER_LIST 2021-04-08 11:24:04,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:2, term:2, logIndex:8} [ CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} - LEADER this CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} ] 2021-04-08 11:24:04,078|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Status is set to: ACTIVE 2021-04-08 11:24:04,112|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} is removed from CP Subsystem. 2021-04-08 11:24:04,113|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-3||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Auto-removal of CPMember{uuid=e7fbd9f7-e281-4ab7-94e7-de19e3451027, address=[10.242.53.5]:5701} is successful. 2021-04-08 11:24:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-4||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0 leaderships. 2021-04-08 11:24:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-4||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:25:59,070|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0 leaderships. 2021-04-08 11:25:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:26:53,482|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:36393 and /10.242.53.5:5701 2021-04-08 11:26:53,781|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,781|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,782|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,782|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,782|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,782|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,782|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,782|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,782|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,782|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,782|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,782|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.AppendSuccessResponseOp, service: hz:core:raft 2021-04-08 11:26:53,981|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=13, /10.242.94.70:36393->/10.242.53.5:5701, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Connection closed by the other side 2021-04-08 11:26:56,018|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:5701 and /10.242.53.5:39887 2021-04-08 11:26:58,069|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:26:59,070|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0 leaderships. 2021-04-08 11:26:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:27:00,100|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:02,333|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:05,207|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:07,448|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:10,095|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:12,231|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:14,474|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:17,355|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:19,362|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:22,257|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:25,173|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:28,157|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:31,012|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] com.hazelcast.spi.exception.CallerNotMemberException: Not Member! this: [10.242.94.70]:5701, caller: [10.242.53.5]:5701, partitionId: 0, operation: com.hazelcast.cp.internal.operation.integration.PreVoteRequestOp, service: hz:core:raft 2021-04-08 11:27:31,720|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Connection[id=14, /10.242.94.70:5701->/10.242.53.5:39887, qualifier=null, endpoint=[10.242.53.5]:5701, alive=false, connectionType=MEMBER] closed. Reason: Connection closed by the other side 2021-04-08 11:27:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0 leaderships. 2021-04-08 11:27:59,074|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:28:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0 leaderships. 2021-04-08 11:28:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:29:59,070|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0 leaderships. 2021-04-08 11:29:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:30:51,481|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.IO.thread-in-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.94.70:5701 and /10.242.251.142:32785 2021-04-08 11:30:57,388|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.priority-generic-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Members {size:3, ver:11} [ Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e Member [10.242.251.142]:5701 - b20f3f02-a694-4062-ada1-e12abb9adfee ] 2021-04-08 11:30:57,389|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.event-1||||INFO||||||| MembershipEvent: MembershipEvent {member=Member [10.242.251.142]:5701 - b20f3f02-a694-4062-ada1-e12abb9adfee, type=added, members=[Member [10.242.94.70]:5701 - e367bd26-c935-4927-b9be-edf58db8f335 this, Member [10.242.29.198]:5701 - f7efea0e-eb17-4439-9d02-fd086abe2a9e, Member [10.242.251.142]:5701 - b20f3f02-a694-4062-ada1-e12abb9adfee]} 2021-04-08 11:30:57,643|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Repartitioning cluster data. Migration tasks count: 271 2021-04-08 11:30:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0 leaderships. 2021-04-08 11:30:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:30:59,540|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Added new CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701}. New active CP members list: [CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701}, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701}, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701}] 2021-04-08 11:31:00,067|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] New members after ADD RaftEndpoint{uuid='94dbc967-cf2c-4da3-9381-7cf87b86cf13'} -> [RaftEndpoint{uuid='e367bd26-c935-4927-b9be-edf58db8f335'}, RaftEndpoint{uuid='f7efea0e-eb17-4439-9d02-fd086abe2a9e'}, RaftEndpoint{uuid='94dbc967-cf2c-4da3-9381-7cf87b86cf13'}] 2021-04-08 11:31:00,067|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||WARN||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Status is set to: UPDATING_GROUP_MEMBER_LIST 2021-04-08 11:31:00,067|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:2, logIndex:11} [ CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} - LEADER this CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} ] 2021-04-08 11:31:00,070|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Status is set to: ACTIVE 2021-04-08 11:31:00,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.partition-operation.thread-0||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Rebalancing is completed. 2021-04-08 11:31:02,372|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.migration||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] All migration tasks have been completed. (repartitionTime=Thu Apr 08 11:30:57 GMT 2021, plannedMigrations=271, completedMigrations=271, remainingMigrations=0, totalCompletedMigrations=1354, elapsedMigrationTime=3718ms, totalElapsedMigrationTime=10819ms) 2021-04-08 11:31:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-3||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:31:59,074|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-3||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:32:59,075|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:32:59,076|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:33:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:33:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:34:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:34:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:35:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-4||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:35:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-4||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:36:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:36:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:37:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-4||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:37:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-4||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:38:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:38:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:39:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:39:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:40:59,082|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:40:59,084|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:41:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:41:59,074|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:42:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:42:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:43:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:43:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:44:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:44:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:45:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:45:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:46:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:46:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:47:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:47:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:48:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:48:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:49:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:49:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:50:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:50:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:51:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:51:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:52:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-3||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:52:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-3||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:53:59,079|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:53:59,081|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:54:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:54:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:55:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:55:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:56:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:56:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:57:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:57:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:58:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:58:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 11:59:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 11:59:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:00:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:00:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:01:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:01:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:02:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:02:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:03:59,075|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:03:59,077|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:04:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:04:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:05:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:05:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-8||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:06:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:06:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:07:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:07:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-5||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:08:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:08:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:09:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:09:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:10:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:10:59,074|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:11:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:11:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:12:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:12:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-1||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:13:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:13:59,071|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:14:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:14:59,074|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-6||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:15:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:15:59,073|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-2||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-08 12:16:59,072|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=e367bd26-c935-4927-b9be-edf58db8f335, address=[10.242.94.70]:5701} has 0, CPMember{uuid=f7efea0e-eb17-4439-9d02-fd086abe2a9e, address=[10.242.29.198]:5701} has 0, CPMember{uuid=94dbc967-cf2c-4da3-9381-7cf87b86cf13, address=[10.242.251.142]:5701} has 0 leaderships. 2021-04-08 12:16:59,074|||hz.dev-cds-blueprints-processor-568978cc79-w7qdf.cached.thread-7||||INFO||||||| [10.242.94.70]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further...