See <https://builds.apache.org/job/beam_PostCommit_Python_VR_Flink/983/display/redirect?page=changes>
Changes: [ankurgoenka] [BEAM-5167] Log unscheduled process bundle requrests ------------------------------------------ [...truncated 3.91 MB...] [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader http://localhost:43255 , session=c3195326-f7d8-4549-b2a3-6601d195d9be [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/dispatcher261a234b-6dc8-44f7-b7b0-7cc8b2c0e725 . [flink-runner-job-server] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Proposing leadership to contender org.apache.flink.runtime.dispatcher.StandaloneDispatcher@26f0ac8c @ akka://flink/user/dispatcher261a234b-6dc8-44f7-b7b0-7cc8b2c0e725 [flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Flink Mini Cluster started successfully [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Dispatcher akka://flink/user/dispatcher261a234b-6dc8-44f7-b7b0-7cc8b2c0e725 was granted leadership with fencing token 0a96d6c9-76c7-4ce3-a353-21dcf279bff1 [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Recovering all persisted jobs. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader akka://flink/user/dispatcher261a234b-6dc8-44f7-b7b0-7cc8b2c0e725 , session=0a96d6c9-76c7-4ce3-a353-21dcf279bff1 [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Submitting job 57b899d90b4d8e492a8a77956ac87e57 (test_windowing_1544183633.99). [flink-akka.actor.default-dispatcher-2] 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-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - Initializing job test_windowing_1544183633.99 (57b899d90b4d8e492a8a77956ac87e57). [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - Using restart strategy NoRestartStrategy for test_windowing_1544183633.99 (57b899d90b4d8e492a8a77956ac87e57). [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Starting RPC endpoint for org.apache.flink.runtime.jobmaster.slotpool.SlotPool at akka://flink/user/942a1198-53be-46c6-bf49-be5e40931617 . [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job recovers via failover strategy: full graph restart [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - Running initialization on master for job test_windowing_1544183633.99 (57b899d90b4d8e492a8a77956ac87e57). [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - Successfully ran initialization on master in 0 ms. [flink-akka.actor.default-dispatcher-2] 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-2] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Proposing leadership to contender org.apache.flink.runtime.jobmaster.JobManagerRunner@588b821c @ akka://flink/user/jobmanager_43 [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobManagerRunner - JobManager runner for job test_windowing_1544183633.99 (57b899d90b4d8e492a8a77956ac87e57) was granted leadership with session id 9203ea9d-2886-4146-a069-384ff8e32080 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_1544183633.99 (57b899d90b4d8e492a8a77956ac87e57) [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544183633.99 (57b899d90b4d8e492a8a77956ac87e57) 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) (7b753980cdca6ffcdcb5f01ff16b62a4) 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) (2f60a43f53cc26f8b75ed9b63753369c) 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:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (ac28a3b33888858ce6cfbd7f000810cf) 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:409>), assert_that} (1/1) (77343ac63d992ef08481ed8e13da1ee9) switched from CREATED to SCHEDULED. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (43be03f6d64e4862a123afa9d1890a3f) 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) (0a3301b08262c85f553ce986f9d49af3) 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{359a618a286e67775f8f3f3aa3163bc5}] [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=9203ea9d-2886-4146-a069-384ff8e32080 [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - Connecting to ResourceManager akka://flink/user/resourcemanager_c18ec1fe-5a2b-450f-b2e9-8d5700d4f368(98eee113b07092ad94581b4e06044b57) [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-4] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Registering job manager a069384ff8e320809203ea9d28864146@akka://flink/user/jobmanager_43 for job 57b899d90b4d8e492a8a77956ac87e57. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Registered job manager a069384ff8e320809203ea9d28864146@akka://flink/user/jobmanager_43 for job 57b899d90b4d8e492a8a77956ac87e57. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.JobMaster - JobManager successfully registered at ResourceManager, leader id: 98eee113b07092ad94581b4e06044b57. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Requesting new slot [SlotRequestId{359a618a286e67775f8f3f3aa3163bc5}] 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 57b899d90b4d8e492a8a77956ac87e57 with allocation id AllocationID{9ad3e3d30192e3803d1e836779abf6b9}. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Receive slot request AllocationID{9ad3e3d30192e3803d1e836779abf6b9} for job 57b899d90b4d8e492a8a77956ac87e57 from resource manager with leader id 98eee113b07092ad94581b4e06044b57. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Allocated slot for AllocationID{9ad3e3d30192e3803d1e836779abf6b9}. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Add job 57b899d90b4d8e492a8a77956ac87e57 for job leader monitoring. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Try to register at job manager akka://flink/user/jobmanager_43 with leader id 9203ea9d-2886-4146-a069-384ff8e32080. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Resolved JobManager address, beginning registration [flink-akka.actor.default-dispatcher-3] 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 57b899d90b4d8e492a8a77956ac87e57. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Establish JobManager connection for job 57b899d90b4d8e492a8a77956ac87e57. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Offer reserved slots to the leader of job 57b899d90b4d8e492a8a77956ac87e57. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.slot.TaskSlotTable - Activate slot AllocationID{9ad3e3d30192e3803d1e836779abf6b9}. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (2f60a43f53cc26f8b75ed9b63753369c) switched from SCHEDULED to DEPLOYING. [flink-akka.actor.default-dispatcher-3] 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-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (7b753980cdca6ffcdcb5f01ff16b62a4) switched from SCHEDULED to DEPLOYING. [flink-akka.actor.default-dispatcher-3] 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-3] 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) (ac28a3b33888858ce6cfbd7f000810cf) switched from SCHEDULED to DEPLOYING. [flink-akka.actor.default-dispatcher-3] 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-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} (1/1) (77343ac63d992ef08481ed8e13da1ee9) switched from SCHEDULED to DEPLOYING. [flink-akka.actor.default-dispatcher-3] 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.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (43be03f6d64e4862a123afa9d1890a3f) switched from SCHEDULED to DEPLOYING. [flink-akka.actor.default-dispatcher-3] 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.executiongraph.ExecutionGraph - assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (0a3301b08262c85f553ce986f9d49af3) switched from SCHEDULED to DEPLOYING. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Deploying assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} (1/1) (attempt #0) to localhost [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task Source: Impulse -> [4]assert_that/{Create, Group} (1/1). [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) (2f60a43f53cc26f8b75ed9b63753369c) 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) (2f60a43f53cc26f8b75ed9b63753369c) [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) (2f60a43f53cc26f8b75ed9b63753369c) [DEPLOYING]. [flink-akka.actor.default-dispatcher-5] 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 - Registering task at network: Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (2f60a43f53cc26f8b75ed9b63753369c) [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) (7b753980cdca6ffcdcb5f01ff16b62a4) 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) (7b753980cdca6ffcdcb5f01ff16b62a4) [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) (7b753980cdca6ffcdcb5f01ff16b62a4) [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) (7b753980cdca6ffcdcb5f01ff16b62a4) [DEPLOYING]. [flink-akka.actor.default-dispatcher-5] 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) (ac28a3b33888858ce6cfbd7f000810cf) 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) (ac28a3b33888858ce6cfbd7f000810cf) [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) (ac28a3b33888858ce6cfbd7f000810cf) [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) (ac28a3b33888858ce6cfbd7f000810cf) [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) (2f60a43f53cc26f8b75ed9b63753369c) 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) (2f60a43f53cc26f8b75ed9b63753369c) 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) (7b753980cdca6ffcdcb5f01ff16b62a4) 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) [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} (1/1). [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) (7b753980cdca6ffcdcb5f01ff16b62a4) 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) [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) (77343ac63d992ef08481ed8e13da1ee9) 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) (77343ac63d992ef08481ed8e13da1ee9) [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) (77343ac63d992ef08481ed8e13da1ee9) [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) (77343ac63d992ef08481ed8e13da1ee9) [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 - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (ac28a3b33888858ce6cfbd7f000810cf) switched from DEPLOYING to RUNNING. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task ToKeyedWorkItem (1/1). [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) (ac28a3b33888858ce6cfbd7f000810cf) 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) [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (43be03f6d64e4862a123afa9d1890a3f) 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) (43be03f6d64e4862a123afa9d1890a3f) [DEPLOYING] [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task ToKeyedWorkItem (1/1) (43be03f6d64e4862a123afa9d1890a3f) [DEPLOYING]. [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) (77343ac63d992ef08481ed8e13da1ee9) 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) [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Registering task at network: ToKeyedWorkItem (1/1) (43be03f6d64e4862a123afa9d1890a3f) [DEPLOYING]. [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) (77343ac63d992ef08481ed8e13da1ee9) switched from DEPLOYING to RUNNING. [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (43be03f6d64e4862a123afa9d1890a3f) switched from DEPLOYING to RUNNING. [flink-akka.actor.default-dispatcher-5] 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-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (43be03f6d64e4862a123afa9d1890a3f) 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) [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) (0a3301b08262c85f553ce986f9d49af3) 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) (0a3301b08262c85f553ce986f9d49af3) [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) (0a3301b08262c85f553ce986f9d49af3) [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) (0a3301b08262c85f553ce986f9d49af3) [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) (0a3301b08262c85f553ce986f9d49af3) 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) (0a3301b08262c85f553ce986f9d49af3) 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: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. [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)] 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-1] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - GetManifest for /tmp/flinktestmo5Nd0/job_f9a78bef-59a8-4b21-8f29-defea500cb96/MANIFEST [grpc-default-executor-1] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Loading manifest for retrieval token /tmp/flinktestmo5Nd0/job_f9a78bef-59a8-4b21-8f29-defea500cb96/MANIFEST [grpc-default-executor-1] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Manifest at /tmp/flinktestmo5Nd0/job_f9a78bef-59a8-4b21-8f29-defea500cb96/MANIFEST has 0 artifact locations [grpc-default-executor-1] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - GetManifest for /tmp/flinktestmo5Nd0/job_f9a78bef-59a8-4b21-8f29-defea500cb96/MANIFEST -> 0 artifacts [grpc-default-executor-1] INFO org.apache.beam.runners.fnexecution.logging.GrpcLoggingService - Beam Fn Logging client connected. [grpc-default-executor-1] INFO sdk_worker_main.main - Logging handler created. [grpc-default-executor-1] INFO sdk_worker_main.start - Status HTTP server running at localhost:43543 [grpc-default-executor-1] INFO sdk_worker_main.main - semi_persistent_directory: /tmp [grpc-default-executor-1] 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-1] 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-1] 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_1544183633.99', 'options_id': u'22', 'pipeline_type_check': None, 'parallelism': 1, 'job_endpoint': u'localhost:48643'} [grpc-default-executor-1] INFO sdk_worker.__init__ - Creating insecure control channel. [grpc-default-executor-1] INFO sdk_worker.__init__ - Control channel established. [grpc-default-executor-1] INFO sdk_worker.__init__ - Initializing SDKHarness with 12 workers. [grpc-default-executor-1] INFO org.apache.beam.runners.fnexecution.control.FnApiControlClientPoolService - Beam Fn Control client connected with id 1 [grpc-default-executor-1] INFO sdk_worker.create_state_handler - Creating channel for localhost:34399 [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/write/ref_PCollection_PCollection_4:0 [grpc-default-executor-1] INFO data_plane.create_data_channel - Creating channel for localhost:34767 [grpc-default-executor-1] INFO org.apache.beam.runners.fnexecution.data.GrpcDataService - Beam Fn Data client connected. [grpc-default-executor-1] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_17:0 [grpc-default-executor-1] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_1:0 [grpc-default-executor-1] 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) (2f60a43f53cc26f8b75ed9b63753369c) 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) (2f60a43f53cc26f8b75ed9b63753369c). [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) (2f60a43f53cc26f8b75ed9b63753369c) [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 -> [4]assert_that/{Create, Group} 2f60a43f53cc26f8b75ed9b63753369c. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (2f60a43f53cc26f8b75ed9b63753369c) 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) (7b753980cdca6ffcdcb5f01ff16b62a4) 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) (7b753980cdca6ffcdcb5f01ff16b62a4). [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) (7b753980cdca6ffcdcb5f01ff16b62a4) [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 Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem 7b753980cdca6ffcdcb5f01ff16b62a4. [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) (7b753980cdca6ffcdcb5f01ff16b62a4) 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: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) (ac28a3b33888858ce6cfbd7f000810cf) 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) (ac28a3b33888858ce6cfbd7f000810cf). [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) (ac28a3b33888858ce6cfbd7f000810cf) [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 ac28a3b33888858ce6cfbd7f000810cf. [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) (ac28a3b33888858ce6cfbd7f000810cf) 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: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) (77343ac63d992ef08481ed8e13da1ee9) 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) (77343ac63d992ef08481ed8e13da1ee9). [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) (77343ac63d992ef08481ed8e13da1ee9) [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:409>), assert_that} 77343ac63d992ef08481ed8e13da1ee9. [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (43be03f6d64e4862a123afa9d1890a3f) switched from RUNNING to FINISHED. [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for ToKeyedWorkItem (1/1) (43be03f6d64e4862a123afa9d1890a3f). [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task ToKeyedWorkItem (1/1) (43be03f6d64e4862a123afa9d1890a3f) [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 43be03f6d64e4862a123afa9d1890a3f. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} (1/1) (77343ac63d992ef08481ed8e13da1ee9) switched from RUNNING to FINISHED. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (43be03f6d64e4862a123afa9d1890a3f) 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-0] WARN org.apache.beam.sdk.fn.data.BeamFnDataGrpcMultiplexer - Hanged up for unknown endpoint. [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) (0a3301b08262c85f553ce986f9d49af3) 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) (0a3301b08262c85f553ce986f9d49af3). [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) (0a3301b08262c85f553ce986f9d49af3) [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} 0a3301b08262c85f553ce986f9d49af3. [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) (0a3301b08262c85f553ce986f9d49af3) switched from RUNNING to FINISHED. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544183633.99 (57b899d90b4d8e492a8a77956ac87e57) switched from state RUNNING to FINISHED. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.checkpoint.CheckpointCoordinator - Stopping checkpoint coordinator for job 57b899d90b4d8e492a8a77956ac87e57. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.checkpoint.StandaloneCompletedCheckpointStore - Shutting down [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Job 57b899d90b4d8e492a8a77956ac87e57 reached globally terminal state FINISHED. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Stopping the JobMaster for job test_windowing_1544183633.99(57b899d90b4d8e492a8a77956ac87e57). [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job 57b899d90b4d8e492a8a77956ac87e57. [flink-runner-job-server] INFO org.apache.flink.runtime.minicluster.MiniCluster - Shutting down Flink Mini Cluster [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Suspending SlotPool. [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.JobMaster - Close ResourceManager connection 9c8005651421faf98ecca6c90b8c8dde: JobManager is shutting down.. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping dispatcher akka://flink/user/dispatcher261a234b-6dc8-44f7-b7b0-7cc8b2c0e725. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping all currently running jobs of dispatcher akka://flink/user/dispatcher261a234b-6dc8-44f7-b7b0-7cc8b2c0e725. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Disconnect job manager a069384ff8e320809203ea9d28864146@akka://flink/user/jobmanager_43 for job 57b899d90b4d8e492a8a77956ac87e57 from the resource manager. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcActor - The rpc endpoint org.apache.flink.runtime.jobmaster.slotpool.SlotPool has not been started yet. Discarding message org.apache.flink.runtime.rpc.messages.LocalRpcInvocation until processing is started. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Stopping SlotPool. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Closing the SlotManager. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Suspending the SlotManager. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - JobManager for job 57b899d90b4d8e492a8a77956ac87e57 with leader id a069384ff8e320809203ea9d28864146 lost leadership. [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{9ad3e3d30192e3803d1e836779abf6b9}, jobId: 57b899d90b4d8e492a8a77956ac87e57). [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Remove job 57b899d90b4d8e492a8a77956ac87e57 from job leader monitoring. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job 57b899d90b4d8e492a8a77956ac87e57. [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. [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-3328ac3e-12af-474c-a316-3e653fa21da3 [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.io.network.NetworkEnvironment - Shutting down the network environment and its components. [ForkJoinPool.commonPool-worker-4] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Removing cache directory /tmp/flink-web-ui [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.rest.handler.legacy.backpressure.StackTraceSampleCoordinator - Shutting down stack trace sample coordinator. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopped dispatcher akka://flink/user/dispatcher261a234b-6dc8-44f7-b7b0-7cc8b2c0e725. [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-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:38839 [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 2261 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@a26e6bc1 INFO:root:Job state changed to DONE . ---------------------------------------------------------------------- Ran 27 tests in 82.158s OK (skipped=7) :beam-sdks-python:flinkCompatibilityMatrixStreamingDOCKER (Thread[Task worker for ':' Thread 4,5,main]) completed. Took 1 mins 24.355 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 2s 60 actionable tasks: 55 executed, 4 from cache, 1 up-to-date Publishing build scan... https://gradle.com/s/sxknr3mmcysbm 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]
