See <https://builds.apache.org/job/beam_PostCommit_Python_VR_Flink/1007/display/redirect>
------------------------------------------ [...truncated 3.92 MB...] [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - http://localhost:33495 was granted leadership with leaderSessionID=0e915f0c-f3ad-4da7-99ac-a84857f87b90 [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader http://localhost:33495 , session=0e915f0c-f3ad-4da7-99ac-a84857f87b90 [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/dispatcherbf75137c-cd88-4430-b234-18e880893b91 . [flink-runner-job-server] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Proposing leadership to contender org.apache.flink.runtime.dispatcher.StandaloneDispatcher@6a15bf13 @ akka://flink/user/dispatcherbf75137c-cd88-4430-b234-18e880893b91 [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/dispatcherbf75137c-cd88-4430-b234-18e880893b91 was granted leadership with fencing token 57ccb9ff-bcc0-4c9e-b673-1bdc0924e789 [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Recovering all persisted jobs. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader akka://flink/user/dispatcherbf75137c-cd88-4430-b234-18e880893b91 , session=57ccb9ff-bcc0-4c9e-b673-1bdc0924e789 [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Submitting job 49734d5e48260791b72f9a9f28f092d7 (test_windowing_1544449395.91). [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_1544449395.91 (49734d5e48260791b72f9a9f28f092d7). [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Using restart strategy NoRestartStrategy for test_windowing_1544449395.91 (49734d5e48260791b72f9a9f28f092d7). [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/b178bf91-cace-4d5d-833c-21b4ade9a3dd . [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_1544449395.91 (49734d5e48260791b72f9a9f28f092d7). [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@3218c063 @ akka://flink/user/jobmanager_43 [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobManagerRunner - JobManager runner for job test_windowing_1544449395.91 (49734d5e48260791b72f9a9f28f092d7) was granted leadership with session id d2ce3164-117b-4151-9869-bcd187aa752b 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_1544449395.91 (49734d5e48260791b72f9a9f28f092d7) [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544449395.91 (49734d5e48260791b72f9a9f28f092d7) 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) (6443720ec6f8cec0becfc06ca5712691) 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) (35a84c56aa9b678067f149162dc69b24) 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d) 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:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7) switched from CREATED to SCHEDULED. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (dd87e8c05344623cd0ca47ac78b9f300) switched from CREATED to SCHEDULED. [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) (39ac17d2fedbc9f6bafe236202e0967e) switched from CREATED to SCHEDULED. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Cannot serve slot request, no ResourceManager connected. Adding as pending request [SlotRequestId{ae4e2c838836ccd69058e2b3d97e8ba0}] [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=d2ce3164-117b-4151-9869-bcd187aa752b [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - Connecting to ResourceManager akka://flink/user/resourcemanager_0a70678b-46df-4732-8c46-a153f986400a(85088878f6a4be92cef7823bcc8d4108) [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - Resolved ResourceManager address, beginning registration [flink-akka.actor.default-dispatcher-3] 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 9869bcd187aa752bd2ce3164117b4151@akka://flink/user/jobmanager_43 for job 49734d5e48260791b72f9a9f28f092d7. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Registered job manager 9869bcd187aa752bd2ce3164117b4151@akka://flink/user/jobmanager_43 for job 49734d5e48260791b72f9a9f28f092d7. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - JobManager successfully registered at ResourceManager, leader id: 85088878f6a4be92cef7823bcc8d4108. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Requesting new slot [SlotRequestId{ae4e2c838836ccd69058e2b3d97e8ba0}] and profile ResourceProfile{cpuCores=-1.0, heapMemoryInMB=-1, directMemoryInMB=0, nativeMemoryInMB=0, networkMemoryInMB=0} from resource manager. [flink-akka.actor.default-dispatcher-5] 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 49734d5e48260791b72f9a9f28f092d7 with allocation id AllocationID{c8525882f721903f01d36524d275eb73}. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Receive slot request AllocationID{c8525882f721903f01d36524d275eb73} for job 49734d5e48260791b72f9a9f28f092d7 from resource manager with leader id 85088878f6a4be92cef7823bcc8d4108. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Allocated slot for AllocationID{c8525882f721903f01d36524d275eb73}. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Add job 49734d5e48260791b72f9a9f28f092d7 for job leader monitoring. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Try to register at job manager akka://flink/user/jobmanager_43 with leader id d2ce3164-117b-4151-9869-bcd187aa752b. [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-4] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Successful registration at job manager akka://flink/user/jobmanager_43 for job 49734d5e48260791b72f9a9f28f092d7. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Establish JobManager connection for job 49734d5e48260791b72f9a9f28f092d7. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Offer reserved slots to the leader of job 49734d5e48260791b72f9a9f28f092d7. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.slot.TaskSlotTable - Activate slot AllocationID{c8525882f721903f01d36524d275eb73}. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (35a84c56aa9b678067f149162dc69b24) 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) (6443720ec6f8cec0becfc06ca5712691) 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d) 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:406>), 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:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7) 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:409>), assert_that} (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 - ToKeyedWorkItem (1/1) (dd87e8c05344623cd0ca47ac78b9f300) 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 [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) (35a84c56aa9b678067f149162dc69b24) switched from CREATED to DEPLOYING. [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) (39ac17d2fedbc9f6bafe236202e0967e) 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 - Creating FileSystem stream leak safety net for task Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (35a84c56aa9b678067f149162dc69b24) [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) (35a84c56aa9b678067f149162dc69b24) [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 -> [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) (6443720ec6f8cec0becfc06ca5712691) 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) (6443720ec6f8cec0becfc06ca5712691) [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) (6443720ec6f8cec0becfc06ca5712691) [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) (35a84c56aa9b678067f149162dc69b24) [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) (6443720ec6f8cec0becfc06ca5712691) [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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1). [Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d) switched from CREATED to DEPLOYING. [Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d) [DEPLOYING] [Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d) [DEPLOYING]. [Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d) [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:409>), assert_that} (1/1). [GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7) switched from CREATED to DEPLOYING. [GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), 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:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7) [DEPLOYING] [GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), 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:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7) [DEPLOYING]. [GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), 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:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7) [DEPLOYING]. [flink-akka.actor.default-dispatcher-3] 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) (dd87e8c05344623cd0ca47ac78b9f300) 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) (dd87e8c05344623cd0ca47ac78b9f300) [DEPLOYING] [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task ToKeyedWorkItem (1/1) (dd87e8c05344623cd0ca47ac78b9f300) [DEPLOYING]. [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: ToKeyedWorkItem (1/1) (dd87e8c05344623cd0ca47ac78b9f300) [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) (35a84c56aa9b678067f149162dc69b24) 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) [GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7) switched from DEPLOYING to RUNNING. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (35a84c56aa9b678067f149162dc69b24) switched from DEPLOYING to RUNNING. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7) switched from DEPLOYING to RUNNING. [GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), 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) [Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d) switched from DEPLOYING to RUNNING. [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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d) switched from DEPLOYING to RUNNING. [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (dd87e8c05344623cd0ca47ac78b9f300) switched from DEPLOYING to RUNNING. [Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), 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-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (dd87e8c05344623cd0ca47ac78b9f300) 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) [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) (6443720ec6f8cec0becfc06ca5712691) 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). [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-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (6443720ec6f8cec0becfc06ca5712691) 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) (39ac17d2fedbc9f6bafe236202e0967e) 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) (39ac17d2fedbc9f6bafe236202e0967e) [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) (39ac17d2fedbc9f6bafe236202e0967e) [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) (39ac17d2fedbc9f6bafe236202e0967e) [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) (39ac17d2fedbc9f6bafe236202e0967e) 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-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (39ac17d2fedbc9f6bafe236202e0967e) 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. [GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1)] WARN org.apache.flink.metrics.MetricGroup - The operator name [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (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/flinktestTJM9Gb/job_5bba47aa-3fc9-429a-b005-09e5490305f5/MANIFEST [grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Loading manifest for retrieval token /tmp/flinktestTJM9Gb/job_5bba47aa-3fc9-429a-b005-09e5490305f5/MANIFEST [grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Manifest at /tmp/flinktestTJM9Gb/job_5bba47aa-3fc9-429a-b005-09e5490305f5/MANIFEST has 0 artifact locations [grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - GetManifest for /tmp/flinktestTJM9Gb/job_5bba47aa-3fc9-429a-b005-09e5490305f5/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:36469 [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'], 'sdk_location': u'container', 'flink_master': '[auto]', 'direct_runner_use_stacked_bundle': None, 'sdk_worker_parallelism': u'1', 'job_name': u'test_windowing_1544449395.91', 'options_id': u'22', 'pipeline_type_check': None, 'parallelism': 1, 'job_endpoint': u'localhost:44251'} [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:37089 [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] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_4:0 [grpc-default-executor-2] INFO data_plane.create_data_channel - Creating channel for localhost:38779 [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_1:0 [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/write/ref_PCollection_PCollection_12: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) (35a84c56aa9b678067f149162dc69b24) 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) (35a84c56aa9b678067f149162dc69b24). [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) (35a84c56aa9b678067f149162dc69b24) [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} 35a84c56aa9b678067f149162dc69b24. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (35a84c56aa9b678067f149162dc69b24) 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) (6443720ec6f8cec0becfc06ca5712691) 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) (6443720ec6f8cec0becfc06ca5712691). [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) (6443720ec6f8cec0becfc06ca5712691) [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 Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem 6443720ec6f8cec0becfc06ca5712691. [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) (6443720ec6f8cec0becfc06ca5712691) switched from RUNNING to FINISHED. [grpc-default-executor-2] 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:406>), 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d) switched from RUNNING to FINISHED. [Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d). [Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d) [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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem 499f88416c81f31a13478779ac32119d. [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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (499f88416c81f31a13478779ac32119d) switched from RUNNING to FINISHED. [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] 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:409>), assert_that} (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7) switched from RUNNING to FINISHED. [GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), 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:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7). [GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), 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:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7) [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 GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} caeed87cd66e29b991cfb17e7ad5bdb7. [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (dd87e8c05344623cd0ca47ac78b9f300) switched from RUNNING to FINISHED. [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for ToKeyedWorkItem (1/1) (dd87e8c05344623cd0ca47ac78b9f300). [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task ToKeyedWorkItem (1/1) (dd87e8c05344623cd0ca47ac78b9f300) [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 ToKeyedWorkItem dd87e8c05344623cd0ca47ac78b9f300. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} (1/1) (caeed87cd66e29b991cfb17e7ad5bdb7) switched from RUNNING to FINISHED. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (dd87e8c05344623cd0ca47ac78b9f300) switched from RUNNING to FINISHED. [grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_27:0 [grpc-default-executor-2] INFO sdk_worker.run - No more requests from control plane [grpc-default-executor-2] INFO sdk_worker.run - SDK Harness waiting for in-flight requests to complete [grpc-default-executor-2] 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) (39ac17d2fedbc9f6bafe236202e0967e) 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) (39ac17d2fedbc9f6bafe236202e0967e). [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) (39ac17d2fedbc9f6bafe236202e0967e) [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} 39ac17d2fedbc9f6bafe236202e0967e. [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) (39ac17d2fedbc9f6bafe236202e0967e) switched from RUNNING to FINISHED. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544449395.91 (49734d5e48260791b72f9a9f28f092d7) switched from state RUNNING to FINISHED. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.checkpoint.CheckpointCoordinator - Stopping checkpoint coordinator for job 49734d5e48260791b72f9a9f28f092d7. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.checkpoint.StandaloneCompletedCheckpointStore - Shutting down [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Job 49734d5e48260791b72f9a9f28f092d7 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_1544449395.91(49734d5e48260791b72f9a9f28f092d7). [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job 49734d5e48260791b72f9a9f28f092d7. [flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Shutting down Flink Mini Cluster [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.JobMaster - Close ResourceManager connection 5e2bb9af95088fa93e463ae333d65c4e: JobManager is shutting down.. [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.jobmaster.slotpool.SlotPool - Suspending SlotPool. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping dispatcher akka://flink/user/dispatcherbf75137c-cd88-4430-b234-18e880893b91. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Disconnect job manager 9869bcd187aa752bd2ce3164117b4151@akka://flink/user/jobmanager_43 for job 49734d5e48260791b72f9a9f28f092d7 from the resource manager. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping all currently running jobs of dispatcher akka://flink/user/dispatcherbf75137c-cd88-4430-b234-18e880893b91. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Closing the SlotManager. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Suspending the SlotManager. [flink-akka.actor.default-dispatcher-2] 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{c8525882f721903f01d36524d275eb73}, jobId: 49734d5e48260791b72f9a9f28f092d7). [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Remove job 49734d5e48260791b72f9a9f28f092d7 from job leader monitoring. [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.taskexecutor.TaskExecutor - Close JobManager connection for job 49734d5e48260791b72f9a9f28f092d7. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Could not resolve JobManager address akka://flink/user/jobmanager_43, retrying in 10000 ms: Could not connect to rpc endpoint under address akka://flink/user/jobmanager_43.. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Stopping TaskExecutor akka://flink/user/taskmanager_42. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.state.TaskExecutorLocalStateStoresManager - Shutting down TaskExecutorLocalStateStoresManager. [ForkJoinPool.commonPool-worker-9] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Removing cache directory /tmp/flink-web-ui [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.io.disk.iomanager.IOManager - I/O manager removed spill file directory /tmp/flink-io-7554912f-c2c1-42ef-a6f6-ad5aea1aeec4 [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.io.network.NetworkEnvironment - Shutting down the network environment and its components. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.rest.handler.legacy.backpressure.StackTraceSampleCoordinator - Shutting down stack trace sample coordinator. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopped dispatcher akka://flink/user/dispatcherbf75137c-cd88-4430-b234-18e880893b91. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Stop job leader service. [flink-akka.actor.default-dispatcher-2] 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.rpc.akka.AkkaRpcService - Stopping Akka RPC service. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.blob.PermanentBlobCache - Shutting down BLOB cache [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.blob.TransientBlobCache - Shutting down BLOB cache [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.blob.BlobServer - Stopped BLOB server at 0.0.0.0:39075 [flink-akka.actor.default-dispatcher-2] 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 2235 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@49cb4e13 INFO:root:Job state changed to DONE . ---------------------------------------------------------------------- Ran 27 tests in 80.115s OK (skipped=7) :beam-sdks-python:flinkCompatibilityMatrixStreamingDOCKER (Thread[Task worker for ':',5,main]) completed. Took 1 mins 22.146 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: 345 * 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 12m 34s 60 actionable tasks: 55 executed, 4 from cache, 1 up-to-date Publishing build scan... https://gradle.com/s/ftwavy3ndlppe Build step 'Invoke Gradle script' changed build result to FAILURE Build step 'Invoke Gradle script' marked build as failure --------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
