See <https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/641/display/redirect?page=changes>
Changes: [sychen] Add a BQ option for configuring buffering duration when auto-sharding is [suztomo] [BEAM-11010] Upgrading google-cloud-pubsublite to 0.13.2 [suztomo] [BEAM-11010] Copying SubscriberOptions from pubsublite repo [suztomo] [BEAM-11010] Declaring flogger-system-backend to avoid conflicts [Kyle Weaver] [BEAM-12194] Enable SqlTransform::registerUdaf in ZetaSQL. [Kyle Weaver] [BEAM-12194] Code style changes from review. [Boyuan Zhang] [BEAM-12114] Dataflow should apply KAFKA_READ_OVERRIDE when it's not [noreply] Make sdk/worker_harness_container_image fully backwards compatible ------------------------------------------ [...truncated 2.51 MB...] type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)> INFO:apache_beam.runners.dataflow.internal.apiclient:Created job with id: [2021-04-21_18_08_03-14441784189528571449] INFO:apache_beam.runners.dataflow.internal.apiclient:Submitted job: 2021-04-21_18_08_03-14441784189528571449 INFO:apache_beam.runners.dataflow.internal.apiclient:To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobs/us-central1/2021-04-21_18_08_03-14441784189528571449?project=apache-beam-testing INFO:apache_beam.runners.dataflow.dataflow_runner:Job 2021-04-21_17_59_30-14308531980156311397 is in state JOB_STATE_DONE INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:11.638Z: JOB_MESSAGE_BASIC: Finished operation external_1SqlTransform-beam-external-java-sql-v1--BeamValuesRel_15-Create-Values-Read-CreateSource--ParDo-Boun/ProcessElementAndRestrictionWithSizing+SqlTransform(beam:external:java:sql:v1)/BeamCalcRel_19/ParDo(Calc)/ParMultiDo(Calc)+assert_that/WindowInto(WindowIntoFn)+assert_that/ToVoidKey+assert_that/Group/pair_with_1+assert_that/Group/Flatten/OutputIdentity+assert_that/Group/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:Job 2021-04-21_18_08_03-14441784189528571449 is in state JOB_STATE_RUNNING INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:14.714Z: JOB_MESSAGE_BASIC: Finished operation assert_that/Create/Impulse+assert_that/Create/FlatMap(<lambda at core.py:2955>)+assert_that/Create/Map(decode)+assert_that/Group/pair_with_0+assert_that/Group/Flatten/OutputIdentity+assert_that/Group/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:14.794Z: JOB_MESSAGE_BASIC: Executing operation assert_that/Group/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:14.842Z: JOB_MESSAGE_BASIC: Finished operation assert_that/Group/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:14.881Z: JOB_MESSAGE_BASIC: Executing operation assert_that/Group/GroupByKey/Read+assert_that/Group/Map(_merge_tagged_vals_under_key)+assert_that/Unkey+assert_that/Match INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:06.520Z: JOB_MESSAGE_DETAILED: Autoscaling is enabled for job 2021-04-21_18_08_03-14441784189528571449. The number of workers will be between 1 and 1000. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:06.638Z: JOB_MESSAGE_DETAILED: Autoscaling was automatically enabled for job 2021-04-21_18_08_03-14441784189528571449. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:08.669Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-f. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.330Z: JOB_MESSAGE_DETAILED: Expanding SplittableParDo operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.371Z: JOB_MESSAGE_DETAILED: Expanding CollectionToSingleton operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.421Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.447Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step assert_that/Group/GroupByKey: GroupByKey not followed by a combiner. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.484Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.517Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.556Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.585Z: JOB_MESSAGE_DEBUG: Inserted coder converter after flatten ref_AppliedPTransform_assert_that-Group-Flatten_14 INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.641Z: JOB_MESSAGE_DETAILED: Unzipping flatten ref_AppliedPTransform_assert_that-Group-Flatten_14 for input ref_AppliedPTransform_assert_that-Group-pair_with_0_12.None INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.675Z: JOB_MESSAGE_DETAILED: Fusing unzipped copy of assert_that/Group/Flatten/OutputIdentity, through flatten assert_that/Group/Flatten, into producer assert_that/Group/pair_with_0 INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.703Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Group/Map(_merge_tagged_vals_under_key) into assert_that/Group/GroupByKey/Read INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.728Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Unkey into assert_that/Group/Map(_merge_tagged_vals_under_key) INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.772Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Match into assert_that/Unkey INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.805Z: JOB_MESSAGE_DETAILED: Unzipping flatten ref_AppliedPTransform_assert_that-Group-Flatten_14-u17 for input ref_AppliedPTransform_assert_that-Group-Flatten_14.None-c15 INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.851Z: JOB_MESSAGE_DETAILED: Fusing unzipped copy of assert_that/Group/GroupByKey/Write, through flatten assert_that/Group/Flatten/Unzipped-1, into producer assert_that/Group/Flatten/OutputIdentity INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.886Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Group/Flatten/OutputIdentity into assert_that/Group/pair_with_1 INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.911Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Group/GroupByKey/Write into assert_that/Group/Flatten/OutputIdentity INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.944Z: JOB_MESSAGE_DETAILED: Fusing consumer SqlTransform(beam:external:java:sql:v1)/BeamValuesRel_13/Create.Values/Read(CreateSource)/ParDo(OutputSingleSource)/ParMultiDo(OutputSingleSource) into SqlTransform(beam:external:java:sql:v1)/BeamValuesRel_13/Create.Values/Read(CreateSource)/Impulse INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.966Z: JOB_MESSAGE_DETAILED: Fusing consumer external_2SqlTransform-beam-external-java-sql-v1--BeamValuesRel_13-Create-Values-Read-CreateSource--ParDo-Boun/PairWithRestriction into SqlTransform(beam:external:java:sql:v1)/BeamValuesRel_13/Create.Values/Read(CreateSource)/ParDo(OutputSingleSource)/ParMultiDo(OutputSingleSource) INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:09.990Z: JOB_MESSAGE_DETAILED: Fusing consumer external_2SqlTransform-beam-external-java-sql-v1--BeamValuesRel_13-Create-Values-Read-CreateSource--ParDo-Boun/SplitWithSizing into external_2SqlTransform-beam-external-java-sql-v1--BeamValuesRel_13-Create-Values-Read-CreateSource--ParDo-Boun/PairWithRestriction INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.016Z: JOB_MESSAGE_DETAILED: Fusing consumer SqlTransform(beam:external:java:sql:v1)/BeamZetaSqlCalcRel_17/ParDo(Calc)/ParMultiDo(Calc) into external_2SqlTransform-beam-external-java-sql-v1--BeamValuesRel_13-Create-Values-Read-CreateSource--ParDo-Boun/ProcessElementAndRestrictionWithSizing INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.044Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/WindowInto(WindowIntoFn) into SqlTransform(beam:external:java:sql:v1)/BeamZetaSqlCalcRel_17/ParDo(Calc)/ParMultiDo(Calc) INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.077Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Create/FlatMap(<lambda at core.py:2955>) into assert_that/Create/Impulse INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.126Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Create/Map(decode) into assert_that/Create/FlatMap(<lambda at core.py:2955>) INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.176Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Group/pair_with_0 into assert_that/Create/Map(decode) INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.210Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/ToVoidKey into assert_that/WindowInto(WindowIntoFn) INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.238Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Group/pair_with_1 into assert_that/ToVoidKey INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.262Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.293Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.333Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.363Z: JOB_MESSAGE_DEBUG: Assigning stage ids. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.481Z: JOB_MESSAGE_DEBUG: Executing wait step start26 INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.622Z: JOB_MESSAGE_BASIC: Executing operation SqlTransform(beam:external:java:sql:v1)/BeamValuesRel_13/Create.Values/Read(CreateSource)/Impulse+SqlTransform(beam:external:java:sql:v1)/BeamValuesRel_13/Create.Values/Read(CreateSource)/ParDo(OutputSingleSource)/ParMultiDo(OutputSingleSource)+external_2SqlTransform-beam-external-java-sql-v1--BeamValuesRel_13-Create-Values-Read-CreateSource--ParDo-Boun/PairWithRestriction+external_2SqlTransform-beam-external-java-sql-v1--BeamValuesRel_13-Create-Values-Read-CreateSource--ParDo-Boun/SplitWithSizing INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.649Z: JOB_MESSAGE_BASIC: Executing operation assert_that/Group/GroupByKey/Create INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.693Z: JOB_MESSAGE_DEBUG: Starting worker pool setup. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.731Z: JOB_MESSAGE_BASIC: Starting 1 workers in us-central1-f... INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.789Z: JOB_MESSAGE_BASIC: Finished operation assert_that/Group/GroupByKey/Create INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.852Z: JOB_MESSAGE_DEBUG: Value "assert_that/Group/GroupByKey/Session" materialized. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:10.916Z: JOB_MESSAGE_BASIC: Executing operation assert_that/Create/Impulse+assert_that/Create/FlatMap(<lambda at core.py:2955>)+assert_that/Create/Map(decode)+assert_that/Group/pair_with_0+assert_that/Group/Flatten/OutputIdentity+assert_that/Group/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:23.987Z: JOB_MESSAGE_BASIC: Finished operation assert_that/Group/GroupByKey/Read+assert_that/Group/Map(_merge_tagged_vals_under_key)+assert_that/Unkey+assert_that/Match INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:24.059Z: JOB_MESSAGE_DEBUG: Executing success step success24 INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:24.124Z: JOB_MESSAGE_DETAILED: Cleaning up. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:24.167Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:24.187Z: JOB_MESSAGE_BASIC: Stopping worker pool... INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:26.703Z: JOB_MESSAGE_BASIC: 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 INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:08:53.988Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 1 based on the rate of progress in the currently running stage(s). INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:13.868Z: JOB_MESSAGE_DETAILED: Autoscaling: Resized worker pool from 1 to 0. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:13.904Z: JOB_MESSAGE_BASIC: Worker pool stopped. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:13.928Z: JOB_MESSAGE_DEBUG: Tearing down pending resources... INFO:apache_beam.runners.dataflow.dataflow_runner:Job 2021-04-21_17_59_29-5320191862812196202 is in state JOB_STATE_DONE INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:24.815Z: JOB_MESSAGE_DETAILED: Workers have started successfully. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:24.868Z: JOB_MESSAGE_DETAILED: Workers have started successfully. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:33.101Z: JOB_MESSAGE_BASIC: Finished operation Create simple/Impulse+Create simple/FlatMap(<lambda at core.py:2955>)+Create simple/MaybeReshuffle/Reshuffle/AddRandomKeys+Create simple/MaybeReshuffle/Reshuffle/ReshufflePerKey/Map(reify_timestamps)+Create simple/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Reify+Create simple/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:33.817Z: JOB_MESSAGE_BASIC: Executing operation Create simple/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:33.858Z: JOB_MESSAGE_BASIC: Finished operation Create simple/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:33.924Z: JOB_MESSAGE_BASIC: Executing operation Create simple/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Read+Create simple/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/GroupByWindow+Create simple/MaybeReshuffle/Reshuffle/ReshufflePerKey/FlatMap(restore_timestamps)+Create simple/MaybeReshuffle/Reshuffle/RemoveRandomKeys+Create simple/Map(decode)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/extractKeyrhs/ParMultiDo(Anonymous)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/MakeUnionTable1/ParMultiDo(ConstructUnionTable)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Reify+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:48.984Z: JOB_MESSAGE_BASIC: Finished operation assert_that/Create/Impulse+assert_that/Create/FlatMap(<lambda at core.py:2955>)+assert_that/Create/Map(decode)+assert_that/Group/pair_with_0+assert_that/Group/Flatten/OutputIdentity+assert_that/Group/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:52.125Z: JOB_MESSAGE_BASIC: Finished operation Create enrich/Impulse+Create enrich/FlatMap(<lambda at core.py:2955>)+Create enrich/MaybeReshuffle/Reshuffle/AddRandomKeys+Create enrich/MaybeReshuffle/Reshuffle/ReshufflePerKey/Map(reify_timestamps)+Create enrich/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Reify+Create enrich/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:52.190Z: JOB_MESSAGE_BASIC: Executing operation Create enrich/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:52.245Z: JOB_MESSAGE_BASIC: Finished operation Create enrich/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:09:52.306Z: JOB_MESSAGE_BASIC: Executing operation Create enrich/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Read+Create enrich/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/GroupByWindow+Create enrich/MaybeReshuffle/Reshuffle/ReshufflePerKey/FlatMap(restore_timestamps)+Create enrich/MaybeReshuffle/Reshuffle/RemoveRandomKeys+Create enrich/Map(decode)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/extractKeylhs/ParMultiDo(Anonymous)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/MakeUnionTable0/ParMultiDo(ConstructUnionTable)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Reify+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:01.756Z: JOB_MESSAGE_BASIC: Finished operation Create enrich/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Read+Create enrich/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/GroupByWindow+Create enrich/MaybeReshuffle/Reshuffle/ReshufflePerKey/FlatMap(restore_timestamps)+Create enrich/MaybeReshuffle/Reshuffle/RemoveRandomKeys+Create enrich/Map(decode)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/extractKeylhs/ParMultiDo(Anonymous)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/MakeUnionTable0/ParMultiDo(ConstructUnionTable)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Reify+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:04.947Z: JOB_MESSAGE_BASIC: Finished operation Create simple/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/Read+Create simple/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey/GroupByWindow+Create simple/MaybeReshuffle/Reshuffle/ReshufflePerKey/FlatMap(restore_timestamps)+Create simple/MaybeReshuffle/Reshuffle/RemoveRandomKeys+Create simple/Map(decode)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/extractKeyrhs/ParMultiDo(Anonymous)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/MakeUnionTable1/ParMultiDo(ConstructUnionTable)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Reify+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:05.039Z: JOB_MESSAGE_BASIC: Executing operation SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:05.091Z: JOB_MESSAGE_BASIC: Finished operation SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:05.153Z: JOB_MESSAGE_BASIC: Executing operation SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Read+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/GroupByWindow+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/ConstructCoGbkResultFn/ParMultiDo(ConstructCoGbkResult)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/ParDo(ConvertCoGbkResult)/ParMultiDo(ConvertCoGbkResult)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Select.Fields/ParDo(Select)/ParMultiDo(Select)+SqlTransform(beam:external:java:sql:v1)/BeamCalcRel_96/ParDo(Calc)/ParMultiDo(Calc)+assert_that/WindowInto(WindowIntoFn)+assert_that/ToVoidKey+assert_that/Group/pair_with_1+assert_that/Group/Flatten/OutputIdentity+assert_that/Group/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:16.153Z: JOB_MESSAGE_BASIC: Finished operation SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/Read+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/GBK/GroupByWindow+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/CoGroupByKey/ConstructCoGbkResultFn/ParMultiDo(ConstructCoGbkResult)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Join.Impl/CoGroup.ExpandCrossProduct/ParDo(ConvertCoGbkResult)/ParMultiDo(ConvertCoGbkResult)+SqlTransform(beam:external:java:sql:v1)/BeamCoGBKJoinRel_95/Select.Fields/ParDo(Select)/ParMultiDo(Select)+SqlTransform(beam:external:java:sql:v1)/BeamCalcRel_96/ParDo(Calc)/ParMultiDo(Calc)+assert_that/WindowInto(WindowIntoFn)+assert_that/ToVoidKey+assert_that/Group/pair_with_1+assert_that/Group/Flatten/OutputIdentity+assert_that/Group/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:16.256Z: JOB_MESSAGE_BASIC: Executing operation assert_that/Group/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:16.312Z: JOB_MESSAGE_BASIC: Finished operation assert_that/Group/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:16.399Z: JOB_MESSAGE_BASIC: Executing operation assert_that/Group/GroupByKey/Read+assert_that/Group/Map(_merge_tagged_vals_under_key)+assert_that/Unkey+assert_that/Match INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:25.409Z: JOB_MESSAGE_BASIC: Finished operation assert_that/Group/GroupByKey/Read+assert_that/Group/Map(_merge_tagged_vals_under_key)+assert_that/Unkey+assert_that/Match INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:25.468Z: JOB_MESSAGE_DEBUG: Executing success step success55 INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:25.536Z: JOB_MESSAGE_DETAILED: Cleaning up. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:25.579Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:25.607Z: JOB_MESSAGE_BASIC: Stopping worker pool... INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:50.265Z: JOB_MESSAGE_BASIC: Finished operation Create/Impulse+Create/FlatMap(<lambda at core.py:2955>)+Create/Map(decode)+SqlTransform(beam:external:java:sql:v1)/BeamCalcRel_18/ParDo(Calc)/ParMultiDo(Calc)+assert_that/WindowInto(WindowIntoFn)+assert_that/ToVoidKey+assert_that/Group/pair_with_1+assert_that/Group/Flatten/OutputIdentity+assert_that/Group/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:53.428Z: JOB_MESSAGE_BASIC: Finished operation assert_that/Create/Impulse+assert_that/Create/FlatMap(<lambda at core.py:2955>)+assert_that/Create/Map(decode)+assert_that/Group/pair_with_0+assert_that/Group/Flatten/OutputIdentity+assert_that/Group/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:53.494Z: JOB_MESSAGE_BASIC: Executing operation assert_that/Group/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:53.543Z: JOB_MESSAGE_BASIC: Finished operation assert_that/Group/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:10:53.592Z: JOB_MESSAGE_BASIC: Executing operation assert_that/Group/GroupByKey/Read+assert_that/Group/Map(_merge_tagged_vals_under_key)+assert_that/Unkey+assert_that/Match INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:11:02.678Z: JOB_MESSAGE_BASIC: Finished operation assert_that/Group/GroupByKey/Read+assert_that/Group/Map(_merge_tagged_vals_under_key)+assert_that/Unkey+assert_that/Match INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:11:02.724Z: JOB_MESSAGE_DEBUG: Executing success step success17 INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:11:02.781Z: JOB_MESSAGE_DETAILED: Cleaning up. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:11:02.834Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:11:02.863Z: JOB_MESSAGE_BASIC: Stopping worker pool... INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:11:15.582Z: JOB_MESSAGE_DETAILED: Autoscaling: Resized worker pool from 1 to 0. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:11:15.652Z: JOB_MESSAGE_BASIC: Worker pool stopped. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:11:15.685Z: JOB_MESSAGE_DEBUG: Tearing down pending resources... INFO:apache_beam.runners.dataflow.dataflow_runner:Job 2021-04-21_17_59_30-9441322414320875064 is in state JOB_STATE_DONE INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:11:50.472Z: JOB_MESSAGE_DETAILED: Autoscaling: Resized worker pool from 1 to 0. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:11:50.517Z: JOB_MESSAGE_BASIC: Worker pool stopped. INFO:apache_beam.runners.dataflow.dataflow_runner:2021-04-22T01:11:50.553Z: JOB_MESSAGE_DEBUG: Tearing down pending resources... INFO:apache_beam.runners.dataflow.dataflow_runner:Job 2021-04-21_17_59_32-17276439788244268920 is in state JOB_STATE_DONE test_map (apache_beam.transforms.sql_test.SqlTransformTest) ... ok test_row (apache_beam.transforms.sql_test.SqlTransformTest) ... ok test_filter (apache_beam.transforms.sql_test.SqlTransformTest) ... ok test_windowing_before_sql (apache_beam.transforms.sql_test.SqlTransformTest) ... ok test_agg (apache_beam.transforms.sql_test.SqlTransformTest) ... ok test_generate_data (apache_beam.transforms.sql_test.SqlTransformTest) ... ok test_tagged_join (apache_beam.transforms.sql_test.SqlTransformTest) ... ok test_project (apache_beam.transforms.sql_test.SqlTransformTest) ... ok Process Process-7: Worker logs: https://console.cloud.google.com/dataflow/jobs/us-central1/2021-04-21_17_59_29-5805476102843442339?project=apache-beam-testing Worker logs: https://console.cloud.google.com/dataflow/jobs/us-central1/2021-04-21_17_59_32-17276439788244268920?project=apache-beam-testing Traceback (most recent call last): File "/usr/lib/python3.6/multiprocessing/process.py", line 258, in _bootstrap Worker logs: https://console.cloud.google.com/dataflow/jobs/us-central1/2021-04-21_17_59_29-3140315902101008702?project=apache-beam-testing self.run() Worker logs: https://console.cloud.google.com/dataflow/jobs/us-central1/2021-04-21_17_59_30-9441322414320875064?project=apache-beam-testing File "/usr/lib/python3.6/multiprocessing/process.py", line 93, in run self._target(*self._args, **self._kwargs) File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 652, in runner keyboardCaught, shouldStop, loaderClass, resultClass, config) File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 700, in __runner for test_addr, arg in iter(get, 'STOP'): File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 675, in get return testQueue.get(timeout=config.multiprocess_timeout) File "<string>", line 2, in get File "/usr/lib/python3.6/multiprocessing/managers.py", line 757, in _callmethod kind, result = conn.recv() File "/usr/lib/python3.6/multiprocessing/connection.py", line 250, in recv buf = self._recv_bytes() File "/usr/lib/python3.6/multiprocessing/connection.py", line 407, in _recv_bytes buf = self._recv(4) File "/usr/lib/python3.6/multiprocessing/connection.py", line 383, in _recv raise EOFError EOFError Process Process-8: Traceback (most recent call last): File "/usr/lib/python3.6/multiprocessing/process.py", line 258, in _bootstrap self.run() File "/usr/lib/python3.6/multiprocessing/process.py", line 93, in run self._target(*self._args, **self._kwargs) File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 652, in runner keyboardCaught, shouldStop, loaderClass, resultClass, config) File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 700, in __runner for test_addr, arg in iter(get, 'STOP'): File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 675, in get return testQueue.get(timeout=config.multiprocess_timeout) File "<string>", line 2, in get File "/usr/lib/python3.6/multiprocessing/managers.py", line 757, in _callmethod kind, result = conn.recv() File "/usr/lib/python3.6/multiprocessing/connection.py", line 250, in recv buf = self._recv_bytes() File "/usr/lib/python3.6/multiprocessing/connection.py", line 407, in _recv_bytes buf = self._recv(4) File "/usr/lib/python3.6/multiprocessing/connection.py", line 383, in _recv raise EOFError EOFError Process Process-10: Traceback (most recent call last): File "/usr/lib/python3.6/multiprocessing/process.py", line 258, in _bootstrap self.run() File "/usr/lib/python3.6/multiprocessing/process.py", line 93, in run self._target(*self._args, **self._kwargs) File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 652, in runner keyboardCaught, shouldStop, loaderClass, resultClass, config) File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 700, in __runner for test_addr, arg in iter(get, 'STOP'): File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 675, in get return testQueue.get(timeout=config.multiprocess_timeout) File "<string>", line 2, in get File "/usr/lib/python3.6/multiprocessing/managers.py", line 757, in _callmethod kind, result = conn.recv() File "/usr/lib/python3.6/multiprocessing/connection.py", line 250, in recv buf = self._recv_bytes() File "/usr/lib/python3.6/multiprocessing/connection.py", line 407, in _recv_bytes buf = self._recv(4) File "/usr/lib/python3.6/multiprocessing/connection.py", line 383, in _recv raise EOFError EOFError Process Process-9: Traceback (most recent call last): File "/usr/lib/python3.6/multiprocessing/process.py", line 258, in _bootstrap self.run() File "/usr/lib/python3.6/multiprocessing/process.py", line 93, in run self._target(*self._args, **self._kwargs) File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 652, in runner keyboardCaught, shouldStop, loaderClass, resultClass, config) File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 700, in __runner for test_addr, arg in iter(get, 'STOP'): File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 675, in get return testQueue.get(timeout=config.multiprocess_timeout) File "<string>", line 2, in get File "/usr/lib/python3.6/multiprocessing/managers.py", line 757, in _callmethod kind, result = conn.recv() File "/usr/lib/python3.6/multiprocessing/connection.py", line 250, in recv buf = self._recv_bytes() File "/usr/lib/python3.6/multiprocessing/connection.py", line 407, in _recv_bytes buf = self._recv(4) File "/usr/lib/python3.6/multiprocessing/connection.py", line 383, in _recv raise EOFError EOFError Terminated The message received from the daemon indicates that the daemon has disappeared. Build request sent: Build{id=a41909c6-59c0-4d77-ad8c-0d58d2c9d1d8, currentDir=<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src}> Attempting to read last messages from the daemon log... Daemon pid: 6613 log file: /home/jenkins/.gradle/daemon/6.8.3/daemon-6613.out.log ----- Last 20 lines from daemon log file - daemon-6613.out.log ----- File "/usr/lib/python3.6/multiprocessing/process.py", line 93, in run self._target(*self._args, **self._kwargs) File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 652, in runner keyboardCaught, shouldStop, loaderClass, resultClass, config) File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 700, in __runner for test_addr, arg in iter(get, 'STOP'): File "<https://ci-beam.apache.org/job/beam_PostCommit_XVR_Dataflow/ws/src/build/gradleenv/1922375555/lib/python3.6/site-packages/nose/plugins/multiprocess.py";,> line 675, in get return testQueue.get(timeout=config.multiprocess_timeout) File "<string>", line 2, in get File "/usr/lib/python3.6/multiprocessing/managers.py", line 757, in _callmethod kind, result = conn.recv() File "/usr/lib/python3.6/multiprocessing/connection.py", line 250, in recv buf = self._recv_bytes() File "/usr/lib/python3.6/multiprocessing/connection.py", line 407, in _recv_bytes buf = self._recv(4) File "/usr/lib/python3.6/multiprocessing/connection.py", line 383, in _recv raise EOFError EOFError Terminated Daemon vm is shutting down... The daemon has exited normally or was terminated in response to a user interrupt. ----- End of the daemon log ----- FAILURE: Build failed with an exception. * What went wrong: Gradle build daemon disappeared unexpectedly (it may have been killed or may have crashed) * Try: Run with --stacktrace option to get the stack trace. Run with --info or --debug option to get more log output. Run with --scan to get full insights. * Get more help at https://help.gradle.org 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]
