See 
<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py36/1147/display/redirect>

Changes:


------------------------------------------
[...truncated 476.30 KB...]
            },
            "output_name": "out",
            "user_name": 
"write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(PreFinalize.out.0).output"
          }
        ],
        "parallel_input": {
          "@type": "OutputReference",
          "output_name": "None",
          "step_name": "s17"
        },
        "user_name": 
"write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(PreFinalize.out.0)",
        "windowing_strategy": 
"%0AB%22%40%0A%1Dref_Coder_GlobalWindowCoder_1%12%1F%0A%1D%0A%1Bbeam%3Acoder%3Aglobal_window%3Av1jQ%0A%22%0A%20beam%3Awindow_fn%3Aglobal_windows%3Av1%10%01%1A%1Dref_Coder_GlobalWindowCoder_1%22%02%3A%00%28%010%018%01H%01"
      }
    },
    {
      "kind": "ParallelDo",
      "name": "s21",
      "properties": {
        "display_data": [
          {
            "key": "fn",
            "label": "Transform Function",
            "namespace": "apache_beam.transforms.core.ParDo",
            "shortValue": "CallableWrapperDoFn",
            "type": "STRING",
            "value": "apache_beam.transforms.core.CallableWrapperDoFn"
          },
          {
            "key": "fn",
            "label": "Transform Function",
            "namespace": "apache_beam.transforms.core.CallableWrapperDoFn",
            "type": "STRING",
            "value": "_finalize_write"
          }
        ],
        "non_parallel_inputs": {
          "side0-write/Write/WriteImpl/FinalizeWrite": {
            "@type": "OutputReference",
            "output_name": "out",
            "step_name": "SideInput-s18"
          },
          "side1-write/Write/WriteImpl/FinalizeWrite": {
            "@type": "OutputReference",
            "output_name": "out",
            "step_name": "SideInput-s19"
          },
          "side2-write/Write/WriteImpl/FinalizeWrite": {
            "@type": "OutputReference",
            "output_name": "out",
            "step_name": "SideInput-s20"
          }
        },
        "output_info": [
          {
            "encoding": {
              "@type": "kind:windowed_value",
              "component_encodings": [
                {
                  "@type": 
"FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
                  "component_encodings": [
                    {
                      "@type": 
"FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
                      "component_encodings": [],
                      "pipeline_proto_coder_id": 
"ref_Coder_FastPrimitivesCoder_5"
                    },
                    {
                      "@type": 
"FastPrimitivesCoder$eNprYE5OLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqYIfgYGhvi0xJycpMTk7HiwlkJ8pgVkJmfnpEJNYQGawlpbyJZUnKQHACYlLgM=",
                      "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": 
"eNrNV2l728YRJkj5COK6TtI4dXOUceOWSkPS8lVHTZMmlOWorGkFUiL0cJElsORCArCY3YVopULqxNXRK1fvM+nd9L7v+77+Sv9DZ5eiXLpS6m/u80gAOLszu/POO+8CF0oVn6TEZ9RrUxLXlCCJ7HARy5rPBbUbJIpIO6JzgqQpFRN8MrGhMPoEWDkUK26pUCh4nQRKQ0FCjn9tIqntdcKEROFj1OuJUFEbRtw9xiXDsKIrU+rDjpa7C22p4D6VEnayEfdaPUctpdRjYaIk7PKDMIpqnr7ani8oUdRLSEwDlaURht1tXKbOzqLPg8blGmMJkzRTJpIE2yzNM3XJdK27U5tE2A0T2LMGL3PL+HsID5xn9lALKAJCFBcS9q7Byx3Y12qdg+vW4HoHbsja5+AVlctBUPS8CrntzeJ9JkwWbLgRkdufw00Vdx8u1Akj6qVEMS8VtBOeh1cOReApeieytkiiDOcJvhgGVNgziqjQf0Qbpwc2OICBX5XDzRXXxsB9D713uGUIuoiTwNhtuNUUTyoBt63Aqx0ouzsGnnC7exafu3K8Xlc0TqsS0yZdWkViVGkSVBXv36hUsp4uVUNV9SOeBfU+uvWx4yePHrv75MmjY8eOHKsLKrMIS3Iwa19KW1fPk1lHp/0aprd/Rw6HKuwWVma3uzirAK/F+TqbJIs9yYgIJLyuWTDb9DlmDcOAG5vcuNmz/IEl3F+DG3hGMf6dOby+7V6nk9bB+jvQVCcK7nLvQHv1UGVjKItHDx8PqryDpkvLaxtU3f3DIboRbw/i1Mxg9c4tPesme5/HWG0psbT9Ch12RzTpMsVhzL0GH+Mw3ijeEZO/plE9jQhy9Kh7QLeG7sUECylIGIVJ10toD+9I6GPrppc8RokG6Hgraw+TMlFUYEfWMhVG9v2im8U0UdMR8SnjkYHqBEL1BqavJ5uWud9Ncxg/B2+suKM6cyTc4app5/rcpetUnEb1yY1uNxa4Z2jp1FDL9h5O0tBfiGgwg4GmdH/a8KYc7q0YGAKiCNy3lePm9AmcYsObcWP35/BAxd2r0fO1duhe0vlBw70Zjdp7XG/XMzIwjnsSWsvGF8dgwhChFyYB73kx4qlhRCE7tZ0a6jgmjLRNxUnk/Ze3DZMG/sWQ9nSw01vJVidLfN3XNjxYYbe6u3G+JqlWLphagbc40Kw0rWYB/0vNGxr2emG5sG5dLM4U4K2tFTgzalwGuQCazroCLXXGY1qfp8lCmMjBvSojskjrPS4WJOZF6zotb5oKw9fEp7O6hb05LoIGzxI1NetNLx09UZfCr8tgQTe3Yjyp/wco9X49aukSTJut3BORuB2Qe+GhMxesRgEc90bd5ILHnsCQmsybu50xGmzw2VA3mF2Fh0cVPOLA3BBcXao8LCcy0jXLtLMwUpgSvM1gjMN6FN6+Cu9w4J1DrmGccqG8mAeZPhzOuddfpur9FOBdK+A58KgJ76GvrzwPyCq0HfDZQ62tqudT/AEBw9phmYpYplJzV7PReFQVlDVfXC4EWKqLVl5cLsqDy9Z8KSiqkYsFXT61YxlHgtJCUZxYLgYjBwpo2xns6NvVrr5t46mknzql/Xh90gpwJtBKq1k0qQe0Q1BQoaNp4j6OlukGjyJqaFXmnbLEFiwfCsq9ULFyjMd4WTGCIwkt04jqji/3G4YGZSLLBB2SbkQVeuvS1MqToZCqrHp8MF+WaeJrglChfTDiwUPy4F3mWoOuAtZv3yiUCkKjYrrmivNIwrw5ZUMZhT6FBXPsYPUgMp17Kk7V0mZvQ2yGI5pAYrTPHHOnhOACOLtNQeoWTWwAA8WARMKsrlUP5BooNm102NuahNmZf1mNfYXiPmvE2mvtsXZbRatYhMVRpGHPgfPMZ1mrlcNSS8FjDrx7BZYdyFmQw+PbqMZ72KRcgQsOPLEKT+ZwER3f68BK1man2GS2Bqubyjl2Rcq5xlAR1yvsPqZl7n05vL/C/remfUCvxk5vcLMvIVZzpjGyrPnzQVSKD40yvD51tfTi6WG9eObMTUXmaNSfdeA5RP0ZjfqHEbyPOPDRTfA+tgnekSsC7+MavE8MwPtkDp+6EvA+vQV4l+vvZxC8zxoIP3e1IHx+GMIXUHKZw2YYqujnEcgvOPBFBPKFFrsaEvUlLVHs/0aWvqzgKxUWsnm2wCIWs4QZCfkqAyYYysTX2PMvJRMvbi0TX9eE/YYD30ScX9SE/RYS9tsOfGcFvuvA97RMfH8bmfiBkYkfOvCjVfhxDj9Bx5868LNNpv+cvuS32JwJiLFs+AUy+5c5/Kpi6NBfCRf49Xb+/Rn2afPi0o8jbfgNRvmtEWuFn0BdpGgCv9suxMYUe6J/+sxu/ITfY5A/mISxeFmcRUTXWx++FP7YtMw7L35E8h4NPByjif7I+9PQKvplFBdA9KUicWpPZIL0X5H+jMH/ksNfzQkSh77gEv7WLMi2OdI3PTx8qW7jC7CAv+OK5usxlN7gnPzHetZW8M/avwHI5Qr1",
        "user_name": "write/Write/WriteImpl/FinalizeWrite/FinalizeWrite"
      }
    }
  ],
  "type": "JOB_TYPE_BATCH"
}
INFO:apache_beam.runners.dataflow.internal.apiclient:Create job: <Job
 createTime: '2020-03-06T12:47:15.627284Z'
 currentStateTime: '1970-01-01T00:00:00Z'
 id: '2020-03-06_04_47_14-11228938863731155602'
 location: 'us-central1'
 name: 'beamapp-jenkins-0306124712-941084'
 projectId: 'apache-beam-testing'
 stageStates: []
 startTime: '2020-03-06T12:47:15.627284Z'
 steps: []
 tempFiles: []
 type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)>
INFO:apache_beam.runners.dataflow.internal.apiclient:Created job with id: 
[2020-03-06_04_47_14-11228938863731155602]
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/2020-03-06_04_47_14-11228938863731155602?project=apache-beam-testing
INFO:apache_beam.runners.dataflow.dataflow_runner:Job 
2020-03-06_04_47_14-11228938863731155602 is in state JOB_STATE_RUNNING
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:17.849Z: 
JOB_MESSAGE_DETAILED: Checking permissions granted to controller Service 
Account.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:18.347Z: 
JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-f.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.073Z: 
JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.101Z: 
JOB_MESSAGE_DEBUG: Combiner lifting skipped for step 
write/Write/WriteImpl/GroupByKey: GroupByKey not followed by a combiner.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.140Z: 
JOB_MESSAGE_DEBUG: Combiner lifting skipped for step group: GroupByKey not 
followed by a combiner.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.179Z: 
JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.220Z: 
JOB_MESSAGE_DETAILED: Lifting ValueCombiningMappingFns into 
MergeBucketsMappingFns
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.321Z: 
JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.370Z: 
JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.393Z: 
JOB_MESSAGE_DETAILED: Fusing consumer split into read/Read
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.418Z: 
JOB_MESSAGE_DETAILED: Fusing consumer pair_with_one into split
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.453Z: 
JOB_MESSAGE_DETAILED: Fusing consumer group/Reify into pair_with_one
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.486Z: 
JOB_MESSAGE_DETAILED: Fusing consumer group/Write into group/Reify
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.513Z: 
JOB_MESSAGE_DETAILED: Fusing consumer group/GroupByWindow into group/Read
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.550Z: 
JOB_MESSAGE_DETAILED: Fusing consumer count into group/GroupByWindow
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.590Z: 
JOB_MESSAGE_DETAILED: Fusing consumer format into count
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.628Z: 
JOB_MESSAGE_DETAILED: Fusing consumer 
write/Write/WriteImpl/WriteBundles/WriteBundles into format
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.654Z: 
JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Pair into 
write/Write/WriteImpl/WriteBundles/WriteBundles
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.677Z: 
JOB_MESSAGE_DETAILED: Fusing consumer 
write/Write/WriteImpl/WindowInto(WindowIntoFn) into write/Write/WriteImpl/Pair
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.707Z: 
JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Reify 
into write/Write/WriteImpl/WindowInto(WindowIntoFn)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.741Z: 
JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/GroupByKey/Write 
into write/Write/WriteImpl/GroupByKey/Reify
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.765Z: 
JOB_MESSAGE_DETAILED: Fusing consumer 
write/Write/WriteImpl/GroupByKey/GroupByWindow into 
write/Write/WriteImpl/GroupByKey/Read
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.797Z: 
JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/Extract into 
write/Write/WriteImpl/GroupByKey/GroupByWindow
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.826Z: 
JOB_MESSAGE_DETAILED: Fusing consumer write/Write/WriteImpl/InitializeWrite 
into write/Write/WriteImpl/DoOnce/Read
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.891Z: 
JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.929Z: 
JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.968Z: 
JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:19.994Z: 
JOB_MESSAGE_DEBUG: Assigning stage ids.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:20.367Z: 
JOB_MESSAGE_DEBUG: Executing wait step start26
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:20.457Z: 
JOB_MESSAGE_BASIC: Executing operation 
write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:20.505Z: 
JOB_MESSAGE_DEBUG: Starting worker pool setup.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:20.505Z: 
JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/GroupByKey/Create
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:20.540Z: 
JOB_MESSAGE_BASIC: Executing operation group/Create
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:20.622Z: 
JOB_MESSAGE_BASIC: Starting 10 workers in us-central1-f...
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:20.686Z: 
JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/GroupByKey/Create
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:20.688Z: 
JOB_MESSAGE_BASIC: Finished operation group/Create
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:20.755Z: 
JOB_MESSAGE_DEBUG: Value "write/Write/WriteImpl/GroupByKey/Session" 
materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:20.794Z: 
JOB_MESSAGE_DEBUG: Value "group/Session" materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:20.867Z: 
JOB_MESSAGE_BASIC: Executing operation 
read/Read+split+pair_with_one+group/Reify+group/Write
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:43.975Z: 
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
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:47:48.646Z: 
JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 10 based on 
the rate of progress in the currently running step(s).
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:49:16.339Z: 
JOB_MESSAGE_DETAILED: Workers have started successfully.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:49:16.380Z: 
JOB_MESSAGE_DETAILED: Workers have started successfully.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:53:20.327Z: 
JOB_MESSAGE_DETAILED: Checking permissions granted to controller Service 
Account.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:02.630Z: 
JOB_MESSAGE_BASIC: Finished operation 
write/Write/WriteImpl/DoOnce/Read+write/Write/WriteImpl/InitializeWrite
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:02.769Z: 
JOB_MESSAGE_DEBUG: Value "write/Write/WriteImpl/DoOnce/Read.out" materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:02.804Z: 
JOB_MESSAGE_DEBUG: Value "write/Write/WriteImpl/InitializeWrite.out" 
materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:02.879Z: 
JOB_MESSAGE_BASIC: Executing operation 
write/Write/WriteImpl/WriteBundles/_UnpickledSideInput(InitializeWrite.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:02.915Z: 
JOB_MESSAGE_BASIC: Executing operation 
write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(InitializeWrite.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:02.930Z: 
JOB_MESSAGE_BASIC: Finished operation 
write/Write/WriteImpl/WriteBundles/_UnpickledSideInput(InitializeWrite.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:02.941Z: 
JOB_MESSAGE_BASIC: Executing operation 
write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(InitializeWrite.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:02.960Z: 
JOB_MESSAGE_BASIC: Finished operation 
write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(InitializeWrite.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:02.987Z: 
JOB_MESSAGE_DEBUG: Value 
"write/Write/WriteImpl/WriteBundles/_UnpickledSideInput(InitializeWrite.out.0).output"
 materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:02.990Z: 
JOB_MESSAGE_BASIC: Finished operation 
write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(InitializeWrite.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:03.022Z: 
JOB_MESSAGE_DEBUG: Value 
"write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(InitializeWrite.out.0).output"
 materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:54:03.062Z: 
JOB_MESSAGE_DEBUG: Value 
"write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(InitializeWrite.out.0).output"
 materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:56:31.238Z: 
JOB_MESSAGE_BASIC: Finished operation 
read/Read+split+pair_with_one+group/Reify+group/Write
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:56:31.290Z: 
JOB_MESSAGE_BASIC: Executing operation group/Close
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:56:31.382Z: 
JOB_MESSAGE_BASIC: Finished operation group/Close
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:56:31.429Z: 
JOB_MESSAGE_BASIC: Executing operation 
group/Read+group/GroupByWindow+count+format+write/Write/WriteImpl/WriteBundles/WriteBundles+write/Write/WriteImpl/Pair+write/Write/WriteImpl/WindowInto(WindowIntoFn)+write/Write/WriteImpl/GroupByKey/Reify+write/Write/WriteImpl/GroupByKey/Write
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:20.328Z: 
JOB_MESSAGE_DETAILED: Checking permissions granted to controller Service 
Account.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:29.379Z: 
JOB_MESSAGE_BASIC: Finished operation 
group/Read+group/GroupByWindow+count+format+write/Write/WriteImpl/WriteBundles/WriteBundles+write/Write/WriteImpl/Pair+write/Write/WriteImpl/WindowInto(WindowIntoFn)+write/Write/WriteImpl/GroupByKey/Reify+write/Write/WriteImpl/GroupByKey/Write
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:29.509Z: 
JOB_MESSAGE_BASIC: Executing operation write/Write/WriteImpl/GroupByKey/Close
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:29.605Z: 
JOB_MESSAGE_BASIC: Finished operation write/Write/WriteImpl/GroupByKey/Close
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:29.658Z: 
JOB_MESSAGE_BASIC: Executing operation 
write/Write/WriteImpl/GroupByKey/Read+write/Write/WriteImpl/GroupByKey/GroupByWindow+write/Write/WriteImpl/Extract
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:33.680Z: 
JOB_MESSAGE_BASIC: Finished operation 
write/Write/WriteImpl/GroupByKey/Read+write/Write/WriteImpl/GroupByKey/GroupByWindow+write/Write/WriteImpl/Extract
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:33.729Z: 
JOB_MESSAGE_DEBUG: Value "write/Write/WriteImpl/Extract.out" materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:33.779Z: 
JOB_MESSAGE_BASIC: Executing operation 
write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(Extract.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:33.798Z: 
JOB_MESSAGE_BASIC: Executing operation 
write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(Extract.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:33.811Z: 
JOB_MESSAGE_BASIC: Finished operation 
write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(Extract.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:33.851Z: 
JOB_MESSAGE_BASIC: Finished operation 
write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(Extract.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:33.859Z: 
JOB_MESSAGE_DEBUG: Value 
"write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(Extract.out.0).output" 
materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:33.898Z: 
JOB_MESSAGE_DEBUG: Value 
"write/Write/WriteImpl/PreFinalize/_UnpickledSideInput(Extract.out.0).output" 
materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:33.940Z: 
JOB_MESSAGE_BASIC: Executing operation 
write/Write/WriteImpl/PreFinalize/PreFinalize
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:36.314Z: 
JOB_MESSAGE_BASIC: Finished operation 
write/Write/WriteImpl/PreFinalize/PreFinalize
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:36.362Z: 
JOB_MESSAGE_DEBUG: Value "write/Write/WriteImpl/PreFinalize.out" materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:36.407Z: 
JOB_MESSAGE_BASIC: Executing operation 
write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(PreFinalize.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:36.450Z: 
JOB_MESSAGE_BASIC: Finished operation 
write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(PreFinalize.out.0)
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:36.498Z: 
JOB_MESSAGE_DEBUG: Value 
"write/Write/WriteImpl/FinalizeWrite/_UnpickledSideInput(PreFinalize.out.0).output"
 materialized.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:36.537Z: 
JOB_MESSAGE_BASIC: Executing operation 
write/Write/WriteImpl/FinalizeWrite/FinalizeWrite
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:39.231Z: 
JOB_MESSAGE_BASIC: Finished operation 
write/Write/WriteImpl/FinalizeWrite/FinalizeWrite
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:39.278Z: 
JOB_MESSAGE_DEBUG: Executing success step success24
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:39.374Z: 
JOB_MESSAGE_DETAILED: Cleaning up.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:39.522Z: 
JOB_MESSAGE_DEBUG: Starting worker pool teardown.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T12:59:39.553Z: 
JOB_MESSAGE_BASIC: Stopping worker pool...
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T13:01:05.691Z: 
JOB_MESSAGE_DETAILED: Autoscaling: Resized worker pool from 10 to 0.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T13:01:05.730Z: 
JOB_MESSAGE_BASIC: Worker pool stopped.
INFO:apache_beam.runners.dataflow.dataflow_runner:2020-03-06T13:01:05.761Z: 
JOB_MESSAGE_DEBUG: Tearing down pending resources...
INFO:apache_beam.runners.dataflow.dataflow_runner:Job 
2020-03-06_04_47_14-11228938863731155602 is in state JOB_STATE_DONE
DEBUG:apache_beam.io.filesystem:Listing files in 
'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results'
DEBUG:apache_beam.io.filesystem:translate_pattern: 
'gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results*-of-*'
 -> 
'gs\\:\\/\\/temp\\-storage\\-for\\-end\\-to\\-end\\-tests\\/py\\-it\\-cloud\\/output\\/1583498831424\\/results[^/\\\\]*\\-of\\-[^/\\\\]*'
INFO:apache_beam.io.gcp.gcsio:Starting the size estimation of the input
INFO:apache_beam.io.gcp.gcsio:Finished listing 31 files in 0.14574337005615234 
seconds.
INFO:apache_beam.testing.pipeline_verifiers:Find 31 files in 
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results*-of-*:
 
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00000-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00001-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00002-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00003-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00004-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00005-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00006-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00007-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00008-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00009-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00010-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00011-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00012-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00013-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00014-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00015-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00016-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00017-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00018-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00019-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00020-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00021-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00022-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00023-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00024-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00025-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00026-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00027-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00028-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00029-of-00031
gs://temp-storage-for-end-to-end-tests/py-it-cloud/output/1583498831424/results-00030-of-00031

IssueCommand timed out after 1200 seconds.  Process was killed by 
perfkitbenchmarker.
2020-03-06 13:06:09,999 5f6c8ee5 MainThread beam_integration_benchmark(1/1) 
ERROR    Benchmark 1/1 beam_integration_benchmark (UID: 
beam_integration_benchmark0) failed. Execution will continue.
2020-03-06 13:06:09,999 5f6c8ee5 MainThread beam_integration_benchmark(1/1) 
INFO     Benchmark run statuses:
---------------------------------------------------------------------------------
Name                        UID                          Status  Failed 
Substatus
---------------------------------------------------------------------------------
beam_integration_benchmark  beam_integration_benchmark0  FAILED                 
 
---------------------------------------------------------------------------------
Success rate: 0.00% (0/1)
2020-03-06 13:06:10,000 5f6c8ee5 MainThread beam_integration_benchmark(1/1) 
INFO     Complete logs can be found at: 
<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py36/ws/runs/5f6c8ee5/pkb.log>
2020-03-06 13:06:10,000 5f6c8ee5 MainThread beam_integration_benchmark(1/1) 
INFO     Completion statuses can be found at: 
<https://builds.apache.org/job/beam_PerformanceTests_WordCountIT_Py36/ws/runs/5f6c8ee5/completion_statuses.json>
Build step 'Execute shell' marked build as failure

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

Reply via email to