See <https://ci-beam.apache.org/job/beam_python_mongoio_load_test/4777/display/redirect?page=changes>
Changes: [noreply] [Python] Allow users to pass service name for profiler (#26220) ------------------------------------------ [...truncated 54.46 KB...] location: 'us-central1' name: 'beamapp-jenkins-0503144855-965159-2nnyqlym' projectId: 'apache-beam-testing' stageStates: [] startTime: '2023-05-03T14:48:57.216237Z' steps: [] tempFiles: [] type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)> INFO:apache_beam.runners.dataflow.internal.apiclient:Created job with id: [2023-05-03_07_48_56-11449028550882264254] INFO:apache_beam.runners.dataflow.internal.apiclient:Submitted job: 2023-05-03_07_48_56-11449028550882264254 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/2023-05-03_07_48_56-11449028550882264254?project=apache-beam-testing INFO:apache_beam.runners.dataflow.dataflow_runner:Job 2023-05-03_07_48_56-11449028550882264254 is in state JOB_STATE_PENDING INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:48:56.699Z: JOB_MESSAGE_BASIC: Dataflow Runner V2 auto-enabled. Use --experiments=disable_runner_v2 to opt out. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:48:57.976Z: JOB_MESSAGE_DETAILED: Autoscaling is enabled for job 2023-05-03_07_48_56-11449028550882264254. The number of workers will be between 1 and 1000. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:48:58.106Z: JOB_MESSAGE_DETAILED: Autoscaling was automatically enabled for job 2023-05-03_07_48_56-11449028550882264254. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:00.185Z: JOB_MESSAGE_BASIC: Worker configuration: e2-standard-2 in us-central1-b. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.318Z: JOB_MESSAGE_DETAILED: Expanding SplittableParDo operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.353Z: JOB_MESSAGE_DETAILED: Expanding CollectionToSingleton operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.421Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.454Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey: GroupByKey not followed by a combiner. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.491Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.523Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.568Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.600Z: JOB_MESSAGE_DETAILED: Fusing consumer Create/FlatMap(<lambda at core.py:3574>) into Create/Impulse INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.633Z: JOB_MESSAGE_DETAILED: Fusing consumer Create/Map(decode) into Create/FlatMap(<lambda at core.py:3574>) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.666Z: JOB_MESSAGE_DETAILED: Fusing consumer Create documents into Create/Map(decode) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.698Z: JOB_MESSAGE_DETAILED: Fusing consumer WriteToMongoDB/ParDo(_GenerateObjectIdFn) into Create documents INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.724Z: JOB_MESSAGE_DETAILED: Fusing consumer WriteToMongoDB/Reshuffle/AddRandomKeys into WriteToMongoDB/ParDo(_GenerateObjectIdFn) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.756Z: JOB_MESSAGE_DETAILED: Fusing consumer WriteToMongoDB/Reshuffle/ReshufflePerKey/Map(reify_timestamps) into WriteToMongoDB/Reshuffle/AddRandomKeys INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.778Z: JOB_MESSAGE_DETAILED: Fusing consumer WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Reify into WriteToMongoDB/Reshuffle/ReshufflePerKey/Map(reify_timestamps) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.807Z: JOB_MESSAGE_DETAILED: Fusing consumer WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Write into WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Reify INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.842Z: JOB_MESSAGE_DETAILED: Fusing consumer WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/GroupByWindow into WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Read INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.877Z: JOB_MESSAGE_DETAILED: Fusing consumer WriteToMongoDB/Reshuffle/ReshufflePerKey/FlatMap(restore_timestamps) into WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/GroupByWindow INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.909Z: JOB_MESSAGE_DETAILED: Fusing consumer WriteToMongoDB/Reshuffle/RemoveRandomKeys into WriteToMongoDB/Reshuffle/ReshufflePerKey/FlatMap(restore_timestamps) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.935Z: JOB_MESSAGE_DETAILED: Fusing consumer WriteToMongoDB/ParDo(_WriteMongoFn) into WriteToMongoDB/Reshuffle/RemoveRandomKeys INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:01.978Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:02.004Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:02.036Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:02.069Z: JOB_MESSAGE_DEBUG: Assigning stage ids. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:02.202Z: JOB_MESSAGE_DEBUG: Executing wait step start13 INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:02.269Z: JOB_MESSAGE_BASIC: Executing operation WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Create INFO:apache_beam.runners.dataflow.dataflow_runner:Job 2023-05-03_07_48_56-11449028550882264254 is in state JOB_STATE_RUNNING INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:02.323Z: JOB_MESSAGE_DEBUG: Starting worker pool setup. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:02.350Z: JOB_MESSAGE_BASIC: Starting 5 workers in us-central1-b... INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:02.837Z: JOB_MESSAGE_BASIC: Finished operation WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Create INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:02.906Z: JOB_MESSAGE_DEBUG: Value "WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Session" materialized. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:02.973Z: JOB_MESSAGE_BASIC: Executing operation Create/Impulse+Create/FlatMap(<lambda at core.py:3574>)+Create/Map(decode)+Create documents+WriteToMongoDB/ParDo(_GenerateObjectIdFn)+WriteToMongoDB/Reshuffle/AddRandomKeys+WriteToMongoDB/Reshuffle/ReshufflePerKey/Map(reify_timestamps)+WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Reify+WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:16.379Z: 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:2023-05-03T14:49:40.633Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 3 based on the rate of progress in the currently running stage(s). INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:40.661Z: JOB_MESSAGE_DETAILED: Autoscaling: Resized worker pool to 3, though goal was 5. This could be a quota issue. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:50.320Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 5 based on the rate of progress in the currently running stage(s). INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:49:50.354Z: JOB_MESSAGE_DETAILED: Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:50:14.263Z: JOB_MESSAGE_DETAILED: Workers have started successfully. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:52:32.922Z: JOB_MESSAGE_DETAILED: Autoscaling: Reduced 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:2023-05-03T14:52:32.951Z: JOB_MESSAGE_DETAILED: Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:52:37.994Z: JOB_MESSAGE_DETAILED: Autoscaling: Resizing worker pool from 5 to 1. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:55:27.242Z: JOB_MESSAGE_DETAILED: All workers have finished the startup processes and began to receive work requests. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:56:04.334Z: JOB_MESSAGE_BASIC: Finished operation Create/Impulse+Create/FlatMap(<lambda at core.py:3574>)+Create/Map(decode)+Create documents+WriteToMongoDB/ParDo(_GenerateObjectIdFn)+WriteToMongoDB/Reshuffle/AddRandomKeys+WriteToMongoDB/Reshuffle/ReshufflePerKey/Map(reify_timestamps)+WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Reify+WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Write INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:56:04.395Z: JOB_MESSAGE_BASIC: Executing operation WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:56:05.337Z: JOB_MESSAGE_BASIC: Finished operation WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Close INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:56:05.399Z: JOB_MESSAGE_BASIC: Executing operation WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Read+WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/GroupByWindow+WriteToMongoDB/Reshuffle/ReshufflePerKey/FlatMap(restore_timestamps)+WriteToMongoDB/Reshuffle/RemoveRandomKeys+WriteToMongoDB/ParDo(_WriteMongoFn) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:57:17.556Z: JOB_MESSAGE_BASIC: Finished operation WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/Read+WriteToMongoDB/Reshuffle/ReshufflePerKey/GroupByKey/GroupByWindow+WriteToMongoDB/Reshuffle/ReshufflePerKey/FlatMap(restore_timestamps)+WriteToMongoDB/Reshuffle/RemoveRandomKeys+WriteToMongoDB/ParDo(_WriteMongoFn) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:57:17.620Z: JOB_MESSAGE_DEBUG: Executing success step success11 INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:57:17.680Z: JOB_MESSAGE_DETAILED: Cleaning up. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:57:17.728Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:57:17.751Z: JOB_MESSAGE_BASIC: Stopping worker pool... INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:26.899Z: JOB_MESSAGE_DETAILED: Autoscaling: Resized worker pool from 1 to 0. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:26.958Z: JOB_MESSAGE_BASIC: Worker pool stopped. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:26.987Z: JOB_MESSAGE_DEBUG: Tearing down pending resources... INFO:apache_beam.runners.dataflow.dataflow_runner:Job 2023-05-03_07_48_56-11449028550882264254 is in state JOB_STATE_DONE INFO:__main__:Writing 1000000 documents to mongodb finished in 642.342 seconds INFO:__main__:================================================================================ INFO:__main__:Reading from mongodb beam_mongodbio_it_db:integration_test_1683125335 INFO:__main__:reader params : {'projection': ['number']} INFO:__main__:expected results: {'number_sum': 499999500000, 'docs_count': 1000000} <https://ci-beam.apache.org/job/beam_python_mongoio_load_test/ws/src/build/gradleenv/-1734967052/lib/python3.7/site-packages/apache_beam/io/mongodbio_it_test.py>:153: FutureWarning: ReadFromMongoDB is experimental. | 'Map' >> beam.Map(lambda doc: doc['number'])) INFO:apache_beam.runners.portability.stager:Copying Beam SDK "<https://ci-beam.apache.org/job/beam_python_mongoio_load_test/ws/src/sdks/python/build/apache-beam.tar.gz";> to staging location. INFO:root:Default Python SDK image for environment is apache/beam_python3.7_sdk:2.48.0.dev INFO:root:Using provided Python SDK container image: gcr.io/cloud-dataflow/v1beta3/python37:beam-master-20230412 INFO:root:Python SDK container image set to "gcr.io/cloud-dataflow/v1beta3/python37:beam-master-20230412" for Docker environment INFO:apache_beam.runners.portability.fn_api_runner.translations:==================== <function pack_combiners at 0x7f626bcd68c0> ==================== INFO:apache_beam.runners.portability.fn_api_runner.translations:==================== <function sort_stages at 0x7f626bcd70e0> ==================== INFO:apache_beam.runners.dataflow.internal.apiclient:Defaulting to the temp_location as staging_location: gs://temp-storage-for-perf-tests/loadtests INFO:apache_beam.runners.dataflow.internal.apiclient:Starting GCS upload to gs://temp-storage-for-perf-tests/loadtests/beamapp-jenkins-0503145944-048638-o24hujq5.1683125984.049380/dataflow_python_sdk.tar... INFO:apache_beam.runners.dataflow.internal.apiclient:Completed GCS upload to gs://temp-storage-for-perf-tests/loadtests/beamapp-jenkins-0503145944-048638-o24hujq5.1683125984.049380/dataflow_python_sdk.tar in 0 seconds. INFO:apache_beam.runners.dataflow.internal.apiclient:Starting GCS upload to gs://temp-storage-for-perf-tests/loadtests/beamapp-jenkins-0503145944-048638-o24hujq5.1683125984.049380/pipeline.pb... INFO:apache_beam.runners.dataflow.internal.apiclient:Completed GCS upload to gs://temp-storage-for-perf-tests/loadtests/beamapp-jenkins-0503145944-048638-o24hujq5.1683125984.049380/pipeline.pb in 0 seconds. INFO:apache_beam.runners.dataflow.internal.apiclient:Create job: <Job clientRequestId: '20230503145944051177-1290' createTime: '2023-05-03T14:59:46.951309Z' currentStateTime: '1970-01-01T00:00:00Z' id: '2023-05-03_07_59_46-13258074817586824625' location: 'us-central1' name: 'beamapp-jenkins-0503145944-048638-o24hujq5' projectId: 'apache-beam-testing' stageStates: [] startTime: '2023-05-03T14:59:46.951309Z' steps: [] tempFiles: [] type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)> INFO:apache_beam.runners.dataflow.internal.apiclient:Created job with id: [2023-05-03_07_59_46-13258074817586824625] INFO:apache_beam.runners.dataflow.internal.apiclient:Submitted job: 2023-05-03_07_59_46-13258074817586824625 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/2023-05-03_07_59_46-13258074817586824625?project=apache-beam-testing INFO:apache_beam.runners.dataflow.dataflow_runner:Job 2023-05-03_07_59_46-13258074817586824625 is in state JOB_STATE_PENDING INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:46.428Z: JOB_MESSAGE_BASIC: Dataflow Runner V2 auto-enabled. Use --experiments=disable_runner_v2 to opt out. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:47.613Z: JOB_MESSAGE_DETAILED: Autoscaling is enabled for job 2023-05-03_07_59_46-13258074817586824625. The number of workers will be between 1 and 1000. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:47.655Z: JOB_MESSAGE_DETAILED: Autoscaling was automatically enabled for job 2023-05-03_07_59_46-13258074817586824625. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:49.045Z: JOB_MESSAGE_BASIC: Worker configuration: e2-standard-2 in us-central1-b. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:49.946Z: JOB_MESSAGE_DETAILED: Expanding SplittableParDo operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:49.992Z: JOB_MESSAGE_DETAILED: Expanding CollectionToSingleton operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.050Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.083Z: JOB_MESSAGE_DEBUG: Combiner lifting skipped for step assert_that/Group/CoGroupByKeyImpl/GroupByKey: GroupByKey not followed by a combiner. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.188Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.217Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.259Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.292Z: JOB_MESSAGE_DEBUG: Inserted coder converter before flatten ref_AppliedPTransform_Flatten_36 INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.318Z: JOB_MESSAGE_DEBUG: Inserted coder converter after flatten ref_AppliedPTransform_assert_that-Group-CoGroupByKeyImpl-Flatten_49 INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.342Z: JOB_MESSAGE_DETAILED: Unzipping flatten ref_AppliedPTransform_assert_that-Group-CoGroupByKeyImpl-Flatten_49 for input ref_AppliedPTransform_assert_that-Group-CoGroupByKeyImpl-Tag-0-_47.None INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.368Z: JOB_MESSAGE_DETAILED: Fusing unzipped copy of assert_that/Group/CoGroupByKeyImpl/Flatten/OutputIdentity, through flatten assert_that/Group/CoGroupByKeyImpl/Flatten, into producer assert_that/Group/CoGroupByKeyImpl/Tag[0] INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.391Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Group/CoGroupByKeyImpl/MapTuple(collect_values) into assert_that/Group/CoGroupByKeyImpl/GroupByKey/Read INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.415Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Group/RestoreTags into assert_that/Group/CoGroupByKeyImpl/MapTuple(collect_values) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.438Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Unkey into assert_that/Group/RestoreTags INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.460Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Match into assert_that/Unkey INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.492Z: JOB_MESSAGE_DETAILED: Unzipping flatten ref_AppliedPTransform_assert_that-Group-CoGroupByKeyImpl-Flatten_49-u47 for input ref_AppliedPTransform_assert_that-Group-CoGroupByKeyImpl-Flatten_49.None-c45 INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.524Z: JOB_MESSAGE_DETAILED: Fusing unzipped copy of assert_that/Group/CoGroupByKeyImpl/GroupByKey/Write, through flatten assert_that/Group/CoGroupByKeyImpl/Flatten/Unzipped-1, into producer assert_that/Group/CoGroupByKeyImpl/Flatten/OutputIdentity INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.548Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Group/CoGroupByKeyImpl/Flatten/OutputIdentity into assert_that/Group/CoGroupByKeyImpl/Tag[1] INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.571Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Group/CoGroupByKeyImpl/GroupByKey/Write into assert_that/Group/CoGroupByKeyImpl/Flatten/OutputIdentity INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.595Z: JOB_MESSAGE_DETAILED: Unzipping flatten ref_AppliedPTransform_Flatten_36 for input ref_AppliedPTransform_Combine-InjectDefault_21.None INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.627Z: JOB_MESSAGE_DETAILED: Fusing unzipped copy of assert_that/WindowInto(WindowIntoFn), through flatten Flatten, into producer Combine/InjectDefault INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.651Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Group/CoGroupByKeyImpl/Tag[1] into assert_that/ToVoidKey INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.683Z: JOB_MESSAGE_DETAILED: Unzipping flatten ref_AppliedPTransform_Flatten_36-u54 for input ref_AppliedPTransform_assert_that-WindowInto-WindowIntoFn-_43.None-c52 INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.708Z: JOB_MESSAGE_DETAILED: Fusing unzipped copy of assert_that/ToVoidKey, through flatten Flatten/Unzipped-1, into producer assert_that/WindowInto(WindowIntoFn) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.739Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine/KeyWithVoid into Map INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.763Z: JOB_MESSAGE_DETAILED: Fusing consumer Count/CombineGlobally(CountCombineFn)/KeyWithVoid into Map INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.788Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/WindowInto(WindowIntoFn) into Flatten/InputIdentity INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.821Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/ToVoidKey into assert_that/WindowInto(WindowIntoFn) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.852Z: JOB_MESSAGE_DETAILED: Fusing consumer ReadFromMongoDB/Read/Map(<lambda at iobase.py:908>) into ReadFromMongoDB/Read/Impulse INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.877Z: JOB_MESSAGE_DETAILED: Fusing consumer ref_AppliedPTransform_ReadFromMongoDB-Read-SDFBoundedSourceReader-ParDo-SDFBoundedSourceDoFn-_7/PairWithRestriction into ReadFromMongoDB/Read/Map(<lambda at iobase.py:908>) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.901Z: JOB_MESSAGE_DETAILED: Fusing consumer ref_AppliedPTransform_ReadFromMongoDB-Read-SDFBoundedSourceReader-ParDo-SDFBoundedSourceDoFn-_7/SplitWithSizing into ref_AppliedPTransform_ReadFromMongoDB-Read-SDFBoundedSourceReader-ParDo-SDFBoundedSourceDoFn-_7/PairWithRestriction INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.930Z: JOB_MESSAGE_DETAILED: Fusing consumer Map into ref_AppliedPTransform_ReadFromMongoDB-Read-SDFBoundedSourceReader-ParDo-SDFBoundedSourceDoFn-_7/ProcessElementAndRestrictionWithSizing INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.955Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine/CombinePerKey/GroupByKey+Combine/CombinePerKey/Combine/Partial into Combine/KeyWithVoid INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:50.987Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine/CombinePerKey/GroupByKey/Write into Combine/CombinePerKey/GroupByKey+Combine/CombinePerKey/Combine/Partial INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.009Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine/CombinePerKey/Combine into Combine/CombinePerKey/GroupByKey/Read INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.042Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine/CombinePerKey/Combine/Extract into Combine/CombinePerKey/Combine INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.066Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine/UnKey into Combine/CombinePerKey/Combine/Extract INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.089Z: JOB_MESSAGE_DETAILED: Fusing consumer Count/CombineGlobally(CountCombineFn)/CombinePerKey/GroupByKey+Count/CombineGlobally(CountCombineFn)/CombinePerKey/Combine/Partial into Count/CombineGlobally(CountCombineFn)/KeyWithVoid INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.126Z: JOB_MESSAGE_DETAILED: Fusing consumer Count/CombineGlobally(CountCombineFn)/CombinePerKey/GroupByKey/Write into Count/CombineGlobally(CountCombineFn)/CombinePerKey/GroupByKey+Count/CombineGlobally(CountCombineFn)/CombinePerKey/Combine/Partial INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.152Z: JOB_MESSAGE_DETAILED: Fusing consumer Count/CombineGlobally(CountCombineFn)/CombinePerKey/Combine into Count/CombineGlobally(CountCombineFn)/CombinePerKey/GroupByKey/Read INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.184Z: JOB_MESSAGE_DETAILED: Fusing consumer Count/CombineGlobally(CountCombineFn)/CombinePerKey/Combine/Extract into Count/CombineGlobally(CountCombineFn)/CombinePerKey/Combine INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.208Z: JOB_MESSAGE_DETAILED: Fusing consumer Count/CombineGlobally(CountCombineFn)/UnKey into Count/CombineGlobally(CountCombineFn)/CombinePerKey/Combine/Extract INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.243Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine/DoOnce/FlatMap(<lambda at core.py:3574>) into Combine/DoOnce/Impulse INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.267Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine/DoOnce/Map(decode) into Combine/DoOnce/FlatMap(<lambda at core.py:3574>) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.288Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine/InjectDefault into Combine/DoOnce/Map(decode) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.314Z: JOB_MESSAGE_DETAILED: Fusing consumer Count/CombineGlobally(CountCombineFn)/DoOnce/FlatMap(<lambda at core.py:3574>) into Count/CombineGlobally(CountCombineFn)/DoOnce/Impulse INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.337Z: JOB_MESSAGE_DETAILED: Fusing consumer Count/CombineGlobally(CountCombineFn)/DoOnce/Map(decode) into Count/CombineGlobally(CountCombineFn)/DoOnce/FlatMap(<lambda at core.py:3574>) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.359Z: JOB_MESSAGE_DETAILED: Fusing consumer Count/CombineGlobally(CountCombineFn)/InjectDefault into Count/CombineGlobally(CountCombineFn)/DoOnce/Map(decode) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.383Z: JOB_MESSAGE_DETAILED: Fusing consumer Flatten/InputIdentity into Count/CombineGlobally(CountCombineFn)/InjectDefault INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.416Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Create/FlatMap(<lambda at core.py:3574>) into assert_that/Create/Impulse INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.449Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Create/Map(decode) into assert_that/Create/FlatMap(<lambda at core.py:3574>) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.473Z: JOB_MESSAGE_DETAILED: Fusing consumer assert_that/Group/CoGroupByKeyImpl/Tag[0] into assert_that/Create/Map(decode) INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.517Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.550Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.575Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.596Z: JOB_MESSAGE_DEBUG: Assigning stage ids. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.741Z: JOB_MESSAGE_DEBUG: Executing wait step start73 INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.800Z: JOB_MESSAGE_BASIC: Executing operation ReadFromMongoDB/Read/Impulse+ReadFromMongoDB/Read/Map(<lambda at iobase.py:908>)+ref_AppliedPTransform_ReadFromMongoDB-Read-SDFBoundedSourceReader-ParDo-SDFBoundedSourceDoFn-_7/PairWithRestriction+ref_AppliedPTransform_ReadFromMongoDB-Read-SDFBoundedSourceReader-ParDo-SDFBoundedSourceDoFn-_7/SplitWithSizing INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.846Z: JOB_MESSAGE_DEBUG: Starting worker pool setup. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T14:59:51.879Z: JOB_MESSAGE_BASIC: Starting 5 workers in us-central1-b... INFO:apache_beam.runners.dataflow.dataflow_runner:Job 2023-05-03_07_59_46-13258074817586824625 is in state JOB_STATE_RUNNING INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T15:00:23.866Z: 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:2023-05-03T15:00:30.542Z: JOB_MESSAGE_WARNING: Autoscaling: Startup of the worker pool in zone us-central1-b reached 4 workers, but the goal was 5 workers. The service will retry. Please refer to https://cloud.google.com/dataflow/docs/guides/common-errors#worker-pool-failure for help troubleshooting. ZONE_RESOURCE_POOL_EXHAUSTED_WITH_DETAILS: Instance 'beamapp-jenkins-050314594-05030759-z65m-harness-2stn' creation failed: The zone 'projects/apache-beam-testing/zones/us-central1-a' does not have enough resources available to fulfill the request. '(resource type:compute)'. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T15:00:40.582Z: JOB_MESSAGE_ERROR: Startup of the worker pool in zone us-central1-b failed to bring up any of the desired 5 workers. Please refer to https://cloud.google.com/dataflow/docs/guides/common-errors#worker-pool-failure for help troubleshooting. ZONE_RESOURCE_POOL_EXHAUSTED_WITH_DETAILS: Instance 'beamapp-jenkins-050314594-05030759-z65m-harness-2stn' creation failed: The zone 'projects/apache-beam-testing/zones/us-central1-a' does not have enough resources available to fulfill the request. '(resource type:compute)'. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T15:00:40.615Z: JOB_MESSAGE_ERROR: Workflow failed. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T15:00:40.735Z: JOB_MESSAGE_WARNING: Unable to delete temp files: "gs://temp-storage-for-perf-tests/loadtests/beamapp-jenkins-0503145944-048638-o24hujq5.1683125984.049380/dax-tmp-2023-05-03_07_59_46-13258074817586824625-S01-0-f75651822d0bf4e2/[email protected]." INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T15:00:40.767Z: JOB_MESSAGE_WARNING: S01:ReadFromMongoDB/Read/Impulse+ReadFromMongoDB/Read/Map(<lambda at iobase.py:908>)+ref_AppliedPTransform_ReadFromMongoDB-Read-SDFBoundedSourceReader-ParDo-SDFBoundedSourceDoFn-_7/PairWithRestriction+ref_AppliedPTransform_ReadFromMongoDB-Read-SDFBoundedSourceReader-ParDo-SDFBoundedSourceDoFn-_7/SplitWithSizing failed. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T15:00:40.803Z: JOB_MESSAGE_BASIC: Finished operation ReadFromMongoDB/Read/Impulse+ReadFromMongoDB/Read/Map(<lambda at iobase.py:908>)+ref_AppliedPTransform_ReadFromMongoDB-Read-SDFBoundedSourceReader-ParDo-SDFBoundedSourceDoFn-_7/PairWithRestriction+ref_AppliedPTransform_ReadFromMongoDB-Read-SDFBoundedSourceReader-ParDo-SDFBoundedSourceDoFn-_7/SplitWithSizing INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T15:00:40.870Z: JOB_MESSAGE_DETAILED: Cleaning up. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T15:00:40.918Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T15:00:40.943Z: JOB_MESSAGE_BASIC: Stopping worker pool... INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T15:01:03.102Z: JOB_MESSAGE_BASIC: Worker pool stopped. INFO:apache_beam.runners.dataflow.dataflow_runner:2023-05-03T15:01:03.124Z: JOB_MESSAGE_DEBUG: Tearing down pending resources... INFO:apache_beam.runners.dataflow.dataflow_runner:Job 2023-05-03_07_59_46-13258074817586824625 is in state JOB_STATE_FAILED ERROR:apache_beam.runners.dataflow.dataflow_runner:Console URL: https://console.cloud.google.com/dataflow/jobs/<RegionId>/2023-05-03_07_59_46-13258074817586824625?project=<ProjectId> Traceback (most recent call last): File "/usr/lib/python3.7/runpy.py", line 193, in _run_module_as_main "__main__", mod_spec) File "/usr/lib/python3.7/runpy.py", line 85, in _run_code exec(code, run_globals) File "<https://ci-beam.apache.org/job/beam_python_mongoio_load_test/ws/src/build/gradleenv/-1734967052/lib/python3.7/site-packages/apache_beam/io/mongodbio_it_test.py";,> line 170, in <module> run() File "<https://ci-beam.apache.org/job/beam_python_mongoio_load_test/ws/src/build/gradleenv/-1734967052/lib/python3.7/site-packages/apache_beam/io/mongodbio_it_test.py";,> line 157, in run assert_that(r, equal_to([expected['number_sum'], expected['docs_count']])) File "<https://ci-beam.apache.org/job/beam_python_mongoio_load_test/ws/src/build/gradleenv/-1734967052/lib/python3.7/site-packages/apache_beam/pipeline.py";,> line 600, in __exit__ self.result = self.run() File "<https://ci-beam.apache.org/job/beam_python_mongoio_load_test/ws/src/build/gradleenv/-1734967052/lib/python3.7/site-packages/apache_beam/testing/test_pipeline.py";,> line 116, in run state = result.wait_until_finish() File "<https://ci-beam.apache.org/job/beam_python_mongoio_load_test/ws/src/build/gradleenv/-1734967052/lib/python3.7/site-packages/apache_beam/runners/dataflow/dataflow_runner.py";,> line 1568, in wait_until_finish self) apache_beam.runners.dataflow.dataflow_runner.DataflowRuntimeException: Dataflow pipeline failed. State: FAILED, Error: Workflow failed. > Task :sdks:python:test-suites:dataflow:py37:mongodbioIT FAILED FAILURE: Build failed with an exception. * Where: Script '<https://ci-beam.apache.org/job/beam_python_mongoio_load_test/ws/src/sdks/python/test-suites/dataflow/common.gradle'> line: 317 * What went wrong: Execution failed for task ':sdks:python:test-suites:dataflow:py37:mongodbioIT'. > Process 'command 'sh'' finished with non-zero exit value 1 * Try: > Run with --stacktrace option to get the stack trace. > Run with --info or --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 BUILD FAILED in 14m 37s 15 actionable tasks: 9 executed, 4 from cache, 2 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/brdwgsef7b3v2 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]
