Build failed in Jenkins: beam_PostCommit_Java_ValidatesRunner_Dataflow #4375

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

See <https://builds.apache.org/job/beam_PostCommit_Java_ValidatesRunner_Dataflow/4375/display/redirect>

------------------------------------------
[...truncated 21.27 MB...]
[INFO] 2017-11-19T19:42:41.914Z: (a6146cd83295413e): Fusing consumer PAssert$331/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign into PAssert$331/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map
[INFO] 2017-11-19T19:42:41.916Z: (a6146cd832954bec): Fusing consumer PAssert$331/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map into PAssert$331/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous)
[INFO] 2017-11-19T19:42:41.918Z: (a6146cd83295469a): Fusing consumer PAssert$331/GroupGlobally/KeyForDummy/AddKeys/Map into PAssert$331/GroupGlobally/RewindowActuals/Window.Assign
[INFO] 2017-11-19T19:42:41.920Z: (a6146cd832954148): Fusing consumer PAssert$331/GroupGlobally/RewindowActuals/Window.Assign into PAssert$331/GroupGlobally/GatherAllOutputs/Values/Values/Map
[INFO] 2017-11-19T19:42:41.922Z: (a6146cd832954bf6): Fusing consumer Distinct.WithRepresentativeValues/KeyByRepresentativeValue/AddKeys/Map into Create.Values/Read(CreateSource)
[INFO] 2017-11-19T19:42:41.924Z: (a6146cd8329546a4): Fusing consumer Distinct.WithRepresentativeValues/OneValuePerKey/GroupByKey+Distinct.WithRepresentativeValues/OneValuePerKey/Combine.GroupedValues/Partial into Distinct.WithRepresentativeValues/KeyByRepresentativeValue/AddKeys/Map
[INFO] 2017-11-19T19:42:41.926Z: (a6146cd832954152): Fusing consumer Distinct.WithRepresentativeValues/OneValuePerKey/Combine.GroupedValues into Distinct.WithRepresentativeValues/OneValuePerKey/GroupByKey/Read
[INFO] 2017-11-19T19:42:41.928Z: (a6146cd832954c00): Fusing consumer Distinct.WithRepresentativeValues/OneValuePerKey/GroupByKey/Write into Distinct.WithRepresentativeValues/OneValuePerKey/GroupByKey/Reify
[INFO] 2017-11-19T19:42:41.931Z: (a6146cd8329546ae): Fusing consumer PAssert$331/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous) into PAssert$331/GroupGlobally/Window.Into()/Window.Assign
[INFO] 2017-11-19T19:42:41.933Z: (a6146cd83295415c): Fusing consumer PAssert$331/GroupGlobally/Window.Into()/Window.Assign into Distinct.WithRepresentativeValues/KeepFirstPane
[INFO] 2017-11-19T19:42:41.935Z: (a6146cd832954c0a): Fusing consumer PAssert$331/GroupGlobally/GroupDummyAndContents/Reify into PAssert$331/GroupGlobally/WindowIntoDummy/Window.Assign
[INFO] 2017-11-19T19:42:41.938Z: (a6146cd8329546b8): Fusing consumer PAssert$331/GroupGlobally/GroupDummyAndContents/Write into PAssert$331/GroupGlobally/GroupDummyAndContents/Reify
[INFO] 2017-11-19T19:42:41.940Z: (a6146cd832954166): Fusing consumer PAssert$331/GroupGlobally/WindowIntoDummy/Window.Assign into PAssert$331/GroupGlobally/Create.Values/Read(CreateSource)
[INFO] 2017-11-19T19:42:42.510Z: (e25eb2b3a4120ce9): Executing operation Distinct.WithRepresentativeValues/OneValuePerKey/GroupByKey/Create
[INFO] 2017-11-19T19:42:42.525Z: (e0de55ca5dcd35c1): Starting 1 workers in us-central1-f...
[INFO] 2017-11-19T19:42:42.595Z: (e1f195350f6970c2): Executing operation Create.Values/Read(CreateSource)+Distinct.WithRepresentativeValues/KeyByRepresentativeValue/AddKeys/Map+Distinct.WithRepresentativeValues/OneValuePerKey/GroupByKey+Distinct.WithRepresentativeValues/OneValuePerKey/Combine.GroupedValues/Partial+Distinct.WithRepresentativeValues/OneValuePerKey/GroupByKey/Reify+Distinct.WithRepresentativeValues/OneValuePerKey/GroupByKey/Write
[INFO] Staging files complete: 0 files cached, 132 files newly uploaded
[INFO] Staging pipeline description to gs://temp-storage-for-validates-runner-tests//kvswaptest0testkvswap-jenkins-1119194229-693892ff/output/results/staging/
[INFO] Uploading <36308 bytes, hash 7T00eB54DutdPRxYzP8d5A> to gs://temp-storage-for-validates-runner-tests//kvswaptest0testkvswap-jenkins-1119194229-693892ff/output/results/staging/pipeline-7T00eB54DutdPRxYzP8d5A.pb
[INFO] Adding Create.Values/Read(CreateSource) as step s1
[INFO] Adding KvSwap/KvSwap/Map as step s2
[INFO] Adding PAssert$335/GroupGlobally/Window.Into()/Window.Assign as step s3
[INFO] Adding PAssert$335/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous) as step s4
[INFO] Adding PAssert$335/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map as step s5
[INFO] Adding PAssert$335/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign as step s6
[INFO] Adding PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey as step s7
[INFO] Adding PAssert$335/GroupGlobally/GatherAllOutputs/Values/Values/Map as step s8
[INFO] Adding PAssert$335/GroupGlobally/RewindowActuals/Window.Assign as step s9
[INFO] Adding PAssert$335/GroupGlobally/KeyForDummy/AddKeys/Map as step s10
[INFO] Adding PAssert$335/GroupGlobally/RemoveActualsTriggering/Flatten.PCollections as step s11
[INFO] Adding PAssert$335/GroupGlobally/Create.Values/Read(CreateSource) as step s12
[INFO] Adding PAssert$335/GroupGlobally/WindowIntoDummy/Window.Assign as step s13
[INFO] Adding PAssert$335/GroupGlobally/RemoveDummyTriggering/Flatten.PCollections as step s14
[INFO] Adding PAssert$335/GroupGlobally/FlattenDummyAndContents as step s15
[INFO] Adding PAssert$335/GroupGlobally/NeverTrigger/Flatten.PCollections as step s16
[INFO] Adding PAssert$335/GroupGlobally/GroupDummyAndContents as step s17
[INFO] Adding PAssert$335/GroupGlobally/Values/Values/Map as step s18
[INFO] Adding PAssert$335/GroupGlobally/ParDo(Concat) as step s19
[INFO] Adding PAssert$335/GetPane/Map as step s20
[INFO] Adding PAssert$335/RunChecks as step s21
[INFO] Adding PAssert$335/VerifyAssertions/ParDo(DefaultConclude) as step s22
[INFO] To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobsDetail/locations/us-central1/jobs/2017-11-19_11_42_49-5411527754700691217?project=apache-beam-testing
[INFO] To cancel the job using the 'gcloud' tool, run:
> gcloud dataflow jobs --project=apache-beam-testing cancel 2017-11-19_11_42_49-5411527754700691217
[INFO] Running Dataflow job 2017-11-19_11_42_49-5411527754700691217 with 1 expected assertions.
[INFO] 2017-11-19T19:42:49.824Z: (6ca0c7fd6989fd6a): Autoscaling: Raised the number of workers to 0 based on the rate of progress in the currently running step(s).
[INFO] 2017-11-19T19:42:50.359Z: (c4281302eabf27d6): Autoscaling: Raised the number of workers to 1 based on the rate of progress in the currently running step(s).
[INFO] 2017-11-19T19:42:54.496Z: (a774b21a48de11): Autoscaling: Raised the number of workers to 1 based on the rate of progress in the currently running step(s).
[INFO] 2017-11-19T19:42:55.785Z: (ff4d97dae34e5985): Autoscaling: Raised the number of workers to 1 based on the rate of progress in the currently running step(s).
[INFO] 2017-11-19T19:42:49.934Z: (4b199bd2471a104d): Autoscaling is enabled for job 2017-11-19_11_42_49-5411527754700691217. The number of workers will be between 1 and 15.
[INFO] 2017-11-19T19:42:49.962Z: (4b199bd2471a1a9c): Autoscaling was automatically enabled for job 2017-11-19_11_42_49-5411527754700691217.
[INFO] 2017-11-19T19:42:52.284Z: (893673e63e075bee): Checking required Cloud APIs are enabled.
[INFO] 2017-11-19T19:42:55.514Z: (893673e63e075bfe): Expanding CoGroupByKey operations into optimizable parts.
[INFO] 2017-11-19T19:42:55.524Z: (893673e63e07518d): Expanding GroupByKey operations into optimizable parts.
[INFO] 2017-11-19T19:42:55.527Z: (893673e63e0759ff): Lifting ValueCombiningMappingFns into MergeBucketsMappingFns
[INFO] 2017-11-19T19:42:55.548Z: (893673e63e075439): Fusing adjacent ParDo, Read, Write, and Flatten operations
[INFO] 2017-11-19T19:42:55.550Z: (893673e63e075cab): Elided trivial flatten 
[INFO] 2017-11-19T19:42:55.552Z: (893673e63e07551d): Elided trivial flatten 
[INFO] 2017-11-19T19:42:55.554Z: (893673e63e075d8f): Elided trivial flatten 
[INFO] 2017-11-19T19:42:55.557Z: (893673e63e075601): Unzipping flatten s15 for input s10.10
[INFO] 2017-11-19T19:42:55.560Z: (893673e63e075e73): Fusing unzipped copy of PAssert$335/GroupGlobally/GroupDummyAndContents/Reify, through flatten , into producer PAssert$335/GroupGlobally/KeyForDummy/AddKeys/Map
[INFO] 2017-11-19T19:42:55.562Z: (893673e63e0756e5): Unzipping flatten s15-u22 for input s17-reify-value0-c20
[INFO] 2017-11-19T19:42:55.564Z: (893673e63e075f57): Fusing unzipped copy of PAssert$335/GroupGlobally/GroupDummyAndContents/Write, through flatten , into producer PAssert$335/GroupGlobally/GroupDummyAndContents/Reify
[INFO] 2017-11-19T19:42:55.567Z: (893673e63e0757c9): Fusing consumer PAssert$335/GetPane/Map into PAssert$335/GroupGlobally/ParDo(Concat)
[INFO] 2017-11-19T19:42:55.569Z: (893673e63e07503b): Fusing consumer PAssert$335/VerifyAssertions/ParDo(DefaultConclude) into PAssert$335/RunChecks
[INFO] 2017-11-19T19:42:55.571Z: (893673e63e0758ad): Fusing consumer PAssert$335/RunChecks into PAssert$335/GetPane/Map
[INFO] 2017-11-19T19:42:55.574Z: (893673e63e07511f): Fusing consumer PAssert$335/GroupGlobally/GroupDummyAndContents/GroupByWindow into PAssert$335/GroupGlobally/GroupDummyAndContents/Read
[INFO] 2017-11-19T19:42:55.576Z: (893673e63e075991): Fusing consumer PAssert$335/GroupGlobally/Values/Values/Map into PAssert$335/GroupGlobally/GroupDummyAndContents/GroupByWindow
[INFO] 2017-11-19T19:42:55.578Z: (893673e63e075203): Fusing consumer PAssert$335/GroupGlobally/ParDo(Concat) into PAssert$335/GroupGlobally/Values/Values/Map
[INFO] 2017-11-19T19:42:55.580Z: (893673e63e075a75): Fusing consumer PAssert$335/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous) into PAssert$335/GroupGlobally/Window.Into()/Window.Assign
[INFO] 2017-11-19T19:42:55.583Z: (893673e63e0752e7): Fusing consumer PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/Write into PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/Reify
[INFO] 2017-11-19T19:42:55.586Z: (893673e63e075b59): Fusing consumer PAssert$335/GroupGlobally/RewindowActuals/Window.Assign into PAssert$335/GroupGlobally/GatherAllOutputs/Values/Values/Map
[INFO] 2017-11-19T19:42:55.588Z: (893673e63e0753cb): Fusing consumer KvSwap/KvSwap/Map into Create.Values/Read(CreateSource)
[INFO] 2017-11-19T19:42:55.590Z: (893673e63e075c3d): Fusing consumer PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/Reify into PAssert$335/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign
[INFO] 2017-11-19T19:42:55.593Z: (893673e63e0754af): Fusing consumer PAssert$335/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map into PAssert$335/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous)
[INFO] 2017-11-19T19:42:55.595Z: (893673e63e075d21): Fusing consumer PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow into PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/Read
[INFO] 2017-11-19T19:42:55.597Z: (893673e63e075593): Fusing consumer PAssert$335/GroupGlobally/KeyForDummy/AddKeys/Map into PAssert$335/GroupGlobally/RewindowActuals/Window.Assign
[INFO] 2017-11-19T19:42:55.600Z: (893673e63e075e05): Fusing consumer PAssert$335/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign into PAssert$335/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map
[INFO] 2017-11-19T19:42:55.602Z: (893673e63e075677): Fusing consumer PAssert$335/GroupGlobally/GatherAllOutputs/Values/Values/Map into PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow
[INFO] 2017-11-19T19:42:55.605Z: (893673e63e075ee9): Fusing consumer PAssert$335/GroupGlobally/Window.Into()/Window.Assign into KvSwap/KvSwap/Map
[INFO] 2017-11-19T19:42:55.607Z: (893673e63e07575b): Fusing consumer PAssert$335/GroupGlobally/GroupDummyAndContents/Reify into PAssert$335/GroupGlobally/WindowIntoDummy/Window.Assign
[INFO] 2017-11-19T19:42:55.611Z: (893673e63e075fcd): Fusing consumer PAssert$335/GroupGlobally/GroupDummyAndContents/Write into PAssert$335/GroupGlobally/GroupDummyAndContents/Reify
[INFO] 2017-11-19T19:42:55.617Z: (893673e63e07583f): Fusing consumer PAssert$335/GroupGlobally/WindowIntoDummy/Window.Assign into PAssert$335/GroupGlobally/Create.Values/Read(CreateSource)
[INFO] 2017-11-19T19:42:55.769Z: (75cfdc88d3cf12cc): Executing operation PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/Create
[INFO] 2017-11-19T19:42:55.787Z: (41c7602478370a5b): Starting 1 workers in us-central1-f...
[INFO] 2017-11-19T19:42:55.862Z: (dd0b96e0a5a46fd3): Executing operation Create.Values/Read(CreateSource)+KvSwap/KvSwap/Map+PAssert$335/GroupGlobally/Window.Into()/Window.Assign+PAssert$335/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous)+PAssert$335/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map+PAssert$335/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign+PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/Reify+PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/Write
[INFO] 2017-11-19T19:43:05.210Z: (8ed617b6f9eedec6): Autoscaling: Raised the number of workers to 0 based on the rate of progress in the currently running step(s).
[INFO] 2017-11-19T19:43:05.615Z: (6ca0c7fd6989fc73): Autoscaling: Raised the number of workers to 1 based on the rate of progress in the currently running step(s).
[INFO] 2017-11-19T19:43:16.461Z: (7d311d99a446f9c6): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2017-11-19T19:43:16.463Z: (7d311d99a446fd74): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2017-11-19T19:43:16.468Z: (f4fbe0b9da74e22f): Worker pool stopped.
[INFO] 2017-11-19T19:43:20.949Z: (877dad67ccf5bb53): Workers have started successfully.
[INFO] 2017-11-19T19:43:21.034Z: (8ed617b6f9eed297): Autoscaling: Raised the number of workers to 1 based on the rate of progress in the currently running step(s).
[INFO] 2017-11-19T19:43:22.253Z: (b63b5f5b2d74ee19): Workers have started successfully.
[INFO] 2017-11-19T19:43:24.156Z: (7391cdaee97799af): Workers have started successfully.
[INFO] Job 2017-11-19_11_40_29-15421258282600837259 finished with status DONE.
[INFO] Success result for Dataflow job 2017-11-19_11_40_29-15421258282600837259. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] 2017-11-19T19:43:24.192Z: (478a7385d32d4868): Workers have started successfully.
[INFO] 2017-11-19T19:43:28.761Z: (25bda1438c3e704d): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2017-11-19T19:43:28.764Z: (25bda1438c3e72eb): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2017-11-19T19:43:29.684Z: (5d801a557e0c5777): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2017-11-19T19:43:29.686Z: (5d801a557e0c5b35): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] Job 2017-11-19_11_40_30-553120496318440941 finished with status DONE.
[INFO] Success result for Dataflow job 2017-11-19_11_40_30-553120496318440941. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] Job 2017-11-19_11_40_29-7868080051517097747 finished with status DONE.
[INFO] Success result for Dataflow job 2017-11-19_11_40_29-7868080051517097747. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] 2017-11-19T19:43:49.593Z: (8520fc2e7b16290): Workers have started successfully.
[INFO] 2017-11-19T19:43:51.295Z: (9543a41fea439b3a): Executing operation Distinct.WithRepresentativeValues/OneValuePerKey/GroupByKey/Close
[INFO] 2017-11-19T19:43:51.325Z: (9543a41fea439c12): Executing operation PAssert$331/GroupGlobally/GatherAllOutputs/GroupByKey/Create
[INFO] 2017-11-19T19:43:51.397Z: (e1f195350f697824): Executing operation Distinct.WithRepresentativeValues/OneValuePerKey/GroupByKey/Read+Distinct.WithRepresentativeValues/OneValuePerKey/Combine.GroupedValues+Distinct.WithRepresentativeValues/OneValuePerKey/Combine.GroupedValues/Extract+Distinct.WithRepresentativeValues/KeepFirstPane+PAssert$331/GroupGlobally/Window.Into()/Window.Assign+PAssert$331/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous)+PAssert$331/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map+PAssert$331/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign+PAssert$331/GroupGlobally/GatherAllOutputs/GroupByKey/Reify+PAssert$331/GroupGlobally/GatherAllOutputs/GroupByKey/Write
[INFO] 2017-11-19T19:43:56.075Z: (9543a41fea439556): Executing operation PAssert$331/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2017-11-19T19:43:56.106Z: (e1f195350f697cba): Executing operation PAssert$331/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2017-11-19T19:43:56.187Z: (9543a41fea43962e): Executing operation PAssert$331/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$331/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$331/GroupGlobally/GroupDummyAndContents/Reify+PAssert$331/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2017-11-19T19:43:56.218Z: (e1f195350f697ab6): Executing operation PAssert$331/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$331/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$331/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$331/GroupGlobally/RewindowActuals/Window.Assign+PAssert$331/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$331/GroupGlobally/GroupDummyAndContents/Reify+PAssert$331/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2017-11-19T19:43:58.234Z: (51ca977e60ab716e): Executing operation PAssert$334/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2017-11-19T19:43:58.254Z: (51ca977e60ab7d66): Executing operation PAssert$334/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2017-11-19T19:43:58.314Z: (51ca977e60ab75db): Executing operation PAssert$334/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$334/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$334/GroupGlobally/GroupDummyAndContents/Reify+PAssert$334/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2017-11-19T19:43:58.333Z: (89eaa8828b24289c): Executing operation PAssert$334/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$334/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$334/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$334/GroupGlobally/RewindowActuals/Window.Assign+PAssert$334/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$334/GroupGlobally/GroupDummyAndContents/Reify+PAssert$334/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2017-11-19T19:43:57.358Z: (a458c132224aae95): Executing operation Distinct/DropValues/GroupByKey/Close
[INFO] 2017-11-19T19:43:57.389Z: (9a521e3e08658f4b): Executing operation PAssert$332/GroupGlobally/GatherAllOutputs/GroupByKey/Create
[INFO] 2017-11-19T19:43:57.472Z: (9a521e3e08658b9c): Executing operation Distinct/DropValues/GroupByKey/Read+Distinct/DropValues/Combine.GroupedValues+Distinct/DropValues/Combine.GroupedValues/Extract+Distinct/ExtractFirstKey+PAssert$332/GroupGlobally/Window.Into()/Window.Assign+PAssert$332/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous)+PAssert$332/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map+PAssert$332/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign+PAssert$332/GroupGlobally/GatherAllOutputs/GroupByKey/Reify+PAssert$332/GroupGlobally/GatherAllOutputs/GroupByKey/Write
[INFO] 2017-11-19T19:44:00.003Z: (9a521e3e086589f2): Executing operation PAssert$332/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2017-11-19T19:44:00.035Z: (a458c132224aaa0e): Executing operation PAssert$332/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2017-11-19T19:44:00.118Z: (a458c132224aac42): Executing operation PAssert$332/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$332/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$332/GroupGlobally/GroupDummyAndContents/Reify+PAssert$332/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2017-11-19T19:44:00.148Z: (9a521e3e08658e8a): Executing operation PAssert$332/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$332/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$332/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$332/GroupGlobally/RewindowActuals/Window.Assign+PAssert$332/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$332/GroupGlobally/GroupDummyAndContents/Reify+PAssert$332/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2017-11-19T19:44:01.384Z: (27b3d032f3626c58): Executing operation Distinct/DropValues/GroupByKey/Close
[INFO] 2017-11-19T19:44:01.414Z: (30673e6fd552927): Executing operation PAssert$333/GroupGlobally/GatherAllOutputs/GroupByKey/Create
[INFO] 2017-11-19T19:44:01.493Z: (27b3d032f36262b7): Executing operation Distinct/DropValues/GroupByKey/Read+Distinct/DropValues/Combine.GroupedValues+Distinct/DropValues/Combine.GroupedValues/Extract+Distinct/ExtractFirstKey+PAssert$333/GroupGlobally/Window.Into()/Window.Assign+PAssert$333/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous)+PAssert$333/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map+PAssert$333/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign+PAssert$333/GroupGlobally/GatherAllOutputs/GroupByKey/Reify+PAssert$333/GroupGlobally/GatherAllOutputs/GroupByKey/Write
[INFO] 2017-11-19T19:44:04.923Z: (89eaa8828b2423e8): Executing operation PAssert$334/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2017-11-19T19:44:04.965Z: (89eaa8828b2424a9): Executing operation PAssert$334/GroupGlobally/GroupDummyAndContents/Read+PAssert$334/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$334/GroupGlobally/Values/Values/Map+PAssert$334/GroupGlobally/ParDo(Concat)+PAssert$334/GetPane/Map+PAssert$334/RunChecks+PAssert$334/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2017-11-19T19:44:03.674Z: (e1f195350f697f4c): Executing operation PAssert$331/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2017-11-19T19:44:03.707Z: (9543a41fea43958d): Executing operation PAssert$331/GroupGlobally/GroupDummyAndContents/Read+PAssert$331/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$331/GroupGlobally/Values/Values/Map+PAssert$331/GroupGlobally/ParDo(Concat)+PAssert$331/GetPane/Map+PAssert$331/RunChecks+PAssert$331/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2017-11-19T19:44:06.364Z: (9a521e3e08658ce0): Executing operation PAssert$332/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2017-11-19T19:44:06.389Z: (a458c132224aa417): Executing operation PAssert$332/GroupGlobally/GroupDummyAndContents/Read+PAssert$332/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$332/GroupGlobally/Values/Values/Map+PAssert$332/GroupGlobally/ParDo(Concat)+PAssert$332/GetPane/Map+PAssert$332/RunChecks+PAssert$332/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2017-11-19T19:44:10.733Z: (f97ef409f480a298): Cleaning up.
[INFO] 2017-11-19T19:44:10.759Z: (f97ef409f480adb2): Stopping worker pool...
[INFO] 2017-11-19T19:44:09.607Z: (a6146cd832954c2d): Cleaning up.
[INFO] 2017-11-19T19:44:09.631Z: (a6146cd832954c37): Stopping worker pool...
[INFO] 2017-11-19T19:44:09.639Z: (27b3d032f3626885): Executing operation PAssert$333/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2017-11-19T19:44:09.669Z: (30673e6fd552bd4): Executing operation PAssert$333/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2017-11-19T19:44:09.753Z: (27b3d032f3626ee4): Executing operation PAssert$333/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$333/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$333/GroupGlobally/GroupDummyAndContents/Reify+PAssert$333/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2017-11-19T19:44:09.783Z: (30673e6fd55243f): Executing operation PAssert$333/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$333/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$333/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$333/GroupGlobally/RewindowActuals/Window.Assign+PAssert$333/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$333/GroupGlobally/GroupDummyAndContents/Reify+PAssert$333/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2017-11-19T19:44:12.270Z: (cdce6275dad6fa23): Cleaning up.
[INFO] 2017-11-19T19:44:12.290Z: (cdce6275dad6f139): Stopping worker pool...
[INFO] 2017-11-19T19:44:15.566Z: (dd0b96e0a5a4699c): Executing operation PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2017-11-19T19:44:15.600Z: (9930a85b5bc80b79): Executing operation PAssert$335/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2017-11-19T19:44:15.681Z: (dd0b96e0a5a46a19): Executing operation PAssert$335/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$335/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$335/GroupGlobally/GroupDummyAndContents/Reify+PAssert$335/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2017-11-19T19:44:15.713Z: (9930a85b5bc8030c): Executing operation PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$335/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$335/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$335/GroupGlobally/RewindowActuals/Window.Assign+PAssert$335/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$335/GroupGlobally/GroupDummyAndContents/Reify+PAssert$335/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2017-11-19T19:44:18.970Z: (27b3d032f3626665): Executing operation PAssert$333/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2017-11-19T19:44:19.019Z: (27b3d032f362626e): Executing operation PAssert$333/GroupGlobally/GroupDummyAndContents/Read+PAssert$333/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$333/GroupGlobally/Values/Values/Map+PAssert$333/GroupGlobally/ParDo(Concat)+PAssert$333/GetPane/Map+PAssert$333/RunChecks+PAssert$333/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2017-11-19T19:44:24.894Z: (a8aa84db3910a629): Cleaning up.
[INFO] 2017-11-19T19:44:24.925Z: (a8aa84db3910a82b): Stopping worker pool...
[INFO] 2017-11-19T19:44:27.350Z: (9930a85b5bc803ce): Executing operation PAssert$335/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2017-11-19T19:44:27.367Z: (9930a85b5bc80cfd): Executing operation PAssert$335/GroupGlobally/GroupDummyAndContents/Read+PAssert$335/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$335/GroupGlobally/Values/Values/Map+PAssert$335/GroupGlobally/ParDo(Concat)+PAssert$335/GetPane/Map+PAssert$335/RunChecks+PAssert$335/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2017-11-19T19:44:33.388Z: (893673e63e075808): Cleaning up.
[INFO] 2017-11-19T19:44:33.408Z: (893673e63e07515e): Stopping worker pool...
[INFO] 2017-11-19T19:45:01.757Z: (ff4d97dae34e5978): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2017-11-19T19:45:01.760Z: (ff4d97dae34e5842): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2017-11-19T19:45:07.813Z: (6ca0c7fd6989f466): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2017-11-19T19:45:07.815Z: (6ca0c7fd6989f024): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] Job 2017-11-19_11_42_26-13486444838942190624 finished with status DONE.
[INFO] Success result for Dataflow job 2017-11-19_11_42_26-13486444838942190624. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] 2017-11-19T19:45:10.031Z: (c4281302eabf24ed): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2017-11-19T19:45:10.033Z: (c4281302eabf23bf): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] Job 2017-11-19_11_42_36-2800093290927359595 finished with status DONE.
[INFO] Success result for Dataflow job 2017-11-19_11_42_36-2800093290927359595. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] Job 2017-11-19_11_42_25-13284648701154921365 finished with status DONE.
[INFO] Success result for Dataflow job 2017-11-19_11_42_25-13284648701154921365. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] 2017-11-19T19:45:24.938Z: (a774b21a48d802): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2017-11-19T19:45:24.940Z: (a774b21a48dde8): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2017-11-19T19:45:32.265Z: (8ed617b6f9eed5ac): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2017-11-19T19:45:32.267Z: (8ed617b6f9eede5a): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] Job 2017-11-19_11_42_25-2474238940818997141 finished with status DONE.
[INFO] Success result for Dataflow job 2017-11-19_11_42_25-2474238940818997141. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] Job 2017-11-19_11_42_49-5411527754700691217 finished with status DONE.
[INFO] Success result for Dataflow job 2017-11-19_11_42_49-5411527754700691217. Found 1 success, 0 failures out of 1 expected assertions.
2017-11-19T19:45:40.652 [INFO] Running org.apache.beam.sdk.transforms.CreateTest
2017-11-19T19:45:40.937 [INFO] Tests run: 9, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 247.755 s - in org.apache.beam.sdk.transforms.CreateTest
2017-11-19T19:45:40.938 [INFO] Running org.apache.beam.sdk.transforms.DistinctTest
2017-11-19T19:45:41.039 [INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 207.51 s - in org.apache.beam.sdk.transforms.DistinctTest
2017-11-19T19:45:41.039 [INFO] Running org.apache.beam.sdk.values.PDoneTest
2017-11-19T19:45:41.051 [WARNING] Tests run: 1, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 0 s - in org.apache.beam.sdk.values.PDoneTest
2017-11-19T19:45:41.052 [INFO] Running org.apache.beam.sdk.transforms.ReifyTimestampsTest
2017-11-19T19:45:41.148 [INFO] Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 204.176 s - in org.apache.beam.sdk.transforms.ReifyTimestampsTest
2017-11-19T19:45:41.148 [INFO] Running org.apache.beam.sdk.transforms.KvSwapTest
2017-11-19T19:45:41.203 [INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 205.736 s - in org.apache.beam.sdk.transforms.KvSwapTest
2017-11-19T19:45:41.204 [INFO] Running org.apache.beam.sdk.transforms.windowing.WindowingTest
2017-11-19T19:45:41.216 [INFO] Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 500.964 s - in org.apache.beam.sdk.transforms.windowing.WindowingTest
2017-11-19T19:45:41.229 [INFO] 
2017-11-19T19:45:41.229 [INFO] Results:
2017-11-19T19:45:41.229 [INFO] 
2017-11-19T19:45:41.230 [WARNING] Tests run: 258, Failures: 0, Errors: 0, Skipped: 1
2017-11-19T19:45:41.230 [INFO] 
[JENKINS] Recording test results
2017-11-19T19:45:42.652 [INFO] 
2017-11-19T19:45:42.653 [INFO] --- maven-dependency-plugin:3.0.1:analyze-only (default) @ beam-runners-google-cloud-dataflow-java ---
2017-11-19T19:45:42.838 [INFO] No dependency problems found
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
[JENKINS] Archiving disabled
2017-11-19T19:45:56.420 [INFO] ------------------------------------------------------------------------
2017-11-19T19:45:56.420 [INFO] Reactor Summary:
2017-11-19T19:45:56.420 [INFO] 
2017-11-19T19:45:56.420 [INFO] Apache Beam :: Parent .............................. SUCCESS [  6.340 s]
2017-11-19T19:45:56.420 [INFO] Apache Beam :: SDKs :: Java :: Build Tools ......... SUCCESS [  6.926 s]
2017-11-19T19:45:56.420 [INFO] Apache Beam :: Model ............................... SUCCESS [  1.559 s]
2017-11-19T19:45:56.420 [INFO] Apache Beam :: Model :: Pipeline ................... SUCCESS [  9.854 s]
2017-11-19T19:45:56.420 [INFO] Apache Beam :: Model :: Job Management ............. SUCCESS [  7.243 s]
2017-11-19T19:45:56.420 [INFO] Apache Beam :: Model :: Fn Execution ............... SUCCESS [  9.261 s]
2017-11-19T19:45:56.420 [INFO] Apache Beam :: SDKs ................................ SUCCESS [  2.326 s]
2017-11-19T19:45:56.420 [INFO] Apache Beam :: SDKs :: Java ........................ SUCCESS [  2.459 s]
2017-11-19T19:45:56.420 [INFO] Apache Beam :: SDKs :: Java :: Core ................ SUCCESS [01:32 min]
2017-11-19T19:45:56.420 [INFO] Apache Beam :: Runners ............................. SUCCESS [  2.343 s]
2017-11-19T19:45:56.420 [INFO] Apache Beam :: Runners :: Local Java Core .......... SUCCESS [  6.769 s]
2017-11-19T19:45:56.421 [INFO] Apache Beam :: Runners :: Core Construction Java ... SUCCESS [ 14.412 s]
2017-11-19T19:45:56.421 [INFO] Apache Beam :: Runners :: Core Java ................ SUCCESS [ 25.105 s]
2017-11-19T19:45:56.421 [INFO] Apache Beam :: Runners :: Direct Java .............. SUCCESS [10:03 min]
2017-11-19T19:45:56.421 [INFO] Apache Beam :: SDKs :: Java :: IO .................. SUCCESS [  2.948 s]
2017-11-19T19:45:56.421 [INFO] Apache Beam :: SDKs :: Java :: Extensions .......... SUCCESS [  2.534 s]
2017-11-19T19:45:56.421 [INFO] Apache Beam :: SDKs :: Java :: Extensions :: Google Cloud Platform Core SUCCESS [ 18.158 s]
2017-11-19T19:45:56.421 [INFO] Apache Beam :: SDKs :: Java :: Extensions :: Protobuf SUCCESS [ 21.346 s]
2017-11-19T19:45:56.421 [INFO] Apache Beam :: SDKs :: Java :: IO :: Google Cloud Platform SUCCESS [01:31 min]
2017-11-19T19:45:56.421 [INFO] Apache Beam :: Runners :: Google Cloud Dataflow .... SUCCESS [  01:27 h]
2017-11-19T19:45:56.421 [INFO] ------------------------------------------------------------------------
2017-11-19T19:45:56.421 [INFO] BUILD SUCCESS
2017-11-19T19:45:56.421 [INFO] ------------------------------------------------------------------------
2017-11-19T19:45:56.421 [INFO] Total time: 01:44 h
2017-11-19T19:45:56.421 [INFO] Finished at: 2017-11-19T19:45:56+00:00
2017-11-19T19:45:58.442 [INFO] Final Memory: 386M/2591M
2017-11-19T19:45:58.443 [INFO] ------------------------------------------------------------------------
channel stopped

Jenkins build is back to normal : beam_PostCommit_Java_ValidatesRunner_Dataflow #4376

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

See <https://builds.apache.org/job/beam_PostCommit_Java_ValidatesRunner_Dataflow/4376/display/redirect>