You are viewing a plain text version of this content. The canonical link for it is here.

Posted to builds@beam.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2021/06/11 07:39:04 UTC

Build failed in Jenkins: beam_PostCommit_Py_VR_Dataflow #8013

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

Changes:

[noreply] Warn on BigQuery Job failures

[noreply] Fix spelling error when starting BigQuery jobs

[Robert Bradshaw] Improve basic explanation of Beam PTransforms.

[Luke Cwik] [BEAM-12459] Ensure that we use the min element timestamp for Watch

[noreply] [BEAM-9547] Add initial implementation of sample (#14984)


------------------------------------------
[...truncated 233.04 KB...]
[33mWARNING [0m apache_beam.options.pipeline_options:pipeline_options.py:309 Discarding unparseable args: ['--sleep_secs=20', '--kms_key_name=projects/apache-beam-testing/locations/global/keyRings/beam-it/cryptoKeys/test']
[33mWARNING [0m apache_beam.options.pipeline_options:pipeline_options.py:309 Discarding unparseable args: ['--sleep_secs=20', '--kms_key_name=projects/apache-beam-testing/locations/global/keyRings/beam-it/cryptoKeys/test']
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:794 Create job: <Job
                                                                           createTime: '2021-06-11T07:26:40.836754Z'
                                                                           currentStateTime: '1970-01-01T00:00:00Z'
                                                                           id: '2021-06-11_00_26_39-16952718722101367532'
                                                                           location: 'us-central1'
                                                                           name: 'beamapp-jenkins-0611072631-368529'
                                                                           projectId: 'apache-beam-testing'
                                                                           stageStates: []
                                                                           startTime: '2021-06-11T07:26:40.836754Z'
                                                                           steps: []
                                                                           tempFiles: []
                                                                           type: TypeValueValuesEnum(JOB_TYPE_STREAMING, 2)>
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:796 Created job with id: [2021-06-11_00_26_39-16952718722101367532]
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:797 Submitted job: 2021-06-11_00_26_39-16952718722101367532
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:798 To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobs/us-central1/2021-06-11_00_26_39-16952718722101367532?project=apache-beam-testing
Worker logs: https://console.cloud.google.com/dataflow/jobs/us-central1/2021-06-11_00_26_39-16952718722101367532?project=apache-beam-testing
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:191 Job 2021-06-11_00_26_39-16952718722101367532 is in state JOB_STATE_RUNNING
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:44.769Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-4 in us-central1-f.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.453Z: JOB_MESSAGE_DETAILED: Expanding SplittableParDo operations into optimizable parts.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.488Z: JOB_MESSAGE_DETAILED: Expanding CollectionToSingleton operations into optimizable parts.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.559Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.646Z: JOB_MESSAGE_DETAILED: Expanding SplittableProcessKeyed operations into optimizable parts.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.672Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into streaming Read/Write steps
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.698Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.743Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.779Z: JOB_MESSAGE_DETAILED: Fusing consumer generate_metrics into ReadFromPubSub/Read
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.814Z: JOB_MESSAGE_DETAILED: Fusing consumer dump_to_pub/ToProtobuf into generate_metrics
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.850Z: JOB_MESSAGE_DETAILED: Fusing consumer dump_to_pub/Write/NativeWrite into dump_to_pub/ToProtobuf
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.889Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.945Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.979Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:46.011Z: JOB_MESSAGE_DEBUG: Assigning stage ids.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:46.239Z: JOB_MESSAGE_DEBUG: Executing wait step start17
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:46.305Z: JOB_MESSAGE_BASIC: Executing operation ReadFromPubSub/Read+generate_metrics+dump_to_pub/ToProtobuf+dump_to_pub/Write/NativeWrite
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:46.361Z: JOB_MESSAGE_DEBUG: Starting worker pool setup.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:46.387Z: JOB_MESSAGE_BASIC: Starting 1 workers in us-central1-f...
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:56.710Z: 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

> Task :sdks:python:test-suites:dataflow:py37:validatesRunnerStreamingTests
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:27:01.602Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 1 so that the pipeline can catch up with its backlog and keep up with its input rate.
[33mWARNING [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:250 Timing out on waiting for job 2021-06-11_00_26_07-13626497633970678068 after 60 seconds

> Task :sdks:python:test-suites:dataflow:py36:validatesRunnerStreamingTests
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:27:10.151Z: 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
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:27:28.656Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 1 so that the pipeline can catch up with its backlog and keep up with its input rate.

> Task :sdks:python:test-suites:dataflow:py38:validatesRunnerStreamingTests
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:27:33.568Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 1 so that the pipeline can catch up with its backlog and keep up with its input rate.
[33mWARNING [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:247 Timing out on waiting for job 2021-06-11_00_26_39-16952718722101367532 after 60 seconds

> Task :sdks:python:test-suites:dataflow:py36:validatesRunnerStreamingTests
[33mWARNING [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:250 Timing out on waiting for job 2021-06-11_00_26_38-6245054312273252140 after 60 seconds

> Task :sdks:python:test-suites:dataflow:py37:validatesRunnerStreamingTests
[32mPASSED[0m

- generated xml file: <https://ci-beam.apache.org/job/beam_PostCommit_Py_VR_Dataflow/ws/src/sdks/python/pytest_validatesRunnerStreamingTests-df-py37-noxdist.xml> -
[32m[1m================= 1 passed, 4605 deselected in 429.48 seconds ==================[0m

> Task :sdks:python:test-suites:dataflow:py36:validatesRunnerStreamingTests
[32mPASSED[0m

- generated xml file: <https://ci-beam.apache.org/job/beam_PostCommit_Py_VR_Dataflow/ws/src/sdks/python/pytest_validatesRunnerStreamingTests-df-py36-noxdist.xml> -
[32m[1m================= 1 passed, 4605 deselected in 441.12 seconds ==================[0m

> Task :sdks:python:test-suites:dataflow:py38:validatesRunnerStreamingTests
[31m[1mERROR   [0m apache_beam.io.gcp.tests.pubsub_matcher:pubsub_matcher.py:158 Timeout after 600 sec. Received 0 messages from projects/apache-beam-testing/subscriptions/exercise_streaming_metrics_subscription_output117f3c4b-1401-437e-8e43-8cff813cf296.
[31mFAILED[0m

=================================== FAILURES ===================================
[31m[1m_ ExerciseStreamingMetricsPipelineTest.test_streaming_pipeline_returns_expected_user_metrics_fnapi_it _[0m

self = <apache_beam.runners.dataflow.dataflow_exercise_streaming_metrics_pipeline_test.ExerciseStreamingMetricsPipelineTest testMethod=test_streaming_pipeline_returns_expected_user_metrics_fnapi_it>

[1m    @pytest.mark.it_validatesrunner[0m
[1m    @pytest.mark.no_sickbay_batch[0m
[1m    @pytest.mark.no_xdist[0m
[1m    def test_streaming_pipeline_returns_expected_user_metrics_fnapi_it(self):[0m
[1m      """[0m
[1m      Runs streaming Dataflow job and verifies that user metrics are reported[0m
[1m      correctly.[0m
[1m      """[0m
[1m      self._inject_words(self.input_topic, MESSAGES_TO_PUBLISH)[0m
[1m>     result = self.run_pipeline()[0m

[1m[31mapache_beam/runners/dataflow/dataflow_exercise_streaming_metrics_pipeline_test.py[0m:125: 
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 
[1m[31mapache_beam/runners/dataflow/dataflow_exercise_streaming_metrics_pipeline_test.py[0m:113: in run_pipeline
[1m    return dataflow_exercise_streaming_metrics_pipeline.run(argv)[0m
[1m[31mapache_beam/runners/dataflow/dataflow_exercise_streaming_metrics_pipeline.py[0m:99: in run
[1m    result = pipeline.run()[0m
[1m[31mapache_beam/pipeline.py[0m:564: in run
[1m    return self.runner.run_pipeline(self, self._options)[0m
_ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ _ 

self = <apache_beam.runners.dataflow.test_dataflow_runner.TestDataflowRunner object at 0x7ff2297dc910>
pipeline = <apache_beam.pipeline.Pipeline object at 0x7ff2297dc7c0>
options = <apache_beam.options.pipeline_options.PipelineOptions object at 0x7ff2297dc9d0>

[1m    def run_pipeline(self, pipeline, options):[0m
[1m      """Execute test pipeline and verify test matcher"""[0m
[1m      test_options = options.view_as(TestOptions)[0m
[1m      on_success_matcher = test_options.on_success_matcher[0m
[1m      wait_duration = test_options.wait_until_finish_duration[0m
[1m      is_streaming = options.view_as(StandardOptions).streaming[0m
[1m    [0m
[1m      # [BEAM-1889] Do not send this to remote workers also, there is no need to[0m
[1m      # send this option to remote executors.[0m
[1m      test_options.on_success_matcher = None[0m
[1m    [0m
[1m      self.result = super(TestDataflowRunner,[0m
[1m                          self).run_pipeline(pipeline, options)[0m
[1m      if self.result.has_job:[0m
[1m        # TODO(markflyhigh)(BEAM-1890): Use print since Nose dosen't show logs[0m
[1m        # in some cases.[0m
[1m        print('Worker logs: %s' % self.build_console_url(options))[0m
[1m    [0m
[1m      try:[0m
[1m        self.wait_until_in_state(PipelineState.RUNNING)[0m
[1m    [0m
[1m        if is_streaming and not wait_duration:[0m
[1m          _LOGGER.warning('Waiting indefinitely for streaming job.')[0m
[1m        self.result.wait_until_finish(duration=wait_duration)[0m
[1m    [0m
[1m        if on_success_matcher:[0m
[1m          from hamcrest import assert_that as hc_assert_that[0m
[1m>         hc_assert_that(self.result, pickler.loads(on_success_matcher))[0m
[1m[31mE         AssertionError: [0m
[1m[31mE         Expected: (Test pipeline expected terminated in state: RUNNING and Expected 3 messages.)[0m
[1m[31mE              but: Expected 3 messages. Got 0 messages. Diffs (item, count):[0m
[1m[31mE           Expected but not in actual: dict_items([(b'message a', 1), (b'message b b', 1), (b'message c', 1)])[0m
[1m[31mE           Unexpected: dict_items([])[0m

[1m[31mapache_beam/runners/dataflow/test_dataflow_runner.py[0m:69: AssertionError
------------------------------ Captured log call -------------------------------
[32mINFO    [0m apache_beam.runners.portability.stager:stager.py:644 Executing command: ['<https://ci-beam.apache.org/job/beam_PostCommit_Py_VR_Dataflow/ws/src/build/gradleenv/-1734967051/bin/python3.8',> '-m', 'pip', 'download', '--dest', '/tmp/dataflow-requirements-cache', '-r', 'postcommit_requirements.txt', '--exists-action', 'i', '--no-binary', ':all:']
[32mINFO    [0m apache_beam.runners.portability.stager:stager.py:300 Copying Beam SDK "<https://ci-beam.apache.org/job/beam_PostCommit_Py_VR_Dataflow/ws/src/sdks/python/build/apache-beam.tar.gz"> to staging location.
[33mWARNING [0m root:environments.py:371 Make sure that locally built Python SDK docker image has Python 3.8 interpreter.
[32mINFO    [0m root:environments.py:380 Default Python SDK image for environment is apache/beam_python3.8_sdk:2.32.0.dev
[32mINFO    [0m root:environments.py:295 Using provided Python SDK container image: gcr.io/cloud-dataflow/v1beta3/python38-fnapi:beam-master-20210526
[32mINFO    [0m root:environments.py:302 Python SDK container image set to "gcr.io/cloud-dataflow/v1beta3/python38-fnapi:beam-master-20210526" for Docker environment
[32mINFO    [0m apache_beam.internal.gcp.auth:auth.py:106 Setting socket default timeout to 60 seconds.
[32mINFO    [0m apache_beam.internal.gcp.auth:auth.py:108 socket default timeout is 60.0 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/requirements.txt...
[32mINFO    [0m oauth2client.transport:transport.py:157 Attempting refresh to obtain initial access_token
[32mINFO    [0m oauth2client.transport:transport.py:157 Attempting refresh to obtain initial access_token
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/requirements.txt in 0 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/pickled_main_session...
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/pickled_main_session in 0 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/pbr-5.6.0.tar.gz...
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/pbr-5.6.0.tar.gz in 0 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/mock-2.0.0.tar.gz...
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/mock-2.0.0.tar.gz in 0 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/six-1.16.0.tar.gz...
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/six-1.16.0.tar.gz in 0 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/soupsieve-2.2.1.tar.gz...
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/soupsieve-2.2.1.tar.gz in 0 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/PyHamcrest-1.10.1.tar.gz...
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/PyHamcrest-1.10.1.tar.gz in 0 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/parameterized-0.7.5.tar.gz...
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/parameterized-0.7.5.tar.gz in 0 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/beautifulsoup4-4.9.3.tar.gz...
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/beautifulsoup4-4.9.3.tar.gz in 0 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/dataflow_python_sdk.tar...
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/dataflow_python_sdk.tar in 0 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/dataflow-worker.jar...
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/dataflow-worker.jar in 6 seconds.
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:632 Starting GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/pipeline.pb...
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:648 Completed GCS upload to gs://temp-storage-for-end-to-end-tests/staging-it/beamapp-jenkins-0611072631-368529.1623396391.368677/pipeline.pb in 0 seconds.
[33mWARNING [0m apache_beam.options.pipeline_options:pipeline_options.py:309 Discarding unparseable args: ['--sleep_secs=20', '--kms_key_name=projects/apache-beam-testing/locations/global/keyRings/beam-it/cryptoKeys/test']
[33mWARNING [0m apache_beam.options.pipeline_options:pipeline_options.py:309 Discarding unparseable args: ['--sleep_secs=20', '--kms_key_name=projects/apache-beam-testing/locations/global/keyRings/beam-it/cryptoKeys/test']
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:794 Create job: <Job
                                                                           createTime: '2021-06-11T07:26:40.836754Z'
                                                                           currentStateTime: '1970-01-01T00:00:00Z'
                                                                           id: '2021-06-11_00_26_39-16952718722101367532'
                                                                           location: 'us-central1'
                                                                           name: 'beamapp-jenkins-0611072631-368529'
                                                                           projectId: 'apache-beam-testing'
                                                                           stageStates: []
                                                                           startTime: '2021-06-11T07:26:40.836754Z'
                                                                           steps: []
                                                                           tempFiles: []
                                                                           type: TypeValueValuesEnum(JOB_TYPE_STREAMING, 2)>
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:796 Created job with id: [2021-06-11_00_26_39-16952718722101367532]
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:797 Submitted job: 2021-06-11_00_26_39-16952718722101367532
[32mINFO    [0m apache_beam.runners.dataflow.internal.apiclient:apiclient.py:798 To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobs/us-central1/2021-06-11_00_26_39-16952718722101367532?project=apache-beam-testing
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:191 Job 2021-06-11_00_26_39-16952718722101367532 is in state JOB_STATE_RUNNING
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:44.769Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-4 in us-central1-f.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.453Z: JOB_MESSAGE_DETAILED: Expanding SplittableParDo operations into optimizable parts.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.488Z: JOB_MESSAGE_DETAILED: Expanding CollectionToSingleton operations into optimizable parts.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.559Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.646Z: JOB_MESSAGE_DETAILED: Expanding SplittableProcessKeyed operations into optimizable parts.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.672Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into streaming Read/Write steps
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.698Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.743Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.779Z: JOB_MESSAGE_DETAILED: Fusing consumer generate_metrics into ReadFromPubSub/Read
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.814Z: JOB_MESSAGE_DETAILED: Fusing consumer dump_to_pub/ToProtobuf into generate_metrics
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.850Z: JOB_MESSAGE_DETAILED: Fusing consumer dump_to_pub/Write/NativeWrite into dump_to_pub/ToProtobuf
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.889Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.945Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:45.979Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:46.011Z: JOB_MESSAGE_DEBUG: Assigning stage ids.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:46.239Z: JOB_MESSAGE_DEBUG: Executing wait step start17
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:46.305Z: JOB_MESSAGE_BASIC: Executing operation ReadFromPubSub/Read+generate_metrics+dump_to_pub/ToProtobuf+dump_to_pub/Write/NativeWrite
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:46.361Z: JOB_MESSAGE_DEBUG: Starting worker pool setup.
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:46.387Z: JOB_MESSAGE_BASIC: Starting 1 workers in us-central1-f...
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:26:56.710Z: 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
[32mINFO    [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:236 2021-06-11T07:27:33.568Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 1 so that the pipeline can catch up with its backlog and keep up with its input rate.
[33mWARNING [0m apache_beam.runners.dataflow.dataflow_runner:dataflow_runner.py:247 Timing out on waiting for job 2021-06-11_00_26_39-16952718722101367532 after 60 seconds
[31m[1mERROR   [0m apache_beam.io.gcp.tests.pubsub_matcher:pubsub_matcher.py:158 Timeout after 600 sec. Received 0 messages from projects/apache-beam-testing/subscriptions/exercise_streaming_metrics_subscription_output117f3c4b-1401-437e-8e43-8cff813cf296.
[33m=============================== warnings summary ===============================[0m
<https://ci-beam.apache.org/job/beam_PostCommit_Py_VR_Dataflow/ws/src/build/gradleenv/-1734967051/lib/python3.8/site-packages/tenacity/_asyncio.py>:42
  <https://ci-beam.apache.org/job/beam_PostCommit_Py_VR_Dataflow/ws/src/build/gradleenv/-1734967051/lib/python3.8/site-packages/tenacity/_asyncio.py>:42: DeprecationWarning: "@coroutine" decorator is deprecated since Python 3.8, use "async def" instead
    def call(self, fn, *args, **kwargs):

-- Docs: https://docs.pytest.org/en/latest/warnings.html
- generated xml file: <https://ci-beam.apache.org/job/beam_PostCommit_Py_VR_Dataflow/ws/src/sdks/python/pytest_validatesRunnerStreamingTests-df-py38-noxdist.xml> -
[31m[1m=========== 1 failed, 4605 deselected, 1 warnings in 761.36 seconds ============[0m

> Task :sdks:python:test-suites:dataflow:py38:validatesRunnerStreamingTests FAILED

FAILURE: Build failed with an exception.

* Where:
Script '<https://ci-beam.apache.org/job/beam_PostCommit_Py_VR_Dataflow/ws/src/sdks/python/test-suites/dataflow/common.gradle'> line: 213

* What went wrong:
Execution failed for task ':sdks:python:test-suites:dataflow:py38:validatesRunnerStreamingTests'.
> 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. Run with --scan to get full insights.

* Get more help at https://help.gradle.org

Deprecated Gradle features were used in this build, making it incompatible with Gradle 7.0.
Use '--warning-mode all' to show the individual deprecation warnings.
See https://docs.gradle.org/6.8.3/userguide/command_line_interface.html#sec:command_line_warnings

BUILD FAILED in 1h 38m 30s
89 actionable tasks: 74 executed, 15 from cache

Publishing build scan...
https://gradle.com/s/uuienvq4rlo7i

Build step 'Invoke Gradle script' changed build result to FAILURE
Build step 'Invoke Gradle script' marked build as failure

---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org

Jenkins build is back to normal : beam_PostCommit_Py_VR_Dataflow #8014

Posted by Apache Jenkins Server <je...@builds.apache.org>.

See <https://ci-beam.apache.org/job/beam_PostCommit_Py_VR_Dataflow/8014/display/redirect>


---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org