See
<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/3800/display/redirect>
Changes:
------------------------------------------
[...truncated 615.95 KB...]
security.providers = null
send.buffer.bytes = 131072
session.timeout.ms = 10000
ssl.cipher.suites = null
ssl.enabled.protocols = [TLSv1.2, TLSv1.1, TLSv1]
ssl.endpoint.identification.algorithm = https
ssl.key.password = null
ssl.keymanager.algorithm = SunX509
ssl.keystore.location = null
ssl.keystore.password = null
ssl.keystore.type = JKS
ssl.protocol = TLS
ssl.provider = null
ssl.secure.random.implementation = null
ssl.trustmanager.algorithm = PKIX
ssl.truststore.location = null
ssl.truststore.password = null
ssl.truststore.type = JKS
value.deserializer = class
org.apache.kafka.common.serialization.ByteArrayDeserializer
May 01, 2023 12:41:59 AM
org.apache.kafka.common.utils.AppInfoParser$AppInfo <init>
INFO: Kafka version: 2.4.1
May 01, 2023 12:41:59 AM
org.apache.kafka.common.utils.AppInfoParser$AppInfo <init>
INFO: Kafka commitId: c57222ae8cd7866b
May 01, 2023 12:41:59 AM
org.apache.kafka.common.utils.AppInfoParser$AppInfo <init>
INFO: Kafka startTimeMs: 1682901719585
May 01, 2023 12:41:59 AM org.apache.kafka.clients.Metadata update
INFO: [Consumer clientId=consumer-1, groupId=null] Cluster ID:
rYU2xxv0Sy2zrgf3tJxJzA
May 01, 2023 12:41:59 AM org.apache.beam.sdk.io.kafka.KafkaUnboundedSource
split
INFO: Partitions assigned to split 0 (total 1): beam-sdf-0
May 01, 2023 12:41:59 AM
org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep
INFO: Adding Read from unbounded
Kafka/KafkaIO.Read.ReadFromKafkaViaSDF/Read(KafkaUnboundedSource)/StripIds as
step s2
May 01, 2023 12:41:59 AM
org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep
INFO: Adding Measure read time as step s3
May 01, 2023 12:41:59 AM
org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep
INFO: Adding Map records to strings/Map as step s4
May 01, 2023 12:41:59 AM
org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep
INFO: Adding Counting element as step s5
May 01, 2023 12:41:59 AM org.apache.beam.runners.dataflow.DataflowRunner run
INFO: Dataflow SDK version: 2.48.0-SNAPSHOT
May 01, 2023 12:42:00 AM org.apache.beam.runners.dataflow.DataflowRunner run
INFO: To access the Dataflow monitoring console, please navigate to
https://console.cloud.google.com/dataflow/jobs/us-central1/2023-04-30_17_42_00-11763581837605242135?project=apache-beam-testing
May 01, 2023 12:42:00 AM org.apache.beam.runners.dataflow.DataflowRunner run
INFO: Submitted job: 2023-04-30_17_42_00-11763581837605242135
May 01, 2023 12:42:00 AM org.apache.beam.runners.dataflow.DataflowRunner run
INFO: To cancel the job using the 'gcloud' tool, run:
> gcloud dataflow jobs --project=apache-beam-testing cancel
--region=us-central1 2023-04-30_17_42_00-11763581837605242135
May 01, 2023 12:42:03 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
WARNING: 2023-05-01T00:42:03.543Z: The workflow name is not a valid Cloud
Label. Labels applied to Cloud resources (such as GCE Instances) for monitoring
will be labeled with this modified job name:
kafkaioit0testkafkaioreadsandwritescorrectlyinstreaming-je-k47b. For the best
monitoring experience, please name your job with a valid Cloud Label. For
details, see:
https://cloud.google.com/compute/docs/labeling-resources#restrictions
May 01, 2023 12:42:13 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:13.700Z: Worker configuration: e2-standard-2 in
us-central1-f.
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:14.751Z: Expanding SplittableParDo operations into
optimizable parts.
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:14.789Z: Expanding CollectionToSingleton operations
into optimizable parts.
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:14.842Z: Expanding CoGroupByKey operations into
optimizable parts.
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:14.872Z: Expanding SplittableProcessKeyed operations
into optimizable parts.
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:14.898Z: Expanding GroupByKey operations into
streaming Read/Write steps
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:14.918Z: Lifting ValueCombiningMappingFns into
MergeBucketsMappingFns
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:14.992Z: Fusing adjacent ParDo, Read, Write, and
Flatten operations
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:15.023Z: Fusing consumer Read from unbounded
Kafka/KafkaIO.Read.ReadFromKafkaViaSDF/ParDo(GenerateKafkaSourceDescriptor)/ParMultiDo(GenerateKafkaSourceDescriptor)
into Read from unbounded Kafka/KafkaIO.Read.ReadFromKafkaViaSDF/Impulse
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:15.058Z: Fusing consumer
Read-from-unbounded-Kafka-KafkaIO-Read-ReadFromKafkaViaSDF-KafkaIO-ReadSourceDescriptors-ParDo-Unbou/PairWithRestriction
into Read from unbounded
Kafka/KafkaIO.Read.ReadFromKafkaViaSDF/ParDo(GenerateKafkaSourceDescriptor)/ParMultiDo(GenerateKafkaSourceDescriptor)
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:15.086Z: Fusing consumer
Read-from-unbounded-Kafka-KafkaIO-Read-ReadFromKafkaViaSDF-KafkaIO-ReadSourceDescriptors-ParDo-Unbou/SplitWithSizing
into
Read-from-unbounded-Kafka-KafkaIO-Read-ReadFromKafkaViaSDF-KafkaIO-ReadSourceDescriptors-ParDo-Unbou/PairWithRestriction
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:15.113Z: Fusing consumer Read from unbounded
Kafka/KafkaIO.Read.ReadFromKafkaViaSDF/KafkaIO.ReadSourceDescriptors/MapElements/Map/ParMultiDo(Anonymous)
into
Read-from-unbounded-Kafka-KafkaIO-Read-ReadFromKafkaViaSDF-KafkaIO-ReadSourceDescriptors-ParDo-Unbou/ProcessElementAndRestrictionWithSizing
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:15.137Z: Fusing consumer Measure read
time/ParMultiDo(TimeMonitor) into Read from unbounded
Kafka/KafkaIO.Read.ReadFromKafkaViaSDF/KafkaIO.ReadSourceDescriptors/MapElements/Map/ParMultiDo(Anonymous)
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:15.191Z: Fusing consumer Map records to
strings/Map/ParMultiDo(Anonymous) into Measure read time/ParMultiDo(TimeMonitor)
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:15.222Z: Fusing consumer Counting
element/ParMultiDo(Counting) into Map records to
strings/Map/ParMultiDo(Anonymous)
May 01, 2023 12:42:15 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:15.321Z: Running job using Streaming Engine
May 01, 2023 12:42:17 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:15.703Z: Starting 5 ****s in us-central1-f...
May 01, 2023 12:42:40 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:38.841Z: Your project already contains 100
Dataflow-created metric descriptors, so new user metrics of the form
custom.googleapis.com/* will not be created. However, all user metrics are also
available in the metric dataflow.googleapis.com/job/user_counter. If you rely
on the custom metrics, you can delete old / unused metric descriptors. See
https://developers.google.com/apis-explorer/#p/monitoring/v3/monitoring.projects.metricDescriptors.list
and
https://developers.google.com/apis-explorer/#p/monitoring/v3/monitoring.projects.metricDescriptors.delete
May 01, 2023 12:42:56 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:42:53.496Z: Autoscaling: Raised the number of ****s to
5 so that the pipeline can catch up with its backlog and keep up with its input
rate.
May 01, 2023 12:43:46 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:43:46.424Z: All ****s have finished the startup
processes and began to receive work requests.
May 01, 2023 12:43:49 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2023-05-01T00:43:47.795Z: Workers have started successfully.
May 01, 2023 1:01:23 AM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
WARNING: 2023-05-01T01:01:22.735Z: The ****s of given job are going to be
updated.
May 01, 2023 1:07:00 AM
org.apache.beam.runners.dataflow.DataflowPipelineJob waitUntilFinish
WARNING: No terminal state was returned within allotted timeout. State
value RUNNING
May 01, 2023 1:07:00 AM org.apache.kafka.common.config.AbstractConfig logAll
INFO: AdminClientConfig values:
bootstrap.servers = [34.133.94.65:32404, 34.28.107.158:32405,
34.122.123.226:32406]
client.dns.lookup = default
client.id =
connections.max.idle.ms = 300000
metadata.max.age.ms = 300000
metric.reporters = []
metrics.num.samples = 2
metrics.recording.level = INFO
metrics.sample.window.ms = 30000
receive.buffer.bytes = 65536
reconnect.backoff.max.ms = 1000
reconnect.backoff.ms = 50
request.timeout.ms = 120000
retries = 5
retry.backoff.ms = 100
sasl.client.callback.handler.class = null
sasl.jaas.config = null
sasl.kerberos.kinit.cmd = /usr/bin/kinit
sasl.kerberos.min.time.before.relogin = 60000
sasl.kerberos.service.name = null
sasl.kerberos.ticket.renew.jitter = 0.05
sasl.kerberos.ticket.renew.window.factor = 0.8
sasl.login.callback.handler.class = null
sasl.login.class = null
sasl.login.refresh.buffer.seconds = 300
sasl.login.refresh.min.period.seconds = 60
sasl.login.refresh.window.factor = 0.8
sasl.login.refresh.window.jitter = 0.05
sasl.mechanism = GSSAPI
security.protocol = PLAINTEXT
security.providers = null
send.buffer.bytes = 131072
ssl.cipher.suites = null
ssl.enabled.protocols = [TLSv1.2, TLSv1.1, TLSv1]
ssl.endpoint.identification.algorithm = https
ssl.key.password = null
ssl.keymanager.algorithm = SunX509
ssl.keystore.location = null
ssl.keystore.password = null
ssl.keystore.type = JKS
ssl.protocol = TLS
ssl.provider = null
ssl.secure.random.implementation = null
ssl.trustmanager.algorithm = PKIX
ssl.truststore.location = null
ssl.truststore.password = null
ssl.truststore.type = JKS
May 01, 2023 1:07:00 AM org.apache.kafka.common.utils.AppInfoParser$AppInfo
<init>
INFO: Kafka version: 2.4.1
May 01, 2023 1:07:00 AM org.apache.kafka.common.utils.AppInfoParser$AppInfo
<init>
INFO: Kafka commitId: c57222ae8cd7866b
May 01, 2023 1:07:00 AM org.apache.kafka.common.utils.AppInfoParser$AppInfo
<init>
INFO: Kafka startTimeMs: 1682903220935
Gradle Test Executor 1 finished executing tests.
> Task :sdks:java:io:kafka:integrationTest FAILED
org.apache.beam.sdk.io.kafka.KafkaIOIT >
testKafkaIOReadsAndWritesCorrectlyInStreaming FAILED
java.lang.AssertionError: actual number of records 99439807 smaller than
expected: 100000000.
at org.junit.Assert.fail(Assert.java:89)
at org.junit.Assert.assertTrue(Assert.java:42)
at
org.apache.beam.sdk.io.kafka.KafkaIOIT.testKafkaIOReadsAndWritesCorrectlyInStreaming(KafkaIOIT.java:225)
1 test completed, 1 failed
Finished generating test XML results (0.027 secs) into:
<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/ws/src/sdks/java/io/kafka/build/test-results/integrationTest>
Generating HTML test report...
Finished generating test html results (0.03 secs) into:
<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/ws/src/sdks/java/io/kafka/build/reports/tests/integrationTest>
:sdks:java:io:kafka:integrationTest (Thread[Execution **** Thread 3,5,main])
completed. Took 32 mins 27.158 secs.
Resolve mutations for
:runners:google-cloud-dataflow-java:cleanUpDockerJavaImages (Thread[Execution
**** Thread 6,5,main]) started.
Resolve mutations for
:runners:google-cloud-dataflow-java:cleanUpDockerJavaImages (Thread[Execution
**** Thread 6,5,main]) completed. Took 0.0 secs.
:runners:google-cloud-dataflow-java:cleanUpDockerJavaImages (Thread[Execution
**** Thread 5,5,main]) started.
> Task :runners:google-cloud-dataflow-java:cleanUpDockerJavaImages
Custom actions are attached to task
':runners:google-cloud-dataflow-java:cleanUpDockerJavaImages'.
Caching disabled for task
':runners:google-cloud-dataflow-java:cleanUpDockerJavaImages' because:
Gradle would require more information to cache this task
Task ':runners:google-cloud-dataflow-java:cleanUpDockerJavaImages' is not
up-to-date because:
Task has not declared any outputs despite executing actions.
Starting process 'command 'docker''. Working directory:
<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/ws/src/runners/google-cloud-dataflow-java>
Command: docker rmi --force
us.gcr.io/apache-beam-testing/java-postcommit-it/java:20230501003301
Successfully started process 'command 'docker''
Untagged: us.gcr.io/apache-beam-testing/java-postcommit-it/java:20230501003301
Untagged:
us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:c39b1e91dc5f8b008d796e2bcb64353eec1590ee8dcc8bb7c23ce38ffbc3f1cd
Deleted: sha256:f4b0f22e6e2aad505a1d61e9ada0843ff4551b98a5126bc12ad558716b3a6318
Starting process 'command 'gcloud''. Working directory:
<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/ws/src/runners/google-cloud-dataflow-java>
Command: gcloud --quiet container images untag
us.gcr.io/apache-beam-testing/java-postcommit-it/java:20230501003301
Successfully started process 'command 'gcloud''
WARNING: Successfully resolved tag to sha256, but it is recommended to use
sha256 directly.
Tag: [us.gcr.io/apache-beam-testing/java-postcommit-it/java:20230501003301]
- referencing digest:
[us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:c39b1e91dc5f8b008d796e2bcb64353eec1590ee8dcc8bb7c23ce38ffbc3f1cd]
Deleted [[us.gcr.io/apache-beam-testing/java-postcommit-it/java:20230501003301]
(referencing
[us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:c39b1e91dc5f8b008d796e2bcb64353eec1590ee8dcc8bb7c23ce38ffbc3f1cd])].
Starting process 'command './scripts/cleanup_untagged_gcr_images.sh''. Working
directory:
<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/ws/src/runners/google-cloud-dataflow-java>
Command: ./scripts/cleanup_untagged_gcr_images.sh
us.gcr.io/apache-beam-testing/java-postcommit-it/java
Successfully started process 'command
'./scripts/cleanup_untagged_gcr_images.sh''
Removing untagged image
us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:c39b1e91dc5f8b008d796e2bcb64353eec1590ee8dcc8bb7c23ce38ffbc3f1cd
Digests:
-
us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:c39b1e91dc5f8b008d796e2bcb64353eec1590ee8dcc8bb7c23ce38ffbc3f1cd
Deleted
[us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:c39b1e91dc5f8b008d796e2bcb64353eec1590ee8dcc8bb7c23ce38ffbc3f1cd].
:runners:google-cloud-dataflow-java:cleanUpDockerJavaImages (Thread[Execution
**** Thread 5,5,main]) completed. Took 4.302 secs.
Resolve mutations for :sdks:java:io:kafka:cleanUp (Thread[Execution **** Thread
6,5,main]) started.
Resolve mutations for :sdks:java:io:kafka:cleanUp (Thread[Execution **** Thread
6,5,main]) completed. Took 0.0 secs.
:sdks:java:io:kafka:cleanUp (Thread[included builds,5,main]) started.
> Task :sdks:java:io:kafka:cleanUp
Skipping task ':sdks:java:io:kafka:cleanUp' as it has no actions.
:sdks:java:io:kafka:cleanUp (Thread[included builds,5,main]) completed. Took
0.0 secs.
FAILURE: Build failed with an exception.
* What went wrong:
Execution failed for task ':sdks:java:io:kafka:integrationTest'.
> There were failing tests. See the report at:
> file://<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/ws/src/sdks/java/io/kafka/build/reports/tests/integrationTest/index.html>
* Try:
> Run with --stacktrace option to get the stack trace.
> Run with --debug option to get more log output.
* Get more help at https://help.gradle.org
Deprecated Gradle features were used in this build, making it incompatible with
Gradle 8.0.
You can use '--warning-mode all' to show the individual deprecation warnings
and determine if they come from your own scripts or plugins.
See
https://docs.gradle.org/7.5.1/userguide/command_line_interface.html#sec:command_line_warnings
Execution optimizations have been disabled for 1 invalid unit(s) of work during
this build to ensure correctness.
Please consult deprecation warnings for more details.
BUILD FAILED in 34m 19s
164 actionable tasks: 103 executed, 57 from cache, 4 up-to-date
Build scan background action failed.
java.lang.IllegalArgumentException:
com.gradle.enterprise.gradleplugin.internal.extension.a is not an interface
at java.lang.reflect.Proxy$ProxyClassFactory.apply(Proxy.java:590)
at java.lang.reflect.Proxy$ProxyClassFactory.apply(Proxy.java:557)
at java.lang.reflect.WeakCache$Factory.get(WeakCache.java:230)
at java.lang.reflect.WeakCache.get(WeakCache.java:127)
at java.lang.reflect.Proxy.getProxyClass0(Proxy.java:419)
at java.lang.reflect.Proxy.newProxyInstance(Proxy.java:719)
at
com.gradle.ProxyFactory$ProxyingInvocationHandler.createLocalProxy(ProxyFactory.java:64)
at
com.gradle.ProxyFactory$ProxyingInvocationHandler.lambda$adaptActionArg$1(ProxyFactory.java:59)
at
com.gradle.enterprise.gradleplugin.internal.extension.b$3.run(SourceFile:100)
at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:750)
Publishing build scan...
https://gradle.com/s/r7phaedlobsfs
Build step 'Invoke Gradle script' changed build result to FAILURE
Build step 'Invoke Gradle script' marked build as failure
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
