You are viewing a plain text version of this content. The canonical link for it is here.
Posted to commits@beam.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2018/03/15 02:06:26 UTC
Build failed in Jenkins:
beam_PostCommit_Java_ValidatesRunner_Dataflow #5153
See <https://builds.apache.org/job/beam_PostCommit_Java_ValidatesRunner_Dataflow/5153/display/redirect?page=changes>
Changes:
[tgroh] Add an InProcess SdkHarness Rule
[tgroh] Close Outstanding Control Clients on Service close
[tgroh] Don't try to close a cancelled Multiplexer
[tgroh] fixup! Close Outstanding Control Clients on Service close
[tgroh] fixup! Don't try to close a cancelled Multiplexer
[tgroh] fixup! Add an InProcess SdkHarness Rule
[tgroh] fixup! Don't try to close a cancelled Multiplexer
[ehudm] Use Python 3 compatible string.
------------------------------------------
[...truncated 24.87 MB...]
[INFO] 2018-03-15T02:02:39.582Z: (b6198bbdcd056431): Fusing consumer PAssert$377/GroupGlobally/GroupDummyAndContents/Reify into PAssert$377/GroupGlobally/WindowIntoDummy/Window.Assign
[INFO] 2018-03-15T02:02:39.616Z: (b6198bbdcd056c57): Fusing consumer PAssert$377/GroupGlobally/WindowIntoDummy/Window.Assign into PAssert$377/GroupGlobally/Create.Values/Read(CreateSource)
[INFO] 2018-03-15T02:02:40.122Z: (15244c67deeb0900): Executing operation PAssert$377/GroupGlobally/GatherAllOutputs/GroupByKey/Create
[INFO] 2018-03-15T02:02:40.190Z: (15f7ab0cbc7b6f10): Starting 1 workers in us-central1-f...
[INFO] 2018-03-15T02:02:40.326Z: (5c5f5f711bf28ed4): Executing operation Create.Values/Read(CreateSource)+KvSwap/KvSwap/Map+PAssert$377/GroupGlobally/Window.Into()/Window.Assign+PAssert$377/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous)+PAssert$377/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map+PAssert$377/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign+PAssert$377/GroupGlobally/GatherAllOutputs/GroupByKey/Reify+PAssert$377/GroupGlobally/GatherAllOutputs/GroupByKey/Write
[INFO] 2018-03-15T02:02:48.524Z: (89bb1449654ebd73): Cleaning up.
[INFO] 2018-03-15T02:02:48.608Z: (89bb1449654eb311): Stopping worker pool...
[INFO] 2018-03-15T02:02:48.509Z: Autoscaling: Raised the number of workers to 0 based on the rate of progress in the currently running step(s).
[INFO] 2018-03-15T02:02:48.909Z: (59a51e12d1f4ecd4): Executing operation PAssert$370/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2018-03-15T02:02:48.987Z: (59a51e12d1f4e9f5): Executing operation PAssert$370/GroupGlobally/GroupDummyAndContents/Read+PAssert$370/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$370/GroupGlobally/Values/Values/Map+PAssert$370/GroupGlobally/ParDo(Concat)+PAssert$370/GetPane/Map+PAssert$370/RunChecks+PAssert$370/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2018-03-15T02:02:50.731Z: (1024ff05ad78a0ce): Workers have started successfully.
[INFO] 2018-03-15T02:02:50.154Z: (7698105668e5849e): Workers have started successfully.
[INFO] 2018-03-15T02:02:51.517Z: (ddb7cdb99ad8cb97): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2018-03-15T02:02:51.540Z: (ddb7cdb99ad8c3bd): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2018-03-15T02:02:43.075Z: (cd90d2b09e9933fb): Autoscaling is enabled for job 2018-03-14_19_02_43-14812570830438480351. The number of workers will be between 1 and 100.
[INFO] 2018-03-15T02:02:43.096Z: (cd90d2b09e993a82): Autoscaling was automatically enabled for job 2018-03-14_19_02_43-14812570830438480351.
[INFO] 2018-03-15T02:02:45.664Z: (b74543d965bf982a): Checking required Cloud APIs are enabled.
[INFO] 2018-03-15T02:02:45.752Z: (b74543d965bf97d3): Checking permissions granted to controller Service Account.
[INFO] 2018-03-15T02:02:49.866Z: (b74543d965bf9933): Expanding CoGroupByKey operations into optimizable parts.
[INFO] 2018-03-15T02:02:49.893Z: (b74543d965bf98dc): Expanding GroupByKey operations into optimizable parts.
[INFO] 2018-03-15T02:02:49.920Z: (b74543d965bf967a): Lifting ValueCombiningMappingFns into MergeBucketsMappingFns
[INFO] 2018-03-15T02:02:49.985Z: (b74543d965bf9a90): Fusing adjacent ParDo, Read, Write, and Flatten operations
[INFO] 2018-03-15T02:02:50.011Z: (b74543d965bf982e): Elided trivial flatten
[INFO] 2018-03-15T02:02:50.031Z: (b74543d965bf95cc): Elided trivial flatten
[INFO] 2018-03-15T02:02:50.070Z: (b74543d965bf936a): Elided trivial flatten
[INFO] 2018-03-15T02:02:50.092Z: (b74543d965bf9108): Unzipping flatten s15 for input s10.org.apache.beam.sdk.values.PCollection.<init>:329#89dcb817761b7ddd
[INFO] 2018-03-15T02:02:50.118Z: (b74543d965bf9ea6): Fusing unzipped copy of PAssert$378/GroupGlobally/GroupDummyAndContents/Reify, through flatten PAssert$378/GroupGlobally/FlattenDummyAndContents, into producer PAssert$378/GroupGlobally/KeyForDummy/AddKeys/Map
[INFO] 2018-03-15T02:02:50.141Z: (b74543d965bf9c44): Unzipping flatten s15-u22 for input s17-reify-value0-c20
[INFO] 2018-03-15T02:02:50.163Z: (b74543d965bf99e2): Fusing unzipped copy of PAssert$378/GroupGlobally/GroupDummyAndContents/Write, through flatten s15-u22, into producer PAssert$378/GroupGlobally/GroupDummyAndContents/Reify
[INFO] 2018-03-15T02:02:50.183Z: (b74543d965bf9780): Fusing consumer PAssert$378/GetPane/Map into PAssert$378/GroupGlobally/ParDo(Concat)
[INFO] 2018-03-15T02:02:50.198Z: (b74543d965bf951e): Fusing consumer PAssert$378/VerifyAssertions/ParDo(DefaultConclude) into PAssert$378/RunChecks
[INFO] 2018-03-15T02:02:50.220Z: (b74543d965bf92bc): Fusing consumer PAssert$378/RunChecks into PAssert$378/GetPane/Map
[INFO] 2018-03-15T02:02:50.244Z: (b74543d965bf905a): Fusing consumer PAssert$378/GroupGlobally/GroupDummyAndContents/GroupByWindow into PAssert$378/GroupGlobally/GroupDummyAndContents/Read
[INFO] 2018-03-15T02:02:50.268Z: (b74543d965bf9df8): Fusing consumer PAssert$378/GroupGlobally/Values/Values/Map into PAssert$378/GroupGlobally/GroupDummyAndContents/GroupByWindow
[INFO] 2018-03-15T02:02:50.296Z: (b74543d965bf9b96): Fusing consumer PAssert$378/GroupGlobally/ParDo(Concat) into PAssert$378/GroupGlobally/Values/Values/Map
[INFO] 2018-03-15T02:02:50.325Z: (b74543d965bf9934): Fusing consumer PAssert$378/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous) into PAssert$378/GroupGlobally/Window.Into()/Window.Assign
[INFO] 2018-03-15T02:02:50.349Z: (b74543d965bf96d2): Fusing consumer PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/Write into PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/Reify
[INFO] 2018-03-15T02:02:50.376Z: (b74543d965bf9470): Fusing consumer PAssert$378/GroupGlobally/RewindowActuals/Window.Assign into PAssert$378/GroupGlobally/GatherAllOutputs/Values/Values/Map
[INFO] 2018-03-15T02:02:50.388Z: (b74543d965bf920e): Fusing consumer KvSwap/KvSwap/Map into Create.Values/Read(CreateSource)
[INFO] 2018-03-15T02:02:50.407Z: (b74543d965bf9fac): Fusing consumer PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/Reify into PAssert$378/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign
[INFO] 2018-03-15T02:02:50.430Z: (b74543d965bf9d4a): Fusing consumer PAssert$378/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map into PAssert$378/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous)
[INFO] 2018-03-15T02:02:50.446Z: (b74543d965bf9ae8): Fusing consumer PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow into PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/Read
[INFO] 2018-03-15T02:02:50.469Z: (b74543d965bf9886): Fusing consumer PAssert$378/GroupGlobally/KeyForDummy/AddKeys/Map into PAssert$378/GroupGlobally/RewindowActuals/Window.Assign
[INFO] 2018-03-15T02:02:50.496Z: (b74543d965bf9624): Fusing consumer PAssert$378/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign into PAssert$378/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map
[INFO] 2018-03-15T02:02:50.516Z: (b74543d965bf93c2): Fusing consumer PAssert$378/GroupGlobally/GatherAllOutputs/Values/Values/Map into PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow
[INFO] 2018-03-15T02:02:50.537Z: (b74543d965bf9160): Fusing consumer PAssert$378/GroupGlobally/Window.Into()/Window.Assign into KvSwap/KvSwap/Map
[INFO] 2018-03-15T02:02:50.562Z: (b74543d965bf9efe): Fusing consumer PAssert$378/GroupGlobally/GroupDummyAndContents/Reify into PAssert$378/GroupGlobally/WindowIntoDummy/Window.Assign
[INFO] 2018-03-15T02:02:50.585Z: (b74543d965bf9c9c): Fusing consumer PAssert$378/GroupGlobally/GroupDummyAndContents/Write into PAssert$378/GroupGlobally/GroupDummyAndContents/Reify
[INFO] 2018-03-15T02:02:50.614Z: (b74543d965bf9a3a): Fusing consumer PAssert$378/GroupGlobally/WindowIntoDummy/Window.Assign into PAssert$378/GroupGlobally/Create.Values/Read(CreateSource)
[INFO] 2018-03-15T02:02:50.850Z: (403306f9507652c1): Executing operation PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/Create
[INFO] 2018-03-15T02:02:50.897Z: (a528910def134314): Starting 1 workers in us-central1-f...
[INFO] 2018-03-15T02:02:50.996Z: (403306f950765ec6): Executing operation Create.Values/Read(CreateSource)+KvSwap/KvSwap/Map+PAssert$378/GroupGlobally/Window.Into()/Window.Assign+PAssert$378/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous)+PAssert$378/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map+PAssert$378/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign+PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/Reify+PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/Write
[INFO] 2018-03-15T02:02:54.391Z: (81cd215cf11ead98): Cleaning up.
[INFO] 2018-03-15T02:02:54.476Z: (81cd215cf11ea852): Stopping worker pool...
[INFO] 2018-03-15T02:02:57.597Z: (59d7f5c28f2a028c): Workers have started successfully.
[INFO] 2018-03-15T02:02:58.496Z: (89933a2b8509afbe): Autoscaling: Raised the number of workers to 0 based on the rate of progress in the currently running step(s).
[INFO] 2018-03-15T02:02:56.440Z: (1b7deb908b3b0090): Executing operation PAssert$369/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2018-03-15T02:02:56.548Z: (1b7deb908b3b0a4f): Executing operation PAssert$369/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$369/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$369/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$369/GroupGlobally/RewindowActuals/Window.Assign+PAssert$369/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$369/GroupGlobally/GroupDummyAndContents/Reify+PAssert$369/GroupGlobally/GroupDummyAndContents/Write
[INFO] Job 2018-03-14_18_59_20-8436897312347400571 finished with status DONE.
[INFO] Success result for Dataflow job 2018-03-14_18_59_20-8436897312347400571. Found 2 success, 0 failures out of 2 expected assertions.
[INFO] 2018-03-15T02:02:59.452Z: (4b4c083d45f4a349): Workers have started successfully.
[INFO] 2018-03-15T02:02:59.413Z: (1b7deb908b3b0dcd): Executing operation PAssert$369/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2018-03-15T02:02:59.478Z: (e525c337024bd9f9): Executing operation PAssert$369/GroupGlobally/GroupDummyAndContents/Read+PAssert$369/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$369/GroupGlobally/Values/Values/Map+PAssert$369/GroupGlobally/ParDo(Concat)+PAssert$369/GetPane/Map+PAssert$369/RunChecks+PAssert$369/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2018-03-15T02:03:00.387Z: (18aaef27924d54fe): Autoscaling: Raised the number of workers to 3 based on the rate of progress in the currently running step(s).
[INFO] 2018-03-15T02:03:04.378Z: (3643a36850f7cf6f): Autoscaling: Raised the number of workers to 1 based on the rate of progress in the currently running step(s).
[INFO] 2018-03-15T02:03:04.454Z: (6c11a49e7cb3b407): Cleaning up.
[INFO] 2018-03-15T02:03:04.542Z: (6c11a49e7cb3baed): Stopping worker pool...
[INFO] 2018-03-15T02:03:14.590Z: (89933a2b8509a295): Autoscaling: Raised the number of workers to 1 based on the rate of progress in the currently running step(s).
[INFO] 2018-03-15T02:03:14.037Z: (f1bb10888e0d77e6): Executing operation GroupByKey/Close
[INFO] 2018-03-15T02:03:14.118Z: (f1bb10888e0d7b93): Executing operation GroupByKey/Read+GroupByKey/GroupByWindow+ParDo(Anonymous)
[INFO] 2018-03-15T02:03:20.143Z: (8f9820b270878934): Cleaning up.
[INFO] 2018-03-15T02:03:20.252Z: (8f9820b270878f6e): Stopping worker pool...
[INFO] 2018-03-15T02:03:22.917Z: (da26dcfa5a06805f): Executing operation Combine.globally(Count)/Combine.perKey(Count)/GroupByKey/Close
[INFO] 2018-03-15T02:03:22.976Z: (c943bcdcdc44d891): Executing operation PAssert$371/GroupGlobally/GatherAllOutputs/GroupByKey/Create
[INFO] 2018-03-15T02:03:23.111Z: (c943bcdcdc44d4ea): Executing operation Combine.globally(Count)/Combine.perKey(Count)/GroupByKey/Read+Combine.globally(Count)/Combine.perKey(Count)/Combine.GroupedValues+Combine.globally(Count)/Values/Values/Map+PAssert$371/GroupGlobally/Window.Into()/Window.Assign+PAssert$371/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous)+PAssert$371/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map+PAssert$371/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign+PAssert$371/GroupGlobally/GatherAllOutputs/GroupByKey/Reify+PAssert$371/GroupGlobally/GatherAllOutputs/GroupByKey/Write
[INFO] 2018-03-15T02:03:29.789Z: (c943bcdcdc44d044): Executing operation PAssert$371/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2018-03-15T02:03:29.854Z: (c943bcdcdc44dd9c): Executing operation PAssert$371/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2018-03-15T02:03:29.998Z: (da26dcfa5a068a89): Executing operation PAssert$371/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$371/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$371/GroupGlobally/GroupDummyAndContents/Reify+PAssert$371/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:30.037Z: (c943bcdcdc44d6f8): Executing operation PAssert$371/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$371/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$371/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$371/GroupGlobally/RewindowActuals/Window.Assign+PAssert$371/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$371/GroupGlobally/GroupDummyAndContents/Reify+PAssert$371/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:33.228Z: (cbfbe6502c22d593): Workers have started successfully.
[INFO] 2018-03-15T02:03:35.340Z: (c943bcdcdc44d252): Executing operation PAssert$371/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2018-03-15T02:03:35.419Z: (c943bcdcdc44dfff): Executing operation PAssert$371/GroupGlobally/GroupDummyAndContents/Read+PAssert$371/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$371/GroupGlobally/Values/Values/Map+PAssert$371/GroupGlobally/ParDo(Concat)+PAssert$371/GetPane/Map+PAssert$371/RunChecks+PAssert$371/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2018-03-15T02:03:40.811Z: Executing operation PAssert$374/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2018-03-15T02:03:40.836Z: Executing operation PAssert$375/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2018-03-15T02:03:40.857Z: Executing operation PAssert$373/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2018-03-15T02:03:40.880Z: Executing operation PAssert$372/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2018-03-15T02:03:40.905Z: Executing operation PAssert$374/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2018-03-15T02:03:40.927Z: Executing operation PAssert$375/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2018-03-15T02:03:40.949Z: Executing operation PAssert$373/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2018-03-15T02:03:40.969Z: Executing operation PAssert$372/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2018-03-15T02:03:41.063Z: Executing operation PAssert$374/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$374/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$374/GroupGlobally/GroupDummyAndContents/Reify+PAssert$374/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:41.088Z: Executing operation PAssert$374/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$374/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$374/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$374/GroupGlobally/RewindowActuals/Window.Assign+PAssert$374/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$374/GroupGlobally/GroupDummyAndContents/Reify+PAssert$374/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:41.142Z: Executing operation PAssert$375/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$375/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$375/GroupGlobally/GroupDummyAndContents/Reify+PAssert$375/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:41.164Z: Executing operation PAssert$375/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$375/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$375/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$375/GroupGlobally/RewindowActuals/Window.Assign+PAssert$375/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$375/GroupGlobally/GroupDummyAndContents/Reify+PAssert$375/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:41.188Z: Executing operation PAssert$373/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$373/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$373/GroupGlobally/GroupDummyAndContents/Reify+PAssert$373/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:41.210Z: Executing operation PAssert$373/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$373/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$373/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$373/GroupGlobally/RewindowActuals/Window.Assign+PAssert$373/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$373/GroupGlobally/GroupDummyAndContents/Reify+PAssert$373/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:41.236Z: Executing operation PAssert$372/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$372/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$372/GroupGlobally/GroupDummyAndContents/Reify+PAssert$372/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:41.258Z: Executing operation PAssert$372/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$372/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$372/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$372/GroupGlobally/RewindowActuals/Window.Assign+PAssert$372/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$372/GroupGlobally/GroupDummyAndContents/Reify+PAssert$372/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:39.644Z: (6eed8dfb07834927): Cleaning up.
[INFO] 2018-03-15T02:03:39.699Z: (6eed8dfb07834e19): Stopping worker pool...
[INFO] 2018-03-15T02:03:42.788Z: Executing operation Combine.globally(Count)/Combine.perKey(Count)/GroupByKey/Close
[INFO] 2018-03-15T02:03:42.865Z: Executing operation Combine.globally(Count)/Combine.perKey(Count)/GroupByKey/Read+Combine.globally(Count)/Combine.perKey(Count)/Combine.GroupedValues+Combine.globally(Count)/Values/Values/Map+PAssert$376/GroupGlobally/Window.Into()/Window.Assign+PAssert$376/GroupGlobally/GatherAllOutputs/Reify.Window/ParDo(Anonymous)+PAssert$376/GroupGlobally/GatherAllOutputs/WithKeys/AddKeys/Map+PAssert$376/GroupGlobally/GatherAllOutputs/Window.Into()/Window.Assign+PAssert$376/GroupGlobally/GatherAllOutputs/GroupByKey/Reify+PAssert$376/GroupGlobally/GatherAllOutputs/GroupByKey/Write
[INFO] 2018-03-15T02:03:50.996Z: Executing operation PAssert$376/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2018-03-15T02:03:51.083Z: Executing operation PAssert$376/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$376/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$376/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$376/GroupGlobally/RewindowActuals/Window.Assign+PAssert$376/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$376/GroupGlobally/GroupDummyAndContents/Reify+PAssert$376/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:51.421Z: (eeef3386a23764db): Executing operation PAssert$377/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2018-03-15T02:03:51.496Z: (eeef3386a2376c43): Executing operation PAssert$377/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2018-03-15T02:03:51.660Z: (5c5f5f711bf285b0): Executing operation PAssert$377/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$377/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$377/GroupGlobally/GroupDummyAndContents/Reify+PAssert$377/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:51.685Z: (eeef3386a2376ec7): Executing operation PAssert$377/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$377/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$377/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$377/GroupGlobally/RewindowActuals/Window.Assign+PAssert$377/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$377/GroupGlobally/GroupDummyAndContents/Reify+PAssert$377/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:03:52.380Z: (9f21369c37b190c3): Workers have started successfully.
[INFO] 2018-03-15T02:03:57.450Z: (eeef3386a2376caa): Executing operation PAssert$377/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2018-03-15T02:03:57.524Z: (5c5f5f711bf28c8c): Executing operation PAssert$377/GroupGlobally/GroupDummyAndContents/Read+PAssert$377/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$377/GroupGlobally/Values/Values/Map+PAssert$377/GroupGlobally/ParDo(Concat)+PAssert$377/GetPane/Map+PAssert$377/RunChecks+PAssert$377/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2018-03-15T02:03:59.845Z: (dfef2e6ba81749e2): Executing operation PAssert$376/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2018-03-15T02:03:59.916Z: (dfef2e6ba817461b): Executing operation PAssert$376/GroupGlobally/GroupDummyAndContents/Read+PAssert$376/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$376/GroupGlobally/Values/Values/Map+PAssert$376/GroupGlobally/ParDo(Concat)+PAssert$376/GetPane/Map+PAssert$376/RunChecks+PAssert$376/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2018-03-15T02:04:01.983Z: (b6198bbdcd05619a): Cleaning up.
[INFO] 2018-03-15T02:04:02.058Z: (b6198bbdcd056a0c): Stopping worker pool...
[INFO] 2018-03-15T02:04:01.984Z: (5cb1e5f1c8cd847e): Cleaning up.
[INFO] 2018-03-15T02:04:02.076Z: (5cb1e5f1c8cd8e4c): Stopping worker pool...
[INFO] 2018-03-15T02:04:06.543Z: (f223daef09ef24e6): Executing operation PAssert$374/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2018-03-15T02:04:06.641Z: (f223daef09ef26a7): Executing operation PAssert$374/GroupGlobally/GroupDummyAndContents/Read+PAssert$374/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$374/GroupGlobally/Values/Values/Map+PAssert$374/GroupGlobally/ParDo(Concat)+PAssert$374/GetPane/Map+PAssert$374/RunChecks+PAssert$374/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2018-03-15T02:04:06.755Z: (e81a6fe065846069): Executing operation PAssert$372/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2018-03-15T02:04:06.814Z: (e81a6fe06584624e): Executing operation PAssert$372/GroupGlobally/GroupDummyAndContents/Read+PAssert$372/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$372/GroupGlobally/Values/Values/Map+PAssert$372/GroupGlobally/ParDo(Concat)+PAssert$372/GetPane/Map+PAssert$372/RunChecks+PAssert$372/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2018-03-15T02:04:08.759Z: (608f4bcf24ab4c82): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2018-03-15T02:04:08.793Z: (608f4bcf24ab4c68): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2018-03-15T02:04:13.870Z: (301b33daed6f88ba): Executing operation PAssert$375/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2018-03-15T02:04:13.929Z: (301b33daed6f8b7b): Executing operation PAssert$375/GroupGlobally/GroupDummyAndContents/Read+PAssert$375/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$375/GroupGlobally/Values/Values/Map+PAssert$375/GroupGlobally/ParDo(Concat)+PAssert$375/GetPane/Map+PAssert$375/RunChecks+PAssert$375/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2018-03-15T02:04:13.968Z: (c241b1d901a6a0e6): Executing operation PAssert$373/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2018-03-15T02:04:14.027Z: (c241b1d901a6a0ad): Executing operation PAssert$373/GroupGlobally/GroupDummyAndContents/Read+PAssert$373/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$373/GroupGlobally/Values/Values/Map+PAssert$373/GroupGlobally/ParDo(Concat)+PAssert$373/GetPane/Map+PAssert$373/RunChecks+PAssert$373/VerifyAssertions/ParDo(DefaultConclude)
[INFO] Job 2018-03-14_19_01_29-10886588099875761710 finished with status DONE.
[INFO] Success result for Dataflow job 2018-03-14_19_01_29-10886588099875761710. Found 0 success, 0 failures out of 0 expected assertions.
[INFO] 2018-03-15T02:04:21.184Z: (2e52e37dedf2ac9a): Cleaning up.
[INFO] 2018-03-15T02:04:21.235Z: (2e52e37dedf2aa4c): Stopping worker pool...
[INFO] 2018-03-15T02:04:24.460Z: (684c161be05883bc): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2018-03-15T02:04:24.495Z: (684c161be058877e): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2018-03-15T02:04:24.534Z: (81cd215cf11ea14a): Worker pool stopped.
[INFO] 2018-03-15T02:04:24.352Z: (843ef0c8d382553a): Executing operation PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/Close
[INFO] 2018-03-15T02:04:24.411Z: (843ef0c8d3825fa2): Executing operation PAssert$378/GroupGlobally/GroupDummyAndContents/Create
[INFO] 2018-03-15T02:04:24.524Z: (403306f950765d1a): Executing operation PAssert$378/GroupGlobally/Create.Values/Read(CreateSource)+PAssert$378/GroupGlobally/WindowIntoDummy/Window.Assign+PAssert$378/GroupGlobally/GroupDummyAndContents/Reify+PAssert$378/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:04:24.549Z: (843ef0c8d3825ef3): Executing operation PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/Read+PAssert$378/GroupGlobally/GatherAllOutputs/GroupByKey/GroupByWindow+PAssert$378/GroupGlobally/GatherAllOutputs/Values/Values/Map+PAssert$378/GroupGlobally/RewindowActuals/Window.Assign+PAssert$378/GroupGlobally/KeyForDummy/AddKeys/Map+PAssert$378/GroupGlobally/GroupDummyAndContents/Reify+PAssert$378/GroupGlobally/GroupDummyAndContents/Write
[INFO] 2018-03-15T02:04:26.095Z: (30f0c9fa9807c2f1): Autoscaling: Resized worker pool from 2 to 0.
[INFO] 2018-03-15T02:04:26.137Z: (30f0c9fa9807c9db): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2018-03-15T02:04:26.170Z: (6c11a49e7cb3b975): Worker pool stopped.
[INFO] Job 2018-03-14_19_01_24-4716141377124645980 finished with status DONE.
[INFO] Success result for Dataflow job 2018-03-14_19_01_24-4716141377124645980. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] Job 2018-03-14_19_01_14-9351954352506139960 finished with status DONE.
[INFO] Success result for Dataflow job 2018-03-14_19_01_14-9351954352506139960. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] 2018-03-15T02:04:34.274Z: (843ef0c8d3825929): Executing operation PAssert$378/GroupGlobally/GroupDummyAndContents/Close
[INFO] 2018-03-15T02:04:34.331Z: (843ef0c8d3825e44): Executing operation PAssert$378/GroupGlobally/GroupDummyAndContents/Read+PAssert$378/GroupGlobally/GroupDummyAndContents/GroupByWindow+PAssert$378/GroupGlobally/Values/Values/Map+PAssert$378/GroupGlobally/ParDo(Concat)+PAssert$378/GetPane/Map+PAssert$378/RunChecks+PAssert$378/VerifyAssertions/ParDo(DefaultConclude)
[INFO] 2018-03-15T02:04:37.570Z: (dd18d41693d46f5): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2018-03-15T02:04:37.607Z: (dd18d41693d432b): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2018-03-15T02:04:36.802Z: (b74543d965bf9df9): Cleaning up.
[INFO] 2018-03-15T02:04:36.858Z: (b74543d965bf96d3): Stopping worker pool...
[INFO] Job 2018-03-14_19_01_42-14400184224065688204 finished with status DONE.
[INFO] Success result for Dataflow job 2018-03-14_19_01_42-14400184224065688204. Found 0 success, 0 failures out of 0 expected assertions.
[INFO] 2018-03-15T02:04:59.889Z: (b190f8853ab9628): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2018-03-15T02:04:59.920Z: (b190f8853ab92ae): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2018-03-15T02:04:59.964Z: (6eed8dfb078344b1): Worker pool stopped.
[INFO] Job 2018-03-14_19_01_49-17127187927384441249 finished with status DONE.
[INFO] Success result for Dataflow job 2018-03-14_19_01_49-17127187927384441249. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] 2018-03-15T02:05:23.440Z: (3643a36850f7caf0): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2018-03-15T02:05:23.470Z: (3643a36850f7c8ca): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] Job 2018-03-14_19_02_31-9595242788350227598 finished with status DONE.
[INFO] Success result for Dataflow job 2018-03-14_19_02_31-9595242788350227598. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] 2018-03-15T02:05:37.189Z: (18aaef27924d5d28): Autoscaling: Resized worker pool from 3 to 0.
[INFO] 2018-03-15T02:05:37.216Z: (18aaef27924d52a2): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2018-03-15T02:05:38.628Z: (c4493787a767bcf): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2018-03-15T02:05:38.660Z: (c4493787a767e25): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] 2018-03-15T02:05:38.850Z: (2e52e37dedf2a1e4): Worker pool stopped.
[INFO] Job 2018-03-14_19_02_00-10336364376504564410 finished with status DONE.
[INFO] Success result for Dataflow job 2018-03-14_19_02_00-10336364376504564410. Found 4 success, 0 failures out of 4 expected assertions.
[INFO] Job 2018-03-14_19_02_07-10648072011005301662 finished with status DONE.
[INFO] Success result for Dataflow job 2018-03-14_19_02_07-10648072011005301662. Found 1 success, 0 failures out of 1 expected assertions.
[INFO] 2018-03-15T02:05:48.240Z: (89933a2b8509ae56): Autoscaling: Resized worker pool from 1 to 0.
[INFO] 2018-03-15T02:05:48.272Z: (89933a2b8509a4d8): Autoscaling: Would further reduce the number of workers but reached the minimum number allowed for the job.
[INFO] Job 2018-03-14_19_02_43-14812570830438480351 finished with status DONE.
[INFO] Success result for Dataflow job 2018-03-14_19_02_43-14812570830438480351. Found 1 success, 0 failures out of 1 expected assertions.
2018-03-15T02:05:57.434 [INFO] Running org.apache.beam.sdk.testing.PAssertTest
2018-03-15T02:05:57.442 [INFO] Tests run: 17, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 456.257 s - in org.apache.beam.sdk.testing.PAssertTest
2018-03-15T02:05:57.443 [INFO] Running org.apache.beam.sdk.values.PDoneTest
2018-03-15T02:05:57.446 [WARNING] Tests run: 1, Failures: 0, Errors: 0, Skipped: 1, Time elapsed: 0 s - in org.apache.beam.sdk.values.PDoneTest
2018-03-15T02:05:57.446 [INFO] Running org.apache.beam.sdk.transforms.KvSwapTest
2018-03-15T02:05:57.451 [INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 210.233 s - in org.apache.beam.sdk.transforms.KvSwapTest
2018-03-15T02:05:57.452 [INFO] Running org.apache.beam.sdk.transforms.windowing.WindowTest
2018-03-15T02:05:57.457 [INFO] Tests run: 6, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 262.692 s - in org.apache.beam.sdk.transforms.windowing.WindowTest
2018-03-15T02:05:57.457 [INFO] Running org.apache.beam.sdk.transforms.ValuesTest
2018-03-15T02:05:57.463 [INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 240.837 s - in org.apache.beam.sdk.transforms.ValuesTest
2018-03-15T02:05:57.464 [INFO] Running org.apache.beam.sdk.transforms.KeysTest
2018-03-15T02:05:57.468 [INFO] Tests run: 2, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 203.441 s - in org.apache.beam.sdk.transforms.KeysTest
2018-03-15T02:05:57.471 [INFO]
2018-03-15T02:05:57.472 [INFO] Results:
2018-03-15T02:05:57.472 [INFO]
2018-03-15T02:05:57.472 [WARNING] Tests run: 305, Failures: 0, Errors: 0, Skipped: 2
2018-03-15T02:05:57.472 [INFO]
[JENKINS] Recording test results
2018-03-15T02:05:58.566 [INFO]
2018-03-15T02:05:58.566 [INFO] --- maven-dependency-plugin:3.0.2:analyze-only (default) @ beam-runners-google-cloud-dataflow-java ---
2018-03-15T02:05:58.770 [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 disabled2018-03-15T02:06:13.083 [INFO] ------------------------------------------------------------------------
2018-03-15T02:06:13.083 [INFO] Reactor Summary:
2018-03-15T02:06:13.083 [INFO]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: Parent .............................. SUCCESS [ 12.035 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: SDKs :: Java :: Build Tools ......... SUCCESS [ 8.682 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: Model ............................... SUCCESS [ 1.988 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: Model :: Pipeline ................... SUCCESS [ 8.277 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: Model :: Job Management ............. SUCCESS [ 5.997 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: Model :: Fn Execution ............... SUCCESS [ 6.813 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: SDKs ................................ SUCCESS [ 2.203 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: SDKs :: Java ........................ SUCCESS [ 1.975 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: SDKs :: Java :: Core ................ SUCCESS [02:09 min]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: SDKs :: Java :: Extensions .......... SUCCESS [ 2.124 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: SDKs :: Java :: Extensions :: Google Cloud Platform Core SUCCESS [ 11.945 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: Runners ............................. SUCCESS [ 2.068 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: Runners :: Core Construction Java ... SUCCESS [ 13.957 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: Runners :: Core Java ................ SUCCESS [ 32.835 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: SDKs :: Java :: IO .................. SUCCESS [ 2.121 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: Runners :: Local Java Core .......... SUCCESS [ 5.226 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: Runners :: Direct Java .............. SUCCESS [05:39 min]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: SDKs :: Java :: Extensions :: Protobuf SUCCESS [ 7.900 s]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: SDKs :: Java :: IO :: Google Cloud Platform SUCCESS [01:57 min]
2018-03-15T02:06:13.084 [INFO] Apache Beam :: Runners :: Google Cloud Dataflow .... SUCCESS [ 01:44 h]
2018-03-15T02:06:13.084 [INFO] ------------------------------------------------------------------------
2018-03-15T02:06:13.084 [INFO] BUILD SUCCESS
2018-03-15T02:06:13.084 [INFO] ------------------------------------------------------------------------
2018-03-15T02:06:13.085 [INFO] Total time: 01:57 h
2018-03-15T02:06:13.085 [INFO] Finished at: 2018-03-15T02:06:13Z
2018-03-15T02:06:14.442 [INFO] Final Memory: 330M/2592M
2018-03-15T02:06:14.442 [INFO] ------------------------------------------------------------------------
channel stopped
Not sending mail to unregistered user ehudm@google.com
Jenkins build is back to stable :
beam_PostCommit_Java_ValidatesRunner_Dataflow #5155
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/beam_PostCommit_Java_ValidatesRunner_Dataflow/5155/display/redirect?page=changes>
Jenkins build is unstable:
beam_PostCommit_Java_ValidatesRunner_Dataflow #5154
Posted by Apache Jenkins Server <je...@builds.apache.org>.
See <https://builds.apache.org/job/beam_PostCommit_Java_ValidatesRunner_Dataflow/5154/display/redirect?page=changes>