Build failed in Jenkins: beam_PostCommit_Python_Verify #8671

Apache Jenkins Server Mon, 08 Jul 2019 12:20:10 -0700

See 
<https://builds.apache.org/job/beam_PostCommit_Python_Verify/8671/display/redirect>


------------------------------------------
[...truncated 975.30 KB...]
[flink-akka.actor.default-dispatcher-7] 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) (1/2) (1156ae6644d34c83587132d7c9c42952) 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) 
(84a932610b194f82011abc61e01257ec) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-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]) (2/2) 
(84a932610b194f82011abc61e01257ec) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-7] 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-3] 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) 
(84a932610b194f82011abc61e01257ec) 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) 
(84a932610b194f82011abc61e01257ec) [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) 
(84a932610b194f82011abc61e01257ec) [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) 
(84a932610b194f82011abc61e01257ec) [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) 
(84a932610b194f82011abc61e01257ec) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-3] 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) 
(84a932610b194f82011abc61e01257ec) 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) 
(1f844e5add8f0b7d1a721bb532b54ffb) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-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) 
(1f844e5add8f0b7d1a721bb532b54ffb) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-7] 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-4] 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) 
(1f844e5add8f0b7d1a721bb532b54ffb) 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) 
(1f844e5add8f0b7d1a721bb532b54ffb) [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) 
(1f844e5add8f0b7d1a721bb532b54ffb) [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) 
(1f844e5add8f0b7d1a721bb532b54ffb) [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) 
(1f844e5add8f0b7d1a721bb532b54ffb) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-4] 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) 
(1f844e5add8f0b7d1a721bb532b54ffb) 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) (2a8768da1c60e5689042f4b6838b4d3d) 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) (2a8768da1c60e5689042f4b6838b4d3d).
[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) (2a8768da1c60e5689042f4b6838b4d3d) [FINISHED]
[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) (aed341d7744559d754bfad9e7b3f2f1a) switched from RUNNING to 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) (aed341d7744559d754bfad9e7b3f2f1a).
[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) (aed341d7744559d754bfad9e7b3f2f1a) [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 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
2a8768da1c60e5689042f4b6838b4d3d.
[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 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
aed341d7744559d754bfad9e7b3f2f1a.
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(2/2) (2a8768da1c60e5689042f4b6838b4d3d) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at 
ExternalTransform(pytest:beam:transforms:count)/Combine.perKey(Count)/Group) 
(1/2) (aed341d7744559d754bfad9e7b3f2f1a) switched from RUNNING to FINISHED.
[jobmanager-future-thread-11] 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) (d505fee35fc2127f5738125154543c61) 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) (d505fee35fc2127f5738125154543c61) 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-3] 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) (d505fee35fc2127f5738125154543c61) 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) (d505fee35fc2127f5738125154543c61) [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) 
(d505fee35fc2127f5738125154543c61) [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) (d505fee35fc2127f5738125154543c61) [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) (d505fee35fc2127f5738125154543c61) switched from 
DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-3] 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) (d505fee35fc2127f5738125154543c61) 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) 
(84a932610b194f82011abc61e01257ec) 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) 
(84a932610b194f82011abc61e01257ec).
[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) 
(84a932610b194f82011abc61e01257ec) [FINISHED]
[flink-akka.actor.default-dispatcher-3] 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]) 
84a932610b194f82011abc61e01257ec.
[flink-akka.actor.default-dispatcher-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]) (2/2) 
(84a932610b194f82011abc61e01257ec) 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) (7221d169309a6a4632c6041b7ddc53ad) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-3] 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) (7221d169309a6a4632c6041b7ddc53ad) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-3] 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) (7221d169309a6a4632c6041b7ddc53ad) 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) (7221d169309a6a4632c6041b7ddc53ad) [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) 
(7221d169309a6a4632c6041b7ddc53ad) [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 - 
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) (7221d169309a6a4632c6041b7ddc53ad) [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 - 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) (7221d169309a6a4632c6041b7ddc53ad) 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-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]) 
(1/2) (7221d169309a6a4632c6041b7ddc53ad) 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)] 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) 
(1f844e5add8f0b7d1a721bb532b54ffb) 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) 
(1f844e5add8f0b7d1a721bb532b54ffb).
[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) 
(1f844e5add8f0b7d1a721bb532b54ffb) [FINISHED]
[flink-akka.actor.default-dispatcher-4] 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]) 
1f844e5add8f0b7d1a721bb532b54ffb.
[flink-akka.actor.default-dispatcher-3] 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) 
(1f844e5add8f0b7d1a721bb532b54ffb) 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) (d505fee35fc2127f5738125154543c61) 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) 
(d505fee35fc2127f5738125154543c61).
[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) (d505fee35fc2127f5738125154543c61) [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 [6]{Map(<lambda at external_test.py:212>), 
Map(<lambda at external_test.py:213>), assert_that}) -> FlatMap (FlatMap at 
ExtractOutput[0]) d505fee35fc2127f5738125154543c61.
[jobmanager-future-thread-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(3019e5342ca791c6070bce051f5793ac) switched from CREATED to SCHEDULED.
[jobmanager-future-thread-4] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(fde3f96f4f065228588885b2882f8341) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(3019e5342ca791c6070bce051f5793ac) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-4] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(fde3f96f4f065228588885b2882f8341) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-4] 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-3] 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-7] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (1/2).
[flink-akka.actor.default-dispatcher-4] 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) (d505fee35fc2127f5738125154543c61) switched from RUNNING to FINISHED.
[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) (3019e5342ca791c6070bce051f5793ac) switched 
from CREATED to DEPLOYING.
[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) (3019e5342ca791c6070bce051f5793ac) [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) 
(3019e5342ca791c6070bce051f5793ac) [DEPLOYING].
[flink-akka.actor.default-dispatcher-7] 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) (fde3f96f4f065228588885b2882f8341) 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) (fde3f96f4f065228588885b2882f8341) [DEPLOYING]
[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) 
(fde3f96f4f065228588885b2882f8341) [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) 
(3019e5342ca791c6070bce051f5793ac) [DEPLOYING].
[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) 
(fde3f96f4f065228588885b2882f8341) [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) (3019e5342ca791c6070bce051f5793ac) 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) (fde3f96f4f065228588885b2882f8341) switched 
from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(3019e5342ca791c6070bce051f5793ac) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(fde3f96f4f065228588885b2882f8341) switched from DEPLOYING to RUNNING.
[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) 
(45f214b663c97e915dcb2162d411c8b5) 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 - 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) (7221d169309a6a4632c6041b7ddc53ad) 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) (45f214b663c97e915dcb2162d411c8b5).
[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) 
(7221d169309a6a4632c6041b7ddc53ad).
[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) 
(8c620fb54a995544fc0ca70aa33f622b) 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) 
(45f214b663c97e915dcb2162d411c8b5) [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) (8c620fb54a995544fc0ca70aa33f622b).
[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) 
(8c620fb54a995544fc0ca70aa33f622b) [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) (7221d169309a6a4632c6041b7ddc53ad) [FINISHED]
[flink-akka.actor.default-dispatcher-4] 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) 
45f214b663c97e915dcb2162d411c8b5.
[flink-akka.actor.default-dispatcher-4] 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) 
8c620fb54a995544fc0ca70aa33f622b.
[flink-akka.actor.default-dispatcher-4] 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]) 7221d169309a6a4632c6041b7ddc53ad.
[flink-akka.actor.default-dispatcher-3] 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) 
(45f214b663c97e915dcb2162d411c8b5) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-3] 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) 
(8c620fb54a995544fc0ca70aa33f622b) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-3] 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) (7221d169309a6a4632c6041b7ddc53ad) switched from RUNNING to FINISHED.
[jobmanager-future-thread-4] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2) 
(1582c1e1a7afc9f77ea81c9edc143a9e) 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}) (2/2) 
(1582c1e1a7afc9f77ea81c9edc143a9e) 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}) (2/2) (attempt #0) to 
localhost
[flink-akka.actor.default-dispatcher-3] 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) (1582c1e1a7afc9f77ea81c9edc143a9e) 
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) (1582c1e1a7afc9f77ea81c9edc143a9e) [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) 
(1582c1e1a7afc9f77ea81c9edc143a9e) [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) 
(1582c1e1a7afc9f77ea81c9edc143a9e) [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) (1582c1e1a7afc9f77ea81c9edc143a9e) 
switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2) 
(1582c1e1a7afc9f77ea81c9edc143a9e) 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) (fde3f96f4f065228588885b2882f8341) switched 
from RUNNING to 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) 
(fde3f96f4f065228588885b2882f8341).
[grpc-default-executor-0] WARN bundle_processor.create_operation - No unique 
name set for transform fn/read/ref_PCollection_PCollection_27:0 
[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) 
(fde3f96f4f065228588885b2882f8341) [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) fde3f96f4f065228588885b2882f8341.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (2/2) 
(fde3f96f4f065228588885b2882f8341) switched from RUNNING to FINISHED.
[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) (3019e5342ca791c6070bce051f5793ac) 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) 
(3019e5342ca791c6070bce051f5793ac).
[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) 
(3019e5342ca791c6070bce051f5793ac) [FINISHED]
[jobmanager-future-thread-14] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) 
(c911151b1f10db5fce329bc2d8e880a9) switched from CREATED to SCHEDULED.
[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 assert_that/Group/GroupByKey) 3019e5342ca791c6070bce051f5793ac.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupReduce 
(GroupReduce at assert_that/Group/GroupByKey) (1/2) 
(3019e5342ca791c6070bce051f5793ac) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) 
(c911151b1f10db5fce329bc2d8e880a9) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] 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-7] 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}) (1/2)] 
INFO org.apache.flink.runtime.taskmanager.Task - MapPartition (MapPartition at 
[3]assert_that/{Group, Unkey, Match}) (1/2) (c911151b1f10db5fce329bc2d8e880a9) 
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) (c911151b1f10db5fce329bc2d8e880a9) [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) 
(c911151b1f10db5fce329bc2d8e880a9) [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) 
(c911151b1f10db5fce329bc2d8e880a9) [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) (c911151b1f10db5fce329bc2d8e880a9) 
switched from DEPLOYING to RUNNING.
[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) (1582c1e1a7afc9f77ea81c9edc143a9e) 
switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) 
(c911151b1f10db5fce329bc2d8e880a9) switched from DEPLOYING to RUNNING.
[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) 
(1582c1e1a7afc9f77ea81c9edc143a9e).
[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) (1582c1e1a7afc9f77ea81c9edc143a9e) 
[FINISHED]
[jobmanager-future-thread-10] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (2/2) (988a99e0723af3dfe3a25c4465a0d1dd) switched from 
CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (2/2) (988a99e0723af3dfe3a25c4465a0d1dd) switched from 
SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying DataSink 
(DiscardingOutput) (2/2) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-4] 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}) 
1582c1e1a7afc9f77ea81c9edc143a9e.
[flink-akka.actor.default-dispatcher-4] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task DataSink 
(DiscardingOutput) (2/2).
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (2/2) 
(1582c1e1a7afc9f77ea81c9edc143a9e) switched from RUNNING to FINISHED.
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - DataSink (DiscardingOutput) (2/2) 
(988a99e0723af3dfe3a25c4465a0d1dd) 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) 
(988a99e0723af3dfe3a25c4465a0d1dd) [DEPLOYING]
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task DataSink 
(DiscardingOutput) (2/2) (988a99e0723af3dfe3a25c4465a0d1dd) [DEPLOYING].
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Registering task at network: 
DataSink (DiscardingOutput) (2/2) (988a99e0723af3dfe3a25c4465a0d1dd) 
[DEPLOYING].
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - DataSink (DiscardingOutput) (2/2) 
(988a99e0723af3dfe3a25c4465a0d1dd) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (2/2) (988a99e0723af3dfe3a25c4465a0d1dd) switched from 
DEPLOYING to RUNNING.
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - DataSink (DiscardingOutput) (2/2) 
(988a99e0723af3dfe3a25c4465a0d1dd) switched from RUNNING to FINISHED.
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Freeing task resources for DataSink 
(DiscardingOutput) (2/2) (988a99e0723af3dfe3a25c4465a0d1dd).
[DataSink (DiscardingOutput) (2/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are 
closed for task DataSink (DiscardingOutput) (2/2) 
(988a99e0723af3dfe3a25c4465a0d1dd) [FINISHED]
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and 
sending final execution state FINISHED to JobManager for task DataSink 
(DiscardingOutput) 988a99e0723af3dfe3a25c4465a0d1dd.
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (2/2) (988a99e0723af3dfe3a25c4465a0d1dd) switched from 
RUNNING to FINISHED.
[grpc-default-executor-0] 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) (c911151b1f10db5fce329bc2d8e880a9) 
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) 
(c911151b1f10db5fce329bc2d8e880a9).
[jobmanager-future-thread-4] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (1/2) (61862425bef65924bc8d1802a7923a89) switched from 
CREATED to SCHEDULED.
[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) (c911151b1f10db5fce329bc2d8e880a9) 
[FINISHED]
[flink-akka.actor.default-dispatcher-3] 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}) 
c911151b1f10db5fce329bc2d8e880a9.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (1/2) (61862425bef65924bc8d1802a7923a89) 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-7] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - MapPartition 
(MapPartition at [3]assert_that/{Group, Unkey, Match}) (1/2) 
(c911151b1f10db5fce329bc2d8e880a9) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-3] 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) 
(61862425bef65924bc8d1802a7923a89) switched from CREATED to DEPLOYING.
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak 
safety net for task DataSink (DiscardingOutput) (1/2) 
(61862425bef65924bc8d1802a7923a89) [DEPLOYING]
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task DataSink 
(DiscardingOutput) (1/2) (61862425bef65924bc8d1802a7923a89) [DEPLOYING].
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Registering task at network: 
DataSink (DiscardingOutput) (1/2) (61862425bef65924bc8d1802a7923a89) 
[DEPLOYING].
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - DataSink (DiscardingOutput) (1/2) 
(61862425bef65924bc8d1802a7923a89) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (1/2) (61862425bef65924bc8d1802a7923a89) switched from 
DEPLOYING to RUNNING.
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - DataSink (DiscardingOutput) (1/2) 
(61862425bef65924bc8d1802a7923a89) switched from RUNNING to FINISHED.
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Freeing task resources for DataSink 
(DiscardingOutput) (1/2) (61862425bef65924bc8d1802a7923a89).
[DataSink (DiscardingOutput) (1/2)] INFO 
org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are 
closed for task DataSink (DiscardingOutput) (1/2) 
(61862425bef65924bc8d1802a7923a89) [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 DataSink 
(DiscardingOutput) 61862425bef65924bc8d1802a7923a89.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - DataSink 
(DiscardingOutput) (1/2) (61862425bef65924bc8d1802a7923a89) switched from 
RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.executiongraph.ExecutionGraph - Job 
BeamApp-root-0708191926-4afbeb39 (c8100453c3f7c52bf51c28aa75bbb4ae) switched 
from state RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Job 
c8100453c3f7c52bf51c28aa75bbb4ae 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-0708191926-4afbeb39(c8100453c3f7c52bf51c28aa75bbb4ae).
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager 
connection for job c8100453c3f7c52bf51c28aa75bbb4ae.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.jobmaster.JobMaster - Close ResourceManager connection 
2466f422c1de09e8b13fb2a31883860d: JobManager is shutting down..
[flink-akka.actor.default-dispatcher-4] INFO 
org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Suspending SlotPool.
[flink-runner-job-invoker] INFO 
org.apache.flink.runtime.minicluster.MiniCluster - Shutting down Flink Mini 
Cluster
[flink-akka.actor.default-dispatcher-4] INFO 
org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Stopping SlotPool.
[flink-runner-job-invoker] INFO 
org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Shutting down rest 
endpoint.
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Disconnect 
job manager b74ec8cc8adf174abaab84b64a2941c5@akka://flink/user/jobmanager_1 for 
job c8100453c3f7c52bf51c28aa75bbb4ae from the resource manager.
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping dispatcher 
akka://flink/user/dispatcher4baa2bf8-f2b5-45c0-bcb7-325793f4941d.
[flink-akka.actor.default-dispatcher-3] INFO 
org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping all 
currently running jobs of dispatcher 
akka://flink/user/dispatcher4baa2bf8-f2b5-45c0-bcb7-325793f4941d.
[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{52a17f5f4a2993e63f992968e6447cf5}, jobId: 
c8100453c3f7c52bf51c28aa75bbb4ae).
[flink-akka.actor.default-dispatcher-4] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - JobManager for job 
c8100453c3f7c52bf51c28aa75bbb4ae with leader id 
b74ec8cc8adf174abaab84b64a2941c5 lost leadership.
[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{a6e3b5db38723f37fde11585d961cab0}, jobId: 
c8100453c3f7c52bf51c28aa75bbb4ae).
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.JobLeaderService - Remove job 
c8100453c3f7c52bf51c28aa75bbb4ae from job leader monitoring.
[flink-akka.actor.default-dispatcher-7] INFO 
org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager 
connection for job c8100453c3f7c52bf51c28aa75bbb4ae.
[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-95bc144e-aee7-4511-8908-2502d709e035
[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-5] INFO 
org.apache.flink.runtime.rest.handler.legacy.backpressure.StackTraceSampleCoordinator
 - Shutting down stack trace sample coordinator.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopped dispatcher 
akka://flink/user/dispatcher4baa2bf8-f2b5-45c0-bcb7-325793f4941d.
[flink-akka.actor.default-dispatcher-5] INFO 
org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Closing the 
SlotManager.
[flink-akka.actor.default-dispatcher-5] 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:44897
[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 15990 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}: 0, 
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}: 4, 
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}: 
0, 
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}: 4, 
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}: 
0, 
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}: 0, 
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_2a5a0bbb-c3d1-4ee3-8b93-b750b9189268/MANIFEST 
has 0 artifact locations
[flink-runner-job-invoker] INFO 
org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactStagingService
 - Removed dir 
/tmp/beam-artifact-staging/job_2a5a0bbb-c3d1-4ee3-8b93-b750b9189268/

> 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: 181

* 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 1h 14m 30s
105 actionable tasks: 81 executed, 21 from cache, 3 up-to-date

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

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

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

Build failed in Jenkins: beam_PostCommit_Python_Verify #8671

Reply via email to