Build failed in Jenkins: beam_PostCommit_Python_Verify #8750

[Apache Jenkins Server]

See 
<https://builds.apache.org/job/beam_PostCommit_Python_Verify/8750/display/redirect?page=changes>

Changes:

[alireza4263] [BEAM-7545] Reordering Beam Joins and check if the produced join 
is

[udim] [BEAM-7484] Metrics collection in BigQuery perf tests (#8766)

------------------------------------------
[...truncated 1.00 MB...]
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at 
[3]{ExternalTransform(pytest:beam:transforms:filter_less_than), 
ExternalTransform(pytest:beam:transforms:count)}) -> FlatMap (FlatMap at 
ExtractOutput[0]) -> Map (Key Extractor) -> GroupCombine (GroupCombine at 
GroupCombine: 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) -> 
Map (Key Extractor) (2/2) (f4a6a0eaf39e9feb2c686c4e5e82ec08) switched from 
RUNNING to FINISHED.
[jobmanager-future-thread-13] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) (attempt #0) 
to localhost
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2).
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0) switched from CREATED to DEPLOYING.
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak 
safety net for task CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0) [DEPLOYING]
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0) [DEPLOYING].
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Registering task at network: CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0) [DEPLOYING].
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0) switched from DEPLOYING to RUNNING.
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2)] WARN 
org.apache.flink.metrics.MetricGroup - The operator name MapPartition 
(MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) exceeded the 80 characters length limit and was truncated.
[jobmanager-future-thread-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) (attempt #0) 
to localhost
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2).
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab) switched from CREATED to DEPLOYING.
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak 
safety net for task CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab) [DEPLOYING]
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab) [DEPLOYING].
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Registering task at network: CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab) [DEPLOYING].
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab) switched from DEPLOYING to RUNNING.
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2)] WARN 
org.apache.flink.metrics.MetricGroup - The operator name MapPartition 
(MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) exceeded the 80 characters length limit and was truncated.
[GroupReduce (GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(2/2)] INFO org.apache.flink.runtime.taskmanager.Task - GroupReduce 
(GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(2/2) (1b3caed6be01159d9773e1fa0bff33e9) switched from RUNNING to FINISHED.
[GroupReduce (GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(2/2)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources 
for GroupReduce (GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(2/2) (1b3caed6be01159d9773e1fa0bff33e9).
[GroupReduce (GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(1/2)] INFO org.apache.flink.runtime.taskmanager.Task - GroupReduce 
(GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(1/2) (1c128ac10f21b3ae297840ee64be3e1f) switched from RUNNING to FINISHED.
[GroupReduce (GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(2/2)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem 
streams are closed for task GroupReduce (GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(2/2) (1b3caed6be01159d9773e1fa0bff33e9) [FINISHED]
[GroupReduce (GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(1/2)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources 
for GroupReduce (GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(1/2) (1c128ac10f21b3ae297840ee64be3e1f).
[GroupReduce (GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(1/2)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem 
streams are closed for task GroupReduce (GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(1/2) (1c128ac10f21b3ae297840ee64be3e1f) [FINISHED]
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task GroupReduce 
(GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
1b3caed6be01159d9773e1fa0bff33e9.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task GroupReduce 
(GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
1c128ac10f21b3ae297840ee64be3e1f.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(2/2) (1b3caed6be01159d9773e1fa0bff33e9) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(1/2) (1c128ac10f21b3ae297840ee64be3e1f) switched from RUNNING to FINISHED.
[jobmanager-future-thread-8] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(2/2) (56efabd7dbf34d09889135e8b582bd94) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(2/2) (56efabd7dbf34d09889135e8b582bd94) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2).
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2)] INFO org.apache.flink.runtime.taskmanager.Task - CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2) (56efabd7dbf34d09889135e8b582bd94) switched from 
CREATED to DEPLOYING.
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2)] INFO org.apache.flink.runtime.taskmanager.Task - 
Creating FileSystem stream leak safety net for task CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(2/2) (56efabd7dbf34d09889135e8b582bd94) [DEPLOYING]
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2)] INFO org.apache.flink.runtime.taskmanager.Task - 
Loading JAR files for task CHAIN MapPartition (MapPartition at [6]{Map(<lambda 
at external_test.py:212>), Map(<lambda at external_test.py:213>), assert_that}) 
-> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(56efabd7dbf34d09889135e8b582bd94) [DEPLOYING].
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2)] INFO org.apache.flink.runtime.taskmanager.Task - 
Registering task at network: CHAIN MapPartition (MapPartition at 
[6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(2/2) (56efabd7dbf34d09889135e8b582bd94) [DEPLOYING].
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2)] INFO org.apache.flink.runtime.taskmanager.Task - CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2) (56efabd7dbf34d09889135e8b582bd94) switched from 
DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(2/2) (56efabd7dbf34d09889135e8b582bd94) switched from DEPLOYING to RUNNING.
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2)] WARN org.apache.flink.metrics.MetricGroup - The 
operator name MapPartition (MapPartition at [6]{Map(<lambda at 
external_test.py:212>), Map(<lambda at external_test.py:213>), assert_that}) 
exceeded the 80 characters length limit and was truncated.
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0) switched from RUNNING to FINISHED.
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Freeing task resources for CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0).
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are 
closed for task CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0) [FINISHED]
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) 
abdcef6b1f00ea0844d62acfa01a0de0.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(abdcef6b1f00ea0844d62acfa01a0de0) switched from RUNNING to FINISHED.
[jobmanager-future-thread-12] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(1/2) (f6680df541b53d3ba187241f9e1a45b8) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(1/2) (f6680df541b53d3ba187241f9e1a45b8) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2).
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2)] INFO org.apache.flink.runtime.taskmanager.Task - CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2) (f6680df541b53d3ba187241f9e1a45b8) switched from 
CREATED to DEPLOYING.
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2)] INFO org.apache.flink.runtime.taskmanager.Task - 
Creating FileSystem stream leak safety net for task CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(1/2) (f6680df541b53d3ba187241f9e1a45b8) [DEPLOYING]
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2)] INFO org.apache.flink.runtime.taskmanager.Task - 
Loading JAR files for task CHAIN MapPartition (MapPartition at [6]{Map(<lambda 
at external_test.py:212>), Map(<lambda at external_test.py:213>), assert_that}) 
-> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(f6680df541b53d3ba187241f9e1a45b8) [DEPLOYING].
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab) switched from RUNNING to FINISHED.
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Freeing task resources for CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab).
[CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are 
closed for task CHAIN MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab) [FINISHED]
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2)] INFO org.apache.flink.runtime.taskmanager.Task - 
Registering task at network: CHAIN MapPartition (MapPartition at 
[6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(1/2) (f6680df541b53d3ba187241f9e1a45b8) [DEPLOYING].
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task CHAIN 
MapPartition (MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) 
404e9f1f062b25b5b5a78c2f666714ab.
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2)] INFO org.apache.flink.runtime.taskmanager.Task - CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2) (f6680df541b53d3ba187241f9e1a45b8) switched from 
DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(1/2) (f6680df541b53d3ba187241f9e1a45b8) switched from DEPLOYING to RUNNING.
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2)] WARN org.apache.flink.metrics.MetricGroup - The 
operator name MapPartition (MapPartition at [6]{Map(<lambda at 
external_test.py:212>), Map(<lambda at external_test.py:213>), assert_that}) 
exceeded the 80 characters length limit and was truncated.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at 
[2]ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/{Merge,
 ExtractOutputs}) -> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(404e9f1f062b25b5b5a78c2f666714ab) switched from RUNNING to FINISHED.
[grpc-default-executor-0] WARN bundle_processor.create_operation - No unique 
name set for transform fn/write/ref_PCollection_PCollection_24:0:0 
[grpc-default-executor-0] WARN bundle_processor.create_operation - No unique 
name set for transform fn/write/ref_PCollection_PCollection_24:0:0 
[grpc-default-executor-0] WARN bundle_processor.create_operation - No unique 
name set for transform fn/read/ref_PCollection_PCollection_14:0 
[grpc-default-executor-0] WARN bundle_processor.create_operation - No unique 
name set for transform fn/read/ref_PCollection_PCollection_14:0 
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2)] INFO org.apache.flink.runtime.taskmanager.Task - CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2) (56efabd7dbf34d09889135e8b582bd94) switched from 
RUNNING to FINISHED.
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2)] INFO org.apache.flink.runtime.taskmanager.Task - 
Freeing task resources for CHAIN MapPartition (MapPartition at [6]{Map(<lambda 
at external_test.py:212>), Map(<lambda at external_test.py:213>), assert_that}) 
-> FlatMap (FlatMap at ExtractOutput[0]) (2/2) 
(56efabd7dbf34d09889135e8b582bd94).
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (2/2)] INFO org.apache.flink.runtime.taskmanager.Task - 
Ensuring all FileSystem streams are closed for task CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(2/2) (56efabd7dbf34d09889135e8b582bd94) [FINISHED]
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) 56efabd7dbf34d09889135e8b582bd94.
[jobmanager-future-thread-16] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(c38aaa8c8801aff9eda95f314627dfaa) switched from CREATED to SCHEDULED.
[jobmanager-future-thread-8] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(e2d1343e3261c47f91edb8895cfafd03) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(e2d1343e3261c47f91edb8895cfafd03) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (2/2) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(c38aaa8c8801aff9eda95f314627dfaa) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (1/2) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (2/2).
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - GroupReduce (GroupReduce at 
assert_that/Group/GroupByKey) (2/2) (e2d1343e3261c47f91edb8895cfafd03) switched 
from CREATED to DEPLOYING.
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak 
safety net for task GroupReduce (GroupReduce at assert_that/Group/GroupByKey) 
(2/2) (e2d1343e3261c47f91edb8895cfafd03) [DEPLOYING]
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(2/2) (56efabd7dbf34d09889135e8b582bd94) switched from RUNNING to FINISHED.
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task 
GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(e2d1343e3261c47f91edb8895cfafd03) [DEPLOYING].
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (1/2).
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Registering task at network: 
GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(e2d1343e3261c47f91edb8895cfafd03) [DEPLOYING].
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - GroupReduce (GroupReduce at 
assert_that/Group/GroupByKey) (2/2) (e2d1343e3261c47f91edb8895cfafd03) switched 
from DEPLOYING to RUNNING.
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - GroupReduce (GroupReduce at 
assert_that/Group/GroupByKey) (1/2) (c38aaa8c8801aff9eda95f314627dfaa) switched 
from CREATED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(e2d1343e3261c47f91edb8895cfafd03) switched from DEPLOYING to RUNNING.
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak 
safety net for task GroupReduce (GroupReduce at assert_that/Group/GroupByKey) 
(1/2) (c38aaa8c8801aff9eda95f314627dfaa) [DEPLOYING]
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task 
GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(c38aaa8c8801aff9eda95f314627dfaa) [DEPLOYING].
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Registering task at network: 
GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(c38aaa8c8801aff9eda95f314627dfaa) [DEPLOYING].
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - GroupReduce (GroupReduce at 
assert_that/Group/GroupByKey) (1/2) (c38aaa8c8801aff9eda95f314627dfaa) switched 
from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(c38aaa8c8801aff9eda95f314627dfaa) switched from DEPLOYING to RUNNING.
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2)] INFO org.apache.flink.runtime.taskmanager.Task - CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2) (f6680df541b53d3ba187241f9e1a45b8) switched from 
RUNNING to FINISHED.
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2)] INFO org.apache.flink.runtime.taskmanager.Task - 
Freeing task resources for CHAIN MapPartition (MapPartition at [6]{Map(<lambda 
at external_test.py:212>), Map(<lambda at external_test.py:213>), assert_that}) 
-> FlatMap (FlatMap at ExtractOutput[0]) (1/2) 
(f6680df541b53d3ba187241f9e1a45b8).
[CHAIN Filter (UnionFixFilter) -> Map (Key Extractor) -> GroupCombine 
(GroupCombine at GroupCombine: assert_that/Group/GroupByKey) -> Map (Key 
Extractor) (2/2)] INFO org.apache.flink.runtime.taskmanager.Task - CHAIN Filter 
(UnionFixFilter) -> Map (Key Extractor) -> GroupCombine (GroupCombine at 
GroupCombine: assert_that/Group/GroupByKey) -> Map (Key Extractor) (2/2) 
(41b5db8e49fd1fbc7254ea9e7804b9e9) switched from RUNNING to FINISHED.
[CHAIN Filter (UnionFixFilter) -> Map (Key Extractor) -> GroupCombine 
(GroupCombine at GroupCombine: assert_that/Group/GroupByKey) -> Map (Key 
Extractor) (2/2)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task 
resources for CHAIN Filter (UnionFixFilter) -> Map (Key Extractor) -> 
GroupCombine (GroupCombine at GroupCombine: assert_that/Group/GroupByKey) -> 
Map (Key Extractor) (2/2) (41b5db8e49fd1fbc7254ea9e7804b9e9).
[CHAIN Filter (UnionFixFilter) -> Map (Key Extractor) -> GroupCombine 
(GroupCombine at GroupCombine: assert_that/Group/GroupByKey) -> Map (Key 
Extractor) (1/2)] INFO org.apache.flink.runtime.taskmanager.Task - CHAIN Filter 
(UnionFixFilter) -> Map (Key Extractor) -> GroupCombine (GroupCombine at 
GroupCombine: assert_that/Group/GroupByKey) -> Map (Key Extractor) (1/2) 
(c45ab594486668be0a7461f8194c048b) switched from RUNNING to FINISHED.
[CHAIN MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) (1/2)] INFO org.apache.flink.runtime.taskmanager.Task - 
Ensuring all FileSystem streams are closed for task CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(1/2) (f6680df541b53d3ba187241f9e1a45b8) [FINISHED]
[CHAIN Filter (UnionFixFilter) -> Map (Key Extractor) -> GroupCombine 
(GroupCombine at GroupCombine: assert_that/Group/GroupByKey) -> Map (Key 
Extractor) (1/2)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task 
resources for CHAIN Filter (UnionFixFilter) -> Map (Key Extractor) -> 
GroupCombine (GroupCombine at GroupCombine: assert_that/Group/GroupByKey) -> 
Map (Key Extractor) (1/2) (c45ab594486668be0a7461f8194c048b).
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task CHAIN 
MapPartition (MapPartition at [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) f6680df541b53d3ba187241f9e1a45b8.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN MapPartition 
(MapPartition at [6]{Map(<lambda at external_test.py:212>), Map(<lambda at 
external_test.py:213>), assert_that}) -> FlatMap (FlatMap at ExtractOutput[0]) 
(1/2) (f6680df541b53d3ba187241f9e1a45b8) switched from RUNNING to FINISHED.
[CHAIN Filter (UnionFixFilter) -> Map (Key Extractor) -> GroupCombine 
(GroupCombine at GroupCombine: assert_that/Group/GroupByKey) -> Map (Key 
Extractor) (1/2)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all 
FileSystem streams are closed for task CHAIN Filter (UnionFixFilter) -> Map 
(Key Extractor) -> GroupCombine (GroupCombine at GroupCombine: 
assert_that/Group/GroupByKey) -> Map (Key Extractor) (1/2) 
(c45ab594486668be0a7461f8194c048b) [FINISHED]
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task CHAIN Filter 
(UnionFixFilter) -> Map (Key Extractor) -> GroupCombine (GroupCombine at 
GroupCombine: assert_that/Group/GroupByKey) -> Map (Key Extractor) 
c45ab594486668be0a7461f8194c048b.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN Filter 
(UnionFixFilter) -> Map (Key Extractor) -> GroupCombine (GroupCombine at 
GroupCombine: assert_that/Group/GroupByKey) -> Map (Key Extractor) (1/2) 
(c45ab594486668be0a7461f8194c048b) switched from RUNNING to FINISHED.
[CHAIN Filter (UnionFixFilter) -> Map (Key Extractor) -> GroupCombine 
(GroupCombine at GroupCombine: assert_that/Group/GroupByKey) -> Map (Key 
Extractor) (2/2)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all 
FileSystem streams are closed for task CHAIN Filter (UnionFixFilter) -> Map 
(Key Extractor) -> GroupCombine (GroupCombine at GroupCombine: 
assert_that/Group/GroupByKey) -> Map (Key Extractor) (2/2) 
(41b5db8e49fd1fbc7254ea9e7804b9e9) [FINISHED]
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task CHAIN Filter 
(UnionFixFilter) -> Map (Key Extractor) -> GroupCombine (GroupCombine at 
GroupCombine: assert_that/Group/GroupByKey) -> Map (Key Extractor) 
41b5db8e49fd1fbc7254ea9e7804b9e9.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - CHAIN Filter 
(UnionFixFilter) -> Map (Key Extractor) -> GroupCombine (GroupCombine at 
GroupCombine: assert_that/Group/GroupByKey) -> Map (Key Extractor) (2/2) 
(41b5db8e49fd1fbc7254ea9e7804b9e9) switched from RUNNING to FINISHED.
[jobmanager-future-thread-3] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2) 
(50f039daa825eeeff47727811f375449) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2) 
(50f039daa825eeeff47727811f375449) switched from SCHEDULED to DEPLOYING.
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - GroupReduce (GroupReduce at 
assert_that/Group/GroupByKey) (1/2) (c38aaa8c8801aff9eda95f314627dfaa) switched 
from RUNNING to FINISHED.
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Freeing task resources for 
GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(c38aaa8c8801aff9eda95f314627dfaa).
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2) (attempt #0) to 
localhost
[jobmanager-future-thread-11] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) 
(e03e47b1c6bf83ecf5ed8582e91e10da) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) 
(e03e47b1c6bf83ecf5ed8582e91e10da) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) (attempt #0) to 
localhost
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2).
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - MapPartition (MapPartition at 
[3]assert_that/{Group, Unkey, Match}) (2/2) (50f039daa825eeeff47727811f375449) 
switched from CREATED to DEPLOYING.
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream 
leak safety net for task MapPartition (MapPartition at [3]assert_that/{Group, 
Unkey, Match}) (2/2) (50f039daa825eeeff47727811f375449) [DEPLOYING]
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task 
MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2) 
(50f039daa825eeeff47727811f375449) [DEPLOYING].
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: 
MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2) 
(50f039daa825eeeff47727811f375449) [DEPLOYING].
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2).
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - MapPartition (MapPartition at 
[3]assert_that/{Group, Unkey, Match}) (2/2) (50f039daa825eeeff47727811f375449) 
switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2) 
(50f039daa825eeeff47727811f375449) switched from DEPLOYING to RUNNING.
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - MapPartition (MapPartition at 
[3]assert_that/{Group, Unkey, Match}) (1/2) (e03e47b1c6bf83ecf5ed8582e91e10da) 
switched from CREATED to DEPLOYING.
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream 
leak safety net for task MapPartition (MapPartition at [3]assert_that/{Group, 
Unkey, Match}) (1/2) (e03e47b1c6bf83ecf5ed8582e91e10da) [DEPLOYING]
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task 
MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) 
(e03e47b1c6bf83ecf5ed8582e91e10da) [DEPLOYING].
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: 
MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) 
(e03e47b1c6bf83ecf5ed8582e91e10da) [DEPLOYING].
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - MapPartition (MapPartition at 
[3]assert_that/{Group, Unkey, Match}) (1/2) (e03e47b1c6bf83ecf5ed8582e91e10da) 
switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) 
(e03e47b1c6bf83ecf5ed8582e91e10da) switched from DEPLOYING to RUNNING.
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - GroupReduce (GroupReduce at 
assert_that/Group/GroupByKey) (2/2) (e2d1343e3261c47f91edb8895cfafd03) switched 
from RUNNING to FINISHED.
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are 
closed for task GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(c38aaa8c8801aff9eda95f314627dfaa) [FINISHED]
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Freeing task resources for 
GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(e2d1343e3261c47f91edb8895cfafd03).
[GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are 
closed for task GroupReduce (GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(e2d1343e3261c47f91edb8895cfafd03) [FINISHED]
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) c38aaa8c8801aff9eda95f314627dfaa.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) e2d1343e3261c47f91edb8895cfafd03.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(c38aaa8c8801aff9eda95f314627dfaa) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(e2d1343e3261c47f91edb8895cfafd03) switched from RUNNING to FINISHED.
[grpc-default-executor-1] WARN bundle_processor.create_operation - No unique 
name set for transform fn/read/ref_PCollection_PCollection_27:0 
[grpc-default-executor-1] WARN bundle_processor.create_operation - No unique 
name set for transform fn/read/ref_PCollection_PCollection_27:0 
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - MapPartition (MapPartition at 
[3]assert_that/{Group, Unkey, Match}) (1/2) (e03e47b1c6bf83ecf5ed8582e91e10da) 
switched from RUNNING to FINISHED.
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for 
MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) 
(e03e47b1c6bf83ecf5ed8582e91e10da).
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem 
streams are closed for task MapPartition (MapPartition at 
[3]assert_that/{Group, Unkey, Match}) (1/2) (e03e47b1c6bf83ecf5ed8582e91e10da) 
[FINISHED]
[jobmanager-future-thread-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (1/2) (5f88aeb0433664f1ca08c25fe1419866) switched from 
CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) 
e03e47b1c6bf83ecf5ed8582e91e10da.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (1/2) (5f88aeb0433664f1ca08c25fe1419866) switched from 
SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying DataSink 
(DiscardingOutput) (1/2) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task DataSink 
(DiscardingOutput) (1/2).
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - DataSink (DiscardingOutput) (1/2) 
(5f88aeb0433664f1ca08c25fe1419866) switched from CREATED to DEPLOYING.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) 
(e03e47b1c6bf83ecf5ed8582e91e10da) switched from RUNNING to FINISHED.
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak 
safety net for task DataSink (DiscardingOutput) (1/2) 
(5f88aeb0433664f1ca08c25fe1419866) [DEPLOYING]
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task DataSink 
(DiscardingOutput) (1/2) (5f88aeb0433664f1ca08c25fe1419866) [DEPLOYING].
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Registering task at network: 
DataSink (DiscardingOutput) (1/2) (5f88aeb0433664f1ca08c25fe1419866) 
[DEPLOYING].
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - MapPartition (MapPartition at 
[3]assert_that/{Group, Unkey, Match}) (2/2) (50f039daa825eeeff47727811f375449) 
switched from RUNNING to FINISHED.
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for 
MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2) 
(50f039daa825eeeff47727811f375449).
[MapPartition (MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem 
streams are closed for task MapPartition (MapPartition at 
[3]assert_that/{Group, Unkey, Match}) (2/2) (50f039daa825eeeff47727811f375449) 
[FINISHED]
[jobmanager-future-thread-15] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (2/2) (2bbc3e11dc7a8ed1568a1ee8d064cd1f) switched from 
CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) 
50f039daa825eeeff47727811f375449.
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - DataSink (DiscardingOutput) (1/2) 
(5f88aeb0433664f1ca08c25fe1419866) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (1/2) (5f88aeb0433664f1ca08c25fe1419866) switched from 
DEPLOYING to RUNNING.
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - DataSink (DiscardingOutput) (1/2) 
(5f88aeb0433664f1ca08c25fe1419866) switched from RUNNING to FINISHED.
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Freeing task resources for DataSink 
(DiscardingOutput) (1/2) (5f88aeb0433664f1ca08c25fe1419866).
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are 
closed for task DataSink (DiscardingOutput) (1/2) 
(5f88aeb0433664f1ca08c25fe1419866) [FINISHED]
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2) 
(50f039daa825eeeff47727811f375449) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task DataSink 
(DiscardingOutput) 5f88aeb0433664f1ca08c25fe1419866.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (1/2) (5f88aeb0433664f1ca08c25fe1419866) switched from 
RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (2/2) (2bbc3e11dc7a8ed1568a1ee8d064cd1f) switched from 
SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying DataSink 
(DiscardingOutput) (2/2) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task DataSink 
(DiscardingOutput) (2/2).
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - DataSink (DiscardingOutput) (2/2) 
(2bbc3e11dc7a8ed1568a1ee8d064cd1f) switched from CREATED to DEPLOYING.
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak 
safety net for task DataSink (DiscardingOutput) (2/2) 
(2bbc3e11dc7a8ed1568a1ee8d064cd1f) [DEPLOYING]
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task DataSink 
(DiscardingOutput) (2/2) (2bbc3e11dc7a8ed1568a1ee8d064cd1f) [DEPLOYING].
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Registering task at network: 
DataSink (DiscardingOutput) (2/2) (2bbc3e11dc7a8ed1568a1ee8d064cd1f) 
[DEPLOYING].
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - DataSink (DiscardingOutput) (2/2) 
(2bbc3e11dc7a8ed1568a1ee8d064cd1f) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (2/2) (2bbc3e11dc7a8ed1568a1ee8d064cd1f) switched from 
DEPLOYING to RUNNING.
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - DataSink (DiscardingOutput) (2/2) 
(2bbc3e11dc7a8ed1568a1ee8d064cd1f) switched from RUNNING to FINISHED.
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Freeing task resources for DataSink 
(DiscardingOutput) (2/2) (2bbc3e11dc7a8ed1568a1ee8d064cd1f).
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are 
closed for task DataSink (DiscardingOutput) (2/2) 
(2bbc3e11dc7a8ed1568a1ee8d064cd1f) [FINISHED]
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task DataSink 
(DiscardingOutput) 2bbc3e11dc7a8ed1568a1ee8d064cd1f.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (2/2) (2bbc3e11dc7a8ed1568a1ee8d064cd1f) switched from 
RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Job 
BeamApp-root-0718015717-7956dbcf (8f28f47e1f23c857082b9b3cf40b1aa7) switched 
from state RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Job 
8f28f47e1f23c857082b9b3cf40b1aa7 reached globally terminal state FINISHED.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.jobmaster.JobMaster - Stopping the JobMaster for job 
BeamApp-root-0718015717-7956dbcf(8f28f47e1f23c857082b9b3cf40b1aa7).
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager 
connection for job 8f28f47e1f23c857082b9b3cf40b1aa7.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.jobmaster.JobMaster - Close ResourceManager connection 
bb77af429e88b451591664d5aaeeddc3: JobManager is shutting down..
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Suspending SlotPool.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Stopping SlotPool.
[flink-runner-job-invoker] INFO 
org.apache.flink.runtime.minicluster.MiniCluster - Shutting down Flink Mini 
Cluster
[flink-runner-job-invoker] INFO 
org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Shutting down rest 
endpoint.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping dispatcher 
akka://flink/user/dispatcher83930161-b6eb-423d-9fec-7d3577fab99f.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping all 
currently running jobs of dispatcher 
akka://flink/user/dispatcher83930161-b6eb-423d-9fec-7d3577fab99f.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Disconnect 
job manager b2ee166d5c4a3c47cbb6a0162a944d61@akka://flink/user/jobmanager_1 for 
job 8f28f47e1f23c857082b9b3cf40b1aa7 from the resource manager.
[flink-akka.actor.default-dispatcher-8] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - JobManager for job 
8f28f47e1f23c857082b9b3cf40b1aa7 with leader id 
b2ee166d5c4a3c47cbb6a0162a944d61 lost leadership.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.slot.TaskSlotTable - Free slot 
TaskSlot(index:1, state:ALLOCATED, resource profile: 
ResourceProfile{cpuCores=1.0, heapMemoryInMB=42, directMemoryInMB=0, 
nativeMemoryInMB=0, networkMemoryInMB=0}, allocationId: 
AllocationID{9467131559eb75743f599ba7b931e8b1}, jobId: 
8f28f47e1f23c857082b9b3cf40b1aa7).
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.rest.handler.legacy.backpressure.StackTraceSampleCoordinator
 - Shutting down stack trace sample coordinator.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.slot.TaskSlotTable - Free slot 
TaskSlot(index:0, state:ALLOCATED, resource profile: 
ResourceProfile{cpuCores=1.0, heapMemoryInMB=42, directMemoryInMB=0, 
nativeMemoryInMB=0, networkMemoryInMB=0}, allocationId: 
AllocationID{eaa2f74c897b856c748c65ed764cc822}, jobId: 
8f28f47e1f23c857082b9b3cf40b1aa7).
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopped dispatcher 
akka://flink/user/dispatcher83930161-b6eb-423d-9fec-7d3577fab99f.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.JobLeaderService - Remove job 
8f28f47e1f23c857082b9b3cf40b1aa7 from job leader monitoring.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager 
connection for job 8f28f47e1f23c857082b9b3cf40b1aa7.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Stopping TaskExecutor 
akka://flink/user/taskmanager_0.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.state.TaskExecutorLocalStateStoresManager - Shutting 
down TaskExecutorLocalStateStoresManager.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.io.disk.iomanager.IOManager - I/O manager removed 
spill file directory /tmp/flink-io-4d7a103c-dd25-496b-b67a-24955716619a
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.io.network.NetworkEnvironment - Shutting down the 
network environment and its components.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Closing the 
SlotManager.
[flink-akka.actor.default-dispatcher-6] INFO 
org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Suspending 
the SlotManager.
[ForkJoinPool.commonPool-worker-2] INFO 
org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Removing cache 
directory /tmp/flink-web-ui
[ForkJoinPool.commonPool-worker-2] INFO 
org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Shut down complete.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.JobLeaderService - Stop job leader 
service.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Stopped TaskExecutor 
akka://flink/user/taskmanager_0.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.rpc.akka.AkkaRpcService - Stopping Akka RPC service.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.blob.PermanentBlobCache - Shutting down BLOB cache
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.blob.TransientBlobCache - Shutting down BLOB cache
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.blob.BlobServer - Stopped BLOB server at 0.0.0.0:35753
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.rpc.akka.AkkaRpcService - Stopped Akka RPC service.
[flink-runner-job-invoker] INFO org.apache.beam.runners.flink.FlinkRunner - 
Execution finished in 20764 msecs
[flink-runner-job-invoker] INFO org.apache.beam.runners.flink.FlinkRunner - 
Final accumulator values:
[flink-runner-job-invoker] INFO org.apache.beam.runners.flink.FlinkRunner - 
__metricscontainers : 
MetricQueryResults(Counters(ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Flatten_34}: 0, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_27:0}: 0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 
{PTRANSFORM=ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Precombine}:
 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_9:0}: 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_9:0}: 0, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_27:0}: 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_9:0}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/ToVoidKey_30}: 0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=external_2root/Init/Map/ParMultiDo(Anonymous)}: 0, 
ref_PCollection_PCollection_14:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_24:0:0}: 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_12:0}: 0, 
ref_PCollection_PCollection_12:beam:metric:element_count:v1 
{PCOLLECTION=pcollection}: 5, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 
{PTRANSFORM=ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Precombine}:
 0, 
ref_PCollection_PCollection_1:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_1:0}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/ToVoidKey_30}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_14:0}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_14:0}: 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_12:0}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Flatten_34}: 0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 
{PTRANSFORM=ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Precombine}:
 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:213>)_22}: 
0, 
ref_PCollection_PCollection_9:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Create/Map(decode)_16}: 0, 
ref_PCollection_PCollection_17:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_18}: 1, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_24:0:0}: 0, 
ref_PCollection_PCollection_17:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_19}: 1, 
ref_PCollection_PCollection_17:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Create/Map(decode)_28}: 0, 
ref_PCollection_PCollection_17:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_17}: 1, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_24:0:0}: 0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=external_2root/Init/Map/ParMultiDo(Anonymous)}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Create/FlatMap(<lambda at 
core.py:2257>)_26}: 0, 
pcollection_1:beam:metric:pardo_execution_time:start_bundle_msecs:v1 
{PTRANSFORM=fn/write/ref_PCollection_PCollection_14:0}: 0, 
pcollection_1:beam:metric:pardo_execution_time:finish_bundle_msecs:v1 
{PTRANSFORM=fn/write/ref_PCollection_PCollection_14:0}: 0, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Match_41}: 0, 
pcollection_1:beam:metric:element_count:v1 {PCOLLECTION=pcollection_1}: 3, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_14:0}: 0, 
ref_PCollection_PCollection_17:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_24:1}: 1, 
ref_PCollection_PCollection_1:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_2:0}: 0, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Match_41}: 0, 
ref_PCollection_PCollection_1:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_1}: 1, 
ref_PCollection_PCollection_14:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Flatten_34}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/WindowInto(WindowIntoFn)_29}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/ToVoidKey_30}: 0, 
ref_PCollection_PCollection_1:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_2}: 12, 
pcollection_1:beam:metric:element_count:v1 {PCOLLECTION=pcollection_2}: 3, 
ref_PCollection_PCollection_17:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Create/FlatMap(<lambda at 
core.py:2257>)_26}: 0, 
ref_PCollection_PCollection_27:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_30}: 1, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:213>)_22}: 
0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:213>)_22}: 
0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Flatten_34}: 0, 
ref_PCollection_PCollection_14:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_14:0}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/WindowInto(WindowIntoFn)_29}: 0, 
pcollection_1:beam:metric:pardo_execution_time:finish_bundle_msecs:v1 
{PTRANSFORM=fn/read/pcollection_1:0}: 0, 
ref_PCollection_PCollection_17:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/pair_with_0_32}: 4, 
ref_PCollection_PCollection_17:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_24:1:0}: 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(unicode)_17}: 0, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Unkey_40}: 0, 
ref_PCollection_PCollection_14:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:213>)_22}: 
0, pcollection_1:beam:metric:pardo_execution_time:process_bundle_msecs:v1 
{PTRANSFORM=ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Merge}:
 0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=external_2root/Init/Map/ParMultiDo(Anonymous)}: 0, 
ref_PCollection_PCollection_1:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Create/FlatMap(<lambda at core.py:2257>)_4}: 
4, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 
{PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Map(_merge_tagged_vals_under_key)_39}:
 0, 
ref_PCollection_PCollection_9:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(unicode)_17}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/WindowInto(WindowIntoFn)_29}: 0, 
ref_PCollection_PCollection_27:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_27:0}: 0, 
ref_PCollection_PCollection_14:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/ToVoidKey_30}: 0, 
ref_PCollection_PCollection_27:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Unkey_40}: 0, 
pcollection_1:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_14}: 3, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_27:0}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Create/FlatMap(<lambda at 
core.py:2257>)_26}: 0, 
ref_PCollection_PCollection_14:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/pair_with_1_33}: 7, 
ref_PCollection_PCollection_17:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_22}: 1, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:212>)_21}: 
0, ref_PCollection_PCollection_27:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_28}: 1, 
ref_PCollection_PCollection_17:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_17:0}: 0, 
ref_PCollection_PCollection_27:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_29}: 1, 
ref_PCollection_PCollection_12:beam:metric:element_count:v1 
{PCOLLECTION=external_2root/Init/Map/ParMultiDo(Anonymous).output}: 6, 
ref_PCollection_PCollection_27:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_27}: 1, 
pcollection_1:beam:metric:pardo_execution_time:start_bundle_msecs:v1 
{PTRANSFORM=fn/read/pcollection_1:0}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Create/FlatMap(<lambda at 
core.py:2257>)_26}: 0, 
pcollection_1:beam:metric:pardo_execution_time:process_bundle_msecs:v1 
{PTRANSFORM=ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/ExtractOutputs}:
 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(unicode)_17}: 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:208>)_18}: 
0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Create/Map(decode)_16}: 0, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 
{PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Map(_merge_tagged_vals_under_key)_39}:
 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Flatten_34}: 0, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 
{PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Map(_merge_tagged_vals_under_key)_39}:
 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Flatten_34}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_24:1:0}: 0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=fn/write/pcollection:0}: 0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_12:0}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_24:1:0}: 0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=fn/write/pcollection:0}: 0, 
ref_PCollection_PCollection_12:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_13}: 6, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:212>)_21}: 
0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Create/Map(decode)_16}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:212>)_21}: 
0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=fn/write/pcollection:0}: 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(unicode)_17}: 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:208>)_18}: 
2, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Unkey_40}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/pair_with_0_32}: 0, 
ref_PCollection_PCollection_1:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_1:0}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/pair_with_0_32}: 0, 
ref_PCollection_PCollection_14:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_14}: 3, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_12:0}: 0, 
ref_PCollection_PCollection_9:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_9}: 12, 
ref_PCollection_PCollection_14:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_16}: 3, 
ref_PCollection_PCollection_1:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_1:0}: 0, 
ref_PCollection_PCollection_14:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_15}: 3, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Flatten_34}: 0, 
ref_PCollection_PCollection_1:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_2:0}: 0, 
ref_PCollection_PCollection_17:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Flatten_34}: 0, 
ref_PCollection_PCollection_12:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_12}: 12, 
ref_PCollection_PCollection_14:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:212>)_21}: 
0, 
ref_PCollection_PCollection_1:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_1:0}: 0, 
ref_PCollection_PCollection_9:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_9:0}: 0, 
ref_PCollection_PCollection_1:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Create/FlatMap(<lambda at core.py:2257>)_4}: 
0, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Unkey_40}: 0, 
ref_PCollection_PCollection_14:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_24:0}: 3, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:208>)_18}: 
0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/pair_with_1_33}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/pair_with_1_33}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Create/Map(decode)_28}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Create/Map(decode)_28}: 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_12:0}: 0, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/pair_with_1_33}: 7, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_17:0}: 0, 
ref_PCollection_PCollection_27:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Match_41}: 0, 
ref_PCollection_PCollection_1:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Create/FlatMap(<lambda at core.py:2257>)_4}: 
4, 
ref_PCollection_PCollection_9:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Map(<lambda at external_test.py:208>)_18}: 
2, 
ref_PCollection_PCollection_14:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_24:0:0}: 0, 
ref_PCollection_PCollection_1:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Create/FlatMap(<lambda at core.py:2257>)_4}: 
0, 
ref_PCollection_PCollection_1:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_2:0}: 0, 
ref_PCollection_PCollection_9:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_12:0}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_17:0}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Create/Map(decode)_28}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Group/pair_with_0_32}: 4, 
ref_PCollection_PCollection_14:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_23}: 3, 
ref_PCollection_PCollection_27:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/Match_41}: 0, 
ref_PCollection_PCollection_14:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_20}: 3, 
pcollection_1:beam:metric:pardo_execution_time:process_bundle_msecs:v1 
{PTRANSFORM=fn/write/ref_PCollection_PCollection_14:0}: 0, 
ref_PCollection_PCollection_14:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_21}: 3, 
ref_PCollection_PCollection_9:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_11}: 12, 
ref_PCollection_PCollection_9:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_12}: 12, 
ref_PCollection_PCollection_9:beam:metric:element_count:v1 
{PCOLLECTION=ref_PCollection_PCollection_10}: 12, 
ref_PCollection_PCollection_27:beam:metric:ptransform_execution_time:total_msecs:v1
 
{PTRANSFORM=ref_AppliedPTransform_assert_that/Group/Map(_merge_tagged_vals_under_key)_39}:
 0, 
ref_PCollection_PCollection_1:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_2:0}: 0, 
ref_PCollection_PCollection_14:beam:metric:ptransform_execution_time:total_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_assert_that/WindowInto(WindowIntoFn)_29}: 0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:finish_bundle_msecs:v1
 {PTRANSFORM=external_1root/ParDo(Anonymous)/ParMultiDo(Anonymous)}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=fn/read/ref_PCollection_PCollection_17:0}: 0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=external_1root/ParDo(Anonymous)/ParMultiDo(Anonymous)}: 0, 
ref_PCollection_PCollection_12:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=external_1root/ParDo(Anonymous)/ParMultiDo(Anonymous)}: 0, 
ref_PCollection_PCollection_9:beam:metric:pardo_execution_time:start_bundle_msecs:v1
 {PTRANSFORM=ref_AppliedPTransform_Create/Map(decode)_16}: 0, 
ref_PCollection_PCollection_17:beam:metric:pardo_execution_time:process_bundle_msecs:v1
 {PTRANSFORM=fn/write/ref_PCollection_PCollection_24:1:0}: 
0)Distributions(ref_PCollection_PCollection_14:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_16}: DistributionResult{sum=54, 
count=3, min=18, max=18}, 
ref_PCollection_PCollection_14:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_15}: DistributionResult{sum=51, 
count=3, min=17, max=17}, 
ref_PCollection_PCollection_14:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_14}: DistributionResult{sum=45, 
count=3, min=15, max=15}, 
ref_PCollection_PCollection_27:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_30}: DistributionResult{sum=14, 
count=1, min=14, max=14}, 
ref_PCollection_PCollection_17:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_24:1}: DistributionResult{sum=19, 
count=1, min=19, max=19}, 
ref_PCollection_PCollection_17:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_17}: DistributionResult{sum=13, 
count=1, min=13, max=13}, 
ref_PCollection_PCollection_17:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_18}: DistributionResult{sum=16, 
count=1, min=16, max=16}, 
ref_PCollection_PCollection_14:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_24:0}: DistributionResult{sum=72, 
count=3, min=24, max=24}, 
ref_PCollection_PCollection_17:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_19}: DistributionResult{sum=15, 
count=1, min=15, max=15}, 
ref_PCollection_PCollection_9:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_9}: DistributionResult{sum=192, 
count=12, min=16, max=16}, 
ref_PCollection_PCollection_17:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_22}: DistributionResult{sum=17, 
count=1, min=17, max=17}, 
ref_PCollection_PCollection_9:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_10}: DistributionResult{sum=168, 
count=12, min=14, max=14}, 
ref_PCollection_PCollection_9:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_12}: DistributionResult{sum=168, 
count=12, min=14, max=14}, 
ref_PCollection_PCollection_9:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_11}: DistributionResult{sum=168, 
count=12, min=14, max=14}, 
ref_PCollection_PCollection_1:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_1}: DistributionResult{sum=13, 
count=1, min=13, max=13}, 
ref_PCollection_PCollection_27:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_27}: DistributionResult{sum=58, 
count=1, min=58, max=58}, 
ref_PCollection_PCollection_27:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_28}: DistributionResult{sum=41, 
count=1, min=41, max=41}, 
ref_PCollection_PCollection_14:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_23}: DistributionResult{sum=63, 
count=3, min=21, max=21}, 
ref_PCollection_PCollection_27:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_29}: DistributionResult{sum=33, 
count=1, min=33, max=33}, 
ref_PCollection_PCollection_1:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_2}: DistributionResult{sum=180, 
count=12, min=15, max=15}, 
ref_PCollection_PCollection_14:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_21}: DistributionResult{sum=57, 
count=3, min=19, max=19}, 
ref_PCollection_PCollection_14:beam:metric:sampled_byte_size:v1 
{PCOLLECTION=ref_PCollection_PCollection_20}: DistributionResult{sum=54, 
count=3, min=18, max=18}))
[flink-runner-job-invoker] INFO 
org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService
 - Manifest at 
/tmp/beam-artifact-staging/job_7d0f0138-8cfa-4176-98f9-cd3ad9b0d7c4/MANIFEST 
has 0 artifact locations
[flink-runner-job-invoker] INFO 
org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactStagingService
 - Removed dir 
/tmp/beam-artifact-staging/job_7d0f0138-8cfa-4176-98f9-cd3ad9b0d7c4/

> Task :sdks:python:crossLanguageTests

FAILURE: Build failed with an exception.

* Where:
Build file 
'<https://builds.apache.org/job/beam_PostCommit_Python_Verify/ws/src/sdks/python/build.gradle'>
 line: 184

* What went wrong:
Execution failed for task ':sdks:python:postCommitIT'.
> 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 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 55m 34s
105 actionable tasks: 81 executed, 21 from cache, 3 up-to-date

Publishing build scan...
https://gradle.com/s/4dngumzmbeelw

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

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