Build failed in Jenkins: beam_PostCommit_Python_VR_Flink #1050

[Apache Jenkins Server <je...@builds.apache.org>]

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

Changes:

[scott] [BEAM-6138] Add User Counter Metric Support to Java SDK (#6799)

------------------------------------------
[...truncated 3.92 MB...]
[flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Starting job dispatcher(s) for JobManger
[flink-runner-job-server] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Starting RPC endpoint for org.apache.flink.runtime.dispatcher.StandaloneDispatcher at akka://flink/user/dispatcher266aacf8-4c06-48e8-912c-da9277cf848a .
[flink-runner-job-server] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Proposing leadership to contender org.apache.flink.runtime.dispatcher.StandaloneDispatcher@68254bd9 @ akka://flink/user/dispatcher266aacf8-4c06-48e8-912c-da9277cf848a
[flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Flink Mini Cluster started successfully
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Dispatcher akka://flink/user/dispatcher266aacf8-4c06-48e8-912c-da9277cf848a was granted leadership with fencing token 57a17bcd-e466-4e15-8b66-a92dcaa72904
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Recovering all persisted jobs.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader akka://flink/user/dispatcher266aacf8-4c06-48e8-912c-da9277cf848a , session=57a17bcd-e466-4e15-8b66-a92dcaa72904
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Submitting job fb8f4ab54847f33ccd6f1e61d6a041d8 (test_windowing_1544725863.68).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Starting RPC endpoint for org.apache.flink.runtime.jobmaster.JobMaster at akka://flink/user/jobmanager_43 .
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Initializing job test_windowing_1544725863.68 (fb8f4ab54847f33ccd6f1e61d6a041d8).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Using restart strategy NoRestartStrategy for test_windowing_1544725863.68 (fb8f4ab54847f33ccd6f1e61d6a041d8).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Starting RPC endpoint for org.apache.flink.runtime.jobmaster.slotpool.SlotPool at akka://flink/user/fb15fd8b-8248-4732-9808-315932710474 .
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job recovers via failover strategy: full graph restart
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Running initialization on master for job test_windowing_1544725863.68 (fb8f4ab54847f33ccd6f1e61d6a041d8).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Successfully ran initialization on master in 0 ms.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Proposing leadership to contender org.apache.flink.runtime.jobmaster.JobManagerRunner@1cd9cff2 @ akka://flink/user/jobmanager_43
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.JobManagerRunner - JobManager runner for job test_windowing_1544725863.68 (fb8f4ab54847f33ccd6f1e61d6a041d8) was granted leadership with session id 4e4e4bb4-6aa4-420d-b59e-8d56b38e8af6 at akka://flink/user/jobmanager_43.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - Starting execution of job test_windowing_1544725863.68 (fb8f4ab54847f33ccd6f1e61d6a041d8)
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544725863.68 (fb8f4ab54847f33ccd6f1e61d6a041d8) switched from state CREATED to RUNNING.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Cannot serve slot request, no ResourceManager connected. Adding as pending request [SlotRequestId{6023ee4a84cebe4d8cc81d26eea4cd19}]
[jobmanager-future-thread-1] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader akka://flink/user/jobmanager_43 , session=4e4e4bb4-6aa4-420d-b59e-8d56b38e8af6
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - Connecting to ResourceManager akka://flink/user/resourcemanager_b912b97f-8d47-4d1a-be59-c16760fd84e6(a4dedad49319b06e2ba4073f241a467c)
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.JobMaster - Resolved ResourceManager address, beginning registration
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.JobMaster - Registration at ResourceManager attempt 1 (timeout=100ms)
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Registering job manager b59e8d56b38e8af64e4e4bb46aa4420d@akka://flink/user/jobmanager_43 for job fb8f4ab54847f33ccd6f1e61d6a041d8.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Registered job manager b59e8d56b38e8af64e4e4bb46aa4420d@akka://flink/user/jobmanager_43 for job fb8f4ab54847f33ccd6f1e61d6a041d8.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - JobManager successfully registered at ResourceManager, leader id: a4dedad49319b06e2ba4073f241a467c.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Requesting new slot [SlotRequestId{6023ee4a84cebe4d8cc81d26eea4cd19}] and profile ResourceProfile{cpuCores=-1.0, heapMemoryInMB=-1, directMemoryInMB=0, nativeMemoryInMB=0, networkMemoryInMB=0} from resource manager.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Request slot with profile ResourceProfile{cpuCores=-1.0, heapMemoryInMB=-1, directMemoryInMB=0, nativeMemoryInMB=0, networkMemoryInMB=0} for job fb8f4ab54847f33ccd6f1e61d6a041d8 with allocation id AllocationID{e7fa0aa7bdef85c0a510da26013ceda6}.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Receive slot request AllocationID{e7fa0aa7bdef85c0a510da26013ceda6} for job fb8f4ab54847f33ccd6f1e61d6a041d8 from resource manager with leader id a4dedad49319b06e2ba4073f241a467c.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Allocated slot for AllocationID{e7fa0aa7bdef85c0a510da26013ceda6}.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Add job fb8f4ab54847f33ccd6f1e61d6a041d8 for job leader monitoring.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Try to register at job manager akka://flink/user/jobmanager_43 with leader id 4e4e4bb4-6aa4-420d-b59e-8d56b38e8af6.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Resolved JobManager address, beginning registration
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Registration at JobManager attempt 1 (timeout=100ms)
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Successful registration at job manager akka://flink/user/jobmanager_43 for job fb8f4ab54847f33ccd6f1e61d6a041d8.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Establish JobManager connection for job fb8f4ab54847f33ccd6f1e61d6a041d8.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Offer reserved slots to the leader of job fb8f4ab54847f33ccd6f1e61d6a041d8.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.slot.TaskSlotTable - Activate slot AllocationID{e7fa0aa7bdef85c0a510da26013ceda6}.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task Source: Impulse -> [4]assert_that/{Create, Group} (1/1).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (attempt #0) to localhost
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c) switched from CREATED to DEPLOYING.
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c) [DEPLOYING]
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c) [DEPLOYING].
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying ToKeyedWorkItem (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (attempt #0) to localhost
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c) [DEPLOYING].
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc) switched from CREATED to DEPLOYING.
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc) [DEPLOYING]
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc) [DEPLOYING].
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc) [DEPLOYING].
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c) switched from DEPLOYING to RUNNING.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028) switched from CREATED to DEPLOYING.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028) [DEPLOYING]
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028) [DEPLOYING].
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028) [DEPLOYING].
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1).
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025) switched from CREATED to DEPLOYING.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025) [DEPLOYING]
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025) [DEPLOYING].
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc) switched from DEPLOYING to RUNNING.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025) [DEPLOYING].
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task ToKeyedWorkItem (1/1).
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025) switched from DEPLOYING to RUNNING.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a) switched from CREATED to DEPLOYING.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028) switched from DEPLOYING to RUNNING.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a) [DEPLOYING]
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a) [DEPLOYING].
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1).
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a) [DEPLOYING].
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025) switched from DEPLOYING to RUNNING.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028) switched from DEPLOYING to RUNNING.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d) switched from CREATED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a) switched from DEPLOYING to RUNNING.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d) [DEPLOYING]
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d) [DEPLOYING].
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d) [DEPLOYING].
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d) switched from DEPLOYING to RUNNING.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] WARN org.apache.flink.metrics.MetricGroup - The operator name [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} exceeded the 80 characters length limit and was truncated.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d) switched from DEPLOYING to RUNNING.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.state.heap.HeapKeyedStateBackend - Initializing heap keyed state backend with stream factory.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.state.heap.HeapKeyedStateBackend - Initializing heap keyed state backend with stream factory.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.state.heap.HeapKeyedStateBackend - Initializing heap keyed state backend with stream factory.
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] WARN org.apache.beam.runners.fnexecution.environment.DockerCommand - Unable to pull docker image jenkins-docker-apache.bintray.io/beam/python:latest, cause: Received exit code 1 for command 'docker pull jenkins-docker-apache.bintray.io/beam/python:latest'. stderr: Error response from daemon: unknown: Repo 'apache' was not found
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - GetManifest for /tmp/flinktestTq6pcP/job_ae4a8571-5824-4ff1-9aa0-bfb8804a61f3/MANIFEST
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Loading manifest for retrieval token /tmp/flinktestTq6pcP/job_ae4a8571-5824-4ff1-9aa0-bfb8804a61f3/MANIFEST
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Manifest at /tmp/flinktestTq6pcP/job_ae4a8571-5824-4ff1-9aa0-bfb8804a61f3/MANIFEST has 0 artifact locations
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - GetManifest for /tmp/flinktestTq6pcP/job_ae4a8571-5824-4ff1-9aa0-bfb8804a61f3/MANIFEST -> 0 artifacts
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.logging.GrpcLoggingService - Beam Fn Logging client connected.
[grpc-default-executor-2] INFO sdk_worker_main.main - Logging handler created.
[grpc-default-executor-2] INFO sdk_worker_main.start - Status HTTP server running at localhost:38151
[grpc-default-executor-2] INFO sdk_worker_main.main - semi_persistent_directory: /tmp
[grpc-default-executor-2] WARN sdk_worker_main._load_main_session - No session file found: /tmp/staged/pickled_main_session. Functions defined in __main__ (interactive session) may fail. 
[grpc-default-executor-2] INFO pipeline_options.get_all_options - Parsing unknown args: [u'--direct_runner_use_stacked_bundle', u'--options_id=22', u'--pipeline_type_check', u'--sdk_worker_parallelism=1']
[grpc-default-executor-2] INFO sdk_worker_main.main - Python sdk harness started with pipeline_options: {'runner': u'None', 'streaming': True, 'experiments': [u'beam_fn_api'], 'environment_type': u'DOCKER', 'sdk_location': u'container', 'flink_master': '[auto]', 'direct_runner_use_stacked_bundle': None, 'sdk_worker_parallelism': u'1', 'job_name': u'test_windowing_1544725863.68', 'options_id': u'22', 'pipeline_type_check': None, 'parallelism': 1, 'job_endpoint': u'localhost:44253'}
[grpc-default-executor-2] INFO sdk_worker.__init__ - Creating insecure control channel.
[grpc-default-executor-2] INFO sdk_worker.__init__ - Control channel established.
[grpc-default-executor-2] INFO sdk_worker.__init__ - Initializing SDKHarness with 12 workers.
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.control.FnApiControlClientPoolService - Beam Fn Control client connected with id 1
[grpc-default-executor-2] INFO sdk_worker.create_state_handler - Creating channel for localhost:38091
[grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_4:0 
[grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_24:1:0 
[grpc-default-executor-2] INFO data_plane.create_data_channel - Creating channel for localhost:37999
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.data.GrpcDataService - Beam Fn Data client connected.
[grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_17:0 
[grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_1:0 
[grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_12:0 
[grpc-default-executor-1] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_7:0 
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc) switched from RUNNING to FINISHED.
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc).
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc) [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 Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem 2fbf60ddbd2fd0b44a98e31ab804f4dc.
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c) switched from RUNNING to FINISHED.
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c).
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c) [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 Source: Impulse -> [4]assert_that/{Create, Group} db7bf48daa3734c0acd7a2d20d1e191c.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2fbf60ddbd2fd0b44a98e31ab804f4dc) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (db7bf48daa3734c0acd7a2d20d1e191c) switched from RUNNING to FINISHED.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028) switched from RUNNING to FINISHED.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028).
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028) [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 Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem cc623533a848b472ad2ad1e9f5c27028.
[flink-akka.actor.default-dispatcher-6] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (cc623533a848b472ad2ad1e9f5c27028) switched from RUNNING to FINISHED.
[grpc-default-executor-1] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_24:0:0 
[grpc-default-executor-1] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_15:0 
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025) switched from RUNNING to FINISHED.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025).
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025) [FINISHED]
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and sending final execution state FINISHED to JobManager for task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} a18e827b3c77d730826e579e5f0a8025.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (a18e827b3c77d730826e579e5f0a8025) switched from RUNNING to FINISHED.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a) switched from RUNNING to FINISHED.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a).
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a) [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 ToKeyedWorkItem 4a1d4ac0af041f0547972afe4863047a.
[flink-akka.actor.default-dispatcher-6] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (4a1d4ac0af041f0547972afe4863047a) 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] INFO sdk_worker.run - No more requests from control plane
[grpc-default-executor-1] INFO sdk_worker.run - SDK Harness waiting for in-flight requests to complete
[grpc-default-executor-1] INFO data_plane.close - Closing all cached grpc data channels.
[grpc-default-executor-1] INFO sdk_worker.close - Closing all cached gRPC state handlers.
[grpc-default-executor-1] INFO sdk_worker.run - Done consuming work.
[grpc-default-executor-1] INFO sdk_worker_main.main - Python sdk harness exiting.
[grpc-default-executor-1] WARN org.apache.beam.sdk.fn.data.BeamFnDataGrpcMultiplexer - Hanged up for unknown endpoint.
[grpc-default-executor-1] INFO org.apache.beam.runners.fnexecution.logging.GrpcLoggingService - Logging client hanged up.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] WARN org.apache.beam.sdk.fn.data.BeamFnDataGrpcMultiplexer - Hanged up for unknown endpoint.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d) switched from RUNNING to FINISHED.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d).
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d) [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 assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} fd994dc10544d37f54fc29ee4eda740d.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (fd994dc10544d37f54fc29ee4eda740d) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544725863.68 (fb8f4ab54847f33ccd6f1e61d6a041d8) switched from state RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.checkpoint.CheckpointCoordinator - Stopping checkpoint coordinator for job fb8f4ab54847f33ccd6f1e61d6a041d8.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.checkpoint.StandaloneCompletedCheckpointStore - Shutting down
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Job fb8f4ab54847f33ccd6f1e61d6a041d8 reached globally terminal state FINISHED.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.JobMaster - Stopping the JobMaster for job test_windowing_1544725863.68(fb8f4ab54847f33ccd6f1e61d6a041d8).
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.JobMaster - Close ResourceManager connection c200ec3b3468f02aebeaad06d7a04b8c: JobManager is shutting down..
[flink-akka.actor.default-dispatcher-6] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job fb8f4ab54847f33ccd6f1e61d6a041d8.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Suspending SlotPool.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Stopping SlotPool.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Disconnect job manager b59e8d56b38e8af64e4e4bb46aa4420d@akka://flink/user/jobmanager_43 for job fb8f4ab54847f33ccd6f1e61d6a041d8 from the resource manager.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - JobManager for job fb8f4ab54847f33ccd6f1e61d6a041d8 with leader id b59e8d56b38e8af64e4e4bb46aa4420d lost leadership.
[flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Shutting down Flink Mini Cluster
[flink-runner-job-server] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Shutting down rest endpoint.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping dispatcher akka://flink/user/dispatcher266aacf8-4c06-48e8-912c-da9277cf848a.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping all currently running jobs of dispatcher akka://flink/user/dispatcher266aacf8-4c06-48e8-912c-da9277cf848a.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Closing the SlotManager.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Suspending the SlotManager.
[flink-akka.actor.default-dispatcher-6] 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{e7fa0aa7bdef85c0a510da26013ceda6}, jobId: fb8f4ab54847f33ccd6f1e61d6a041d8).
[flink-akka.actor.default-dispatcher-6] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Remove job fb8f4ab54847f33ccd6f1e61d6a041d8 from job leader monitoring.
[flink-akka.actor.default-dispatcher-6] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job fb8f4ab54847f33ccd6f1e61d6a041d8.
[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-6] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job fb8f4ab54847f33ccd6f1e61d6a041d8.
[flink-akka.actor.default-dispatcher-6] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Stopping TaskExecutor akka://flink/user/taskmanager_42.
[flink-akka.actor.default-dispatcher-6] INFO org.apache.flink.runtime.state.TaskExecutorLocalStateStoresManager - Shutting down TaskExecutorLocalStateStoresManager.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopped dispatcher akka://flink/user/dispatcher266aacf8-4c06-48e8-912c-da9277cf848a.
[flink-akka.actor.default-dispatcher-6] INFO org.apache.flink.runtime.io.disk.iomanager.IOManager - I/O manager removed spill file directory /tmp/flink-io-fd97699c-afec-45fd-b9df-bbf9b9e8582e
[flink-akka.actor.default-dispatcher-6] 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.taskexecutor.JobLeaderService - Stop job leader service.
[flink-akka.actor.default-dispatcher-6] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Stopped TaskExecutor akka://flink/user/taskmanager_42.
[ForkJoinPool.commonPool-worker-9] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Removing cache directory /tmp/flink-web-ui
[ForkJoinPool.commonPool-worker-9] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Stopping Akka RPC service.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.blob.PermanentBlobCache - Shutting down BLOB cache
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.blob.TransientBlobCache - Shutting down BLOB cache
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.blob.BlobServer - Stopped BLOB server at 0.0.0.0:35977
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Stopped Akka RPC service.
[flink-runner-job-server] INFO org.apache.beam.runners.flink.FlinkRunner - Execution finished in 3295 msecs
[flink-runner-job-server] INFO org.apache.beam.runners.flink.FlinkRunner - Final accumulator values:
[flink-runner-job-server] INFO org.apache.beam.runners.flink.FlinkRunner - __metricscontainers : org.apache.beam.runners.core.metrics.MetricsContainerStepMap@69fd690c
INFO:root:Job state changed to DONE
.
----------------------------------------------------------------------
Ran 27 tests in 95.208s

OK (skipped=7)
:beam-sdks-python:flinkCompatibilityMatrixStreamingDOCKER (Thread[Task worker for ':' Thread 6,5,main]) completed. Took 1 mins 37.546 secs.

FAILURE: Build failed with an exception.

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

* What went wrong:
Execution failed for task ':beam-sdks-python:flinkCompatibilityMatrixBatchDOCKER'.
> Process 'command 'sh'' finished with non-zero exit value 1

* Try:
Run with --stacktrace option to get the stack trace. Run with --debug option to get more log output. Run with --scan to get full insights.

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

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

BUILD FAILED in 16m 12s
60 actionable tasks: 55 executed, 4 from cache, 1 up-to-date

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

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

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

Jenkins build is back to normal : beam_PostCommit_Python_VR_Flink #1053

[Apache Jenkins Server <je...@builds.apache.org>]

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


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

Build failed in Jenkins: beam_PostCommit_Python_VR_Flink #1052

[Apache Jenkins Server <je...@builds.apache.org>]

See <https://builds.apache.org/job/beam_PostCommit_Python_VR_Flink/1052/display/redirect>

------------------------------------------
[...truncated 3.93 MB...]
[flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Starting job dispatcher(s) for JobManger
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - http://localhost:38579 was granted leadership with leaderSessionID=c21a8e06-c6a3-46e5-8d2b-48e8e254fd74
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader http://localhost:38579 , session=c21a8e06-c6a3-46e5-8d2b-48e8e254fd74
[flink-runner-job-server] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Starting RPC endpoint for org.apache.flink.runtime.dispatcher.StandaloneDispatcher at akka://flink/user/dispatcher38da3fa5-a582-4400-8bac-7b953af92d34 .
[flink-runner-job-server] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Proposing leadership to contender org.apache.flink.runtime.dispatcher.StandaloneDispatcher@6eee0ab4 @ akka://flink/user/dispatcher38da3fa5-a582-4400-8bac-7b953af92d34
[flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Flink Mini Cluster started successfully
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Dispatcher akka://flink/user/dispatcher38da3fa5-a582-4400-8bac-7b953af92d34 was granted leadership with fencing token fdd5e34b-2544-4d91-9c6d-6b5b15c4fdd0
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Recovering all persisted jobs.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader akka://flink/user/dispatcher38da3fa5-a582-4400-8bac-7b953af92d34 , session=fdd5e34b-2544-4d91-9c6d-6b5b15c4fdd0
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Submitting job d5bb96915e53b086b1e5a1657df21aa2 (test_windowing_1544746389.08).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Starting RPC endpoint for org.apache.flink.runtime.jobmaster.JobMaster at akka://flink/user/jobmanager_43 .
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Initializing job test_windowing_1544746389.08 (d5bb96915e53b086b1e5a1657df21aa2).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Using restart strategy NoRestartStrategy for test_windowing_1544746389.08 (d5bb96915e53b086b1e5a1657df21aa2).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Starting RPC endpoint for org.apache.flink.runtime.jobmaster.slotpool.SlotPool at akka://flink/user/5865ef8e-6dd7-4371-b169-7ca142f04611 .
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job recovers via failover strategy: full graph restart
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Running initialization on master for job test_windowing_1544746389.08 (d5bb96915e53b086b1e5a1657df21aa2).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Successfully ran initialization on master in 0 ms.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Proposing leadership to contender org.apache.flink.runtime.jobmaster.JobManagerRunner@d752eab @ akka://flink/user/jobmanager_43
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobManagerRunner - JobManager runner for job test_windowing_1544746389.08 (d5bb96915e53b086b1e5a1657df21aa2) was granted leadership with session id 147c26fe-aa95-44bc-b580-e2ae1d273296 at akka://flink/user/jobmanager_43.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.JobMaster - Starting execution of job test_windowing_1544746389.08 (d5bb96915e53b086b1e5a1657df21aa2)
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544746389.08 (d5bb96915e53b086b1e5a1657df21aa2) switched from state CREATED to RUNNING.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Cannot serve slot request, no ResourceManager connected. Adding as pending request [SlotRequestId{a446a3234a4b160f650aba32a0f06d13}]
[jobmanager-future-thread-1] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader akka://flink/user/jobmanager_43 , session=147c26fe-aa95-44bc-b580-e2ae1d273296
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.JobMaster - Connecting to ResourceManager akka://flink/user/resourcemanager_b4ee92f5-eb68-4d8e-a7f6-13943f1fb02b(a636ba372a14a876e05956a7ddd847a1)
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Resolved ResourceManager address, beginning registration
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Registration at ResourceManager attempt 1 (timeout=100ms)
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Registering job manager b580e2ae1d273296147c26feaa9544bc@akka://flink/user/jobmanager_43 for job d5bb96915e53b086b1e5a1657df21aa2.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Registered job manager b580e2ae1d273296147c26feaa9544bc@akka://flink/user/jobmanager_43 for job d5bb96915e53b086b1e5a1657df21aa2.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - JobManager successfully registered at ResourceManager, leader id: a636ba372a14a876e05956a7ddd847a1.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Requesting new slot [SlotRequestId{a446a3234a4b160f650aba32a0f06d13}] and profile ResourceProfile{cpuCores=-1.0, heapMemoryInMB=-1, directMemoryInMB=0, nativeMemoryInMB=0, networkMemoryInMB=0} from resource manager.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Request slot with profile ResourceProfile{cpuCores=-1.0, heapMemoryInMB=-1, directMemoryInMB=0, nativeMemoryInMB=0, networkMemoryInMB=0} for job d5bb96915e53b086b1e5a1657df21aa2 with allocation id AllocationID{20702459c8b000c3ebcfaeafb4b56a9e}.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Receive slot request AllocationID{20702459c8b000c3ebcfaeafb4b56a9e} for job d5bb96915e53b086b1e5a1657df21aa2 from resource manager with leader id a636ba372a14a876e05956a7ddd847a1.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Allocated slot for AllocationID{20702459c8b000c3ebcfaeafb4b56a9e}.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Add job d5bb96915e53b086b1e5a1657df21aa2 for job leader monitoring.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Try to register at job manager akka://flink/user/jobmanager_43 with leader id 147c26fe-aa95-44bc-b580-e2ae1d273296.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Resolved JobManager address, beginning registration
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Registration at JobManager attempt 1 (timeout=100ms)
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Successful registration at job manager akka://flink/user/jobmanager_43 for job d5bb96915e53b086b1e5a1657df21aa2.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Establish JobManager connection for job d5bb96915e53b086b1e5a1657df21aa2.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Offer reserved slots to the leader of job d5bb96915e53b086b1e5a1657df21aa2.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.slot.TaskSlotTable - Activate slot AllocationID{20702459c8b000c3ebcfaeafb4b56a9e}.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying ToKeyedWorkItem (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task Source: Impulse -> [4]assert_that/{Create, Group} (1/1).
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (attempt #0) to localhost
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0) switched from CREATED to DEPLOYING.
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0) [DEPLOYING]
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1).
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0) [DEPLOYING].
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e) switched from CREATED to DEPLOYING.
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e) [DEPLOYING]
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e) [DEPLOYING].
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0) [DEPLOYING].
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e) [DEPLOYING].
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1).
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09) switched from CREATED to DEPLOYING.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09) [DEPLOYING]
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09) [DEPLOYING].
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09) [DEPLOYING].
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1).
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e) switched from CREATED to DEPLOYING.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e) [DEPLOYING]
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e) [DEPLOYING].
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task ToKeyedWorkItem (1/1).
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e) [DEPLOYING].
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a) switched from CREATED to DEPLOYING.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a) [DEPLOYING]
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a) [DEPLOYING].
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0) switched from DEPLOYING to RUNNING.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a) [DEPLOYING].
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0) switched from DEPLOYING to RUNNING.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09) switched from DEPLOYING to RUNNING.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09) switched from DEPLOYING to RUNNING.
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e) switched from DEPLOYING to RUNNING.
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e) switched from DEPLOYING to RUNNING.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a) switched from DEPLOYING to RUNNING.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1).
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e) switched from DEPLOYING to RUNNING.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771) switched from CREATED to DEPLOYING.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771) [DEPLOYING]
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771) [DEPLOYING].
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771) [DEPLOYING].
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771) switched from DEPLOYING to RUNNING.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771) switched from DEPLOYING to RUNNING.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.state.heap.HeapKeyedStateBackend - Initializing heap keyed state backend with stream factory.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] WARN org.apache.flink.metrics.MetricGroup - The operator name [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} exceeded the 80 characters length limit and was truncated.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.state.heap.HeapKeyedStateBackend - Initializing heap keyed state backend with stream factory.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.state.heap.HeapKeyedStateBackend - Initializing heap keyed state backend with stream factory.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] WARN org.apache.beam.runners.fnexecution.environment.DockerCommand - Unable to pull docker image jenkins-docker-apache.bintray.io/beam/python:latest, cause: Received exit code 1 for command 'docker pull jenkins-docker-apache.bintray.io/beam/python:latest'. stderr: Error response from daemon: unknown: Repo 'apache' was not found
[grpc-default-executor-0] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - GetManifest for /tmp/flinktest2ddubA/job_184fd371-f987-437a-86c0-cb025e416148/MANIFEST
[grpc-default-executor-0] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Loading manifest for retrieval token /tmp/flinktest2ddubA/job_184fd371-f987-437a-86c0-cb025e416148/MANIFEST
[grpc-default-executor-0] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Manifest at /tmp/flinktest2ddubA/job_184fd371-f987-437a-86c0-cb025e416148/MANIFEST has 0 artifact locations
[grpc-default-executor-0] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - GetManifest for /tmp/flinktest2ddubA/job_184fd371-f987-437a-86c0-cb025e416148/MANIFEST -> 0 artifacts
[grpc-default-executor-0] INFO org.apache.beam.runners.fnexecution.logging.GrpcLoggingService - Beam Fn Logging client connected.
[grpc-default-executor-0] INFO sdk_worker_main.main - Logging handler created.
[grpc-default-executor-0] INFO sdk_worker_main.start - Status HTTP server running at localhost:36875
[grpc-default-executor-0] INFO sdk_worker_main.main - semi_persistent_directory: /tmp
[grpc-default-executor-0] WARN sdk_worker_main._load_main_session - No session file found: /tmp/staged/pickled_main_session. Functions defined in __main__ (interactive session) may fail. 
[grpc-default-executor-0] INFO pipeline_options.get_all_options - Parsing unknown args: [u'--direct_runner_use_stacked_bundle', u'--options_id=22', u'--pipeline_type_check', u'--sdk_worker_parallelism=1']
[grpc-default-executor-0] INFO sdk_worker_main.main - Python sdk harness started with pipeline_options: {'runner': u'None', 'streaming': True, 'experiments': [u'beam_fn_api'], 'environment_type': u'DOCKER', 'sdk_location': u'container', 'flink_master': '[auto]', 'direct_runner_use_stacked_bundle': None, 'sdk_worker_parallelism': u'1', 'job_name': u'test_windowing_1544746389.08', 'options_id': u'22', 'pipeline_type_check': None, 'parallelism': 1, 'job_endpoint': u'localhost:59187'}
[grpc-default-executor-0] INFO sdk_worker.__init__ - Creating insecure control channel.
[grpc-default-executor-0] INFO sdk_worker.__init__ - Control channel established.
[grpc-default-executor-0] INFO sdk_worker.__init__ - Initializing SDKHarness with 12 workers.
[grpc-default-executor-0] INFO org.apache.beam.runners.fnexecution.control.FnApiControlClientPoolService - Beam Fn Control client connected with id 1
[grpc-default-executor-0] INFO sdk_worker.create_state_handler - Creating channel for localhost:36161
[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_4:0 
[grpc-default-executor-0] INFO data_plane.create_data_channel - Creating channel for localhost:46741
[grpc-default-executor-0] INFO org.apache.beam.runners.fnexecution.data.GrpcDataService - Beam Fn Data client connected.
[grpc-default-executor-0] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_17:0 
[grpc-default-executor-0] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_1:0 
[grpc-default-executor-0] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_12:0 
[grpc-default-executor-0] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_7:0 
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0) switched from RUNNING to FINISHED.
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0).
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0) [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 Source: Impulse -> [4]assert_that/{Create, Group} 1b520ded1552613d5173ac3bfb08dfb0.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (1b520ded1552613d5173ac3bfb08dfb0) switched from RUNNING to FINISHED.
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e) switched from RUNNING to FINISHED.
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e).
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e) [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 Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem b5ec42447a302cc8c5000ff400f2241e.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (b5ec42447a302cc8c5000ff400f2241e) switched from RUNNING to FINISHED.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09) switched from RUNNING to FINISHED.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09).
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09) [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 Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem 83ef149030a7736b4e9414cc46302c09.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (83ef149030a7736b4e9414cc46302c09) 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:1:0 
[grpc-default-executor-0] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_15:0 
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e) switched from RUNNING to FINISHED.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e).
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e) [FINISHED]
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and sending final execution state FINISHED to JobManager for task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} da3b263d7f22509400c2511f883be41e.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a) switched from RUNNING to FINISHED.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a).
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a) [FINISHED]
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Un-registering task and sending final execution state FINISHED to JobManager for task ToKeyedWorkItem c6cf279ab0b8a0fcba3ea16639ecbf8a.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (da3b263d7f22509400c2511f883be41e) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (c6cf279ab0b8a0fcba3ea16639ecbf8a) 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 
[grpc-default-executor-0] INFO sdk_worker.run - No more requests from control plane
[grpc-default-executor-0] INFO sdk_worker.run - SDK Harness waiting for in-flight requests to complete
[grpc-default-executor-0] INFO data_plane.close - Closing all cached grpc data channels.
[grpc-default-executor-0] WARN org.apache.beam.sdk.fn.data.BeamFnDataGrpcMultiplexer - Hanged up for unknown endpoint.
[grpc-default-executor-0] INFO sdk_worker.close - Closing all cached gRPC state handlers.
[grpc-default-executor-0] INFO sdk_worker.run - Done consuming work.
[grpc-default-executor-0] INFO sdk_worker_main.main - Python sdk harness exiting.
[grpc-default-executor-0] INFO org.apache.beam.runners.fnexecution.logging.GrpcLoggingService - Logging client hanged up.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] WARN org.apache.beam.sdk.fn.data.BeamFnDataGrpcMultiplexer - Hanged up for unknown endpoint.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771) switched from RUNNING to FINISHED.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771).
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771) [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 assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} e3bd243cd5435b112d2e5b8d56da6771.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (e3bd243cd5435b112d2e5b8d56da6771) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544746389.08 (d5bb96915e53b086b1e5a1657df21aa2) switched from state RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.checkpoint.CheckpointCoordinator - Stopping checkpoint coordinator for job d5bb96915e53b086b1e5a1657df21aa2.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.checkpoint.StandaloneCompletedCheckpointStore - Shutting down
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Job d5bb96915e53b086b1e5a1657df21aa2 reached globally terminal state FINISHED.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - Stopping the JobMaster for job test_windowing_1544746389.08(d5bb96915e53b086b1e5a1657df21aa2).
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job d5bb96915e53b086b1e5a1657df21aa2.
[flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Shutting down Flink Mini Cluster
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - Close ResourceManager connection 3a4ebb7a1fae941c6fda9ad6963d8fa8: JobManager is shutting down..
[flink-runner-job-server] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Shutting down rest endpoint.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Suspending SlotPool.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping dispatcher akka://flink/user/dispatcher38da3fa5-a582-4400-8bac-7b953af92d34.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping all currently running jobs of dispatcher akka://flink/user/dispatcher38da3fa5-a582-4400-8bac-7b953af92d34.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Stopping SlotPool.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Disconnect job manager b580e2ae1d273296147c26feaa9544bc@akka://flink/user/jobmanager_43 for job d5bb96915e53b086b1e5a1657df21aa2 from the resource manager.
[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.
[flink-akka.actor.default-dispatcher-4] 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{20702459c8b000c3ebcfaeafb4b56a9e}, jobId: d5bb96915e53b086b1e5a1657df21aa2).
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Remove job d5bb96915e53b086b1e5a1657df21aa2 from job leader monitoring.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job d5bb96915e53b086b1e5a1657df21aa2.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Stopping TaskExecutor akka://flink/user/taskmanager_42.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.state.TaskExecutorLocalStateStoresManager - Shutting down TaskExecutorLocalStateStoresManager.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.io.disk.iomanager.IOManager - I/O manager removed spill file directory /tmp/flink-io-eb6da976-bee0-4aa9-8497-93b756c04a70
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.io.network.NetworkEnvironment - Shutting down the network environment and its components.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Stop job leader service.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.rest.handler.legacy.backpressure.StackTraceSampleCoordinator - Shutting down stack trace sample coordinator.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Stopped TaskExecutor akka://flink/user/taskmanager_42.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopped dispatcher akka://flink/user/dispatcher38da3fa5-a582-4400-8bac-7b953af92d34.
[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.rpc.akka.AkkaRpcService - Stopping Akka RPC service.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.blob.PermanentBlobCache - Shutting down BLOB cache
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.blob.TransientBlobCache - Shutting down BLOB cache
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.blob.BlobServer - Stopped BLOB server at 0.0.0.0:44571
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Stopped Akka RPC service.
[flink-runner-job-server] INFO org.apache.beam.runners.flink.FlinkRunner - Execution finished in 2393 msecs
[flink-runner-job-server] INFO org.apache.beam.runners.flink.FlinkRunner - Final accumulator values:
[flink-runner-job-server] INFO org.apache.beam.runners.flink.FlinkRunner - __metricscontainers : org.apache.beam.runners.core.metrics.MetricsContainerStepMap@5c674c32
INFO:root:Job state changed to DONE
.
----------------------------------------------------------------------
Ran 27 tests in 87.813s

OK (skipped=7)
:beam-sdks-python:flinkCompatibilityMatrixStreamingDOCKER (Thread[Task worker for ':' Thread 7,5,main]) completed. Took 1 mins 30.158 secs.

FAILURE: Build failed with an exception.

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

* What went wrong:
Execution failed for task ':beam-sdks-python:flinkCompatibilityMatrixBatchDOCKER'.
> Process 'command 'sh'' finished with non-zero exit value 1

* Try:
Run with --stacktrace option to get the stack trace. Run with --debug option to get more log output. Run with --scan to get full insights.

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

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

BUILD FAILED in 13m 0s
60 actionable tasks: 55 executed, 4 from cache, 1 up-to-date

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

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

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

Build failed in Jenkins: beam_PostCommit_Python_VR_Flink #1051

[Apache Jenkins Server <je...@builds.apache.org>]

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

Changes:

[relax] Stop subclassing user pojos.

[relax] spotless.

------------------------------------------
[...truncated 3.94 MB...]
[flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Starting job dispatcher(s) for JobManger
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - http://localhost:44451 was granted leadership with leaderSessionID=5206e952-b2f8-42f0-b3ad-76c0a394a861
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader http://localhost:44451 , session=5206e952-b2f8-42f0-b3ad-76c0a394a861
[flink-runner-job-server] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Starting RPC endpoint for org.apache.flink.runtime.dispatcher.StandaloneDispatcher at akka://flink/user/dispatcher51cb8405-dc8f-4322-9d08-f5be3db1d064 .
[flink-runner-job-server] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Proposing leadership to contender org.apache.flink.runtime.dispatcher.StandaloneDispatcher@4a94bcdd @ akka://flink/user/dispatcher51cb8405-dc8f-4322-9d08-f5be3db1d064
[flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Flink Mini Cluster started successfully
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Dispatcher akka://flink/user/dispatcher51cb8405-dc8f-4322-9d08-f5be3db1d064 was granted leadership with fencing token fe8aec10-fbc5-433c-bda2-d272ea2418b7
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Recovering all persisted jobs.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader akka://flink/user/dispatcher51cb8405-dc8f-4322-9d08-f5be3db1d064 , session=fe8aec10-fbc5-433c-bda2-d272ea2418b7
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Submitting job a6169ff7f4fbb76abe7853831746bc43 (test_windowing_1544737044.3).
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Starting RPC endpoint for org.apache.flink.runtime.jobmaster.JobMaster at akka://flink/user/jobmanager_43 .
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - Initializing job test_windowing_1544737044.3 (a6169ff7f4fbb76abe7853831746bc43).
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - Using restart strategy NoRestartStrategy for test_windowing_1544737044.3 (a6169ff7f4fbb76abe7853831746bc43).
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Starting RPC endpoint for org.apache.flink.runtime.jobmaster.slotpool.SlotPool at akka://flink/user/c2fe90cb-0fbd-40c7-8edb-15957ac5abba .
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job recovers via failover strategy: full graph restart
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - Running initialization on master for job test_windowing_1544737044.3 (a6169ff7f4fbb76abe7853831746bc43).
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - Successfully ran initialization on master in 0 ms.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Proposing leadership to contender org.apache.flink.runtime.jobmaster.JobManagerRunner@480f79d8 @ akka://flink/user/jobmanager_43
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobManagerRunner - JobManager runner for job test_windowing_1544737044.3 (a6169ff7f4fbb76abe7853831746bc43) was granted leadership with session id c0a36b1d-22d4-4ad3-ad59-0a7e608d8972 at akka://flink/user/jobmanager_43.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - Starting execution of job test_windowing_1544737044.3 (a6169ff7f4fbb76abe7853831746bc43)
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544737044.3 (a6169ff7f4fbb76abe7853831746bc43) switched from state CREATED to RUNNING.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796) switched from CREATED to SCHEDULED.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Cannot serve slot request, no ResourceManager connected. Adding as pending request [SlotRequestId{65c4da6b8101ac762191602139ad35c7}]
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8) switched from CREATED to SCHEDULED.
[jobmanager-future-thread-1] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader akka://flink/user/jobmanager_43 , session=c0a36b1d-22d4-4ad3-ad59-0a7e608d8972
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - Connecting to ResourceManager akka://flink/user/resourcemanager_a2eefded-fd2c-4615-8858-97a92f44a2c3(86f40a89a41cd6cf492be6da96ef488a)
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Resolved ResourceManager address, beginning registration
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Registration at ResourceManager attempt 1 (timeout=100ms)
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Registering job manager ad590a7e608d8972c0a36b1d22d44ad3@akka://flink/user/jobmanager_43 for job a6169ff7f4fbb76abe7853831746bc43.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Registered job manager ad590a7e608d8972c0a36b1d22d44ad3@akka://flink/user/jobmanager_43 for job a6169ff7f4fbb76abe7853831746bc43.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - JobManager successfully registered at ResourceManager, leader id: 86f40a89a41cd6cf492be6da96ef488a.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Requesting new slot [SlotRequestId{65c4da6b8101ac762191602139ad35c7}] and profile ResourceProfile{cpuCores=-1.0, heapMemoryInMB=-1, directMemoryInMB=0, nativeMemoryInMB=0, networkMemoryInMB=0} from resource manager.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Request slot with profile ResourceProfile{cpuCores=-1.0, heapMemoryInMB=-1, directMemoryInMB=0, nativeMemoryInMB=0, networkMemoryInMB=0} for job a6169ff7f4fbb76abe7853831746bc43 with allocation id AllocationID{3e2d376df217fc655034deec60abe7f8}.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Receive slot request AllocationID{3e2d376df217fc655034deec60abe7f8} for job a6169ff7f4fbb76abe7853831746bc43 from resource manager with leader id 86f40a89a41cd6cf492be6da96ef488a.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Allocated slot for AllocationID{3e2d376df217fc655034deec60abe7f8}.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Add job a6169ff7f4fbb76abe7853831746bc43 for job leader monitoring.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Try to register at job manager akka://flink/user/jobmanager_43 with leader id c0a36b1d-22d4-4ad3-ad59-0a7e608d8972.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Resolved JobManager address, beginning registration
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Registration at JobManager attempt 1 (timeout=100ms)
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Successful registration at job manager akka://flink/user/jobmanager_43 for job a6169ff7f4fbb76abe7853831746bc43.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Establish JobManager connection for job a6169ff7f4fbb76abe7853831746bc43.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Offer reserved slots to the leader of job a6169ff7f4fbb76abe7853831746bc43.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.slot.TaskSlotTable - Activate slot AllocationID{3e2d376df217fc655034deec60abe7f8}.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task Source: Impulse -> [4]assert_that/{Create, Group} (1/1).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (attempt #0) to localhost
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72) switched from CREATED to DEPLOYING.
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72) [DEPLOYING]
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796) switched from SCHEDULED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying ToKeyedWorkItem (1/1) (attempt #0) to localhost
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1).
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72) [DEPLOYING].
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8) switched from SCHEDULED to DEPLOYING.
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087) switched from CREATED to DEPLOYING.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (attempt #0) to localhost
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087) [DEPLOYING]
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087) [DEPLOYING].
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72) [DEPLOYING].
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087) [DEPLOYING].
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1).
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874) switched from CREATED to DEPLOYING.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874) [DEPLOYING]
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874) [DEPLOYING].
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1).
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874) [DEPLOYING].
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2) switched from CREATED to DEPLOYING.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2) [DEPLOYING]
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2) [DEPLOYING].
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2) [DEPLOYING].
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task ToKeyedWorkItem (1/1).
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796) switched from CREATED to DEPLOYING.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796) [DEPLOYING]
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796) [DEPLOYING].
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796) [DEPLOYING].
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087) switched from DEPLOYING to RUNNING.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1).
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087) switched from DEPLOYING to RUNNING.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2) switched from DEPLOYING to RUNNING.
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72) switched from DEPLOYING to RUNNING.
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874) switched from DEPLOYING to RUNNING.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874) switched from DEPLOYING to RUNNING.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8) switched from CREATED to DEPLOYING.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Creating FileSystem stream leak safety net for task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8) [DEPLOYING]
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8) [DEPLOYING].
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8) [DEPLOYING].
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796) switched from DEPLOYING to RUNNING.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796) switched from DEPLOYING to RUNNING.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8) switched from DEPLOYING to RUNNING.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8) switched from DEPLOYING to RUNNING.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880)
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.state.heap.HeapKeyedStateBackend - Initializing heap keyed state backend with stream factory.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.state.heap.HeapKeyedStateBackend - Initializing heap keyed state backend with stream factory.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] WARN org.apache.flink.metrics.MetricGroup - The operator name [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} exceeded the 80 characters length limit and was truncated.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.state.heap.HeapKeyedStateBackend - Initializing heap keyed state backend with stream factory.
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] WARN org.apache.beam.runners.fnexecution.environment.DockerCommand - Unable to pull docker image jenkins-docker-apache.bintray.io/beam/python:latest, cause: Received exit code 1 for command 'docker pull jenkins-docker-apache.bintray.io/beam/python:latest'. stderr: Error response from daemon: unknown: Repo 'apache' was not found
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - GetManifest for /tmp/flinktestds5x_s/job_a03763eb-8bbc-4ce4-9b98-0e9cf7402e3d/MANIFEST
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Loading manifest for retrieval token /tmp/flinktestds5x_s/job_a03763eb-8bbc-4ce4-9b98-0e9cf7402e3d/MANIFEST
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Manifest at /tmp/flinktestds5x_s/job_a03763eb-8bbc-4ce4-9b98-0e9cf7402e3d/MANIFEST has 0 artifact locations
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - GetManifest for /tmp/flinktestds5x_s/job_a03763eb-8bbc-4ce4-9b98-0e9cf7402e3d/MANIFEST -> 0 artifacts
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.logging.GrpcLoggingService - Beam Fn Logging client connected.
[grpc-default-executor-2] INFO sdk_worker_main.main - Logging handler created.
[grpc-default-executor-2] INFO sdk_worker_main.start - Status HTTP server running at localhost:42341
[grpc-default-executor-2] INFO sdk_worker_main.main - semi_persistent_directory: /tmp
[grpc-default-executor-2] WARN sdk_worker_main._load_main_session - No session file found: /tmp/staged/pickled_main_session. Functions defined in __main__ (interactive session) may fail. 
[grpc-default-executor-2] INFO pipeline_options.get_all_options - Parsing unknown args: [u'--direct_runner_use_stacked_bundle', u'--options_id=22', u'--pipeline_type_check', u'--sdk_worker_parallelism=1']
[grpc-default-executor-2] INFO sdk_worker_main.main - Python sdk harness started with pipeline_options: {'runner': u'None', 'streaming': True, 'experiments': [u'beam_fn_api'], 'environment_type': u'DOCKER', 'sdk_location': u'container', 'flink_master': '[auto]', 'direct_runner_use_stacked_bundle': None, 'sdk_worker_parallelism': u'1', 'job_name': u'test_windowing_1544737044.3', 'options_id': u'22', 'pipeline_type_check': None, 'parallelism': 1, 'job_endpoint': u'localhost:33671'}
[grpc-default-executor-2] INFO sdk_worker.__init__ - Creating insecure control channel.
[grpc-default-executor-2] INFO sdk_worker.__init__ - Control channel established.
[grpc-default-executor-2] INFO sdk_worker.__init__ - Initializing SDKHarness with 12 workers.
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.control.FnApiControlClientPoolService - Beam Fn Control client connected with id 1
[grpc-default-executor-2] INFO sdk_worker.create_state_handler - Creating channel for localhost:35503
[grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_4:0 
[grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_24:0:0 
[grpc-default-executor-2] INFO data_plane.create_data_channel - Creating channel for localhost:34361
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.data.GrpcDataService - Beam Fn Data client connected.
[grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_17:0 
[grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_1:0 
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72) switched from RUNNING to FINISHED.
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72).
[Source: Impulse -> [4]assert_that/{Create, Group} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72) [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 Source: Impulse -> [4]assert_that/{Create, Group} 6138a82b08428643df0de07329c3ce72.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (6138a82b08428643df0de07329c3ce72) switched from RUNNING to FINISHED.
[grpc-default-executor-1] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_12:0 
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087) switched from RUNNING to FINISHED.
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087).
[Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087) [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 Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem c1bd5bbc56385d0bb640f4f24ce1e087.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (c1bd5bbc56385d0bb640f4f24ce1e087) 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_7:0 
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874) switched from RUNNING to FINISHED.
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874).
[Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874) [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 Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem 32a9de8bc39abf39acc414bd2faef874.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:405>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (32a9de8bc39abf39acc414bd2faef874) switched from RUNNING to FINISHED.
[grpc-default-executor-1] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_24:1:0 
[grpc-default-executor-1] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_15:0 
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2) switched from RUNNING to FINISHED.
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2).
[GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2) [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 GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} ff2a7432b44584b419a5ffc71ae65de2.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796) switched from RUNNING to FINISHED.
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796).
[ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796) [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 ToKeyedWorkItem 077d3869a523d8611d6f7c9892d06796.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:408>), assert_that} (1/1) (ff2a7432b44584b419a5ffc71ae65de2) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (077d3869a523d8611d6f7c9892d06796) 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] INFO sdk_worker.run - No more requests from control plane
[grpc-default-executor-1] INFO sdk_worker.run - SDK Harness waiting for in-flight requests to complete
[grpc-default-executor-1] INFO data_plane.close - Closing all cached grpc data channels.
[grpc-default-executor-2] WARN org.apache.beam.sdk.fn.data.BeamFnDataGrpcMultiplexer - Hanged up for unknown endpoint.
[grpc-default-executor-2] INFO sdk_worker.close - Closing all cached gRPC state handlers.
[grpc-default-executor-2] INFO sdk_worker.run - Done consuming work.
[grpc-default-executor-2] INFO sdk_worker_main.main - Python sdk harness exiting.
[grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.logging.GrpcLoggingService - Logging client hanged up.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] WARN org.apache.beam.sdk.fn.data.BeamFnDataGrpcMultiplexer - Hanged up for unknown endpoint.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8) switched from RUNNING to FINISHED.
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8).
[assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8) [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 assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} 2fd07d2c5dc2539abf30c7e0eaa028c8.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (2fd07d2c5dc2539abf30c7e0eaa028c8) switched from RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544737044.3 (a6169ff7f4fbb76abe7853831746bc43) switched from state RUNNING to FINISHED.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.checkpoint.CheckpointCoordinator - Stopping checkpoint coordinator for job a6169ff7f4fbb76abe7853831746bc43.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.checkpoint.StandaloneCompletedCheckpointStore - Shutting down
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Job a6169ff7f4fbb76abe7853831746bc43 reached globally terminal state FINISHED.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - Stopping the JobMaster for job test_windowing_1544737044.3(a6169ff7f4fbb76abe7853831746bc43).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job a6169ff7f4fbb76abe7853831746bc43.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - Close ResourceManager connection 2aa65e25ddbb7c2677b93ad896313036: JobManager is shutting down..
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Suspending SlotPool.
[flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Shutting down Flink Mini Cluster
[flink-runner-job-server] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Shutting down rest endpoint.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Disconnect job manager ad590a7e608d8972c0a36b1d22d44ad3@akka://flink/user/jobmanager_43 for job a6169ff7f4fbb76abe7853831746bc43 from the resource manager.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Stopping SlotPool.
[flink-akka.actor.default-dispatcher-5] 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{3e2d376df217fc655034deec60abe7f8}, jobId: a6169ff7f4fbb76abe7853831746bc43).
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Remove job a6169ff7f4fbb76abe7853831746bc43 from job leader monitoring.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job a6169ff7f4fbb76abe7853831746bc43.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping dispatcher akka://flink/user/dispatcher51cb8405-dc8f-4322-9d08-f5be3db1d064.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping all currently running jobs of dispatcher akka://flink/user/dispatcher51cb8405-dc8f-4322-9d08-f5be3db1d064.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Closing the SlotManager.
[flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Suspending the SlotManager.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Stopping TaskExecutor akka://flink/user/taskmanager_42.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.state.TaskExecutorLocalStateStoresManager - Shutting down TaskExecutorLocalStateStoresManager.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.rest.handler.legacy.backpressure.StackTraceSampleCoordinator - Shutting down stack trace sample coordinator.
[flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopped dispatcher akka://flink/user/dispatcher51cb8405-dc8f-4322-9d08-f5be3db1d064.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.io.disk.iomanager.IOManager - I/O manager removed spill file directory /tmp/flink-io-dace4109-39a3-4690-920c-9eac6e0ca1fd
[flink-akka.actor.default-dispatcher-5] 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.taskexecutor.JobLeaderService - Stop job leader service.
[flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Stopped TaskExecutor akka://flink/user/taskmanager_42.
[ForkJoinPool.commonPool-worker-9] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Removing cache directory /tmp/flink-web-ui
[ForkJoinPool.commonPool-worker-9] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Stopping Akka RPC service.
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.blob.PermanentBlobCache - Shutting down BLOB cache
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.blob.TransientBlobCache - Shutting down BLOB cache
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.blob.BlobServer - Stopped BLOB server at 0.0.0.0:38101
[flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Stopped Akka RPC service.
[flink-runner-job-server] INFO org.apache.beam.runners.flink.FlinkRunner - Execution finished in 2326 msecs
[flink-runner-job-server] INFO org.apache.beam.runners.flink.FlinkRunner - Final accumulator values:
[flink-runner-job-server] INFO org.apache.beam.runners.flink.FlinkRunner - __metricscontainers : org.apache.beam.runners.core.metrics.MetricsContainerStepMap@1239e8d8
INFO:root:Job state changed to DONE
.
----------------------------------------------------------------------
Ran 27 tests in 118.264s

OK (skipped=7)
:beam-sdks-python:flinkCompatibilityMatrixStreamingDOCKER (Thread[Task worker for ':' Thread 9,5,main]) completed. Took 2 mins 11.699 secs.

FAILURE: Build failed with an exception.

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

* What went wrong:
Execution failed for task ':beam-sdks-python:flinkCompatibilityMatrixBatchDOCKER'.
> Process 'command 'sh'' finished with non-zero exit value 1

* Try:
Run with --stacktrace option to get the stack trace. Run with --debug option to get more log output. Run with --scan to get full insights.

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

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

BUILD FAILED in 19m 9s
60 actionable tasks: 56 executed, 3 from cache, 1 up-to-date

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

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

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