You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@beam.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2019/07/06 16:16:14 UTC
Build failed in Jenkins:
beam_LoadTests_Python_Combine_Dataflow_Batch #5
See <https://builds.apache.org/job/beam_LoadTests_Python_Combine_Dataflow_Batch/5/display/redirect>
------------------------------------------
[...truncated 385.03 KB...]
root: INFO: 2019-07-06T16:09:06.714Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
root: INFO: 2019-07-06T16:09:06.807Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
root: INFO: 2019-07-06T16:09:06.855Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 1/KeyWithVoid into Measure time: Start
root: INFO: 2019-07-06T16:09:06.908Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 2/KeyWithVoid into Measure time: Start
root: INFO: 2019-07-06T16:09:06.953Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/KeyWithVoid into Measure time: Start
root: INFO: 2019-07-06T16:09:06.999Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 3/KeyWithVoid into Measure time: Start
root: INFO: 2019-07-06T16:09:07.049Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 4/KeyWithVoid into Measure time: Start
root: INFO: 2019-07-06T16:09:07.100Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 5/KeyWithVoid into Measure time: Start
root: INFO: 2019-07-06T16:09:07.147Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 6/KeyWithVoid into Measure time: Start
root: INFO: 2019-07-06T16:09:07.195Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 7/KeyWithVoid into Measure time: Start
root: INFO: 2019-07-06T16:09:07.240Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 1/CombinePerKey/GroupByKey+Combine with Top 1/CombinePerKey/Combine/Partial into Combine with Top 1/KeyWithVoid
root: INFO: 2019-07-06T16:09:07.284Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 1/CombinePerKey/Combine/Extract into Combine with Top 1/CombinePerKey/Combine
root: INFO: 2019-07-06T16:09:07.330Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 2/UnKey into Combine with Top 2/CombinePerKey/Combine/Extract
root: INFO: 2019-07-06T16:09:07.378Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 5/CombinePerKey/GroupByKey+Combine with Top 5/CombinePerKey/Combine/Partial into Combine with Top 5/KeyWithVoid
root: INFO: 2019-07-06T16:09:07.415Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 2/CombinePerKey/Combine/Extract into Combine with Top 2/CombinePerKey/Combine
root: INFO: 2019-07-06T16:09:07.456Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 4/UnKey into Combine with Top 4/CombinePerKey/Combine/Extract
root: INFO: 2019-07-06T16:09:07.501Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 4/CombinePerKey/Combine/Extract into Combine with Top 4/CombinePerKey/Combine
root: INFO: 2019-07-06T16:09:07.552Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/UnKey into Combine with Top 0/CombinePerKey/Combine/Extract
root: INFO: 2019-07-06T16:09:07.590Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/CombinePerKey/Combine/Extract into Combine with Top 0/CombinePerKey/Combine
root: INFO: 2019-07-06T16:09:07.646Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 1/CombinePerKey/Combine into Combine with Top 1/CombinePerKey/GroupByKey/Read
root: INFO: 2019-07-06T16:09:07.687Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 2/CombinePerKey/Combine into Combine with Top 2/CombinePerKey/GroupByKey/Read
root: INFO: 2019-07-06T16:09:07.735Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 4/CombinePerKey/Combine into Combine with Top 4/CombinePerKey/GroupByKey/Read
root: INFO: 2019-07-06T16:09:07.781Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/CombinePerKey/Combine into Combine with Top 0/CombinePerKey/GroupByKey/Read
root: INFO: 2019-07-06T16:09:07.820Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/CombinePerKey/GroupByKey/Write into Combine with Top 0/CombinePerKey/GroupByKey/Reify
root: INFO: 2019-07-06T16:09:07.857Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 4/CombinePerKey/GroupByKey/Write into Combine with Top 4/CombinePerKey/GroupByKey/Reify
root: INFO: 2019-07-06T16:09:07.905Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/CombinePerKey/GroupByKey/Reify into Combine with Top 0/CombinePerKey/GroupByKey+Combine with Top 0/CombinePerKey/Combine/Partial
root: INFO: 2019-07-06T16:09:07.947Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/CombinePerKey/GroupByKey+Combine with Top 0/CombinePerKey/Combine/Partial into Combine with Top 0/KeyWithVoid
root: INFO: 2019-07-06T16:09:07.994Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 2/CombinePerKey/GroupByKey/Write into Combine with Top 2/CombinePerKey/GroupByKey/Reify
root: INFO: 2019-07-06T16:09:08.039Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 4/CombinePerKey/GroupByKey/Reify into Combine with Top 4/CombinePerKey/GroupByKey+Combine with Top 4/CombinePerKey/Combine/Partial
root: INFO: 2019-07-06T16:09:08.081Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 7/UnKey into Combine with Top 7/CombinePerKey/Combine/Extract
root: INFO: 2019-07-06T16:09:08.128Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 4/CombinePerKey/GroupByKey+Combine with Top 4/CombinePerKey/Combine/Partial into Combine with Top 4/KeyWithVoid
root: INFO: 2019-07-06T16:09:08.172Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 7/CombinePerKey/Combine/Extract into Combine with Top 7/CombinePerKey/Combine
root: INFO: 2019-07-06T16:09:08.215Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 7/CombinePerKey/Combine into Combine with Top 7/CombinePerKey/GroupByKey/Read
root: INFO: 2019-07-06T16:09:08.260Z: JOB_MESSAGE_DETAILED: Fusing consumer Measure time: Start into Read
root: INFO: 2019-07-06T16:09:08.302Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 1/CombinePerKey/GroupByKey/Write into Combine with Top 1/CombinePerKey/GroupByKey/Reify
root: INFO: 2019-07-06T16:09:08.350Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 2/CombinePerKey/GroupByKey/Reify into Combine with Top 2/CombinePerKey/GroupByKey+Combine with Top 2/CombinePerKey/Combine/Partial
root: INFO: 2019-07-06T16:09:08.395Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 7/CombinePerKey/GroupByKey/Write into Combine with Top 7/CombinePerKey/GroupByKey/Reify
root: INFO: 2019-07-06T16:09:08.442Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 7/CombinePerKey/GroupByKey/Reify into Combine with Top 7/CombinePerKey/GroupByKey+Combine with Top 7/CombinePerKey/Combine/Partial
root: INFO: 2019-07-06T16:09:08.478Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 3/UnKey into Combine with Top 3/CombinePerKey/Combine/Extract
root: INFO: 2019-07-06T16:09:08.522Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 7/CombinePerKey/GroupByKey+Combine with Top 7/CombinePerKey/Combine/Partial into Combine with Top 7/KeyWithVoid
root: INFO: 2019-07-06T16:09:08.571Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 2/CombinePerKey/GroupByKey+Combine with Top 2/CombinePerKey/Combine/Partial into Combine with Top 2/KeyWithVoid
root: INFO: 2019-07-06T16:09:08.616Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 3/CombinePerKey/Combine/Extract into Combine with Top 3/CombinePerKey/Combine
root: INFO: 2019-07-06T16:09:08.657Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 6/UnKey into Combine with Top 6/CombinePerKey/Combine/Extract
root: INFO: 2019-07-06T16:09:08.709Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 6/CombinePerKey/Combine/Extract into Combine with Top 6/CombinePerKey/Combine
root: INFO: 2019-07-06T16:09:08.756Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 3/CombinePerKey/Combine into Combine with Top 3/CombinePerKey/GroupByKey/Read
root: INFO: 2019-07-06T16:09:08.805Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 6/CombinePerKey/Combine into Combine with Top 6/CombinePerKey/GroupByKey/Read
root: INFO: 2019-07-06T16:09:08.850Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 6/CombinePerKey/GroupByKey/Write into Combine with Top 6/CombinePerKey/GroupByKey/Reify
root: INFO: 2019-07-06T16:09:08.898Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 1/CombinePerKey/GroupByKey/Reify into Combine with Top 1/CombinePerKey/GroupByKey+Combine with Top 1/CombinePerKey/Combine/Partial
root: INFO: 2019-07-06T16:09:08.946Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 3/CombinePerKey/GroupByKey/Write into Combine with Top 3/CombinePerKey/GroupByKey/Reify
root: INFO: 2019-07-06T16:09:08.996Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 6/CombinePerKey/GroupByKey/Reify into Combine with Top 6/CombinePerKey/GroupByKey+Combine with Top 6/CombinePerKey/Combine/Partial
root: INFO: 2019-07-06T16:09:09.040Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 6/CombinePerKey/GroupByKey+Combine with Top 6/CombinePerKey/Combine/Partial into Combine with Top 6/KeyWithVoid
root: INFO: 2019-07-06T16:09:09.086Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 3/CombinePerKey/GroupByKey/Reify into Combine with Top 3/CombinePerKey/GroupByKey+Combine with Top 3/CombinePerKey/Combine/Partial
root: INFO: 2019-07-06T16:09:09.133Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 5/UnKey into Combine with Top 5/CombinePerKey/Combine/Extract
root: INFO: 2019-07-06T16:09:09.182Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 1/UnKey into Combine with Top 1/CombinePerKey/Combine/Extract
root: INFO: 2019-07-06T16:09:09.229Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 3/CombinePerKey/GroupByKey+Combine with Top 3/CombinePerKey/Combine/Partial into Combine with Top 3/KeyWithVoid
root: INFO: 2019-07-06T16:09:09.272Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 5/CombinePerKey/Combine/Extract into Combine with Top 5/CombinePerKey/Combine
root: INFO: 2019-07-06T16:09:09.321Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 5/CombinePerKey/Combine into Combine with Top 5/CombinePerKey/GroupByKey/Read
root: INFO: 2019-07-06T16:09:09.370Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 5/CombinePerKey/GroupByKey/Write into Combine with Top 5/CombinePerKey/GroupByKey/Reify
root: INFO: 2019-07-06T16:09:09.414Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 5/CombinePerKey/GroupByKey/Reify into Combine with Top 5/CombinePerKey/GroupByKey+Combine with Top 5/CombinePerKey/Combine/Partial
root: INFO: 2019-07-06T16:09:09.463Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 1/InjectDefault/InjectDefault into Combine with Top 1/DoOnce/Read
root: INFO: 2019-07-06T16:09:09.495Z: JOB_MESSAGE_DETAILED: Fusing consumer Consume 7 into Combine with Top 7/InjectDefault/InjectDefault
root: INFO: 2019-07-06T16:09:09.540Z: JOB_MESSAGE_DETAILED: Fusing consumer Measure time: End 5 into Consume 5
root: INFO: 2019-07-06T16:09:09.577Z: JOB_MESSAGE_DETAILED: Fusing consumer Measure time: End 1 into Consume 1
root: INFO: 2019-07-06T16:09:09.623Z: JOB_MESSAGE_DETAILED: Fusing consumer Measure time: End 0 into Consume 0
root: INFO: 2019-07-06T16:09:09.668Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/InjectDefault/InjectDefault into Combine with Top 0/DoOnce/Read
root: INFO: 2019-07-06T16:09:09.718Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 7/InjectDefault/InjectDefault into Combine with Top 7/DoOnce/Read
root: INFO: 2019-07-06T16:09:09.759Z: JOB_MESSAGE_DETAILED: Fusing consumer Measure time: End 6 into Consume 6
root: INFO: 2019-07-06T16:09:09.795Z: JOB_MESSAGE_DETAILED: Fusing consumer Consume 5 into Combine with Top 5/InjectDefault/InjectDefault
root: INFO: 2019-07-06T16:09:09.836Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 5/InjectDefault/InjectDefault into Combine with Top 5/DoOnce/Read
root: INFO: 2019-07-06T16:09:09.881Z: JOB_MESSAGE_DETAILED: Fusing consumer Measure time: End 4 into Consume 4
root: INFO: 2019-07-06T16:09:09.915Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 3/InjectDefault/InjectDefault into Combine with Top 3/DoOnce/Read
root: INFO: 2019-07-06T16:09:09.953Z: JOB_MESSAGE_DETAILED: Fusing consumer Measure time: End 2 into Consume 2
root: INFO: 2019-07-06T16:09:09.999Z: JOB_MESSAGE_DETAILED: Fusing consumer Measure time: End 3 into Consume 3
root: INFO: 2019-07-06T16:09:10.047Z: JOB_MESSAGE_DETAILED: Fusing consumer Consume 6 into Combine with Top 6/InjectDefault/InjectDefault
root: INFO: 2019-07-06T16:09:10.086Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 4/InjectDefault/InjectDefault into Combine with Top 4/DoOnce/Read
root: INFO: 2019-07-06T16:09:10.123Z: JOB_MESSAGE_DETAILED: Fusing consumer Consume 1 into Combine with Top 1/InjectDefault/InjectDefault
root: INFO: 2019-07-06T16:09:10.166Z: JOB_MESSAGE_DETAILED: Fusing consumer Measure time: End 7 into Consume 7
root: INFO: 2019-07-06T16:09:10.210Z: JOB_MESSAGE_DETAILED: Fusing consumer Consume 0 into Combine with Top 0/InjectDefault/InjectDefault
root: INFO: 2019-07-06T16:09:10.247Z: JOB_MESSAGE_DETAILED: Fusing consumer Consume 4 into Combine with Top 4/InjectDefault/InjectDefault
root: INFO: 2019-07-06T16:09:10.290Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 6/InjectDefault/InjectDefault into Combine with Top 6/DoOnce/Read
root: INFO: 2019-07-06T16:09:10.332Z: JOB_MESSAGE_DETAILED: Fusing consumer Consume 2 into Combine with Top 2/InjectDefault/InjectDefault
root: INFO: 2019-07-06T16:09:10.373Z: JOB_MESSAGE_DETAILED: Fusing consumer Consume 3 into Combine with Top 3/InjectDefault/InjectDefault
root: INFO: 2019-07-06T16:09:10.401Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 2/InjectDefault/InjectDefault into Combine with Top 2/DoOnce/Read
root: INFO: 2019-07-06T16:09:10.454Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
root: INFO: 2019-07-06T16:09:10.502Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
root: INFO: 2019-07-06T16:09:10.528Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
root: INFO: 2019-07-06T16:09:10.567Z: JOB_MESSAGE_DEBUG: Assigning stage ids.
root: INFO: 2019-07-06T16:09:10.799Z: JOB_MESSAGE_DEBUG: Executing wait step start163
root: INFO: 2019-07-06T16:09:10.895Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 1/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:10.934Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 2/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:10.946Z: JOB_MESSAGE_DEBUG: Starting worker pool setup.
root: INFO: 2019-07-06T16:09:10.977Z: JOB_MESSAGE_BASIC: Starting 16 workers in us-central1-a...
root: INFO: 2019-07-06T16:09:10.978Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 3/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.027Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 4/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.040Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 1/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.057Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 2/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.057Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 3/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.072Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 0/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.092Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 4/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.116Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 5/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.136Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 0/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.159Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-a.
root: INFO: 2019-07-06T16:09:11.163Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 6/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.185Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 5/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.212Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 7/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.233Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 6/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.255Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 1/CombinePerKey/GroupByKey/Session" materialized.
root: INFO: 2019-07-06T16:09:11.277Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 7/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-06T16:09:11.300Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 2/CombinePerKey/GroupByKey/Session" materialized.
root: INFO: 2019-07-06T16:09:11.348Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 3/CombinePerKey/GroupByKey/Session" materialized.
root: INFO: 2019-07-06T16:09:11.383Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 4/CombinePerKey/GroupByKey/Session" materialized.
root: INFO: 2019-07-06T16:09:11.427Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 0/CombinePerKey/GroupByKey/Session" materialized.
root: INFO: 2019-07-06T16:09:11.465Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 5/CombinePerKey/GroupByKey/Session" materialized.
root: INFO: 2019-07-06T16:09:11.513Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 6/CombinePerKey/GroupByKey/Session" materialized.
root: INFO: 2019-07-06T16:09:11.558Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 7/CombinePerKey/GroupByKey/Session" materialized.
root: INFO: 2019-07-06T16:09:11.657Z: JOB_MESSAGE_BASIC: Executing operation Read+Measure time: Start+Combine with Top 1/KeyWithVoid+Combine with Top 2/KeyWithVoid+Combine with Top 0/KeyWithVoid+Combine with Top 3/KeyWithVoid+Combine with Top 4/KeyWithVoid+Combine with Top 5/KeyWithVoid+Combine with Top 6/KeyWithVoid+Combine with Top 7/KeyWithVoid+Combine with Top 1/CombinePerKey/GroupByKey+Combine with Top 1/CombinePerKey/Combine/Partial+Combine with Top 5/CombinePerKey/GroupByKey+Combine with Top 5/CombinePerKey/Combine/Partial+Combine with Top 0/CombinePerKey/GroupByKey+Combine with Top 0/CombinePerKey/Combine/Partial+Combine with Top 0/CombinePerKey/GroupByKey/Reify+Combine with Top 0/CombinePerKey/GroupByKey/Write+Combine with Top 4/CombinePerKey/GroupByKey+Combine with Top 4/CombinePerKey/Combine/Partial+Combine with Top 4/CombinePerKey/GroupByKey/Reify+Combine with Top 4/CombinePerKey/GroupByKey/Write+Combine with Top 7/CombinePerKey/GroupByKey+Combine with Top 7/CombinePerKey/Combine/Partial+Combine with Top 7/CombinePerKey/GroupByKey/Reify+Combine with Top 7/CombinePerKey/GroupByKey/Write+Combine with Top 2/CombinePerKey/GroupByKey+Combine with Top 2/CombinePerKey/Combine/Partial+Combine with Top 2/CombinePerKey/GroupByKey/Reify+Combine with Top 2/CombinePerKey/GroupByKey/Write+Combine with Top 1/CombinePerKey/GroupByKey/Reify+Combine with Top 1/CombinePerKey/GroupByKey/Write+Combine with Top 6/CombinePerKey/GroupByKey+Combine with Top 6/CombinePerKey/Combine/Partial+Combine with Top 6/CombinePerKey/GroupByKey/Reify+Combine with Top 6/CombinePerKey/GroupByKey/Write+Combine with Top 3/CombinePerKey/GroupByKey+Combine with Top 3/CombinePerKey/Combine/Partial+Combine with Top 3/CombinePerKey/GroupByKey/Reify+Combine with Top 3/CombinePerKey/GroupByKey/Write+Combine with Top 5/CombinePerKey/GroupByKey/Reify+Combine with Top 5/CombinePerKey/GroupByKey/Write
root: INFO: Job 2019-07-06_09_09_01-122050152604082817 is in state JOB_STATE_RUNNING
root: INFO: 2019-07-06T16:09:51.518Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 3 based on the rate of progress in the currently running step(s).
root: INFO: 2019-07-06T16:09:51.566Z: JOB_MESSAGE_DETAILED: Resized worker pool to 3, though goal was 16. This could be a quota issue.
root: INFO: 2019-07-06T16:09:57.067Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 11 based on the rate of progress in the currently running step(s).
root: INFO: 2019-07-06T16:09:57.113Z: JOB_MESSAGE_DETAILED: Resized worker pool to 11, though goal was 16. This could be a quota issue.
root: INFO: 2019-07-06T16:10:02.425Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 15 based on the rate of progress in the currently running step(s).
root: INFO: 2019-07-06T16:10:02.470Z: JOB_MESSAGE_DETAILED: Resized worker pool to 15, though goal was 16. This could be a quota issue.
root: INFO: 2019-07-06T16:10:18.346Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 16 based on the rate of progress in the currently running step(s).
root: INFO: 2019-07-06T16:10:37.352Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-07-06T16:10:37.399Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-07-06T16:12:11.223Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-a.
root: INFO: 2019-07-06T16:13:29.234Z: JOB_MESSAGE_BASIC: Finished operation Read+Measure time: Start+Combine with Top 1/KeyWithVoid+Combine with Top 2/KeyWithVoid+Combine with Top 0/KeyWithVoid+Combine with Top 3/KeyWithVoid+Combine with Top 4/KeyWithVoid+Combine with Top 5/KeyWithVoid+Combine with Top 6/KeyWithVoid+Combine with Top 7/KeyWithVoid+Combine with Top 1/CombinePerKey/GroupByKey+Combine with Top 1/CombinePerKey/Combine/Partial+Combine with Top 5/CombinePerKey/GroupByKey+Combine with Top 5/CombinePerKey/Combine/Partial+Combine with Top 0/CombinePerKey/GroupByKey+Combine with Top 0/CombinePerKey/Combine/Partial+Combine with Top 0/CombinePerKey/GroupByKey/Reify+Combine with Top 0/CombinePerKey/GroupByKey/Write+Combine with Top 4/CombinePerKey/GroupByKey+Combine with Top 4/CombinePerKey/Combine/Partial+Combine with Top 4/CombinePerKey/GroupByKey/Reify+Combine with Top 4/CombinePerKey/GroupByKey/Write+Combine with Top 7/CombinePerKey/GroupByKey+Combine with Top 7/CombinePerKey/Combine/Partial+Combine with Top 7/CombinePerKey/GroupByKey/Reify+Combine with Top 7/CombinePerKey/GroupByKey/Write+Combine with Top 2/CombinePerKey/GroupByKey+Combine with Top 2/CombinePerKey/Combine/Partial+Combine with Top 2/CombinePerKey/GroupByKey/Reify+Combine with Top 2/CombinePerKey/GroupByKey/Write+Combine with Top 1/CombinePerKey/GroupByKey/Reify+Combine with Top 1/CombinePerKey/GroupByKey/Write+Combine with Top 6/CombinePerKey/GroupByKey+Combine with Top 6/CombinePerKey/Combine/Partial+Combine with Top 6/CombinePerKey/GroupByKey/Reify+Combine with Top 6/CombinePerKey/GroupByKey/Write+Combine with Top 3/CombinePerKey/GroupByKey+Combine with Top 3/CombinePerKey/Combine/Partial+Combine with Top 3/CombinePerKey/GroupByKey/Reify+Combine with Top 3/CombinePerKey/GroupByKey/Write+Combine with Top 5/CombinePerKey/GroupByKey/Reify+Combine with Top 5/CombinePerKey/GroupByKey/Write
root: INFO: 2019-07-06T16:13:29.344Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 1/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.392Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 5/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.414Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 1/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.433Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 6/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.453Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 5/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.476Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 3/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.495Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 6/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.524Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 2/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.542Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 3/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.572Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 7/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.589Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 2/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.615Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 4/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.632Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 7/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.662Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 0/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.679Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 4/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.702Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 1/CombinePerKey/GroupByKey/Read+Combine with Top 1/CombinePerKey/Combine+Combine with Top 1/CombinePerKey/Combine/Extract+Combine with Top 1/UnKey
root: INFO: 2019-07-06T16:13:29.720Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 0/CombinePerKey/GroupByKey/Close
root: INFO: 2019-07-06T16:13:29.753Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 5/CombinePerKey/GroupByKey/Read+Combine with Top 5/CombinePerKey/Combine+Combine with Top 5/CombinePerKey/Combine/Extract+Combine with Top 5/UnKey
root: INFO: 2019-07-06T16:13:29.791Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 6/CombinePerKey/GroupByKey/Read+Combine with Top 6/CombinePerKey/Combine+Combine with Top 6/CombinePerKey/Combine/Extract+Combine with Top 6/UnKey
root: INFO: 2019-07-06T16:13:29.840Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 3/CombinePerKey/GroupByKey/Read+Combine with Top 3/CombinePerKey/Combine+Combine with Top 3/CombinePerKey/Combine/Extract+Combine with Top 3/UnKey
root: INFO: 2019-07-06T16:13:29.888Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 2/CombinePerKey/GroupByKey/Read+Combine with Top 2/CombinePerKey/Combine+Combine with Top 2/CombinePerKey/Combine/Extract+Combine with Top 2/UnKey
root: INFO: 2019-07-06T16:13:29.942Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 7/CombinePerKey/GroupByKey/Read+Combine with Top 7/CombinePerKey/Combine+Combine with Top 7/CombinePerKey/Combine/Extract+Combine with Top 7/UnKey
root: INFO: 2019-07-06T16:13:29.995Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 4/CombinePerKey/GroupByKey/Read+Combine with Top 4/CombinePerKey/Combine+Combine with Top 4/CombinePerKey/Combine/Extract+Combine with Top 4/UnKey
root: INFO: 2019-07-06T16:13:30.031Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 0/CombinePerKey/GroupByKey/Read+Combine with Top 0/CombinePerKey/Combine+Combine with Top 0/CombinePerKey/Combine/Extract+Combine with Top 0/UnKey
root: INFO: 2019-07-06T16:13:38.829Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 7/CombinePerKey/GroupByKey/Read+Combine with Top 7/CombinePerKey/Combine+Combine with Top 7/CombinePerKey/Combine/Extract+Combine with Top 7/UnKey
root: INFO: 2019-07-06T16:13:38.917Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 7/UnKey.out" materialized.
root: INFO: 2019-07-06T16:13:39.012Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 7/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:39.081Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 7/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:39.184Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 7/InjectDefault/_UnpickledSideInput(UnKey.out.0).output" materialized.
root: INFO: 2019-07-06T16:13:39.266Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 7/DoOnce/Read+Combine with Top 7/InjectDefault/InjectDefault+Consume 7+Measure time: End 7
root: INFO: 2019-07-06T16:13:40.029Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 0/CombinePerKey/GroupByKey/Read+Combine with Top 0/CombinePerKey/Combine+Combine with Top 0/CombinePerKey/Combine/Extract+Combine with Top 0/UnKey
root: INFO: 2019-07-06T16:13:40.131Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 0/UnKey.out" materialized.
root: INFO: 2019-07-06T16:13:40.229Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 0/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:40.322Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 0/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:40.425Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 0/InjectDefault/_UnpickledSideInput(UnKey.out.0).output" materialized.
root: INFO: 2019-07-06T16:13:40.496Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 3/CombinePerKey/GroupByKey/Read+Combine with Top 3/CombinePerKey/Combine+Combine with Top 3/CombinePerKey/Combine/Extract+Combine with Top 3/UnKey
root: INFO: 2019-07-06T16:13:40.521Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 0/DoOnce/Read+Combine with Top 0/InjectDefault/InjectDefault+Consume 0+Measure time: End 0
root: INFO: 2019-07-06T16:13:40.606Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 3/UnKey.out" materialized.
root: INFO: 2019-07-06T16:13:40.717Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 3/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:40.777Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 1/CombinePerKey/GroupByKey/Read+Combine with Top 1/CombinePerKey/Combine+Combine with Top 1/CombinePerKey/Combine/Extract+Combine with Top 1/UnKey
root: INFO: 2019-07-06T16:13:40.798Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 3/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:40.881Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 1/UnKey.out" materialized.
root: INFO: 2019-07-06T16:13:40.916Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 3/InjectDefault/_UnpickledSideInput(UnKey.out.0).output" materialized.
root: INFO: 2019-07-06T16:13:40.977Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 1/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:41.029Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 3/DoOnce/Read+Combine with Top 3/InjectDefault/InjectDefault+Consume 3+Measure time: End 3
root: INFO: 2019-07-06T16:13:41.039Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 1/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:41.112Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 4/CombinePerKey/GroupByKey/Read+Combine with Top 4/CombinePerKey/Combine+Combine with Top 4/CombinePerKey/Combine/Extract+Combine with Top 4/UnKey
root: INFO: 2019-07-06T16:13:41.136Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 1/InjectDefault/_UnpickledSideInput(UnKey.out.0).output" materialized.
root: INFO: 2019-07-06T16:13:41.222Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 4/UnKey.out" materialized.
root: INFO: 2019-07-06T16:13:41.261Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 1/DoOnce/Read+Combine with Top 1/InjectDefault/InjectDefault+Consume 1+Measure time: End 1
root: INFO: 2019-07-06T16:13:41.310Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 4/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:41.326Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 2/CombinePerKey/GroupByKey/Read+Combine with Top 2/CombinePerKey/Combine+Combine with Top 2/CombinePerKey/Combine/Extract+Combine with Top 2/UnKey
root: INFO: 2019-07-06T16:13:41.384Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 4/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:41.406Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 7/DoOnce/Read+Combine with Top 7/InjectDefault/InjectDefault+Consume 7+Measure time: End 7
root: INFO: 2019-07-06T16:13:41.416Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 2/UnKey.out" materialized.
root: INFO: 2019-07-06T16:13:41.477Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 4/InjectDefault/_UnpickledSideInput(UnKey.out.0).output" materialized.
root: INFO: 2019-07-06T16:13:41.525Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 2/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:41.563Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 4/DoOnce/Read+Combine with Top 4/InjectDefault/InjectDefault+Consume 4+Measure time: End 4
root: INFO: 2019-07-06T16:13:41.586Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 2/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:41.689Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 2/InjectDefault/_UnpickledSideInput(UnKey.out.0).output" materialized.
root: INFO: 2019-07-06T16:13:41.712Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 3/DoOnce/Read+Combine with Top 3/InjectDefault/InjectDefault+Consume 3+Measure time: End 3
root: INFO: 2019-07-06T16:13:41.721Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 5/CombinePerKey/GroupByKey/Read+Combine with Top 5/CombinePerKey/Combine+Combine with Top 5/CombinePerKey/Combine/Extract+Combine with Top 5/UnKey
root: INFO: 2019-07-06T16:13:41.793Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 2/DoOnce/Read+Combine with Top 2/InjectDefault/InjectDefault+Consume 2+Measure time: End 2
root: INFO: 2019-07-06T16:13:41.810Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 6/CombinePerKey/GroupByKey/Read+Combine with Top 6/CombinePerKey/Combine+Combine with Top 6/CombinePerKey/Combine/Extract+Combine with Top 6/UnKey
root: INFO: 2019-07-06T16:13:41.836Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 5/UnKey.out" materialized.
root: INFO: 2019-07-06T16:13:41.906Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 6/UnKey.out" materialized.
root: INFO: 2019-07-06T16:13:41.946Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 5/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:41.993Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 6/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:42.017Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 5/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:42.054Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 6/InjectDefault/_UnpickledSideInput(UnKey.out.0)
root: INFO: 2019-07-06T16:13:42.115Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 5/InjectDefault/_UnpickledSideInput(UnKey.out.0).output" materialized.
root: INFO: 2019-07-06T16:13:42.129Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 0/DoOnce/Read+Combine with Top 0/InjectDefault/InjectDefault+Consume 0+Measure time: End 0
root: INFO: 2019-07-06T16:13:42.154Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 4/DoOnce/Read+Combine with Top 4/InjectDefault/InjectDefault+Consume 4+Measure time: End 4
root: INFO: 2019-07-06T16:13:42.158Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 6/InjectDefault/_UnpickledSideInput(UnKey.out.0).output" materialized.
root: INFO: 2019-07-06T16:13:42.215Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 5/DoOnce/Read+Combine with Top 5/InjectDefault/InjectDefault+Consume 5+Measure time: End 5
root: INFO: 2019-07-06T16:13:42.262Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 6/DoOnce/Read+Combine with Top 6/InjectDefault/InjectDefault+Consume 6+Measure time: End 6
root: INFO: 2019-07-06T16:13:42.450Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 2/DoOnce/Read+Combine with Top 2/InjectDefault/InjectDefault+Consume 2+Measure time: End 2
root: INFO: 2019-07-06T16:13:43.028Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 1/DoOnce/Read+Combine with Top 1/InjectDefault/InjectDefault+Consume 1+Measure time: End 1
root: INFO: 2019-07-06T16:13:43.028Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 6/DoOnce/Read+Combine with Top 6/InjectDefault/InjectDefault+Consume 6+Measure time: End 6
root: INFO: 2019-07-06T16:13:44.373Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 5/DoOnce/Read+Combine with Top 5/InjectDefault/InjectDefault+Consume 5+Measure time: End 5
root: INFO: 2019-07-06T16:13:44.479Z: JOB_MESSAGE_DEBUG: Executing success step success161
root: INFO: 2019-07-06T16:13:44.637Z: JOB_MESSAGE_DETAILED: Cleaning up.
root: INFO: 2019-07-06T16:13:44.714Z: JOB_MESSAGE_DEBUG: Starting worker pool teardown.
root: INFO: 2019-07-06T16:13:44.755Z: JOB_MESSAGE_BASIC: Stopping worker pool...
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://builds.apache.org/job/beam_LoadTests_Python_Combine_Dataflow_Batch/ws/src/sdks/python/nosetests.xml>
----------------------------------------------------------------------
Ran 1 test in 433.984s
FAILED (errors=1)
> Task :sdks:python:apache_beam:testing:load_tests:run FAILED
FAILURE: Build failed with an exception.
* Where:
Build file '<https://builds.apache.org/job/beam_LoadTests_Python_Combine_Dataflow_Batch/ws/src/sdks/python/apache_beam/testing/load_tests/build.gradle'> line: 49
* What went wrong:
Execution failed for task ':sdks:python:apache_beam:testing:load_tests:run'.
> error occurred
* Try:
Run with --stacktrace option to get the stack trace. Run with --info or --debug option to get more log output. Run with --scan to get full insights.
* Get more help at https://help.gradle.org
Deprecated Gradle features were used in this build, making it incompatible with Gradle 6.0.
Use '--warning-mode all' to show the individual deprecation warnings.
See https://docs.gradle.org/5.2.1/userguide/command_line_interface.html#sec:command_line_warnings
BUILD FAILED in 7m 24s
4 actionable tasks: 3 executed, 1 up-to-date
Publishing build scan...
https://gradle.com/s/nq5b2cgxrnfxc
Build step 'Invoke Gradle script' changed build result to FAILURE
Build step 'Invoke Gradle script' marked build as failure
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org
Jenkins build is back to normal :
beam_LoadTests_Python_Combine_Dataflow_Batch #7
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/beam_LoadTests_Python_Combine_Dataflow_Batch/7/display/redirect>
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org
Build failed in Jenkins:
beam_LoadTests_Python_Combine_Dataflow_Batch #6
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/beam_LoadTests_Python_Combine_Dataflow_Batch/6/display/redirect>
------------------------------------------
[...truncated 108.92 KB...]
"shortValue": "CallableWrapperDoFn",
"type": "STRING",
"value": "apache_beam.transforms.core.CallableWrapperDoFn"
}
],
"non_parallel_inputs": {
"side0-Combine with Top 0/InjectDefault": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "SideInput-s8"
}
},
"output_info": [
{
"encoding": {
"@type": "kind:windowed_value",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": []
},
{
"@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": []
}
],
"is_pair_like": true
},
{
"@type": "kind:global_window"
}
],
"is_wrapper": true
},
"output_name": "out",
"user_name": "Combine with Top 0/InjectDefault.out"
}
],
"parallel_input": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "s7"
},
"serialized_fn": "<string of 1824 bytes>",
"user_name": "Combine with Top 0/InjectDefault/InjectDefault"
}
},
{
"kind": "ParallelDo",
"name": "s10",
"properties": {
"display_data": [
{
"key": "fn",
"label": "Transform Function",
"namespace": "apache_beam.transforms.core.ParDo",
"shortValue": "_GetElement",
"type": "STRING",
"value": "apache_beam.testing.load_tests.combine_test._GetElement"
}
],
"non_parallel_inputs": {},
"output_info": [
{
"encoding": {
"@type": "kind:windowed_value",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": []
},
{
"@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": []
}
],
"is_pair_like": true
},
{
"@type": "kind:global_window"
}
],
"is_wrapper": true
},
"output_name": "out",
"user_name": "Consume 0.out"
}
],
"parallel_input": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "s9"
},
"serialized_fn": "<string of 432 bytes>",
"user_name": "Consume 0"
}
},
{
"kind": "ParallelDo",
"name": "s11",
"properties": {
"display_data": [
{
"key": "fn",
"label": "Transform Function",
"namespace": "apache_beam.transforms.core.ParDo",
"shortValue": "MeasureTime",
"type": "STRING",
"value": "apache_beam.testing.load_tests.load_test_metrics_utils.MeasureTime"
}
],
"non_parallel_inputs": {},
"output_info": [
{
"encoding": {
"@type": "kind:windowed_value",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": [
{
"@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": []
},
{
"@type": "FastPrimitivesCoder$eNprYEpOLEhMzkiNT0pNzNVLzk9JLSqGUlxuicUlAUWZuZklmWWpxc4gQa5CBs3GQsbaQqZQ/vi0xJycpMTk7Hiw+kJmPEYFZCZn56RCjWABGsFaW8iWVJykBwDlGS3/",
"component_encodings": []
}
],
"is_pair_like": true
},
{
"@type": "kind:global_window"
}
],
"is_wrapper": true
},
"output_name": "out",
"user_name": "Measure time: End 0.out"
}
],
"parallel_input": {
"@type": "OutputReference",
"output_name": "out",
"step_name": "s10"
},
"serialized_fn": "<string of 504 bytes>",
"user_name": "Measure time: End 0"
}
}
],
"type": "JOB_TYPE_BATCH"
}
root: INFO: Create job: <Job
createTime: u'2019-07-07T15:42:43.095784Z'
currentStateTime: u'1970-01-01T00:00:00Z'
id: u'2019-07-07_08_42_42-8241186059035490445'
location: u'us-central1'
name: u'load-tests-python-dataflow-batch-combine-2-0707150139'
projectId: u'apache-beam-testing'
stageStates: []
startTime: u'2019-07-07T15:42:43.095784Z'
steps: []
tempFiles: []
type: TypeValueValuesEnum(JOB_TYPE_BATCH, 1)>
root: INFO: Created job with id: [2019-07-07_08_42_42-8241186059035490445]
root: INFO: To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2019-07-07_08_42_42-8241186059035490445?project=apache-beam-testing
root: INFO: Job 2019-07-07_08_42_42-8241186059035490445 is in state JOB_STATE_PENDING
root: INFO: 2019-07-07T15:42:42.264Z: JOB_MESSAGE_WARNING: The requested max number of workers (5) is ignored as autoscaling is explicitly disabled (autoscalingAlgorithm=NONE).
root: INFO: 2019-07-07T15:42:44.907Z: JOB_MESSAGE_DETAILED: Checking permissions granted to controller Service Account.
root: INFO: 2019-07-07T15:42:45.410Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-a.
root: INFO: 2019-07-07T15:42:46.039Z: JOB_MESSAGE_DETAILED: Expanding CoGroupByKey operations into optimizable parts.
root: INFO: 2019-07-07T15:42:46.088Z: JOB_MESSAGE_DETAILED: Expanding GroupByKey operations into optimizable parts.
root: INFO: 2019-07-07T15:42:46.130Z: JOB_MESSAGE_DETAILED: Lifting ValueCombiningMappingFns into MergeBucketsMappingFns
root: INFO: 2019-07-07T15:42:46.278Z: JOB_MESSAGE_DEBUG: Annotating graph with Autotuner information.
root: INFO: 2019-07-07T15:42:46.324Z: JOB_MESSAGE_DETAILED: Fusing adjacent ParDo, Read, Write, and Flatten operations
root: INFO: 2019-07-07T15:42:46.368Z: JOB_MESSAGE_DETAILED: Fusing consumer Measure time: Start into Read
root: INFO: 2019-07-07T15:42:46.431Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/CombinePerKey/GroupByKey+Combine with Top 0/CombinePerKey/Combine/Partial into Combine with Top 0/KeyWithVoid
root: INFO: 2019-07-07T15:42:46.474Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/CombinePerKey/Combine/Extract into Combine with Top 0/CombinePerKey/Combine
root: INFO: 2019-07-07T15:42:46.512Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/CombinePerKey/Combine into Combine with Top 0/CombinePerKey/GroupByKey/Read
root: INFO: 2019-07-07T15:42:46.555Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/KeyWithVoid into Measure time: Start
root: INFO: 2019-07-07T15:42:46.596Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/CombinePerKey/GroupByKey/Write into Combine with Top 0/CombinePerKey/GroupByKey/Reify
root: INFO: 2019-07-07T15:42:46.627Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/CombinePerKey/GroupByKey/Reify into Combine with Top 0/CombinePerKey/GroupByKey+Combine with Top 0/CombinePerKey/Combine/Partial
root: INFO: 2019-07-07T15:42:46.672Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/UnKey into Combine with Top 0/CombinePerKey/Combine/Extract
root: INFO: 2019-07-07T15:42:46.709Z: JOB_MESSAGE_DETAILED: Fusing consumer Measure time: End 0 into Consume 0
root: INFO: 2019-07-07T15:42:46.757Z: JOB_MESSAGE_DETAILED: Fusing consumer Consume 0 into Combine with Top 0/InjectDefault/InjectDefault
root: INFO: 2019-07-07T15:42:46.798Z: JOB_MESSAGE_DETAILED: Fusing consumer Combine with Top 0/InjectDefault/InjectDefault into Combine with Top 0/DoOnce/Read
root: INFO: 2019-07-07T15:42:46.843Z: JOB_MESSAGE_DEBUG: Workflow config is missing a default resource spec.
root: INFO: 2019-07-07T15:42:46.891Z: JOB_MESSAGE_DEBUG: Adding StepResource setup and teardown to workflow graph.
root: INFO: 2019-07-07T15:42:46.928Z: JOB_MESSAGE_DEBUG: Adding workflow start and stop steps.
root: INFO: 2019-07-07T15:42:46.963Z: JOB_MESSAGE_DEBUG: Assigning stage ids.
root: INFO: 2019-07-07T15:42:47.153Z: JOB_MESSAGE_DEBUG: Executing wait step start23
root: INFO: 2019-07-07T15:42:47.241Z: JOB_MESSAGE_BASIC: Executing operation Combine with Top 0/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-07T15:42:47.297Z: JOB_MESSAGE_DEBUG: Starting worker pool setup.
root: INFO: 2019-07-07T15:42:47.338Z: JOB_MESSAGE_BASIC: Starting 5 workers in us-central1-a...
root: INFO: 2019-07-07T15:42:47.391Z: JOB_MESSAGE_BASIC: Finished operation Combine with Top 0/CombinePerKey/GroupByKey/Create
root: INFO: 2019-07-07T15:42:47.474Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-a.
root: INFO: 2019-07-07T15:42:47.487Z: JOB_MESSAGE_DEBUG: Value "Combine with Top 0/CombinePerKey/GroupByKey/Session" materialized.
root: INFO: 2019-07-07T15:42:47.582Z: JOB_MESSAGE_BASIC: Executing operation Read+Measure time: Start+Combine with Top 0/KeyWithVoid+Combine with Top 0/CombinePerKey/GroupByKey+Combine with Top 0/CombinePerKey/Combine/Partial+Combine with Top 0/CombinePerKey/GroupByKey/Reify+Combine with Top 0/CombinePerKey/GroupByKey/Write
root: INFO: Job 2019-07-07_08_42_42-8241186059035490445 is in state JOB_STATE_RUNNING
root: INFO: 2019-07-07T15:43:45.341Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 2 based on the rate of progress in the currently running step(s).
root: INFO: 2019-07-07T15:43:45.377Z: JOB_MESSAGE_DETAILED: Resized worker pool to 2, though goal was 5. This could be a quota issue.
root: INFO: 2019-07-07T15:43:50.624Z: JOB_MESSAGE_DETAILED: Autoscaling: Raised the number of workers to 5 based on the rate of progress in the currently running step(s).
root: INFO: 2019-07-07T15:44:13.119Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-07-07T15:44:13.156Z: JOB_MESSAGE_DETAILED: Workers have started successfully.
root: INFO: 2019-07-07T15:45:47.511Z: JOB_MESSAGE_BASIC: Worker configuration: n1-standard-1 in us-central1-a.
--------------------- >> end captured logging << ---------------------
----------------------------------------------------------------------
XML: <https://builds.apache.org/job/beam_LoadTests_Python_Combine_Dataflow_Batch/ws/src/sdks/python/nosetests.xml>
----------------------------------------------------------------------
Ran 1 test in 271.892s
FAILED (errors=1)
> Task :sdks:python:apache_beam:testing:load_tests:run FAILED
FAILURE: Build failed with an exception.
* Where:
Build file '<https://builds.apache.org/job/beam_LoadTests_Python_Combine_Dataflow_Batch/ws/src/sdks/python/apache_beam/testing/load_tests/build.gradle'> line: 49
* What went wrong:
Execution failed for task ':sdks:python:apache_beam:testing:load_tests:run'.
> error occurred
* Try:
Run with --stacktrace option to get the stack trace. Run with --info or --debug option to get more log output. Run with --scan to get full insights.
* Get more help at https://help.gradle.org
Deprecated Gradle features were used in this build, making it incompatible with Gradle 6.0.
Use '--warning-mode all' to show the individual deprecation warnings.
See https://docs.gradle.org/5.2.1/userguide/command_line_interface.html#sec:command_line_warnings
BUILD FAILED in 4m 46s
4 actionable tasks: 3 executed, 1 up-to-date
Publishing build scan...
https://gradle.com/s/jp3x25mg7iyvg
Build step 'Invoke Gradle script' changed build result to FAILURE
Build step 'Invoke Gradle script' marked build as failure
---------------------------------------------------------------------
To unsubscribe, e-mail: builds-unsubscribe@beam.apache.org
For additional commands, e-mail: builds-help@beam.apache.org