By type
cds-cluster:dev-cds-blueprints-processor-568978cc79-xfld6 APP Config HOME : /opt/app/onap/config Warning: use -cacerts option to access cacerts keystore Certificate was added to keystore 08:07:48,162 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 08:07:48,163 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy] 08:07:48,164 |-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] 08:07:48,165 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs multiple times on the classpath. 08:07:48,165 |-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] 08:07:48,165 |-WARN in ch.qos.logback.classic.LoggerContext[default] - Resource [logback.xml] occurs at [file:/opt/app/onap/config/logback.xml] 08:07:48,190 |-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 08:07:48,339 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set 08:07:48,353 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 08:07:48,361 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT] 08:07:48,371 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 08:07:48,454 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.springframework] to INFO 08:07:48,454 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.springframework.web] to INFO 08:07:48,454 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.hibernate] to ERROR 08:07:48,454 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [com.hazelcast] to ERROR 08:07:48,454 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.onap.ccsdk.cds] to INFO 08:07:48,454 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO 08:07:48,454 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT] 08:07:48,455 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration. 08:07:48,457 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@2925bf5b - Registering current configuration as safe fallback point . ____ _ __ _ _ /\\ / ___'_ __ _ _(_)_ __ __ _ \ \ \ \ ( ( )\___ | '_ | '_| | '_ \/ _` | \ \ \ \ \\/ ___)| |_)| | | | | || (_| | ) ) ) ) ' |____| .__|_| |_|_| |_\__, | / / / / =========|_|==============|___/=/_/_/_/ :: Spring Boot :: (v2.3.8.RELEASE) 2021-04-07 08:07:49,188|||main||||INFO||||||| Starting BlueprintProcessorApplicationKt v1.1.2 on dev-cds-blueprints-processor-568978cc79-xfld6 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-07 08:07:49,191|||main||||INFO||||||| No active profile set, falling back to default profiles: default 2021-04-07 08:07:51,955|||main||||INFO||||||| Bootstrapping Spring Data JPA repositories in DEFAULT mode. 2021-04-07 08:07:52,533|||main||||INFO||||||| Finished Spring Data repository scanning in 567ms. Found 10 JPA repository interfaces. 2021-04-07 08:07:54,602|||main||||INFO||||||| HHH000204: Processing PersistenceUnitInfo [name: default] 2021-04-07 08:07:54,664|||main||||INFO||||||| HHH000412: Hibernate ORM core version 5.4.27.Final 2021-04-07 08:07:54,943|||main||||INFO||||||| HCANN000001: Hibernate Commons Annotations {5.1.2.Final} 2021-04-07 08:07:55,246|||main||||INFO||||||| HHH000400: Using dialect: org.hibernate.dialect.MySQL5InnoDBDialect 2021-04-07 08:07:55,558|||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-07 08:07:55,562|||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-07 08:07:55,735|||main||||INFO||||||| HV000001: Hibernate Validator 6.1.7.Final 2021-04-07 08:07:56,919|||main||||INFO||||||| HHH000490: Using JtaPlatform implementation: [org.hibernate.engine.transaction.jta.platform.internal.NoJtaPlatform] 2021-04-07 08:07:56,931|||main||||INFO||||||| Initialized JPA EntityManagerFactory for persistence unit 'default' 2021-04-07 08:07:57,029|||main||||INFO||||||| Application ID: cds > Initializing error catalog message from properties... 2021-04-07 08:07:58,171|||main||||INFO||||||| Audit service is disabled 2021-04-07 08:07:58,352|||main||||INFO||||||| Dependency Management module created... 2021-04-07 08:07:58,885|||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-07 08:08:00,685|||main||||INFO||||||| Exposing 14 endpoint(s) beneath base path '/actuator' 2021-04-07 08:08:01,014|||main||||INFO||||||| Initialised Primary Transaction Manager for url jdbc:mysql://cds-db:3306/sdnctl 2021-04-07 08:08:02,233|||main||||INFO||||||| Netty started on port(s): 8080 2021-04-07 08:08:03,452|||main||||INFO||||||| Starting Blueprint Processor GRPC Starting.. 2021-04-07 08:08:03,822|||main||||INFO||||||| Blueprint Processor GRPC server started and ready to serve on port(9111)... 2021-04-07 08:08:03,833|||main||||INFO||||||| Started BlueprintProcessorApplicationKt in 15.239 seconds (JVM running for 16.16) 2021-04-07 08:08:03,896|||DefaultDispatcher-worker-1||||INFO||||||| ****** Cluster configuration file(/opt/app/onap/config/hazelcast.yaml) **** Apr 07, 2021 8:08:03 AM com.hazelcast.config.FileSystemYamlConfig INFO: Configuring Hazelcast from '/opt/app/onap/config/hazelcast.yaml'. Apr 07, 2021 8:08:04 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-07 08:08:04,079|||DefaultDispatcher-worker-1||||INFO||||||| [LOCAL] [cds-cluster] [4.0] Prefer IPv4 stack is true, prefer IPv6 addresses is false 2021-04-07 08:08:04,090|||DefaultDispatcher-worker-1||||INFO||||||| [LOCAL] [cds-cluster] [4.0] Picked [10.242.144.5]:5701, using socket ServerSocket[addr=/0:0:0:0:0:0:0:0,localport=5701], bind any local is true 2021-04-07 08:08:04,113|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Hazelcast 4.0 (20200204 - 8b959f5) starting at [10.242.144.5]:5701 2021-04-07 08:08:04,113|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Copyright (c) 2008-2020, Hazelcast, Inc. All Rights Reserved. 2021-04-07 08:08:04,600|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Backpressure is disabled 2021-04-07 08:08:04,859|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]: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-07 08:08:04,865|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Kubernetes Discovery activated with mode: KUBERNETES_API 2021-04-07 08:08:04,966|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Activating Discovery SPI Joiner 2021-04-07 08:08:04,972|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Subsystem is enabled with 3 members. 2021-04-07 08:08:05,295|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Starting 2 partition threads and 3 generic threads (1 dedicated for priority tasks) 2021-04-07 08:08:05,297|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Diagnostics disabled. To enable add -Dhazelcast.diagnostics.enabled=true to the JVM arguments. 2021-04-07 08:08:05,303|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] [10.242.144.5]: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-07 08:08:05,704|||DefaultDispatcher-worker-1||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Cannot fetch the current zone, ZONE_AWARE feature is disabled 2021-04-07 08:08:05,859|||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-07 08:08:05,879|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Connecting to /10.242.216.74:5701, timeout: 10000, bind-any: true 2021-04-07 08:08:05,881|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Connecting to /10.242.146.145:5701, timeout: 10000, bind-any: true 2021-04-07 08:08:05,883|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Could not connect to: /10.242.216.74:5701. Reason: SocketException[Connection refused to address /10.242.216.74:5701] 2021-04-07 08:08:05,883|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] [10.242.216.74]:5701 is added to the blacklist. 2021-04-07 08:08:05,884|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Could not connect to: /10.242.146.145:5701. Reason: SocketException[Connection refused to address /10.242.146.145:5701] 2021-04-07 08:08:05,885|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] [10.242.146.145]:5701 is added to the blacklist. 2021-04-07 08:08:06,881|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Members {size:1, ver:1} [ Member [10.242.144.5]:5701 - 7462bd45-57eb-4428-94a1-0d6ab1905097 this ] 2021-04-07 08:08:06,902|||DefaultDispatcher-worker-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] [10.242.144.5]:5701 is STARTED 2021-04-07 08:08:07,292|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 1 2021-04-07 08:08:12,295|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 1 2021-04-07 08:08:15,524|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.IO.thread-in-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.144.5:5701 and /10.242.216.74:33895 2021-04-07 08:08:16,786|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.IO.thread-in-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.144.5:5701 and /10.242.146.145:46713 2021-04-07 08:08:17,297|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 1 2021-04-07 08:08:22,300|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Subsystem is waiting for 3 members to join the cluster. Current member count: 1 2021-04-07 08:08:23,546|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.priority-generic-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Members {size:3, ver:3} [ Member [10.242.144.5]:5701 - 7462bd45-57eb-4428-94a1-0d6ab1905097 this Member [10.242.216.74]:5701 - 36a48cd3-02a7-4520-9b09-4d47f69b33f0 Member [10.242.146.145]:5701 - 2cdcc839-ff27-42bd-b904-daca1fcbbca5 ] 2021-04-07 08:08:23,633|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.generic-operation.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Initializing cluster partition table arrangement... 2021-04-07 08:08:24,346|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] RaftNode[CPGroupId{name='METADATA', seed=0, groupId=0}] is created with [RaftEndpoint{uuid='2cdcc839-ff27-42bd-b904-daca1fcbbca5'}, RaftEndpoint{uuid='36a48cd3-02a7-4520-9b09-4d47f69b33f0'}, RaftEndpoint{uuid='7462bd45-57eb-4428-94a1-0d6ab1905097'}] 2021-04-07 08:08:24,351|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Status is set to: ACTIVE 2021-04-07 08:08:26,114|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Granted pre-vote for PreVoteRequest{candidate=RaftEndpoint{uuid='2cdcc839-ff27-42bd-b904-daca1fcbbca5'}, nextTerm=1, lastLogTerm=0, lastLogIndex=0} 2021-04-07 08:08:26,127|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Moving to new term: 1 from current term: 0 after VoteRequest{candidate=RaftEndpoint{uuid='2cdcc839-ff27-42bd-b904-daca1fcbbca5'}, term=1, lastLogTerm=0, lastLogIndex=0, disruptive=false} 2021-04-07 08:08:26,128|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:1, logIndex:0} [ CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701} CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} - FOLLOWER this ] 2021-04-07 08:08:26,128|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Granted vote for VoteRequest{candidate=RaftEndpoint{uuid='2cdcc839-ff27-42bd-b904-daca1fcbbca5'}, term=1, lastLogTerm=0, lastLogIndex=0, disruptive=false} 2021-04-07 08:08:26,146|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Setting leader: RaftEndpoint{uuid='2cdcc839-ff27-42bd-b904-daca1fcbbca5'} 2021-04-07 08:08:26,146|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:1, logIndex:0} [ CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701} - LEADER CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} - FOLLOWER this ] 2021-04-07 08:08:27,002|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Subsystem is initialized with: [CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701}, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701}, CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701}] 2021-04-07 08:08:27,005|||DefaultDispatcher-worker-1||||INFO||||||| Promoted as CP member(Member [10.242.144.5]:5701 - 7462bd45-57eb-4428-94a1-0d6ab1905097 this) 2021-04-07 08:08:27,058|||DefaultDispatcher-worker-1||||INFO||||||| CP Members(3): [CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701}, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701}, CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701}] 2021-04-07 08:08:27,061|||DefaultDispatcher-worker-1||||INFO||||||| CP Group Members(3): [CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701}, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701}, CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701}] 2021-04-07 08:08:27,064|||DefaultDispatcher-worker-1||||INFO||||||| Cluster(cds-cluster) node(dev-cds-blueprints-processor-568978cc79-xfld6) created successfully.... 2021-04-07 08:08:27,067|||DefaultDispatcher-worker-1||||INFO||||||| Registering BlueprintCompilerCacheMessageListener 2021-04-07 08:08:27,067|||DefaultDispatcher-worker-1||||INFO||||||| Cluster(cds-cluster) node(dev-cds-blueprints-processor-568978cc79-xfld6) listening to topic(BLUEPRINT_CLEAN_COMPILER_CACHE)... 2021-04-07 08:13:59,147|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leader RaftEndpoint{uuid='2cdcc839-ff27-42bd-b904-daca1fcbbca5'}'s heartbeats are timed-out. Will start new election round... 2021-04-07 08:13:59,148|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:1, logIndex:0} [ CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701} CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} - FOLLOWER this ] 2021-04-07 08:13:59,155|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Pre-vote started for next term: 2, last log index: 4, last log term: 1 2021-04-07 08:13:59,156|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:1, logIndex:0} [ CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701} CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} - FOLLOWER this ] 2021-04-07 08:13:59,176|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Pre-vote granted from RaftEndpoint{uuid='36a48cd3-02a7-4520-9b09-4d47f69b33f0'} for term: 2, number of votes: 2, majority: 2 2021-04-07 08:13:59,177|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] We have the majority during pre-vote phase. Let's start real election! 2021-04-07 08:13:59,178|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Leader election started for term: 2, last log index: 4, last log term: 1 2021-04-07 08:13:59,178|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:2, logIndex:0} [ CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701} CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} - CANDIDATE this ] 2021-04-07 08:13:59,184|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Vote granted from RaftEndpoint{uuid='36a48cd3-02a7-4520-9b09-4d47f69b33f0'} for term: 2, number of votes: 2, majority: 2 2021-04-07 08:13:59,184|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] We are the LEADER! 2021-04-07 08:13:59,189|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:2, logIndex:0} [ CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701} CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} - LEADER this ] 2021-04-07 08:14:35,292|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Suspecting Member [10.242.146.145]:5701 - 2cdcc839-ff27-42bd-b904-daca1fcbbca5 because it has not sent any heartbeats since 2021-04-07 08:13:31.100. Now: 2021-04-07 08:14:35.288, heartbeat timeout: 60000 ms, suspicion level: 1.00 2021-04-07 08:14:35,292|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Connection[id=2, /10.242.144.5:5701->/10.242.146.145:46713, qualifier=null, endpoint=[10.242.146.145]:5701, alive=false, connectionType=MEMBER] closed. Reason: Suspecting Member [10.242.146.145]:5701 - 2cdcc839-ff27-42bd-b904-daca1fcbbca5 because it has not sent any heartbeats since 2021-04-07 08:13:31.100. Now: 2021-04-07 08:14:35.288, heartbeat timeout: 60000 ms, suspicion level: 1.00 2021-04-07 08:14:35,295|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Removing Member [10.242.146.145]:5701 - 2cdcc839-ff27-42bd-b904-daca1fcbbca5 2021-04-07 08:14:35,299|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Members {size:2, ver:4} [ Member [10.242.144.5]:5701 - 7462bd45-57eb-4428-94a1-0d6ab1905097 this Member [10.242.216.74]:5701 - 36a48cd3-02a7-4520-9b09-4d47f69b33f0 ] 2021-04-07 08:14:35,299|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.event-2||||INFO||||||| MembershipEvent: MembershipEvent {member=Member [10.242.146.145]:5701 - 2cdcc839-ff27-42bd-b904-daca1fcbbca5, type=removed, members=[Member [10.242.144.5]:5701 - 7462bd45-57eb-4428-94a1-0d6ab1905097 this, Member [10.242.216.74]:5701 - 36a48cd3-02a7-4520-9b09-4d47f69b33f0]} 2021-04-07 08:14:35,319|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Committing/rolling-back live transactions of [10.242.146.145]:5701, UUID: 2cdcc839-ff27-42bd-b904-daca1fcbbca5 2021-04-07 08:14:35,323|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701} is not present in the cluster. It will be auto-removed after 120 seconds. 2021-04-07 08:14:35,338|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]: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.146.145]:5701, partitionId: -1, operation: com.hazelcast.cp.internal.operation.GetLeadedGroupsOp, service: hz:core:raft 2021-04-07 08:14:35,607|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.migration||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Repartitioning cluster data. Migration tasks count: 180 2021-04-07 08:14:37,749|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.migration||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] All migration tasks have been completed. (repartitionTime=Wed Apr 07 08:14:35 GMT 2021, plannedMigrations=180, completedMigrations=180, remainingMigrations=0, totalCompletedMigrations=180, elapsedMigrationTime=1118ms, totalElapsedMigrationTime=1118ms) 2021-04-07 08:15:09,897|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=849, invocationTime=1617783309895 (2021-04-07 08:15:09.895), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=100, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:09,899|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=850, invocationTime=1617783309898 (2021-04-07 08:15:09.898), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=100, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:10,415|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=871, invocationTime=1617783310414 (2021-04-07 08:15:10.414), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=110, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:10,416|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=872, invocationTime=1617783310415 (2021-04-07 08:15:10.415), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=110, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:15,428|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=901, invocationTime=1617783315427 (2021-04-07 08:15:15.427), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=120, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:15,428|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=902, invocationTime=1617783315428 (2021-04-07 08:15:15.428), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=120, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:20,433|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=932, invocationTime=1617783320432 (2021-04-07 08:15:20.432), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=130, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:20,434|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=933, invocationTime=1617783320433 (2021-04-07 08:15:20.433), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=130, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:21,569|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=954, invocationTime=1617783321568 (2021-04-07 08:15:21.568), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=140, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:21,570|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=955, invocationTime=1617783321569 (2021-04-07 08:15:21.569), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=140, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:25,964|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=982, invocationTime=1617783325963 (2021-04-07 08:15:25.963), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=150, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:25,965|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=983, invocationTime=1617783325965 (2021-04-07 08:15:25.965), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=150, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]: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.146.145]:5701, partitionId: -1, operation: com.hazelcast.cp.internal.operation.GetLeadedGroupsOp, service: hz:core:raft 2021-04-07 08:15:30,969|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=1017, invocationTime=1617783330968 (2021-04-07 08:15:30.968), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=160, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:30,969|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=1018, invocationTime=1617783330969 (2021-04-07 08:15:30.969), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=160, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:33,003|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=1041, invocationTime=1617783333003 (2021-04-07 08:15:33.003), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=170, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:33,004|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=1042, invocationTime=1617783333004 (2021-04-07 08:15:33.004), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=170, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:36,489|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=1070, invocationTime=1617783336489 (2021-04-07 08:15:36.489), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=180, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:36,495|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=1071, invocationTime=1617783336495 (2021-04-07 08:15:36.495), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=180, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:41,503|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=1100, invocationTime=1617783341502 (2021-04-07 08:15:41.502), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=190, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:41,504|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=1101, invocationTime=1617783341503 (2021-04-07 08:15:41.503), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=190, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:44,513|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=1126, invocationTime=1617783344512 (2021-04-07 08:15:44.512), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=200, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:44,514|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=1127, invocationTime=1617783344513 (2021-04-07 08:15:44.513), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=200, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:47,021|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=1152, invocationTime=1617783347020 (2021-04-07 08:15:47.020), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=210, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:47,022|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=1153, invocationTime=1617783347021 (2021-04-07 08:15:47.021), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=210, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:52,025|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=1183, invocationTime=1617783352024 (2021-04-07 08:15:52.024), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=220, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:52,026|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=1184, invocationTime=1617783352025 (2021-04-07 08:15:52.025), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=220, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:56,030|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=1211, invocationTime=1617783356029 (2021-04-07 08:15:56.029), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=230, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:56,031|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=1212, invocationTime=1617783356030 (2021-04-07 08:15:56.030), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=230, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:57,554|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=872532019, partitionId=-1, replicaIndex=0, callId=1233, invocationTime=1617783357553 (2021-04-07 08:15:57.553), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=240, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275300, firstInvocationTime='2021-04-07 08:14:35.300', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:15:57,555|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Retrying invocation: Invocation{op=com.hazelcast.internal.partition.operation.PartitionStateOperation{serviceName='hz:core:partitionService', identityHash=1984815559, partitionId=-1, replicaIndex=0, callId=1234, invocationTime=1617783357554 (2021-04-07 08:15:57.554), waitTimeout=-1, callTimeout=60000}, tryCount=250, tryPauseMillis=500, invokeCount=240, callTimeoutMillis=60000, firstInvocationTimeMs=1617783275319, firstInvocationTime='2021-04-07 08:14:35.319', lastHeartbeatMillis=0, lastHeartbeatTime='1970-01-01 00:00:00.000', target=[10.242.146.145]:5701, pendingResponse={VOID}, backupsAcksExpected=-1, backupsAcksReceived=0, connection=null}, Reason: com.hazelcast.spi.exception.RetryableIOException: Packet not sent to -> [10.242.146.145]:5701 over null 2021-04-07 08:16:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]: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.146.145]:5701, partitionId: -1, operation: com.hazelcast.cp.internal.operation.GetLeadedGroupsOp, service: hz:core:raft 2021-04-07 08:16:36,291|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Removing CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701} since it is absent for 120 seconds. 2021-04-07 08:16:36,307|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701} will be removed from [CPGroupId{name='METADATA', seed=0, groupId=0}] 2021-04-07 08:16:37,012|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] New members after REMOVE RaftEndpoint{uuid='2cdcc839-ff27-42bd-b904-daca1fcbbca5'} -> [RaftEndpoint{uuid='36a48cd3-02a7-4520-9b09-4d47f69b33f0'}, RaftEndpoint{uuid='7462bd45-57eb-4428-94a1-0d6ab1905097'}] 2021-04-07 08:16:37,012|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Status is set to: UPDATING_GROUP_MEMBER_LIST 2021-04-07 08:16:37,012|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:2, term:2, logIndex:8} [ CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} - LEADER this ] 2021-04-07 08:16:37,017|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Status is set to: ACTIVE 2021-04-07 08:16:37,022|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701} is removed from CP Subsystem. 2021-04-07 08:16:37,022|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Auto-removal of CPMember{uuid=2cdcc839-ff27-42bd-b904-daca1fcbbca5, address=[10.242.146.145]:5701} is successful. 2021-04-07 08:17:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:17:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:17:36,303|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.IO.thread-in-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.144.5:57251 and /10.242.146.145:5701 2021-04-07 08:18:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:18:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:19:27,013|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:19:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:20:27,019|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:20:27,021|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:21:06,294|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.InvocationMonitorThread||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Invocations:2 timeouts:1 backup-timeouts:0 2021-04-07 08:21:27,021|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:21:27,022|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:22:27,022|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:22:27,024|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:23:27,024|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:23:27,026|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:24:27,013|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:24:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:25:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:25:27,019|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:26:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:26:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:27:27,018|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:27:27,019|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:28:27,013|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:28:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:29:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:29:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:30:27,013|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0 leaderships. 2021-04-07 08:30:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:30:39,372|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.IO.thread-in-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Initialized new cluster connection between /10.242.144.5:5701 and /10.242.144.30:36447 2021-04-07 08:30:45,363|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.event-2||||INFO||||||| MembershipEvent: MembershipEvent {member=Member [10.242.144.30]:5701 - 41dff2c4-9a12-4501-ae0f-60bbf2f92a58, type=added, members=[Member [10.242.144.5]:5701 - 7462bd45-57eb-4428-94a1-0d6ab1905097 this, Member [10.242.216.74]:5701 - 36a48cd3-02a7-4520-9b09-4d47f69b33f0, Member [10.242.144.30]:5701 - 41dff2c4-9a12-4501-ae0f-60bbf2f92a58]} 2021-04-07 08:30:45,363|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.priority-generic-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Members {size:3, ver:5} [ Member [10.242.144.5]:5701 - 7462bd45-57eb-4428-94a1-0d6ab1905097 this Member [10.242.216.74]:5701 - 36a48cd3-02a7-4520-9b09-4d47f69b33f0 Member [10.242.144.30]:5701 - 41dff2c4-9a12-4501-ae0f-60bbf2f92a58 ] 2021-04-07 08:30:45,620|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.migration||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Repartitioning cluster data. Migration tasks count: 271 2021-04-07 08:30:47,929|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Added new CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701}. New active CP members list: [CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701}, CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701}, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701}] 2021-04-07 08:30:48,009|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] New members after ADD RaftEndpoint{uuid='6e384ae2-5555-4261-a13f-466266d0e0be'} -> [RaftEndpoint{uuid='36a48cd3-02a7-4520-9b09-4d47f69b33f0'}, RaftEndpoint{uuid='7462bd45-57eb-4428-94a1-0d6ab1905097'}, RaftEndpoint{uuid='6e384ae2-5555-4261-a13f-466266d0e0be'}] 2021-04-07 08:30:48,009|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||WARN||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Status is set to: UPDATING_GROUP_MEMBER_LIST 2021-04-07 08:30:48,009|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CP Group Members {groupId: METADATA(0), size:3, term:2, logIndex:11} [ CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} - LEADER this CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} ] 2021-04-07 08:30:48,010|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Status is set to: ACTIVE 2021-04-07 08:30:48,012|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.partition-operation.thread-0||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Rebalancing is completed. 2021-04-07 08:30:48,198|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.migration||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] All migration tasks have been completed. (repartitionTime=Wed Apr 07 08:30:45 GMT 2021, plannedMigrations=271, completedMigrations=271, remainingMigrations=0, totalCompletedMigrations=451, elapsedMigrationTime=1572ms, totalElapsedMigrationTime=2691ms) 2021-04-07 08:31:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:31:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:32:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:32:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:33:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:33:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:34:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:34:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:35:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:35:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:36:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:36:27,018|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:37:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:37:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:38:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:38:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:39:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-7||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:39:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-7||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:40:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:40:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:41:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:41:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:42:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:42:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:43:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:43:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:44:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:44:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:45:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:45:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:46:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:46:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:47:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:47:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:48:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:48:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:49:27,022|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:49:27,023|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:50:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:50:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:51:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:51:27,017|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:52:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:52:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:53:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:53:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:54:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:54:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:55:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:55:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:56:27,018|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:56:27,020|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:57:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:57:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:58:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:58:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 08:59:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 08:59:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:00:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:00:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:01:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:01:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:02:27,017|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:02:27,019|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:03:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:03:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:04:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:04:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:05:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:05:27,018|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:06:27,020|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:06:27,020|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:07:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:07:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-1||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:08:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:08:27,017|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:09:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:09:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:10:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-7||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:10:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-7||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:11:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:11:27,016|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:12:27,026|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:12:27,027|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:13:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:13:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:14:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:14:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:15:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:15:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-6||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:16:27,018|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:16:27,018|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:17:11,172|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| Enhancing blueprint(/opt/app/onap/blueprints/working/057b20bd-95a5-4ef9-903f-4fc76a9ff488) 2021-04-07 09:17:11,190|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-1||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| deleting definition types under : /opt/app/onap/blueprints/working/057b20bd-95a5-4ef9-903f-4fc76a9ff488/Definitions 2021-04-07 09:17:11,346|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| reinitialized all type definitions 2021-04-07 09:17:11,353|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| ***** Enhancing NodeTemplate(helloworld) 2021-04-07 09:17:11,475|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| enhancing ArtifactDefinition(helloworld-template) 2021-04-07 09:17:11,483|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| enhancing ArtifactDefinition(helloworld-mapping) 2021-04-07 09:17:11,488|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| enhancing resource mapping file(Templates/hello-world-mapping.json) already enhanced(false) 2021-04-07 09:17:11,531|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| ##### Enhancing Workflow(helloworld) 2021-04-07 09:17:11,532|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| workflow(helloworld) dependent component NodeTemplates([helloworld]) 2021-04-07 09:17:11,532|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| identified workflow(helloworld) targets(helloworld) 2021-04-07 09:17:11,532|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| resource assignment artifacts(helloworld-mapping) for NodeType(helloworld) 2021-04-07 09:17:11,532|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| workflow(helloworld) resource assignment files([Templates/hello-world-mapping.json] 2021-04-07 09:17:11,532|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| enriching artifacts file(/opt/app/onap/blueprints/working/057b20bd-95a5-4ef9-903f-4fc76a9ff488/Templates/hello-world-mapping.json 2021-04-07 09:17:11,544|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| enhancing workflow resource mapping file(Templates/hello-world-mapping.json) already enhanced(true) 2021-04-07 09:17:11,545|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| dataType not present for the recipe(dt-helloworld-properties) 2021-04-07 09:17:11,545|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| ##### Enhancing blueprint Resource Definitions 2021-04-07 09:17:11,545|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| resources assignment files ([Templates/hello-world-mapping.json]) 2021-04-07 09:17:11,546|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| processing file (Templates/hello-world-mapping.json) 2021-04-07 09:17:11,572|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| distinct resource keys ([]) 2021-04-07 09:17:11,572|3d09959d-1d94-409d-9dfb-64da2aab4aab||DefaultDispatcher-worker-2||/api/v1/blueprint-model/enrich||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| Enriching Resource Definition sources Node Template: [] 2021-04-07 09:17:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:17:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:17:58,992|c1308032-c5e2-42b4-84cd-bdff32d3748a||reactor-http-epoll-1||/api/v1/blueprint-model/bootstrap||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| Bootstrap request with type load(true), resource dictionary load(true) and cba load(false) 2021-04-07 09:17:58,994|c1308032-c5e2-42b4-84cd-bdff32d3748a||reactor-http-epoll-1||/api/v1/blueprint-model/bootstrap||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| model types load from paths(/opt/app/onap/model-catalog/definition-type/starter-type) 2021-04-07 09:17:58,997|c1308032-c5e2-42b4-84cd-bdff32d3748a||reactor-http-epoll-1||/api/v1/blueprint-model/bootstrap||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| ****** loadModelType(/opt/app/onap/model-catalog/definition-type/starter-type) ******** 2021-04-07 09:17:59,339|c1308032-c5e2-42b4-84cd-bdff32d3748a||DefaultDispatcher-worker-12||/api/v1/blueprint-model/bootstrap||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| resource dictionary load from paths(/opt/app/onap/model-catalog/resource-dictionary/starter-dictionary) 2021-04-07 09:17:59,342|c1308032-c5e2-42b4-84cd-bdff32d3748a||DefaultDispatcher-worker-12||/api/v1/blueprint-model/bootstrap||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| ******* loadResourceDictionary(/opt/app/onap/model-catalog/resource-dictionary/starter-dictionary) ******** 2021-04-07 09:18:00,957|180b44a8-db8a-4d26-a317-e066cce38f62||DefaultDispatcher-worker-2||/api/v1/blueprint-model/publish||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| Save processing(409a4b08-4b73-4801-b465-a30bd3c4bac8) CBA(/opt/app/onap/blueprints/archive/409a4b08-4b73-4801-b465-a30bd3c4bac8/cba.zip) 2021-04-07 09:18:00,967|180b44a8-db8a-4d26-a317-e066cce38f62||DefaultDispatcher-worker-5||/api/v1/blueprint-model/publish||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| Reading blueprint type(DEFAULT) path(/opt/app/onap/blueprints/working/409a4b08-4b73-4801-b465-a30bd3c4bac8) and entry definition file (Definitions/blueprint.json) 2021-04-07 09:18:01,043|180b44a8-db8a-4d26-a317-e066cce38f62||DefaultDispatcher-worker-5||/api/v1/blueprint-model/publish||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| Validating Workflow(helloworld) 2021-04-07 09:18:01,086|180b44a8-db8a-4d26-a317-e066cce38f62||DefaultDispatcher-worker-5||/api/v1/blueprint-model/publish||INFO|||dev-cds-blueprints-processor-568978cc79-xfld6|||| Reading blueprint type(DEFAULT) path(/opt/app/onap/blueprints/working/409a4b08-4b73-4801-b465-a30bd3c4bac8) and entry definition file (Definitions/blueprint.json) 2021-04-07 09:18:01,221|180b44a8-db8a-4d26-a317-e066cce38f62||DefaultDispatcher-worker-5||/api/v1/blueprint-model/publish||WARN|||dev-cds-blueprints-processor-568978cc79-xfld6|||| No compiled cache(/opt/app/onap/blueprints/working/409a4b08-4b73-4801-b465-a30bd3c4bac8) present to clean. 2021-04-07 09:18:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:18:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:19:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:19:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:20:27,018|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:20:27,019|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-3||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:21:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:21:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:22:27,022|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:22:27,023|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-5||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:23:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:23:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-4||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:24:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:24:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-8||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further... 2021-04-07 09:25:27,014|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] Current leadership claims: CPMember{uuid=7462bd45-57eb-4428-94a1-0d6ab1905097, address=[10.242.144.5]:5701} has 0, CPMember{uuid=36a48cd3-02a7-4520-9b09-4d47f69b33f0, address=[10.242.216.74]:5701} has 0, CPMember{uuid=6e384ae2-5555-4261-a13f-466266d0e0be, address=[10.242.144.30]:5701} has 0 leaderships. 2021-04-07 09:25:27,015|||hz.dev-cds-blueprints-processor-568978cc79-xfld6.cached.thread-2||||INFO||||||| [10.242.144.5]:5701 [cds-cluster] [4.0] CPGroup leadership balance is fine, cannot rebalance further...