See <https://ci-beam.apache.org/job/beam_LoadTests_Java_GBK_Dataflow_V2_Streaming_Java11/46/display/redirect>
Changes: ------------------------------------------ [...truncated 62.50 KB...] INFO:root:pull_licenses_java.py succeed. It took 136.002786 seconds with 16 threads. Copying licenses from <https://ci-beam.apache.org/job/beam_LoadTests_Java_GBK_Dataflow_V2_Streaming_Java11/ws/src/sdks/java/container/build/target/java_third_party_licenses> to <https://ci-beam.apache.org/job/beam_LoadTests_Java_GBK_Dataflow_V2_Streaming_Java11/ws/src/sdks/java/container/build/target/third_party_licenses.> Finished license_scripts.sh > Task :sdks:java:container:java11:copyJavaThirdPartyLicenses NO-SOURCE > Task :sdks:go:resolveBuildDependencies Resolving google.golang.org/api: commit='0324d5e90dc7753607860272666845fad9ceb97e', urls=[https://code.googlesource.com/google-api-go-client] Resolving google.golang.org/genproto: commit='4d944d34d83c502a5f761500a14d8842648415c3', urls=[https://github.com/google/go-genproto] Resolving google.golang.org/grpc: commit='5e8f83304c0563d1ba74db05fee83d9c18ab9a58', urls=[https://github.com/grpc/grpc-go] Resolving google.golang.org/protobuf: commit='d165be301fb1e13390ad453281ded24385fd8ebc', urls=[https://go.googlesource.com/protobuf] Resolving cached github.com/etcd-io/etcd: commit='11214aa33bf5a47d3d9d8dafe0f6b97237dfe921', urls=[https://github.com/etcd-io/etcd.git, [email protected]:etcd-io/etcd.git] Resolving cached github.com/etcd-io/etcd: commit='11214aa33bf5a47d3d9d8dafe0f6b97237dfe921', urls=[https://github.com/etcd-io/etcd.git, [email protected]:etcd-io/etcd.git] > Task :sdks:go:installDependencies > Task :sdks:go:buildLinuxAmd64 > Task :sdks:go:goBuild > Task :sdks:java:container:resolveBuildDependencies Resolving ./github.com/apache/beam/sdks/go@<https://ci-beam.apache.org/job/beam_LoadTests_Java_GBK_Dataflow_V2_Streaming_Java11/ws/src/sdks/go> > Task :sdks:java:container:installDependencies > Task :sdks:java:container:buildLinuxAmd64 > Task :sdks:java:container:goBuild > Task :sdks:java:container:java11:copySdkHarnessLauncher > Task :sdks:java:container:java11:dockerPrepare > Task :sdks:java:container:java11:docker > Task :runners:google-cloud-dataflow-java:buildAndPushDockerContainer WARNING: `gcloud docker` will not be supported for Docker client versions above 18.03. As an alternative, use `gcloud auth configure-docker` to configure `docker` to use `gcloud` as a credential helper, then use `docker` as you would for non-GCR registries, e.g. `docker pull gcr.io/project-id/my-image`. Add `--verbosity=error` to silence this warning: `gcloud docker --verbosity=error -- pull gcr.io/project-id/my-image`. See: https://cloud.google.com/container-registry/docs/support/deprecation-notices#gcloud-docker The push refers to repository [us.gcr.io/apache-beam-testing/java-postcommit-it/java] 83b8611f9286: Preparing 45a52360f9b3: Preparing 41f8ba9ffe54: Preparing 90a117ed2d07: Preparing 47292604b47a: Preparing 1a6e6a2995e1: Preparing 4c5567d7afe7: Preparing 8f5629a314c8: Preparing 70581461c97a: Preparing 117e1dd247e9: Preparing 2b6e307e3074: Preparing 62480c3fcaf6: Preparing f42aed5f7feb: Preparing 89819bafde36: Preparing f3d5b8f65132: Preparing ad83f0aa5c0a: Preparing 5a9a65095453: Preparing 4b0edb23340c: Preparing afa3e488a0ee: Preparing 4c5567d7afe7: Waiting 8f5629a314c8: Waiting 70581461c97a: Waiting 4b0edb23340c: Waiting f3d5b8f65132: Waiting ad83f0aa5c0a: Waiting 117e1dd247e9: Waiting afa3e488a0ee: Waiting 2b6e307e3074: Waiting 5a9a65095453: Waiting 62480c3fcaf6: Waiting 1a6e6a2995e1: Waiting 89819bafde36: Waiting f42aed5f7feb: Waiting 41f8ba9ffe54: Pushed 47292604b47a: Pushed 90a117ed2d07: Pushed 45a52360f9b3: Pushed 83b8611f9286: Pushed 1a6e6a2995e1: Pushed 70581461c97a: Pushed 8f5629a314c8: Pushed f42aed5f7feb: Layer already exists 89819bafde36: Layer already exists f3d5b8f65132: Layer already exists ad83f0aa5c0a: Layer already exists 5a9a65095453: Layer already exists 4b0edb23340c: Layer already exists afa3e488a0ee: Layer already exists 62480c3fcaf6: Pushed 4c5567d7afe7: Pushed 2b6e307e3074: Pushed 117e1dd247e9: Pushed 20210802120923: digest: sha256:9ed0955ca51514d1a6fbc0dd0f627c280b60bae11da595fbb1f270c3f944c069 size: 4310 > Task :sdks:java:testing:load-tests:run Aug 02, 2021 12:14:33 PM org.apache.beam.runners.dataflow.options.DataflowPipelineOptions$StagingLocationFactory create INFO: No stagingLocation provided, falling back to gcpTempLocation Aug 02, 2021 12:14:34 PM org.apache.beam.runners.dataflow.DataflowRunner fromOptions INFO: PipelineOptions.filesToStage was not specified. Defaulting to files from the classpath: will stage 191 files. Enable logging at DEBUG level to see which files will be staged. Aug 02, 2021 12:14:34 PM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Executing pipeline on the Dataflow Service, which will have billing implications related to Google Compute Engine usage and other Google Cloud Services. Aug 02, 2021 12:14:36 PM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Staging portable pipeline proto to gs://temp-storage-for-perf-tests/loadtests/staging/ Aug 02, 2021 12:14:36 PM org.apache.beam.runners.dataflow.util.PackageUtil tryStagePackage INFO: Uploading <92927 bytes, hash 4aa166868f4286d01f606a7c29582a51984aab8b4f0144f399cb2911ceacda5d> to gs://temp-storage-for-perf-tests/loadtests/staging/pipeline-SqFmho9ChtAfYGp8KVgqUZhKq4tPAUTzmcspEc6s2l0.pb Aug 02, 2021 12:14:38 PM org.apache.beam.runners.dataflow.util.PackageUtil stageClasspathElements INFO: Uploading 191 files from PipelineOptions.filesToStage to staging location to prepare for execution. Aug 02, 2021 12:14:39 PM org.apache.beam.runners.dataflow.util.PackageUtil stageClasspathElements INFO: Staging files complete: 191 files cached, 0 files newly uploaded in 0 seconds Aug 02, 2021 12:14:39 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Read input/DataflowRunner.StreamingUnboundedRead.ReadWithIds as step s1 Aug 02, 2021 12:14:39 PM org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource split INFO: Split into 20 bundles of sizes: [org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@6cd64ee8, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@620c8641, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@2f1d0bbc, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@5460b754, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@a9f023e, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@c27a3a2, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@4b200971, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@1a2bcd56, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@68d7a2df, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@59dc36d4, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@12fcc71f, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@5679e96b, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@3ed7821, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@3bbf841e, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@4f0f7849, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@56a4f272, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@3ee0b4f7, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@79b84841, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@4d41ba0f, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@3c87e6b7] Aug 02, 2021 12:14:39 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Read input/StripIds as step s2 Aug 02, 2021 12:14:39 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Collect start time metrics as step s3 Aug 02, 2021 12:14:39 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Total bytes monitor as step s4 Aug 02, 2021 12:14:39 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Window.Into()/Window.Assign as step s5 Aug 02, 2021 12:14:39 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Group by key (0) as step s6 Aug 02, 2021 12:14:39 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Ungroup and reiterate (0) as step s7 Aug 02, 2021 12:14:39 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Collect end time metrics (0) as step s8 Aug 02, 2021 12:14:39 PM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Dataflow SDK version: 2.33.0-SNAPSHOT Aug 02, 2021 12:14:40 PM org.apache.beam.runners.dataflow.DataflowRunner run INFO: To access the Dataflow monitoring console, please navigate to https://console.cloud.google.com/dataflow/jobs/us-central1/2021-08-02_05_14_39-8517231583869160239?project=apache-beam-testing Aug 02, 2021 12:14:40 PM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Submitted job: 2021-08-02_05_14_39-8517231583869160239 Aug 02, 2021 12:14:40 PM org.apache.beam.runners.dataflow.DataflowRunner run INFO: To cancel the job using the 'gcloud' tool, run: > gcloud dataflow jobs --project=apache-beam-testing cancel > --region=us-central1 2021-08-02_05_14_39-8517231583869160239 Aug 02, 2021 12:14:49 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process WARNING: 2021-08-02T12:14:49.717Z: The workflow name is not a valid Cloud Label. Labels applied to Cloud resources (such as GCE Instances) for monitoring will be labeled with this modified job name: load0tests0java110dataflow0v20streaming0gbk01-jenkins-0802-tk1o. For the best monitoring experience, please name your job with a valid Cloud Label. For details, see: https://cloud.google.com/compute/docs/labeling-resources#restrictions Aug 02, 2021 12:14:54 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:54.561Z: Worker configuration: e2-standard-2 in us-central1-a. Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.017Z: Expanding SplittableParDo operations into optimizable parts. Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.048Z: Expanding CollectionToSingleton operations into optimizable parts. Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.120Z: Expanding CoGroupByKey operations into optimizable parts. Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.188Z: Expanding SplittableProcessKeyed operations into optimizable parts. Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.222Z: Expanding GroupByKey operations into streaming Read/Write steps Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.281Z: Lifting ValueCombiningMappingFns into MergeBucketsMappingFns Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.384Z: Fusing adjacent ParDo, Read, Write, and Flatten operations Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.401Z: Fusing consumer Read input/ParDo(OutputSingleSource)/ParMultiDo(OutputSingleSource) into Read input/Impulse Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.435Z: Fusing consumer Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/PairWithRestriction into Read input/ParDo(OutputSingleSource)/ParMultiDo(OutputSingleSource) Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.466Z: Fusing consumer Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/SplitWithSizing into Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/PairWithRestriction Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.495Z: Fusing consumer Read input/ParDo(StripIds)/ParMultiDo(StripIds) into Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/ProcessElementAndRestrictionWithSizing Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.526Z: Fusing consumer Collect start time metrics/ParMultiDo(TimeMonitor) into Read input/ParDo(StripIds)/ParMultiDo(StripIds) Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.560Z: Fusing consumer Total bytes monitor/ParMultiDo(ByteMonitor) into Collect start time metrics/ParMultiDo(TimeMonitor) Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.593Z: Fusing consumer Window.Into()/Window.Assign into Total bytes monitor/ParMultiDo(ByteMonitor) Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.623Z: Fusing consumer Group by key (0)/WriteStream into Window.Into()/Window.Assign Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.648Z: Fusing consumer Group by key (0)/MergeBuckets into Group by key (0)/ReadStream Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.690Z: Fusing consumer Ungroup and reiterate (0)/ParMultiDo(UngroupAndReiterate) into Group by key (0)/MergeBuckets Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:55.711Z: Fusing consumer Collect end time metrics (0)/ParMultiDo(TimeMonitor) into Ungroup and reiterate (0)/ParMultiDo(UngroupAndReiterate) Aug 02, 2021 12:14:56 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:14:56.036Z: Starting 5 ****s in us-central1-a... Aug 02, 2021 12:15:26 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:15:26.016Z: Your project already contains 100 Dataflow-created metric descriptors, so new user metrics of the form custom.googleapis.com/* will not be created. However, all user metrics are also available in the metric dataflow.googleapis.com/job/user_counter. If you rely on the custom metrics, you can delete old / unused metric descriptors. See https://developers.google.com/apis-explorer/#p/monitoring/v3/monitoring.projects.metricDescriptors.list and https://developers.google.com/apis-explorer/#p/monitoring/v3/monitoring.projects.metricDescriptors.delete Aug 02, 2021 12:15:34 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:15:33.368Z: Autoscaling: Raised the number of ****s to 5 so that the pipeline can catch up with its backlog and keep up with its input rate. Aug 02, 2021 12:16:31 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:16:30.048Z: Workers have started successfully. Aug 02, 2021 12:16:31 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T12:16:30.111Z: Workers have started successfully. Aug 02, 2021 4:00:45 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T16:00:43.351Z: Cancel request is committed for workflow job: 2021-08-02_05_14_39-8517231583869160239. Aug 02, 2021 4:00:45 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T16:00:43.454Z: Cleaning up. Aug 02, 2021 4:00:45 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T16:00:43.524Z: Stopping **** pool... Aug 02, 2021 4:00:45 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T16:00:43.572Z: Stopping **** pool... Aug 02, 2021 4:02:59 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T16:02:56.819Z: Autoscaling: Reduced the number of ****s to 0 based on low average **** CPU utilization, and the pipeline having sufficiently low backlog and keeping up with input rate. Aug 02, 2021 4:02:59 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-08-02T16:02:56.852Z: Worker pool stopped. Aug 02, 2021 4:03:04 PM org.apache.beam.runners.dataflow.DataflowPipelineJob logTerminalState INFO: Job 2021-08-02_05_14_39-8517231583869160239 finished with status CANCELLED. Aug 02, 2021 4:03:04 PM org.apache.beam.sdk.testutils.metrics.MetricsReader getCounterMetric SEVERE: Failed to get metric totalBytes.count, from namespace gbk Load test results for test (ID): c0452ceb-242d-41dc-9ccf-9aab0e3d0cea and timestamp: 2021-08-02T12:14:34.333000000Z: Metric: Value: dataflow_v2_java11_runtime_sec 0.0 dataflow_v2_java11_total_bytes_count -1.0 Exception in thread "main" java.lang.RuntimeException: Invalid job state: CANCELLED. at org.apache.beam.sdk.loadtests.JobFailure.handleFailure(JobFailure.java:55) at org.apache.beam.sdk.loadtests.LoadTest.run(LoadTest.java:141) at org.apache.beam.sdk.loadtests.GroupByKeyLoadTest.run(GroupByKeyLoadTest.java:57) at org.apache.beam.sdk.loadtests.GroupByKeyLoadTest.main(GroupByKeyLoadTest.java:131) > Task :sdks:java:testing:load-tests:run FAILED > Task :runners:google-cloud-dataflow-java:cleanUpDockerImages Untagged: us.gcr.io/apache-beam-testing/java-postcommit-it/java:20210802120923 Untagged: us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:9ed0955ca51514d1a6fbc0dd0f627c280b60bae11da595fbb1f270c3f944c069 Tag: [us.gcr.io/apache-beam-testing/java-postcommit-it/java:20210802120923] - referencing digest: [us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:9ed0955ca51514d1a6fbc0dd0f627c280b60bae11da595fbb1f270c3f944c069] Deleted [[us.gcr.io/apache-beam-testing/java-postcommit-it/java:20210802120923] (referencing [us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:9ed0955ca51514d1a6fbc0dd0f627c280b60bae11da595fbb1f270c3f944c069])]. Removing untagged image us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:9ed0955ca51514d1a6fbc0dd0f627c280b60bae11da595fbb1f270c3f944c069 Digests: - us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:9ed0955ca51514d1a6fbc0dd0f627c280b60bae11da595fbb1f270c3f944c069 Deleted [us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:9ed0955ca51514d1a6fbc0dd0f627c280b60bae11da595fbb1f270c3f944c069]. FAILURE: Build failed with an exception. * What went wrong: Execution failed for task ':sdks:java:testing:load-tests:run'. > Process 'command '/usr/lib/jvm/java-8-openjdk-amd64/bin/java'' finished with > non-zero exit value 1 * 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 7.0. Use '--warning-mode all' to show the individual deprecation warnings. See https://docs.gradle.org/6.8.3/userguide/command_line_interface.html#sec:command_line_warnings BUILD FAILED in 3h 54m 4s 107 actionable tasks: 76 executed, 29 from cache, 2 up-to-date Publishing build scan... https://gradle.com/s/734r5fxeky232 Build step 'Invoke Gradle script' changed build result to FAILURE Build step 'Invoke Gradle script' marked build as failure --------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
