See 
<https://ci-beam.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/1828/display/redirect>

Changes:


------------------------------------------
[...truncated 290.98 KB...]
          }
        },
        "output_info": [
          {
            "encoding": {
              "@type": "kind:windowed_value",
              "component_encodings": [
                {
                  "@type": 
"FastPrimitivesCoder$QlpoOTFBWSZTWYQR6NMAAEDXwH8QgCEJAEBAv279AmAAIABqEqnqGgaABpoyNAGVHpGgMgDQBk0oR6IeoECBiqqU5NY23ndshzT2UPUOGrg42YPi9VyA8lbwwPJgtghxs5Qq1aWwExCDeMa0RHC2QigTCdizz1nx+LuSKcKEhCCPRpg=",
                  "component_encodings": [
                    {
                      "@type": 
"FastPrimitivesCoder$QlpoOTFBWSZTWYQR6NMAAEDXwH8QgCEJAEBAv279AmAAIABqEqnqGgaABpoyNAGVHpGgMgDQBk0oR6IeoECBiqqU5NY23ndshzT2UPUOGrg42YPi9VyA8lbwwPJgtghxs5Qq1aWwExCDeMa0RHC2QigTCdizz1nx+LuSKcKEhCCPRpg=",
                      "component_encodings": [],
                      "pipeline_proto_coder_id": 
"ref_Coder_FastPrimitivesCoder_5"
                    },
                    {
                      "@type": 
"FastPrimitivesCoder$QlpoOTFBWSZTWYQR6NMAAEDXwH8QgCEJAEBAv279AmAAIABqEqnqGgaABpoyNAGVHpGgMgDQBk0oR6IeoECBiqqU5NY23ndshzT2UPUOGrg42YPi9VyA8lbwwPJgtghxs5Qq1aWwExCDeMa0RHC2QigTCdizz1nx+LuSKcKEhCCPRpg=",
                      "component_encodings": [],
                      "pipeline_proto_coder_id": 
"ref_Coder_FastPrimitivesCoder_5"
                    }
                  ],
                  "is_pair_like": true,
                  "pipeline_proto_coder_id": "ref_Coder_FastPrimitivesCoder_5"
                },
                {
                  "@type": "kind:global_window"
                }
              ],
              "is_wrapper": true
            },
            "output_name": "None",
            "user_name": "Write/Write/WriteImpl/FinalizeWrite.out"
          }
        ],
        "parallel_input": {
          "@type": "OutputReference",
          "output_name": "out",
          "step_name": "s7"
        },
        "serialized_fn": 
"QlpoOTFBWSZTWXosx98ACKN/////////////////////////////////////////////4AjT6gN26rgjZtCxsgC9g1E4g0UIZKYniNI9TTEeo9JtJ6mj1MmRkNANNA09QAaAAGgAAA0ABoAaAAAA0ANDQAaABoHqGhoNNDQaDTaQZIRpMTEwQCaak9I9Q0epptQAAANA0aZAAAAAAZAAAAAAAANAAAAAAAAAAAAABkjYoAAAAEwCYAEYATIwAAmACYABBgTEYBMJkwAAAAAAAAEwJoyMCDAAACaEHqf6pBiEwAjTE0wATBGmTARppkwBMARgAmACMAEaaYmAEwAAI0wACYAAJpgACDCGjQMACTAATAAEwAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAEiRBohMIIyNU9oU/QgjQeKB6maj1MmGoxAADQNNNAGQepmmpoAAAA0NADQAAAAAAAAAAAAAGVTG2N0MIEsmXFZl2KiN8TzPiaGvXsYUOCY7BdZBUWLq48k7FE/bttdcZRUXKrQTanofeppgXO/AKhjwLpqhEICFCgQEjTEm0gGamid+mkuXTGNd16B6pKbGNCUxCCdbyKAMWd4CwFAniAjQLAeC+EEVytfnu3r1nAgtW7maamEoahhMRnHjf8GmkeINAInAtVmmbI2JqnFZNQNIpeXHSkUFvIzznyZgOlPDkgtMQYu/lh4m8MVxMsRZjJB4CvcZiwLJ1kwmE4JyFKhKYTAnaT8hNTlARwvAxw+i6NtznOSlZxIsTc2cSRpWwzDwqiU64Rff0N07MpiCWKAjGShyUSJSGwmaZKSGxvKQQ2HFkKNsSGS0XNMhtMjGdgGcuTxGebAKjSJlFkDRNQrLSZaV060FAhnOxiZzCqOUCRmRg+nodwwf+rV5i676211eIx/cR8n1+J2EgJdgW86Pu/VCLdSOQcsJGAEBzO/lb0Jc65cLUEY4R7JaYm52hpakMMMMMWCCBBBBBCCCBBEie8cEIhKAhgCiOACA9+n1BJSYoo/Sb/n9ZcrI5Yu4IqhdPE01ewuWUnNkxN1MhZOHnVF4GppxUXS0qMLahYBLzRy5314t3/CNVeWstZiFzgF27RiWN2rgqOrGzMClQeLopyzPCs9ZVI0U7x9hTgbObg2WT3DcQoZIONGUDz8UKJhYXGi+X5aldFwkQPqC2KIwDkxM4wqUQFdlFApmRdjOhg4/hrjCimzZzPHkiZwQw3td6CSPRPQePXeh2GDRWJYd3eFFG1660x+WyZaVf1GPkNvplS4GlsCZswzRJUqBnISGc1ElrU9lUNtjOPjZbs+eY9kz952GfAZmDFYZMqq+tX5B/J/JkiSWjSUUNWalCsiNlC0GrJO0FFAkCkq3U5CwanlxqqLNftBX+VwJXT6CkbtlELY3vTDzJxNweeFHMbnVLirknEjqza3FOCTQ5BptUEndDeIjhUZDHaN8o0HeLsWu0qnbcwjSqeCYYhIgwY4FGpFwyQfhfiTijOJIgURExprCWVZ9BKBLzsOxlM6aipuIvlApNchKwOMrmVFsVSv38YMgqKVhfEncTnuZ5NUr3xYutqxhbMeZTaBZedvLCrBUDC/nKd7R2RMVEkrVYGIWUyLALrwK5ibONUs91Aa0GUPoJNDzmiMu0VIFpAGQuTGRppG0+BZCuvS06hCoTAQBKExJIkwO55/ttlMOANr3ZxQLTIOyBB7Ktc/p2LpQ24Z4pGT5PIRpUou6pjr0QCp83IyvPlFZQhG0ZQhUymqiAKEANUItcEwDiQCiM+ReRNVkpF/LFhpnaSQw9wVh0h4Ohr66qTUsctYwxGdAay6y2IEx6AvICBRQ6TODhmqQZA8p+MxwPksbdN3i3jqO+l5Bj5CitFjXHLfK5VN31rrClYoqwLEgVddIdtgoVk3VJuyw0kksK/7S6hMxkb8ndvrCyeKXHhFoZ0jWK9OfNCrvFsq8zK3USuiJkX6DQOuaCOYUEwNgwUGlWTosbjAKvkVVcXj2QWV1vxm3NmBduUYBnoC16SoG3WsoVi4C1QEgODMVsEwDgWFtiSl8VuGAavYpCdcLO0WX9a0Q4MQJeX2y03EEHYQ4ggoBdwwawq+OuSomYKWc+6aipWbdyAJo0oa+nJQMPbIWpNllnJiCmoGDXPA+ZkLIA5nPfPOA2AcAGBZgJ2Zm3VnAf1AvnDD09vkZX32ntibEUYGhgPwHJX8icCgKRyTV7OTGW3b1U6+cyNDbNXNLKEZDLQVjNdPmxwMmq0jvFrKEQIbEwhhi1Kgg7OWOFJhYU/XEIfAuYgNbWBj2YLFgqF4yHIVCDYuFDURd9mUK58ZIV5F1l84CYCsltA0qg2hn36dK8YQK1ii94R4rt+noZ1pZbDVok2CWZqaks9XAyamDK027yvRgmLHiIocqWqtriKq7gYBYNbZ1BaNGc0V2hgCpXlGpoTrIIqgDE5Cn7PDMTbd7LoK2ElW1cKIcy5MZJqCFdvTHOeibSDdczoili7pt2LYpBGwNc0tIrM1qtmnQMJJQ06FUKe5zZZaLpxaZnFWZVpF1m1jLjVDcUqNcRW1ejMzarUQLGdGpYYbBs1oCtYNnFqVsYY2ClbkYDZoFE201Yub6brlcs/GQ1LnofJ89ERVbbykpS20tj01s7rbbcM7aVVY9i3TM86lKUVMVk5aEVSt4Tm27JJGpaWfKYyL3JXrj7lZ1xjYF2nFOPv2UwkgfUI4VBlNh3UHISoeHiYQBgwlKxQAAAAAAAAAACwABoABGLFkwoaBAAgggggjeG6JPQyUNDQuusiLZNtt3XRJ3XXF11999eaRgwZZV4Ii9yy5c6TbbbdVWCVkqpNtt3ZJS6FXTnERgyylXNFGLNhkbHOKtJpSmlttvtJ4U1qCYxmqrTWNpAVfZ1cHFOm7xYgUhKhfuFuc2dOl1g7YS45gotHG3VBV4MZBzQaJpGorBbkre6HNjUt2uqYSSztPX3Z+ZvssH4AvGZoqgvDFpB0I47IBqDFMcxmclEwpVXXGK6W2zFwF4ZoFhw5pBlevt/ClRshnpRnZg3WQxmCW8aUwnLNr4qsrRK8CmkOvghZnRQIeNdWeUyXGCl64GgqiL5aHhWllagTDMNWQTQzNUEGVguuNd9h9utBET8GKWKX8benJnquw0FYCB6Q37AogECEWcH2sxmJfl+v+dTpIw5QTOvEmxaC5SBexjlyNZanA00jTV9ZIxI2PGqSNSzVJStW1oapWZJLbDvcMG1cVUYSsKsRuFVXXbcWLBu1OhvWhsmvpMU1gI81Tw7ClDCCUBhINwFjcGflcueO8+mstoDzRnm9ntrEz7/h8a9NfJdNrvn9PrOK/srY/j8zv6/f9nv9PuqCDuggh+KqgI0BwACEGEYUNwoAYBhIJBWAZgWa+0UT3+tKIDpCKn4t0jQO4n591aFoM48PQoE3oJRB96P2DJA2DTBsGmDYMX3IgNgDrIIFIaAbSQ22gfuYEc40HlmhWjS2nqv/i7kinChIPRZj74A==",
        "user_name": "Write/Write/WriteImpl/FinalizeWrite/FinalizeWrite"
      }
    }
  ],
  "type": "JOB_TYPE_BATCH"
}
apache_beam.runners.dataflow.internal.apiclient: INFO: Create job: <Job
 createTime: '2020-08-21T12:46:32.906118Z'
 currentStateTime: '1970-01-01T00:00:00Z'
 id: '2020-08-21_05_46_31-1794211109423176823'
 location: 'us-central1'
 name: 'performance-tests-wordcount-python37-batch-1gb0821100314'
 projectId: 'apache-beam-testing'
 stageStates: []
 startTime: '2020-08-21T12:46:32.906118Z'
 steps: []
 tempFiles: []
 type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)>
apache_beam.runners.dataflow.internal.apiclient: INFO: Created job with id: 
[2020-08-21_05_46_31-1794211109423176823]
apache_beam.runners.dataflow.internal.apiclient: INFO: Submitted job: 
2020-08-21_05_46_31-1794211109423176823
apache_beam.runners.dataflow.internal.apiclient: INFO: To access the Dataflow 
monitoring console, please navigate to 
https://console.cloud.google.com/dataflow/jobs/us-central1/2020-08-21_05_46_31-1794211109423176823?project=apache-beam-testing
apache_beam.runners.dataflow.dataflow_runner: INFO: Job 
2020-08-21_05_46_31-1794211109423176823 is in state JOB_STATE_RUNNING
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:35.579Z: 
JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-f.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.300Z: 
JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.429Z: 
JOB_MESSAGE_DEBUG: Combiner lifting skipped for step 
Write/Write/WriteImpl/GroupByKey: GroupByKey not followed by a combiner.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.500Z: 
JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.529Z: 
JOB_MESSAGE_DETAILED: Lifting ValueCombiningMappingFns into 
MergeBucketsMappingFns
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.642Z: 
JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.685Z: 
JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.725Z: 
JOB_MESSAGE_DETAILED: Fusing consumer Split into Read/Read
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.759Z: 
JOB_MESSAGE_DETAILED: Fusing consumer PairWIthOne into Split
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.785Z: 
JOB_MESSAGE_DETAILED: Fusing consumer 
GroupAndSum/GroupByKey+GroupAndSum/Combine/Partial into PairWIthOne
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.823Z: 
JOB_MESSAGE_DETAILED: Fusing consumer GroupAndSum/GroupByKey/Reify into 
GroupAndSum/GroupByKey+GroupAndSum/Combine/Partial
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.853Z: 
JOB_MESSAGE_DETAILED: Fusing consumer GroupAndSum/GroupByKey/Write into 
GroupAndSum/GroupByKey/Reify
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.895Z: 
JOB_MESSAGE_DETAILED: Fusing consumer GroupAndSum/Combine into 
GroupAndSum/GroupByKey/Read
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.918Z: 
JOB_MESSAGE_DETAILED: Fusing consumer GroupAndSum/Combine/Extract into 
GroupAndSum/Combine
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.952Z: 
JOB_MESSAGE_DETAILED: Fusing consumer Format into GroupAndSum/Combine/Extract
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:36.989Z: 
JOB_MESSAGE_DETAILED: Fusing consumer 
Write/Write/WriteImpl/WindowInto(WindowIntoFn) into Format
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.021Z: 
JOB_MESSAGE_DETAILED: Fusing consumer 
Write/Write/WriteImpl/WriteBundles/WriteBundles into 
Write/Write/WriteImpl/WindowInto(WindowIntoFn)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.055Z: 
JOB_MESSAGE_DETAILED: Fusing consumer Write/Write/WriteImpl/Pair into 
Write/Write/WriteImpl/WriteBundles/WriteBundles
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.084Z: 
JOB_MESSAGE_DETAILED: Fusing consumer Write/Write/WriteImpl/GroupByKey/Reify 
into Write/Write/WriteImpl/Pair
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.121Z: 
JOB_MESSAGE_DETAILED: Fusing consumer Write/Write/WriteImpl/GroupByKey/Write 
into Write/Write/WriteImpl/GroupByKey/Reify
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.153Z: 
JOB_MESSAGE_DETAILED: Fusing consumer 
Write/Write/WriteImpl/GroupByKey/GroupByWindow into 
Write/Write/WriteImpl/GroupByKey/Read
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.186Z: 
JOB_MESSAGE_DETAILED: Fusing consumer Write/Write/WriteImpl/Extract into 
Write/Write/WriteImpl/GroupByKey/GroupByWindow
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.220Z: 
JOB_MESSAGE_DETAILED: Fusing consumer Write/Write/WriteImpl/InitializeWrite 
into Write/Write/WriteImpl/DoOnce/Read
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.259Z: 
JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.295Z: 
JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.329Z: 
JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.368Z: 
JOB_MESSAGE_DEBUG: Assigning stage ids.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.584Z: 
JOB_MESSAGE_DEBUG: Executing wait step start35
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.647Z: 
JOB_MESSAGE_BASIC: Executing operation 
Write/Write/WriteImpl/DoOnce/Read+Write/Write/WriteImpl/InitializeWrite
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.675Z: 
JOB_MESSAGE_BASIC: Executing operation Write/Write/WriteImpl/GroupByKey/Create
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.697Z: 
JOB_MESSAGE_DEBUG: Starting **** pool setup.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.703Z: 
JOB_MESSAGE_BASIC: Executing operation GroupAndSum/GroupByKey/Create
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.730Z: 
JOB_MESSAGE_BASIC: Starting 10 ****s in us-central1-f...
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.793Z: 
JOB_MESSAGE_BASIC: Finished operation Write/Write/WriteImpl/GroupByKey/Create
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.793Z: 
JOB_MESSAGE_BASIC: Finished operation GroupAndSum/GroupByKey/Create
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.872Z: 
JOB_MESSAGE_DEBUG: Value "GroupAndSum/GroupByKey/Session" materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.900Z: 
JOB_MESSAGE_DEBUG: Value "Write/Write/WriteImpl/GroupByKey/Session" 
materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:37.933Z: 
JOB_MESSAGE_BASIC: Executing operation 
Read/Read+Split+PairWIthOne+GroupAndSum/GroupByKey+GroupAndSum/Combine/Partial+GroupAndSum/GroupByKey/Reify+GroupAndSum/GroupByKey/Write
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:46:49.246Z: 
JOB_MESSAGE_WARNING: Your project already contains 100 Dataflow-created metric 
descriptors and Stackdriver will not create new Dataflow custom metrics for 
this job. Each unique user-defined metric name (independent of the DoFn in 
which it is defined) produces a new metric descriptor. To 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
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:47:03.787Z: 
JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of ****s to 6 based on the 
rate of progress in the currently running stage(s).
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:47:03.821Z: 
JOB_MESSAGE_DETAILED: Resized **** pool to 6, though goal was 10.  This could 
be a quota issue.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:47:09.054Z: 
JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of ****s to 9 based on the 
rate of progress in the currently running stage(s).
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:47:09.080Z: 
JOB_MESSAGE_DETAILED: Resized **** pool to 9, though goal was 10.  This could 
be a quota issue.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:47:14.324Z: 
JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of ****s to 10 based on 
the rate of progress in the currently running stage(s).
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:48:42.634Z: 
JOB_MESSAGE_DETAILED: Workers have started successfully.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:48:42.673Z: 
JOB_MESSAGE_DETAILED: Workers have started successfully.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.073Z: 
JOB_MESSAGE_BASIC: Finished operation 
Write/Write/WriteImpl/DoOnce/Read+Write/Write/WriteImpl/InitializeWrite
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.145Z: 
JOB_MESSAGE_DEBUG: Value "Write/Write/WriteImpl/DoOnce/Read.out" materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.189Z: 
JOB_MESSAGE_DEBUG: Value "Write/Write/WriteImpl/InitializeWrite.out" 
materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.257Z: 
JOB_MESSAGE_BASIC: Executing operation 
Write/Write/WriteImpl/WriteBundles/_UnpickledSideInput(InitializeWrite.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.280Z: 
JOB_MESSAGE_BASIC: Executing operation 
Write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(InitializeWrite.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.306Z: 
JOB_MESSAGE_BASIC: Executing operation 
Write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(InitializeWrite.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.317Z: 
JOB_MESSAGE_BASIC: Finished operation 
Write/Write/WriteImpl/WriteBundles/_UnpickledSideInput(InitializeWrite.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.327Z: 
JOB_MESSAGE_BASIC: Finished operation 
Write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(InitializeWrite.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.354Z: 
JOB_MESSAGE_BASIC: Finished operation 
Write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(InitializeWrite.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.392Z: 
JOB_MESSAGE_DEBUG: Value 
"Write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(InitializeWrite.out.0).output"
 materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.419Z: 
JOB_MESSAGE_DEBUG: Value 
"Write/Write/WriteImpl/WriteBundles/_UnpickledSideInput(InitializeWrite.out.0).output"
 materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:52:01.444Z: 
JOB_MESSAGE_DEBUG: Value 
"Write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(InitializeWrite.out.0).output"
 materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:54:15.718Z: 
JOB_MESSAGE_BASIC: Finished operation 
Read/Read+Split+PairWIthOne+GroupAndSum/GroupByKey+GroupAndSum/Combine/Partial+GroupAndSum/GroupByKey/Reify+GroupAndSum/GroupByKey/Write
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:54:15.807Z: 
JOB_MESSAGE_BASIC: Executing operation GroupAndSum/GroupByKey/Close
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:54:15.868Z: 
JOB_MESSAGE_BASIC: Finished operation GroupAndSum/GroupByKey/Close
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:54:15.950Z: 
JOB_MESSAGE_BASIC: Executing operation 
GroupAndSum/GroupByKey/Read+GroupAndSum/Combine+GroupAndSum/Combine/Extract+Format+Write/Write/WriteImpl/WindowInto(WindowIntoFn)+Write/Write/WriteImpl/WriteBundles/WriteBundles+Write/Write/WriteImpl/Pair+Write/Write/WriteImpl/GroupByKey/Reify+Write/Write/WriteImpl/GroupByKey/Write
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:56:56.948Z: 
JOB_MESSAGE_BASIC: Finished operation 
GroupAndSum/GroupByKey/Read+GroupAndSum/Combine+GroupAndSum/Combine/Extract+Format+Write/Write/WriteImpl/WindowInto(WindowIntoFn)+Write/Write/WriteImpl/WriteBundles/WriteBundles+Write/Write/WriteImpl/Pair+Write/Write/WriteImpl/GroupByKey/Reify+Write/Write/WriteImpl/GroupByKey/Write
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:56:57.041Z: 
JOB_MESSAGE_BASIC: Executing operation Write/Write/WriteImpl/GroupByKey/Close
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:56:57.091Z: 
JOB_MESSAGE_BASIC: Finished operation Write/Write/WriteImpl/GroupByKey/Close
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:56:57.165Z: 
JOB_MESSAGE_BASIC: Executing operation 
Write/Write/WriteImpl/GroupByKey/Read+Write/Write/WriteImpl/GroupByKey/GroupByWindow+Write/Write/WriteImpl/Extract
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:56:59.807Z: 
JOB_MESSAGE_BASIC: Finished operation 
Write/Write/WriteImpl/GroupByKey/Read+Write/Write/WriteImpl/GroupByKey/GroupByWindow+Write/Write/WriteImpl/Extract
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:56:59.917Z: 
JOB_MESSAGE_DEBUG: Value "Write/Write/WriteImpl/Extract.out" materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:00.004Z: 
JOB_MESSAGE_BASIC: Executing operation 
Write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(Extract.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:00.043Z: 
JOB_MESSAGE_BASIC: Executing operation 
Write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(Extract.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:00.063Z: 
JOB_MESSAGE_BASIC: Finished operation 
Write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(Extract.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:00.097Z: 
JOB_MESSAGE_BASIC: Finished operation 
Write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(Extract.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:00.136Z: 
JOB_MESSAGE_DEBUG: Value 
"Write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(Extract.out.0).output" 
materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:00.179Z: 
JOB_MESSAGE_DEBUG: Value 
"Write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(Extract.out.0).output" 
materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:00.253Z: 
JOB_MESSAGE_BASIC: Executing operation 
Write/Write/WriteImpl/PreFinalize/PreFinalize
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:03.019Z: 
JOB_MESSAGE_BASIC: Finished operation 
Write/Write/WriteImpl/PreFinalize/PreFinalize
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:03.097Z: 
JOB_MESSAGE_DEBUG: Value "Write/Write/WriteImpl/PreFinalize.out" materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:03.171Z: 
JOB_MESSAGE_BASIC: Executing operation 
Write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(PreFinalize.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:03.332Z: 
JOB_MESSAGE_BASIC: Finished operation 
Write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(PreFinalize.out.0)
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:03.471Z: 
JOB_MESSAGE_DEBUG: Value 
"Write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(PreFinalize.out.0).output"
 materialized.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:03.599Z: 
JOB_MESSAGE_BASIC: Executing operation 
Write/Write/WriteImpl/FinalizeWrite/FinalizeWrite
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:07.006Z: 
JOB_MESSAGE_BASIC: Finished operation 
Write/Write/WriteImpl/FinalizeWrite/FinalizeWrite
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:07.309Z: 
JOB_MESSAGE_DEBUG: Executing success step success33
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:07.586Z: 
JOB_MESSAGE_DETAILED: Cleaning up.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:07.724Z: 
JOB_MESSAGE_DEBUG: Starting **** pool teardown.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:07.774Z: 
JOB_MESSAGE_BASIC: Stopping **** pool...
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:56.967Z: 
JOB_MESSAGE_DETAILED: Autoscaling: Resized **** pool from 10 to 0.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:57.011Z: 
JOB_MESSAGE_BASIC: Worker pool stopped.
apache_beam.runners.dataflow.dataflow_runner: INFO: 2020-08-21T12:57:57.072Z: 
JOB_MESSAGE_DEBUG: Tearing down pending resources...
apache_beam.runners.dataflow.dataflow_runner: INFO: Job 
2020-08-21_05_46_31-1794211109423176823 is in state JOB_STATE_DONE
apache_beam.io.filesystem: DEBUG: Listing files in 
'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results'
apache_beam.io.filesystem: DEBUG: translate_pattern: 
'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results*-of-*'
 -> 
'gs://temp\\-storage\\-for\\-end\\-to\\-end\\-tests/py\\-it\\-cloud/output/1598013989231/results[^/\\\\]*\\-of\\-[^/\\\\]*'
apache_beam.io.gcp.gcsio: INFO: Starting the size estimation of the input
apache_beam.io.gcp.gcsio: INFO: Finished listing 30 files in 
0.06664705276489258 seconds.
apache_beam.testing.pipeline_verifiers: INFO: Find 30 files in 
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results*-of-*:
 
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00000-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00001-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00002-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00003-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00004-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00005-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00006-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00007-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00008-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00009-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00010-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00011-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00012-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00013-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00014-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00015-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00016-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00017-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00018-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00019-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00020-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00021-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00022-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00023-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00024-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00025-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00026-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00027-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00028-of-00030
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results-00029-of-00030
apache_beam.testing.pipeline_verifiers: INFO: Read from given path 
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results*-of-*,
 26186927 lines, checksum: ea0ca2e5ee4ea5f218790f28d0b9fe7d09d8d710.
google.auth._default: DEBUG: Checking None for explicit credentials as part of 
auth process...
google.auth._default: DEBUG: Checking Cloud SDK credentials as part of auth 
process...
google.auth._default: DEBUG: Cloud SDK credentials not found on disk; not using 
them
google.auth._default: DEBUG: Checking for App Engine runtime as part of auth 
process...
google.auth._default: DEBUG: No App Engine library was found so cannot 
authentication via App Engine Identity Credentials.
google.auth.transport._http_client: DEBUG: Making request: GET 
http://169.254.169.254
google.auth.transport._http_client: DEBUG: Making request: GET 
http://metadata.google.internal/computeMetadata/v1/project/project-id
urllib3.util.retry: DEBUG: Converted retries value: 3 -> Retry(total=3, 
connect=None, read=None, redirect=None, status=None)
google.auth.transport.requests: DEBUG: Making request: GET 
http://metadata.google.internal/computeMetadata/v1/instance/service-accounts/default/?recursive=true
urllib3.connectionpool: DEBUG: Starting new HTTP connection (1): 
metadata.google.internal:80
urllib3.connectionpool: DEBUG: http://metadata.google.internal:80 "GET 
/computeMetadata/v1/instance/service-accounts/default/?recursive=true HTTP/1.1" 
200 144
google.auth.transport.requests: DEBUG: Making request: GET 
http://metadata.google.internal/computeMetadata/v1/instance/service-accounts/[email protected]/token
urllib3.connectionpool: DEBUG: http://metadata.google.internal:80 "GET 
/computeMetadata/v1/instance/service-accounts/[email protected]/token
 HTTP/1.1" 200 221
urllib3.connectionpool: DEBUG: Starting new HTTPS connection (1): 
bigquery.googleapis.com:443
urllib3.connectionpool: DEBUG: https://bigquery.googleapis.com:443 "GET 
/bigquery/v2/projects/apache-beam-testing/datasets/beam_performance HTTP/1.1" 
200 None
urllib3.connectionpool: DEBUG: https://bigquery.googleapis.com:443 "GET 
/bigquery/v2/projects/apache-beam-testing/datasets/beam_performance/tables/wordcount_py37_pkb_results
 HTTP/1.1" 200 None
apache_beam.testing.load_tests.load_test_metrics_utils: INFO: Load test results 
for test: f9fe3fee02d04e5e9bfdd117b4fe8633 and timestamp: 1598014789.5929508:
apache_beam.testing.load_tests.load_test_metrics_utils: INFO: Metric: runtime 
Value: 800
urllib3.connectionpool: DEBUG: https://bigquery.googleapis.com:443 "POST 
/bigquery/v2/projects/apache-beam-testing/datasets/beam_performance/tables/wordcount_py37_pkb_results/insertAll
 HTTP/1.1" 200 None
apache_beam.testing.load_tests.load_test_metrics_utils: ERROR: no such field.
apache_beam.io.filesystem: DEBUG: Listing files in 
'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results'
apache_beam.io.filesystem: DEBUG: translate_pattern: 
'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1598013989231/results*'
 -> 
'gs://temp\\-storage\\-for\\-end\\-to\\-end\\-tests/py\\-it\\-cloud/output/1598013989231/results[^/\\\\]*'
apache_beam.io.gcp.gcsio: INFO: Starting the size estimation of the input
apache_beam.io.gcp.gcsio: INFO: Finished listing 30 files in 
0.05712437629699707 seconds.
--------------------- >> end captured logging << ---------------------

----------------------------------------------------------------------
XML: nosetests-runPerformanceTest-df-py37.xml
----------------------------------------------------------------------
XML: 
<https://ci-beam.apache.org/job/beam_PerformanceTests_WordCountIT_Py37/ws/src/sdks/python/nosetests.xml>
----------------------------------------------------------------------
Ran 1 test in 800.870s

FAILED (errors=1)

> Task :sdks:python:test-suites:dataflow:py37:runPerformanceTest FAILED
:sdks:python:test-suites:dataflow:py37:runPerformanceTest (Thread[Execution 
**** for ':',5,main]) completed. Took 13 mins 23.435 secs.

FAILURE: Build failed with an exception.

* What went wrong:
Execution failed for task 
':sdks:python:test-suites:dataflow:py37:runPerformanceTest'.
> Process 'command 'sh'' finished with non-zero exit value 1

* Try:
Run with --stacktrace option to get the stack trace. Run with --debug option to 
get more log output. 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 6.0.
Use '--warning-mode all' to show the individual deprecation warnings.
See 
https://docs.gradle.org/5.2.1/userguide/command_line_interface.html#sec:command_line_warnings

BUILD FAILED in 14m 32s
5 actionable tasks: 5 executed

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

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

---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to