See
<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/3504/display/redirect>
Changes:
------------------------------------------
[...truncated 907.97 KB...]
enable.auto.commit = false
exclude.internal.topics = true
fetch.max.bytes = 52428800
fetch.max.wait.ms = 500
fetch.min.bytes = 1
group.id = null
group.instance.id = null
heartbeat.interval.ms = 3000
interceptor.classes = []
internal.leave.group.on.close = true
isolation.level = read_uncommitted
key.deserializer = class
org.apache.kafka.common.serialization.ByteArrayDeserializer
max.partition.fetch.bytes = 1048576
max.poll.interval.ms = 300000
max.poll.records = 500
metadata.max.age.ms = 300000
metric.reporters = []
metrics.num.samples = 2
metrics.recording.level = INFO
metrics.sample.window.ms = 30000
partition.assignment.strategy = [class
org.apache.kafka.clients.consumer.RangeAssignor]
receive.buffer.bytes = 524288
reconnect.backoff.max.ms = 1000
reconnect.backoff.ms = 50
request.timeout.ms = 30000
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
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
Dec 27, 2022 12:40:10 PM
org.apache.kafka.common.utils.AppInfoParser$AppInfo <init>
INFO: Kafka version: 2.4.1
Dec 27, 2022 12:40:10 PM
org.apache.kafka.common.utils.AppInfoParser$AppInfo <init>
INFO: Kafka commitId: c57222ae8cd7866b
Dec 27, 2022 12:40:10 PM
org.apache.kafka.common.utils.AppInfoParser$AppInfo <init>
INFO: Kafka startTimeMs: 1672144810991
Dec 27, 2022 12:40:11 PM org.apache.kafka.clients.Metadata update
INFO: [Consumer clientId=consumer-1, groupId=null] Cluster ID:
WFrMlmQHTVOFtqDQ5awkdQ
Dec 27, 2022 12:40:11 PM org.apache.beam.sdk.io.kafka.KafkaUnboundedSource
split
INFO: Partitions assigned to split 0 (total 1): beam-sdf-0
Dec 27, 2022 12:40:11 PM
org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep
INFO: Adding Read from unbounded
Kafka/KafkaIO.Read.ReadFromKafkaViaSDF/Read(KafkaUnboundedSource)/StripIds as
step s2
Dec 27, 2022 12:40:11 PM
org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep
INFO: Adding Measure read time as step s3
Dec 27, 2022 12:40:11 PM
org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep
INFO: Adding Map records to strings/Map as step s4
Dec 27, 2022 12:40:11 PM
org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep
INFO: Adding Counting element as step s5
Dec 27, 2022 12:40:11 PM org.apache.beam.runners.dataflow.DataflowRunner run
INFO: Dataflow SDK version: 2.45.0-SNAPSHOT
Dec 27, 2022 12:40:12 PM 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/2022-12-27_04_40_11-2741143938988808713?project=apache-beam-testing
Dec 27, 2022 12:40:12 PM org.apache.beam.runners.dataflow.DataflowRunner run
INFO: Submitted job: 2022-12-27_04_40_11-2741143938988808713
Dec 27, 2022 12:40:12 PM 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 2022-12-27_04_40_11-2741143938988808713
Dec 27, 2022 12:40:17 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
WARNING: 2022-12-27T12:40:16.552Z: 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-7nly. 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
Dec 27, 2022 12:40:31 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:30.798Z: Worker configuration: e2-standard-2 in
us-central1-a.
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.342Z: Expanding SplittableParDo operations into
optimizable parts.
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.475Z: Expanding CollectionToSingleton operations
into optimizable parts.
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.527Z: Expanding CoGroupByKey operations into
optimizable parts.
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.580Z: Expanding SplittableProcessKeyed operations
into optimizable parts.
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.642Z: Expanding GroupByKey operations into
streaming Read/Write steps
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.707Z: Lifting ValueCombiningMappingFns into
MergeBucketsMappingFns
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.781Z: Fusing adjacent ParDo, Read, Write, and
Flatten operations
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.805Z: Fusing consumer Read from unbounded
Kafka/KafkaIO.Read.ReadFromKafkaViaSDF/ParDo(GenerateKafkaSourceDescriptor)/ParMultiDo(GenerateKafkaSourceDescriptor)
into Read from unbounded Kafka/KafkaIO.Read.ReadFromKafkaViaSDF/Impulse
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.837Z: 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)
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.858Z: 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
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.880Z: 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
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.903Z: Fusing consumer Measure read
time/ParMultiDo(TimeMonitor) into Read from unbounded
Kafka/KafkaIO.Read.ReadFromKafkaViaSDF/KafkaIO.ReadSourceDescriptors/MapElements/Map/ParMultiDo(Anonymous)
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.922Z: Fusing consumer Map records to
strings/Map/ParMultiDo(Anonymous) into Measure read time/ParMultiDo(TimeMonitor)
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:32.944Z: Fusing consumer Counting
element/ParMultiDo(Counting) into Map records to
strings/Map/ParMultiDo(Anonymous)
Dec 27, 2022 12:40:34 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:33.017Z: Running job using Streaming Engine
Dec 27, 2022 12:40:35 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:34.244Z: Starting 5 ****s in us-central1-a...
Dec 27, 2022 12:40:41 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:40:40.771Z: 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
Dec 27, 2022 12:41:21 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:41:19.778Z: 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.
Dec 27, 2022 12:42:30 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:42:29.495Z: Workers have started successfully.
Dec 27, 2022 12:42:30 PM
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
INFO: 2022-12-27T12:42:30.233Z: All ****s have finished the startup
processes and began to receive work requests.
Dec 27, 2022 12:55:12 PM
org.apache.beam.runners.dataflow.DataflowPipelineJob waitUntilFinish
WARNING: No terminal state was returned within allotted timeout. State
value RUNNING
org.apache.beam.sdk.io.kafka.KafkaIOIT >
testKafkaIOReadsAndWritesCorrectlyInStreaming STANDARD_OUT
Load test results for test (ID): 898ae618-accb-4f8d-85b5-80a1632601a1 and
timestamp: 2022-12-27T12:34:57.590000000Z:
Metric: Value:
read_time 3.996
write_time 12.831
run_time 16.826999999999998
Gradle Test Executor 1 finished executing tests.
> Task :sdks:java:io:kafka:integrationTest
Finished generating test XML results (0.021 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.029 secs) into:
<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/ws/src/sdks/java/io/kafka/build/reports/tests/integrationTest>
Invalidating in-memory cache of
/home/jenkins/.gradle/caches/journal-1/file-access.bin
Stored cache entry for task ':sdks:java:io:kafka:integrationTest' with cache
key 5064c6aabd719ab144c354ec423132a1
:sdks:java:io:kafka:integrationTest (Thread[included builds,5,main]) completed.
Took 20 mins 17.049 secs.
Resolve mutations for
:runners:google-cloud-dataflow-java:cleanUpDockerJavaImages (Thread[Execution
**** Thread 4,5,main]) started.
Resolve mutations for
:runners:google-cloud-dataflow-java:cleanUpDockerJavaImages (Thread[Execution
**** Thread 4,5,main]) completed. Took 0.0 secs.
:runners:google-cloud-dataflow-java:cleanUpDockerJavaImages (Thread[Execution
****,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:20221227123404
Successfully started process 'command 'docker''
Untagged: us.gcr.io/apache-beam-testing/java-postcommit-it/java:20221227123404
Untagged:
us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:17f03814188d4586f23f38d281247af5fe5f8eb425d252ad1c6b6f1fce5fe534
Deleted: sha256:02b682b4d3e6207e644c33c34d772adc594c98abc3883d986f6b97790731fd1a
Deleted: sha256:574465bc80535a6a688d058219036cb3a4f22e6ff4f22630147ecefa996123a7
Deleted: sha256:a4ecf315f7e1fbe8a91f35b4f13d571582e097618abc5eaa1c52d3156b1d6d9e
Deleted: sha256:a6e82211530ae9a7966df8224a98b616d425c388398fbb87537e445fe9660b74
Deleted: sha256:3e150f762aebe8746bd511b2ff2ec739c61749451f7700bfbd12eb978df136c1
Deleted: sha256:aedf23455cfbbfd0fe36c5ac6f298eeff6d60cf178026150364aeb0477f1843e
Deleted: sha256:91a70503204b28b6dbdc1e846cfc0c24e102afcbed82eedae8a2e2fcf57db326
Deleted: sha256:1018605c904c772077f58d502329ce9f4e301cb7abd095974e466d641be067e0
Deleted: sha256:c6d9c6a5e042572b8b3b301a613b0d0452eed6c46e4a21dee719c02f7433e3ee
Deleted: sha256:cf9899f7dd52fba17db6bc379e0bf385474d0b69f42f92a9a3602a2556c5c8e3
Deleted: sha256:98db87a28762edee0faf8471d8572f659dcbdd7bd5f15fd5207a271d79163803
Deleted: sha256:4f2741a51e3e310fb7e9de357ae22eca8aa6764d8470282701722ffa88c25808
Deleted: sha256:7aa25d4e0836dd0a46efa735cec1a0af0f452133b0d59799baf3b3b6133b45b2
Deleted: sha256:8ec1a1535eaf53409112160b0ddd81a9c6a19bb6a5d14508d37836fca6082f1b
Deleted: sha256:1e8aa21d74d8197b3e97ecf0ea63773e460d0c2bbeff28e9775daf2b5e13c079
Deleted: sha256:32155d1f64e8af1aca7279ea0663b867e788c865e60affa50b0b86e6dfdb5e02
Deleted: sha256:a9938fffa3433e03a72c9c7ec61b6e647919367f3d98d341887526193aae5d66
Deleted: sha256:e36f4d16a89cbc56ec90596cca304cf1491999d8174e63e1f825cc1ec49b1ee6
Deleted: sha256:481e9ce4bb014be40309c8a0b1f414fae82847028fa534b96679dc2f14cfc3fc
Deleted: sha256:a361a327603780533ff3453e7f90c3b3f17777a0c5fb0ec537e0bba4933d4e8c
Deleted: sha256:3f014513090c6c85404259772a5d743036335b701b34a7d8e37dbaf6df517ec0
Deleted: sha256:f840e6c3c32999941a4634eac4b50ac9cec6fda6a2cf87c9f029635b8e3468d5
Deleted: sha256:f411bb4fec731851ff637903e3e5c31b0b0eded29989429443a2ada281d082a7
Deleted: sha256:b8497be69c4b7f8ed2ea66f146c14c53cdf9a12d5f25c76f5939270fe8596c39
Deleted: sha256:80282c8043665358e957c3f35cb2710bcaf223447a4053fc428278f8166f76e9
Deleted: sha256:ea2b9138ce7745dae3c1933c444403562c1db2d589ba8538e75d49705253b35c
Deleted: sha256:85f1f4d328ae3cc02ae931625a28726dd60123ae28fcc08effc4d46be28e2dd0
Deleted: sha256:3d43f609c1985ccb61d346b375dcd89d72db49bce22ab05c233fbb618242a6a5
Deleted: sha256:ef60832d0ce479acd6ac173282c295504863c1a3576a3da2eb836fea0ee16cdd
Deleted: sha256:1a51003e30813debc88cff69609be216f51094975f373e258c04d2f5c43fe4e3
Deleted: sha256:f710d3f28238d039e77f1dd208e2f149b26f15cf3a379db9be77afbcfc8ba9b4
Deleted: sha256:b5ce49f599a1086a21b6187d259953b8cc831a74130f9c62e4cb3a6b6e523e4a
Deleted: sha256:955a4ab94d88f2e00c09c3be0f04659bf7dee652aa4c9d038e576c6eb105f4a3
Deleted: sha256:87705fc2427099c4aab82d4ec6ea03605c3e385c46fc157c21689a5f3694cef5
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:20221227123404
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:20221227123404]
- referencing digest:
[us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:17f03814188d4586f23f38d281247af5fe5f8eb425d252ad1c6b6f1fce5fe534]
Deleted [[us.gcr.io/apache-beam-testing/java-postcommit-it/java:20221227123404]
(referencing
[us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:17f03814188d4586f23f38d281247af5fe5f8eb425d252ad1c6b6f1fce5fe534])].
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:b554aa95d04f6fe040e2ce2b1766e62b36af5a98e0ec4e4a1f2b736feb9c7b5f
Digests:
-
us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:b554aa95d04f6fe040e2ce2b1766e62b36af5a98e0ec4e4a1f2b736feb9c7b5f
ERROR: (gcloud.container.images.delete) Not found: response:
{'docker-distribution-api-version': 'registry/2.0', 'content-type':
'application/json', 'content-encoding': 'gzip', 'date': 'Tue, 27 Dec 2022
12:55:17 GMT', 'server': 'Docker Registry', 'cache-control': 'private',
'x-xss-protection': '0', 'x-frame-options': 'SAMEORIGIN', 'transfer-encoding':
'chunked', 'status': 404}
Failed to compute blob liveness for manifest:
'sha256:b554aa95d04f6fe040e2ce2b1766e62b36af5a98e0ec4e4a1f2b736feb9c7b5f': None
> Task :runners:google-cloud-dataflow-java:cleanUpDockerJavaImages FAILED
:runners:google-cloud-dataflow-java:cleanUpDockerJavaImages (Thread[Execution
****,5,main]) completed. Took 4.736 secs.
FAILURE: Build failed with an exception.
* Where:
Build file
'<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/ws/src/runners/google-cloud-dataflow-java/build.gradle'>
line: 305
* What went wrong:
Execution failed for task
':runners:google-cloud-dataflow-java:cleanUpDockerJavaImages'.
> Process 'command './scripts/cleanup_untagged_gcr_images.sh'' finished with
> non-zero exit value 1
* 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 21m 28s
156 actionable tasks: 97 executed, 55 from cache, 4 up-to-date
Publishing build scan...
https://gradle.com/s/mqax6y5t6jlsa
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]
