search

strimzi / strimzi-kafka-operator

Apache Kafka® running on Kubernetes
https://strimzi.io/
Apache License 2.0
4.86k stars 1.3k forks source link

Fix flaky SecurityST.testAutoRenewAllCaCertsTriggeredByAnno system test #3140

Closed scholzj closed 2 years ago

scholzj commented 4 years ago

The system test SecurityST.testAutoRenewAllCaCertsTriggeredByAnno seems to be flaky on Azure. It seems to often fail with the following errors:

2020-06-02T18:57:07.8897121Z 2020-06-02 18:57:07 INFO  [TestSeparator:27] ############################################################################
2020-06-02T18:57:07.8898188Z 2020-06-02 18:57:07 INFO  [TestSeparator:28] io.strimzi.systemtest.security.SecurityST.testAutoRenewAllCaCertsTriggeredByAnno-STARTED
2020-06-02T18:57:07.8899148Z 2020-06-02 18:57:07 INFO  [ResourceManager:100] Setting pointer to method resources
2020-06-02T18:57:07.9028917Z 2020-06-02 18:57:07 INFO  [SecurityST:462] Creating a cluster
2020-06-02T18:57:07.9629827Z 2020-06-02 18:57:07 INFO  [KafkaResource:220] Waiting for Kafka my-cluster in namespace security-cluster-test
2020-06-02T18:57:07.9631074Z 2020-06-02 18:57:07 INFO  [StatefulSetUtils:137] Waiting for StatefulSet my-cluster-zookeeper to be ready
2020-06-02T18:57:12.0965030Z 2020-06-02 18:57:12 INFO  [StatefulSetUtils:142] Waiting for 3 Pod(s) of StatefulSet my-cluster-zookeeper to be ready
2020-06-02T18:57:46.4309417Z 2020-06-02 18:57:46 INFO  [StatefulSetUtils:145] StatefulSet my-cluster-zookeeper is ready
2020-06-02T18:57:46.4311668Z 2020-06-02 18:57:46 INFO  [StatefulSetUtils:137] Waiting for StatefulSet my-cluster-kafka to be ready
2020-06-02T18:57:46.4388847Z 2020-06-02 18:57:46 INFO  [StatefulSetUtils:142] Waiting for 3 Pod(s) of StatefulSet my-cluster-kafka to be ready
2020-06-02T18:58:23.8729100Z 2020-06-02 18:58:23 INFO  [StatefulSetUtils:145] StatefulSet my-cluster-kafka is ready
2020-06-02T18:58:23.8739431Z 2020-06-02 18:58:23 INFO  [DeploymentUtils:156] Waiting for Deployment my-cluster-entity-operator
2020-06-02T18:58:37.9462976Z 2020-06-02 18:58:37 INFO  [DeploymentUtils:160] Deployment my-cluster-entity-operator is ready
2020-06-02T18:58:37.9557410Z 2020-06-02 18:58:37 INFO  [KafkaUserResource:59] Created KafkaUser my-user-1842403490-1170670516
2020-06-02T18:58:37.9569382Z 2020-06-02 18:58:37 INFO  [ResourceManager:416] Wait for KafkaUser: my-user-1842403490-1170670516 will have desired state: Ready
2020-06-02T18:58:41.0227354Z 2020-06-02 18:58:41 INFO  [ResourceManager:425] KafkaUser:my-user-1842403490-1170670516 is in desired state: Ready
2020-06-02T18:58:41.0348529Z 2020-06-02 18:58:41 INFO  [KafkaTopicResource:65] Created KafkaTopic my-topic-992962085-96215772-1226875616
2020-06-02T18:58:41.0358734Z 2020-06-02 18:58:41 INFO  [ResourceManager:416] Wait for KafkaTopic: my-topic-992962085-96215772-1226875616 will have desired state: Ready
2020-06-02T18:58:43.0579378Z 2020-06-02 18:58:43 INFO  [ResourceManager:425] KafkaTopic:my-topic-992962085-96215772-1226875616 is in desired state: Ready
2020-06-02T18:58:45.1287217Z 2020-06-02 18:58:45 INFO  [DeploymentUtils:173] Waiting for 1 Pod(s) of Deployment my-cluster-kafka-clients to be ready
2020-06-02T18:58:56.1842057Z 2020-06-02 18:58:56 INFO  [DeploymentUtils:176] Deployment my-cluster-kafka-clients is ready
2020-06-02T18:58:56.1844807Z 2020-06-02 18:58:56 INFO  [SecurityST:177] Checking produced and consumed messages to pod:my-cluster-kafka-clients-6867f4dc8d-rnhhl
2020-06-02T18:58:56.1889067Z 2020-06-02 18:58:56 INFO  [InternalKafkaClient:78] Starting verifiableClient plain producer with the following configuration: VerifiableClient{allowedArguments=[TOPIC, BROKER_LIST, MAX_MESSAGES, THROUGHPUT, ACKS, PRODUCER_CONFIG, MESSAGE_CREATE_TIME, VALUE_PREFIX, REPEATING_KEYS, USER], lock=java.lang.Object@32a033b6, messages=[], arguments=[--broker-list, my-cluster-kafka-bootstrap:9092, --max-messages, 100, --topic, my-topic-992962085-96215772-1226875616], executable='/opt/kafka/producer.sh', executor=null, clientType=CLI_KAFKA_VERIFIABLE_PRODUCER, podName='my-cluster-kafka-clients-6867f4dc8d-rnhhl', podNamespace='security-cluster-test', bootstrapServer='my-cluster-kafka-bootstrap:9092', topicName='my-topic-992962085-96215772-1226875616', maxMessages=100, kafkaUsername='null', consumerGroupName='null', consumerInstanceId='null', clientArgumentMap=io.strimzi.systemtest.kafkaclients.internalClients.ClientArgumentMap@5f6e2ad9}
2020-06-02T18:58:56.1921054Z 2020-06-02 18:58:56 INFO  [InternalKafkaClient:79] Producing 100 messages to my-cluster-kafka-bootstrap:9092:my-topic-992962085-96215772-1226875616 from pod my-cluster-kafka-clients-6867f4dc8d-rnhhl
2020-06-02T18:58:56.1933054Z 2020-06-02 18:58:56 INFO  [VerifiableClient:202] Client command: kubectl exec my-cluster-kafka-clients-6867f4dc8d-rnhhl -n security-cluster-test -- /opt/kafka/producer.sh --broker-list my-cluster-kafka-bootstrap:9092 --max-messages 100 --topic my-topic-992962085-96215772-1226875616
2020-06-02T18:58:59.8767063Z 2020-06-02 18:58:59 INFO  [InternalKafkaClient:82] Producer finished correctly: true
2020-06-02T18:58:59.8776056Z 2020-06-02 18:58:59 INFO  [InternalKafkaClient:86] Producer produced 100 messages
2020-06-02T18:58:59.8879346Z 2020-06-02 18:58:59 INFO  [InternalKafkaClient:141] Starting verifiableClient plain consumer with the following configuration: VerifiableClient{allowedArguments=[BROKER_LIST, TOPIC, GROUP_ID, MAX_MESSAGES, SESSION_TIMEOUT, VERBOSE, ENABLE_AUTOCOMMIT, RESET_POLICY, ASSIGMENT_STRATEGY, CONSUMER_CONFIG, USER, GROUP_INSTANCE_ID], lock=java.lang.Object@3212bfd, messages=[], arguments=[--broker-list, my-cluster-kafka-bootstrap:9092, --group-instance-id, instance334477762, --group-id, my-consumer-group-1812250750, --max-messages, 100, --topic, my-topic-992962085-96215772-1226875616], executable='/opt/kafka/consumer.sh', executor=null, clientType=CLI_KAFKA_VERIFIABLE_CONSUMER, podName='my-cluster-kafka-clients-6867f4dc8d-rnhhl', podNamespace='security-cluster-test', bootstrapServer='my-cluster-kafka-bootstrap:9092', topicName='my-topic-992962085-96215772-1226875616', maxMessages=100, kafkaUsername='null', consumerGroupName='my-consumer-group-1812250750', consumerInstanceId='instance334477762', clientArgumentMap=io.strimzi.systemtest.kafkaclients.internalClients.ClientArgumentMap@1cc9bd9b}
2020-06-02T18:58:59.8932255Z 2020-06-02 18:58:59 INFO  [InternalKafkaClient:142] Consuming 100 messages from my-cluster-kafka-bootstrap:9092#my-topic-992962085-96215772-1226875616 from pod my-cluster-kafka-clients-6867f4dc8d-rnhhl
2020-06-02T18:58:59.8993233Z 2020-06-02 18:58:59 INFO  [VerifiableClient:202] Client command: kubectl exec my-cluster-kafka-clients-6867f4dc8d-rnhhl -n security-cluster-test -- /opt/kafka/consumer.sh --broker-list my-cluster-kafka-bootstrap:9092 --group-instance-id instance334477762 --group-id my-consumer-group-1812250750 --max-messages 100 --topic my-topic-992962085-96215772-1226875616
2020-06-02T18:59:20.0178321Z 2020-06-02 18:59:20 INFO  [InternalKafkaClient:145] Consumer finished correctly: true
2020-06-02T18:59:20.0203801Z 2020-06-02 18:59:20 INFO  [InternalKafkaClient:148] Consumer consumed 100 messages
2020-06-02T18:59:20.0442487Z 2020-06-02 18:59:20 INFO  [SecurityST:189] Triggering CA cert renewal by adding the annotation
2020-06-02T18:59:20.0541164Z 2020-06-02 18:59:20 INFO  [SecurityST:201] Patching secret my-cluster-cluster-ca-cert with strimzi.io/force-renew
2020-06-02T18:59:20.0779842Z 2020-06-02 18:59:20 INFO  [SecurityST:201] Patching secret my-cluster-clients-ca-cert with strimzi.io/force-renew
2020-06-02T18:59:20.0902791Z 2020-06-02 18:59:20 INFO  [SecurityST:206] Wait for zk to rolling restart ...
2020-06-02T18:59:20.0904542Z 2020-06-02 18:59:20 INFO  [StatefulSetUtils:101] Waiting for StatefulSet my-cluster-zookeeper rolling update
2020-06-02T19:01:20.5360166Z 2020-06-02 19:01:20 INFO  [StatefulSetUtils:111] StatefulSet my-cluster-zookeeper rolling update finished
2020-06-02T19:01:20.5495280Z 2020-06-02 19:01:20 INFO  [StatefulSetUtils:137] Waiting for StatefulSet my-cluster-zookeeper to be ready
2020-06-02T19:01:20.5637341Z 2020-06-02 19:01:20 INFO  [StatefulSetUtils:142] Waiting for 3 Pod(s) of StatefulSet my-cluster-zookeeper to be ready
2020-06-02T19:01:52.8568231Z 2020-06-02 19:01:52 INFO  [StatefulSetUtils:145] StatefulSet my-cluster-zookeeper is ready
2020-06-02T19:01:52.8624222Z 2020-06-02 19:01:52 INFO  [SecurityST:210] Wait for kafka to rolling restart ...
2020-06-02T19:01:52.8625235Z 2020-06-02 19:01:52 INFO  [StatefulSetUtils:101] Waiting for StatefulSet my-cluster-kafka rolling update
2020-06-02T19:15:52.9397212Z io.strimzi.test.WaitException: Timeout after 840000 ms waiting for StatefulSet my-cluster-kafka rolling update
2020-06-02T19:15:52.9542769Z    at io.strimzi.test.TestUtils.waitFor(TestUtils.java:129)
2020-06-02T19:15:52.9544005Z    at io.strimzi.test.TestUtils.waitFor(TestUtils.java:110)
2020-06-02T19:15:52.9545399Z    at io.strimzi.systemtest.utils.kubeUtils.controllers.StatefulSetUtils.waitTillSsHasRolled(StatefulSetUtils.java:102)
2020-06-02T19:15:52.9546637Z    at io.strimzi.systemtest.utils.kubeUtils.controllers.StatefulSetUtils.waitTillSsHasRolled(StatefulSetUtils.java:123)
2020-06-02T19:15:52.9549662Z    at io.strimzi.systemtest.security.SecurityST.autoRenewSomeCaCertsTriggeredByAnno(SecurityST.java:211)
2020-06-02T19:15:52.9604628Z    at io.strimzi.systemtest.security.SecurityST.testAutoRenewAllCaCertsTriggeredByAnno(SecurityST.java:298)
2020-06-02T19:15:52.9605950Z    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
2020-06-02T19:15:52.9606772Z    at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
2020-06-02T19:15:52.9607591Z    at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
2020-06-02T19:15:52.9608344Z    at java.base/java.lang.reflect.Method.invoke(Method.java:566)
2020-06-02T19:15:52.9609042Z    at org.junit.platform.commons.util.ReflectionUtils.invokeMethod(ReflectionUtils.java:675)
2020-06-02T19:15:52.9609813Z    at org.junit.jupiter.engine.execution.MethodInvocation.proceed(MethodInvocation.java:60)
2020-06-02T19:15:52.9610841Z    at org.junit.jupiter.engine.execution.InvocationInterceptorChain$ValidatingInvocation.proceed(InvocationInterceptorChain.java:125)
2020-06-02T19:15:52.9611752Z    at org.junit.jupiter.engine.extension.TimeoutExtension.intercept(TimeoutExtension.java:132)
2020-06-02T19:15:52.9613675Z    at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestableMethod(TimeoutExtension.java:124)
2020-06-02T19:15:52.9614658Z    at org.junit.jupiter.engine.extension.TimeoutExtension.interceptTestMethod(TimeoutExtension.java:74)
2020-06-02T19:15:52.9615551Z    at org.junit.jupiter.engine.execution.ExecutableInvoker$ReflectiveInterceptorCall.lambda$ofVoidMethod$0(ExecutableInvoker.java:115)
2020-06-02T19:15:52.9616802Z    at org.junit.jupiter.engine.execution.ExecutableInvoker.lambda$invoke$0(ExecutableInvoker.java:105)
2020-06-02T19:15:52.9617663Z    at org.junit.jupiter.engine.execution.InvocationInterceptorChain$InterceptedInvocation.proceed(InvocationInterceptorChain.java:104)
2020-06-02T19:15:52.9618617Z    at org.junit.jupiter.engine.execution.InvocationInterceptorChain.proceed(InvocationInterceptorChain.java:62)
2020-06-02T19:15:52.9628640Z    at org.junit.jupiter.engine.execution.InvocationInterceptorChain.chainAndInvoke(InvocationInterceptorChain.java:43)
2020-06-02T19:15:52.9631229Z    at org.junit.jupiter.engine.execution.InvocationInterceptorChain.invoke(InvocationInterceptorChain.java:35)
2020-06-02T19:15:52.9632242Z    at org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:104)
2020-06-02T19:15:52.9633791Z    at org.junit.jupiter.engine.execution.ExecutableInvoker.invoke(ExecutableInvoker.java:98)
2020-06-02T19:15:52.9659875Z    at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.lambda$invokeTestMethod$6(TestMethodTestDescriptor.java:202)
2020-06-02T19:15:52.9668845Z    at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
2020-06-02T19:15:52.9670057Z    at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.invokeTestMethod(TestMethodTestDescriptor.java:198)
2020-06-02T19:15:52.9670929Z    at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:135)
2020-06-02T19:15:52.9671762Z    at org.junit.jupiter.engine.descriptor.TestMethodTestDescriptor.execute(TestMethodTestDescriptor.java:69)
2020-06-02T19:15:52.9672590Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:135)
2020-06-02T19:15:52.9673445Z    at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
2020-06-02T19:15:52.9674270Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125)
2020-06-02T19:15:52.9675027Z    at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135)
2020-06-02T19:15:52.9675997Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123)
2020-06-02T19:15:52.9677958Z    at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
2020-06-02T19:15:52.9680977Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122)
2020-06-02T19:15:52.9684330Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80)
2020-06-02T19:15:52.9685150Z    at java.base/java.util.ArrayList.forEach(ArrayList.java:1540)
2020-06-02T19:15:52.9688475Z    at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38)
2020-06-02T19:15:52.9689646Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139)
2020-06-02T19:15:52.9690350Z    at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
2020-06-02T19:15:52.9690999Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125)
2020-06-02T19:15:52.9770377Z    at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135)
2020-06-02T19:15:52.9771178Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123)
2020-06-02T19:15:52.9771887Z    at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
2020-06-02T19:15:52.9772499Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122)
2020-06-02T19:15:52.9773086Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80)
2020-06-02T19:15:52.9773815Z    at java.base/java.util.ArrayList.forEach(ArrayList.java:1540)
2020-06-02T19:15:52.9774432Z    at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.invokeAll(SameThreadHierarchicalTestExecutorService.java:38)
2020-06-02T19:15:52.9775122Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$5(NodeTestTask.java:139)
2020-06-02T19:15:52.9775742Z    at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
2020-06-02T19:15:52.9776559Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$7(NodeTestTask.java:125)
2020-06-02T19:15:52.9777327Z    at org.junit.platform.engine.support.hierarchical.Node.around(Node.java:135)
2020-06-02T19:15:52.9778225Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.lambda$executeRecursively$8(NodeTestTask.java:123)
2020-06-02T19:15:52.9779105Z    at org.junit.platform.engine.support.hierarchical.ThrowableCollector.execute(ThrowableCollector.java:73)
2020-06-02T19:15:52.9779717Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.executeRecursively(NodeTestTask.java:122)
2020-06-02T19:15:52.9780627Z    at org.junit.platform.engine.support.hierarchical.NodeTestTask.execute(NodeTestTask.java:80)
2020-06-02T19:15:52.9781544Z    at org.junit.platform.engine.support.hierarchical.SameThreadHierarchicalTestExecutorService.submit(SameThreadHierarchicalTestExecutorService.java:32)
2020-06-02T19:15:52.9782264Z    at org.junit.platform.engine.support.hierarchical.HierarchicalTestExecutor.execute(HierarchicalTestExecutor.java:57)
2020-06-02T19:15:52.9783059Z    at org.junit.platform.engine.support.hierarchical.HierarchicalTestEngine.execute(HierarchicalTestEngine.java:51)
2020-06-02T19:15:52.9830695Z    at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:229)
2020-06-02T19:15:52.9831423Z    at org.junit.platform.launcher.core.DefaultLauncher.lambda$execute$6(DefaultLauncher.java:197)
2020-06-02T19:15:52.9832127Z    at org.junit.platform.launcher.core.DefaultLauncher.withInterceptedStreams(DefaultLauncher.java:211)
2020-06-02T19:15:52.9832808Z    at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:191)
2020-06-02T19:15:52.9837509Z    at org.junit.platform.launcher.core.DefaultLauncher.execute(DefaultLauncher.java:128)
2020-06-02T19:15:52.9838360Z    at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invokeAllTests(JUnitPlatformProvider.java:142)
2020-06-02T19:15:52.9845931Z    at org.apache.maven.surefire.junitplatform.JUnitPlatformProvider.invoke(JUnitPlatformProvider.java:117)
2020-06-02T19:15:52.9847258Z    at org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
2020-06-02T19:15:52.9847996Z    at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
2020-06-02T19:15:52.9848652Z    at org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
2020-06-02T19:15:52.9849253Z    at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
2020-06-02T19:15:52.9852858Z 2020-06-02 19:15:52 INFO  [TimeMeasuringSystem:113] End time of operation TEST_EXECUTION is correctly stored
2020-06-02T19:15:52.9921413Z 2020-06-02 19:15:52 INFO  [LogCollector:64] Collecting events in Namespace security-cluster-test
2020-06-02T19:15:53.2085695Z 2020-06-02 19:15:53 INFO  [LogCollector:71] Collecting ConfigMaps in Namespace security-cluster-test
2020-06-02T19:15:53.2202337Z 2020-06-02 19:15:53 INFO  [LogCollector:44] Collecting logs for Pod(s) in namespace security-cluster-test
2020-06-02T19:16:17.3517508Z 2020-06-02 19:16:17 INFO  [LogCollector:78] Collecting Deployments in Namespace security-cluster-test
2020-06-02T19:16:17.5072709Z 2020-06-02 19:16:17 INFO  [LogCollector:83] Collecting StatefulSets in Namespace security-cluster-test
2020-06-02T19:16:17.5969205Z 2020-06-02 19:16:17 INFO  [LogCollector:88] Collecting ReplicaSet in Namespace security-cluster-test
2020-06-02T19:16:17.6877469Z 2020-06-02 19:16:17 INFO  [LogCollector:93] Collecting Strimzi in Namespace security-cluster-test
2020-06-02T19:16:18.0119719Z 2020-06-02 19:16:18 INFO  [Exec:167] Command: kubectl get strimzi -o yaml -n security-cluster-test
2020-06-02T19:16:18.0120929Z 2020-06-02 19:16:18 INFO  [Exec:168] RETURN code: 0
2020-06-02T19:16:18.0121626Z 2020-06-02 19:16:18 INFO  [Exec:170] ======STDOUT START=======
2020-06-02T19:16:18.0124696Z 2020-06-02 19:16:18 INFO  [Exec:171] apiVersion: v1
2020-06-02T19:16:18.0125254Z items:
2020-06-02T19:16:18.0125808Z - apiVersion: kafka.strimzi.io/v1beta1
2020-06-02T19:16:18.0126154Z   kind: KafkaUser
2020-06-02T19:16:18.0126539Z   metadata:
2020-06-02T19:16:18.0127063Z     creationTimestamp: "2020-06-02T18:58:37Z"
2020-06-02T19:16:18.0127545Z     generation: 1
2020-06-02T19:16:18.0127815Z     labels:
2020-06-02T19:16:18.0128285Z       strimzi.io/cluster: my-cluster
2020-06-02T19:16:18.0156147Z     name: my-user-1842403490-1170670516
2020-06-02T19:16:18.0157957Z     namespace: security-cluster-test
2020-06-02T19:16:18.0158561Z     resourceVersion: "11327"
2020-06-02T19:16:18.0159451Z     selfLink: /apis/kafka.strimzi.io/v1beta1/namespaces/security-cluster-test/kafkausers/my-user-1842403490-1170670516
2020-06-02T19:16:18.0160322Z     uid: 7c5445af-270b-4234-879d-51840ea6d88b
2020-06-02T19:16:18.0160869Z   spec:
2020-06-02T19:16:18.0161122Z     authentication:
2020-06-02T19:16:18.0161419Z       type: tls
2020-06-02T19:16:18.0161728Z   status:
2020-06-02T19:16:18.0161945Z     conditions:
2020-06-02T19:16:18.0162538Z     - lastTransitionTime: "2020-06-02T18:58:40.426661Z"
2020-06-02T19:16:18.0162853Z       status: "True"
2020-06-02T19:16:18.0163381Z       type: Ready
2020-06-02T19:16:18.0163777Z     observedGeneration: 1
2020-06-02T19:16:18.0164561Z     secret: my-user-1842403490-1170670516
2020-06-02T19:16:18.0165198Z     username: CN=my-user-1842403490-1170670516
2020-06-02T19:16:18.0165834Z - apiVersion: kafka.strimzi.io/v1beta1
2020-06-02T19:16:18.0166221Z   kind: Kafka
2020-06-02T19:16:18.0166544Z   metadata:
2020-06-02T19:16:18.0167099Z     creationTimestamp: "2020-06-02T18:57:07Z"
2020-06-02T19:16:18.0167725Z     generation: 1
2020-06-02T19:16:18.0168251Z     name: my-cluster
2020-06-02T19:16:18.0170936Z     namespace: security-cluster-test
2020-06-02T19:16:18.0171707Z     resourceVersion: "12095"
2020-06-02T19:16:18.0172431Z     selfLink: /apis/kafka.strimzi.io/v1beta1/namespaces/security-cluster-test/kafkas/my-cluster
2020-06-02T19:16:18.0174102Z     uid: 262d5161-03cd-4b9d-9779-6a476591a0ec
2020-06-02T19:16:18.0174669Z   spec:
2020-06-02T19:16:18.0207532Z     entityOperator:
2020-06-02T19:16:18.0209220Z       topicOperator:
2020-06-02T19:16:18.0209674Z         image: docker.io/strimzici/operator:latest
2020-06-02T19:16:18.0210014Z         logging:
2020-06-02T19:16:18.0210293Z           loggers:
2020-06-02T19:16:18.0210616Z             rootLogger.level: DEBUG
2020-06-02T19:16:18.0211120Z           type: inline
2020-06-02T19:16:18.0211474Z         reconciliationIntervalSeconds: 90
2020-06-02T19:16:18.0211842Z         topicMetadataMaxAttempts: 6
2020-06-02T19:16:18.0212215Z         zookeeperSessionTimeoutSeconds: 20
2020-06-02T19:16:18.0212546Z       userOperator:
2020-06-02T19:16:18.0212880Z         image: docker.io/strimzici/operator:latest
2020-06-02T19:16:18.0213227Z         logging:
2020-06-02T19:16:18.0213508Z           loggers:
2020-06-02T19:16:18.0213832Z             rootLogger.level: DEBUG
2020-06-02T19:16:18.0214150Z           type: inline
2020-06-02T19:16:18.0214478Z         reconciliationIntervalSeconds: 120
2020-06-02T19:16:18.0214861Z         zookeeperSessionTimeoutSeconds: 6
2020-06-02T19:16:18.0215178Z     kafka:
2020-06-02T19:16:18.0215457Z       config:
2020-06-02T19:16:18.0218452Z         default.replication.factor: 3
2020-06-02T19:16:18.0228755Z       listeners:
2020-06-02T19:16:18.0241317Z         plain: {}
2020-06-02T19:16:18.0242415Z         tls:
2020-06-02T19:16:18.0242899Z           authentication:
2020-06-02T19:16:18.0243332Z             type: tls
2020-06-02T19:16:18.0244016Z       logging:
2020-06-02T19:16:18.0245090Z         loggers:
2020-06-02T19:16:18.0246410Z           kafka.root.logger.level: DEBUG
2020-06-02T19:16:18.0247247Z         type: inline
2020-06-02T19:16:18.0247694Z       replicas: 3
2020-06-02T19:16:18.0248108Z       storage:
2020-06-02T19:16:18.0248530Z         deleteClaim: true
2020-06-02T19:16:18.0248975Z         size: 2Gi
2020-06-02T19:16:18.0249795Z         type: persistent-claim
2020-06-02T19:16:18.0259894Z       version: 2.5.0
2020-06-02T19:16:18.0271482Z     zookeeper:
2020-06-02T19:16:18.0272060Z       logging:
2020-06-02T19:16:18.0272490Z         loggers:
2020-06-02T19:16:18.0272943Z           zookeeper.root.logger: DEBUG
2020-06-02T19:16:18.0273388Z         type: inline
2020-06-02T19:16:18.0273807Z       replicas: 3
2020-06-02T19:16:18.0274207Z       storage:
2020-06-02T19:16:18.0274634Z         deleteClaim: true
2020-06-02T19:16:18.0275049Z         size: 2Gi
2020-06-02T19:16:18.0275785Z         type: persistent-claim
2020-06-02T19:16:18.0276336Z   status:
2020-06-02T19:16:18.0277512Z     conditions:
2020-06-02T19:16:18.0283063Z     - lastTransitionTime: 2020-06-02T19:06:41+0000
2020-06-02T19:16:18.0317327Z       message: Failed to connect to Zookeeper my-cluster-zookeeper-0.my-cluster-zookeeper-nodes.security-cluster-test.svc:2181,my-cluster-zookeeper-1.my-cluster-zookeeper-nodes.security-cluster-test.svc:2181,my-cluster-zookeeper-2.my-cluster-zookeeper-nodes.security-cluster-test.svc:2181.
2020-06-02T19:16:18.0318557Z         Connection was not ready in 300000 ms.
2020-06-02T19:16:18.0319125Z       reason: ZookeeperScalingException
2020-06-02T19:16:18.0319599Z       status: "True"
2020-06-02T19:16:18.0320147Z       type: NotReady
2020-06-02T19:16:18.0320599Z     observedGeneration: 1
2020-06-02T19:16:18.0321311Z - apiVersion: kafka.strimzi.io/v1beta1
2020-06-02T19:16:18.0321880Z   kind: KafkaTopic
2020-06-02T19:16:18.0322293Z   metadata:
2020-06-02T19:16:18.0323008Z     creationTimestamp: "2020-06-02T18:59:54Z"
2020-06-02T19:16:18.0331884Z     generation: 1
2020-06-02T19:16:18.0345058Z     labels:
2020-06-02T19:16:18.0345980Z       strimzi.io/cluster: my-cluster
2020-06-02T19:16:18.0346909Z     name: consumer-offsets---84e7a678d08f4bd226872e5cdd4eb527fadc1c6a
2020-06-02T19:16:18.0348336Z     namespace: security-cluster-test
2020-06-02T19:16:18.0349014Z     resourceVersion: "11519"
2020-06-02T19:16:18.0375079Z     selfLink: /apis/kafka.strimzi.io/v1beta1/namespaces/security-cluster-test/kafkatopics/consumer-offsets---84e7a678d08f4bd226872e5cdd4eb527fadc1c6a
2020-06-02T19:16:18.0376298Z     uid: 32649f16-de31-4d36-8e5b-515a0dcdac41
2020-06-02T19:16:18.0377082Z   spec:
2020-06-02T19:16:18.0377721Z     config:
2020-06-02T19:16:18.0378249Z       cleanup.policy: compact
2020-06-02T19:16:18.0378928Z       compression.type: producer
2020-06-02T19:16:18.0379608Z       segment.bytes: "104857600"
2020-06-02T19:16:18.0380158Z     partitions: 50
2020-06-02T19:16:18.0380592Z     replicas: 3
2020-06-02T19:16:18.0381210Z     topicName: __consumer_offsets
2020-06-02T19:16:18.0381870Z   status:
2020-06-02T19:16:18.0386138Z     conditions:
2020-06-02T19:16:18.0402435Z     - lastTransitionTime: "2020-06-02T18:59:54.459549Z"
2020-06-02T19:16:18.0403159Z       status: "True"
2020-06-02T19:16:18.0403641Z       type: Ready
2020-06-02T19:16:18.0404176Z     observedGeneration: 1
2020-06-02T19:16:18.0404909Z - apiVersion: kafka.strimzi.io/v1beta1
2020-06-02T19:16:18.0405452Z   kind: KafkaTopic
2020-06-02T19:16:18.0405881Z   metadata:
2020-06-02T19:16:18.0406567Z     creationTimestamp: "2020-06-02T18:58:41Z"
2020-06-02T19:16:18.0407181Z     generation: 1
2020-06-02T19:16:18.0407610Z     labels:
2020-06-02T19:16:18.0415302Z       strimzi.io/cluster: my-cluster
2020-06-02T19:16:18.0430062Z     name: my-topic-992962085-96215772-1226875616
2020-06-02T19:16:18.0431387Z     namespace: security-cluster-test
2020-06-02T19:16:18.0432040Z     resourceVersion: "11343"
2020-06-02T19:16:18.0447858Z     selfLink: /apis/kafka.strimzi.io/v1beta1/namespaces/security-cluster-test/kafkatopics/my-topic-992962085-96215772-1226875616
2020-06-02T19:16:18.0449385Z     uid: a11603a7-89e9-413a-8482-1a223c346f1e
2020-06-02T19:16:18.0450014Z   spec:
2020-06-02T19:16:18.0452638Z     config:
2020-06-02T19:16:18.0458535Z       min.insync.replicas: 1
2020-06-02T19:16:18.0470771Z       retention.ms: 7200000
2020-06-02T19:16:18.0471499Z       segment.bytes: 1073741824
2020-06-02T19:16:18.0472060Z     partitions: 1
2020-06-02T19:16:18.0472539Z     replicas: 1
2020-06-02T19:16:18.0473019Z   status:
2020-06-02T19:16:18.0473786Z     conditions:
2020-06-02T19:16:18.0474632Z     - lastTransitionTime: "2020-06-02T18:58:42.668315Z"
2020-06-02T19:16:18.0475306Z       status: "True"
2020-06-02T19:16:18.0475769Z       type: Ready
2020-06-02T19:16:18.0476246Z     observedGeneration: 1
2020-06-02T19:16:18.0476689Z kind: List
2020-06-02T19:16:18.0477224Z metadata:
2020-06-02T19:16:18.0477674Z   resourceVersion: ""
2020-06-02T19:16:18.0478134Z   selfLink: ""
2020-06-02T19:16:18.0478511Z 
2020-06-02T19:16:18.0495881Z 2020-06-02 19:16:18 INFO  [Exec:172] ======STDOUT END======
2020-06-02T19:16:18.0497142Z 2020-06-02 19:16:18 INFO  [TimeMeasuringSystem:113] End time of operation TEST_EXECUTION is correctly stored
2020-06-02T19:16:18.0498303Z 2020-06-02 19:16:18 INFO  [BaseST:673] Search in strimzi-cluster-operator log for errors in last 1150 seconds
2020-06-02T19:16:18.3784681Z 2020-06-02 19:16:18 INFO  [BaseST:757] Test execution contains exception, going to recreate test environment
2020-06-02T19:16:18.3795496Z 2020-06-02 19:16:18 INFO  [ResourceManager:353] -----CLEARING METHOD RESOURCES-----
2020-06-02T19:16:18.3827016Z 2020-06-02 19:16:18 INFO  [ResourceManager:188] Deleting Deployment my-cluster-kafka-clients
2020-06-02T19:16:18.3828508Z 2020-06-02 19:16:18 INFO  [ResourceManager:334] Waiting when all the pods are terminated for Deployment my-cluster-kafka-clients
2020-06-02T19:16:18.3829490Z 2020-06-02 19:16:18 WARN  [DeploymentUtils:190] Deployment my-cluster-kafka-clients is not deleted yet! Triggering force delete by cmd client!
2020-06-02T19:16:23.4858757Z 2020-06-02 19:16:23 INFO  [PodUtils:147] Waiting when Pod my-cluster-kafka-clients-6867f4dc8d-rnhhl will be deleted
2020-06-02T19:16:53.5380378Z 2020-06-02 19:16:53 INFO  [PodUtils:164] Pod my-cluster-kafka-clients-6867f4dc8d-rnhhl deleted
2020-06-02T19:16:53.5549601Z 2020-06-02 19:16:53 INFO  [ResourceManager:227] Deleting KafkaTopic my-topic-992962085-96215772-1226875616 in namespace security-cluster-test
2020-06-02T19:16:53.5619740Z 2020-06-02 19:16:53 INFO  [ResourceManager:227] Deleting KafkaUser my-user-1842403490-1170670516 in namespace security-cluster-test
2020-06-02T19:16:53.5806291Z 2020-06-02 19:16:53 INFO  [ResourceManager:122] Deleting Kafka my-cluster in namespace security-cluster-test
2020-06-02T19:16:53.6078641Z 2020-06-02 19:16:53 INFO  [ResourceManager:240] Waiting when all the pods are terminated for Kafka my-cluster
2020-06-02T19:16:53.6503104Z 2020-06-02 19:16:53 WARN  [StatefulSetUtils:159] StatefulSet my-cluster-zookeeper is not deleted yet! Triggering force delete by cmd client!
2020-06-02T19:16:58.8300042Z 2020-06-02 19:16:58 INFO  [PodUtils:147] Waiting when Pod my-cluster-zookeeper-0 will be deleted
2020-06-02T19:17:08.8406655Z 2020-06-02 19:17:08 INFO  [PodUtils:164] Pod my-cluster-zookeeper-0 deleted
2020-06-02T19:17:08.8408399Z 2020-06-02 19:17:08 INFO  [PodUtils:147] Waiting when Pod my-cluster-zookeeper-1 will be deleted
2020-06-02T19:17:08.8947922Z 2020-06-02 19:17:08 INFO  [PodUtils:164] Pod my-cluster-zookeeper-1 deleted
2020-06-02T19:17:08.8949087Z 2020-06-02 19:17:08 INFO  [PodUtils:147] Waiting when Pod my-cluster-zookeeper-2 will be deleted
2020-06-02T19:17:08.8990204Z 2020-06-02 19:17:08 INFO  [PodUtils:164] Pod my-cluster-zookeeper-2 deleted
2020-06-02T19:17:08.9037875Z 2020-06-02 19:17:08 INFO  [PodUtils:147] Waiting when Pod my-cluster-kafka-0 will be deleted
2020-06-02T19:17:28.9231504Z 2020-06-02 19:17:28 INFO  [PodUtils:164] Pod my-cluster-kafka-0 deleted
2020-06-02T19:17:28.9241744Z 2020-06-02 19:17:28 INFO  [PodUtils:147] Waiting when Pod my-cluster-kafka-1 will be deleted
2020-06-02T19:17:28.9266709Z 2020-06-02 19:17:28 INFO  [PodUtils:164] Pod my-cluster-kafka-1 deleted
2020-06-02T19:17:28.9271100Z 2020-06-02 19:17:28 INFO  [PodUtils:147] Waiting when Pod my-cluster-kafka-2 will be deleted
2020-06-02T19:17:33.9383183Z 2020-06-02 19:17:33 INFO  [PodUtils:164] Pod my-cluster-kafka-2 deleted
2020-06-02T19:17:33.9973915Z 2020-06-02 19:17:33 INFO  [SecretUtils:94] Waiting for Secret my-cluster deletion
2020-06-02T19:17:34.0418003Z 2020-06-02 19:17:34 INFO  [SecretUtils:108] Secret my-cluster deleted
2020-06-02T19:17:34.0422357Z 2020-06-02 19:17:34 INFO  [PersistentVolumeClaimUtils:58] Wait until PVC deletion for cluster my-cluster
2020-06-02T19:17:34.0440932Z 2020-06-02 19:17:34 INFO  [PersistentVolumeClaimUtils:72] PVC for cluster my-cluster was deleted
2020-06-02T19:17:34.0444312Z 2020-06-02 19:17:34 INFO  [ConfigMapUtils:66] Waiting for all ConfigMaps of cluster my-cluster-kafka-config deletion
2020-06-02T19:17:34.0466434Z 2020-06-02 19:17:34 INFO  [ConfigMapUtils:80] ConfigMaps of cluster my-cluster-kafka-config were deleted
2020-06-02T19:17:34.0471506Z 2020-06-02 19:17:34 INFO  [ConfigMapUtils:66] Waiting for all ConfigMaps of cluster my-cluster-zookeeper-config deletion
2020-06-02T19:17:34.0488051Z 2020-06-02 19:17:34 INFO  [ConfigMapUtils:80] ConfigMaps of cluster my-cluster-zookeeper-config were deleted
2020-06-02T19:17:34.0493040Z 2020-06-02 19:17:34 INFO  [ResourceManager:359] -----METHOD RESOURCES CLEARED-----
2020-06-02T19:17:34.0496488Z 2020-06-02 19:17:34 INFO  [ResourceManager:344] -----CLEARING CLASS RESOURCES-----
2020-06-02T19:17:34.0514295Z 2020-06-02 19:17:34 INFO  [ResourceManager:188] Deleting Deployment strimzi-cluster-operator
2020-06-02T19:17:34.0515878Z 2020-06-02 19:17:34 INFO  [ResourceManager:334] Waiting when all the pods are terminated for Deployment strimzi-cluster-operator
2020-06-02T19:17:34.0544417Z 2020-06-02 19:17:34 WARN  [DeploymentUtils:190] Deployment strimzi-cluster-operator is not deleted yet! Triggering force delete by cmd client!
2020-06-02T19:17:39.1547081Z 2020-06-02 19:17:39 INFO  [ResourceManager:202] Deleting RoleBinding strimzi-cluster-operator-topic-operator-delegation
2020-06-02T19:17:39.1569290Z 2020-06-02 19:17:39 INFO  [ResourceManager:202] Deleting RoleBinding strimzi-cluster-operator-entity-operator-delegation
2020-06-02T19:17:39.1602161Z 2020-06-02 19:17:39 INFO  [ResourceManager:195] Deleting ClusterRoleBinding strimzi-cluster-operator-kafka-broker-delegation
2020-06-02T19:17:39.1649216Z 2020-06-02 19:17:39 INFO  [ResourceManager:195] Deleting ClusterRoleBinding strimzi-cluster-operator
2020-06-02T19:17:39.1837003Z 2020-06-02 19:17:39 INFO  [ResourceManager:202] Deleting RoleBinding strimzi-cluster-operator
2020-06-02T19:17:39.1915045Z 2020-06-02 19:17:39 INFO  [ResourceManager:227] Deleting NetworkPolicy global-network-policy in namespace security-cluster-test
2020-06-02T19:17:39.1975066Z 2020-06-02 19:17:39 INFO  [ResourceManager:349] -----CLASS RESOURCES CLEARED-----
2020-06-02T19:17:39.1979964Z 2020-06-02 19:17:39 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/049-Crd-kafkarebalance.yaml
2020-06-02T19:17:39.2964101Z 2020-06-02 19:17:39 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/048-Crd-kafkamirrormaker2.yaml
2020-06-02T19:17:39.5305848Z 2020-06-02 19:17:39 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/047-Crd-kafkaconnector.yaml
2020-06-02T19:17:39.6758401Z 2020-06-02 19:17:39 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/046-Crd-kafkabridge.yaml
2020-06-02T19:17:40.0445339Z 2020-06-02 19:17:40 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/045-Crd-kafkamirrormaker.yaml
2020-06-02T19:17:40.3444395Z 2020-06-02 19:17:40 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/044-Crd-kafkauser.yaml
2020-06-02T19:17:40.5469757Z 2020-06-02 19:17:40 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/043-Crd-kafkatopic.yaml
2020-06-02T19:17:40.8249285Z 2020-06-02 19:17:40 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/042-Crd-kafkaconnects2i.yaml
2020-06-02T19:17:41.1398952Z 2020-06-02 19:17:41 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/041-Crd-kafkaconnect.yaml
2020-06-02T19:17:41.6349636Z 2020-06-02 19:17:41 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/040-Crd-kafka.yaml
2020-06-02T19:17:42.3973508Z 2020-06-02 19:17:42 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/032-ClusterRole-strimzi-topic-operator.yaml
2020-06-02T19:17:42.4906030Z 2020-06-02 19:17:42 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/031-ClusterRole-strimzi-entity-operator.yaml
2020-06-02T19:17:42.5725519Z 2020-06-02 19:17:42 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/030-ClusterRole-strimzi-kafka-broker.yaml
2020-06-02T19:17:42.6519757Z 2020-06-02 19:17:42 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/021-ClusterRole-strimzi-cluster-operator-role.yaml
2020-06-02T19:17:42.7447327Z 2020-06-02 19:17:42 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/020-ClusterRole-strimzi-cluster-operator-role.yaml
2020-06-02T19:17:42.8514064Z 2020-06-02 19:17:42 INFO  [KubeClusterResource:175] Deleting configuration file: ../install/cluster-operator/010-ServiceAccount-strimzi-cluster-operator.yaml
2020-06-02T19:17:42.9687960Z 2020-06-02 19:17:42 INFO  [KubeClusterResource:220] Deleting Namespace security-cluster-test
2020-06-02T19:17:48.6369564Z 2020-06-02 19:17:48 INFO  [KubeClusterResource:226] Using Namespace security-cluster-test
2020-06-02T19:17:48.6371873Z 2020-06-02 19:17:48 INFO  [KubeClusterResource:118] Changing to security-cluster-test namespace
2020-06-02T19:17:48.6391498Z 2020-06-02 19:17:48 INFO  [KubeClusterResource:195] Creating Namespace security-cluster-test
2020-06-02T19:17:48.7239208Z 2020-06-02 19:17:48 INFO  [KubeClusterResource:201] Using Namespace security-cluster-test
2020-06-02T19:17:48.7240519Z 2020-06-02 19:17:48 INFO  [KubeClusterResource:118] Changing to security-cluster-test namespace
2020-06-02T19:17:48.7897189Z 2020-06-02 19:17:48 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/010-ServiceAccount-strimzi-cluster-operator.yaml
2020-06-02T19:17:49.0365253Z 2020-06-02 19:17:49 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/020-ClusterRole-strimzi-cluster-operator-role.yaml
2020-06-02T19:17:49.2953941Z 2020-06-02 19:17:49 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/021-ClusterRole-strimzi-cluster-operator-role.yaml
2020-06-02T19:17:49.4991782Z 2020-06-02 19:17:49 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/030-ClusterRole-strimzi-kafka-broker.yaml
2020-06-02T19:17:49.6748839Z 2020-06-02 19:17:49 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/031-ClusterRole-strimzi-entity-operator.yaml
2020-06-02T19:17:49.8410476Z 2020-06-02 19:17:49 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/032-ClusterRole-strimzi-topic-operator.yaml
2020-06-02T19:17:50.0416777Z 2020-06-02 19:17:50 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/040-Crd-kafka.yaml
2020-06-02T19:17:50.4128151Z 2020-06-02 19:17:50 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/041-Crd-kafkaconnect.yaml
2020-06-02T19:17:50.9896286Z 2020-06-02 19:17:50 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/042-Crd-kafkaconnects2i.yaml
2020-06-02T19:17:51.5278789Z 2020-06-02 19:17:51 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/043-Crd-kafkatopic.yaml
2020-06-02T19:17:51.9306631Z 2020-06-02 19:17:51 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/044-Crd-kafkauser.yaml
2020-06-02T19:17:52.3261645Z 2020-06-02 19:17:52 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/045-Crd-kafkamirrormaker.yaml
2020-06-02T19:17:52.7429167Z 2020-06-02 19:17:52 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/046-Crd-kafkabridge.yaml
2020-06-02T19:17:53.1561007Z 2020-06-02 19:17:53 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/047-Crd-kafkaconnector.yaml
2020-06-02T19:17:53.3856888Z 2020-06-02 19:17:53 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/048-Crd-kafkamirrormaker2.yaml
2020-06-02T19:17:53.6629966Z 2020-06-02 19:17:53 INFO  [KubeClusterResource:97] Applying configuration file: ../install/cluster-operator/049-Crd-kafkarebalance.yaml
2020-06-02T19:17:54.1741222Z 2020-06-02 19:17:54 INFO  [ResourceManager:105] Setting pointer to class resources
2020-06-02T19:17:54.1743395Z 2020-06-02 19:17:54 INFO  [KubernetesResource:143] Creating RoleBinding from ../install/cluster-operator/020-RoleBinding-strimzi-cluster-operator.yaml in namespace security-cluster-test
2020-06-02T19:17:54.3774070Z 2020-06-02 19:17:54 INFO  [KubernetesResource:158] Creating ClusterRoleBinding from ../install/cluster-operator/021-ClusterRoleBinding-strimzi-cluster-operator.yaml in namespace security-cluster-test
2020-06-02T19:17:54.3839983Z 2020-06-02 19:17:54 INFO  [KubernetesResource:158] Creating ClusterRoleBinding from ../install/cluster-operator/030-ClusterRoleBinding-strimzi-cluster-operator-kafka-broker-delegation.yaml in namespace security-cluster-test
2020-06-02T19:17:54.4165128Z 2020-06-02 19:17:54 INFO  [KubernetesResource:143] Creating RoleBinding from ../install/cluster-operator/031-RoleBinding-strimzi-cluster-operator-entity-operator-delegation.yaml in namespace security-cluster-test
2020-06-02T19:17:54.4445719Z 2020-06-02 19:17:54 INFO  [KubernetesResource:143] Creating RoleBinding from ../install/cluster-operator/032-RoleBinding-strimzi-cluster-operator-topic-operator-delegation.yaml in namespace security-cluster-test
2020-06-02T19:18:22.7883037Z 2020-06-02 19:18:22 INFO  [DeploymentUtils:173] Waiting for 1 Pod(s) of Deployment strimzi-cluster-operator to be ready
2020-06-02T19:18:33.8256512Z 2020-06-02 19:18:33 INFO  [DeploymentUtils:176] Deployment strimzi-cluster-operator is ready
2020-06-02T19:18:33.8349585Z 2020-06-02 19:18:33 INFO  [KubernetesResource:406] Network policy successfully set to: DEFAULT_TO_DENY
2020-06-02T19:18:33.8386817Z 2020-06-02 19:18:33 INFO  [KubernetesResource:323] NetworkPolicy successfully set to: true for namespace: security-cluster-test
2020-06-02T19:18:33.8388815Z 2020-06-02 19:18:33 INFO  [BaseST:760] Env recreated.
2020-06-02T19:18:33.8390056Z 2020-06-02 19:18:33 INFO  [ResourceManager:353] -----CLEARING METHOD RESOURCES-----
2020-06-02T19:18:33.8391396Z 2020-06-02 19:18:33 INFO  [ResourceManager:359] -----METHOD RESOURCES CLEARED-----
2020-06-02T19:18:33.8392673Z 2020-06-02 19:18:33 INFO  [TimeMeasuringSystem:113] End time of operation TEST_EXECUTION is correctly stored
2020-06-02T19:18:33.8394058Z 2020-06-02 19:18:33 INFO  [TestSeparator:34] io.strimzi.systemtest.security.SecurityST.testAutoRenewAllCaCertsTriggeredByAnno-FINISHED
2020-06-02T19:18:33.8395685Z 2020-06-02 19:18:33 INFO  [TestSeparator:35] ############################################################################

We should look into it.

sknot-rh commented 4 years ago

I was not able to reproduce this (via https://github.com/strimzi/strimzi-kafka-operator/pull/3196). Do you have any idea whether this is still valid?