See <https://builds.apache.org/job/beam_PostCommit_Python_VR_Flink/986/display/redirect>
------------------------------------------ [...truncated 3.92 MB...] [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - http://localhost:44531 was granted leadership with leaderSessionID=9e9b5e30-821f-4fdd-897e-227d348f07b2 [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader http://localhost:44531 , session=9e9b5e30-821f-4fdd-897e-227d348f07b2 [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/dispatcherc9a3d96f-f5c7-43cf-9e1a-a06953e866ee . [flink-runner-job-server] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Proposing leadership to contender org.apache.flink.runtime.dispatcher.StandaloneDispatcher@6b28c347 @ akka://flink/user/dispatcherc9a3d96f-f5c7-43cf-9e1a-a06953e866ee [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Dispatcher akka://flink/user/dispatcherc9a3d96f-f5c7-43cf-9e1a-a06953e866ee was granted leadership with fencing token eb7678a3-fc6c-4742-9bbf-de2d95a90585 [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 - Recovering all persisted jobs. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader akka://flink/user/dispatcherc9a3d96f-f5c7-43cf-9e1a-a06953e866ee , session=eb7678a3-fc6c-4742-9bbf-de2d95a90585 [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Submitting job f94cb56a8e810c3b7dde547f935eb6f2 (test_windowing_1544206389.35). [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_1544206389.35 (f94cb56a8e810c3b7dde547f935eb6f2). [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - Using restart strategy NoRestartStrategy for test_windowing_1544206389.35 (f94cb56a8e810c3b7dde547f935eb6f2). [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/2eb5cfaf-cf22-4771-9b5b-c494b05b8827 . [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_1544206389.35 (f94cb56a8e810c3b7dde547f935eb6f2). [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@342a32ee @ akka://flink/user/jobmanager_43 [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.jobmaster.JobManagerRunner - JobManager runner for job test_windowing_1544206389.35 (f94cb56a8e810c3b7dde547f935eb6f2) was granted leadership with session id a571f382-c678-4804-9aed-15258f85ce49 at akka://flink/user/jobmanager_43. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Starting execution of job test_windowing_1544206389.35 (f94cb56a8e810c3b7dde547f935eb6f2) [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544206389.35 (f94cb56a8e810c3b7dde547f935eb6f2) switched from state CREATED to RUNNING. [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) (2f506efbe9982e5da0465ab1e1cc4407) switched from CREATED to SCHEDULED. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (e428854e3a125e0b21c8746b641eeb66) switched from CREATED to SCHEDULED. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem (1/1) (03166344c628617630debe2395383811) switched from CREATED to SCHEDULED. [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) (0c2d9203f3e604f84723e6235d766b6c) switched from CREATED to SCHEDULED. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Cannot serve slot request, no ResourceManager connected. Adding as pending request [SlotRequestId{4481a8b554c995cf5ba7d3a3c27ab352}] [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (35cb9ea58357fbcc9235c1c17e1b6261) switched from CREATED to SCHEDULED. [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) (ab4cc5e8b15c488dbf25c0f3c57629a4) switched from CREATED to SCHEDULED. [jobmanager-future-thread-1] INFO org.apache.flink.runtime.highavailability.nonha.embedded.EmbeddedLeaderService - Received confirmation of leadership for leader akka://flink/user/jobmanager_43 , session=a571f382-c678-4804-9aed-15258f85ce49 [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - Connecting to ResourceManager akka://flink/user/resourcemanager_9e2d677b-22ee-4afc-b1bb-5bd57a9592bd(82516f6c5513b41de08df72bf7904285) [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.jobmaster.JobMaster - Resolved ResourceManager address, beginning registration [flink-akka.actor.default-dispatcher-2] 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 9aed15258f85ce49a571f382c6784804@akka://flink/user/jobmanager_43 for job f94cb56a8e810c3b7dde547f935eb6f2. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Registered job manager 9aed15258f85ce49a571f382c6784804@akka://flink/user/jobmanager_43 for job f94cb56a8e810c3b7dde547f935eb6f2. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.JobMaster - JobManager successfully registered at ResourceManager, leader id: 82516f6c5513b41de08df72bf7904285. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Requesting new slot [SlotRequestId{4481a8b554c995cf5ba7d3a3c27ab352}] 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 f94cb56a8e810c3b7dde547f935eb6f2 with allocation id AllocationID{0d61e36eb5f031e23d4c70f291b803b9}. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Receive slot request AllocationID{0d61e36eb5f031e23d4c70f291b803b9} for job f94cb56a8e810c3b7dde547f935eb6f2 from resource manager with leader id 82516f6c5513b41de08df72bf7904285. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Allocated slot for AllocationID{0d61e36eb5f031e23d4c70f291b803b9}. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Add job f94cb56a8e810c3b7dde547f935eb6f2 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 a571f382-c678-4804-9aed-15258f85ce49. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Resolved JobManager address, beginning registration [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Registration at JobManager attempt 1 (timeout=100ms) [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Successful registration at job manager akka://flink/user/jobmanager_43 for job f94cb56a8e810c3b7dde547f935eb6f2. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Establish JobManager connection for job f94cb56a8e810c3b7dde547f935eb6f2. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Offer reserved slots to the leader of job f94cb56a8e810c3b7dde547f935eb6f2. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.slot.TaskSlotTable - Activate slot AllocationID{0d61e36eb5f031e23d4c70f291b803b9}. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (e428854e3a125e0b21c8746b641eeb66) 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) (2f506efbe9982e5da0465ab1e1cc4407) 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) (03166344c628617630debe2395383811) 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) (0c2d9203f3e604f84723e6235d766b6c) 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-5] 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) (35cb9ea58357fbcc9235c1c17e1b6261) 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) (e428854e3a125e0b21c8746b641eeb66) 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) (e428854e3a125e0b21c8746b641eeb66) [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) (ab4cc5e8b15c488dbf25c0f3c57629a4) 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 [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 - Loading JAR files for task Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (e428854e3a125e0b21c8746b641eeb66) [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) (2f506efbe9982e5da0465ab1e1cc4407) 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) (2f506efbe9982e5da0465ab1e1cc4407) [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) (2f506efbe9982e5da0465ab1e1cc4407) [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) (e428854e3a125e0b21c8746b641eeb66) [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) (2f506efbe9982e5da0465ab1e1cc4407) [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) (03166344c628617630debe2395383811) 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) (03166344c628617630debe2395383811) [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) (03166344c628617630debe2395383811) [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) (03166344c628617630debe2395383811) [DEPLOYING]. [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). [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) (0c2d9203f3e604f84723e6235d766b6c) 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) (0c2d9203f3e604f84723e6235d766b6c) [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) (0c2d9203f3e604f84723e6235d766b6c) [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) (0c2d9203f3e604f84723e6235d766b6c) [DEPLOYING]. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Received task ToKeyedWorkItem (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) (0c2d9203f3e604f84723e6235d766b6c) switched from DEPLOYING to RUNNING. [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (35cb9ea58357fbcc9235c1c17e1b6261) 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) (35cb9ea58357fbcc9235c1c17e1b6261) [DEPLOYING] [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Loading JAR files for task ToKeyedWorkItem (1/1) (35cb9ea58357fbcc9235c1c17e1b6261) [DEPLOYING]. [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) (0c2d9203f3e604f84723e6235d766b6c) 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) (35cb9ea58357fbcc9235c1c17e1b6261) [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) (e428854e3a125e0b21c8746b641eeb66) 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). [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) (03166344c628617630debe2395383811) 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) (e428854e3a125e0b21c8746b641eeb66) 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) [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) (2f506efbe9982e5da0465ab1e1cc4407) switched from DEPLOYING to RUNNING. [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) (03166344c628617630debe2395383811) 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-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [3]Create/{FlatMap(<lambda at core.py:2027>), MaybeReshuffle} -> ToKeyedWorkItem (1/1) (2f506efbe9982e5da0465ab1e1cc4407) 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) [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) (ab4cc5e8b15c488dbf25c0f3c57629a4) 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) (ab4cc5e8b15c488dbf25c0f3c57629a4) [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) (ab4cc5e8b15c488dbf25c0f3c57629a4) [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) (ab4cc5e8b15c488dbf25c0f3c57629a4) [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) (ab4cc5e8b15c488dbf25c0f3c57629a4) switched from DEPLOYING to RUNNING. [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (35cb9ea58357fbcc9235c1c17e1b6261) switched from DEPLOYING to RUNNING. [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) (ab4cc5e8b15c488dbf25c0f3c57629a4) 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.streaming.runtime.tasks.StreamTask - No state backend has been configured, using default (Memory / JobManager) MemoryStateBackend (data in heap memory / checkpoints to JobManager) (checkpoints: 'null', savepoints: 'null', asynchronous: TRUE, maxStateSize: 5242880) [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (35cb9ea58357fbcc9235c1c17e1b6261) 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-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - GetManifest for /tmp/flinktestdtmtaG/job_7f21e21d-b303-4716-8987-77fd7def254e/MANIFEST [grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Loading manifest for retrieval token /tmp/flinktestdtmtaG/job_7f21e21d-b303-4716-8987-77fd7def254e/MANIFEST [grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - Manifest at /tmp/flinktestdtmtaG/job_7f21e21d-b303-4716-8987-77fd7def254e/MANIFEST has 0 artifact locations [grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.artifact.BeamFileSystemArtifactRetrievalService - GetManifest for /tmp/flinktestdtmtaG/job_7f21e21d-b303-4716-8987-77fd7def254e/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:37715 [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_1544206389.35', 'options_id': u'22', 'pipeline_type_check': None, 'parallelism': 1, 'job_endpoint': u'localhost:57099'} [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:33111 [grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_4:0 [grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_24:1:0 [grpc-default-executor-2] INFO data_plane.create_data_channel - Creating channel for localhost:44545 [grpc-default-executor-2] INFO org.apache.beam.runners.fnexecution.data.GrpcDataService - Beam Fn Data client connected. [grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_17:0 [grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/read/ref_PCollection_PCollection_1:0 [grpc-default-executor-2] WARN bundle_processor.create_operation - No unique name set for transform fn/write/ref_PCollection_PCollection_12:0 [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) (e428854e3a125e0b21c8746b641eeb66) 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) (e428854e3a125e0b21c8746b641eeb66). [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) (e428854e3a125e0b21c8746b641eeb66) [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} e428854e3a125e0b21c8746b641eeb66. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Source: Impulse -> [4]assert_that/{Create, Group} (1/1) (e428854e3a125e0b21c8746b641eeb66) 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) (2f506efbe9982e5da0465ab1e1cc4407) 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) (2f506efbe9982e5da0465ab1e1cc4407). [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) (2f506efbe9982e5da0465ab1e1cc4407) [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 2f506efbe9982e5da0465ab1e1cc4407. [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) (2f506efbe9982e5da0465ab1e1cc4407) 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) (03166344c628617630debe2395383811) 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) (03166344c628617630debe2395383811). [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) (03166344c628617630debe2395383811) [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 Create/MaybeReshuffle/Reshuffle/ReshufflePerKey/GroupByKey -> [5]{Create, Map(<lambda at fn_api_runner_test.py:406>), WindowInto(WindowIntoFn)} -> ToKeyedWorkItem 03166344c628617630debe2395383811. [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) (03166344c628617630debe2395383811) 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) (0c2d9203f3e604f84723e6235d766b6c) 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) (0c2d9203f3e604f84723e6235d766b6c). [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) (0c2d9203f3e604f84723e6235d766b6c) [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 GroupByKey -> [5]{Map(<lambda at fn_api_runner_test.py:409>), assert_that} 0c2d9203f3e604f84723e6235d766b6c. [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - ToKeyedWorkItem (1/1) (35cb9ea58357fbcc9235c1c17e1b6261) switched from RUNNING to FINISHED. [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Freeing task resources for ToKeyedWorkItem (1/1) (35cb9ea58357fbcc9235c1c17e1b6261). [ToKeyedWorkItem (1/1)] INFO org.apache.flink.runtime.taskmanager.Task - Ensuring all FileSystem streams are closed for task ToKeyedWorkItem (1/1) (35cb9ea58357fbcc9235c1c17e1b6261) [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 ToKeyedWorkItem 35cb9ea58357fbcc9235c1c17e1b6261. [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) (0c2d9203f3e604f84723e6235d766b6c) switched from RUNNING to FINISHED. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - ToKeyedWorkItem (1/1) (35cb9ea58357fbcc9235c1c17e1b6261) 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-1] WARN org.apache.beam.sdk.fn.data.BeamFnDataGrpcMultiplexer - Hanged up for unknown endpoint. [grpc-default-executor-2] INFO data_plane.close - Closing all cached grpc data channels. [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) (ab4cc5e8b15c488dbf25c0f3c57629a4) 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) (ab4cc5e8b15c488dbf25c0f3c57629a4). [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) (ab4cc5e8b15c488dbf25c0f3c57629a4) [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 assert_that/Group/GroupByKey -> [3]assert_that/{Group, Unkey, Match} ab4cc5e8b15c488dbf25c0f3c57629a4. [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) (ab4cc5e8b15c488dbf25c0f3c57629a4) switched from RUNNING to FINISHED. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.executiongraph.ExecutionGraph - Job test_windowing_1544206389.35 (f94cb56a8e810c3b7dde547f935eb6f2) switched from state RUNNING to FINISHED. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.checkpoint.CheckpointCoordinator - Stopping checkpoint coordinator for job f94cb56a8e810c3b7dde547f935eb6f2. [flink-akka.actor.default-dispatcher-5] INFO org.apache.flink.runtime.checkpoint.StandaloneCompletedCheckpointStore - Shutting down [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Job f94cb56a8e810c3b7dde547f935eb6f2 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_1544206389.35(f94cb56a8e810c3b7dde547f935eb6f2). [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job f94cb56a8e810c3b7dde547f935eb6f2. [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 0c2ef9782377b850940d1a8c5344ce2c: JobManager is shutting down.. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping dispatcher akka://flink/user/dispatcherc9a3d96f-f5c7-43cf-9e1a-a06953e866ee. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.dispatcher.StandaloneDispatcher - Stopping all currently running jobs of dispatcher akka://flink/user/dispatcherc9a3d96f-f5c7-43cf-9e1a-a06953e866ee. [flink-akka.actor.default-dispatcher-3] 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-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{0d61e36eb5f031e23d4c70f291b803b9}, jobId: f94cb56a8e810c3b7dde547f935eb6f2). [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.JobLeaderService - Remove job f94cb56a8e810c3b7dde547f935eb6f2 from job leader monitoring. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.taskexecutor.TaskExecutor - Close JobManager connection for job f94cb56a8e810c3b7dde547f935eb6f2. [flink-akka.actor.default-dispatcher-4] INFO org.apache.flink.runtime.resourcemanager.StandaloneResourceManager - Disconnect job manager 9aed15258f85ce49a571f382c6784804@akka://flink/user/jobmanager_43 for job f94cb56a8e810c3b7dde547f935eb6f2 from the resource manager. [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-4] INFO org.apache.flink.runtime.resourcemanager.slotmanager.SlotManager - Closing the SlotManager. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.jobmaster.slotpool.SlotPool - Stopping SlotPool. [flink-akka.actor.default-dispatcher-2] INFO org.apache.flink.runtime.state.TaskExecutorLocalStateStoresManager - Shutting down TaskExecutorLocalStateStoresManager. [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.io.disk.iomanager.IOManager - I/O manager removed spill file directory /tmp/flink-io-333c08d6-f917-40b5-8d03-24ff52bee246 [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/dispatcherc9a3d96f-f5c7-43cf-9e1a-a06953e866ee. [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. [ForkJoinPool.commonPool-worker-2] INFO org.apache.flink.runtime.dispatcher.DispatcherRestEndpoint - Removing cache directory /tmp/flink-web-ui [ForkJoinPool.commonPool-worker-2] INFO org.apache.flink.runtime.rpc.akka.AkkaRpcService - Stopping Akka RPC service. [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.blob.PermanentBlobCache - Shutting down BLOB cache [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.blob.TransientBlobCache - Shutting down BLOB cache [flink-akka.actor.default-dispatcher-3] INFO org.apache.flink.runtime.blob.BlobServer - Stopped BLOB server at 0.0.0.0:36845 [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 2270 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@ed9704b8 INFO:root:Job state changed to DONE . ---------------------------------------------------------------------- Ran 27 tests in 90.007s OK (skipped=7) :beam-sdks-python:flinkCompatibilityMatrixStreamingDOCKER (Thread[Daemon worker,5,main]) completed. Took 1 mins 32.464 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 58s 60 actionable tasks: 55 executed, 4 from cache, 1 up-to-date Publishing build scan... https://gradle.com/s/gizjg57w6nmdi 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]
