See 
<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/4125/display/redirect?page=changes>

Changes:

[noreply] Add no-cache-dir to tox install (#29024)


------------------------------------------
[...truncated 1.02 MB...]
    WARNING: 2023-10-17T01:15:39.877Z: 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: 
kafkaioit0testkafkaioreadsandwritescorrectlyinbatch-jenkin-ttbe. 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
    Oct 17, 2023 1:15:52 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:50.739Z: Worker configuration: e2-standard-2 in 
us-central1-b.
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.358Z: Expanding CoGroupByKey operations into 
optimizable parts.
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.507Z: Expanding GroupByKey operations into 
optimizable parts.
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.534Z: Lifting ValueCombiningMappingFns into 
MergeBucketsMappingFns
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.691Z: Fusing adjacent ParDo, Read, Write, and 
Flatten operations
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.723Z: Elided trivial flatten 
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.753Z: Unzipping flatten s26 for input 
s23.org.apache.beam.sdk.values.PCollection.<init>:397#f8b74da6be94df5a
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.779Z: Fusing unzipped copy of 
PAssert$0/GroupGlobally/WithKeys/AddKeys/Map, through flatten 
PAssert$0/GroupGlobally/Flatten.PCollections, into producer 
PAssert$0/GroupGlobally/ParDo(ToSingletonIterables)
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.805Z: Fusing consumer 
PAssert$0/GroupGlobally/GroupByKey/Write into 
PAssert$0/GroupGlobally/GroupByKey/Reify
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.827Z: Fusing consumer 
PAssert$0/GroupGlobally/GroupByKey/GroupByWindow into 
PAssert$0/GroupGlobally/GroupByKey/Read
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.858Z: Fusing consumer 
PAssert$0/GroupGlobally/Values/Values/Map into 
PAssert$0/GroupGlobally/GroupByKey/GroupByWindow
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.888Z: Fusing consumer 
PAssert$0/GroupGlobally/ParDo(Concat) into 
PAssert$0/GroupGlobally/Values/Values/Map
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.917Z: Fusing consumer PAssert$0/GetPane/Map into 
PAssert$0/GroupGlobally/ParDo(Concat)
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.943Z: Fusing consumer PAssert$0/RunChecks into 
PAssert$0/GetPane/Map
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.966Z: Fusing consumer 
PAssert$0/VerifyAssertions/ParDo(DefaultConclude) into PAssert$0/RunChecks
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:52.996Z: Unzipping flatten s26-u40 for input 
s28.org.apache.beam.sdk.values.PCollection.<init>:397#dabfabce15317cd8-c38
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.026Z: Fusing unzipped copy of 
PAssert$0/GroupGlobally/GroupByKey/Reify, through flatten 
PAssert$0/GroupGlobally/Flatten.PCollections/Unzipped-1, into producer 
PAssert$0/GroupGlobally/WithKeys/AddKeys/Map
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.056Z: Unzipping flatten s21 for input 
s15.org.apache.beam.sdk.values.PCollection.<init>:397#bbafda9391edc490
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.085Z: Fusing unzipped copy of 
PAssert$0/GroupGlobally/Reify.Window/ParDo(Anonymous), through flatten Counting 
element/Flatten.PCollections, into producer Counting element/Values/Values/Map
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.111Z: Unzipping flatten s21-u49 for input 
s22.org.apache.beam.sdk.values.PCollection.<init>:397#dbfeca6deeafacc8-c47
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.141Z: Fusing unzipped copy of 
PAssert$0/GroupGlobally/ParDo(ToSingletonIterables), through flatten Counting 
element/Flatten.PCollections/Unzipped-1, into producer 
PAssert$0/GroupGlobally/Reify.Window/ParDo(Anonymous)
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.177Z: Fusing consumer 
PAssert$0/GroupGlobally/GroupByKey/Reify into 
PAssert$0/GroupGlobally/WithKeys/AddKeys/Map
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.209Z: Fusing consumer Counting 
element/View.AsIterable/ParDo(ToIsmRecordForGlobalWindow) into Counting 
element/Values/Values/Map
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.244Z: Fusing consumer 
PAssert$0/GroupGlobally/WithKeys/AddKeys/Map into 
PAssert$0/GroupGlobally/Create.Values/MapElements/Map
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.285Z: Fusing consumer 
PAssert$0/GroupGlobally/Reify.Window/ParDo(Anonymous) into Counting 
element/ProduceDefault
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.312Z: Fusing consumer 
PAssert$0/GroupGlobally/ParDo(ToSingletonIterables) into 
PAssert$0/GroupGlobally/Reify.Window/ParDo(Anonymous)
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.341Z: Fusing consumer Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Create/MapElements/Map
 into Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Create/Impulse
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.362Z: Fusing consumer Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Split 
into Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Create/MapElements/Map
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.389Z: Fusing consumer Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Pair
 with random key into Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Split
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.413Z: Fusing consumer Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/Window.Into()/Window.Assign
 into Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Pair
 with random key
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.436Z: Fusing consumer Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Reify
 into Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/Window.Into()/Window.Assign
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.458Z: Fusing consumer Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Write
 into Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Reify
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.486Z: Fusing consumer Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/GroupByWindow
 into Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Read
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.511Z: Fusing consumer Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/ExpandIterable
 into Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/GroupByWindow
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.538Z: Fusing consumer Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Values/Values/Map
 into Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/ExpandIterable
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.563Z: Fusing consumer Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Read 
into Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Values/Values/Map
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.594Z: Fusing consumer Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/StripIds
 into Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Read
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.628Z: Fusing consumer Measure read time into Read 
from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/StripIds
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.655Z: Fusing consumer Counting 
element/WithKeys/AddKeys/Map into Measure read time
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.681Z: Fusing consumer Counting 
element/Combine.perKey(Count)/GroupByKey+Counting 
element/Combine.perKey(Count)/Combine.GroupedValues/Partial into Counting 
element/WithKeys/AddKeys/Map
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.706Z: Fusing consumer Counting 
element/Combine.perKey(Count)/GroupByKey/Reify into Counting 
element/Combine.perKey(Count)/GroupByKey+Counting 
element/Combine.perKey(Count)/Combine.GroupedValues/Partial
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.733Z: Fusing consumer Counting 
element/Combine.perKey(Count)/GroupByKey/Write into Counting 
element/Combine.perKey(Count)/GroupByKey/Reify
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.763Z: Fusing consumer Counting 
element/Combine.perKey(Count)/Combine.GroupedValues into Counting 
element/Combine.perKey(Count)/GroupByKey/Read
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.784Z: Fusing consumer Counting 
element/Combine.perKey(Count)/Combine.GroupedValues/Extract into Counting 
element/Combine.perKey(Count)/Combine.GroupedValues
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.820Z: Fusing consumer Counting 
element/Values/Values/Map into Counting 
element/Combine.perKey(Count)/Combine.GroupedValues/Extract
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.850Z: Fusing consumer Counting 
element/CreateVoid/MapElements/Map into Counting element/CreateVoid/Impulse
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.878Z: Fusing consumer Counting 
element/ProduceDefault into Counting element/CreateVoid/MapElements/Map
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:53.905Z: Fusing consumer 
PAssert$0/GroupGlobally/Create.Values/MapElements/Map into 
PAssert$0/GroupGlobally/Create.Values/Impulse
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:54.343Z: Executing operation Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Create
    Oct 17, 2023 1:15:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:54.453Z: Starting 5 ****s in us-central1-b...
    Oct 17, 2023 1:15:56 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:15:54.990Z: Finished operation Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Create
    Oct 17, 2023 1:16:04 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:16:03.689Z: Executing operation Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Create/Impulse+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Create/MapElements/Map+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Split+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Pair
 with random key+Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/Window.Into()/Window.Assign+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Reify+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Write
    Oct 17, 2023 1:16:07 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:16:06.429Z: 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
    Oct 17, 2023 1:16:44 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:16:43.974Z: Autoscaling: Raised the number of ****s to 
3 based on the rate of progress in the currently running stage(s).
    Oct 17, 2023 1:16:44 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:16:44.027Z: Autoscaling: Resized **** pool to 3, though 
goal was 5.  This could be a quota issue.
    Oct 17, 2023 1:16:54 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:16:53.407Z: Autoscaling: Raised the number of ****s to 
5 based on the rate of progress in the currently running stage(s).
    Oct 17, 2023 1:17:19 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:17:18.352Z: Workers have started successfully.
    Oct 17, 2023 1:17:40 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:17:38.735Z: All ****s have finished the startup 
processes and began to receive work requests.
    Oct 17, 2023 1:18:40 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    SEVERE: 2023-10-17T01:18:40.674Z: 
org.apache.kafka.common.errors.TimeoutException: Timeout expired while fetching 
topic metadata

    Oct 17, 2023 1:19:42 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    SEVERE: 2023-10-17T01:19:40.935Z: 
org.apache.kafka.common.errors.TimeoutException: Timeout expired while fetching 
topic metadata

    Oct 17, 2023 1:20:41 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    SEVERE: 2023-10-17T01:20:41.036Z: 
org.apache.kafka.common.errors.TimeoutException: Timeout expired while fetching 
topic metadata

    Oct 17, 2023 1:21:42 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    SEVERE: 2023-10-17T01:21:41.119Z: 
org.apache.kafka.common.errors.TimeoutException: Timeout expired while fetching 
topic metadata

    Oct 17, 2023 1:21:42 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:21:41.184Z: Finished operation Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Create/Impulse+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Create/MapElements/Map+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Split+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Pair
 with random key+Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/Window.Into()/Window.Assign+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Reify+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Write
    Oct 17, 2023 1:21:42 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    SEVERE: 2023-10-17T01:21:41.312Z: Workflow failed. Causes: S02:Read from 
bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Create/Impulse+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Create/MapElements/Map+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Split+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Pair
 with random key+Read from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/Window.Into()/Window.Assign+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Reify+Read
 from bounded 
Kafka/KafkaIO.Read.ReadFromKafkaViaUnbounded/Read(KafkaUnboundedSource)/Reshuffle/Reshuffle/GroupByKey/Write
 failed., The job failed because a work item has failed 4 times. Look in 
previous log entries for the cause of each one of the 4 failures. If the logs 
only contain generic timeout errors related to accessing external resources, 
such as MongoDB, verify that the **** service account has permission to access 
the resource's subnetwork. For more information, see 
https://cloud.google.com/dataflow/docs/guides/common-errors. The work item was 
attempted on these ****s: 

          Root cause: Work item failed.
          Worker ID: kafkaioit0testkafkaioread-10161815-cppz-harness-j20n,

          Root cause: Work item failed.
          Worker ID: kafkaioit0testkafkaioread-10161815-cppz-harness-j20n,

          Root cause: Work item failed.
          Worker ID: kafkaioit0testkafkaioread-10161815-cppz-harness-j20n,

          Root cause: Work item failed.
          Worker ID: kafkaioit0testkafkaioread-10161815-cppz-harness-j20n
    Oct 17, 2023 1:21:42 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:21:41.384Z: Cleaning up.
    Oct 17, 2023 1:21:42 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:21:41.492Z: Stopping **** pool...
    Oct 17, 2023 1:24:03 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:24:02.474Z: Autoscaling: Resized **** pool from 5 to 0.
    Oct 17, 2023 1:24:03 AM 
org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process
    INFO: 2023-10-17T01:24:02.540Z: Worker pool stopped.
    Oct 17, 2023 1:24:40 AM 
org.apache.beam.runners.dataflow.DataflowPipelineJob logTerminalState
    INFO: Job 2023-10-16_18_15_37-78598075644436868 failed with status FAILED.
    Oct 17, 2023 1:24:40 AM org.apache.kafka.common.config.AbstractConfig logAll
    INFO: AdminClientConfig values: 
        bootstrap.servers = [104.154.191.159:32404, 34.70.1.199:32405, 
34.136.68.116: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

    Oct 17, 2023 1:24:40 AM org.apache.kafka.common.utils.AppInfoParser$AppInfo 
<init>
    INFO: Kafka version: 2.4.1
    Oct 17, 2023 1:24:40 AM org.apache.kafka.common.utils.AppInfoParser$AppInfo 
<init>
    INFO: Kafka commitId: c57222ae8cd7866b
    Oct 17, 2023 1:24:40 AM org.apache.kafka.common.utils.AppInfoParser$AppInfo 
<init>
    INFO: Kafka startTimeMs: 1697505880374

Gradle Test Executor 1 finished executing tests.

> Task :sdks:java:io:kafka:integrationTest FAILED

org.apache.beam.sdk.io.kafka.KafkaIOIT > 
testKafkaIOReadsAndWritesCorrectlyInBatch FAILED
    java.lang.AssertionError: Values should be different. Actual: FAILED
        at org.junit.Assert.fail(Assert.java:89)
        at org.junit.Assert.failEquals(Assert.java:187)
        at org.junit.Assert.assertNotEquals(Assert.java:163)
        at org.junit.Assert.assertNotEquals(Assert.java:177)
        at 
org.apache.beam.sdk.io.kafka.KafkaIOIT.testKafkaIOReadsAndWritesCorrectlyInBatch(KafkaIOIT.java:260)

1 test completed, 1 failed
Finished generating test XML results (0.026 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.038 secs) into: 
<https://ci-beam.apache.org/job/beam_PerformanceTests_Kafka_IO/ws/src/sdks/java/io/kafka/build/reports/tests/integrationTest>

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>

Deprecated Gradle features were used in this build, making it incompatible with 
Gradle 9.0.

You can use '--warning-mode all' to show the individual deprecation warnings 
and determine if they come from your own scripts or plugins.

For more on this, please refer to 
https://docs.gradle.org/8.3/userguide/command_line_interface.html#sec:command_line_warnings
 in the Gradle documentation.

BUILD FAILED in 17m 55s
143 actionable tasks: 1 executed, 142 up-to-date

Publishing build scan...
https://ge.apache.org/s/zyiqw263mpkfc

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]

Reply via email to